[50.925661] Initializing watchdogs
[50.925722]   /dev/watchdog0
[50.941564] [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]
[50.947625] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[50.950162] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[50.952184] [001/156] (960s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[51.051849] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc
[51.053208] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[51.145665] [002/156] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[51.239092] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[51.240466] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[51.323383] [003/156] (960s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[51.425114] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[51.801826] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.375s)
[51.927708] [004/156] (959s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-blt)
[52.021184] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-blt
[52.022592] Subtest psrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[52.119835] [005/156] (959s left) gem_exec_schedule (noreorder)
[52.287518] Starting subtest: noreorder
[52.288414] Starting dynamic subtest: rcs0
[52.337523] Dynamic subtest rcs0: SUCCESS (0.053s)
[52.351136] Starting dynamic subtest: bcs0
[52.392447] Dynamic subtest bcs0: SUCCESS (0.054s)
[52.407193] Starting dynamic subtest: vcs0
[52.453638] Dynamic subtest vcs0: SUCCESS (0.060s)
[52.467402] Starting dynamic subtest: vcs1
[52.508454] Dynamic subtest vcs1: SUCCESS (0.054s)
[52.521153] Starting dynamic subtest: vecs0
[52.571441] Dynamic subtest vecs0: SUCCESS (0.062s)
[52.572485] Subtest noreorder: SUCCESS (0.287s)
[52.753915] [006/156] (958s left) i915_drm_fdinfo (memory-info-active)
[52.791299] Starting subtest: memory-info-active
[52.792097] Starting dynamic subtest: smem0
[54.106889] Dynamic subtest smem0: SUCCESS (1.311s)
[54.108386] Subtest memory-info-active: SUCCESS (1.312s)
[54.174737] [007/156] (957s left) kms_big_fb (linear-32bpp-rotate-270)
[54.275124] Starting subtest: linear-32bpp-rotate-270
[54.352185] Subtest linear-32bpp-rotate-270: SKIP (0.076s)
[54.462755] [008/156] (957s left) gem_render_copy (yf-tiled)
[54.504354] Starting subtest: yf-tiled
[54.505145] Starting dynamic subtest: smem
[54.574631] Dynamic subtest smem: SUCCESS (0.070s)
[54.575376] Subtest yf-tiled: SUCCESS (0.070s)
[54.765421] [009/156] (956s left) gem_ctx_param (vm)
[54.799263] Starting subtest: vm
[54.821052] Subtest vm: SUCCESS (0.022s)
[54.932297] [010/156] (956s left) prime_vgem (basic-read)
[55.025782] Starting subtest: basic-read
[55.048923] Subtest basic-read: SUCCESS (0.023s)
[55.148590] [FACT prime_vgem (basic-read)] new: kernel.kmod_is_loaded.vgem: true
[55.150557] [011/156] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[55.244589] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[55.246014] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[55.335431] [012/156] (956s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[55.423728] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[55.425139] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[55.494590] [013/156] (956s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[55.588119] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[55.589479] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[55.676571] [014/156] (956s left) gem_exec_params (invalid-fence-in-submit)
[55.714152] Starting subtest: invalid-fence-in-submit
[55.716325] Subtest invalid-fence-in-submit: SUCCESS (0.002s)
[55.828211] [015/156] (956s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-rte)
[55.922380] Starting subtest: fbcpsrhdr-2p-rte
[55.923811] Subtest fbcpsrhdr-2p-rte: SKIP (0.000s)
[56.028760] [016/156] (956s left) gem_userptr_blits (sync-unmap-cycles)
[56.075206] Starting subtest: sync-unmap-cycles
[61.488865] Subtest sync-unmap-cycles: SUCCESS (5.371s)
[61.573693] [017/156] (950s left) i915_pm_rpm (system-suspend-devices)
[62.972475] Starting subtest: system-suspend-devices
[70.849273] Subtest system-suspend-devices: SUCCESS (7.873s)
[79.080357] [018/156] (941s left) kms_psr (pr-primary-mmap-cpu)
[79.180793] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[79.222564] [019/156] (940s left) gem_exec_reloc (basic-range-active)
[79.263096] Starting subtest: basic-range-active
[79.302087] Subtest basic-range-active: SUCCESS (0.039s)
[79.427360] [020/156] (940s left) kms_vrr (lobf)
[79.515560] Starting subtest: lobf
[79.516956] Subtest lobf: SKIP (0.000s)
[79.577501] [021/156] (940s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-render)
[79.670543] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-render
[79.671963] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[79.769972] [022/156] (940s left) kms_frontbuffer_tracking (hdr-modesetfrombusy)
[79.863174] Starting subtest: hdr-modesetfrombusy
[79.864594] Subtest hdr-modesetfrombusy: SKIP (0.000s)
[79.951797] [023/156] (940s left) syncobj_wait (multi-wait-all-signaled)
[79.986982] Starting subtest: multi-wait-all-signaled
[79.987846] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[80.050858] [024/156] (940s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[80.137811] Starting subtest: nonblocking-crc-frame-sequence
[80.138618] Starting dynamic subtest: pipe-A-HDMI-A-1
[80.483103] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.344s)
[80.491658] Starting dynamic subtest: pipe-B-HDMI-A-1
[80.817658] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.333s)
[80.826276] Starting dynamic subtest: pipe-C-HDMI-A-1
[81.163685] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.343s)
[81.171720] Starting dynamic subtest: pipe-D-HDMI-A-1
[81.505783] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.341s)
[81.506840] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.368s)
[81.620263] [025/156] (938s left) kms_cursor_crc (cursor-offscreen-64x21)
[81.716732] Starting subtest: cursor-offscreen-64x21
[81.721651] Starting dynamic subtest: pipe-A-HDMI-A-1
[82.956297] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.235s)
[82.992871] Starting dynamic subtest: pipe-D-HDMI-A-1
[84.211295] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.227s)
[84.212029] Subtest cursor-offscreen-64x21: SUCCESS (2.494s)
[84.356228] [026/156] (936s left) gem_pipe_control_store_loop (reused-buffer)
[84.398638] Starting subtest: reused-buffer
[86.558234] Subtest reused-buffer: SUCCESS (2.151s)
[86.656587] [027/156] (933s left) sw_sync (sync_multi_consumer)
[86.690895] Starting subtest: sync_multi_consumer
[87.226265] Subtest sync_multi_consumer: SUCCESS (0.527s)
[87.281739] [028/156] (933s left) gem_exec_whisper (basic-fds-priority)
[87.324404] Starting subtest: basic-fds-priority
[90.691307] Subtest basic-fds-priority: SUCCESS (3.353s)
[90.858170] [029/156] (929s left) gem_basic (bad-close)
[90.891964] Starting subtest: bad-close
[90.893403] Subtest bad-close: SUCCESS (0.000s)
[90.947684] [030/156] (929s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[91.037531] Starting subtest: primary-4-tiled-reflect-x-0
[91.087245] Subtest primary-4-tiled-reflect-x-0: SKIP (0.049s)
[91.176578] [031/156] (929s left) gem_exec_schedule (u-submit-golden-slice)
[91.223529] Starting subtest: u-submit-golden-slice
[91.224242] Starting dynamic subtest: rcs0
[91.255176] Dynamic subtest rcs0: SUCCESS (0.032s)
[91.263878] Starting dynamic subtest: bcs0
[91.285392] Dynamic subtest bcs0: SUCCESS (0.030s)
[91.294273] Starting dynamic subtest: vcs0
[91.316060] Dynamic subtest vcs0: SUCCESS (0.030s)
[91.325234] Starting dynamic subtest: vcs1
[91.348034] Dynamic subtest vcs1: SUCCESS (0.032s)
[91.357081] Starting dynamic subtest: vecs0
[91.378217] Dynamic subtest vecs0: SUCCESS (0.030s)
[91.379052] Subtest u-submit-golden-slice: SUCCESS (0.155s)
[91.679542] [032/156] (929s left) gem_busy (extended)
[91.856356] Starting subtest: extended
[91.857530] Starting dynamic subtest: rcs0
[91.884624] Dynamic subtest rcs0: SUCCESS (0.039s)
[91.895606] Starting dynamic subtest: bcs0
[91.901148] Dynamic subtest bcs0: SUCCESS (0.016s)
[91.912212] Starting dynamic subtest: vcs0
[91.923207] Dynamic subtest vcs0: SUCCESS (0.022s)
[91.938684] Starting dynamic subtest: vcs1
[91.947337] Dynamic subtest vcs1: SUCCESS (0.023s)
[91.961359] Starting dynamic subtest: vecs0
[91.963213] Dynamic subtest vecs0: SUCCESS (0.016s)
[91.964077] Subtest extended: SUCCESS (0.119s)
[92.181705] [033/156] (928s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[92.217035] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[92.260844] [034/156] (928s left) kms_force_connector_basic (prune-stale-modes)
[92.383543] Starting subtest: prune-stale-modes
[92.531445] Subtest prune-stale-modes: SUCCESS (0.148s)
[92.690480] [035/156] (928s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[92.788184] Starting subtest: x-tiled-8bpp-rotate-180
[93.779227] Subtest x-tiled-8bpp-rotate-180: SUCCESS (0.990s)
[93.900873] [036/156] (927s left) gem_exec_balancer (semaphore)
[93.943489] Starting subtest: semaphore
[95.287589] Subtest semaphore: SUCCESS (1.343s)
[95.473991] [037/156] (925s left) kms_psr2_su (page_flip-xrgb8888)
[95.507342] Subtest page_flip-XRGB8888: SKIP (0.000s)
[95.556694] [038/156] (925s left) kms_frontbuffer_tracking (hdr-2p-pri-indfb-multidraw)
[95.651340] Starting subtest: hdr-2p-pri-indfb-multidraw
[95.652708] Subtest hdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[95.760930] [039/156] (925s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[96.237923] Starting subtest: syncobj-backward-timeline-chain-engines
[96.299083] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.070s)
[96.474148] [040/156] (924s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[96.565548] Starting subtest: fbc-shrfb-scaledprimary
[97.205111] Subtest fbc-shrfb-scaledprimary: SUCCESS (0.640s)
[97.336935] [041/156] (923s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-plflip-blt)
[97.429467] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-plflip-blt
[97.430870] Subtest fbcpsrhdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[97.526321] [042/156] (923s left) kms_pm_rpm (modeset-lpsp)
[98.924167] Starting subtest: modeset-lpsp
[100.217544] Subtest modeset-lpsp: SUCCESS (1.294s)
[100.350272] [043/156] (920s left) api_intel_allocator (gem-pool)
[100.384204] Starting subtest: gem-pool
[100.388685] Subtest gem-pool: SUCCESS (0.005s)
[100.504748] [044/156] (920s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-cpu)
[100.597506] Starting subtest: fbchdr-rgb101010-draw-mmap-cpu
[100.598933] Subtest fbchdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[100.687021] [045/156] (920s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[100.774627] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[100.775340] Starting dynamic subtest: pipe-A-HDMI-A-1
[100.782129] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[100.790540] Starting dynamic subtest: pipe-B-HDMI-A-1
[100.797399] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[100.805646] Starting dynamic subtest: pipe-C-HDMI-A-1
[100.812389] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[100.820481] Starting dynamic subtest: pipe-D-HDMI-A-1
[100.827332] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[100.828707] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[101.036747] [046/156] (920s left) gem_mmap_wc (close)
[101.071747] Starting subtest: close
[101.074231] Subtest close: SUCCESS (0.004s)
[101.160364] [047/156] (920s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[101.254382] Starting subtest: fbcpsr-rgb101010-draw-blt
[101.255774] Subtest fbcpsr-rgb101010-draw-blt: SKIP (0.000s)
[101.353453] [048/156] (920s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[101.450068] Starting subtest: extended-modeset-hang-oldfb-with-reset
[101.451607] Starting dynamic subtest: pipe-A
[111.909115] Dynamic subtest pipe-A: SUCCESS (10.458s)
[111.920361] Starting dynamic subtest: pipe-D
[122.646656] Dynamic subtest pipe-D: SUCCESS (10.735s)
[122.647357] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (21.198s)
[122.774530] [049/156] (898s left) gem_reg_read (timestamp-monotonic)
[122.809252] Starting subtest: timestamp-monotonic
[127.768948] Subtest timestamp-monotonic: SUCCESS (4.926s)
[127.817430] [050/156] (893s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[127.906554] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[127.907295] Starting dynamic subtest: pipe-A-HDMI-A-1
[127.914032] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[127.922558] Starting dynamic subtest: pipe-B-HDMI-A-1
[127.929482] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[127.938619] Starting dynamic subtest: pipe-C-HDMI-A-1
[127.945521] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[127.953840] Starting dynamic subtest: pipe-D-HDMI-A-1
[127.960734] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[127.962078] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SKIP (0.005s)
[128.177467] [051/156] (893s left) kms_cursor_edge_walk (64x64-top-bottom)
[128.265764] Starting subtest: 64x64-top-bottom
[128.267305] Starting dynamic subtest: pipe-A-HDMI-A-1
[130.035169] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.767s)
[130.044974] Starting dynamic subtest: pipe-D-HDMI-A-1
[131.720825] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.684s)
[131.721595] Subtest 64x64-top-bottom: SUCCESS (3.455s)
[131.844239] [052/156] (889s left) sysfs_preempt_timeout (idempotent)
[131.884289] Starting subtest: idempotent
[131.885032] Starting dynamic subtest: vecs0
[131.886723] Dynamic subtest vecs0: SUCCESS (0.001s)
[131.895320] Starting dynamic subtest: vcs0
[131.896124] Dynamic subtest vcs0: SUCCESS (0.001s)
[131.904498] Starting dynamic subtest: bcs0
[131.905205] Dynamic subtest bcs0: SUCCESS (0.001s)
[131.913081] Starting dynamic subtest: rcs0
[131.913783] Dynamic subtest rcs0: SUCCESS (0.001s)
[131.921779] Starting dynamic subtest: vcs1
[131.922465] Dynamic subtest vcs1: SUCCESS (0.001s)
[131.923157] Subtest idempotent: SUCCESS (0.010s)
[131.992297] [053/156] (889s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[132.090018] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[132.763902] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.674s)
[132.887995] [054/156] (888s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[132.980788] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[132.982163] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[133.088105] [055/156] (888s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[133.122783] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[133.232278] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.108s)
[133.296728] [056/156] (888s left) gen9_exec_parse (allowed-single)
[133.333415] Subtest allowed-single: SKIP (0.000s)
[133.383754] [057/156] (888s left) kms_color_pipeline (plane-ctm3x4)
[133.473794] Starting subtest: plane-ctm3x4
[133.555776] Starting dynamic subtest: pipe-A-plane-0
[133.638802] Dynamic subtest pipe-A-plane-0: SUCCESS (0.083s)
[133.655617] Starting dynamic subtest: pipe-A-plane-1
[133.713663] Dynamic subtest pipe-A-plane-1: SUCCESS (0.074s)
[133.730681] Starting dynamic subtest: pipe-A-plane-2
[133.797147] Dynamic subtest pipe-A-plane-2: SUCCESS (0.082s)
[134.015924] Starting dynamic subtest: pipe-B-plane-0
[134.073580] Dynamic subtest pipe-B-plane-0: SUCCESS (0.067s)
[134.089676] Starting dynamic subtest: pipe-B-plane-1
[134.148583] Dynamic subtest pipe-B-plane-1: SUCCESS (0.074s)
[134.164640] Starting dynamic subtest: pipe-B-plane-2
[134.223683] Dynamic subtest pipe-B-plane-2: SUCCESS (0.074s)
[134.456084] Starting dynamic subtest: pipe-C-plane-0
[134.513727] Dynamic subtest pipe-C-plane-0: SUCCESS (0.067s)
[134.528359] Starting dynamic subtest: pipe-C-plane-1
[134.590432] Dynamic subtest pipe-C-plane-1: SUCCESS (0.075s)
[134.603634] Starting dynamic subtest: pipe-C-plane-2
[134.671981] Dynamic subtest pipe-C-plane-2: SUCCESS (0.081s)
[134.872712] Starting dynamic subtest: pipe-D-plane-0
[134.931074] Dynamic subtest pipe-D-plane-0: SUCCESS (0.067s)
[134.942369] Starting dynamic subtest: pipe-D-plane-1
[135.006844] Dynamic subtest pipe-D-plane-1: SUCCESS (0.074s)
[135.018791] Starting dynamic subtest: pipe-D-plane-2
[135.089683] Dynamic subtest pipe-D-plane-2: SUCCESS (0.082s)
[135.138845] Subtest plane-ctm3x4: SUCCESS (1.664s)
[135.259687] [058/156] (886s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[135.357324] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[135.358711] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[135.443076] [059/156] (886s left) i915_drm_fdinfo (virtual-busy-idle-all)
[135.480705] Starting subtest: virtual-busy-idle-all
[136.100453] Subtest virtual-busy-idle-all: SUCCESS (0.620s)
[136.176983] [060/156] (885s left) gem_softpin (allocator-nopin-reserve)
[136.213109] Starting subtest: allocator-nopin-reserve
[136.294193] Subtest allocator-nopin-reserve: SUCCESS (0.081s)
[136.419842] [061/156] (885s left) kms_chamelium_frames (dp-crc-multiple)
[136.565628] Subtest dp-crc-multiple: SKIP (0.000s)
[136.669134] [062/156] (885s left) kms_pm_rpm (dpms-non-lpsp)
[138.068108] Starting subtest: dpms-non-lpsp
[138.070395] Subtest dpms-non-lpsp: SKIP (0.001s)
[138.270654] [063/156] (883s left) prime_busy (before)
[138.309661] Starting subtest: before
[138.313551] Starting dynamic subtest: rcs0
[138.340306] Dynamic subtest rcs0: SUCCESS (0.026s)
[138.356962] Starting dynamic subtest: bcs0
[138.359022] Dynamic subtest bcs0: SUCCESS (0.017s)
[138.372853] Starting dynamic subtest: vcs0
[138.382181] Dynamic subtest vcs0: SUCCESS (0.023s)
[138.398382] Starting dynamic subtest: vcs1
[138.399203] Dynamic subtest vcs1: SUCCESS (0.015s)
[138.407820] Starting dynamic subtest: vecs0
[138.412945] Dynamic subtest vecs0: SUCCESS (0.014s)
[138.522891] Subtest before: SUCCESS (0.212s)
[138.597627] [064/156] (883s left) gem_mmap_offset (open-flood)
[138.630760] Starting subtest: open-flood
[160.130240] Subtest open-flood: SUCCESS (21.499s)
[160.255159] [065/156] (861s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[160.347635] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[160.349017] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[160.407784] [066/156] (861s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-onoff)
[160.501555] Starting subtest: psrhdr-1p-primscrn-spr-indfb-onoff
[160.502983] Subtest psrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[160.598529] [067/156] (861s left) gen7_exec_parse (basic-allocation)
[160.635313] Subtest basic-allocation: SKIP (0.000s)
[160.678965] [068/156] (861s left) kms_draw_crc (draw-method-mmap-cpu)
[160.766377] Starting subtest: draw-method-mmap-cpu
[160.767134] Starting dynamic subtest: xrgb8888-untiled
[160.910813] Dynamic subtest xrgb8888-untiled: SUCCESS (0.144s)
[160.927052] Starting dynamic subtest: rgb565-untiled
[161.069205] Dynamic subtest rgb565-untiled: SUCCESS (0.157s)
[161.085201] Starting dynamic subtest: xrgb2101010-untiled
[161.202377] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.132s)
[161.217329] Starting dynamic subtest: xbgr16161616f-untiled
[161.352464] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.149s)
[161.367763] Starting dynamic subtest: xrgb8888-xtiled
[161.436195] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.082s)
[161.455742] Starting dynamic subtest: rgb565-xtiled
[161.527735] Dynamic subtest rgb565-xtiled: SUCCESS (0.089s)
[161.544138] Starting dynamic subtest: xrgb2101010-xtiled
[161.610882] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.082s)
[161.630592] Starting dynamic subtest: xbgr16161616f-xtiled
[161.694368] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.081s)
[161.709669] Starting dynamic subtest: xrgb8888-ytiled
[161.785652] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.090s)
[161.796922] Starting dynamic subtest: rgb565-ytiled
[161.869413] Dynamic subtest rgb565-ytiled: SUCCESS (0.083s)
[161.884925] Starting dynamic subtest: xrgb2101010-ytiled
[161.952527] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.082s)
[161.970284] Starting dynamic subtest: xbgr16161616f-ytiled
[162.035854] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.082s)
[162.036801] Subtest draw-method-mmap-cpu: SUCCESS (1.270s)
[162.129531] [069/156] (860s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-cpu)
[162.224561] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-cpu
[162.226016] Subtest fbcpsrhdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[162.305272] [070/156] (860s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[162.397266] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[162.398647] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[162.494854] [071/156] (859s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[162.583916] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[162.584715] Starting dynamic subtest: pipe-A-HDMI-A-1
[162.587486] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[162.596124] Starting dynamic subtest: pipe-B-HDMI-A-1
[162.598991] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[162.607407] Starting dynamic subtest: pipe-C-HDMI-A-1
[162.610250] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[162.618952] Starting dynamic subtest: pipe-D-HDMI-A-1
[162.621743] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[162.623166] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.006s)
[162.837161] [072/156] (859s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-blt)
[162.933745] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-blt
[162.942094] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[163.024598] [073/156] (859s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[163.118320] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[163.119710] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[163.207614] [074/156] (859s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[163.300586] Starting subtest: psr-modesetfrombusy
[163.302008] Subtest psr-modesetfrombusy: SKIP (0.000s)
[163.392815] [075/156] (859s left) kms_properties (crtc-properties-atomic)
[163.481765] Starting subtest: crtc-properties-atomic
[163.482493] Starting dynamic subtest: pipe-A-HDMI-A-1
[163.641090] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.158s)
[163.652136] Starting dynamic subtest: pipe-B-HDMI-A-1
[163.832841] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.189s)
[163.843779] Starting dynamic subtest: pipe-C-HDMI-A-1
[164.016136] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.181s)
[164.028017] Starting dynamic subtest: pipe-D-HDMI-A-1
[164.199269] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.183s)
[164.199997] Subtest crtc-properties-atomic: SUCCESS (0.718s)
[164.367166] [076/156] (858s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[164.411265] Starting subtest: y-tiled-to-vebox-y-tiled
[164.412106] Starting dynamic subtest: smem
[164.508040] Dynamic subtest smem: SUCCESS (0.096s)
[164.508857] Subtest y-tiled-to-vebox-y-tiled: SUCCESS (0.097s)
[164.691797] [077/156] (857s left) syncobj_basic (bad-fd-to-handle)
[164.727110] Starting subtest: bad-fd-to-handle
[164.727835] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[164.810176] [078/156] (857s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-pwrite)
[164.905384] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-pwrite
[164.906764] Subtest hdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[164.998921] [079/156] (857s left) gem_pxp (create-valid-protected-context)
[165.101924] Starting subtest: create-valid-protected-context
[165.102911] Subtest create-valid-protected-context: SUCCESS (0.001s)
[165.194305] [080/156] (857s left) gem_mmap_gtt (medium-copy-odd)
[165.227900] Starting subtest: medium-copy-odd
[169.130671] Subtest medium-copy-odd: SUCCESS (3.902s)
[169.204079] [081/156] (853s left) syncobj_timeline (signal-point-0)
[169.294841] Starting subtest: signal-point-0
[169.295585] Subtest signal-point-0: SUCCESS (0.001s)
[169.383423] [082/156] (853s left) gem_close_race (multigpu-basic-process)
[169.429454] Starting subtest: multigpu-basic-process
[169.430860] Subtest multigpu-basic-process: SKIP (0.000s)
[169.610956] [083/156] (853s left) kms_vrr (flipline)
[169.706432] Starting subtest: flipline
[169.708639] Subtest flipline: SKIP (0.000s)
[169.766950] [084/156] (853s left) prime_self_import (basic-with_one_bo_two_files)
[169.800813] Starting subtest: basic-with_one_bo_two_files
[169.803342] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[169.910555] [085/156] (853s left) kms_atomic (plane-invalid-params-fence)
[169.997817] Starting subtest: plane-invalid-params-fence
[169.998551] Starting dynamic subtest: pipe-A-HDMI-A-1
[170.135871] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.137s)
[170.136692] Subtest plane-invalid-params-fence: SUCCESS (0.139s)
[170.281765] [086/156] (852s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[170.379983] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[170.381411] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[170.475949] [087/156] (852s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-gtt)
[170.568354] Starting subtest: psrhdr-rgb101010-draw-mmap-gtt
[170.569744] Subtest psrhdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[170.676685] [088/156] (852s left) i915_query (test-query-geometry-subslices)
[170.710920] Starting subtest: test-query-geometry-subslices
[170.712308] Subtest test-query-geometry-subslices: SKIP (0.000s)
[170.792066] [089/156] (852s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[170.883711] Starting subtest: fbc-rgb565-draw-blt
[172.153362] Subtest fbc-rgb565-draw-blt: SUCCESS (1.270s)
[172.285253] [090/156] (850s left) gem_ctx_persistence (idempotent)
[172.324339] Starting subtest: idempotent
[172.325124] Subtest idempotent: SUCCESS (0.000s)
[172.394564] [091/156] (850s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[172.484865] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[173.018481] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.534s)
[173.186100] [092/156] (850s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[173.285479] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[173.286920] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[173.375910] [093/156] (849s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[173.468379] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[173.469756] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[173.570652] [094/156] (849s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[173.606026] Starting subtest: multi-wait-available-submitted-signaled
[173.606729] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[173.678182] [095/156] (849s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[173.767069] Starting subtest: cursorB-vs-flipA-atomic-transitions
[173.768691] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.002s)
[173.837662] [096/156] (849s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[173.926148] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[173.926882] Starting dynamic subtest: pipe-A
[175.023357] Dynamic subtest pipe-A: SUCCESS (1.097s)
[175.041829] Starting dynamic subtest: pipe-B
[176.208852] Dynamic subtest pipe-B: SUCCESS (1.184s)
[176.219678] Starting dynamic subtest: pipe-C
[176.418437] Dynamic subtest pipe-C: SUCCESS (0.209s)
[176.430180] Starting dynamic subtest: pipe-D
[176.635694] Dynamic subtest pipe-D: SUCCESS (0.216s)
[176.636489] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (2.711s)
[176.821893] [097/156] (846s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[176.860941] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[176.967405] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s)
[177.043617] [098/156] (846s left) drm_read (empty-nonblock)
[177.156093] Starting subtest: empty-nonblock
[177.156854] Subtest empty-nonblock: SUCCESS (0.000s)
[177.268798] [099/156] (846s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[177.357806] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.000s)
[177.406235] [100/156] (846s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[177.495060] Starting subtest: 2x-long-flip-vs-cursor-atomic
[177.496426] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.002s)
[177.560465] [101/156] (846s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[177.649443] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[177.650227] Starting dynamic subtest: pipe-A
[177.783646] Dynamic subtest pipe-A: SUCCESS (0.134s)
[177.794680] Starting dynamic subtest: pipe-B
[177.917434] Dynamic subtest pipe-B: SUCCESS (0.133s)
[177.935976] Starting dynamic subtest: pipe-C
[178.077279] Dynamic subtest pipe-C: SUCCESS (0.159s)
[178.089348] Starting dynamic subtest: pipe-D
[178.238348] Dynamic subtest pipe-D: SUCCESS (0.160s)
[178.240221] Subtest planes-downscale-factor-0-5-unity-scaling: SUCCESS (0.590s)
[178.423414] [102/156] (845s left) kms_psr (psr2-sprite-plane-onoff)
[178.514629] Subtest psr2-sprite-plane-onoff: SKIP (0.000s)
[178.558578] [103/156] (845s left) api_intel_bb (full-batch)
[178.598921] Starting subtest: full-batch
[178.599625] Subtest full-batch: SUCCESS (0.003s)
[178.697021] [104/156] (845s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-blt)
[178.790298] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-blt
[178.791829] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[178.889932] [105/156] (844s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite)
[178.982427] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite
[178.983800] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[179.082600] [106/156] (844s left) kms_flip (dpms-vs-vblank-race)
[179.171243] Starting subtest: dpms-vs-vblank-race
[179.173723] Starting dynamic subtest: A-HDMI-A1
[182.068724] Dynamic subtest A-HDMI-A1: SUCCESS (2.894s)
[182.077995] Starting dynamic subtest: B-HDMI-A1
[184.913318] Dynamic subtest B-HDMI-A1: SUCCESS (2.843s)
[184.924716] Starting dynamic subtest: C-HDMI-A1
[187.790102] Dynamic subtest C-HDMI-A1: SUCCESS (2.876s)
[187.800837] Starting dynamic subtest: D-HDMI-A1
[190.637824] Dynamic subtest D-HDMI-A1: SUCCESS (2.845s)
[190.640325] Subtest dpms-vs-vblank-race: SUCCESS (11.469s)
[190.819640] [107/156] (833s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[190.920999] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[190.922875] Starting dynamic subtest: pipe-A-HDMI-A-1
[190.941118] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[190.950159] Starting dynamic subtest: pipe-B-HDMI-A-1
[190.968658] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[190.977460] Starting dynamic subtest: pipe-C-HDMI-A-1
[190.995548] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[191.005058] Starting dynamic subtest: pipe-D-HDMI-A-1
[191.022906] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[191.024255] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.014s)
[191.191051] [108/156] (832s left) dumb_buffer (map-invalid-size)
[191.226675] Starting subtest: map-invalid-size
[191.227424] Subtest map-invalid-size: SUCCESS (0.000s)
[191.309674] [109/156] (832s left) kms_frontbuffer_tracking (psrhdr-shrfb-scaledprimary)
[191.402479] Starting subtest: psrhdr-shrfb-scaledprimary
[191.403926] Subtest psrhdr-shrfb-scaledprimary: SKIP (0.000s)
[191.500328] [110/156] (832s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-msflip-blt)
[191.592174] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-msflip-blt
[191.593583] Subtest fbcpsrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[191.693505] [111/156] (832s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[191.728213] Starting subtest: invalid-multi-wait-unsubmitted
[191.728956] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[191.798478] [112/156] (832s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[191.889087] Starting subtest: 2x-long-cursor-vs-flip-atomic
[191.890725] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.002s)
[191.957486] [113/156] (832s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-blt)
[192.051013] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-blt
[192.052469] Subtest hdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[192.149141] [114/156] (832s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-pwrite)
[192.241453] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-pwrite
[192.242869] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[192.333049] [115/156] (831s left) kms_fbcon_fbt (psr)
[192.372485] Starting subtest: psr
[192.373854] Subtest psr: SKIP (0.000s)
[192.462790] [116/156] (831s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[192.606327] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[192.716487] [117/156] (831s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[192.811394] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[192.858259] [118/156] (831s left) gem_mmap_gtt (close-race)
[192.892123] Starting subtest: close-race
[212.969092] Subtest close-race: SUCCESS (20.068s)
[213.092312] [119/156] (811s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[213.188415] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc
[213.189932] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[213.283462] [120/156] (811s left) kms_flip (2x-flip-vs-panning)
[213.371588] Starting subtest: 2x-flip-vs-panning
[213.380843] Subtest 2x-flip-vs-panning: SKIP (0.009s)
[213.450383] [121/156] (811s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[213.539151] Starting subtest: basic-busy-flip-before-cursor-atomic
[213.540658] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[213.598609] [122/156] (810s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-move)
[213.692984] Starting subtest: hdr-2p-scndscrn-cur-indfb-move
[213.694471] Subtest hdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[213.783441] [123/156] (810s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[213.875783] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[215.220730] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (1.346s)
[215.334499] [124/156] (809s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[215.437359] Starting subtest: yf-tiled-64bpp-rotate-270
[215.438873] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[215.522814] [125/156] (809s left) gem_madvise (dontneed-before-exec)
[215.556264] Starting subtest: dontneed-before-exec
[215.559132] Subtest dontneed-before-exec: SUCCESS (0.003s)
[215.659997] [126/156] (809s left) kms_display_modes (extended-mode-basic)
[215.748448] Starting subtest: extended-mode-basic
[215.750069] Subtest extended-mode-basic: SKIP (0.000s)
[215.795762] [127/156] (808s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[215.895200] Starting subtest: 4-tiled-8bpp-rotate-180
[215.896633] Subtest 4-tiled-8bpp-rotate-180: SKIP (0.000s)
[215.993855] [128/156] (808s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[216.083108] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[216.084577] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[216.141663] [129/156] (808s left) gem_softpin (evict-active-interruptible)
[216.183365] Starting subtest: evict-active-interruptible
[216.187625] Subtest evict-active-interruptible: SUCCESS (0.004s)
[216.293363] [130/156] (808s left) kms_lease (possible-crtcs-filtering)
[216.381139] Starting subtest: possible-crtcs-filtering
[216.385810] Subtest possible-crtcs-filtering: SUCCESS (0.004s)
[216.483386] [131/156] (808s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[216.574883] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[216.620322] [132/156] (808s left) sw_sync (sync_merge)
[216.654228] Starting subtest: sync_merge
[216.654987] Subtest sync_merge: SUCCESS (0.000s)
[216.708170] [133/156] (808s left) kms_content_protection (uevent)
[216.801074] Starting subtest: uevent
[216.806495] Subtest uevent: SKIP (0.004s)
[216.910529] [134/156] (808s left) kms_getfb (getfb-addfb-different-handles)
[217.000175] Starting subtest: getfb-addfb-different-handles
[217.000927] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[217.111283] [135/156] (807s left) gem_eio (create)
[217.156511] Starting subtest: create
[217.182815] Subtest create: SUCCESS (0.025s)
[217.312930] [136/156] (807s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[217.406128] Starting subtest: addfb25-y-tiled-legacy
[217.406926] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[217.494724] [137/156] (807s left) kms_force_connector_basic (force-load-detect)
[217.618980] Starting subtest: force-load-detect
[217.620446] Subtest force-load-detect: SKIP (0.000s)
[217.773224] [138/156] (807s left) syncobj_timeline (invalid-signal-bad-pad)
[217.809103] Starting subtest: invalid-signal-bad-pad
[217.809884] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[217.882014] [139/156] (807s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-blt)
[217.973473] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-blt
[217.974984] Subtest fbchdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[218.077644] [140/156] (807s left) gem_lmem_swapping (massive-random)
[218.115962] Subtest massive-random: SKIP (0.000s)
[218.162061] [141/156] (807s left) kms_selftest (drm_plane_helper)
[218.201164] Starting subtest: drm_plane_helper
[218.228504] Starting dynamic subtest: drm_test_check_plane_state
[218.298991] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.069s)
[218.314256] Starting dynamic subtest: drm_test_check_invalid_plane_state
[218.366894] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.064s)
[218.370971] Subtest drm_plane_helper: SUCCESS (0.167s)
[218.495137] [142/156] (806s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[218.583418] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[218.584914] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[218.664287] [143/156] (806s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[218.756584] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[218.758084] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[218.856816] [144/156] (806s left) kms_invalid_mode (bad-vsync-start)
[218.946840] Starting subtest: bad-vsync-start
[218.947585] Starting dynamic subtest: pipe-A-HDMI-A-1
[218.997545] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.051s)
[219.009826] Starting dynamic subtest: pipe-B-HDMI-A-1
[219.010536] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[219.019727] Starting dynamic subtest: pipe-C-HDMI-A-1
[219.020430] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[219.030082] Starting dynamic subtest: pipe-D-HDMI-A-1
[219.030852] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.002s)
[219.031566] Subtest bad-vsync-start: SUCCESS (0.066s)
[219.161216] [145/156] (806s left) kms_addfb_basic (unused-modifier)
[219.197910] Starting subtest: unused-modifier
[219.198669] Subtest unused-modifier: SUCCESS (0.000s)
[219.358741] [146/156] (806s left) gem_exec_flush (basic-wb-prw-default)
[219.404016] Starting subtest: basic-wb-prw-default
[224.828198] Subtest basic-wb-prw-default: SUCCESS (5.425s)
[225.043241] [147/156] (800s left) kms_flip (blocking-absolute-wf_vblank)
[225.135856] Starting subtest: blocking-absolute-wf_vblank
[225.138167] Starting dynamic subtest: A-HDMI-A1
[232.819421] Dynamic subtest A-HDMI-A1: SUCCESS (7.681s)
[232.831947] Starting dynamic subtest: B-HDMI-A1
[240.517125] Dynamic subtest B-HDMI-A1: SUCCESS (7.666s)
[240.525784] Starting dynamic subtest: C-HDMI-A1
[248.182828] Dynamic subtest C-HDMI-A1: SUCCESS (7.665s)
[248.192193] Starting dynamic subtest: D-HDMI-A1
[255.841064] Dynamic subtest D-HDMI-A1: SUCCESS (7.656s)
[255.841962] Subtest blocking-absolute-wf_vblank: SUCCESS (30.682s)
[256.002191] [148/156] (769s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[256.096374] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[257.755184] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SUCCESS (1.659s)
[257.887955] [149/156] (767s left) kms_psr (fbc-psr-sprite-blt)
[257.981679] Subtest fbc-psr-sprite-blt: SKIP (0.000s)
[258.029352] [150/156] (767s left) vgem_basic (dmabuf-export)
[258.063920] Starting subtest: dmabuf-export
[258.066486] Subtest dmabuf-export: SUCCESS (0.003s)
[258.169915] [151/156] (767s left) kms_chamelium_color (ctm-0-50)
[258.260738] Subtest ctm-0-50: SKIP (0.000s)
[258.305717] [152/156] (767s left) perf_pmu (busy-idle-check-all)
[258.342706] Starting subtest: busy-idle-check-all
[258.343494] Starting dynamic subtest: rcs0
[258.963954] Dynamic subtest rcs0: SUCCESS (0.620s)
[258.976322] Starting dynamic subtest: bcs0
[259.595807] Dynamic subtest bcs0: SUCCESS (0.631s)
[259.606351] Starting dynamic subtest: vcs0
[260.219323] Dynamic subtest vcs0: SUCCESS (0.622s)
[260.234903] Starting dynamic subtest: vcs1
[260.846292] Dynamic subtest vcs1: SUCCESS (0.624s)
[260.861224] Starting dynamic subtest: vecs0
[261.472785] Dynamic subtest vecs0: SUCCESS (0.623s)
[261.474088] Subtest busy-idle-check-all: SUCCESS (3.131s)
[261.548127] [153/156] (764s left) gem_exec_balancer (bonded-true-hang)
[261.709099] Starting subtest: bonded-true-hang
[262.988093] Subtest bonded-true-hang: SUCCESS (1.279s)
[263.052163] [154/156] (762s left) kms_cursor_crc (cursor-random-256x256)
[263.152678] Starting subtest: cursor-random-256x256
[263.157450] Starting dynamic subtest: pipe-A-HDMI-A-1
[265.057131] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.898s)
[265.098505] Starting dynamic subtest: pipe-D-HDMI-A-1
[266.984070] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.894s)
[266.984871] Subtest cursor-random-256x256: SUCCESS (3.832s)
[267.135973] [155/156] (758s left) kms_rotation_crc (primary-rotation-180)
[267.229066] Starting subtest: primary-rotation-180
[270.766903] Subtest primary-rotation-180: SUCCESS (3.538s)
[270.966332] [156/156] (755s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[271.059930] Starting subtest: flip-vs-cursor-busy-crc-atomic
[271.374898] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.315s)
[271.533673] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: i915_drm_fdinfo
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: gem_render_copy
results: parsing output: 8/ for test: gem_ctx_param
results: parsing output: 9/ for test: prime_vgem
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_flip_scaled_crc
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: gem_userptr_blits
results: parsing output: 16/ for test: i915_pm_rpm
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: gem_exec_reloc
results: parsing output: 19/ for test: kms_vrr
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: syncobj_wait
results: parsing output: 23/ for test: kms_pipe_crc_basic
results: parsing output: 24/ for test: kms_cursor_crc
results: parsing output: 25/ for test: gem_pipe_control_store_loop
results: parsing output: 26/ for test: sw_sync
results: parsing output: 27/ for test: gem_exec_whisper
results: parsing output: 28/ for test: gem_basic
results: parsing output: 29/ for test: kms_rotation_crc
results: parsing output: 30/ for test: gem_exec_schedule
results: parsing output: 31/ for test: gem_busy
results: parsing output: 32/ for test: kms_pipe_b_c_ivb
results: parsing output: 33/ for test: kms_force_connector_basic
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: gem_exec_balancer
results: parsing output: 36/ for test: kms_psr2_su
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_exec_fence
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_pm_rpm
results: parsing output: 42/ for test: api_intel_allocator
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: gem_mmap_wc
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_busy
results: parsing output: 48/ for test: gem_reg_read
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_cursor_edge_walk
results: parsing output: 51/ for test: sysfs_preempt_timeout
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: gen9_exec_parse
results: parsing output: 56/ for test: kms_color_pipeline
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: i915_drm_fdinfo
results: parsing output: 59/ for test: gem_softpin
results: parsing output: 60/ for test: kms_chamelium_frames
results: parsing output: 61/ for test: kms_pm_rpm
results: parsing output: 62/ for test: prime_busy
results: parsing output: 63/ for test: gem_mmap_offset
results: parsing output: 64/ for test: kms_plane
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gen7_exec_parse
results: parsing output: 67/ for test: kms_draw_crc
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_properties
results: parsing output: 75/ for test: gem_render_copy
results: parsing output: 76/ for test: syncobj_basic
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_pxp
results: parsing output: 79/ for test: gem_mmap_gtt
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: gem_close_race
results: parsing output: 82/ for test: kms_vrr
results: parsing output: 83/ for test: prime_self_import
results: parsing output: 84/ for test: kms_atomic
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: i915_query
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_ctx_persistence
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_cursor_legacy
results: parsing output: 95/ for test: kms_plane_scaling
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: drm_read
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: kms_plane_scaling
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: api_intel_bb
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: dumb_buffer
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_fbcon_fbt
results: parsing output: 115/ for test: kms_chamelium_hpd
results: parsing output: 116/ for test: kms_psr2_sf
results: parsing output: 117/ for test: gem_mmap_gtt
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_madvise
results: parsing output: 125/ for test: kms_display_modes
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_plane
results: parsing output: 128/ for test: gem_softpin
results: parsing output: 129/ for test: kms_lease
results: parsing output: 130/ for test: kms_psr2_sf
results: parsing output: 131/ for test: sw_sync
results: parsing output: 132/ for test: kms_content_protection
results: parsing output: 133/ for test: kms_getfb
results: parsing output: 134/ for test: gem_eio
results: parsing output: 135/ for test: kms_addfb_basic
results: parsing output: 136/ for test: kms_force_connector_basic
results: parsing output: 137/ for test: syncobj_timeline
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: gem_lmem_swapping
results: parsing output: 140/ for test: kms_selftest
results: parsing output: 141/ for test: kms_flip_scaled_crc
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_invalid_mode
results: parsing output: 144/ for test: kms_addfb_basic
results: parsing output: 145/ for test: gem_exec_flush
results: parsing output: 146/ for test: kms_flip
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_psr
results: parsing output: 149/ for test: vgem_basic
results: parsing output: 150/ for test: kms_chamelium_color
results: parsing output: 151/ for test: perf_pmu
results: parsing output: 152/ for test: gem_exec_balancer
results: parsing output: 153/ for test: kms_cursor_crc
results: parsing output: 154/ for test: kms_rotation_crc
results: parsing output: 155/ for test: kms_cursor_legacy
Done.