[88.604895] Initializing watchdogs
[88.605134]   /dev/watchdog0
[88.645365] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3184 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 605]
[88.658980] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[88.666207] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[88.672074] [001/133] (960s left) kms_flip (plain-flip-ts-check-interruptible)
[88.864148] Starting subtest: plain-flip-ts-check-interruptible
[88.866463] Starting dynamic subtest: A-HDMI-A1
[94.811672] Dynamic subtest A-HDMI-A1: SUCCESS (5.944s)
[94.825599] Starting dynamic subtest: B-HDMI-A1
[100.473282] Dynamic subtest B-HDMI-A1: SUCCESS (5.658s)
[100.496399] Starting dynamic subtest: C-HDMI-A1
[106.131985] Dynamic subtest C-HDMI-A1: SUCCESS (5.660s)
[106.145874] Starting dynamic subtest: A-HDMI-A2
[111.795246] Dynamic subtest A-HDMI-A2: SUCCESS (5.661s)
[111.811842] Starting dynamic subtest: B-HDMI-A2
[117.439855] Dynamic subtest B-HDMI-A2: SUCCESS (5.643s)
[117.453826] Starting dynamic subtest: C-HDMI-A2
[123.097597] Dynamic subtest C-HDMI-A2: SUCCESS (5.657s)
[123.098570] Subtest plain-flip-ts-check-interruptible: SUCCESS (34.235s)
[123.550603] [002/133] (925s left) kms_psr (fbc-psr-primary-mmap-gtt)
[123.717761] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s)
[123.809416] [003/133] (925s left) gem_madvise (dontneed-before-exec)
[123.896772] Starting subtest: dontneed-before-exec
[123.905238] Subtest dontneed-before-exec: SUCCESS (0.009s)
[124.068604] [004/133] (925s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[124.246440] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[124.248406] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[124.430451] [005/133] (925s left) gem_exec_fence (syncobj-timeline-signal)
[125.136412] Starting subtest: syncobj-timeline-signal
[125.144705] Subtest syncobj-timeline-signal: SUCCESS (0.010s)
[125.442473] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true
[125.445977] [006/133] (924s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[127.316441] Starting subtest: gem-execbuf-stress-pc8
[127.374401] Subtest gem-execbuf-stress-pc8: SKIP (0.041s)
[127.692221] [007/133] (921s left) dmabuf (all-tests)
[127.783517] Starting subtest: all-tests
[127.784569] Starting dynamic subtest: sanitycheck
[127.856810] Dynamic subtest sanitycheck: SUCCESS (0.074s)
[127.873199] Starting dynamic subtest: dma_fence
[128.079511] Dynamic subtest dma_fence: SUCCESS (0.221s)
[128.094219] Starting dynamic subtest: dma_fence_chain
[128.095941] Dynamic subtest dma_fence_chain: SKIP (0.000s)
[128.113925] Starting dynamic subtest: dma_fence_unwrap
[128.145511] Dynamic subtest dma_fence_unwrap: SUCCESS (0.063s)
[128.161331] Starting dynamic subtest: dma_resv
[128.232316] Dynamic subtest dma_resv: SUCCESS (0.083s)
[128.233286] Subtest all-tests: SUCCESS (0.449s)
[128.372775] [008/133] (921s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[128.541998] Starting subtest: plane-lut1d-post-ctm3x4
[129.665760] Subtest plane-lut1d-post-ctm3x4: SKIP (1.124s)
[129.937553] [009/133] (919s left) gem_ctx_shared (q-in-order)
[130.049096] Starting subtest: Q-in-order
[130.049989] Starting dynamic subtest: rcs0
[130.136294] Dynamic subtest rcs0: SUCCESS (0.086s)
[130.157923] Starting dynamic subtest: bcs0
[130.228853] Dynamic subtest bcs0: SUCCESS (0.092s)
[130.246577] Starting dynamic subtest: vcs0
[130.308928] Dynamic subtest vcs0: SUCCESS (0.079s)
[130.326576] Starting dynamic subtest: vecs0
[130.390691] Dynamic subtest vecs0: SUCCESS (0.081s)
[130.391930] Subtest Q-in-order: SUCCESS (0.342s)
[130.709529] [010/133] (919s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[130.900883] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[130.902616] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[131.074668] [011/133] (918s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[131.251609] Starting subtest: psr-indfb-scaledprimary
[131.253343] Subtest psr-indfb-scaledprimary: SKIP (0.000s)
[131.422165] [012/133] (918s left) syncobj_timeline (multi-wait-all-available-signaled)
[131.517957] Starting subtest: multi-wait-all-available-signaled
[131.519957] Subtest multi-wait-all-available-signaled: SUCCESS (0.002s)
[131.688997] [013/133] (918s left) kms_pm_rpm (system-suspend-modeset)
[133.445595] Starting subtest: system-suspend-modeset
[152.139989] Subtest system-suspend-modeset: SUCCESS (2.408s)
[159.245100] [014/133] (898s left) i915_hangman (engine-engine-error)
[159.370384] Starting subtest: engine-engine-error
[159.371379] Starting dynamic subtest: rcs0
[159.460619] Dynamic subtest rcs0: SUCCESS (0.090s)
[159.479767] Starting dynamic subtest: bcs0
[159.481510] Dynamic subtest bcs0: SKIP (0.004s)
[159.507718] Starting dynamic subtest: vcs0
[159.568256] Dynamic subtest vcs0: SUCCESS (0.101s)
[159.588326] Starting dynamic subtest: vecs0
[159.661043] Dynamic subtest vecs0: SUCCESS (0.091s)
[159.662188] Subtest engine-engine-error: SUCCESS (0.291s)
[159.861144] [015/133] (897s left) gem_mmap_gtt (fault-concurrent-x)
[159.952285] Starting subtest: fault-concurrent-X
[163.565656] Subtest fault-concurrent-X: SUCCESS (3.547s)
[163.812894] [016/133] (893s left) gem_ctx_param (invalid-size-set)
[163.904345] Starting subtest: invalid-size-set
[163.905368] Subtest invalid-size-set: SUCCESS (0.000s)
[164.081147] [017/133] (893s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[164.258311] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[164.260304] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[164.446146] [018/133] (893s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[164.542131] Starting subtest: etime-multi-wait-all-for-submit-submitted
[164.652409] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.107s)
[164.831728] [019/133] (892s left) gem_softpin (softpin)
[164.941257] Starting subtest: softpin
[197.330543] Subtest softpin: SUCCESS (32.287s)
[197.527365] [020/133] (860s left) kms_pm_rpm (cursor-dpms)
[199.393546] Starting subtest: cursor-dpms
[201.251299] Subtest cursor-dpms: SUCCESS (1.858s)
[201.604009] [021/133] (856s left) kms_sequence (get-idle)
[201.770524] Starting subtest: get-idle
[201.771559] Starting dynamic subtest: pipe-A-HDMI-A-1
[204.452672] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.681s)
[204.493906] Starting dynamic subtest: pipe-A-HDMI-A-2
[206.866943] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.411s)
[206.887801] Starting dynamic subtest: pipe-B-HDMI-A-1
[209.261846] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.390s)
[209.282185] Starting dynamic subtest: pipe-B-HDMI-A-2
[211.650720] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.386s)
[211.670851] Starting dynamic subtest: pipe-C-HDMI-A-1
[214.052723] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.398s)
[214.073508] Starting dynamic subtest: pipe-C-HDMI-A-2
[216.443374] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.387s)
[216.444375] Subtest get-idle: SUCCESS (14.672s)
[216.741102] [022/133] (841s left) kms_psr (psr-cursor-plane-move)
[216.909237] Subtest psr-cursor-plane-move: SKIP (0.000s)
[217.001659] [023/133] (841s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[217.183236] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[217.394221] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.211s)
[217.656767] [024/133] (840s left) syncobj_wait (reset-unsignaled)
[217.750986] Starting subtest: reset-unsignaled
[217.752021] Subtest reset-unsignaled: SUCCESS (0.000s)
[217.924138] [025/133] (840s left) gem_mmap_offset (partial-mmap)
[218.015550] Starting subtest: partial-mmap
[218.016516] Starting dynamic subtest: smem0
[218.026120] Dynamic subtest smem0: SUCCESS (0.010s)
[218.029137] Subtest partial-mmap: SUCCESS (0.013s)
[218.222091] [026/133] (840s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[218.319747] Starting subtest: etime-single-wait-available-unsubmitted
[218.428460] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.108s)
[218.582717] [027/133] (839s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[218.748993] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[218.749995] Starting dynamic subtest: pipe-A-valid-mode
[219.704606] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.954s)
[219.705719] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SUCCESS (0.957s)
[220.021693] [028/133] (838s left) gem_exec_reloc (basic-cpu-active)
[220.128214] Starting subtest: basic-cpu-active
[220.266284] Subtest basic-cpu-active: SUCCESS (0.138s)
[220.510643] [029/133] (838s left) kms_chamelium_frames (hdmi-frame-dump)
[221.044783] Subtest hdmi-frame-dump: SKIP (0.000s)
[221.283359] [030/133] (837s left) gem_exec_balancer (full-late)
[221.395299] Starting subtest: full-late
[225.707756] Subtest full-late: SUCCESS (4.311s)
[226.017354] [031/133] (832s left) gem_exec_fence (parallel)
[226.259862] Starting subtest: parallel
[226.260834] Starting dynamic subtest: rcs0
[228.407730] Dynamic subtest rcs0: SUCCESS (2.148s)
[228.429206] Starting dynamic subtest: bcs0
[230.568616] Dynamic subtest bcs0: SUCCESS (2.158s)
[230.590389] Starting dynamic subtest: vcs0
[232.723010] Dynamic subtest vcs0: SUCCESS (2.152s)
[232.745071] Starting dynamic subtest: vecs0
[234.881934] Dynamic subtest vecs0: SUCCESS (2.155s)
[234.883610] Subtest parallel: SUCCESS (8.622s)
[235.591312] [032/133] (823s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[235.698652] Starting subtest: yf-tiled-ccs-to-y-tiled
[235.699631] Starting dynamic subtest: smem
[235.953604] Dynamic subtest smem: SUCCESS (0.254s)
[235.956680] Subtest yf-tiled-ccs-to-y-tiled: SUCCESS (0.255s)
[236.227963] [033/133] (822s left) gem_exec_schedule (timeslicing)
[236.350863] Starting subtest: timeslicing
[236.351868] Starting dynamic subtest: rcs0
[236.355336] Dynamic subtest rcs0: SUCCESS (0.007s)
[236.382456] Starting dynamic subtest: bcs0
[236.383438] Dynamic subtest bcs0: SUCCESS (0.010s)
[236.408314] Starting dynamic subtest: vcs0
[236.410055] Dynamic subtest vcs0: SUCCESS (0.007s)
[236.434504] Starting dynamic subtest: vecs0
[236.435562] Dynamic subtest vecs0: SUCCESS (0.005s)
[236.436422] Subtest timeslicing: SUCCESS (0.035s)
[236.817908] [034/133] (822s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[236.926158] Starting subtest: y-tiled-ccs-to-x-tiled
[236.927112] Starting dynamic subtest: smem
[237.151184] Dynamic subtest smem: SUCCESS (0.224s)
[237.153691] Subtest y-tiled-ccs-to-x-tiled: SUCCESS (0.226s)
[237.429473] [035/133] (821s left) gem_softpin (zero)
[237.533917] Starting subtest: zero
[237.539556] Subtest zero: SUCCESS (0.005s)
[237.712119] [036/133] (821s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[237.877267] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[237.879438] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[238.042176] [037/133] (821s left) kms_psr (fbc-pr-suspend)
[238.208667] Subtest fbc-pr-suspend: SKIP (0.000s)
[238.304270] [038/133] (821s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[238.468700] Starting subtest: plane-use-after-nonblocking-unbind
[238.472730] Starting dynamic subtest: pipe-A-HDMI-A-1
[238.872688] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.401s)
[239.124948] Starting dynamic subtest: pipe-A-HDMI-A-2
[239.465225] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.365s)
[239.681050] Starting dynamic subtest: pipe-B-HDMI-A-1
[240.024324] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.364s)
[240.224156] Starting dynamic subtest: pipe-B-HDMI-A-2
[240.587096] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.382s)
[240.761291] Subtest plane-use-after-nonblocking-unbind: SUCCESS (2.290s)
[241.069855] [039/133] (818s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[243.689072] Starting subtest: verify-pxp-execution-after-suspend-resume
[243.691230] Subtest verify-pxp-execution-after-suspend-resume: SKIP (0.000s)
[243.860547] [040/133] (815s left) prime_vgem (basic-write)
[243.980430] Starting subtest: basic-write
[244.062244] Subtest basic-write: SUCCESS (0.080s)
[244.229782] [041/133] (815s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[244.398481] Starting subtest: cursor-vs-flip-atomic
[283.487463] Subtest cursor-vs-flip-atomic: SUCCESS (39.087s)
[283.801321] [042/133] (776s left) i915_query (query-topology-garbage-items)
[283.893112] Starting subtest: query-topology-garbage-items
[283.894087] Subtest query-topology-garbage-items: SUCCESS (0.001s)
[284.071390] [043/133] (775s left) gen9_exec_parse (cmd-crossing-page)
[284.187424] Starting subtest: cmd-crossing-page
[284.192761] Subtest cmd-crossing-page: SUCCESS (0.007s)
[284.493189] [044/133] (775s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[284.673377] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[284.675213] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[284.851396] [045/133] (775s left) gem_exec_store (basic)
[284.966156] Starting subtest: basic
[285.045997] Subtest basic: SUCCESS (0.080s)
[285.321636] [046/133] (774s left) kms_plane (plane-panning-bottom-right)
[285.489337] Starting subtest: plane-panning-bottom-right
[285.491150] Starting dynamic subtest: pipe-A
[286.616952] Dynamic subtest pipe-A: SUCCESS (1.122s)
[286.637659] Starting dynamic subtest: pipe-B
[287.458247] Dynamic subtest pipe-B: SUCCESS (0.835s)
[287.459229] Subtest plane-panning-bottom-right: SUCCESS (1.966s)
[287.796816] [047/133] (772s left) kms_async_flips (test-time-stamp-atomic)
[287.961994] Starting subtest: test-time-stamp-atomic
[288.522270] Starting dynamic subtest: pipe-A-HDMI-A-1
[288.751880] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.230s)
[289.093595] Starting dynamic subtest: pipe-A-HDMI-A-2
[289.324658] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.249s)
[289.660959] Starting dynamic subtest: pipe-B-HDMI-A-1
[289.892077] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.248s)
[290.204257] Starting dynamic subtest: pipe-B-HDMI-A-2
[290.433913] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.248s)
[290.749891] Starting dynamic subtest: pipe-C-HDMI-A-1
[290.978231] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.249s)
[291.287120] Starting dynamic subtest: pipe-C-HDMI-A-2
[291.497427] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.230s)
[291.498452] Subtest test-time-stamp-atomic: SUCCESS (3.537s)
[292.081034] [048/133] (768s left) kms_scaling_modes (scaling-mode-center)
[292.249785] Starting subtest: scaling-mode-center
[292.256694] Subtest scaling-mode-center: SKIP (0.003s)
[292.398699] [049/133] (768s left) kms_chamelium_hpd (dp-hpd-fast)
[292.933446] Subtest dp-hpd-fast: SKIP (0.000s)
[293.174091] [050/133] (767s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[293.266709] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[293.373899] [051/133] (767s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[293.536283] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[293.540013] Starting dynamic subtest: pipe-A-HDMI-A-1
[293.548494] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[293.569069] Starting dynamic subtest: pipe-A-HDMI-A-2
[293.577361] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.002s)
[293.597888] Starting dynamic subtest: pipe-B-HDMI-A-1
[293.606371] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[293.627060] Starting dynamic subtest: pipe-B-HDMI-A-2
[293.635863] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.002s)
[293.665905] Starting dynamic subtest: pipe-C-HDMI-A-1
[293.673904] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[293.694217] Starting dynamic subtest: pipe-C-HDMI-A-2
[293.702756] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[293.704559] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.039s)
[294.469440] [052/133] (766s left) kms_flip (flip-vs-panning-interruptible)
[294.646558] Starting subtest: flip-vs-panning-interruptible
[294.648657] Starting dynamic subtest: A-HDMI-A1
[300.300380] Dynamic subtest A-HDMI-A1: SUCCESS (5.649s)
[300.323374] Starting dynamic subtest: B-HDMI-A1
[305.715105] Dynamic subtest B-HDMI-A1: SUCCESS (5.409s)
[305.738033] Starting dynamic subtest: C-HDMI-A1
[311.111047] Dynamic subtest C-HDMI-A1: SUCCESS (5.392s)
[311.134284] Starting dynamic subtest: A-HDMI-A2
[316.528368] Dynamic subtest A-HDMI-A2: SUCCESS (5.411s)
[316.551210] Starting dynamic subtest: B-HDMI-A2
[321.921644] Dynamic subtest B-HDMI-A2: SUCCESS (5.386s)
[321.942089] Starting dynamic subtest: C-HDMI-A2
[327.311180] Dynamic subtest C-HDMI-A2: SUCCESS (5.387s)
[327.313381] Subtest flip-vs-panning-interruptible: SUCCESS (32.663s)
[327.795765] [053/133] (733s left) gem_userptr_blits (map-fixed-invalidate-busy)
[327.929180] Starting subtest: map-fixed-invalidate-busy
[327.930441] Starting dynamic subtest: gtt
[330.958462] Dynamic subtest gtt: SUCCESS (3.024s)
[330.980023] Starting dynamic subtest: wb
[333.893061] Dynamic subtest wb: SUCCESS (2.934s)
[333.918059] Starting dynamic subtest: wc
[336.847943] Dynamic subtest wc: SUCCESS (2.951s)
[336.873554] Starting dynamic subtest: uc
[339.744320] Dynamic subtest uc: SUCCESS (2.893s)
[339.748274] Subtest map-fixed-invalidate-busy: SUCCESS (11.814s)
[339.966936] [054/133] (720s left) gem_reg_read (timestamp-monotonic)
[340.065170] Starting subtest: timestamp-monotonic
[344.090034] Subtest timestamp-monotonic: SUCCESS (4.025s)
[344.259880] [055/133] (716s left) gem_mmap_wc (set-cache-level)
[344.351960] Starting subtest: set-cache-level
[344.358010] Subtest set-cache-level: SUCCESS (0.005s)
[344.513957] [056/133] (716s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[344.700274] Starting subtest: x-tiled-32bpp-rotate-180
[349.516187] Subtest x-tiled-32bpp-rotate-180: SUCCESS (4.815s)
[350.167343] [057/133] (711s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[350.346697] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[350.349037] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[350.518594] [058/133] (710s left) gem_ctx_isolation (preservation-s3)
[350.628227] Starting subtest: preservation-S3
[350.629291] Starting dynamic subtest: rcs0