[55.188427] Initializing watchdogs
[55.188474]   /dev/watchdog0
[55.196555] [001/130] (960s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[55.322476] Starting subtest: yf-tiled-32bpp-rotate-90
[55.326926] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[55.408078] [002/130] (960s left) kms_content_protection (dp-mst-type-1)
[55.567888] Starting subtest: dp-mst-type-1
[55.572282] Subtest dp-mst-type-1: SKIP (0.000s)
[55.689710] [003/130] (960s left) kms_plane_scaling (planes-scaler-unity-scaling)
[55.796633] Starting subtest: planes-scaler-unity-scaling
[55.798801] Starting dynamic subtest: pipe-A
[55.886143] Dynamic subtest pipe-A: SUCCESS (0.088s)
[55.894429] Starting dynamic subtest: pipe-B
[57.065306] Dynamic subtest pipe-B: SUCCESS (1.157s)
[57.073931] Starting dynamic subtest: pipe-C
[58.183223] Dynamic subtest pipe-C: SUCCESS (1.100s)
[58.191414] Starting dynamic subtest: pipe-D
[59.330575] Dynamic subtest pipe-D: SUCCESS (1.131s)
[59.333229] Subtest planes-scaler-unity-scaling: SUCCESS (3.476s)
[60.460650] [004/130] (955s left) perf (low-oa-exponent-permissions)
[60.590441] Starting subtest: low-oa-exponent-permissions
[60.631150] Subtest low-oa-exponent-permissions: SUCCESS (0.041s)
[60.657956] [005/130] (955s left) gem_ccs (ctrl-surf-copy-new-ctx)
[60.729023] Starting subtest: ctrl-surf-copy-new-ctx
[60.733438] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[60.801199] [006/130] (955s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[60.901504] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[60.906090] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[60.985257] [007/130] (954s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[61.077861] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[61.080324] Starting dynamic subtest: pipe-A-eDP-1
[61.137901] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[61.145943] Starting dynamic subtest: pipe-B-eDP-1
[61.204767] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[61.212588] Starting dynamic subtest: pipe-C-eDP-1
[61.270854] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[61.278109] Starting dynamic subtest: pipe-D-eDP-1
[61.335825] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[61.340193] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[63.241864] [008/130] (952s left) perf_pmu (interrupts-sync)
[63.281500] Starting subtest: interrupts-sync
[64.392074] Subtest interrupts-sync: SUCCESS (1.103s)
[64.517733] [009/130] (951s left) syncobj_wait (multi-wait-all-submitted-signaled)
[64.583167] Starting subtest: multi-wait-all-submitted-signaled
[64.685079] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.101s)
[64.759512] [010/130] (951s left) gem_lmem_swapping (verify-random-ccs)
[64.803084] Subtest verify-random-ccs: SKIP (0.000s)
[64.856908] [011/130] (951s left) syncobj_timeline (signal)
[64.925387] Starting subtest: signal
[64.927825] Subtest signal: SUCCESS (0.000s)
[65.049541] [012/130] (951s left) prime_mmap (test_userptr)
[65.120233] Starting subtest: test_userptr
[65.122707] Starting dynamic subtest: test_userptr-smem
[65.124719] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[65.126679] Subtest test_userptr: SUCCESS (0.002s)
[65.218793] [013/130] (950s left) gem_exec_schedule (smoketest)
[65.406970] Starting subtest: smoketest
[65.409306] Starting dynamic subtest: rcs0
[70.986521] Dynamic subtest rcs0: SUCCESS (5.502s)
[70.997744] Starting dynamic subtest: bcs0
[76.505495] Dynamic subtest bcs0: SUCCESS (5.512s)
[76.513655] Starting dynamic subtest: vcs0
[82.014439] Dynamic subtest vcs0: SUCCESS (5.506s)
[82.025809] Starting dynamic subtest: vcs1
[87.549307] Dynamic subtest vcs1: SUCCESS (5.524s)
[87.561604] Starting dynamic subtest: vecs0
[93.066310] Dynamic subtest vecs0: SUCCESS (5.515s)
[93.077383] Starting dynamic subtest: ccs0
[98.553811] Dynamic subtest ccs0: SUCCESS (5.491s)
[98.555993] Subtest smoketest: SUCCESS (33.051s)
[98.670911] [014/130] (917s left) kms_pm_rpm (modeset-pc8-residency-stress)
[100.216958] Starting subtest: modeset-pc8-residency-stress
[100.222396] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[100.939938] [015/130] (915s left) gem_eio (in-flight-contexts-immediate)
[101.180744] Starting subtest: in-flight-contexts-immediate
[112.956370] Subtest in-flight-contexts-immediate: SUCCESS (11.772s)
[113.108619] [016/130] (903s left) gem_exec_reloc (basic-gtt-read-active)
[113.172199] Subtest basic-gtt-read-active: SKIP (0.000s)
[113.228788] [017/130] (903s left) kms_hdr (bpc-switch-suspend)
[113.340059] Starting subtest: bpc-switch-suspend
[114.417180] Starting dynamic subtest: pipe-A-eDP-1
[133.500126] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.466s)
[133.502547] Subtest bpc-switch-suspend: SUCCESS (5.542s)
[133.606613] [018/130] (897s left) kms_flip (flip-vs-blocking-wf-vblank)
[133.710676] Starting subtest: flip-vs-blocking-wf-vblank
[133.713466] Starting dynamic subtest: A-eDP1
[140.297861] Dynamic subtest A-eDP1: FAIL (6.180s)
[140.308431] Starting dynamic subtest: B-eDP1
[149.516792] Dynamic subtest B-eDP1: FAIL (8.917s)
[149.527262] Starting dynamic subtest: C-eDP1
[157.954692] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[157.964977] Starting dynamic subtest: D-eDP1
[166.885626] Dynamic subtest D-eDP1: SUCCESS (8.923s)
[166.891350] Subtest flip-vs-blocking-wf-vblank: FAIL (32.950s)
[168.083514] [019/130] (863s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[168.191973] Starting subtest: y-tiled-64bpp-rotate-180
[168.196345] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[168.271881] [020/130] (862s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[168.338168] Subtest tiled-to-tiled: SKIP (0.000s)
[168.384923] [021/130] (862s left) gem_exec_whisper (basic-forked)
[168.445311] Starting subtest: basic-forked
[175.308883] Subtest basic-forked: SUCCESS (6.859s)
[175.467718] [022/130] (855s left) i915_hangman (gt-error-state-capture)
[175.536171] Starting subtest: gt-error-state-capture
[175.538653] Starting dynamic subtest: rcs0
[187.468762] Dynamic subtest rcs0: SUCCESS (11.927s)
[187.480933] Starting dynamic subtest: bcs0
[199.501665] Dynamic subtest bcs0: SUCCESS (12.028s)
[199.512564] Starting dynamic subtest: vcs0
[210.510706] Dynamic subtest vcs0: SUCCESS (11.004s)
[210.521397] Starting dynamic subtest: vcs1
[222.412763] Dynamic subtest vcs1: SUCCESS (11.896s)
[222.423645] Starting dynamic subtest: vecs0
[233.419584] Dynamic subtest vecs0: SUCCESS (11.006s)
[233.430098] Starting dynamic subtest: ccs0
[244.491690] Dynamic subtest ccs0: SUCCESS (11.073s)
[244.494946] Subtest gt-error-state-capture: SUCCESS (68.937s)
[244.619660] [023/130] (786s left) kms_chamelium_frames (dp-crc-fast)
[245.016103] Subtest dp-crc-fast: SKIP (0.000s)
[245.803936] [024/130] (785s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[245.910824] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[245.913188] Starting dynamic subtest: pipe-A-eDP-1
[245.943808] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[245.954563] Starting dynamic subtest: pipe-B-eDP-1
[245.975518] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[245.983262] Starting dynamic subtest: pipe-C-eDP-1
[246.005111] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[246.012683] Starting dynamic subtest: pipe-D-eDP-1
[246.034622] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[246.038969] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.002s)
[248.074036] [025/130] (783s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[248.188481] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[248.192829] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[248.291230] [026/130] (783s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[248.392785] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[248.396876] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[248.468751] [027/130] (782s left) vgem_basic (debugfs)
[248.515811] Starting subtest: debugfs
[248.518022] Subtest debugfs: SUCCESS (0.000s)
[248.550346] [028/130] (782s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[248.649234] Starting subtest: primary-4-tiled-reflect-x-0
[255.635417] Subtest primary-4-tiled-reflect-x-0: SUCCESS (6.986s)
[256.814227] [029/130] (774s left) perf_pmu (interrupts)
[256.855987] Starting subtest: interrupts
[257.972600] Subtest interrupts: SUCCESS (1.115s)
[258.064311] [030/130] (773s left) gem_vm_create (invalid-destroy)
[258.125935] Starting subtest: invalid-destroy
[258.130460] Subtest invalid-destroy: SUCCESS (0.002s)
[258.215062] [031/130] (773s left) gem_ctx_bad_destroy (invalid-ctx)
[258.276793] Starting subtest: invalid-ctx
[258.279257] Subtest invalid-ctx: SUCCESS (0.000s)
[258.329562] [032/130] (773s left) gem_userptr_blits (sd-probe)
[258.393736] Starting subtest: sd-probe
[258.395982] Subtest sd-probe: SUCCESS (0.000s)
[258.492867] [033/130] (772s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[258.591668] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[258.596151] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[258.682106] [034/130] (772s left) gem_exec_schedule (reorder-wide)
[258.875097] Subtest reorder-wide: SKIP (0.000s)
[259.033139] [035/130] (772s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[259.137683] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[263.908408] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.774s)
[264.000822] [036/130] (767s left) gem_exec_reloc (basic-cpu-wc)
[264.058472] Subtest basic-cpu-wc: SKIP (0.000s)
[264.123971] [037/130] (767s left) api_intel_allocator (open-vm)
[264.188515] Starting subtest: open-vm
[264.190811] Subtest open-vm: SUCCESS (0.003s)
[264.306669] [038/130] (767s left) dmabuf_sync_file (import-basic)
[264.356971] Starting subtest: import-basic
[264.359171] Subtest import-basic: SUCCESS (0.002s)
[264.394780] [039/130] (767s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[264.497588] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[264.501891] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[264.586621] [040/130] (766s left) gem_create (create-ext-placement-each)
[264.773172] Starting subtest: create-ext-placement-each
[264.775824] Subtest create-ext-placement-each: SUCCESS (0.000s)
[264.870437] [041/130] (766s left) api_intel_bb (simple-bb)
[264.940624] Starting subtest: simple-bb
[264.942994] Subtest simple-bb: SUCCESS (0.005s)
[265.031440] [042/130] (766s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[265.138444] Starting subtest: x-tiled-32bpp-rotate-0
[266.538390] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.400s)
[266.674415] [043/130] (764s left) kms_invalid_mode (bad-vsync-start)
[266.782450] Starting subtest: bad-vsync-start
[266.784345] Starting dynamic subtest: pipe-A-eDP-1
[267.062171] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.280s)
[267.071281] Starting dynamic subtest: pipe-B-eDP-1
[267.073380] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[267.081402] Starting dynamic subtest: pipe-C-eDP-1
[267.083552] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[267.091991] Starting dynamic subtest: pipe-D-eDP-1
[267.093862] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[267.095788] Subtest bad-vsync-start: SUCCESS (0.284s)
[267.893781] [044/130] (763s left) kms_vblank (query-busy)
[267.993182] Starting subtest: query-busy
[267.995405] Starting dynamic subtest: pipe-A-eDP-1
[269.881424] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.886s)
[269.896420] Starting dynamic subtest: pipe-D-eDP-1
[272.479771] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.595s)
[272.482155] Subtest query-busy: SUCCESS (4.484s)
[273.252324] [045/130] (758s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[273.309645] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[273.386548] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.005s)
[273.404495] [046/130] (758s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[273.508076] Starting subtest: fbc-rgb101010-draw-mmap-wc
[277.012240] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (3.506s)
[277.095759] [047/130] (754s left) kms_flip (flip-vs-rmfb-interruptible)
[277.198943] Starting subtest: flip-vs-rmfb-interruptible
[277.201290] Starting dynamic subtest: A-eDP1
[285.877222] Dynamic subtest A-eDP1: SUCCESS (8.675s)
[285.887480] Starting dynamic subtest: B-eDP1
[294.507794] Dynamic subtest B-eDP1: SUCCESS (8.627s)
[294.518810] Starting dynamic subtest: C-eDP1
[303.116784] Dynamic subtest C-eDP1: SUCCESS (8.604s)
[303.126443] Starting dynamic subtest: D-eDP1
[311.740732] Dynamic subtest D-eDP1: SUCCESS (8.620s)
[311.745490] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.536s)
[312.899210] [048/130] (718s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[312.996052] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[312.998363] Starting dynamic subtest: pipe-A-default-mode
[313.301036] Dynamic subtest pipe-A-default-mode: SKIP (0.301s)
[313.305735] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.302s)
[314.123171] [049/130] (717s left) perf_pmu (busy-idle)
[314.168155] Starting subtest: busy-idle
[314.170487] Starting dynamic subtest: rcs0
[314.865239] Dynamic subtest rcs0: SUCCESS (0.698s)
[314.876245] Starting dynamic subtest: bcs0
[315.531390] Dynamic subtest bcs0: SUCCESS (0.664s)
[315.543012] Starting dynamic subtest: vcs0
[317.549643] Dynamic subtest vcs0: SUCCESS (2.014s)
[317.561083] Starting dynamic subtest: vcs1
[319.534469] Dynamic subtest vcs1: SUCCESS (1.981s)
[319.546053] Starting dynamic subtest: vecs0
[321.518698] Dynamic subtest vecs0: SUCCESS (1.981s)
[321.529866] Starting dynamic subtest: ccs0
[322.197639] Dynamic subtest ccs0: SUCCESS (0.679s)
[322.200272] Subtest busy-idle: SUCCESS (8.030s)
[322.283838] [050/130] (709s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[322.396132] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[322.400446] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[322.491906] [051/130] (709s left) perf (gen12-unprivileged-single-ctx-counters)
[322.586387] Starting subtest: gen12-unprivileged-single-ctx-counters
[322.588874] Starting dynamic subtest: rcs0
[322.803299] Dynamic subtest rcs0: SUCCESS (0.216s)
[322.805837] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.217s)
[322.831959] [052/130] (708s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[322.975491] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[322.977830] Starting dynamic subtest: pipe-A-default-mode
[323.261910] Dynamic subtest pipe-A-default-mode: SKIP (0.282s)
[323.266731] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.283s)
[324.046010] [053/130] (707s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[324.154107] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[324.158830] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[324.220883] [054/130] (707s left) kms_plane (plane-position-hole)
[324.324523] Starting subtest: plane-position-hole
[324.815183] Starting dynamic subtest: pipe-A-plane-1
[326.135247] Dynamic subtest pipe-A-plane-1: SUCCESS (1.322s)
[326.145088] Starting dynamic subtest: pipe-A-plane-2
[327.347474] Dynamic subtest pipe-A-plane-2: SUCCESS (1.210s)
[327.356151] Starting dynamic subtest: pipe-A-plane-3
[328.591748] Dynamic subtest pipe-A-plane-3: SUCCESS (1.244s)
[328.600322] Starting dynamic subtest: pipe-A-plane-4
[329.799263] Dynamic subtest pipe-A-plane-4: SUCCESS (1.205s)
[329.809567] Starting dynamic subtest: pipe-A-plane-5
[329.822564] Dynamic subtest pipe-A-plane-5: SUCCESS (0.021s)
[330.941887] Starting dynamic subtest: pipe-B-plane-1
[332.151501] Dynamic subtest pipe-B-plane-1: SUCCESS (1.214s)
[332.161298] Starting dynamic subtest: pipe-B-plane-2
[333.376411] Dynamic subtest pipe-B-plane-2: SUCCESS (1.226s)
[333.385944] Starting dynamic subtest: pipe-B-plane-3
[334.592408] Dynamic subtest pipe-B-plane-3: SUCCESS (1.216s)
[334.602067] Starting dynamic subtest: pipe-B-plane-4
[335.814041] Dynamic subtest pipe-B-plane-4: SUCCESS (1.220s)
[335.824502] Starting dynamic subtest: pipe-B-plane-5
[335.836728] Dynamic subtest pipe-B-plane-5: SUCCESS (0.020s)
[335.839033] Subtest plane-position-hole: SUCCESS (11.505s)
[336.605689] [055/130] (695s left) kms_cursor_legacy (torture-bo)
[336.734327] Starting subtest: torture-bo
[336.736599] Starting dynamic subtest: pipe-A
[343.150979] Dynamic subtest pipe-A: SUCCESS (6.410s)
[343.163565] Starting dynamic subtest: pipe-B
[349.614995] Dynamic subtest pipe-B: SUCCESS (6.459s)
[349.623925] Starting dynamic subtest: pipe-C
[356.213978] Dynamic subtest pipe-C: SUCCESS (6.595s)
[356.225266] Starting dynamic subtest: pipe-D
[362.275756] Dynamic subtest pipe-D: SUCCESS (6.062s)
[362.286529] Starting dynamic subtest: all-pipes
[368.341249] Dynamic subtest all-pipes: SUCCESS (6.067s)
[368.344107] Subtest torture-bo: SUCCESS (31.601s)
[368.473417] [056/130] (663s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-wc)
[368.578799] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-wc
[371.428964] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (2.855s)
[371.533512] [057/130] (660s left) kms_cursor_crc (cursor-sliding-128x42)
[371.734645] Starting subtest: cursor-sliding-128x42
[371.774723] Subtest cursor-sliding-128x42: SKIP (0.034s)
[371.959146] [058/130] (659s left) kms_cursor_crc (cursor-random-32x32)
[372.083329] Starting subtest: cursor-random-32x32
[372.123566] Subtest cursor-random-32x32: SKIP (0.037s)
[372.380356] [059/130] (659s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[372.772661] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[373.525032] [060/130] (658s left) vgem_basic (dmabuf-mmap)
[373.577017] Starting subtest: dmabuf-mmap
[373.597120] Subtest dmabuf-mmap: SUCCESS (0.022s)
[373.638570] [061/130] (658s left) kms_atomic_transition (plane-all-transition-nonblocking)
[373.736231] Starting subtest: plane-all-transition-nonblocking
[373.738387] Starting dynamic subtest: pipe-A-eDP-1
[376.225491] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.490s)
[376.530291] Starting dynamic subtest: pipe-B-eDP-1
[379.801248] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.284s)
[380.076391] Subtest plane-all-transition-nonblocking: SUCCESS (6.343s)
[380.898498] [062/130] (651s left) kms_async_flips (async-flip-suspend-resume)
[381.006943] Starting subtest: async-flip-suspend-resume
[381.365687] Starting dynamic subtest: pipe-A-eDP-1
[399.360074] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.852s)
[399.725591] Starting dynamic subtest: pipe-B-eDP-1
[402.491621] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.696s)
[402.859974] Starting dynamic subtest: pipe-C-eDP-1
[405.597439] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.691s)
[405.967081] Starting dynamic subtest: pipe-D-eDP-1
[408.779879] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.787s)
[408.782335] Subtest async-flip-suspend-resume: SUCCESS (12.456s)
[409.980069] [063/130] (637s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[410.088880] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[410.091360] Starting dynamic subtest: pipe-A-default-mode
[410.370035] Dynamic subtest pipe-A-default-mode: SKIP (0.282s)
[410.374847] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.283s)
[411.214039] [064/130] (636s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[411.326574] Starting subtest: x-tiled-32bpp-rotate-90
[411.346200] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s)
[411.451791] [065/130] (635s left) gem_ctx_param (invalid-set-ringsize)
[411.516082] Starting subtest: invalid-set-ringsize
[411.518534] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[411.571620] [066/130] (635s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[411.679463] Starting subtest: psr-rgb101010-draw-render
[416.818759] Subtest psr-rgb101010-draw-render: SUCCESS (5.113s)
[416.922071] [067/130] (630s left) template (b)
[416.984324] Starting subtest: B
[416.986699] Subtest B: SUCCESS (0.000s)
[417.074473] [068/130] (630s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[417.174978] Starting subtest: plane-all-modeset-transition-internal-panels
[417.177167] Starting dynamic subtest: pipe-A-eDP-1
[418.462993] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.281s)
[418.744008] Starting dynamic subtest: pipe-B-eDP-1
[419.789199] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.055s)
[420.053304] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.868s)
[420.874642] [069/130] (626s left) kms_pm_rpm (cursor-dpms)
[422.817915] Starting subtest: cursor-dpms
[433.637742] Subtest cursor-dpms: SUCCESS (10.806s)
[433.964010] [070/130] (613s left) kms_dsc (dsc-basic)
[434.063026] Starting subtest: dsc-basic
[434.075861] Subtest dsc-basic: SKIP (0.000s)
[434.117118] [071/130] (613s left) gem_lmem_swapping (heavy-verify-random)
[434.164737] Subtest heavy-verify-random: SKIP (0.000s)
[434.191103] [072/130] (613s left) i915_suspend (basic-s2idle-without-i915)
[434.224250] Starting subtest: basic-s2idle-without-i915
[455.709988] Subtest basic-s2idle-without-i915: SUCCESS (6.419s)
[455.784472] [073/130] (606s left) gem_linear_blits (basic)
[456.262985] Starting subtest: basic
[456.276721] Subtest basic: SUCCESS (0.014s)
[456.407902] [074/130] (606s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[456.560966] Starting subtest: psr-1p-primscrn-cur-indfb-move
[461.665611] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (4.993s)
[461.781316] [075/130] (601s left) gem_partial_pwrite_pread (reads-uncached)
[461.847004] Subtest reads-uncached: SKIP (0.000s)
[461.887689] [076/130] (601s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[461.953195] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[461.957777] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[462.119697] [077/130] (600s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[462.232801] Starting subtest: modeset-transition-nonblocking-fencing
[462.234813] Starting dynamic subtest: 1x-outputs
[472.792736] Dynamic subtest 1x-outputs: SUCCESS (10.473s)
[473.059339] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.736s)
[473.900371] [078/130] (589s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[473.997502] Starting subtest: bad-aux-stride-y-tiled-ccs
[473.999845] Starting dynamic subtest: pipe-A-eDP-1
[474.022745] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[474.032457] Starting dynamic subtest: pipe-B-eDP-1
[474.054512] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[474.063032] Starting dynamic subtest: pipe-C-eDP-1
[474.084954] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[474.094999] Starting dynamic subtest: pipe-D-eDP-1
[474.116994] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[474.121070] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[476.152826] [079/130] (586s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[481.144388] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[481.146835] Starting dynamic subtest: pipe-A-eDP-1
[481.936009] Dynamic subtest pipe-A-eDP-1: SKIP (0.786s)
[481.944547] Starting dynamic subtest: pipe-B-eDP-1
[483.060103] Dynamic subtest pipe-B-eDP-1: SKIP (1.121s)
[483.064779] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.910s)
[484.219185] [080/130] (578s left) kms_chamelium_hpd (vga-hpd-fast)
[484.608048] Subtest vga-hpd-fast: SKIP (0.000s)
[485.427104] [081/130] (577s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[485.526896] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[485.530753] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[485.587038] [082/130] (577s left) gem_tiled_partial_pwrite_pread (writes)
[485.649829] Subtest writes: SKIP (0.000s)
[485.701085] [083/130] (577s left) gem_ctx_param (invalid-size-set)
[485.754100] Starting subtest: invalid-size-set
[485.756411] Subtest invalid-size-set: SUCCESS (0.001s)
[485.834180] [084/130] (577s left) kms_fbcon_fbt (fbc-suspend)
[485.899727] Starting subtest: fbc-suspend
[532.642872] Subtest fbc-suspend: SUCCESS (17.614s)
[532.728455] [085/130] (559s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[532.795890] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[532.901045] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[532.955200] [086/130] (559s left) gem_mmap_offset (clear-via-pagefault)
[533.006198] Starting subtest: clear-via-pagefault
[533.008442] Starting dynamic subtest: smem0
[566.761257] Dynamic subtest smem0: SUCCESS (33.620s)
[566.763249] Subtest clear-via-pagefault: SUCCESS (33.621s)
[566.861724] [087/130] (525s left) gem_mmap_gtt (medium-copy)
[566.922868] Subtest medium-copy: SKIP (0.000s)
[566.968578] [088/130] (525s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[567.567547] Starting subtest: syncobj-timeline-multiple-ext-nodes
[567.574109] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.005s)
[568.731586] [089/130] (523s left) gem_exec_balancer (bonded-semaphore)
[568.794615] Starting subtest: bonded-semaphore
[568.798811] Subtest bonded-semaphore: SKIP (0.000s)
[569.061341] [090/130] (523s left) gem_eio (in-flight-1us)
[569.251006] Starting subtest: in-flight-1us
[576.693959] Subtest in-flight-1us: SUCCESS (7.440s)
[576.796943] [091/130] (515s left) kms_plane_alpha_blend (constant-alpha-min)
[576.900268] Starting subtest: constant-alpha-min
[577.175337] Starting dynamic subtest: pipe-A-eDP-1
[577.867891] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.691s)
[577.876876] Starting dynamic subtest: pipe-D-eDP-1
[579.339786] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.469s)
[579.342254] Subtest constant-alpha-min: SUCCESS (2.437s)
[580.107485] [092/130] (512s left) gem_reg_read (bad-register)
[580.167485] Starting subtest: bad-register
[580.169798] Subtest bad-register: SUCCESS (0.000s)
[580.252408] [093/130] (512s left) gem_exec_balancer (parallel-out-fence)
[580.502271] Starting subtest: parallel-out-fence
[581.481118] Subtest parallel-out-fence: SUCCESS (0.978s)
[581.582354] [094/130] (511s left) i915_query (query-topology-kernel-writes)
[581.646547] Starting subtest: query-topology-kernel-writes
[581.648939] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[581.737848] [095/130] (510s left) gem_ctx_persistence (processes)
[581.796667] Starting subtest: processes
[583.634562] Subtest processes: SUCCESS (1.837s)
[583.696816] [096/130] (509s left) perf_pmu (rc6-all-gts)
[583.740979] Starting subtest: rc6-all-gts
[590.116845] Subtest rc6-all-gts: SUCCESS (6.371s)
[590.971657] [097/130] (501s left) syncobj_timeline (invalid-transfer-bad-pad)
[591.026856] Starting subtest: invalid-transfer-bad-pad
[591.029065] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[591.114024] [098/130] (501s left) gem_exec_big (single)
[591.165624] Starting subtest: single
[593.311668] Subtest single: SUCCESS (2.142s)
[593.481069] [099/130] (499s left) gem_exec_suspend (basic-s3-devices)
[593.586511] Starting subtest: basic-S3-devices
[593.588939] Starting dynamic subtest: smem
[604.608803] Dynamic subtest smem: SUCCESS (11.015s)
[604.611902] Subtest basic-S3-devices: SUCCESS (11.017s)
[604.773278] [100/130] (488s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-gtt)
[604.888781] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-gtt
[604.892769] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[604.974499] [101/130] (487s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[605.070207] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[605.072609] Starting dynamic subtest: pipe-A-eDP-1
[605.096829] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.026s)
[605.106760] Starting dynamic subtest: pipe-B-eDP-1
[605.126651] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.025s)
[605.135792] Starting dynamic subtest: pipe-C-eDP-1
[605.155277] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.025s)
[605.164759] Starting dynamic subtest: pipe-D-eDP-1
[605.185085] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.026s)
[605.187371] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.106s)
[607.305936] [102/130] (485s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[607.421203] Starting subtest: primary-yf-tiled-reflect-x-180
[607.483638] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[607.565271] [103/130] (485s left) kms_addfb_basic (unused-offsets)
[607.625065] Starting subtest: unused-offsets
[607.627721] Subtest unused-offsets: SUCCESS (0.000s)
[607.740368] [104/130] (485s left) syncobj_timeline (multi-wait-available-submitted)
[607.810117] Starting subtest: multi-wait-available-submitted
[607.812519] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[607.896162] [105/130] (485s left) gem_pxp (display-protected-crc)
[609.062322] Starting subtest: display-protected-crc
[610.705281] Subtest display-protected-crc: SUCCESS (1.643s)
[610.801333] [106/130] (482s left) kms_psr (fbc-psr-cursor-plane-move)
[610.895175] Starting subtest: fbc-psr-cursor-plane-move
[610.897502] Starting dynamic subtest: eDP-1
[610.901841] Dynamic subtest eDP-1: SKIP (0.000s)
[610.906200] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[610.948850] [107/130] (481s left) syncobj_timeline (wait-any-snapshot)
[611.003555] Starting subtest: wait-any-snapshot
[611.083572] Subtest wait-any-snapshot: SUCCESS (0.081s)
[611.140180] [108/130] (481s left) kms_lease (setcrtc-implicit-plane)
[611.246124] Starting subtest: setcrtc-implicit-plane
[611.248444] Starting dynamic subtest: pipe-A-eDP-1
[611.703089] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.454s)
[611.714187] Starting dynamic subtest: pipe-B-eDP-1
[612.856735] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.153s)
[612.866154] Starting dynamic subtest: pipe-C-eDP-1
[613.969132] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.112s)
[613.979844] Starting dynamic subtest: pipe-D-eDP-1
[615.084824] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.113s)
[615.087218] Subtest setcrtc-implicit-plane: SUCCESS (3.837s)
[615.907301] [109/130] (477s left) gen9_exec_parse (bb-oversize)
[615.967642] Subtest bb-oversize: SKIP (0.000s)
[616.034931] [110/130] (476s left) gem_eio (unwedge-stress)
[616.293061] Starting subtest: unwedge-stress
[660.103956] Subtest unwedge-stress: SUCCESS (43.801s)
[661.654780] [111/130] (431s left) prime_vgem (basic-gtt)
[661.733570] Starting subtest: basic-gtt
[661.738211] Subtest basic-gtt: SKIP (0.000s)
[661.808788] [112/130] (431s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[661.874598] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[661.878783] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[662.036489] [113/130] (431s left) gem_exec_params (invalid-batch-start-offset)
[662.104844] Starting subtest: invalid-batch-start-offset
[662.110836] Subtest invalid-batch-start-offset: SUCCESS (0.003s)
[662.225057] [114/130] (430s left) dumb_buffer (create-clear)
[662.279321] Starting subtest: create-clear
[696.567244] Subtest create-clear: SUCCESS (34.277s)
[696.638957] [115/130] (396s left) kms_psr (pr-primary-page-flip)
[696.736093] Starting subtest: pr-primary-page-flip
[696.740150] Subtest pr-primary-page-flip: SKIP (0.000s)
[696.789158] [116/130] (396s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[696.855216] Subtest writes-after-reads-uncached: SKIP (0.000s)
[696.918472] [117/130] (396s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-blt)
[697.015629] Starting subtest: psr-1p-offscren-pri-indfb-draw-blt
[701.855835] Subtest psr-1p-offscren-pri-indfb-draw-blt: SUCCESS (4.842s)
[701.963774] [118/130] (391s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[702.072313] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[702.076355] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[702.166244] [119/130] (391s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[702.270634] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[706.567390] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (4.300s)
[706.660552] [120/130] (386s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[711.672702] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[711.675050] Starting dynamic subtest: pipe-A-eDP-1
[718.193484] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.517s)
[718.202888] Starting dynamic subtest: pipe-B-eDP-1
[724.836559] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.638s)
[724.838883] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (13.159s)
[725.676045] [121/130] (367s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[725.794665] Starting subtest: cursorB-vs-flipA-toggle
[725.799243] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[725.919461] [122/130] (367s left) kms_big_fb (4-tiled-addfb)
[726.024074] Starting subtest: 4-tiled-addfb
[726.026412] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[726.116564] [123/130] (367s left) kms_sequence (get-idle)
[726.212390] Starting subtest: get-idle
[726.214782] Starting dynamic subtest: pipe-A-eDP-1
[728.014937] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.800s)
[728.024795] Starting dynamic subtest: pipe-B-eDP-1
[730.461288] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.444s)
[730.471398] Starting dynamic subtest: pipe-C-eDP-1
[732.869728] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.404s)
[732.879603] Starting dynamic subtest: pipe-D-eDP-1
[735.286630] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.415s)
[735.288754] Subtest get-idle: SUCCESS (9.070s)
[736.072065] [124/130] (357s left) kms_psr (psr2-cursor-plane-move)
[736.171938] Starting subtest: psr2-cursor-plane-move
[736.174226] Starting dynamic subtest: eDP-1
[737.860941] Dynamic subtest eDP-1: SUCCESS (1.688s)
[737.863235] Subtest psr2-cursor-plane-move: SUCCESS (1.689s)
[738.627418] [125/130] (354s left) kms_psr (fbc-psr2-cursor-plane-move)
[738.722366] Starting subtest: fbc-psr2-cursor-plane-move
[738.724745] Starting dynamic subtest: eDP-1
[738.728887] Dynamic subtest eDP-1: SKIP (0.000s)
[738.733184] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[738.777422] [126/130] (354s left) kms_prop_blob (invalid-set-prop-any)
[738.836009] Starting subtest: invalid-set-prop-any
[738.838309] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[738.922476] [127/130] (354s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[739.025591] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[739.029690] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[739.117686] [128/130] (354s left) i915_pm_rps (thresholds-idle-park)
[739.184113] Starting subtest: thresholds-idle-park
[739.188724] Subtest thresholds-idle-park: SKIP (0.001s)
[739.248216] [129/130] (354s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[739.345406] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[739.347828] Starting dynamic subtest: pipe-A-eDP-1
[740.152215] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.798s)
[740.161540] Starting dynamic subtest: pipe-B-eDP-1
[741.677601] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.521s)
[741.687837] Starting dynamic subtest: pipe-C-eDP-1
[743.154471] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.476s)
[743.165001] Starting dynamic subtest: pipe-D-eDP-1
[744.678466] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.523s)
[744.680874] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.322s)
[745.821938] [130/130] (347s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[745.885615] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[745.888034] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[745.971293] Closing watchdogs
Done.