[60.448165] Initializing watchdogs
[60.448222]   /dev/watchdog0
[60.456358] [001/130] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[60.682221] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[60.683997] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[60.783198] [002/130] (960s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-cpu)
[61.056448] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-cpu
[61.058276] Subtest psr-1p-offscren-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[61.176073] [003/130] (959s left) prime_busy (hang-wait)
[61.297067] Starting subtest: hang-wait
[61.298998] Starting dynamic subtest: rcs0
[87.501448] Dynamic subtest rcs0: SUCCESS (26.173s)
[87.508134] Starting dynamic subtest: bcs0
[94.654233] Dynamic subtest bcs0: SUCCESS (7.149s)
[94.660872] Starting dynamic subtest: vcs0
[101.638261] Dynamic subtest vcs0: SUCCESS (6.980s)
[101.644931] Starting dynamic subtest: vcs1
[108.670504] Dynamic subtest vcs1: SUCCESS (7.030s)
[108.677209] Starting dynamic subtest: vecs0
[115.649200] Dynamic subtest vecs0: SUCCESS (6.977s)
[115.655965] Starting dynamic subtest: vecs1
[122.697143] Dynamic subtest vecs1: SUCCESS (7.048s)
[122.703958] Starting dynamic subtest: ccs0
[136.523286] Dynamic subtest ccs0: SUCCESS (13.823s)
[136.524389] Subtest hang-wait: SUCCESS (75.182s)
[136.613968] [004/130] (884s left) gem_ctx_param (set-priority-range)
[136.681466] Starting subtest: set-priority-range
[136.704931] Subtest set-priority-range: SUCCESS (0.024s)
[136.843621] [005/130] (884s left) gem_partial_pwrite_pread (reads-uncached)
[136.938350] Subtest reads-uncached: SKIP (0.000s)
[136.977625] [006/130] (884s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[137.067193] Starting subtest: multi-wait-all-for-submit-available-submitted
[137.068168] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[137.193437] [007/130] (884s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[137.433843] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[137.435586] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[137.524092] [008/130] (883s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[137.789660] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[137.790542] Starting dynamic subtest: pipe-A-DP-4
[137.799549] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[137.806296] Starting dynamic subtest: pipe-B-DP-4
[137.815157] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[137.821952] Starting dynamic subtest: pipe-C-DP-4
[137.830395] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[137.836745] Starting dynamic subtest: pipe-D-DP-4
[137.845223] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[137.846955] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SKIP (0.003s)
[138.236951] [009/130] (883s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[138.522443] Starting subtest: fbc-tiling-linear
[140.896315] Subtest fbc-tiling-linear: SUCCESS (2.373s)
[141.073321] [010/130] (880s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[141.307267] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[141.309163] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[141.404875] [011/130] (879s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[141.670550] Starting subtest: cursorA-vs-flipA-toggle
[152.637542] Subtest cursorA-vs-flipA-toggle: SUCCESS (10.969s)
[152.861267] [012/130] (868s left) gem_eio (in-flight-internal-1us)
[153.165181] Starting subtest: in-flight-internal-1us
[154.912958] Subtest in-flight-internal-1us: SUCCESS (1.748s)
[155.146160] [013/130] (866s left) gem_exec_reloc (basic-write-wc-noreloc)
[155.233014] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[155.293317] [014/130] (866s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[155.543131] Starting subtest: fbcpsr-1p-rte
[155.544910] Subtest fbcpsr-1p-rte: SKIP (0.000s)
[155.636078] [015/130] (865s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[155.885510] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[155.886427] Starting dynamic subtest: pipe-A-valid-mode
[155.998503] Dynamic subtest pipe-A-valid-mode: SKIP (0.110s)
[156.000853] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.111s)
[156.176875] [016/130] (865s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-20x20)
[156.418521] Starting subtest: planes-downscale-factor-0-25-upscale-20x20
[156.419297] Starting dynamic subtest: pipe-A
[157.281841] Dynamic subtest pipe-A: SKIP (0.861s)
[157.289285] Starting dynamic subtest: pipe-B
[158.597183] Dynamic subtest pipe-B: SKIP (1.315s)
[158.604551] Starting dynamic subtest: pipe-C
[159.913261] Dynamic subtest pipe-C: SKIP (1.316s)
[159.920607] Starting dynamic subtest: pipe-D
[161.232247] Dynamic subtest pipe-D: SKIP (1.318s)
[161.233666] Subtest planes-downscale-factor-0-25-upscale-20x20: SKIP (4.813s)
[161.315457] [017/130] (860s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[161.555129] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[161.556886] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[161.649760] [018/130] (859s left) kms_psr (fbc-psr-cursor-blt)
[161.869718] Subtest fbc-psr-cursor-blt: SKIP (0.000s)
[161.896122] [019/130] (859s left) gem_exec_fence (parallel)
[162.092876] Starting subtest: parallel
[162.093840] Starting dynamic subtest: rcs0
[164.242143] Dynamic subtest rcs0: SUCCESS (2.153s)
[164.251513] Starting dynamic subtest: bcs0
[166.391511] Dynamic subtest bcs0: SUCCESS (2.148s)
[166.400888] Starting dynamic subtest: vcs0
[168.544954] Dynamic subtest vcs0: SUCCESS (2.152s)
[168.554593] Starting dynamic subtest: vcs1
[170.695201] Dynamic subtest vcs1: SUCCESS (2.149s)
[170.704494] Starting dynamic subtest: vecs0
[172.849381] Dynamic subtest vecs0: SUCCESS (2.153s)
[172.858707] Starting dynamic subtest: vecs1
[174.999955] Dynamic subtest vecs1: SUCCESS (2.149s)
[175.007806] Starting dynamic subtest: ccs0
[177.149499] Dynamic subtest ccs0: SUCCESS (2.149s)
[177.150415] Subtest parallel: SUCCESS (15.062s)
[177.872198] [020/130] (843s left) kms_sysfs_edid_timing
[180.101166] [021/130] (841s left) gem_exec_flush (basic-wb-pro-default)
[180.186427] Subtest basic-wb-pro-default: SKIP (0.000s)
[180.260226] [022/130] (841s left) perf_pmu (busy)
[180.356840] Starting subtest: busy
[180.357856] Starting dynamic subtest: rcs0
[180.991976] Dynamic subtest rcs0: SUCCESS (0.633s)
[181.005057] Starting dynamic subtest: bcs0
[181.555978] Dynamic subtest bcs0: SUCCESS (0.559s)
[181.568580] Starting dynamic subtest: vcs0
[182.116047] Dynamic subtest vcs0: SUCCESS (0.555s)
[182.128831] Starting dynamic subtest: vcs1
[182.681962] Dynamic subtest vcs1: SUCCESS (0.562s)
[182.696540] Starting dynamic subtest: vecs0
[183.241923] Dynamic subtest vecs0: SUCCESS (0.558s)
[183.255276] Starting dynamic subtest: vecs1
[183.803101] Dynamic subtest vecs1: SUCCESS (0.558s)
[183.815981] Starting dynamic subtest: ccs0
[184.368984] Dynamic subtest ccs0: SUCCESS (0.561s)
[184.374132] Subtest busy: SUCCESS (4.013s)
[184.473578] [023/130] (837s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[184.700119] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[184.701922] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[184.794808] [024/130] (836s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[185.150394] Starting subtest: cursor-rapid-movement-32x10
[185.204868] Subtest cursor-rapid-movement-32x10: SKIP (0.052s)
[185.567355] [025/130] (836s left) syncobj_timeline (reset-unsignaled)
[185.655113] Starting subtest: reset-unsignaled
[185.655998] Subtest reset-unsignaled: SUCCESS (0.000s)
[185.777356] [026/130] (836s left) drm_fdinfo (virtual-busy-hang-all)
[185.855185] Starting subtest: virtual-busy-hang-all
[185.857056] Subtest virtual-busy-hang-all: SKIP (0.000s)
[185.928296] [027/130] (835s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[186.160142] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[189.403082] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (3.242s)
[189.566427] [028/130] (832s left) gem_mmap_offset (basic-uaf)
[189.657377] Starting subtest: basic-uaf
[189.658366] Subtest basic-uaf: SUCCESS (0.000s)
[189.756673] [029/130] (832s left) gem_fenced_exec_thrash (no-spare-fences)
[189.846327] Subtest no-spare-fences: SKIP (0.000s)
[189.901069] [030/130] (832s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[190.143309] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[190.145042] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[190.259083] [031/130] (831s left) gem_exec_reloc (basic-cpu-noreloc)
[190.367667] Subtest basic-cpu-noreloc: SKIP (0.000s)
[190.414359] [032/130] (831s left) core_setmaster (master-drop-set-user)
[193.303429] Starting subtest: master-drop-set-user
[193.323481] Subtest master-drop-set-user: SUCCESS (0.021s)
[193.341193] [033/130] (828s left) gem_exec_balancer (noheartbeat)
[193.709136] Starting subtest: noheartbeat
[193.711184] Subtest noheartbeat: SKIP (0.000s)
[193.791902] [034/130] (828s left) gem_softpin (32b-excludes-last-page)
[193.868428] Starting subtest: 32b-excludes-last-page
[193.873083] Subtest 32b-excludes-last-page: SUCCESS (0.005s)
[194.033644] [035/130] (828s left) kms_chamelium_edid (dp-edid-read)
[194.363802] Subtest dp-edid-read: SKIP (0.000s)
[194.487738] [036/130] (827s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[194.742809] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[194.764306] [037/130] (827s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[194.992439] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[194.993399] Starting dynamic subtest: pipe-A-DP-4
[195.002101] Dynamic subtest pipe-A-DP-4: SKIP (0.001s)
[195.010936] Starting dynamic subtest: pipe-B-DP-4
[195.019521] Dynamic subtest pipe-B-DP-4: SKIP (0.001s)
[195.028195] Starting dynamic subtest: pipe-C-DP-4
[195.036837] Dynamic subtest pipe-C-DP-4: SKIP (0.001s)
[195.045492] Starting dynamic subtest: pipe-D-DP-4
[195.054970] Dynamic subtest pipe-D-DP-4: SKIP (0.001s)
[195.056931] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.009s)
[195.441224] [038/130] (826s left) gem_ctx_persistence (many-contexts)
[195.545110] Starting subtest: many-contexts
[233.234583] Subtest many-contexts: SUCCESS (37.686s)
[233.335307] [039/130] (788s left) gem_exec_schedule (u-submit-early-slice)
[233.423320] Starting subtest: u-submit-early-slice
[233.424264] Starting dynamic subtest: rcs0
[233.490129] Dynamic subtest rcs0: SUCCESS (0.066s)
[233.499399] Starting dynamic subtest: bcs0
[233.536509] Dynamic subtest bcs0: SUCCESS (0.045s)
[233.545671] Starting dynamic subtest: vcs0
[233.586056] Dynamic subtest vcs0: SUCCESS (0.048s)
[233.595270] Starting dynamic subtest: vcs1
[233.633206] Dynamic subtest vcs1: SUCCESS (0.046s)
[233.642372] Starting dynamic subtest: vecs0
[233.680200] Dynamic subtest vecs0: SUCCESS (0.046s)
[233.689180] Starting dynamic subtest: vecs1
[233.727290] Dynamic subtest vecs1: SUCCESS (0.046s)
[233.736490] Starting dynamic subtest: ccs0
[233.775921] Dynamic subtest ccs0: SUCCESS (0.048s)
[233.776907] Subtest u-submit-early-slice: SUCCESS (0.353s)
[234.241267] [040/130] (788s left) gem_ctx_param (invalid-param-get)
[234.311803] Starting subtest: invalid-param-get
[234.314219] Subtest invalid-param-get: SUCCESS (0.001s)
[234.452221] [041/130] (787s left) gem_ctx_isolation (preservation-s3)
[234.548384] Starting subtest: preservation-S3
[234.549369] Starting dynamic subtest: rcs0
[253.594965] Dynamic subtest rcs0: SUCCESS (4.153s)
[253.606293] Starting dynamic subtest: bcs0
[273.601399] Dynamic subtest bcs0: SUCCESS (3.900s)
[273.612504] Starting dynamic subtest: vcs0
[293.576614] Dynamic subtest vcs0: SUCCESS (3.892s)
[293.587284] Starting dynamic subtest: vcs1
[313.638868] Dynamic subtest vcs1: SUCCESS (3.849s)
[313.650406] Starting dynamic subtest: vecs0
[333.578965] Dynamic subtest vecs0: SUCCESS (3.821s)
[333.589736] Starting dynamic subtest: vecs1
[353.599713] Dynamic subtest vecs1: SUCCESS (3.810s)
[353.610199] Starting dynamic subtest: ccs0
[373.603588] Dynamic subtest ccs0: SUCCESS (3.874s)
[373.604566] Subtest preservation-S3: SUCCESS (27.307s)
[376.902551] [042/130] (760s left) gem_exec_reloc (basic-concurrent16)
[376.982800] Subtest basic-concurrent16: SKIP (0.000s)
[377.042571] [043/130] (760s left) kms_psr (psr-cursor-plane-onoff)
[377.267217] Subtest psr-cursor-plane-onoff: SKIP (0.000s)
[377.292060] [044/130] (759s left) kms_vrr (max-min)
[377.537731] Starting subtest: max-min
[377.540772] Subtest max-min: SKIP (0.000s)
[377.596030] [045/130] (759s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[377.836985] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[377.840457] Starting dynamic subtest: pipe-A-DP-4
[377.849767] Dynamic subtest pipe-A-DP-4: SUCCESS (0.001s)
[377.863776] Starting dynamic subtest: pipe-B-DP-4
[377.871755] Dynamic subtest pipe-B-DP-4: SUCCESS (0.001s)
[377.882271] Starting dynamic subtest: pipe-C-DP-4
[377.889698] Dynamic subtest pipe-C-DP-4: SUCCESS (0.001s)
[377.899820] Starting dynamic subtest: pipe-D-DP-4
[377.907555] Dynamic subtest pipe-D-DP-4: SUCCESS (0.001s)
[377.908473] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SUCCESS (0.016s)
[378.274947] [046/130] (758s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[378.536983] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[378.538941] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[378.636639] [047/130] (758s left) gem_gtt_cpu_tlb
[378.778286] [048/130] (758s left) gen7_exec_parse (oacontrol-tracking)
[378.877360] Subtest oacontrol-tracking: SKIP (0.000s)
[378.922467] [049/130] (758s left) kms_sequence (queue-idle)
[379.155086] Starting subtest: queue-idle
[379.157742] Starting dynamic subtest: pipe-A-DP-4
[381.515413] Dynamic subtest pipe-A-DP-4: SUCCESS (2.358s)
[381.531948] Starting dynamic subtest: pipe-B-DP-4
[383.828520] Dynamic subtest pipe-B-DP-4: SUCCESS (2.311s)
[383.840974] Starting dynamic subtest: pipe-C-DP-4
[386.120583] Dynamic subtest pipe-C-DP-4: SUCCESS (2.290s)
[386.133203] Starting dynamic subtest: pipe-D-DP-4
[388.421470] Dynamic subtest pipe-D-DP-4: SUCCESS (2.299s)
[388.422481] Subtest queue-idle: SUCCESS (9.265s)
[388.658650] [050/130] (748s left) gem_pxp (verify-pxp-stale-ctx-execution)
[391.282001] Starting subtest: verify-pxp-stale-ctx-execution
[391.284457] Subtest verify-pxp-stale-ctx-execution: SKIP (0.000s)
[391.368401] [051/130] (746s left) gem_ctx_engines (execute-allforone)
[391.455466] Starting subtest: execute-allforone
[391.487567] Subtest execute-allforone: SUCCESS (0.032s)
[391.768709] [052/130] (745s left) perf (oa-exponents)
[392.164218] Starting subtest: oa-exponents
[392.165131] Starting dynamic subtest: 0-rcs0
[394.414143] Dynamic subtest 0-rcs0: SUCCESS (2.250s)
[394.415112] Subtest oa-exponents: SUCCESS (2.251s)
[394.453292] [053/130] (743s left) kms_psr (fbc-pr-cursor-render)
[394.800099] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[394.831509] [054/130] (742s left) kms_plane (plane-position-hole)
[395.113501] Starting subtest: plane-position-hole
[395.565580] Starting dynamic subtest: pipe-A-plane-1
[396.043108] Dynamic subtest pipe-A-plane-1: SUCCESS (0.477s)
[396.066836] Starting dynamic subtest: pipe-A-plane-2
[396.558559] Dynamic subtest pipe-A-plane-2: SUCCESS (0.513s)
[396.581013] Starting dynamic subtest: pipe-A-plane-3
[397.049707] Dynamic subtest pipe-A-plane-3: SUCCESS (0.489s)
[397.065794] Starting dynamic subtest: pipe-A-plane-4
[397.540123] Dynamic subtest pipe-A-plane-4: SUCCESS (0.489s)
[397.554805] Starting dynamic subtest: pipe-A-plane-5
[397.560456] Dynamic subtest pipe-A-plane-5: SUCCESS (0.019s)
[397.904283] Starting dynamic subtest: pipe-B-plane-1
[398.322875] Dynamic subtest pipe-B-plane-1: SUCCESS (0.435s)
[398.334347] Starting dynamic subtest: pipe-B-plane-2
[398.733709] Dynamic subtest pipe-B-plane-2: SUCCESS (0.411s)
[398.745067] Starting dynamic subtest: pipe-B-plane-3
[399.196581] Dynamic subtest pipe-B-plane-3: SUCCESS (0.462s)
[399.207766] Starting dynamic subtest: pipe-B-plane-4
[399.647857] Dynamic subtest pipe-B-plane-4: SUCCESS (0.450s)
[399.664233] Starting dynamic subtest: pipe-B-plane-5
[399.670579] Dynamic subtest pipe-B-plane-5: SUCCESS (0.021s)
[399.671549] Subtest plane-position-hole: SUCCESS (4.557s)
[399.924511] [055/130] (737s left) gem_ccs (suspend-resume)
[400.066873] Starting subtest: suspend-resume
[400.069242] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0
[418.094002] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (3.972s)
[418.104806] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0
[436.200272] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.745s)
[436.211663] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0
[454.101665] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (3.617s)
[454.115614] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0
[472.211686] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.738s)
[472.222701] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0
[490.092703] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (3.752s)
[490.106014] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0