[45.648115] Initializing watchdogs [45.648240] /dev/watchdog0 [45.661603] [001/142] (960s left) gem_exec_params (no-blt) [45.771126] Starting subtest: no-blt [45.782482] Subtest no-blt: SUCCESS (0.011s) [45.881435] [002/142] (960s left) kms_atomic_interruptible (universal-setplane-cursor) [46.012761] Starting subtest: universal-setplane-cursor [46.017614] Starting dynamic subtest: eDP-1-pipe-A [53.594069] Dynamic subtest eDP-1-pipe-A: SUCCESS (7.578s) [53.597574] Subtest universal-setplane-cursor: SUCCESS (7.581s) [54.501280] [003/142] (951s left) v3d/v3d_submit_csd (multi-and-single-sync) [54.635165] Subtest multi-and-single-sync: SKIP (0.000s) [54.682317] [004/142] (951s left) drm_fdinfo (most-busy-idle-check-all) [54.768905] Starting subtest: most-busy-idle-check-all [54.771550] Starting dynamic subtest: rcs0 [54.780839] Dynamic subtest rcs0: SKIP (0.005s) [54.791643] Starting dynamic subtest: bcs0 [54.797063] Dynamic subtest bcs0: SKIP (0.001s) [54.807664] Starting dynamic subtest: vcs0 [54.812767] Dynamic subtest vcs0: SKIP (0.001s) [54.823078] Starting dynamic subtest: vcs1 [54.828646] Dynamic subtest vcs1: SKIP (0.001s) [54.839289] Starting dynamic subtest: vecs0 [54.845687] Dynamic subtest vecs0: SKIP (0.001s) [54.855667] Starting dynamic subtest: ccs0 [54.861030] Dynamic subtest ccs0: SKIP (0.001s) [54.866095] Subtest most-busy-idle-check-all: SKIP (0.010s) [54.884238] [005/142] (951s left) syncobj_wait (wait-for-submit-snapshot) [54.998489] Starting subtest: wait-for-submit-snapshot [55.081781] Subtest wait-for-submit-snapshot: SUCCESS (0.083s) [55.147351] [006/142] (951s left) kms_vblank (pipe-c-ts-continuation-dpms-suspend) [55.269281] Starting subtest: pipe-C-ts-continuation-dpms-suspend [74.567642] Subtest pipe-C-ts-continuation-dpms-suspend: SUCCESS (3.301s) [75.492503] [007/142] (946s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-pwrite) [75.624341] Starting subtest: psr-1p-offscren-pri-indfb-draw-pwrite [80.539844] Subtest psr-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (4.918s) [80.670392] [008/142] (941s left) kms_prime (basic-crc-hybrid) [81.548723] Subtest basic-crc-hybrid: SKIP (0.000s) [81.650511] [009/142] (940s left) perf (mi-rpc) [81.924205] Starting subtest: mi-rpc [81.928409] Subtest mi-rpc: SKIP (0.000s) [81.965515] [010/142] (940s left) core_getclient [82.113983] [011/142] (940s left) kms_plane_scaling (invalid-num-scalers) [82.232860] Starting subtest: invalid-num-scalers [82.235506] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers [82.267590] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.035s) [82.279805] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers [82.329297] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.057s) [82.341372] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers [82.371265] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.040s) [82.383171] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers [82.399831] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.028s) [82.401928] Subtest invalid-num-scalers: SUCCESS (0.167s) [82.486990] [012/142] (939s left) kms_busy (extended-pageflip-hang-oldfb) [82.583241] Starting subtest: extended-pageflip-hang-oldfb [82.590474] Starting dynamic subtest: pipe-A [83.220377] Dynamic subtest pipe-A: SUCCESS (0.633s) [83.237385] Starting dynamic subtest: pipe-D [84.471252] Dynamic subtest pipe-D: SUCCESS (1.245s) [84.474028] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.888s) [85.369913] [013/142] (937s left) kms_cursor_legacy (flip-vs-cursor-atomic) [85.529070] Starting subtest: flip-vs-cursor-atomic [91.553926] Subtest flip-vs-cursor-atomic: SUCCESS (6.023s) [92.455222] [014/142] (930s left) gem_exec_fence (syncobj-backward-timeline-chain-engines) [93.312106] Starting subtest: syncobj-backward-timeline-chain-engines [93.413101] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.102s) [94.481771] [015/142] (928s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_dg2_rc_ccs) [95.041848] Starting subtest: pipe-D-crc-primary-basic-4_tiled_dg2_rc_ccs [95.047742] Subtest pipe-D-crc-primary-basic-4_tiled_dg2_rc_ccs: SKIP (0.001s) [95.797242] [016/142] (926s left) kms_big_fb (yf-tiled-8bpp-rotate-90) [95.943737] Starting subtest: yf-tiled-8bpp-rotate-90 [95.948899] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s) [96.037063] [017/142] (926s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc) [96.168745] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc [101.109487] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (4.946s) [101.258583] [018/142] (921s left) gem_wait (busy) [101.369495] Starting subtest: busy [101.372217] Starting dynamic subtest: all-engines [103.418177] Dynamic subtest all-engines: SUCCESS (2.048s) [103.434592] Starting dynamic subtest: rcs0 [103.957045] Dynamic subtest rcs0: SUCCESS (0.539s) [103.969953] Starting dynamic subtest: bcs0 [104.497805] Dynamic subtest bcs0: SUCCESS (0.540s) [104.511283] Starting dynamic subtest: vcs0 [106.426436] Dynamic subtest vcs0: SUCCESS (1.928s) [106.439220] Starting dynamic subtest: vcs1 [108.410846] Dynamic subtest vcs1: SUCCESS (1.984s) [108.423837] Starting dynamic subtest: vecs0 [110.394153] Dynamic subtest vecs0: SUCCESS (1.983s) [110.406921] Starting dynamic subtest: ccs0 [110.934618] Dynamic subtest ccs0: SUCCESS (0.541s) [110.937549] Subtest busy: SUCCESS (9.566s) [111.143789] [019/142] (911s left) gem_softpin (evict-prime) [111.237698] Starting subtest: evict-prime [111.240614] Starting dynamic subtest: rcs0 [112.351089] Dynamic subtest rcs0: SUCCESS (1.116s) [112.365324] Starting dynamic subtest: bcs0 [113.461052] Dynamic subtest bcs0: SUCCESS (1.110s) [113.471817] Starting dynamic subtest: vcs0 [115.422903] Dynamic subtest vcs0: SUCCESS (1.960s) [115.438120] Starting dynamic subtest: vcs1 [117.397661] Dynamic subtest vcs1: SUCCESS (1.974s) [117.411523] Starting dynamic subtest: vecs0 [119.366700] Dynamic subtest vecs0: SUCCESS (1.969s) [119.381388] Starting dynamic subtest: ccs0 [120.500121] Dynamic subtest ccs0: SUCCESS (1.135s) [120.514808] Starting dynamic subtest: all [122.375304] Dynamic subtest all: SUCCESS (1.872s) [122.378888] Subtest evict-prime: SUCCESS (11.138s) [122.476940] [020/142] (900s left) kms_flip (2x-nonexisting-fb-interruptible) [122.591869] Starting subtest: 2x-nonexisting-fb-interruptible [122.645050] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.047s) [122.715867] [021/142] (900s left) gem_set_tiling_vs_pwrite [122.847390] [022/142] (899s left) kms_cursor_crc (cursor-rapid-movement-32x32) [123.006736] Starting subtest: cursor-rapid-movement-32x32 [123.096044] Subtest cursor-rapid-movement-32x32: SKIP (0.082s) [123.378763] [023/142] (899s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip) [123.518818] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip [124.851602] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.332s) [124.998639] [024/142] (897s left) gem_bad_reloc (negative-reloc) [125.094868] Subtest negative-reloc: SKIP (0.000s) [125.152625] [025/142] (897s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs) [125.607024] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs [125.613363] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SKIP (0.004s) [126.463207] [026/142] (896s left) syncobj_timeline (invalid-multi-wait-unsubmitted) [126.552377] Starting subtest: invalid-multi-wait-unsubmitted [126.555044] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [126.618075] [027/142] (896s left) i915_pm_rpm (modeset-non-lpsp) [128.564243] Starting subtest: modeset-non-lpsp [132.088011] Subtest modeset-non-lpsp: SKIP (3.521s) [132.946557] [028/142] (889s left) gen7_exec_parse (oacontrol-tracking) [133.043290] Subtest oacontrol-tracking: SKIP (0.000s) [133.083075] [029/142] (889s left) sw_sync (sync_multi_consumer) [133.165292] Starting subtest: sync_multi_consumer [134.846917] Subtest sync_multi_consumer: SUCCESS (1.681s) [134.903208] [030/142] (888s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt) [135.036512] Starting subtest: psr-2p-primscrn-indfb-msflip-blt [135.041597] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [135.127043] [031/142] (887s left) gem_mmap_gtt (hang-user) [135.213182] Subtest hang-user: SKIP (0.000s) [135.250079] [032/142] (887s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_dg2_mc_ccs) [135.674073] Starting subtest: pipe-A-crc-primary-basic-4_tiled_dg2_mc_ccs [135.679150] Subtest pipe-A-crc-primary-basic-4_tiled_dg2_mc_ccs: SKIP (0.001s) [136.557763] [033/142] (886s left) gem_exec_params (invalid-bsd1-flag-on-blt) [136.648545] Starting subtest: invalid-bsd1-flag-on-blt [136.651188] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s) [136.741933] [034/142] (886s left) api_intel_allocator (simple-allocator) [136.825754] Starting subtest: simple-allocator [136.828535] Starting dynamic subtest: basic [136.831209] Dynamic subtest basic: SUCCESS (0.005s) [136.845375] Starting dynamic subtest: parallel-one [137.053024] Dynamic subtest parallel-one: SUCCESS (0.222s) [137.067658] Starting dynamic subtest: print [137.070481] Dynamic subtest print: SUCCESS (0.000s) [137.084456] Starting dynamic subtest: reuse [137.087073] Dynamic subtest reuse: SUCCESS (0.000s) [137.100611] Starting dynamic subtest: reserve [137.103265] Dynamic subtest reserve: SUCCESS (0.000s) [137.116642] Starting dynamic subtest: fork-reopen-allocator [137.119182] Dynamic subtest fork-reopen-allocator: SUCCESS (0.028s) [137.121786] Subtest simple-allocator: SUCCESS (0.258s) [137.182815] [035/142] (885s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move) [137.325637] Starting subtest: psr-2p-scndscrn-spr-indfb-move [137.331091] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [137.412597] [036/142] (885s left) prime_busy (after) [137.507159] Starting subtest: after [137.516153] Starting dynamic subtest: rcs0 [137.542830] Dynamic subtest rcs0: SUCCESS (0.026s) [137.557282] Starting dynamic subtest: bcs0 [137.582319] Dynamic subtest bcs0: SUCCESS (0.039s) [137.596774] Starting dynamic subtest: vcs0 [137.622646] Dynamic subtest vcs0: SUCCESS (0.040s) [137.637801] Starting dynamic subtest: vcs1 [137.640537] Dynamic subtest vcs1: SUCCESS (0.016s) [137.654209] Starting dynamic subtest: vecs0 [137.663421] Dynamic subtest vecs0: SUCCESS (0.022s) [137.679048] Starting dynamic subtest: ccs0 [137.681200] Dynamic subtest ccs0: SUCCESS (0.015s) [137.790806] Subtest after: SUCCESS (0.282s) [137.860044] [037/142] (885s left) gem_ctx_param (basic) [137.947155] Starting subtest: basic [137.949831] Subtest basic: SUCCESS (0.000s) [138.017667] [038/142] (885s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted) [138.103764] Starting subtest: etime-single-wait-for-submit-unsubmitted [138.211656] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.107s) [138.282439] [039/142] (884s left) kms_cursor_crc (cursor-sliding-512x512) [138.603052] Starting subtest: cursor-sliding-512x512 [138.608757] Subtest cursor-sliding-512x512: SKIP (0.002s) [138.756699] [040/142] (884s left) gem_ctx_shared (q-smoketest-all) [138.860326] Starting subtest: Q-smoketest-all [171.430820] Subtest Q-smoketest-all: SUCCESS (32.512s) [172.488375] [041/142] (850s left) gem_exec_await (wide-all) [172.988948] Starting subtest: wide-all [196.948212] Subtest wide-all: SUCCESS (23.958s) [197.154627] [042/142] (826s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary) [197.380047] Starting subtest: fbcpsr-indfb-scaledprimary [203.286241] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.911s) [203.415017] [043/142] (819s left) v3d/v3d_submit_cl (bad-multisync-in-sync) [203.560052] Subtest bad-multisync-in-sync: SKIP (0.000s) [203.612936] [044/142] (819s left) kms_vblank (pipe-a-wait-busy-hang) [203.735029] Starting subtest: pipe-A-wait-busy-hang [215.547794] Subtest pipe-A-wait-busy-hang: SUCCESS (11.812s) [216.486925] [045/142] (806s left) syncobj_timeline (wait-any-complex) [216.578336] Starting subtest: wait-any-complex [216.642384] Subtest wait-any-complex: SUCCESS (0.064s) [216.713936] [046/142] (806s left) gem_pxp (reject-modify-context-protection-off-3) [219.343040] Subtest reject-modify-context-protection-off-3: SKIP (0.000s) [219.410398] [047/142] (804s left) kms_ccs (pipe-a-bad-rotation-90-y_tiled_ccs) [219.852768] Starting subtest: pipe-A-bad-rotation-90-y_tiled_ccs [219.857543] Subtest pipe-A-bad-rotation-90-y_tiled_ccs: SKIP (0.000s) [220.744471] [048/142] (802s left) kms_vblank (invalid) [220.868452] Starting subtest: invalid [221.293417] Subtest invalid: SUCCESS (0.426s) [222.247445] [049/142] (801s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-cpu) [222.380924] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-cpu [225.475482] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (3.100s) [225.607726] [050/142] (797s left) syncobj_basic (test-valid-cycle) [225.695899] Starting subtest: test-valid-cycle [225.698157] Subtest test-valid-cycle: SUCCESS (0.000s) [225.762722] [051/142] (797s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation) [225.883221] Starting subtest: plane-scaler-with-clipping-clamping-rotation [225.885491] Starting dynamic subtest: pipe-A-eDP-1 [226.562151] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.679s) [226.579117] Starting dynamic subtest: pipe-B-eDP-1 [228.445754] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.878s) [228.463548] Starting dynamic subtest: pipe-C-eDP-1 [230.297436] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.851s) [230.322334] Starting dynamic subtest: pipe-D-eDP-1 [232.144018] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.843s) [232.146692] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (6.264s) [233.449264] [052/142] (790s left) kms_chamelium_frames (dp-crc-single) [233.879928] Subtest dp-crc-single: SKIP (0.000s) [234.759981] [053/142] (788s left) vc4/vc4_label_bo (set-label) [234.895926] Subtest set-label: SKIP (0.000s) [234.947542] [054/142] (788s left) kms_rotation_crc (bad-pixel-format) [235.069617] Starting subtest: bad-pixel-format [235.075095] Subtest bad-pixel-format: SKIP (0.002s) [235.142080] [055/142] (788s left) drm_read (empty-block) [235.507509] Starting subtest: empty-block [236.508029] Subtest empty-block: SUCCESS (1.002s) [236.628766] [056/142] (787s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [236.765826] Starting subtest: psr-2p-primscrn-spr-indfb-move [236.770068] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [236.849232] [057/142] (786s left) gem_mmap_offset (close-race) [236.936270] Starting subtest: close-race [257.201978] Subtest close-race: SUCCESS (20.265s) [257.294855] [058/142] (766s left) gem_ctx_isolation (dirty-switch) [257.400387] Starting subtest: dirty-switch [257.403660] Starting dynamic subtest: rcs0 [257.689291] Dynamic subtest rcs0: SUCCESS (0.289s) [257.697202] Starting dynamic subtest: bcs0 [258.048406] Dynamic subtest bcs0: SUCCESS (0.358s) [258.062670] Starting dynamic subtest: vcs0 [258.392775] Dynamic subtest vcs0: SUCCESS (0.344s) [258.408482] Starting dynamic subtest: vcs1 [259.720160] Dynamic subtest vcs1: SUCCESS (1.326s) [259.736420] Starting dynamic subtest: vecs0 [261.722052] Dynamic subtest vecs0: SUCCESS (2.001s) [261.738257] Starting dynamic subtest: ccs0 [263.780045] Dynamic subtest ccs0: SUCCESS (2.057s) [263.783023] Subtest dirty-switch: SUCCESS (6.380s) [264.019822] [059/142] (759s left) gem_ctx_engines (invalid-engines) [264.120185] Starting subtest: invalid-engines [264.135318] Subtest invalid-engines: SUCCESS (0.015s) [264.355197] [060/142] (759s left) syncobj_wait (wait-all-snapshot) [264.447370] Starting subtest: wait-all-snapshot [264.528657] Subtest wait-all-snapshot: SUCCESS (0.083s) [264.603816] [061/142] (759s left) kms_pm_backlight (fade-with-dpms) [264.737022] Starting subtest: fade-with-dpms [266.997308] Starting dynamic subtest: eDP-1 [269.704037] Dynamic subtest eDP-1: SUCCESS (2.704s) [269.707371] Subtest fade-with-dpms: SUCCESS (4.967s) [270.633504] [062/142] (753s left) drm_read (short-buffer-block) [270.875128] Starting subtest: short-buffer-block [270.877869] Subtest short-buffer-block: SUCCESS (0.000s) [270.990190] [063/142] (753s left) gem_exec_alignment (single) [271.084612] Starting subtest: single [271.091185] Subtest single: SUCCESS (0.006s) [271.186120] [064/142] (752s left) kms_ccs (pipe-d-bad-pixel-format-yf_tiled_ccs) [271.738535] Starting subtest: pipe-D-bad-pixel-format-yf_tiled_ccs [271.744103] Subtest pipe-D-bad-pixel-format-yf_tiled_ccs: SKIP (0.000s) [272.503673] [065/142] (751s left) kms_ccs (pipe-b-ccs-on-another-bo-y_tiled_gen12_rc_ccs) [273.001461] Starting subtest: pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs [273.007534] Subtest pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs: SKIP (0.000s) [273.832202] [066/142] (750s left) kms_flip (dpms-vs-vblank-race-interruptible) [273.948698] Starting subtest: dpms-vs-vblank-race-interruptible [273.954891] Starting dynamic subtest: A-eDP1 [278.200469] Dynamic subtest A-eDP1: SUCCESS (4.245s) [278.216094] Starting dynamic subtest: B-eDP1 [281.973406] Dynamic subtest B-eDP1: SUCCESS (3.771s) [281.994181] Starting dynamic subtest: C-eDP1 [285.675105] Dynamic subtest C-eDP1: SUCCESS (3.701s) [285.690810] Starting dynamic subtest: D-eDP1 [289.400716] Dynamic subtest D-eDP1: SUCCESS (3.723s) [289.406773] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (15.460s) [290.298316] [067/142] (733s left) i915_suspend (fence-restore-tiled2untiled) [290.393747] Starting subtest: fence-restore-tiled2untiled [290.401541] Subtest fence-restore-tiled2untiled: SKIP (0.000s) [290.462468] [068/142] (733s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs) [291.059259] Starting subtest: pipe-D-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs [298.680084] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs: SUCCESS (7.620s) [299.883575] [069/142] (724s left) gem_exec_fair (basic-sync) [300.001728] Subtest basic-sync: SKIP (0.000s) [300.057337] [070/142] (724s left) kms_lease (lease_invalid_crtc) [300.178420] Starting subtest: lease_invalid_crtc [300.181049] Starting dynamic subtest: pipe-A-eDP-1 [300.183605] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [300.199081] Starting dynamic subtest: pipe-B-eDP-1 [300.201337] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [300.216293] Starting dynamic subtest: pipe-C-eDP-1 [300.218775] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [300.233379] Starting dynamic subtest: pipe-D-eDP-1 [300.236073] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [300.238620] Subtest lease_invalid_crtc: SUCCESS (0.011s) [300.264265] [071/142] (724s left) gem_shrink (reclaim) [300.356639] Starting subtest: reclaim [302.870528] Subtest reclaim: SUCCESS (2.510s) [302.982102] [072/142] (721s left) syncobj_basic (create-signaled) [303.072009] Starting subtest: create-signaled [303.075319] Subtest create-signaled: SUCCESS (0.000s) [303.141611] [073/142] (721s left) gem_exec_basic (basic) [303.235696] Starting subtest: basic [303.238297] Starting dynamic subtest: rcs0-smem [303.241022] Dynamic subtest rcs0-smem: SUCCESS (0.003s) [303.256231] Starting dynamic subtest: bcs0-smem [303.258339] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [303.272551] Starting dynamic subtest: vcs0-smem [303.274682] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [303.288418] Starting dynamic subtest: vcs1-smem [303.290521] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [303.306027] Starting dynamic subtest: vecs0-smem [303.308917] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [303.323377] Starting dynamic subtest: ccs0-smem [303.325789] Dynamic subtest ccs0-smem: SUCCESS (0.001s) [303.328088] Subtest basic: SUCCESS (0.016s) [304.451542] [074/142] (719s left) kms_flip (plain-flip-interruptible) [304.562565] Starting subtest: plain-flip-interruptible [304.571469] Starting dynamic subtest: A-eDP1 [306.433744] Dynamic subtest A-eDP1: SUCCESS (1.862s) [306.457652] Starting dynamic subtest: B-eDP1 [308.228756] Dynamic subtest B-eDP1: SUCCESS (1.791s) [308.249716] Starting dynamic subtest: C-eDP1 [310.005268] Dynamic subtest C-eDP1: SUCCESS (1.778s) [310.022023] Starting dynamic subtest: D-eDP1 [311.798095] Dynamic subtest D-eDP1: SUCCESS (1.791s) [311.806211] Subtest plain-flip-interruptible: SUCCESS (7.244s) [313.131050] [075/142] (711s left) kms_ccs (pipe-b-bad-aux-stride-4_tiled_mtl_rc_ccs_cc) [313.638826] Starting subtest: pipe-B-bad-aux-stride-4_tiled_mtl_rc_ccs_cc [313.642093] Subtest pipe-B-bad-aux-stride-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.001s) [314.461869] [076/142] (709s left) kms_flip (flip-vs-fences-interruptible) [314.568470] Starting subtest: flip-vs-fences-interruptible [314.573230] Subtest flip-vs-fences-interruptible: SKIP (0.000s) [314.648492] [077/142] (709s left) perf (global-sseu-config) [314.849052] Subtest global-sseu-config: SKIP (0.000s) [314.881321] [078/142] (709s left) kms_atomic_transition (plane-all-transition) [315.004036] Starting subtest: plane-all-transition [315.006674] Starting dynamic subtest: pipe-A-eDP-1 [317.540527] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.536s) [317.878922] Starting dynamic subtest: pipe-B-eDP-1 [321.167676] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.304s) [321.479755] Subtest plane-all-transition: SUCCESS (6.475s) [322.409243] [079/142] (702s left) v3d/v3d_perfmon (get-values-invalid-perfmon) [322.548129] Subtest get-values-invalid-perfmon: SKIP (0.000s) [322.601236] [080/142] (701s left) kms_flip (absolute-wf_vblank) [322.701639] Starting subtest: absolute-wf_vblank [322.708813] Starting dynamic subtest: A-eDP1 [331.665854] Dynamic subtest A-eDP1: SUCCESS (8.956s) [331.682100] Starting dynamic subtest: B-eDP1 [340.561242] Dynamic subtest B-eDP1: SUCCESS (8.894s) [340.581451] Starting dynamic subtest: C-eDP1 [349.459119] Dynamic subtest C-eDP1: SUCCESS (8.896s) [349.475267] Starting dynamic subtest: D-eDP1 [358.345350] Dynamic subtest D-eDP1: SUCCESS (8.882s) [358.351918] Subtest absolute-wf_vblank: SUCCESS (35.652s) [359.657209] [081/142] (664s left) kms_ccs (pipe-d-random-ccs-data-yf_tiled_ccs) [360.242766] Starting subtest: pipe-D-random-ccs-data-yf_tiled_ccs [360.253517] Subtest pipe-D-random-ccs-data-yf_tiled_ccs: SKIP (0.000s) [360.991575] [082/142] (663s left) gem_render_copy (y-tiled-ccs-to-x-tiled) [361.089236] Starting subtest: y-tiled-ccs-to-x-tiled [361.094374] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s) [361.275612] [083/142] (663s left) kms_rotation_crc (primary-x-tiled-reflect-x-180) [361.397037] Starting subtest: primary-x-tiled-reflect-x-180 [369.408354] Subtest primary-x-tiled-reflect-x-180: SUCCESS (8.012s) [370.729744] [084/142] (653s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs) [371.279531] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs [373.147318] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs: SUCCESS (1.866s) [374.359584] [085/142] (650s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt) [374.497721] Starting subtest: fbc-farfromfence-mmap-gtt [374.502481] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s) [374.579477] [086/142] (650s left) kms_content_protection (lic) [374.795053] Starting subtest: LIC [378.493164] Subtest LIC: SKIP (3.693s) [379.815946] [087/142] (644s left) gem_ctx_param (invalid-ctx-get) [379.906555] Starting subtest: invalid-ctx-get [379.909226] Subtest invalid-ctx-get: SUCCESS (0.000s) [379.978210] [088/142] (644s left) kms_ccs (pipe-b-crc-sprite-planes-basic-yf_tiled_ccs) [380.485519] Starting subtest: pipe-B-crc-sprite-planes-basic-yf_tiled_ccs [380.496537] Subtest pipe-B-crc-sprite-planes-basic-yf_tiled_ccs: SKIP (0.004s) [381.304258] [089/142] (643s left) gem_eio (in-flight-contexts-10ms) [381.865331] Starting subtest: in-flight-contexts-10ms [407.482673] Subtest in-flight-contexts-10ms: SUCCESS (25.617s) [409.475658] [090/142] (615s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt) [409.611108] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt [409.616205] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [409.705251] [091/142] (615s left) gem_lmem_swapping (heavy-multi) [409.803023] Subtest heavy-multi: SKIP (0.000s) [409.846220] [092/142] (615s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [409.943287] Starting subtest: x-tiled-to-vebox-y-tiled [409.948407] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s) [410.131257] [093/142] (614s left) syncobj_wait (single-wait-all-signaled) [410.219802] Starting subtest: single-wait-all-signaled [410.222314] Subtest single-wait-all-signaled: SUCCESS (0.000s) [410.289741] [094/142] (614s left) kms_atomic_interruptible (legacy-dpms) [410.411703] Starting subtest: legacy-dpms [410.413948] Starting dynamic subtest: eDP-1-pipe-A [417.921381] Dynamic subtest eDP-1-pipe-A: SUCCESS (7.506s) [417.924092] Subtest legacy-dpms: SUCCESS (7.509s) [418.793662] [095/142] (606s left) dmabuf_sync_file (export-basic) [418.893714] Starting subtest: export-basic [418.896393] Subtest export-basic: SUCCESS (0.001s) [418.949035] [096/142] (606s left) kms_psr (psr2_cursor_render) [419.072088] Starting subtest: psr2_cursor_render [420.944437] Subtest psr2_cursor_render: SUCCESS (1.871s) [421.864990] [097/142] (603s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [422.000132] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt [422.005241] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [422.086458] [098/142] (603s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt) [422.218201] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt [422.223076] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [422.308039] [099/142] (602s left) api_intel_allocator (alloc-simple) [422.396521] Starting subtest: alloc-simple [422.399278] Subtest alloc-simple: SUCCESS (0.003s) [422.493232] [100/142] (602s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt) [422.627812] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt [428.222816] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (5.597s) [428.364359] [101/142] (596s left) gem_exec_params (invalid-bsd2-flag-on-blt) [428.463748] Starting subtest: invalid-bsd2-flag-on-blt [428.466535] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s) [428.556162] [102/142] (596s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen) [428.692719] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen [432.120721] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.429s) [432.257053] [103/142] (593s left) kms_chamelium_hpd (hdmi-hpd-storm) [432.687309] Subtest hdmi-hpd-storm: SKIP (0.000s) [433.543796] [104/142] (591s left) kms_ccs (pipe-b-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc) [434.025206] Starting subtest: pipe-B-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc [434.032831] Subtest pipe-B-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc: SKIP (0.001s) [434.867007] [105/142] (590s left) prime_self_import (basic-llseek-bad) [434.950687] Starting subtest: basic-llseek-bad [434.956076] Subtest basic-llseek-bad: SUCCESS (0.004s) [435.046133] [106/142] (590s left) perf_pmu (gt-awake) [435.138734] Starting subtest: gt-awake [443.388929] Subtest gt-awake: SUCCESS (8.249s) [443.492193] [107/142] (581s left) kms_ccs (pipe-c-bad-rotation-90-yf_tiled_ccs) [444.017825] Starting subtest: pipe-C-bad-rotation-90-yf_tiled_ccs [444.023674] Subtest pipe-C-bad-rotation-90-yf_tiled_ccs: SKIP (0.000s) [444.824265] [108/142] (580s left) i915_pm_rpm (basic-rte) [444.912065] Starting subtest: basic-rte [451.088915] Subtest basic-rte: SUCCESS (6.176s) [456.214943] [109/142] (569s left) kms_big_fb (linear-64bpp-rotate-0) [456.365732] Starting subtest: linear-64bpp-rotate-0 [458.845256] Subtest linear-64bpp-rotate-0: SUCCESS (2.481s) [459.077266] [110/142] (566s left) kms_dsc (dsc-with-output-formats-with-bpc) [459.200657] Starting subtest: dsc-with-output-formats-with-bpc [459.205413] Subtest dsc-with-output-formats-with-bpc: SKIP (0.003s) [459.277021] [111/142] (566s left) kms_big_fb (x-tiled-64bpp-rotate-180) [459.427422] Starting subtest: x-tiled-64bpp-rotate-180 [461.864101] Subtest x-tiled-64bpp-rotate-180: SUCCESS (2.436s) [462.147245] [112/142] (563s left) gem_exec_balancer (fairslice) [462.242900] Starting subtest: fairslice [465.382422] Subtest fairslice: SUCCESS (3.138s) [465.671654] [113/142] (560s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0) [465.826620] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0 [465.831731] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s) [465.912084] [114/142] (559s left) kms_dsc (dsc-with-bpc-formats) [466.036826] Starting subtest: dsc-with-bpc-formats [466.044634] Subtest dsc-with-bpc-formats: SKIP (0.006s) [466.116110] [115/142] (559s left) vgem_basic (unload) [466.203287] Starting subtest: unload [495.193615] Subtest unload: SUCCESS (28.988s) [495.304670] [116/142] (530s left) kms_big_fb (4-tiled-32bpp-rotate-0) [495.454218] Starting subtest: 4-tiled-32bpp-rotate-0 [497.214939] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.761s) [497.480744] [117/142] (528s left) kms_atomic (plane-primary-overlay-mutable-zpos) [497.697334] Starting subtest: plane-primary-overlay-mutable-zpos [497.705329] Subtest plane-primary-overlay-mutable-zpos: SKIP (0.001s) [498.923744] [118/142] (526s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling) [499.050047] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling [499.052686] Starting dynamic subtest: pipe-A-default-mode [502.047132] Dynamic subtest pipe-A-default-mode: SUCCESS (2.993s) [502.049847] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.997s) [502.944776] [119/142] (522s left) gem_ctx_exec (basic) [503.037615] Starting subtest: basic [503.040241] Subtest basic: SUCCESS (0.005s) [503.151107] [120/142] (522s left) i915_power (sanity) [503.236393] Starting subtest: sanity [507.266754] Subtest sanity: SUCCESS (4.021s) [508.495489] [121/142] (517s left) kms_hdr (static-toggle) [508.627017] Starting subtest: static-toggle [508.631921] Subtest static-toggle: SKIP (0.000s) [508.700123] [122/142] (517s left) gem_exec_whisper (basic-contexts) [508.801032] Starting subtest: basic-contexts [516.503282] Subtest basic-contexts: SUCCESS (7.697s) [516.690548] [123/142] (509s left) gem_ctx_persistence (legacy-engines-mixed-process) [516.787787] Starting subtest: legacy-engines-mixed-process [516.791021] Starting dynamic subtest: render [518.437885] Dynamic subtest render: SUCCESS (1.647s) [518.457226] Starting dynamic subtest: bsd1 [538.499075] Dynamic subtest bsd1: SUCCESS (20.063s) [538.517912] Starting dynamic subtest: bsd2 [558.556849] Dynamic subtest bsd2: SUCCESS (20.055s) [558.575854] Starting dynamic subtest: blt [560.350763] Dynamic subtest blt: SUCCESS (1.792s) [560.369688] Starting dynamic subtest: vebox [580.406677] Dynamic subtest vebox: SUCCESS (20.054s) [580.409754] Subtest legacy-engines-mixed-process: SUCCESS (63.622s) [580.492541] [124/142] (445s left) gem_exec_schedule (lateslice) [580.604253] Starting subtest: lateslice [580.606814] Starting dynamic subtest: rcs0 [580.623784] Dynamic subtest rcs0: SUCCESS (0.024s) [580.641830] Starting dynamic subtest: bcs0 [580.648132] Dynamic subtest bcs0: SUCCESS (0.022s) [580.666323] Starting dynamic subtest: vcs0 [580.669144] Dynamic subtest vcs0: SUCCESS (0.019s) [580.686782] Starting dynamic subtest: vcs1 [580.689622] Dynamic subtest vcs1: SUCCESS (0.018s) [580.708453] Starting dynamic subtest: vecs0 [580.711843] Dynamic subtest vecs0: SUCCESS (0.018s) [580.730625] Starting dynamic subtest: ccs0 [580.733546] Dynamic subtest ccs0: SUCCESS (0.021s) [580.736053] Subtest lateslice: SUCCESS (0.132s) [582.500378] [125/142] (443s left) gem_exercise_blt (fast-copy-emit) [582.594269] Starting subtest: fast-copy-emit [582.596841] Starting dynamic subtest: linear-smem-smem-emit [582.647662] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.052s) [582.665374] Starting dynamic subtest: xmajor-smem-smem-emit [582.696835] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.046s) [582.713662] Starting dynamic subtest: tile4-smem-smem-emit [582.740298] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.043s) [582.757922] Starting dynamic subtest: tile64-smem-smem-emit [582.783815] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.042s) [582.786681] Subtest fast-copy-emit: SUCCESS (0.190s) [582.892130] [126/142] (443s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled) [582.984846] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled [582.987529] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s) [583.062235] [127/142] (443s left) i915_hangman (engine-engine-hang) [583.169712] Starting subtest: engine-engine-hang [583.172305] Starting dynamic subtest: rcs0 [584.380681] Dynamic subtest rcs0: SUCCESS (1.210s) [584.399262] Starting dynamic subtest: bcs0 [586.427437] Dynamic subtest bcs0: SUCCESS (2.045s) [586.446641] Starting dynamic subtest: vcs0 [596.701364] Dynamic subtest vcs0: FAIL (10.189s) [596.718848] Starting dynamic subtest: vcs1 [598.396525] Dynamic subtest vcs1: SUCCESS (1.777s) [598.415530] Starting dynamic subtest: vecs0 [600.380374] Dynamic subtest vecs0: SUCCESS (1.982s) [600.399491] Starting dynamic subtest: ccs0 [602.428116] Dynamic subtest ccs0: SUCCESS (2.046s) [602.432401] Subtest engine-engine-hang: FAIL (19.260s) [602.517805] [128/142] (423s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-wc) [602.660043] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-wc [605.950823] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (3.296s) [606.098773] [129/142] (420s left) syncobj_timeline (single-wait-signaled) [606.188685] Starting subtest: single-wait-signaled [606.191437] Subtest single-wait-signaled: SUCCESS (0.001s) [606.262183] [130/142] (420s left) kms_ccs (pipe-c-bad-aux-stride-4_tiled_mtl_rc_ccs) [606.806685] Starting subtest: pipe-C-bad-aux-stride-4_tiled_mtl_rc_ccs [606.810182] Subtest pipe-C-bad-aux-stride-4_tiled_mtl_rc_ccs: SUCCESS (0.001s) [607.589759] [131/142] (418s left) gem_exec_schedule (preempt-queue) [607.700598] Subtest preempt-queue: SKIP (0.000s) [608.005568] [132/142] (418s left) kms_vblank (pipe-d-ts-continuation-idle) [608.125619] Starting subtest: pipe-D-ts-continuation-idle [609.721488] Subtest pipe-D-ts-continuation-idle: SUCCESS (1.597s) [610.669952] [133/142] (415s left) kms_plane_alpha_blend (alpha-transparent-fb) [610.796106] Starting subtest: alpha-transparent-fb [611.307568] Starting dynamic subtest: pipe-A-eDP-1 [612.057480] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.746s) [612.078705] Starting dynamic subtest: pipe-D-eDP-1 [613.575781] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.516s) [613.578019] Subtest alpha-transparent-fb: SUCCESS (2.780s) [614.476562] [134/142] (411s left) kms_cursor_crc (cursor-onscreen-512x512) [614.800204] Starting subtest: cursor-onscreen-512x512 [614.805501] Subtest cursor-onscreen-512x512: SKIP (0.002s) [614.954650] [135/142] (411s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [615.064248] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [615.122751] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.054s) [615.209763] [136/142] (411s left) gem_eio (in-flight-suspend) [615.678409] Starting subtest: in-flight-suspend [659.533363] Subtest in-flight-suspend: SUCCESS (14.119s) [661.168638] [137/142] (395s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [661.303264] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu [661.307891] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [661.402145] [138/142] (394s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc) [661.529225] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc [667.135044] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (5.608s) [667.268165] [139/142] (389s left) kms_scaling_modes (scaling-mode-none) [667.396237] Starting subtest: scaling-mode-none [667.402162] Starting dynamic subtest: eDP-1-pipe-A [667.548522] Dynamic subtest eDP-1-pipe-A: SKIP (0.149s) [667.568161] Starting dynamic subtest: eDP-1-pipe-B [667.612485] Dynamic subtest eDP-1-pipe-B: SKIP (0.061s) [667.630623] Starting dynamic subtest: eDP-1-pipe-C [667.674622] Dynamic subtest eDP-1-pipe-C: SKIP (0.060s) [667.692667] Starting dynamic subtest: eDP-1-pipe-D [667.736116] Dynamic subtest eDP-1-pipe-D: SKIP (0.058s) [667.742267] Subtest scaling-mode-none: SKIP (0.340s) [667.840897] [140/142] (388s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_dg2_mc_ccs) [668.374140] Starting subtest: pipe-C-random-ccs-data-4_tiled_dg2_mc_ccs [668.381997] Subtest pipe-C-random-ccs-data-4_tiled_dg2_mc_ccs: SKIP (0.000s) [669.167568] [141/142] (387s left) vgem_basic (bad-flag) [669.269825] Starting subtest: bad-flag [669.273026] Subtest bad-flag: SUCCESS (0.000s) [669.328673] [142/142] (387s left) sw_sync (sync_merge_invalid) [669.412645] Starting subtest: sync_merge_invalid [669.419590] Subtest sync_merge_invalid: SUCCESS (0.004s) [669.461854] Closing watchdogs Done.