[86.286666] Initializing watchdogs
[86.286835]   /dev/watchdog0
[86.329423] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[86.343942] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[86.351260] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[86.359092] [001/133] (960s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[86.587248] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[86.860186] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.270s)
[87.097657] [002/133] (959s left) gem_mmap_wc (read-write-distinct)
[87.204681] Starting subtest: read-write-distinct
[87.214299] Subtest read-write-distinct: SUCCESS (0.011s)
[87.374578] [003/133] (959s left) api_intel_bb (blit-noreloc-purge-cache)
[87.474793] Starting subtest: blit-noreloc-purge-cache
[87.492970] Subtest blit-noreloc-purge-cache: SUCCESS (0.020s)
[87.677609] [004/133] (959s left) perf_pmu (interrupts)
[87.796758] Starting subtest: interrupts
[88.978410] Subtest interrupts: SUCCESS (1.180s)
[89.133668] [FACT perf_pmu (interrupts)] new: kernel.kmod_is_loaded.vgem: true
[89.142902] [005/133] (958s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[89.349503] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[89.356510] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[89.538906] [006/133] (957s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[89.737454] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[89.744209] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s)
[89.920965] [007/133] (957s left) sysfs_heartbeat_interval (precise)
[90.034550] Starting subtest: precise
[90.037945] Starting dynamic subtest: vecs0
[91.513089] Dynamic subtest vecs0: SUCCESS (1.475s)
[91.533220] Starting dynamic subtest: vcs0
[92.984647] Dynamic subtest vcs0: SUCCESS (1.472s)
[93.009399] Starting dynamic subtest: bcs0
[94.439308] Dynamic subtest bcs0: SUCCESS (1.453s)
[94.463650] Starting dynamic subtest: rcs0
[95.897299] Dynamic subtest rcs0: SUCCESS (1.459s)
[95.901465] Subtest precise: SUCCESS (5.865s)
[96.069193] [008/133] (951s left) kms_force_connector_basic (force-edid)
[96.336386] Starting subtest: force-edid
[96.511053] Subtest force-edid: SUCCESS (0.159s)
[96.855914] [009/133] (950s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[97.049154] Starting subtest: cursorB-vs-flipB-legacy
[108.354160] Subtest cursorB-vs-flipB-legacy: SUCCESS (11.305s)
[108.678235] [010/133] (939s left) kms_cursor_edge_walk (256x256-top-edge)
[108.856434] Starting subtest: 256x256-top-edge
[108.900677] Starting dynamic subtest: pipe-A-HDMI-A-1
[112.711635] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.849s)
[112.732949] Starting dynamic subtest: pipe-C-HDMI-A-1
[116.174532] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.416s)
[116.181041] Subtest 256x256-top-edge: SUCCESS (7.274s)
[116.443473] [011/133] (931s left) device_reset (unbind-cold-reset-rebind)
[116.580980] Starting subtest: unbind-cold-reset-rebind
[116.589520] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[116.747895] [012/133] (931s left) syncobj_wait (single-wait-for-submit-signaled)
[116.849032] Starting subtest: single-wait-for-submit-signaled
[116.852535] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s)
[117.007773] [013/133] (931s left) gem_caching (read-writes)
[117.124201] Starting subtest: read-writes
[138.469082] Subtest read-writes: SUCCESS (21.346s)
[138.678357] [014/133] (909s left) gem_ctx_engines (execute-oneforall)
[138.803250] Starting subtest: execute-oneforall
[139.435416] Subtest execute-oneforall: SUCCESS (0.570s)
[140.048191] [015/133] (908s left) gem_render_copy (y-tiled-ccs-to-linear)
[140.433664] Starting subtest: y-tiled-ccs-to-linear
[140.436945] Starting dynamic subtest: smem
[140.511963] Dynamic subtest smem: SUCCESS (0.194s)
[140.515965] Subtest y-tiled-ccs-to-linear: SUCCESS (0.195s)
[140.793577] [016/133] (907s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[141.004259] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[141.011042] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[141.178376] [017/133] (907s left) kms_psr (fbc-pr-cursor-plane-onoff)
[141.361111] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[141.475097] [018/133] (907s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[141.684794] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[144.119268] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (2.440s)
[144.425276] [019/133] (904s left) gem_ctx_exec (basic-nohangcheck)
[144.532802] Starting subtest: basic-nohangcheck
[144.801555] Subtest basic-nohangcheck: SUCCESS (0.268s)
[144.992628] [020/133] (904s left) i915_selftest (live)
[146.564707] Starting subtest: live
[146.569210] Starting dynamic subtest: sanitycheck
[149.113079] Dynamic subtest sanitycheck: SUCCESS (2.536s)
[149.140580] Starting dynamic subtest: uncore
[151.472568] Dynamic subtest uncore: SUCCESS (2.365s)
[151.493603] Starting dynamic subtest: workarounds
[154.288105] Dynamic subtest workarounds: SUCCESS (2.825s)
[154.311777] Starting dynamic subtest: gt_engines
[157.372226] Dynamic subtest gt_engines: SUCCESS (3.076s)
[157.393196] Starting dynamic subtest: gt_timelines
[173.026342] Dynamic subtest gt_timelines: SUCCESS (15.655s)
[173.049677] Starting dynamic subtest: gt_contexts
[175.455780] Dynamic subtest gt_contexts: SUCCESS (2.428s)
[175.477828] Starting dynamic subtest: gt_lrc
[180.494786] Dynamic subtest gt_lrc: SUCCESS (5.035s)
[180.516813] Starting dynamic subtest: gt_mocs
[182.948153] Dynamic subtest gt_mocs: SUCCESS (2.442s)
[182.969935] Starting dynamic subtest: gt_pm
[193.707598] Dynamic subtest gt_pm: SUCCESS (10.768s)
[193.730573] Starting dynamic subtest: gt_heartbeat
[196.154089] Dynamic subtest gt_heartbeat: SUCCESS (2.444s)
[196.177786] Starting dynamic subtest: gt_tlb
[199.834167] Dynamic subtest gt_tlb: SUCCESS (3.676s)
[199.856170] Starting dynamic subtest: requests
[208.514088] Dynamic subtest requests: SUCCESS (8.679s)
[208.539325] Starting dynamic subtest: migrate
[213.771148] Dynamic subtest migrate: SUCCESS (5.252s)
[213.793715] Starting dynamic subtest: active
[216.179337] Dynamic subtest active: SUCCESS (2.407s)
[216.201669] Starting dynamic subtest: objects
[220.872342] Dynamic subtest objects: SUCCESS (4.691s)
[220.894264] Starting dynamic subtest: mman
[228.982163] Dynamic subtest mman: SUCCESS (8.107s)
[229.004212] Starting dynamic subtest: dmabuf
[231.663436] Dynamic subtest dmabuf: SUCCESS (2.678s)
[231.685378] Starting dynamic subtest: vma
[234.114762] Dynamic subtest vma: SUCCESS (2.448s)
[234.136557] Starting dynamic subtest: coherency
[243.087884] Dynamic subtest coherency: SUCCESS (8.970s)
[243.109858] Starting dynamic subtest: gtt
[252.929377] Dynamic subtest gtt: SUCCESS (9.839s)
[252.952899] Starting dynamic subtest: gem
[255.648436] Dynamic subtest gem: SUCCESS (2.717s)
[255.670648] Starting dynamic subtest: evict
[260.773856] Dynamic subtest evict: SUCCESS (5.122s)
[260.795803] Starting dynamic subtest: hugepages
[269.573618] Dynamic subtest hugepages: SUCCESS (8.798s)
[269.596992] Starting dynamic subtest: gem_contexts
[290.007130] Dynamic subtest gem_contexts: SUCCESS (20.430s)
[290.031198] Starting dynamic subtest: client
[292.765396] Dynamic subtest client: SUCCESS (2.755s)
[292.788557] Starting dynamic subtest: gem_migrate
[295.233222] Dynamic subtest gem_migrate: SUCCESS (2.406s)
[295.301661] Starting dynamic subtest: reset
[301.370890] Dynamic subtest reset: SUCCESS (6.195s)
[301.394830] Starting dynamic subtest: memory_region
[303.701366] Dynamic subtest memory_region: SUCCESS (2.327s)
[303.723622] Starting dynamic subtest: hangcheck
[329.055050] Dynamic subtest hangcheck: SUCCESS (25.349s)
[329.098536] Starting dynamic subtest: execlists
[340.841433] Dynamic subtest execlists: SUCCESS (11.784s)
[340.864978] Starting dynamic subtest: ring_submission
[343.174692] Dynamic subtest ring_submission: SUCCESS (2.332s)
[343.196665] Starting dynamic subtest: perf
[345.632354] Dynamic subtest perf: SUCCESS (2.453s)
[345.655205] Starting dynamic subtest: slpc
[348.204691] Dynamic subtest slpc: SUCCESS (2.570s)
[348.227651] Starting dynamic subtest: guc
[350.581217] Dynamic subtest guc: SUCCESS (2.374s)
[350.603373] Starting dynamic subtest: guc_multi_lrc
[353.070832] Dynamic subtest guc_multi_lrc: SUCCESS (2.487s)
[353.094544] Starting dynamic subtest: guc_hang
[355.382725] Dynamic subtest guc_hang: SUCCESS (2.309s)
[355.404684] Starting dynamic subtest: late_gt_pm
[357.809141] Dynamic subtest late_gt_pm: SUCCESS (2.418s)
[357.812589] Subtest live: SUCCESS (211.245s)
[357.877393] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[357.880205] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[357.886944] [021/133] (691s left) gem_userptr_blits (sync-unmap-after-close)
[360.674804] Starting subtest: sync-unmap-after-close
[360.794033] Subtest sync-unmap-after-close: SUCCESS (0.120s)
[360.940832] [FACT gem_userptr_blits (sync-unmap-after-close)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[360.943819] [FACT gem_userptr_blits (sync-unmap-after-close)] new: kernel.kmod_is_loaded.i915: true
[360.954214] [022/133] (688s left) gem_exec_suspend (basic-s3-devices)
[361.110448] Starting subtest: basic-S3-devices
[361.115180] Starting dynamic subtest: smem
[371.222479] Dynamic subtest smem: SUCCESS (10.126s)
[371.226995] Subtest basic-S3-devices: SUCCESS (10.129s)
[377.522743] [023/133] (677s left) prime_vgem (fence-wait)
[377.691981] Starting subtest: fence-wait
[377.695364] Starting dynamic subtest: rcs0
[378.712144] Dynamic subtest rcs0: SUCCESS (1.024s)
[378.736127] Starting dynamic subtest: vcs0
[379.744562] Dynamic subtest vcs0: SUCCESS (1.028s)
[379.767665] Starting dynamic subtest: vecs0
[380.768390] Dynamic subtest vecs0: SUCCESS (1.023s)
[380.772094] Subtest fence-wait: SUCCESS (3.083s)
[380.957863] [024/133] (674s left) gem_ppgtt (blt-vs-render-ctxn)
[381.078287] Starting subtest: blt-vs-render-ctxN
[414.255930] Subtest blt-vs-render-ctxN: SUCCESS (33.180s)
[414.455878] [025/133] (641s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[414.714955] Starting subtest: basic-wc-gtt-noreloc
[414.726893] Subtest basic-wc-gtt-noreloc: SUCCESS (0.012s)
[414.977335] [026/133] (640s left) kms_sequence (queue-busy)
[415.169204] Starting subtest: queue-busy
[415.174155] Starting dynamic subtest: pipe-A-HDMI-A-1
[418.114741] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.938s)
[418.156450] Starting dynamic subtest: pipe-A-HDMI-A-2
[420.724897] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.606s)
[420.787098] Starting dynamic subtest: pipe-B-HDMI-A-1
[423.321086] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.588s)
[423.369350] Starting dynamic subtest: pipe-B-HDMI-A-2
[425.923419] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.604s)
[425.974889] Starting dynamic subtest: pipe-C-HDMI-A-1
[428.500461] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.570s)
[428.550377] Starting dynamic subtest: pipe-C-HDMI-A-2
[431.123665] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.572s)
[431.129583] Subtest queue-busy: SUCCESS (15.910s)
[431.401992] [027/133] (624s left) i915_pm_rps (engine-order)
[431.525700] Starting subtest: engine-order
[442.931116] Subtest engine-order: SUCCESS (11.389s)
[443.156412] [028/133] (612s left) kms_psr (pr-cursor-plane-onoff)
[443.338852] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[443.465992] [029/133] (612s left) perf_pmu (busy-accuracy-50)
[443.589295] Starting subtest: busy-accuracy-50
[443.592770] Starting dynamic subtest: rcs0
[445.133159] Dynamic subtest rcs0: SUCCESS (1.551s)
[445.158563] Starting dynamic subtest: bcs0
[446.690622] Dynamic subtest bcs0: SUCCESS (1.555s)
[446.715262] Starting dynamic subtest: vcs0
[448.243473] Dynamic subtest vcs0: SUCCESS (1.549s)
[448.268074] Starting dynamic subtest: vecs0
[449.796630] Dynamic subtest vecs0: SUCCESS (1.550s)
[449.801997] Subtest busy-accuracy-50: SUCCESS (6.215s)
[449.963846] [030/133] (606s left) gem_exec_store (pages)
[450.090498] Starting subtest: pages
[450.094232] Starting dynamic subtest: rcs0
[450.181077] Dynamic subtest rcs0: SUCCESS (0.089s)
[450.213037] Starting dynamic subtest: bcs0
[450.287661] Dynamic subtest bcs0: SUCCESS (0.100s)
[450.312098] Starting dynamic subtest: vcs0
[450.369344] Dynamic subtest vcs0: SUCCESS (0.078s)
[450.394725] Starting dynamic subtest: vecs0
[450.454808] Dynamic subtest vecs0: SUCCESS (0.081s)
[450.459287] Subtest pages: SUCCESS (0.366s)
[450.750588] [031/133] (605s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[450.956757] Starting subtest: x-tiled-addfb-size-offset-overflow
[450.960441] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[451.135998] [032/133] (605s left) syncobj_timeline (multi-wait-all-signaled)
[451.258361] Starting subtest: multi-wait-all-signaled
[451.262132] Subtest multi-wait-all-signaled: SUCCESS (0.003s)
[451.463773] [033/133] (605s left) gem_ctx_bad_destroy (invalid-pad)
[451.570262] Starting subtest: invalid-pad
[451.573397] Subtest invalid-pad: SUCCESS (0.000s)
[451.762868] [034/133] (604s left) kms_getfb (getfb-handle-closed)
[451.941427] Starting subtest: getfb-handle-closed
[451.945230] Subtest getfb-handle-closed: SUCCESS (0.000s)
[452.136278] [035/133] (604s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[452.695199] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[452.960325] [036/133] (603s left) perf (missing-sample-flags)
[453.230123] Starting subtest: missing-sample-flags
[453.233328] Subtest missing-sample-flags: SUCCESS (0.002s)
[453.341531] [037/133] (603s left) i915_hangman (engine-engine-error)
[453.482451] Starting subtest: engine-engine-error
[453.485750] Starting dynamic subtest: rcs0
[453.556113] Dynamic subtest rcs0: SUCCESS (0.074s)
[453.580714] Starting dynamic subtest: bcs0
[453.587189] Dynamic subtest bcs0: SKIP (0.004s)
[453.612555] Starting dynamic subtest: vcs0
[453.659308] Dynamic subtest vcs0: SUCCESS (0.090s)
[453.685709] Starting dynamic subtest: vecs0
[453.733572] Dynamic subtest vecs0: SUCCESS (0.073s)
[453.741815] Subtest engine-engine-error: SUCCESS (0.260s)
[453.960892] [038/133] (603s left) syncobj_basic (bad-pad-handle-to-fd)
[454.067058] Starting subtest: bad-pad-handle-to-fd
[454.070908] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[454.235942] [039/133] (602s left) syncobj_timeline (wait-all-for-submit-snapshot)
[454.343264] Starting subtest: wait-all-for-submit-snapshot
[454.425092] Subtest wait-all-for-submit-snapshot: SUCCESS (0.086s)
[454.603680] [040/133] (602s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[454.794746] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[454.917446] [041/133] (602s left) kms_vblank (ts-continuation-suspend)
[455.111803] Starting subtest: ts-continuation-suspend
[455.115188] Starting dynamic subtest: pipe-A-HDMI-A-1