[27.513763] Initializing watchdogs
[27.513817]   /dev/watchdog0
[27.520292] [001/133] (960s left) kms_psr (fbc-psr2-primary-blt)
[27.654416] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[27.673400] [002/133] (960s left) gem_ctx_shared (detached-shared-gtt)
[27.740451] Starting subtest: detached-shared-gtt
[29.893461] Subtest detached-shared-gtt: SUCCESS (2.153s)
[32.071061] [003/133] (955s left) gem_exec_whisper (basic-fds-all)
[32.143128] Starting subtest: basic-fds-all
[55.052580] Subtest basic-fds-all: SUCCESS (22.908s)
[55.217292] [004/133] (932s left) gen9_exec_parse (bb-large)
[55.291532] Subtest bb-large: SKIP (0.000s)
[55.347754] [005/133] (932s left) gem_exec_balancer (parallel-keep-submit-fence)
[55.667816] Starting subtest: parallel-keep-submit-fence
[57.399262] Subtest parallel-keep-submit-fence: SUCCESS (1.731s)
[57.466499] [006/133] (930s left) gem_pxp (create-regular-context-2)
[60.056453] Subtest create-regular-context-2: SKIP (0.000s)
[60.127731] [007/133] (927s left) kms_psr (psr2-primary-render)
[60.253150] Subtest psr2-primary-render: SKIP (0.000s)
[60.275341] [008/133] (927s left) vc4/vc4_perfmon (create-single-perfmon)
[60.335779] Subtest create-single-perfmon: SKIP (0.000s)
[60.388260] [009/133] (927s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[60.567871] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[60.569614] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[60.655759] [010/133] (927s left) gem_exec_fair (basic-none-rrul)
[60.746560] Subtest basic-none-rrul: SKIP (0.000s)
[60.774973] [011/133] (927s left) kms_atomic_transition (plane-all-transition)
[60.900780] Starting subtest: plane-all-transition
[60.901770] Starting dynamic subtest: pipe-A-DP-4
[64.686829] Dynamic subtest pipe-A-DP-4: SUCCESS (3.784s)
[64.818801] Starting dynamic subtest: pipe-B-DP-4
[68.699088] Dynamic subtest pipe-B-DP-4: SUCCESS (3.885s)
[68.804461] Subtest plane-all-transition: SUCCESS (7.903s)
[68.973220] [012/133] (919s left) gem_busy (busy)
[69.091126] Starting subtest: busy
[69.092102] Starting dynamic subtest: all-engines
[69.212051] Dynamic subtest all-engines: SUCCESS (0.121s)
[69.217450] Starting dynamic subtest: rcs0
[69.327303] Dynamic subtest rcs0: SUCCESS (0.112s)
[69.332896] Starting dynamic subtest: bcs0
[69.362184] Dynamic subtest bcs0: SUCCESS (0.037s)
[69.368894] Starting dynamic subtest: vcs0
[69.401834] Dynamic subtest vcs0: SUCCESS (0.040s)
[69.419847] Starting dynamic subtest: vcs1
[69.445989] Dynamic subtest vcs1: SUCCESS (0.043s)
[69.470319] Starting dynamic subtest: vecs0
[69.487186] Dynamic subtest vecs0: SUCCESS (0.041s)
[69.503795] Starting dynamic subtest: vecs1
[69.528400] Dynamic subtest vecs1: SUCCESS (0.041s)
[69.544647] Starting dynamic subtest: ccs0
[69.571364] Dynamic subtest ccs0: SUCCESS (0.042s)
[69.595699] Starting dynamic subtest: ccs1
[69.614273] Dynamic subtest ccs1: SUCCESS (0.043s)
[69.635608] Starting dynamic subtest: ccs2
[69.655198] Dynamic subtest ccs2: SUCCESS (0.041s)
[69.667458] Starting dynamic subtest: ccs3
[69.697468] Dynamic subtest ccs3: SUCCESS (0.042s)
[69.699195] Subtest busy: SUCCESS (0.606s)
[70.042282] [013/133] (918s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[70.109172] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[70.229172] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.108s)
[70.281685] [014/133] (917s left) kms_feature_discovery (display-3x)
[70.414463] Starting subtest: display-3x
[70.416271] Subtest display-3x: SKIP (0.000s)
[70.475549] [015/133] (917s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[70.622721] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[71.927476] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.304s)
[72.075116] [016/133] (916s left) syncobj_wait (invalid-signal-illegal-handle)
[72.141169] Starting subtest: invalid-signal-illegal-handle
[72.142128] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[72.212190] [017/133] (916s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[72.467984] Starting subtest: cursor-rapid-movement-64x21
[72.471902] Starting dynamic subtest: pipe-A-DP-4
[72.889866] Dynamic subtest pipe-A-DP-4: SUCCESS (0.416s)
[72.929332] Starting dynamic subtest: pipe-D-DP-4
[73.324977] Dynamic subtest pipe-D-DP-4: SUCCESS (0.395s)
[73.325973] Subtest cursor-rapid-movement-64x21: SUCCESS (0.851s)
[73.688040] [018/133] (914s left) kms_async_flips (invalid-async-flip)
[73.862876] Starting subtest: invalid-async-flip
[73.864821] Subtest invalid-async-flip: SKIP (0.000s)
[74.216879] [019/133] (914s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[74.323628] Starting subtest: invalid-multi-wait-all-unsubmitted
[74.324756] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[74.421723] [020/133] (913s left) kms_frontbuffer_tracking (fbc-tiling-4)
[74.556495] Starting subtest: fbc-tiling-4
[76.900529] Subtest fbc-tiling-4: SUCCESS (2.344s)
[77.039525] [021/133] (911s left) gem_tiled_partial_pwrite_pread (reads)
[77.099248] Subtest reads: SKIP (0.000s)
[77.142371] [022/133] (911s left) prime_vgem (basic-write)
[77.277145] Starting subtest: basic-write
[77.283935] Subtest basic-write: SKIP (0.006s)
[77.384588] [023/133] (911s left) kms_flip (flip-vs-panning)
[77.567574] Starting subtest: flip-vs-panning
[77.573375] Starting dynamic subtest: A-DP4
[85.440021] Dynamic subtest A-DP4: SUCCESS (7.867s)
[85.447018] Starting dynamic subtest: B-DP4
[93.219059] Dynamic subtest B-DP4: SUCCESS (7.779s)
[93.225761] Starting dynamic subtest: C-DP4
[100.994989] Dynamic subtest C-DP4: SUCCESS (7.775s)
[101.001194] Starting dynamic subtest: D-DP4
[108.771556] Dynamic subtest D-DP4: SUCCESS (7.776s)
[108.772406] Subtest flip-vs-panning: SUCCESS (31.205s)
[109.084132] [024/133] (879s left) perf_pmu (busy-start)
[109.179403] Starting subtest: busy-start
[109.180396] Starting dynamic subtest: rcs0
[111.750198] Dynamic subtest rcs0: SUCCESS (2.570s)
[111.760723] Starting dynamic subtest: bcs0
[114.298918] Dynamic subtest bcs0: SUCCESS (2.548s)
[114.309254] Starting dynamic subtest: vcs0
[116.847226] Dynamic subtest vcs0: SUCCESS (2.547s)
[116.857282] Starting dynamic subtest: vcs1
[119.394927] Dynamic subtest vcs1: SUCCESS (2.547s)
[119.405246] Starting dynamic subtest: vecs0
[121.943953] Dynamic subtest vecs0: SUCCESS (2.548s)
[121.954677] Starting dynamic subtest: vecs1
[124.492243] Dynamic subtest vecs1: SUCCESS (2.547s)
[124.503199] Starting dynamic subtest: ccs0
[127.040255] Dynamic subtest ccs0: SUCCESS (2.547s)
[127.049666] Starting dynamic subtest: ccs1
[129.587907] Dynamic subtest ccs1: SUCCESS (2.547s)
[129.597596] Starting dynamic subtest: ccs2
[132.136352] Dynamic subtest ccs2: SUCCESS (2.547s)
[132.145945] Starting dynamic subtest: ccs3
[134.683288] Dynamic subtest ccs3: SUCCESS (2.546s)
[134.685413] Subtest busy-start: SUCCESS (25.503s)
[134.786809] [025/133] (853s left) kms_properties (invalid-properties-atomic)
[134.918961] Starting subtest: invalid-properties-atomic
[135.235978] Subtest invalid-properties-atomic: SUCCESS (0.317s)
[135.297520] [026/133] (853s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[135.430014] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[135.431782] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[135.519542] [027/133] (852s left) gem_exec_reloc (basic-write-cpu-noreloc)
[135.606933] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[135.640096] [028/133] (852s left) syncobj_wait (wait-all-delayed-signal)
[135.718386] Starting subtest: wait-all-delayed-signal
[135.819798] Subtest wait-all-delayed-signal: SUCCESS (0.101s)
[135.929193] [029/133] (852s left) gem_exec_reloc (basic-wc-read-noreloc)
[135.999650] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[136.040229] [030/133] (852s left) gem_exec_params (batch-first)
[136.118637] Starting subtest: batch-first
[136.146016] Subtest batch-first: SUCCESS (0.027s)
[136.235021] [031/133] (852s left) v3d/v3d_submit_cl (bad-multisync-out-sync)
[136.298617] Subtest bad-multisync-out-sync: SKIP (0.000s)
[136.353500] [032/133] (852s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[136.509514] Starting subtest: cursorA-vs-flipA-atomic-transitions
[147.474550] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (10.964s)
[147.690924] [033/133] (840s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[147.872455] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[147.874248] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s)
[147.942555] [034/133] (840s left) kms_psr (fbc-psr-basic)
[148.090850] Subtest fbc-psr-basic: SKIP (0.000s)
[148.115526] [035/133] (840s left) i915_pm_rpm (system-suspend)
[149.639413] Starting subtest: system-suspend
[170.523140] Subtest system-suspend: SUCCESS (4.984s)
[170.844420] [036/133] (833s left) vc4/vc4_wait_bo (unused-bo-1ns)
[170.939963] Subtest unused-bo-1ns: SKIP (0.000s)
[170.993187] [037/133] (833s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[171.145094] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[171.146921] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[171.224608] [038/133] (833s left) gem_mmap_gtt (cpuset-big-copy-odd)
[171.287512] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[171.315340] [039/133] (833s left) kms_invalid_mode (zero-vdisplay)
[171.460173] Starting subtest: zero-vdisplay
[171.461120] Starting dynamic subtest: pipe-A-DP-4
[171.530174] Dynamic subtest pipe-A-DP-4: SUCCESS (0.070s)
[171.539522] Starting dynamic subtest: pipe-B-DP-4
[171.540387] Dynamic subtest pipe-B-DP-4: SUCCESS (0.001s)
[171.548437] Starting dynamic subtest: pipe-C-DP-4
[171.549263] Dynamic subtest pipe-C-DP-4: SUCCESS (0.001s)
[171.557174] Starting dynamic subtest: pipe-D-DP-4
[171.558023] Dynamic subtest pipe-D-DP-4: SUCCESS (0.001s)
[171.558832] Subtest zero-vdisplay: SUCCESS (0.076s)
[171.721464] [040/133] (832s left) kms_content_protection (atomic-dpms)
[171.927840] Starting subtest: atomic-dpms
[171.957503] Starting dynamic subtest: pipe-A-DP-4
[292.438852] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[292.728831] Closing watchdogs
[292.730403] Initializing watchdogs
[292.730442]   /dev/watchdog0
[292.742103] [041/133] (711s left) kms_psr2_sf (overlay-plane-update-sf-dmg-area)
[292.881888] Subtest overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[292.902890] [042/133] (711s left) kms_content_protection (type1)
[293.087122] Starting subtest: type1
[293.689296] Subtest type1: SKIP (0.600s)
[294.008097] [043/133] (710s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[294.175552] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[295.143986] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.968s)
[295.335629] [044/133] (709s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[295.470092] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[295.470992] Starting dynamic subtest: pipe-A-DP-4
[295.473435] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[295.481456] Starting dynamic subtest: pipe-B-DP-4
[295.484186] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[295.491895] Starting dynamic subtest: pipe-C-DP-4
[295.494651] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[295.502354] Starting dynamic subtest: pipe-D-DP-4
[295.506192] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[295.508267] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SKIP (0.005s)
[295.528091] [045/133] (709s left) api_intel_allocator (simple-allocator)
[295.584015] Starting subtest: simple-allocator
[295.584974] Starting dynamic subtest: basic
[295.606968] Dynamic subtest basic: SUCCESS (0.023s)
[295.615274] Starting dynamic subtest: parallel-one
[295.794889] Dynamic subtest parallel-one: SUCCESS (0.187s)
[295.802944] Starting dynamic subtest: print
[295.808843] Dynamic subtest print: SUCCESS (0.000s)
[295.817082] Starting dynamic subtest: reuse
[295.817918] Dynamic subtest reuse: SUCCESS (0.000s)
[295.825908] Starting dynamic subtest: reserve
[295.827037] Dynamic subtest reserve: SUCCESS (0.000s)
[295.834597] Starting dynamic subtest: fork-reopen-allocator
[295.835341] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[295.836141] Subtest simple-allocator: SUCCESS (0.227s)
[295.928789] [046/133] (708s left) sysfs_timeslice_duration (duration)
[296.023563] Starting subtest: duration
[296.024437] Starting dynamic subtest: ccs2
[309.183029] Dynamic subtest ccs2: SUCCESS (13.159s)
[309.192113] Starting dynamic subtest: vecs0
[322.328555] Dynamic subtest vecs0: SUCCESS (13.144s)
[322.363801] Starting dynamic subtest: ccs0
[335.489581] Dynamic subtest ccs0: SUCCESS (13.158s)
[335.501414] Starting dynamic subtest: vcs0
[348.653242] Dynamic subtest vcs0: SUCCESS (13.161s)
[348.664451] Starting dynamic subtest: bcs0
[361.781418] Dynamic subtest bcs0: SUCCESS (13.125s)
[361.794183] Starting dynamic subtest: ccs3
[374.938017] Dynamic subtest ccs3: SUCCESS (13.155s)
[374.947257] Starting dynamic subtest: vecs1
[388.077411] Dynamic subtest vecs1: SUCCESS (13.138s)
[388.089335] Starting dynamic subtest: ccs1
[401.213370] Dynamic subtest ccs1: SUCCESS (13.133s)
[401.224885] Starting dynamic subtest: rcs0
[414.374495] Dynamic subtest rcs0: SUCCESS (13.158s)
[414.385723] Starting dynamic subtest: vcs1
[427.525147] Dynamic subtest vcs1: SUCCESS (13.148s)
[427.527011] Subtest duration: SUCCESS (131.502s)
[427.595320] [047/133] (577s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[427.741570] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[427.744149] Starting dynamic subtest: pipe-A-DP-4
[427.746052] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[427.754385] Starting dynamic subtest: pipe-B-DP-4
[427.756497] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[427.764365] Starting dynamic subtest: pipe-C-DP-4
[427.766060] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[427.773994] Starting dynamic subtest: pipe-D-DP-4
[427.775637] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[427.778330] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.005s)
[427.815859] [048/133] (577s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[428.043535] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[428.161954] [049/133] (576s left) prime_busy (hang)
[428.229536] Starting subtest: hang
[428.231474] Starting dynamic subtest: rcs0
[441.919229] Dynamic subtest rcs0: SUCCESS (13.687s)
[441.927223] Starting dynamic subtest: bcs0
[449.002272] Dynamic subtest bcs0: SUCCESS (7.083s)
[449.010892] Starting dynamic subtest: vcs0
[456.044099] Dynamic subtest vcs0: SUCCESS (7.040s)
[456.052186] Starting dynamic subtest: vcs1
[463.021091] Dynamic subtest vcs1: SUCCESS (6.976s)
[463.029333] Starting dynamic subtest: vecs0
[469.995554] Dynamic subtest vecs0: SUCCESS (6.975s)
[470.003961] Starting dynamic subtest: vecs1
[477.056054] Dynamic subtest vecs1: SUCCESS (7.059s)
[477.064152] Starting dynamic subtest: ccs0
[490.877261] Dynamic subtest ccs0: SUCCESS (13.821s)
[490.885717] Starting dynamic subtest: ccs1
[504.894483] Dynamic subtest ccs1: SUCCESS (14.018s)
[504.902429] Starting dynamic subtest: ccs2
[518.906804] Dynamic subtest ccs2: SUCCESS (14.011s)
[518.915327] Starting dynamic subtest: ccs3
[532.863780] Dynamic subtest ccs3: SUCCESS (13.956s)
[532.864939] Subtest hang: SUCCESS (104.634s)
[532.959357] [050/133] (471s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[533.107933] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[533.109623] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[533.189714] [051/133] (471s left) drm_fdinfo (busy-check-all)
[533.250235] Starting subtest: busy-check-all
[533.251126] Starting dynamic subtest: rcs0
[533.272790] Dynamic subtest rcs0: SKIP (0.021s)
[533.281148] Starting dynamic subtest: bcs0
[533.282793] Dynamic subtest bcs0: SKIP (0.000s)
[533.290787] Starting dynamic subtest: vcs0
[533.292994] Dynamic subtest vcs0: SKIP (0.000s)
[533.301187] Starting dynamic subtest: vcs1
[533.303526] Dynamic subtest vcs1: SKIP (0.000s)
[533.311536] Starting dynamic subtest: vecs0
[533.313475] Dynamic subtest vecs0: SKIP (0.000s)
[533.324318] Starting dynamic subtest: vecs1
[533.326755] Dynamic subtest vecs1: SKIP (0.000s)
[533.334440] Starting dynamic subtest: ccs0
[533.336213] Dynamic subtest ccs0: SKIP (0.000s)
[533.344239] Starting dynamic subtest: ccs1
[533.345890] Dynamic subtest ccs1: SKIP (0.000s)
[533.353963] Starting dynamic subtest: ccs2
[533.356374] Dynamic subtest ccs2: SKIP (0.000s)
[533.364827] Starting dynamic subtest: ccs3
[533.366923] Dynamic subtest ccs3: SKIP (0.000s)
[533.368918] Subtest busy-check-all: SKIP (0.029s)
[533.382493] [052/133] (471s left) kms_getfb (getfb-handle-not-fb)
[533.442879] Starting subtest: getfb-handle-not-fb
[533.516533] Subtest getfb-handle-not-fb: SUCCESS (0.074s)
[533.608709] [053/133] (471s left) syncobj_wait (invalid-signal-zero-handles)
[533.693062] Starting subtest: invalid-signal-zero-handles
[533.694087] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[533.824574] [054/133] (471s left) gem_userptr_blits (invalid-null-pointer)
[533.896838] Starting subtest: invalid-null-pointer
[533.897735] Subtest invalid-null-pointer: SUCCESS (0.001s)
[534.026060] [055/133] (471s left) gem_lmem_swapping (parallel-random-engines)
[536.676719] Starting subtest: parallel-random-engines
[536.677966] Starting dynamic subtest: lmem0
[571.188035] Dynamic subtest lmem0: SUCCESS (34.513s)
[571.188904] Subtest parallel-random-engines: SUCCESS (34.514s)
[572.476712] [056/133] (432s left) syncobj_timeline (32bits-limit)
[574.045721] Starting subtest: 32bits-limit
[574.046789] Subtest 32bits-limit: SUCCESS (0.000s)
[574.084612] [057/133] (430s left) kms_flip (2x-absolute-wf_vblank)
[574.237964] Starting subtest: 2x-absolute-wf_vblank
[574.272617] Subtest 2x-absolute-wf_vblank: SKIP (0.036s)
[574.336634] [058/133] (430s left) gem_exec_balancer (bonded-semaphore)
[574.414303] Starting subtest: bonded-semaphore
[574.416132] Subtest bonded-semaphore: SKIP (0.000s)
[574.736707] [059/133] (430s left) gem_exec_reloc (basic-cpu)
[574.803962] Subtest basic-cpu: SKIP (0.000s)
[574.844615] [060/133] (430s left) kms_atomic_interruptible (legacy-cursor)
[574.981796] Starting subtest: legacy-cursor
[574.984448] Starting dynamic subtest: pipe-A-DP-4
[581.280129] Dynamic subtest pipe-A-DP-4: SUCCESS (6.295s)
[581.281168] Subtest legacy-cursor: SUCCESS (6.298s)
[581.469265] [061/133] (423s left) gem_exec_fence (syncobj-invalid-flags)
[582.294657] Starting subtest: syncobj-invalid-flags
[582.295630] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[582.662981] [062/133] (422s left) gem_flink_race (flink_close)
[582.709143] Starting subtest: flink_close
[587.771089] Subtest flink_close: SUCCESS (5.062s)
[587.829566] [063/133] (417s left) syncobj_timeline (single-wait-for-submit-signaled)
[587.961419] Starting subtest: single-wait-for-submit-signaled
[587.962523] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[588.069283] [064/133] (417s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[588.231496] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[588.233980] Starting dynamic subtest: pipe-A-DP-4
[588.234859] Dynamic subtest pipe-A-DP-4: SUCCESS (0.002s)
[588.244184] Starting dynamic subtest: pipe-B-DP-4
[588.245000] Dynamic subtest pipe-B-DP-4: SUCCESS (0.002s)
[588.252538] Starting dynamic subtest: pipe-C-DP-4
[588.253376] Dynamic subtest pipe-C-DP-4: SUCCESS (0.002s)
[588.261460] Starting dynamic subtest: pipe-D-DP-4
[588.262687] Dynamic subtest pipe-D-DP-4: SUCCESS (0.002s)
[588.264040] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SUCCESS (0.013s)
[588.307304] [065/133] (416s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[588.453824] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[589.674765] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.220s)
[589.836821] [066/133] (415s left) syncobj_wait (wait-for-submit-delayed-submit)
[589.896081] Starting subtest: wait-for-submit-delayed-submit
[589.997798] Subtest wait-for-submit-delayed-submit: SUCCESS (0.101s)
[590.067354] [067/133] (415s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[590.210750] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[590.212309] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[590.298124] [068/133] (415s left) syncobj_wait (invalid-signal-one-illegal-handle)
[590.373114] Starting subtest: invalid-signal-one-illegal-handle
[590.374167] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[590.472164] [069/133] (414s left) kms_psr (psr-sprite-mmap-gtt)
[590.639691] Subtest psr-sprite-mmap-gtt: SKIP (0.000s)
[590.666699] [070/133] (414s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[590.804397] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[590.806141] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[590.876346] [071/133] (414s left) kms_sequence (get-forked)
[591.017014] Starting subtest: get-forked
[591.017860] Starting dynamic subtest: pipe-A-DP-4
[593.397269] Dynamic subtest pipe-A-DP-4: SUCCESS (2.380s)
[593.407104] Starting dynamic subtest: pipe-B-DP-4
[595.783097] Dynamic subtest pipe-B-DP-4: SUCCESS (2.384s)
[595.793291] Starting dynamic subtest: pipe-C-DP-4
[598.154266] Dynamic subtest pipe-C-DP-4: SUCCESS (2.370s)
[598.162011] Starting dynamic subtest: pipe-D-DP-4
[600.522324] Dynamic subtest pipe-D-DP-4: SUCCESS (2.367s)
[600.523137] Subtest get-forked: SUCCESS (9.506s)
[600.746105] [072/133] (404s left) gem_exec_params (readonly)
[600.838777] Starting subtest: readonly
[600.841012] Subtest readonly: SUCCESS (0.001s)
[600.973654] [073/133] (404s left) gem_exec_schedule (reorder-wide)
[601.213696] Subtest reorder-wide: SKIP (0.000s)
[601.408039] [074/133] (404s left) kms_cursor_legacy (torture-bo)
[601.535174] Starting subtest: torture-bo
[601.536070] Starting dynamic subtest: pipe-A
[607.114580] Dynamic subtest pipe-A: SUCCESS (5.579s)
[607.125626] Starting dynamic subtest: pipe-B
[612.694167] Dynamic subtest pipe-B: SUCCESS (5.579s)
[612.701828] Starting dynamic subtest: pipe-C
[618.327790] Dynamic subtest pipe-C: SUCCESS (5.633s)
[618.335399] Starting dynamic subtest: pipe-D
[623.892102] Dynamic subtest pipe-D: SUCCESS (5.564s)
[623.900089] Starting dynamic subtest: all-pipes
[629.345081] Dynamic subtest all-pipes: SUCCESS (5.450s)
[629.345902] Subtest torture-bo: SUCCESS (27.807s)
[629.408424] [075/133] (376s left) kms_writeback (writeback-invalid-parameters)
[629.626742] Subtest writeback-invalid-parameters: SKIP (0.000s)
[629.650575] [076/133] (375s left) sw_sync (sync_expired_merge)
[629.697385] Starting subtest: sync_expired_merge
[630.770947] Subtest sync_expired_merge: SUCCESS (1.074s)
[630.824204] [077/133] (374s left) gem_exec_schedule (manyslice)
[630.886923] Starting subtest: manyslice
[630.887845] Starting dynamic subtest: rcs0
[635.829864] Dynamic subtest rcs0: SUCCESS (4.942s)
[635.843503] Starting dynamic subtest: bcs0
[640.773978] Dynamic subtest bcs0: SUCCESS (4.943s)
[640.783135] Starting dynamic subtest: vcs0
[645.838788] Dynamic subtest vcs0: SUCCESS (5.064s)
[645.848613] Starting dynamic subtest: vcs1
[650.899955] Dynamic subtest vcs1: SUCCESS (5.060s)
[650.909110] Starting dynamic subtest: vecs0
[655.965791] Dynamic subtest vecs0: SUCCESS (5.065s)
[655.975893] Starting dynamic subtest: vecs1
[661.031070] Dynamic subtest vecs1: SUCCESS (5.064s)
[661.042242] Starting dynamic subtest: ccs0
[666.490979] Dynamic subtest ccs0: SUCCESS (5.458s)
[666.519224] Starting dynamic subtest: ccs1
[671.477967] Dynamic subtest ccs1: SUCCESS (4.984s)
[671.488720] Starting dynamic subtest: ccs2
[675.946431] Dynamic subtest ccs2: SUCCESS (4.467s)
[675.957318] Starting dynamic subtest: ccs3
[680.417450] Dynamic subtest ccs3: SUCCESS (4.470s)
[680.418379] Subtest manyslice: SUCCESS (49.531s)
[680.765037] [078/133] (324s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[680.900208] Starting subtest: cursorB-vs-flipA-atomic-transitions
[680.903165] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.002s)
[680.957102] [079/133] (324s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[681.100311] Starting subtest: psr-1p-primscrn-cur-indfb-move
[681.102243] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[681.200154] [080/133] (324s left) gem_userptr_blits (sync-unmap-cycles)
[681.294657] Starting subtest: sync-unmap-cycles
[686.665891] Subtest sync-unmap-cycles: SUCCESS (5.370s)
[686.822136] [081/133] (318s left) gem_create (create-ext-cpu-access-big)