[51.508260] Initializing watchdogs
[51.508475]   /dev/watchdog0
[51.524400] [001/138] (960s left) kms_ccs (pipe-d-bad-pixel-format-y-tiled-gen12-mc-ccs)
[52.053714] Subtest pipe-D-bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[52.410431] [002/138] (959s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[52.727820] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[52.731837] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[52.828971] [003/138] (959s left) gem_spin_batch (legacy)
[53.028607] Starting subtest: legacy
[53.034166] Starting dynamic subtest: default
[56.371790] Dynamic subtest default: SUCCESS (3.335s)
[56.386403] Starting dynamic subtest: render
[59.693547] Dynamic subtest render: SUCCESS (3.324s)
[59.707653] Starting dynamic subtest: bsd
[62.927786] Dynamic subtest bsd: SUCCESS (3.232s)
[62.940499] Starting dynamic subtest: bsd1
[66.245856] Dynamic subtest bsd1: SUCCESS (3.320s)
[66.259299] Starting dynamic subtest: blt
[69.572940] Dynamic subtest blt: SUCCESS (3.324s)
[69.585462] Starting dynamic subtest: vebox
[72.893627] Dynamic subtest vebox: SUCCESS (3.320s)
[72.894957] Subtest legacy: SUCCESS (19.864s)
[73.089915] [004/138] (939s left) api_intel_bb (add-remove-objects)
[73.237556] Starting subtest: add-remove-objects
[73.257311] Subtest add-remove-objects: SUCCESS (0.019s)
[73.354306] [005/138] (938s left) gem_ccs (ctrl-surf-copy-new-ctx)
[73.503511] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[73.553983] [006/138] (938s left) kms_flip (dpms-vs-vblank-race-interruptible)
[73.783778] Starting subtest: dpms-vs-vblank-race-interruptible
[73.787642] Starting dynamic subtest: A-DP1
[78.322646] Dynamic subtest A-DP1: SUCCESS (4.533s)
[78.335967] Starting dynamic subtest: B-DP1
[82.529868] Dynamic subtest B-DP1: SUCCESS (4.207s)
[82.545255] Starting dynamic subtest: C-DP1
[86.704124] Dynamic subtest C-DP1: SUCCESS (4.167s)
[86.705431] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (12.916s)
[87.072885] [007/138] (925s left) gem_mmap_wc (copy)
[87.228669] Starting subtest: copy
[87.587810] Subtest copy: SUCCESS (0.359s)
[87.669964] [008/138] (924s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[87.941943] Starting subtest: yf-tiled-addfb-size-overflow
[87.943643] Subtest yf-tiled-addfb-size-overflow: SUCCESS (0.002s)
[88.038822] [009/138] (924s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[88.191123] Starting subtest: no-spare-fences-busy
[90.368969] Subtest no-spare-fences-busy: SUCCESS (2.176s)
[90.671345] [010/138] (921s left) kms_ccs (pipe-b-random-ccs-data-4-tiled-dg2-rc-ccs)
[91.069059] Starting subtest: pipe-B-random-ccs-data-4-tiled-dg2-rc-ccs
[91.073200] Subtest pipe-B-random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[91.460634] [011/138] (920s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[91.709914] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[91.712536] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[91.807728] [012/138] (920s left) kms_cursor_edge_walk (128x128-left-edge)
[92.049125] Starting subtest: 128x128-left-edge
[92.050421] Starting dynamic subtest: pipe-A-DP-1
[95.685418] Dynamic subtest pipe-A-DP-1: SUCCESS (3.635s)
[95.700686] Starting dynamic subtest: pipe-C-DP-1
[99.163225] Dynamic subtest pipe-C-DP-1: SUCCESS (3.475s)
[99.164831] Subtest 128x128-left-edge: SUCCESS (7.116s)
[99.484932] [013/138] (912s left) gem_mmap_gtt (fault-concurrent-y)
[99.631432] Starting subtest: fault-concurrent-Y
[103.116930] Subtest fault-concurrent-Y: SUCCESS (3.484s)
[103.297835] [014/138] (909s left) gem_exec_balancer (parallel-keep-submit-fence)
[107.311703] Subtest parallel-keep-submit-fence: SKIP (0.000s)
[107.399485] [015/138] (905s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[107.651553] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[107.654271] Subtest psr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[107.749129] [016/138] (904s left) gem_ctx_param (set-priority-not-supported)
[107.893172] Starting subtest: set-priority-not-supported
[107.896227] Subtest set-priority-not-supported: SKIP (0.000s)
[107.963463] [017/138] (904s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[108.215710] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[108.218479] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[108.313703] [018/138] (904s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[108.458230] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[108.567350] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.109s)
[108.651865] [019/138] (903s left) kms_ccs (pipe-b-bad-pixel-format-y-tiled-ccs)
[109.026353] Starting subtest: pipe-B-bad-pixel-format-y-tiled-ccs
[109.027668] Subtest pipe-B-bad-pixel-format-y-tiled-ccs: SUCCESS (0.001s)
[109.447370] [020/138] (903s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[109.682783] Starting subtest: plane-downscale-factor-0-5-with-rotation
[109.684182] Starting dynamic subtest: pipe-A-DP-1
[110.022603] Dynamic subtest pipe-A-DP-1: SKIP (0.334s)
[110.036657] Starting dynamic subtest: pipe-B-DP-1
[110.411340] Dynamic subtest pipe-B-DP-1: SKIP (0.387s)
[110.425987] Starting dynamic subtest: pipe-C-DP-1
[110.801537] Dynamic subtest pipe-C-DP-1: SKIP (0.388s)
[110.804498] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (1.120s)
[111.183941] [021/138] (901s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[111.431333] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[111.434084] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[111.534519] [022/138] (901s left) gem_render_copy (linear-to-vebox-y-tiled)
[111.693388] Starting subtest: linear-to-vebox-y-tiled
[111.696025] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[111.883893] [023/138] (900s left) gem_exec_schedule (preempt-queue)
[112.063278] Starting subtest: preempt-queue
[112.064816] Starting dynamic subtest: rcs0
[112.477170] Dynamic subtest rcs0: SUCCESS (0.413s)
[112.494980] Starting dynamic subtest: bcs0
[112.894244] Dynamic subtest bcs0: SUCCESS (0.413s)
[112.912047] Starting dynamic subtest: vcs0
[113.288541] Dynamic subtest vcs0: SUCCESS (0.395s)
[113.307313] Starting dynamic subtest: vecs0
[113.683989] Dynamic subtest vecs0: SUCCESS (0.394s)
[113.685706] Subtest preempt-queue: SUCCESS (1.620s)
[114.034703] [024/138] (898s left) gem_exec_params (rsvd2-dirt)
[114.182795] Starting subtest: rsvd2-dirt
[114.185403] Subtest rsvd2-dirt: SKIP (0.000s)
[114.285159] [025/138] (898s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[114.519682] Starting subtest: plane-upscale-factor-0-25-with-rotation
[114.520968] Starting dynamic subtest: pipe-A-DP-1
[114.588701] Dynamic subtest pipe-A-DP-1: SKIP (0.065s)
[114.603413] Starting dynamic subtest: pipe-B-DP-1
[114.933855] Dynamic subtest pipe-B-DP-1: SKIP (0.342s)
[114.948601] Starting dynamic subtest: pipe-C-DP-1
[115.298849] Dynamic subtest pipe-C-DP-1: SKIP (0.360s)
[115.301381] Subtest plane-upscale-factor-0-25-with-rotation: SKIP (0.777s)
[115.699117] [026/138] (897s left) prime_mmap (test_dup)
[115.844721] Starting subtest: test_dup
[115.846167] Starting dynamic subtest: test_dup-smem
[115.851932] Dynamic subtest test_dup-smem: SUCCESS (0.008s)
[115.853513] Subtest test_dup: SUCCESS (0.009s)
[115.965070] [027/138] (896s left) gem_ctx_shared (q-in-order)
[116.131142] Starting subtest: Q-in-order
[116.134258] Starting dynamic subtest: rcs0
[116.320231] Dynamic subtest rcs0: SUCCESS (0.185s)
[116.336302] Starting dynamic subtest: bcs0
[116.436243] Dynamic subtest bcs0: SUCCESS (0.112s)
[116.452437] Starting dynamic subtest: vcs0
[116.523998] Dynamic subtest vcs0: SUCCESS (0.089s)
[116.541500] Starting dynamic subtest: vecs0
[116.619808] Dynamic subtest vecs0: SUCCESS (0.093s)
[116.622296] Subtest Q-in-order: SUCCESS (0.489s)
[116.848446] [028/138] (896s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[117.217307] Starting subtest: pipe-A-crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[117.223593] Subtest pipe-A-crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.005s)
[117.648354] [029/138] (895s left) gem_exec_parallel (basic)
[117.812911] Starting subtest: basic
[117.814451] Starting dynamic subtest: rcs0
[121.013461] Dynamic subtest rcs0: SUCCESS (3.199s)
[121.028565] Starting dynamic subtest: bcs0
[124.343782] Dynamic subtest bcs0: SUCCESS (3.330s)
[124.359631] Starting dynamic subtest: vcs0
[127.495679] Dynamic subtest vcs0: SUCCESS (3.150s)
[127.511744] Starting dynamic subtest: vecs0
[130.704492] Dynamic subtest vecs0: SUCCESS (3.207s)
[130.705947] Subtest basic: SUCCESS (12.892s)
[130.899315] [030/138] (882s left) kms_chamelium_audio (dp-audio)
[131.228865] Subtest dp-audio: SKIP (0.000s)
[131.529622] [031/138] (881s left) gem_exercise_blt (fast-copy)
[131.678447] Starting subtest: fast-copy
[131.679854] Starting dynamic subtest: linear-smem-smem
[131.737457] Dynamic subtest linear-smem-smem: SUCCESS (0.060s)
[131.752752] Starting dynamic subtest: ymajor-smem-smem
[131.793164] Dynamic subtest ymajor-smem-smem: SUCCESS (0.052s)
[131.808256] Starting dynamic subtest: yfmajor-smem-smem
[131.842382] Dynamic subtest yfmajor-smem-smem: SUCCESS (0.051s)
[131.857460] Starting dynamic subtest: tile64-smem-smem
[131.893439] Dynamic subtest tile64-smem-smem: SUCCESS (0.050s)
[131.895229] Subtest fast-copy: SUCCESS (0.217s)
[131.990212] [032/138] (881s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[132.238644] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[132.241259] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[132.339870] [033/138] (880s left) kms_ccs (pipe-a-ccs-on-another-bo-yf-tiled-ccs)
[132.717183] Starting subtest: pipe-A-ccs-on-another-bo-yf-tiled-ccs
[132.718685] Subtest pipe-A-ccs-on-another-bo-yf-tiled-ccs: SUCCESS (0.001s)
[133.150688] [034/138] (880s left) gem_ctx_persistence (engines-mixed)
[133.304275] Starting subtest: engines-mixed
[133.305924] Starting dynamic subtest: rcs0
[133.369055] Dynamic subtest rcs0: SUCCESS (0.063s)
[133.385619] Starting dynamic subtest: bcs0
[133.420809] Dynamic subtest bcs0: SUCCESS (0.051s)
[133.437298] Starting dynamic subtest: vcs0
[133.476172] Dynamic subtest vcs0: SUCCESS (0.051s)
[133.492060] Starting dynamic subtest: vecs0
[133.525373] Dynamic subtest vecs0: SUCCESS (0.050s)
[133.526935] Subtest engines-mixed: SUCCESS (0.222s)
[133.617355] [035/138] (879s left) core_getversion
[133.833291] [036/138] (879s left) gem_flink_basic (flink-lifetime)
[133.975155] Starting subtest: flink-lifetime
[133.978935] Subtest flink-lifetime: SUCCESS (0.003s)
[134.083440] [037/138] (879s left) v3d/v3d_wait_bo (used-bo-1ns)
[134.283195] Subtest used-bo-1ns: SKIP (0.000s)
[134.349158] [038/138] (878s left) prime_mmap (test_errors)
[134.486868] Starting subtest: test_errors
[134.488261] Starting dynamic subtest: test_errors-smem
[134.503384] Dynamic subtest test_errors-smem: SUCCESS (0.017s)
[134.504791] Subtest test_errors: SUCCESS (0.019s)
[134.600226] [039/138] (878s left) kms_invalid_mode (bad-vtotal)
[134.848484] Starting subtest: bad-vtotal
[134.850583] Starting dynamic subtest: pipe-A-DP-1
[134.944268] Dynamic subtest pipe-A-DP-1: SUCCESS (0.096s)
[134.962066] Starting dynamic subtest: pipe-B-DP-1
[134.963297] Dynamic subtest pipe-B-DP-1: SUCCESS (0.002s)
[134.980284] Starting dynamic subtest: pipe-C-DP-1
[134.983090] Dynamic subtest pipe-C-DP-1: SUCCESS (0.002s)
[134.985947] Subtest bad-vtotal: SUCCESS (0.108s)
[135.262298] [040/138] (878s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[135.505174] Starting subtest: short-flip-before-cursor-toggle
[136.575467] Subtest short-flip-before-cursor-toggle: SUCCESS (1.069s)
[136.885862] [041/138] (876s left) perf (invalid-oa-format-id)
[137.166488] Starting subtest: invalid-oa-format-id
[137.224263] Subtest invalid-oa-format-id: SUCCESS (0.059s)
[137.268156] [042/138] (876s left) gem_exec_fence (submit3)
[137.576477] Starting subtest: submit3
[137.577892] Starting dynamic subtest: rcs0
[137.589245] Dynamic subtest rcs0: SUCCESS (0.014s)
[137.607421] Starting dynamic subtest: bcs0
[137.608833] Dynamic subtest bcs0: SUCCESS (0.013s)
[137.626317] Starting dynamic subtest: vcs0
[137.627643] Dynamic subtest vcs0: SUCCESS (0.013s)
[137.643711] Starting dynamic subtest: vecs0
[137.645071] Dynamic subtest vecs0: SUCCESS (0.011s)
[137.646339] Subtest submit3: SUCCESS (0.059s)
[138.302489] [043/138] (875s left) syncobj_timeline (wait-all-complex)
[138.444778] Starting subtest: wait-all-complex
[138.663853] Subtest wait-all-complex: SUCCESS (0.217s)
[138.754141] [044/138] (874s left) kms_plane_alpha_blend (alpha-basic)
[138.997514] Starting subtest: alpha-basic
[139.323355] Starting dynamic subtest: pipe-A-DP-1
[140.083059] Dynamic subtest pipe-A-DP-1: FAIL (0.199s)
[140.098679] Starting dynamic subtest: pipe-C-DP-1
[140.708337] Dynamic subtest pipe-C-DP-1: FAIL (0.720s)
[140.709828] Subtest alpha-basic: FAIL (1.345s)
[140.776454] [045/138] (872s left) dmabuf_sync_file (export-before-signal)
[140.922650] Starting subtest: export-before-signal
[140.924397] Subtest export-before-signal: SUCCESS (0.003s)
[140.991682] [046/138] (872s left) kms_psr (suspend)
[141.135312] Subtest suspend: SKIP (0.000s)
[141.191530] [047/138] (872s left) kms_atomic (plane-invalid-params)
[141.426908] Starting subtest: plane-invalid-params
[141.428224] Starting dynamic subtest: pipe-A-DP-1
[141.784344] Dynamic subtest pipe-A-DP-1: SUCCESS (0.356s)
[141.785786] Subtest plane-invalid-params: SUCCESS (0.360s)
[142.124336] [048/138] (871s left) kms_rotation_crc (multiplane-rotation)
[142.363312] Starting subtest: multiplane-rotation
[156.438257] Subtest multiplane-rotation: SUCCESS (14.076s)
[156.556160] [049/138] (857s left) kms_addfb_basic (small-bo)
[156.798505] Starting subtest: small-bo
[156.800227] Subtest small-bo: SUCCESS (0.000s)
[156.888633] [050/138] (856s left) gem_exec_params (invalid-ring2)
[157.038930] Starting subtest: invalid-ring2
[157.040793] Subtest invalid-ring2: SUCCESS (0.001s)
[157.138384] [051/138] (856s left) gem_mmap_wc (write-cpu-read-wc)
[157.282021] Starting subtest: write-cpu-read-wc
[157.569645] Subtest write-cpu-read-wc: SUCCESS (0.289s)
[157.654714] [052/138] (856s left) perf_pmu (frequency)
[157.805217] Starting subtest: frequency
[157.806790] Starting dynamic subtest: gt0
[159.912412] Dynamic subtest gt0: SUCCESS (2.103s)
[159.929269] Starting dynamic subtest: idle-gt0
[160.420096] Dynamic subtest idle-gt0: SUCCESS (0.505s)
[160.421488] Subtest frequency: SUCCESS (2.614s)
[160.505821] [053/138] (853s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[160.744740] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[160.746076] Starting dynamic subtest: pipe-A-valid-mode
[160.834255] Dynamic subtest pipe-A-valid-mode: SKIP (0.088s)
[160.836964] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.092s)
[161.137401] [054/138] (852s left) gem_fence_thrash (bo-write-verify-threaded-x)
[161.275653] Starting subtest: bo-write-verify-threaded-x
[163.354437] Subtest bo-write-verify-threaded-x: SUCCESS (2.077s)
[163.456217] [055/138] (850s left) v3d/v3d_submit_cl (valid-submission)
[163.655271] Subtest valid-submission: SKIP (0.000s)
[163.721517] [056/138] (850s left) gem_pread (self)
[163.865947] Starting subtest: self
[163.924195] Subtest self: SUCCESS (0.059s)
[164.020684] [057/138] (850s left) kms_flip (flip-vs-fences-interruptible)
[164.255643] Starting subtest: flip-vs-fences-interruptible
[164.259408] Starting dynamic subtest: A-DP1
[175.072529] Dynamic subtest A-DP1: SUCCESS (10.812s)
[175.092367] Starting dynamic subtest: B-DP1
[185.770661] Dynamic subtest B-DP1: SUCCESS (10.693s)
[185.790161] Starting dynamic subtest: C-DP1
[196.547779] Dynamic subtest C-DP1: SUCCESS (10.772s)
[196.551291] Subtest flip-vs-fences-interruptible: SUCCESS (32.290s)
[197.053307] [058/138] (817s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[197.310125] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[199.381930] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.073s)
[199.518992] [059/138] (814s left) gem_reg_read (timestamp-monotonic)
[199.660901] Starting subtest: timestamp-monotonic
[204.071771] Subtest timestamp-monotonic: SUCCESS (4.410s)
[204.151398] [060/138] (809s left) gem_ctx_param (invalid-param-set)
[204.294686] Starting subtest: invalid-param-set
[204.296244] Subtest invalid-param-set: SUCCESS (0.000s)
[204.386154] [061/138] (809s left) kms_getfb (getfb-handle-protection)
[204.531939] Starting subtest: getfb-handle-protection
[204.566106] Subtest getfb-handle-protection: SUCCESS (0.034s)
[204.669462] [062/138] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[204.915489] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[204.918370] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[205.002037] [063/138] (809s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[205.262637] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[206.547293] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (1.286s)
[206.803188] [064/138] (807s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[207.043423] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[207.050952] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.004s)
[207.151669] [065/138] (807s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[207.407215] Starting subtest: x-tiled-64bpp-rotate-270
[207.490736] Subtest x-tiled-64bpp-rotate-270: SKIP (0.081s)
[207.602776] [066/138] (806s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[207.861037] Starting subtest: 4-tiled-8bpp-rotate-270
[207.863942] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.000s)
[207.951925] [067/138] (806s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[208.221606] Starting subtest: yf-tiled-16bpp-rotate-270
[208.307348] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.086s)
[208.419251] [068/138] (806s left) kms_ccs (pipe-d-crc-primary-basic-y-tiled-gen12-mc-ccs)
[208.910449] Subtest pipe-D-crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[209.225731] [069/138] (805s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[209.480221] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[209.483171] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[209.575421] [070/138] (804s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[209.718281] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[209.722367] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.002s)
[209.810748] [071/138] (804s left) kms_atomic_transition (plane-all-transition-nonblocking)
[210.052729] Starting subtest: plane-all-transition-nonblocking
[210.056769] Starting dynamic subtest: pipe-A-DP-1
[214.037916] Dynamic subtest pipe-A-DP-1: SUCCESS (3.983s)
[214.169115] Starting dynamic subtest: pipe-B-DP-1
[218.463763] Dynamic subtest pipe-B-DP-1: SUCCESS (4.327s)
[218.564147] Subtest plane-all-transition-nonblocking: SUCCESS (8.510s)
[218.909183] [072/138] (795s left) gem_ctx_create (basic-files)
[219.084724] Starting subtest: basic-files
[221.121302] Subtest basic-files: SUCCESS (2.036s)
[221.342979] [073/138] (793s left) syncobj_timeline (single-wait-available-submitted)
[221.486881] Starting subtest: single-wait-available-submitted
[221.488895] Subtest single-wait-available-submitted: SUCCESS (0.001s)
[221.577298] [074/138] (793s left) syncobj_timeline (invalid-query-one-illegal-handle)
[221.721244] Starting subtest: invalid-query-one-illegal-handle
[221.722784] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[221.808866] [075/138] (792s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[222.044596] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[222.045948] Starting dynamic subtest: pipe-A-valid-mode
[222.516296] Dynamic subtest pipe-A-valid-mode: SKIP (0.467s)
[222.519136] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.472s)
[222.902836] [076/138] (791s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[223.143713] Starting subtest: flip-vs-cursor-crc-atomic
[223.758791] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.615s)
[224.101817] [077/138] (790s left) api_intel_bb (reset-flags)
[224.245178] Starting subtest: reset-flags
[224.266992] Subtest reset-flags: SUCCESS (0.022s)
[224.402098] [078/138] (790s left) gem_exec_schedule (implicit-boths)
[224.574268] Starting subtest: implicit-boths
[224.575613] Starting dynamic subtest: rcs0
[224.726624] Dynamic subtest rcs0: SUCCESS (0.147s)
[224.747965] Starting dynamic subtest: bcs0
[224.867869] Dynamic subtest bcs0: SUCCESS (0.142s)
[224.893414] Starting dynamic subtest: vcs0
[225.001444] Dynamic subtest vcs0: SUCCESS (0.130s)
[225.024953] Starting dynamic subtest: vecs0
[225.136918] Dynamic subtest vecs0: SUCCESS (0.132s)
[225.138805] Subtest implicit-boths: SUCCESS (0.566s)
[225.500448] [079/138] (789s left) kms_ccs (pipe-c-random-ccs-data-yf-tiled-ccs)
[225.944849] Starting subtest: pipe-C-random-ccs-data-yf-tiled-ccs
[225.948614] Subtest pipe-C-random-ccs-data-yf-tiled-ccs: SKIP (0.000s)
[226.297693] [080/138] (788s left) v3d/v3d_submit_cl (multisync-out-syncs)
[226.495622] Subtest multisync-out-syncs: SKIP (0.000s)
[226.564912] [081/138] (788s left) kms_pm_rpm (universal-planes)
[228.302647] Starting subtest: universal-planes
[228.305492] Starting dynamic subtest: plane-31
[230.289455] Dynamic subtest plane-31: SUCCESS (1.984s)
[230.321988] Starting dynamic subtest: plane-39
[232.599372] Dynamic subtest plane-39: SUCCESS (2.306s)
[232.619086] Starting dynamic subtest: plane-47
[234.608064] Dynamic subtest plane-47: SUCCESS (2.005s)
[234.631795] Starting dynamic subtest: plane-55
[236.435981] Dynamic subtest plane-55: SUCCESS (1.824s)
[236.438659] Subtest universal-planes: SUCCESS (8.137s)
[236.942984] [082/138] (778s left) kms_ccs (pipe-d-crc-sprite-planes-basic-yf-tiled-ccs)
[237.422611] Subtest pipe-D-crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.000s)
[237.744451] [083/138] (777s left) kms_ccs (pipe-a-bad-rotation-90-y-tiled-ccs)
[238.086244] Starting subtest: pipe-A-bad-rotation-90-y-tiled-ccs
[238.557874] Subtest pipe-A-bad-rotation-90-y-tiled-ccs: SUCCESS (0.464s)
[239.109108] [084/138] (775s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[239.357837] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[239.360436] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[239.439359] [085/138] (775s left) gem_barrier_race (remote-request)
[239.605640] Starting subtest: remote-request
[239.607040] Starting dynamic subtest: rcs0
[244.741963] Dynamic subtest rcs0: SUCCESS (5.136s)
[244.743566] Subtest remote-request: SUCCESS (5.139s)
[244.845953] [086/138] (770s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[245.302350] Starting subtest: pipe-C-crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[245.308212] Subtest pipe-C-crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[245.633354] [087/138] (769s left) v3d/v3d_mmap (mmap-bad-handle)
[245.829367] Subtest mmap-bad-handle: SKIP (0.000s)
[245.898943] [088/138] (769s left) gem_exec_fence (expired-history)
[246.492879] Starting subtest: expired-history
[252.322759] Subtest expired-history: SUCCESS (5.827s)
[252.884649] [089/138] (762s left) gen9_exec_parse (allowed-all)
[253.052933] Starting subtest: allowed-all
[253.059309] Subtest allowed-all: SUCCESS (0.003s)
[253.286071] [090/138] (762s left) syncobj_timeline (32bits-limit)
[253.428477] Starting subtest: 32bits-limit
[253.433141] Subtest 32bits-limit: SUCCESS (0.003s)
[253.515793] [091/138] (761s left) i915_hangman (engine-error-state-capture)
[253.683643] Starting subtest: engine-error-state-capture
[253.685250] Starting dynamic subtest: rcs0
[257.737264] Dynamic subtest rcs0: SUCCESS (4.052s)
[257.758840] Starting dynamic subtest: bcs0
[261.767730] Dynamic subtest bcs0: SUCCESS (4.027s)
[261.789223] Starting dynamic subtest: vcs0
[265.727747] Dynamic subtest vcs0: SUCCESS (3.956s)
[265.749456] Starting dynamic subtest: vecs0
[269.760299] Dynamic subtest vecs0: SUCCESS (4.028s)
[269.762325] Subtest engine-error-state-capture: SUCCESS (16.078s)
[269.884271] [092/138] (745s left) i915_pm_rps (basic-api)
[270.034068] Starting subtest: basic-api
[270.039809] Subtest basic-api: SUCCESS (0.007s)
[270.150196] [093/138] (745s left) kms_big_fb (linear-64bpp-rotate-270)
[270.410113] Starting subtest: linear-64bpp-rotate-270
[270.488198] Subtest linear-64bpp-rotate-270: SKIP (0.076s)
[270.600113] [094/138] (744s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[270.850696] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[270.853497] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[270.949844] [095/138] (744s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[271.194240] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[271.197297] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[271.299258] [096/138] (744s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[271.457197] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[271.459810] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[271.666942] [097/138] (743s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[271.909834] Starting subtest: coverage-vs-premult-vs-constant
[272.236102] Starting dynamic subtest: pipe-A-DP-1
[272.655575] Dynamic subtest pipe-A-DP-1: SUCCESS (0.419s)
[272.676375] Starting dynamic subtest: pipe-C-DP-1
[273.316829] Dynamic subtest pipe-C-DP-1: SUCCESS (0.657s)
[273.319337] Subtest coverage-vs-premult-vs-constant: SUCCESS (1.409s)
[273.713498] [098/138] (741s left) perf (gen12-group-exclusive-stream-sample-oa)
[273.954495] Starting subtest: gen12-group-exclusive-stream-sample-oa
[273.957188] Subtest gen12-group-exclusive-stream-sample-oa: SKIP (0.000s)
[274.012204] [099/138] (741s left) kms_psr (dpms)
[274.153712] Subtest dpms: SKIP (0.000s)
[274.215067] [100/138] (741s left) kms_ccs (pipe-c-bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[274.655863] Starting subtest: pipe-C-bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[274.658374] Subtest pipe-C-bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[275.004699] [101/138] (740s left) gem_ctx_engines (invalid-engines)
[275.174886] Starting subtest: invalid-engines
[275.189801] Subtest invalid-engines: SUCCESS (0.015s)
[275.391446] [102/138] (740s left) kms_ccs (pipe-c-bad-pixel-format-y-tiled-gen12-rc-ccs)
[275.805657] Starting subtest: pipe-C-bad-pixel-format-y-tiled-gen12-rc-ccs
[275.808429] Subtest pipe-C-bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[276.165252] [103/138] (739s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[276.415374] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[279.007364] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (2.594s)
[279.145916] [104/138] (736s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[279.404480] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[279.427464] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.021s)
[279.529438] [105/138] (736s left) kms_flip (2x-flip-vs-panning)
[279.751802] Starting subtest: 2x-flip-vs-panning
[279.754342] Subtest 2x-flip-vs-panning: SKIP (0.003s)
[279.863656] [106/138] (736s left) kms_chamelium_hpd (dp-hpd)
[280.207152] Subtest dp-hpd: SKIP (0.000s)
[280.497120] [107/138] (735s left) kms_ccs (pipe-b-bad-aux-stride-4-tiled-mtl-rc-ccs)
[280.919102] Starting subtest: pipe-B-bad-aux-stride-4-tiled-mtl-rc-ccs
[280.921844] Subtest pipe-B-bad-aux-stride-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[281.296249] [108/138] (734s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc)
[281.543957] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc
[281.546620] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[281.645492] [109/138] (734s left) gem_exec_balancer (bonded-false-hang)
[285.655466] Starting subtest: bonded-false-hang
[289.258778] Subtest bonded-false-hang: SUCCESS (3.602s)
[289.361743] [110/138] (726s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-gtt)
[289.607109] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-gtt
[291.456762] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-gtt: SUCCESS (1.852s)
[291.595264] [111/138] (724s left) kms_content_protection (content-type-change)
[291.878391] Starting subtest: content-type-change
[292.599986] Subtest content-type-change: SKIP (0.720s)
[293.028605] [112/138] (723s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[293.347281] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[293.396275] [113/138] (722s left) gem_exec_store (pages)
[293.559776] Starting subtest: pages
[293.561349] Starting dynamic subtest: rcs0
[293.658339] Dynamic subtest rcs0: SUCCESS (0.097s)
[293.679743] Starting dynamic subtest: bcs0
[293.754699] Dynamic subtest bcs0: SUCCESS (0.093s)
[293.778507] Starting dynamic subtest: vcs0
[293.846175] Dynamic subtest vcs0: SUCCESS (0.088s)
[293.867557] Starting dynamic subtest: vecs0
[293.949238] Dynamic subtest vecs0: SUCCESS (0.098s)
[293.950557] Subtest pages: SUCCESS (0.388s)
[294.146160] [114/138] (722s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[294.310164] Starting subtest: addfb25-x-tiled-mismatch-legacy
[294.311660] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[294.518821] [115/138] (721s left) kms_ccs (pipe-b-crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[294.920447] Starting subtest: pipe-B-crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[294.923302] Subtest pipe-B-crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.001s)
[295.328398] [116/138] (721s left) i915_pm_rc6_residency (media-rc6-accuracy)
[295.645480] Starting subtest: media-rc6-accuracy
[295.649238] Subtest media-rc6-accuracy: SKIP (0.000s)
[295.727859] [117/138] (720s left) syncobj_wait (multi-wait-all-signaled)
[295.872456] Starting subtest: multi-wait-all-signaled
[295.874033] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[295.961971] [118/138] (720s left) kms_draw_crc (draw-method-blt)
[296.205364] Starting subtest: draw-method-blt
[296.206667] Starting dynamic subtest: xrgb8888-untiled
[296.504830] Dynamic subtest xrgb8888-untiled: SUCCESS (0.300s)
[296.527369] Starting dynamic subtest: rgb565-untiled
[296.804769] Dynamic subtest rgb565-untiled: SUCCESS (0.298s)
[296.826919] Starting dynamic subtest: xrgb2101010-untiled
[297.104455] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.297s)
[297.126755] Starting dynamic subtest: xrgb8888-xtiled
[297.271644] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.164s)
[297.297498] Starting dynamic subtest: rgb565-xtiled
[297.437909] Dynamic subtest rgb565-xtiled: SUCCESS (0.163s)
[297.460416] Starting dynamic subtest: xrgb2101010-xtiled
[297.604794] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.164s)
[297.627171] Starting dynamic subtest: xrgb8888-ytiled
[297.788325] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.181s)
[297.810463] Starting dynamic subtest: rgb565-ytiled
[297.954757] Dynamic subtest rgb565-ytiled: SUCCESS (0.164s)
[297.976637] Starting dynamic subtest: xrgb2101010-ytiled
[298.137757] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.180s)
[298.139275] Subtest draw-method-blt: SUCCESS (1.936s)
[298.261174] [119/138] (718s left) kms_prop_blob (invalid-set-prop-any)
[298.407598] Starting subtest: invalid-set-prop-any
[298.409046] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[298.494649] [120/138] (718s left) prime_mmap (test_map_unmap)
[298.636180] Starting subtest: test_map_unmap
[298.637762] Starting dynamic subtest: test_map_unmap-smem
[298.643256] Dynamic subtest test_map_unmap-smem: SUCCESS (0.006s)
[298.645111] Subtest test_map_unmap: SUCCESS (0.009s)
[298.744567] [121/138] (717s left) kms_cursor_crc (cursor-random-512x170)
[299.003675] Starting subtest: cursor-random-512x170
[299.010082] Subtest cursor-random-512x170: SKIP (0.003s)
[299.116847] [122/138] (717s left) gem_exec_schedule (u-fairslice-all)
[299.290943] Starting subtest: u-fairslice-all
[301.405829] Subtest u-fairslice-all: SUCCESS (2.115s)
[301.763154] [123/138] (714s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[303.495272] Starting subtest: dpms-mode-unset-lpsp
[303.986812] Subtest dpms-mode-unset-lpsp: SKIP (0.488s)
[304.494166] [124/138] (712s left) kms_vblank (wait-busy-hang)
[304.732877] Starting subtest: wait-busy-hang
[304.734902] Starting dynamic subtest: pipe-A-DP-1
[311.986340] Dynamic subtest pipe-A-DP-1: SUCCESS (7.249s)
[312.016586] Starting dynamic subtest: pipe-C-DP-1
[319.031471] Dynamic subtest pipe-C-DP-1: SUCCESS (7.037s)
[319.032850] Subtest wait-busy-hang: SUCCESS (14.300s)
[319.380401] [125/138] (697s left) gem_eio (wait-wedge-immediate)
[319.557352] Starting subtest: wait-wedge-immediate
[319.630116] Subtest wait-wedge-immediate: SUCCESS (0.075s)
[319.831291] [126/138] (696s left) kms_chamelium_frames (dp-crc-multiple)
[320.175421] Subtest dp-crc-multiple: SKIP (0.000s)
[320.462349] [127/138] (696s left) perf_pmu (rc6-all-gts)
[320.608239] Starting subtest: rc6-all-gts
[320.611529] Subtest rc6-all-gts: SKIP (0.000s)
[320.708590] [128/138] (696s left) gem_partial_pwrite_pread (write-display)
[320.866182] Starting subtest: write-display
[334.905689] Subtest write-display: SUCCESS (14.042s)
[335.024780] [129/138] (681s left) gem_eio (wait-wedge-10ms)
[335.188450] Starting subtest: wait-wedge-10ms
[335.290523] Subtest wait-wedge-10ms: SUCCESS (0.102s)
[335.491328] [130/138] (681s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[335.747666] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[335.750558] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[335.838145] [131/138] (681s left) gem_mmap_offset (perf)
[335.981891] Starting subtest: perf
[335.983264] Starting dynamic subtest: smem0
[336.277914] Dynamic subtest smem0: SUCCESS (0.294s)
[336.279609] Subtest perf: SUCCESS (0.296s)
[336.388897] [132/138] (680s left) kms_flip_event_leak (basic)
[336.623880] Starting subtest: basic
[336.625179] Starting dynamic subtest: pipe-A-DP-1
[336.895394] Dynamic subtest pipe-A-DP-1: SUCCESS (0.271s)
[336.921998] Starting dynamic subtest: pipe-B-DP-1
[337.346568] Dynamic subtest pipe-B-DP-1: SUCCESS (0.445s)
[337.369253] Starting dynamic subtest: pipe-C-DP-1
[337.804353] Dynamic subtest pipe-C-DP-1: SUCCESS (0.455s)
[337.805724] Subtest basic: SUCCESS (1.184s)
[338.146573] [133/138] (678s left) vc4/vc4_wait_seqno (bad-seqno-0ns)
[338.356219] Subtest bad-seqno-0ns: SKIP (0.000s)
[338.428837] [134/138] (678s left) kms_flip (nonblocking-read)
[338.649842] Starting subtest: nonblocking-read
[338.651146] Subtest nonblocking-read: SUCCESS (0.000s)
[338.760658] [135/138] (678s left) sw_sync (sync_multi_consumer_producer)
[338.901828] Starting subtest: sync_multi_consumer_producer
[339.726547] Subtest sync_multi_consumer_producer: SUCCESS (0.824s)
[339.793915] [136/138] (677s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[340.038637] Starting subtest: fbcpsr-rgb565-draw-render
[340.041567] Subtest fbcpsr-rgb565-draw-render: SKIP (0.000s)
[340.144085] [137/138] (677s left) kms_cursor_crc (cursor-offscreen-512x512)
[340.395448] Starting subtest: cursor-offscreen-512x512
[340.402798] Subtest cursor-offscreen-512x512: SKIP (0.003s)
[340.515120] [138/138] (676s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[340.750543] Starting subtest: basic-flip-after-cursor-atomic
[341.818887] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.067s)
[342.164981] Closing watchdogs
Done.