[62.854368] Initializing watchdogs
[62.854413]   /dev/watchdog0
[62.868031] [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]
[62.872785] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.875544] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.878857] [001/133] (960s left) gem_workarounds (suspend-resume-context)
[62.977823] Starting subtest: suspend-resume-context
[79.438191] Subtest suspend-resume-context: SUCCESS (1.293s)
[79.572605] [002/133] (943s left) api_intel_bb (crc32)
[79.645899] Starting subtest: crc32
[79.647908] Starting dynamic subtest: rcs0-smem0
[79.941094] Dynamic subtest rcs0-smem0: SUCCESS (0.292s)
[79.952073] Starting dynamic subtest: bcs0-smem0
[80.251903] Dynamic subtest bcs0-smem0: SUCCESS (0.305s)
[80.260986] Starting dynamic subtest: vcs0-smem0
[80.592888] Dynamic subtest vcs0-smem0: SUCCESS (0.334s)
[80.603714] Starting dynamic subtest: vcs1-smem0
[80.907991] Dynamic subtest vcs1-smem0: SUCCESS (0.293s)
[80.919162] Starting dynamic subtest: vecs0-smem0
[81.242061] Dynamic subtest vecs0-smem0: SUCCESS (0.343s)
[81.253349] Starting dynamic subtest: ccs0-smem0
[81.549766] Dynamic subtest ccs0-smem0: SUCCESS (0.300s)
[81.552495] Subtest crc32: SUCCESS (1.875s)
[81.670445] [003/133] (941s left) kms_psr (psr-sprite-plane-move)
[81.756641] Starting subtest: psr-sprite-plane-move
[81.759085] Starting dynamic subtest: eDP-1
[83.489010] Dynamic subtest eDP-1: SUCCESS (1.710s)
[83.491727] Subtest psr-sprite-plane-move: SUCCESS (1.711s)
[84.325936] [004/133] (939s left) kms_display_modes (extended-mode-basic)
[84.422553] Starting subtest: extended-mode-basic
[84.427010] Subtest extended-mode-basic: SKIP (0.000s)
[84.478599] [005/133] (939s left) kms_plane_alpha_blend (constant-alpha-mid)
[84.565731] Starting subtest: constant-alpha-mid
[84.870810] Starting dynamic subtest: pipe-A-eDP-1
[85.755230] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.874s)
[85.764729] Starting dynamic subtest: pipe-D-eDP-1
[87.219976] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.451s)
[87.222191] Subtest constant-alpha-mid: SUCCESS (2.629s)
[88.012180] [006/133] (935s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[88.116060] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[88.118375] Starting dynamic subtest: pipe-A-eDP-1
[99.459139] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.305s)
[99.467101] Starting dynamic subtest: pipe-B-eDP-1
[111.483473] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.009s)
[111.485839] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.316s)
[112.330389] [007/133] (911s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[112.454455] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[112.459091] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[112.556034] [008/133] (911s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[112.651405] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[112.653679] Starting dynamic subtest: A-eDP1
[116.256062] Dynamic subtest A-eDP1: SUCCESS (3.604s)
[116.266288] Starting dynamic subtest: B-eDP1
[119.465640] Dynamic subtest B-eDP1: SUCCESS (3.210s)
[119.475523] Starting dynamic subtest: C-eDP1
[122.596071] Dynamic subtest C-eDP1: SUCCESS (3.128s)
[122.605308] Starting dynamic subtest: D-eDP1
[125.707968] Dynamic subtest D-eDP1: SUCCESS (3.109s)
[125.710283] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.057s)
[126.513784] [009/133] (897s left) i915_drm_fdinfo (busy-hang)
[126.562854] Starting subtest: busy-hang
[126.565133] Starting dynamic subtest: rcs0
[126.603420] Dynamic subtest rcs0: SKIP (0.038s)
[126.613586] Starting dynamic subtest: bcs0
[126.617451] Dynamic subtest bcs0: SKIP (0.001s)
[126.625455] Starting dynamic subtest: vcs0
[126.629613] Dynamic subtest vcs0: SKIP (0.001s)
[126.637635] Starting dynamic subtest: vcs1
[126.641637] Dynamic subtest vcs1: SKIP (0.001s)
[126.648520] Starting dynamic subtest: vecs0
[126.652590] Dynamic subtest vecs0: SKIP (0.000s)
[126.659477] Starting dynamic subtest: ccs0
[126.663538] Dynamic subtest ccs0: SKIP (0.000s)
[126.667545] Subtest busy-hang: SKIP (0.045s)
[126.701045] [010/133] (897s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[126.810641] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[126.814900] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[126.901147] [011/133] (896s left) kms_addfb_basic (unused-modifier)
[126.958141] Starting subtest: unused-modifier
[126.960411] Subtest unused-modifier: SUCCESS (0.000s)
[127.119941] [012/133] (896s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[127.217370] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[127.221450] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[127.310842] [013/133] (896s left) gem_softpin (allocator-fork)
[127.368685] Starting subtest: allocator-fork
[129.582705] Subtest allocator-fork: SUCCESS (2.212s)
[129.714635] [014/133] (894s left) gem_exec_params (invalid-ring)
[129.772977] Starting subtest: invalid-ring
[129.775451] Subtest invalid-ring: SUCCESS (0.000s)
[129.870402] [015/133] (894s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[129.987074] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[136.590148] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.604s)
[136.710151] [016/133] (887s left) gem_exec_balancer (persistence)
[136.980460] Starting subtest: persistence
[137.866284] Subtest persistence: SUCCESS (0.886s)
[137.990583] [017/133] (885s left) gem_exec_reloc (basic-cpu-wc-active)
[138.051664] Subtest basic-cpu-wc-active: SKIP (0.000s)
[138.105120] [018/133] (885s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[138.200976] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[138.205171] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[138.324475] [019/133] (885s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[138.412851] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[138.417094] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[138.481470] [020/133] (885s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[138.593480] Starting subtest: yf-tiled-8bpp-rotate-90
[138.597781] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[138.689547] [021/133] (885s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[138.750474] Starting subtest: multi-wait-all-for-submit-available-submitted
[138.752679] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[138.833312] [022/133] (885s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[138.925155] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[138.928819] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[139.002434] [023/133] (885s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[139.097246] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[139.101100] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[139.173336] [024/133] (885s left) gem_media_vme
[139.294143] [025/133] (884s left) kms_invalid_mode (clock-too-high)
[139.390473] Starting subtest: clock-too-high
[139.392378] Starting dynamic subtest: pipe-A-eDP-1
[139.395811] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[139.403186] Starting dynamic subtest: pipe-B-eDP-1
[139.407108] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[139.414484] Starting dynamic subtest: pipe-C-eDP-1
[139.418235] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[139.425352] Starting dynamic subtest: pipe-D-eDP-1
[139.428841] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[139.432258] Subtest clock-too-high: SKIP (0.003s)
[139.466103] [026/133] (884s left) kms_psr (fbc-psr2-primary-blt)
[139.559914] Starting subtest: fbc-psr2-primary-blt
[139.561908] Starting dynamic subtest: eDP-1
[139.565381] Dynamic subtest eDP-1: SKIP (0.000s)
[139.569026] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[139.642309] [027/133] (884s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[139.728298] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[139.730218] Starting dynamic subtest: pipe-A
[139.753356] Dynamic subtest pipe-A: SKIP (0.020s)
[139.762612] Starting dynamic subtest: pipe-B
[139.784193] Dynamic subtest pipe-B: SKIP (0.031s)
[139.791236] Starting dynamic subtest: pipe-C
[139.815293] Dynamic subtest pipe-C: SKIP (0.030s)
[139.824046] Starting dynamic subtest: pipe-D
[139.846043] Dynamic subtest pipe-D: SKIP (0.031s)
[139.849627] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.114s)
[139.926760] [028/133] (884s left) gem_exec_schedule (out-order)
[139.994685] Starting subtest: out-order
[139.996345] Starting dynamic subtest: rcs0
[140.098303] Dynamic subtest rcs0: SUCCESS (0.108s)
[140.108796] Starting dynamic subtest: vcs0
[140.187492] Dynamic subtest vcs0: SUCCESS (0.089s)
[140.197483] Starting dynamic subtest: vcs1
[140.265517] Dynamic subtest vcs1: SUCCESS (0.077s)
[140.275740] Starting dynamic subtest: vecs0
[140.342229] Dynamic subtest vecs0: SUCCESS (0.076s)
[140.352949] Starting dynamic subtest: ccs0
[140.431786] Dynamic subtest ccs0: SUCCESS (0.089s)
[140.434040] Subtest out-order: SUCCESS (0.442s)
[142.187972] [029/133] (882s left) kms_psr (psr2-no-drrs)
[142.280169] Starting subtest: psr2-no-drrs
[142.282381] Starting dynamic subtest: eDP-1
[143.905822] Dynamic subtest eDP-1: SUCCESS (1.626s)
[143.908035] Subtest psr2-no-drrs: SUCCESS (1.626s)
[144.706256] [030/133] (879s left) gem_exec_balancer (bonded-chain)
[144.781123] Starting subtest: bonded-chain
[151.814422] Subtest bonded-chain: SUCCESS (7.029s)
[152.134291] [031/133] (872s left) kms_chamelium_edid (hdmi-edid-read)
[152.531453] Subtest hdmi-edid-read: SKIP (0.000s)
[153.319187] [032/133] (871s left) kms_content_protection (dp-mst-lic-type-1)
[153.465433] Starting subtest: dp-mst-lic-type-1
[153.470282] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[153.578343] [033/133] (871s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[153.669649] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[153.673839] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[153.743158] [034/133] (870s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[153.846165] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[157.397814] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.554s)
[158.544248] [035/133] (866s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[158.647569] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[158.673229] Starting dynamic subtest: pipe-A-plane-0
[159.106317] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[159.114600] Starting dynamic subtest: pipe-A-plane-3
[159.363898] Dynamic subtest pipe-A-plane-3: SUCCESS (0.254s)
[160.513875] Starting dynamic subtest: pipe-B-plane-0
[160.949875] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[160.962511] Starting dynamic subtest: pipe-B-plane-3
[161.205385] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[161.519053] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.872s)
[162.384032] [036/133] (862s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[162.490387] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[162.494809] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[162.582007] [037/133] (862s left) gem_tiled_fence_blits (normal)
[162.638469] Subtest normal: SKIP (0.000s)
[162.704012] [038/133] (862s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[162.798245] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[162.800481] Starting dynamic subtest: pipe-A-eDP-1
[162.823083] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[162.833481] Starting dynamic subtest: pipe-B-eDP-1
[162.855134] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[162.862953] Starting dynamic subtest: pipe-C-eDP-1
[162.885093] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[162.892948] Starting dynamic subtest: pipe-D-eDP-1
[162.915319] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[162.919492] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[165.036569] [039/133] (859s left) kms_cursor_crc (cursor-alpha-transparent)
[165.140590] Starting subtest: cursor-alpha-transparent
[165.142853] Starting dynamic subtest: pipe-A-eDP-1
[165.760483] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.621s)
[165.770194] Starting dynamic subtest: pipe-D-eDP-1
[167.046608] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.282s)
[167.048993] Subtest cursor-alpha-transparent: SUCCESS (1.906s)
[167.918122] [040/133] (856s left) core_auth (basic-auth)
[167.979803] Starting subtest: basic-auth
[167.981802] Subtest basic-auth: SUCCESS (0.001s)
[168.086665] [041/133] (856s left) kms_getfb (getfb-reject-nv12)
[168.178581] Starting subtest: getfb-reject-nv12
[168.180859] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[168.275224] [042/133] (856s left) kms_psr (fbc-psr-cursor-plane-move)
[168.358210] Starting subtest: fbc-psr-cursor-plane-move
[168.360468] Starting dynamic subtest: eDP-1
[168.364779] Dynamic subtest eDP-1: SKIP (0.000s)
[168.368971] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[168.428804] [043/133] (856s left) gem_userptr_blits (sync-overlap)
[168.493472] Starting subtest: sync-overlap
[168.495835] Subtest sync-overlap: SUCCESS (0.000s)
[168.622110] [044/133] (856s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[168.719609] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[169.514298] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.795s)
[169.672308] [045/133] (855s left) gem_exec_gttfill (multigpu-basic)
[169.844889] Starting subtest: multigpu-basic
[183.108009] Subtest multigpu-basic: SUCCESS (13.264s)
[183.200402] [046/133] (841s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[183.341382] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[183.343710] Starting dynamic subtest: pipe-A-eDP-1
[183.353238] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[183.363844] Starting dynamic subtest: pipe-B-eDP-1
[183.372301] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[183.380550] Starting dynamic subtest: pipe-C-eDP-1
[183.388867] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[183.396743] Starting dynamic subtest: pipe-D-eDP-1
[183.404977] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[183.409159] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[185.569488] [047/133] (839s left) kms_cursor_edge_walk (256x256-top-edge)
[185.650487] Starting subtest: 256x256-top-edge
[185.652793] Starting dynamic subtest: pipe-A-eDP-1
[189.142520] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.493s)
[189.151692] Starting dynamic subtest: pipe-D-eDP-1
[192.242025] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.098s)
[192.244435] Subtest 256x256-top-edge: SUCCESS (6.594s)
[193.056793] [048/133] (832s left) gem_mmap_wc (write-cpu-read-wc)
[193.117866] Subtest write-cpu-read-wc: SKIP (0.000s)
[193.170822] [049/133] (832s left) gem_ctx_isolation (preservation-s3)
[193.221864] Starting subtest: preservation-S3
[193.224257] Starting dynamic subtest: rcs0
[209.472489] Dynamic subtest rcs0: SUCCESS (1.325s)
[209.484442] Starting dynamic subtest: bcs0
[225.504251] Dynamic subtest bcs0: SUCCESS (1.337s)
[225.517100] Starting dynamic subtest: vcs0
[241.485133] Dynamic subtest vcs0: SUCCESS (2.222s)
[241.494266] Starting dynamic subtest: vcs1
[259.462648] Dynamic subtest vcs1: SUCCESS (4.886s)
[259.471925] Starting dynamic subtest: vecs0
[277.468427] Dynamic subtest vecs0: SUCCESS (4.944s)
[277.477779] Starting dynamic subtest: ccs0
[295.469918] Dynamic subtest ccs0: SUCCESS (3.124s)
[295.473712] Subtest preservation-S3: SUCCESS (17.845s)
[295.697534] [050/133] (729s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[297.340539] Starting subtest: dpms-mode-unset-non-lpsp
[298.498863] Subtest dpms-mode-unset-non-lpsp: SKIP (1.138s)
[298.875506] [051/133] (726s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[298.996126] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[299.132381] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.137s)
[299.259441] [052/133] (726s left) gem_mmap_gtt (basic-short)
[299.311522] Subtest basic-short: SKIP (0.000s)
[299.372372] [053/133] (725s left) gem_mmap_gtt (basic-write-gtt)
[299.424471] Subtest basic-write-gtt: SKIP (0.000s)
[299.485565] [054/133] (725s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[299.553773] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[299.664575] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[299.742054] [055/133] (725s left) fbdev (eof)
[299.784388] Starting subtest: eof
[299.787374] Subtest eof: SUCCESS (0.000s)
[299.849606] [056/133] (725s left) kms_plane_cursor (primary)
[299.949569] Starting subtest: primary
[299.954745] Starting dynamic subtest: pipe-A-eDP-1-size-64
[302.550151] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.577s)
[302.575391] Starting dynamic subtest: pipe-A-eDP-1-size-128
[305.160393] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.572s)
[305.182541] Starting dynamic subtest: pipe-A-eDP-1-size-256
[307.772525] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.583s)
[308.086707] Starting dynamic subtest: pipe-B-eDP-1-size-64
[311.322787] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.233s)
[311.345224] Starting dynamic subtest: pipe-B-eDP-1-size-128
[313.943439] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.596s)
[313.964936] Starting dynamic subtest: pipe-B-eDP-1-size-256
[316.535030] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.573s)
[316.851523] Starting dynamic subtest: pipe-C-eDP-1-size-64
[319.714683] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.870s)
[319.739349] Starting dynamic subtest: pipe-C-eDP-1-size-128
[322.028170] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.291s)
[322.053307] Starting dynamic subtest: pipe-C-eDP-1-size-256
[324.230367] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.180s)
[324.549497] Starting dynamic subtest: pipe-D-eDP-1-size-64
[327.526739] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.990s)
[327.552919] Starting dynamic subtest: pipe-D-eDP-1-size-128
[329.760237] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.214s)
[329.785090] Starting dynamic subtest: pipe-D-eDP-1-size-256
[332.002251] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.225s)
[332.312536] Subtest primary: SUCCESS (32.275s)
[333.125128] [057/133] (692s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[333.245878] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[341.777413] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.537s)
[341.893610] [058/133] (683s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[341.948556] Starting subtest: yf-tiled-to-vebox-y-tiled
[341.953710] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[342.136069] [059/133] (683s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[342.236545] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[342.241548] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[342.343883] [060/133] (683s left) kms_universal_plane (universal-plane-pageflip-windowed)
[342.427309] Starting subtest: universal-plane-pageflip-windowed
[342.429716] Starting dynamic subtest: pipe-A-eDP-1
[343.007480] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.581s)
[343.017740] Starting dynamic subtest: pipe-B-eDP-1
[344.285953] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.276s)
[344.294700] Starting dynamic subtest: pipe-C-eDP-1
[345.507620] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.220s)
[345.518220] Starting dynamic subtest: pipe-D-eDP-1
[346.741419] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s)
[346.744552] Subtest universal-plane-pageflip-windowed: SUCCESS (4.315s)
[347.591950] [061/133] (678s left) syncobj_timeline (wait-for-submit-complex)
[347.650692] Starting subtest: wait-for-submit-complex
[347.710553] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[347.784306] [062/133] (677s left) gem_mmap_gtt (big-copy-xy)
[347.842591] Subtest big-copy-XY: SKIP (0.000s)
[347.896873] [063/133] (677s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[347.960142] Starting subtest: yf-tiled-ccs-to-x-tiled
[347.965287] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[348.136472] [064/133] (677s left) kms_dsc (dsc-basic)
[348.240400] Starting subtest: dsc-basic
[348.255347] Subtest dsc-basic: SKIP (0.000s)
[348.323140] [065/133] (677s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[348.422723] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[348.434728] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s)
[348.509171] [066/133] (677s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[348.612437] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[355.286463] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.675s)
[355.389216] [067/133] (670s left) kms_flip (flip-vs-suspend)
[355.478314] Starting subtest: flip-vs-suspend
[355.481189] Starting dynamic subtest: A-eDP1
[404.450005] Dynamic subtest A-eDP1: SUCCESS (4.635s)
[404.461514] Starting dynamic subtest: B-eDP1
[453.453971] Dynamic subtest B-eDP1: SUCCESS (4.500s)
[453.468958] Starting dynamic subtest: C-eDP1
[502.456911] Dynamic subtest C-eDP1: SUCCESS (4.470s)
[502.469125] Starting dynamic subtest: D-eDP1
[551.452214] Dynamic subtest D-eDP1: SUCCESS (4.489s)
[551.454594] Subtest flip-vs-suspend: SUCCESS (18.105s)
[552.691872] [068/133] (473s left) gem_gpgpu_fill (basic)
[552.765906] Starting subtest: basic
[552.768621] Starting dynamic subtest: smem
[552.774645] Dynamic subtest smem: SUCCESS (0.007s)
[552.777166] Subtest basic: SUCCESS (0.008s)
[552.907148] [069/133] (473s left) gem_exec_params (no-bsd)
[552.970605] Starting subtest: no-bsd
[552.975988] Subtest no-bsd: SUCCESS (0.003s)
[554.983436] [070/133] (471s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[555.071945] Starting subtest: psr-1p-primscrn-spr-indfb-move
[562.656191] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.525s)
[562.775831] [071/133] (463s left) gem_exec_schedule (semaphore-codependency)
[562.855537] Starting subtest: semaphore-codependency
[562.861423] Subtest semaphore-codependency: SUCCESS (0.013s)
[563.201975] [072/133] (462s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[563.303169] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[563.307828] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[563.421636] [073/133] (462s left) kms_flip (2x-flip-vs-fences)
[563.519980] Starting subtest: 2x-flip-vs-fences
[563.524401] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[563.616263] [074/133] (462s left) gem_ctx_persistence (legacy-engines-hostile)
[563.673704] Starting subtest: legacy-engines-hostile
[563.676040] Starting dynamic subtest: render
[563.790698] Dynamic subtest render: SUCCESS (0.115s)
[563.802508] Starting dynamic subtest: bsd1
[563.886761] Dynamic subtest bsd1: SUCCESS (0.093s)
[563.898184] Starting dynamic subtest: bsd2
[563.955667] Dynamic subtest bsd2: SUCCESS (0.067s)
[563.965523] Starting dynamic subtest: blt
[564.067169] Dynamic subtest blt: SUCCESS (0.109s)
[564.079814] Starting dynamic subtest: vebox
[564.158369] Dynamic subtest vebox: SUCCESS (0.088s)
[564.160695] Subtest legacy-engines-hostile: SUCCESS (0.484s)
[564.246464] [075/133] (462s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[564.302201] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[564.370115] [076/133] (461s left) perf (gen12-mi-rpc)
[564.483495] Starting subtest: gen12-mi-rpc
[564.485457] Starting dynamic subtest: rcs0
[564.504405] Dynamic subtest rcs0: SUCCESS (0.019s)
[564.506195] Subtest gen12-mi-rpc: SUCCESS (0.020s)
[564.544863] [077/133] (461s left) perf_pmu (init-sema)
[564.580685] Starting subtest: init-sema
[564.582517] Starting dynamic subtest: rcs0
[564.584480] Dynamic subtest rcs0: SUCCESS (0.001s)
[564.593219] Starting dynamic subtest: bcs0
[564.594759] Dynamic subtest bcs0: SUCCESS (0.000s)
[564.602831] Starting dynamic subtest: vcs0
[564.604699] Dynamic subtest vcs0: SUCCESS (0.000s)
[564.612489] Starting dynamic subtest: vcs1
[564.614284] Dynamic subtest vcs1: SUCCESS (0.000s)
[564.621975] Starting dynamic subtest: vecs0
[564.623801] Dynamic subtest vecs0: SUCCESS (0.000s)
[564.631370] Starting dynamic subtest: ccs0
[564.633125] Dynamic subtest ccs0: SUCCESS (0.000s)
[564.634887] Subtest init-sema: SUCCESS (0.006s)
[564.698870] [078/133] (461s left) syncobj_timeline (multi-wait-signaled)
[564.744863] Starting subtest: multi-wait-signaled
[564.746752] Subtest multi-wait-signaled: SUCCESS (0.000s)
[564.851241] [079/133] (461s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[564.951524] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[564.955186] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[565.049846] [080/133] (461s left) gem_softpin (overlap)
[565.106275] Starting subtest: overlap
[565.986768] Subtest overlap: SUCCESS (0.875s)
[566.094861] [081/133] (460s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[566.147291] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[566.253497] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.105s)
[566.332752] [082/133] (460s left) gem_exec_reloc (basic-gtt-noreloc)
[566.395459] Subtest basic-gtt-noreloc: SKIP (0.000s)
[566.458531] [083/133] (460s left) gem_wait (await)
[566.524411] Starting subtest: await
[566.526602] Starting dynamic subtest: all-engines
[567.695462] Dynamic subtest all-engines: SUCCESS (1.169s)
[567.712919] Starting dynamic subtest: rcs0
[568.752701] Dynamic subtest rcs0: SUCCESS (1.052s)
[568.770233] Starting dynamic subtest: bcs0
[569.810473] Dynamic subtest bcs0: SUCCESS (1.053s)
[569.827918] Starting dynamic subtest: vcs0
[570.866294] Dynamic subtest vcs0: SUCCESS (1.051s)
[570.882719] Starting dynamic subtest: vcs1
[571.920318] Dynamic subtest vcs1: SUCCESS (1.050s)
[571.936711] Starting dynamic subtest: vecs0
[572.974340] Dynamic subtest vecs0: SUCCESS (1.050s)
[572.990353] Starting dynamic subtest: ccs0
[574.032620] Dynamic subtest ccs0: SUCCESS (1.054s)
[574.035326] Subtest await: SUCCESS (7.495s)
[574.227595] [FACT gem_wait (await)] new: kernel.kmod_is_loaded.vgem: true
[574.231129] [084/133] (452s left) drm_mm (drm_mm)
[574.279043] Starting subtest: drm_mm
[574.286822] Starting dynamic subtest: drm_test_mm_init
[574.371144] Dynamic subtest drm_test_mm_init: SUCCESS (0.083s)
[574.379617] Starting dynamic subtest: drm_test_mm_debug
[574.458278] Dynamic subtest drm_test_mm_debug: SUCCESS (0.086s)
[574.468274] Starting dynamic subtest: drm_test_mm_align32
[574.547221] Dynamic subtest drm_test_mm_align32: SUCCESS (0.088s)
[574.557380] Starting dynamic subtest: drm_test_mm_align64
[574.643138] Dynamic subtest drm_test_mm_align64: SUCCESS (0.093s)
[574.652802] Starting dynamic subtest: drm_test_mm_lowest
[574.737157] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.094s)
[574.746205] Starting dynamic subtest: drm_test_mm_highest
[574.832225] Dynamic subtest drm_test_mm_highest: SUCCESS (0.092s)
[574.834205] Subtest drm_mm: SUCCESS (0.552s)
[574.985560] [085/133] (451s left) gem_ctx_param (basic)
[575.048976] Starting subtest: basic
[575.051252] Subtest basic: SUCCESS (0.001s)
[575.153592] [086/133] (451s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[575.250887] Starting subtest: plane-primary-overlay-mutable-zpos
[578.911627] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.656s)
[580.090482] [087/133] (446s left) i915_module_load (resize-bar)
[580.135262] Starting subtest: resize-bar
[580.141465] Subtest resize-bar: SKIP (0.006s)
[580.189371] [088/133] (446s left) gem_exec_suspend (basic-s3)
[580.249328] Starting subtest: basic-S3
[580.251633] Starting dynamic subtest: smem
[600.386404] Dynamic subtest smem: SUCCESS (6.618s)
[600.389467] Subtest basic-S3: SUCCESS (6.621s)
[600.588870] [089/133] (426s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[600.722521] Starting subtest: basic-flip-after-cursor-atomic
[601.659162] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.922s)
[602.501594] [090/133] (424s left) kms_lease (lease-revoke)
[602.602973] Starting subtest: lease-revoke
[602.605916] Starting dynamic subtest: pipe-A-eDP-1
[602.635375] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.032s)
[602.644965] Starting dynamic subtest: pipe-B-eDP-1
[602.664921] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.028s)
[602.674325] Starting dynamic subtest: pipe-C-eDP-1
[602.692788] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.028s)
[602.702083] Starting dynamic subtest: pipe-D-eDP-1
[602.720167] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.026s)
[602.722955] Subtest lease-revoke: SUCCESS (0.119s)
[602.842780] [091/133] (424s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[602.946520] Starting subtest: 4-tiled-64bpp-rotate-90
[602.967465] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.020s)
[603.080858] [092/133] (423s left) gem_exec_async (forked-writes)
[603.144202] Starting subtest: forked-writes
[603.147109] Starting dynamic subtest: rcs0
[603.172962] Dynamic subtest rcs0: SUCCESS (0.028s)
[603.184682] Starting dynamic subtest: bcs0
[603.196603] Dynamic subtest bcs0: SUCCESS (0.023s)
[603.205924] Starting dynamic subtest: vcs0
[603.216988] Dynamic subtest vcs0: SUCCESS (0.019s)
[603.233059] Starting dynamic subtest: vcs1
[603.241359] Dynamic subtest vcs1: SUCCESS (0.023s)
[603.252744] Starting dynamic subtest: vecs0
[603.265420] Dynamic subtest vecs0: SUCCESS (0.022s)
[603.276841] Starting dynamic subtest: ccs0
[603.286805] Dynamic subtest ccs0: SUCCESS (0.020s)
[603.289599] Subtest forked-writes: SUCCESS (0.141s)
[603.528957] [093/133] (423s left) kms_cursor_crc (cursor-random-32x10)
[603.679116] Starting subtest: cursor-random-32x10
[603.724930] Subtest cursor-random-32x10: SKIP (0.041s)
[603.967121] [094/133] (423s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[604.070777] Starting subtest: pr-cursor-plane-update-sf
[604.076014] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[604.142971] [095/133] (422s left) perf_pmu (all-busy-idle-check-all)
[604.190138] Starting subtest: all-busy-idle-check-all
[605.377570] Subtest all-busy-idle-check-all: SUCCESS (1.177s)
[605.486662] [096/133] (421s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[605.589760] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[605.594549] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[605.686277] [097/133] (421s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[605.785381] Starting subtest: fbcpsr-slowdraw
[631.014513] Subtest fbcpsr-slowdraw: SUCCESS (25.162s)
[631.138742] [098/133] (396s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[631.253084] Starting subtest: x-tiled-8bpp-rotate-180
[632.477723] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.224s)
[632.602228] [099/133] (394s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[633.185083] Starting subtest: syncobj-backward-timeline-chain-engines
[633.300569] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.116s)
[634.410291] [100/133] (392s left) gem_eio (in-flight-external)
[634.644250] Starting subtest: in-flight-external
[636.442912] Subtest in-flight-external: SUCCESS (1.798s)
[636.580007] [101/133] (390s left) kms_pm_rpm (pm-caching)
[638.512668] Starting subtest: pm-caching
[638.518433] Subtest pm-caching: SKIP (0.000s)
[638.896391] [102/133] (388s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[638.960797] Starting subtest: invalid-smem-bo-on-discrete
[638.966229] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[639.086859] [103/133] (388s left) gem_eio (in-flight-internal-immediate)
[639.300619] Starting subtest: in-flight-internal-immediate
[640.456267] Subtest in-flight-internal-immediate: SUCCESS (1.156s)
[640.570215] [104/133] (386s left) api_intel_bb (delta-check)
[640.624140] Starting subtest: delta-check
[640.627842] Subtest delta-check: SUCCESS (0.008s)
[640.752892] [105/133] (386s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[640.847145] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[640.849548] Starting dynamic subtest: pipe-A-eDP-1
[640.926274] Dynamic subtest pipe-A-eDP-1: SKIP (0.002s)
[640.947784] Starting dynamic subtest: pipe-B-eDP-1
[641.023370] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[641.044948] Starting dynamic subtest: pipe-C-eDP-1
[641.117376] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[641.128703] Starting dynamic subtest: pipe-D-eDP-1
[641.194098] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[641.199318] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.010s)
[643.157859] [106/133] (384s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[643.250350] Starting subtest: bad-pixel-format-yf-tiled-ccs
[643.253636] Starting dynamic subtest: pipe-A-eDP-1
[643.278029] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[643.287730] Starting dynamic subtest: pipe-B-eDP-1
[643.313024] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[643.322444] Starting dynamic subtest: pipe-C-eDP-1
[643.348379] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[643.357644] Starting dynamic subtest: pipe-D-eDP-1
[643.383842] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[643.389301] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.005s)
[645.528918] [107/133] (382s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[645.634740] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[645.639226] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[645.729050] [108/133] (381s left) gem_exec_fence (basic-wait-all)
[645.781813] Starting subtest: basic-wait-all
[645.867437] Subtest basic-wait-all: SUCCESS (0.086s)
[647.451144] [109/133] (380s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[647.551181] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[648.505290] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.956s)
[648.682998] [110/133] (379s left) syncobj_timeline (wait-all-snapshot)
[648.752291] Starting subtest: wait-all-snapshot
[648.832263] Subtest wait-all-snapshot: SUCCESS (0.082s)
[648.908984] [111/133] (378s left) kms_chamelium_color (ctm-negative)
[648.996381] Subtest ctm-negative: SKIP (0.000s)
[649.042087] [112/133] (378s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[649.161171] Starting subtest: cursorB-vs-flipA-legacy
[649.165947] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[649.304085] [113/133] (378s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[649.417118] Starting subtest: flip-vs-cursor-varying-size
[658.044362] Subtest flip-vs-cursor-varying-size: SUCCESS (8.625s)
[658.868220] [114/133] (369s left) kms_flip (flip-vs-panning)
[658.955331] Starting subtest: flip-vs-panning
[658.958295] Starting dynamic subtest: A-eDP1
[667.674313] Dynamic subtest A-eDP1: SUCCESS (8.719s)
[667.685856] Starting dynamic subtest: B-eDP1
[676.401275] Dynamic subtest B-eDP1: SUCCESS (8.723s)
[676.411431] Starting dynamic subtest: C-eDP1
[685.136087] Dynamic subtest C-eDP1: SUCCESS (8.732s)
[685.149217] Starting dynamic subtest: D-eDP1
[693.864124] Dynamic subtest D-eDP1: SUCCESS (8.722s)
[693.866834] Subtest flip-vs-panning: SUCCESS (34.909s)
[695.033116] [115/133] (332s left) gem_create (create-ext-cpu-access-sanity-check)
[695.211945] Starting subtest: create-ext-cpu-access-sanity-check
[695.217367] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[695.283188] [116/133] (332s left) prime_busy (hang)
[695.354631] Starting subtest: hang
[695.357517] Starting dynamic subtest: rcs0
[721.882782] Dynamic subtest rcs0: SUCCESS (26.517s)
[721.892538] Starting dynamic subtest: bcs0
[729.034545] Dynamic subtest bcs0: SUCCESS (7.150s)
[729.046549] Starting dynamic subtest: vcs0
[736.012375] Dynamic subtest vcs0: SUCCESS (6.975s)
[736.024365] Starting dynamic subtest: vcs1
[743.051762] Dynamic subtest vcs1: SUCCESS (7.033s)
[743.062450] Starting dynamic subtest: vecs0
[750.024351] Dynamic subtest vecs0: SUCCESS (6.968s)
[750.035243] Starting dynamic subtest: ccs0
[763.936230] Dynamic subtest ccs0: SUCCESS (13.906s)
[763.939130] Subtest hang: SUCCESS (68.557s)
[764.043572] [117/133] (263s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[764.146580] Starting subtest: plane-lut1d-pre-ctm3x4
[764.280328] Starting dynamic subtest: pipe-A-plane-0
[764.656240] Dynamic subtest pipe-A-plane-0: FAIL (0.182s)
[764.665725] Starting dynamic subtest: pipe-A-plane-1
[764.897318] Dynamic subtest pipe-A-plane-1: FAIL (0.169s)
[764.907101] Starting dynamic subtest: pipe-A-plane-2
[765.126877] Dynamic subtest pipe-A-plane-2: FAIL (0.165s)
[765.973098] Starting dynamic subtest: pipe-B-plane-0
[766.480535] Dynamic subtest pipe-B-plane-0: FAIL (0.197s)
[766.491778] Starting dynamic subtest: pipe-B-plane-1
[766.856168] Dynamic subtest pipe-B-plane-1: FAIL (0.166s)
[766.867412] Starting dynamic subtest: pipe-B-plane-2
[767.202946] Dynamic subtest pipe-B-plane-2: FAIL (0.692s)
[768.197802] Starting dynamic subtest: pipe-C-plane-0
[768.770284] Dynamic subtest pipe-C-plane-0: FAIL (0.151s)
[768.780357] Starting dynamic subtest: pipe-C-plane-1
[769.212259] Dynamic subtest pipe-C-plane-1: FAIL (0.724s)
[769.223654] Starting dynamic subtest: pipe-C-plane-2
[769.664113] Dynamic subtest pipe-C-plane-2: FAIL (0.173s)
[770.420995] Starting dynamic subtest: pipe-D-plane-0
[771.091321] Dynamic subtest pipe-D-plane-0: FAIL (0.140s)
[771.102978] Starting dynamic subtest: pipe-D-plane-1
[771.630932] Dynamic subtest pipe-D-plane-1: FAIL (0.682s)
[771.641554] Starting dynamic subtest: pipe-D-plane-2
[772.137839] Dynamic subtest pipe-D-plane-2: FAIL (0.606s)
[772.139795] Subtest plane-lut1d-pre-ctm3x4: FAIL (7.987s)
[773.003071] [118/133] (255s left) kms_psr (pr-sprite-mmap-gtt)
[773.096079] Starting subtest: pr-sprite-mmap-gtt
[773.100639] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[773.165852] [119/133] (254s left) i915_query (hwconfig_table)
[773.229932] Starting subtest: hwconfig_table
[773.552903] Subtest hwconfig_table: SUCCESS (0.001s)
[773.593597] [120/133] (254s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[773.696370] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[773.701333] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[773.804245] [121/133] (254s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[774.183293] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[775.010221] [122/133] (253s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[775.107181] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[775.112572] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[775.219448] [123/133] (253s left) gem_workarounds (basic-read)
[775.295446] Starting subtest: basic-read
[775.308878] Subtest basic-read: SUCCESS (0.014s)
[775.434019] [124/133] (252s left) gen9_exec_parse (secure-batches)
[775.507798] Subtest secure-batches: SKIP (0.000s)
[775.574562] [125/133] (252s left) syncobj_wait (multi-wait-for-submit-submitted)
[775.636340] Starting subtest: multi-wait-for-submit-submitted
[775.740569] Subtest multi-wait-for-submit-submitted: SUCCESS (0.105s)
[775.844538] [126/133] (252s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[775.942401] Starting subtest: y-tiled-64bpp-rotate-270
[775.947516] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[776.039861] [127/133] (252s left) gem_mmap_gtt (flink-race)
[776.101458] Subtest flink-race: SKIP (0.000s)
[776.164154] [128/133] (252s left) syncobj_wait (wait-all-delayed-signal)
[776.214030] Starting subtest: wait-all-delayed-signal
[776.317250] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[776.407983] [129/133] (252s left) gem_exec_whisper (basic-fds-priority)
[776.478047] Starting subtest: basic-fds-priority
[800.512446] Subtest basic-fds-priority: SUCCESS (24.029s)
[800.707981] [130/133] (227s left) kms_plane (plane-position-hole-dpms)
[800.802254] Starting subtest: plane-position-hole-dpms
[801.338346] Starting dynamic subtest: pipe-A-plane-1
[803.701197] Dynamic subtest pipe-A-plane-1: SUCCESS (2.366s)
[803.710930] Starting dynamic subtest: pipe-A-plane-2
[806.122187] Dynamic subtest pipe-A-plane-2: SUCCESS (2.419s)
[806.132428] Starting dynamic subtest: pipe-A-plane-3
[808.550587] Dynamic subtest pipe-A-plane-3: SUCCESS (2.429s)
[808.561394] Starting dynamic subtest: pipe-A-plane-4
[810.896447] Dynamic subtest pipe-A-plane-4: SUCCESS (2.343s)
[810.906785] Starting dynamic subtest: pipe-A-plane-5
[810.920829] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[812.100991] Starting dynamic subtest: pipe-B-plane-1
[814.515021] Dynamic subtest pipe-B-plane-1: SUCCESS (2.427s)
[814.526010] Starting dynamic subtest: pipe-B-plane-2
[816.901518] Dynamic subtest pipe-B-plane-2: SUCCESS (2.387s)
[816.911278] Starting dynamic subtest: pipe-B-plane-3
[819.337538] Dynamic subtest pipe-B-plane-3: SUCCESS (2.436s)
[819.348251] Starting dynamic subtest: pipe-B-plane-4
[821.702691] Dynamic subtest pipe-B-plane-4: SUCCESS (2.363s)
[821.713185] Starting dynamic subtest: pipe-B-plane-5
[821.727417] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[821.730167] Subtest plane-position-hole-dpms: SUCCESS (20.928s)
[822.496347] [131/133] (206s left) i915_pm_rpm (gem-mmap-type)
[824.540454] Starting subtest: gem-mmap-type
[824.543494] Starting dynamic subtest: wb-smem0
[828.343027] Dynamic subtest wb-smem0: SUCCESS (3.804s)
[828.353499] Starting dynamic subtest: wc-smem0
[831.540230] Dynamic subtest wc-smem0: SUCCESS (3.198s)
[831.554371] Starting dynamic subtest: uc-smem0
[834.731212] Dynamic subtest uc-smem0: SUCCESS (3.190s)
[834.733552] Subtest gem-mmap-type: SUCCESS (10.195s)
[834.820228] [132/133] (193s left) kms_vblank (ts-continuation-idle-hang)
[834.925391] Starting subtest: ts-continuation-idle-hang
[834.927773] Starting dynamic subtest: pipe-A-eDP-1
[861.134893] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.210s)
[861.150460] Starting dynamic subtest: pipe-D-eDP-1
[886.158280] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.016s)
[886.160633] Subtest ts-continuation-idle-hang: SUCCESS (51.230s)
[886.978611] [133/133] (141s left) syncobj_wait (invalid-reset-bad-pad)
[887.040673] Starting subtest: invalid-reset-bad-pad
[887.043498] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[887.132777] 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.