[62.299814] Initializing watchdogs
[62.299877]   /dev/watchdog0
[62.305392] [001/131] (960s left) gem_lmem_swapping (heavy-verify-multi)
[62.350444] Subtest heavy-verify-multi: SKIP (0.000s)
[62.376777] [002/131] (960s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[62.480383] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[62.481706] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s)
[62.570925] [003/131] (960s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[62.678764] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[62.680093] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[62.802708] [004/131] (960s left) gem_ctx_param (vm)
[62.848201] Starting subtest: vm
[62.867296] Subtest vm: SUCCESS (0.019s)
[63.008784] [005/131] (959s left) kms_selftest (drm_damage_helper)
[63.040775] Starting subtest: drm_damage_helper
[63.045747] Starting dynamic subtest: drm_test_damage_iter_no_damage
[63.164470] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.117s)
[63.178726] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[63.269938] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.104s)
[63.284395] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[63.387305] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.115s)
[63.401690] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[63.501452] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.113s)
[63.516722] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[63.595072] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.093s)
[63.609467] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[63.726235] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.129s)
[63.740843] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[63.840092] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.112s)
[63.854668] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[63.949093] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.108s)
[63.963396] Starting dynamic subtest: drm_test_damage_iter_single_damage
[64.067086] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.116s)
[64.081612] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[64.173065] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.105s)
[64.187532] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[64.289002] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.114s)
[64.303792] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[64.414557] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.125s)
[64.429060] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[64.535540] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.119s)
[64.550072] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[64.615403] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.079s)
[64.630224] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[64.741384] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.124s)
[64.756373] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[64.861699] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.119s)
[64.875496] Starting dynamic subtest: drm_test_damage_iter_damage
[64.981448] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.118s)
[64.996262] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[65.078499] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.097s)
[65.093098] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[65.200643] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.120s)
[65.215536] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[65.285661] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.084s)
[65.301439] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[65.357355] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.070s)
[65.358688] Subtest drm_damage_helper: SUCCESS (2.297s)
[65.493609] [006/131] (957s left) kms_psr (psr2-primary-page-flip)
[65.593629] Subtest psr2-primary-page-flip: SKIP (0.000s)
[65.610156] [007/131] (957s left) syncobj_timeline (host-signal-ordered)
[65.649268] Starting subtest: host-signal-ordered
[65.650705] Subtest host-signal-ordered: SUCCESS (0.001s)
[65.727529] [008/131] (957s left) gem_exec_flush (basic-wb-rw-default)
[65.778984] Starting subtest: basic-wb-rw-default
[71.258197] Subtest basic-wb-rw-default: SUCCESS (5.453s)
[71.454983] [009/131] (951s left) core_getclient
[71.619252] [010/131] (951s left) kms_chamelium_audio (dp-audio-edid)
[71.767890] Subtest dp-audio-edid: SKIP (0.000s)
[71.825112] [011/131] (951s left) i915_module_load (reload-with-fault-injection)
[71.868097] Starting subtest: reload-with-fault-injection
[86.067728] Subtest reload-with-fault-injection: SUCCESS (14.180s)
[86.091214] [012/131] (937s left) gem_ctx_persistence (saturated-hostile)
[89.112323] Starting subtest: saturated-hostile
[89.113149] Starting dynamic subtest: rcs0
[89.874292] Dynamic subtest rcs0: SUCCESS (0.761s)
[89.882432] Starting dynamic subtest: bcs0
[90.627704] Dynamic subtest bcs0: SUCCESS (0.753s)
[90.634642] Starting dynamic subtest: vcs0
[91.380570] Dynamic subtest vcs0: SUCCESS (0.752s)
[91.387664] Starting dynamic subtest: vecs0
[92.172294] Dynamic subtest vecs0: SUCCESS (0.791s)
[92.173753] Subtest saturated-hostile: SUCCESS (3.059s)
[92.269560] [013/131] (930s left) kms_addfb_basic (too-high)
[92.367906] Starting subtest: too-high
[92.368581] Subtest too-high: SUCCESS (0.001s)
[92.486682] [014/131] (930s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[92.592210] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[95.206056] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (2.614s)
[95.364721] [015/131] (927s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[95.463942] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[95.624573] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (0.160s)
[95.788258] [016/131] (927s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[95.833272] Starting subtest: yf-tiled-ccs-to-y-tiled
[95.833953] Starting dynamic subtest: smem
[95.951385] Dynamic subtest smem: SUCCESS (0.118s)
[95.952075] Subtest yf-tiled-ccs-to-y-tiled: SUCCESS (0.118s)
[96.144702] [017/131] (927s left) kms_pm_dc (dc5-dpms-negative)
[97.255446] Starting subtest: dc5-dpms-negative
[101.468754] Subtest dc5-dpms-negative: SUCCESS (4.212s)
[101.544608] [018/131] (921s left) gem_mmap_offset (mmap-unmap)
[101.581874] Starting subtest: mmap-unmap
[101.582546] Starting dynamic subtest: smem0
[130.111042] Dynamic subtest smem0: SUCCESS (28.527s)
[130.111819] Subtest mmap-unmap: SUCCESS (28.527s)
[130.239460] [019/131] (893s left) vgem_basic (second-client)
[130.331976] Starting subtest: second-client
[130.371160] Subtest second-client: SUCCESS (0.039s)
[130.435462] [020/131] (892s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[130.535869] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[130.536568] Starting dynamic subtest: pipe-A-valid-mode
[131.521288] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.985s)
[131.521966] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SUCCESS (0.985s)
[131.680808] [021/131] (891s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[131.790532] Starting subtest: 4-tiled-8bpp-rotate-270
[131.791833] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.000s)
[131.917012] [022/131] (891s left) vgem_basic (busy-fence)
[131.960208] Starting subtest: busy-fence
[131.960900] Subtest busy-fence: SUCCESS (0.000s)
[132.024761] [023/131] (891s left) kms_color (gamma)
[132.128901] Starting subtest: gamma
[132.129701] Starting dynamic subtest: pipe-A-HDMI-A-2
[132.671129] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.542s)
[132.678872] Starting dynamic subtest: pipe-B-HDMI-A-2
[133.109434] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.438s)
[133.110093] Subtest gamma: SUCCESS (0.980s)
[133.278745] [024/131] (890s left) gem_mmap_gtt (close-race)
[133.321327] Starting subtest: close-race
[153.436039] Subtest close-race: SUCCESS (20.114s)
[153.568927] [025/131] (869s left) kms_lease (cursor-implicit-plane)
[153.711943] Starting subtest: cursor-implicit-plane
[153.712656] Starting dynamic subtest: pipe-A-HDMI-A-2
[153.971275] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.258s)
[153.976388] Starting dynamic subtest: pipe-B-HDMI-A-2
[154.153654] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.181s)
[154.154433] Subtest cursor-implicit-plane: SUCCESS (0.441s)
[154.276459] [026/131] (869s left) kms_writeback (writeback-pixel-formats)
[154.380564] Subtest writeback-pixel-formats: SKIP (0.000s)
[154.415715] [027/131] (869s left) kms_plane (plane-position-covered)
[154.523859] Starting subtest: plane-position-covered
[154.848059] Starting dynamic subtest: pipe-A-plane-1
[155.203419] Dynamic subtest pipe-A-plane-1: SUCCESS (0.355s)
[155.211562] Starting dynamic subtest: pipe-A-plane-2
[155.555222] Dynamic subtest pipe-A-plane-2: SUCCESS (0.352s)
[155.561484] Starting dynamic subtest: pipe-A-plane-3
[155.911247] Dynamic subtest pipe-A-plane-3: SUCCESS (0.355s)
[155.920760] Starting dynamic subtest: pipe-A-plane-4
[156.249703] Dynamic subtest pipe-A-plane-4: SUCCESS (0.338s)
[156.257494] Starting dynamic subtest: pipe-A-plane-5
[156.258905] Dynamic subtest pipe-A-plane-5: SUCCESS (0.005s)
[156.499337] Starting dynamic subtest: pipe-B-plane-1
[156.825351] Dynamic subtest pipe-B-plane-1: SUCCESS (0.331s)
[156.830449] Starting dynamic subtest: pipe-B-plane-2
[157.157396] Dynamic subtest pipe-B-plane-2: SUCCESS (0.332s)
[157.162551] Starting dynamic subtest: pipe-B-plane-3
[157.489317] Dynamic subtest pipe-B-plane-3: SUCCESS (0.332s)
[157.494362] Starting dynamic subtest: pipe-B-plane-4
[157.820348] Dynamic subtest pipe-B-plane-4: SUCCESS (0.331s)
[157.825405] Starting dynamic subtest: pipe-B-plane-5
[157.826715] Dynamic subtest pipe-B-plane-5: SUCCESS (0.003s)
[157.827395] Subtest plane-position-covered: SUCCESS (3.300s)
[157.968527] [028/131] (865s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[158.074854] Starting subtest: x-tiled-addfb-size-offset-overflow
[158.075519] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[158.197985] [029/131] (865s left) kms_psr (fbc-psr2-sprite-plane-move)
[158.300589] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[158.324466] [030/131] (865s left) gem_exec_schedule (u-semaphore-codependency)
[158.378779] Starting subtest: u-semaphore-codependency
[158.385067] Subtest u-semaphore-codependency: SUCCESS (0.006s)
[158.683804] [031/131] (864s left) gem_tiled_blits (normal)
[158.958737] Starting subtest: normal
[170.127206] Subtest normal: SUCCESS (11.168s)
[170.244325] [032/131] (853s left) prime_mmap (test_map_unmap)
[170.315630] Starting subtest: test_map_unmap
[170.316441] Starting dynamic subtest: test_map_unmap-smem
[170.362315] Dynamic subtest test_map_unmap-smem: SUCCESS (0.047s)
[170.363028] Subtest test_map_unmap: SUCCESS (0.047s)
[170.490309] [033/131] (853s left) kms_pm_rpm (pm-caching)
[171.923451] Starting subtest: pm-caching
[173.262171] Subtest pm-caching: SUCCESS (1.338s)
[173.389427] [034/131] (850s left) gem_exec_balancer (bonded-true-hang)
[173.544311] Starting subtest: bonded-true-hang
[174.567883] Subtest bonded-true-hang: SUCCESS (1.024s)
[174.636976] [035/131] (849s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[174.686946] Starting subtest: map-fixed-invalidate-overlap
[174.687661] Starting dynamic subtest: gtt
[174.757172] Dynamic subtest gtt: SUCCESS (0.070s)
[174.763120] Starting dynamic subtest: wb
[174.804830] Dynamic subtest wb: SUCCESS (0.047s)
[174.810747] Starting dynamic subtest: wc
[174.854142] Dynamic subtest wc: SUCCESS (0.049s)
[174.860026] Starting dynamic subtest: uc
[174.900205] Dynamic subtest uc: SUCCESS (0.046s)
[174.900900] Subtest map-fixed-invalidate-overlap: SUCCESS (0.213s)
[175.066510] [036/131] (848s left) kms_cursor_legacy (forked-bo)
[175.167144] Starting subtest: forked-bo
[175.167879] Starting dynamic subtest: pipe-A
[180.612035] Dynamic subtest pipe-A: SUCCESS (5.444s)
[180.617924] Starting dynamic subtest: pipe-B
[186.062035] Dynamic subtest pipe-B: SUCCESS (5.449s)
[186.070867] Starting dynamic subtest: all-pipes
[191.523567] Dynamic subtest all-pipes: SUCCESS (5.461s)
[191.524439] Subtest forked-bo: SUCCESS (16.355s)
[191.609905] [037/131] (832s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[191.721832] Starting subtest: 4-tiled-16bpp-rotate-0
[191.723146] Subtest 4-tiled-16bpp-rotate-0: SKIP (0.000s)
[191.818861] [038/131] (831s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[191.925408] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[191.926727] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[192.046892] [039/131] (831s left) gem_ctx_create (basic-files)
[192.093080] Starting subtest: basic-files
[194.105147] Subtest basic-files: SUCCESS (2.012s)
[194.296354] [040/131] (829s left) gem_exec_reloc (basic-wc-cpu-active)
[194.342387] Subtest basic-wc-cpu-active: SKIP (0.000s)
[194.426079] [041/131] (829s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[194.559208] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[194.560541] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[194.680665] [042/131] (829s left) gem_spin_batch (spin-each)
[194.726842] Starting subtest: spin-each
[198.070635] Subtest spin-each: SUCCESS (3.344s)
[198.255469] [043/131] (825s left) gem_userptr_blits (unsync-unmap-after-close)
[198.294598] Subtest unsync-unmap-after-close: SKIP (0.000s)
[198.463142] [044/131] (825s left) kms_psr (psr-suspend)
[198.562536] Subtest psr-suspend: SKIP (0.000s)
[198.590756] [045/131] (825s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[198.686050] Starting subtest: basic-max-pipe-crc-check
[198.687553] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[198.731878] [046/131] (825s left) kms_flip (bo-too-big)
[198.831867] Starting subtest: bo-too-big
[198.833674] Starting dynamic subtest: A-HDMI-A2
[199.181375] Dynamic subtest A-HDMI-A2: SUCCESS (0.348s)
[199.192899] Starting dynamic subtest: B-HDMI-A2
[199.469332] Dynamic subtest B-HDMI-A2: SUCCESS (0.286s)
[199.472321] Subtest bo-too-big: SUCCESS (0.639s)
[199.676575] [047/131] (824s left) kms_invalid_mode (bad-hsync-end)
[199.778719] Starting subtest: bad-hsync-end
[199.779450] Starting dynamic subtest: pipe-A-HDMI-A-2
[199.818370] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.039s)
[199.824640] Starting dynamic subtest: pipe-B-HDMI-A-2
[199.825347] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.000s)
[199.826057] Subtest bad-hsync-end: SUCCESS (0.041s)
[199.965855] [048/131] (824s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[200.064519] Starting subtest: psr-rgb101010-draw-pwrite
[200.065830] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[200.167570] [049/131] (823s left) gem_workarounds (suspend-resume)
[200.215626] Starting subtest: suspend-resume
[217.369400] Subtest suspend-resume: SUCCESS (17.153s)
[220.495845] [050/131] (806s left) kms_async_flips (async-flip-with-page-flip-events-atomic)
[220.601099] Starting subtest: async-flip-with-page-flip-events-atomic
[220.790561] Starting dynamic subtest: pipe-A-HDMI-A-2-y-rc-ccs
[220.927666] Dynamic subtest pipe-A-HDMI-A-2-y-rc-ccs: SKIP (0.136s)
[220.935649] Starting dynamic subtest: pipe-A-HDMI-A-2-y-rc-ccs-cc
[221.059842] Dynamic subtest pipe-A-HDMI-A-2-y-rc-ccs-cc: SKIP (0.132s)
[221.066438] Starting dynamic subtest: pipe-A-HDMI-A-2-y
[223.186249] Dynamic subtest pipe-A-HDMI-A-2-y: SUCCESS (2.127s)
[223.196198] Starting dynamic subtest: pipe-A-HDMI-A-2-x
[225.253537] Dynamic subtest pipe-A-HDMI-A-2-x: SUCCESS (2.067s)
[225.260403] Starting dynamic subtest: pipe-A-HDMI-A-2-linear
[227.322890] Dynamic subtest pipe-A-HDMI-A-2-linear: SUCCESS (2.068s)
[227.492037] Starting dynamic subtest: pipe-B-HDMI-A-2-y-rc-ccs
[227.617103] Dynamic subtest pipe-B-HDMI-A-2-y-rc-ccs: SKIP (0.130s)
[227.623638] Starting dynamic subtest: pipe-B-HDMI-A-2-y-rc-ccs-cc
[227.729288] Dynamic subtest pipe-B-HDMI-A-2-y-rc-ccs-cc: SKIP (0.112s)
[227.735841] Starting dynamic subtest: pipe-B-HDMI-A-2-y
[229.836227] Dynamic subtest pipe-B-HDMI-A-2-y: SUCCESS (2.107s)
[229.846030] Starting dynamic subtest: pipe-B-HDMI-A-2-x
[231.885065] Dynamic subtest pipe-B-HDMI-A-2-x: SUCCESS (2.048s)
[231.893794] Starting dynamic subtest: pipe-B-HDMI-A-2-linear
[233.915304] Dynamic subtest pipe-B-HDMI-A-2-linear: SUCCESS (2.030s)
[233.916022] Subtest async-flip-with-page-flip-events-atomic: SUCCESS (13.314s)
[234.200042] [051/131] (792s left) kms_flip (2x-plain-flip-ts-check)
[234.302746] Starting subtest: 2x-plain-flip-ts-check
[234.305127] Subtest 2x-plain-flip-ts-check: SKIP (0.001s)
[234.435846] [052/131] (792s left) gem_render_copy (x-tiled)
[234.480918] Starting subtest: x-tiled
[234.481593] Starting dynamic subtest: smem
[234.587129] Dynamic subtest smem: SUCCESS (0.106s)
[234.587814] Subtest x-tiled: SUCCESS (0.106s)
[234.768409] [053/131] (792s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[234.869128] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[234.870629] Starting dynamic subtest: pipe-A-HDMI-A-2
[234.950120] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.080s)
[235.010433] Starting dynamic subtest: pipe-B-HDMI-A-2
[235.089822] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.097s)
[235.110889] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (0.241s)
[235.255181] [054/131] (791s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[235.357154] Starting subtest: primary-yf-tiled-reflect-x-90
[235.458332] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.100s)
[235.556994] [055/131] (791s left) kms_rotation_crc (primary-rotation-270)
[235.652017] Starting subtest: primary-rotation-270
[245.327435] Subtest primary-rotation-270: SUCCESS (9.675s)
[245.555504] [056/131] (781s left) gem_wait (busy)
[245.604018] Starting subtest: busy
[245.604714] Starting dynamic subtest: all-engines
[246.147508] Dynamic subtest all-engines: SUCCESS (0.543s)
[246.163701] Starting dynamic subtest: rcs0
[246.662773] Dynamic subtest rcs0: SUCCESS (0.514s)
[246.670752] Starting dynamic subtest: bcs0
[247.184867] Dynamic subtest bcs0: SUCCESS (0.522s)
[247.193759] Starting dynamic subtest: vcs0
[247.698787] Dynamic subtest vcs0: SUCCESS (0.513s)
[247.706636] Starting dynamic subtest: vecs0
[248.216768] Dynamic subtest vecs0: SUCCESS (0.518s)
[248.217492] Subtest busy: SUCCESS (2.613s)
[248.431269] [057/131] (778s left) gen9_exec_parse (unaligned-jump)
[248.471213] Subtest unaligned-jump: SKIP (0.000s)
[248.489581] [058/131] (778s left) i915_query (query-topology-known-pci-ids)
[248.535271] Starting subtest: query-topology-known-pci-ids
[248.536596] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[248.608518] [059/131] (778s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[248.710469] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[248.711760] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[248.840159] [060/131] (778s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[248.945639] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[251.364681] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.420s)
[251.543574] [061/131] (775s left) core_setmaster (master-drop-set-shared-fd)
[253.907580] Starting subtest: master-drop-set-shared-fd
[253.925687] Subtest master-drop-set-shared-fd: SUCCESS (0.019s)
[253.938172] [062/131] (773s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[253.975737] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[254.039445] [063/131] (773s left) kms_plane_scaling (planes-downscale-factor-0-25-unity-scaling)
[254.137010] Starting subtest: planes-downscale-factor-0-25-unity-scaling
[254.137734] Starting dynamic subtest: pipe-A
[254.582423] Dynamic subtest pipe-A: SKIP (0.443s)
[254.589159] Starting dynamic subtest: pipe-B
[255.239130] Dynamic subtest pipe-B: SKIP (0.656s)
[255.240414] Subtest planes-downscale-factor-0-25-unity-scaling: SKIP (1.101s)
[255.343017] [064/131] (772s left) kms_psr (fbc-pr-primary-blt)
[255.439453] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[255.472168] [065/131] (771s left) kms_chamelium_frames (dp-crc-single)
[255.601405] Subtest dp-crc-single: SKIP (0.000s)
[255.653363] [066/131] (771s left) gem_exec_fence (syncobj-invalid-wait)
[255.935504] Starting subtest: syncobj-invalid-wait
[255.936218] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[256.240657] [067/131] (771s left) perf (unprivileged-single-ctx-counters)
[256.361925] Starting subtest: unprivileged-single-ctx-counters
[256.363261] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[256.377999] [068/131] (771s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[256.520566] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[256.575589] [069/131] (770s left) gem_ctx_param (basic)
[256.613571] Starting subtest: basic
[256.614258] Subtest basic: SUCCESS (0.000s)
[256.690252] [070/131] (770s left) drm_fdinfo (all-busy-idle-check-all)
[256.727003] Starting subtest: all-busy-idle-check-all
[257.352327] Subtest all-busy-idle-check-all: SUCCESS (0.625s)
[257.425815] [071/131] (770s left) gem_eio (reset-stress)
[257.473551] Starting subtest: reset-stress
[290.991220] Subtest reset-stress: SUCCESS (33.515s)
[291.156742] [072/131] (736s left) sysfs_timeslice_duration (duration)
[291.194881] Starting subtest: duration
[291.195562] Starting dynamic subtest: vecs0
[291.266910] Dynamic subtest vecs0: SUCCESS (0.071s)
[291.283322] Starting dynamic subtest: vcs0
[291.348680] Dynamic subtest vcs0: SUCCESS (0.079s)
[291.371118] Starting dynamic subtest: bcs0
[291.457615] Dynamic subtest bcs0: SUCCESS (0.107s)
[291.471755] Starting dynamic subtest: rcs0
[291.525692] Dynamic subtest rcs0: SUCCESS (0.066s)
[291.526903] Subtest duration: SUCCESS (0.331s)
[291.607900] [073/131] (735s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[291.709764] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[291.711088] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[291.836635] [074/131] (735s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[291.934967] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[291.936313] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[292.035693] [075/131] (735s left) kms_psr (fbc-pr-cursor-render)
[292.137883] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[292.168756] [076/131] (735s left) core_auth (basic-auth)
[292.209322] Starting subtest: basic-auth
[292.210017] Subtest basic-auth: SUCCESS (0.001s)
[292.292300] [077/131] (735s left) kms_vblank (query-forked-hang)
[292.389256] Starting subtest: query-forked-hang
[292.391040] Starting dynamic subtest: pipe-A-HDMI-A-2
[306.829640] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (14.438s)
[306.837435] Starting dynamic subtest: pipe-B-HDMI-A-2
[320.635064] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (13.803s)
[320.635778] Subtest query-forked-hang: SUCCESS (28.245s)
[320.822114] [078/131] (706s left) gem_pxp (fail-invalid-protected-context)
[441.125926] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[443.482272] Closing watchdogs
[443.484527] Initializing watchdogs
[443.484566]   /dev/watchdog0
[443.493111] [079/131] (584s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[443.593402] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[444.764628] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.171s)
[444.953280] [080/131] (582s left) drm_fdinfo (memory-info-resident)
[444.988529] Starting subtest: memory-info-resident
[444.990339] Starting dynamic subtest: smem0
[446.738295] Dynamic subtest smem0: SUCCESS (1.748s)
[446.739067] Subtest memory-info-resident: SUCCESS (1.750s)
[446.821309] [081/131] (580s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[446.859765] Starting subtest: multi-wait-all-for-submit-available-signaled
[446.860454] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[446.945480] [082/131] (580s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-cpu)
[447.044950] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-cpu
[449.149806] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (2.106s)
[449.308927] [083/131] (578s left) perf (global-sseu-config-invalid)
[449.400272] Starting subtest: global-sseu-config-invalid
[449.400974] Starting dynamic subtest: 0-rcs0
[449.412527] Dynamic subtest 0-rcs0: SUCCESS (0.012s)
[449.413197] Subtest global-sseu-config-invalid: SUCCESS (0.013s)
[449.453197] [084/131] (578s left) gem_eio (in-flight-suspend)
[449.492285] Starting subtest: in-flight-suspend
[519.351437] Subtest in-flight-suspend: SUCCESS (69.854s)
[523.484040] [085/131] (508s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[523.607860] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[523.609263] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[523.731779] [086/131] (508s left) gem_exec_reloc (basic-active)
[523.768628] Subtest basic-active: SKIP (0.000s)
[523.857986] [087/131] (508s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[523.895681] Starting subtest: invalid-multi-wait-all-unsubmitted
[523.896361] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[523.972435] [088/131] (508s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-blt)
[524.073147] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-blt
[524.074463] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-blt: SKIP (0.000s)
[524.177435] [089/131] (507s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[524.282497] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[524.311363] [090/131] (507s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[524.412954] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[524.414263] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[524.528814] [091/131] (507s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[524.564187] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[524.675368] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[524.756280] [092/131] (507s left) gem_ccs (large-ctrl-surf-copy)
[524.795096] Starting subtest: large-ctrl-surf-copy
[524.796413] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[524.881046] [093/131] (507s left) prime_busy (hang-wait)
[524.920607] Starting subtest: hang-wait
[524.921287] Starting dynamic subtest: rcs0
[538.719508] Dynamic subtest rcs0: SUCCESS (13.796s)
[538.728675] Starting dynamic subtest: bcs0
[545.567561] Dynamic subtest bcs0: SUCCESS (6.845s)
[545.577578] Starting dynamic subtest: vcs0
[552.543477] Dynamic subtest vcs0: SUCCESS (6.974s)
[552.553153] Starting dynamic subtest: vecs0
[559.583376] Dynamic subtest vecs0: SUCCESS (7.037s)
[559.584545] Subtest hang-wait: SUCCESS (34.662s)
[559.734749] [094/131] (472s left) kms_psr (pr-cursor-mmap-cpu)
[559.831557] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[559.849515] [095/131] (472s left) kms_cursor_crc (cursor-onscreen-32x32)
[559.947125] Starting subtest: cursor-onscreen-32x32
[559.979669] Subtest cursor-onscreen-32x32: SKIP (0.032s)
[560.124672] [096/131] (472s left) gem_exec_whisper (basic-fds-forked)
[560.171323] Starting subtest: basic-fds-forked
[562.523364] Subtest basic-fds-forked: SUCCESS (2.351s)
[562.724633] [097/131] (469s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[562.826366] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[562.827842] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[562.997864] [098/131] (469s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[563.098098] Starting subtest: extended-pageflip-modeset-hang-oldfb
[563.100082] Starting dynamic subtest: pipe-A
[582.777027] Dynamic subtest pipe-A: SUCCESS (19.677s)
[582.787965] Starting dynamic subtest: pipe-B
[602.739732] Dynamic subtest pipe-B: SUCCESS (19.961s)
[602.740416] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (39.641s)
[602.937948] [099/131] (429s left) kms_plane_alpha_blend (constant-alpha-max)
[603.035419] Starting subtest: constant-alpha-max
[603.102722] Starting dynamic subtest: pipe-A-HDMI-A-2
[604.084736] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.982s)
[604.093277] Starting dynamic subtest: pipe-B-HDMI-A-2
[605.057715] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.971s)
[605.058381] Subtest constant-alpha-max: SUCCESS (2.022s)
[605.250202] [100/131] (427s left) gem_ctx_engines (execute-allforone)
[605.291058] Starting subtest: execute-allforone
[605.294754] Subtest execute-allforone: SUCCESS (0.004s)
[605.498599] [101/131] (426s left) kms_concurrent (multi-plane-atomic-lowres)
[605.596630] Starting subtest: multi-plane-atomic-lowres
[605.597317] Starting dynamic subtest: pipe-A-HDMI-A-2
[605.958752] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.361s)
[605.959416] Subtest multi-plane-atomic-lowres: SUCCESS (0.362s)
[606.073597] [102/131] (426s left) perf (non-sampling-read-error)
[606.182876] Starting subtest: non-sampling-read-error
[606.191144] Subtest non-sampling-read-error: SUCCESS (0.008s)
[606.221516] [103/131] (426s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[606.317429] Starting subtest: cursorA-vs-flipB-varying-size
[606.319897] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[606.415859] [104/131] (425s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[606.516545] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[606.517841] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[606.659875] [105/131] (425s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[606.755353] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[606.757169] Starting dynamic subtest: pipe-A-HDMI-A-2
[606.763651] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[606.771379] Starting dynamic subtest: pipe-B-HDMI-A-2
[606.777798] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[606.779077] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.003s)
[606.963057] [106/131] (425s left) gem_exec_fence (concurrent)
[607.144107] Starting subtest: concurrent
[607.144963] Starting dynamic subtest: rcs0
[607.176668] Dynamic subtest rcs0: SUCCESS (0.031s)
[607.197563] Starting dynamic subtest: bcs0
[607.207152] Dynamic subtest bcs0: SUCCESS (0.029s)
[607.221974] Starting dynamic subtest: vcs0
[607.236121] Dynamic subtest vcs0: SUCCESS (0.027s)
[607.250877] Starting dynamic subtest: vecs0
[607.265191] Dynamic subtest vecs0: SUCCESS (0.027s)
[607.266153] Subtest concurrent: SUCCESS (0.122s)
[607.759200] [107/131] (424s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[607.856180] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[607.857509] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[608.032149] [108/131] (424s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[608.131407] Starting subtest: y-tiled-8bpp-rotate-90
[608.201310] Subtest y-tiled-8bpp-rotate-90: SKIP (0.069s)
[608.335195] [109/131] (424s left) i915_selftest (perf)
[611.098273] Starting subtest: perf
[611.099808] Starting dynamic subtest: engine_cs
[614.626763] Dynamic subtest engine_cs: SUCCESS (3.527s)
[614.634732] Starting dynamic subtest: request
[621.053695] Dynamic subtest request: SUCCESS (6.424s)
[621.071098] Starting dynamic subtest: migrate
[624.548648] Dynamic subtest migrate: SUCCESS (3.491s)
[624.557728] Starting dynamic subtest: region
[629.025573] Dynamic subtest region: SUCCESS (4.475s)
[629.026951] Subtest perf: SUCCESS (17.929s)
[629.060690] [110/131] (403s left) kms_feature_discovery (display-1x)
[634.593702] Starting subtest: display-1x
[634.594396] Subtest display-1x: SUCCESS (0.000s)
[634.617838] [111/131] (397s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[634.718767] Starting subtest: fbcpsr-modesetfrombusy
[634.720098] Subtest fbcpsr-modesetfrombusy: SKIP (0.000s)
[634.843731] [112/131] (397s left) syncobj_timeline (signal-array)
[634.886731] Starting subtest: signal-array
[634.887414] Subtest signal-array: SUCCESS (0.000s)
[634.981251] [113/131] (397s left) syncobj_wait (invalid-reset-one-illegal-handle)
[635.018142] Starting subtest: invalid-reset-one-illegal-handle
[635.018838] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[635.089329] [114/131] (397s left) gem_workarounds (basic-read-fd)
[635.141063] Starting subtest: basic-read-fd
[635.154568] Subtest basic-read-fd: SUCCESS (0.012s)
[635.285415] [115/131] (397s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[635.395032] Starting subtest: y-tiled-32bpp-rotate-0
[637.128078] Subtest y-tiled-32bpp-rotate-0: SUCCESS (1.732s)
[637.299292] [116/131] (395s left) api_intel_bb (blit-reloc-purge-cache)
[637.337170] Starting subtest: blit-reloc-purge-cache
[637.338508] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[637.457782] [117/131] (395s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[637.555740] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[637.557064] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[637.695824] [118/131] (395s left) kms_prop_blob (invalid-set-prop)
[637.734867] Starting subtest: invalid-set-prop
[637.735572] Subtest invalid-set-prop: SUCCESS (0.000s)
[637.827776] [119/131] (394s left) gem_exec_schedule (preemptive-hang)
[637.986072] Starting subtest: preemptive-hang
[637.987236] Starting dynamic subtest: rcs0
[644.028997] Dynamic subtest rcs0: SUCCESS (6.040s)
[644.037145] Starting dynamic subtest: bcs0
[649.977444] Dynamic subtest bcs0: SUCCESS (5.948s)
[649.987237] Starting dynamic subtest: vcs0
[656.002197] Dynamic subtest vcs0: SUCCESS (6.021s)
[656.009012] Starting dynamic subtest: vecs0
[662.015630] Dynamic subtest vecs0: SUCCESS (6.012s)
[662.016863] Subtest preemptive-hang: SUCCESS (24.030s)
[662.201023] [120/131] (370s left) gem_ctx_shared (single-timeline)
[662.244951] Starting subtest: single-timeline
[662.250130] Subtest single-timeline: SUCCESS (0.004s)
[662.457563] [121/131] (370s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[662.554225] Starting subtest: fbc-dirtyfb-ioctl
[662.563131] Starting dynamic subtest: A-HDMI-A-2
[663.902950] Dynamic subtest A-HDMI-A-2: SUCCESS (1.347s)
[663.903652] Subtest fbc-dirtyfb-ioctl: SUCCESS (1.348s)
[664.002091] [122/131] (368s left) kms_cursor_crc (cursor-random-512x512)
[664.102936] Starting subtest: cursor-random-512x512
[664.104259] Subtest cursor-random-512x512: SKIP (0.001s)
[664.243046] [123/131] (368s left) i915_query (query-topology-unsupported)
[664.287196] Starting subtest: query-topology-unsupported
[664.288514] Subtest query-topology-unsupported: SKIP (0.000s)
[664.378207] [124/131] (368s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[664.475827] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[667.131154] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (2.656s)
[667.319159] [125/131] (365s left) i915_pm_rps (thresholds-idle)
[667.358756] Starting subtest: thresholds-idle
[667.359447] Starting dynamic subtest: gt0
[678.010107] Dynamic subtest gt0: SUCCESS (10.651s)
[678.014079] Subtest thresholds-idle: SUCCESS (10.653s)
[678.085910] [126/131] (354s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[678.183787] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[678.185121] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[678.285996] [127/131] (354s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[678.385762] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[678.387093] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[678.495524] [128/131] (354s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[678.535354] Starting subtest: y-tiled-to-vebox-x-tiled
[678.536059] Starting dynamic subtest: smem
[678.645035] Dynamic subtest smem: SUCCESS (0.103s)
[678.645735] Subtest y-tiled-to-vebox-x-tiled: SUCCESS (0.104s)
[678.837368] [129/131] (354s left) gem_partial_pwrite_pread (reads-snoop)
[678.877936] Subtest reads-snoop: SKIP (0.000s)
[678.952153] [130/131] (354s left) prime_vgem (shrink)
[679.034968] Starting subtest: shrink
[679.040795] Subtest shrink: SUCCESS (0.005s)
[679.160120] [131/131] (353s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[679.265178] Starting subtest: yf-tiled-32bpp-rotate-0
[679.266506] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[679.385528] Closing watchdogs
Done.