0s autopkgtest [16:38:08]: starting date and time: 2025-11-17 16:38:08+0000 0s autopkgtest [16:38:08]: git checkout: 4b346b80 nova: make wait_reboot return success even when a no-op 0s autopkgtest [16:38:08]: host juju-7f2275-prod-proposed-migration-environment-20; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.t3ehs5ba/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:feedgenerator --apt-upgrade metalfinder --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=feedgenerator/2.2.1-2 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor builder-cpu2-ram4-disk20 --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-20@bos03-5.secgroup --name adt-resolute-amd64-metalfinder-20251117-163808-juju-7f2275-prod-proposed-migration-environment-20-a2c79d48-609e-4db3-90ca-7071decc139a --image adt/ubuntu-resolute-amd64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-20 --net-id=net_prod-proposed-migration-amd64 -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 3s Creating nova instance adt-resolute-amd64-metalfinder-20251117-163808-juju-7f2275-prod-proposed-migration-environment-20-a2c79d48-609e-4db3-90ca-7071decc139a from image adt/ubuntu-resolute-amd64-server-20251117.img (UUID 47cb9b95-dcf3-40f8-972d-d06b1b09ded2)... 57s autopkgtest [16:39:05]: testbed dpkg architecture: amd64 58s autopkgtest [16:39:06]: testbed apt version: 3.1.11 58s autopkgtest [16:39:06]: @@@@@@@@@@@@@@@@@@@@ test bed setup 58s autopkgtest [16:39:06]: testbed release detected to be: None 59s autopkgtest [16:39:07]: updating testbed package index (apt update) 59s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease [87.8 kB] 60s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 60s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 60s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 60s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse Sources [22.9 kB] 60s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/universe Sources [839 kB] 61s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/main Sources [81.5 kB] 61s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/restricted Sources [9848 B] 61s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 Packages [159 kB] 61s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/main i386 Packages [118 kB] 61s Get:11 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 c-n-f Metadata [3236 B] 61s Get:12 http://ftpmaster.internal/ubuntu resolute-proposed/restricted i386 Packages [3744 B] 61s Get:13 http://ftpmaster.internal/ubuntu resolute-proposed/restricted amd64 Packages [64.6 kB] 61s Get:14 http://ftpmaster.internal/ubuntu resolute-proposed/restricted amd64 c-n-f Metadata [336 B] 61s Get:15 http://ftpmaster.internal/ubuntu resolute-proposed/universe amd64 Packages [585 kB] 61s Get:16 http://ftpmaster.internal/ubuntu resolute-proposed/universe i386 Packages [271 kB] 62s Get:17 http://ftpmaster.internal/ubuntu resolute-proposed/universe amd64 c-n-f Metadata [20.1 kB] 62s Get:18 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse i386 Packages [6516 B] 62s Get:19 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse amd64 Packages [13.4 kB] 62s Get:20 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse amd64 c-n-f Metadata [680 B] 64s Fetched 2286 kB in 2s (960 kB/s) 65s Reading package lists... 66s Hit:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease 66s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 66s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 66s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 67s Reading package lists... 67s Reading package lists... 68s Building dependency tree... 68s Reading state information... 68s Calculating upgrade... 68s The following packages will be upgraded: 68s usbutils 68s 1 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 68s Need to get 83.9 kB of archives. 68s After this operation, 0 B of additional disk space will be used. 68s Get:1 http://ftpmaster.internal/ubuntu resolute/main amd64 usbutils amd64 1:019-1 [83.9 kB] 69s dpkg-preconfigure: unable to re-open stdin: No such file or directory 69s Fetched 83.9 kB in 0s (294 kB/s) 69s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 83372 files and directories currently installed.) 69s Preparing to unpack .../usbutils_1%3a019-1_amd64.deb ... 69s Unpacking usbutils (1:019-1) over (1:018-2) ... 69s Setting up usbutils (1:019-1) ... 69s Processing triggers for man-db (2.13.1-1) ... 70s autopkgtest [16:39:18]: upgrading testbed (apt dist-upgrade and autopurge) 70s Reading package lists... 71s Building dependency tree... 71s Reading state information... 71s Calculating upgrade... 71s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 71s Reading package lists... 72s Building dependency tree... 72s Reading state information... 72s Solving dependencies... 72s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 74s autopkgtest [16:39:22]: testbed running kernel: Linux 6.17.0-5-generic #5-Ubuntu SMP PREEMPT_DYNAMIC Mon Sep 22 10:00:33 UTC 2025 75s autopkgtest [16:39:23]: @@@@@@@@@@@@@@@@@@@@ apt-source metalfinder 76s Get:1 http://ftpmaster.internal/ubuntu resolute/universe metalfinder 2.1.6-2 (dsc) [1594 B] 76s Get:2 http://ftpmaster.internal/ubuntu resolute/universe metalfinder 2.1.6-2 (tar) [25.3 kB] 76s Get:3 http://ftpmaster.internal/ubuntu resolute/universe metalfinder 2.1.6-2 (diff) [4024 B] 76s gpgv: Signature made Wed Jan 25 17:07:08 2023 UTC 76s gpgv: using EDDSA key CAA7400707A816B0202FC3CDF4257A50B21CFA85 76s gpgv: Can't check signature: No public key 76s dpkg-source: warning: cannot verify inline signature for ./metalfinder_2.1.6-2.dsc: no acceptable signature found 76s autopkgtest [16:39:24]: testing package metalfinder version 2.1.6-2 77s autopkgtest [16:39:25]: build not needed 77s autopkgtest [16:39:25]: test unittests: preparing testbed 77s Reading package lists... 77s Building dependency tree... 77s Reading state information... 78s Solving dependencies... 78s The following NEW packages will be installed: 78s docutils-common flit metalfinder python3-all python3-docutils 78s python3-feedgenerator python3-iniconfig python3-mutagen python3-pip 78s python3-pluggy python3-pytest python3-roman python3-tomli-w python3-wheel 78s sgml-base xml-core 78s 0 upgraded, 16 newly installed, 0 to remove and 0 not upgraded. 78s Need to get 2553 kB of archives. 78s After this operation, 15.7 MB of additional disk space will be used. 78s Get:1 http://ftpmaster.internal/ubuntu resolute/main amd64 sgml-base all 1.31+nmu1 [11.0 kB] 78s Get:2 http://ftpmaster.internal/ubuntu resolute/main amd64 xml-core all 0.19 [20.3 kB] 78s Get:3 http://ftpmaster.internal/ubuntu resolute/main amd64 docutils-common all 0.21.2+dfsg-2 [131 kB] 78s Get:4 http://ftpmaster.internal/ubuntu resolute/main amd64 python3-roman all 5.1-1 [10.6 kB] 78s Get:5 http://ftpmaster.internal/ubuntu resolute/main amd64 python3-docutils all 0.21.2+dfsg-2 [409 kB] 79s Get:6 http://ftpmaster.internal/ubuntu resolute/universe amd64 python3-wheel all 0.46.1-2 [22.1 kB] 79s Get:7 http://ftpmaster.internal/ubuntu resolute/universe amd64 python3-pip all 25.1.1+dfsg-1ubuntu2 [1416 kB] 79s Get:8 http://ftpmaster.internal/ubuntu resolute/universe amd64 python3-tomli-w all 1.2.0-1 [8120 B] 79s Get:9 http://ftpmaster.internal/ubuntu resolute/universe amd64 flit all 3.12.0-3 [87.0 kB] 79s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/universe amd64 python3-feedgenerator all 2.2.1-2 [17.6 kB] 79s Get:11 http://ftpmaster.internal/ubuntu resolute/universe amd64 python3-mutagen all 1.47.0-1 [125 kB] 79s Get:12 http://ftpmaster.internal/ubuntu resolute/universe amd64 metalfinder all 2.1.6-2 [13.1 kB] 79s Get:13 http://ftpmaster.internal/ubuntu resolute/main amd64 python3-all amd64 3.13.7-1 [884 B] 79s Get:14 http://ftpmaster.internal/ubuntu resolute/universe amd64 python3-iniconfig all 2.1.0-1 [6840 B] 79s Get:15 http://ftpmaster.internal/ubuntu resolute/universe amd64 python3-pluggy all 1.6.0-1 [21.0 kB] 79s Get:16 http://ftpmaster.internal/ubuntu resolute/universe amd64 python3-pytest all 8.3.5-2 [252 kB] 80s Fetched 2553 kB in 2s (1433 kB/s) 80s Selecting previously unselected package sgml-base. 80s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 83372 files and directories currently installed.) 80s Preparing to unpack .../00-sgml-base_1.31+nmu1_all.deb ... 80s Unpacking sgml-base (1.31+nmu1) ... 80s Selecting previously unselected package xml-core. 80s Preparing to unpack .../01-xml-core_0.19_all.deb ... 80s Unpacking xml-core (0.19) ... 80s Selecting previously unselected package docutils-common. 80s Preparing to unpack .../02-docutils-common_0.21.2+dfsg-2_all.deb ... 80s Unpacking docutils-common (0.21.2+dfsg-2) ... 80s Selecting previously unselected package python3-roman. 80s Preparing to unpack .../03-python3-roman_5.1-1_all.deb ... 80s Unpacking python3-roman (5.1-1) ... 80s Selecting previously unselected package python3-docutils. 80s Preparing to unpack .../04-python3-docutils_0.21.2+dfsg-2_all.deb ... 80s Unpacking python3-docutils (0.21.2+dfsg-2) ... 80s Selecting previously unselected package python3-wheel. 80s Preparing to unpack .../05-python3-wheel_0.46.1-2_all.deb ... 80s Unpacking python3-wheel (0.46.1-2) ... 80s Selecting previously unselected package python3-pip. 80s Preparing to unpack .../06-python3-pip_25.1.1+dfsg-1ubuntu2_all.deb ... 80s Unpacking python3-pip (25.1.1+dfsg-1ubuntu2) ... 80s Selecting previously unselected package python3-tomli-w. 80s Preparing to unpack .../07-python3-tomli-w_1.2.0-1_all.deb ... 80s Unpacking python3-tomli-w (1.2.0-1) ... 80s Selecting previously unselected package flit. 80s Preparing to unpack .../08-flit_3.12.0-3_all.deb ... 80s Unpacking flit (3.12.0-3) ... 80s Selecting previously unselected package python3-feedgenerator. 80s Preparing to unpack .../09-python3-feedgenerator_2.2.1-2_all.deb ... 80s Unpacking python3-feedgenerator (2.2.1-2) ... 80s Selecting previously unselected package python3-mutagen. 80s Preparing to unpack .../10-python3-mutagen_1.47.0-1_all.deb ... 80s Unpacking python3-mutagen (1.47.0-1) ... 80s Selecting previously unselected package metalfinder. 80s Preparing to unpack .../11-metalfinder_2.1.6-2_all.deb ... 80s Unpacking metalfinder (2.1.6-2) ... 80s Selecting previously unselected package python3-all. 80s Preparing to unpack .../12-python3-all_3.13.7-1_amd64.deb ... 80s Unpacking python3-all (3.13.7-1) ... 80s Selecting previously unselected package python3-iniconfig. 80s Preparing to unpack .../13-python3-iniconfig_2.1.0-1_all.deb ... 80s Unpacking python3-iniconfig (2.1.0-1) ... 80s Selecting previously unselected package python3-pluggy. 80s Preparing to unpack .../14-python3-pluggy_1.6.0-1_all.deb ... 80s Unpacking python3-pluggy (1.6.0-1) ... 80s Selecting previously unselected package python3-pytest. 80s Preparing to unpack .../15-python3-pytest_8.3.5-2_all.deb ... 80s Unpacking python3-pytest (8.3.5-2) ... 80s Setting up python3-iniconfig (2.1.0-1) ... 81s Setting up python3-mutagen (1.47.0-1) ... 81s Setting up python3-all (3.13.7-1) ... 81s Setting up python3-wheel (0.46.1-2) ... 81s Setting up python3-roman (5.1-1) ... 81s Setting up python3-pip (25.1.1+dfsg-1ubuntu2) ... 82s Setting up python3-pluggy (1.6.0-1) ... 82s Setting up python3-feedgenerator (2.2.1-2) ... 82s Setting up sgml-base (1.31+nmu1) ... 82s Setting up python3-tomli-w (1.2.0-1) ... 82s Setting up python3-pytest (8.3.5-2) ... 82s Setting up xml-core (0.19) ... 83s Processing triggers for man-db (2.13.1-1) ... 83s Processing triggers for sgml-base (1.31+nmu1) ... 83s Setting up docutils-common (0.21.2+dfsg-2) ... 83s Processing triggers for sgml-base (1.31+nmu1) ... 83s Setting up python3-docutils (0.21.2+dfsg-2) ... 84s Setting up flit (3.12.0-3) ... 84s Setting up metalfinder (2.1.6-2) ... 85s autopkgtest [16:39:33]: test unittests: [----------------------- 85s === python3.13 === 85s ============================= test session starts ============================== 85s platform linux -- Python 3.13.9, pytest-8.3.5, pluggy-1.6.0 -- /usr/bin/python3.13 85s cachedir: .pytest_cache 85s rootdir: /tmp/autopkgtest.F58mpj/autopkgtest_tmp 85s plugins: typeguard-4.4.2 85s collecting ... collected 58 items 85s 85s tests/test_api_bandsintown.py::test_init_stores_properties PASSED [ 1%] 85s tests/test_api_bandsintown.py::RequestTestCase::test_builds_and_executes_request PASSED [ 3%] 85s tests/test_api_bandsintown.py::RequestTestCase::test_merges_passed_in_params PASSED [ 5%] 85s tests/test_api_bandsintown.py::RequestTestCase::test_raises_error_for_bad_api_key PASSED [ 6%] 85s tests/test_api_bandsintown.py::EventsTestCase::test_requests_artist_events PASSED [ 8%] 85s tests/test_api_bandsintown.py::EventsTestCase::test_returns_none_when_artist_not_found PASSED [ 10%] 85s tests/test_api_bandsintown.py::EventsTestCase::test_returns_none_when_no_events_found PASSED [ 12%] 85s tests/test_api_bandsintown.py::EventsTestCase::test_takes_date_param PASSED [ 13%] 85s tests/test_cli.py::test_output_choices_ok PASSED [ 15%] 85s tests/test_cli.py::test_output_choices_invalid_extension PASSED [ 17%] 85s tests/test_cli.py::test_output_choices_invalid_path PASSED [ 18%] 86s tests/test_cli.py::test_date_lint_ok PASSED [ 20%] 86s tests/test_cli.py::test_date_lint_not_iso_8601 PASSED [ 22%] 86s tests/test_cli.py::test_date_lint_maxdate_too_early PASSED [ 24%] 86s tests/test_cli.py::test_dir_not_path PASSED [ 25%] 86s tests/test_cli.py::test_parser_no_dir PASSED [ 27%] 86s tests/test_cli.py::test_parser_no_output PASSED [ 29%] 86s tests/test_cli.py::test_parser_no_location PASSED [ 31%] 86s tests/test_cli.py::test_parser_api_with_env PASSED [ 32%] 86s tests/test_cli.py::test_parser_api_no_env PASSED [ 34%] 86s tests/test_cli.py::test_parser_no_api_with_env PASSED [ 36%] 86s tests/test_cli.py::test_parser_no_api_no_env PASSED [ 37%] 86s tests/test_cli.py::test_parse_cache_default PASSED [ 39%] 86s tests/test_cli.py::test_parser_cache_non_default PASSED [ 41%] 86s tests/test_cli.py::test_parser_verbose_default PASSED [ 43%] 86s tests/test_cli.py::test_parser_verbose_debug PASSED [ 44%] 86s tests/test_cli.py::test_parser_version PASSED [ 46%] 86s tests/test_concerts.py::test_has_changed_false PASSED [ 48%] 86s tests/test_concerts.py::test_has_changed_true PASSED [ 50%] 86s tests/test_concerts.py::test_write_concert_cache PASSED [ 51%] 86s tests/test_concerts.py::test_get_concert_cache PASSED [ 53%] 86s tests/test_concerts.py::test_query_bit[artist_list0-split_artist_list0] PASSED [ 55%] 86s tests/test_concerts.py::test_query_bit[artist_list1-split_artist_list1] PASSED [ 56%] 86s tests/test_concerts.py::test_filter_location PASSED [ 58%] 86s tests/test_output.py::test_pretty_strings PASSED [ 60%] 86s tests/test_output.py::test_atom FAILED [ 62%] 86s tests/test_output.py::test_txt PASSED [ 63%] 86s tests/test_output.py::test_json PASSED [ 65%] 86s tests/test_output.py::test_output_wrapper PASSED [ 67%] 86s tests/test_scan.py::test_has_changed_new[Arch Enemy-arch_enemy.flac] PASSED [ 68%] 86s tests/test_scan.py::test_has_changed_new[Napalm Death-napalm_death.flac] PASSED [ 70%] 86s tests/test_scan.py::test_has_changed_old[Arch Enemy-arch_enemy.flac] PASSED [ 72%] 86s tests/test_scan.py::test_has_changed_old[Napalm Death-napalm_death.flac] PASSED [ 74%] 86s tests/test_scan.py::test_get_artist_ok[Arch Enemy-tests/test_files/arch_enemy.flac] PASSED [ 75%] 86s tests/test_scan.py::test_get_artist_ok[Napalm Death-tests/test_files/napalm_death.flac] PASSED [ 77%] 86s tests/test_scan.py::test_get_artist_common_errors[tests/test_files/no_artist.flac-: 'artist'] PASSED [ 79%] 86s tests/test_scan.py::test_get_artist_common_errors[tests/test_files/no_header.flac-] PASSED [ 81%] 86s tests/test_scan.py::test_write_song_cache PASSED [ 82%] 86s tests/test_scan.py::test_get_song_cache PASSED [ 84%] 86s tests/test_scan.py::test_write_artist_cache PASSED [ 86%] 86s tests/test_scan.py::test_get_artist_cache PASSED [ 87%] 86s tests/test_scan.py::test_scan_dir[Arch Enemy-arch_enemy.flac] PASSED [ 89%] 86s tests/test_scan.py::test_scan_dir[Napalm Death-napalm_death.flac] PASSED [ 91%] 86s tests/test_scan.py::test_scan_wrapper[Arch Enemy-arch_enemy.flac] PASSED [ 93%] 86s tests/test_scan.py::test_scan_wrapper[Napalm Death-napalm_death.flac] PASSED [ 94%] 86s tests/test_scan.py::test_issue21 PASSED [ 96%] 86s tests/test_scan.py::test_issue22 PASSED [ 98%] 86s tests/test_scan.py::test_issue28 SKIPPED (Flaky test on resource-con...) [100%] 86s 86s =================================== FAILURES =================================== 86s __________________________________ test_atom ___________________________________ 86s 86s outdir = PosixPath('/tmp/pytest-of-ubuntu/pytest-0/test_atom0/out') 86s 86s def test_atom(outdir): 86s """Test function atom()""" 86s output = mfo.atom(CONCERT_LIST) 86s # We need to write to a file, since this object is a 86s # feedgenerator.django.utils.feedgenerator.Atom1Feed object 86s with open(str(outdir) + '.atom', 'w', encoding='utf-8') as final: 86s output.write(final, 'utf-8') 86s with open('tests/test_files/concerts.atom', 'r', encoding='utf-8') as file1: 86s valid_atom = file1.read() 86s with open(str(outdir) + '.atom', 'r', encoding='utf-8') as file2: 86s testfile_atom = file2.read() 86s > assert valid_atom == testfile_atom 86s E assert '' == '' 86s E 86s E 86s E - Metalfinderhttps://gitlab.com/baldurmen/metalfinder2022-06-06T20:05:13.366428ZFeed for your personalised concertsArch Enemy @ TheFooBar, Oslo on 2022-11-06 20:002022-06-06T20:05:13.366428Z2022-06-06T20:05:13.366428Z... 86s =================== 1 failed, 56 passed, 1 skipped in 0.29s ==================== 86s autopkgtest [16:39:34]: test unittests: -----------------------] 86s unittests FAIL non-zero exit status 1 86s autopkgtest [16:39:34]: test unittests: - - - - - - - - - - results - - - - - - - - - - 87s autopkgtest [16:39:35]: @@@@@@@@@@@@@@@@@@@@ summary 87s unittests FAIL non-zero exit status 1