[86.529451] Initializing watchdogs
[86.529620]   /dev/watchdog0
[86.568779] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[86.583240] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[86.589815] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[86.597918] [001/130] (960s left) prime_self_import (basic-with_one_bo_two_files)
[86.709446] Starting subtest: basic-with_one_bo_two_files
[86.717739] Subtest basic-with_one_bo_two_files: SUCCESS (0.008s)
[86.894910] [002/130] (960s left) kms_flip (basic-flip-vs-wf_vblank)
[87.076643] Starting subtest: basic-flip-vs-wf_vblank
[87.080178] Starting dynamic subtest: A-HDMI-A1
[88.712895] Dynamic subtest A-HDMI-A1: SUCCESS (1.636s)
[88.730831] Starting dynamic subtest: B-HDMI-A1
[89.859763] Dynamic subtest B-HDMI-A1: SUCCESS (1.147s)
[89.877877] Starting dynamic subtest: C-HDMI-A1
[91.017193] Dynamic subtest C-HDMI-A1: SUCCESS (1.154s)
[91.034966] Starting dynamic subtest: A-HDMI-A2
[92.182995] Dynamic subtest A-HDMI-A2: SUCCESS (1.163s)
[92.201099] Starting dynamic subtest: B-HDMI-A2
[93.342614] Dynamic subtest B-HDMI-A2: SUCCESS (1.158s)
[93.360683] Starting dynamic subtest: C-HDMI-A2
[94.500399] Dynamic subtest C-HDMI-A2: SUCCESS (1.156s)
[94.503790] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.431s)
[95.000928] [003/130] (952s left) gem_pxp (reject-modify-context-protection-off-3)
[97.651634] Starting subtest: reject-modify-context-protection-off-3
[97.658593] Subtest reject-modify-context-protection-off-3: SKIP (0.000s)
[97.813912] [004/130] (949s left) kms_hdr (invalid-metadata-sizes)
[97.992368] Starting subtest: invalid-metadata-sizes
[98.004714] Subtest invalid-metadata-sizes: SKIP (0.001s)
[98.148764] [005/130] (949s left) perf_pmu (init-busy)
[98.257977] Starting subtest: init-busy
[98.263599] Starting dynamic subtest: rcs0
[98.266541] Dynamic subtest rcs0: SUCCESS (0.005s)
[98.285093] Starting dynamic subtest: bcs0
[98.288929] Dynamic subtest bcs0: SUCCESS (0.002s)
[98.313388] Starting dynamic subtest: vcs0
[98.317268] Dynamic subtest vcs0: SUCCESS (0.001s)
[98.335649] Starting dynamic subtest: vecs0
[98.340294] Dynamic subtest vecs0: SUCCESS (0.002s)
[98.356090] Subtest init-busy: SUCCESS (0.016s)
[98.453111] [006/130] (949s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[98.669156] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[98.676232] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.001s)
[98.833754] [007/130] (948s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[99.038343] Starting subtest: yf-tiled-64bpp-rotate-90
[99.045101] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[99.201478] [008/130] (948s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[99.374825] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[99.380311] Starting dynamic subtest: pipe-A-valid-mode
[99.935507] Dynamic subtest pipe-A-valid-mode: SKIP (0.553s)
[99.978210] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SKIP (0.555s)
[100.376540] [009/130] (947s left) gem_exec_gttfill (engines)
[100.520535] Starting subtest: engines
[100.525431] Starting dynamic subtest: rcs0
[128.570089] Dynamic subtest rcs0: SUCCESS (28.050s)
[128.589226] Starting dynamic subtest: bcs0
[158.041860] Dynamic subtest bcs0: SUCCESS (29.472s)
[158.063510] Starting dynamic subtest: vcs0
[185.124058] Dynamic subtest vcs0: SUCCESS (27.079s)
[185.143572] Starting dynamic subtest: vecs0
[212.452949] Dynamic subtest vecs0: SUCCESS (27.327s)
[212.457193] Subtest engines: SUCCESS (111.932s)
[212.753932] [010/130] (835s left) gem_exec_store (dword)
[213.007570] Starting subtest: dword
[213.013577] Starting dynamic subtest: rcs0
[213.026838] Dynamic subtest rcs0: SUCCESS (0.017s)
[213.048463] Starting dynamic subtest: bcs0
[213.060107] Dynamic subtest bcs0: SUCCESS (0.033s)
[213.081845] Starting dynamic subtest: vcs0
[213.086210] Dynamic subtest vcs0: SUCCESS (0.023s)
[213.108415] Starting dynamic subtest: vecs0
[213.112187] Dynamic subtest vecs0: SUCCESS (0.024s)
[213.116476] Subtest dword: SUCCESS (0.101s)
[213.380838] [011/130] (834s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[213.510867] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[213.618901] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.105s)
[213.783129] [012/130] (834s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[213.996849] Starting subtest: fbcpsr-1p-rte
[214.005132] Subtest fbcpsr-1p-rte: SKIP (0.000s)
[214.161696] [013/130] (834s left) gem_ctx_param (set-priority-not-supported)
[214.271385] Starting subtest: set-priority-not-supported
[214.280146] Subtest set-priority-not-supported: SKIP (0.000s)
[214.430216] [014/130] (833s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[214.633620] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[214.640469] Subtest psr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[214.795135] [015/130] (833s left) gen7_exec_parse (load-register-reg)
[214.908188] Subtest load-register-reg: SKIP (0.000s)
[215.009691] [016/130] (833s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[215.201973] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[215.208305] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[215.362986] [017/130] (833s left) kms_frontbuffer_tracking (fbc-stridechange)
[215.557805] Starting subtest: fbc-stridechange
[217.545230] Subtest fbc-stridechange: SUCCESS (1.993s)
[217.847145] [018/130] (830s left) gem_mmap_gtt (basic-wc)
[217.957646] Starting subtest: basic-wc
[218.584042] Subtest basic-wc: SUCCESS (0.631s)
[218.759255] [019/130] (829s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[218.962754] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[220.045263] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.083s)
[220.379896] [020/130] (828s left) gem_exec_capture (userptr)
[220.494928] Starting subtest: userptr
[221.791054] Subtest userptr: SUCCESS (1.295s)
[221.961848] [021/130] (826s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[222.154650] Starting subtest: 4-tiled-8bpp-rotate-180
[222.161514] Subtest 4-tiled-8bpp-rotate-180: SKIP (0.000s)
[222.329121] [022/130] (826s left) kms_cursor_crc (cursor-sliding-32x10)
[222.514217] Starting subtest: cursor-sliding-32x10
[222.662155] Subtest cursor-sliding-32x10: SKIP (0.142s)
[222.832681] [023/130] (826s left) syncobj_timeline (wait-all-interrupted)
[222.940849] Starting subtest: wait-all-interrupted
[223.047429] Subtest wait-all-interrupted: SUCCESS (0.107s)
[223.214725] [024/130] (825s left) kms_tiled_display (basic-test-pattern)
[223.502221] Starting subtest: basic-test-pattern
[225.273873] Subtest basic-test-pattern: FAIL (0.946s)
[225.357791] [025/130] (823s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[225.516182] Starting subtest: fbcpsr-tiling-linear
[225.522598] Subtest fbcpsr-tiling-linear: SKIP (0.000s)
[225.695231] [026/130] (823s left) kms_cursor_edge_walk (64x64-top-bottom)
[225.865528] Starting subtest: 64x64-top-bottom
[225.872729] Starting dynamic subtest: pipe-A-HDMI-A-1
[229.636640] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.809s)
[229.659036] Starting dynamic subtest: pipe-C-HDMI-A-1
[233.047287] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.407s)
[233.095068] Subtest 64x64-top-bottom: SUCCESS (7.224s)
[233.355921] [027/130] (816s left) kms_color (ctm-red-to-blue)
[233.489243] Starting subtest: ctm-red-to-blue
[233.492448] Starting dynamic subtest: pipe-A-HDMI-A-1
[234.438089] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.948s)
[234.462034] Starting dynamic subtest: pipe-A-HDMI-A-2
[235.096798] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.654s)
[235.152778] Starting dynamic subtest: pipe-B-HDMI-A-1
[235.719725] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.622s)
[235.775489] Starting dynamic subtest: pipe-B-HDMI-A-2
[236.386042] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.665s)
[236.426527] Starting dynamic subtest: pipe-C-HDMI-A-1
[237.016551] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.629s)
[237.054304] Starting dynamic subtest: pipe-C-HDMI-A-2
[237.641695] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.623s)
[237.645911] Subtest ctm-red-to-blue: SUCCESS (4.149s)
[237.954417] [028/130] (811s left) i915_drm_fdinfo (virtual-busy)
[238.073752] Starting subtest: virtual-busy
[240.243624] Subtest virtual-busy: SUCCESS (2.172s)
[240.404308] [029/130] (809s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[240.547684] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[240.554542] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[240.722058] [030/130] (808s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[240.860956] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[240.864317] Starting dynamic subtest: pipe-A-HDMI-A-1
[240.899869] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[240.940196] Starting dynamic subtest: pipe-A-HDMI-A-2
[240.977118] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.002s)
[241.017042] Starting dynamic subtest: pipe-B-HDMI-A-1
[241.049935] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[241.070997] Starting dynamic subtest: pipe-B-HDMI-A-2
[241.106839] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.002s)
[241.129901] Starting dynamic subtest: pipe-C-HDMI-A-1
[241.162886] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[241.183515] Starting dynamic subtest: pipe-C-HDMI-A-2
[241.217524] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.004s)
[241.224345] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.034s)
[241.833938] [031/130] (807s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[241.973507] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s)
[242.081183] [032/130] (807s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[242.221916] Starting subtest: primary-x-tiled-reflect-x-180
[242.229042] Subtest primary-x-tiled-reflect-x-180: SKIP (0.003s)
[242.402131] [033/130] (807s left) gem_userptr_blits (sync-unmap-after-close)
[242.538600] Starting subtest: sync-unmap-after-close
[242.580609] Subtest sync-unmap-after-close: SUCCESS (0.043s)
[242.764706] [034/130] (807s left) gem_exec_schedule (smoketest)
[243.017476] Starting subtest: smoketest
[243.020696] Starting dynamic subtest: rcs0
[248.447415] Dynamic subtest rcs0: SUCCESS (5.422s)
[248.468146] Starting dynamic subtest: bcs0
[253.879529] Dynamic subtest bcs0: SUCCESS (5.430s)
[253.900590] Starting dynamic subtest: vcs0
[259.300376] Dynamic subtest vcs0: SUCCESS (5.420s)
[259.321882] Starting dynamic subtest: vecs0
[264.728466] Dynamic subtest vecs0: SUCCESS (5.422s)
[264.732487] Subtest smoketest: SUCCESS (21.702s)
[265.028194] [035/130] (785s left) gem_tiled_swapping (non-threaded)
[286.620057] Starting subtest: non-threaded
[311.079457] Subtest non-threaded: SUCCESS (24.455s)
[315.952614] [036/130] (734s left) kms_plane_lowres (tiling-4)
[316.349377] Starting subtest: tiling-4
[316.357130] Subtest tiling-4: SKIP (0.000s)
[316.523830] [037/130] (734s left) gem_lmem_swapping (parallel-random-engines)
[316.667264] Subtest parallel-random-engines: SKIP (0.000s)
[316.780189] [038/130] (734s left) kms_big_fb (linear-32bpp-rotate-180)
[316.933935] Starting subtest: linear-32bpp-rotate-180
[323.198048] Subtest linear-32bpp-rotate-180: SUCCESS (6.264s)
[323.635203] [039/130] (727s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[323.763790] Starting subtest: crc-primary-suspend-y-tiled-ccs
[323.767141] Starting dynamic subtest: pipe-A-HDMI-A-1
[340.666762] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.543s)
[340.705278] Starting dynamic subtest: pipe-A-HDMI-A-2