Created
May 21, 2025 14:33
-
-
Save b10n1k/a4ac976210a682af9fd3241a18ff57fa to your computer and use it in GitHub Desktop.
This file contains hidden or bidirectional Unicode text that may be interpreted or compiled differently than what appears below. To review, open the file in an editor that reveals hidden Unicode characters.
Learn more about bidirectional Unicode characters
| ❯ OPENQA_FULLSTACK_TEMP_DIR=/home/iob/Desktop FULLSTACK=1 prove -l t/full-stack.t | |
| t/full-stack.t .. 31/? # stopped waiting for '(?^u:Result: passed)', result turned out to be 'incomplete,' | |
| # full result panel contents: | |
| # 3 | |
| # Result: incomplete, finished less than a minute ago (ran for 00:14 minutes) | |
| # Reason: died: terminated prematurely, see log output for details | |
| # Clone of 5 (restarted already 1 time) | |
| # Scheduled product: job has not been created by posting an ISO (but possibly the original job) | |
| # Assigned worker: chameleon.suse.cz:1 | |
| # Actions: | |
| # | |
| # Restart job | |
| # Failed test 'Expected result not found' | |
| # at /home/iob/openqadev/openQA/t/lib/OpenQA/Test/FullstackUtils.pm line 76. | |
| # Failed test 'job 6 passed' | |
| # at t/full-stack.t line 396. | |
| # job info: { | |
| # 'assigned_worker_id' => 1, | |
| # 'blocked_by_id' => undef, | |
| # 'clone_id' => undef, | |
| # 'group_id' => undef, | |
| # 'id' => 6, | |
| # 'name' => 'tinycore-1-flavor-i386-Build1-core@coolone', | |
| # 'origin_id' => 5, | |
| # 'priority' => 50, | |
| # 'reason' => 'died: terminated prematurely, see log output for details', | |
| # 'result' => 'incomplete', | |
| # 'settings' => { | |
| # 'ARCH' => 'i386', | |
| # 'BUILD' => '1', | |
| # 'DISTRI' => 'tinycore', | |
| # 'FLAVOR' => 'flavor', | |
| # 'INTEGRATION_TESTS' => '1', | |
| # 'ISO' => 'Core-7.2.iso', | |
| # 'MACHINE' => 'coolone', | |
| # 'NAME' => '00000006-tinycore-1-flavor-i386-Build1-core@coolone', | |
| # 'PUBLISH_HDD_1' => '', | |
| # 'QEMU' => 'i386', | |
| # 'QEMU_NO_FDC_SET' => '1', | |
| # 'QEMU_NO_TABLET' => '1', | |
| # 'TEST' => 'core', | |
| # 'UEFI_PFLASH_VARS' => '/usr/share/qemu/ovmf-x86_64.bin', | |
| # 'VERSION' => '1', | |
| # 'WORKER_CLASS' => 'qemu_i386' | |
| # }, | |
| # 'state' => 'done', | |
| # 't_finished' => '2025-05-21T14:15:28', | |
| # 't_started' => '2025-05-21T14:15:14', | |
| # 'test' => 'core' | |
| # } | |
| # Looks like you failed 2 tests of 6. | |
| # Failed test 'results of test 6' | |
| # at t/full-stack.t line 403. | |
| # /home/iob/Desktop/full-stack.d/openqa/testresults/00000/00000006-tinycore-1-flavor-i386-Build1-core@coolone/autoinst-log.txt: | |
| # [2025-05-21T16:15:14.760244+02:00] [info] [pid:355531] +++ setup notes +++ | |
| # [2025-05-21T16:15:14.760471+02:00] [info] [pid:355531] Running on chameleon.suse.cz:1 (Linux 6.14.6-1-default #1 SMP PREEMPT_DYNAMIC Tue May 13 09:56:22 UTC 2025 (ad69173) x86_64) | |
| # [2025-05-21T16:15:14.767691+02:00] [debug] [pid:355531] Found ISO, caching Core-7.2.iso | |
| # [2025-05-21T16:15:14.782066+02:00] [info] [pid:355531] Downloading Core-7.2.iso, request #2 sent to Cache Service | |
| # [2025-05-21T16:15:19.841647+02:00] [info] [pid:355531] Download of Core-7.2.iso processed | |
| # [2025-05-21T16:15:19.848803+02:00] [debug] [pid:355603] +++ worker notes +++ | |
| # [2025-05-21T16:15:20.304477+02:00] [debug] [pid:355603] Current version is fac36516cca173f765987dea7b32646c56c15d32 [interface v44] | |
| # [2025-05-21T16:15:20.314602+02:00] [debug] [pid:355603] git hash in 'tinycore': fac36516cca173f765987dea7b32646c56c15d32 | |
| # [2025-05-21T16:15:20.314794+02:00] [debug] [pid:355603] git url in 'tinycore': "UNKNOWN (no .git found)" | |
| # [2025-05-21T16:15:20.333053+02:00] [debug] [pid:355603] scheduling boot tests/boot.pm | |
| # [2025-05-21T16:15:20.333771+02:00] [debug] [pid:355603] scheduling assert_screen tests/assert_screen.pm | |
| # [2025-05-21T16:15:20.334341+02:00] [debug] [pid:355603] scheduling shutdown tests/shutdown.pm | |
| # [2025-05-21T16:15:20.341205+02:00] [info] [pid:355610] cmdsrv: daemon reachable under http://*:20013/u7Orv6rOUzAon2Bt/ | |
| # [2025-05-21T16:15:20.342834+02:00] [info] [pid:355610] Listening at "http://[::]:20013" | |
| # Web application available at http://[::]:20013 | |
| # [2025-05-21T16:15:20.346846+02:00] [debug] [pid:355603] git hash in 'tinycore/needles': fac36516cca173f765987dea7b32646c56c15d32 | |
| # [2025-05-21T16:15:20.347066+02:00] [debug] [pid:355603] git url in 'tinycore/needles': "UNKNOWN (no .git found)" | |
| # [2025-05-21T16:15:20.347174+02:00] [debug] [pid:355603] init needles from tinycore/needles | |
| # [2025-05-21T16:15:20.348396+02:00] [debug] [pid:355603] loaded 4 needles | |
| # [2025-05-21T16:15:20.448784+02:00] [debug] [pid:355603] 355603: channel_out 16, channel_in 15 | |
| # [2025-05-21T16:15:20.469826+02:00] [debug] [pid:355634] 355634: cmdpipe 14, rsppipe 17 | |
| # [2025-05-21T16:15:20.470011+02:00] [debug] [pid:355634] started mgmt loop with pid 355634 | |
| # [2025-05-21T16:15:20.582921+02:00] [debug] [pid:355634] Launching external video encoder: ffmpeg -y -hide_banner -nostats -r 24 -f image2pipe -vcodec ppm -i - -pix_fmt yuv420p -c:v libsvtav1 -crf 50 -preset 7 'video.webm' | |
| # [2025-05-21T16:15:20.652650+02:00] [debug] [pid:355634] qemu version detected: 10.0.0 | |
| # [2025-05-21T16:15:20.653898+02:00] [debug] [pid:355634] running `/usr/bin/chattr +C /home/iob/Desktop/full-stack.d/openqa/pool/1/raid` | |
| # [2025-05-21T16:15:20.662201+02:00] [debug] [pid:355634] Command `/usr/bin/chattr +C /home/iob/Desktop/full-stack.d/openqa/pool/1/raid` terminated with 1 | |
| # /usr/bin/chattr: Operation not supported while setting flags on /home/iob/Desktop/full-stack.d/openqa/pool/1/raid | |
| # [2025-05-21T16:15:20.662333+02:00] [debug] [pid:355634] Configuring storage controllers and block devices | |
| # [2025-05-21T16:15:20.662820+02:00] [debug] [pid:355634] running `/usr/bin/qemu-img info --output=json /home/iob/Desktop/full-stack.d/openqa/pool/1/Core-7.2.iso` | |
| # [2025-05-21T16:15:20.693748+02:00] [debug] [pid:355634] Initializing block device images | |
| # [2025-05-21T16:15:20.693984+02:00] [debug] [pid:355634] running `/usr/bin/qemu-img create -f qcow2 /home/iob/Desktop/full-stack.d/openqa/pool/1/raid/hd0 10G` | |
| # [2025-05-21T16:15:20.738575+02:00] [debug] [pid:355634] Formatting '/home/iob/Desktop/full-stack.d/openqa/pool/1/raid/hd0', fmt=qcow2 cluster_size=65536 extended_l2=off compression_type=zlib size=10737418240 lazy_refcounts=off refcount_bits=16 | |
| # [2025-05-21T16:15:20.738823+02:00] [debug] [pid:355634] running `/usr/bin/qemu-img create -f qcow2 -F raw -b /home/iob/Desktop/full-stack.d/openqa/pool/1/Core-7.2.iso /home/iob/Desktop/full-stack.d/openqa/pool/1/raid/cd0-overlay0 11116544` | |
| # [2025-05-21T16:15:20.774332+02:00] [debug] [pid:355634] Formatting '/home/iob/Desktop/full-stack.d/openqa/pool/1/raid/cd0-overlay0', fmt=qcow2 cluster_size=65536 extended_l2=off compression_type=zlib size=11116544 backing_file=/home/iob/Desktop/full-stack.d/openqa/pool/1/Core-7.2.iso backing_fmt=raw lazy_refcounts=off refcount_bits=16 | |
| # [2025-05-21T16:15:20.774506+02:00] [debug] [pid:355634] init_blockdev_images: Finished creating block devices | |
| # [2025-05-21T16:15:20.775656+02:00] [debug] [pid:355634] starting: /usr/bin/qemu-system-i386 -device VGA,edid=on,xres=1024,yres=768 -only-migratable -chardev ringbuf,id=serial0,logfile=serial0,logappend=on -serial chardev:serial0 -audiodev none,id=snd0 -device intel-hda -device hda-output,audiodev=snd0 -m 1024 -netdev user,id=qanet0 -device virtio-net,netdev=qanet0,mac=52:54:00:12:34:56 -object rng-random,filename=/dev/urandom,id=rng0 -device virtio-rng-pci,rng=rng0 -boot once=d -smp 1 -enable-kvm -no-shutdown -vnc :91,share=force-shared -device virtio-serial -chardev pipe,id=virtio_console,path=virtio_console,logfile=virtio_console.log,logappend=on -device virtconsole,chardev=virtio_console,name=org.openqa.console.virtio_console -chardev pipe,id=virtio_console_user,path=virtio_console_user,logfile=virtio_console_user.log,logappend=on -device virtconsole,chardev=virtio_console_user,name=org.openqa.console.virtio_console_user -chardev socket,path=qmp_socket,server=on,wait=off,id=qmp_socket,logfile=qmp_socket.log,logappend=on -qmp chardev:qmp_socket -S -device virtio-scsi-pci,id=scsi0 -blockdev driver=file,node-name=hd0-file,filename=/home/iob/Desktop/full-stack.d/openqa/pool/1/raid/hd0,cache.no-flush=on -blockdev driver=qcow2,node-name=hd0,file=hd0-file,cache.no-flush=on,discard=unmap -device virtio-blk,id=hd0-device,drive=hd0,serial=hd0 -blockdev driver=file,node-name=cd0-overlay0-file,filename=/home/iob/Desktop/full-stack.d/openqa/pool/1/raid/cd0-overlay0,cache.no-flush=on -blockdev driver=qcow2,node-name=cd0-overlay0,file=cd0-overlay0-file,cache.no-flush=on,discard=unmap -device scsi-cd,id=cd0-device,drive=cd0-overlay0,serial=cd0 | |
| # [2025-05-21T16:15:20.780571+02:00] [debug] [pid:355634] Waiting for 0 attempts | |
| # [2025-05-21T16:15:21.781162+02:00] [debug] [pid:355634] Waiting for 1 attempts | |
| # [2025-05-21T16:15:22.781670+02:00] [debug] [pid:355634] Finished after 2 attempts | |
| # [2025-05-21T16:15:22.783561+02:00] [debug] [pid:355634] Establishing VNC connection to localhost:5991 | |
| # [2025-05-21T16:15:22.837971+02:00] [debug] [pid:355634] pointer type 0 0 640 480 -257 | |
| # [2025-05-21T16:15:22.838188+02:00] [debug] [pid:355634] led state 0 1 1 -261 | |
| # [2025-05-21T16:15:22.842767+02:00] [debug] [pid:355634] Start CPU | |
| # [2025-05-21T16:15:22.843196+02:00] [debug] [pid:355634] EVENT {"data":{"client":{"family":"ipv4","host":"127.0.0.1","service":"43018","websocket":false},"server":{"auth":"none","family":"ipv4","host":"0.0.0.0","service":"5991","websocket":false}},"event":"VNC_CONNECTED","timestamp":{"microseconds":784416,"seconds":1747836922}} | |
| # [2025-05-21T16:15:22.843293+02:00] [debug] [pid:355634] EVENT {"data":{"client":{"family":"ipv4","host":"127.0.0.1","service":"43018","websocket":false},"server":{"auth":"none","family":"ipv4","host":"0.0.0.0","service":"5991","websocket":false}},"event":"VNC_INITIALIZED","timestamp":{"microseconds":786596,"seconds":1747836922}} | |
| # [2025-05-21T16:15:22.843354+02:00] [debug] [pid:355634] EVENT {"event":"RESUME","timestamp":{"microseconds":843197,"seconds":1747836922}} | |
| # [2025-05-21T16:15:22.844447+02:00] [debug] [pid:355613] GOT GO | |
| # [2025-05-21T16:15:22.848233+02:00] [debug] [pid:355634] QEMU: QEMU emulator version 10.0.0 (openSUSE Tumbleweed) | |
| # [2025-05-21T16:15:22.848349+02:00] [debug] [pid:355634] QEMU: Copyright (c) 2003-2025 Fabrice Bellard and the QEMU Project developers | |
| # [2025-05-21T16:15:22.851780+02:00] [debug] [pid:355613] Snapshots are supported | |
| # [2025-05-21T16:15:22.852967+02:00] [debug] [pid:355613] ||| starting boot tests/boot.pm | |
| # [2025-05-21T16:15:22.855222+02:00] [debug] [pid:355613] tests/boot.pm:9 called testapi::assert_screen | |
| # [2025-05-21T16:15:22.855612+02:00] [debug] [pid:355613] <<< testapi::assert_screen(mustmatch="core", timeout=15, no_wait=1) | |
| # [2025-05-21T16:15:22.881415+02:00] [debug] [pid:355634] no match: 14.9s, best candidate: boot-core (0.00) | |
| # [2025-05-21T16:15:22.982412+02:00] [debug] [pid:355634] no change: 14.8s | |
| # [2025-05-21T16:15:22.998462+02:00] [debug] [pid:355634] no match: 14.8s, best candidate: boot-core (0.00) | |
| # [2025-05-21T16:15:23.099439+02:00] [debug] [pid:355634] no change: 14.7s | |
| # [2025-05-21T16:15:23.116595+02:00] [debug] [pid:355634] no match: 14.7s, best candidate: boot-core (0.00) | |
| # [2025-05-21T16:15:23.217707+02:00] [debug] [pid:355634] no change: 14.6s | |
| # [2025-05-21T16:15:23.233480+02:00] [debug] [pid:355634] no match: 14.6s, best candidate: boot-core (0.00) | |
| # [2025-05-21T16:15:23.334602+02:00] [debug] [pid:355634] no change: 14.5s | |
| # [2025-05-21T16:15:23.350957+02:00] [debug] [pid:355634] no match: 14.5s, best candidate: boot-core (0.00) | |
| # [2025-05-21T16:15:23.506136+02:00] [debug] [pid:355613] >>> testapi::_handle_found_needle: found boot-core, similarity 0.97 @ 1/74 | |
| # [2025-05-21T16:15:23.506546+02:00] [debug] [pid:355613] tests/boot.pm:10 called testapi::send_key | |
| # [2025-05-21T16:15:23.506655+02:00] [debug] [pid:355613] <<< testapi::send_key(key="ret", wait_screen_change=0) | |
| # [2025-05-21T16:15:23.776576+02:00] [debug] [pid:355613] tests/boot.pm:14 called testapi::assert_screen | |
| # [2025-05-21T16:15:23.776771+02:00] [debug] [pid:355613] <<< testapi::assert_screen(mustmatch="on_prompt", timeout=90) | |
| # Input #0, image2pipe, from 'fd:': | |
| # Duration: N/A, bitrate: N/A | |
| # Stream #0:0: Video: ppm, rgb24, 1024x768, 24 fps, 24 tbr, 24 tbn | |
| # Stream mapping: | |
| # Stream #0:0 -> #0:0 (ppm (native) -> av1 (libsvtav1)) | |
| # Svt[info]: ------------------------------------------- | |
| # Svt[info]: SVT [version]: SVT-AV1 Encoder Lib v3.0.0 | |
| # Svt[info]: SVT [build] : GCC 14.2.1 20250220 [revision 9ffecde121af883b60bbe60d00425036bc873048] 64 bit | |
| # Svt[info]: LIB Build date: Mar 14 2025 10:08:16 | |
| # Svt[info]: ------------------------------------------- | |
| # Svt[info]: Level of Parallelism: 5 | |
| # Svt[info]: Number of PPCS 140 | |
| # Svt[info]: [asm level on system : up to avx512icl] | |
| # Svt[info]: [asm level selected : up to avx512icl] | |
| # Svt[info]: ------------------------------------------- | |
| # Svt[info]: SVT [config]: main profile tier (auto) level (auto) | |
| # Svt[info]: SVT [config]: width / height / fps numerator / fps denominator : 1024 / 768 / 24 / 1 | |
| # Svt[info]: SVT [config]: bit-depth / color format : 8 / YUV420 | |
| # Svt[info]: SVT [config]: preset / tune / pred struct : 7 / PSNR / random access | |
| # Svt[info]: SVT [config]: gop size / mini-gop size / key-frame type : 161 / 32 / key frame | |
| # Svt[info]: SVT [config]: BRC mode / rate factor : CRF / 50 | |
| # Svt[info]: SVT [config]: AQ mode / variance boost : 2 / 0 | |
| # Svt[info]: SVT [config]: sharpness / luminance-based QP bias : 0 / 0 | |
| # Svt[info]: Svt[info]: ------------------------------------------- | |
| # Output #0, webm, to 'video.webm': | |
| # Metadata: | |
| # encoder : Lavf61.7.100 | |
| # Stream #0:0: Video: av1, yuv420p(tv, progressive), 1024x768, q=2-31, 24 fps, 1k tbn | |
| # Metadata: | |
| # encoder : Lavc61.19.101 libsvtav1 | |
| # [2025-05-21T16:15:24.457586+02:00] [debug] [pid:355634] no match: 89.3s, best candidate: boot-on_prompt (0.00) | |
| # [2025-05-21T16:15:25.499485+02:00] [debug] [pid:355613] >>> testapi::_handle_found_needle: found boot-on_prompt, similarity 1.00 @ 2/64 | |
| # [2025-05-21T16:15:25.503151+02:00] [debug] [pid:355613] ||| finished boot tests (runtime: 3 s) | |
| # [2025-05-21T16:15:25.504591+02:00] [debug] [pid:355613] ||| starting assert_screen tests/assert_screen.pm | |
| # [2025-05-21T16:15:25.505389+02:00] [debug] [pid:355613] tests/assert_screen.pm:9 called testapi::assert_screen | |
| # [2025-05-21T16:15:25.505526+02:00] [debug] [pid:355613] <<< testapi::assert_screen(mustmatch="on_prompt", timeout=60) | |
| # [2025-05-21T16:15:26.505643+02:00] [debug] [pid:355613] >>> testapi::_handle_found_needle: found boot-on_prompt, similarity 1.00 @ 2/64 | |
| # [2025-05-21T16:15:26.506220+02:00] [debug] [pid:355613] tests/assert_screen.pm:10 called testapi::assert_screen | |
| # [2025-05-21T16:15:26.506349+02:00] [debug] [pid:355613] <<< testapi::assert_screen(mustmatch="on_prompt", timeout=30, no_wait=1) | |
| # [2025-05-21T16:15:26.566298+02:00] [debug] [pid:355613] >>> testapi::_handle_found_needle: found boot-on_prompt, similarity 1.00 @ 2/64 | |
| # [2025-05-21T16:15:26.567816+02:00] [debug] [pid:355613] ||| finished assert_screen tests (runtime: 1 s) | |
| # [2025-05-21T16:15:26.568908+02:00] [debug] [pid:355613] ||| starting shutdown tests/shutdown.pm | |
| # [2025-05-21T16:15:26.569735+02:00] [debug] [pid:355613] tests/shutdown.pm:8 called testapi::power | |
| # [2025-05-21T16:15:26.569913+02:00] [debug] [pid:355613] <<< testapi::power(action="off") | |
| # [2025-05-21T16:15:26.570705+02:00] [debug] [pid:355634] POWER: action: off, expected_shutdown: 1 | |
| # [2025-05-21T16:15:26.571003+02:00] [debug] [pid:355634] EVENT {"data":{"path":"\/machine\/peripheral-anon\/device[3]\/virtio-backend"},"event":"NIC_RX_FILTER_CHANGED","timestamp":{"microseconds":747778,"seconds":1747836924}} | |
| # [2025-05-21T16:15:26.571129+02:00] [debug] [pid:355634] EVENT {"data":{"client":{"family":"ipv4","host":"127.0.0.1","service":"43018","websocket":false},"server":{"auth":"none","family":"ipv4","host":"0.0.0.0","service":"5991","websocket":false}},"event":"VNC_DISCONNECTED","timestamp":{"microseconds":570667,"seconds":1747836926}} | |
| # [2025-05-21T16:15:26.571244+02:00] [debug] [pid:355634] EVENT {"data":{"guest":false,"reason":"host-qmp-quit"},"event":"SHUTDOWN","timestamp":{"microseconds":571162,"seconds":1747836926}} | |
| # [2025-05-21T16:15:26.576279+02:00] [debug] [pid:355613] tests/shutdown.pm:9 called testapi::assert_shutdown | |
| # [2025-05-21T16:15:26.576476+02:00] [debug] [pid:355613] <<< testapi::check_shutdown(timeout=90) | |
| # [2025-05-21T16:15:26.637969+02:00] [debug] [pid:355613] ||| finished shutdown tests (runtime: 0 s) | |
| # [2025-05-21T16:15:27.825983+02:00] [debug] [pid:355603] backend process exited: 0 | |
| # [2025-05-21T16:15:27.827637+02:00] [info] [pid:355603] ::: backend::driver::_collect_orphan: Driver backend collected unknown process with pid 355651 and exit status: 0 | |
| # [2025-05-21T16:15:27.828440+02:00] [debug] [pid:355603] isotovideo handle_shutdown | |
| # [2025-05-21T16:15:27.828542+02:00] [debug] [pid:355603] stopping command server 355610 because test execution ended | |
| # [2025-05-21T16:15:27.828602+02:00] [debug] [pid:355603] isotovideo: informing websocket clients before stopping command server: http://127.0.0.1:20013/u7Orv6rOUzAon2Bt/broadcast | |
| # [2025-05-21T16:15:27.829278+02:00] [debug] [pid:355613] Sending tests_done | |
| # [2025-05-21T16:15:27.854858+02:00] [debug] [pid:355603] commands process exited: 0 | |
| # [2025-05-21T16:15:27.955319+02:00] [debug] [pid:355603] done with command server | |
| # [2025-05-21T16:15:27.955669+02:00] [debug] [pid:355603] stopping autotest process 355613 | |
| # [2025-05-21T16:15:27.968163+02:00] [debug] [pid:355603] [autotest] process exited: 0 | |
| # [2025-05-21T16:15:28.068610+02:00] [debug] [pid:355603] done with autotest process | |
| # [2025-05-21T16:15:28.068753+02:00] [debug] [pid:355603] isotovideo failed | |
| # [2025-05-21T16:15:28.069369+02:00] [debug] [pid:355603] stopping backend process 355634 | |
| # [2025-05-21T16:15:28.069462+02:00] [debug] [pid:355603] done with backend process | |
| # 355603: EXIT 1 | |
| # [2025-05-21T16:15:28.098790+02:00] [info] [pid:355531] Isotovideo exit status: 1 | |
| # [out#0/webm @ 0x5648cde55d80] video:10KiB audio:0KiB subtitle:0KiB other streams:0KiB global headers:0KiB muxing overhead: 5.692292% | |
| # frame= 9 fps=2.1 q=37.0 Lsize= 10KiB time=00:00:00.33 bitrate= 250.4kbits/s speed=0.0786x | |
| # Exiting normally, received signal 15. | |
| # [2025-05-21T16:15:28.284564+02:00] [info] [pid:355531] +++ worker notes +++ | |
| # [2025-05-21T16:15:28.284756+02:00] [info] [pid:355531] End time: 2025-05-21 14:15:28 | |
| # [2025-05-21T16:15:28.284809+02:00] [info] [pid:355531] Result: died | |
| # [2025-05-21T16:15:28.291022+02:00] [info] [pid:355950] Uploading video.webm | |
| # [2025-05-21T16:15:28.360472+02:00] [info] [pid:355950] Uploading autoinst-log.txt | |
| # /home/iob/Desktop/full-stack.d/openqa/testresults/00000/00000006-tinycore-1-flavor-i386-Build1-core@coolone/worker-log.txt: | |
| # [2025-05-21T16:15:14.759837+02:00] [debug] [pid:355531] Preparing Mojo::IOLoop::ReadWriteProcess::Session | |
| # [2025-05-21T16:15:14.760798+02:00] [debug] [pid:355531] Job settings: | |
| # ARCH=i386 | |
| # BUILD=1 | |
| # CACHEDIRECTORY=/home/iob/Desktop/full-stack.d/cache | |
| # CACHELIMIT=50 | |
| # CRITICAL_LOAD_AVG_THRESHOLD=0 | |
| # DISTRI=tinycore | |
| # FLAVOR=flavor | |
| # INTEGRATION_TESTS=1 | |
| # ISO=Core-7.2.iso | |
| # JOBTOKEN=u7Orv6rOUzAon2Bt | |
| # LOCAL_UPLOAD=0 | |
| # LOG_LEVEL=debug | |
| # MACHINE=coolone | |
| # NAME=00000006-tinycore-1-flavor-i386-Build1-core@coolone | |
| # OPENQA_HOSTNAME=localhost:9526 | |
| # OPENQA_URL=http://localhost:9526 | |
| # PUBLISH_HDD_1= | |
| # QEMU=i386 | |
| # QEMUPORT=20012 | |
| # QEMU_NO_FDC_SET=1 | |
| # QEMU_NO_TABLET=1 | |
| # RETRY_DELAY=5 | |
| # RETRY_DELAY_IF_WEBUI_BUSY=60 | |
| # TEST=core | |
| # UEFI_PFLASH_VARS=/usr/share/qemu/ovmf-x86_64.bin | |
| # VERSION=1 | |
| # VNC=91 | |
| # WORKER_CLASS=qemu_i386,qemu_x86_64 | |
| # WORKER_HOSTNAME=localhost | |
| # WORKER_ID=1 | |
| # WORKER_INSTANCE=1 | |
| # [2025-05-21T16:15:14.782216+02:00] [debug] [pid:355531] Updating status so job 6 is not considered dead. | |
| # [2025-05-21T16:15:14.782471+02:00] [debug] [pid:355531] REST-API call: POST "http://localhost:9526/api/v1/jobs/6/status" | |
| # [2025-05-21T16:15:19.810102+02:00] [debug] [pid:355531] Updating status so job 6 is not considered dead. | |
| # [2025-05-21T16:15:19.810554+02:00] [debug] [pid:355531] REST-API call: POST "http://localhost:9526/api/v1/jobs/6/status" | |
| # [2025-05-21T16:15:19.842248+02:00] [debug] [pid:355531] Linked asset "/home/iob/Desktop/full-stack.d/cache/localhost/Core-7.2.iso" to "/home/iob/Desktop/full-stack.d/openqa/pool/1/Core-7.2.iso" | |
| # [2025-05-21T16:15:19.842614+02:00] [debug] [pid:355531] Symlinked from "/home/iob/Desktop/full-stack.d/openqa/share/tests/tinycore" to "/home/iob/Desktop/full-stack.d/openqa/pool/1/tinycore" | |
| # [2025-05-21T16:15:19.842909+02:00] [info] [pid:355531] Preparing cgroup to start isotovideo | |
| # [2025-05-21T16:15:19.843647+02:00] [warn] [pid:355531] Disabling cgroup usage because cgroup creation failed: mkdir /sys/fs/cgroup/systemd: Permission denied at /usr/lib/perl5/vendor_perl/5.40.0/Mojo/File.pm line 85. | |
| # [2025-05-21T16:15:19.843718+02:00] [info] [pid:355531] You can define a custom slice with OPENQA_CGROUP_SLICE or indicating the base mount with MOJO_CGROUP_FS. | |
| # [2025-05-21T16:15:19.843970+02:00] [info] [pid:355531] Starting isotovideo container | |
| # [2025-05-21T16:15:19.848361+02:00] [debug] [pid:355531] Registered process:355603 | |
| # [2025-05-21T16:15:19.848530+02:00] [info] [pid:355603] 355603: WORKING 6 | |
| # [2025-05-21T16:15:19.848863+02:00] [info] [pid:355531] isotovideo has been started (PID: 355603) | |
| # [2025-05-21T16:15:19.849406+02:00] [debug] [pid:355531] Starting livelog | |
| # [2025-05-21T16:15:19.850892+02:00] [debug] [pid:355531] REST-API call: POST "http://localhost:9526/api/v1/jobs/6/status" | |
| # [2025-05-21T16:15:19.851984+02:00] [debug] [pid:355531] Running job 6 from http://localhost:9526: 00000006-tinycore-1-flavor-i386-Build1-core@coolone. | |
| # [2025-05-21T16:15:19.853089+02:00] [debug] [pid:355531] REST-API call: POST "http://localhost:9526/api/v1/jobs/6/status" | |
| # [2025-05-21T16:15:19.879455+02:00] [debug] [pid:355531] Upload concluded (no current module) | |
| # [2025-05-21T16:15:19.896443+02:00] [debug] [pid:355531] Upload concluded (no current module) | |
| # [2025-05-21T16:15:20.880868+02:00] [debug] [pid:355531] REST-API call: POST "http://localhost:9526/api/v1/jobs/6/status" | |
| # [2025-05-21T16:15:20.904198+02:00] [debug] [pid:355531] Upload concluded (no current module) | |
| # [2025-05-21T16:15:21.906664+02:00] [debug] [pid:355531] REST-API call: POST "http://localhost:9526/api/v1/jobs/6/status" | |
| # [2025-05-21T16:15:21.932406+02:00] [debug] [pid:355531] Upload concluded (no current module) | |
| # [2025-05-21T16:15:22.935438+02:00] [debug] [pid:355531] REST-API call: POST "http://localhost:9526/api/v1/jobs/6/status" | |
| # [2025-05-21T16:15:22.973096+02:00] [debug] [pid:355531] Upload concluded (at boot) | |
| # [2025-05-21T16:15:23.975078+02:00] [debug] [pid:355531] REST-API call: POST "http://localhost:9526/api/v1/jobs/6/status" | |
| # [2025-05-21T16:15:24.006256+02:00] [debug] [pid:355531] Upload concluded (at boot) | |
| # [2025-05-21T16:15:25.008096+02:00] [debug] [pid:355531] REST-API call: POST "http://localhost:9526/api/v1/jobs/6/status" | |
| # [2025-05-21T16:15:25.046608+02:00] [debug] [pid:355531] Upload concluded (at boot) | |
| # [2025-05-21T16:15:26.048377+02:00] [debug] [pid:355531] REST-API call: POST "http://localhost:9526/api/v1/jobs/6/status" | |
| # [2025-05-21T16:15:26.117941+02:00] [debug] [pid:355531] Upload concluded (up to boot) | |
| # [2025-05-21T16:15:27.120306+02:00] [debug] [pid:355531] REST-API call: POST "http://localhost:9526/api/v1/jobs/6/status" | |
| # [2025-05-21T16:15:27.199003+02:00] [debug] [pid:355531] Upload concluded (up to assert_screen) | |
| # [2025-05-21T16:15:28.099092+02:00] [debug] [pid:355531] Stopping job 6 from http://localhost:9526: 00000006-tinycore-1-flavor-i386-Build1-core@coolone - reason: died | |
| # [2025-05-21T16:15:28.099649+02:00] [debug] [pid:355531] REST-API call: POST "http://localhost:9526/api/v1/jobs/6/status" | |
| # [2025-05-21T16:15:28.121916+02:00] [debug] [pid:355531] Announcing job termination (due to died) to command server via http://localhost:20013/u7Orv6rOUzAon2Bt/broadcast | |
| # [2025-05-21T16:15:28.124433+02:00] [debug] [pid:355531] Unable to announce job termination (NOT the reason for the job termination): | |
| # [2025-05-21T16:15:28.124536+02:00] [debug] [pid:355531] Command server is likely finished already | |
| # [2025-05-21T16:15:28.290895+02:00] [info] [pid:355950] Uploading video.webm | |
| # [2025-05-21T16:15:28.291166+02:00] [debug] [pid:355950] Uploading artefact video.webm | |
| # [2025-05-21T16:15:28.291173+02:00] [debug] [pid:355531] REST-API call: POST "http://localhost:9526/api/v1/jobs/6/status" | |
| # [2025-05-21T16:15:28.360367+02:00] [info] [pid:355950] Uploading autoinst-log.txt | |
| # [2025-05-21T16:15:28.360601+02:00] [debug] [pid:355950] Uploading artefact autoinst-log.txt | |
| # [2025-05-21T16:15:28.369979+02:00] [debug] [pid:355531] Upload concluded (up to shutdown) | |
| # [2025-05-21T16:15:28.381011+02:00] [info] [pid:355950] Uploading worker-log.txt | |
| # [2025-05-21T16:15:28.381224+02:00] [debug] [pid:355950] Uploading artefact worker-log.txt | |
| # Looks like you failed 1 test of 26. | |
| t/full-stack.t .. 34/? | |
| # Failed test 'Cache tests' | |
| # at t/full-stack.t line 447. | |
| # Looks like you failed 1 test of 35. | |
| t/full-stack.t .. Dubious, test returned 1 (wstat 256, 0x100) | |
| Failed 1/35 subtests | |
| Test Summary Report | |
| ------------------- | |
| t/full-stack.t (Wstat: 256 (exited 1) Tests: 35 Failed: 1) | |
| Failed test: 34 | |
| Non-zero exit status: 1 | |
| Files=1, Tests=35, 111 wallclock secs ( 0.16 usr 0.01 sys + 32.99 cusr 9.16 csys = 42.32 CPU) | |
| Result: FAIL |
Sign up for free
to join this conversation on GitHub.
Already have an account?
Sign in to comment