[59.870984] Initializing watchdogs
[59.871040]   /dev/watchdog0
[59.886219] [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.890495] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.892774] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.896367] [001/155] (960s left) prime_vgem (coherency-blt)
[60.020803] Starting subtest: coherency-blt
[62.142657] Subtest coherency-blt: SUCCESS (2.090s)
[62.226629] [FACT prime_vgem (coherency-blt)] new: kernel.kmod_is_loaded.vgem: true
[62.229510] [002/155] (958s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[62.277750] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[62.382907] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[62.458920] [003/155] (958s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[62.522710] Starting subtest: multi-wait-all-for-submit-signaled
[62.525089] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[62.639395] [004/155] (957s left) kms_psr (psr2-primary-mmap-cpu)
[62.735649] Starting subtest: psr2-primary-mmap-cpu
[62.737912] Starting dynamic subtest: eDP-1
[64.510342] Dynamic subtest eDP-1: SUCCESS (1.788s)
[64.512670] Subtest psr2-primary-mmap-cpu: SUCCESS (1.788s)
[65.370914] [005/155] (955s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[65.421395] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[65.526783] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[65.596920] [006/155] (954s left) kms_plane (pixel-format-y-tiled-modifier)
[65.686310] Starting subtest: pixel-format-y-tiled-modifier
[65.690413] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[65.769638] [007/155] (954s left) kms_cursor_crc (cursor-dpms)
[65.889755] Starting subtest: cursor-dpms
[65.892189] Starting dynamic subtest: pipe-A-eDP-1
[68.947837] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.069s)
[68.956598] Starting dynamic subtest: pipe-D-eDP-1
[72.615050] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.676s)
[72.617578] Subtest cursor-dpms: SUCCESS (6.748s)
[73.448807] [008/155] (947s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[73.595592] Starting subtest: stress-xrgb8888-xtiled
[79.442710] Subtest stress-xrgb8888-xtiled: SUCCESS (5.855s)
[79.490337] [009/155] (941s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[79.579438] Starting subtest: flip-vs-dpms-on-nop-interruptible
[79.581332] Starting dynamic subtest: A-eDP1
[81.436299] Dynamic subtest A-eDP1: SUCCESS (1.856s)
[81.446257] Starting dynamic subtest: B-eDP1
[83.263075] Dynamic subtest B-eDP1: SUCCESS (1.827s)
[83.271310] Starting dynamic subtest: C-eDP1
[85.071836] Dynamic subtest C-eDP1: SUCCESS (1.807s)
[85.081528] Starting dynamic subtest: D-eDP1
[86.906851] Dynamic subtest D-eDP1: SUCCESS (1.833s)
[86.911969] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.333s)
[88.083053] [010/155] (932s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[88.138860] Starting subtest: multi-wait-all-available-submitted-signaled
[88.141220] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[88.232992] [011/155] (932s left) gem_pread (self)
[88.290293] Subtest self: SKIP (0.000s)
[88.356224] [012/155] (932s left) gem_ctx_shared (exec-single-timeline)
[88.416972] Starting subtest: exec-single-timeline
[88.419327] Starting dynamic subtest: rcs0
[89.494201] Dynamic subtest rcs0: SUCCESS (1.075s)
[89.509187] Starting dynamic subtest: bcs0
[90.518827] Dynamic subtest bcs0: SUCCESS (1.022s)
[90.531503] Starting dynamic subtest: vcs0
[91.607032] Dynamic subtest vcs0: SUCCESS (1.086s)
[91.619421] Starting dynamic subtest: vcs1
[92.694854] Dynamic subtest vcs1: SUCCESS (1.086s)
[92.705860] Starting dynamic subtest: vecs0
[93.783556] Dynamic subtest vecs0: SUCCESS (1.086s)
[93.795878] Starting dynamic subtest: ccs0
[94.870886] Dynamic subtest ccs0: SUCCESS (1.086s)
[94.874056] Subtest exec-single-timeline: SUCCESS (6.452s)
[95.070896] [013/155] (925s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[95.186644] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[95.933646] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.748s)
[96.109228] [014/155] (924s left) gem_sync (basic-store-all)
[96.183733] Starting subtest: basic-store-all
[99.165662] Subtest basic-store-all: SUCCESS (2.993s)
[99.351949] [015/155] (921s left) kms_content_protection (dp-mst-lic-type-1)
[99.492816] Starting subtest: dp-mst-lic-type-1
[99.497763] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[99.633290] [016/155] (921s left) gem_exec_balancer (parallel-contexts)
[99.898386] Starting subtest: parallel-contexts
[102.498575] Subtest parallel-contexts: SUCCESS (2.600s)
[103.390433] [017/155] (917s left) kms_lease (lease-unleased-crtc)
[103.484077] Starting subtest: lease-unleased-crtc
[103.486594] Starting dynamic subtest: pipe-A-eDP-1
[103.772346] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[103.781938] Starting dynamic subtest: pipe-B-eDP-1
[104.524183] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.752s)
[104.535400] Starting dynamic subtest: pipe-C-eDP-1
[104.537811] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[104.548115] Starting dynamic subtest: pipe-D-eDP-1
[104.549981] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s)
[104.551839] Subtest lease-unleased-crtc: SUCCESS (1.057s)
[104.920472] [018/155] (916s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[105.025203] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[105.029499] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[105.130876] [019/155] (915s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[105.220420] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[105.224815] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[105.336717] [020/155] (915s left) kms_frontbuffer_tracking (fbchdr-1p-pri-indfb-multidraw)
[105.444579] Starting subtest: fbchdr-1p-pri-indfb-multidraw
[105.448755] Subtest fbchdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[105.532212] [021/155] (915s left) gem_exec_store (pages)
[105.592416] Starting subtest: pages
[105.594632] Starting dynamic subtest: rcs0
[105.684920] Dynamic subtest rcs0: SUCCESS (0.093s)
[105.696446] Starting dynamic subtest: bcs0
[105.751441] Dynamic subtest bcs0: SUCCESS (0.066s)
[105.762379] Starting dynamic subtest: vcs0
[105.812072] Dynamic subtest vcs0: SUCCESS (0.060s)
[105.821228] Starting dynamic subtest: vcs1
[105.875770] Dynamic subtest vcs1: SUCCESS (0.063s)
[105.883399] Starting dynamic subtest: vecs0
[105.935839] Dynamic subtest vecs0: SUCCESS (0.059s)
[105.945877] Starting dynamic subtest: ccs0
[106.001566] Dynamic subtest ccs0: SUCCESS (0.065s)
[106.003554] Subtest pages: SUCCESS (0.410s)
[106.183539] [022/155] (915s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[106.276052] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[110.355383] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.084s)
[111.526288] [023/155] (909s left) drm_read (fault-buffer)
[111.666517] Starting subtest: fault-buffer
[111.668990] Subtest fault-buffer: SUCCESS (0.000s)
[111.781042] [024/155] (909s left) gen9_exec_parse (unaligned-jump)
[111.845372] Subtest unaligned-jump: SKIP (0.000s)
[111.917255] [025/155] (909s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[112.025227] Starting subtest: flip-vs-cursor-crc-atomic
[112.682107] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.656s)
[113.540775] [026/155] (907s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[113.640513] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[113.642516] Starting dynamic subtest: pipe-A-eDP-1
[114.411735] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.764s)
[114.421382] Starting dynamic subtest: pipe-B-eDP-1
[115.956670] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.544s)
[115.966323] Starting dynamic subtest: pipe-C-eDP-1
[117.461299] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.503s)
[117.471074] Starting dynamic subtest: pipe-D-eDP-1
[119.009730] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.548s)
[119.011952] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.363s)
[120.184502] [027/155] (901s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[120.272222] Starting subtest: plane-all-modeset-transition-internal-panels
[120.274163] Starting dynamic subtest: pipe-A-eDP-1
[121.631505] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.359s)
[121.916569] Starting dynamic subtest: pipe-B-eDP-1
[122.953234] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.046s)
[123.222277] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.952s)
[124.062465] [028/155] (897s left) kms_psr (fbc-psr-sprite-render)
[124.150116] Starting subtest: fbc-psr-sprite-render
[124.152373] Starting dynamic subtest: eDP-1
[124.156763] Dynamic subtest eDP-1: SKIP (0.000s)
[124.161220] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[124.222944] [029/155] (897s left) i915_suspend (basic-s2idle-without-i915)
[124.259971] Starting subtest: basic-s2idle-without-i915
[146.463442] Subtest basic-s2idle-without-i915: SUCCESS (7.030s)
[146.555485] [030/155] (875s left) gem_ctx_persistence (engines-persistence)
[146.646367] Starting subtest: engines-persistence
[146.648760] Starting dynamic subtest: rcs0
[147.498599] Dynamic subtest rcs0: SUCCESS (0.873s)
[147.509705] Starting dynamic subtest: bcs0
[148.263943] Dynamic subtest bcs0: SUCCESS (0.782s)
[148.273816] Starting dynamic subtest: vcs0
[149.027189] Dynamic subtest vcs0: SUCCESS (0.777s)
[149.039246] Starting dynamic subtest: vcs1
[149.773306] Dynamic subtest vcs1: SUCCESS (0.758s)
[149.785115] Starting dynamic subtest: vecs0
[150.565578] Dynamic subtest vecs0: SUCCESS (0.803s)
[150.578235] Starting dynamic subtest: ccs0
[151.326656] Dynamic subtest ccs0: SUCCESS (0.770s)
[151.329508] Subtest engines-persistence: SUCCESS (4.775s)
[151.419022] [031/155] (870s left) gem_exec_params (rel-constants-invalid)
[151.472700] Starting subtest: rel-constants-invalid
[151.475082] Subtest rel-constants-invalid: SUCCESS (0.000s)
[151.573773] [032/155] (870s left) kms_pm_rpm (fences)
[153.705167] Starting subtest: fences
[153.709902] Subtest fences: SKIP (0.000s)
[154.080109] [033/155] (867s left) gem_exec_create (forked)
[154.144690] Starting subtest: forked
[154.146613] Starting dynamic subtest: smem
[175.456977] Dynamic subtest smem: SUCCESS (21.388s)
[175.461075] Subtest forked: SUCCESS (21.390s)
[175.645518] [034/155] (846s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[175.699369] Starting subtest: invalid-multi-wait-unsubmitted
[175.701613] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[175.805951] [035/155] (845s left) kms_psr (psr2-cursor-blt)
[175.904244] Starting subtest: psr2-cursor-blt
[175.906591] Starting dynamic subtest: eDP-1
[177.654168] Dynamic subtest eDP-1: SUCCESS (1.748s)
[177.656510] Subtest psr2-cursor-blt: SUCCESS (1.749s)
[178.534151] [036/155] (843s left) gem_ctx_param (invalid-ctx-set)
[178.589678] Starting subtest: invalid-ctx-set
[178.592067] Subtest invalid-ctx-set: SUCCESS (0.001s)
[178.686548] [037/155] (843s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-fullscreen)
[178.787872] Starting subtest: psrhdr-2p-primscrn-spr-indfb-fullscreen
[178.792043] Subtest psrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[178.884118] [038/155] (842s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[178.982013] Starting subtest: fbc-psr2-cursor-mmap-gtt
[178.984271] Starting dynamic subtest: eDP-1
[178.990364] Dynamic subtest eDP-1: SKIP (0.000s)
[178.996571] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[179.054660] [039/155] (842s left) kms_dp_link_training (non-uhbr-mst)
[179.141096] Starting subtest: non-uhbr-mst
[179.149156] Subtest non-uhbr-mst: SKIP (0.000s)
[179.216496] [040/155] (842s left) gen9_exec_parse (bb-start-cmd)
[179.278452] Subtest bb-start-cmd: SKIP (0.000s)
[179.354930] [041/155] (842s left) gem_madvise (dontneed-after-mmap)
[179.389174] Starting subtest: dontneed-after-mmap
[179.407282] Subtest dontneed-after-mmap: SUCCESS (0.019s)
[179.502403] [042/155] (842s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[179.596698] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[179.600177] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[179.696923] [043/155] (842s left) kms_frontbuffer_tracking (fbchdr-tiling-linear)
[179.800037] Starting subtest: fbchdr-tiling-linear
[179.803434] Subtest fbchdr-tiling-linear: SKIP (0.000s)
[179.917374] [044/155] (842s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-blt)
[180.018565] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-blt
[180.022063] Subtest psrhdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[180.121890] [045/155] (842s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[180.218331] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[187.605257] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.390s)
[187.704115] [046/155] (834s left) gem_render_copy (yf-tiled-ccs-to-linear)
[187.763386] Starting subtest: yf-tiled-ccs-to-linear
[187.767971] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[187.959693] [047/155] (834s left) kms_cursor_edge_walk (128x128-right-edge)
[188.043598] Starting subtest: 128x128-right-edge
[188.045964] Starting dynamic subtest: pipe-A-eDP-1
[191.504407] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.459s)
[191.515197] Starting dynamic subtest: pipe-D-eDP-1
[194.628814] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s)
[194.631349] Subtest 128x128-right-edge: SUCCESS (6.586s)
[195.444975] [048/155] (826s left) kms_cursor_crc (cursor-random-512x512)
[195.707290] Starting subtest: cursor-random-512x512
[195.711963] Subtest cursor-random-512x512: SKIP (0.001s)
[195.873172] [049/155] (826s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[195.970711] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[195.974961] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[196.071722] [050/155] (826s left) gem_mmap_wc (set-cache-level)
[196.126922] Subtest set-cache-level: SKIP (0.000s)
[196.198447] [051/155] (826s left) kms_rmfb (close-fd)
[196.302354] Starting subtest: close-fd
[196.304778] Starting dynamic subtest: pipe-A-eDP-1
[196.408825] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s)
[196.417716] Starting dynamic subtest: pipe-B-eDP-1
[197.602792] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.194s)
[197.612782] Starting dynamic subtest: pipe-C-eDP-1
[198.833034] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.228s)
[198.842387] Starting dynamic subtest: pipe-D-eDP-1
[200.060235] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.225s)
[200.062100] Subtest close-fd: SUCCESS (3.759s)
[201.267678] [052/155] (821s left) kms_plane_multiple (2x-tiling-4)
[201.365079] Starting subtest: 2x-tiling-4
[201.369283] Subtest 2x-tiling-4: SKIP (0.000s)
[201.437751] [053/155] (821s left) gem_cs_tlb (engines)
[201.485573] Starting subtest: engines
[201.487843] Starting dynamic subtest: rcs0
[203.641157] Dynamic subtest rcs0: SUCCESS (2.152s)
[203.651602] Starting dynamic subtest: bcs0
[205.795695] Dynamic subtest bcs0: SUCCESS (2.152s)
[205.804960] Starting dynamic subtest: vcs0
[208.001590] Dynamic subtest vcs0: SUCCESS (2.152s)
[208.010398] Starting dynamic subtest: vcs1
[210.151825] Dynamic subtest vcs1: SUCCESS (2.152s)
[210.163773] Starting dynamic subtest: vecs0
[212.303560] Dynamic subtest vecs0: SUCCESS (2.151s)
[212.314467] Starting dynamic subtest: ccs0
[214.457222] Dynamic subtest ccs0: SUCCESS (2.153s)
[214.459638] Subtest engines: SUCCESS (12.920s)
[214.518517] [054/155] (808s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[214.617227] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[214.619543] Starting dynamic subtest: pipe-A-default-mode
[217.422972] Dynamic subtest pipe-A-default-mode: SUCCESS (2.805s)
[217.424959] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.806s)
[218.249527] [055/155] (804s left) gem_exec_capture (capture-recoverable)
[218.315611] Starting subtest: capture-recoverable
[218.317959] Subtest capture-recoverable: SUCCESS (0.003s)
[218.439358] [056/155] (804s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[218.534903] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[218.539092] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[218.621541] [057/155] (804s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[218.716535] Starting subtest: random-ccs-data-y-tiled-ccs
[218.718652] Starting dynamic subtest: pipe-A-eDP-1
[218.743400] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[218.754963] Starting dynamic subtest: pipe-B-eDP-1
[218.778674] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[218.787074] Starting dynamic subtest: pipe-C-eDP-1
[218.811158] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[218.821594] Starting dynamic subtest: pipe-D-eDP-1
[218.845097] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[218.849451] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[221.032917] [058/155] (801s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[221.141489] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[221.143775] Starting dynamic subtest: pipe-A
[222.244454] Dynamic subtest pipe-A: SUCCESS (1.106s)
[222.253171] Starting dynamic subtest: pipe-B
[224.374240] Dynamic subtest pipe-B: SUCCESS (2.129s)
[224.383059] Starting dynamic subtest: pipe-C
[225.532560] Dynamic subtest pipe-C: SUCCESS (1.157s)
[225.546171] Starting dynamic subtest: pipe-D
[226.770166] Dynamic subtest pipe-D: SUCCESS (1.237s)
[226.772392] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.634s)
[227.961785] [059/155] (794s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[228.053764] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[228.056128] Starting dynamic subtest: pipe-A-eDP-1
[228.205006] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.141s)
[228.216406] Starting dynamic subtest: pipe-B-eDP-1
[228.236375] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[228.245737] Starting dynamic subtest: pipe-C-eDP-1
[228.265206] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[228.274622] Starting dynamic subtest: pipe-D-eDP-1
[228.293647] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.013s)
[228.295839] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.178s)
[230.528519] [060/155] (792s left) kms_getfb (getfb2-handle-protection)
[230.613515] Starting subtest: getfb2-handle-protection
[230.634892] Subtest getfb2-handle-protection: SUCCESS (0.022s)
[230.763418] [061/155] (792s left) core_getversion (all-cards)
[230.802406] Starting subtest: all-cards
[230.811396] Subtest all-cards: SUCCESS (0.012s)
[230.860520] [062/155] (792s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[230.966409] Starting subtest: 4-tiled-64bpp-rotate-270
[230.986191] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.019s)
[231.100401] [063/155] (791s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-pgflip-blt)
[231.201070] Starting subtest: psrhdr-1p-primscrn-indfb-pgflip-blt
[231.205160] Subtest psrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[231.297777] [064/155] (791s left) gem_mmap_gtt (big-bo-tiledy)
[231.352894] Subtest big-bo-tiledY: SKIP (0.000s)
[231.420295] [065/155] (791s left) gem_lmem_swapping (heavy-random)
[231.458726] Subtest heavy-random: SKIP (0.000s)
[231.505218] [066/155] (791s left) api_intel_allocator (alloc-simple)
[231.556998] Starting subtest: alloc-simple
[231.558906] Subtest alloc-simple: SUCCESS (0.003s)
[231.669984] [067/155] (791s left) gem_shrink (reclaim)
[231.724364] Starting subtest: reclaim
[234.166503] Subtest reclaim: SUCCESS (2.441s)
[234.312592] [068/155] (788s left) gem_readwrite (write-bad-handle)
[234.374602] Subtest write-bad-handle: SKIP (0.000s)
[234.445806] [069/155] (788s left) i915_pm_rpm (reg-read-ioctl)
[236.675212] Starting subtest: reg-read-ioctl
[238.954492] Subtest reg-read-ioctl: SUCCESS (2.285s)
[239.338981] [070/155] (783s left) gem_mmap_gtt (big-copy-odd)
[239.401011] Subtest big-copy-odd: SKIP (0.000s)
[239.460024] [071/155] (783s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-render)
[239.559395] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-render
[239.563586] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[239.665433] [072/155] (783s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[239.760509] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[239.762809] Starting dynamic subtest: pipe-A-eDP-1
[239.855375] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[239.866304] Starting dynamic subtest: pipe-B-eDP-1
[241.008282] Dynamic subtest pipe-B-eDP-1: SKIP (1.149s)
[241.013199] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.251s)
[242.194417] [073/155] (781s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-fullscreen)
[242.300089] Starting subtest: hdr-1p-primscrn-spr-indfb-fullscreen
[242.304067] Subtest hdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[242.404835] [074/155] (780s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-blt)
[242.509117] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-blt
[242.513656] Subtest fbchdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[242.628888] [075/155] (780s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-render)
[242.721122] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-render
[242.725643] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[242.826978] [076/155] (780s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[242.928256] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[247.415175] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.491s)
[248.619486] [077/155] (774s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-blt)
[248.719441] Starting subtest: fbcpsrhdr-rgb565-draw-blt
[248.723969] Subtest fbcpsrhdr-rgb565-draw-blt: SKIP (0.000s)
[248.811482] [078/155] (774s left) kms_vblank (query-forked-busy)
[248.899772] Starting subtest: query-forked-busy
[248.901561] Starting dynamic subtest: pipe-A-eDP-1
[250.776012] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.876s)
[250.790546] Starting dynamic subtest: pipe-D-eDP-1
[253.364839] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.585s)
[253.366855] Subtest query-forked-busy: SUCCESS (4.465s)
[254.178227] [079/155] (769s left) perf (gen12-invalid-class-instance)
[254.295423] Starting subtest: gen12-invalid-class-instance
[254.305439] Subtest gen12-invalid-class-instance: SUCCESS (0.010s)
[254.343808] [080/155] (769s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[254.444284] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[261.798493] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.358s)
[261.938454] [081/155] (761s left) syncobj_wait (invalid-single-wait-unsubmitted)
[261.992999] Starting subtest: invalid-single-wait-unsubmitted
[261.995287] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[262.096684] [082/155] (761s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt)
[262.195041] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt
[262.199420] Subtest fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[262.293830] [083/155] (761s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[262.385156] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[262.389368] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[262.479742] [084/155] (761s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-render)
[262.571478] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-render
[262.575665] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[262.676962] [085/155] (761s left) i915_getparams_basic (basic-subslice-total)
[262.726855] Starting subtest: basic-subslice-total
[262.730698] Subtest basic-subslice-total: SUCCESS (0.000s)
[262.826936] [086/155] (761s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[262.921580] Starting subtest: 4-tiled-16bpp-rotate-180
[264.134210] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.211s)
[264.268743] [087/155] (759s left) gem_eio (in-flight-external)
[264.488034] Starting subtest: in-flight-external
[265.581499] Subtest in-flight-external: SUCCESS (1.091s)
[265.696124] [088/155] (758s left) gem_set_tiling_vs_gtt
[265.848232] [089/155] (758s left) gem_eio (in-flight-suspend)
[266.058020] Starting subtest: in-flight-suspend
[309.318699] Subtest in-flight-suspend: SUCCESS (13.420s)
[309.469945] [090/155] (714s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[309.573070] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[309.577179] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[309.692780] [091/155] (714s left) syncobj_basic (bad-fd-to-handle)
[309.748145] Starting subtest: bad-fd-to-handle
[309.750509] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[309.850824] [092/155] (714s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[309.951028] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[310.903655] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.980s)
[311.024615] [093/155] (713s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[311.124639] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[311.128782] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[311.217976] [094/155] (713s left) gem_mmap_gtt (medium-copy)
[311.267207] Subtest medium-copy: SKIP (0.000s)
[311.323450] [095/155] (712s left) gem_softpin (allocator-nopin-reserve)
[311.374503] Starting subtest: allocator-nopin-reserve
[311.460647] Subtest allocator-nopin-reserve: SUCCESS (0.088s)
[311.587411] [096/155] (712s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[311.635514] Starting subtest: framebuffer-vs-set-tiling
[311.639199] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[311.764775] [097/155] (712s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[311.887940] Starting subtest: flip-vs-cursor-crc-legacy
[312.520719] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.647s)
[313.328165] [098/155] (711s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[313.429721] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[320.286401] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.945s)
[320.435548] [099/155] (704s left) gem_exec_schedule (preempt-user)
[320.518805] Starting subtest: preempt-user
[320.520762] Starting dynamic subtest: rcs0
[320.536791] Dynamic subtest rcs0: SUCCESS (0.025s)
[320.546551] Starting dynamic subtest: bcs0
[320.558859] Dynamic subtest bcs0: SUCCESS (0.020s)
[320.569362] Starting dynamic subtest: vcs0
[320.579013] Dynamic subtest vcs0: SUCCESS (0.020s)
[320.588613] Starting dynamic subtest: vcs1
[320.600389] Dynamic subtest vcs1: SUCCESS (0.021s)
[320.610163] Starting dynamic subtest: vecs0
[320.622811] Dynamic subtest vecs0: SUCCESS (0.022s)
[320.635070] Starting dynamic subtest: ccs0
[320.646484] Dynamic subtest ccs0: SUCCESS (0.023s)
[320.648896] Subtest preempt-user: SUCCESS (0.137s)
[322.433318] [100/155] (702s left) gem_blits (basic)
[322.481014] Starting subtest: basic
[324.486676] Subtest basic: SUCCESS (2.015s)
[324.598621] [101/155] (699s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[324.692402] Starting subtest: sprite-rotation-90-pos-100-0
[324.696723] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[324.764634] [102/155] (699s left) kms_vblank (ts-continuation-modeset-rpm)
[324.858517] Starting subtest: ts-continuation-modeset-rpm
[324.860333] Starting dynamic subtest: pipe-A-eDP-1
[327.335808] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.488s)
[327.351023] Starting dynamic subtest: pipe-D-eDP-1
[329.574127] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.243s)
[329.576311] Subtest ts-continuation-modeset-rpm: SUCCESS (4.734s)
[330.455870] [103/155] (694s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[330.561096] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[330.565294] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[330.660922] [104/155] (693s left) gem_close (many-handles-one-vma)
[330.722990] Starting subtest: many-handles-one-vma
[330.743924] Subtest many-handles-one-vma: SUCCESS (0.024s)
[330.857604] [105/155] (693s left) core_hotunplug (unbind-rebind)
[330.941403] Starting subtest: unbind-rebind
[336.886398] Subtest unbind-rebind: SUCCESS (5.957s)
[336.928707] [106/155] (687s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render)
[338.372082] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render
[338.376223] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[338.486194] [107/155] (686s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[338.577915] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[338.580278] Starting dynamic subtest: pipe-A-eDP-1
[338.603354] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[338.618102] Starting dynamic subtest: pipe-B-eDP-1
[338.639840] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[338.649103] Starting dynamic subtest: pipe-C-eDP-1
[338.670951] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[338.680531] Starting dynamic subtest: pipe-D-eDP-1
[338.702302] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[338.706767] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[340.819825] [108/155] (683s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-msflip-blt)
[340.922461] Starting subtest: psrhdr-2p-scndscrn-indfb-msflip-blt
[340.926887] Subtest psrhdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[341.015975] [109/155] (683s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[341.117305] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[341.121672] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[341.219789] [110/155] (683s left) kms_dsc (dsc-with-output-formats-with-bpc)
[341.310498] Starting subtest: dsc-with-output-formats-with-bpc
[341.368904] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[341.407860] [111/155] (683s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[341.500748] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[341.504846] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[341.601837] [112/155] (683s left) gem_ringfill (basic-all)
[347.314607] Starting subtest: basic-all
[348.475163] Subtest basic-all: SUCCESS (1.159s)
[348.613352] [113/155] (676s left) gem_exec_params (invalid-fence-in-submit)
[348.681333] Starting subtest: invalid-fence-in-submit
[348.683829] Subtest invalid-fence-in-submit: SUCCESS (0.004s)
[348.806166] [114/155] (676s left) perf_pmu (render-node-busy)
[348.879193] Starting subtest: render-node-busy
[348.882014] Starting dynamic subtest: rcs0
[349.464332] Dynamic subtest rcs0: SUCCESS (0.585s)
[349.476895] Starting dynamic subtest: bcs0
[350.032959] Dynamic subtest bcs0: SUCCESS (0.566s)
[350.046385] Starting dynamic subtest: vcs0
[351.342900] Dynamic subtest vcs0: SUCCESS (1.305s)
[351.357000] Starting dynamic subtest: vcs1
[353.327876] Dynamic subtest vcs1: SUCCESS (1.982s)
[353.344567] Starting dynamic subtest: vecs0
[355.313227] Dynamic subtest vecs0: SUCCESS (1.982s)
[355.326065] Starting dynamic subtest: ccs0
[355.878366] Dynamic subtest ccs0: SUCCESS (0.564s)
[355.881165] Subtest render-node-busy: SUCCESS (6.999s)
[355.969439] [115/155] (669s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[356.069483] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[356.074265] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[356.171909] [116/155] (668s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[356.292026] Starting subtest: cursorB-vs-flipA-legacy
[356.296889] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[356.438679] [117/155] (668s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[356.540978] Starting subtest: psr-farfromfence-mmap-gtt
[356.545605] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[356.657506] [118/155] (668s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[356.752532] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[356.757267] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[356.855314] [119/155] (668s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[356.954864] Starting subtest: fbc-farfromfence-mmap-gtt
[356.958549] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[357.047943] [120/155] (668s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[357.143917] Starting subtest: primary-yf-tiled-reflect-x-270
[357.147464] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[357.217085] [121/155] (668s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[357.310963] Starting subtest: fbc-tiling-linear
[361.058936] Subtest fbc-tiling-linear: SUCCESS (3.752s)
[362.252964] [122/155] (663s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[362.306220] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[362.362990] [123/155] (663s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[362.892915] Starting subtest: syncobj-backward-timeline-chain-engines
[362.997617] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.105s)
[364.433971] [124/155] (661s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[364.533703] Starting subtest: plane-upscale-20x20-with-modifiers
[364.536050] Starting dynamic subtest: pipe-A
[364.869436] Dynamic subtest pipe-A: SUCCESS (0.338s)
[364.879542] Starting dynamic subtest: pipe-B
[366.326095] Dynamic subtest pipe-B: SUCCESS (1.456s)
[366.339407] Starting dynamic subtest: pipe-C
[367.755881] Dynamic subtest pipe-C: SUCCESS (1.429s)
[367.766887] Starting dynamic subtest: pipe-D
[369.187692] Dynamic subtest pipe-D: SUCCESS (1.431s)
[369.190120] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.657s)
[370.365310] [125/155] (655s left) gem_exec_schedule (preempt-hang)
[370.545966] Starting subtest: preempt-hang
[370.547897] Starting dynamic subtest: rcs0
[370.776169] Dynamic subtest rcs0: SUCCESS (0.232s)
[370.792396] Starting dynamic subtest: bcs0
[370.997515] Dynamic subtest bcs0: SUCCESS (0.221s)
[371.008763] Starting dynamic subtest: vcs0
[371.222625] Dynamic subtest vcs0: SUCCESS (0.224s)
[371.233551] Starting dynamic subtest: vcs1
[371.441449] Dynamic subtest vcs1: SUCCESS (0.219s)
[371.454153] Starting dynamic subtest: vecs0
[371.667815] Dynamic subtest vecs0: SUCCESS (0.225s)
[371.681350] Starting dynamic subtest: ccs0
[371.891491] Dynamic subtest ccs0: SUCCESS (0.223s)
[371.893909] Subtest preempt-hang: SUCCESS (1.348s)
[372.443235] [126/155] (653s left) gem_ctx_persistence (legacy-engines-mixed)
[372.491896] Starting subtest: legacy-engines-mixed
[372.494156] Starting dynamic subtest: render
[372.571227] Dynamic subtest render: SUCCESS (0.079s)
[372.586678] Starting dynamic subtest: bsd1
[372.623006] Dynamic subtest bsd1: SUCCESS (0.049s)
[372.636449] Starting dynamic subtest: bsd2
[372.673193] Dynamic subtest bsd2: SUCCESS (0.048s)
[372.689076] Starting dynamic subtest: blt
[372.726936] Dynamic subtest blt: SUCCESS (0.050s)
[372.744018] Starting dynamic subtest: vebox
[372.783030] Dynamic subtest vebox: SUCCESS (0.053s)
[372.785431] Subtest legacy-engines-mixed: SUCCESS (0.294s)
[372.869222] [127/155] (652s left) kms_psr (psr-primary-blt)
[372.966829] Starting subtest: psr-primary-blt
[372.969090] Starting dynamic subtest: eDP-1
[374.764851] Dynamic subtest eDP-1: SUCCESS (1.800s)
[374.767269] Subtest psr-primary-blt: SUCCESS (1.801s)
[375.646530] [128/155] (649s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[376.065294] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[376.870486] [129/155] (648s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[376.969749] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[381.441600] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.480s)
[382.594264] [130/155] (643s left) kms_color (ctm-0-75)
[382.693052] Starting subtest: ctm-0-75
[382.695363] Starting dynamic subtest: pipe-A-eDP-1
[387.623253] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.933s)
[387.634934] Starting dynamic subtest: pipe-B-eDP-1
[393.369003] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.746s)
[393.379895] Starting dynamic subtest: pipe-C-eDP-1
[398.744174] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.376s)
[398.754794] Starting dynamic subtest: pipe-D-eDP-1
[404.070143] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.329s)
[404.072405] Subtest ctm-0-75: SUCCESS (21.387s)
[404.902122] [131/155] (620s left) gem_userptr_blits (set-cache-level)
[404.981490] Starting subtest: set-cache-level
[404.986204] Subtest set-cache-level: SKIP (0.000s)
[405.120456] [132/155] (620s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[405.219642] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[405.223934] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[405.338446] [133/155] (620s left) kms_frontbuffer_tracking (psrhdr-indfb-scaledprimary)
[405.431690] Starting subtest: psrhdr-indfb-scaledprimary
[405.435783] Subtest psrhdr-indfb-scaledprimary: SKIP (0.000s)
[405.528547] [134/155] (620s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[405.625594] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc
[405.629777] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[405.728732] [135/155] (620s left) kms_flip (basic-flip-vs-dpms)
[405.824673] Starting subtest: basic-flip-vs-dpms
[405.826654] Starting dynamic subtest: A-eDP1
[408.407998] Dynamic subtest A-eDP1: SUCCESS (2.582s)
[408.419647] Starting dynamic subtest: B-eDP1
[410.600990] Dynamic subtest B-eDP1: SUCCESS (2.191s)
[410.613267] Starting dynamic subtest: C-eDP1
[412.701419] Dynamic subtest C-eDP1: SUCCESS (2.098s)
[412.713405] Starting dynamic subtest: D-eDP1
[414.970513] Dynamic subtest D-eDP1: SUCCESS (2.267s)
[414.972841] Subtest basic-flip-vs-dpms: SUCCESS (9.147s)
[415.795091] [136/155] (610s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-gtt)
[415.894283] Starting subtest: hdr-rgb101010-draw-mmap-gtt
[415.898833] Subtest hdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[415.993921] [137/155] (610s left) kms_psr (fbc-pr-primary-mmap-cpu)
[416.078506] Starting subtest: fbc-pr-primary-mmap-cpu
[416.082712] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[416.154179] [138/155] (609s left) kms_async_flips (alternate-sync-async-flip)
[416.240171] Starting subtest: alternate-sync-async-flip
[416.621655] Starting dynamic subtest: pipe-A-eDP-1
[419.373232] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.751s)
[419.754996] Starting dynamic subtest: pipe-B-eDP-1
[422.513050] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.766s)
[422.891297] Starting dynamic subtest: pipe-C-eDP-1
[425.655143] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.772s)
[426.022357] Starting dynamic subtest: pipe-D-eDP-1
[428.790343] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.778s)
[428.792514] Subtest alternate-sync-async-flip: SUCCESS (12.551s)
[429.963755] [139/155] (596s left) kms_invalid_mode (zero-clock)
[430.072156] Starting subtest: zero-clock
[430.074484] Starting dynamic subtest: pipe-A-eDP-1
[430.360732] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[430.373511] Starting dynamic subtest: pipe-B-eDP-1
[430.375793] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[430.385619] Starting dynamic subtest: pipe-C-eDP-1
[430.387537] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[430.397429] Starting dynamic subtest: pipe-D-eDP-1
[430.399363] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[430.401347] Subtest zero-clock: SUCCESS (0.295s)
[431.196550] [140/155] (594s left) gem_mmap_offset (partial-mmap)
[431.243551] Starting subtest: partial-mmap
[431.246028] Starting dynamic subtest: smem0
[431.248497] Dynamic subtest smem0: SUCCESS (0.004s)
[431.250866] Subtest partial-mmap: SUCCESS (0.004s)
[431.374490] [141/155] (594s left) gem_exec_fence (basic-wait-all)
[431.434210] Starting subtest: basic-wait-all
[431.532918] Subtest basic-wait-all: SUCCESS (0.099s)
[433.382314] [142/155] (592s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[433.480701] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[433.482909] Starting dynamic subtest: pipe-A-eDP-1
[433.505906] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[433.518636] Starting dynamic subtest: pipe-B-eDP-1
[433.540772] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[433.551193] Starting dynamic subtest: pipe-C-eDP-1
[433.572911] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[433.582854] Starting dynamic subtest: pipe-D-eDP-1
[433.604753] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[433.608780] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[435.754002] [143/155] (590s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[435.857809] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc
[435.862036] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[435.955726] [144/155] (590s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[436.055184] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-mmap-wc
[436.059630] Subtest hdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[436.164309] [145/155] (590s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[436.261661] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[436.265758] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[436.388293] [146/155] (590s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[436.496556] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[436.501120] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[436.600627] [147/155] (589s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[436.695088] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[436.697135] Starting dynamic subtest: pipe-A-eDP-1
[436.791877] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[436.802467] Starting dynamic subtest: pipe-B-eDP-1
[437.929914] Dynamic subtest pipe-B-eDP-1: SKIP (1.136s)
[437.934705] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.238s)
[439.218214] [148/155] (587s left) syncobj_wait (multi-wait-all-submitted)
[439.280395] Starting subtest: multi-wait-all-submitted
[439.386396] Subtest multi-wait-all-submitted: SUCCESS (0.106s)
[439.467185] [149/155] (587s left) kms_chamelium_edid (hdmi-edid-read)
[439.857108] Subtest hdmi-edid-read: SKIP (0.000s)
[440.714625] [150/155] (585s left) syncobj_timeline (wait-for-submit-delayed-submit)
[440.768487] Starting subtest: wait-for-submit-delayed-submit
[440.870162] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[440.947084] [151/155] (585s left) syncobj_timeline (transfer-timeline-point)
[441.004406] Starting subtest: transfer-timeline-point
[441.006858] Subtest transfer-timeline-point: SUCCESS (0.000s)
[441.102961] [152/155] (585s left) gem_userptr_blits (dmabuf-sync)
[441.168205] Starting subtest: dmabuf-sync
[441.172959] Subtest dmabuf-sync: SKIP (0.002s)
[441.321133] [153/155] (585s left) kms_flip (2x-absolute-wf_vblank)
[441.413650] Starting subtest: 2x-absolute-wf_vblank
[441.424564] Subtest 2x-absolute-wf_vblank: SKIP (0.010s)
[441.517852] [154/155] (585s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[441.640397] Starting subtest: short-flip-after-cursor-atomic-transitions
[442.604492] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.964s)
[443.478073] [155/155] (583s left) gem_mmap (short-mmap)
[443.526354] Subtest short-mmap: SKIP (0.000s)
[443.588863] Closing watchdogs
results: parsing output: 0/ for test: prime_vgem
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_plane
results: parsing output: 6/ for test: kms_cursor_crc
results: parsing output: 7/ for test: kms_pipe_stress
results: parsing output: 8/ for test: kms_flip
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: gem_pread
results: parsing output: 11/ for test: gem_ctx_shared
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: gem_sync
results: parsing output: 14/ for test: kms_content_protection
results: parsing output: 15/ for test: gem_exec_balancer
results: parsing output: 16/ for test: kms_lease
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_exec_store
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: drm_read
results: parsing output: 23/ for test: gen9_exec_parse
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: kms_atomic_transition
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: i915_suspend
results: parsing output: 29/ for test: gem_ctx_persistence
results: parsing output: 30/ for test: gem_exec_params
results: parsing output: 31/ for test: kms_pm_rpm
results: parsing output: 32/ for test: gem_exec_create
results: parsing output: 33/ for test: syncobj_wait
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: gem_ctx_param
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: kms_dp_link_training
results: parsing output: 39/ for test: gen9_exec_parse
results: parsing output: 40/ for test: gem_madvise
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_render_copy
results: parsing output: 46/ for test: kms_cursor_edge_walk
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: gem_mmap_wc
results: parsing output: 50/ for test: kms_rmfb
results: parsing output: 51/ for test: kms_plane_multiple
results: parsing output: 52/ for test: gem_cs_tlb
results: parsing output: 53/ for test: kms_flip_scaled_crc
results: parsing output: 54/ for test: gem_exec_capture
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: kms_plane_scaling
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_getfb
results: parsing output: 60/ for test: core_getversion
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_mmap_gtt
results: parsing output: 64/ for test: gem_lmem_swapping
results: parsing output: 65/ for test: api_intel_allocator
results: parsing output: 66/ for test: gem_shrink
results: parsing output: 67/ for test: gem_readwrite
results: parsing output: 68/ for test: i915_pm_rpm
results: parsing output: 69/ for test: gem_mmap_gtt
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_psr2_sf
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_vblank
results: parsing output: 78/ for test: perf
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: i915_getparams_basic
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_eio
results: parsing output: 87/ for test: gem_set_tiling_vs_gtt
results: parsing output: 88/ for test: gem_eio
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: syncobj_basic
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_mmap_gtt
results: parsing output: 94/ for test: gem_softpin
results: parsing output: 95/ for test: kms_addfb_basic
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_exec_schedule
results: parsing output: 99/ for test: gem_blits
results: parsing output: 100/ for test: kms_rotation_crc
results: parsing output: 101/ for test: kms_vblank
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: gem_close
results: parsing output: 104/ for test: core_hotunplug
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_dsc
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_ringfill
results: parsing output: 112/ for test: gem_exec_params
results: parsing output: 113/ for test: perf_pmu
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_rotation_crc
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_mmap_gtt
results: parsing output: 122/ for test: gem_exec_fence
results: parsing output: 123/ for test: kms_plane_scaling
results: parsing output: 124/ for test: gem_exec_schedule
results: parsing output: 125/ for test: gem_ctx_persistence
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_chamelium_hpd
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_color
results: parsing output: 130/ for test: gem_userptr_blits
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_flip
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: kms_psr
results: parsing output: 137/ for test: kms_async_flips
results: parsing output: 138/ for test: kms_invalid_mode
results: parsing output: 139/ for test: gem_mmap_offset
results: parsing output: 140/ for test: gem_exec_fence
results: parsing output: 141/ for test: kms_ccs
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_psr2_sf
results: parsing output: 147/ for test: syncobj_wait
results: parsing output: 148/ for test: kms_chamelium_edid
results: parsing output: 149/ for test: syncobj_timeline
results: parsing output: 150/ for test: syncobj_timeline
results: parsing output: 151/ for test: gem_userptr_blits
results: parsing output: 152/ for test: kms_flip
results: parsing output: 153/ for test: kms_cursor_legacy
results: parsing output: 154/ for test: gem_mmap
Done.