[65.642759] Initializing watchdogs
[65.642824]   /dev/watchdog0
[65.662893] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[65.673698] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[65.677248] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[65.680261] [001/131] (960s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[65.754041] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[65.817345] [002/131] (960s left) gem_exec_fence (syncobj-invalid-flags)
[66.367443] Starting subtest: syncobj-invalid-flags
[66.368292] Subtest syncobj-invalid-flags: SUCCESS (0.001s)
[66.758029] [FACT gem_exec_fence (syncobj-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[66.759657] [003/131] (959s left) gem_linear_blits (normal)
[67.500089] Starting subtest: normal
[74.739664] Subtest normal: SUCCESS (7.240s)
[75.096087] [004/131] (951s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[75.322930] Starting subtest: flip-vs-cursor-crc-legacy
[75.938343] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.616s)
[76.280975] [005/131] (950s left) gem_exec_reloc (basic-write-read-noreloc)
[76.372858] Subtest basic-write-read-noreloc: SKIP (0.000s)
[76.441974] [006/131] (950s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[76.627851] Starting subtest: cursor-vs-flip-toggle
[109.561214] Subtest cursor-vs-flip-toggle: SUCCESS (32.933s)
[109.884938] [007/131] (916s left) i915_query (engine-info-invalid)
[109.964991] Starting subtest: engine-info-invalid
[109.965931] Subtest engine-info-invalid: SUCCESS (0.000s)
[110.146366] [008/131] (916s left) syncobj_timeline (signal)
[110.227404] Starting subtest: signal
[110.228348] Subtest signal: SUCCESS (0.000s)
[110.397931] [009/131] (916s left) perf (blocking)
[110.829377] Starting subtest: blocking
[110.830227] Starting dynamic subtest: 0-rcs0
[120.853732] Dynamic subtest 0-rcs0: SUCCESS (10.024s)
[120.854588] Subtest blocking: SUCCESS (10.024s)
[120.901990] [010/131] (905s left) perf (gen12-unprivileged-single-ctx-counters)
[121.162774] Starting subtest: gen12-unprivileged-single-ctx-counters
[121.163610] Starting dynamic subtest: rcs0
[121.259378] Dynamic subtest rcs0: SUCCESS (0.096s)
[121.260387] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.097s)
[121.318233] [011/131] (905s left) kms_chamelium_hpd (dp-hpd-storm)
[121.602567] Subtest dp-hpd-storm: SKIP (0.000s)
[121.757671] [012/131] (905s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[121.955464] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[121.957130] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[122.156133] [013/131] (904s left) gem_create (hog-create)
[122.240144] Starting subtest: hog-create
[122.241092] Starting dynamic subtest: lmem0
[154.516222] Dynamic subtest lmem0: SUCCESS (32.276s)
[154.525404] Starting dynamic subtest: smem0
[186.767259] Dynamic subtest smem0: SUCCESS (32.250s)
[186.768197] Subtest hog-create: SUCCESS (64.526s)
[187.060202] [014/131] (839s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[187.250544] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[187.252191] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[187.458702] [015/131] (839s left) gem_pxp (create-regular-buffer)
[190.058995] Starting subtest: create-regular-buffer
[190.061490] Subtest create-regular-buffer: SKIP (0.000s)
[190.195563] [016/131] (836s left) device_reset (unbind-reset-rebind)
[190.283365] Starting subtest: unbind-reset-rebind
[192.887513] Subtest unbind-reset-rebind: SUCCESS (2.603s)
[192.945689] [017/131] (834s left) gem_mmap_gtt (ptrace)
[193.022968] Subtest ptrace: SKIP (0.000s)
[193.110528] [018/131] (834s left) syncobj_wait (multi-wait-for-submit-submitted)
[193.188394] Starting subtest: multi-wait-for-submit-submitted
[193.295788] Subtest multi-wait-for-submit-submitted: SUCCESS (0.107s)
[193.446116] [019/131] (833s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[193.630119] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[193.631067] Starting dynamic subtest: pipe-A-DP-3
[193.639627] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[193.649108] Starting dynamic subtest: pipe-B-DP-3
[193.657590] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[193.666973] Starting dynamic subtest: pipe-C-DP-3
[193.675062] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[193.684370] Starting dynamic subtest: pipe-D-DP-3
[193.694412] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[193.696356] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.006s)
[194.096830] [020/131] (833s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[194.291487] Starting subtest: y-tiled-32bpp-rotate-180
[194.293240] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[194.494475] [021/131] (832s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[194.688772] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[194.738936] [022/131] (832s left) syncobj_wait (reset-signaled)
[194.815165] Starting subtest: reset-signaled
[194.816195] Subtest reset-signaled: SUCCESS (0.000s)
[195.028460] [023/131] (832s left) kms_big_fb (linear-16bpp-rotate-90)
[195.225291] Starting subtest: linear-16bpp-rotate-90
[195.284695] Subtest linear-16bpp-rotate-90: SKIP (0.056s)
[195.494081] [024/131] (832s left) kms_joiner (basic-max-non-joiner)
[195.690420] Starting subtest: basic-max-non-joiner
[195.692123] Subtest basic-max-non-joiner: SKIP (0.000s)
[195.846235] [025/131] (831s left) gem_render_copy_redux (interruptible)
[195.931837] Starting subtest: interruptible
[196.676971] Subtest interruptible: SUCCESS (0.745s)
[196.875773] [026/131] (830s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[197.064477] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[197.066229] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[197.245052] [027/131] (830s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[197.433508] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[197.434415] Starting dynamic subtest: pipe-A-DP-3
[197.442776] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[197.452371] Starting dynamic subtest: pipe-B-DP-3
[197.460663] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[197.470117] Starting dynamic subtest: pipe-C-DP-3
[197.478175] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[197.487508] Starting dynamic subtest: pipe-D-DP-3
[197.497549] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[197.499538] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.004s)
[197.926406] [028/131] (830s left) kms_sequence (get-forked)
[198.111586] Starting subtest: get-forked
[198.112479] Starting dynamic subtest: pipe-A-DP-3
[200.550184] Dynamic subtest pipe-A-DP-3: SUCCESS (2.438s)
[200.562169] Starting dynamic subtest: pipe-B-DP-3
[202.908218] Dynamic subtest pipe-B-DP-3: SUCCESS (2.356s)
[202.918026] Starting dynamic subtest: pipe-C-DP-3
[205.253427] Dynamic subtest pipe-C-DP-3: SUCCESS (2.344s)
[205.264741] Starting dynamic subtest: pipe-D-DP-3
[207.622438] Dynamic subtest pipe-D-DP-3: SUCCESS (2.368s)
[207.623327] Subtest get-forked: SUCCESS (9.510s)
[207.934054] [029/131] (820s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[208.129377] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[208.131062] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[208.327579] [030/131] (819s left) gem_ctx_persistence (heartbeat-many)
[208.411505] Starting subtest: heartbeat-many
[208.413583] Subtest heartbeat-many: SKIP (0.000s)
[208.612373] [031/131] (819s left) gem_exec_schedule (fairslice)
[208.701562] Starting subtest: fairslice
[208.702454] Starting dynamic subtest: rcs0
[210.753338] Dynamic subtest rcs0: SUCCESS (2.051s)
[210.763274] Starting dynamic subtest: bcs0
[212.774330] Dynamic subtest bcs0: SUCCESS (2.021s)
[212.784579] Starting dynamic subtest: vcs0
[214.794050] Dynamic subtest vcs0: SUCCESS (2.019s)
[214.804289] Starting dynamic subtest: vcs1
[216.812897] Dynamic subtest vcs1: SUCCESS (2.019s)
[216.823627] Starting dynamic subtest: vecs0
[218.833870] Dynamic subtest vecs0: SUCCESS (2.021s)
[218.843743] Starting dynamic subtest: vecs1
[220.852940] Dynamic subtest vecs1: SUCCESS (2.019s)
[220.863323] Starting dynamic subtest: ccs0
[222.874048] Dynamic subtest ccs0: SUCCESS (2.021s)
[222.875040] Subtest fairslice: SUCCESS (14.172s)
[223.282073] [032/131] (804s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[223.368428] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[223.370584] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[223.647007] [033/131] (804s left) api_intel_bb (delta-check)
[223.730979] Starting subtest: delta-check
[223.761167] Subtest delta-check: SUCCESS (0.031s)
[223.998583] [034/131] (804s left) kms_async_flips (invalid-async-flip-atomic)
[224.183567] Starting subtest: invalid-async-flip-atomic
[224.423176] Starting dynamic subtest: pipe-A-DP-3
[224.802991] Dynamic subtest pipe-A-DP-3: SUCCESS (0.380s)
[225.010039] Starting dynamic subtest: pipe-B-DP-3
[225.159659] Dynamic subtest pipe-B-DP-3: SUCCESS (0.159s)
[225.361788] Starting dynamic subtest: pipe-C-DP-3
[225.519967] Dynamic subtest pipe-C-DP-3: SUCCESS (0.168s)
[225.733347] Starting dynamic subtest: pipe-D-DP-3
[225.882809] Dynamic subtest pipe-D-DP-3: SUCCESS (0.160s)
[225.883907] Subtest invalid-async-flip-atomic: SUCCESS (1.699s)
[226.384468] [035/131] (802s left) perf (polling)
[226.814481] Starting subtest: polling
[226.815370] Starting dynamic subtest: 0-rcs0
[236.829946] Dynamic subtest 0-rcs0: SUCCESS (10.015s)
[236.831085] Subtest polling: SUCCESS (10.016s)
[236.882051] [036/131] (791s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[237.068912] Starting subtest: plane-upscale-factor-0-25-with-rotation
[237.069760] Starting dynamic subtest: pipe-A
[237.453267] Dynamic subtest pipe-A: SUCCESS (0.384s)
[237.479393] Starting dynamic subtest: pipe-B
[237.932565] Dynamic subtest pipe-B: SUCCESS (0.478s)
[237.952478] Starting dynamic subtest: pipe-C
[238.412744] Dynamic subtest pipe-C: SUCCESS (0.479s)
[238.437984] Starting dynamic subtest: pipe-D
[238.892449] Dynamic subtest pipe-D: SUCCESS (0.479s)
[238.893453] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (1.824s)
[239.251764] [037/131] (789s left) kms_chamelium_audio (dp-audio)
[239.520446] Subtest dp-audio: SKIP (0.000s)
[239.670154] [038/131] (789s left) syncobj_timeline (invalid-query-illegal-handle)
[239.754245] Starting subtest: invalid-query-illegal-handle
[239.755168] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[239.909516] [039/131] (788s left) gem_mmap (big-bo)
[239.986010] Subtest big-bo: SKIP (0.000s)
[240.054692] [040/131] (788s left) gem_exec_params (rsvd2-dirt)
[240.137886] Starting subtest: rsvd2-dirt
[240.139736] Subtest rsvd2-dirt: SKIP (0.000s)
[240.335719] [041/131] (788s left) kms_pm_rpm (modeset-non-lpsp-stress)
[242.063817] Starting subtest: modeset-non-lpsp-stress
[247.951475] Subtest modeset-non-lpsp-stress: SUCCESS (5.889s)
[248.226431] [042/131] (780s left) kms_psr (psr2-basic)
[248.413060] Subtest psr2-basic: SKIP (0.000s)
[248.475566] [043/131] (780s left) gem_mmap_gtt (basic-small-bo)
[248.551980] Subtest basic-small-bo: SKIP (0.000s)
[248.623296] [044/131] (780s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[248.822912] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[251.365680] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.551s)
[251.634165] [045/131] (777s left) gem_ctx_param (vm)
[251.711549] Starting subtest: vm
[251.798863] Subtest vm: SUCCESS (0.087s)
[252.012755] [046/131] (777s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[252.212031] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[252.898273] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.686s)
[253.181363] [047/131] (776s left) kms_feature_discovery (display)
[253.367255] Starting subtest: display
[253.368168] Subtest display: SUCCESS (0.000s)
[253.537780] [048/131] (775s left) gem_eio (in-flight-internal-immediate)
[253.829210] Starting subtest: in-flight-internal-immediate
[254.911155] Subtest in-flight-internal-immediate: SUCCESS (1.082s)
[255.173993] [049/131] (774s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[255.366972] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[259.394052] Subtest fbc-1p-primscrn-cur-indfb-onoff: FAIL (3.694s)
[259.478497] [050/131] (770s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[259.677275] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[259.679192] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[259.881642] [051/131] (769s left) kms_flip (plain-flip-ts-check-interruptible)
[260.071512] Starting subtest: plain-flip-ts-check-interruptible
[260.076159] Starting dynamic subtest: A-DP3
[268.164120] Dynamic subtest A-DP3: SUCCESS (8.087s)
[268.206894] Starting dynamic subtest: B-DP3
[276.226526] Dynamic subtest B-DP3: SUCCESS (8.058s)
[276.244815] Starting dynamic subtest: C-DP3
[284.254183] Dynamic subtest C-DP3: SUCCESS (8.024s)
[284.269032] Starting dynamic subtest: D-DP3
[292.285238] Dynamic subtest D-DP3: SUCCESS (8.029s)
[292.290149] Subtest plain-flip-ts-check-interruptible: SUCCESS (32.218s)
[292.647734] [052/131] (737s left) kms_psr (fbc-psr-cursor-blt)
[292.834726] Subtest fbc-psr-cursor-blt: SKIP (0.000s)
[292.912725] [053/131] (736s left) kms_flip (2x-flip-vs-fences-interruptible)
[293.102358] Starting subtest: 2x-flip-vs-fences-interruptible
[293.104155] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[293.291964] [054/131] (736s left) kms_cursor_edge_walk (256x256-left-edge)
[293.476762] Starting subtest: 256x256-left-edge
[293.478946] Starting dynamic subtest: pipe-A-DP-3
[296.935606] Dynamic subtest pipe-A-DP-3: SUCCESS (3.457s)
[296.949627] Starting dynamic subtest: pipe-D-DP-3
[300.262563] Dynamic subtest pipe-D-DP-3: SUCCESS (3.324s)
[300.263538] Subtest 256x256-left-edge: SUCCESS (6.785s)
[300.595814] [055/131] (729s left) gem_exec_store (basic)
[300.684866] Starting subtest: basic
[300.843914] Subtest basic: SUCCESS (0.159s)
[301.179947] [056/131] (728s left) kms_flip (flip-vs-suspend)
[301.368013] Starting subtest: flip-vs-suspend
[301.372388] Starting dynamic subtest: A-DP3
[341.065057] Dynamic subtest A-DP3: SUCCESS (8.019s)
[341.081921] Starting dynamic subtest: B-DP3
[380.259466] Dynamic subtest B-DP3: SUCCESS (7.467s)
[380.272974] Starting dynamic subtest: C-DP3
[419.425809] Dynamic subtest C-DP3: SUCCESS (7.403s)
[419.441654] Starting dynamic subtest: D-DP3
[458.649430] Dynamic subtest D-DP3: SUCCESS (7.377s)
[458.650157] Subtest flip-vs-suspend: SUCCESS (30.282s)
[458.994000] [057/131] (571s left) kms_vblank (crtc-id)
[459.209086] Starting subtest: crtc-id
[459.209969] Starting dynamic subtest: pipe-A-DP-3
[459.588480] Dynamic subtest pipe-A-DP-3: SUCCESS (0.378s)
[459.609938] Starting dynamic subtest: pipe-D-DP-3
[459.903908] Dynamic subtest pipe-D-DP-3: SUCCESS (0.311s)
[459.904808] Subtest crtc-id: SUCCESS (0.696s)
[460.209813] [058/131] (570s left) kms_chamelium_frames (hdmi-crc-multiple)
[460.477459] Subtest hdmi-crc-multiple: SKIP (0.000s)
[460.632775] [059/131] (569s left) perf (non-sampling-read-error)
[460.876990] Starting subtest: non-sampling-read-error
[460.893127] Subtest non-sampling-read-error: SUCCESS (0.016s)
[460.952433] [060/131] (569s left) kms_lease (simple-lease)
[461.143064] Starting subtest: simple-lease
[461.143954] Starting dynamic subtest: pipe-A-DP-3
[461.617128] Dynamic subtest pipe-A-DP-3: SUCCESS (0.473s)
[461.634278] Starting dynamic subtest: pipe-B-DP-3
[462.004851] Dynamic subtest pipe-B-DP-3: SUCCESS (0.385s)
[462.019230] Starting dynamic subtest: pipe-C-DP-3
[462.390606] Dynamic subtest pipe-C-DP-3: SUCCESS (0.383s)
[462.411668] Starting dynamic subtest: pipe-D-DP-3
[462.779716] Dynamic subtest pipe-D-DP-3: SUCCESS (0.386s)
[462.780785] Subtest simple-lease: SUCCESS (1.637s)
[463.131768] [061/131] (567s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[463.331839] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[463.333551] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[463.532802] [062/131] (566s left) kms_psr (psr2-no-drrs)
[463.717877] Subtest psr2-no-drrs: SKIP (0.000s)
[463.774840] [063/131] (566s left) gem_exec_schedule (implicit-boths)
[463.865251] Starting subtest: implicit-boths
[463.866135] Starting dynamic subtest: rcs0
[464.163750] Dynamic subtest rcs0: SUCCESS (0.291s)
[464.176526] Starting dynamic subtest: bcs0
[464.366944] Dynamic subtest bcs0: SUCCESS (0.203s)
[464.379990] Starting dynamic subtest: vcs0
[464.577672] Dynamic subtest vcs0: SUCCESS (0.210s)
[464.593278] Starting dynamic subtest: vcs1
[464.908500] Dynamic subtest vcs1: SUCCESS (0.214s)
[464.920776] Starting dynamic subtest: vecs0
[464.994883] Dynamic subtest vecs0: SUCCESS (0.207s)
[465.009528] Starting dynamic subtest: vecs1
[465.216147] Dynamic subtest vecs1: SUCCESS (0.212s)
[465.228965] Starting dynamic subtest: ccs0
[465.435196] Dynamic subtest ccs0: SUCCESS (0.213s)
[465.436388] Subtest implicit-boths: SUCCESS (1.558s)
[465.947358] [064/131] (564s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[466.310615] Starting subtest: cursor-rapid-movement-128x128
[466.315092] Starting dynamic subtest: pipe-A-DP-3
[466.743341] Dynamic subtest pipe-A-DP-3: SUCCESS (0.428s)
[466.796042] Starting dynamic subtest: pipe-D-DP-3
[467.175391] Dynamic subtest pipe-D-DP-3: SUCCESS (0.391s)
[467.176415] Subtest cursor-rapid-movement-128x128: SUCCESS (0.865s)
[467.639370] [065/131] (563s left) kms_rotation_crc (bad-tiling)
[467.827183] Starting subtest: bad-tiling
[467.828943] Subtest bad-tiling: SKIP (0.001s)
[467.988504] [066/131] (562s left) gem_blits (basic)
[468.096869] Starting subtest: basic
[474.443950] Subtest basic: SUCCESS (6.346s)
[474.650643] [067/131] (556s left) gem_spin_batch (user-each)
[474.739235] Starting subtest: user-each
[478.156111] Subtest user-each: SUCCESS (3.417s)
[478.505054] [068/131] (552s left) gem_exec_params (invalid-ring2)
[478.591645] Starting subtest: invalid-ring2
[478.592628] Subtest invalid-ring2: SUCCESS (0.000s)
[478.753736] [069/131] (552s left) i915_getparams_basic (basic-subslice-total)
[478.839004] Starting subtest: basic-subslice-total
[478.840846] Subtest basic-subslice-total: SUCCESS (0.000s)
[479.040564] [070/131] (551s left) gem_userptr_blits (sync-unmap-cycles)
[479.130039] Starting subtest: sync-unmap-cycles
[484.520250] Subtest sync-unmap-cycles: SUCCESS (5.389s)
[484.741712] [071/131] (546s left) perf_pmu (idle-no-semaphores)
[484.812002] Starting subtest: idle-no-semaphores
[484.812941] Starting dynamic subtest: rcs0
[485.390754] Dynamic subtest rcs0: SUCCESS (0.577s)
[485.408351] Starting dynamic subtest: bcs0
[485.907012] Dynamic subtest bcs0: SUCCESS (0.511s)
[485.924249] Starting dynamic subtest: vcs0
[486.426134] Dynamic subtest vcs0: SUCCESS (0.514s)
[486.443345] Starting dynamic subtest: vcs1
[486.942908] Dynamic subtest vcs1: SUCCESS (0.512s)
[486.960362] Starting dynamic subtest: vecs0
[487.462087] Dynamic subtest vecs0: SUCCESS (0.514s)
[487.479868] Starting dynamic subtest: vecs1
[487.980083] Dynamic subtest vecs1: SUCCESS (0.513s)
[487.997875] Starting dynamic subtest: ccs0
[488.496968] Dynamic subtest ccs0: SUCCESS (0.512s)
[488.501483] Subtest idle-no-semaphores: SUCCESS (3.686s)
[488.676345] [072/131] (542s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[488.871022] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[488.872691] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[489.076818] [073/131] (542s left) gem_ctx_shared (q-independent)
[489.209181] Starting subtest: Q-independent
[489.210106] Starting dynamic subtest: rcs0
[489.447826] Dynamic subtest rcs0: SUCCESS (0.231s)
[489.461063] Starting dynamic subtest: bcs0
[489.602902] Dynamic subtest bcs0: SUCCESS (0.155s)
[489.616879] Starting dynamic subtest: vcs0
[489.760156] Dynamic subtest vcs0: SUCCESS (0.156s)
[489.774067] Starting dynamic subtest: vcs1
[489.919717] Dynamic subtest vcs1: SUCCESS (0.157s)
[489.933233] Starting dynamic subtest: vecs0
[490.074093] Dynamic subtest vecs0: SUCCESS (0.156s)
[490.088150] Starting dynamic subtest: vecs1
[490.236536] Dynamic subtest vecs1: SUCCESS (0.159s)
[490.250666] Starting dynamic subtest: ccs0
[490.397902] Dynamic subtest ccs0: SUCCESS (0.161s)
[490.398923] Subtest Q-independent: SUCCESS (1.182s)
[490.808059] [074/131] (540s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[490.996878] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[490.998574] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[491.198254] [075/131] (540s left) syncobj_wait (multi-wait-all-submitted)
[491.275181] Starting subtest: multi-wait-all-submitted
[491.378146] Subtest multi-wait-all-submitted: SUCCESS (0.102s)
[491.559873] [076/131] (539s left) kms_big_fb (x-tiled-addfb)
[491.760654] Starting subtest: x-tiled-addfb
[491.761539] Subtest x-tiled-addfb: SUCCESS (0.000s)
[491.974923] [077/131] (539s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[492.163993] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[492.168746] Starting dynamic subtest: A-DP3
[492.982443] Dynamic subtest A-DP3: SUCCESS (0.811s)
[493.009930] Starting dynamic subtest: B-DP3
[493.768208] Dynamic subtest B-DP3: SUCCESS (0.782s)
[493.784032] Starting dynamic subtest: C-DP3
[494.560189] Dynamic subtest C-DP3: SUCCESS (0.791s)
[494.587115] Starting dynamic subtest: D-DP3
[495.326252] Dynamic subtest D-DP3: SUCCESS (0.763s)
[495.329651] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (3.165s)
[495.673577] [078/131] (536s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[495.870971] Starting subtest: crc-primary-basic-yf-tiled-ccs
[495.871879] Starting dynamic subtest: pipe-A-DP-3
[495.880355] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[495.894226] Starting dynamic subtest: pipe-B-DP-3
[495.903338] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[495.917702] Starting dynamic subtest: pipe-C-DP-3
[495.926139] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[495.939787] Starting dynamic subtest: pipe-D-DP-3
[495.949917] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[495.952033] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.009s)
[496.372787] [079/131] (535s left) sw_sync (timeline_closed_signaled)
[496.425839] Starting subtest: timeline_closed_signaled
[496.426769] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[496.538707] [080/131] (535s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[496.615198] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[496.722374] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[496.854063] [081/131] (535s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[497.050809] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[498.083872] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (1.033s)
[498.370591] [082/131] (533s left) syncobj_timeline (etime-single-wait-submitted)
[498.448135] Starting subtest: etime-single-wait-submitted
[498.555125] Subtest etime-single-wait-submitted: SUCCESS (0.106s)
[498.734577] [083/131] (533s left) gem_eio (in-flight-internal-1us)
[499.034829] Starting subtest: in-flight-internal-1us
[499.870723] Subtest in-flight-internal-1us: SUCCESS (0.836s)
[500.167294] [084/131] (532s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[500.351208] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[500.353559] Starting dynamic subtest: pipe-A-DP-3
[500.361557] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[500.376177] Starting dynamic subtest: pipe-B-DP-3
[500.384699] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[500.399513] Starting dynamic subtest: pipe-C-DP-3
[500.408912] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[500.423457] Starting dynamic subtest: pipe-D-DP-3
[500.433131] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[500.435188] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[500.827798] [085/131] (531s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[501.019842] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[501.021567] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[501.227418] [086/131] (531s left) prime_vgem (fence-flip-hang)
[501.329068] Subtest fence-flip-hang: SKIP (0.000s)
[501.546545] [087/131] (530s left) kms_properties (plane-properties-legacy)
[501.734226] Starting subtest: plane-properties-legacy
[501.736671] Starting dynamic subtest: pipe-A-DP-3
[502.219833] Dynamic subtest pipe-A-DP-3: SUCCESS (0.483s)
[502.245570] Starting dynamic subtest: pipe-B-DP-3
[502.750015] Dynamic subtest pipe-B-DP-3: SUCCESS (0.529s)
[502.767321] Starting dynamic subtest: pipe-C-DP-3
[503.293937] Dynamic subtest pipe-C-DP-3: SUCCESS (0.542s)
[503.309815] Starting dynamic subtest: pipe-D-DP-3
[503.832842] Dynamic subtest pipe-D-DP-3: SUCCESS (0.536s)
[503.833757] Subtest plane-properties-legacy: SUCCESS (2.099s)
[504.145995] [088/131] (528s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[504.340757] Starting subtest: psr-rgb565-draw-render
[504.342543] Subtest psr-rgb565-draw-render: SKIP (0.000s)
[504.546592] [089/131] (528s left) kms_lease (lease-invalid-connector)
[504.738963] Starting subtest: lease-invalid-connector
[504.739867] Starting dynamic subtest: pipe-A-DP-3
[504.740731] Dynamic subtest pipe-A-DP-3: SUCCESS (0.000s)
[504.754852] Starting dynamic subtest: pipe-B-DP-3
[504.755739] Dynamic subtest pipe-B-DP-3: SUCCESS (0.000s)
[504.769740] Starting dynamic subtest: pipe-C-DP-3
[504.770813] Dynamic subtest pipe-C-DP-3: SUCCESS (0.000s)
[504.784400] Starting dynamic subtest: pipe-D-DP-3
[504.785372] Dynamic subtest pipe-D-DP-3: SUCCESS (0.000s)
[504.786539] Subtest lease-invalid-connector: SUCCESS (0.007s)
[504.891435] [090/131] (527s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[505.083807] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[505.085555] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[505.296408] [091/131] (527s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[505.484099] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[505.484973] Starting dynamic subtest: pipe-A-valid-mode
[507.355454] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.868s)
[507.356963] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (1.871s)
[507.687549] [092/131] (525s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[507.878083] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[507.879831] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[508.072656] [093/131] (524s left) gem_exec_balancer (parallel-contexts)
[508.468348] Starting subtest: parallel-contexts
[514.944350] Subtest parallel-contexts: SUCCESS (6.477s)
[515.106777] [094/131] (517s left) kms_debugfs (display-off-read-all)
[515.292451] Starting subtest: display-off-read-all
[515.381227] Subtest display-off-read-all: SUCCESS (0.089s)
[515.631358] [095/131] (517s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[515.827712] Starting subtest: fbc-rgb565-draw-render
[519.370138] Subtest fbc-rgb565-draw-render: SUCCESS (3.543s)
[519.588635] [096/131] (513s left) kms_plane_cursor (overlay)
[519.772643] Starting subtest: overlay
[519.774497] Starting dynamic subtest: pipe-A-DP-3-size-64
[523.035970] Dynamic subtest pipe-A-DP-3-size-64: SUCCESS (3.262s)
[523.151747] Starting dynamic subtest: pipe-A-DP-3-size-128
[526.370302] Dynamic subtest pipe-A-DP-3-size-128: SUCCESS (3.265s)
[526.468050] Starting dynamic subtest: pipe-A-DP-3-size-256
[529.703108] Dynamic subtest pipe-A-DP-3-size-256: SUCCESS (3.266s)
[529.881839] Starting dynamic subtest: pipe-B-DP-3-size-64
[533.199493] Dynamic subtest pipe-B-DP-3-size-64: SUCCESS (3.334s)
[533.286257] Starting dynamic subtest: pipe-B-DP-3-size-128
[536.500122] Dynamic subtest pipe-B-DP-3-size-128: SUCCESS (3.249s)
[536.593106] Starting dynamic subtest: pipe-B-DP-3-size-256
[539.833086] Dynamic subtest pipe-B-DP-3-size-256: SUCCESS (3.281s)
[540.002437] Starting dynamic subtest: pipe-C-DP-3-size-64
[543.333001] Dynamic subtest pipe-C-DP-3-size-64: SUCCESS (3.352s)
[543.420344] Starting dynamic subtest: pipe-C-DP-3-size-128
[546.599630] Dynamic subtest pipe-C-DP-3-size-128: SUCCESS (3.215s)
[546.663520] Starting dynamic subtest: pipe-C-DP-3-size-256
[549.933257] Dynamic subtest pipe-C-DP-3-size-256: SUCCESS (3.283s)
[550.078666] Starting dynamic subtest: pipe-D-DP-3-size-64
[553.311481] Dynamic subtest pipe-D-DP-3-size-64: SUCCESS (3.249s)
[553.374804] Starting dynamic subtest: pipe-D-DP-3-size-128
[556.611789] Dynamic subtest pipe-D-DP-3-size-128: SUCCESS (3.250s)
[556.694028] Starting dynamic subtest: pipe-D-DP-3-size-256
[559.861948] Dynamic subtest pipe-D-DP-3-size-256: SUCCESS (3.199s)
[559.988930] Subtest overlay: SUCCESS (40.214s)
[560.331350] [097/131] (472s left) kms_content_protection (srm)
[560.580826] Starting subtest: srm
[560.609919] Starting dynamic subtest: pipe-A-DP-3
[681.466115] Dynamic subtest pipe-A-DP-3: FAIL (120.679s)
[681.467275] Subtest srm: FAIL (120.808s)
[681.725626] [098/131] (351s left) prime_busy (hang-wait)
[681.809893] Starting subtest: hang-wait
[681.812106] Starting dynamic subtest: rcs0
[708.498464] Dynamic subtest rcs0: SUCCESS (26.684s)
[708.512937] Starting dynamic subtest: bcs0
[715.656432] Dynamic subtest bcs0: SUCCESS (7.156s)
[715.670895] Starting dynamic subtest: vcs0
[722.638252] Dynamic subtest vcs0: SUCCESS (6.981s)
[722.652517] Starting dynamic subtest: vcs1
[729.671771] Dynamic subtest vcs1: SUCCESS (7.033s)
[729.686313] Starting dynamic subtest: vecs0
[736.655116] Dynamic subtest vecs0: SUCCESS (6.981s)
[736.669521] Starting dynamic subtest: vecs1
[743.628243] Dynamic subtest vecs1: SUCCESS (6.972s)
[743.642528] Starting dynamic subtest: ccs0
[757.516471] Dynamic subtest ccs0: SUCCESS (13.887s)
[757.517392] Subtest hang-wait: SUCCESS (75.705s)
[757.706684] [099/131] (275s left) kms_vblank (ts-continuation-idle)
[757.891420] Starting subtest: ts-continuation-idle
[757.893836] Starting dynamic subtest: pipe-A-DP-3
[758.218476] Dynamic subtest pipe-A-DP-3: SUCCESS (0.324s)
[758.245320] Starting dynamic subtest: pipe-D-DP-3
[758.486650] Dynamic subtest pipe-D-DP-3: SUCCESS (0.262s)
[758.487558] Subtest ts-continuation-idle: SUCCESS (0.596s)
[758.788385] [100/131] (274s left) kms_async_flips (alternate-sync-async-flip)
[758.972401] Starting subtest: alternate-sync-async-flip
[759.201594] Starting dynamic subtest: pipe-A-DP-3
[761.502714] Dynamic subtest pipe-A-DP-3: SUCCESS (2.300s)
[761.751950] Starting dynamic subtest: pipe-B-DP-3
[763.872445] Dynamic subtest pipe-B-DP-3: SUCCESS (2.135s)
[764.089941] Starting dynamic subtest: pipe-C-DP-3
[766.211297] Dynamic subtest pipe-C-DP-3: SUCCESS (2.135s)
[766.424914] Starting dynamic subtest: pipe-D-DP-3
[768.529538] Dynamic subtest pipe-D-DP-3: SUCCESS (2.117s)
[768.536627] Subtest alternate-sync-async-flip: SUCCESS (9.559s)
[769.086649] [101/131] (264s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[769.273520] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[769.346158] [102/131] (264s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[769.536557] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[769.538168] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[769.733593] [103/131] (264s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[772.044710] Starting subtest: dpms-mode-unset-non-lpsp
[773.388411] Subtest dpms-mode-unset-non-lpsp: SUCCESS (1.347s)
[773.835974] [104/131] (260s left) gem_pxp (verify-pxp-stale-ctx-execution)
[776.437666] Starting subtest: verify-pxp-stale-ctx-execution
[776.439695] Subtest verify-pxp-stale-ctx-execution: SKIP (0.000s)
[776.588909] [105/131] (257s left) sysfs_preempt_timeout (idempotent)
[776.678970] Starting subtest: idempotent
[776.681150] Starting dynamic subtest: vecs0
[776.682000] Dynamic subtest vecs0: SUCCESS (0.001s)
[776.696878] Starting dynamic subtest: ccs0
[776.698103] Dynamic subtest ccs0: SUCCESS (0.001s)
[776.712444] Starting dynamic subtest: vcs0
[776.713456] Dynamic subtest vcs0: SUCCESS (0.001s)
[776.727950] Starting dynamic subtest: bcs0
[776.729260] Dynamic subtest bcs0: SUCCESS (0.001s)
[776.743743] Starting dynamic subtest: vecs1
[776.744886] Dynamic subtest vecs1: SUCCESS (0.001s)
[776.759461] Starting dynamic subtest: rcs0
[776.760297] Dynamic subtest rcs0: SUCCESS (0.001s)
[776.774851] Starting dynamic subtest: vcs1
[776.776062] Dynamic subtest vcs1: SUCCESS (0.001s)
[776.777321] Subtest idempotent: SUCCESS (0.013s)
[776.841312] [106/131] (257s left) gem_mmap_gtt (basic-small-bo-tiledy)
[776.916943] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[776.985626] [107/131] (257s left) kms_plane_scaling (intel-max-src-size)
[777.170822] Starting subtest: intel-max-src-size
[777.176121] Starting dynamic subtest: pipe-A-DP-3
[777.364442] Dynamic subtest pipe-A-DP-3: SUCCESS (0.187s)
[777.370304] Subtest intel-max-src-size: SUCCESS (0.197s)
[777.838100] [108/131] (256s left) kms_color (invalid-gamma-lut-sizes)
[778.027586] Starting subtest: invalid-gamma-lut-sizes
[778.028537] Starting dynamic subtest: pipe-A
[778.110915] Dynamic subtest pipe-A: SUCCESS (0.082s)
[778.128511] Starting dynamic subtest: pipe-B
[778.129437] Dynamic subtest pipe-B: SUCCESS (0.001s)
[778.143621] Starting dynamic subtest: pipe-C
[778.144582] Dynamic subtest pipe-C: SUCCESS (0.001s)
[778.159055] Starting dynamic subtest: pipe-D
[778.160319] Dynamic subtest pipe-D: SUCCESS (0.001s)
[778.161478] Subtest invalid-gamma-lut-sizes: SUCCESS (0.090s)
[778.378530] [109/131] (255s left) kms_psr (fbc-pr-primary-mmap-gtt)
[778.566343] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[778.637619] [110/131] (255s left) gem_exec_schedule (semaphore-codependency)
[778.731183] Starting subtest: semaphore-codependency
[778.773025] Subtest semaphore-codependency: SUCCESS (0.042s)
[779.227212] [111/131] (255s left) kms_addfb_basic (bad-pitch-63)
[779.306625] Starting subtest: bad-pitch-63
[779.307574] Subtest bad-pitch-63: SUCCESS (0.000s)
[779.628537] [112/131] (254s left) i915_pm_rpm (gem-execbuf)
[782.034510] Starting subtest: gem-execbuf
[782.035838] Starting dynamic subtest: lmem0
[784.749628] Dynamic subtest lmem0: SUCCESS (2.715s)
[784.785708] Starting dynamic subtest: smem0
[789.035395] Dynamic subtest smem0: SUCCESS (4.281s)
[789.036547] Subtest gem-execbuf: SUCCESS (7.005s)
[789.456267] [113/131] (245s left) syncobj_basic (bad-pad-fd-to-handle)
[789.539235] Starting subtest: bad-pad-fd-to-handle
[789.540108] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[789.710620] [114/131] (244s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[789.904114] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[789.905884] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[790.115155] [115/131] (244s left) gem_userptr_blits (process-exit)
[790.206937] Starting subtest: process-exit
[790.215731] Subtest process-exit: SUCCESS (0.009s)
[790.433250] [116/131] (244s left) kms_atomic_interruptible (universal-setplane-cursor)
[790.625261] Starting subtest: universal-setplane-cursor
[790.626135] Starting dynamic subtest: pipe-A-DP-3
[796.922650] Dynamic subtest pipe-A-DP-3: SUCCESS (6.296s)
[796.923979] Subtest universal-setplane-cursor: SUCCESS (6.299s)
[797.217810] [117/131] (237s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[797.407936] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[800.384511] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (2.977s)
[800.649757] [118/131] (234s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[800.727040] Starting subtest: single-wait-all-for-submit-signaled
[800.728098] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[800.900232] [119/131] (234s left) kms_force_connector_basic (force-connector-state)
[801.007605] Starting subtest: force-connector-state
[801.370034] Subtest force-connector-state: SUCCESS (0.362s)
[801.801269] [120/131] (233s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[801.991849] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[801.993590] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[802.207614] [121/131] (232s left) gem_eio (in-flight-immediate)
[802.518300] Starting subtest: in-flight-immediate
[807.582411] Subtest in-flight-immediate: SUCCESS (5.064s)
[807.868663] [122/131] (227s left) gen9_exec_parse (bb-secure)
[807.958104] Subtest bb-secure: SKIP (0.000s)
[808.060228] [123/131] (227s left) gem_spin_batch (engines)
[808.146880] Starting subtest: engines
[808.147841] Starting dynamic subtest: rcs0
[811.411010] Dynamic subtest rcs0: SUCCESS (3.261s)
[811.430013] Starting dynamic subtest: bcs0
[814.646945] Dynamic subtest bcs0: SUCCESS (3.231s)
[814.663870] Starting dynamic subtest: vcs0
[817.881291] Dynamic subtest vcs0: SUCCESS (3.230s)
[817.900966] Starting dynamic subtest: vcs1
[821.113910] Dynamic subtest vcs1: SUCCESS (3.229s)
[821.129270] Starting dynamic subtest: vecs0
[824.343761] Dynamic subtest vecs0: SUCCESS (3.227s)
[824.367092] Starting dynamic subtest: vecs1
[827.585646] Dynamic subtest vecs1: SUCCESS (3.237s)
[827.603391] Starting dynamic subtest: ccs0
[830.820316] Dynamic subtest ccs0: SUCCESS (3.230s)
[830.822121] Subtest engines: SUCCESS (22.673s)
[831.146594] [124/131] (204s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[831.226124] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[831.329806] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.103s)
[831.509054] [125/131] (203s left) gem_lmem_swapping (heavy-random)
[834.346651] Starting subtest: heavy-random
[834.347707] Starting dynamic subtest: lmem0
[839.965623] Dynamic subtest lmem0: SUCCESS (5.618s)
[839.966545] Subtest heavy-random: SUCCESS (5.619s)
[841.185525] [FACT gem_lmem_swapping (heavy-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[841.186479] [FACT gem_lmem_swapping (heavy-random)] deleted: kernel.kmod_is_loaded.i915: true
[841.188495] [126/131] (194s left) i915_drm_fdinfo (busy-hang)
[842.850474] Starting subtest: busy-hang
[842.851806] Starting dynamic subtest: rcs0
[842.869141] Dynamic subtest rcs0: SKIP (0.018s)
[842.882235] Starting dynamic subtest: bcs0
[842.883976] Dynamic subtest bcs0: SKIP (0.001s)
[842.896171] Starting dynamic subtest: vcs0
[842.898192] Dynamic subtest vcs0: SKIP (0.001s)
[842.910840] Starting dynamic subtest: vcs1
[842.912914] Dynamic subtest vcs1: SKIP (0.001s)
[842.925073] Starting dynamic subtest: vecs0
[842.927414] Dynamic subtest vecs0: SKIP (0.001s)
[842.939451] Starting dynamic subtest: vecs1
[842.941765] Dynamic subtest vecs1: SKIP (0.001s)
[842.953876] Starting dynamic subtest: ccs0
[842.956289] Dynamic subtest ccs0: SKIP (0.001s)
[842.958534] Subtest busy-hang: SKIP (0.031s)
[843.002132] [FACT i915_drm_fdinfo (busy-hang)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[843.004565] [FACT i915_drm_fdinfo (busy-hang)] new: kernel.kmod_is_loaded.i915: true
[843.007493] [127/131] (192s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[843.199721] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[843.201541] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[843.373542] [128/131] (192s left) kms_psr (psr-suspend)
[843.559552] Subtest psr-suspend: SKIP (0.000s)
[843.653711] [129/131] (192s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[843.850248] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[843.910449] [130/131] (191s left) gem_exec_balancer (hang)
[844.261915] Starting subtest: hang
[847.644931] Subtest hang: SUCCESS (3.383s)
[847.817701] [131/131] (188s left) gem_exec_params (invalid-ring)
[847.900825] Starting subtest: invalid-ring
[847.901787] Subtest invalid-ring: SUCCESS (0.000s)
[848.109454] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_gtt
results: parsing output: 1/ for test: gem_exec_fence
results: parsing output: 2/ for test: gem_linear_blits
results: parsing output: 3/ for test: kms_cursor_legacy
results: parsing output: 4/ for test: gem_exec_reloc
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: i915_query
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: perf
results: parsing output: 9/ for test: perf
results: parsing output: 10/ for test: kms_chamelium_hpd
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_create
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_pxp
results: parsing output: 15/ for test: device_reset
results: parsing output: 16/ for test: gem_mmap_gtt
results: parsing output: 17/ for test: syncobj_wait
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_psr2_sf
results: parsing output: 21/ for test: syncobj_wait
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_joiner
results: parsing output: 24/ for test: gem_render_copy_redux
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: kms_sequence
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_ctx_persistence
results: parsing output: 30/ for test: gem_exec_schedule
results: parsing output: 31/ for test: gem_render_copy
results: parsing output: 32/ for test: api_intel_bb
results: parsing output: 33/ for test: kms_async_flips
results: parsing output: 34/ for test: perf
results: parsing output: 35/ for test: kms_plane_scaling
results: parsing output: 36/ for test: kms_chamelium_audio
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: gem_mmap
results: parsing output: 39/ for test: gem_exec_params
results: parsing output: 40/ for test: kms_pm_rpm
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_ctx_param
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_feature_discovery
results: parsing output: 47/ for test: gem_eio
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_cursor_edge_walk
results: parsing output: 54/ for test: gem_exec_store
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: kms_vblank
results: parsing output: 57/ for test: kms_chamelium_frames
results: parsing output: 58/ for test: perf
results: parsing output: 59/ for test: kms_lease
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: gem_exec_schedule
results: parsing output: 63/ for test: kms_cursor_crc
results: parsing output: 64/ for test: kms_rotation_crc
results: parsing output: 65/ for test: gem_blits
results: parsing output: 66/ for test: gem_spin_batch
results: parsing output: 67/ for test: gem_exec_params
results: parsing output: 68/ for test: i915_getparams_basic
results: parsing output: 69/ for test: gem_userptr_blits
results: parsing output: 70/ for test: perf_pmu
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_ctx_shared
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: syncobj_wait
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: sw_sync
results: parsing output: 79/ for test: syncobj_wait
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: gem_eio
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: prime_vgem
results: parsing output: 86/ for test: kms_properties
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_lease
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_flip_scaled_crc
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_exec_balancer
results: parsing output: 93/ for test: kms_debugfs
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_plane_cursor
results: parsing output: 96/ for test: kms_content_protection
results: parsing output: 97/ for test: prime_busy
results: parsing output: 98/ for test: kms_vblank
results: parsing output: 99/ for test: kms_async_flips
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_pm_rpm
results: parsing output: 103/ for test: gem_pxp
results: parsing output: 104/ for test: sysfs_preempt_timeout
results: parsing output: 105/ for test: gem_mmap_gtt
results: parsing output: 106/ for test: kms_plane_scaling
results: parsing output: 107/ for test: kms_color
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: gem_exec_schedule
results: parsing output: 110/ for test: kms_addfb_basic
results: parsing output: 111/ for test: i915_pm_rpm
results: parsing output: 112/ for test: syncobj_basic
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: gem_userptr_blits
results: parsing output: 115/ for test: kms_atomic_interruptible
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: kms_force_connector_basic
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_eio
results: parsing output: 121/ for test: gen9_exec_parse
results: parsing output: 122/ for test: gem_spin_batch
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: gem_lmem_swapping
results: parsing output: 125/ for test: i915_drm_fdinfo
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_psr2_sf
results: parsing output: 129/ for test: gem_exec_balancer
results: parsing output: 130/ for test: gem_exec_params
Done.