[42.622621] Initializing watchdogs
[42.622833]   /dev/watchdog0
[42.684526] [001/130] (960s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[43.132641] Starting subtest: cursorB-vs-flipA-varying-size
[43.184616] Subtest cursorB-vs-flipA-varying-size: SKIP (0.005s)
[43.366438] [002/130] (959s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[43.788741] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[43.831907] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.001s)
[43.921873] [003/130] (959s left) gem_exec_reloc (basic-cpu-read-noreloc)
[44.217293] Starting subtest: basic-cpu-read-noreloc
[44.241230] Subtest basic-cpu-read-noreloc: SUCCESS (0.025s)
[44.502107] [004/130] (959s left) gem_exec_reloc (basic-concurrent16)
[44.742214] Starting subtest: basic-concurrent16
[50.342295] Subtest basic-concurrent16: SUCCESS (5.546s)
[50.541585] [005/130] (953s left) dumb_buffer (create-valid-dumb)
[50.813079] Starting subtest: create-valid-dumb
[50.833183] Subtest create-valid-dumb: SUCCESS (0.000s)
[50.927613] [006/130] (952s left) gem_exec_fence (invalid-fence-array)
[51.843759] Starting subtest: invalid-fence-array
[51.863796] Subtest invalid-fence-array: SUCCESS (0.007s)
[52.249174] [007/130] (951s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[52.627693] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[52.647535] Starting dynamic subtest: pipe-A-DP-1
[52.857266] Dynamic subtest pipe-A-DP-1: SKIP (0.000s)
[52.895950] Starting dynamic subtest: pipe-B-DP-1
[53.134213] Dynamic subtest pipe-B-DP-1: SKIP (0.000s)
[53.174940] Starting dynamic subtest: pipe-C-DP-1
[53.386737] Dynamic subtest pipe-C-DP-1: SKIP (0.000s)
[53.429139] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SKIP (0.009s)
[53.528202] [008/130] (950s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[53.879333] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[53.951108] Starting dynamic subtest: pipe-A-DP-1
[54.660763] Dynamic subtest pipe-A-DP-1: SKIP (0.011s)
[54.702801] Starting dynamic subtest: pipe-B-DP-1
[55.412317] Dynamic subtest pipe-B-DP-1: SKIP (0.011s)
[55.464730] Starting dynamic subtest: pipe-C-DP-1
[56.067027] Dynamic subtest pipe-C-DP-1: SKIP (0.009s)
[56.119754] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.037s)
[56.235741] [009/130] (947s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[56.502108] Starting subtest: basic-cpu-gtt-noreloc
[56.527729] Subtest basic-cpu-gtt-noreloc: SUCCESS (0.018s)
[56.732834] [010/130] (947s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[56.962914] Starting subtest: wait-all-for-submit-delayed-submit
[57.037657] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.107s)
[57.153633] [011/130] (947s left) core_auth (getclient-master-drop)
[57.377939] Starting subtest: getclient-master-drop
[57.420605] Subtest getclient-master-drop: SUCCESS (0.006s)
[57.518758] [012/130] (946s left) gem_ctx_param (get-priority-new-ctx)
[57.783436] Starting subtest: get-priority-new-ctx
[57.805490] Subtest get-priority-new-ctx: SUCCESS (0.000s)
[57.898578] [013/130] (946s left) gem_exec_reloc (basic-gtt-cpu-active)
[58.137509] Starting subtest: basic-gtt-cpu-active
[58.264395] Subtest basic-gtt-cpu-active: SUCCESS (0.148s)
[58.536726] [014/130] (945s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[58.946758] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[58.989313] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[59.081616] [015/130] (945s left) gem_close_race (basic-threads)
[59.351154] Starting subtest: basic-threads
[60.643995] Subtest basic-threads: SUCCESS (1.300s)
[60.870668] [016/130] (943s left) kms_atomic (plane-cursor-legacy)
[61.223396] Starting subtest: plane-cursor-legacy
[61.243484] Starting dynamic subtest: pipe-A-DP-1
[61.576180] Dynamic subtest pipe-A-DP-1: SUCCESS (0.348s)
[61.606231] Subtest plane-cursor-legacy: SUCCESS (0.351s)
[61.958539] [017/130] (942s left) prime_mmap (test_aperture_limit)
[62.206817] Starting subtest: test_aperture_limit
[62.228988] Starting dynamic subtest: test_aperture_limit-smem
[62.250516] Dynamic subtest test_aperture_limit-smem: SUCCESS (0.043s)
[62.271055] Subtest test_aperture_limit: SUCCESS (0.043s)
[62.364825] [018/130] (942s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[62.770246] Starting subtest: psr-rgb565-draw-blt
[62.814863] Subtest psr-rgb565-draw-blt: SKIP (0.000s)
[62.909404] [019/130] (942s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[63.293202] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s)
[63.382270] [020/130] (941s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[63.726075] Starting subtest: cursorA-vs-flipB-varying-size
[63.765905] Subtest cursorA-vs-flipB-varying-size: SKIP (0.002s)
[63.879766] [021/130] (941s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[64.140780] Starting subtest: etime-multi-wait-all-for-submit-submitted
[64.202821] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.104s)
[64.336488] [022/130] (940s left) kms_flip (absolute-wf_vblank-interruptible)
[64.709965] Starting subtest: absolute-wf_vblank-interruptible
[64.731677] Starting dynamic subtest: A-DP1
[75.374225] Dynamic subtest A-DP1: SUCCESS (10.673s)
[75.411989] Starting dynamic subtest: B-DP1
[86.011453] Dynamic subtest B-DP1: SUCCESS (10.635s)
[86.051372] Starting dynamic subtest: C-DP1
[96.667067] Dynamic subtest C-DP1: SUCCESS (10.650s)
[96.689263] Subtest absolute-wf_vblank-interruptible: SUCCESS (31.965s)
[97.118368] [023/130] (908s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[97.467517] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[97.508038] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[97.921204] [024/130] (907s left) kms_pm_backlight (bad-brightness)
[98.298398] Subtest bad-brightness: SKIP (0.000s)
[98.392778] [025/130] (907s left) gem_mmap_gtt (medium-copy-xy)
[98.662440] Starting subtest: medium-copy-XY
[105.188730] Subtest medium-copy-XY: SUCCESS (6.580s)
[105.344474] [026/130] (900s left) api_intel_bb (blit-reloc-purge-cache)
[105.715534] Starting subtest: blit-reloc-purge-cache
[105.740155] Subtest blit-reloc-purge-cache: SUCCESS (0.022s)
[105.858218] [027/130] (899s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[106.336258] Starting subtest: psr-2p-pri-indfb-multidraw
[106.377557] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[106.471727] [028/130] (899s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[106.930194] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[107.024538] [029/130] (898s left) gem_busy (semaphore)
[107.405380] Starting subtest: semaphore
[107.426170] Starting dynamic subtest: rcs0
[107.473312] Dynamic subtest rcs0: SUCCESS (0.049s)
[107.516517] Starting dynamic subtest: bcs0
[107.535746] Dynamic subtest bcs0: SUCCESS (0.033s)
[107.594230] Starting dynamic subtest: vcs0
[107.616351] Dynamic subtest vcs0: SUCCESS (0.031s)
[107.662344] Starting dynamic subtest: vecs0
[107.681616] Dynamic subtest vecs0: SUCCESS (0.029s)
[107.703706] Subtest semaphore: SUCCESS (0.144s)
[107.796312] [030/130] (898s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[108.161309] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[108.185925] Starting dynamic subtest: pipe-A-valid-mode
[108.662610] Dynamic subtest pipe-A-valid-mode: SKIP (0.459s)
[108.714696] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SKIP (0.462s)
[109.029560] [031/130] (897s left) kms_invalid_mode (clock-too-high)
[109.405060] Starting subtest: clock-too-high
[109.424763] Starting dynamic subtest: pipe-A-DP-1
[109.493440] Dynamic subtest pipe-A-DP-1: SUCCESS (0.096s)
[109.532507] Starting dynamic subtest: pipe-B-DP-1
[109.554397] Dynamic subtest pipe-B-DP-1: SUCCESS (0.003s)
[109.597171] Starting dynamic subtest: pipe-C-DP-1
[109.616539] Dynamic subtest pipe-C-DP-1: SUCCESS (0.003s)
[109.636296] Subtest clock-too-high: SUCCESS (0.109s)
[109.880361] [032/130] (896s left) gem_mmap_gtt (basic-copy)
[110.124700] Starting subtest: basic-copy
[110.893487] Subtest basic-copy: SUCCESS (0.802s)
[111.048398] [033/130] (895s left) gem_exec_schedule (wide)
[111.495983] Starting subtest: wide
[111.517668] Starting dynamic subtest: rcs0
[133.648864] Dynamic subtest rcs0: SUCCESS (22.151s)
[133.696857] Starting dynamic subtest: bcs0
[157.002307] Dynamic subtest bcs0: SUCCESS (23.349s)
[157.049319] Starting dynamic subtest: vcs0
[180.021331] Dynamic subtest vcs0: SUCCESS (23.022s)
[180.072202] Starting dynamic subtest: vecs0
[202.840954] Dynamic subtest vecs0: SUCCESS (22.824s)
[202.860706] Subtest wide: SUCCESS (91.354s)
[203.901303] [034/130] (802s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[204.255681] Starting subtest: flip-vs-cursor-busy-crc-legacy
[205.108690] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.851s)
[205.512325] [035/130] (800s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[205.777883] Starting subtest: basic-cpu-wc-noreloc
[205.797643] Subtest basic-cpu-wc-noreloc: SUCCESS (0.013s)
[206.016671] [036/130] (800s left) gem_pipe_control_store_loop (reused-buffer)
[206.297694] Starting subtest: reused-buffer
[208.597277] Subtest reused-buffer: SUCCESS (2.155s)
[208.715551] [037/130] (797s left) gem_tiled_swapping (non-threaded)
[234.276549] Starting subtest: non-threaded
[251.641588] Subtest non-threaded: FAIL (16.696s)
[255.396950] [038/130] (751s left) gem_exec_balancer (invalid-bonds)
[255.781933] Starting subtest: invalid-bonds
[255.804194] Subtest invalid-bonds: SUCCESS (0.008s)
[261.397968] [039/130] (745s left) gem_render_copy_redux (normal)
[261.659258] Starting subtest: normal
[264.029177] Subtest normal: SUCCESS (2.405s)
[264.180919] [040/130] (742s left) kms_psr (psr-sprite-mmap-gtt)
[264.640801] Subtest psr-sprite-mmap-gtt: SKIP (0.000s)
[264.745539] [041/130] (742s left) gem_ctx_param (invalid-size-get)
[265.010542] Starting subtest: invalid-size-get
[265.030919] Subtest invalid-size-get: SUCCESS (0.000s)
[265.137756] [042/130] (742s left) gen9_exec_parse (allowed-single)
[265.402576] Starting subtest: allowed-single
[265.425075] Subtest allowed-single: SUCCESS (0.015s)
[265.663651] [043/130] (741s left) gem_wait (wait)
[265.930579] Starting subtest: wait
[265.953553] Starting dynamic subtest: all-engines
[266.979853] Dynamic subtest all-engines: SUCCESS (1.047s)
[267.030697] Starting dynamic subtest: rcs0
[268.011798] Dynamic subtest rcs0: SUCCESS (1.032s)
[268.061966] Starting dynamic subtest: bcs0
[269.043090] Dynamic subtest bcs0: SUCCESS (1.031s)
[269.092423] Starting dynamic subtest: vcs0
[270.073341] Dynamic subtest vcs0: SUCCESS (1.028s)
[270.122420] Starting dynamic subtest: vecs0
[271.101076] Dynamic subtest vecs0: SUCCESS (1.027s)
[271.123528] Subtest wait: SUCCESS (5.168s)
[271.383441] [044/130] (736s left) drm_fdinfo (memory-info-active)
[271.639600] Starting subtest: memory-info-active
[271.659314] Starting dynamic subtest: smem0
[274.595413] Dynamic subtest smem0: SUCCESS (2.983s)
[274.615495] Subtest memory-info-active: SUCCESS (2.984s)
[274.737351] [045/130] (732s left) syncobj_wait (invalid-signal-illegal-handle)
[275.017534] Starting subtest: invalid-signal-illegal-handle
[275.039333] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[275.147864] [046/130] (732s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[275.610511] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[275.712767] [047/130] (732s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[276.135032] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[278.750431] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (2.681s)
[278.949544] [048/130] (728s left) gem_userptr_blits (unsync-unmap-cycles)
[279.303737] Subtest unsync-unmap-cycles: SKIP (0.000s)
[279.407196] [049/130] (728s left) gem_render_copy (y-tiled-to-vebox-linear)
[279.672415] Starting subtest: y-tiled-to-vebox-linear
[279.714662] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[279.878537] [050/130] (728s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[280.296335] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[280.337140] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[280.438818] [051/130] (727s left) kms_psr (psr2-primary-render)
[280.810105] Subtest psr2-primary-render: SKIP (0.000s)
[280.911991] [052/130] (727s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[281.266961] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[281.289058] Starting dynamic subtest: pipe-A-DP-1
[281.541167] Dynamic subtest pipe-A-DP-1: SKIP (0.000s)
[281.593246] Starting dynamic subtest: pipe-B-DP-1
[281.869364] Dynamic subtest pipe-B-DP-1: SKIP (0.000s)
[281.925075] Starting dynamic subtest: pipe-C-DP-1
[282.155653] Dynamic subtest pipe-C-DP-1: SKIP (0.001s)
[282.201649] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.010s)
[282.313679] [053/130] (726s left) gem_userptr_blits (relocations)
[282.626573] Starting subtest: relocations
[282.666816] Subtest relocations: SKIP (0.004s)
[282.794082] [054/130] (725s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[283.234383] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[283.284842] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[283.407650] [055/130] (725s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[283.832349] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[283.873250] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[283.979496] [056/130] (724s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[284.372361] Starting subtest: x-tiled-16bpp-rotate-270
[284.480636] Subtest x-tiled-16bpp-rotate-270: SKIP (0.098s)
[284.596783] [057/130] (724s left) gem_ctx_persistence (engines-hostile-preempt)
[284.875626] Starting subtest: engines-hostile-preempt
[284.896334] Starting dynamic subtest: rcs0
[284.941041] Dynamic subtest rcs0: SUCCESS (0.116s)
[284.993897] Starting dynamic subtest: bcs0
[285.036231] Dynamic subtest bcs0: SUCCESS (0.102s)
[285.085593] Starting dynamic subtest: vcs0
[285.127817] Dynamic subtest vcs0: SUCCESS (0.090s)
[285.178858] Starting dynamic subtest: vecs0
[285.222422] Dynamic subtest vecs0: SUCCESS (0.097s)
[285.242147] Subtest engines-hostile-preempt: SUCCESS (0.409s)
[285.350520] [058/130] (723s left) kms_psr (pr-cursor-mmap-gtt)
[285.709192] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[285.811348] [059/130] (723s left) gem_reg_read (bad-register)
[286.051943] Starting subtest: bad-register
[286.079301] Subtest bad-register: SUCCESS (0.000s)
[286.184976] [060/130] (722s left) gem_exec_schedule (semaphore-codependency)
[286.623104] Starting subtest: semaphore-codependency
[286.643927] Subtest semaphore-codependency: SUCCESS (0.025s)
[286.882910] [061/130] (722s left) gem_ctx_shared (q-independent)
[287.149702] Starting subtest: Q-independent
[287.172252] Starting dynamic subtest: rcs0
[287.221835] Dynamic subtest rcs0: SUCCESS (0.091s)
[287.274360] Starting dynamic subtest: bcs0
[287.321342] Dynamic subtest bcs0: SUCCESS (0.090s)
[287.371822] Starting dynamic subtest: vcs0
[287.393642] Dynamic subtest vcs0: SUCCESS (0.071s)
[287.444129] Starting dynamic subtest: vecs0
[287.465033] Dynamic subtest vecs0: SUCCESS (0.077s)
[287.484857] Subtest Q-independent: SUCCESS (0.335s)
[287.751287] [062/130] (721s left) gem_partial_pwrite_pread (write-snoop)
[287.995733] Starting subtest: write-snoop
[303.521899] Subtest write-snoop: SUCCESS (15.527s)
[303.647571] [063/130] (705s left) kms_color (ctm-0-25)
[304.013789] Starting subtest: ctm-0-25
[304.034857] Starting dynamic subtest: pipe-A-DP-1
[305.912275] Dynamic subtest pipe-A-DP-1: SUCCESS (1.897s)
[305.965716] Starting dynamic subtest: pipe-B-DP-1
[308.015644] Dynamic subtest pipe-B-DP-1: SUCCESS (2.095s)
[308.065291] Starting dynamic subtest: pipe-C-DP-1
[310.114066] Dynamic subtest pipe-C-DP-1: SUCCESS (2.109s)
[310.138851] Subtest ctm-0-25: SUCCESS (6.105s)
[310.520280] [064/130] (698s left) kms_cursor_crc (cursor-size-change)
[310.906558] Starting subtest: cursor-size-change
[310.926752] Starting dynamic subtest: pipe-A-DP-1
[311.661410] Dynamic subtest pipe-A-DP-1: SUCCESS (0.767s)
[311.713390] Starting dynamic subtest: pipe-C-DP-1
[312.560611] Dynamic subtest pipe-C-DP-1: SUCCESS (0.878s)
[312.585164] Subtest cursor-size-change: SUCCESS (1.653s)
[312.983715] [065/130] (696s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[313.386372] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[313.426161] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[313.530693] [066/130] (696s left) kms_chamelium_frames (dp-crc-single)
[314.029249] Subtest dp-crc-single: SKIP (0.000s)
[314.373772] [067/130] (695s left) kms_cursor_crc (cursor-offscreen-256x85)
[314.738573] Starting subtest: cursor-offscreen-256x85
[314.763210] Starting dynamic subtest: pipe-A-DP-1
[317.219967] Dynamic subtest pipe-A-DP-1: SUCCESS (2.454s)
[317.330552] Starting dynamic subtest: pipe-C-DP-1
[319.914947] Dynamic subtest pipe-C-DP-1: SUCCESS (2.636s)
[319.937323] Subtest cursor-offscreen-256x85: SUCCESS (5.174s)
[320.332989] [068/130] (689s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[320.622663] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[320.649173] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.002s)
[320.781996] [069/130] (689s left) kms_pm_rpm (universal-planes-dpms)
[321.623691] Starting subtest: universal-planes-dpms
[321.647441] Starting dynamic subtest: plane-32
[324.405169] Dynamic subtest plane-32: SUCCESS (2.777s)
[324.455723] Starting dynamic subtest: plane-40
[327.166072] Dynamic subtest plane-40: SUCCESS (2.758s)
[327.217096] Starting dynamic subtest: plane-48
[329.920723] Dynamic subtest plane-48: SUCCESS (2.750s)
[329.977331] Starting dynamic subtest: plane-56
[332.982395] Dynamic subtest plane-56: SUCCESS (3.061s)
[333.005287] Subtest universal-planes-dpms: SUCCESS (11.360s)
[333.512567] [070/130] (676s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[333.880940] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[333.901519] Starting dynamic subtest: pipe-A-DP-1
[334.419736] Dynamic subtest pipe-A-DP-1: SUCCESS (0.376s)
[334.476116] Starting dynamic subtest: pipe-B-DP-1
[334.903757] Dynamic subtest pipe-B-DP-1: SUCCESS (0.542s)
[334.956482] Starting dynamic subtest: pipe-C-DP-1
[335.175939] Dynamic subtest pipe-C-DP-1: SKIP (0.002s)
[335.199869] Subtest crc-primary-rotation-180-y-tiled-ccs: SUCCESS (0.933s)
[335.648352] [071/130] (674s left) kms_feature_discovery (psr2)
[336.013263] Starting subtest: psr2
[336.056112] Subtest psr2: SKIP (0.000s)
[336.166954] [072/130] (674s left) i915_query (query-regions-sanity-check)
[336.440549] Starting subtest: query-regions-sanity-check
[336.462903] Subtest query-regions-sanity-check: SUCCESS (0.044s)
[336.597815] [073/130] (673s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[336.998622] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[337.042798] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[337.153099] [074/130] (673s left) kms_cursor_crc (cursor-random-64x64)
[337.521264] Starting subtest: cursor-random-64x64
[337.544797] Starting dynamic subtest: pipe-A-DP-1
[341.299123] Dynamic subtest pipe-A-DP-1: SUCCESS (3.784s)
[341.412589] Starting dynamic subtest: pipe-C-DP-1
[345.346389] Dynamic subtest pipe-C-DP-1: SUCCESS (3.960s)
[345.387172] Subtest cursor-random-64x64: SUCCESS (7.829s)
[345.768099] [075/130] (664s left) syncobj_wait (multi-wait-all-submitted-signaled)
[346.032097] Starting subtest: multi-wait-all-submitted-signaled
[346.085273] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.106s)
[346.226258] [076/130] (664s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[346.651226] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[348.693219] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SUCCESS (2.115s)
[348.860625] [077/130] (662s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[349.271275] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[349.315512] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[349.424473] [078/130] (661s left) gem_pxp (reject-modify-context-protection-on)
[352.375168] Subtest reject-modify-context-protection-on: SKIP (0.000s)
[352.580751] [079/130] (658s left) kms_vblank (query-forked-busy)
[352.942368] Starting subtest: query-forked-busy
[352.963431] Starting dynamic subtest: pipe-A-DP-1
[355.406740] Dynamic subtest pipe-A-DP-1: SUCCESS (2.463s)
[355.491873] Starting dynamic subtest: pipe-C-DP-1
[358.083934] Dynamic subtest pipe-C-DP-1: SUCCESS (2.662s)
[358.106309] Subtest query-forked-busy: SUCCESS (5.138s)
[358.461325] [080/130] (652s left) gem_softpin (evict-single-offset)
[358.715118] Starting subtest: evict-single-offset
[396.450682] Subtest evict-single-offset: SUCCESS (37.783s)
[396.590493] [081/130] (614s left) gem_exec_params (sol-reset-not-gen7)
[396.967378] Starting subtest: sol-reset-not-gen7
[396.986942] Subtest sol-reset-not-gen7: SUCCESS (0.004s)
[397.105364] [082/130] (614s left) gem_exec_flush (basic-uc-set-default)
[397.396922] Starting subtest: basic-uc-set-default
[402.848841] Subtest basic-uc-set-default: SUCCESS (5.513s)
[403.087307] [083/130] (608s left) kms_cursor_crc (cursor-sliding-128x128)
[403.590666] Starting subtest: cursor-sliding-128x128
[403.612662] Starting dynamic subtest: pipe-A-DP-1
[407.307066] Dynamic subtest pipe-A-DP-1: SUCCESS (3.695s)
[407.406960] Starting dynamic subtest: pipe-C-DP-1
[411.209879] Dynamic subtest pipe-C-DP-1: SUCCESS (3.821s)
[411.238783] Subtest cursor-sliding-128x128: SUCCESS (7.602s)
[411.607691] [084/130] (600s left) kms_vrr (lobf)
[411.973903] Starting subtest: lobf
[412.014817] Subtest lobf: SKIP (0.000s)
[412.123425] [085/130] (599s left) gem_lmem_swapping (parallel-random-engines)
[412.426347] Subtest parallel-random-engines: SKIP (0.000s)
[412.564524] [086/130] (599s left) perf (blocking-parameterized)
[413.275180] Starting subtest: blocking-parameterized
[433.567335] Subtest blocking-parameterized: SUCCESS (20.131s)
[433.677944] [087/130] (578s left) kms_big_fb (y-tiled-addfb)
[434.081183] Starting subtest: y-tiled-addfb
[434.103131] Subtest y-tiled-addfb: SUCCESS (0.001s)
[434.224628] [088/130] (577s left) kms_flip (plain-flip-ts-check-interruptible)
[434.593491] Starting subtest: plain-flip-ts-check-interruptible
[434.615103] Starting dynamic subtest: A-DP1
[445.405296] Dynamic subtest A-DP1: SUCCESS (10.810s)
[445.454911] Starting dynamic subtest: B-DP1
[456.145512] Dynamic subtest B-DP1: SUCCESS (10.742s)
[456.196396] Starting dynamic subtest: C-DP1
[466.891992] Dynamic subtest C-DP1: SUCCESS (10.743s)
[466.951060] Subtest plain-flip-ts-check-interruptible: SUCCESS (32.309s)
[467.384580] [089/130] (544s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[467.805173] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[467.848316] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[467.955928] [090/130] (544s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[468.375224] Starting subtest: psr-farfromfence-mmap-gtt
[468.414897] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[468.525988] [091/130] (543s left) kms_pm_backlight (fade-with-dpms)
[468.889525] Subtest fade-with-dpms: SKIP (0.000s)
[468.996995] [092/130] (543s left) kms_joiner (basic-force-big-joiner)
[469.410478] Starting subtest: basic-force-big-joiner
[469.460041] Subtest basic-force-big-joiner: SKIP (0.000s)
[469.589418] [093/130] (543s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[470.016754] Starting subtest: 4-tiled-32bpp-rotate-0
[470.071586] Subtest 4-tiled-32bpp-rotate-0: SKIP (0.000s)
[470.194871] [094/130] (542s left) gem_sync (basic-many-each)
[470.638228] Starting subtest: basic-many-each
[472.967456] Subtest basic-many-each: SUCCESS (2.445s)
[473.147498] [095/130] (539s left) kms_busy (extended-modeset-hang-oldfb)
[473.491162] Starting subtest: extended-modeset-hang-oldfb
[473.510773] Starting dynamic subtest: pipe-A
[478.263791] Dynamic subtest pipe-A: SUCCESS (4.753s)
[478.325335] Starting dynamic subtest: pipe-C
[483.296648] Dynamic subtest pipe-C: SUCCESS (5.039s)
[483.319134] Subtest extended-modeset-hang-oldfb: SUCCESS (9.807s)
[483.768843] [096/130] (529s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[484.194475] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[484.237891] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[484.346183] [097/130] (528s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[484.740805] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[484.781881] Subtest psr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[484.895210] [098/130] (528s left) kms_psr (fbc-pr-primary-blt)
[485.252857] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[485.360369] [099/130] (528s left) kms_addfb_basic (basic)
[485.622052] Starting subtest: basic
[485.642969] Subtest basic: SUCCESS (0.000s)
[485.852836] [100/130] (527s left) i915_pm_rpm (sysfs-read)
[488.812257] Starting subtest: sysfs-read
[489.204815] Subtest sysfs-read: SUCCESS (0.348s)
[489.788247] [101/130] (523s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[490.182336] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s)
[490.315300] [102/130] (523s left) kms_plane_lowres (tiling-y)
[490.676761] Starting subtest: tiling-y
[490.698931] Starting dynamic subtest: pipe-A-DP-1
[497.479314] Dynamic subtest pipe-A-DP-1: SUCCESS (6.811s)
[497.624356] Starting dynamic subtest: pipe-B-DP-1
[504.303606] Dynamic subtest pipe-B-DP-1: SUCCESS (6.729s)
[504.486933] Starting dynamic subtest: pipe-C-DP-1
[509.067089] Dynamic subtest pipe-C-DP-1: SUCCESS (4.624s)
[509.184144] Subtest tiling-y: SUCCESS (18.493s)
[509.679272] [103/130] (504s left) vgem_basic (dmabuf-export)
[509.947178] Starting subtest: dmabuf-export
[509.992697] Subtest dmabuf-export: SUCCESS (0.015s)
[510.101276] [104/130] (503s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[510.441355] Starting subtest: plane-all-modeset-transition-internal-panels
[510.480997] Subtest plane-all-modeset-transition-internal-panels: SKIP (0.000s)
[510.588980] [105/130] (503s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[510.862602] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[510.917176] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[511.050198] [106/130] (503s left) api_intel_allocator (alloc-simple)
[511.301790] Starting subtest: alloc-simple
[511.321431] Subtest alloc-simple: SUCCESS (0.013s)
[511.431231] [107/130] (502s left) gem_exec_whisper (basic-queues-all)
[511.741680] Starting subtest: basic-queues-all
[520.150417] Subtest basic-queues-all: SUCCESS (8.435s)
[520.370609] [108/130] (494s left) kms_chamelium_frames (hdmi-crc-single)
[520.873781] Subtest hdmi-crc-single: SKIP (0.000s)
[521.225785] [109/130] (493s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[521.609892] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.000s)
[521.722541] [110/130] (492s left) gem_mmap_gtt (flink-race)
[521.996347] Starting subtest: flink-race
[542.257513] Subtest flink-race: SUCCESS (20.144s)
[542.371490] [111/130] (472s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[542.762821] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[542.846183] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.003s)
[542.958753] [112/130] (471s left) gem_mmap_offset (oob-read)
[543.230140] Starting subtest: oob-read
[543.250187] Subtest oob-read: SUCCESS (0.002s)
[543.362978] [113/130] (471s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[543.782585] Starting subtest: fbcpsr-stridechange
[543.825329] Subtest fbcpsr-stridechange: SKIP (0.000s)
[543.935954] [114/130] (471s left) syncobj_basic (bad-flags-handle-to-fd)
[544.191876] Starting subtest: bad-flags-handle-to-fd
[544.213673] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[544.323428] [115/130] (470s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[544.678369] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[544.701739] Starting dynamic subtest: pipe-A
[545.112511] Dynamic subtest pipe-A: SUCCESS (0.376s)
[545.187198] Starting dynamic subtest: pipe-B
[545.512606] Dynamic subtest pipe-B: SUCCESS (0.440s)
[545.585230] Starting dynamic subtest: pipe-C
[545.633160] Dynamic subtest pipe-C: SUCCESS (0.010s)
[545.656945] Subtest planes-downscale-factor-0-5-upscale-20x20: SUCCESS (0.837s)
[546.027737] [116/130] (469s left) gem_exec_balancer (bonded-dual)
[546.299330] Starting subtest: bonded-dual
[551.677546] Subtest bonded-dual: SUCCESS (5.225s)
[557.100615] [117/130] (458s left) kms_pipe_crc_basic (nonblocking-crc)
[557.453044] Starting subtest: nonblocking-crc
[557.475076] Starting dynamic subtest: pipe-A-DP-1
[558.064635] Dynamic subtest pipe-A-DP-1: SUCCESS (0.605s)
[558.118626] Starting dynamic subtest: pipe-B-DP-1
[558.878828] Dynamic subtest pipe-B-DP-1: SUCCESS (0.824s)
[558.934282] Starting dynamic subtest: pipe-C-DP-1
[559.711765] Dynamic subtest pipe-C-DP-1: SUCCESS (0.816s)
[559.734035] Subtest nonblocking-crc: SUCCESS (2.263s)
[560.116300] [118/130] (455s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[560.516919] Starting subtest: yf-tiled-64bpp-rotate-180
[560.556278] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[560.671244] [119/130] (455s left) gem_mmap_gtt (basic-wc)
[560.910366] Starting subtest: basic-wc
[561.509263] Subtest basic-wc: SUCCESS (0.631s)
[561.665469] [120/130] (454s left) kms_display_modes (mst-extended-mode-negative)
[562.035266] Starting subtest: mst-extended-mode-negative
[562.078388] Subtest mst-extended-mode-negative: SKIP (0.000s)
[562.194894] [121/130] (453s left) i915_pm_freq_api (freq-basic-api)
[562.485955] Subtest freq-basic-api: SKIP (0.000s)
[562.598201] [122/130] (453s left) gem_fence_thrash (bo-write-verify-threaded-none)
[562.844663] Starting subtest: bo-write-verify-threaded-none
[568.189513] Subtest bo-write-verify-threaded-none: SUCCESS (5.210s)
[568.303666] [123/130] (447s left) gem_exec_fence (syncobj-unused-fence)
[569.036924] Starting subtest: syncobj-unused-fence
[569.057946] Subtest syncobj-unused-fence: SUCCESS (0.007s)
[569.468751] [124/130] (446s left) sysfs_preempt_timeout (invalid)
[569.729672] Starting subtest: invalid
[569.760413] Starting dynamic subtest: vecs0
[569.782614] Dynamic subtest vecs0: SUCCESS (0.001s)
[569.837461] Starting dynamic subtest: vcs0
[569.859601] Dynamic subtest vcs0: SUCCESS (0.001s)
[569.950051] Starting dynamic subtest: bcs0
[569.973387] Dynamic subtest bcs0: SUCCESS (0.001s)
[570.068106] Starting dynamic subtest: rcs0
[570.091987] Dynamic subtest rcs0: SUCCESS (0.001s)
[570.119687] Subtest invalid: SUCCESS (0.023s)
[570.274283] [125/130] (446s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[570.531393] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[570.555968] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.002s)
[570.710438] [126/130] (445s left) perf_pmu (event-wait)
[570.965046] Starting subtest: event-wait
[570.984608] Starting dynamic subtest: rcs0
[571.027533] Dynamic subtest rcs0: SKIP (0.000s)
[571.069548] Subtest event-wait: SKIP (0.004s)
[571.201749] [127/130] (445s left) gem_ctx_isolation (clean)
[571.449504] Starting subtest: clean
[571.470652] Starting dynamic subtest: rcs0
[571.677827] Dynamic subtest rcs0: SUCCESS (0.247s)
[571.733648] Starting dynamic subtest: bcs0
[572.029503] Dynamic subtest bcs0: SUCCESS (0.347s)
[572.082168] Starting dynamic subtest: vcs0
[572.298754] Dynamic subtest vcs0: SUCCESS (0.262s)
[572.363519] Starting dynamic subtest: vecs0
[572.596161] Dynamic subtest vecs0: SUCCESS (0.282s)
[572.617621] Subtest clean: SUCCESS (1.153s)
[572.838257] [128/130] (444s left) prime_vgem (wait)
[573.127047] Starting subtest: wait
[573.149443] Starting dynamic subtest: rcs0
[573.170944] Dynamic subtest rcs0: SUCCESS (0.016s)
[573.230524] Starting dynamic subtest: vcs0
[573.250134] Dynamic subtest vcs0: SUCCESS (0.020s)
[573.337402] Starting dynamic subtest: vecs0
[573.358817] Dynamic subtest vecs0: SUCCESS (0.020s)
[573.378488] Subtest wait: SUCCESS (0.067s)
[573.508625] [129/130] (443s left) gem_ppgtt (shrink-vs-evict-any)
[573.770705] Starting subtest: shrink-vs-evict-any
[579.052899] Subtest shrink-vs-evict-any: SUCCESS (5.100s)
[579.165461] [130/130] (437s left) gem_softpin (overlap)
[579.433162] Starting subtest: overlap
[582.625099] Subtest overlap: SUCCESS (3.054s)
[582.710425] Closing watchdogs
Done.