[57.900836] Initializing watchdogs
[57.900880]   /dev/watchdog0
[57.914282] [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.918568] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.920893] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.924228] [001/132] (960s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[58.073040] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[58.077497] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[58.240302] [002/132] (960s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[58.291675] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[58.343568] [003/132] (960s left) kms_prime (basic-crc-hybrid)
[58.424378] Subtest basic-crc-hybrid: SKIP (0.000s)
[58.549516] [FACT kms_prime (basic-crc-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[58.552382] [004/132] (959s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[58.603602] Starting subtest: single-wait-all-for-submit-signaled
[58.605757] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[58.718012] [005/132] (959s left) gem_ctx_isolation (dirty-create)
[58.776341] Starting subtest: dirty-create
[58.778321] Starting dynamic subtest: rcs0
[58.944347] Dynamic subtest rcs0: SUCCESS (0.169s)
[58.953752] Starting dynamic subtest: bcs0
[59.109087] Dynamic subtest bcs0: SUCCESS (0.165s)
[59.117889] Starting dynamic subtest: vcs0
[59.334302] Dynamic subtest vcs0: SUCCESS (0.227s)
[59.343719] Starting dynamic subtest: vcs1
[61.108556] Dynamic subtest vcs1: SUCCESS (1.785s)
[61.118898] Starting dynamic subtest: vecs0
[63.162803] Dynamic subtest vecs0: SUCCESS (2.064s)
[63.170515] Starting dynamic subtest: ccs0
[65.140985] Dynamic subtest ccs0: SUCCESS (1.986s)
[65.143509] Subtest dirty-create: SUCCESS (6.398s)
[65.414200] [006/132] (953s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[65.509118] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[65.511492] Starting dynamic subtest: pipe-A-default-mode
[66.698895] Dynamic subtest pipe-A-default-mode: SKIP (1.187s)
[66.703608] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.188s)
[66.948819] [007/132] (951s left) kms_cursor_edge_walk (128x128-top-edge)
[67.340377] Starting subtest: 128x128-top-edge
[67.342482] Starting dynamic subtest: pipe-A-eDP-1
[70.815722] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.483s)
[70.824083] Starting dynamic subtest: pipe-D-eDP-1
[73.918401] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.106s)
[73.920800] Subtest 128x128-top-edge: SUCCESS (6.591s)
[74.753481] [008/132] (943s left) gem_exec_flush (basic-wb-prw-default)
[74.820579] Starting subtest: basic-wb-prw-default
[80.276389] Subtest basic-wb-prw-default: SUCCESS (5.458s)
[80.486321] [009/132] (938s left) kms_getfb (getfb2-accept-nv12)
[80.587996] Starting subtest: getfb2-accept-nv12
[80.590698] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[80.724277] [010/132] (938s left) gem_softpin (invalid)
[80.786030] Starting subtest: invalid
[80.793537] Subtest invalid: SUCCESS (0.006s)
[80.940354] [011/132] (937s left) gem_userptr_blits (readonly-unsync)
[81.007339] Subtest readonly-unsync: SKIP (0.000s)
[81.147735] [012/132] (937s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[81.247602] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[81.251715] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[81.387637] [013/132] (937s left) gem_lmem_swapping (smem-oom)
[81.429910] Subtest smem-oom: SKIP (0.000s)
[81.465717] [014/132] (937s left) syncobj_eventfd (binary-wait-before-signal)
[81.522054] Starting subtest: binary-wait-before-signal
[81.552939] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[81.647510] [015/132] (937s left) gem_mmap_offset (partial-unmap)
[81.713172] Starting subtest: partial-unmap
[81.715237] Starting dynamic subtest: smem0
[82.220425] Dynamic subtest smem0: SUCCESS (0.505s)
[82.223067] Subtest partial-unmap: SUCCESS (0.505s)
[82.377379] [016/132] (936s left) kms_color_pipeline (plane-lut3d-green-only)
[82.472278] Starting subtest: plane-lut3d-green-only
[82.484794] Starting dynamic subtest: pipe-A-eDP-1
[82.489504] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[83.523714] Starting dynamic subtest: pipe-B-eDP-1
[83.528196] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[84.558154] Starting dynamic subtest: pipe-C-eDP-1
[84.562750] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[85.596107] Starting dynamic subtest: pipe-D-eDP-1
[85.600815] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[85.886597] Subtest plane-lut3d-green-only: SKIP (3.412s)
[86.700779] [017/132] (932s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[86.809890] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[86.812124] Starting dynamic subtest: pipe-A-eDP-1
[86.832117] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[86.843097] Starting dynamic subtest: pipe-B-eDP-1
[86.863366] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[86.872739] Starting dynamic subtest: pipe-C-eDP-1
[86.891924] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[86.900328] Starting dynamic subtest: pipe-D-eDP-1
[86.919415] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[86.921625] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[89.069619] [018/132] (930s left) kms_plane_lowres (tiling-y)
[89.158810] Starting subtest: tiling-y
[89.163292] Subtest tiling-y: SKIP (0.000s)
[89.251412] [019/132] (929s left) i915_query (engine-info)
[89.307885] Starting subtest: engine-info
[89.312606] Subtest engine-info: SUCCESS (0.006s)
[89.440076] [020/132] (929s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[94.452053] Starting subtest: pr-cursor-plane-move-continuous-sf
[94.456651] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.003s)
[95.317153] [021/132] (923s left) kms_chamelium_color (ctm-green-to-red)
[95.423552] Subtest ctm-green-to-red: SKIP (0.000s)
[95.470247] [022/132] (923s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[95.552143] Starting subtest: plane-upscale-20x20-with-rotation
[95.554512] Starting dynamic subtest: pipe-A
[95.778988] Dynamic subtest pipe-A: SUCCESS (0.226s)
[95.790408] Starting dynamic subtest: pipe-B
[97.070910] Dynamic subtest pipe-B: SUCCESS (1.291s)
[97.079974] Starting dynamic subtest: pipe-C
[98.406959] Dynamic subtest pipe-C: SUCCESS (1.336s)
[98.416109] Starting dynamic subtest: pipe-D
[99.748598] Dynamic subtest pipe-D: SUCCESS (1.341s)
[99.750942] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.197s)
[100.944122] [023/132] (918s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[101.008840] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[101.088018] [024/132] (918s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[101.193553] Starting subtest: 4-tiled-16bpp-rotate-270
[101.213283] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[101.371128] [025/132] (917s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[101.487984] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[101.492120] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[101.601211] [026/132] (917s left) gem_eio (banned)
[101.826620] Starting subtest: banned
[102.470231] Subtest banned: SUCCESS (0.646s)
[102.653485] [027/132] (916s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[102.754661] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[102.757973] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[102.889196] [028/132] (916s left) gem_flink_race (flink_close)
[102.920986] Starting subtest: flink_close
[108.038664] Subtest flink_close: SUCCESS (5.116s)
[108.139248] [029/132] (911s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[108.252723] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[108.256695] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[108.379853] [030/132] (911s left) gem_exec_balancer (parallel-keep-submit-fence)
[108.659976] Starting subtest: parallel-keep-submit-fence
[109.935992] Subtest parallel-keep-submit-fence: SUCCESS (1.276s)
[110.076425] [031/132] (909s left) kms_cursor_crc (cursor-onscreen-512x170)
[110.386538] Starting subtest: cursor-onscreen-512x170
[110.390920] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[110.569804] [032/132] (909s left) gem_ringfill (engines-basic)
[115.929460] Starting subtest: engines-basic
[115.932075] Starting dynamic subtest: rcs0
[116.008330] Dynamic subtest rcs0: SUCCESS (0.080s)
[116.019267] Starting dynamic subtest: bcs0
[116.052204] Dynamic subtest bcs0: SUCCESS (0.043s)
[116.062246] Starting dynamic subtest: vcs0
[116.095064] Dynamic subtest vcs0: SUCCESS (0.042s)
[116.104745] Starting dynamic subtest: vcs1
[116.137205] Dynamic subtest vcs1: SUCCESS (0.041s)
[116.146797] Starting dynamic subtest: vecs0
[116.179125] Dynamic subtest vecs0: SUCCESS (0.041s)
[116.192321] Starting dynamic subtest: ccs0
[116.222223] Dynamic subtest ccs0: SUCCESS (0.042s)
[116.225253] Subtest engines-basic: SUCCESS (0.295s)
[116.321729] [033/132] (903s left) perf (buffer-fill)
[116.454316] Starting subtest: buffer-fill
[116.456136] Starting dynamic subtest: 0-rcs0
[118.723356] Dynamic subtest 0-rcs0: SUCCESS (2.268s)
[118.731759] Starting dynamic subtest: 1-vecs0
[123.153746] Dynamic subtest 1-vecs0: SUCCESS (4.430s)
[123.156315] Subtest buffer-fill: SUCCESS (6.699s)
[123.202183] [034/132] (896s left) gem_linear_blits (basic)
[123.475148] Starting subtest: basic
[123.492320] Subtest basic: SUCCESS (0.017s)
[123.670195] [035/132] (896s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[123.803655] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[124.179049] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[126.995265] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.816s)
[127.004208] Starting dynamic subtest: pipe-A-eDP-1-4
[129.170884] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.175s)
[129.182244] Starting dynamic subtest: pipe-A-eDP-1-4
[131.181869] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.010s)
[131.193236] Starting dynamic subtest: pipe-A-eDP-1-x
[133.358911] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[133.724348] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[136.524028] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.806s)
[136.535293] Starting dynamic subtest: pipe-B-eDP-1-4
[138.710461] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.186s)
[138.719254] Starting dynamic subtest: pipe-B-eDP-1-4
[140.720835] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[140.731979] Starting dynamic subtest: pipe-B-eDP-1-x
[142.910213] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[143.274846] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[146.047963] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.778s)
[146.058938] Starting dynamic subtest: pipe-C-eDP-1-4
[148.223486] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.175s)
[148.234272] Starting dynamic subtest: pipe-C-eDP-1-4
[150.233436] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[150.244186] Starting dynamic subtest: pipe-C-eDP-1-x
[152.412451] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[152.777834] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[155.575872] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.807s)
[155.587485] Starting dynamic subtest: pipe-D-eDP-1-4
[157.751089] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.175s)
[157.762303] Starting dynamic subtest: pipe-D-eDP-1-4
[159.761819] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[159.774621] Starting dynamic subtest: pipe-D-eDP-1-x
[161.939937] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[161.942523] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.135s)
[163.189717] [036/132] (856s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[163.299032] Starting subtest: fbc-dirtyfb-ioctl
[163.301415] Starting dynamic subtest: A-eDP-1
[165.930736] Dynamic subtest A-eDP-1: SUCCESS (2.633s)
[165.933104] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.634s)
[166.764238] [037/132] (853s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[166.871820] Starting subtest: y-tiled-32bpp-rotate-180
[166.875966] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[167.000152] [038/132] (852s left) gem_ctx_param (root-set)
[167.058721] Starting subtest: root-set
[167.061078] Subtest root-set: SUCCESS (0.001s)
[167.172361] [039/132] (852s left) gem_exec_fence (basic-wait-all)
[167.247041] Starting subtest: basic-wait-all
[167.347707] Subtest basic-wait-all: SUCCESS (0.102s)
[169.020167] [040/132] (850s left) gem_lmem_swapping (heavy-random)
[169.072126] Subtest heavy-random: SKIP (0.000s)
[169.119874] [041/132] (850s left) kms_psr (fbc-pr-primary-blt)
[169.215355] Starting subtest: fbc-pr-primary-blt
[169.219747] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[169.313253] [042/132] (850s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[169.413598] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[169.417957] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[169.553771] [043/132] (850s left) kms_content_protection (type1)
[169.712258] Starting subtest: type1
[169.716843] Subtest type1: SKIP (0.000s)
[169.861013] [044/132] (850s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[172.123252] Starting subtest: gem-execbuf-stress-pc8
[172.165656] Subtest gem-execbuf-stress-pc8: SKIP (0.041s)
[172.522593] [045/132] (847s left) kms_plane_alpha_blend (alpha-transparent-fb)
[172.629637] Starting subtest: alpha-transparent-fb
[172.908327] Starting dynamic subtest: pipe-A-eDP-1
[173.535824] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.624s)
[173.545272] Starting dynamic subtest: pipe-D-eDP-1
[174.881488] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.345s)
[174.883890] Subtest alpha-transparent-fb: SUCCESS (2.254s)
[175.707137] [046/132] (844s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[175.769395] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[175.873434] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.104s)
[175.975258] [047/132] (844s left) gem_mmap_wc (bad-offset)
[176.043612] Subtest bad-offset: SKIP (0.000s)
[176.109569] [048/132] (844s left) gem_mmap_wc (write-gtt-read-wc)
[176.173616] Subtest write-gtt-read-wc: SKIP (0.000s)
[176.231497] [049/132] (844s left) vgem_basic (dmabuf-fence)
[176.276257] Starting subtest: dmabuf-fence
[176.278357] Subtest dmabuf-fence: SUCCESS (0.000s)
[176.359096] [050/132] (844s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[176.457575] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[177.125940] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.670s)
[177.346269] [051/132] (843s left) dmabuf_sync_file (export-wait-after-attach)
[177.394857] Starting subtest: export-wait-after-attach
[177.397062] Subtest export-wait-after-attach: SUCCESS (0.001s)
[177.475290] [052/132] (842s left) gem_exec_reloc (basic-concurrent0)
[177.543624] Subtest basic-concurrent0: SKIP (0.000s)
[177.626878] [053/132] (842s left) perf_pmu (busy-hang)
[177.675049] Starting subtest: busy-hang
[177.677274] Starting dynamic subtest: rcs0
[178.984594] Dynamic subtest rcs0: SUCCESS (1.306s)
[178.995490] Starting dynamic subtest: bcs0
[180.226174] Dynamic subtest bcs0: SUCCESS (1.242s)
[180.236832] Starting dynamic subtest: vcs0
[182.432612] Dynamic subtest vcs0: SUCCESS (2.202s)
[182.443573] Starting dynamic subtest: vcs1
[184.411523] Dynamic subtest vcs1: SUCCESS (1.979s)
[184.420848] Starting dynamic subtest: vecs0
[186.396216] Dynamic subtest vecs0: SUCCESS (1.983s)
[186.405676] Starting dynamic subtest: ccs0
[187.646220] Dynamic subtest ccs0: SUCCESS (1.249s)
[187.648799] Subtest busy-hang: SUCCESS (9.971s)
[187.790169] [054/132] (832s left) kms_psr (pr-suspend)
[187.898500] Starting subtest: pr-suspend
[187.902670] Subtest pr-suspend: SKIP (0.000s)
[187.993272] [055/132] (832s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[188.253381] Starting subtest: cursor-rapid-movement-256x85
[188.300858] Subtest cursor-rapid-movement-256x85: SKIP (0.041s)
[188.543398] [056/132] (832s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[193.573627] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[193.576132] Starting dynamic subtest: pipe-A-eDP-1
[200.199183] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.622s)
[200.209130] Starting dynamic subtest: pipe-B-eDP-1
[206.851049] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.650s)
[206.853348] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (13.277s)
[207.732516] [057/132] (812s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[207.862899] Starting subtest: cursorA-vs-flipA-toggle
[218.997735] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.133s)
[219.882914] [058/132] (800s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[219.984113] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[219.986409] Starting dynamic subtest: pipe-A-eDP-1
[220.009618] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[220.021051] Starting dynamic subtest: pipe-B-eDP-1
[220.042516] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[220.050589] Starting dynamic subtest: pipe-C-eDP-1
[220.072208] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[220.080221] Starting dynamic subtest: pipe-D-eDP-1
[220.102279] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[220.106610] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[222.160465] [059/132] (798s left) gem_ccs (ctrl-surf-copy-new-ctx)
[222.229087] Starting subtest: ctrl-surf-copy-new-ctx
[222.233656] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[222.372969] [060/132] (798s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[222.477411] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[229.380858] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.905s)
[229.555607] [061/132] (791s left) gem_exec_reloc (basic-softpin)
[229.620717] Subtest basic-softpin: SKIP (0.000s)
[229.711080] [062/132] (791s left) kms_vblank (query-idle-hang)
[229.809911] Starting subtest: query-idle-hang
[229.812154] Starting dynamic subtest: pipe-A-eDP-1
[256.675180] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.864s)
[256.690573] Starting dynamic subtest: pipe-D-eDP-1
[271.651520] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.974s)
[271.653993] Subtest query-idle-hang: SUCCESS (41.843s)
[272.536732] [063/132] (748s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[272.910480] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[273.718236] [064/132] (747s left) gem_exec_balancer (hang)
[273.969102] Starting subtest: hang
[275.953279] Subtest hang: SUCCESS (1.988s)
[276.117427] [065/132] (744s left) gem_mmap_gtt (basic-small-bo)
[276.187183] Subtest basic-small-bo: SKIP (0.000s)
[276.247876] [066/132] (744s left) kms_plane_scaling (planes-downscale-factor-0-5)
[276.350890] Starting subtest: planes-downscale-factor-0-5
[276.353197] Starting dynamic subtest: pipe-A
[276.372941] Dynamic subtest pipe-A: SKIP (0.018s)
[276.382737] Starting dynamic subtest: pipe-B
[276.402879] Dynamic subtest pipe-B: SKIP (0.030s)
[276.412229] Starting dynamic subtest: pipe-C
[276.432239] Dynamic subtest pipe-C: SKIP (0.030s)
[276.441153] Starting dynamic subtest: pipe-D
[276.463360] Dynamic subtest pipe-D: SKIP (0.029s)
[276.467167] Subtest planes-downscale-factor-0-5: SKIP (0.110s)
[276.592041] [067/132] (744s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[276.694061] Starting subtest: fbcpsr-rgb565-draw-blt
[283.676138] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (6.984s)
[283.845536] [068/132] (737s left) kms_selftest (drm_cmdline_parser)
[283.883144] Starting subtest: drm_cmdline_parser
[283.916805] Starting dynamic subtest: drm_test_cmdline_force_d_only
[284.071489] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.152s)
[284.080064] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[284.176334] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.106s)
[284.185180] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[284.319939] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.139s)
[284.328771] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[284.470057] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.149s)
[284.478410] Starting dynamic subtest: drm_test_cmdline_force_e_only
[284.613070] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.143s)
[284.621777] Starting dynamic subtest: drm_test_cmdline_res
[284.760019] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.145s)
[284.768944] Starting dynamic subtest: drm_test_cmdline_res_vesa
[284.901632] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.142s)
[284.910130] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[285.044842] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.142s)
[285.053662] Starting dynamic subtest: drm_test_cmdline_res_rblank
[285.159354] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.113s)
[285.168153] Starting dynamic subtest: drm_test_cmdline_res_bpp
[285.300480] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.141s)
[285.308927] Starting dynamic subtest: drm_test_cmdline_res_refresh
[285.399809] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.099s)
[285.408234] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[285.527373] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.127s)
[285.535579] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[285.636528] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.110s)
[285.646059] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[285.790582] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.151s)
[285.800940] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[285.925215] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.135s)
[285.933446] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[286.062331] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.135s)
[286.072148] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[286.205308] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.142s)
[286.216044] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[286.328783] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.126s)
[286.337409] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[286.462831] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.131s)
[286.472155] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[286.613192] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.149s)
[286.623226] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[286.720560] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.108s)
[286.728694] Starting dynamic subtest: drm_test_cmdline_name
[286.859478] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.136s)
[286.868886] Starting dynamic subtest: drm_test_cmdline_name_bpp
[286.973390] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.115s)
[286.981608] Starting dynamic subtest: drm_test_cmdline_name_option
[287.063481] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.089s)
[287.073115] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[287.163413] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.100s)
[287.171581] Starting dynamic subtest: drm_test_cmdline_rotate_0
[287.295338] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.130s)
[287.303806] Starting dynamic subtest: drm_test_cmdline_rotate_90
[287.432657] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.137s)
[287.441104] Starting dynamic subtest: drm_test_cmdline_rotate_180
[287.549824] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.116s)
[287.559880] Starting dynamic subtest: drm_test_cmdline_rotate_270
[287.643376] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.094s)
[287.651509] Starting dynamic subtest: drm_test_cmdline_hmirror
[287.794569] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.149s)
[287.802750] Starting dynamic subtest: drm_test_cmdline_vmirror
[287.894723] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.100s)
[287.902953] Starting dynamic subtest: drm_test_cmdline_margin_options
[287.999193] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.103s)
[288.009689] Starting dynamic subtest: drm_test_cmdline_multiple_options
[288.126572] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.128s)
[288.135229] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[288.261313] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.132s)
[288.269748] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[288.408079] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.145s)
[288.418266] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[288.507591] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.102s)
[288.516166] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[288.647702] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.136s)
[288.657636] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[288.802101] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.153s)
[288.812394] Starting dynamic subtest: drm_test_cmdline_invalid
[288.950970] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.149s)
[288.959515] Starting dynamic subtest: drm_test_cmdline_tv_options
[289.097486] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.147s)
[289.099778] Subtest drm_cmdline_parser: SUCCESS (5.214s)
[289.299286] [069/132] (731s left) kms_properties (get_properties-sanity-non-atomic)
[289.395151] Starting subtest: get_properties-sanity-non-atomic
[289.397404] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[289.490030] [070/132] (731s left) kms_flip (2x-flip-vs-suspend)
[289.572421] Starting subtest: 2x-flip-vs-suspend
[289.583072] Subtest 2x-flip-vs-suspend: SKIP (0.010s)
[289.684694] [071/132] (731s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[289.787397] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[289.791755] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[289.923358] [072/132] (731s left) perf_pmu (semaphore-wait)
[289.968549] Starting subtest: semaphore-wait
[289.970426] Starting dynamic subtest: rcs0
[290.481044] Dynamic subtest rcs0: SUCCESS (0.512s)
[290.496177] Starting dynamic subtest: bcs0
[290.996914] Dynamic subtest bcs0: SUCCESS (0.512s)
[291.013079] Starting dynamic subtest: vcs0
[291.512568] Dynamic subtest vcs0: SUCCESS (0.512s)
[291.525000] Starting dynamic subtest: vcs1
[292.027733] Dynamic subtest vcs1: SUCCESS (0.512s)
[292.039838] Starting dynamic subtest: vecs0
[292.541330] Dynamic subtest vecs0: SUCCESS (0.510s)
[292.553840] Starting dynamic subtest: ccs0
[293.056080] Dynamic subtest ccs0: SUCCESS (0.512s)
[293.059027] Subtest semaphore-wait: SUCCESS (3.089s)
[293.197282] [073/132] (728s left) gem_exec_schedule (u-lateslice)
[293.277082] Starting subtest: u-lateslice
[293.279424] Starting dynamic subtest: rcs0
[293.309521] Dynamic subtest rcs0: SUCCESS (0.040s)
[293.320538] Starting dynamic subtest: bcs0
[293.331806] Dynamic subtest bcs0: SUCCESS (0.022s)
[293.340453] Starting dynamic subtest: vcs0
[293.355235] Dynamic subtest vcs0: SUCCESS (0.022s)
[293.363658] Starting dynamic subtest: vcs1
[293.378151] Dynamic subtest vcs1: SUCCESS (0.023s)
[293.389358] Starting dynamic subtest: vecs0
[293.400932] Dynamic subtest vecs0: SUCCESS (0.021s)
[293.409999] Starting dynamic subtest: ccs0
[293.426099] Dynamic subtest ccs0: SUCCESS (0.024s)
[293.428296] Subtest u-lateslice: SUCCESS (0.158s)
[294.973941] [074/132] (726s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[295.075713] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[295.077918] Starting dynamic subtest: pipe-A-default-mode
[295.365519] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[295.369859] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.290s)
[296.215197] [075/132] (725s left) gem_spin_batch (spin-all-new)
[296.295095] Starting subtest: spin-all-new
[296.307570] Subtest spin-all-new: SUCCESS (0.014s)
[297.944381] [076/132] (723s left) kms_async_flips (crc-atomic)
[298.046129] Starting subtest: crc-atomic
[298.417446] Starting dynamic subtest: pipe-A-eDP-1
[301.327643] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.907s)
[301.736157] Starting dynamic subtest: pipe-B-eDP-1
[304.638847] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.922s)
[305.022488] Starting dynamic subtest: pipe-C-eDP-1
[307.936267] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.923s)
[308.299728] Starting dynamic subtest: pipe-D-eDP-1
[311.162342] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.874s)
[311.164754] Subtest crc-atomic: SUCCESS (13.118s)
[312.349452] [077/132] (709s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[312.455226] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[312.460486] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[313.573265] [078/132] (707s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[313.660638] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[313.669065] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[313.771776] [079/132] (707s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[313.880649] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[313.884833] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[314.018386] [080/132] (707s left) kms_psr (psr-sprite-blt)
[314.116283] Starting subtest: psr-sprite-blt
[314.118582] Starting dynamic subtest: eDP-1
[315.867825] Dynamic subtest eDP-1: SUCCESS (1.753s)
[315.870207] Subtest psr-sprite-blt: SUCCESS (1.754s)
[316.738314] [081/132] (704s left) gem_mmap_gtt (basic-small-copy-xy)
[316.793147] Subtest basic-small-copy-XY: SKIP (0.000s)
[316.856997] [082/132] (704s left) kms_chamelium_hpd (vga-hpd-fast)
[317.231736] Subtest vga-hpd-fast: SKIP (0.000s)
[318.021056] [083/132] (703s left) gem_exec_async (concurrent-writes)
[318.086868] Starting subtest: concurrent-writes
[318.089583] Starting dynamic subtest: rcs0
[318.102496] Dynamic subtest rcs0: SUCCESS (0.015s)
[318.114622] Starting dynamic subtest: bcs0
[318.116946] Dynamic subtest bcs0: SUCCESS (0.007s)
[318.126182] Starting dynamic subtest: vcs0
[318.128471] Dynamic subtest vcs0: SUCCESS (0.005s)
[318.137353] Starting dynamic subtest: vcs1
[318.139237] Dynamic subtest vcs1: SUCCESS (0.005s)
[318.147843] Starting dynamic subtest: vecs0
[318.149822] Dynamic subtest vecs0: SUCCESS (0.005s)
[318.158421] Starting dynamic subtest: ccs0
[318.160296] Dynamic subtest ccs0: SUCCESS (0.006s)
[318.162149] Subtest concurrent-writes: SUCCESS (0.048s)
[318.398750] [084/132] (703s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[318.458133] Starting subtest: legacy-engines-hostile-preempt
[318.460403] Starting dynamic subtest: render
[318.525605] Dynamic subtest render: SUCCESS (0.067s)
[318.536785] Starting dynamic subtest: bsd1
[319.912067] Dynamic subtest bsd1: SUCCESS (1.383s)
[319.923556] Starting dynamic subtest: bsd2
[321.963798] Dynamic subtest bsd2: SUCCESS (2.049s)
[321.975169] Starting dynamic subtest: blt
[321.999589] Dynamic subtest blt: SUCCESS (0.034s)
[322.008083] Starting dynamic subtest: vebox
[323.959253] Dynamic subtest vebox: SUCCESS (1.956s)
[323.962303] Subtest legacy-engines-hostile-preempt: SUCCESS (5.501s)
[324.064760] [085/132] (697s left) gem_exec_whisper (basic-forked-all)
[324.139626] Starting subtest: basic-forked-all
[338.030675] Subtest basic-forked-all: SUCCESS (13.888s)
[338.241872] [086/132] (683s left) kms_addfb_basic (bo-too-small)
[338.351609] Starting subtest: bo-too-small
[338.353777] Subtest bo-too-small: SUCCESS (0.000s)
[338.486308] [087/132] (683s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[338.587304] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[338.591204] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[338.692051] [088/132] (683s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[338.781852] Starting subtest: x-tiled-32bpp-rotate-0
[340.262539] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.480s)
[340.452629] [089/132] (681s left) sysfs_timeslice_duration (invalid)
[340.521552] Starting subtest: invalid
[340.523559] Starting dynamic subtest: vecs0
[340.525645] Dynamic subtest vecs0: SUCCESS (0.000s)
[340.535637] Starting dynamic subtest: ccs0
[340.537228] Dynamic subtest ccs0: SUCCESS (0.000s)
[340.545056] Starting dynamic subtest: vcs0
[340.546701] Dynamic subtest vcs0: SUCCESS (0.000s)
[340.554564] Starting dynamic subtest: bcs0
[340.556194] Dynamic subtest bcs0: SUCCESS (0.000s)
[340.564019] Starting dynamic subtest: rcs0
[340.565631] Dynamic subtest rcs0: SUCCESS (0.000s)
[340.573974] Starting dynamic subtest: vcs1
[340.575572] Dynamic subtest vcs1: SUCCESS (0.000s)
[340.577170] Subtest invalid: SUCCESS (0.006s)
[340.663774] [090/132] (681s left) syncobj_wait (wait-all-snapshot)
[340.721970] Starting subtest: wait-all-snapshot
[340.802667] Subtest wait-all-snapshot: SUCCESS (0.082s)
[340.902809] [091/132] (681s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[341.024171] Starting subtest: fbc-rgb101010-draw-blt
[345.669200] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.648s)
[346.878987] [092/132] (675s left) gem_ccs (ctrl-surf-copy)
[346.948576] Starting subtest: ctrl-surf-copy
[346.952977] Subtest ctrl-surf-copy: SKIP (0.000s)
[347.092297] [093/132] (675s left) i915_fb_tiling (basic-x-tiling)
[347.157143] Subtest basic-x-tiling: SKIP (0.000s)
[347.224447] [094/132] (674s left) i915_drm_fdinfo (busy-hang)
[347.267097] Starting subtest: busy-hang
[347.269280] Starting dynamic subtest: rcs0
[347.303250] Dynamic subtest rcs0: SKIP (0.036s)
[347.314655] Starting dynamic subtest: bcs0
[347.319091] Dynamic subtest bcs0: SKIP (0.001s)
[347.328708] Starting dynamic subtest: vcs0
[347.332994] Dynamic subtest vcs0: SKIP (0.001s)
[347.342049] Starting dynamic subtest: vcs1
[347.346533] Dynamic subtest vcs1: SKIP (0.000s)
[347.357919] Starting dynamic subtest: vecs0
[347.362286] Dynamic subtest vecs0: SKIP (0.000s)
[347.372071] Starting dynamic subtest: ccs0
[347.376313] Dynamic subtest ccs0: SKIP (0.000s)
[347.380596] Subtest busy-hang: SKIP (0.043s)
[347.416596] [095/132] (674s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[347.515502] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[347.519536] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[347.651897] [096/132] (674s left) gem_render_copy (linear)
[347.720347] Starting subtest: linear
[347.722792] Starting dynamic subtest: smem
[347.760143] Dynamic subtest smem: SUCCESS (0.039s)
[347.762807] Subtest linear: SUCCESS (0.040s)
[348.038982] [097/132] (674s left) prime_mmap (test_aperture_limit)
[348.106915] Starting subtest: test_aperture_limit
[348.109219] Starting dynamic subtest: test_aperture_limit-smem
[348.116188] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[348.120250] Subtest test_aperture_limit: SKIP (0.009s)
[348.249023] [098/132] (674s left) syncobj_wait (multi-wait-submitted-signaled)
[348.311878] Starting subtest: multi-wait-submitted-signaled
[348.314100] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[348.457421] [099/132] (673s left) kms_lease (lease-unleased-crtc)
[348.555704] Starting subtest: lease-unleased-crtc
[348.557921] Starting dynamic subtest: pipe-A-eDP-1
[348.845147] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[348.854889] Starting dynamic subtest: pipe-B-eDP-1
[349.591191] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.745s)
[349.600679] Starting dynamic subtest: pipe-C-eDP-1
[349.603187] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.005s)
[349.612683] Starting dynamic subtest: pipe-D-eDP-1
[349.614987] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s)
[349.617355] Subtest lease-unleased-crtc: SUCCESS (1.053s)
[350.010041] [100/132] (672s left) gem_exec_schedule (pi-common)
[350.199044] Starting subtest: pi-common
[350.201372] Starting dynamic subtest: rcs0
[350.227982] Dynamic subtest rcs0: SUCCESS (0.031s)
[350.242198] Starting dynamic subtest: bcs0
[350.261616] Dynamic subtest bcs0: SUCCESS (0.033s)
[350.275936] Starting dynamic subtest: vcs0
[350.291080] Dynamic subtest vcs0: SUCCESS (0.028s)
[350.303342] Starting dynamic subtest: vcs1
[350.320322] Dynamic subtest vcs1: SUCCESS (0.029s)
[350.332022] Starting dynamic subtest: vecs0
[350.349238] Dynamic subtest vecs0: SUCCESS (0.028s)
[350.362528] Starting dynamic subtest: ccs0
[350.376275] Dynamic subtest ccs0: SUCCESS (0.026s)
[350.378453] Subtest pi-common: SUCCESS (0.180s)
[350.628377] [101/132] (671s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[350.685128] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[350.687624] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[350.818237] [102/132] (671s left) kms_psr (pr-primary-blt)
[350.914223] Starting subtest: pr-primary-blt
[350.918248] Subtest pr-primary-blt: SKIP (0.000s)
[351.013618] [103/132] (671s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[351.102275] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[351.106518] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[351.236383] [104/132] (671s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[351.341593] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[351.345799] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[351.485542] [105/132] (671s left) core_auth (getclient-simple)
[351.521853] Starting subtest: getclient-simple
[351.548068] Subtest getclient-simple: SUCCESS (0.026s)
[351.681870] [106/132] (670s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[351.779379] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[352.592905] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.814s)
[352.792410] [107/132] (669s left) gem_mmap_wc (invalid-flags)
[352.846129] Subtest invalid-flags: SKIP (0.000s)
[352.918352] [108/132] (669s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[352.962779] Starting subtest: multi-wait-all-for-submit-available-submitted
[352.965093] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[353.094594] [109/132] (669s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[353.203099] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[360.137049] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.938s)
[360.284427] [110/132] (662s left) kms_rotation_crc (primary-rotation-270)
[360.391685] Starting subtest: primary-rotation-270
[360.396146] Subtest primary-rotation-270: SKIP (0.001s)
[360.488280] [111/132] (662s left) syncobj_wait (wait-zero-handles)
[360.547552] Starting subtest: wait-zero-handles
[360.549517] Subtest wait-zero-handles: SUCCESS (0.000s)
[360.678764] [112/132] (662s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[360.804381] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[360.808754] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[360.919872] [113/132] (662s left) kms_invalid_mode (overflow-vrefresh)
[361.019137] Starting subtest: overflow-vrefresh
[361.021368] Starting dynamic subtest: pipe-A-eDP-1
[361.311122] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[361.324747] Starting dynamic subtest: pipe-B-eDP-1
[361.327279] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[361.338625] Starting dynamic subtest: pipe-C-eDP-1
[361.340607] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[361.349430] Starting dynamic subtest: pipe-D-eDP-1
[361.351345] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[361.353287] Subtest overflow-vrefresh: SUCCESS (0.295s)
[362.166378] [114/132] (660s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[362.278199] Starting subtest: fbc-rgb565-draw-render
[366.451380] Subtest fbc-rgb565-draw-render: SUCCESS (4.177s)
[367.592947] [115/132] (655s left) gen9_exec_parse (basic-rejected)
[367.662405] Subtest basic-rejected: SKIP (0.000s)
[367.730349] [116/132] (655s left) gem_exec_nop (basic-series)
[367.815944] Starting subtest: basic-series
[383.897530] Subtest basic-series: SUCCESS (16.089s)
[384.164800] [117/132] (638s left) kms_flip (blocking-absolute-wf_vblank)
[384.267276] Starting subtest: blocking-absolute-wf_vblank
[384.269608] Starting dynamic subtest: A-eDP1
[393.016666] Dynamic subtest A-eDP1: SUCCESS (8.748s)
[393.033856] Starting dynamic subtest: B-eDP1
[401.742535] Dynamic subtest B-eDP1: SUCCESS (8.723s)
[401.752338] Starting dynamic subtest: C-eDP1
[410.463945] Dynamic subtest C-eDP1: SUCCESS (8.719s)
[410.479875] Starting dynamic subtest: D-eDP1
[419.189012] Dynamic subtest D-eDP1: SUCCESS (8.722s)
[419.191473] Subtest blocking-absolute-wf_vblank: SUCCESS (34.924s)
[420.430908] [118/132] (602s left) gem_tiled_fence_blits (basic)
[420.493576] Subtest basic: SKIP (0.000s)
[420.579460] [119/132] (602s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[420.661486] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[420.819213] [120/132] (602s left) gem_workarounds (reset)
[420.894435] Starting subtest: reset
[421.086039] Subtest reset: SUCCESS (0.191s)
[421.245318] [121/132] (602s left) gem_exec_fence (nb-await)
[421.440508] Starting subtest: nb-await
[421.442831] Starting dynamic subtest: rcs0
[421.503361] Dynamic subtest rcs0: SUCCESS (0.065s)
[421.515879] Starting dynamic subtest: bcs0
[421.560810] Dynamic subtest bcs0: SUCCESS (0.056s)
[421.572439] Starting dynamic subtest: vcs0
[421.619942] Dynamic subtest vcs0: SUCCESS (0.057s)
[421.631113] Starting dynamic subtest: vcs1
[421.678344] Dynamic subtest vcs1: SUCCESS (0.056s)
[421.689059] Starting dynamic subtest: vecs0
[421.737390] Dynamic subtest vecs0: SUCCESS (0.057s)
[421.749277] Starting dynamic subtest: ccs0
[421.795385] Dynamic subtest ccs0: SUCCESS (0.056s)
[421.798212] Subtest nb-await: SUCCESS (0.359s)
[424.034990] [122/132] (599s left) gem_partial_pwrite_pread (writes-after-reads)
[424.102513] Subtest writes-after-reads: SKIP (0.000s)
[424.169375] [123/132] (599s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[424.267994] Starting subtest: fbc-psr2-cursor-mmap-gtt
[424.270271] Starting dynamic subtest: eDP-1
[424.274614] Dynamic subtest eDP-1: SKIP (0.000s)
[424.278963] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[424.382446] [124/132] (599s left) api_intel_allocator (two-level-inception)
[424.441193] Starting subtest: two-level-inception
[429.841667] Subtest two-level-inception: SUCCESS (5.400s)
[429.995533] [125/132] (593s left) sw_sync (timeline_closed)
[430.031616] Starting subtest: timeline_closed
[430.033716] Subtest timeline_closed: SUCCESS (0.000s)
[430.116213] [126/132] (593s left) gem_pxp (reject-modify-context-protection-off-3)
[430.241497] Starting subtest: reject-modify-context-protection-off-3
[430.244034] Subtest reject-modify-context-protection-off-3: SUCCESS (0.001s)
[430.394386] [127/132] (593s left) kms_pm_rpm (basic-rte)
[430.430824] Starting subtest: basic-rte
[433.478298] Subtest basic-rte: SUCCESS (3.047s)
[434.993708] [128/132] (588s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[435.120692] Starting subtest: cursor-vs-flip-legacy
[464.373895] Subtest cursor-vs-flip-legacy: SUCCESS (29.252s)
[465.213317] [129/132] (558s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[465.304107] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[465.306567] Starting dynamic subtest: pipe-A-eDP-1
[466.532223] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.230s)
[466.542847] Starting dynamic subtest: pipe-B-eDP-1
[468.787395] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.253s)
[468.796327] Starting dynamic subtest: pipe-C-eDP-1
[471.028482] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.241s)
[471.038312] Starting dynamic subtest: pipe-D-eDP-1
[473.270678] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.240s)
[473.273142] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (7.969s)
[474.451249] [130/132] (549s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[474.567479] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[474.569724] Starting dynamic subtest: pipe-A-eDP-1
[474.592064] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[474.604274] Starting dynamic subtest: pipe-B-eDP-1
[474.626609] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[474.637365] Starting dynamic subtest: pipe-C-eDP-1
[474.659133] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[474.668552] Starting dynamic subtest: pipe-D-eDP-1
[474.690193] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[474.694560] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[476.903666] [131/132] (546s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[476.971581] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[476.974024] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[477.116739] [132/132] (546s left) kms_vblank (wait-idle)
[477.210437] Starting subtest: wait-idle
[477.212660] Starting dynamic subtest: pipe-A-eDP-1
[478.959779] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.751s)
[478.974805] Starting dynamic subtest: pipe-D-eDP-1
[481.413036] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.449s)
[481.415293] Subtest wait-idle: SUCCESS (4.204s)
[482.257171] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_legacy
results: parsing output: 1/ for test: kms_pipe_b_c_ivb
results: parsing output: 2/ for test: kms_prime
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: gem_ctx_isolation
results: parsing output: 5/ for test: kms_flip_scaled_crc
results: parsing output: 6/ for test: kms_cursor_edge_walk
results: parsing output: 7/ for test: gem_exec_flush
results: parsing output: 8/ for test: kms_getfb
results: parsing output: 9/ for test: gem_softpin
results: parsing output: 10/ for test: gem_userptr_blits
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_lmem_swapping
results: parsing output: 13/ for test: syncobj_eventfd
results: parsing output: 14/ for test: gem_mmap_offset
results: parsing output: 15/ for test: kms_color_pipeline
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_plane_lowres
results: parsing output: 18/ for test: i915_query
results: parsing output: 19/ for test: kms_psr2_sf
results: parsing output: 20/ for test: kms_chamelium_color
results: parsing output: 21/ for test: kms_plane_scaling
results: parsing output: 22/ for test: gem_fenced_exec_thrash
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: gem_eio
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_flink_race
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_exec_balancer
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: gem_ringfill
results: parsing output: 32/ for test: perf
results: parsing output: 33/ for test: gem_linear_blits
results: parsing output: 34/ for test: kms_async_flips
results: parsing output: 35/ for test: kms_dirtyfb
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: gem_ctx_param
results: parsing output: 38/ for test: gem_exec_fence
results: parsing output: 39/ for test: gem_lmem_swapping
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_content_protection
results: parsing output: 43/ for test: i915_pm_rpm
results: parsing output: 44/ for test: kms_plane_alpha_blend
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: gem_mmap_wc
results: parsing output: 47/ for test: gem_mmap_wc
results: parsing output: 48/ for test: vgem_basic
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: dmabuf_sync_file
results: parsing output: 51/ for test: gem_exec_reloc
results: parsing output: 52/ for test: perf_pmu
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: kms_cursor_crc
results: parsing output: 55/ for test: kms_psr2_sf
results: parsing output: 56/ for test: kms_cursor_legacy
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: gem_ccs
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: kms_vblank
results: parsing output: 62/ for test: kms_chamelium_hpd
results: parsing output: 63/ for test: gem_exec_balancer
results: parsing output: 64/ for test: gem_mmap_gtt
results: parsing output: 65/ for test: kms_plane_scaling
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_selftest
results: parsing output: 68/ for test: kms_properties
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: perf_pmu
results: parsing output: 72/ for test: gem_exec_schedule
results: parsing output: 73/ for test: kms_flip_scaled_crc
results: parsing output: 74/ for test: gem_spin_batch
results: parsing output: 75/ for test: kms_async_flips
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: gem_mmap_gtt
results: parsing output: 81/ for test: kms_chamelium_hpd
results: parsing output: 82/ for test: gem_exec_async
results: parsing output: 83/ for test: gem_ctx_persistence
results: parsing output: 84/ for test: gem_exec_whisper
results: parsing output: 85/ for test: kms_addfb_basic
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: sysfs_timeslice_duration
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_ccs
results: parsing output: 92/ for test: i915_fb_tiling
results: parsing output: 93/ for test: i915_drm_fdinfo
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_render_copy
results: parsing output: 96/ for test: prime_mmap
results: parsing output: 97/ for test: syncobj_wait
results: parsing output: 98/ for test: kms_lease
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: core_auth
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: gem_mmap_wc
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_rotation_crc
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_invalid_mode
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gen9_exec_parse
results: parsing output: 115/ for test: gem_exec_nop
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: gem_tiled_fence_blits
results: parsing output: 118/ for test: gem_userptr_blits
results: parsing output: 119/ for test: gem_workarounds
results: parsing output: 120/ for test: gem_exec_fence
results: parsing output: 121/ for test: gem_partial_pwrite_pread
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: api_intel_allocator
results: parsing output: 124/ for test: sw_sync
results: parsing output: 125/ for test: gem_pxp
results: parsing output: 126/ for test: kms_pm_rpm
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: kms_vblank
Done.