[60.390200] Initializing watchdogs
[60.390246]   /dev/watchdog0
[60.403879] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[60.409021] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.411237] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.414442] [001/133] (960s left) kms_psr (fbc-pr-cursor-plane-onoff)
[60.537822] Starting subtest: fbc-pr-cursor-plane-onoff
[60.542169] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[60.617103] [002/133] (960s left) gem_exec_schedule (preempt-self)
[60.695585] Starting subtest: preempt-self
[60.697585] Starting dynamic subtest: rcs0
[60.711803] Dynamic subtest rcs0: SUCCESS (0.022s)
[60.721197] Starting dynamic subtest: bcs0
[60.732069] Dynamic subtest bcs0: SUCCESS (0.020s)
[60.739445] Starting dynamic subtest: vcs0
[60.751053] Dynamic subtest vcs0: SUCCESS (0.019s)
[60.757969] Starting dynamic subtest: vcs1
[60.766266] Dynamic subtest vcs1: SUCCESS (0.015s)
[60.773096] Starting dynamic subtest: vecs0
[60.786331] Dynamic subtest vecs0: SUCCESS (0.020s)
[60.793272] Starting dynamic subtest: ccs0
[60.803368] Dynamic subtest ccs0: SUCCESS (0.016s)
[60.805536] Subtest preempt-self: SUCCESS (0.114s)
[62.000324] [003/133] (958s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[62.100798] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[62.105157] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[62.200600] [004/133] (958s left) kms_color_pipeline (plane-ctm3x4)
[62.293896] Starting subtest: plane-ctm3x4
[62.449944] Starting dynamic subtest: pipe-A-plane-0
[62.801409] Dynamic subtest pipe-A-plane-0: FAIL (0.186s)
[62.810366] Starting dynamic subtest: pipe-A-plane-1
[63.016536] Dynamic subtest pipe-A-plane-1: FAIL (0.144s)
[63.025058] Starting dynamic subtest: pipe-A-plane-2
[63.220144] Dynamic subtest pipe-A-plane-2: FAIL (0.145s)
[64.150747] Starting dynamic subtest: pipe-B-plane-0
[64.587525] Dynamic subtest pipe-B-plane-0: FAIL (0.167s)
[64.596266] Starting dynamic subtest: pipe-B-plane-1
[64.898848] Dynamic subtest pipe-B-plane-1: FAIL (0.152s)
[64.907902] Starting dynamic subtest: pipe-B-plane-2
[65.207554] Dynamic subtest pipe-B-plane-2: FAIL (0.145s)
[65.768221] Starting dynamic subtest: pipe-C-plane-0
[66.231652] Dynamic subtest pipe-C-plane-0: FAIL (0.106s)
[66.240796] Starting dynamic subtest: pipe-C-plane-1
[66.636338] Dynamic subtest pipe-C-plane-1: FAIL (0.593s)
[66.644848] Starting dynamic subtest: pipe-C-plane-2
[66.990855] Dynamic subtest pipe-C-plane-2: FAIL (0.121s)
[67.814320] Starting dynamic subtest: pipe-D-plane-0
[68.384453] Dynamic subtest pipe-D-plane-0: FAIL (0.129s)
[68.394129] Starting dynamic subtest: pipe-D-plane-1
[68.837493] Dynamic subtest pipe-D-plane-1: FAIL (0.616s)
[68.846951] Starting dynamic subtest: pipe-D-plane-2
[69.266742] Dynamic subtest pipe-D-plane-2: FAIL (0.539s)
[69.389666] Subtest plane-ctm3x4: FAIL (7.098s)
[70.201846] [005/133] (950s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[70.301613] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[77.386708] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.091s)
[77.528952] [006/133] (943s left) perf_pmu (busy-idle-check-all)
[77.574732] Starting subtest: busy-idle-check-all
[77.576581] Starting dynamic subtest: rcs0
[78.224811] Dynamic subtest rcs0: SUCCESS (0.651s)
[78.234111] Starting dynamic subtest: bcs0
[78.876450] Dynamic subtest bcs0: SUCCESS (0.651s)
[78.885862] Starting dynamic subtest: vcs0
[80.919136] Dynamic subtest vcs0: SUCCESS (2.040s)
[80.927857] Starting dynamic subtest: vcs1
[82.903199] Dynamic subtest vcs1: SUCCESS (1.982s)
[82.913021] Starting dynamic subtest: vecs0
[84.887357] Dynamic subtest vecs0: SUCCESS (1.982s)
[84.897718] Starting dynamic subtest: ccs0
[85.543037] Dynamic subtest ccs0: SUCCESS (0.656s)
[85.545471] Subtest busy-idle-check-all: SUCCESS (7.971s)
[85.646719] [007/133] (935s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[85.745782] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[85.748068] Starting dynamic subtest: pipe-A
[85.808436] Dynamic subtest pipe-A: SUCCESS (0.065s)
[85.816358] Starting dynamic subtest: pipe-B
[86.932455] Dynamic subtest pipe-B: SUCCESS (1.124s)
[86.943932] Starting dynamic subtest: pipe-C
[88.060738] Dynamic subtest pipe-C: SUCCESS (1.128s)
[88.073650] Starting dynamic subtest: pipe-D
[89.171568] Dynamic subtest pipe-D: SUCCESS (1.110s)
[89.174090] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.428s)
[90.328961] [008/133] (930s left) gem_basic (bad-close)
[90.396999] Starting subtest: bad-close
[90.401514] Subtest bad-close: SUCCESS (0.000s)
[90.479367] [009/133] (930s left) syncobj_basic (test-valid-cycle)
[90.539115] Starting subtest: test-valid-cycle
[90.541536] Subtest test-valid-cycle: SUCCESS (0.000s)
[90.619251] [010/133] (930s left) gen9_exec_parse (unaligned-jump)
[90.675431] Subtest unaligned-jump: SKIP (0.000s)
[90.748136] [011/133] (930s left) drm_buddy (drm_buddy)
[90.783277] Starting subtest: drm_buddy
[90.787554] Subtest drm_buddy: SKIP (0.001s)
[90.836550] [012/133] (930s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[90.940788] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[92.044302] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.104s)
[92.166588] [013/133] (929s left) gen9_exec_parse (bb-chained)
[92.226858] Subtest bb-chained: SKIP (0.000s)
[92.289712] [014/133] (929s left) gem_gtt_cpu_tlb
[92.410139] [015/133] (929s left) syncobj_timeline (transfer-timeline-point)
[92.457190] Starting subtest: transfer-timeline-point
[92.459212] Subtest transfer-timeline-point: SUCCESS (0.000s)
[92.549386] [016/133] (928s left) gem_ctx_shared (exec-single-timeline)
[92.602358] Starting subtest: exec-single-timeline
[92.604075] Starting dynamic subtest: rcs0
[93.682590] Dynamic subtest rcs0: SUCCESS (1.080s)
[93.692135] Starting dynamic subtest: bcs0
[94.706410] Dynamic subtest bcs0: SUCCESS (1.023s)
[94.715902] Starting dynamic subtest: vcs0
[95.795461] Dynamic subtest vcs0: SUCCESS (1.086s)
[95.804706] Starting dynamic subtest: vcs1
[96.883973] Dynamic subtest vcs1: SUCCESS (1.087s)
[96.898337] Starting dynamic subtest: vecs0
[97.971616] Dynamic subtest vecs0: SUCCESS (1.086s)
[97.980869] Starting dynamic subtest: ccs0
[99.061105] Dynamic subtest ccs0: SUCCESS (1.087s)
[99.064067] Subtest exec-single-timeline: SUCCESS (6.460s)
[99.290115] [017/133] (922s left) kms_chamelium_color (ctm-0-75)
[99.394024] Subtest ctm-0-75: SKIP (0.000s)
[99.437636] [018/133] (922s left) gem_pxp (create-regular-buffer)
[99.551726] Starting subtest: create-regular-buffer
[99.554772] Subtest create-regular-buffer: SUCCESS (0.000s)
[99.667952] [019/133] (921s left) kms_force_connector_basic (prune-stale-modes)
[99.741097] Starting subtest: prune-stale-modes
[100.182445] Subtest prune-stale-modes: SUCCESS (0.442s)
[100.315829] [020/133] (921s left) kms_chamelium_hpd (dp-hpd)
[100.692724] Subtest dp-hpd: SKIP (0.000s)
[101.538378] [021/133] (920s left) gem_render_copy (yf-tiled-to-vebox-linear)
[101.613988] Starting subtest: yf-tiled-to-vebox-linear
[101.618821] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[101.804418] [022/133] (919s left) kms_psr (psr-sprite-blt)
[101.895865] Starting subtest: psr-sprite-blt
[101.898244] Starting dynamic subtest: eDP-1
[103.651841] Dynamic subtest eDP-1: SUCCESS (1.756s)
[103.654188] Subtest psr-sprite-blt: SUCCESS (1.757s)
[104.446279] [023/133] (917s left) perf (non-system-wide-paranoid)
[104.583282] Starting subtest: non-system-wide-paranoid
[104.612148] Subtest non-system-wide-paranoid: SUCCESS (0.029s)
[104.655571] [024/133] (917s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[104.755192] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[104.757430] Starting dynamic subtest: pipe-A-eDP-1
[104.780346] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[104.790627] Starting dynamic subtest: pipe-B-eDP-1
[104.812179] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[104.820103] Starting dynamic subtest: pipe-C-eDP-1
[104.841213] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[104.848744] Starting dynamic subtest: pipe-D-eDP-1
[104.871200] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[104.875265] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[106.954163] [025/133] (914s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[107.019238] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[107.123709] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[107.197594] [026/133] (914s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[107.592930] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[108.428996] [027/133] (913s left) kms_panel_fitting (legacy)
[108.534918] Starting subtest: legacy
[108.537344] Starting dynamic subtest: pipe-A-eDP-1
[109.084235] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.551s)
[109.110808] Starting dynamic subtest: pipe-B-eDP-1
[110.682321] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.577s)
[110.708309] Starting dynamic subtest: pipe-C-eDP-1
[112.270270] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.569s)
[112.297574] Starting dynamic subtest: pipe-D-eDP-1
[113.835071] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.547s)
[113.837208] Subtest legacy: SUCCESS (5.304s)
[115.045402] [028/133] (906s left) api_intel_allocator (reserve-simple)
[115.103303] Starting subtest: reserve-simple
[115.108316] Subtest reserve-simple: SUCCESS (0.005s)
[115.234382] [029/133] (906s left) gem_exec_balancer (hog)
[115.294767] Starting subtest: hog
[115.299110] Subtest hog: SKIP (0.000s)
[115.600064] [030/133] (906s left) kms_flip (2x-dpms-vs-vblank-race)
[115.698481] Starting subtest: 2x-dpms-vs-vblank-race
[115.706633] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s)
[115.782437] [031/133] (906s left) gem_exec_schedule (pi-userfault)
[115.966324] Starting subtest: pi-userfault
[115.968756] Starting dynamic subtest: rcs0
[115.974990] Dynamic subtest rcs0: SUCCESS (0.012s)
[115.985778] Starting dynamic subtest: bcs0
[115.987685] Dynamic subtest bcs0: SUCCESS (0.007s)
[115.995761] Starting dynamic subtest: vcs0
[115.998072] Dynamic subtest vcs0: SUCCESS (0.008s)
[116.006551] Starting dynamic subtest: vcs1
[116.008636] Dynamic subtest vcs1: SUCCESS (0.009s)
[116.017537] Starting dynamic subtest: vecs0
[116.024239] Dynamic subtest vecs0: SUCCESS (0.009s)
[116.031428] Starting dynamic subtest: ccs0
[116.033936] Dynamic subtest ccs0: SUCCESS (0.010s)
[116.036135] Subtest pi-userfault: SUCCESS (0.058s)
[116.199335] [032/133] (905s left) kms_frontbuffer_tracking (fbc-tiling-y)
[116.304409] Starting subtest: fbc-tiling-y
[116.308689] Subtest fbc-tiling-y: SKIP (0.000s)
[116.412619] [033/133] (905s left) kms_vblank (wait-busy-hang)
[116.505396] Starting subtest: wait-busy-hang
[116.507744] Starting dynamic subtest: pipe-A-eDP-1
[142.680526] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.173s)
[142.694316] Starting dynamic subtest: pipe-D-eDP-1
[167.706834] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.027s)
[167.709545] Subtest wait-busy-hang: SUCCESS (51.204s)
[168.541804] [034/133] (853s left) gem_lmem_swapping (heavy-verify-random-ccs)
[168.592437] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[168.630531] [035/133] (853s left) gem_create (create-ext-cpu-access-big)
[168.794630] Starting subtest: create-ext-cpu-access-big
[168.799476] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[168.875631] [036/133] (853s left) kms_async_flips (invalid-async-flip)
[168.981107] Starting subtest: invalid-async-flip
[169.367542] Starting dynamic subtest: pipe-A-eDP-1
[170.153326] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.787s)
[170.515662] Starting dynamic subtest: pipe-B-eDP-1
[171.329351] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.821s)
[171.685710] Starting dynamic subtest: pipe-C-eDP-1
[172.525217] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.846s)
[172.878048] Starting dynamic subtest: pipe-D-eDP-1
[173.723868] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.852s)
[173.726135] Subtest invalid-async-flip: SUCCESS (4.746s)
[174.931324] [037/133] (847s left) gem_userptr_blits (huge-split)
[174.999277] Starting subtest: huge-split
[175.009121] Subtest huge-split: SUCCESS (0.010s)
[175.121182] [038/133] (847s left) kms_pm_dc (dc5-psr)
[176.217445] Starting subtest: dc5-psr
[179.216219] Subtest dc5-psr: SUCCESS (2.999s)
[180.032882] [039/133] (842s left) prime_mmap (test_forked_cpu_write)
[180.092757] Starting subtest: test_forked_cpu_write
[180.094811] Starting dynamic subtest: test_forked_cpu_write-smem
[180.102082] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.012s)
[180.104325] Subtest test_forked_cpu_write: SUCCESS (0.012s)
[180.199378] [040/133] (842s left) kms_invalid_mode (zero-vdisplay)
[180.286530] Starting subtest: zero-vdisplay
[180.288855] Starting dynamic subtest: pipe-A-eDP-1
[180.571689] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[180.580326] Starting dynamic subtest: pipe-B-eDP-1
[180.582290] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[180.589822] Starting dynamic subtest: pipe-C-eDP-1
[180.592225] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[180.599466] Starting dynamic subtest: pipe-D-eDP-1
[180.601815] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[180.604228] Subtest zero-vdisplay: SUCCESS (0.294s)
[181.457940] [041/133] (840s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[181.587455] Starting subtest: basic-busy-flip-before-cursor-legacy
[181.591792] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[181.728399] [042/133] (840s left) gem_eio (in-flight-contexts-1us)
[181.934536] Starting subtest: in-flight-contexts-1us
[193.956058] Subtest in-flight-contexts-1us: SUCCESS (12.021s)
[194.070515] [043/133] (828s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[194.172373] Starting subtest: 4-tiled-32bpp-rotate-270
[194.191516] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.018s)
[194.295582] [044/133] (828s left) perf (invalid-oa-format-id)
[194.371401] Starting subtest: invalid-oa-format-id
[194.380403] Subtest invalid-oa-format-id: SUCCESS (0.008s)
[194.440764] [045/133] (828s left) tools_test (tools_test)
[194.492241] Starting subtest: tools_test
[194.554351] Subtest tools_test: SUCCESS (0.075s)
[194.620779] [046/133] (827s left) prime_mmap (test_refcounting)
[194.675305] Starting subtest: test_refcounting
[194.677307] Starting dynamic subtest: test_refcounting-smem
[194.708590] Dynamic subtest test_refcounting-smem: SUCCESS (0.034s)
[194.711094] Subtest test_refcounting: SUCCESS (0.035s)
[194.803034] [047/133] (827s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[194.897303] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[198.966930] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.075s)
[200.161433] [048/133] (822s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[200.266968] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[200.271305] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[200.368390] [049/133] (822s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[200.428848] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[200.503828] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.005s)
[200.552598] [050/133] (822s left) kms_sequence (get-forked)
[200.653788] Starting subtest: get-forked
[200.656161] Starting dynamic subtest: pipe-A-eDP-1
[202.537663] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.884s)
[202.546742] Starting dynamic subtest: pipe-B-eDP-1
[205.066249] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.527s)
[205.075913] Starting dynamic subtest: pipe-C-eDP-1
[207.639749] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.573s)
[207.650593] Starting dynamic subtest: pipe-D-eDP-1
[210.133113] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.491s)
[210.135436] Subtest get-forked: SUCCESS (9.480s)
[210.930298] [051/133] (811s left) kms_flip (2x-flip-vs-suspend)
[211.033112] Starting subtest: 2x-flip-vs-suspend
[211.041290] Subtest 2x-flip-vs-suspend: SKIP (0.010s)
[211.112832] [052/133] (811s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[211.211198] Starting subtest: fbcpsr-rgb565-draw-blt
[218.101265] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (6.893s)
[218.221550] [053/133] (804s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[218.322092] Starting subtest: yf-tiled-64bpp-rotate-90
[218.326501] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[218.418223] [054/133] (804s left) gem_mmap_gtt (hang-user)
[218.469791] Subtest hang-user: SKIP (0.000s)
[218.527422] [055/133] (804s left) vgem_basic (busy-fence)
[218.628389] Starting subtest: busy-fence
[218.630726] Subtest busy-fence: SUCCESS (0.001s)
[218.719690] [FACT vgem_basic (busy-fence)] new: kernel.kmod_is_loaded.vgem: true
[218.723638] [056/133] (804s left) kms_psr (psr2-cursor-render)
[218.814249] Starting subtest: psr2-cursor-render
[218.816594] Starting dynamic subtest: eDP-1
[220.470549] Dynamic subtest eDP-1: SUCCESS (1.656s)
[220.472729] Subtest psr2-cursor-render: SUCCESS (1.657s)
[221.331855] [057/133] (801s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[221.427038] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[221.429149] Starting dynamic subtest: pipe-A-default-mode
[222.558933] Dynamic subtest pipe-A-default-mode: SKIP (1.128s)
[222.563398] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.129s)
[222.694554] [058/133] (800s left) kms_flip (2x-flip-vs-panning-vs-hang)
[222.787770] Starting subtest: 2x-flip-vs-panning-vs-hang
[222.795663] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.011s)
[222.905880] [059/133] (800s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[223.012037] Starting subtest: pr-cursor-plane-move-continuous-sf
[223.016441] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[223.091462] [060/133] (800s left) api_intel_bb (delta-check)
[223.151471] Starting subtest: delta-check
[223.154669] Subtest delta-check: SUCCESS (0.006s)
[223.284618] [061/133] (799s left) gem_exec_parallel (contexts)
[223.344302] Starting subtest: contexts
[223.346596] Starting dynamic subtest: rcs0
[226.916930] Dynamic subtest rcs0: SUCCESS (3.571s)
[226.928708] Starting dynamic subtest: bcs0
[231.209929] Dynamic subtest bcs0: SUCCESS (4.290s)
[231.221688] Starting dynamic subtest: vcs0
[235.436223] Dynamic subtest vcs0: SUCCESS (4.224s)
[235.445932] Starting dynamic subtest: vcs1
[241.250163] Dynamic subtest vcs1: SUCCESS (5.810s)
[241.258594] Starting dynamic subtest: vecs0
[245.414982] Dynamic subtest vecs0: SUCCESS (4.161s)
[245.426172] Starting dynamic subtest: ccs0
[249.938123] Dynamic subtest ccs0: SUCCESS (4.520s)
[249.940444] Subtest contexts: SUCCESS (26.593s)
[250.141617] [062/133] (773s left) i915_pm_rpm (debugfs-read)
[252.072437] Starting subtest: debugfs-read
[253.229423] Subtest debugfs-read: SUCCESS (1.157s)
[253.619511] [063/133] (769s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[253.723278] Starting subtest: fbc-rgb101010-draw-pwrite
[259.071973] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.351s)
[260.239775] [064/133] (763s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[260.290708] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[260.395073] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.104s)
[260.474289] [065/133] (762s left) kms_prop_blob (blob-multiple)
[260.533119] Starting subtest: blob-multiple
[260.535425] Subtest blob-multiple: SUCCESS (0.002s)
[260.651316] [066/133] (762s left) kms_draw_crc (draw-method-mmap-gtt)
[260.743136] Starting subtest: draw-method-mmap-gtt
[260.747144] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[260.851513] [067/133] (762s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[260.950509] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[261.930956] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.979s)
[262.035931] [068/133] (761s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[262.129342] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[262.133395] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[262.197798] [069/133] (761s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[262.301266] Starting subtest: y-tiled-8bpp-rotate-180
[262.304816] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[262.421152] [070/133] (761s left) gem_softpin (noreloc)
[262.478110] Starting subtest: noreloc
[267.866907] Subtest noreloc: SUCCESS (5.386s)
[268.004780] [071/133] (755s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[268.104348] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[268.108738] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[268.206437] [072/133] (755s left) gem_ctx_persistence (heartbeat-hang)
[268.267880] Starting subtest: heartbeat-hang
[268.272230] Subtest heartbeat-hang: SKIP (0.000s)
[268.368936] [073/133] (755s left) gem_exec_whisper (basic-normal-all)
[268.434676] Starting subtest: basic-normal-all
[270.943969] Subtest basic-normal-all: SUCCESS (2.507s)
[271.129127] [074/133] (752s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[271.228334] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[271.232726] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[271.331876] [075/133] (752s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[271.427090] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[271.431579] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[271.522911] [076/133] (752s left) kms_plane_lowres (tiling-none)
[271.625568] Starting subtest: tiling-none
[271.627871] Starting dynamic subtest: pipe-A-eDP-1
[271.632534] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[271.926647] Starting dynamic subtest: pipe-B-eDP-1
[271.931354] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[271.939986] Starting dynamic subtest: pipe-C-eDP-1
[271.945668] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[271.954333] Starting dynamic subtest: pipe-D-eDP-1
[271.958824] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[271.963284] Subtest tiling-none: SKIP (0.302s)
[272.738552] [077/133] (751s left) gem_tiled_fence_blits (basic)
[272.799908] Subtest basic: SKIP (0.000s)
[272.873479] [078/133] (751s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[272.936378] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[273.042564] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.106s)
[273.130368] [079/133] (750s left) perf (per-context-mode-unprivileged)
[273.224840] Starting subtest: per-context-mode-unprivileged
[273.229438] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[273.270906] [080/133] (750s left) kms_psr (pr-dpms)
[273.360125] Starting subtest: pr-dpms
[273.364661] Subtest pr-dpms: SKIP (0.000s)
[273.431440] [081/133] (750s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[273.512519] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[273.516960] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[273.611325] [082/133] (750s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[273.699093] Starting subtest: basic-modeset-with-all-modifiers-formats
[274.077463] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[274.891873] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.814s)
[274.901078] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[274.912989] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[274.921508] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[274.935569] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[274.943866] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[275.080322] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.144s)
[275.090764] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[275.102214] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[275.110176] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[275.124501] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[275.132656] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[275.146465] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[275.154656] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[275.169058] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s)
[275.177119] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[275.191312] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s)
[275.199144] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[275.213447] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[275.221532] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[275.235802] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[275.243655] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[275.257853] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[275.265776] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[275.414177] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[275.428690] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[275.435649] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.020s)
[275.444684] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[275.457990] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[275.466352] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[275.480319] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[275.488321] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[275.502508] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.021s)
[275.510585] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[275.524792] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[275.533070] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[275.547076] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[275.555180] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[275.569096] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[275.577999] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[275.591178] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.021s)
[275.599287] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[275.747280] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[275.760896] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[275.769682] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[275.781719] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[275.791806] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[275.800944] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[275.814221] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.020s)
[275.828543] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[275.836152] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[275.844544] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[275.858299] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[275.866604] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[275.880049] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[275.888088] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[275.902462] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s)
[275.910517] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[275.924902] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[276.316815] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.620s)
[277.128234] [083/133] (746s left) syncobj_timeline (signal)
[277.191405] Starting subtest: signal
[277.193630] Subtest signal: SUCCESS (0.000s)
[277.298717] [084/133] (746s left) kms_hdr (invalid-metadata-sizes)
[277.393364] Starting subtest: invalid-metadata-sizes
[277.399864] Subtest invalid-metadata-sizes: SKIP (0.000s)
[277.466623] [085/133] (746s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[277.580928] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[281.548951] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (3.970s)
[282.745998] [086/133] (741s left) gem_softpin (allocator-nopin)
[282.817900] Starting subtest: allocator-nopin
[282.917029] Subtest allocator-nopin: SUCCESS (0.100s)
[283.068366] [087/133] (741s left) kms_cursor_crc (cursor-onscreen-128x42)
[283.304843] Starting subtest: cursor-onscreen-128x42
[283.351823] Subtest cursor-onscreen-128x42: SKIP (0.041s)
[283.561772] [088/133] (740s left) syncobj_timeline (invalid-wait-illegal-handle)
[283.617580] Starting subtest: invalid-wait-illegal-handle
[283.619818] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[283.728174] [089/133] (740s left) perf_pmu (busy-accuracy-2)
[283.769910] Starting subtest: busy-accuracy-2
[283.771907] Starting dynamic subtest: rcs0
[286.823177] Dynamic subtest rcs0: SUCCESS (3.049s)
[286.833898] Starting dynamic subtest: bcs0
[289.879982] Dynamic subtest bcs0: SUCCESS (3.055s)
[289.889032] Starting dynamic subtest: vcs0
[292.927762] Dynamic subtest vcs0: SUCCESS (3.045s)
[292.936786] Starting dynamic subtest: vcs1
[295.975247] Dynamic subtest vcs1: SUCCESS (3.043s)
[295.986041] Starting dynamic subtest: vecs0
[299.020613] Dynamic subtest vecs0: SUCCESS (3.044s)
[299.032227] Starting dynamic subtest: ccs0
[302.078072] Dynamic subtest ccs0: SUCCESS (3.055s)
[302.080552] Subtest busy-accuracy-2: SUCCESS (18.305s)
[302.199550] [090/133] (722s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[302.287794] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[302.290022] Starting dynamic subtest: pipe-A-eDP-1
[302.311922] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[302.321782] Starting dynamic subtest: pipe-B-eDP-1
[302.343529] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[302.353746] Starting dynamic subtest: pipe-C-eDP-1
[302.375184] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[302.383338] Starting dynamic subtest: pipe-D-eDP-1
[302.405241] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[302.409618] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.004s)
[304.529493] [091/133] (719s left) gem_pipe_control_store_loop (fresh-buffer)
[304.587188] Starting subtest: fresh-buffer
[306.741573] Subtest fresh-buffer: SUCCESS (2.152s)
[306.868693] [092/133] (717s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[306.989114] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[313.970205] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.983s)
[314.107916] [093/133] (710s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[314.225080] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[314.229072] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[314.330497] [094/133] (710s left) perf (invalid-oa-metric-set-id)
[314.414536] Starting subtest: invalid-oa-metric-set-id
[314.423262] Subtest invalid-oa-metric-set-id: SUCCESS (0.008s)
[314.474445] [095/133] (710s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[314.566114] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[315.544452] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.978s)
[315.678709] [096/133] (708s left) gem_softpin (evict-snoop-interruptible)
[315.740626] Starting subtest: evict-snoop-interruptible
[315.745064] Subtest evict-snoop-interruptible: SKIP (0.000s)
[315.857839] [097/133] (708s left) kms_flip (modeset-vs-vblank-race)
[315.950440] Starting subtest: modeset-vs-vblank-race
[315.952305] Starting dynamic subtest: A-eDP1
[320.621044] Dynamic subtest A-eDP1: SUCCESS (4.671s)
[320.633643] Starting dynamic subtest: B-eDP1
[325.322133] Dynamic subtest B-eDP1: SUCCESS (4.698s)
[325.334609] Starting dynamic subtest: C-eDP1
[329.996873] Dynamic subtest C-eDP1: SUCCESS (4.672s)
[330.005585] Starting dynamic subtest: D-eDP1
[334.701849] Dynamic subtest D-eDP1: SUCCESS (4.704s)
[334.707474] Subtest modeset-vs-vblank-race: SUCCESS (18.757s)
[335.933190] [098/133] (688s left) gem_eio (banned)
[336.164845] Starting subtest: banned
[336.837498] Subtest banned: SUCCESS (0.673s)
[337.002608] [099/133] (687s left) kms_cursor_crc (cursor-random-128x42)
[337.226352] Starting subtest: cursor-random-128x42
[337.272369] Subtest cursor-random-128x42: SKIP (0.041s)
[337.480623] [100/133] (687s left) kms_lease (lease-revoke)
[337.571566] Starting subtest: lease-revoke
[337.573522] Starting dynamic subtest: pipe-A-eDP-1
[337.603803] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.032s)
[337.614765] Starting dynamic subtest: pipe-B-eDP-1
[337.630117] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.027s)
[337.639068] Starting dynamic subtest: pipe-C-eDP-1
[337.658089] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s)
[337.667216] Starting dynamic subtest: pipe-D-eDP-1
[337.690502] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.029s)
[337.692477] Subtest lease-revoke: SUCCESS (0.121s)
[337.815232] [101/133] (687s left) gem_exec_reloc (basic-gtt-noreloc)
[337.867014] Subtest basic-gtt-noreloc: SKIP (0.000s)
[337.942962] [102/133] (686s left) kms_pipe_stress (stress-xrgb8888-untiled)
[338.031468] Starting subtest: stress-xrgb8888-untiled
[343.885466] Subtest stress-xrgb8888-untiled: SUCCESS (5.853s)
[343.933892] [103/133] (680s left) kms_content_protection (mei-interface)
[344.088626] Starting subtest: mei-interface
[344.092727] Subtest mei-interface: SKIP (0.001s)
[344.246990] [104/133] (680s left) gem_mmap_gtt (cpuset-big-copy-odd)
[344.301973] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[344.355765] [105/133] (680s left) prime_self_import (basic-with_fd_dup)
[344.386949] Starting subtest: basic-with_fd_dup
[344.405166] Subtest basic-with_fd_dup: SUCCESS (0.018s)
[344.492072] [106/133] (680s left) fbdev (nullptr)
[344.533015] Starting subtest: nullptr
[344.534984] Subtest nullptr: SUCCESS (0.000s)
[344.589977] [107/133] (680s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[344.676475] Starting subtest: psr-rgb101010-draw-mmap-cpu
[351.766883] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.092s)
[351.865253] [108/133] (673s left) i915_hangman (error-state-basic)
[351.944566] Starting subtest: error-state-basic
[352.097647] Subtest error-state-basic: SUCCESS (0.152s)
[352.168861] [109/133] (673s left) kms_rotation_crc (bad-tiling)
[352.264544] Starting subtest: bad-tiling
[352.268588] Subtest bad-tiling: SKIP (0.001s)
[352.356338] [110/133] (672s left) gem_userptr_blits (sync-unmap-after-close)
[352.430277] Starting subtest: sync-unmap-after-close
[352.440784] Subtest sync-unmap-after-close: SUCCESS (0.011s)
[352.578100] [111/133] (672s left) kms_flip (flip-vs-expired-vblank-interruptible)
[352.668270] Starting subtest: flip-vs-expired-vblank-interruptible
[352.670526] Starting dynamic subtest: A-eDP1
[361.299709] Dynamic subtest A-eDP1: SUCCESS (8.630s)
[361.316847] Starting dynamic subtest: B-eDP1
[370.003599] Dynamic subtest B-eDP1: SUCCESS (8.702s)
[370.012742] Starting dynamic subtest: C-eDP1
[378.694863] Dynamic subtest C-eDP1: SUCCESS (8.689s)
[378.705076] Starting dynamic subtest: D-eDP1
[387.299053] Dynamic subtest D-eDP1: SUCCESS (8.602s)
[387.304571] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.635s)
[388.525045] [112/133] (636s left) gem_exec_fence (syncobj-timeline-chain-engines)
[389.100131] Starting subtest: syncobj-timeline-chain-engines
[389.228864] Subtest syncobj-timeline-chain-engines: SUCCESS (0.129s)
[391.031340] [113/133] (634s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[391.121468] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[391.125838] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[391.201532] [114/133] (634s left) kms_cursor_edge_walk (64x64-left-edge)
[391.299963] Starting subtest: 64x64-left-edge
[391.302322] Starting dynamic subtest: pipe-A-eDP-1
[394.754754] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.454s)
[394.764797] Starting dynamic subtest: pipe-D-eDP-1
[397.947804] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.192s)
[397.950102] Subtest 64x64-left-edge: SUCCESS (6.648s)
[398.823773] [115/133] (626s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[398.917428] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[398.919703] Starting dynamic subtest: pipe-A-eDP-1
[398.942484] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[398.953208] Starting dynamic subtest: pipe-B-eDP-1
[398.974776] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[398.983643] Starting dynamic subtest: pipe-C-eDP-1
[399.005170] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[399.013542] Starting dynamic subtest: pipe-D-eDP-1
[399.035608] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[399.039677] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[401.127845] [116/133] (624s left) gem_exec_schedule (fifo)
[401.196281] Starting subtest: fifo
[401.198142] Starting dynamic subtest: rcs0
[401.291300] Dynamic subtest rcs0: SUCCESS (0.105s)
[401.304167] Starting dynamic subtest: vcs0
[401.376099] Dynamic subtest vcs0: SUCCESS (0.083s)
[401.388639] Starting dynamic subtest: vcs1
[401.452800] Dynamic subtest vcs1: SUCCESS (0.076s)
[401.465093] Starting dynamic subtest: vecs0
[401.540043] Dynamic subtest vecs0: SUCCESS (0.086s)
[401.552899] Starting dynamic subtest: ccs0
[401.645545] Dynamic subtest ccs0: SUCCESS (0.104s)
[401.648636] Subtest fifo: SUCCESS (0.460s)
[403.000916] [117/133] (622s left) kms_psr (fbc-psr2-basic)
[403.101979] Starting subtest: fbc-psr2-basic
[403.104350] Starting dynamic subtest: eDP-1
[403.108489] Dynamic subtest eDP-1: SKIP (0.000s)
[403.112667] Subtest fbc-psr2-basic: SKIP (0.001s)
[403.213391] [118/133] (622s left) prime_mmap (test_forked)
[403.277518] Starting subtest: test_forked
[403.279480] Starting dynamic subtest: test_forked-smem
[403.311642] Dynamic subtest test_forked-smem: SUCCESS (0.036s)
[403.314083] Subtest test_forked: SUCCESS (0.038s)
[403.432099] [119/133] (622s left) i915_query (query-regions-garbage-items)
[403.500030] Starting subtest: query-regions-garbage-items
[403.502341] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[403.601378] [120/133] (622s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[403.703769] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[403.708189] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[403.795956] [121/133] (621s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[403.925222] Starting subtest: cursorA-vs-flipB-varying-size
[403.929555] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[404.083593] [122/133] (621s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[404.185241] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[404.188541] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[404.299074] [123/133] (621s left) gem_render_copy (linear-to-vebox-yf-tiled)
[404.360019] Starting subtest: linear-to-vebox-yf-tiled
[404.363923] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[404.544710] [124/133] (621s left) gem_ctx_isolation (nonpriv)
[404.623948] Starting subtest: nonpriv
[404.625833] Starting dynamic subtest: rcs0
[404.849801] Dynamic subtest rcs0: SUCCESS (0.228s)
[404.862605] Starting dynamic subtest: bcs0
[405.090861] Dynamic subtest bcs0: SUCCESS (0.240s)
[405.103176] Starting dynamic subtest: vcs0
[405.340604] Dynamic subtest vcs0: SUCCESS (0.249s)
[405.349585] Starting dynamic subtest: vcs1
[407.186480] Dynamic subtest vcs1: SUCCESS (1.845s)
[407.197634] Starting dynamic subtest: vecs0
[409.151158] Dynamic subtest vecs0: SUCCESS (1.964s)
[409.162735] Starting dynamic subtest: ccs0
[411.169988] Dynamic subtest ccs0: SUCCESS (2.018s)
[411.172510] Subtest nonpriv: SUCCESS (6.549s)
[411.413366] [125/133] (614s left) kms_psr (fbc-psr-primary-mmap-gtt)
[411.524262] Starting subtest: fbc-psr-primary-mmap-gtt
[411.526633] Starting dynamic subtest: eDP-1
[411.530849] Dynamic subtest eDP-1: SKIP (0.000s)
[411.535111] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[411.598813] [126/133] (614s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[411.681611] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[411.685640] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[411.782595] [127/133] (614s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[412.046961] Starting subtest: parallel-dmabuf-import-out-fence
[413.261845] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.218s)
[413.357342] [128/133] (612s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[413.447147] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[413.449406] Starting dynamic subtest: A-eDP1
[422.336124] Dynamic subtest A-eDP1: SUCCESS (8.888s)
[422.347818] Starting dynamic subtest: B-eDP1
[431.236225] Dynamic subtest B-eDP1: SUCCESS (8.899s)
[431.245575] Starting dynamic subtest: C-eDP1
[440.132908] Dynamic subtest C-eDP1: SUCCESS (8.895s)
[440.143081] Starting dynamic subtest: D-eDP1
[449.027873] Dynamic subtest D-eDP1: SUCCESS (8.893s)
[449.033688] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.586s)
[450.224356] [129/133] (575s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[450.319623] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[450.323667] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[450.427841] [130/133] (575s left) kms_plane (plane-position-covered)
[450.521045] Starting subtest: plane-position-covered
[451.024974] Starting dynamic subtest: pipe-A-plane-1
[452.294394] Dynamic subtest pipe-A-plane-1: SUCCESS (1.272s)
[452.303923] Starting dynamic subtest: pipe-A-plane-2
[453.561511] Dynamic subtest pipe-A-plane-2: SUCCESS (1.266s)
[453.571894] Starting dynamic subtest: pipe-A-plane-3
[454.856154] Dynamic subtest pipe-A-plane-3: SUCCESS (1.290s)
[454.866405] Starting dynamic subtest: pipe-A-plane-4
[456.150533] Dynamic subtest pipe-A-plane-4: SUCCESS (1.295s)
[456.161291] Starting dynamic subtest: pipe-A-plane-5
[456.176828] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[457.375578] Starting dynamic subtest: pipe-B-plane-1
[458.667076] Dynamic subtest pipe-B-plane-1: SUCCESS (1.303s)
[458.676664] Starting dynamic subtest: pipe-B-plane-2
[459.949284] Dynamic subtest pipe-B-plane-2: SUCCESS (1.278s)
[459.959429] Starting dynamic subtest: pipe-B-plane-3
[461.310965] Dynamic subtest pipe-B-plane-3: SUCCESS (1.361s)
[461.320370] Starting dynamic subtest: pipe-B-plane-4
[462.598287] Dynamic subtest pipe-B-plane-4: SUCCESS (1.286s)
[462.608314] Starting dynamic subtest: pipe-B-plane-5
[462.622385] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[462.624788] Subtest plane-position-covered: SUCCESS (12.101s)
[463.424640] [131/133] (562s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[463.543236] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[463.547563] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[463.686954] [132/133] (562s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[463.771286] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[463.773560] Starting dynamic subtest: pipe-A-eDP-1
[463.795234] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[463.807589] Starting dynamic subtest: pipe-B-eDP-1
[463.827147] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[463.835901] Starting dynamic subtest: pipe-C-eDP-1
[463.856251] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[463.865057] Starting dynamic subtest: pipe-D-eDP-1
[463.885820] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[463.889958] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[466.016422] [133/133] (560s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[466.111289] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[466.115163] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[466.203835] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_color_pipeline
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: perf_pmu
results: parsing output: 6/ for test: kms_plane_scaling
results: parsing output: 7/ for test: gem_basic
results: parsing output: 8/ for test: syncobj_basic
results: parsing output: 9/ for test: gen9_exec_parse
results: parsing output: 10/ for test: drm_buddy
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: gen9_exec_parse
results: parsing output: 13/ for test: gem_gtt_cpu_tlb
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: gem_ctx_shared
results: parsing output: 16/ for test: kms_chamelium_color
results: parsing output: 17/ for test: gem_pxp
results: parsing output: 18/ for test: kms_force_connector_basic
results: parsing output: 19/ for test: kms_chamelium_hpd
results: parsing output: 20/ for test: gem_render_copy
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: perf
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_chamelium_edid
results: parsing output: 26/ for test: kms_panel_fitting
results: parsing output: 27/ for test: api_intel_allocator
results: parsing output: 28/ for test: gem_exec_balancer
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: gem_exec_schedule
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_vblank
results: parsing output: 33/ for test: gem_lmem_swapping
results: parsing output: 34/ for test: gem_create
results: parsing output: 35/ for test: kms_async_flips
results: parsing output: 36/ for test: gem_userptr_blits
results: parsing output: 37/ for test: kms_pm_dc
results: parsing output: 38/ for test: prime_mmap
results: parsing output: 39/ for test: kms_invalid_mode
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: gem_eio
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: perf
results: parsing output: 44/ for test: tools_test
results: parsing output: 45/ for test: prime_mmap
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: sriov_basic
results: parsing output: 49/ for test: kms_sequence
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: gem_mmap_gtt
results: parsing output: 54/ for test: vgem_basic
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_flip_scaled_crc
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_psr2_sf
results: parsing output: 59/ for test: api_intel_bb
results: parsing output: 60/ for test: gem_exec_parallel
results: parsing output: 61/ for test: i915_pm_rpm
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: kms_prop_blob
results: parsing output: 65/ for test: kms_draw_crc
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_plane
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: gem_softpin
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_ctx_persistence
results: parsing output: 72/ for test: gem_exec_whisper
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_plane_lowres
results: parsing output: 76/ for test: gem_tiled_fence_blits
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: perf
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_async_flips
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_hdr
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_softpin
results: parsing output: 86/ for test: kms_cursor_crc
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: perf_pmu
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: gem_pipe_control_store_loop
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: perf
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: gem_softpin
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: gem_eio
results: parsing output: 98/ for test: kms_cursor_crc
results: parsing output: 99/ for test: kms_lease
results: parsing output: 100/ for test: gem_exec_reloc
results: parsing output: 101/ for test: kms_pipe_stress
results: parsing output: 102/ for test: kms_content_protection
results: parsing output: 103/ for test: gem_mmap_gtt
results: parsing output: 104/ for test: prime_self_import
results: parsing output: 105/ for test: fbdev
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: i915_hangman
results: parsing output: 108/ for test: kms_rotation_crc
results: parsing output: 109/ for test: gem_userptr_blits
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: gem_exec_fence
results: parsing output: 112/ for test: kms_psr2_sf
results: parsing output: 113/ for test: kms_cursor_edge_walk
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: gem_exec_schedule
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: prime_mmap
results: parsing output: 118/ for test: i915_query
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_render_copy
results: parsing output: 123/ for test: gem_ctx_isolation
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_exec_balancer
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_plane
results: parsing output: 130/ for test: kms_cursor_legacy
results: parsing output: 131/ for test: kms_ccs
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.