[94.437565] Initializing watchdogs
[94.437745]   /dev/watchdog0
[94.476205] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3184 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 605]
[94.490045] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[94.497740] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[94.504080] [001/133] (960s left) syncobj_basic (illegal-fd-to-handle)
[94.623094] Starting subtest: illegal-fd-to-handle
[94.625101] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[94.782124] [002/133] (960s left) prime_mmap (test_dup)
[94.880962] Starting subtest: test_dup
[94.882795] Starting dynamic subtest: test_dup-smem
[94.887864] Dynamic subtest test_dup-smem: SUCCESS (0.008s)
[94.889958] Subtest test_dup: SUCCESS (0.009s)
[95.016378] [003/133] (960s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[95.213788] Starting subtest: y-tiled-16bpp-rotate-90
[95.701857] Subtest y-tiled-16bpp-rotate-90: SKIP (0.485s)
[95.938376] [004/133] (959s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[96.129277] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[96.133275] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[96.271572] [005/133] (959s left) kms_atomic_transition (modeset-transition)
[96.446770] Starting subtest: modeset-transition
[96.448662] Starting dynamic subtest: 1x-outputs
[99.999069] Dynamic subtest 1x-outputs: SUCCESS (3.550s)
[100.016054] Starting dynamic subtest: 2x-outputs
[107.350846] Dynamic subtest 2x-outputs: SUCCESS (7.349s)
[107.353540] Subtest modeset-transition: SUCCESS (10.900s)
[107.642226] [006/133] (947s left) kms_flip (2x-blocking-absolute-wf_vblank)
[107.816428] Starting subtest: 2x-blocking-absolute-wf_vblank
[107.822971] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[118.518223] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.697s)
[118.535843] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[129.200334] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.678s)
[129.217491] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[139.845660] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.641s)
[139.848641] Subtest 2x-blocking-absolute-wf_vblank: SUCCESS (32.026s)
[140.417437] [007/133] (915s left) kms_plane_multiple (2x-tiling-x)
[140.589672] Starting subtest: 2x-tiling-x
[140.596018] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-B-HDMI-A-2
[141.503677] Dynamic subtest pipe-A-HDMI-A-1-pipe-B-HDMI-A-2: SUCCESS (0.908s)
[141.555722] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-C-HDMI-A-2
[142.487674] Dynamic subtest pipe-A-HDMI-A-1-pipe-C-HDMI-A-2: SUCCESS (0.944s)
[142.539059] Starting dynamic subtest: pipe-A-HDMI-A-2-pipe-B-HDMI-A-1
[143.662810] Dynamic subtest pipe-A-HDMI-A-2-pipe-B-HDMI-A-1: SUCCESS (1.138s)
[143.700988] Starting dynamic subtest: pipe-A-HDMI-A-2-pipe-C-HDMI-A-1
[144.630378] Dynamic subtest pipe-A-HDMI-A-2-pipe-C-HDMI-A-1: SUCCESS (0.946s)
[144.665818] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-A-HDMI-A-2
[145.872125] Dynamic subtest pipe-B-HDMI-A-1-pipe-A-HDMI-A-2: SUCCESS (1.220s)
[145.908036] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-C-HDMI-A-2
[146.871263] Dynamic subtest pipe-B-HDMI-A-1-pipe-C-HDMI-A-2: SUCCESS (0.979s)
[146.905756] Starting dynamic subtest: pipe-B-HDMI-A-2-pipe-A-HDMI-A-1
[147.991696] Dynamic subtest pipe-B-HDMI-A-2-pipe-A-HDMI-A-1: SUCCESS (1.099s)
[148.042436] Starting dynamic subtest: pipe-B-HDMI-A-2-pipe-C-HDMI-A-1
[148.966392] Dynamic subtest pipe-B-HDMI-A-2-pipe-C-HDMI-A-1: SUCCESS (0.938s)
[149.002420] Starting dynamic subtest: pipe-C-HDMI-A-1-pipe-A-HDMI-A-2
[149.928687] Dynamic subtest pipe-C-HDMI-A-1-pipe-A-HDMI-A-2: SUCCESS (0.939s)
[149.980314] Starting dynamic subtest: pipe-C-HDMI-A-1-pipe-B-HDMI-A-2
[150.927428] Dynamic subtest pipe-C-HDMI-A-1-pipe-B-HDMI-A-2: SUCCESS (0.962s)
[150.967176] Starting dynamic subtest: pipe-C-HDMI-A-2-pipe-A-HDMI-A-1
[152.103649] Dynamic subtest pipe-C-HDMI-A-2-pipe-A-HDMI-A-1: SUCCESS (1.156s)
[152.139613] Starting dynamic subtest: pipe-C-HDMI-A-2-pipe-B-HDMI-A-1
[153.054474] Dynamic subtest pipe-C-HDMI-A-2-pipe-B-HDMI-A-1: SUCCESS (0.929s)
[153.088420] Subtest 2x-tiling-x: SUCCESS (12.498s)
[153.778335] [008/133] (901s left) syncobj_eventfd (invalid-bad-flags)
[153.894655] Starting subtest: invalid-bad-flags
[153.896728] Subtest invalid-bad-flags: SUCCESS (0.001s)
[154.041360] [009/133] (901s left) prime_busy (before)
[154.159154] Starting subtest: before
[154.171887] Starting dynamic subtest: rcs0
[154.196556] Dynamic subtest rcs0: SUCCESS (0.023s)
[154.216704] Starting dynamic subtest: bcs0
[154.219787] Dynamic subtest bcs0: SUCCESS (0.012s)
[154.239437] Starting dynamic subtest: vcs0
[154.241811] Dynamic subtest vcs0: SUCCESS (0.019s)
[154.259362] Starting dynamic subtest: vecs0
[154.262611] Dynamic subtest vecs0: SUCCESS (0.015s)
[154.359458] Subtest before: SUCCESS (0.198s)
[154.507305] [010/133] (901s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[154.696746] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[154.700833] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[154.828945] [011/133] (900s left) gen9_exec_parse (unaligned-access)
[154.951780] Starting subtest: unaligned-access
[155.018032] Subtest unaligned-access: SUCCESS (0.064s)
[155.278331] [012/133] (900s left) perf (blocking-parameterized)
[155.473298] Starting subtest: blocking-parameterized
[175.514947] Subtest blocking-parameterized: SUCCESS (20.039s)
[175.611464] [013/133] (880s left) i915_selftest (live)
[180.752522] Starting subtest: live
[180.755030] Starting dynamic subtest: sanitycheck
[183.176824] Dynamic subtest sanitycheck: SUCCESS (2.423s)
[183.196209] Starting dynamic subtest: uncore
[185.726922] Dynamic subtest uncore: SUCCESS (2.549s)
[185.746351] Starting dynamic subtest: workarounds
[188.474943] Dynamic subtest workarounds: SUCCESS (2.746s)
[188.494313] Starting dynamic subtest: gt_engines
[191.491102] Dynamic subtest gt_engines: SUCCESS (3.014s)
[191.510477] Starting dynamic subtest: gt_timelines
[206.280672] Dynamic subtest gt_timelines: SUCCESS (14.787s)
[206.299939] Starting dynamic subtest: gt_contexts
[208.906505] Dynamic subtest gt_contexts: SUCCESS (2.623s)
[208.925965] Starting dynamic subtest: gt_lrc
[214.159913] Dynamic subtest gt_lrc: SUCCESS (5.249s)
[214.179959] Starting dynamic subtest: gt_mocs
[216.793646] Dynamic subtest gt_mocs: SUCCESS (2.633s)
[216.812509] Starting dynamic subtest: gt_pm
[228.530234] Dynamic subtest gt_pm: SUCCESS (11.733s)
[228.549669] Starting dynamic subtest: gt_heartbeat
[230.897835] Dynamic subtest gt_heartbeat: SUCCESS (2.361s)
[230.917958] Starting dynamic subtest: gt_tlb
[234.606359] Dynamic subtest gt_tlb: SUCCESS (3.710s)
[234.625550] Starting dynamic subtest: requests
[243.263320] Dynamic subtest requests: SUCCESS (8.653s)
[243.283842] Starting dynamic subtest: migrate
[248.818132] Dynamic subtest migrate: SUCCESS (5.554s)
[248.837116] Starting dynamic subtest: active
[251.358047] Dynamic subtest active: SUCCESS (2.537s)
[251.377590] Starting dynamic subtest: objects
[255.422490] Dynamic subtest objects: SUCCESS (4.062s)
[255.441960] Starting dynamic subtest: mman
[263.091506] Dynamic subtest mman: SUCCESS (7.666s)
[263.111799] Starting dynamic subtest: dmabuf
[265.576867] Dynamic subtest dmabuf: SUCCESS (2.482s)
[265.596493] Starting dynamic subtest: vma
[267.983194] Dynamic subtest vma: SUCCESS (2.403s)
[268.002609] Starting dynamic subtest: coherency
[272.724722] Dynamic subtest coherency: SUCCESS (4.739s)
[272.744208] Starting dynamic subtest: gtt
[283.115536] Dynamic subtest gtt: SUCCESS (10.389s)
[283.134679] Starting dynamic subtest: gem
[285.991511] Dynamic subtest gem: SUCCESS (2.873s)
[286.011041] Starting dynamic subtest: evict
[291.145806] Dynamic subtest evict: SUCCESS (5.152s)
[291.165069] Starting dynamic subtest: hugepages
[299.978336] Dynamic subtest hugepages: SUCCESS (8.830s)
[299.998832] Starting dynamic subtest: gem_contexts
[320.151204] Dynamic subtest gem_contexts: SUCCESS (20.171s)
[320.170200] Starting dynamic subtest: client
[322.762467] Dynamic subtest client: SUCCESS (2.609s)
[322.781929] Starting dynamic subtest: gem_migrate
[325.325546] Dynamic subtest gem_migrate: SUCCESS (2.560s)
[325.344951] Starting dynamic subtest: reset
[331.774171] Dynamic subtest reset: SUCCESS (6.445s)
[331.794026] Starting dynamic subtest: memory_region
[334.263253] Dynamic subtest memory_region: SUCCESS (2.486s)
[334.283341] Starting dynamic subtest: hangcheck
[359.728745] Dynamic subtest hangcheck: SUCCESS (25.466s)
[359.748157] Starting dynamic subtest: execlists
[371.275826] Dynamic subtest execlists: SUCCESS (11.545s)
[371.295354] Starting dynamic subtest: ring_submission
[373.775515] Dynamic subtest ring_submission: SUCCESS (2.497s)
[373.795092] Starting dynamic subtest: perf
[376.414308] Dynamic subtest perf: SUCCESS (2.635s)
[376.433919] Starting dynamic subtest: slpc
[378.734946] Dynamic subtest slpc: SUCCESS (2.318s)
[378.754829] Starting dynamic subtest: guc
[381.260069] Dynamic subtest guc: SUCCESS (2.521s)
[381.279469] Starting dynamic subtest: guc_multi_lrc
[383.652627] Dynamic subtest guc_multi_lrc: SUCCESS (2.389s)
[383.672850] Starting dynamic subtest: guc_hang
[385.971444] Dynamic subtest guc_hang: SUCCESS (2.315s)
[385.991281] Starting dynamic subtest: late_gt_pm
[388.566750] Dynamic subtest late_gt_pm: SUCCESS (2.591s)
[388.568808] Subtest live: SUCCESS (207.817s)
[388.624351] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[388.629796] [014/133] (667s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[391.193164] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[391.227577] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[391.364288] [FACT kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)] new: kernel.kmod_is_loaded.i915: true
[391.375018] [015/133] (664s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[391.553712] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[394.797242] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (3.243s)
[395.087980] [016/133] (661s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[395.267621] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[395.470759] Starting dynamic subtest: pipe-A-plane-0
[395.772616] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[395.791145] Starting dynamic subtest: pipe-A-plane-1
[396.036839] Dynamic subtest pipe-A-plane-1: SUCCESS (0.264s)
[396.058493] Starting dynamic subtest: pipe-A-plane-2
[396.302368] Dynamic subtest pipe-A-plane-2: SUCCESS (0.263s)
[396.324219] Starting dynamic subtest: pipe-A-plane-3
[396.569208] Dynamic subtest pipe-A-plane-3: SUCCESS (0.264s)
[396.911753] Starting dynamic subtest: pipe-B-plane-0
[397.161173] Dynamic subtest pipe-B-plane-0: SUCCESS (0.265s)
[397.184605] Starting dynamic subtest: pipe-B-plane-1
[397.428041] Dynamic subtest pipe-B-plane-1: SUCCESS (0.264s)
[397.451626] Starting dynamic subtest: pipe-B-plane-2
[397.695015] Dynamic subtest pipe-B-plane-2: SUCCESS (0.264s)
[397.717583] Starting dynamic subtest: pipe-B-plane-3
[397.962793] Dynamic subtest pipe-B-plane-3: SUCCESS (0.264s)
[398.163292] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SUCCESS (2.899s)
[398.463440] [017/133] (657s left) kms_vblank (wait-forked-hang)
[398.641223] Starting subtest: wait-forked-hang
[398.643094] Starting dynamic subtest: pipe-A-HDMI-A-1
[405.874812] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.230s)
[405.893506] Starting dynamic subtest: pipe-A-HDMI-A-2
[412.912567] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (7.035s)
[412.939369] Starting dynamic subtest: pipe-C-HDMI-A-1
[419.880288] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.959s)
[419.902283] Starting dynamic subtest: pipe-C-HDMI-A-2
[426.904469] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (7.017s)
[426.906515] Subtest wait-forked-hang: SUCCESS (28.269s)
[427.176844] [018/133] (629s left) kms_pm_rpm (system-suspend-idle)
[429.055474] Starting subtest: system-suspend-idle
[446.010300] Subtest system-suspend-idle: SUCCESS (1.819s)
[454.369571] [019/133] (610s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[454.575158] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[454.579300] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[454.728367] [020/133] (609s left) gem_media_vme
[454.943695] [021/133] (609s left) gem_render_copy (linear-to-vebox-yf-tiled)
[455.059396] Starting subtest: linear-to-vebox-yf-tiled
[455.064507] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[455.308909] [022/133] (609s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[455.502972] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[455.506823] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[455.653077] [023/133] (609s left) kms_tiled_display (basic-test-pattern)
[455.908339] Starting subtest: basic-test-pattern
[457.297993] Subtest basic-test-pattern: FAIL (0.879s)
[457.378620] [024/133] (607s left) dmabuf_sync_file (export-basic)
[457.556039] Starting subtest: export-basic
[457.558055] Subtest export-basic: SUCCESS (0.004s)
[457.683348] [FACT dmabuf_sync_file (export-basic)] new: kernel.kmod_is_loaded.vgem: true
[457.691482] [025/133] (607s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[457.817931] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[457.819864] Starting dynamic subtest: pipe-A-HDMI-A-1
[457.839851] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[457.862804] Starting dynamic subtest: pipe-A-HDMI-A-2
[457.900708] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[457.921289] Starting dynamic subtest: pipe-B-HDMI-A-1
[457.940131] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[457.960222] Starting dynamic subtest: pipe-B-HDMI-A-2
[457.979634] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[457.999520] Starting dynamic subtest: pipe-C-HDMI-A-1
[458.018242] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[458.038942] Starting dynamic subtest: pipe-C-HDMI-A-2
[458.057601] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[458.061522] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.034s)
[458.753228] [026/133] (606s left) gem_ctx_isolation (nonpriv)
[458.875650] Starting subtest: nonpriv
[458.877871] Starting dynamic subtest: rcs0
[459.652552] Dynamic subtest rcs0: SUCCESS (0.761s)
[459.673230] Starting dynamic subtest: bcs0
[460.903524] Dynamic subtest bcs0: SUCCESS (1.230s)
[460.925449] Starting dynamic subtest: vcs0
[461.652798] Dynamic subtest vcs0: SUCCESS (0.736s)
[461.673947] Starting dynamic subtest: vecs0
[462.395527] Dynamic subtest vecs0: SUCCESS (0.732s)
[462.398155] Subtest nonpriv: SUCCESS (3.472s)
[462.658464] [027/133] (602s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[462.798978] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[465.141427] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SUCCESS (2.321s)
[465.415018] [028/133] (599s left) kms_chamelium_edid (dp-edid-read)
[465.923991] Subtest dp-edid-read: SKIP (0.000s)
[466.181410] [029/133] (599s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[466.307900] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[466.309794] Starting dynamic subtest: pipe-A
[467.127963] Dynamic subtest pipe-A: SUCCESS (0.819s)
[467.153431] Starting dynamic subtest: pipe-B
[467.941753] Dynamic subtest pipe-B: SUCCESS (0.806s)
[467.968359] Starting dynamic subtest: pipe-C
[468.757846] Dynamic subtest pipe-C: SUCCESS (0.809s)
[468.759945] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (2.442s)
[469.260863] [030/133] (596s left) gem_softpin (evict-snoop-interruptible)
[469.383710] Starting subtest: evict-snoop-interruptible
[469.388002] Subtest evict-snoop-interruptible: SKIP (0.000s)
[469.565110] [031/133] (596s left) kms_fb_coherency (memset-crc)
[469.691407] Starting subtest: memset-crc
[469.693828] Starting dynamic subtest: mmap-gtt
[470.359691] Dynamic subtest mmap-gtt: SUCCESS (0.664s)
[470.594812] Starting dynamic subtest: mmap-offset-wc
[470.965777] Dynamic subtest mmap-offset-wc: SUCCESS (0.390s)
[471.230992] Starting dynamic subtest: mmap-offset-uc
[471.989762] Dynamic subtest mmap-offset-uc: SUCCESS (0.807s)
[472.227215] Starting dynamic subtest: mmap-legacy-wc
[472.598761] Dynamic subtest mmap-legacy-wc: SUCCESS (0.392s)
[472.809685] Subtest memset-crc: SUCCESS (3.106s)
[473.106225] [032/133] (592s left) gem_spin_batch (spin-all)
[473.226215] Starting subtest: spin-all
[473.250467] Subtest spin-all: SUCCESS (0.024s)
[473.571670] [033/133] (592s left) sysfs_preempt_timeout (timeout)
[473.682052] Starting subtest: timeout
[473.685414] Starting dynamic subtest: vecs0
[474.567845] Dynamic subtest vecs0: SUCCESS (0.882s)
[474.594088] Starting dynamic subtest: vcs0
[475.434825] Dynamic subtest vcs0: SUCCESS (0.861s)
[475.455829] Starting dynamic subtest: bcs0
[476.350610] Dynamic subtest bcs0: SUCCESS (0.911s)
[476.381592] Starting dynamic subtest: rcs0
[477.256683] Dynamic subtest rcs0: SUCCESS (0.901s)
[477.258956] Subtest timeout: SUCCESS (3.570s)
[477.398406] [034/133] (588s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[477.539709] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[477.543542] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[477.700981] [035/133] (588s left) kms_frontbuffer_tracking (fbc-suspend)
[477.842032] Starting subtest: fbc-suspend