[57.590759] Initializing watchdogs
[57.590806]   /dev/watchdog0
[57.605018] [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.609462] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.611573] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.614956] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[57.743538] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[64.496841] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.758s)
[64.639995] [002/133] (953s left) gem_exec_fence (syncobj-signal)
[65.093035] Starting subtest: syncobj-signal
[65.098692] Subtest syncobj-signal: SUCCESS (0.006s)
[67.064579] [FACT gem_exec_fence (syncobj-signal)] new: kernel.kmod_is_loaded.vgem: true
[67.067780] [003/133] (951s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[67.302776] Starting subtest: y-tiled-32bpp-rotate-180
[67.307414] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[67.673248] [004/133] (950s left) gem_eio (throttle)
[67.968219] Starting subtest: throttle
[68.230776] Subtest throttle: SUCCESS (0.261s)
[68.345153] [005/133] (949s left) kms_psr (psr2-cursor-blt)
[68.452761] Starting subtest: psr2-cursor-blt
[68.455057] Starting dynamic subtest: eDP-1
[70.174659] Dynamic subtest eDP-1: SUCCESS (1.724s)
[70.177089] Subtest psr2-cursor-blt: SUCCESS (1.725s)
[70.977803] [006/133] (947s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[71.078689] Starting subtest: 4-tiled-addfb-size-offset-overflow
[71.080893] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[71.183196] [007/133] (947s left) gem_spin_batch (user-each)
[71.243334] Starting subtest: user-each
[74.511797] Subtest user-each: SUCCESS (3.260s)
[74.914231] [008/133] (943s left) kms_feature_discovery (display)
[75.003119] Starting subtest: display
[75.005482] Subtest display: SUCCESS (0.000s)
[75.078163] [009/133] (943s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[75.169937] Starting subtest: fbc-psr2-cursor-mmap-gtt
[75.172347] Starting dynamic subtest: eDP-1
[75.176551] Dynamic subtest eDP-1: SKIP (0.000s)
[75.180764] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[75.254197] [010/133] (943s left) prime_vgem (busy)
[75.329618] Starting subtest: busy
[75.331775] Starting dynamic subtest: rcs0
[75.371470] Dynamic subtest rcs0: SUCCESS (0.042s)
[75.379478] Starting dynamic subtest: bcs0
[75.443213] Dynamic subtest bcs0: SUCCESS (0.071s)
[75.451200] Starting dynamic subtest: vcs0
[75.487899] Dynamic subtest vcs0: SUCCESS (0.045s)
[75.496116] Starting dynamic subtest: vcs1
[75.536759] Dynamic subtest vcs1: SUCCESS (0.048s)
[75.544665] Starting dynamic subtest: vecs0
[75.582820] Dynamic subtest vecs0: SUCCESS (0.046s)
[75.590926] Starting dynamic subtest: ccs0
[75.631620] Dynamic subtest ccs0: SUCCESS (0.048s)
[75.633898] Subtest busy: SUCCESS (0.302s)
[75.770630] [011/133] (942s left) kms_pwrite_crc
[77.399938] [012/133] (941s left) kms_chamelium_frames (dp-crc-multiple)
[77.773132] Subtest dp-crc-multiple: SKIP (0.000s)
[78.617195] [013/133] (940s left) kms_vblank (ts-continuation-suspend)
[78.708969] Starting subtest: ts-continuation-suspend
[78.710949] Starting dynamic subtest: pipe-A-eDP-1
[95.040730] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.625s)
[95.059133] Starting dynamic subtest: pipe-D-eDP-1
[112.021099] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.171s)
[112.023435] Subtest ts-continuation-suspend: SUCCESS (3.801s)
[112.855887] [014/133] (905s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[112.971744] Starting subtest: cursorA-vs-flipB-toggle
[112.976389] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[113.128634] [015/133] (905s left) syncobj_timeline (wait-all-snapshot)
[113.179229] Starting subtest: wait-all-snapshot
[113.262447] Subtest wait-all-snapshot: SUCCESS (0.084s)
[113.338641] [016/133] (905s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[113.440401] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[117.007856] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.571s)
[118.140843] [017/133] (900s left) kms_pm_rpm (universal-planes-dpms)
[119.678841] Starting subtest: universal-planes-dpms
[119.681761] Starting dynamic subtest: plane-35
[128.006916] Dynamic subtest plane-35: SUCCESS (8.327s)
[128.018170] Starting dynamic subtest: plane-65
[136.326010] Dynamic subtest plane-65: SUCCESS (8.317s)
[136.338146] Starting dynamic subtest: plane-95
[144.624914] Dynamic subtest plane-95: SUCCESS (8.297s)
[144.636175] Starting dynamic subtest: plane-125
[152.905355] Dynamic subtest plane-125: SUCCESS (8.277s)
[152.917580] Starting dynamic subtest: plane-135
[161.189035] Dynamic subtest plane-135: SUCCESS (8.281s)
[161.200716] Starting dynamic subtest: plane-145
[169.827731] Dynamic subtest plane-145: SUCCESS (8.637s)
[169.830742] Subtest universal-planes-dpms: SUCCESS (50.146s)
[170.249449] [018/133] (848s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[170.349604] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[170.354177] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[170.451355] [019/133] (848s left) api_intel_allocator (reopen-fork)
[170.510489] Starting subtest: reopen-fork
[174.015243] Subtest reopen-fork: SUCCESS (3.503s)
[174.090690] [020/133] (844s left) kms_draw_crc (fill-fb)
[174.191366] Starting subtest: fill-fb
[174.597990] Subtest fill-fb: SUCCESS (0.408s)
[174.704570] [021/133] (844s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[174.796172] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[174.800645] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[174.883972] [022/133] (844s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[174.931301] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[174.935703] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[175.113239] [023/133] (843s left) i915_drm_fdinfo (busy-hang)
[175.156278] Starting subtest: busy-hang
[175.158618] Starting dynamic subtest: rcs0
[175.189645] Dynamic subtest rcs0: SKIP (0.032s)
[175.200091] Starting dynamic subtest: bcs0
[175.204219] Dynamic subtest bcs0: SKIP (0.001s)
[175.212502] Starting dynamic subtest: vcs0
[175.216937] Dynamic subtest vcs0: SKIP (0.000s)
[175.224844] Starting dynamic subtest: vcs1
[175.230350] Dynamic subtest vcs1: SKIP (0.000s)
[175.240814] Starting dynamic subtest: vecs0
[175.244914] Dynamic subtest vecs0: SKIP (0.000s)
[175.253176] Starting dynamic subtest: ccs0
[175.257463] Dynamic subtest ccs0: SKIP (0.000s)
[175.261702] Subtest busy-hang: SKIP (0.037s)
[175.300091] [024/133] (843s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[175.398789] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[175.402864] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[175.487906] [025/133] (843s left) gem_userptr_blits (coherency-sync)
[175.547787] Starting subtest: coherency-sync
[175.873908] Subtest coherency-sync: SKIP (0.291s)
[175.983583] [026/133] (843s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[176.131574] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[176.135582] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[176.218609] [027/133] (843s left) kms_cursor_crc (cursor-onscreen-256x85)
[176.487925] Starting subtest: cursor-onscreen-256x85
[176.531781] Subtest cursor-onscreen-256x85: SKIP (0.042s)
[176.716043] [028/133] (842s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[176.810460] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[176.813942] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[176.899109] [029/133] (842s left) gen9_exec_parse (bb-secure)
[176.954606] Subtest bb-secure: SKIP (0.000s)
[177.018786] [030/133] (842s left) gem_exec_schedule (implicit-read-write)
[177.086816] Starting subtest: implicit-read-write
[177.088352] Starting dynamic subtest: rcs0
[177.191063] Dynamic subtest rcs0: SUCCESS (0.112s)
[177.202596] Starting dynamic subtest: vcs0
[177.270062] Dynamic subtest vcs0: SUCCESS (0.078s)
[177.281005] Starting dynamic subtest: vcs1
[177.349812] Dynamic subtest vcs1: SUCCESS (0.079s)
[177.360871] Starting dynamic subtest: vecs0
[177.438136] Dynamic subtest vecs0: SUCCESS (0.088s)
[177.448664] Starting dynamic subtest: ccs0
[177.529004] Dynamic subtest ccs0: SUCCESS (0.090s)
[177.530895] Subtest implicit-read-write: SUCCESS (0.450s)
[178.503011] [031/133] (840s left) kms_cursor_crc (cursor-sliding-32x32)
[178.644920] Starting subtest: cursor-sliding-32x32
[178.687748] Subtest cursor-sliding-32x32: SKIP (0.040s)
[178.961307] [032/133] (840s left) syncobj_wait (multi-wait-for-submit-signaled)
[179.015010] Starting subtest: multi-wait-for-submit-signaled
[179.017223] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[179.114497] [033/133] (840s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[179.215638] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[186.064906] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.852s)
[186.214044] [034/133] (833s left) i915_pm_rc6_residency (media-rc6-accuracy)
[186.278171] Starting subtest: media-rc6-accuracy
[186.282242] Subtest media-rc6-accuracy: SKIP (0.000s)
[186.379315] [035/133] (833s left) perf (blocking)
[186.516107] Starting subtest: blocking
[186.517996] Starting dynamic subtest: 0-rcs0
[196.535303] Dynamic subtest 0-rcs0: SUCCESS (10.017s)
[196.545427] Starting dynamic subtest: 1-vcs0
[206.560890] Dynamic subtest 1-vcs0: SUCCESS (10.024s)
[206.563302] Subtest blocking: SUCCESS (20.043s)
[206.610352] [036/133] (813s left) kms_plane_multiple (2x-tiling-none)
[206.724874] Starting subtest: 2x-tiling-none
[206.729765] Subtest 2x-tiling-none: SKIP (0.000s)
[206.815959] [037/133] (812s left) kms_vrr (flipline)
[206.925043] Starting subtest: flipline
[206.931728] Subtest flipline: SKIP (0.000s)
[206.997356] [038/133] (812s left) vgem_basic (dmabuf-fence-before)
[207.051675] Starting subtest: dmabuf-fence-before
[207.053905] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[207.110817] [039/133] (812s left) vgem_basic (create)
[207.160611] Starting subtest: create
[207.162593] Subtest create: SUCCESS (0.000s)
[207.219182] [040/133] (812s left) dmabuf_sync_file (export-basic)
[207.260809] Starting subtest: export-basic
[207.263199] Subtest export-basic: SUCCESS (0.001s)
[207.319370] [041/133] (812s left) i915_pciid
[207.475492] [042/133] (812s left) gem_pxp (create-valid-protected-context)
[207.609393] Starting subtest: create-valid-protected-context
[207.611828] Subtest create-valid-protected-context: SUCCESS (0.002s)
[207.711442] [043/133] (812s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[207.802605] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[208.174957] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[210.942277] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.738s)
[210.953334] Starting dynamic subtest: pipe-A-eDP-1-4
[213.100403] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.185s)
[213.110236] Starting dynamic subtest: pipe-A-eDP-1-4
[215.111066] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[215.126562] Starting dynamic subtest: pipe-A-eDP-1-x
[217.301093] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[217.666222] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[220.442973] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.781s)
[220.455459] Starting dynamic subtest: pipe-B-eDP-1-4
[222.628056] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[222.638931] Starting dynamic subtest: pipe-B-eDP-1-4
[224.638015] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.010s)
[224.647158] Starting dynamic subtest: pipe-B-eDP-1-x
[226.828900] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[227.967189] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[230.382804] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.423s)
[230.393399] Starting dynamic subtest: pipe-C-eDP-1-4
[232.555719] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.171s)
[232.571518] Starting dynamic subtest: pipe-C-eDP-1-4
[234.565891] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[234.577158] Starting dynamic subtest: pipe-C-eDP-1-x
[236.744893] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[237.121732] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[239.913889] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.801s)
[239.923759] Starting dynamic subtest: pipe-D-eDP-1-4
[242.087543] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[242.097252] Starting dynamic subtest: pipe-D-eDP-1-4
[244.098165] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[244.107225] Starting dynamic subtest: pipe-D-eDP-1-x
[246.265464] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.165s)
[246.267913] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.460s)
[247.496710] [044/133] (772s left) gem_mmap_offset (clear)
[247.557678] Starting subtest: clear
[247.560078] Starting dynamic subtest: smem0
[272.458421] Dynamic subtest smem0: SUCCESS (24.895s)
[272.460857] Subtest clear: SUCCESS (24.895s)
[272.588888] [045/133] (747s left) kms_flip (2x-flip-vs-fences-interruptible)
[272.742781] Starting subtest: 2x-flip-vs-fences-interruptible
[272.747165] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[272.840613] [046/133] (747s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[272.934147] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[272.938289] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[273.036698] [047/133] (747s left) kms_flip_event_leak (basic)
[273.127653] Starting subtest: basic
[273.129592] Starting dynamic subtest: pipe-A-eDP-1
[273.558841] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.431s)
[273.570551] Starting dynamic subtest: pipe-B-eDP-1
[274.715703] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.155s)
[274.729674] Starting dynamic subtest: pipe-C-eDP-1
[275.839456] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.123s)
[275.851605] Starting dynamic subtest: pipe-D-eDP-1
[276.965977] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[276.967880] Subtest basic: SUCCESS (3.838s)
[277.828251] [048/133] (742s left) kms_flip (blocking-absolute-wf_vblank)
[277.918812] Starting subtest: blocking-absolute-wf_vblank
[277.920961] Starting dynamic subtest: A-eDP1
[286.691102] Dynamic subtest A-eDP1: SUCCESS (8.773s)
[286.700648] Starting dynamic subtest: B-eDP1
[295.412518] Dynamic subtest B-eDP1: SUCCESS (8.719s)
[295.422625] Starting dynamic subtest: C-eDP1
[304.128049] Dynamic subtest C-eDP1: SUCCESS (8.713s)
[304.143240] Starting dynamic subtest: D-eDP1
[312.862354] Dynamic subtest D-eDP1: SUCCESS (8.731s)
[312.864838] Subtest blocking-absolute-wf_vblank: SUCCESS (34.946s)
[314.105677] [049/133] (706s left) kms_getfb (getfb-handle-protection)
[314.206844] Starting subtest: getfb-handle-protection
[314.224947] Subtest getfb-handle-protection: SUCCESS (0.019s)
[314.371183] [050/133] (705s left) gem_exec_parallel (basic)
[314.426746] Starting subtest: basic
[314.429181] Starting dynamic subtest: rcs0
[315.871037] Dynamic subtest rcs0: SUCCESS (1.443s)
[315.882431] Starting dynamic subtest: bcs0
[317.327014] Dynamic subtest bcs0: SUCCESS (1.455s)
[317.339367] Starting dynamic subtest: vcs0
[319.390949] Dynamic subtest vcs0: SUCCESS (2.060s)
[319.401607] Starting dynamic subtest: vcs1
[321.438358] Dynamic subtest vcs1: SUCCESS (2.045s)
[321.450899] Starting dynamic subtest: vecs0
[323.423454] Dynamic subtest vecs0: SUCCESS (1.983s)
[323.436460] Starting dynamic subtest: ccs0
[324.888060] Dynamic subtest ccs0: SUCCESS (1.464s)
[324.890360] Subtest basic: SUCCESS (10.462s)
[325.087587] [051/133] (695s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[325.192085] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[332.179881] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.990s)
[332.289433] [052/133] (688s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[332.344686] Starting subtest: invalid-bsd2-flag-on-vebox
[332.347042] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[332.483727] [053/133] (687s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[332.573475] Starting subtest: sprite-rotation-90-pos-100-0
[332.577768] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[332.646257] [054/133] (687s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[332.751535] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[339.390055] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.641s)
[339.526645] [055/133] (680s left) fbdev (read)
[339.569604] Starting subtest: read
[340.119475] Subtest read: SUCCESS (0.551s)
[340.180398] [056/133] (680s left) gem_partial_pwrite_pread (write-display)
[340.248155] Subtest write-display: SKIP (0.000s)
[340.323838] [057/133] (680s left) gem_render_copy_redux (interruptible)
[340.387858] Starting subtest: interruptible
[340.648596] Subtest interruptible: SUCCESS (0.261s)
[340.823008] [058/133] (679s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[340.892640] Starting subtest: multi-wait-all-available-submitted-signaled
[340.894909] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[341.019823] [059/133] (679s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[341.115592] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[341.117864] Starting dynamic subtest: pipe-A-eDP-1
[341.139450] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[341.149388] Starting dynamic subtest: pipe-B-eDP-1
[341.166758] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[341.175237] Starting dynamic subtest: pipe-C-eDP-1
[341.192479] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[341.200925] Starting dynamic subtest: pipe-D-eDP-1
[341.219020] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[341.222588] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[343.288233] [060/133] (677s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[343.687209] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[344.506015] [061/133] (676s left) sysfs_defaults (readonly)
[344.577399] Starting subtest: readonly
[344.580108] Starting dynamic subtest: vecs0
[344.582601] Dynamic subtest vecs0: SUCCESS (0.000s)
[344.594933] Starting dynamic subtest: ccs0
[344.597131] Dynamic subtest ccs0: SUCCESS (0.001s)
[344.606144] Starting dynamic subtest: vcs0
[344.608355] Dynamic subtest vcs0: SUCCESS (0.000s)
[344.617495] Starting dynamic subtest: bcs0
[344.619772] Dynamic subtest bcs0: SUCCESS (0.000s)
[344.628866] Starting dynamic subtest: rcs0
[344.631096] Dynamic subtest rcs0: SUCCESS (0.000s)
[344.640277] Starting dynamic subtest: vcs1
[344.642171] Dynamic subtest vcs1: SUCCESS (0.000s)
[344.644109] Subtest readonly: SUCCESS (0.008s)
[344.697396] [062/133] (676s left) kms_plane (plane-panning-top-left)
[344.785587] Starting subtest: plane-panning-top-left
[344.787472] Starting dynamic subtest: pipe-A
[346.491911] Dynamic subtest pipe-A: SUCCESS (1.707s)
[346.504599] Starting dynamic subtest: pipe-B
[348.756856] Dynamic subtest pipe-B: SUCCESS (2.262s)
[348.759178] Subtest plane-panning-top-left: SUCCESS (3.972s)
[349.577430] [063/133] (671s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[349.673221] Starting subtest: psr-rgb101010-draw-blt
[356.912691] Subtest psr-rgb101010-draw-blt: SUCCESS (7.244s)
[357.052230] [064/133] (663s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[357.148039] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[357.152383] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[357.239758] [065/133] (663s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[357.335638] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[357.339717] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[357.433976] [066/133] (663s left) gem_cs_tlb (engines)
[357.503549] Starting subtest: engines
[357.505725] Starting dynamic subtest: rcs0
[359.657201] Dynamic subtest rcs0: SUCCESS (2.153s)
[359.666404] Starting dynamic subtest: bcs0
[361.810026] Dynamic subtest bcs0: SUCCESS (2.151s)
[361.820383] Starting dynamic subtest: vcs0
[363.962029] Dynamic subtest vcs0: SUCCESS (2.152s)
[363.978080] Starting dynamic subtest: vcs1
[366.115889] Dynamic subtest vcs1: SUCCESS (2.152s)
[366.128209] Starting dynamic subtest: vecs0
[368.268490] Dynamic subtest vecs0: SUCCESS (2.151s)
[368.279869] Starting dynamic subtest: ccs0
[370.424192] Dynamic subtest ccs0: SUCCESS (2.155s)
[370.426164] Subtest engines: SUCCESS (12.920s)
[370.552082] [067/133] (650s left) kms_cursor_legacy (forked-bo)
[370.682981] Starting subtest: forked-bo
[370.685491] Starting dynamic subtest: pipe-A
[376.145334] Dynamic subtest pipe-A: SUCCESS (5.459s)
[376.156725] Starting dynamic subtest: pipe-B
[381.643099] Dynamic subtest pipe-B: SUCCESS (5.494s)
[381.660275] Starting dynamic subtest: pipe-C
[387.108345] Dynamic subtest pipe-C: SUCCESS (5.463s)
[387.122882] Starting dynamic subtest: pipe-D
[392.580961] Dynamic subtest pipe-D: SUCCESS (5.470s)
[392.592834] Starting dynamic subtest: all-pipes
[398.104207] Dynamic subtest all-pipes: SUCCESS (5.520s)
[398.106752] Subtest forked-bo: SUCCESS (27.418s)
[398.262951] [068/133] (622s left) kms_addfb_basic (invalid-set-prop)
[398.334022] Starting subtest: invalid-set-prop
[398.336224] Subtest invalid-set-prop: SUCCESS (0.000s)
[398.494575] [069/133] (622s left) gem_eio (in-flight-1us)
[398.711456] Starting subtest: in-flight-1us
[407.188354] Subtest in-flight-1us: SUCCESS (8.476s)
[407.303212] [070/133] (613s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[407.392549] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[407.394656] Starting dynamic subtest: pipe-A-eDP-1
[407.416189] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[407.427870] Starting dynamic subtest: pipe-B-eDP-1
[407.448589] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[407.457909] Starting dynamic subtest: pipe-C-eDP-1
[407.478675] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[407.487592] Starting dynamic subtest: pipe-D-eDP-1
[407.509216] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[407.513199] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[409.649267] [071/133] (611s left) syncobj_wait (single-wait-all-for-submit-submitted)
[409.710996] Starting subtest: single-wait-all-for-submit-submitted
[409.818407] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.107s)
[409.896064] [072/133] (611s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[410.000032] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[410.005097] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[410.094879] [073/133] (611s left) gem_userptr_blits (usage-restrictions)
[410.165018] Starting subtest: usage-restrictions
[410.167001] Subtest usage-restrictions: SUCCESS (0.000s)
[410.288338] [074/133] (611s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[410.393862] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[410.396135] Starting dynamic subtest: pipe-A-eDP-1
[410.418985] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[410.429867] Starting dynamic subtest: pipe-B-eDP-1
[410.450853] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[410.459666] Starting dynamic subtest: pipe-C-eDP-1
[410.480970] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[410.489831] Starting dynamic subtest: pipe-D-eDP-1
[410.511478] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[410.515796] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[412.720156] [075/133] (608s left) gem_tiled_pread_pwrite
[412.847733] [076/133] (608s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[412.947573] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[412.949791] Starting dynamic subtest: pipe-A-default-mode
[414.070033] Dynamic subtest pipe-A-default-mode: SKIP (1.122s)
[414.074475] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.123s)
[414.230856] [077/133] (607s left) gem_ctx_bad_destroy (invalid-ctx)
[414.282192] Starting subtest: invalid-ctx
[414.284606] Subtest invalid-ctx: SUCCESS (0.000s)
[414.360467] [078/133] (607s left) i915_suspend (fence-restore-untiled)
[414.414538] Starting subtest: fence-restore-untiled
[414.418578] Subtest fence-restore-untiled: SKIP (0.000s)
[414.508406] [079/133] (607s left) gem_exec_reloc (basic-cpu-read-active)
[414.567812] Subtest basic-cpu-read-active: SKIP (0.000s)
[414.635014] [080/133] (606s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[414.742417] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[415.710636] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.968s)
[415.831925] [081/133] (605s left) gem_exec_gttfill (engines)
[415.890296] Starting subtest: engines
[415.892746] Starting dynamic subtest: rcs0
[438.559107] Dynamic subtest rcs0: SUCCESS (22.666s)
[438.571073] Starting dynamic subtest: bcs0
[461.907274] Dynamic subtest bcs0: SUCCESS (23.345s)
[461.919765] Starting dynamic subtest: vcs0
[485.234327] Dynamic subtest vcs0: SUCCESS (23.323s)
[485.246564] Starting dynamic subtest: vcs1
[508.569274] Dynamic subtest vcs1: SUCCESS (23.331s)
[508.579261] Starting dynamic subtest: vecs0
[531.876437] Dynamic subtest vecs0: SUCCESS (23.304s)
[531.889279] Starting dynamic subtest: ccs0
[555.273819] Dynamic subtest ccs0: SUCCESS (23.393s)
[555.276593] Subtest engines: SUCCESS (139.377s)
[555.460434] [082/133] (466s left) gem_exec_schedule (timeslicing)
[555.587382] Starting subtest: timeslicing
[555.589548] Starting dynamic subtest: rcs0
[555.602379] Dynamic subtest rcs0: SUCCESS (0.025s)
[555.614272] Starting dynamic subtest: bcs0
[555.626331] Dynamic subtest bcs0: SUCCESS (0.023s)
[555.635942] Starting dynamic subtest: vcs0
[555.650205] Dynamic subtest vcs0: SUCCESS (0.023s)
[555.660079] Starting dynamic subtest: vcs1
[555.671693] Dynamic subtest vcs1: SUCCESS (0.021s)
[555.681111] Starting dynamic subtest: vecs0
[555.693475] Dynamic subtest vecs0: SUCCESS (0.021s)
[555.703248] Starting dynamic subtest: ccs0
[555.717973] Dynamic subtest ccs0: SUCCESS (0.024s)
[555.720288] Subtest timeslicing: SUCCESS (0.141s)
[557.450467] [083/133] (464s left) prime_self_import (reimport-vs-gem_close-race)
[557.495343] Starting subtest: reimport-vs-gem_close-race
[562.577592] Subtest reimport-vs-gem_close-race: SUCCESS (5.083s)
[562.656050] [084/133] (459s left) perf (unprivileged-single-ctx-counters)
[562.776573] Starting subtest: unprivileged-single-ctx-counters
[562.781449] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[562.824174] [085/133] (458s left) kms_color (ctm-0-25)
[562.929788] Starting subtest: ctm-0-25
[562.931625] Starting dynamic subtest: pipe-A-eDP-1
[566.337620] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.408s)
[566.351155] Starting dynamic subtest: pipe-B-eDP-1
[570.460744] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.121s)
[570.471260] Starting dynamic subtest: pipe-C-eDP-1
[574.517104] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.055s)
[574.526927] Starting dynamic subtest: pipe-D-eDP-1
[578.498260] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.981s)
[578.500618] Subtest ctm-0-25: SUCCESS (15.569s)
[579.312847] [086/133] (442s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[579.420477] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[579.424959] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[579.529662] [087/133] (442s left) gem_ctx_shared (q-promotion)
[579.614038] Starting subtest: Q-promotion
[579.616017] Starting dynamic subtest: rcs0
[579.738850] Dynamic subtest rcs0: SUCCESS (0.125s)
[579.749132] Starting dynamic subtest: vcs0
[579.834486] Dynamic subtest vcs0: SUCCESS (0.096s)
[579.844141] Starting dynamic subtest: vcs1
[579.946690] Dynamic subtest vcs1: SUCCESS (0.111s)
[579.962269] Starting dynamic subtest: vecs0
[580.031045] Dynamic subtest vecs0: SUCCESS (0.082s)
[580.048314] Starting dynamic subtest: ccs0
[580.130191] Dynamic subtest ccs0: SUCCESS (0.099s)
[580.132622] Subtest Q-promotion: SUCCESS (0.519s)
[581.494660] [088/133] (440s left) gem_exec_balancer (sequential)
[581.555350] Starting subtest: sequential
[584.626259] Subtest sequential: SUCCESS (3.071s)
[584.918671] [089/133] (437s left) perf_pmu (busy-hang)
[584.958357] Starting subtest: busy-hang
[584.960778] Starting dynamic subtest: rcs0
[586.244933] Dynamic subtest rcs0: SUCCESS (1.286s)
[586.259424] Starting dynamic subtest: bcs0
[587.492457] Dynamic subtest bcs0: SUCCESS (1.245s)
[587.505169] Starting dynamic subtest: vcs0
[589.917924] Dynamic subtest vcs0: SUCCESS (2.421s)
[589.929705] Starting dynamic subtest: vcs1
[591.969135] Dynamic subtest vcs1: SUCCESS (2.049s)
[591.983775] Starting dynamic subtest: vecs0
[593.954050] Dynamic subtest vecs0: SUCCESS (1.986s)
[593.965984] Starting dynamic subtest: ccs0
[595.191673] Dynamic subtest ccs0: SUCCESS (1.236s)
[595.194204] Subtest busy-hang: SUCCESS (10.234s)
[595.304144] [090/133] (426s left) kms_mmap_write_crc (main)
[595.415183] Starting subtest: main
[595.417454] Starting dynamic subtest: pipe-A-eDP-1
[598.741428] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.323s)
[598.743297] Subtest main: SUCCESS (3.324s)
[599.538362] [091/133] (422s left) gem_exec_reloc (basic-wc-read)
[599.598313] Subtest basic-wc-read: SKIP (0.000s)
[599.672971] [092/133] (422s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[599.767702] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[599.769881] Starting dynamic subtest: pipe-A-eDP-1
[599.790671] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[599.802383] Starting dynamic subtest: pipe-B-eDP-1
[599.822012] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[599.831697] Starting dynamic subtest: pipe-C-eDP-1
[599.851206] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[599.860941] Starting dynamic subtest: pipe-D-eDP-1
[599.880229] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[599.882115] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.013s)
[602.106957] [093/133] (419s left) gem_userptr_blits (stress-mm)
[602.175164] Starting subtest: stress-mm
[607.545267] Subtest stress-mm: SUCCESS (5.369s)
[607.674465] [094/133] (414s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[607.784404] Starting subtest: x-tiled-64bpp-rotate-270
[607.804107] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[607.922838] [095/133] (414s left) kms_atomic (plane-primary-legacy)
[608.015848] Starting subtest: plane-primary-legacy
[608.018104] Starting dynamic subtest: pipe-A-eDP-1
[608.463191] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.448s)
[608.465445] Subtest plane-primary-legacy: SUCCESS (0.450s)
[609.333346] [096/133] (412s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[609.434800] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[609.439374] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[609.516309] [097/133] (412s left) kms_psr (psr2-sprite-blt)
[609.614928] Starting subtest: psr2-sprite-blt
[609.617322] Starting dynamic subtest: eDP-1
[611.314815] Dynamic subtest eDP-1: SUCCESS (1.700s)
[611.317019] Subtest psr2-sprite-blt: SUCCESS (1.701s)
[612.197737] [098/133] (410s left) gem_mmap_gtt (cpuset-medium-copy)
[612.265659] Subtest cpuset-medium-copy: SKIP (0.000s)
[612.329805] [099/133] (410s left) kms_big_fb (linear-16bpp-rotate-90)
[612.422622] Starting subtest: linear-16bpp-rotate-90
[612.445142] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[612.558974] [100/133] (409s left) api_intel_bb (misplaced-blitter)
[612.606351] Starting subtest: misplaced-blitter
[612.611314] Subtest misplaced-blitter: SUCCESS (0.007s)
[612.746810] [101/133] (409s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[612.841958] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[620.134326] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.294s)
[620.262839] [102/133] (402s left) kms_prop_blob (blob-prop-validate)
[620.316860] Starting subtest: blob-prop-validate
[620.319078] Subtest blob-prop-validate: SUCCESS (0.000s)
[620.423844] [103/133] (402s left) kms_fbcon_fbt (psr)
[620.477098] Starting subtest: psr
[627.780237] Subtest psr: SUCCESS (7.299s)
[627.863947] [104/133] (394s left) kms_lease (lease-unleased-connector)
[627.966723] Starting subtest: lease-unleased-connector
[627.968927] Starting dynamic subtest: pipe-A-eDP-1
[627.973688] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[627.984130] Starting dynamic subtest: pipe-B-eDP-1
[627.986190] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[627.996483] Starting dynamic subtest: pipe-C-eDP-1
[627.998631] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[628.008845] Starting dynamic subtest: pipe-D-eDP-1
[628.011059] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[628.013209] Subtest lease-unleased-connector: SUCCESS (0.039s)
[628.123342] [105/133] (394s left) kms_content_protection (dp-mst-type-0)
[628.261638] Starting subtest: dp-mst-type-0
[628.266066] Subtest dp-mst-type-0: SKIP (0.000s)
[628.379124] [106/133] (394s left) gem_exec_balancer (bonded-dual)
[628.464190] Starting subtest: bonded-dual
[628.468305] Subtest bonded-dual: SKIP (0.000s)
[628.822975] [107/133] (393s left) gem_vm_create (create-ext)
[628.877257] Starting subtest: create-ext
[628.883211] Subtest create-ext: SUCCESS (0.006s)
[629.020739] [108/133] (393s left) gem_ctx_persistence (legacy-engines-persistence)
[629.083095] Starting subtest: legacy-engines-persistence
[629.085424] Starting dynamic subtest: render
[629.927383] Dynamic subtest render: SUCCESS (0.846s)
[629.940776] Starting dynamic subtest: bsd1
[630.694502] Dynamic subtest bsd1: SUCCESS (0.764s)
[630.708179] Starting dynamic subtest: bsd2
[631.448542] Dynamic subtest bsd2: SUCCESS (0.751s)
[631.461509] Starting dynamic subtest: blt
[632.195358] Dynamic subtest blt: SUCCESS (0.744s)
[632.208602] Starting dynamic subtest: vebox
[632.999753] Dynamic subtest vebox: SUCCESS (0.802s)
[633.002445] Subtest legacy-engines-persistence: SUCCESS (3.920s)
[633.084536] [109/133] (389s left) syncobj_eventfd (timeline-wait-signaled)
[633.141992] Starting subtest: timeline-wait-signaled
[633.144183] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[633.259853] [110/133] (389s left) gem_ctx_freq (sysfs)
[633.333627] Starting subtest: sysfs
[633.336335] Starting dynamic subtest: gt0
[638.858343] Dynamic subtest gt0: SUCCESS (5.529s)
[638.870400] Starting dynamic subtest: gt1
[680.413855] Dynamic subtest gt1: SUCCESS (41.551s)
[680.416759] Subtest sysfs: SUCCESS (47.084s)
[680.529894] [111/133] (342s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[680.626497] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[680.652654] Starting dynamic subtest: pipe-A-plane-0
[681.085925] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[681.096260] Starting dynamic subtest: pipe-A-plane-3
[681.352543] Dynamic subtest pipe-A-plane-3: SUCCESS (0.264s)
[681.362859] Starting dynamic subtest: pipe-A-plane-5
[681.367338] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[682.473588] Starting dynamic subtest: pipe-B-plane-0
[682.899165] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[682.911866] Starting dynamic subtest: pipe-B-plane-3
[683.153001] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[683.164240] Starting dynamic subtest: pipe-B-plane-5
[683.168788] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[683.469968] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.843s)
[684.346145] [112/133] (338s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[684.450850] Starting subtest: primary-x-tiled-reflect-x-180
[691.402307] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.954s)
[692.607954] [113/133] (330s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[692.717479] Starting subtest: pr-primary-plane-update-sf-dmg-area
[692.721990] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[692.787748] [114/133] (330s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[694.611445] Starting subtest: dpms-mode-unset-lpsp
[698.670774] Subtest dpms-mode-unset-lpsp: SUCCESS (4.063s)
[699.057194] [115/133] (324s left) kms_cdclk (mode-transition-all-outputs)
[699.145505] Starting subtest: mode-transition-all-outputs
[699.436584] Subtest mode-transition-all-outputs: SKIP (0.289s)
[700.279690] [116/133] (322s left) kms_atomic_interruptible (universal-setplane-primary)
[700.380592] Starting subtest: universal-setplane-primary
[700.385065] Starting dynamic subtest: pipe-A-eDP-1
[707.816504] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.430s)
[707.818539] Subtest universal-setplane-primary: SUCCESS (7.434s)
[708.641948] [117/133] (314s left) gem_lmem_swapping (parallel-multi)
[708.692126] Subtest parallel-multi: SKIP (0.000s)
[708.742770] [118/133] (314s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[708.850648] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[715.782962] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.935s)
[715.888878] [119/133] (307s left) kms_invalid_mode (bad-vsync-start)
[716.012636] Starting subtest: bad-vsync-start
[716.014884] Starting dynamic subtest: pipe-A-eDP-1
[716.296692] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[716.307765] Starting dynamic subtest: pipe-B-eDP-1
[716.309788] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[716.319692] Starting dynamic subtest: pipe-C-eDP-1
[716.321809] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[716.332173] Starting dynamic subtest: pipe-D-eDP-1
[716.334321] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[716.336603] Subtest bad-vsync-start: SUCCESS (0.290s)
[717.122904] [120/133] (306s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[717.220713] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[717.224383] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[717.316742] [121/133] (306s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[717.544889] Starting subtest: cursor-rapid-movement-128x42
[717.594148] Subtest cursor-rapid-movement-128x42: SKIP (0.043s)
[717.789776] [122/133] (305s left) gem_exec_whisper (basic-forked)
[717.853335] Starting subtest: basic-forked
[725.799938] Subtest basic-forked: SUCCESS (7.944s)
[725.990124] [123/133] (297s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[726.045646] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[726.047976] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[726.163145] [124/133] (297s left) kms_selftest (drm_dp_mst_helper)
[726.203259] Starting subtest: drm_dp_mst_helper
[726.240056] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[726.332377] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.091s)
[726.342847] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[726.428645] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.094s)
[726.438154] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[726.552796] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.125s)
[726.554655] Subtest drm_dp_mst_helper: SUCCESS (0.349s)
[726.698316] [125/133] (296s left) kms_psr (psr-sprite-plane-move)
[726.799673] Starting subtest: psr-sprite-plane-move
[726.801977] Starting dynamic subtest: eDP-1
[728.575336] Dynamic subtest eDP-1: SUCCESS (1.773s)
[728.578095] Subtest psr-sprite-plane-move: SUCCESS (1.774s)
[729.393039] [126/133] (294s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[729.494727] Starting subtest: fbc-psr-cursor-mmap-gtt
[729.497017] Starting dynamic subtest: eDP-1
[729.501086] Dynamic subtest eDP-1: SKIP (0.000s)
[729.505224] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[729.583382] [127/133] (294s left) syncobj_timeline (etime-single-wait-all-submitted)
[729.634303] Starting subtest: etime-single-wait-all-submitted
[729.737266] Subtest etime-single-wait-all-submitted: SUCCESS (0.103s)
[729.820519] [128/133] (293s left) gem_pxp (protected-raw-src-copy-not-readible)
[729.925649] Starting subtest: protected-raw-src-copy-not-readible
[729.984848] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.061s)
[730.112670] [129/133] (293s left) syncobj_wait (wait-all-complex)
[730.160924] Starting subtest: wait-all-complex
[730.378732] Subtest wait-all-complex: SUCCESS (0.216s)
[730.468669] [130/133] (293s left) gem_flink_basic (basic)
[730.515765] Starting subtest: basic
[730.517732] Subtest basic: SUCCESS (0.000s)
[730.632055] [131/133] (293s left) syncobj_wait (reset-signaled)
[730.692045] Starting subtest: reset-signaled
[730.694430] Subtest reset-signaled: SUCCESS (0.000s)
[730.812954] [132/133] (293s left) kms_psr (fbc-pr-no-drrs)
[730.915517] Starting subtest: fbc-pr-no-drrs
[730.919608] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[730.987848] [133/133] (292s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[731.079688] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[731.082006] Starting dynamic subtest: pipe-A
[731.351881] Dynamic subtest pipe-A: SUCCESS (0.274s)
[731.363246] Starting dynamic subtest: pipe-B
[732.676304] Dynamic subtest pipe-B: SUCCESS (1.323s)
[732.687429] Starting dynamic subtest: pipe-C
[734.007906] Dynamic subtest pipe-C: SUCCESS (1.331s)
[734.018257] Starting dynamic subtest: pipe-D
[735.340670] Dynamic subtest pipe-D: SUCCESS (1.332s)
[735.342945] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.264s)
[736.526915] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_exec_fence
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: gem_eio
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: gem_spin_batch
results: parsing output: 7/ for test: kms_feature_discovery
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: prime_vgem
results: parsing output: 10/ for test: kms_pwrite_crc
results: parsing output: 11/ for test: kms_chamelium_frames
results: parsing output: 12/ for test: kms_vblank
results: parsing output: 13/ for test: kms_cursor_legacy
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_pm_rpm
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: api_intel_allocator
results: parsing output: 19/ for test: kms_draw_crc
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_render_copy
results: parsing output: 22/ for test: i915_drm_fdinfo
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: gem_userptr_blits
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gen9_exec_parse
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: syncobj_wait
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: i915_pm_rc6_residency
results: parsing output: 34/ for test: perf
results: parsing output: 35/ for test: kms_plane_multiple
results: parsing output: 36/ for test: kms_vrr
results: parsing output: 37/ for test: vgem_basic
results: parsing output: 38/ for test: vgem_basic
results: parsing output: 39/ for test: dmabuf_sync_file
results: parsing output: 40/ for test: i915_pciid
results: parsing output: 41/ for test: gem_pxp
results: parsing output: 42/ for test: kms_async_flips
results: parsing output: 43/ for test: gem_mmap_offset
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_flip_event_leak
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: kms_getfb
results: parsing output: 49/ for test: gem_exec_parallel
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_exec_params
results: parsing output: 52/ for test: kms_rotation_crc
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: fbdev
results: parsing output: 55/ for test: gem_partial_pwrite_pread
results: parsing output: 56/ for test: gem_render_copy_redux
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_chamelium_hpd
results: parsing output: 60/ for test: sysfs_defaults
results: parsing output: 61/ for test: kms_plane
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_cs_tlb
results: parsing output: 66/ for test: kms_cursor_legacy
results: parsing output: 67/ for test: kms_addfb_basic
results: parsing output: 68/ for test: gem_eio
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: syncobj_wait
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: gem_userptr_blits
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: gem_tiled_pread_pwrite
results: parsing output: 75/ for test: kms_flip_scaled_crc
results: parsing output: 76/ for test: gem_ctx_bad_destroy
results: parsing output: 77/ for test: i915_suspend
results: parsing output: 78/ for test: gem_exec_reloc
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: gem_exec_gttfill
results: parsing output: 81/ for test: gem_exec_schedule
results: parsing output: 82/ for test: prime_self_import
results: parsing output: 83/ for test: perf
results: parsing output: 84/ for test: kms_color
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_ctx_shared
results: parsing output: 87/ for test: gem_exec_balancer
results: parsing output: 88/ for test: perf_pmu
results: parsing output: 89/ for test: kms_mmap_write_crc
results: parsing output: 90/ for test: gem_exec_reloc
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: gem_userptr_blits
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_atomic
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: gem_mmap_gtt
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: api_intel_bb
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_prop_blob
results: parsing output: 102/ for test: kms_fbcon_fbt
results: parsing output: 103/ for test: kms_lease
results: parsing output: 104/ for test: kms_content_protection
results: parsing output: 105/ for test: gem_exec_balancer
results: parsing output: 106/ for test: gem_vm_create
results: parsing output: 107/ for test: gem_ctx_persistence
results: parsing output: 108/ for test: syncobj_eventfd
results: parsing output: 109/ for test: gem_ctx_freq
results: parsing output: 110/ for test: kms_plane
results: parsing output: 111/ for test: kms_rotation_crc
results: parsing output: 112/ for test: kms_psr2_sf
results: parsing output: 113/ for test: kms_pm_rpm
results: parsing output: 114/ for test: kms_cdclk
results: parsing output: 115/ for test: kms_atomic_interruptible
results: parsing output: 116/ for test: gem_lmem_swapping
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_invalid_mode
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_cursor_crc
results: parsing output: 121/ for test: gem_exec_whisper
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_selftest
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: gem_pxp
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: gem_flink_basic
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: kms_plane_scaling
Done.