[56.097090] Initializing watchdogs
[56.097161]   /dev/watchdog0
[56.112651] [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]
[56.117273] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.120117] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.123741] [001/133] (960s left) gem_pxp (create-regular-buffer)
[56.278377] Starting subtest: create-regular-buffer
[56.280886] Subtest create-regular-buffer: SUCCESS (0.000s)
[56.409442] [002/133] (960s left) kms_pm_rpm (basic-pci-d3-state)
[58.482620] Starting subtest: basic-pci-d3-state
[59.985073] Subtest basic-pci-d3-state: SUCCESS (1.481s)
[60.110022] [003/133] (956s left) gem_wait (wait)
[60.172426] Starting subtest: wait
[60.174727] Starting dynamic subtest: all-engines
[61.346380] Dynamic subtest all-engines: SUCCESS (1.156s)
[61.357074] Starting dynamic subtest: rcs0
[62.389985] Dynamic subtest rcs0: SUCCESS (1.032s)
[62.400645] Starting dynamic subtest: bcs0
[63.436162] Dynamic subtest bcs0: SUCCESS (1.035s)
[63.446084] Starting dynamic subtest: vcs0
[64.480695] Dynamic subtest vcs0: SUCCESS (1.034s)
[64.490567] Starting dynamic subtest: vcs1
[65.526112] Dynamic subtest vcs1: SUCCESS (1.036s)
[65.536079] Starting dynamic subtest: vecs0
[66.571058] Dynamic subtest vecs0: SUCCESS (1.035s)
[66.580727] Starting dynamic subtest: ccs0
[67.617059] Dynamic subtest ccs0: SUCCESS (1.042s)
[67.619439] Subtest wait: SUCCESS (7.377s)
[67.810693] [004/133] (948s left) gem_exec_gttfill (engines)
[67.884760] Starting subtest: engines
[67.887137] Starting dynamic subtest: rcs0
[91.403371] Dynamic subtest rcs0: SUCCESS (23.478s)
[91.413568] Starting dynamic subtest: bcs0
[114.674625] Dynamic subtest bcs0: SUCCESS (23.262s)
[114.685768] Starting dynamic subtest: vcs0
[137.968932] Dynamic subtest vcs0: SUCCESS (23.290s)
[137.977454] Starting dynamic subtest: vcs1
[161.300486] Dynamic subtest vcs1: SUCCESS (23.333s)
[161.309508] Starting dynamic subtest: vecs0
[184.625026] Dynamic subtest vecs0: SUCCESS (23.326s)
[184.633449] Starting dynamic subtest: ccs0
[207.973318] Dynamic subtest ccs0: SUCCESS (23.347s)
[207.975902] Subtest engines: SUCCESS (140.042s)
[208.187553] [005/133] (808s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[208.357463] Starting subtest: fbcpsr-2p-rte
[208.361814] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[208.460051] [006/133] (808s left) kms_psr (fbc-pr-no-drrs)
[208.555902] Starting subtest: fbc-pr-no-drrs
[208.559806] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[208.623195] [007/133] (808s left) perf (gen12-group-concurrent-oa-buffer-read)
[208.775100] Starting subtest: gen12-group-concurrent-oa-buffer-read
[218.816813] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.040s)
[218.863173] [008/133] (798s left) gem_softpin (full)
[218.935790] Starting subtest: full
[218.940626] Subtest full: SUCCESS (0.008s)
[219.064245] [009/133] (797s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[219.162827] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[219.167063] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[219.235631] [010/133] (797s left) gem_mmap_gtt (basic-read)
[219.294143] Subtest basic-read: SKIP (0.000s)
[219.351929] [011/133] (797s left) kms_big_fb (linear-32bpp-rotate-180)
[219.453711] Starting subtest: linear-32bpp-rotate-180
[220.966627] Subtest linear-32bpp-rotate-180: SUCCESS (1.513s)
[221.112082] [012/133] (795s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[221.200971] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[221.204572] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[221.299977] [013/133] (795s left) gem_ctx_bad_destroy (invalid-ctx)
[221.359293] Starting subtest: invalid-ctx
[221.361110] Subtest invalid-ctx: SUCCESS (0.000s)
[221.429485] [014/133] (795s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[221.514704] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[221.543815] Starting dynamic subtest: pipe-A-plane-0
[221.832145] Dynamic subtest pipe-A-plane-0: SUCCESS (0.288s)
[221.841240] Starting dynamic subtest: pipe-A-plane-3
[222.065552] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[222.074349] Starting dynamic subtest: pipe-A-plane-5
[222.077899] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[223.135632] Starting dynamic subtest: pipe-B-plane-0
[223.427434] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[223.435831] Starting dynamic subtest: pipe-B-plane-3
[223.661350] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[223.674953] Starting dynamic subtest: pipe-B-plane-5
[223.679894] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[223.970226] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.453s)
[224.804383] [015/133] (792s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[224.884770] Starting subtest: single-wait-for-submit-available-signaled
[224.887189] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.001s)
[225.006155] [016/133] (792s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[225.104635] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[225.106510] Starting dynamic subtest: pipe-A-default-mode
[226.264333] Dynamic subtest pipe-A-default-mode: SKIP (1.158s)
[226.268069] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.159s)
[226.397853] [017/133] (790s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[226.451857] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[226.453866] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[226.560213] [018/133] (790s left) i915_drm_fdinfo (virtual-busy-all)
[226.595650] Starting subtest: virtual-busy-all
[226.600404] Subtest virtual-busy-all: SKIP (0.000s)
[226.658498] [019/133] (790s left) gem_exec_reloc (basic-gtt-read-noreloc)
[226.709176] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[226.784463] [020/133] (790s left) kms_lease (lease-invalid-connector)
[226.880901] Starting subtest: lease-invalid-connector
[226.883201] Starting dynamic subtest: pipe-A-eDP-1
[226.885113] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[226.895028] Starting dynamic subtest: pipe-B-eDP-1
[226.897202] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[226.905602] Starting dynamic subtest: pipe-C-eDP-1
[226.907510] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[226.915298] Starting dynamic subtest: pipe-D-eDP-1
[226.917171] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[226.919020] Subtest lease-invalid-connector: SUCCESS (0.003s)
[226.954043] [021/133] (790s left) gem_pxp (reject-modify-context-protection-off-3)
[227.054062] Starting subtest: reject-modify-context-protection-off-3
[227.056404] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[227.159672] [022/133] (790s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[227.253466] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[227.255360] Starting dynamic subtest: pipe-A-eDP-1
[227.304588] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[227.314040] Starting dynamic subtest: pipe-B-eDP-1
[227.363275] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[227.372228] Starting dynamic subtest: pipe-C-eDP-1
[227.420312] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[227.429735] Starting dynamic subtest: pipe-D-eDP-1
[227.478872] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[227.482621] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[229.496609] [023/133] (787s left) gem_mmap_gtt (fault-concurrent)
[229.558059] Subtest fault-concurrent: SKIP (0.000s)
[229.613831] [024/133] (787s left) kms_addfb_basic (addfb25-4-tiled)
[229.704134] Starting subtest: addfb25-4-tiled
[229.706320] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[229.793654] [025/133] (787s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[229.889519] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[229.891765] Starting dynamic subtest: A-eDP1
[233.538066] Dynamic subtest A-eDP1: SUCCESS (3.645s)
[233.548637] Starting dynamic subtest: B-eDP1
[236.748642] Dynamic subtest B-eDP1: SUCCESS (3.211s)
[236.758894] Starting dynamic subtest: C-eDP1
[239.859904] Dynamic subtest C-eDP1: SUCCESS (3.108s)
[239.870305] Starting dynamic subtest: D-eDP1
[242.984621] Dynamic subtest D-eDP1: SUCCESS (3.126s)
[242.988317] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.096s)
[243.801834] [026/133] (773s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[243.924141] Starting subtest: flip-vs-cursor-busy-crc-legacy
[244.728635] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.801s)
[245.525443] [027/133] (772s left) syncobj_eventfd (timeline-wait-signaled)
[245.590204] Starting subtest: timeline-wait-signaled
[245.592510] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[245.691613] [028/133] (771s left) gem_exec_schedule (u-fairslice)
[245.769313] Starting subtest: u-fairslice
[245.771241] Starting dynamic subtest: rcs0
[247.856879] Dynamic subtest rcs0: SUCCESS (2.025s)
[247.867213] Starting dynamic subtest: bcs0
[249.816161] Dynamic subtest bcs0: SUCCESS (2.017s)
[249.826395] Starting dynamic subtest: vcs0
[251.880217] Dynamic subtest vcs0: SUCCESS (2.019s)
[251.890439] Starting dynamic subtest: vcs1
[253.850888] Dynamic subtest vcs1: SUCCESS (2.018s)
[253.862280] Starting dynamic subtest: vecs0
[255.920267] Dynamic subtest vecs0: SUCCESS (2.019s)
[255.930181] Starting dynamic subtest: ccs0
[257.938138] Dynamic subtest ccs0: SUCCESS (2.019s)
[257.940205] Subtest u-fairslice: SUCCESS (12.119s)
[258.190676] [029/133] (759s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[258.293140] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[258.295395] Starting dynamic subtest: pipe-A-default-mode
[261.060565] Dynamic subtest pipe-A-default-mode: SUCCESS (2.767s)
[261.063144] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.769s)
[261.928031] [030/133] (755s left) gem_exec_whisper (basic-sync-all)
[261.990866] Starting subtest: basic-sync-all
[268.597692] Subtest basic-sync-all: SUCCESS (6.605s)
[268.799049] [031/133] (749s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[268.870131] Starting subtest: etime-multi-wait-available-unsubmitted
[268.974329] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.103s)
[269.048270] [032/133] (748s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[269.149055] Starting subtest: random-ccs-data-y-tiled-ccs
[269.151375] Starting dynamic subtest: pipe-A-eDP-1
[269.176519] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[269.187792] Starting dynamic subtest: pipe-B-eDP-1
[269.211373] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[269.219660] Starting dynamic subtest: pipe-C-eDP-1
[269.242101] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[269.250551] Starting dynamic subtest: pipe-D-eDP-1
[269.273238] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[269.277070] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.003s)
[271.405927] [033/133] (746s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[271.506991] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[271.509247] Starting dynamic subtest: pipe-A-eDP-1
[271.529595] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[271.542282] Starting dynamic subtest: pipe-B-eDP-1
[271.561541] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[271.570238] Starting dynamic subtest: pipe-C-eDP-1
[271.589427] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[271.597897] Starting dynamic subtest: pipe-D-eDP-1
[271.617263] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[271.619437] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[273.768658] [034/133] (744s left) kms_addfb_basic (basic)
[273.827257] Starting subtest: basic
[273.829247] Subtest basic: SUCCESS (0.000s)
[273.949420] [035/133] (744s left) kms_color_pipeline (plane-lut1d-lut1d)
[274.049282] Starting subtest: plane-lut1d-lut1d
[274.172297] Starting dynamic subtest: pipe-A-plane-0
[274.350493] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s)
[274.360732] Starting dynamic subtest: pipe-A-plane-1
[274.506520] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[274.516278] Starting dynamic subtest: pipe-A-plane-2
[274.662542] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[275.872175] Starting dynamic subtest: pipe-B-plane-0
[276.042614] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[276.051618] Starting dynamic subtest: pipe-B-plane-1
[276.198981] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[276.212443] Starting dynamic subtest: pipe-B-plane-2
[276.365058] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[277.622754] Starting dynamic subtest: pipe-C-plane-0
[277.781039] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s)
[277.791326] Starting dynamic subtest: pipe-C-plane-1
[277.947610] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[277.957633] Starting dynamic subtest: pipe-C-plane-2
[278.081113] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s)
[279.243868] Starting dynamic subtest: pipe-D-plane-0
[279.403339] Dynamic subtest pipe-D-plane-0: SUCCESS (0.167s)
[279.412248] Starting dynamic subtest: pipe-D-plane-1
[279.550535] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[279.561631] Starting dynamic subtest: pipe-D-plane-2
[279.692329] Dynamic subtest pipe-D-plane-2: SUCCESS (0.143s)
[279.985884] Subtest plane-lut1d-lut1d: SUCCESS (5.936s)
[280.820342] [036/133] (737s left) api_intel_allocator (standalone)
[280.889612] Starting subtest: standalone
[280.903418] Subtest standalone: SUCCESS (0.016s)
[281.024914] [037/133] (737s left) prime_self_import (basic-llseek-bad)
[281.063610] Starting subtest: basic-llseek-bad
[281.092847] Subtest basic-llseek-bad: SUCCESS (0.029s)
[281.206268] [038/133] (736s left) kms_vblank (query-forked)
[281.295283] Starting subtest: query-forked
[281.297659] Starting dynamic subtest: pipe-A-eDP-1
[283.178818] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.880s)
[283.193399] Starting dynamic subtest: pipe-D-eDP-1
[285.736771] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.551s)
[285.738787] Subtest query-forked: SUCCESS (4.438s)
[286.576547] [039/133] (731s left) gem_exec_flush (basic-uc-ro-default)
[286.638470] Starting subtest: basic-uc-ro-default
[292.123644] Subtest basic-uc-ro-default: SUCCESS (5.459s)
[292.291696] [040/133] (725s left) perf (per-context-mode-unprivileged)
[292.390484] Starting subtest: per-context-mode-unprivileged
[292.395209] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[292.435345] [041/133] (725s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[292.527095] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[292.531475] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[292.627711] [042/133] (725s left) i915_pm_rps (min-max-config-idle)
[292.694398] Starting subtest: min-max-config-idle
[292.698902] Subtest min-max-config-idle: SKIP (0.000s)
[292.766273] [043/133] (725s left) gem_exec_balancer (busy)
[292.828867] Starting subtest: busy
[294.300991] Subtest busy: SUCCESS (1.470s)
[294.641135] [044/133] (723s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[294.737642] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[294.742062] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[294.839116] [045/133] (723s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[294.949672] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[294.953791] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[295.058176] [046/133] (723s left) gem_mmap_gtt (big-bo-tiledy)
[295.115717] Subtest big-bo-tiledY: SKIP (0.000s)
[295.180041] [047/133] (723s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[295.280733] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[302.778373] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.499s)
[302.914710] [048/133] (715s left) kms_chamelium_edid (vga-edid-read)
[303.316266] Subtest vga-edid-read: SKIP (0.000s)
[304.115841] [049/133] (714s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[304.202890] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[311.162323] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.960s)
[311.343281] [050/133] (707s left) gem_create (hog-create)
[311.396853] Starting subtest: hog-create
[311.399131] Starting dynamic subtest: smem0
[345.320656] Dynamic subtest smem0: SUCCESS (33.918s)
[345.323286] Subtest hog-create: SUCCESS (33.920s)
[345.523786] [051/133] (673s left) kms_getfb (getfb-repeated-different-handles)
[345.621797] Starting subtest: getfb-repeated-different-handles
[345.624012] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[345.736818] [052/133] (672s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[345.841228] Starting subtest: y-tiled-64bpp-rotate-0
[345.845265] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[345.931700] [053/133] (672s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[346.033384] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[346.037742] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[346.126963] [054/133] (672s left) api_intel_bb (simple-bb)
[346.177794] Starting subtest: simple-bb
[346.180874] Subtest simple-bb: SUCCESS (0.005s)
[346.304422] [055/133] (672s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[346.403700] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[346.407973] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[346.478975] [056/133] (672s left) kms_flip (blocking-wf_vblank)
[346.572106] Starting subtest: blocking-wf_vblank
[346.573935] Starting dynamic subtest: A-eDP1
[355.506838] Dynamic subtest A-eDP1: SUCCESS (8.934s)
[355.517381] Starting dynamic subtest: B-eDP1
[364.458157] Dynamic subtest B-eDP1: SUCCESS (8.916s)
[364.469429] Starting dynamic subtest: C-eDP1
[373.387726] Dynamic subtest C-eDP1: SUCCESS (8.913s)
[373.399846] Starting dynamic subtest: D-eDP1
[382.324934] Dynamic subtest D-eDP1: SUCCESS (8.931s)
[382.327303] Subtest blocking-wf_vblank: SUCCESS (35.711s)
[383.502356] [057/133] (635s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[383.622970] Starting subtest: cursorA-vs-flipB-atomic-transitions
[383.627917] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[383.768620] [058/133] (635s left) gem_mmap_offset (bad-flags)
[383.825594] Starting subtest: bad-flags
[383.827596] Subtest bad-flags: SUCCESS (0.000s)
[383.928039] [059/133] (635s left) vgem_basic (create)
[384.067128] Starting subtest: create
[384.069511] Subtest create: SUCCESS (0.000s)
[384.125785] [FACT vgem_basic (create)] new: kernel.kmod_is_loaded.vgem: true
[384.128929] [060/133] (634s left) kms_atomic (plane-primary-legacy)
[384.216448] Starting subtest: plane-primary-legacy
[384.218726] Starting dynamic subtest: pipe-A-eDP-1
[384.666706] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.451s)
[384.669065] Subtest plane-primary-legacy: SUCCESS (0.453s)
[385.538731] [061/133] (633s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[385.656316] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[385.660982] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[385.749627] [062/133] (633s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[385.809080] Starting subtest: invalid-single-wait-unsubmitted
[385.811369] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[385.912768] [063/133] (633s left) kms_psr (psr-cursor-render)
[385.999437] Starting subtest: psr-cursor-render
[386.001728] Starting dynamic subtest: eDP-1
[387.739074] Dynamic subtest eDP-1: SUCCESS (1.740s)
[387.741525] Subtest psr-cursor-render: SUCCESS (1.741s)
[388.604879] [064/133] (630s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[388.697165] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[388.699458] Starting dynamic subtest: pipe-A-eDP-1
[388.722908] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[388.733248] Starting dynamic subtest: pipe-B-eDP-1
[388.755252] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[388.763607] Starting dynamic subtest: pipe-C-eDP-1
[388.785570] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[388.796540] Starting dynamic subtest: pipe-D-eDP-1
[388.818561] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[388.822990] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[390.971706] [065/133] (628s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[391.522402] Starting subtest: syncobj-timeline-invalid-flags
[391.524768] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[393.386906] [066/133] (625s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[393.489616] Starting subtest: stress-xrgb8888-ytiled
[393.493940] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[393.563307] [067/133] (625s left) gem_sync (basic-each)
[393.644915] Starting subtest: basic-each
[395.862501] Subtest basic-each: SUCCESS (2.228s)
[396.049688] [068/133] (623s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[396.184379] Starting subtest: x-tiled-8bpp-rotate-0
[397.409631] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.225s)
[397.519721] [069/133] (621s left) sw_sync (sync_expired_merge)
[397.560202] Starting subtest: sync_expired_merge
[398.635067] Subtest sync_expired_merge: SUCCESS (1.074s)
[398.694679] [070/133] (620s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[398.788635] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[403.501988] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.716s)
[404.694171] [071/133] (614s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[404.798226] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[404.802769] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[404.891229] [072/133] (614s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[404.997250] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[405.001212] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[405.112468] [073/133] (614s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[405.219167] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[405.221402] Starting dynamic subtest: pipe-A
[406.368401] Dynamic subtest pipe-A: SUCCESS (1.151s)
[406.377315] Starting dynamic subtest: pipe-B
[408.650277] Dynamic subtest pipe-B: SUCCESS (2.281s)
[408.659488] Starting dynamic subtest: pipe-C
[409.887647] Dynamic subtest pipe-C: SUCCESS (1.235s)
[409.897460] Starting dynamic subtest: pipe-D
[411.139583] Dynamic subtest pipe-D: SUCCESS (1.251s)
[411.142046] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.923s)
[412.316037] [074/133] (607s left) kms_cursor_edge_walk (64x64-top-bottom)
[412.413155] Starting subtest: 64x64-top-bottom
[412.415554] Starting dynamic subtest: pipe-A-eDP-1
[415.885297] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.472s)
[415.894878] Starting dynamic subtest: pipe-D-eDP-1
[419.011217] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[419.013486] Subtest 64x64-top-bottom: SUCCESS (6.600s)
[419.815883] [075/133] (599s left) kms_joiner (basic-ultra-joiner)
[419.909739] Starting subtest: basic-ultra-joiner
[419.914246] Subtest basic-ultra-joiner: SKIP (0.000s)
[419.991135] [076/133] (599s left) gen9_exec_parse (bb-start-param)
[420.050889] Subtest bb-start-param: SKIP (0.000s)
[420.121767] [077/133] (599s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[420.215043] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[427.091834] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.878s)
[427.241260] [078/133] (592s left) sw_sync (sync_multi_consumer)
[427.277914] Starting subtest: sync_multi_consumer
[427.697450] Subtest sync_multi_consumer: SUCCESS (0.422s)
[427.762654] [079/133] (592s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[427.828660] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[427.832982] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[428.020439] [080/133] (591s left) gem_exec_schedule (pi-common)
[428.195644] Starting subtest: pi-common
[428.197533] Starting dynamic subtest: rcs0
[428.223088] Dynamic subtest rcs0: SUCCESS (0.030s)
[428.236640] Starting dynamic subtest: bcs0
[428.252329] Dynamic subtest bcs0: SUCCESS (0.028s)
[428.265388] Starting dynamic subtest: vcs0
[428.280490] Dynamic subtest vcs0: SUCCESS (0.027s)
[428.294402] Starting dynamic subtest: vcs1
[428.306774] Dynamic subtest vcs1: SUCCESS (0.026s)
[428.318818] Starting dynamic subtest: vecs0
[428.334822] Dynamic subtest vecs0: SUCCESS (0.027s)
[428.348964] Starting dynamic subtest: ccs0
[428.360318] Dynamic subtest ccs0: SUCCESS (0.025s)
[428.362598] Subtest pi-common: SUCCESS (0.168s)
[428.601719] [081/133] (591s left) gem_exec_whisper (basic-contexts-all)
[428.665512] Starting subtest: basic-contexts-all
[440.021703] Subtest basic-contexts-all: SUCCESS (11.351s)
[440.205549] [082/133] (579s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[440.309047] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[440.311278] Starting dynamic subtest: pipe-A-eDP-1
[440.331526] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[440.342953] Starting dynamic subtest: pipe-B-eDP-1
[440.362670] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.023s)
[440.372326] Starting dynamic subtest: pipe-C-eDP-1
[440.391978] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[440.401409] Starting dynamic subtest: pipe-D-eDP-1
[440.421634] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[440.423968] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.094s)
[442.596082] [083/133] (577s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[442.708675] Starting subtest: psr-rgb101010-draw-blt
[450.014365] Subtest psr-rgb101010-draw-blt: SUCCESS (7.308s)
[450.119859] [084/133] (569s left) core_setmaster (master-drop-set-shared-fd)
[450.211129] Starting subtest: master-drop-set-shared-fd
[450.221817] Subtest master-drop-set-shared-fd: SUCCESS (0.011s)
[450.264724] [085/133] (569s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[450.365632] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[457.110924] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.748s)
[457.250413] [086/133] (562s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[457.351506] Starting subtest: psr-rgb565-draw-render
[464.391427] Subtest psr-rgb565-draw-render: SUCCESS (7.042s)
[464.510438] [087/133] (555s left) kms_sequence (get-forked-busy)
[464.602314] Starting subtest: get-forked-busy
[464.604631] Starting dynamic subtest: pipe-A-eDP-1
[466.540640] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.937s)
[466.557073] Starting dynamic subtest: pipe-B-eDP-1
[469.102095] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.559s)
[469.112959] Starting dynamic subtest: pipe-C-eDP-1
[471.710629] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.610s)
[471.721340] Starting dynamic subtest: pipe-D-eDP-1
[474.266777] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.554s)
[474.269779] Subtest get-forked-busy: SUCCESS (9.666s)
[475.150437] [088/133] (545s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[475.257256] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[475.261549] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[475.357334] [089/133] (544s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[475.410798] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[475.413094] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[475.509527] [090/133] (544s left) syncobj_wait (single-wait-for-submit-signaled)
[475.578362] Starting subtest: single-wait-for-submit-signaled
[475.580758] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[475.681110] [091/133] (544s left) kms_dsc (dsc-fractional-bpp)
[475.774118] Starting subtest: dsc-fractional-bpp
[475.786903] Subtest dsc-fractional-bpp: SKIP (0.000s)
[475.847102] [092/133] (544s left) syncobj_wait (wait-all-snapshot)
[475.906416] Starting subtest: wait-all-snapshot
[475.987802] Subtest wait-all-snapshot: SUCCESS (0.082s)
[476.064722] [093/133] (544s left) kms_content_protection (legacy-hdcp14)
[476.199161] Starting subtest: legacy-hdcp14
[476.202927] Subtest legacy-hdcp14: SKIP (0.000s)
[476.325213] [094/133] (544s left) gem_exec_balancer (waits)
[476.386677] Starting subtest: waits
[482.990357] Subtest waits: SUCCESS (6.551s)
[483.234694] [095/133] (537s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[483.332077] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[483.334434] Starting dynamic subtest: pipe-A-eDP-1
[483.343519] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[483.358044] Starting dynamic subtest: pipe-B-eDP-1
[483.366485] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[483.378564] Starting dynamic subtest: pipe-C-eDP-1
[483.387250] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[483.395836] Starting dynamic subtest: pipe-D-eDP-1
[483.404358] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[483.408415] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[485.607294] [096/133] (534s left) i915_hangman (engine-error-state-capture)
[485.664768] Starting subtest: engine-error-state-capture
[485.666928] Starting dynamic subtest: rcs0
[489.281634] Dynamic subtest rcs0: SUCCESS (3.615s)
[489.294695] Starting dynamic subtest: bcs0
[495.296737] Dynamic subtest bcs0: SUCCESS (6.012s)
[495.309764] Starting dynamic subtest: vcs0
[501.311531] Dynamic subtest vcs0: SUCCESS (6.011s)
[501.323781] Starting dynamic subtest: vcs1
[507.264214] Dynamic subtest vcs1: SUCCESS (5.949s)
[507.276797] Starting dynamic subtest: vecs0
[513.281533] Dynamic subtest vecs0: SUCCESS (6.013s)
[513.294086] Starting dynamic subtest: ccs0
[519.296995] Dynamic subtest ccs0: SUCCESS (6.013s)
[519.300023] Subtest engine-error-state-capture: SUCCESS (33.630s)
[519.379683] [097/133] (501s left) perf_pmu (rc6-suspend)
[519.419341] Starting subtest: rc6-suspend
[542.243739] Subtest rc6-suspend: SUCCESS (8.932s)
[548.156752] [098/133] (477s left) gem_exec_parallel (basic)
[548.244922] Starting subtest: basic
[548.247464] Starting dynamic subtest: rcs0
[549.917959] Dynamic subtest rcs0: SUCCESS (1.611s)
[549.929837] Starting dynamic subtest: bcs0
[551.428684] Dynamic subtest bcs0: SUCCESS (1.463s)
[551.450462] Starting dynamic subtest: vcs0
[553.199382] Dynamic subtest vcs0: SUCCESS (1.724s)
[553.212503] Starting dynamic subtest: vcs1
[555.235717] Dynamic subtest vcs1: SUCCESS (1.995s)
[555.249098] Starting dynamic subtest: vecs0
[557.220552] Dynamic subtest vecs0: SUCCESS (1.953s)
[557.232905] Starting dynamic subtest: ccs0
[558.738154] Dynamic subtest ccs0: SUCCESS (1.499s)
[558.740663] Subtest basic: SUCCESS (10.261s)
[558.936542] [099/133] (466s left) kms_psr (psr-primary-blt)
[559.030621] Starting subtest: psr-primary-blt
[559.033154] Starting dynamic subtest: eDP-1
[560.790548] Dynamic subtest eDP-1: SUCCESS (1.744s)
[560.792838] Subtest psr-primary-blt: SUCCESS (1.745s)
[561.670067] [100/133] (464s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[561.726472] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[561.805587] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.025s)
[561.845736] [101/133] (463s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[561.952616] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[565.562655] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.596s)
[566.701713] [102/133] (459s left) kms_prop_blob (blob-prop-lifetime)
[566.754092] Starting subtest: blob-prop-lifetime
[566.756368] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[566.869321] [103/133] (459s left) gem_userptr_blits (readonly-unsync)
[566.933950] Subtest readonly-unsync: SKIP (0.000s)
[567.061640] [104/133] (458s left) perf (polling)
[567.147644] Starting subtest: polling
[567.150086] Starting dynamic subtest: 0-rcs0
[577.178218] Dynamic subtest 0-rcs0: SUCCESS (10.009s)
[577.189518] Starting dynamic subtest: 1-vecs0
[587.260201] Dynamic subtest 1-vecs0: SUCCESS (10.020s)
[587.262437] Subtest polling: SUCCESS (20.032s)
[587.304377] [105/133] (438s left) i915_query (query-topology-kernel-writes)
[587.360008] Starting subtest: query-topology-kernel-writes
[587.362158] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[587.469157] [106/133] (438s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[587.566792] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[588.612422] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.047s)
[588.727542] [107/133] (437s left) kms_psr (fbc-pr-sprite-blt)
[588.823167] Starting subtest: fbc-pr-sprite-blt
[588.826934] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[588.912025] [108/133] (437s left) prime_self_import (basic-with_two_bos)
[588.944316] Starting subtest: basic-with_two_bos
[588.959746] Subtest basic-with_two_bos: SUCCESS (0.017s)
[589.054832] [109/133] (437s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[589.146741] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[590.215316] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.067s)
[590.349920] [110/133] (435s left) gem_exec_reloc (basic-cpu-read)
[590.414028] Subtest basic-cpu-read: SKIP (0.000s)
[590.485488] [111/133] (435s left) gem_ctx_shared (exec-shared-gtt)
[590.551780] Starting subtest: exec-shared-gtt
[590.553713] Starting dynamic subtest: rcs0
[590.559155] Dynamic subtest rcs0: SUCCESS (0.007s)
[590.569765] Starting dynamic subtest: bcs0
[590.571551] Dynamic subtest bcs0: SUCCESS (0.006s)
[590.581943] Starting dynamic subtest: vcs0
[590.583907] Dynamic subtest vcs0: SUCCESS (0.007s)
[590.593942] Starting dynamic subtest: vcs1
[590.595498] Dynamic subtest vcs1: SUCCESS (0.007s)
[590.605384] Starting dynamic subtest: vecs0
[590.607239] Dynamic subtest vecs0: SUCCESS (0.008s)
[590.616572] Starting dynamic subtest: ccs0
[590.618453] Dynamic subtest ccs0: SUCCESS (0.007s)
[590.620246] Subtest exec-shared-gtt: SUCCESS (0.045s)
[590.784517] [112/133] (435s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[590.867110] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[590.868936] Starting dynamic subtest: pipe-A
[590.886160] Dynamic subtest pipe-A: SKIP (0.017s)
[590.896350] Starting dynamic subtest: pipe-B
[590.918643] Dynamic subtest pipe-B: SKIP (0.031s)
[590.929180] Starting dynamic subtest: pipe-C
[590.948916] Dynamic subtest pipe-C: SKIP (0.031s)
[590.959269] Starting dynamic subtest: pipe-D
[590.981264] Dynamic subtest pipe-D: SKIP (0.031s)
[590.984357] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.112s)
[591.090064] [113/133] (435s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[591.188072] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[598.554001] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.363s)
[598.679731] [114/133] (427s left) kms_getfb (getfb-handle-protection)
[598.767833] Starting subtest: getfb-handle-protection
[598.789727] Subtest getfb-handle-protection: SUCCESS (0.023s)
[598.901946] [115/133] (427s left) gem_ctx_persistence (process)
[598.960651] Starting subtest: process
[599.151467] Subtest process: SUCCESS (0.193s)
[599.232692] [116/133] (427s left) i915_selftest (mock)
[601.017223] Starting subtest: mock
[601.020414] Starting dynamic subtest: sanitycheck
[601.750758] Dynamic subtest sanitycheck: SUCCESS (0.733s)
[601.759360] Starting dynamic subtest: shmem
[602.429874] Dynamic subtest shmem: SUCCESS (0.676s)
[602.440667] Starting dynamic subtest: fence
[610.311768] Dynamic subtest fence: SUCCESS (7.875s)
[610.322366] Starting dynamic subtest: scatterlist
[611.986876] Dynamic subtest scatterlist: SUCCESS (1.672s)
[611.997875] Starting dynamic subtest: syncmap
[615.180287] Dynamic subtest syncmap: SUCCESS (3.190s)
[615.191261] Starting dynamic subtest: uncore
[615.847754] Dynamic subtest uncore: SUCCESS (0.665s)
[615.858577] Starting dynamic subtest: ring
[616.525857] Dynamic subtest ring: SUCCESS (0.676s)
[616.543416] Starting dynamic subtest: engine
[617.225934] Dynamic subtest engine: SUCCESS (0.697s)
[617.236745] Starting dynamic subtest: timelines
[621.119159] Dynamic subtest timelines: SUCCESS (3.888s)
[621.129775] Starting dynamic subtest: requests
[624.522401] Dynamic subtest requests: SUCCESS (3.399s)
[624.532758] Starting dynamic subtest: objects
[625.260725] Dynamic subtest objects: SUCCESS (0.737s)
[625.271631] Starting dynamic subtest: phys
[626.026949] Dynamic subtest phys: SUCCESS (0.764s)
[626.037489] Starting dynamic subtest: dmabuf
[626.807866] Dynamic subtest dmabuf: SUCCESS (0.780s)
[626.818530] Starting dynamic subtest: vma
[632.589039] Dynamic subtest vma: SUCCESS (5.776s)
[632.597382] Starting dynamic subtest: evict
[633.991449] Dynamic subtest evict: SUCCESS (1.400s)
[634.008405] Starting dynamic subtest: gtt
[637.284638] Dynamic subtest gtt: SUCCESS (3.292s)
[637.294287] Starting dynamic subtest: hugepages
[638.151946] Dynamic subtest hugepages: SUCCESS (0.867s)
[638.160658] Starting dynamic subtest: memory_region
[640.606454] Dynamic subtest memory_region: SUCCESS (2.453s)
[640.609195] Subtest mock: SUCCESS (39.575s)
[640.638781] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[640.639464] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[640.642967] [117/133] (385s left) kms_pm_rpm (legacy-planes-dpms)
[644.376723] Starting subtest: legacy-planes-dpms
[644.379451] Starting dynamic subtest: plane-65
[652.959180] Dynamic subtest plane-65: SUCCESS (8.590s)
[652.971286] Starting dynamic subtest: plane-95
[661.262195] Dynamic subtest plane-95: SUCCESS (8.302s)
[661.275724] Starting dynamic subtest: plane-125
[669.667246] Dynamic subtest plane-125: SUCCESS (8.404s)
[669.679462] Starting dynamic subtest: plane-135
[677.975552] Dynamic subtest plane-135: SUCCESS (8.305s)
[677.978656] Subtest legacy-planes-dpms: SUCCESS (33.611s)
[678.374416] [FACT kms_pm_rpm (legacy-planes-dpms)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[678.375739] [FACT kms_pm_rpm (legacy-planes-dpms)] new: kernel.kmod_is_loaded.i915: true
[678.379801] [118/133] (348s left) kms_cursor_crc (cursor-random-32x10)
[678.559925] Starting subtest: cursor-random-32x10
[678.610823] Subtest cursor-random-32x10: SKIP (0.046s)
[678.861616] [119/133] (347s left) kms_cursor_crc (cursor-offscreen-32x32)
[678.999203] Starting subtest: cursor-offscreen-32x32
[679.049056] Subtest cursor-offscreen-32x32: SKIP (0.046s)
[679.317759] [120/133] (347s left) syncobj_wait (single-wait-all-for-submit-submitted)
[679.371454] Starting subtest: single-wait-all-for-submit-submitted
[679.481141] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.109s)
[679.563633] [121/133] (347s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[679.610113] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[679.670932] [122/133] (347s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[679.721827] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[679.724099] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[679.806180] [123/133] (346s left) kms_chamelium_hpd (hdmi-hpd)
[680.177271] Subtest hdmi-hpd: SKIP (0.000s)
[680.954391] [124/133] (345s left) gem_exec_reloc (basic-gtt-noreloc)
[681.013906] Subtest basic-gtt-noreloc: SKIP (0.000s)
[681.082600] [125/133] (345s left) kms_flip (2x-wf_vblank-ts-check)
[681.172798] Starting subtest: 2x-wf_vblank-ts-check
[681.182100] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s)
[681.264146] [126/133] (345s left) kms_psr (pr-primary-mmap-cpu)
[681.354726] Starting subtest: pr-primary-mmap-cpu
[681.359064] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[681.443157] [127/133] (345s left) gem_readwrite (read-write)
[681.498117] Subtest read-write: SKIP (0.000s)
[681.556073] [128/133] (345s left) fbdev (write)
[681.608865] Starting subtest: write
[681.971026] Subtest write: SUCCESS (0.360s)
[682.048633] [129/133] (344s left) kms_dp_aux_dev (basic)
[682.099489] Starting subtest: basic
[682.326143] Subtest basic: SUCCESS (0.225s)
[682.399372] [130/133] (344s left) kms_psr (fbc-psr2-sprite-render)
[682.490635] Starting subtest: fbc-psr2-sprite-render
[682.492913] Starting dynamic subtest: eDP-1
[682.497108] Dynamic subtest eDP-1: SKIP (0.000s)
[682.501225] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[682.566095] [131/133] (344s left) gem_ctx_persistence (engines-cleanup)
[682.624282] Starting subtest: engines-cleanup
[682.626576] Starting dynamic subtest: rcs0
[682.683215] Dynamic subtest rcs0: SUCCESS (0.059s)
[682.694767] Starting dynamic subtest: bcs0
[682.730539] Dynamic subtest bcs0: SUCCESS (0.045s)
[682.747162] Starting dynamic subtest: vcs0
[682.769344] Dynamic subtest vcs0: SUCCESS (0.036s)
[682.780553] Starting dynamic subtest: vcs1
[682.818446] Dynamic subtest vcs1: SUCCESS (0.047s)
[682.829425] Starting dynamic subtest: vecs0
[682.857249] Dynamic subtest vecs0: SUCCESS (0.037s)
[682.866948] Starting dynamic subtest: ccs0
[682.893120] Dynamic subtest ccs0: SUCCESS (0.034s)
[682.895438] Subtest engines-cleanup: SUCCESS (0.270s)
[682.985753] [132/133] (344s left) sysfs_heartbeat_interval (idempotent)
[683.054415] Starting subtest: idempotent
[683.056934] Starting dynamic subtest: vecs0
[683.059332] Dynamic subtest vecs0: SUCCESS (0.001s)
[683.071678] Starting dynamic subtest: ccs0
[683.074161] Dynamic subtest ccs0: SUCCESS (0.001s)
[683.083654] Starting dynamic subtest: vcs0
[683.085541] Dynamic subtest vcs0: SUCCESS (0.001s)
[683.104829] Starting dynamic subtest: bcs0
[683.107285] Dynamic subtest bcs0: SUCCESS (0.001s)
[683.126143] Starting dynamic subtest: rcs0
[683.128776] Dynamic subtest rcs0: SUCCESS (0.000s)
[683.143150] Starting dynamic subtest: vcs1
[683.145449] Dynamic subtest vcs1: SUCCESS (0.000s)
[683.147713] Subtest idempotent: SUCCESS (0.008s)
[683.186723] [133/133] (344s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[683.284876] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[690.373311] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.090s)
[690.484514] Closing watchdogs
results: parsing output: 0/ for test: gem_pxp
results: parsing output: 1/ for test: kms_pm_rpm
results: parsing output: 2/ for test: gem_wait
results: parsing output: 3/ for test: gem_exec_gttfill
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: perf
results: parsing output: 7/ for test: gem_softpin
results: parsing output: 8/ for test: kms_plane
results: parsing output: 9/ for test: gem_mmap_gtt
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_ctx_bad_destroy
results: parsing output: 13/ for test: kms_plane
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_flip_scaled_crc
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: i915_drm_fdinfo
results: parsing output: 18/ for test: gem_exec_reloc
results: parsing output: 19/ for test: kms_lease
results: parsing output: 20/ for test: gem_pxp
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: gem_mmap_gtt
results: parsing output: 23/ for test: kms_addfb_basic
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: syncobj_eventfd
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: kms_flip_scaled_crc
results: parsing output: 29/ for test: gem_exec_whisper
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: kms_addfb_basic
results: parsing output: 34/ for test: kms_color_pipeline
results: parsing output: 35/ for test: api_intel_allocator
results: parsing output: 36/ for test: prime_self_import
results: parsing output: 37/ for test: kms_vblank
results: parsing output: 38/ for test: gem_exec_flush
results: parsing output: 39/ for test: perf
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: i915_pm_rps
results: parsing output: 42/ for test: gem_exec_balancer
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_mmap_gtt
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_chamelium_edid
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_create
results: parsing output: 50/ for test: kms_getfb
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: api_intel_bb
results: parsing output: 54/ for test: kms_psr2_sf
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: kms_cursor_legacy
results: parsing output: 57/ for test: gem_mmap_offset
results: parsing output: 58/ for test: vgem_basic
results: parsing output: 59/ for test: kms_atomic
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: gem_exec_fence
results: parsing output: 65/ for test: kms_pipe_stress
results: parsing output: 66/ for test: gem_sync
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: sw_sync
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_plane_scaling
results: parsing output: 73/ for test: kms_cursor_edge_walk
results: parsing output: 74/ for test: kms_joiner
results: parsing output: 75/ for test: gen9_exec_parse
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: sw_sync
results: parsing output: 78/ for test: gem_render_copy
results: parsing output: 79/ for test: gem_exec_schedule
results: parsing output: 80/ for test: gem_exec_whisper
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: core_setmaster
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_sequence
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: syncobj_wait
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: kms_dsc
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: kms_content_protection
results: parsing output: 93/ for test: gem_exec_balancer
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: i915_hangman
results: parsing output: 96/ for test: perf_pmu
results: parsing output: 97/ for test: gem_exec_parallel
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: sriov_basic
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_prop_blob
results: parsing output: 102/ for test: gem_userptr_blits
results: parsing output: 103/ for test: perf
results: parsing output: 104/ for test: i915_query
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: prime_self_import
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: gem_exec_reloc
results: parsing output: 110/ for test: gem_ctx_shared
results: parsing output: 111/ for test: kms_plane_scaling
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_getfb
results: parsing output: 114/ for test: gem_ctx_persistence
results: parsing output: 115/ for test: i915_selftest
results: parsing output: 116/ for test: kms_pm_rpm
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: kms_cursor_crc
results: parsing output: 119/ for test: syncobj_wait
results: parsing output: 120/ for test: gem_mmap_gtt
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_chamelium_hpd
results: parsing output: 123/ for test: gem_exec_reloc
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: gem_readwrite
results: parsing output: 127/ for test: fbdev
results: parsing output: 128/ for test: kms_dp_aux_dev
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: gem_ctx_persistence
results: parsing output: 131/ for test: sysfs_heartbeat_interval
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.