[56.209044] Initializing watchdogs
[56.209157]   /dev/watchdog0
[56.224316] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.228639] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.230935] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.234696] [001/156] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite)
[56.368254] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite
[56.372632] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[56.467721] [002/156] (960s left) gem_mmap_gtt (big-bo-tiledy)
[56.524118] Subtest big-bo-tiledY: SKIP (0.000s)
[56.606783] [003/156] (960s left) gem_ppgtt (blt-vs-render-ctx0)
[56.658330] Starting subtest: blt-vs-render-ctx0
[89.470672] Subtest blt-vs-render-ctx0: SUCCESS (32.808s)
[89.601925] [004/156] (927s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[89.747318] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[89.749500] Starting dynamic subtest: pipe-A-eDP-1
[106.606596] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.588s)
[106.616669] Starting dynamic subtest: pipe-B-eDP-1
[123.584959] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.444s)
[123.593950] Starting dynamic subtest: pipe-C-eDP-1
[140.550146] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.432s)
[140.560550] Starting dynamic subtest: pipe-D-eDP-1
[157.544148] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.335s)
[157.546445] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.803s)
[158.762436] [005/156] (858s left) kms_rmfb (rmfb-ioctl)
[158.875625] Starting subtest: rmfb-ioctl
[158.878018] Starting dynamic subtest: pipe-A-eDP-1
[158.981801] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[158.995512] Starting dynamic subtest: pipe-B-eDP-1
[160.127211] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.143s)
[160.138897] Starting dynamic subtest: pipe-C-eDP-1
[161.278515] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.149s)
[161.289505] Starting dynamic subtest: pipe-D-eDP-1
[162.424706] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.145s)
[162.426971] Subtest rmfb-ioctl: SUCCESS (3.547s)
[163.628102] [006/156] (853s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[163.732384] Starting subtest: yf-tiled-16bpp-rotate-180
[163.736522] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[163.826098] [007/156] (853s left) gem_mmap_wc (read-write)
[163.892819] Subtest read-write: SKIP (0.000s)
[163.954527] [008/156] (853s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[164.063421] Starting subtest: fbc-pr-cursor-plane-update-sf
[164.068021] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[164.125625] [009/156] (852s left) gem_mmap_offset (clear-via-pagefault)
[164.185888] Starting subtest: clear-via-pagefault
[164.188127] Starting dynamic subtest: smem0
[195.281390] Dynamic subtest smem0: SUCCESS (31.075s)
[195.283500] Subtest clear-via-pagefault: SUCCESS (31.075s)
[195.381832] [010/156] (821s left) syncobj_wait (wait-for-submit-delayed-submit)
[195.453345] Starting subtest: wait-for-submit-delayed-submit
[195.557712] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[195.648745] [011/156] (821s left) kms_plane_multiple (tiling-x)
[195.746749] Starting subtest: tiling-x
[195.749169] Starting dynamic subtest: pipe-A-eDP-1
[199.684575] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.935s)
[199.694703] Starting dynamic subtest: pipe-B-eDP-1
[204.251393] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.564s)
[204.260921] Starting dynamic subtest: pipe-C-eDP-1
[208.782425] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.529s)
[208.792414] Starting dynamic subtest: pipe-D-eDP-1
[213.322291] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.537s)
[213.324704] Subtest tiling-x: SUCCESS (17.568s)
[214.132174] [012/156] (803s left) kms_addfb_basic (addfb25-bad-modifier)
[214.227915] Starting subtest: addfb25-bad-modifier
[214.230299] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[214.317607] [013/156] (802s left) template (b)
[214.382515] Starting subtest: B
[214.384438] Subtest B: SUCCESS (0.000s)
[214.484362] [014/156] (802s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-y)
[214.594355] Starting subtest: fbcpsrhdr-tiling-y
[214.598529] Subtest fbcpsrhdr-tiling-y: SKIP (0.000s)
[214.671459] [015/156] (802s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[214.772640] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc
[214.777046] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[214.881854] [016/156] (802s left) fbdev (read)
[214.921811] Starting subtest: read
[215.448668] Subtest read: SUCCESS (0.527s)
[215.520028] [017/156] (801s left) gem_fence_thrash (bo-write-verify-threaded-none)
[215.552393] Starting subtest: bo-write-verify-threaded-none
[215.569395] Subtest bo-write-verify-threaded-none: SKIP (0.017s)
[215.625135] [018/156] (801s left) gem_lmem_evict (dontneed-evict-race)
[215.675756] Subtest dontneed-evict-race: SKIP (0.000s)
[215.711491] [019/156] (801s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[215.812761] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[215.817070] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[215.905271] [020/156] (801s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[216.010515] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[216.014720] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[216.106275] [021/156] (801s left) gem_pwrite (basic-self)
[216.164956] Subtest basic-self: SKIP (0.000s)
[216.223652] [022/156] (801s left) gem_exec_schedule (u-submit-late-slice)
[216.302463] Starting subtest: u-submit-late-slice
[216.304491] Starting dynamic subtest: rcs0
[216.332544] Dynamic subtest rcs0: SUCCESS (0.036s)
[216.344599] Starting dynamic subtest: bcs0
[216.358599] Dynamic subtest bcs0: SUCCESS (0.026s)
[216.370463] Starting dynamic subtest: vcs0
[216.389412] Dynamic subtest vcs0: SUCCESS (0.030s)
[216.398564] Starting dynamic subtest: vcs1
[216.426670] Dynamic subtest vcs1: SUCCESS (0.036s)
[216.440647] Starting dynamic subtest: vecs0
[216.458453] Dynamic subtest vecs0: SUCCESS (0.032s)
[216.468107] Starting dynamic subtest: ccs0
[216.488777] Dynamic subtest ccs0: SUCCESS (0.030s)
[216.490778] Subtest u-submit-late-slice: SUCCESS (0.194s)
[218.376706] [023/156] (799s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[218.440145] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[218.547177] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[218.640491] [024/156] (799s left) syncobj_wait (single-wait-submitted)
[218.702786] Starting subtest: single-wait-submitted
[218.803839] Subtest single-wait-submitted: SUCCESS (0.103s)
[218.893964] [025/156] (798s left) kms_cursor_crc (cursor-sliding-512x512)
[219.158403] Starting subtest: cursor-sliding-512x512
[219.163126] Subtest cursor-sliding-512x512: SKIP (0.001s)
[219.294917] [026/156] (798s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-wc)
[219.394777] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-wc
[219.398344] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[219.473161] [027/156] (798s left) gem_pread (snoop)
[219.530232] Subtest snoop: SKIP (0.000s)
[219.584758] [028/156] (798s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[219.690436] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[219.694202] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[219.803522] [029/156] (798s left) gem_pxp (hw-rejects-pxp-context)
[219.931623] Starting subtest: hw-rejects-pxp-context
[219.935514] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[220.037635] [030/156] (797s left) prime_mmap (test_refcounting)
[220.098083] Starting subtest: test_refcounting
[220.100000] Starting dynamic subtest: test_refcounting-smem
[220.130655] Dynamic subtest test_refcounting-smem: SUCCESS (0.032s)
[220.133222] Subtest test_refcounting: SUCCESS (0.033s)
[220.220610] [031/156] (797s left) kms_flip (wf_vblank-ts-check-interruptible)
[220.307946] Starting subtest: wf_vblank-ts-check-interruptible
[220.309893] Starting dynamic subtest: A-eDP1
[229.278446] Dynamic subtest A-eDP1: SUCCESS (8.965s)
[229.287769] Starting dynamic subtest: B-eDP1
[238.216129] Dynamic subtest B-eDP1: SUCCESS (8.932s)
[238.228132] Starting dynamic subtest: C-eDP1
[247.142475] Dynamic subtest C-eDP1: SUCCESS (8.920s)
[247.152123] Starting dynamic subtest: D-eDP1
[256.074731] Dynamic subtest D-eDP1: SUCCESS (8.929s)
[256.079633] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.754s)
[257.305810] [032/156] (760s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[257.404724] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[257.407102] Starting dynamic subtest: pipe-A
[257.467385] Dynamic subtest pipe-A: SUCCESS (0.065s)
[257.477194] Starting dynamic subtest: pipe-B
[258.627345] Dynamic subtest pipe-B: SUCCESS (1.159s)
[258.638727] Starting dynamic subtest: pipe-C
[259.728926] Dynamic subtest pipe-C: SUCCESS (1.101s)
[259.739107] Starting dynamic subtest: pipe-D
[260.865294] Dynamic subtest pipe-D: SUCCESS (1.135s)
[260.867582] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.462s)
[262.022742] [033/156] (755s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[262.135292] Starting subtest: x-tiled-32bpp-rotate-90
[262.154605] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s)
[262.261725] [034/156] (755s left) syncobj_timeline (transfer-timeline-point)
[262.319363] Starting subtest: transfer-timeline-point
[262.321553] Subtest transfer-timeline-point: SUCCESS (0.001s)
[262.466149] [035/156] (755s left) gem_exec_reloc (basic-gtt-read-noreloc)
[262.521590] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[262.586422] [036/156] (755s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[262.674941] Starting subtest: fbc-rgb101010-draw-mmap-wc
[265.146828] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (2.476s)
[266.271737] [037/156] (751s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[266.370003] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[266.372182] Starting dynamic subtest: pipe-A-eDP-1
[268.594532] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.225s)
[268.604513] Starting dynamic subtest: pipe-B-eDP-1
[270.909995] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.314s)
[270.922059] Starting dynamic subtest: pipe-C-eDP-1
[273.064311] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.152s)
[273.073980] Starting dynamic subtest: pipe-D-eDP-1
[275.236437] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.170s)
[275.238490] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.866s)
[276.493313] [038/156] (741s left) kms_psr (psr-primary-page-flip)
[276.596195] Starting subtest: psr-primary-page-flip
[276.598479] Starting dynamic subtest: eDP-1
[278.385493] Dynamic subtest eDP-1: SUCCESS (1.788s)
[278.387904] Subtest psr-primary-page-flip: SUCCESS (1.789s)
[279.244058] [039/156] (738s left) i915_hangman (gt-engine-hang)
[279.314247] Starting subtest: gt-engine-hang
[279.316441] Starting dynamic subtest: rcs0
[281.224813] Dynamic subtest rcs0: SUCCESS (1.910s)
[281.237962] Starting dynamic subtest: bcs0
[283.270918] Dynamic subtest bcs0: SUCCESS (2.042s)
[283.283516] Starting dynamic subtest: vcs0
[285.253880] Dynamic subtest vcs0: SUCCESS (1.979s)
[285.270700] Starting dynamic subtest: vcs1
[287.239708] Dynamic subtest vcs1: SUCCESS (1.982s)
[287.251924] Starting dynamic subtest: vecs0
[289.286681] Dynamic subtest vecs0: SUCCESS (2.043s)
[289.300019] Starting dynamic subtest: ccs0
[291.270525] Dynamic subtest ccs0: SUCCESS (1.980s)
[291.273712] Subtest gt-engine-hang: SUCCESS (11.953s)
[291.401352] [040/156] (726s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[291.499830] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[291.502125] Starting dynamic subtest: pipe-A-eDP-1
[291.560443] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[291.569953] Starting dynamic subtest: pipe-B-eDP-1
[291.627758] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[291.638701] Starting dynamic subtest: pipe-C-eDP-1
[291.695380] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[291.705827] Starting dynamic subtest: pipe-D-eDP-1
[291.761643] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[291.765579] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.008s)
[293.825392] [041/156] (724s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-render)
[293.923781] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-render
[293.928175] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[294.010078] [042/156] (724s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[294.067334] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[294.071801] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[294.268243] [043/156] (724s left) kms_vblank (wait-idle-hang)
[294.364158] Starting subtest: wait-idle-hang
[294.366093] Starting dynamic subtest: pipe-A-eDP-1
[321.064415] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.688s)
[321.078560] Starting dynamic subtest: pipe-D-eDP-1
[346.017308] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.939s)
[346.019804] Subtest wait-idle-hang: SUCCESS (51.631s)
[346.839717] [044/156] (671s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[346.937982] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[353.991994] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.056s)
[354.112591] [045/156] (664s left) gem_exec_params (readonly)
[354.178645] Starting subtest: readonly
[354.184670] Subtest readonly: SUCCESS (0.003s)
[354.297816] [046/156] (664s left) gen9_exec_parse (bb-start-param)
[354.355480] Subtest bb-start-param: SKIP (0.000s)
[354.433265] [047/156] (664s left) syncobj_wait (multi-wait-all-submitted)
[354.490519] Starting subtest: multi-wait-all-submitted
[354.596276] Subtest multi-wait-all-submitted: SUCCESS (0.107s)
[354.672483] [048/156] (663s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-render)
[354.769630] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-render
[354.774087] Subtest hdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[354.875718] [049/156] (663s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-pwrite)
[354.982018] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-pwrite
[354.986508] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[355.089687] [050/156] (663s left) kms_plane_cursor (primary)
[355.178618] Starting subtest: primary
[355.183230] Starting dynamic subtest: pipe-A-eDP-1-size-64
[357.730624] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.553s)
[357.757282] Starting dynamic subtest: pipe-A-eDP-1-size-128
[360.333927] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.583s)
[360.359577] Starting dynamic subtest: pipe-A-eDP-1-size-256
[362.936415] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.583s)
[363.256795] Starting dynamic subtest: pipe-B-eDP-1-size-64
[366.556976] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.308s)
[366.581351] Starting dynamic subtest: pipe-B-eDP-1-size-128
[369.135330] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.561s)
[369.160372] Starting dynamic subtest: pipe-B-eDP-1-size-256
[371.716165] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.561s)
[372.038243] Starting dynamic subtest: pipe-C-eDP-1-size-64
[374.937415] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.910s)
[374.965983] Starting dynamic subtest: pipe-C-eDP-1-size-128
[377.172206] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.214s)
[377.199486] Starting dynamic subtest: pipe-C-eDP-1-size-256
[379.406240] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.214s)
[379.728741] Starting dynamic subtest: pipe-D-eDP-1-size-64
[382.694139] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.977s)
[382.721281] Starting dynamic subtest: pipe-D-eDP-1-size-128
[384.916203] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.203s)
[384.943470] Starting dynamic subtest: pipe-D-eDP-1-size-256
[387.106451] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.169s)
[387.415051] Subtest primary: SUCCESS (32.224s)
[388.306325] [051/156] (630s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[388.403111] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[388.405459] Starting dynamic subtest: pipe-A-eDP-1
[388.427980] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[388.438738] Starting dynamic subtest: pipe-B-eDP-1
[388.459945] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[388.468808] Starting dynamic subtest: pipe-C-eDP-1
[388.489640] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[388.498811] Starting dynamic subtest: pipe-D-eDP-1
[388.520716] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[388.524927] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[390.667530] [052/156] (628s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[390.759508] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[390.763753] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[390.868288] [053/156] (627s left) vgem_basic (debugfs)
[390.978477] Starting subtest: debugfs
[390.980355] Subtest debugfs: SUCCESS (0.000s)
[391.030925] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[391.034331] [054/156] (627s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[391.134707] Starting subtest: 4-tiled-32bpp-rotate-90
[391.154403] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[391.292215] [055/156] (627s left) api_intel_bb (object-noreloc-keep-cache-simple)
[391.340515] Starting subtest: object-noreloc-keep-cache-simple
[391.342475] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.005s)
[391.469223] [056/156] (627s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[391.571927] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[398.994365] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.425s)
[399.107225] [057/156] (619s left) vgem_basic (dmabuf-mmap)
[399.150679] Starting subtest: dmabuf-mmap
[399.155981] Subtest dmabuf-mmap: SUCCESS (0.009s)
[399.228501] [058/156] (619s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[399.334336] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[399.338686] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[399.408184] [059/156] (619s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[399.507851] Starting subtest: primary-y-tiled-reflect-x-180
[399.567825] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s)
[399.672157] [060/156] (619s left) kms_pm_rpm (fences-dpms)
[401.404077] Starting subtest: fences-dpms
[401.408905] Subtest fences-dpms: SKIP (0.000s)
[401.928473] [061/156] (617s left) kms_content_protection (atomic-dpms)
[402.070581] Starting subtest: atomic-dpms
[402.075068] Subtest atomic-dpms: SKIP (0.000s)
[402.208379] [062/156] (616s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[402.255465] Starting subtest: etime-single-wait-all-for-submit-submitted
[402.356687] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.102s)
[402.432817] [063/156] (616s left) gem_ctx_persistence (many-contexts)
[402.490190] Starting subtest: many-contexts
[440.191122] Subtest many-contexts: SUCCESS (37.684s)
[440.277394] [064/156] (578s left) gem_mmap_wc (set-cache-level)
[440.326558] Subtest set-cache-level: SKIP (0.000s)
[440.399329] [065/156] (578s left) kms_invalid_mode (int-max-clock)
[440.492174] Starting subtest: int-max-clock
[440.494495] Starting dynamic subtest: pipe-A-eDP-1
[440.775447] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[440.784945] Starting dynamic subtest: pipe-B-eDP-1
[440.786778] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[440.795783] Starting dynamic subtest: pipe-C-eDP-1
[440.798112] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[440.807405] Starting dynamic subtest: pipe-D-eDP-1
[440.809736] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[440.812074] Subtest int-max-clock: SUCCESS (0.289s)
[441.670286] [066/156] (577s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-render)
[441.760975] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-render
[441.765453] Subtest fbchdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[441.849042] [067/156] (577s left) prime_busy (after-wait)
[441.903434] Starting subtest: after-wait
[441.908810] Starting dynamic subtest: rcs0
[441.951968] Dynamic subtest rcs0: SUCCESS (0.045s)
[441.966231] Starting dynamic subtest: bcs0
[442.007920] Dynamic subtest bcs0: SUCCESS (0.055s)
[442.018046] Starting dynamic subtest: vcs0
[442.047461] Dynamic subtest vcs0: SUCCESS (0.039s)
[442.056726] Starting dynamic subtest: vcs1
[442.086828] Dynamic subtest vcs1: SUCCESS (0.038s)
[442.096095] Starting dynamic subtest: vecs0
[442.125746] Dynamic subtest vecs0: SUCCESS (0.038s)
[442.134956] Starting dynamic subtest: ccs0
[442.165399] Dynamic subtest ccs0: SUCCESS (0.039s)
[442.274419] Subtest after-wait: SUCCESS (0.369s)
[442.348361] [068/156] (577s left) gem_create (hog-create)
[442.411768] Starting subtest: hog-create
[442.414072] Starting dynamic subtest: smem0
[475.251485] Dynamic subtest smem0: SUCCESS (32.954s)
[475.254423] Subtest hog-create: SUCCESS (32.956s)
[475.445265] [069/156] (544s left) i915_suspend (forcewake)
[475.508219] Starting subtest: forcewake
[507.381318] Subtest forcewake: SUCCESS (2.242s)
[508.456185] [070/156] (512s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[508.556811] Starting subtest: plane-scaler-unity-scaling-with-rotation
[508.559097] Starting dynamic subtest: pipe-A
[508.794492] Dynamic subtest pipe-A: SUCCESS (0.239s)
[508.804252] Starting dynamic subtest: pipe-B
[510.134982] Dynamic subtest pipe-B: SUCCESS (1.338s)
[510.145713] Starting dynamic subtest: pipe-C
[511.452994] Dynamic subtest pipe-C: SUCCESS (1.316s)
[511.465950] Starting dynamic subtest: pipe-D
[512.789576] Dynamic subtest pipe-D: SUCCESS (1.334s)
[512.792053] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.231s)
[513.976214] [071/156] (506s left) gem_eio (in-flight-10ms)
[514.195382] Starting subtest: in-flight-10ms
[522.683412] Subtest in-flight-10ms: SUCCESS (8.487s)
[522.808138] [072/156] (497s left) gem_exec_async (concurrent-writes)
[522.868243] Starting subtest: concurrent-writes
[522.871004] Starting dynamic subtest: rcs0
[522.883910] Dynamic subtest rcs0: SUCCESS (0.016s)
[522.894281] Starting dynamic subtest: bcs0
[522.896195] Dynamic subtest bcs0: SUCCESS (0.006s)
[522.906052] Starting dynamic subtest: vcs0
[522.908675] Dynamic subtest vcs0: SUCCESS (0.006s)
[522.922811] Starting dynamic subtest: vcs1
[522.925051] Dynamic subtest vcs1: SUCCESS (0.007s)
[522.934874] Starting dynamic subtest: vecs0
[522.936924] Dynamic subtest vecs0: SUCCESS (0.007s)
[522.946677] Starting dynamic subtest: ccs0
[522.948779] Dynamic subtest ccs0: SUCCESS (0.007s)
[522.950944] Subtest concurrent-writes: SUCCESS (0.052s)
[523.142683] [073/156] (497s left) gem_userptr_blits (mmap-offset-banned)
[523.211895] Starting subtest: mmap-offset-banned
[523.214298] Starting dynamic subtest: wb
[523.216908] Dynamic subtest wb: SUCCESS (0.000s)
[523.227428] Starting dynamic subtest: wc
[523.229638] Dynamic subtest wc: SUCCESS (0.000s)
[523.239650] Starting dynamic subtest: uc
[523.241841] Dynamic subtest uc: SUCCESS (0.000s)
[523.243888] Subtest mmap-offset-banned: SUCCESS (0.003s)
[523.330322] [074/156] (497s left) kms_flip (nonexisting-fb)
[523.430515] Starting subtest: nonexisting-fb
[523.432850] Starting dynamic subtest: A-eDP1
[524.573935] Dynamic subtest A-eDP1: SUCCESS (1.142s)
[524.584322] Starting dynamic subtest: B-eDP1
[525.709434] Dynamic subtest B-eDP1: SUCCESS (1.134s)
[525.719957] Starting dynamic subtest: C-eDP1
[526.840703] Dynamic subtest C-eDP1: SUCCESS (1.131s)
[526.851753] Starting dynamic subtest: D-eDP1
[527.983042] Dynamic subtest D-eDP1: SUCCESS (1.140s)
[527.988421] Subtest nonexisting-fb: SUCCESS (4.559s)
[529.147321] [075/156] (491s left) perf_pmu (enable-race)
[529.188091] Starting subtest: enable-race
[529.190773] Starting dynamic subtest: rcs0
[541.959081] Dynamic subtest rcs0: SUCCESS (12.773s)
[541.970235] Starting dynamic subtest: bcs0
[554.702104] Dynamic subtest bcs0: SUCCESS (12.739s)
[554.715123] Starting dynamic subtest: vcs0
[569.894073] Dynamic subtest vcs0: SUCCESS (15.190s)
[569.906941] Starting dynamic subtest: vcs1
[585.894340] Dynamic subtest vcs1: SUCCESS (15.999s)
[585.907639] Starting dynamic subtest: vecs0
[601.894832] Dynamic subtest vecs0: SUCCESS (16.001s)
[601.914764] Starting dynamic subtest: ccs0
[614.645703] Dynamic subtest ccs0: SUCCESS (12.747s)
[614.648531] Subtest enable-race: SUCCESS (85.461s)
[614.746280] [076/156] (406s left) gem_ctx_param (invalid-get-no-zeromap)
[614.804713] Starting subtest: invalid-get-no-zeromap
[614.807087] Subtest invalid-get-no-zeromap: SUCCESS (0.002s)
[614.902922] [077/156] (405s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[615.012378] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[615.016986] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[615.104446] [078/156] (405s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[615.502501] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[616.344621] [079/156] (404s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[616.456787] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[616.462090] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[616.553257] [080/156] (404s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[616.655783] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[616.660952] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[616.754315] [081/156] (404s left) kms_pm_rpm (pc8-residency)
[619.088597] Starting subtest: pc8-residency
[619.094076] Subtest pc8-residency: SKIP (0.000s)
[619.484879] [082/156] (401s left) gem_spin_batch (engines)
[619.546522] Starting subtest: engines
[619.548556] Starting dynamic subtest: rcs0
[622.784170] Dynamic subtest rcs0: SUCCESS (3.235s)
[622.797127] Starting dynamic subtest: bcs0
[626.024177] Dynamic subtest bcs0: SUCCESS (3.236s)
[626.037489] Starting dynamic subtest: vcs0
[629.262960] Dynamic subtest vcs0: SUCCESS (3.235s)
[629.276832] Starting dynamic subtest: vcs1
[632.499148] Dynamic subtest vcs1: SUCCESS (3.233s)
[632.512332] Starting dynamic subtest: vecs0
[635.738206] Dynamic subtest vecs0: SUCCESS (3.235s)
[635.751861] Starting dynamic subtest: ccs0
[638.972463] Dynamic subtest ccs0: SUCCESS (3.231s)
[638.974935] Subtest engines: SUCCESS (19.424s)
[639.199618] [083/156] (381s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[639.280117] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[639.352149] [084/156] (381s left) gem_partial_pwrite_pread (write-snoop)
[639.408003] Subtest write-snoop: SKIP (0.000s)
[639.472105] [085/156] (381s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[639.575164] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[640.543886] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.969s)
[640.675875] [086/156] (380s left) gem_exec_fence (syncobj-invalid-flags)
[641.098346] Starting subtest: syncobj-invalid-flags
[641.101082] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[642.975588] [087/156] (378s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[643.072643] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[649.913892] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.847s)
[650.050244] [088/156] (371s left) i915_drm_fdinfo (all-busy-idle-check-all)
[650.095148] Starting subtest: all-busy-idle-check-all
[650.103832] Subtest all-busy-idle-check-all: SKIP (0.005s)
[650.180228] [089/156] (371s left) gem_exec_balancer (bonded-semaphore)
[650.270869] Starting subtest: bonded-semaphore
[650.275665] Subtest bonded-semaphore: SKIP (0.000s)
[650.561837] [090/156] (370s left) kms_frontbuffer_tracking (psrhdr-farfromfence-mmap-gtt)
[650.660080] Starting subtest: psrhdr-farfromfence-mmap-gtt
[650.665272] Subtest psrhdr-farfromfence-mmap-gtt: SKIP (0.000s)
[650.749131] [091/156] (370s left) kms_psr (psr2-sprite-render)
[650.838818] Starting subtest: psr2-sprite-render
[650.841596] Starting dynamic subtest: eDP-1
[652.587105] Dynamic subtest eDP-1: SUCCESS (1.747s)
[652.589824] Subtest psr2-sprite-render: SUCCESS (1.748s)
[653.454770] [092/156] (367s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[653.554916] Starting subtest: y-tiled-32bpp-rotate-270
[653.560867] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[653.657053] [093/156] (367s left) gem_exec_parallel (fds)
[653.713986] Starting subtest: fds
[653.716901] Starting dynamic subtest: rcs0
[658.525429] Dynamic subtest rcs0: SUCCESS (4.810s)
[658.540623] Starting dynamic subtest: bcs0
[663.814796] Dynamic subtest bcs0: SUCCESS (5.288s)
[663.825988] Starting dynamic subtest: vcs0
[669.972006] Dynamic subtest vcs0: SUCCESS (6.155s)
[669.983376] Starting dynamic subtest: vcs1
[676.020848] Dynamic subtest vcs1: SUCCESS (6.048s)
[676.032852] Starting dynamic subtest: vecs0
[682.007586] Dynamic subtest vecs0: SUCCESS (5.986s)
[682.024338] Starting dynamic subtest: ccs0
[687.742244] Dynamic subtest ccs0: SUCCESS (5.733s)
[687.744741] Subtest fds: SUCCESS (34.030s)
[687.934697] [094/156] (333s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-onoff)
[688.040909] Starting subtest: hdr-1p-primscrn-spr-indfb-onoff
[688.046093] Subtest hdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[688.148637] [095/156] (333s left) kms_cursor_crc (cursor-random-512x512)
[688.446160] Starting subtest: cursor-random-512x512
[688.452244] Subtest cursor-random-512x512: SKIP (0.001s)
[688.613827] [096/156] (332s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[688.723676] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[688.728865] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[688.814227] [097/156] (332s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[688.908424] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[696.023074] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.121s)
[696.133377] [098/156] (325s left) kms_frontbuffer_tracking (fbchdr-farfromfence-mmap-gtt)
[696.233947] Starting subtest: fbchdr-farfromfence-mmap-gtt
[696.239448] Subtest fbchdr-farfromfence-mmap-gtt: SKIP (0.000s)
[696.328308] [099/156] (325s left) gem_lmem_swapping (verify-random)
[696.377759] Subtest verify-random: SKIP (0.000s)
[696.425184] [100/156] (325s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[696.506232] Starting subtest: fbc-psr2-primary-mmap-cpu
[696.508647] Starting dynamic subtest: eDP-1
[696.513707] Dynamic subtest eDP-1: SKIP (0.000s)
[696.518908] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[696.579536] [101/156] (325s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[696.670468] Starting subtest: async-flip-with-page-flip-events-tiled
[697.048318] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[699.853317] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.805s)
[699.868815] Starting dynamic subtest: pipe-A-eDP-1-4
[702.038093] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.184s)
[702.049601] Starting dynamic subtest: pipe-A-eDP-1-4
[704.047479] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[704.058416] Starting dynamic subtest: pipe-A-eDP-1-x
[706.237944] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[706.622623] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[709.380688] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.767s)
[709.392151] Starting dynamic subtest: pipe-B-eDP-1-4
[711.577887] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.195s)
[711.591733] Starting dynamic subtest: pipe-B-eDP-1-4
[713.586982] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[713.601984] Starting dynamic subtest: pipe-B-eDP-1-x
[715.800892] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.211s)
[716.167099] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[718.909301] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.751s)
[718.922052] Starting dynamic subtest: pipe-C-eDP-1-4
[721.105519] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.195s)
[721.116952] Starting dynamic subtest: pipe-C-eDP-1-4
[723.115498] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[723.130134] Starting dynamic subtest: pipe-C-eDP-1-x
[725.305116] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.189s)
[725.670015] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[728.445380] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.782s)
[728.460300] Starting dynamic subtest: pipe-D-eDP-1-4
[730.629083] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.184s)
[730.640254] Starting dynamic subtest: pipe-D-eDP-1-4
[732.639357] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[732.654028] Starting dynamic subtest: pipe-D-eDP-1-x
[734.828890] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.188s)
[734.831734] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.161s)
[736.029892] [102/156] (285s left) core_setmaster (master-drop-set-user)
[736.127999] Starting subtest: master-drop-set-user
[736.137767] Subtest master-drop-set-user: SUCCESS (0.013s)
[736.180351] [103/156] (285s left) kms_frontbuffer_tracking (fbchdr-1p-indfb-fliptrack-mmap-gtt)
[736.277853] Starting subtest: fbchdr-1p-indfb-fliptrack-mmap-gtt
[736.282629] Subtest fbchdr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[736.383670] [104/156] (285s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[736.486623] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[736.488940] Starting dynamic subtest: pipe-A-default-mode
[739.248721] Dynamic subtest pipe-A-default-mode: SUCCESS (2.763s)
[739.251595] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.765s)
[740.120289] [105/156] (281s left) kms_addfb_basic (basic)
[740.178923] Starting subtest: basic
[740.181598] Subtest basic: SUCCESS (0.000s)
[740.318068] [106/156] (281s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[740.414827] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[744.125092] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.716s)
[745.333414] [107/156] (276s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[745.383931] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[745.489335] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.106s)
[745.570857] [108/156] (276s left) kms_getfb (getfb2-handle-protection)
[745.681642] Starting subtest: getfb2-handle-protection
[745.708229] Subtest getfb2-handle-protection: SUCCESS (0.028s)
[745.828059] [109/156] (276s left) kms_chamelium_frames (hdmi-crc-single)
[746.216353] Subtest hdmi-crc-single: SKIP (0.000s)
[747.032878] [110/156] (275s left) gem_render_copy (linear)
[747.082054] Starting subtest: linear
[747.084518] Starting dynamic subtest: smem
[747.121758] Dynamic subtest smem: SUCCESS (0.039s)
[747.124067] Subtest linear: SUCCESS (0.040s)
[747.318274] [111/156] (274s left) i915_pm_rpm (system-suspend-execbuf)
[749.041353] Starting subtest: system-suspend-execbuf
[808.358422] Subtest system-suspend-execbuf: SUCCESS (44.019s)
[808.771851] [112/156] (213s left) kms_atomic (atomic-plane-damage)
[808.858667] Starting subtest: atomic-plane-damage
[808.907525] Starting dynamic subtest: pipe-A-eDP-1
[809.460409] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.554s)
[809.463328] Subtest atomic-plane-damage: SUCCESS (0.604s)
[810.258589] [113/156] (212s left) kms_frontbuffer_tracking (hdr-suspend)
[810.365399] Starting subtest: hdr-suspend
[810.370587] Subtest hdr-suspend: SKIP (0.000s)
[810.466291] [114/156] (211s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-pwrite)
[810.563048] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-pwrite
[810.567663] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[810.676497] [115/156] (211s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[810.740703] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[810.808569] [116/156] (211s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[810.916695] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[810.921693] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[811.016792] [117/156] (211s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[811.113306] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[811.117923] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[811.205221] [118/156] (211s left) gem_exec_schedule (u-semaphore-codependency)
[811.275078] Starting subtest: u-semaphore-codependency
[811.280572] Subtest u-semaphore-codependency: SUCCESS (0.013s)
[811.622458] [119/156] (210s left) perf (per-context-mode-unprivileged)
[811.765078] Starting subtest: per-context-mode-unprivileged
[811.770293] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[811.814516] [120/156] (210s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[811.906928] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[811.912072] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[812.010432] [121/156] (210s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-render)
[812.112104] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-render
[812.116969] Subtest hdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[812.203519] [122/156] (210s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[812.461589] Starting subtest: parallel-dmabuf-import-out-fence
[813.786304] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.324s)
[813.884937] [123/156] (208s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[813.980105] Starting subtest: fbc-pr-cursor-mmap-cpu
[813.985435] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[814.052567] [124/156] (208s left) kms_cursor_legacy (single-bo)
[814.179599] Starting subtest: single-bo
[814.182322] Starting dynamic subtest: pipe-A
[819.561762] Dynamic subtest pipe-A: SUCCESS (5.380s)
[819.573704] Starting dynamic subtest: pipe-B
[824.943675] Dynamic subtest pipe-B: SUCCESS (5.380s)
[824.958127] Starting dynamic subtest: pipe-C
[830.327094] Dynamic subtest pipe-C: SUCCESS (5.379s)
[830.339580] Starting dynamic subtest: pipe-D
[835.708847] Dynamic subtest pipe-D: SUCCESS (5.379s)
[835.721665] Starting dynamic subtest: all-pipes
[841.098326] Dynamic subtest all-pipes: SUCCESS (5.385s)
[841.100978] Subtest single-bo: SUCCESS (26.916s)
[841.242602] [125/156] (181s left) syncobj_timeline (invalid-wait-illegal-handle)
[841.294651] Starting subtest: invalid-wait-illegal-handle
[841.296957] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[841.387816] [126/156] (181s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[841.478720] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[841.483476] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[841.552137] [127/156] (181s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-move)
[841.654567] Starting subtest: psrhdr-1p-primscrn-cur-indfb-move
[841.660156] Subtest psrhdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[841.743483] [128/156] (181s left) syncobj_wait (wait-zero-handles)
[841.806832] Starting subtest: wait-zero-handles
[841.809618] Subtest wait-zero-handles: SUCCESS (0.000s)
[841.903487] [129/156] (181s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-pgflip-blt)
[841.995354] Starting subtest: hdr-2p-primscrn-shrfb-pgflip-blt
[841.999845] Subtest hdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[842.097582] [130/156] (180s left) sw_sync (sync_multi_consumer)
[842.131213] Starting subtest: sync_multi_consumer
[842.853070] Subtest sync_multi_consumer: SUCCESS (0.723s)
[842.916369] [131/156] (180s left) kms_lease (lease-uevent)
[843.007413] Starting subtest: lease-uevent
[844.016294] Subtest lease-uevent: SUCCESS (1.012s)
[844.099555] [132/156] (179s left) kms_color (ctm-0-75)
[844.199006] Starting subtest: ctm-0-75
[844.200994] Starting dynamic subtest: pipe-A-eDP-1
[849.236092] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.036s)
[849.247620] Starting dynamic subtest: pipe-B-eDP-1
[854.937398] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.702s)
[854.949003] Starting dynamic subtest: pipe-C-eDP-1
[860.324013] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.384s)
[860.336592] Starting dynamic subtest: pipe-D-eDP-1
[865.664597] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.338s)
[865.667687] Subtest ctm-0-75: SUCCESS (21.463s)
[866.485473] [133/156] (156s left) kms_sequence (get-forked-busy)
[866.572375] Starting subtest: get-forked-busy
[866.575066] Starting dynamic subtest: pipe-A-eDP-1
[868.502480] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.929s)
[868.514589] Starting dynamic subtest: pipe-B-eDP-1
[871.094969] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.590s)
[871.107339] Starting dynamic subtest: pipe-C-eDP-1
[873.695560] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.598s)
[873.706607] Starting dynamic subtest: pipe-D-eDP-1
[876.332893] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.638s)
[876.335673] Subtest get-forked-busy: SUCCESS (9.761s)
[877.223205] [134/156] (146s left) gem_userptr_blits (coherency-unsync)
[877.301346] Subtest coherency-unsync: SKIP (0.000s)
[877.419835] [135/156] (145s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-plflip-blt)
[877.526479] Starting subtest: fbchdr-2p-primscrn-indfb-plflip-blt
[877.531663] Subtest fbchdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[877.620093] [136/156] (145s left) gem_exec_schedule (pi-ringfull)
[877.799692] Starting subtest: pi-ringfull
[877.801951] Starting dynamic subtest: rcs0
[877.846316] Dynamic subtest rcs0: SUCCESS (0.047s)
[877.858982] Starting dynamic subtest: bcs0
[877.899103] Dynamic subtest bcs0: SUCCESS (0.052s)
[877.910831] Starting dynamic subtest: vcs0
[877.937698] Dynamic subtest vcs0: SUCCESS (0.038s)
[877.949686] Starting dynamic subtest: vcs1
[877.975261] Dynamic subtest vcs1: SUCCESS (0.037s)
[877.989283] Starting dynamic subtest: vecs0
[878.005986] Dynamic subtest vecs0: SUCCESS (0.029s)
[878.020482] Starting dynamic subtest: ccs0
[878.037997] Dynamic subtest ccs0: SUCCESS (0.031s)
[878.040919] Subtest pi-ringfull: SUCCESS (0.240s)
[878.263990] [137/156] (145s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[878.355386] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[878.360224] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[878.448184] [138/156] (144s left) syncobj_timeline (signal-array)
[878.506541] Starting subtest: signal-array
[878.509552] Subtest signal-array: SUCCESS (0.000s)
[878.592941] [139/156] (144s left) kms_flip (2x-flip-vs-suspend)
[878.696055] Starting subtest: 2x-flip-vs-suspend
[878.700654] Subtest 2x-flip-vs-suspend: SKIP (0.002s)
[878.777440] [140/156] (144s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt)
[878.871311] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-blt
[878.876484] Subtest fbchdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[878.955439] [141/156] (144s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-gtt)
[879.059244] Starting subtest: hdr-rgb565-draw-mmap-gtt
[879.064178] Subtest hdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[879.163411] [142/156] (144s left) kms_psr (fbc-psr-cursor-plane-move)
[879.249296] Starting subtest: fbc-psr-cursor-plane-move
[879.251527] Starting dynamic subtest: eDP-1
[879.256299] Dynamic subtest eDP-1: SKIP (0.000s)
[879.260703] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[879.325011] [143/156] (144s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-move)
[879.422214] Starting subtest: psrhdr-2p-primscrn-spr-indfb-move
[879.426380] Subtest psrhdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[879.507277] [144/156] (144s left) perf_pmu (busy-idle)
[879.540148] Starting subtest: busy-idle
[879.542176] Starting dynamic subtest: rcs0
[880.229705] Dynamic subtest rcs0: SUCCESS (0.688s)
[880.244899] Starting dynamic subtest: bcs0
[880.900115] Dynamic subtest bcs0: SUCCESS (0.667s)
[880.917154] Starting dynamic subtest: vcs0
[882.193031] Dynamic subtest vcs0: SUCCESS (1.289s)
[882.208685] Starting dynamic subtest: vcs1
[884.176425] Dynamic subtest vcs1: SUCCESS (1.981s)
[884.191841] Starting dynamic subtest: vecs0
[884.907560] Dynamic subtest vecs0: FAIL (0.662s)
[884.920439] Starting dynamic subtest: ccs0
[886.861110] Dynamic subtest ccs0: FAIL (1.943s)
[886.863526] Subtest busy-idle: FAIL (7.243s)
[886.908241] [145/156] (136s left) gen3_render_linear_blits
[887.022383] [146/156] (136s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[887.078697] Starting subtest: invalid-multi-wait-unsubmitted
[887.081698] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[887.177249] [147/156] (136s left) kms_chamelium_audio (dp-audio)
[887.560675] Subtest dp-audio: SKIP (0.000s)
[888.349767] [148/156] (135s left) kms_cursor_crc (cursor-alpha-transparent)
[888.433452] Starting subtest: cursor-alpha-transparent
[888.436149] Starting dynamic subtest: pipe-A-eDP-1
[889.052682] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.620s)
[889.064167] Starting dynamic subtest: pipe-D-eDP-1
[890.348725] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.293s)
[890.351137] Subtest cursor-alpha-transparent: SUCCESS (1.916s)
[891.235355] [149/156] (132s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-wc)
[891.333717] Starting subtest: fbchdr-rgb101010-draw-mmap-wc
[891.339034] Subtest fbchdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[891.422982] [150/156] (132s left) api_intel_bb (bb-with-allocator)
[891.473662] Starting subtest: bb-with-allocator
[891.477659] Subtest bb-with-allocator: SUCCESS (0.007s)
[891.600051] [151/156] (132s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[891.694381] Starting subtest: psr-rgb565-draw-pwrite
[898.830163] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.143s)
[898.960803] [152/156] (125s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[899.076517] Starting subtest: yf-tiled-64bpp-rotate-0
[899.081492] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[899.195681] [153/156] (124s left) kms_flip (absolute-wf_vblank-interruptible)
[899.297563] Starting subtest: absolute-wf_vblank-interruptible
[899.300278] Starting dynamic subtest: A-eDP1
[907.991721] Dynamic subtest A-eDP1: SUCCESS (8.693s)
[908.003503] Starting dynamic subtest: B-eDP1
[916.720077] Dynamic subtest B-eDP1: SUCCESS (8.725s)
[916.732902] Starting dynamic subtest: C-eDP1
[925.435005] Dynamic subtest C-eDP1: SUCCESS (8.714s)
[925.447696] Starting dynamic subtest: D-eDP1
[934.167242] Dynamic subtest D-eDP1: SUCCESS (8.730s)
[934.170283] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.871s)
[935.392196] [154/156] ( 88s left) kms_psr (psr2-cursor-mmap-cpu)
[935.483344] Starting subtest: psr2-cursor-mmap-cpu
[935.485716] Starting dynamic subtest: eDP-1
[937.167594] Dynamic subtest eDP-1: SUCCESS (1.683s)
[937.170478] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.684s)
[938.036796] [155/156] ( 86s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[938.132209] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[938.136688] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[938.218717] [156/156] ( 85s left) kms_feature_discovery (display-4x)
[938.310637] Starting subtest: display-4x
[938.315719] Subtest display-4x: SKIP (0.000s)
[938.381268] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_mmap_gtt
results: parsing output: 2/ for test: gem_ppgtt
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_rmfb
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: gem_mmap_wc
results: parsing output: 7/ for test: kms_psr2_sf
results: parsing output: 8/ for test: gem_mmap_offset
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: kms_plane_multiple
results: parsing output: 11/ for test: kms_addfb_basic
results: parsing output: 12/ for test: template
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: fbdev
results: parsing output: 16/ for test: gem_fence_thrash
results: parsing output: 17/ for test: gem_lmem_evict
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_pwrite
results: parsing output: 21/ for test: gem_exec_schedule
results: parsing output: 22/ for test: syncobj_wait
results: parsing output: 23/ for test: syncobj_wait
results: parsing output: 24/ for test: kms_cursor_crc
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_pread
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: gem_pxp
results: parsing output: 29/ for test: prime_mmap
results: parsing output: 30/ for test: kms_flip
results: parsing output: 31/ for test: kms_plane_scaling
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: gem_exec_reloc
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_ccs
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: i915_hangman
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_render_copy
results: parsing output: 42/ for test: kms_vblank
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_exec_params
results: parsing output: 45/ for test: gen9_exec_parse
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_plane_cursor
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: vgem_basic
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: api_intel_bb
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: vgem_basic
results: parsing output: 57/ for test: kms_psr2_sf
results: parsing output: 58/ for test: kms_rotation_crc
results: parsing output: 59/ for test: kms_pm_rpm
results: parsing output: 60/ for test: kms_content_protection
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: gem_ctx_persistence
results: parsing output: 63/ for test: gem_mmap_wc
results: parsing output: 64/ for test: kms_invalid_mode
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: prime_busy
results: parsing output: 67/ for test: gem_create
results: parsing output: 68/ for test: i915_suspend
results: parsing output: 69/ for test: kms_plane_scaling
results: parsing output: 70/ for test: gem_eio
results: parsing output: 71/ for test: gem_exec_async
results: parsing output: 72/ for test: gem_userptr_blits
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: perf_pmu
results: parsing output: 75/ for test: gem_ctx_param
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_chamelium_hpd
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_pm_rpm
results: parsing output: 81/ for test: gem_spin_batch
results: parsing output: 82/ for test: gem_exec_reloc
results: parsing output: 83/ for test: gem_partial_pwrite_pread
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: gem_exec_fence
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: i915_drm_fdinfo
results: parsing output: 88/ for test: gem_exec_balancer
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: gem_exec_parallel
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_cursor_crc
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_frontbuffer_tracking
results: parsing output: 98/ for test: gem_lmem_swapping
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: kms_async_flips
results: parsing output: 101/ for test: core_setmaster
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_flip_scaled_crc
results: parsing output: 104/ for test: kms_addfb_basic
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_getfb
results: parsing output: 108/ for test: kms_chamelium_frames
results: parsing output: 109/ for test: gem_render_copy
results: parsing output: 110/ for test: i915_pm_rpm
results: parsing output: 111/ for test: kms_atomic
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_fenced_exec_thrash
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_exec_schedule
results: parsing output: 118/ for test: perf
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_exec_balancer
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_cursor_legacy
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: kms_plane
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: sw_sync
results: parsing output: 130/ for test: kms_lease
results: parsing output: 131/ for test: kms_color
results: parsing output: 132/ for test: kms_sequence
results: parsing output: 133/ for test: gem_userptr_blits
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: gem_exec_schedule
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: syncobj_timeline
results: parsing output: 138/ for test: kms_flip
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: kms_psr
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: perf_pmu
results: parsing output: 144/ for test: gen3_render_linear_blits
results: parsing output: 145/ for test: syncobj_wait
results: parsing output: 146/ for test: kms_chamelium_audio
results: parsing output: 147/ for test: kms_cursor_crc
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: api_intel_bb
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_big_fb
results: parsing output: 152/ for test: kms_flip
results: parsing output: 153/ for test: kms_psr
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: kms_feature_discovery
Done.