[38.979083] Initializing watchdogs [38.979149] /dev/watchdog0 [38.985257] [001/143] (960s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [40.937070] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling [40.938141] Starting dynamic subtest: pipe-A-valid-mode [40.985318] Dynamic subtest pipe-A-valid-mode: SKIP (0.046s) [40.987116] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.048s) [41.071324] [002/143] (958s left) gem_vm_create (invalid-destroy) [41.138828] Starting subtest: invalid-destroy [41.141013] Subtest invalid-destroy: SUCCESS (0.002s) [41.255144] [003/143] (958s left) gem_exec_whisper (basic-contexts-priority-all) [41.359902] Starting subtest: basic-contexts-priority-all [65.101524] Subtest basic-contexts-priority-all: SUCCESS (23.737s) [65.273073] [004/143] (934s left) kms_psr (fbc-psr2-cursor-render) [67.230705] Subtest fbc-psr2-cursor-render: SKIP (0.000s) [67.256982] [005/143] (932s left) kms_ccs (pipe-a-crc-primary-rotation-180-4-tiled-dg2-mc-ccs) [69.264334] Starting subtest: pipe-A-crc-primary-rotation-180-4-tiled-dg2-mc-ccs [69.266057] Subtest pipe-A-crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.000s) [69.480438] [006/143] (930s left) kms_vrr (seamless-rr-switch-vrr) [71.438120] Starting subtest: seamless-rr-switch-vrr [71.440045] Subtest seamless-rr-switch-vrr: SKIP (0.000s) [71.499318] [007/143] (928s left) vc4/vc4_purgeable_bo (mark-purgeable-twice) [71.651345] Subtest mark-purgeable-twice: SKIP (0.000s) [71.698319] [008/143] (927s left) kms_chamelium_color (ctm-negative) [73.661304] Subtest ctm-negative: SKIP (0.000s) [73.689585] [009/143] (925s left) gem_exec_schedule (lateslice) [73.753582] Starting subtest: lateslice [73.754547] Starting dynamic subtest: rcs0 [73.790441] Dynamic subtest rcs0: SUCCESS (0.037s) [73.796761] Starting dynamic subtest: bcs0 [73.810350] Dynamic subtest bcs0: SUCCESS (0.020s) [73.817863] Starting dynamic subtest: vcs0 [73.831030] Dynamic subtest vcs0: SUCCESS (0.020s) [73.838546] Starting dynamic subtest: vcs1 [73.851475] Dynamic subtest vcs1: SUCCESS (0.020s) [73.858890] Starting dynamic subtest: vecs0 [73.873787] Dynamic subtest vecs0: SUCCESS (0.022s) [73.874831] Subtest lateslice: SUCCESS (0.120s) [74.213553] [010/143] (925s left) gem_softpin (allocator-evict) [74.267142] Starting subtest: allocator-evict [74.268171] Starting dynamic subtest: rcs0 [102.175393] Dynamic subtest rcs0: SUCCESS (27.905s) [102.181047] Starting dynamic subtest: bcs0 [130.103565] Dynamic subtest bcs0: SUCCESS (27.928s) [130.109051] Starting dynamic subtest: vcs0 [157.934400] Dynamic subtest vcs0: SUCCESS (27.831s) [157.940104] Starting dynamic subtest: vcs1 [185.726424] Dynamic subtest vcs1: SUCCESS (27.792s) [185.733036] Starting dynamic subtest: vecs0 [213.687153] Dynamic subtest vecs0: SUCCESS (27.961s) [213.688045] Subtest allocator-evict: SUCCESS (139.417s) [213.814922] [011/143] (785s left) gem_flink_basic (flink-lifetime) [213.900207] Starting subtest: flink-lifetime [213.902099] Subtest flink-lifetime: SUCCESS (0.002s) [213.996715] [012/143] (785s left) kms_ccs (pipe-c-crc-primary-rotation-180-y-tiled-ccs) [216.068587] Starting subtest: pipe-C-crc-primary-rotation-180-y-tiled-ccs [216.070607] Subtest pipe-C-crc-primary-rotation-180-y-tiled-ccs: SKIP (0.000s) [216.212375] [013/143] (783s left) gem_exec_balancer (bonded-false-hang) [216.504812] Starting subtest: bonded-false-hang [216.506480] Subtest bonded-false-hang: SKIP (0.000s) [216.561975] [014/143] (783s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move) [218.517716] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move [218.519750] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SKIP (0.000s) [218.602341] [015/143] (781s left) kms_ccs (pipe-b-bad-rotation-90-y-tiled-ccs) [220.722009] Starting subtest: pipe-B-bad-rotation-90-y-tiled-ccs [220.723851] Subtest pipe-B-bad-rotation-90-y-tiled-ccs: SKIP (0.000s) [220.909796] [016/143] (778s left) gem_exec_reloc (basic-wc-cpu) [220.961688] Subtest basic-wc-cpu: SKIP (0.000s) [221.022710] [017/143] (778s left) kms_psr (psr-sprite-mmap-gtt) [223.006431] Subtest psr-sprite-mmap-gtt: SKIP (0.000s) [223.035358] [018/143] (776s left) prime_vgem (basic-read) [223.243889] Starting subtest: basic-read [223.261344] Subtest basic-read: SKIP (0.018s) [223.358587] [019/143] (776s left) kms_ccs (pipe-c-ccs-on-another-bo-4-tiled-mtl-rc-ccs) [225.475406] Starting subtest: pipe-C-ccs-on-another-bo-4-tiled-mtl-rc-ccs [225.477387] Subtest pipe-C-ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.000s) [225.606803] [020/143] (774s left) gem_basic (create-fd-close) [225.655554] Starting subtest: create-fd-close [225.657521] Subtest create-fd-close: SUCCESS (0.000s) [225.737259] [021/143] (774s left) kms_pm_dc (dc5-dpms) [228.737938] Starting subtest: dc5-dpms [230.274209] Subtest dc5-dpms: SUCCESS (1.533s) [230.528187] [022/143] (769s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc) [232.554386] Starting subtest: pipe-A-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc [232.558763] Subtest pipe-A-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.003s) [232.754339] [023/143] (767s left) gem_exec_flush (basic-batch-kernel-default-uc) [232.811921] Subtest basic-batch-kernel-default-uc: SKIP (0.000s) [232.845948] [024/143] (767s left) gem_fence_thrash (bo-write-verify-x) [232.896371] Starting subtest: bo-write-verify-x [232.899744] Subtest bo-write-verify-x: SKIP (0.002s) [232.929373] [025/143] (766s left) syncobj_timeline (transfer-timeline-point) [232.975623] Starting subtest: transfer-timeline-point [232.976466] Subtest transfer-timeline-point: SUCCESS (0.001s) [233.039042] [026/143] (766s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff) [234.995689] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff [234.997808] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [235.075312] [027/143] (764s left) kms_ccs (pipe-a-bad-rotation-90-4-tiled-mtl-rc-ccs-cc) [237.161111] Starting subtest: pipe-A-bad-rotation-90-4-tiled-mtl-rc-ccs-cc [237.162983] Subtest pipe-A-bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s) [237.389067] [028/143] (762s left) kms_addfb_basic (invalid-smem-bo-on-discrete) [237.453218] Starting subtest: invalid-smem-bo-on-discrete [237.455736] Subtest invalid-smem-bo-on-discrete: SUCCESS (0.000s) [239.420792] [029/143] (760s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff) [241.453674] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff [241.455889] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [241.542028] [030/143] (758s left) gem_workarounds (suspend-resume) [241.701144] Starting subtest: suspend-resume [262.735934] Subtest suspend-resume: SUCCESS (9.012s) [268.852990] [031/143] (749s left) gem_userptr_blits (invalid-null-pointer) [268.911579] Starting subtest: invalid-null-pointer [268.912486] Subtest invalid-null-pointer: SUCCESS (0.001s) [269.047417] [032/143] (749s left) i915_pm_rps (min-max-config-loaded) [269.097010] Starting subtest: min-max-config-loaded [269.098768] Subtest min-max-config-loaded: SKIP (0.001s) [269.157154] [033/143] (748s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4-tiled-dg2-mc-ccs) [271.298093] Starting subtest: pipe-D-crc-sprite-planes-basic-4-tiled-dg2-mc-ccs [271.301872] Subtest pipe-D-crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.003s) [271.390659] [034/143] (746s left) kms_rotation_crc (primary-rotation-180) [273.348978] Starting subtest: primary-rotation-180 [283.969172] Subtest primary-rotation-180: SUCCESS (10.619s) [284.133466] [035/143] (733s left) kms_rotation_crc (exhaust-fences) [286.089539] Starting subtest: exhaust-fences [286.091609] Subtest exhaust-fences: SKIP (0.000s) [286.151877] [036/143] (731s left) gem_lmem_swapping (heavy-verify-random-ccs) [290.054235] Starting subtest: heavy-verify-random-ccs [290.055055] Starting dynamic subtest: lmem0 [290.056741] Dynamic subtest lmem0: SKIP (0.000s) [290.058411] Subtest heavy-verify-random-ccs: SKIP (0.000s) [292.056396] [037/143] (726s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt) [297.323520] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt [297.325354] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [297.414985] [038/143] (720s left) gem_pxp (reject-modify-context-protection-off-2) [300.076282] Subtest reject-modify-context-protection-off-2: SKIP (0.000s) [300.157928] [039/143] (718s left) kms_ccs (pipe-d-ccs-on-another-bo-y-tiled-gen12-rc-ccs) [302.277086] Starting subtest: pipe-D-ccs-on-another-bo-y-tiled-gen12-rc-ccs [302.278115] Subtest pipe-D-ccs-on-another-bo-y-tiled-gen12-rc-ccs: SUCCESS (0.000s) [302.375376] [040/143] (715s left) kms_flip (2x-modeset-vs-vblank-race) [304.329112] Starting subtest: 2x-modeset-vs-vblank-race [304.355026] Subtest 2x-modeset-vs-vblank-race: SKIP (0.025s) [304.428465] [041/143] (713s left) gem_reg_read (timestamp-moving) [304.518760] Starting subtest: timestamp-moving [305.522661] Subtest timestamp-moving: SUCCESS (1.000s) [305.583919] [042/143] (712s left) kms_cursor_crc (cursor-rapid-movement-128x42) [307.679399] Starting subtest: cursor-rapid-movement-128x42 [307.685690] Starting dynamic subtest: pipe-A-HDMI-A-4 [308.181490] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.495s) [308.207486] Starting dynamic subtest: pipe-D-HDMI-A-4 [308.493269] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.292s) [308.494071] Subtest cursor-rapid-movement-128x42: SUCCESS (0.814s) [308.800384] [043/143] (709s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu) [310.753141] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu [310.757631] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [310.841264] [044/143] (707s left) kms_ccs (pipe-b-bad-rotation-90-4-tiled-dg2-rc-ccs) [312.958497] Starting subtest: pipe-B-bad-rotation-90-4-tiled-dg2-rc-ccs [312.960273] Subtest pipe-B-bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.000s) [313.150138] [045/143] (705s left) gem_mmap_gtt (hang-user) [313.204030] Subtest hang-user: SKIP (0.000s) [313.226246] [046/143] (705s left) kms_universal_plane (universal-plane-pageflip-windowed) [315.179056] Starting subtest: universal-plane-pageflip-windowed [315.181520] Starting dynamic subtest: pipe-A-HDMI-A-4 [315.722181] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.541s) [315.731213] Starting dynamic subtest: pipe-B-HDMI-A-4 [316.074202] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.350s) [316.084198] Starting dynamic subtest: pipe-C-HDMI-A-4 [316.459755] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.383s) [316.468472] Starting dynamic subtest: pipe-D-HDMI-A-4 [316.849593] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.388s) [316.850614] Subtest universal-plane-pageflip-windowed: SUCCESS (1.670s) [316.967233] [047/143] (701s left) core_setmaster (master-drop-set-user) [317.848202] Starting subtest: master-drop-set-user [317.872904] Subtest master-drop-set-user: SUCCESS (0.025s) [317.887449] [048/143] (700s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode) [319.876354] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s) [319.928167] [049/143] (698s left) i915_query (query-garbage) [319.975380] Starting subtest: query-garbage [319.976598] Subtest query-garbage: SUCCESS (0.000s) [320.041097] [050/143] (698s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling) [322.013181] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling [322.015733] Starting dynamic subtest: pipe-A-valid-mode [323.086801] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.071s) [323.087815] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SUCCESS (1.073s) [323.204020] [051/143] (695s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [325.162495] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu [325.164454] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [325.242771] [052/143] (693s left) kms_psr (psr2-basic) [327.296510] Subtest psr2-basic: SKIP (0.000s) [327.329017] [053/143] (691s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling) [329.280408] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling [329.281439] Starting dynamic subtest: pipe-A-valid-mode [331.152795] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.870s) [331.153827] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SUCCESS (1.872s) [331.271769] [054/143] (687s left) syncobj_wait (invalid-wait-zero-handles) [331.322122] Starting subtest: invalid-wait-zero-handles [331.323527] Subtest invalid-wait-zero-handles: SUCCESS (0.000s) [331.403307] [055/143] (687s left) syncobj_wait (multi-wait-submitted-signaled) [331.449760] Starting subtest: multi-wait-submitted-signaled [331.450648] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [331.502970] [056/143] (687s left) gem_mmap_gtt (coherency) [331.549778] Subtest coherency: SKIP (0.000s) [331.579266] [057/143] (686s left) kms_content_protection (srm) [333.579466] Starting subtest: srm [333.945042] Subtest srm: SKIP (0.364s) [334.096171] [058/143] (684s left) kms_invalid_mode (bad-hsync-start) [336.052643] Starting subtest: bad-hsync-start [336.053723] Starting dynamic subtest: pipe-A-HDMI-A-4 [336.084273] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.030s) [336.091674] Starting dynamic subtest: pipe-B-HDMI-A-4 [336.092647] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s) [336.099565] Starting dynamic subtest: pipe-C-HDMI-A-4 [336.100547] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s) [336.107836] Starting dynamic subtest: pipe-D-HDMI-A-4 [336.108967] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s) [336.110079] Subtest bad-hsync-start: SUCCESS (0.040s) [336.203957] [059/143] (682s left) gen7_exec_parse (load-register-reg) [336.266489] Subtest load-register-reg: SKIP (0.000s) [336.298392] [060/143] (682s left) kms_ccs (pipe-d-bad-aux-stride-y-tiled-gen12-mc-ccs) [338.442205] Starting subtest: pipe-D-bad-aux-stride-y-tiled-gen12-mc-ccs [338.443875] Subtest pipe-D-bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.000s) [338.535802] [061/143] (680s left) gem_partial_pwrite_pread (reads-display) [338.589203] Subtest reads-display: SKIP (0.000s) [338.648983] [062/143] (679s left) kms_getfb (getfb-handle-closed) [338.711125] Starting subtest: getfb-handle-closed [338.712035] Subtest getfb-handle-closed: SUCCESS (0.000s) [338.822417] [063/143] (679s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted) [338.879284] Starting subtest: etime-single-wait-for-submit-unsubmitted [338.990466] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.107s) [339.077196] [064/143] (679s left) kms_cursor_crc (cursor-random-32x10) [341.102244] Starting subtest: cursor-random-32x10 [341.146285] Subtest cursor-random-32x10: SKIP (0.042s) [341.446538] [065/143] (677s left) i915_pm_freq_mult (media-freq) [341.526639] Starting subtest: media-freq [341.527596] Starting dynamic subtest: gt0 [341.529480] Dynamic subtest gt0: SKIP (0.000s) [341.531624] Subtest media-freq: SKIP (0.001s) [341.586845] [066/143] (677s left) kms_plane_scaling (planes-downscale-factor-0-5) [343.534368] Starting subtest: planes-downscale-factor-0-5 [343.538486] Starting dynamic subtest: pipe-A-HDMI-A-4 [343.690902] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.153s) [343.706459] Starting dynamic subtest: pipe-B-HDMI-A-4 [343.831912] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.135s) [343.844171] Starting dynamic subtest: pipe-C-HDMI-A-4 [343.953690] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.117s) [343.965205] Starting dynamic subtest: pipe-D-HDMI-A-4 [344.075621] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.117s) [344.076500] Subtest planes-downscale-factor-0-5: SUCCESS (0.543s) [344.198329] [067/143] (674s left) prime_self_import (basic-with_one_bo_two_files) [344.245576] Starting subtest: basic-with_one_bo_two_files [344.248850] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [344.372065] [068/143] (674s left) kms_psr (fbc-pr-primary-render) [346.351984] Subtest fbc-pr-primary-render: SKIP (0.000s) [346.374620] [069/143] (672s left) gem_fence_thrash (bo-write-verify-threaded-y) [346.417259] Starting subtest: bo-write-verify-threaded-y [346.420488] Subtest bo-write-verify-threaded-y: SKIP (0.002s) [346.441303] [070/143] (672s left) kms_psr (fbc-psr-primary-mmap-gtt) [348.406471] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s) [348.441202] [071/143] (670s left) perf (gen12-group-exclusive-stream-sample-oa) [348.587474] Starting subtest: gen12-group-exclusive-stream-sample-oa [348.612793] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.025s) [348.646936] [072/143] (670s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [350.637990] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [350.692109] [073/143] (668s left) gem_userptr_blits (unsync-unmap-cycles) [350.744372] Subtest unsync-unmap-cycles: SKIP (0.000s) [350.890622] [074/143] (668s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite) [352.875421] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite [355.280625] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (2.405s) [355.405182] [075/143] (663s left) kms_plane_alpha_blend (constant-alpha-max) [357.357604] Starting subtest: constant-alpha-max [357.580944] Starting dynamic subtest: pipe-A-HDMI-A-4 [358.434181] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.852s) [358.442774] Starting dynamic subtest: pipe-D-HDMI-A-4 [359.312260] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.876s) [359.313201] Subtest constant-alpha-max: SUCCESS (1.954s) [359.437440] [076/143] (659s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu) [361.394652] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu [361.396626] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [361.476597] [077/143] (657s left) perf (unprivileged-single-ctx-counters) [361.658052] Starting subtest: unprivileged-single-ctx-counters [361.660005] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [361.685710] [078/143] (657s left) gem_exec_balancer (nohangcheck) [361.973029] Starting subtest: nohangcheck [363.162896] Subtest nohangcheck: SUCCESS (1.188s) [363.302281] [079/143] (655s left) gem_eio (in-flight-contexts-immediate) [363.484352] Starting subtest: in-flight-contexts-immediate [377.275321] Subtest in-flight-contexts-immediate: SUCCESS (13.791s) [379.252823] [080/143] (639s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs) [379.336395] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs [379.337594] Starting dynamic subtest: smem [379.449888] Dynamic subtest smem: SUCCESS (0.113s) [379.458075] Starting dynamic subtest: lmem0 [380.556133] Dynamic subtest lmem0: SUCCESS (1.103s) [380.557013] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SUCCESS (1.217s) [380.785568] [081/143] (638s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [382.752757] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu [382.754911] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [382.843110] [082/143] (636s left) kms_hdmi_inject (inject-audio) [383.022542] Starting subtest: inject-audio [383.119325] Subtest inject-audio: SUCCESS (0.094s) [384.222364] [083/143] (634s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [386.279828] Starting subtest: psr-2p-primscrn-cur-indfb-move [386.283602] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [386.438644] [084/143] (632s left) kms_ccs (pipe-c-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc) [388.548320] Starting subtest: pipe-C-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc [388.550301] Subtest pipe-C-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s) [388.688893] [085/143] (630s left) kms_flip (2x-plain-flip-ts-check) [390.640888] Starting subtest: 2x-plain-flip-ts-check [390.666209] Subtest 2x-plain-flip-ts-check: SKIP (0.025s) [390.740856] [086/143] (628s left) gem_exec_basic (basic) [390.840386] Starting subtest: basic [390.841591] Starting dynamic subtest: rcs0-smem [390.844423] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [390.853429] Starting dynamic subtest: bcs0-smem [390.854514] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [390.863028] Starting dynamic subtest: vcs0-smem [390.864532] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [390.872887] Starting dynamic subtest: vcs1-smem [390.873932] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [390.882193] Starting dynamic subtest: vecs0-smem [390.883700] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [390.891779] Starting dynamic subtest: rcs0-lmem0 [390.893293] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s) [390.901443] Starting dynamic subtest: bcs0-lmem0 [390.902859] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s) [390.910983] Starting dynamic subtest: vcs0-lmem0 [390.912484] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s) [390.920520] Starting dynamic subtest: vcs1-lmem0 [390.921937] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s) [390.929807] Starting dynamic subtest: vecs0-lmem0 [390.931829] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s) [390.933909] Subtest basic: SUCCESS (0.016s) [391.073693] [087/143] (628s left) kms_big_fb (yf-tiled-64bpp-rotate-0) [393.068450] Starting subtest: yf-tiled-64bpp-rotate-0 [393.071124] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s) [393.142480] [088/143] (626s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5) [395.184598] Starting subtest: planes-unity-scaling-downscale-factor-0-5 [395.188943] Starting dynamic subtest: pipe-A-HDMI-A-4 [395.341476] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.153s) [395.362731] Starting dynamic subtest: pipe-B-HDMI-A-4 [395.501062] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.153s) [395.513596] Starting dynamic subtest: pipe-C-HDMI-A-4 [395.623045] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.117s) [395.636820] Starting dynamic subtest: pipe-D-HDMI-A-4 [395.745057] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.117s) [395.745932] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.563s) [395.868292] [089/143] (623s left) kms_big_fb (x-tiled-32bpp-rotate-180) [397.834114] Starting subtest: x-tiled-32bpp-rotate-180 [399.804526] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.967s) [399.927828] [090/143] (619s left) drm_fdinfo (memory-info-resident) [399.976240] Starting subtest: memory-info-resident [399.977147] Starting dynamic subtest: lmem0 [400.007962] Dynamic subtest lmem0: SKIP (0.030s) [400.016347] Starting dynamic subtest: smem0 [400.023743] Dynamic subtest smem0: SKIP (0.015s) [400.025405] Subtest memory-info-resident: SKIP (0.047s) [400.085251] [091/143] (619s left) kms_ccs (pipe-a-bad-aux-stride-y-tiled-gen12-rc-ccs-cc) [402.114348] Starting subtest: pipe-A-bad-aux-stride-y-tiled-gen12-rc-ccs-cc [402.115395] Subtest pipe-A-bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.001s) [402.319233] [092/143] (617s left) kms_fbcon_fbt (psr) [402.371901] Starting subtest: psr [402.373755] Subtest psr: SKIP (0.000s) [402.493704] [093/143] (616s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip) [404.465274] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip [405.555703] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.086s) [405.682236] [094/143] (613s left) i915_pm_freq_api (freq-basic-api) [405.733973] Starting subtest: freq-basic-api [405.734942] Starting dynamic subtest: gt0 [405.738686] Dynamic subtest gt0: SUCCESS (0.004s) [405.739673] Subtest freq-basic-api: SUCCESS (0.005s) [405.825535] [095/143] (613s left) prime_vgem (coherency-gtt) [405.900816] Starting subtest: coherency-gtt [405.902614] Subtest coherency-gtt: SKIP (0.000s) [406.008467] [096/143] (613s left) kms_ccs (pipe-b-crc-primary-rotation-180-4-tiled-mtl-rc-ccs) [408.051843] Starting subtest: pipe-B-crc-primary-rotation-180-4-tiled-mtl-rc-ccs [408.054134] Subtest pipe-B-crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.000s) [408.272244] [097/143] (611s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move) [410.259448] Starting subtest: fbc-1p-primscrn-spr-indfb-move [413.519862] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (3.259s) [413.683801] [098/143] (605s left) gem_exec_schedule (preempt-hang) [413.857013] Starting subtest: preempt-hang [413.858063] Starting dynamic subtest: rcs0 [414.157054] Dynamic subtest rcs0: SUCCESS (0.301s) [414.165479] Starting dynamic subtest: bcs0 [414.441994] Dynamic subtest bcs0: SUCCESS (0.284s) [414.451235] Starting dynamic subtest: vcs0 [414.728372] Dynamic subtest vcs0: SUCCESS (0.285s) [414.736472] Starting dynamic subtest: vcs1 [415.047765] Dynamic subtest vcs1: SUCCESS (0.318s) [415.055793] Starting dynamic subtest: vecs0 [415.360976] Dynamic subtest vecs0: SUCCESS (0.312s) [415.361793] Subtest preempt-hang: SUCCESS (1.506s) [415.646975] [099/143] (603s left) gem_lmem_swapping (heavy-random) [420.078652] Starting subtest: heavy-random [420.079689] Starting dynamic subtest: lmem0 [425.015526] Dynamic subtest lmem0: SUCCESS (4.933s) [425.016545] Subtest heavy-random: SUCCESS (4.934s) [426.616290] [100/143] (592s left) gem_ctx_persistence (file) [429.933943] Starting subtest: file [430.034517] Subtest file: SUCCESS (0.100s) [430.141742] [101/143] (589s left) kms_plane_lowres (tiling-none) [432.152918] Starting subtest: tiling-none [432.156218] Starting dynamic subtest: pipe-A-HDMI-A-4 [440.986380] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (8.827s) [441.077035] Starting dynamic subtest: pipe-B-HDMI-A-4 [449.768619] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (8.698s) [449.819139] Starting dynamic subtest: pipe-C-HDMI-A-4 [458.423459] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (8.607s) [458.513237] Starting dynamic subtest: pipe-D-HDMI-A-4 [467.077123] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (8.569s) [467.134121] Subtest tiling-none: SUCCESS (34.980s) [467.270983] [102/143] (552s left) kms_prop_blob (invalid-set-prop) [467.321609] Starting subtest: invalid-set-prop [467.322649] Subtest invalid-set-prop: SUCCESS (0.000s) [467.396554] [103/143] (552s left) syncobj_timeline (signal-array) [467.470193] Starting subtest: signal-array [467.471077] Subtest signal-array: SUCCESS (0.000s) [467.539392] [104/143] (552s left) gem_ctx_shared (q-independent) [467.607751] Starting subtest: Q-independent [467.608740] Starting dynamic subtest: rcs0 [467.748905] Dynamic subtest rcs0: SUCCESS (0.137s) [467.756728] Starting dynamic subtest: bcs0 [467.831665] Dynamic subtest bcs0: SUCCESS (0.085s) [467.840884] Starting dynamic subtest: vcs0 [467.917433] Dynamic subtest vcs0: SUCCESS (0.084s) [467.926443] Starting dynamic subtest: vcs1 [468.015645] Dynamic subtest vcs1: SUCCESS (0.097s) [468.024619] Starting dynamic subtest: vecs0 [468.114492] Dynamic subtest vecs0: SUCCESS (0.098s) [468.115457] Subtest Q-independent: SUCCESS (0.507s) [468.362086] [105/143] (551s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-cpu) [470.315886] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-cpu [470.318087] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [470.415086] [106/143] (549s left) kms_invalid_mode (zero-hdisplay) [472.458031] Starting subtest: zero-hdisplay [472.459084] Starting dynamic subtest: pipe-A-HDMI-A-4 [472.490442] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.032s) [472.499732] Starting dynamic subtest: pipe-B-HDMI-A-4 [472.500736] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s) [472.508300] Starting dynamic subtest: pipe-C-HDMI-A-4 [472.509336] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s) [472.516595] Starting dynamic subtest: pipe-D-HDMI-A-4 [472.517547] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s) [472.518628] Subtest zero-hdisplay: SUCCESS (0.044s) [472.598150] [107/143] (547s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt) [474.565721] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt [474.568113] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [474.657746] [108/143] (545s left) kms_addfb_basic (small-bo) [476.701725] Starting subtest: small-bo [476.702709] Subtest small-bo: SUCCESS (0.000s) [476.787029] [109/143] (543s left) prime_busy (after) [476.922000] Starting subtest: after [476.928047] Starting dynamic subtest: rcs0 [476.959497] Dynamic subtest rcs0: SUCCESS (0.031s) [476.968955] Starting dynamic subtest: bcs0 [477.007556] Dynamic subtest bcs0: SUCCESS (0.047s) [477.021281] Starting dynamic subtest: vcs0 [477.051813] Dynamic subtest vcs0: SUCCESS (0.042s) [477.082204] Starting dynamic subtest: vcs1 [477.092583] Dynamic subtest vcs1: SUCCESS (0.037s) [477.110843] Starting dynamic subtest: vecs0 [477.133921] Dynamic subtest vecs0: SUCCESS (0.039s) [477.265184] Subtest after: SUCCESS (0.339s) [477.406949] [110/143] (542s left) api_intel_bb (crc32) [477.484305] Starting subtest: crc32 [477.486060] Subtest crc32: SKIP (0.000s) [477.575080] [111/143] (542s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render) [479.557329] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render [479.559676] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [479.636575] [112/143] (540s left) kms_flip (2x-plain-flip-fb-recreate-interruptible) [481.673770] Starting subtest: 2x-plain-flip-fb-recreate-interruptible [481.699879] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.025s) [481.767296] [113/143] (538s left) v3d/v3d_submit_csd (single-out-sync) [481.898427] Subtest single-out-sync: SKIP (0.000s) [481.962550] [114/143] (538s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle) [483.942303] Starting subtest: short-busy-flip-before-cursor-toggle [483.944370] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s) [483.999700] [115/143] (536s left) kms_ccs (pipe-d-random-ccs-data-y-tiled-gen12-mc-ccs) [486.157674] Starting subtest: pipe-D-random-ccs-data-y-tiled-gen12-mc-ccs [486.160549] Subtest pipe-D-random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.000s) [486.264688] [116/143] (533s left) gem_exec_flush (basic-wb-ro-before-default) [486.316250] Subtest basic-wb-ro-before-default: SKIP (0.000s) [486.358121] [117/143] (533s left) gem_exec_params (invalid-fence-in-submit) [486.409533] Starting subtest: invalid-fence-in-submit [486.411770] Subtest invalid-fence-in-submit: SUCCESS (0.002s) [486.548278] [118/143] (533s left) kms_ccs (pipe-b-random-ccs-data-4-tiled-mtl-rc-ccs-cc) [488.602148] Starting subtest: pipe-B-random-ccs-data-4-tiled-mtl-rc-ccs-cc [488.605586] Subtest pipe-B-random-ccs-data-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s) [488.780865] [119/143] (531s left) dmabuf (all-tests) [488.830632] Starting subtest: all-tests [488.902242] Starting dynamic subtest: sanitycheck [489.054328] Dynamic subtest sanitycheck: SUCCESS (0.222s) [489.096933] Starting dynamic subtest: dma_fence [489.247159] Dynamic subtest dma_fence: SUCCESS (0.188s) [489.263093] Starting dynamic subtest: dma_fence_chain [502.333046] Dynamic subtest dma_fence_chain: SUCCESS (13.081s) [502.341389] Starting dynamic subtest: dma_fence_unwrap [502.402340] Dynamic subtest dma_fence_unwrap: SUCCESS (0.070s) [502.430804] Starting dynamic subtest: dma_resv [502.490323] Dynamic subtest dma_resv: SUCCESS (0.083s) [502.491572] Subtest all-tests: SUCCESS (13.661s) [502.580766] [120/143] (517s left) vc4/vc4_create_bo (create-bo-zeroed) [502.663010] Subtest create-bo-zeroed: SKIP (0.000s) [502.712166] [121/143] (517s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size) [504.661936] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size [515.620226] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (10.958s) [515.751594] [122/143] (504s left) kms_psr (psr-primary-page-flip) [517.708091] Subtest psr-primary-page-flip: SKIP (0.000s) [517.742675] [123/143] (502s left) kms_big_fb (y-tiled-64bpp-rotate-0) [519.711880] Starting subtest: y-tiled-64bpp-rotate-0 [521.867493] Subtest y-tiled-64bpp-rotate-0: SUCCESS (2.153s) [521.991646] [124/143] (498s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes) [522.037852] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s) [522.057999] [125/143] (498s left) sysfs_preempt_timeout (idempotent) [522.110197] Starting subtest: idempotent [522.112666] Starting dynamic subtest: vecs0 [522.113626] Dynamic subtest vecs0: SUCCESS (0.001s) [522.121533] Starting dynamic subtest: vcs0 [522.122447] Dynamic subtest vcs0: SUCCESS (0.000s) [522.130069] Starting dynamic subtest: bcs0 [522.131182] Dynamic subtest bcs0: SUCCESS (0.000s) [522.138699] Starting dynamic subtest: rcs0 [522.139738] Dynamic subtest rcs0: SUCCESS (0.001s) [522.147296] Starting dynamic subtest: vcs1 [522.148406] Dynamic subtest vcs1: SUCCESS (0.001s) [522.149654] Subtest idempotent: SUCCESS (0.009s) [522.202847] [126/143] (498s left) kms_psr2_sf (fbc-overlay-plane-move-continuous-exceed-fully-sf) [522.259052] Subtest fbc-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [522.296182] [127/143] (497s left) kms_draw_crc (draw-method-mmap-cpu) [524.254545] Starting subtest: draw-method-mmap-cpu [524.255522] Starting dynamic subtest: xrgb8888-untiled [524.616073] Dynamic subtest xrgb8888-untiled: SUCCESS (0.360s) [524.655705] Starting dynamic subtest: rgb565-untiled [524.949224] Dynamic subtest rgb565-untiled: SUCCESS (0.327s) [524.986763] Starting dynamic subtest: xrgb2101010-untiled [525.248768] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.293s) [525.281228] Starting dynamic subtest: xrgb8888-xtiled [525.432223] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.177s) [525.464752] Starting dynamic subtest: rgb565-xtiled [525.616053] Dynamic subtest rgb565-xtiled: SUCCESS (0.177s) [525.652095] Starting dynamic subtest: xrgb2101010-xtiled [525.797269] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.176s) [525.808077] Starting dynamic subtest: xrgb8888-ytiled [525.964263] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.165s) [525.979222] Starting dynamic subtest: rgb565-ytiled [526.132587] Dynamic subtest rgb565-ytiled: SUCCESS (0.165s) [526.170997] Starting dynamic subtest: xrgb2101010-ytiled [526.314009] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.176s) [526.315037] Subtest draw-method-mmap-cpu: SUCCESS (2.061s) [526.422537] [128/143] (493s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw) [528.411179] Starting subtest: fbcpsr-1p-pri-indfb-multidraw [528.413118] Subtest fbcpsr-1p-pri-indfb-multidraw: SKIP (0.000s) [528.486584] [129/143] (491s left) kms_big_fb (x-tiled-addfb-size-overflow) [530.509836] Starting subtest: x-tiled-addfb-size-overflow [530.510997] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.001s) [530.608986] [130/143] (489s left) gem_create (create-ext-placement-each) [530.882615] Starting subtest: create-ext-placement-each [530.885125] Subtest create-ext-placement-each: SUCCESS (0.001s) [530.998924] [131/143] (489s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary) [532.981900] Starting subtest: fbc-shrfb-scaledprimary [536.547766] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.565s) [536.684953] [132/143] (483s left) gem_pxp (create-regular-context-1) [539.254522] Subtest create-regular-context-1: SKIP (0.000s) [539.325599] [133/143] (481s left) gem_busy (parallel) [539.570151] Starting subtest: parallel [539.571138] Starting dynamic subtest: rcs0 [539.661474] Dynamic subtest rcs0: SUCCESS (0.090s) [539.673670] Starting dynamic subtest: bcs0 [539.716312] Dynamic subtest bcs0: SUCCESS (0.053s) [539.730281] Starting dynamic subtest: vcs0 [539.773282] Dynamic subtest vcs0: SUCCESS (0.055s) [539.805260] Starting dynamic subtest: vcs1 [539.850639] Dynamic subtest vcs1: SUCCESS (0.074s) [539.871590] Starting dynamic subtest: vecs0 [539.918960] Dynamic subtest vecs0: SUCCESS (0.066s) [539.920409] Subtest parallel: SUCCESS (0.350s) [540.135519] [134/143] (480s left) gem_exec_fence (syncobj-invalid-wait) [540.482625] Starting subtest: syncobj-invalid-wait [540.485059] Subtest syncobj-invalid-wait: SUCCESS (0.001s) [540.834562] [135/143] (479s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0) [542.797714] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0 [542.799822] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [542.888766] [136/143] (477s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled) [543.029462] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled [543.134888] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.101s) [543.228117] [137/143] (477s left) gem_madvise (dontneed-before-exec) [543.304205] Starting subtest: dontneed-before-exec [543.306917] Subtest dontneed-before-exec: SKIP (0.002s) [543.339296] [138/143] (477s left) kms_big_fb (4-tiled-8bpp-rotate-0) [545.296875] Starting subtest: 4-tiled-8bpp-rotate-0 [545.299081] Subtest 4-tiled-8bpp-rotate-0: SKIP (0.000s) [545.387094] [139/143] (475s left) syncobj_timeline (invalid-wait-zero-handles) [545.522891] Starting subtest: invalid-wait-zero-handles [545.523895] Subtest invalid-wait-zero-handles: SUCCESS (0.000s) [545.579928] [140/143] (475s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc) [547.544776] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc [547.546686] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [547.618024] [141/143] (473s left) v3d/v3d_submit_cl (bad-multisync-in-sync) [547.762243] Subtest bad-multisync-in-sync: SKIP (0.000s) [547.811664] [142/143] (472s left) gem_exec_flush (basic-batch-kernel-default-cmd) [547.863117] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s) [547.904937] [143/143] (472s left) syncobj_eventfd (invalid-illegal-handle) [547.953200] Starting subtest: invalid-illegal-handle [547.954103] Subtest invalid-illegal-handle: SUCCESS (0.000s) [548.019807] Closing watchdogs Done.