[59.596138] Initializing watchdogs
[59.596189]   /dev/watchdog0
[59.625912] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.630427] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.633184] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.635567] [001/133] (960s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[59.741510] Starting subtest: 4-tiled-32bpp-rotate-0
[61.197230] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.456s)
[61.338119] [002/133] (958s left) gen9_exec_parse (shadow-peek)
[61.406350] Subtest shadow-peek: SKIP (0.000s)
[61.463813] [003/133] (958s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[61.560181] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[61.561904] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[61.642417] [004/133] (958s left) gem_exec_fence (syncobj-invalid-flags)
[62.091236] Starting subtest: syncobj-invalid-flags
[62.092286] Subtest syncobj-invalid-flags: SUCCESS (0.001s)
[63.384204] [FACT gem_exec_fence (syncobj-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[63.386165] [005/133] (956s left) syncobj_timeline (etime-single-wait-submitted)
[63.437529] Starting subtest: etime-single-wait-submitted
[63.542025] Subtest etime-single-wait-submitted: SUCCESS (0.104s)
[63.610984] [006/133] (956s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[63.697148] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[63.698007] Starting dynamic subtest: pipe-A-eDP-1
[63.701344] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[63.710544] Starting dynamic subtest: pipe-B-eDP-1
[63.713743] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[63.723037] Starting dynamic subtest: pipe-C-eDP-1
[63.726258] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[63.736335] Starting dynamic subtest: pipe-D-eDP-1
[63.740064] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[63.742181] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.003s)
[65.976636] [007/133] (954s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[66.067052] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[66.068894] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[66.145485] [008/133] (954s left) drm_read (fault-buffer)
[66.269731] Starting subtest: fault-buffer
[66.270833] Subtest fault-buffer: SUCCESS (0.000s)
[66.400026] [009/133] (954s left) dumb_buffer (map-valid)
[66.446471] Starting subtest: map-valid
[66.447641] Subtest map-valid: SUCCESS (0.000s)
[66.535190] [010/133] (953s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[66.635286] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[66.636897] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[66.727638] [011/133] (953s left) gem_exec_reloc (basic-write-read)
[66.772600] Subtest basic-write-read: SKIP (0.000s)
[66.826662] [012/133] (953s left) kms_flip (flip-vs-dpms-on-nop)
[66.918722] Starting subtest: flip-vs-dpms-on-nop
[66.921094] Starting dynamic subtest: A-eDP1
[68.755307] Dynamic subtest A-eDP1: SUCCESS (1.834s)
[68.764857] Starting dynamic subtest: B-eDP1
[70.577435] Dynamic subtest B-eDP1: SUCCESS (1.821s)
[70.586310] Starting dynamic subtest: C-eDP1
[72.419745] Dynamic subtest C-eDP1: SUCCESS (1.841s)
[72.430424] Starting dynamic subtest: D-eDP1
[74.263879] Dynamic subtest D-eDP1: SUCCESS (1.843s)
[74.266869] Subtest flip-vs-dpms-on-nop: SUCCESS (7.348s)
[75.445187] [013/133] (945s left) kms_cursor_crc (cursor-random-128x42)
[75.654952] Starting subtest: cursor-random-128x42
[75.698212] Subtest cursor-random-128x42: SKIP (0.041s)
[75.883655] [014/133] (944s left) gem_exec_schedule (pi-distinct-iova)
[76.066620] Starting subtest: pi-distinct-iova
[76.067653] Starting dynamic subtest: rcs0
[76.140705] Dynamic subtest rcs0: SUCCESS (0.079s)
[76.151258] Starting dynamic subtest: vcs0
[76.199466] Dynamic subtest vcs0: SUCCESS (0.059s)
[76.207189] Starting dynamic subtest: vcs1
[76.254372] Dynamic subtest vcs1: SUCCESS (0.055s)
[76.263911] Starting dynamic subtest: vecs0
[76.308947] Dynamic subtest vecs0: SUCCESS (0.054s)
[76.315433] Starting dynamic subtest: ccs0
[76.372607] Dynamic subtest ccs0: SUCCESS (0.063s)
[76.373727] Subtest pi-distinct-iova: SUCCESS (0.311s)
[77.427040] [015/133] (943s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[77.527673] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[77.529401] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[77.630973] [016/133] (943s left) kms_atomic_interruptible (legacy-pageflip)
[77.714355] Starting subtest: legacy-pageflip
[77.715430] Starting dynamic subtest: pipe-A-eDP-1
[85.161424] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.447s)
[85.162402] Subtest legacy-pageflip: SUCCESS (7.448s)
[86.019035] [017/133] (934s left) kms_async_flips (async-flip-dpms)
[86.104511] Starting subtest: async-flip-dpms
[86.490886] Starting dynamic subtest: pipe-A-eDP-1
[90.448332] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.958s)
[90.818270] Starting dynamic subtest: pipe-B-eDP-1
[93.609730] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.800s)
[93.998759] Starting dynamic subtest: pipe-C-eDP-1
[96.775355] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.783s)
[97.155822] Starting dynamic subtest: pipe-D-eDP-1
[99.951520] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.802s)
[99.952456] Subtest async-flip-dpms: SUCCESS (13.848s)
[101.124829] [018/133] (919s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[101.185900] Starting subtest: rel-constants-invalid-rel-gen5
[101.186898] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[101.280444] [019/133] (919s left) gem_ctx_engines (execute-oneforall)
[101.340420] Starting subtest: execute-oneforall
[101.811488] Subtest execute-oneforall: SUCCESS (0.471s)
[103.439655] [020/133] (917s left) kms_cdclk (mode-transition-all-outputs)
[103.523335] Starting subtest: mode-transition-all-outputs
[103.809210] Subtest mode-transition-all-outputs: SKIP (0.286s)
[104.648752] [021/133] (916s left) kms_psr (fbc-psr-dpms)
[104.735202] Starting subtest: fbc-psr-dpms
[104.736047] Starting dynamic subtest: eDP-1
[104.737686] Dynamic subtest eDP-1: SKIP (0.000s)
[104.739426] Subtest fbc-psr-dpms: SKIP (0.000s)
[104.801555] [022/133] (916s left) gem_shrink (reclaim)
[104.858615] Starting subtest: reclaim
[107.250509] Subtest reclaim: SUCCESS (2.379s)
[107.366585] [023/133] (913s left) kms_rotation_crc (primary-rotation-180)
[107.451912] Starting subtest: primary-rotation-180
[114.325444] Subtest primary-rotation-180: SUCCESS (6.874s)
[115.515544] [024/133] (905s left) kms_psr (psr2-primary-render)
[115.604454] Starting subtest: psr2-primary-render
[115.605391] Starting dynamic subtest: eDP-1
[117.305276] Dynamic subtest eDP-1: SUCCESS (1.701s)
[117.306114] Subtest psr2-primary-render: SUCCESS (1.702s)
[118.169238] [025/133] (902s left) kms_cursor_legacy (torture-move)
[118.276805] Starting subtest: torture-move
[118.277759] Starting dynamic subtest: pipe-A
[123.969593] Dynamic subtest pipe-A: SUCCESS (5.646s)
[123.978462] Starting dynamic subtest: pipe-B
[130.342885] Dynamic subtest pipe-B: SUCCESS (6.408s)
[130.352530] Starting dynamic subtest: pipe-C
[136.395879] Dynamic subtest pipe-C: SUCCESS (6.053s)
[136.405214] Starting dynamic subtest: pipe-D
[142.612929] Dynamic subtest pipe-D: SUCCESS (6.215s)
[142.622071] Starting dynamic subtest: all-pipes
[148.618847] Dynamic subtest all-pipes: SUCCESS (6.005s)
[148.619926] Subtest torture-move: SUCCESS (30.334s)
[148.807821] [026/133] (872s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[148.862358] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[148.863348] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[148.973152] [027/133] (872s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[149.026285] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[149.080099] [028/133] (872s left) kms_feature_discovery (display-4x)
[149.160586] Starting subtest: display-4x
[149.162623] Subtest display-4x: SKIP (0.000s)
[149.230482] [029/133] (871s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[149.320841] Starting subtest: x-tiled-addfb-size-offset-overflow
[149.321935] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[149.401752] [030/133] (871s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[149.491562] Starting subtest: invalidate-primary-flip-overlay
[160.225505] Subtest invalidate-primary-flip-overlay: SUCCESS (10.733s)
[160.338273] [031/133] (860s left) gem_pxp (hw-rejects-pxp-context)
[160.453779] Starting subtest: hw-rejects-pxp-context
[160.456217] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[160.554079] [032/133] (860s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[160.641219] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[166.230518] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.589s)
[167.386135] [033/133] (853s left) prime_udl
[167.469731] [034/133] (853s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[167.525936] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[167.527028] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[167.624581] [035/133] (853s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[167.712641] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[167.713596] Starting dynamic subtest: pipe-A-eDP-1
[167.736316] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[167.744676] Starting dynamic subtest: pipe-B-eDP-1
[167.765768] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[167.772810] Starting dynamic subtest: pipe-C-eDP-1
[167.801156] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[167.807958] Starting dynamic subtest: pipe-D-eDP-1
[167.829350] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[167.830954] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.008s)
[170.046537] [036/133] (851s left) kms_chamelium_edid (hdmi-edid-read)
[170.420736] Subtest hdmi-edid-read: SKIP (0.000s)
[171.264933] [037/133] (850s left) gem_userptr_blits (readonly-unsync)
[171.335076] Subtest readonly-unsync: SKIP (0.000s)
[171.455469] [038/133] (850s left) gem_ctx_shared (q-smoketest)
[171.504045] Starting subtest: Q-smoketest
[171.505081] Starting dynamic subtest: rcs0
[177.098060] Dynamic subtest rcs0: SUCCESS (5.521s)
[177.106700] Starting dynamic subtest: bcs0
[182.585867] Dynamic subtest bcs0: SUCCESS (5.495s)
[182.593874] Starting dynamic subtest: vcs0
[188.062931] Dynamic subtest vcs0: SUCCESS (5.477s)
[188.072101] Starting dynamic subtest: vcs1
[193.544886] Dynamic subtest vcs1: SUCCESS (5.479s)
[193.555719] Starting dynamic subtest: vecs0
[199.019552] Dynamic subtest vecs0: SUCCESS (5.473s)
[199.029461] Starting dynamic subtest: ccs0
[204.517500] Dynamic subtest ccs0: SUCCESS (5.496s)
[204.518403] Subtest Q-smoketest: SUCCESS (32.947s)
[204.647735] [039/133] (816s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[204.738881] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[204.739815] Starting dynamic subtest: pipe-A
[205.077921] Dynamic subtest pipe-A: SUCCESS (0.340s)
[205.087084] Starting dynamic subtest: pipe-B
[206.483844] Dynamic subtest pipe-B: SUCCESS (1.406s)
[206.491340] Starting dynamic subtest: pipe-C
[207.949795] Dynamic subtest pipe-C: SUCCESS (1.465s)
[207.957367] Starting dynamic subtest: pipe-D
[209.340141] Dynamic subtest pipe-D: SUCCESS (1.390s)
[209.341272] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.603s)
[210.515962] [040/133] (811s left) syncobj_basic (bad-pad-fd-to-handle)
[210.571487] Starting subtest: bad-pad-fd-to-handle
[210.572478] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[210.662574] [041/133] (810s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[210.749207] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[210.750059] Starting dynamic subtest: pipe-A-eDP-1
[210.758715] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[210.766310] Starting dynamic subtest: pipe-B-eDP-1
[210.774566] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[210.781196] Starting dynamic subtest: pipe-C-eDP-1
[210.789092] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[210.795853] Starting dynamic subtest: pipe-D-eDP-1
[210.804188] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[210.805781] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[212.969738] [042/133] (808s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[213.070896] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[213.098396] Starting dynamic subtest: pipe-A-plane-0
[213.531334] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[213.538366] Starting dynamic subtest: pipe-A-plane-3
[213.843356] Dynamic subtest pipe-A-plane-3: SUCCESS (0.311s)
[214.961023] Starting dynamic subtest: pipe-B-plane-0
[215.386272] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[215.397492] Starting dynamic subtest: pipe-B-plane-3
[215.641922] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[215.962698] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.892s)
[216.848220] [043/133] (804s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[216.940660] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[216.942353] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[217.032988] [044/133] (804s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[217.123930] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[217.125725] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[217.211028] [045/133] (804s left) kms_pipe_crc_basic (read-crc)
[217.310039] Starting subtest: read-crc
[217.310988] Starting dynamic subtest: pipe-A-eDP-1
[218.022597] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.712s)
[218.029582] Starting dynamic subtest: pipe-B-eDP-1
[219.430761] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.406s)
[219.437757] Starting dynamic subtest: pipe-C-eDP-1
[220.800764] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.370s)
[220.811084] Starting dynamic subtest: pipe-D-eDP-1
[222.130306] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[222.131182] Subtest read-crc: SUCCESS (4.821s)
[222.953090] [046/133] (798s left) gen9_exec_parse (secure-batches)
[223.004653] Subtest secure-batches: SKIP (0.000s)
[223.065032] [047/133] (798s left) gem_partial_pwrite_pread (write-display)
[223.111388] Subtest write-display: SKIP (0.000s)
[223.169878] [048/133] (798s left) kms_flip (2x-plain-flip-interruptible)
[223.265386] Starting subtest: 2x-plain-flip-interruptible
[223.277688] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[223.361393] [049/133] (798s left) sysfs_heartbeat_interval (idempotent)
[223.412279] Starting subtest: idempotent
[223.413129] Starting dynamic subtest: vecs0
[223.413931] Dynamic subtest vecs0: SUCCESS (0.001s)
[223.421147] Starting dynamic subtest: ccs0
[223.421951] Dynamic subtest ccs0: SUCCESS (0.001s)
[223.428639] Starting dynamic subtest: vcs0
[223.429486] Dynamic subtest vcs0: SUCCESS (0.000s)
[223.436119] Starting dynamic subtest: bcs0
[223.437056] Dynamic subtest bcs0: SUCCESS (0.001s)
[223.443780] Starting dynamic subtest: rcs0
[223.444684] Dynamic subtest rcs0: SUCCESS (0.000s)
[223.451329] Starting dynamic subtest: vcs1
[223.452225] Dynamic subtest vcs1: SUCCESS (0.000s)
[223.453031] Subtest idempotent: SUCCESS (0.008s)
[223.510809] [050/133] (798s left) gem_madvise (dontneed-after-mmap)
[223.540123] Starting subtest: dontneed-after-mmap
[223.559433] Subtest dontneed-after-mmap: SUCCESS (0.018s)
[223.646591] [051/133] (798s left) kms_psr (fbc-psr2-cursor-render)
[223.727364] Starting subtest: fbc-psr2-cursor-render
[223.728205] Starting dynamic subtest: eDP-1
[223.729807] Dynamic subtest eDP-1: SKIP (0.000s)
[223.731580] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[223.808335] [052/133] (798s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[223.901540] Starting subtest: invalid-modeset-force-ultra-joiner
[223.903417] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[223.971486] [053/133] (798s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[224.064674] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[224.065780] Starting dynamic subtest: pipe-A
[224.128591] Dynamic subtest pipe-A: SUCCESS (0.065s)
[224.137922] Starting dynamic subtest: pipe-B
[225.285600] Dynamic subtest pipe-B: SUCCESS (1.156s)
[225.295682] Starting dynamic subtest: pipe-C
[226.411584] Dynamic subtest pipe-C: SUCCESS (1.125s)
[226.420204] Starting dynamic subtest: pipe-D
[227.538546] Dynamic subtest pipe-D: SUCCESS (1.125s)
[227.539430] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.476s)
[228.692890] [054/133] (793s left) syncobj_wait (wait-all-interrupted)
[228.741299] Starting subtest: wait-all-interrupted
[228.845901] Subtest wait-all-interrupted: SUCCESS (0.104s)
[228.917398] [055/133] (793s left) gem_ctx_persistence (engines-hostile)
[228.972364] Starting subtest: engines-hostile
[228.973353] Starting dynamic subtest: rcs0
[229.072016] Dynamic subtest rcs0: SUCCESS (0.099s)
[229.083470] Starting dynamic subtest: bcs0
[229.170924] Dynamic subtest bcs0: SUCCESS (0.097s)
[229.180847] Starting dynamic subtest: vcs0
[229.286928] Dynamic subtest vcs0: SUCCESS (0.114s)
[229.297226] Starting dynamic subtest: vcs1
[229.377594] Dynamic subtest vcs1: SUCCESS (0.089s)
[229.388063] Starting dynamic subtest: vecs0
[229.470035] Dynamic subtest vecs0: SUCCESS (0.090s)
[229.480960] Starting dynamic subtest: ccs0
[229.557714] Dynamic subtest ccs0: SUCCESS (0.086s)
[229.559038] Subtest engines-hostile: SUCCESS (0.586s)
[229.631000] [056/133] (792s left) kms_prop_blob (invalid-get-prop)
[229.681288] Starting subtest: invalid-get-prop
[229.682203] Subtest invalid-get-prop: SUCCESS (0.000s)
[229.772073] [057/133] (792s left) gem_exec_whisper (basic-normal-all)
[229.823562] Starting subtest: basic-normal-all
[232.404460] Subtest basic-normal-all: SUCCESS (2.579s)
[232.587108] [058/133] (789s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[232.697301] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[239.699440] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (7.003s)
[239.821069] [059/133] (782s left) kms_async_flips (crc-atomic)
[239.906417] Starting subtest: crc-atomic
[240.282368] Starting dynamic subtest: pipe-A-eDP-1
[243.169730] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.887s)
[243.547169] Starting dynamic subtest: pipe-B-eDP-1
[246.477862] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.937s)
[246.862387] Starting dynamic subtest: pipe-C-eDP-1
[249.726068] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.871s)
[250.095299] Starting dynamic subtest: pipe-D-eDP-1
[252.945723] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.857s)
[252.946662] Subtest crc-atomic: SUCCESS (13.040s)
[254.116012] [060/133] (768s left) gem_mmap_gtt (hang-busy)
[254.167814] Subtest hang-busy: SKIP (0.000s)
[254.227746] [061/133] (768s left) kms_lease (simple-lease)
[254.312202] Starting subtest: simple-lease
[254.313086] Starting dynamic subtest: pipe-A-eDP-1
[254.821416] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.508s)
[254.832740] Starting dynamic subtest: pipe-B-eDP-1
[256.264370] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.442s)
[256.272966] Starting dynamic subtest: pipe-C-eDP-1
[257.670763] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.403s)
[257.678807] Starting dynamic subtest: pipe-D-eDP-1
[259.107956] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.435s)
[259.109211] Subtest simple-lease: SUCCESS (4.795s)
[259.933271] [062/133] (762s left) prime_busy (before-wait)
[259.983870] Starting subtest: before-wait
[259.986377] Starting dynamic subtest: rcs0
[260.015412] Dynamic subtest rcs0: SUCCESS (0.029s)
[260.024653] Starting dynamic subtest: bcs0
[260.055605] Dynamic subtest bcs0: SUCCESS (0.039s)
[260.063698] Starting dynamic subtest: vcs0
[260.097181] Dynamic subtest vcs0: SUCCESS (0.041s)
[260.104823] Starting dynamic subtest: vcs1
[260.139706] Dynamic subtest vcs1: SUCCESS (0.042s)
[260.148236] Starting dynamic subtest: vecs0
[260.180620] Dynamic subtest vecs0: SUCCESS (0.040s)
[260.188353] Starting dynamic subtest: ccs0
[260.221881] Dynamic subtest ccs0: SUCCESS (0.041s)
[260.329834] Subtest before-wait: SUCCESS (0.345s)
[260.401291] [063/133] (761s left) gem_exec_fence (syncobj-wait)
[260.867478] Starting subtest: syncobj-wait
[262.344781] Subtest syncobj-wait: SUCCESS (1.467s)
[264.387417] [064/133] (757s left) gem_close (basic)
[264.447444] Starting subtest: basic
[264.448442] Subtest basic: SUCCESS (0.000s)
[264.560927] [065/133] (757s left) gem_ctx_persistence (processes)
[264.611058] Starting subtest: processes
[266.285014] Subtest processes: SUCCESS (1.674s)
[266.359174] [066/133] (756s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[266.450376] Starting subtest: pr-cursor-plane-update-sf
[266.451969] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[266.520105] [067/133] (755s left) prime_vgem (fence-write-hang)
[266.591587] Subtest fence-write-hang: SKIP (0.000s)
[266.686959] [068/133] (755s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[266.783607] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[266.795399] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[266.921752] [069/133] (755s left) kms_atomic_interruptible (universal-setplane-cursor)
[267.022032] Starting subtest: universal-setplane-cursor
[267.023174] Starting dynamic subtest: pipe-A-eDP-1
[274.441479] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.418s)
[274.442416] Subtest universal-setplane-cursor: SUCCESS (7.420s)
[275.279450] [070/133] (747s left) gem_wait (await)
[275.336134] Starting subtest: await
[275.336985] Starting dynamic subtest: all-engines
[276.424614] Dynamic subtest all-engines: SUCCESS (1.089s)
[276.442735] Starting dynamic subtest: rcs0
[277.481299] Dynamic subtest rcs0: SUCCESS (1.055s)
[277.498649] Starting dynamic subtest: bcs0
[278.538191] Dynamic subtest bcs0: SUCCESS (1.054s)
[278.556264] Starting dynamic subtest: vcs0
[279.591391] Dynamic subtest vcs0: SUCCESS (1.051s)
[279.609381] Starting dynamic subtest: vcs1
[280.644039] Dynamic subtest vcs1: SUCCESS (1.050s)
[280.660200] Starting dynamic subtest: vecs0
[281.699050] Dynamic subtest vecs0: SUCCESS (1.053s)
[281.716444] Starting dynamic subtest: ccs0
[282.756040] Dynamic subtest ccs0: SUCCESS (1.054s)
[282.757273] Subtest await: SUCCESS (7.421s)
[282.946956] [071/133] (739s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[283.046829] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[283.048623] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[283.135791] [072/133] (739s left) kms_vrr (negative-basic)
[283.233403] Starting subtest: negative-basic
[283.236039] Starting dynamic subtest: pipe-A-eDP-1
[288.696211] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.413s)
[288.944027] Subtest negative-basic: SUCCESS (5.709s)
[289.813410] [073/133] (732s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[289.903291] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[289.905060] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[289.993411] [074/133] (732s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[290.086466] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[290.087376] Starting dynamic subtest: pipe-A-default-mode
[292.886567] Dynamic subtest pipe-A-default-mode: SUCCESS (2.800s)
[292.887619] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.801s)
[293.709180] [075/133] (729s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[293.798821] Starting subtest: y-tiled-16bpp-rotate-0
[293.800852] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[293.889707] [076/133] (728s left) kms_cursor_crc (cursor-sliding-512x170)
[294.171194] Starting subtest: cursor-sliding-512x170
[294.172910] Subtest cursor-sliding-512x170: SKIP (0.001s)
[294.312333] [077/133] (728s left) syncobj_timeline (single-wait-available-submitted)
[294.361218] Starting subtest: single-wait-available-submitted
[294.362077] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[294.461513] [078/133] (728s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[294.550049] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[294.551736] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[294.641903] [079/133] (728s left) kms_sequence (queue-idle)
[294.735251] Starting subtest: queue-idle
[294.736029] Starting dynamic subtest: pipe-A-eDP-1
[296.544520] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.809s)
[296.553971] Starting dynamic subtest: pipe-B-eDP-1
[298.996165] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.450s)
[299.005266] Starting dynamic subtest: pipe-C-eDP-1
[301.420170] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.423s)
[301.429455] Starting dynamic subtest: pipe-D-eDP-1
[303.858677] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.437s)
[303.859523] Subtest queue-idle: SUCCESS (9.124s)
[304.677271] [080/133] (718s left) gem_softpin (evict-active-interruptible)
[304.729418] Starting subtest: evict-active-interruptible
[304.735087] Subtest evict-active-interruptible: SUCCESS (0.006s)
[304.839046] [081/133] (718s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[304.887107] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[304.888642] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[305.077540] [082/133] (717s left) syncobj_wait (invalid-wait-illegal-handle)
[305.124200] Starting subtest: invalid-wait-illegal-handle
[305.125043] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[305.227685] [083/133] (717s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[305.324326] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[305.325847] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[305.412702] [084/133] (717s left) kms_force_connector_basic (prune-stale-modes)
[305.493203] Starting subtest: prune-stale-modes
[305.931132] Subtest prune-stale-modes: SUCCESS (0.440s)
[306.068110] [085/133] (717s left) dmabuf_sync_file (import-basic)
[306.110885] Starting subtest: import-basic
[306.111767] Subtest import-basic: SUCCESS (0.002s)
[306.163981] [086/133] (716s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[306.212533] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[306.213844] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[306.310763] [087/133] (716s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[306.399098] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[306.400844] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[306.487091] [088/133] (716s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[306.590261] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[306.592593] Starting dynamic subtest: A-eDP1
[310.223660] Dynamic subtest A-eDP1: SUCCESS (3.629s)
[310.234737] Starting dynamic subtest: B-eDP1
[313.525462] Dynamic subtest B-eDP1: SUCCESS (3.301s)
[313.533831] Starting dynamic subtest: C-eDP1
[316.824869] Dynamic subtest C-eDP1: SUCCESS (3.292s)
[316.833772] Starting dynamic subtest: D-eDP1
[320.111562] Dynamic subtest D-eDP1: SUCCESS (3.292s)
[320.113572] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.522s)
[320.986884] [089/133] (702s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[321.075385] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[328.545672] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.471s)
[328.680900] [090/133] (694s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[328.746279] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[328.863116] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.107s)
[328.925703] [091/133] (694s left) kms_flip (plain-flip-fb-recreate-interruptible)
[329.027513] Starting subtest: plain-flip-fb-recreate-interruptible
[329.030062] Starting dynamic subtest: A-eDP1
[337.854952] Dynamic subtest A-eDP1: SUCCESS (8.824s)
[337.869955] Starting dynamic subtest: B-eDP1
[346.744554] Dynamic subtest B-eDP1: SUCCESS (8.888s)
[346.754484] Starting dynamic subtest: C-eDP1
[355.532724] Dynamic subtest C-eDP1: SUCCESS (8.785s)
[355.543945] Starting dynamic subtest: D-eDP1
[364.332187] Dynamic subtest D-eDP1: SUCCESS (8.798s)
[364.335910] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.307s)
[365.471539] [092/133] (657s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[365.584543] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[365.586744] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[365.735074] [093/133] (657s left) gem_mmap (pf-nonblock)
[365.796539] Subtest pf-nonblock: SKIP (0.000s)
[365.849848] [094/133] (657s left) kms_pm_rpm (fences)
[367.472732] Starting subtest: fences
[367.475344] Subtest fences: SKIP (0.000s)
[368.079454] [095/133] (655s left) kms_cursor_crc (cursor-onscreen-512x170)
[368.384388] Starting subtest: cursor-onscreen-512x170
[368.386088] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[368.528142] [096/133] (654s left) i915_getparams_basic (basic-eu-total)
[368.582453] Starting subtest: basic-eu-total
[368.584096] Subtest basic-eu-total: SUCCESS (0.000s)
[368.658409] [097/133] (654s left) api_intel_bb (simple-bb-ctx)
[368.706976] Starting subtest: simple-bb-ctx
[368.715621] Subtest simple-bb-ctx: SUCCESS (0.010s)
[368.827152] [098/133] (654s left) kms_getfb (getfb2-accept-nv12)
[368.917679] Starting subtest: getfb2-accept-nv12
[368.918581] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[369.020973] [099/133] (654s left) gem_exec_whisper (basic-sync-all)
[369.085388] Starting subtest: basic-sync-all
[376.149831] Subtest basic-sync-all: SUCCESS (7.064s)
[376.333086] [100/133] (647s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[376.405786] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[376.474778] [101/133] (647s left) gem_exec_schedule (submit-golden-slice)
[376.539416] Starting subtest: submit-golden-slice
[376.540486] Starting dynamic subtest: rcs0
[376.604992] Dynamic subtest rcs0: SUCCESS (0.065s)
[376.616490] Starting dynamic subtest: bcs0
[376.649441] Dynamic subtest bcs0: SUCCESS (0.044s)
[376.660771] Starting dynamic subtest: vcs0
[376.707519] Dynamic subtest vcs0: SUCCESS (0.057s)
[376.718207] Starting dynamic subtest: vcs1
[376.758673] Dynamic subtest vcs1: SUCCESS (0.050s)
[376.769550] Starting dynamic subtest: vecs0
[376.813652] Dynamic subtest vecs0: SUCCESS (0.054s)
[376.821523] Starting dynamic subtest: ccs0
[376.859373] Dynamic subtest ccs0: SUCCESS (0.045s)
[376.860412] Subtest submit-golden-slice: SUCCESS (0.320s)
[378.414677] [102/133] (645s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[378.523942] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[385.486744] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.962s)
[385.633030] [103/133] (638s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[385.690833] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[385.691686] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[385.791065] [104/133] (637s left) gem_softpin (allocator-nopin-reserve)
[385.847926] Starting subtest: allocator-nopin-reserve
[385.933909] Subtest allocator-nopin-reserve: SUCCESS (0.087s)
[386.038086] [105/133] (637s left) gem_exec_balancer (indices)
[386.095550] Starting subtest: indices
[388.296549] Subtest indices: SUCCESS (2.191s)
[388.600324] [106/133] (635s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[388.729847] Starting subtest: psr2-overlay-plane-move-continuous-sf
[388.732178] Starting dynamic subtest: pipe-A-eDP-1
[394.753589] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.020s)
[394.761621] Starting dynamic subtest: pipe-B-eDP-1
[401.437448] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.682s)
[401.438342] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.706s)
[402.282074] [107/133] (621s left) i915_power (sanity)
[402.335378] Starting subtest: sanity
[406.387051] Subtest sanity: SUCCESS (4.040s)
[408.363744] [108/133] (615s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[408.449450] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[408.450418] Starting dynamic subtest: pipe-A-eDP-1
[408.459482] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[408.468159] Starting dynamic subtest: pipe-B-eDP-1
[408.477049] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[408.485594] Starting dynamic subtest: pipe-C-eDP-1
[408.493677] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[408.501530] Starting dynamic subtest: pipe-D-eDP-1
[408.509810] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[408.511509] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.005s)
[410.670299] [109/133] (613s left) kms_atomic_transition (plane-toggle-modeset-transition)
[410.764279] Starting subtest: plane-toggle-modeset-transition
[410.765082] Starting dynamic subtest: pipe-A-eDP-1
[423.784310] Dynamic subtest pipe-A-eDP-1: SUCCESS (13.019s)
[423.796025] Starting dynamic subtest: pipe-B-eDP-1
[436.490724] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.703s)
[436.494265] Subtest plane-toggle-modeset-transition: SUCCESS (25.728s)
[437.392168] [110/133] (586s left) kms_psr (pr-suspend)
[437.494042] Starting subtest: pr-suspend
[437.495990] Subtest pr-suspend: SKIP (0.000s)
[437.562979] [111/133] (586s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[437.616853] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[437.680954] [112/133] (586s left) perf_pmu (busy-hang)
[437.722726] Starting subtest: busy-hang
[437.723736] Starting dynamic subtest: rcs0
[438.941069] Dynamic subtest rcs0: SUCCESS (1.215s)
[438.952861] Starting dynamic subtest: bcs0
[440.149600] Dynamic subtest bcs0: SUCCESS (1.206s)
[440.159932] Starting dynamic subtest: vcs0
[441.829635] Dynamic subtest vcs0: SUCCESS (1.680s)
[441.840185] Starting dynamic subtest: vcs1
[443.876501] Dynamic subtest vcs1: SUCCESS (2.043s)
[443.886686] Starting dynamic subtest: vecs0
[445.860345] Dynamic subtest vecs0: SUCCESS (1.983s)
[445.870660] Starting dynamic subtest: ccs0
[447.067539] Dynamic subtest ccs0: SUCCESS (1.204s)
[447.068759] Subtest busy-hang: SUCCESS (9.342s)
[447.170042] [113/133] (576s left) i915_pm_rpm (debugfs-read)
[449.503311] Starting subtest: debugfs-read
[450.649782] Subtest debugfs-read: SUCCESS (1.147s)
[451.035600] [114/133] (573s left) gem_exec_balancer (waits)
[451.105262] Starting subtest: waits
[457.781043] Subtest waits: SUCCESS (6.630s)
[458.040926] [115/133] (566s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[458.134748] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[458.136687] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[458.221681] [116/133] (565s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[458.313369] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[458.315138] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[458.382666] [117/133] (565s left) kms_flip (2x-modeset-vs-vblank-race)
[458.468066] Starting subtest: 2x-modeset-vs-vblank-race
[458.478250] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[458.568385] [118/133] (565s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[458.657722] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[463.177030] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.520s)
[464.388311] [119/133] (559s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[464.485437] Starting subtest: plane-lut1d-post-ctm3x4
[464.610603] Starting dynamic subtest: pipe-A-plane-0
[464.777112] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[464.787158] Starting dynamic subtest: pipe-A-plane-1
[464.932836] Dynamic subtest pipe-A-plane-1: SUCCESS (0.154s)
[464.949677] Starting dynamic subtest: pipe-A-plane-2
[465.121561] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[466.341135] Starting dynamic subtest: pipe-B-plane-0
[466.533189] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[466.544576] Starting dynamic subtest: pipe-B-plane-1
[466.688730] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[466.698350] Starting dynamic subtest: pipe-B-plane-2
[466.855406] Dynamic subtest pipe-B-plane-2: SUCCESS (0.165s)
[468.045883] Starting dynamic subtest: pipe-C-plane-0
[468.182604] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[468.194245] Starting dynamic subtest: pipe-C-plane-1
[468.326981] Dynamic subtest pipe-C-plane-1: SUCCESS (0.143s)
[468.335174] Starting dynamic subtest: pipe-C-plane-2
[468.471106] Dynamic subtest pipe-C-plane-2: SUCCESS (0.143s)
[469.635474] Starting dynamic subtest: pipe-D-plane-0
[469.783071] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[469.794268] Starting dynamic subtest: pipe-D-plane-1
[469.949746] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[469.958713] Starting dynamic subtest: pipe-D-plane-2
[470.105194] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[470.390796] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.905s)
[471.273202] [120/133] (553s left) kms_content_protection (dp-mst-type-0)
[471.429700] Starting subtest: dp-mst-type-0
[471.431704] Subtest dp-mst-type-0: SKIP (0.000s)
[471.558061] [121/133] (552s left) gem_mmap_wc (invalid-flags)
[471.620531] Subtest invalid-flags: SKIP (0.000s)
[471.684541] [122/133] (552s left) gem_mmap_gtt (basic-write-gtt)
[471.745949] Subtest basic-write-gtt: SKIP (0.000s)
[471.805760] [123/133] (552s left) syncobj_wait (wait-all-for-submit-snapshot)
[471.865520] Starting subtest: wait-all-for-submit-snapshot
[471.946810] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[472.016679] [124/133] (552s left) kms_prime (basic-crc-vgem)
[472.096889] Starting subtest: basic-crc-vgem
[472.097810] Starting dynamic subtest: second-to-first
[473.106224] Dynamic subtest second-to-first: SUCCESS (1.010s)
[473.108112] Subtest basic-crc-vgem: SUCCESS (1.012s)
[473.207465] [125/133] (551s left) kms_big_fb (linear-64bpp-rotate-0)
[473.335356] Starting subtest: linear-64bpp-rotate-0
[474.926443] Subtest linear-64bpp-rotate-0: SUCCESS (1.591s)
[475.102145] [126/133] (549s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[475.207748] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[475.209529] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[475.301504] [127/133] (549s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[475.677153] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[476.445890] [128/133] (548s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[476.544378] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[483.862203] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.319s)
[483.980650] [129/133] (540s left) kms_flip (2x-plain-flip-ts-check)
[484.076321] Starting subtest: 2x-plain-flip-ts-check
[484.086732] Subtest 2x-plain-flip-ts-check: SKIP (0.011s)
[484.163168] [130/133] (540s left) kms_properties (get_properties-sanity-atomic)
[484.252230] Starting subtest: get_properties-sanity-atomic
[484.254500] Subtest get_properties-sanity-atomic: SUCCESS (0.003s)
[484.324804] [131/133] (540s left) gem_exec_reloc (basic-write-cpu-noreloc)
[484.368348] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[484.472513] [132/133] (540s left) kms_vblank (ts-continuation-idle-hang)
[484.560340] Starting subtest: ts-continuation-idle-hang
[484.561237] Starting dynamic subtest: pipe-A-eDP-1
[512.096943] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.534s)
[512.108600] Starting dynamic subtest: pipe-D-eDP-1
[527.074820] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.974s)
[527.076187] Subtest ts-continuation-idle-hang: SUCCESS (42.514s)
[527.879441] [133/133] (496s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[527.966643] Starting subtest: yf-tiled-64bpp-rotate-180
[527.968572] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[528.063737] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: gen9_exec_parse
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_exec_fence
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: drm_read
results: parsing output: 8/ for test: dumb_buffer
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_exec_reloc
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: kms_cursor_crc
results: parsing output: 13/ for test: gem_exec_schedule
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_atomic_interruptible
results: parsing output: 16/ for test: kms_async_flips
results: parsing output: 17/ for test: gem_exec_params
results: parsing output: 18/ for test: gem_ctx_engines
results: parsing output: 19/ for test: kms_cdclk
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: gem_shrink
results: parsing output: 22/ for test: kms_rotation_crc
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: gem_mmap_gtt
results: parsing output: 27/ for test: kms_feature_discovery
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_psr_stress_test
results: parsing output: 30/ for test: gem_pxp
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: prime_udl
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: kms_chamelium_edid
results: parsing output: 36/ for test: gem_userptr_blits
results: parsing output: 37/ for test: gem_ctx_shared
results: parsing output: 38/ for test: kms_plane_scaling
results: parsing output: 39/ for test: syncobj_basic
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: kms_plane
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_pipe_crc_basic
results: parsing output: 45/ for test: gen9_exec_parse
results: parsing output: 46/ for test: gem_partial_pwrite_pread
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: sysfs_heartbeat_interval
results: parsing output: 49/ for test: gem_madvise
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: kms_joiner
results: parsing output: 52/ for test: kms_plane_scaling
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: gem_ctx_persistence
results: parsing output: 55/ for test: kms_prop_blob
results: parsing output: 56/ for test: gem_exec_whisper
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_async_flips
results: parsing output: 59/ for test: gem_mmap_gtt
results: parsing output: 60/ for test: kms_lease
results: parsing output: 61/ for test: prime_busy
results: parsing output: 62/ for test: gem_exec_fence
results: parsing output: 63/ for test: gem_close
results: parsing output: 64/ for test: gem_ctx_persistence
results: parsing output: 65/ for test: kms_psr2_sf
results: parsing output: 66/ for test: prime_vgem
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: kms_atomic_interruptible
results: parsing output: 69/ for test: gem_wait
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_vrr
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_flip_scaled_crc
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_cursor_crc
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_sequence
results: parsing output: 79/ for test: gem_softpin
results: parsing output: 80/ for test: gem_render_copy
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_force_connector_basic
results: parsing output: 84/ for test: dmabuf_sync_file
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: gem_mmap
results: parsing output: 93/ for test: kms_pm_rpm
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: i915_getparams_basic
results: parsing output: 96/ for test: api_intel_bb
results: parsing output: 97/ for test: kms_getfb
results: parsing output: 98/ for test: gem_exec_whisper
results: parsing output: 99/ for test: gem_exec_reloc
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: syncobj_wait
results: parsing output: 103/ for test: gem_softpin
results: parsing output: 104/ for test: gem_exec_balancer
results: parsing output: 105/ for test: kms_psr2_sf
results: parsing output: 106/ for test: i915_power
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_atomic_transition
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: gem_exec_reloc
results: parsing output: 111/ for test: perf_pmu
results: parsing output: 112/ for test: i915_pm_rpm
results: parsing output: 113/ for test: gem_exec_balancer
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_plane
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_color_pipeline
results: parsing output: 119/ for test: kms_content_protection
results: parsing output: 120/ for test: gem_mmap_wc
results: parsing output: 121/ for test: gem_mmap_gtt
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: kms_prime
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_chamelium_hpd
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: kms_properties
results: parsing output: 130/ for test: gem_exec_reloc
results: parsing output: 131/ for test: kms_vblank
results: parsing output: 132/ for test: kms_big_fb
Done.