[969.337831] Initializing watchdogs
[969.337913]   /dev/watchdog0
[969.354353] [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]
[969.360312] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[969.362436] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[969.362975] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true
[969.366782] [001/131] (960s left) dumb_buffer (invalid-bpp)
[969.447755] Starting subtest: invalid-bpp
[969.450085] Subtest invalid-bpp: SUCCESS (0.000s)
[969.566436] [002/131] (960s left) prime_mmap (test_errors)
[969.617916] Starting subtest: test_errors
[969.619815] Starting dynamic subtest: test_errors-smem
[969.709915] Dynamic subtest test_errors-smem: SUCCESS (0.093s)
[969.712623] Subtest test_errors: SUCCESS (0.094s)
[969.850620] [003/131] (960s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[969.943626] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[969.945805] Starting dynamic subtest: pipe-A-eDP-1
[970.357022] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.415s)
[970.368456] Starting dynamic subtest: pipe-B-eDP-1
[970.388392] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[970.397949] Starting dynamic subtest: pipe-C-eDP-1
[970.412358] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.003s)
[970.420827] Starting dynamic subtest: pipe-D-eDP-1
[970.436366] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[970.437960] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.429s)
[972.680658] [004/131] (957s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[972.793023] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[972.795574] Starting dynamic subtest: pipe-A-eDP-1
[973.227272] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.404s)
[973.249039] Starting dynamic subtest: pipe-B-eDP-1
[974.620473] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.393s)
[974.630234] Starting dynamic subtest: pipe-C-eDP-1
[975.993430] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.372s)
[976.005413] Starting dynamic subtest: pipe-D-eDP-1
[977.319297] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[977.321641] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.501s)
[978.478878] [005/131] (951s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[978.580868] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[979.182271] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.603s)
[979.381294] [006/131] (950s left) gem_softpin (overlap)
[979.450399] Starting subtest: overlap
[980.277518] Subtest overlap: SUCCESS (0.825s)
[980.443389] [007/131] (949s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[980.537817] Starting subtest: bad-aux-stride-y-tiled-ccs
[980.540150] Starting dynamic subtest: pipe-A-eDP-1
[980.562613] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[980.575195] Starting dynamic subtest: pipe-B-eDP-1
[980.596033] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[980.605434] Starting dynamic subtest: pipe-C-eDP-1
[980.627300] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[980.638811] Starting dynamic subtest: pipe-D-eDP-1
[980.662045] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[980.666286] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[982.783014] [008/131] (947s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[982.880528] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[982.882644] Starting dynamic subtest: pipe-A-eDP-1
[982.905984] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[982.918618] Starting dynamic subtest: pipe-B-eDP-1
[982.940477] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[982.950619] Starting dynamic subtest: pipe-C-eDP-1
[982.972876] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[982.983407] Starting dynamic subtest: pipe-D-eDP-1
[983.006050] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[983.010110] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.007s)
[985.183346] [009/131] (945s left) kms_dsc (dsc-with-bpc-formats)
[985.281974] Starting subtest: dsc-with-bpc-formats
[985.394779] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[985.437534] [010/131] (944s left) gem_pread (bench)
[985.496567] Subtest bench: SKIP (0.000s)
[985.557699] [011/131] (944s left) kms_atomic_interruptible (atomic-setmode)
[985.662388] Starting subtest: atomic-setmode
[985.664680] Starting dynamic subtest: pipe-A-eDP-1
[992.552709] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.888s)
[992.555002] Subtest atomic-setmode: SUCCESS (6.889s)
[993.379949] [012/131] (936s left) i915_query (query-topology-known-pci-ids)
[993.446790] Starting subtest: query-topology-known-pci-ids
[993.451110] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[993.579272] [013/131] (936s left) gem_create (create-ext-placement-all)
[993.748212] Starting subtest: create-ext-placement-all
[993.751224] Subtest create-ext-placement-all: SUCCESS (0.000s)
[993.906078] [014/131] (936s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[994.002653] Starting subtest: disable-crc-after-crtc
[994.004900] Starting dynamic subtest: pipe-A-eDP-1
[995.667502] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.665s)
[995.679592] Starting dynamic subtest: pipe-B-eDP-1
[998.062796] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.394s)
[998.072591] Starting dynamic subtest: pipe-C-eDP-1
[1000.254480] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.188s)
[1000.265052] Starting dynamic subtest: pipe-D-eDP-1
[1002.550308] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.297s)
[1002.552535] Subtest disable-crc-after-crtc: SUCCESS (8.551s)
[1003.376137] [015/131] (927s left) kms_psr (fbc-pr-primary-render)
[1003.479581] Starting subtest: fbc-pr-primary-render
[1003.483952] Subtest fbc-pr-primary-render: SKIP (0.000s)
[1003.576157] [016/131] (926s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[1003.686301] Starting subtest: fbc-psr2-cursor-mmap-cpu
[1003.688596] Starting dynamic subtest: eDP-1
[1003.693013] Dynamic subtest eDP-1: SKIP (0.000s)
[1003.697295] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.003s)
[1003.794386] [017/131] (926s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[1003.864368] Subtest tiled-to-untiled: SKIP (0.000s)
[1003.951946] [018/131] (926s left) kms_big_fb (linear-64bpp-rotate-0)
[1004.054642] Starting subtest: linear-64bpp-rotate-0
[1005.644020] Subtest linear-64bpp-rotate-0: SUCCESS (1.589s)
[1005.838669] [019/131] (924s left) gem_exec_schedule (u-submit-late-slice)
[1005.920539] Starting subtest: u-submit-late-slice
[1005.922084] Starting dynamic subtest: rcs0
[1005.950986] Dynamic subtest rcs0: SUCCESS (0.032s)
[1005.961692] Starting dynamic subtest: bcs0
[1005.978000] Dynamic subtest bcs0: SUCCESS (0.026s)
[1005.987532] Starting dynamic subtest: vcs0
[1006.009471] Dynamic subtest vcs0: SUCCESS (0.031s)
[1006.019292] Starting dynamic subtest: vcs1
[1006.037998] Dynamic subtest vcs1: SUCCESS (0.028s)
[1006.047402] Starting dynamic subtest: vecs0
[1006.064823] Dynamic subtest vecs0: SUCCESS (0.026s)
[1006.073988] Starting dynamic subtest: ccs0
[1006.092059] Dynamic subtest ccs0: SUCCESS (0.026s)
[1006.094160] Subtest u-submit-late-slice: SUCCESS (0.174s)
[1007.988581] [020/131] (922s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[1008.370933] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[1009.224385] [021/131] (921s left) kms_flip (2x-flip-vs-modeset)
[1009.333567] Starting subtest: 2x-flip-vs-modeset
[1009.345270] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[1009.450354] [022/131] (921s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[1009.545724] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[1009.548009] Starting dynamic subtest: pipe-A-default-mode
[1012.249044] Dynamic subtest pipe-A-default-mode: SUCCESS (2.702s)
[1012.251383] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.705s)
[1013.071659] [023/131] (917s left) i915_drm_fdinfo (all-busy-idle-check-all)
[1013.122277] Starting subtest: all-busy-idle-check-all
[1013.126843] Subtest all-busy-idle-check-all: SKIP (0.003s)
[1013.225591] [024/131] (917s left) kms_psr (psr-sprite-plane-onoff)
[1013.384068] Starting subtest: psr-sprite-plane-onoff
[1013.386400] Starting dynamic subtest: eDP-1
[1015.251684] Dynamic subtest eDP-1: SUCCESS (1.864s)
[1015.254019] Subtest psr-sprite-plane-onoff: SUCCESS (1.866s)
[1016.074909] [025/131] (914s left) kms_hdr (invalid-hdr)
[1016.191691] Starting subtest: invalid-hdr
[1018.384919] Starting dynamic subtest: pipe-A-eDP-1
[1021.278912] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.895s)
[1021.281407] Subtest invalid-hdr: SUCCESS (5.089s)
[1021.423700] [026/131] (909s left) gem_exec_balancer (fairslice)
[1021.486763] Starting subtest: fairslice
[1024.377750] Subtest fairslice: SUCCESS (2.888s)
[1024.871111] [027/131] (906s left) gem_render_copy (yf-tiled)
[1024.944392] Starting subtest: yf-tiled
[1024.948781] Subtest yf-tiled: SKIP (0.000s)
[1025.153241] [028/131] (905s left) perf (create-destroy-userspace-config)
[1025.302763] Starting subtest: create-destroy-userspace-config
[1025.322205] Subtest create-destroy-userspace-config: SUCCESS (0.018s)
[1025.362703] [029/131] (905s left) kms_cursor_crc (cursor-onscreen-512x170)
[1025.645379] Starting subtest: cursor-onscreen-512x170
[1025.650116] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[1025.834978] [030/131] (905s left) kms_psr (fbc-psr-cursor-render)
[1025.938884] Starting subtest: fbc-psr-cursor-render
[1025.941207] Starting dynamic subtest: eDP-1
[1025.945363] Dynamic subtest eDP-1: SKIP (0.000s)
[1025.949572] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[1026.039346] [031/131] (905s left) gen9_exec_parse (bb-secure)
[1026.112913] Subtest bb-secure: SKIP (0.000s)
[1026.204698] [032/131] (904s left) i915_pm_rc6_residency (rc6-accuracy)
[1026.264789] Starting subtest: rc6-accuracy
[1026.266937] Starting dynamic subtest: gt0
[1029.440065] Dynamic subtest gt0: SUCCESS (3.169s)
[1029.453171] Starting dynamic subtest: gt1
[1032.611132] Dynamic subtest gt1: SUCCESS (3.167s)
[1032.614107] Subtest rc6-accuracy: SUCCESS (6.344s)
[1032.720155] [033/131] (898s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[1032.821896] Starting subtest: plane-primary-overlay-mutable-zpos
[1037.199127] Subtest plane-primary-overlay-mutable-zpos: SKIP (4.374s)
[1038.467767] [034/131] (892s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[1038.588579] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[1038.593262] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[1038.759945] [035/131] (892s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[1038.818725] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[1038.923196] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.104s)
[1039.023552] [036/131] (892s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[1039.093460] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[1039.174565] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.026s)
[1039.215097] [037/131] (892s left) syncobj_timeline (etime-single-wait-all-submitted)
[1039.275050] Starting subtest: etime-single-wait-all-submitted
[1039.378961] Subtest etime-single-wait-all-submitted: SUCCESS (0.103s)
[1039.478658] [038/131] (891s left) kms_prop_blob (blob-prop-core)
[1039.530134] Starting subtest: blob-prop-core
[1039.532504] Subtest blob-prop-core: SUCCESS (0.000s)
[1039.669233] [039/131] (891s left) gem_userptr_blits (userfault)
[1039.727986] Starting subtest: userfault
[1039.730268] Subtest userfault: SUCCESS (0.005s)
[1039.891906] [040/131] (891s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[1039.997119] Starting subtest: yf-tiled-8bpp-rotate-90
[1040.001465] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[1040.115285] [041/131] (891s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[1040.219806] Starting subtest: 2x-absolute-wf_vblank-interruptible
[1040.231117] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.010s)
[1040.380160] [042/131] (891s left) gem_exec_params (no-blt)
[1040.436042] Starting subtest: no-blt
[1040.440992] Subtest no-blt: SUCCESS (0.002s)
[1040.597365] [043/131] (891s left) kms_cursor_crc (cursor-size-change)
[1040.701587] Starting subtest: cursor-size-change
[1040.703564] Starting dynamic subtest: pipe-A-eDP-1
[1041.478532] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.775s)
[1041.490853] Starting dynamic subtest: pipe-D-eDP-1
[1043.019401] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.540s)
[1043.021711] Subtest cursor-size-change: SUCCESS (2.319s)
[1043.863293] [044/131] (887s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[1043.973964] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[1044.347089] Starting dynamic subtest: pipe-A-eDP-1
[1047.091895] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.745s)
[1047.461741] Starting dynamic subtest: pipe-B-eDP-1
[1050.190762] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.738s)
[1050.552977] Starting dynamic subtest: pipe-C-eDP-1
[1053.291389] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.744s)
[1053.662532] Starting dynamic subtest: pipe-D-eDP-1
[1056.384962] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.729s)
[1056.387482] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.411s)
[1057.594413] [045/131] (874s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[1057.705414] Starting subtest: fbcpsr-tiling-linear
[1064.179677] Subtest fbcpsr-tiling-linear: SUCCESS (6.476s)
[1064.363252] [046/131] (867s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[1064.460468] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[1064.464563] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[1064.595341] [047/131] (867s left) gem_ctx_persistence (hostile)
[1064.663296] Starting subtest: hostile
[1074.176781] Subtest hostile: SUCCESS (9.508s)
[1074.326070] [048/131] (857s left) syncobj_timeline (wait-all-for-submit-snapshot)
[1074.396582] Starting subtest: wait-all-for-submit-snapshot
[1074.478893] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[1074.588383] [049/131] (857s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[1074.695870] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[1074.698115] Starting dynamic subtest: pipe-A-default-mode
[1074.985261] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[1074.989754] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.288s)
[1075.878619] [050/131] (856s left) syncobj_wait (wait-all-interrupted)
[1075.941302] Starting subtest: wait-all-interrupted
[1076.041645] Subtest wait-all-interrupted: SUCCESS (0.102s)
[1076.141999] [051/131] (855s left) gem_softpin (full)
[1076.187507] Starting subtest: full
[1076.194183] Subtest full: SUCCESS (0.007s)
[1076.355377] [052/131] (855s left) gem_exec_reloc (basic-wc-read-noreloc)
[1076.425831] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[1076.517727] [053/131] (855s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[1076.635229] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[1083.554645] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (6.920s)
[1083.758221] [054/131] (848s left) kms_psr (psr2-cursor-render)
[1083.860149] Starting subtest: psr2-cursor-render
[1083.862449] Starting dynamic subtest: eDP-1
[1085.577900] Dynamic subtest eDP-1: SUCCESS (1.719s)
[1085.580598] Subtest psr2-cursor-render: SUCCESS (1.720s)
[1086.466206] [055/131] (845s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[1086.568519] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[1086.572935] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[1086.708641] [056/131] (845s left) gem_exec_schedule (in-order)
[1086.797995] Starting subtest: in-order
[1086.799985] Starting dynamic subtest: rcs0
[1086.886727] Dynamic subtest rcs0: SUCCESS (0.094s)
[1086.902226] Starting dynamic subtest: vcs0
[1086.970973] Dynamic subtest vcs0: SUCCESS (0.083s)
[1086.980639] Starting dynamic subtest: vcs1
[1087.047646] Dynamic subtest vcs1: SUCCESS (0.076s)
[1087.060840] Starting dynamic subtest: vecs0
[1087.119636] Dynamic subtest vecs0: SUCCESS (0.071s)
[1087.132475] Starting dynamic subtest: ccs0
[1087.198629] Dynamic subtest ccs0: SUCCESS (0.078s)
[1087.201169] Subtest in-order: SUCCESS (0.407s)
[1088.958475] [057/131] (843s left) kms_vblank (ts-continuation-modeset-rpm)
[1089.059917] Starting subtest: ts-continuation-modeset-rpm
[1089.062201] Starting dynamic subtest: pipe-A-eDP-1
[1091.609112] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.546s)
[1091.625156] Starting dynamic subtest: pipe-D-eDP-1
[1093.791381] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.182s)
[1093.793744] Subtest ts-continuation-modeset-rpm: SUCCESS (4.732s)
[1094.668287] [058/131] (837s left) kms_cursor_edge_walk (64x64-top-edge)
[1094.781315] Starting subtest: 64x64-top-edge
[1094.783685] Starting dynamic subtest: pipe-A-eDP-1
[1098.283195] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.501s)
[1098.294272] Starting dynamic subtest: pipe-D-eDP-1
[1101.471233] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.188s)
[1101.473599] Subtest 64x64-top-edge: SUCCESS (6.692s)
[1102.368504] [059/131] (829s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[1102.475353] Starting subtest: y-tiled-8bpp-rotate-0
[1102.479525] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[1102.592509] [060/131] (829s left) gem_linear_blits (interruptible)
[1102.893654] Starting subtest: interruptible
[1107.153874] Subtest interruptible: SUCCESS (4.259s)
[1107.320083] [061/131] (825s left) kms_flip (dpms-vs-vblank-race-interruptible)
[1107.461659] Starting subtest: dpms-vs-vblank-race-interruptible
[1107.463965] Starting dynamic subtest: A-eDP1
[1111.294269] Dynamic subtest A-eDP1: SUCCESS (3.829s)
[1111.305280] Starting dynamic subtest: B-eDP1
[1114.799472] Dynamic subtest B-eDP1: SUCCESS (3.503s)
[1114.810051] Starting dynamic subtest: C-eDP1
[1118.320680] Dynamic subtest C-eDP1: SUCCESS (3.520s)
[1118.330928] Starting dynamic subtest: D-eDP1
[1121.799368] Dynamic subtest D-eDP1: SUCCESS (3.475s)
[1121.801687] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (14.340s)
[1122.663230] [062/131] (809s left) kms_chamelium_color (ctm-max)
[1122.766451] Subtest ctm-max: SKIP (0.000s)
[1122.811680] [063/131] (809s left) kms_vblank (query-forked-busy-hang)
[1122.919924] Starting subtest: query-forked-busy-hang
[1122.921787] Starting dynamic subtest: pipe-A-eDP-1
[1150.576902] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.657s)
[1150.592651] Starting dynamic subtest: pipe-D-eDP-1
[1165.619646] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.043s)
[1165.622113] Subtest query-forked-busy-hang: SUCCESS (42.704s)
[1166.459176] [064/131] (766s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[1166.557366] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[1173.055904] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.501s)
[1173.206564] [065/131] (759s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[1173.316387] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[1173.320798] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[1173.438069] [066/131] (759s left) kms_setmode (invalid-clone-exclusive-crtc)
[1173.494450] Starting subtest: invalid-clone-exclusive-crtc
[1173.501165] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[1173.618824] [067/131] (759s left) gem_exec_fence (submit)
[1173.783888] Starting subtest: submit
[1173.788394] Subtest submit: SKIP (0.000s)
[1175.979547] [068/131] (756s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[1176.086544] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[1180.066712] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (3.984s)
[1181.255196] [069/131] (751s left) sw_sync (sync_busy)
[1181.300922] Starting subtest: sync_busy
[1181.303293] Subtest sync_busy: SUCCESS (0.002s)
[1181.388779] [070/131] (751s left) i915_pciid
[1181.587208] [071/131] (751s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[1181.688053] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[1181.692023] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[1181.823130] [072/131] (751s left) gem_lmem_swapping (verify-ccs)
[1181.866906] Subtest verify-ccs: SKIP (0.000s)
[1181.907962] [073/131] (751s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[1182.022086] Starting subtest: basic-flip-before-cursor-legacy
[1182.935930] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.915s)
[1183.747724] [074/131] (749s left) kms_psr (psr2-primary-mmap-cpu)
[1183.845830] Starting subtest: psr2-primary-mmap-cpu
[1183.848119] Starting dynamic subtest: eDP-1
[1185.583695] Dynamic subtest eDP-1: SUCCESS (1.738s)
[1185.586721] Subtest psr2-primary-mmap-cpu: SUCCESS (1.739s)
[1186.459345] [075/131] (746s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[1186.577381] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[1187.614319] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.036s)
[1187.773216] [076/131] (745s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[1187.878521] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[1187.882443] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[1188.017501] [077/131] (745s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[1193.083495] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[1193.087707] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[1193.946046] [078/131] (739s left) kms_chamelium_edid (hdmi-edid-read)
[1194.341759] Subtest hdmi-edid-read: SKIP (0.000s)
[1195.106598] [079/131] (738s left) gem_lmem_swapping (heavy-multi)
[1195.151566] Subtest heavy-multi: SKIP (0.000s)
[1195.212697] [080/131] (738s left) vgem_basic (bad-handle)
[1195.259279] Starting subtest: bad-handle
[1195.261486] Subtest bad-handle: SUCCESS (0.000s)
[1195.338804] [081/131] (737s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[1195.440406] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[1195.444733] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[1196.551313] [082/131] (736s left) gem_exec_create (legacy)
[1196.611654] Starting subtest: legacy
[1196.613992] Starting dynamic subtest: smem
[1199.789931] Dynamic subtest smem: SUCCESS (3.177s)
[1199.793054] Subtest legacy: SUCCESS (3.179s)
[1199.995923] [083/131] (733s left) gem_mmap_offset (bad-extensions)
[1200.064484] Starting subtest: bad-extensions
[1200.066818] Subtest bad-extensions: SUCCESS (0.000s)
[1200.207948] [084/131] (733s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[1200.312449] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[1207.124012] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.816s)
[1207.287964] [085/131] (726s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[1207.349505] Starting subtest: multi-wait-for-submit-submitted-signaled
[1207.351676] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[1207.486057] [086/131] (725s left) prime_vgem (fence-read-hang)
[1207.560333] Subtest fence-read-hang: SKIP (0.000s)
[1207.684251] [087/131] (725s left) kms_properties (plane-properties-atomic)
[1207.776785] Starting subtest: plane-properties-atomic
[1207.779134] Starting dynamic subtest: pipe-A-eDP-1
[1208.320583] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.544s)
[1208.332276] Starting dynamic subtest: pipe-B-eDP-1
[1209.564527] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.243s)
[1209.575821] Starting dynamic subtest: pipe-C-eDP-1
[1210.866054] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.298s)
[1210.876678] Starting dynamic subtest: pipe-D-eDP-1
[1212.154410] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.289s)
[1212.156692] Subtest plane-properties-atomic: SUCCESS (4.380s)
[1213.047480] [088/131] (720s left) prime_mmap (test_dup)
[1213.104830] Starting subtest: test_dup
[1213.106978] Starting dynamic subtest: test_dup-smem
[1213.131502] Dynamic subtest test_dup-smem: SUCCESS (0.028s)
[1213.133783] Subtest test_dup: SUCCESS (0.029s)
[1213.228682] [089/131] (720s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[1213.328143] Starting subtest: yf-tiled-16bpp-rotate-0
[1213.332113] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[1213.460185] [090/131] (720s left) api_intel_bb (misplaced-blitter)
[1213.522734] Starting subtest: misplaced-blitter
[1213.529967] Subtest misplaced-blitter: SUCCESS (0.008s)
[1213.723254] [091/131] (720s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[1213.859129] Starting subtest: cursorB-vs-flipA-atomic-transitions
[1213.863606] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[1214.027200] [092/131] (719s left) vgem_slow (nohang)
[1214.066869] Starting subtest: nohang
[1224.267317] Subtest nohang: SUCCESS (10.201s)
[1224.360121] [093/131] (709s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[1224.479973] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[1224.483976] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[1224.625765] [094/131] (709s left) perf_pmu (invalid-init)
[1224.667081] Starting subtest: invalid-init
[1224.669356] Subtest invalid-init: SUCCESS (0.000s)
[1224.813905] [095/131] (709s left) perf_pmu (busy-idle-no-semaphores)
[1224.860377] Starting subtest: busy-idle-no-semaphores
[1224.862744] Starting dynamic subtest: rcs0
[1225.525636] Dynamic subtest rcs0: SUCCESS (0.667s)
[1225.538501] Starting dynamic subtest: bcs0
[1226.179059] Dynamic subtest bcs0: SUCCESS (0.650s)
[1226.192224] Starting dynamic subtest: vcs0
[1226.832965] Dynamic subtest vcs0: SUCCESS (0.651s)
[1226.845651] Starting dynamic subtest: vcs1
[1228.440961] Dynamic subtest vcs1: SUCCESS (1.604s)
[1228.452628] Starting dynamic subtest: vecs0
[1230.427917] Dynamic subtest vecs0: SUCCESS (1.985s)
[1230.441132] Starting dynamic subtest: ccs0
[1232.412568] Dynamic subtest ccs0: SUCCESS (1.982s)
[1232.415474] Subtest busy-idle-no-semaphores: SUCCESS (7.555s)
[1232.580139] [096/131] (701s left) gem_userptr_blits (create-destroy-unsync)
[1232.651333] Subtest create-destroy-unsync: SKIP (0.000s)
[1232.820526] [097/131] (701s left) kms_rotation_crc (sprite-rotation-270)
[1232.924769] Starting subtest: sprite-rotation-270
[1232.929150] Subtest sprite-rotation-270: SKIP (0.001s)
[1233.022132] [098/131] (700s left) kms_plane_scaling (planes-upscale-factor-0-25)
[1233.108017] Starting subtest: planes-upscale-factor-0-25
[1233.110309] Starting dynamic subtest: pipe-A
[1233.167712] Dynamic subtest pipe-A: SUCCESS (0.062s)
[1233.179613] Starting dynamic subtest: pipe-B
[1234.309187] Dynamic subtest pipe-B: SUCCESS (1.139s)
[1234.326254] Starting dynamic subtest: pipe-C
[1235.393315] Dynamic subtest pipe-C: SUCCESS (1.082s)
[1235.406771] Starting dynamic subtest: pipe-D
[1236.481676] Dynamic subtest pipe-D: SUCCESS (1.085s)
[1236.484568] Subtest planes-upscale-factor-0-25: SUCCESS (3.377s)
[1237.736585] [099/131] (696s left) kms_properties (invalid-properties-legacy)
[1237.837051] Starting subtest: invalid-properties-legacy
[1237.937687] Subtest invalid-properties-legacy: SUCCESS (0.101s)
[1238.036965] [100/131] (696s left) syncobj_basic (test-valid-cycle)
[1238.098419] Starting subtest: test-valid-cycle
[1238.100411] Subtest test-valid-cycle: SUCCESS (0.000s)
[1238.213263] [101/131] (695s left) kms_cursor_edge_walk (128x128-top-bottom)
[1238.309071] Starting subtest: 128x128-top-bottom
[1238.311313] Starting dynamic subtest: pipe-A-eDP-1
[1241.741160] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.430s)
[1241.752121] Starting dynamic subtest: pipe-D-eDP-1
[1244.933853] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.191s)
[1244.936199] Subtest 128x128-top-bottom: SUCCESS (6.626s)
[1245.751500] [102/131] (688s left) kms_getfb (getfb-handle-zero)
[1245.852433] Starting subtest: getfb-handle-zero
[1245.854642] Subtest getfb-handle-zero: SUCCESS (0.000s)
[1245.968957] [103/131] (688s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[1246.060948] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[1246.064905] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[1246.181828] [104/131] (688s left) gem_exec_schedule (u-lateslice)
[1246.249488] Starting subtest: u-lateslice
[1246.251420] Starting dynamic subtest: rcs0
[1246.260951] Dynamic subtest rcs0: SUCCESS (0.019s)
[1246.271232] Starting dynamic subtest: bcs0
[1246.277925] Dynamic subtest bcs0: SUCCESS (0.016s)
[1246.287154] Starting dynamic subtest: vcs0
[1246.296492] Dynamic subtest vcs0: SUCCESS (0.018s)
[1246.306143] Starting dynamic subtest: vcs1
[1246.314285] Dynamic subtest vcs1: SUCCESS (0.017s)
[1246.323539] Starting dynamic subtest: vecs0
[1246.330880] Dynamic subtest vecs0: SUCCESS (0.016s)
[1246.340335] Starting dynamic subtest: ccs0
[1246.348901] Dynamic subtest ccs0: SUCCESS (0.017s)
[1246.351008] Subtest u-lateslice: SUCCESS (0.108s)
[1247.975822] [105/131] (686s left) perf_pmu (init-sema)
[1248.020738] Starting subtest: init-sema
[1248.023124] Starting dynamic subtest: rcs0
[1248.025448] Dynamic subtest rcs0: SUCCESS (0.001s)
[1248.036305] Starting dynamic subtest: bcs0
[1248.038579] Dynamic subtest bcs0: SUCCESS (0.000s)
[1248.047987] Starting dynamic subtest: vcs0
[1248.050257] Dynamic subtest vcs0: SUCCESS (0.001s)
[1248.059129] Starting dynamic subtest: vcs1
[1248.061059] Dynamic subtest vcs1: SUCCESS (0.000s)
[1248.070113] Starting dynamic subtest: vecs0
[1248.072051] Dynamic subtest vecs0: SUCCESS (0.001s)
[1248.081235] Starting dynamic subtest: ccs0
[1248.083187] Dynamic subtest ccs0: SUCCESS (0.000s)
[1248.085147] Subtest init-sema: SUCCESS (0.007s)
[1248.173229] [106/131] (686s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[1248.278473] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[1248.282948] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[1248.413635] [107/131] (685s left) gem_exec_reloc (basic-wc-gtt-active)
[1248.478316] Subtest basic-wc-gtt-active: SKIP (0.000s)
[1248.565652] [108/131] (685s left) gem_mmap_wc (set-cache-level)
[1248.619573] Subtest set-cache-level: SKIP (0.000s)
[1248.697871] [109/131] (685s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[1248.797905] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[1255.615043] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.821s)
[1255.777400] [110/131] (678s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[1255.880986] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[1263.210307] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.333s)
[1263.384140] [111/131] (671s left) kms_cursor_crc (cursor-onscreen-128x42)
[1263.598428] Starting subtest: cursor-onscreen-128x42
[1263.644397] Subtest cursor-onscreen-128x42: SKIP (0.041s)
[1263.878039] [112/131] (670s left) kms_color (ctm-green-to-red)
[1263.986107] Starting subtest: ctm-green-to-red
[1263.988449] Starting dynamic subtest: pipe-A-eDP-1
[1264.681028] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.696s)
[1264.703638] Starting dynamic subtest: pipe-B-eDP-1
[1266.028220] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.345s)
[1266.038646] Starting dynamic subtest: pipe-C-eDP-1
[1267.296957] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.270s)
[1267.307191] Starting dynamic subtest: pipe-D-eDP-1
[1268.639712] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.339s)
[1268.641676] Subtest ctm-green-to-red: SUCCESS (4.654s)
[1269.529247] [113/131] (665s left) gem_mmap_gtt (basic-small-copy-xy)
[1269.595785] Subtest basic-small-copy-XY: SKIP (0.000s)
[1269.665118] [114/131] (665s left) kms_plane_cursor (primary)
[1269.763663] Starting subtest: primary
[1269.768230] Starting dynamic subtest: pipe-A-eDP-1-size-64
[1272.291346] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.529s)
[1272.323689] Starting dynamic subtest: pipe-A-eDP-1-size-128
[1274.936339] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.627s)
[1274.961022] Starting dynamic subtest: pipe-A-eDP-1-size-256
[1277.570933] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.616s)
[1277.901279] Starting dynamic subtest: pipe-B-eDP-1-size-64
[1281.206714] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.329s)
[1281.231091] Starting dynamic subtest: pipe-B-eDP-1-size-128
[1283.829839] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.604s)
[1283.855814] Starting dynamic subtest: pipe-B-eDP-1-size-256
[1286.431795] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.582s)
[1286.745680] Starting dynamic subtest: pipe-C-eDP-1-size-64
[1289.653339] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.918s)
[1289.681507] Starting dynamic subtest: pipe-C-eDP-1-size-128
[1291.787357] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.113s)
[1291.815135] Starting dynamic subtest: pipe-C-eDP-1-size-256
[1293.931243] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.125s)
[1294.248831] Starting dynamic subtest: pipe-D-eDP-1-size-64
[1297.111126] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.873s)
[1297.138830] Starting dynamic subtest: pipe-D-eDP-1-size-128
[1299.245221] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.113s)
[1299.273445] Starting dynamic subtest: pipe-D-eDP-1-size-256
[1301.412423] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.147s)
[1301.718374] Subtest primary: SUCCESS (31.951s)
[1302.546526] [115/131] (632s left) gem_eio (in-flight-external)
[1302.781892] Starting subtest: in-flight-external
[1303.865293] Subtest in-flight-external: SUCCESS (1.084s)
[1304.039571] [116/131] (630s left) syncobj_timeline (invalid-signal-illegal-handle)
[1304.092432] Starting subtest: invalid-signal-illegal-handle
[1304.094347] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[1304.214930] [117/131] (630s left) gem_ctx_isolation (preservation)
[1304.284173] Starting subtest: preservation
[1304.286457] Starting dynamic subtest: rcs0
[1304.433265] Dynamic subtest rcs0: SUCCESS (0.148s)
[1304.446457] Starting dynamic subtest: bcs0
[1304.598183] Dynamic subtest bcs0: SUCCESS (0.164s)
[1304.611708] Starting dynamic subtest: vcs0
[1304.748408] Dynamic subtest vcs0: SUCCESS (0.148s)
[1304.762623] Starting dynamic subtest: vcs1
[1305.986391] Dynamic subtest vcs1: SUCCESS (1.238s)
[1305.999399] Starting dynamic subtest: vecs0
[1307.961532] Dynamic subtest vecs0: SUCCESS (1.974s)
[1307.974724] Starting dynamic subtest: ccs0
[1309.951820] Dynamic subtest ccs0: SUCCESS (1.988s)
[1309.954602] Subtest preservation: SUCCESS (5.666s)
[1310.230055] [118/131] (624s left) kms_pm_rpm (fences-dpms)
[1312.070539] Starting subtest: fences-dpms
[1312.075598] Subtest fences-dpms: SKIP (0.000s)
[1312.536261] [119/131] (622s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[1317.599259] Starting subtest: pr-cursor-plane-update-sf
[1317.603293] Subtest pr-cursor-plane-update-sf: SKIP (0.002s)
[1318.437851] [120/131] (616s left) gem_exec_fence (syncobj-timeline-signal)
[1319.013769] Starting subtest: syncobj-timeline-signal
[1319.017143] Subtest syncobj-timeline-signal: SUCCESS (0.009s)
[1320.951252] [121/131] (614s left) kms_joiner (basic-ultra-joiner)
[1321.062520] Starting subtest: basic-ultra-joiner
[1321.066787] Subtest basic-ultra-joiner: SKIP (0.000s)
[1321.153468] [122/131] (613s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[1321.211759] Starting subtest: y-tiled-ccs-to-yf-tiled
[1321.216017] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[1321.419065] [123/131] (613s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[1321.526636] Starting subtest: fbc-rgb565-draw-mmap-cpu
[1325.491652] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (3.968s)
[1326.654699] [124/131] (608s left) kms_plane (plane-position-covered)
[1326.752590] Starting subtest: plane-position-covered
[1327.255526] Starting dynamic subtest: pipe-A-plane-1
[1328.552494] Dynamic subtest pipe-A-plane-1: SUCCESS (1.298s)
[1328.564000] Starting dynamic subtest: pipe-A-plane-2
[1329.832530] Dynamic subtest pipe-A-plane-2: SUCCESS (1.280s)
[1329.844229] Starting dynamic subtest: pipe-A-plane-3
[1331.179433] Dynamic subtest pipe-A-plane-3: SUCCESS (1.345s)
[1331.191231] Starting dynamic subtest: pipe-A-plane-4
[1332.446642] Dynamic subtest pipe-A-plane-4: SUCCESS (1.264s)
[1332.458381] Starting dynamic subtest: pipe-A-plane-5
[1332.470123] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[1333.652307] Starting dynamic subtest: pipe-B-plane-1
[1334.971606] Dynamic subtest pipe-B-plane-1: SUCCESS (1.330s)
[1334.983069] Starting dynamic subtest: pipe-B-plane-2
[1336.235816] Dynamic subtest pipe-B-plane-2: SUCCESS (1.263s)
[1336.249349] Starting dynamic subtest: pipe-B-plane-3
[1337.547809] Dynamic subtest pipe-B-plane-3: SUCCESS (1.310s)
[1337.558758] Starting dynamic subtest: pipe-B-plane-4
[1338.837693] Dynamic subtest pipe-B-plane-4: SUCCESS (1.289s)
[1338.848389] Starting dynamic subtest: pipe-B-plane-5
[1338.861165] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[1338.863434] Subtest plane-position-covered: SUCCESS (12.108s)
[1339.731336] [125/131] (595s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[1339.838438] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[1339.842923] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[1339.945274] [126/131] (595s left) i915_suspend (basic-s2idle-without-i915)
[1339.987736] Starting subtest: basic-s2idle-without-i915
[1361.035968] Subtest basic-s2idle-without-i915: SUCCESS (5.814s)
[1361.181610] [127/131] (574s left) kms_panel_fitting (legacy)
[1361.292522] Starting subtest: legacy
[1361.294893] Starting dynamic subtest: pipe-A-eDP-1
[1361.836998] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.547s)
[1361.865018] Starting dynamic subtest: pipe-B-eDP-1
[1363.625549] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.770s)
[1363.653767] Starting dynamic subtest: pipe-C-eDP-1
[1365.207040] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.562s)
[1365.233579] Starting dynamic subtest: pipe-D-eDP-1
[1366.755928] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.531s)
[1366.758229] Subtest legacy: SUCCESS (5.471s)
[1367.994471] [128/131] (567s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[1368.092698] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[1368.097125] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[1368.241439] [129/131] (567s left) gem_busy (parallel)
[1368.432972] Starting subtest: parallel
[1368.435439] Starting dynamic subtest: rcs0
[1370.038516] Dynamic subtest rcs0: SUCCESS (1.605s)
[1370.051997] Starting dynamic subtest: bcs0
[1372.083516] Dynamic subtest bcs0: SUCCESS (2.043s)
[1372.095678] Starting dynamic subtest: vcs0
[1374.069830] Dynamic subtest vcs0: SUCCESS (1.984s)
[1374.081690] Starting dynamic subtest: vcs1
[1376.051308] Dynamic subtest vcs1: SUCCESS (1.978s)
[1376.062852] Starting dynamic subtest: vecs0
[1378.035989] Dynamic subtest vecs0: SUCCESS (1.982s)
[1378.047761] Starting dynamic subtest: ccs0
[1380.082750] Dynamic subtest ccs0: SUCCESS (2.045s)
[1380.085529] Subtest parallel: SUCCESS (11.655s)
[1380.367625] [130/131] (554s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[1380.467319] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[1380.475944] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[1380.581954] [131/131] (554s left) gem_ctx_shared (single-timeline)
[1380.660857] Starting subtest: single-timeline
[1380.683088] Subtest single-timeline: SUCCESS (0.022s)
[1380.952125] Closing watchdogs
results: parsing output: 0/ for test: dumb_buffer
results: parsing output: 1/ for test: prime_mmap
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: gem_softpin
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: kms_dsc
results: parsing output: 9/ for test: gem_pread
results: parsing output: 10/ for test: kms_atomic_interruptible
results: parsing output: 11/ for test: i915_query
results: parsing output: 12/ for test: gem_create
results: parsing output: 13/ for test: kms_pipe_crc_basic
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: gem_set_tiling_vs_blt
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: gem_exec_schedule
results: parsing output: 19/ for test: kms_chamelium_hpd
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: kms_flip_scaled_crc
results: parsing output: 22/ for test: i915_drm_fdinfo
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: kms_hdr
results: parsing output: 25/ for test: gem_exec_balancer
results: parsing output: 26/ for test: gem_render_copy
results: parsing output: 27/ for test: perf
results: parsing output: 28/ for test: kms_cursor_crc
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: gen9_exec_parse
results: parsing output: 31/ for test: i915_pm_rc6_residency
results: parsing output: 32/ for test: kms_atomic
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: sriov_basic
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_prop_blob
results: parsing output: 38/ for test: gem_userptr_blits
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: gem_exec_params
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_async_flips
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_ctx_persistence
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: kms_flip_scaled_crc
results: parsing output: 49/ for test: syncobj_wait
results: parsing output: 50/ for test: gem_softpin
results: parsing output: 51/ for test: gem_exec_reloc
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_exec_schedule
results: parsing output: 56/ for test: kms_vblank
results: parsing output: 57/ for test: kms_cursor_edge_walk
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: gem_linear_blits
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: kms_chamelium_color
results: parsing output: 62/ for test: kms_vblank
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_setmode
results: parsing output: 66/ for test: gem_exec_fence
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: sw_sync
results: parsing output: 69/ for test: i915_pciid
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_lmem_swapping
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_psr2_sf
results: parsing output: 77/ for test: kms_chamelium_edid
results: parsing output: 78/ for test: gem_lmem_swapping
results: parsing output: 79/ for test: vgem_basic
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: gem_exec_create
results: parsing output: 82/ for test: gem_mmap_offset
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: prime_vgem
results: parsing output: 86/ for test: kms_properties
results: parsing output: 87/ for test: prime_mmap
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: api_intel_bb
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: vgem_slow
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: perf_pmu
results: parsing output: 94/ for test: perf_pmu
results: parsing output: 95/ for test: gem_userptr_blits
results: parsing output: 96/ for test: kms_rotation_crc
results: parsing output: 97/ for test: kms_plane_scaling
results: parsing output: 98/ for test: kms_properties
results: parsing output: 99/ for test: syncobj_basic
results: parsing output: 100/ for test: kms_cursor_edge_walk
results: parsing output: 101/ for test: kms_getfb
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_exec_schedule
results: parsing output: 104/ for test: perf_pmu
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_exec_reloc
results: parsing output: 107/ for test: gem_mmap_wc
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: kms_color
results: parsing output: 112/ for test: gem_mmap_gtt
results: parsing output: 113/ for test: kms_plane_cursor
results: parsing output: 114/ for test: gem_eio
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: gem_ctx_isolation
results: parsing output: 117/ for test: kms_pm_rpm
results: parsing output: 118/ for test: kms_psr2_sf
results: parsing output: 119/ for test: gem_exec_fence
results: parsing output: 120/ for test: kms_joiner
results: parsing output: 121/ for test: gem_render_copy
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_plane
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: i915_suspend
results: parsing output: 126/ for test: kms_panel_fitting
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_busy
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: gem_ctx_shared
Done.