[56.347048] Initializing watchdogs
[56.347095]   /dev/watchdog0
[56.362933] [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]
[56.367259] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.369412] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.372540] [001/131] (960s left) i915_hangman (gt-engine-hang)
[56.462179] Starting subtest: gt-engine-hang
[56.464036] Starting dynamic subtest: rcs0
[57.909051] Dynamic subtest rcs0: SUCCESS (1.446s)
[57.916175] Starting dynamic subtest: bcs0
[59.890847] Dynamic subtest bcs0: SUCCESS (1.981s)
[59.900952] Starting dynamic subtest: vcs0
[61.875942] Dynamic subtest vcs0: SUCCESS (1.984s)
[61.885732] Starting dynamic subtest: vcs1
[63.859270] Dynamic subtest vcs1: SUCCESS (1.982s)
[63.869583] Starting dynamic subtest: vecs0
[65.842345] Dynamic subtest vecs0: SUCCESS (1.982s)
[65.851946] Starting dynamic subtest: ccs0
[67.890608] Dynamic subtest ccs0: SUCCESS (2.047s)
[67.893770] Subtest gt-engine-hang: SUCCESS (11.429s)
[67.981449] [002/131] (948s left) gem_exec_schedule (submit-golden-slice)
[68.054069] Starting subtest: submit-golden-slice
[68.056472] Starting dynamic subtest: rcs0
[68.108370] Dynamic subtest rcs0: SUCCESS (0.059s)
[68.118518] Starting dynamic subtest: bcs0
[68.147388] Dynamic subtest bcs0: SUCCESS (0.039s)
[68.156710] Starting dynamic subtest: vcs0
[68.198971] Dynamic subtest vcs0: SUCCESS (0.051s)
[68.205720] Starting dynamic subtest: vcs1
[68.250370] Dynamic subtest vcs1: SUCCESS (0.051s)
[68.260859] Starting dynamic subtest: vecs0
[68.300677] Dynamic subtest vecs0: SUCCESS (0.050s)
[68.310621] Starting dynamic subtest: ccs0
[68.345473] Dynamic subtest ccs0: SUCCESS (0.044s)
[68.347873] Subtest submit-golden-slice: SUCCESS (0.297s)
[70.043196] [003/131] (946s left) kms_vblank (wait-forked)
[70.149975] Starting subtest: wait-forked
[70.152365] Starting dynamic subtest: pipe-A-eDP-1
[71.982437] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.831s)
[71.996112] Starting dynamic subtest: pipe-D-eDP-1
[74.501217] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.516s)
[74.503448] Subtest wait-forked: SUCCESS (4.353s)
[75.377451] [004/131] (941s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[75.505871] Starting subtest: cursorA-vs-flipB-toggle
[75.510330] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[75.674717] [005/131] (941s left) gem_exec_flush (basic-uc-pro-default)
[75.744593] Starting subtest: basic-uc-pro-default
[81.198284] Subtest basic-uc-pro-default: SUCCESS (5.455s)
[81.396326] [006/131] (935s left) api_intel_allocator (fork-simple-stress-signal)
[81.452642] Starting subtest: fork-simple-stress-signal
[86.856726] Subtest fork-simple-stress-signal: SUCCESS (5.402s)
[86.984603] [007/131] (930s left) gem_exec_balancer (invalid-balancer)
[87.049629] Starting subtest: invalid-balancer
[88.080109] Subtest invalid-balancer: SUCCESS (1.029s)
[88.408870] [008/131] (928s left) kms_psr (pr-primary-mmap-cpu)
[88.519827] Starting subtest: pr-primary-mmap-cpu
[88.524296] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[88.613187] [009/131] (928s left) perf (i915-ref-count)
[88.694703] Starting subtest: i915-ref-count
[88.767982] Subtest i915-ref-count: SUCCESS (0.071s)
[88.835882] [010/131] (928s left) gem_linear_blits (interruptible)
[89.140069] Starting subtest: interruptible
[93.237749] Subtest interruptible: SUCCESS (4.098s)
[93.400343] [011/131] (923s left) gem_pxp (create-protected-buffer)
[93.552487] Starting subtest: create-protected-buffer
[93.554878] Subtest create-protected-buffer: SUCCESS (0.000s)
[93.668888] [012/131] (923s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[93.775780] Starting subtest: psr-indfb-scaledprimary
[99.508082] Subtest psr-indfb-scaledprimary: SUCCESS (5.735s)
[99.675326] [013/131] (917s left) prime_mmap (test_correct_cpu_write)
[99.736868] Starting subtest: test_correct_cpu_write
[99.739475] Starting dynamic subtest: test_correct_cpu_write-smem
[99.741992] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[99.744652] Subtest test_correct_cpu_write: SUCCESS (0.000s)
[99.852462] [014/131] (917s left) gem_ctx_param (invalid-ctx-set)
[99.913885] Starting subtest: invalid-ctx-set
[99.916286] Subtest invalid-ctx-set: SUCCESS (0.001s)
[100.039631] [015/131] (917s left) syncobj_timeline (wait-delayed-signal)
[100.109469] Starting subtest: wait-delayed-signal
[100.211659] Subtest wait-delayed-signal: SUCCESS (0.102s)
[100.294529] [016/131] (917s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[100.347817] Starting subtest: etime-multi-wait-for-submit-submitted
[100.457104] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.108s)
[100.549855] [017/131] (916s left) sw_sync (alloc_timeline)
[100.586108] Starting subtest: alloc_timeline
[100.588137] Subtest alloc_timeline: SUCCESS (0.000s)
[100.661548] [018/131] (916s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[100.752462] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[100.754807] Starting dynamic subtest: A-eDP1
[104.443402] Dynamic subtest A-eDP1: SUCCESS (3.692s)
[104.457227] Starting dynamic subtest: B-eDP1
[107.636059] Dynamic subtest B-eDP1: SUCCESS (3.192s)
[107.645735] Starting dynamic subtest: C-eDP1
[110.743186] Dynamic subtest C-eDP1: SUCCESS (3.107s)
[110.754575] Starting dynamic subtest: D-eDP1
[113.849382] Dynamic subtest D-eDP1: SUCCESS (3.104s)
[113.851664] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.102s)
[114.652628] [019/131] (902s left) kms_flip (2x-absolute-wf_vblank)
[114.743017] Starting subtest: 2x-absolute-wf_vblank
[114.752615] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[114.838130] [020/131] (902s left) gem_mmap_gtt (medium-copy)
[114.894725] Subtest medium-copy: SKIP (0.000s)
[114.951241] [021/131] (902s left) perf (stress-open-close)
[115.073900] Starting subtest: stress-open-close
[115.076441] Starting dynamic subtest: 0-rcs0
[117.239038] Dynamic subtest 0-rcs0: SUCCESS (2.165s)
[117.246391] Starting dynamic subtest: 1-vecs0
[119.403859] Dynamic subtest 1-vecs0: SUCCESS (2.164s)
[119.405856] Subtest stress-open-close: SUCCESS (4.330s)
[119.446950] [022/131] (898s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[119.543025] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[119.546674] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[119.665442] [023/131] (898s left) kms_addfb_basic (master-rmfb)
[119.724489] Starting subtest: master-rmfb
[119.726441] Subtest master-rmfb: SUCCESS (0.001s)
[119.863886] [024/131] (897s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[119.918337] Starting subtest: multi-wait-available-unsubmitted-signaled
[119.920166] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[120.033179] [025/131] (897s left) kms_vblank (ts-continuation-idle-hang)
[120.126113] Starting subtest: ts-continuation-idle-hang
[120.127851] Starting dynamic subtest: pipe-A-eDP-1
[146.708991] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.581s)
[146.723207] Starting dynamic subtest: pipe-D-eDP-1
[161.691703] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.978s)
[161.693998] Subtest ts-continuation-idle-hang: SUCCESS (41.564s)
[162.521247] [026/131] (855s left) kms_feature_discovery (chamelium)
[162.620747] Starting subtest: chamelium
[162.625218] Subtest chamelium: SKIP (0.000s)
[162.701353] [027/131] (855s left) kms_plane_cursor (primary)
[162.800645] Starting subtest: primary
[162.804724] Starting dynamic subtest: pipe-A-eDP-1-size-64
[165.566100] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.765s)
[165.591075] Starting dynamic subtest: pipe-A-eDP-1-size-128
[168.367885] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.782s)
[168.391143] Starting dynamic subtest: pipe-A-eDP-1-size-256
[171.147117] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.760s)
[171.470146] Starting dynamic subtest: pipe-B-eDP-1-size-64
[174.934281] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.475s)
[174.957307] Starting dynamic subtest: pipe-B-eDP-1-size-128
[177.669497] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.716s)
[177.692391] Starting dynamic subtest: pipe-B-eDP-1-size-256
[180.391887] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.704s)
[180.709249] Starting dynamic subtest: pipe-C-eDP-1-size-64
[183.690943] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.993s)
[183.715179] Starting dynamic subtest: pipe-C-eDP-1-size-128
[186.112557] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.402s)
[186.138930] Starting dynamic subtest: pipe-C-eDP-1-size-256
[188.392450] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.258s)
[188.708049] Starting dynamic subtest: pipe-D-eDP-1-size-64
[191.678292] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.980s)
[191.710130] Starting dynamic subtest: pipe-D-eDP-1-size-128
[194.012076] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.311s)
[194.037572] Starting dynamic subtest: pipe-D-eDP-1-size-256
[196.312579] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.279s)
[196.622444] Subtest primary: SUCCESS (33.820s)
[197.428812] [028/131] (820s left) gem_exec_params (secure-non-root)
[197.491143] Starting subtest: secure-non-root
[197.495524] Subtest secure-non-root: SKIP (0.000s)
[197.615397] [029/131] (820s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[197.709409] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[197.711708] Starting dynamic subtest: pipe-A-eDP-1
[197.768097] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[197.775414] Starting dynamic subtest: pipe-B-eDP-1
[197.833194] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[197.842239] Starting dynamic subtest: pipe-C-eDP-1
[197.900863] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[197.910733] Starting dynamic subtest: pipe-D-eDP-1
[197.967490] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[197.971670] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[199.912060] [030/131] (818s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[204.951365] Starting subtest: fbc-psr2-cursor-plane-update-sf
[204.953266] Starting dynamic subtest: pipe-A-eDP-1
[205.759810] Dynamic subtest pipe-A-eDP-1: SKIP (0.805s)
[205.767592] Starting dynamic subtest: pipe-B-eDP-1
[206.882971] Dynamic subtest pipe-B-eDP-1: SKIP (1.123s)
[206.887424] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.932s)
[208.077448] [031/131] (809s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[208.187683] Starting subtest: yf-tiled-16bpp-rotate-0
[208.192075] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[208.321323] [032/131] (809s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[208.417835] Starting subtest: 4-tiled-64bpp-rotate-0
[209.992337] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.576s)
[210.181216] [033/131] (807s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[210.302824] Starting subtest: short-flip-before-cursor-atomic-transitions
[211.258959] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.953s)
[212.106376] [034/131] (806s left) api_intel_bb (delta-check)
[212.155389] Starting subtest: delta-check
[212.158811] Subtest delta-check: SUCCESS (0.006s)
[212.315022] [035/131] (805s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[212.421088] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[212.425659] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[212.553575] [036/131] (805s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[212.652172] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[212.654400] Starting dynamic subtest: pipe-A-default-mode
[212.946189] Dynamic subtest pipe-A-default-mode: SKIP (0.292s)
[212.950878] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.293s)
[213.737909] [037/131] (804s left) gem_softpin (evict-prime-sanity-check)
[213.792585] Starting subtest: evict-prime-sanity-check
[213.794875] Starting dynamic subtest: rcs0
[214.949947] Dynamic subtest rcs0: SUCCESS (1.157s)
[214.959893] Starting dynamic subtest: bcs0
[216.080818] Dynamic subtest bcs0: SUCCESS (1.129s)
[216.090870] Starting dynamic subtest: vcs0
[217.949032] Dynamic subtest vcs0: SUCCESS (1.865s)
[217.959628] Starting dynamic subtest: vcs1
[219.904339] Dynamic subtest vcs1: SUCCESS (1.953s)
[219.914808] Starting dynamic subtest: vecs0
[221.908373] Dynamic subtest vecs0: SUCCESS (2.001s)
[221.918756] Starting dynamic subtest: ccs0
[223.045107] Dynamic subtest ccs0: SUCCESS (1.136s)
[223.055464] Starting dynamic subtest: all
[224.204735] Dynamic subtest all: SUCCESS (1.155s)
[224.207401] Subtest evict-prime-sanity-check: SUCCESS (10.411s)
[224.294353] [038/131] (793s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[224.361962] Subtest writes-after-reads-snoop: SKIP (0.000s)
[224.432187] [039/131] (793s left) kms_psr (fbc-psr2-primary-page-flip)
[224.535493] Starting subtest: fbc-psr2-primary-page-flip
[224.537874] Starting dynamic subtest: eDP-1
[224.542192] Dynamic subtest eDP-1: SKIP (0.000s)
[224.546564] Subtest fbc-psr2-primary-page-flip: SKIP (0.002s)
[224.633582] [040/131] (793s left) kms_cursor_crc (cursor-random-128x42)
[224.871903] Starting subtest: cursor-random-128x42
[224.916700] Subtest cursor-random-128x42: SKIP (0.040s)
[225.162047] [041/131] (793s left) gem_set_tiling_vs_gtt
[225.291825] [042/131] (793s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[225.390998] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[225.393342] Starting dynamic subtest: pipe-A-eDP-1
[225.416174] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[225.426139] Starting dynamic subtest: pipe-B-eDP-1
[225.447612] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[225.454890] Starting dynamic subtest: pipe-C-eDP-1
[225.476466] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[225.483627] Starting dynamic subtest: pipe-D-eDP-1
[225.505464] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[225.509841] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[227.718972] [043/131] (790s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[232.773104] Starting subtest: pr-overlay-plane-move-continuous-sf
[232.777998] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.003s)
[233.635851] [044/131] (784s left) kms_fbcon_fbt (psr-suspend)
[233.701575] Starting subtest: psr-suspend
[283.287812] Subtest psr-suspend: SUCCESS (19.787s)
[283.356629] [045/131] (735s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[283.490019] Starting subtest: cursorA-vs-flipA-toggle
[294.618379] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.123s)
[295.513815] [046/131] (723s left) i915_pm_rpm (system-suspend)
[297.051959] Starting subtest: system-suspend
[315.081812] Subtest system-suspend: SUCCESS (2.875s)
[315.464363] [047/131] (703s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[315.572165] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[315.576552] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[315.679421] [048/131] (702s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[315.787411] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[315.792139] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[315.916876] [049/131] (702s left) perf_pmu (busy)
[315.958876] Starting subtest: busy
[315.961324] Starting dynamic subtest: rcs0
[316.551643] Dynamic subtest rcs0: SUCCESS (0.594s)
[316.563922] Starting dynamic subtest: bcs0
[317.123639] Dynamic subtest bcs0: SUCCESS (0.569s)
[317.135236] Starting dynamic subtest: vcs0
[318.820453] Dynamic subtest vcs0: SUCCESS (1.692s)
[318.831945] Starting dynamic subtest: vcs1
[320.869723] Dynamic subtest vcs1: SUCCESS (2.044s)
[320.881693] Starting dynamic subtest: vecs0
[322.853930] Dynamic subtest vecs0: SUCCESS (1.980s)
[322.866563] Starting dynamic subtest: ccs0
[323.417793] Dynamic subtest ccs0: SUCCESS (0.562s)
[323.420523] Subtest busy: SUCCESS (7.458s)
[323.525166] [050/131] (695s left) kms_psr (psr2-sprite-plane-onoff)
[323.623371] Starting subtest: psr2-sprite-plane-onoff
[323.625917] Starting dynamic subtest: eDP-1
[325.404638] Dynamic subtest eDP-1: SUCCESS (1.781s)
[325.407311] Subtest psr2-sprite-plane-onoff: SUCCESS (1.783s)
[326.261182] [051/131] (692s left) kms_chamelium_frames (dp-frame-dump)
[326.650533] Subtest dp-frame-dump: SKIP (0.000s)
[327.455090] [052/131] (691s left) syncobj_wait (multi-wait-for-submit-submitted)
[327.507157] Starting subtest: multi-wait-for-submit-submitted
[327.608616] Subtest multi-wait-for-submit-submitted: SUCCESS (0.103s)
[327.697032] [053/131] (691s left) kms_properties (invalid-properties-atomic)
[327.788486] Starting subtest: invalid-properties-atomic
[328.043525] Subtest invalid-properties-atomic: SUCCESS (0.256s)
[328.127406] [054/131] (690s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[328.234347] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[328.238629] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[328.349898] [055/131] (690s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[328.440639] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[332.886641] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.449s)
[334.083894] [056/131] (684s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[334.191466] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[334.196451] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[334.296023] [057/131] (684s left) kms_busy (extended-modeset-hang-newfb)
[334.401627] Starting subtest: extended-modeset-hang-newfb
[334.404457] Starting dynamic subtest: pipe-A
[368.746177] Dynamic subtest pipe-A: SUCCESS (34.335s)
[368.756277] Starting dynamic subtest: pipe-D
[391.696785] Dynamic subtest pipe-D: SUCCESS (22.942s)
[391.699339] Subtest extended-modeset-hang-newfb: SUCCESS (57.283s)
[392.508100] [058/131] (626s left) gem_exec_fence (basic-wait)
[392.688041] Starting subtest: basic-wait
[392.690504] Starting dynamic subtest: rcs0
[392.773114] Dynamic subtest rcs0: SUCCESS (0.085s)
[392.784650] Starting dynamic subtest: bcs0
[392.830937] Dynamic subtest bcs0: SUCCESS (0.055s)
[392.842792] Starting dynamic subtest: vcs0
[392.897787] Dynamic subtest vcs0: SUCCESS (0.064s)
[392.908766] Starting dynamic subtest: vcs1
[392.957755] Dynamic subtest vcs1: SUCCESS (0.058s)
[392.969635] Starting dynamic subtest: vecs0
[393.024449] Dynamic subtest vecs0: SUCCESS (0.065s)
[393.035155] Starting dynamic subtest: ccs0
[393.093036] Dynamic subtest ccs0: SUCCESS (0.066s)
[393.096124] Subtest basic-wait: SUCCESS (0.407s)
[394.938319] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[394.942792] [059/131] (624s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[395.050737] Starting subtest: x-tiled-8bpp-rotate-0
[396.254938] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.204s)
[396.411384] [060/131] (622s left) kms_invalid_mode (int-max-clock)
[396.509061] Starting subtest: int-max-clock
[396.511090] Starting dynamic subtest: pipe-A-eDP-1
[396.795812] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[396.806368] Starting dynamic subtest: pipe-B-eDP-1
[396.808503] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[396.817472] Starting dynamic subtest: pipe-C-eDP-1
[396.819905] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[396.828283] Starting dynamic subtest: pipe-D-eDP-1
[396.830610] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[396.833120] Subtest int-max-clock: SUCCESS (0.291s)
[397.642093] [061/131] (621s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[397.729636] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[397.732120] Starting dynamic subtest: pipe-A-eDP-1
[397.756291] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[397.766927] Starting dynamic subtest: pipe-B-eDP-1
[397.792739] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[397.812632] Starting dynamic subtest: pipe-C-eDP-1
[397.839916] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[397.859772] Starting dynamic subtest: pipe-D-eDP-1
[397.887073] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[397.892611] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[399.916496] [062/131] (619s left) gem_exec_whisper (basic-sync)
[399.976318] Starting subtest: basic-sync
[406.337617] Subtest basic-sync: SUCCESS (6.358s)
[406.527122] [063/131] (612s left) gem_mmap_wc (copy)
[406.585119] Subtest copy: SKIP (0.000s)
[406.659908] [064/131] (612s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[406.763406] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[406.775418] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[406.889999] [065/131] (612s left) perf (invalid-oa-metric-set-id)
[406.987167] Starting subtest: invalid-oa-metric-set-id
[406.996750] Subtest invalid-oa-metric-set-id: SUCCESS (0.009s)
[407.045155] [066/131] (612s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[407.138358] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[407.141098] Starting dynamic subtest: pipe-A-default-mode
[407.428497] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[407.434066] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.287s)
[408.269122] [067/131] (611s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[408.371302] Starting subtest: plane-upscale-20x20-with-pixel-format
[408.373836] Starting dynamic subtest: pipe-A
[409.419012] Dynamic subtest pipe-A: SUCCESS (1.050s)
[409.428117] Starting dynamic subtest: pipe-B
[411.541264] Dynamic subtest pipe-B: SUCCESS (2.123s)
[411.550037] Starting dynamic subtest: pipe-C
[412.742555] Dynamic subtest pipe-C: SUCCESS (1.201s)
[412.751533] Starting dynamic subtest: pipe-D
[413.887285] Dynamic subtest pipe-D: SUCCESS (1.144s)
[413.889879] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.521s)
[415.079784] [068/131] (604s left) kms_flip (modeset-vs-vblank-race)
[415.181135] Starting subtest: modeset-vs-vblank-race
[415.183602] Starting dynamic subtest: A-eDP1
[419.919996] Dynamic subtest A-eDP1: SUCCESS (4.743s)
[419.931252] Starting dynamic subtest: B-eDP1
[424.666817] Dynamic subtest B-eDP1: SUCCESS (4.747s)
[424.678628] Starting dynamic subtest: C-eDP1
[429.273890] Dynamic subtest C-eDP1: SUCCESS (4.607s)
[429.284931] Starting dynamic subtest: D-eDP1
[433.764102] Dynamic subtest D-eDP1: SUCCESS (4.490s)
[433.766585] Subtest modeset-vs-vblank-race: SUCCESS (18.595s)
[435.026847] [069/131] (584s left) vgem_basic (dmabuf-fence-before)
[435.093619] Starting subtest: dmabuf-fence-before
[435.096342] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[435.163022] [070/131] (584s left) kms_plane_alpha_blend (constant-alpha-max)
[435.258226] Starting subtest: constant-alpha-max
[435.546794] Starting dynamic subtest: pipe-A-eDP-1
[436.483523] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.936s)
[436.493616] Starting dynamic subtest: pipe-D-eDP-1
[438.121886] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.636s)
[438.124367] Subtest constant-alpha-max: SUCCESS (2.866s)
[439.004158] [071/131] (580s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[439.104630] Starting subtest: psr-2p-primscrn-spr-indfb-move
[439.110616] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[439.227443] [072/131] (580s left) kms_pm_rpm (modeset-stress-extra-wait)
[441.064059] Starting subtest: modeset-stress-extra-wait
[495.335882] Subtest modeset-stress-extra-wait: SUCCESS (54.269s)
[495.449693] [073/131] (524s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[495.539127] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[502.931783] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.394s)
[503.051916] [074/131] (516s left) kms_psr (fbc-psr-sprite-plane-onoff)
[503.150410] Starting subtest: fbc-psr-sprite-plane-onoff
[503.152554] Starting dynamic subtest: eDP-1
[503.157401] Dynamic subtest eDP-1: SKIP (0.000s)
[503.162112] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[503.246486] [075/131] (516s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[503.355777] Starting subtest: fbcpsr-indfb-scaledprimary
[509.106643] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.753s)
[509.287823] [076/131] (510s left) gem_mmap_gtt (isolation)
[509.354185] Subtest isolation: SKIP (0.000s)
[509.424317] [077/131] (510s left) perf_pmu (idle)
[509.463917] Starting subtest: idle
[509.466226] Starting dynamic subtest: rcs0
[510.032997] Dynamic subtest rcs0: SUCCESS (0.570s)
[510.045215] Starting dynamic subtest: bcs0
[510.548796] Dynamic subtest bcs0: SUCCESS (0.513s)
[510.560502] Starting dynamic subtest: vcs0
[511.080733] Dynamic subtest vcs0: SUCCESS (0.528s)
[511.093315] Starting dynamic subtest: vcs1
[511.602674] Dynamic subtest vcs1: SUCCESS (0.519s)
[511.612434] Starting dynamic subtest: vecs0
[512.126190] Dynamic subtest vecs0: SUCCESS (0.520s)
[512.136383] Starting dynamic subtest: ccs0
[512.649510] Dynamic subtest ccs0: SUCCESS (0.521s)
[512.652620] Subtest idle: SUCCESS (3.189s)
[512.764118] [078/131] (507s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[512.875667] Starting subtest: y-tiled-64bpp-rotate-90
[512.881178] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[512.997285] [079/131] (506s left) kms_psr (fbc-pr-sprite-render)
[513.088887] Starting subtest: fbc-pr-sprite-render
[513.093433] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[513.161037] [080/131] (506s left) kms_cursor_legacy (single-move)
[513.273385] Starting subtest: single-move
[513.275443] Starting dynamic subtest: pipe-A
[518.656209] Dynamic subtest pipe-A: SUCCESS (5.380s)
[518.667165] Starting dynamic subtest: pipe-B
[524.040117] Dynamic subtest pipe-B: SUCCESS (5.380s)
[524.050355] Starting dynamic subtest: pipe-C
[529.423229] Dynamic subtest pipe-C: SUCCESS (5.379s)
[529.434456] Starting dynamic subtest: pipe-D
[534.806633] Dynamic subtest pipe-D: SUCCESS (5.378s)
[534.817921] Starting dynamic subtest: all-pipes
[540.193602] Dynamic subtest all-pipes: SUCCESS (5.386s)
[540.195975] Subtest single-move: SUCCESS (26.917s)
[540.367873] [081/131] (479s left) kms_tv_load_detect (load-detect)
[540.427280] Subtest load-detect: SKIP (0.000s)
[540.490244] [082/131] (479s left) gem_exec_schedule (preempt)
[540.557546] Starting subtest: preempt
[540.560279] Starting dynamic subtest: rcs0
[540.571291] Dynamic subtest rcs0: SUCCESS (0.024s)
[540.580966] Starting dynamic subtest: bcs0
[540.591482] Dynamic subtest bcs0: SUCCESS (0.019s)
[540.602412] Starting dynamic subtest: vcs0
[540.611448] Dynamic subtest vcs0: SUCCESS (0.019s)
[540.621184] Starting dynamic subtest: vcs1
[540.632848] Dynamic subtest vcs1: SUCCESS (0.021s)
[540.642595] Starting dynamic subtest: vecs0
[540.653644] Dynamic subtest vecs0: SUCCESS (0.019s)
[540.662928] Starting dynamic subtest: ccs0
[540.676450] Dynamic subtest ccs0: SUCCESS (0.023s)
[540.679446] Subtest preempt: SUCCESS (0.130s)
[541.957516] [083/131] (478s left) gem_exec_whisper (basic-forked-all)
[542.013289] Starting subtest: basic-forked-all
[555.817320] Subtest basic-forked-all: SUCCESS (13.801s)
[556.014671] [084/131] (464s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[556.118200] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[563.470387] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.354s)
[563.605119] [085/131] (456s left) i915_drm_fdinfo (busy-idle-check-all)
[563.652382] Starting subtest: busy-idle-check-all
[563.655101] Starting dynamic subtest: rcs0
[563.660339] Dynamic subtest rcs0: SKIP (0.004s)
[563.670509] Starting dynamic subtest: bcs0
[563.675517] Dynamic subtest bcs0: SKIP (0.000s)
[563.685158] Starting dynamic subtest: vcs0
[563.689427] Dynamic subtest vcs0: SKIP (0.000s)
[563.698290] Starting dynamic subtest: vcs1
[563.702657] Dynamic subtest vcs1: SKIP (0.000s)
[563.711415] Starting dynamic subtest: vecs0
[563.716440] Dynamic subtest vecs0: SKIP (0.000s)
[563.725197] Starting dynamic subtest: ccs0
[563.729814] Dynamic subtest ccs0: SKIP (0.000s)
[563.734307] Subtest busy-idle-check-all: SKIP (0.009s)
[563.772828] [086/131] (456s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[563.924870] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[563.929879] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[564.049413] [087/131] (456s left) gem_ctx_persistence (heartbeat-many)
[564.103474] Starting subtest: heartbeat-many
[564.108466] Subtest heartbeat-many: SKIP (0.000s)
[564.225882] [088/131] (456s left) i915_query (test-query-geometry-subslices)
[564.277130] Starting subtest: test-query-geometry-subslices
[564.279895] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[564.388837] [089/131] (455s left) gem_ctx_shared (q-promotion)
[564.455801] Starting subtest: Q-promotion
[564.458198] Starting dynamic subtest: rcs0
[564.572963] Dynamic subtest rcs0: SUCCESS (0.115s)
[564.589708] Starting dynamic subtest: vcs0
[564.660011] Dynamic subtest vcs0: SUCCESS (0.087s)
[564.676921] Starting dynamic subtest: vcs1
[564.740174] Dynamic subtest vcs1: SUCCESS (0.079s)
[564.758473] Starting dynamic subtest: vecs0
[564.822122] Dynamic subtest vecs0: SUCCESS (0.079s)
[564.837686] Starting dynamic subtest: ccs0
[564.899817] Dynamic subtest ccs0: SUCCESS (0.078s)
[564.902311] Subtest Q-promotion: SUCCESS (0.444s)
[565.951853] [090/131] (454s left) kms_chamelium_audio (dp-audio-edid)
[566.359845] Subtest dp-audio-edid: SKIP (0.000s)
[567.179041] [091/131] (453s left) gem_eio (in-flight-immediate)
[567.416561] Starting subtest: in-flight-immediate
[575.858464] Subtest in-flight-immediate: SUCCESS (8.441s)
[576.003056] [092/131] (444s left) perf_pmu (interrupts)
[576.046024] Starting subtest: interrupts
[577.117505] Subtest interrupts: SUCCESS (1.072s)
[577.253899] [093/131] (443s left) drm_read (short-buffer-wakeup)
[577.402240] Starting subtest: short-buffer-wakeup
[609.619044] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[609.776853] [094/131] (410s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[609.840522] Starting subtest: yf-tiled-to-vebox-y-tiled
[609.845562] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[610.037223] [095/131] (410s left) kms_color (legacy-gamma)
[610.146224] Starting subtest: legacy-gamma
[610.148620] Starting dynamic subtest: pipe-A-eDP-1
[610.834747] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.688s)
[610.846945] Starting dynamic subtest: pipe-B-eDP-1
[612.255644] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.420s)
[612.265447] Starting dynamic subtest: pipe-C-eDP-1
[613.651371] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.394s)
[613.661642] Starting dynamic subtest: pipe-D-eDP-1
[614.977152] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s)
[614.979637] Subtest legacy-gamma: SUCCESS (4.831s)
[615.812083] [096/131] (404s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[615.921410] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[616.867133] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.946s)
[617.037204] [097/131] (403s left) kms_pm_dc (dc9-dpms)
[618.138331] Starting subtest: dc9-dpms
[619.575270] Subtest dc9-dpms: SUCCESS (1.436s)
[619.652974] [098/131] (401s left) gem_exec_fence (keep-in-fence)
[619.834810] Starting subtest: keep-in-fence
[619.837304] Starting dynamic subtest: rcs0
[619.916351] Dynamic subtest rcs0: SUCCESS (0.081s)
[619.928859] Starting dynamic subtest: bcs0
[619.971248] Dynamic subtest bcs0: SUCCESS (0.053s)
[619.982294] Starting dynamic subtest: vcs0
[621.862485] Dynamic subtest vcs0: SUCCESS (1.887s)
[621.874617] Starting dynamic subtest: vcs1
[623.846073] Dynamic subtest vcs1: SUCCESS (1.981s)
[623.858504] Starting dynamic subtest: vecs0
[625.830173] Dynamic subtest vecs0: SUCCESS (1.981s)
[625.842504] Starting dynamic subtest: ccs0
[626.068239] Dynamic subtest ccs0: SUCCESS (0.237s)
[626.070913] Subtest keep-in-fence: SUCCESS (6.234s)
[627.992012] [099/131] (392s left) gem_exec_schedule (fifo)
[628.062414] Starting subtest: fifo
[628.064604] Starting dynamic subtest: rcs0
[628.219055] Dynamic subtest rcs0: SUCCESS (0.168s)
[628.231930] Starting dynamic subtest: vcs0
[628.332008] Dynamic subtest vcs0: SUCCESS (0.111s)
[628.342481] Starting dynamic subtest: vcs1
[628.441257] Dynamic subtest vcs1: SUCCESS (0.108s)
[628.453654] Starting dynamic subtest: vecs0
[628.545338] Dynamic subtest vecs0: SUCCESS (0.103s)
[628.555611] Starting dynamic subtest: ccs0
[628.681547] Dynamic subtest ccs0: SUCCESS (0.135s)
[628.684284] Subtest fifo: SUCCESS (0.632s)
[630.007218] [100/131] (390s left) kms_addfb_basic (bad-pitch-32)
[630.062619] Starting subtest: bad-pitch-32
[630.065073] Subtest bad-pitch-32: SUCCESS (0.000s)
[630.227108] [101/131] (390s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[630.316291] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[637.232253] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.918s)
[637.386705] [102/131] (383s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[637.770792] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[638.543943] [103/131] (382s left) kms_cursor_crc (cursor-size-hints)
[638.663452] Starting subtest: cursor-size-hints
[638.666159] Starting dynamic subtest: pipe-A-eDP-1
[639.270626] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.606s)
[639.280630] Starting dynamic subtest: pipe-D-eDP-1
[640.536141] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.265s)
[640.539475] Subtest cursor-size-hints: SUCCESS (1.873s)
[641.348037] [104/131] (379s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[641.440246] Starting subtest: plane-primary-overlay-mutable-zpos
[644.885402] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.443s)
[646.077098] [105/131] (374s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[646.179599] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[646.182222] Starting dynamic subtest: pipe-A
[646.407451] Dynamic subtest pipe-A: SUCCESS (0.230s)
[646.416944] Starting dynamic subtest: pipe-B
[647.743944] Dynamic subtest pipe-B: SUCCESS (1.336s)
[647.754157] Starting dynamic subtest: pipe-C
[649.080550] Dynamic subtest pipe-C: SUCCESS (1.335s)
[649.098244] Starting dynamic subtest: pipe-D
[650.410606] Dynamic subtest pipe-D: SUCCESS (1.329s)
[650.413281] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.234s)
[651.608905] [106/131] (369s left) gem_ctx_persistence (engines-mixed)
[651.667645] Starting subtest: engines-mixed
[651.670284] Starting dynamic subtest: rcs0
[651.749872] Dynamic subtest rcs0: SUCCESS (0.085s)
[651.761349] Starting dynamic subtest: bcs0
[651.811798] Dynamic subtest bcs0: SUCCESS (0.060s)
[651.824323] Starting dynamic subtest: vcs0
[651.878996] Dynamic subtest vcs0: SUCCESS (0.065s)
[651.890316] Starting dynamic subtest: vcs1
[651.953860] Dynamic subtest vcs1: SUCCESS (0.073s)
[651.966112] Starting dynamic subtest: vecs0
[652.025855] Dynamic subtest vecs0: SUCCESS (0.070s)
[652.038129] Starting dynamic subtest: ccs0
[652.092775] Dynamic subtest ccs0: SUCCESS (0.065s)
[652.095517] Subtest engines-mixed: SUCCESS (0.429s)
[652.196996] [107/131] (368s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[652.317067] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[683.517293] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.198s)
[684.333291] [108/131] (336s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[684.440170] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[688.594226] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.158s)
[689.739225] [109/131] (331s left) kms_cursor_crc (cursor-offscreen-max-size)
[690.078460] Starting subtest: cursor-offscreen-max-size
[690.085641] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[690.234809] [110/131] (331s left) gem_exec_params (no-vebox)
[690.291099] Starting subtest: no-vebox
[690.296351] Subtest no-vebox: SUCCESS (0.003s)
[691.981437] [111/131] (329s left) gem_wait (busy)
[692.043353] Starting subtest: busy
[692.046143] Starting dynamic subtest: all-engines
[693.860955] Dynamic subtest all-engines: SUCCESS (1.816s)
[693.874233] Starting dynamic subtest: rcs0
[694.405838] Dynamic subtest rcs0: SUCCESS (0.543s)
[694.416155] Starting dynamic subtest: bcs0
[694.949355] Dynamic subtest bcs0: SUCCESS (0.542s)
[694.959285] Starting dynamic subtest: vcs0
[696.869335] Dynamic subtest vcs0: SUCCESS (1.917s)
[696.881269] Starting dynamic subtest: vcs1
[698.852674] Dynamic subtest vcs1: SUCCESS (1.981s)
[698.864651] Starting dynamic subtest: vecs0
[700.837165] Dynamic subtest vecs0: SUCCESS (1.981s)
[700.849620] Starting dynamic subtest: ccs0
[701.379354] Dynamic subtest ccs0: SUCCESS (0.541s)
[701.382206] Subtest busy: SUCCESS (9.335s)
[701.599805] [112/131] (319s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[701.698294] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[701.700860] Starting dynamic subtest: pipe-A-eDP-1
[701.723792] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[701.734120] Starting dynamic subtest: pipe-B-eDP-1
[701.757320] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[701.767367] Starting dynamic subtest: pipe-C-eDP-1
[701.790174] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[701.801025] Starting dynamic subtest: pipe-D-eDP-1
[701.822136] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[701.824301] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.092s)
[704.072465] [113/131] (317s left) gem_ccs (block-multicopy-inplace)
[704.143309] Starting subtest: block-multicopy-inplace
[704.148856] Subtest block-multicopy-inplace: SKIP (0.000s)
[704.263018] [114/131] (317s left) gem_tiled_wb
[704.373463] [115/131] (317s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[704.486471] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[708.048563] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.566s)
[709.197691] [116/131] (312s left) prime_mmap (test_errors)
[709.265366] Starting subtest: test_errors
[709.267510] Starting dynamic subtest: test_errors-smem
[709.358399] Dynamic subtest test_errors-smem: SUCCESS (0.094s)
[709.361496] Subtest test_errors: SUCCESS (0.095s)
[709.464010] [117/131] (312s left) gen9_exec_parse (bb-chained)
[709.521073] Subtest bb-chained: SKIP (0.000s)
[709.606313] [118/131] (311s left) gem_eio (throttle)
[709.794466] Starting subtest: throttle
[710.055155] Subtest throttle: SUCCESS (0.262s)
[710.218138] [119/131] (311s left) gem_render_copy (linear-to-vebox-y-tiled)
[710.277113] Starting subtest: linear-to-vebox-y-tiled
[710.281155] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[710.483280] [120/131] (311s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[710.580290] Starting subtest: fbc-rgb565-draw-render
[714.775807] Subtest fbc-rgb565-draw-render: SUCCESS (4.199s)
[715.985500] [121/131] (305s left) gem_cs_tlb (engines)
[716.057627] Starting subtest: engines
[716.059783] Starting dynamic subtest: rcs0
[718.212852] Dynamic subtest rcs0: SUCCESS (2.152s)
[718.225463] Starting dynamic subtest: bcs0
[720.365805] Dynamic subtest bcs0: SUCCESS (2.153s)
[720.376459] Starting dynamic subtest: vcs0
[722.521319] Dynamic subtest vcs0: SUCCESS (2.154s)
[722.531301] Starting dynamic subtest: vcs1
[724.694294] Dynamic subtest vcs1: SUCCESS (2.154s)
[724.704364] Starting dynamic subtest: vecs0
[726.831313] Dynamic subtest vecs0: SUCCESS (2.153s)
[726.842625] Starting dynamic subtest: ccs0
[728.987453] Dynamic subtest ccs0: SUCCESS (2.154s)
[728.989998] Subtest engines: SUCCESS (12.925s)
[729.161313] [122/131] (292s left) syncobj_timeline (wait-zero-handles)
[729.222779] Starting subtest: wait-zero-handles
[729.225182] Subtest wait-zero-handles: SUCCESS (0.000s)
[729.360020] [123/131] (292s left) syncobj_timeline (invalid-transfer-bad-pad)
[729.427485] Starting subtest: invalid-transfer-bad-pad
[729.430213] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[729.563340] [124/131] (292s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[729.671322] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[736.531232] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.861s)
[736.692164] [125/131] (285s left) gem_exec_flush (basic-batch-kernel-default-wb)
[736.749651] Starting subtest: basic-batch-kernel-default-wb
[743.257659] Subtest basic-batch-kernel-default-wb: SUCCESS (6.508s)
[743.459289] [126/131] (278s left) kms_lease (lease-unleased-connector)
[743.571265] Starting subtest: lease-unleased-connector
[743.573745] Starting dynamic subtest: pipe-A-eDP-1
[743.575940] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[743.587506] Starting dynamic subtest: pipe-B-eDP-1
[743.589819] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[743.600257] Starting dynamic subtest: pipe-C-eDP-1
[743.602682] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[743.612597] Starting dynamic subtest: pipe-D-eDP-1
[743.614951] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[743.616860] Subtest lease-unleased-connector: SUCCESS (0.033s)
[743.742521] [127/131] (278s left) kms_psr (psr-sprite-mmap-gtt)
[743.835060] Starting subtest: psr-sprite-mmap-gtt
[743.837608] Starting dynamic subtest: eDP-1
[745.291809] Dynamic subtest eDP-1: SKIP (1.454s)
[745.297517] Subtest psr-sprite-mmap-gtt: SKIP (1.456s)
[745.486888] [128/131] (276s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[745.553265] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[745.657848] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.106s)
[745.754380] [129/131] (276s left) gem_media_fill (media-fill)
[745.811342] Subtest media-fill: SKIP (0.000s)
[745.942496] [130/131] (276s left) prime_mmap_kms (buffer-sharing)
[746.036503] Starting subtest: buffer-sharing
[746.496012] Subtest buffer-sharing: SUCCESS (0.463s)
[747.337388] [131/131] (274s left) gem_userptr_blits (create-destroy-unsync)
[747.408553] Subtest create-destroy-unsync: SKIP (0.000s)
[747.554134] Closing watchdogs
results: parsing output: 0/ for test: i915_hangman
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: kms_vblank
results: parsing output: 3/ for test: kms_cursor_legacy
results: parsing output: 4/ for test: gem_exec_flush
results: parsing output: 5/ for test: api_intel_allocator
results: parsing output: 6/ for test: gem_exec_balancer
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: perf
results: parsing output: 9/ for test: gem_linear_blits
results: parsing output: 10/ for test: gem_pxp
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: prime_mmap
results: parsing output: 13/ for test: gem_ctx_param
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: sw_sync
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: gem_mmap_gtt
results: parsing output: 20/ for test: perf
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_addfb_basic
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_vblank
results: parsing output: 25/ for test: kms_feature_discovery
results: parsing output: 26/ for test: kms_plane_cursor
results: parsing output: 27/ for test: gem_exec_params
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: kms_psr2_sf
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: api_intel_bb
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_flip_scaled_crc
results: parsing output: 36/ for test: gem_softpin
results: parsing output: 37/ for test: gem_partial_pwrite_pread
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: kms_cursor_crc
results: parsing output: 40/ for test: gem_set_tiling_vs_gtt
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_psr2_sf
results: parsing output: 43/ for test: kms_fbcon_fbt
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: i915_pm_rpm
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: perf_pmu
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_chamelium_frames
results: parsing output: 51/ for test: syncobj_wait
results: parsing output: 52/ for test: kms_properties
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_busy
results: parsing output: 57/ for test: gem_exec_fence
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_invalid_mode
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: gem_exec_whisper
results: parsing output: 62/ for test: gem_mmap_wc
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: perf
results: parsing output: 65/ for test: kms_flip_scaled_crc
results: parsing output: 66/ for test: kms_plane_scaling
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: vgem_basic
results: parsing output: 69/ for test: kms_plane_alpha_blend
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_pm_rpm
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_mmap_gtt
results: parsing output: 76/ for test: perf_pmu
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: kms_tv_load_detect
results: parsing output: 81/ for test: gem_exec_schedule
results: parsing output: 82/ for test: gem_exec_whisper
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: i915_drm_fdinfo
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_ctx_persistence
results: parsing output: 87/ for test: i915_query
results: parsing output: 88/ for test: gem_ctx_shared
results: parsing output: 89/ for test: kms_chamelium_audio
results: parsing output: 90/ for test: gem_eio
results: parsing output: 91/ for test: perf_pmu
results: parsing output: 92/ for test: drm_read
results: parsing output: 93/ for test: gem_render_copy
results: parsing output: 94/ for test: kms_color
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_pm_dc
results: parsing output: 97/ for test: gem_exec_fence
results: parsing output: 98/ for test: gem_exec_schedule
results: parsing output: 99/ for test: kms_addfb_basic
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_chamelium_hpd
results: parsing output: 102/ for test: kms_cursor_crc
results: parsing output: 103/ for test: kms_atomic
results: parsing output: 104/ for test: kms_plane_scaling
results: parsing output: 105/ for test: gem_ctx_persistence
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_cursor_crc
results: parsing output: 109/ for test: gem_exec_params
results: parsing output: 110/ for test: gem_wait
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: gem_ccs
results: parsing output: 113/ for test: gem_tiled_wb
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: prime_mmap
results: parsing output: 116/ for test: gen9_exec_parse
results: parsing output: 117/ for test: gem_eio
results: parsing output: 118/ for test: gem_render_copy
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_cs_tlb
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_exec_flush
results: parsing output: 125/ for test: kms_lease
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: gem_media_fill
results: parsing output: 129/ for test: prime_mmap_kms
results: parsing output: 130/ for test: gem_userptr_blits
Done.