[60.316067] Initializing watchdogs
[60.316213]   /dev/watchdog0
[60.333112] [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.337621] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.340068] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.343264] [001/133] (960s left) gem_workarounds (suspend-resume-context)
[60.442144] Starting subtest: suspend-resume-context
[78.885060] Subtest suspend-resume-context: SUCCESS (4.352s)
[87.037025] [002/133] (941s left) api_intel_bb (crc32)
[87.105344] Starting subtest: crc32
[87.107770] Starting dynamic subtest: rcs0-smem0
[87.402439] Dynamic subtest rcs0-smem0: SUCCESS (0.295s)
[87.413480] Starting dynamic subtest: bcs0-smem0
[87.732258] Dynamic subtest bcs0-smem0: SUCCESS (0.329s)
[87.746012] Starting dynamic subtest: vcs0-smem0
[88.127970] Dynamic subtest vcs0-smem0: SUCCESS (0.393s)
[88.143396] Starting dynamic subtest: vcs1-smem0
[88.468698] Dynamic subtest vcs1-smem0: SUCCESS (0.342s)
[88.480737] Starting dynamic subtest: vecs0-smem0
[88.802687] Dynamic subtest vecs0-smem0: SUCCESS (0.331s)
[88.815705] Starting dynamic subtest: ccs0-smem0
[89.148120] Dynamic subtest ccs0-smem0: SUCCESS (0.344s)
[89.150865] Subtest crc32: SUCCESS (2.043s)
[89.273906] [003/133] (939s left) kms_psr (psr-sprite-plane-move)
[89.370942] Starting subtest: psr-sprite-plane-move
[89.373196] Starting dynamic subtest: eDP-1
[91.170183] Dynamic subtest eDP-1: SUCCESS (1.798s)
[91.172594] Subtest psr-sprite-plane-move: SUCCESS (1.799s)
[91.997295] [004/133] (936s left) kms_display_modes (extended-mode-basic)
[92.096124] Starting subtest: extended-mode-basic
[92.100800] Subtest extended-mode-basic: SKIP (0.000s)
[92.138619] [005/133] (936s left) kms_plane_alpha_blend (constant-alpha-mid)
[92.237310] Starting subtest: constant-alpha-mid
[92.536552] Starting dynamic subtest: pipe-A-eDP-1
[93.455448] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.918s)
[93.469509] Starting dynamic subtest: pipe-D-eDP-1
[95.024330] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.566s)
[95.026877] Subtest constant-alpha-mid: SUCCESS (2.786s)
[95.859864] [006/133] (933s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[95.954919] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[95.957246] Starting dynamic subtest: pipe-A-eDP-1
[107.259272] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.305s)
[107.268919] Starting dynamic subtest: pipe-B-eDP-1
[119.286778] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.025s)
[119.289240] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.333s)
[120.121582] [007/133] (908s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[120.231501] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[120.235748] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[120.355457] [008/133] (908s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[120.463729] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[120.466164] Starting dynamic subtest: A-eDP1
[124.072873] Dynamic subtest A-eDP1: SUCCESS (3.608s)
[124.083148] Starting dynamic subtest: B-eDP1
[127.289514] Dynamic subtest B-eDP1: SUCCESS (3.216s)
[127.299537] Starting dynamic subtest: C-eDP1
[130.407318] Dynamic subtest C-eDP1: SUCCESS (3.117s)
[130.416929] Starting dynamic subtest: D-eDP1
[133.506564] Dynamic subtest D-eDP1: SUCCESS (3.101s)
[133.508798] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.050s)
[134.310220] [009/133] (894s left) i915_drm_fdinfo (busy-hang)
[134.353235] Starting subtest: busy-hang
[134.355463] Starting dynamic subtest: rcs0
[134.380459] Dynamic subtest rcs0: SKIP (0.026s)
[134.389926] Starting dynamic subtest: bcs0
[134.394015] Dynamic subtest bcs0: SKIP (0.001s)
[134.402225] Starting dynamic subtest: vcs0
[134.405983] Dynamic subtest vcs0: SKIP (0.000s)
[134.414126] Starting dynamic subtest: vcs1
[134.418395] Dynamic subtest vcs1: SKIP (0.001s)
[134.428071] Starting dynamic subtest: vecs0
[134.432298] Dynamic subtest vecs0: SKIP (0.000s)
[134.442363] Starting dynamic subtest: ccs0
[134.446601] Dynamic subtest ccs0: SKIP (0.000s)
[134.450877] Subtest busy-hang: SKIP (0.030s)
[134.485337] [010/133] (894s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[134.605387] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[134.610022] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[134.709333] [011/133] (894s left) kms_addfb_basic (unused-modifier)
[134.770154] Starting subtest: unused-modifier
[134.772405] Subtest unused-modifier: SUCCESS (0.000s)
[134.917037] [012/133] (894s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[135.014001] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[135.018020] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[135.115574] [013/133] (894s left) gem_softpin (allocator-fork)
[135.181240] Starting subtest: allocator-fork
[137.392267] Subtest allocator-fork: SUCCESS (2.210s)
[137.527618] [014/133] (891s left) gem_exec_params (invalid-ring)
[137.597068] Starting subtest: invalid-ring
[137.599144] Subtest invalid-ring: SUCCESS (0.000s)
[137.695354] [015/133] (891s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[137.803764] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[144.447055] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.649s)
[144.557602] [016/133] (884s left) gem_exec_balancer (persistence)
[144.827689] Starting subtest: persistence
[145.737410] Subtest persistence: SUCCESS (0.911s)
[145.843886] [017/133] (883s left) gem_exec_reloc (basic-cpu-wc-active)
[145.906968] Subtest basic-cpu-wc-active: SKIP (0.000s)
[145.969100] [018/133] (883s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[146.058434] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[146.062747] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[146.155236] [019/133] (883s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[146.248237] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[146.252765] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[146.317750] [020/133] (883s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[146.417188] Starting subtest: yf-tiled-8bpp-rotate-90
[146.421550] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[146.510667] [021/133] (883s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[146.571336] Starting subtest: multi-wait-all-for-submit-available-submitted
[146.573775] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[146.660713] [022/133] (883s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[146.769350] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[146.772563] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[146.865119] [023/133] (882s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[146.965231] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[146.968691] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[147.080351] [024/133] (882s left) gem_media_vme
[147.209062] [025/133] (882s left) kms_invalid_mode (clock-too-high)
[147.298765] Starting subtest: clock-too-high
[147.300829] Starting dynamic subtest: pipe-A-eDP-1
[147.304614] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[147.312869] Starting dynamic subtest: pipe-B-eDP-1
[147.316542] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[147.324256] Starting dynamic subtest: pipe-C-eDP-1
[147.327989] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[147.337297] Starting dynamic subtest: pipe-D-eDP-1
[147.340646] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[147.343884] Subtest clock-too-high: SKIP (0.003s)
[147.377386] [026/133] (882s left) kms_psr (fbc-psr2-primary-blt)
[147.471024] Starting subtest: fbc-psr2-primary-blt
[147.472878] Starting dynamic subtest: eDP-1
[147.476240] Dynamic subtest eDP-1: SKIP (0.000s)
[147.479878] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[147.541148] [027/133] (882s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[147.631163] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[147.633170] Starting dynamic subtest: pipe-A
[147.651753] Dynamic subtest pipe-A: SKIP (0.018s)
[147.663583] Starting dynamic subtest: pipe-B
[147.685515] Dynamic subtest pipe-B: SKIP (0.033s)
[147.693572] Starting dynamic subtest: pipe-C
[147.720757] Dynamic subtest pipe-C: SKIP (0.034s)
[147.728732] Starting dynamic subtest: pipe-D
[147.759559] Dynamic subtest pipe-D: SKIP (0.039s)
[147.762609] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.125s)
[147.845767] [028/133] (882s left) gem_exec_schedule (out-order)
[147.914534] Starting subtest: out-order
[147.916546] Starting dynamic subtest: rcs0
[148.013549] Dynamic subtest rcs0: SUCCESS (0.104s)
[148.024555] Starting dynamic subtest: vcs0
[148.098418] Dynamic subtest vcs0: SUCCESS (0.084s)
[148.109716] Starting dynamic subtest: vcs1
[148.182462] Dynamic subtest vcs1: SUCCESS (0.084s)
[148.194394] Starting dynamic subtest: vecs0
[148.257911] Dynamic subtest vecs0: SUCCESS (0.075s)
[148.267921] Starting dynamic subtest: ccs0
[148.343058] Dynamic subtest ccs0: SUCCESS (0.085s)
[148.345354] Subtest out-order: SUCCESS (0.434s)
[150.063576] [029/133] (879s left) kms_psr (psr2-no-drrs)
[150.152010] Starting subtest: psr2-no-drrs
[150.154382] Starting dynamic subtest: eDP-1
[151.722142] Dynamic subtest eDP-1: SUCCESS (1.570s)
[151.724443] Subtest psr2-no-drrs: SUCCESS (1.571s)
[152.516717] [030/133] (877s left) gem_exec_balancer (bonded-chain)
[152.571811] Starting subtest: bonded-chain
[159.681138] Subtest bonded-chain: SUCCESS (7.108s)
[159.999690] [031/133] (870s left) kms_chamelium_edid (hdmi-edid-read)
[160.380366] Subtest hdmi-edid-read: SKIP (0.000s)
[161.224359] [032/133] (868s left) kms_content_protection (dp-mst-lic-type-1)
[161.378674] Starting subtest: dp-mst-lic-type-1
[161.383143] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[161.514610] [033/133] (868s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[161.620609] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[161.625120] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[161.689705] [034/133] (868s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[161.774397] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[165.323625] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.553s)
[166.453224] [035/133] (863s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[166.556774] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[166.582737] Starting dynamic subtest: pipe-A-plane-0
[167.049309] Dynamic subtest pipe-A-plane-0: SUCCESS (0.467s)
[167.057629] Starting dynamic subtest: pipe-A-plane-3
[167.306424] Dynamic subtest pipe-A-plane-3: SUCCESS (0.254s)
[168.425024] Starting dynamic subtest: pipe-B-plane-0
[168.852294] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[168.860555] Starting dynamic subtest: pipe-B-plane-3
[169.107333] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[169.419401] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.862s)
[170.293045] [036/133] (859s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[170.387231] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[170.391525] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[170.467399] [037/133] (859s left) gem_tiled_fence_blits (normal)
[170.518869] Subtest normal: SKIP (0.000s)
[170.580974] [038/133] (859s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[170.679232] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[170.681547] Starting dynamic subtest: pipe-A-eDP-1
[170.704800] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[170.715684] Starting dynamic subtest: pipe-B-eDP-1
[170.737390] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[170.745890] Starting dynamic subtest: pipe-C-eDP-1
[170.767768] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[170.778232] Starting dynamic subtest: pipe-D-eDP-1
[170.800130] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[170.804143] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[172.961070] [039/133] (857s left) kms_cursor_crc (cursor-alpha-transparent)
[173.070111] Starting subtest: cursor-alpha-transparent
[173.072411] Starting dynamic subtest: pipe-A-eDP-1
[173.683473] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.611s)
[173.693520] Starting dynamic subtest: pipe-D-eDP-1
[174.938322] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.252s)
[174.940486] Subtest cursor-alpha-transparent: SUCCESS (1.867s)
[175.727888] [040/133] (854s left) core_auth (basic-auth)
[175.791902] Starting subtest: basic-auth
[175.794142] Subtest basic-auth: SUCCESS (0.001s)
[175.892809] [041/133] (854s left) kms_getfb (getfb-reject-nv12)
[175.990440] Starting subtest: getfb-reject-nv12
[175.992556] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[176.088057] [042/133] (854s left) kms_psr (fbc-psr-cursor-plane-move)
[176.181478] Starting subtest: fbc-psr-cursor-plane-move
[176.183577] Starting dynamic subtest: eDP-1
[176.187495] Dynamic subtest eDP-1: SKIP (0.000s)
[176.191469] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[176.252526] [043/133] (854s left) gem_userptr_blits (sync-overlap)
[176.315584] Starting subtest: sync-overlap
[176.317949] Subtest sync-overlap: SUCCESS (0.000s)
[176.432494] [044/133] (854s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[176.526130] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[177.306118] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.781s)
[177.454635] [045/133] (853s left) gem_exec_gttfill (multigpu-basic)
[177.623905] Starting subtest: multigpu-basic
[191.051883] Subtest multigpu-basic: SUCCESS (13.426s)
[191.135670] [046/133] (839s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[191.276778] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[191.279190] Starting dynamic subtest: pipe-A-eDP-1
[191.288625] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[191.298505] Starting dynamic subtest: pipe-B-eDP-1
[191.307988] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[191.316646] Starting dynamic subtest: pipe-C-eDP-1
[191.324926] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[191.333337] Starting dynamic subtest: pipe-D-eDP-1
[191.341715] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[191.345941] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[193.578941] [047/133] (837s left) kms_cursor_edge_walk (256x256-top-edge)
[193.676208] Starting subtest: 256x256-top-edge
[193.678368] Starting dynamic subtest: pipe-A-eDP-1
[197.150397] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.473s)
[197.162110] Starting dynamic subtest: pipe-D-eDP-1
[200.280181] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.128s)
[200.282386] Subtest 256x256-top-edge: SUCCESS (6.604s)
[201.091071] [048/133] (829s left) gem_mmap_wc (write-cpu-read-wc)
[201.162713] Subtest write-cpu-read-wc: SKIP (0.000s)
[201.222283] [049/133] (829s left) gem_ctx_isolation (preservation-s3)
[201.283416] Starting subtest: preservation-S3
[201.285651] Starting dynamic subtest: rcs0
[217.598528] Dynamic subtest rcs0: SUCCESS (1.341s)
[217.608306] Starting dynamic subtest: bcs0
[233.612101] Dynamic subtest bcs0: SUCCESS (1.321s)
[233.623219] Starting dynamic subtest: vcs0
[249.621072] Dynamic subtest vcs0: SUCCESS (3.112s)
[249.635041] Starting dynamic subtest: vcs1
[267.607524] Dynamic subtest vcs1: SUCCESS (4.991s)
[267.616744] Starting dynamic subtest: vecs0
[285.605421] Dynamic subtest vecs0: SUCCESS (5.028s)
[285.617052] Starting dynamic subtest: ccs0
[303.619559] Dynamic subtest ccs0: SUCCESS (3.176s)
[303.624099] Subtest preservation-S3: SUCCESS (18.975s)
[303.852203] [050/133] (726s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[305.484645] Starting subtest: dpms-mode-unset-non-lpsp
[306.641236] Subtest dpms-mode-unset-non-lpsp: SKIP (1.155s)
[307.014278] [051/133] (723s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[307.140423] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[307.272086] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.136s)
[307.384227] [052/133] (723s left) gem_mmap_gtt (basic-short)
[307.441071] Subtest basic-short: SKIP (0.000s)
[307.498196] [053/133] (723s left) gem_mmap_gtt (basic-write-gtt)
[307.562506] Subtest basic-write-gtt: SKIP (0.000s)
[307.631256] [054/133] (723s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[307.692529] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[307.800174] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[307.878642] [055/133] (723s left) fbdev (eof)
[307.915946] Starting subtest: eof
[307.918411] Subtest eof: SUCCESS (0.000s)
[307.982564] [056/133] (723s left) kms_plane_cursor (primary)
[308.078847] Starting subtest: primary
[308.083283] Starting dynamic subtest: pipe-A-eDP-1-size-64
[310.642556] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.565s)
[310.666961] Starting dynamic subtest: pipe-A-eDP-1-size-128
[313.254186] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.594s)
[313.277984] Starting dynamic subtest: pipe-A-eDP-1-size-256
[315.843379] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.572s)
[316.161790] Starting dynamic subtest: pipe-B-eDP-1-size-64
[319.497044] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.344s)
[319.523771] Starting dynamic subtest: pipe-B-eDP-1-size-128
[322.098512] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.583s)
[322.122866] Starting dynamic subtest: pipe-B-eDP-1-size-256
[324.665374] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.549s)
[324.986755] Starting dynamic subtest: pipe-C-eDP-1-size-64
[327.882965] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.908s)
[327.910716] Starting dynamic subtest: pipe-C-eDP-1-size-128
[330.104420] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.203s)
[330.131113] Starting dynamic subtest: pipe-C-eDP-1-size-256
[332.292754] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.169s)
[332.618539] Starting dynamic subtest: pipe-D-eDP-1-size-64
[335.513626] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.905s)
[335.539588] Starting dynamic subtest: pipe-D-eDP-1-size-128
[337.726288] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.191s)
[337.752135] Starting dynamic subtest: pipe-D-eDP-1-size-256
[339.993527] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.247s)
[340.303608] Subtest primary: SUCCESS (32.225s)
[341.141549] [057/133] (689s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[341.242540] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[349.945822] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.704s)
[350.073623] [058/133] (681s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[350.155176] Starting subtest: yf-tiled-to-vebox-y-tiled
[350.159618] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[350.348855] [059/133] (680s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[350.453136] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[350.457294] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[350.548948] [060/133] (680s left) kms_universal_plane (universal-plane-pageflip-windowed)
[350.635792] Starting subtest: universal-plane-pageflip-windowed
[350.638132] Starting dynamic subtest: pipe-A-eDP-1
[351.222138] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.585s)
[351.232287] Starting dynamic subtest: pipe-B-eDP-1
[352.460845] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.239s)
[352.470832] Starting dynamic subtest: pipe-C-eDP-1
[353.661526] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.200s)
[353.671541] Starting dynamic subtest: pipe-D-eDP-1
[354.906521] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.240s)
[354.908610] Subtest universal-plane-pageflip-windowed: SUCCESS (4.270s)
[355.751522] [061/133] (675s left) syncobj_timeline (wait-for-submit-complex)
[355.810826] Starting subtest: wait-for-submit-complex
[355.871226] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[355.958175] [062/133] (675s left) gem_mmap_gtt (big-copy-xy)
[356.014224] Subtest big-copy-XY: SKIP (0.000s)
[356.069430] [063/133] (675s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[356.130478] Starting subtest: yf-tiled-ccs-to-x-tiled
[356.135572] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[356.310585] [064/133] (675s left) kms_dsc (dsc-basic)
[356.406847] Starting subtest: dsc-basic
[356.420089] Subtest dsc-basic: SKIP (0.000s)
[356.478578] [065/133] (674s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[356.584704] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[356.597018] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s)
[356.671589] [066/133] (674s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[356.763785] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[363.490107] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.727s)
[363.596177] [067/133] (667s left) kms_flip (flip-vs-suspend)
[363.691090] Starting subtest: flip-vs-suspend
[363.693452] Starting dynamic subtest: A-eDP1
[412.583265] Dynamic subtest A-eDP1: SUCCESS (4.625s)
[412.597636] Starting dynamic subtest: B-eDP1
[461.605543] Dynamic subtest B-eDP1: SUCCESS (4.536s)
[461.618791] Starting dynamic subtest: C-eDP1
[510.581124] Dynamic subtest C-eDP1: SUCCESS (4.574s)
[510.591744] Starting dynamic subtest: D-eDP1
[559.581723] Dynamic subtest D-eDP1: SUCCESS (4.492s)
[559.587618] Subtest flip-vs-suspend: SUCCESS (18.238s)
[560.755056] [068/133] (470s left) gem_gpgpu_fill (basic)
[560.819098] Starting subtest: basic
[560.821603] Starting dynamic subtest: smem
[560.827559] Dynamic subtest smem: SUCCESS (0.009s)
[560.830107] Subtest basic: SUCCESS (0.009s)
[560.960139] [069/133] (470s left) gem_exec_params (no-bsd)
[561.026515] Starting subtest: no-bsd
[561.029347] Subtest no-bsd: SUCCESS (0.003s)
[563.074123] [070/133] (468s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[563.169303] Starting subtest: psr-1p-primscrn-spr-indfb-move
[570.752592] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.583s)
[570.876092] [071/133] (460s left) gem_exec_schedule (semaphore-codependency)
[570.948618] Starting subtest: semaphore-codependency
[570.955068] Subtest semaphore-codependency: SUCCESS (0.016s)
[571.294816] [072/133] (460s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[571.393119] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[571.398343] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[571.494458] [073/133] (460s left) kms_flip (2x-flip-vs-fences)
[571.585151] Starting subtest: 2x-flip-vs-fences
[571.589334] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[571.684419] [074/133] (460s left) gem_ctx_persistence (legacy-engines-hostile)
[571.739379] Starting subtest: legacy-engines-hostile
[571.741879] Starting dynamic subtest: render
[571.852158] Dynamic subtest render: SUCCESS (0.111s)
[571.863840] Starting dynamic subtest: bsd1
[571.942999] Dynamic subtest bsd1: SUCCESS (0.088s)
[571.955614] Starting dynamic subtest: bsd2
[572.032967] Dynamic subtest bsd2: SUCCESS (0.087s)
[572.044958] Starting dynamic subtest: blt
[572.125741] Dynamic subtest blt: SUCCESS (0.090s)
[572.139517] Starting dynamic subtest: vebox
[572.216705] Dynamic subtest vebox: SUCCESS (0.088s)
[572.219339] Subtest legacy-engines-hostile: SUCCESS (0.478s)
[572.297598] [075/133] (459s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[572.356559] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[572.417923] [076/133] (459s left) perf (gen12-mi-rpc)
[572.554617] Starting subtest: gen12-mi-rpc
[572.557083] Starting dynamic subtest: rcs0
[572.573471] Dynamic subtest rcs0: SUCCESS (0.019s)
[572.575481] Subtest gen12-mi-rpc: SUCCESS (0.020s)
[572.620276] [077/133] (459s left) perf_pmu (init-sema)
[572.660989] Starting subtest: init-sema
[572.663158] Starting dynamic subtest: rcs0
[572.665291] Dynamic subtest rcs0: SUCCESS (0.002s)
[572.676516] Starting dynamic subtest: bcs0
[572.678513] Dynamic subtest bcs0: SUCCESS (0.001s)
[572.687698] Starting dynamic subtest: vcs0
[572.689972] Dynamic subtest vcs0: SUCCESS (0.000s)
[572.698935] Starting dynamic subtest: vcs1
[572.700966] Dynamic subtest vcs1: SUCCESS (0.000s)
[572.709053] Starting dynamic subtest: vecs0
[572.711403] Dynamic subtest vecs0: SUCCESS (0.001s)
[572.721615] Starting dynamic subtest: ccs0
[572.723975] Dynamic subtest ccs0: SUCCESS (0.000s)
[572.726253] Subtest init-sema: SUCCESS (0.008s)
[572.776113] [078/133] (459s left) syncobj_timeline (multi-wait-signaled)
[572.826418] Starting subtest: multi-wait-signaled
[572.828700] Subtest multi-wait-signaled: SUCCESS (0.001s)
[572.926698] [079/133] (458s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[573.022440] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[573.026927] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[573.121435] [080/133] (458s left) gem_softpin (overlap)
[573.179505] Starting subtest: overlap
[574.107187] Subtest overlap: SUCCESS (0.927s)
[574.235782] [081/133] (457s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[574.294556] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[574.400645] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.106s)
[574.479416] [082/133] (457s left) gem_exec_reloc (basic-gtt-noreloc)
[574.539487] Subtest basic-gtt-noreloc: SKIP (0.000s)
[574.614022] [083/133] (457s left) gem_wait (await)
[574.682116] Starting subtest: await
[574.684537] Starting dynamic subtest: all-engines
[575.851053] Dynamic subtest all-engines: SUCCESS (1.172s)
[575.869528] Starting dynamic subtest: rcs0
[576.915746] Dynamic subtest rcs0: SUCCESS (1.062s)
[576.933665] Starting dynamic subtest: bcs0
[577.977889] Dynamic subtest bcs0: SUCCESS (1.060s)
[577.995376] Starting dynamic subtest: vcs0
[579.040250] Dynamic subtest vcs0: SUCCESS (1.060s)
[579.056103] Starting dynamic subtest: vcs1
[580.102660] Dynamic subtest vcs1: SUCCESS (1.059s)
[580.119702] Starting dynamic subtest: vecs0
[581.160716] Dynamic subtest vecs0: SUCCESS (1.056s)
[581.177477] Starting dynamic subtest: ccs0
[582.223614] Dynamic subtest ccs0: SUCCESS (1.060s)
[582.226732] Subtest await: SUCCESS (7.545s)
[582.425553] [FACT gem_wait (await)] new: kernel.kmod_is_loaded.vgem: true
[582.429148] [084/133] (449s left) drm_mm (drm_mm)
[582.468245] Starting subtest: drm_mm
[582.474704] Starting dynamic subtest: drm_test_mm_init
[582.575396] Dynamic subtest drm_test_mm_init: SUCCESS (0.100s)
[582.586540] Starting dynamic subtest: drm_test_mm_debug
[582.657411] Dynamic subtest drm_test_mm_debug: SUCCESS (0.081s)
[582.667704] Starting dynamic subtest: drm_test_mm_align32
[582.759342] Dynamic subtest drm_test_mm_align32: SUCCESS (0.101s)
[582.769469] Starting dynamic subtest: drm_test_mm_align64
[582.847998] Dynamic subtest drm_test_mm_align64: SUCCESS (0.088s)
[582.857353] Starting dynamic subtest: drm_test_mm_lowest
[582.955126] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.106s)
[582.964522] Starting dynamic subtest: drm_test_mm_highest
[583.032548] Dynamic subtest drm_test_mm_highest: SUCCESS (0.077s)
[583.035566] Subtest drm_mm: SUCCESS (0.566s)
[583.187009] [085/133] (448s left) gem_ctx_param (basic)
[583.241984] Starting subtest: basic
[583.244585] Subtest basic: SUCCESS (0.001s)
[583.334724] [086/133] (448s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[583.441059] Starting subtest: plane-primary-overlay-mutable-zpos
[586.893853] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.452s)
[588.089271] [087/133] (444s left) i915_module_load (resize-bar)
[588.132746] Starting subtest: resize-bar
[588.140541] Subtest resize-bar: SKIP (0.006s)
[588.187435] [088/133] (444s left) gem_exec_suspend (basic-s3)
[588.253468] Starting subtest: basic-S3
[588.256128] Starting dynamic subtest: smem
[608.506932] Dynamic subtest smem: SUCCESS (6.739s)
[608.509976] Subtest basic-S3: SUCCESS (6.741s)
[608.693635] [089/133] (423s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[608.839350] Starting subtest: basic-flip-after-cursor-atomic
[609.768953] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.930s)
[610.582451] [090/133] (421s left) kms_lease (lease-revoke)
[610.667169] Starting subtest: lease-revoke
[610.669688] Starting dynamic subtest: pipe-A-eDP-1
[610.697537] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.032s)
[610.708410] Starting dynamic subtest: pipe-B-eDP-1
[610.731509] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.030s)
[610.741092] Starting dynamic subtest: pipe-C-eDP-1
[610.761358] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.029s)
[610.770956] Starting dynamic subtest: pipe-D-eDP-1
[610.791394] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.028s)
[610.793735] Subtest lease-revoke: SUCCESS (0.124s)
[610.904943] [091/133] (421s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[611.002615] Starting subtest: 4-tiled-64bpp-rotate-90
[611.023719] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.020s)
[611.153866] [092/133] (421s left) gem_exec_async (forked-writes)
[611.229213] Starting subtest: forked-writes
[611.231936] Starting dynamic subtest: rcs0
[611.259956] Dynamic subtest rcs0: SUCCESS (0.031s)
[611.269867] Starting dynamic subtest: bcs0
[611.281820] Dynamic subtest bcs0: SUCCESS (0.021s)
[611.291533] Starting dynamic subtest: vcs0
[611.304959] Dynamic subtest vcs0: SUCCESS (0.022s)
[611.314275] Starting dynamic subtest: vcs1
[611.328540] Dynamic subtest vcs1: SUCCESS (0.022s)
[611.338504] Starting dynamic subtest: vecs0
[611.351970] Dynamic subtest vecs0: SUCCESS (0.023s)
[611.361835] Starting dynamic subtest: ccs0
[611.374506] Dynamic subtest ccs0: SUCCESS (0.021s)
[611.376967] Subtest forked-writes: SUCCESS (0.146s)
[612.516833] [093/133] (419s left) kms_cursor_crc (cursor-random-32x10)
[612.686616] Starting subtest: cursor-random-32x10
[612.730827] Subtest cursor-random-32x10: SKIP (0.042s)
[612.982832] [094/133] (419s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[613.078857] Starting subtest: pr-cursor-plane-update-sf
[613.083684] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[613.161319] [095/133] (419s left) perf_pmu (all-busy-idle-check-all)
[613.207404] Starting subtest: all-busy-idle-check-all
[614.522553] Subtest all-busy-idle-check-all: SUCCESS (1.317s)
[614.622005] [096/133] (418s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[614.723668] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[614.728523] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[614.818508] [097/133] (417s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[614.916603] Starting subtest: fbcpsr-slowdraw
[640.310751] Subtest fbcpsr-slowdraw: SUCCESS (25.388s)
[640.438155] [098/133] (392s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[640.548967] Starting subtest: x-tiled-8bpp-rotate-180
[641.776334] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.227s)
[641.890411] [099/133] (390s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[642.456121] Starting subtest: syncobj-backward-timeline-chain-engines
[642.569180] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.113s)
[643.623626] [100/133] (389s left) gem_eio (in-flight-external)
[643.843751] Starting subtest: in-flight-external
[645.580946] Subtest in-flight-external: SUCCESS (1.735s)
[645.699234] [101/133] (387s left) kms_pm_rpm (pm-caching)
[647.731174] Starting subtest: pm-caching
[647.736457] Subtest pm-caching: SKIP (0.000s)
[648.117062] [102/133] (384s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[648.175920] Starting subtest: invalid-smem-bo-on-discrete
[648.180911] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[648.310155] [103/133] (384s left) gem_eio (in-flight-internal-immediate)
[648.521684] Starting subtest: in-flight-internal-immediate
[649.597906] Subtest in-flight-internal-immediate: SUCCESS (1.076s)
[649.740299] [104/133] (383s left) api_intel_bb (delta-check)
[649.797914] Starting subtest: delta-check
[649.803424] Subtest delta-check: SUCCESS (0.007s)
[649.916443] [105/133] (383s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[650.012658] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[650.015151] Starting dynamic subtest: pipe-A-eDP-1
[650.077712] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[650.087256] Starting dynamic subtest: pipe-B-eDP-1
[650.153695] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[650.165143] Starting dynamic subtest: pipe-C-eDP-1
[650.231949] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[650.242675] Starting dynamic subtest: pipe-D-eDP-1
[650.308825] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[650.313314] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s)
[652.262239] [106/133] (380s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[652.350643] Starting subtest: bad-pixel-format-yf-tiled-ccs
[652.353221] Starting dynamic subtest: pipe-A-eDP-1
[652.377362] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[652.387756] Starting dynamic subtest: pipe-B-eDP-1
[652.413023] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[652.422855] Starting dynamic subtest: pipe-C-eDP-1
[652.447834] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[652.457512] Starting dynamic subtest: pipe-D-eDP-1
[652.483779] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[652.488612] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[654.621382] [107/133] (378s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[654.716436] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[654.721752] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[654.828456] [108/133] (378s left) gem_exec_fence (basic-wait-all)
[654.885424] Starting subtest: basic-wait-all
[654.972616] Subtest basic-wait-all: SUCCESS (0.087s)
[656.596319] [109/133] (376s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[656.689949] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[657.714807] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.024s)
[657.835802] [110/133] (375s left) syncobj_timeline (wait-all-snapshot)
[657.891729] Starting subtest: wait-all-snapshot
[657.972721] Subtest wait-all-snapshot: SUCCESS (0.082s)
[658.051494] [111/133] (375s left) kms_chamelium_color (ctm-negative)
[658.154472] Subtest ctm-negative: SKIP (0.000s)
[658.204073] [112/133] (375s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[658.322672] Starting subtest: cursorB-vs-flipA-legacy
[658.326600] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[658.466718] [113/133] (374s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[658.576440] Starting subtest: flip-vs-cursor-varying-size
[667.330913] Subtest flip-vs-cursor-varying-size: SUCCESS (8.749s)
[668.149103] [114/133] (365s left) kms_flip (flip-vs-panning)
[668.262934] Starting subtest: flip-vs-panning
[668.265653] Starting dynamic subtest: A-eDP1
[676.958239] Dynamic subtest A-eDP1: SUCCESS (8.693s)
[676.968954] Starting dynamic subtest: B-eDP1
[685.691054] Dynamic subtest B-eDP1: SUCCESS (8.730s)
[685.704444] Starting dynamic subtest: C-eDP1
[694.407578] Dynamic subtest C-eDP1: SUCCESS (8.711s)
[694.420239] Starting dynamic subtest: D-eDP1
[703.135566] Dynamic subtest D-eDP1: SUCCESS (8.725s)
[703.140928] Subtest flip-vs-panning: SUCCESS (34.871s)
[704.295344] [115/133] (329s left) gem_create (create-ext-cpu-access-sanity-check)
[704.461897] Starting subtest: create-ext-cpu-access-sanity-check
[704.467708] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[704.538155] [116/133] (328s left) prime_busy (hang)
[704.602720] Starting subtest: hang
[704.605546] Starting dynamic subtest: rcs0
[731.028792] Dynamic subtest rcs0: SUCCESS (26.430s)
[731.038604] Starting dynamic subtest: bcs0
[738.184951] Dynamic subtest bcs0: SUCCESS (7.155s)
[738.194812] Starting dynamic subtest: vcs0
[745.161198] Dynamic subtest vcs0: SUCCESS (6.976s)
[745.171635] Starting dynamic subtest: vcs1
[752.197929] Dynamic subtest vcs1: SUCCESS (7.036s)
[752.207844] Starting dynamic subtest: vecs0
[759.170193] Dynamic subtest vecs0: SUCCESS (6.973s)
[759.182913] Starting dynamic subtest: ccs0
[773.014072] Dynamic subtest ccs0: SUCCESS (13.839s)
[773.016524] Subtest hang: SUCCESS (68.416s)
[773.120964] [117/133] (260s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[773.219238] Starting subtest: plane-lut1d-pre-ctm3x4
[773.366703] Starting dynamic subtest: pipe-A-plane-0
[773.789653] Dynamic subtest pipe-A-plane-0: FAIL (0.220s)
[773.800909] Starting dynamic subtest: pipe-A-plane-1
[774.044481] Dynamic subtest pipe-A-plane-1: FAIL (0.176s)
[774.055032] Starting dynamic subtest: pipe-A-plane-2
[774.307560] Dynamic subtest pipe-A-plane-2: FAIL (0.177s)
[775.205915] Starting dynamic subtest: pipe-B-plane-0
[775.671303] Dynamic subtest pipe-B-plane-0: FAIL (0.168s)
[775.681817] Starting dynamic subtest: pipe-B-plane-1
[776.047843] Dynamic subtest pipe-B-plane-1: FAIL (0.172s)
[776.059407] Starting dynamic subtest: pipe-B-plane-2
[776.410351] Dynamic subtest pipe-B-plane-2: FAIL (0.707s)
[777.402936] Starting dynamic subtest: pipe-C-plane-0
[777.955375] Dynamic subtest pipe-C-plane-0: FAIL (0.163s)
[777.965795] Starting dynamic subtest: pipe-C-plane-1
[778.399753] Dynamic subtest pipe-C-plane-1: FAIL (0.632s)
[778.410509] Starting dynamic subtest: pipe-C-plane-2
[778.851940] Dynamic subtest pipe-C-plane-2: FAIL (0.164s)
[779.529300] Starting dynamic subtest: pipe-D-plane-0
[780.228524] Dynamic subtest pipe-D-plane-0: FAIL (0.162s)
[780.240479] Starting dynamic subtest: pipe-D-plane-1
[780.763397] Dynamic subtest pipe-D-plane-1: FAIL (0.707s)
[780.777586] Starting dynamic subtest: pipe-D-plane-2
[781.290766] Dynamic subtest pipe-D-plane-2: FAIL (0.642s)
[781.328665] Subtest plane-lut1d-pre-ctm3x4: FAIL (8.109s)
[782.200621] [118/133] (251s left) kms_psr (pr-sprite-mmap-gtt)
[782.317588] Starting subtest: pr-sprite-mmap-gtt
[782.321951] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[782.389986] [119/133] (251s left) i915_query (hwconfig_table)
[782.451970] Starting subtest: hwconfig_table
[782.803635] Subtest hwconfig_table: SUCCESS (0.001s)
[782.846023] [120/133] (250s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[782.945735] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[782.950742] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[783.041312] [121/133] (250s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[783.415347] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[784.215966] [122/133] (249s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[784.316922] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[784.322628] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[784.420529] [123/133] (249s left) gem_workarounds (basic-read)
[784.491752] Starting subtest: basic-read
[784.503707] Subtest basic-read: SUCCESS (0.012s)
[784.621670] [124/133] (249s left) gen9_exec_parse (secure-batches)
[784.680605] Subtest secure-batches: SKIP (0.000s)
[784.754434] [125/133] (249s left) syncobj_wait (multi-wait-for-submit-submitted)
[784.816690] Starting subtest: multi-wait-for-submit-submitted
[784.916991] Subtest multi-wait-for-submit-submitted: SUCCESS (0.101s)
[784.999270] [126/133] (248s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[785.105994] Starting subtest: y-tiled-64bpp-rotate-270
[785.110921] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[785.205451] [127/133] (248s left) gem_mmap_gtt (flink-race)
[785.261702] Subtest flink-race: SKIP (0.000s)
[785.324939] [128/133] (248s left) syncobj_wait (wait-all-delayed-signal)
[785.380952] Starting subtest: wait-all-delayed-signal
[785.482378] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[785.565667] [129/133] (248s left) gem_exec_whisper (basic-fds-priority)
[785.626366] Starting subtest: basic-fds-priority
[810.821918] Subtest basic-fds-priority: SUCCESS (25.189s)
[811.008305] [130/133] (223s left) kms_plane (plane-position-hole-dpms)
[811.113551] Starting subtest: plane-position-hole-dpms
[811.647798] Starting dynamic subtest: pipe-A-plane-1
[814.029441] Dynamic subtest pipe-A-plane-1: SUCCESS (2.383s)
[814.041455] Starting dynamic subtest: pipe-A-plane-2
[816.465834] Dynamic subtest pipe-A-plane-2: SUCCESS (2.435s)
[816.477962] Starting dynamic subtest: pipe-A-plane-3
[818.841320] Dynamic subtest pipe-A-plane-3: SUCCESS (2.372s)
[818.854575] Starting dynamic subtest: pipe-A-plane-4
[821.225396] Dynamic subtest pipe-A-plane-4: SUCCESS (2.385s)
[821.237952] Starting dynamic subtest: pipe-A-plane-5
[821.254710] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s)
[822.410279] Starting dynamic subtest: pipe-B-plane-1
[824.858537] Dynamic subtest pipe-B-plane-1: SUCCESS (2.454s)
[824.869289] Starting dynamic subtest: pipe-B-plane-2
[827.277577] Dynamic subtest pipe-B-plane-2: SUCCESS (2.420s)
[827.289298] Starting dynamic subtest: pipe-B-plane-3
[829.651849] Dynamic subtest pipe-B-plane-3: SUCCESS (2.370s)
[829.664466] Starting dynamic subtest: pipe-B-plane-4
[832.016736] Dynamic subtest pipe-B-plane-4: SUCCESS (2.365s)
[832.027445] Starting dynamic subtest: pipe-B-plane-5
[832.042769] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[832.045620] Subtest plane-position-hole-dpms: SUCCESS (20.926s)
[832.808549] [131/133] (201s left) i915_pm_rpm (gem-mmap-type)
[834.744851] Starting subtest: gem-mmap-type
[834.747679] Starting dynamic subtest: wb-smem0
[838.226393] Dynamic subtest wb-smem0: SUCCESS (3.482s)
[838.236726] Starting dynamic subtest: wc-smem0
[841.407764] Dynamic subtest wc-smem0: SUCCESS (3.180s)
[841.419008] Starting dynamic subtest: uc-smem0
[844.253456] Dynamic subtest uc-smem0: SUCCESS (2.844s)
[844.255960] Subtest gem-mmap-type: SUCCESS (9.510s)
[844.339301] [132/133] (189s left) kms_vblank (ts-continuation-idle-hang)
[844.436609] Starting subtest: ts-continuation-idle-hang
[844.438807] Starting dynamic subtest: pipe-A-eDP-1
[871.281561] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.845s)
[871.295942] Starting dynamic subtest: pipe-D-eDP-1
[896.261800] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.977s)
[896.264890] Subtest ts-continuation-idle-hang: SUCCESS (51.827s)
[897.063228] [133/133] (137s left) syncobj_wait (invalid-reset-bad-pad)
[897.114990] Starting subtest: invalid-reset-bad-pad
[897.117386] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[897.221993] Closing watchdogs
results: parsing output: 0/ for test: gem_workarounds
results: parsing output: 1/ for test: api_intel_bb
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_display_modes
results: parsing output: 4/ for test: kms_plane_alpha_blend
results: parsing output: 5/ for test: kms_psr2_sf
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: i915_drm_fdinfo
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_addfb_basic
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_softpin
results: parsing output: 13/ for test: gem_exec_params
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_exec_balancer
results: parsing output: 16/ for test: gem_exec_reloc
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_flip_scaled_crc
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_media_vme
results: parsing output: 24/ for test: kms_invalid_mode
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: kms_plane_scaling
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: gem_exec_balancer
results: parsing output: 30/ for test: kms_chamelium_edid
results: parsing output: 31/ for test: kms_content_protection
results: parsing output: 32/ for test: kms_psr2_sf
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_plane
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: gem_tiled_fence_blits
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: kms_cursor_crc
results: parsing output: 39/ for test: core_auth
results: parsing output: 40/ for test: kms_getfb
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: gem_userptr_blits
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: gem_exec_gttfill
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: kms_cursor_edge_walk
results: parsing output: 47/ for test: gem_mmap_wc
results: parsing output: 48/ for test: gem_ctx_isolation
results: parsing output: 49/ for test: kms_pm_rpm
results: parsing output: 50/ for test: gem_pxp
results: parsing output: 51/ for test: gem_mmap_gtt
results: parsing output: 52/ for test: gem_mmap_gtt
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: fbdev
results: parsing output: 55/ for test: kms_plane_cursor
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_render_copy
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_universal_plane
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: gem_mmap_gtt
results: parsing output: 62/ for test: gem_render_copy
results: parsing output: 63/ for test: kms_dsc
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: gem_gpgpu_fill
results: parsing output: 68/ for test: gem_exec_params
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_exec_schedule
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: gem_ctx_persistence
results: parsing output: 74/ for test: kms_pipe_b_c_ivb
results: parsing output: 75/ for test: perf
results: parsing output: 76/ for test: perf_pmu
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_softpin
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: gem_wait
results: parsing output: 83/ for test: drm_mm
results: parsing output: 84/ for test: gem_ctx_param
results: parsing output: 85/ for test: kms_atomic
results: parsing output: 86/ for test: i915_module_load
results: parsing output: 87/ for test: gem_exec_suspend
results: parsing output: 88/ for test: kms_cursor_legacy
results: parsing output: 89/ for test: kms_lease
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: gem_exec_async
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: kms_psr2_sf
results: parsing output: 94/ for test: perf_pmu
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: gem_exec_fence
results: parsing output: 99/ for test: gem_eio
results: parsing output: 100/ for test: kms_pm_rpm
results: parsing output: 101/ for test: kms_addfb_basic
results: parsing output: 102/ for test: gem_eio
results: parsing output: 103/ for test: api_intel_bb
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_exec_fence
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: kms_chamelium_color
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: kms_cursor_legacy
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: gem_create
results: parsing output: 115/ for test: prime_busy
results: parsing output: 116/ for test: kms_color_pipeline
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: i915_query
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_chamelium_hpd
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_workarounds
results: parsing output: 123/ for test: gen9_exec_parse
results: parsing output: 124/ for test: syncobj_wait
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: gem_mmap_gtt
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: gem_exec_whisper
results: parsing output: 129/ for test: kms_plane
results: parsing output: 130/ for test: i915_pm_rpm
results: parsing output: 131/ for test: kms_vblank
results: parsing output: 132/ for test: syncobj_wait
Done.