[60.109273] Initializing watchdogs
[60.109348]   /dev/watchdog0
[60.123901] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[60.129955] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.132399] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.134631] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[60.228439] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[60.229797] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[60.366637] [002/133] (960s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[60.450934] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[60.499545] [003/133] (960s left) gem_mmap (short-mmap)
[60.532154] Starting subtest: short-mmap
[60.532958] Subtest short-mmap: SUCCESS (0.000s)
[60.650270] [004/133] (960s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[60.733262] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.000s)
[60.784425] [005/133] (959s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[60.871311] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[60.872675] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[60.988756] [006/133] (959s left) kms_frontbuffer_tracking (psr-slowdraw)
[61.076408] Starting subtest: psr-slowdraw
[61.077704] Subtest psr-slowdraw: SKIP (0.000s)
[61.211137] [007/133] (959s left) syncobj_wait (single-wait-for-submit-submitted)
[61.244374] Starting subtest: single-wait-for-submit-submitted
[61.351075] Subtest single-wait-for-submit-submitted: SUCCESS (0.107s)
[61.441767] [008/133] (959s left) kms_color (ctm-0-75)
[61.525333] Starting subtest: ctm-0-75
[61.526021] Starting dynamic subtest: pipe-A-HDMI-A-1
[63.390910] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.874s)
[63.397239] Starting dynamic subtest: pipe-B-HDMI-A-1
[65.066584] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.682s)
[65.071751] Starting dynamic subtest: pipe-C-HDMI-A-1
[66.754386] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.692s)
[66.759684] Starting dynamic subtest: pipe-D-HDMI-A-1
[68.429888] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.678s)
[68.430575] Subtest ctm-0-75: SUCCESS (6.927s)
[68.588760] [009/133] (952s left) i915_pm_freq_api (freq-reset)
[68.632189] Subtest freq-reset: SKIP (0.000s)
[68.666871] [010/133] (952s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[69.144394] Starting subtest: syncobj-timeline-multiple-ext-nodes
[69.145268] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[69.348957] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[69.350594] [011/133] (951s left) kms_force_connector_basic (prune-stale-modes)
[69.471920] Starting subtest: prune-stale-modes
[69.618629] Subtest prune-stale-modes: SUCCESS (0.148s)
[69.822221] [012/133] (951s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[69.909619] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[69.911022] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[70.050550] [013/133] (951s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[70.137546] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[70.138935] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[70.259201] [014/133] (950s left) prime_self_import (basic-with_one_bo)
[70.289960] Starting subtest: basic-with_one_bo
[70.292988] Subtest basic-with_one_bo: SUCCESS (0.003s)
[70.421206] [015/133] (950s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[70.454395] Starting subtest: multi-wait-all-for-submit-available-signaled
[70.455137] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[70.535272] [016/133] (950s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[70.571433] Starting subtest: rel-constants-invalid-rel-gen5
[70.572119] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[70.694914] [017/133] (950s left) i915_pm_rps (reset)
[70.732763] Starting subtest: reset
[75.297302] Subtest reset: SUCCESS (4.539s)
[75.390938] [018/133] (945s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[75.476218] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[75.477580] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[75.563996] [019/133] (945s left) gem_mmap_wc (invalid-flags)
[75.595875] Starting subtest: invalid-flags
[75.596585] Subtest invalid-flags: SUCCESS (0.000s)
[75.697660] [020/133] (945s left) kms_joiner (basic-force-ultra-joiner)
[75.782660] Starting subtest: basic-force-ultra-joiner
[75.784093] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[75.866497] [021/133] (945s left) kms_lease (atomic-implicit-crtc)
[75.949716] Starting subtest: atomic-implicit-crtc
[75.950432] Starting dynamic subtest: pipe-A-HDMI-A-1
[75.954118] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[75.961379] Starting dynamic subtest: pipe-B-HDMI-A-1
[75.964898] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.007s)
[75.972228] Starting dynamic subtest: pipe-C-HDMI-A-1
[75.975711] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.007s)
[75.982775] Starting dynamic subtest: pipe-D-HDMI-A-1
[75.986204] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.007s)
[75.986902] Subtest atomic-implicit-crtc: SUCCESS (0.028s)
[76.115890] [022/133] (945s left) gem_render_copy (y-tiled)
[76.154218] Starting subtest: y-tiled
[76.154997] Starting dynamic subtest: smem
[76.252376] Dynamic subtest smem: SUCCESS (0.098s)
[76.253099] Subtest y-tiled: SUCCESS (0.098s)
[76.452888] [023/133] (945s left) kms_feature_discovery (display-1x)
[76.536961] Starting subtest: display-1x
[76.537751] Subtest display-1x: SUCCESS (0.000s)
[76.625336] [024/133] (944s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[76.720049] Starting subtest: yf-tiled-64bpp-rotate-0
[76.721437] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[76.835586] [025/133] (944s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[76.924594] Starting subtest: fbc-indfb-scaledprimary
[80.374220] Subtest fbc-indfb-scaledprimary: SUCCESS (3.451s)
[80.531919] [026/133] (941s left) kms_busy (extended-modeset-hang-newfb)
[80.624462] Starting subtest: extended-modeset-hang-newfb
[80.625868] Starting dynamic subtest: pipe-A
[105.158665] Dynamic subtest pipe-A: SUCCESS (24.531s)
[105.166353] Starting dynamic subtest: pipe-D
[129.201948] Dynamic subtest pipe-D: SUCCESS (24.040s)
[129.202708] Subtest extended-modeset-hang-newfb: SUCCESS (48.576s)
[129.347723] [027/133] (892s left) kms_prop_blob (blob-prop-lifetime)
[129.384143] Starting subtest: blob-prop-lifetime
[129.384872] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[129.479780] [028/133] (892s left) gem_pxp (reject-modify-context-protection-off-1)
[129.579405] Starting subtest: reject-modify-context-protection-off-1
[129.580404] Subtest reject-modify-context-protection-off-1: SUCCESS (0.001s)
[129.670519] [029/133] (892s left) perf (invalid-open-flags)
[129.789948] Starting subtest: invalid-open-flags
[129.790652] Subtest invalid-open-flags: SUCCESS (0.000s)
[129.825684] [030/133] (891s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[129.929701] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[130.343108] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.413s)
[130.524491] [031/133] (891s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[130.613744] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[133.018973] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (2.406s)
[133.198584] [032/133] (888s left) core_setmaster (master-drop-set-user)
[133.324149] Starting subtest: master-drop-set-user
[133.347821] Subtest master-drop-set-user: SUCCESS (0.025s)
[133.390539] [033/133] (888s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[133.428284] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[133.429009] Starting dynamic subtest: smem
[133.504968] Dynamic subtest smem: SUCCESS (0.076s)
[133.505691] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SUCCESS (0.077s)
[133.712380] [034/133] (888s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[133.748395] Starting subtest: writes-after-reads-snoop
[145.789360] Subtest writes-after-reads-snoop: SUCCESS (12.041s)
[145.929479] [035/133] (876s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[146.018386] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[146.019711] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[146.157271] [036/133] (875s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[146.249706] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[146.251114] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[146.366851] [037/133] (875s left) gem_userptr_blits (dmabuf-unsync)
[146.405147] Subtest dmabuf-unsync: SKIP (0.000s)
[146.541477] [038/133] (875s left) kms_psr (psr2-sprite-blt)
[146.624415] Subtest psr2-sprite-blt: SKIP (0.000s)
[146.671506] [039/133] (875s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[146.754471] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[146.794366] Starting dynamic subtest: pipe-A-plane-0
[147.211532] Dynamic subtest pipe-A-plane-0: SUCCESS (0.417s)
[147.223915] Starting dynamic subtest: pipe-A-plane-3
[147.534143] Dynamic subtest pipe-A-plane-3: SUCCESS (0.321s)
[147.546715] Starting dynamic subtest: pipe-A-plane-5
[147.856404] Dynamic subtest pipe-A-plane-5: SUCCESS (0.322s)
[148.012737] Starting dynamic subtest: pipe-B-plane-0
[148.365410] Dynamic subtest pipe-B-plane-0: SUCCESS (0.360s)
[148.377534] Starting dynamic subtest: pipe-B-plane-3
[148.687937] Dynamic subtest pipe-B-plane-3: SUCCESS (0.321s)
[148.700234] Starting dynamic subtest: pipe-B-plane-5
[149.010337] Dynamic subtest pipe-B-plane-5: SUCCESS (0.322s)
[149.074029] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SUCCESS (2.319s)
[149.239218] [040/133] (872s left) perf_pmu (enable-race)
[149.274256] Starting subtest: enable-race
[149.274998] Starting dynamic subtest: rcs0
[161.868297] Dynamic subtest rcs0: SUCCESS (12.572s)
[161.880364] Starting dynamic subtest: bcs0
[174.438400] Dynamic subtest bcs0: SUCCESS (12.565s)
[174.450605] Starting dynamic subtest: vcs0
[187.006154] Dynamic subtest vcs0: SUCCESS (12.568s)
[187.018303] Starting dynamic subtest: vcs1
[199.572204] Dynamic subtest vcs1: SUCCESS (12.569s)
[199.584293] Starting dynamic subtest: vecs0
[212.122641] Dynamic subtest vecs0: SUCCESS (12.570s)
[212.123336] Subtest enable-race: SUCCESS (62.848s)
[212.215148] [041/133] (810s left) kms_pm_rpm (drm-resources-equal)
[213.614236] Starting subtest: drm-resources-equal
[216.305748] Subtest drm-resources-equal: SUCCESS (2.692s)
[216.449465] [042/133] (805s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[216.533479] Starting subtest: addfb25-framebuffer-vs-set-tiling
[216.534181] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[216.637895] [043/133] (805s left) prime_vgem (busy)
[216.709309] Starting subtest: busy
[216.710052] Starting dynamic subtest: rcs0
[216.745183] Dynamic subtest rcs0: SUCCESS (0.036s)
[216.751455] Starting dynamic subtest: bcs0
[216.766772] Dynamic subtest bcs0: SUCCESS (0.021s)
[216.774124] Starting dynamic subtest: vcs0
[216.787154] Dynamic subtest vcs0: SUCCESS (0.019s)
[216.798572] Starting dynamic subtest: vcs1
[216.803459] Dynamic subtest vcs1: SUCCESS (0.016s)
[216.812654] Starting dynamic subtest: vecs0
[216.818793] Dynamic subtest vecs0: SUCCESS (0.015s)
[216.819499] Subtest busy: SUCCESS (0.110s)
[216.968684] [044/133] (805s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[217.051525] Starting subtest: nonblocking-crc-frame-sequence
[217.052195] Starting dynamic subtest: pipe-A-HDMI-A-1
[217.717139] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.664s)
[217.724501] Starting dynamic subtest: pipe-B-HDMI-A-1
[218.251557] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.533s)
[218.258738] Starting dynamic subtest: pipe-C-HDMI-A-1
[218.812397] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.559s)
[218.819640] Starting dynamic subtest: pipe-D-HDMI-A-1
[219.359719] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.546s)
[219.360415] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.309s)
[219.492819] [045/133] (802s left) kms_psr (fbc-pr-cursor-plane-move)
[219.580416] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[219.628291] [046/133] (802s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[219.712670] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[219.915725] Starting dynamic subtest: pipe-A-HDMI-A-1
[221.987527] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.063s)
[222.178189] Starting dynamic subtest: pipe-B-HDMI-A-1
[224.239542] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.058s)
[224.401906] Starting dynamic subtest: pipe-C-HDMI-A-1
[226.458645] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.054s)
[226.638988] Starting dynamic subtest: pipe-D-HDMI-A-1
[228.709963] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.070s)
[228.710851] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (8.990s)
[228.991611] [047/133] (793s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[229.026854] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[229.135977] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.107s)
[229.239797] [048/133] (793s left) kms_vrr (max-min)
[229.325584] Starting subtest: max-min
[229.327724] Subtest max-min: SKIP (0.000s)
[229.428949] [049/133] (793s left) gem_spin_batch (spin-each)
[229.470357] Starting subtest: spin-each
[232.828854] Subtest spin-each: SUCCESS (3.342s)
[233.036075] [050/133] (789s left) kms_chamelium_color (ctm-0-50)
[233.123427] Subtest ctm-0-50: SKIP (0.000s)
[233.166978] [051/133] (789s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[233.253451] Starting subtest: basic-flip-after-cursor-legacy
[234.321437] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.069s)
[234.486192] [052/133] (788s left) gem_pwrite (basic-exhaustion)
[234.520530] Starting subtest: basic-exhaustion
[238.125345] Subtest basic-exhaustion: SUCCESS (3.596s)
[238.572780] [053/133] (784s left) kms_pm_rpm (modeset-non-lpsp)
[239.970934] Starting subtest: modeset-non-lpsp
[241.174683] Subtest modeset-non-lpsp: SKIP (1.203s)
[241.376419] [054/133] (781s left) i915_selftest (live)
[242.269412] Starting subtest: live
[242.270145] Starting dynamic subtest: sanitycheck
[243.416514] Dynamic subtest sanitycheck: SUCCESS (1.147s)
[243.425438] Starting dynamic subtest: uncore
[244.552542] Dynamic subtest uncore: SUCCESS (1.135s)
[244.558895] Starting dynamic subtest: workarounds
[246.010404] Dynamic subtest workarounds: SUCCESS (1.457s)
[246.016089] Starting dynamic subtest: gt_engines
[247.746582] Dynamic subtest gt_engines: SUCCESS (1.735s)
[247.752488] Starting dynamic subtest: gt_timelines
[256.204631] Dynamic subtest gt_timelines: SUCCESS (8.457s)
[256.213775] Starting dynamic subtest: gt_contexts
[257.482679] Dynamic subtest gt_contexts: SUCCESS (1.277s)
[257.491601] Starting dynamic subtest: gt_lrc
[261.617575] Dynamic subtest gt_lrc: SUCCESS (4.133s)
[261.627853] Starting dynamic subtest: gt_mocs
[262.914466] Dynamic subtest gt_mocs: SUCCESS (1.296s)
[262.920477] Starting dynamic subtest: gt_pm
[284.320356] Dynamic subtest gt_pm: SUCCESS (21.405s)
[284.329442] Starting dynamic subtest: gt_heartbeat
[285.491596] Dynamic subtest gt_heartbeat: SUCCESS (1.169s)
[285.498340] Starting dynamic subtest: gt_tlb
[288.899584] Dynamic subtest gt_tlb: SUCCESS (3.407s)
[288.909743] Starting dynamic subtest: requests
[297.433499] Dynamic subtest requests: SUCCESS (8.532s)
[297.439273] Starting dynamic subtest: migrate
[301.650539] Dynamic subtest migrate: SUCCESS (4.216s)
[301.659643] Starting dynamic subtest: active
[302.795447] Dynamic subtest active: SUCCESS (1.143s)
[302.808029] Starting dynamic subtest: objects
[304.534557] Dynamic subtest objects: SUCCESS (1.738s)
[304.543431] Starting dynamic subtest: mman
[309.286458] Dynamic subtest mman: SUCCESS (4.750s)
[309.292441] Starting dynamic subtest: dmabuf
[310.492648] Dynamic subtest dmabuf: SUCCESS (1.204s)
[310.501625] Starting dynamic subtest: vma
[311.654585] Dynamic subtest vma: SUCCESS (1.160s)
[311.660619] Starting dynamic subtest: coherency
[314.389595] Dynamic subtest coherency: SUCCESS (2.734s)
[314.395798] Starting dynamic subtest: gtt
[323.070511] Dynamic subtest gtt: SUCCESS (8.679s)
[323.076659] Starting dynamic subtest: gem
[325.170561] Dynamic subtest gem: SUCCESS (2.098s)
[325.176653] Starting dynamic subtest: evict
[327.339657] Dynamic subtest evict: SUCCESS (2.167s)
[327.350323] Starting dynamic subtest: hugepages
[335.009391] Dynamic subtest hugepages: SUCCESS (7.668s)
[335.015324] Starting dynamic subtest: gem_contexts
[350.481470] Dynamic subtest gem_contexts: SUCCESS (15.470s)
[350.494808] Starting dynamic subtest: client
[351.705339] Dynamic subtest client: SUCCESS (1.222s)
[351.718892] Starting dynamic subtest: gem_migrate
[352.844541] Dynamic subtest gem_migrate: SUCCESS (1.137s)
[352.853646] Starting dynamic subtest: reset
[357.746607] Dynamic subtest reset: SUCCESS (4.900s)
[357.752658] Starting dynamic subtest: memory_region
[358.896657] Dynamic subtest memory_region: SUCCESS (1.148s)
[358.905601] Starting dynamic subtest: hangcheck
[388.802396] Dynamic subtest hangcheck: SUCCESS (29.904s)
[388.813138] Starting dynamic subtest: execlists
[402.455472] Dynamic subtest execlists: SUCCESS (13.651s)
[402.461465] Starting dynamic subtest: ring_submission
[403.602286] Dynamic subtest ring_submission: SUCCESS (1.145s)
[403.608317] Starting dynamic subtest: perf
[404.887519] Dynamic subtest perf: SUCCESS (1.283s)
[404.893955] Starting dynamic subtest: slpc
[406.029599] Dynamic subtest slpc: SUCCESS (1.140s)
[406.036111] Starting dynamic subtest: guc
[407.173562] Dynamic subtest guc: SUCCESS (1.142s)
[407.179662] Starting dynamic subtest: guc_multi_lrc
[408.315599] Dynamic subtest guc_multi_lrc: SUCCESS (1.140s)
[408.325829] Starting dynamic subtest: guc_hang
[409.454535] Dynamic subtest guc_hang: SUCCESS (1.137s)
[409.463914] Starting dynamic subtest: late_gt_pm
[410.650515] Dynamic subtest late_gt_pm: SUCCESS (1.194s)
[410.651339] Subtest live: SUCCESS (168.383s)
[410.679406] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[410.680204] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[410.682510] [055/133] (612s left) sysfs_preempt_timeout (timeout)
[411.780130] Starting subtest: timeout
[411.780920] Starting dynamic subtest: vecs0
[412.672418] Dynamic subtest vecs0: SUCCESS (0.892s)
[412.681621] Starting dynamic subtest: vcs0
[413.707546] Dynamic subtest vcs0: SUCCESS (1.032s)
[413.717869] Starting dynamic subtest: bcs0
[414.651241] Dynamic subtest bcs0: SUCCESS (0.942s)
[414.662721] Starting dynamic subtest: rcs0
[415.538239] Dynamic subtest rcs0: SUCCESS (0.884s)
[415.547516] Starting dynamic subtest: vcs1
[416.433668] Dynamic subtest vcs1: SUCCESS (0.893s)
[416.434632] Subtest timeout: SUCCESS (4.655s)
[416.494265] [FACT sysfs_preempt_timeout (timeout)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[416.495600] [FACT sysfs_preempt_timeout (timeout)] new: kernel.kmod_is_loaded.i915: true
[416.498443] [056/133] (606s left) kms_psr (fbc-psr2-primary-render)
[416.591813] Subtest fbc-psr2-primary-render: SKIP (0.000s)
[416.639756] [057/133] (606s left) gem_exec_fence (basic-busy)
[416.804795] Starting subtest: basic-busy
[416.805836] Starting dynamic subtest: rcs0
[416.837516] Dynamic subtest rcs0: SUCCESS (0.033s)
[416.852631] Starting dynamic subtest: bcs0
[416.875509] Dynamic subtest bcs0: SUCCESS (0.035s)
[416.889398] Starting dynamic subtest: vcs0
[416.909473] Dynamic subtest vcs0: SUCCESS (0.032s)
[416.923195] Starting dynamic subtest: vcs1
[416.940279] Dynamic subtest vcs1: SUCCESS (0.028s)
[416.952408] Starting dynamic subtest: vecs0
[416.974343] Dynamic subtest vecs0: SUCCESS (0.032s)
[416.975483] Subtest basic-busy: SUCCESS (0.172s)
[417.453748] [058/133] (605s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[417.538116] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[417.576345] Starting dynamic subtest: pipe-A-plane-0
[418.506251] Dynamic subtest pipe-A-plane-0: SUCCESS (0.930s)
[418.521489] Starting dynamic subtest: pipe-A-plane-3
[419.303383] Dynamic subtest pipe-A-plane-3: SUCCESS (0.795s)
[419.314937] Starting dynamic subtest: pipe-A-plane-5
[419.891419] Dynamic subtest pipe-A-plane-5: SUCCESS (0.586s)
[420.052214] Starting dynamic subtest: pipe-B-plane-0
[420.894670] Dynamic subtest pipe-B-plane-0: SUCCESS (0.853s)
[420.910426] Starting dynamic subtest: pipe-B-plane-3
[421.672789] Dynamic subtest pipe-B-plane-3: SUCCESS (0.776s)
[421.688708] Starting dynamic subtest: pipe-B-plane-5
[422.260840] Dynamic subtest pipe-B-plane-5: SUCCESS (0.586s)
[422.324368] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (4.786s)
[422.505904] [059/133] (600s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[422.598821] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[422.600204] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[422.715720] [060/133] (600s left) syncobj_timeline (single-wait-available-signaled)
[422.749664] Starting subtest: single-wait-available-signaled
[422.750336] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[422.847379] [061/133] (600s left) gem_exec_schedule (preempt-engines)
[422.891538] Starting subtest: preempt-engines
[422.892260] Starting dynamic subtest: rcs0
[422.969631] Dynamic subtest rcs0: SUCCESS (0.077s)
[422.977790] Starting dynamic subtest: bcs0
[423.048173] Dynamic subtest bcs0: SUCCESS (0.077s)
[423.057779] Starting dynamic subtest: vcs0
[423.131836] Dynamic subtest vcs0: SUCCESS (0.082s)
[423.140840] Starting dynamic subtest: vcs1
[423.214182] Dynamic subtest vcs1: SUCCESS (0.081s)
[423.221615] Starting dynamic subtest: vecs0
[423.295971] Dynamic subtest vecs0: SUCCESS (0.081s)
[423.296899] Subtest preempt-engines: SUCCESS (0.405s)
[423.627633] [062/133] (599s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[423.661736] Starting subtest: multi-wait-all-for-submit-unsubmitted
[423.766718] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[423.872969] [063/133] (599s left) perf (non-system-wide-paranoid)
[423.969686] Starting subtest: non-system-wide-paranoid
[423.998548] Subtest non-system-wide-paranoid: SUCCESS (0.029s)
[424.058438] [064/133] (599s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[424.148062] Starting subtest: cursor-rapid-movement-32x32
[424.195720] Subtest cursor-rapid-movement-32x32: SKIP (0.046s)
[424.327668] [065/133] (598s left) gem_exec_reloc (basic-range)
[424.364929] Starting subtest: basic-range
[424.393058] Subtest basic-range: SUCCESS (0.028s)
[424.555153] [066/133] (598s left) gen7_exec_parse (basic-offset)
[424.591413] Subtest basic-offset: SKIP (0.000s)
[424.631263] [067/133] (598s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[424.721835] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[424.723221] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[424.839707] [068/133] (598s left) gem_exec_schedule (timeslicing)
[424.882065] Starting subtest: timeslicing
[424.882832] Starting dynamic subtest: rcs0
[424.888670] Dynamic subtest rcs0: SUCCESS (0.006s)
[424.897150] Starting dynamic subtest: bcs0
[424.897849] Dynamic subtest bcs0: SUCCESS (0.003s)
[424.905427] Starting dynamic subtest: vcs0
[424.906115] Dynamic subtest vcs0: SUCCESS (0.002s)
[424.912759] Starting dynamic subtest: vcs1
[424.913444] Dynamic subtest vcs1: SUCCESS (0.003s)
[424.919737] Starting dynamic subtest: vecs0
[424.920418] Dynamic subtest vecs0: SUCCESS (0.003s)
[424.921083] Subtest timeslicing: SUCCESS (0.022s)
[425.239513] [069/133] (598s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[425.326359] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[425.327074] Starting dynamic subtest: pipe-A-HDMI-A-1
[425.344417] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[425.351231] Starting dynamic subtest: pipe-B-HDMI-A-1
[425.368714] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[425.375444] Starting dynamic subtest: pipe-C-HDMI-A-1
[425.391978] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[425.398196] Starting dynamic subtest: pipe-D-HDMI-A-1
[425.414962] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[425.416257] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.016s)
[425.611674] [070/133] (597s left) gem_ctx_shared (q-independent)
[425.654329] Starting subtest: Q-independent
[425.655030] Starting dynamic subtest: rcs0
[425.676619] Dynamic subtest rcs0: SUCCESS (0.022s)
[425.685139] Starting dynamic subtest: bcs0
[425.700658] Dynamic subtest bcs0: SUCCESS (0.022s)
[425.709558] Starting dynamic subtest: vcs0
[425.722294] Dynamic subtest vcs0: SUCCESS (0.020s)
[425.730428] Starting dynamic subtest: vcs1
[425.743612] Dynamic subtest vcs1: SUCCESS (0.020s)
[425.752051] Starting dynamic subtest: vecs0
[425.766393] Dynamic subtest vecs0: SUCCESS (0.021s)
[425.767200] Subtest Q-independent: SUCCESS (0.113s)
[425.973798] [071/133] (597s left) gem_mmap_offset (blt-coherency)
[426.007804] Starting subtest: blt-coherency
[426.013556] Subtest blt-coherency: SUCCESS (0.006s)
[426.149757] [072/133] (597s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[426.237135] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[426.237820] Starting dynamic subtest: pipe-A-HDMI-A-1
[426.244308] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[426.251169] Starting dynamic subtest: pipe-B-HDMI-A-1
[426.257753] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[426.264525] Starting dynamic subtest: pipe-C-HDMI-A-1
[426.271035] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[426.277615] Starting dynamic subtest: pipe-D-HDMI-A-1
[426.284388] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[426.285865] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s)
[426.497861] [073/133] (597s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[426.580968] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[426.582711] Starting dynamic subtest: pipe-A-HDMI-A-1
[426.589293] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[426.596305] Starting dynamic subtest: pipe-B-HDMI-A-1
[426.602863] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[426.609554] Starting dynamic subtest: pipe-C-HDMI-A-1
[426.616046] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[426.622692] Starting dynamic subtest: pipe-D-HDMI-A-1
[426.629287] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[426.630623] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[426.827264] [074/133] (596s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[426.912178] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[426.912845] Starting dynamic subtest: pipe-A-HDMI-A-1
[426.915371] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[426.922132] Starting dynamic subtest: pipe-B-HDMI-A-1
[426.924852] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[426.931710] Starting dynamic subtest: pipe-C-HDMI-A-1
[426.934414] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[426.941116] Starting dynamic subtest: pipe-D-HDMI-A-1
[426.943821] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[426.945169] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[427.171100] [075/133] (596s left) kms_flip (flip-vs-panning-vs-hang)
[427.256602] Starting subtest: flip-vs-panning-vs-hang
[427.258393] Starting dynamic subtest: A-HDMI-A1
[466.554131] Dynamic subtest A-HDMI-A1: SUCCESS (39.290s)
[466.560766] Starting dynamic subtest: D-HDMI-A1
[505.466128] Dynamic subtest D-HDMI-A1: SUCCESS (38.888s)
[505.466880] Subtest flip-vs-panning-vs-hang: SUCCESS (78.184s)
[505.607703] [076/133] (518s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[505.705490] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[505.706981] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[505.836264] [077/133] (517s left) kms_hdr (invalid-metadata-sizes)
[505.920129] Starting subtest: invalid-metadata-sizes
[505.922192] Subtest invalid-metadata-sizes: SKIP (0.001s)
[506.021336] [078/133] (517s left) kms_async_flips (invalid-async-flip)
[506.105938] Starting subtest: invalid-async-flip
[506.297043] Starting dynamic subtest: pipe-A-HDMI-A-1
[506.484061] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.187s)
[506.652717] Starting dynamic subtest: pipe-B-HDMI-A-1
[506.759471] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.113s)
[506.924979] Starting dynamic subtest: pipe-C-HDMI-A-1
[507.029909] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.111s)
[507.187423] Starting dynamic subtest: pipe-D-HDMI-A-1
[507.291950] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.111s)
[507.292705] Subtest invalid-async-flip: SUCCESS (1.186s)
[507.573274] [079/133] (516s left) kms_rotation_crc (primary-rotation-90)
[507.667929] Starting subtest: primary-rotation-90
[515.902715] Subtest primary-rotation-90: SUCCESS (8.234s)
[516.134818] [080/133] (507s left) kms_cursor_edge_walk (256x256-top-edge)
[516.225874] Starting subtest: 256x256-top-edge
[516.226624] Starting dynamic subtest: pipe-A-HDMI-A-1
[519.935875] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.709s)
[519.946987] Starting dynamic subtest: pipe-D-HDMI-A-1
[523.559984] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (3.622s)
[523.560705] Subtest 256x256-top-edge: SUCCESS (7.336s)
[523.692592] [081/133] (500s left) gem_exec_flush (basic-wb-ro-default)
[523.737747] Starting subtest: basic-wb-ro-default
[529.170823] Subtest basic-wb-ro-default: SUCCESS (5.434s)
[529.402505] [082/133] (494s left) kms_psr (psr2-basic)
[529.490686] Subtest psr2-basic: SKIP (0.000s)
[529.539723] [083/133] (494s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[529.626158] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[529.626850] Starting dynamic subtest: pipe-A-valid-mode
[530.356965] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.729s)
[530.357688] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (0.731s)
[530.524065] [084/133] (493s left) gem_workarounds (suspend-resume-fd)
[530.572652] Starting subtest: suspend-resume-fd
[547.423905] Subtest suspend-resume-fd: SUCCESS (1.292s)
[555.584800] [085/133] (476s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[555.687637] Starting subtest: y-tiled-8bpp-rotate-90
[555.784683] Subtest y-tiled-8bpp-rotate-90: SKIP (0.100s)
[555.933970] [086/133] (476s left) kms_pipe_crc_basic (bad-source)
[556.015597] Starting subtest: bad-source
[556.016342] Subtest bad-source: SUCCESS (0.000s)
[556.136005] [087/133] (476s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[556.221910] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[556.223242] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[556.355920] [088/133] (475s left) gem_lmem_swapping (verify-random-ccs)
[556.391033] Subtest verify-random-ccs: SKIP (0.000s)
[556.431720] [089/133] (475s left) kms_flip (wf_vblank-ts-check-interruptible)
[556.517546] Starting subtest: wf_vblank-ts-check-interruptible
[556.520319] Starting dynamic subtest: A-HDMI-A1
[575.637652] Dynamic subtest A-HDMI-A1: SUCCESS (19.338s)
[575.651409] Starting dynamic subtest: B-HDMI-A1
[583.704614] Dynamic subtest B-HDMI-A1: SUCCESS (8.062s)
[583.712466] Starting dynamic subtest: C-HDMI-A1
[591.772278] Dynamic subtest C-HDMI-A1: SUCCESS (8.064s)
[591.780131] Starting dynamic subtest: D-HDMI-A1
[599.806100] Dynamic subtest D-HDMI-A1: SUCCESS (8.034s)
[599.807077] Subtest wf_vblank-ts-check-interruptible: SUCCESS (43.513s)
[599.957846] [090/133] (432s left) gem_partial_pwrite_pread (writes-after-reads)
[599.999674] Starting subtest: writes-after-reads
[612.211520] Subtest writes-after-reads: SUCCESS (12.215s)
[612.344044] [091/133] (419s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[612.434408] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[614.346543] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SUCCESS (1.913s)
[614.507593] [092/133] (417s left) gem_exec_params (invalid-batch-start-offset)
[614.543737] Starting subtest: invalid-batch-start-offset
[614.546658] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[614.677647] [093/133] (417s left) gem_lmem_swapping (basic)
[614.714500] Subtest basic: SKIP (0.000s)
[614.755489] [094/133] (417s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[614.846485] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[614.847893] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[615.000925] [095/133] (417s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[615.093722] Starting subtest: 4-tiled-64bpp-rotate-180
[615.095126] Subtest 4-tiled-64bpp-rotate-180: SKIP (0.000s)
[615.209433] [096/133] (417s left) kms_sequence (queue-busy)
[615.292796] Starting subtest: queue-busy
[615.294639] Starting dynamic subtest: pipe-A-HDMI-A-1
[618.105425] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.812s)
[618.114462] Starting dynamic subtest: pipe-B-HDMI-A-1
[620.801240] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.696s)
[620.810431] Starting dynamic subtest: pipe-C-HDMI-A-1
[623.506387] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.704s)
[623.515533] Starting dynamic subtest: pipe-D-HDMI-A-1
[626.219187] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.712s)
[626.219917] Subtest queue-busy: SUCCESS (10.931s)
[626.357986] [097/133] (406s left) gem_pread (uncached)
[626.401696] Starting subtest: uncached
[627.245108] Subtest uncached: SUCCESS (0.842s)
[627.359851] [098/133] (405s left) kms_cursor_legacy (single-move)
[627.445537] Starting subtest: single-move
[627.446225] Starting dynamic subtest: pipe-A
[632.858426] Dynamic subtest pipe-A: SUCCESS (5.380s)
[632.867988] Starting dynamic subtest: pipe-B
[638.235959] Dynamic subtest pipe-B: SUCCESS (5.379s)
[638.246227] Starting dynamic subtest: pipe-C
[643.613107] Dynamic subtest pipe-C: SUCCESS (5.378s)
[643.622811] Starting dynamic subtest: pipe-D
[648.992717] Dynamic subtest pipe-D: SUCCESS (5.378s)
[649.000941] Starting dynamic subtest: all-pipes
[654.375216] Dynamic subtest all-pipes: SUCCESS (5.379s)
[654.376119] Subtest single-move: SUCCESS (26.900s)
[654.430829] [099/133] (378s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[654.520374] Starting subtest: psr-rgb565-draw-mmap-cpu
[654.521727] Subtest psr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[654.623835] [100/133] (378s left) api_intel_bb (object-noreloc-purge-cache-simple)
[654.657176] Starting subtest: object-noreloc-purge-cache-simple
[654.659859] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.004s)
[654.794796] [101/133] (377s left) kms_scaling_modes (scaling-mode-center)
[654.879681] Starting subtest: scaling-mode-center
[654.883671] Subtest scaling-mode-center: SKIP (0.001s)
[655.002475] [102/133] (377s left) gem_busy (extended)
[655.174916] Starting subtest: extended
[655.175963] Starting dynamic subtest: rcs0
[655.198007] Dynamic subtest rcs0: SUCCESS (0.031s)
[655.215866] Starting dynamic subtest: bcs0
[655.216619] Dynamic subtest bcs0: SUCCESS (0.016s)
[655.225467] Starting dynamic subtest: vcs0
[655.233500] Dynamic subtest vcs0: SUCCESS (0.016s)
[655.243675] Starting dynamic subtest: vcs1
[655.252546] Dynamic subtest vcs1: SUCCESS (0.018s)
[655.263234] Starting dynamic subtest: vecs0
[655.266419] Dynamic subtest vecs0: SUCCESS (0.013s)
[655.267122] Subtest extended: SUCCESS (0.101s)
[655.517397] [103/133] (377s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[655.605968] Starting subtest: dp-mst-lic-type-0-hdcp14
[655.607380] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[655.726805] [104/133] (377s left) gem_exec_nop (basic-parallel)
[655.768341] Starting subtest: basic-parallel
[659.075161] Subtest basic-parallel: SUCCESS (3.306s)
[659.332406] [105/133] (373s left) kms_cursor_crc (cursor-offscreen-256x85)
[659.422403] Starting subtest: cursor-offscreen-256x85
[659.428015] Starting dynamic subtest: pipe-A-HDMI-A-1
[662.136277] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.708s)
[662.169420] Starting dynamic subtest: pipe-D-HDMI-A-1
[664.772738] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.611s)
[664.773469] Subtest cursor-offscreen-256x85: SUCCESS (5.349s)
[664.945302] [106/133] (368s left) kms_chamelium_frames (hdmi-frame-dump)
[665.099669] Subtest hdmi-frame-dump: SKIP (0.000s)
[665.187603] [107/133] (367s left) kms_vblank (wait-forked-busy-hang)
[665.272745] Starting subtest: wait-forked-busy-hang
[665.274535] Starting dynamic subtest: pipe-A-HDMI-A-1
[679.244997] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.969s)
[679.256583] Starting dynamic subtest: pipe-D-HDMI-A-1
[693.056690] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.803s)
[693.057370] Subtest wait-forked-busy-hang: SUCCESS (27.778s)
[693.221373] [108/133] (339s left) gem_exec_balancer (nohangcheck)
[693.386416] Starting subtest: nohangcheck
[694.693100] Subtest nohangcheck: SUCCESS (1.300s)
[694.772396] [109/133] (338s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[694.857866] Starting subtest: cursorA-vs-flipB-toggle
[694.860376] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[694.985816] [110/133] (338s left) gem_exec_params (rsvd2-dirt)
[695.021882] Starting subtest: rsvd2-dirt
[695.023206] Subtest rsvd2-dirt: SKIP (0.000s)
[695.155578] [111/133] (338s left) i915_drm_fdinfo (busy-check-all)
[695.190961] Starting subtest: busy-check-all
[695.191668] Starting dynamic subtest: rcs0
[695.710725] Dynamic subtest rcs0: SUCCESS (0.519s)
[695.722038] Starting dynamic subtest: bcs0
[696.240112] Dynamic subtest bcs0: SUCCESS (0.527s)
[696.251337] Starting dynamic subtest: vcs0
[696.761723] Dynamic subtest vcs0: SUCCESS (0.520s)
[696.772992] Starting dynamic subtest: vcs1
[697.282941] Dynamic subtest vcs1: SUCCESS (0.519s)
[697.294023] Starting dynamic subtest: vecs0
[697.804598] Dynamic subtest vecs0: SUCCESS (0.520s)
[697.805575] Subtest busy-check-all: SUCCESS (2.615s)
[697.908597] [112/133] (335s left) gem_mmap_wc (copy)
[697.941385] Starting subtest: copy
[698.046089] Subtest copy: SUCCESS (0.104s)
[698.153917] [113/133] (335s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[698.240560] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[698.241242] Starting dynamic subtest: pipe-A
[698.370705] Dynamic subtest pipe-A: SUCCESS (0.130s)
[698.387116] Starting dynamic subtest: pipe-B
[698.533193] Dynamic subtest pipe-B: SUCCESS (0.160s)
[698.548676] Starting dynamic subtest: pipe-C
[698.709977] Dynamic subtest pipe-C: SUCCESS (0.175s)
[698.721363] Starting dynamic subtest: pipe-D
[698.871171] Dynamic subtest pipe-D: SUCCESS (0.160s)
[698.872113] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (0.632s)
[699.077944] [114/133] (334s left) gem_ctx_param (invalid-get-engines)
[699.115150] Starting subtest: invalid-get-engines
[699.115865] Subtest invalid-get-engines: SUCCESS (0.000s)
[699.209403] [115/133] (334s left) gem_mmap_wc (read)
[699.242243] Starting subtest: read
[699.250511] Subtest read: SUCCESS (0.008s)
[699.382151] [116/133] (334s left) gem_userptr_blits (mmap-offset-banned)
[699.426662] Starting subtest: mmap-offset-banned
[699.427360] Starting dynamic subtest: gtt
[699.428014] Dynamic subtest gtt: SUCCESS (0.000s)
[699.435969] Starting dynamic subtest: wb
[699.436645] Dynamic subtest wb: SUCCESS (0.000s)
[699.444621] Starting dynamic subtest: wc
[699.445353] Dynamic subtest wc: SUCCESS (0.000s)
[699.452704] Starting dynamic subtest: uc
[699.453378] Dynamic subtest uc: SUCCESS (0.000s)
[699.454022] Subtest mmap-offset-banned: SUCCESS (0.004s)
[699.570850] [117/133] (333s left) gem_fence_thrash (bo-write-verify-x)
[699.602660] Starting subtest: bo-write-verify-x
[700.693872] Subtest bo-write-verify-x: SUCCESS (1.084s)
[700.801001] [118/133] (332s left) drm_read (fault-buffer)
[700.908904] Starting subtest: fault-buffer
[700.909654] Subtest fault-buffer: SUCCESS (0.001s)
[701.069936] [119/133] (332s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[701.200870] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[701.281556] [120/133] (332s left) gem_userptr_blits (unsync-overlap)
[701.322803] Subtest unsync-overlap: SKIP (0.000s)
[701.494801] [121/133] (332s left) kms_big_fb (linear-64bpp-rotate-90)
[701.588467] Starting subtest: linear-64bpp-rotate-90
[701.656090] Subtest linear-64bpp-rotate-90: SKIP (0.067s)
[701.792108] [122/133] (331s left) syncobj_wait (wait-all-for-submit-complex)
[701.826317] Starting subtest: wait-all-for-submit-complex
[702.051359] Subtest wait-all-for-submit-complex: SUCCESS (0.216s)
[702.149380] [123/133] (331s left) api_intel_allocator (execbuf-with-allocator)
[702.183680] Starting subtest: execbuf-with-allocator
[702.185817] Subtest execbuf-with-allocator: SUCCESS (0.003s)
[702.322774] [124/133] (331s left) gem_flink_race (flink_close)
[702.354190] Starting subtest: flink_close
[707.388823] Subtest flink_close: SUCCESS (5.035s)
[707.503543] [125/133] (326s left) gem_ctx_persistence (legacy-engines-mixed)
[707.541929] Starting subtest: legacy-engines-mixed
[707.543716] Starting dynamic subtest: render
[707.584144] Dynamic subtest render: SUCCESS (0.041s)
[707.599668] Starting dynamic subtest: bsd1
[707.636160] Dynamic subtest bsd1: SUCCESS (0.050s)
[707.652636] Starting dynamic subtest: bsd2
[707.684078] Dynamic subtest bsd2: SUCCESS (0.045s)
[707.700063] Starting dynamic subtest: blt
[707.734203] Dynamic subtest blt: SUCCESS (0.048s)
[707.750223] Starting dynamic subtest: vebox
[707.782269] Dynamic subtest vebox: SUCCESS (0.045s)
[707.783251] Subtest legacy-engines-mixed: SUCCESS (0.241s)
[707.882912] [126/133] (326s left) gem_cs_tlb (engines)
[707.918540] Starting subtest: engines
[707.919223] Starting dynamic subtest: rcs0
[710.077698] Dynamic subtest rcs0: SUCCESS (2.150s)
[710.086873] Starting dynamic subtest: bcs0
[712.228779] Dynamic subtest bcs0: SUCCESS (2.150s)
[712.237091] Starting dynamic subtest: vcs0
[714.378913] Dynamic subtest vcs0: SUCCESS (2.149s)
[714.387607] Starting dynamic subtest: vcs1
[716.529183] Dynamic subtest vcs1: SUCCESS (2.149s)
[716.538114] Starting dynamic subtest: vecs0
[718.679147] Dynamic subtest vecs0: SUCCESS (2.150s)
[718.679843] Subtest engines: SUCCESS (10.754s)
[718.810397] [127/133] (315s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[718.899306] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[718.900677] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[719.035099] [128/133] (314s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[719.118733] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[719.120123] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[719.243599] [129/133] (314s left) sw_sync (alloc_fence_invalid_timeline)
[719.275873] Starting subtest: alloc_fence_invalid_timeline
[719.276647] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[719.374564] [130/133] (314s left) vgem_basic (dmabuf-fence-before)
[719.424514] Starting subtest: dmabuf-fence-before
[719.425229] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[719.504396] [131/133] (314s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[719.537554] Starting subtest: etime-multi-wait-for-submit-submitted
[719.645455] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.108s)
[719.774807] [132/133] (314s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[719.808810] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[719.809524] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[719.907342] [133/133] (314s left) gem_exec_whisper (basic-forked)
[719.950480] Starting subtest: basic-forked
[721.519400] Subtest basic-forked: SUCCESS (1.570s)
[721.739695] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_psr2_sf
results: parsing output: 2/ for test: gem_mmap
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: syncobj_wait
results: parsing output: 7/ for test: kms_color
results: parsing output: 8/ for test: i915_pm_freq_api
results: parsing output: 9/ for test: gem_exec_fence
results: parsing output: 10/ for test: kms_force_connector_basic
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: prime_self_import
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: gem_exec_params
results: parsing output: 16/ for test: i915_pm_rps
results: parsing output: 17/ for test: kms_flip_scaled_crc
results: parsing output: 18/ for test: gem_mmap_wc
results: parsing output: 19/ for test: kms_joiner
results: parsing output: 20/ for test: kms_lease
results: parsing output: 21/ for test: gem_render_copy
results: parsing output: 22/ for test: kms_feature_discovery
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_busy
results: parsing output: 26/ for test: kms_prop_blob
results: parsing output: 27/ for test: gem_pxp
results: parsing output: 28/ for test: perf
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: core_setmaster
results: parsing output: 32/ for test: gem_render_copy
results: parsing output: 33/ for test: gem_partial_pwrite_pread
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: gem_userptr_blits
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: kms_plane
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: kms_pm_rpm
results: parsing output: 41/ for test: kms_addfb_basic
results: parsing output: 42/ for test: prime_vgem
results: parsing output: 43/ for test: kms_pipe_crc_basic
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: kms_async_flips
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: kms_vrr
results: parsing output: 48/ for test: gem_spin_batch
results: parsing output: 49/ for test: kms_chamelium_color
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: gem_pwrite
results: parsing output: 52/ for test: kms_pm_rpm
results: parsing output: 53/ for test: i915_selftest
results: parsing output: 54/ for test: sysfs_preempt_timeout
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: gem_exec_fence
results: parsing output: 57/ for test: kms_plane
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: gem_exec_schedule
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: perf
results: parsing output: 63/ for test: kms_cursor_crc
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: gen7_exec_parse
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_exec_schedule
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: gem_ctx_shared
results: parsing output: 70/ for test: gem_mmap_offset
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_hdr
results: parsing output: 77/ for test: kms_async_flips
results: parsing output: 78/ for test: kms_rotation_crc
results: parsing output: 79/ for test: kms_cursor_edge_walk
results: parsing output: 80/ for test: gem_exec_flush
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: kms_flip_scaled_crc
results: parsing output: 83/ for test: gem_workarounds
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_pipe_crc_basic
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_lmem_swapping
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: gem_partial_pwrite_pread
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_exec_params
results: parsing output: 92/ for test: gem_lmem_swapping
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_sequence
results: parsing output: 96/ for test: gem_pread
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: api_intel_bb
results: parsing output: 100/ for test: kms_scaling_modes
results: parsing output: 101/ for test: gem_busy
results: parsing output: 102/ for test: kms_content_protection
results: parsing output: 103/ for test: gem_exec_nop
results: parsing output: 104/ for test: kms_cursor_crc
results: parsing output: 105/ for test: kms_chamelium_frames
results: parsing output: 106/ for test: kms_vblank
results: parsing output: 107/ for test: gem_exec_balancer
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: gem_exec_params
results: parsing output: 110/ for test: i915_drm_fdinfo
results: parsing output: 111/ for test: gem_mmap_wc
results: parsing output: 112/ for test: kms_plane_scaling
results: parsing output: 113/ for test: gem_ctx_param
results: parsing output: 114/ for test: gem_mmap_wc
results: parsing output: 115/ for test: gem_userptr_blits
results: parsing output: 116/ for test: gem_fence_thrash
results: parsing output: 117/ for test: drm_read
results: parsing output: 118/ for test: kms_chamelium_hpd
results: parsing output: 119/ for test: gem_userptr_blits
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: api_intel_allocator
results: parsing output: 123/ for test: gem_flink_race
results: parsing output: 124/ for test: gem_ctx_persistence
results: parsing output: 125/ for test: gem_cs_tlb
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_plane
results: parsing output: 128/ for test: sw_sync
results: parsing output: 129/ for test: vgem_basic
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: syncobj_timeline
results: parsing output: 132/ for test: gem_exec_whisper
Done.