[40.147543] Initializing watchdogs
[40.147586]   /dev/watchdog0
[40.153972] [001/139] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[40.271404] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[40.275984] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[40.363980] [002/139] (960s left) kms_rotation_crc (multiplane-rotation)
[40.424892] Starting subtest: multiplane-rotation
[48.196959] Subtest multiplane-rotation: SUCCESS (7.772s)
[48.289853] [003/139] (952s left) prime_vgem (basic-fence-read)
[48.415135] Starting subtest: basic-fence-read
[48.423701] Subtest basic-fence-read: SKIP (0.007s)
[48.508840] [004/139] (952s left) gem_lmem_swapping (verify-random-ccs)
[48.558712] Subtest verify-random-ccs: SKIP (0.000s)
[48.581243] [005/139] (952s left) syncobj_wait (single-wait-signaled)
[48.627995] Starting subtest: single-wait-signaled
[48.629897] Subtest single-wait-signaled: SUCCESS (0.000s)
[48.685510] [006/139] (952s left) intel_hwmon (hwmon-read)
[48.737659] Subtest hwmon-read: SKIP (0.000s)
[48.761774] [007/139] (952s left) perf (blocking)
[48.885207] Starting subtest: blocking
[48.886922] Starting dynamic subtest: 0-rcs0
[58.905092] Dynamic subtest 0-rcs0: SUCCESS (10.019s)
[58.914920] Starting dynamic subtest: 1-vcs1
[68.971790] Dynamic subtest 1-vcs1: SUCCESS (10.017s)
[68.975614] Subtest blocking: SUCCESS (20.036s)
[69.002935] [008/139] (931s left) i915_pm_rps (min-max-config-loaded)
[69.075265] Starting subtest: min-max-config-loaded
[69.080818] Subtest min-max-config-loaded: SKIP (0.001s)
[69.132881] [009/139] (931s left) gem_mmap_gtt (big-copy)
[69.186367] Subtest big-copy: SKIP (0.000s)
[69.209727] [010/139] (931s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[69.272254] Starting subtest: 4-tiled-addfb-size-offset-overflow
[69.274560] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[69.353141] [011/139] (931s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[69.424790] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[72.217465] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (2.798s)
[72.333041] [012/139] (928s left) gen9_exec_parse (allowed-all)
[72.384614] Subtest allowed-all: SKIP (0.000s)
[72.403497] [013/139] (928s left) v3d/v3d_mmap (mmap-bad-flags)
[72.486162] Subtest mmap-bad-flags: SKIP (0.000s)
[72.532162] [014/139] (928s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[72.601962] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[75.396862] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (2.799s)
[75.514459] [015/139] (925s left) gem_tiled_fence_blits (basic)
[75.568650] Subtest basic: SKIP (0.000s)
[75.605738] [016/139] (925s left) gem_userptr_blits (relocations)
[75.667282] Starting subtest: relocations
[75.670886] Subtest relocations: SKIP (0.001s)
[75.772830] [017/139] (925s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[75.824869] Starting subtest: yf-tiled-32bpp-rotate-90
[75.828082] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[75.898781] [018/139] (925s left) gem_eio (in-flight-10ms)
[76.113923] Starting subtest: in-flight-10ms
[84.314708] Subtest in-flight-10ms: SUCCESS (8.199s)
[84.443937] [019/139] (916s left) sw_sync (sync_multi_consumer_producer)
[84.493627] Starting subtest: sync_multi_consumer_producer
[84.849320] Subtest sync_multi_consumer_producer: SUCCESS (0.355s)
[84.896237] [020/139] (916s left) sw_sync (alloc_fence)
[84.929095] Starting subtest: alloc_fence
[84.931548] Subtest alloc_fence: SUCCESS (0.000s)
[84.972104] [021/139] (916s left) i915_getparams_basic (basic-eu-total)
[85.011146] Starting subtest: basic-eu-total
[85.015665] Subtest basic-eu-total: SUCCESS (0.000s)
[85.060623] [022/139] (916s left) kms_chamelium_color (ctm-limited-range)
[85.161708] Subtest ctm-limited-range: SKIP (0.000s)
[85.184116] [023/139] (915s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[85.251080] Starting subtest: primary-yf-tiled-reflect-x-90
[85.256047] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.002s)
[85.306762] [024/139] (915s left) gem_pxp (reject-modify-context-protection-on)
[87.890956] Subtest reject-modify-context-protection-on: SKIP (0.000s)
[87.953518] [025/139] (913s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[88.036041] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[88.040664] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[88.116401] [026/139] (913s left) gem_mmap_gtt (fault-concurrent-x)
[88.165520] Subtest fault-concurrent-X: SKIP (0.000s)
[88.185990] [027/139] (913s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[88.255602] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[88.260527] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[88.332552] [028/139] (912s left) kms_lease (invalid-create-leases)
[88.394335] Starting subtest: invalid-create-leases
[88.397053] Subtest invalid-create-leases: SUCCESS (0.002s)
[88.448749] [029/139] (912s left) kms_frontbuffer_tracking (psr-suspend)
[88.528051] Starting subtest: psr-suspend
[125.125958] Subtest psr-suspend: SUCCESS (6.002s)
[125.243699] [030/139] (906s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[125.304146] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[125.341964] [031/139] (906s left) perf_pmu (event-wait)
[125.413854] Starting subtest: event-wait
[125.416313] Starting dynamic subtest: rcs0
[125.421019] Dynamic subtest rcs0: SKIP (0.000s)
[125.425602] Subtest event-wait: SKIP (0.000s)
[125.481945] [032/139] (906s left) kms_cursor_crc (cursor-size-change)
[125.541514] Starting subtest: cursor-size-change
[125.544054] Starting dynamic subtest: pipe-A-eDP-1
[126.523509] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.980s)
[126.535429] Starting dynamic subtest: pipe-D-eDP-1
[128.119239] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.592s)
[128.121815] Subtest cursor-size-change: SUCCESS (2.575s)
[128.998080] [033/139] (903s left) kms_ccs (pipe-b-bad-aux-stride-y-tiled-ccs)
[129.382272] Starting subtest: pipe-B-bad-aux-stride-y-tiled-ccs
[129.388304] Subtest pipe-B-bad-aux-stride-y-tiled-ccs: SKIP (0.000s)
[130.244943] [034/139] (901s left) kms_atomic_transition (plane-toggle-modeset-transition)
[130.320092] Starting subtest: plane-toggle-modeset-transition
[130.322491] Starting dynamic subtest: pipe-A-eDP-1
[144.504622] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.183s)
[144.522377] Starting dynamic subtest: pipe-B-eDP-1
[158.748829] Dynamic subtest pipe-B-eDP-1: SUCCESS (14.239s)
[158.751285] Subtest plane-toggle-modeset-transition: SUCCESS (28.430s)
[159.683466] [035/139] (872s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[159.743658] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[163.063479] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (3.324s)
[163.181581] [036/139] (868s left) kms_psr2_su (page_flip-p010)
[163.240494] Subtest page_flip-P010: SKIP (0.000s)
[163.254153] [037/139] (868s left) kms_ccs (pipe-a-crc-primary-basic-yf-tiled-ccs)
[163.618949] Starting subtest: pipe-A-crc-primary-basic-yf-tiled-ccs
[163.624230] Subtest pipe-A-crc-primary-basic-yf-tiled-ccs: SKIP (0.001s)
[164.490310] [038/139] (867s left) vc4/vc4_tiling (get-after-free)
[164.573192] Subtest get-after-free: SKIP (0.000s)
[164.620316] [039/139] (867s left) kms_plane_alpha_blend (constant-alpha-max)
[164.700466] Starting subtest: constant-alpha-max
[164.969375] Starting dynamic subtest: pipe-A-eDP-1
[166.229780] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.260s)
[166.243640] Starting dynamic subtest: pipe-D-eDP-1
[168.063372] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.829s)
[168.065635] Subtest constant-alpha-max: SUCCESS (3.362s)
[168.965348] [040/139] (863s left) kms_vrr (flipline)
[169.036611] Starting subtest: flipline
[169.041387] Subtest flipline: SKIP (0.000s)
[169.094382] [041/139] (863s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[169.653322] Starting subtest: syncobj-timeline-invalid-flags
[169.656082] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.001s)
[171.126682] [042/139] (861s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[171.199316] Starting subtest: plane-upscale-20x20-with-pixel-format
[171.201630] Starting dynamic subtest: pipe-A-eDP-1
[172.828417] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.629s)
[172.844462] Starting dynamic subtest: pipe-B-eDP-1
[175.587887] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.756s)
[175.604100] Starting dynamic subtest: pipe-C-eDP-1
[176.938914] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.347s)
[176.954186] Starting dynamic subtest: pipe-D-eDP-1
[178.292685] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.351s)
[178.295173] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (7.094s)
[179.525989] [043/139] (852s left) kms_prop_blob (blob-multiple)
[179.583536] Starting subtest: blob-multiple
[179.585905] Subtest blob-multiple: SUCCESS (0.001s)
[179.646178] [044/139] (852s left) kms_ccs (pipe-a-random-ccs-data-y-tiled-gen12-mc-ccs)
[180.032681] Starting subtest: pipe-A-random-ccs-data-y-tiled-gen12-mc-ccs
[180.041205] Subtest pipe-A-random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[180.938198] [045/139] (851s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[181.025679] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[185.644880] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (4.624s)
[185.761520] [046/139] (846s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[186.120247] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[186.983836] [047/139] (845s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[187.058837] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[188.145743] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.089s)
[188.255474] [048/139] (844s left) kms_getfb (getfb2-into-addfb2)
[188.304934] Starting subtest: getfb2-into-addfb2
[188.307008] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[188.393497] [049/139] (844s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-submitted-signaled
[188.452322] Starting subtest: invalid-multi-wait-available-unsubmitted-submitted-signaled
[188.487298] Subtest invalid-multi-wait-available-unsubmitted-submitted-signaled: FAIL (0.003s)
[188.517312] [050/139] (843s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[188.909314] Starting subtest: pipe-B-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[190.879375] Subtest pipe-B-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (1.969s)
[192.069467] [051/139] (840s left) kms_ccs (pipe-c-bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[192.472035] Starting subtest: pipe-C-bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[192.474967] Subtest pipe-C-bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.000s)
[193.349629] [052/139] (839s left) gem_exec_schedule (pi-ringfull)
[193.524276] Starting subtest: pi-ringfull
[193.526957] Starting dynamic subtest: rcs0
[193.612139] Dynamic subtest rcs0: SUCCESS (0.089s)
[193.641207] Starting dynamic subtest: bcs0
[193.696623] Dynamic subtest bcs0: SUCCESS (0.083s)
[193.720639] Starting dynamic subtest: vcs0
[193.779346] Dynamic subtest vcs0: SUCCESS (0.081s)
[193.804350] Starting dynamic subtest: vcs1
[193.864174] Dynamic subtest vcs1: SUCCESS (0.083s)
[193.889005] Starting dynamic subtest: vecs0
[193.948732] Dynamic subtest vecs0: SUCCESS (0.083s)
[193.973399] Starting dynamic subtest: ccs0
[194.032318] Dynamic subtest ccs0: SUCCESS (0.082s)
[194.035165] Subtest pi-ringfull: SUCCESS (0.511s)
[194.250317] [053/139] (838s left) gem_linear_blits (interruptible)
[194.624684] Starting subtest: interruptible
[199.154341] Subtest interruptible: SUCCESS (4.476s)
[199.249553] [054/139] (833s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[199.399707] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[199.404212] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[199.472200] [055/139] (833s left) prime_vgem (sync)
[199.537043] Starting subtest: sync
[199.539492] Starting dynamic subtest: rcs0
[199.584398] Dynamic subtest rcs0: SUCCESS (0.046s)
[199.598026] Starting dynamic subtest: bcs0
[199.637960] Dynamic subtest bcs0: SUCCESS (0.053s)
[199.649906] Starting dynamic subtest: vcs0
[199.690613] Dynamic subtest vcs0: SUCCESS (0.052s)
[199.701919] Starting dynamic subtest: vcs1
[199.743984] Dynamic subtest vcs1: SUCCESS (0.052s)
[199.756376] Starting dynamic subtest: vecs0
[199.798492] Dynamic subtest vecs0: SUCCESS (0.053s)
[199.810531] Starting dynamic subtest: ccs0
[199.852372] Dynamic subtest ccs0: SUCCESS (0.053s)
[199.854990] Subtest sync: SUCCESS (0.315s)
[199.959068] [056/139] (832s left) kms_ccs (pipe-c-crc-primary-basic-y-tiled-gen12-mc-ccs)
[200.346024] Starting subtest: pipe-C-crc-primary-basic-y-tiled-gen12-mc-ccs
[200.351638] Subtest pipe-C-crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[201.222471] [057/139] (831s left) kms_color (ctm-signed)
[201.295357] Starting subtest: ctm-signed
[201.297695] Starting dynamic subtest: pipe-A
[203.526383] Dynamic subtest pipe-A: SUCCESS (2.232s)
[203.539726] Starting dynamic subtest: pipe-B
[206.515977] Dynamic subtest pipe-B: SUCCESS (2.986s)
[206.528541] Starting dynamic subtest: pipe-C
[209.438151] Dynamic subtest pipe-C: SUCCESS (2.921s)
[209.455576] Starting dynamic subtest: pipe-D
[212.358896] Dynamic subtest pipe-D: SUCCESS (2.921s)
[212.361580] Subtest ctm-signed: SUCCESS (11.065s)
[213.253280] [058/139] (819s left) gem_userptr_blits (stress-purge)
[213.314888] Starting subtest: stress-purge
[218.707708] Subtest stress-purge: SUCCESS (5.398s)
[218.815468] [059/139] (813s left) kms_universal_plane (cursor-fb-leak)
[218.921686] Starting subtest: cursor-fb-leak
[218.923909] Starting dynamic subtest: pipe-A-eDP-1
[219.533689] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.614s)
[219.550965] Starting dynamic subtest: pipe-B-eDP-1
[220.779474] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.242s)
[220.793626] Starting dynamic subtest: pipe-C-eDP-1
[222.038130] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.256s)
[222.059012] Starting dynamic subtest: pipe-D-eDP-1
[223.279610] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.236s)
[223.282299] Subtest cursor-fb-leak: SUCCESS (4.359s)
[224.199372] [060/139] (808s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[224.263202] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[224.265695] Starting dynamic subtest: pipe-A-default-mode
[224.552907] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[224.558478] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.287s)
[225.480497] [061/139] (807s left) gem_exec_schedule (preempt-queue-chain)
[225.567875] Subtest preempt-queue-chain: SKIP (0.000s)
[225.860488] [062/139] (806s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[225.946909] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[225.951492] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[226.022889] [063/139] (806s left) prime_busy (after)
[226.070175] Starting subtest: after
[226.072798] Starting dynamic subtest: rcs0
[226.095967] Dynamic subtest rcs0: SUCCESS (0.024s)
[226.111625] Starting dynamic subtest: bcs0
[226.141549] Dynamic subtest bcs0: SUCCESS (0.045s)
[226.157325] Starting dynamic subtest: vcs0
[226.184645] Dynamic subtest vcs0: SUCCESS (0.041s)
[226.199901] Starting dynamic subtest: vcs1
[226.226016] Dynamic subtest vcs1: SUCCESS (0.040s)
[226.241114] Starting dynamic subtest: vecs0
[226.270901] Dynamic subtest vecs0: SUCCESS (0.041s)
[226.286489] Starting dynamic subtest: ccs0
[226.309596] Dynamic subtest ccs0: SUCCESS (0.040s)
[226.420002] Subtest after: SUCCESS (0.350s)
[226.489823] [064/139] (806s left) gem_mmap_gtt (basic-small-bo-tiledy)
[226.535227] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[226.552395] [065/139] (806s left) kms_content_protection (type1)
[226.663086] Starting subtest: type1
[230.171549] Subtest type1: SKIP (3.506s)
[231.428232] [066/139] (801s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[231.483919] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[231.486399] Starting dynamic subtest: A-eDP1
[235.385158] Dynamic subtest A-eDP1: SUCCESS (3.900s)
[235.398636] Starting dynamic subtest: B-eDP1
[238.845956] Dynamic subtest B-eDP1: SUCCESS (3.458s)
[238.856532] Starting dynamic subtest: C-eDP1
[242.296653] Dynamic subtest C-eDP1: SUCCESS (3.452s)
[242.314238] Starting dynamic subtest: D-eDP1
[245.752206] Dynamic subtest D-eDP1: SUCCESS (3.452s)
[245.758336] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (14.277s)
[246.663695] [067/139] (786s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[247.081954] Starting subtest: pipe-D-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[247.088129] Subtest pipe-D-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.001s)
[247.936496] [068/139] (784s left) kms_draw_crc (draw-method-mmap-cpu)
[248.014881] Starting subtest: draw-method-mmap-cpu
[248.017258] Starting dynamic subtest: xrgb8888-untiled
[248.257687] Dynamic subtest xrgb8888-untiled: SUCCESS (0.245s)
[248.272774] Starting dynamic subtest: rgb565-untiled
[248.502531] Dynamic subtest rgb565-untiled: SUCCESS (0.243s)
[248.512059] Starting dynamic subtest: xrgb2101010-untiled
[248.723431] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[248.739376] Starting dynamic subtest: xrgb8888-xtiled
[248.871522] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s)
[248.885807] Starting dynamic subtest: rgb565-xtiled
[248.992134] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[249.007331] Starting dynamic subtest: xrgb2101010-xtiled
[249.100616] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[249.114840] Starting dynamic subtest: xrgb8888-4tiled
[249.233998] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[249.247540] Starting dynamic subtest: rgb565-4tiled
[249.358176] Dynamic subtest rgb565-4tiled: SUCCESS (0.121s)
[249.373373] Starting dynamic subtest: xrgb2101010-4tiled
[249.478119] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[249.480442] Subtest draw-method-mmap-cpu: SUCCESS (1.468s)
[249.566691] [069/139] (783s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[249.609015] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[249.612987] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[249.785610] [070/139] (783s left) syncobj_timeline (etime-multi-wait-submitted)
[249.848530] Starting subtest: etime-multi-wait-submitted
[249.952999] Subtest etime-multi-wait-submitted: SUCCESS (0.103s)
[250.022287] [071/139] (782s left) kms_cursor_crc (cursor-onscreen-64x21)
[250.186370] Starting subtest: cursor-onscreen-64x21
[250.198556] Starting dynamic subtest: pipe-A-eDP-1
[252.510014] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.312s)
[252.545104] Starting dynamic subtest: pipe-D-eDP-1
[255.625179] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.091s)
[255.628498] Subtest cursor-onscreen-64x21: SUCCESS (5.435s)
[256.506010] [072/139] (776s left) prime_vgem (basic-write)
[256.581557] Starting subtest: basic-write
[256.591309] Subtest basic-write: SKIP (0.007s)
[256.670871] [073/139] (776s left) kms_cdclk (mode-transition-all-outputs)
[256.724832] Starting subtest: mode-transition-all-outputs
[257.011960] Subtest mode-transition-all-outputs: SKIP (0.286s)
[257.927447] [074/139] (775s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[258.022245] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[258.026943] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[258.100745] [075/139] (775s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-25)
[258.152596] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-25
[258.155466] Starting dynamic subtest: pipe-A-eDP-1
[258.165514] Dynamic subtest pipe-A-eDP-1: SKIP (0.008s)
[258.181334] Starting dynamic subtest: pipe-B-eDP-1
[258.186755] Dynamic subtest pipe-B-eDP-1: SKIP (0.016s)
[258.201007] Starting dynamic subtest: pipe-C-eDP-1
[258.206199] Dynamic subtest pipe-C-eDP-1: SKIP (0.016s)
[258.218097] Starting dynamic subtest: pipe-D-eDP-1
[258.222940] Dynamic subtest pipe-D-eDP-1: SKIP (0.016s)
[258.227397] Subtest planes-upscale-factor-0-25-downscale-factor-0-25: SKIP (0.061s)
[258.300621] [076/139] (774s left) kms_big_fb (y-tiled-addfb)
[258.378059] Starting subtest: y-tiled-addfb
[258.382901] Subtest y-tiled-addfb: SKIP (0.000s)
[258.472256] [077/139] (774s left) gem_exec_params (sol-reset-not-gen7)
[258.535619] Starting subtest: sol-reset-not-gen7
[258.540691] Subtest sol-reset-not-gen7: SUCCESS (0.005s)
[258.638005] [078/139] (774s left) gem_ctx_isolation (clean)
[258.705485] Starting subtest: clean
[258.708199] Starting dynamic subtest: rcs0
[258.728947] Dynamic subtest rcs0: SUCCESS (0.023s)
[258.743390] Starting dynamic subtest: bcs0
[258.790826] Dynamic subtest bcs0: SUCCESS (0.062s)
[258.806235] Starting dynamic subtest: vcs0
[258.852687] Dynamic subtest vcs0: SUCCESS (0.061s)
[258.869189] Starting dynamic subtest: vcs1
[260.112570] Dynamic subtest vcs1: SUCCESS (1.258s)
[260.129145] Starting dynamic subtest: vecs0
[262.118672] Dynamic subtest vecs0: SUCCESS (2.006s)
[262.134709] Starting dynamic subtest: ccs0
[264.103701] Dynamic subtest ccs0: SUCCESS (1.983s)
[264.106971] Subtest clean: SUCCESS (5.398s)
[264.318970] [079/139] (768s left) gem_exec_reloc (basic-wc-gtt)
[264.386889] Subtest basic-wc-gtt: SKIP (0.000s)
[264.448465] [080/139] (768s left) gem_create (create-clear)
[264.506972] Starting subtest: create-clear
[264.509345] Starting dynamic subtest: smem0
[297.426708] Dynamic subtest smem0: SUCCESS (32.914s)
[297.429106] Subtest create-clear: SUCCESS (32.915s)
[297.608241] [081/139] (735s left) gem_exec_whisper (basic-contexts-all)
[297.669821] Starting subtest: basic-contexts-all
[317.251791] Subtest basic-contexts-all: SUCCESS (19.577s)
[317.431921] [082/139] (715s left) kms_async_flips (test-cursor)
[317.500315] Starting subtest: test-cursor
[317.505109] Subtest test-cursor: SKIP (0.000s)
[318.792158] [083/139] (714s left) drm_fdinfo (busy)
[318.849114] Starting subtest: busy
[318.851873] Starting dynamic subtest: rcs0
[318.857153] Dynamic subtest rcs0: SKIP (0.000s)
[318.871211] Starting dynamic subtest: bcs0
[318.876717] Dynamic subtest bcs0: SKIP (0.000s)
[318.893195] Starting dynamic subtest: vcs0
[318.898395] Dynamic subtest vcs0: SKIP (0.000s)
[318.912131] Starting dynamic subtest: vcs1
[318.917022] Dynamic subtest vcs1: SKIP (0.000s)
[318.927963] Starting dynamic subtest: vecs0
[318.932746] Dynamic subtest vecs0: SKIP (0.000s)
[318.942381] Starting dynamic subtest: ccs0
[318.947177] Dynamic subtest ccs0: SKIP (0.000s)
[318.952055] Subtest busy: SKIP (0.002s)
[318.973600] [084/139] (714s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[319.040324] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[319.044976] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[319.112988] [085/139] (714s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[319.208156] Starting subtest: flip-vs-cursor-crc-atomic
[319.904259] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.695s)
[320.832899] [086/139] (712s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[321.227377] Starting subtest: pipe-C-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[322.942565] Subtest pipe-C-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (1.713s)
[324.166508] [087/139] (709s left) gem_exec_params (rs-invalid)
[324.207818] Starting subtest: rs-invalid
[324.210634] Subtest rs-invalid: SUCCESS (0.001s)
[324.311182] [088/139] (709s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[324.395620] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[353.739568] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (29.342s)
[354.631219] [089/139] (678s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[366.229735] Starting subtest: modeset-lpsp-stress-no-wait
[377.877920] Subtest modeset-lpsp-stress-no-wait: SUCCESS (11.646s)
[377.991975] [090/139] (655s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[378.062132] Starting subtest: cursor-vs-flip-atomic
[406.512618] Subtest cursor-vs-flip-atomic: SUCCESS (28.451s)
[407.430964] [091/139] (626s left) kms_frontbuffer_tracking (psr-2p-rte)
[407.520788] Starting subtest: psr-2p-rte
[407.525653] Subtest psr-2p-rte: SKIP (0.000s)
[407.604444] [092/139] (625s left) debugfs_test (sysfs)
[407.650051] Starting subtest: sysfs
[407.799377] Subtest sysfs: SUCCESS (0.152s)
[407.869623] [093/139] (625s left) gem_exec_suspend (basic-s4-devices)
[407.939729] Starting subtest: basic-S4-devices
[407.942238] Starting dynamic subtest: smem
[419.085275] Dynamic subtest smem: SUCCESS (11.143s)
[419.088352] Subtest basic-S4-devices: SUCCESS (11.144s)
[421.326093] [094/139] (614s left) gem_exec_capture (pi)
[421.382530] Starting subtest: pi
[421.385393] Starting dynamic subtest: rcs0
[425.584401] Dynamic subtest rcs0: SUCCESS (4.202s)
[425.600861] Starting dynamic subtest: bcs0
[429.658190] Dynamic subtest bcs0: SUCCESS (4.072s)
[429.670377] Starting dynamic subtest: vcs0
[433.839467] Dynamic subtest vcs0: SUCCESS (4.184s)
[433.858430] Starting dynamic subtest: vcs1
[437.948580] Dynamic subtest vcs1: SUCCESS (4.108s)
[437.966487] Starting dynamic subtest: vecs0
[441.990680] Dynamic subtest vecs0: SUCCESS (4.041s)
[442.003254] Starting dynamic subtest: ccs0
[446.053127] Dynamic subtest ccs0: SUCCESS (4.061s)
[446.056102] Subtest pi: SUCCESS (24.674s)
[446.122609] [095/139] (589s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[446.273569] Starting subtest: psr-rgb101010-draw-render
[451.541041] Subtest psr-rgb101010-draw-render: SUCCESS (5.269s)
[451.643594] [096/139] (584s left) syncobj_basic (bad-destroy-pad)
[451.696621] Starting subtest: bad-destroy-pad
[451.699376] Subtest bad-destroy-pad: SUCCESS (0.000s)
[451.757997] [097/139] (583s left) kms_properties (crtc-properties-atomic)
[451.811350] Starting subtest: crtc-properties-atomic
[455.754509] Subtest crtc-properties-atomic: SUCCESS (3.938s)
[456.642133] [098/139] (579s left) sw_sync (sync_merge_same)
[456.705479] Starting subtest: sync_merge_same
[456.708064] Subtest sync_merge_same: SUCCESS (0.000s)
[456.762425] [099/139] (579s left) kms_cursor_crc (cursor-sliding-32x32)
[456.857877] Starting subtest: cursor-sliding-32x32
[456.900136] Subtest cursor-sliding-32x32: SKIP (0.038s)
[457.132921] [100/139] (578s left) kms_cursor_legacy (forked-bo)
[457.217207] Starting subtest: forked-bo
[457.219196] Starting dynamic subtest: pipe-A
[462.689470] Dynamic subtest pipe-A: SUCCESS (5.468s)
[462.707512] Starting dynamic subtest: pipe-B
[468.246502] Dynamic subtest pipe-B: SUCCESS (5.555s)
[468.264840] Starting dynamic subtest: pipe-C
[473.793140] Dynamic subtest pipe-C: SUCCESS (5.545s)
[473.811046] Starting dynamic subtest: pipe-D
[479.343444] Dynamic subtest pipe-D: SUCCESS (5.549s)
[479.364449] Starting dynamic subtest: all-pipes
[484.934734] Dynamic subtest all-pipes: SUCCESS (5.538s)
[484.937415] Subtest forked-bo: SUCCESS (27.664s)
[485.002065] [101/139] (550s left) gem_mmap_wc (write-prefaulted)
[485.043363] Subtest write-prefaulted: SKIP (0.000s)
[485.078725] [102/139] (550s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[485.116834] Starting subtest: wait-all-for-submit-delayed-submit
[485.215056] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[485.287123] [103/139] (550s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[485.356047] Starting subtest: basic-flip-after-cursor-atomic
[486.296355] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.940s)
[487.179737] [104/139] (548s left) api_intel_bb (delta-check)
[487.226752] Starting subtest: delta-check
[487.235096] Subtest delta-check: SUCCESS (0.011s)
[487.330181] [105/139] (548s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[487.404875] Starting subtest: x-tiled-16bpp-rotate-270
[487.423823] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[487.516799] [106/139] (548s left) gem_sync (basic-many-each)
[487.597324] Starting subtest: basic-many-each
[489.851676] Subtest basic-many-each: SUCCESS (2.259s)
[490.023425] [107/139] (545s left) kms_ccs (pipe-a-bad-aux-stride-4-tiled-mtl-mc-ccs)
[490.423957] Starting subtest: pipe-A-bad-aux-stride-4-tiled-mtl-mc-ccs
[490.507952] Subtest pipe-A-bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.085s)
[491.268733] [108/139] (544s left) kms_ccs (pipe-c-bad-rotation-90-y-tiled-gen12-rc-ccs)
[491.662554] Starting subtest: pipe-C-bad-rotation-90-y-tiled-gen12-rc-ccs
[491.668300] Subtest pipe-C-bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[492.551998] [109/139] (543s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[492.603548] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[492.606082] Starting dynamic subtest: pipe-A-default-mode
[492.894977] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[492.900161] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.285s)
[493.831300] [110/139] (542s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-render)
[493.926949] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-render
[496.906570] Subtest fbc-1p-offscren-pri-shrfb-draw-render: SUCCESS (2.984s)
[497.028412] [111/139] (539s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[497.086329] Starting subtest: y-tiled-ccs-to-x-tiled
[497.090585] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[497.263910] [112/139] (538s left) gem_exec_balancer (bonded-semaphore)
[497.310432] Starting subtest: bonded-semaphore
[497.314872] Subtest bonded-semaphore: SKIP (0.000s)
[497.550883] [113/139] (538s left) gem_mmap_wc (write)
[497.620883] Subtest write: SKIP (0.000s)
[497.649151] [114/139] (538s left) kms_ccs (pipe-d-bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[498.039439] Starting subtest: pipe-D-bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[498.833436] Subtest pipe-D-bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.795s)
[500.039106] [115/139] (536s left) kms_lease (lease-again)
[500.121804] Starting subtest: lease-again
[500.124376] Starting dynamic subtest: pipe-A-eDP-1
[500.126808] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[500.134099] Starting dynamic subtest: pipe-B-eDP-1
[500.136345] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[500.143564] Starting dynamic subtest: pipe-C-eDP-1
[500.145819] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[500.153027] Starting dynamic subtest: pipe-D-eDP-1
[500.154920] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[500.156849] Subtest lease-again: SUCCESS (0.006s)
[500.177048] [116/139] (536s left) kms_ccs (pipe-d-bad-aux-stride-y-tiled-gen12-rc-ccs)
[500.590816] Starting subtest: pipe-D-bad-aux-stride-y-tiled-gen12-rc-ccs
[500.596153] Subtest pipe-D-bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[501.450576] [117/139] (534s left) v3d/v3d_submit_cl (bad-multisync-out-sync)
[501.527343] Subtest bad-multisync-out-sync: SKIP (0.000s)
[501.580097] [118/139] (534s left) gem_exec_balancer (parallel-bb-first)
[501.806931] Starting subtest: parallel-bb-first
[502.467859] Subtest parallel-bb-first: SUCCESS (0.661s)
[503.090134] [119/139] (533s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[503.164235] Starting subtest: 4-tiled-32bpp-rotate-270
[503.183983] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.018s)
[503.280250] [120/139] (533s left) syncobj_timeline (multi-wait-available-submitted)
[503.335754] Starting subtest: multi-wait-available-submitted
[503.338368] Subtest multi-wait-available-submitted: SUCCESS (0.001s)
[503.384798] [121/139] (533s left) kms_ccs (pipe-a-bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[503.731581] Starting subtest: pipe-A-bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[504.600378] Subtest pipe-A-bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.866s)
[505.784287] [122/139] (530s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[505.860595] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[511.065433] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (5.210s)
[511.186102] [123/139] (525s left) vc4/vc4_mmap (mmap-bad-handle)
[511.264848] Subtest mmap-bad-handle: SKIP (0.000s)
[511.313217] [124/139] (525s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[511.369222] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[511.371256] Starting dynamic subtest: pipe-A-eDP-1
[516.157822] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.791s)
[516.170587] Starting dynamic subtest: pipe-B-eDP-1
[522.091952] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.931s)
[522.109537] Starting dynamic subtest: pipe-C-eDP-1
[523.489330] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.395s)
[523.502690] Starting dynamic subtest: pipe-D-eDP-1
[524.831512] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.341s)
[524.834075] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (13.466s)
[526.089089] [125/139] (510s left) gem_exec_reloc (basic-gtt)
[526.136076] Subtest basic-gtt: SKIP (0.000s)
[526.174613] [126/139] (510s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[526.248917] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[526.254397] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[526.345341] [127/139] (510s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[526.390927] Starting subtest: framebuffer-vs-set-tiling
[526.395513] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[526.514256] [128/139] (510s left) vc4/vc4_create_bo (create-bo-0)
[526.616920] Subtest create-bo-0: SKIP (0.000s)
[526.669674] [129/139] (509s left) gem_ctx_persistence (engines-mixed)
[526.727406] Starting subtest: engines-mixed
[526.729906] Starting dynamic subtest: rcs0
[526.778474] Dynamic subtest rcs0: SUCCESS (0.051s)
[526.796652] Starting dynamic subtest: bcs0
[526.830462] Dynamic subtest bcs0: SUCCESS (0.050s)
[526.848902] Starting dynamic subtest: vcs0
[526.861642] Dynamic subtest vcs0: SUCCESS (0.029s)
[526.880341] Starting dynamic subtest: vcs1
[526.936390] Dynamic subtest vcs1: SUCCESS (0.074s)
[526.954481] Starting dynamic subtest: vecs0
[526.986282] Dynamic subtest vecs0: SUCCESS (0.049s)
[527.005650] Starting dynamic subtest: ccs0
[527.035080] Dynamic subtest ccs0: SUCCESS (0.048s)
[527.037180] Subtest engines-mixed: SUCCESS (0.309s)
[527.111436] [130/139] (509s left) gem_spin_batch (spin-all-new)
[527.163555] Starting subtest: spin-all-new
[527.181023] Subtest spin-all-new: SUCCESS (0.018s)
[529.132118] [131/139] (507s left) syncobj_timeline (multi-wait-submitted-signaled)
[529.173547] Starting subtest: multi-wait-submitted-signaled
[529.176191] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[529.233613] [132/139] (507s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[529.300042] Starting subtest: fbcpsr-indfb-scaledprimary
[535.155329] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.855s)
[535.251339] [133/139] (501s left) gem_mmap (short-mmap)
[535.303339] Subtest short-mmap: SKIP (0.000s)
[535.335213] [134/139] (501s left) dumb_buffer (map-valid)
[535.385041] Starting subtest: map-valid
[535.387622] Subtest map-valid: SUCCESS (0.000s)
[535.476176] [135/139] (501s left) kms_ccs (pipe-b-ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[535.873808] Starting subtest: pipe-B-ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[535.879633] Subtest pipe-B-ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[536.777336] [136/139] (500s left) gem_lmem_swapping (heavy-verify-random-ccs)
[536.834388] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[536.864148] [137/139] (499s left) gem_ctx_shared (q-promotion)
[536.941743] Starting subtest: Q-promotion
[536.944196] Starting dynamic subtest: rcs0
[537.069247] Dynamic subtest rcs0: SUCCESS (0.125s)
[537.096594] Starting dynamic subtest: vcs0
[537.157509] Dynamic subtest vcs0: SUCCESS (0.088s)
[537.182178] Starting dynamic subtest: vcs1
[537.250640] Dynamic subtest vcs1: SUCCESS (0.091s)
[537.272521] Starting dynamic subtest: vecs0
[537.334727] Dynamic subtest vecs0: SUCCESS (0.083s)
[537.359849] Starting dynamic subtest: ccs0
[537.434292] Dynamic subtest ccs0: SUCCESS (0.098s)
[537.436981] Subtest Q-promotion: SUCCESS (0.493s)
[539.168616] [138/139] (497s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[539.231099] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[539.235797] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[539.314022] [139/139] (497s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[539.413606] Starting subtest: fbcpsr-rgb565-draw-pwrite
[544.375710] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (4.964s)
[544.501140] Closing watchdogs
Done.