[89.870973] Initializing watchdogs
[89.871231]   /dev/watchdog0
[89.911650] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[89.926541] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[89.932763] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[89.940792] [001/133] (960s left) gen9_exec_parse (unaligned-jump)
[90.111726] Starting subtest: unaligned-jump
[90.429310] Subtest unaligned-jump: SUCCESS (0.321s)
[90.704289] [002/133] (959s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[90.902108] Starting subtest: stress-xrgb8888-yftiled
[101.357952] Subtest stress-xrgb8888-yftiled: SUCCESS (10.458s)
[101.901710] [003/133] (948s left) kms_psr (psr-cursor-plane-move)
[102.103174] Subtest psr-cursor-plane-move: SKIP (0.000s)
[102.208814] [004/133] (948s left) gem_lmem_swapping (heavy-verify-random)
[102.332302] Subtest heavy-verify-random: SKIP (0.000s)
[102.438316] [005/133] (948s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[102.648430] Starting subtest: fbc-rgb565-draw-mmap-wc
[105.442420] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (2.801s)
[105.733924] [006/133] (945s left) syncobj_wait (wait-for-submit-snapshot)
[105.846750] Starting subtest: wait-for-submit-snapshot
[105.931545] Subtest wait-for-submit-snapshot: SUCCESS (0.087s)
[106.065095] [007/133] (944s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[106.252901] Starting subtest: modeset-transition-nonblocking-fencing
[106.256109] Starting dynamic subtest: 1x-outputs
[109.770205] Dynamic subtest 1x-outputs: SUCCESS (3.518s)
[109.790968] Starting dynamic subtest: 2x-outputs
[117.126509] Dynamic subtest 2x-outputs: SUCCESS (7.354s)
[117.130436] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.872s)
[117.440060] [008/133] (933s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[117.653834] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[117.661539] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.001s)
[117.804412] [009/133] (933s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[118.010206] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[118.018114] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[118.153497] [010/133] (933s left) gem_softpin (noreloc)
[118.279165] Starting subtest: noreloc
[123.717931] Subtest noreloc: SUCCESS (5.433s)
[123.869789] [011/133] (927s left) kms_chamelium_audio (hdmi-audio)
[124.459109] Subtest hdmi-audio: SKIP (0.000s)
[124.734490] [012/133] (926s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[124.953424] Starting subtest: psr-1p-primscrn-spr-indfb-move
[124.961913] Subtest psr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[125.124269] [013/133] (926s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[125.332978] Starting subtest: y-tiled-8bpp-rotate-180
[128.794263] Subtest y-tiled-8bpp-rotate-180: SUCCESS (3.463s)
[129.084651] [014/133] (922s left) kms_pwrite_crc
[130.478729] [015/133] (921s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[130.593997] Starting subtest: invalid-multi-wait-unsubmitted
[130.598147] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.001s)
[130.724176] [016/133] (921s left) gem_exec_params (cliprects-invalid)
[130.837372] Starting subtest: cliprects-invalid
[130.840613] Subtest cliprects-invalid: SUCCESS (0.001s)
[130.975738] [017/133] (920s left) sw_sync (timeline_closed)
[131.082696] Starting subtest: timeline_closed
[131.088101] Subtest timeline_closed: SUCCESS (0.001s)
[131.191913] [018/133] (920s left) gem_ctx_sseu (engines)
[131.310492] Subtest engines: SKIP (0.000s)
[131.417292] [019/133] (920s left) kms_chamelium_color (gamma)
[131.605068] Subtest gamma: SKIP (0.000s)
[131.704638] [020/133] (920s left) gem_exec_schedule (thriceslice)
[131.842410] Starting subtest: thriceslice
[131.845825] Starting dynamic subtest: rcs0
[131.859377] Dynamic subtest rcs0: SUCCESS (0.014s)
[131.885244] Starting dynamic subtest: bcs0
[131.892079] Dynamic subtest bcs0: SUCCESS (0.015s)
[131.914434] Starting dynamic subtest: vcs0
[131.918568] Dynamic subtest vcs0: SUCCESS (0.022s)
[131.938355] Starting dynamic subtest: vecs0
[131.941974] Dynamic subtest vecs0: SUCCESS (0.014s)
[131.945950] Subtest thriceslice: SUCCESS (0.067s)
[132.293223] [021/133] (920s left) kms_addfb_basic (size-max)
[132.493776] Starting subtest: size-max
[132.497094] Subtest size-max: SUCCESS (0.001s)
[132.645067] [022/133] (919s left) perf (global-sseu-config-invalid)
[132.861570] Starting subtest: global-sseu-config-invalid
[132.865086] Starting dynamic subtest: 0-rcs0
[132.893086] Dynamic subtest 0-rcs0: SUCCESS (0.034s)
[132.896967] Subtest global-sseu-config-invalid: SUCCESS (0.036s)
[132.996323] [023/133] (919s left) gem_exec_create (madvise)
[133.124325] Starting subtest: madvise
[133.127715] Starting dynamic subtest: smem
[153.267249] Dynamic subtest smem: SUCCESS (20.130s)
[153.279502] Subtest madvise: SUCCESS (20.132s)
[154.661268] [024/133] (897s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[154.834736] Starting subtest: cursorB-vs-flipB-atomic
[166.099898] Subtest cursorB-vs-flipB-atomic: SUCCESS (11.260s)
[166.421747] [025/133] (886s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[166.640847] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[166.647291] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[166.786804] [026/133] (885s left) gem_exec_params (cliprects_ptr-dirt)
[166.903292] Starting subtest: cliprects_ptr-dirt
[166.907190] Subtest cliprects_ptr-dirt: SUCCESS (0.001s)
[167.050869] [027/133] (885s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[167.250553] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[167.257624] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[167.385891] [028/133] (885s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[167.582029] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[167.721648] [029/133] (885s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[167.905786] Starting subtest: primary-yf-tiled-reflect-x-270
[167.913179] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.003s)
[168.054096] [030/133] (885s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[168.256861] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[168.264507] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[168.402799] [031/133] (884s left) gen7_exec_parse (bitmasks)
[168.522249] Subtest bitmasks: SKIP (0.000s)
[168.624960] [032/133] (884s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[168.811750] Starting subtest: addfb25-x-tiled-mismatch-legacy
[168.815110] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[168.951734] [033/133] (884s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[169.062773] Starting subtest: etime-multi-wait-all-submitted-signaled
[169.176388] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.113s)
[169.315247] [034/133] (884s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[169.525467] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[169.533121] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[169.669120] [035/133] (883s left) gem_exec_reloc (basic-write-cpu-active)
[169.790512] Starting subtest: basic-write-cpu-active
[169.933221] Subtest basic-write-cpu-active: SUCCESS (0.140s)
[170.151920] [036/133] (883s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[172.799330] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[172.805636] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SKIP (0.000s)
[172.932345] [037/133] (880s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[173.113787] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[173.120532] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[173.253049] [038/133] (880s left) syncobj_wait (reset-during-wait-for-submit)
[173.363454] Starting subtest: reset-during-wait-for-submit
[173.465810] Subtest reset-during-wait-for-submit: SUCCESS (0.105s)
[173.615276] [039/133] (880s left) kms_plane_scaling (planes-upscale-20x20)
[173.798384] Starting subtest: planes-upscale-20x20
[173.803156] Starting dynamic subtest: pipe-A
[174.110412] Dynamic subtest pipe-A: SUCCESS (0.313s)
[174.152485] Starting dynamic subtest: pipe-B
[174.630684] Dynamic subtest pipe-B: SUCCESS (0.432s)
[174.697286] Starting dynamic subtest: pipe-C
[174.893844] Dynamic subtest pipe-C: SUCCESS (0.056s)
[174.959630] Subtest planes-upscale-20x20: SUCCESS (0.803s)
[175.482553] [040/133] (878s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[175.901236] Starting subtest: no-spare-fences-interruptible
[177.915477] Subtest no-spare-fences-interruptible: SUCCESS (2.169s)
[178.045881] [041/133] (876s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[178.326968] Starting subtest: basic-test-pattern-with-chamelium
[178.333805] Subtest basic-test-pattern-with-chamelium: SKIP (0.001s)
[178.468480] [042/133] (876s left) kms_pm_dc (dc3co-vpb-simulation)
[179.624061] Starting subtest: dc3co-vpb-simulation
[179.630180] Subtest dc3co-vpb-simulation: SKIP (0.000s)
[179.765665] [043/133] (874s left) kms_pipe_crc_basic (bad-source)
[179.913175] Starting subtest: bad-source
[179.916667] Subtest bad-source: SUCCESS (0.001s)
[180.051515] [044/133] (874s left) gem_exec_params (rel-constants-invalid-ring)
[180.203293] Starting subtest: rel-constants-invalid-ring
[180.208155] Subtest rel-constants-invalid-ring: SUCCESS (0.001s)
[180.347968] [045/133] (874s left) gem_exec_balancer (hang)
[180.590512] Starting subtest: hang
[184.837358] Subtest hang: SUCCESS (4.249s)
[184.979383] [046/133] (870s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[185.728783] Starting subtest: syncobj-timeline-multiple-ext-nodes
[185.732390] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s)
[186.031712] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[186.038300] [047/133] (869s left) kms_plane_multiple (2x-tiling-4)
[186.176088] Starting subtest: 2x-tiling-4
[186.182781] Subtest 2x-tiling-4: SKIP (0.000s)
[186.339959] [048/133] (868s left) gem_gtt_cpu_tlb
[186.605297] [049/133] (868s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[186.735069] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[186.738244] Starting dynamic subtest: pipe-A-HDMI-A-1
[186.892242] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.011s)
[186.932453] Starting dynamic subtest: pipe-A-HDMI-A-2
[187.073712] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.011s)
[187.094300] Starting dynamic subtest: pipe-B-HDMI-A-1
[187.229727] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.011s)
[187.252406] Starting dynamic subtest: pipe-B-HDMI-A-2
[187.444394] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.011s)
[187.471229] Starting dynamic subtest: pipe-C-HDMI-A-1
[187.593677] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.011s)
[187.614054] Starting dynamic subtest: pipe-C-HDMI-A-2
[187.752326] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.011s)
[187.758100] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.085s)
[187.889800] [050/133] (867s left) kms_getfb (getfb2-handle-not-fb)
[188.027208] Starting subtest: getfb2-handle-not-fb
[188.030631] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[188.196339] [051/133] (867s left) kms_feature_discovery (psr1)
[188.342318] Starting subtest: psr1
[188.348721] Subtest psr1: SKIP (0.000s)
[188.495982] [052/133] (867s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[188.650086] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[188.754306] [053/133] (867s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[188.923131] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[192.047834] Subtest fbc-2p-primscrn-cur-indfb-move: SUCCESS (3.126s)
[192.294823] [054/133] (863s left) perf (short-reads)
[192.538107] Starting subtest: short-reads
[192.573392] Subtest short-reads: SUCCESS (0.037s)
[192.704923] [055/133] (863s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[192.933228] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[192.940089] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[193.082790] [056/133] (863s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[193.244089] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s)
[193.355197] [057/133] (862s left) kms_cursor_crc (cursor-onscreen-256x85)
[193.520142] Starting subtest: cursor-onscreen-256x85
[193.575489] Starting dynamic subtest: pipe-A-HDMI-A-1
[196.254587] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.674s)
[196.367383] Starting dynamic subtest: pipe-C-HDMI-A-1
[198.765540] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.438s)
[198.768862] Subtest cursor-onscreen-256x85: SUCCESS (5.243s)
[199.075167] [058/133] (857s left) kms_psr (fbc-psr-cursor-plane-onoff)
[199.223066] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[199.346322] [059/133] (857s left) sysfs_heartbeat_interval (mixed)
[199.470118] Starting subtest: mixed
[199.473818] Starting dynamic subtest: vecs0
[204.727087] Dynamic subtest vecs0: SUCCESS (5.256s)
[204.751288] Starting dynamic subtest: vcs0
[210.005189] Dynamic subtest vcs0: SUCCESS (5.266s)
[210.087921] Starting dynamic subtest: bcs0
[215.251678] Dynamic subtest bcs0: SUCCESS (5.255s)
[215.279074] Starting dynamic subtest: rcs0
[220.448069] Dynamic subtest rcs0: SUCCESS (5.194s)
[220.453659] Subtest mixed: SUCCESS (20.982s)
[220.603258] [060/133] (835s left) kms_color (ctm-0-75)
[220.735880] Starting subtest: ctm-0-75
[220.741104] Starting dynamic subtest: pipe-A-HDMI-A-1
[223.541612] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.800s)
[223.587449] Starting dynamic subtest: pipe-A-HDMI-A-2
[226.072039] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.528s)
[226.103351] Starting dynamic subtest: pipe-B-HDMI-A-1
[228.575106] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.423s)
[228.640580] Starting dynamic subtest: pipe-B-HDMI-A-2
[230.889383] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.392s)
[230.922034] Starting dynamic subtest: pipe-C-HDMI-A-1
[233.317982] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.422s)
[233.366307] Starting dynamic subtest: pipe-C-HDMI-A-2
[235.764181] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.438s)
[235.770335] Subtest ctm-0-75: SUCCESS (15.022s)
[236.076402] [061/133] (820s left) gem_pxp (reject-modify-context-protection-off-3)
[238.756201] Starting subtest: reject-modify-context-protection-off-3
[238.764435] Subtest reject-modify-context-protection-off-3: SKIP (0.000s)
[238.908365] [062/133] (817s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[239.062051] Starting subtest: psr-rgb101010-draw-blt
[239.069117] Subtest psr-rgb101010-draw-blt: SKIP (0.000s)
[239.210170] [063/133] (817s left) kms_cursor_legacy (forked-bo)
[239.379119] Starting subtest: forked-bo
[239.382454] Starting dynamic subtest: pipe-A
[244.871075] Dynamic subtest pipe-A: SUCCESS (5.511s)
[244.905531] Starting dynamic subtest: pipe-B
[250.319350] Dynamic subtest pipe-B: SUCCESS (5.444s)
[250.456205] Starting dynamic subtest: pipe-C
[255.740037] Dynamic subtest pipe-C: SUCCESS (5.416s)
[255.781474] Starting dynamic subtest: all-pipes
[261.180277] Dynamic subtest all-pipes: SUCCESS (5.444s)
[261.185490] Subtest forked-bo: SUCCESS (21.829s)
[261.341828] [064/133] (795s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[261.512094] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[261.522144] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[261.660721] [065/133] (795s left) fbdev (unaligned-read)
[261.781146] Starting subtest: unaligned-read
[261.808689] Subtest unaligned-read: SUCCESS (0.028s)
[261.938843] [066/133] (795s left) gem_ctx_isolation (nonpriv-switch)
[262.075485] Starting subtest: nonpriv-switch
[262.080208] Starting dynamic subtest: rcs0
[262.923074] Dynamic subtest rcs0: SUCCESS (0.851s)
[262.949429] Starting dynamic subtest: bcs0
[264.305804] Dynamic subtest bcs0: SUCCESS (1.379s)
[264.330126] Starting dynamic subtest: vcs0
[265.185451] Dynamic subtest vcs0: SUCCESS (0.876s)
[265.210469] Starting dynamic subtest: vecs0
[266.043149] Dynamic subtest vecs0: SUCCESS (0.856s)
[266.046865] Subtest nonpriv-switch: SUCCESS (3.973s)
[266.307888] [067/133] (790s left) kms_psr (psr-sprite-mmap-gtt)
[266.457032] Subtest psr-sprite-mmap-gtt: SKIP (0.000s)
[266.570551] [068/133] (790s left) gem_render_copy (yf-tiled-to-vebox-linear)
[266.701301] Starting subtest: yf-tiled-to-vebox-linear
[266.709229] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[266.957039] [069/133] (790s left) kms_content_protection (atomic)
[267.110307] Starting subtest: atomic
[267.146157] Subtest atomic: SKIP (0.026s)
[267.295893] [070/133] (790s left) syncobj_eventfd (timeline-wait-before-signal)
[267.411652] Starting subtest: timeline-wait-before-signal
[267.442254] Subtest timeline-wait-before-signal: SUCCESS (0.035s)
[267.589823] [071/133] (790s left) kms_flip (flip-vs-suspend)
[267.728141] Starting subtest: flip-vs-suspend
[267.731630] Starting dynamic subtest: A-HDMI-A1