[58.393877] Initializing watchdogs
[58.393924]   /dev/watchdog0
[58.408579] [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]
[58.413183] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.415479] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.418775] [001/131] (960s left) kms_pm_rpm (cursor-dpms)
[60.089534] Starting subtest: cursor-dpms
[60.094383] Subtest cursor-dpms: SKIP (0.000s)
[60.770847] [002/131] (958s left) gem_exec_async (forked-writes)
[60.833463] Starting subtest: forked-writes
[60.835817] Starting dynamic subtest: rcs0
[60.860751] Dynamic subtest rcs0: SUCCESS (0.027s)
[60.873125] Starting dynamic subtest: bcs0
[60.885705] Dynamic subtest bcs0: SUCCESS (0.024s)
[60.897965] Starting dynamic subtest: vcs0
[60.907142] Dynamic subtest vcs0: SUCCESS (0.022s)
[60.915961] Starting dynamic subtest: vcs1
[60.930334] Dynamic subtest vcs1: SUCCESS (0.023s)
[60.938635] Starting dynamic subtest: vecs0
[60.953513] Dynamic subtest vecs0: SUCCESS (0.023s)
[60.961613] Starting dynamic subtest: ccs0
[60.975079] Dynamic subtest ccs0: SUCCESS (0.021s)
[60.977473] Subtest forked-writes: SUCCESS (0.143s)
[61.242388] [003/131] (957s left) kms_cursor_crc (cursor-onscreen-512x512)
[61.502030] Starting subtest: cursor-onscreen-512x512
[61.506586] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[61.703532] [004/131] (957s left) perf_pmu (frequency)
[61.743877] Starting subtest: frequency
[61.748444] Starting dynamic subtest: gt0
[63.922424] Dynamic subtest gt0: SUCCESS (2.177s)
[63.930932] Starting dynamic subtest: idle-gt0
[64.427901] Dynamic subtest idle-gt0: SUCCESS (0.506s)
[64.438626] Starting dynamic subtest: gt1
[68.900512] Dynamic subtest gt1: SUCCESS (4.479s)
[68.910515] Starting dynamic subtest: idle-gt1
[69.404309] Dynamic subtest idle-gt1: SUCCESS (0.505s)
[69.406906] Subtest frequency: SUCCESS (7.679s)
[69.518586] [005/131] (949s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[69.617544] Starting subtest: plane-primary-toggle-with-vblank-wait
[69.620012] Starting dynamic subtest: pipe-A-eDP-1
[69.791322] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.175s)
[70.112175] Starting dynamic subtest: pipe-B-eDP-1
[71.027219] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.918s)
[71.320855] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.704s)
[72.196311] [006/131] (946s left) gem_ctx_persistence (legacy-engines-queued)
[72.257399] Starting subtest: legacy-engines-queued
[72.259702] Starting dynamic subtest: render
[72.359760] Dynamic subtest render: SUCCESS (0.102s)
[72.370910] Starting dynamic subtest: bsd1
[73.845850] Dynamic subtest bsd1: SUCCESS (1.484s)
[73.856779] Starting dynamic subtest: bsd2
[75.893102] Dynamic subtest bsd2: SUCCESS (2.047s)
[75.902171] Starting dynamic subtest: blt
[75.988012] Dynamic subtest blt: SUCCESS (0.094s)
[75.999359] Starting dynamic subtest: vebox
[77.877467] Dynamic subtest vebox: SUCCESS (1.887s)
[77.880381] Subtest legacy-engines-queued: SUCCESS (5.623s)
[77.977209] [007/131] (941s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[78.088079] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[78.090437] Starting dynamic subtest: pipe-A-eDP-1
[78.147390] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[78.156699] Starting dynamic subtest: pipe-B-eDP-1
[78.211787] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[78.220701] Starting dynamic subtest: pipe-C-eDP-1
[78.274755] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[78.282779] Starting dynamic subtest: pipe-D-eDP-1
[78.340368] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[78.344575] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.008s)
[80.270583] [008/131] (938s left) kms_content_protection (lic-type-1)
[80.415608] Starting subtest: lic-type-1
[80.420125] Subtest lic-type-1: SKIP (0.000s)
[80.582335] [009/131] (938s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[80.688516] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[80.692714] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[80.797903] [010/131] (938s left) kms_display_modes (extended-mode-basic)
[80.890291] Starting subtest: extended-mode-basic
[80.894715] Subtest extended-mode-basic: SKIP (0.000s)
[80.936676] [011/131] (938s left) gem_exec_schedule (u-lateslice)
[81.013735] Starting subtest: u-lateslice
[81.016117] Starting dynamic subtest: rcs0
[81.029259] Dynamic subtest rcs0: SUCCESS (0.027s)
[81.037447] Starting dynamic subtest: bcs0
[81.046826] Dynamic subtest bcs0: SUCCESS (0.017s)
[81.055057] Starting dynamic subtest: vcs0
[81.065655] Dynamic subtest vcs0: SUCCESS (0.018s)
[81.073845] Starting dynamic subtest: vcs1
[81.083858] Dynamic subtest vcs1: SUCCESS (0.018s)
[81.092073] Starting dynamic subtest: vecs0
[81.101432] Dynamic subtest vecs0: SUCCESS (0.017s)
[81.109393] Starting dynamic subtest: ccs0
[81.117687] Dynamic subtest ccs0: SUCCESS (0.016s)
[81.120138] Subtest u-lateslice: SUCCESS (0.115s)
[83.034412] [012/131] (936s left) kms_flip_event_leak (basic)
[83.136225] Starting subtest: basic
[83.138385] Starting dynamic subtest: pipe-A-eDP-1
[83.567829] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.432s)
[83.578342] Starting dynamic subtest: pipe-B-eDP-1
[84.667474] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.100s)
[84.679976] Starting dynamic subtest: pipe-C-eDP-1
[85.788990] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.119s)
[85.798043] Starting dynamic subtest: pipe-D-eDP-1
[86.909909] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.122s)
[86.912220] Subtest basic: SUCCESS (3.776s)
[87.796307] [013/131] (931s left) gem_ccs (block-copy-compressed)
[87.866821] Starting subtest: block-copy-compressed
[87.872021] Subtest block-copy-compressed: SKIP (0.000s)
[87.993471] [014/131] (931s left) kms_getfb (getfb2-handle-protection)
[88.093810] Starting subtest: getfb2-handle-protection
[88.122574] Subtest getfb2-handle-protection: SUCCESS (0.029s)
[88.248769] [015/131] (931s left) gem_exec_fence (invalid-timeline-fence-array)
[88.791494] Starting subtest: invalid-timeline-fence-array
[88.793985] Subtest invalid-timeline-fence-array: SUCCESS (0.006s)
[90.002667] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[90.005798] [016/131] (929s left) kms_psr (fbc-psr-primary-mmap-gtt)
[90.095203] Starting subtest: fbc-psr-primary-mmap-gtt
[90.097098] Starting dynamic subtest: eDP-1
[90.101168] Dynamic subtest eDP-1: SKIP (0.000s)
[90.105180] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s)
[90.189557] [017/131] (929s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[90.287952] Starting subtest: fbc-psr2-cursor-mmap-gtt
[90.290252] Starting dynamic subtest: eDP-1
[90.294210] Dynamic subtest eDP-1: SKIP (0.000s)
[90.298208] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[90.382894] [018/131] (929s left) syncobj_wait (wait-any-interrupted)
[90.438691] Starting subtest: wait-any-interrupted
[90.542036] Subtest wait-any-interrupted: SUCCESS (0.101s)
[90.640802] [019/131] (928s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[90.740414] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[90.742782] Starting dynamic subtest: pipe-A-eDP-1
[90.766337] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[90.777045] Starting dynamic subtest: pipe-B-eDP-1
[90.798791] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[90.807090] Starting dynamic subtest: pipe-C-eDP-1
[90.828868] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[90.837109] Starting dynamic subtest: pipe-D-eDP-1
[90.859194] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[90.863240] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[93.052913] [020/131] (926s left) gem_eio (unwedge-stress)
[93.267920] Starting subtest: unwedge-stress
[93.275105] Starting dynamic subtest: render
[98.037674] Dynamic subtest render: SUCCESS (4.767s)
[98.053673] Starting dynamic subtest: bsd1
[116.381571] Dynamic subtest bsd1: SUCCESS (18.343s)
[116.397351] Starting dynamic subtest: bsd2
[134.431614] Dynamic subtest bsd2: SUCCESS (18.050s)
[134.447504] Starting dynamic subtest: blt
[134.451939] Dynamic subtest blt: SKIP (0.000s)
[134.461073] Starting dynamic subtest: vebox
[152.389612] Dynamic subtest vebox: SUCCESS (17.956s)
[152.391747] Subtest unwedge-stress: SUCCESS (59.118s)
[153.946471] [021/131] (865s left) perf_pmu (busy-hang)
[153.992684] Starting subtest: busy-hang
[153.994845] Starting dynamic subtest: rcs0
[155.290244] Dynamic subtest rcs0: SUCCESS (1.299s)
[155.299585] Starting dynamic subtest: bcs0
[156.512881] Dynamic subtest bcs0: SUCCESS (1.222s)
[156.521935] Starting dynamic subtest: vcs0
[158.429070] Dynamic subtest vcs0: SUCCESS (1.915s)
[158.440511] Starting dynamic subtest: vcs1
[160.409507] Dynamic subtest vcs1: SUCCESS (1.977s)
[160.420621] Starting dynamic subtest: vecs0
[162.390458] Dynamic subtest vecs0: SUCCESS (1.982s)
[162.401704] Starting dynamic subtest: ccs0
[163.611294] Dynamic subtest ccs0: SUCCESS (1.220s)
[163.613843] Subtest busy-hang: SUCCESS (9.620s)
[163.738226] [022/131] (856s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[163.792077] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[163.794495] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[163.929832] [023/131] (855s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[164.043096] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[164.045591] Starting dynamic subtest: pipe-A-default-mode
[164.338351] Dynamic subtest pipe-A-default-mode: SKIP (0.293s)
[164.343178] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.295s)
[165.181759] [024/131] (854s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[165.301390] Starting subtest: cursor-vs-flip-legacy
[194.849370] Subtest cursor-vs-flip-legacy: SUCCESS (29.547s)
[195.717470] [025/131] (824s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[195.824830] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[202.863072] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.042s)
[203.012168] [026/131] (816s left) syncobj_basic (bad-handle-to-fd)
[203.069178] Starting subtest: bad-handle-to-fd
[203.071135] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[203.205068] [027/131] (816s left) kms_content_protection (srm)
[203.358573] Starting subtest: srm
[203.364788] Subtest srm: SKIP (0.004s)
[203.520984] [028/131] (816s left) kms_properties (get_properties-sanity-atomic)
[203.618170] Starting subtest: get_properties-sanity-atomic
[203.622801] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[203.715011] [029/131] (816s left) gem_request_retire (retire-vma-not-inactive)
[203.775507] Starting subtest: retire-vma-not-inactive
[203.833966] Subtest retire-vma-not-inactive: SUCCESS (0.057s)
[203.994668] [030/131] (816s left) kms_rotation_crc (primary-rotation-180)
[204.092926] Starting subtest: primary-rotation-180
[211.191550] Subtest primary-rotation-180: SUCCESS (7.099s)
[212.489826] [031/131] (807s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[212.590073] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[212.592139] Starting dynamic subtest: pipe-A-eDP-1
[229.070343] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.149s)
[229.081259] Starting dynamic subtest: pipe-B-eDP-1
[246.018778] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.401s)
[246.032298] Starting dynamic subtest: pipe-C-eDP-1
[262.986415] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.359s)
[262.996893] Starting dynamic subtest: pipe-D-eDP-1
[280.002669] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.407s)
[280.005123] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (12.321s)
[281.236030] [032/131] (738s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[281.315902] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[281.380758] [033/131] (738s left) gem_shrink (reclaim)
[281.438474] Starting subtest: reclaim
[283.898482] Subtest reclaim: SUCCESS (2.505s)
[284.059726] [034/131] (736s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[284.131032] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[284.236927] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.107s)
[284.346231] [035/131] (735s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[284.447145] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[284.451746] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[284.564123] [036/131] (735s left) kms_dsc (dsc-fractional-bpp)
[284.669906] Starting subtest: dsc-fractional-bpp
[284.682524] Subtest dsc-fractional-bpp: SKIP (0.000s)
[284.770369] [037/131] (735s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[284.911895] Starting subtest: cursorB-vs-flipB-atomic
[284.916309] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[285.079429] [038/131] (735s left) prime_vgem (fence-flip-hang)
[285.162883] Subtest fence-flip-hang: SKIP (0.000s)
[285.305173] [039/131] (735s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[285.396340] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[292.588042] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.254s)
[292.761608] [040/131] (727s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[292.869285] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[292.871531] Starting dynamic subtest: pipe-A
[292.891710] Dynamic subtest pipe-A: SKIP (0.019s)
[292.902083] Starting dynamic subtest: pipe-B
[292.925766] Dynamic subtest pipe-B: SKIP (0.033s)
[292.935732] Starting dynamic subtest: pipe-C
[292.957204] Dynamic subtest pipe-C: SKIP (0.033s)
[292.967090] Starting dynamic subtest: pipe-D
[292.989994] Dynamic subtest pipe-D: SKIP (0.032s)
[292.994140] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.119s)
[293.128624] [041/131] (727s left) gem_mmap (pf-nonblock)
[293.196432] Subtest pf-nonblock: SKIP (0.000s)
[293.267555] [042/131] (727s left) kms_plane_multiple (tiling-y)
[293.359674] Starting subtest: tiling-y
[293.363612] Subtest tiling-y: SKIP (0.000s)
[293.458443] [043/131] (727s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[293.571459] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[293.575085] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[293.696697] [044/131] (726s left) kms_async_flips (alternate-sync-async-flip-atomic)
[293.795305] Starting subtest: alternate-sync-async-flip-atomic
[294.166718] Starting dynamic subtest: pipe-A-eDP-1
[296.918340] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.762s)
[297.298131] Starting dynamic subtest: pipe-B-eDP-1
[300.048169] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.766s)
[300.437170] Starting dynamic subtest: pipe-C-eDP-1
[303.176172] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.754s)
[303.545119] Starting dynamic subtest: pipe-D-eDP-1
[306.307042] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.779s)
[306.309401] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.545s)
[307.502374] [045/131] (713s left) perf (polling)
[307.650343] Starting subtest: polling
[307.652243] Starting dynamic subtest: 0-rcs0
[317.664070] Dynamic subtest 0-rcs0: SUCCESS (10.012s)
[317.674673] Starting dynamic subtest: 1-vcs1
[327.686072] Dynamic subtest 1-vcs1: SUCCESS (10.020s)
[327.688628] Subtest polling: SUCCESS (20.035s)
[327.736140] [046/131] (693s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[327.847569] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[334.648232] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.805s)
[334.811771] [047/131] (685s left) gem_exec_schedule (preempt-engines)
[334.887770] Starting subtest: preempt-engines
[334.889766] Starting dynamic subtest: rcs0
[337.123588] Dynamic subtest rcs0: SUCCESS (2.239s)
[337.135104] Starting dynamic subtest: bcs0
[339.359459] Dynamic subtest bcs0: SUCCESS (2.233s)
[339.376145] Starting dynamic subtest: vcs0
[341.601981] Dynamic subtest vcs0: SUCCESS (2.242s)
[341.614423] Starting dynamic subtest: vcs1
[343.874337] Dynamic subtest vcs1: SUCCESS (2.271s)
[343.894353] Starting dynamic subtest: vecs0
[346.128652] Dynamic subtest vecs0: SUCCESS (2.252s)
[346.144620] Starting dynamic subtest: ccs0
[348.410805] Dynamic subtest ccs0: SUCCESS (2.281s)
[348.413658] Subtest preempt-engines: SUCCESS (13.530s)
[348.750450] [048/131] (672s left) gem_create (create-valid-nonaligned)
[348.813500] Starting subtest: create-valid-nonaligned
[348.815707] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[349.028783] [049/131] (671s left) gem_spin_batch (spin-all)
[349.091368] Starting subtest: spin-all
[349.111816] Subtest spin-all: SUCCESS (0.020s)
[351.201634] [050/131] (669s left) kms_addfb_basic (tile-pitch-mismatch)
[351.260554] Starting subtest: tile-pitch-mismatch
[351.264865] Subtest tile-pitch-mismatch: SKIP (0.000s)
[351.443094] [051/131] (669s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[351.506712] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[351.509176] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[351.637568] [052/131] (669s left) gem_mmap_gtt (basic-write-gtt)
[351.699134] Subtest basic-write-gtt: SKIP (0.000s)
[351.768388] [053/131] (669s left) kms_sequence (queue-idle)
[351.864727] Starting subtest: queue-idle
[351.866879] Starting dynamic subtest: pipe-A-eDP-1
[353.675251] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.812s)
[353.685928] Starting dynamic subtest: pipe-B-eDP-1
[356.159093] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.482s)
[356.170079] Starting dynamic subtest: pipe-C-eDP-1
[358.577921] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.417s)
[358.588032] Starting dynamic subtest: pipe-D-eDP-1
[360.989647] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.411s)
[360.991762] Subtest queue-idle: SUCCESS (9.127s)
[361.827323] [054/131] (659s left) kms_psr (psr2-primary-mmap-gtt)
[361.929066] Starting subtest: psr2-primary-mmap-gtt
[361.931296] Starting dynamic subtest: eDP-1
[363.396104] Dynamic subtest eDP-1: SKIP (1.465s)
[363.400596] Subtest psr2-primary-mmap-gtt: SKIP (1.467s)
[363.550877] [055/131] (657s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[363.664721] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[364.444766] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.781s)
[364.678715] [056/131] (656s left) gem_ctx_bad_destroy (double-destroy)
[364.746029] Starting subtest: double-destroy
[364.748514] Subtest double-destroy: SUCCESS (0.000s)
[364.848607] [057/131] (656s left) gem_ctx_persistence (engines-hostile)
[364.919510] Starting subtest: engines-hostile
[364.921771] Starting dynamic subtest: rcs0
[365.097909] Dynamic subtest rcs0: SUCCESS (0.181s)
[365.110843] Starting dynamic subtest: bcs0
[365.219469] Dynamic subtest bcs0: SUCCESS (0.119s)
[365.231487] Starting dynamic subtest: vcs0
[365.339518] Dynamic subtest vcs0: SUCCESS (0.118s)
[365.352036] Starting dynamic subtest: vcs1
[365.457431] Dynamic subtest vcs1: SUCCESS (0.116s)
[365.469661] Starting dynamic subtest: vecs0
[365.576497] Dynamic subtest vecs0: SUCCESS (0.117s)
[365.589065] Starting dynamic subtest: ccs0
[365.703576] Dynamic subtest ccs0: SUCCESS (0.125s)
[365.705856] Subtest engines-hostile: SUCCESS (0.789s)
[365.805845] [058/131] (655s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[365.906057] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[365.909943] Starting dynamic subtest: A-eDP1
[374.773482] Dynamic subtest A-eDP1: SUCCESS (8.868s)
[374.785559] Starting dynamic subtest: B-eDP1
[383.712086] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[383.723238] Starting dynamic subtest: C-eDP1
[392.640748] Dynamic subtest C-eDP1: SUCCESS (8.924s)
[392.652506] Starting dynamic subtest: D-eDP1
[401.561317] Dynamic subtest D-eDP1: SUCCESS (8.918s)
[401.563570] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.652s)
[402.813316] [059/131] (618s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[402.922157] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[402.926573] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[404.040288] [060/131] (617s left) kms_plane_alpha_blend (alpha-transparent-fb)
[404.145092] Starting subtest: alpha-transparent-fb
[404.438249] Starting dynamic subtest: pipe-A-eDP-1
[405.026677] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.588s)
[405.037618] Starting dynamic subtest: pipe-D-eDP-1
[406.365952] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.337s)
[406.368122] Subtest alpha-transparent-fb: SUCCESS (2.219s)
[407.221704] [061/131] (614s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[407.343423] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[407.351668] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[407.473371] [062/131] (613s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[412.440619] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[412.442556] Starting dynamic subtest: pipe-A-eDP-1
[413.238590] Dynamic subtest pipe-A-eDP-1: SKIP (0.796s)
[413.248873] Starting dynamic subtest: pipe-B-eDP-1
[414.369864] Dynamic subtest pipe-B-eDP-1: SKIP (1.128s)
[414.374509] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.928s)
[415.583774] [063/131] (605s left) kms_prop_blob (invalid-set-prop)
[415.648599] Starting subtest: invalid-set-prop
[415.650543] Subtest invalid-set-prop: SUCCESS (0.000s)
[415.780560] [064/131] (605s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[415.881478] Starting subtest: fbcpsr-rgb565-draw-pwrite
[422.873235] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (6.995s)
[423.034416] [065/131] (598s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[423.143028] Starting subtest: random-ccs-data-yf-tiled-ccs
[423.145210] Starting dynamic subtest: pipe-A-eDP-1
[423.169973] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[423.185040] Starting dynamic subtest: pipe-B-eDP-1
[423.209465] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[423.221394] Starting dynamic subtest: pipe-C-eDP-1
[423.245171] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[423.258728] Starting dynamic subtest: pipe-D-eDP-1
[423.285574] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[423.289946] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.008s)
[425.480537] [066/131] (596s left) i915_query (engine-info-invalid)
[425.545459] Starting subtest: engine-info-invalid
[425.547886] Subtest engine-info-invalid: SUCCESS (0.000s)
[425.668849] [067/131] (596s left) kms_atomic_interruptible (legacy-dpms)
[425.771922] Starting subtest: legacy-dpms
[425.774213] Starting dynamic subtest: pipe-A-eDP-1
[433.166508] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.396s)
[433.168805] Subtest legacy-dpms: SUCCESS (7.397s)
[434.024265] [068/131] (587s left) kms_big_fb (linear-64bpp-rotate-90)
[434.134617] Starting subtest: linear-64bpp-rotate-90
[434.154034] Subtest linear-64bpp-rotate-90: SKIP (0.019s)
[434.291240] [069/131] (587s left) gem_exec_whisper (basic-fds-forked-all)
[434.357659] Starting subtest: basic-fds-forked-all
[454.396396] Subtest basic-fds-forked-all: SUCCESS (20.039s)
[454.603691] [070/131] (567s left) syncobj_wait (invalid-signal-zero-handles)
[454.667459] Starting subtest: invalid-signal-zero-handles
[454.669909] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[454.817875] [071/131] (567s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[454.921156] Starting subtest: primary-x-tiled-reflect-x-180
[462.066200] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.148s)
[463.289468] [072/131] (558s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[463.391025] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[463.393257] Starting dynamic subtest: pipe-A
[463.411399] Dynamic subtest pipe-A: SKIP (0.018s)
[463.425714] Starting dynamic subtest: pipe-B
[463.445777] Dynamic subtest pipe-B: SKIP (0.032s)
[463.457194] Starting dynamic subtest: pipe-C
[463.480071] Dynamic subtest pipe-C: SKIP (0.032s)
[463.490305] Starting dynamic subtest: pipe-D
[463.512943] Dynamic subtest pipe-D: SKIP (0.032s)
[463.516678] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.119s)
[463.656801] [073/131] (558s left) syncobj_basic (illegal-fd-to-handle)
[463.716336] Starting subtest: illegal-fd-to-handle
[463.718274] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[463.837446] [074/131] (558s left) i915_drm_fdinfo (isolation)
[463.883952] Starting subtest: isolation
[463.886469] Starting dynamic subtest: rcs0
[463.925613] Dynamic subtest rcs0: SKIP (0.038s)
[463.945714] Starting dynamic subtest: bcs0
[463.950171] Dynamic subtest bcs0: SKIP (0.001s)
[463.960559] Starting dynamic subtest: vcs0
[463.965057] Dynamic subtest vcs0: SKIP (0.001s)
[463.975044] Starting dynamic subtest: vcs1
[463.979833] Dynamic subtest vcs1: SKIP (0.000s)
[463.989949] Starting dynamic subtest: vecs0
[463.994551] Dynamic subtest vecs0: SKIP (0.000s)
[464.004525] Starting dynamic subtest: ccs0
[464.009291] Dynamic subtest ccs0: SKIP (0.000s)
[464.014030] Subtest isolation: SKIP (0.048s)
[464.054113] [075/131] (557s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[466.285704] Starting subtest: modeset-non-lpsp-stress-no-wait
[466.352425] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.064s)
[466.699039] [076/131] (555s left) kms_psr (pr-cursor-plane-move)
[466.786832] Starting subtest: pr-cursor-plane-move
[466.791174] Subtest pr-cursor-plane-move: SKIP (0.000s)
[466.885531] [077/131] (555s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[466.976363] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[466.980374] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[467.098364] [078/131] (555s left) kms_psr (fbc-pr-cursor-render)
[467.198862] Starting subtest: fbc-pr-cursor-render
[467.203325] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[467.304083] [079/131] (554s left) gem_exec_reloc (basic-cpu-read-noreloc)
[467.371166] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[467.463374] [080/131] (554s left) i915_drm_fdinfo (virtual-idle)
[467.500814] Starting subtest: virtual-idle
[470.572923] Subtest virtual-idle: SUCCESS (3.072s)
[470.676732] [081/131] (551s left) i915_pm_rpm (gem-pread)
[472.299952] Starting subtest: gem-pread
[474.559891] Subtest gem-pread: SUCCESS (2.258s)
[474.663804] [082/131] (547s left) gem_linear_blits (interruptible)
[475.206800] Starting subtest: interruptible
[479.502280] Subtest interruptible: SUCCESS (4.296s)
[479.670141] [083/131] (542s left) kms_atomic_transition (modeset-transition)
[479.830731] Starting subtest: modeset-transition
[479.832587] Starting dynamic subtest: 1x-outputs
[490.709725] Dynamic subtest 1x-outputs: SUCCESS (10.883s)
[490.712170] Subtest modeset-transition: SUCCESS (10.884s)
[491.594123] [084/131] (530s left) kms_cursor_crc (cursor-suspend)
[491.756728] Starting subtest: cursor-suspend
[491.758564] Starting dynamic subtest: pipe-A-eDP-1
[525.328470] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.159s)
[525.345370] Starting dynamic subtest: pipe-D-eDP-1
[559.284482] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.781s)
[559.287129] Subtest cursor-suspend: SUCCESS (6.942s)
[560.126127] [085/131] (462s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[560.242894] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[560.247961] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[560.366335] [086/131] (462s left) kms_frontbuffer_tracking (fbc-2p-rte)
[560.466579] Starting subtest: fbc-2p-rte
[560.471694] Subtest fbc-2p-rte: SKIP (0.000s)
[560.599737] [087/131] (461s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[560.731199] Starting subtest: verify-pxp-execution-after-suspend-resume
[567.813875] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.178s)
[567.990509] [088/131] (454s left) gem_exec_balancer (parallel-ordering)
[568.263203] Starting subtest: parallel-ordering
[569.203843] Subtest parallel-ordering: SUCCESS (0.943s)
[569.363115] [089/131] (453s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[569.471192] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[569.476235] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[569.586506] [090/131] (453s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[569.687317] Starting subtest: x-tiled-64bpp-rotate-270
[569.707574] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[569.861717] [091/131] (452s left) tools_test (sysfs_l3_parity)
[569.913065] Starting subtest: sysfs_l3_parity
[569.968319] Subtest sysfs_l3_parity: SKIP (0.067s)
[570.046648] [092/131] (452s left) perf (blocking)
[570.181463] Starting subtest: blocking
[570.184135] Starting dynamic subtest: 0-rcs0
[580.200708] Dynamic subtest 0-rcs0: SUCCESS (10.041s)
[580.212665] Starting dynamic subtest: 1-vecs0
[590.211357] Dynamic subtest 1-vecs0: SUCCESS (10.023s)
[590.214309] Subtest blocking: SUCCESS (20.067s)
[590.263629] [093/131] (432s left) gem_exec_suspend (basic)
[590.342209] Starting subtest: basic
[590.345094] Starting dynamic subtest: smem
[591.837822] Dynamic subtest smem: SUCCESS (1.496s)
[591.840914] Subtest basic: SUCCESS (1.498s)
[592.049553] [094/131] (430s left) gem_mmap_offset (partial-mmap)
[592.118842] Starting subtest: partial-mmap
[592.121190] Starting dynamic subtest: smem0
[592.123848] Dynamic subtest smem0: SUCCESS (0.006s)
[592.126334] Subtest partial-mmap: SUCCESS (0.007s)
[592.272700] [095/131] (430s left) kms_hdr (bpc-switch-suspend)
[592.393840] Starting subtest: bpc-switch-suspend
[593.491427] Starting dynamic subtest: pipe-A-eDP-1
[612.953150] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.589s)
[612.956143] Subtest bpc-switch-suspend: SUCCESS (5.690s)
[613.111586] [096/131] (409s left) gem_mmap (bad-object)
[613.184631] Subtest bad-object: SKIP (0.000s)
[613.250570] [097/131] (409s left) syncobj_timeline (invalid-transfer-bad-pad)
[613.322790] Starting subtest: invalid-transfer-bad-pad
[613.325070] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[613.440957] [098/131] (409s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[613.544933] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[613.550077] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[613.684722] [099/131] (409s left) sysfs_heartbeat_interval (precise)
[613.742391] Starting subtest: precise
[613.744777] Starting dynamic subtest: vecs0
[621.706969] Dynamic subtest vecs0: SUCCESS (8.071s)
[621.721885] Starting dynamic subtest: ccs0
[622.856085] Dynamic subtest ccs0: SUCCESS (1.157s)
[622.870079] Starting dynamic subtest: vcs0
[630.756874] Dynamic subtest vcs0: SUCCESS (7.933s)
[630.770360] Starting dynamic subtest: bcs0
[631.939286] Dynamic subtest bcs0: SUCCESS (1.182s)
[631.952579] Starting dynamic subtest: rcs0
[633.089363] Dynamic subtest rcs0: SUCCESS (1.150s)
[633.103168] Starting dynamic subtest: vcs1
[640.743360] Dynamic subtest vcs1: SUCCESS (7.665s)
[640.746306] Subtest precise: SUCCESS (27.172s)
[640.853375] [100/131] (382s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[640.984222] Starting subtest: basic-flip-after-cursor-varying-size
[641.912291] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.931s)
[642.778836] [101/131] (380s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[642.870849] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[648.048840] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.182s)
[649.277070] [102/131] (373s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[649.345173] Starting subtest: y-tiled-ccs-to-y-tiled
[649.351080] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[649.557002] [103/131] (373s left) gem_vm_create (isolation)
[649.623274] Starting subtest: isolation
[649.630428] Subtest isolation: SUCCESS (0.009s)
[649.801911] [104/131] (373s left) syncobj_wait (invalid-wait-bad-flags)
[649.865127] Starting subtest: invalid-wait-bad-flags
[649.868025] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[650.005514] [105/131] (373s left) gem_ctx_shared (q-promotion)
[650.072863] Starting subtest: Q-promotion
[650.075364] Starting dynamic subtest: rcs0
[650.185293] Dynamic subtest rcs0: SUCCESS (0.111s)
[650.197052] Starting dynamic subtest: vcs0
[650.278585] Dynamic subtest vcs0: SUCCESS (0.093s)
[650.296031] Starting dynamic subtest: vcs1
[650.357823] Dynamic subtest vcs1: SUCCESS (0.078s)
[650.375285] Starting dynamic subtest: vecs0
[650.429176] Dynamic subtest vecs0: SUCCESS (0.070s)
[650.446389] Starting dynamic subtest: ccs0
[650.510230] Dynamic subtest ccs0: SUCCESS (0.080s)
[650.513240] Subtest Q-promotion: SUCCESS (0.437s)
[651.858825] [106/131] (371s left) syncobj_timeline (single-wait-available-signaled)
[651.930636] Starting subtest: single-wait-available-signaled
[651.933253] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[652.062746] [107/131] (371s left) drm_buddy (drm_buddy)
[652.105076] Starting subtest: drm_buddy
[652.122189] Starting dynamic subtest: drm_test_buddy_alloc_limit
[652.242373] Dynamic subtest drm_test_buddy_alloc_limit: SUCCESS (0.121s)
[652.253650] Starting dynamic subtest: drm_test_buddy_alloc_optimistic
[652.387396] Dynamic subtest drm_test_buddy_alloc_optimistic: SUCCESS (0.143s)
[652.398403] Starting dynamic subtest: drm_test_buddy_alloc_pessimistic
[652.515425] Dynamic subtest drm_test_buddy_alloc_pessimistic: SUCCESS (0.127s)
[652.526676] Starting dynamic subtest: drm_test_buddy_alloc_pathological
[652.631246] Dynamic subtest drm_test_buddy_alloc_pathological: SUCCESS (0.114s)
[652.642070] Starting dynamic subtest: drm_test_buddy_alloc_contiguous
[652.759096] Dynamic subtest drm_test_buddy_alloc_contiguous: SUCCESS (0.129s)
[652.771846] Starting dynamic subtest: drm_test_buddy_alloc_clear
[652.939216] Dynamic subtest drm_test_buddy_alloc_clear: SUCCESS (0.178s)
[652.951367] Starting dynamic subtest: drm_test_buddy_alloc_range_bias
[653.049653] Dynamic subtest drm_test_buddy_alloc_range_bias: SUCCESS (0.108s)
[653.060404] Starting dynamic subtest: drm_test_buddy_fragmentation_performance
[657.345578] Dynamic subtest drm_test_buddy_fragmentation_performance: SUCCESS (4.292s)
[657.348347] Subtest drm_buddy: SUCCESS (5.236s)
[657.525847] [108/131] (365s left) gem_workarounds (reset-context)
[657.598195] Starting subtest: reset-context
[657.785886] Subtest reset-context: SUCCESS (0.188s)
[657.963586] [109/131] (365s left) gem_exec_reloc (basic-wc-gtt-active)
[658.022042] Subtest basic-wc-gtt-active: SKIP (0.000s)
[658.109749] [110/131] (365s left) kms_vblank (wait-busy)
[658.210943] Starting subtest: wait-busy
[658.213266] Starting dynamic subtest: pipe-A-eDP-1
[660.091243] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.876s)
[660.109363] Starting dynamic subtest: pipe-D-eDP-1
[662.689369] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.598s)
[662.692352] Subtest wait-busy: SUCCESS (4.478s)
[663.517679] [111/131] (360s left) gen9_exec_parse (bb-oversize)
[663.582172] Subtest bb-oversize: SKIP (0.000s)
[663.667129] [112/131] (359s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[663.735169] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[663.738088] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[663.870341] [113/131] (359s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[663.969918] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[667.964815] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.000s)
[669.126990] [114/131] (354s left) prime_vgem (coherency-gtt)
[669.205091] Starting subtest: coherency-gtt
[669.210365] Subtest coherency-gtt: SKIP (0.000s)
[669.329768] [115/131] (354s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[669.718089] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[670.504285] [116/131] (353s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[670.608413] Starting subtest: y-tiled-64bpp-rotate-270
[670.614049] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[670.744745] [117/131] (353s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[670.842019] Starting subtest: psr-rgb101010-draw-mmap-cpu
[677.825759] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (6.987s)
[677.973424] [118/131] (345s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[678.031886] Starting subtest: y-tiled-to-vebox-y-tiled
[678.037015] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[678.242127] [119/131] (345s left) perf_pmu (semaphore-busy)
[678.283376] Starting subtest: semaphore-busy
[678.286042] Starting dynamic subtest: rcs0
[679.942133] Dynamic subtest rcs0: SUCCESS (1.657s)
[679.955537] Starting dynamic subtest: bcs0
[681.577189] Dynamic subtest bcs0: SUCCESS (1.632s)
[681.590142] Starting dynamic subtest: vcs0
[685.189237] Dynamic subtest vcs0: SUCCESS (3.610s)
[685.202394] Starting dynamic subtest: vcs1
[691.206299] Dynamic subtest vcs1: SUCCESS (6.015s)
[691.219364] Starting dynamic subtest: vecs0
[697.220932] Dynamic subtest vecs0: SUCCESS (6.013s)
[697.234112] Starting dynamic subtest: ccs0
[700.296152] Dynamic subtest ccs0: SUCCESS (3.073s)
[700.299047] Subtest semaphore-busy: SUCCESS (22.019s)
[700.462284] [120/131] (323s left) kms_flip (2x-flip-vs-fences)
[700.576575] Starting subtest: 2x-flip-vs-fences
[700.581375] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[700.725881] [121/131] (323s left) gem_exec_schedule (deep)
[700.908268] Starting subtest: deep
[700.911403] Starting dynamic subtest: rcs0
[706.434655] Dynamic subtest rcs0: SKIP (5.524s)
[706.454640] Starting dynamic subtest: vcs0
[718.094554] Dynamic subtest vcs0: SUCCESS (11.657s)
[718.108093] Starting dynamic subtest: vcs1
[730.416168] Dynamic subtest vcs1: SUCCESS (12.318s)
[730.429973] Starting dynamic subtest: vecs0
[742.380265] Dynamic subtest vecs0: SUCCESS (11.962s)
[742.394771] Starting dynamic subtest: ccs0
[755.248165] Dynamic subtest ccs0: SUCCESS (12.867s)
[755.251268] Subtest deep: SUCCESS (54.334s)
[757.274698] [122/131] (266s left) gem_create (hog-create)
[757.336233] Starting subtest: hog-create
[757.339253] Starting dynamic subtest: smem0
[789.706361] Dynamic subtest smem0: SUCCESS (32.373s)
[789.709495] Subtest hog-create: SUCCESS (32.375s)
[789.925796] [123/131] (234s left) api_intel_bb (object-reloc-purge-cache)
[789.979374] Starting subtest: object-reloc-purge-cache
[789.985221] Subtest object-reloc-purge-cache: SKIP (0.006s)
[790.109375] [124/131] (234s left) kms_lease (lease-unleased-crtc)
[790.213423] Starting subtest: lease-unleased-crtc
[790.216441] Starting dynamic subtest: pipe-A-eDP-1
[790.520630] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.305s)
[790.533220] Starting dynamic subtest: pipe-B-eDP-1
[791.269578] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.745s)
[791.282367] Starting dynamic subtest: pipe-C-eDP-1
[791.284891] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.005s)
[791.296468] Starting dynamic subtest: pipe-D-eDP-1
[791.299286] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[791.302256] Subtest lease-unleased-crtc: SUCCESS (1.073s)
[791.698354] [125/131] (232s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[791.809175] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[792.489150] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.681s)
[792.698250] [126/131] (231s left) kms_chamelium_frames (dp-crc-multiple)
[793.093132] Subtest dp-crc-multiple: SKIP (0.000s)
[793.880557] [127/131] (230s left) gem_partial_pwrite_pread (write)
[793.951404] Subtest write: SKIP (0.000s)
[794.031088] [128/131] (230s left) kms_psr (psr-primary-page-flip)
[794.130295] Starting subtest: psr-primary-page-flip
[794.133222] Starting dynamic subtest: eDP-1
[795.898067] Dynamic subtest eDP-1: SUCCESS (1.769s)
[795.900576] Subtest psr-primary-page-flip: SUCCESS (1.770s)
[796.778779] [129/131] (227s left) gem_exec_whisper (basic-queues-forked)
[796.850282] Starting subtest: basic-queues-forked
[819.533241] Subtest basic-queues-forked: SUCCESS (22.684s)
[819.744482] [130/131] (204s left) prime_vgem (sync)
[819.820929] Starting subtest: sync
[819.823771] Starting dynamic subtest: rcs0
[819.879376] Dynamic subtest rcs0: SUCCESS (0.058s)
[819.890906] Starting dynamic subtest: bcs0
[819.976439] Dynamic subtest bcs0: SUCCESS (0.096s)
[819.987395] Starting dynamic subtest: vcs0
[820.026131] Dynamic subtest vcs0: SUCCESS (0.048s)
[820.037484] Starting dynamic subtest: vcs1
[820.077133] Dynamic subtest vcs1: SUCCESS (0.050s)
[820.088193] Starting dynamic subtest: vecs0
[820.123827] Dynamic subtest vecs0: SUCCESS (0.046s)
[820.136152] Starting dynamic subtest: ccs0
[820.172420] Dynamic subtest ccs0: SUCCESS (0.048s)
[820.175432] Subtest sync: SUCCESS (0.353s)
[820.345757] [131/131] (204s left) kms_properties (crtc-properties-legacy)
[820.451110] Starting subtest: crtc-properties-legacy
[820.453201] Starting dynamic subtest: pipe-A-eDP-1
[820.890142] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.440s)
[820.902435] Starting dynamic subtest: pipe-B-eDP-1
[822.102187] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.211s)
[822.119025] Starting dynamic subtest: pipe-C-eDP-1
[823.228924] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.126s)
[823.241379] Starting dynamic subtest: pipe-D-eDP-1
[824.348123] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.118s)
[824.350652] Subtest crtc-properties-legacy: SUCCESS (3.901s)
[825.191113] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_rpm
results: parsing output: 1/ for test: gem_exec_async
results: parsing output: 2/ for test: kms_cursor_crc
results: parsing output: 3/ for test: perf_pmu
results: parsing output: 4/ for test: kms_atomic_transition
results: parsing output: 5/ for test: gem_ctx_persistence
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_content_protection
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_display_modes
results: parsing output: 10/ for test: gem_exec_schedule
results: parsing output: 11/ for test: kms_flip_event_leak
results: parsing output: 12/ for test: gem_ccs
results: parsing output: 13/ for test: kms_getfb
results: parsing output: 14/ for test: gem_exec_fence
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: syncobj_wait
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: gem_eio
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_flip_scaled_crc
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: syncobj_basic
results: parsing output: 26/ for test: kms_content_protection
results: parsing output: 27/ for test: kms_properties
results: parsing output: 28/ for test: gem_request_retire
results: parsing output: 29/ for test: kms_rotation_crc
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: gem_mmap_gtt
results: parsing output: 32/ for test: gem_shrink
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_dsc
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: prime_vgem
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_plane_scaling
results: parsing output: 40/ for test: gem_mmap
results: parsing output: 41/ for test: kms_plane_multiple
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: kms_async_flips
results: parsing output: 44/ for test: perf
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_exec_schedule
results: parsing output: 47/ for test: gem_create
results: parsing output: 48/ for test: gem_spin_batch
results: parsing output: 49/ for test: kms_addfb_basic
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: gem_mmap_gtt
results: parsing output: 52/ for test: kms_sequence
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: gem_ctx_bad_destroy
results: parsing output: 56/ for test: gem_ctx_persistence
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_plane_alpha_blend
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: kms_prop_blob
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: i915_query
results: parsing output: 66/ for test: kms_atomic_interruptible
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_exec_whisper
results: parsing output: 69/ for test: syncobj_wait
results: parsing output: 70/ for test: kms_rotation_crc
results: parsing output: 71/ for test: kms_plane_scaling
results: parsing output: 72/ for test: syncobj_basic
results: parsing output: 73/ for test: i915_drm_fdinfo
results: parsing output: 74/ for test: kms_pm_rpm
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: gem_exec_reloc
results: parsing output: 79/ for test: i915_drm_fdinfo
results: parsing output: 80/ for test: i915_pm_rpm
results: parsing output: 81/ for test: gem_linear_blits
results: parsing output: 82/ for test: kms_atomic_transition
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_pxp
results: parsing output: 87/ for test: gem_exec_balancer
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: tools_test
results: parsing output: 91/ for test: perf
results: parsing output: 92/ for test: gem_exec_suspend
results: parsing output: 93/ for test: gem_mmap_offset
results: parsing output: 94/ for test: kms_hdr
results: parsing output: 95/ for test: gem_mmap
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: sysfs_heartbeat_interval
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_render_copy
results: parsing output: 102/ for test: gem_vm_create
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: gem_ctx_shared
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: drm_buddy
results: parsing output: 107/ for test: gem_workarounds
results: parsing output: 108/ for test: gem_exec_reloc
results: parsing output: 109/ for test: kms_vblank
results: parsing output: 110/ for test: gen9_exec_parse
results: parsing output: 111/ for test: syncobj_wait
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: prime_vgem
results: parsing output: 114/ for test: kms_chamelium_hpd
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_render_copy
results: parsing output: 118/ for test: perf_pmu
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: gem_exec_schedule
results: parsing output: 121/ for test: gem_create
results: parsing output: 122/ for test: api_intel_bb
results: parsing output: 123/ for test: kms_lease
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_chamelium_frames
results: parsing output: 126/ for test: gem_partial_pwrite_pread
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: gem_exec_whisper
results: parsing output: 129/ for test: prime_vgem
results: parsing output: 130/ for test: kms_properties
Done.