[57.725262] Initializing watchdogs
[57.725308]   /dev/watchdog0
[57.738519] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.742760] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.744968] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.748309] [001/131] (960s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[57.911998] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[57.914207] Starting dynamic subtest: pipe-A-eDP-1
[57.937752] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[57.947628] Starting dynamic subtest: pipe-B-eDP-1
[57.968806] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[57.975326] Starting dynamic subtest: pipe-C-eDP-1
[57.996795] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[58.003928] Starting dynamic subtest: pipe-D-eDP-1
[58.025688] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[58.029799] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[60.054402] [002/131] (958s left) kms_pm_dc (dc6-dpms)
[61.160060] Starting subtest: dc6-dpms
[68.187621] Subtest dc6-dpms: FAIL (6.696s)
[68.215159] [003/131] (950s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[68.312614] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[68.314866] Starting dynamic subtest: pipe-A-default-mode
[70.977177] Dynamic subtest pipe-A-default-mode: SUCCESS (2.661s)
[70.979513] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.662s)
[71.855843] [004/131] (946s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-pwrite)
[71.970821] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-pwrite
[76.920786] Subtest fbcpsr-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (4.952s)
[77.037242] [005/131] (941s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[77.147294] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[77.151667] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[77.253952] [006/131] (941s left) kms_color (invalid-ctm-matrix-sizes)
[77.353166] Starting subtest: invalid-ctm-matrix-sizes
[77.355549] Starting dynamic subtest: pipe-A
[77.357530] Dynamic subtest pipe-A: SUCCESS (0.002s)
[77.365597] Starting dynamic subtest: pipe-B
[77.367875] Dynamic subtest pipe-B: SUCCESS (0.005s)
[77.374402] Starting dynamic subtest: pipe-C
[77.376320] Dynamic subtest pipe-C: SUCCESS (0.003s)
[77.383699] Starting dynamic subtest: pipe-D
[77.386043] Dynamic subtest pipe-D: SUCCESS (0.004s)
[77.388253] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.015s)
[77.430877] [007/131] (941s left) gem_mmap_offset (blt-coherency)
[77.487081] Starting subtest: blt-coherency
[77.494094] Subtest blt-coherency: SUCCESS (0.009s)
[77.624672] [008/131] (940s left) gem_mmap_gtt (cpuset-big-copy-odd)
[77.681523] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[77.735014] [009/131] (940s left) perf (gen12-unprivileged-single-ctx-counters)
[77.847384] Starting subtest: gen12-unprivileged-single-ctx-counters
[77.849699] Starting dynamic subtest: rcs0
[78.038538] Dynamic subtest rcs0: SUCCESS (0.191s)
[78.040609] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.192s)
[78.075871] [010/131] (940s left) perf (blocking)
[78.161176] Starting subtest: blocking
[78.162969] Starting dynamic subtest: 0-rcs0
[88.194702] Dynamic subtest 0-rcs0: SUCCESS (10.031s)
[88.201437] Starting dynamic subtest: 1-vecs0
[98.271723] Dynamic subtest 1-vecs0: SUCCESS (10.025s)
[98.274263] Subtest blocking: SUCCESS (20.057s)
[98.303880] [011/131] (920s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[98.406901] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[98.411093] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[98.500781] [012/131] (920s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[98.606187] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[103.241468] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.638s)
[103.355886] [013/131] (915s left) gem_ctx_persistence (engines-hostile)
[103.421047] Starting subtest: engines-hostile
[103.423393] Starting dynamic subtest: rcs0
[103.576647] Dynamic subtest rcs0: SUCCESS (0.155s)
[103.585375] Starting dynamic subtest: bcs0
[103.698598] Dynamic subtest bcs0: SUCCESS (0.122s)
[103.708279] Starting dynamic subtest: vcs0
[103.811671] Dynamic subtest vcs0: SUCCESS (0.113s)
[103.820222] Starting dynamic subtest: vcs1
[103.919757] Dynamic subtest vcs1: SUCCESS (0.108s)
[103.929646] Starting dynamic subtest: vecs0
[104.029906] Dynamic subtest vecs0: SUCCESS (0.110s)
[104.039911] Starting dynamic subtest: ccs0
[104.148112] Dynamic subtest ccs0: SUCCESS (0.118s)
[104.150928] Subtest engines-hostile: SUCCESS (0.726s)
[104.224539] [014/131] (914s left) fbdev (nullptr)
[104.265651] Starting subtest: nullptr
[104.267461] Subtest nullptr: SUCCESS (0.000s)
[104.312992] [015/131] (914s left) gem_userptr_blits (create-destroy-sync)
[104.385561] Starting subtest: create-destroy-sync
[109.451424] Subtest create-destroy-sync: SUCCESS (5.011s)
[109.529679] [016/131] (909s left) kms_psr (psr2-cursor-plane-move)
[109.635241] Starting subtest: psr2-cursor-plane-move
[109.637658] Starting dynamic subtest: eDP-1
[111.302375] Dynamic subtest eDP-1: SUCCESS (1.666s)
[111.304831] Subtest psr2-cursor-plane-move: SUCCESS (1.666s)
[112.079516] [017/131] (906s left) i915_suspend (basic-s3-without-i915)
[112.114440] Starting subtest: basic-s3-without-i915
[115.621121] Subtest basic-s3-without-i915: SKIP (3.499s)
[116.975988] [018/131] (901s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[117.076286] Starting subtest: fbc-psr2-cursor-mmap-gtt
[117.078602] Starting dynamic subtest: eDP-1
[117.082898] Dynamic subtest eDP-1: SKIP (0.000s)
[117.087218] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[117.143206] [019/131] (901s left) kms_atomic_interruptible (legacy-dpms)
[117.243595] Starting subtest: legacy-dpms
[117.246023] Starting dynamic subtest: pipe-A-eDP-1
[124.722232] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.479s)
[124.724077] Subtest legacy-dpms: SUCCESS (7.479s)
[125.534751] [020/131] (893s left) gem_ctx_isolation (nonpriv)
[125.599567] Starting subtest: nonpriv
[125.601947] Starting dynamic subtest: rcs0
[126.149288] Dynamic subtest rcs0: SUCCESS (0.549s)
[126.156296] Starting dynamic subtest: bcs0
[126.704832] Dynamic subtest bcs0: SUCCESS (0.556s)
[126.715708] Starting dynamic subtest: vcs0
[127.263221] Dynamic subtest vcs0: SUCCESS (0.558s)
[127.272284] Starting dynamic subtest: vcs1
[128.471641] Dynamic subtest vcs1: SUCCESS (1.207s)
[128.481336] Starting dynamic subtest: vecs0
[130.472847] Dynamic subtest vecs0: SUCCESS (2.002s)
[130.479424] Starting dynamic subtest: ccs0
[132.552244] Dynamic subtest ccs0: SUCCESS (2.079s)
[132.554759] Subtest nonpriv: SUCCESS (6.952s)
[132.806926] [021/131] (886s left) gem_userptr_blits (coherency-sync)
[132.877763] Starting subtest: coherency-sync
[133.219769] Subtest coherency-sync: SKIP (0.304s)
[133.336874] [022/131] (885s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[133.500349] Starting subtest: 4-tiled-16bpp-rotate-180
[134.865241] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.366s)
[135.058284] [023/131] (883s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[140.078230] Starting subtest: pr-cursor-plane-update-sf
[140.083130] Subtest pr-cursor-plane-update-sf: SKIP (0.003s)
[140.924949] [024/131] (878s left) kms_dsc (dsc-with-output-formats)
[141.019831] Starting subtest: dsc-with-output-formats
[141.042290] Subtest dsc-with-output-formats: SKIP (0.000s)
[141.085186] [025/131] (877s left) kms_flip (blocking-wf_vblank)
[141.177918] Starting subtest: blocking-wf_vblank
[141.180201] Starting dynamic subtest: A-eDP1
[150.120052] Dynamic subtest A-eDP1: SUCCESS (8.906s)
[150.128899] Starting dynamic subtest: B-eDP1
[159.007092] Dynamic subtest B-eDP1: SUCCESS (8.920s)
[159.015542] Starting dynamic subtest: C-eDP1
[167.965582] Dynamic subtest C-eDP1: SUCCESS (8.912s)
[167.974822] Starting dynamic subtest: D-eDP1
[176.895937] Dynamic subtest D-eDP1: SUCCESS (8.926s)
[176.898486] Subtest blocking-wf_vblank: SUCCESS (35.675s)
[178.063471] [026/131] (840s left) gem_softpin (allocator-nopin)
[178.139930] Starting subtest: allocator-nopin
[178.263722] Subtest allocator-nopin: SUCCESS (0.125s)
[178.377024] [027/131] (840s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[178.493664] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[183.079020] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (4.588s)
[183.238363] [028/131] (835s left) kms_plane_multiple (tiling-4)
[183.329097] Starting subtest: tiling-4
[183.331473] Starting dynamic subtest: pipe-A-eDP-1
[187.038837] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.704s)
[187.045907] Starting dynamic subtest: pipe-B-eDP-1
[191.418059] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.383s)
[191.426310] Starting dynamic subtest: pipe-C-eDP-1
[195.707181] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.285s)
[195.716628] Starting dynamic subtest: pipe-D-eDP-1
[200.002801] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.297s)
[200.005256] Subtest tiling-4: SUCCESS (16.672s)
[200.805019] [029/131] (818s left) api_intel_bb (blit-noreloc-keep-cache)
[200.869670] Starting subtest: blit-noreloc-keep-cache
[200.875774] Subtest blit-noreloc-keep-cache: SUCCESS (0.009s)
[200.963580] [030/131] (818s left) kms_addfb_basic (addfb25-modifier-no-flag)
[201.062282] Starting subtest: addfb25-modifier-no-flag
[201.064590] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[201.175308] [031/131] (818s left) gem_ctx_persistence (legacy-engines-mixed)
[201.255982] Starting subtest: legacy-engines-mixed
[201.258156] Starting dynamic subtest: render
[201.394723] Dynamic subtest render: SUCCESS (0.138s)
[201.404190] Starting dynamic subtest: bsd1
[201.487234] Dynamic subtest bsd1: SUCCESS (0.090s)
[201.497598] Starting dynamic subtest: bsd2
[201.567325] Dynamic subtest bsd2: SUCCESS (0.078s)
[201.576824] Starting dynamic subtest: blt
[201.624639] Dynamic subtest blt: SUCCESS (0.056s)
[201.634158] Starting dynamic subtest: vebox
[201.680335] Dynamic subtest vebox: SUCCESS (0.054s)
[201.682544] Subtest legacy-engines-mixed: SUCCESS (0.425s)
[201.751114] [032/131] (817s left) device_reset (unbind-reset-rebind)
[201.796696] Starting subtest: unbind-reset-rebind
[206.470574] Subtest unbind-reset-rebind: SUCCESS (4.668s)
[206.500035] [033/131] (812s left) kms_plane (plane-panning-top-left)
[206.598352] Starting subtest: plane-panning-top-left
[206.600753] Starting dynamic subtest: pipe-A
[208.277899] Dynamic subtest pipe-A: SUCCESS (1.678s)
[208.287486] Starting dynamic subtest: pipe-B
[210.507962] Dynamic subtest pipe-B: SUCCESS (2.227s)
[210.510374] Subtest plane-panning-top-left: SUCCESS (3.910s)
[211.312477] [034/131] (807s left) gem_eio (wait-10ms)
[211.446088] Starting subtest: wait-10ms
[211.643051] Subtest wait-10ms: SUCCESS (0.197s)
[211.783382] [035/131] (807s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[211.898701] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[211.903171] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[212.006079] [036/131] (807s left) kms_flip (flip-vs-modeset-vs-hang)
[212.101190] Starting subtest: flip-vs-modeset-vs-hang
[212.103446] Starting dynamic subtest: A-eDP1
[215.923300] Dynamic subtest A-eDP1: SUCCESS (3.821s)
[215.931181] Starting dynamic subtest: D-eDP1
[218.919596] Dynamic subtest D-eDP1: SUCCESS (2.994s)
[218.921839] Subtest flip-vs-modeset-vs-hang: SUCCESS (6.819s)
[219.285239] [037/131] (800s left) gem_userptr_blits (vma-merge)
[219.368807] Starting subtest: vma-merge
[219.413602] Subtest vma-merge: SUCCESS (0.045s)
[219.539301] [038/131] (799s left) kms_cursor_crc (cursor-offscreen-512x512)
[219.791759] Starting subtest: cursor-offscreen-512x512
[219.796278] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[219.967541] [039/131] (799s left) kms_psr (psr-cursor-plane-onoff)
[220.074085] Starting subtest: psr-cursor-plane-onoff
[220.076344] Starting dynamic subtest: eDP-1
[221.771427] Dynamic subtest eDP-1: SUCCESS (1.699s)
[221.773765] Subtest psr-cursor-plane-onoff: SUCCESS (1.700s)
[222.629109] [040/131] (796s left) gem_eio (context-create)
[222.782043] Starting subtest: context-create
[222.993058] Subtest context-create: SUCCESS (0.210s)
[223.105251] [041/131] (796s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[223.172328] Subtest writes-after-reads-uncached: SKIP (0.000s)
[223.238078] [042/131] (796s left) kms_vblank (ts-continuation-idle-hang)
[223.350756] Starting subtest: ts-continuation-idle-hang
[223.353072] Starting dynamic subtest: pipe-A-eDP-1
[249.766914] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.413s)
[249.780489] Starting dynamic subtest: pipe-D-eDP-1
[274.677647] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.907s)
[274.679564] Subtest ts-continuation-idle-hang: SUCCESS (51.324s)
[275.489370] [043/131] (744s left) gem_mmap_gtt (basic-small-copy-odd)
[275.554332] Subtest basic-small-copy-odd: SKIP (0.000s)
[275.615357] [044/131] (744s left) gem_exec_fence (syncobj-signal)
[276.076591] Starting subtest: syncobj-signal
[276.081670] Subtest syncobj-signal: SUCCESS (0.005s)
[277.997760] [FACT gem_exec_fence (syncobj-signal)] new: kernel.kmod_is_loaded.vgem: true
[278.001122] [045/131] (741s left) gem_lmem_swapping (smem-oom)
[278.051805] Subtest smem-oom: SKIP (0.000s)
[278.091244] [046/131] (741s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[278.198515] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[282.796839] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (4.599s)
[282.939332] [047/131] (736s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[283.053577] Starting subtest: y-tiled-32bpp-rotate-90
[283.058076] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[283.158582] [048/131] (736s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[283.268595] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[283.272638] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[283.372069] [049/131] (736s left) kms_flip (2x-plain-flip)
[283.473140] Starting subtest: 2x-plain-flip
[283.484929] Subtest 2x-plain-flip: SKIP (0.011s)
[283.561633] [050/131] (736s left) sysfs_heartbeat_interval (invalid)
[283.629585] Starting subtest: invalid
[283.631794] Starting dynamic subtest: vecs0
[283.634065] Dynamic subtest vecs0: SUCCESS (0.000s)
[283.642103] Starting dynamic subtest: ccs0
[283.643941] Dynamic subtest ccs0: SUCCESS (0.000s)
[283.651400] Starting dynamic subtest: vcs0
[283.653244] Dynamic subtest vcs0: SUCCESS (0.000s)
[283.660640] Starting dynamic subtest: bcs0
[283.662539] Dynamic subtest bcs0: SUCCESS (0.000s)
[283.669769] Starting dynamic subtest: rcs0
[283.671688] Dynamic subtest rcs0: SUCCESS (0.000s)
[283.678999] Starting dynamic subtest: vcs1
[283.680906] Dynamic subtest vcs1: SUCCESS (0.000s)
[283.682883] Subtest invalid: SUCCESS (0.005s)
[283.740036] [051/131] (736s left) sysfs_timeslice_duration (idempotent)
[283.794180] Starting subtest: idempotent
[283.795982] Starting dynamic subtest: vecs0
[283.797968] Dynamic subtest vecs0: SUCCESS (0.000s)
[283.805681] Starting dynamic subtest: ccs0
[283.807683] Dynamic subtest ccs0: SUCCESS (0.000s)
[283.815159] Starting dynamic subtest: vcs0
[283.816916] Dynamic subtest vcs0: SUCCESS (0.000s)
[283.824186] Starting dynamic subtest: bcs0
[283.825965] Dynamic subtest bcs0: SUCCESS (0.000s)
[283.832967] Starting dynamic subtest: rcs0
[283.834826] Dynamic subtest rcs0: SUCCESS (0.000s)
[283.842238] Starting dynamic subtest: vcs1
[283.844071] Dynamic subtest vcs1: SUCCESS (0.000s)
[283.845862] Subtest idempotent: SUCCESS (0.005s)
[283.903525] [052/131] (736s left) gem_pread (bench)
[283.952474] Subtest bench: SKIP (0.000s)
[284.011900] [053/131] (735s left) gem_exec_capture (userptr)
[284.076124] Starting subtest: userptr
[284.900943] Subtest userptr: SUCCESS (0.821s)
[284.997932] [054/131] (734s left) kms_cursor_crc (cursor-onscreen-128x42)
[285.203024] Starting subtest: cursor-onscreen-128x42
[285.245431] Subtest cursor-onscreen-128x42: SKIP (0.037s)
[285.452332] [055/131] (734s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[285.558616] Starting subtest: fbc-rgb565-draw-pwrite
[289.240046] Subtest fbc-rgb565-draw-pwrite: SUCCESS (3.685s)
[289.349668] [056/131] (730s left) i915_query (query-topology-known-pci-ids)
[289.420673] Starting subtest: query-topology-known-pci-ids
[289.425262] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[289.529659] [057/131] (730s left) gem_set_tiling_vs_gtt
[289.642622] [058/131] (730s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[289.742232] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[289.746226] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[289.853053] [059/131] (730s left) gem_pipe_control_store_loop (fresh-buffer)
[289.918490] Starting subtest: fresh-buffer
[292.072071] Subtest fresh-buffer: SUCCESS (2.152s)
[292.201009] [060/131] (727s left) kms_hdr (bpc-switch-suspend)
[292.300632] Starting subtest: bpc-switch-suspend
[293.333902] Starting dynamic subtest: pipe-A-eDP-1
[312.561689] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.572s)
[312.564559] Subtest bpc-switch-suspend: SUCCESS (5.608s)
[312.690118] [061/131] (722s left) kms_vblank (wait-forked-hang)
[312.786359] Starting subtest: wait-forked-hang
[312.788828] Starting dynamic subtest: pipe-A-eDP-1
[339.359497] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.553s)
[339.376347] Starting dynamic subtest: pipe-D-eDP-1
[364.383568] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.017s)
[364.385949] Subtest wait-forked-hang: SUCCESS (51.574s)
[365.171202] [062/131] (669s left) perf (gen8-unprivileged-single-ctx-counters)
[365.302401] Starting subtest: gen8-unprivileged-single-ctx-counters
[365.306203] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[365.339178] [063/131] (669s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[365.459408] Starting subtest: 4-tiled-addfb-size-offset-overflow
[365.461834] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[365.544905] [064/131] (669s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[365.660148] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[365.665256] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[365.770139] [065/131] (669s left) gem_exec_schedule (lateslice)
[365.848497] Starting subtest: lateslice
[365.851134] Starting dynamic subtest: rcs0
[365.861655] Dynamic subtest rcs0: SUCCESS (0.025s)
[365.872335] Starting dynamic subtest: bcs0
[365.878422] Dynamic subtest bcs0: SUCCESS (0.016s)
[365.888187] Starting dynamic subtest: vcs0
[365.896346] Dynamic subtest vcs0: SUCCESS (0.018s)
[365.905883] Starting dynamic subtest: vcs1
[365.915338] Dynamic subtest vcs1: SUCCESS (0.018s)
[365.925455] Starting dynamic subtest: vecs0
[365.934064] Dynamic subtest vecs0: SUCCESS (0.018s)
[365.944983] Starting dynamic subtest: ccs0
[365.950976] Dynamic subtest ccs0: SUCCESS (0.015s)
[365.953175] Subtest lateslice: SUCCESS (0.113s)
[367.699454] [066/131] (667s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[367.810366] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[371.307838] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (3.503s)
[371.441049] [067/131] (663s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[371.504032] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[371.506473] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[371.618433] [068/131] (663s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[371.731430] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[371.735464] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[371.842589] [069/131] (663s left) syncobj_wait (reset-unsignaled)
[371.899930] Starting subtest: reset-unsignaled
[371.902531] Subtest reset-unsignaled: SUCCESS (0.000s)
[371.991956] [070/131] (663s left) kms_psr (fbc-psr-cursor-plane-move)
[372.082738] Starting subtest: fbc-psr-cursor-plane-move
[372.084969] Starting dynamic subtest: eDP-1
[372.089468] Dynamic subtest eDP-1: SKIP (0.000s)
[372.094325] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[372.151434] [071/131] (663s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[372.254259] Starting subtest: disable-crc-after-crtc
[372.256396] Starting dynamic subtest: pipe-A-eDP-1
[373.917408] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.659s)
[373.926480] Starting dynamic subtest: pipe-B-eDP-1
[376.176829] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.259s)
[376.186843] Starting dynamic subtest: pipe-C-eDP-1
[378.433222] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.255s)
[378.442798] Starting dynamic subtest: pipe-D-eDP-1
[380.690939] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.256s)
[380.693375] Subtest disable-crc-after-crtc: SUCCESS (8.435s)
[381.523060] [072/131] (653s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[381.630560] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[384.998513] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (3.371s)
[385.143747] [073/131] (650s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[385.251686] Starting subtest: fbc-psr-sprite-mmap-cpu
[385.254095] Starting dynamic subtest: eDP-1
[385.258592] Dynamic subtest eDP-1: SKIP (0.000s)
[385.263103] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.002s)
[385.320391] [074/131] (650s left) gem_spin_batch (resubmit)
[385.382388] Starting subtest: resubmit
[385.384487] Starting dynamic subtest: rcs0
[385.389228] Dynamic subtest rcs0: SUCCESS (0.007s)
[385.398415] Starting dynamic subtest: bcs0
[385.400847] Dynamic subtest bcs0: SUCCESS (0.003s)
[385.409947] Starting dynamic subtest: vcs0
[385.412376] Dynamic subtest vcs0: SUCCESS (0.003s)
[385.420689] Starting dynamic subtest: vcs1
[385.423236] Dynamic subtest vcs1: SUCCESS (0.003s)
[385.431624] Starting dynamic subtest: vecs0
[385.434270] Dynamic subtest vecs0: SUCCESS (0.002s)
[385.442554] Starting dynamic subtest: ccs0
[385.445401] Dynamic subtest ccs0: SUCCESS (0.003s)
[385.447671] Subtest resubmit: SUCCESS (0.023s)
[385.645956] [075/131] (649s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[385.742842] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[385.745250] Starting dynamic subtest: pipe-A-eDP-1
[386.164315] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.394s)
[386.172525] Starting dynamic subtest: pipe-B-eDP-1
[387.548408] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.375s)
[387.558596] Starting dynamic subtest: pipe-C-eDP-1
[388.948207] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.398s)
[388.958282] Starting dynamic subtest: pipe-D-eDP-1
[390.272486] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[390.274688] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.498s)
[391.460241] [076/131] (643s left) core_setmaster (master-drop-set-root)
[393.740736] Starting subtest: master-drop-set-root
[393.753744] Subtest master-drop-set-root: SUCCESS (0.013s)
[393.792724] [FACT core_setmaster (master-drop-set-root)] new: kernel.kmod_is_loaded.amdgpu: true
[393.793380] [FACT core_setmaster (master-drop-set-root)] new: kernel.kmod_is_loaded.xe: true
[393.796529] [077/131] (641s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[398.817568] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[398.820527] Starting dynamic subtest: pipe-A-eDP-1
[405.426568] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.606s)
[405.438123] Starting dynamic subtest: pipe-B-eDP-1
[412.042883] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.614s)
[412.045307] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.224s)
[412.910191] [078/131] (622s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[413.025526] Starting subtest: yf-tiled-8bpp-rotate-90
[413.030510] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[413.141419] [079/131] (622s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[413.268695] Starting subtest: basic-flip-before-cursor-legacy
[414.185991] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.917s)
[415.037844] [080/131] (620s left) gem_ctx_param (invalid-param-get)
[415.094070] Starting subtest: invalid-param-get
[415.096680] Subtest invalid-param-get: SUCCESS (0.001s)
[415.189578] [081/131] (620s left) kms_plane_scaling (2x-scaler-multi-pipe)
[415.285184] Starting subtest: 2x-scaler-multi-pipe
[415.290696] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[415.376659] [082/131] (620s left) kms_joiner (basic-force-big-joiner)
[415.480593] Starting subtest: basic-force-big-joiner
[415.483024] Starting dynamic subtest: single
[418.772934] Dynamic subtest single: SUCCESS (3.302s)
[418.775690] Subtest basic-force-big-joiner: SUCCESS (3.303s)
[419.933219] [083/131] (615s left) gem_exec_schedule (preempt-queue)
[420.011722] Subtest preempt-queue: SKIP (0.000s)
[420.296803] [084/131] (615s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[420.406274] Starting subtest: fbc-rgb565-draw-render
[423.636268] Subtest fbc-rgb565-draw-render: SUCCESS (3.235s)
[423.770900] [085/131] (611s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[423.880354] Starting subtest: fbc-2p-pri-indfb-multidraw
[423.884363] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[423.982165] [086/131] (611s left) kms_prop_blob (invalid-set-prop-any)
[424.048337] Starting subtest: invalid-set-prop-any
[424.050674] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[424.166864] [087/131] (611s left) kms_chamelium_color (ctm-max)
[424.265981] Subtest ctm-max: SKIP (0.000s)
[424.306727] [088/131] (611s left) kms_cdclk (mode-transition-all-outputs)
[424.406271] Starting subtest: mode-transition-all-outputs
[424.692146] Subtest mode-transition-all-outputs: SKIP (0.284s)
[425.486078] [089/131] (610s left) gem_exec_schedule (u-fairslice-all)
[425.564218] Starting subtest: u-fairslice-all
[427.669387] Subtest u-fairslice-all: SUCCESS (2.069s)
[429.649323] [090/131] (606s left) i915_pm_rpm (gem-idle)
[431.798736] Starting subtest: gem-idle
[438.013249] Subtest gem-idle: SUCCESS (6.200s)
[438.310054] [091/131] (597s left) gem_compute (compute-square)
[439.562585] Starting subtest: compute-square
[439.686481] Subtest compute-square: FAIL (0.028s)
[439.721971] [092/131] (596s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[439.818898] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[439.821420] Starting dynamic subtest: pipe-A-eDP-1
[439.845087] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[439.855715] Starting dynamic subtest: pipe-B-eDP-1
[439.876725] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[439.885061] Starting dynamic subtest: pipe-C-eDP-1
[439.905655] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[439.914214] Starting dynamic subtest: pipe-D-eDP-1
[439.934313] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[439.936693] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.009s)
[441.963036] [093/131] (594s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[442.065619] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[442.071170] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[442.142311] [094/131] (593s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[442.262259] Starting subtest: short-busy-flip-before-cursor-toggle
[442.267209] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[442.355356] [095/131] (593s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-wc)
[442.470933] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-wc
[445.582700] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (3.115s)
[445.705563] [096/131] (590s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[445.804372] Starting subtest: psr-rgb101010-draw-pwrite
[451.506187] Subtest psr-rgb101010-draw-pwrite: SUCCESS (5.705s)
[451.605520] [097/131] (584s left) kms_selftest (drm_plane_helper)
[451.650224] Starting subtest: drm_plane_helper
[451.670094] Starting dynamic subtest: drm_test_check_plane_state
[451.813695] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.144s)
[451.823297] Starting dynamic subtest: drm_test_check_invalid_plane_state
[451.963948] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.150s)
[451.966580] Subtest drm_plane_helper: SUCCESS (0.313s)
[452.095565] [098/131] (584s left) i915_pm_rpm (gem-evict-pwrite)
[453.732554] Starting subtest: gem-evict-pwrite
[453.738672] Subtest gem-evict-pwrite: SKIP (0.000s)
[454.360058] [099/131] (581s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[454.463140] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[454.465670] Starting dynamic subtest: pipe-A-default-mode
[454.776667] Dynamic subtest pipe-A-default-mode: SKIP (0.310s)
[454.781981] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.311s)
[455.577547] [100/131] (580s left) kms_async_flips (alternate-sync-async-flip-atomic)
[455.683322] Starting subtest: alternate-sync-async-flip-atomic
[456.045212] Starting dynamic subtest: pipe-A-eDP-1
[458.866269] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.824s)
[459.250677] Starting dynamic subtest: pipe-B-eDP-1
[461.996087] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.759s)
[462.358718] Starting dynamic subtest: pipe-C-eDP-1
[465.117598] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.767s)
[465.483117] Starting dynamic subtest: pipe-D-eDP-1
[468.240512] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.765s)
[468.243090] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.557s)
[469.399572] [101/131] (566s left) gem_exec_reloc (basic-wc)
[469.478689] Subtest basic-wc: SKIP (0.000s)
[469.550034] [102/131] (566s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[469.658288] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[469.660699] Starting dynamic subtest: pipe-A-default-mode
[469.943430] Dynamic subtest pipe-A-default-mode: SKIP (0.282s)
[469.948832] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.283s)
[470.719049] [103/131] (565s left) gem_mmap_gtt (basic-short)
[470.783528] Subtest basic-short: SKIP (0.000s)
[470.855356] [104/131] (565s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[470.967066] Starting subtest: fbcpsr-rgb101010-draw-blt
[475.649241] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (4.686s)
[475.748840] [105/131] (560s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[475.861606] Starting subtest: x-tiled-16bpp-rotate-180
[477.350715] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.489s)
[477.522454] [106/131] (559s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[477.623835] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[477.626592] Starting dynamic subtest: pipe-A
[477.704861] Dynamic subtest pipe-A: SUCCESS (0.084s)
[477.714557] Starting dynamic subtest: pipe-B
[478.898945] Dynamic subtest pipe-B: SUCCESS (1.193s)
[478.909154] Starting dynamic subtest: pipe-C
[480.005945] Dynamic subtest pipe-C: SUCCESS (1.106s)
[480.015187] Starting dynamic subtest: pipe-D
[481.128370] Dynamic subtest pipe-D: SUCCESS (1.121s)
[481.131126] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.507s)
[482.277491] [107/131] (554s left) gen9_exec_parse (batch-invalid-length)
[482.343554] Subtest batch-invalid-length: SKIP (0.000s)
[482.423952] [108/131] (554s left) gem_reg_read (timestamp-moving)
[482.490466] Starting subtest: timestamp-moving
[483.490527] Subtest timestamp-moving: SUCCESS (1.001s)
[483.564147] [109/131] (553s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[483.685436] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[485.021540] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.336s)
[485.826069] [110/131] (550s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[485.891676] Starting subtest: invalid-single-wait-all-unsubmitted
[485.894060] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[485.974029] [111/131] (550s left) kms_chamelium_hpd (dp-hpd-fast)
[486.355267] Subtest dp-hpd-fast: SKIP (0.000s)
[487.129547] [112/131] (549s left) kms_busy (extended-pageflip-hang-oldfb)
[487.229377] Starting subtest: extended-pageflip-hang-oldfb
[487.231814] Starting dynamic subtest: pipe-A
[487.683559] Dynamic subtest pipe-A: SUCCESS (0.450s)
[487.698658] Starting dynamic subtest: pipe-D
[488.774486] Dynamic subtest pipe-D: SUCCESS (1.086s)
[488.777281] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.541s)
[489.604123] [113/131] (547s left) kms_pm_lpsp (kms-lpsp)
[490.712178] Starting subtest: kms-lpsp
[490.714201] Starting dynamic subtest: pipe-A-eDP-1
[490.876566] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.166s)
[491.163420] Subtest kms-lpsp: SUCCESS (0.451s)
[492.030616] [114/131] (544s left) gem_exec_capture (capture-invisible)
[492.087966] Starting subtest: capture-invisible
[492.090620] Starting dynamic subtest: smem0
[492.096421] Dynamic subtest smem0: SKIP (0.000s)
[492.101697] Subtest capture-invisible: SKIP (0.001s)
[492.180433] [115/131] (544s left) perf (per-context-mode-unprivileged)
[492.273183] Starting subtest: per-context-mode-unprivileged
[492.278491] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[492.312870] [116/131] (544s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[492.374304] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[492.432625] [117/131] (544s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[492.551439] Starting subtest: x-tiled-8bpp-rotate-270
[492.572472] Subtest x-tiled-8bpp-rotate-270: SKIP (0.021s)
[492.688092] [118/131] (544s left) syncobj_wait (single-wait-submitted)
[492.743561] Starting subtest: single-wait-submitted
[492.843758] Subtest single-wait-submitted: SUCCESS (0.102s)
[492.920711] [119/131] (544s left) gem_mmap_wc (write-read)
[492.986174] Subtest write-read: SKIP (0.000s)
[493.048375] [120/131] (544s left) prime_busy (before-wait)
[493.119778] Starting subtest: before-wait
[493.124978] Starting dynamic subtest: rcs0
[493.172959] Dynamic subtest rcs0: SUCCESS (0.049s)
[493.183444] Starting dynamic subtest: bcs0
[493.236360] Dynamic subtest bcs0: SUCCESS (0.063s)
[493.246326] Starting dynamic subtest: vcs0
[493.279216] Dynamic subtest vcs0: SUCCESS (0.042s)
[493.288699] Starting dynamic subtest: vcs1
[493.320967] Dynamic subtest vcs1: SUCCESS (0.041s)
[493.331414] Starting dynamic subtest: vecs0
[493.362318] Dynamic subtest vecs0: SUCCESS (0.041s)
[493.370985] Starting dynamic subtest: ccs0
[493.402562] Dynamic subtest ccs0: SUCCESS (0.040s)
[493.512293] Subtest before-wait: SUCCESS (0.392s)
[493.580237] [121/131] (543s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[493.646942] Starting subtest: yf-tiled-to-vebox-yf-tiled
[493.652595] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[493.832277] [122/131] (543s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[493.902691] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[494.003827] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s)
[494.102481] [123/131] (543s left) gem_exec_balancer (nop)
[494.172087] Starting subtest: nop
[540.812104] Subtest nop: SUCCESS (46.635s)
[541.117970] [124/131] (496s left) gem_ctx_param (basic-default)
[541.174892] Starting subtest: basic-default
[541.178103] Subtest basic-default: SUCCESS (0.000s)
[541.246482] [125/131] (496s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[541.304955] Starting subtest: etime-single-wait-for-submit-unsubmitted
[541.412173] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[541.481762] [126/131] (495s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[541.549846] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[541.639947] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.005s)
[541.674733] [127/131] (495s left) gem_basic (create-close)
[541.738056] Starting subtest: create-close
[541.743001] Subtest create-close: SUCCESS (0.000s)
[541.857059] [128/131] (495s left) gem_exec_whisper (basic-sync-all)
[541.937159] Starting subtest: basic-sync-all
[550.074654] Subtest basic-sync-all: SUCCESS (8.135s)
[550.256149] [129/131] (487s left) syncobj_timeline (multi-wait-for-submit-signaled)
[550.321261] Starting subtest: multi-wait-for-submit-signaled
[550.323918] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[550.442361] [130/131] (487s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[550.553545] Starting subtest: y-tiled-addfb-size-offset-overflow
[550.558537] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[550.659882] [131/131] (486s left) kms_cursor_crc (cursor-sliding-512x170)
[550.937167] Starting subtest: cursor-sliding-512x170
[550.941093] Subtest cursor-sliding-512x170: SKIP (0.001s)
[551.081834] Closing watchdogs
Done.