[55.548308] Initializing watchdogs
[55.548723]   /dev/watchdog0
[55.582133] [001/141] (960s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[56.120583] Starting subtest: modeset-transition-nonblocking-fencing
[56.124324] Starting dynamic subtest: 1x-outputs
[83.661152] Dynamic subtest 1x-outputs: SUCCESS (27.543s)
[83.983569] Subtest modeset-transition-nonblocking-fencing: SUCCESS (27.862s)
[84.957882] [002/141] (931s left) drm_fdinfo (all-busy-check-all)
[85.385192] Starting subtest: all-busy-check-all
[85.400172] Subtest all-busy-check-all: SKIP (0.012s)
[85.526325] [003/141] (930s left) kms_ccs (pipe-b-ccs-on-another-bo-yf_tiled_ccs)
[86.840587] Starting subtest: pipe-B-ccs-on-another-bo-yf_tiled_ccs
[86.846903] Subtest pipe-B-ccs-on-another-bo-yf_tiled_ccs: SKIP (0.000s)
[87.972580] [004/141] (928s left) perf_pmu (most-busy-check-all)
[88.361891] Starting subtest: most-busy-check-all
[88.365797] Starting dynamic subtest: rcs0
[89.529254] Dynamic subtest rcs0: SUCCESS (1.165s)
[89.567942] Starting dynamic subtest: bcs0
[91.514537] Dynamic subtest bcs0: SUCCESS (1.985s)
[91.550367] Starting dynamic subtest: vcs0
[93.496646] Dynamic subtest vcs0: SUCCESS (1.979s)
[93.528774] Starting dynamic subtest: vcs1
[95.543514] Dynamic subtest vcs1: SUCCESS (2.045s)
[95.576886] Starting dynamic subtest: vecs0
[97.528108] Dynamic subtest vecs0: SUCCESS (1.983s)
[97.561182] Starting dynamic subtest: ccs0
[99.512725] Dynamic subtest ccs0: SUCCESS (1.983s)
[99.516546] Subtest most-busy-check-all: SUCCESS (11.150s)
[99.689661] [005/141] (916s left) prime_vgem (basic-fence-flip)
[100.248843] Starting subtest: basic-fence-flip
[101.003269] Subtest basic-fence-flip: SUCCESS (0.755s)
[101.180189] [006/141] (915s left) gem_exec_schedule (preempt-engines)
[101.626343] Starting subtest: preempt-engines
[101.629945] Starting dynamic subtest: rcs0
[104.160359] Dynamic subtest rcs0: SUCCESS (2.533s)
[104.191278] Starting dynamic subtest: bcs0
[106.650364] Dynamic subtest bcs0: SUCCESS (2.486s)
[106.683238] Starting dynamic subtest: vcs0
[109.102422] Dynamic subtest vcs0: SUCCESS (2.449s)
[109.135488] Starting dynamic subtest: vcs1
[111.548102] Dynamic subtest vcs1: SUCCESS (2.445s)
[111.583254] Starting dynamic subtest: vecs0
[113.988644] Dynamic subtest vecs0: SUCCESS (2.437s)
[114.023472] Starting dynamic subtest: ccs0
[116.524097] Dynamic subtest ccs0: SUCCESS (2.534s)
[116.527697] Subtest preempt-engines: SUCCESS (14.897s)
[117.114333] [007/141] (899s left) kms_scaling_modes (scaling-mode-center)
[117.608166] Starting subtest: scaling-mode-center
[117.616893] Starting dynamic subtest: eDP-1-pipe-A
[117.979749] Dynamic subtest eDP-1-pipe-A: SUCCESS (0.366s)
[118.018193] Starting dynamic subtest: eDP-1-pipe-B
[119.634929] Dynamic subtest eDP-1-pipe-B: SUCCESS (1.648s)
[119.677278] Starting dynamic subtest: eDP-1-pipe-C
[121.308316] Dynamic subtest eDP-1-pipe-C: SUCCESS (1.664s)
[121.326835] Starting dynamic subtest: eDP-1-pipe-D
[123.024357] Dynamic subtest eDP-1-pipe-D: SUCCESS (1.708s)
[123.028226] Subtest scaling-mode-center: SUCCESS (5.418s)
[124.543806] [008/141] (892s left) prime_mmap_coherency (read)
[124.947791] Starting subtest: read
[130.343282] Subtest read: SUCCESS (5.397s)
[130.517827] [009/141] (886s left) gem_exec_balancer (parallel-ordering)
[131.756649] Starting subtest: parallel-ordering
[137.632651] Subtest parallel-ordering: SUCCESS (5.875s)
[137.827441] [010/141] (878s left) kms_ccs (pipe-b-bad-aux-stride-y_tiled_gen12_rc_ccs_cc)
[139.153674] Starting subtest: pipe-B-bad-aux-stride-y_tiled_gen12_rc_ccs_cc
[139.160073] Subtest pipe-B-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[140.254973] [011/141] (876s left) i915_hangman (gt-error-state-capture)
[140.674811] Starting subtest: gt-error-state-capture
[140.678614] Starting dynamic subtest: rcs0
[152.505094] Dynamic subtest rcs0: SUCCESS (11.829s)
[152.542971] Starting dynamic subtest: bcs0
[164.537420] Dynamic subtest bcs0: SUCCESS (12.030s)
[164.577104] Starting dynamic subtest: vcs0
[170.488714] Dynamic subtest vcs0: SUCCESS (5.950s)
[170.526585] Starting dynamic subtest: vcs1
[176.506131] Dynamic subtest vcs1: SUCCESS (6.015s)
[176.545709] Starting dynamic subtest: vecs0
[182.522089] Dynamic subtest vecs0: SUCCESS (6.013s)
[182.559458] Starting dynamic subtest: ccs0
[194.554579] Dynamic subtest ccs0: SUCCESS (12.031s)
[194.558793] Subtest gt-error-state-capture: SUCCESS (53.880s)
[194.736435] [012/141] (822s left) gem_mmap_gtt (basic-read)
[195.122801] Subtest basic-read: SKIP (0.000s)
[195.247471] [013/141] (821s left) kms_ccs (pipe-d-crc-primary-rotation-180-y_tiled_gen12_mc_ccs)
[196.864592] Starting subtest: pipe-D-crc-primary-rotation-180-y_tiled_gen12_mc_ccs
[196.870592] Subtest pipe-D-crc-primary-rotation-180-y_tiled_gen12_mc_ccs: SKIP (0.002s)
[197.569120] [014/141] (819s left) v3d/v3d_perfmon (create-single-perfmon)
[198.064500] Subtest create-single-perfmon: SKIP (0.000s)
[198.188402] [015/141] (818s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[198.575920] Starting subtest: invalid-single-wait-unsubmitted
[198.580192] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.001s)
[198.713367] [016/141] (818s left) kms_vblank (pipe-d-wait-forked-busy)
[199.205553] Starting subtest: pipe-D-wait-forked-busy
[203.755871] Subtest pipe-D-wait-forked-busy: SUCCESS (4.551s)
[204.695516] [017/141] (812s left) i915_pm_sseu (full-enable)
[205.096647] Subtest full-enable: SKIP (0.000s)
[205.229621] [018/141] (812s left) gem_linear_blits (normal)
[208.531071] Starting subtest: normal
[230.740501] Subtest normal: SUCCESS (22.208s)
[230.922396] [019/141] (786s left) gem_userptr_blits (dmabuf-sync)
[231.520698] Starting subtest: dmabuf-sync
[231.531657] Subtest dmabuf-sync: SKIP (0.012s)
[231.791077] [020/141] (785s left) kms_ccs (pipe-a-crc-primary-basic-y_tiled_gen12_mc_ccs)
[232.721874] Starting subtest: pipe-A-crc-primary-basic-y_tiled_gen12_mc_ccs
[232.728825] Subtest pipe-A-crc-primary-basic-y_tiled_gen12_mc_ccs: SKIP (0.003s)
[234.093791] [021/141] (783s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[234.658802] Starting subtest: yf-tiled-addfb-size-overflow
[234.665796] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[234.825561] [022/141] (782s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_ccs)
[235.823423] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_ccs
[235.829912] Subtest pipe-A-missing-ccs-buffer-y_tiled_ccs: SKIP (0.000s)
[237.225941] [023/141] (780s left) gem_ctx_persistence (legacy-engines-hostile)
[237.624146] Starting subtest: legacy-engines-hostile
[237.627959] Starting dynamic subtest: render
[237.687421] Dynamic subtest render: SUCCESS (0.062s)
[237.731951] Starting dynamic subtest: bsd1
[237.745941] Dynamic subtest bsd1: SUCCESS (0.055s)
[237.786424] Starting dynamic subtest: bsd2
[237.789454] Dynamic subtest bsd2: SUCCESS (0.033s)
[237.826705] Starting dynamic subtest: blt
[237.830435] Dynamic subtest blt: SUCCESS (0.045s)
[237.868676] Starting dynamic subtest: vebox
[237.878926] Dynamic subtest vebox: SUCCESS (0.040s)
[237.882604] Subtest legacy-engines-hostile: SUCCESS (0.251s)
[238.045627] [024/141] (779s left) kms_vblank (pipe-a-query-forked-busy)
[238.526438] Starting subtest: pipe-A-query-forked-busy
[240.913636] Subtest pipe-A-query-forked-busy: SUCCESS (2.387s)
[241.858217] [025/141] (776s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[242.329218] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[242.332229] Starting dynamic subtest: pipe-A-eDP-1
[242.371121] Dynamic subtest pipe-A-eDP-1: SKIP (0.034s)
[242.409985] Starting dynamic subtest: pipe-B-eDP-1
[242.500185] Dynamic subtest pipe-B-eDP-1: SKIP (0.122s)
[242.547382] Starting dynamic subtest: pipe-C-eDP-1
[242.654195] Dynamic subtest pipe-C-eDP-1: SKIP (0.142s)
[242.698184] Starting dynamic subtest: pipe-D-eDP-1
[242.814083] Dynamic subtest pipe-D-eDP-1: SKIP (0.152s)
[242.821290] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.484s)
[242.980105] [026/141] (774s left) gem_exec_params (invalid-batch-start-offset)
[243.383517] Starting subtest: invalid-batch-start-offset
[243.406934] Subtest invalid-batch-start-offset: SUCCESS (0.021s)
[243.584318] [027/141] (774s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[244.101836] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[244.108987] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[244.276375] [028/141] (773s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[244.779101] Starting subtest: psr-rgb565-draw-mmap-cpu
[257.529683] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (12.755s)
[257.820615] [029/141] (760s left) gem_exec_balancer (bonded-semaphore)
[258.250425] Starting subtest: bonded-semaphore
[258.257777] Subtest bonded-semaphore: SKIP (0.000s)
[259.245562] [030/141] (759s left) gem_mmap_gtt (hang-busy)
[259.626591] Subtest hang-busy: SKIP (0.000s)
[259.742734] [031/141] (758s left) kms_ccs (pipe-d-bad-rotation-90-y_tiled_gen12_rc_ccs_cc)
[261.340750] Starting subtest: pipe-D-bad-rotation-90-y_tiled_gen12_rc_ccs_cc
[261.347143] Subtest pipe-D-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[262.137925] [032/141] (756s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[262.695554] Starting subtest: flip-vs-cursor-atomic-transitions
[269.353849] Subtest flip-vs-cursor-atomic-transitions: FAIL (5.965s)
[269.552575] [033/141] (749s left) gem_exec_fence (submit)
[270.140129] Starting subtest: submit
[270.145583] Subtest submit: SKIP (0.000s)
[272.060619] [034/141] (746s left) api_intel_allocator (simple-allocator)
[272.444790] Starting subtest: simple-allocator
[272.448300] Starting dynamic subtest: basic
[272.456719] Dynamic subtest basic: SUCCESS (0.017s)
[272.495758] Starting dynamic subtest: parallel-one
[273.107171] Dynamic subtest parallel-one: SUCCESS (0.646s)
[273.151818] Starting dynamic subtest: print
[273.155295] Dynamic subtest print: SUCCESS (0.000s)
[273.179917] Starting dynamic subtest: reuse
[273.182740] Dynamic subtest reuse: SUCCESS (0.001s)
[273.207499] Starting dynamic subtest: reserve
[273.210621] Dynamic subtest reserve: SUCCESS (0.000s)
[273.257123] Starting dynamic subtest: fork-reopen-allocator
[273.260000] Dynamic subtest fork-reopen-allocator: SUCCESS (0.080s)
[273.262881] Subtest simple-allocator: SUCCESS (0.764s)
[273.383820] [035/141] (745s left) gem_exec_flush (basic-wb-pro-default)
[273.812582] Starting subtest: basic-wb-pro-default
[279.693055] Subtest basic-wb-pro-default: SUCCESS (5.884s)
[279.990536] [036/141] (738s left) kms_vblank (pipe-a-wait-idle-hang)
[280.471225] Starting subtest: pipe-A-wait-idle-hang
[294.819892] Subtest pipe-A-wait-idle-hang: SUCCESS (14.351s)
[295.780242] [037/141] (723s left) sysfs_timeslice_duration (timeout)
[296.180672] Starting subtest: timeout
[296.184365] Starting dynamic subtest: vecs0
[305.552503] Dynamic subtest vecs0: SUCCESS (9.366s)
[305.597889] Starting dynamic subtest: ccs0
[308.276281] Dynamic subtest ccs0: SUCCESS (2.721s)
[308.322744] Starting dynamic subtest: vcs0
[317.521200] Dynamic subtest vcs0: SUCCESS (9.239s)
[317.570808] Starting dynamic subtest: bcs0
[320.187644] Dynamic subtest bcs0: SUCCESS (2.664s)
[320.233367] Starting dynamic subtest: rcs0
[323.024529] Dynamic subtest rcs0: SUCCESS (2.833s)
[323.068991] Starting dynamic subtest: vcs1
[332.565610] Dynamic subtest vcs1: SUCCESS (9.533s)
[332.569411] Subtest timeout: SUCCESS (36.383s)
[332.741446] [038/141] (686s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[333.261832] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[333.269000] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[333.439292] [039/141] (685s left) gem_ctx_exec (basic-invalid-context)
[333.771227] Starting subtest: basic-invalid-context
[333.780164] Subtest basic-invalid-context: SUCCESS (0.009s)
[333.935557] [040/141] (685s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[334.335170] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[334.338676] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.002s)
[334.488121] [041/141] (684s left) kms_chamelium_edid (dp-edid-resolution-list)
[335.365723] Subtest dp-edid-resolution-list: SKIP (0.000s)
[336.234773] [042/141] (683s left) gem_mmap_wc (write-wc-read-gtt)
[336.616128] Subtest write-wc-read-gtt: SKIP (0.000s)
[336.733750] [043/141] (682s left) prime_vgem (basic-write)
[337.153099] Starting subtest: basic-write
[337.185515] Subtest basic-write: SKIP (0.030s)
[337.370328] [044/141] (682s left) kms_color (legacy-gamma-reset)
[337.851567] Starting subtest: legacy-gamma-reset
[337.854930] Starting dynamic subtest: pipe-A
[340.153172] Dynamic subtest pipe-A: SUCCESS (2.297s)
[340.199059] Starting dynamic subtest: pipe-B
[342.047558] Dynamic subtest pipe-B: SUCCESS (1.892s)
[342.092449] Starting dynamic subtest: pipe-C
[343.974541] Dynamic subtest pipe-C: SUCCESS (1.920s)
[344.018173] Starting dynamic subtest: pipe-D
[344.718705] Dynamic subtest pipe-D: SUCCESS (0.742s)
[344.722168] Subtest legacy-gamma-reset: SUCCESS (6.867s)
[345.086927] [045/141] (674s left) kms_ccs (pipe-d-bad-aux-stride-4_tiled_mtl_mc_ccs)
[346.861296] Starting subtest: pipe-D-bad-aux-stride-4_tiled_mtl_mc_ccs
[347.360711] Subtest pipe-D-bad-aux-stride-4_tiled_mtl_mc_ccs: SUCCESS (0.500s)
[347.976171] [046/141] (671s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[348.488061] Starting subtest: fbcpsr-rgb565-draw-pwrite
[361.635720] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (13.153s)
[361.805326] [047/141] (657s left) kms_addfb_basic (bad-pitch-999)
[361.956923] Starting subtest: bad-pitch-999
[361.960135] Subtest bad-pitch-999: SUCCESS (0.000s)
[362.237266] [048/141] (657s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[362.748447] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu
[374.773297] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (12.030s)
[375.033980] [049/141] (644s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[375.448492] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[375.621401] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.169s)
[375.800166] [050/141] (644s left) kms_fbcon_fbt (fbc-suspend)
[376.203423] Starting subtest: fbc-suspend
[425.272192] Subtest fbc-suspend: SUCCESS (49.063s)
[425.480487] [051/141] (594s left) kms_ccs (pipe-c-bad-aux-stride-y_tiled_gen12_rc_ccs_cc)
[427.019055] Starting subtest: pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs_cc
[427.025347] Subtest pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[427.889233] [052/141] (592s left) kms_big_fb (linear-32bpp-rotate-270)
[428.427295] Starting subtest: linear-32bpp-rotate-270
[428.489299] Subtest linear-32bpp-rotate-270: SKIP (0.054s)
[428.677674] [053/141] (591s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[429.198561] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[439.841721] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (10.647s)
[440.124348] [054/141] (580s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs)
[441.674325] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs
[462.606618] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs: SUCCESS (20.930s)
[463.955949] [055/141] (556s left) api_intel_allocator (gem-pool)
[464.324797] Starting subtest: gem-pool
[464.355149] Subtest gem-pool: SUCCESS (0.031s)
[464.537780] [056/141] (555s left) syncobj_timeline (etime-single-wait-all-submitted)
[464.918125] Starting subtest: etime-single-wait-all-submitted
[465.022340] Subtest etime-single-wait-all-submitted: SUCCESS (0.105s)
[465.178483] [057/141] (555s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[465.715407] Starting subtest: y-tiled-8bpp-rotate-0
[465.722397] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[465.910280] [058/141] (554s left) kms_psr (sprite_plane_onoff)
[466.402557] Starting subtest: sprite_plane_onoff
[469.531826] Subtest sprite_plane_onoff: SUCCESS (3.129s)
[470.482370] [059/141] (550s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[470.968579] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[470.974781] Starting dynamic subtest: pipe-A-default-mode
[471.391357] Dynamic subtest pipe-A-default-mode: SKIP (0.410s)
[471.398412] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.423s)
[472.334198] [060/141] (548s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_mtl_rc_ccs_cc)
[474.055585] Starting subtest: pipe-D-random-ccs-data-4_tiled_mtl_rc_ccs_cc
[475.256349] Subtest pipe-D-random-ccs-data-4_tiled_mtl_rc_ccs_cc: SUCCESS (1.201s)
[476.691341] [061/141] (544s left) kms_plane_scaling (plane-upscale-with-rotation-20x20)
[477.179286] Starting subtest: plane-upscale-with-rotation-20x20
[477.189787] Starting dynamic subtest: pipe-A-eDP-1
[477.994150] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.809s)
[478.058635] Starting dynamic subtest: pipe-B-eDP-1
[480.206215] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.201s)
[480.268595] Starting dynamic subtest: pipe-C-eDP-1
[482.347576] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.129s)
[482.412172] Starting dynamic subtest: pipe-D-eDP-1
[484.546121] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.188s)
[484.549570] Subtest plane-upscale-with-rotation-20x20: SUCCESS (7.373s)
[486.102328] [062/141] (534s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[486.642546] Starting subtest: yf-tiled-32bpp-rotate-270
[486.649771] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[486.824257] [063/141] (534s left) kms_flip (basic-flip-vs-wf_vblank)
[487.226860] Starting subtest: basic-flip-vs-wf_vblank
[487.253378] Starting dynamic subtest: A-eDP1
[489.746780] Dynamic subtest A-eDP1: SUCCESS (2.493s)
[489.804217] Starting dynamic subtest: B-eDP1
[492.088713] Dynamic subtest B-eDP1: SUCCESS (2.337s)
[492.143318] Starting dynamic subtest: C-eDP1
[494.440149] Dynamic subtest C-eDP1: SUCCESS (2.345s)
[494.494628] Starting dynamic subtest: D-eDP1
[496.766592] Dynamic subtest D-eDP1: SUCCESS (2.321s)
[496.793855] Subtest basic-flip-vs-wf_vblank: SUCCESS (9.572s)
[498.389680] [064/141] (522s left) gem_exec_capture (pi)
[498.806732] Starting subtest: pi
[498.811209] Starting dynamic subtest: rcs0
[510.775257] Dynamic subtest rcs0: SUCCESS (11.971s)
[510.795771] Starting dynamic subtest: bcs0
[521.235389] Dynamic subtest bcs0: SUCCESS (10.460s)
[521.251815] Starting dynamic subtest: vcs0
[539.132341] Dynamic subtest vcs0: SUCCESS (17.892s)
[539.181910] Starting dynamic subtest: vcs1
[555.914318] Dynamic subtest vcs1: SUCCESS (16.777s)
[555.969709] Starting dynamic subtest: vecs0
[568.938190] Dynamic subtest vecs0: SUCCESS (13.015s)
[568.982998] Starting dynamic subtest: ccs0
[581.021071] Dynamic subtest ccs0: SUCCESS (12.080s)
[581.024111] Subtest pi: SUCCESS (82.220s)
[581.175836] [065/141] (440s left) kms_plane_multiple (tiling-y)
[581.829136] Starting subtest: tiling-y
[581.835476] Subtest tiling-y: SKIP (0.000s)
[581.977535] [066/141] (439s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[582.396963] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[582.503169] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[582.661316] [067/141] (438s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[585.582269] Subtest verify-pxp-stale-buf-optout-execution: SKIP (0.000s)
[585.755984] [068/141] (435s left) core_auth (many-magics)
[586.123363] Starting subtest: many-magics
[589.137989] Subtest many-magics: SUCCESS (3.012s)
[589.538711] [069/141] (432s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[590.448046] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[591.325929] [070/141] (430s left) kms_cursor_crc (cursor-sliding-256x256)
[592.362451] Starting subtest: cursor-sliding-256x256
[592.397158] Starting dynamic subtest: pipe-A-eDP-1
[598.622679] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.227s)
[598.787712] Starting dynamic subtest: pipe-D-eDP-1
[604.273931] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.537s)
[604.276686] Subtest cursor-sliding-256x256: SUCCESS (11.913s)
[605.225378] [071/141] (416s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[605.730416] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[605.737057] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[605.912578] [072/141] (416s left) gem_exec_reloc (basic-wc-read)
[606.317736] Subtest basic-wc-read: SKIP (0.000s)
[606.460093] [073/141] (415s left) perf (non-sampling-read-error)
[607.390642] Starting subtest: non-sampling-read-error
[607.429829] Subtest non-sampling-read-error: SUCCESS (0.041s)
[607.549975] [074/141] (414s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[608.050379] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[608.057107] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[608.226476] [075/141] (414s left) debugfs_test (basic-hwmon)
[608.616525] Starting subtest: basic-hwmon
[608.623954] Subtest basic-hwmon: SKIP (0.000s)
[608.881391] [076/141] (413s left) kms_cursor_edge_walk (256x256-left-edge)
[609.374175] Starting subtest: 256x256-left-edge
[609.382914] Starting dynamic subtest: pipe-A-eDP-1
[613.168810] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.782s)
[613.226199] Starting dynamic subtest: pipe-D-eDP-1
[616.500299] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.329s)
[616.503938] Subtest 256x256-left-edge: SUCCESS (7.127s)
[617.456253] [077/141] (405s left) gem_workarounds (reset)
[617.924620] Starting subtest: reset
[619.420842] Subtest reset: SUCCESS (1.496s)
[619.621908] [078/141] (402s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[620.058357] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[620.225863] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.164s)
[620.404460] [079/141] (402s left) kms_sequence (get-forked-busy)
[620.892215] Starting subtest: get-forked-busy
[620.902831] Starting dynamic subtest: eDP-1-pipe-A
[623.464118] Dynamic subtest eDP-1-pipe-A: SUCCESS (2.561s)
[623.522148] Starting dynamic subtest: eDP-1-pipe-B
[626.794839] Dynamic subtest eDP-1-pipe-B: SUCCESS (3.318s)
[626.855681] Starting dynamic subtest: eDP-1-pipe-C
[630.369946] Dynamic subtest eDP-1-pipe-C: SUCCESS (3.568s)
[630.429190] Starting dynamic subtest: eDP-1-pipe-D
[634.177601] Dynamic subtest eDP-1-pipe-D: SUCCESS (3.799s)
[634.181138] Subtest get-forked-busy: SUCCESS (13.285s)
[635.141522] [080/141] (387s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc)
[636.505987] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc
[636.517245] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.013s)
[637.610766] [081/141] (385s left) gem_partial_pwrite_pread (reads-snoop)
[638.006429] Subtest reads-snoop: SKIP (0.000s)
[638.172667] [082/141] (384s left) gem_mmap_gtt (basic-read-write-distinct)
[638.561432] Subtest basic-read-write-distinct: SKIP (0.000s)
[638.691518] [083/141] (384s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[639.219810] Starting subtest: fbcpsr-1p-rte
[649.758205] Subtest fbcpsr-1p-rte: SUCCESS (10.545s)
[650.065472] [084/141] (373s left) gem_userptr_blits (access-control)
[650.577744] Starting subtest: access-control
[650.586382] Subtest access-control: SKIP (0.000s)
[650.772188] [085/141] (372s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[651.290106] Starting subtest: x-tiled-8bpp-rotate-0
[654.811532] Subtest x-tiled-8bpp-rotate-0: SUCCESS (3.519s)
[655.164698] [086/141] (368s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[655.733035] Starting subtest: cursor-vs-flip-atomic-transitions
[695.785146] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (40.049s)
[696.408688] [087/141] (327s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[696.988612] Starting subtest: cursorB-vs-flipA-varying-size
[697.005837] Subtest cursorB-vs-flipA-varying-size: SKIP (0.016s)
[697.355335] [088/141] (326s left) gem_userptr_blits (map-fixed-invalidate)
[697.805805] Starting subtest: map-fixed-invalidate
[697.812300] Subtest map-fixed-invalidate: SKIP (0.000s)
[698.051413] [089/141] (325s left) kms_vblank (pipe-b-wait-idle-hang)
[698.526574] Starting subtest: pipe-B-wait-idle-hang
[713.862937] Subtest pipe-B-wait-idle-hang: SUCCESS (15.334s)
[714.822951] [090/141] (308s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[715.334707] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[715.342580] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.001s)
[715.526066] [091/141] (308s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[716.037256] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[721.377420] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (5.351s)
[721.664534] [092/141] (302s left) gem_close (basic)
[722.056077] Starting subtest: basic
[722.059937] Subtest basic: SUCCESS (0.000s)
[722.234303] [093/141] (301s left) gen7_exec_parse (bitmasks)
[722.636683] Subtest bitmasks: SKIP (0.000s)
[722.763808] [094/141] (301s left) kms_ccs (pipe-c-bad-rotation-90-y_tiled_gen12_rc_ccs_cc)
[724.140182] Starting subtest: pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs_cc
[724.147219] Subtest pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[725.185502] [095/141] (299s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[725.692960] Starting subtest: fbc-rgb565-draw-mmap-cpu
[735.418510] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (9.725s)
[735.732442] [096/141] (288s left) gem_exec_whisper (basic-fds-forked-all)
[736.170648] Starting subtest: basic-fds-forked-all
[783.051961] Subtest basic-fds-forked-all: SUCCESS (46.878s)
[783.298535] [097/141] (241s left) v3d/v3d_submit_csd (bad-bo)
[783.779543] Subtest bad-bo: SKIP (0.000s)
[783.928839] [098/141] (240s left) syncobj_wait (invalid-wait-zero-handles)
[784.300724] Starting subtest: invalid-wait-zero-handles
[784.304259] Subtest invalid-wait-zero-handles: SUCCESS (0.000s)
[784.475301] [099/141] (240s left) syncobj_timeline (signal-array)
[784.840860] Starting subtest: signal-array
[784.844381] Subtest signal-array: SUCCESS (0.002s)
[785.032677] [100/141] (239s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[785.458062] Starting subtest: y-tiled-to-vebox-x-tiled
[785.465128] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[785.770743] [101/141] (238s left) kms_psr2_sf (overlay-primary-update-sf-dmg-area)
[793.833813] Starting subtest: overlay-primary-update-sf-dmg-area
[793.842420] Starting dynamic subtest: pipe-A-eDP-1
[801.925853] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.081s)
[801.982956] Starting dynamic subtest: pipe-B-eDP-1
[810.167529] Dynamic subtest pipe-B-eDP-1: SUCCESS (8.232s)
[810.170372] Subtest overlay-primary-update-sf-dmg-area: SUCCESS (16.334s)
[811.138406] [102/141] (213s left) i915_pm_rpm (dpms-mode-unset-non-lpsp)
[813.666635] Starting subtest: dpms-mode-unset-non-lpsp
[817.227228] Subtest dpms-mode-unset-non-lpsp: SKIP (3.555s)
[818.167663] [103/141] (206s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_mtl_rc_ccs)
[819.052900] Starting subtest: pipe-A-bad-rotation-90-4_tiled_mtl_rc_ccs
[819.859986] Subtest pipe-A-bad-rotation-90-4_tiled_mtl_rc_ccs: SUCCESS (0.806s)
[821.678873] [104/141] (203s left) gem_lmem_swapping (parallel-random-engines)
[822.078867] Subtest parallel-random-engines: SKIP (0.000s)
[822.211463] [105/141] (202s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[822.749788] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[826.322370] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (3.571s)
[826.822988] [106/141] (198s left) prime_vgem (busy)
[827.240790] Starting subtest: busy
[827.245199] Starting dynamic subtest: rcs0
[827.309964] Dynamic subtest rcs0: SUCCESS (0.068s)
[827.382610] Starting dynamic subtest: bcs0
[827.386510] Dynamic subtest bcs0: SUCCESS (0.065s)
[827.453241] Starting dynamic subtest: vcs0
[827.456735] Dynamic subtest vcs0: SUCCESS (0.061s)
[827.544734] Starting dynamic subtest: vcs1
[827.548794] Dynamic subtest vcs1: SUCCESS (0.052s)
[827.618513] Starting dynamic subtest: vecs0
[827.621837] Dynamic subtest vecs0: SUCCESS (0.044s)
[827.679280] Starting dynamic subtest: ccs0
[827.683448] Dynamic subtest ccs0: SUCCESS (0.050s)
[827.687599] Subtest busy: SUCCESS (0.359s)
[827.804364] [107/141] (197s left) vc4/vc4_create_bo (create-bo-4096)
[828.286789] Subtest create-bo-4096: SKIP (0.000s)
[828.432467] [108/141] (196s left) kms_chamelium_frames (dp-crc-single)
[829.311337] Subtest dp-crc-single: SKIP (0.000s)
[830.205720] [109/141] (195s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[830.719402] Starting subtest: fbc-rgb101010-draw-blt
[836.100883] Subtest fbc-rgb101010-draw-blt: SUCCESS (5.386s)
[836.371743] [110/141] (189s left) gem_exec_reloc (basic-wc-read-noreloc)
[836.777964] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[836.921711] [111/141] (188s left) gem_create (create-clear)
[837.308581] Starting subtest: create-clear
[837.312473] Starting dynamic subtest: smem0
[872.069278] Dynamic subtest smem0: SUCCESS (34.756s)
[872.072484] Subtest create-clear: SUCCESS (34.760s)
[872.404227] [112/141] (153s left) kms_hdr (static-swap)
[872.743524] Starting subtest: static-swap
[872.750305] Subtest static-swap: SKIP (0.000s)
[872.865851] [113/141] (153s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[873.322157] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[873.326470] Starting dynamic subtest: pipe-A-eDP-1
[875.481202] Dynamic subtest pipe-A-eDP-1: SKIP (2.152s)
[875.521415] Starting dynamic subtest: pipe-B-eDP-1
[879.001594] Dynamic subtest pipe-B-eDP-1: SKIP (3.512s)
[879.065641] Starting dynamic subtest: pipe-C-eDP-1
[880.940819] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.935s)
[881.008437] Starting dynamic subtest: pipe-D-eDP-1
[882.847993] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.896s)
[882.851943] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (9.533s)
[884.440390] [114/141] (141s left) kms_cursor_legacy (torture-move)
[885.016413] Starting subtest: torture-move
[885.020181] Starting dynamic subtest: pipe-A
[891.457834] Dynamic subtest pipe-A: SUCCESS (6.437s)
[891.508699] Starting dynamic subtest: pipe-B
[898.347386] Dynamic subtest pipe-B: SUCCESS (6.888s)
[898.409571] Starting dynamic subtest: pipe-C
[904.843858] Dynamic subtest pipe-C: SUCCESS (6.489s)
[904.898538] Starting dynamic subtest: pipe-D
[912.167359] Dynamic subtest pipe-D: SUCCESS (7.320s)
[912.217907] Starting dynamic subtest: all-pipes
[918.329595] Dynamic subtest all-pipes: SUCCESS (6.159s)
[918.333204] Subtest torture-move: SUCCESS (33.317s)
[918.717490] [115/141] (107s left) gem_set_tiling_vs_pwrite
[919.208139] [116/141] (106s left) i915_selftest (live)
[923.471047] Starting subtest: live
[923.475064] Starting dynamic subtest: sanitycheck
[928.679383] Dynamic subtest sanitycheck: SUCCESS (5.207s)
[928.726156] Starting dynamic subtest: uncore
[932.763234] Dynamic subtest uncore: SUCCESS (4.080s)
[932.800810] Starting dynamic subtest: workarounds
[938.124125] Dynamic subtest workarounds: SUCCESS (5.358s)
[938.161060] Starting dynamic subtest: gt_engines
[942.561387] Dynamic subtest gt_engines: SUCCESS (4.433s)
[942.598086] Starting dynamic subtest: gt_timelines
[963.222301] Dynamic subtest gt_timelines: SUCCESS (20.657s)
[963.260323] Starting dynamic subtest: gt_contexts
[967.357730] Dynamic subtest gt_contexts: SUCCESS (4.131s)
[967.394149] Starting dynamic subtest: gt_lrc
[973.469194] Dynamic subtest gt_lrc: SUCCESS (6.108s)
[973.507146] Starting dynamic subtest: gt_mocs
[977.952627] Dynamic subtest gt_mocs: SUCCESS (4.479s)
[977.989044] Starting dynamic subtest: gt_pm
[982.780187] Dynamic subtest gt_pm: SUCCESS (4.823s)
[982.818368] Starting dynamic subtest: gt_heartbeat
[987.096859] Dynamic subtest gt_heartbeat: SUCCESS (4.311s)
[987.134689] Starting dynamic subtest: gt_tlb
[993.196109] Dynamic subtest gt_tlb: SUCCESS (6.097s)
[993.231856] Starting dynamic subtest: requests
[1018.151561] Dynamic subtest requests: SUCCESS (24.950s)
[1018.189882] Starting dynamic subtest: migrate
[1026.976887] Dynamic subtest migrate: SUCCESS (8.822s)
[1027.015133] Starting dynamic subtest: active
[1031.130354] Dynamic subtest active: SUCCESS (4.150s)
[1031.166940] Starting dynamic subtest: objects
[1038.002480] Dynamic subtest objects: SUCCESS (6.866s)
[1038.039182] Starting dynamic subtest: mman
[1045.905174] Dynamic subtest mman: SUCCESS (7.899s)
[1045.940719] Starting dynamic subtest: dmabuf
[1049.768234] Dynamic subtest dmabuf: SUCCESS (3.858s)
[1049.815729] Starting dynamic subtest: vma
[1053.859093] Dynamic subtest vma: SUCCESS (4.086s)
[1053.892913] Starting dynamic subtest: coherency
[1060.308870] Dynamic subtest coherency: SUCCESS (6.446s)
[1060.347782] Starting dynamic subtest: gtt
[1073.815174] Dynamic subtest gtt: SUCCESS (13.501s)
[1073.852273] Starting dynamic subtest: gem
[1081.101724] Dynamic subtest gem: SUCCESS (7.284s)
[1081.138124] Starting dynamic subtest: evict
[1087.755623] Dynamic subtest evict: SUCCESS (6.650s)
[1087.792701] Starting dynamic subtest: hugepages
[1097.866568] Dynamic subtest hugepages: SUCCESS (10.108s)
[1097.906121] Starting dynamic subtest: gem_contexts
[1150.257799] Dynamic subtest gem_contexts: SUCCESS (52.388s)
[1150.304174] Starting dynamic subtest: client
[1153.346133] Dynamic subtest client: SUCCESS (3.083s)
[1153.390494] Starting dynamic subtest: gem_migrate
[1157.164735] Dynamic subtest gem_migrate: SUCCESS (3.816s)
[1157.203500] Starting dynamic subtest: reset
[1161.336930] Dynamic subtest reset: SUCCESS (4.166s)
[1161.374969] Starting dynamic subtest: memory_region
[1165.534405] Dynamic subtest memory_region: SUCCESS (4.194s)
[1165.573510] Starting dynamic subtest: hangcheck
[1182.981377] Dynamic subtest hangcheck: SUCCESS (17.443s)
[1183.023324] Starting dynamic subtest: execlists
[1187.127134] Dynamic subtest execlists: SUCCESS (4.141s)
[1187.164644] Starting dynamic subtest: ring_submission
[1191.290277] Dynamic subtest ring_submission: SUCCESS (4.158s)
[1191.327810] Starting dynamic subtest: perf
[1195.687114] Dynamic subtest perf: SUCCESS (4.394s)
[1195.724286] Starting dynamic subtest: slpc
[1207.925802] Dynamic subtest slpc: SUCCESS (12.235s)
[1207.963748] Starting dynamic subtest: guc
[1214.016151] Dynamic subtest guc: SUCCESS (6.087s)
[1214.054641] Starting dynamic subtest: guc_multi_lrc
[1218.154733] Dynamic subtest guc_multi_lrc: SUCCESS (4.135s)
[1218.193430] Starting dynamic subtest: guc_hang
[1223.100110] Dynamic subtest guc_hang: SUCCESS (4.940s)
[1223.137886] Starting dynamic subtest: late_gt_pm
[1227.334564] Dynamic subtest late_gt_pm: SUCCESS (4.229s)
[1227.338885] Subtest live: SUCCESS (303.865s)
[1227.639423] Overall timeout time exceeded, stopping.
[1227.640724] Closing watchdogs
Done.