[60.802884] Initializing watchdogs
[60.802932]   /dev/watchdog0
[60.817600] [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]
[60.822105] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.824403] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.828024] [001/133] (960s left) kms_properties (plane-properties-legacy)
[60.941300] Starting subtest: plane-properties-legacy
[60.943504] Starting dynamic subtest: pipe-A-eDP-1
[61.547547] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.605s)
[61.555368] Starting dynamic subtest: pipe-B-eDP-1
[62.805407] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.257s)
[62.813764] Starting dynamic subtest: pipe-C-eDP-1
[64.117137] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.309s)
[64.124567] Starting dynamic subtest: pipe-D-eDP-1
[65.355316] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.238s)
[65.357886] Subtest plane-properties-legacy: SUCCESS (4.413s)
[66.174365] [002/133] (955s left) gem_ctx_persistence (idempotent)
[66.236126] Starting subtest: idempotent
[66.238534] Subtest idempotent: SUCCESS (0.000s)
[66.326546] [003/133] (955s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[66.427089] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[67.461949] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.037s)
[67.861237] [004/133] (953s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[68.011420] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[68.013499] Starting dynamic subtest: pipe-A-eDP-1
[68.903478] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.886s)
[68.911974] Starting dynamic subtest: pipe-B-eDP-1
[70.616318] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.709s)
[70.626206] Starting dynamic subtest: pipe-C-eDP-1
[72.163498] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.547s)
[72.173704] Starting dynamic subtest: pipe-D-eDP-1
[73.624148] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.459s)
[73.626113] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.605s)
[74.801865] [005/133] (946s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[74.851095] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[74.853500] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[74.947320] [006/133] (946s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[75.043945] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[75.048582] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[75.138019] [007/133] (946s left) gem_exec_nop (basic-series)
[75.208084] Starting subtest: basic-series
[90.907079] Subtest basic-series: SUCCESS (15.704s)
[91.125983] [008/133] (930s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[91.232246] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[91.236430] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[91.334878] [009/133] (930s left) kms_psr (psr2-sprite-render)
[91.416954] Starting subtest: psr2-sprite-render
[91.419285] Starting dynamic subtest: eDP-1
[93.109906] Dynamic subtest eDP-1: SUCCESS (1.694s)
[93.112298] Subtest psr2-sprite-render: SUCCESS (1.694s)
[93.965452] [010/133] (927s left) perf (blocking)
[94.099982] Starting subtest: blocking
[94.102364] Starting dynamic subtest: 0-rcs0
[104.117425] Dynamic subtest 0-rcs0: SUCCESS (10.015s)
[104.125691] Starting dynamic subtest: 1-vcs0
[114.142142] Dynamic subtest 1-vcs0: SUCCESS (10.024s)
[114.144699] Subtest blocking: SUCCESS (20.041s)
[114.188654] [011/133] (907s left) gem_exec_balancer (busy)
[114.262677] Starting subtest: busy
[115.942310] Subtest busy: SUCCESS (1.678s)
[116.279661] [012/133] (905s left) gem_render_tiled_blits (basic)
[116.340090] Subtest basic: SKIP (0.000s)
[116.417540] [013/133] (905s left) gem_exec_flush (basic-uc-prw-default)
[116.474580] Starting subtest: basic-uc-prw-default
[121.946175] Subtest basic-uc-prw-default: SUCCESS (5.474s)
[122.141935] [014/133] (899s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[122.248963] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[122.253509] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[122.319249] [015/133] (899s left) kms_properties (colorop-properties-legacy)
[122.416482] Starting subtest: colorop-properties-legacy
[122.418648] Starting dynamic subtest: pipe-A-eDP-1
[122.778947] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.362s)
[122.787135] Starting dynamic subtest: pipe-B-eDP-1
[123.821574] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.040s)
[123.832046] Starting dynamic subtest: pipe-C-eDP-1
[124.868234] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.048s)
[124.876083] Starting dynamic subtest: pipe-D-eDP-1
[125.912630] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.043s)
[125.915032] Subtest colorop-properties-legacy: SUCCESS (3.497s)
[126.710287] [016/133] (895s left) gem_mmap_offset (pf-nonblock)
[126.759689] Starting subtest: pf-nonblock
[126.764250] Subtest pf-nonblock: SUCCESS (0.006s)
[126.887202] [017/133] (895s left) kms_feature_discovery (psr1)
[126.978605] Starting subtest: psr1
[126.980866] Subtest psr1: SUCCESS (0.000s)
[127.049104] [018/133] (894s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[127.252593] Starting subtest: cursor-rapid-movement-64x21
[127.301712] Subtest cursor-rapid-movement-64x21: SKIP (0.046s)
[127.525719] [019/133] (894s left) kms_cursor_crc (cursor-offscreen-64x21)
[127.709511] Starting subtest: cursor-offscreen-64x21
[127.770547] Subtest cursor-offscreen-64x21: SKIP (0.056s)
[128.002243] [020/133] (894s left) gem_create (create-clear)
[128.058159] Starting subtest: create-clear
[128.060598] Starting dynamic subtest: smem0
[160.870134] Dynamic subtest smem0: SUCCESS (32.807s)
[160.872503] Subtest create-clear: SUCCESS (32.808s)
[161.069329] [021/133] (861s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[161.180728] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[165.359093] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.182s)
[166.529069] [022/133] (855s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[166.668832] Starting subtest: dp-mst-lic-type-0-hdcp14
[166.673234] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[166.780477] [023/133] (855s left) gem_reg_read (bad-register)
[166.833068] Starting subtest: bad-register
[166.835434] Subtest bad-register: SUCCESS (0.000s)
[166.927285] [024/133] (855s left) gem_exec_params (mmapped)
[166.984538] Starting subtest: mmapped
[166.986945] Subtest mmapped: SUCCESS (0.002s)
[167.098792] [025/133] (855s left) api_intel_allocator (reserve-simple)
[167.153919] Starting subtest: reserve-simple
[167.156314] Subtest reserve-simple: SUCCESS (0.003s)
[167.285370] [026/133] (855s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[167.381404] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[167.385683] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[167.451206] [027/133] (854s left) gem_flink_race (flink_close)
[167.488811] Starting subtest: flink_close
[172.577222] Subtest flink_close: SUCCESS (5.086s)
[172.664423] [028/133] (849s left) kms_vblank (query-forked-busy)
[172.773520] Starting subtest: query-forked-busy
[172.775655] Starting dynamic subtest: pipe-A-eDP-1
[174.659980] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.886s)
[174.672648] Starting dynamic subtest: pipe-D-eDP-1
[177.284121] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.622s)
[177.286505] Subtest query-forked-busy: SUCCESS (4.512s)
[178.092004] [029/133] (844s left) kms_force_connector_basic (force-edid)
[178.168942] Starting subtest: force-edid
[178.530200] Subtest force-edid: SUCCESS (0.364s)
[178.669086] [030/133] (843s left) gem_vm_create (invalid-create)
[178.729230] Starting subtest: invalid-create
[178.731665] Subtest invalid-create: SUCCESS (0.002s)
[178.848325] [031/133] (843s left) prime_mmap (test_userptr)
[178.899797] Starting subtest: test_userptr
[178.902149] Starting dynamic subtest: test_userptr-smem
[178.904455] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[178.906807] Subtest test_userptr: SUCCESS (0.001s)
[178.996732] [032/133] (843s left) kms_hdr (static-toggle-suspend)
[179.093488] Starting subtest: static-toggle-suspend
[179.098812] Subtest static-toggle-suspend: SKIP (0.000s)
[179.178950] [033/133] (843s left) kms_pm_rpm (legacy-planes-dpms)
[181.004851] Starting subtest: legacy-planes-dpms
[181.007709] Starting dynamic subtest: plane-64
[189.340910] Dynamic subtest plane-64: SUCCESS (8.335s)
[189.351278] Starting dynamic subtest: plane-94
[197.943229] Dynamic subtest plane-94: SUCCESS (8.600s)
[197.954113] Starting dynamic subtest: plane-124
[206.581988] Dynamic subtest plane-124: SUCCESS (8.637s)
[206.592541] Starting dynamic subtest: plane-134
[215.177328] Dynamic subtest plane-134: SUCCESS (8.593s)
[215.179745] Subtest legacy-planes-dpms: SUCCESS (34.173s)
[215.548237] [034/133] (807s left) syncobj_timeline (32bits-limit)
[215.611201] Starting subtest: 32bits-limit
[215.613612] Subtest 32bits-limit: SUCCESS (0.001s)
[215.725426] [035/133] (806s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[215.823613] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[216.458843] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.637s)
[216.634286] [036/133] (806s left) kms_debugfs (display-off-read-all)
[216.733821] Starting subtest: display-off-read-all
[217.032205] Subtest display-off-read-all: SUCCESS (0.301s)
[217.832280] [037/133] (804s left) perf_pmu (enable-race)
[217.876436] Starting subtest: enable-race
[217.878715] Starting dynamic subtest: rcs0
[230.646433] Dynamic subtest rcs0: SUCCESS (12.771s)
[230.654705] Starting dynamic subtest: bcs0
[243.388657] Dynamic subtest bcs0: SUCCESS (12.739s)
[243.398875] Starting dynamic subtest: vcs0
[258.901753] Dynamic subtest vcs0: SUCCESS (15.512s)
[258.910619] Starting dynamic subtest: vcs1
[274.902971] Dynamic subtest vcs1: SUCCESS (15.999s)
[274.911928] Starting dynamic subtest: vecs0
[290.901419] Dynamic subtest vecs0: SUCCESS (15.996s)
[290.912355] Starting dynamic subtest: ccs0
[303.648906] Dynamic subtest ccs0: SUCCESS (12.746s)
[303.651390] Subtest enable-race: SUCCESS (85.771s)
[303.758743] [038/133] (719s left) gem_mmap_wc (read-write)
[303.814074] Subtest read-write: SKIP (0.000s)
[303.877766] [039/133] (718s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[303.994473] Starting subtest: y-tiled-64bpp-rotate-0
[303.998764] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[304.088832] [040/133] (718s left) kms_flip (wf_vblank-ts-check-interruptible)
[304.189662] Starting subtest: wf_vblank-ts-check-interruptible
[304.194580] Starting dynamic subtest: A-eDP1
[313.122143] Dynamic subtest A-eDP1: SUCCESS (8.927s)
[313.131987] Starting dynamic subtest: B-eDP1
[322.019928] Dynamic subtest B-eDP1: SUCCESS (8.895s)
[322.028632] Starting dynamic subtest: C-eDP1
[330.908307] Dynamic subtest C-eDP1: SUCCESS (8.887s)
[330.916312] Starting dynamic subtest: D-eDP1
[339.803657] Dynamic subtest D-eDP1: SUCCESS (8.894s)
[339.808690] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.617s)
[341.004191] [041/133] (681s left) gem_exec_fence (nb-await)
[341.179441] Starting subtest: nb-await
[341.181619] Starting dynamic subtest: rcs0
[341.249085] Dynamic subtest rcs0: SUCCESS (0.069s)
[341.259532] Starting dynamic subtest: bcs0
[341.308715] Dynamic subtest bcs0: SUCCESS (0.058s)
[341.318631] Starting dynamic subtest: vcs0
[341.366710] Dynamic subtest vcs0: SUCCESS (0.057s)
[341.376643] Starting dynamic subtest: vcs1
[341.426301] Dynamic subtest vcs1: SUCCESS (0.058s)
[341.436413] Starting dynamic subtest: vecs0
[341.486505] Dynamic subtest vecs0: SUCCESS (0.058s)
[341.496724] Starting dynamic subtest: ccs0
[341.546711] Dynamic subtest ccs0: SUCCESS (0.059s)
[341.549262] Subtest nb-await: SUCCESS (0.368s)
[343.010453] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[343.013779] [042/133] (679s left) gem_flink_basic (bad-flink)
[343.076316] Starting subtest: bad-flink
[343.078329] Subtest bad-flink: SUCCESS (0.000s)
[343.178783] [043/133] (679s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[343.269304] Starting subtest: nonblocking-crc-frame-sequence
[343.271540] Starting dynamic subtest: pipe-A-eDP-1
[344.016058] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.745s)
[344.024866] Starting dynamic subtest: pipe-B-eDP-1
[345.500990] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.484s)
[345.509377] Starting dynamic subtest: pipe-C-eDP-1
[346.821948] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.322s)
[346.830748] Starting dynamic subtest: pipe-D-eDP-1
[348.247334] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.423s)
[348.249653] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.980s)
[349.097956] [044/133] (673s left) syncobj_timeline (wait-any-snapshot)
[349.156896] Starting subtest: wait-any-snapshot
[349.237725] Subtest wait-any-snapshot: SUCCESS (0.083s)
[349.314766] [045/133] (673s left) gem_exec_fence (basic-await)
[349.495578] Starting subtest: basic-await
[349.498038] Starting dynamic subtest: rcs0
[349.573197] Dynamic subtest rcs0: SUCCESS (0.077s)
[349.587690] Starting dynamic subtest: bcs0
[349.648808] Dynamic subtest bcs0: SUCCESS (0.074s)
[349.660560] Starting dynamic subtest: vcs0
[349.723568] Dynamic subtest vcs0: SUCCESS (0.073s)
[349.734109] Starting dynamic subtest: vcs1
[349.796944] Dynamic subtest vcs1: SUCCESS (0.073s)
[349.808313] Starting dynamic subtest: vecs0
[349.872241] Dynamic subtest vecs0: SUCCESS (0.073s)
[349.884038] Starting dynamic subtest: ccs0
[349.949319] Dynamic subtest ccs0: SUCCESS (0.076s)
[349.952039] Subtest basic-await: SUCCESS (0.455s)
[351.964874] [046/133] (671s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[352.106705] Starting subtest: cursorB-vs-flipB-atomic-transitions
[352.111270] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[352.262322] [047/133] (670s left) kms_addfb_basic (invalid-set-prop)
[352.314174] Starting subtest: invalid-set-prop
[352.316435] Subtest invalid-set-prop: SUCCESS (0.000s)
[352.434107] [048/133] (670s left) kms_plane_scaling (planes-upscale-20x20)
[352.536283] Starting subtest: planes-upscale-20x20
[352.538594] Starting dynamic subtest: pipe-A
[352.597144] Dynamic subtest pipe-A: SUCCESS (0.064s)
[352.605603] Starting dynamic subtest: pipe-B
[353.794548] Dynamic subtest pipe-B: SUCCESS (1.196s)
[353.805811] Starting dynamic subtest: pipe-C
[354.874805] Dynamic subtest pipe-C: SUCCESS (1.079s)
[354.884636] Starting dynamic subtest: pipe-D
[355.976397] Dynamic subtest pipe-D: SUCCESS (1.101s)
[355.978760] Subtest planes-upscale-20x20: SUCCESS (3.443s)
[357.124260] [049/133] (666s left) kms_psr (fbc-pr-suspend)
[357.212853] Starting subtest: fbc-pr-suspend
[357.217203] Subtest fbc-pr-suspend: SKIP (0.000s)
[357.286225] [050/133] (666s left) kms_cursor_edge_walk (128x128-right-edge)
[357.373024] Starting subtest: 128x128-right-edge
[357.375307] Starting dynamic subtest: pipe-A-eDP-1
[360.838332] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.465s)
[360.846894] Starting dynamic subtest: pipe-D-eDP-1
[364.014933] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.175s)
[364.017360] Subtest 128x128-right-edge: SUCCESS (6.643s)
[364.909631] [051/133] (658s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[364.965475] Starting subtest: single-wait-all-for-submit-signaled
[364.967748] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[365.059180] [052/133] (658s left) kms_3d (basic)
[365.107854] Starting subtest: basic
[367.144680] Subtest basic: SUCCESS (2.038s)
[367.623934] [053/133] (655s left) gem_spin_batch (legacy-resubmit-new)
[367.694689] Starting subtest: legacy-resubmit-new
[367.696887] Starting dynamic subtest: default
[367.706200] Dynamic subtest default: SUCCESS (0.011s)
[367.718595] Starting dynamic subtest: render
[367.720901] Dynamic subtest render: SUCCESS (0.005s)
[367.728666] Starting dynamic subtest: bsd
[367.730566] Dynamic subtest bsd: SUCCESS (0.005s)
[367.738344] Starting dynamic subtest: bsd1
[367.740516] Dynamic subtest bsd1: SUCCESS (0.002s)
[367.748089] Starting dynamic subtest: bsd2
[367.749949] Dynamic subtest bsd2: SUCCESS (0.008s)
[367.757229] Starting dynamic subtest: blt
[367.759260] Dynamic subtest blt: SUCCESS (0.004s)
[367.766324] Starting dynamic subtest: vebox
[367.768165] Dynamic subtest vebox: SUCCESS (0.004s)
[367.769986] Subtest legacy-resubmit-new: SUCCESS (0.047s)
[368.959539] [054/133] (654s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[369.061930] Starting subtest: yf-tiled-64bpp-rotate-0
[369.066271] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[369.151677] [055/133] (654s left) i915_pm_rc6_residency (media-rc6-accuracy)
[369.206425] Starting subtest: media-rc6-accuracy
[369.210900] Subtest media-rc6-accuracy: SKIP (0.000s)
[369.314147] [056/133] (654s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[369.405514] Starting subtest: fbcpsr-modesetfrombusy
[375.512553] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.111s)
[375.640097] [057/133] (647s left) gem_sync (basic-all)
[375.716499] Starting subtest: basic-all
[377.870300] Subtest basic-all: SUCCESS (2.154s)
[378.062183] [058/133] (645s left) prime_mmap (test_refcounting)
[378.112105] Starting subtest: test_refcounting
[378.114276] Starting dynamic subtest: test_refcounting-smem
[378.143524] Dynamic subtest test_refcounting-smem: SUCCESS (0.033s)
[378.146066] Subtest test_refcounting: SUCCESS (0.034s)
[378.240910] [059/133] (645s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[378.350853] Starting subtest: fbc-psr-cursor-mmap-gtt
[378.352960] Starting dynamic subtest: eDP-1
[378.357322] Dynamic subtest eDP-1: SKIP (0.000s)
[378.361522] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.003s)
[378.429059] [060/133] (645s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[378.543234] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[379.512269] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.968s)
[380.400623] [061/133] (643s left) gem_lmem_swapping (verify)
[380.450466] Subtest verify: SKIP (0.000s)
[380.496436] [062/133] (643s left) kms_scaling_modes (scaling-mode-center)
[380.600705] Starting subtest: scaling-mode-center
[380.602936] Starting dynamic subtest: pipe-A-eDP-1
[380.705037] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.105s)
[380.713378] Starting dynamic subtest: pipe-B-eDP-1
[381.884755] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.178s)
[381.892701] Starting dynamic subtest: pipe-C-eDP-1
[383.070983] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.184s)
[383.079083] Starting dynamic subtest: pipe-D-eDP-1
[384.266172] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.193s)
[384.268554] Subtest scaling-mode-center: SUCCESS (3.668s)
[385.406376] [063/133] (638s left) gem_exec_schedule (preempt-queue-contexts)
[385.492739] Subtest preempt-queue-contexts: SKIP (0.000s)
[385.809395] [064/133] (638s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[385.862306] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[385.864143] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[385.959275] [065/133] (637s left) kms_color (ctm-0-25)
[386.046302] Starting subtest: ctm-0-25
[386.048135] Starting dynamic subtest: pipe-A-eDP-1
[389.543528] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.499s)
[389.552576] Starting dynamic subtest: pipe-B-eDP-1
[393.739037] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.192s)
[393.747575] Starting dynamic subtest: pipe-C-eDP-1
[397.830119] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.093s)
[397.839152] Starting dynamic subtest: pipe-D-eDP-1
[401.912170] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.079s)
[401.914416] Subtest ctm-0-25: SUCCESS (15.866s)
[402.712950] [066/133] (621s left) gem_pxp (regular-baseline-src-copy-readible)
[402.834589] Starting subtest: regular-baseline-src-copy-readible
[402.891474] Subtest regular-baseline-src-copy-readible: SUCCESS (0.060s)
[403.021346] [067/133] (620s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[403.111155] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[406.741953] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.634s)
[407.911921] [068/133] (616s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[408.008974] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[408.013503] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[408.117867] [069/133] (615s left) vgem_basic (dmabuf-export)
[408.162232] Starting subtest: dmabuf-export
[408.212175] Subtest dmabuf-export: SUCCESS (0.052s)
[408.339484] [070/133] (615s left) gem_exec_reloc (basic-write-gtt)
[408.395605] Subtest basic-write-gtt: SKIP (0.000s)
[408.470759] [071/133] (615s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[408.573626] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[412.082040] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.514s)
[413.223813] [072/133] (610s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[413.319497] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[419.834033] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.518s)
[419.959230] [073/133] (604s left) api_intel_bb (object-reloc-purge-cache)
[420.015524] Starting subtest: object-reloc-purge-cache
[420.020054] Subtest object-reloc-purge-cache: SKIP (0.002s)
[420.132614] [074/133] (604s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[420.219810] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[420.222126] Starting dynamic subtest: pipe-A-eDP-1
[420.245073] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[420.255108] Starting dynamic subtest: pipe-B-eDP-1
[420.277014] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[420.287718] Starting dynamic subtest: pipe-C-eDP-1
[420.309614] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[420.317232] Starting dynamic subtest: pipe-D-eDP-1
[420.339137] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[420.344036] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[422.491830] [075/133] (601s left) kms_flip (2x-flip-vs-modeset)
[422.594220] Starting subtest: 2x-flip-vs-modeset
[422.606362] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[422.685975] [076/133] (601s left) gem_busy (parallel)
[422.865540] Starting subtest: parallel
[422.868056] Starting dynamic subtest: rcs0
[424.917991] Dynamic subtest rcs0: SUCCESS (2.051s)
[424.929074] Starting dynamic subtest: bcs0
[426.902081] Dynamic subtest bcs0: SUCCESS (1.982s)
[426.916231] Starting dynamic subtest: vcs0
[428.886487] Dynamic subtest vcs0: SUCCESS (1.981s)
[428.898105] Starting dynamic subtest: vcs1
[430.934101] Dynamic subtest vcs1: SUCCESS (2.045s)
[430.944981] Starting dynamic subtest: vecs0
[432.918595] Dynamic subtest vecs0: SUCCESS (1.982s)
[432.929609] Starting dynamic subtest: ccs0
[434.903108] Dynamic subtest ccs0: SUCCESS (1.982s)
[434.906109] Subtest parallel: SUCCESS (12.037s)
[435.141431] [077/133] (589s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[435.238721] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[435.241031] Starting dynamic subtest: pipe-A-eDP-1
[435.262969] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[435.272975] Starting dynamic subtest: pipe-B-eDP-1
[435.293206] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[435.300780] Starting dynamic subtest: pipe-C-eDP-1
[435.321625] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[435.329093] Starting dynamic subtest: pipe-D-eDP-1
[435.350823] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[435.355169] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[437.510961] [078/133] (586s left) drm_buddy (drm_buddy)
[437.549151] Starting subtest: drm_buddy
[437.553244] Subtest drm_buddy: SKIP (0.001s)
[437.612826] [079/133] (586s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[437.699973] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[437.702177] Starting dynamic subtest: pipe-A-eDP-1
[438.224248] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.497s)
[438.234703] Starting dynamic subtest: pipe-B-eDP-1
[439.729660] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.500s)
[439.740223] Starting dynamic subtest: pipe-C-eDP-1
[441.145087] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.417s)
[441.154483] Starting dynamic subtest: pipe-D-eDP-1
[442.547969] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.402s)
[442.549912] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.822s)
[443.693102] [080/133] (580s left) kms_pm_lpsp (screens-disabled)
[444.805555] Starting subtest: screens-disabled
[444.810093] Subtest screens-disabled: SKIP (0.000s)
[444.878858] [081/133] (579s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[444.983153] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[444.985392] Starting dynamic subtest: pipe-A-eDP-1
[445.046212] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[445.060186] Starting dynamic subtest: pipe-B-eDP-1
[445.109822] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.064s)
[445.118294] Starting dynamic subtest: pipe-C-eDP-1
[445.174651] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.064s)
[445.182954] Starting dynamic subtest: pipe-D-eDP-1
[445.236616] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.061s)
[445.238882] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.256s)
[447.493246] [082/133] (577s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[447.588138] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[447.592082] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[447.667556] [083/133] (577s left) kms_plane_multiple (tiling-y)
[447.752840] Starting subtest: tiling-y
[447.756752] Subtest tiling-y: SKIP (0.000s)
[447.824554] [084/133] (576s left) gem_exec_params (dr1-dirt)
[447.879163] Starting subtest: DR1-dirt
[447.881571] Subtest DR1-dirt: SUCCESS (0.000s)
[447.991472] [085/133] (576s left) gem_render_copy (yf-tiled-to-vebox-linear)
[448.053788] Starting subtest: yf-tiled-to-vebox-linear
[448.058381] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[448.240372] [086/133] (576s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[448.330944] Starting subtest: pr-cursor-plane-update-sf
[448.335237] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[448.397230] [087/133] (576s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[448.484965] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[448.487220] Starting dynamic subtest: pipe-A-default-mode
[451.189284] Dynamic subtest pipe-A-default-mode: SUCCESS (2.704s)
[451.191599] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.706s)
[451.984460] [088/133] (572s left) gem_exec_params (invalid-ring)
[452.053040] Starting subtest: invalid-ring
[452.055449] Subtest invalid-ring: SUCCESS (0.000s)
[452.147750] [089/133] (572s left) syncobj_wait (wait-delayed-signal)
[452.201133] Starting subtest: wait-delayed-signal
[452.304390] Subtest wait-delayed-signal: SUCCESS (0.103s)
[452.400898] [090/133] (572s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[452.492780] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[459.176340] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.686s)
[459.305684] [091/133] (565s left) gem_exec_schedule (u-fairslice)
[459.369615] Starting subtest: u-fairslice
[459.371621] Starting dynamic subtest: rcs0
[461.383072] Dynamic subtest rcs0: SUCCESS (2.019s)
[461.392521] Starting dynamic subtest: bcs0
[463.400715] Dynamic subtest bcs0: SUCCESS (2.017s)
[463.410998] Starting dynamic subtest: vcs0
[465.419767] Dynamic subtest vcs0: SUCCESS (2.017s)
[465.429160] Starting dynamic subtest: vcs1
[467.436926] Dynamic subtest vcs1: SUCCESS (2.017s)
[467.447269] Starting dynamic subtest: vecs0
[469.459289] Dynamic subtest vecs0: SUCCESS (2.022s)
[469.468219] Starting dynamic subtest: ccs0
[471.479983] Dynamic subtest ccs0: SUCCESS (2.018s)
[471.482309] Subtest u-fairslice: SUCCESS (12.117s)
[471.778801] [092/133] (553s left) gem_mmap_offset (mmap-unmap)
[471.837241] Starting subtest: mmap-unmap
[471.839585] Starting dynamic subtest: smem0
[495.430635] Dynamic subtest smem0: SUCCESS (23.594s)
[495.433341] Subtest mmap-unmap: SUCCESS (23.596s)
[495.567216] [093/133] (529s left) i915_hangman (engine-error-state-capture)
[495.641861] Starting subtest: engine-error-state-capture
[495.644455] Starting dynamic subtest: rcs0
[498.868262] Dynamic subtest rcs0: SUCCESS (3.224s)
[498.879765] Starting dynamic subtest: bcs0
[504.884208] Dynamic subtest bcs0: SUCCESS (6.013s)
[504.895440] Starting dynamic subtest: vcs0
[510.836431] Dynamic subtest vcs0: SUCCESS (5.949s)
[510.847352] Starting dynamic subtest: vcs1
[515.892107] Dynamic subtest vcs1: SUCCESS (5.053s)
[515.903036] Starting dynamic subtest: vecs0
[521.843885] Dynamic subtest vecs0: SUCCESS (5.949s)
[521.854829] Starting dynamic subtest: ccs0
[527.860195] Dynamic subtest ccs0: SUCCESS (6.013s)
[527.862997] Subtest engine-error-state-capture: SUCCESS (32.218s)
[527.940636] [094/133] (497s left) kms_frontbuffer_tracking (fbc-suspend)
[528.046404] Starting subtest: fbc-suspend
[566.886137] Subtest fbc-suspend: SUCCESS (9.191s)
[571.097463] [095/133] (457s left) kms_addfb_basic (no-handle)
[571.157083] Starting subtest: no-handle
[571.159222] Subtest no-handle: SUCCESS (0.000s)
[571.291899] [096/133] (456s left) kms_hdr (invalid-hdr)
[571.381524] Starting subtest: invalid-hdr
[573.518065] Starting dynamic subtest: pipe-A-eDP-1
[576.423745] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.900s)
[576.426105] Subtest invalid-hdr: SUCCESS (5.032s)
[576.544944] [097/133] (451s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[576.637130] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[576.641128] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[576.719128] [098/133] (451s left) i915_query (query-regions-garbage-items)
[576.774225] Starting subtest: query-regions-garbage-items
[576.776364] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[576.864613] [099/133] (451s left) gen7_exec_parse (cmd-crossing-page)
[576.916918] Subtest cmd-crossing-page: SKIP (0.000s)
[576.977100] [100/133] (451s left) kms_vrr (seamless-rr-switch-vrr)
[577.064741] Starting subtest: seamless-rr-switch-vrr
[577.071009] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[577.138128] [101/133] (451s left) kms_chamelium_edid (hdmi-edid-read)
[577.509735] Subtest hdmi-edid-read: SKIP (0.000s)
[578.369042] [102/133] (450s left) kms_sequence (get-busy)
[578.458885] Starting subtest: get-busy
[578.461066] Starting dynamic subtest: pipe-A-eDP-1
[580.401032] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.937s)
[580.410423] Starting dynamic subtest: pipe-B-eDP-1
[582.981999] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.577s)
[582.992682] Starting dynamic subtest: pipe-C-eDP-1
[585.531159] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.545s)
[585.540126] Starting dynamic subtest: pipe-D-eDP-1
[588.146788] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.611s)
[588.149139] Subtest get-busy: SUCCESS (9.678s)
[588.996647] [103/133] (439s left) kms_psr (pr-cursor-mmap-cpu)
[589.092918] Starting subtest: pr-cursor-mmap-cpu
[589.097449] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[589.165733] [104/133] (439s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[589.257540] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[593.528124] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.271s)
[594.717539] [105/133] (433s left) gem_exec_whisper (basic-contexts-forked)
[594.803881] Starting subtest: basic-contexts-forked
[618.252827] Subtest basic-contexts-forked: SUCCESS (23.452s)
[618.438561] [106/133] (410s left) gem_ctx_shared (q-independent)
[618.504958] Starting subtest: Q-independent
[618.507804] Starting dynamic subtest: rcs0
[618.639183] Dynamic subtest rcs0: SUCCESS (0.133s)
[618.651291] Starting dynamic subtest: vcs0
[618.708478] Dynamic subtest vcs0: SUCCESS (0.068s)
[618.718875] Starting dynamic subtest: vcs1
[618.779152] Dynamic subtest vcs1: SUCCESS (0.070s)
[618.792286] Starting dynamic subtest: vecs0
[618.845654] Dynamic subtest vecs0: SUCCESS (0.064s)
[618.858145] Starting dynamic subtest: ccs0
[618.928690] Dynamic subtest ccs0: SUCCESS (0.082s)
[618.931730] Subtest Q-independent: SUCCESS (0.423s)
[620.676663] [107/133] (408s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[620.750693] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[620.851645] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s)
[620.933689] [108/133] (407s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[621.045664] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[622.080203] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.035s)
[622.206367] [109/133] (406s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[622.306138] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[622.309927] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[622.406040] [110/133] (406s left) i915_drm_fdinfo (memory-info-shared)
[622.442163] Starting subtest: memory-info-shared
[622.444026] Starting dynamic subtest: smem0
[622.489026] Dynamic subtest smem0: SUCCESS (0.047s)
[622.491245] Subtest memory-info-shared: SUCCESS (0.048s)
[622.578161] [111/133] (406s left) gem_userptr_blits (invalid-null-pointer)
[622.631183] Starting subtest: invalid-null-pointer
[622.632758] Subtest invalid-null-pointer: SUCCESS (0.001s)
[622.772610] [112/133] (406s left) kms_psr (fbc-pr-dpms)
[622.874159] Starting subtest: fbc-pr-dpms
[622.877795] Subtest fbc-pr-dpms: SKIP (0.000s)
[622.978612] [113/133] (405s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[623.044650] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[623.111791] [114/133] (405s left) kms_atomic (plane-immutable-zpos)
[623.205058] Starting subtest: plane-immutable-zpos
[623.206827] Starting dynamic subtest: pipe-A-eDP-1
[623.870830] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.664s)
[623.873194] Subtest plane-immutable-zpos: SUCCESS (0.665s)
[624.697703] [115/133] (404s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[624.800821] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[624.804796] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[624.901444] [116/133] (404s left) gem_exec_reloc (basic-cpu)
[624.956834] Subtest basic-cpu: SKIP (0.000s)
[625.029915] [117/133] (404s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[625.153389] Starting subtest: cursor-vs-flip-atomic-transitions
[655.192371] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.031s)
[655.997015] [118/133] (373s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[656.098307] Starting subtest: fbcpsr-tiling-4
[663.144169] Subtest fbcpsr-tiling-4: SUCCESS (7.047s)
[663.280130] [119/133] (365s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[663.383964] Starting subtest: plane-scaler-unity-scaling-with-rotation
[663.386008] Starting dynamic subtest: pipe-A
[663.642826] Dynamic subtest pipe-A: SUCCESS (0.262s)
[663.654992] Starting dynamic subtest: pipe-B
[664.950897] Dynamic subtest pipe-B: SUCCESS (1.306s)
[664.961221] Starting dynamic subtest: pipe-C
[666.243131] Dynamic subtest pipe-C: SUCCESS (1.292s)
[666.253423] Starting dynamic subtest: pipe-D
[667.544183] Dynamic subtest pipe-D: SUCCESS (1.300s)
[667.546545] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.165s)
[668.693860] [120/133] (360s left) gem_lmem_swapping (parallel-multi)
[668.742056] Subtest parallel-multi: SKIP (0.000s)
[668.795601] [121/133] (360s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[668.886598] Starting subtest: plane-all-transition-nonblocking-fencing
[668.888922] Starting dynamic subtest: pipe-A-eDP-1
[671.380500] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[671.686582] Starting dynamic subtest: pipe-B-eDP-1
[674.908024] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.231s)
[675.208359] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.321s)
[676.086645] [122/133] (353s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[676.185626] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[676.190010] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[676.285679] [123/133] (353s left) gem_exec_reloc (basic-cpu-active)
[676.340989] Subtest basic-cpu-active: SKIP (0.000s)
[676.409262] [124/133] (353s left) sriov_basic (enable-vfs-bind-unbind-each)
[676.473923] Starting subtest: enable-vfs-bind-unbind-each
[676.475819] Starting dynamic subtest: numvfs-1
[676.548275] Dynamic subtest numvfs-1: FAIL (0.014s)
[676.559309] Starting dynamic subtest: numvfs-2
[676.631846] Dynamic subtest numvfs-2: FAIL (0.006s)
[676.643017] Starting dynamic subtest: numvfs-3
[676.716308] Dynamic subtest numvfs-3: FAIL (0.004s)
[676.726504] Starting dynamic subtest: numvfs-4
[676.799739] Dynamic subtest numvfs-4: FAIL (0.003s)
[676.810578] Starting dynamic subtest: numvfs-5
[676.883025] Dynamic subtest numvfs-5: FAIL (0.003s)
[676.893795] Starting dynamic subtest: numvfs-6
[676.966978] Dynamic subtest numvfs-6: FAIL (0.004s)
[676.977195] Starting dynamic subtest: numvfs-7
[677.044767] Dynamic subtest numvfs-7: FAIL (0.003s)
[677.055328] Starting dynamic subtest: numvfs-random
[677.114258] Dynamic subtest numvfs-random: FAIL (0.003s)
[677.116139] Subtest enable-vfs-bind-unbind-each: FAIL (0.048s)
[677.154282] [125/133] (352s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[677.244959] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[677.248571] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[677.331943] [126/133] (352s left) gem_exec_flush (basic-batch-kernel-default-uc)
[677.389971] Starting subtest: basic-batch-kernel-default-uc
[684.403451] Subtest basic-batch-kernel-default-uc: SUCCESS (7.013s)
[684.592057] [127/133] (344s left) kms_chamelium_color (ctm-blue-to-red)
[684.686101] Subtest ctm-blue-to-red: SKIP (0.000s)
[684.734285] [128/133] (344s left) gem_ctx_persistence (engines-mixed)
[684.787691] Starting subtest: engines-mixed
[684.789801] Starting dynamic subtest: rcs0
[684.873842] Dynamic subtest rcs0: SUCCESS (0.085s)
[684.889327] Starting dynamic subtest: bcs0
[684.922632] Dynamic subtest bcs0: SUCCESS (0.046s)
[684.934416] Starting dynamic subtest: vcs0
[684.962482] Dynamic subtest vcs0: SUCCESS (0.038s)
[684.972383] Starting dynamic subtest: vcs1
[685.008862] Dynamic subtest vcs1: SUCCESS (0.045s)
[685.021543] Starting dynamic subtest: vecs0
[685.050697] Dynamic subtest vecs0: SUCCESS (0.041s)
[685.061547] Starting dynamic subtest: ccs0
[685.095715] Dynamic subtest ccs0: SUCCESS (0.043s)
[685.098356] Subtest engines-mixed: SUCCESS (0.308s)
[685.187057] [129/133] (344s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[685.577892] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[686.363718] [130/133] (343s left) kms_flip (flip-vs-rmfb)
[686.460190] Starting subtest: flip-vs-rmfb
[686.464952] Starting dynamic subtest: A-eDP1
[695.396365] Dynamic subtest A-eDP1: SUCCESS (8.933s)
[695.409663] Starting dynamic subtest: B-eDP1
[704.051829] Dynamic subtest B-eDP1: SUCCESS (8.652s)
[704.068679] Starting dynamic subtest: C-eDP1
[712.741822] Dynamic subtest C-eDP1: SUCCESS (8.686s)
[712.753992] Starting dynamic subtest: D-eDP1
[721.440122] Dynamic subtest D-eDP1: SUCCESS (8.695s)
[721.444558] Subtest flip-vs-rmfb: SUCCESS (34.980s)
[722.600214] [131/133] (307s left) syncobj_timeline (invalid-wait-bad-flags)
[722.649613] Starting subtest: invalid-wait-bad-flags
[722.651626] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[722.733539] [132/133] (307s left) kms_big_fb (linear-8bpp-rotate-270)
[722.829660] Starting subtest: linear-8bpp-rotate-270
[722.852062] Subtest linear-8bpp-rotate-270: SKIP (0.021s)
[722.970843] [133/133] (306s left) kms_lease (multimaster-lease)
[723.151015] Starting subtest: multimaster-lease
[723.156119] Subtest multimaster-lease: SUCCESS (0.004s)
[723.368110] 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.