[87.483654] Initializing watchdogs
[87.483875]   /dev/watchdog0
[87.522100] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3184 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 605]
[87.536265] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[87.542491] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[87.548672] [001/133] (960s left) sw_sync (sync_busy)
[87.658351] Starting subtest: sync_busy
[87.666319] Subtest sync_busy: SUCCESS (0.010s)
[87.774433] [002/133] (960s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[87.972023] Starting subtest: y-tiled-32bpp-rotate-270
[93.045516] Subtest y-tiled-32bpp-rotate-270: SUCCESS (5.073s)
[93.551651] [003/133] (954s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[93.668273] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[93.669296] Starting dynamic subtest: smem
[94.027192] Dynamic subtest smem: SUCCESS (0.355s)
[94.028419] Subtest mixed-tiled-to-yf-tiled-ccs: SUCCESS (0.356s)
[94.252362] [004/133] (954s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[94.419611] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[94.420610] Starting dynamic subtest: pipe-A-HDMI-A-1
[94.430313] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[94.445798] Starting dynamic subtest: pipe-A-HDMI-A-2
[94.454941] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[94.470955] Starting dynamic subtest: pipe-B-HDMI-A-1
[94.479749] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[94.495840] Starting dynamic subtest: pipe-B-HDMI-A-2
[94.505077] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[94.521963] Starting dynamic subtest: pipe-C-HDMI-A-1
[94.530853] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[94.545172] Starting dynamic subtest: pipe-C-HDMI-A-2
[94.553118] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[94.554733] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.016s)
[95.292144] [005/133] (953s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[95.473854] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[95.475898] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[95.608232] [006/133] (952s left) gem_sync (basic-each)
[95.729730] Starting subtest: basic-each
[98.005215] Subtest basic-each: SUCCESS (2.275s)
[98.244108] [007/133] (950s left) gem_workarounds (suspend-resume)
[98.367181] Starting subtest: suspend-resume
[117.985297] Subtest suspend-resume: SUCCESS (1.751s)
[124.071096] [008/133] (930s left) kms_psr (psr2-primary-blt)
[124.251730] Subtest psr2-primary-blt: SKIP (0.000s)
[124.347534] [009/133] (930s left) gem_exec_create (basic)
[124.461770] Starting subtest: basic
[124.462929] Starting dynamic subtest: smem
[126.525693] Dynamic subtest smem: SUCCESS (2.026s)
[126.526794] Subtest basic: SUCCESS (2.027s)
[126.772907] [010/133] (927s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[126.878246] Starting subtest: invalid-bsd2-flag-on-blt
[126.879406] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.001s)
[127.027029] [011/133] (927s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[127.210842] Starting subtest: psr-rgb101010-draw-mmap-cpu
[127.212773] Subtest psr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[127.364542] [012/133] (927s left) kms_pm_rpm (modeset-lpsp-stress)
[129.245648] Starting subtest: modeset-lpsp-stress
[129.444991] Subtest modeset-lpsp-stress: SKIP (0.196s)
[129.784575] [013/133] (925s left) sw_sync (sync_merge)
[129.878185] Starting subtest: sync_merge
[129.879131] Subtest sync_merge: SUCCESS (0.001s)
[129.988058] [014/133] (925s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[130.159114] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[130.255053] [015/133] (924s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[130.436195] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[133.037070] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (2.578s)
[133.314834] [016/133] (921s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[133.496477] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[133.498352] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[133.632878] [017/133] (921s left) gem_cs_tlb (engines)
[133.735686] Starting subtest: engines
[133.736674] Starting dynamic subtest: rcs0
[135.907918] Dynamic subtest rcs0: SUCCESS (2.160s)
[135.926596] Starting dynamic subtest: bcs0
[138.079262] Dynamic subtest bcs0: SUCCESS (2.161s)
[138.098405] Starting dynamic subtest: vcs0
[140.249933] Dynamic subtest vcs0: SUCCESS (2.159s)
[140.267830] Starting dynamic subtest: vecs0
[142.413385] Dynamic subtest vecs0: SUCCESS (2.160s)
[142.415280] Subtest engines: SUCCESS (8.644s)
[142.569471] [018/133] (912s left) kms_rotation_crc (sprite-rotation-180)
[142.735387] Starting subtest: sprite-rotation-180
[153.856567] Subtest sprite-rotation-180: SUCCESS (11.108s)
[154.097099] [019/133] (901s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[154.266288] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[154.267353] Starting dynamic subtest: pipe-A-HDMI-A-1
[154.275287] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.002s)
[154.294058] Starting dynamic subtest: pipe-A-HDMI-A-2
[154.302143] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s)
[154.320604] Starting dynamic subtest: pipe-B-HDMI-A-1
[154.328917] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s)
[154.348830] Starting dynamic subtest: pipe-B-HDMI-A-2
[154.356325] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s)
[154.374621] Starting dynamic subtest: pipe-C-HDMI-A-1
[154.383328] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[154.401375] Starting dynamic subtest: pipe-C-HDMI-A-2
[154.410608] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[154.411453] Subtest ccs-on-another-bo-yf-tiled-ccs: SUCCESS (0.022s)
[155.137826] [020/133] (900s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[155.234268] Starting subtest: multi-wait-available-submitted-signaled
[155.236867] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.003s)
[155.353881] [021/133] (900s left) syncobj_wait (invalid-reset-illegal-handle)
[155.449754] Starting subtest: invalid-reset-illegal-handle
[155.450763] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[155.571560] [022/133] (900s left) syncobj_basic (bad-fd-to-handle)
[155.667830] Starting subtest: bad-fd-to-handle
[155.668826] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[155.789975] [023/133] (900s left) gem_pwrite (basic-random)
[155.888091] Starting subtest: basic-random
[161.741463] Subtest basic-random: SUCCESS (5.854s)
[161.935112] [024/133] (893s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[162.218020] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[162.222322] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[162.354127] [025/133] (893s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[162.534920] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[162.536725] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[162.671071] [026/133] (893s left) gem_exec_schedule (noreorder-priority)
[162.927514] Starting subtest: noreorder-priority
[162.928546] Starting dynamic subtest: rcs0
[164.055329] Dynamic subtest rcs0: SUCCESS (1.126s)
[164.079627] Starting dynamic subtest: bcs0
[165.189549] Dynamic subtest bcs0: SUCCESS (1.132s)
[165.214977] Starting dynamic subtest: vcs0
[166.321467] Dynamic subtest vcs0: SUCCESS (1.130s)
[166.345719] Starting dynamic subtest: vecs0
[167.458523] Dynamic subtest vecs0: SUCCESS (1.135s)
[167.459599] Subtest noreorder-priority: SUCCESS (4.531s)
[167.693653] [027/133] (888s left) kms_addfb_basic (bad-pitch-1024)
[167.788242] Starting subtest: bad-pitch-1024
[167.789204] Subtest bad-pitch-1024: SUCCESS (0.000s)
[168.006025] [028/133] (888s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[168.173262] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[179.606004] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.421s)
[179.914473] [029/133] (876s left) kms_joiner (invalid-modeset-ultra-joiner)
[180.107090] Starting subtest: invalid-modeset-ultra-joiner
[180.110434] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[180.234792] [030/133] (876s left) vgem_basic (mmap)
[180.411645] Starting subtest: mmap
[180.427784] Subtest mmap: SUCCESS (0.020s)
[180.538978] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[180.543906] [031/133] (875s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[180.710893] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[180.714309] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[180.843981] [032/133] (875s left) kms_chamelium_color (ctm-0-75)
[181.015396] Subtest ctm-0-75: SKIP (0.000s)
[181.118789] [033/133] (875s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[181.286107] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[181.287018] Starting dynamic subtest: pipe-A
[184.865488] Dynamic subtest pipe-A: SKIP (3.578s)
[184.886884] Starting dynamic subtest: pipe-B
[188.570915] Dynamic subtest pipe-B: SKIP (3.701s)
[188.593031] Starting dynamic subtest: pipe-C
[192.320334] Dynamic subtest pipe-C: SKIP (3.745s)
[192.322224] Subtest plane-scaler-with-clipping-clamping-rotation: SKIP (11.033s)
[192.799876] [034/133] (863s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[193.031407] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[195.593190] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.561s)
[195.817203] [035/133] (860s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[195.991667] Starting subtest: plane-lut1d-post-ctm3x4
[197.437569] Subtest plane-lut1d-post-ctm3x4: SKIP (1.442s)
[197.701374] [036/133] (859s left) kms_properties (plane-properties-legacy)
[197.873745] Starting subtest: plane-properties-legacy
[197.875762] Starting dynamic subtest: pipe-A-HDMI-A-1
[198.594814] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.710s)
[198.614963] Starting dynamic subtest: pipe-B-HDMI-A-2
[199.188979] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.596s)
[199.214360] Starting dynamic subtest: pipe-C-HDMI-A-1
[199.776739] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.578s)
[199.777865] Subtest plane-properties-legacy: SUCCESS (1.899s)
[200.041803] [037/133] (856s left) sysfs_timeslice_duration (duration)
[200.152571] Starting subtest: duration
[200.153760] Starting dynamic subtest: vecs0
[200.245409] Dynamic subtest vecs0: SUCCESS (0.091s)
[200.265134] Starting dynamic subtest: vcs0
[200.329204] Dynamic subtest vcs0: SUCCESS (0.083s)
[200.352088] Starting dynamic subtest: bcs0
[200.426183] Dynamic subtest bcs0: SUCCESS (0.094s)
[200.452421] Starting dynamic subtest: rcs0
[200.520147] Dynamic subtest rcs0: SUCCESS (0.091s)
[200.523621] Subtest duration: SUCCESS (0.373s)
[200.657954] [038/133] (856s left) gem_exec_gttfill (basic)
[200.779978] Starting subtest: basic
[216.235323] Subtest basic: SUCCESS (15.450s)
[216.485316] [039/133] (840s left) kms_cursor_crc (cursor-onscreen-256x85)
[216.755812] Starting subtest: cursor-onscreen-256x85
[216.794757] Starting dynamic subtest: pipe-A-HDMI-A-1
[219.533018] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.730s)
[219.601765] Starting dynamic subtest: pipe-C-HDMI-A-1
[221.967739] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.384s)
[221.972708] Subtest cursor-onscreen-256x85: SUCCESS (5.210s)
[222.278746] [040/133] (834s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[222.465004] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[222.466984] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[222.607869] [041/133] (834s left) gem_partial_pwrite_pread (writes-after-reads)
[222.717587] Starting subtest: writes-after-reads
[241.333125] Subtest writes-after-reads: SUCCESS (18.620s)
[241.503005] [042/133] (815s left) gem_exec_fence (syncobj-timeline-chain-engines)
[242.184838] Starting subtest: syncobj-timeline-chain-engines
[242.297215] Subtest syncobj-timeline-chain-engines: SUCCESS (0.113s)
[242.569349] [043/133] (814s left) kms_busy (basic-hang)
[242.753873] Starting subtest: basic-hang
[242.755463] Starting dynamic subtest: flip-pipe-A
[243.711166] Dynamic subtest flip-pipe-A: SUCCESS (0.953s)
[243.732334] Starting dynamic subtest: modeset-pipe-A
[244.948949] Dynamic subtest modeset-pipe-A: SUCCESS (1.228s)
[244.973844] Starting dynamic subtest: flip-pipe-C
[245.546157] Dynamic subtest flip-pipe-C: SUCCESS (0.595s)
[245.566913] Starting dynamic subtest: modeset-pipe-C
[246.746753] Dynamic subtest modeset-pipe-C: SUCCESS (1.193s)
[246.755813] Subtest basic-hang: SUCCESS (4.004s)
[247.083409] [044/133] (810s left) syncobj_timeline (host-signal-ordered)
[247.185759] Starting subtest: host-signal-ordered
[247.189229] Subtest host-signal-ordered: SUCCESS (0.002s)
[247.333759] [045/133] (810s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[247.520585] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[250.441684] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SUCCESS (2.920s)
[250.664426] [046/133] (807s left) core_setmaster (master-drop-set-user)
[250.880141] Starting subtest: master-drop-set-user
[250.922122] Subtest master-drop-set-user: SUCCESS (0.042s)
[251.015561] [047/133] (806s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[251.210959] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[252.507800] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (1.298s)
[252.914950] [048/133] (805s left) kms_psr (fbc-psr-basic)
[253.087923] Subtest fbc-psr-basic: SKIP (0.000s)
[253.193280] [049/133] (804s left) kms_content_protection (type1)
[253.393459] Starting subtest: type1
[253.424191] Subtest type1: SKIP (0.026s)
[253.581235] [050/133] (804s left) syncobj_wait (wait-all-complex)
[253.679240] Starting subtest: wait-all-complex
[253.903315] Subtest wait-all-complex: SUCCESS (0.222s)
[254.048768] [051/133] (804s left) gem_gpgpu_fill (basic)
[254.149961] Starting subtest: basic
[254.150843] Starting dynamic subtest: smem
[254.160314] Dynamic subtest smem: SUCCESS (0.011s)
[254.162030] Subtest basic: SUCCESS (0.014s)
[254.324140] [052/133] (804s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[254.513105] Starting subtest: yf-tiled-64bpp-rotate-0
[254.515926] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[254.647261] [053/133] (803s left) gem_ctx_param (invalid-size-get)
[254.743459] Starting subtest: invalid-size-get
[254.744462] Subtest invalid-size-get: SUCCESS (0.000s)
[254.881996] [054/133] (803s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[255.052388] Starting subtest: 2x-long-flip-vs-cursor-legacy
[260.606037] Subtest 2x-long-flip-vs-cursor-legacy: SUCCESS (5.554s)
[260.903383] [055/133] (797s left) perf_pmu (busy-idle-check-all)
[261.010991] Starting subtest: busy-idle-check-all
[261.011925] Starting dynamic subtest: rcs0
[261.657036] Dynamic subtest rcs0: SUCCESS (0.646s)
[261.682705] Starting dynamic subtest: bcs0
[262.295762] Dynamic subtest bcs0: SUCCESS (0.635s)
[262.321593] Starting dynamic subtest: vcs0
[262.932986] Dynamic subtest vcs0: SUCCESS (0.633s)
[262.959253] Starting dynamic subtest: vecs0
[263.565566] Dynamic subtest vecs0: SUCCESS (0.629s)
[263.569990] Subtest busy-idle-check-all: SUCCESS (2.558s)
[263.705914] [056/133] (795s left) gem_spin_batch (spin-all-new)
[263.823817] Starting subtest: spin-all-new
[263.851151] Subtest spin-all-new: SUCCESS (0.027s)
[264.142114] [057/133] (794s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[264.327944] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[264.330063] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[264.487922] [058/133] (794s left) syncobj_timeline (multi-wait-all-available-submitted)
[264.586224] Starting subtest: multi-wait-all-available-submitted
[264.589798] Subtest multi-wait-all-available-submitted: SUCCESS (0.002s)
[264.770161] [059/133] (794s left) sriov_basic (enable-vfs-bind-unbind-each)
[264.866598] Subtest enable-vfs-bind-unbind-each: SKIP (0.000s)
[264.979400] [060/133] (794s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[265.150016] Starting subtest: cursor-tearing-framebuffer-change
[265.154200] Starting dynamic subtest: pipe-A-HDMI-A-1
[265.978431] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.824s)
[266.014000] Starting dynamic subtest: pipe-C-HDMI-A-1
[266.516873] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.535s)
[266.520357] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.370s)
[266.845028] [061/133] (792s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier)
[267.019923] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier
[267.022320] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s)
[267.165198] [062/133] (792s left) syncobj_wait (single-wait-for-submit-submitted)
[267.265049] Starting subtest: single-wait-for-submit-submitted
[267.365644] Subtest single-wait-for-submit-submitted: SUCCESS (0.101s)
[267.517149] [063/133] (791s left) kms_psr (psr-no-drrs)
[267.687345] Subtest psr-no-drrs: SKIP (0.000s)
[267.789215] [064/133] (791s left) gen7_exec_parse (batch-without-end)
[267.892517] Subtest batch-without-end: SKIP (0.000s)
[268.005250] [065/133] (791s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[268.174298] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[268.175369] Starting dynamic subtest: pipe-A
[268.470072] Dynamic subtest pipe-A: SUCCESS (0.297s)
[268.496885] Starting dynamic subtest: pipe-B
[268.828836] Dynamic subtest pipe-B: SUCCESS (0.356s)
[268.857365] Starting dynamic subtest: pipe-C
[268.883171] Dynamic subtest pipe-C: SUCCESS (0.051s)
[268.884166] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (0.712s)
[269.313344] [066/133] (790s left) gem_exec_alignment (single)
[269.426247] Starting subtest: single
[269.432217] Subtest single: SUCCESS (0.009s)
[269.598820] [067/133] (790s left) i915_pm_rpm (system-suspend-execbuf)
[271.475940] Starting subtest: system-suspend-execbuf