[59.898753] Initializing watchdogs
[59.898800]   /dev/watchdog0
[59.913251] [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]
[59.917797] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.920356] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.923483] [001/133] (960s left) kms_properties (plane-properties-legacy)
[60.049137] Starting subtest: plane-properties-legacy
[60.051572] Starting dynamic subtest: pipe-A-eDP-1
[60.660945] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.611s)
[60.668391] Starting dynamic subtest: pipe-B-eDP-1
[61.974685] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.314s)
[61.984222] Starting dynamic subtest: pipe-C-eDP-1
[63.283695] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.307s)
[63.292751] Starting dynamic subtest: pipe-D-eDP-1
[64.515111] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s)
[64.517308] Subtest plane-properties-legacy: SUCCESS (4.467s)
[65.319608] [002/133] (955s left) gem_ctx_persistence (idempotent)
[65.410249] Starting subtest: idempotent
[65.413045] Subtest idempotent: SUCCESS (0.000s)
[65.518756] [003/133] (954s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[65.629073] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[66.442071] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.814s)
[66.634569] [004/133] (953s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[66.800998] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[66.805625] Starting dynamic subtest: pipe-A-eDP-1
[67.812472] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.002s)
[67.819447] Starting dynamic subtest: pipe-B-eDP-1
[69.471460] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.654s)
[69.480680] Starting dynamic subtest: pipe-C-eDP-1
[70.984737] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.512s)
[70.993622] Starting dynamic subtest: pipe-D-eDP-1
[72.502873] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.518s)
[72.504932] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.692s)
[73.670693] [005/133] (946s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[73.727895] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[73.730276] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[73.832515] [006/133] (946s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[73.927681] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[73.933495] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[74.013985] [007/133] (946s left) gem_exec_nop (basic-series)
[74.084827] Starting subtest: basic-series
[89.881975] Subtest basic-series: SUCCESS (15.801s)
[90.092093] [008/133] (930s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[90.213732] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[90.218069] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[90.304681] [009/133] (930s left) kms_psr (psr2-sprite-render)
[90.402158] Starting subtest: psr2-sprite-render
[90.404508] Starting dynamic subtest: eDP-1
[92.166342] Dynamic subtest eDP-1: SUCCESS (1.764s)
[92.168687] Subtest psr2-sprite-render: SUCCESS (1.765s)
[93.026639] [010/133] (927s left) perf (blocking)
[93.170321] Starting subtest: blocking
[93.172146] Starting dynamic subtest: 0-rcs0
[103.193098] Dynamic subtest 0-rcs0: SUCCESS (10.021s)
[103.201164] Starting dynamic subtest: 1-vcs1
[113.267200] Dynamic subtest 1-vcs1: SUCCESS (10.019s)
[113.270208] Subtest blocking: SUCCESS (20.041s)
[113.307902] [011/133] (907s left) gem_exec_balancer (busy)
[113.377919] Starting subtest: busy
[114.900611] Subtest busy: SUCCESS (1.521s)
[115.200818] [012/133] (905s left) gem_render_tiled_blits (basic)
[115.256205] Subtest basic: SKIP (0.000s)
[115.308437] [013/133] (905s left) gem_exec_flush (basic-uc-prw-default)
[115.379592] Starting subtest: basic-uc-prw-default
[120.870352] Subtest basic-uc-prw-default: SUCCESS (5.467s)
[121.026192] [014/133] (899s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[121.124814] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[121.128924] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[121.201018] [015/133] (899s left) kms_properties (colorop-properties-legacy)
[121.291948] Starting subtest: colorop-properties-legacy
[121.294140] Starting dynamic subtest: pipe-A-eDP-1
[121.653859] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.362s)
[121.661411] Starting dynamic subtest: pipe-B-eDP-1
[122.700069] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.044s)
[122.708788] Starting dynamic subtest: pipe-C-eDP-1
[123.722229] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.022s)
[123.729961] Starting dynamic subtest: pipe-D-eDP-1
[124.761731] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.039s)
[124.764183] Subtest colorop-properties-legacy: SUCCESS (3.472s)
[125.555785] [016/133] (895s left) gem_mmap_offset (pf-nonblock)
[125.618683] Starting subtest: pf-nonblock
[125.623256] Subtest pf-nonblock: SUCCESS (0.006s)
[125.744157] [017/133] (895s left) kms_feature_discovery (psr1)
[125.842931] Starting subtest: psr1
[125.845264] Subtest psr1: SUCCESS (0.000s)
[125.920512] [018/133] (895s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[126.116650] Starting subtest: cursor-rapid-movement-64x21
[126.165381] Subtest cursor-rapid-movement-64x21: SKIP (0.043s)
[126.396676] [019/133] (894s left) kms_cursor_crc (cursor-offscreen-64x21)
[126.578268] Starting subtest: cursor-offscreen-64x21
[126.626245] Subtest cursor-offscreen-64x21: SKIP (0.043s)
[126.847454] [020/133] (894s left) gem_create (create-clear)
[126.893306] Starting subtest: create-clear
[126.895233] Starting dynamic subtest: smem0
[159.728857] Dynamic subtest smem0: SUCCESS (32.831s)
[159.731368] Subtest create-clear: SUCCESS (32.831s)
[159.912803] [021/133] (861s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[160.001374] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[164.215033] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.217s)
[165.369219] [022/133] (855s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[165.515872] Starting subtest: dp-mst-lic-type-0-hdcp14
[165.520625] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[165.655600] [023/133] (855s left) gem_reg_read (bad-register)
[165.707933] Starting subtest: bad-register
[165.709968] Subtest bad-register: SUCCESS (0.000s)
[165.790311] [024/133] (855s left) gem_exec_params (mmapped)
[165.843912] Starting subtest: mmapped
[165.848614] Subtest mmapped: SUCCESS (0.003s)
[165.951507] [025/133] (855s left) api_intel_allocator (reserve-simple)
[166.003702] Starting subtest: reserve-simple
[166.006055] Subtest reserve-simple: SUCCESS (0.003s)
[166.121857] [026/133] (855s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[166.212015] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[166.216248] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[166.294382] [027/133] (855s left) gem_flink_race (flink_close)
[166.324825] Starting subtest: flink_close
[171.426616] Subtest flink_close: SUCCESS (5.089s)
[171.496554] [028/133] (849s left) kms_vblank (query-forked-busy)
[171.600936] Starting subtest: query-forked-busy
[171.602921] Starting dynamic subtest: pipe-A-eDP-1
[173.478977] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.876s)
[173.495767] Starting dynamic subtest: pipe-D-eDP-1
[176.016044] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.536s)
[176.018440] Subtest query-forked-busy: SUCCESS (4.415s)
[176.815165] [029/133] (844s left) kms_force_connector_basic (force-edid)
[176.885131] Starting subtest: force-edid
[177.249763] Subtest force-edid: SUCCESS (0.367s)
[177.384855] [030/133] (844s left) gem_vm_create (invalid-create)
[177.445232] Starting subtest: invalid-create
[177.447519] Subtest invalid-create: SUCCESS (0.001s)
[177.558875] [031/133] (844s left) prime_mmap (test_userptr)
[177.619846] Starting subtest: test_userptr
[177.622158] Starting dynamic subtest: test_userptr-smem
[177.624504] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[177.626734] Subtest test_userptr: SUCCESS (0.001s)
[177.726350] [032/133] (843s left) kms_hdr (static-toggle-suspend)
[177.821642] Starting subtest: static-toggle-suspend
[177.827147] Subtest static-toggle-suspend: SKIP (0.000s)
[177.891367] [033/133] (843s left) kms_pm_rpm (legacy-planes-dpms)
[180.122739] Starting subtest: legacy-planes-dpms
[180.128251] Starting dynamic subtest: plane-64
[188.428614] Dynamic subtest plane-64: SUCCESS (8.309s)
[188.438803] Starting dynamic subtest: plane-94
[196.744120] Dynamic subtest plane-94: SUCCESS (8.314s)
[196.754051] Starting dynamic subtest: plane-124
[205.084762] Dynamic subtest plane-124: SUCCESS (8.339s)
[205.095734] Starting dynamic subtest: plane-134
[213.393659] Dynamic subtest plane-134: SUCCESS (8.308s)
[213.396178] Subtest legacy-planes-dpms: SUCCESS (33.275s)
[213.771454] [034/133] (807s left) syncobj_timeline (32bits-limit)
[213.819806] Starting subtest: 32bits-limit
[213.822094] Subtest 32bits-limit: SUCCESS (0.001s)
[213.916368] [035/133] (807s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[214.019841] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[214.644101] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.626s)
[214.814758] [036/133] (806s left) kms_debugfs (display-off-read-all)
[214.907066] Starting subtest: display-off-read-all
[215.195808] Subtest display-off-read-all: SUCCESS (0.289s)
[216.038859] [037/133] (805s left) perf_pmu (enable-race)
[216.077450] Starting subtest: enable-race
[216.079733] Starting dynamic subtest: rcs0
[228.867449] Dynamic subtest rcs0: SUCCESS (12.770s)
[228.878063] Starting dynamic subtest: bcs0
[241.610396] Dynamic subtest bcs0: SUCCESS (12.742s)
[241.619528] Starting dynamic subtest: vcs0
[256.853331] Dynamic subtest vcs0: SUCCESS (15.259s)
[256.862113] Starting dynamic subtest: vcs1
[272.917894] Dynamic subtest vcs1: SUCCESS (16.062s)
[272.927396] Starting dynamic subtest: vecs0
[288.917845] Dynamic subtest vecs0: SUCCESS (15.997s)
[288.926899] Starting dynamic subtest: ccs0
[301.678125] Dynamic subtest ccs0: SUCCESS (12.739s)
[301.680205] Subtest enable-race: SUCCESS (85.580s)
[301.783940] [038/133] (720s left) gem_mmap_wc (read-write)
[301.846778] Subtest read-write: SKIP (0.000s)
[301.905381] [039/133] (719s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[302.021755] Starting subtest: y-tiled-64bpp-rotate-0
[302.026246] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[302.117835] [040/133] (719s left) kms_flip (wf_vblank-ts-check-interruptible)
[302.214304] Starting subtest: wf_vblank-ts-check-interruptible
[302.216581] Starting dynamic subtest: A-eDP1
[311.175974] Dynamic subtest A-eDP1: SUCCESS (8.929s)
[311.186050] Starting dynamic subtest: B-eDP1
[320.073319] Dynamic subtest B-eDP1: SUCCESS (8.895s)
[320.086086] Starting dynamic subtest: C-eDP1
[328.972608] Dynamic subtest C-eDP1: SUCCESS (8.885s)
[328.982080] Starting dynamic subtest: D-eDP1
[337.868883] Dynamic subtest D-eDP1: SUCCESS (8.894s)
[337.871206] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.615s)
[339.023541] [041/133] (682s left) gem_exec_fence (nb-await)
[339.214874] Starting subtest: nb-await
[339.217341] Starting dynamic subtest: rcs0
[339.283253] Dynamic subtest rcs0: SUCCESS (0.068s)
[339.293839] Starting dynamic subtest: bcs0
[339.341895] Dynamic subtest bcs0: SUCCESS (0.057s)
[339.352496] Starting dynamic subtest: vcs0
[339.400627] Dynamic subtest vcs0: SUCCESS (0.057s)
[339.411092] Starting dynamic subtest: vcs1
[339.460096] Dynamic subtest vcs1: SUCCESS (0.058s)
[339.471062] Starting dynamic subtest: vecs0
[339.518426] Dynamic subtest vecs0: SUCCESS (0.057s)
[339.528631] Starting dynamic subtest: ccs0
[339.579120] Dynamic subtest ccs0: SUCCESS (0.059s)
[339.581458] Subtest nb-await: SUCCESS (0.365s)
[340.958090] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[340.961851] [042/133] (681s left) gem_flink_basic (bad-flink)
[341.030557] Starting subtest: bad-flink
[341.032910] Subtest bad-flink: SUCCESS (0.000s)
[341.128504] [043/133] (680s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[341.215572] Starting subtest: nonblocking-crc-frame-sequence
[341.217741] Starting dynamic subtest: pipe-A-eDP-1
[341.969159] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.754s)
[341.979767] Starting dynamic subtest: pipe-B-eDP-1
[343.420800] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.447s)
[343.429662] Starting dynamic subtest: pipe-C-eDP-1
[344.750418] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.329s)
[344.759653] Starting dynamic subtest: pipe-D-eDP-1
[346.152338] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.401s)
[346.154687] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.938s)
[347.031996] [044/133] (675s left) syncobj_timeline (wait-any-snapshot)
[347.092044] Starting subtest: wait-any-snapshot
[347.173952] Subtest wait-any-snapshot: SUCCESS (0.082s)
[347.250946] [045/133] (674s left) gem_exec_fence (basic-await)
[347.445557] Starting subtest: basic-await
[347.448118] Starting dynamic subtest: rcs0
[347.521906] Dynamic subtest rcs0: SUCCESS (0.074s)
[347.534912] Starting dynamic subtest: bcs0
[347.595796] Dynamic subtest bcs0: SUCCESS (0.072s)
[347.606938] Starting dynamic subtest: vcs0
[347.670740] Dynamic subtest vcs0: SUCCESS (0.073s)
[347.681707] Starting dynamic subtest: vcs1
[347.740518] Dynamic subtest vcs1: SUCCESS (0.071s)
[347.750250] Starting dynamic subtest: vecs0
[347.819196] Dynamic subtest vecs0: SUCCESS (0.077s)
[347.828176] Starting dynamic subtest: ccs0
[347.896733] Dynamic subtest ccs0: SUCCESS (0.076s)
[347.899575] Subtest basic-await: SUCCESS (0.452s)
[349.969076] [046/133] (672s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[350.101384] Starting subtest: cursorB-vs-flipB-atomic-transitions
[350.105969] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[350.245463] [047/133] (671s left) kms_addfb_basic (invalid-set-prop)
[350.301672] Starting subtest: invalid-set-prop
[350.303825] Subtest invalid-set-prop: SUCCESS (0.000s)
[350.454920] [048/133] (671s left) kms_plane_scaling (planes-upscale-20x20)
[350.562447] Starting subtest: planes-upscale-20x20
[350.564726] Starting dynamic subtest: pipe-A
[350.623982] Dynamic subtest pipe-A: SUCCESS (0.062s)
[350.633839] Starting dynamic subtest: pipe-B
[351.736703] Dynamic subtest pipe-B: SUCCESS (1.112s)
[351.750452] Starting dynamic subtest: pipe-C
[352.892263] Dynamic subtest pipe-C: SUCCESS (1.153s)
[352.901000] Starting dynamic subtest: pipe-D
[353.995896] Dynamic subtest pipe-D: SUCCESS (1.103s)
[353.998333] Subtest planes-upscale-20x20: SUCCESS (3.435s)
[355.144585] [049/133] (667s left) kms_psr (fbc-pr-suspend)
[355.251814] Starting subtest: fbc-pr-suspend
[355.256715] Subtest fbc-pr-suspend: SKIP (0.000s)
[355.325626] [050/133] (666s left) kms_cursor_edge_walk (128x128-right-edge)
[355.420067] Starting subtest: 128x128-right-edge
[355.422157] Starting dynamic subtest: pipe-A-eDP-1
[358.853641] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.434s)
[358.862425] Starting dynamic subtest: pipe-D-eDP-1
[362.034797] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.180s)
[362.037088] Subtest 128x128-right-edge: SUCCESS (6.617s)
[362.833785] [051/133] (659s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[362.886912] Starting subtest: single-wait-all-for-submit-signaled
[362.889287] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[362.982193] [052/133] (659s left) kms_3d (basic)
[363.029929] Starting subtest: basic
[365.017995] Subtest basic: SUCCESS (1.990s)
[365.491657] [053/133] (656s left) gem_spin_batch (legacy-resubmit-new)
[365.551729] Starting subtest: legacy-resubmit-new
[365.554122] Starting dynamic subtest: default
[365.559074] Dynamic subtest default: SUCCESS (0.007s)
[365.568453] Starting dynamic subtest: render
[365.570530] Dynamic subtest render: SUCCESS (0.003s)
[365.578175] Starting dynamic subtest: bsd
[365.579992] Dynamic subtest bsd: SUCCESS (0.004s)
[365.587837] Starting dynamic subtest: bsd1
[365.590078] Dynamic subtest bsd1: SUCCESS (0.003s)
[365.597786] Starting dynamic subtest: bsd2
[365.599962] Dynamic subtest bsd2: SUCCESS (0.005s)
[365.607568] Starting dynamic subtest: blt
[365.609705] Dynamic subtest blt: SUCCESS (0.004s)
[365.617205] Starting dynamic subtest: vebox
[365.619356] Dynamic subtest vebox: SUCCESS (0.004s)
[365.621503] Subtest legacy-resubmit-new: SUCCESS (0.035s)
[366.974093] [054/133] (655s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[367.080330] Starting subtest: yf-tiled-64bpp-rotate-0
[367.084379] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[367.185157] [055/133] (655s left) i915_pm_rc6_residency (media-rc6-accuracy)
[367.241088] Starting subtest: media-rc6-accuracy
[367.245162] Subtest media-rc6-accuracy: SKIP (0.000s)
[367.340654] [056/133] (655s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[367.441544] Starting subtest: fbcpsr-modesetfrombusy
[373.531294] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.093s)
[373.657342] [057/133] (648s left) gem_sync (basic-all)
[373.728917] Starting subtest: basic-all
[375.880286] Subtest basic-all: SUCCESS (2.144s)
[376.049179] [058/133] (646s left) prime_mmap (test_refcounting)
[376.113648] Starting subtest: test_refcounting
[376.115973] Starting dynamic subtest: test_refcounting-smem
[376.144968] Dynamic subtest test_refcounting-smem: SUCCESS (0.035s)
[376.147680] Subtest test_refcounting: SUCCESS (0.036s)
[376.258536] [059/133] (646s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[376.367386] Starting subtest: fbc-psr-cursor-mmap-gtt
[376.369650] Starting dynamic subtest: eDP-1
[376.374127] Dynamic subtest eDP-1: SKIP (0.000s)
[376.378601] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[376.453371] [060/133] (646s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[376.568560] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[377.557331] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.989s)
[378.424908] [061/133] (644s left) gem_lmem_swapping (verify)
[378.469288] Subtest verify: SKIP (0.000s)
[378.506784] [062/133] (644s left) kms_scaling_modes (scaling-mode-center)
[378.603311] Starting subtest: scaling-mode-center
[378.605662] Starting dynamic subtest: pipe-A-eDP-1
[378.696844] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s)
[378.705707] Starting dynamic subtest: pipe-B-eDP-1
[379.908845] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.211s)
[379.917747] Starting dynamic subtest: pipe-C-eDP-1
[381.091597] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.182s)
[381.100088] Starting dynamic subtest: pipe-D-eDP-1
[382.221877] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s)
[382.224108] Subtest scaling-mode-center: SUCCESS (3.622s)
[383.426119] [063/133] (639s left) gem_exec_schedule (preempt-queue-contexts)
[383.503629] Subtest preempt-queue-contexts: SKIP (0.000s)
[383.804099] [064/133] (639s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[383.863591] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[383.865541] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[383.979822] [065/133] (638s left) kms_color (ctm-0-25)
[384.069939] Starting subtest: ctm-0-25
[384.072046] Starting dynamic subtest: pipe-A-eDP-1
[387.593501] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.524s)
[387.602035] Starting dynamic subtest: pipe-B-eDP-1
[391.792386] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.197s)
[391.800865] Starting dynamic subtest: pipe-C-eDP-1
[395.834517] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.041s)
[395.842859] Starting dynamic subtest: pipe-D-eDP-1
[399.927944] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.092s)
[399.930276] Subtest ctm-0-25: SUCCESS (15.858s)
[400.730548] [066/133] (622s left) gem_pxp (regular-baseline-src-copy-readible)
[400.856926] Starting subtest: regular-baseline-src-copy-readible
[400.914490] Subtest regular-baseline-src-copy-readible: SUCCESS (0.059s)
[401.037551] [067/133] (621s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[401.146113] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[404.773616] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.631s)
[405.930784] [068/133] (617s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[406.031836] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[406.036078] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[406.116956] [069/133] (616s left) vgem_basic (dmabuf-export)
[406.168615] Starting subtest: dmabuf-export
[406.206823] Subtest dmabuf-export: SUCCESS (0.044s)
[406.301831] [070/133] (616s left) gem_exec_reloc (basic-write-gtt)
[406.357830] Subtest basic-write-gtt: SKIP (0.000s)
[406.422784] [071/133] (616s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[406.523849] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[410.024822] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.505s)
[411.218988] [072/133] (611s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[411.308758] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[417.776387] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.470s)
[417.882757] [073/133] (605s left) api_intel_bb (object-reloc-purge-cache)
[417.936079] Starting subtest: object-reloc-purge-cache
[417.940271] Subtest object-reloc-purge-cache: SKIP (0.003s)
[418.054918] [074/133] (605s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[418.147143] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[418.149351] Starting dynamic subtest: pipe-A-eDP-1
[418.171465] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[418.180784] Starting dynamic subtest: pipe-B-eDP-1
[418.201687] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[418.209485] Starting dynamic subtest: pipe-C-eDP-1
[418.230882] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[418.238446] Starting dynamic subtest: pipe-D-eDP-1
[418.261741] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[418.265994] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[420.424992] [075/133] (602s left) kms_flip (2x-flip-vs-modeset)
[420.528049] Starting subtest: 2x-flip-vs-modeset
[420.537630] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[420.617545] [076/133] (602s left) gem_busy (parallel)
[420.791830] Starting subtest: parallel
[420.794250] Starting dynamic subtest: rcs0
[422.870735] Dynamic subtest rcs0: SUCCESS (2.077s)
[422.879383] Starting dynamic subtest: bcs0
[424.853483] Dynamic subtest bcs0: SUCCESS (1.980s)
[424.866606] Starting dynamic subtest: vcs0
[426.955472] Dynamic subtest vcs0: SUCCESS (2.045s)
[426.967691] Starting dynamic subtest: vcs1
[428.886160] Dynamic subtest vcs1: SUCCESS (1.981s)
[428.899232] Starting dynamic subtest: vecs0
[430.870541] Dynamic subtest vecs0: SUCCESS (1.982s)
[430.883805] Starting dynamic subtest: ccs0
[432.855558] Dynamic subtest ccs0: SUCCESS (1.982s)
[432.858176] Subtest parallel: SUCCESS (12.065s)
[433.119850] [077/133] (590s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[433.230060] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[433.232333] Starting dynamic subtest: pipe-A-eDP-1
[433.255175] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[433.267537] Starting dynamic subtest: pipe-B-eDP-1
[433.289190] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[433.296785] Starting dynamic subtest: pipe-C-eDP-1
[433.318171] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[433.325658] Starting dynamic subtest: pipe-D-eDP-1
[433.348218] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[433.352716] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[435.523860] [078/133] (587s left) drm_buddy (drm_buddy)
[435.560923] Starting subtest: drm_buddy
[435.565586] Subtest drm_buddy: SKIP (0.001s)
[435.623776] [079/133] (587s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[435.720066] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[435.722367] Starting dynamic subtest: pipe-A-eDP-1
[436.245992] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.496s)
[436.256291] Starting dynamic subtest: pipe-B-eDP-1
[437.776908] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.532s)
[437.788765] Starting dynamic subtest: pipe-C-eDP-1
[439.175602] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.397s)
[439.185878] Starting dynamic subtest: pipe-D-eDP-1
[440.577095] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.401s)
[440.579241] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.832s)
[441.722317] [080/133] (581s left) kms_pm_lpsp (screens-disabled)
[442.836859] Starting subtest: screens-disabled
[442.841439] Subtest screens-disabled: SKIP (0.000s)
[442.918127] [081/133] (580s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[443.006213] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[443.008354] Starting dynamic subtest: pipe-A-eDP-1
[443.067924] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[443.076243] Starting dynamic subtest: pipe-B-eDP-1
[443.130223] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.060s)
[443.138369] Starting dynamic subtest: pipe-C-eDP-1
[443.195656] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.065s)
[443.206590] Starting dynamic subtest: pipe-D-eDP-1
[443.258273] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.060s)
[443.260630] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.253s)
[445.516535] [082/133] (578s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[445.616971] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[445.621062] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[445.704748] [083/133] (577s left) kms_plane_multiple (tiling-y)
[445.791237] Starting subtest: tiling-y
[445.795221] Subtest tiling-y: SKIP (0.000s)
[445.894879] [084/133] (577s left) gem_exec_params (dr1-dirt)
[445.959774] Starting subtest: DR1-dirt
[445.962206] Subtest DR1-dirt: SUCCESS (0.000s)
[446.060582] [085/133] (577s left) gem_render_copy (yf-tiled-to-vebox-linear)
[446.122050] Starting subtest: yf-tiled-to-vebox-linear
[446.126156] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[446.316431] [086/133] (577s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[446.419173] Starting subtest: pr-cursor-plane-update-sf
[446.423408] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[446.488505] [087/133] (577s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[446.588069] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[446.590470] Starting dynamic subtest: pipe-A-default-mode
[449.333350] Dynamic subtest pipe-A-default-mode: SUCCESS (2.746s)
[449.335744] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.747s)
[450.139526] [088/133] (573s left) gem_exec_params (invalid-ring)
[450.196637] Starting subtest: invalid-ring
[450.199043] Subtest invalid-ring: SUCCESS (0.000s)
[450.297712] [089/133] (573s left) syncobj_wait (wait-delayed-signal)
[450.352385] Starting subtest: wait-delayed-signal
[450.455533] Subtest wait-delayed-signal: SUCCESS (0.103s)
[450.534434] [090/133] (573s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[450.630393] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[457.265860] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.638s)
[457.392441] [091/133] (566s left) gem_exec_schedule (u-fairslice)
[457.471437] Starting subtest: u-fairslice
[457.473391] Starting dynamic subtest: rcs0
[459.488187] Dynamic subtest rcs0: SUCCESS (2.021s)
[459.499169] Starting dynamic subtest: bcs0
[461.503559] Dynamic subtest bcs0: SUCCESS (2.017s)
[461.512070] Starting dynamic subtest: vcs0
[463.523434] Dynamic subtest vcs0: SUCCESS (2.017s)
[463.531720] Starting dynamic subtest: vcs1
[465.540931] Dynamic subtest vcs1: SUCCESS (2.017s)
[465.549599] Starting dynamic subtest: vecs0
[467.613262] Dynamic subtest vecs0: SUCCESS (2.018s)
[467.622556] Starting dynamic subtest: ccs0
[469.579450] Dynamic subtest ccs0: SUCCESS (2.019s)
[469.581641] Subtest u-fairslice: SUCCESS (12.115s)
[469.892023] [092/133] (554s left) gem_mmap_offset (mmap-unmap)
[469.953022] Starting subtest: mmap-unmap
[469.955779] Starting dynamic subtest: smem0
[493.394077] Dynamic subtest smem0: SUCCESS (23.390s)
[493.396904] Subtest mmap-unmap: SUCCESS (23.391s)
[493.476862] [093/133] (530s left) i915_hangman (engine-error-state-capture)
[493.560688] Starting subtest: engine-error-state-capture
[493.562899] Starting dynamic subtest: rcs0
[498.868375] Dynamic subtest rcs0: SUCCESS (5.308s)
[498.881367] Starting dynamic subtest: bcs0
[504.883261] Dynamic subtest bcs0: SUCCESS (6.012s)
[504.898737] Starting dynamic subtest: vcs0
[510.837564] Dynamic subtest vcs0: SUCCESS (5.951s)
[510.852214] Starting dynamic subtest: vcs1
[516.851997] Dynamic subtest vcs1: SUCCESS (6.011s)
[516.863326] Starting dynamic subtest: vecs0
[522.868213] Dynamic subtest vecs0: SUCCESS (6.013s)
[522.879107] Starting dynamic subtest: ccs0
[528.884785] Dynamic subtest ccs0: SUCCESS (6.013s)
[528.888220] Subtest engine-error-state-capture: SUCCESS (35.325s)
[528.970772] [094/133] (495s left) kms_frontbuffer_tracking (fbc-suspend)
[529.086303] Starting subtest: fbc-suspend
[566.952590] Subtest fbc-suspend: SUCCESS (7.599s)
[568.106630] [095/133] (456s left) kms_addfb_basic (no-handle)
[568.177894] Starting subtest: no-handle
[568.180190] Subtest no-handle: SUCCESS (0.000s)
[568.303923] [096/133] (455s left) kms_hdr (invalid-hdr)
[568.393950] Starting subtest: invalid-hdr
[570.543533] Starting dynamic subtest: pipe-A-eDP-1
[573.460961] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.915s)
[573.463802] Subtest invalid-hdr: SUCCESS (5.067s)
[573.647730] [097/133] (450s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[573.768400] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[573.773347] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[573.864071] [098/133] (450s left) i915_query (query-regions-garbage-items)
[573.914612] Starting subtest: query-regions-garbage-items
[573.917205] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[574.004689] [099/133] (450s left) gen7_exec_parse (cmd-crossing-page)
[574.067644] Subtest cmd-crossing-page: SKIP (0.000s)
[574.147011] [100/133] (450s left) kms_vrr (seamless-rr-switch-vrr)
[574.236185] Starting subtest: seamless-rr-switch-vrr
[574.243782] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[574.309841] [101/133] (450s left) kms_chamelium_edid (hdmi-edid-read)
[574.690174] Subtest hdmi-edid-read: SKIP (0.000s)
[575.481099] [102/133] (449s left) kms_sequence (get-busy)
[575.574504] Starting subtest: get-busy
[575.577164] Starting dynamic subtest: pipe-A-eDP-1
[577.496404] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.923s)
[577.505636] Starting dynamic subtest: pipe-B-eDP-1
[580.082235] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.581s)
[580.092825] Starting dynamic subtest: pipe-C-eDP-1
[582.665362] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.584s)
[582.675595] Starting dynamic subtest: pipe-D-eDP-1
[585.255298] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.584s)
[585.257403] Subtest get-busy: SUCCESS (9.677s)
[586.099508] [103/133] (438s left) kms_psr (pr-cursor-mmap-cpu)
[586.198490] Starting subtest: pr-cursor-mmap-cpu
[586.203651] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[586.274023] [104/133] (438s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[586.378336] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[590.593826] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.219s)
[591.742215] [105/133] (432s left) gem_exec_whisper (basic-contexts-forked)
[591.818613] Starting subtest: basic-contexts-forked
[616.654639] Subtest basic-contexts-forked: SUCCESS (24.776s)
[616.786133] [106/133] (407s left) gem_ctx_shared (q-independent)
[616.862030] Starting subtest: Q-independent
[616.865055] Starting dynamic subtest: rcs0
[617.001937] Dynamic subtest rcs0: SUCCESS (0.138s)
[617.016617] Starting dynamic subtest: vcs0
[617.073994] Dynamic subtest vcs0: SUCCESS (0.071s)
[617.088637] Starting dynamic subtest: vcs1
[617.141242] Dynamic subtest vcs1: SUCCESS (0.067s)
[617.151286] Starting dynamic subtest: vecs0
[617.214783] Dynamic subtest vecs0: SUCCESS (0.073s)
[617.224446] Starting dynamic subtest: ccs0
[617.308647] Dynamic subtest ccs0: SUCCESS (0.092s)
[617.311615] Subtest Q-independent: SUCCESS (0.447s)
[618.281898] [107/133] (406s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[618.350177] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[618.451423] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s)
[618.531203] [108/133] (406s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[618.644357] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[619.734768] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.090s)
[619.871803] [109/133] (404s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[619.976120] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[619.980474] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[620.058998] [110/133] (404s left) i915_drm_fdinfo (memory-info-shared)
[620.100751] Starting subtest: memory-info-shared
[620.103146] Starting dynamic subtest: smem0
[620.129318] Dynamic subtest smem0: SUCCESS (0.030s)
[620.131850] Subtest memory-info-shared: SUCCESS (0.030s)
[620.217935] [111/133] (404s left) gem_userptr_blits (invalid-null-pointer)
[620.280640] Starting subtest: invalid-null-pointer
[620.282486] Subtest invalid-null-pointer: SUCCESS (0.001s)
[620.396812] [112/133] (404s left) kms_psr (fbc-pr-dpms)
[620.483355] Starting subtest: fbc-pr-dpms
[620.487374] Subtest fbc-pr-dpms: SKIP (0.000s)
[620.571000] [113/133] (404s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[620.626125] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[620.687705] [114/133] (404s left) kms_atomic (plane-immutable-zpos)
[620.770200] Starting subtest: plane-immutable-zpos
[620.772363] Starting dynamic subtest: pipe-A-eDP-1
[621.411520] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.636s)
[621.414028] Subtest plane-immutable-zpos: SUCCESS (0.638s)
[622.206009] [115/133] (402s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[622.299475] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[622.303750] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[622.396913] [116/133] (402s left) gem_exec_reloc (basic-cpu)
[622.455315] Subtest basic-cpu: SKIP (0.000s)
[622.529673] [117/133] (402s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[622.659424] Starting subtest: cursor-vs-flip-atomic-transitions
[652.661247] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.997s)
[653.518967] [118/133] (371s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[653.618271] Starting subtest: fbcpsr-tiling-4
[660.576532] Subtest fbcpsr-tiling-4: SUCCESS (6.961s)
[660.720558] [119/133] (364s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[660.814310] Starting subtest: plane-scaler-unity-scaling-with-rotation
[660.816420] Starting dynamic subtest: pipe-A
[661.062632] Dynamic subtest pipe-A: SUCCESS (0.251s)
[661.072466] Starting dynamic subtest: pipe-B
[662.361697] Dynamic subtest pipe-B: SUCCESS (1.299s)
[662.371787] Starting dynamic subtest: pipe-C
[663.663440] Dynamic subtest pipe-C: SUCCESS (1.301s)
[663.673648] Starting dynamic subtest: pipe-D
[664.967228] Dynamic subtest pipe-D: SUCCESS (1.303s)
[664.969878] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.157s)
[666.145064] [120/133] (359s left) gem_lmem_swapping (parallel-multi)
[666.198496] Subtest parallel-multi: SKIP (0.000s)
[666.262300] [121/133] (359s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[666.362049] Starting subtest: plane-all-transition-nonblocking-fencing
[666.364385] Starting dynamic subtest: pipe-A-eDP-1
[668.855607] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[669.164160] Starting dynamic subtest: pipe-B-eDP-1
[672.416285] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.261s)
[672.715503] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.353s)
[673.510163] [122/133] (351s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[673.621508] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[673.626498] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[673.703680] [123/133] (351s left) gem_exec_reloc (basic-cpu-active)
[673.759703] Subtest basic-cpu-active: SKIP (0.000s)
[673.836811] [124/133] (351s left) sriov_basic (enable-vfs-bind-unbind-each)
[673.881870] Starting subtest: enable-vfs-bind-unbind-each
[673.884477] Starting dynamic subtest: numvfs-1
[673.972361] Dynamic subtest numvfs-1: FAIL (0.030s)
[673.984105] Starting dynamic subtest: numvfs-2
[674.069348] Dynamic subtest numvfs-2: FAIL (0.003s)
[674.080979] Starting dynamic subtest: numvfs-3
[674.166154] Dynamic subtest numvfs-3: FAIL (0.003s)
[674.176404] Starting dynamic subtest: numvfs-4
[674.260622] Dynamic subtest numvfs-4: FAIL (0.003s)
[674.271107] Starting dynamic subtest: numvfs-5
[674.356376] Dynamic subtest numvfs-5: FAIL (0.004s)
[674.366118] Starting dynamic subtest: numvfs-6
[674.450016] Dynamic subtest numvfs-6: FAIL (0.004s)
[674.459977] Starting dynamic subtest: numvfs-7
[674.532192] Dynamic subtest numvfs-7: FAIL (0.004s)
[674.542605] Starting dynamic subtest: numvfs-random
[674.615338] Dynamic subtest numvfs-random: FAIL (0.004s)
[674.617300] Subtest enable-vfs-bind-unbind-each: FAIL (0.061s)
[674.656236] [125/133] (350s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[674.754044] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[674.758274] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[674.847950] [126/133] (350s left) gem_exec_flush (basic-batch-kernel-default-uc)
[674.905258] Starting subtest: basic-batch-kernel-default-uc
[682.254922] Subtest basic-batch-kernel-default-uc: SUCCESS (7.350s)
[682.448880] [127/133] (343s left) kms_chamelium_color (ctm-blue-to-red)
[682.546153] Subtest ctm-blue-to-red: SKIP (0.000s)
[682.593369] [128/133] (343s left) gem_ctx_persistence (engines-mixed)
[682.654598] Starting subtest: engines-mixed
[682.657588] Starting dynamic subtest: rcs0
[682.723879] Dynamic subtest rcs0: SUCCESS (0.069s)
[682.736928] Starting dynamic subtest: bcs0
[682.768521] Dynamic subtest bcs0: SUCCESS (0.043s)
[682.780460] Starting dynamic subtest: vcs0
[682.821510] Dynamic subtest vcs0: SUCCESS (0.052s)
[682.834315] Starting dynamic subtest: vcs1
[682.878229] Dynamic subtest vcs1: SUCCESS (0.054s)
[682.890447] Starting dynamic subtest: vecs0
[682.928594] Dynamic subtest vecs0: SUCCESS (0.048s)
[682.937643] Starting dynamic subtest: ccs0
[682.978227] Dynamic subtest ccs0: SUCCESS (0.048s)
[682.980991] Subtest engines-mixed: SUCCESS (0.325s)
[683.058657] [129/133] (342s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[683.452928] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[684.291677] [130/133] (341s left) kms_flip (flip-vs-rmfb)
[684.411057] Starting subtest: flip-vs-rmfb
[684.413520] Starting dynamic subtest: A-eDP1
[693.065113] Dynamic subtest A-eDP1: SUCCESS (8.657s)
[693.077976] Starting dynamic subtest: B-eDP1
[701.769158] Dynamic subtest B-eDP1: SUCCESS (8.700s)
[701.779520] Starting dynamic subtest: C-eDP1
[710.463241] Dynamic subtest C-eDP1: SUCCESS (8.691s)
[710.473808] Starting dynamic subtest: D-eDP1
[719.156209] Dynamic subtest D-eDP1: SUCCESS (8.691s)
[719.158474] Subtest flip-vs-rmfb: SUCCESS (34.750s)
[720.314730] [131/133] (305s left) syncobj_timeline (invalid-wait-bad-flags)
[720.364427] Starting subtest: invalid-wait-bad-flags
[720.366833] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[720.460124] [132/133] (305s left) kms_big_fb (linear-8bpp-rotate-270)
[720.550906] Starting subtest: linear-8bpp-rotate-270
[720.574116] Subtest linear-8bpp-rotate-270: SKIP (0.022s)
[720.679770] [133/133] (305s left) kms_lease (multimaster-lease)
[720.777321] Starting subtest: multimaster-lease
[720.782370] Subtest multimaster-lease: SUCCESS (0.006s)
[720.896273] Closing watchdogs
results: parsing output: 0/ for test: kms_properties
results: parsing output: 1/ for test: gem_ctx_persistence
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_exec_nop
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: perf
results: parsing output: 10/ for test: gem_exec_balancer
results: parsing output: 11/ for test: gem_render_tiled_blits
results: parsing output: 12/ for test: gem_exec_flush
results: parsing output: 13/ for test: kms_flip_scaled_crc
results: parsing output: 14/ for test: kms_properties
results: parsing output: 15/ for test: gem_mmap_offset
results: parsing output: 16/ for test: kms_feature_discovery
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: kms_cursor_crc
results: parsing output: 19/ for test: gem_create
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_content_protection
results: parsing output: 22/ for test: gem_reg_read
results: parsing output: 23/ for test: gem_exec_params
results: parsing output: 24/ for test: api_intel_allocator
results: parsing output: 25/ for test: kms_plane
results: parsing output: 26/ for test: gem_flink_race
results: parsing output: 27/ for test: kms_vblank
results: parsing output: 28/ for test: kms_force_connector_basic
results: parsing output: 29/ for test: gem_vm_create
results: parsing output: 30/ for test: prime_mmap
results: parsing output: 31/ for test: kms_hdr
results: parsing output: 32/ for test: kms_pm_rpm
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_debugfs
results: parsing output: 36/ for test: perf_pmu
results: parsing output: 37/ for test: gem_mmap_wc
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: kms_flip
results: parsing output: 40/ for test: gem_exec_fence
results: parsing output: 41/ for test: gem_flink_basic
results: parsing output: 42/ for test: kms_pipe_crc_basic
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: gem_exec_fence
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: kms_addfb_basic
results: parsing output: 47/ for test: kms_plane_scaling
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_cursor_edge_walk
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: kms_3d
results: parsing output: 52/ for test: gem_spin_batch
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: i915_pm_rc6_residency
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_sync
results: parsing output: 57/ for test: prime_mmap
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: gem_lmem_swapping
results: parsing output: 61/ for test: kms_scaling_modes
results: parsing output: 62/ for test: gem_exec_schedule
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: kms_color
results: parsing output: 65/ for test: gem_pxp
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: vgem_basic
results: parsing output: 69/ for test: gem_exec_reloc
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: api_intel_bb
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: gem_busy
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: drm_buddy
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_pm_lpsp
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_plane_multiple
results: parsing output: 83/ for test: gem_exec_params
results: parsing output: 84/ for test: gem_render_copy
results: parsing output: 85/ for test: kms_psr2_sf
results: parsing output: 86/ for test: kms_flip_scaled_crc
results: parsing output: 87/ for test: gem_exec_params
results: parsing output: 88/ for test: syncobj_wait
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_exec_schedule
results: parsing output: 91/ for test: gem_mmap_offset
results: parsing output: 92/ for test: i915_hangman
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_addfb_basic
results: parsing output: 95/ for test: kms_hdr
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: i915_query
results: parsing output: 98/ for test: gen7_exec_parse
results: parsing output: 99/ for test: kms_vrr
results: parsing output: 100/ for test: kms_chamelium_edid
results: parsing output: 101/ for test: kms_sequence
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_whisper
results: parsing output: 105/ for test: gem_ctx_shared
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: i915_drm_fdinfo
results: parsing output: 110/ for test: gem_userptr_blits
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: kms_pipe_b_c_ivb
results: parsing output: 113/ for test: kms_atomic
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_exec_reloc
results: parsing output: 116/ for test: kms_cursor_legacy
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_plane_scaling
results: parsing output: 119/ for test: gem_lmem_swapping
results: parsing output: 120/ for test: kms_atomic_transition
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_exec_reloc
results: parsing output: 123/ for test: sriov_basic
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_exec_flush
results: parsing output: 126/ for test: kms_chamelium_color
results: parsing output: 127/ for test: gem_ctx_persistence
results: parsing output: 128/ for test: kms_chamelium_hpd
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: kms_lease
Done.