[43.109253] Initializing watchdogs
[43.109314]   /dev/watchdog0
[43.115170] [001/141] (960s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[45.079567] Starting subtest: modeset-transition-nonblocking-fencing
[45.080563] Starting dynamic subtest: 1x-outputs
[49.313384] Dynamic subtest 1x-outputs: SUCCESS (4.235s)
[49.339153] Subtest modeset-transition-nonblocking-fencing: SUCCESS (4.260s)
[49.460270] [002/141] (954s left) drm_fdinfo (all-busy-check-all)
[49.528707] Starting subtest: all-busy-check-all
[49.545159] Subtest all-busy-check-all: SKIP (0.016s)
[49.592901] [003/141] (954s left) kms_ccs (pipe-b-ccs-on-another-bo-yf_tiled_ccs)
[51.688179] Starting subtest: pipe-B-ccs-on-another-bo-yf_tiled_ccs
[51.690174] Subtest pipe-B-ccs-on-another-bo-yf_tiled_ccs: SKIP (0.000s)
[51.850656] [004/141] (951s left) perf_pmu (most-busy-check-all)
[51.912478] Starting subtest: most-busy-check-all
[51.913407] Starting dynamic subtest: rcs0
[52.491356] Dynamic subtest rcs0: SUCCESS (0.578s)
[52.501103] Starting dynamic subtest: bcs0
[53.045395] Dynamic subtest bcs0: SUCCESS (0.554s)
[53.050671] Starting dynamic subtest: vcs0
[53.599481] Dynamic subtest vcs0: SUCCESS (0.554s)
[53.606142] Starting dynamic subtest: vcs1
[54.150605] Dynamic subtest vcs1: SUCCESS (0.551s)
[54.155444] Starting dynamic subtest: vecs0
[54.704365] Dynamic subtest vecs0: SUCCESS (0.554s)
[54.709511] Starting dynamic subtest: vecs1
[55.255926] Dynamic subtest vecs1: SUCCESS (0.551s)
[55.260987] Starting dynamic subtest: ccs0
[55.809471] Dynamic subtest ccs0: SUCCESS (0.553s)
[55.814549] Starting dynamic subtest: ccs1
[56.363484] Dynamic subtest ccs1: SUCCESS (0.554s)
[56.368711] Starting dynamic subtest: ccs2
[56.915398] Dynamic subtest ccs2: SUCCESS (0.552s)
[56.920428] Starting dynamic subtest: ccs3
[57.469543] Dynamic subtest ccs3: SUCCESS (0.554s)
[57.470468] Subtest most-busy-check-all: SUCCESS (5.557s)
[57.538214] [005/141] (946s left) prime_vgem (basic-fence-flip)
[57.648820] Starting subtest: basic-fence-flip
[59.554792] Subtest basic-fence-flip: SKIP (1.905s)
[59.635710] [006/141] (944s left) gem_exec_schedule (preempt-engines)
[59.780050] Starting subtest: preempt-engines
[59.781058] Starting dynamic subtest: rcs0
[62.036107] Dynamic subtest rcs0: SUCCESS (2.221s)
[62.040993] Starting dynamic subtest: bcs0
[64.202996] Dynamic subtest bcs0: SUCCESS (2.166s)
[64.207940] Starting dynamic subtest: vcs0
[66.423572] Dynamic subtest vcs0: SUCCESS (2.245s)
[66.428516] Starting dynamic subtest: vcs1
[68.694686] Dynamic subtest vcs1: SUCCESS (2.245s)
[68.699858] Starting dynamic subtest: vecs0
[70.942854] Dynamic subtest vecs0: SUCCESS (2.248s)
[70.947874] Starting dynamic subtest: vecs1
[73.189764] Dynamic subtest vecs1: SUCCESS (2.246s)
[73.194824] Starting dynamic subtest: ccs0
[75.385810] Dynamic subtest ccs0: SUCCESS (2.196s)
[75.390831] Starting dynamic subtest: ccs1
[77.584507] Dynamic subtest ccs1: SUCCESS (2.198s)
[77.589675] Starting dynamic subtest: ccs2
[79.779561] Dynamic subtest ccs2: SUCCESS (2.194s)
[79.784696] Starting dynamic subtest: ccs3
[81.950239] Dynamic subtest ccs3: SUCCESS (2.194s)
[81.952159] Subtest preempt-engines: SUCCESS (22.161s)
[82.255128] [007/141] (921s left) kms_scaling_modes (scaling-mode-center)
[84.221161] Starting subtest: scaling-mode-center
[84.224322] Subtest scaling-mode-center: SKIP (0.001s)
[84.285203] [008/141] (919s left) prime_mmap_coherency (read)
[84.375997] Starting subtest: read
[89.778950] Subtest read: SUCCESS (5.403s)
[89.894741] [009/141] (913s left) gem_exec_balancer (parallel-ordering)
[90.203308] Starting subtest: parallel-ordering
[91.254891] Subtest parallel-ordering: SUCCESS (1.051s)
[91.344264] [010/141] (912s left) kms_ccs (pipe-b-bad-aux-stride-y_tiled_gen12_rc_ccs_cc)
[93.385098] Starting subtest: pipe-B-bad-aux-stride-y_tiled_gen12_rc_ccs_cc
[93.386922] Subtest pipe-B-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[93.546074] [011/141] (910s left) i915_hangman (gt-error-state-capture)
[93.618301] Starting subtest: gt-error-state-capture
[93.619119] Starting dynamic subtest: rcs0
[103.570214] Dynamic subtest rcs0: SUCCESS (9.952s)
[103.575722] Starting dynamic subtest: bcs0
[113.533134] Dynamic subtest bcs0: SUCCESS (9.963s)
[113.538725] Starting dynamic subtest: vcs0
[123.512385] Dynamic subtest vcs0: SUCCESS (9.979s)
[123.518212] Starting dynamic subtest: vcs1
[133.514260] Dynamic subtest vcs1: SUCCESS (10.002s)
[133.520693] Starting dynamic subtest: vecs0
[143.559497] Dynamic subtest vecs0: SUCCESS (10.045s)
[143.565181] Starting dynamic subtest: vecs1
[153.531345] Dynamic subtest vecs1: SUCCESS (9.972s)
[153.537144] Starting dynamic subtest: ccs0
[163.542531] Dynamic subtest ccs0: SUCCESS (10.011s)
[163.549446] Starting dynamic subtest: ccs1
[173.507408] Dynamic subtest ccs1: SUCCESS (9.965s)
[173.513437] Starting dynamic subtest: ccs2
[183.563677] Dynamic subtest ccs2: SUCCESS (10.056s)
[183.569381] Starting dynamic subtest: ccs3
[193.547405] Dynamic subtest ccs3: SUCCESS (9.984s)
[193.548406] Subtest gt-error-state-capture: SUCCESS (99.930s)
[193.676353] [012/141] (810s left) gem_mmap_gtt (basic-read)
[193.736249] Subtest basic-read: SKIP (0.000s)
[193.759111] [013/141] (810s left) kms_ccs (pipe-d-crc-primary-rotation-180-y_tiled_gen12_mc_ccs)
[195.866739] Starting subtest: pipe-D-crc-primary-rotation-180-y_tiled_gen12_mc_ccs
[195.868293] Subtest pipe-D-crc-primary-rotation-180-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[195.975707] [014/141] (807s left) v3d/v3d_perfmon (create-single-perfmon)
[196.062889] Subtest create-single-perfmon: SKIP (0.000s)
[196.108137] [015/141] (807s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[196.167975] Starting subtest: invalid-single-wait-unsubmitted
[196.168816] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[196.232711] [016/141] (807s left) kms_vblank (pipe-d-wait-forked-busy)
[198.217536] Starting subtest: pipe-D-wait-forked-busy
[200.920201] Subtest pipe-D-wait-forked-busy: SUCCESS (2.703s)
[201.023963] [017/141] (802s left) i915_pm_sseu (full-enable)
[201.090804] Subtest full-enable: SKIP (0.000s)
[201.140211] [018/141] (802s left) gem_linear_blits (normal)
[201.537450] Starting subtest: normal
[208.441954] Subtest normal: SUCCESS (6.904s)
[208.658624] [019/141] (795s left) gem_userptr_blits (dmabuf-sync)
[208.770387] Starting subtest: dmabuf-sync
[208.773123] Subtest dmabuf-sync: SKIP (0.002s)
[208.901106] [020/141] (794s left) kms_ccs (pipe-a-crc-primary-basic-y_tiled_gen12_mc_ccs)
[210.905064] Starting subtest: pipe-A-crc-primary-basic-y_tiled_gen12_mc_ccs
[210.906909] Subtest pipe-A-crc-primary-basic-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[211.116474] [021/141] (792s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[213.080123] Starting subtest: yf-tiled-addfb-size-overflow
[213.081817] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[213.169305] [022/141] (790s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_ccs)
[215.242662] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_ccs
[215.244410] Subtest pipe-A-missing-ccs-buffer-y_tiled_ccs: SKIP (0.000s)
[215.442900] [023/141] (788s left) gem_ctx_persistence (legacy-engines-hostile)
[215.507186] Starting subtest: legacy-engines-hostile
[215.508101] Starting dynamic subtest: render
[215.549265] Dynamic subtest render: SUCCESS (0.042s)
[215.555777] Starting dynamic subtest: bsd1
[215.654978] Dynamic subtest bsd1: SUCCESS (0.105s)
[215.679263] Starting dynamic subtest: bsd2
[215.680801] Dynamic subtest bsd2: SUCCESS (0.024s)
[215.700188] Starting dynamic subtest: blt
[215.736276] Dynamic subtest blt: SUCCESS (0.055s)
[215.749024] Starting dynamic subtest: vebox
[215.835098] Dynamic subtest vebox: SUCCESS (0.097s)
[215.836879] Subtest legacy-engines-hostile: SUCCESS (0.328s)
[215.964330] [024/141] (787s left) kms_vblank (pipe-a-query-forked-busy)
[217.947496] Starting subtest: pipe-A-query-forked-busy
[220.361124] Subtest pipe-A-query-forked-busy: SUCCESS (2.413s)
[220.495616] [025/141] (783s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[222.456692] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[222.457531] Starting dynamic subtest: pipe-A-HDMI-A-3
[222.548147] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.092s)
[222.555529] Starting dynamic subtest: pipe-B-HDMI-A-3
[222.655008] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.106s)
[222.662470] Starting dynamic subtest: pipe-C-HDMI-A-3
[222.762079] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.106s)
[222.769412] Starting dynamic subtest: pipe-D-HDMI-A-3
[222.868935] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.106s)
[222.869773] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.414s)
[222.989224] [026/141] (780s left) gem_exec_params (invalid-batch-start-offset)
[223.053319] Starting subtest: invalid-batch-start-offset
[223.056053] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[223.138782] [027/141] (780s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[225.093074] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[225.094608] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[225.174750] [028/141] (778s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[227.207246] Starting subtest: psr-rgb565-draw-mmap-cpu
[227.208874] Subtest psr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[227.272427] [029/141] (776s left) gem_exec_balancer (bonded-semaphore)
[227.367357] Starting subtest: bonded-semaphore
[227.369472] Subtest bonded-semaphore: SKIP (0.000s)
[227.675412] [030/141] (776s left) gem_mmap_gtt (hang-busy)
[227.740321] Subtest hang-busy: SKIP (0.000s)
[227.766852] [031/141] (776s left) kms_ccs (pipe-d-bad-rotation-90-y_tiled_gen12_rc_ccs_cc)
[229.864965] Starting subtest: pipe-D-bad-rotation-90-y_tiled_gen12_rc_ccs_cc
[229.866608] Subtest pipe-D-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[229.982722] [032/141] (774s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[231.938803] Starting subtest: flip-vs-cursor-atomic-transitions
[240.358531] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (8.421s)
[240.481768] [033/141] (763s left) gem_exec_fence (submit)
[240.674596] Starting subtest: submit
[240.677242] Subtest submit: SKIP (0.000s)
[241.639361] [034/141] (762s left) api_intel_allocator (simple-allocator)
[241.702447] Starting subtest: simple-allocator
[241.703315] Starting dynamic subtest: basic
[241.723521] Dynamic subtest basic: SUCCESS (0.021s)
[241.730397] Starting dynamic subtest: parallel-one
[241.785053] Dynamic subtest parallel-one: SUCCESS (0.061s)
[241.791657] Starting dynamic subtest: print
[241.792559] Dynamic subtest print: SUCCESS (0.000s)
[241.798980] Starting dynamic subtest: reuse
[241.799786] Dynamic subtest reuse: SUCCESS (0.000s)
[241.806328] Starting dynamic subtest: reserve
[241.807157] Dynamic subtest reserve: SUCCESS (0.000s)
[241.813436] Starting dynamic subtest: fork-reopen-allocator
[241.814223] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[241.815009] Subtest simple-allocator: SUCCESS (0.098s)
[241.935590] [035/141] (762s left) gem_exec_flush (basic-wb-pro-default)
[242.043477] Subtest basic-wb-pro-default: SKIP (0.000s)
[242.096285] [036/141] (762s left) kms_vblank (pipe-a-wait-idle-hang)
[244.052631] Starting subtest: pipe-A-wait-idle-hang
[258.057787] Subtest pipe-A-wait-idle-hang: SUCCESS (14.006s)
[258.161023] [037/141] (745s left) sysfs_timeslice_duration (timeout)
[258.225654] Starting subtest: timeout
[258.226535] Starting dynamic subtest: ccs2
[259.841255] Dynamic subtest ccs2: SUCCESS (1.615s)
[259.847939] Starting dynamic subtest: vecs0
[261.406237] Dynamic subtest vecs0: SUCCESS (1.565s)
[261.412796] Starting dynamic subtest: ccs0
[263.011173] Dynamic subtest ccs0: SUCCESS (1.604s)
[263.018010] Starting dynamic subtest: vcs0
[383.411635] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[383.664185] Closing watchdogs
[383.666918] Initializing watchdogs
[383.666958]   /dev/watchdog0
[383.675364] [038/141] (620s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[385.634600] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[385.636265] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[385.715559] [039/141] (618s left) gem_ctx_exec (basic-invalid-context)
[385.814098] Starting subtest: basic-invalid-context
[385.818553] Subtest basic-invalid-context: SUCCESS (0.004s)
[385.951533] [040/141] (618s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[386.045844] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[386.046843] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[386.098369] [041/141] (618s left) kms_chamelium_edid (dp-edid-resolution-list)
[388.108211] Subtest dp-edid-resolution-list: SKIP (0.000s)
[388.222553] [042/141] (616s left) gem_mmap_wc (write-wc-read-gtt)
[388.282987] Subtest write-wc-read-gtt: SKIP (0.000s)
[388.301409] [043/141] (615s left) prime_vgem (basic-write)
[388.385445] Starting subtest: basic-write
[388.391818] Subtest basic-write: SKIP (0.006s)
[388.509139] [044/141] (615s left) kms_color (legacy-gamma-reset)
[390.507833] Starting subtest: legacy-gamma-reset
[390.508732] Starting dynamic subtest: pipe-A
[390.935152] Dynamic subtest pipe-A: SUCCESS (0.427s)
[390.942182] Starting dynamic subtest: pipe-B
[391.262193] Dynamic subtest pipe-B: SUCCESS (0.327s)
[391.269161] Starting dynamic subtest: pipe-C
[391.587927] Dynamic subtest pipe-C: SUCCESS (0.325s)
[391.595045] Starting dynamic subtest: pipe-D
[391.912997] Dynamic subtest pipe-D: SUCCESS (0.325s)
[391.913857] Subtest legacy-gamma-reset: SUCCESS (1.406s)
[392.003087] [045/141] (612s left) kms_ccs (pipe-d-bad-aux-stride-4_tiled_mtl_mc_ccs)
[394.114337] Starting subtest: pipe-D-bad-aux-stride-4_tiled_mtl_mc_ccs
[394.116123] Subtest pipe-D-bad-aux-stride-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[394.211043] [046/141] (610s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[396.171110] Starting subtest: fbcpsr-rgb565-draw-pwrite
[396.172810] Subtest fbcpsr-rgb565-draw-pwrite: SKIP (0.000s)
[396.244939] [047/141] (608s left) kms_addfb_basic (bad-pitch-999)
[396.344468] Starting subtest: bad-pitch-999
[396.345436] Subtest bad-pitch-999: SUCCESS (0.000s)
[398.329121] [048/141] (606s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[400.346366] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu
[400.347934] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[400.429155] [049/141] (603s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[401.491194] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[401.506727] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.015s)
[401.560831] [050/141] (602s left) kms_fbcon_fbt (fbc-suspend)
[401.659153] Starting subtest: fbc-suspend
[450.641842] Subtest fbc-suspend: SUCCESS (18.054s)
[451.685875] [051/141] (584s left) kms_ccs (pipe-c-bad-aux-stride-y_tiled_gen12_rc_ccs_cc)
[453.780340] Starting subtest: pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs_cc
[453.781918] Subtest pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[453.911801] [052/141] (582s left) kms_big_fb (linear-32bpp-rotate-270)
[455.876321] Starting subtest: linear-32bpp-rotate-270
[455.929593] Subtest linear-32bpp-rotate-270: SKIP (0.053s)
[456.056883] [053/141] (580s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[458.083269] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[458.084944] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[458.163959] [054/141] (578s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs)
[460.296553] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs
[460.298266] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs: SKIP (0.002s)
[460.425944] [055/141] (576s left) api_intel_allocator (gem-pool)
[460.485940] Starting subtest: gem-pool
[460.509641] Subtest gem-pool: SUCCESS (0.024s)
[460.652417] [056/141] (575s left) syncobj_timeline (etime-single-wait-all-submitted)
[460.718688] Starting subtest: etime-single-wait-all-submitted
[460.819588] Subtest etime-single-wait-all-submitted: SUCCESS (0.101s)
[460.922445] [057/141] (575s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[462.891781] Starting subtest: y-tiled-8bpp-rotate-0
[462.893387] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[462.978146] [058/141] (573s left) kms_psr (sprite_plane_onoff)
[463.083495] Subtest sprite_plane_onoff: SKIP (0.000s)
[463.125195] [059/141] (573s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[465.102071] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[465.102877] Starting dynamic subtest: pipe-A-valid-mode
[465.150648] Dynamic subtest pipe-A-valid-mode: SKIP (0.047s)
[465.152223] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.048s)
[465.241064] [060/141] (571s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_mtl_rc_ccs_cc)
[467.356323] Starting subtest: pipe-D-random-ccs-data-4_tiled_mtl_rc_ccs_cc
[467.358825] Subtest pipe-D-random-ccs-data-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[467.464806] [061/141] (569s left) kms_plane_scaling (plane-upscale-with-rotation-20x20)
[469.423149] Starting subtest: plane-upscale-with-rotation-20x20
[469.423982] Starting dynamic subtest: pipe-A-HDMI-A-3
[469.798351] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.375s)
[469.807786] Starting dynamic subtest: pipe-B-HDMI-A-3
[470.189907] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.390s)
[470.199383] Starting dynamic subtest: pipe-C-HDMI-A-3
[470.581216] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.390s)
[470.590438] Starting dynamic subtest: pipe-D-HDMI-A-3
[470.970860] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.388s)
[470.971781] Subtest plane-upscale-with-rotation-20x20: SUCCESS (1.549s)
[471.177038] [062/141] (565s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[473.141145] Starting subtest: yf-tiled-32bpp-rotate-270
[473.143014] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[473.210663] [063/141] (563s left) kms_flip (basic-flip-vs-wf_vblank)
[474.262285] Starting subtest: basic-flip-vs-wf_vblank
[474.266909] Starting dynamic subtest: A-HDMI-A3
[475.283642] Dynamic subtest A-HDMI-A3: SUCCESS (1.017s)
[475.294157] Starting dynamic subtest: B-HDMI-A3
[476.229819] Dynamic subtest B-HDMI-A3: SUCCESS (0.945s)
[476.239110] Starting dynamic subtest: C-HDMI-A3
[477.174796] Dynamic subtest C-HDMI-A3: SUCCESS (0.944s)
[477.183654] Starting dynamic subtest: D-HDMI-A3
[478.118106] Dynamic subtest D-HDMI-A3: SUCCESS (0.942s)
[478.119100] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.858s)
[478.291306] [064/141] (558s left) gem_exec_capture (pi)
[478.357169] Starting subtest: pi
[478.357996] Starting dynamic subtest: rcs0
[484.348268] Dynamic subtest rcs0: SUCCESS (5.991s)
[484.356688] Starting dynamic subtest: bcs0
[490.286499] Dynamic subtest bcs0: SUCCESS (5.937s)
[490.294803] Starting dynamic subtest: vcs0
[496.206174] Dynamic subtest vcs0: SUCCESS (5.918s)
[496.214412] Starting dynamic subtest: vcs1
[502.123374] Dynamic subtest vcs1: SUCCESS (5.917s)
[502.131852] Starting dynamic subtest: vecs0
[508.140558] Dynamic subtest vecs0: SUCCESS (6.007s)
[508.148771] Starting dynamic subtest: vecs1
[514.072801] Dynamic subtest vecs1: SUCCESS (5.932s)
[514.080985] Starting dynamic subtest: ccs0
[519.970220] Dynamic subtest ccs0: SUCCESS (5.905s)
[519.978669] Starting dynamic subtest: ccs1
[525.985944] Dynamic subtest ccs1: SUCCESS (6.006s)
[525.994432] Starting dynamic subtest: ccs2
[531.917717] Dynamic subtest ccs2: SUCCESS (5.931s)
[531.926226] Starting dynamic subtest: ccs3
[537.909081] Dynamic subtest ccs3: SUCCESS (5.990s)
[537.910062] Subtest pi: SUCCESS (59.544s)
[538.042747] [065/141] (498s left) kms_plane_multiple (tiling-y)
[540.098457] Starting subtest: tiling-y
[540.100326] Subtest tiling-y: SKIP (0.000s)
[540.159260] [066/141] (496s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[540.245754] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[540.348429] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.102s)
[540.443847] [067/141] (496s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[543.074099] Subtest verify-pxp-stale-buf-optout-execution: SKIP (0.000s)
[543.099013] [068/141] (493s left) core_auth (many-magics)
[543.158619] Starting subtest: many-magics
[543.759416] Subtest many-magics: SUCCESS (0.602s)
[543.986463] [069/141] (492s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[546.001335] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[546.117411] [070/141] (490s left) kms_cursor_crc (cursor-sliding-256x256)
[548.211403] Starting subtest: cursor-sliding-256x256
[548.216335] Starting dynamic subtest: pipe-A-HDMI-A-3
[552.560280] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.344s)
[552.589939] Starting dynamic subtest: pipe-D-HDMI-A-3
[556.833377] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.250s)
[556.834463] Subtest cursor-sliding-256x256: SUCCESS (8.621s)
[557.047245] [071/141] (479s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[559.011904] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[559.013369] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[559.098258] [072/141] (477s left) gem_exec_reloc (basic-wc-read)
[559.227195] Subtest basic-wc-read: SKIP (0.000s)
[559.256919] [073/141] (477s left) perf (non-sampling-read-error)
[560.196842] Starting subtest: non-sampling-read-error
[560.212499] Subtest non-sampling-read-error: SUCCESS (0.015s)
[560.246187] [074/141] (476s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[562.206327] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[562.208033] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[562.281242] [075/141] (474s left) debugfs_test (basic-hwmon)
[562.396460] Starting subtest: basic-hwmon
[562.406653] Subtest basic-hwmon: SUCCESS (0.010s)
[564.362842] [076/141] (472s left) kms_cursor_edge_walk (256x256-left-edge)
[566.340397] Starting subtest: 256x256-left-edge
[566.341306] Starting dynamic subtest: pipe-A-HDMI-A-3
[569.636822] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.295s)
[569.645341] Starting dynamic subtest: pipe-D-HDMI-A-3
[572.832522] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.194s)
[572.833470] Subtest 256x256-left-edge: SUCCESS (6.492s)
[572.954281] [077/141] (463s left) gem_workarounds (reset)
[573.027626] Starting subtest: reset
[573.243455] Subtest reset: SUCCESS (0.216s)
[573.365041] [078/141] (463s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[574.387280] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[574.402806] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.015s)
[574.473750] [079/141] (462s left) kms_sequence (get-forked-busy)
[576.480269] Starting subtest: get-forked-busy
[576.481241] Starting dynamic subtest: HDMI-A-3-pipe-A
[578.988524] Dynamic subtest HDMI-A-3-pipe-A: SUCCESS (2.507s)
[579.019633] Starting dynamic subtest: HDMI-A-3-pipe-B
[581.529134] Dynamic subtest HDMI-A-3-pipe-B: SUCCESS (2.534s)
[581.562799] Starting dynamic subtest: HDMI-A-3-pipe-C
[584.141851] Dynamic subtest HDMI-A-3-pipe-C: SUCCESS (2.610s)
[584.164532] Starting dynamic subtest: HDMI-A-3-pipe-D
[586.772611] Dynamic subtest HDMI-A-3-pipe-D: SUCCESS (2.623s)
[586.774547] Subtest get-forked-busy: SUCCESS (10.291s)
[586.912969] [080/141] (450s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc)
[588.979451] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc
[588.982430] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.002s)
[589.143388] [081/141] (447s left) gem_partial_pwrite_pread (reads-snoop)
[589.207664] Subtest reads-snoop: SKIP (0.000s)
[589.254432] [082/141] (447s left) gem_mmap_gtt (basic-read-write-distinct)
[589.314543] Subtest basic-read-write-distinct: SKIP (0.000s)
[589.337179] [083/141] (447s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[591.294302] Starting subtest: fbcpsr-1p-rte
[591.296024] Subtest fbcpsr-1p-rte: SKIP (0.000s)
[591.378461] [084/141] (445s left) gem_userptr_blits (access-control)
[591.500548] Starting subtest: access-control
[591.502379] Subtest access-control: SKIP (0.000s)
[591.587730] [085/141] (445s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[593.565777] Starting subtest: x-tiled-8bpp-rotate-0
[594.971156] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.395s)
[595.145892] [086/141] (441s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[597.116313] Starting subtest: cursor-vs-flip-atomic-transitions
[626.068370] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (28.953s)
[626.191592] [087/141] (410s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[628.147263] Starting subtest: cursorB-vs-flipA-varying-size
[628.149111] Subtest cursorB-vs-flipA-varying-size: SKIP (0.002s)
[628.207697] [088/141] (408s left) gem_userptr_blits (map-fixed-invalidate)
[628.291979] Starting subtest: map-fixed-invalidate
[628.293959] Subtest map-fixed-invalidate: SKIP (0.000s)
[628.431203] [089/141] (408s left) kms_vblank (pipe-b-wait-idle-hang)
[630.421270] Starting subtest: pipe-B-wait-idle-hang
[643.900257] Subtest pipe-B-wait-idle-hang: SUCCESS (13.479s)
[644.029424] [090/141] (393s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[645.991468] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[645.993191] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[646.063033] [091/141] (391s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[648.053410] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[650.380915] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (2.328s)
[650.513091] [092/141] (386s left) gem_close (basic)
[650.578808] Starting subtest: basic
[650.579714] Subtest basic: SUCCESS (0.000s)
[650.667830] [093/141] (386s left) gen7_exec_parse (bitmasks)
[650.732480] Subtest bitmasks: SKIP (0.000s)
[650.756961] [094/141] (386s left) kms_ccs (pipe-c-bad-rotation-90-y_tiled_gen12_rc_ccs_cc)
[652.819286] Starting subtest: pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs_cc
[652.820974] Subtest pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[652.972739] [095/141] (384s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[654.932307] Starting subtest: fbc-rgb565-draw-mmap-cpu
[659.257121] Subtest fbc-rgb565-draw-mmap-cpu: FAIL (3.970s)
[659.372661] [096/141] (377s left) gem_exec_whisper (basic-fds-forked-all)
[659.448380] Starting subtest: basic-fds-forked-all
[687.279753] Subtest basic-fds-forked-all: SUCCESS (27.821s)
[687.441353] [097/141] (349s left) v3d/v3d_submit_csd (bad-bo)
[687.523991] Subtest bad-bo: SKIP (0.000s)
[687.577217] [098/141] (349s left) syncobj_wait (invalid-wait-zero-handles)
[687.657749] Starting subtest: invalid-wait-zero-handles
[687.658862] Subtest invalid-wait-zero-handles: SUCCESS (0.000s)
[687.734306] [099/141] (349s left) syncobj_timeline (signal-array)
[687.806479] Starting subtest: signal-array
[687.807414] Subtest signal-array: SUCCESS (0.000s)
[687.876431] [100/141] (349s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[687.962446] Starting subtest: y-tiled-to-vebox-x-tiled
[687.964629] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[688.134105] [101/141] (349s left) kms_psr2_sf (overlay-primary-update-sf-dmg-area)
[688.195111] Subtest overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[688.218888] [102/141] (349s left) i915_pm_rpm (dpms-mode-unset-non-lpsp)
[692.453988] Starting subtest: dpms-mode-unset-non-lpsp
[698.242044] Subtest dpms-mode-unset-non-lpsp: SUCCESS (5.789s)
[699.332123] [103/141] (338s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_mtl_rc_ccs)
[701.334549] Starting subtest: pipe-A-bad-rotation-90-4_tiled_mtl_rc_ccs
[701.336286] Subtest pipe-A-bad-rotation-90-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[701.553632] [104/141] (335s left) gem_lmem_swapping (parallel-random-engines)
[705.223077] Starting subtest: parallel-random-engines
[705.223844] Starting dynamic subtest: lmem0
[706.021252] Dynamic subtest lmem0: SUCCESS (0.798s)
[706.022019] Subtest parallel-random-engines: SUCCESS (0.799s)
[708.464964] [105/141] (329s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[712.895576] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[713.497144] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.601s)
[714.660568] [106/141] (322s left) prime_vgem (busy)
[714.732035] Starting subtest: busy
[714.732937] Starting dynamic subtest: rcs0
[714.778396] Dynamic subtest rcs0: SUCCESS (0.046s)
[714.786982] Starting dynamic subtest: bcs0
[714.820566] Dynamic subtest bcs0: SUCCESS (0.041s)
[714.831048] Starting dynamic subtest: vcs0
[714.863747] Dynamic subtest vcs0: SUCCESS (0.042s)
[714.890584] Starting dynamic subtest: vcs1
[714.907383] Dynamic subtest vcs1: SUCCESS (0.042s)
[714.940363] Starting dynamic subtest: vecs0
[714.948471] Dynamic subtest vecs0: SUCCESS (0.039s)
[714.962396] Starting dynamic subtest: vecs1
[714.988530] Dynamic subtest vecs1: SUCCESS (0.039s)
[714.999415] Starting dynamic subtest: ccs0
[715.033502] Dynamic subtest ccs0: SUCCESS (0.044s)
[715.052813] Starting dynamic subtest: ccs1
[715.076241] Dynamic subtest ccs1: SUCCESS (0.041s)
[715.096183] Starting dynamic subtest: ccs2
[715.118832] Dynamic subtest ccs2: SUCCESS (0.041s)
[715.139285] Starting dynamic subtest: ccs3
[715.163035] Dynamic subtest ccs3: SUCCESS (0.043s)
[715.164294] Subtest busy: SUCCESS (0.431s)
[715.299207] [107/141] (322s left) vc4/vc4_create_bo (create-bo-4096)
[715.397163] Subtest create-bo-4096: SKIP (0.000s)
[715.452126] [108/141] (322s left) kms_chamelium_frames (dp-crc-single)
[717.454925] Subtest dp-crc-single: SKIP (0.000s)
[717.572790] [109/141] (320s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[719.537244] Starting subtest: fbc-rgb101010-draw-blt
[722.376688] Subtest fbc-rgb101010-draw-blt: SUCCESS (2.841s)
[722.499007] [110/141] (315s left) gem_exec_reloc (basic-wc-read-noreloc)
[722.564038] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[722.621522] [111/141] (314s left) gem_create (create-clear)
[722.684770] Starting subtest: create-clear
[722.685633] Starting dynamic subtest: lmem0
[756.684770] Dynamic subtest lmem0: SUCCESS (33.981s)
[756.692762] Starting dynamic subtest: smem0
[791.578088] Dynamic subtest smem0: SUCCESS (34.911s)
[791.578901] Subtest create-clear: SUCCESS (68.893s)
[791.995926] [112/141] (245s left) kms_hdr (static-swap)
[793.948462] Starting subtest: static-swap
[793.950354] Subtest static-swap: SKIP (0.000s)
[794.010104] [113/141] (243s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[795.981880] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[795.982670] Starting dynamic subtest: pipe-A-HDMI-A-3
[824.577913] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (28.595s)
[824.587446] Starting dynamic subtest: pipe-B-HDMI-A-3
[853.352649] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (28.773s)
[853.362353] Starting dynamic subtest: pipe-C-HDMI-A-3
[853.577733] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.223s)
[853.587259] Starting dynamic subtest: pipe-D-HDMI-A-3
[853.801209] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.222s)
[853.802087] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (57.820s)
[853.942527] [114/141] (183s left) kms_cursor_legacy (torture-move)
[855.899381] Starting subtest: torture-move
[855.900302] Starting dynamic subtest: pipe-A
[861.360441] Dynamic subtest pipe-A: SUCCESS (5.427s)
[861.369412] Starting dynamic subtest: pipe-B
[866.774414] Dynamic subtest pipe-B: SUCCESS (5.438s)
[866.786464] Starting dynamic subtest: pipe-C
[872.208988] Dynamic subtest pipe-C: SUCCESS (5.435s)
[872.221889] Starting dynamic subtest: pipe-D
[877.642823] Dynamic subtest pipe-D: SUCCESS (5.434s)
[877.651032] Starting dynamic subtest: all-pipes
[883.080972] Dynamic subtest all-pipes: SUCCESS (5.435s)
[883.081801] Subtest torture-move: SUCCESS (27.173s)
[883.125942] [115/141] (154s left) gem_set_tiling_vs_pwrite
[883.258182] [116/141] (154s left) i915_selftest (live)
[885.229776] Starting subtest: live
[885.231383] Starting dynamic subtest: sanitycheck
[886.627715] Dynamic subtest sanitycheck: SUCCESS (1.400s)
[886.634112] Starting dynamic subtest: uncore
[887.996628] Dynamic subtest uncore: SUCCESS (1.368s)
[888.004109] Starting dynamic subtest: workarounds
[891.649359] Dynamic subtest workarounds: SUCCESS (3.652s)
[891.656638] Starting dynamic subtest: gt_engines
[894.066613] Dynamic subtest gt_engines: SUCCESS (2.416s)
[894.074199] Starting dynamic subtest: gt_timelines
[921.401477] Dynamic subtest gt_timelines: SUCCESS (27.334s)
[921.408015] Starting dynamic subtest: gt_contexts
[922.833640] Dynamic subtest gt_contexts: SUCCESS (1.431s)
[922.840920] Starting dynamic subtest: gt_lrc
[930.800743] Dynamic subtest gt_lrc: SUCCESS (7.966s)
[930.808786] Starting dynamic subtest: gt_mocs
[933.895613] Dynamic subtest gt_mocs: SUCCESS (3.094s)
[933.903202] Starting dynamic subtest: gt_pm
[936.212479] Dynamic subtest gt_pm: SUCCESS (2.316s)
[936.220116] Starting dynamic subtest: gt_heartbeat
[937.862880] Dynamic subtest gt_heartbeat: SUCCESS (1.649s)
[937.870465] Starting dynamic subtest: gt_tlb
[950.074508] Dynamic subtest gt_tlb: SUCCESS (12.211s)
[950.081069] Starting dynamic subtest: requests
[967.323497] Dynamic subtest requests: SUCCESS (17.248s)
[967.330494] Starting dynamic subtest: migrate
[972.002544] Dynamic subtest migrate: SUCCESS (4.678s)
[972.009547] Starting dynamic subtest: active
[973.374401] Dynamic subtest active: SUCCESS (1.371s)
[973.381425] Starting dynamic subtest: objects
[975.729845] Dynamic subtest objects: SUCCESS (2.363s)
[975.737449] Starting dynamic subtest: mman
[984.537172] Dynamic subtest mman: SUCCESS (8.798s)
[984.543523] Starting dynamic subtest: dmabuf
[985.941087] Dynamic subtest dmabuf: SUCCESS (1.403s)
[985.947444] Starting dynamic subtest: vma
[987.343108] Dynamic subtest vma: SUCCESS (1.401s)
[987.349560] Starting dynamic subtest: coherency
[990.620174] Dynamic subtest coherency: SUCCESS (3.276s)
[990.626571] Starting dynamic subtest: gtt
[999.459182] Dynamic subtest gtt: SUCCESS (8.837s)
[999.470180] Starting dynamic subtest: gem
[1000.935366] Dynamic subtest gem: SUCCESS (1.474s)
[1000.942586] Starting dynamic subtest: evict
[1004.274735] Dynamic subtest evict: SUCCESS (3.338s)
[1004.282276] Starting dynamic subtest: hugepages
[1022.565740] Dynamic subtest hugepages: SUCCESS (18.289s)
[1022.572155] Starting dynamic subtest: gem_contexts
[1063.312566] Dynamic subtest gem_contexts: SUCCESS (40.747s)
[1063.319447] Starting dynamic subtest: client
[1064.745487] Dynamic subtest client: SUCCESS (1.432s)
[1064.753067] Starting dynamic subtest: gem_migrate
[1068.920610] Dynamic subtest gem_migrate: SUCCESS (4.174s)
[1068.927232] Starting dynamic subtest: reset
[1070.359688] Dynamic subtest reset: SUCCESS (1.438s)
[1070.367070] Starting dynamic subtest: memory_region
[1073.306318] Dynamic subtest memory_region: SUCCESS (2.946s)
[1073.312889] Starting dynamic subtest: hangcheck
[1117.000575] Dynamic subtest hangcheck: SUCCESS (43.693s)
[1117.007720] Starting dynamic subtest: execlists
[1118.393540] Dynamic subtest execlists: SUCCESS (1.392s)
[1118.401285] Starting dynamic subtest: ring_submission
[1119.753701] Dynamic subtest ring_submission: SUCCESS (1.357s)
[1119.760462] Starting dynamic subtest: perf
[1121.218484] Dynamic subtest perf: SUCCESS (1.466s)
[1121.227405] Starting dynamic subtest: slpc
[1130.388564] Dynamic subtest slpc: SUCCESS (9.169s)
[1130.395606] Starting dynamic subtest: guc
[1132.943425] Dynamic subtest guc: SUCCESS (2.554s)
[1132.951707] Starting dynamic subtest: guc_multi_lrc
[1134.360852] Dynamic subtest guc_multi_lrc: SUCCESS (1.416s)
[1134.368098] Starting dynamic subtest: guc_hang
[1136.436447] Dynamic subtest guc_hang: SUCCESS (2.075s)
[1136.443684] Starting dynamic subtest: late_gt_pm
[1137.903434] Dynamic subtest late_gt_pm: SUCCESS (1.466s)
[1137.904534] Subtest live: SUCCESS (252.678s)
[1138.331332] Overall timeout time exceeded, stopping.
[1138.331479] Closing watchdogs
Done.