[60.841370] Initializing watchdogs
[60.841494]   /dev/watchdog0
[60.854743] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[60.858550] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.860789] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.863672] [001/130] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[61.042403] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[65.298641] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (4.259s)
[65.436821] [002/130] (955s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[65.543317] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[66.543065] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.000s)
[66.677910] [003/130] (954s left) prime_vgem (basic-fence-mmap)
[66.788079] Starting subtest: basic-fence-mmap
[66.792824] Subtest basic-fence-mmap: SKIP (0.000s)
[66.867678] [FACT prime_vgem (basic-fence-mmap)] new: kernel.kmod_is_loaded.vgem: true
[66.870546] [004/130] (954s left) gem_ctx_exec (basic-invalid-context)
[66.924036] Starting subtest: basic-invalid-context
[66.928281] Subtest basic-invalid-context: SUCCESS (0.004s)
[67.007858] [005/130] (954s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[67.116021] Starting subtest: fbcpsr-1p-rte
[72.143052] Subtest fbcpsr-1p-rte: SUCCESS (5.029s)
[72.257218] [006/130] (949s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[72.366289] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[72.370529] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[72.446943] [007/130] (949s left) gem_softpin (allocator-nopin-reserve)
[72.515292] Starting subtest: allocator-nopin-reserve
[72.634214] Subtest allocator-nopin-reserve: SUCCESS (0.117s)
[72.760180] [008/130] (948s left) gem_fence_thrash (bo-write-verify-threaded-none)
[72.794983] Starting subtest: bo-write-verify-threaded-none
[72.815939] Subtest bo-write-verify-threaded-none: SKIP (0.018s)
[72.875866] [009/130] (948s left) kms_cursor_crc (cursor-onscreen-64x21)
[73.037669] Starting subtest: cursor-onscreen-64x21
[73.088679] Subtest cursor-onscreen-64x21: SKIP (0.046s)
[73.323873] [010/130] (948s left) vgem_slow (nohang)
[73.369935] Starting subtest: nohang
[83.591842] Subtest nohang: SUCCESS (10.222s)
[83.649561] [011/130] (938s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[83.754525] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[83.756879] Starting dynamic subtest: pipe-A-eDP-1
[83.766703] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[83.779209] Starting dynamic subtest: pipe-B-eDP-1
[83.788691] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[83.797609] Starting dynamic subtest: pipe-C-eDP-1
[83.806089] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[83.812487] Starting dynamic subtest: pipe-D-eDP-1
[83.821111] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[83.825340] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.002s)
[85.901398] [012/130] (935s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[88.035954] Starting subtest: dpms-mode-unset-non-lpsp
[89.197620] Subtest dpms-mode-unset-non-lpsp: SKIP (1.157s)
[89.554565] [013/130] (932s left) gem_exec_schedule (preempt-self)
[89.639269] Starting subtest: preempt-self
[89.641515] Starting dynamic subtest: rcs0
[89.651978] Dynamic subtest rcs0: SUCCESS (0.017s)
[89.659148] Starting dynamic subtest: bcs0
[89.665842] Dynamic subtest bcs0: SUCCESS (0.014s)
[89.672660] Starting dynamic subtest: vcs0
[89.685088] Dynamic subtest vcs0: SUCCESS (0.019s)
[89.698694] Starting dynamic subtest: vcs1
[89.704051] Dynamic subtest vcs1: SUCCESS (0.017s)
[89.713250] Starting dynamic subtest: vecs0
[89.721817] Dynamic subtest vecs0: SUCCESS (0.020s)
[89.728644] Starting dynamic subtest: ccs0
[89.737353] Dynamic subtest ccs0: SUCCESS (0.015s)
[89.739185] Subtest preempt-self: SUCCESS (0.102s)
[91.027452] [014/130] (930s left) gem_eio (in-flight-internal-1us)
[91.258250] Starting subtest: in-flight-internal-1us
[92.983305] Subtest in-flight-internal-1us: SUCCESS (1.723s)
[93.139076] [015/130] (928s left) perf_pmu (idle-no-semaphores)
[93.178688] Starting subtest: idle-no-semaphores
[93.181056] Starting dynamic subtest: rcs0
[93.740829] Dynamic subtest rcs0: SUCCESS (0.562s)
[93.751644] Starting dynamic subtest: bcs0
[94.268687] Dynamic subtest bcs0: SUCCESS (0.527s)
[94.279290] Starting dynamic subtest: vcs0
[94.797349] Dynamic subtest vcs0: SUCCESS (0.528s)
[94.806645] Starting dynamic subtest: vcs1
[95.319064] Dynamic subtest vcs1: SUCCESS (0.521s)
[95.328640] Starting dynamic subtest: vecs0
[95.849443] Dynamic subtest vecs0: SUCCESS (0.530s)
[95.859453] Starting dynamic subtest: ccs0
[96.376348] Dynamic subtest ccs0: SUCCESS (0.527s)
[96.378973] Subtest idle-no-semaphores: SUCCESS (3.198s)
[96.464926] [016/130] (925s left) gem_exec_fence (syncobj-invalid-wait)
[96.901401] Starting subtest: syncobj-invalid-wait
[96.903778] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[97.998559] [017/130] (923s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[98.089726] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[98.091857] Starting dynamic subtest: pipe-A-eDP-1
[98.116155] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[98.123631] Starting dynamic subtest: pipe-B-eDP-1
[98.146659] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[98.153420] Starting dynamic subtest: pipe-C-eDP-1
[98.176690] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[98.184041] Starting dynamic subtest: pipe-D-eDP-1
[98.207766] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[98.212199] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.002s)
[100.217878] [018/130] (921s left) vgem_basic (second-client)
[100.266529] Starting subtest: second-client
[100.288055] Subtest second-client: SUCCESS (0.022s)
[100.338817] [019/130] (921s left) gem_pxp (create-regular-context-1)
[100.452889] Starting subtest: create-regular-context-1
[100.455830] Subtest create-regular-context-1: SUCCESS (0.002s)
[100.553999] [020/130] (921s left) gem_exec_capture (capture-invisible)
[100.616987] Starting subtest: capture-invisible
[100.619382] Starting dynamic subtest: smem0
[100.623169] Dynamic subtest smem0: SKIP (0.000s)
[100.627248] Subtest capture-invisible: SKIP (0.000s)
[100.747708] [021/130] (921s left) i915_pm_rc6_residency (rc6-accuracy)
[100.803447] Starting subtest: rc6-accuracy
[100.805683] Starting dynamic subtest: gt0
[103.975220] Dynamic subtest gt0: SUCCESS (3.168s)
[103.985894] Starting dynamic subtest: gt1
[107.144554] Dynamic subtest gt1: SUCCESS (3.168s)
[107.147234] Subtest rc6-accuracy: SUCCESS (6.339s)
[107.212737] [022/130] (914s left) kms_rotation_crc (bad-tiling)
[107.318546] Starting subtest: bad-tiling
[107.323094] Subtest bad-tiling: SKIP (0.001s)
[107.387180] [023/130] (914s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[107.491028] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[107.495544] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[107.589571] [024/130] (914s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[107.689662] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[107.693668] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[107.786644] [025/130] (914s left) api_intel_bb (blit-noreloc-purge-cache)
[107.850922] Starting subtest: blit-noreloc-purge-cache
[107.860056] Subtest blit-noreloc-purge-cache: SUCCESS (0.011s)
[107.999144] [026/130] (914s left) gem_ctx_param (root-set)
[108.055802] Starting subtest: root-set
[108.058168] Subtest root-set: SUCCESS (0.001s)
[108.159626] [027/130] (914s left) gem_spin_batch (resubmit)
[108.222561] Starting subtest: resubmit
[108.224581] Starting dynamic subtest: rcs0
[108.230040] Dynamic subtest rcs0: SUCCESS (0.008s)
[108.237302] Starting dynamic subtest: bcs0
[108.239193] Dynamic subtest bcs0: SUCCESS (0.003s)
[108.246127] Starting dynamic subtest: vcs0
[108.247907] Dynamic subtest vcs0: SUCCESS (0.005s)
[108.254312] Starting dynamic subtest: vcs1
[108.255903] Dynamic subtest vcs1: SUCCESS (0.002s)
[108.262202] Starting dynamic subtest: vecs0
[108.263748] Dynamic subtest vecs0: SUCCESS (0.002s)
[108.270097] Starting dynamic subtest: ccs0
[108.271660] Dynamic subtest ccs0: SUCCESS (0.003s)
[108.273298] Subtest resubmit: SUCCESS (0.024s)
[108.477878] [028/130] (913s left) gem_madvise (dontneed-before-mmap)
[108.512770] Starting subtest: dontneed-before-mmap
[108.534370] Subtest dontneed-before-mmap: SUCCESS (0.023s)
[108.624083] [029/130] (913s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[108.725261] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[108.728819] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[108.836227] [030/130] (913s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[108.930058] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[108.940519] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.011s)
[109.012366] [031/130] (913s left) kms_vblank (wait-forked-busy)
[109.112480] Starting subtest: wait-forked-busy
[109.114501] Starting dynamic subtest: pipe-A-eDP-1
[110.989974] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.873s)
[111.003558] Starting dynamic subtest: pipe-D-eDP-1
[113.573146] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.583s)
[113.575356] Subtest wait-forked-busy: SUCCESS (4.459s)
[114.368211] [032/130] (908s left) kms_psr (fbc-psr-cursor-plane-move)
[114.464230] Starting subtest: fbc-psr-cursor-plane-move
[114.466488] Starting dynamic subtest: eDP-1
[114.470631] Dynamic subtest eDP-1: SKIP (0.000s)
[114.474730] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[114.528451] [033/130] (907s left) kms_force_connector_basic (prune-stale-modes)
[114.619487] Starting subtest: prune-stale-modes
[115.045459] Subtest prune-stale-modes: SUCCESS (0.426s)
[115.184365] [034/130] (907s left) gem_userptr_blits (forbidden-operations)
[115.244298] Starting subtest: forbidden-operations
[115.248718] Subtest forbidden-operations: SKIP (0.000s)
[115.380432] [035/130] (907s left) gem_workarounds (reset)
[115.438246] Starting subtest: reset
[115.592772] Subtest reset: SUCCESS (0.154s)
[115.735334] [036/130] (906s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[115.843311] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[115.846842] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[115.940835] [037/130] (906s left) gem_ctx_persistence (userptr)
[116.000086] Starting subtest: userptr
[116.207249] Subtest userptr: SUCCESS (0.207s)
[116.278353] [038/130] (906s left) perf (gen12-invalid-class-instance)
[116.384864] Starting subtest: gen12-invalid-class-instance
[116.400209] Subtest gen12-invalid-class-instance: SUCCESS (0.015s)
[116.434038] [039/130] (906s left) gen9_exec_parse (allowed-all)
[116.488154] Subtest allowed-all: SKIP (0.000s)
[116.562573] [040/130] (906s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[116.649543] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[116.660200] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.010s)
[116.768895] [041/130] (905s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[116.826663] Starting subtest: etime-multi-wait-available-unsubmitted
[116.934970] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.106s)
[117.001276] [042/130] (905s left) gem_reg_read (timestamp-moving)
[117.061227] Starting subtest: timestamp-moving
[118.062358] Subtest timestamp-moving: SUCCESS (1.001s)
[118.132249] [043/130] (904s left) kms_cursor_edge_walk (128x128-right-edge)
[118.231880] Starting subtest: 128x128-right-edge
[118.234162] Starting dynamic subtest: pipe-A-eDP-1
[121.703583] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.468s)
[121.712441] Starting dynamic subtest: pipe-D-eDP-1
[124.798980] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.095s)
[124.801285] Subtest 128x128-right-edge: SUCCESS (6.564s)
[125.587740] [044/130] (897s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[125.697954] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[125.702588] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[126.780220] [045/130] (896s left) gem_ctx_param (basic-default)
[126.838755] Starting subtest: basic-default
[126.841132] Subtest basic-default: SUCCESS (0.000s)
[126.912120] [046/130] (895s left) syncobj_wait (multi-wait-for-submit-submitted)
[126.964245] Starting subtest: multi-wait-for-submit-submitted
[127.071115] Subtest multi-wait-for-submit-submitted: SUCCESS (0.107s)
[127.143851] [047/130] (895s left) syncobj_wait (invalid-reset-bad-pad)
[127.201027] Starting subtest: invalid-reset-bad-pad
[127.203414] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[127.298873] [048/130] (895s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[127.394247] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[127.398160] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[127.494991] [049/130] (895s left) kms_chamelium_hpd (vga-hpd-fast)
[127.870180] Subtest vga-hpd-fast: SKIP (0.000s)
[128.659511] [050/130] (894s left) gem_close (many-handles-one-vma)
[128.715259] Starting subtest: many-handles-one-vma
[128.738065] Subtest many-handles-one-vma: SUCCESS (0.024s)
[128.881822] [051/130] (894s left) gem_exec_flush (basic-batch-kernel-default-uc)
[128.944605] Starting subtest: basic-batch-kernel-default-uc
[135.877905] Subtest basic-batch-kernel-default-uc: SUCCESS (6.933s)
[136.060206] [052/130] (886s left) kms_feature_discovery (display-1x)
[136.157754] Starting subtest: display-1x
[136.159677] Subtest display-1x: SUCCESS (0.000s)
[136.222861] [053/130] (886s left) kms_atomic_transition (modeset-transition-fencing)
[136.326245] Starting subtest: modeset-transition-fencing
[136.328474] Starting dynamic subtest: 1x-outputs
[146.980846] Dynamic subtest 1x-outputs: SUCCESS (10.653s)
[147.256729] Subtest modeset-transition-fencing: SUCCESS (10.927s)
[148.079448] [054/130] (875s left) kms_plane_alpha_blend (alpha-opaque-fb)
[148.190942] Starting subtest: alpha-opaque-fb
[148.603502] Starting dynamic subtest: pipe-A-eDP-1
[149.171944] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.566s)
[149.181390] Starting dynamic subtest: pipe-D-eDP-1
[150.506758] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.335s)
[150.509304] Subtest alpha-opaque-fb: SUCCESS (2.315s)
[151.379502] [055/130] (871s left) gem_exec_schedule (u-fairslice-all)
[151.448865] Starting subtest: u-fairslice-all
[153.508098] Subtest u-fairslice-all: SUCCESS (2.065s)
[153.800266] [056/130] (869s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[153.856238] Starting subtest: multi-wait-all-available-submitted-signaled
[153.858578] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[153.960286] [057/130] (869s left) perf (buffer-fill)
[154.040181] Starting subtest: buffer-fill
[154.042552] Starting dynamic subtest: 0-rcs0
[156.345069] Dynamic subtest 0-rcs0: SUCCESS (2.302s)
[156.352949] Starting dynamic subtest: 1-vecs0
[160.774979] Dynamic subtest 1-vecs0: SUCCESS (4.430s)
[160.777759] Subtest buffer-fill: SUCCESS (6.733s)
[160.828717] [058/130] (862s left) kms_prop_blob (blob-multiple)
[160.884861] Starting subtest: blob-multiple
[160.887207] Subtest blob-multiple: SUCCESS (0.002s)
[160.992791] [059/130] (862s left) gem_create (create-ext-cpu-access-big)
[161.161824] Starting subtest: create-ext-cpu-access-big
[161.166462] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[161.228301] [060/130] (862s left) kms_cursor_crc (cursor-sliding-32x32)
[161.356447] Starting subtest: cursor-sliding-32x32
[161.396132] Subtest cursor-sliding-32x32: SKIP (0.033s)
[161.681132] [061/130] (861s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[161.778610] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[166.902239] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (5.127s)
[167.020177] [062/130] (856s left) gem_exec_whisper (basic-contexts-all)
[167.085167] Starting subtest: basic-contexts-all
[177.666313] Subtest basic-contexts-all: SUCCESS (10.577s)
[177.839171] [063/130] (845s left) kms_tiled_display (basic-test-pattern)
[177.959117] Subtest basic-test-pattern: SKIP (0.000s)
[177.997337] [064/130] (845s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[178.101631] Starting subtest: y-tiled-32bpp-rotate-180
[178.105654] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[178.209228] [065/130] (845s left) kms_plane (plane-panning-bottom-right-suspend)
[178.309994] Starting subtest: plane-panning-bottom-right-suspend
[178.312281] Starting dynamic subtest: pipe-A
[196.309766] Dynamic subtest pipe-A: SUCCESS (2.902s)
[196.324972] Starting dynamic subtest: pipe-B
[214.233186] Dynamic subtest pipe-B: SUCCESS (3.444s)
[214.235781] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.348s)
[215.074657] [066/130] (838s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[215.182460] Starting subtest: yf-tiled-8bpp-rotate-270
[215.188281] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[215.296073] [067/130] (837s left) perf_pmu (all-busy-idle-check-all)
[215.337036] Starting subtest: all-busy-idle-check-all
[216.050262] Subtest all-busy-idle-check-all: FAIL (0.635s)
[216.563421] [068/130] (836s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[216.674075] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[220.966084] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (4.294s)
[221.083604] [069/130] (832s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[221.182266] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[222.485965] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: FAIL (0.651s)
[222.518734] [070/130] (830s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[222.613906] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[227.101426] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (4.490s)
[227.231951] [071/130] (826s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[227.339158] Starting subtest: fbc-rgb565-draw-mmap-gtt
[227.344237] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[227.432265] [072/130] (825s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[227.533482] Starting subtest: psr-indfb-scaledprimary
[231.089421] Subtest psr-indfb-scaledprimary: SUCCESS (3.558s)
[231.219634] [073/130] (822s left) kms_addfb_basic (invalid-get-prop)
[231.274690] Starting subtest: invalid-get-prop
[231.277568] Subtest invalid-get-prop: SUCCESS (0.000s)
[231.395681] [074/130] (822s left) gem_exec_reloc (basic-concurrent16)
[231.461815] Subtest basic-concurrent16: SKIP (0.000s)
[231.541550] [075/130] (821s left) gem_ctx_param (invalid-ctx-get)
[231.584459] Starting subtest: invalid-ctx-get
[231.587141] Subtest invalid-ctx-get: SUCCESS (0.000s)
[231.643449] [076/130] (821s left) gem_tiled_fence_blits (basic)
[231.702401] Subtest basic: SKIP (0.000s)
[231.786783] [077/130] (821s left) gem_exec_balancer (noheartbeat)
[232.042417] Starting subtest: noheartbeat
[232.047544] Subtest noheartbeat: SKIP (0.000s)
[232.166086] [078/130] (821s left) kms_cursor_crc (cursor-alpha-opaque)
[232.276538] Starting subtest: cursor-alpha-opaque
[232.279202] Starting dynamic subtest: pipe-A-eDP-1
[232.910519] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.634s)
[232.925000] Starting dynamic subtest: pipe-D-eDP-1
[234.251854] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.340s)
[234.255100] Subtest cursor-alpha-opaque: SUCCESS (1.976s)
[235.078129] [079/130] (818s left) kms_flip (flip-vs-panning-vs-hang)
[235.177992] Starting subtest: flip-vs-panning-vs-hang
[235.180516] Starting dynamic subtest: A-eDP1
[286.998775] Dynamic subtest A-eDP1: SUCCESS (51.820s)
[287.010268] Starting dynamic subtest: D-eDP1
[336.982544] Dynamic subtest D-eDP1: SUCCESS (49.978s)
[336.985648] Subtest flip-vs-panning-vs-hang: SUCCESS (101.803s)
[338.170808] [080/130] (715s left) drm_fdinfo (virtual-idle)
[338.211159] Starting subtest: virtual-idle
[341.247937] Subtest virtual-idle: SUCCESS (3.036s)
[341.318955] [081/130] (712s left) gem_mmap (bad-offset)
[341.379273] Subtest bad-offset: SKIP (0.000s)
[341.454930] [082/130] (712s left) kms_psr2_su (page_flip-p010)
[341.508801] Subtest page_flip-P010: SKIP (0.000s)
[341.564205] [083/130] (712s left) i915_pm_rps (thresholds)
[341.626403] Starting subtest: thresholds
[341.632229] Subtest thresholds: SKIP (0.001s)
[341.706812] [084/130] (712s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[341.806413] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[341.809506] Starting dynamic subtest: pipe-A-default-mode
[342.105320] Dynamic subtest pipe-A-default-mode: SKIP (0.294s)
[342.110880] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.295s)
[342.970544] [085/130] (710s left) syncobj_wait (multi-wait-submitted-signaled)
[343.022085] Starting subtest: multi-wait-submitted-signaled
[343.024960] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[343.108738] [086/130] (710s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[343.214345] Starting subtest: x-tiled-64bpp-rotate-180
[345.563795] Subtest x-tiled-64bpp-rotate-180: SUCCESS (2.350s)
[345.781653] [087/130] (708s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[345.878587] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[345.883856] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[345.959700] [088/130] (707s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[346.011167] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[346.066587] [089/130] (707s left) kms_frontbuffer_tracking (fbc-tiling-y)
[346.169188] Starting subtest: fbc-tiling-y
[346.174173] Subtest fbc-tiling-y: SKIP (0.000s)
[346.267547] [090/130] (707s left) kms_vblank (invalid)
[346.363661] Starting subtest: invalid
[346.366577] Starting dynamic subtest: pipe-A-eDP-1
[346.794285] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.427s)
[346.796540] Subtest invalid: SUCCESS (0.428s)
[347.573729] [091/130] (706s left) gem_exec_reloc (basic-cpu-gtt-active)
[347.645783] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[347.715977] [092/130] (706s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[347.765093] Starting subtest: wait-all-for-submit-delayed-submit
[347.870275] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s)
[347.942658] [093/130] (706s left) syncobj_timeline (signal)
[347.997333] Starting subtest: signal
[348.000080] Subtest signal: SUCCESS (0.000s)
[348.097743] [094/130] (706s left) kms_psr (psr2-primary-render)
[348.197312] Starting subtest: psr2-primary-render
[348.200095] Starting dynamic subtest: eDP-1
[349.953411] Dynamic subtest eDP-1: SUCCESS (1.753s)
[349.956529] Subtest psr2-primary-render: SUCCESS (1.755s)
[350.769348] [095/130] (703s left) kms_psr (fbc-psr-primary-mmap-gtt)
[350.872301] Starting subtest: fbc-psr-primary-mmap-gtt
[350.874400] Starting dynamic subtest: eDP-1
[350.879339] Dynamic subtest eDP-1: SKIP (0.000s)
[350.884280] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[350.939042] [096/130] (703s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[351.036214] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[351.038750] Starting dynamic subtest: pipe-A
[351.232239] Dynamic subtest pipe-A: SKIP (0.189s)
[351.241507] Starting dynamic subtest: pipe-B
[352.457973] Dynamic subtest pipe-B: SKIP (1.225s)
[352.468201] Starting dynamic subtest: pipe-C
[353.650856] Dynamic subtest pipe-C: SUCCESS (1.199s)
[353.660821] Starting dynamic subtest: pipe-D
[354.827863] Dynamic subtest pipe-D: SUCCESS (1.176s)
[354.830833] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.791s)
[355.972202] [097/130] (698s left) gem_reg_read (timestamp-monotonic)
[356.027360] Starting subtest: timestamp-monotonic
[360.378026] Subtest timestamp-monotonic: SUCCESS (4.350s)
[360.446662] [098/130] (693s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[360.539668] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[360.542511] Starting dynamic subtest: pipe-A-eDP-1
[361.422507] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.871s)
[361.431189] Starting dynamic subtest: pipe-B-eDP-1
[362.954389] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.527s)
[362.966529] Starting dynamic subtest: pipe-C-eDP-1
[364.429461] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.476s)
[364.439377] Starting dynamic subtest: pipe-D-eDP-1
[365.929691] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.499s)
[365.931942] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.377s)
[367.076283] [099/130] (687s left) gem_ctx_persistence (engines-cleanup)
[367.140806] Starting subtest: engines-cleanup
[367.143657] Starting dynamic subtest: rcs0
[367.227192] Dynamic subtest rcs0: SUCCESS (0.085s)
[367.239389] Starting dynamic subtest: bcs0
[367.260115] Dynamic subtest bcs0: SUCCESS (0.033s)
[367.269368] Starting dynamic subtest: vcs0
[367.273952] Dynamic subtest vcs0: SUCCESS (0.013s)
[367.283116] Starting dynamic subtest: vcs1
[367.366513] Dynamic subtest vcs1: SUCCESS (0.092s)
[367.378543] Starting dynamic subtest: vecs0
[367.384911] Dynamic subtest vecs0: SUCCESS (0.017s)
[367.393304] Starting dynamic subtest: ccs0
[367.478661] Dynamic subtest ccs0: SUCCESS (0.093s)
[367.481494] Subtest engines-cleanup: SUCCESS (0.339s)
[367.551960] [100/130] (686s left) kms_psr (psr2-sprite-plane-onoff)
[367.653943] Starting subtest: psr2-sprite-plane-onoff
[367.656253] Starting dynamic subtest: eDP-1
[369.346724] Dynamic subtest eDP-1: SUCCESS (1.693s)
[369.349317] Subtest psr2-sprite-plane-onoff: SUCCESS (1.694s)
[370.167941] [101/130] (684s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[370.238784] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[370.241554] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[370.322579] [102/130] (684s left) kms_flip (2x-plain-flip)
[370.418519] Starting subtest: 2x-plain-flip
[370.429008] Subtest 2x-plain-flip: SKIP (0.010s)
[370.503513] [103/130] (683s left) gem_lmem_swapping (random)
[370.551524] Subtest random: SKIP (0.000s)
[370.591441] [104/130] (683s left) kms_lease (lease-uevent)
[370.691947] Starting subtest: lease-uevent
[371.704573] Subtest lease-uevent: SUCCESS (1.011s)
[371.791814] [105/130] (682s left) i915_fb_tiling (basic-x-tiling)
[371.849985] Subtest basic-x-tiling: SKIP (0.000s)
[371.903121] [106/130] (682s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-wc)
[371.997532] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-wc
[374.951429] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (2.958s)
[375.069127] [107/130] (679s left) gem_exec_params (rel-constants-invalid)
[375.130897] Starting subtest: rel-constants-invalid
[375.133582] Subtest rel-constants-invalid: SUCCESS (0.000s)
[375.242587] [108/130] (679s left) intel_hwmon (hwmon-write)
[375.297196] Subtest hwmon-write: SKIP (0.000s)
[375.346882] [109/130] (679s left) gem_exec_reloc (basic-cpu-read-active)
[375.406185] Subtest basic-cpu-read-active: SKIP (0.000s)
[375.481852] [110/130] (679s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[375.536926] Starting subtest: invalid-smem-bo-on-discrete
[375.540932] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[375.660723] [111/130] (679s left) gem_mmap_offset (ptrace)
[375.719348] Starting subtest: ptrace
[375.721875] Starting dynamic subtest: smem0-wb
[375.745069] Dynamic subtest smem0-wb: SUCCESS (0.024s)
[375.755235] Starting dynamic subtest: smem0-wc
[375.767459] Dynamic subtest smem0-wc: SUCCESS (0.021s)
[375.776314] Starting dynamic subtest: smem0-uc
[375.790260] Dynamic subtest smem0-uc: SUCCESS (0.022s)
[375.792710] Subtest ptrace: SUCCESS (0.074s)
[375.902760] [112/130] (678s left) kms_dp_link_training (uhbr-mst)
[376.002983] Starting subtest: uhbr-mst
[376.012285] Subtest uhbr-mst: SKIP (0.000s)
[376.074400] [113/130] (678s left) dmabuf_sync_file (import-multiple-read-write)
[376.118054] Starting subtest: import-multiple-read-write
[376.120260] Subtest import-multiple-read-write: SUCCESS (0.003s)
[376.174790] [114/130] (678s left) gem_tiled_wb
[376.293533] [115/130] (678s left) prime_vgem (wait)
[376.376025] Starting subtest: wait
[376.378307] Starting dynamic subtest: rcs0
[376.443405] Dynamic subtest rcs0: SUCCESS (0.067s)
[376.453066] Starting dynamic subtest: bcs0
[376.521027] Dynamic subtest bcs0: SUCCESS (0.077s)
[376.529709] Starting dynamic subtest: vcs0
[376.569583] Dynamic subtest vcs0: SUCCESS (0.048s)
[376.578807] Starting dynamic subtest: vcs1
[376.616810] Dynamic subtest vcs1: SUCCESS (0.046s)
[376.626572] Starting dynamic subtest: vecs0
[376.661887] Dynamic subtest vecs0: SUCCESS (0.045s)
[376.670593] Starting dynamic subtest: ccs0
[376.708750] Dynamic subtest ccs0: SUCCESS (0.046s)
[376.711075] Subtest wait: SUCCESS (0.333s)
[376.813884] [116/130] (678s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[376.917010] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[376.919142] Starting dynamic subtest: pipe-A
[376.928189] Dynamic subtest pipe-A: SKIP (0.004s)
[376.937908] Starting dynamic subtest: pipe-B
[376.947176] Dynamic subtest pipe-B: SKIP (0.015s)
[376.956163] Starting dynamic subtest: pipe-C
[376.965493] Dynamic subtest pipe-C: SKIP (0.015s)
[376.974067] Starting dynamic subtest: pipe-D
[376.981750] Dynamic subtest pipe-D: SKIP (0.015s)
[376.985534] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.051s)
[377.061333] [117/130] (677s left) kms_psr (fbc-pr-sprite-render)
[377.154429] Starting subtest: fbc-pr-sprite-render
[377.159386] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[377.224535] [118/130] (677s left) kms_chamelium_frames (hdmi-aspect-ratio)
[377.626551] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[378.461113] [119/130] (676s left) core_setmaster (master-drop-set-shared-fd)
[380.589503] Starting subtest: master-drop-set-shared-fd
[380.597130] Subtest master-drop-set-shared-fd: SUCCESS (0.011s)
[380.626615] [FACT core_setmaster (master-drop-set-shared-fd)] new: kernel.kmod_is_loaded.amdgpu: true
[380.627240] [FACT core_setmaster (master-drop-set-shared-fd)] new: kernel.kmod_is_loaded.xe: true
[380.630867] [120/130] (674s left) gem_partial_pwrite_pread (write-uncached)
[380.685525] Subtest write-uncached: SKIP (0.000s)
[380.763437] [121/130] (674s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[385.849528] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[385.851943] Starting dynamic subtest: pipe-A-eDP-1
[386.622412] Dynamic subtest pipe-A-eDP-1: SKIP (0.769s)
[386.631420] Starting dynamic subtest: pipe-B-eDP-1
[387.821683] Dynamic subtest pipe-B-eDP-1: SKIP (1.198s)
[387.826533] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.971s)
[388.969815] [122/130] (666s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[389.085354] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[389.090340] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[389.174707] [123/130] (665s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[389.280587] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[389.285677] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[389.390802] [124/130] (665s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[389.503233] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[389.506019] Starting dynamic subtest: pipe-A-eDP-1
[389.531288] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[389.540543] Starting dynamic subtest: pipe-B-eDP-1
[389.566569] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[389.575506] Starting dynamic subtest: pipe-C-eDP-1
[389.602305] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[389.612785] Starting dynamic subtest: pipe-D-eDP-1
[389.638512] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[389.643498] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[391.769463] [125/130] (663s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu)
[391.882891] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu
[396.497425] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (4.618s)
[396.631594] [126/130] (658s left) kms_chamelium_color (ctm-negative)
[396.736328] Subtest ctm-negative: SKIP (0.000s)
[396.776976] [127/130] (658s left) gem_pxp (verify-pxp-stale-ctx-execution)
[396.876433] Starting subtest: verify-pxp-stale-ctx-execution
[397.941562] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.064s)
[398.078151] [128/130] (657s left) gem_exec_balancer (bonded-pair)
[398.145324] Starting subtest: bonded-pair
[398.150566] Subtest bonded-pair: SKIP (0.000s)
[398.446977] [129/130] (656s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[398.561156] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[398.566379] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[398.671389] [130/130] (656s left) kms_joiner (basic-ultra-joiner)
[398.783697] Starting subtest: basic-ultra-joiner
[398.789236] Subtest basic-ultra-joiner: SKIP (0.000s)
[398.840612] Closing watchdogs
Done.