[90.215327] Initializing watchdogs
[90.215492]   /dev/watchdog0
[90.253538] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[90.266600] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[90.273351] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[90.281518] [001/131] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[90.826126] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[90.834444] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[90.951956] [002/131] (959s left) kms_async_flips (test-time-stamp)
[91.149156] Starting subtest: test-time-stamp
[91.759440] Starting dynamic subtest: pipe-A-HDMI-A-1
[92.307598] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.488s)
[92.523069] Starting dynamic subtest: pipe-A-HDMI-A-2
[92.897792] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.237s)
[93.001104] Starting dynamic subtest: pipe-B-HDMI-A-1
[93.210658] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.219s)
[93.475454] Starting dynamic subtest: pipe-B-HDMI-A-2
[93.739212] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.273s)
[94.049562] Starting dynamic subtest: pipe-C-HDMI-A-1
[94.280102] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.243s)
[94.545344] Starting dynamic subtest: pipe-C-HDMI-A-2
[94.774830] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.242s)
[94.777833] Subtest test-time-stamp: SUCCESS (3.625s)
[95.349430] [003/131] (955s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[95.482803] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[95.576826] [004/131] (955s left) gem_exec_whisper (basic-contexts)
[95.732476] Starting subtest: basic-contexts
[101.907150] Subtest basic-contexts: SUCCESS (6.175s)
[102.154223] [005/131] (948s left) gem_exec_reloc (basic-cpu-active)
[102.283899] Starting subtest: basic-cpu-active
[102.423262] Subtest basic-cpu-active: SUCCESS (0.138s)
[102.631381] [006/131] (948s left) gem_exec_schedule (preempt-contexts)
[102.781123] Starting subtest: preempt-contexts
[102.784448] Starting dynamic subtest: rcs0
[102.877506] Dynamic subtest rcs0: SUCCESS (0.094s)
[102.898862] Starting dynamic subtest: bcs0
[102.990948] Dynamic subtest bcs0: SUCCESS (0.115s)
[103.013332] Starting dynamic subtest: vcs0
[103.104727] Dynamic subtest vcs0: SUCCESS (0.104s)
[103.127335] Starting dynamic subtest: vecs0
[103.191290] Dynamic subtest vecs0: SUCCESS (0.091s)
[103.195578] Subtest preempt-contexts: SUCCESS (0.412s)
[103.589089] [007/131] (947s left) kms_flip (2x-plain-flip-ts-check)
[103.799080] Starting subtest: 2x-plain-flip-ts-check
[103.802075] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[114.878656] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.080s)
[114.901927] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[125.783256] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.897s)
[125.806065] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[136.699760] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.913s)
[136.707965] Subtest 2x-plain-flip-ts-check: SUCCESS (32.907s)
[137.273076] [008/131] (914s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[137.507179] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[137.513650] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[137.640468] [009/131] (913s left) syncobj_wait (wait-for-submit-snapshot)
[137.763544] Starting subtest: wait-for-submit-snapshot
[137.850778] Subtest wait-for-submit-snapshot: SUCCESS (0.086s)
[137.976939] [010/131] (913s left) perf_pmu (rc6)
[138.099407] Starting subtest: rc6
[138.103665] Starting dynamic subtest: gt0
[144.448344] Dynamic subtest gt0: SUCCESS (6.349s)
[144.473205] Starting dynamic subtest: runtime-pm-gt0
[152.243751] Dynamic subtest runtime-pm-gt0: SUCCESS (7.795s)
[152.263138] Starting dynamic subtest: runtime-pm-long-gt0
[164.683328] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.438s)
[164.730512] Starting dynamic subtest: other-idle-gt0
[164.768274] Dynamic subtest other-idle-gt0: SKIP (0.000s)
[164.772465] Subtest rc6: SUCCESS (26.587s)
[166.267178] [011/131] (885s left) gem_vm_create (invalid-create)
[166.393792] Starting subtest: invalid-create
[166.396912] Subtest invalid-create: SUCCESS (0.000s)
[166.507944] [012/131] (885s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[166.732523] Subtest psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[166.812478] [013/131] (885s left) gem_ctx_exec (basic-norecovery)
[166.941806] Starting subtest: basic-norecovery
[166.977234] Subtest basic-norecovery: SUCCESS (0.035s)
[167.096208] [014/131] (884s left) perf_pmu (render-node-busy-idle)
[167.242809] Starting subtest: render-node-busy-idle
[167.251131] Starting dynamic subtest: rcs0
[167.875156] Dynamic subtest rcs0: SUCCESS (0.627s)
[167.894873] Starting dynamic subtest: bcs0
[168.494383] Dynamic subtest bcs0: SUCCESS (0.624s)
[168.514156] Starting dynamic subtest: vcs0
[169.132493] Dynamic subtest vcs0: SUCCESS (0.636s)
[169.151616] Starting dynamic subtest: vecs0
[169.763293] Dynamic subtest vecs0: SUCCESS (0.624s)
[169.767241] Subtest render-node-busy-idle: SUCCESS (2.513s)
[169.854899] [015/131] (882s left) gem_exec_flush (basic-wb-ro-before-default)
[169.997957] Starting subtest: basic-wb-ro-before-default
[175.428384] Subtest basic-wb-ro-before-default: SUCCESS (5.430s)
[175.655587] [016/131] (876s left) kms_chamelium_frames (hdmi-frame-dump)
[176.176159] Subtest hdmi-frame-dump: SKIP (0.000s)
[176.389914] [017/131] (875s left) gem_userptr_blits (forbidden-operations)
[176.528875] Starting subtest: forbidden-operations
[176.531786] Subtest forbidden-operations: SUCCESS (0.002s)
[176.710256] [018/131] (875s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[176.829266] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[176.832491] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[176.939029] [019/131] (875s left) kms_cursor_crc (cursor-onscreen-512x170)
[177.153090] Starting subtest: cursor-onscreen-512x170
[177.159828] Subtest cursor-onscreen-512x170: SKIP (0.003s)
[177.264570] [020/131] (875s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[177.482948] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[177.489852] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[177.581600] [021/131] (874s left) gem_ctx_shared (create-shared-gtt)
[177.728626] Starting subtest: create-shared-gtt
[179.882391] Subtest create-shared-gtt: SUCCESS (2.152s)
[180.097110] [022/131] (872s left) gem_exec_flush (basic-uc-pro-default)
[180.234460] Starting subtest: basic-uc-pro-default
[185.660305] Subtest basic-uc-pro-default: SUCCESS (5.425s)
[185.866804] [023/131] (866s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[186.070111] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[186.073253] Starting dynamic subtest: pipe-A-HDMI-A-1
[186.141520] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[186.164034] Starting dynamic subtest: pipe-A-HDMI-A-2
[186.196713] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[186.215459] Starting dynamic subtest: pipe-B-HDMI-A-1
[186.246034] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[186.275768] Starting dynamic subtest: pipe-B-HDMI-A-2
[186.288271] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[186.306722] Starting dynamic subtest: pipe-C-HDMI-A-1
[186.321011] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[186.342699] Starting dynamic subtest: pipe-C-HDMI-A-2
[186.357049] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[186.363691] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.022s)
[186.904782] [024/131] (865s left) kms_chamelium_color (ctm-0-50)
[187.111959] Subtest ctm-0-50: SKIP (0.000s)
[187.197926] [025/131] (865s left) gem_mmap (big-bo)
[187.319598] Starting subtest: big-bo
[189.248151] Subtest big-bo: SUCCESS (1.932s)
[189.395666] [026/131] (863s left) fbdev (read)
[189.649520] Starting subtest: read
[191.155289] Subtest read: SUCCESS (1.505s)
[191.239593] [027/131] (861s left) perf_pmu (interrupts)
[191.378062] Starting subtest: interrupts
[192.576285] Subtest interrupts: SUCCESS (1.195s)
[192.686054] [FACT perf_pmu (interrupts)] new: kernel.kmod_is_loaded.vgem: true
[192.692281] [028/131] (860s left) gem_create (create-clear)
[192.811895] Starting subtest: create-clear
[192.815776] Starting dynamic subtest: smem0
[225.227393] Dynamic subtest smem0: SUCCESS (32.410s)
[225.230489] Subtest create-clear: SUCCESS (32.410s)
[225.465125] [029/131] (827s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[225.726140] Starting subtest: x-tiled-32bpp-rotate-270
[226.114794] Subtest x-tiled-32bpp-rotate-270: SKIP (0.382s)
[226.469353] [030/131] (826s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-render)
[226.694108] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-render
[226.700885] Subtest fbcpsr-1p-offscren-pri-indfb-draw-render: SKIP (0.000s)
[226.800488] [031/131] (826s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[226.927867] Starting subtest: basic-write-cpu-read-gtt
[226.933671] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[227.035821] [032/131] (826s left) gem_exec_fence (submit3)
[227.316279] Starting subtest: submit3
[227.319535] Starting dynamic subtest: rcs0
[227.352466] Dynamic subtest rcs0: SUCCESS (0.011s)
[227.392127] Starting dynamic subtest: bcs0
[227.396824] Dynamic subtest bcs0: SUCCESS (0.010s)
[227.419062] Starting dynamic subtest: vcs0
[227.424478] Dynamic subtest vcs0: SUCCESS (0.011s)
[227.445294] Starting dynamic subtest: vecs0
[227.449393] Dynamic subtest vecs0: SUCCESS (0.010s)
[227.453246] Subtest submit3: SUCCESS (0.073s)
[228.024468] [033/131] (825s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[228.242936] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[230.806171] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (2.563s)
[231.165817] [034/131] (822s left) syncobj_timeline (etime-multi-wait-submitted)
[231.294726] Starting subtest: etime-multi-wait-submitted
[231.396920] Subtest etime-multi-wait-submitted: SUCCESS (0.103s)
[231.515284] [035/131] (822s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[231.727337] Starting subtest: y-tiled-32bpp-rotate-0
[236.868717] Subtest y-tiled-32bpp-rotate-0: SUCCESS (5.141s)
[237.507791] [036/131] (816s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[237.778673] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[237.784951] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[237.962827] [037/131] (816s left) kms_addfb_basic (bad-pitch-63)
[238.083155] Starting subtest: bad-pitch-63
[238.086143] Subtest bad-pitch-63: SUCCESS (0.000s)
[238.272623] [038/131] (815s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-20x20)
[238.470547] Starting subtest: planes-downscale-factor-0-25-upscale-20x20
[238.474484] Starting dynamic subtest: pipe-A
[243.773094] Dynamic subtest pipe-A: SKIP (5.295s)
[243.808654] Starting dynamic subtest: pipe-B
[248.520213] Dynamic subtest pipe-B: SKIP (4.747s)
[248.551845] Starting dynamic subtest: pipe-C
[248.578204] Dynamic subtest pipe-C: SKIP (0.050s)
[248.585438] Subtest planes-downscale-factor-0-25-upscale-20x20: SKIP (10.100s)
[248.719491] [039/131] (805s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[248.989321] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[248.995823] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[249.111061] [040/131] (805s left) gem_mmap_wc (write-prefaulted)
[249.237678] Starting subtest: write-prefaulted
[249.522779] Subtest write-prefaulted: SUCCESS (0.286s)
[249.643980] [041/131] (804s left) kms_joiner (basic-force-ultra-joiner)
[249.862450] Starting subtest: basic-force-ultra-joiner
[249.869153] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[249.969723] [042/131] (804s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[250.199332] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[250.202656] Starting dynamic subtest: A-HDMI-A1
[251.373127] Dynamic subtest A-HDMI-A1: SUCCESS (1.155s)
[251.413491] Starting dynamic subtest: B-HDMI-A1
[252.118219] Dynamic subtest B-HDMI-A1: SUCCESS (0.738s)
[252.162353] Starting dynamic subtest: C-HDMI-A1
[252.862777] Dynamic subtest C-HDMI-A1: SUCCESS (0.713s)
[252.914337] Starting dynamic subtest: A-HDMI-A2
[253.863881] Dynamic subtest A-HDMI-A2: SUCCESS (0.970s)
[253.901503] Starting dynamic subtest: B-HDMI-A2
[254.822092] Dynamic subtest B-HDMI-A2: SUCCESS (0.956s)
[254.872718] Starting dynamic subtest: C-HDMI-A2
[255.761627] Dynamic subtest C-HDMI-A2: SUCCESS (0.908s)
[255.764883] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (5.554s)
[255.999269] [043/131] (798s left) kms_psr (fbc-psr-primary-mmap-gtt)
[256.215250] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s)
[256.328390] [044/131] (798s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[256.617771] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[256.729052] [045/131] (798s left) syncobj_timeline (wait-any-complex)
[256.852404] Starting subtest: wait-any-complex
[256.917276] Subtest wait-any-complex: SUCCESS (0.065s)
[257.028927] [046/131] (797s left) gem_softpin (allocator-basic-reserve)
[257.165454] Starting subtest: allocator-basic-reserve
[257.451315] Subtest allocator-basic-reserve: SUCCESS (0.274s)
[257.579633] [047/131] (797s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[257.809883] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[259.279763] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (1.471s)
[259.840925] [048/131] (795s left) kms_pm_rpm (pc8-residency)
[261.647241] Starting subtest: pc8-residency
[261.698153] Subtest pc8-residency: SKIP (0.000s)
[261.952791] [049/131] (793s left) kms_flip (flip-vs-suspend-interruptible)
[262.179876] Starting subtest: flip-vs-suspend-interruptible
[262.190156] Starting dynamic subtest: A-HDMI-A1