2026-09-29T18:10:20.406661387Z [ - ] apache-htcacheclean 2026-09-29T18:10:20.414342120Z [ - ] apache2 2026-09-29T18:10:20.420565654Z [ - ] atd 2026-09-29T18:10:20.441662586Z [ - ] cron 2026-09-29T18:10:20.448802982Z [ - ] dbus 2026-09-29T18:10:20.456632892Z [ - ] exim4 2026-09-29T18:10:20.491516925Z [ - ] koha-common 2026-09-29T18:10:20.505425791Z [ - ] memcached 2026-09-29T18:10:20.512899748Z [ - ] procps 2026-09-29T18:10:21.610815830Z [ - ] rabbitmq-server 2026-09-29T18:10:21.616424611Z [ - ] sudo 2026-09-29T18:10:21.622301568Z [ - ] x11-common 2026-09-29T18:10:21.700701187Z Running [sudo cp /kohadevbox/koha/debian/templates/* /etc/koha]... 2026-09-29T18:10:21.723762456Z Running [sudo cp /kohadevbox/koha/debian/koha-post-install-setup /usr/sbin]... 2026-09-29T18:10:21.739113072Z Running [sudo cp /kohadevbox/koha/debian/unavailable.html /usr/share/koha/intranet/htdocs]... 2026-09-29T18:10:21.755443864Z Running [sudo cp /kohadevbox/koha/debian/unavailable.html /usr/share/koha/opac/htdocs]... 2026-09-29T18:10:21.772020437Z Running [sudo cp /kohadevbox/koha/debian/templates/* /etc/koha]... 2026-09-29T18:10:21.792845136Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-functions.sh /usr/share/koha/bin]... 2026-09-29T18:10:21.808929023Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-create /usr/sbin]... 2026-09-29T18:10:21.825584609Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-create-dirs /usr/sbin]... 2026-09-29T18:10:21.842162003Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-disable /usr/sbin]... 2026-09-29T18:10:21.860241555Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-dump /usr/sbin]... 2026-09-29T18:10:21.878881435Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-dump-defaults /usr/sbin]... 2026-09-29T18:10:21.897748121Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-elasticsearch /usr/sbin]... 2026-09-29T18:10:21.915778870Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-email-disable /usr/sbin]... 2026-09-29T18:10:21.932945467Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-email-enable /usr/sbin]... 2026-09-29T18:10:21.951862449Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-enable /usr/sbin]... 2026-09-29T18:10:21.967982034Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-es-indexer /usr/sbin]... 2026-09-29T18:10:21.988595047Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-foreach /usr/sbin]... 2026-09-29T18:10:22.005750793Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-indexer /usr/sbin]... 2026-09-29T18:10:22.026717835Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-list /usr/sbin]... 2026-09-29T18:10:22.044511649Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-mysql /usr/sbin]... 2026-09-29T18:10:22.064712619Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-passwd /usr/sbin]... 2026-09-29T18:10:22.084966471Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-plack /usr/sbin]... 2026-09-29T18:10:22.103069830Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-rebuild-zebra /usr/sbin]... 2026-09-29T18:10:22.120735656Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-remove /usr/sbin]... 2026-09-29T18:10:22.138952794Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-reset-passwd /usr/sbin]... 2026-09-29T18:10:22.155537353Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-restore /usr/sbin]... 2026-09-29T18:10:22.172758725Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-run-backups /usr/sbin]... 2026-09-29T18:10:22.192076187Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-shell /usr/sbin]... 2026-09-29T18:10:22.211916044Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-sip /usr/sbin]... 2026-09-29T18:10:22.232350052Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-sitemap /usr/sbin]... 2026-09-29T18:10:22.253050582Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-translate /usr/sbin]... 2026-09-29T18:10:22.273373487Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-upgrade-schema /usr/sbin]... 2026-09-29T18:10:22.291511853Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-upgrade-to-3.4 /usr/sbin]... 2026-09-29T18:10:22.310500822Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-worker /usr/sbin]... 2026-09-29T18:10:22.331274494Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-z3950-responder /usr/sbin]... 2026-09-29T18:10:22.352325448Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-zebra /usr/sbin]... 2026-09-29T18:10:22.372777861Z Running [sudo cp /kohadevbox/koha/debian/koha-core.bash-completion /etc/bash_completion.d/koha-common]... 2026-09-29T18:10:22.391800106Z Skipping /etc/cron.d/koha-common, none of ( koha-common.cron.d, koha-core.cron.d ) exist 2026-09-29T18:10:22.391838680Z Skipping /etc/cron.daily/koha-common, none of ( koha-common.cron.daily, koha-core.cron.daily ) exist 2026-09-29T18:10:22.391843870Z Skipping /etc/cron.hourly/koha-common, none of ( koha-common.cron.hourly, koha-core.cron.hourly ) exist 2026-09-29T18:10:22.391848018Z Skipping /etc/cron.monthly/koha-common, none of ( koha-common.cron.monthly, koha-core.cron.monthly ) exist 2026-09-29T18:10:22.391852266Z Skipping /etc/default/koha-common, none of ( koha-common.default, koha-core.default ) exist 2026-09-29T18:10:22.391856635Z Skipping /etc/init.d/koha-common, none of ( koha-common.init, koha-sysv.init ) exist 2026-09-29T18:10:22.391861003Z Skipping /etc/logrotate.d/koha-common, none of ( koha-common.logrotate, koha-core.logrotate ) exist 2026-09-29T18:10:22.391871884Z Running [sudo xsltproc --output /usr/share/man/man8/ /usr/share/xml/docbook/stylesheet/docbook-xsl-ns/manpages/docbook.xsl /kohadevbox/koha/debian/docs/*.xml]... 2026-09-29T18:10:24.172896917Z Running [sudo rm /usr/share/man/man8/koha-*.8.gz]... 2026-09-29T18:10:24.193826597Z Running [sudo gzip /usr/share/man/man8/koha-*.8]... 2026-09-29T18:10:24.951456432Z See upgradetest-db-request.txt for database creation request. 2026-09-29T18:10:24.951492722Z Please forward it to the right person, and then run 2026-09-29T18:10:24.951496379Z /usr/sbin/koha-create --populate-db upgradetest 2026-09-29T18:10:24.951499204Z Thanks. 2026-09-29T18:10:25.012897984Z Error: worker not running for upgradetest (default) 2026-09-29T18:10:25.018873912Z Error: worker not running for upgradetest (long_tasks) 2026-09-29T18:10:25.018925130Z failed! 2026-09-29T18:10:26.083192803Z Restarting Apache httpd web server: apache2. 2026-09-29T18:10:26.084057355Z 2026-09-29T18:10:26.088388641Z Install Koha-how-to 2026-09-29T18:10:26.093681184Z [cypress] Make the pre-built cypress available to the instance user [HACK] 2026-09-29T18:10:26.095577078Z [*] Created cache dir /var/lib/koha/upgradetest/.cache/ 2026-09-29T18:10:26.097472050Z [*] Chowning /var/lib/koha/upgradetest/.cache/ 2026-09-29T18:10:26.098676916Z [*] Cypress dir linked to /var/lib/koha/upgradetest/.cache/ 2026-09-29T18:10:26.098814501Z [koha-l10n] Handling koha-l10n as requested 2026-09-29T18:10:26.098866380Z [*] Cloning koha-l10n into misc/translator/po 2026-09-29T18:10:39.782562587Z [API logging] Set TRACE to API log4perl config 2026-09-29T18:10:39.785254752Z [*] TRACE set for the API log4perl configuration 2026-09-29T18:10:39.785308746Z [git] Setting up Git on the instance user 2026-09-29T18:10:39.785315629Z [*] Generating /var/lib/koha/upgradetest/.gitconfig 2026-09-29T18:10:39.859554551Z [*] General setup 2026-09-29T18:10:39.969964350Z [*] Installing and setting hooks (/kohadevbox/koha) 2026-09-29T18:10:40.112608561Z gitifying upgradetest (/etc/koha/sites/upgradetest) to point at '/kohadevbox/koha' 2026-09-29T18:10:40.112699075Z 2026-09-29T18:10:40.112706489Z I appear to be done... 2026-09-29T18:10:40.112710747Z Please remember to restart apache before trying to use 'upgradetest' ;) 2026-09-29T18:10:42.248413430Z Restarting Apache httpd web server: apache2. 2026-09-29T18:10:42.286040025Z Enabling site upgradetest. 2026-09-29T18:10:42.293088584Z To activate the new configuration, you need to run: 2026-09-29T18:10:42.293117209Z service apache2 reload 2026-09-29T18:10:42.493150984Z yarn install v1.22.22 2026-09-29T18:10:42.615107939Z [1/4] Resolving packages... 2026-09-29T18:10:43.193928486Z success Already up-to-date. 2026-09-29T18:10:43.200574641Z Done in 0.72s. 2026-09-29T18:10:44.803579913Z Running [sudo koha-shell upgradetest -p -c 'PERL5LIB=/kohadevbox/koha:/kohadevbox/qa-test-tools perl /kohadevbox/misc4dev/populate_db.pl -v --opac-base-url http://upgradetest.myDNSname.org:8080 --intranet-base-url http://staff-upgradetest.myDNSname.org:8081 --marcflavour MARC21']... 2026-09-29T18:11:11.254146745Z Inserting koha db structure... 2026-09-29T18:11:11.254199507Z Inserting /kohadevbox/koha/installer/data/mysql/mandatory/sysprefs.sql... 2026-09-29T18:11:11.254203204Z Inserting /kohadevbox/koha/installer/data/mysql/mandatory/subtag_registry.sql... 2026-09-29T18:11:11.254206160Z Inserting /kohadevbox/koha/installer/data/mysql/mandatory/auth_val_cat.sql... 2026-09-29T18:11:11.254209196Z Inserting /kohadevbox/koha/installer/data/mysql/mandatory/message_transport_types.sql... 2026-09-29T18:11:11.254212211Z Inserting /kohadevbox/koha/installer/data/mysql/mandatory/sample_notices_message_attributes.sql... 2026-09-29T18:11:11.254215137Z Inserting /kohadevbox/koha/installer/data/mysql/mandatory/sample_notices_message_transports.sql... 2026-09-29T18:11:11.254218032Z Inserting /kohadevbox/koha/installer/data/mysql/mandatory/keyboard_shortcuts.sql... 2026-09-29T18:11:11.254220939Z Inserting /kohadevbox/koha/installer/data/mysql/mandatory/userflags.sql... 2026-09-29T18:11:11.254223994Z Inserting /kohadevbox/koha/installer/data/mysql/mandatory/userpermissions.sql... 2026-09-29T18:11:11.254226890Z Inserting /kohadevbox/koha/installer/data/mysql/mandatory/audio_alerts.sql... 2026-09-29T18:11:11.254229745Z Skipping /kohadevbox/koha/installer/data/mysql/mandatory/account_offset_types.sql 2026-09-29T18:11:11.254232681Z Skipping /kohadevbox/koha/installer/data/mysql/mandatory/account_credit_types.sql 2026-09-29T18:11:11.254255134Z Skipping /kohadevbox/koha/installer/data/mysql/mandatory/account_debit_types.sql 2026-09-29T18:11:11.254258099Z Inserting /kohadevbox/koha/installer/data/mysql/en/mandatory/account_credit_types.yml... 2026-09-29T18:11:11.254261285Z Inserting /kohadevbox/koha/installer/data/mysql/en/mandatory/account_debit_types.yml... 2026-09-29T18:11:11.254264232Z Inserting /kohadevbox/koha/installer/data/mysql/en/mandatory/auth_values.yml... 2026-09-29T18:11:11.254267067Z Inserting /kohadevbox/koha/installer/data/mysql/en/mandatory/class_sources.yml... 2026-09-29T18:11:11.254269892Z Inserting /kohadevbox/koha/installer/data/mysql/en/mandatory/illbatch_statuses.yml... 2026-09-29T18:11:11.254272718Z Inserting /kohadevbox/koha/installer/data/mysql/en/mandatory/patron_restriction_types.yml... 2026-09-29T18:11:11.254275613Z Inserting /kohadevbox/koha/installer/data/mysql/en/mandatory/sample_frequencies.yml... 2026-09-29T18:11:11.254278488Z Inserting /kohadevbox/koha/installer/data/mysql/en/mandatory/sample_notices.yml... 2026-09-29T18:11:11.254281414Z Inserting /kohadevbox/koha/installer/data/mysql/en/mandatory/sample_numberpatterns.yml... 2026-09-29T18:11:11.254284260Z Inserting /kohadevbox/koha/installer/data/mysql/en/optional/auth_val.yml... 2026-09-29T18:11:11.254287146Z Inserting /kohadevbox/koha/installer/data/mysql/en/optional/csv_profiles.yml... 2026-09-29T18:11:11.254291404Z Inserting /kohadevbox/koha/installer/data/mysql/en/optional/marc21_holdings_coded_values.yml... 2026-09-29T18:11:11.254294409Z Inserting /kohadevbox/koha/installer/data/mysql/en/optional/marc21_relatorterms.yml... 2026-09-29T18:11:11.254297335Z Inserting /kohadevbox/koha/installer/data/mysql/en/optional/parameters.yml... 2026-09-29T18:11:11.254300210Z Inserting /kohadevbox/koha/installer/data/mysql/en/optional/patron_atributes.yml... 2026-09-29T18:11:11.254303146Z Inserting /kohadevbox/koha/installer/data/mysql/en/optional/patron_categories.yml... 2026-09-29T18:11:11.254306243Z Inserting /kohadevbox/koha/installer/data/mysql/en/optional/sample_creator_data.yml... 2026-09-29T18:11:11.254309048Z Inserting /kohadevbox/koha/installer/data/mysql/en/optional/sample_itemtypes.yml... 2026-09-29T18:11:11.254311933Z Inserting /kohadevbox/koha/installer/data/mysql/en/optional/sample_libraries.yml... 2026-09-29T18:11:11.254315089Z Inserting /kohadevbox/koha/installer/data/mysql/en/optional/sample_libraries_holidays.yml... 2026-09-29T18:11:11.254318035Z Inserting /kohadevbox/koha/installer/data/mysql/en/optional/sample_news.yml... 2026-09-29T18:11:11.254321050Z Inserting /kohadevbox/koha/installer/data/mysql/en/optional/sample_patrons.yml... 2026-09-29T18:11:11.254323946Z Inserting /kohadevbox/koha/installer/data/mysql/en/optional/sample_quotes.yml... 2026-09-29T18:11:11.254326812Z Inserting /kohadevbox/koha/installer/data/mysql/en/optional/sample_z3950_servers.yml... 2026-09-29T18:11:11.254329677Z Inserting /kohadevbox/koha/installer/data/mysql/en/marcflavour/marc21/mandatory/authorities_normal_marc21.yml... 2026-09-29T18:11:11.254335969Z Inserting /kohadevbox/koha/installer/data/mysql/en/marcflavour/marc21/mandatory/marc21_framework_DEFAULT.yml... 2026-09-29T18:11:11.254338895Z Inserting /kohadevbox/koha/installer/data/mysql/en/marcflavour/marc21/optional/marc21_default_matching_rules.yml... 2026-09-29T18:11:11.254341810Z Inserting /kohadevbox/koha/installer/data/mysql/en/marcflavour/marc21/optional/marc21_sample_fastadd_framework.yml... 2026-09-29T18:11:11.254344726Z Inserting /kohadevbox/koha/installer/data/mysql/en/marcflavour/marc21/optional/marc21_simple_bib_frameworks.yml... 2026-09-29T18:11:11.254347602Z Setting the MARC flavour on the sysprefs... 2026-09-29T18:11:11.254350397Z Setting Koha version to 26.0600030... 2026-09-29T18:11:11.329519767Z Running [sudo koha-shell upgradetest -p -c 'PERL5LIB=/kohadevbox/koha:/kohadevbox/qa-test-tools perl /kohadevbox/misc4dev/create_superlibrarian.pl --userid koha --password koha ']... 2026-09-29T18:11:14.880722395Z Running [sudo koha-shell upgradetest -c 'PERL5LIB=/kohadevbox/koha:/kohadevbox/qa-test-tools perl /kohadevbox/misc4dev/insert_data.pl --marcflavour MARC21']... 2026-09-29T18:11:19.084286139Z Running [koha-mysql upgradetest -e 'UPDATE systempreferences SET value="1" WHERE variable="RESTBasicAuth"']... 2026-09-29T18:11:19.156378184Z There is no custom.sql (/kohadevbox/koha/shared/custom.sql) file, skipping. 2026-09-29T18:11:19.156427189Z Running [sudo perl /kohadevbox/misc4dev/cp_debian_files.pl --instance=upgradetest --koha_dir=/kohadevbox/koha --gitify_dir=/kohadevbox/gitify]... 2026-09-29T18:11:19.255207443Z Running [sudo cp /kohadevbox/koha/debian/templates/* /etc/koha]... 2026-09-29T18:11:19.274554722Z Running [sudo cp /kohadevbox/koha/debian/koha-post-install-setup /usr/sbin]... 2026-09-29T18:11:19.290235875Z Running [sudo cp /kohadevbox/koha/debian/unavailable.html /usr/share/koha/intranet/htdocs]... 2026-09-29T18:11:19.305797518Z Running [sudo cp /kohadevbox/koha/debian/unavailable.html /usr/share/koha/opac/htdocs]... 2026-09-29T18:11:19.320764126Z Running [sudo cp /kohadevbox/koha/debian/templates/* /etc/koha]... 2026-09-29T18:11:19.344095433Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-functions.sh /usr/share/koha/bin]... 2026-09-29T18:11:19.362949946Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-create /usr/sbin]... 2026-09-29T18:11:19.378766859Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-create-dirs /usr/sbin]... 2026-09-29T18:11:19.397922480Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-disable /usr/sbin]... 2026-09-29T18:11:19.413796963Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-dump /usr/sbin]... 2026-09-29T18:11:19.430644578Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-dump-defaults /usr/sbin]... 2026-09-29T18:11:19.450581952Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-elasticsearch /usr/sbin]... 2026-09-29T18:11:19.467421661Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-email-disable /usr/sbin]... 2026-09-29T18:11:19.480816318Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-email-enable /usr/sbin]... 2026-09-29T18:11:19.496966071Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-enable /usr/sbin]... 2026-09-29T18:11:19.517246524Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-es-indexer /usr/sbin]... 2026-09-29T18:11:19.538178740Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-foreach /usr/sbin]... 2026-09-29T18:11:19.556242873Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-indexer /usr/sbin]... 2026-09-29T18:11:19.578209296Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-list /usr/sbin]... 2026-09-29T18:11:19.596621658Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-mysql /usr/sbin]... 2026-09-29T18:11:19.615578397Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-passwd /usr/sbin]... 2026-09-29T18:11:19.633992102Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-plack /usr/sbin]... 2026-09-29T18:11:19.653632525Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-rebuild-zebra /usr/sbin]... 2026-09-29T18:11:19.673410251Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-remove /usr/sbin]... 2026-09-29T18:11:19.693069500Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-reset-passwd /usr/sbin]... 2026-09-29T18:11:19.712520829Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-restore /usr/sbin]... 2026-09-29T18:11:19.730453148Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-run-backups /usr/sbin]... 2026-09-29T18:11:19.747243313Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-shell /usr/sbin]... 2026-09-29T18:11:19.762798653Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-sip /usr/sbin]... 2026-09-29T18:11:19.778217441Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-sitemap /usr/sbin]... 2026-09-29T18:11:19.792752440Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-translate /usr/sbin]... 2026-09-29T18:11:19.808678373Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-upgrade-schema /usr/sbin]... 2026-09-29T18:11:19.824996199Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-upgrade-to-3.4 /usr/sbin]... 2026-09-29T18:11:19.843688820Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-worker /usr/sbin]... 2026-09-29T18:11:19.860329516Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-z3950-responder /usr/sbin]... 2026-09-29T18:11:19.878640864Z Running [sudo cp /kohadevbox/koha/debian/scripts/koha-zebra /usr/sbin]... 2026-09-29T18:11:19.899908445Z Running [sudo cp /kohadevbox/koha/debian/koha-core.bash-completion /etc/bash_completion.d/koha-common]... 2026-09-29T18:11:19.918819896Z Skipping /etc/cron.d/koha-common, none of ( koha-common.cron.d, koha-core.cron.d ) exist 2026-09-29T18:11:19.922432691Z Skipping /etc/cron.daily/koha-common, none of ( koha-common.cron.daily, koha-core.cron.daily ) exist 2026-09-29T18:11:19.922454202Z Skipping /etc/cron.hourly/koha-common, none of ( koha-common.cron.hourly, koha-core.cron.hourly ) exist 2026-09-29T18:11:19.922457709Z Skipping /etc/cron.monthly/koha-common, none of ( koha-common.cron.monthly, koha-core.cron.monthly ) exist 2026-09-29T18:11:19.922462067Z Skipping /etc/default/koha-common, none of ( koha-common.default, koha-core.default ) exist 2026-09-29T18:11:19.922465825Z Skipping /etc/init.d/koha-common, none of ( koha-common.init, koha-sysv.init ) exist 2026-09-29T18:11:19.922469883Z Skipping /etc/logrotate.d/koha-common, none of ( koha-common.logrotate, koha-core.logrotate ) exist 2026-09-29T18:11:19.922472999Z Running [sudo xsltproc --output /usr/share/man/man8/ /usr/share/xml/docbook/stylesheet/docbook-xsl-ns/manpages/docbook.xsl /kohadevbox/koha/debian/docs/*.xml]... 2026-09-29T18:11:21.227928710Z Running [sudo rm /usr/share/man/man8/koha-*.8.gz]... 2026-09-29T18:11:21.245614947Z Running [sudo gzip /usr/share/man/man8/koha-*.8]... 2026-09-29T18:11:21.392086213Z Running [sudo perl /kohadevbox/misc4dev/cp_zebra_files.pl --koha_dir=/kohadevbox/koha ]... 2026-09-29T18:11:21.492083047Z Running [cp -r /kohadevbox/koha/etc/zebradb/marc_defs/* /etc/koha/zebradb/marc_defs/]... 2026-09-29T18:11:21.504882179Z Running [PERL5LIB=/kohadevbox/koha:/kohadevbox/qa-test-tools perl /kohadevbox/misc4dev/setup_sip.pl --instance=upgradetest]... 2026-09-29T18:11:24.619905404Z Running [sudo cp /etc/koha/SIPconfig.xml /etc/koha/sites/upgradetest/SIPconfig.xml]... 2026-09-29T18:11:24.653665417Z Running [sudo koha-shell upgradetest -p -c 'PERL5LIB=/kohadevbox/koha:/kohadevbox/qa-test-tools perl -MKoha::Patrons -le "exit(1) if Koha::Patrons->find({ userid => 'term1' }); Koha::Patron->new({ surname => 'koha_sip', cardnumber => 'koha_sip', userid => 'term1', categorycode => 'S', branchcode => 'CPL', flags => 2, })->store->password(Koha::AuthUtils::hash_password('term1'))->_result->update_or_insert; "']... 2026-09-29T18:11:27.847770573Z Running [sudo koha-sip --stop upgradetest]... 2026-09-29T18:11:27.896885010Z Running [sudo koha-sip --enable upgradetest]... 2026-09-29T18:11:27.951812091Z Enabling SIP server for upgradetest - edit /etc/koha/sites/upgradetest/SIPconfig.xml to configure 2026-09-29T18:11:27.955082437Z Running [sudo koha-sip --start upgradetest]... 2026-09-29T18:11:28.120877637Z Running [PERL5LIB=/kohadevbox/koha:/kohadevbox/qa-test-tools perl /kohadevbox/misc4dev/reset_plack.pl --koha_dir=/kohadevbox/koha --instance=upgradetest]... 2026-09-29T18:11:28.508141244Z Running [sudo service apache2 restart]... 2026-09-29T18:11:30.660146439Z Restarting Apache httpd web server: apache2. 2026-09-29T18:11:30.662365234Z Running [grep -q watch_js /kohadevbox/koha/package.json]... 2026-09-29T18:11:30.673487674Z Running [sudo koha-shell upgradetest -c '(cd /kohadevbox/koha ; PATH=/usr/bin:/bin:/usr/sbin:/sbin:/kohadevbox/bin:/kohadevbox/koha/node_modules/.bin/:/kohadevbox/node_modules/.bin/ yarn build)']... 2026-09-29T18:11:31.101103765Z yarn run v1.22.22 2026-09-29T18:11:31.159601099Z $ yarn css:build && yarn js:build && yarn api:bundle 2026-09-29T18:11:31.539642654Z $ gulp css && gulp css --view opac 2026-09-29T18:11:32.818110900Z [18:11:32] Using gulpfile /kohadevbox/koha/gulpfile.js 2026-09-29T18:11:32.818780216Z [18:11:32] Starting 'css'... 2026-09-29T18:11:32.829345945Z [18:11:32] Finished 'css' after 10 ms 2026-09-29T18:11:47.265874493Z [18:11:47] Using gulpfile /kohadevbox/koha/gulpfile.js 2026-09-29T18:11:47.266867703Z [18:11:47] Starting 'css'... 2026-09-29T18:11:47.282651211Z [18:11:47] Finished 'css' after 15 ms 2026-09-29T18:12:01.945053086Z $ rspack build --mode development 2026-09-29T18:12:04.892602439Z Rspack compiled successfully in 2.50 s 2026-09-29T18:12:04.892694015Z 2026-09-29T18:12:04.892701119Z Rspack compiled successfully in 2.24 s 2026-09-29T18:12:04.892705087Z 2026-09-29T18:12:04.892709335Z Rspack compiled successfully in 2.25 s 2026-09-29T18:12:04.892713182Z 2026-09-29T18:12:04.892716668Z Rspack compiled successfully in 2.20 s 2026-09-29T18:12:05.254317295Z $ redocly bundle --ext json api/v1/swagger/swagger.yaml --output api/v1/swagger/swagger_bundle.json 2026-09-29T18:12:07.182014645Z Done in 36.09s. 2026-09-29T18:12:07.204414903Z Running [koha-mysql upgradetest -e 'UPDATE systempreferences SET value="Zebra" WHERE variable="SearchEngine"']... 2026-09-29T18:12:07.264784334Z Running [sudo koha-rebuild-zebra -f -v upgradetest]... 2026-09-29T18:12:10.325039951Z Zebra configuration information 2026-09-29T18:12:10.325086611Z ================================ 2026-09-29T18:12:10.325091670Z Zebra biblio directory = /var/lib/koha/upgradetest/biblios 2026-09-29T18:12:10.325095598Z Zebra authorities directory = /var/lib/koha/upgradetest/authorities 2026-09-29T18:12:10.325099786Z Koha directory = /kohadevbox/koha 2026-09-29T18:12:10.325103603Z Lockfile = /var/lock/koha/upgradetest/rebuild/rebuild..LCK 2026-09-29T18:12:10.325107110Z BIBLIONUMBER in : 999$c 2026-09-29T18:12:10.325110907Z BIBLIOITEMNUMBER in : 999$d 2026-09-29T18:12:10.325114865Z ================================ 2026-09-29T18:12:10.325118643Z Job started: 18:12:10 2026-09-29T18:12:10.325201362Z skipping authorities 2026-09-29T18:12:10.325219517Z ==================== 2026-09-29T18:12:10.325223755Z exporting biblio 18:12:10 [00:00:00] 2026-09-29T18:12:10.325227422Z ==================== 2026-09-29T18:12:17.925488990Z . 1.................................................................................................... 101.................................................................................................... 201.................................................................................................... 301.................................................................................................... 401................................... 2026-09-29T18:12:17.925534248Z Records exported: 435 18:12:17 [00:00:07] 2026-09-29T18:12:17.927221761Z ==================== 2026-09-29T18:12:17.927269232Z REINDEXING zebra 18:12:17 [00:00:07] 2026-09-29T18:12:17.927308257Z ==================== 2026-09-29T18:12:20.973853529Z ==================== 2026-09-29T18:12:20.973900139Z Indexing complete: 18:12:20 [00:00:10] 2026-09-29T18:12:20.973903766Z ==================== 2026-09-29T18:12:20.973906801Z CLEANING 2026-09-29T18:12:20.973909717Z ==================== 2026-09-29T18:12:24.077680437Z Zebra configuration information 2026-09-29T18:12:24.077714973Z ================================ 2026-09-29T18:12:24.077719070Z Zebra biblio directory = /var/lib/koha/upgradetest/biblios 2026-09-29T18:12:24.077722407Z Zebra authorities directory = /var/lib/koha/upgradetest/authorities 2026-09-29T18:12:24.077725283Z Koha directory = /kohadevbox/koha 2026-09-29T18:12:24.077727998Z Lockfile = /var/lock/koha/upgradetest/rebuild/rebuild..LCK 2026-09-29T18:12:24.077730733Z BIBLIONUMBER in : 999$c 2026-09-29T18:12:24.077733398Z BIBLIOITEMNUMBER in : 999$d 2026-09-29T18:12:24.077736003Z ================================ 2026-09-29T18:12:24.077738688Z Job started: 18:12:24 2026-09-29T18:12:24.078101616Z ==================== 2026-09-29T18:12:24.078208832Z exporting authority 18:12:24 [00:00:00] 2026-09-29T18:12:24.078216647Z ==================== 2026-09-29T18:12:25.843969527Z . 1.................................................................................................... 101.................................................................................................... 201.................................................................................................... 301.................................................................................................... 401.................................................................................................... 501.................................................................................................... 601.................................................................................................... 701.................................................................................................... 801.................................................................................................... 901.................................................................................................... 1001.................................................................................................... 1101.................................................................................................... 1201.................................................................................................... 1301.................................................................................................... 1401.................................................................................................... 1501.................................................................................................... 1601.................................................................................................... 1701..... 2026-09-29T18:12:25.844021918Z Records exported: 1706 18:12:25 [00:00:01] 2026-09-29T18:12:25.845845483Z ==================== 2026-09-29T18:12:25.845878265Z REINDEXING zebra 18:12:25 [00:00:01] 2026-09-29T18:12:25.845899626Z ==================== 2026-09-29T18:12:27.954727523Z skipping biblios 2026-09-29T18:12:27.954793169Z ==================== 2026-09-29T18:12:27.954798178Z Indexing complete: 18:12:27 [00:00:03] 2026-09-29T18:12:27.954802096Z ==================== 2026-09-29T18:12:27.954806335Z CLEANING 2026-09-29T18:12:27.954810342Z ==================== 2026-09-29T18:12:29.179457462Z Stopping Apache httpd web server: apache2. 2026-09-29T18:12:29.179824718Z [logs] Chowning logs 2026-09-29T18:12:29.181624447Z [*] Success chowning /var/log/koha/upgradetest 2026-09-29T18:12:29.557566662Z Error: Plack already running for upgradetest: failed! 2026-09-29T18:12:32.497356938Z Starting Z39.50/SRU daemon for upgradetest:. 2026-09-29T18:12:32.541107454Z Starting Koha worker daemon for upgradetest (default) 2026-09-29T18:12:32.543978443Z . 2026-09-29T18:12:32.582375891Z Starting Koha worker daemon for upgradetest (long_tasks) 2026-09-29T18:12:32.585122671Z . 2026-09-29T18:12:32.623940836Z Starting Koha indexing daemon for upgradetest:. 2026-09-29T18:12:33.907799541Z Starting Apache httpd web server: apache2. 2026-09-29T18:12:37.753017134Z Starting RabbitMQ Messaging Server: rabbitmq-server. 2026-09-29T18:12:37.754887199Z koha-testing-docker has started up and is ready to be enjoyed!