[91.592617] Initializing watchdogs
[91.592793]   /dev/watchdog0
[91.634218] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[91.649282] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[91.656726] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[91.663036] [001/131] (960s left) gem_wait (write-busy)
[91.815134] Starting subtest: write-busy
[91.818166] Starting dynamic subtest: all-engines
[92.415307] Dynamic subtest all-engines: SUCCESS (0.601s)
[92.442901] Starting dynamic subtest: rcs0
[92.941869] Dynamic subtest rcs0: SUCCESS (0.523s)
[92.965703] Starting dynamic subtest: bcs0
[93.464769] Dynamic subtest bcs0: SUCCESS (0.523s)
[93.490444] Starting dynamic subtest: vcs0
[93.988179] Dynamic subtest vcs0: SUCCESS (0.519s)
[94.008442] Starting dynamic subtest: vecs0
[94.507097] Dynamic subtest vecs0: SUCCESS (0.520s)
[94.510214] Subtest write-busy: SUCCESS (2.692s)
[94.809581] [FACT gem_wait (write-busy)] new: kernel.kmod_is_loaded.vgem: true
[94.814712] [002/131] (957s left) gem_mmap_gtt (hang-user)
[94.919206] Starting subtest: hang-user
[110.044164] Subtest hang-user: SUCCESS (15.126s)
[110.207995] [003/131] (942s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[110.414172] Starting subtest: psr-2p-primscrn-cur-indfb-move
[110.419089] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[110.560228] [004/131] (941s left) perf_pmu (busy-start)
[110.679256] Starting subtest: busy-start
[110.681251] Starting dynamic subtest: rcs0
[113.200255] Dynamic subtest rcs0: SUCCESS (2.519s)
[113.219502] Starting dynamic subtest: bcs0
[115.723250] Dynamic subtest bcs0: SUCCESS (2.524s)
[115.743721] Starting dynamic subtest: vcs0
[118.248787] Dynamic subtest vcs0: SUCCESS (2.520s)
[118.268630] Starting dynamic subtest: vecs0
[120.769579] Dynamic subtest vecs0: SUCCESS (2.521s)
[120.771650] Subtest busy-start: SUCCESS (10.091s)
[120.912993] [005/131] (931s left) gem_exec_flush (basic-batch-kernel-default-wb)
[121.047090] Starting subtest: basic-batch-kernel-default-wb
[126.691743] Subtest basic-batch-kernel-default-wb: SUCCESS (5.647s)
[126.947099] [006/131] (925s left) gem_exec_schedule (deep)
[127.214143] Starting subtest: deep
[127.215757] Starting dynamic subtest: rcs0
[140.406048] Dynamic subtest rcs0: SUCCESS (13.181s)
[140.448097] Starting dynamic subtest: bcs0
[154.798365] Dynamic subtest bcs0: SUCCESS (14.388s)
[154.852435] Starting dynamic subtest: vcs0
[168.517676] Dynamic subtest vcs0: SUCCESS (13.715s)
[168.581373] Starting dynamic subtest: vecs0
[182.282302] Dynamic subtest vecs0: SUCCESS (13.752s)
[182.284037] Subtest deep: SUCCESS (55.055s)
[183.085504] [007/131] (869s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[183.264100] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[183.266083] Starting dynamic subtest: pipe-A-HDMI-A-1
[183.349664] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.012s)
[183.395490] Starting dynamic subtest: pipe-A-HDMI-A-2
[183.507622] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.012s)
[183.529231] Starting dynamic subtest: pipe-B-HDMI-A-1
[183.596194] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.012s)
[183.616651] Starting dynamic subtest: pipe-B-HDMI-A-2
[183.687644] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.012s)
[183.707280] Starting dynamic subtest: pipe-C-HDMI-A-1
[183.770206] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.012s)
[183.798355] Starting dynamic subtest: pipe-C-HDMI-A-2
[183.938411] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.013s)
[183.946955] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.088s)
[184.355232] [008/131] (868s left) gem_exec_schedule (preempt)
[184.499899] Starting subtest: preempt
[184.501849] Starting dynamic subtest: rcs0
[184.549146] Dynamic subtest rcs0: SUCCESS (0.049s)
[184.575187] Starting dynamic subtest: bcs0
[184.627247] Dynamic subtest bcs0: SUCCESS (0.077s)
[184.654274] Starting dynamic subtest: vcs0
[184.677265] Dynamic subtest vcs0: SUCCESS (0.050s)
[184.705115] Starting dynamic subtest: vecs0
[184.729682] Dynamic subtest vecs0: SUCCESS (0.054s)
[184.731979] Subtest preempt: SUCCESS (0.233s)
[185.132259] [009/131] (867s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[185.246734] Starting subtest: invalid-bsd1-flag-on-blt
[185.249343] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.001s)
[185.395468] [010/131] (867s left) gem_exec_fence (syncobj-invalid-flags)
[185.958776] Starting subtest: syncobj-invalid-flags
[185.961242] Subtest syncobj-invalid-flags: SUCCESS (0.003s)
[186.362321] [011/131] (866s left) gem_ctx_engines (execute-allforone)
[186.484509] Starting subtest: execute-allforone
[186.495445] Subtest execute-allforone: SUCCESS (0.013s)
[186.763940] [012/131] (866s left) gem_softpin (safe-alignment)
[186.881968] Starting subtest: safe-alignment
[186.910432] Subtest safe-alignment: SUCCESS (0.028s)
[187.074832] [013/131] (866s left) gem_exec_capture (capture-recoverable)
[187.191202] Starting subtest: capture-recoverable
[187.194740] Subtest capture-recoverable: SKIP (0.000s)
[187.346137] [014/131] (866s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[187.528190] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[187.530052] Starting dynamic subtest: pipe-A-valid-mode
[188.595119] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.065s)
[188.598409] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (1.069s)
[188.907289] [015/131] (864s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[189.125939] Starting subtest: y-tiled-64bpp-rotate-0
[197.823168] Subtest y-tiled-64bpp-rotate-0: SUCCESS (8.697s)
[198.352547] [016/131] (855s left) kms_psr (psr2-sprite-plane-onoff)
[198.546301] Subtest psr2-sprite-plane-onoff: SKIP (0.000s)
[198.642887] [017/131] (855s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[198.830406] Starting subtest: plane-downscale-factor-0-75-with-rotation
[198.832221] Starting dynamic subtest: pipe-A
[204.945346] Dynamic subtest pipe-A: SKIP (6.115s)
[204.969057] Starting dynamic subtest: pipe-B
[210.118714] Dynamic subtest pipe-B: SKIP (5.158s)
[210.166279] Starting dynamic subtest: pipe-C
[214.857491] Dynamic subtest pipe-C: SKIP (4.747s)
[214.865136] Subtest plane-downscale-factor-0-75-with-rotation: SKIP (16.026s)
[215.423095] [018/131] (838s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[215.675090] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[215.680437] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[215.826336] [019/131] (838s left) kms_draw_crc (draw-method-mmap-wc)
[216.026073] Starting subtest: draw-method-mmap-wc
[216.029403] Starting dynamic subtest: xrgb8888-untiled
[216.528315] Dynamic subtest xrgb8888-untiled: SUCCESS (0.498s)
[216.562484] Starting dynamic subtest: rgb565-untiled
[216.793207] Dynamic subtest rgb565-untiled: SUCCESS (0.262s)
[216.831045] Starting dynamic subtest: xrgb2101010-untiled
[217.077404] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.279s)
[217.118665] Starting dynamic subtest: xbgr16161616f-untiled
[217.379572] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.295s)
[217.416902] Starting dynamic subtest: xrgb8888-xtiled
[217.560242] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.180s)
[217.601059] Starting dynamic subtest: rgb565-xtiled
[217.778358] Dynamic subtest rgb565-xtiled: SUCCESS (0.212s)
[217.818072] Starting dynamic subtest: xrgb2101010-xtiled
[217.960235] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.179s)
[218.001073] Starting dynamic subtest: xbgr16161616f-xtiled
[218.161235] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.195s)
[218.201077] Starting dynamic subtest: xrgb8888-ytiled
[218.379168] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.211s)
[218.416112] Starting dynamic subtest: rgb565-ytiled
[218.593257] Dynamic subtest rgb565-ytiled: SUCCESS (0.212s)
[218.633082] Starting dynamic subtest: xrgb2101010-ytiled
[218.776126] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.179s)
[218.816085] Starting dynamic subtest: xbgr16161616f-ytiled
[218.975909] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.196s)
[218.978837] Subtest draw-method-mmap-wc: SUCCESS (2.953s)
[219.260844] [020/131] (834s left) gem_eio (context-create)
[219.437717] Starting subtest: context-create
[219.505948] Subtest context-create: SUCCESS (0.073s)
[219.775883] [021/131] (834s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[220.006387] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[220.009905] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[220.158781] [022/131] (834s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[220.389390] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[221.945200] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.557s)
[222.271924] [023/131] (832s left) gem_ctx_bad_destroy (invalid-default-ctx)
[222.383987] Starting subtest: invalid-default-ctx
[222.386230] Subtest invalid-default-ctx: SUCCESS (0.000s)
[222.538875] [024/131] (831s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[222.759283] Starting subtest: psr-1p-pri-indfb-multidraw
[222.764068] Subtest psr-1p-pri-indfb-multidraw: SKIP (0.000s)
[222.910327] [025/131] (831s left) gem_exec_schedule (u-semaphore-resolve)
[223.057799] Starting subtest: u-semaphore-resolve
[223.103905] Subtest u-semaphore-resolve: SUCCESS (0.050s)
[223.530905] [026/131] (831s left) gem_mmap_gtt (cpuset-big-copy)
[223.637678] Starting subtest: cpuset-big-copy
[240.037809] Subtest cpuset-big-copy: SUCCESS (16.395s)
[240.237173] [027/131] (814s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[240.605106] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[240.609146] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[240.761324] [028/131] (814s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[240.992473] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[240.995679] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[241.197804] [029/131] (813s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[243.196283] Starting subtest: dpms-mode-unset-lpsp
[243.408823] Subtest dpms-mode-unset-lpsp: SKIP (0.212s)
[243.862163] [030/131] (811s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[244.071296] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[246.591321] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (2.521s)
[246.919979] [031/131] (808s left) syncobj_timeline (device-signal-unordered)
[247.051154] Starting subtest: device-signal-unordered
[247.058390] Subtest device-signal-unordered: SUCCESS (0.003s)
[247.212550] [032/131] (808s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[247.411379] Starting subtest: yf-tiled-64bpp-rotate-180
[247.419233] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[247.561106] [033/131] (807s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[247.768434] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[247.771709] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[247.953443] [034/131] (807s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[248.155482] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[248.159028] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[248.309936] [035/131] (807s left) i915_hangman (gt-engine-error)
[248.452209] Starting subtest: gt-engine-error
[248.455832] Starting dynamic subtest: rcs0
[248.528450] Dynamic subtest rcs0: SUCCESS (0.077s)
[248.559750] Starting dynamic subtest: bcs0
[248.565274] Dynamic subtest bcs0: SKIP (0.003s)
[248.600835] Starting dynamic subtest: vcs0
[248.607885] Dynamic subtest vcs0: SUCCESS (0.066s)
[248.631378] Starting dynamic subtest: vecs0
[248.674849] Dynamic subtest vecs0: SUCCESS (0.067s)
[248.676874] Subtest gt-engine-error: SUCCESS (0.227s)
[248.844823] [036/131] (806s left) gem_lmem_swapping (heavy-verify-random-ccs)
[248.963260] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[249.081711] [037/131] (806s left) kms_addfb_basic (addfb25-4-tiled)
[249.275438] Starting subtest: addfb25-4-tiled
[249.278186] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[249.426851] [038/131] (806s left) gem_ctx_persistence (heartbeat-hostile)
[249.551063] Starting subtest: heartbeat-hostile
[250.724053] Subtest heartbeat-hostile: SUCCESS (1.176s)
[250.907116] [039/131] (805s left) kms_lease (lease-invalid-connector)
[251.102039] Starting subtest: lease-invalid-connector
[251.116124] Starting dynamic subtest: pipe-A-HDMI-A-1
[251.119236] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s)
[251.166091] Starting dynamic subtest: pipe-A-HDMI-A-2
[251.167702] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.000s)
[251.194427] Starting dynamic subtest: pipe-B-HDMI-A-1
[251.196086] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[251.230676] Starting dynamic subtest: pipe-B-HDMI-A-2
[251.232264] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.000s)
[251.253323] Starting dynamic subtest: pipe-C-HDMI-A-1
[251.254993] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.000s)
[251.276073] Starting dynamic subtest: pipe-C-HDMI-A-2
[251.277641] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.000s)
[251.279218] Subtest lease-invalid-connector: SUCCESS (0.054s)
[251.368558] [040/131] (804s left) syncobj_wait (invalid-single-wait-unsubmitted)
[251.479224] Starting subtest: invalid-single-wait-unsubmitted
[251.481991] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.001s)
[251.628656] [041/131] (804s left) kms_atomic_interruptible (universal-setplane-primary)
[251.812146] Starting subtest: universal-setplane-primary
[251.824263] Starting dynamic subtest: pipe-A-HDMI-A-1
[258.590877] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.772s)
[258.594255] Subtest universal-setplane-primary: SUCCESS (6.778s)
[258.956055] [042/131] (797s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[259.145066] Subtest psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[259.261778] [043/131] (797s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[259.457646] Starting subtest: cursorA-vs-flipA-atomic-transitions
[270.765459] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.302s)
[271.153964] [044/131] (785s left) gem_workarounds (suspend-resume)
[271.314133] Starting subtest: suspend-resume
[288.741759] Subtest suspend-resume: SUCCESS (1.210s)
[296.924594] [045/131] (767s left) kms_psr (psr-sprite-render)
[297.116895] Subtest psr-sprite-render: SKIP (0.000s)
[297.233405] [046/131] (767s left) vgem_basic (dmabuf-fence)
[297.365998] Starting subtest: dmabuf-fence
[297.368696] Subtest dmabuf-fence: SUCCESS (0.002s)
[297.522610] [047/131] (767s left) gem_reg_read (timestamp-moving)
[297.626530] Starting subtest: timestamp-moving
[298.626107] Subtest timestamp-moving: SUCCESS (1.001s)
[298.777244] [048/131] (766s left) kms_chamelium_hpd (dp-hpd)
[299.346573] Subtest dp-hpd: SKIP (0.000s)
[299.688078] [049/131] (765s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[299.800334] Starting subtest: single-wait-for-submit-available-signaled
[299.803416] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.001s)
[299.950555] [050/131] (765s left) kms_sequence (get-forked-busy)
[300.152267] Starting subtest: get-forked-busy
[300.154550] Starting dynamic subtest: pipe-A-HDMI-A-1
[303.132230] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.979s)
[303.163204] Starting dynamic subtest: pipe-A-HDMI-A-2
[305.820404] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.682s)
[305.876192] Starting dynamic subtest: pipe-B-HDMI-A-1
[308.479573] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.624s)
[308.529893] Starting dynamic subtest: pipe-B-HDMI-A-2
[311.167003] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.636s)
[311.204392] Starting dynamic subtest: pipe-C-HDMI-A-1
[313.834338] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.629s)
[313.879517] Starting dynamic subtest: pipe-C-HDMI-A-2
[316.465250] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.606s)
[316.468075] Subtest get-forked-busy: SUCCESS (16.203s)
[316.777608] [051/131] (748s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[316.975284] Starting subtest: 2x-long-flip-vs-cursor-atomic
[322.615228] Subtest 2x-long-flip-vs-cursor-atomic: SUCCESS (5.614s)
[322.994246] [052/131] (742s left) i915_pm_rc6_residency (rc6-idle)
[323.103232] Starting subtest: rc6-idle
[323.121382] Subtest rc6-idle: SKIP (0.015s)
[323.275999] [053/131] (742s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[323.473215] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[323.483494] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[326.023928] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (2.533s)
[326.053207] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[328.088146] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (2.057s)
[328.131215] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[330.176237] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (2.076s)
[330.180238] Subtest 2x-flip-vs-dpms-off-vs-modeset: SUCCESS (6.688s)
[330.541882] [054/131] (735s left) gem_exec_whisper (basic-fds-all)
[330.686376] Starting subtest: basic-fds-all
[346.414585] Subtest basic-fds-all: SUCCESS (15.712s)
[346.691259] [055/131] (719s left) kms_cursor_crc (cursor-suspend)
[346.883065] Starting subtest: cursor-suspend
[346.885235] Starting dynamic subtest: pipe-A-HDMI-A-1