[38.209682] Initializing watchdogs
[38.209726]   /dev/watchdog0
[38.216676] [001/131] (960s left) syncobj_basic (bad-flags-fd-to-handle)
[38.276698] Starting subtest: bad-flags-fd-to-handle
[38.277490] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[38.385380] [002/131] (960s left) gem_workarounds (reset)
[38.482370] Starting subtest: reset
[38.673075] Subtest reset: SUCCESS (0.191s)
[38.768939] [003/131] (959s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[38.966971] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[40.205943] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.238s)
[40.346737] [004/131] (958s left) debugfs_test (read_all_entries_display_off)
[40.539468] Starting subtest: read_all_entries_display_off
[41.313947] Subtest read_all_entries_display_off: SUCCESS (0.774s)
[41.478945] [005/131] (957s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[41.673844] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[41.675386] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[41.744212] [006/131] (957s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[41.945511] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[41.969901] [007/131] (956s left) kms_psr (fbc-psr2-suspend)
[42.149955] Subtest fbc-psr2-suspend: SKIP (0.000s)
[42.169309] [008/131] (956s left) i915_query (query-topology-kernel-writes)
[42.214805] Starting subtest: query-topology-kernel-writes
[42.215565] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[42.318170] [009/131] (956s left) kms_getfb (getfb2-handle-closed)
[42.410020] Starting subtest: getfb2-handle-closed
[42.411059] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[42.480107] [010/131] (956s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[42.558212] Starting subtest: multi-wait-all-for-submit-signaled
[42.559169] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[42.641692] [011/131] (956s left) kms_atomic (plane-invalid-params-fence)
[42.819525] Starting subtest: plane-invalid-params-fence
[42.821415] Starting dynamic subtest: pipe-A-DP-4
[43.375558] Dynamic subtest pipe-A-DP-4: SUCCESS (0.554s)
[43.376577] Subtest plane-invalid-params-fence: SUCCESS (0.555s)
[43.619826] [012/131] (955s left) i915_pm_rc6_residency (rc6-idle)
[43.692088] Starting subtest: rc6-idle
[43.712609] Starting dynamic subtest: gt0-rcs0
[55.930826] Dynamic subtest gt0-rcs0: SUCCESS (12.210s)
[55.936947] Starting dynamic subtest: gt0-bcs0
[68.177614] Dynamic subtest gt0-bcs0: SUCCESS (12.243s)
[68.183643] Starting dynamic subtest: gt0-vcs0
[80.419108] Dynamic subtest gt0-vcs0: SUCCESS (12.239s)
[80.426830] Starting dynamic subtest: gt0-vecs0
[92.663180] Dynamic subtest gt0-vecs0: SUCCESS (12.243s)
[92.669628] Starting dynamic subtest: gt0-ccs0
[104.907496] Dynamic subtest gt0-ccs0: SUCCESS (12.244s)
[104.908332] Subtest rc6-idle: SUCCESS (61.201s)
[105.013607] [013/131] (893s left) kms_legacy_colorkey (invalid-plane)
[105.193879] Starting subtest: invalid-plane
[105.194719] Starting dynamic subtest: zero-id
[105.195562] Dynamic subtest zero-id: SUCCESS (0.000s)
[105.201202] Starting dynamic subtest: outrange-id
[105.201960] Dynamic subtest outrange-id: SUCCESS (0.000s)
[105.202733] Subtest invalid-plane: SUCCESS (0.000s)
[105.242214] [014/131] (893s left) i915_hangman (hangcheck-unterminated)
[105.309420] Starting subtest: hangcheck-unterminated
[115.497196] Subtest hangcheck-unterminated: SUCCESS (10.187s)
[115.634612] [015/131] (883s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[115.855980] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[115.856860] Starting dynamic subtest: pipe-A-valid-mode
[118.286513] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.428s)
[118.288349] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (2.429s)
[118.517399] [016/131] (880s left) kms_psr (psr-primary-blt)
[118.729930] Subtest psr-primary-blt: SKIP (0.000s)
[118.746525] [017/131] (880s left) kms_flip (modeset-vs-vblank-race-interruptible)
[118.922922] Starting subtest: modeset-vs-vblank-race-interruptible
[118.929049] Starting dynamic subtest: A-DP4
[122.154094] Dynamic subtest A-DP4: SUCCESS (3.224s)
[122.182966] Starting dynamic subtest: B-DP4
[125.450542] Dynamic subtest B-DP4: SUCCESS (3.295s)
[125.479779] Starting dynamic subtest: C-DP4
[128.541921] Dynamic subtest C-DP4: SUCCESS (3.088s)
[128.570236] Starting dynamic subtest: D-DP4
[131.622084] Dynamic subtest D-DP4: SUCCESS (3.079s)
[131.626221] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (12.702s)
[131.954837] [018/131] (867s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[132.145976] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[132.146723] Starting dynamic subtest: pipe-A
[132.249735] Dynamic subtest pipe-A: SUCCESS (0.104s)
[132.261379] Starting dynamic subtest: pipe-B
[132.476927] Dynamic subtest pipe-B: SUCCESS (0.227s)
[132.490348] Starting dynamic subtest: pipe-C
[132.702487] Dynamic subtest pipe-C: SUCCESS (0.225s)
[132.715987] Starting dynamic subtest: pipe-D
[132.928542] Dynamic subtest pipe-D: SUCCESS (0.225s)
[132.929589] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.783s)
[133.206850] [019/131] (865s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[133.431349] Starting subtest: fbcpsr-modesetfrombusy
[133.433010] Subtest fbcpsr-modesetfrombusy: SKIP (0.000s)
[133.515804] [020/131] (865s left) drm_fdinfo (virtual-idle)
[133.582552] Starting subtest: virtual-idle
[137.173022] Subtest virtual-idle: SUCCESS (3.588s)
[137.231322] [021/131] (861s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[137.409256] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[137.410980] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[137.476863] [022/131] (861s left) fbdev (unaligned-write)
[137.545822] Starting subtest: unaligned-write
[137.924877] Subtest unaligned-write: SUCCESS (0.379s)
[137.973686] [023/131] (861s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[138.156527] Starting subtest: read-crc-frame-sequence
[138.157386] Starting dynamic subtest: pipe-A-DP-4
[138.760788] Dynamic subtest pipe-A-DP-4: SUCCESS (0.603s)
[138.776391] Starting dynamic subtest: pipe-B-DP-4
[139.371774] Dynamic subtest pipe-B-DP-4: SUCCESS (0.608s)
[139.386380] Starting dynamic subtest: pipe-C-DP-4
[139.936588] Dynamic subtest pipe-C-DP-4: SUCCESS (0.560s)
[139.951328] Starting dynamic subtest: pipe-D-DP-4
[140.498394] Dynamic subtest pipe-D-DP-4: SUCCESS (0.560s)
[140.499540] Subtest read-crc-frame-sequence: SUCCESS (2.342s)
[140.741842] [024/131] (858s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[140.973031] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[141.000463] [025/131] (858s left) kms_big_fb (linear-8bpp-rotate-90)
[141.185649] Starting subtest: linear-8bpp-rotate-90
[141.244486] Subtest linear-8bpp-rotate-90: SKIP (0.058s)
[141.396239] [026/131] (857s left) kms_vblank (query-forked-busy-hang)
[141.594956] Starting subtest: query-forked-busy-hang
[141.595862] Starting dynamic subtest: pipe-A-DP-4
[167.951078] Dynamic subtest pipe-A-DP-4: SUCCESS (26.356s)
[167.959983] Starting dynamic subtest: pipe-D-DP-4
[192.951144] Dynamic subtest pipe-D-DP-4: SUCCESS (24.996s)
[192.952064] Subtest query-forked-busy-hang: SUCCESS (51.356s)
[193.136160] [027/131] (806s left) gen9_exec_parse (basic-rejected)
[193.220185] Subtest basic-rejected: SKIP (0.000s)
[193.265232] [028/131] (806s left) syncobj_eventfd (timeline-wait)
[193.323208] Starting subtest: timeline-wait
[193.333773] Subtest timeline-wait: SUCCESS (0.011s)
[193.445190] [029/131] (805s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[193.534297] Starting subtest: invalid-bsd1-flag-on-blt
[193.535241] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[193.611530] [030/131] (805s left) perf_pmu (busy-accuracy-2)
[193.658611] Starting subtest: busy-accuracy-2
[193.659420] Starting dynamic subtest: rcs0
[196.712860] Dynamic subtest rcs0: SUCCESS (3.053s)
[196.719406] Starting dynamic subtest: bcs0
[199.771604] Dynamic subtest bcs0: SUCCESS (3.058s)
[199.778237] Starting dynamic subtest: vcs0
[202.828771] Dynamic subtest vcs0: SUCCESS (3.057s)
[202.835367] Starting dynamic subtest: vcs1
[205.886503] Dynamic subtest vcs1: SUCCESS (3.058s)
[205.893249] Starting dynamic subtest: vecs0
[208.945742] Dynamic subtest vecs0: SUCCESS (3.059s)
[208.952488] Starting dynamic subtest: vecs1
[212.002746] Dynamic subtest vecs1: SUCCESS (3.056s)
[212.009402] Starting dynamic subtest: ccs0
[215.059776] Dynamic subtest ccs0: SUCCESS (3.057s)
[215.060658] Subtest busy-accuracy-2: SUCCESS (21.400s)
[215.157339] [031/131] (784s left) syncobj_timeline (invalid-signal-illegal-handle)
[215.207910] Starting subtest: invalid-signal-illegal-handle
[215.208701] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[215.294409] [032/131] (784s left) kms_addfb_basic (bad-pitch-0)
[215.354159] Starting subtest: bad-pitch-0
[215.355123] Subtest bad-pitch-0: SUCCESS (0.000s)
[215.556314] [033/131] (783s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[215.751926] Starting subtest: flip-vs-cursor-atomic
[224.399624] Subtest flip-vs-cursor-atomic: SUCCESS (8.648s)
[224.628178] [034/131] (774s left) gem_exec_schedule (preempt-other)
[224.733255] Starting subtest: preempt-other
[224.734064] Starting dynamic subtest: rcs0
[225.090608] Dynamic subtest rcs0: SUCCESS (0.357s)
[225.097346] Starting dynamic subtest: bcs0
[225.424866] Dynamic subtest bcs0: SUCCESS (0.334s)
[225.431134] Starting dynamic subtest: vcs0
[225.759338] Dynamic subtest vcs0: SUCCESS (0.334s)
[225.765891] Starting dynamic subtest: vcs1
[226.091708] Dynamic subtest vcs1: SUCCESS (0.332s)
[226.098323] Starting dynamic subtest: vecs0
[226.445678] Dynamic subtest vecs0: SUCCESS (0.354s)
[226.452023] Starting dynamic subtest: vecs1
[226.776860] Dynamic subtest vecs1: SUCCESS (0.331s)
[226.783425] Starting dynamic subtest: ccs0
[227.109265] Dynamic subtest ccs0: SUCCESS (0.332s)
[227.110072] Subtest preempt-other: SUCCESS (2.376s)
[227.444888] [035/131] (772s left) gem_exec_fair (basic-pace)
[227.512589] Subtest basic-pace: SKIP (0.000s)
[227.545066] [036/131] (771s left) gem_ctx_persistence (engines-hang)
[227.619394] Starting subtest: engines-hang
[227.620338] Starting dynamic subtest: rcs0
[227.698207] Dynamic subtest rcs0: SUCCESS (0.079s)
[227.705313] Starting dynamic subtest: bcs0
[227.768226] Dynamic subtest bcs0: SUCCESS (0.069s)
[227.788584] Starting dynamic subtest: vcs0
[227.858419] Dynamic subtest vcs0: SUCCESS (0.089s)
[227.871787] Starting dynamic subtest: vcs1
[227.946947] Dynamic subtest vcs1: SUCCESS (0.087s)
[227.971891] Starting dynamic subtest: vecs0
[227.996938] Dynamic subtest vecs0: SUCCESS (0.049s)
[228.020361] Starting dynamic subtest: vecs1
[228.118242] Dynamic subtest vecs1: SUCCESS (0.120s)
[228.146234] Starting dynamic subtest: ccs0
[228.153177] Dynamic subtest ccs0: SUCCESS (0.033s)
[228.155057] Subtest engines-hang: SUCCESS (0.534s)
[228.300961] [037/131] (771s left) gem_pread (self)
[228.374491] Subtest self: SKIP (0.000s)
[228.411717] [038/131] (771s left) gem_userptr_blits (input-checking)
[228.467075] Starting subtest: input-checking
[228.467856] Subtest input-checking: SUCCESS (0.000s)
[228.602260] [039/131] (771s left) gem_exec_balancer (parallel-ordering)
[228.906803] Starting subtest: parallel-ordering
[229.861764] Subtest parallel-ordering: SUCCESS (0.955s)
[229.998732] [040/131] (769s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[230.055493] Starting subtest: invalid-bsd1-flag-on-vebox
[230.056472] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[230.148094] [041/131] (769s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[230.333434] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[230.335186] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[230.399039] [042/131] (769s left) prime_vgem (fence-read-hang)
[230.514104] Subtest fence-read-hang: SKIP (0.000s)
[230.622666] [043/131] (769s left) kms_async_flips (test-cursor)
[230.838814] Starting subtest: test-cursor
[231.054290] Starting dynamic subtest: pipe-A-DP-4
[231.299830] Dynamic subtest pipe-A-DP-4: SUCCESS (0.245s)
[231.526271] Starting dynamic subtest: pipe-B-DP-4
[231.646012] Dynamic subtest pipe-B-DP-4: SUCCESS (0.127s)
[231.843247] Starting dynamic subtest: pipe-C-DP-4
[231.982354] Dynamic subtest pipe-C-DP-4: SUCCESS (0.147s)
[232.178382] Starting dynamic subtest: pipe-D-DP-4
[232.297772] Dynamic subtest pipe-D-DP-4: SUCCESS (0.127s)
[232.298691] Subtest test-cursor: SUCCESS (1.459s)
[232.746445] [044/131] (767s left) kms_cursor_crc (cursor-sliding-max-size)
[233.165544] Starting subtest: cursor-sliding-max-size
[233.168576] Subtest cursor-sliding-max-size: SKIP (0.000s)
[233.346899] [045/131] (766s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[233.543845] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[233.550186] Starting dynamic subtest: A-DP4
[241.643129] Dynamic subtest A-DP4: SUCCESS (8.093s)
[241.651363] Starting dynamic subtest: B-DP4
[249.672847] Dynamic subtest B-DP4: SUCCESS (8.028s)
[249.680324] Starting dynamic subtest: C-DP4
[257.697292] Dynamic subtest C-DP4: SUCCESS (8.023s)
[257.706997] Starting dynamic subtest: D-DP4
[265.720203] Dynamic subtest D-DP4: SUCCESS (8.020s)
[265.721102] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (32.176s)
[266.007042] [046/131] (733s left) gem_exec_await (wide-all)
[266.199986] Starting subtest: wide-all
[290.286173] Subtest wide-all: SUCCESS (24.085s)
[290.473056] [047/131] (709s left) kms_psr (pr-primary-blt)
[290.682682] Subtest pr-primary-blt: SKIP (0.000s)
[290.708619] [048/131] (709s left) gem_exec_params (no-bsd)
[290.760187] Starting subtest: no-bsd
[290.762119] Subtest no-bsd: SUCCESS (0.001s)
[290.888078] [049/131] (709s left) kms_chamelium_frames (hdmi-crc-multiple)
[291.178467] Subtest hdmi-crc-multiple: SKIP (0.000s)
[291.299365] [050/131] (708s left) kms_feature_discovery (display-1x)
[291.486794] Starting subtest: display-1x
[291.487753] Subtest display-1x: SUCCESS (0.000s)
[291.551494] [051/131] (708s left) prime_self_import (basic-llseek-bad)
[291.605580] Starting subtest: basic-llseek-bad
[291.625437] Subtest basic-llseek-bad: SUCCESS (0.020s)
[291.740565] [052/131] (708s left) perf (rc6-disable)
[292.140213] Starting subtest: rc6-disable
[292.321875] Subtest rc6-disable: SUCCESS (0.181s)
[292.382992] [053/131] (707s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[292.636585] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[292.637496] Starting dynamic subtest: pipe-A-DP-4
[292.645769] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[292.653174] Starting dynamic subtest: pipe-B-DP-4
[292.662099] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[292.669205] Starting dynamic subtest: pipe-C-DP-4
[292.677540] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[292.684599] Starting dynamic subtest: pipe-D-DP-4
[292.694817] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[292.697043] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[293.059315] [054/131] (707s left) gem_exercise_blt (fast-copy-emit)
[293.159268] Starting subtest: fast-copy-emit
[293.160169] Starting dynamic subtest: linear-smem-smem-emit
[293.195682] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.036s)
[293.203122] Starting dynamic subtest: linear-smem-lmem0-emit
[293.208104] Dynamic subtest linear-smem-lmem0-emit: SUCCESS (0.012s)
[293.215457] Starting dynamic subtest: linear-lmem0-smem-emit
[293.315480] Dynamic subtest linear-lmem0-smem-emit: SUCCESS (0.107s)
[293.322619] Starting dynamic subtest: linear-lmem0-lmem0-emit
[293.422803] Dynamic subtest linear-lmem0-lmem0-emit: SUCCESS (0.107s)
[293.429972] Starting dynamic subtest: xmajor-smem-smem-emit
[293.436817] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.013s)
[293.443974] Starting dynamic subtest: xmajor-smem-lmem0-emit
[293.448738] Dynamic subtest xmajor-smem-lmem0-emit: SUCCESS (0.011s)
[293.456099] Starting dynamic subtest: xmajor-lmem0-smem-emit
[293.556750] Dynamic subtest xmajor-lmem0-smem-emit: SUCCESS (0.107s)
[293.564014] Starting dynamic subtest: xmajor-lmem0-lmem0-emit
[293.663506] Dynamic subtest xmajor-lmem0-lmem0-emit: SUCCESS (0.106s)
[293.670765] Starting dynamic subtest: tile4-smem-smem-emit
[293.675999] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.012s)
[293.683230] Starting dynamic subtest: tile4-smem-lmem0-emit
[293.688338] Dynamic subtest tile4-smem-lmem0-emit: SUCCESS (0.012s)
[293.695574] Starting dynamic subtest: tile4-lmem0-smem-emit
[293.795567] Dynamic subtest tile4-lmem0-smem-emit: SUCCESS (0.107s)
[293.802800] Starting dynamic subtest: tile4-lmem0-lmem0-emit
[293.902702] Dynamic subtest tile4-lmem0-lmem0-emit: SUCCESS (0.107s)
[293.909958] Starting dynamic subtest: tile64-smem-smem-emit
[293.915186] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.012s)
[293.922340] Starting dynamic subtest: tile64-smem-lmem0-emit
[293.927245] Dynamic subtest tile64-smem-lmem0-emit: SUCCESS (0.012s)
[293.934459] Starting dynamic subtest: tile64-lmem0-smem-emit
[294.034660] Dynamic subtest tile64-lmem0-smem-emit: SUCCESS (0.107s)
[294.041728] Starting dynamic subtest: tile64-lmem0-lmem0-emit
[294.141344] Dynamic subtest tile64-lmem0-lmem0-emit: SUCCESS (0.106s)
[294.142203] Subtest fast-copy-emit: SUCCESS (0.982s)
[294.286720] [055/131] (705s left) kms_lease (empty-lease)
[294.507797] Starting subtest: empty-lease
[294.508674] Starting dynamic subtest: pipe-A-DP-4
[294.509564] Dynamic subtest pipe-A-DP-4: SUCCESS (0.001s)
[294.518672] Starting dynamic subtest: pipe-B-DP-4
[294.519566] Dynamic subtest pipe-B-DP-4: SUCCESS (0.001s)
[294.526900] Starting dynamic subtest: pipe-C-DP-4
[294.527732] Dynamic subtest pipe-C-DP-4: SUCCESS (0.001s)
[294.535208] Starting dynamic subtest: pipe-D-DP-4
[294.536230] Dynamic subtest pipe-D-DP-4: SUCCESS (0.001s)
[294.537213] Subtest empty-lease: SUCCESS (0.010s)
[294.587326] [056/131] (705s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[294.816619] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[294.818439] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[294.889135] [057/131] (705s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[295.126941] Starting subtest: flip-vs-cursor-varying-size
[304.830251] Subtest flip-vs-cursor-varying-size: SUCCESS (9.703s)
[305.070345] [058/131] (695s left) kms_atomic_interruptible (universal-setplane-primary)
[305.302045] Starting subtest: universal-setplane-primary
[305.304144] Starting dynamic subtest: pipe-A-DP-4
[311.620244] Dynamic subtest pipe-A-DP-4: SUCCESS (6.316s)
[311.621234] Subtest universal-setplane-primary: SUCCESS (6.318s)
[311.818344] [059/131] (688s left) gem_softpin (allocator-nopin)
[311.911436] Starting subtest: allocator-nopin
[312.061845] Subtest allocator-nopin: SUCCESS (0.150s)
[312.185510] [060/131] (688s left) kms_dp_linktrain_fallback (dp-fallback)
[312.401896] Starting subtest: dp-fallback
[322.295030] Subtest dp-fallback: SUCCESS (9.892s)
[322.669093] [061/131] (677s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[322.886987] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[322.887969] Starting dynamic subtest: pipe-A-DP-4
[322.897048] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[322.904412] Starting dynamic subtest: pipe-B-DP-4
[322.912897] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[322.920155] Starting dynamic subtest: pipe-C-DP-4
[322.928383] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[322.937134] Starting dynamic subtest: pipe-D-DP-4
[322.947122] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[322.949648] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[323.319050] [062/131] (676s left) gem_mmap_offset (blt-coherency)
[323.411214] Starting subtest: blt-coherency
[323.435129] Subtest blt-coherency: SUCCESS (0.025s)
[323.578538] [063/131] (676s left) gem_exec_fence (invalid-timeline-fence-array)
[324.132320] Starting subtest: invalid-timeline-fence-array
[324.141269] Subtest invalid-timeline-fence-array: SUCCESS (0.009s)
[324.384907] [064/131] (675s left) gem_spin_batch (spin-all)
[324.486939] Starting subtest: spin-all
[324.522348] Subtest spin-all: SUCCESS (0.035s)
[324.788703] [065/131] (675s left) gem_eio (wait-wedge-immediate)
[325.102308] Starting subtest: wait-wedge-immediate
[326.286655] Subtest wait-wedge-immediate: SUCCESS (1.185s)
[326.473452] [066/131] (673s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[326.701475] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[326.703082] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[326.780830] [067/131] (673s left) kms_flip (nonblocking-read)
[327.037692] Starting subtest: nonblocking-read
[327.038637] Subtest nonblocking-read: SUCCESS (0.000s)
[327.107328] [068/131] (673s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[327.333792] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[327.335374] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[327.413586] [069/131] (673s left) gem_eio (in-flight-1us)
[327.759542] Starting subtest: in-flight-1us
[332.810976] Subtest in-flight-1us: SUCCESS (5.052s)
[333.010965] [070/131] (667s left) gem_ctx_persistence (many-contexts)
[333.114862] Starting subtest: many-contexts
[370.766472] Subtest many-contexts: SUCCESS (37.651s)
[370.880557] [071/131] (629s left) gem_render_copy (yf-tiled-ccs-to-linear)
[370.968318] Starting subtest: yf-tiled-ccs-to-linear
[370.969890] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[371.149662] [072/131] (629s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[371.403425] Starting subtest: psr-shrfb-scaledprimary
[371.405078] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[371.483283] [073/131] (629s left) kms_chamelium_color (ctm-limited-range)
[371.718251] Subtest ctm-limited-range: SKIP (0.000s)
[371.738095] [074/131] (628s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[371.956919] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[371.958719] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[372.057633] [075/131] (628s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-gtt)
[372.303701] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-gtt
[372.305579] Subtest psr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[372.383568] [076/131] (628s left) api_intel_allocator (reserve-simple)
[372.497211] Starting subtest: reserve-simple
[372.516621] Subtest reserve-simple: SUCCESS (0.020s)
[372.628697] [077/131] (627s left) gem_softpin (noreloc-s3)
[372.718067] Starting subtest: noreloc-S3
[393.081142] Subtest noreloc-S3: SUCCESS (5.421s)
[394.172560] [078/131] (622s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[394.399645] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[394.431808] [079/131] (622s left) perf_pmu (most-busy-idle-check-all)
[394.510242] Starting subtest: most-busy-idle-check-all
[394.511183] Starting dynamic subtest: rcs0
[395.211918] Dynamic subtest rcs0: FAIL (0.674s)
[395.225649] Starting dynamic subtest: bcs0
[395.845178] Dynamic subtest bcs0: SUCCESS (0.659s)
[395.856560] Starting dynamic subtest: vcs0
[396.497329] Dynamic subtest vcs0: SUCCESS (0.651s)
[396.507154] Starting dynamic subtest: vcs1
[397.148969] Dynamic subtest vcs1: SUCCESS (0.651s)
[397.158575] Starting dynamic subtest: vecs0
[397.799543] Dynamic subtest vecs0: SUCCESS (0.650s)
[397.809230] Starting dynamic subtest: vecs1
[398.451686] Dynamic subtest vecs1: SUCCESS (0.650s)
[398.466239] Starting dynamic subtest: ccs0
[399.109376] Dynamic subtest ccs0: SUCCESS (0.656s)
[399.110288] Subtest most-busy-idle-check-all: FAIL (4.599s)
[399.205489] [080/131] (617s left) sysfs_preempt_timeout (timeout)
[399.291940] Starting subtest: timeout
[399.293140] Starting dynamic subtest: vecs0
[400.940894] Dynamic subtest vecs0: SUCCESS (1.648s)
[400.951237] Starting dynamic subtest: ccs0
[402.710127] Dynamic subtest ccs0: SUCCESS (1.769s)
[402.720118] Starting dynamic subtest: vcs0
[404.366756] Dynamic subtest vcs0: SUCCESS (1.656s)
[404.377400] Starting dynamic subtest: bcs0
[405.899768] Dynamic subtest bcs0: SUCCESS (1.533s)
[405.909440] Starting dynamic subtest: vecs1
[407.520739] Dynamic subtest vecs1: SUCCESS (1.606s)
[407.530574] Starting dynamic subtest: rcs0
[409.163054] Dynamic subtest rcs0: SUCCESS (1.590s)
[409.172989] Starting dynamic subtest: vcs1
[410.836680] Dynamic subtest vcs1: SUCCESS (1.631s)
[410.837582] Subtest timeout: SUCCESS (11.436s)
[410.949951] [081/131] (605s left) kms_vblank (wait-forked-hang)
[411.172433] Starting subtest: wait-forked-hang
[411.174993] Starting dynamic subtest: pipe-A-DP-4
[437.932814] Dynamic subtest pipe-A-DP-4: SUCCESS (26.587s)
[437.948173] Starting dynamic subtest: pipe-D-DP-4
[462.877197] Dynamic subtest pipe-D-DP-4: SUCCESS (24.931s)
[462.878163] Subtest wait-forked-hang: SUCCESS (51.526s)
[463.041837] [082/131] (553s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[463.136905] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[463.372432] [083/131] (553s left) kms_sequence (get-busy)
[463.632074] Starting subtest: get-busy
[463.633066] Starting dynamic subtest: pipe-A-DP-4
[466.166202] Dynamic subtest pipe-A-DP-4: SUCCESS (2.531s)
[466.177424] Starting dynamic subtest: pipe-B-DP-4
[468.641267] Dynamic subtest pipe-B-DP-4: SUCCESS (2.473s)
[468.651438] Starting dynamic subtest: pipe-C-DP-4
[471.116983] Dynamic subtest pipe-C-DP-4: SUCCESS (2.473s)
[471.130603] Starting dynamic subtest: pipe-D-DP-4
[473.599955] Dynamic subtest pipe-D-DP-4: SUCCESS (2.481s)
[473.600859] Subtest get-busy: SUCCESS (9.963s)
[473.823295] [084/131] (543s left) kms_content_protection (srm)
[474.108546] Starting subtest: srm
[474.146584] Starting dynamic subtest: pipe-A-DP-4
[594.539280] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[594.850926] Closing watchdogs
[594.852197] Initializing watchdogs
[594.852229]   /dev/watchdog0
[594.863461] [085/131] (422s left) prime_self_import (export-vs-gem_close-race)
[594.937327] Starting subtest: export-vs-gem_close-race
[599.987614] Subtest export-vs-gem_close-race: SUCCESS (5.049s)
[600.052686] [086/131] (417s left) gem_tiled_wb
[600.245608] [087/131] (416s left) syncobj_basic (create-signaled)
[600.341584] Starting subtest: create-signaled
[600.342460] Subtest create-signaled: SUCCESS (0.000s)
[600.430156] [088/131] (416s left) kms_psr (fbc-pr-cursor-plane-move)
[600.692652] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[600.711583] [089/131] (416s left) kms_psr (psr2-sprite-mmap-cpu)
[600.944585] Subtest psr2-sprite-mmap-cpu: SKIP (0.000s)
[600.978241] [090/131] (416s left) kms_plane_scaling (plane-downscale-factor-0-25-with-modifiers)
[601.191847] Starting subtest: plane-downscale-factor-0-25-with-modifiers
[601.192612] Starting dynamic subtest: pipe-A
[601.929822] Dynamic subtest pipe-A: SKIP (0.736s)
[601.939389] Starting dynamic subtest: pipe-B
[603.060506] Dynamic subtest pipe-B: SKIP (1.130s)
[603.070902] Starting dynamic subtest: pipe-C
[604.191787] Dynamic subtest pipe-C: SKIP (1.130s)
[604.201398] Starting dynamic subtest: pipe-D
[605.321810] Dynamic subtest pipe-D: SKIP (1.129s)
[605.323284] Subtest plane-downscale-factor-0-25-with-modifiers: SKIP (4.127s)
[605.401363] [091/131] (411s left) drm_fdinfo (busy)
[605.492455] Starting subtest: busy
[605.493387] Starting dynamic subtest: rcs0
[605.509737] Dynamic subtest rcs0: SKIP (0.016s)
[605.519384] Starting dynamic subtest: bcs0
[605.521136] Dynamic subtest bcs0: SKIP (0.006s)
[605.530294] Starting dynamic subtest: vcs0
[605.532047] Dynamic subtest vcs0: SKIP (0.000s)
[605.541522] Starting dynamic subtest: vcs1
[605.543106] Dynamic subtest vcs1: SKIP (0.000s)
[605.552480] Starting dynamic subtest: vecs0
[605.554213] Dynamic subtest vecs0: SKIP (0.000s)
[605.563461] Starting dynamic subtest: vecs1
[605.565169] Dynamic subtest vecs1: SKIP (0.000s)
[605.575448] Starting dynamic subtest: ccs0
[605.577229] Dynamic subtest ccs0: SKIP (0.000s)
[605.579093] Subtest busy: SKIP (0.026s)
[605.593052] [092/131] (411s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[605.821462] Starting subtest: x-tiled-addfb-size-offset-overflow
[605.822519] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.001s)
[605.917945] [093/131] (411s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[606.132965] Starting subtest: yf-tiled-64bpp-rotate-270
[606.134741] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[606.200758] [094/131] (411s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[606.417237] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[606.419071] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[606.487178] [095/131] (410s left) i915_pm_rps (thresholds-idle)
[606.587005] Starting subtest: thresholds-idle
[606.589335] Subtest thresholds-idle: SKIP (0.000s)
[606.681191] [096/131] (410s left) kms_getfb (getfb-handle-zero)
[606.787707] Starting subtest: getfb-handle-zero
[606.788784] Subtest getfb-handle-zero: SUCCESS (0.000s)
[606.891561] [097/131] (410s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-gtt)
[607.151641] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-gtt
[607.153424] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[607.246752] [098/131] (410s left) gem_exec_reloc (basic-concurrent16)
[607.365246] Subtest basic-concurrent16: SKIP (0.000s)
[607.416007] [099/131] (409s left) kms_addfb_basic (small-bo)
[607.638001] Starting subtest: small-bo
[607.639003] Subtest small-bo: SUCCESS (0.000s)
[607.727165] [100/131] (409s left) gem_ctx_isolation (dirty-create)
[607.839788] Starting subtest: dirty-create
[607.840749] Starting dynamic subtest: rcs0
[608.263638] Dynamic subtest rcs0: SUCCESS (0.423s)
[608.274395] Starting dynamic subtest: bcs0
[608.707713] Dynamic subtest bcs0: SUCCESS (0.443s)
[608.717390] Starting dynamic subtest: vcs0
[609.161370] Dynamic subtest vcs0: SUCCESS (0.453s)
[609.171672] Starting dynamic subtest: vcs1
[609.616539] Dynamic subtest vcs1: SUCCESS (0.454s)
[609.626521] Starting dynamic subtest: vecs0
[610.085642] Dynamic subtest vecs0: SUCCESS (0.468s)
[610.095339] Starting dynamic subtest: vecs1
[610.563602] Dynamic subtest vecs1: SUCCESS (0.477s)
[610.573161] Starting dynamic subtest: ccs0
[611.069106] Dynamic subtest ccs0: SUCCESS (0.505s)
[611.070017] Subtest dirty-create: SUCCESS (3.229s)
[611.303891] [101/131] (406s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[611.389618] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[611.390586] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[611.531843] [102/131] (405s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[611.766729] Starting subtest: y-tiled-8bpp-rotate-270
[611.768518] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[611.842474] [103/131] (405s left) syncobj_timeline (wait-all-snapshot)
[611.952704] Starting subtest: wait-all-snapshot
[612.034099] Subtest wait-all-snapshot: SUCCESS (0.082s)
[612.148986] [104/131] (405s left) kms_cursor_crc (cursor-onscreen-128x128)
[612.491127] Starting subtest: cursor-onscreen-128x128
[612.505263] Starting dynamic subtest: pipe-A-DP-4
[615.150895] Dynamic subtest pipe-A-DP-4: SUCCESS (2.644s)
[615.184142] Starting dynamic subtest: pipe-D-DP-4
[617.841838] Dynamic subtest pipe-D-DP-4: SUCCESS (2.664s)
[617.842825] Subtest cursor-onscreen-128x128: SUCCESS (5.348s)
[618.214371] [105/131] (399s left) gem_tiled_partial_pwrite_pread (reads)
[618.327016] Subtest reads: SKIP (0.000s)
[618.363197] [106/131] (399s left) gem_exec_whisper (basic-fds)
[618.465592] Starting subtest: basic-fds
[627.640779] Subtest basic-fds: SUCCESS (9.170s)
[627.813316] [107/131] (389s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[627.908140] Subtest tiled-to-untiled: SKIP (0.000s)
[627.948675] [108/131] (389s left) gem_lmem_swapping (verify-ccs)
[631.353711] Starting subtest: verify-ccs
[631.354581] Starting dynamic subtest: lmem0
[644.585608] Abort requested by /sbin/init [1] via Terminated, terminating children
[644.586042] Abort requested by sudo LD_LIBRARY_PATH=/opt/igt/lib:/opt/igt/lib/x86_64-linux-gnu IGT_DEVICE=pci:vendor=intel,device=discrete,card=all IG [1131] via Terminated, terminating children
[644.586986] Abort requested by /sbin/init [1] via Hangup, terminating children
[644.587020] Exiting gracefully, currently running test will have a 'notrun' result
[645.346404] Closing watchdogs
Done.