[133.663428] Initializing watchdogs
[133.663622]   /dev/watchdog0
[133.703437] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[133.718595] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[133.725556] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[133.731054] [001/132] (960s left) kms_big_fb (y-tiled-addfb-size-overflow)
[133.954466] Starting subtest: y-tiled-addfb-size-overflow
[133.957625] Subtest y-tiled-addfb-size-overflow: SUCCESS (0.002s)
[134.092401] [002/132] (960s left) gem_eio (wait-10ms)
[134.242047] Starting subtest: wait-10ms
[134.354047] Subtest wait-10ms: SUCCESS (0.114s)
[134.589563] [003/132] (959s left) kms_psr (fbc-psr2-cursor-blt)
[134.782045] Subtest fbc-psr2-cursor-blt: SKIP (0.000s)
[134.865594] [004/132] (959s left) i915_query (test-query-geometry-subslices)
[134.969241] Starting subtest: test-query-geometry-subslices
[134.970965] Subtest test-query-geometry-subslices: SKIP (0.000s)
[135.095385] [005/132] (959s left) kms_dp_link_training (uhbr-mst)
[135.279696] Starting subtest: uhbr-mst
[135.285233] Subtest uhbr-mst: SKIP (0.000s)
[135.411642] [006/132] (959s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[135.605378] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[135.609212] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[135.744226] [007/132] (958s left) i915_hangman (engine-engine-error)
[135.882807] Starting subtest: engine-engine-error
[135.885051] Starting dynamic subtest: rcs0
[135.964058] Dynamic subtest rcs0: SUCCESS (0.082s)
[135.982295] Starting dynamic subtest: bcs0
[135.985969] Dynamic subtest bcs0: SKIP (0.005s)
[136.010248] Starting dynamic subtest: vcs0
[136.045565] Dynamic subtest vcs0: SUCCESS (0.071s)
[136.063730] Starting dynamic subtest: vecs0
[136.118670] Dynamic subtest vecs0: SUCCESS (0.075s)
[136.120525] Subtest engine-engine-error: SUCCESS (0.238s)
[136.264361] [008/132] (958s left) gem_pwrite_snooped
[136.542890] [009/132] (958s left) kms_lease (setcrtc-implicit-plane)
[136.724104] Starting subtest: setcrtc-implicit-plane
[136.726293] Starting dynamic subtest: pipe-A-HDMI-A-1
[137.515125] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.789s)
[137.547150] Starting dynamic subtest: pipe-A-HDMI-A-2
[137.996039] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.481s)
[138.047541] Starting dynamic subtest: pipe-B-HDMI-A-1
[138.404973] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.409s)
[138.437452] Starting dynamic subtest: pipe-B-HDMI-A-2
[138.905454] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.496s)
[138.937893] Starting dynamic subtest: pipe-C-HDMI-A-1
[139.357281] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.438s)
[139.393927] Starting dynamic subtest: pipe-C-HDMI-A-2
[139.787160] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.420s)
[139.793110] Subtest setcrtc-implicit-plane: SUCCESS (3.066s)
[140.088118] [010/132] (954s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[140.311495] Starting subtest: yf-tiled-64bpp-rotate-0
[140.313252] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[140.436353] [011/132] (954s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[140.620160] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[140.622266] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (0.000s)
[140.735883] [012/132] (954s left) kms_async_flips (crc)
[140.922192] Starting subtest: crc
[141.534136] Starting dynamic subtest: pipe-A-HDMI-A-1
[143.797135] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.260s)
[144.155310] Starting dynamic subtest: pipe-A-HDMI-A-2
[146.412902] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.274s)
[146.782257] Starting dynamic subtest: pipe-B-HDMI-A-1
[149.068922] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.304s)
[149.418934] Starting dynamic subtest: pipe-B-HDMI-A-2
[151.707074] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.302s)
[152.046913] Starting dynamic subtest: pipe-C-HDMI-A-1
[154.294682] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.266s)
[154.661442] Starting dynamic subtest: pipe-C-HDMI-A-2
[156.852261] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.227s)
[156.853360] Subtest crc: SUCCESS (15.931s)
[157.508146] [013/132] (937s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[157.625325] Starting subtest: writes-after-reads-snoop
[177.919135] Subtest writes-after-reads-snoop: SUCCESS (20.296s)
[178.077772] [014/132] (917s left) gem_exec_schedule (preempt-self)
[178.212878] Starting subtest: preempt-self
[178.214122] Starting dynamic subtest: rcs0
[178.242775] Dynamic subtest rcs0: SUCCESS (0.032s)
[178.268378] Starting dynamic subtest: bcs0
[178.278204] Dynamic subtest bcs0: SUCCESS (0.034s)
[178.303568] Starting dynamic subtest: vcs0
[178.311723] Dynamic subtest vcs0: SUCCESS (0.030s)
[178.332757] Starting dynamic subtest: vecs0
[178.349329] Dynamic subtest vecs0: SUCCESS (0.035s)
[178.351071] Subtest preempt-self: SUCCESS (0.137s)
[178.726478] [015/132] (916s left) kms_psr (fbc-psr-sprite-render)
[178.921090] Subtest fbc-psr-sprite-render: SKIP (0.000s)
[179.016548] [016/132] (916s left) gen9_exec_parse (unaligned-jump)
[179.145305] Starting subtest: unaligned-jump
[179.474184] Subtest unaligned-jump: SUCCESS (0.329s)
[179.728662] [017/132] (915s left) gem_mmap_wc (coherency)
[179.831203] Starting subtest: coherency
[179.914186] Subtest coherency: SUCCESS (0.082s)
[180.085396] [018/132] (915s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[180.291138] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[182.383053] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SUCCESS (2.088s)
[182.591808] [019/132] (913s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[182.799312] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[182.801916] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[182.940342] [020/132] (912s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[183.134081] Starting subtest: cursorB-vs-flipA-varying-size
[194.573434] Subtest cursorB-vs-flipA-varying-size: SUCCESS (11.436s)
[194.941832] [021/132] (900s left) gem_exec_reloc (basic-gtt-wc)
[195.070156] Starting subtest: basic-gtt-wc
[195.090871] Subtest basic-gtt-wc: SUCCESS (0.020s)
[195.312999] [022/132] (900s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[195.510073] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[195.603785] [023/132] (900s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[195.713918] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[195.717060] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.005s)
[195.847803] [024/132] (900s left) gem_close_race (basic-threads)
[195.981155] Starting subtest: basic-threads
[197.155202] Subtest basic-threads: SUCCESS (1.177s)
[197.416173] [025/132] (898s left) core_setmaster (master-drop-set-root)
[197.574869] Starting subtest: master-drop-set-root
[197.601903] Subtest master-drop-set-root: SUCCESS (0.022s)
[197.698259] [026/132] (898s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[197.887097] Starting subtest: primary-4-tiled-reflect-x-180
[197.890079] Subtest primary-4-tiled-reflect-x-180: SKIP (0.003s)
[198.031792] [027/132] (898s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[198.250464] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[198.254313] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[198.380935] [028/132] (898s left) gem_exec_balancer (parallel-contexts)
[198.622846] Subtest parallel-contexts: SKIP (0.000s)
[198.765820] [029/132] (897s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[198.940071] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[199.163648] Starting dynamic subtest: pipe-A-plane-0
[199.882267] Dynamic subtest pipe-A-plane-0: SUCCESS (0.717s)
[199.901408] Starting dynamic subtest: pipe-A-plane-1
[200.548132] Dynamic subtest pipe-A-plane-1: SUCCESS (0.663s)
[200.566483] Starting dynamic subtest: pipe-A-plane-2
[201.030527] Dynamic subtest pipe-A-plane-2: SUCCESS (0.482s)
[201.049735] Starting dynamic subtest: pipe-A-plane-3
[201.546503] Dynamic subtest pipe-A-plane-3: SUCCESS (0.514s)
[201.934570] Starting dynamic subtest: pipe-B-plane-0
[202.566189] Dynamic subtest pipe-B-plane-0: SUCCESS (0.649s)
[202.585363] Starting dynamic subtest: pipe-B-plane-1
[203.234651] Dynamic subtest pipe-B-plane-1: SUCCESS (0.664s)
[203.253536] Starting dynamic subtest: pipe-B-plane-2
[203.717956] Dynamic subtest pipe-B-plane-2: SUCCESS (0.482s)
[203.736727] Starting dynamic subtest: pipe-B-plane-3
[204.233139] Dynamic subtest pipe-B-plane-3: SUCCESS (0.514s)
[204.454461] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (5.512s)
[204.788782] [030/132] (891s left) kms_plane_cursor (primary)
[204.992118] Starting subtest: primary
[204.998258] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[207.636477] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.645s)
[207.713925] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[210.119583] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.431s)
[210.197340] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[212.620473] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.448s)
[212.960487] Starting dynamic subtest: pipe-B-HDMI-A-2-size-64
[215.412656] Dynamic subtest pipe-B-HDMI-A-2-size-64: SUCCESS (2.499s)
[215.468305] Starting dynamic subtest: pipe-B-HDMI-A-2-size-128
[217.880032] Dynamic subtest pipe-B-HDMI-A-2-size-128: SUCCESS (2.432s)
[217.933920] Starting dynamic subtest: pipe-B-HDMI-A-2-size-256
[220.345758] Dynamic subtest pipe-B-HDMI-A-2-size-256: SUCCESS (2.432s)
[220.642580] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64
[223.099106] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (2.504s)
[223.151569] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128
[225.564024] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (2.432s)
[225.615926] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256
[228.030854] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (2.434s)
[228.279966] Subtest primary: SUCCESS (23.291s)
[228.565339] [031/132] (868s left) syncobj_wait (reset-during-wait-for-submit)
[228.683255] Starting subtest: reset-during-wait-for-submit
[228.786035] Subtest reset-during-wait-for-submit: SUCCESS (0.105s)
[228.944400] [032/132] (867s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[229.150945] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[229.153771] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[229.297168] [033/132] (867s left) kms_chamelium_hpd (common-hpd-after-suspend)
[229.863416] Subtest common-hpd-after-suspend: SKIP (0.000s)
[230.146251] [034/132] (866s left) gem_madvise (dontneed-before-exec)
[230.252295] Starting subtest: dontneed-before-exec
[230.265744] Subtest dontneed-before-exec: SUCCESS (0.013s)
[230.408499] [035/132] (866s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[230.509605] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[230.511720] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.002s)
[230.644169] [036/132] (866s left) gem_mmap_offset (oob-read)
[230.742115] Starting subtest: oob-read
[230.746182] Subtest oob-read: SUCCESS (0.002s)
[230.879780] [037/132] (866s left) tools_test (sysfs_l3_parity)
[230.980436] Starting subtest: sysfs_l3_parity
[231.125142] Subtest sysfs_l3_parity: SKIP (0.144s)
[231.245232] [038/132] (865s left) kms_feature_discovery (psr2)
[231.440336] Starting subtest: psr2
[231.444067] Subtest psr2: SKIP (0.001s)
[231.606084] [039/132] (865s left) gem_lmem_swapping (massive-random)
[231.718236] Subtest massive-random: SKIP (0.000s)
[231.819836] [040/132] (865s left) kms_addfb_basic (unused-offsets)
[231.929107] Starting subtest: unused-offsets
[231.930549] Subtest unused-offsets: SUCCESS (0.000s)
[232.145869] [041/132] (865s left) gem_pxp (create-regular-buffer)
[234.796924] Starting subtest: create-regular-buffer
[234.799327] Subtest create-regular-buffer: SKIP (0.000s)
[234.929884] [042/132] (862s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[235.142346] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[237.844594] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SUCCESS (2.704s)
[238.047582] [043/132] (859s left) gen9_exec_parse (cmd-crossing-page)
[238.173720] Starting subtest: cmd-crossing-page
[238.178357] Subtest cmd-crossing-page: SUCCESS (0.007s)
[238.447367] [044/132] (859s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[238.640057] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[238.643102] Starting dynamic subtest: pipe-A-HDMI-A-1
[238.713147] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.013s)
[238.750814] Starting dynamic subtest: pipe-A-HDMI-A-2
[238.869368] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.013s)
[238.905343] Starting dynamic subtest: pipe-B-HDMI-A-1
[238.961609] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.014s)
[238.981081] Starting dynamic subtest: pipe-B-HDMI-A-2
[239.014877] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.015s)
[239.033689] Starting dynamic subtest: pipe-C-HDMI-A-1
[239.066174] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.024s)
[239.084733] Starting dynamic subtest: pipe-C-HDMI-A-2
[239.120457] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.015s)
[239.122053] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.132s)
[239.814950] [045/132] (857s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[239.995302] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[239.998087] Starting dynamic subtest: pipe-A-HDMI-A-1
[240.015102] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[240.057761] Starting dynamic subtest: pipe-A-HDMI-A-2
[240.101607] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.003s)
[240.143819] Starting dynamic subtest: pipe-B-HDMI-A-1
[240.155900] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.003s)
[240.174729] Starting dynamic subtest: pipe-B-HDMI-A-2
[240.182664] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.002s)
[240.200895] Starting dynamic subtest: pipe-C-HDMI-A-1
[240.210928] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[240.230136] Starting dynamic subtest: pipe-C-HDMI-A-2
[240.237799] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[240.239501] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.042s)
[241.091550] [046/132] (856s left) api_intel_allocator (fork-simple-once)
[241.200160] Starting subtest: fork-simple-once
[241.233877] Subtest fork-simple-once: SUCCESS (0.036s)
[241.404145] [047/132] (856s left) kms_big_fb (linear-32bpp-rotate-270)
[241.600729] Starting subtest: linear-32bpp-rotate-270
[241.975109] Subtest linear-32bpp-rotate-270: SKIP (0.370s)
[242.208109] [048/132] (855s left) kms_content_protection (content-type-change)
[242.428101] Starting subtest: content-type-change
[242.456242] Subtest content-type-change: SKIP (0.022s)
[242.590603] [049/132] (855s left) i915_query (query-topology-unsupported)
[242.699906] Starting subtest: query-topology-unsupported
[242.704126] Subtest query-topology-unsupported: SKIP (0.000s)
[242.843272] [050/132] (855s left) gem_fenced_exec_thrash (2-spare-fences)
[242.957055] Starting subtest: 2-spare-fences
[245.124565] Subtest 2-spare-fences: SUCCESS (2.163s)
[245.302909] [051/132] (852s left) gem_ringfill (basic-all)
[245.765182] Starting subtest: basic-all
[246.964884] Subtest basic-all: SUCCESS (1.204s)
[247.131214] [FACT gem_ringfill (basic-all)] new: kernel.kmod_is_loaded.vgem: true
[247.135571] [052/132] (851s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[247.333363] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[247.336709] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.001s)
[247.485037] [053/132] (850s left) syncobj_wait (single-wait-all-submitted)
[247.592664] Starting subtest: single-wait-all-submitted
[247.697289] Subtest single-wait-all-submitted: SUCCESS (0.103s)
[247.863493] [054/132] (850s left) gem_exec_balancer (hang)
[248.109136] Starting subtest: hang
[252.366812] Subtest hang: SUCCESS (4.256s)
[252.519046] [055/132] (846s left) gem_vm_create (invalid-destroy)
[252.642300] Starting subtest: invalid-destroy
[252.643740] Subtest invalid-destroy: SUCCESS (0.001s)
[252.803641] [056/132] (845s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[252.996629] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[252.999057] Starting dynamic subtest: pipe-A
[253.374906] Dynamic subtest pipe-A: SUCCESS (0.380s)
[253.417204] Starting dynamic subtest: pipe-B
[253.825104] Dynamic subtest pipe-B: SUCCESS (0.443s)
[253.851830] Starting dynamic subtest: pipe-C
[253.908691] Dynamic subtest pipe-C: SUCCESS (0.076s)
[253.911088] Subtest planes-downscale-factor-0-5-unity-scaling: SUCCESS (0.914s)
[254.427149] [057/132] (844s left) kms_frontbuffer_tracking (fbc-suspend)
[254.635231] Starting subtest: fbc-suspend