[90.420195] Initializing watchdogs
[90.420392]   /dev/watchdog0
[90.459502] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[90.474000] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[90.481196] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[90.489244] [001/131] (960s left) drm_read (short-buffer-wakeup)
[91.234224] Starting subtest: short-buffer-wakeup
[123.443045] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[123.732616] [002/131] (927s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[123.923679] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[123.931229] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[124.099161] [003/131] (927s left) gem_wait (wait)
[124.238844] Starting subtest: wait
[124.241948] Starting dynamic subtest: all-engines
[125.280139] Dynamic subtest all-engines: SUCCESS (1.042s)
[125.299800] Starting dynamic subtest: rcs0
[126.316160] Dynamic subtest rcs0: SUCCESS (1.035s)
[126.333927] Starting dynamic subtest: bcs0
[127.345644] Dynamic subtest bcs0: SUCCESS (1.028s)
[127.363345] Starting dynamic subtest: vcs0
[128.377451] Dynamic subtest vcs0: SUCCESS (1.027s)
[128.395301] Starting dynamic subtest: vecs0
[129.397275] Dynamic subtest vecs0: SUCCESS (1.022s)
[129.400468] Subtest wait: SUCCESS (5.160s)
[129.714296] [004/131] (921s left) gem_exec_balancer (parallel-contexts)
[129.954157] Subtest parallel-contexts: SKIP (0.000s)
[130.135554] [005/131] (921s left) kms_psr2_su (page_flip-xrgb8888)
[130.245192] Subtest page_flip-XRGB8888: SKIP (0.000s)
[130.339396] [006/131] (921s left) kms_cursor_legacy (torture-move)
[130.513767] Starting subtest: torture-move
[130.517786] Starting dynamic subtest: pipe-A
[136.932774] Dynamic subtest pipe-A: SUCCESS (6.415s)
[136.952055] Starting dynamic subtest: pipe-B
[142.765821] Dynamic subtest pipe-B: SUCCESS (5.835s)
[142.784045] Starting dynamic subtest: pipe-C
[148.214978] Dynamic subtest pipe-C: SUCCESS (5.449s)
[148.236091] Starting dynamic subtest: all-pipes
[153.814028] Dynamic subtest all-pipes: SUCCESS (5.593s)
[153.817148] Subtest torture-move: SUCCESS (23.298s)
[153.983367] [007/131] (897s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[154.205217] Starting subtest: cursor-rapid-movement-256x256
[154.242786] Starting dynamic subtest: pipe-A-HDMI-A-1
[155.102111] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.857s)
[155.205387] Starting dynamic subtest: pipe-C-HDMI-A-1
[155.709337] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.542s)
[155.713231] Subtest cursor-rapid-movement-256x256: SUCCESS (1.502s)
[156.025494] [008/131] (895s left) gem_exec_params (secure-non-root)
[156.150587] Starting subtest: secure-non-root
[156.157919] Subtest secure-non-root: SKIP (0.000s)
[156.320870] [009/131] (895s left) kms_fb_coherency (memset-crc)
[156.498093] Starting subtest: memset-crc
[156.502871] Starting dynamic subtest: mmap-gtt
[157.857566] Dynamic subtest mmap-gtt: CRASH (0.485s)
[158.820559] Subtest memset-crc: CRASH (1.306s)
[158.904262] [010/131] (892s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[159.675603] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[160.196519] [011/131] (892s left) gem_unfence_active_buffers
[160.859256] [012/131] (891s left) kms_plane_lowres (tiling-4)
[161.033342] Starting subtest: tiling-4
[161.039691] Subtest tiling-4: SKIP (0.000s)
[161.194392] [013/131] (891s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[161.396537] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[161.403801] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[161.576480] [014/131] (890s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[161.784188] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[164.463085] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SUCCESS (2.680s)
[164.700180] [015/131] (887s left) gen9_exec_parse (batch-invalid-length)
[164.823754] Starting subtest: batch-invalid-length
[164.831289] Subtest batch-invalid-length: SUCCESS (0.010s)
[165.108436] [016/131] (887s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[165.315127] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[167.128653] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.811s)
[167.408530] [017/131] (885s left) vgem_basic (dmabuf-fence-before)
[167.604918] Starting subtest: dmabuf-fence-before
[167.608372] Subtest dmabuf-fence-before: SUCCESS (0.003s)
[167.757427] [FACT vgem_basic (dmabuf-fence-before)] new: kernel.kmod_is_loaded.vgem: true
[167.763899] [018/131] (885s left) kms_hdr (static-toggle-dpms)
[167.947722] Starting subtest: static-toggle-dpms
[195.672839] Subtest static-toggle-dpms: SKIP (27.676s)
[196.089513] [019/131] (856s left) prime_self_import (basic-with_two_bos)
[196.227314] Starting subtest: basic-with_two_bos
[196.234427] Subtest basic-with_two_bos: SUCCESS (0.007s)
[196.423603] [020/131] (856s left) kms_psr (fbc-psr-no-drrs)
[196.611584] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[196.725149] [021/131] (856s left) kms_pm_rpm (pm-caching)
[198.628571] Starting subtest: pm-caching
[200.148664] Subtest pm-caching: SUCCESS (1.522s)
[200.543271] [022/131] (852s left) kms_flip (absolute-wf_vblank-interruptible)
[200.735945] Starting subtest: absolute-wf_vblank-interruptible
[200.746487] Starting dynamic subtest: A-HDMI-A1
[206.366946] Dynamic subtest A-HDMI-A1: SUCCESS (5.624s)
[206.387881] Starting dynamic subtest: B-HDMI-A1
[211.713176] Dynamic subtest B-HDMI-A1: SUCCESS (5.339s)
[211.732222] Starting dynamic subtest: C-HDMI-A1
[217.067536] Dynamic subtest C-HDMI-A1: SUCCESS (5.353s)
[217.087101] Starting dynamic subtest: A-HDMI-A2
[222.601231] Dynamic subtest A-HDMI-A2: SUCCESS (5.527s)
[222.620931] Starting dynamic subtest: B-HDMI-A2
[227.963241] Dynamic subtest B-HDMI-A2: SUCCESS (5.358s)
[227.982733] Starting dynamic subtest: C-HDMI-A2
[233.324256] Dynamic subtest C-HDMI-A2: SUCCESS (5.356s)
[233.330070] Subtest absolute-wf_vblank-interruptible: SUCCESS (32.590s)
[233.830691] [023/131] (819s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[234.033612] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[234.039920] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[234.224869] [024/131] (819s left) gem_exec_reloc (basic-write-read)
[234.341196] Starting subtest: basic-write-read
[234.353458] Subtest basic-write-read: SUCCESS (0.014s)
[234.629394] [025/131] (818s left) syncobj_timeline (wait-all-interrupted)
[234.745150] Starting subtest: wait-all-interrupted
[234.851276] Subtest wait-all-interrupted: SUCCESS (0.106s)
[235.024769] [026/131] (818s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[235.218685] Starting subtest: fbcpsr-tiling-linear
[235.225148] Subtest fbcpsr-tiling-linear: SKIP (0.000s)
[235.396219] [027/131] (818s left) kms_tv_load_detect (load-detect)
[235.509140] Subtest load-detect: SKIP (0.000s)
[235.605209] [028/131] (818s left) kms_addfb_basic (no-handle)
[235.708805] Starting subtest: no-handle
[235.713089] Subtest no-handle: SUCCESS (0.000s)
[235.977560] [029/131] (818s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[236.168494] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[236.172519] Starting dynamic subtest: pipe-A
[236.467372] Dynamic subtest pipe-A: SUCCESS (0.306s)
[236.496063] Starting dynamic subtest: pipe-B
[236.860117] Dynamic subtest pipe-B: SUCCESS (0.390s)
[236.894288] Starting dynamic subtest: pipe-C
[236.940299] Dynamic subtest pipe-C: SUCCESS (0.076s)
[236.943837] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (0.783s)
[237.436271] [030/131] (816s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[237.636979] Starting subtest: yf-tiled-8bpp-rotate-270
[237.644287] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[237.820992] [031/131] (816s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[238.025326] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[238.033136] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[238.203997] [032/131] (816s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[238.311355] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[238.315614] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.002s)
[238.484289] [033/131] (815s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[238.659301] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[239.255051] Subtest async-flip-with-page-flip-events-linear-atomic: SKIP (0.596s)
[239.603574] [034/131] (814s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[239.848534] Starting subtest: cursor-rapid-movement-max-size
[239.858992] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[240.021106] [035/131] (814s left) gem_exec_params (invalid-batch-start-offset)
[240.141087] Starting subtest: invalid-batch-start-offset
[240.144465] Subtest invalid-batch-start-offset: SUCCESS (0.007s)
[240.335463] [036/131] (814s left) api_intel_bb (misplaced-blitter)
[240.441953] Starting subtest: misplaced-blitter
[240.454150] Subtest misplaced-blitter: SUCCESS (0.015s)
[240.671618] [037/131] (814s left) api_intel_bb (blit-reloc-keep-cache)
[240.785048] Starting subtest: blit-reloc-keep-cache
[240.799788] Subtest blit-reloc-keep-cache: SUCCESS (0.018s)
[240.985288] [038/131] (813s left) gem_ctx_shared (q-in-order)
[241.110801] Starting subtest: Q-in-order
[241.114154] Starting dynamic subtest: rcs0
[241.197308] Dynamic subtest rcs0: SUCCESS (0.086s)
[241.220256] Starting dynamic subtest: bcs0
[241.304482] Dynamic subtest bcs0: SUCCESS (0.103s)
[241.323887] Starting dynamic subtest: vcs0
[241.401701] Dynamic subtest vcs0: SUCCESS (0.092s)
[241.422630] Starting dynamic subtest: vecs0
[241.497700] Dynamic subtest vecs0: SUCCESS (0.090s)
[241.501783] Subtest Q-in-order: SUCCESS (0.389s)
[241.801829] [039/131] (813s left) i915_hangman (hangcheck-unterminated)
[241.935181] Starting subtest: hangcheck-unterminated
[252.068682] Subtest hangcheck-unterminated: SUCCESS (10.140s)
[252.270397] [040/131] (802s left) kms_pm_rpm (cursor-dpms)
[254.173332] Starting subtest: cursor-dpms
[256.222394] Subtest cursor-dpms: SUCCESS (2.049s)
[256.637842] [041/131] (798s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[256.862637] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[256.868244] Starting dynamic subtest: pipe-A-valid-mode
[257.210584] Dynamic subtest pipe-A-valid-mode: SKIP (0.378s)
[257.293672] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.385s)
[257.526276] [042/131] (797s left) gem_basic (bad-close)
[257.637113] Starting subtest: bad-close
[257.643233] Subtest bad-close: SUCCESS (0.000s)
[257.805663] [043/131] (797s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[258.004315] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[258.011919] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[258.176498] [044/131] (797s left) i915_drm_fdinfo (isolation)
[258.293242] Starting subtest: isolation
[258.298087] Starting dynamic subtest: rcs0
[258.838073] Dynamic subtest rcs0: SUCCESS (0.543s)
[258.860729] Starting dynamic subtest: bcs0
[259.371710] Dynamic subtest bcs0: SUCCESS (0.530s)
[259.393121] Starting dynamic subtest: vcs0
[259.901138] Dynamic subtest vcs0: SUCCESS (0.527s)
[259.922237] Starting dynamic subtest: vecs0
[260.432180] Dynamic subtest vecs0: SUCCESS (0.529s)
[260.435629] Subtest isolation: SUCCESS (2.144s)
[260.619987] [045/131] (795s left) kms_psr (pr-primary-page-flip)
[260.807809] Subtest pr-primary-page-flip: SKIP (0.000s)
[260.922776] [046/131] (794s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[261.133433] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[261.141648] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[261.323776] [047/131] (794s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[261.499461] Starting subtest: modeset-transition-nonblocking-fencing
[261.503748] Starting dynamic subtest: 1x-outputs
[265.021217] Dynamic subtest 1x-outputs: SUCCESS (3.519s)
[265.041386] Starting dynamic subtest: 2x-outputs
[272.390231] Dynamic subtest 2x-outputs: SUCCESS (7.366s)
[272.393511] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.892s)
[272.715158] [048/131] (783s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[272.930236] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[275.501572] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.574s)
[275.762544] [049/131] (780s left) syncobj_wait (wait-any-complex)
[275.867162] Starting subtest: wait-any-complex
[275.933186] Subtest wait-any-complex: SUCCESS (0.066s)
[276.110145] [050/131] (780s left) kms_vblank (ts-continuation-dpms-suspend)
[276.288363] Starting subtest: ts-continuation-dpms-suspend
[276.301682] Starting dynamic subtest: pipe-A-HDMI-A-1