[56.222222] Initializing watchdogs
[56.222271]   /dev/watchdog0
[56.235596] [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.239780] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.241968] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.245301] [001/131] (960s left) gem_tiled_wb
[56.428174] [002/131] (960s left) kms_force_connector_basic (prune-stale-modes)
[56.518904] Starting subtest: prune-stale-modes
[56.931251] Subtest prune-stale-modes: SUCCESS (0.409s)
[57.070564] [003/131] (959s left) kms_feature_discovery (display-2x)
[57.172876] Starting subtest: display-2x
[57.176479] Subtest display-2x: SKIP (0.000s)
[57.249761] [004/131] (959s left) gem_eio (execbuf)
[57.403298] Starting subtest: execbuf
[57.564250] Subtest execbuf: SUCCESS (0.160s)
[57.674199] [005/131] (959s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[57.774641] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[57.776586] Starting dynamic subtest: pipe-A-default-mode
[58.082664] Dynamic subtest pipe-A-default-mode: SKIP (0.300s)
[58.087299] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.301s)
[58.941205] [006/131] (958s left) api_intel_bb (delta-check)
[59.003104] Starting subtest: delta-check
[59.008974] Subtest delta-check: SUCCESS (0.007s)
[59.115875] [007/131] (957s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-wc)
[59.224265] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-wc
[62.284792] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (3.049s)
[62.414166] [008/131] (954s left) gem_exec_flush (basic-wb-set-default)
[62.478535] Starting subtest: basic-wb-set-default
[67.965357] Subtest basic-wb-set-default: SUCCESS (5.472s)
[68.142571] [009/131] (948s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[68.230949] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[68.376909] [010/131] (948s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[68.474821] Starting subtest: y-tiled-8bpp-rotate-180
[68.479186] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[68.584170] [011/131] (948s left) kms_prime (basic-modeset-hybrid)
[70.994027] Subtest basic-modeset-hybrid: SKIP (0.000s)
[71.137749] [FACT kms_prime (basic-modeset-hybrid)] new: kernel.kmod_is_loaded.amdgpu: true
[71.139341] [FACT kms_prime (basic-modeset-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[71.139752] [FACT kms_prime (basic-modeset-hybrid)] new: kernel.kmod_is_loaded.xe: true
[71.143287] [012/131] (946s left) kms_cursor_crc (cursor-onscreen-512x170)
[71.604761] Starting subtest: cursor-onscreen-512x170
[71.610616] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[71.859138] [013/131] (945s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[72.008270] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[72.010807] Starting dynamic subtest: A-eDP1
[81.011867] Dynamic subtest A-eDP1: SUCCESS (8.995s)
[81.020507] Starting dynamic subtest: B-eDP1
[89.911276] Dynamic subtest B-eDP1: SUCCESS (8.895s)
[89.918818] Starting dynamic subtest: C-eDP1
[98.805296] Dynamic subtest C-eDP1: SUCCESS (8.891s)
[98.813775] Starting dynamic subtest: D-eDP1
[107.702507] Dynamic subtest D-eDP1: SUCCESS (8.894s)
[107.707264] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.685s)
[108.889336] [014/131] (908s left) syncobj_eventfd (timeline-wait-signaled)
[108.942583] Starting subtest: timeline-wait-signaled
[108.944907] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[109.050261] [015/131] (908s left) kms_atomic_transition (plane-toggle-modeset-transition)
[109.149400] Starting subtest: plane-toggle-modeset-transition
[109.151820] Starting dynamic subtest: pipe-A-eDP-1
[121.803185] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.651s)
[121.814070] Starting dynamic subtest: pipe-B-eDP-1
[134.210231] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.400s)
[134.212878] Subtest plane-toggle-modeset-transition: SUCCESS (25.058s)
[135.091774] [016/131] (882s left) gem_render_copy (linear-to-vebox-yf-tiled)
[135.146488] Starting subtest: linear-to-vebox-yf-tiled
[135.151273] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[135.320634] [017/131] (882s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[135.437597] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[135.442189] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[135.532415] [018/131] (881s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[135.634808] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[135.637083] Starting dynamic subtest: pipe-A-eDP-1
[151.717013] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.463s)
[151.734213] Starting dynamic subtest: pipe-B-eDP-1
[168.607103] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.251s)
[168.615892] Starting dynamic subtest: pipe-C-eDP-1
[185.575801] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.250s)
[185.584598] Starting dynamic subtest: pipe-D-eDP-1
[202.589682] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.287s)
[202.592241] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.254s)
[203.857238] [019/131] (872s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[203.968862] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[203.974499] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[204.084011] [020/131] (872s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[204.187813] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[204.193627] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[204.285082] [021/131] (872s left) syncobj_wait (invalid-reset-one-illegal-handle)
[204.348096] Starting subtest: invalid-reset-one-illegal-handle
[204.350932] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[204.450575] [022/131] (871s left) gem_mmap_gtt (coherency)
[204.518759] Subtest coherency: SKIP (0.000s)
[204.577628] [023/131] (871s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[204.752095] Starting subtest: cursor-rapid-movement-64x21
[204.793097] Subtest cursor-rapid-movement-64x21: SKIP (0.034s)
[205.027667] [024/131] (871s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[205.128085] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[205.130459] Starting dynamic subtest: pipe-A-eDP-1
[205.152931] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[205.162580] Starting dynamic subtest: pipe-B-eDP-1
[205.185177] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[205.192934] Starting dynamic subtest: pipe-C-eDP-1
[205.214317] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[205.221932] Starting dynamic subtest: pipe-D-eDP-1
[205.243258] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[205.247172] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[207.406315] [025/131] (869s left) kms_draw_crc (draw-method-pwrite)
[207.511937] Starting subtest: draw-method-pwrite
[207.514386] Starting dynamic subtest: xrgb8888-untiled
[208.102671] Dynamic subtest xrgb8888-untiled: SUCCESS (0.585s)
[208.111963] Starting dynamic subtest: rgb565-untiled
[208.573201] Dynamic subtest rgb565-untiled: SUCCESS (0.467s)
[208.584562] Starting dynamic subtest: xrgb2101010-untiled
[209.123557] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.544s)
[209.132977] Starting dynamic subtest: xbgr16161616f-untiled
[209.886084] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.755s)
[209.896901] Starting dynamic subtest: xrgb8888-xtiled
[211.699687] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.800s)
[211.709996] Starting dynamic subtest: rgb565-xtiled
[212.828925] Dynamic subtest rgb565-xtiled: SUCCESS (1.122s)
[212.838727] Starting dynamic subtest: xrgb2101010-xtiled
[214.704878] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.866s)
[214.713358] Starting dynamic subtest: xbgr16161616f-xtiled
[218.006761] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.289s)
[218.016904] Starting dynamic subtest: xrgb8888-4tiled
[219.143898] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.133s)
[219.152718] Starting dynamic subtest: rgb565-4tiled
[219.712590] Dynamic subtest rgb565-4tiled: SUCCESS (0.567s)
[219.720596] Starting dynamic subtest: xrgb2101010-4tiled
[220.837496] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.121s)
[220.845708] Starting dynamic subtest: xbgr16161616f-4tiled
[223.832492] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.988s)
[223.835485] Subtest draw-method-pwrite: SUCCESS (16.242s)
[223.923823] [026/131] (852s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[224.034904] Starting subtest: 4-tiled-16bpp-rotate-270
[224.054760] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[224.161242] [027/131] (852s left) kms_chamelium_frames (dp-frame-dump)
[224.545925] Subtest dp-frame-dump: SKIP (0.000s)
[225.367032] [028/131] (851s left) kms_vblank (wait-forked-busy-hang)
[225.472471] Starting subtest: wait-forked-busy-hang
[225.475063] Starting dynamic subtest: pipe-A-eDP-1
[252.344385] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.863s)
[252.357452] Starting dynamic subtest: pipe-D-eDP-1
[277.232004] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.880s)
[277.234635] Subtest wait-forked-busy-hang: SUCCESS (51.747s)
[278.090115] [029/131] (798s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[278.196953] Starting subtest: psr-rgb565-draw-render
[283.129381] Subtest psr-rgb565-draw-render: SUCCESS (4.934s)
[283.269536] [030/131] (793s left) syncobj_timeline (wait-all-snapshot)
[283.330079] Starting subtest: wait-all-snapshot
[283.411187] Subtest wait-all-snapshot: SUCCESS (0.081s)
[283.482392] [031/131] (793s left) kms_pm_dc (dc5-dpms)
[284.593824] Starting subtest: dc5-dpms
[286.646138] Subtest dc5-dpms: SUCCESS (2.052s)
[286.743764] [032/131] (790s left) kms_cursor_edge_walk (256x256-top-bottom)
[286.849310] Starting subtest: 256x256-top-bottom
[286.851752] Starting dynamic subtest: pipe-A-eDP-1
[290.334601] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.483s)
[290.343789] Starting dynamic subtest: pipe-D-eDP-1
[293.533209] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.196s)
[293.535860] Subtest 256x256-top-bottom: SUCCESS (6.681s)
[294.399415] [033/131] (782s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[294.501447] Starting subtest: x-tiled-16bpp-rotate-90
[294.521912] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s)
[294.631447] [034/131] (782s left) kms_flip (2x-plain-flip-ts-check)
[294.724674] Starting subtest: 2x-plain-flip-ts-check
[294.735564] Subtest 2x-plain-flip-ts-check: SKIP (0.010s)
[294.854300] [035/131] (782s left) kms_plane_scaling (plane-downscale-factor-0-25-with-rotation)
[294.963608] Starting subtest: plane-downscale-factor-0-25-with-rotation
[294.966140] Starting dynamic subtest: pipe-A
[294.982486] Dynamic subtest pipe-A: SKIP (0.011s)
[294.991157] Starting dynamic subtest: pipe-B
[295.001667] Dynamic subtest pipe-B: SKIP (0.021s)
[295.009863] Starting dynamic subtest: pipe-C
[295.025344] Dynamic subtest pipe-C: SKIP (0.021s)
[295.033302] Starting dynamic subtest: pipe-D
[295.046373] Dynamic subtest pipe-D: SKIP (0.021s)
[295.050713] Subtest plane-downscale-factor-0-25-with-rotation: SKIP (0.076s)
[295.129972] [036/131] (781s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[295.232683] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[295.237936] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[295.325791] [037/131] (781s left) gem_pread (self)
[295.385858] Subtest self: SKIP (0.000s)
[295.461209] [038/131] (781s left) kms_psr (psr2-no-drrs)
[295.566397] Starting subtest: psr2-no-drrs
[295.568633] Starting dynamic subtest: eDP-1
[297.134968] Dynamic subtest eDP-1: SUCCESS (1.568s)
[297.137573] Subtest psr2-no-drrs: SUCCESS (1.568s)
[298.001600] [039/131] (779s left) perf (oa-exponents)
[298.124333] Starting subtest: oa-exponents
[298.126240] Starting dynamic subtest: 0-rcs0
[299.982256] Dynamic subtest 0-rcs0: SUCCESS (1.859s)
[299.990235] Starting dynamic subtest: 1-vecs0
[301.892076] Dynamic subtest 1-vecs0: SUCCESS (1.910s)
[301.894746] Subtest oa-exponents: SUCCESS (3.770s)
[301.937020] [040/131] (775s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[302.053746] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[302.058703] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[302.193302] [041/131] (775s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[302.312712] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[307.218483] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.912s)
[307.337728] [042/131] (769s left) syncobj_wait (multi-wait-signaled)
[307.406277] Starting subtest: multi-wait-signaled
[307.408678] Subtest multi-wait-signaled: SUCCESS (0.000s)
[307.506480] [043/131] (769s left) kms_psr (fbc-pr-sprite-render)
[307.601496] Starting subtest: fbc-pr-sprite-render
[307.606707] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[307.668683] [044/131] (769s left) gen9_exec_parse (valid-registers)
[307.737493] Subtest valid-registers: SKIP (0.000s)
[307.818195] [045/131] (769s left) gem_lmem_swapping (heavy-random)
[307.863657] Subtest heavy-random: SKIP (0.000s)
[307.908228] [046/131] (769s left) gem_exec_balancer (bonded-dual)
[307.981584] Starting subtest: bonded-dual
[307.986942] Subtest bonded-dual: SKIP (0.000s)
[308.257506] [047/131] (769s left) gem_busy (extended)
[308.447536] Starting subtest: extended
[308.450291] Starting dynamic subtest: rcs0
[308.546916] Dynamic subtest rcs0: SUCCESS (0.099s)
[308.558950] Starting dynamic subtest: bcs0
[308.588837] Dynamic subtest bcs0: SUCCESS (0.041s)
[308.597762] Starting dynamic subtest: vcs0
[310.524390] Dynamic subtest vcs0: SUCCESS (1.933s)
[310.534776] Starting dynamic subtest: vcs1
[312.507197] Dynamic subtest vcs1: SUCCESS (1.981s)
[312.518587] Starting dynamic subtest: vecs0
[314.493382] Dynamic subtest vecs0: SUCCESS (1.984s)
[314.503663] Starting dynamic subtest: ccs0
[314.537633] Dynamic subtest ccs0: SUCCESS (0.044s)
[314.540495] Subtest extended: SUCCESS (6.091s)
[314.783408] [048/131] (762s left) perf_pmu (busy-accuracy-2)
[314.826067] Starting subtest: busy-accuracy-2
[314.828643] Starting dynamic subtest: rcs0
[317.891364] Dynamic subtest rcs0: SUCCESS (3.061s)
[317.899980] Starting dynamic subtest: bcs0
[320.955660] Dynamic subtest bcs0: SUCCESS (3.067s)
[320.967232] Starting dynamic subtest: vcs0
[324.001735] Dynamic subtest vcs0: SUCCESS (3.044s)
[324.012501] Starting dynamic subtest: vcs1
[327.051834] Dynamic subtest vcs1: SUCCESS (3.048s)
[327.063672] Starting dynamic subtest: vecs0
[330.102552] Dynamic subtest vecs0: SUCCESS (3.049s)
[330.112603] Starting dynamic subtest: ccs0
[333.164918] Dynamic subtest ccs0: SUCCESS (3.061s)
[333.167405] Subtest busy-accuracy-2: SUCCESS (18.338s)
[333.297993] [049/131] (744s left) kms_psr (fbc-psr-cursor-render)
[333.404637] Starting subtest: fbc-psr-cursor-render
[333.407339] Starting dynamic subtest: eDP-1
[333.412492] Dynamic subtest eDP-1: SKIP (0.000s)
[333.417643] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[333.474950] [050/131] (744s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[333.575942] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[333.581531] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[333.654771] [051/131] (743s left) kms_chamelium_frames (hdmi-crc-multiple)
[334.044272] Subtest hdmi-crc-multiple: SKIP (0.000s)
[334.876328] [052/131] (742s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[334.985753] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[336.008132] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.023s)
[336.180717] [053/131] (741s left) kms_psr (fbc-psr-sprite-plane-onoff)
[336.280420] Starting subtest: fbc-psr-sprite-plane-onoff
[336.282989] Starting dynamic subtest: eDP-1
[336.287842] Dynamic subtest eDP-1: SKIP (0.000s)
[336.293275] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[336.349047] [054/131] (741s left) drm_fdinfo (memory-info-active)
[336.395912] Starting subtest: memory-info-active
[336.398791] Starting dynamic subtest: smem0
[339.437823] Dynamic subtest smem0: SUCCESS (3.040s)
[339.441081] Subtest memory-info-active: SUCCESS (3.041s)
[339.510185] [055/131] (738s left) kms_legacy_colorkey (invalid-plane)
[339.613735] Starting subtest: invalid-plane
[339.616698] Starting dynamic subtest: zero-id
[339.619403] Dynamic subtest zero-id: SUCCESS (0.000s)
[339.629317] Starting dynamic subtest: outrange-id
[339.631922] Dynamic subtest outrange-id: SUCCESS (0.000s)
[339.634575] Subtest invalid-plane: SUCCESS (0.001s)
[339.683008] [056/131] (738s left) gem_ctx_freq (sysfs)
[339.740741] Starting subtest: sysfs
[339.743640] Starting dynamic subtest: gt0
[345.262331] Dynamic subtest gt0: SUCCESS (5.520s)
[345.272533] Starting dynamic subtest: gt1
[386.491001] Dynamic subtest gt1: SUCCESS (41.217s)
[386.494218] Subtest sysfs: SUCCESS (46.739s)
[386.573011] [057/131] (691s left) kms_psr (psr-no-drrs)
[386.675739] Starting subtest: psr-no-drrs
[386.678457] Starting dynamic subtest: eDP-1
[388.252608] Dynamic subtest eDP-1: SUCCESS (1.573s)
[388.254850] Subtest psr-no-drrs: SUCCESS (1.574s)
[389.114638] [058/131] (688s left) gem_mmap_gtt (medium-copy-xy)
[389.175754] Subtest medium-copy-XY: SKIP (0.000s)
[389.227240] [059/131] (688s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[394.289820] Starting subtest: pr-overlay-plane-move-continuous-sf
[394.295482] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.005s)
[395.098568] [060/131] (682s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[395.208679] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[395.213452] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[395.328293] [061/131] (682s left) sysfs_heartbeat_interval (nopreempt)
[395.393939] Starting subtest: nopreempt
[395.396742] Starting dynamic subtest: vecs0
[404.462825] Dynamic subtest vecs0: SUCCESS (9.063s)
[404.473930] Starting dynamic subtest: ccs0
[408.414191] Dynamic subtest ccs0: SUCCESS (3.950s)
[408.425437] Starting dynamic subtest: vcs0
[417.537272] Dynamic subtest vcs0: SUCCESS (9.120s)
[417.548903] Starting dynamic subtest: bcs0
[421.440918] Dynamic subtest bcs0: SUCCESS (3.900s)
[421.449902] Starting dynamic subtest: rcs0
[425.427674] Dynamic subtest rcs0: SUCCESS (3.984s)
[425.436697] Starting dynamic subtest: vcs1
[434.512818] Dynamic subtest vcs1: SUCCESS (9.085s)
[434.515905] Subtest nopreempt: SUCCESS (39.110s)
[434.585130] [062/131] (643s left) prime_busy (hang)
[434.646849] Starting subtest: hang
[434.649765] Starting dynamic subtest: rcs0
[461.008913] Dynamic subtest rcs0: SUCCESS (26.363s)
[461.018859] Starting dynamic subtest: bcs0
[468.167933] Dynamic subtest bcs0: SUCCESS (7.157s)
[468.177939] Starting dynamic subtest: vcs0
[475.151133] Dynamic subtest vcs0: SUCCESS (6.987s)
[475.159825] Starting dynamic subtest: vcs1
[482.181914] Dynamic subtest vcs1: SUCCESS (7.026s)
[482.192825] Starting dynamic subtest: vecs0
[489.156209] Dynamic subtest vecs0: SUCCESS (6.974s)
[489.164761] Starting dynamic subtest: ccs0
[502.994101] Dynamic subtest ccs0: SUCCESS (13.837s)
[502.996726] Subtest hang: SUCCESS (68.350s)
[503.127832] [063/131] (574s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[503.241542] Starting subtest: yf-tiled-32bpp-rotate-180
[503.246530] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[503.338513] [064/131] (574s left) i915_selftest (live)
[505.304581] Starting subtest: live
[505.307258] Starting dynamic subtest: sanitycheck
[509.975742] Dynamic subtest sanitycheck: SUCCESS (4.670s)
[509.988757] Starting dynamic subtest: uncore
[512.942783] Dynamic subtest uncore: SUCCESS (2.965s)
[512.955943] Starting dynamic subtest: workarounds
[516.385791] Dynamic subtest workarounds: SUCCESS (3.441s)
[516.394898] Starting dynamic subtest: gt_engines
[519.800485] Dynamic subtest gt_engines: SUCCESS (3.413s)
[519.810204] Starting dynamic subtest: gt_timelines
[535.539687] Dynamic subtest gt_timelines: SUCCESS (15.736s)
[535.548950] Starting dynamic subtest: gt_contexts
[538.612705] Dynamic subtest gt_contexts: SUCCESS (3.071s)
[538.622517] Starting dynamic subtest: gt_lrc
[543.300914] Dynamic subtest gt_lrc: SUCCESS (4.686s)
[543.310711] Starting dynamic subtest: gt_mocs
[546.536394] Dynamic subtest gt_mocs: SUCCESS (3.234s)
[546.545916] Starting dynamic subtest: gt_pm
[551.607064] Dynamic subtest gt_pm: SUCCESS (5.069s)
[551.616606] Starting dynamic subtest: gt_heartbeat
[556.231330] Dynamic subtest gt_heartbeat: SUCCESS (4.622s)
[556.241128] Starting dynamic subtest: gt_tlb
[565.248961] Dynamic subtest gt_tlb: SUCCESS (9.014s)
[565.258224] Starting dynamic subtest: requests
[577.177064] Dynamic subtest requests: SUCCESS (11.925s)
[577.186324] Starting dynamic subtest: migrate
[584.072341] Dynamic subtest migrate: SUCCESS (6.893s)
[584.082102] Starting dynamic subtest: active
[588.644108] Dynamic subtest active: SUCCESS (4.569s)
[588.653841] Starting dynamic subtest: objects
[593.581343] Dynamic subtest objects: SUCCESS (4.936s)
[593.590520] Starting dynamic subtest: mman
[598.706699] Dynamic subtest mman: SUCCESS (5.123s)
[598.716201] Starting dynamic subtest: dmabuf
[603.391284] Dynamic subtest dmabuf: SUCCESS (4.683s)
[603.401440] Starting dynamic subtest: vma
[606.355449] Dynamic subtest vma: SUCCESS (2.962s)
[606.365319] Starting dynamic subtest: coherency
[610.547463] Dynamic subtest coherency: SUCCESS (4.189s)
[610.557156] Starting dynamic subtest: gtt
[622.807109] Dynamic subtest gtt: SUCCESS (12.256s)
[622.816486] Starting dynamic subtest: gem
[630.054333] Dynamic subtest gem: SUCCESS (7.245s)
[630.063934] Starting dynamic subtest: evict
[635.811942] Dynamic subtest evict: SUCCESS (5.755s)
[635.821518] Starting dynamic subtest: hugepages
[645.646140] Dynamic subtest hugepages: SUCCESS (9.831s)
[645.655436] Starting dynamic subtest: gem_contexts
[670.187518] Dynamic subtest gem_contexts: SUCCESS (24.535s)
[670.197602] Starting dynamic subtest: client
[673.342058] Dynamic subtest client: SUCCESS (3.152s)
[673.351212] Starting dynamic subtest: gem_migrate
[677.945747] Dynamic subtest gem_migrate: SUCCESS (4.602s)
[677.952666] Starting dynamic subtest: reset
[680.975194] Dynamic subtest reset: SUCCESS (3.027s)
[680.984744] Starting dynamic subtest: memory_region
[683.948366] Dynamic subtest memory_region: SUCCESS (2.972s)
[683.957475] Starting dynamic subtest: hangcheck
[697.880918] Dynamic subtest hangcheck: SUCCESS (13.933s)
[697.890127] Starting dynamic subtest: execlists
[702.558946] Dynamic subtest execlists: SUCCESS (4.676s)
[702.569054] Starting dynamic subtest: ring_submission
[707.181708] Dynamic subtest ring_submission: SUCCESS (4.622s)
[707.191935] Starting dynamic subtest: perf
[710.334329] Dynamic subtest perf: SUCCESS (3.152s)
[710.344582] Starting dynamic subtest: slpc
[723.351516] Dynamic subtest slpc: SUCCESS (13.017s)
[723.360591] Starting dynamic subtest: guc
[727.547507] Dynamic subtest guc: SUCCESS (4.194s)
[727.557152] Starting dynamic subtest: guc_multi_lrc
[732.140993] Dynamic subtest guc_multi_lrc: SUCCESS (4.593s)
[732.150882] Starting dynamic subtest: guc_hang
[735.884530] Dynamic subtest guc_hang: SUCCESS (3.742s)
[735.894725] Starting dynamic subtest: late_gt_pm
[740.443986] Dynamic subtest late_gt_pm: SUCCESS (4.558s)
[740.446668] Subtest live: SUCCESS (235.114s)
[740.469446] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[740.470236] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[740.473671] [065/131] (337s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[742.092451] Starting subtest: flip-vs-cursor-atomic-transitions
[749.437528] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.347s)
[750.526528] [FACT kms_cursor_legacy (flip-vs-cursor-atomic-transitions)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[750.528464] [FACT kms_cursor_legacy (flip-vs-cursor-atomic-transitions)] new: kernel.kmod_is_loaded.i915: true
[750.533491] [066/131] (327s left) kms_vblank (query-busy)
[750.632735] Starting subtest: query-busy
[750.635497] Starting dynamic subtest: pipe-A-eDP-1
[752.552225] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.916s)
[752.568296] Starting dynamic subtest: pipe-D-eDP-1
[755.358255] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.801s)
[755.360851] Subtest query-busy: SUCCESS (4.724s)
[756.304721] [067/131] (321s left) kms_frontbuffer_tracking (fbc-stridechange)
[756.415511] Starting subtest: fbc-stridechange
[758.931459] Subtest fbc-stridechange: SUCCESS (2.521s)
[759.077940] [068/131] (319s left) gem_ctx_persistence (engines-mixed-process)
[759.135489] Starting subtest: engines-mixed-process
[759.137694] Starting dynamic subtest: rcs0
[760.545373] Dynamic subtest rcs0: SUCCESS (1.409s)
[760.556780] Starting dynamic subtest: bcs0
[762.519270] Dynamic subtest bcs0: SUCCESS (1.973s)
[762.530529] Starting dynamic subtest: vcs0
[764.484285] Dynamic subtest vcs0: SUCCESS (1.964s)
[764.494841] Starting dynamic subtest: vcs1
[766.533053] Dynamic subtest vcs1: SUCCESS (2.048s)
[766.542624] Starting dynamic subtest: vecs0
[768.516171] Dynamic subtest vecs0: SUCCESS (1.982s)
[768.525770] Starting dynamic subtest: ccs0
[770.483444] Dynamic subtest ccs0: SUCCESS (1.966s)
[770.486451] Subtest engines-mixed-process: SUCCESS (11.347s)
[770.561570] [069/131] (307s left) perf (oa-formats)
[770.681257] Starting subtest: oa-formats
[770.683850] Starting dynamic subtest: 0-rcs0
[770.699841] Dynamic subtest 0-rcs0: SUCCESS (0.021s)
[770.709158] Starting dynamic subtest: 1-vcs1
[770.741071] Dynamic subtest 1-vcs1: SUCCESS (0.041s)
[770.743821] Subtest oa-formats: SUCCESS (0.063s)
[770.790360] [070/131] (307s left) gem_exec_reloc (basic-wc-read-active)
[770.854758] Subtest basic-wc-read-active: SKIP (0.000s)
[770.914263] [071/131] (307s left) kms_concurrent (multi-plane-atomic-lowres)
[771.020608] Starting subtest: multi-plane-atomic-lowres
[771.022660] Starting dynamic subtest: pipe-A-eDP-1
[771.542646] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.520s)
[771.545438] Subtest multi-plane-atomic-lowres: SUCCESS (0.521s)
[772.374172] [072/131] (306s left) gem_exec_await (wide-all)
[772.559819] Starting subtest: wide-all
[796.535911] Subtest wide-all: SUCCESS (23.973s)
[796.733045] [073/131] (281s left) syncobj_wait (wait-all-for-submit-snapshot)
[796.835780] Starting subtest: wait-all-for-submit-snapshot
[796.918361] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[796.992289] [074/131] (281s left) perf_pmu (gt-awake)
[797.034633] Starting subtest: gt-awake
[805.499644] Subtest gt-awake: SUCCESS (8.463s)
[805.598689] [075/131] (272s left) syncobj_basic (bad-create-flags)
[805.661719] Starting subtest: bad-create-flags
[805.664337] Subtest bad-create-flags: SUCCESS (0.000s)
[805.760745] [076/131] (272s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[805.862547] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[805.864807] Starting dynamic subtest: pipe-A
[805.936347] Dynamic subtest pipe-A: SUCCESS (0.073s)
[805.946114] Starting dynamic subtest: pipe-B
[807.096533] Dynamic subtest pipe-B: SUCCESS (1.159s)
[807.107939] Starting dynamic subtest: pipe-C
[808.202879] Dynamic subtest pipe-C: SUCCESS (1.106s)
[808.211838] Starting dynamic subtest: pipe-D
[809.322821] Dynamic subtest pipe-D: SUCCESS (1.119s)
[809.325763] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.460s)
[810.477723] [077/131] (268s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[810.548943] Starting subtest: etime-single-wait-all-for-submit-submitted
[810.655796] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.106s)
[810.729215] [078/131] (267s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[810.838497] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[810.840934] Starting dynamic subtest: pipe-A-eDP-1
[810.996760] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.158s)
[811.006822] Starting dynamic subtest: pipe-B-eDP-1
[811.157488] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.159s)
[811.168832] Starting dynamic subtest: pipe-C-eDP-1
[811.314915] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.157s)
[811.324928] Starting dynamic subtest: pipe-D-eDP-1
[811.474124] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.158s)
[811.476910] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.636s)
[813.630893] [079/131] (265s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[813.741800] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[813.746820] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[813.841175] [080/131] (264s left) gem_mmap_offset (oob-read)
[813.904899] Starting subtest: oob-read
[813.907624] Subtest oob-read: SUCCESS (0.001s)
[814.016428] [081/131] (264s left) gem_exec_params (dr1-dirt)
[814.080007] Starting subtest: DR1-dirt
[814.082759] Subtest DR1-dirt: SUCCESS (0.000s)
[814.177311] [082/131] (264s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[814.294367] Starting subtest: 2x-cursor-vs-flip-legacy
[814.299664] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[814.423882] [083/131] (264s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[814.520696] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[814.523522] Starting dynamic subtest: pipe-A-default-mode
[814.887810] Dynamic subtest pipe-A-default-mode: SKIP (0.363s)
[814.892769] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.364s)
[815.660248] [084/131] (263s left) drm_fdinfo (virtual-busy)
[815.702807] Starting subtest: virtual-busy
[815.708586] Subtest virtual-busy: SKIP (0.000s)
[815.764142] [085/131] (263s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc)
[815.862700] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc
[820.458979] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (4.599s)
[820.602985] [086/131] (258s left) perf_pmu (all-busy-idle-check-all)
[820.645786] Starting subtest: all-busy-idle-check-all
[822.522613] Subtest all-busy-idle-check-all: SUCCESS (1.876s)
[822.642987] [087/131] (256s left) kms_pipe_crc_basic (hang-read-crc)
[822.749936] Starting subtest: hang-read-crc
[822.752678] Starting dynamic subtest: pipe-A-eDP-1
[824.911490] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.161s)
[824.921756] Starting dynamic subtest: pipe-B-eDP-1
[827.643669] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.732s)
[827.653675] Starting dynamic subtest: pipe-C-eDP-1
[830.245933] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.598s)
[830.256164] Starting dynamic subtest: pipe-D-eDP-1
[832.894187] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.649s)
[832.896949] Subtest hang-read-crc: SUCCESS (10.145s)
[833.745689] [088/131] (245s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[833.813694] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[833.894975] [089/131] (245s left) kms_hdr (static-swap)
[833.993683] Starting subtest: static-swap
[834.001111] Subtest static-swap: SKIP (0.000s)
[834.061729] [090/131] (245s left) gem_ppgtt (blt-vs-render-ctx0)
[834.117978] Starting subtest: blt-vs-render-ctx0
[867.016103] Subtest blt-vs-render-ctx0: SUCCESS (32.893s)
[867.169742] [091/131] (211s left) gem_madvise (dontneed-before-mmap)
[867.239754] Starting subtest: dontneed-before-mmap
[867.269187] Subtest dontneed-before-mmap: SUCCESS (0.028s)
[867.381715] [092/131] (211s left) gem_exec_schedule (pi-common)
[867.576904] Starting subtest: pi-common
[867.579955] Starting dynamic subtest: rcs0
[867.671904] Dynamic subtest rcs0: SUCCESS (0.097s)
[867.684176] Starting dynamic subtest: bcs0
[867.761266] Dynamic subtest bcs0: SUCCESS (0.089s)
[867.773813] Starting dynamic subtest: vcs0
[867.844636] Dynamic subtest vcs0: SUCCESS (0.083s)
[867.860903] Starting dynamic subtest: vcs1
[867.927950] Dynamic subtest vcs1: SUCCESS (0.082s)
[867.942534] Starting dynamic subtest: vecs0
[868.008920] Dynamic subtest vecs0: SUCCESS (0.080s)
[868.020761] Starting dynamic subtest: ccs0
[868.094202] Dynamic subtest ccs0: SUCCESS (0.084s)
[868.097581] Subtest pi-common: SUCCESS (0.520s)
[868.336066] [093/131] (210s left) gem_exec_fence (submit-chain)
[868.520672] Starting subtest: submit-chain
[868.558922] Subtest submit-chain: SUCCESS (0.038s)
[870.586644] [094/131] (208s left) kms_cursor_crc (cursor-offscreen-32x32)
[870.733798] Starting subtest: cursor-offscreen-32x32
[870.771788] Subtest cursor-offscreen-32x32: SKIP (0.033s)
[871.080717] [095/131] (208s left) kms_big_fb (linear-16bpp-rotate-270)
[871.193331] Starting subtest: linear-16bpp-rotate-270
[871.219701] Subtest linear-16bpp-rotate-270: SKIP (0.022s)
[871.349701] [096/131] (207s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[876.403308] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[876.405806] Starting dynamic subtest: pipe-A-eDP-1
[877.200905] Dynamic subtest pipe-A-eDP-1: SKIP (0.793s)
[877.210712] Starting dynamic subtest: pipe-B-eDP-1
[878.332504] Dynamic subtest pipe-B-eDP-1: SKIP (1.131s)
[878.337965] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.928s)
[879.507032] [097/131] (199s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[879.574209] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[879.579604] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[879.756089] [098/131] (199s left) syncobj_timeline (multi-wait-available-submitted)
[879.811802] Starting subtest: multi-wait-available-submitted
[879.814797] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[879.906177] [099/131] (199s left) gem_userptr_blits (unsync-overlap)
[879.967649] Subtest unsync-overlap: SKIP (0.000s)
[880.082618] [100/131] (199s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[880.182757] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[880.188568] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[880.288685] [101/131] (199s left) kms_joiner (invalid-modeset-force-big-joiner)
[880.399288] Starting subtest: invalid-modeset-force-big-joiner
[880.402053] Starting dynamic subtest: big_joiner_on_last_pipe
[880.781009] Dynamic subtest big_joiner_on_last_pipe: SUCCESS (0.386s)
[880.783937] Subtest invalid-modeset-force-big-joiner: SUCCESS (0.387s)
[881.540704] [102/131] (197s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[881.643250] Starting subtest: fbcpsr-1p-rte
[886.503400] Subtest fbcpsr-1p-rte: SUCCESS (4.863s)
[886.648220] [103/131] (192s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[886.740954] Starting subtest: primary-4-tiled-reflect-x-0
[894.009401] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.265s)
[895.232277] [104/131] (184s left) gem_close_race (basic-threads)
[895.319402] Starting subtest: basic-threads
[896.829944] Subtest basic-threads: SUCCESS (1.510s)
[897.012206] [105/131] (182s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[897.118280] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[897.122445] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[897.220135] [106/131] (182s left) syncobj_wait (single-wait-all-submitted)
[897.282911] Starting subtest: single-wait-all-submitted
[897.381379] Subtest single-wait-all-submitted: SUCCESS (0.100s)
[897.452279] [107/131] (182s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[897.568446] Starting subtest: 2x-long-flip-vs-cursor-atomic
[897.573720] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[897.662271] [108/131] (182s left) gem_exec_balancer (nop)
[897.729763] Starting subtest: nop
[944.265496] Subtest nop: SUCCESS (46.529s)
[944.549930] [109/131] (135s left) gem_exec_whisper (basic-normal-all)
[944.616077] Starting subtest: basic-normal-all
[947.867953] Subtest basic-normal-all: SUCCESS (3.249s)
[948.049922] [110/131] (131s left) i915_query (query-topology-coherent-slice-mask)
[948.107773] Starting subtest: query-topology-coherent-slice-mask
[948.113758] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[948.231030] [111/131] (131s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[948.353279] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[953.489325] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (5.138s)
[953.630688] [112/131] (126s left) gem_partial_pwrite_pread (reads-snoop)
[953.706203] Subtest reads-snoop: SKIP (0.000s)
[953.777360] [113/131] (126s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[953.879904] Starting subtest: fbc-rgb565-draw-mmap-gtt
[953.885356] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[953.958448] [114/131] (126s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[954.048665] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[954.053792] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[955.204243] [115/131] (124s left) kms_atomic (plane-invalid-params-fence)
[955.303432] Starting subtest: plane-invalid-params-fence
[955.305902] Starting dynamic subtest: pipe-A-eDP-1
[955.665901] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.361s)
[955.668782] Subtest plane-invalid-params-fence: SUCCESS (0.362s)
[956.530208] [116/131] (123s left) gem_mmap_gtt (cpuset-big-copy)
[956.592170] Subtest cpuset-big-copy: SKIP (0.000s)
[956.646665] [117/131] (123s left) gem_exec_schedule (noreorder)
[956.825284] Starting subtest: noreorder
[956.828162] Starting dynamic subtest: rcs0
[956.905268] Dynamic subtest rcs0: SUCCESS (0.080s)
[956.916941] Starting dynamic subtest: vcs0
[958.545780] Dynamic subtest vcs0: SUCCESS (1.637s)
[958.557650] Starting dynamic subtest: vcs1
[960.488593] Dynamic subtest vcs1: SUCCESS (1.940s)
[960.500213] Starting dynamic subtest: vecs0
[962.473922] Dynamic subtest vecs0: SUCCESS (1.983s)
[962.487266] Starting dynamic subtest: ccs0
[962.556903] Dynamic subtest ccs0: SUCCESS (0.083s)
[962.559905] Subtest noreorder: SUCCESS (5.732s)
[962.741313] [118/131] (117s left) i915_pm_rpm (gem-execbuf-stress)
[964.690623] Starting subtest: gem-execbuf-stress
[964.693630] Starting dynamic subtest: smem0
[977.413545] Dynamic subtest smem0: SUCCESS (12.720s)
[977.426271] Starting dynamic subtest: extra-wait-smem0
[1040.381718] Dynamic subtest extra-wait-smem0: SUCCESS (62.955s)
[1040.384730] Subtest gem-execbuf-stress: SUCCESS (75.681s)
[1040.746199] [119/131] ( 39s left) kms_pm_rpm (modeset-non-lpsp-stress)
[1042.696347] Starting subtest: modeset-non-lpsp-stress
[1043.848897] Subtest modeset-non-lpsp-stress: SKIP (1.155s)
[1044.193697] [120/131] ( 36s left) kms_chamelium_audio (hdmi-audio-edid)
[1044.585626] Subtest hdmi-audio-edid: SKIP (0.000s)
[1045.396392] [121/131] ( 34s left) syncobj_wait (reset-signaled)
[1045.452263] Starting subtest: reset-signaled
[1045.454546] Subtest reset-signaled: SUCCESS (0.000s)
[1045.551283] [122/131] ( 34s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[1045.611651] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[1045.718998] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s)
[1045.794717] [123/131] ( 34s left) gem_wait (await)
[1045.859727] Starting subtest: await
[1045.862723] Starting dynamic subtest: all-engines
[1046.999958] Dynamic subtest all-engines: SUCCESS (1.140s)
[1047.014667] Starting dynamic subtest: rcs0
[1048.067098] Dynamic subtest rcs0: SUCCESS (1.065s)
[1048.085174] Starting dynamic subtest: bcs0
[1049.131972] Dynamic subtest bcs0: SUCCESS (1.063s)
[1049.150119] Starting dynamic subtest: vcs0
[1050.191961] Dynamic subtest vcs0: SUCCESS (1.058s)
[1050.209808] Starting dynamic subtest: vcs1
[1051.254950] Dynamic subtest vcs1: SUCCESS (1.060s)
[1051.271923] Starting dynamic subtest: vecs0
[1052.312942] Dynamic subtest vecs0: SUCCESS (1.056s)
[1052.330556] Starting dynamic subtest: ccs0
[1053.374255] Dynamic subtest ccs0: SUCCESS (1.059s)
[1053.377155] Subtest await: SUCCESS (7.514s)
[1053.573662] [124/131] ( 26s left) api_intel_bb (simple-bb-ctx)
[1053.641744] Starting subtest: simple-bb-ctx
[1053.658742] Subtest simple-bb-ctx: SUCCESS (0.018s)
[1053.803252] [125/131] ( 26s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[1053.909976] Starting subtest: primary-y-tiled-reflect-x-270
[1053.914776] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[1053.977003] [126/131] ( 26s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[1054.039571] Starting subtest: multi-wait-for-submit-available-signaled
[1054.042434] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[1054.147270] [127/131] ( 26s left) gem_exec_schedule (submit-early-slice)
[1054.230408] Starting subtest: submit-early-slice
[1054.232670] Starting dynamic subtest: rcs0
[1054.261191] Dynamic subtest rcs0: SUCCESS (0.041s)
[1054.271824] Starting dynamic subtest: bcs0
[1054.300318] Dynamic subtest bcs0: SUCCESS (0.038s)
[1054.310020] Starting dynamic subtest: vcs0
[1054.341188] Dynamic subtest vcs0: SUCCESS (0.041s)
[1054.351173] Starting dynamic subtest: vcs1
[1054.379250] Dynamic subtest vcs1: SUCCESS (0.038s)
[1054.388967] Starting dynamic subtest: vecs0
[1054.415826] Dynamic subtest vecs0: SUCCESS (0.036s)
[1054.425818] Starting dynamic subtest: ccs0
[1054.459789] Dynamic subtest ccs0: SUCCESS (0.043s)
[1054.462614] Subtest submit-early-slice: SUCCESS (0.240s)
[1055.573026] [128/131] ( 24s left) i915_module_load (reload-no-display)
[1055.614703] Starting subtest: reload-no-display
[1060.488562] Subtest reload-no-display: SUCCESS (4.874s)
[1060.514625] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[1060.515407] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[1060.519717] [129/131] ( 20s left) gem_ctx_persistence (many-contexts)
[1062.120219] Starting subtest: many-contexts
[1107.339235] Subtest many-contexts: SUCCESS (45.213s)
[1107.367164] Overall timeout time exceeded, stopping.
[1107.379390] [FACT gem_ctx_persistence (many-contexts)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[1107.381390] [FACT gem_ctx_persistence (many-contexts)] new: kernel.kmod_is_loaded.i915: true
[1107.382117] Closing watchdogs
results: parsing output: 0/ for test: gem_tiled_wb
results: parsing output: 1/ for test: kms_force_connector_basic
results: parsing output: 2/ for test: kms_feature_discovery
results: parsing output: 3/ for test: gem_eio
results: parsing output: 4/ for test: kms_flip_scaled_crc
results: parsing output: 5/ for test: api_intel_bb
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_exec_flush
results: parsing output: 8/ for test: gem_userptr_blits
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_prime
results: parsing output: 11/ for test: kms_cursor_crc
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: syncobj_eventfd
results: parsing output: 14/ for test: kms_atomic_transition
results: parsing output: 15/ for test: gem_render_copy
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: syncobj_wait
results: parsing output: 21/ for test: gem_mmap_gtt
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: kms_draw_crc
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_chamelium_frames
results: parsing output: 27/ for test: kms_vblank
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: kms_pm_dc
results: parsing output: 31/ for test: kms_cursor_edge_walk
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: kms_plane_scaling
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_pread
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: perf
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: gen9_exec_parse
results: parsing output: 44/ for test: gem_lmem_swapping
results: parsing output: 45/ for test: gem_exec_balancer
results: parsing output: 46/ for test: gem_busy
results: parsing output: 47/ for test: perf_pmu
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_chamelium_frames
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: drm_fdinfo
results: parsing output: 54/ for test: kms_legacy_colorkey
results: parsing output: 55/ for test: gem_ctx_freq
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: gem_mmap_gtt
results: parsing output: 58/ for test: kms_psr2_sf
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: sysfs_heartbeat_interval
results: parsing output: 61/ for test: prime_busy
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: i915_selftest
results: parsing output: 64/ for test: kms_cursor_legacy
results: parsing output: 65/ for test: kms_vblank
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_ctx_persistence
results: parsing output: 68/ for test: perf
results: parsing output: 69/ for test: gem_exec_reloc
results: parsing output: 70/ for test: kms_concurrent
results: parsing output: 71/ for test: gem_exec_await
results: parsing output: 72/ for test: syncobj_wait
results: parsing output: 73/ for test: perf_pmu
results: parsing output: 74/ for test: syncobj_basic
results: parsing output: 75/ for test: kms_plane_scaling
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_mmap_offset
results: parsing output: 80/ for test: gem_exec_params
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: kms_flip_scaled_crc
results: parsing output: 83/ for test: drm_fdinfo
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: perf_pmu
results: parsing output: 86/ for test: kms_pipe_crc_basic
results: parsing output: 87/ for test: gem_fenced_exec_thrash
results: parsing output: 88/ for test: kms_hdr
results: parsing output: 89/ for test: gem_ppgtt
results: parsing output: 90/ for test: gem_madvise
results: parsing output: 91/ for test: gem_exec_schedule
results: parsing output: 92/ for test: gem_exec_fence
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_psr2_sf
results: parsing output: 96/ for test: gem_render_copy
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: gem_userptr_blits
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_joiner
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_rotation_crc
results: parsing output: 103/ for test: gem_close_race
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: gem_exec_balancer
results: parsing output: 108/ for test: gem_exec_whisper
results: parsing output: 109/ for test: i915_query
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_partial_pwrite_pread
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_atomic
results: parsing output: 115/ for test: gem_mmap_gtt
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: i915_pm_rpm
results: parsing output: 118/ for test: kms_pm_rpm
results: parsing output: 119/ for test: kms_chamelium_audio
results: parsing output: 120/ for test: syncobj_wait
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: gem_wait
results: parsing output: 123/ for test: api_intel_bb
results: parsing output: 124/ for test: kms_rotation_crc
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: i915_module_load
results: parsing output: 128/ for test: gem_ctx_persistence
results: parsing output: 129/ for test: gem_exec_fence
results: no output, setting notrun
results: parsing output: 130/ for test: gem_mmap_wc
results: no output, setting notrun
Done.