[57.029742] Initializing watchdogs
[57.029788]   /dev/watchdog0
[57.060682] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.065587] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.067798] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.071543] [001/133] (960s left) gem_mmap_offset (partial-unmap)
[57.146600] Starting subtest: partial-unmap
[57.148527] Starting dynamic subtest: smem0
[57.649642] Dynamic subtest smem0: SUCCESS (0.507s)
[57.652430] Subtest partial-unmap: SUCCESS (0.508s)
[57.761901] [002/133] (959s left) kms_cursor_crc (cursor-dpms)
[57.897680] Starting subtest: cursor-dpms
[57.900098] Starting dynamic subtest: pipe-A-eDP-1
[60.952142] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.074s)
[60.960514] Starting dynamic subtest: pipe-D-eDP-1
[64.633179] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.698s)
[64.635564] Subtest cursor-dpms: SUCCESS (6.775s)
[65.467530] [003/133] (952s left) dmabuf_sync_file (export-wait-after-attach)
[65.558490] Starting subtest: export-wait-after-attach
[65.560698] Subtest export-wait-after-attach: SUCCESS (0.001s)
[65.623916] [FACT dmabuf_sync_file (export-wait-after-attach)] new: kernel.kmod_is_loaded.vgem: true
[65.627656] [004/133] (952s left) kms_color_pipeline (plane-lut1d-lut1d)
[65.722084] Starting subtest: plane-lut1d-lut1d
[65.855879] Starting dynamic subtest: pipe-A-plane-0
[66.203857] Dynamic subtest pipe-A-plane-0: FAIL (0.173s)
[66.210858] Starting dynamic subtest: pipe-A-plane-1
[66.421061] Dynamic subtest pipe-A-plane-1: FAIL (0.179s)
[66.431218] Starting dynamic subtest: pipe-A-plane-2
[66.631326] Dynamic subtest pipe-A-plane-2: FAIL (0.178s)
[67.577427] Starting dynamic subtest: pipe-B-plane-0
[68.012881] Dynamic subtest pipe-B-plane-0: FAIL (0.164s)
[68.021912] Starting dynamic subtest: pipe-B-plane-1
[68.337423] Dynamic subtest pipe-B-plane-1: FAIL (0.181s)
[68.345015] Starting dynamic subtest: pipe-B-plane-2
[68.647729] Dynamic subtest pipe-B-plane-2: FAIL (0.173s)
[69.294858] Starting dynamic subtest: pipe-C-plane-0
[69.789468] Dynamic subtest pipe-C-plane-0: FAIL (0.129s)
[69.799058] Starting dynamic subtest: pipe-C-plane-1
[70.190195] Dynamic subtest pipe-C-plane-1: FAIL (0.617s)
[70.197939] Starting dynamic subtest: pipe-C-plane-2
[70.552598] Dynamic subtest pipe-C-plane-2: FAIL (0.156s)
[71.468354] Starting dynamic subtest: pipe-D-plane-0
[72.086726] Dynamic subtest pipe-D-plane-0: FAIL (0.163s)
[72.094291] Starting dynamic subtest: pipe-D-plane-1
[72.544075] Dynamic subtest pipe-D-plane-1: FAIL (0.615s)
[72.552640] Starting dynamic subtest: pipe-D-plane-2
[73.001143] Dynamic subtest pipe-D-plane-2: FAIL (0.557s)
[73.090111] Subtest plane-lut1d-lut1d: FAIL (7.384s)
[73.882064] [005/133] (943s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[73.988034] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[73.990595] Starting dynamic subtest: pipe-A
[74.049616] Dynamic subtest pipe-A: SUCCESS (0.064s)
[74.056472] Starting dynamic subtest: pipe-B
[75.198688] Dynamic subtest pipe-B: SUCCESS (1.149s)
[75.208582] Starting dynamic subtest: pipe-C
[76.311044] Dynamic subtest pipe-C: SUCCESS (1.112s)
[76.317985] Starting dynamic subtest: pipe-D
[77.433358] Dynamic subtest pipe-D: SUCCESS (1.123s)
[77.435678] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.452s)
[78.597356] [006/133] (939s left) syncobj_wait (wait-delayed-signal)
[78.652191] Starting subtest: wait-delayed-signal
[78.756327] Subtest wait-delayed-signal: SUCCESS (0.103s)
[78.857986] [007/133] (938s left) kms_chamelium_hpd (dp-hpd-storm)
[79.242086] Subtest dp-hpd-storm: SKIP (0.000s)
[80.018225] [008/133] (937s left) gem_exec_flush (basic-uc-set-default)
[80.087072] Starting subtest: basic-uc-set-default
[85.541728] Subtest basic-uc-set-default: SUCCESS (5.453s)
[85.728097] [009/133] (932s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[85.830158] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[89.857360] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.031s)
[91.084131] [010/133] (926s left) i915_pm_rc6_residency (rc6-fence)
[91.148040] Starting subtest: rc6-fence
[91.175790] Starting dynamic subtest: gt0
[103.498504] Dynamic subtest gt0: SUCCESS (12.320s)
[103.509439] Starting dynamic subtest: gt1
[117.908083] Dynamic subtest gt1: SUCCESS (14.406s)
[117.911055] Subtest rc6-fence: SUCCESS (26.759s)
[117.987961] [011/133] (900s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[118.097922] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[118.101865] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[118.192247] [012/133] (899s left) kms_rotation_crc (bad-tiling)
[118.280276] Starting subtest: bad-tiling
[118.284732] Subtest bad-tiling: SKIP (0.001s)
[118.355586] [013/133] (899s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[118.463633] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[126.106698] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.644s)
[126.219013] [014/133] (891s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[126.317628] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[126.321695] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[126.422279] [015/133] (891s left) gem_ctx_persistence (process)
[126.475769] Starting subtest: process
[126.678119] Subtest process: SUCCESS (0.204s)
[126.754926] [016/133] (891s left) perf (low-oa-exponent-permissions)
[126.878000] Starting subtest: low-oa-exponent-permissions
[126.909359] Subtest low-oa-exponent-permissions: SUCCESS (0.033s)
[126.959876] [017/133] (891s left) gem_ctx_param (invalid-get-ringsize)
[127.012815] Starting subtest: invalid-get-ringsize
[127.015064] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[127.116838] [018/133] (891s left) kms_lease (page-flip-implicit-plane)
[127.194987] Starting subtest: page-flip-implicit-plane
[127.196866] Starting dynamic subtest: pipe-A-eDP-1
[127.691376] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.493s)
[127.699601] Starting dynamic subtest: pipe-B-eDP-1
[128.844483] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.154s)
[128.853609] Starting dynamic subtest: pipe-C-eDP-1
[129.949881] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.101s)
[129.959151] Starting dynamic subtest: pipe-D-eDP-1
[131.070995] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.122s)
[131.073221] Subtest page-flip-implicit-plane: SUCCESS (3.875s)
[131.918960] [019/133] (886s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[132.025052] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[132.029309] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[132.126974] [020/133] (886s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[132.237163] Starting subtest: x-tiled-8bpp-rotate-90
[132.259268] Subtest x-tiled-8bpp-rotate-90: SKIP (0.022s)
[132.371303] [021/133] (886s left) gem_exec_schedule (u-submit-late-slice)
[132.450503] Starting subtest: u-submit-late-slice
[132.452941] Starting dynamic subtest: rcs0
[132.477496] Dynamic subtest rcs0: SUCCESS (0.036s)
[132.488248] Starting dynamic subtest: bcs0
[132.504528] Dynamic subtest bcs0: SUCCESS (0.027s)
[132.512586] Starting dynamic subtest: vcs0
[132.538985] Dynamic subtest vcs0: SUCCESS (0.033s)
[132.549728] Starting dynamic subtest: vcs1
[132.567074] Dynamic subtest vcs1: SUCCESS (0.028s)
[132.575185] Starting dynamic subtest: vecs0
[132.601073] Dynamic subtest vecs0: SUCCESS (0.034s)
[132.609860] Starting dynamic subtest: ccs0
[132.633774] Dynamic subtest ccs0: SUCCESS (0.032s)
[132.635912] Subtest u-submit-late-slice: SUCCESS (0.193s)
[134.003323] [022/133] (884s left) gem_pxp (create-protected-buffer)
[134.121355] Starting subtest: create-protected-buffer
[134.123696] Subtest create-protected-buffer: SUCCESS (0.000s)
[134.226462] [023/133] (884s left) gem_exec_balancer (noheartbeat)
[134.484096] Starting subtest: noheartbeat
[134.488823] Subtest noheartbeat: SKIP (0.000s)
[134.573917] [024/133] (883s left) kms_plane_multiple (2x-tiling-yf)
[134.662114] Starting subtest: 2x-tiling-yf
[134.666526] Subtest 2x-tiling-yf: SKIP (0.000s)
[134.767281] [025/133] (883s left) kms_psr (fbc-psr-cursor-plane-onoff)
[134.871097] Starting subtest: fbc-psr-cursor-plane-onoff
[134.873374] Starting dynamic subtest: eDP-1
[134.877687] Dynamic subtest eDP-1: SKIP (0.000s)
[134.882024] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[134.942322] [026/133] (883s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[135.006942] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[135.011287] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[135.187672] [027/133] (883s left) kms_plane (pixel-format-x-tiled-modifier)
[135.283329] Starting subtest: pixel-format-x-tiled-modifier
[135.308893] Starting dynamic subtest: pipe-A-plane-0
[135.942816] Dynamic subtest pipe-A-plane-0: SUCCESS (0.633s)
[135.953440] Starting dynamic subtest: pipe-A-plane-3
[136.364187] Dynamic subtest pipe-A-plane-3: SUCCESS (0.420s)
[136.371679] Starting dynamic subtest: pipe-A-plane-5
[136.375342] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[137.509696] Starting dynamic subtest: pipe-B-plane-0
[138.126163] Dynamic subtest pipe-B-plane-0: SUCCESS (0.622s)
[138.134809] Starting dynamic subtest: pipe-B-plane-3
[138.580914] Dynamic subtest pipe-B-plane-3: SUCCESS (0.454s)
[138.588421] Starting dynamic subtest: pipe-B-plane-5
[138.591839] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[138.895886] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.613s)
[139.694228] [028/133] (879s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[139.802831] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[147.278075] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.478s)
[147.438847] [029/133] (871s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[147.529726] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[147.531971] Starting dynamic subtest: pipe-A-eDP-1
[147.553686] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[147.563076] Starting dynamic subtest: pipe-B-eDP-1
[147.584729] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[147.592051] Starting dynamic subtest: pipe-C-eDP-1
[147.613126] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[147.620344] Starting dynamic subtest: pipe-D-eDP-1
[147.643040] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[147.647287] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s)
[149.774480] [030/133] (869s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[149.866281] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[149.868449] Starting dynamic subtest: pipe-A-eDP-1
[149.954596] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[149.964349] Starting dynamic subtest: pipe-B-eDP-1
[151.156342] Dynamic subtest pipe-B-eDP-1: SKIP (1.200s)
[151.161121] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.290s)
[152.342686] [031/133] (866s left) perf (polling)
[152.442753] Starting subtest: polling
[152.445177] Starting dynamic subtest: 0-rcs0
[162.454097] Dynamic subtest 0-rcs0: SUCCESS (10.009s)
[162.463087] Starting dynamic subtest: 1-vcs1
[172.477829] Dynamic subtest 1-vcs1: SUCCESS (10.022s)
[172.480295] Subtest polling: SUCCESS (20.033s)
[172.525676] [032/133] (846s left) gem_softpin (allocator-fork)
[172.592549] Starting subtest: allocator-fork
[174.804787] Subtest allocator-fork: SUCCESS (2.210s)
[174.959014] [033/133] (843s left) kms_rotation_crc (primary-rotation-90)
[175.068936] Starting subtest: primary-rotation-90
[175.073318] Subtest primary-rotation-90: SKIP (0.001s)
[175.138649] [034/133] (843s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[175.234488] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[175.238626] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[175.315418] [035/133] (843s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[175.407083] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[175.411150] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[175.504549] [036/133] (843s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[175.606088] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[176.551310] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.945s)
[176.660539] [037/133] (842s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[176.765136] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[176.769460] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[176.863092] [038/133] (842s left) prime_mmap_kms (buffer-sharing)
[176.951534] Starting subtest: buffer-sharing
[177.386301] Subtest buffer-sharing: SUCCESS (0.433s)
[178.271267] [039/133] (840s left) gem_exec_schedule (out-order)
[178.355912] Starting subtest: out-order
[178.358328] Starting dynamic subtest: rcs0
[178.455700] Dynamic subtest rcs0: SUCCESS (0.108s)
[178.467018] Starting dynamic subtest: vcs0
[178.535575] Dynamic subtest vcs0: SUCCESS (0.079s)
[178.547029] Starting dynamic subtest: vcs1
[178.613381] Dynamic subtest vcs1: SUCCESS (0.077s)
[178.625254] Starting dynamic subtest: vecs0
[178.689747] Dynamic subtest vecs0: SUCCESS (0.076s)
[178.700411] Starting dynamic subtest: ccs0
[178.773578] Dynamic subtest ccs0: SUCCESS (0.083s)
[178.776079] Subtest out-order: SUCCESS (0.427s)
[180.009067] [040/133] (839s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[180.106967] Starting subtest: fbc-psr2-cursor-plane-onoff
[180.109193] Starting dynamic subtest: eDP-1
[180.113338] Dynamic subtest eDP-1: SKIP (0.000s)
[180.117562] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[180.176467] [041/133] (839s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[180.263163] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[180.265304] Starting dynamic subtest: pipe-A-eDP-1
[180.288703] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[180.297702] Starting dynamic subtest: pipe-B-eDP-1
[180.320134] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[180.327428] Starting dynamic subtest: pipe-C-eDP-1
[180.350083] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[180.357093] Starting dynamic subtest: pipe-D-eDP-1
[180.379781] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[180.383980] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[182.522303] [042/133] (836s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[182.646695] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[182.651303] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[182.795390] [043/133] (836s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[182.903393] Starting subtest: cursorB-vs-flipA-toggle
[182.907919] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[183.066565] [044/133] (836s left) kms_chamelium_frames (dp-crc-fast)
[183.449576] Subtest dp-crc-fast: SKIP (0.000s)
[184.238022] [045/133] (835s left) gem_exec_params (invalid-ring2)
[184.297140] Starting subtest: invalid-ring2
[184.299876] Subtest invalid-ring2: SUCCESS (0.000s)
[184.410186] [046/133] (835s left) i915_suspend (basic-s3-without-i915)
[184.447437] Starting subtest: basic-s3-without-i915
[187.736526] Subtest basic-s3-without-i915: SKIP (3.285s)
[189.265351] [047/133] (830s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[189.387102] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[189.391411] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[189.478093] [048/133] (830s left) i915_fb_tiling (basic-x-tiling)
[189.540535] Subtest basic-x-tiling: SKIP (0.000s)
[189.592608] [049/133] (829s left) gem_exec_schedule (deep)
[189.782448] Starting subtest: deep
[189.784897] Starting dynamic subtest: rcs0
[194.880110] Dynamic subtest rcs0: SKIP (5.094s)
[194.889959] Starting dynamic subtest: vcs0
[205.049897] Dynamic subtest vcs0: SUCCESS (10.169s)
[205.059246] Starting dynamic subtest: vcs1
[215.791733] Dynamic subtest vcs1: SUCCESS (10.741s)
[215.802037] Starting dynamic subtest: vecs0
[226.648692] Dynamic subtest vecs0: SUCCESS (10.855s)
[226.657474] Starting dynamic subtest: ccs0
[239.317823] Dynamic subtest ccs0: SUCCESS (12.667s)
[239.321171] Subtest deep: SUCCESS (49.531s)
[240.641118] [050/133] (778s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[240.748077] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[240.752040] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[240.845143] [051/133] (778s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[240.939635] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[240.943693] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[241.036967] [052/133] (778s left) gem_exec_parallel (contexts)
[241.094181] Starting subtest: contexts
[241.096415] Starting dynamic subtest: rcs0
[244.054055] Dynamic subtest rcs0: SUCCESS (2.958s)
[244.062740] Starting dynamic subtest: bcs0
[247.562754] Dynamic subtest bcs0: SUCCESS (3.506s)
[247.573887] Starting dynamic subtest: vcs0
[251.439641] Dynamic subtest vcs0: SUCCESS (3.876s)
[251.450083] Starting dynamic subtest: vcs1
[255.423064] Dynamic subtest vcs1: SUCCESS (3.981s)
[255.433074] Starting dynamic subtest: vecs0
[259.461075] Dynamic subtest vecs0: SUCCESS (4.036s)
[259.469055] Starting dynamic subtest: ccs0
[263.148986] Dynamic subtest ccs0: SUCCESS (3.686s)
[263.151710] Subtest contexts: SUCCESS (22.054s)
[263.346135] [053/133] (756s left) syncobj_wait (reset-during-wait-for-submit)
[263.401412] Starting subtest: reset-during-wait-for-submit
[263.502496] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[263.584582] [054/133] (756s left) syncobj_wait (single-wait-signaled)
[263.655182] Starting subtest: single-wait-signaled
[263.657485] Subtest single-wait-signaled: SUCCESS (0.000s)
[263.762419] [055/133] (756s left) gem_busy (parallel)
[263.957973] Starting subtest: parallel
[263.960609] Starting dynamic subtest: rcs0
[265.878728] Dynamic subtest rcs0: SUCCESS (1.919s)
[265.890406] Starting dynamic subtest: bcs0
[267.926403] Dynamic subtest bcs0: SUCCESS (2.045s)
[267.937889] Starting dynamic subtest: vcs0
[269.910392] Dynamic subtest vcs0: SUCCESS (1.981s)
[269.921946] Starting dynamic subtest: vcs1
[271.894374] Dynamic subtest vcs1: SUCCESS (1.982s)
[271.904998] Starting dynamic subtest: vecs0
[273.878058] Dynamic subtest vecs0: SUCCESS (1.980s)
[273.889572] Starting dynamic subtest: ccs0
[275.925755] Dynamic subtest ccs0: SUCCESS (2.044s)
[275.928657] Subtest parallel: SUCCESS (11.968s)
[276.167749] [056/133] (743s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[276.274045] Starting subtest: modeset-transition-nonblocking-fencing
[276.276304] Starting dynamic subtest: 1x-outputs
[287.127553] Dynamic subtest 1x-outputs: SUCCESS (10.855s)
[287.130083] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.857s)
[287.976268] [057/133] (731s left) gem_exec_fence (long-history)
[288.463660] Starting subtest: long-history
[295.624039] Subtest long-history: SUCCESS (7.161s)
[296.253656] [058/133] (723s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[296.352108] Starting subtest: yf-tiled-8bpp-rotate-90
[296.356630] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[296.447918] [059/133] (723s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[296.546967] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[297.560014] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.012s)
[297.701399] [060/133] (722s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[297.794621] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[297.798250] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[297.884285] [061/133] (722s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[297.981765] Starting subtest: plane-downscale-factor-0-5-with-rotation
[297.983653] Starting dynamic subtest: pipe-A
[298.002286] Dynamic subtest pipe-A: SKIP (0.016s)
[298.016070] Starting dynamic subtest: pipe-B
[298.031073] Dynamic subtest pipe-B: SKIP (0.029s)
[298.041313] Starting dynamic subtest: pipe-C
[298.059345] Dynamic subtest pipe-C: SKIP (0.029s)
[298.067144] Starting dynamic subtest: pipe-D
[298.091861] Dynamic subtest pipe-D: SKIP (0.032s)
[298.095074] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.108s)
[298.184425] [062/133] (721s left) kms_invalid_mode (bad-hsync-start)
[298.276797] Starting subtest: bad-hsync-start
[298.278667] Starting dynamic subtest: pipe-A-eDP-1
[298.562464] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[298.572262] Starting dynamic subtest: pipe-B-eDP-1
[298.574361] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[298.581901] Starting dynamic subtest: pipe-C-eDP-1
[298.584302] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[298.591976] Starting dynamic subtest: pipe-D-eDP-1
[298.594317] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[298.596534] Subtest bad-hsync-start: SUCCESS (0.292s)
[299.393607] [063/133] (720s left) kms_content_protection (suspend-resume)
[299.527953] Starting subtest: suspend-resume
[299.532221] Subtest suspend-resume: SKIP (0.000s)
[299.639918] [064/133] (720s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[299.758846] Starting subtest: flip-vs-cursor-atomic
[306.832934] Subtest flip-vs-cursor-atomic: SUCCESS (7.072s)
[307.629704] [065/133] (712s left) kms_feature_discovery (psr2)
[307.724190] Starting subtest: psr2
[307.726572] Subtest psr2: SUCCESS (0.000s)
[307.795741] [066/133] (712s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[307.889383] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[307.891650] Starting dynamic subtest: pipe-A-default-mode
[310.603362] Dynamic subtest pipe-A-default-mode: SUCCESS (2.713s)
[310.605725] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.714s)
[311.431177] [067/133] (708s left) syncobj_wait (single-wait-all-signaled)
[311.494876] Starting subtest: single-wait-all-signaled
[311.497185] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[311.600061] [068/133] (708s left) gem_exec_schedule (promotion)
[311.675274] Starting subtest: promotion
[311.677578] Starting dynamic subtest: rcs0
[311.776871] Dynamic subtest rcs0: SUCCESS (0.110s)
[311.788174] Starting dynamic subtest: vcs0
[311.866943] Dynamic subtest vcs0: SUCCESS (0.089s)
[311.878220] Starting dynamic subtest: vcs1
[311.959297] Dynamic subtest vcs1: SUCCESS (0.090s)
[311.971912] Starting dynamic subtest: vecs0
[312.042571] Dynamic subtest vecs0: SUCCESS (0.082s)
[312.053852] Starting dynamic subtest: ccs0
[312.140938] Dynamic subtest ccs0: SUCCESS (0.096s)
[312.143489] Subtest promotion: SUCCESS (0.475s)
[313.021809] [069/133] (707s left) kms_flip (basic-flip-vs-modeset)
[313.123759] Starting subtest: basic-flip-vs-modeset
[313.125959] Starting dynamic subtest: A-eDP1
[315.735211] Dynamic subtest A-eDP1: SUCCESS (2.610s)
[315.744663] Starting dynamic subtest: B-eDP1
[317.917371] Dynamic subtest B-eDP1: SUCCESS (2.182s)
[317.926390] Starting dynamic subtest: C-eDP1
[320.093425] Dynamic subtest C-eDP1: SUCCESS (2.175s)
[320.101767] Starting dynamic subtest: D-eDP1
[322.172359] Dynamic subtest D-eDP1: SUCCESS (2.078s)
[322.174217] Subtest basic-flip-vs-modeset: SUCCESS (9.052s)
[322.979390] [070/133] (697s left) kms_addfb_basic (unused-offsets)
[323.044610] Starting subtest: unused-offsets
[323.046999] Subtest unused-offsets: SUCCESS (0.000s)
[323.181081] [071/133] (697s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[323.284992] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[323.289281] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[323.367185] [072/133] (697s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[323.420325] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[323.486753] [073/133] (697s left) gem_wait (busy)
[323.549771] Starting subtest: busy
[323.552196] Starting dynamic subtest: all-engines
[324.885824] Dynamic subtest all-engines: SUCCESS (1.334s)
[324.896777] Starting dynamic subtest: rcs0
[325.426713] Dynamic subtest rcs0: SUCCESS (0.540s)
[325.437092] Starting dynamic subtest: bcs0
[325.966300] Dynamic subtest bcs0: SUCCESS (0.539s)
[325.976595] Starting dynamic subtest: vcs0
[327.893375] Dynamic subtest vcs0: SUCCESS (1.925s)
[327.903474] Starting dynamic subtest: vcs1
[329.942621] Dynamic subtest vcs1: SUCCESS (2.046s)
[329.953616] Starting dynamic subtest: vecs0
[331.925928] Dynamic subtest vecs0: SUCCESS (1.981s)
[331.936747] Starting dynamic subtest: ccs0
[332.468303] Dynamic subtest ccs0: SUCCESS (0.541s)
[332.470693] Subtest busy: SUCCESS (8.919s)
[332.673107] [074/133] (687s left) gen9_exec_parse (bb-large)
[332.743670] Subtest bb-large: SKIP (0.000s)
[332.818065] [075/133] (687s left) syncobj_timeline (single-wait-for-submit-signaled)
[332.884053] Starting subtest: single-wait-for-submit-signaled
[332.886426] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[333.000905] [076/133] (687s left) gem_pxp (protected-raw-src-copy-not-readible)
[333.137654] Starting subtest: protected-raw-src-copy-not-readible
[333.209918] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.074s)
[333.326027] [077/133] (687s left) perf (whitelisted-registers-userspace-config)
[333.461088] Starting subtest: whitelisted-registers-userspace-config
[333.463343] Subtest whitelisted-registers-userspace-config: SUCCESS (0.000s)
[333.500654] [078/133] (687s left) kms_flip (dpms-vs-vblank-race-interruptible)
[333.610845] Starting subtest: dpms-vs-vblank-race-interruptible
[333.615754] Starting dynamic subtest: A-eDP1
[338.590016] Dynamic subtest A-eDP1: SUCCESS (4.972s)
[338.599202] Starting dynamic subtest: B-eDP1
[343.212381] Dynamic subtest B-eDP1: SUCCESS (4.622s)
[343.224056] Starting dynamic subtest: C-eDP1
[347.832077] Dynamic subtest C-eDP1: SUCCESS (4.615s)
[347.841295] Starting dynamic subtest: D-eDP1
[352.469903] Dynamic subtest D-eDP1: SUCCESS (4.636s)
[352.472624] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.860s)
[353.334131] [079/133] (667s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[353.427307] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[353.429467] Starting dynamic subtest: pipe-A-eDP-1
[353.485826] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[353.494047] Starting dynamic subtest: pipe-B-eDP-1
[353.550097] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[353.560064] Starting dynamic subtest: pipe-C-eDP-1
[353.617111] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[353.627458] Starting dynamic subtest: pipe-D-eDP-1
[353.681233] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[353.685226] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[355.691318] [080/133] (665s left) kms_flip (flip-vs-fences)
[355.781230] Starting subtest: flip-vs-fences
[355.785780] Subtest flip-vs-fences: SKIP (0.000s)
[355.909828] [081/133] (664s left) kms_flip (2x-nonexisting-fb-interruptible)
[355.993896] Starting subtest: 2x-nonexisting-fb-interruptible
[356.005647] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.010s)
[356.092431] [082/133] (664s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[356.179977] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[356.184125] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[356.266178] [083/133] (664s left) gem_exec_balancer (parallel-keep-submit-fence)
[356.534952] Starting subtest: parallel-keep-submit-fence
[357.700500] Subtest parallel-keep-submit-fence: SUCCESS (1.169s)
[357.794018] [084/133] (663s left) kms_pm_rpm (modeset-stress-extra-wait)
[360.018404] Starting subtest: modeset-stress-extra-wait
[414.318503] Subtest modeset-stress-extra-wait: SUCCESS (54.300s)
[414.410062] [085/133] (606s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[414.505695] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[414.507547] Starting dynamic subtest: pipe-A-eDP-1
[415.357281] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.847s)
[415.366448] Starting dynamic subtest: pipe-B-eDP-1
[416.890709] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.532s)
[416.899923] Starting dynamic subtest: pipe-C-eDP-1
[418.423923] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.532s)
[418.433222] Starting dynamic subtest: pipe-D-eDP-1
[419.972150] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.546s)
[419.974318] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.462s)
[421.135577] [086/133] (599s left) syncobj_wait (wait-all-interrupted)
[421.201487] Starting subtest: wait-all-interrupted
[421.303984] Subtest wait-all-interrupted: SUCCESS (0.103s)
[421.379625] [087/133] (599s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[421.480043] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[421.482229] Starting dynamic subtest: pipe-A-eDP-1
[421.627425] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.139s)
[421.637768] Starting dynamic subtest: pipe-B-eDP-1
[421.656137] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[421.664664] Starting dynamic subtest: pipe-C-eDP-1
[421.683998] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[421.692537] Starting dynamic subtest: pipe-D-eDP-1
[421.711057] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[421.713118] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.176s)
[423.899401] [088/133] (597s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[423.955723] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[424.030856] [089/133] (597s left) vgem_basic (bad-flag)
[424.077649] Starting subtest: bad-flag
[424.079625] Subtest bad-flag: SUCCESS (0.000s)
[424.144091] [090/133] (597s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[424.201793] Starting subtest: etime-single-wait-for-submit-unsubmitted
[424.305681] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[424.380927] [091/133] (596s left) syncobj_timeline (multi-wait-all-available-submitted)
[424.435464] Starting subtest: multi-wait-all-available-submitted
[424.437487] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[424.531032] [092/133] (596s left) kms_universal_plane (disable-primary-vs-flip)
[424.621119] Starting subtest: disable-primary-vs-flip
[424.623302] Starting dynamic subtest: pipe-A-eDP-1
[426.194866] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.574s)
[426.205121] Starting dynamic subtest: pipe-B-eDP-1
[428.465243] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.266s)
[428.483454] Starting dynamic subtest: pipe-C-eDP-1
[430.698132] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.234s)
[430.707669] Starting dynamic subtest: pipe-D-eDP-1
[432.877595] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.176s)
[432.879992] Subtest disable-primary-vs-flip: SUCCESS (8.257s)
[433.759832] [093/133] (587s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[433.844225] Starting subtest: invalidate-primary-flip-overlay
[444.567111] Subtest invalidate-primary-flip-overlay: SUCCESS (10.724s)
[444.679849] [094/133] (576s left) kms_cursor_crc (cursor-random-512x512)
[444.954659] Starting subtest: cursor-random-512x512
[444.958325] Subtest cursor-random-512x512: SKIP (0.001s)
[445.099589] [095/133] (576s left) i915_drm_fdinfo (virtual-busy-all)
[445.142793] Starting subtest: virtual-busy-all
[445.146483] Subtest virtual-busy-all: SKIP (0.000s)
[445.211757] [096/133] (576s left) gem_create (create-massive)
[445.262992] Starting subtest: create-massive
[445.264930] Subtest create-massive: SUCCESS (0.000s)
[445.459850] [097/133] (576s left) kms_pm_dc (dc6-psr)
[446.556855] Starting subtest: dc6-psr
[449.540025] Subtest dc6-psr: SUCCESS (2.984s)
[450.380913] [098/133] (571s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[450.513305] Starting subtest: basic-busy-flip-before-cursor-varying-size
[450.517924] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[450.659230] [099/133] (570s left) kms_vblank (query-forked-busy-hang)
[450.745681] Starting subtest: query-forked-busy-hang
[450.747821] Starting dynamic subtest: pipe-A-eDP-1
[477.652081] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.905s)
[477.667044] Starting dynamic subtest: pipe-D-eDP-1
[502.689879] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.034s)
[502.692333] Subtest query-forked-busy-hang: SUCCESS (51.943s)
[503.554811] [100/133] (518s left) kms_addfb_basic (master-rmfb)
[503.613927] Starting subtest: master-rmfb
[503.616089] Subtest master-rmfb: SUCCESS (0.001s)
[503.744799] [101/133] (517s left) perf_pmu (render-node-busy-idle)
[503.805948] Starting subtest: render-node-busy-idle
[503.808287] Starting dynamic subtest: rcs0
[504.491889] Dynamic subtest rcs0: SUCCESS (0.685s)
[504.503200] Starting dynamic subtest: bcs0
[505.153717] Dynamic subtest bcs0: SUCCESS (0.660s)
[505.165398] Starting dynamic subtest: vcs0
[506.902277] Dynamic subtest vcs0: SUCCESS (1.744s)
[506.911630] Starting dynamic subtest: vcs1
[508.886355] Dynamic subtest vcs1: SUCCESS (1.981s)
[508.897135] Starting dynamic subtest: vecs0
[510.934388] Dynamic subtest vecs0: SUCCESS (2.044s)
[510.945663] Starting dynamic subtest: ccs0
[511.604607] Dynamic subtest ccs0: SUCCESS (0.669s)
[511.607509] Subtest render-node-busy-idle: SUCCESS (7.799s)
[511.677954] [102/133] (509s left) kms_atomic_transition (plane-all-transition-fencing)
[511.779604] Starting subtest: plane-all-transition-fencing
[511.782652] Starting dynamic subtest: pipe-A-eDP-1
[514.273239] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[514.580206] Starting dynamic subtest: pipe-B-eDP-1
[517.782534] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.211s)
[518.095712] Subtest plane-all-transition-fencing: SUCCESS (6.318s)
[518.912807] [103/133] (502s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[519.017522] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[519.021914] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[519.107030] [104/133] (502s left) gem_mmap_gtt (basic-write-gtt)
[519.166944] Subtest basic-write-gtt: SKIP (0.000s)
[519.236428] [105/133] (502s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[519.328610] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[519.332881] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[519.422043] [106/133] (502s left) gem_gtt_cpu_tlb
[519.534395] [107/133] (502s left) kms_properties (plane-properties-legacy)
[519.631776] Starting subtest: plane-properties-legacy
[519.634059] Starting dynamic subtest: pipe-A-eDP-1
[520.179031] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.545s)
[520.187318] Starting dynamic subtest: pipe-B-eDP-1
[521.484776] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.304s)
[521.493726] Starting dynamic subtest: pipe-C-eDP-1
[522.803624] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.317s)
[522.813153] Starting dynamic subtest: pipe-D-eDP-1
[524.039239] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s)
[524.041096] Subtest plane-properties-legacy: SUCCESS (4.406s)
[524.847700] [108/133] (497s left) gem_exec_whisper (basic-queues-forked-all)
[524.907725] Starting subtest: basic-queues-forked-all
[543.345112] Subtest basic-queues-forked-all: SUCCESS (18.435s)
[543.532957] [109/133] (478s left) gem_exec_alignment (many)
[543.590144] Starting subtest: many
[567.450530] Subtest many: SUCCESS (23.856s)
[568.841899] [110/133] (453s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[569.000866] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[569.005459] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[569.148385] [111/133] (452s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[569.252209] Starting subtest: read-crc-frame-sequence
[569.254279] Starting dynamic subtest: pipe-A-eDP-1
[569.968281] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.715s)
[569.978363] Starting dynamic subtest: pipe-B-eDP-1
[571.312675] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.345s)
[571.323030] Starting dynamic subtest: pipe-C-eDP-1
[572.602800] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.288s)
[572.612977] Starting dynamic subtest: pipe-D-eDP-1
[573.950056] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.344s)
[573.952327] Subtest read-crc-frame-sequence: SUCCESS (4.698s)
[574.785791] [112/133] (447s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[574.886993] Starting subtest: psr-rgb565-draw-pwrite
[581.876882] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.990s)
[582.009861] [113/133] (440s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[582.074598] Starting subtest: single-wait-for-submit-unsubmitted
[582.177076] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[582.254918] [114/133] (439s left) api_intel_bb (object-noreloc-keep-cache-simple)
[582.321880] Starting subtest: object-noreloc-keep-cache-simple
[582.326498] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.007s)
[582.458412] [115/133] (439s left) kms_psr (pr-sprite-blt)
[582.558401] Starting subtest: pr-sprite-blt
[582.562793] Subtest pr-sprite-blt: SKIP (0.000s)
[582.629092] [116/133] (439s left) gem_lmem_swapping (verify-random)
[582.674950] Subtest verify-random: SKIP (0.000s)
[582.719267] [117/133] (439s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[582.814722] Starting subtest: y-tiled-addfb-size-offset-overflow
[582.819247] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[582.923305] [118/133] (439s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[583.018274] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[589.651347] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.635s)
[589.764437] [119/133] (432s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[589.882449] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[590.528697] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.648s)
[590.683770] [120/133] (431s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[590.745677] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[590.747990] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[590.866043] [121/133] (431s left) api_intel_allocator (execbuf-with-allocator)
[590.931559] Starting subtest: execbuf-with-allocator
[590.934965] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[591.065148] [122/133] (431s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[591.132608] Starting subtest: multi-wait-for-submit-submitted-signaled
[591.134568] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[591.224397] [123/133] (431s left) syncobj_timeline (reset-unsignaled)
[591.271578] Starting subtest: reset-unsignaled
[591.273895] Subtest reset-unsignaled: SUCCESS (0.000s)
[591.380561] [124/133] (431s left) prime_self_import (export-vs-gem_close-race)
[591.415641] Starting subtest: export-vs-gem_close-race
[596.530712] Subtest export-vs-gem_close-race: SUCCESS (5.112s)
[596.603688] [125/133] (426s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[596.745088] Starting subtest: cursorA-vs-flipA-legacy
[607.897794] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.150s)
[608.776421] [126/133] (413s left) prime_vgem (basic-fence-mmap)
[608.861776] Starting subtest: basic-fence-mmap
[608.866941] Subtest basic-fence-mmap: SKIP (0.000s)
[608.971526] [127/133] (413s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[609.073536] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[615.681318] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.610s)
[615.816305] [128/133] (406s left) kms_psr (psr-cursor-plane-onoff)
[615.917899] Starting subtest: psr-cursor-plane-onoff
[615.920107] Starting dynamic subtest: eDP-1
[617.605867] Dynamic subtest eDP-1: SUCCESS (1.687s)
[617.608134] Subtest psr-cursor-plane-onoff: SUCCESS (1.688s)
[618.474657] [129/133] (404s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[618.567660] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[618.571780] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[618.659603] [130/133] (404s left) perf (stress-open-close)
[618.777647] Starting subtest: stress-open-close
[618.779608] Starting dynamic subtest: 0-rcs0
[620.946970] Dynamic subtest 0-rcs0: SUCCESS (2.171s)
[620.957900] Starting dynamic subtest: 1-vcs0
[623.110816] Dynamic subtest 1-vcs0: SUCCESS (2.163s)
[623.112833] Subtest stress-open-close: SUCCESS (4.337s)
[623.153285] [131/133] (399s left) perf_pmu (busy-accuracy-98)
[623.196591] Starting subtest: busy-accuracy-98
[623.198707] Starting dynamic subtest: rcs0
[626.238471] Dynamic subtest rcs0: SUCCESS (3.041s)
[626.250328] Starting dynamic subtest: bcs0
[629.288353] Dynamic subtest bcs0: SUCCESS (3.048s)
[629.299950] Starting dynamic subtest: vcs0
[632.337100] Dynamic subtest vcs0: SUCCESS (3.047s)
[632.347354] Starting dynamic subtest: vcs1
[635.379543] Dynamic subtest vcs1: SUCCESS (3.039s)
[635.389081] Starting dynamic subtest: vecs0
[638.420848] Dynamic subtest vecs0: SUCCESS (3.039s)
[638.430104] Starting dynamic subtest: ccs0
[641.470613] Dynamic subtest ccs0: SUCCESS (3.046s)
[641.473044] Subtest busy-accuracy-98: SUCCESS (18.273s)
[641.587218] [132/133] (381s left) syncobj_eventfd (binary-wait-before-signal)
[641.648061] Starting subtest: binary-wait-before-signal
[641.677668] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[641.755195] [133/133] (381s left) kms_psr (fbc-pr-cursor-blt)
[641.842106] Starting subtest: fbc-pr-cursor-blt
[641.846076] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[641.913704] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_offset
results: parsing output: 1/ for test: kms_cursor_crc
results: parsing output: 2/ for test: dmabuf_sync_file
results: parsing output: 3/ for test: kms_color_pipeline
results: parsing output: 4/ for test: kms_plane_scaling
results: parsing output: 5/ for test: syncobj_wait
results: parsing output: 6/ for test: kms_chamelium_hpd
results: parsing output: 7/ for test: gem_exec_flush
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: i915_pm_rc6_residency
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_rotation_crc
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_ctx_persistence
results: parsing output: 15/ for test: perf
results: parsing output: 16/ for test: gem_ctx_param
results: parsing output: 17/ for test: kms_lease
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: gem_exec_schedule
results: parsing output: 21/ for test: gem_pxp
results: parsing output: 22/ for test: gem_exec_balancer
results: parsing output: 23/ for test: kms_plane_multiple
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: gem_render_copy
results: parsing output: 26/ for test: kms_plane
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: kms_psr2_sf
results: parsing output: 30/ for test: perf
results: parsing output: 31/ for test: gem_softpin
results: parsing output: 32/ for test: kms_rotation_crc
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: prime_mmap_kms
results: parsing output: 38/ for test: gem_exec_schedule
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: kms_chamelium_frames
results: parsing output: 44/ for test: gem_exec_params
results: parsing output: 45/ for test: i915_suspend
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: i915_fb_tiling
results: parsing output: 48/ for test: gem_exec_schedule
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_exec_parallel
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: gem_busy
results: parsing output: 55/ for test: kms_atomic_transition
results: parsing output: 56/ for test: gem_exec_fence
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_plane_scaling
results: parsing output: 61/ for test: kms_invalid_mode
results: parsing output: 62/ for test: kms_content_protection
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: kms_feature_discovery
results: parsing output: 65/ for test: kms_flip_scaled_crc
results: parsing output: 66/ for test: syncobj_wait
results: parsing output: 67/ for test: gem_exec_schedule
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: kms_addfb_basic
results: parsing output: 70/ for test: kms_flip_scaled_crc
results: parsing output: 71/ for test: gem_fenced_exec_thrash
results: parsing output: 72/ for test: gem_wait
results: parsing output: 73/ for test: gen9_exec_parse
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: gem_pxp
results: parsing output: 76/ for test: perf
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_psr2_sf
results: parsing output: 82/ for test: gem_exec_balancer
results: parsing output: 83/ for test: kms_pm_rpm
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: gem_exec_reloc
results: parsing output: 88/ for test: vgem_basic
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_universal_plane
results: parsing output: 92/ for test: kms_psr_stress_test
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: i915_drm_fdinfo
results: parsing output: 95/ for test: gem_create
results: parsing output: 96/ for test: kms_pm_dc
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: kms_vblank
results: parsing output: 99/ for test: kms_addfb_basic
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: kms_atomic_transition
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_mmap_gtt
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_gtt_cpu_tlb
results: parsing output: 106/ for test: kms_properties
results: parsing output: 107/ for test: gem_exec_whisper
results: parsing output: 108/ for test: gem_exec_alignment
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: kms_pipe_crc_basic
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: api_intel_bb
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: gem_lmem_swapping
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: syncobj_wait
results: parsing output: 120/ for test: api_intel_allocator
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: prime_self_import
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: prime_vgem
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: perf
results: parsing output: 130/ for test: perf_pmu
results: parsing output: 131/ for test: syncobj_eventfd
results: parsing output: 132/ for test: kms_psr
Done.