[61.483462] Initializing watchdogs
[61.483510]   /dev/watchdog0
[61.497342] [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]
[61.501571] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.504454] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.507557] [001/133] (960s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[61.637644] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[61.648776] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.010s)
[61.774760] [002/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[61.875782] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[61.880178] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[61.969667] [003/133] (960s left) perf_pmu (init-busy)
[62.011069] Starting subtest: init-busy
[62.013453] Starting dynamic subtest: rcs0
[62.015902] Dynamic subtest rcs0: SUCCESS (0.002s)
[62.023874] Starting dynamic subtest: bcs0
[62.026072] Dynamic subtest bcs0: SUCCESS (0.001s)
[62.032742] Starting dynamic subtest: vcs0
[62.034633] Dynamic subtest vcs0: SUCCESS (0.001s)
[62.040970] Starting dynamic subtest: vcs1
[62.043033] Dynamic subtest vcs1: SUCCESS (0.001s)
[62.049279] Starting dynamic subtest: vecs0
[62.051133] Dynamic subtest vecs0: SUCCESS (0.000s)
[62.057325] Starting dynamic subtest: ccs0
[62.059300] Dynamic subtest ccs0: SUCCESS (0.000s)
[62.061142] Subtest init-busy: SUCCESS (0.005s)
[62.135868] [004/133] (959s left) kms_flip (flip-vs-rmfb)
[62.242233] Starting subtest: flip-vs-rmfb
[62.244525] Starting dynamic subtest: A-eDP1
[70.925748] Dynamic subtest A-eDP1: SUCCESS (8.705s)
[70.934856] Starting dynamic subtest: B-eDP1
[79.630837] Dynamic subtest B-eDP1: SUCCESS (8.706s)
[79.641432] Starting dynamic subtest: C-eDP1
[88.251043] Dynamic subtest C-eDP1: SUCCESS (8.614s)
[88.260532] Starting dynamic subtest: D-eDP1
[96.887951] Dynamic subtest D-eDP1: SUCCESS (8.632s)
[96.892052] Subtest flip-vs-rmfb: SUCCESS (34.670s)
[98.060098] [005/133] (924s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[98.175223] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[98.177434] Starting dynamic subtest: pipe-A-eDP-1
[98.200205] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[98.209515] Starting dynamic subtest: pipe-B-eDP-1
[98.230999] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[98.238385] Starting dynamic subtest: pipe-C-eDP-1
[98.259953] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[98.266911] Starting dynamic subtest: pipe-D-eDP-1
[98.288662] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[98.292737] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[100.338817] [006/133] (921s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[100.398551] Starting subtest: x-tiled-to-vebox-y-tiled
[100.402977] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[100.585590] [007/133] (921s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[100.690535] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[100.694832] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[100.786779] [008/133] (921s left) gem_ctx_persistence (legacy-engines-mixed-process)
[100.839604] Starting subtest: legacy-engines-mixed-process
[100.842062] Starting dynamic subtest: render
[102.872354] Dynamic subtest render: SUCCESS (2.032s)
[102.881369] Starting dynamic subtest: bsd1
[104.925969] Dynamic subtest bsd1: SUCCESS (2.052s)
[104.934114] Starting dynamic subtest: bsd2
[106.903927] Dynamic subtest bsd2: SUCCESS (1.975s)
[106.913432] Starting dynamic subtest: blt
[108.911670] Dynamic subtest blt: SUCCESS (2.005s)
[108.921778] Starting dynamic subtest: vebox
[110.890767] Dynamic subtest vebox: SUCCESS (1.977s)
[110.893272] Subtest legacy-engines-mixed-process: SUCCESS (10.051s)
[110.970746] [009/133] (911s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[111.027541] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[111.088291] [010/133] (911s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[111.184787] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[117.758076] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.573s)
[117.894523] [011/133] (904s left) gem_exec_fence (basic-await)
[118.073963] Starting subtest: basic-await
[118.076809] Starting dynamic subtest: rcs0
[118.151056] Dynamic subtest rcs0: SUCCESS (0.076s)
[118.163183] Starting dynamic subtest: bcs0
[118.221340] Dynamic subtest bcs0: SUCCESS (0.070s)
[118.232698] Starting dynamic subtest: vcs0
[118.294179] Dynamic subtest vcs0: SUCCESS (0.071s)
[118.303595] Starting dynamic subtest: vcs1
[118.365966] Dynamic subtest vcs1: SUCCESS (0.070s)
[118.376047] Starting dynamic subtest: vecs0
[118.437879] Dynamic subtest vecs0: SUCCESS (0.070s)
[118.450670] Starting dynamic subtest: ccs0
[118.511693] Dynamic subtest ccs0: SUCCESS (0.071s)
[118.514114] Subtest basic-await: SUCCESS (0.438s)
[119.968058] [FACT gem_exec_fence (basic-await)] new: kernel.kmod_is_loaded.vgem: true
[119.971409] [012/133] (902s left) kms_vblank (query-forked)
[120.061041] Starting subtest: query-forked
[120.063290] Starting dynamic subtest: pipe-A-eDP-1
[121.887708] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.827s)
[121.904382] Starting dynamic subtest: pipe-D-eDP-1
[124.405463] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.514s)
[124.407851] Subtest query-forked: SUCCESS (4.345s)
[125.257883] [013/133] (897s left) gem_create (hog-create)
[125.323118] Starting subtest: hog-create
[125.325077] Starting dynamic subtest: smem0
[158.938053] Dynamic subtest smem0: SUCCESS (33.614s)
[158.940893] Subtest hog-create: SUCCESS (33.615s)
[159.124953] [014/133] (863s left) syncobj_wait (single-wait-all-for-submit-signaled)
[159.178126] Starting subtest: single-wait-all-for-submit-signaled
[159.180416] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[159.284785] [015/133] (863s left) gem_exec_balancer (hang)
[159.553800] Starting subtest: hang
[161.215759] Subtest hang: SUCCESS (1.665s)
[161.336891] [016/133] (861s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[161.444209] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[161.446371] Starting dynamic subtest: pipe-A-eDP-1
[161.455203] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[161.463327] Starting dynamic subtest: pipe-B-eDP-1
[161.471951] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[161.479679] Starting dynamic subtest: pipe-C-eDP-1
[161.488261] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[161.495954] Starting dynamic subtest: pipe-D-eDP-1
[161.504133] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[161.508265] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.012s)
[163.636288] [017/133] (858s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[163.749270] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[163.753541] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[163.847388] [018/133] (858s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[164.240300] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[165.049853] [019/133] (857s left) vgem_basic (bad-flag)
[165.090771] Starting subtest: bad-flag
[165.093020] Subtest bad-flag: SUCCESS (0.000s)
[165.146919] [020/133] (857s left) kms_flip (flip-vs-panning)
[165.245056] Starting subtest: flip-vs-panning
[165.247231] Starting dynamic subtest: A-eDP1
[173.993272] Dynamic subtest A-eDP1: SUCCESS (8.750s)
[174.002592] Starting dynamic subtest: B-eDP1
[182.716316] Dynamic subtest B-eDP1: SUCCESS (8.720s)
[182.727952] Starting dynamic subtest: C-eDP1
[191.443475] Dynamic subtest C-eDP1: SUCCESS (8.724s)
[191.452704] Starting dynamic subtest: D-eDP1
[200.167820] Dynamic subtest D-eDP1: SUCCESS (8.723s)
[200.172811] Subtest flip-vs-panning: SUCCESS (34.928s)
[201.324043] [021/133] (821s left) kms_setmode (invalid-clone-exclusive-crtc)
[201.380895] Starting subtest: invalid-clone-exclusive-crtc
[201.387863] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[201.479334] [022/133] (821s left) gem_exec_reloc (basic-softpin)
[201.536615] Subtest basic-softpin: SKIP (0.000s)
[201.612265] [023/133] (821s left) gen9_exec_parse (unaligned-access)
[201.675882] Subtest unaligned-access: SKIP (0.000s)
[201.742438] [024/133] (821s left) kms_rotation_crc (primary-rotation-180)
[201.827134] Starting subtest: primary-rotation-180
[208.867075] Subtest primary-rotation-180: SUCCESS (7.041s)
[210.079929] [025/133] (812s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[210.193478] Starting subtest: y-tiled-8bpp-rotate-0
[210.197882] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[210.291616] [026/133] (812s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[212.126604] Starting subtest: modeset-lpsp-stress-no-wait
[221.888694] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.765s)
[221.963792] [027/133] (801s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[222.052715] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[222.056846] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[222.155914] [028/133] (800s left) prime_vgem (busy)
[222.253374] Starting subtest: busy
[222.255324] Starting dynamic subtest: rcs0
[222.315816] Dynamic subtest rcs0: SUCCESS (0.065s)
[222.324626] Starting dynamic subtest: bcs0
[222.359396] Dynamic subtest bcs0: SUCCESS (0.043s)
[222.367456] Starting dynamic subtest: vcs0
[222.409080] Dynamic subtest vcs0: SUCCESS (0.049s)
[222.417166] Starting dynamic subtest: vcs1
[222.453982] Dynamic subtest vcs1: SUCCESS (0.043s)
[222.462057] Starting dynamic subtest: vecs0
[222.499469] Dynamic subtest vecs0: SUCCESS (0.045s)
[222.507387] Starting dynamic subtest: ccs0
[222.546447] Dynamic subtest ccs0: SUCCESS (0.046s)
[222.548697] Subtest busy: SUCCESS (0.296s)
[222.655891] [029/133] (800s left) gem_ctx_param (basic)
[222.706942] Starting subtest: basic
[222.709313] Subtest basic: SUCCESS (0.001s)
[222.795267] [030/133] (800s left) syncobj_timeline (multi-wait-signaled)
[222.864568] Starting subtest: multi-wait-signaled
[222.866745] Subtest multi-wait-signaled: SUCCESS (0.001s)
[222.982018] [031/133] (800s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[223.043540] Starting subtest: invalid-bsd1-flag-on-blt
[223.045664] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[223.165487] [032/133] (800s left) i915_query (test-query-geometry-subslices)
[223.219929] Starting subtest: test-query-geometry-subslices
[223.221748] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[223.330683] [033/133] (799s left) kms_psr2_su (frontbuffer-xrgb8888)
[223.388891] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[223.449918] [034/133] (799s left) kms_color (ctm-negative)
[223.537549] Starting subtest: ctm-negative
[223.539359] Starting dynamic subtest: pipe-A-eDP-1
[224.262058] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.721s)
[224.270820] Starting dynamic subtest: pipe-B-eDP-1
[225.659012] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.399s)
[225.674785] Starting dynamic subtest: pipe-C-eDP-1
[227.036160] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.375s)
[227.046557] Starting dynamic subtest: pipe-D-eDP-1
[228.358777] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s)
[228.361093] Subtest ctm-negative: SUCCESS (4.823s)
[229.172429] [035/133] (794s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[229.259484] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[229.263997] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[229.328671] [036/133] (794s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[229.393556] Subtest no-spare-fences-busy: SKIP (0.000s)
[229.472951] [037/133] (793s left) gem_exec_schedule (independent)
[229.544353] Starting subtest: independent
[229.546651] Starting dynamic subtest: rcs0
[230.934042] Dynamic subtest rcs0: SUCCESS (1.397s)
[230.945957] Starting dynamic subtest: vcs0
[232.928711] Dynamic subtest vcs0: SUCCESS (1.992s)
[232.943461] Starting dynamic subtest: vcs1
[234.913363] Dynamic subtest vcs1: SUCCESS (1.982s)
[234.926158] Starting dynamic subtest: vecs0
[236.891668] Dynamic subtest vecs0: SUCCESS (1.977s)
[236.902894] Starting dynamic subtest: ccs0
[238.869235] Dynamic subtest ccs0: SUCCESS (1.975s)
[238.871846] Subtest independent: SUCCESS (9.335s)
[239.175241] [038/133] (784s left) kms_cursor_crc (cursor-alpha-opaque)
[239.271193] Starting subtest: cursor-alpha-opaque
[239.273497] Starting dynamic subtest: pipe-A-eDP-1
[239.900862] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.629s)
[239.909672] Starting dynamic subtest: pipe-D-eDP-1
[241.131493] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s)
[241.133894] Subtest cursor-alpha-opaque: SUCCESS (1.862s)
[241.941313] [039/133] (781s left) gem_mmap_gtt (basic-write-read)
[241.996157] Subtest basic-write-read: SKIP (0.000s)
[242.061655] [040/133] (781s left) gen9_exec_parse (bb-secure)
[242.114971] Subtest bb-secure: SKIP (0.000s)
[242.170365] [041/133] (781s left) api_intel_bb (lot-of-buffers)
[242.230021] Starting subtest: lot-of-buffers
[243.229135] Subtest lot-of-buffers: SUCCESS (1.001s)
[243.755742] [042/133] (779s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[243.803430] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[243.856590] [043/133] (779s left) gem_exec_params (invalid-fence-in)
[243.919940] Starting subtest: invalid-fence-in
[243.922736] Subtest invalid-fence-in: SUCCESS (0.000s)
[244.024585] [044/133] (779s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[244.121028] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[251.115297] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.997s)
[251.238915] [045/133] (772s left) gem_mmap_gtt (big-bo-tiledy)
[251.299300] Subtest big-bo-tiledY: SKIP (0.000s)
[251.353701] [046/133] (772s left) gem_softpin (evict-single-offset)
[251.412753] Starting subtest: evict-single-offset
[276.888353] Subtest evict-single-offset: SUCCESS (25.471s)
[276.966947] [047/133] (746s left) syncobj_wait (invalid-signal-illegal-handle)
[277.063475] Starting subtest: invalid-signal-illegal-handle
[277.065904] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[277.197343] [048/133] (746s left) kms_addfb_basic (master-rmfb)
[277.249597] Starting subtest: master-rmfb
[277.251943] Subtest master-rmfb: SUCCESS (0.001s)
[277.397114] [049/133] (746s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[277.490542] Starting subtest: plane-use-after-nonblocking-unbind
[277.492903] Starting dynamic subtest: pipe-A-eDP-1
[277.554053] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.065s)
[277.863398] Starting dynamic subtest: pipe-B-eDP-1
[278.656508] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.802s)
[278.964547] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.476s)
[279.834187] [050/133] (744s left) i915_pm_rpm (debugfs-forcewake-user)
[282.102239] Starting subtest: debugfs-forcewake-user
[293.514854] Subtest debugfs-forcewake-user: SUCCESS (11.416s)
[293.890070] [051/133] (730s left) kms_pm_dc (dc5-dpms-negative)
[295.002132] Starting subtest: dc5-dpms-negative
[295.006922] Subtest dc5-dpms-negative: SKIP (0.000s)
[295.079985] [052/133] (728s left) gem_ctx_sseu (engines)
[295.143982] Subtest engines: SKIP (0.000s)
[295.207459] [053/133] (728s left) kms_flip (2x-busy-flip)
[295.293447] Starting subtest: 2x-busy-flip
[295.301772] Subtest 2x-busy-flip: SKIP (0.010s)
[295.381708] [054/133] (728s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[295.494921] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[295.499166] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[295.592313] [055/133] (728s left) kms_content_protection (suspend-resume)
[295.743308] Starting subtest: suspend-resume
[295.748260] Subtest suspend-resume: SKIP (0.000s)
[295.906815] [056/133] (728s left) gem_busy (busy)
[295.968319] Starting subtest: busy
[295.970511] Starting dynamic subtest: all-engines
[296.030862] Dynamic subtest all-engines: SUCCESS (0.062s)
[296.041475] Starting dynamic subtest: rcs0
[297.885683] Dynamic subtest rcs0: SUCCESS (1.851s)
[297.896179] Starting dynamic subtest: bcs0
[297.926366] Dynamic subtest bcs0: SUCCESS (0.038s)
[297.935408] Starting dynamic subtest: vcs0
[297.965153] Dynamic subtest vcs0: SUCCESS (0.038s)
[297.973955] Starting dynamic subtest: vcs1
[299.932302] Dynamic subtest vcs1: SUCCESS (1.963s)
[299.943304] Starting dynamic subtest: vecs0
[301.915245] Dynamic subtest vecs0: SUCCESS (1.982s)
[301.926247] Starting dynamic subtest: ccs0
[303.899666] Dynamic subtest ccs0: SUCCESS (1.981s)
[303.901939] Subtest busy: SUCCESS (7.928s)
[304.265168] [057/133] (720s left) kms_chamelium_frames (dp-crc-multiple)
[304.656474] Subtest dp-crc-multiple: SKIP (0.000s)
[305.488168] [058/133] (718s left) gem_userptr_blits (nohangcheck)
[305.563805] Starting subtest: nohangcheck
[305.807941] Subtest nohangcheck: SUCCESS (0.240s)
[305.922330] [059/133] (718s left) kms_invalid_mode (bad-vtotal)
[306.023777] Starting subtest: bad-vtotal
[306.026172] Starting dynamic subtest: pipe-A-eDP-1
[306.320558] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s)
[306.330160] Starting dynamic subtest: pipe-B-eDP-1
[306.332639] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[306.342854] Starting dynamic subtest: pipe-C-eDP-1
[306.347274] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[306.355485] Starting dynamic subtest: pipe-D-eDP-1
[306.357869] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[306.360306] Subtest bad-vtotal: SUCCESS (0.303s)
[307.149143] [060/133] (717s left) gem_partial_pwrite_pread (write-uncached)
[307.203697] Subtest write-uncached: SKIP (0.000s)
[307.271578] [061/133] (717s left) gem_mmap_gtt (bad-object)
[307.322276] Subtest bad-object: SKIP (0.000s)
[307.385348] [062/133] (717s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[307.477991] Starting subtest: psr-rgb565-draw-mmap-cpu
[314.232612] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.756s)
[314.334325] [063/133] (710s left) kms_big_fb (yf-tiled-addfb)
[314.446227] Starting subtest: yf-tiled-addfb
[314.450190] Subtest yf-tiled-addfb: SKIP (0.000s)
[314.553445] [064/133] (710s left) gem_exec_reloc (basic-write-read-active)
[314.610084] Subtest basic-write-read-active: SKIP (0.000s)
[314.682360] [065/133] (709s left) kms_lease (setcrtc-implicit-plane)
[314.778958] Starting subtest: setcrtc-implicit-plane
[314.781191] Starting dynamic subtest: pipe-A-eDP-1
[315.250578] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.472s)
[315.260263] Starting dynamic subtest: pipe-B-eDP-1
[316.397867] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.144s)
[316.410024] Starting dynamic subtest: pipe-C-eDP-1
[317.519358] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.119s)
[317.528858] Starting dynamic subtest: pipe-D-eDP-1
[318.644522] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s)
[318.646454] Subtest setcrtc-implicit-plane: SUCCESS (3.865s)
[319.499936] [066/133] (705s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[319.602888] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[320.593072] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.990s)
[320.711953] [067/133] (703s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[320.805481] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[320.807490] Starting dynamic subtest: pipe-A-eDP-1
[320.827533] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[320.837397] Starting dynamic subtest: pipe-B-eDP-1
[320.855774] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[320.863475] Starting dynamic subtest: pipe-C-eDP-1
[320.881149] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[320.888962] Starting dynamic subtest: pipe-D-eDP-1
[320.907355] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[320.910796] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[323.062984] [068/133] (701s left) kms_chamelium_audio (hdmi-audio-edid)
[323.434866] Subtest hdmi-audio-edid: SKIP (0.000s)
[324.275262] [069/133] (700s left) vgem_basic (sysfs)
[324.325565] Starting subtest: sysfs
[324.327475] Subtest sysfs: SUCCESS (0.000s)
[324.380421] [070/133] (700s left) kms_vrr (negative-basic)
[324.475121] Starting subtest: negative-basic
[324.481639] Starting dynamic subtest: pipe-A-eDP-1
[329.897691] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.415s)
[330.180343] Subtest negative-basic: SUCCESS (5.705s)
[331.034412] [071/133] (693s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[331.149128] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[331.153718] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[332.265562] [072/133] (692s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[332.353260] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[332.364924] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[332.440183] [073/133] (692s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[332.531287] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[332.535193] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[332.604549] [074/133] (692s left) gem_exec_whisper (basic-forked)
[332.661581] Starting subtest: basic-forked
[340.782066] Subtest basic-forked: SUCCESS (8.118s)
[340.971492] [075/133] (684s left) gem_exec_reloc (basic-write-read-noreloc)
[341.029952] Subtest basic-write-read-noreloc: SKIP (0.000s)
[341.092098] [076/133] (683s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[341.192106] Starting subtest: multiplane-rotation-cropping-top
[358.683690] Subtest multiplane-rotation-cropping-top: SUCCESS (17.493s)
[358.814659] [077/133] (666s left) gen3_mixed_blits
[358.931014] [078/133] (666s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[359.021350] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[365.876041] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.855s)
[366.021324] [079/133] (659s left) kms_hdmi_inject (inject-audio)
[366.372659] Starting subtest: inject-audio
[366.644224] Subtest inject-audio: SUCCESS (0.275s)
[367.247365] [080/133] (657s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[367.351705] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[367.356156] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[367.455099] [081/133] (657s left) gem_mmap_gtt (hang-user)
[367.520497] Subtest hang-user: SKIP (0.000s)
[367.586041] [082/133] (657s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[367.653148] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[367.725120] [083/133] (657s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[367.820203] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[367.822539] Starting dynamic subtest: pipe-A
[367.846445] Dynamic subtest pipe-A: SKIP (0.022s)
[367.855937] Starting dynamic subtest: pipe-B
[367.876916] Dynamic subtest pipe-B: SKIP (0.029s)
[367.886299] Starting dynamic subtest: pipe-C
[367.907126] Dynamic subtest pipe-C: SKIP (0.029s)
[367.915982] Starting dynamic subtest: pipe-D
[367.935635] Dynamic subtest pipe-D: SKIP (0.029s)
[367.939454] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.111s)
[368.061592] [084/133] (657s left) kms_hdr (static-swap)
[368.146889] Starting subtest: static-swap
[368.152308] Subtest static-swap: SKIP (0.000s)
[368.218997] [085/133] (657s left) gem_exec_fence (syncobj-timeline-repeat)
[368.770592] Starting subtest: syncobj-timeline-repeat
[369.004942] Subtest syncobj-timeline-repeat: SUCCESS (0.234s)
[369.949075] [086/133] (655s left) gem_ctx_isolation (preservation-reset)
[370.121749] Starting subtest: preservation-reset
[370.125153] Starting dynamic subtest: rcs0
[370.396326] Dynamic subtest rcs0: SUCCESS (0.275s)
[370.406307] Starting dynamic subtest: bcs0
[370.725075] Dynamic subtest bcs0: SUCCESS (0.326s)
[370.736928] Starting dynamic subtest: vcs0
[371.084480] Dynamic subtest vcs0: SUCCESS (0.359s)
[371.098443] Starting dynamic subtest: vcs1
[372.231802] Dynamic subtest vcs1: SUCCESS (1.146s)
[372.243058] Starting dynamic subtest: vecs0
[374.200038] Dynamic subtest vecs0: SUCCESS (1.967s)
[374.212085] Starting dynamic subtest: ccs0
[376.195283] Dynamic subtest ccs0: SUCCESS (1.994s)
[376.197819] Subtest preservation-reset: SUCCESS (6.076s)
[376.334492] [087/133] (649s left) kms_async_flips (crc-atomic)
[376.461024] Starting subtest: crc-atomic
[376.854120] Starting dynamic subtest: pipe-A-eDP-1
[379.819574] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.964s)
[380.217152] Starting dynamic subtest: pipe-B-eDP-1
[383.101055] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.893s)
[383.476326] Starting dynamic subtest: pipe-C-eDP-1
[386.386068] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.921s)
[386.776040] Starting dynamic subtest: pipe-D-eDP-1
[389.680127] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.923s)
[389.682521] Subtest crc-atomic: SUCCESS (13.220s)
[390.932062] [088/133] (634s left) kms_cursor_legacy (forked-bo)
[391.056515] Starting subtest: forked-bo
[391.058745] Starting dynamic subtest: pipe-A
[396.517302] Dynamic subtest pipe-A: SUCCESS (5.458s)
[396.529428] Starting dynamic subtest: pipe-B
[401.999250] Dynamic subtest pipe-B: SUCCESS (5.479s)
[402.014308] Starting dynamic subtest: pipe-C
[407.482720] Dynamic subtest pipe-C: SUCCESS (5.480s)
[407.498956] Starting dynamic subtest: pipe-D
[412.969340] Dynamic subtest pipe-D: SUCCESS (5.485s)
[412.984976] Starting dynamic subtest: all-pipes
[418.467865] Dynamic subtest all-pipes: SUCCESS (5.495s)
[418.470366] Subtest forked-bo: SUCCESS (27.409s)
[418.622832] [089/133] (606s left) syncobj_eventfd (timeline-wait-signaled)
[418.675790] Starting subtest: timeline-wait-signaled
[418.678079] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[418.778910] [090/133] (606s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[418.873193] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[426.127485] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.255s)
[426.286533] [091/133] (599s left) syncobj_timeline (invalid-transfer-non-existent-point)
[426.345217] Starting subtest: invalid-transfer-non-existent-point
[426.347089] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[426.454885] [092/133] (599s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[426.581615] Starting subtest: cursorB-vs-flipA-atomic-transitions
[426.586224] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[426.724730] [093/133] (599s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[426.822928] Starting subtest: x-tiled-32bpp-rotate-90
[426.841928] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s)
[426.960503] [094/133] (598s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[427.050676] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[427.075514] Starting dynamic subtest: pipe-A-plane-0
[427.731510] Dynamic subtest pipe-A-plane-0: SUCCESS (0.655s)
[427.751974] Starting dynamic subtest: pipe-A-plane-3
[428.164140] Dynamic subtest pipe-A-plane-3: SUCCESS (0.431s)
[429.264277] Starting dynamic subtest: pipe-B-plane-0
[430.134806] Dynamic subtest pipe-B-plane-0: SUCCESS (0.878s)
[430.147582] Starting dynamic subtest: pipe-B-plane-3
[430.611972] Dynamic subtest pipe-B-plane-3: SUCCESS (0.474s)
[430.932443] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.883s)
[431.808739] [095/133] (594s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[431.914068] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[431.918605] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[432.037763] [096/133] (593s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[432.108673] Starting subtest: single-wait-for-submit-available-signaled
[432.110892] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[432.217777] [097/133] (593s left) gem_exec_flush (basic-batch-kernel-default-uc)
[432.272233] Starting subtest: basic-batch-kernel-default-uc
[439.041332] Subtest basic-batch-kernel-default-uc: SUCCESS (6.770s)
[439.231018] [098/133] (586s left) gem_fence_thrash (bo-write-verify-threaded-y)
[439.281658] Starting subtest: bo-write-verify-threaded-y
[439.301831] Subtest bo-write-verify-threaded-y: SKIP (0.018s)
[439.369421] [099/133] (586s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[439.466511] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[439.470484] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[439.581860] [100/133] (586s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[439.681618] Starting subtest: psr2-cursor-plane-update-sf
[439.684041] Starting dynamic subtest: pipe-A-eDP-1
[440.247869] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.569s)
[440.258092] Starting dynamic subtest: pipe-B-eDP-1
[441.576839] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.327s)
[441.579226] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.899s)
[442.404282] [101/133] (583s left) kms_cursor_crc (cursor-random-256x85)
[442.689831] Starting subtest: cursor-random-256x85
[442.734999] Subtest cursor-random-256x85: SKIP (0.041s)
[442.914408] [102/133] (583s left) gem_mmap_offset (ptrace)
[442.972060] Starting subtest: ptrace
[442.978198] Starting dynamic subtest: smem0-wb
[442.991833] Dynamic subtest smem0-wb: SUCCESS (0.016s)
[443.003046] Starting dynamic subtest: smem0-wc
[443.010046] Dynamic subtest smem0-wc: SUCCESS (0.018s)
[443.021740] Starting dynamic subtest: smem0-uc
[443.028911] Dynamic subtest smem0-uc: SUCCESS (0.018s)
[443.031437] Subtest ptrace: SUCCESS (0.058s)
[443.136867] [103/133] (583s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[443.218878] Starting subtest: compare-crc-sanitycheck-xr24
[443.221389] Starting dynamic subtest: pipe-A-eDP-1
[443.827658] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.611s)
[443.838392] Starting dynamic subtest: pipe-B-eDP-1
[445.137627] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.307s)
[445.147875] Starting dynamic subtest: pipe-C-eDP-1
[446.391329] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.252s)
[446.401389] Starting dynamic subtest: pipe-D-eDP-1
[447.588403] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.197s)
[447.590607] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.372s)
[448.409674] [104/133] (577s left) kms_force_connector_basic (prune-stale-modes)
[448.496366] Starting subtest: prune-stale-modes
[448.938799] Subtest prune-stale-modes: SUCCESS (0.445s)
[449.093242] [105/133] (577s left) kms_psr (psr-cursor-plane-move)
[449.187961] Starting subtest: psr-cursor-plane-move
[449.190358] Starting dynamic subtest: eDP-1
[450.865992] Dynamic subtest eDP-1: SUCCESS (1.678s)
[450.868532] Subtest psr-cursor-plane-move: SUCCESS (1.679s)
[451.710277] [106/133] (574s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[451.804800] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[451.809209] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[451.897638] [107/133] (574s left) kms_big_fb (linear-8bpp-rotate-270)
[452.005455] Starting subtest: linear-8bpp-rotate-270
[452.026142] Subtest linear-8bpp-rotate-270: SKIP (0.020s)
[452.126047] [108/133] (574s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[452.186224] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[452.272931] [109/133] (574s left) gem_exec_schedule (fairslice-all)
[452.343895] Starting subtest: fairslice-all
[454.402600] Subtest fairslice-all: SUCCESS (2.063s)
[454.710467] [110/133] (571s left) kms_psr (pr-no-drrs)
[454.805209] Starting subtest: pr-no-drrs
[454.809239] Subtest pr-no-drrs: SKIP (0.000s)
[454.879235] [111/133] (571s left) gem_exec_reloc (basic-wc-gtt)
[454.933958] Subtest basic-wc-gtt: SKIP (0.000s)
[455.006935] [112/133] (571s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[455.107431] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[455.111789] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[455.210272] [113/133] (571s left) kms_dsc (dsc-with-bpc)
[455.313127] Starting subtest: dsc-with-bpc
[455.344052] Subtest dsc-with-bpc: SKIP (0.001s)
[455.383150] [114/133] (571s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[455.481631] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[455.485720] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[455.581022] [115/133] (571s left) i915_module_load (reload-no-display)
[455.622614] Starting subtest: reload-no-display
[461.595576] Subtest reload-no-display: SUCCESS (5.972s)
[461.626412] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[461.627125] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[461.630770] [116/133] (565s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[463.153890] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[463.256496] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[463.298917] [FACT syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[463.300170] [FACT syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)] new: kernel.kmod_is_loaded.i915: true
[463.303774] [117/133] (563s left) dmabuf (all-tests)
[463.345182] Starting subtest: all-tests
[463.347475] Starting dynamic subtest: sanitycheck
[463.437702] Dynamic subtest sanitycheck: SUCCESS (0.093s)
[463.449579] Starting dynamic subtest: dma_fence
[463.645634] Dynamic subtest dma_fence: SUCCESS (0.205s)
[463.656726] Starting dynamic subtest: dma_fence_chain
[472.985213] Dynamic subtest dma_fence_chain: SUCCESS (9.336s)
[472.996794] Starting dynamic subtest: dma_fence_unwrap
[473.082644] Dynamic subtest dma_fence_unwrap: SUCCESS (0.096s)
[473.094151] Starting dynamic subtest: dma_resv
[473.175665] Dynamic subtest dma_resv: SUCCESS (0.091s)
[473.178437] Subtest all-tests: SUCCESS (9.833s)
[473.242236] [118/133] (553s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[473.298058] Starting subtest: single-wait-all-for-submit-unsubmitted
[473.401836] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[473.490373] [119/133] (553s left) api_intel_allocator (simple-allocator)
[473.544830] Starting subtest: simple-allocator
[473.547192] Starting dynamic subtest: basic
[473.553567] Dynamic subtest basic: SUCCESS (0.011s)
[473.561805] Starting dynamic subtest: parallel-one
[473.745085] Dynamic subtest parallel-one: SUCCESS (0.189s)
[473.756321] Starting dynamic subtest: print
[473.758843] Dynamic subtest print: SUCCESS (0.000s)
[473.770149] Starting dynamic subtest: reuse
[473.772271] Dynamic subtest reuse: SUCCESS (0.000s)
[473.780711] Starting dynamic subtest: reserve
[473.782661] Dynamic subtest reserve: SUCCESS (0.000s)
[473.790090] Starting dynamic subtest: fork-reopen-allocator
[473.792095] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[473.794111] Subtest simple-allocator: SUCCESS (0.220s)
[473.915462] [120/133] (553s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[474.010931] Starting subtest: yf-tiled-16bpp-rotate-180
[474.015368] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[474.117769] [121/133] (552s left) gem_exec_schedule (u-independent)
[474.194526] Starting subtest: u-independent
[474.196682] Starting dynamic subtest: rcs0
[475.929359] Dynamic subtest rcs0: SUCCESS (1.740s)
[475.941785] Starting dynamic subtest: vcs0
[477.915867] Dynamic subtest vcs0: SUCCESS (1.983s)
[477.927850] Starting dynamic subtest: vcs1
[479.900397] Dynamic subtest vcs1: SUCCESS (1.982s)
[479.915089] Starting dynamic subtest: vecs0
[481.888123] Dynamic subtest vecs0: SUCCESS (1.985s)
[481.899869] Starting dynamic subtest: ccs0
[483.928212] Dynamic subtest ccs0: SUCCESS (2.037s)
[483.931254] Subtest u-independent: SUCCESS (9.740s)
[484.239813] [122/133] (542s left) gem_exec_params (sol-reset-not-gen7)
[484.286292] Starting subtest: sol-reset-not-gen7
[484.291961] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[484.397240] [123/133] (542s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[484.452848] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[484.458060] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[484.649316] [124/133] (542s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[484.756808] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[491.759548] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.005s)
[491.871134] [125/133] (535s left) kms_cursor_crc (cursor-suspend)
[492.026548] Starting subtest: cursor-suspend
[492.028740] Starting dynamic subtest: pipe-A-eDP-1
[524.850867] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.321s)
[524.861218] Starting dynamic subtest: pipe-D-eDP-1
[558.809308] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.836s)
[558.811742] Subtest cursor-suspend: SUCCESS (7.159s)
[559.600624] [126/133] (467s left) gem_userptr_blits (sync-unmap-after-close)
[559.677521] Starting subtest: sync-unmap-after-close
[559.686564] Subtest sync-unmap-after-close: SUCCESS (0.011s)
[559.798085] [127/133] (467s left) kms_vblank (ts-continuation-modeset-rpm)
[559.884944] Starting subtest: ts-continuation-modeset-rpm
[559.887089] Starting dynamic subtest: pipe-A-eDP-1
[562.348106] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.522s)
[562.365556] Starting dynamic subtest: pipe-D-eDP-1
[564.549468] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.235s)
[564.551838] Subtest ts-continuation-modeset-rpm: SUCCESS (4.760s)
[565.354361] [128/133] (461s left) gem_userptr_blits (create-destroy-sync)
[565.426851] Starting subtest: create-destroy-sync
[570.443376] Subtest create-destroy-sync: SUCCESS (5.066s)
[570.551872] [129/133] (456s left) gem_sync (basic-many-each)
[570.631779] Starting subtest: basic-many-each
[572.917463] Subtest basic-many-each: SUCCESS (2.309s)
[573.107231] [130/133] (454s left) kms_psr (fbc-psr2-no-drrs)
[573.212718] Starting subtest: fbc-psr2-no-drrs
[573.214912] Starting dynamic subtest: eDP-1
[573.218823] Dynamic subtest eDP-1: SKIP (0.000s)
[573.222851] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[573.283394] [131/133] (454s left) kms_plane (plane-position-covered)
[573.379506] Starting subtest: plane-position-covered
[573.890637] Starting dynamic subtest: pipe-A-plane-1
[575.135600] Dynamic subtest pipe-A-plane-1: SUCCESS (1.249s)
[575.145304] Starting dynamic subtest: pipe-A-plane-2
[576.373298] Dynamic subtest pipe-A-plane-2: SUCCESS (1.244s)
[576.383221] Starting dynamic subtest: pipe-A-plane-3
[577.710110] Dynamic subtest pipe-A-plane-3: SUCCESS (1.339s)
[577.720454] Starting dynamic subtest: pipe-A-plane-4
[579.052908] Dynamic subtest pipe-A-plane-4: SUCCESS (1.346s)
[579.063681] Starting dynamic subtest: pipe-A-plane-5
[579.077198] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[580.282306] Starting dynamic subtest: pipe-B-plane-1
[581.593040] Dynamic subtest pipe-B-plane-1: SUCCESS (1.323s)
[581.604318] Starting dynamic subtest: pipe-B-plane-2
[582.966170] Dynamic subtest pipe-B-plane-2: SUCCESS (1.374s)
[582.977181] Starting dynamic subtest: pipe-B-plane-3
[584.239008] Dynamic subtest pipe-B-plane-3: SUCCESS (1.274s)
[584.250161] Starting dynamic subtest: pipe-B-plane-4
[585.485466] Dynamic subtest pipe-B-plane-4: SUCCESS (1.249s)
[585.495530] Starting dynamic subtest: pipe-B-plane-5
[585.511800] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[585.513967] Subtest plane-position-covered: SUCCESS (12.166s)
[586.364214] [132/133] (441s left) kms_psr (fbc-psr-sprite-render)
[586.458983] Starting subtest: fbc-psr-sprite-render
[586.460847] Starting dynamic subtest: eDP-1
[586.464937] Dynamic subtest eDP-1: SKIP (0.000s)
[586.468964] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[586.538506] [133/133] (440s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[586.637508] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[586.641553] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[586.756702] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: perf_pmu
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: gem_render_copy
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_ctx_persistence
results: parsing output: 8/ for test: kms_pipe_b_c_ivb
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_exec_fence
results: parsing output: 11/ for test: kms_vblank
results: parsing output: 12/ for test: gem_create
results: parsing output: 13/ for test: syncobj_wait
results: parsing output: 14/ for test: gem_exec_balancer
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_chamelium_hpd
results: parsing output: 18/ for test: vgem_basic
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: kms_setmode
results: parsing output: 21/ for test: gem_exec_reloc
results: parsing output: 22/ for test: gen9_exec_parse
results: parsing output: 23/ for test: kms_rotation_crc
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_pm_rpm
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: prime_vgem
results: parsing output: 28/ for test: gem_ctx_param
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: gem_exec_params
results: parsing output: 31/ for test: i915_query
results: parsing output: 32/ for test: kms_psr2_su
results: parsing output: 33/ for test: kms_color
results: parsing output: 34/ for test: kms_flip_scaled_crc
results: parsing output: 35/ for test: gem_fenced_exec_thrash
results: parsing output: 36/ for test: gem_exec_schedule
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: gem_mmap_gtt
results: parsing output: 39/ for test: gen9_exec_parse
results: parsing output: 40/ for test: api_intel_bb
results: parsing output: 41/ for test: gem_lmem_swapping
results: parsing output: 42/ for test: gem_exec_params
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_mmap_gtt
results: parsing output: 45/ for test: gem_softpin
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: kms_addfb_basic
results: parsing output: 48/ for test: kms_atomic_transition
results: parsing output: 49/ for test: i915_pm_rpm
results: parsing output: 50/ for test: kms_pm_dc
results: parsing output: 51/ for test: gem_ctx_sseu
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_content_protection
results: parsing output: 55/ for test: gem_busy
results: parsing output: 56/ for test: kms_chamelium_frames
results: parsing output: 57/ for test: gem_userptr_blits
results: parsing output: 58/ for test: kms_invalid_mode
results: parsing output: 59/ for test: gem_partial_pwrite_pread
results: parsing output: 60/ for test: gem_mmap_gtt
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: gem_exec_reloc
results: parsing output: 64/ for test: kms_lease
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_chamelium_audio
results: parsing output: 68/ for test: vgem_basic
results: parsing output: 69/ for test: kms_vrr
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: kms_plane
results: parsing output: 73/ for test: gem_exec_whisper
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: kms_rotation_crc
results: parsing output: 76/ for test: gen3_mixed_blits
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_hdmi_inject
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_mmap_gtt
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: kms_plane_scaling
results: parsing output: 83/ for test: kms_hdr
results: parsing output: 84/ for test: gem_exec_fence
results: parsing output: 85/ for test: gem_ctx_isolation
results: parsing output: 86/ for test: kms_async_flips
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: syncobj_eventfd
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_plane
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: gem_exec_flush
results: parsing output: 97/ for test: gem_fence_thrash
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_psr2_sf
results: parsing output: 100/ for test: kms_cursor_crc
results: parsing output: 101/ for test: gem_mmap_offset
results: parsing output: 102/ for test: kms_pipe_crc_basic
results: parsing output: 103/ for test: kms_force_connector_basic
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: gem_exec_reloc
results: parsing output: 108/ for test: gem_exec_schedule
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: gem_exec_reloc
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: kms_dsc
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: i915_module_load
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: dmabuf
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: api_intel_allocator
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_exec_schedule
results: parsing output: 121/ for test: gem_exec_params
results: parsing output: 122/ for test: gem_render_copy
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_cursor_crc
results: parsing output: 125/ for test: gem_userptr_blits
results: parsing output: 126/ for test: kms_vblank
results: parsing output: 127/ for test: gem_userptr_blits
results: parsing output: 128/ for test: gem_sync
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: kms_plane
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.