[102.540699] Initializing watchdogs
[102.540750]   /dev/watchdog0
[102.554365] [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]
[102.558539] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[102.560731] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[102.564145] [001/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[102.683159] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[102.687795] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[102.807178] [002/133] (960s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[102.911284] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[102.913541] Starting dynamic subtest: pipe-A-eDP-1
[102.936335] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[102.946572] Starting dynamic subtest: pipe-B-eDP-1
[102.967489] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[102.973989] Starting dynamic subtest: pipe-C-eDP-1
[102.995961] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[103.002662] Starting dynamic subtest: pipe-D-eDP-1
[103.024812] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[103.029710] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.003s)
[105.178932] [003/133] (957s left) syncobj_timeline (wait-all-interrupted)
[105.233798] Starting subtest: wait-all-interrupted
[105.341224] Subtest wait-all-interrupted: SUCCESS (0.106s)
[105.413665] [004/133] (957s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[105.507326] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[109.096387] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.592s)
[110.282807] [005/133] (952s left) kms_pm_lpsp (kms-lpsp)
[111.372328] Starting subtest: kms-lpsp
[111.374282] Starting dynamic subtest: pipe-A-eDP-1
[111.542732] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[111.830635] Subtest kms-lpsp: SUCCESS (0.461s)
[112.700954] [006/133] (950s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[112.809284] Starting subtest: yf-tiled-8bpp-rotate-180
[112.814049] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[112.899123] [007/133] (950s left) kms_cursor_crc (cursor-random-512x170)
[113.181709] Starting subtest: cursor-random-512x170
[113.186277] Subtest cursor-random-512x170: SKIP (0.001s)
[113.334947] [008/133] (949s left) kms_psr (fbc-pr-suspend)
[113.439750] Starting subtest: fbc-pr-suspend
[113.443711] Subtest fbc-pr-suspend: SKIP (0.000s)
[113.505521] [009/133] (949s left) kms_chamelium_edid (dp-edid-resolution-list)
[113.880551] Subtest dp-edid-resolution-list: SKIP (0.000s)
[114.713854] [010/133] (948s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[114.805230] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[114.807598] Starting dynamic subtest: pipe-A-default-mode
[115.991080] Dynamic subtest pipe-A-default-mode: SKIP (1.184s)
[115.995287] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.185s)
[116.136918] [011/133] (947s left) kms_plane_alpha_blend (alpha-transparent-fb)
[116.228404] Starting subtest: alpha-transparent-fb
[116.508588] Starting dynamic subtest: pipe-A-eDP-1
[117.145859] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.635s)
[117.159238] Starting dynamic subtest: pipe-D-eDP-1
[118.535351] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.389s)
[118.537738] Subtest alpha-transparent-fb: SUCCESS (2.307s)
[119.334014] [012/133] (944s left) syncobj_eventfd (invalid-bad-flags)
[119.394615] Starting subtest: invalid-bad-flags
[119.397178] Subtest invalid-bad-flags: SUCCESS (0.000s)
[119.504616] [013/133] (944s left) gem_ctx_sseu (invalid-args)
[119.567494] Subtest invalid-args: SKIP (0.000s)
[119.632964] [014/133] (943s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[119.718904] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[119.721389] Starting dynamic subtest: pipe-A-eDP-1
[119.744820] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[119.754164] Starting dynamic subtest: pipe-B-eDP-1
[119.776161] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[119.783812] Starting dynamic subtest: pipe-C-eDP-1
[119.805150] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[119.812156] Starting dynamic subtest: pipe-D-eDP-1
[119.832895] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[119.836829] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[121.924326] [015/133] (941s left) kms_cursor_edge_walk (128x128-left-edge)
[122.018711] Starting subtest: 128x128-left-edge
[122.021495] Starting dynamic subtest: pipe-A-eDP-1
[125.488832] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.467s)
[125.497470] Starting dynamic subtest: pipe-D-eDP-1
[128.613536] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[128.615901] Subtest 128x128-left-edge: SUCCESS (6.594s)
[129.427758] [016/133] (934s left) fbdev (eof)
[129.467720] Starting subtest: eof
[129.470139] Subtest eof: SUCCESS (0.000s)
[129.545554] [017/133] (934s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[129.631073] Starting subtest: fbc-pr-cursor-mmap-gtt
[129.635294] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[129.699969] [018/133] (933s left) gem_flink_basic (double-flink)
[129.748806] Starting subtest: double-flink
[129.751503] Subtest double-flink: SUCCESS (0.000s)
[129.828775] [019/133] (933s left) kms_psr (psr-primary-mmap-cpu)
[129.921294] Starting subtest: psr-primary-mmap-cpu
[129.923707] Starting dynamic subtest: eDP-1
[131.607562] Dynamic subtest eDP-1: SUCCESS (1.687s)
[131.609998] Subtest psr-primary-mmap-cpu: SUCCESS (1.688s)
[132.471864] [020/133] (931s left) syncobj_timeline (multi-wait-all-available-signaled)
[132.538062] Starting subtest: multi-wait-all-available-signaled
[132.540424] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[132.646354] [021/133] (931s left) gem_exec_reloc (basic-scanout)
[132.716887] Subtest basic-scanout: SKIP (0.000s)
[132.789101] [022/133] (931s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[132.844485] Starting subtest: saturated-hostile-nopreempt
[132.846857] Starting dynamic subtest: rcs0
[132.894054] Dynamic subtest rcs0: SKIP (0.047s)
[132.902525] Starting dynamic subtest: bcs0
[132.947043] Dynamic subtest bcs0: SKIP (0.052s)
[132.955897] Starting dynamic subtest: vcs0
[132.963476] Dynamic subtest vcs0: SKIP (0.016s)
[132.969672] Starting dynamic subtest: vcs1
[132.980613] Dynamic subtest vcs1: SKIP (0.017s)
[132.987082] Starting dynamic subtest: vecs0
[132.995583] Dynamic subtest vecs0: SKIP (0.015s)
[133.001783] Starting dynamic subtest: ccs0
[133.011749] Dynamic subtest ccs0: SKIP (0.016s)
[133.015976] Subtest saturated-hostile-nopreempt: SKIP (0.166s)
[133.095194] [023/133] (930s left) sw_sync (alloc_fence_invalid_timeline)
[133.128741] Starting subtest: alloc_fence_invalid_timeline
[133.130956] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[133.186605] [024/133] (930s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[133.276562] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[133.280992] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[133.377638] [025/133] (930s left) kms_feature_discovery (display-2x)
[133.463477] Starting subtest: display-2x
[133.467057] Subtest display-2x: SKIP (0.000s)
[133.532288] [026/133] (930s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[133.649067] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[133.650928] Starting dynamic subtest: pipe-A-eDP-1
[133.671786] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[133.680945] Starting dynamic subtest: pipe-B-eDP-1
[133.699837] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[133.706280] Starting dynamic subtest: pipe-C-eDP-1
[133.723968] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[133.730092] Starting dynamic subtest: pipe-D-eDP-1
[133.747954] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[133.751521] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.004s)
[135.864246] [027/133] (928s left) kms_invalid_mode (zero-clock)
[135.961622] Starting subtest: zero-clock
[135.963985] Starting dynamic subtest: pipe-A-eDP-1
[136.242692] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[136.251973] Starting dynamic subtest: pipe-B-eDP-1
[136.254200] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[136.260640] Starting dynamic subtest: pipe-C-eDP-1
[136.262581] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[136.272500] Starting dynamic subtest: pipe-D-eDP-1
[136.274666] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[136.276737] Subtest zero-clock: SUCCESS (0.287s)
[137.085475] [028/133] (926s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[137.193335] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[137.197702] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[137.289211] [029/133] (926s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[137.353677] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[137.358247] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[137.537206] [030/133] (926s left) i915_pm_rps (thresholds-idle-park)
[137.590178] Starting subtest: thresholds-idle-park
[137.594654] Subtest thresholds-idle-park: SKIP (0.001s)
[137.683020] [031/133] (926s left) gen7_exec_parse (cmd-crossing-page)
[137.742108] Subtest cmd-crossing-page: SKIP (0.000s)
[137.793973] [032/133] (926s left) syncobj_wait (single-wait-for-submit-submitted)
[137.855957] Starting subtest: single-wait-for-submit-submitted
[137.961978] Subtest single-wait-for-submit-submitted: SUCCESS (0.105s)
[138.063042] [033/133] (926s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[138.164233] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[143.130533] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.971s)
[144.284729] [034/133] (920s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[144.396280] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[151.824181] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.432s)
[151.958162] [035/133] (912s left) gem_ppgtt (blt-vs-render-ctx0)
[152.012276] Starting subtest: blt-vs-render-ctx0
[184.868373] Subtest blt-vs-render-ctx0: SUCCESS (32.852s)
[184.993147] [036/133] (879s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[185.134299] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[189.662703] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.532s)
[190.861809] [037/133] (873s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[190.953421] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[190.957900] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[191.035083] [038/133] (873s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[191.126000] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[198.346204] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.223s)
[198.471088] [039/133] (866s left) kms_frontbuffer_tracking (psr-suspend)
[198.571404] Starting subtest: psr-suspend
[236.900241] Subtest psr-suspend: SUCCESS (8.095s)
[237.033763] [040/133] (827s left) api_intel_bb (misplaced-blitter)
[237.101518] Starting subtest: misplaced-blitter
[237.109446] Subtest misplaced-blitter: SUCCESS (0.008s)
[237.229705] [041/133] (827s left) kms_setmode (basic-clone-single-crtc)
[237.276506] Starting subtest: basic-clone-single-crtc
[237.282978] Subtest basic-clone-single-crtc: SKIP (0.001s)
[237.372805] [042/133] (827s left) kms_pm_rpm (modeset-lpsp-stress)
[239.328156] Starting subtest: modeset-lpsp-stress
[254.925959] Subtest modeset-lpsp-stress: SUCCESS (15.641s)
[255.014735] [043/133] (809s left) gem_exec_whisper (basic-fds-forked-all)
[255.079422] Starting subtest: basic-fds-forked-all
[275.431677] Subtest basic-fds-forked-all: SUCCESS (20.335s)
[275.594390] [044/133] (789s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[275.706019] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[275.710204] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[275.802695] [045/133] (788s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[275.889018] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[275.892877] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[275.986004] [046/133] (788s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[276.081951] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[283.437233] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.357s)
[283.560167] [047/133] (781s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[283.648645] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[283.650968] Starting dynamic subtest: pipe-A-eDP-1
[283.709974] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[283.718395] Starting dynamic subtest: pipe-B-eDP-1
[283.774128] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[283.784584] Starting dynamic subtest: pipe-C-eDP-1
[283.841127] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[283.851083] Starting dynamic subtest: pipe-D-eDP-1
[283.910995] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[283.915215] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[285.956815] [048/133] (778s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[286.048681] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[286.053226] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[286.129603] [049/133] (778s left) kms_content_protection (atomic-dpms-hdcp14)
[286.271946] Starting subtest: atomic-dpms-hdcp14
[286.276333] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[286.398698] [050/133] (778s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[286.499916] Starting subtest: plane-ctm3x4-lut1d
[286.668363] Starting dynamic subtest: pipe-A-plane-0
[287.017201] Dynamic subtest pipe-A-plane-0: FAIL (0.203s)
[287.027573] Starting dynamic subtest: pipe-A-plane-1
[287.212768] Dynamic subtest pipe-A-plane-1: FAIL (0.171s)
[287.221043] Starting dynamic subtest: pipe-A-plane-2
[287.432475] Dynamic subtest pipe-A-plane-2: FAIL (0.191s)
[288.489541] Starting dynamic subtest: pipe-B-plane-0
[288.915396] Dynamic subtest pipe-B-plane-0: FAIL (0.164s)
[288.926270] Starting dynamic subtest: pipe-B-plane-1
[289.224539] Dynamic subtest pipe-B-plane-1: FAIL (0.177s)
[289.234206] Starting dynamic subtest: pipe-B-plane-2
[289.532994] Dynamic subtest pipe-B-plane-2: FAIL (0.187s)
[290.221284] Starting dynamic subtest: pipe-C-plane-0
[290.726903] Dynamic subtest pipe-C-plane-0: FAIL (0.140s)
[290.736356] Starting dynamic subtest: pipe-C-plane-1
[291.120996] Dynamic subtest pipe-C-plane-1: FAIL (0.602s)
[291.131404] Starting dynamic subtest: pipe-C-plane-2
[291.499443] Dynamic subtest pipe-C-plane-2: FAIL (0.160s)
[292.357017] Starting dynamic subtest: pipe-D-plane-0
[292.952026] Dynamic subtest pipe-D-plane-0: FAIL (0.140s)
[292.962782] Starting dynamic subtest: pipe-D-plane-1
[293.411678] Dynamic subtest pipe-D-plane-1: FAIL (0.606s)
[293.423786] Starting dynamic subtest: pipe-D-plane-2
[293.859684] Dynamic subtest pipe-D-plane-2: FAIL (0.557s)
[293.948553] Subtest plane-ctm3x4-lut1d: FAIL (7.450s)
[294.797470] [051/133] (770s left) gem_lmem_swapping (heavy-random)
[294.854554] Subtest heavy-random: SKIP (0.000s)
[294.898748] [052/133] (770s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[295.008077] Starting subtest: pr-overlay-plane-update-continuous-sf
[295.012126] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[295.075819] [053/133] (769s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[295.198322] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[295.202963] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[295.347273] [054/133] (769s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[295.443300] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[295.446072] Starting dynamic subtest: pipe-A
[295.782148] Dynamic subtest pipe-A: SUCCESS (0.340s)
[295.792583] Starting dynamic subtest: pipe-B
[297.197325] Dynamic subtest pipe-B: SUCCESS (1.414s)
[297.206790] Starting dynamic subtest: pipe-C
[298.628614] Dynamic subtest pipe-C: SUCCESS (1.429s)
[298.638472] Starting dynamic subtest: pipe-D
[300.059161] Dynamic subtest pipe-D: SUCCESS (1.430s)
[300.061641] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.619s)
[301.241750] [055/133] (763s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[301.345536] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[301.350091] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[301.449472] [056/133] (763s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[301.549598] Starting subtest: fbc-psr2-sprite-mmap-gtt
[301.551877] Starting dynamic subtest: eDP-1
[301.555912] Dynamic subtest eDP-1: SKIP (0.000s)
[301.559908] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[301.623276] [057/133] (763s left) gem_pxp (protected-raw-src-copy-not-readible)
[301.741567] Starting subtest: protected-raw-src-copy-not-readible
[301.799932] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.060s)
[301.921508] [058/133] (763s left) gem_softpin (allocator-evict)
[301.983464] Starting subtest: allocator-evict
[301.985823] Starting dynamic subtest: rcs0
[324.989782] Dynamic subtest rcs0: SUCCESS (23.012s)
[325.003448] Starting dynamic subtest: bcs0
[348.538368] Dynamic subtest bcs0: SUCCESS (23.542s)
[348.548774] Starting dynamic subtest: vcs0
[372.096604] Dynamic subtest vcs0: SUCCESS (23.556s)
[372.106653] Starting dynamic subtest: vcs1
[395.957604] Dynamic subtest vcs1: SUCCESS (23.863s)
[395.970161] Starting dynamic subtest: vecs0
[420.159318] Dynamic subtest vecs0: SUCCESS (24.203s)
[420.173034] Starting dynamic subtest: ccs0
[443.647458] Dynamic subtest ccs0: SUCCESS (23.492s)
[443.650656] Subtest allocator-evict: SUCCESS (141.678s)
[443.726830] [059/133] (621s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[443.866562] Starting subtest: plane-scaler-unity-scaling-with-rotation
[443.868767] Starting dynamic subtest: pipe-A
[444.092552] Dynamic subtest pipe-A: SUCCESS (0.228s)
[444.102138] Starting dynamic subtest: pipe-B
[445.411703] Dynamic subtest pipe-B: SUCCESS (1.318s)
[445.420912] Starting dynamic subtest: pipe-C
[446.744312] Dynamic subtest pipe-C: SUCCESS (1.331s)
[446.753325] Starting dynamic subtest: pipe-D
[448.049480] Dynamic subtest pipe-D: SUCCESS (1.305s)
[448.051770] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.187s)
[449.224238] [060/133] (616s left) gem_ctx_exec (basic)
[449.281042] Starting subtest: basic
[449.286248] Subtest basic: SUCCESS (0.005s)
[449.411904] [061/133] (615s left) gem_exec_schedule (semaphore-noskip)
[449.491784] Starting subtest: semaphore-noskip
[449.910754] Subtest semaphore-noskip: SUCCESS (0.425s)
[450.252342] [062/133] (615s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[450.355331] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[450.967786] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.614s)
[451.120102] [063/133] (614s left) gem_exec_capture (capture-invisible)
[451.196801] Starting subtest: capture-invisible
[451.198969] Starting dynamic subtest: smem0
[451.202597] Dynamic subtest smem0: SKIP (0.000s)
[451.206657] Subtest capture-invisible: SKIP (0.001s)
[451.291511] [064/133] (614s left) kms_async_flips (async-flip-hang)
[451.385386] Starting subtest: async-flip-hang
[451.756969] Starting dynamic subtest: pipe-A-eDP-1
[466.655380] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.895s)
[467.026930] Starting dynamic subtest: pipe-B-eDP-1
[482.650407] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.622s)
[483.022989] Starting dynamic subtest: pipe-C-eDP-1
[498.647774] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.628s)
[499.023408] Starting dynamic subtest: pipe-D-eDP-1
[514.646763] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.624s)
[514.648899] Subtest async-flip-hang: SUCCESS (63.248s)
[515.856064] [065/133] (549s left) kms_dp_aux_dev
[516.213992] [066/133] (549s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[516.313385] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[516.318224] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[516.422863] [067/133] (549s left) kms_cursor_crc (cursor-offscreen-128x128)
[516.621617] Starting subtest: cursor-offscreen-128x128
[516.624129] Starting dynamic subtest: pipe-A-eDP-1
[518.564751] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.939s)
[518.598298] Starting dynamic subtest: pipe-D-eDP-1
[521.165361] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.576s)
[521.167641] Subtest cursor-offscreen-128x128: SUCCESS (4.544s)
[522.022099] [068/133] (543s left) gem_userptr_blits (sd-probe)
[522.105277] Starting subtest: sd-probe
[522.107215] Subtest sd-probe: SUCCESS (0.001s)
[522.245230] [069/133] (543s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[522.335442] Starting subtest: 2x-flip-vs-rmfb-interruptible
[522.345983] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.010s)
[522.434150] [070/133] (543s left) gem_exec_fence (keep-in-fence)
[522.617718] Starting subtest: keep-in-fence
[522.619988] Starting dynamic subtest: rcs0
[522.694575] Dynamic subtest rcs0: SUCCESS (0.076s)
[522.705390] Starting dynamic subtest: bcs0
[522.748215] Dynamic subtest bcs0: SUCCESS (0.051s)
[522.758464] Starting dynamic subtest: vcs0
[524.159871] Dynamic subtest vcs0: SUCCESS (1.408s)
[524.171445] Starting dynamic subtest: vcs1
[526.143768] Dynamic subtest vcs1: SUCCESS (1.981s)
[526.155604] Starting dynamic subtest: vecs0
[528.129411] Dynamic subtest vecs0: SUCCESS (1.983s)
[528.140929] Starting dynamic subtest: ccs0
[528.364675] Dynamic subtest ccs0: SUCCESS (0.234s)
[528.367622] Subtest keep-in-fence: SUCCESS (5.747s)
[530.261844] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[530.267680] [071/133] (535s left) kms_big_fb (x-tiled-addfb)
[530.368039] Starting subtest: x-tiled-addfb
[530.370340] Subtest x-tiled-addfb: SUCCESS (0.000s)
[530.471145] [072/133] (535s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[530.583576] Starting subtest: cursorA-vs-flipB-legacy
[530.588071] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[530.727478] [073/133] (535s left) gem_mmap_gtt (pf-nonblock)
[530.776100] Subtest pf-nonblock: SKIP (0.000s)
[530.831656] [074/133] (535s left) kms_psr (pr-primary-mmap-cpu)
[530.932867] Starting subtest: pr-primary-mmap-cpu
[530.937102] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[531.002699] [075/133] (534s left) kms_selftest (drm_damage_helper)
[531.046798] Starting subtest: drm_damage_helper
[531.053439] Starting dynamic subtest: drm_test_damage_iter_no_damage
[531.146892] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.092s)
[531.157789] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[531.243002] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.096s)
[531.253469] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[531.342872] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.099s)
[531.353589] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[531.436067] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.092s)
[531.445637] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[531.522140] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.086s)
[531.532582] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[531.614137] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.091s)
[531.624802] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[531.697654] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.082s)
[531.708089] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[531.792193] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.094s)
[531.802772] Starting dynamic subtest: drm_test_damage_iter_single_damage
[531.900250] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.107s)
[531.910705] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[531.977415] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.077s)
[531.987723] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[532.073735] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.095s)
[532.083776] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[532.166241] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.091s)
[532.175610] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[532.259188] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.093s)
[532.269554] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[532.358236] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.098s)
[532.368281] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[532.447298] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.088s)
[532.457229] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[532.530196] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.082s)
[532.540306] Starting dynamic subtest: drm_test_damage_iter_damage
[532.627265] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.097s)
[532.636352] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[532.721222] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.091s)
[532.731529] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[532.803187] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.081s)
[532.813385] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[532.899241] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.095s)
[532.909611] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[532.991082] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.091s)
[532.992974] Subtest drm_damage_helper: SUCCESS (1.946s)
[533.142752] [076/133] (532s left) syncobj_timeline (wait-zero-handles)
[533.196742] Starting subtest: wait-zero-handles
[533.198235] Subtest wait-zero-handles: SUCCESS (0.000s)
[533.306755] [077/133] (532s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[533.397138] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[540.131255] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.735s)
[540.233465] [078/133] (525s left) kms_lease (lease-invalid-connector)
[540.332965] Starting subtest: lease-invalid-connector
[540.335285] Starting dynamic subtest: pipe-A-eDP-1
[540.337426] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[540.348407] Starting dynamic subtest: pipe-B-eDP-1
[540.350479] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[540.359409] Starting dynamic subtest: pipe-C-eDP-1
[540.361259] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[540.369696] Starting dynamic subtest: pipe-D-eDP-1
[540.371577] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[540.373474] Subtest lease-invalid-connector: SUCCESS (0.004s)
[540.410019] [079/133] (525s left) gem_exec_params (no-blt)
[540.463983] Starting subtest: no-blt
[540.468873] Subtest no-blt: SUCCESS (0.002s)
[540.585654] [080/133] (525s left) i915_pm_rpm (debugfs-forcewake-user)
[542.311286] Starting subtest: debugfs-forcewake-user
[553.705299] Subtest debugfs-forcewake-user: SUCCESS (11.398s)
[554.076171] [081/133] (512s left) kms_big_fb (linear-32bpp-rotate-180)
[554.177361] Starting subtest: linear-32bpp-rotate-180
[555.722414] Subtest linear-32bpp-rotate-180: SUCCESS (1.545s)
[555.861707] [082/133] (510s left) gem_workarounds (reset)
[555.923172] Starting subtest: reset
[556.099423] Subtest reset: SUCCESS (0.176s)
[556.231810] [083/133] (510s left) syncobj_timeline (reset-unsignaled)
[556.292615] Starting subtest: reset-unsignaled
[556.294642] Subtest reset-unsignaled: SUCCESS (0.000s)
[556.409238] [084/133] (509s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[556.505054] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[556.508501] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[556.613220] [085/133] (509s left) prime_self_import (basic-llseek-size)
[556.652638] Starting subtest: basic-llseek-size
[556.678864] Subtest basic-llseek-size: SUCCESS (0.028s)
[556.798478] [086/133] (509s left) gem_exec_schedule (preempt-other)
[556.873164] Starting subtest: preempt-other
[556.875054] Starting dynamic subtest: rcs0
[556.937738] Dynamic subtest rcs0: SUCCESS (0.069s)
[556.953371] Starting dynamic subtest: bcs0
[557.004285] Dynamic subtest bcs0: SUCCESS (0.066s)
[557.018863] Starting dynamic subtest: vcs0
[557.069802] Dynamic subtest vcs0: SUCCESS (0.064s)
[557.082733] Starting dynamic subtest: vcs1
[557.133588] Dynamic subtest vcs1: SUCCESS (0.063s)
[557.146894] Starting dynamic subtest: vecs0
[557.204506] Dynamic subtest vecs0: SUCCESS (0.071s)
[557.218207] Starting dynamic subtest: ccs0
[557.274545] Dynamic subtest ccs0: SUCCESS (0.069s)
[557.277202] Subtest preempt-other: SUCCESS (0.407s)
[558.230396] [087/133] (508s left) gem_pxp (create-protected-buffer)
[558.332643] Starting subtest: create-protected-buffer
[558.335001] Subtest create-protected-buffer: SUCCESS (0.000s)
[558.439750] [088/133] (508s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[558.544572] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[558.548890] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[558.661590] [089/133] (507s left) gem_mmap_wc (set-cache-level)
[558.733411] Subtest set-cache-level: SKIP (0.000s)
[558.794367] [090/133] (507s left) kms_busy (extended-pageflip-hang-oldfb)
[558.889691] Starting subtest: extended-pageflip-hang-oldfb
[558.891557] Starting dynamic subtest: pipe-A
[559.323213] Dynamic subtest pipe-A: SUCCESS (0.433s)
[559.333773] Starting dynamic subtest: pipe-D
[560.481835] Dynamic subtest pipe-D: SUCCESS (1.155s)
[560.484082] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.593s)
[561.326074] [091/133] (505s left) kms_psr (psr-cursor-mmap-gtt)
[561.428010] Starting subtest: psr-cursor-mmap-gtt
[561.430287] Starting dynamic subtest: eDP-1
[563.118146] Dynamic subtest eDP-1: SUCCESS (1.692s)
[563.120469] Subtest psr-cursor-mmap-gtt: SUCCESS (1.693s)
[563.980984] [092/133] (502s left) kms_async_flips (test-time-stamp)
[564.087785] Starting subtest: test-time-stamp
[564.464994] Starting dynamic subtest: pipe-A-eDP-1
[565.277215] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.811s)
[565.648973] Starting dynamic subtest: pipe-B-eDP-1
[566.405673] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.762s)
[566.788923] Starting dynamic subtest: pipe-C-eDP-1
[567.550911] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.766s)
[567.918641] Starting dynamic subtest: pipe-D-eDP-1
[568.678547] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.766s)
[568.681004] Subtest test-time-stamp: SUCCESS (4.589s)
[569.838913] [093/133] (496s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[570.227672] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[571.045467] [094/133] (495s left) gem_close_race (multigpu-basic-threads)
[571.131207] Starting subtest: multigpu-basic-threads
[571.135953] Subtest multigpu-basic-threads: SKIP (0.000s)
[571.343467] [095/133] (495s left) prime_mmap (test_correct_cpu_write)
[571.398413] Starting subtest: test_correct_cpu_write
[571.400723] Starting dynamic subtest: test_correct_cpu_write-smem
[571.403050] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[571.405343] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[571.516460] [096/133] (495s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[571.609314] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[571.611515] Starting dynamic subtest: pipe-A-eDP-1
[571.682756] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[571.694435] Starting dynamic subtest: pipe-B-eDP-1
[572.838435] Dynamic subtest pipe-B-eDP-1: SKIP (1.153s)
[572.843196] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.233s)
[574.039505] [097/133] (492s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[574.090675] Starting subtest: etime-single-wait-for-submit-submitted
[574.195704] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.105s)
[574.273475] [098/133] (492s left) perf (non-zero-reason)
[574.408379] Starting subtest: non-zero-reason
[574.410289] Starting dynamic subtest: 0-rcs0
[579.696389] Dynamic subtest 0-rcs0: SUCCESS (5.288s)
[579.709769] Starting dynamic subtest: 1-vcs1
[583.555126] Dynamic subtest 1-vcs1: SUCCESS (3.858s)
[583.557903] Subtest non-zero-reason: SUCCESS (9.148s)
[583.601629] [099/133] (483s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[583.712809] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[583.721822] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.010s)
[583.812846] [100/133] (483s left) gem_fence_thrash (bo-write-verify-y)
[583.848565] Starting subtest: bo-write-verify-y
[583.881075] Subtest bo-write-verify-y: SKIP (0.028s)
[583.951516] [101/133] (483s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[584.045427] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[584.049735] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[584.130085] [102/133] (482s left) prime_vgem (busy)
[584.211067] Starting subtest: busy
[584.213267] Starting dynamic subtest: rcs0
[584.286606] Dynamic subtest rcs0: SUCCESS (0.077s)
[584.297155] Starting dynamic subtest: bcs0
[584.354658] Dynamic subtest bcs0: SUCCESS (0.068s)
[584.364299] Starting dynamic subtest: vcs0
[584.401544] Dynamic subtest vcs0: SUCCESS (0.046s)
[584.411485] Starting dynamic subtest: vcs1
[584.447141] Dynamic subtest vcs1: SUCCESS (0.045s)
[584.456795] Starting dynamic subtest: vecs0
[584.494549] Dynamic subtest vecs0: SUCCESS (0.047s)
[584.504170] Starting dynamic subtest: ccs0
[584.540476] Dynamic subtest ccs0: SUCCESS (0.045s)
[584.542720] Subtest busy: SUCCESS (0.333s)
[584.675394] [103/133] (482s left) gem_eio (in-flight-suspend)
[584.886281] Starting subtest: in-flight-suspend
[627.638471] Subtest in-flight-suspend: SUCCESS (13.288s)
[627.785650] [104/133] (439s left) kms_vblank (wait-forked-busy)
[627.884090] Starting subtest: wait-forked-busy
[627.886714] Starting dynamic subtest: pipe-A-eDP-1
[629.768764] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.896s)
[629.784522] Starting dynamic subtest: pipe-D-eDP-1
[632.364909] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.609s)
[632.367826] Subtest wait-forked-busy: SUCCESS (4.510s)
[633.171182] [105/133] (434s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[633.268758] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[633.273788] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[633.342800] [106/133] (433s left) gem_exec_reloc (basic-wc-active)
[633.398641] Subtest basic-wc-active: SKIP (0.000s)
[633.465215] [107/133] (433s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[633.554624] Starting subtest: y-tiled-64bpp-rotate-180
[633.559229] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[633.661103] [108/133] (433s left) i915_query (query-topology-known-pci-ids)
[633.715207] Starting subtest: query-topology-known-pci-ids
[633.720662] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[633.822754] [109/133] (433s left) kms_cdclk (plane-scaling)
[633.916563] Starting subtest: plane-scaling
[633.918790] Starting dynamic subtest: pipe-A-eDP-1
[634.208007] Dynamic subtest pipe-A-eDP-1: SKIP (0.290s)
[634.218692] Starting dynamic subtest: pipe-B-eDP-1
[634.223366] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[634.232603] Starting dynamic subtest: pipe-C-eDP-1
[634.237793] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[634.247984] Starting dynamic subtest: pipe-D-eDP-1
[634.252973] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[634.258089] Subtest plane-scaling: SKIP (0.298s)
[635.007295] [110/133] (432s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[635.112469] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[635.117778] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[635.202434] [111/133] (432s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[635.290865] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[635.293692] Starting dynamic subtest: pipe-A-default-mode
[636.460671] Dynamic subtest pipe-A-default-mode: SKIP (1.171s)
[636.465626] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.173s)
[636.617237] [112/133] (430s left) gem_userptr_blits (access-control)
[636.691028] Starting subtest: access-control
[636.696317] Subtest access-control: SKIP (0.000s)
[636.800231] [113/133] (430s left) perf_pmu (busy-idle-no-semaphores)
[636.845857] Starting subtest: busy-idle-no-semaphores
[636.848730] Starting dynamic subtest: rcs0
[637.509298] Dynamic subtest rcs0: SUCCESS (0.666s)
[637.522652] Starting dynamic subtest: bcs0
[638.159310] Dynamic subtest bcs0: SUCCESS (0.650s)
[638.171721] Starting dynamic subtest: vcs0
[638.811260] Dynamic subtest vcs0: SUCCESS (0.651s)
[638.824007] Starting dynamic subtest: vcs1
[640.256422] Dynamic subtest vcs1: SUCCESS (1.446s)
[640.269114] Starting dynamic subtest: vecs0
[642.240370] Dynamic subtest vecs0: SUCCESS (1.985s)
[642.253038] Starting dynamic subtest: ccs0
[644.226738] Dynamic subtest ccs0: SUCCESS (1.987s)
[644.229630] Subtest busy-idle-no-semaphores: SUCCESS (7.398s)
[644.345581] [114/133] (423s left) gem_ctx_freq (sysfs)
[644.422771] Starting subtest: sysfs
[644.425662] Starting dynamic subtest: gt0
[649.954499] Dynamic subtest gt0: SUCCESS (5.537s)
[649.965300] Starting dynamic subtest: gt1
[691.607817] Dynamic subtest gt1: SUCCESS (41.652s)
[691.610412] Subtest sysfs: SUCCESS (47.193s)
[691.727713] [115/133] (375s left) dumb_buffer (create-valid-dumb)
[691.771975] Starting subtest: create-valid-dumb
[691.774350] Subtest create-valid-dumb: SUCCESS (0.000s)
[691.887344] [116/133] (375s left) gem_media_fill (media-fill)
[691.939739] Subtest media-fill: SKIP (0.000s)
[692.062647] [117/133] (375s left) gem_exec_nop (basic-parallel)
[692.136293] Starting subtest: basic-parallel
[707.611209] Subtest basic-parallel: SUCCESS (15.489s)
[707.835446] [118/133] (359s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[707.889964] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[707.892992] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[707.996493] [119/133] (359s left) gem_partial_pwrite_pread (write-snoop)
[708.060999] Subtest write-snoop: SKIP (0.000s)
[708.140625] [120/133] (359s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[708.248802] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[708.253733] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[708.343914] [121/133] (359s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[708.439787] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[709.351877] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.914s)
[709.520216] [122/133] (358s left) gem_render_copy (x-tiled)
[709.580616] Starting subtest: x-tiled
[709.582952] Starting dynamic subtest: smem
[709.624990] Dynamic subtest smem: SUCCESS (0.044s)
[709.627917] Subtest x-tiled: SUCCESS (0.045s)
[709.812055] [123/133] (358s left) gem_exec_reloc (basic-wc-read-active)
[709.871837] Subtest basic-wc-read-active: SKIP (0.000s)
[709.939506] [124/133] (358s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[710.049798] Starting subtest: basic-flip-before-cursor-varying-size
[710.974219] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.924s)
[711.841576] [125/133] (356s left) gem_tiled_wb
[711.967552] [126/133] (356s left) gem_exec_balancer (invalid-bonds)
[712.024994] Starting subtest: invalid-bonds
[712.030506] Subtest invalid-bonds: SKIP (0.000s)
[712.309861] [127/133] (355s left) api_intel_allocator (execbuf-with-allocator)
[712.355746] Starting subtest: execbuf-with-allocator
[712.358598] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[712.466697] [128/133] (355s left) gem_exec_fence (basic-busy-all)
[712.537682] Starting subtest: basic-busy-all
[712.629723] Subtest basic-busy-all: SUCCESS (0.095s)
[714.725302] [129/133] (353s left) gem_exec_reloc (basic-cpu-read-noreloc)
[714.781623] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[714.845224] [130/133] (353s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[714.945800] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[721.624206] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.684s)
[721.761415] [131/133] (346s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[721.871720] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[721.876641] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[721.967639] [132/133] (346s left) i915_pciid
[722.115579] [133/133] (346s left) i915_drm_fdinfo (memory-info-resident)
[722.158492] Starting subtest: memory-info-resident
[722.160917] Starting dynamic subtest: smem0
[724.742597] Dynamic subtest smem0: SUCCESS (2.583s)
[724.744768] Subtest memory-info-resident: SUCCESS (2.584s)
[724.813389] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_pm_lpsp
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_cursor_crc
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_chamelium_edid
results: parsing output: 9/ for test: kms_flip_scaled_crc
results: parsing output: 10/ for test: kms_plane_alpha_blend
results: parsing output: 11/ for test: syncobj_eventfd
results: parsing output: 12/ for test: gem_ctx_sseu
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_cursor_edge_walk
results: parsing output: 15/ for test: fbdev
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: gem_flink_basic
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: gem_exec_reloc
results: parsing output: 21/ for test: gem_ctx_persistence
results: parsing output: 22/ for test: sw_sync
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_feature_discovery
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: kms_invalid_mode
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_render_copy
results: parsing output: 29/ for test: i915_pm_rps
results: parsing output: 30/ for test: gen7_exec_parse
results: parsing output: 31/ for test: syncobj_wait
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_ppgtt
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: api_intel_bb
results: parsing output: 40/ for test: kms_setmode
results: parsing output: 41/ for test: kms_pm_rpm
results: parsing output: 42/ for test: gem_exec_whisper
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_plane
results: parsing output: 48/ for test: kms_content_protection
results: parsing output: 49/ for test: kms_color_pipeline
results: parsing output: 50/ for test: gem_lmem_swapping
results: parsing output: 51/ for test: kms_psr2_sf
results: parsing output: 52/ for test: kms_cursor_legacy
results: parsing output: 53/ for test: kms_plane_scaling
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: gem_pxp
results: parsing output: 57/ for test: gem_softpin
results: parsing output: 58/ for test: kms_plane_scaling
results: parsing output: 59/ for test: gem_ctx_exec
results: parsing output: 60/ for test: gem_exec_schedule
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: gem_exec_capture
results: parsing output: 63/ for test: kms_async_flips
results: parsing output: 64/ for test: kms_dp_aux_dev
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: gem_userptr_blits
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: gem_exec_fence
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: gem_mmap_gtt
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_selftest
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_lease
results: parsing output: 78/ for test: gem_exec_params
results: parsing output: 79/ for test: i915_pm_rpm
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: gem_workarounds
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: prime_self_import
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: gem_pxp
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_mmap_wc
results: parsing output: 89/ for test: kms_busy
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: kms_async_flips
results: parsing output: 92/ for test: kms_chamelium_hpd
results: parsing output: 93/ for test: gem_close_race
results: parsing output: 94/ for test: prime_mmap
results: parsing output: 95/ for test: kms_psr2_sf
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: perf
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: gem_fence_thrash
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: prime_vgem
results: parsing output: 102/ for test: gem_eio
results: parsing output: 103/ for test: kms_vblank
results: parsing output: 104/ for test: kms_plane
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: i915_query
results: parsing output: 108/ for test: kms_cdclk
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_flip_scaled_crc
results: parsing output: 111/ for test: gem_userptr_blits
results: parsing output: 112/ for test: perf_pmu
results: parsing output: 113/ for test: gem_ctx_freq
results: parsing output: 114/ for test: dumb_buffer
results: parsing output: 115/ for test: gem_media_fill
results: parsing output: 116/ for test: gem_exec_nop
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: gem_partial_pwrite_pread
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: gem_render_copy
results: parsing output: 122/ for test: gem_exec_reloc
results: parsing output: 123/ for test: kms_cursor_legacy
results: parsing output: 124/ for test: gem_tiled_wb
results: parsing output: 125/ for test: gem_exec_balancer
results: parsing output: 126/ for test: api_intel_allocator
results: parsing output: 127/ for test: gem_exec_fence
results: parsing output: 128/ for test: gem_exec_reloc
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: i915_pciid
results: parsing output: 132/ for test: i915_drm_fdinfo
Done.