[57.857617] Initializing watchdogs
[57.857665]   /dev/watchdog0
[57.871837] [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.876289] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.878479] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.881812] [001/132] (960s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[58.041876] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[58.046570] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[58.205758] [002/132] (960s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[58.255157] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[58.311528] [003/132] (960s left) kms_prime (basic-crc-hybrid)
[58.389862] Subtest basic-crc-hybrid: SKIP (0.000s)
[58.521479] [FACT kms_prime (basic-crc-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[58.525445] [004/132] (959s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[58.585421] Starting subtest: single-wait-all-for-submit-signaled
[58.587411] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[58.711239] [005/132] (959s left) gem_ctx_isolation (dirty-create)
[58.766632] Starting subtest: dirty-create
[58.768625] Starting dynamic subtest: rcs0
[58.969270] Dynamic subtest rcs0: SUCCESS (0.202s)
[58.978223] Starting dynamic subtest: bcs0
[59.176679] Dynamic subtest bcs0: SUCCESS (0.206s)
[59.186172] Starting dynamic subtest: vcs0
[59.403080] Dynamic subtest vcs0: SUCCESS (0.225s)
[59.412504] Starting dynamic subtest: vcs1
[61.112219] Dynamic subtest vcs1: SUCCESS (1.702s)
[61.120087] Starting dynamic subtest: vecs0
[63.091095] Dynamic subtest vecs0: SUCCESS (1.972s)
[63.101655] Starting dynamic subtest: ccs0
[65.177838] Dynamic subtest ccs0: SUCCESS (2.082s)
[65.180362] Subtest dirty-create: SUCCESS (6.392s)
[65.454643] [006/132] (953s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[65.553436] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[65.556042] Starting dynamic subtest: pipe-A-default-mode
[66.739808] Dynamic subtest pipe-A-default-mode: SKIP (1.186s)
[66.744239] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.187s)
[67.067234] [007/132] (951s left) kms_cursor_edge_walk (128x128-top-edge)
[67.252453] Starting subtest: 128x128-top-edge
[67.254969] Starting dynamic subtest: pipe-A-eDP-1
[70.682496] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.426s)
[70.691482] Starting dynamic subtest: pipe-D-eDP-1
[73.799414] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.115s)
[73.801946] Subtest 128x128-top-edge: SUCCESS (6.542s)
[74.635652] [008/132] (944s left) gem_exec_flush (basic-wb-prw-default)
[74.705014] Starting subtest: basic-wb-prw-default
[80.162986] Subtest basic-wb-prw-default: SUCCESS (5.457s)
[80.381321] [009/132] (938s left) kms_getfb (getfb2-accept-nv12)
[80.485829] Starting subtest: getfb2-accept-nv12
[80.488284] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[80.612452] [010/132] (938s left) gem_softpin (invalid)
[80.681611] Starting subtest: invalid
[80.689721] Subtest invalid: SUCCESS (0.009s)
[80.843956] [011/132] (938s left) gem_userptr_blits (readonly-unsync)
[80.909868] Subtest readonly-unsync: SKIP (0.000s)
[81.078372] [012/132] (937s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[81.179416] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[81.183595] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[81.308799] [013/132] (937s left) gem_lmem_swapping (smem-oom)
[81.344149] Subtest smem-oom: SKIP (0.000s)
[81.393186] [014/132] (937s left) syncobj_eventfd (binary-wait-before-signal)
[81.455399] Starting subtest: binary-wait-before-signal
[81.484594] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[81.580870] [015/132] (937s left) gem_mmap_offset (partial-unmap)
[81.624062] Starting subtest: partial-unmap
[81.625982] Starting dynamic subtest: smem0
[82.132776] Dynamic subtest smem0: SUCCESS (0.508s)
[82.135256] Subtest partial-unmap: SUCCESS (0.509s)
[82.278482] [016/132] (936s left) kms_color_pipeline (plane-lut3d-green-only)
[82.368594] Starting subtest: plane-lut3d-green-only
[82.385664] Starting dynamic subtest: pipe-A-eDP-1
[82.390315] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[83.491493] Starting dynamic subtest: pipe-B-eDP-1
[83.496086] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[84.524677] Starting dynamic subtest: pipe-C-eDP-1
[84.529380] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[85.557898] Starting dynamic subtest: pipe-D-eDP-1
[85.562681] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[85.860238] Subtest plane-lut3d-green-only: SKIP (3.487s)
[86.676356] [017/132] (932s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[86.806604] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[86.808903] Starting dynamic subtest: pipe-A-eDP-1
[86.828805] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[86.838947] Starting dynamic subtest: pipe-B-eDP-1
[86.858891] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[86.866251] Starting dynamic subtest: pipe-C-eDP-1
[86.885210] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[86.892533] Starting dynamic subtest: pipe-D-eDP-1
[86.911735] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[86.914061] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.009s)
[89.135224] [018/132] (930s left) kms_plane_lowres (tiling-y)
[89.240896] Starting subtest: tiling-y
[89.245062] Subtest tiling-y: SKIP (0.000s)
[89.335208] [019/132] (929s left) i915_query (engine-info)
[89.395778] Starting subtest: engine-info
[89.398597] Subtest engine-info: SUCCESS (0.005s)
[89.543244] [020/132] (929s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[94.607013] Starting subtest: pr-cursor-plane-move-continuous-sf
[94.612049] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.002s)
[95.471482] [021/132] (923s left) kms_chamelium_color (ctm-green-to-red)
[95.570260] Subtest ctm-green-to-red: SKIP (0.000s)
[95.616177] [022/132] (923s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[95.714658] Starting subtest: plane-upscale-20x20-with-rotation
[95.716835] Starting dynamic subtest: pipe-A
[95.939388] Dynamic subtest pipe-A: SUCCESS (0.226s)
[95.947740] Starting dynamic subtest: pipe-B
[97.227316] Dynamic subtest pipe-B: SUCCESS (1.287s)
[97.236197] Starting dynamic subtest: pipe-C
[98.562709] Dynamic subtest pipe-C: SUCCESS (1.335s)
[98.579975] Starting dynamic subtest: pipe-D
[99.886542] Dynamic subtest pipe-D: SUCCESS (1.323s)
[99.888941] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.173s)
[101.094154] [023/132] (918s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[101.149304] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[101.236510] [024/132] (918s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[101.331616] Starting subtest: 4-tiled-16bpp-rotate-270
[101.351314] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[101.499422] [025/132] (917s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[101.603374] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[101.607425] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[101.733414] [026/132] (917s left) gem_eio (banned)
[101.970197] Starting subtest: banned
[102.632311] Subtest banned: SUCCESS (0.663s)
[102.832316] [027/132] (916s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[102.936373] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[102.939812] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[103.054143] [028/132] (916s left) gem_flink_race (flink_close)
[103.087971] Starting subtest: flink_close
[108.191251] Subtest flink_close: SUCCESS (5.101s)
[108.295247] [029/132] (911s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[108.408069] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[108.412074] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[108.546532] [030/132] (911s left) gem_exec_balancer (parallel-keep-submit-fence)
[108.817436] Starting subtest: parallel-keep-submit-fence
[109.985071] Subtest parallel-keep-submit-fence: SUCCESS (1.171s)
[110.112404] [031/132] (909s left) kms_cursor_crc (cursor-onscreen-512x170)
[110.414719] Starting subtest: cursor-onscreen-512x170
[110.419166] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[110.594356] [032/132] (909s left) gem_ringfill (engines-basic)
[115.866092] Starting subtest: engines-basic
[115.868584] Starting dynamic subtest: rcs0
[115.929876] Dynamic subtest rcs0: SUCCESS (0.065s)
[115.940631] Starting dynamic subtest: bcs0
[115.974067] Dynamic subtest bcs0: SUCCESS (0.043s)
[115.984315] Starting dynamic subtest: vcs0
[116.016052] Dynamic subtest vcs0: SUCCESS (0.041s)
[116.025872] Starting dynamic subtest: vcs1
[116.059724] Dynamic subtest vcs1: SUCCESS (0.042s)
[116.069742] Starting dynamic subtest: vecs0
[116.102127] Dynamic subtest vecs0: SUCCESS (0.042s)
[116.112038] Starting dynamic subtest: ccs0
[116.147848] Dynamic subtest ccs0: SUCCESS (0.045s)
[116.150250] Subtest engines-basic: SUCCESS (0.284s)
[116.249695] [033/132] (903s left) perf (buffer-fill)
[116.381421] Starting subtest: buffer-fill
[116.383613] Starting dynamic subtest: 0-rcs0
[118.660859] Dynamic subtest 0-rcs0: SUCCESS (2.278s)
[118.670317] Starting dynamic subtest: 1-vecs0
[123.094851] Dynamic subtest 1-vecs0: SUCCESS (4.433s)
[123.097321] Subtest buffer-fill: SUCCESS (6.712s)
[123.142996] [034/132] (896s left) gem_linear_blits (basic)
[123.430867] Starting subtest: basic
[123.446338] Subtest basic: SUCCESS (0.016s)
[123.618789] [035/132] (896s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[123.760781] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[124.136901] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[126.936831] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.798s)
[126.948488] Starting dynamic subtest: pipe-A-eDP-1-4
[129.123458] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.186s)
[129.132704] Starting dynamic subtest: pipe-A-eDP-1-4
[131.133068] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[131.144150] Starting dynamic subtest: pipe-A-eDP-1-x
[133.324692] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[133.688424] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[136.471812] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.789s)
[136.483560] Starting dynamic subtest: pipe-B-eDP-1-4
[138.657992] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.186s)
[138.669067] Starting dynamic subtest: pipe-B-eDP-1-4
[140.668739] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.010s)
[140.680065] Starting dynamic subtest: pipe-B-eDP-1-x
[142.858710] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[143.227489] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[146.007261] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.786s)
[146.018945] Starting dynamic subtest: pipe-C-eDP-1-4
[148.183337] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.175s)
[148.194944] Starting dynamic subtest: pipe-C-eDP-1-4
[150.193450] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[150.205140] Starting dynamic subtest: pipe-C-eDP-1-x
[152.371494] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[152.735102] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[155.542940] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.813s)
[155.554955] Starting dynamic subtest: pipe-D-eDP-1-4
[157.717215] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[157.728162] Starting dynamic subtest: pipe-D-eDP-1-4
[159.727803] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[159.736481] Starting dynamic subtest: pipe-D-eDP-1-x
[161.906542] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[161.909310] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.143s)
[163.153303] [036/132] (856s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[163.251918] Starting subtest: fbc-dirtyfb-ioctl
[163.254318] Starting dynamic subtest: A-eDP-1
[165.913436] Dynamic subtest A-eDP-1: SUCCESS (2.660s)
[165.915884] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.661s)
[166.737273] [037/132] (853s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[166.840586] Starting subtest: y-tiled-32bpp-rotate-180
[166.845143] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[166.968779] [038/132] (853s left) gem_ctx_param (root-set)
[167.026663] Starting subtest: root-set
[167.029027] Subtest root-set: SUCCESS (0.001s)
[167.156231] [039/132] (852s left) gem_exec_fence (basic-wait-all)
[167.213711] Starting subtest: basic-wait-all
[167.310909] Subtest basic-wait-all: SUCCESS (0.098s)
[169.056388] [040/132] (851s left) gem_lmem_swapping (heavy-random)
[169.108563] Subtest heavy-random: SKIP (0.000s)
[169.151916] [041/132] (850s left) kms_psr (fbc-pr-primary-blt)
[169.249186] Starting subtest: fbc-pr-primary-blt
[169.253587] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[169.344053] [042/132] (850s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[169.445044] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[169.449217] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[169.560160] [043/132] (850s left) kms_content_protection (type1)
[169.716097] Starting subtest: type1
[169.720826] Subtest type1: SKIP (0.000s)
[169.883912] [044/132] (850s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[172.132083] Starting subtest: gem-execbuf-stress-pc8
[172.171316] Subtest gem-execbuf-stress-pc8: SKIP (0.039s)
[172.524302] [045/132] (847s left) kms_plane_alpha_blend (alpha-transparent-fb)
[172.627383] Starting subtest: alpha-transparent-fb
[172.918933] Starting dynamic subtest: pipe-A-eDP-1
[173.563821] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.644s)
[173.573909] Starting dynamic subtest: pipe-D-eDP-1
[174.964795] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.398s)
[174.967173] Subtest alpha-transparent-fb: SUCCESS (2.338s)
[175.794856] [046/132] (844s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[175.866432] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[175.971493] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.104s)
[176.071021] [047/132] (844s left) gem_mmap_wc (bad-offset)
[176.132874] Subtest bad-offset: SKIP (0.000s)
[176.192274] [048/132] (844s left) gem_mmap_wc (write-gtt-read-wc)
[176.259614] Subtest write-gtt-read-wc: SKIP (0.000s)
[176.324793] [049/132] (844s left) vgem_basic (dmabuf-fence)
[176.365701] Starting subtest: dmabuf-fence
[176.367801] Subtest dmabuf-fence: SUCCESS (0.000s)
[176.446133] [050/132] (844s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[176.550570] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[177.230591] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.681s)
[177.468295] [051/132] (843s left) dmabuf_sync_file (export-wait-after-attach)
[177.515183] Starting subtest: export-wait-after-attach
[177.517397] Subtest export-wait-after-attach: SUCCESS (0.001s)
[177.598257] [052/132] (842s left) gem_exec_reloc (basic-concurrent0)
[177.672924] Subtest basic-concurrent0: SKIP (0.000s)
[177.747904] [053/132] (842s left) perf_pmu (busy-hang)
[177.789646] Starting subtest: busy-hang
[177.792018] Starting dynamic subtest: rcs0
[179.078816] Dynamic subtest rcs0: SUCCESS (1.287s)
[179.089949] Starting dynamic subtest: bcs0
[180.337570] Dynamic subtest bcs0: SUCCESS (1.260s)
[180.348895] Starting dynamic subtest: vcs0
[182.421669] Dynamic subtest vcs0: SUCCESS (2.083s)
[182.433303] Starting dynamic subtest: vcs1
[184.416568] Dynamic subtest vcs1: SUCCESS (1.991s)
[184.428055] Starting dynamic subtest: vecs0
[186.390212] Dynamic subtest vecs0: SUCCESS (1.975s)
[186.401809] Starting dynamic subtest: ccs0
[187.659639] Dynamic subtest ccs0: SUCCESS (1.265s)
[187.661748] Subtest busy-hang: SUCCESS (9.869s)
[187.794783] [054/132] (832s left) kms_psr (pr-suspend)
[187.899773] Starting subtest: pr-suspend
[187.904112] Subtest pr-suspend: SKIP (0.000s)
[187.997466] [055/132] (832s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[188.250063] Starting subtest: cursor-rapid-movement-256x85
[188.299243] Subtest cursor-rapid-movement-256x85: SKIP (0.044s)
[188.503875] [056/132] (832s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[193.533154] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[193.535594] Starting dynamic subtest: pipe-A-eDP-1
[200.164194] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.630s)
[200.174738] Starting dynamic subtest: pipe-B-eDP-1
[206.834516] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.667s)
[206.836876] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (13.301s)
[207.728720] [057/132] (813s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[207.846080] Starting subtest: cursorA-vs-flipA-toggle
[218.997225] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.149s)
[219.860553] [058/132] (800s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[219.948423] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[219.950748] Starting dynamic subtest: pipe-A-eDP-1
[219.973701] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[219.985576] Starting dynamic subtest: pipe-B-eDP-1
[220.006704] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[220.015621] Starting dynamic subtest: pipe-C-eDP-1
[220.037496] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[220.046416] Starting dynamic subtest: pipe-D-eDP-1
[220.067896] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[220.072154] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[222.210921] [059/132] (798s left) gem_ccs (ctrl-surf-copy-new-ctx)
[222.275399] Starting subtest: ctrl-surf-copy-new-ctx
[222.279567] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[222.411640] [060/132] (798s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[222.512511] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[229.504708] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.994s)
[229.656471] [061/132] (791s left) gem_exec_reloc (basic-softpin)
[229.719691] Subtest basic-softpin: SKIP (0.000s)
[229.802433] [062/132] (791s left) kms_vblank (query-idle-hang)
[229.892309] Starting subtest: query-idle-hang
[229.894467] Starting dynamic subtest: pipe-A-eDP-1
[256.666472] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.773s)
[256.683167] Starting dynamic subtest: pipe-D-eDP-1
[281.696544] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.027s)
[281.698942] Subtest query-idle-hang: SUCCESS (51.804s)
[282.521946] [063/132] (738s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[282.911277] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[283.700975] [064/132] (737s left) gem_exec_balancer (hang)
[283.961535] Starting subtest: hang
[285.893466] Subtest hang: SUCCESS (1.935s)
[286.051935] [065/132] (735s left) gem_mmap_gtt (basic-small-bo)
[286.122033] Subtest basic-small-bo: SKIP (0.000s)
[286.186402] [066/132] (734s left) kms_plane_scaling (planes-downscale-factor-0-5)
[286.295763] Starting subtest: planes-downscale-factor-0-5
[286.298091] Starting dynamic subtest: pipe-A
[286.318386] Dynamic subtest pipe-A: SKIP (0.018s)
[286.328319] Starting dynamic subtest: pipe-B
[286.350747] Dynamic subtest pipe-B: SKIP (0.032s)
[286.360638] Starting dynamic subtest: pipe-C
[286.383524] Dynamic subtest pipe-C: SKIP (0.032s)
[286.392469] Starting dynamic subtest: pipe-D
[286.416250] Dynamic subtest pipe-D: SKIP (0.032s)
[286.419979] Subtest planes-downscale-factor-0-5: SKIP (0.116s)
[286.541684] [067/132] (734s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[286.645781] Starting subtest: fbcpsr-rgb565-draw-blt
[293.684445] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.040s)
[293.889798] [068/132] (727s left) kms_selftest (drm_cmdline_parser)
[293.933700] Starting subtest: drm_cmdline_parser
[293.970065] Starting dynamic subtest: drm_test_cmdline_force_d_only
[294.111856] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.140s)
[294.122831] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[294.219389] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.107s)
[294.230516] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[294.348159] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.127s)
[294.358976] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[294.479032] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.130s)
[294.489972] Starting dynamic subtest: drm_test_cmdline_force_e_only
[294.625814] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.146s)
[294.636404] Starting dynamic subtest: drm_test_cmdline_res
[294.778091] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.152s)
[294.789366] Starting dynamic subtest: drm_test_cmdline_res_vesa
[294.922187] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.143s)
[294.932859] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[295.016276] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.095s)
[295.025084] Starting dynamic subtest: drm_test_cmdline_res_rblank
[295.156517] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.138s)
[295.166640] Starting dynamic subtest: drm_test_cmdline_res_bpp
[295.312525] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.155s)
[295.327773] Starting dynamic subtest: drm_test_cmdline_res_refresh
[295.415289] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.104s)
[295.425938] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[295.539487] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.123s)
[295.548699] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[295.692135] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.151s)
[295.701422] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[295.821094] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.128s)
[295.830589] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[295.961169] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.139s)
[295.970268] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[296.089101] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.127s)
[296.098507] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[296.177385] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.089s)
[296.186356] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[296.297986] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.118s)
[296.307809] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[296.405957] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.108s)
[296.415388] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[296.534051] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.126s)
[296.543078] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[296.683582] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.148s)
[296.702136] Starting dynamic subtest: drm_test_cmdline_name
[296.770432] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.086s)
[296.782058] Starting dynamic subtest: drm_test_cmdline_name_bpp
[296.914177] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.143s)
[296.924779] Starting dynamic subtest: drm_test_cmdline_name_option
[297.066970] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.152s)
[297.078318] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[297.207271] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.139s)
[297.218094] Starting dynamic subtest: drm_test_cmdline_rotate_0
[297.336063] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.129s)
[297.345645] Starting dynamic subtest: drm_test_cmdline_rotate_90
[297.471721] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.135s)
[297.482466] Starting dynamic subtest: drm_test_cmdline_rotate_180
[297.594183] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.122s)
[297.604832] Starting dynamic subtest: drm_test_cmdline_rotate_270
[297.729112] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.132s)
[297.739401] Starting dynamic subtest: drm_test_cmdline_hmirror
[297.866610] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.138s)
[297.875521] Starting dynamic subtest: drm_test_cmdline_vmirror
[298.008074] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.139s)
[298.017225] Starting dynamic subtest: drm_test_cmdline_margin_options
[298.124149] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.115s)
[298.133649] Starting dynamic subtest: drm_test_cmdline_multiple_options
[298.260405] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.136s)
[298.269258] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[298.363044] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.102s)
[298.372510] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[298.477339] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.114s)
[298.486680] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[298.595036] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.116s)
[298.603825] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[298.703439] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.108s)
[298.712422] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[298.817305] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.112s)
[298.826940] Starting dynamic subtest: drm_test_cmdline_invalid
[298.956774] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.141s)
[298.966066] Starting dynamic subtest: drm_test_cmdline_tv_options
[299.073055] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.114s)
[299.075342] Subtest drm_cmdline_parser: SUCCESS (5.137s)
[299.279849] [069/132] (722s left) kms_properties (get_properties-sanity-non-atomic)
[299.381091] Starting subtest: get_properties-sanity-non-atomic
[299.383323] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[299.481386] [070/132] (721s left) kms_flip (2x-flip-vs-suspend)
[299.572963] Starting subtest: 2x-flip-vs-suspend
[299.584393] Subtest 2x-flip-vs-suspend: SKIP (0.011s)
[299.711957] [071/132] (721s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[299.817813] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[299.822177] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[299.941608] [072/132] (721s left) perf_pmu (semaphore-wait)
[299.978978] Starting subtest: semaphore-wait
[299.981254] Starting dynamic subtest: rcs0
[300.491996] Dynamic subtest rcs0: SUCCESS (0.512s)
[300.505254] Starting dynamic subtest: bcs0
[301.005366] Dynamic subtest bcs0: SUCCESS (0.511s)
[301.018051] Starting dynamic subtest: vcs0
[301.519618] Dynamic subtest vcs0: SUCCESS (0.510s)
[301.532219] Starting dynamic subtest: vcs1
[302.032897] Dynamic subtest vcs1: SUCCESS (0.510s)
[302.045876] Starting dynamic subtest: vecs0
[302.548212] Dynamic subtest vecs0: SUCCESS (0.512s)
[302.564208] Starting dynamic subtest: ccs0
[303.064442] Dynamic subtest ccs0: SUCCESS (0.513s)
[303.067286] Subtest semaphore-wait: SUCCESS (3.086s)
[303.208836] [073/132] (718s left) gem_exec_schedule (u-lateslice)
[303.291637] Starting subtest: u-lateslice
[303.294164] Starting dynamic subtest: rcs0
[303.310247] Dynamic subtest rcs0: SUCCESS (0.028s)
[303.322104] Starting dynamic subtest: bcs0
[303.336789] Dynamic subtest bcs0: SUCCESS (0.025s)
[303.346305] Starting dynamic subtest: vcs0
[303.357233] Dynamic subtest vcs0: SUCCESS (0.020s)
[303.366969] Starting dynamic subtest: vcs1
[303.380679] Dynamic subtest vcs1: SUCCESS (0.022s)
[303.389913] Starting dynamic subtest: vecs0
[303.401043] Dynamic subtest vecs0: SUCCESS (0.020s)
[303.410784] Starting dynamic subtest: ccs0
[303.423696] Dynamic subtest ccs0: SUCCESS (0.022s)
[303.425838] Subtest u-lateslice: SUCCESS (0.142s)
[305.036682] [074/132] (716s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[305.147791] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[305.149995] Starting dynamic subtest: pipe-A-default-mode
[305.435305] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[305.439613] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.287s)
[306.292943] [075/132] (715s left) gem_spin_batch (spin-all-new)
[306.349658] Starting subtest: spin-all-new
[306.368788] Subtest spin-all-new: SUCCESS (0.022s)
[307.926450] [076/132] (713s left) kms_async_flips (crc-atomic)
[308.023321] Starting subtest: crc-atomic
[308.413593] Starting dynamic subtest: pipe-A-eDP-1
[311.295822] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.882s)
[311.680060] Starting dynamic subtest: pipe-B-eDP-1
[314.617837] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.948s)
[315.006156] Starting dynamic subtest: pipe-C-eDP-1
[317.933454] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.937s)
[318.304646] Starting dynamic subtest: pipe-D-eDP-1
[321.161478] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.868s)
[321.163901] Subtest crc-atomic: SUCCESS (13.138s)
[322.375110] [077/132] (699s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[322.468135] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[322.472708] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[323.604991] [078/132] (698s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[323.704285] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[323.715317] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[323.848571] [079/132] (697s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[323.958439] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[323.962526] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[324.093718] [080/132] (697s left) kms_psr (psr-sprite-blt)
[324.191976] Starting subtest: psr-sprite-blt
[324.194265] Starting dynamic subtest: eDP-1
[325.900849] Dynamic subtest eDP-1: SUCCESS (1.710s)
[325.903120] Subtest psr-sprite-blt: SUCCESS (1.711s)
[326.761234] [081/132] (695s left) gem_mmap_gtt (basic-small-copy-xy)
[326.824330] Subtest basic-small-copy-XY: SKIP (0.000s)
[326.882937] [082/132] (694s left) kms_chamelium_hpd (vga-hpd-fast)
[327.271393] Subtest vga-hpd-fast: SKIP (0.000s)
[328.048420] [083/132] (693s left) gem_exec_async (concurrent-writes)
[328.117456] Starting subtest: concurrent-writes
[328.119669] Starting dynamic subtest: rcs0
[328.131947] Dynamic subtest rcs0: SUCCESS (0.014s)
[328.143623] Starting dynamic subtest: bcs0
[328.145729] Dynamic subtest bcs0: SUCCESS (0.006s)
[328.155199] Starting dynamic subtest: vcs0
[328.157345] Dynamic subtest vcs0: SUCCESS (0.004s)
[328.166674] Starting dynamic subtest: vcs1
[328.168552] Dynamic subtest vcs1: SUCCESS (0.007s)
[328.177321] Starting dynamic subtest: vecs0
[328.179163] Dynamic subtest vecs0: SUCCESS (0.007s)
[328.187938] Starting dynamic subtest: ccs0
[328.189904] Dynamic subtest ccs0: SUCCESS (0.006s)
[328.191728] Subtest concurrent-writes: SUCCESS (0.048s)
[328.441585] [084/132] (693s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[328.498161] Starting subtest: legacy-engines-hostile-preempt
[328.500436] Starting dynamic subtest: render
[328.591631] Dynamic subtest render: SUCCESS (0.093s)
[328.605273] Starting dynamic subtest: bsd1
[329.861220] Dynamic subtest bsd1: SUCCESS (1.265s)
[329.873500] Starting dynamic subtest: bsd2
[331.950242] Dynamic subtest bsd2: SUCCESS (2.086s)
[331.963030] Starting dynamic subtest: blt
[332.031910] Dynamic subtest blt: SUCCESS (0.080s)
[332.047140] Starting dynamic subtest: vebox
[333.911249] Dynamic subtest vebox: SUCCESS (1.875s)
[333.914245] Subtest legacy-engines-hostile-preempt: SUCCESS (5.413s)
[334.017168] [085/132] (687s left) gem_exec_whisper (basic-forked-all)
[334.084021] Starting subtest: basic-forked-all
[347.866087] Subtest basic-forked-all: SUCCESS (13.777s)
[348.073436] [086/132] (673s left) kms_addfb_basic (bo-too-small)
[348.177226] Starting subtest: bo-too-small
[348.179526] Subtest bo-too-small: SUCCESS (0.000s)
[348.316581] [087/132] (673s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[348.416635] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[348.420787] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[348.552489] [088/132] (673s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[348.663372] Starting subtest: x-tiled-32bpp-rotate-0
[350.109363] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.447s)
[350.263282] [089/132] (671s left) sysfs_timeslice_duration (invalid)
[350.322226] Starting subtest: invalid
[350.324155] Starting dynamic subtest: vecs0
[350.326176] Dynamic subtest vecs0: SUCCESS (0.000s)
[350.335696] Starting dynamic subtest: ccs0
[350.337267] Dynamic subtest ccs0: SUCCESS (0.000s)
[350.345781] Starting dynamic subtest: vcs0
[350.347774] Dynamic subtest vcs0: SUCCESS (0.000s)
[350.359035] Starting dynamic subtest: bcs0
[350.360812] Dynamic subtest bcs0: SUCCESS (0.000s)
[350.369656] Starting dynamic subtest: rcs0
[350.371360] Dynamic subtest rcs0: SUCCESS (0.000s)
[350.381069] Starting dynamic subtest: vcs1
[350.382776] Dynamic subtest vcs1: SUCCESS (0.000s)
[350.384783] Subtest invalid: SUCCESS (0.006s)
[350.466465] [090/132] (671s left) syncobj_wait (wait-all-snapshot)
[350.528994] Starting subtest: wait-all-snapshot
[350.608876] Subtest wait-all-snapshot: SUCCESS (0.081s)
[350.711866] [091/132] (671s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[350.810683] Starting subtest: fbc-rgb101010-draw-blt
[355.372303] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.563s)
[356.585885] [092/132] (665s left) gem_ccs (ctrl-surf-copy)
[356.641187] Starting subtest: ctrl-surf-copy
[356.645306] Subtest ctrl-surf-copy: SKIP (0.000s)
[356.767403] [093/132] (665s left) i915_fb_tiling (basic-x-tiling)
[356.826841] Subtest basic-x-tiling: SKIP (0.000s)
[356.900374] [094/132] (665s left) i915_drm_fdinfo (busy-hang)
[356.937200] Starting subtest: busy-hang
[356.939525] Starting dynamic subtest: rcs0
[356.973699] Dynamic subtest rcs0: SKIP (0.034s)
[356.984910] Starting dynamic subtest: bcs0
[356.989024] Dynamic subtest bcs0: SKIP (0.001s)
[356.998632] Starting dynamic subtest: vcs0
[357.002744] Dynamic subtest vcs0: SKIP (0.000s)
[357.012170] Starting dynamic subtest: vcs1
[357.016158] Dynamic subtest vcs1: SKIP (0.000s)
[357.025175] Starting dynamic subtest: vecs0
[357.029227] Dynamic subtest vecs0: SKIP (0.001s)
[357.038078] Starting dynamic subtest: ccs0
[357.042284] Dynamic subtest ccs0: SKIP (0.000s)
[357.046320] Subtest busy-hang: SKIP (0.041s)
[357.084776] [095/132] (665s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[357.179949] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[357.184219] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[357.319633] [096/132] (665s left) gem_render_copy (linear)
[357.402615] Starting subtest: linear
[357.404901] Starting dynamic subtest: smem
[357.462896] Dynamic subtest smem: SUCCESS (0.062s)
[357.465732] Subtest linear: SUCCESS (0.063s)
[357.731626] [097/132] (664s left) prime_mmap (test_aperture_limit)
[357.791952] Starting subtest: test_aperture_limit
[357.794507] Starting dynamic subtest: test_aperture_limit-smem
[357.802097] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[357.806667] Subtest test_aperture_limit: SKIP (0.009s)
[357.944473] [098/132] (664s left) syncobj_wait (multi-wait-submitted-signaled)
[358.000826] Starting subtest: multi-wait-submitted-signaled
[358.003311] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[358.133043] [099/132] (664s left) kms_lease (lease-unleased-crtc)
[358.228907] Starting subtest: lease-unleased-crtc
[358.231135] Starting dynamic subtest: pipe-A-eDP-1
[358.521395] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s)
[358.532329] Starting dynamic subtest: pipe-B-eDP-1
[359.304583] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.780s)
[359.315961] Starting dynamic subtest: pipe-C-eDP-1
[359.318127] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.005s)
[359.327068] Starting dynamic subtest: pipe-D-eDP-1
[359.328903] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[359.330822] Subtest lease-unleased-crtc: SUCCESS (1.088s)
[359.704237] [100/132] (662s left) gem_exec_schedule (pi-common)
[359.892990] Starting subtest: pi-common
[359.895309] Starting dynamic subtest: rcs0
[359.920395] Dynamic subtest rcs0: SUCCESS (0.030s)
[359.931737] Starting dynamic subtest: bcs0
[359.955948] Dynamic subtest bcs0: SUCCESS (0.035s)
[359.971773] Starting dynamic subtest: vcs0
[359.986099] Dynamic subtest vcs0: SUCCESS (0.029s)
[360.000099] Starting dynamic subtest: vcs1
[360.013429] Dynamic subtest vcs1: SUCCESS (0.027s)
[360.027297] Starting dynamic subtest: vecs0
[360.041158] Dynamic subtest vecs0: SUCCESS (0.027s)
[360.055109] Starting dynamic subtest: ccs0
[360.069540] Dynamic subtest ccs0: SUCCESS (0.028s)
[360.071678] Subtest pi-common: SUCCESS (0.180s)
[360.311978] [101/132] (662s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[360.376859] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[360.379254] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[360.495204] [102/132] (662s left) kms_psr (pr-primary-blt)
[360.579275] Starting subtest: pr-primary-blt
[360.583661] Subtest pr-primary-blt: SKIP (0.000s)
[360.673586] [103/132] (662s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[360.783306] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[360.787806] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[360.904170] [104/132] (661s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[360.998403] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[361.002668] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[361.119030] [105/132] (661s left) core_auth (getclient-simple)
[361.158317] Starting subtest: getclient-simple
[361.180318] Subtest getclient-simple: SUCCESS (0.023s)
[361.305905] [106/132] (661s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[361.413516] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[362.227500] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.815s)
[362.462574] [107/132] (660s left) gem_mmap_wc (invalid-flags)
[362.526695] Subtest invalid-flags: SKIP (0.000s)
[362.590601] [108/132] (660s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[362.639938] Starting subtest: multi-wait-all-for-submit-available-submitted
[362.641994] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[362.750555] [109/132] (660s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[362.867822] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[369.963406] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.100s)
[370.116293] [110/132] (652s left) kms_rotation_crc (primary-rotation-270)
[370.220797] Starting subtest: primary-rotation-270
[370.225122] Subtest primary-rotation-270: SKIP (0.001s)
[370.317984] [111/132] (652s left) syncobj_wait (wait-zero-handles)
[370.389143] Starting subtest: wait-zero-handles
[370.391590] Subtest wait-zero-handles: SUCCESS (0.000s)
[370.529388] [112/132] (652s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[370.628912] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[370.633181] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[370.748291] [113/132] (652s left) kms_invalid_mode (overflow-vrefresh)
[370.841187] Starting subtest: overflow-vrefresh
[370.843392] Starting dynamic subtest: pipe-A-eDP-1
[371.131828] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[371.142419] Starting dynamic subtest: pipe-B-eDP-1
[371.144392] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[371.153854] Starting dynamic subtest: pipe-C-eDP-1
[371.156132] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[371.165349] Starting dynamic subtest: pipe-D-eDP-1
[371.167651] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[371.169937] Subtest overflow-vrefresh: SUCCESS (0.295s)
[371.959555] [114/132] (651s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[372.067452] Starting subtest: fbc-rgb565-draw-render
[376.221715] Subtest fbc-rgb565-draw-render: SUCCESS (4.156s)
[377.463699] [115/132] (645s left) gen9_exec_parse (basic-rejected)
[377.541050] Subtest basic-rejected: SKIP (0.000s)
[377.630238] [116/132] (645s left) gem_exec_nop (basic-series)
[377.707604] Starting subtest: basic-series
[392.347588] Subtest basic-series: SUCCESS (14.649s)
[392.577832] [117/132] (630s left) kms_flip (blocking-absolute-wf_vblank)
[392.685285] Starting subtest: blocking-absolute-wf_vblank
[392.687498] Starting dynamic subtest: A-eDP1
[401.381282] Dynamic subtest A-eDP1: SUCCESS (8.697s)
[401.393688] Starting dynamic subtest: B-eDP1
[410.115359] Dynamic subtest B-eDP1: SUCCESS (8.731s)
[410.134619] Starting dynamic subtest: C-eDP1
[418.836443] Dynamic subtest C-eDP1: SUCCESS (8.718s)
[418.846237] Starting dynamic subtest: D-eDP1
[427.565097] Dynamic subtest D-eDP1: SUCCESS (8.726s)
[427.570439] Subtest blocking-absolute-wf_vblank: SUCCESS (34.887s)
[428.800661] [118/132] (594s left) gem_tiled_fence_blits (basic)
[428.866765] Subtest basic: SKIP (0.000s)
[428.954221] [119/132] (594s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[429.040047] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[429.195196] [120/132] (594s left) gem_workarounds (reset)
[429.271847] Starting subtest: reset
[429.469822] Subtest reset: SUCCESS (0.196s)
[429.620895] [121/132] (593s left) gem_exec_fence (nb-await)
[429.791703] Starting subtest: nb-await
[429.793722] Starting dynamic subtest: rcs0
[429.856238] Dynamic subtest rcs0: SUCCESS (0.067s)
[429.868587] Starting dynamic subtest: bcs0
[429.913571] Dynamic subtest bcs0: SUCCESS (0.056s)
[429.925348] Starting dynamic subtest: vcs0
[429.973105] Dynamic subtest vcs0: SUCCESS (0.057s)
[429.984939] Starting dynamic subtest: vcs1
[430.032351] Dynamic subtest vcs1: SUCCESS (0.057s)
[430.044296] Starting dynamic subtest: vecs0
[430.091940] Dynamic subtest vecs0: SUCCESS (0.057s)
[430.103484] Starting dynamic subtest: ccs0
[430.149859] Dynamic subtest ccs0: SUCCESS (0.056s)
[430.152560] Subtest nb-await: SUCCESS (0.363s)
[432.023401] [122/132] (591s left) gem_partial_pwrite_pread (writes-after-reads)
[432.093389] Subtest writes-after-reads: SKIP (0.000s)
[432.177236] [123/132] (591s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[432.276980] Starting subtest: fbc-psr2-cursor-mmap-gtt
[432.279276] Starting dynamic subtest: eDP-1
[432.283276] Dynamic subtest eDP-1: SKIP (0.000s)
[432.287287] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[432.379079] [124/132] (591s left) api_intel_allocator (two-level-inception)
[432.436492] Starting subtest: two-level-inception
[437.834193] Subtest two-level-inception: SUCCESS (5.399s)
[437.992845] [125/132] (585s left) sw_sync (timeline_closed)
[438.033288] Starting subtest: timeline_closed
[438.035601] Subtest timeline_closed: SUCCESS (0.000s)
[438.119397] [126/132] (585s left) gem_pxp (reject-modify-context-protection-off-3)
[438.241662] Starting subtest: reject-modify-context-protection-off-3
[438.244140] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[438.407376] [127/132] (585s left) kms_pm_rpm (basic-rte)
[438.441568] Starting subtest: basic-rte
[441.504273] Subtest basic-rte: SUCCESS (3.065s)
[443.324689] [128/132] (580s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[443.452069] Starting subtest: cursor-vs-flip-legacy
[472.790326] Subtest cursor-vs-flip-legacy: SUCCESS (29.339s)
[473.649332] [129/132] (550s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[473.741067] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[473.742933] Starting dynamic subtest: pipe-A-eDP-1
[474.992396] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.252s)
[475.002653] Starting dynamic subtest: pipe-B-eDP-1
[477.401556] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.408s)
[477.417656] Starting dynamic subtest: pipe-C-eDP-1
[479.738146] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.334s)
[479.748667] Starting dynamic subtest: pipe-D-eDP-1
[482.024520] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.284s)
[482.026685] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.285s)
[483.273314] [130/132] (540s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[483.372382] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[483.374629] Starting dynamic subtest: pipe-A-eDP-1
[483.396780] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[483.411059] Starting dynamic subtest: pipe-B-eDP-1
[483.431978] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[483.442313] Starting dynamic subtest: pipe-C-eDP-1
[483.463083] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[483.472669] Starting dynamic subtest: pipe-D-eDP-1
[483.493752] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[483.497661] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[485.547221] [131/132] (538s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[485.604457] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[485.606356] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[485.734089] [132/132] (538s left) kms_vblank (wait-idle)
[485.838061] Starting subtest: wait-idle
[485.840210] Starting dynamic subtest: pipe-A-eDP-1
[487.591074] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.753s)
[487.606334] Starting dynamic subtest: pipe-D-eDP-1
[490.070967] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.476s)
[490.073393] Subtest wait-idle: SUCCESS (4.233s)
[490.909247] 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.