[44.129481] Initializing watchdogs
[44.129620]   /dev/watchdog0
[44.143316] [001/144] (960s left) kms_ccs (pipe-d-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[44.579212] Starting subtest: pipe-D-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[44.582051] Subtest pipe-D-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.000s)
[45.420958] [002/144] (959s left) core_getclient
[45.566468] [003/144] (959s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[45.636902] Starting subtest: multi-wait-available-submitted-signaled
[45.639929] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[45.728154] [004/144] (958s left) kms_ccs (pipe-a-bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[46.140149] Starting subtest: pipe-A-bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[46.143068] Subtest pipe-A-bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.000s)
[47.060127] [005/144] (957s left) gem_mmap_gtt (fault-concurrent)
[47.122829] Subtest fault-concurrent: SKIP (0.000s)
[47.170969] [006/144] (957s left) kms_content_protection (srm)
[47.312459] Starting subtest: srm
[50.971570] Subtest srm: SKIP (3.656s)
[52.243328] [007/144] (952s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[52.361886] Starting subtest: flip-vs-cursor-atomic-transitions
[59.348852] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (6.984s)
[60.228650] [008/144] (944s left) perf (invalid-oa-exponent)
[60.404936] Starting subtest: invalid-oa-exponent
[60.422053] Subtest invalid-oa-exponent: SUCCESS (0.014s)
[60.441765] [009/144] (944s left) kms_ccs (pipe-d-ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[60.838467] Starting subtest: pipe-D-ccs-on-another-bo-y-tiled-gen12-rc-ccs
[60.844610] Subtest pipe-D-ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[61.691543] [010/144] (943s left) kms_ccs (pipe-c-bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[62.097181] Starting subtest: pipe-C-bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[62.100311] Subtest pipe-C-bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.000s)
[62.979909] [011/144] (941s left) gem_userptr_blits (readonly-unsync)
[63.053980] Subtest readonly-unsync: SKIP (0.000s)
[63.181843] [012/144] (941s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[63.320806] Starting subtest: cursorA-vs-flipB-atomic-transitions
[63.326273] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[63.453439] [013/144] (941s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[63.559081] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[66.838311] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (3.285s)
[66.982202] [014/144] (937s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[67.090545] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[68.104401] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.013s)
[68.990644] [015/144] (935s left) kms_cursor_crc (cursor-sliding-max-size)
[69.276678] Starting subtest: cursor-sliding-max-size
[69.284287] Subtest cursor-sliding-max-size: SKIP (0.000s)
[69.385377] [016/144] (935s left) kms_color (gamma)
[69.487033] Starting subtest: gamma
[69.489077] Starting dynamic subtest: pipe-A
[70.242087] Dynamic subtest pipe-A: SUCCESS (0.757s)
[70.252129] Starting dynamic subtest: pipe-B
[71.799775] Dynamic subtest pipe-B: SUCCESS (1.556s)
[71.808178] Starting dynamic subtest: pipe-C
[73.302249] Dynamic subtest pipe-C: SUCCESS (1.503s)
[73.312397] Starting dynamic subtest: pipe-D
[74.798803] Dynamic subtest pipe-D: SUCCESS (1.495s)
[74.801478] Subtest gamma: SUCCESS (5.312s)
[75.718633] [017/144] (929s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[75.845244] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[76.614226] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.771s)
[76.805244] [018/144] (928s left) kms_ccs (pipe-b-crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[77.231651] Starting subtest: pipe-B-crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[77.237497] Subtest pipe-B-crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[78.089214] [019/144] (927s left) kms_psr (fbc-psr2-primary-page-flip)
[78.211393] Starting subtest: fbc-psr2-primary-page-flip
[78.213680] Starting dynamic subtest: eDP-1
[78.218423] Dynamic subtest eDP-1: SKIP (0.000s)
[78.222273] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[78.314587] [020/144] (926s left) drm_fdinfo (all-busy-idle-check-all)
[78.392330] Starting subtest: all-busy-idle-check-all
[78.397600] Subtest all-busy-idle-check-all: SKIP (0.004s)
[78.458353] [021/144] (926s left) gem_softpin (overlap)
[78.545084] Starting subtest: overlap
[79.275588] Subtest overlap: SUCCESS (0.729s)
[79.378997] [022/144] (925s left) gen9_exec_parse (batch-zero-length)
[79.441068] Subtest batch-zero-length: SKIP (0.000s)
[79.506231] [023/144] (925s left) kms_lease (lease-invalid-connector)
[79.601256] Starting subtest: lease-invalid-connector
[79.603316] Starting dynamic subtest: pipe-A-eDP-1
[79.605365] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[79.615199] Starting dynamic subtest: pipe-B-eDP-1
[79.617107] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[79.623146] Starting dynamic subtest: pipe-C-eDP-1
[79.625491] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[79.631467] Starting dynamic subtest: pipe-D-eDP-1
[79.633866] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[79.636467] Subtest lease-invalid-connector: SUCCESS (0.002s)
[79.659298] [024/144] (925s left) gem_mmap_gtt (basic-copy)
[79.754530] Subtest basic-copy: SKIP (0.000s)
[79.804201] [025/144] (925s left) i915_suspend (basic-s3-without-i915)
[79.859054] Starting subtest: basic-s3-without-i915
[81.371421] Subtest basic-s3-without-i915: SKIP (1.509s)
[82.620518] [026/144] (922s left) api_intel_bb (offset-control)
[82.714874] Starting subtest: offset-control
[82.738739] Subtest offset-control: SUCCESS (0.026s)
[82.842377] [027/144] (922s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-cpu)
[82.934260] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-cpu
[87.503441] Subtest psr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (4.574s)
[87.611382] [028/144] (917s left) gem_exec_schedule (u-semaphore-codependency)
[87.695846] Starting subtest: u-semaphore-codependency
[87.727552] Subtest u-semaphore-codependency: SUCCESS (0.032s)
[88.060056] [029/144] (917s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[88.161736] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[88.164173] Starting dynamic subtest: pipe-A-default-mode
[88.453449] Dynamic subtest pipe-A-default-mode: SKIP (0.290s)
[88.458537] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.291s)
[89.365655] [030/144] (916s left) kms_pwrite_crc
[91.016661] [031/144] (914s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[91.092908] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[91.095740] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s)
[91.187826] [032/144] (914s left) gem_ctx_sseu (invalid-args)
[91.255666] Subtest invalid-args: SKIP (0.000s)
[91.310173] [033/144] (914s left) kms_ccs (pipe-b-ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[91.745011] Starting subtest: pipe-B-ccs-on-another-bo-y-tiled-gen12-mc-ccs
[91.750162] Subtest pipe-B-ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[92.591259] [034/144] (912s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[92.702220] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[92.706299] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[92.778437] [035/144] (912s left) gem_pxp (verify-pxp-stale-buf-execution)
[95.419621] Subtest verify-pxp-stale-buf-execution: SKIP (0.000s)
[95.446293] [036/144] (910s left) kms_ccs (pipe-a-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[95.838757] Starting subtest: pipe-A-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[95.841286] Subtest pipe-A-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.000s)
[96.712724] [037/144] (908s left) api_intel_allocator (gem-pool)
[96.786268] Starting subtest: gem-pool
[96.800054] Subtest gem-pool: SUCCESS (0.016s)
[96.900142] [038/144] (908s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[96.983683] Subtest writes-after-reads-uncached: SKIP (0.000s)
[97.031831] [039/144] (908s left) kms_psr2_sf (fbc-primary-plane-update-sf-dmg-area)
[102.271490] Starting subtest: fbc-primary-plane-update-sf-dmg-area
[102.274268] Starting dynamic subtest: pipe-A-eDP-1
[103.106869] Dynamic subtest pipe-A-eDP-1: SKIP (0.833s)
[103.119469] Starting dynamic subtest: pipe-B-eDP-1
[104.345800] Dynamic subtest pipe-B-eDP-1: SKIP (1.237s)
[104.350841] Subtest fbc-primary-plane-update-sf-dmg-area: SKIP (2.075s)
[105.620473] [040/144] (900s left) gem_mmap_offset (close-race)
[105.686735] Starting subtest: close-race
[128.118265] Subtest close-race: SUCCESS (22.434s)
[128.205339] [041/144] (877s left) kms_psr (pr-no-drrs)
[128.292109] Starting subtest: pr-no-drrs
[128.297409] Subtest pr-no-drrs: SKIP (0.000s)
[128.383276] [042/144] (877s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[128.463779] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[128.514488] [043/144] (877s left) kms_ccs (pipe-d-bad-aux-stride-y-tiled-ccs)
[128.943333] Starting subtest: pipe-D-bad-aux-stride-y-tiled-ccs
[128.949367] Subtest pipe-D-bad-aux-stride-y-tiled-ccs: SKIP (0.000s)
[129.796870] [044/144] (875s left) gem_exec_reloc (basic-gtt-cpu-active)
[129.890842] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[129.941621] [045/144] (875s left) gem_exec_balancer (sequential)
[130.035691] Starting subtest: sequential
[132.896602] Subtest sequential: SUCCESS (2.861s)
[133.161573] [046/144] (872s left) kms_big_joiner (basic)
[133.260861] Subtest basic: SKIP (0.000s)
[133.278432] [047/144] (872s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[133.360934] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[136.140722] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.785s)
[136.266883] [048/144] (869s left) gem_exec_flush (basic-wb-rw-before-default)
[136.377726] Starting subtest: basic-wb-rw-before-default
[141.863378] Subtest basic-wb-rw-before-default: SUCCESS (5.486s)
[142.052639] [049/144] (863s left) kms_cursor_crc (cursor-sliding-128x128)
[142.237463] Starting subtest: cursor-sliding-128x128
[142.239988] Starting dynamic subtest: pipe-A-eDP-1
[145.998447] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.757s)
[146.030816] Starting dynamic subtest: pipe-D-eDP-1
[150.503687] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.486s)
[150.506778] Subtest cursor-sliding-128x128: SUCCESS (8.266s)
[151.384727] [050/144] (854s left) gem_create (create-ext-placement-all)
[151.572272] Starting subtest: create-ext-placement-all
[151.575505] Subtest create-ext-placement-all: SUCCESS (0.000s)
[151.658540] [051/144] (854s left) gem_exec_balancer (hang)
[151.952776] Starting subtest: hang
[153.478777] Subtest hang: SUCCESS (1.526s)
[153.578287] [052/144] (852s left) kms_ccs (pipe-c-crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[154.021954] Starting subtest: pipe-C-crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[155.005548] Subtest pipe-C-crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.983s)
[156.194546] [053/144] (849s left) perf_pmu (semaphore-wait-idle)
[156.241053] Starting subtest: semaphore-wait-idle
[156.243647] Starting dynamic subtest: rcs0
[156.756547] Dynamic subtest rcs0: SUCCESS (0.515s)
[156.772869] Starting dynamic subtest: bcs0
[157.270494] Dynamic subtest bcs0: SUCCESS (0.513s)
[157.287049] Starting dynamic subtest: vcs0
[157.786069] Dynamic subtest vcs0: SUCCESS (0.514s)
[157.802398] Starting dynamic subtest: vcs1
[158.301125] Dynamic subtest vcs1: SUCCESS (0.514s)
[158.318198] Starting dynamic subtest: vecs0
[158.815360] Dynamic subtest vecs0: SUCCESS (0.513s)
[158.831369] Starting dynamic subtest: ccs0
[159.330903] Dynamic subtest ccs0: SUCCESS (0.514s)
[159.333854] Subtest semaphore-wait-idle: SUCCESS (3.090s)
[160.532289] [054/144] (845s left) gem_softpin (32b-excludes-last-page)
[160.633905] Starting subtest: 32b-excludes-last-page
[160.644432] Subtest 32b-excludes-last-page: SUCCESS (0.011s)
[160.752751] [055/144] (845s left) gem_eio (wait-1us)
[160.990485] Starting subtest: wait-1us
[161.404237] Subtest wait-1us: SUCCESS (0.416s)
[161.506413] [056/144] (844s left) gem_exec_fence (syncobj-timeline-export)
[162.144692] Starting subtest: syncobj-timeline-export
[162.157307] Subtest syncobj-timeline-export: SUCCESS (0.013s)
[163.533560] [057/144] (842s left) v3d/v3d_submit_csd (multi-and-single-sync)
[163.603565] Subtest multi-and-single-sync: SKIP (0.000s)
[163.653045] [058/144] (842s left) fbdev (unaligned-write)
[163.720975] Starting subtest: unaligned-write
[163.831453] Subtest unaligned-write: SUCCESS (0.109s)
[163.887611] [059/144] (842s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[163.979774] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[168.617851] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (4.645s)
[168.730067] [060/144] (837s left) gem_ctx_param (basic)
[168.789758] Starting subtest: basic
[168.792234] Subtest basic: SUCCESS (0.001s)
[168.872408] [061/144] (837s left) gem_exec_schedule (smoketest)
[169.095392] Starting subtest: smoketest
[169.098441] Starting dynamic subtest: rcs0
[174.726669] Dynamic subtest rcs0: SUCCESS (5.573s)
[174.735997] Starting dynamic subtest: bcs0
[180.373412] Dynamic subtest bcs0: SUCCESS (5.645s)
[180.385534] Starting dynamic subtest: vcs0
[185.934372] Dynamic subtest vcs0: SUCCESS (5.565s)
[185.948063] Starting dynamic subtest: vcs1
[191.502100] Dynamic subtest vcs1: SUCCESS (5.566s)
[191.515735] Starting dynamic subtest: vecs0
[197.166822] Dynamic subtest vecs0: SUCCESS (5.613s)
[197.182082] Starting dynamic subtest: ccs0
[202.759058] Dynamic subtest ccs0: SUCCESS (5.584s)
[202.761191] Subtest smoketest: SUCCESS (33.550s)
[202.828848] [062/144] (803s left) kms_big_fb (linear-32bpp-rotate-270)
[202.895137] Starting subtest: linear-32bpp-rotate-270
[202.926192] Subtest linear-32bpp-rotate-270: SKIP (0.029s)
[203.018029] [063/144] (803s left) syncobj_timeline (wait-any-snapshot)
[203.071208] Starting subtest: wait-any-snapshot
[203.152272] Subtest wait-any-snapshot: SUCCESS (0.083s)
[203.228892] [064/144] (803s left) kms_flip (plain-flip-interruptible)
[203.331751] Starting subtest: plain-flip-interruptible
[203.337657] Starting dynamic subtest: A-eDP1
[205.103745] Dynamic subtest A-eDP1: SUCCESS (1.766s)
[205.121042] Starting dynamic subtest: B-eDP1
[206.831981] Dynamic subtest B-eDP1: SUCCESS (1.726s)
[206.851634] Starting dynamic subtest: C-eDP1
[208.610952] Dynamic subtest C-eDP1: SUCCESS (1.778s)
[208.628759] Starting dynamic subtest: D-eDP1
[210.339451] Dynamic subtest D-eDP1: SUCCESS (1.727s)
[210.348526] Subtest plain-flip-interruptible: SUCCESS (7.017s)
[211.601020] [065/144] (794s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-pwrite)
[211.705729] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-pwrite
[216.935644] Subtest fbc-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (5.234s)
[217.040262] [066/144] (789s left) kms_chamelium_frames (hdmi-crc-single)
[217.457454] Subtest hdmi-crc-single: SKIP (0.000s)
[218.343042] [067/144] (788s left) vc4/vc4_perfmon (create-perfmon-invalid-events)
[218.423640] Subtest create-perfmon-invalid-events: SKIP (0.000s)
[218.475555] [068/144] (787s left) gem_tiled_swapping (non-threaded)
[218.552776] Subtest non-threaded: SKIP (0.000s)
[218.593180] [069/144] (787s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[218.659696] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[218.662159] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[218.758655] [070/144] (787s left) kms_fbcon_fbt (psr-suspend)
[218.808894] Starting subtest: psr-suspend
[267.161283] Subtest psr-suspend: SUCCESS (18.735s)
[267.266346] [071/144] (768s left) gem_exec_params (sol-reset-invalid)
[267.350887] Starting subtest: sol-reset-invalid
[267.358214] Subtest sol-reset-invalid: SUCCESS (0.007s)
[269.159905] [072/144] (767s left) kms_ccs (pipe-a-crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[269.551465] Starting subtest: pipe-A-crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[269.557352] Subtest pipe-A-crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[270.473405] [073/144] (765s left) prime_vgem (basic-read)
[270.593087] Starting subtest: basic-read
[270.604972] Subtest basic-read: SKIP (0.009s)
[270.698036] [074/144] (765s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[270.790550] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[275.401236] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (4.615s)
[275.524032] [075/144] (760s left) kms_psr (psr-primary-mmap-cpu)
[275.598183] Starting subtest: psr-primary-mmap-cpu
[275.601011] Starting dynamic subtest: eDP-1
[277.411918] Dynamic subtest eDP-1: SUCCESS (1.815s)
[277.414664] Subtest psr-primary-mmap-cpu: SUCCESS (1.816s)
[278.333154] [076/144] (757s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[278.442600] Starting subtest: basic-flip-after-cursor-atomic
[279.384699] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.941s)
[280.293761] [077/144] (756s left) prime_busy (before-wait)
[280.396689] Starting subtest: before-wait
[280.405452] Starting dynamic subtest: rcs0
[280.438788] Dynamic subtest rcs0: SUCCESS (0.034s)
[280.453461] Starting dynamic subtest: bcs0
[280.482450] Dynamic subtest bcs0: SUCCESS (0.042s)
[280.494922] Starting dynamic subtest: vcs0
[280.527173] Dynamic subtest vcs0: SUCCESS (0.043s)
[280.540075] Starting dynamic subtest: vcs1
[280.571468] Dynamic subtest vcs1: SUCCESS (0.043s)
[280.584618] Starting dynamic subtest: vecs0
[280.615829] Dynamic subtest vecs0: SUCCESS (0.043s)
[280.630919] Starting dynamic subtest: ccs0
[280.660884] Dynamic subtest ccs0: SUCCESS (0.044s)
[280.775024] Subtest before-wait: SUCCESS (0.377s)
[280.845706] [078/144] (755s left) prime_self_import (basic-with_fd_dup)
[280.905428] Starting subtest: basic-with_fd_dup
[280.919443] Subtest basic-with_fd_dup: SUCCESS (0.014s)
[281.016352] [079/144] (755s left) kms_hdr (bpc-switch)
[281.118021] Starting subtest: bpc-switch
[282.246361] Starting dynamic subtest: pipe-A-eDP-1
[285.959197] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.713s)
[285.961721] Subtest bpc-switch: SUCCESS (4.842s)
[286.068211] [080/144] (750s left) kms_dirtyfb (default-dirtyfb-ioctl)
[286.176319] Starting subtest: default-dirtyfb-ioctl
[286.178590] Starting dynamic subtest: A-eDP-1
[287.872471] Dynamic subtest A-eDP-1: SUCCESS (1.695s)
[287.875258] Subtest default-dirtyfb-ioctl: SUCCESS (1.698s)
[288.763731] [081/144] (747s left) gem_eio (in-flight-suspend)
[289.022238] Starting subtest: in-flight-suspend
[331.474416] Subtest in-flight-suspend: SUCCESS (13.147s)
[331.588485] [082/144] (734s left) kms_sequence (queue-busy)
[331.680505] Starting subtest: queue-busy
[331.683027] Starting dynamic subtest: pipe-A-eDP-1
[333.639666] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.959s)
[333.666604] Starting dynamic subtest: pipe-B-eDP-1
[336.364445] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.720s)
[336.383055] Starting dynamic subtest: pipe-C-eDP-1
[339.053424] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.687s)
[339.074269] Starting dynamic subtest: pipe-D-eDP-1
[341.750449] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.694s)
[341.753142] Subtest queue-busy: SUCCESS (10.071s)
[342.660331] [083/144] (723s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[342.742254] Starting subtest: basic-max-pipe-crc-check
[342.746317] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[342.771266] [084/144] (723s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[342.843184] Starting subtest: saturated-hostile-nopreempt
[342.845631] Starting dynamic subtest: rcs0
[342.865225] Dynamic subtest rcs0: SKIP (0.020s)
[342.875856] Starting dynamic subtest: bcs0
[342.891244] Dynamic subtest bcs0: SKIP (0.025s)
[342.901682] Starting dynamic subtest: vcs0
[342.911453] Dynamic subtest vcs0: SKIP (0.019s)
[342.920750] Starting dynamic subtest: vcs1
[342.927967] Dynamic subtest vcs1: SKIP (0.014s)
[342.936002] Starting dynamic subtest: vecs0
[342.940307] Dynamic subtest vecs0: SKIP (0.014s)
[342.947279] Starting dynamic subtest: ccs0
[342.951960] Dynamic subtest ccs0: SKIP (0.011s)
[342.956501] Subtest saturated-hostile-nopreempt: SKIP (0.106s)
[343.012386] [085/144] (722s left) kms_psr (pr-cursor-plane-move)
[343.093265] Starting subtest: pr-cursor-plane-move
[343.098245] Subtest pr-cursor-plane-move: SKIP (0.000s)
[343.230214] [086/144] (722s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[343.347106] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[347.933777] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.590s)
[348.047000] [087/144] (717s left) gem_exec_reloc (basic-gtt-wc-active)
[348.145753] Subtest basic-gtt-wc-active: SKIP (0.000s)
[348.210459] [088/144] (717s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[348.328168] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[348.332958] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[348.411604] [089/144] (717s left) gem_softpin (allocator-evict)
[348.500877] Starting subtest: allocator-evict
[348.503406] Starting dynamic subtest: rcs0
[372.255722] Dynamic subtest rcs0: SUCCESS (23.754s)
[372.265246] Starting dynamic subtest: bcs0
[395.794133] Dynamic subtest bcs0: SUCCESS (23.537s)
[395.813638] Starting dynamic subtest: vcs0
[419.431174] Dynamic subtest vcs0: SUCCESS (23.637s)
[419.438623] Starting dynamic subtest: vcs1
[442.721952] Dynamic subtest vcs1: SUCCESS (23.290s)
[442.742216] Starting dynamic subtest: vecs0
[466.076219] Dynamic subtest vecs0: SUCCESS (23.352s)
[466.091544] Starting dynamic subtest: ccs0
[489.381247] Dynamic subtest ccs0: SUCCESS (23.303s)
[489.385314] Subtest allocator-evict: SUCCESS (140.881s)
[489.465318] [090/144] (576s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[489.615339] Starting subtest: map-fixed-invalidate-overlap-busy
[489.620561] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[489.739020] [091/144] (576s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[489.864161] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[489.868149] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[489.952481] [092/144] (576s left) kms_ccs (pipe-b-bad-aux-stride-y-tiled-gen12-rc-ccs)
[490.351544] Starting subtest: pipe-B-bad-aux-stride-y-tiled-gen12-rc-ccs
[490.358225] Subtest pipe-B-bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[491.265842] [093/144] (574s left) vc4/vc4_purgeable_bo (mark-unpurgeable-purged)
[491.378786] Subtest mark-unpurgeable-purged: SKIP (0.000s)
[491.433129] [094/144] (574s left) gem_mmap_gtt (bad-object)
[491.508797] Subtest bad-object: SKIP (0.000s)
[491.571911] [095/144] (574s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[492.031895] Starting subtest: pipe-C-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[492.037153] Subtest pipe-C-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.002s)
[492.866921] [096/144] (573s left) kms_pm_rpm (i2c)
[494.550961] Starting subtest: i2c
[500.318217] Subtest i2c: SUCCESS (5.768s)
[500.440432] [097/144] (565s left) kms_pm_rpm (pm-caching)
[502.490922] Starting subtest: pm-caching
[502.496069] Subtest pm-caching: SKIP (0.000s)
[502.867831] [098/144] (563s left) kms_ccs (pipe-d-crc-primary-rotation-180-yf-tiled-ccs)
[503.323932] Starting subtest: pipe-D-crc-primary-rotation-180-yf-tiled-ccs
[503.328991] Subtest pipe-D-crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.001s)
[504.156097] [099/144] (562s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[504.276153] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[504.280164] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[504.375198] [100/144] (562s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[504.470151] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[504.474239] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[504.557475] [101/144] (561s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[504.680217] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[505.690760] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.014s)
[505.846435] [102/144] (560s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[505.935497] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[506.890880] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.959s)
[507.052076] [103/144] (559s left) kms_feature_discovery (psr2)
[507.155599] Starting subtest: psr2
[507.158081] Subtest psr2: SUCCESS (0.000s)
[507.224371] [104/144] (559s left) kms_plane_lowres (tiling-4)
[507.349935] Starting subtest: tiling-4
[507.352457] Starting dynamic subtest: pipe-A-eDP-1
[507.357424] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[507.657103] Starting dynamic subtest: pipe-B-eDP-1
[507.662435] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[507.674731] Starting dynamic subtest: pipe-C-eDP-1
[507.679024] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[507.685458] Starting dynamic subtest: pipe-D-eDP-1
[507.690124] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[507.694799] Subtest tiling-4: SKIP (0.308s)
[508.553400] [105/144] (558s left) gem_lmem_swapping (heavy-verify-random)
[508.611101] Subtest heavy-verify-random: SKIP (0.000s)
[508.653238] [106/144] (557s left) v3d/v3d_create_bo (create-bo-0)
[508.703356] Subtest create-bo-0: SKIP (0.000s)
[508.742797] [107/144] (557s left) kms_ccs (pipe-c-bad-pixel-format-yf-tiled-ccs)
[509.151927] Starting subtest: pipe-C-bad-pixel-format-yf-tiled-ccs
[509.157408] Subtest pipe-C-bad-pixel-format-yf-tiled-ccs: SKIP (0.000s)
[510.066379] [108/144] (556s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[510.173786] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[510.176160] Starting dynamic subtest: pipe-A-eDP-1
[510.180878] Dynamic subtest pipe-A-eDP-1: SKIP (0.003s)
[510.189625] Starting dynamic subtest: pipe-B-eDP-1
[510.197877] Dynamic subtest pipe-B-eDP-1: SKIP (0.014s)
[510.205983] Starting dynamic subtest: pipe-C-eDP-1
[510.219046] Dynamic subtest pipe-C-eDP-1: SKIP (0.022s)
[510.225814] Starting dynamic subtest: pipe-D-eDP-1
[510.244176] Dynamic subtest pipe-D-eDP-1: SKIP (0.021s)
[510.248015] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.068s)
[510.316167] [109/144] (556s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[510.405927] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[510.409895] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[510.487283] [110/144] (556s left) kms_properties (connector-properties-atomic)
[510.557130] Starting subtest: connector-properties-atomic
[510.985463] Subtest connector-properties-atomic: SUCCESS (0.415s)
[511.860498] [111/144] (554s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[511.932204] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[511.947947] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.013s)
[512.019977] [112/144] (554s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[512.134487] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[512.139542] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[512.216454] [113/144] (554s left) kms_psr (fbc-pr-primary-mmap-cpu)
[512.291286] Starting subtest: fbc-pr-primary-mmap-cpu
[512.295906] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[512.388345] [114/144] (554s left) gem_exec_fence (long-history)
[512.859234] Starting subtest: long-history
[520.065785] Subtest long-history: SUCCESS (7.207s)
[521.162426] [115/144] (545s left) kms_cursor_crc (cursor-offscreen-32x32)
[521.291027] Starting subtest: cursor-offscreen-32x32
[521.324142] Subtest cursor-offscreen-32x32: SKIP (0.026s)
[521.617067] [116/144] (545s left) gem_sync (basic-many-each)
[521.701958] Starting subtest: basic-many-each
[524.051237] Subtest basic-many-each: SUCCESS (2.343s)
[524.233884] [117/144] (542s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[524.347090] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[524.351535] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[524.438637] [118/144] (542s left) i915_pm_rps (fence-order)
[524.530019] Starting subtest: fence-order
[526.111549] Subtest fence-order: SUCCESS (1.579s)
[526.211537] [119/144] (540s left) gem_exec_schedule (fifo)
[526.340936] Starting subtest: fifo
[526.343736] Starting dynamic subtest: rcs0
[526.450481] Dynamic subtest rcs0: SUCCESS (0.113s)
[526.472774] Starting dynamic subtest: vcs0
[526.566691] Dynamic subtest vcs0: SUCCESS (0.115s)
[526.588743] Starting dynamic subtest: vcs1
[526.702815] Dynamic subtest vcs1: SUCCESS (0.134s)
[526.723899] Starting dynamic subtest: vecs0
[526.831081] Dynamic subtest vecs0: SUCCESS (0.127s)
[526.853125] Starting dynamic subtest: ccs0
[526.926836] Dynamic subtest ccs0: SUCCESS (0.095s)
[526.929428] Subtest fifo: SUCCESS (0.590s)
[528.481462] [120/144] (538s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[528.593378] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[528.597519] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[528.682515] [121/144] (538s left) kms_writeback (writeback-fb-id)
[528.781361] Subtest writeback-fb-id: SKIP (0.000s)
[528.810704] [122/144] (538s left) i915_module_load (resize-bar)
[528.866461] Starting subtest: resize-bar
[528.879741] Subtest resize-bar: SKIP (0.013s)
[528.926578] [123/144] (538s left) kms_pm_backlight (basic-brightness)
[529.026378] Starting subtest: basic-brightness
[529.093410] Starting dynamic subtest: eDP-1
[529.628291] Dynamic subtest eDP-1: SUCCESS (0.534s)
[529.631455] Subtest basic-brightness: SUCCESS (0.603s)
[530.552308] [124/144] (536s left) kms_chamelium_edid (hdmi-edid-read)
[530.954494] Subtest hdmi-edid-read: SKIP (0.000s)
[531.866507] [125/144] (535s left) gem_reg_read (timestamp-monotonic)
[531.941450] Starting subtest: timestamp-monotonic
[536.324864] Subtest timestamp-monotonic: SUCCESS (4.385s)
[536.395914] [126/144] (530s left) kms_atomic (plane-invalid-params)
[536.498558] Starting subtest: plane-invalid-params
[536.501130] Starting dynamic subtest: pipe-A-eDP-1
[536.932678] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.433s)
[536.935381] Subtest plane-invalid-params: SUCCESS (0.434s)
[537.846212] [127/144] (529s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[537.965284] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[537.969924] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[538.052902] [128/144] (529s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[538.105715] Starting subtest: etime-single-wait-all-for-submit-submitted
[538.204592] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.101s)
[538.287260] [129/144] (529s left) kms_scaling_modes (scaling-mode-center)
[538.365853] Starting subtest: scaling-mode-center
[538.368312] Starting dynamic subtest: pipe-A-eDP-1
[538.502852] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.138s)
[538.523642] Starting dynamic subtest: pipe-B-eDP-1
[539.762218] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.256s)
[539.782345] Starting dynamic subtest: pipe-C-eDP-1
[541.025234] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.262s)
[541.043040] Starting dynamic subtest: pipe-D-eDP-1
[542.241360] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.214s)
[542.243937] Subtest scaling-mode-center: SUCCESS (3.881s)
[543.493229] [130/144] (523s left) kms_ccs (pipe-a-bad-rotation-90-4-tiled-mtl-mc-ccs)
[543.901258] Starting subtest: pipe-A-bad-rotation-90-4-tiled-mtl-mc-ccs
[544.950854] Subtest pipe-A-bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (1.049s)
[546.176025] [131/144] (521s left) vc4/vc4_wait_seqno (bad-seqno-0ns)
[546.280566] Subtest bad-seqno-0ns: SKIP (0.000s)
[546.339802] [132/144] (521s left) syncobj_wait (invalid-reset-illegal-handle)
[546.394791] Starting subtest: invalid-reset-illegal-handle
[546.397018] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[546.468021] [133/144] (521s left) gem_ctx_persistence (heartbeat-many)
[546.517303] Starting subtest: heartbeat-many
[546.521718] Subtest heartbeat-many: SKIP (0.000s)
[546.622609] [134/144] (520s left) v3d/v3d_submit_cl (bad-multisync-pad)
[546.686127] Subtest bad-multisync-pad: SKIP (0.000s)
[546.731132] [135/144] (520s left) perf_pmu (busy-start)
[546.766230] Starting subtest: busy-start
[546.768597] Starting dynamic subtest: rcs0
[549.320895] Dynamic subtest rcs0: SUCCESS (2.555s)
[549.343457] Starting dynamic subtest: bcs0
[551.895336] Dynamic subtest bcs0: SUCCESS (2.552s)
[551.917639] Starting dynamic subtest: vcs0
[555.377138] Dynamic subtest vcs0: SUCCESS (3.501s)
[555.399455] Starting dynamic subtest: vcs1
[559.409851] Dynamic subtest vcs1: SUCCESS (4.030s)
[559.431856] Starting dynamic subtest: vecs0
[563.377907] Dynamic subtest vecs0: SUCCESS (3.967s)
[563.399866] Starting dynamic subtest: ccs0
[565.950729] Dynamic subtest ccs0: SUCCESS (2.552s)
[565.952975] Subtest busy-start: SUCCESS (19.166s)
[566.027347] [136/144] (501s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[566.101709] Starting subtest: multi-wait-for-submit-unsubmitted
[566.205883] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[566.286756] [137/144] (501s left) gem_mmap_offset (pf-nonblock)
[566.363271] Starting subtest: pf-nonblock
[566.384172] Subtest pf-nonblock: SUCCESS (0.024s)
[566.494427] [138/144] (501s left) kms_flip (2x-nonexisting-fb-interruptible)
[566.592143] Starting subtest: 2x-nonexisting-fb-interruptible
[566.606187] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.013s)
[566.684401] [139/144] (501s left) kms_addfb_basic (addfb25-4-tiled)
[566.780579] Starting subtest: addfb25-4-tiled
[566.783173] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[566.864513] [140/144] (500s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[566.921683] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[567.020452] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[567.091524] [141/144] (500s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[567.169201] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[567.171831] Starting dynamic subtest: pipe-A-default-mode
[567.458256] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[567.463637] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.291s)
[568.390135] [142/144] (499s left) gem_set_tiling_vs_gtt
[568.503856] [143/144] (499s left) gem_vm_create (invalid-create)
[568.570641] Starting subtest: invalid-create
[568.573632] Subtest invalid-create: SUCCESS (0.001s)
[568.669950] [144/144] (499s left) dumb_buffer (create-valid-dumb)
[568.730681] Starting subtest: create-valid-dumb
[568.732907] Subtest create-valid-dumb: SUCCESS (0.000s)
[568.809685] Closing watchdogs
Done.