[60.747457] Initializing watchdogs
[60.747526]   /dev/watchdog0
[60.755792] [001/130] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[60.984780] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[60.986476] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[61.069417] [002/130] (960s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[61.336359] Starting subtest: x-tiled-32bpp-rotate-180
[63.013679] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.678s)
[63.177729] [003/130] (958s left) gem_mmap_gtt (basic-write-gtt)
[63.266015] Subtest basic-write-gtt: SKIP (0.000s)
[63.311574] [004/130] (958s left) kms_psr (psr2-dpms)
[63.538514] Subtest psr2-dpms: SKIP (0.000s)
[63.556695] [005/130] (957s left) kms_color (ctm-red-to-blue)
[63.778029] Starting subtest: ctm-red-to-blue
[63.778974] Starting dynamic subtest: pipe-A-DP-4
[64.387373] Dynamic subtest pipe-A-DP-4: SUCCESS (0.608s)
[64.404547] Starting dynamic subtest: pipe-B-DP-4
[65.026777] Dynamic subtest pipe-B-DP-4: SUCCESS (0.640s)
[65.036380] Starting dynamic subtest: pipe-C-DP-4
[65.671540] Dynamic subtest pipe-C-DP-4: SUCCESS (0.645s)
[65.683861] Starting dynamic subtest: pipe-D-DP-4
[66.276043] Dynamic subtest pipe-D-DP-4: SUCCESS (0.604s)
[66.277083] Subtest ctm-red-to-blue: SUCCESS (2.498s)
[66.482106] [006/130] (954s left) gem_ctx_shared (exec-single-timeline)
[66.585844] Starting subtest: exec-single-timeline
[66.586776] Starting dynamic subtest: rcs0
[67.640253] Dynamic subtest rcs0: SUCCESS (1.053s)
[67.647549] Starting dynamic subtest: bcs0
[68.731706] Dynamic subtest bcs0: SUCCESS (1.091s)
[68.739550] Starting dynamic subtest: vcs0
[69.753099] Dynamic subtest vcs0: SUCCESS (1.021s)
[69.762423] Starting dynamic subtest: vcs1
[70.780062] Dynamic subtest vcs1: SUCCESS (1.024s)
[70.787663] Starting dynamic subtest: vecs0
[71.801282] Dynamic subtest vecs0: SUCCESS (1.023s)
[71.810281] Starting dynamic subtest: vecs1
[72.825245] Dynamic subtest vecs1: SUCCESS (1.023s)
[72.834310] Starting dynamic subtest: ccs0
[73.850129] Dynamic subtest ccs0: SUCCESS (1.024s)
[73.851883] Subtest exec-single-timeline: SUCCESS (7.263s)
[74.063659] [007/130] (947s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[74.309378] Starting subtest: yf-tiled-64bpp-rotate-270
[74.311132] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[74.412759] [008/130] (947s left) kms_psr (psr-primary-mmap-gtt)
[74.666653] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[74.689244] [009/130] (946s left) gem_mmap_gtt (big-copy-xy)
[74.760602] Subtest big-copy-XY: SKIP (0.000s)
[74.807488] [010/130] (946s left) intel_hwmon (hwmon-read)
[74.891994] Starting subtest: hwmon-read
[74.893023] Subtest hwmon-read: SUCCESS (0.001s)
[74.968193] [011/130] (946s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[75.199039] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[75.200910] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[75.285216] [012/130] (946s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[75.384233] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[75.487625] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.103s)
[75.584276] [013/130] (945s left) kms_prime (basic-modeset-hybrid)
[78.235903] Subtest basic-modeset-hybrid: SKIP (0.000s)
[78.355302] [014/130] (943s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[78.611823] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[78.613498] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[78.706510] [015/130] (942s left) kms_psr (pr-no-drrs)
[78.964880] Subtest pr-no-drrs: SKIP (0.000s)
[78.989272] [016/130] (942s left) kms_plane_alpha_blend (alpha-opaque-fb)
[79.219198] Starting subtest: alpha-opaque-fb
[79.436571] Starting dynamic subtest: pipe-A-DP-4
[79.968165] Dynamic subtest pipe-A-DP-4: SUCCESS (0.531s)
[79.975402] Starting dynamic subtest: pipe-D-DP-4
[80.530805] Dynamic subtest pipe-D-DP-4: SUCCESS (0.561s)
[80.531741] Subtest alpha-opaque-fb: SUCCESS (1.312s)
[80.755743] [017/130] (940s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[81.019206] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[81.020141] Starting dynamic subtest: pipe-A-DP-4
[81.029508] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[81.036893] Starting dynamic subtest: pipe-B-DP-4
[81.045416] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[81.052774] Starting dynamic subtest: pipe-C-DP-4
[81.061192] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[81.068222] Starting dynamic subtest: pipe-D-DP-4
[81.076680] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[81.078295] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SKIP (0.004s)
[81.429500] [018/130] (940s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[81.683292] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[81.684205] Starting dynamic subtest: pipe-A-valid-mode
[83.541667] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.856s)
[83.543233] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (1.857s)
[83.816693] [019/130] (937s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[84.067010] Starting subtest: disable-crc-after-crtc
[84.067946] Starting dynamic subtest: pipe-A-DP-4
[84.824163] Dynamic subtest pipe-A-DP-4: SUCCESS (0.754s)
[84.840541] Starting dynamic subtest: pipe-B-DP-4
[85.449534] Dynamic subtest pipe-B-DP-4: SUCCESS (0.623s)
[85.458229] Starting dynamic subtest: pipe-C-DP-4
[86.073415] Dynamic subtest pipe-C-DP-4: SUCCESS (0.622s)
[86.081295] Starting dynamic subtest: pipe-D-DP-4
[86.693735] Dynamic subtest pipe-D-DP-4: SUCCESS (0.619s)
[86.694726] Subtest disable-crc-after-crtc: SUCCESS (2.626s)
[86.919037] [020/130] (934s left) kms_vblank (query-idle)
[87.179374] Starting subtest: query-idle
[87.180274] Starting dynamic subtest: pipe-A-DP-4
[89.489482] Dynamic subtest pipe-A-DP-4: SUCCESS (2.309s)
[89.501493] Starting dynamic subtest: pipe-D-DP-4
[91.740408] Dynamic subtest pipe-D-DP-4: SUCCESS (2.247s)
[91.741300] Subtest query-idle: SUCCESS (4.562s)
[91.914630] [021/130] (929s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[92.179755] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[92.180611] Starting dynamic subtest: pipe-A-DP-4
[100.325352] Dynamic subtest pipe-A-DP-4: SUCCESS (8.140s)
[100.337272] Starting dynamic subtest: pipe-B-DP-4
[101.079726] Dynamic subtest pipe-B-DP-4: SUCCESS (0.751s)
[101.091886] Starting dynamic subtest: pipe-C-DP-4
[101.848311] Dynamic subtest pipe-C-DP-4: SUCCESS (0.764s)
[101.859578] Starting dynamic subtest: pipe-D-DP-4
[102.634653] Dynamic subtest pipe-D-DP-4: SUCCESS (0.782s)
[102.636639] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SUCCESS (10.449s)
[102.976726] [022/130] (918s left) gem_mmap_gtt (pf-nonblock)
[103.076192] Subtest pf-nonblock: SKIP (0.000s)
[103.111677] [023/130] (918s left) gem_exec_reloc (basic-gtt-read-active)
[103.190306] Subtest basic-gtt-read-active: SKIP (0.000s)
[103.228802] [024/130] (918s left) kms_cursor_crc (cursor-onscreen-32x32)
[103.530789] Starting subtest: cursor-onscreen-32x32
[103.583499] Subtest cursor-onscreen-32x32: SKIP (0.046s)
[103.939296] [025/130] (918s left) i915_hangman (engine-engine-hang)
[104.052049] Starting subtest: engine-engine-hang
[104.052965] Starting dynamic subtest: rcs0
[104.837592] Dynamic subtest rcs0: SUCCESS (0.785s)
[104.848306] Starting dynamic subtest: bcs0
[105.564545] Dynamic subtest bcs0: SUCCESS (0.726s)
[105.574278] Starting dynamic subtest: vcs0
[106.279413] Dynamic subtest vcs0: SUCCESS (0.715s)
[106.287374] Starting dynamic subtest: vcs1
[106.987381] Dynamic subtest vcs1: SUCCESS (0.708s)
[106.996722] Starting dynamic subtest: vecs0
[107.710488] Dynamic subtest vecs0: SUCCESS (0.723s)
[107.720462] Starting dynamic subtest: vecs1
[108.433594] Dynamic subtest vecs1: SUCCESS (0.723s)
[108.444606] Starting dynamic subtest: ccs0
[109.186479] Dynamic subtest ccs0: SUCCESS (0.752s)
[109.187449] Subtest engine-engine-hang: SUCCESS (5.134s)
[109.303796] [026/130] (912s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[109.541058] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[109.555474] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.014s)
[109.618737] [027/130] (912s left) gem_fenced_exec_thrash (2-spare-fences)
[109.701962] Subtest 2-spare-fences: SKIP (0.000s)
[109.757407] [028/130] (912s left) perf (polling-parameterized)
[110.151021] Starting subtest: polling-parameterized
[130.182807] Subtest polling-parameterized: SUCCESS (20.031s)
[130.200837] [029/130] (891s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[130.511249] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[130.513312] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[130.622939] [030/130] (891s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[130.935916] Subtest psr2-overlay-plane-update-continuous-sf: SKIP (0.000s)
[130.962850] [031/130] (891s left) gem_userptr_blits (nohangcheck)
[131.108635] Starting subtest: nohangcheck
[131.410557] Subtest nohangcheck: SUCCESS (0.301s)
[131.511317] [032/130] (890s left) kms_writeback (writeback-check-output-xrgb2101010)
[131.807456] Subtest writeback-check-output-XRGB2101010: SKIP (0.000s)
[131.829998] [033/130] (890s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[132.101184] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s)
[132.129734] [034/130] (890s left) gem_mmap_gtt (big-bo)
[132.249190] Subtest big-bo: SKIP (0.000s)
[132.279290] [035/130] (889s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[132.551178] Starting subtest: fbcpsr-shrfb-scaledprimary
[132.552980] Subtest fbcpsr-shrfb-scaledprimary: SKIP (0.000s)
[132.645524] [036/130] (889s left) gem_huc_copy (huc-copy)
[132.819367] Starting subtest: huc-copy
[132.824293] Subtest huc-copy: SUCCESS (0.005s)
[132.979697] [037/130] (889s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[133.248532] Starting subtest: primary-y-tiled-reflect-x-270
[133.251350] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[133.319579] [038/130] (888s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[133.619614] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[134.218938] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.599s)
[134.415193] [039/130] (887s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[134.707016] Starting subtest: plane-primary-overlay-mutable-zpos
[136.628254] Subtest plane-primary-overlay-mutable-zpos: SKIP (1.919s)
[136.913365] [040/130] (885s left) gem_vm_create (invalid-destroy)
[137.051532] Starting subtest: invalid-destroy
[137.055195] Subtest invalid-destroy: SUCCESS (0.004s)
[137.182501] [041/130] (885s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[137.312287] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[137.314214] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[137.523157] [042/130] (884s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[137.801853] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[137.803554] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[137.895975] [043/130] (884s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-blt)
[138.201045] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-blt
[138.202857] Subtest fbcpsr-1p-offscren-pri-indfb-draw-blt: SKIP (0.000s)
[138.295905] [044/130] (884s left) i915_pm_rps (min-max-config-loaded)
[138.447662] Starting subtest: min-max-config-loaded
[138.449476] Subtest min-max-config-loaded: SKIP (0.001s)
[138.526677] [045/130] (884s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[138.803973] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[138.805642] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[138.894857] [046/130] (883s left) gem_userptr_blits (usage-restrictions)
[139.042951] Starting subtest: usage-restrictions
[139.043923] Subtest usage-restrictions: SUCCESS (0.000s)
[139.175945] [047/130] (883s left) kms_chamelium_audio (dp-audio)
[139.512307] Subtest dp-audio: SKIP (0.000s)
[139.620342] [048/130] (883s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[139.908769] Starting subtest: cursorB-vs-flipA-legacy
[139.913223] Subtest cursorB-vs-flipA-legacy: SKIP (0.005s)
[139.969790] [049/130] (882s left) kms_feature_discovery (display)
[140.239202] Starting subtest: display
[140.240116] Subtest display: SUCCESS (0.000s)
[140.306148] [050/130] (882s left) kms_atomic_interruptible (universal-setplane-cursor)
[140.577533] Starting subtest: universal-setplane-cursor
[140.579473] Starting dynamic subtest: pipe-A-DP-4
[146.900511] Dynamic subtest pipe-A-DP-4: SUCCESS (6.321s)
[146.901408] Subtest universal-setplane-cursor: SUCCESS (6.322s)
[147.106914] [051/130] (875s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[147.413878] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[147.415585] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[147.495331] [052/130] (875s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-pwrite)
[147.791852] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-pwrite
[147.793526] Subtest fbcpsr-1p-offscren-pri-indfb-draw-pwrite: SKIP (0.000s)
[147.880919] [053/130] (874s left) kms_content_protection (type1)
[148.223220] Starting subtest: type1
[148.786321] Subtest type1: SKIP (0.559s)
[149.094782] [054/130] (873s left) gem_ctx_isolation (nonpriv-switch)
[149.247238] Starting subtest: nonpriv-switch
[149.248186] Starting dynamic subtest: rcs0
[150.064772] Dynamic subtest rcs0: SUCCESS (0.817s)
[150.072635] Starting dynamic subtest: bcs0
[150.905445] Dynamic subtest bcs0: SUCCESS (0.840s)
[150.913392] Starting dynamic subtest: vcs0
[151.732249] Dynamic subtest vcs0: SUCCESS (0.826s)
[151.740183] Starting dynamic subtest: vcs1
[152.575033] Dynamic subtest vcs1: SUCCESS (0.842s)
[152.583192] Starting dynamic subtest: vecs0
[153.420848] Dynamic subtest vecs0: SUCCESS (0.845s)
[153.428937] Starting dynamic subtest: vecs1
[154.258963] Dynamic subtest vecs1: SUCCESS (0.838s)
[154.267124] Starting dynamic subtest: ccs0
[155.114195] Dynamic subtest ccs0: SUCCESS (0.855s)
[155.115177] Subtest nonpriv-switch: SUCCESS (5.867s)
[155.349897] [055/130] (867s left) syncobj_wait (invalid-wait-illegal-handle)
[155.469517] Starting subtest: invalid-wait-illegal-handle
[155.470493] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[155.588112] [056/130] (867s left) kms_flip (2x-flip-vs-fences-interruptible)
[155.890122] Starting subtest: 2x-flip-vs-fences-interruptible
[155.892400] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[155.952229] [057/130] (866s left) kms_pm_backlight (basic-brightness)
[156.227678] Subtest basic-brightness: SKIP (0.000s)
[156.262399] [058/130] (866s left) gem_basic (bad-close)
[156.379163] Starting subtest: bad-close
[156.381168] Subtest bad-close: SUCCESS (0.000s)
[156.502649] [059/130] (866s left) gem_pxp (hw-rejects-pxp-buffer)
[159.155949] Starting subtest: hw-rejects-pxp-buffer
[159.157774] Subtest hw-rejects-pxp-buffer: SUCCESS (0.000s)
[159.255609] [060/130] (863s left) gem_exec_schedule (u-submit-late-slice)
[159.384154] Starting subtest: u-submit-late-slice
[159.385134] Starting dynamic subtest: rcs0
[159.447766] Dynamic subtest rcs0: SUCCESS (0.063s)
[159.455672] Starting dynamic subtest: bcs0
[159.488820] Dynamic subtest bcs0: SUCCESS (0.040s)
[159.496685] Starting dynamic subtest: vcs0
[159.531496] Dynamic subtest vcs0: SUCCESS (0.042s)
[159.539515] Starting dynamic subtest: vcs1
[159.571602] Dynamic subtest vcs1: SUCCESS (0.040s)
[159.579533] Starting dynamic subtest: vecs0
[159.618837] Dynamic subtest vecs0: SUCCESS (0.047s)
[159.630220] Starting dynamic subtest: vecs1
[159.663393] Dynamic subtest vecs1: SUCCESS (0.044s)
[159.671764] Starting dynamic subtest: ccs0
[159.707578] Dynamic subtest ccs0: SUCCESS (0.044s)
[159.708591] Subtest u-submit-late-slice: SUCCESS (0.324s)
[160.102512] [061/130] (862s left) kms_addfb_basic (invalid-get-prop-any)
[160.250289] Starting subtest: invalid-get-prop-any
[160.251231] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[160.491055] [062/130] (862s left) perf (gen8-unprivileged-single-ctx-counters)
[160.779779] Starting subtest: gen8-unprivileged-single-ctx-counters
[160.781916] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[160.799912] [063/130] (862s left) syncobj_eventfd (invalid-illegal-handle)
[160.917469] Starting subtest: invalid-illegal-handle
[160.918407] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[161.026165] [064/130] (862s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[161.325897] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[161.327640] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[161.432932] [065/130] (861s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[161.755230] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[161.756917] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[161.871517] [066/130] (861s left) kms_addfb_basic (bad-pitch-999)
[162.024286] Starting subtest: bad-pitch-999
[162.025208] Subtest bad-pitch-999: SUCCESS (0.000s)
[162.258951] [067/130] (860s left) drm_fdinfo (virtual-busy-hang)
[162.403424] Starting subtest: virtual-busy-hang
[162.405322] Subtest virtual-busy-hang: SKIP (0.000s)
[162.470393] [068/130] (860s left) kms_busy (extended-modeset-hang-newfb)
[162.753304] Starting subtest: extended-modeset-hang-newfb
[162.754235] Starting dynamic subtest: pipe-A
[178.534325] Dynamic subtest pipe-A: SUCCESS (15.780s)
[178.550477] Starting dynamic subtest: pipe-D
[194.313256] Dynamic subtest pipe-D: SUCCESS (15.775s)
[194.314295] Subtest extended-modeset-hang-newfb: SUCCESS (31.562s)
[194.587838] [069/130] (828s left) kms_async_flips (invalid-async-flip)
[194.883231] Starting subtest: invalid-async-flip
[194.885038] Subtest invalid-async-flip: SKIP (0.000s)
[195.269016] [070/130] (828s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[195.564200] Starting subtest: fb-8bpc-vs-panel-8bpc
[195.565127] Starting dynamic subtest: pipe-A-DP-4
[195.996979] Dynamic subtest pipe-A-DP-4: SUCCESS (0.428s)
[195.998625] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (0.431s)
[196.200792] [071/130] (827s left) kms_plane_scaling (planes-scaler-unity-scaling)
[196.498175] Starting subtest: planes-scaler-unity-scaling
[196.498906] Starting dynamic subtest: pipe-A
[196.589285] Dynamic subtest pipe-A: SUCCESS (0.092s)
[196.597941] Starting dynamic subtest: pipe-B
[196.792357] Dynamic subtest pipe-B: SUCCESS (0.202s)
[196.804473] Starting dynamic subtest: pipe-C
[197.011295] Dynamic subtest pipe-C: SUCCESS (0.218s)
[197.019589] Starting dynamic subtest: pipe-D
[197.213488] Dynamic subtest pipe-D: SUCCESS (0.201s)
[197.214417] Subtest planes-scaler-unity-scaling: SUCCESS (0.717s)
[197.491162] [072/130] (825s left) gem_exec_store (pages)
[197.636796] Starting subtest: pages
[197.637665] Starting dynamic subtest: rcs0
[197.789730] Dynamic subtest rcs0: SUCCESS (0.152s)
[197.800515] Starting dynamic subtest: bcs0
[197.886692] Dynamic subtest bcs0: SUCCESS (0.096s)
[197.896351] Starting dynamic subtest: vcs0
[197.984664] Dynamic subtest vcs0: SUCCESS (0.097s)
[197.993136] Starting dynamic subtest: vcs1
[198.070589] Dynamic subtest vcs1: SUCCESS (0.085s)
[198.078872] Starting dynamic subtest: vecs0
[198.157616] Dynamic subtest vecs0: SUCCESS (0.086s)
[198.166728] Starting dynamic subtest: vecs1
[198.249557] Dynamic subtest vecs1: SUCCESS (0.091s)
[198.257931] Starting dynamic subtest: ccs0
[198.335743] Dynamic subtest ccs0: SUCCESS (0.085s)
[198.336760] Subtest pages: SUCCESS (0.699s)
[198.591975] [073/130] (824s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[198.863110] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s)
[198.893898] [074/130] (824s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[199.286571] Starting subtest: cursor-rapid-movement-128x128
[199.291213] Starting dynamic subtest: pipe-A-DP-4
[199.761615] Dynamic subtest pipe-A-DP-4: SUCCESS (0.470s)
[199.807569] Starting dynamic subtest: pipe-D-DP-4
[200.177812] Dynamic subtest pipe-D-DP-4: SUCCESS (0.376s)
[200.178864] Subtest cursor-rapid-movement-128x128: SUCCESS (0.890s)
[200.551022] [075/130] (822s left) kms_chamelium_color (ctm-negative)
[200.853816] Subtest ctm-negative: SKIP (0.000s)
[200.883877] [076/130] (822s left) fbdev (unaligned-read)
[201.006194] Starting subtest: unaligned-read
[201.018218] Subtest unaligned-read: SUCCESS (0.012s)
[201.079920] [077/130] (822s left) dmabuf_sync_file (import-multiple-read-write)
[201.222702] Starting subtest: import-multiple-read-write
[201.226377] Subtest import-multiple-read-write: SUCCESS (0.004s)
[201.276503] [078/130] (822s left) gem_exec_fence (invalid-fence-array)
[201.822132] Starting subtest: invalid-fence-array
[201.825548] Subtest invalid-fence-array: SUCCESS (0.003s)
[202.233791] [079/130] (821s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[202.560782] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[202.562435] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[202.649243] [080/130] (820s left) syncobj_timeline (invalid-query-bad-pad)
[202.815791] Starting subtest: invalid-query-bad-pad
[202.817033] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[202.938559] [081/130] (820s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[203.226266] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[203.227182] Starting dynamic subtest: pipe-A-DP-4
[203.256534] Dynamic subtest pipe-A-DP-4: SKIP (0.002s)
[203.264908] Starting dynamic subtest: pipe-B-DP-4
[203.286992] Dynamic subtest pipe-B-DP-4: SKIP (0.002s)
[203.295288] Starting dynamic subtest: pipe-C-DP-4
[203.321227] Dynamic subtest pipe-C-DP-4: SKIP (0.002s)
[203.329751] Starting dynamic subtest: pipe-D-DP-4
[203.350428] Dynamic subtest pipe-D-DP-4: SKIP (0.002s)
[203.352420] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.014s)
[203.659251] [082/130] (820s left) prime_mmap (test_invalid_sync_flags)
[203.788353] Starting subtest: test_invalid_sync_flags
[203.789273] Starting dynamic subtest: test_invalid_sync_flags-smem
[203.790274] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[203.798839] Starting dynamic subtest: test_invalid_sync_flags-lmem0
[203.799943] Dynamic subtest test_invalid_sync_flags-lmem0: SUCCESS (0.000s)
[203.801114] Subtest test_invalid_sync_flags: SUCCESS (0.002s)
[203.877771] [083/130] (819s left) kms_properties (invalid-properties-atomic)
[204.155298] Starting subtest: invalid-properties-atomic
[204.533825] Subtest invalid-properties-atomic: SUCCESS (0.371s)
[204.594551] [084/130] (819s left) gem_userptr_blits (coherency-sync)
[204.725753] Starting subtest: coherency-sync
[205.099221] Subtest coherency-sync: SKIP (0.357s)
[205.243095] [085/130] (818s left) gem_exec_balancer (noheartbeat)
[205.701397] Starting subtest: noheartbeat
[205.703382] Subtest noheartbeat: SKIP (0.000s)
[205.761226] [086/130] (818s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[205.888161] Starting subtest: invalid-bsd2-flag-on-vebox
[205.889138] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[205.981524] [087/130] (817s left) gem_tiling_max_stride
[206.160536] [088/130] (817s left) gem_exec_schedule (preempt-queue-chain)
[206.298677] Subtest preempt-queue-chain: SKIP (0.000s)
[206.635525] [089/130] (817s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[206.918404] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[206.920241] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[207.034496] [090/130] (816s left) kms_plane (plane-position-covered)
[207.331484] Starting subtest: plane-position-covered
[207.755289] Starting dynamic subtest: pipe-A-plane-1
[208.200836] Dynamic subtest pipe-A-plane-1: SUCCESS (0.446s)
[208.212957] Starting dynamic subtest: pipe-A-plane-2
[208.679988] Dynamic subtest pipe-A-plane-2: SUCCESS (0.478s)
[208.692062] Starting dynamic subtest: pipe-A-plane-3
[209.158668] Dynamic subtest pipe-A-plane-3: SUCCESS (0.478s)
[209.170389] Starting dynamic subtest: pipe-A-plane-4
[209.638426] Dynamic subtest pipe-A-plane-4: SUCCESS (0.478s)
[209.651504] Starting dynamic subtest: pipe-A-plane-5
[209.659780] Dynamic subtest pipe-A-plane-5: SUCCESS (0.020s)
[210.007270] Starting dynamic subtest: pipe-B-plane-1
[210.419933] Dynamic subtest pipe-B-plane-1: SUCCESS (0.423s)
[210.429970] Starting dynamic subtest: pipe-B-plane-2
[210.857999] Dynamic subtest pipe-B-plane-2: SUCCESS (0.437s)
[210.867393] Starting dynamic subtest: pipe-B-plane-3
[211.313945] Dynamic subtest pipe-B-plane-3: SUCCESS (0.455s)
[211.323368] Starting dynamic subtest: pipe-B-plane-4
[211.735042] Dynamic subtest pipe-B-plane-4: SUCCESS (0.420s)
[211.744740] Starting dynamic subtest: pipe-B-plane-5
[211.753152] Dynamic subtest pipe-B-plane-5: SUCCESS (0.017s)
[211.754033] Subtest plane-position-covered: SUCCESS (4.422s)
[212.015395] [091/130] (811s left) syncobj_timeline (single-wait-available-submitted)
[212.149831] Starting subtest: single-wait-available-submitted
[212.150792] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[212.239885] [092/130] (811s left) gem_workarounds (reset-context)
[212.401100] Starting subtest: reset-context
[212.643763] Subtest reset-context: SUCCESS (0.243s)
[212.795708] [093/130] (811s left) kms_flip (basic-plain-flip)
[213.071166] Starting subtest: basic-plain-flip
[213.075559] Starting dynamic subtest: A-DP4
[213.931967] Dynamic subtest A-DP4: SUCCESS (0.855s)
[213.971443] Starting dynamic subtest: B-DP4
[214.717277] Dynamic subtest B-DP4: SUCCESS (0.780s)
[214.730772] Starting dynamic subtest: C-DP4
[215.494645] Dynamic subtest C-DP4: SUCCESS (0.773s)
[215.505811] Starting dynamic subtest: D-DP4
[216.249086] Dynamic subtest D-DP4: SUCCESS (0.753s)
[216.252593] Subtest basic-plain-flip: SUCCESS (3.181s)
[216.571746] [094/130] (807s left) kms_chamelium_hpd (common-hpd-after-suspend)
[216.931460] Subtest common-hpd-after-suspend: SKIP (0.000s)
[217.047241] [095/130] (807s left) gem_mmap_gtt (basic-small-bo-tiledx)
[217.169302] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[217.211699] [096/130] (806s left) gem_cs_tlb (engines)
[217.349541] Starting subtest: engines
[217.350458] Starting dynamic subtest: rcs0
[219.504379] Dynamic subtest rcs0: SUCCESS (2.153s)
[219.514081] Starting dynamic subtest: bcs0
[221.658400] Dynamic subtest bcs0: SUCCESS (2.153s)
[221.668059] Starting dynamic subtest: vcs0
[223.810776] Dynamic subtest vcs0: SUCCESS (2.152s)
[223.820131] Starting dynamic subtest: vcs1
[225.964237] Dynamic subtest vcs1: SUCCESS (2.152s)
[225.973563] Starting dynamic subtest: vecs0
[228.118298] Dynamic subtest vecs0: SUCCESS (2.152s)
[228.127654] Starting dynamic subtest: vecs1
[230.270592] Dynamic subtest vecs1: SUCCESS (2.152s)
[230.279815] Starting dynamic subtest: ccs0
[232.422577] Dynamic subtest ccs0: SUCCESS (2.151s)
[232.423438] Subtest engines: SUCCESS (15.073s)
[232.534172] [097/130] (791s left) gem_exec_reloc (basic-active)
[232.660218] Subtest basic-active: SKIP (0.000s)
[232.714030] [098/130] (791s left) gem_unref_active_buffers
[233.088370] [099/130] (791s left) gen9_exec_parse (bb-start-param)
[233.239145] Subtest bb-start-param: SKIP (0.000s)
[233.292563] [100/130] (790s left) gem_mmap_gtt (basic-read-write)
[233.414424] Subtest basic-read-write: SKIP (0.000s)
[233.461175] [101/130] (790s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[233.737192] Starting subtest: psr-rgb101010-draw-pwrite
[233.738971] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[233.861706] [102/130] (790s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[234.147069] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[234.148876] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[234.244347] [103/130] (790s left) api_intel_bb (destroy-bb)
[234.384356] Starting subtest: destroy-bb
[234.414501] Subtest destroy-bb: SUCCESS (0.029s)
[234.552786] [104/130] (789s left) syncobj_timeline (wait-all-snapshot)
[234.671163] Starting subtest: wait-all-snapshot
[234.753301] Subtest wait-all-snapshot: SUCCESS (0.082s)
[234.864034] [105/130] (789s left) kms_big_fb (x-tiled-addfb)
[235.140363] Starting subtest: x-tiled-addfb
[235.141240] Subtest x-tiled-addfb: SUCCESS (0.000s)
[235.247830] [106/130] (789s left) kms_psr (fbc-pr-sprite-plane-move)
[235.536530] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[235.559465] [107/130] (788s left) kms_properties (crtc-properties-atomic)
[235.829026] Starting subtest: crtc-properties-atomic
[235.829908] Starting dynamic subtest: pipe-A-DP-4
[236.155718] Dynamic subtest pipe-A-DP-4: SUCCESS (0.325s)
[236.169285] Starting dynamic subtest: pipe-B-DP-4
[236.499565] Dynamic subtest pipe-B-DP-4: SUCCESS (0.342s)
[236.511760] Starting dynamic subtest: pipe-C-DP-4
[236.858784] Dynamic subtest pipe-C-DP-4: SUCCESS (0.358s)
[236.869592] Starting dynamic subtest: pipe-D-DP-4
[237.200509] Dynamic subtest pipe-D-DP-4: SUCCESS (0.340s)
[237.201468] Subtest crtc-properties-atomic: SUCCESS (1.372s)
[237.402304] [108/130] (787s left) kms_sequence (get-busy)
[237.696419] Starting subtest: get-busy
[237.697793] Starting dynamic subtest: pipe-A-DP-4
[240.262196] Dynamic subtest pipe-A-DP-4: SUCCESS (2.565s)
[240.273396] Starting dynamic subtest: pipe-B-DP-4
[242.729760] Dynamic subtest pipe-B-DP-4: SUCCESS (2.466s)
[242.742800] Starting dynamic subtest: pipe-C-DP-4
[245.202198] Dynamic subtest pipe-C-DP-4: SUCCESS (2.470s)
[245.213456] Starting dynamic subtest: pipe-D-DP-4
[247.677890] Dynamic subtest pipe-D-DP-4: SUCCESS (2.474s)
[247.678978] Subtest get-busy: SUCCESS (9.982s)
[247.901118] [109/130] (776s left) gem_exec_balancer (bonded-false-hang)
[248.306573] Starting subtest: bonded-false-hang
[248.308410] Subtest bonded-false-hang: SKIP (0.000s)
[248.395188] [110/130] (776s left) gem_exec_flush (basic-wb-rw-default)
[248.517080] Subtest basic-wb-rw-default: SKIP (0.000s)
[248.554120] [111/130] (776s left) core_getversion (basic)
[248.660315] Starting subtest: basic
[248.662385] Subtest basic: SUCCESS (0.000s)
[248.725950] [112/130] (775s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[248.998789] Starting subtest: fbc-rgb101010-draw-mmap-wc
[249.000592] Subtest fbc-rgb101010-draw-mmap-wc: SKIP (0.000s)
[249.113822] [113/130] (775s left) gem_exec_fence (syncobj-invalid-wait)
[249.716718] Starting subtest: syncobj-invalid-wait
[249.717665] Subtest syncobj-invalid-wait: SUCCESS (0.001s)
[250.043665] [114/130] (774s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[250.165963] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[250.166938] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[250.246333] [115/130] (774s left) gem_tiled_swapping (non-threaded)
[250.362529] Subtest non-threaded: SKIP (0.000s)
[250.404744] [116/130] (774s left) perf_pmu (idle)
[250.515270] Starting subtest: idle
[250.516217] Starting dynamic subtest: rcs0
[251.081759] Dynamic subtest rcs0: SUCCESS (0.565s)
[251.094614] Starting dynamic subtest: bcs0
[251.601676] Dynamic subtest bcs0: SUCCESS (0.516s)
[251.614642] Starting dynamic subtest: vcs0
[252.122611] Dynamic subtest vcs0: SUCCESS (0.517s)
[252.135461] Starting dynamic subtest: vcs1
[252.639606] Dynamic subtest vcs1: SUCCESS (0.513s)
[252.651613] Starting dynamic subtest: vecs0
[253.160577] Dynamic subtest vecs0: SUCCESS (0.517s)
[253.172608] Starting dynamic subtest: vecs1
[253.677596] Dynamic subtest vecs1: SUCCESS (0.513s)
[253.690607] Starting dynamic subtest: ccs0
[254.198597] Dynamic subtest ccs0: SUCCESS (0.517s)
[254.200489] Subtest idle: SUCCESS (3.684s)
[254.317938] [117/130] (770s left) kms_pm_rpm (modeset-non-lpsp)
[257.061219] Starting subtest: modeset-non-lpsp
[257.752279] Subtest modeset-non-lpsp: SUCCESS (0.691s)
[257.938984] [118/130] (766s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[258.219445] Starting subtest: modeset-atomic-cursor-hotspot
[258.221203] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[258.294149] [119/130] (766s left) gem_linear_blits (normal)
[258.555815] Starting subtest: normal
[265.147347] Subtest normal: SUCCESS (6.591s)
[265.339436] [120/130] (759s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-wc)
[265.690990] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-wc
[265.692811] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[265.778193] [121/130] (759s left) kms_hdr (static-toggle-dpms)
[266.057722] Starting subtest: static-toggle-dpms
[269.106542] Starting dynamic subtest: pipe-A-DP-4
[270.372172] Dynamic subtest pipe-A-DP-4: SUCCESS (1.266s)
[270.373183] Subtest static-toggle-dpms: SUCCESS (4.316s)
[270.642404] [122/130] (754s left) gem_exec_reloc (basic-write-gtt-noreloc)
[270.792454] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[270.840382] [123/130] (754s left) gem_mmap_offset (partial-mmap)
[270.958472] Starting subtest: partial-mmap
[270.959430] Starting dynamic subtest: lmem0
[270.964105] Dynamic subtest lmem0: SUCCESS (0.006s)
[270.974767] Starting dynamic subtest: smem0
[270.975887] Dynamic subtest smem0: SUCCESS (0.003s)
[270.977215] Subtest partial-mmap: SUCCESS (0.011s)
[271.127285] [124/130] (753s left) gem_exec_flush (basic-batch-kernel-default-uc)
[271.255074] Subtest basic-batch-kernel-default-uc: SKIP (0.000s)
[271.307102] [125/130] (753s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[271.575406] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[271.577125] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[271.671814] [126/130] (753s left) kms_invalid_mode (zero-clock)
[271.959141] Starting subtest: zero-clock
[271.960033] Starting dynamic subtest: pipe-A-DP-4
[272.031212] Dynamic subtest pipe-A-DP-4: SUCCESS (0.073s)
[272.043742] Starting dynamic subtest: pipe-B-DP-4
[272.044836] Dynamic subtest pipe-B-DP-4: SUCCESS (0.001s)
[272.055736] Starting dynamic subtest: pipe-C-DP-4
[272.056797] Dynamic subtest pipe-C-DP-4: SUCCESS (0.001s)
[272.067435] Starting dynamic subtest: pipe-D-DP-4
[272.068403] Dynamic subtest pipe-D-DP-4: SUCCESS (0.001s)
[272.069318] Subtest zero-clock: SUCCESS (0.082s)
[272.235970] [127/130] (752s left) syncobj_wait (wait-for-submit-complex)
[272.369062] Starting subtest: wait-for-submit-complex
[272.431731] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[272.512698] [128/130] (752s left) gem_exec_params (cliprects-invalid)
[272.642027] Starting subtest: cliprects-invalid
[272.642986] Subtest cliprects-invalid: SUCCESS (0.000s)
[272.780307] [129/130] (752s left) gem_ringfill (basic-all)
[273.290966] Starting subtest: basic-all
[275.087589] Subtest basic-all: SUCCESS (1.797s)
[275.243266] [130/130] (749s left) kms_properties (connector-properties-atomic)
[275.522360] Starting subtest: connector-properties-atomic
[275.523200] Starting dynamic subtest: pipe-A-DP-4
[277.001749] Dynamic subtest pipe-A-DP-4: SUCCESS (1.478s)
[277.015642] Starting dynamic subtest: pipe-None-DP-1
[277.017526] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[277.029780] Starting dynamic subtest: pipe-None-DP-2
[277.032012] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[277.043853] Starting dynamic subtest: pipe-None-HDMI-A-1
[277.046142] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[277.056149] Starting dynamic subtest: pipe-None-DP-3
[277.057953] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[277.067991] Starting dynamic subtest: pipe-None-HDMI-A-2
[277.069810] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[277.079652] Starting dynamic subtest: pipe-None-HDMI-A-3
[277.081070] Dynamic subtest pipe-None-HDMI-A-3: SUCCESS (0.001s)
[277.081765] Subtest connector-properties-atomic: SUCCESS (1.497s)
[277.200350] Closing watchdogs
Done.