[57.289416] Initializing watchdogs
[57.289564]   /dev/watchdog0
[57.326085] [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.338734] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.345023] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.349983] [001/133] (960s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[57.477440] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[57.481374] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[57.545719] [002/133] (960s left) gem_render_copy (x-tiled)
[57.611307] Starting subtest: x-tiled
[57.613798] Starting dynamic subtest: smem
[57.662689] Dynamic subtest smem: SUCCESS (0.051s)
[57.665072] Subtest x-tiled: SUCCESS (0.052s)
[57.873067] [003/133] (960s left) syncobj_wait (wait-for-submit-complex)
[57.935794] Starting subtest: wait-for-submit-complex
[57.998404] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[58.082763] [004/133] (959s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[58.175431] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[81.469689] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (23.296s)
[81.589575] [005/133] (936s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[81.695847] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[81.699492] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[81.760320] [006/133] (936s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[81.808285] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[81.810319] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[81.899919] [007/133] (936s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[82.005676] Starting subtest: y-tiled-64bpp-rotate-270
[82.009413] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[82.118363] [008/133] (935s left) gem_exec_whisper (basic-contexts-forked)
[82.182492] Starting subtest: basic-contexts-forked
[106.415472] Subtest basic-contexts-forked: SUCCESS (24.227s)
[106.599609] [009/133] (911s left) gem_readwrite (read-bad-handle)
[106.654552] Subtest read-bad-handle: SKIP (0.000s)
[106.722812] [010/133] (911s left) kms_psr (psr-dpms)
[106.823032] Starting subtest: psr-dpms
[106.825433] Starting dynamic subtest: eDP-1
[109.813269] Dynamic subtest eDP-1: SUCCESS (2.990s)
[109.815601] Subtest psr-dpms: SUCCESS (2.991s)
[110.671089] [011/133] (907s left) prime_vgem (basic-gtt)
[110.843524] Starting subtest: basic-gtt
[110.848347] Subtest basic-gtt: SKIP (0.000s)
[110.967725] [FACT prime_vgem (basic-gtt)] new: kernel.kmod_is_loaded.vgem: true
[110.971289] [012/133] (907s left) gem_exec_fence (syncobj-import)
[111.387531] Starting subtest: syncobj-import
[111.393595] Subtest syncobj-import: SUCCESS (0.006s)
[112.991308] [013/133] (905s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[113.095984] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[113.100351] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[113.166031] [014/133] (905s left) kms_rotation_crc (cursor-rotation-180)
[113.271990] Starting subtest: cursor-rotation-180
[114.770758] Subtest cursor-rotation-180: SUCCESS (1.496s)
[115.940948] [015/133] (902s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[115.993678] Starting subtest: etime-single-wait-all-for-submit-submitted
[116.098672] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.103s)
[116.174562] [016/133] (902s left) gem_mmap_wc (write-gtt-read-wc)
[116.241720] Subtest write-gtt-read-wc: SKIP (0.000s)
[116.315176] [017/133] (902s left) gem_spin_batch (legacy)
[116.377230] Starting subtest: legacy
[116.379170] Starting dynamic subtest: default
[119.612259] Dynamic subtest default: SUCCESS (3.232s)
[119.621625] Starting dynamic subtest: render
[122.846946] Dynamic subtest render: SUCCESS (3.233s)
[122.857316] Starting dynamic subtest: bsd
[126.086794] Dynamic subtest bsd: SUCCESS (3.236s)
[126.097042] Starting dynamic subtest: bsd1
[129.320089] Dynamic subtest bsd1: SUCCESS (3.231s)
[129.330458] Starting dynamic subtest: bsd2
[132.553750] Dynamic subtest bsd2: SUCCESS (3.232s)
[132.564492] Starting dynamic subtest: blt
[135.793326] Dynamic subtest blt: SUCCESS (3.237s)
[135.808879] Starting dynamic subtest: vebox
[139.031592] Dynamic subtest vebox: SUCCESS (3.235s)
[139.033755] Subtest legacy: SUCCESS (22.652s)
[140.973535] [018/133] (877s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[141.031084] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[141.033320] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[141.158619] [019/133] (877s left) kms_psr (psr-cursor-plane-onoff)
[141.259569] Starting subtest: psr-cursor-plane-onoff
[141.261819] Starting dynamic subtest: eDP-1
[143.029052] Dynamic subtest eDP-1: SUCCESS (1.768s)
[143.031408] Subtest psr-cursor-plane-onoff: SUCCESS (1.769s)
[143.893385] [020/133] (874s left) i915_pm_freq_api (freq-suspend)
[143.967787] Starting subtest: freq-suspend
[143.970368] Starting dynamic subtest: gt0
[160.661709] Dynamic subtest gt0: SUCCESS (1.700s)
[160.678289] Starting dynamic subtest: gt1
[177.688472] Dynamic subtest gt1: SUCCESS (1.611s)
[177.690706] Subtest freq-suspend: SUCCESS (3.314s)
[188.776098] [021/133] (840s left) i915_query (hwconfig_table)
[188.845317] Starting subtest: hwconfig_table
[189.138564] Subtest hwconfig_table: SUCCESS (0.001s)
[189.178431] [022/133] (840s left) gem_exec_reloc (basic-gtt-read-noreloc)
[189.239484] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[189.318783] [023/133] (840s left) kms_big_fb (linear-8bpp-rotate-90)
[189.429294] Starting subtest: linear-8bpp-rotate-90
[189.449724] Subtest linear-8bpp-rotate-90: SKIP (0.020s)
[189.568897] [024/133] (840s left) kms_content_protection (suspend-resume)
[189.712541] Starting subtest: suspend-resume
[189.717290] Subtest suspend-resume: SKIP (0.000s)
[189.825218] [025/133] (840s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[189.920599] Starting subtest: basic-modeset-with-all-modifiers-formats
[190.301196] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[191.043821] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.741s)
[191.054016] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[191.065413] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[191.074071] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[191.087844] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[191.097447] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[191.243996] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[191.253699] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[191.266206] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s)
[191.276808] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[191.288085] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[191.297005] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[191.310783] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[191.320032] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[191.332857] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[191.344344] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[191.356072] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s)
[191.366212] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[191.377610] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.020s)
[191.390202] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[191.399919] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[191.411071] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[191.422105] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[191.431149] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[191.578116] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[191.588596] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[191.600278] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[191.609850] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[191.622309] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[191.631309] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[191.644579] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[191.653514] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[191.667106] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[191.675923] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[191.689361] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[191.698087] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[191.711805] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[191.720730] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[191.733908] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[191.742850] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[191.756163] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[191.765082] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[191.957127] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.200s)
[191.966530] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[191.979251] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.020s)
[191.990331] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[192.001537] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[192.011144] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[192.023772] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s)
[192.033404] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[192.045819] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[192.054854] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[192.068157] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[192.076400] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[192.090387] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[192.098793] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[192.112701] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[192.121230] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[192.134892] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[192.518048] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.592s)
[193.354697] [026/133] (836s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[193.451958] Starting subtest: bad-pixel-format-y-tiled-ccs
[193.454680] Starting dynamic subtest: pipe-A-eDP-1
[193.481005] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[193.491856] Starting dynamic subtest: pipe-B-eDP-1
[193.513802] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[193.522704] Starting dynamic subtest: pipe-C-eDP-1
[193.544493] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[193.553381] Starting dynamic subtest: pipe-D-eDP-1
[193.575364] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[193.579449] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.005s)
[195.716240] [027/133] (834s left) gem_mmap (bad-size)
[195.770056] Subtest bad-size: SKIP (0.000s)
[195.834829] [028/133] (834s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[195.949760] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[195.954080] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[196.069048] [029/133] (833s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[196.158194] Starting subtest: disable-crc-after-crtc
[196.160074] Starting dynamic subtest: pipe-A-eDP-1
[197.854917] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.693s)
[197.865705] Starting dynamic subtest: pipe-B-eDP-1
[200.138653] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.279s)
[200.148792] Starting dynamic subtest: pipe-C-eDP-1
[202.400899] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.262s)
[202.410977] Starting dynamic subtest: pipe-D-eDP-1
[204.650534] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.243s)
[204.652835] Subtest disable-crc-after-crtc: SUCCESS (8.482s)
[205.490665] [030/133] (824s left) kms_invalid_mode (clock-too-high)
[205.574264] Starting subtest: clock-too-high
[205.576584] Starting dynamic subtest: pipe-A-eDP-1
[205.581223] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[205.590609] Starting dynamic subtest: pipe-B-eDP-1
[205.594819] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[205.605053] Starting dynamic subtest: pipe-C-eDP-1
[205.609430] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[205.618384] Starting dynamic subtest: pipe-D-eDP-1
[205.622890] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[205.627447] Subtest clock-too-high: SKIP (0.004s)
[205.666417] [031/133] (824s left) syncobj_timeline (signal)
[205.738450] Starting subtest: signal
[205.740782] Subtest signal: SUCCESS (0.000s)
[205.853054] [032/133] (824s left) kms_hdr (bpc-switch)
[205.944673] Starting subtest: bpc-switch
[207.064868] Starting dynamic subtest: pipe-A-eDP-1
[210.465110] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.400s)
[210.467490] Subtest bpc-switch: SUCCESS (4.521s)
[210.578370] [033/133] (819s left) perf (gen12-group-concurrent-oa-buffer-read)
[210.707573] Starting subtest: gen12-group-concurrent-oa-buffer-read
[220.745333] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.034s)
[220.794720] [034/133] (809s left) gem_exec_reloc (basic-cpu-wc-active)
[220.867863] Subtest basic-cpu-wc-active: SKIP (0.000s)
[220.940362] [035/133] (809s left) kms_cursor_edge_walk (256x256-top-bottom)
[221.042704] Starting subtest: 256x256-top-bottom
[221.044995] Starting dynamic subtest: pipe-A-eDP-1
[224.507083] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.467s)
[224.517100] Starting dynamic subtest: pipe-D-eDP-1
[227.697979] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.190s)
[227.700253] Subtest 256x256-top-bottom: SUCCESS (6.660s)
[228.523016] [036/133] (801s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[228.643178] Starting subtest: cursorA-vs-flipB-varying-size
[228.647411] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[228.814345] [037/133] (801s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[228.877067] Starting subtest: etime-multi-wait-all-available-unsubmitted
[228.983975] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.106s)
[229.060510] [038/133] (801s left) gem_workarounds (basic-read-context)
[229.125634] Starting subtest: basic-read-context
[229.138095] Subtest basic-read-context: SUCCESS (0.011s)
[229.285061] [039/133] (801s left) kms_flip (flip-vs-rmfb)
[229.386010] Starting subtest: flip-vs-rmfb
[229.388396] Starting dynamic subtest: A-eDP1
[238.002168] Dynamic subtest A-eDP1: SUCCESS (8.620s)
[238.016501] Starting dynamic subtest: B-eDP1
[246.642421] Dynamic subtest B-eDP1: SUCCESS (8.638s)
[246.654983] Starting dynamic subtest: C-eDP1
[255.273713] Dynamic subtest C-eDP1: SUCCESS (8.625s)
[255.287123] Starting dynamic subtest: D-eDP1
[263.914509] Dynamic subtest D-eDP1: SUCCESS (8.637s)
[263.918855] Subtest flip-vs-rmfb: SUCCESS (34.535s)
[265.099200] [040/133] (765s left) gem_exec_suspend (basic-s3)
[265.151572] Starting subtest: basic-S3
[265.154073] Starting dynamic subtest: smem
[286.150816] Dynamic subtest smem: SUCCESS (7.113s)
[286.154036] Subtest basic-S3: SUCCESS (7.115s)
[290.356288] [041/133] (744s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[290.474766] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[290.477341] Starting dynamic subtest: pipe-A-eDP-1
[290.502116] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[290.511852] Starting dynamic subtest: pipe-B-eDP-1
[290.538692] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[290.547963] Starting dynamic subtest: pipe-C-eDP-1
[290.574504] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[290.583768] Starting dynamic subtest: pipe-D-eDP-1
[290.611428] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[290.616186] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[292.744719] [042/133] (741s left) gem_lmem_swapping (heavy-verify-multi)
[292.791643] Subtest heavy-verify-multi: SKIP (0.000s)
[292.846710] [043/133] (741s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[292.934321] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[292.938969] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[294.084185] [044/133] (740s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[294.198972] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[294.203757] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[294.294367] [045/133] (740s left) api_intel_bb (destroy-bb)
[294.345778] Starting subtest: destroy-bb
[294.357490] Subtest destroy-bb: SUCCESS (0.011s)
[294.472328] [046/133] (740s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[294.574467] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[294.579774] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[294.692902] [047/133] (740s left) kms_atomic_transition (modeset-transition)
[294.774635] Starting subtest: modeset-transition
[294.776759] Starting dynamic subtest: 1x-outputs
[305.674526] Dynamic subtest 1x-outputs: SUCCESS (10.891s)
[305.677215] Subtest modeset-transition: SUCCESS (10.893s)
[306.535364] [048/133] (728s left) gem_ctx_shared (q-smoketest-all)
[306.605853] Starting subtest: Q-smoketest-all
[339.019089] Subtest Q-smoketest-all: SUCCESS (32.347s)
[340.282984] [049/133] (694s left) gem_fence_thrash (bo-write-verify-none)
[340.323519] Starting subtest: bo-write-verify-none
[340.341075] Subtest bo-write-verify-none: SKIP (0.015s)
[340.410554] [050/133] (694s left) kms_cursor_crc (cursor-offscreen-128x128)
[340.618661] Starting subtest: cursor-offscreen-128x128
[340.624562] Starting dynamic subtest: pipe-A-eDP-1
[342.553753] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.930s)
[342.583519] Starting dynamic subtest: pipe-D-eDP-1
[345.128812] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.553s)
[345.131449] Subtest cursor-offscreen-128x128: SUCCESS (4.508s)
[345.987421] [051/133] (689s left) gem_exec_balancer (bonded-false-hang)
[346.246811] Starting subtest: bonded-false-hang
[346.252698] Subtest bonded-false-hang: SKIP (0.000s)
[346.350951] [052/133] (688s left) kms_big_fb (4-tiled-addfb-size-overflow)
[346.448660] Starting subtest: 4-tiled-addfb-size-overflow
[346.451302] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[346.556377] [053/133] (688s left) kms_psr (fbc-psr-primary-render)
[346.660789] Starting subtest: fbc-psr-primary-render
[346.663308] Starting dynamic subtest: eDP-1
[346.667825] Dynamic subtest eDP-1: SKIP (0.000s)
[346.671924] Subtest fbc-psr-primary-render: SKIP (0.001s)
[346.733704] [054/133] (688s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[346.823120] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[346.825369] Starting dynamic subtest: pipe-A-default-mode
[347.949435] Dynamic subtest pipe-A-default-mode: SKIP (1.123s)
[347.953742] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.125s)
[348.093205] [055/133] (687s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[348.202977] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[348.207817] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[348.299527] [056/133] (686s left) gem_fence_thrash (bo-write-verify-y)
[348.344659] Starting subtest: bo-write-verify-y
[348.366225] Subtest bo-write-verify-y: SKIP (0.023s)
[348.429964] [057/133] (686s left) perf_pmu (all-busy-check-all)
[348.473697] Starting subtest: all-busy-check-all
[350.214601] Subtest all-busy-check-all: SUCCESS (1.740s)
[350.320592] [058/133] (684s left) gem_exec_schedule (manyslice)
[350.402744] Starting subtest: manyslice
[350.405567] Starting dynamic subtest: rcs0
[356.039894] Dynamic subtest rcs0: SUCCESS (5.650s)
[356.050030] Starting dynamic subtest: bcs0
[362.684611] Dynamic subtest bcs0: SUCCESS (6.641s)
[362.696344] Starting dynamic subtest: vcs0
[368.790947] Dynamic subtest vcs0: SUCCESS (6.104s)
[368.802932] Starting dynamic subtest: vcs1
[375.922271] Dynamic subtest vcs1: SUCCESS (7.127s)
[375.938136] Starting dynamic subtest: vecs0
[381.523154] Dynamic subtest vecs0: SUCCESS (5.597s)
[381.540256] Starting dynamic subtest: ccs0
[388.228864] Dynamic subtest ccs0: SUCCESS (6.702s)
[388.231802] Subtest manyslice: SUCCESS (37.833s)
[388.548594] [059/133] (646s left) core_sysfs (read-all-entries)
[388.614588] Starting subtest: read-all-entries
[388.623805] Subtest read-all-entries: SUCCESS (0.011s)
[388.723051] [060/133] (646s left) kms_draw_crc (draw-method-mmap-cpu)
[388.830617] Starting subtest: draw-method-mmap-cpu
[388.833178] Starting dynamic subtest: xrgb8888-untiled
[389.051835] Dynamic subtest xrgb8888-untiled: SUCCESS (0.223s)
[389.061696] Starting dynamic subtest: rgb565-untiled
[389.262645] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[389.272085] Starting dynamic subtest: xrgb2101010-untiled
[389.485281] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[389.494563] Starting dynamic subtest: xbgr16161616f-untiled
[389.706848] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[389.716340] Starting dynamic subtest: xrgb8888-xtiled
[389.829254] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[389.838418] Starting dynamic subtest: rgb565-xtiled
[389.952048] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[389.961738] Starting dynamic subtest: xrgb2101010-xtiled
[390.085333] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s)
[390.094875] Starting dynamic subtest: xbgr16161616f-xtiled
[390.207444] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[390.216706] Starting dynamic subtest: xrgb8888-4tiled
[390.340194] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.132s)
[390.349005] Starting dynamic subtest: rgb565-4tiled
[390.474072] Dynamic subtest rgb565-4tiled: SUCCESS (0.132s)
[390.482992] Starting dynamic subtest: xrgb2101010-4tiled
[390.596086] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[390.605883] Starting dynamic subtest: xbgr16161616f-4tiled
[390.741158] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[390.743460] Subtest draw-method-mmap-cpu: SUCCESS (1.913s)
[390.836969] [061/133] (644s left) kms_sequence (queue-idle)
[390.925625] Starting subtest: queue-idle
[390.927579] Starting dynamic subtest: pipe-A-eDP-1
[392.719830] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.791s)
[392.730393] Starting dynamic subtest: pipe-B-eDP-1
[395.203094] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.484s)
[395.213914] Starting dynamic subtest: pipe-C-eDP-1
[397.693281] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.489s)
[397.705855] Starting dynamic subtest: pipe-D-eDP-1
[400.138620] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.444s)
[400.141381] Subtest queue-idle: SUCCESS (9.214s)
[400.952447] [062/133] (634s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[401.044809] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[401.047440] Starting dynamic subtest: pipe-A
[401.396554] Dynamic subtest pipe-A: SUCCESS (0.353s)
[401.406522] Starting dynamic subtest: pipe-B
[402.873519] Dynamic subtest pipe-B: SUCCESS (1.477s)
[402.882823] Starting dynamic subtest: pipe-C
[404.307582] Dynamic subtest pipe-C: SUCCESS (1.433s)
[404.317402] Starting dynamic subtest: pipe-D
[405.714267] Dynamic subtest pipe-D: SUCCESS (1.406s)
[405.717596] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.673s)
[406.886928] [063/133] (628s left) i915_drm_fdinfo (basics)
[406.934860] Starting subtest: basics
[406.937861] Subtest basics: SUCCESS (0.000s)
[407.008236] [064/133] (628s left) gem_ringfill (legacy-basic)
[413.194819] Starting subtest: legacy-basic
[413.197769] Starting dynamic subtest: default
[413.251116] Dynamic subtest default: SUCCESS (0.055s)
[413.263891] Starting dynamic subtest: render
[413.291516] Dynamic subtest render: SUCCESS (0.039s)
[413.301870] Starting dynamic subtest: bsd
[413.336315] Dynamic subtest bsd: SUCCESS (0.043s)
[413.347692] Starting dynamic subtest: bsd1
[413.381271] Dynamic subtest bsd1: SUCCESS (0.043s)
[413.394677] Starting dynamic subtest: bsd2
[413.421699] Dynamic subtest bsd2: SUCCESS (0.038s)
[413.433705] Starting dynamic subtest: blt
[413.468952] Dynamic subtest blt: SUCCESS (0.045s)
[413.480644] Starting dynamic subtest: vebox
[413.514426] Dynamic subtest vebox: SUCCESS (0.044s)
[413.517131] Subtest legacy-basic: SUCCESS (0.321s)
[413.599695] [065/133] (622s left) sysfs_timeslice_duration (invalid)
[413.663159] Starting subtest: invalid
[413.665478] Starting dynamic subtest: vecs0
[413.667884] Dynamic subtest vecs0: SUCCESS (0.000s)
[413.677842] Starting dynamic subtest: ccs0
[413.680067] Dynamic subtest ccs0: SUCCESS (0.000s)
[413.689026] Starting dynamic subtest: vcs0
[413.691238] Dynamic subtest vcs0: SUCCESS (0.000s)
[413.700410] Starting dynamic subtest: bcs0
[413.702642] Dynamic subtest bcs0: SUCCESS (0.000s)
[413.711651] Starting dynamic subtest: rcs0
[413.713982] Dynamic subtest rcs0: SUCCESS (0.000s)
[413.722870] Starting dynamic subtest: vcs1
[413.725701] Dynamic subtest vcs1: SUCCESS (0.000s)
[413.728399] Subtest invalid: SUCCESS (0.006s)
[413.771378] [066/133] (621s left) gem_exec_params (larger-than-life-batch)
[413.841585] Starting subtest: larger-than-life-batch
[416.258681] Subtest larger-than-life-batch: SUCCESS (2.420s)
[417.226433] [067/133] (618s left) gem_exec_reloc (basic-write-cpu)
[417.335706] Subtest basic-write-cpu: SKIP (0.000s)
[417.395360] [068/133] (618s left) sriov_basic (enable-vfs-autoprobe-on)
[417.447524] Starting subtest: enable-vfs-autoprobe-on
[417.450072] Starting dynamic subtest: numvfs-1
[417.545311] Dynamic subtest numvfs-1: FAIL (0.034s)
[417.555861] Starting dynamic subtest: numvfs-2
[417.640420] Dynamic subtest numvfs-2: FAIL (0.006s)
[417.651396] Starting dynamic subtest: numvfs-3
[417.736858] Dynamic subtest numvfs-3: FAIL (0.006s)
[417.747718] Starting dynamic subtest: numvfs-4
[417.833633] Dynamic subtest numvfs-4: FAIL (0.008s)
[417.843989] Starting dynamic subtest: numvfs-5
[417.929716] Dynamic subtest numvfs-5: FAIL (0.004s)
[417.940369] Starting dynamic subtest: numvfs-6
[418.021577] Dynamic subtest numvfs-6: FAIL (0.003s)
[418.031591] Starting dynamic subtest: numvfs-7
[418.103828] Dynamic subtest numvfs-7: FAIL (0.004s)
[418.113779] Starting dynamic subtest: numvfs-random
[418.185655] Dynamic subtest numvfs-random: FAIL (0.004s)
[418.196054] Starting dynamic subtest: numvfs-all
[418.265706] Dynamic subtest numvfs-all: FAIL (0.006s)
[418.268188] Subtest enable-vfs-autoprobe-on: FAIL (0.086s)
[418.313199] [069/133] (617s left) gem_eio (banned)
[418.546716] Starting subtest: banned
[419.186493] Subtest banned: SUCCESS (0.641s)
[419.341147] [070/133] (616s left) kms_pm_rpm (basic-pci-d3-state)
[421.391250] Starting subtest: basic-pci-d3-state
[422.877595] Subtest basic-pci-d3-state: SUCCESS (1.489s)
[422.968120] [071/133] (612s left) gem_ccs (ctrl-surf-copy)
[423.029559] Starting subtest: ctrl-surf-copy
[423.035088] Subtest ctrl-surf-copy: SKIP (0.000s)
[423.133289] [072/133] (612s left) prime_mmap (test_reprime)
[423.187602] Starting subtest: test_reprime
[423.189955] Starting dynamic subtest: test_reprime-smem
[423.217023] Dynamic subtest test_reprime-smem: SUCCESS (0.031s)
[423.219567] Subtest test_reprime: SUCCESS (0.032s)
[423.321917] [073/133] (612s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[423.442044] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[424.389520] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.948s)
[424.527934] [074/133] (611s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[424.622623] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[424.627580] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[424.731425] [075/133] (611s left) gem_tiled_wc
[424.868544] [076/133] (611s left) gem_wait (wait)
[424.944477] Starting subtest: wait
[424.947209] Starting dynamic subtest: all-engines
[426.182197] Dynamic subtest all-engines: SUCCESS (1.236s)
[426.197807] Starting dynamic subtest: rcs0
[427.234642] Dynamic subtest rcs0: SUCCESS (1.050s)
[427.250653] Starting dynamic subtest: bcs0
[428.287696] Dynamic subtest bcs0: SUCCESS (1.050s)
[428.303772] Starting dynamic subtest: vcs0
[429.336848] Dynamic subtest vcs0: SUCCESS (1.046s)
[429.350663] Starting dynamic subtest: vcs1
[430.386766] Dynamic subtest vcs1: SUCCESS (1.047s)
[430.401074] Starting dynamic subtest: vecs0
[431.437234] Dynamic subtest vecs0: SUCCESS (1.048s)
[431.450473] Starting dynamic subtest: ccs0
[432.489198] Dynamic subtest ccs0: SUCCESS (1.050s)
[432.492228] Subtest wait: SUCCESS (7.545s)
[432.704148] [077/133] (603s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[432.825240] Starting subtest: flip-vs-cursor-varying-size
[441.586864] Subtest flip-vs-cursor-varying-size: SUCCESS (8.760s)
[442.467086] [078/133] (593s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[442.555618] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[442.560838] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[442.663981] [079/133] (593s left) perf_pmu (multi-client)
[442.703256] Starting subtest: multi-client
[442.705997] Starting dynamic subtest: rcs0
[443.750633] Dynamic subtest rcs0: SUCCESS (1.049s)
[443.762605] Starting dynamic subtest: bcs0
[444.801841] Dynamic subtest bcs0: SUCCESS (1.048s)
[444.814673] Starting dynamic subtest: vcs0
[445.855717] Dynamic subtest vcs0: SUCCESS (1.049s)
[445.867697] Starting dynamic subtest: vcs1
[447.230004] Dynamic subtest vcs1: SUCCESS (1.372s)
[447.242094] Starting dynamic subtest: vecs0
[449.213594] Dynamic subtest vecs0: SUCCESS (1.982s)
[449.225163] Starting dynamic subtest: ccs0
[451.197844] Dynamic subtest ccs0: SUCCESS (1.982s)
[451.200545] Subtest multi-client: SUCCESS (8.498s)
[451.316619] [080/133] (584s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[451.421457] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[451.429478] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[451.520515] [081/133] (584s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[451.625457] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[459.105207] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.482s)
[459.231620] [082/133] (577s left) kms_psr (pr-sprite-blt)
[459.328581] Starting subtest: pr-sprite-blt
[459.333347] Subtest pr-sprite-blt: SKIP (0.000s)
[459.402005] [083/133] (577s left) kms_prime (basic-modeset-hybrid)
[459.493588] Subtest basic-modeset-hybrid: SKIP (0.000s)
[459.594153] [084/133] (576s left) gem_eio (in-flight-internal-1us)
[459.772032] Starting subtest: in-flight-internal-1us
[461.251832] Subtest in-flight-internal-1us: SUCCESS (1.479s)
[461.393053] [085/133] (575s left) gem_exec_create (legacy)
[461.455286] Starting subtest: legacy
[461.457671] Starting dynamic subtest: smem
[465.158878] Dynamic subtest smem: SUCCESS (3.701s)
[465.161842] Subtest legacy: SUCCESS (3.703s)
[465.344677] [086/133] (571s left) syncobj_basic (bad-create-flags)
[465.405840] Starting subtest: bad-create-flags
[465.408517] Subtest bad-create-flags: SUCCESS (0.000s)
[465.512926] [087/133] (571s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[465.606354] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[465.610841] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[465.678149] [088/133] (570s left) kms_psr (fbc-psr2-primary-page-flip)
[465.769253] Starting subtest: fbc-psr2-primary-page-flip
[465.771660] Starting dynamic subtest: eDP-1
[465.776600] Dynamic subtest eDP-1: SKIP (0.000s)
[465.780985] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[465.843618] [089/133] (570s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[465.935562] Starting subtest: psr-rgb565-draw-mmap-wc
[472.800589] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.867s)
[472.914659] [090/133] (563s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[473.008235] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[473.010685] Starting dynamic subtest: pipe-A
[473.343774] Dynamic subtest pipe-A: SUCCESS (0.338s)
[473.353686] Starting dynamic subtest: pipe-B
[474.787097] Dynamic subtest pipe-B: SUCCESS (1.442s)
[474.797836] Starting dynamic subtest: pipe-C
[476.204644] Dynamic subtest pipe-C: SUCCESS (1.416s)
[476.214689] Starting dynamic subtest: pipe-D
[477.646370] Dynamic subtest pipe-D: SUCCESS (1.441s)
[477.648863] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.640s)
[478.822063] [091/133] (557s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[478.915861] Starting subtest: fbcpsr-2p-rte
[478.920628] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[479.026904] [092/133] (557s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[479.113887] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[479.116265] Starting dynamic subtest: pipe-A-eDP-1
[479.984765] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.865s)
[479.994561] Starting dynamic subtest: pipe-B-eDP-1
[481.523700] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.534s)
[481.534148] Starting dynamic subtest: pipe-C-eDP-1
[483.028544] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.503s)
[483.038756] Starting dynamic subtest: pipe-D-eDP-1
[484.650262] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.620s)
[484.652468] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.527s)
[485.851770] [093/133] (551s left) gem_exec_reloc (basic-write-read-noreloc)
[485.908124] Subtest basic-write-read-noreloc: SKIP (0.000s)
[485.975932] [094/133] (550s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[486.076549] Starting subtest: psr-2p-primscrn-spr-indfb-move
[486.081135] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[486.171151] [095/133] (550s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[486.238712] Starting subtest: multi-wait-all-for-submit-signaled
[486.241667] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[486.375865] [096/133] (550s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[486.487344] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[493.158050] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.672s)
[493.288405] [097/133] (543s left) kms_flip (flip-vs-fences-interruptible)
[493.379510] Starting subtest: flip-vs-fences-interruptible
[493.384447] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[493.476478] [098/133] (543s left) gem_pwrite (basic-self)
[493.536428] Subtest basic-self: SKIP (0.000s)
[493.600241] [099/133] (543s left) api_intel_bb (blit-noreloc-keep-cache)
[493.655560] Starting subtest: blit-noreloc-keep-cache
[493.666319] Subtest blit-noreloc-keep-cache: SUCCESS (0.012s)
[493.783856] [100/133] (543s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[493.869464] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[493.874455] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[493.945454] [101/133] (543s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[494.047589] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[498.592243] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.549s)
[499.782598] [102/133] (537s left) kms_chamelium_color (ctm-0-25)
[499.895987] Subtest ctm-0-25: SKIP (0.000s)
[499.941619] [103/133] (537s left) gem_create (create-ext-placement-sanity-check)
[500.114114] Starting subtest: create-ext-placement-sanity-check
[500.116713] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[500.207100] [104/133] (537s left) kms_vblank (ts-continuation-idle-hang)
[500.296551] Starting subtest: ts-continuation-idle-hang
[500.298866] Starting dynamic subtest: pipe-A-eDP-1
[526.917685] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.616s)
[526.934284] Starting dynamic subtest: pipe-D-eDP-1
[551.944649] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.022s)
[551.947109] Subtest ts-continuation-idle-hang: SUCCESS (51.642s)
[552.742129] [105/133] (484s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[552.852589] Starting subtest: short-busy-flip-before-cursor-toggle
[552.856977] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[553.009764] [106/133] (484s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[553.106771] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[553.109249] Starting dynamic subtest: pipe-A-eDP-1
[559.039881] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.934s)
[559.050705] Starting dynamic subtest: pipe-B-eDP-1
[565.697499] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.656s)
[565.700192] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.592s)
[566.586585] [107/133] (470s left) syncobj_wait (wait-delayed-signal)
[566.639624] Starting subtest: wait-delayed-signal
[566.739873] Subtest wait-delayed-signal: SUCCESS (0.102s)
[566.820701] [108/133] (470s left) kms_cursor_crc (cursor-random-256x256)
[567.074268] Starting subtest: cursor-random-256x256
[567.079966] Starting dynamic subtest: pipe-A-eDP-1
[570.423578] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.342s)
[570.451431] Starting dynamic subtest: pipe-D-eDP-1
[574.550404] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.108s)
[574.552838] Subtest cursor-random-256x256: SUCCESS (7.475s)
[575.355833] [109/133] (462s left) kms_flip (2x-modeset-vs-vblank-race)
[575.444144] Starting subtest: 2x-modeset-vs-vblank-race
[575.452709] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[575.539396] [110/133] (462s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[575.679184] Starting subtest: basic-flip-before-cursor-varying-size
[576.603248] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.924s)
[577.496623] [111/133] (460s left) kms_flip (2x-flip-vs-dpms)
[577.590811] Starting subtest: 2x-flip-vs-dpms
[577.599501] Subtest 2x-flip-vs-dpms: SKIP (0.010s)
[577.683248] [112/133] (460s left) gem_render_copy_redux (interruptible)
[577.741321] Starting subtest: interruptible
[578.062615] Subtest interruptible: SUCCESS (0.322s)
[578.152928] [113/133] (459s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[578.250989] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[578.255777] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[578.344916] [114/133] (459s left) kms_color (ctm-negative)
[578.436601] Starting subtest: ctm-negative
[578.438667] Starting dynamic subtest: pipe-A-eDP-1
[579.146831] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s)
[579.157876] Starting dynamic subtest: pipe-B-eDP-1
[580.597576] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.452s)
[580.608815] Starting dynamic subtest: pipe-C-eDP-1
[581.970567] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.370s)
[581.984820] Starting dynamic subtest: pipe-D-eDP-1
[583.305692] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.336s)
[583.308704] Subtest ctm-negative: SUCCESS (4.869s)
[584.127323] [115/133] (453s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[584.235412] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[591.051852] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.819s)
[591.176316] [116/133] (446s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[591.273233] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[591.278511] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[591.373509] [117/133] (446s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[591.438665] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[591.502660] [118/133] (446s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[591.603624] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[591.608623] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[591.711077] [119/133] (446s left) gem_ctx_persistence (engines-hostile-preempt)
[591.779654] Starting subtest: engines-hostile-preempt
[591.782337] Starting dynamic subtest: rcs0
[591.849174] Dynamic subtest rcs0: SUCCESS (0.072s)
[591.862096] Starting dynamic subtest: bcs0
[591.890007] Dynamic subtest bcs0: SUCCESS (0.039s)
[591.903262] Starting dynamic subtest: vcs0
[593.153724] Dynamic subtest vcs0: SUCCESS (1.259s)
[593.167268] Starting dynamic subtest: vcs1
[595.165359] Dynamic subtest vcs1: SUCCESS (1.995s)
[595.179275] Starting dynamic subtest: vecs0
[597.100737] Dynamic subtest vecs0: SUCCESS (1.944s)
[597.113592] Starting dynamic subtest: ccs0
[597.165595] Dynamic subtest ccs0: SUCCESS (0.064s)
[597.168263] Subtest engines-hostile-preempt: SUCCESS (5.389s)
[597.306182] [120/133] (440s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[597.408984] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[597.413017] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[597.494608] [121/133] (440s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[597.882537] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[598.727593] [122/133] (439s left) gem_render_copy (yf-tiled-ccs-to-linear)
[598.780846] Starting subtest: yf-tiled-ccs-to-linear
[598.786472] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[598.964279] [123/133] (439s left) kms_lease (simple-lease)
[599.053040] Starting subtest: simple-lease
[599.055561] Starting dynamic subtest: pipe-A-eDP-1
[599.558611] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.504s)
[599.569700] Starting dynamic subtest: pipe-B-eDP-1
[600.987746] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.427s)
[600.998688] Starting dynamic subtest: pipe-C-eDP-1
[602.382552] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.395s)
[602.394249] Starting dynamic subtest: pipe-D-eDP-1
[603.779393] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.392s)
[603.781662] Subtest simple-lease: SUCCESS (4.726s)
[604.587890] [124/133] (433s left) gem_mmap_gtt (basic-read-write)
[604.644661] Subtest basic-read-write: SKIP (0.000s)
[604.701594] [125/133] (433s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[604.801324] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[609.235003] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.437s)
[610.423552] [126/133] (427s left) gem_ctx_persistence (heartbeat-close)
[610.478525] Starting subtest: heartbeat-close
[610.483728] Subtest heartbeat-close: SKIP (0.000s)
[610.583503] [127/133] (427s left) i915_pm_rpm (sysfs-read)
[612.320484] Starting subtest: sysfs-read
[613.474159] Subtest sysfs-read: SUCCESS (1.155s)
[613.863444] [128/133] (424s left) gem_mmap_gtt (fault-concurrent-y)
[613.919650] Subtest fault-concurrent-Y: SKIP (0.000s)
[613.989145] [129/133] (424s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[614.370045] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[615.153947] [130/133] (423s left) kms_flip (nonexisting-fb)
[615.248462] Starting subtest: nonexisting-fb
[615.250856] Starting dynamic subtest: A-eDP1
[616.458725] Dynamic subtest A-eDP1: SUCCESS (1.213s)
[616.469898] Starting dynamic subtest: B-eDP1
[617.583833] Dynamic subtest B-eDP1: SUCCESS (1.124s)
[617.594590] Starting dynamic subtest: C-eDP1
[618.724693] Dynamic subtest C-eDP1: SUCCESS (1.139s)
[618.737864] Starting dynamic subtest: D-eDP1
[619.858104] Dynamic subtest D-eDP1: SUCCESS (1.131s)
[619.863307] Subtest nonexisting-fb: SUCCESS (4.618s)
[621.034864] [131/133] (417s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[621.128235] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[627.695693] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.569s)
[627.822492] [132/133] (410s left) gen7_exec_parse (chained-batch)
[627.889583] Subtest chained-batch: SKIP (0.000s)
[627.956240] [133/133] (410s left) gem_exec_schedule (thriceslice)
[628.023727] Starting subtest: thriceslice
[628.026609] Starting dynamic subtest: rcs0
[628.041610] Dynamic subtest rcs0: SUCCESS (0.031s)
[628.055027] Starting dynamic subtest: bcs0
[628.094995] Dynamic subtest bcs0: SUCCESS (0.052s)
[628.108385] Starting dynamic subtest: vcs0
[628.148144] Dynamic subtest vcs0: SUCCESS (0.051s)
[628.164716] Starting dynamic subtest: vcs1
[628.204354] Dynamic subtest vcs1: SUCCESS (0.053s)
[628.218775] Starting dynamic subtest: vecs0
[628.235872] Dynamic subtest vecs0: SUCCESS (0.029s)
[628.245843] Starting dynamic subtest: ccs0
[628.290283] Dynamic subtest ccs0: SUCCESS (0.053s)
[628.293139] Subtest thriceslice: SUCCESS (0.281s)
[629.228800] Closing watchdogs
results: parsing output: 0/ for test: kms_flip_scaled_crc
results: parsing output: 1/ for test: gem_render_copy
results: parsing output: 2/ for test: syncobj_wait
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_psr2_sf
results: parsing output: 5/ for test: syncobj_wait
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: gem_exec_whisper
results: parsing output: 8/ for test: gem_readwrite
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: prime_vgem
results: parsing output: 11/ for test: gem_exec_fence
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: kms_rotation_crc
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: gem_mmap_wc
results: parsing output: 16/ for test: gem_spin_batch
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: i915_pm_freq_api
results: parsing output: 20/ for test: i915_query
results: parsing output: 21/ for test: gem_exec_reloc
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_content_protection
results: parsing output: 24/ for test: kms_async_flips
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: gem_mmap
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_pipe_crc_basic
results: parsing output: 29/ for test: kms_invalid_mode
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: kms_hdr
results: parsing output: 32/ for test: perf
results: parsing output: 33/ for test: gem_exec_reloc
results: parsing output: 34/ for test: kms_cursor_edge_walk
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: gem_workarounds
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: gem_exec_suspend
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: gem_lmem_swapping
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: api_intel_bb
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_atomic_transition
results: parsing output: 47/ for test: gem_ctx_shared
results: parsing output: 48/ for test: gem_fence_thrash
results: parsing output: 49/ for test: kms_cursor_crc
results: parsing output: 50/ for test: gem_exec_balancer
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_flip_scaled_crc
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: gem_fence_thrash
results: parsing output: 56/ for test: perf_pmu
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: core_sysfs
results: parsing output: 59/ for test: kms_draw_crc
results: parsing output: 60/ for test: kms_sequence
results: parsing output: 61/ for test: kms_plane_scaling
results: parsing output: 62/ for test: i915_drm_fdinfo
results: parsing output: 63/ for test: gem_ringfill
results: parsing output: 64/ for test: sysfs_timeslice_duration
results: parsing output: 65/ for test: gem_exec_params
results: parsing output: 66/ for test: gem_exec_reloc
results: parsing output: 67/ for test: sriov_basic
results: parsing output: 68/ for test: gem_eio
results: parsing output: 69/ for test: kms_pm_rpm
results: parsing output: 70/ for test: gem_ccs
results: parsing output: 71/ for test: prime_mmap
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_tiled_wc
results: parsing output: 75/ for test: gem_wait
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: perf_pmu
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: kms_prime
results: parsing output: 83/ for test: gem_eio
results: parsing output: 84/ for test: gem_exec_create
results: parsing output: 85/ for test: syncobj_basic
results: parsing output: 86/ for test: kms_flip_scaled_crc
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_plane_scaling
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: gem_exec_reloc
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: gem_pwrite
results: parsing output: 98/ for test: api_intel_bb
results: parsing output: 99/ for test: kms_plane
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_chamelium_color
results: parsing output: 102/ for test: gem_create
results: parsing output: 103/ for test: kms_vblank
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: kms_psr2_sf
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: kms_cursor_crc
results: parsing output: 108/ for test: kms_flip
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: gem_render_copy_redux
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_color
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_pipe_b_c_ivb
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_ctx_persistence
results: parsing output: 119/ for test: kms_psr2_sf
results: parsing output: 120/ for test: kms_chamelium_edid
results: parsing output: 121/ for test: gem_render_copy
results: parsing output: 122/ for test: kms_lease
results: parsing output: 123/ for test: gem_mmap_gtt
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_ctx_persistence
results: parsing output: 126/ for test: i915_pm_rpm
results: parsing output: 127/ for test: gem_mmap_gtt
results: parsing output: 128/ for test: kms_chamelium_hpd
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gen7_exec_parse
results: parsing output: 132/ for test: gem_exec_schedule
Done.