[90.929236] Initializing watchdogs
[90.929421]   /dev/watchdog0
[90.972852] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[90.987559] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[90.995351] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[91.003962] [001/130] (960s left) api_intel_allocator (fork-simple-once)
[91.137694] Starting subtest: fork-simple-once
[91.172520] Subtest fork-simple-once: SUCCESS (0.038s)
[91.327876] [002/130] (960s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[91.547685] Starting subtest: yf-tiled-addfb-size-offset-overflow
[91.551739] Subtest yf-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[91.693020] [003/130] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[91.909854] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[91.916963] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[92.056517] [004/130] (959s left) kms_flip (plain-flip-fb-recreate)
[92.245440] Starting subtest: plain-flip-fb-recreate
[92.249191] Starting dynamic subtest: A-HDMI-A1
[98.279415] Dynamic subtest A-HDMI-A1: SUCCESS (6.027s)
[98.297063] Starting dynamic subtest: B-HDMI-A1
[103.965515] Dynamic subtest B-HDMI-A1: SUCCESS (5.684s)
[103.991199] Starting dynamic subtest: C-HDMI-A1
[109.681196] Dynamic subtest C-HDMI-A1: SUCCESS (5.716s)
[109.703380] Starting dynamic subtest: A-HDMI-A2
[115.394097] Dynamic subtest A-HDMI-A2: SUCCESS (5.710s)
[115.411536] Starting dynamic subtest: B-HDMI-A2
[121.087447] Dynamic subtest B-HDMI-A2: SUCCESS (5.689s)
[121.112782] Starting dynamic subtest: C-HDMI-A2
[126.784703] Dynamic subtest C-HDMI-A2: SUCCESS (5.697s)
[126.789579] Subtest plain-flip-fb-recreate: SUCCESS (34.541s)
[127.741817] [005/130] (924s left) kms_pm_rpm (drm-resources-equal)
[129.823616] Starting subtest: drm-resources-equal
[130.968628] Subtest drm-resources-equal: SUCCESS (1.162s)
[131.226563] [006/130] (921s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[131.437304] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[134.115733] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SUCCESS (2.678s)
[134.337395] [007/130] (918s left) gem_eio (wait-wedge-1us)
[134.484780] Starting subtest: wait-wedge-1us
[134.589837] Subtest wait-wedge-1us: SUCCESS (0.100s)
[134.820788] [008/130] (917s left) kms_properties (connector-properties-atomic)
[135.018082] Starting subtest: connector-properties-atomic
[135.021631] Starting dynamic subtest: pipe-A-HDMI-A-1
[136.931354] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.912s)
[136.956768] Starting dynamic subtest: pipe-A-HDMI-A-2
[138.717772] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.735s)
[138.724620] Subtest connector-properties-atomic: SUCCESS (3.656s)
[138.957212] [009/130] (913s left) kms_big_fb (linear-8bpp-rotate-90)
[139.180693] Starting subtest: linear-8bpp-rotate-90
[139.482701] Subtest linear-8bpp-rotate-90: SKIP (0.299s)
[139.725129] [010/130] (913s left) syncobj_wait (invalid-signal-bad-pad)
[139.840125] Starting subtest: invalid-signal-bad-pad
[139.843952] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[139.974255] [011/130] (912s left) gem_vm_create (isolation)
[140.096577] Starting subtest: isolation
[140.108851] Subtest isolation: SUCCESS (0.013s)
[140.255223] [012/130] (912s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[140.470281] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[143.961684] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (3.476s)
[144.266853] [013/130] (908s left) gem_softpin (allocator-fork)
[144.389923] Starting subtest: allocator-fork
[146.757613] Subtest allocator-fork: SUCCESS (2.367s)
[146.896620] [014/130] (906s left) syncobj_timeline (host-signal-points)
[147.010352] Starting subtest: host-signal-points
[147.032482] Subtest host-signal-points: SUCCESS (0.022s)
[147.161625] [015/130] (906s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[147.349368] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[147.353875] Starting dynamic subtest: pipe-A
[148.507516] Dynamic subtest pipe-A: SUCCESS (1.161s)
[148.528108] Starting dynamic subtest: pipe-B
[149.623505] Dynamic subtest pipe-B: SUCCESS (1.114s)
[149.645052] Starting dynamic subtest: pipe-C
[150.718988] Dynamic subtest pipe-C: SUCCESS (1.097s)
[150.723657] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (3.377s)
[151.219496] [016/130] (902s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[151.449837] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[151.457712] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[151.596657] [017/130] (901s left) gem_pwrite (basic-exhaustion)
[151.710644] Starting subtest: basic-exhaustion
[177.144224] Subtest basic-exhaustion: SUCCESS (25.440s)
[177.302658] [FACT gem_pwrite (basic-exhaustion)] new: kernel.kmod_is_loaded.vgem: true
[177.309413] [018/130] (876s left) gem_exec_reloc (basic-wc-gtt)
[177.424469] Starting subtest: basic-wc-gtt
[177.446065] Subtest basic-wc-gtt: SUCCESS (0.019s)
[177.692188] [019/130] (875s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[177.904608] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[177.911569] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[178.063548] [020/130] (875s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[178.188673] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[178.196903] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[178.455897] [021/130] (875s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-blt)
[178.663926] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-blt
[181.241682] Subtest fbc-1p-offscren-pri-shrfb-draw-blt: SUCCESS (2.577s)
[181.538446] [022/130] (872s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[181.758217] Starting subtest: 4-tiled-32bpp-rotate-180
[181.764549] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s)
[181.926318] [023/130] (872s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[182.141321] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[184.189890] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (2.050s)
[184.492910] [024/130] (869s left) gem_exec_reloc (basic-scanout)
[184.698422] Starting subtest: basic-scanout
[184.701846] Starting dynamic subtest: rcs0
[185.271781] Dynamic subtest rcs0: SUCCESS (0.572s)
[185.291988] Starting dynamic subtest: bcs0
[185.487989] Dynamic subtest bcs0: SUCCESS (0.213s)
[185.512669] Starting dynamic subtest: vcs0
[185.704599] Dynamic subtest vcs0: SUCCESS (0.213s)
[185.729341] Starting dynamic subtest: vecs0
[185.923499] Dynamic subtest vecs0: SUCCESS (0.213s)
[185.927317] Subtest basic-scanout: SUCCESS (1.225s)
[186.179816] [025/130] (868s left) gem_exec_flush (basic-uc-pro-default)
[186.320935] Starting subtest: basic-uc-pro-default
[191.734991] Subtest basic-uc-pro-default: SUCCESS (5.418s)
[192.008329] [026/130] (862s left) gem_exec_flush (basic-batch-kernel-default-uc)
[192.139881] Starting subtest: basic-batch-kernel-default-uc
[197.786212] Subtest basic-batch-kernel-default-uc: SUCCESS (5.646s)
[198.059898] [027/130] (856s left) kms_rotation_crc (multiplane-rotation)
[198.248476] Starting subtest: multiplane-rotation
[263.500449] Subtest multiplane-rotation: SUCCESS (65.250s)
[263.971450] [028/130] (790s left) kms_cursor_crc (cursor-random-max-size)
[264.217253] Starting subtest: cursor-random-max-size
[264.226991] Subtest cursor-random-max-size: SKIP (0.000s)
[264.369928] [029/130] (790s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[264.596125] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[264.604197] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[264.759171] [030/130] (790s left) kms_cursor_crc (cursor-offscreen-128x42)
[264.964913] Starting subtest: cursor-offscreen-128x42
[265.009518] Starting dynamic subtest: pipe-A-HDMI-A-1
[267.898288] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.872s)
[267.993528] Starting dynamic subtest: pipe-C-HDMI-A-1
[270.536164] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.571s)
[270.540262] Subtest cursor-offscreen-128x42: SUCCESS (5.567s)
[270.887566] [031/130] (784s left) gem_spin_batch (user-each)
[271.021127] Starting subtest: user-each
[274.320172] Subtest user-each: SUCCESS (3.298s)
[274.600486] [032/130] (780s left) gem_exec_nop (basic-parallel)
[274.749018] Starting subtest: basic-parallel
[277.868271] Subtest basic-parallel: SUCCESS (3.131s)
[278.148893] [033/130] (776s left) perf_pmu (busy-start)
[278.265361] Starting subtest: busy-start
[278.269485] Starting dynamic subtest: rcs0
[280.790310] Dynamic subtest rcs0: SUCCESS (2.519s)
[280.812563] Starting dynamic subtest: bcs0
[283.314729] Dynamic subtest bcs0: SUCCESS (2.526s)
[283.343436] Starting dynamic subtest: vcs0
[285.839874] Dynamic subtest vcs0: SUCCESS (2.520s)
[285.861980] Starting dynamic subtest: vecs0
[288.360185] Dynamic subtest vecs0: SUCCESS (2.518s)
[288.363572] Subtest busy-start: SUCCESS (10.097s)
[288.520745] [034/130] (766s left) drm_read (empty-nonblock)
[288.997662] Starting subtest: empty-nonblock
[289.000728] Subtest empty-nonblock: SUCCESS (0.000s)
[289.290412] [035/130] (766s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-render)
[289.513813] Starting subtest: fbc-1p-offscren-pri-indfb-draw-render
[292.101262] Subtest fbc-1p-offscren-pri-indfb-draw-render: SUCCESS (2.591s)
[292.387336] [036/130] (763s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[292.581169] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[292.652763] Starting dynamic subtest: pipe-A-valid-mode
[292.985091] Dynamic subtest pipe-A-valid-mode: SKIP (0.389s)
[293.034808] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.397s)
[293.317524] [037/130] (762s left) gen3_mixed_blits
[293.559192] [038/130] (762s left) i915_hangman (engine-error-state-capture)
[293.702019] Starting subtest: engine-error-state-capture
[293.705632] Starting dynamic subtest: rcs0
[297.493064] Dynamic subtest rcs0: SUCCESS (3.794s)
[297.515081] Starting dynamic subtest: bcs0
[301.452536] Dynamic subtest bcs0: SUCCESS (3.956s)
[301.474914] Starting dynamic subtest: vcs0
[305.484801] Dynamic subtest vcs0: SUCCESS (4.028s)
[305.507374] Starting dynamic subtest: vecs0
[309.514856] Dynamic subtest vecs0: SUCCESS (4.026s)
[309.519686] Subtest engine-error-state-capture: SUCCESS (15.821s)
[309.680304] [039/130] (746s left) gem_tiled_blits (normal)
[310.454839] Starting subtest: normal
[370.070480] Subtest normal: SUCCESS (59.616s)
[370.259952] [040/130] (685s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[370.602201] Starting subtest: fbc-rgb565-draw-pwrite
[373.678354] Subtest fbc-rgb565-draw-pwrite: SUCCESS (3.076s)
[373.967880] [041/130] (681s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[374.089407] Starting subtest: no-spare-fences-busy
[376.278296] Subtest no-spare-fences-busy: SUCCESS (2.178s)
[376.933173] [042/130] (679s left) perf (global-sseu-config-invalid)
[378.026365] Starting subtest: global-sseu-config-invalid
[378.030782] Starting dynamic subtest: 0-rcs0
[378.055199] Dynamic subtest 0-rcs0: SUCCESS (0.031s)
[378.059349] Subtest global-sseu-config-invalid: SUCCESS (0.035s)
[378.182896] [043/130] (678s left) syncobj_wait (multi-wait-signaled)
[378.297829] Starting subtest: multi-wait-signaled
[378.302554] Subtest multi-wait-signaled: SUCCESS (0.002s)
[378.452328] [044/130] (678s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[378.638419] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[378.643716] Starting dynamic subtest: pipe-A-HDMI-A-1
[378.682251] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.003s)
[378.756749] Starting dynamic subtest: pipe-A-HDMI-A-2
[378.789548] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.003s)
[378.815630] Starting dynamic subtest: pipe-B-HDMI-A-1
[378.848171] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.003s)
[378.871608] Starting dynamic subtest: pipe-B-HDMI-A-2
[378.903320] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.003s)
[378.925995] Starting dynamic subtest: pipe-C-HDMI-A-1
[378.958529] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[378.980623] Starting dynamic subtest: pipe-C-HDMI-A-2
[379.013530] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.003s)
[379.019618] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.069s)
[379.709906] [045/130] (676s left) gem_readwrite (read-bad-handle)
[379.823840] Starting subtest: read-bad-handle
[379.832366] Subtest read-bad-handle: SUCCESS (0.000s)
[379.983111] [046/130] (676s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[380.201639] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[380.208686] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[380.418408] [047/130] (676s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[380.619167] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[380.622980] Starting dynamic subtest: pipe-A-HDMI-A-1
[380.641030] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[380.695026] Starting dynamic subtest: pipe-A-HDMI-A-2
[380.708942] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[380.753667] Starting dynamic subtest: pipe-B-HDMI-A-1
[380.767226] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[380.789323] Starting dynamic subtest: pipe-B-HDMI-A-2
[380.802538] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[380.825140] Starting dynamic subtest: pipe-C-HDMI-A-1
[380.838497] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[380.860592] Starting dynamic subtest: pipe-C-HDMI-A-2
[380.873804] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[380.880228] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SKIP (0.037s)
[381.603247] [048/130] (675s left) dumb_buffer (map-valid)
[381.715871] Starting subtest: map-valid
[381.719075] Subtest map-valid: SUCCESS (0.000s)
[381.870546] [049/130] (675s left) kms_cursor_crc (cursor-onscreen-512x512)
[382.106341] Starting subtest: cursor-onscreen-512x512
[382.120523] Subtest cursor-onscreen-512x512: SKIP (0.005s)
[382.289192] [050/130] (674s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[382.506661] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[382.513448] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[382.690783] [051/130] (674s left) kms_atomic (plane-immutable-zpos)
[382.875174] Starting subtest: plane-immutable-zpos
[382.889039] Starting dynamic subtest: pipe-A-HDMI-A-1
[383.760932] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.877s)
[383.816827] Subtest plane-immutable-zpos: SUCCESS (0.883s)
[384.067657] [052/130] (673s left) gem_exec_fence (nb-await)
[384.334737] Starting subtest: nb-await
[384.338249] Starting dynamic subtest: rcs0
[384.411447] Dynamic subtest rcs0: SUCCESS (0.075s)
[384.435495] Starting dynamic subtest: bcs0
[384.485242] Dynamic subtest bcs0: SUCCESS (0.069s)
[384.508119] Starting dynamic subtest: vcs0
[384.556820] Dynamic subtest vcs0: SUCCESS (0.067s)
[384.580843] Starting dynamic subtest: vecs0
[384.627811] Dynamic subtest vecs0: SUCCESS (0.066s)
[384.631621] Subtest nb-await: SUCCESS (0.295s)
[385.385264] [053/130] (672s left) kms_plane_alpha_blend (alpha-opaque-fb)
[385.579784] Starting subtest: alpha-opaque-fb
[385.832828] Starting dynamic subtest: pipe-A-HDMI-A-1
[387.361875] Dynamic subtest pipe-A-HDMI-A-1: FAIL (0.481s)
[387.399954] Starting dynamic subtest: pipe-C-HDMI-A-1
[388.496629] Dynamic subtest pipe-C-HDMI-A-1: FAIL (1.308s)
[388.500602] Subtest alpha-opaque-fb: FAIL (2.056s)
[388.617314] [054/130] (669s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[388.841532] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[388.847732] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[388.992540] [055/130] (668s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[389.114089] Starting subtest: no-spare-fences-interruptible
[391.288455] Subtest no-spare-fences-interruptible: SUCCESS (2.165s)
[391.588212] [056/130] (666s left) gem_ctx_isolation (preservation-s3)
[391.716726] Starting subtest: preservation-S3
[391.727746] Starting dynamic subtest: rcs0
[410.090414] Dynamic subtest rcs0: SUCCESS (2.734s)
[410.124364] Starting dynamic subtest: bcs0