[90.658557] Initializing watchdogs
[90.658775]   /dev/watchdog0
[90.698345] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[90.713683] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[90.720983] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[90.726949] [001/133] (960s left) gen9_exec_parse (unaligned-jump)
[90.871546] Starting subtest: unaligned-jump
[91.189539] Subtest unaligned-jump: SUCCESS (0.320s)
[91.463556] [002/133] (959s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[91.657894] Starting subtest: stress-xrgb8888-yftiled
[101.532102] Subtest stress-xrgb8888-yftiled: SUCCESS (9.868s)
[102.080978] [003/133] (949s left) kms_psr (psr-cursor-plane-move)
[102.276102] Subtest psr-cursor-plane-move: SKIP (0.000s)
[102.378870] [004/133] (949s left) gem_lmem_swapping (heavy-verify-random)
[102.496131] Subtest heavy-verify-random: SKIP (0.000s)
[102.599487] [005/133] (948s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[102.795096] Starting subtest: fbc-rgb565-draw-mmap-wc
[105.580963] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (2.782s)
[105.858459] [006/133] (945s left) syncobj_wait (wait-for-submit-snapshot)
[105.963774] Starting subtest: wait-for-submit-snapshot
[106.052802] Subtest wait-for-submit-snapshot: SUCCESS (0.088s)
[106.180124] [007/133] (945s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[106.372064] Starting subtest: modeset-transition-nonblocking-fencing
[106.376063] Starting dynamic subtest: 1x-outputs
[109.889439] Dynamic subtest 1x-outputs: SUCCESS (3.519s)
[109.908556] Starting dynamic subtest: 2x-outputs
[117.240846] Dynamic subtest 2x-outputs: SUCCESS (7.350s)
[117.242717] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.870s)
[117.525117] [008/133] (934s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[117.735206] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[117.740855] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.001s)
[117.873115] [009/133] (934s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[118.064340] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[118.069158] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[118.208126] [010/133] (933s left) gem_softpin (noreloc)
[118.337199] Starting subtest: noreloc
[123.868110] Subtest noreloc: SUCCESS (5.523s)
[124.010558] [011/133] (928s left) kms_chamelium_audio (hdmi-audio)
[124.597702] Subtest hdmi-audio: SKIP (0.000s)
[124.942791] [012/133] (927s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[125.139034] Starting subtest: psr-1p-primscrn-spr-indfb-move
[125.142099] Subtest psr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[125.278034] [013/133] (926s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[125.485079] Starting subtest: y-tiled-8bpp-rotate-180
[128.830089] Subtest y-tiled-8bpp-rotate-180: SUCCESS (3.340s)
[129.093843] [014/133] (923s left) kms_pwrite_crc
[130.477833] [015/133] (921s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[130.590094] Starting subtest: invalid-multi-wait-unsubmitted
[130.593338] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.001s)
[130.759394] [016/133] (921s left) gem_exec_params (cliprects-invalid)
[130.875113] Starting subtest: cliprects-invalid
[130.877053] Subtest cliprects-invalid: SUCCESS (0.001s)
[131.011903] [017/133] (921s left) sw_sync (timeline_closed)
[131.108081] Starting subtest: timeline_closed
[131.109809] Subtest timeline_closed: SUCCESS (0.000s)
[131.247587] [018/133] (921s left) gem_ctx_sseu (engines)
[131.361161] Subtest engines: SKIP (0.000s)
[131.451263] [019/133] (921s left) kms_chamelium_color (gamma)
[131.640213] Subtest gamma: SKIP (0.000s)
[131.734146] [020/133] (921s left) gem_exec_schedule (thriceslice)
[131.873116] Starting subtest: thriceslice
[131.875911] Starting dynamic subtest: rcs0
[131.886874] Dynamic subtest rcs0: SUCCESS (0.015s)
[131.914793] Starting dynamic subtest: bcs0
[131.916447] Dynamic subtest bcs0: SUCCESS (0.024s)
[131.939634] Starting dynamic subtest: vcs0
[131.941216] Dynamic subtest vcs0: SUCCESS (0.017s)
[131.960918] Starting dynamic subtest: vecs0
[131.963242] Dynamic subtest vecs0: SUCCESS (0.022s)
[131.965360] Subtest thriceslice: SUCCESS (0.081s)
[132.364912] [021/133] (920s left) kms_addfb_basic (size-max)
[132.552577] Starting subtest: size-max
[132.554195] Subtest size-max: SUCCESS (0.000s)
[132.722949] [022/133] (920s left) perf (global-sseu-config-invalid)
[132.923251] Starting subtest: global-sseu-config-invalid
[132.926123] Starting dynamic subtest: 0-rcs0
[132.952652] Dynamic subtest 0-rcs0: SUCCESS (0.031s)
[132.955668] Subtest global-sseu-config-invalid: SUCCESS (0.031s)
[133.057955] [023/133] (920s left) gem_exec_create (madvise)
[133.202099] Starting subtest: madvise
[133.205058] Starting dynamic subtest: smem
[153.341242] Dynamic subtest smem: SUCCESS (20.133s)
[153.346059] Subtest madvise: SUCCESS (20.134s)
[154.747795] [024/133] (898s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[154.931071] Starting subtest: cursorB-vs-flipB-atomic
[166.268269] Subtest cursorB-vs-flipB-atomic: SUCCESS (11.335s)
[166.553314] [025/133] (886s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[166.754365] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[166.759061] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[166.887969] [026/133] (886s left) gem_exec_params (cliprects_ptr-dirt)
[166.999584] Starting subtest: cliprects_ptr-dirt
[167.002513] Subtest cliprects_ptr-dirt: SUCCESS (0.001s)
[167.136909] [027/133] (886s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[167.328928] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[167.333064] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[167.470981] [028/133] (886s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[167.655689] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[167.744897] [029/133] (885s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[167.930224] Starting subtest: primary-yf-tiled-reflect-x-270
[167.934626] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.005s)
[168.072158] [030/133] (885s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[168.267580] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[168.273434] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[168.404649] [031/133] (885s left) gen7_exec_parse (bitmasks)
[168.521414] Subtest bitmasks: SKIP (0.000s)
[168.626153] [032/133] (885s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[168.810922] Starting subtest: addfb25-x-tiled-mismatch-legacy
[168.812692] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[168.953989] [033/133] (885s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[169.064830] Starting subtest: etime-multi-wait-all-submitted-signaled
[169.174670] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.108s)
[169.305520] [034/133] (884s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[169.505768] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[169.510261] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[169.685592] [035/133] (884s left) gem_exec_reloc (basic-write-cpu-active)
[169.798302] Starting subtest: basic-write-cpu-active
[169.935803] Subtest basic-write-cpu-active: SUCCESS (0.137s)
[170.154955] [036/133] (884s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[172.804243] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[172.808872] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SKIP (0.000s)
[172.939031] [037/133] (881s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[173.124294] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[173.127354] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[173.254833] [038/133] (881s left) syncobj_wait (reset-during-wait-for-submit)
[173.361095] Starting subtest: reset-during-wait-for-submit
[173.469655] Subtest reset-during-wait-for-submit: SUCCESS (0.106s)
[173.625957] [039/133] (880s left) kms_plane_scaling (planes-upscale-20x20)
[173.800980] Starting subtest: planes-upscale-20x20
[173.804622] Starting dynamic subtest: pipe-A
[174.152777] Dynamic subtest pipe-A: SUCCESS (0.351s)
[174.191558] Starting dynamic subtest: pipe-B
[174.598897] Dynamic subtest pipe-B: SUCCESS (0.444s)
[174.620057] Starting dynamic subtest: pipe-C
[174.661743] Dynamic subtest pipe-C: SUCCESS (0.063s)
[174.664080] Subtest planes-upscale-20x20: SUCCESS (0.862s)
[175.150124] [040/133] (879s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[175.263751] Starting subtest: no-spare-fences-interruptible
[177.447395] Subtest no-spare-fences-interruptible: SUCCESS (2.169s)
[177.609444] [041/133] (877s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[177.899193] Starting subtest: basic-test-pattern-with-chamelium
[177.904783] Subtest basic-test-pattern-with-chamelium: SKIP (0.001s)
[178.029930] [042/133] (876s left) kms_pm_dc (dc3co-vpb-simulation)
[179.173865] Starting subtest: dc3co-vpb-simulation
[179.178207] Subtest dc3co-vpb-simulation: SKIP (0.000s)
[179.313997] [043/133] (875s left) kms_pipe_crc_basic (bad-source)
[179.453340] Starting subtest: bad-source
[179.456276] Subtest bad-source: SUCCESS (0.001s)
[179.582991] [044/133] (875s left) gem_exec_params (rel-constants-invalid-ring)
[179.691275] Starting subtest: rel-constants-invalid-ring
[179.693294] Subtest rel-constants-invalid-ring: SUCCESS (0.001s)
[179.832169] [045/133] (875s left) gem_exec_balancer (hang)
[180.071583] Starting subtest: hang
[184.286924] Subtest hang: SUCCESS (4.217s)
[184.464426] [046/133] (870s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[185.196130] Starting subtest: syncobj-timeline-multiple-ext-nodes
[185.201954] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s)
[185.469877] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[185.475196] [047/133] (869s left) kms_plane_multiple (2x-tiling-4)
[185.617268] Starting subtest: 2x-tiling-4
[185.620826] Subtest 2x-tiling-4: SKIP (0.000s)
[185.757635] [048/133] (869s left) gem_gtt_cpu_tlb
[186.025393] [049/133] (869s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[186.158137] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[186.161100] Starting dynamic subtest: pipe-A-HDMI-A-1
[186.275257] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.012s)
[186.316527] Starting dynamic subtest: pipe-A-HDMI-A-2
[186.405862] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.012s)
[186.425230] Starting dynamic subtest: pipe-B-HDMI-A-1
[186.489807] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.012s)
[186.508216] Starting dynamic subtest: pipe-B-HDMI-A-2
[186.574884] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.012s)
[186.593643] Starting dynamic subtest: pipe-C-HDMI-A-1
[186.661178] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.012s)
[186.682573] Starting dynamic subtest: pipe-C-HDMI-A-2
[186.805205] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.012s)
[186.811314] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.090s)
[187.223058] [050/133] (868s left) kms_getfb (getfb2-handle-not-fb)
[187.366591] Starting subtest: getfb2-handle-not-fb
[187.368279] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[187.525341] [051/133] (868s left) kms_feature_discovery (psr1)
[187.660123] Starting subtest: psr1
[187.663252] Subtest psr1: SKIP (0.000s)
[187.805700] [052/133] (867s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[187.947253] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[188.066197] [053/133] (867s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[188.235471] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[191.212218] Subtest fbc-2p-primscrn-cur-indfb-move: SUCCESS (2.973s)
[191.437443] [054/133] (864s left) perf (short-reads)
[191.635168] Starting subtest: short-reads
[191.665142] Subtest short-reads: SUCCESS (0.029s)
[191.771967] [055/133] (864s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[191.898513] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[191.901648] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[192.051297] [056/133] (864s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[192.191859] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s)
[192.296836] [057/133] (863s left) kms_cursor_crc (cursor-onscreen-256x85)
[192.463083] Starting subtest: cursor-onscreen-256x85
[192.528145] Starting dynamic subtest: pipe-A-HDMI-A-1
[195.233124] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.703s)
[195.363402] Starting dynamic subtest: pipe-C-HDMI-A-1
[197.765197] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.444s)
[197.767248] Subtest cursor-onscreen-256x85: SUCCESS (5.302s)
[198.114807] [058/133] (858s left) kms_psr (fbc-psr-cursor-plane-onoff)
[198.260855] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[198.369647] [059/133] (857s left) sysfs_heartbeat_interval (mixed)
[198.491171] Starting subtest: mixed
[198.496069] Starting dynamic subtest: vecs0
[203.755150] Dynamic subtest vecs0: SUCCESS (5.261s)
[203.776076] Starting dynamic subtest: vcs0
[208.998262] Dynamic subtest vcs0: SUCCESS (5.241s)
[209.018855] Starting dynamic subtest: bcs0
[214.277471] Dynamic subtest bcs0: SUCCESS (5.279s)
[214.299673] Starting dynamic subtest: rcs0
[219.548279] Dynamic subtest rcs0: SUCCESS (5.265s)
[219.550527] Subtest mixed: SUCCESS (21.058s)
[219.700580] [060/133] (836s left) kms_color (ctm-0-75)
[219.826939] Starting subtest: ctm-0-75
[219.828664] Starting dynamic subtest: pipe-A-HDMI-A-1
[222.667160] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.834s)
[222.690259] Starting dynamic subtest: pipe-A-HDMI-A-2
[225.235183] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.566s)
[225.277226] Starting dynamic subtest: pipe-B-HDMI-A-1
[227.694174] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.458s)
[227.719161] Starting dynamic subtest: pipe-B-HDMI-A-2
[230.172872] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.472s)
[230.205748] Starting dynamic subtest: pipe-C-HDMI-A-1
[232.623292] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.448s)
[232.649306] Starting dynamic subtest: pipe-C-HDMI-A-2
[235.074909] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.447s)
[235.077346] Subtest ctm-0-75: SUCCESS (15.245s)
[235.418855] [061/133] (821s left) gem_pxp (reject-modify-context-protection-off-3)
[238.071345] Starting subtest: reject-modify-context-protection-off-3
[238.075317] Subtest reject-modify-context-protection-off-3: SKIP (0.000s)
[238.219413] [062/133] (818s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[238.372233] Starting subtest: psr-rgb101010-draw-blt
[238.376081] Subtest psr-rgb101010-draw-blt: SKIP (0.000s)
[238.519121] [063/133] (818s left) kms_cursor_legacy (forked-bo)
[238.664185] Starting subtest: forked-bo
[238.667104] Starting dynamic subtest: pipe-A
[244.081071] Dynamic subtest pipe-A: SUCCESS (5.410s)
[244.110032] Starting dynamic subtest: pipe-B
[249.502053] Dynamic subtest pipe-B: SUCCESS (5.420s)
[249.529147] Starting dynamic subtest: pipe-C
[254.920203] Dynamic subtest pipe-C: SUCCESS (5.415s)
[254.961695] Starting dynamic subtest: all-pipes
[260.337235] Dynamic subtest all-pipes: SUCCESS (5.415s)
[260.338985] Subtest forked-bo: SUCCESS (21.673s)
[260.535866] [064/133] (796s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[260.694425] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[260.698662] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[260.835574] [065/133] (796s left) fbdev (unaligned-read)
[260.948100] Starting subtest: unaligned-read
[260.974857] Subtest unaligned-read: SUCCESS (0.027s)
[261.134814] [066/133] (795s left) gem_ctx_isolation (nonpriv-switch)
[261.261186] Starting subtest: nonpriv-switch
[261.263083] Starting dynamic subtest: rcs0
[262.090336] Dynamic subtest rcs0: SUCCESS (0.827s)
[262.112594] Starting dynamic subtest: bcs0
[263.455199] Dynamic subtest bcs0: SUCCESS (1.360s)
[263.479189] Starting dynamic subtest: vcs0
[264.286689] Dynamic subtest vcs0: SUCCESS (0.833s)
[264.308202] Starting dynamic subtest: vecs0
[265.123658] Dynamic subtest vecs0: SUCCESS (0.831s)
[265.125545] Subtest nonpriv-switch: SUCCESS (3.863s)
[265.389418] [067/133] (791s left) kms_psr (psr-sprite-mmap-gtt)
[265.528899] Subtest psr-sprite-mmap-gtt: SKIP (0.000s)
[265.642226] [068/133] (791s left) gem_render_copy (yf-tiled-to-vebox-linear)
[265.767894] Starting subtest: yf-tiled-to-vebox-linear
[265.771256] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[266.021681] [069/133] (791s left) kms_content_protection (atomic)
[266.166557] Starting subtest: atomic
[266.208299] Subtest atomic: SKIP (0.036s)
[266.353647] [070/133] (791s left) syncobj_eventfd (timeline-wait-before-signal)
[266.459994] Starting subtest: timeline-wait-before-signal
[266.496896] Subtest timeline-wait-before-signal: SUCCESS (0.035s)
[266.652052] [071/133] (790s left) kms_flip (flip-vs-suspend)
[266.793432] Starting subtest: flip-vs-suspend
[266.803081] Starting dynamic subtest: A-HDMI-A1