[87.883390] Initializing watchdogs
[87.883557]   /dev/watchdog0
[87.921560] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3184 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 605]
[87.935601] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[87.943761] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[87.951189] [001/133] (960s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[88.078547] Starting subtest: writes-after-reads-snoop
[106.478492] Subtest writes-after-reads-snoop: SUCCESS (18.394s)
[106.648055] [002/133] (941s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[106.831694] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[106.835945] Starting dynamic subtest: pipe-A-valid-mode
[107.755181] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.923s)
[107.757161] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SUCCESS (0.926s)
[108.041462] [003/133] (940s left) kms_feature_discovery (dp-mst)
[108.237379] Starting subtest: dp-mst
[108.242841] Subtest dp-mst: SKIP (0.001s)
[108.373825] [004/133] (940s left) kms_vblank (ts-continuation-modeset-hang)
[108.544755] Starting subtest: ts-continuation-modeset-hang
[108.550363] Starting dynamic subtest: pipe-A-HDMI-A-1
[115.882171] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.332s)
[115.901995] Starting dynamic subtest: pipe-A-HDMI-A-2
[122.931848] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (7.044s)
[122.953539] Starting dynamic subtest: pipe-C-HDMI-A-1
[129.884777] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.943s)
[129.904111] Starting dynamic subtest: pipe-C-HDMI-A-2
[136.867756] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (6.978s)
[136.869673] Subtest ts-continuation-modeset-hang: SUCCESS (28.317s)
[137.153394] [005/133] (911s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[137.327679] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[137.329524] Starting dynamic subtest: pipe-A
[137.624549] Dynamic subtest pipe-A: SUCCESS (0.296s)
[137.642920] Starting dynamic subtest: pipe-B
[137.969010] Dynamic subtest pipe-B: SUCCESS (0.344s)
[137.986934] Starting dynamic subtest: pipe-C
[138.017122] Dynamic subtest pipe-C: SUCCESS (0.047s)
[138.019222] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.690s)
[138.440585] [006/133] (910s left) kms_cursor_legacy (torture-bo)
[138.614493] Starting subtest: torture-bo
[138.616588] Starting dynamic subtest: pipe-A
[144.255177] Dynamic subtest pipe-A: SUCCESS (5.637s)
[144.273248] Starting dynamic subtest: pipe-B
[149.812240] Dynamic subtest pipe-B: SUCCESS (5.558s)
[149.831433] Starting dynamic subtest: pipe-C
[155.328350] Dynamic subtest pipe-C: SUCCESS (5.516s)
[155.345835] Starting dynamic subtest: all-pipes
[160.807137] Dynamic subtest all-pipes: SUCCESS (5.479s)
[160.810736] Subtest torture-bo: SUCCESS (22.193s)
[160.940506] [007/133] (887s left) sw_sync (sync_merge_invalid)
[161.037675] Starting subtest: sync_merge_invalid
[161.044521] Subtest sync_merge_invalid: SUCCESS (0.006s)
[161.131282] [008/133] (887s left) syncobj_eventfd (timeline-wait)
[161.228492] Starting subtest: timeline-wait
[161.240200] Subtest timeline-wait: SUCCESS (0.012s)
[161.359674] [009/133] (887s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[161.531558] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[161.535117] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[161.658507] [010/133] (887s left) gem_mmap_gtt (basic-write-gtt)
[161.755384] Starting subtest: basic-write-gtt
[162.497100] Subtest basic-write-gtt: SUCCESS (0.741s)
[162.640266] [011/133] (886s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[162.822973] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[162.827252] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[162.974541] [012/133] (886s left) kms_flip (wf_vblank-ts-check)
[163.144496] Starting subtest: wf_vblank-ts-check
[163.151975] Starting dynamic subtest: A-HDMI-A1
[169.230998] Dynamic subtest A-HDMI-A1: SUCCESS (6.083s)
[169.249278] Starting dynamic subtest: B-HDMI-A1
[175.039435] Dynamic subtest B-HDMI-A1: SUCCESS (5.806s)
[175.060289] Starting dynamic subtest: C-HDMI-A1
[180.690584] Dynamic subtest C-HDMI-A1: SUCCESS (5.648s)
[180.709046] Starting dynamic subtest: A-HDMI-A2
[186.355576] Dynamic subtest A-HDMI-A2: SUCCESS (5.663s)
[186.377369] Starting dynamic subtest: B-HDMI-A2
[192.001547] Dynamic subtest B-HDMI-A2: SUCCESS (5.642s)
[192.019624] Starting dynamic subtest: C-HDMI-A2
[197.648338] Dynamic subtest C-HDMI-A2: SUCCESS (5.645s)
[197.651123] Subtest wf_vblank-ts-check: SUCCESS (34.505s)
[198.106036] [013/133] (851s left) syncobj_timeline (wait-for-submit-delayed-submit)
[198.209358] Starting subtest: wait-for-submit-delayed-submit
[198.313320] Subtest wait-for-submit-delayed-submit: SUCCESS (0.105s)
[198.454290] [014/133] (851s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[198.624107] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[198.628092] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[199.385105] [015/133] (850s left) gem_exec_whisper (basic-normal)
[199.519865] Starting subtest: basic-normal
[204.947115] Subtest basic-normal: SUCCESS (5.428s)
[205.184668] [016/133] (844s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[205.379199] Starting subtest: x-tiled-32bpp-rotate-180
[208.941423] Subtest x-tiled-32bpp-rotate-180: SUCCESS (3.558s)
[209.320071] [017/133] (840s left) sriov_basic (enable-vfs-bind-unbind-each)
[209.419808] Subtest enable-vfs-bind-unbind-each: SKIP (0.000s)
[209.509420] [018/133] (840s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[209.682091] Starting subtest: cursorA-vs-flipB-varying-size
[221.006128] Subtest cursorA-vs-flipB-varying-size: SUCCESS (11.321s)
[221.289572] [019/133] (828s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[221.402520] Starting subtest: etime-single-wait-for-submit-submitted
[221.506736] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.104s)
[221.634754] [020/133] (828s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[222.376812] Starting subtest: syncobj-timeline-invalid-flags
[222.379346] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.001s)
[222.642636] [FACT gem_exec_fence (syncobj-timeline-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[222.649734] [021/133] (827s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[222.836111] Starting subtest: yf-tiled-16bpp-rotate-180
[225.923219] Subtest yf-tiled-16bpp-rotate-180: SUCCESS (3.085s)
[226.247897] [022/133] (824s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[226.435010] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[226.439112] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[226.581397] [023/133] (823s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[226.755349] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[226.757777] Starting dynamic subtest: pipe-A-HDMI-A-1
[226.765319] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[226.789222] Starting dynamic subtest: pipe-A-HDMI-A-2
[226.804070] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[226.824976] Starting dynamic subtest: pipe-B-HDMI-A-1
[226.832483] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[226.853670] Starting dynamic subtest: pipe-B-HDMI-A-2
[226.860811] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[226.881748] Starting dynamic subtest: pipe-C-HDMI-A-1
[226.888986] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[226.909412] Starting dynamic subtest: pipe-C-HDMI-A-2
[226.917799] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[226.921755] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.028s)
[227.671376] [024/133] (822s left) kms_chamelium_audio (hdmi-audio-edid)
[228.213976] Subtest hdmi-audio-edid: SKIP (0.000s)
[228.461563] [025/133] (822s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[231.094845] Starting subtest: verify-pxp-key-change-after-suspend-resume
[231.099634] Subtest verify-pxp-key-change-after-suspend-resume: SKIP (0.000s)
[231.226900] [026/133] (819s left) api_intel_bb (object-noreloc-keep-cache-simple)
[231.329696] Starting subtest: object-noreloc-keep-cache-simple
[231.334470] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.007s)
[231.511483] [027/133] (819s left) gem_exec_schedule (pi-userfault)
[231.769170] Starting subtest: pi-userfault
[231.771111] Starting dynamic subtest: rcs0
[231.780474] Dynamic subtest rcs0: SUCCESS (0.013s)
[231.807198] Starting dynamic subtest: bcs0
[231.809207] Dynamic subtest bcs0: SUCCESS (0.011s)
[231.832489] Starting dynamic subtest: vcs0
[231.835470] Dynamic subtest vcs0: SUCCESS (0.008s)
[231.857639] Starting dynamic subtest: vecs0
[231.860453] Dynamic subtest vecs0: SUCCESS (0.008s)
[231.863592] Subtest pi-userfault: SUCCESS (0.050s)
[232.111886] [028/133] (818s left) kms_flip (nonblocking-read)
[232.285151] Starting subtest: nonblocking-read
[232.286948] Subtest nonblocking-read: SUCCESS (0.000s)
[232.446623] [029/133] (818s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[232.634857] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[232.638837] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[232.798213] [030/133] (818s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[232.985897] Starting subtest: fbc-rgb565-draw-mmap-cpu
[235.688562] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (2.702s)
[235.979128] [031/133] (815s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[236.169660] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[236.173290] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[236.313475] [032/133] (814s left) kms_vrr (flip-suspend)
[236.488958] Starting subtest: flip-suspend
[236.496701] Subtest flip-suspend: SKIP (0.000s)
[236.630667] [033/133] (814s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[236.818963] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[236.822785] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[236.979160] [034/133] (814s left) i915_pm_freq_api (freq-reset)
[237.086819] Subtest freq-reset: SKIP (0.000s)
[237.187196] [035/133] (814s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[237.373709] Starting subtest: fbcpsr-rgb565-draw-render
[237.378144] Subtest fbcpsr-rgb565-draw-render: SKIP (0.000s)
[237.530697] [036/133] (814s left) gem_wait (busy)
[237.665333] Starting subtest: busy
[237.667305] Starting dynamic subtest: all-engines
[238.189060] Dynamic subtest all-engines: SUCCESS (0.524s)
[238.218255] Starting dynamic subtest: rcs0
[238.714424] Dynamic subtest rcs0: SUCCESS (0.522s)
[238.740170] Starting dynamic subtest: bcs0
[239.239740] Dynamic subtest bcs0: SUCCESS (0.522s)
[239.265413] Starting dynamic subtest: vcs0
[239.762648] Dynamic subtest vcs0: SUCCESS (0.520s)
[239.784505] Starting dynamic subtest: vecs0
[240.281989] Dynamic subtest vecs0: SUCCESS (0.517s)
[240.284444] Subtest busy: SUCCESS (2.619s)
[240.564262] [037/133] (811s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[240.753023] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[240.757082] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[240.914734] [038/133] (810s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[241.102142] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[241.106079] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[241.263280] [039/133] (810s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[241.445468] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[241.556090] [040/133] (810s left) gem_exec_balancer (invalid-balancer)
[241.677252] Starting subtest: invalid-balancer
[245.821619] Subtest invalid-balancer: SUCCESS (4.145s)
[246.079130] [041/133] (806s left) kms_fbcon_fbt (psr)
[246.185058] Starting subtest: psr
[246.189686] Subtest psr: SKIP (0.000s)
[246.414768] [042/133] (805s left) syncobj_wait (invalid-signal-illegal-handle)
[246.517201] Starting subtest: invalid-signal-illegal-handle
[246.519308] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[246.661609] [043/133] (805s left) kms_psr (pr-sprite-plane-onoff)
[246.833892] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[246.939137] [044/133] (805s left) kms_force_connector_basic (force-load-detect)
[247.190638] Starting subtest: force-load-detect
[247.194108] Subtest force-load-detect: SKIP (0.000s)
[247.513226] [045/133] (804s left) gem_create (create-size-update)
[247.616200] Starting subtest: create-size-update
[247.618162] Subtest create-size-update: SUCCESS (0.000s)
[247.899051] [046/133] (804s left) kms_flip (dpms-off-confusion)
[248.072756] Starting subtest: dpms-off-confusion
[248.074737] Starting dynamic subtest: A-HDMI-A1
[253.673140] Dynamic subtest A-HDMI-A1: SUCCESS (5.599s)
[253.698574] Starting dynamic subtest: B-HDMI-A1
[259.039335] Dynamic subtest B-HDMI-A1: SUCCESS (5.363s)
[259.064537] Starting dynamic subtest: C-HDMI-A1
[264.405208] Dynamic subtest C-HDMI-A1: SUCCESS (5.362s)
[264.431257] Starting dynamic subtest: A-HDMI-A2
[269.785767] Dynamic subtest A-HDMI-A2: SUCCESS (5.376s)
[269.811618] Starting dynamic subtest: B-HDMI-A2
[275.153158] Dynamic subtest B-HDMI-A2: SUCCESS (5.362s)
[275.178293] Starting dynamic subtest: C-HDMI-A2
[280.517571] Dynamic subtest C-HDMI-A2: SUCCESS (5.363s)
[280.519963] Subtest dpms-off-confusion: SUCCESS (32.449s)
[281.024286] [047/133] (771s left) kms_hdr (invalid-hdr)
[281.206246] Starting subtest: invalid-hdr
[281.213799] Subtest invalid-hdr: SKIP (0.001s)
[281.341707] [048/133] (771s left) gem_exec_nop (basic-series)
[281.462657] Starting subtest: basic-series
[284.542631] Subtest basic-series: SUCCESS (3.078s)
[284.825349] [049/133] (768s left) gem_mmap_wc (copy)
[284.923544] Starting subtest: copy
[285.138362] Subtest copy: SUCCESS (0.214s)
[285.273856] [050/133] (767s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[285.460287] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[288.348855] Subtest fbc-2p-primscrn-indfb-msflip-blt: SUCCESS (2.888s)
[288.575472] [051/133] (764s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[288.695260] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[288.697236] Starting dynamic subtest: smem
[289.045302] Dynamic subtest smem: SUCCESS (0.347s)
[289.048701] Subtest y-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.349s)
[289.330237] [052/133] (763s left) kms_psr (psr2-sprite-plane-move)
[289.507951] Subtest psr2-sprite-plane-move: SKIP (0.000s)
[289.619225] [053/133] (763s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[289.791111] Starting subtest: compare-crc-sanitycheck-nv12
[289.793298] Starting dynamic subtest: pipe-A-HDMI-A-1
[290.715086] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.922s)
[290.741036] Starting dynamic subtest: pipe-B-HDMI-A-2
[291.346105] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.625s)
[291.371937] Starting dynamic subtest: pipe-C-HDMI-A-1
[291.986177] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.635s)
[291.988143] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.198s)
[292.283191] [054/133] (761s left) kms_rotation_crc (exhaust-fences)
[292.461234] Starting subtest: exhaust-fences
[294.887205] Subtest exhaust-fences: SUCCESS (2.430s)
[295.131559] [055/133] (758s left) gem_gpgpu_fill (offset-16x16)
[295.237999] Starting subtest: offset-16x16
[295.250104] Subtest offset-16x16: SUCCESS (0.010s)
[295.461580] [056/133] (758s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[295.652372] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[295.656351] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[295.816300] [057/133] (757s left) kms_chamelium_hpd (common-hpd-after-suspend)
[296.356869] Subtest common-hpd-after-suspend: SKIP (0.000s)
[296.612510] [058/133] (757s left) kms_cursor_crc (cursor-offscreen-32x10)
[296.790665] Starting subtest: cursor-offscreen-32x10
[296.943077] Subtest cursor-offscreen-32x10: SKIP (0.148s)
[297.115878] [059/133] (756s left) gem_workarounds (suspend-resume-context)
[297.245366] Starting subtest: suspend-resume-context