[57.008974] Initializing watchdogs
[57.009031]   /dev/watchdog0
[57.023051] [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]
[57.027429] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.029727] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.032895] [001/133] (960s left) gem_pxp (create-regular-buffer)
[57.194869] Starting subtest: create-regular-buffer
[57.197254] Subtest create-regular-buffer: SUCCESS (0.000s)
[57.295468] [002/133] (960s left) kms_pm_rpm (basic-pci-d3-state)
[59.445832] Starting subtest: basic-pci-d3-state
[60.925459] Subtest basic-pci-d3-state: SUCCESS (1.491s)
[61.021536] [003/133] (956s left) gem_wait (wait)
[61.077092] Starting subtest: wait
[61.079585] Starting dynamic subtest: all-engines
[62.277897] Dynamic subtest all-engines: SUCCESS (1.207s)
[62.288237] Starting dynamic subtest: rcs0
[63.321599] Dynamic subtest rcs0: SUCCESS (1.050s)
[63.329713] Starting dynamic subtest: bcs0
[64.368165] Dynamic subtest bcs0: SUCCESS (1.051s)
[64.378152] Starting dynamic subtest: vcs0
[65.412799] Dynamic subtest vcs0: SUCCESS (1.048s)
[65.423596] Starting dynamic subtest: vcs1
[66.457678] Dynamic subtest vcs1: SUCCESS (1.048s)
[66.466941] Starting dynamic subtest: vecs0
[67.502424] Dynamic subtest vecs0: SUCCESS (1.048s)
[67.512762] Starting dynamic subtest: ccs0
[68.551067] Dynamic subtest ccs0: SUCCESS (1.050s)
[68.553749] Subtest wait: SUCCESS (7.508s)
[68.756857] [004/133] (948s left) gem_exec_gttfill (engines)
[68.827922] Starting subtest: engines
[68.830043] Starting dynamic subtest: rcs0
[92.263911] Dynamic subtest rcs0: SUCCESS (23.453s)
[92.273883] Starting dynamic subtest: bcs0
[115.498365] Dynamic subtest bcs0: SUCCESS (23.234s)
[115.507162] Starting dynamic subtest: vcs0
[138.793376] Dynamic subtest vcs0: SUCCESS (23.293s)
[138.801924] Starting dynamic subtest: vcs1
[162.050801] Dynamic subtest vcs1: SUCCESS (23.254s)
[162.061600] Starting dynamic subtest: vecs0
[185.336703] Dynamic subtest vecs0: SUCCESS (23.282s)
[185.347214] Starting dynamic subtest: ccs0
[208.570697] Dynamic subtest ccs0: SUCCESS (23.233s)
[208.573505] Subtest engines: SUCCESS (139.757s)
[208.759411] [005/133] (808s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[208.898084] Starting subtest: fbcpsr-2p-rte
[208.902432] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[208.998973] [006/133] (808s left) kms_psr (fbc-pr-no-drrs)
[209.110192] Starting subtest: fbc-pr-no-drrs
[209.114406] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[209.179981] [007/133] (808s left) perf (gen12-group-concurrent-oa-buffer-read)
[209.320940] Starting subtest: gen12-group-concurrent-oa-buffer-read
[219.344876] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.023s)
[219.387808] [008/133] (798s left) gem_softpin (full)
[219.445185] Starting subtest: full
[219.455300] Subtest full: SUCCESS (0.010s)
[219.576717] [009/133] (798s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[219.670698] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[219.674740] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[219.742477] [010/133] (798s left) gem_mmap_gtt (basic-read)
[219.801974] Subtest basic-read: SKIP (0.000s)
[219.855866] [011/133] (798s left) kms_big_fb (linear-32bpp-rotate-180)
[219.953918] Starting subtest: linear-32bpp-rotate-180
[221.533158] Subtest linear-32bpp-rotate-180: SUCCESS (1.579s)
[221.655590] [012/133] (796s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[221.749812] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[221.753258] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[221.836385] [013/133] (796s left) gem_ctx_bad_destroy (invalid-ctx)
[221.890358] Starting subtest: invalid-ctx
[221.892389] Subtest invalid-ctx: SUCCESS (0.000s)
[221.957871] [014/133] (796s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[222.054287] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[222.080341] Starting dynamic subtest: pipe-A-plane-0
[222.381956] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[222.389996] Starting dynamic subtest: pipe-A-plane-3
[222.613728] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[222.621695] Starting dynamic subtest: pipe-A-plane-5
[222.625132] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[223.691066] Starting dynamic subtest: pipe-B-plane-0
[223.983576] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[223.994458] Starting dynamic subtest: pipe-B-plane-3
[224.219624] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[224.229788] Starting dynamic subtest: pipe-B-plane-5
[224.234821] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[224.526810] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.471s)
[225.371550] [015/133] (792s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[225.432830] Starting subtest: single-wait-for-submit-available-signaled
[225.435100] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[225.527260] [016/133] (792s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[225.611272] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[225.613477] Starting dynamic subtest: pipe-A-default-mode
[226.738203] Dynamic subtest pipe-A-default-mode: SKIP (1.124s)
[226.742885] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.125s)
[226.875588] [017/133] (791s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[226.926755] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[226.928787] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[227.011643] [018/133] (791s left) i915_drm_fdinfo (virtual-busy-all)
[227.055306] Starting subtest: virtual-busy-all
[227.059694] Subtest virtual-busy-all: SKIP (0.000s)
[227.124603] [019/133] (791s left) gem_exec_reloc (basic-gtt-read-noreloc)
[227.191761] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[227.266810] [020/133] (790s left) kms_lease (lease-invalid-connector)
[227.355443] Starting subtest: lease-invalid-connector
[227.357959] Starting dynamic subtest: pipe-A-eDP-1
[227.360721] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[227.371034] Starting dynamic subtest: pipe-B-eDP-1
[227.372955] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[227.383172] Starting dynamic subtest: pipe-C-eDP-1
[227.385357] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[227.393288] Starting dynamic subtest: pipe-D-eDP-1
[227.395485] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[227.397726] Subtest lease-invalid-connector: SUCCESS (0.002s)
[227.431239] [021/133] (790s left) gem_pxp (reject-modify-context-protection-off-3)
[227.533394] Starting subtest: reject-modify-context-protection-off-3
[227.535717] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[227.634557] [022/133] (790s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[227.719163] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[227.721169] Starting dynamic subtest: pipe-A-eDP-1
[227.770798] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[227.778114] Starting dynamic subtest: pipe-B-eDP-1
[227.824745] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[227.833156] Starting dynamic subtest: pipe-C-eDP-1
[227.880693] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[227.889293] Starting dynamic subtest: pipe-D-eDP-1
[227.937481] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[227.941093] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[229.960099] [023/133] (788s left) gem_mmap_gtt (fault-concurrent)
[230.010929] Subtest fault-concurrent: SKIP (0.000s)
[230.065787] [024/133] (788s left) kms_addfb_basic (addfb25-4-tiled)
[230.168731] Starting subtest: addfb25-4-tiled
[230.170801] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[230.263961] [025/133] (788s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[230.366949] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[230.369279] Starting dynamic subtest: A-eDP1
[233.991794] Dynamic subtest A-eDP1: SUCCESS (3.623s)
[234.001582] Starting dynamic subtest: B-eDP1
[237.186657] Dynamic subtest B-eDP1: SUCCESS (3.192s)
[237.201548] Starting dynamic subtest: C-eDP1
[240.288406] Dynamic subtest C-eDP1: SUCCESS (3.102s)
[240.298465] Starting dynamic subtest: D-eDP1
[243.393906] Dynamic subtest D-eDP1: SUCCESS (3.105s)
[243.396116] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.029s)
[244.184899] [026/133] (774s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[244.308617] Starting subtest: flip-vs-cursor-busy-crc-legacy
[245.109860] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.800s)
[245.931721] [027/133] (772s left) syncobj_eventfd (timeline-wait-signaled)
[245.990120] Starting subtest: timeline-wait-signaled
[245.992555] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[246.107367] [028/133] (772s left) gem_exec_schedule (u-fairslice)
[246.179080] Starting subtest: u-fairslice
[246.181367] Starting dynamic subtest: rcs0
[248.192757] Dynamic subtest rcs0: SUCCESS (2.021s)
[248.202913] Starting dynamic subtest: bcs0
[250.212460] Dynamic subtest bcs0: SUCCESS (2.020s)
[250.222728] Starting dynamic subtest: vcs0
[252.229406] Dynamic subtest vcs0: SUCCESS (2.017s)
[252.239747] Starting dynamic subtest: vcs1
[254.250311] Dynamic subtest vcs1: SUCCESS (2.020s)
[254.260696] Starting dynamic subtest: vecs0
[256.278653] Dynamic subtest vecs0: SUCCESS (2.026s)
[256.289064] Starting dynamic subtest: ccs0
[258.301915] Dynamic subtest ccs0: SUCCESS (2.024s)
[258.304350] Subtest u-fairslice: SUCCESS (12.131s)
[258.602838] [029/133] (759s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[258.702839] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[258.705250] Starting dynamic subtest: pipe-A-default-mode
[261.451239] Dynamic subtest pipe-A-default-mode: SUCCESS (2.746s)
[261.453167] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.747s)
[262.300507] [030/133] (756s left) gem_exec_whisper (basic-sync-all)
[262.368983] Starting subtest: basic-sync-all
[269.080058] Subtest basic-sync-all: SUCCESS (6.711s)
[269.266450] [031/133] (749s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[269.326071] Starting subtest: etime-multi-wait-available-unsubmitted
[269.434128] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.107s)
[269.508941] [032/133] (749s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[269.615710] Starting subtest: random-ccs-data-y-tiled-ccs
[269.617909] Starting dynamic subtest: pipe-A-eDP-1
[269.641475] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[269.652254] Starting dynamic subtest: pipe-B-eDP-1
[269.675060] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[269.682999] Starting dynamic subtest: pipe-C-eDP-1
[269.706590] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[269.714856] Starting dynamic subtest: pipe-D-eDP-1
[269.738879] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[269.742956] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.003s)
[271.782912] [033/133] (746s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[271.884331] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[271.886593] Starting dynamic subtest: pipe-A-eDP-1
[271.906576] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[271.917669] Starting dynamic subtest: pipe-B-eDP-1
[271.936927] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[271.945064] Starting dynamic subtest: pipe-C-eDP-1
[271.963364] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[271.972075] Starting dynamic subtest: pipe-D-eDP-1
[271.991407] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[271.993292] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.010s)
[274.141934] [034/133] (744s left) kms_addfb_basic (basic)
[274.206640] Starting subtest: basic
[274.208640] Subtest basic: SUCCESS (0.000s)
[274.347962] [035/133] (744s left) kms_color_pipeline (plane-lut1d-lut1d)
[274.456943] Starting subtest: plane-lut1d-lut1d
[274.579897] Starting dynamic subtest: pipe-A-plane-0
[274.757526] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s)
[274.770809] Starting dynamic subtest: pipe-A-plane-1
[274.901933] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[274.911268] Starting dynamic subtest: pipe-A-plane-2
[275.035167] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[276.285278] Starting dynamic subtest: pipe-B-plane-0
[276.455927] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[276.465516] Starting dynamic subtest: pipe-B-plane-1
[276.588675] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[276.602231] Starting dynamic subtest: pipe-B-plane-2
[276.777235] Dynamic subtest pipe-B-plane-2: SUCCESS (0.187s)
[277.969208] Starting dynamic subtest: pipe-C-plane-0
[278.095042] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[278.107381] Starting dynamic subtest: pipe-C-plane-1
[278.239536] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[278.248094] Starting dynamic subtest: pipe-C-plane-2
[278.373028] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s)
[279.589229] Starting dynamic subtest: pipe-D-plane-0
[279.715300] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[279.724773] Starting dynamic subtest: pipe-D-plane-1
[279.859565] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[279.868875] Starting dynamic subtest: pipe-D-plane-2
[279.992958] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[280.280076] Subtest plane-lut1d-lut1d: SUCCESS (5.823s)
[281.070412] [036/133] (737s left) api_intel_allocator (standalone)
[281.125472] Starting subtest: standalone
[281.139532] Subtest standalone: SUCCESS (0.017s)
[281.285248] [037/133] (737s left) prime_self_import (basic-llseek-bad)
[281.322194] Starting subtest: basic-llseek-bad
[281.336831] Subtest basic-llseek-bad: SUCCESS (0.018s)
[281.439706] [038/133] (737s left) kms_vblank (query-forked)
[281.541256] Starting subtest: query-forked
[281.543533] Starting dynamic subtest: pipe-A-eDP-1
[283.367996] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.823s)
[283.382790] Starting dynamic subtest: pipe-D-eDP-1
[285.875796] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.507s)
[285.878075] Subtest query-forked: SUCCESS (4.333s)
[286.743862] [039/133] (732s left) gem_exec_flush (basic-uc-ro-default)
[286.817224] Starting subtest: basic-uc-ro-default
[292.269409] Subtest basic-uc-ro-default: SUCCESS (5.453s)
[292.454951] [040/133] (726s left) perf (per-context-mode-unprivileged)
[292.559380] Starting subtest: per-context-mode-unprivileged
[292.564093] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[292.599846] [041/133] (726s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[292.706276] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[292.710565] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[292.810621] [042/133] (726s left) i915_pm_rps (min-max-config-idle)
[292.871902] Starting subtest: min-max-config-idle
[292.876603] Subtest min-max-config-idle: SKIP (0.001s)
[292.970258] [043/133] (726s left) gem_exec_balancer (busy)
[293.034613] Starting subtest: busy
[294.255136] Subtest busy: SUCCESS (1.219s)
[294.571548] [044/133] (724s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[294.666258] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[294.670827] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[294.747896] [045/133] (724s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[294.843127] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[294.847187] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[294.930328] [046/133] (724s left) gem_mmap_gtt (big-bo-tiledy)
[294.984594] Subtest big-bo-tiledY: SKIP (0.000s)
[295.048407] [047/133] (724s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[295.136040] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[302.503717] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.370s)
[302.633825] [048/133] (716s left) kms_chamelium_edid (vga-edid-read)
[303.012209] Subtest vga-edid-read: SKIP (0.000s)
[303.858187] [049/133] (715s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[303.951648] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[310.792753] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.842s)
[310.952315] [050/133] (708s left) gem_create (hog-create)
[311.010605] Starting subtest: hog-create
[311.013017] Starting dynamic subtest: smem0
[344.333683] Dynamic subtest smem0: SUCCESS (33.320s)
[344.336772] Subtest hog-create: SUCCESS (33.321s)
[344.536372] [051/133] (674s left) kms_getfb (getfb-repeated-different-handles)
[344.628318] Starting subtest: getfb-repeated-different-handles
[344.630632] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[344.715716] [052/133] (674s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[344.825373] Starting subtest: y-tiled-64bpp-rotate-0
[344.829741] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[344.905830] [053/133] (674s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[344.998493] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[345.002527] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[345.108910] [054/133] (674s left) api_intel_bb (simple-bb)
[345.170226] Starting subtest: simple-bb
[345.175286] Subtest simple-bb: SUCCESS (0.008s)
[345.289184] [055/133] (674s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[345.383412] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[345.387699] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[345.449502] [056/133] (674s left) kms_flip (blocking-wf_vblank)
[345.534552] Starting subtest: blocking-wf_vblank
[345.536431] Starting dynamic subtest: A-eDP1
[354.440529] Dynamic subtest A-eDP1: SUCCESS (8.906s)
[354.450943] Starting dynamic subtest: B-eDP1
[363.371790] Dynamic subtest B-eDP1: SUCCESS (8.930s)
[363.381060] Starting dynamic subtest: C-eDP1
[372.284887] Dynamic subtest C-eDP1: SUCCESS (8.911s)
[372.296853] Starting dynamic subtest: D-eDP1
[381.210037] Dynamic subtest D-eDP1: SUCCESS (8.921s)
[381.214926] Subtest blocking-wf_vblank: SUCCESS (35.681s)
[382.438602] [057/133] (637s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[382.568461] Starting subtest: cursorA-vs-flipB-atomic-transitions
[382.573190] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[382.713062] [058/133] (636s left) gem_mmap_offset (bad-flags)
[382.768379] Starting subtest: bad-flags
[382.770334] Subtest bad-flags: SUCCESS (0.000s)
[382.882021] [059/133] (636s left) vgem_basic (create)
[382.990782] Starting subtest: create
[382.992863] Subtest create: SUCCESS (0.000s)
[383.045059] [FACT vgem_basic (create)] new: kernel.kmod_is_loaded.vgem: true
[383.048242] [060/133] (636s left) kms_atomic (plane-primary-legacy)
[383.146177] Starting subtest: plane-primary-legacy
[383.148277] Starting dynamic subtest: pipe-A-eDP-1
[383.585251] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.440s)
[383.587628] Subtest plane-primary-legacy: SUCCESS (0.441s)
[384.458200] [061/133] (635s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[384.558725] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[384.563302] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[384.666559] [062/133] (635s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[384.724762] Starting subtest: invalid-single-wait-unsubmitted
[384.726976] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[384.826871] [063/133] (635s left) kms_psr (psr-cursor-render)
[384.912727] Starting subtest: psr-cursor-render
[384.914973] Starting dynamic subtest: eDP-1
[386.646438] Dynamic subtest eDP-1: SUCCESS (1.732s)
[386.648926] Subtest psr-cursor-render: SUCCESS (1.733s)
[387.512894] [064/133] (632s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[387.609971] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[387.612215] Starting dynamic subtest: pipe-A-eDP-1
[387.634328] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[387.645214] Starting dynamic subtest: pipe-B-eDP-1
[387.666227] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[387.674327] Starting dynamic subtest: pipe-C-eDP-1
[387.695178] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[387.703065] Starting dynamic subtest: pipe-D-eDP-1
[387.724544] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[387.728847] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[389.878579] [065/133] (630s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[390.396512] Starting subtest: syncobj-timeline-invalid-flags
[390.398835] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[391.395736] [066/133] (628s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[391.499314] Starting subtest: stress-xrgb8888-ytiled
[391.503623] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[391.611302] [067/133] (628s left) gem_sync (basic-each)
[391.688081] Starting subtest: basic-each
[394.004498] Subtest basic-each: SUCCESS (2.326s)
[394.193037] [068/133] (625s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[394.315530] Starting subtest: x-tiled-8bpp-rotate-0
[395.507541] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.192s)
[395.613314] [069/133] (624s left) sw_sync (sync_expired_merge)
[395.645496] Starting subtest: sync_expired_merge
[396.720660] Subtest sync_expired_merge: SUCCESS (1.074s)
[396.788722] [070/133] (623s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[396.895270] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[401.403860] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.512s)
[402.568094] [071/133] (617s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[402.657332] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[402.661303] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[402.761121] [072/133] (617s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[402.853617] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[402.857621] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[402.948515] [073/133] (617s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[403.044043] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[403.046278] Starting dynamic subtest: pipe-A
[404.181464] Dynamic subtest pipe-A: SUCCESS (1.140s)
[404.189766] Starting dynamic subtest: pipe-B
[406.570311] Dynamic subtest pipe-B: SUCCESS (2.387s)
[406.579053] Starting dynamic subtest: pipe-C
[407.748928] Dynamic subtest pipe-C: SUCCESS (1.177s)
[407.760729] Starting dynamic subtest: pipe-D
[408.903039] Dynamic subtest pipe-D: SUCCESS (1.153s)
[408.905409] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.863s)
[410.107364] [074/133] (610s left) kms_cursor_edge_walk (64x64-top-bottom)
[410.210088] Starting subtest: 64x64-top-bottom
[410.212341] Starting dynamic subtest: pipe-A-eDP-1
[413.681131] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.470s)
[413.693588] Starting dynamic subtest: pipe-D-eDP-1
[416.825700] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.145s)
[416.827931] Subtest 64x64-top-bottom: SUCCESS (6.617s)
[417.622042] [075/133] (602s left) kms_joiner (basic-ultra-joiner)
[417.725582] Starting subtest: basic-ultra-joiner
[417.729942] Subtest basic-ultra-joiner: SKIP (0.000s)
[417.790760] [076/133] (602s left) gen9_exec_parse (bb-start-param)
[417.848047] Subtest bb-start-param: SKIP (0.000s)
[417.924476] [077/133] (602s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[418.029727] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[424.797791] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.771s)
[424.933966] [078/133] (595s left) sw_sync (sync_multi_consumer)
[424.978396] Starting subtest: sync_multi_consumer
[425.397477] Subtest sync_multi_consumer: SUCCESS (0.420s)
[425.461559] [079/133] (595s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[425.523767] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[425.528131] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[425.708184] [080/133] (594s left) gem_exec_schedule (pi-common)
[425.890964] Starting subtest: pi-common
[425.892920] Starting dynamic subtest: rcs0
[425.917725] Dynamic subtest rcs0: SUCCESS (0.029s)
[425.926541] Starting dynamic subtest: bcs0
[425.949068] Dynamic subtest bcs0: SUCCESS (0.030s)
[425.961837] Starting dynamic subtest: vcs0
[425.979070] Dynamic subtest vcs0: SUCCESS (0.029s)
[425.992235] Starting dynamic subtest: vcs1
[426.008071] Dynamic subtest vcs1: SUCCESS (0.028s)
[426.020122] Starting dynamic subtest: vecs0
[426.035498] Dynamic subtest vecs0: SUCCESS (0.027s)
[426.049032] Starting dynamic subtest: ccs0
[426.061491] Dynamic subtest ccs0: SUCCESS (0.025s)
[426.063760] Subtest pi-common: SUCCESS (0.174s)
[426.288622] [081/133] (594s left) gem_exec_whisper (basic-contexts-all)
[426.344699] Starting subtest: basic-contexts-all
[437.653263] Subtest basic-contexts-all: SUCCESS (11.303s)
[437.838958] [082/133] (582s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[437.935269] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[437.937109] Starting dynamic subtest: pipe-A-eDP-1
[437.957383] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[437.969209] Starting dynamic subtest: pipe-B-eDP-1
[437.990764] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[438.001699] Starting dynamic subtest: pipe-C-eDP-1
[438.020591] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.037s)
[438.029218] Starting dynamic subtest: pipe-D-eDP-1
[438.049036] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[438.051265] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.107s)
[440.231733] [083/133] (580s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[440.330047] Starting subtest: psr-rgb101010-draw-blt
[447.648092] Subtest psr-rgb101010-draw-blt: SUCCESS (7.322s)
[447.763362] [084/133] (573s left) core_setmaster (master-drop-set-shared-fd)
[447.855588] Starting subtest: master-drop-set-shared-fd
[447.866521] Subtest master-drop-set-shared-fd: SUCCESS (0.011s)
[447.909271] [085/133] (572s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[448.017563] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[454.746041] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.732s)
[454.894156] [086/133] (565s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[454.995588] Starting subtest: psr-rgb565-draw-render
[461.992365] Subtest psr-rgb565-draw-render: SUCCESS (7.000s)
[462.104606] [087/133] (558s left) kms_sequence (get-forked-busy)
[462.189614] Starting subtest: get-forked-busy
[462.191912] Starting dynamic subtest: pipe-A-eDP-1
[464.120851] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.933s)
[464.131296] Starting dynamic subtest: pipe-B-eDP-1
[466.713932] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.591s)
[466.724115] Starting dynamic subtest: pipe-C-eDP-1
[469.318189] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.601s)
[469.327747] Starting dynamic subtest: pipe-D-eDP-1
[471.870239] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.550s)
[471.872213] Subtest get-forked-busy: SUCCESS (9.681s)
[472.664875] [088/133] (548s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[472.762234] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[472.766117] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[472.845493] [089/133] (548s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[472.898430] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[472.900686] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[472.982116] [090/133] (548s left) syncobj_wait (single-wait-for-submit-signaled)
[473.040442] Starting subtest: single-wait-for-submit-signaled
[473.042557] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[473.150494] [091/133] (547s left) kms_dsc (dsc-fractional-bpp)
[473.241551] Starting subtest: dsc-fractional-bpp
[473.254415] Subtest dsc-fractional-bpp: SKIP (0.000s)
[473.325400] [092/133] (547s left) syncobj_wait (wait-all-snapshot)
[473.385840] Starting subtest: wait-all-snapshot
[473.465271] Subtest wait-all-snapshot: SUCCESS (0.081s)
[473.541249] [093/133] (547s left) kms_content_protection (legacy-hdcp14)
[473.681059] Starting subtest: legacy-hdcp14
[473.685018] Subtest legacy-hdcp14: SKIP (0.000s)
[473.812018] [094/133] (547s left) gem_exec_balancer (waits)
[473.876410] Starting subtest: waits
[480.435795] Subtest waits: SUCCESS (6.557s)
[480.735607] [095/133] (540s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[480.835851] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[480.838066] Starting dynamic subtest: pipe-A-eDP-1
[480.846531] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[480.857050] Starting dynamic subtest: pipe-B-eDP-1
[480.865450] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[480.874660] Starting dynamic subtest: pipe-C-eDP-1
[480.882584] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[480.890756] Starting dynamic subtest: pipe-D-eDP-1
[480.898768] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[480.902660] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[483.140193] [096/133] (538s left) i915_hangman (engine-error-state-capture)
[483.218089] Starting subtest: engine-error-state-capture
[483.220348] Starting dynamic subtest: rcs0
[486.244356] Dynamic subtest rcs0: SUCCESS (3.026s)
[486.256158] Starting dynamic subtest: bcs0
[492.260078] Dynamic subtest bcs0: SUCCESS (6.013s)
[492.272874] Starting dynamic subtest: vcs0
[498.212220] Dynamic subtest vcs0: SUCCESS (5.949s)
[498.225073] Starting dynamic subtest: vcs1
[503.206512] Dynamic subtest vcs1: SUCCESS (4.991s)
[503.226878] Starting dynamic subtest: vecs0
[509.221319] Dynamic subtest vecs0: SUCCESS (6.013s)
[509.233976] Starting dynamic subtest: ccs0
[515.301260] Dynamic subtest ccs0: SUCCESS (6.076s)
[515.304225] Subtest engine-error-state-capture: SUCCESS (32.084s)
[515.428138] [097/133] (505s left) perf_pmu (rc6-suspend)
[515.472925] Starting subtest: rc6-suspend
[538.277216] Subtest rc6-suspend: SUCCESS (7.709s)
[539.138256] [098/133] (482s left) gem_exec_parallel (basic)
[539.217772] Starting subtest: basic
[539.219930] Starting dynamic subtest: rcs0
[540.810965] Dynamic subtest rcs0: SUCCESS (1.611s)
[540.821854] Starting dynamic subtest: bcs0
[542.270362] Dynamic subtest bcs0: SUCCESS (1.472s)
[542.281246] Starting dynamic subtest: vcs0
[545.472224] Dynamic subtest vcs0: SUCCESS (3.220s)
[545.486002] Starting dynamic subtest: vcs1
[547.456311] Dynamic subtest vcs1: SUCCESS (1.990s)
[547.469400] Starting dynamic subtest: vecs0
[549.440080] Dynamic subtest vecs0: SUCCESS (1.988s)
[549.452759] Starting dynamic subtest: ccs0
[550.905129] Dynamic subtest ccs0: SUCCESS (1.469s)
[550.907391] Subtest basic: SUCCESS (11.766s)
[551.111136] [099/133] (470s left) kms_psr (psr-primary-blt)
[551.212778] Starting subtest: psr-primary-blt
[551.214990] Starting dynamic subtest: eDP-1
[552.916588] Dynamic subtest eDP-1: SUCCESS (1.708s)
[552.918947] Subtest psr-primary-blt: SUCCESS (1.709s)
[553.777050] [100/133] (467s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[553.827052] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[553.909946] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.027s)
[553.954245] [101/133] (467s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[554.052065] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[557.665876] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.624s)
[558.869060] [102/133] (462s left) kms_prop_blob (blob-prop-lifetime)
[558.933303] Starting subtest: blob-prop-lifetime
[558.935586] Subtest blob-prop-lifetime: SUCCESS (0.002s)
[559.043606] [103/133] (462s left) gem_userptr_blits (readonly-unsync)
[559.104039] Subtest readonly-unsync: SKIP (0.000s)
[559.223980] [104/133] (462s left) perf (polling)
[559.304786] Starting subtest: polling
[559.307132] Starting dynamic subtest: 0-rcs0
[569.334264] Dynamic subtest 0-rcs0: SUCCESS (10.030s)
[569.345503] Starting dynamic subtest: 1-vcs1
[579.362221] Dynamic subtest 1-vcs1: SUCCESS (10.021s)
[579.364896] Subtest polling: SUCCESS (20.054s)
[579.411681] [105/133] (442s left) i915_query (query-topology-kernel-writes)
[579.474606] Starting subtest: query-topology-kernel-writes
[579.476785] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[579.563987] [106/133] (442s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[579.669326] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[580.715986] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.045s)
[580.838869] [107/133] (440s left) kms_psr (fbc-pr-sprite-blt)
[580.923980] Starting subtest: fbc-pr-sprite-blt
[580.927648] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[580.995981] [108/133] (440s left) prime_self_import (basic-with_two_bos)
[581.033376] Starting subtest: basic-with_two_bos
[581.043919] Subtest basic-with_two_bos: SUCCESS (0.013s)
[581.127105] [109/133] (440s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[581.217333] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[582.207679] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.990s)
[582.339432] [110/133] (439s left) gem_exec_reloc (basic-cpu-read)
[582.399221] Subtest basic-cpu-read: SKIP (0.000s)
[582.471063] [111/133] (439s left) gem_ctx_shared (exec-shared-gtt)
[582.534090] Starting subtest: exec-shared-gtt
[582.535984] Starting dynamic subtest: rcs0
[582.542421] Dynamic subtest rcs0: SUCCESS (0.008s)
[582.553660] Starting dynamic subtest: bcs0
[582.555492] Dynamic subtest bcs0: SUCCESS (0.005s)
[582.571924] Starting dynamic subtest: vcs0
[582.573583] Dynamic subtest vcs0: SUCCESS (0.008s)
[582.582808] Starting dynamic subtest: vcs1
[582.584557] Dynamic subtest vcs1: SUCCESS (0.006s)
[582.593438] Starting dynamic subtest: vecs0
[582.595143] Dynamic subtest vecs0: SUCCESS (0.006s)
[582.604094] Starting dynamic subtest: ccs0
[582.605801] Dynamic subtest ccs0: SUCCESS (0.005s)
[582.607523] Subtest exec-shared-gtt: SUCCESS (0.043s)
[582.768002] [112/133] (439s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[582.868263] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[582.869998] Starting dynamic subtest: pipe-A
[582.887864] Dynamic subtest pipe-A: SKIP (0.018s)
[582.900296] Starting dynamic subtest: pipe-B
[582.922619] Dynamic subtest pipe-B: SKIP (0.031s)
[582.933348] Starting dynamic subtest: pipe-C
[582.951680] Dynamic subtest pipe-C: SKIP (0.030s)
[582.961380] Starting dynamic subtest: pipe-D
[582.980530] Dynamic subtest pipe-D: SKIP (0.029s)
[582.984290] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.110s)
[583.095569] [113/133] (438s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[583.193788] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[590.354911] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.162s)
[590.482263] [114/133] (431s left) kms_getfb (getfb-handle-protection)
[590.574408] Starting subtest: getfb-handle-protection
[590.590870] Subtest getfb-handle-protection: SUCCESS (0.018s)
[590.703624] [115/133] (431s left) gem_ctx_persistence (process)
[590.771289] Starting subtest: process
[590.935622] Subtest process: SUCCESS (0.167s)
[591.030289] [116/133] (431s left) i915_selftest (mock)
[592.867441] Starting subtest: mock
[592.870382] Starting dynamic subtest: sanitycheck
[593.554994] Dynamic subtest sanitycheck: SUCCESS (0.687s)
[593.565346] Starting dynamic subtest: shmem
[594.236540] Dynamic subtest shmem: SUCCESS (0.680s)
[594.250192] Starting dynamic subtest: fence
[601.626367] Dynamic subtest fence: SUCCESS (7.388s)
[601.636817] Starting dynamic subtest: scatterlist
[603.296386] Dynamic subtest scatterlist: SUCCESS (1.669s)
[603.306921] Starting dynamic subtest: syncmap
[606.464635] Dynamic subtest syncmap: SUCCESS (3.167s)
[606.475593] Starting dynamic subtest: uncore
[607.116148] Dynamic subtest uncore: SUCCESS (0.650s)
[607.126894] Starting dynamic subtest: ring
[607.749907] Dynamic subtest ring: SUCCESS (0.632s)
[607.760581] Starting dynamic subtest: engine
[608.395029] Dynamic subtest engine: SUCCESS (0.643s)
[608.405690] Starting dynamic subtest: timelines
[612.178246] Dynamic subtest timelines: SUCCESS (3.782s)
[612.188675] Starting dynamic subtest: requests
[616.157059] Dynamic subtest requests: SUCCESS (3.978s)
[616.167998] Starting dynamic subtest: objects
[616.918010] Dynamic subtest objects: SUCCESS (0.759s)
[616.928568] Starting dynamic subtest: phys
[617.645853] Dynamic subtest phys: SUCCESS (0.726s)
[617.656386] Starting dynamic subtest: dmabuf
[618.371787] Dynamic subtest dmabuf: SUCCESS (0.725s)
[618.382244] Starting dynamic subtest: vma
[623.891380] Dynamic subtest vma: SUCCESS (5.519s)
[623.901748] Starting dynamic subtest: evict
[625.250700] Dynamic subtest evict: SUCCESS (1.358s)
[625.260998] Starting dynamic subtest: gtt
[628.521752] Dynamic subtest gtt: SUCCESS (3.271s)
[628.531680] Starting dynamic subtest: hugepages
[629.380258] Dynamic subtest hugepages: SUCCESS (0.857s)
[629.390792] Starting dynamic subtest: memory_region
[631.924193] Dynamic subtest memory_region: SUCCESS (2.540s)
[631.926891] Subtest mock: SUCCESS (39.063s)
[631.956515] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[631.957261] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[631.960415] [117/133] (390s left) kms_pm_rpm (legacy-planes-dpms)
[635.661679] Starting subtest: legacy-planes-dpms
[635.664181] Starting dynamic subtest: plane-65
[644.295732] Dynamic subtest plane-65: SUCCESS (8.636s)
[644.307378] Starting dynamic subtest: plane-95
[652.598414] Dynamic subtest plane-95: SUCCESS (8.300s)
[652.609537] Starting dynamic subtest: plane-125
[660.945031] Dynamic subtest plane-125: SUCCESS (8.343s)
[660.957294] Starting dynamic subtest: plane-135
[669.259127] Dynamic subtest plane-135: SUCCESS (8.312s)
[669.261886] Subtest legacy-planes-dpms: SUCCESS (33.600s)
[669.665197] [FACT kms_pm_rpm (legacy-planes-dpms)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[669.666580] [FACT kms_pm_rpm (legacy-planes-dpms)] new: kernel.kmod_is_loaded.i915: true
[669.670751] [118/133] (352s left) kms_cursor_crc (cursor-random-32x10)
[669.833300] Starting subtest: cursor-random-32x10
[669.885654] Subtest cursor-random-32x10: SKIP (0.047s)
[670.154530] [119/133] (352s left) kms_cursor_crc (cursor-offscreen-32x32)
[670.280882] Starting subtest: cursor-offscreen-32x32
[670.332511] Subtest cursor-offscreen-32x32: SKIP (0.047s)
[670.634816] [120/133] (351s left) syncobj_wait (single-wait-all-for-submit-submitted)
[670.687173] Starting subtest: single-wait-all-for-submit-submitted
[670.796753] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.108s)
[670.870551] [121/133] (351s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[670.932277] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[670.993633] [122/133] (351s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[671.059530] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[671.062074] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[671.151430] [123/133] (351s left) kms_chamelium_hpd (hdmi-hpd)
[671.530557] Subtest hdmi-hpd: SKIP (0.000s)
[672.346414] [124/133] (350s left) gem_exec_reloc (basic-gtt-noreloc)
[672.405070] Subtest basic-gtt-noreloc: SKIP (0.000s)
[672.503282] [125/133] (349s left) kms_flip (2x-wf_vblank-ts-check)
[672.598996] Starting subtest: 2x-wf_vblank-ts-check
[672.607452] Subtest 2x-wf_vblank-ts-check: SKIP (0.010s)
[672.693973] [126/133] (349s left) kms_psr (pr-primary-mmap-cpu)
[672.795151] Starting subtest: pr-primary-mmap-cpu
[672.799476] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[672.867590] [127/133] (349s left) gem_readwrite (read-write)
[672.919435] Subtest read-write: SKIP (0.000s)
[672.973082] [128/133] (349s left) fbdev (write)
[673.015634] Starting subtest: write
[673.374540] Subtest write: SUCCESS (0.357s)
[673.435319] [129/133] (349s left) kms_dp_aux_dev (basic)
[673.486983] Starting subtest: basic
[673.708263] Subtest basic: SUCCESS (0.221s)
[673.781372] [130/133] (348s left) kms_psr (fbc-psr2-sprite-render)
[673.873071] Starting subtest: fbc-psr2-sprite-render
[673.875250] Starting dynamic subtest: eDP-1
[673.879538] Dynamic subtest eDP-1: SKIP (0.000s)
[673.883744] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[673.960445] [131/133] (348s left) gem_ctx_persistence (engines-cleanup)
[674.023117] Starting subtest: engines-cleanup
[674.025434] Starting dynamic subtest: rcs0
[674.110895] Dynamic subtest rcs0: SUCCESS (0.087s)
[674.123491] Starting dynamic subtest: bcs0
[674.160539] Dynamic subtest bcs0: SUCCESS (0.048s)
[674.171772] Starting dynamic subtest: vcs0
[674.206541] Dynamic subtest vcs0: SUCCESS (0.044s)
[674.217430] Starting dynamic subtest: vcs1
[674.259878] Dynamic subtest vcs1: SUCCESS (0.051s)
[674.271855] Starting dynamic subtest: vecs0
[674.278509] Dynamic subtest vecs0: SUCCESS (0.017s)
[674.287554] Starting dynamic subtest: ccs0
[674.342756] Dynamic subtest ccs0: SUCCESS (0.063s)
[674.345380] Subtest engines-cleanup: SUCCESS (0.320s)
[674.424373] [132/133] (348s left) sysfs_heartbeat_interval (idempotent)
[674.479391] Starting subtest: idempotent
[674.481801] Starting dynamic subtest: vecs0
[674.484636] Dynamic subtest vecs0: SUCCESS (0.001s)
[674.500454] Starting dynamic subtest: ccs0
[674.502376] Dynamic subtest ccs0: SUCCESS (0.001s)
[674.511240] Starting dynamic subtest: vcs0
[674.513053] Dynamic subtest vcs0: SUCCESS (0.000s)
[674.521599] Starting dynamic subtest: bcs0
[674.523410] Dynamic subtest bcs0: SUCCESS (0.001s)
[674.532280] Starting dynamic subtest: rcs0
[674.534416] Dynamic subtest rcs0: SUCCESS (0.000s)
[674.545193] Starting dynamic subtest: vcs1
[674.549149] Dynamic subtest vcs1: SUCCESS (0.000s)
[674.551021] Subtest idempotent: SUCCESS (0.009s)
[674.596464] [133/133] (348s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[674.686350] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[681.765159] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.081s)
[681.878039] 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.