[59.631799] Initializing watchdogs
[59.631845]   /dev/watchdog0
[59.645371] [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]
[59.649845] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.652267] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.655461] [001/134] (960s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[59.793632] Starting subtest: y-tiled-64bpp-rotate-270
[59.798274] Subtest y-tiled-64bpp-rotate-270: SKIP (0.002s)
[59.920295] [002/134] (960s left) gem_exec_reloc (basic-wc-gtt)
[60.001585] Subtest basic-wc-gtt: SKIP (0.000s)
[60.085521] [003/134] (960s left) gem_exec_reloc (basic-active)
[60.149317] Subtest basic-active: SKIP (0.000s)
[60.223746] [004/134] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[60.328188] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[60.332169] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[60.452874] [005/134] (959s left) gem_mmap_wc (copy)
[60.515799] Subtest copy: SKIP (0.000s)
[60.580373] [006/134] (959s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[60.673506] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[60.712042] Starting dynamic subtest: pipe-A-plane-0
[60.989600] Dynamic subtest pipe-A-plane-0: SUCCESS (0.278s)
[60.997418] Starting dynamic subtest: pipe-A-plane-3
[61.222615] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[61.230023] Starting dynamic subtest: pipe-A-plane-5
[61.233781] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[62.273587] Starting dynamic subtest: pipe-B-plane-0
[62.565762] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[62.575445] Starting dynamic subtest: pipe-B-plane-3
[62.798704] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[62.807652] Starting dynamic subtest: pipe-B-plane-5
[62.811884] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[63.106737] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.435s)
[63.966411] [007/134] (956s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[64.034818] Starting subtest: invalid-bsd1-flag-on-blt
[64.037217] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[64.155659] [008/134] (956s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[64.251949] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[65.218631] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.967s)
[65.363563] [009/134] (955s left) kms_lease (simple-lease)
[65.451927] Starting subtest: simple-lease
[65.454183] Starting dynamic subtest: pipe-A-eDP-1
[65.954558] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.503s)
[65.961499] Starting dynamic subtest: pipe-B-eDP-1
[67.386403] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.432s)
[67.394917] Starting dynamic subtest: pipe-C-eDP-1
[68.779539] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.391s)
[68.787184] Starting dynamic subtest: pipe-D-eDP-1
[70.186998] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.409s)
[70.189375] Subtest simple-lease: SUCCESS (4.740s)
[71.002986] [010/134] (949s left) gem_exec_schedule (pi-distinct-iova)
[71.184618] Starting subtest: pi-distinct-iova
[71.186667] Starting dynamic subtest: rcs0
[71.257221] Dynamic subtest rcs0: SUCCESS (0.075s)
[71.267521] Starting dynamic subtest: vcs0
[71.316640] Dynamic subtest vcs0: SUCCESS (0.060s)
[71.326558] Starting dynamic subtest: vcs1
[71.374914] Dynamic subtest vcs1: SUCCESS (0.057s)
[71.384837] Starting dynamic subtest: vecs0
[71.432774] Dynamic subtest vecs0: SUCCESS (0.058s)
[71.442412] Starting dynamic subtest: ccs0
[71.489857] Dynamic subtest ccs0: SUCCESS (0.057s)
[71.492188] Subtest pi-distinct-iova: SUCCESS (0.309s)
[73.058210] [011/134] (947s left) gem_create (create-massive)
[73.108815] Starting subtest: create-massive
[73.110787] Subtest create-massive: SUCCESS (0.000s)
[73.299150] [012/134] (947s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[73.362987] Starting subtest: multi-wait-for-submit-submitted-signaled
[73.365409] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[73.491350] [013/134] (947s left) gem_userptr_blits (dmabuf-sync)
[73.568704] Starting subtest: dmabuf-sync
[73.573168] Subtest dmabuf-sync: SKIP (0.002s)
[73.743779] [014/134] (946s left) kms_psr (psr-cursor-plane-move)
[73.846944] Starting subtest: psr-cursor-plane-move
[73.849311] Starting dynamic subtest: eDP-1
[75.581948] Dynamic subtest eDP-1: SUCCESS (1.735s)
[75.584227] Subtest psr-cursor-plane-move: SUCCESS (1.736s)
[76.449580] [015/134] (944s left) gem_close_race (basic-process)
[76.519729] Starting subtest: basic-process
[76.579189] Subtest basic-process: SUCCESS (0.059s)
[76.780292] [016/134] (943s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[76.875975] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[76.878212] Starting dynamic subtest: pipe-A-default-mode
[77.183802] Dynamic subtest pipe-A-default-mode: SKIP (0.305s)
[77.188538] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.306s)
[78.002505] [017/134] (942s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[78.063141] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[78.170796] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.106s)
[78.253147] [018/134] (942s left) kms_properties (get_properties-sanity-non-atomic)
[78.350981] Starting subtest: get_properties-sanity-non-atomic
[78.353472] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s)
[78.444302] [019/134] (942s left) gem_ctx_param (invalid-param-set)
[78.496413] Starting subtest: invalid-param-set
[78.498766] Subtest invalid-param-set: SUCCESS (0.000s)
[78.579265] [020/134] (942s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[83.558577] Starting subtest: psr2-cursor-plane-update-sf
[83.561058] Starting dynamic subtest: pipe-A-eDP-1
[84.850191] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.288s)
[84.858543] Starting dynamic subtest: pipe-B-eDP-1
[86.182773] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.333s)
[86.185206] Subtest psr2-cursor-plane-update-sf: SUCCESS (2.624s)
[87.068694] [021/134] (933s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[87.175769] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[87.180298] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[87.300765] [022/134] (933s left) drm_read (short-buffer-wakeup)
[87.460323] Starting subtest: short-buffer-wakeup
[119.680189] Subtest short-buffer-wakeup: SUCCESS (32.218s)
[119.862472] [023/134] (901s left) gem_exec_whisper (basic-contexts-priority)
[119.925057] Starting subtest: basic-contexts-priority
[143.427271] Subtest basic-contexts-priority: SUCCESS (23.498s)
[143.619621] [024/134] (877s left) kms_chamelium_frames (dp-crc-multiple)
[144.006287] Subtest dp-crc-multiple: SKIP (0.000s)
[144.785362] [025/134] (876s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[144.843663] Starting subtest: yf-tiled-to-vebox-x-tiled
[144.848299] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[145.036697] [026/134] (876s left) kms_pm_rpm (legacy-planes)
[147.058147] Starting subtest: legacy-planes
[147.060275] Starting dynamic subtest: plane-64
[155.388204] Dynamic subtest plane-64: SUCCESS (8.331s)
[155.399521] Starting dynamic subtest: plane-94
[163.680373] Dynamic subtest plane-94: SUCCESS (8.291s)
[163.690854] Starting dynamic subtest: plane-124
[171.956499] Dynamic subtest plane-124: SUCCESS (8.274s)
[171.968040] Starting dynamic subtest: plane-134
[180.533398] Dynamic subtest plane-134: SUCCESS (8.573s)
[180.536255] Subtest legacy-planes: SUCCESS (33.477s)
[180.924192] [027/134] (840s left) kms_pm_rpm (system-suspend-modeset)
[183.057322] Starting subtest: system-suspend-modeset
[203.145828] Subtest system-suspend-modeset: SUCCESS (4.513s)
[203.520552] [028/134] (817s left) gem_exec_reloc (basic-wc-cpu)
[203.606090] Subtest basic-wc-cpu: SKIP (0.000s)
[203.688288] [029/134] (817s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[208.838188] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[208.843918] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.003s)
[209.697714] [030/134] (811s left) kms_flip (absolute-wf_vblank-interruptible)
[209.796171] Starting subtest: absolute-wf_vblank-interruptible
[209.798780] Starting dynamic subtest: A-eDP1
[218.519159] Dynamic subtest A-eDP1: SUCCESS (8.747s)
[218.529231] Starting dynamic subtest: B-eDP1
[227.240667] Dynamic subtest B-eDP1: SUCCESS (8.731s)
[227.251114] Starting dynamic subtest: C-eDP1
[235.958996] Dynamic subtest C-eDP1: SUCCESS (8.722s)
[235.970261] Starting dynamic subtest: D-eDP1
[244.685210] Dynamic subtest D-eDP1: SUCCESS (8.730s)
[244.688057] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.939s)
[245.909139] [031/134] (775s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[245.968366] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[246.031695] [032/134] (775s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[246.131563] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[253.075640] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.950s)
[253.208093] [033/134] (768s left) i915_drm_fdinfo (virtual-busy-all)
[253.252153] Starting subtest: virtual-busy-all
[253.257231] Subtest virtual-busy-all: SKIP (0.000s)
[253.328619] [034/134] (768s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[253.438404] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[260.024885] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.593s)
[260.159807] [035/134] (761s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[260.272910] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[261.351239] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.080s)
[261.508803] [036/134] (759s left) gem_exec_balancer (parallel)
[261.776078] Starting subtest: parallel
[262.671950] Subtest parallel: SUCCESS (0.896s)
[263.540061] [037/134] (757s left) gem_ctx_param (vm)
[263.595922] Starting subtest: vm
[263.651958] Subtest vm: SUCCESS (0.056s)
[263.798775] [038/134] (757s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[263.893481] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[263.898659] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[263.993101] [039/134] (757s left) gem_softpin (full)
[264.047485] Starting subtest: full
[264.056078] Subtest full: SUCCESS (0.009s)
[264.207099] [040/134] (757s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[264.309955] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[264.314851] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[264.421619] [041/134] (757s left) gem_pread (uncached)
[264.484152] Subtest uncached: SKIP (0.000s)
[264.553615] [042/134] (757s left) kms_psr (psr-sprite-mmap-gtt)
[264.655531] Starting subtest: psr-sprite-mmap-gtt
[264.657812] Starting dynamic subtest: eDP-1
[266.091961] Dynamic subtest eDP-1: SKIP (1.435s)
[266.096957] Subtest psr-sprite-mmap-gtt: SKIP (1.437s)
[266.302436] [043/134] (755s left) i915_pm_rpm (debugfs-forcewake-user)
[267.834516] Starting subtest: debugfs-forcewake-user
[279.216020] Subtest debugfs-forcewake-user: SUCCESS (11.387s)
[279.626283] [044/134] (742s left) gem_ccs (block-multicopy-inplace)
[279.704150] Starting subtest: block-multicopy-inplace
[279.710226] Subtest block-multicopy-inplace: SKIP (0.000s)
[279.832835] [045/134] (742s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[279.895167] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[279.997993] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.104s)
[280.085813] [046/134] (741s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[280.197160] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[280.202366] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[280.318965] [047/134] (741s left) gem_ctx_shared (exec-single-timeline)
[280.383837] Starting subtest: exec-single-timeline
[280.386276] Starting dynamic subtest: rcs0
[281.438144] Dynamic subtest rcs0: SUCCESS (1.053s)
[281.448545] Starting dynamic subtest: bcs0
[282.526603] Dynamic subtest bcs0: SUCCESS (1.086s)
[282.538391] Starting dynamic subtest: vcs0
[283.615259] Dynamic subtest vcs0: SUCCESS (1.087s)
[283.628040] Starting dynamic subtest: vcs1
[284.702399] Dynamic subtest vcs1: SUCCESS (1.085s)
[284.714283] Starting dynamic subtest: vecs0
[285.791136] Dynamic subtest vecs0: SUCCESS (1.086s)
[285.803151] Starting dynamic subtest: ccs0
[286.879920] Dynamic subtest ccs0: SUCCESS (1.085s)
[286.883003] Subtest exec-single-timeline: SUCCESS (6.499s)
[287.535588] [048/134] (734s left) gem_mmap_wc (write-read)
[287.605161] Subtest write-read: SKIP (0.000s)
[287.666969] [049/134] (734s left) kms_psr (pr-suspend)
[287.766138] Starting subtest: pr-suspend
[287.771156] Subtest pr-suspend: SKIP (0.000s)
[287.865658] [050/134] (734s left) kms_debugfs (display-off-read-all)
[287.963677] Starting subtest: display-off-read-all
[288.254563] Subtest display-off-read-all: SUCCESS (0.293s)
[289.113839] [051/134] (733s left) gem_exec_params (invalid-flag)
[289.188224] Starting subtest: invalid-flag
[289.191238] Subtest invalid-flag: SUCCESS (0.000s)
[289.309788] [052/134] (732s left) kms_cursor_crc (cursor-sliding-128x42)
[289.535788] Starting subtest: cursor-sliding-128x42
[289.584359] Subtest cursor-sliding-128x42: SKIP (0.043s)
[289.820399] [053/134] (732s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-gtt)
[289.924380] Starting subtest: psr-abgr161616f-draw-mmap-gtt
[289.929363] Subtest psr-abgr161616f-draw-mmap-gtt: SKIP (0.000s)
[290.015388] [054/134] (732s left) sysfs_defaults (readonly)
[290.069982] Starting subtest: readonly
[290.072177] Starting dynamic subtest: vecs0
[290.074261] Dynamic subtest vecs0: SUCCESS (0.000s)
[290.083398] Starting dynamic subtest: ccs0
[290.085788] Dynamic subtest ccs0: SUCCESS (0.000s)
[290.093800] Starting dynamic subtest: vcs0
[290.096063] Dynamic subtest vcs0: SUCCESS (0.000s)
[290.104125] Starting dynamic subtest: bcs0
[290.106433] Dynamic subtest bcs0: SUCCESS (0.000s)
[290.114220] Starting dynamic subtest: rcs0
[290.116996] Dynamic subtest rcs0: SUCCESS (0.000s)
[290.125378] Starting dynamic subtest: vcs1
[290.127515] Dynamic subtest vcs1: SUCCESS (0.000s)
[290.129665] Subtest readonly: SUCCESS (0.005s)
[290.188642] [055/134] (732s left) kms_plane_multiple (tiling-4)
[290.286984] Starting subtest: tiling-4
[290.289007] Starting dynamic subtest: pipe-A-eDP-1
[293.968248] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.683s)
[293.979032] Starting dynamic subtest: pipe-B-eDP-1
[298.410953] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.441s)
[298.421281] Starting dynamic subtest: pipe-C-eDP-1
[302.749094] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.342s)
[302.758513] Starting dynamic subtest: pipe-D-eDP-1
[307.072284] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.324s)
[307.075021] Subtest tiling-4: SUCCESS (16.795s)
[307.891764] [056/134] (714s left) kms_async_flips (invalid-async-flip-atomic)
[307.989160] Starting subtest: invalid-async-flip-atomic
[308.359155] Starting dynamic subtest: pipe-A-eDP-1
[309.208199] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.850s)
[309.585084] Starting dynamic subtest: pipe-B-eDP-1
[310.351287] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.775s)
[310.719219] Starting dynamic subtest: pipe-C-eDP-1
[311.475113] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.760s)
[311.824645] Starting dynamic subtest: pipe-D-eDP-1
[312.632110] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.815s)
[312.634671] Subtest invalid-async-flip-atomic: SUCCESS (4.648s)
[313.789925] [057/134] (708s left) gem_exec_reloc (basic-range-active)
[313.857387] Subtest basic-range-active: SKIP (0.000s)
[313.928666] [058/134] (708s left) i915_query (query-regions-garbage-items)
[313.990205] Starting subtest: query-regions-garbage-items
[313.993078] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[314.101010] [059/134] (708s left) gem_exec_fence (basic-busy)
[314.271063] Starting subtest: basic-busy
[314.274404] Starting dynamic subtest: rcs0
[314.373081] Dynamic subtest rcs0: SUCCESS (0.100s)
[314.384186] Starting dynamic subtest: bcs0
[314.436521] Dynamic subtest bcs0: SUCCESS (0.063s)
[314.448243] Starting dynamic subtest: vcs0
[314.499498] Dynamic subtest vcs0: SUCCESS (0.061s)
[314.511409] Starting dynamic subtest: vcs1
[314.565535] Dynamic subtest vcs1: SUCCESS (0.064s)
[314.576372] Starting dynamic subtest: vecs0
[314.624601] Dynamic subtest vecs0: SUCCESS (0.057s)
[314.635637] Starting dynamic subtest: ccs0
[314.690608] Dynamic subtest ccs0: SUCCESS (0.064s)
[314.693341] Subtest basic-busy: SUCCESS (0.421s)
[316.617701] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[316.621319] [060/134] (705s left) gem_partial_pwrite_pread (reads-display)
[316.693220] Subtest reads-display: SKIP (0.000s)
[316.770705] [061/134] (705s left) kms_pipe_crc_basic (suspend-read-crc)
[316.867039] Starting subtest: suspend-read-crc
[316.869130] Starting dynamic subtest: pipe-A-eDP-1
[334.804109] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.564s)
[334.813176] Starting dynamic subtest: pipe-B-eDP-1
[352.818031] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.178s)
[352.828198] Starting dynamic subtest: pipe-C-eDP-1
[370.744453] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.103s)
[370.754618] Starting dynamic subtest: pipe-D-eDP-1
[388.748517] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.025s)
[388.751380] Subtest suspend-read-crc: SUCCESS (11.876s)
[389.581077] [062/134] (632s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[389.684703] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[389.687178] Starting dynamic subtest: pipe-A-eDP-1
[389.708268] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[389.718188] Starting dynamic subtest: pipe-B-eDP-1
[389.742905] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[389.753072] Starting dynamic subtest: pipe-C-eDP-1
[389.775719] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[389.784290] Starting dynamic subtest: pipe-D-eDP-1
[389.807389] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[389.810292] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[391.925767] [063/134] (630s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[392.025362] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[398.933806] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.943s)
[399.046749] [064/134] (623s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[399.178328] Starting subtest: basic-flip-before-cursor-varying-size
[400.113486] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.939s)
[400.974639] [065/134] (621s left) kms_addfb_basic (bad-pitch-32)
[401.025494] Starting subtest: bad-pitch-32
[401.028108] Subtest bad-pitch-32: SUCCESS (0.000s)
[401.187723] [066/134] (621s left) kms_atomic_transition (plane-all-transition)
[401.291485] Starting subtest: plane-all-transition
[401.293900] Starting dynamic subtest: pipe-A-eDP-1
[403.780284] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[404.088685] Starting dynamic subtest: pipe-B-eDP-1
[407.289532] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.214s)
[407.591148] Subtest plane-all-transition: SUCCESS (6.310s)
[408.423806] [067/134] (614s left) gem_ctx_persistence (legacy-engines-cleanup)
[408.497365] Starting subtest: legacy-engines-cleanup
[408.500076] Starting dynamic subtest: render
[408.578502] Dynamic subtest render: SUCCESS (0.085s)
[408.590135] Starting dynamic subtest: bsd1
[408.628545] Dynamic subtest bsd1: SUCCESS (0.047s)
[408.638742] Starting dynamic subtest: bsd2
[408.679521] Dynamic subtest bsd2: SUCCESS (0.049s)
[408.689818] Starting dynamic subtest: blt
[408.726518] Dynamic subtest blt: SUCCESS (0.045s)
[408.736359] Starting dynamic subtest: vebox
[408.750554] Dynamic subtest vebox: SUCCESS (0.022s)
[408.753516] Subtest legacy-engines-cleanup: SUCCESS (0.258s)
[408.893477] [068/134] (613s left) i915_drm_fdinfo (virtual-busy-idle)
[408.944495] Starting subtest: virtual-busy-idle
[408.949351] Subtest virtual-busy-idle: SKIP (0.000s)
[409.031880] [069/134] (613s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[409.128504] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[409.133354] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[409.227851] [070/134] (613s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[409.325314] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[409.335422] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.010s)
[409.463338] [071/134] (613s left) gen9_exec_parse (bb-start-out)
[409.513119] Subtest bb-start-out: SKIP (0.000s)
[409.571001] [072/134] (613s left) gem_sync (basic-store-each)
[409.652311] Starting subtest: basic-store-each
[411.922713] Subtest basic-store-each: SUCCESS (2.282s)
[412.126291] [073/134] (610s left) api_intel_bb (reset-flags)
[412.193968] Starting subtest: reset-flags
[412.211399] Subtest reset-flags: SUCCESS (0.019s)
[412.351424] [074/134] (610s left) kms_psr (fbc-psr2-primary-page-flip)
[412.453537] Starting subtest: fbc-psr2-primary-page-flip
[412.455936] Starting dynamic subtest: eDP-1
[412.460385] Dynamic subtest eDP-1: SKIP (0.000s)
[412.464538] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[412.536177] [075/134] (610s left) kms_psr (fbc-pr-dpms)
[412.631074] Starting subtest: fbc-pr-dpms
[412.635612] Subtest fbc-pr-dpms: SKIP (0.000s)
[412.712648] [076/134] (610s left) kms_vrr (negative-basic)
[412.799923] Starting subtest: negative-basic
[412.806327] Starting dynamic subtest: pipe-A-eDP-1
[418.219719] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.416s)
[418.516088] Subtest negative-basic: SUCCESS (5.723s)
[419.360290] [077/134] (603s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[419.461389] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[419.472367] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[419.565204] [078/134] (603s left) kms_chamelium_hpd (dp-hpd)
[419.961386] Subtest dp-hpd: SKIP (0.000s)
[420.770354] [079/134] (602s left) gem_lmem_swapping (heavy-verify-random)
[420.812448] Subtest heavy-verify-random: SKIP (0.000s)
[420.860039] [080/134] (602s left) syncobj_basic (bad-pad-handle-to-fd)
[420.918451] Starting subtest: bad-pad-handle-to-fd
[420.921329] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[421.046609] [081/134] (602s left) gem_mmap_gtt (fault-concurrent-y)
[421.095338] Subtest fault-concurrent-Y: SKIP (0.000s)
[421.173089] [082/134] (602s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[421.271485] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[428.546981] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.276s)
[428.716825] [083/134] (594s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[428.789030] Starting subtest: x-tiled-to-vebox-y-tiled
[428.794312] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[428.986099] [084/134] (594s left) gem_userptr_blits (userfault)
[429.048291] Starting subtest: userfault
[429.050569] Subtest userfault: SUCCESS (0.007s)
[429.197803] [085/134] (594s left) gem_exec_schedule (promotion)
[429.272059] Starting subtest: promotion
[429.274548] Starting dynamic subtest: rcs0
[429.368010] Dynamic subtest rcs0: SUCCESS (0.106s)
[429.379414] Starting dynamic subtest: vcs0
[429.454807] Dynamic subtest vcs0: SUCCESS (0.086s)
[429.466951] Starting dynamic subtest: vcs1
[429.544347] Dynamic subtest vcs1: SUCCESS (0.089s)
[429.555109] Starting dynamic subtest: vecs0
[429.632256] Dynamic subtest vecs0: SUCCESS (0.087s)
[429.643882] Starting dynamic subtest: ccs0
[429.727423] Dynamic subtest ccs0: SUCCESS (0.095s)
[429.730428] Subtest promotion: SUCCESS (0.466s)
[430.719949] [086/134] (592s left) kms_chamelium_color (ctm-0-50)
[430.818512] Subtest ctm-0-50: SKIP (0.000s)
[430.865186] [087/134] (592s left) syncobj_timeline (invalid-transfer-illegal-handle)
[430.914375] Starting subtest: invalid-transfer-illegal-handle
[430.917038] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[431.023691] [088/134] (592s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[431.121268] Starting subtest: yf-tiled-64bpp-rotate-90
[431.125762] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[431.250903] [089/134] (592s left) api_intel_bb (blit-noreloc-purge-cache)
[431.312075] Starting subtest: blit-noreloc-purge-cache
[431.321394] Subtest blit-noreloc-purge-cache: SUCCESS (0.012s)
[431.492658] [090/134] (592s left) kms_feature_discovery (display-2x)
[431.589378] Starting subtest: display-2x
[431.594207] Subtest display-2x: SKIP (0.000s)
[431.684969] [091/134] (592s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[431.780152] Starting subtest: plane-lut1d-ctm3x4-lut1d
[431.793653] Starting dynamic subtest: pipe-A-eDP-1
[432.488149] Dynamic subtest pipe-A-eDP-1: FAIL (0.314s)
[433.204062] Starting dynamic subtest: pipe-B-eDP-1
[434.185293] Dynamic subtest pipe-B-eDP-1: FAIL (0.334s)
[434.626386] Starting dynamic subtest: pipe-C-eDP-1
[435.582364] Dynamic subtest pipe-C-eDP-1: FAIL (0.256s)
[435.958079] Starting dynamic subtest: pipe-D-eDP-1
[436.894038] Dynamic subtest pipe-D-eDP-1: FAIL (0.255s)
[436.896318] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.714s)
[437.361206] [092/134] (586s left) sriov_basic (bind-unbind-vf)
[437.432683] Starting subtest: bind-unbind-vf
[437.434757] Starting dynamic subtest: vf-1
[437.519336] Dynamic subtest vf-1: FAIL (0.005s)
[437.528097] Starting dynamic subtest: vf-2
[437.604740] Dynamic subtest vf-2: FAIL (0.004s)
[437.613242] Starting dynamic subtest: vf-3
[437.691174] Dynamic subtest vf-3: FAIL (0.003s)
[437.700151] Starting dynamic subtest: vf-4
[437.775298] Dynamic subtest vf-4: FAIL (0.003s)
[437.784260] Starting dynamic subtest: vf-5
[437.862362] Dynamic subtest vf-5: FAIL (0.004s)
[437.873520] Starting dynamic subtest: vf-6
[437.960121] Dynamic subtest vf-6: FAIL (0.003s)
[437.970632] Starting dynamic subtest: vf-7
[438.052510] Dynamic subtest vf-7: FAIL (0.003s)
[438.061671] Starting dynamic subtest: vf-random
[438.138057] Dynamic subtest vf-random: FAIL (0.003s)
[438.146379] Starting dynamic subtest: vf-last
[438.223011] Dynamic subtest vf-last: FAIL (0.553s)
[438.225202] Subtest bind-unbind-vf: FAIL (0.589s)
[438.261838] [093/134] (585s left) gem_eio (wait-immediate)
[438.505942] Starting subtest: wait-immediate
[438.888961] Subtest wait-immediate: SUCCESS (0.385s)
[439.052849] [094/134] (584s left) gem_mmap_gtt (coherency)
[439.113779] Subtest coherency: SKIP (0.000s)
[439.164878] [095/134] (584s left) syncobj_timeline (wait-delayed-signal)
[439.217195] Starting subtest: wait-delayed-signal
[439.321448] Subtest wait-delayed-signal: SUCCESS (0.103s)
[439.412292] [096/134] (584s left) perf (i915-ref-count)
[439.481627] Starting subtest: i915-ref-count
[439.539645] Subtest i915-ref-count: SUCCESS (0.059s)
[439.596822] [097/134] (584s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[439.729190] Starting subtest: flip-vs-cursor-varying-size
[448.231432] Subtest flip-vs-cursor-varying-size: SUCCESS (8.504s)
[449.093131] [098/134] (574s left) kms_pm_backlight (bad-brightness)
[449.189383] Starting subtest: bad-brightness
[449.241106] Starting dynamic subtest: eDP-1
[449.551407] Dynamic subtest eDP-1: SUCCESS (0.309s)
[449.554328] Subtest bad-brightness: SUCCESS (0.362s)
[450.439529] [099/134] (573s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[450.538404] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[450.541361] Starting dynamic subtest: pipe-A
[450.649905] Dynamic subtest pipe-A: SKIP (0.108s)
[450.659487] Starting dynamic subtest: pipe-B
[451.789761] Dynamic subtest pipe-B: SKIP (1.138s)
[451.800204] Starting dynamic subtest: pipe-C
[452.925144] Dynamic subtest pipe-C: SUCCESS (1.142s)
[452.935655] Starting dynamic subtest: pipe-D
[454.068228] Dynamic subtest pipe-D: SUCCESS (1.143s)
[454.070846] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.534s)
[455.265112] [100/134] (568s left) gem_exec_reloc (basic-write-wc)
[455.331953] Subtest basic-write-wc: SKIP (0.000s)
[455.400882] [101/134] (568s left) gem_userptr_blits (unsync-unmap-after-close)
[455.466863] Subtest unsync-unmap-after-close: SKIP (0.000s)
[455.583235] [102/134] (568s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[455.683534] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[455.686196] Starting dynamic subtest: pipe-A-eDP-1
[455.713637] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[455.724083] Starting dynamic subtest: pipe-B-eDP-1
[455.750343] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[455.759534] Starting dynamic subtest: pipe-C-eDP-1
[455.785368] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[455.794441] Starting dynamic subtest: pipe-D-eDP-1
[455.820278] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[455.825184] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[457.932034] [103/134] (566s left) kms_force_connector_basic (prune-stale-modes)
[458.005270] Starting subtest: prune-stale-modes
[458.446836] Subtest prune-stale-modes: SUCCESS (0.441s)
[458.601688] [104/134] (565s left) kms_joiner (invalid-modeset-ultra-joiner)
[458.699310] Starting subtest: invalid-modeset-ultra-joiner
[458.704168] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[458.777782] [105/134] (565s left) kms_vblank (wait-forked-busy)
[458.872554] Starting subtest: wait-forked-busy
[458.875078] Starting dynamic subtest: pipe-A-eDP-1
[460.755064] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.878s)
[460.771304] Starting dynamic subtest: pipe-D-eDP-1
[463.275540] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.522s)
[463.278333] Subtest wait-forked-busy: SUCCESS (4.403s)
[464.162780] [106/134] (560s left) syncobj_wait (wait-all-interrupted)
[464.222560] Starting subtest: wait-all-interrupted
[464.323788] Subtest wait-all-interrupted: SUCCESS (0.102s)
[464.415990] [107/134] (560s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[464.528147] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[464.530835] Starting dynamic subtest: pipe-A-eDP-1
[464.558407] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[464.569237] Starting dynamic subtest: pipe-B-eDP-1
[464.594389] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[464.603966] Starting dynamic subtest: pipe-C-eDP-1
[464.629454] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[464.639282] Starting dynamic subtest: pipe-D-eDP-1
[464.666997] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[464.672086] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.009s)
[466.844775] [108/134] (557s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[466.957493] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[466.960257] Starting dynamic subtest: pipe-A-eDP-1
[466.987205] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[466.997522] Starting dynamic subtest: pipe-B-eDP-1
[467.023387] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[467.032691] Starting dynamic subtest: pipe-C-eDP-1
[467.058385] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[467.067358] Starting dynamic subtest: pipe-D-eDP-1
[467.093170] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[467.098320] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[469.249894] [109/134] (555s left) kms_content_protection (type1)
[469.409326] Starting subtest: type1
[469.414356] Subtest type1: SKIP (0.000s)
[469.566880] [110/134] (555s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[469.633299] Starting subtest: basic-batch-kernel-default-cmd
[469.639066] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[469.830646] [111/134] (554s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[469.932316] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[469.935054] Starting dynamic subtest: pipe-A-eDP-1
[469.961824] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[469.972352] Starting dynamic subtest: pipe-B-eDP-1
[469.995438] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[470.004829] Starting dynamic subtest: pipe-C-eDP-1
[470.028289] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[470.036963] Starting dynamic subtest: pipe-D-eDP-1
[470.060401] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[470.064958] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[472.137888] [112/134] (552s left) kms_frontbuffer_tracking (psr-1p-rte)
[472.250877] Starting subtest: psr-1p-rte
[477.541702] Subtest psr-1p-rte: SUCCESS (5.297s)
[477.713280] [113/134] (546s left) kms_vblank (query-forked-busy-hang)
[477.805495] Starting subtest: query-forked-busy-hang
[477.807961] Starting dynamic subtest: pipe-A-eDP-1
[504.394554] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.581s)
[504.410492] Starting dynamic subtest: pipe-D-eDP-1
[519.375897] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.978s)
[519.378529] Subtest query-forked-busy-hang: SUCCESS (41.564s)
[520.246686] [114/134] (504s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[520.345911] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[520.348523] Starting dynamic subtest: pipe-A-default-mode
[520.642798] Dynamic subtest pipe-A-default-mode: SKIP (0.294s)
[520.647367] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.296s)
[521.464451] [115/134] (503s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[521.567269] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[521.572499] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[521.675880] [116/134] (503s left) gem_ppgtt (shrink-vs-evict-any)
[521.736371] Starting subtest: shrink-vs-evict-any
[527.657776] Subtest shrink-vs-evict-any: SUCCESS (5.921s)
[527.768305] [117/134] (497s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[528.440325] Starting subtest: syncobj-timeline-invalid-wait
[528.446367] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.007s)
[529.642291] [118/134] (495s left) kms_async_flips (crc)
[529.739362] Starting subtest: crc
[530.126332] Starting dynamic subtest: pipe-A-eDP-1
[533.003390] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.875s)
[533.390091] Starting dynamic subtest: pipe-B-eDP-1
[536.329182] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.948s)
[536.711153] Starting dynamic subtest: pipe-C-eDP-1
[539.588818] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.887s)
[539.953959] Starting dynamic subtest: pipe-D-eDP-1
[542.797828] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.855s)
[542.800363] Subtest crc: SUCCESS (13.062s)
[544.037796] [119/134] (480s left) gem_lmem_swapping (parallel-random-verify-ccs)
[544.084045] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[544.136865] [120/134] (480s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[544.237182] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[544.242419] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[544.359455] [121/134] (480s left) perf_pmu (busy-start)
[544.404496] Starting subtest: busy-start
[544.407295] Starting dynamic subtest: rcs0
[546.958666] Dynamic subtest rcs0: SUCCESS (2.554s)
[546.971520] Starting dynamic subtest: bcs0
[549.510837] Dynamic subtest bcs0: SUCCESS (2.549s)
[549.522251] Starting dynamic subtest: vcs0
[552.581423] Dynamic subtest vcs0: SUCCESS (3.067s)
[552.594523] Starting dynamic subtest: vcs1
[556.611417] Dynamic subtest vcs1: SUCCESS (4.029s)
[556.643429] Starting dynamic subtest: vecs0
[560.580396] Dynamic subtest vecs0: SUCCESS (3.967s)
[560.592535] Starting dynamic subtest: ccs0
[563.131491] Dynamic subtest ccs0: SUCCESS (2.550s)
[563.134525] Subtest busy-start: SUCCESS (18.731s)
[563.237847] [122/134] (461s left) gem_exec_params (no-blt)
[563.301272] Starting subtest: no-blt
[563.307408] Subtest no-blt: SUCCESS (0.006s)
[563.449446] [123/134] (461s left) gem_exec_flush (basic-uc-rw-default)
[563.511982] Starting subtest: basic-uc-rw-default
[568.970987] Subtest basic-uc-rw-default: SUCCESS (5.459s)
[569.171597] [124/134] (456s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[569.274022] Starting subtest: x-tiled-8bpp-rotate-180
[570.510353] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.237s)
[570.655233] [125/134] (454s left) gem_userptr_blits (map-fixed-invalidate-busy)
[570.722686] Starting subtest: map-fixed-invalidate-busy
[570.727289] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[570.854915] [126/134] (454s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[570.946716] Starting subtest: flip-vs-dpms-on-nop-interruptible
[570.948726] Starting dynamic subtest: A-eDP1
[572.783211] Dynamic subtest A-eDP1: SUCCESS (1.835s)
[572.794078] Starting dynamic subtest: B-eDP1
[574.696198] Dynamic subtest B-eDP1: SUCCESS (1.912s)
[574.708188] Starting dynamic subtest: C-eDP1
[576.560380] Dynamic subtest C-eDP1: SUCCESS (1.863s)
[576.570513] Starting dynamic subtest: D-eDP1
[578.376523] Dynamic subtest D-eDP1: SUCCESS (1.815s)
[578.379266] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.434s)
[579.635334] [127/134] (445s left) kms_cursor_edge_walk (128x128-right-edge)
[579.736197] Starting subtest: 128x128-right-edge
[579.738773] Starting dynamic subtest: pipe-A-eDP-1
[583.155689] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.419s)
[583.166248] Starting dynamic subtest: pipe-D-eDP-1
[586.331902] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.176s)
[586.334410] Subtest 128x128-right-edge: SUCCESS (6.598s)
[587.135248] [128/134] (438s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[587.247536] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[587.253406] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[587.360271] [129/134] (438s left) kms_frontbuffer_tracking (fbc-suspend)
[587.460458] Starting subtest: fbc-suspend
[625.363729] Subtest fbc-suspend: SUCCESS (7.478s)
[626.508398] [130/134] (398s left) gem_softpin (noreloc)
[626.577188] Starting subtest: noreloc
[631.937703] Subtest noreloc: SUCCESS (5.385s)
[632.100723] [131/134] (393s left) kms_psr (fbc-psr-sprite-blt)
[632.213938] Starting subtest: fbc-psr-sprite-blt
[632.216462] Starting dynamic subtest: eDP-1
[632.221348] Dynamic subtest eDP-1: SKIP (0.000s)
[632.226723] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[632.308914] [132/134] (393s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[632.422242] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[633.409453] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.990s)
[633.553842] [133/134] (392s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[633.659206] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[633.663698] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[633.780914] [134/134] (391s left) kms_cursor_crc (cursor-onscreen-128x42)
[633.987537] Starting subtest: cursor-onscreen-128x42
[634.034659] Subtest cursor-onscreen-128x42: SKIP (0.043s)
[634.234458] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: gem_exec_reloc
results: parsing output: 2/ for test: gem_exec_reloc
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_mmap_wc
results: parsing output: 5/ for test: kms_plane
results: parsing output: 6/ for test: gem_exec_params
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_lease
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: gem_create
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: gem_userptr_blits
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: gem_close_race
results: parsing output: 15/ for test: kms_flip_scaled_crc
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: kms_properties
results: parsing output: 18/ for test: gem_ctx_param
results: parsing output: 19/ for test: kms_psr2_sf
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: drm_read
results: parsing output: 22/ for test: gem_exec_whisper
results: parsing output: 23/ for test: kms_chamelium_frames
results: parsing output: 24/ for test: gem_render_copy
results: parsing output: 25/ for test: kms_pm_rpm
results: parsing output: 26/ for test: kms_pm_rpm
results: parsing output: 27/ for test: gem_exec_reloc
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: kms_pipe_b_c_ivb
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: i915_drm_fdinfo
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: gem_exec_balancer
results: parsing output: 36/ for test: gem_ctx_param
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_softpin
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_pread
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: i915_pm_rpm
results: parsing output: 43/ for test: gem_ccs
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_ctx_shared
results: parsing output: 47/ for test: gem_mmap_wc
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_debugfs
results: parsing output: 50/ for test: gem_exec_params
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: sysfs_defaults
results: parsing output: 54/ for test: kms_plane_multiple
results: parsing output: 55/ for test: kms_async_flips
results: parsing output: 56/ for test: gem_exec_reloc
results: parsing output: 57/ for test: i915_query
results: parsing output: 58/ for test: gem_exec_fence
results: parsing output: 59/ for test: gem_partial_pwrite_pread
results: parsing output: 60/ for test: kms_pipe_crc_basic
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: kms_addfb_basic
results: parsing output: 65/ for test: kms_atomic_transition
results: parsing output: 66/ for test: gem_ctx_persistence
results: parsing output: 67/ for test: i915_drm_fdinfo
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: gen9_exec_parse
results: parsing output: 71/ for test: gem_sync
results: parsing output: 72/ for test: api_intel_bb
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_vrr
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: kms_chamelium_hpd
results: parsing output: 78/ for test: gem_lmem_swapping
results: parsing output: 79/ for test: syncobj_basic
results: parsing output: 80/ for test: gem_mmap_gtt
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_render_copy
results: parsing output: 83/ for test: gem_userptr_blits
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: kms_chamelium_color
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: api_intel_bb
results: parsing output: 89/ for test: kms_feature_discovery
results: parsing output: 90/ for test: kms_color_pipeline
results: parsing output: 91/ for test: sriov_basic
results: parsing output: 92/ for test: gem_eio
results: parsing output: 93/ for test: gem_mmap_gtt
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: perf
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: kms_pm_backlight
results: parsing output: 98/ for test: kms_plane_scaling
results: parsing output: 99/ for test: gem_exec_reloc
results: parsing output: 100/ for test: gem_userptr_blits
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_force_connector_basic
results: parsing output: 103/ for test: kms_joiner
results: parsing output: 104/ for test: kms_vblank
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_content_protection
results: parsing output: 109/ for test: gem_exec_flush
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_vblank
results: parsing output: 113/ for test: kms_flip_scaled_crc
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_ppgtt
results: parsing output: 116/ for test: gem_exec_fence
results: parsing output: 117/ for test: kms_async_flips
results: parsing output: 118/ for test: gem_lmem_swapping
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: perf_pmu
results: parsing output: 121/ for test: gem_exec_params
results: parsing output: 122/ for test: gem_exec_flush
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_userptr_blits
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: kms_cursor_edge_walk
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_softpin
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_cursor_crc
Done.