[87.588547] Initializing watchdogs
[87.588727]   /dev/watchdog0
[87.628821] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[87.643554] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[87.651729] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[87.660130] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[87.885800] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[87.892982] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[88.041875] [002/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[88.250924] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[88.259857] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[88.405878] [003/133] (959s left) kms_plane_alpha_blend (coverage-7efc)
[88.600292] Starting subtest: coverage-7efc
[88.847391] Starting dynamic subtest: pipe-A-HDMI-A-1
[89.887506] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.041s)
[89.996135] Starting dynamic subtest: pipe-C-HDMI-A-1
[90.867307] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.906s)
[90.875647] Subtest coverage-7efc: SUCCESS (2.264s)
[91.205579] [004/133] (957s left) api_intel_bb (object-noreloc-keep-cache-simple)
[91.331214] Starting subtest: object-noreloc-keep-cache-simple
[91.340993] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.014s)
[91.486448] [005/133] (957s left) syncobj_basic (bad-flags-handle-to-fd)
[91.593373] Starting subtest: bad-flags-handle-to-fd
[91.596719] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[91.736207] [006/133] (956s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[91.949532] Starting subtest: fbc-indfb-scaledprimary
[95.501223] Subtest fbc-indfb-scaledprimary: SUCCESS (3.548s)
[95.801328] [007/133] (952s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[96.010629] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[98.473105] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SUCCESS (2.465s)
[98.657164] [008/133] (950s left) kms_flip (dpms-off-confusion-interruptible)
[98.859124] Starting subtest: dpms-off-confusion-interruptible
[98.864106] Starting dynamic subtest: A-HDMI-A1
[104.567338] Dynamic subtest A-HDMI-A1: SUCCESS (5.703s)
[104.587237] Starting dynamic subtest: B-HDMI-A1
[109.943356] Dynamic subtest B-HDMI-A1: SUCCESS (5.372s)
[109.963411] Starting dynamic subtest: C-HDMI-A1
[115.311288] Dynamic subtest C-HDMI-A1: SUCCESS (5.367s)
[115.330846] Starting dynamic subtest: A-HDMI-A2
[120.727256] Dynamic subtest A-HDMI-A2: SUCCESS (5.411s)
[120.747276] Starting dynamic subtest: B-HDMI-A2
[126.114299] Dynamic subtest B-HDMI-A2: SUCCESS (5.385s)
[126.135636] Starting dynamic subtest: C-HDMI-A2
[131.488474] Dynamic subtest C-HDMI-A2: SUCCESS (5.366s)
[131.494444] Subtest dpms-off-confusion-interruptible: SUCCESS (32.622s)
[132.414327] [009/133] (916s left) perf_pmu (busy-accuracy-2)
[132.906269] Starting subtest: busy-accuracy-2
[132.973867] Starting dynamic subtest: rcs0
[135.769117] Dynamic subtest rcs0: SUCCESS (3.072s)
[135.791161] Starting dynamic subtest: bcs0
[138.846226] Dynamic subtest bcs0: SUCCESS (3.076s)
[138.867916] Starting dynamic subtest: vcs0
[141.918204] Dynamic subtest vcs0: SUCCESS (3.070s)
[141.942334] Starting dynamic subtest: vecs0
[144.991757] Dynamic subtest vecs0: SUCCESS (3.071s)
[144.995657] Subtest busy-accuracy-2: SUCCESS (12.293s)
[145.135159] [010/133] (904s left) prime_mmap_coherency (write)
[145.254577] Starting subtest: write
[150.628990] Subtest write: SUCCESS (5.375s)
[150.835243] [011/133] (898s left) sysfs_heartbeat_interval (mixed)
[150.962538] Starting subtest: mixed
[150.967085] Starting dynamic subtest: vecs0
[156.222298] Dynamic subtest vecs0: SUCCESS (5.259s)
[156.243282] Starting dynamic subtest: vcs0
[161.448072] Dynamic subtest vcs0: SUCCESS (5.220s)
[161.484215] Starting dynamic subtest: bcs0
[166.713424] Dynamic subtest bcs0: SUCCESS (5.272s)
[166.739166] Starting dynamic subtest: rcs0
[171.953786] Dynamic subtest rcs0: SUCCESS (5.232s)
[171.958265] Subtest mixed: SUCCESS (20.991s)
[172.084283] [012/133] (877s left) vgem_basic (mmap)
[172.313092] Starting subtest: mmap
[172.325226] Subtest mmap: SUCCESS (0.028s)
[172.453356] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[172.459922] [013/133] (877s left) gen7_exec_parse (basic-allowed)
[172.583729] Subtest basic-allowed: SKIP (0.000s)
[172.703252] [014/133] (877s left) kms_chamelium_color (ctm-max)
[172.891638] Subtest ctm-max: SKIP (0.000s)
[173.006909] [015/133] (876s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[173.218176] Starting subtest: psr-rgb101010-draw-pwrite
[173.226119] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[173.367841] [016/133] (876s left) gem_exec_params (secure-non-master)
[173.495464] Starting subtest: secure-non-master
[173.503486] Subtest secure-non-master: SKIP (0.000s)
[173.646502] [017/133] (876s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[173.842267] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[173.847204] Starting dynamic subtest: pipe-A-HDMI-A-1
[173.898282] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.002s)
[173.944254] Starting dynamic subtest: pipe-A-HDMI-A-2
[173.982090] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s)
[174.004248] Starting dynamic subtest: pipe-B-HDMI-A-1
[174.041118] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s)
[174.062663] Starting dynamic subtest: pipe-B-HDMI-A-2
[174.099162] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s)
[174.122086] Starting dynamic subtest: pipe-C-HDMI-A-1
[174.156519] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[174.177826] Starting dynamic subtest: pipe-C-HDMI-A-2
[174.210039] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[174.213055] Subtest ccs-on-another-bo-y-tiled-ccs: SUCCESS (0.024s)
[174.804229] [018/133] (875s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[175.004865] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[175.130767] [019/133] (875s left) kms_cursor_edge_walk (64x64-top-bottom)
[175.316655] Starting subtest: 64x64-top-bottom
[175.320405] Starting dynamic subtest: pipe-A-HDMI-A-1
[179.233712] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.910s)
[179.280663] Starting dynamic subtest: pipe-C-HDMI-A-1
[182.716696] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.479s)
[182.720462] Subtest 64x64-top-bottom: SUCCESS (7.398s)
[183.029655] [020/133] (867s left) gem_sync (basic-each)
[183.182748] Starting subtest: basic-each
[185.504412] Subtest basic-each: SUCCESS (2.328s)
[185.762774] [021/133] (864s left) gem_mmap_gtt (basic-read)
[185.881052] Starting subtest: basic-read
[185.900986] Subtest basic-read: SUCCESS (0.032s)
[186.062372] [022/133] (864s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[186.177812] Starting subtest: no-spare-fences-interruptible
[188.363507] Subtest no-spare-fences-interruptible: SUCCESS (2.167s)
[188.516494] [023/133] (862s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[188.707121] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[188.714073] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[191.147469] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (2.435s)
[191.169897] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[193.141926] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (1.986s)
[193.168072] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[195.108758] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.967s)
[195.112340] Subtest 2x-flip-vs-dpms-off-vs-modeset: SUCCESS (6.404s)
[195.433437] [024/133] (855s left) kms_atomic_interruptible (legacy-setmode)
[195.639330] Starting subtest: legacy-setmode
[195.646315] Starting dynamic subtest: pipe-A-HDMI-A-1
[202.451921] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.808s)
[202.457057] Subtest legacy-setmode: SUCCESS (6.814s)
[202.789146] [025/133] (848s left) gem_exec_whisper (basic-queues-all)
[202.925668] Starting subtest: basic-queues-all
[211.317971] Subtest basic-queues-all: SUCCESS (8.389s)
[211.586296] [026/133] (839s left) i915_drm_fdinfo (memory-info-idle)
[211.698275] Starting subtest: memory-info-idle
[211.702111] Starting dynamic subtest: smem0
[211.735072] Dynamic subtest smem0: SUCCESS (0.035s)
[211.738714] Subtest memory-info-idle: SUCCESS (0.037s)
[211.884655] [027/133] (839s left) kms_psr (pr-cursor-plane-onoff)
[212.089674] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[212.232169] [028/133] (839s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[212.441158] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[212.559275] [029/133] (838s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[214.467425] Starting subtest: dpms-mode-unset-lpsp
[214.681189] Subtest dpms-mode-unset-lpsp: SKIP (0.210s)
[215.084411] [030/133] (836s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[215.201133] Starting subtest: multi-wait-all-for-submit-signaled
[215.204497] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.003s)
[215.353493] [031/133] (836s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[215.492131] Starting subtest: x-tiled-to-vebox-yf-tiled
[215.500313] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[216.138180] [032/133] (835s left) kms_content_protection (atomic-dpms-hdcp14)
[216.624040] Starting subtest: atomic-dpms-hdcp14
[216.904597] Subtest atomic-dpms-hdcp14: SKIP (0.010s)
[217.213520] [033/133] (835s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[217.418419] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[217.425297] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[217.569430] [034/133] (834s left) gem_basic (bad-close)
[217.682895] Starting subtest: bad-close
[217.691130] Subtest bad-close: SUCCESS (0.001s)
[217.834843] [035/133] (834s left) i915_getparams_basic (basic-eu-total)
[217.949505] Starting subtest: basic-eu-total
[217.956706] Subtest basic-eu-total: SUCCESS (0.000s)
[218.084718] [036/133] (834s left) gem_fenced_exec_thrash (too-many-fences)
[218.206301] Starting subtest: too-many-fences
[220.388341] Subtest too-many-fences: SUCCESS (2.169s)
[220.534720] [037/133] (832s left) gem_exec_big (single)
[220.655246] Starting subtest: single
[274.226056] Subtest single: SUCCESS (53.565s)
[274.833795] [038/133] (778s left) gem_exec_fence (keep-in-fence)
[275.247372] Starting subtest: keep-in-fence
[275.251074] Starting dynamic subtest: rcs0
[275.274428] Dynamic subtest rcs0: SUCCESS (0.031s)
[275.301594] Starting dynamic subtest: bcs0
[275.402930] Dynamic subtest bcs0: SUCCESS (0.127s)
[275.427262] Starting dynamic subtest: vcs0
[275.443515] Dynamic subtest vcs0: SUCCESS (0.039s)
[275.473177] Starting dynamic subtest: vecs0
[275.484572] Dynamic subtest vecs0: SUCCESS (0.038s)
[275.488538] Subtest keep-in-fence: SUCCESS (0.245s)
[276.190387] [039/133] (776s left) gem_ctx_persistence (heartbeat-stop)
[276.312842] Starting subtest: heartbeat-stop
[276.459162] Subtest heartbeat-stop: SUCCESS (0.152s)
[276.652695] [040/133] (776s left) gem_exec_reloc (basic-gtt-read-active)
[276.772042] Starting subtest: basic-gtt-read-active
[276.910721] Subtest basic-gtt-read-active: SUCCESS (0.137s)
[277.161393] [041/133] (776s left) gem_workarounds (suspend-resume-context)
[277.311030] Starting subtest: suspend-resume-context
[292.818942] Subtest suspend-resume-context: SUCCESS (1.230s)
[303.028666] [042/133] (760s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[303.225404] Starting subtest: plane-all-transition-nonblocking-fencing
[303.229314] Starting dynamic subtest: pipe-A-HDMI-A-1
[308.113333] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.883s)
[308.409703] Starting dynamic subtest: pipe-A-HDMI-A-2
[313.236369] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (4.884s)
[313.544465] Starting dynamic subtest: pipe-B-HDMI-A-1
[318.581471] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (5.090s)
[318.861672] Starting dynamic subtest: pipe-B-HDMI-A-2
[323.895574] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (5.087s)
[324.112410] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (20.885s)
[324.446953] [043/133] (739s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[324.685661] Starting subtest: modeset-transition-nonblocking-fencing
[324.690460] Starting dynamic subtest: 1x-outputs
[328.235257] Dynamic subtest 1x-outputs: SUCCESS (3.549s)
[328.287776] Starting dynamic subtest: 2x-outputs
[335.594023] Dynamic subtest 2x-outputs: SUCCESS (7.354s)
[335.599303] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.916s)
[335.926222] [044/133] (727s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[336.047074] Starting subtest: invalid-smem-bo-on-discrete
[336.054305] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[336.304309] [045/133] (727s left) core_getversion (all-cards)
[336.424234] Starting subtest: all-cards
[336.463430] Subtest all-cards: SUCCESS (0.046s)
[336.587700] [046/133] (727s left) gem_unfence_active_buffers
[336.955394] [047/133] (727s left) kms_vblank (invalid)
[337.144650] Starting subtest: invalid
[337.148397] Starting dynamic subtest: pipe-A-HDMI-A-1
[337.817385] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.665s)
[337.821977] Subtest invalid: SUCCESS (0.673s)
[338.143320] [048/133] (725s left) prime_vgem (basic-fence-read)
[338.290188] Starting subtest: basic-fence-read
[338.429223] Subtest basic-fence-read: SUCCESS (0.141s)
[338.585528] [049/133] (725s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[338.785866] Starting subtest: flip-vs-cursor-busy-crc-legacy
[339.814000] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (1.032s)
[340.201705] [050/133] (724s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[340.413314] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[343.369070] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (2.963s)
[343.656830] [051/133] (720s left) kms_lease (setcrtc-implicit-plane)
[343.851381] Starting subtest: setcrtc-implicit-plane
[343.856285] Starting dynamic subtest: pipe-A-HDMI-A-1
[344.610809] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.750s)
[344.667304] Starting dynamic subtest: pipe-A-HDMI-A-2
[345.065291] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.449s)
[345.104389] Starting dynamic subtest: pipe-B-HDMI-A-1
[345.530597] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.453s)
[345.594648] Starting dynamic subtest: pipe-B-HDMI-A-2
[346.002232] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.449s)
[346.048329] Starting dynamic subtest: pipe-C-HDMI-A-1
[346.456321] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.454s)
[346.519549] Starting dynamic subtest: pipe-C-HDMI-A-2
[346.917810] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.447s)
[346.925330] Subtest setcrtc-implicit-plane: SUCCESS (3.064s)
[347.269835] [052/133] (717s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[347.487407] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[347.496426] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[347.638312] [053/133] (716s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[347.762448] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[347.766138] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.002s)
[347.917474] [054/133] (716s left) gem_softpin (allocator-fork)
[348.046845] Starting subtest: allocator-fork
[350.413308] Subtest allocator-fork: SUCCESS (2.370s)
[350.567487] [055/133] (714s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[350.778281] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[350.897212] [056/133] (714s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[351.115551] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[351.119525] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[362.184400] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.066s)
[362.218430] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[373.451950] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (11.261s)
[373.483081] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[384.416354] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.955s)
[384.421529] Subtest 2x-plain-flip-fb-recreate-interruptible: SUCCESS (33.307s)
[385.071458] [057/133] (680s left) kms_fbcon_fbt (fbc-suspend)
[385.203335] Starting subtest: fbc-suspend