[29.585666] Initializing watchdogs
[29.585725]   /dev/watchdog0
[29.592577] [001/130] (960s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[29.823767] Starting subtest: basic-busy-flip-before-cursor-varying-size
[29.825296] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[29.875323] [002/130] (960s left) kms_flip (plain-flip-interruptible)
[30.105184] Starting subtest: plain-flip-interruptible
[30.110474] Starting dynamic subtest: A-DP4
[30.966580] Dynamic subtest A-DP4: SUCCESS (0.855s)
[30.977173] Starting dynamic subtest: B-DP4
[31.724927] Dynamic subtest B-DP4: SUCCESS (0.757s)
[31.733895] Starting dynamic subtest: C-DP4
[32.458535] Dynamic subtest C-DP4: SUCCESS (0.733s)
[32.465760] Starting dynamic subtest: D-DP4
[33.197281] Dynamic subtest D-DP4: SUCCESS (0.737s)
[33.203164] Subtest plain-flip-interruptible: SUCCESS (3.093s)
[33.530580] [003/130] (956s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[33.776534] Starting subtest: multiplane-rotation-cropping-bottom
[45.369059] Subtest multiplane-rotation-cropping-bottom: SUCCESS (11.596s)
[45.446816] [004/130] (944s left) gem_flink_race (flink_name)
[45.517942] Starting subtest: flink_name
[50.846619] Subtest flink_name: SUCCESS (5.387s)
[50.938931] [005/130] (939s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[51.246941] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[51.248506] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[51.338736] [006/130] (938s left) kms_atomic (plane-invalid-params)
[51.586036] Starting subtest: plane-invalid-params
[51.586864] Starting dynamic subtest: pipe-A-DP-4
[52.418064] Dynamic subtest pipe-A-DP-4: SUCCESS (0.836s)
[52.418976] Subtest plane-invalid-params: SUCCESS (0.838s)
[52.657540] [007/130] (937s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[52.911112] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[52.912665] Subtest psr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[53.003577] [008/130] (937s left) gem_ctx_param (non-root-set)
[53.106198] Starting subtest: non-root-set
[53.128973] Subtest non-root-set: SUCCESS (0.023s)
[53.237598] [009/130] (937s left) gem_exec_store (basic)
[53.339617] Starting subtest: basic
[53.489314] Subtest basic: SUCCESS (0.150s)
[53.714452] [010/130] (936s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[53.954897] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[54.605782] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.654s)
[54.754654] [011/130] (935s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[55.010694] Starting subtest: flip-vs-cursor-legacy
[64.425167] Subtest flip-vs-cursor-legacy: SUCCESS (9.436s)
[64.676762] [012/130] (925s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[64.777486] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[64.820812] [013/130] (925s left) kms_flip (2x-flip-vs-panning)
[65.044805] Starting subtest: 2x-flip-vs-panning
[65.058142] Subtest 2x-flip-vs-panning: SKIP (0.013s)
[65.124397] [014/130] (925s left) kms_pm_dc (dc5-psr)
[65.356889] Starting subtest: dc5-psr
[65.359340] Subtest dc5-psr: SKIP (0.000s)
[65.424179] [015/130] (924s left) gem_lmem_swapping (heavy-verify-random)
[69.549379] Starting subtest: heavy-verify-random
[69.550379] Starting dynamic subtest: lmem0
[83.318125] Dynamic subtest lmem0: SUCCESS (13.773s)
[83.320406] Subtest heavy-verify-random: SUCCESS (13.773s)
[85.531317] [016/130] (904s left) sysfs_preempt_timeout (idempotent)
[86.994945] Starting subtest: idempotent
[86.997337] Starting dynamic subtest: vecs0
[86.998220] Dynamic subtest vecs0: SUCCESS (0.001s)
[87.008614] Starting dynamic subtest: ccs0
[87.009532] Dynamic subtest ccs0: SUCCESS (0.001s)
[87.021822] Starting dynamic subtest: vcs0
[87.022681] Dynamic subtest vcs0: SUCCESS (0.001s)
[87.035596] Starting dynamic subtest: bcs0
[87.036479] Dynamic subtest bcs0: SUCCESS (0.002s)
[87.046906] Starting dynamic subtest: vecs1
[87.047706] Dynamic subtest vecs1: SUCCESS (0.001s)
[87.056666] Starting dynamic subtest: rcs0
[87.057590] Dynamic subtest rcs0: SUCCESS (0.001s)
[87.066325] Starting dynamic subtest: vcs1
[87.067196] Dynamic subtest vcs1: SUCCESS (0.005s)
[87.068070] Subtest idempotent: SUCCESS (0.020s)
[87.081413] [017/130] (903s left) gem_render_copy (y-tiled-ccs-to-linear)
[87.181662] Starting subtest: y-tiled-ccs-to-linear
[87.183345] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[87.394372] [018/130] (903s left) syncobj_timeline (invalid-transfer-illegal-handle)
[87.487493] Starting subtest: invalid-transfer-illegal-handle
[87.488321] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[87.566505] [019/130] (902s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[87.806842] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[87.834794] [020/130] (902s left) gem_exec_reloc (basic-write-wc-active)
[87.909489] Subtest basic-write-wc-active: SKIP (0.000s)
[87.953459] [021/130] (902s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[88.186224] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[88.187869] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[88.291124] [022/130] (902s left) gem_ctx_isolation (nonpriv-switch)
[88.411906] Starting subtest: nonpriv-switch
[88.412757] Starting dynamic subtest: rcs0
[89.235408] Dynamic subtest rcs0: SUCCESS (0.823s)
[89.244835] Starting dynamic subtest: bcs0
[90.089827] Dynamic subtest bcs0: SUCCESS (0.854s)
[90.096955] Starting dynamic subtest: vcs0
[90.934693] Dynamic subtest vcs0: SUCCESS (0.844s)
[90.941787] Starting dynamic subtest: vcs1
[91.758669] Dynamic subtest vcs1: SUCCESS (0.823s)
[91.765633] Starting dynamic subtest: vecs0
[92.623719] Dynamic subtest vecs0: SUCCESS (0.865s)
[92.630717] Starting dynamic subtest: vecs1
[93.463567] Dynamic subtest vecs1: SUCCESS (0.840s)
[93.470604] Starting dynamic subtest: ccs0
[94.290472] Dynamic subtest ccs0: SUCCESS (0.827s)
[94.291307] Subtest nonpriv-switch: SUCCESS (5.879s)
[94.541316] [023/130] (896s left) fbdev (pan)
[94.597399] Starting subtest: pan
[94.642443] Subtest pan: SUCCESS (0.045s)
[94.732558] [024/130] (895s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[94.984739] Starting subtest: basic-flip-before-cursor-legacy
[96.020334] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.035s)
[96.256156] [025/130] (894s left) gem_ctx_param (set-priority-range)
[96.355199] Starting subtest: set-priority-range
[96.379110] Subtest set-priority-range: SUCCESS (0.024s)
[96.512800] [026/130] (894s left) kms_flip (flip-vs-panning)
[96.740868] Starting subtest: flip-vs-panning
[96.744980] Starting dynamic subtest: A-DP4
[104.612639] Dynamic subtest A-DP4: SUCCESS (7.868s)
[104.622231] Starting dynamic subtest: B-DP4
[112.418024] Dynamic subtest B-DP4: SUCCESS (7.805s)
[112.426401] Starting dynamic subtest: C-DP4
[120.254075] Dynamic subtest C-DP4: SUCCESS (7.835s)
[120.261996] Starting dynamic subtest: D-DP4
[128.063557] Dynamic subtest D-DP4: SUCCESS (7.808s)
[128.068466] Subtest flip-vs-panning: SUCCESS (31.326s)
[128.327395] [027/130] (862s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[128.573476] Starting subtest: fbcpsr-shrfb-scaledprimary
[128.575054] Subtest fbcpsr-shrfb-scaledprimary: SKIP (0.000s)
[128.658021] [028/130] (862s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[128.900035] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[128.901578] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[128.999813] [029/130] (861s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[129.364139] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[129.485120] [030/130] (861s left) gem_mmap_gtt (basic-small-bo-tiledx)
[129.560617] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[129.600258] [031/130] (861s left) kms_cursor_crc (cursor-offscreen-max-size)
[130.071291] Starting subtest: cursor-offscreen-max-size
[130.073524] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[130.248053] [032/130] (860s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[130.336574] Starting subtest: etime-single-wait-available-unsubmitted
[130.439595] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.102s)
[130.509934] [033/130] (860s left) gem_exec_balancer (bonded-semaphore)
[130.588481] Starting subtest: bonded-semaphore
[130.590077] Subtest bonded-semaphore: SKIP (0.000s)
[130.919360] [034/130] (859s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[131.147497] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[131.148322] Starting dynamic subtest: pipe-A-DP-4
[131.168637] Dynamic subtest pipe-A-DP-4: SKIP (0.002s)
[131.175876] Starting dynamic subtest: pipe-B-DP-4
[131.195784] Dynamic subtest pipe-B-DP-4: SKIP (0.002s)
[131.202904] Starting dynamic subtest: pipe-C-DP-4
[131.222279] Dynamic subtest pipe-C-DP-4: SKIP (0.002s)
[131.229306] Starting dynamic subtest: pipe-D-DP-4
[131.249199] Dynamic subtest pipe-D-DP-4: SKIP (0.002s)
[131.250810] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.013s)
[131.558942] [035/130] (859s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[131.803196] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[131.804858] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[131.928686] [036/130] (859s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[132.179500] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[132.182155] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.002s)
[132.233490] [037/130] (858s left) kms_fence_pin_leak
[132.512821] [038/130] (858s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[132.738845] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[132.762491] [039/130] (858s left) gem_create (create-ext-set-pat)
[132.954085] Starting subtest: create-ext-set-pat
[132.956615] Subtest create-ext-set-pat: SKIP (0.000s)
[133.050113] [040/130] (858s left) kms_lease (lease-revoke)
[133.283940] Starting subtest: lease-revoke
[133.284774] Starting dynamic subtest: pipe-A-DP-4
[133.421140] Dynamic subtest pipe-A-DP-4: SUCCESS (0.137s)
[133.429719] Starting dynamic subtest: pipe-B-DP-4
[133.527582] Dynamic subtest pipe-B-DP-4: SUCCESS (0.105s)
[133.535995] Starting dynamic subtest: pipe-C-DP-4
[133.629870] Dynamic subtest pipe-C-DP-4: SUCCESS (0.101s)
[133.638468] Starting dynamic subtest: pipe-D-DP-4
[133.735476] Dynamic subtest pipe-D-DP-4: SUCCESS (0.104s)
[133.736755] Subtest lease-revoke: SUCCESS (0.453s)
[133.857197] [041/130] (857s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[134.135674] Starting subtest: 4-tiled-32bpp-rotate-180
[135.770665] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.634s)
[135.901762] [042/130] (855s left) gem_pxp (reject-modify-context-protection-off-2)
[138.497720] Subtest reject-modify-context-protection-off-2: SKIP (0.000s)
[138.559311] [043/130] (852s left) kms_chamelium_color (ctm-green-to-red)
[138.781322] Subtest ctm-green-to-red: SKIP (0.000s)
[138.812867] [044/130] (852s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[139.043271] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[139.044857] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[139.145781] [045/130] (852s left) kms_feature_discovery (display-3x)
[139.403211] Starting subtest: display-3x
[139.404818] Subtest display-3x: SKIP (0.000s)
[139.471796] [046/130] (851s left) kms_plane_alpha_blend (constant-alpha-min)
[139.712929] Starting subtest: constant-alpha-min
[139.928933] Starting dynamic subtest: pipe-A-DP-4
[140.609787] Dynamic subtest pipe-A-DP-4: SUCCESS (0.680s)
[140.617254] Starting dynamic subtest: pipe-D-DP-4
[141.376814] Dynamic subtest pipe-D-DP-4: SUCCESS (0.765s)
[141.377609] Subtest constant-alpha-min: SUCCESS (1.664s)
[141.594660] [047/130] (849s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[141.910939] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[142.027809] [048/130] (849s left) gem_ctx_persistence (processes)
[142.108466] Starting subtest: processes
[143.892280] Subtest processes: SUCCESS (1.783s)
[144.005748] [049/130] (847s left) prime_vgem (basic-fence-read)
[144.184926] Starting subtest: basic-fence-read
[144.191539] Subtest basic-fence-read: SKIP (0.006s)
[144.342452] [050/130] (847s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[144.587290] Starting subtest: psr-indfb-scaledprimary
[144.588878] Subtest psr-indfb-scaledprimary: SKIP (0.000s)
[144.692276] [051/130] (846s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-render)
[144.944265] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-render
[144.945897] Subtest fbcpsr-1p-offscren-pri-indfb-draw-render: SKIP (0.000s)
[145.039725] [052/130] (846s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[145.301891] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[145.303920] Starting dynamic subtest: pipe-A-DP-4
[145.312181] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[145.320133] Starting dynamic subtest: pipe-B-DP-4
[145.327741] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[145.335419] Starting dynamic subtest: pipe-C-DP-4
[145.342961] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[145.350599] Starting dynamic subtest: pipe-D-DP-4
[145.358269] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[145.359840] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SKIP (0.005s)
[145.724048] [053/130] (845s left) gem_softpin (full)
[145.818541] Starting subtest: full
[145.831309] Subtest full: SUCCESS (0.013s)
[145.990590] [054/130] (845s left) dmabuf_sync_file (import-multiple-read-only)
[146.077982] Starting subtest: import-multiple-read-only
[146.081652] Subtest import-multiple-read-only: SUCCESS (0.004s)
[146.131842] [055/130] (845s left) kms_getfb (getfb-repeated-different-handles)
[146.210952] Starting subtest: getfb-repeated-different-handles
[146.211813] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[146.341436] [056/130] (845s left) syncobj_timeline (reset-during-wait-for-submit)
[146.425677] Starting subtest: reset-during-wait-for-submit
[146.527646] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[146.593199] [057/130] (845s left) gem_mmap_wc (coherency)
[146.673787] Subtest coherency: SKIP (0.000s)
[146.725193] [058/130] (844s left) kms_rotation_crc (primary-rotation-180)
[146.964041] Starting subtest: primary-rotation-180
[157.408101] Subtest primary-rotation-180: SUCCESS (10.444s)
[157.754050] [059/130] (833s left) kms_vblank (wait-busy)
[158.017052] Starting subtest: wait-busy
[158.017923] Starting dynamic subtest: pipe-A-DP-4
[160.492844] Dynamic subtest pipe-A-DP-4: SUCCESS (2.473s)
[160.515339] Starting dynamic subtest: pipe-D-DP-4
[162.941617] Dynamic subtest pipe-D-DP-4: SUCCESS (2.443s)
[162.942532] Subtest wait-busy: SUCCESS (4.926s)
[163.153843] [060/130] (828s left) kms_plane_multiple (tiling-none)
[163.411542] Starting subtest: tiling-none
[163.413668] Starting dynamic subtest: pipe-A-DP-4
[164.529915] Dynamic subtest pipe-A-DP-4: SUCCESS (1.117s)
[164.541202] Starting dynamic subtest: pipe-B-DP-4
[165.610820] Dynamic subtest pipe-B-DP-4: SUCCESS (1.074s)
[165.619067] Starting dynamic subtest: pipe-C-DP-4
[166.682768] Dynamic subtest pipe-C-DP-4: SUCCESS (1.076s)
[166.694048] Starting dynamic subtest: pipe-D-DP-4
[167.767477] Dynamic subtest pipe-D-DP-4: SUCCESS (1.083s)
[167.768661] Subtest tiling-none: SUCCESS (4.357s)
[168.064476] [061/130] (823s left) gem_exec_reloc (basic-gtt-cpu)
[168.163007] Subtest basic-gtt-cpu: SKIP (0.000s)
[168.229439] [062/130] (823s left) kms_pm_rpm (modeset-non-lpsp-stress)
[170.821805] Starting subtest: modeset-non-lpsp-stress
[185.821375] Subtest modeset-non-lpsp-stress: SUCCESS (15.000s)
[186.006008] [063/130] (805s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[186.242570] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[186.244136] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[186.367767] [064/130] (805s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[186.478148] Starting subtest: mixed-tiled-to-y-tiled-ccs
[186.479751] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[186.696732] [065/130] (805s left) perf (invalid-oa-metric-set-id)
[187.089405] Starting subtest: invalid-oa-metric-set-id
[187.107609] Subtest invalid-oa-metric-set-id: SUCCESS (0.017s)
[187.138786] [066/130] (804s left) perf_pmu (most-busy-idle-check-all)
[187.284235] Starting subtest: most-busy-idle-check-all
[187.285137] Starting dynamic subtest: rcs0
[187.994118] Dynamic subtest rcs0: FAIL (0.684s)
[188.007126] Starting dynamic subtest: bcs0
[188.648824] Dynamic subtest bcs0: SUCCESS (0.676s)
[188.687181] Starting dynamic subtest: vcs0
[189.319810] Dynamic subtest vcs0: SUCCESS (0.668s)
[189.329054] Starting dynamic subtest: vcs1
[189.974159] Dynamic subtest vcs1: SUCCESS (0.652s)
[189.987423] Starting dynamic subtest: vecs0
[190.630710] Dynamic subtest vecs0: SUCCESS (0.653s)
[190.639950] Starting dynamic subtest: vecs1
[191.285750] Dynamic subtest vecs1: SUCCESS (0.654s)
[191.294969] Starting dynamic subtest: ccs0
[191.938709] Dynamic subtest ccs0: SUCCESS (0.652s)
[191.939474] Subtest most-busy-idle-check-all: FAIL (4.655s)
[192.065915] [067/130] (799s left) gem_ccs (large-ctrl-surf-copy)
[192.196858] Starting subtest: large-ctrl-surf-copy
[192.856120] Subtest large-ctrl-surf-copy: SUCCESS (0.659s)
[192.978156] [068/130] (799s left) gem_softpin (allocator-evict)
[193.104098] Starting subtest: allocator-evict
[193.104948] Starting dynamic subtest: rcs0
[219.565346] Dynamic subtest rcs0: SUCCESS (26.460s)
[219.574937] Starting dynamic subtest: bcs0
[245.925412] Dynamic subtest bcs0: SUCCESS (26.359s)
[245.935059] Starting dynamic subtest: vcs0
[272.743401] Dynamic subtest vcs0: SUCCESS (26.817s)
[272.752837] Starting dynamic subtest: vcs1
[299.606416] Dynamic subtest vcs1: SUCCESS (26.861s)
[299.616147] Starting dynamic subtest: vecs0
[326.218375] Dynamic subtest vecs0: SUCCESS (26.610s)
[326.227953] Starting dynamic subtest: vecs1
[352.775734] Dynamic subtest vecs1: SUCCESS (26.556s)
[352.785965] Starting dynamic subtest: ccs0
[379.219449] Dynamic subtest ccs0: SUCCESS (26.442s)
[379.220283] Subtest allocator-evict: SUCCESS (186.112s)
[379.349237] [069/130] (612s left) syncobj_timeline (32bits-limit)
[379.537250] Starting subtest: 32bits-limit
[379.538167] Subtest 32bits-limit: SUCCESS (0.001s)
[379.631808] [070/130] (612s left) gem_exec_balancer (invalid-bonds)
[379.765275] Starting subtest: invalid-bonds
[379.767008] Subtest invalid-bonds: SKIP (0.000s)
[380.083828] [071/130] (611s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[380.354182] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[380.355012] Starting dynamic subtest: pipe-A-DP-4
[380.363189] Dynamic subtest pipe-A-DP-4: SKIP (0.001s)
[380.373849] Starting dynamic subtest: pipe-B-DP-4
[380.381594] Dynamic subtest pipe-B-DP-4: SKIP (0.001s)
[380.391862] Starting dynamic subtest: pipe-C-DP-4
[380.399288] Dynamic subtest pipe-C-DP-4: SKIP (0.001s)
[380.408721] Starting dynamic subtest: pipe-D-DP-4
[380.416540] Dynamic subtest pipe-D-DP-4: SKIP (0.001s)
[380.418142] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.010s)
[380.740976] [072/130] (611s left) syncobj_wait (wait-any-interrupted)
[380.884096] Starting subtest: wait-any-interrupted
[380.986323] Subtest wait-any-interrupted: SUCCESS (0.102s)
[381.056115] [073/130] (611s left) gen9_exec_parse (batch-zero-length)
[381.190186] Subtest batch-zero-length: SKIP (0.000s)
[381.226670] [074/130] (610s left) kms_cursor_crc (cursor-size-hints)
[381.539423] Starting subtest: cursor-size-hints
[381.541748] Starting dynamic subtest: pipe-A-DP-4
[382.060817] Dynamic subtest pipe-A-DP-4: SUCCESS (0.520s)
[382.073929] Starting dynamic subtest: pipe-D-DP-4
[382.565232] Dynamic subtest pipe-D-DP-4: SUCCESS (0.502s)
[382.566102] Subtest cursor-size-hints: SUCCESS (1.026s)
[383.006915] [075/130] (609s left) i915_pm_rpm (system-suspend-devices)
[385.755987] Starting subtest: system-suspend-devices
[393.747998] Subtest system-suspend-devices: SUCCESS (7.996s)
[396.171153] [076/130] (597s left) api_intel_bb (reset-flags)
[396.292193] Starting subtest: reset-flags
[396.324763] Subtest reset-flags: SUCCESS (0.033s)
[396.492674] [077/130] (597s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[396.772148] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[396.772965] Starting dynamic subtest: pipe-A-valid-mode
[396.855420] Dynamic subtest pipe-A-valid-mode: SKIP (0.081s)
[396.857168] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.083s)
[397.021176] [078/130] (597s left) kms_pipe_crc_basic (bad-source)
[397.312349] Starting subtest: bad-source
[397.313177] Subtest bad-source: SUCCESS (0.000s)
[397.371027] [079/130] (596s left) api_intel_allocator (fork-simple-stress)
[397.489131] Starting subtest: fork-simple-stress
[402.911706] Subtest fork-simple-stress: SUCCESS (5.423s)
[402.992014] [080/130] (591s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[403.310216] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[403.311334] Starting dynamic subtest: pipe-A-DP-4
[403.319478] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[403.330270] Starting dynamic subtest: pipe-B-DP-4
[403.337982] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[403.348566] Starting dynamic subtest: pipe-C-DP-4
[403.356055] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[403.366478] Starting dynamic subtest: pipe-D-DP-4
[403.374268] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[403.375887] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[403.722927] [081/130] (590s left) vgem_basic (second-client)
[403.859597] Starting subtest: second-client
[403.892681] Subtest second-client: SUCCESS (0.033s)
[403.947340] [082/130] (590s left) gem_softpin (noreloc-interruptible)
[404.075225] Starting subtest: noreloc-interruptible
[409.501778] Subtest noreloc-interruptible: SUCCESS (5.426s)
[409.598224] [083/130] (584s left) gem_wait (wait)
[409.734728] Starting subtest: wait
[409.735608] Starting dynamic subtest: all-engines
[410.829743] Dynamic subtest all-engines: SUCCESS (1.094s)
[410.845035] Starting dynamic subtest: rcs0
[411.880646] Dynamic subtest rcs0: SUCCESS (1.048s)
[411.895404] Starting dynamic subtest: bcs0
[412.933676] Dynamic subtest bcs0: SUCCESS (1.049s)
[412.948516] Starting dynamic subtest: vcs0
[413.987806] Dynamic subtest vcs0: SUCCESS (1.050s)
[414.002546] Starting dynamic subtest: vcs1
[415.042511] Dynamic subtest vcs1: SUCCESS (1.050s)
[415.057187] Starting dynamic subtest: vecs0
[416.095781] Dynamic subtest vecs0: SUCCESS (1.049s)
[416.112317] Starting dynamic subtest: vecs1
[417.150547] Dynamic subtest vecs1: SUCCESS (1.050s)
[417.194997] Starting dynamic subtest: ccs0
[418.206661] Dynamic subtest ccs0: SUCCESS (1.052s)
[418.212561] Subtest wait: SUCCESS (8.473s)
[418.484954] [084/130] (575s left) gem_exec_schedule (preempt)
[418.628275] Starting subtest: preempt
[418.629121] Starting dynamic subtest: rcs0
[418.689208] Dynamic subtest rcs0: SUCCESS (0.060s)
[418.700227] Starting dynamic subtest: bcs0
[418.718611] Dynamic subtest bcs0: SUCCESS (0.029s)
[418.730520] Starting dynamic subtest: vcs0
[418.748872] Dynamic subtest vcs0: SUCCESS (0.029s)
[418.760832] Starting dynamic subtest: vcs1
[418.778754] Dynamic subtest vcs1: SUCCESS (0.029s)
[418.791035] Starting dynamic subtest: vecs0
[418.808919] Dynamic subtest vecs0: SUCCESS (0.029s)
[418.819943] Starting dynamic subtest: vecs1
[418.839082] Dynamic subtest vecs1: SUCCESS (0.029s)
[418.851451] Starting dynamic subtest: ccs0
[418.869959] Dynamic subtest ccs0: SUCCESS (0.030s)
[418.870813] Subtest preempt: SUCCESS (0.242s)
[419.290954] [085/130] (575s left) i915_hangman (gt-engine-hang)
[419.446238] Starting subtest: gt-engine-hang
[419.447154] Starting dynamic subtest: rcs0
[420.226405] Dynamic subtest rcs0: SUCCESS (0.780s)
[420.239782] Starting dynamic subtest: bcs0
[420.981568] Dynamic subtest bcs0: SUCCESS (0.754s)
[420.998126] Starting dynamic subtest: vcs0
[421.709357] Dynamic subtest vcs0: SUCCESS (0.726s)
[421.722073] Starting dynamic subtest: vcs1
[422.448544] Dynamic subtest vcs1: SUCCESS (0.738s)
[422.467741] Starting dynamic subtest: vecs0
[423.179199] Dynamic subtest vecs0: SUCCESS (0.729s)
[423.192252] Starting dynamic subtest: vecs1
[423.908449] Dynamic subtest vecs1: SUCCESS (0.728s)
[423.922157] Starting dynamic subtest: ccs0
[424.742534] Dynamic subtest ccs0: SUCCESS (0.832s)
[424.744553] Subtest gt-engine-hang: SUCCESS (5.298s)
[424.865476] [086/130] (569s left) gem_exec_params (mmapped)
[424.993048] Starting subtest: mmapped
[424.995208] Subtest mmapped: SUCCESS (0.001s)
[425.166359] [087/130] (569s left) kms_big_fb (linear-32bpp-rotate-0)
[425.471262] Starting subtest: linear-32bpp-rotate-0
[427.227876] Subtest linear-32bpp-rotate-0: SUCCESS (1.755s)
[427.427221] [088/130] (567s left) gem_partial_pwrite_pread (write)
[427.558314] Subtest write: SKIP (0.000s)
[427.648253] [089/130] (567s left) kms_chamelium_hpd (hdmi-hpd-fast)
[428.001612] Subtest hdmi-hpd-fast: SKIP (0.000s)
[428.128284] [090/130] (566s left) kms_psr (psr2-primary-page-flip)
[428.418316] Subtest psr2-primary-page-flip: SKIP (0.000s)
[428.450602] [091/130] (566s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[428.729524] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[428.750378] [092/130] (565s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[429.030048] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[429.031595] Subtest fbcpsr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[429.140350] [093/130] (565s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[429.434123] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[429.434940] Starting dynamic subtest: pipe-A-valid-mode
[429.511605] Dynamic subtest pipe-A-valid-mode: SKIP (0.076s)
[429.513199] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.078s)
[429.670072] [094/130] (565s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[429.998776] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[430.000339] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[430.117270] [095/130] (564s left) kms_writeback (writeback-fb-id-xrgb2101010)
[430.405077] Subtest writeback-fb-id-XRGB2101010: SKIP (0.000s)
[430.437668] [096/130] (564s left) i915_selftest (perf)
[432.694511] Starting subtest: perf
[432.696032] Starting dynamic subtest: engine_cs
[434.361171] Dynamic subtest engine_cs: SUCCESS (1.666s)
[434.379101] Starting dynamic subtest: request
[439.032056] Dynamic subtest request: SUCCESS (4.669s)
[439.046836] Starting dynamic subtest: migrate
[440.645726] Dynamic subtest migrate: SUCCESS (1.612s)
[440.654780] Starting dynamic subtest: region
[470.298112] Dynamic subtest region: SUCCESS (29.651s)
[470.299076] Subtest perf: SUCCESS (37.604s)
[470.318814] [097/130] (524s left) gem_mmap (pf-nonblock)
[471.767997] Subtest pf-nonblock: SKIP (0.000s)
[471.822054] [098/130] (523s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[472.071453] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[472.073092] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[472.162616] [099/130] (522s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[472.387534] Starting subtest: plane-all-transition-nonblocking-fencing
[472.389852] Starting dynamic subtest: pipe-A-DP-4
[476.104810] Dynamic subtest pipe-A-DP-4: SUCCESS (3.715s)
[476.197070] Starting dynamic subtest: pipe-B-DP-4
[479.966307] Dynamic subtest pipe-B-DP-4: SUCCESS (3.781s)
[480.021027] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (7.633s)
[480.238477] [100/130] (514s left) gem_sync (basic-store-all)
[480.348664] Starting subtest: basic-store-all
[485.562883] Subtest basic-store-all: SUCCESS (5.214s)
[485.754741] [101/130] (509s left) kms_plane_scaling (invalid-parameters)
[485.982168] Starting subtest: invalid-parameters
[485.983028] Starting dynamic subtest: less-than-1-height-src
[485.994768] Dynamic subtest less-than-1-height-src: SUCCESS (0.013s)
[486.004519] Starting dynamic subtest: less-than-1-width-src
[486.008743] Dynamic subtest less-than-1-width-src: SUCCESS (0.013s)
[486.009540] Subtest invalid-parameters: SUCCESS (0.027s)
[486.128207] [102/130] (508s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[486.228698] Starting subtest: invalid-bsd2-flag-on-vebox
[486.229510] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[486.362488] [103/130] (508s left) kms_psr (fbc-psr2-cursor-render)
[486.586597] Subtest fbc-psr2-cursor-render: SKIP (0.000s)
[486.615939] [104/130] (508s left) kms_universal_plane (disable-primary-vs-flip)
[486.835648] Starting subtest: disable-primary-vs-flip
[486.838286] Starting dynamic subtest: pipe-A-DP-4
[487.362911] Dynamic subtest pipe-A-DP-4: SUCCESS (0.525s)
[487.375411] Starting dynamic subtest: pipe-B-DP-4
[487.867091] Dynamic subtest pipe-B-DP-4: SUCCESS (0.500s)
[487.889172] Starting dynamic subtest: pipe-C-DP-4
[488.315513] Dynamic subtest pipe-C-DP-4: SUCCESS (0.444s)
[488.325428] Starting dynamic subtest: pipe-D-DP-4
[488.793061] Dynamic subtest pipe-D-DP-4: SUCCESS (0.476s)
[488.794159] Subtest disable-primary-vs-flip: SUCCESS (1.958s)
[489.074534] [105/130] (506s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[489.317045] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[489.318600] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[489.404306] [106/130] (505s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[489.663120] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[489.664737] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[489.754154] [107/130] (505s left) gen3_render_tiledy_blits
[489.873390] [108/130] (505s left) syncobj_wait (reset-unsignaled)
[489.944676] Starting subtest: reset-unsignaled
[489.945562] Subtest reset-unsignaled: SUCCESS (0.000s)
[490.058235] [109/130] (505s left) gem_exec_whisper (basic-fds-forked)
[490.187059] Starting subtest: basic-fds-forked
[512.742080] Subtest basic-fds-forked: SUCCESS (22.554s)
[512.943097] [110/130] (482s left) syncobj_basic (illegal-fd-to-handle)
[513.013179] Starting subtest: illegal-fd-to-handle
[513.014017] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[513.126413] [111/130] (482s left) syncobj_timeline (single-wait-available-signaled)
[513.202745] Starting subtest: single-wait-available-signaled
[513.203558] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[513.314725] [112/130] (482s left) kms_big_fb (linear-8bpp-rotate-270)
[513.539110] Starting subtest: linear-8bpp-rotate-270
[513.594803] Subtest linear-8bpp-rotate-270: SKIP (0.055s)
[513.763724] [113/130] (481s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[514.001906] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[514.003465] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[514.088906] [114/130] (481s left) kms_invalid_mode (bad-vsync-end)
[514.336504] Starting subtest: bad-vsync-end
[514.338751] Starting dynamic subtest: pipe-A-DP-4
[514.418602] Dynamic subtest pipe-A-DP-4: SUCCESS (0.080s)
[514.430707] Starting dynamic subtest: pipe-B-DP-4
[514.431573] Dynamic subtest pipe-B-DP-4: SUCCESS (0.001s)
[514.443321] Starting dynamic subtest: pipe-C-DP-4
[514.444167] Dynamic subtest pipe-C-DP-4: SUCCESS (0.001s)
[514.455613] Starting dynamic subtest: pipe-D-DP-4
[514.456462] Dynamic subtest pipe-D-DP-4: SUCCESS (0.001s)
[514.457314] Subtest bad-vsync-end: SUCCESS (0.090s)
[514.634747] [115/130] (480s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[514.864405] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[514.866010] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[514.957876] [116/130] (480s left) api_intel_allocator (execbuf-with-allocator)
[515.047146] Starting subtest: execbuf-with-allocator
[515.072910] Subtest execbuf-with-allocator: SUCCESS (0.026s)
[515.231843] [117/130] (480s left) prime_mmap (test_dup)
[515.310161] Starting subtest: test_dup
[515.310971] Starting dynamic subtest: test_dup-smem
[515.358589] Dynamic subtest test_dup-smem: SUCCESS (0.048s)
[515.370276] Starting dynamic subtest: test_dup-lmem0
[515.560330] Dynamic subtest test_dup-lmem0: SUCCESS (0.200s)
[515.561134] Subtest test_dup: SUCCESS (0.250s)
[515.633866] [118/130] (479s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[515.863911] Starting subtest: plane-upscale-20x20-with-rotation
[515.864796] Starting dynamic subtest: pipe-A
[516.259442] Dynamic subtest pipe-A: SUCCESS (0.396s)
[516.283164] Starting dynamic subtest: pipe-B
[516.751696] Dynamic subtest pipe-B: SUCCESS (0.490s)
[516.780128] Starting dynamic subtest: pipe-C
[517.243597] Dynamic subtest pipe-C: SUCCESS (0.489s)
[517.272349] Starting dynamic subtest: pipe-D
[517.734387] Dynamic subtest pipe-D: SUCCESS (0.488s)
[517.735587] Subtest plane-upscale-20x20-with-rotation: SUCCESS (1.872s)
[518.036891] [119/130] (477s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[518.281863] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[518.283434] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[518.393976] [120/130] (477s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[518.630164] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[518.631798] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[518.750489] [121/130] (476s left) gem_exec_reloc (basic-cpu)
[518.846117] Subtest basic-cpu: SKIP (0.000s)
[518.914590] [122/130] (476s left) kms_psr (pr-cursor-mmap-cpu)
[519.143428] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[519.171714] [123/130] (476s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[519.393532] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[519.394354] Starting dynamic subtest: pipe-A-valid-mode
[522.113211] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.718s)
[522.115116] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SUCCESS (2.721s)
[522.342812] [124/130] (473s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[522.586727] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[522.600781] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.013s)
[522.685401] [125/130] (473s left) kms_psr (pr-sprite-render)
[522.938464] Subtest pr-sprite-render: SKIP (0.000s)
[522.972752] [126/130] (472s left) gem_exec_fence (syncobj-timeline-export)
[523.687143] Starting subtest: syncobj-timeline-export
[523.727995] Subtest syncobj-timeline-export: SUCCESS (0.042s)
[523.986845] [127/130] (471s left) gem_exec_balancer (waits)
[524.073519] Starting subtest: waits
[536.662642] Subtest waits: SUCCESS (12.589s)
[537.029728] [128/130] (458s left) kms_cursor_crc (cursor-random-128x42)
[537.411611] Starting subtest: cursor-random-128x42
[537.416259] Starting dynamic subtest: pipe-A-DP-4
[541.669934] Dynamic subtest pipe-A-DP-4: SUCCESS (4.253s)
[541.713745] Starting dynamic subtest: pipe-D-DP-4
[545.968171] Dynamic subtest pipe-D-DP-4: SUCCESS (4.263s)
[545.969044] Subtest cursor-random-128x42: SUCCESS (8.556s)
[546.286850] [129/130] (449s left) sriov_basic (enable-vfs-bind-unbind-each)
[546.387949] Subtest enable-vfs-bind-unbind-each: SKIP (0.000s)
[546.420809] [130/130] (449s left) kms_flip (busy-flip)
[546.649824] Starting subtest: busy-flip
[546.654188] Starting dynamic subtest: A-DP4
[547.489696] Dynamic subtest A-DP4: SUCCESS (0.835s)
[547.507183] Starting dynamic subtest: B-DP4
[548.272883] Dynamic subtest B-DP4: SUCCESS (0.781s)
[548.285622] Starting dynamic subtest: C-DP4
[549.032845] Dynamic subtest C-DP4: SUCCESS (0.758s)
[549.071170] Starting dynamic subtest: D-DP4
[549.822581] Dynamic subtest D-DP4: SUCCESS (0.785s)
[549.824913] Subtest busy-flip: SUCCESS (3.175s)
[550.149551] Closing watchdogs
Done.