[44.832236] Initializing watchdogs
[44.832302]   /dev/watchdog0
[44.848169] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[44.854226] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[44.856658] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[44.858487] [001/133] (960s left) api_intel_bb (full-batch)
[44.895944] Starting subtest: full-batch
[44.899815] Subtest full-batch: SUCCESS (0.004s)
[44.994645] [002/133] (960s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[45.094163] Starting subtest: x-tiled-64bpp-rotate-90
[45.153414] Subtest x-tiled-64bpp-rotate-90: SKIP (0.058s)
[45.242702] [003/133] (960s left) vgem_basic (second-client)
[45.303139] Starting subtest: second-client
[45.319893] Subtest second-client: SUCCESS (0.017s)
[45.398079] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true
[45.399498] [004/133] (960s left) i915_drm_fdinfo (context-close-stress)
[45.437365] Starting subtest: context-close-stress
[56.128443] Subtest context-close-stress: SUCCESS (10.745s)
[56.172109] [005/133] (949s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[56.260602] Starting subtest: primary-yf-tiled-reflect-x-90
[56.316516] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.055s)
[56.413574] [006/133] (949s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[56.499796] Starting subtest: addfb25-framebuffer-vs-set-tiling
[56.500511] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[56.592429] [007/133] (949s left) gen9_exec_parse (basic-rejected-ctx-param)
[56.629386] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[56.667692] [008/133] (948s left) kms_flip (flip-vs-panning-interruptible)
[56.757410] Starting subtest: flip-vs-panning-interruptible
[56.759238] Starting dynamic subtest: A-HDMI-A1
[64.466018] Dynamic subtest A-HDMI-A1: SUCCESS (7.727s)
[64.477316] Starting dynamic subtest: B-HDMI-A1
[72.126203] Dynamic subtest B-HDMI-A1: SUCCESS (7.665s)
[72.135572] Starting dynamic subtest: C-HDMI-A1
[79.788971] Dynamic subtest C-HDMI-A1: SUCCESS (7.665s)
[79.802749] Starting dynamic subtest: D-HDMI-A1
[87.439291] Dynamic subtest D-HDMI-A1: SUCCESS (7.649s)
[87.443819] Subtest flip-vs-panning-interruptible: SUCCESS (30.718s)
[87.592394] [009/133] (918s left) gem_exec_schedule (manyslice)
[87.642831] Starting subtest: manyslice
[87.643596] Starting dynamic subtest: rcs0
[88.201682] Dynamic subtest rcs0: SUCCESS (0.547s)
[88.207875] Starting dynamic subtest: bcs0
[88.544619] Dynamic subtest bcs0: SUCCESS (0.346s)
[88.551615] Starting dynamic subtest: vcs0
[88.935910] Dynamic subtest vcs0: SUCCESS (0.391s)
[88.948615] Starting dynamic subtest: vcs1
[89.273751] Dynamic subtest vcs1: SUCCESS (0.337s)
[89.286066] Starting dynamic subtest: vecs0
[89.630494] Dynamic subtest vecs0: SUCCESS (0.354s)
[89.631224] Subtest manyslice: SUCCESS (1.978s)
[89.920824] [010/133] (915s left) kms_joiner (basic-max-non-joiner)
[90.008901] Starting subtest: basic-max-non-joiner
[90.010319] Subtest basic-max-non-joiner: SKIP (0.000s)
[90.064935] [011/133] (915s left) syncobj_timeline (host-signal-points)
[90.098715] Starting subtest: host-signal-points
[90.105720] Subtest host-signal-points: SUCCESS (0.007s)
[90.167978] [012/133] (915s left) kms_cursor_legacy (single-move)
[90.252858] Starting subtest: single-move
[90.253580] Starting dynamic subtest: pipe-A
[95.667443] Dynamic subtest pipe-A: SUCCESS (5.380s)
[95.672818] Starting dynamic subtest: pipe-B
[101.046362] Dynamic subtest pipe-B: SUCCESS (5.379s)
[101.051880] Starting dynamic subtest: pipe-C
[106.425249] Dynamic subtest pipe-C: SUCCESS (5.378s)
[106.430995] Starting dynamic subtest: pipe-D
[111.804013] Dynamic subtest pipe-D: SUCCESS (5.378s)
[111.809673] Starting dynamic subtest: all-pipes
[117.184511] Dynamic subtest all-pipes: SUCCESS (5.379s)
[117.185466] Subtest single-move: SUCCESS (26.898s)
[117.223474] [013/133] (888s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[117.315529] Starting subtest: pipe-fbc-rte
[117.319465] Subtest pipe-fbc-rte: SKIP (0.000s)
[117.404009] [014/133] (888s left) gem_exec_params (no-bsd)
[117.440559] Starting subtest: no-bsd
[117.442129] Subtest no-bsd: SUCCESS (0.001s)
[117.546423] [015/133] (888s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[117.633537] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[118.852700] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (1.219s)
[118.973660] [016/133] (886s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[119.063543] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[119.064893] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[119.154584] [017/133] (886s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[119.240659] Starting subtest: 2x-cursor-vs-flip-atomic
[119.242917] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.002s)
[119.305465] [018/133] (886s left) gem_render_copy_redux (flink-interruptible)
[119.343743] Starting subtest: flink-interruptible
[120.157900] Subtest flink-interruptible: SUCCESS (0.814s)
[120.274451] [019/133] (885s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[120.364396] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[120.365876] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[120.524754] [020/133] (885s left) vgem_basic (sysfs)
[120.564652] Starting subtest: sysfs
[120.565343] Subtest sysfs: SUCCESS (0.000s)
[120.618179] [021/133] (885s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[120.651799] Starting subtest: multi-wait-all-for-submit-available-submitted
[120.653578] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[120.708649] [022/133] (885s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[120.793485] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[120.835935] [023/133] (885s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[120.923482] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[120.924811] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[121.002694] [024/133] (885s left) syncobj_basic (test-valid-cycle)
[121.036722] Starting subtest: test-valid-cycle
[121.037399] Subtest test-valid-cycle: SUCCESS (0.000s)
[121.090753] [025/133] (885s left) kms_cursor_crc (cursor-random-128x128)
[121.178413] Starting subtest: cursor-random-128x128
[121.183271] Starting dynamic subtest: pipe-A-HDMI-A-1
[123.098929] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.916s)
[123.131018] Starting dynamic subtest: pipe-D-HDMI-A-1
[124.997836] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.872s)
[124.998517] Subtest cursor-random-128x128: SUCCESS (3.820s)
[125.149560] [026/133] (881s left) vgem_basic (mmap)
[125.189141] Starting subtest: mmap
[125.204772] Subtest mmap: SUCCESS (0.017s)
[125.254147] [027/133] (881s left) kms_content_protection (uevent)
[125.344696] Starting subtest: uevent
[125.359064] Subtest uevent: SKIP (0.013s)
[125.444130] [028/133] (880s left) kms_plane (plane-position-covered)
[125.529754] Starting subtest: plane-position-covered
[125.736995] Starting dynamic subtest: pipe-A-plane-1
[125.970909] Dynamic subtest pipe-A-plane-1: SUCCESS (0.234s)
[125.977903] Starting dynamic subtest: pipe-A-plane-2
[126.203862] Dynamic subtest pipe-A-plane-2: SUCCESS (0.232s)
[126.210930] Starting dynamic subtest: pipe-A-plane-3
[126.443836] Dynamic subtest pipe-A-plane-3: SUCCESS (0.238s)
[126.450093] Starting dynamic subtest: pipe-A-plane-4
[126.666908] Dynamic subtest pipe-A-plane-4: SUCCESS (0.222s)
[126.673964] Starting dynamic subtest: pipe-A-plane-5
[126.909980] Dynamic subtest pipe-A-plane-5: SUCCESS (0.243s)
[126.917135] Starting dynamic subtest: pipe-A-plane-6
[127.142691] Dynamic subtest pipe-A-plane-6: SUCCESS (0.232s)
[127.150270] Starting dynamic subtest: pipe-A-plane-7
[127.151746] Dynamic subtest pipe-A-plane-7: SUCCESS (0.002s)
[127.324128] Starting dynamic subtest: pipe-B-plane-1
[127.561728] Dynamic subtest pipe-B-plane-1: SUCCESS (0.243s)
[127.569673] Starting dynamic subtest: pipe-B-plane-2
[127.765985] Dynamic subtest pipe-B-plane-2: SUCCESS (0.203s)
[127.773821] Starting dynamic subtest: pipe-B-plane-3
[127.984857] Dynamic subtest pipe-B-plane-3: SUCCESS (0.219s)
[127.994578] Starting dynamic subtest: pipe-B-plane-4
[128.211283] Dynamic subtest pipe-B-plane-4: SUCCESS (0.224s)
[128.219906] Starting dynamic subtest: pipe-B-plane-5
[128.418210] Dynamic subtest pipe-B-plane-5: SUCCESS (0.206s)
[128.424232] Starting dynamic subtest: pipe-B-plane-6
[128.638445] Dynamic subtest pipe-B-plane-6: SUCCESS (0.219s)
[128.644702] Starting dynamic subtest: pipe-B-plane-7
[128.646041] Dynamic subtest pipe-B-plane-7: SUCCESS (0.002s)
[128.646699] Subtest plane-position-covered: SUCCESS (3.112s)
[128.778281] [029/133] (877s left) perf_pmu (init-sema)
[128.820031] Starting subtest: init-sema
[128.820745] Starting dynamic subtest: rcs0
[128.822626] Dynamic subtest rcs0: SUCCESS (0.001s)
[128.829980] Starting dynamic subtest: bcs0
[128.830763] Dynamic subtest bcs0: SUCCESS (0.001s)
[128.837280] Starting dynamic subtest: vcs0
[128.837969] Dynamic subtest vcs0: SUCCESS (0.001s)
[128.844076] Starting dynamic subtest: vcs1
[128.844783] Dynamic subtest vcs1: SUCCESS (0.001s)
[128.850427] Starting dynamic subtest: vecs0
[128.851113] Dynamic subtest vecs0: SUCCESS (0.000s)
[128.851792] Subtest init-sema: SUCCESS (0.010s)
[128.890300] [030/133] (877s left) gem_mmap_gtt (basic)
[128.923787] Starting subtest: basic
[128.924461] Subtest basic: SUCCESS (0.001s)
[128.999253] [031/133] (877s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[129.094145] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[129.095552] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[129.185902] [032/133] (877s left) kms_plane_cursor (primary)
[129.271967] Starting subtest: primary
[129.274437] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[130.481924] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (1.208s)
[130.519894] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[131.723769] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (1.216s)
[131.759454] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[132.965595] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (1.216s)
[133.046901] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[134.294137] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (1.252s)
[134.318356] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[135.519161] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (1.208s)
[135.544209] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[136.744574] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (1.208s)
[136.817491] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64
[138.079228] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (1.267s)
[138.107090] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128
[139.312784] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (1.216s)
[139.336213] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256
[140.538042] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (1.208s)
[140.611841] Starting dynamic subtest: pipe-D-HDMI-A-1-size-64
[141.859610] Dynamic subtest pipe-D-HDMI-A-1-size-64: SUCCESS (1.254s)
[141.885012] Starting dynamic subtest: pipe-D-HDMI-A-1-size-128
[143.093159] Dynamic subtest pipe-D-HDMI-A-1-size-128: SUCCESS (1.216s)
[143.117235] Starting dynamic subtest: pipe-D-HDMI-A-1-size-256
[144.318165] Dynamic subtest pipe-D-HDMI-A-1-size-256: SUCCESS (1.208s)
[144.387118] Subtest primary: SUCCESS (15.115s)
[144.498802] [033/133] (862s left) gem_exec_params (invalid-ring2)
[144.541417] Starting subtest: invalid-ring2
[144.542110] Subtest invalid-ring2: SUCCESS (0.000s)
[144.636884] [034/133] (861s left) gem_madvise (dontneed-after-mmap)
[144.669880] Starting subtest: dontneed-after-mmap
[144.677821] Subtest dontneed-after-mmap: SUCCESS (0.008s)
[144.760996] [035/133] (861s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[144.799127] Starting subtest: basic-cpu-gtt-noreloc
[144.801938] Subtest basic-cpu-gtt-noreloc: SUCCESS (0.003s)
[144.912562] [036/133] (861s left) gem_pxp (create-valid-protected-context)
[145.015526] Starting subtest: create-valid-protected-context
[145.016777] Subtest create-valid-protected-context: SUCCESS (0.001s)
[145.089567] [037/133] (861s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[145.180288] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[145.181725] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[145.271958] [038/133] (861s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[145.312283] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[145.312976] Starting dynamic subtest: smem
[145.387084] Dynamic subtest smem: SUCCESS (0.076s)
[145.387873] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SUCCESS (0.077s)
[145.565669] [039/133] (861s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[145.651418] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[145.654266] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.002s)
[145.711965] [040/133] (861s left) prime_self_import (basic-with_one_bo)
[145.744538] Starting subtest: basic-with_one_bo
[145.748188] Subtest basic-with_one_bo: SUCCESS (0.004s)
[145.825391] [041/133] (861s left) perf (gen12-unprivileged-single-ctx-counters)
[145.907921] Starting subtest: gen12-unprivileged-single-ctx-counters
[145.908681] Starting dynamic subtest: rcs0
[146.246721] Dynamic subtest rcs0: SUCCESS (0.339s)
[146.247451] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.340s)
[146.290495] [042/133] (860s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[146.326691] Starting subtest: single-wait-for-submit-unsubmitted
[146.431685] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[146.504975] [043/133] (860s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[146.594447] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[147.689708] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (1.096s)
[147.797930] [044/133] (859s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[147.886420] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[147.887863] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[147.946349] [045/133] (859s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[148.050159] Starting subtest: extended-modeset-hang-newfb-with-reset
[148.052121] Starting dynamic subtest: pipe-A
[150.898989] Dynamic subtest pipe-A: SUCCESS (2.847s)
[150.908095] Starting dynamic subtest: pipe-D
[153.763688] Dynamic subtest pipe-D: SUCCESS (2.861s)
[153.765845] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (5.716s)
[153.876524] [046/133] (853s left) i915_pm_rpm (system-suspend-devices)
[155.278900] Starting subtest: system-suspend-devices
[163.145739] Subtest system-suspend-devices: SUCCESS (7.867s)
[171.395707] [047/133] (843s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[171.496725] Starting subtest: addfb25-y-tiled-legacy
[171.497449] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[171.595103] [048/133] (843s left) gem_mmap_gtt (flink-race)
[171.630696] Starting subtest: flink-race
[191.708373] Subtest flink-race: SUCCESS (20.071s)
[191.825978] [049/133] (823s left) kms_cursor_crc (cursor-offscreen-max-size)
[191.919690] Starting subtest: cursor-offscreen-max-size
[191.921763] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[192.002996] [050/133] (823s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[192.039276] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[192.143652] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.104s)
[192.210686] [051/133] (823s left) kms_lease (multimaster-lease)
[192.296097] Starting subtest: multimaster-lease
[192.297937] Subtest multimaster-lease: SUCCESS (0.002s)
[192.355171] [052/133] (823s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[192.440034] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[192.441401] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[192.498712] [053/133] (822s left) gem_eio (wait-10ms)
[192.541111] Starting subtest: wait-10ms
[192.704294] Subtest wait-10ms: SUCCESS (0.162s)
[192.827771] [054/133] (822s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[192.862408] Starting subtest: multi-wait-for-submit-available-signaled
[192.864269] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[192.925999] [055/133] (822s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[193.021171] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[193.687348] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.667s)
[193.822078] [056/133] (821s left) kms_rotation_crc (cursor-rotation-180)
[193.908076] Starting subtest: cursor-rotation-180
[194.257421] Subtest cursor-rotation-180: SUCCESS (0.349s)
[194.460407] [057/133] (821s left) gem_exec_fence (syncobj-signal)
[194.807801] Starting subtest: syncobj-signal
[194.810099] Subtest syncobj-signal: SUCCESS (0.002s)
[195.113925] [058/133] (820s left) kms_vblank (query-busy-hang)
[195.204028] Starting subtest: query-busy-hang
[195.205864] Starting dynamic subtest: pipe-A-HDMI-A-1
[209.557314] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.351s)
[209.568125] Starting dynamic subtest: pipe-D-HDMI-A-1
[223.872814] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (14.311s)
[223.873601] Subtest query-busy-hang: SUCCESS (28.671s)
[224.025978] [059/133] (791s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[224.068707] Starting subtest: verify-pxp-key-change-after-suspend-resume
[230.719480] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (6.651s)
[240.879833] [060/133] (784s left) syncobj_timeline (single-wait-available-signaled)
[240.925357] Starting subtest: single-wait-available-signaled
[240.926059] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[241.005839] [061/133] (784s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier)
[241.091320] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier
[241.109724] Starting dynamic subtest: pipe-A-plane-0
[241.318122] Dynamic subtest pipe-A-plane-0: SUCCESS (0.208s)
[241.334460] Starting dynamic subtest: pipe-A-plane-3
[241.484839] Dynamic subtest pipe-A-plane-3: SUCCESS (0.164s)
[241.501080] Starting dynamic subtest: pipe-A-plane-5
[241.651415] Dynamic subtest pipe-A-plane-5: SUCCESS (0.164s)
[241.668244] Starting dynamic subtest: pipe-A-plane-7
[241.669701] Dynamic subtest pipe-A-plane-7: SKIP (0.000s)
[241.803099] Starting dynamic subtest: pipe-B-plane-0
[241.969710] Dynamic subtest pipe-B-plane-0: SUCCESS (0.175s)
[241.982164] Starting dynamic subtest: pipe-B-plane-3
[242.144692] Dynamic subtest pipe-B-plane-3: SUCCESS (0.173s)
[242.156115] Starting dynamic subtest: pipe-B-plane-5
[242.311430] Dynamic subtest pipe-B-plane-5: SUCCESS (0.165s)
[242.326704] Starting dynamic subtest: pipe-B-plane-7
[242.328163] Dynamic subtest pipe-B-plane-7: SKIP (0.000s)
[242.378189] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SUCCESS (1.286s)
[242.533409] [062/133] (783s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[242.633273] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[242.985088] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.352s)
[243.130935] [063/133] (782s left) kms_pm_rpm (pm-tiling)
[244.523377] Starting subtest: pm-tiling
[248.249027] Subtest pm-tiling: SUCCESS (3.726s)
[248.328055] [064/133] (777s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[248.415018] Starting subtest: plane-upscale-factor-0-25-with-rotation
[248.415964] Starting dynamic subtest: pipe-A
[249.500162] Dynamic subtest pipe-A: SKIP (1.083s)
[249.509976] Starting dynamic subtest: pipe-B
[250.651953] Dynamic subtest pipe-B: SKIP (1.149s)
[250.659867] Starting dynamic subtest: pipe-C
[251.773240] Dynamic subtest pipe-C: SKIP (1.123s)
[251.780704] Starting dynamic subtest: pipe-D
[252.922295] Dynamic subtest pipe-D: SKIP (1.146s)
[252.923784] Subtest plane-upscale-factor-0-25-with-rotation: SKIP (4.506s)
[253.097965] [065/133] (772s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[253.151134] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[253.254933] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[253.314226] [066/133] (772s left) gem_exec_parallel (contexts)
[253.356565] Starting subtest: contexts
[253.357334] Starting dynamic subtest: rcs0
[258.360863] Dynamic subtest rcs0: SUCCESS (5.003s)
[258.384529] Starting dynamic subtest: bcs0
[261.304453] Dynamic subtest bcs0: SUCCESS (2.930s)
[261.311755] Starting dynamic subtest: vcs0
[263.771168] Dynamic subtest vcs0: SUCCESS (2.467s)
[263.780094] Starting dynamic subtest: vcs1
[267.356573] Dynamic subtest vcs1: SUCCESS (3.593s)
[267.366278] Starting dynamic subtest: vecs0
[270.134582] Dynamic subtest vecs0: SUCCESS (2.768s)
[270.135350] Subtest contexts: SUCCESS (16.770s)
[270.320573] [067/133] (755s left) kms_plane_alpha_blend (alpha-7efc)
[270.407801] Starting subtest: alpha-7efc
[270.478837] Starting dynamic subtest: pipe-A-HDMI-A-1
[270.786991] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.308s)
[270.821981] Starting dynamic subtest: pipe-D-HDMI-A-1
[271.274489] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.460s)
[271.275264] Subtest alpha-7efc: SUCCESS (0.867s)
[271.432879] [068/133] (754s left) i915_suspend (fence-restore-tiled2untiled)
[271.469711] Starting subtest: fence-restore-tiled2untiled
[291.430597] Subtest fence-restore-tiled2untiled: SUCCESS (5.156s)
[296.550891] [069/133] (734s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[296.657192] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[296.658551] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[296.754392] [070/133] (734s left) kms_psr (psr2-sprite-mmap-gtt)
[296.839516] Subtest psr2-sprite-mmap-gtt: SKIP (0.000s)
[296.884264] [071/133] (734s left) gem_ctx_isolation (nonpriv-switch)
[296.924239] Starting subtest: nonpriv-switch
[296.924973] Starting dynamic subtest: rcs0
[297.200213] Dynamic subtest rcs0: SUCCESS (0.271s)
[297.207531] Starting dynamic subtest: bcs0
[297.504243] Dynamic subtest bcs0: SUCCESS (0.307s)
[297.511705] Starting dynamic subtest: vcs0
[297.813482] Dynamic subtest vcs0: SUCCESS (0.313s)
[297.820710] Starting dynamic subtest: vcs1
[298.113300] Dynamic subtest vcs1: SUCCESS (0.303s)
[298.120550] Starting dynamic subtest: vecs0
[298.414831] Dynamic subtest vecs0: SUCCESS (0.304s)
[298.415526] Subtest nonpriv-switch: SUCCESS (1.505s)
[298.586289] [072/133] (732s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[298.672419] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[298.673126] Starting dynamic subtest: pipe-A-HDMI-A-1
[298.679612] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[298.687161] Starting dynamic subtest: pipe-B-HDMI-A-1
[298.693546] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[298.700893] Starting dynamic subtest: pipe-C-HDMI-A-1
[298.707274] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[298.714525] Starting dynamic subtest: pipe-D-HDMI-A-1
[298.721126] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[298.722431] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.007s)
[298.911938] [073/133] (732s left) gem_softpin (softpin)
[298.952950] Starting subtest: softpin
[331.163164] Subtest softpin: SUCCESS (32.300s)
[331.258024] [074/133] (700s left) gem_blits (basic)
[331.296540] Starting subtest: basic
[335.743832] Subtest basic: SUCCESS (4.415s)
[335.828211] [075/133] (695s left) kms_draw_crc (draw-method-mmap-gtt)
[335.915737] Starting subtest: draw-method-mmap-gtt
[335.916528] Starting dynamic subtest: xrgb8888-untiled
[336.069395] Dynamic subtest xrgb8888-untiled: SUCCESS (0.153s)
[336.086161] Starting dynamic subtest: rgb565-untiled
[336.227920] Dynamic subtest rgb565-untiled: SUCCESS (0.156s)
[336.243216] Starting dynamic subtest: xrgb2101010-untiled
[336.369227] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.139s)
[336.384592] Starting dynamic subtest: xbgr16161616f-untiled
[336.519212] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.147s)
[336.535322] Starting dynamic subtest: xrgb8888-xtiled
[336.594294] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.073s)
[336.610703] Starting dynamic subtest: rgb565-xtiled
[336.669199] Dynamic subtest rgb565-xtiled: SUCCESS (0.073s)
[336.684977] Starting dynamic subtest: xrgb2101010-xtiled
[336.735854] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.064s)
[336.750936] Starting dynamic subtest: xbgr16161616f-xtiled
[336.810826] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.072s)
[336.825878] Starting dynamic subtest: xrgb8888-ytiled
[336.894185] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.081s)
[336.909898] Starting dynamic subtest: rgb565-ytiled
[336.977754] Dynamic subtest rgb565-ytiled: SUCCESS (0.081s)
[336.994506] Starting dynamic subtest: xrgb2101010-ytiled
[337.052533] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.072s)
[337.069529] Starting dynamic subtest: xbgr16161616f-ytiled
[337.160727] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.106s)
[337.162872] Subtest draw-method-mmap-gtt: SUCCESS (1.247s)
[337.252904] [076/133] (694s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[337.340056] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.000s)
[337.386147] [077/133] (694s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[337.475255] Starting subtest: psr-1p-primscrn-spr-indfb-move
[337.476639] Subtest psr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[337.564280] [078/133] (693s left) gem_exercise_blt (fast-copy-emit)
[337.602304] Starting subtest: fast-copy-emit
[337.603106] Starting dynamic subtest: linear-smem-smem-emit
[337.621736] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.020s)
[337.630360] Starting dynamic subtest: ymajor-smem-smem-emit
[337.639729] Dynamic subtest ymajor-smem-smem-emit: SUCCESS (0.017s)
[337.648361] Starting dynamic subtest: tile4-smem-smem-emit
[337.656347] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s)
[337.664940] Starting dynamic subtest: tile64-smem-smem-emit
[337.672887] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[337.673564] Subtest fast-copy-emit: SUCCESS (0.072s)
[337.793337] [079/133] (693s left) sysfs_heartbeat_interval (nopreempt)
[337.830639] Starting subtest: nopreempt
[337.832418] Starting dynamic subtest: vecs0
[341.417138] Dynamic subtest vecs0: SUCCESS (3.584s)
[341.425666] Starting dynamic subtest: vcs0
[344.969823] Dynamic subtest vcs0: SUCCESS (3.553s)
[344.983610] Starting dynamic subtest: bcs0
[348.541520] Dynamic subtest bcs0: SUCCESS (3.570s)
[348.553191] Starting dynamic subtest: rcs0
[352.181410] Dynamic subtest rcs0: SUCCESS (3.639s)
[352.192537] Starting dynamic subtest: vcs1
[355.750763] Dynamic subtest vcs1: SUCCESS (3.569s)
[355.751818] Subtest nopreempt: SUCCESS (17.926s)
[355.817454] [080/133] (675s left) gem_ctx_shared (q-in-order)
[355.860855] Starting subtest: Q-in-order
[355.861598] Starting dynamic subtest: rcs0
[355.921423] Dynamic subtest rcs0: SUCCESS (0.060s)
[355.934060] Starting dynamic subtest: bcs0
[355.982627] Dynamic subtest bcs0: SUCCESS (0.059s)
[355.997517] Starting dynamic subtest: vcs0
[356.039248] Dynamic subtest vcs0: SUCCESS (0.053s)
[356.054337] Starting dynamic subtest: vcs1
[356.095306] Dynamic subtest vcs1: SUCCESS (0.054s)
[356.108741] Starting dynamic subtest: vecs0
[356.148349] Dynamic subtest vecs0: SUCCESS (0.051s)
[356.151360] Subtest Q-in-order: SUCCESS (0.289s)
[356.340567] [081/133] (675s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[356.436146] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[356.437544] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[356.539632] [082/133] (675s left) gem_readwrite (read-bad-handle)
[356.574406] Starting subtest: read-bad-handle
[356.575877] Subtest read-bad-handle: SUCCESS (0.000s)
[356.662441] [083/133] (675s left) gem_ctx_persistence (processes)
[356.701268] Starting subtest: processes
[357.138792] Subtest processes: SUCCESS (0.438s)
[357.212035] [084/133] (674s left) kms_hdr (static-swap)
[357.296661] Starting subtest: static-swap
[357.298781] Subtest static-swap: SKIP (0.001s)
[357.361794] [085/133] (674s left) kms_chamelium_hpd (vga-hpd)
[357.501756] Subtest vga-hpd: SKIP (0.000s)
[357.602991] [086/133] (674s left) kms_big_fb (linear-32bpp-rotate-0)
[357.697814] Starting subtest: linear-32bpp-rotate-0
[359.183240] Subtest linear-32bpp-rotate-0: SUCCESS (1.485s)
[359.312713] [087/133] (672s left) kms_psr (psr2-cursor-blt)
[359.403803] Subtest psr2-cursor-blt: SKIP (0.000s)
[359.448702] [088/133] (672s left) gem_exec_capture (pi)
[359.488184] Starting subtest: pi
[359.488939] Starting dynamic subtest: rcs0
[369.968920] Dynamic subtest rcs0: SUCCESS (10.484s)
[369.979924] Starting dynamic subtest: bcs0
[449.250718] Dynamic subtest bcs0: SUCCESS (79.283s)
[449.262521] Starting dynamic subtest: vcs0
[528.899572] Dynamic subtest vcs0: SUCCESS (79.662s)
[528.911822] Starting dynamic subtest: vcs1
[608.396048] Dynamic subtest vcs1: SUCCESS (79.489s)
[608.407450] Starting dynamic subtest: vecs0
[618.618399] Dynamic subtest vecs0: SUCCESS (10.222s)
[618.619244] Subtest pi: SUCCESS (259.149s)
[618.694929] [089/133] (413s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[618.826553] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[618.828345] Starting dynamic subtest: pipe-A-HDMI-A-1
[618.835195] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[618.843581] Starting dynamic subtest: pipe-B-HDMI-A-1
[618.850295] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[618.858455] Starting dynamic subtest: pipe-C-HDMI-A-1
[618.865239] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[618.873213] Starting dynamic subtest: pipe-D-HDMI-A-1
[618.879950] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[618.881335] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.008s)
[619.080585] [090/133] (412s left) gem_eio (in-flight-contexts-1us)
[619.130872] Starting subtest: in-flight-contexts-1us
[632.630517] Subtest in-flight-contexts-1us: SUCCESS (13.500s)
[632.754473] [091/133] (399s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[632.842452] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[632.843805] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[632.995407] [092/133] (399s left) kms_pm_backlight (fade)
[633.089865] Subtest fade: SKIP (0.000s)
[633.131300] [093/133] (399s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[633.225956] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[633.227314] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[633.340605] [094/133] (398s left) gem_partial_pwrite_pread (write-uncached)
[633.377081] Starting subtest: write-uncached
[643.774400] Subtest write-uncached: SUCCESS (10.399s)
[643.889386] [095/133] (388s left) gem_exec_schedule (reorder-wide)
[644.070496] Starting subtest: reorder-wide
[644.072696] Starting dynamic subtest: rcs0
[644.144562] Dynamic subtest rcs0: SUCCESS (0.072s)
[644.156706] Starting dynamic subtest: bcs0
[644.219969] Dynamic subtest bcs0: SUCCESS (0.073s)
[644.234838] Starting dynamic subtest: vcs0
[644.295545] Dynamic subtest vcs0: SUCCESS (0.073s)
[644.309568] Starting dynamic subtest: vcs1
[644.370228] Dynamic subtest vcs1: SUCCESS (0.073s)
[644.385176] Starting dynamic subtest: vecs0
[644.444930] Dynamic subtest vecs0: SUCCESS (0.072s)
[644.445899] Subtest reorder-wide: SUCCESS (0.375s)
[644.631945] [096/133] (387s left) gem_exec_params (sol-reset-invalid)
[644.668788] Starting subtest: sol-reset-invalid
[644.670817] Subtest sol-reset-invalid: SUCCESS (0.001s)
[644.783963] [097/133] (387s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[644.924267] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[645.015846] [098/133] (387s left) i915_pm_freq_api (freq-suspend)
[645.071989] Subtest freq-suspend: SKIP (0.000s)
[645.121489] [099/133] (387s left) syncobj_wait (wait-for-submit-delayed-submit)
[645.155915] Starting subtest: wait-for-submit-delayed-submit
[645.257267] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[645.340214] [100/133] (387s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[645.437548] Starting subtest: 4-tiled-8bpp-rotate-270
[645.438954] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.000s)
[645.560397] [101/133] (386s left) kms_fbcon_fbt (psr-suspend)
[645.599299] Starting subtest: psr-suspend
[645.600660] Subtest psr-suspend: SKIP (0.000s)
[645.702741] [102/133] (386s left) gem_softpin (overlap)
[645.741936] Starting subtest: overlap
[646.689290] Subtest overlap: SUCCESS (0.939s)
[646.784682] [103/133] (385s left) kms_frontbuffer_tracking (fbc-stridechange)
[646.876201] Starting subtest: fbc-stridechange
[647.888172] Subtest fbc-stridechange: SUCCESS (1.012s)
[648.017453] [104/133] (384s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[648.110356] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[648.111748] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[648.199578] [105/133] (384s left) kms_atomic_interruptible (legacy-cursor)
[648.288600] Starting subtest: legacy-cursor
[648.289319] Starting dynamic subtest: pipe-A-HDMI-A-1
[654.530180] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.242s)
[654.530915] Subtest legacy-cursor: SUCCESS (6.244s)
[654.663483] [106/133] (378s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[654.758820] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[654.804371] [107/133] (377s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[654.890446] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[654.891171] Starting dynamic subtest: pipe-A-HDMI-A-1
[654.897743] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[654.906039] Starting dynamic subtest: pipe-B-HDMI-A-1
[654.912473] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[654.920743] Starting dynamic subtest: pipe-C-HDMI-A-1
[654.927155] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[654.935352] Starting dynamic subtest: pipe-D-HDMI-A-1
[654.941989] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[654.943292] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SKIP (0.009s)
[655.141833] [108/133] (377s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[655.230422] Subtest psr2-cursor-plane-update-sf: SKIP (0.000s)
[655.276085] [109/133] (377s left) gem_exec_flush (basic-batch-kernel-default-wb)
[655.317897] Starting subtest: basic-batch-kernel-default-wb
[660.958594] Subtest basic-batch-kernel-default-wb: SUCCESS (5.641s)
[661.156995] [110/133] (371s left) gem_mmap (bad-size)
[661.190386] Starting subtest: bad-size
[661.191071] Subtest bad-size: SUCCESS (0.001s)
[661.290540] [111/133] (371s left) gem_softpin (allocator-evict)
[661.327733] Starting subtest: allocator-evict
[661.328430] Starting dynamic subtest: rcs0
[684.409239] Dynamic subtest rcs0: SUCCESS (23.085s)
[684.420704] Starting dynamic subtest: bcs0
[707.686870] Dynamic subtest bcs0: SUCCESS (23.281s)
[707.697007] Starting dynamic subtest: vcs0
[731.460079] Dynamic subtest vcs0: SUCCESS (23.777s)
[731.469839] Starting dynamic subtest: vcs1
[754.932704] Dynamic subtest vcs1: SUCCESS (23.477s)
[754.943579] Starting dynamic subtest: vecs0
[778.130703] Dynamic subtest vecs0: SUCCESS (23.199s)
[778.131517] Subtest allocator-evict: SUCCESS (116.826s)
[778.198347] [112/133] (254s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[778.333125] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[778.342649] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.009s)
[778.425355] [113/133] (254s left) gem_exec_schedule (deep)
[778.600715] Starting subtest: deep
[778.601562] Starting dynamic subtest: rcs0
[786.786453] Dynamic subtest rcs0: SUCCESS (8.171s)
[786.795603] Starting dynamic subtest: bcs0
[795.071052] Dynamic subtest bcs0: SUCCESS (8.278s)
[795.079772] Starting dynamic subtest: vcs0
[803.399756] Dynamic subtest vcs0: SUCCESS (8.323s)
[803.408520] Starting dynamic subtest: vcs1
[811.708747] Dynamic subtest vcs1: SUCCESS (8.304s)
[811.737064] Starting dynamic subtest: vecs0
[819.947993] Dynamic subtest vecs0: SUCCESS (8.235s)
[819.948862] Subtest deep: SUCCESS (41.317s)
[820.386611] [114/133] (212s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[820.478801] Starting subtest: basic-busy-flip-before-cursor-varying-size
[820.480168] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[820.539723] [115/133] (212s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[820.627643] Starting subtest: basic-flip-after-cursor-varying-size
[821.177535] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.550s)
[821.317546] [116/133] (211s left) kms_vblank (ts-continuation-idle-hang)
[821.410448] Starting subtest: ts-continuation-idle-hang
[821.411186] Starting dynamic subtest: pipe-A-HDMI-A-1
[835.678265] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.262s)
[835.690595] Starting dynamic subtest: pipe-D-HDMI-A-1
[849.497745] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.811s)
[849.499534] Subtest ts-continuation-idle-hang: SUCCESS (28.082s)
[849.644891] [117/133] (183s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[849.688190] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[849.814053] [118/133] (183s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[849.907198] Starting subtest: psr-rgb101010-draw-blt
[849.908559] Subtest psr-rgb101010-draw-blt: SKIP (0.000s)
[850.008419] [119/133] (183s left) gem_close_race (multigpu-basic-threads)
[850.052847] Starting subtest: multigpu-basic-threads
[850.054197] Subtest multigpu-basic-threads: SKIP (0.000s)
[850.240208] [120/133] (183s left) dmabuf_sync_file (import-basic)
[850.282864] Starting subtest: import-basic
[850.285337] Subtest import-basic: SUCCESS (0.003s)
[850.354569] [121/133] (183s left) prime_busy (before-wait)
[850.392846] Starting subtest: before-wait
[850.398415] Starting dynamic subtest: rcs0
[850.427738] Dynamic subtest rcs0: SUCCESS (0.029s)
[850.442158] Starting dynamic subtest: bcs0
[850.445102] Dynamic subtest bcs0: SUCCESS (0.016s)
[850.455246] Starting dynamic subtest: vcs0
[850.465689] Dynamic subtest vcs0: SUCCESS (0.019s)
[850.475773] Starting dynamic subtest: vcs1
[850.482568] Dynamic subtest vcs1: SUCCESS (0.015s)
[850.492293] Starting dynamic subtest: vecs0
[850.498626] Dynamic subtest vecs0: SUCCESS (0.015s)
[850.606032] Subtest before-wait: SUCCESS (0.213s)
[850.678123] [122/133] (182s left) gem_fence_thrash (bo-write-verify-threaded-none)
[850.710453] Starting subtest: bo-write-verify-threaded-none
[855.047856] Subtest bo-write-verify-threaded-none: SUCCESS (4.303s)
[855.137081] [123/133] (178s left) kms_psr (psr-suspend)
[855.229590] Subtest psr-suspend: SKIP (0.000s)
[855.276079] [124/133] (178s left) gem_readwrite (new-obj)
[855.309999] Starting subtest: new-obj
[855.311375] Subtest new-obj: SUCCESS (0.000s)
[855.405825] [125/133] (178s left) kms_frontbuffer_tracking (fbc-suspend)
[855.496819] Starting subtest: fbc-suspend
[891.683369] Subtest fbc-suspend: SUCCESS (5.180s)
[902.861984] [126/133] (141s left) gem_exec_whisper (basic-forked)
[902.906068] Starting subtest: basic-forked
[904.523505] Subtest basic-forked: SUCCESS (1.607s)
[904.718777] [127/133] (139s left) kms_atomic_transition (modeset-transition)
[904.807546] Starting subtest: modeset-transition
[904.808243] Starting dynamic subtest: 1x-outputs
[906.003719] Dynamic subtest 1x-outputs: SUCCESS (1.190s)
[906.004522] Subtest modeset-transition: SUCCESS (1.192s)
[906.155539] [128/133] (138s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[906.250134] Starting subtest: plane-lut1d-pre-ctm3x4
[906.334786] Starting dynamic subtest: pipe-A-plane-0
[906.434259] Dynamic subtest pipe-A-plane-0: SUCCESS (0.099s)
[906.453691] Starting dynamic subtest: pipe-A-plane-1
[906.526171] Dynamic subtest pipe-A-plane-1: SUCCESS (0.088s)
[906.543913] Starting dynamic subtest: pipe-A-plane-2
[906.618322] Dynamic subtest pipe-A-plane-2: SUCCESS (0.088s)
[906.824958] Starting dynamic subtest: pipe-B-plane-0
[906.899645] Dynamic subtest pipe-B-plane-0: SUCCESS (0.083s)
[906.916643] Starting dynamic subtest: pipe-B-plane-1
[906.991862] Dynamic subtest pipe-B-plane-1: SUCCESS (0.089s)
[907.008123] Starting dynamic subtest: pipe-B-plane-2
[907.083787] Dynamic subtest pipe-B-plane-2: SUCCESS (0.089s)
[907.284210] Starting dynamic subtest: pipe-C-plane-0
[907.367910] Dynamic subtest pipe-C-plane-0: SUCCESS (0.092s)
[907.383693] Starting dynamic subtest: pipe-C-plane-1
[907.459876] Dynamic subtest pipe-C-plane-1: SUCCESS (0.089s)
[907.475609] Starting dynamic subtest: pipe-C-plane-2
[907.553187] Dynamic subtest pipe-C-plane-2: SUCCESS (0.089s)
[907.760965] Starting dynamic subtest: pipe-D-plane-0
[907.852030] Dynamic subtest pipe-D-plane-0: SUCCESS (0.100s)
[907.867066] Starting dynamic subtest: pipe-D-plane-1
[907.945859] Dynamic subtest pipe-D-plane-1: SUCCESS (0.090s)
[907.958420] Starting dynamic subtest: pipe-D-plane-2
[908.044805] Dynamic subtest pipe-D-plane-2: SUCCESS (0.098s)
[908.093347] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (1.836s)
[908.202789] [129/133] (136s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[908.298254] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[908.299725] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[908.404272] [130/133] (136s left) gem_exec_balancer (bonded-true-hang)
[908.563367] Starting subtest: bonded-true-hang
[909.838755] Subtest bonded-true-hang: SUCCESS (1.270s)
[909.900721] [131/133] (134s left) api_intel_bb (blit-noreloc-keep-cache)
[909.935487] Starting subtest: blit-noreloc-keep-cache
[909.941726] Subtest blit-noreloc-keep-cache: SUCCESS (0.007s)
[910.042286] [132/133] (134s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[910.133327] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[910.134704] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[910.232488] [133/133] (134s left) kms_psr (fbc-psr-cursor-plane-move)
[910.318346] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[910.360115] Closing watchdogs
results: parsing output: 0/ for test: api_intel_bb
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: vgem_basic
results: parsing output: 3/ for test: i915_drm_fdinfo
results: parsing output: 4/ for test: kms_rotation_crc
results: parsing output: 5/ for test: kms_addfb_basic
results: parsing output: 6/ for test: gen9_exec_parse
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: gem_exec_schedule
results: parsing output: 9/ for test: kms_joiner
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: kms_cursor_legacy
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_exec_params
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: gem_render_copy_redux
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: vgem_basic
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: syncobj_basic
results: parsing output: 24/ for test: kms_cursor_crc
results: parsing output: 25/ for test: vgem_basic
results: parsing output: 26/ for test: kms_content_protection
results: parsing output: 27/ for test: kms_plane
results: parsing output: 28/ for test: perf_pmu
results: parsing output: 29/ for test: gem_mmap_gtt
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_plane_cursor
results: parsing output: 32/ for test: gem_exec_params
results: parsing output: 33/ for test: gem_madvise
results: parsing output: 34/ for test: gem_exec_reloc
results: parsing output: 35/ for test: gem_pxp
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_render_copy
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: prime_self_import
results: parsing output: 40/ for test: perf
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_flip_scaled_crc
results: parsing output: 44/ for test: kms_busy
results: parsing output: 45/ for test: i915_pm_rpm
results: parsing output: 46/ for test: kms_addfb_basic
results: parsing output: 47/ for test: gem_mmap_gtt
results: parsing output: 48/ for test: kms_cursor_crc
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: kms_lease
results: parsing output: 51/ for test: kms_flip_scaled_crc
results: parsing output: 52/ for test: gem_eio
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_rotation_crc
results: parsing output: 56/ for test: gem_exec_fence
results: parsing output: 57/ for test: kms_vblank
results: parsing output: 58/ for test: gem_pxp
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: kms_plane
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_pm_rpm
results: parsing output: 63/ for test: kms_plane_scaling
results: parsing output: 64/ for test: syncobj_wait
results: parsing output: 65/ for test: gem_exec_parallel
results: parsing output: 66/ for test: kms_plane_alpha_blend
results: parsing output: 67/ for test: i915_suspend
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: gem_ctx_isolation
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: gem_softpin
results: parsing output: 73/ for test: gem_blits
results: parsing output: 74/ for test: kms_draw_crc
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_exercise_blt
results: parsing output: 78/ for test: sysfs_heartbeat_interval
results: parsing output: 79/ for test: gem_ctx_shared
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: gem_readwrite
results: parsing output: 82/ for test: gem_ctx_persistence
results: parsing output: 83/ for test: kms_hdr
results: parsing output: 84/ for test: kms_chamelium_hpd
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: gem_exec_capture
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: gem_eio
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_pm_backlight
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_partial_pwrite_pread
results: parsing output: 94/ for test: gem_exec_schedule
results: parsing output: 95/ for test: gem_exec_params
results: parsing output: 96/ for test: kms_chamelium_edid
results: parsing output: 97/ for test: i915_pm_freq_api
results: parsing output: 98/ for test: syncobj_wait
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_fbcon_fbt
results: parsing output: 101/ for test: gem_softpin
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_atomic_interruptible
results: parsing output: 105/ for test: kms_psr2_sf
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: kms_psr2_sf
results: parsing output: 108/ for test: gem_exec_flush
results: parsing output: 109/ for test: gem_mmap
results: parsing output: 110/ for test: gem_softpin
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: kms_cursor_legacy
results: parsing output: 114/ for test: kms_cursor_legacy
results: parsing output: 115/ for test: kms_vblank
results: parsing output: 116/ for test: gem_userptr_blits
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_close_race
results: parsing output: 119/ for test: dmabuf_sync_file
results: parsing output: 120/ for test: prime_busy
results: parsing output: 121/ for test: gem_fence_thrash
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: gem_readwrite
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_exec_whisper
results: parsing output: 126/ for test: kms_atomic_transition
results: parsing output: 127/ for test: kms_color_pipeline
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_exec_balancer
results: parsing output: 130/ for test: api_intel_bb
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_psr
Done.