[57.885429] Initializing watchdogs
[57.885474]   /dev/watchdog0
[57.899350] [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.903676] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.906219] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.909548] [001/133] (960s left) kms_psr (fbc-psr-primary-mmap-gtt)
[58.032817] Starting subtest: fbc-psr-primary-mmap-gtt
[58.035189] Starting dynamic subtest: eDP-1
[58.039239] Dynamic subtest eDP-1: SKIP (0.000s)
[58.043378] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s)
[58.105225] [002/133] (960s left) gen9_exec_parse (bb-secure)
[58.170652] Subtest bb-secure: SKIP (0.000s)
[58.252850] [003/133] (960s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[58.354757] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[58.359309] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.002s)
[58.499169] [004/133] (960s left) kms_invalid_mode (bad-hsync-start)
[58.588101] Starting subtest: bad-hsync-start
[58.590401] Starting dynamic subtest: pipe-A-eDP-1
[58.886119] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.298s)
[58.894202] Starting dynamic subtest: pipe-B-eDP-1
[58.896108] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[58.902260] Starting dynamic subtest: pipe-C-eDP-1
[58.904096] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[58.911062] Starting dynamic subtest: pipe-D-eDP-1
[58.913202] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[58.915447] Subtest bad-hsync-start: SUCCESS (0.305s)
[59.722859] [005/133] (958s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[59.839715] Starting subtest: fbcpsr-tiling-linear
[66.382138] Subtest fbcpsr-tiling-linear: SUCCESS (6.570s)
[66.507179] [006/133] (952s left) kms_color_pipeline (plane-ctm3x4)
[66.601345] Starting subtest: plane-ctm3x4
[66.782039] Starting dynamic subtest: pipe-A-plane-0
[67.099594] Dynamic subtest pipe-A-plane-0: FAIL (0.142s)
[67.110349] Starting dynamic subtest: pipe-A-plane-1
[67.326810] Dynamic subtest pipe-A-plane-1: FAIL (0.172s)
[67.335284] Starting dynamic subtest: pipe-A-plane-2
[67.549920] Dynamic subtest pipe-A-plane-2: FAIL (0.164s)
[68.431414] Starting dynamic subtest: pipe-B-plane-0
[68.819057] Dynamic subtest pipe-B-plane-0: FAIL (0.119s)
[68.826055] Starting dynamic subtest: pipe-B-plane-1
[69.132230] Dynamic subtest pipe-B-plane-1: FAIL (0.133s)
[69.141422] Starting dynamic subtest: pipe-B-plane-2
[69.444338] Dynamic subtest pipe-B-plane-2: FAIL (0.629s)
[70.470366] Starting dynamic subtest: pipe-C-plane-0
[70.931844] Dynamic subtest pipe-C-plane-0: FAIL (0.107s)
[70.940403] Starting dynamic subtest: pipe-C-plane-1
[71.333276] Dynamic subtest pipe-C-plane-1: FAIL (0.590s)
[71.340729] Starting dynamic subtest: pipe-C-plane-2
[71.688803] Dynamic subtest pipe-C-plane-2: FAIL (0.124s)
[72.502075] Starting dynamic subtest: pipe-D-plane-0
[73.060189] Dynamic subtest pipe-D-plane-0: FAIL (0.119s)
[73.069093] Starting dynamic subtest: pipe-D-plane-1
[73.532909] Dynamic subtest pipe-D-plane-1: FAIL (0.604s)
[73.542162] Starting dynamic subtest: pipe-D-plane-2
[73.961490] Dynamic subtest pipe-D-plane-2: FAIL (0.538s)
[74.047613] Subtest plane-ctm3x4: FAIL (7.453s)
[74.865007] [007/133] (943s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[74.981019] Starting subtest: 4-tiled-16bpp-rotate-180
[76.346774] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.367s)
[76.484767] [008/133] (942s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[76.543591] Starting subtest: wait-all-for-submit-delayed-submit
[76.648704] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s)
[76.724659] [009/133] (942s left) kms_plane_multiple (tiling-y)
[76.811859] Starting subtest: tiling-y
[76.816246] Subtest tiling-y: SKIP (0.000s)
[76.883077] [010/133] (941s left) gem_gpgpu_fill (basic)
[76.937721] Starting subtest: basic
[76.940069] Starting dynamic subtest: smem
[76.944897] Dynamic subtest smem: SUCCESS (0.008s)
[76.947188] Subtest basic: SUCCESS (0.008s)
[77.061054] [011/133] (941s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[77.143443] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[77.145716] Starting dynamic subtest: pipe-A-eDP-1
[77.441310] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.263s)
[77.451083] Starting dynamic subtest: pipe-B-eDP-1
[78.742068] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.303s)
[78.750067] Starting dynamic subtest: pipe-C-eDP-1
[79.964545] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.222s)
[79.973022] Starting dynamic subtest: pipe-D-eDP-1
[81.175271] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.208s)
[81.177696] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.000s)
[82.278265] [012/133] (936s left) kms_vblank (ts-continuation-modeset)
[82.361627] Starting subtest: ts-continuation-modeset
[82.363863] Starting dynamic subtest: pipe-A-eDP-1
[83.849373] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.489s)
[83.864552] Starting dynamic subtest: pipe-D-eDP-1
[86.020451] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.167s)
[86.022764] Subtest ts-continuation-modeset: SUCCESS (3.659s)
[86.822224] [013/133] (932s left) kms_selftest (drm_dp_mst_helper)
[86.864763] Starting subtest: drm_dp_mst_helper
[86.880342] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[87.003135] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.122s)
[87.015326] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[87.109247] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.104s)
[87.116812] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[87.197785] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.090s)
[87.200104] Subtest drm_dp_mst_helper: SUCCESS (0.335s)
[87.346864] [014/133] (931s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[87.405113] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[87.409588] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[87.586093] [015/133] (931s left) kms_flip (flip-vs-suspend)
[87.675202] Starting subtest: flip-vs-suspend
[87.677515] Starting dynamic subtest: A-eDP1
[137.340151] Dynamic subtest A-eDP1: SUCCESS (4.659s)
[137.349169] Starting dynamic subtest: B-eDP1
[186.326460] Dynamic subtest B-eDP1: SUCCESS (4.479s)
[186.335840] Starting dynamic subtest: C-eDP1
[235.318645] Dynamic subtest C-eDP1: SUCCESS (4.572s)
[235.332015] Starting dynamic subtest: D-eDP1
[284.332119] Dynamic subtest D-eDP1: SUCCESS (4.536s)
[284.334755] Subtest flip-vs-suspend: SUCCESS (18.257s)
[285.487790] [016/133] (733s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[285.610856] Starting subtest: cursorB-vs-flipA-toggle
[285.615469] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[285.747647] [017/133] (733s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[285.803228] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[285.911067] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.110s)
[285.985171] [018/133] (733s left) kms_plane (plane-panning-bottom-right)
[286.076042] Starting subtest: plane-panning-bottom-right
[286.078161] Starting dynamic subtest: pipe-A
[287.734380] Dynamic subtest pipe-A: SUCCESS (1.691s)
[287.744227] Starting dynamic subtest: pipe-B
[290.053487] Dynamic subtest pipe-B: SUCCESS (2.351s)
[290.056496] Subtest plane-panning-bottom-right: SUCCESS (4.045s)
[290.854010] [019/133] (728s left) prime_vgem (basic-read)
[290.949862] Starting subtest: basic-read
[290.960631] Subtest basic-read: SKIP (0.011s)
[291.065207] [FACT prime_vgem (basic-read)] new: kernel.kmod_is_loaded.vgem: true
[291.068536] [020/133] (728s left) kms_flip (dpms-off-confusion-interruptible)
[291.172353] Starting subtest: dpms-off-confusion-interruptible
[291.175249] Starting dynamic subtest: A-eDP1
[299.871305] Dynamic subtest A-eDP1: SUCCESS (8.755s)
[299.882436] Starting dynamic subtest: B-eDP1
[308.541736] Dynamic subtest B-eDP1: SUCCESS (8.689s)
[308.551194] Starting dynamic subtest: C-eDP1
[317.151710] Dynamic subtest C-eDP1: SUCCESS (8.614s)
[317.165364] Starting dynamic subtest: D-eDP1
[325.774226] Dynamic subtest D-eDP1: SUCCESS (8.618s)
[325.777110] Subtest dpms-off-confusion-interruptible: SUCCESS (34.687s)
[326.942442] [021/133] (692s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[327.036190] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[327.041105] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[327.129910] [022/133] (692s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[327.224697] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[327.229771] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[327.326727] [023/133] (691s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[327.431020] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[327.433288] Starting dynamic subtest: pipe-A-eDP-1
[327.559156] Dynamic subtest pipe-A-eDP-1: SKIP (0.133s)
[327.569064] Starting dynamic subtest: pipe-B-eDP-1
[328.727047] Dynamic subtest pipe-B-eDP-1: SKIP (1.166s)
[328.731338] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.301s)
[329.930265] [024/133] (689s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[330.045742] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[336.750046] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.706s)
[336.867773] [025/133] (682s left) gem_ctx_engines (execute-one)
[336.925995] Starting subtest: execute-one
[339.315168] Subtest execute-one: SUCCESS (2.390s)
[339.548397] [026/133] (679s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[339.595225] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[339.597979] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[339.699771] [027/133] (679s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[339.806292] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[343.413910] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.611s)
[344.554555] [028/133] (674s left) gem_eio (wait-1us)
[344.797099] Starting subtest: wait-1us
[345.153418] Subtest wait-1us: SUCCESS (0.355s)
[345.294254] [029/133] (674s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[345.400326] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[345.405562] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[345.486235] [030/133] (674s left) perf_pmu (invalid-open)
[345.530340] Starting subtest: invalid-open
[345.532512] Subtest invalid-open: SUCCESS (0.000s)
[345.628272] [031/133] (674s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[345.714653] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[345.718781] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[346.875424] [032/133] (672s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[346.980705] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[353.708541] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.732s)
[353.894016] [033/133] (665s left) kms_chamelium_frames (hdmi-aspect-ratio)
[354.309905] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[355.090680] [034/133] (664s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[355.195380] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[355.200496] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[355.260924] [035/133] (664s left) gem_eio (in-flight-10ms)
[355.486895] Starting subtest: in-flight-10ms
[364.476929] Subtest in-flight-10ms: SUCCESS (8.993s)
[364.603153] [036/133] (655s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[364.721549] Starting subtest: 2x-flip-vs-cursor-atomic
[364.727166] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[364.870533] [037/133] (655s left) kms_cursor_crc (cursor-onscreen-32x32)
[365.022074] Starting subtest: cursor-onscreen-32x32
[365.067788] Subtest cursor-onscreen-32x32: SKIP (0.039s)
[365.368229] [038/133] (654s left) kms_frontbuffer_tracking (fbc-1p-rte)
[365.466112] Starting subtest: fbc-1p-rte
[370.897487] Subtest fbc-1p-rte: SUCCESS (5.437s)
[372.109776] [039/133] (647s left) gem_exec_fence (nb-await)
[372.300898] Starting subtest: nb-await
[372.303844] Starting dynamic subtest: rcs0
[372.370985] Dynamic subtest rcs0: SUCCESS (0.070s)
[372.382256] Starting dynamic subtest: bcs0
[372.430283] Dynamic subtest bcs0: SUCCESS (0.057s)
[372.441316] Starting dynamic subtest: vcs0
[372.490678] Dynamic subtest vcs0: SUCCESS (0.058s)
[372.501644] Starting dynamic subtest: vcs1
[372.549993] Dynamic subtest vcs1: SUCCESS (0.057s)
[372.561514] Starting dynamic subtest: vecs0
[372.611434] Dynamic subtest vecs0: SUCCESS (0.059s)
[372.623902] Starting dynamic subtest: ccs0
[372.671028] Dynamic subtest ccs0: SUCCESS (0.058s)
[372.674140] Subtest nb-await: SUCCESS (0.372s)
[373.533822] [040/133] (646s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[373.631784] Starting subtest: fbc-psr2-primary-mmap-gtt
[373.634421] Starting dynamic subtest: eDP-1
[373.639408] Dynamic subtest eDP-1: SKIP (0.000s)
[373.644315] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[373.707129] [041/133] (646s left) gem_exec_fence (basic-await)
[373.874830] Starting subtest: basic-await
[373.877282] Starting dynamic subtest: rcs0
[373.950611] Dynamic subtest rcs0: SUCCESS (0.076s)
[373.964617] Starting dynamic subtest: bcs0
[374.023890] Dynamic subtest bcs0: SUCCESS (0.072s)
[374.035848] Starting dynamic subtest: vcs0
[374.097263] Dynamic subtest vcs0: SUCCESS (0.072s)
[374.109713] Starting dynamic subtest: vcs1
[374.169669] Dynamic subtest vcs1: SUCCESS (0.071s)
[374.182120] Starting dynamic subtest: vecs0
[374.242703] Dynamic subtest vecs0: SUCCESS (0.072s)
[374.253282] Starting dynamic subtest: ccs0
[374.316888] Dynamic subtest ccs0: SUCCESS (0.072s)
[374.319862] Subtest basic-await: SUCCESS (0.444s)
[376.568200] [042/133] (643s left) core_setmaster_vs_auth
[376.729732] [043/133] (643s left) kms_content_protection (atomic-dpms-hdcp14)
[376.876540] Starting subtest: atomic-dpms-hdcp14
[376.882139] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[376.983888] [044/133] (643s left) kms_cdclk (plane-scaling)
[377.074955] Starting subtest: plane-scaling
[377.077316] Starting dynamic subtest: pipe-A-eDP-1
[377.378300] Dynamic subtest pipe-A-eDP-1: SKIP (0.301s)
[377.388485] Starting dynamic subtest: pipe-B-eDP-1
[377.394514] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[377.404094] Starting dynamic subtest: pipe-C-eDP-1
[377.409913] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[377.425147] Starting dynamic subtest: pipe-D-eDP-1
[377.430278] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[377.435332] Subtest plane-scaling: SKIP (0.309s)
[378.236226] [045/133] (642s left) i915_pm_rpm (system-suspend-execbuf)
[379.775675] Starting subtest: system-suspend-execbuf
[438.205918] Subtest system-suspend-execbuf: SUCCESS (43.137s)
[438.598454] [046/133] (581s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[438.690848] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[438.693205] Starting dynamic subtest: pipe-A-eDP-1
[438.718001] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[438.729030] Starting dynamic subtest: pipe-B-eDP-1
[438.754364] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[438.763767] Starting dynamic subtest: pipe-C-eDP-1
[438.789100] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[438.798771] Starting dynamic subtest: pipe-D-eDP-1
[438.824910] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[438.830081] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[440.845168] [047/133] (579s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[440.948052] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[440.950373] Starting dynamic subtest: pipe-A
[440.969065] Dynamic subtest pipe-A: SKIP (0.017s)
[440.980891] Starting dynamic subtest: pipe-B
[440.999155] Dynamic subtest pipe-B: SKIP (0.029s)
[441.008861] Starting dynamic subtest: pipe-C
[441.027033] Dynamic subtest pipe-C: SKIP (0.029s)
[441.035924] Starting dynamic subtest: pipe-D
[441.056919] Dynamic subtest pipe-D: SKIP (0.029s)
[441.060725] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.107s)
[441.153443] [048/133] (579s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[441.272483] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[441.277929] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[441.342375] [049/133] (579s left) kms_addfb_basic (unused-modifier)
[441.403873] Starting subtest: unused-modifier
[441.405961] Subtest unused-modifier: SUCCESS (0.000s)
[441.537807] [050/133] (578s left) gem_exec_flush (basic-wb-rw-default)
[441.606148] Starting subtest: basic-wb-rw-default
[447.060654] Subtest basic-wb-rw-default: SUCCESS (5.453s)
[447.240182] [051/133] (573s left) syncobj_wait (invalid-signal-illegal-handle)
[447.294410] Starting subtest: invalid-signal-illegal-handle
[447.297203] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[447.396731] [052/133] (573s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[447.506235] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[447.509083] Starting dynamic subtest: pipe-A-eDP-1
[458.848422] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.351s)
[458.858139] Starting dynamic subtest: pipe-B-eDP-1
[470.871619] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.028s)
[470.874324] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.382s)
[471.704515] [053/133] (548s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[471.800209] Starting subtest: x-tiled-16bpp-rotate-270
[471.819470] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[471.948728] [054/133] (548s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[472.049180] Starting subtest: primary-x-tiled-reflect-x-0
[479.371190] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.327s)
[480.590913] [055/133] (540s left) gem_softpin (zero)
[480.649270] Starting subtest: zero
[480.658191] Subtest zero: SUCCESS (0.006s)
[480.766366] [056/133] (540s left) core_setmaster (master-drop-set-root)
[480.820005] Starting subtest: master-drop-set-root
[480.844881] Subtest master-drop-set-root: SUCCESS (0.025s)
[480.894129] [057/133] (539s left) gem_exec_schedule (smoketest)
[481.080729] Starting subtest: smoketest
[481.083187] Starting dynamic subtest: rcs0
[486.645279] Dynamic subtest rcs0: SUCCESS (5.507s)
[486.656984] Starting dynamic subtest: bcs0
[492.175083] Dynamic subtest bcs0: SUCCESS (5.527s)
[492.191075] Starting dynamic subtest: vcs0
[497.708062] Dynamic subtest vcs0: SUCCESS (5.522s)
[497.720136] Starting dynamic subtest: vcs1
[503.234092] Dynamic subtest vcs1: SUCCESS (5.523s)
[503.248158] Starting dynamic subtest: vecs0
[508.751376] Dynamic subtest vecs0: SUCCESS (5.513s)
[508.763599] Starting dynamic subtest: ccs0
[514.275666] Dynamic subtest ccs0: SUCCESS (5.527s)
[514.278403] Subtest smoketest: SUCCESS (33.131s)
[514.409154] [058/133] (506s left) api_intel_bb (misplaced-blitter)
[514.457794] Starting subtest: misplaced-blitter
[514.465747] Subtest misplaced-blitter: SUCCESS (0.010s)
[514.593147] [059/133] (506s left) gem_tiled_partial_pwrite_pread (reads)
[514.648211] Subtest reads: SKIP (0.000s)
[514.715057] [060/133] (506s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[514.819061] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[515.432266] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.615s)
[515.593329] [061/133] (505s left) kms_vrr (lobf)
[515.691074] Starting subtest: lobf
[515.696338] Subtest lobf: SKIP (0.000s)
[515.760666] [062/133] (505s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[516.144344] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[516.977319] [063/133] (504s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[517.033783] Starting subtest: invalid-bsd2-flag-on-vebox
[517.036289] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[517.134801] [064/133] (503s left) kms_plane_alpha_blend (alpha-opaque-fb)
[517.225978] Starting subtest: alpha-opaque-fb
[517.509706] Starting dynamic subtest: pipe-A-eDP-1
[518.142371] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.632s)
[518.151704] Starting dynamic subtest: pipe-D-eDP-1
[519.436398] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.290s)
[519.439069] Subtest alpha-opaque-fb: SUCCESS (2.210s)
[520.269810] [065/133] (500s left) syncobj_wait (single-wait-all-for-submit-signaled)
[520.337554] Starting subtest: single-wait-all-for-submit-signaled
[520.340319] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[520.441625] [066/133] (500s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[520.551447] Starting subtest: yf-tiled-addfb-size-offset-overflow
[520.556785] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[520.646479] [067/133] (500s left) kms_getfb (getfb-handle-protection)
[520.737597] Starting subtest: getfb-handle-protection
[520.760566] Subtest getfb-handle-protection: SUCCESS (0.023s)
[520.869255] [068/133] (500s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[520.962284] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[520.967429] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[521.063283] [069/133] (500s left) api_intel_allocator (simple-allocator)
[521.118050] Starting subtest: simple-allocator
[521.120576] Starting dynamic subtest: basic
[521.122753] Dynamic subtest basic: SUCCESS (0.004s)
[521.134798] Starting dynamic subtest: parallel-one
[521.323154] Dynamic subtest parallel-one: SUCCESS (0.203s)
[521.333272] Starting dynamic subtest: print
[521.335850] Dynamic subtest print: SUCCESS (0.000s)
[521.345592] Starting dynamic subtest: reuse
[521.348492] Dynamic subtest reuse: SUCCESS (0.000s)
[521.358308] Starting dynamic subtest: reserve
[521.361258] Dynamic subtest reserve: SUCCESS (0.000s)
[521.370784] Starting dynamic subtest: fork-reopen-allocator
[521.373431] Dynamic subtest fork-reopen-allocator: SUCCESS (0.015s)
[521.376228] Subtest simple-allocator: SUCCESS (0.226s)
[521.466942] [070/133] (499s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[521.577423] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[522.556247] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.978s)
[522.668486] [071/133] (498s left) kms_psr (pr-sprite-blt)
[522.783417] Starting subtest: pr-sprite-blt
[522.788093] Subtest pr-sprite-blt: SKIP (0.000s)
[522.856124] [072/133] (498s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[522.912233] Starting subtest: invalid-signal-one-illegal-handle
[522.914472] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[523.001671] [073/133] (498s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[525.134793] Starting subtest: dpms-mode-unset-lpsp
[529.195953] Subtest dpms-mode-unset-lpsp: SUCCESS (4.065s)
[529.588964] [074/133] (491s left) gem_mmap_gtt (hang-busy)
[529.652330] Subtest hang-busy: SKIP (0.000s)
[529.720453] [075/133] (491s left) gem_exec_schedule (preempt-hang)
[529.914425] Starting subtest: preempt-hang
[529.917029] Starting dynamic subtest: rcs0
[530.198741] Dynamic subtest rcs0: SUCCESS (0.283s)
[530.215163] Starting dynamic subtest: bcs0
[530.433478] Dynamic subtest bcs0: SUCCESS (0.234s)
[530.443424] Starting dynamic subtest: vcs0
[530.654360] Dynamic subtest vcs0: SUCCESS (0.221s)
[530.664487] Starting dynamic subtest: vcs1
[530.876240] Dynamic subtest vcs1: SUCCESS (0.221s)
[530.887433] Starting dynamic subtest: vecs0
[531.101064] Dynamic subtest vecs0: SUCCESS (0.225s)
[531.111200] Starting dynamic subtest: ccs0
[531.327979] Dynamic subtest ccs0: SUCCESS (0.226s)
[531.330306] Subtest preempt-hang: SUCCESS (1.416s)
[532.134438] [076/133] (489s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[532.252312] Starting subtest: y-tiled-16bpp-rotate-0
[532.257240] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[532.351365] [077/133] (489s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[532.445898] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[532.471749] Starting dynamic subtest: pipe-A-plane-0
[532.771291] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[532.781242] Starting dynamic subtest: pipe-A-plane-3
[533.005416] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[534.141135] Starting dynamic subtest: pipe-B-plane-0
[534.435096] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[534.445455] Starting dynamic subtest: pipe-B-plane-3
[534.666990] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[534.987328] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.542s)
[535.823790] [078/133] (485s left) gem_ctx_sseu (invalid-sseu)
[535.887335] Subtest invalid-sseu: SKIP (0.000s)
[535.952791] [079/133] (485s left) gem_ctx_isolation (nonpriv)
[536.026326] Starting subtest: nonpriv
[536.029119] Starting dynamic subtest: rcs0
[536.227887] Dynamic subtest rcs0: SUCCESS (0.203s)
[536.237983] Starting dynamic subtest: bcs0
[536.465494] Dynamic subtest bcs0: SUCCESS (0.237s)
[536.476475] Starting dynamic subtest: vcs0
[536.703458] Dynamic subtest vcs0: SUCCESS (0.237s)
[536.715153] Starting dynamic subtest: vcs1
[538.209682] Dynamic subtest vcs1: SUCCESS (1.506s)
[538.219274] Starting dynamic subtest: vecs0
[540.213540] Dynamic subtest vecs0: SUCCESS (2.002s)
[540.225321] Starting dynamic subtest: ccs0
[542.261416] Dynamic subtest ccs0: SUCCESS (2.047s)
[542.264372] Subtest nonpriv: SUCCESS (6.239s)
[542.487340] [080/133] (479s left) kms_draw_crc (draw-method-mmap-gtt)
[542.581437] Starting subtest: draw-method-mmap-gtt
[542.586487] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[542.680202] [081/133] (479s left) gem_softpin (softpin)
[542.745471] Starting subtest: softpin
[575.075473] Subtest softpin: SUCCESS (32.331s)
[575.181927] [082/133] (446s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[575.294238] Starting subtest: fbc-1p-pri-indfb-multidraw
[588.394699] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.108s)
[589.826074] [083/133] (432s left) kms_pm_rpm (system-suspend-idle)
[592.165225] Starting subtest: system-suspend-idle
[614.972250] Subtest system-suspend-idle: SUCCESS (7.800s)
[615.360781] [084/133] (406s left) kms_getfb (getfb-handle-zero)
[615.471611] Starting subtest: getfb-handle-zero
[615.474106] Subtest getfb-handle-zero: SUCCESS (0.000s)
[615.585725] [085/133] (406s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[615.693658] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[615.698735] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[615.794218] [086/133] (406s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[615.918697] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[617.332601] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.427s)
[618.130666] [087/133] (403s left) gem_userptr_blits (probe)
[618.214732] Starting subtest: probe
[618.288126] Subtest probe: SUCCESS (0.074s)
[618.402904] [088/133] (403s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[618.494162] Starting subtest: fbc-shrfb-scaledprimary
[621.502716] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.033s)
[622.646566] [089/133] (399s left) kms_psr (psr2-sprite-blt)
[622.753671] Starting subtest: psr2-sprite-blt
[622.756446] Starting dynamic subtest: eDP-1
[624.519786] Dynamic subtest eDP-1: SUCCESS (1.773s)
[624.522512] Subtest psr2-sprite-blt: SUCCESS (1.774s)
[625.377884] [090/133] (396s left) gem_barrier_race (remote-request)
[625.443511] Starting subtest: remote-request
[625.446394] Starting dynamic subtest: rcs0
[630.615506] Dynamic subtest rcs0: SUCCESS (5.188s)
[630.623138] Subtest remote-request: SUCCESS (5.189s)
[630.749031] [091/133] (391s left) gen9_exec_parse (shadow-peek)
[630.801645] Subtest shadow-peek: SKIP (0.000s)
[630.902085] [092/133] (391s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[630.962634] Starting subtest: etime-single-wait-all-for-submit-submitted
[631.067229] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.105s)
[631.190568] [093/133] (391s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[631.279000] Starting subtest: primary-4-tiled-reflect-x-0
[638.455636] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.189s)
[639.623645] [094/133] (382s left) gem_tiling_max_stride
[639.742256] [095/133] (382s left) gem_ctx_persistence (legacy-engines-mixed)
[639.790667] Starting subtest: legacy-engines-mixed
[639.793714] Starting dynamic subtest: render
[639.886998] Dynamic subtest render: SUCCESS (0.096s)
[639.901475] Starting dynamic subtest: bsd1
[639.935804] Dynamic subtest bsd1: SUCCESS (0.046s)
[639.946738] Starting dynamic subtest: bsd2
[639.983979] Dynamic subtest bsd2: SUCCESS (0.046s)
[639.998877] Starting dynamic subtest: blt
[640.035686] Dynamic subtest blt: SUCCESS (0.050s)
[640.047603] Starting dynamic subtest: vebox
[640.089033] Dynamic subtest vebox: SUCCESS (0.051s)
[640.091844] Subtest legacy-engines-mixed: SUCCESS (0.300s)
[640.173799] [096/133] (382s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[640.264648] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[640.269756] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s)
[640.351765] [097/133] (382s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[640.461635] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[647.367510] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.908s)
[647.490688] [098/133] (375s left) i915_getparams_basic (basic-eu-total)
[647.554511] Starting subtest: basic-eu-total
[647.559894] Subtest basic-eu-total: SUCCESS (0.000s)
[647.659763] [099/133] (375s left) gem_render_tiled_blits (basic)
[647.713432] Subtest basic: SKIP (0.000s)
[647.793195] [100/133] (374s left) gem_ppgtt (shrink-vs-evict-any)
[647.852850] Starting subtest: shrink-vs-evict-any
[653.060677] Subtest shrink-vs-evict-any: SUCCESS (5.205s)
[653.151642] [101/133] (369s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[653.260746] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[653.265676] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[653.354735] [102/133] (369s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[653.448829] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[653.453861] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[653.551220] [103/133] (369s left) kms_async_flips (async-flip-dpms)
[653.638680] Starting subtest: async-flip-dpms
[654.012650] Starting dynamic subtest: pipe-A-eDP-1
[657.958576] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.945s)
[658.323716] Starting dynamic subtest: pipe-B-eDP-1
[661.136643] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.821s)
[661.511803] Starting dynamic subtest: pipe-C-eDP-1
[664.297665] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.797s)
[664.673787] Starting dynamic subtest: pipe-D-eDP-1
[667.466676] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.797s)
[667.469167] Subtest async-flip-dpms: SUCCESS (13.826s)
[668.657730] [104/133] (354s left) gem_lmem_swapping (smem-oom)
[668.708803] Subtest smem-oom: SKIP (0.000s)
[668.751742] [105/133] (354s left) gem_exec_params (invalid-ring)
[668.816654] Starting subtest: invalid-ring
[668.819515] Subtest invalid-ring: SUCCESS (0.000s)
[668.914033] [106/133] (354s left) kms_cursor_edge_walk (128x128-right-edge)
[669.005764] Starting subtest: 128x128-right-edge
[669.008589] Starting dynamic subtest: pipe-A-eDP-1
[672.423384] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.419s)
[672.434394] Starting dynamic subtest: pipe-D-eDP-1
[675.552901] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.129s)
[675.555864] Subtest 128x128-right-edge: SUCCESS (6.551s)
[676.353072] [107/133] (346s left) i915_power (sanity)
[676.417840] Starting subtest: sanity
[680.462383] Subtest sanity: SUCCESS (4.038s)
[682.112211] [108/133] (340s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[682.227892] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[682.233307] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[682.335100] [109/133] (340s left) gem_pwrite_snooped
[682.464661] [110/133] (340s left) sriov_basic (enable-vfs-bind-unbind-each)
[682.517304] Starting subtest: enable-vfs-bind-unbind-each
[682.519782] Starting dynamic subtest: numvfs-1
[682.607364] Dynamic subtest numvfs-1: FAIL (0.006s)
[682.618622] Starting dynamic subtest: numvfs-2
[682.701752] Dynamic subtest numvfs-2: FAIL (0.003s)
[682.711543] Starting dynamic subtest: numvfs-3
[682.787740] Dynamic subtest numvfs-3: FAIL (0.003s)
[682.797417] Starting dynamic subtest: numvfs-4
[682.873447] Dynamic subtest numvfs-4: FAIL (0.003s)
[682.882725] Starting dynamic subtest: numvfs-5
[682.967389] Dynamic subtest numvfs-5: FAIL (0.003s)
[682.978694] Starting dynamic subtest: numvfs-6
[683.064789] Dynamic subtest numvfs-6: FAIL (0.003s)
[683.075645] Starting dynamic subtest: numvfs-7
[683.150682] Dynamic subtest numvfs-7: FAIL (0.003s)
[683.161793] Starting dynamic subtest: numvfs-random
[683.235619] Dynamic subtest numvfs-random: FAIL (0.003s)
[683.237752] Subtest enable-vfs-bind-unbind-each: FAIL (0.035s)
[683.279136] [111/133] (339s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[683.377549] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[683.381595] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[683.488191] [112/133] (339s left) gem_exec_fence (syncobj-unused-fence)
[683.926782] Starting subtest: syncobj-unused-fence
[683.933272] Subtest syncobj-unused-fence: SUCCESS (0.004s)
[685.189571] [113/133] (338s left) prime_self_import (basic-llseek-size)
[685.228900] Starting subtest: basic-llseek-size
[685.247171] Subtest basic-llseek-size: SUCCESS (0.017s)
[685.353448] [114/133] (337s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[685.421653] Starting subtest: x-tiled-to-vebox-yf-tiled
[685.426878] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[685.604486] [115/133] (337s left) gem_exec_balancer (invalid-bonds)
[685.658870] Starting subtest: invalid-bonds
[685.664741] Subtest invalid-bonds: SKIP (0.000s)
[685.949644] [116/133] (337s left) prime_mmap (test_map_unmap)
[686.006833] Starting subtest: test_map_unmap
[686.009104] Starting dynamic subtest: test_map_unmap-smem
[686.036047] Dynamic subtest test_map_unmap-smem: SUCCESS (0.031s)
[686.038686] Subtest test_map_unmap: SUCCESS (0.032s)
[686.184359] [117/133] (337s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[686.252612] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[686.254961] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[686.352218] [118/133] (337s left) kms_rotation_crc (bad-tiling)
[686.453681] Starting subtest: bad-tiling
[686.458879] Subtest bad-tiling: SKIP (0.001s)
[686.528046] [119/133] (337s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[686.632614] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[686.637885] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[686.733650] [120/133] (336s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[686.846614] Starting subtest: short-busy-flip-before-cursor-toggle
[686.852444] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[686.991292] [121/133] (336s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[687.087881] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[687.092347] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[687.184206] [122/133] (336s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[687.274491] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[687.276771] Starting dynamic subtest: pipe-A-eDP-1
[687.299666] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[687.313452] Starting dynamic subtest: pipe-B-eDP-1
[687.335699] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[687.347106] Starting dynamic subtest: pipe-C-eDP-1
[687.368661] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[687.378835] Starting dynamic subtest: pipe-D-eDP-1
[687.401670] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[687.406102] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[689.509148] [123/133] (334s left) kms_fbcon_fbt (fbc)
[689.569738] Starting subtest: fbc
[695.931464] Subtest fbc: SUCCESS (6.362s)
[697.021149] [124/133] (326s left) kms_properties (plane-properties-legacy)
[697.129615] Starting subtest: plane-properties-legacy
[697.132365] Starting dynamic subtest: pipe-A-eDP-1
[697.695803] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s)
[697.707633] Starting dynamic subtest: pipe-B-eDP-1
[699.005841] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.311s)
[699.018262] Starting dynamic subtest: pipe-C-eDP-1
[700.331885] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.326s)
[700.344592] Starting dynamic subtest: pipe-D-eDP-1
[701.572744] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.237s)
[701.575521] Subtest plane-properties-legacy: SUCCESS (4.444s)
[702.379186] [125/133] (321s left) gem_eio (suspend)
[702.572502] Starting subtest: suspend
[714.879730] Subtest suspend: SUCCESS (12.282s)
[715.032343] [126/133] (308s left) gem_exec_whisper (basic-fds-all)
[715.212118] Starting subtest: basic-fds-all
[725.072387] Subtest basic-fds-all: SUCCESS (9.891s)
[725.259516] [127/133] (298s left) syncobj_wait (single-wait-all-submitted)
[725.307716] Starting subtest: single-wait-all-submitted
[725.411876] Subtest single-wait-all-submitted: SUCCESS (0.104s)
[725.494060] [128/133] (298s left) kms_frontbuffer_tracking (fbc-suspend)
[725.593645] Starting subtest: fbc-suspend
[763.814572] Subtest fbc-suspend: SUCCESS (7.378s)
[765.017823] [129/133] (259s left) syncobj_wait (wait-zero-handles)
[765.089953] Starting subtest: wait-zero-handles
[765.093059] Subtest wait-zero-handles: SUCCESS (0.000s)
[765.207667] [130/133] (258s left) gem_softpin (evict-snoop)
[765.270229] Starting subtest: evict-snoop
[765.275770] Subtest evict-snoop: SKIP (0.000s)
[765.384426] [131/133] (258s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[765.589688] Starting subtest: cursor-rapid-movement-64x21
[765.632904] Subtest cursor-rapid-movement-64x21: SKIP (0.038s)
[765.886740] [132/133] (258s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[765.988129] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[767.092754] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.103s)
[767.209567] [133/133] (257s left) gem_exec_flush (basic-wb-pro-default)
[767.260952] Starting subtest: basic-wb-pro-default
[772.743709] Subtest basic-wb-pro-default: SUCCESS (5.471s)
[772.933494] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: gen9_exec_parse
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_invalid_mode
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_color_pipeline
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_plane_multiple
results: parsing output: 9/ for test: gem_gpgpu_fill
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: kms_vblank
results: parsing output: 12/ for test: kms_selftest
results: parsing output: 13/ for test: gem_render_copy
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: kms_cursor_legacy
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: kms_plane
results: parsing output: 18/ for test: prime_vgem
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_psr2_sf
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_ctx_engines
results: parsing output: 25/ for test: syncobj_wait
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_eio
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: perf_pmu
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_chamelium_frames
results: parsing output: 33/ for test: kms_joiner
results: parsing output: 34/ for test: gem_eio
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: kms_cursor_crc
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_exec_fence
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: gem_exec_fence
results: parsing output: 41/ for test: core_setmaster_vs_auth
results: parsing output: 42/ for test: kms_content_protection
results: parsing output: 43/ for test: kms_cdclk
results: parsing output: 44/ for test: i915_pm_rpm
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: kms_plane_scaling
results: parsing output: 47/ for test: kms_psr2_sf
results: parsing output: 48/ for test: kms_addfb_basic
results: parsing output: 49/ for test: gem_exec_flush
results: parsing output: 50/ for test: syncobj_wait
results: parsing output: 51/ for test: kms_psr2_sf
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_rotation_crc
results: parsing output: 54/ for test: gem_softpin
results: parsing output: 55/ for test: core_setmaster
results: parsing output: 56/ for test: gem_exec_schedule
results: parsing output: 57/ for test: api_intel_bb
results: parsing output: 58/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_vrr
results: parsing output: 61/ for test: kms_chamelium_hpd
results: parsing output: 62/ for test: gem_exec_params
results: parsing output: 63/ for test: kms_plane_alpha_blend
results: parsing output: 64/ for test: syncobj_wait
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_getfb
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: api_intel_allocator
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: kms_pm_rpm
results: parsing output: 73/ for test: gem_mmap_gtt
results: parsing output: 74/ for test: gem_exec_schedule
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: kms_plane
results: parsing output: 77/ for test: gem_ctx_sseu
results: parsing output: 78/ for test: gem_ctx_isolation
results: parsing output: 79/ for test: kms_draw_crc
results: parsing output: 80/ for test: gem_softpin
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_pm_rpm
results: parsing output: 83/ for test: kms_getfb
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: gem_userptr_blits
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: gem_barrier_race
results: parsing output: 90/ for test: gen9_exec_parse
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: kms_rotation_crc
results: parsing output: 93/ for test: gem_tiling_max_stride
results: parsing output: 94/ for test: gem_ctx_persistence
results: parsing output: 95/ for test: kms_flip_scaled_crc
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: i915_getparams_basic
results: parsing output: 98/ for test: gem_render_tiled_blits
results: parsing output: 99/ for test: gem_ppgtt
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_async_flips
results: parsing output: 103/ for test: gem_lmem_swapping
results: parsing output: 104/ for test: gem_exec_params
results: parsing output: 105/ for test: kms_cursor_edge_walk
results: parsing output: 106/ for test: i915_power
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_pwrite_snooped
results: parsing output: 109/ for test: sriov_basic
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_exec_fence
results: parsing output: 112/ for test: prime_self_import
results: parsing output: 113/ for test: gem_render_copy
results: parsing output: 114/ for test: gem_exec_balancer
results: parsing output: 115/ for test: prime_mmap
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_rotation_crc
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_cursor_legacy
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: kms_fbcon_fbt
results: parsing output: 123/ for test: kms_properties
results: parsing output: 124/ for test: gem_eio
results: parsing output: 125/ for test: gem_exec_whisper
results: parsing output: 126/ for test: syncobj_wait
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: gem_softpin
results: parsing output: 130/ for test: kms_cursor_crc
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: gem_exec_flush
Done.