[49.348700] Initializing watchdogs
[49.349037]   /dev/watchdog0
[49.384290] [001/136] (960s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[49.761431] Starting subtest: basic-batch-kernel-default-cmd
[55.582113] Subtest basic-batch-kernel-default-cmd: SUCCESS (5.784s)
[55.743043] [002/136] (954s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[56.142421] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[56.163593] Starting dynamic subtest: pipe-A-valid-mode
[56.962441] Dynamic subtest pipe-A-valid-mode: SKIP (0.808s)
[57.003890] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (0.808s)
[57.385785] [003/136] (952s left) sysfs_heartbeat_interval (nopreempt)
[57.691947] Starting subtest: nopreempt
[57.713476] Starting dynamic subtest: vecs0
[61.378953] Dynamic subtest vecs0: SUCCESS (3.504s)
[61.409327] Starting dynamic subtest: vcs0
[64.857412] Dynamic subtest vcs0: SUCCESS (3.470s)
[64.887453] Starting dynamic subtest: bcs0
[68.354043] Dynamic subtest bcs0: SUCCESS (3.489s)
[68.388546] Starting dynamic subtest: rcs0
[71.834876] Dynamic subtest rcs0: SUCCESS (3.501s)
[71.856215] Subtest nopreempt: SUCCESS (13.966s)
[71.964543] [004/136] (938s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_gen12_rc_ccs)
[72.475111] Starting subtest: pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs
[72.511928] Subtest pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[72.850444] [005/136] (937s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[73.272607] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[73.309838] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[73.445619] [006/136] (936s left) kms_addfb_basic (bad-pitch-32)
[73.761571] Starting subtest: bad-pitch-32
[73.780893] Subtest bad-pitch-32: SUCCESS (0.000s)
[74.182611] [007/136] (936s left) kms_properties (plane-properties-atomic)
[74.552159] Starting subtest: plane-properties-atomic
[75.852512] Subtest plane-properties-atomic: SUCCESS (1.286s)
[76.217084] [008/136] (934s left) gem_flink_basic (flink-lifetime)
[76.518353] Starting subtest: flink-lifetime
[76.538414] Subtest flink-lifetime: SUCCESS (0.003s)
[76.652143] [009/136] (934s left) gem_exec_fair (basic-throttle)
[77.117472] Starting subtest: basic-throttle
[77.138386] Starting dynamic subtest: rcs0
[82.092577] Dynamic subtest rcs0: SUCCESS (5.138s)
[82.111274] Subtest basic-throttle: SUCCESS (5.139s)
[82.335599] [010/136] (928s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[82.635819] Starting subtest: multi-wait-all-for-submit-available-submitted
[82.656737] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.002s)
[82.757307] [011/136] (928s left) gem_fence_thrash (bo-write-verify-threaded-none)
[83.037145] Starting subtest: bo-write-verify-threaded-none
[86.090529] Subtest bo-write-verify-threaded-none: SUCCESS (2.899s)
[86.176649] [012/136] (924s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-submitted)
[86.444797] Starting subtest: invalid-multi-wait-available-unsubmitted-submitted
[86.466208] Subtest invalid-multi-wait-available-unsubmitted-submitted: SUCCESS (0.002s)
[86.549042] [013/136] (924s left) kms_flip (2x-flip-vs-rmfb)
[86.912240] Starting subtest: 2x-flip-vs-rmfb
[86.949781] Subtest 2x-flip-vs-rmfb: SKIP (0.004s)
[87.062837] [014/136] (924s left) gem_ctx_engines (execute-oneforall)
[87.360808] Starting subtest: execute-oneforall
[88.179614] Subtest execute-oneforall: SUCCESS (0.829s)
[88.411077] [015/136] (922s left) gem_mmap_gtt (basic-wc)
[88.695743] Starting subtest: basic-wc
[89.312163] Subtest basic-wc: SUCCESS (0.631s)
[89.433736] [016/136] (921s left) syncobj_timeline (single-wait-for-submit-signaled)
[89.698290] Starting subtest: single-wait-for-submit-signaled
[89.720315] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s)
[89.807238] [017/136] (921s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[90.082042] Starting subtest: multi-wait-for-submit-submitted-signaled
[90.104120] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[90.187299] [018/136] (921s left) gem_exec_whisper (basic-contexts)
[90.508056] Starting subtest: basic-contexts
[100.860038] Subtest basic-contexts: SUCCESS (10.360s)
[101.064494] [019/136] (910s left) api_intel_bb (reset-flags)
[101.349571] Starting subtest: reset-flags
[101.368545] Subtest reset-flags: SUCCESS (0.031s)
[101.501063] [020/136] (910s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[101.930970] Starting subtest: y-tiled-64bpp-rotate-90
[101.990959] Subtest y-tiled-64bpp-rotate-90: SKIP (0.072s)
[102.132870] [021/136] (909s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_dg2_rc_ccs)
[102.635771] Starting subtest: pipe-C-bad-rotation-90-4_tiled_dg2_rc_ccs
[102.674895] Subtest pipe-C-bad-rotation-90-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[103.015567] [022/136] (908s left) vc4/vc4_perfmon (get-values-invalid-perfmon)
[103.410132] Subtest get-values-invalid-perfmon: SKIP (0.000s)
[103.510850] [023/136] (908s left) dmabuf_sync_file (export-multiwait)
[103.895771] Starting subtest: export-multiwait
[103.914508] Subtest export-multiwait: SUCCESS (0.003s)
[104.024641] [024/136] (908s left) kms_psr (psr2_cursor_blt)
[104.328496] Subtest psr2_cursor_blt: SKIP (0.000s)
[104.430640] [025/136] (907s left) kms_frontbuffer_tracking (psr-slowdraw)
[104.873870] Starting subtest: psr-slowdraw
[104.911865] Subtest psr-slowdraw: SKIP (0.000s)
[105.014177] [026/136] (907s left) gem_ctx_persistence (engines-hang)
[105.293715] Starting subtest: engines-hang
[105.312267] Starting dynamic subtest: rcs0
[105.353997] Dynamic subtest rcs0: SUCCESS (0.040s)
[105.390305] Starting dynamic subtest: bcs0
[105.430227] Dynamic subtest bcs0: SKIP (0.005s)
[105.463260] Starting dynamic subtest: vcs0
[105.481736] Dynamic subtest vcs0: SUCCESS (0.058s)
[105.514379] Starting dynamic subtest: vecs0
[105.534193] Dynamic subtest vecs0: SUCCESS (0.041s)
[105.555608] Subtest engines-hang: SUCCESS (0.146s)
[105.660913] [027/136] (906s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[106.076453] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[106.117390] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[106.227509] [028/136] (906s left) kms_async_flips (async-flip-with-page-flip-events)
[106.599882] Starting subtest: async-flip-with-page-flip-events
[106.621776] Starting dynamic subtest: pipe-A-DP-1
[109.134270] Dynamic subtest pipe-A-DP-1: SUCCESS (2.533s)
[109.169536] Starting dynamic subtest: pipe-B-DP-1
[111.523421] Dynamic subtest pipe-B-DP-1: SUCCESS (2.388s)
[111.557688] Starting dynamic subtest: pipe-C-DP-1
[113.921694] Dynamic subtest pipe-C-DP-1: SUCCESS (2.397s)
[113.942471] Subtest async-flip-with-page-flip-events: SUCCESS (7.321s)
[114.437609] [029/136] (898s left) kms_cursor_crc (cursor-onscreen-512x512)
[114.846878] Starting subtest: cursor-onscreen-512x512
[114.896514] Subtest cursor-onscreen-512x512: SKIP (0.000s)
[115.022600] [030/136] (897s left) gem_lmem_swapping (parallel-random)
[115.322296] Subtest parallel-random: SKIP (0.000s)
[115.429063] [031/136] (897s left) kms_addfb_basic (invalid-get-prop)
[115.968414] Starting subtest: invalid-get-prop
[115.987032] Subtest invalid-get-prop: SUCCESS (0.000s)
[116.107786] [032/136] (896s left) gem_sync (basic-each)
[116.561596] Starting subtest: basic-each
[118.795256] Subtest basic-each: SUCCESS (2.373s)
[119.008426] [033/136] (893s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[119.429714] Starting subtest: yf-tiled-64bpp-rotate-0
[119.466952] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[119.576717] [034/136] (893s left) kms_psr (sprite_render)
[119.865866] Subtest sprite_render: SKIP (0.000s)
[119.950706] [035/136] (893s left) kms_universal_plane (disable-primary-vs-flip-pipe-c)
[120.314523] Starting subtest: disable-primary-vs-flip-pipe-C
[121.251591] Subtest disable-primary-vs-flip-pipe-C: SUCCESS (0.921s)
[121.618812] [036/136] (891s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[122.030976] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[122.070571] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[122.182658] [037/136] (891s left) gem_exec_reloc (basic-write-read-active)
[122.483411] Starting subtest: basic-write-read-active
[122.605567] Subtest basic-write-read-active: SUCCESS (0.143s)
[122.828904] [038/136] (890s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[123.210169] Starting subtest: cursor-rapid-movement-64x64
[123.228974] Starting dynamic subtest: pipe-A-DP-1
[123.765659] Dynamic subtest pipe-A-DP-1: SUCCESS (0.549s)
[123.832840] Starting dynamic subtest: pipe-B-DP-1
[124.414842] Dynamic subtest pipe-B-DP-1: SUCCESS (0.593s)
[124.502677] Starting dynamic subtest: pipe-C-DP-1
[125.089112] Dynamic subtest pipe-C-DP-1: SUCCESS (0.605s)
[125.108642] Subtest cursor-rapid-movement-64x64: SUCCESS (1.882s)
[125.465155] [039/136] (888s left) api_intel_allocator (fork-simple-stress-signal)
[125.779640] Starting subtest: fork-simple-stress-signal
[131.284042] Subtest fork-simple-stress-signal: SUCCESS (5.526s)
[131.412220] [040/136] (882s left) kms_color (ctm-negative)
[131.776870] Starting subtest: ctm-negative
[131.795991] Starting dynamic subtest: pipe-A-DP-1
[132.302939] Dynamic subtest pipe-A-DP-1: SUCCESS (0.521s)
[132.339576] Starting dynamic subtest: pipe-B-DP-1
[133.019383] Dynamic subtest pipe-B-DP-1: SUCCESS (0.713s)
[133.056588] Starting dynamic subtest: pipe-C-DP-1
[133.719183] Dynamic subtest pipe-C-DP-1: SUCCESS (0.699s)
[133.737952] Subtest ctm-negative: SUCCESS (1.939s)
[134.092182] [041/136] (879s left) kms_plane_scaling (planes-downscale-factor-0-25)
[134.456870] Starting subtest: planes-downscale-factor-0-25
[134.476028] Starting dynamic subtest: pipe-A-DP-1
[134.670387] Dynamic subtest pipe-A-DP-1: SKIP (0.191s)
[134.704193] Starting dynamic subtest: pipe-B-DP-1
[134.840033] Dynamic subtest pipe-B-DP-1: SKIP (0.163s)
[134.876896] Starting dynamic subtest: pipe-C-DP-1
[135.012667] Dynamic subtest pipe-C-DP-1: SKIP (0.165s)
[135.053835] Subtest planes-downscale-factor-0-25: SKIP (0.521s)
[135.177900] [042/136] (878s left) gem_exec_balancer (bonded-sync)
[135.477380] Starting subtest: bonded-sync
[140.418659] Subtest bonded-sync: SUCCESS (4.767s)
[145.240467] [043/136] (868s left) gem_exec_schedule (preemptive-hang)
[145.679444] Starting subtest: preemptive-hang
[145.698428] Starting dynamic subtest: rcs0
[152.104983] Dynamic subtest rcs0: SUCCESS (6.231s)
[152.139699] Starting dynamic subtest: bcs0
[158.100121] Dynamic subtest bcs0: SUCCESS (6.013s)
[158.134958] Starting dynamic subtest: vcs0
[164.111092] Dynamic subtest vcs0: SUCCESS (6.016s)
[164.146812] Starting dynamic subtest: vecs0
[170.137180] Dynamic subtest vecs0: SUCCESS (6.023s)
[170.155702] Subtest preemptive-hang: SUCCESS (24.286s)
[170.243343] [044/136] (843s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_ccs)
[170.715758] Starting subtest: pipe-B-crc-primary-basic-y_tiled_ccs
[171.410436] Subtest pipe-B-crc-primary-basic-y_tiled_ccs: SUCCESS (0.686s)
[171.958120] [045/136] (842s left) vgem_basic (mmap)
[172.280283] Starting subtest: mmap
[172.319790] Subtest mmap: SUCCESS (0.034s)
[172.428102] [046/136] (841s left) gem_exec_params (mmapped)
[172.707286] Starting subtest: mmapped
[172.728828] Subtest mmapped: SUCCESS (0.006s)
[172.863337] [047/136] (841s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_dg2_mc_ccs)
[173.407465] Subtest pipe-D-bad-rotation-90-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[173.746856] [048/136] (840s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[174.016352] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[174.037532] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.002s)
[174.141699] [049/136] (840s left) kms_ccs (pipe-c-random-ccs-data-y_tiled_gen12_rc_ccs_cc)
[174.650426] Starting subtest: pipe-C-random-ccs-data-y_tiled_gen12_rc_ccs_cc
[174.709674] Subtest pipe-C-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[175.012838] [050/136] (839s left) v3d/v3d_submit_cl (valid-submission)
[175.380670] Subtest valid-submission: SKIP (0.000s)
[175.482435] [051/136] (839s left) kms_plane_scaling (i915-max-source-size)
[175.883585] Subtest i915-max-source-size: SKIP (0.000s)
[175.986986] [052/136] (838s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_dg2_mc_ccs)
[176.442673] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_dg2_mc_ccs
[176.485530] Subtest pipe-A-crc-primary-rotation-180-4_tiled_dg2_mc_ccs: SKIP (0.002s)
[176.847680] [053/136] (837s left) kms_getfb (getfb-repeated-different-handles)
[177.128179] Starting subtest: getfb-repeated-different-handles
[177.148966] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[177.260339] [054/136] (837s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[177.682091] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[177.722176] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[177.827789] [055/136] (837s left) kms_flip (flip-vs-blocking-wf-vblank)
[178.212645] Starting subtest: flip-vs-blocking-wf-vblank
[178.233115] Starting dynamic subtest: A-DP1
[189.176914] Dynamic subtest A-DP1: SUCCESS (10.822s)
[189.216103] Starting dynamic subtest: B-DP1
[199.748794] Dynamic subtest B-DP1: SUCCESS (10.747s)
[199.783244] Starting dynamic subtest: C-DP1
[210.672672] Dynamic subtest C-DP1: SUCCESS (10.747s)
[210.691481] Subtest flip-vs-blocking-wf-vblank: SUCCESS (32.327s)
[210.932245] [056/136] (804s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs)
[211.413558] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs
[211.451602] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SKIP (0.007s)
[211.811286] [057/136] (803s left) kms_getfb (getfb2-accept-ccs)
[212.081656] Starting subtest: getfb2-accept-ccs
[212.102485] Subtest getfb2-accept-ccs: SUCCESS (0.001s)
[212.223977] [058/136] (803s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[212.641432] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[212.680545] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[212.788968] [059/136] (802s left) kms_ccs (pipe-d-missing-ccs-buffer-y_tiled_gen12_mc_ccs)
[213.334262] Subtest pipe-D-missing-ccs-buffer-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[213.660448] [060/136] (801s left) kms_chamelium_frames (dp-crc-single)
[214.145986] Subtest dp-crc-single: SKIP (0.000s)
[214.446095] [061/136] (801s left) v3d/v3d_perfmon (create-perfmon-0)
[214.826418] Subtest create-perfmon-0: SKIP (0.000s)
[214.932744] [062/136] (800s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-b)
[215.296909] Starting subtest: universal-plane-pageflip-windowed-pipe-B
[216.022935] Subtest universal-plane-pageflip-windowed-pipe-B: SUCCESS (0.713s)
[216.359482] [063/136] (799s left) gem_ctx_shared (disjoint-timelines)
[216.664469] Starting subtest: disjoint-timelines
[216.683234] Subtest disjoint-timelines: SUCCESS (0.018s)
[216.947411] [064/136] (798s left) kms_lease (lease_invalid_connector)
[217.312466] Starting subtest: lease_invalid_connector
[217.331296] Starting dynamic subtest: pipe-A-DP-1
[217.469521] Dynamic subtest pipe-A-DP-1: SUCCESS (0.149s)
[217.515129] Starting dynamic subtest: pipe-B-DP-1
[217.535623] Dynamic subtest pipe-B-DP-1: SUCCESS (0.018s)
[217.570482] Starting dynamic subtest: pipe-C-DP-1
[217.589442] Dynamic subtest pipe-C-DP-1: SUCCESS (0.018s)
[217.610892] Subtest lease_invalid_connector: SUCCESS (0.188s)
[217.855911] [065/136] (798s left) kms_vblank (pipe-a-query-forked)
[218.222922] Starting subtest: pipe-A-query-forked
[220.574516] Subtest pipe-A-query-forked: SUCCESS (2.350s)
[220.968211] [066/136] (795s left) gem_lmem_swapping (verify-random)
[221.279754] Subtest verify-random: SKIP (0.000s)
[221.411426] [067/136] (794s left) i915_power (sanity)
[221.726524] Starting subtest: sanity
[225.929112] Subtest sanity: SUCCESS (4.016s)
[226.061536] [068/136] (790s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[226.525607] Starting subtest: fbcpsr-rgb101010-draw-render
[226.576185] Subtest fbcpsr-rgb101010-draw-render: SKIP (0.000s)
[226.717952] [069/136] (789s left) gem_exec_balancer (sequential)
[227.030263] Starting subtest: sequential
[231.852629] Subtest sequential: SUCCESS (4.644s)
[236.729409] [070/136] (779s left) kms_content_protection (type1)
[237.147601] Starting subtest: type1
[237.830752] Subtest type1: SKIP (0.658s)
[238.255815] [071/136] (778s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[238.625470] Starting subtest: cursorA-vs-flipB-toggle
[238.662960] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[238.777482] [072/136] (778s left) gem_exec_params (invalid-bsd-ring)
[239.048978] Starting subtest: invalid-bsd-ring
[239.070182] Subtest invalid-bsd-ring: SUCCESS (0.002s)
[239.201916] [073/136] (777s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[239.647063] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[239.685571] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[239.792116] [074/136] (777s left) i915_pipe_stress (stress-xrgb8888-untiled)
[240.188958] Starting subtest: stress-xrgb8888-untiled
[248.227738] Subtest stress-xrgb8888-untiled: FAIL (6.767s)
[248.325961] [075/136] (768s left) gen9_exec_parse (shadow-peek)
[248.625310] Starting subtest: shadow-peek
[248.646602] Subtest shadow-peek: SUCCESS (0.005s)
[248.875551] [076/136] (768s left) kms_busy (extended-pageflip-hang-oldfb)
[249.270046] Starting subtest: extended-pageflip-hang-oldfb
[249.292443] Starting dynamic subtest: pipe-A
[249.588636] Dynamic subtest pipe-A: SUCCESS (0.329s)
[249.626958] Starting dynamic subtest: pipe-C
[250.065585] Dynamic subtest pipe-C: SUCCESS (0.478s)
[250.096066] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.810s)
[250.465577] [077/136] (766s left) api_intel_bb (misplaced-blitter)
[250.769523] Starting subtest: misplaced-blitter
[250.794080] Subtest misplaced-blitter: SUCCESS (0.018s)
[250.926926] [078/136] (766s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_dg2_mc_ccs)
[251.479439] Starting subtest: pipe-C-bad-rotation-90-4_tiled_dg2_mc_ccs
[251.531103] Subtest pipe-C-bad-rotation-90-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[251.872712] [079/136] (765s left) gem_pread (exhaustion)
[252.187313] Starting subtest: exhaustion
[274.887508] Subtest exhaustion: SUCCESS (22.716s)
[275.016471] [080/136] (742s left) gem_mmap_gtt (hang-user)
[275.289469] Starting subtest: hang-user
[290.946793] Subtest hang-user: SUCCESS (15.478s)
[291.063139] [081/136] (726s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[291.480573] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[291.523788] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[291.633230] [082/136] (726s left) kms_vblank (pipe-d-wait-idle)
[292.017486] Subtest pipe-D-wait-idle: SKIP (0.000s)
[292.172065] [083/136] (725s left) gem_spin_batch (resubmit)
[292.475882] Starting subtest: resubmit
[292.494796] Starting dynamic subtest: rcs0
[292.513529] Dynamic subtest rcs0: SUCCESS (0.008s)
[292.547706] Starting dynamic subtest: bcs0
[292.567687] Dynamic subtest bcs0: SUCCESS (0.008s)
[292.604179] Starting dynamic subtest: vcs0
[292.625299] Dynamic subtest vcs0: SUCCESS (0.006s)
[292.661313] Starting dynamic subtest: vecs0
[292.681756] Dynamic subtest vecs0: SUCCESS (0.006s)
[292.700477] Subtest resubmit: SUCCESS (0.033s)
[292.807616] [084/136] (725s left) syncobj_timeline (32bits-limit)
[293.080732] Starting subtest: 32bits-limit
[293.099827] Subtest 32bits-limit: SUCCESS (0.003s)
[293.192694] [085/136] (725s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[293.609793] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[293.648645] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[293.765939] [086/136] (724s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[294.188971] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[294.231955] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[294.341686] [087/136] (724s left) gem_exec_schedule (timeslicing)
[294.779746] Starting subtest: timeslicing
[294.799579] Starting dynamic subtest: rcs0
[294.818410] Dynamic subtest rcs0: SUCCESS (0.010s)
[294.852339] Starting dynamic subtest: bcs0
[294.871069] Dynamic subtest bcs0: SUCCESS (0.010s)
[294.906251] Starting dynamic subtest: vcs0
[294.928032] Dynamic subtest vcs0: SUCCESS (0.007s)
[294.964263] Starting dynamic subtest: vecs0
[294.984822] Dynamic subtest vecs0: SUCCESS (0.008s)
[295.004333] Subtest timeslicing: SUCCESS (0.039s)
[295.089322] [088/136] (723s left) gem_exec_reloc (basic-gtt-cpu)
[295.391164] Starting subtest: basic-gtt-cpu
[295.410091] Subtest basic-gtt-cpu: SUCCESS (0.022s)
[295.616951] [089/136] (722s left) kms_plane_cursor (primary)
[296.009078] Starting subtest: primary
[296.031374] Starting dynamic subtest: pipe-A-DP-1-size-64
[298.418840] Dynamic subtest pipe-A-DP-1-size-64: SUCCESS (2.429s)
[298.480299] Starting dynamic subtest: pipe-A-DP-1-size-128
[300.883546] Dynamic subtest pipe-A-DP-1-size-128: SUCCESS (2.432s)
[300.943492] Starting dynamic subtest: pipe-A-DP-1-size-256
[303.333959] Dynamic subtest pipe-A-DP-1-size-256: SUCCESS (2.416s)
[303.494384] Starting dynamic subtest: pipe-B-DP-1-size-64
[306.106298] Dynamic subtest pipe-B-DP-1-size-64: SUCCESS (2.637s)
[306.169719] Starting dynamic subtest: pipe-B-DP-1-size-128
[308.559441] Dynamic subtest pipe-B-DP-1-size-128: SUCCESS (2.415s)
[308.627898] Starting dynamic subtest: pipe-B-DP-1-size-256
[311.005463] Dynamic subtest pipe-B-DP-1-size-256: SUCCESS (2.415s)
[311.158489] Starting dynamic subtest: pipe-C-DP-1-size-64
[313.766800] Dynamic subtest pipe-C-DP-1-size-64: SUCCESS (2.645s)
[313.827561] Starting dynamic subtest: pipe-C-DP-1-size-128
[316.215903] Dynamic subtest pipe-C-DP-1-size-128: SUCCESS (2.415s)
[316.272660] Starting dynamic subtest: pipe-C-DP-1-size-256
[318.688806] Dynamic subtest pipe-C-DP-1-size-256: SUCCESS (2.432s)
[318.805218] Subtest primary: SUCCESS (22.812s)
[319.147315] [090/136] (699s left) kms_invalid_mode (clock-too-high)
[319.537633] Starting subtest: clock-too-high
[319.556616] Starting dynamic subtest: DP-1-pipe-A
[319.630986] Dynamic subtest DP-1-pipe-A: SUCCESS (0.090s)
[319.686669] Starting dynamic subtest: DP-1-pipe-B
[319.707864] Dynamic subtest DP-1-pipe-B: SUCCESS (0.003s)
[319.743350] Starting dynamic subtest: DP-1-pipe-C
[319.762122] Dynamic subtest DP-1-pipe-C: SUCCESS (0.003s)
[319.780948] Subtest clock-too-high: SUCCESS (0.099s)
[319.986068] [091/136] (698s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[320.410474] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[320.450574] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[320.560392] [092/136] (698s left) i915_pm_rpm (cursor-dpms)
[322.536758] Starting subtest: cursor-dpms
[325.157822] Subtest cursor-dpms: SUCCESS (2.619s)
[325.632445] [093/136] (693s left) syncobj_wait (single-wait-submitted)
[325.906688] Starting subtest: single-wait-submitted
[325.996445] Subtest single-wait-submitted: SUCCESS (0.101s)
[326.134409] [094/136] (692s left) kms_ccs (pipe-d-crc-primary-rotation-180-yf_tiled_ccs)
[326.669987] Subtest pipe-D-crc-primary-rotation-180-yf_tiled_ccs: SKIP (0.000s)
[327.011425] [095/136] (692s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-wc)
[327.436075] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-wc
[327.476991] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[327.584836] [096/136] (691s left) i915_pm_rpm (modeset-lpsp-stress-no-wait)
[329.451897] Starting subtest: modeset-lpsp-stress-no-wait
[329.706172] Subtest modeset-lpsp-stress-no-wait: SKIP (0.203s)
[330.230410] [097/136] (689s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[330.609142] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[330.665889] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.004s)
[330.808725] [098/136] (688s left) gem_exec_params (invalid-bsd2-flag-on-render)
[331.107788] Starting subtest: invalid-bsd2-flag-on-render
[331.135218] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.001s)
[331.278644] [099/136] (688s left) gen7_exec_parse (basic-allocation)
[331.585993] Subtest basic-allocation: SKIP (0.000s)
[331.690944] [100/136] (688s left) gem_busy (busy)
[331.994275] Starting subtest: busy
[332.013255] Starting dynamic subtest: all-engines
[332.081708] Dynamic subtest all-engines: SUCCESS (0.087s)
[332.119558] Starting dynamic subtest: rcs0
[332.141137] Dynamic subtest rcs0: SUCCESS (0.023s)
[332.178442] Starting dynamic subtest: bcs0
[332.197286] Dynamic subtest bcs0: SUCCESS (0.015s)
[332.232356] Starting dynamic subtest: vcs0
[332.251078] Dynamic subtest vcs0: SUCCESS (0.017s)
[332.290511] Starting dynamic subtest: vecs0
[332.311667] Dynamic subtest vecs0: SUCCESS (0.014s)
[332.333084] Subtest busy: SUCCESS (0.164s)
[332.573407] [101/136] (687s left) kms_prime (basic-crc-vgem)
[335.040176] Starting subtest: basic-crc-vgem
[335.059233] Starting dynamic subtest: second-to-first
[336.294075] Dynamic subtest second-to-first: SUCCESS (1.267s)
[336.312894] Subtest basic-crc-vgem: SUCCESS (1.268s)
[336.445891] [102/136] (683s left) kms_fence_pin_leak
[340.714649] [103/136] (679s left) kms_big_fb (linear-32bpp-rotate-90)
[341.141601] Starting subtest: linear-32bpp-rotate-90
[341.205852] Subtest linear-32bpp-rotate-90: SKIP (0.079s)
[341.351868] [104/136] (678s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[341.774645] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[341.811781] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[341.927818] [105/136] (678s left) syncobj_basic (bad-destroy)
[342.196894] Starting subtest: bad-destroy
[342.218748] Subtest bad-destroy: SUCCESS (0.000s)
[342.329820] [106/136] (678s left) kms_vblank (pipe-a-ts-continuation-modeset-rpm)
[342.693882] Starting subtest: pipe-A-ts-continuation-modeset-rpm
[344.613602] Subtest pipe-A-ts-continuation-modeset-rpm: SUCCESS (1.917s)
[345.082709] [107/136] (675s left) gem_render_copy (y-tiled)
[345.385125] Starting subtest: y-tiled
[345.405418] Starting dynamic subtest: smem
[345.680202] Dynamic subtest smem: SUCCESS (0.300s)
[345.700801] Subtest y-tiled: SUCCESS (0.302s)
[345.929671] [108/136] (674s left) kms_atomic_transition (plane-all-transition)
[346.305749] Starting subtest: plane-all-transition
[346.327121] Starting dynamic subtest: pipe-A-DP-1
[350.254367] Dynamic subtest pipe-A-DP-1: SUCCESS (3.942s)
[350.393573] Starting dynamic subtest: pipe-B-DP-1
[354.730250] Dynamic subtest pipe-B-DP-1: SUCCESS (4.374s)
[354.830144] Subtest plane-all-transition: SUCCESS (8.516s)
[355.191544] [109/136] (665s left) gem_ctx_param (invalid-ctx-get)
[355.503698] Starting subtest: invalid-ctx-get
[355.526309] Subtest invalid-ctx-get: SUCCESS (0.000s)
[355.645085] [110/136] (665s left) gem_workarounds (basic-read-fd)
[355.960905] Starting subtest: basic-read-fd
[356.001903] Subtest basic-read-fd: SUCCESS (0.026s)
[356.158232] [111/136] (664s left) gem_ctx_param (invalid-ctx-set)
[356.427559] Starting subtest: invalid-ctx-set
[356.449521] Subtest invalid-ctx-set: SUCCESS (0.000s)
[356.564062] [112/136] (664s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[356.972141] Starting subtest: 4-tiled-8bpp-rotate-0
[357.016855] Subtest 4-tiled-8bpp-rotate-0: SKIP (0.000s)
[357.132282] [113/136] (663s left) kms_flip (bo-too-big-interruptible)
[357.497578] Starting subtest: bo-too-big-interruptible
[357.516775] Starting dynamic subtest: A-DP1
[361.414216] Dynamic subtest A-DP1: SUCCESS (3.739s)
[361.459716] Starting dynamic subtest: B-DP1
[365.019886] Dynamic subtest B-DP1: SUCCESS (3.612s)
[365.058118] Starting dynamic subtest: C-DP1
[368.623844] Dynamic subtest C-DP1: SUCCESS (3.593s)
[368.644461] Subtest bo-too-big-interruptible: SUCCESS (10.956s)
[369.151700] [114/136] (652s left) gem_exec_fence (syncobj-invalid-wait)
[369.974102] Starting subtest: syncobj-invalid-wait
[369.994471] Subtest syncobj-invalid-wait: SUCCESS (0.001s)
[370.465695] [115/136] (650s left) perf_pmu (init-wait)
[370.746074] Starting subtest: init-wait
[370.767850] Starting dynamic subtest: rcs0
[370.789364] Dynamic subtest rcs0: SUCCESS (0.003s)
[370.826847] Starting dynamic subtest: bcs0
[370.847038] Dynamic subtest bcs0: SUCCESS (0.002s)
[370.882236] Starting dynamic subtest: vcs0
[370.901136] Dynamic subtest vcs0: SUCCESS (0.002s)
[370.936196] Starting dynamic subtest: vecs0
[370.956377] Dynamic subtest vecs0: SUCCESS (0.002s)
[370.978029] Subtest init-wait: SUCCESS (0.014s)
[371.089678] [116/136] (650s left) feature_discovery (display-3x)
[371.478472] Starting subtest: display-3x
[371.521642] Subtest display-3x: SKIP (0.000s)
[371.636813] [117/136] (649s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[371.998129] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[372.016944] Starting dynamic subtest: pipe-A-valid-mode
[372.134587] Dynamic subtest pipe-A-valid-mode: SKIP (0.098s)
[372.172167] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SKIP (0.100s)
[372.447415] [118/136] (649s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[372.871051] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[375.108979] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (2.302s)
[375.285494] [119/136] (646s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[375.714250] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[375.756460] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[375.867922] [120/136] (645s left) kms_flip (2x-dpms-vs-vblank-race)
[376.253713] Starting subtest: 2x-dpms-vs-vblank-race
[376.306138] Subtest 2x-dpms-vs-vblank-race: SKIP (0.004s)
[376.443196] [121/136] (645s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[376.898112] Starting subtest: x-tiled-64bpp-rotate-0
[386.214368] Subtest x-tiled-64bpp-rotate-0: SUCCESS (9.368s)
[387.364417] [122/136] (634s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[387.747958] Starting subtest: FB-8BPC-Vs-Panel-6BPC
[387.770231] Starting dynamic subtest: pipe-A-DP-1
[388.193985] Dynamic subtest pipe-A-DP-1: SUCCESS (0.443s)
[388.214707] Subtest FB-8BPC-Vs-Panel-6BPC: SUCCESS (0.446s)
[388.648802] [123/136] (633s left) kms_psr (psr2_sprite_plane_move)
[388.945334] Subtest psr2_sprite_plane_move: SKIP (0.000s)
[389.056668] [124/136] (633s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[389.513073] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[389.553704] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[389.690680] [125/136] (632s left) syncobj_wait (multi-wait-all-signaled)
[389.961926] Starting subtest: multi-wait-all-signaled
[389.980585] Subtest multi-wait-all-signaled: SUCCESS (0.002s)
[390.094704] [126/136] (632s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[390.395031] Starting subtest: basic-cpu-gtt-noreloc
[390.416151] Subtest basic-cpu-gtt-noreloc: SUCCESS (0.015s)
[390.630264] [127/136] (631s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[391.048124] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[393.636732] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (2.649s)
[393.822979] [128/136] (628s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[394.248443] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[394.290236] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[394.400276] [129/136] (628s left) gem_exec_nop (basic-sequential)
[394.853633] Starting subtest: basic-sequential
[397.858566] Subtest basic-sequential: SUCCESS (3.112s)
[398.088974] [130/136] (624s left) perf_pmu (event-wait)
[398.368482] Starting subtest: event-wait
[398.387765] Starting dynamic subtest: rcs0
[398.425736] Dynamic subtest rcs0: SKIP (0.000s)
[398.466821] Subtest event-wait: SKIP (0.002s)
[398.580151] [131/136] (624s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[398.880829] Starting subtest: yf-tiled-to-vebox-yf-tiled
[398.920372] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[399.112323] [132/136] (624s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[399.512409] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[400.786273] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.292s)
[401.326791] [133/136] (621s left) kms_chamelium_hpd (vga-hpd-fast)
[401.814952] Subtest vga-hpd-fast: SKIP (0.000s)
[402.131996] [134/136] (621s left) kms_flip (dpms-off-confusion-interruptible)
[402.493066] Starting subtest: dpms-off-confusion-interruptible
[402.511813] Starting dynamic subtest: A-DP1
[413.192539] Dynamic subtest A-DP1: SUCCESS (10.501s)
[413.228378] Starting dynamic subtest: B-DP1
[423.626704] Dynamic subtest B-DP1: SUCCESS (10.429s)
[423.664717] Starting dynamic subtest: C-DP1
[433.846936] Dynamic subtest C-DP1: SUCCESS (10.416s)
[433.868888] Subtest dpms-off-confusion-interruptible: SUCCESS (31.358s)
[434.315360] [135/136] (589s left) v3d/v3d_wait_bo (bad-pad)
[434.694277] Subtest bad-pad: SKIP (0.000s)
[434.801557] [136/136] (588s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[435.100320] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[435.119168] Starting dynamic subtest: smem
[435.537839] Dynamic subtest smem: SUCCESS (0.454s)
[435.559368] Subtest y-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.456s)
[435.755538] Closing watchdogs
Done.