[57.716170] Initializing watchdogs
[57.716291]   /dev/watchdog0
[57.737468] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.741487] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.743683] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.746950] [001/132] (960s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[57.834553] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[57.938257] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[58.039046] [002/132] (960s left) kms_psr (fbc-psr2-cursor-blt)
[58.153054] Starting subtest: fbc-psr2-cursor-blt
[58.155079] Starting dynamic subtest: eDP-1
[58.159306] Dynamic subtest eDP-1: SKIP (0.000s)
[58.163519] Subtest fbc-psr2-cursor-blt: SKIP (0.000s)
[58.247026] [003/132] (960s left) kms_pm_rpm (package-g7)
[61.218021] Starting subtest: package-g7
[61.223591] Subtest package-g7: SKIP (0.000s)
[61.588197] [004/132] (956s left) gem_softpin (full)
[61.657327] Starting subtest: full
[61.665841] Subtest full: SUCCESS (0.009s)
[61.814869] [005/132] (956s left) kms_lease (simple-lease)
[61.903214] Starting subtest: simple-lease
[61.905868] Starting dynamic subtest: pipe-A-eDP-1
[62.418044] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.514s)
[62.426472] Starting dynamic subtest: pipe-B-eDP-1
[63.818620] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.401s)
[63.827330] Starting dynamic subtest: pipe-C-eDP-1
[65.222207] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.401s)
[65.234473] Starting dynamic subtest: pipe-D-eDP-1
[66.633598] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.408s)
[66.635992] Subtest simple-lease: SUCCESS (4.730s)
[67.481515] [006/132] (950s left) api_intel_bb (destroy-bb)
[67.577170] Starting subtest: destroy-bb
[67.589533] Subtest destroy-bb: SUCCESS (0.012s)
[67.832969] [007/132] (950s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[67.950957] Starting subtest: yf-tiled-32bpp-rotate-0
[67.955432] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[68.133727] [008/132] (950s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[68.351299] Starting subtest: cursor-rapid-movement-128x42
[68.397144] Subtest cursor-rapid-movement-128x42: SKIP (0.041s)
[68.637440] [009/132] (949s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[68.752298] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[68.756368] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[68.876077] [010/132] (949s left) gem_mmap_gtt (basic-short)
[68.944087] Subtest basic-short: SKIP (0.000s)
[69.020158] [011/132] (949s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[69.116356] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[69.120215] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[69.229635] [012/132] (949s left) gem_create (create-ext-placement-all)
[69.405345] Starting subtest: create-ext-placement-all
[69.408046] Subtest create-ext-placement-all: SUCCESS (0.000s)
[69.541052] [013/132] (949s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[69.640330] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[69.644945] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[69.780133] [014/132] (948s left) gem_mmap_offset (basic-uaf)
[69.842848] Starting subtest: basic-uaf
[69.845273] Subtest basic-uaf: SUCCESS (0.001s)
[69.974311] [015/132] (948s left) kms_chamelium_color (ctm-0-50)
[70.058082] Subtest ctm-0-50: SKIP (0.000s)
[70.097494] [016/132] (948s left) i915_drm_fdinfo (busy)
[70.140243] Starting subtest: busy
[70.142114] Starting dynamic subtest: rcs0
[70.176078] Dynamic subtest rcs0: SKIP (0.034s)
[70.185051] Starting dynamic subtest: bcs0
[70.189269] Dynamic subtest bcs0: SKIP (0.001s)
[70.196077] Starting dynamic subtest: vcs0
[70.200132] Dynamic subtest vcs0: SKIP (0.000s)
[70.206916] Starting dynamic subtest: vcs1
[70.211155] Dynamic subtest vcs1: SKIP (0.000s)
[70.217723] Starting dynamic subtest: vecs0
[70.222108] Dynamic subtest vecs0: SKIP (0.000s)
[70.228739] Starting dynamic subtest: ccs0
[70.233064] Dynamic subtest ccs0: SKIP (0.000s)
[70.237357] Subtest busy: SKIP (0.038s)
[70.270207] [017/132] (948s left) syncobj_wait (multi-wait-submitted-signaled)
[70.330898] Starting subtest: multi-wait-submitted-signaled
[70.333210] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[70.449329] [018/132] (948s left) gen9_exec_parse (batch-without-end)
[70.516561] Subtest batch-without-end: SKIP (0.000s)
[70.597166] [019/132] (948s left) prime_vgem (busy)
[70.715338] Starting subtest: busy
[70.717566] Starting dynamic subtest: rcs0
[70.755819] Dynamic subtest rcs0: SUCCESS (0.041s)
[70.762813] Starting dynamic subtest: bcs0
[70.807479] Dynamic subtest bcs0: SUCCESS (0.051s)
[70.814742] Starting dynamic subtest: vcs0
[70.856120] Dynamic subtest vcs0: SUCCESS (0.049s)
[70.862986] Starting dynamic subtest: vcs1
[70.900079] Dynamic subtest vcs1: SUCCESS (0.043s)
[70.907528] Starting dynamic subtest: vecs0
[70.946747] Dynamic subtest vecs0: SUCCESS (0.047s)
[70.954066] Starting dynamic subtest: ccs0
[70.993585] Dynamic subtest ccs0: SUCCESS (0.046s)
[70.996065] Subtest busy: SUCCESS (0.278s)
[71.139253] [FACT prime_vgem (busy)] new: kernel.kmod_is_loaded.vgem: true
[71.142165] [020/132] (947s left) kms_vblank (wait-forked)
[71.258283] Starting subtest: wait-forked
[71.260155] Starting dynamic subtest: pipe-A-eDP-1
[73.065606] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.807s)
[73.078202] Starting dynamic subtest: pipe-D-eDP-1
[75.517050] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.447s)
[75.519360] Subtest wait-forked: SUCCESS (4.257s)
[76.411854] [021/132] (942s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[76.515987] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[83.877741] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.363s)
[84.033383] [022/132] (935s left) gem_mmap (bad-size)
[84.090934] Subtest bad-size: SKIP (0.000s)
[84.144901] [023/132] (934s left) kms_chamelium_frames (hdmi-frame-dump)
[84.531094] Subtest hdmi-frame-dump: SKIP (0.000s)
[85.335321] [024/132] (933s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[85.449886] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[85.462304] Starting dynamic subtest: pipe-A-eDP-1
[85.486425] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[85.493343] Starting dynamic subtest: pipe-B-eDP-1
[85.516308] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[85.523067] Starting dynamic subtest: pipe-C-eDP-1
[85.545708] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[85.552638] Starting dynamic subtest: pipe-D-eDP-1
[85.576487] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[85.580861] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[87.738954] [025/132] (931s left) vgem_slow (nohang)
[87.792063] Starting subtest: nohang
[97.907723] Subtest nohang: SUCCESS (10.115s)
[97.995517] [026/132] (921s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[98.115699] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[99.086460] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.970s)
[99.240197] [027/132] (920s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[99.336972] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[99.338868] Starting dynamic subtest: pipe-A-default-mode
[102.069530] Dynamic subtest pipe-A-default-mode: SUCCESS (2.730s)
[102.071965] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.731s)
[102.930924] [028/132] (916s left) kms_feature_discovery (display-2x)
[103.021044] Starting subtest: display-2x
[103.025664] Subtest display-2x: SKIP (0.000s)
[103.117161] [029/132] (916s left) syncobj_timeline (multi-wait-signaled)
[103.175128] Starting subtest: multi-wait-signaled
[103.177417] Subtest multi-wait-signaled: SUCCESS (0.001s)
[103.306984] [030/132] (916s left) gem_ctx_bad_destroy (invalid-ctx)
[103.359059] Starting subtest: invalid-ctx
[103.361756] Subtest invalid-ctx: SUCCESS (0.000s)
[103.453271] [031/132] (915s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[103.516077] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[103.626219] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.108s)
[103.724962] [032/132] (915s left) prime_vgem (basic-gtt)
[103.801453] Starting subtest: basic-gtt
[103.806250] Subtest basic-gtt: SKIP (0.000s)
[103.935611] [033/132] (915s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[104.033403] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[104.035732] Starting dynamic subtest: pipe-A-default-mode
[105.165785] Dynamic subtest pipe-A-default-mode: SKIP (1.129s)
[105.170025] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.130s)
[105.362923] [034/132] (914s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[105.416054] Starting subtest: multi-wait-all-available-submitted-signaled
[105.418329] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[105.534918] [035/132] (914s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[110.504767] Starting subtest: psr2-plane-move-sf-dmg-area
[110.507289] Starting dynamic subtest: pipe-A-eDP-1
[115.793558] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.288s)
[115.802712] Starting dynamic subtest: pipe-B-eDP-1
[121.019543] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.227s)
[121.022060] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (10.518s)
[121.960156] [036/132] (897s left) gem_ctx_isolation (nonpriv-switch)
[122.040419] Starting subtest: nonpriv-switch
[122.042926] Starting dynamic subtest: rcs0
[122.322745] Dynamic subtest rcs0: SUCCESS (0.282s)
[122.331519] Starting dynamic subtest: bcs0
[122.654823] Dynamic subtest bcs0: SUCCESS (0.332s)
[122.666074] Starting dynamic subtest: vcs0
[122.996557] Dynamic subtest vcs0: SUCCESS (0.340s)
[123.006595] Starting dynamic subtest: vcs1
[124.191895] Dynamic subtest vcs1: SUCCESS (1.194s)
[124.202146] Starting dynamic subtest: vecs0
[126.224713] Dynamic subtest vecs0: SUCCESS (2.032s)
[126.234850] Starting dynamic subtest: ccs0
[128.262085] Dynamic subtest ccs0: SUCCESS (2.037s)
[128.264542] Subtest nonpriv-switch: SUCCESS (6.222s)
[128.539228] [037/132] (891s left) kms_cursor_legacy (single-bo)
[128.659460] Starting subtest: single-bo
[128.661385] Starting dynamic subtest: pipe-A
[134.040969] Dynamic subtest pipe-A: SUCCESS (5.379s)
[134.051263] Starting dynamic subtest: pipe-B
[139.422911] Dynamic subtest pipe-B: SUCCESS (5.380s)
[139.432802] Starting dynamic subtest: pipe-C
[144.803819] Dynamic subtest pipe-C: SUCCESS (5.379s)
[144.813562] Starting dynamic subtest: pipe-D
[150.186030] Dynamic subtest pipe-D: SUCCESS (5.380s)
[150.196177] Starting dynamic subtest: all-pipes
[155.574071] Dynamic subtest all-pipes: SUCCESS (5.387s)
[155.576386] Subtest single-bo: SUCCESS (26.913s)
[155.741100] [038/132] (863s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[155.814780] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[155.883287] [039/132] (863s left) gem_render_tiled_blits (basic)
[155.946250] Subtest basic: SKIP (0.000s)
[156.019011] [040/132] (863s left) kms_color (invalid-degamma-lut-sizes)
[156.123980] Starting subtest: invalid-degamma-lut-sizes
[156.126324] Starting dynamic subtest: pipe-A
[156.412873] Dynamic subtest pipe-A: SUCCESS (0.290s)
[156.429822] Starting dynamic subtest: pipe-B
[156.432598] Dynamic subtest pipe-B: SUCCESS (0.001s)
[156.448946] Starting dynamic subtest: pipe-C
[156.451628] Dynamic subtest pipe-C: SUCCESS (0.001s)
[156.466868] Starting dynamic subtest: pipe-D
[156.469516] Dynamic subtest pipe-D: SUCCESS (0.001s)
[156.472122] Subtest invalid-degamma-lut-sizes: SUCCESS (0.296s)
[157.253029] [041/132] (862s left) gen3_render_mixed_blits
[157.390462] [042/132] (862s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[157.481835] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[157.484188] Starting dynamic subtest: pipe-A-eDP-1
[157.508148] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[157.518579] Starting dynamic subtest: pipe-B-eDP-1
[157.539747] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[157.547400] Starting dynamic subtest: pipe-C-eDP-1
[157.569442] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[157.577758] Starting dynamic subtest: pipe-D-eDP-1
[157.599994] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[157.604369] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[159.815205] [043/132] (860s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[159.925422] Starting subtest: extended-modeset-hang-oldfb-with-reset
[159.927718] Starting dynamic subtest: pipe-A
[171.452274] Dynamic subtest pipe-A: SUCCESS (11.526s)
[171.460567] Starting dynamic subtest: pipe-D
[183.725885] Dynamic subtest pipe-D: SUCCESS (12.272s)
[183.728264] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.802s)
[184.542759] [044/132] (835s left) syncobj_wait (multi-wait-all-submitted)
[184.604315] Starting subtest: multi-wait-all-submitted
[184.704852] Subtest multi-wait-all-submitted: SUCCESS (0.101s)
[184.801573] [045/132] (835s left) kms_vblank (query-forked-hang)
[184.904919] Starting subtest: query-forked-hang
[184.907243] Starting dynamic subtest: pipe-A-eDP-1
[212.694177] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.785s)
[212.709495] Starting dynamic subtest: pipe-D-eDP-1
[227.665446] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.972s)
[227.668043] Subtest query-forked-hang: SUCCESS (42.762s)
[228.487091] [046/132] (791s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[230.004455] Starting subtest: gem-execbuf-stress-pc8
[230.046652] Subtest gem-execbuf-stress-pc8: SKIP (0.040s)
[230.724186] [047/132] (789s left) kms_async_flips (crc-atomic)
[230.820637] Starting subtest: crc-atomic
[231.206088] Starting dynamic subtest: pipe-A-eDP-1
[234.121614] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.915s)
[234.510764] Starting dynamic subtest: pipe-B-eDP-1
[237.383155] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.879s)
[237.755254] Starting dynamic subtest: pipe-C-eDP-1
[240.682676] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.934s)
[241.065286] Starting dynamic subtest: pipe-D-eDP-1
[243.922459] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.866s)
[243.924848] Subtest crc-atomic: SUCCESS (13.104s)
[245.112353] [048/132] (775s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[245.226562] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[245.230998] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[245.354817] [049/132] (774s left) gem_linear_blits (normal)
[245.691079] Starting subtest: normal
[249.644336] Subtest normal: SUCCESS (3.952s)
[249.819409] [050/132] (770s left) gem_flink_race (flink_close)
[249.886020] Starting subtest: flink_close
[254.991660] Subtest flink_close: SUCCESS (5.108s)
[255.119262] [051/132] (765s left) gem_mmap_wc (pf-nonblock)
[255.204366] Subtest pf-nonblock: SKIP (0.000s)
[255.276656] [052/132] (765s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[255.424411] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[255.428793] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[255.612493] [053/132] (764s left) gem_wait (invalid-buf)
[255.695843] Starting subtest: invalid-buf
[255.698130] Subtest invalid-buf: SUCCESS (0.000s)
[255.989508] [054/132] (764s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[256.124356] Starting subtest: x-tiled-16bpp-rotate-90
[256.144213] Subtest x-tiled-16bpp-rotate-90: SKIP (0.020s)
[256.302196] [055/132] (764s left) kms_rotation_crc (sprite-rotation-270)
[256.423391] Starting subtest: sprite-rotation-270
[256.427637] Subtest sprite-rotation-270: SKIP (0.001s)
[256.546944] [056/132] (764s left) kms_hdr (static-toggle-suspend)
[256.672267] Starting subtest: static-toggle-suspend
[256.678725] Subtest static-toggle-suspend: SKIP (0.000s)
[256.780954] [057/132] (763s left) api_intel_allocator (reopen-fork)
[256.840786] Starting subtest: reopen-fork
[260.433306] Subtest reopen-fork: SUCCESS (3.593s)
[260.544318] [058/132] (760s left) gem_partial_pwrite_pread (reads-snoop)
[260.604606] Subtest reads-snoop: SKIP (0.000s)
[260.688162] [059/132] (760s left) gem_exec_whisper (basic-sync)
[260.743266] Starting subtest: basic-sync
[270.373476] Subtest basic-sync: SUCCESS (9.628s)
[270.580338] [060/132] (750s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[270.638438] Starting subtest: yf-tiled-ccs-to-y-tiled
[270.643034] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[270.851306] [061/132] (749s left) perf_pmu (most-busy-check-all)
[270.900331] Starting subtest: most-busy-check-all
[270.902399] Starting dynamic subtest: rcs0
[272.918333] Dynamic subtest rcs0: SUCCESS (2.018s)
[272.930972] Starting dynamic subtest: bcs0
[274.903232] Dynamic subtest bcs0: SUCCESS (1.982s)
[274.915568] Starting dynamic subtest: vcs0
[276.887040] Dynamic subtest vcs0: SUCCESS (1.981s)
[276.899387] Starting dynamic subtest: vcs1
[278.933880] Dynamic subtest vcs1: SUCCESS (2.044s)
[278.946085] Starting dynamic subtest: vecs0
[280.918412] Dynamic subtest vecs0: SUCCESS (1.982s)
[280.930834] Starting dynamic subtest: ccs0
[282.902411] Dynamic subtest ccs0: SUCCESS (1.981s)
[282.905247] Subtest most-busy-check-all: SUCCESS (12.003s)
[283.050311] [062/132] (737s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[283.155962] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[283.158199] Starting dynamic subtest: pipe-A-eDP-1
[283.167265] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[283.177631] Starting dynamic subtest: pipe-B-eDP-1
[283.186665] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[283.195173] Starting dynamic subtest: pipe-C-eDP-1
[283.203389] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[283.211649] Starting dynamic subtest: pipe-D-eDP-1
[283.220083] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[283.224234] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[285.378637] [063/132] (735s left) prime_mmap (test_refcounting)
[285.443696] Starting subtest: test_refcounting
[285.446038] Starting dynamic subtest: test_refcounting-smem
[285.475623] Dynamic subtest test_refcounting-smem: SUCCESS (0.034s)
[285.478080] Subtest test_refcounting: SUCCESS (0.035s)
[285.599334] [064/132] (735s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[285.705079] Starting subtest: fbc-psr2-primary-mmap-gtt
[285.707270] Starting dynamic subtest: eDP-1
[285.711106] Dynamic subtest eDP-1: SKIP (0.000s)
[285.715079] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[285.799039] [065/132] (735s left) gem_readwrite (read-bad-handle)
[285.872486] Subtest read-bad-handle: SKIP (0.000s)
[285.939582] [066/132] (735s left) perf (short-reads)
[286.101976] Starting subtest: short-reads
[286.116476] Subtest short-reads: SUCCESS (0.016s)
[286.158320] [067/132] (734s left) kms_prime (basic-crc-hybrid)
[286.241128] Subtest basic-crc-hybrid: SKIP (0.000s)
[286.353518] [068/132] (734s left) gem_tiling_max_stride
[286.498263] [069/132] (734s left) kms_cursor_edge_walk (64x64-top-bottom)
[286.600331] Starting subtest: 64x64-top-bottom
[286.602174] Starting dynamic subtest: pipe-A-eDP-1
[290.023020] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.422s)
[290.038185] Starting dynamic subtest: pipe-D-eDP-1
[293.149368] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s)
[293.151769] Subtest 64x64-top-bottom: SUCCESS (6.548s)
[293.980256] [070/132] (727s left) gem_busy (busy)
[294.047394] Starting subtest: busy
[294.049833] Starting dynamic subtest: all-engines
[294.107693] Dynamic subtest all-engines: SUCCESS (0.060s)
[294.117284] Starting dynamic subtest: rcs0
[295.902214] Dynamic subtest rcs0: SUCCESS (1.793s)
[295.912198] Starting dynamic subtest: bcs0
[295.952611] Dynamic subtest bcs0: SUCCESS (0.048s)
[295.962091] Starting dynamic subtest: vcs0
[295.991111] Dynamic subtest vcs0: SUCCESS (0.038s)
[296.000358] Starting dynamic subtest: vcs1
[297.947355] Dynamic subtest vcs1: SUCCESS (1.952s)
[297.958588] Starting dynamic subtest: vecs0
[299.930825] Dynamic subtest vecs0: SUCCESS (1.982s)
[299.941655] Starting dynamic subtest: ccs0
[301.915338] Dynamic subtest ccs0: SUCCESS (1.984s)
[301.917849] Subtest busy: SUCCESS (7.866s)
[302.306256] [071/132] (718s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[302.414772] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[302.419290] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[302.552191] [072/132] (718s left) kms_plane_cursor (viewport)
[302.656371] Starting subtest: viewport
[302.660500] Starting dynamic subtest: pipe-A-eDP-1-size-64
[305.095519] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.440s)
[305.159479] Starting dynamic subtest: pipe-A-eDP-1-size-128
[307.654136] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.504s)
[307.713799] Starting dynamic subtest: pipe-A-eDP-1-size-256
[310.310573] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.605s)
[310.660265] Starting dynamic subtest: pipe-B-eDP-1-size-64
[313.913735] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.264s)
[313.974888] Starting dynamic subtest: pipe-B-eDP-1-size-128
[316.546983] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.582s)
[316.609267] Starting dynamic subtest: pipe-B-eDP-1-size-256
[319.071705] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.470s)
[319.428045] Starting dynamic subtest: pipe-C-eDP-1-size-64
[322.226284] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.811s)
[322.265816] Starting dynamic subtest: pipe-C-eDP-1-size-128
[324.415929] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.157s)
[324.452474] Starting dynamic subtest: pipe-C-eDP-1-size-256
[326.605698] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.158s)
[326.933242] Starting dynamic subtest: pipe-D-eDP-1-size-64
[329.767249] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.845s)
[329.805311] Starting dynamic subtest: pipe-D-eDP-1-size-128
[331.934093] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.135s)
[331.971523] Starting dynamic subtest: pipe-D-eDP-1-size-256
[334.200259] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.235s)
[334.520128] Subtest viewport: SUCCESS (31.862s)
[335.401363] [073/132] (685s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[340.461766] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[340.464064] Starting dynamic subtest: pipe-A-eDP-1
[341.277073] Dynamic subtest pipe-A-eDP-1: SKIP (0.812s)
[341.287263] Starting dynamic subtest: pipe-B-eDP-1
[342.398749] Dynamic subtest pipe-B-eDP-1: SKIP (1.120s)
[342.403148] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.936s)
[343.609045] [074/132] (677s left) gem_ctx_shared (exec-single-timeline)
[343.673651] Starting subtest: exec-single-timeline
[343.675963] Starting dynamic subtest: rcs0
[344.753624] Dynamic subtest rcs0: SUCCESS (1.078s)
[344.766735] Starting dynamic subtest: bcs0
[345.842208] Dynamic subtest bcs0: SUCCESS (1.084s)
[345.854694] Starting dynamic subtest: vcs0
[346.934328] Dynamic subtest vcs0: SUCCESS (1.089s)
[346.949214] Starting dynamic subtest: vcs1
[348.018609] Dynamic subtest vcs1: SUCCESS (1.082s)
[348.034639] Starting dynamic subtest: vecs0
[349.107069] Dynamic subtest vecs0: SUCCESS (1.085s)
[349.121147] Starting dynamic subtest: ccs0
[350.194976] Dynamic subtest ccs0: SUCCESS (1.085s)
[350.198075] Subtest exec-single-timeline: SUCCESS (6.521s)
[351.010303] [075/132] (670s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[351.138754] Starting subtest: cursorA-vs-flipA-varying-size
[362.279432] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.139s)
[363.132127] [076/132] (658s left) gem_mmap_gtt (basic-small-bo)
[363.204878] Subtest basic-small-bo: SKIP (0.000s)
[363.262309] [077/132] (658s left) kms_psr (pr-cursor-mmap-cpu)
[363.342934] Starting subtest: pr-cursor-mmap-cpu
[363.347196] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[363.438709] [078/132] (658s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[363.815651] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[364.612285] [079/132] (656s left) gem_partial_pwrite_pread (write-snoop)
[364.683065] Subtest write-snoop: SKIP (0.000s)
[364.770376] [080/132] (656s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[364.882437] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[396.282176] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.396s)
[397.194353] [081/132] (624s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[397.314486] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[397.318770] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[397.452399] [082/132] (624s left) syncobj_wait (multi-wait-signaled)
[397.511533] Starting subtest: multi-wait-signaled
[397.513924] Subtest multi-wait-signaled: SUCCESS (0.000s)
[397.646619] [083/132] (624s left) gem_exec_fence (syncobj-unused-fence)
[398.153900] Starting subtest: syncobj-unused-fence
[398.158838] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[400.017318] [084/132] (621s left) kms_psr (psr-cursor-plane-onoff)
[400.112985] Starting subtest: psr-cursor-plane-onoff
[400.115336] Starting dynamic subtest: eDP-1
[401.866580] Dynamic subtest eDP-1: SUCCESS (1.754s)
[401.869026] Subtest psr-cursor-plane-onoff: SUCCESS (1.755s)
[402.766183] [085/132] (619s left) kms_plane_lowres (tiling-y)
[402.861592] Starting subtest: tiling-y
[402.865896] Subtest tiling-y: SKIP (0.000s)
[402.971773] [086/132] (618s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[403.094772] Starting subtest: verify-pxp-execution-after-suspend-resume
[413.829402] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (10.734s)
[414.003203] [087/132] (607s left) gem_wait (busy)
[414.085354] Starting subtest: busy
[414.087220] Starting dynamic subtest: all-engines
[415.893651] Dynamic subtest all-engines: SUCCESS (1.808s)
[415.906629] Starting dynamic subtest: rcs0
[416.436202] Dynamic subtest rcs0: SUCCESS (0.541s)
[416.447495] Starting dynamic subtest: bcs0
[416.976080] Dynamic subtest bcs0: SUCCESS (0.539s)
[416.987034] Starting dynamic subtest: vcs0
[418.900997] Dynamic subtest vcs0: SUCCESS (1.922s)
[418.914523] Starting dynamic subtest: vcs1
[420.885385] Dynamic subtest vcs1: SUCCESS (1.981s)
[420.897924] Starting dynamic subtest: vecs0
[422.933240] Dynamic subtest vecs0: SUCCESS (2.045s)
[422.946205] Starting dynamic subtest: ccs0
[423.474621] Dynamic subtest ccs0: SUCCESS (0.541s)
[423.477112] Subtest busy: SUCCESS (9.391s)
[423.697541] [088/132] (598s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[423.798170] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[423.802225] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[423.910034] [089/132] (598s left) gem_ctx_persistence (file)
[423.983130] Starting subtest: file
[424.134595] Subtest file: SUCCESS (0.151s)
[424.323851] [090/132] (597s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[424.419235] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[424.423122] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[424.562032] [091/132] (597s left) kms_big_fb (y-tiled-addfb)
[424.660376] Starting subtest: y-tiled-addfb
[424.664644] Subtest y-tiled-addfb: SKIP (0.000s)
[424.800630] [092/132] (597s left) i915_fb_tiling (basic-x-tiling)
[424.866162] Subtest basic-x-tiling: SKIP (0.000s)
[424.928350] [093/132] (597s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[425.026423] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[425.030959] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[425.155031] [094/132] (597s left) gem_exec_schedule (preempt-hang)
[425.333372] Starting subtest: preempt-hang
[425.336347] Starting dynamic subtest: rcs0
[425.552112] Dynamic subtest rcs0: SUCCESS (0.219s)
[425.566732] Starting dynamic subtest: bcs0
[425.766237] Dynamic subtest bcs0: SUCCESS (0.212s)
[425.777033] Starting dynamic subtest: vcs0
[426.011951] Dynamic subtest vcs0: SUCCESS (0.245s)
[426.023360] Starting dynamic subtest: vcs1
[426.225461] Dynamic subtest vcs1: SUCCESS (0.212s)
[426.237680] Starting dynamic subtest: vecs0
[426.437725] Dynamic subtest vecs0: SUCCESS (0.211s)
[426.448962] Starting dynamic subtest: ccs0
[426.735448] Dynamic subtest ccs0: SUCCESS (0.296s)
[426.737961] Subtest preempt-hang: SUCCESS (1.402s)
[427.029077] [095/132] (595s left) kms_content_protection (atomic-dpms-hdcp14)
[427.169626] Starting subtest: atomic-dpms-hdcp14
[427.174497] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[427.344473] [096/132] (594s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[427.467074] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[434.857396] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.391s)
[435.041644] [097/132] (587s left) kms_addfb_basic (size-max)
[435.144189] Starting subtest: size-max
[435.146502] Subtest size-max: SUCCESS (0.000s)
[435.268305] [098/132] (587s left) kms_fbcon_fbt (psr)
[435.336100] Starting subtest: psr
[442.628964] Subtest psr: SUCCESS (7.290s)
[442.730162] [099/132] (579s left) perf_pmu (frequency)
[442.769521] Starting subtest: frequency
[442.771895] Starting dynamic subtest: gt0
[444.955116] Dynamic subtest gt0: SUCCESS (2.177s)
[444.966912] Starting dynamic subtest: idle-gt0
[445.460927] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[445.472703] Starting dynamic subtest: gt1
[449.910789] Dynamic subtest gt1: SUCCESS (4.444s)
[449.922984] Starting dynamic subtest: idle-gt1
[450.415646] Dynamic subtest idle-gt1: SUCCESS (0.504s)
[450.418377] Subtest frequency: SUCCESS (7.647s)
[450.563996] [100/132] (571s left) i915_suspend (basic-s2idle-without-i915)
[450.607313] Starting subtest: basic-s2idle-without-i915
[472.094793] Subtest basic-s2idle-without-i915: SUCCESS (5.841s)
[472.219610] [101/132] (550s left) prime_mmap (test_invalid_sync_flags)
[472.283069] Starting subtest: test_invalid_sync_flags
[472.285494] Starting dynamic subtest: test_invalid_sync_flags-smem
[472.287766] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[472.290068] Subtest test_invalid_sync_flags: SUCCESS (0.002s)
[472.418279] [102/132] (550s left) gem_fenced_exec_thrash (no-spare-fences)
[472.489516] Subtest no-spare-fences: SKIP (0.000s)
[472.580736] [103/132] (550s left) core_auth (basic-auth)
[472.636627] Starting subtest: basic-auth
[472.638597] Subtest basic-auth: SUCCESS (0.001s)
[472.768893] [104/132] (549s left) kms_cursor_crc (cursor-offscreen-64x64)
[472.952035] Starting subtest: cursor-offscreen-64x64
[472.968752] Starting dynamic subtest: pipe-A-eDP-1
[474.919347] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.947s)
[474.953349] Starting dynamic subtest: pipe-D-eDP-1
[477.503340] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.556s)
[477.505566] Subtest cursor-offscreen-64x64: SUCCESS (4.546s)
[478.385012] [105/132] (544s left) device_reset (unbind-reset-rebind)
[478.436837] Starting subtest: unbind-reset-rebind
[481.541117] Subtest unbind-reset-rebind: SUCCESS (3.095s)
[481.579667] [106/132] (541s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[481.700818] Starting subtest: flip-vs-cursor-varying-size
[490.147713] Subtest flip-vs-cursor-varying-size: SUCCESS (8.443s)
[491.043515] [107/132] (531s left) sysfs_heartbeat_interval (precise)
[491.129161] Starting subtest: precise
[491.131329] Starting dynamic subtest: vecs0
[498.571992] Dynamic subtest vecs0: SUCCESS (7.440s)
[498.583622] Starting dynamic subtest: ccs0
[499.607093] Dynamic subtest ccs0: SUCCESS (1.035s)
[499.620028] Starting dynamic subtest: vcs0
[507.588163] Dynamic subtest vcs0: SUCCESS (7.977s)
[507.599802] Starting dynamic subtest: bcs0
[508.735441] Dynamic subtest bcs0: SUCCESS (1.145s)
[508.746740] Starting dynamic subtest: rcs0
[509.896877] Dynamic subtest rcs0: SUCCESS (1.158s)
[509.908317] Starting dynamic subtest: vcs1
[517.581785] Dynamic subtest vcs1: SUCCESS (7.680s)
[517.584223] Subtest precise: SUCCESS (26.447s)
[517.680564] [108/132] (505s left) kms_addfb_basic (invalid-get-prop)
[517.750788] Starting subtest: invalid-get-prop
[517.752829] Subtest invalid-get-prop: SUCCESS (0.000s)
[517.930738] [109/132] (504s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[518.032080] Starting subtest: plane-downscale-factor-0-75-with-rotation
[518.034437] Starting dynamic subtest: pipe-A
[518.260846] Dynamic subtest pipe-A: SUCCESS (0.230s)
[518.272628] Starting dynamic subtest: pipe-B
[519.592298] Dynamic subtest pipe-B: SUCCESS (1.330s)
[519.602438] Starting dynamic subtest: pipe-C
[520.924111] Dynamic subtest pipe-C: SUCCESS (1.330s)
[520.934122] Starting dynamic subtest: pipe-D
[522.258095] Dynamic subtest pipe-D: SUCCESS (1.332s)
[522.260397] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.228s)
[523.472430] [110/132] (499s left) sysfs_timeslice_duration (duration)
[523.530504] Starting subtest: duration
[523.532991] Starting dynamic subtest: vecs0
[537.491420] Dynamic subtest vecs0: SUCCESS (13.955s)
[537.504205] Starting dynamic subtest: ccs0
[550.662518] Dynamic subtest ccs0: SUCCESS (13.167s)
[550.674848] Starting dynamic subtest: vcs0
[564.498070] Dynamic subtest vcs0: SUCCESS (13.829s)
[564.511280] Starting dynamic subtest: bcs0
[577.658403] Dynamic subtest bcs0: SUCCESS (13.161s)
[577.671890] Starting dynamic subtest: rcs0
[590.816114] Dynamic subtest rcs0: SUCCESS (13.158s)
[590.828615] Starting dynamic subtest: vcs1
[604.499370] Dynamic subtest vcs1: SUCCESS (13.680s)
[604.502048] Subtest duration: SUCCESS (80.965s)
[604.599373] [111/132] (418s left) kms_pm_dc (dc5-dpms-negative)
[605.709850] Starting subtest: dc5-dpms-negative
[605.714098] Subtest dc5-dpms-negative: SKIP (0.000s)
[605.806575] [112/132] (417s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[605.903919] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[605.908278] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[607.085107] [113/132] (415s left) gem_exec_whisper (basic-contexts-priority)
[607.152031] Starting subtest: basic-contexts-priority
[631.923539] Subtest basic-contexts-priority: SUCCESS (24.767s)
[632.135802] [114/132] (390s left) drm_read (short-buffer-nonblock)
[632.307353] Starting subtest: short-buffer-nonblock
[632.309760] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[632.500433] [115/132] (390s left) gem_exec_reloc (basic-gtt-cpu)
[632.563161] Subtest basic-gtt-cpu: SKIP (0.000s)
[632.644157] [116/132] (390s left) perf_pmu (init-busy)
[632.686334] Starting subtest: init-busy
[632.688742] Starting dynamic subtest: rcs0
[632.691084] Dynamic subtest rcs0: SUCCESS (0.001s)
[632.701991] Starting dynamic subtest: bcs0
[632.704229] Dynamic subtest bcs0: SUCCESS (0.000s)
[632.713733] Starting dynamic subtest: vcs0
[632.715974] Dynamic subtest vcs0: SUCCESS (0.001s)
[632.725704] Starting dynamic subtest: vcs1
[632.728065] Dynamic subtest vcs1: SUCCESS (0.001s)
[632.738538] Starting dynamic subtest: vecs0
[632.740758] Dynamic subtest vecs0: SUCCESS (0.001s)
[632.750033] Starting dynamic subtest: ccs0
[632.751950] Dynamic subtest ccs0: SUCCESS (0.000s)
[632.753893] Subtest init-busy: SUCCESS (0.008s)
[632.828733] [117/132] (390s left) gem_exec_fence (syncobj-import)
[633.306099] Starting subtest: syncobj-import
[633.311287] Subtest syncobj-import: SUCCESS (0.005s)
[634.683365] [118/132] (388s left) gem_mmap_gtt (basic)
[634.745717] Subtest basic: SKIP (0.000s)
[634.807135] [119/132] (388s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[634.899191] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[634.903187] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[635.022954] [120/132] (388s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[635.118480] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[635.122843] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[635.240124] [121/132] (388s left) kms_flip (2x-wf_vblank-ts-check)
[635.340421] Starting subtest: 2x-wf_vblank-ts-check
[635.351495] Subtest 2x-wf_vblank-ts-check: SKIP (0.010s)
[635.452151] [122/132] (387s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[635.567914] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[653.122501] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.552s)
[653.941602] [123/132] (369s left) kms_invalid_mode (bad-hsync-start)
[654.059996] Starting subtest: bad-hsync-start
[654.062833] Starting dynamic subtest: pipe-A-eDP-1
[654.345454] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[654.355155] Starting dynamic subtest: pipe-B-eDP-1
[654.357390] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[654.366794] Starting dynamic subtest: pipe-C-eDP-1
[654.369132] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[654.378124] Starting dynamic subtest: pipe-D-eDP-1
[654.380031] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[654.381954] Subtest bad-hsync-start: SUCCESS (0.293s)
[655.180783] [124/132] (368s left) kms_psr (psr2-cursor-mmap-gtt)
[655.283373] Starting subtest: psr2-cursor-mmap-gtt
[655.285716] Starting dynamic subtest: eDP-1
[657.018708] Dynamic subtest eDP-1: SUCCESS (1.735s)
[657.020979] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.736s)
[657.836932] [125/132] (365s left) kms_big_fb (linear-16bpp-rotate-0)
[657.941341] Starting subtest: linear-16bpp-rotate-0
[659.395630] Subtest linear-16bpp-rotate-0: SUCCESS (1.455s)
[659.550498] [126/132] (364s left) prime_vgem (basic-fence-read)
[659.648243] Starting subtest: basic-fence-read
[659.658114] Subtest basic-fence-read: SKIP (0.009s)
[659.806622] [127/132] (363s left) prime_mmap (test_userptr)
[659.852739] Starting subtest: test_userptr
[659.854731] Starting dynamic subtest: test_userptr-smem
[659.856576] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[659.858404] Subtest test_userptr: SUCCESS (0.001s)
[659.982197] [128/132] (363s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[660.032164] Starting subtest: invalid-smem-bo-on-discrete
[660.036134] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[660.184965] [129/132] (363s left) gem_exec_schedule (promotion)
[660.260318] Starting subtest: promotion
[660.262019] Starting dynamic subtest: rcs0
[660.367469] Dynamic subtest rcs0: SUCCESS (0.112s)
[660.379477] Starting dynamic subtest: vcs0
[660.454091] Dynamic subtest vcs0: SUCCESS (0.086s)
[660.471855] Starting dynamic subtest: vcs1
[660.534185] Dynamic subtest vcs1: SUCCESS (0.079s)
[660.543580] Starting dynamic subtest: vecs0
[660.620258] Dynamic subtest vecs0: SUCCESS (0.084s)
[660.634083] Starting dynamic subtest: ccs0
[660.703005] Dynamic subtest ccs0: SUCCESS (0.082s)
[660.705280] Subtest promotion: SUCCESS (0.448s)
[661.700354] [130/132] (362s left) gem_exec_balancer (full-pulse)
[661.764364] Starting subtest: full-pulse
[666.376876] Subtest full-pulse: SUCCESS (4.612s)
[666.751221] [131/132] (357s left) gem_exec_balancer (sequential)
[666.827280] Starting subtest: sequential
[669.861072] Subtest sequential: SUCCESS (3.033s)
[670.226806] [132/132] (353s left) kms_rotation_crc (multiplane-rotation)
[670.335874] Starting subtest: multiplane-rotation
[687.696250] Subtest multiplane-rotation: SUCCESS (17.360s)
[687.844033] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: kms_pm_rpm
results: parsing output: 3/ for test: gem_softpin
results: parsing output: 4/ for test: kms_lease
results: parsing output: 5/ for test: api_intel_bb
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_mmap_gtt
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_create
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_mmap_offset
results: parsing output: 14/ for test: kms_chamelium_color
results: parsing output: 15/ for test: i915_drm_fdinfo
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: gen9_exec_parse
results: parsing output: 18/ for test: prime_vgem
results: parsing output: 19/ for test: kms_vblank
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_mmap
results: parsing output: 22/ for test: kms_chamelium_frames
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: vgem_slow
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_flip_scaled_crc
results: parsing output: 27/ for test: kms_feature_discovery
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: gem_ctx_bad_destroy
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: prime_vgem
results: parsing output: 32/ for test: kms_flip_scaled_crc
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_psr2_sf
results: parsing output: 35/ for test: gem_ctx_isolation
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: kms_pipe_b_c_ivb
results: parsing output: 38/ for test: gem_render_tiled_blits
results: parsing output: 39/ for test: kms_color
results: parsing output: 40/ for test: gen3_render_mixed_blits
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_busy
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: kms_vblank
results: parsing output: 45/ for test: i915_pm_rpm
results: parsing output: 46/ for test: kms_async_flips
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_linear_blits
results: parsing output: 49/ for test: gem_flink_race
results: parsing output: 50/ for test: gem_mmap_wc
results: parsing output: 51/ for test: kms_cursor_legacy
results: parsing output: 52/ for test: gem_wait
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_rotation_crc
results: parsing output: 55/ for test: kms_hdr
results: parsing output: 56/ for test: api_intel_allocator
results: parsing output: 57/ for test: gem_partial_pwrite_pread
results: parsing output: 58/ for test: gem_exec_whisper
results: parsing output: 59/ for test: gem_render_copy
results: parsing output: 60/ for test: perf_pmu
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: prime_mmap
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: gem_readwrite
results: parsing output: 65/ for test: perf
results: parsing output: 66/ for test: kms_prime
results: parsing output: 67/ for test: gem_tiling_max_stride
results: parsing output: 68/ for test: kms_cursor_edge_walk
results: parsing output: 69/ for test: gem_busy
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_plane_cursor
results: parsing output: 72/ for test: kms_psr2_sf
results: parsing output: 73/ for test: gem_ctx_shared
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: gem_mmap_gtt
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_chamelium_hpd
results: parsing output: 78/ for test: gem_partial_pwrite_pread
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: gem_exec_fence
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_plane_lowres
results: parsing output: 85/ for test: gem_pxp
results: parsing output: 86/ for test: gem_wait
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_ctx_persistence
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: i915_fb_tiling
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: kms_content_protection
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_addfb_basic
results: parsing output: 97/ for test: kms_fbcon_fbt
results: parsing output: 98/ for test: perf_pmu
results: parsing output: 99/ for test: i915_suspend
results: parsing output: 100/ for test: prime_mmap
results: parsing output: 101/ for test: gem_fenced_exec_thrash
results: parsing output: 102/ for test: core_auth
results: parsing output: 103/ for test: kms_cursor_crc
results: parsing output: 104/ for test: device_reset
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: sysfs_heartbeat_interval
results: parsing output: 107/ for test: kms_addfb_basic
results: parsing output: 108/ for test: kms_plane_scaling
results: parsing output: 109/ for test: sysfs_timeslice_duration
results: parsing output: 110/ for test: kms_pm_dc
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: gem_exec_whisper
results: parsing output: 113/ for test: drm_read
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: perf_pmu
results: parsing output: 116/ for test: gem_exec_fence
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_frontbuffer_tracking
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: kms_cursor_legacy
results: parsing output: 122/ for test: kms_invalid_mode
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: prime_vgem
results: parsing output: 126/ for test: prime_mmap
results: parsing output: 127/ for test: kms_addfb_basic
results: parsing output: 128/ for test: gem_exec_schedule
results: parsing output: 129/ for test: gem_exec_balancer
results: parsing output: 130/ for test: gem_exec_balancer
results: parsing output: 131/ for test: kms_rotation_crc
Done.