[55.069739] Initializing watchdogs
[55.069881]   /dev/watchdog0
[55.085366] [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]
[55.089459] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.091769] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.095786] [001/133] (960s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[55.214532] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[55.225884] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.010s)
[55.308149] [002/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[55.402240] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[55.406579] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[55.496624] [003/133] (960s left) perf_pmu (init-busy)
[55.539036] Starting subtest: init-busy
[55.541532] Starting dynamic subtest: rcs0
[55.544465] Dynamic subtest rcs0: SUCCESS (0.002s)
[55.551770] Starting dynamic subtest: bcs0
[55.553998] Dynamic subtest bcs0: SUCCESS (0.001s)
[55.560798] Starting dynamic subtest: vcs0
[55.563061] Dynamic subtest vcs0: SUCCESS (0.000s)
[55.569702] Starting dynamic subtest: vcs1
[55.571923] Dynamic subtest vcs1: SUCCESS (0.000s)
[55.578408] Starting dynamic subtest: vecs0
[55.580609] Dynamic subtest vecs0: SUCCESS (0.000s)
[55.587109] Starting dynamic subtest: ccs0
[55.589466] Dynamic subtest ccs0: SUCCESS (0.000s)
[55.591836] Subtest init-busy: SUCCESS (0.005s)
[55.652843] [004/133] (960s left) kms_flip (flip-vs-rmfb)
[55.754153] Starting subtest: flip-vs-rmfb
[55.755960] Starting dynamic subtest: A-eDP1
[64.413907] Dynamic subtest A-eDP1: SUCCESS (8.700s)
[64.421093] Starting dynamic subtest: B-eDP1
[73.103467] Dynamic subtest B-eDP1: SUCCESS (8.700s)
[73.110723] Starting dynamic subtest: C-eDP1
[81.757283] Dynamic subtest C-eDP1: SUCCESS (8.656s)
[81.766084] Starting dynamic subtest: D-eDP1
[90.375071] Dynamic subtest D-eDP1: SUCCESS (8.616s)
[90.379931] Subtest flip-vs-rmfb: SUCCESS (34.681s)
[91.572528] [005/133] (924s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[91.668180] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[91.670533] Starting dynamic subtest: pipe-A-eDP-1
[91.693633] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[91.702246] Starting dynamic subtest: pipe-B-eDP-1
[91.723982] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[91.730984] Starting dynamic subtest: pipe-C-eDP-1
[91.752809] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[91.759841] Starting dynamic subtest: pipe-D-eDP-1
[91.781946] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[91.785996] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[93.839675] [006/133] (921s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[93.899394] Starting subtest: x-tiled-to-vebox-y-tiled
[93.903990] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[94.081233] [007/133] (921s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[94.189478] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[94.193555] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[94.279547] [008/133] (921s left) gem_ctx_persistence (legacy-engines-mixed-process)
[94.345676] Starting subtest: legacy-engines-mixed-process
[94.348058] Starting dynamic subtest: render
[95.908875] Dynamic subtest render: SUCCESS (1.562s)
[95.918856] Starting dynamic subtest: bsd1
[97.884076] Dynamic subtest bsd1: SUCCESS (1.973s)
[97.892783] Starting dynamic subtest: bsd2
[99.905189] Dynamic subtest bsd2: SUCCESS (2.019s)
[99.913720] Starting dynamic subtest: blt
[101.891239] Dynamic subtest blt: SUCCESS (1.982s)
[101.899840] Starting dynamic subtest: vebox
[103.915514] Dynamic subtest vebox: SUCCESS (2.025s)
[103.918244] Subtest legacy-engines-mixed-process: SUCCESS (9.570s)
[103.994781] [009/133] (911s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[104.060237] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[104.120038] [010/133] (911s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[104.219285] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[110.866258] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.649s)
[111.011629] [011/133] (904s left) gem_exec_fence (basic-await)
[111.191671] Starting subtest: basic-await
[111.194358] Starting dynamic subtest: rcs0
[111.266331] Dynamic subtest rcs0: SUCCESS (0.075s)
[111.277459] Starting dynamic subtest: bcs0
[111.343047] Dynamic subtest bcs0: SUCCESS (0.075s)
[111.353820] Starting dynamic subtest: vcs0
[111.415983] Dynamic subtest vcs0: SUCCESS (0.071s)
[111.426579] Starting dynamic subtest: vcs1
[111.488083] Dynamic subtest vcs1: SUCCESS (0.070s)
[111.498365] Starting dynamic subtest: vecs0
[111.560023] Dynamic subtest vecs0: SUCCESS (0.070s)
[111.569267] Starting dynamic subtest: ccs0
[111.636437] Dynamic subtest ccs0: SUCCESS (0.075s)
[111.639111] Subtest basic-await: SUCCESS (0.447s)
[113.017597] [FACT gem_exec_fence (basic-await)] new: kernel.kmod_is_loaded.vgem: true
[113.021705] [012/133] (903s left) kms_vblank (query-forked)
[113.107089] Starting subtest: query-forked
[113.108962] Starting dynamic subtest: pipe-A-eDP-1
[114.949580] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.841s)
[114.962694] Starting dynamic subtest: pipe-D-eDP-1
[117.515580] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.564s)
[117.517586] Subtest query-forked: SUCCESS (4.409s)
[118.329713] [013/133] (897s left) gem_create (hog-create)
[118.390925] Starting subtest: hog-create
[118.392881] Starting dynamic subtest: smem0
[151.889448] Dynamic subtest smem0: SUCCESS (33.498s)
[151.892417] Subtest hog-create: SUCCESS (33.500s)
[152.076245] [014/133] (864s left) syncobj_wait (single-wait-all-for-submit-signaled)
[152.131154] Starting subtest: single-wait-all-for-submit-signaled
[152.133501] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[152.215791] [015/133] (863s left) gem_exec_balancer (hang)
[152.466046] Starting subtest: hang
[154.113913] Subtest hang: SUCCESS (1.650s)
[154.226514] [016/133] (861s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[154.337129] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[154.339611] Starting dynamic subtest: pipe-A-eDP-1
[154.348755] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[154.358903] Starting dynamic subtest: pipe-B-eDP-1
[154.367621] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[154.375611] Starting dynamic subtest: pipe-C-eDP-1
[154.384083] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[154.391640] Starting dynamic subtest: pipe-D-eDP-1
[154.400117] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[154.404245] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[156.602628] [017/133] (859s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[156.694460] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[156.698498] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[156.797669] [018/133] (859s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[157.176509] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[157.995442] [019/133] (858s left) vgem_basic (bad-flag)
[158.048410] Starting subtest: bad-flag
[158.050662] Subtest bad-flag: SUCCESS (0.000s)
[158.106863] [020/133] (858s left) kms_flip (flip-vs-panning)
[158.206588] Starting subtest: flip-vs-panning
[158.208898] Starting dynamic subtest: A-eDP1
[166.929504] Dynamic subtest A-eDP1: SUCCESS (8.724s)
[166.940058] Starting dynamic subtest: B-eDP1
[175.657421] Dynamic subtest B-eDP1: SUCCESS (8.725s)
[175.668836] Starting dynamic subtest: C-eDP1
[184.377812] Dynamic subtest C-eDP1: SUCCESS (8.718s)
[184.385909] Starting dynamic subtest: D-eDP1
[193.108684] Dynamic subtest D-eDP1: SUCCESS (8.729s)
[193.112657] Subtest flip-vs-panning: SUCCESS (34.907s)
[194.274724] [021/133] (822s left) kms_setmode (invalid-clone-exclusive-crtc)
[194.331072] Starting subtest: invalid-clone-exclusive-crtc
[194.337942] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[194.430549] [022/133] (822s left) gem_exec_reloc (basic-softpin)
[194.485088] Subtest basic-softpin: SKIP (0.000s)
[194.556761] [023/133] (821s left) gen9_exec_parse (unaligned-access)
[194.611353] Subtest unaligned-access: SKIP (0.000s)
[194.694757] [024/133] (821s left) kms_rotation_crc (primary-rotation-180)
[194.799279] Starting subtest: primary-rotation-180
[201.802289] Subtest primary-rotation-180: SUCCESS (7.004s)
[202.948293] [025/133] (813s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[203.056751] Starting subtest: y-tiled-8bpp-rotate-0
[203.061209] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[203.156357] [026/133] (813s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[205.084994] Starting subtest: modeset-lpsp-stress-no-wait
[214.811968] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.731s)
[214.909922] [027/133] (801s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[215.008221] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[215.012150] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[215.096951] [028/133] (801s left) prime_vgem (busy)
[215.178294] Starting subtest: busy
[215.180563] Starting dynamic subtest: rcs0
[215.241409] Dynamic subtest rcs0: SUCCESS (0.063s)
[215.249655] Starting dynamic subtest: bcs0
[215.284917] Dynamic subtest bcs0: SUCCESS (0.043s)
[215.292735] Starting dynamic subtest: vcs0
[215.331244] Dynamic subtest vcs0: SUCCESS (0.045s)
[215.338880] Starting dynamic subtest: vcs1
[215.375361] Dynamic subtest vcs1: SUCCESS (0.043s)
[215.383153] Starting dynamic subtest: vecs0
[215.422645] Dynamic subtest vecs0: SUCCESS (0.046s)
[215.430755] Starting dynamic subtest: ccs0
[215.468973] Dynamic subtest ccs0: SUCCESS (0.045s)
[215.471106] Subtest busy: SUCCESS (0.291s)
[215.600848] [029/133] (801s left) gem_ctx_param (basic)
[215.657898] Starting subtest: basic
[215.660329] Subtest basic: SUCCESS (0.001s)
[215.772918] [030/133] (801s left) syncobj_timeline (multi-wait-signaled)
[215.837381] Starting subtest: multi-wait-signaled
[215.839328] Subtest multi-wait-signaled: SUCCESS (0.001s)
[215.955658] [031/133] (800s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[216.017424] Starting subtest: invalid-bsd1-flag-on-blt
[216.019396] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[216.124908] [032/133] (800s left) i915_query (test-query-geometry-subslices)
[216.182507] Starting subtest: test-query-geometry-subslices
[216.184559] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[216.273757] [033/133] (800s left) kms_psr2_su (frontbuffer-xrgb8888)
[216.333976] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[216.401854] [034/133] (800s left) kms_color (ctm-negative)
[216.505625] Starting subtest: ctm-negative
[216.507462] Starting dynamic subtest: pipe-A-eDP-1
[217.216378] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s)
[217.225240] Starting dynamic subtest: pipe-B-eDP-1
[218.585485] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.367s)
[218.593911] Starting dynamic subtest: pipe-C-eDP-1
[219.960739] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s)
[219.969219] Starting dynamic subtest: pipe-D-eDP-1
[221.296572] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s)
[221.298920] Subtest ctm-negative: SUCCESS (4.789s)
[222.091617] [035/133] (794s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[222.191291] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[222.195459] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[222.264221] [036/133] (794s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[222.319377] Subtest no-spare-fences-busy: SKIP (0.000s)
[222.384183] [037/133] (794s left) gem_exec_schedule (independent)
[222.451155] Starting subtest: independent
[222.453407] Starting dynamic subtest: rcs0
[223.893332] Dynamic subtest rcs0: SUCCESS (1.451s)
[223.905157] Starting dynamic subtest: vcs0
[225.889569] Dynamic subtest vcs0: SUCCESS (1.994s)
[225.901555] Starting dynamic subtest: vcs1
[227.940477] Dynamic subtest vcs1: SUCCESS (2.048s)
[227.951707] Starting dynamic subtest: vecs0
[229.933467] Dynamic subtest vecs0: SUCCESS (1.990s)
[229.945029] Starting dynamic subtest: ccs0
[231.893171] Dynamic subtest ccs0: SUCCESS (1.956s)
[231.896183] Subtest independent: SUCCESS (9.453s)
[232.205784] [038/133] (784s left) kms_cursor_crc (cursor-alpha-opaque)
[232.310836] Starting subtest: cursor-alpha-opaque
[232.313021] Starting dynamic subtest: pipe-A-eDP-1
[232.956673] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.646s)
[232.965469] Starting dynamic subtest: pipe-D-eDP-1
[234.311281] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.354s)
[234.313415] Subtest cursor-alpha-opaque: SUCCESS (2.003s)
[235.161109] [039/133] (781s left) gem_mmap_gtt (basic-write-read)
[235.208658] Subtest basic-write-read: SKIP (0.000s)
[235.268590] [040/133] (781s left) gen9_exec_parse (bb-secure)
[235.332719] Subtest bb-secure: SKIP (0.000s)
[235.405096] [041/133] (781s left) api_intel_bb (lot-of-buffers)
[235.469901] Starting subtest: lot-of-buffers
[236.505067] Subtest lot-of-buffers: SUCCESS (1.035s)
[236.787726] [042/133] (780s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[236.831570] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[236.876182] [043/133] (780s left) gem_exec_params (invalid-fence-in)
[236.942726] Starting subtest: invalid-fence-in
[236.945208] Subtest invalid-fence-in: SUCCESS (0.000s)
[237.058341] [044/133] (780s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[237.161430] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[244.134602] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.975s)
[244.256921] [045/133] (773s left) gem_mmap_gtt (big-bo-tiledy)
[244.314949] Subtest big-bo-tiledY: SKIP (0.000s)
[244.386610] [046/133] (773s left) gem_softpin (evict-single-offset)
[244.439659] Starting subtest: evict-single-offset
[269.909651] Subtest evict-single-offset: SUCCESS (25.467s)
[270.013940] [047/133] (747s left) syncobj_wait (invalid-signal-illegal-handle)
[270.119737] Starting subtest: invalid-signal-illegal-handle
[270.122053] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[270.224572] [048/133] (747s left) kms_addfb_basic (master-rmfb)
[270.270505] Starting subtest: master-rmfb
[270.272907] Subtest master-rmfb: SUCCESS (0.001s)
[270.421254] [049/133] (747s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[270.514966] Starting subtest: plane-use-after-nonblocking-unbind
[270.517197] Starting dynamic subtest: pipe-A-eDP-1
[270.575816] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[270.873849] Starting dynamic subtest: pipe-B-eDP-1
[271.678709] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.813s)
[271.965121] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.451s)
[272.831570] [050/133] (744s left) i915_pm_rpm (debugfs-forcewake-user)
[275.101489] Starting subtest: debugfs-forcewake-user
[286.487678] Subtest debugfs-forcewake-user: SUCCESS (11.389s)
[286.892364] [051/133] (730s left) kms_pm_dc (dc5-dpms-negative)
[287.981903] Starting subtest: dc5-dpms-negative
[287.986336] Subtest dc5-dpms-negative: SKIP (0.000s)
[288.051909] [052/133] (729s left) gem_ctx_sseu (engines)
[288.101887] Subtest engines: SKIP (0.000s)
[288.156238] [053/133] (729s left) kms_flip (2x-busy-flip)
[288.258448] Starting subtest: 2x-busy-flip
[288.269374] Subtest 2x-busy-flip: SKIP (0.010s)
[288.369847] [054/133] (729s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[288.459663] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[288.464222] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[288.557585] [055/133] (729s left) kms_content_protection (suspend-resume)
[288.697091] Starting subtest: suspend-resume
[288.701492] Subtest suspend-resume: SKIP (0.000s)
[288.810497] [056/133] (729s left) gem_busy (busy)
[288.874335] Starting subtest: busy
[288.876510] Starting dynamic subtest: all-engines
[288.929812] Dynamic subtest all-engines: SUCCESS (0.055s)
[288.939336] Starting dynamic subtest: rcs0
[290.905652] Dynamic subtest rcs0: SUCCESS (1.973s)
[290.915129] Starting dynamic subtest: bcs0
[290.961809] Dynamic subtest bcs0: SUCCESS (0.052s)
[290.972750] Starting dynamic subtest: vcs0
[290.999138] Dynamic subtest vcs0: SUCCESS (0.038s)
[291.007571] Starting dynamic subtest: vcs1
[292.891337] Dynamic subtest vcs1: SUCCESS (1.887s)
[292.902069] Starting dynamic subtest: vecs0
[294.938052] Dynamic subtest vecs0: SUCCESS (2.046s)
[294.948523] Starting dynamic subtest: ccs0
[296.924397] Dynamic subtest ccs0: SUCCESS (1.984s)
[296.927050] Subtest busy: SUCCESS (8.046s)
[297.276872] [057/133] (720s left) kms_chamelium_frames (dp-crc-multiple)
[297.680299] Subtest dp-crc-multiple: SKIP (0.000s)
[298.480129] [058/133] (719s left) gem_userptr_blits (nohangcheck)
[298.547542] Starting subtest: nohangcheck
[298.791173] Subtest nohangcheck: SUCCESS (0.240s)
[298.911121] [059/133] (719s left) kms_invalid_mode (bad-vtotal)
[299.011260] Starting subtest: bad-vtotal
[299.013812] Starting dynamic subtest: pipe-A-eDP-1
[299.297804] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[299.307718] Starting dynamic subtest: pipe-B-eDP-1
[299.310209] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[299.318394] Starting dynamic subtest: pipe-C-eDP-1
[299.320837] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[299.328738] Starting dynamic subtest: pipe-D-eDP-1
[299.331181] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[299.333521] Subtest bad-vtotal: SUCCESS (0.293s)
[300.130206] [060/133] (717s left) gem_partial_pwrite_pread (write-uncached)
[300.177431] Subtest write-uncached: SKIP (0.000s)
[300.250195] [061/133] (717s left) gem_mmap_gtt (bad-object)
[300.314169] Subtest bad-object: SKIP (0.000s)
[300.373488] [062/133] (717s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[300.471383] Starting subtest: psr-rgb565-draw-mmap-cpu
[307.205316] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.736s)
[307.316926] [063/133] (710s left) kms_big_fb (yf-tiled-addfb)
[307.429783] Starting subtest: yf-tiled-addfb
[307.434278] Subtest yf-tiled-addfb: SKIP (0.000s)
[307.523540] [064/133] (710s left) gem_exec_reloc (basic-write-read-active)
[307.587055] Subtest basic-write-read-active: SKIP (0.000s)
[307.650389] [065/133] (710s left) kms_lease (setcrtc-implicit-plane)
[307.752048] Starting subtest: setcrtc-implicit-plane
[307.754402] Starting dynamic subtest: pipe-A-eDP-1
[308.229218] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.476s)
[308.239262] Starting dynamic subtest: pipe-B-eDP-1
[309.390862] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.161s)
[309.400166] Starting dynamic subtest: pipe-C-eDP-1
[310.511330] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.117s)
[310.520219] Starting dynamic subtest: pipe-D-eDP-1
[311.637653] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s)
[311.639629] Subtest setcrtc-implicit-plane: SUCCESS (3.885s)
[312.488492] [066/133] (705s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[312.600916] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[313.568350] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.967s)
[313.699684] [067/133] (704s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[313.789175] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[313.791637] Starting dynamic subtest: pipe-A-eDP-1
[313.813052] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[313.824079] Starting dynamic subtest: pipe-B-eDP-1
[313.842374] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[313.850320] Starting dynamic subtest: pipe-C-eDP-1
[313.869114] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[313.876983] Starting dynamic subtest: pipe-D-eDP-1
[313.895216] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[313.898819] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[316.049336] [068/133] (702s left) kms_chamelium_audio (hdmi-audio-edid)
[316.438450] Subtest hdmi-audio-edid: SKIP (0.000s)
[317.255334] [069/133] (701s left) vgem_basic (sysfs)
[317.301823] Starting subtest: sysfs
[317.304222] Subtest sysfs: SUCCESS (0.000s)
[317.356843] [070/133] (701s left) kms_vrr (negative-basic)
[317.439745] Starting subtest: negative-basic
[317.446289] Starting dynamic subtest: pipe-A-eDP-1
[322.861308] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.414s)
[323.153625] Subtest negative-basic: SUCCESS (5.713s)
[324.001684] [071/133] (694s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[324.102361] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[324.107064] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[325.240384] [072/133] (693s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[325.334707] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[325.345508] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[325.424820] [073/133] (693s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[325.517179] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[325.521668] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[325.589325] [074/133] (692s left) gem_exec_whisper (basic-forked)
[325.653546] Starting subtest: basic-forked
[333.752689] Subtest basic-forked: SUCCESS (8.096s)
[333.939979] [075/133] (684s left) gem_exec_reloc (basic-write-read-noreloc)
[334.012224] Subtest basic-write-read-noreloc: SKIP (0.000s)
[334.073144] [076/133] (684s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[334.163081] Starting subtest: multiplane-rotation-cropping-top
[351.610534] Subtest multiplane-rotation-cropping-top: SUCCESS (17.449s)
[351.725793] [077/133] (666s left) gen3_mixed_blits
[351.851134] [078/133] (666s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[351.949747] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[358.683513] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.734s)
[358.810803] [079/133] (659s left) kms_hdmi_inject (inject-audio)
[359.154834] Starting subtest: inject-audio
[359.430083] Subtest inject-audio: SUCCESS (0.277s)
[360.042865] [080/133] (658s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[360.132224] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[360.136282] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[360.245600] [081/133] (658s left) gem_mmap_gtt (hang-user)
[360.302195] Subtest hang-user: SKIP (0.000s)
[360.359346] [082/133] (658s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[360.418981] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[360.482944] [083/133] (658s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[360.566504] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[360.568914] Starting dynamic subtest: pipe-A
[360.588427] Dynamic subtest pipe-A: SKIP (0.017s)
[360.602079] Starting dynamic subtest: pipe-B
[360.618600] Dynamic subtest pipe-B: SKIP (0.029s)
[360.627780] Starting dynamic subtest: pipe-C
[360.645085] Dynamic subtest pipe-C: SKIP (0.029s)
[360.653924] Starting dynamic subtest: pipe-D
[360.674474] Dynamic subtest pipe-D: SKIP (0.029s)
[360.678470] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.106s)
[360.783772] [084/133] (658s left) kms_hdr (static-swap)
[360.889877] Starting subtest: static-swap
[360.897257] Subtest static-swap: SKIP (0.000s)
[360.962241] [085/133] (658s left) gem_exec_fence (syncobj-timeline-repeat)
[361.533733] Starting subtest: syncobj-timeline-repeat
[361.762182] Subtest syncobj-timeline-repeat: SUCCESS (0.228s)
[362.978329] [086/133] (656s left) gem_ctx_isolation (preservation-reset)
[363.153639] Starting subtest: preservation-reset
[363.156054] Starting dynamic subtest: rcs0
[363.434965] Dynamic subtest rcs0: SUCCESS (0.284s)
[363.449295] Starting dynamic subtest: bcs0
[363.785684] Dynamic subtest bcs0: SUCCESS (0.350s)
[363.798184] Starting dynamic subtest: vcs0
[364.119076] Dynamic subtest vcs0: SUCCESS (0.332s)
[364.131303] Starting dynamic subtest: vcs1
[366.200365] Dynamic subtest vcs1: SUCCESS (2.080s)
[366.212858] Starting dynamic subtest: vecs0
[368.185078] Dynamic subtest vecs0: SUCCESS (1.984s)
[368.197296] Starting dynamic subtest: ccs0
[370.174073] Dynamic subtest ccs0: SUCCESS (1.988s)
[370.176667] Subtest preservation-reset: SUCCESS (7.026s)
[370.325357] [087/133] (648s left) kms_async_flips (crc-atomic)
[370.417133] Starting subtest: crc-atomic
[370.794606] Starting dynamic subtest: pipe-A-eDP-1
[373.680686] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.887s)
[374.057316] Starting dynamic subtest: pipe-B-eDP-1
[376.976896] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.929s)
[377.353752] Starting dynamic subtest: pipe-C-eDP-1
[380.264917] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.921s)
[380.630074] Starting dynamic subtest: pipe-D-eDP-1
[383.571471] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.953s)
[383.574053] Subtest crc-atomic: SUCCESS (13.157s)
[384.799653] [088/133] (634s left) kms_cursor_legacy (forked-bo)
[384.914020] Starting subtest: forked-bo
[384.916270] Starting dynamic subtest: pipe-A
[390.388127] Dynamic subtest pipe-A: SUCCESS (5.472s)
[390.402706] Starting dynamic subtest: pipe-B
[395.865619] Dynamic subtest pipe-B: SUCCESS (5.475s)
[395.877377] Starting dynamic subtest: pipe-C
[401.338712] Dynamic subtest pipe-C: SUCCESS (5.469s)
[401.357354] Starting dynamic subtest: pipe-D
[406.822036] Dynamic subtest pipe-D: SUCCESS (5.481s)
[406.834031] Starting dynamic subtest: all-pipes
[412.312271] Dynamic subtest all-pipes: SUCCESS (5.488s)
[412.314966] Subtest forked-bo: SUCCESS (27.397s)
[412.455804] [089/133] (606s left) syncobj_eventfd (timeline-wait-signaled)
[412.529792] Starting subtest: timeline-wait-signaled
[412.532104] Subtest timeline-wait-signaled: SUCCESS (0.001s)
[412.630371] [090/133] (606s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[412.725702] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[419.968550] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.245s)
[420.118543] [091/133] (599s left) syncobj_timeline (invalid-transfer-non-existent-point)
[420.197919] Starting subtest: invalid-transfer-non-existent-point
[420.200392] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[420.300358] [092/133] (599s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[420.418463] Starting subtest: cursorB-vs-flipA-atomic-transitions
[420.423093] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[420.567876] [093/133] (598s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[420.669592] Starting subtest: x-tiled-32bpp-rotate-90
[420.689668] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s)
[420.815384] [094/133] (598s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[420.911887] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[420.937580] Starting dynamic subtest: pipe-A-plane-0
[421.570792] Dynamic subtest pipe-A-plane-0: SUCCESS (0.633s)
[421.579954] Starting dynamic subtest: pipe-A-plane-3
[421.981599] Dynamic subtest pipe-A-plane-3: SUCCESS (0.410s)
[423.058351] Starting dynamic subtest: pipe-B-plane-0
[423.698727] Dynamic subtest pipe-B-plane-0: SUCCESS (0.655s)
[423.708072] Starting dynamic subtest: pipe-B-plane-3
[424.142633] Dynamic subtest pipe-B-plane-3: SUCCESS (0.442s)
[424.451286] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.541s)
[425.304450] [095/133] (594s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[425.404311] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[425.408902] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[425.512471] [096/133] (593s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[425.577446] Starting subtest: single-wait-for-submit-available-signaled
[425.580020] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[425.687927] [097/133] (593s left) gem_exec_flush (basic-batch-kernel-default-uc)
[425.748989] Starting subtest: basic-batch-kernel-default-uc
[432.644756] Subtest basic-batch-kernel-default-uc: SUCCESS (6.895s)
[432.842909] [098/133] (586s left) gem_fence_thrash (bo-write-verify-threaded-y)
[432.885729] Starting subtest: bo-write-verify-threaded-y
[432.912641] Subtest bo-write-verify-threaded-y: SKIP (0.023s)
[433.001234] [099/133] (586s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[433.110119] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[433.114239] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[433.212230] [100/133] (586s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[433.311311] Starting subtest: psr2-cursor-plane-update-sf
[433.313525] Starting dynamic subtest: pipe-A-eDP-1
[433.875735] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s)
[433.891955] Starting dynamic subtest: pipe-B-eDP-1
[435.140941] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.265s)
[435.143151] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.833s)
[436.010086] [101/133] (583s left) kms_cursor_crc (cursor-random-256x85)
[436.286741] Starting subtest: cursor-random-256x85
[436.330499] Subtest cursor-random-256x85: SKIP (0.041s)
[436.494663] [102/133] (583s left) gem_mmap_offset (ptrace)
[436.556437] Starting subtest: ptrace
[436.559026] Starting dynamic subtest: smem0-wb
[436.573170] Dynamic subtest smem0-wb: SUCCESS (0.018s)
[436.582093] Starting dynamic subtest: smem0-wc
[436.590579] Dynamic subtest smem0-wc: SUCCESS (0.017s)
[436.600216] Starting dynamic subtest: smem0-uc
[436.611590] Dynamic subtest smem0-uc: SUCCESS (0.020s)
[436.613762] Subtest ptrace: SUCCESS (0.059s)
[436.725973] [103/133] (583s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[436.808353] Starting subtest: compare-crc-sanitycheck-xr24
[436.810607] Starting dynamic subtest: pipe-A-eDP-1
[437.448057] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.641s)
[437.458488] Starting dynamic subtest: pipe-B-eDP-1
[438.777315] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.324s)
[438.786884] Starting dynamic subtest: pipe-C-eDP-1
[440.000173] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.223s)
[440.010358] Starting dynamic subtest: pipe-D-eDP-1
[441.174795] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.171s)
[441.177436] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.364s)
[441.993415] [104/133] (577s left) kms_force_connector_basic (prune-stale-modes)
[442.086786] Starting subtest: prune-stale-modes
[442.526974] Subtest prune-stale-modes: SUCCESS (0.440s)
[442.686209] [105/133] (577s left) kms_psr (psr-cursor-plane-move)
[442.773110] Starting subtest: psr-cursor-plane-move
[442.775516] Starting dynamic subtest: eDP-1
[444.446736] Dynamic subtest eDP-1: SUCCESS (1.673s)
[444.449302] Subtest psr-cursor-plane-move: SUCCESS (1.675s)
[445.285408] [106/133] (574s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[445.388167] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[445.392831] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[445.487759] [107/133] (574s left) kms_big_fb (linear-8bpp-rotate-270)
[445.600544] Starting subtest: linear-8bpp-rotate-270
[445.622884] Subtest linear-8bpp-rotate-270: SKIP (0.022s)
[445.734837] [108/133] (574s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[445.796933] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[445.855761] [109/133] (574s left) gem_exec_schedule (fairslice-all)
[445.936614] Starting subtest: fairslice-all
[447.992293] Subtest fairslice-all: SUCCESS (2.058s)
[448.296578] [110/133] (571s left) kms_psr (pr-no-drrs)
[448.393089] Starting subtest: pr-no-drrs
[448.397486] Subtest pr-no-drrs: SKIP (0.000s)
[448.470991] [111/133] (571s left) gem_exec_reloc (basic-wc-gtt)
[448.538120] Subtest basic-wc-gtt: SKIP (0.000s)
[448.614618] [112/133] (571s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[448.730371] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[448.734778] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[448.804112] [113/133] (571s left) kms_dsc (dsc-with-bpc)
[448.902503] Starting subtest: dsc-with-bpc
[448.934727] Subtest dsc-with-bpc: SKIP (0.001s)
[448.979803] [114/133] (571s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[449.075899] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[449.080330] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[449.170300] [115/133] (571s left) i915_module_load (reload-no-display)
[449.203512] Starting subtest: reload-no-display
[455.064847] Subtest reload-no-display: SUCCESS (5.861s)
[455.093827] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[455.095069] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[455.098622] [116/133] (565s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[456.612401] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[456.719873] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[456.761304] [FACT syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[456.762481] [FACT syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)] new: kernel.kmod_is_loaded.i915: true
[456.766243] [117/133] (563s left) dmabuf (all-tests)
[456.808731] Starting subtest: all-tests
[456.810986] Starting dynamic subtest: sanitycheck
[456.908426] Dynamic subtest sanitycheck: SUCCESS (0.099s)
[456.920115] Starting dynamic subtest: dma_fence
[457.093799] Dynamic subtest dma_fence: SUCCESS (0.183s)
[457.105445] Starting dynamic subtest: dma_fence_chain
[466.270569] Dynamic subtest dma_fence_chain: SUCCESS (9.173s)
[466.281284] Starting dynamic subtest: dma_fence_unwrap
[466.363241] Dynamic subtest dma_fence_unwrap: SUCCESS (0.092s)
[466.374117] Starting dynamic subtest: dma_resv
[466.462403] Dynamic subtest dma_resv: SUCCESS (0.097s)
[466.465145] Subtest all-tests: SUCCESS (9.655s)
[466.542852] [118/133] (553s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[466.599253] Starting subtest: single-wait-all-for-submit-unsubmitted
[466.704873] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[466.784170] [119/133] (553s left) api_intel_allocator (simple-allocator)
[466.833075] Starting subtest: simple-allocator
[466.835464] Starting dynamic subtest: basic
[466.843400] Dynamic subtest basic: SUCCESS (0.010s)
[466.853890] Starting dynamic subtest: parallel-one
[467.020725] Dynamic subtest parallel-one: SUCCESS (0.175s)
[467.028768] Starting dynamic subtest: print
[467.031199] Dynamic subtest print: SUCCESS (0.000s)
[467.044103] Starting dynamic subtest: reuse
[467.046070] Dynamic subtest reuse: SUCCESS (0.000s)
[467.053393] Starting dynamic subtest: reserve
[467.055279] Dynamic subtest reserve: SUCCESS (0.000s)
[467.062488] Starting dynamic subtest: fork-reopen-allocator
[467.064400] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[467.066285] Subtest simple-allocator: SUCCESS (0.203s)
[467.162892] [120/133] (553s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[467.266628] Starting subtest: yf-tiled-16bpp-rotate-180
[467.271185] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[467.368474] [121/133] (553s left) gem_exec_schedule (u-independent)
[467.439749] Starting subtest: u-independent
[467.442062] Starting dynamic subtest: rcs0
[468.887978] Dynamic subtest rcs0: SUCCESS (1.452s)
[468.901801] Starting dynamic subtest: vcs0
[470.948725] Dynamic subtest vcs0: SUCCESS (2.058s)
[470.958860] Starting dynamic subtest: vcs1
[472.942122] Dynamic subtest vcs1: SUCCESS (1.991s)
[472.953281] Starting dynamic subtest: vecs0
[474.914887] Dynamic subtest vecs0: SUCCESS (1.970s)
[474.925779] Starting dynamic subtest: ccs0
[476.885798] Dynamic subtest ccs0: SUCCESS (1.968s)
[476.888770] Subtest u-independent: SUCCESS (9.452s)
[477.187930] [122/133] (543s left) gem_exec_params (sol-reset-not-gen7)
[477.257593] Starting subtest: sol-reset-not-gen7
[477.259757] Subtest sol-reset-not-gen7: SUCCESS (0.005s)
[477.393401] [123/133] (543s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[477.453323] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[477.457931] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[477.655046] [124/133] (543s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[477.760773] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[485.006217] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.249s)
[485.129585] [125/133] (535s left) kms_cursor_crc (cursor-suspend)
[485.273947] Starting subtest: cursor-suspend
[485.275918] Starting dynamic subtest: pipe-A-eDP-1
[518.785002] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.273s)
[518.794149] Starting dynamic subtest: pipe-D-eDP-1
[552.837179] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.838s)
[552.839357] Subtest cursor-suspend: SUCCESS (7.115s)
[553.819494] [126/133] (466s left) gem_userptr_blits (sync-unmap-after-close)
[553.900057] Starting subtest: sync-unmap-after-close
[553.910251] Subtest sync-unmap-after-close: SUCCESS (0.013s)
[554.035189] [127/133] (466s left) kms_vblank (ts-continuation-modeset-rpm)
[554.123508] Starting subtest: ts-continuation-modeset-rpm
[554.125360] Starting dynamic subtest: pipe-A-eDP-1
[556.658007] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.574s)
[556.672672] Starting dynamic subtest: pipe-D-eDP-1
[558.895776] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.259s)
[558.898069] Subtest ts-continuation-modeset-rpm: SUCCESS (4.836s)
[559.770919] [128/133] (461s left) gem_userptr_blits (create-destroy-sync)
[559.856515] Starting subtest: create-destroy-sync
[564.873018] Subtest create-destroy-sync: SUCCESS (5.049s)
[564.992728] [129/133] (455s left) gem_sync (basic-many-each)
[565.075246] Starting subtest: basic-many-each
[567.343779] Subtest basic-many-each: SUCCESS (2.281s)
[567.530636] [130/133] (453s left) kms_psr (fbc-psr2-no-drrs)
[567.619554] Starting subtest: fbc-psr2-no-drrs
[567.621910] Starting dynamic subtest: eDP-1
[567.626064] Dynamic subtest eDP-1: SKIP (0.000s)
[567.630225] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[567.707616] [131/133] (453s left) kms_plane (plane-position-covered)
[567.798447] Starting subtest: plane-position-covered
[568.310569] Starting dynamic subtest: pipe-A-plane-1
[569.559299] Dynamic subtest pipe-A-plane-1: SUCCESS (1.253s)
[569.569490] Starting dynamic subtest: pipe-A-plane-2
[570.807774] Dynamic subtest pipe-A-plane-2: SUCCESS (1.250s)
[570.819699] Starting dynamic subtest: pipe-A-plane-3
[572.040039] Dynamic subtest pipe-A-plane-3: SUCCESS (1.232s)
[572.049896] Starting dynamic subtest: pipe-A-plane-4
[573.278343] Dynamic subtest pipe-A-plane-4: SUCCESS (1.240s)
[573.288458] Starting dynamic subtest: pipe-A-plane-5
[573.306805] Dynamic subtest pipe-A-plane-5: SUCCESS (0.028s)
[574.425897] Starting dynamic subtest: pipe-B-plane-1
[575.667064] Dynamic subtest pipe-B-plane-1: SUCCESS (1.248s)
[575.678098] Starting dynamic subtest: pipe-B-plane-2
[576.966267] Dynamic subtest pipe-B-plane-2: SUCCESS (1.301s)
[576.977043] Starting dynamic subtest: pipe-B-plane-3
[578.236369] Dynamic subtest pipe-B-plane-3: SUCCESS (1.274s)
[578.247726] Starting dynamic subtest: pipe-B-plane-4
[579.543315] Dynamic subtest pipe-B-plane-4: SUCCESS (1.305s)
[579.554123] Starting dynamic subtest: pipe-B-plane-5
[579.566540] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[579.568765] Subtest plane-position-covered: SUCCESS (11.791s)
[580.424895] [132/133] (440s left) kms_psr (fbc-psr-sprite-render)
[580.515117] Starting subtest: fbc-psr-sprite-render
[580.517505] Starting dynamic subtest: eDP-1
[580.521934] Dynamic subtest eDP-1: SKIP (0.000s)
[580.526437] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[580.588399] [133/133] (440s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[580.681301] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[580.685532] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[580.774519] 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.