[86.842973] Initializing watchdogs
[86.843186]   /dev/watchdog0
[86.881923] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[86.894812] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card1
[86.901905] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[86.910397] [001/133] (960s left) kms_psr (psr2-sprite-blt)
[87.114441] Subtest psr2-sprite-blt: SKIP (0.000s)
[87.218970] [002/133] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[87.433679] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[90.425497] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (2.996s)
[90.755198] [003/133] (956s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[90.958598] Starting subtest: yf-tiled-8bpp-rotate-90
[90.965295] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[91.103880] [004/133] (956s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[91.285825] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[91.289082] Starting dynamic subtest: pipe-A
[91.587163] Dynamic subtest pipe-A: SUCCESS (0.305s)
[91.613517] Starting dynamic subtest: pipe-B
[91.983961] Dynamic subtest pipe-B: SUCCESS (0.396s)
[92.012729] Starting dynamic subtest: pipe-C
[92.066089] Dynamic subtest pipe-C: SUCCESS (0.077s)
[92.070295] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.781s)
[92.511194] [005/133] (955s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[92.715443] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[92.722574] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[92.863952] [006/133] (954s left) gem_exec_balancer (bonded-true-hang)
[93.115564] Starting subtest: bonded-true-hang
[97.175214] Subtest bonded-true-hang: SUCCESS (4.063s)
[97.346802] [007/133] (950s left) gem_pread (snoop)
[97.451506] Starting subtest: snoop
[100.753357] Subtest snoop: SUCCESS (3.302s)
[100.928196] [008/133] (947s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[101.116174] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[101.209615] [009/133] (946s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[101.416515] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[101.423583] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[101.578496] [010/133] (946s left) kms_lease (master-vs-lease)
[101.757576] Starting subtest: master-vs-lease
[101.771119] Subtest master-vs-lease: SUCCESS (0.007s)
[101.967726] [011/133] (946s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[102.176536] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[102.183229] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[102.348083] [012/133] (946s left) gem_ringfill (basic-all)
[102.763753] Starting subtest: basic-all
[103.955032] Subtest basic-all: SUCCESS (1.190s)
[104.136914] [FACT gem_ringfill (basic-all)] new: kernel.kmod_is_loaded.vgem: true
[104.143289] [013/133] (944s left) gem_ctx_param (invalid-set-no-zeromap)
[104.249722] Starting subtest: invalid-set-no-zeromap
[104.253222] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[104.422750] [014/133] (944s left) kms_cursor_crc (cursor-random-256x256)
[104.645798] Starting subtest: cursor-random-256x256
[104.690216] Starting dynamic subtest: pipe-A-HDMI-A-1
[108.901434] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.207s)
[109.000861] Starting dynamic subtest: pipe-C-HDMI-A-1
[112.854651] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.883s)
[112.858111] Subtest cursor-random-256x256: SUCCESS (8.205s)
[113.187401] [015/133] (935s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[113.370510] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[113.373700] Starting dynamic subtest: pipe-A-HDMI-A-1
[113.407169] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[113.426593] Starting dynamic subtest: pipe-A-HDMI-A-2
[113.462599] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[113.480975] Starting dynamic subtest: pipe-B-HDMI-A-1
[113.513431] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[113.532060] Starting dynamic subtest: pipe-B-HDMI-A-2
[113.564568] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[113.582966] Starting dynamic subtest: pipe-C-HDMI-A-1
[113.615371] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[113.633807] Starting dynamic subtest: pipe-C-HDMI-A-2
[113.665746] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[113.672616] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.016s)
[114.309808] [016/133] (934s left) gem_mmap (pf-nonblock)
[114.415115] Starting subtest: pf-nonblock
[114.428342] Subtest pf-nonblock: SUCCESS (0.009s)
[114.624261] [017/133] (934s left) device_reset (cold-reset-bound)
[114.756337] Starting subtest: cold-reset-bound
[114.764595] Subtest cold-reset-bound: SKIP (0.000s)
[114.921315] [018/133] (934s left) gem_exec_schedule (in-order)
[115.060595] Starting subtest: in-order
[115.064267] Starting dynamic subtest: rcs0
[115.173644] Dynamic subtest rcs0: SUCCESS (0.116s)
[115.199193] Starting dynamic subtest: bcs0
[115.304099] Dynamic subtest bcs0: SUCCESS (0.133s)
[115.329062] Starting dynamic subtest: vcs0
[115.424855] Dynamic subtest vcs0: SUCCESS (0.117s)
[115.451035] Starting dynamic subtest: vecs0
[115.540773] Dynamic subtest vecs0: SUCCESS (0.116s)
[115.544204] Subtest in-order: SUCCESS (0.485s)
[115.944319] [019/133] (933s left) kms_cdclk (mode-transition)
[116.051308] Subtest mode-transition: SKIP (0.000s)
[116.169281] [020/133] (932s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[116.362447] Starting subtest: extended-pageflip-modeset-hang-oldfb
[116.365653] Starting dynamic subtest: pipe-A
[120.816776] Dynamic subtest pipe-A: SUCCESS (4.449s)
[120.846072] Starting dynamic subtest: pipe-C
[124.818063] Dynamic subtest pipe-C: SUCCESS (3.990s)
[124.822899] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (8.453s)
[125.140917] [021/133] (924s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[125.326292] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[125.333516] Subtest plane-all-modeset-transition-fencing-internal-panels: SKIP (0.000s)
[125.505195] [022/133] (923s left) i915_selftest (mock)
[127.470688] Starting subtest: mock
[127.474745] Starting dynamic subtest: sanitycheck
[129.152444] Dynamic subtest sanitycheck: SUCCESS (1.681s)
[129.171861] Starting dynamic subtest: shmem
[130.855299] Dynamic subtest shmem: SUCCESS (1.701s)
[130.875057] Starting dynamic subtest: fence
[140.159467] Dynamic subtest fence: SUCCESS (9.304s)
[140.183047] Starting dynamic subtest: scatterlist
[142.877612] Dynamic subtest scatterlist: SUCCESS (2.713s)
[142.898945] Starting dynamic subtest: syncmap
[146.623545] Dynamic subtest syncmap: SUCCESS (3.745s)
[146.645691] Starting dynamic subtest: uncore
[148.340138] Dynamic subtest uncore: SUCCESS (1.716s)
[148.359477] Starting dynamic subtest: ring
[150.015567] Dynamic subtest ring: SUCCESS (1.673s)
[150.035170] Starting dynamic subtest: engine
[151.702656] Dynamic subtest engine: SUCCESS (1.686s)
[151.721998] Starting dynamic subtest: timelines
[161.101125] Dynamic subtest timelines: SUCCESS (9.395s)
[161.124231] Starting dynamic subtest: requests
[164.884580] Dynamic subtest requests: SUCCESS (3.782s)
[164.907406] Starting dynamic subtest: objects
[166.737886] Dynamic subtest objects: SUCCESS (1.852s)
[166.761211] Starting dynamic subtest: phys
[168.614505] Dynamic subtest phys: SUCCESS (1.875s)
[168.633746] Starting dynamic subtest: dmabuf
[170.532319] Dynamic subtest dmabuf: SUCCESS (1.915s)
[170.556217] Starting dynamic subtest: vma
[190.112062] Dynamic subtest vma: SUCCESS (19.577s)
[190.137842] Starting dynamic subtest: evict
[194.231298] Dynamic subtest evict: SUCCESS (4.118s)
[194.255869] Starting dynamic subtest: gtt
[199.681432] Dynamic subtest gtt: SUCCESS (5.447s)
[199.699431] Starting dynamic subtest: hugepages
[201.905256] Dynamic subtest hugepages: SUCCESS (2.223s)
[201.929758] Starting dynamic subtest: memory_region
[209.976651] Dynamic subtest memory_region: SUCCESS (8.068s)
[209.980466] Subtest mock: SUCCESS (82.506s)
[210.042841] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card1
[210.045733] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[210.062467] [023/133] (839s left) kms_addfb_basic (bad-pitch-999)
[212.559739] Starting subtest: bad-pitch-999
[212.562843] Subtest bad-pitch-999: SUCCESS (0.000s)
[212.887974] [FACT kms_addfb_basic (bad-pitch-999)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card1
[212.895969] [FACT kms_addfb_basic (bad-pitch-999)] new: kernel.kmod_is_loaded.i915: true
[212.910229] [024/133] (836s left) gem_ctx_persistence (legacy-engines-mixed-process)
[213.176651] Starting subtest: legacy-engines-mixed-process
[213.185082] Starting dynamic subtest: render
[213.632126] Dynamic subtest render: SUCCESS (0.446s)
[213.659400] Starting dynamic subtest: bsd
[214.029955] Dynamic subtest bsd: SUCCESS (0.393s)
[214.064484] Starting dynamic subtest: blt
[214.424086] Dynamic subtest blt: SUCCESS (0.394s)
[214.469715] Starting dynamic subtest: vebox
[214.790502] Dynamic subtest vebox: SUCCESS (0.362s)
[214.793708] Subtest legacy-engines-mixed-process: SUCCESS (1.613s)
[214.995387] [025/133] (834s left) syncobj_eventfd (binary-wait)
[215.105412] Starting subtest: binary-wait
[215.113394] Subtest binary-wait: SUCCESS (0.011s)
[215.293713] [026/133] (834s left) sysfs_heartbeat_interval (idempotent)
[215.407295] Starting subtest: idempotent
[215.410766] Starting dynamic subtest: vecs0
[215.414736] Dynamic subtest vecs0: SUCCESS (0.006s)
[215.435914] Starting dynamic subtest: vcs0
[215.439238] Dynamic subtest vcs0: SUCCESS (0.004s)
[215.459062] Starting dynamic subtest: bcs0
[215.462387] Dynamic subtest bcs0: SUCCESS (0.004s)
[215.482289] Starting dynamic subtest: rcs0
[215.486488] Dynamic subtest rcs0: SUCCESS (0.004s)
[215.490502] Subtest idempotent: SUCCESS (0.024s)
[215.627223] [027/133] (834s left) gem_barrier_race (remote-request)
[215.750763] Starting subtest: remote-request
[215.757275] Starting dynamic subtest: rcs0
[220.839104] Dynamic subtest rcs0: SUCCESS (5.092s)
[220.842993] Subtest remote-request: SUCCESS (5.093s)
[221.028765] [028/133] (829s left) gem_spin_batch (spin-all)
[221.154036] Starting subtest: spin-all
[221.181795] Subtest spin-all: SUCCESS (0.028s)
[221.496820] [029/133] (828s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[221.674334] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[221.678747] Starting dynamic subtest: pipe-A
[222.500620] Dynamic subtest pipe-A: SUCCESS (0.826s)
[222.523058] Starting dynamic subtest: pipe-B
[223.332182] Dynamic subtest pipe-B: SUCCESS (0.831s)
[223.366039] Starting dynamic subtest: pipe-C
[224.162982] Dynamic subtest pipe-C: SUCCESS (0.829s)
[224.166685] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (2.491s)
[224.685518] [030/133] (825s left) gem_workarounds (suspend-resume)
[224.827021] Starting subtest: suspend-resume