[58.680190] Initializing watchdogs
[58.680240]   /dev/watchdog0
[58.694132] [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]
[58.698526] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.701075] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.704217] [001/133] (960s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[58.884725] Starting subtest: dp-mst-lic-type-0-hdcp14
[58.889428] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[59.028236] [002/133] (960s left) core_getversion (all-cards)
[59.063794] Starting subtest: all-cards
[59.070525] Subtest all-cards: SUCCESS (0.009s)
[59.111452] [003/133] (960s left) kms_atomic_interruptible (legacy-dpms)
[59.220979] Starting subtest: legacy-dpms
[59.223406] Starting dynamic subtest: pipe-A-eDP-1
[66.613917] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.368s)
[66.616535] Subtest legacy-dpms: SUCCESS (7.370s)
[67.515284] [004/133] (951s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[67.691139] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[67.704231] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[67.865730] [005/133] (951s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[68.002229] Starting subtest: plane-primary-toggle-with-vblank-wait
[68.004558] Starting dynamic subtest: pipe-A-eDP-1
[68.175454] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.175s)
[68.479097] Starting dynamic subtest: pipe-B-eDP-1
[69.361205] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.888s)
[69.659271] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.656s)
[70.538223] [006/133] (948s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[70.643172] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[70.647428] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[70.766217] [007/133] (948s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[70.853401] Starting subtest: fbc-psr2-primary-mmap-cpu
[70.855794] Starting dynamic subtest: eDP-1
[70.860249] Dynamic subtest eDP-1: SKIP (0.000s)
[70.864757] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[70.938201] [008/133] (948s left) perf (invalid-oa-exponent)
[71.074230] Starting subtest: invalid-oa-exponent
[71.084788] Subtest invalid-oa-exponent: SUCCESS (0.012s)
[71.121670] [009/133] (948s left) gem_eio (create-ext)
[71.276664] Starting subtest: create-ext
[71.460092] Subtest create-ext: SUCCESS (0.182s)
[71.613323] [010/133] (947s left) kms_color (invalid-degamma-lut-sizes)
[71.696282] Starting subtest: invalid-degamma-lut-sizes
[71.698319] Starting dynamic subtest: pipe-A
[72.001793] Dynamic subtest pipe-A: SUCCESS (0.305s)
[72.010390] Starting dynamic subtest: pipe-B
[72.012664] Dynamic subtest pipe-B: SUCCESS (0.000s)
[72.019558] Starting dynamic subtest: pipe-C
[72.021913] Dynamic subtest pipe-C: SUCCESS (0.000s)
[72.028723] Starting dynamic subtest: pipe-D
[72.031093] Dynamic subtest pipe-D: SUCCESS (0.000s)
[72.033384] Subtest invalid-degamma-lut-sizes: SUCCESS (0.307s)
[72.866925] [011/133] (946s left) gem_softpin (allocator-basic)
[72.923386] Starting subtest: allocator-basic
[72.995806] Subtest allocator-basic: SUCCESS (0.072s)
[73.134136] [012/133] (946s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[73.241608] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[73.243949] Starting dynamic subtest: pipe-A-eDP-1
[79.119468] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.880s)
[79.128709] Starting dynamic subtest: pipe-B-eDP-1
[85.763091] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.638s)
[85.765376] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.520s)
[86.651997] [013/133] (933s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[86.762182] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[86.766633] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[86.878955] [014/133] (932s left) kms_psr (pr-primary-render)
[86.981111] Starting subtest: pr-primary-render
[86.985611] Subtest pr-primary-render: SKIP (0.000s)
[87.062989] [015/133] (932s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[87.181482] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[87.186069] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[87.320718] [016/133] (932s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[87.433702] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[87.437806] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[87.510869] [017/133] (932s left) gem_ccs (ctrl-surf-copy)
[87.575258] Starting subtest: ctrl-surf-copy
[87.578902] Subtest ctrl-surf-copy: SKIP (0.000s)
[87.689755] [018/133] (932s left) perf (invalid-oa-metric-set-id)
[87.792799] Starting subtest: invalid-oa-metric-set-id
[87.802186] Subtest invalid-oa-metric-set-id: SUCCESS (0.009s)
[87.849291] [019/133] (932s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[87.955869] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[87.959451] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[88.078828] [020/133] (931s left) gem_pxp (create-regular-buffer)
[88.201047] Starting subtest: create-regular-buffer
[88.203366] Subtest create-regular-buffer: SUCCESS (0.000s)
[88.334478] [021/133] (931s left) gem_eio (in-flight-contexts-10ms)
[88.531467] Starting subtest: in-flight-contexts-10ms
[99.951409] Subtest in-flight-contexts-10ms: SUCCESS (11.415s)
[100.140067] [022/133] (919s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[100.237236] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[107.020094] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.785s)
[107.167986] [023/133] (912s left) gem_exec_schedule (u-fairslice-all)
[107.233701] Starting subtest: u-fairslice-all
[109.286768] Subtest u-fairslice-all: SUCCESS (2.058s)
[110.940662] [024/133] (909s left) core_getstats (basic)
[111.001334] Starting subtest: basic
[111.003599] Subtest basic: SUCCESS (0.000s)
[111.135630] [025/133] (909s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[111.228749] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[111.231072] Starting dynamic subtest: pipe-A-eDP-1
[112.027982] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.794s)
[112.035753] Starting dynamic subtest: pipe-B-eDP-1
[113.643517] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.610s)
[113.652330] Starting dynamic subtest: pipe-C-eDP-1
[115.178151] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.535s)
[115.187364] Starting dynamic subtest: pipe-D-eDP-1
[116.700206] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.520s)
[116.702458] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.463s)
[117.895702] [026/133] (902s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[118.014347] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[118.016744] Starting dynamic subtest: pipe-A-eDP-1
[118.039405] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[118.049760] Starting dynamic subtest: pipe-B-eDP-1
[118.071057] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[118.078461] Starting dynamic subtest: pipe-C-eDP-1
[118.099775] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[118.107517] Starting dynamic subtest: pipe-D-eDP-1
[118.129194] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[118.133188] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[120.350717] [027/133] (899s left) sw_sync (alloc_fence)
[120.391115] Starting subtest: alloc_fence
[120.393165] Subtest alloc_fence: SUCCESS (0.000s)
[120.470390] [028/133] (899s left) i915_pm_rps (basic-api)
[120.530277] Starting subtest: basic-api
[120.534819] Subtest basic-api: SKIP (0.000s)
[120.644234] [029/133] (899s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[120.764797] Starting subtest: cursorB-vs-flipA-toggle
[120.769287] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[120.918514] [030/133] (899s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[121.139126] Starting subtest: cursor-rapid-movement-128x42
[121.184147] Subtest cursor-rapid-movement-128x42: SKIP (0.041s)
[121.393691] [031/133] (899s left) kms_dp_link_training (non-uhbr-sst)
[121.489050] Starting subtest: non-uhbr-sst
[121.496020] Subtest non-uhbr-sst: SKIP (0.000s)
[121.581481] [032/133] (898s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[121.676098] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[121.679599] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[121.786832] [033/133] (898s left) gem_exec_parallel (engines)
[121.842024] Starting subtest: engines
[121.844041] Starting dynamic subtest: basic
[123.924269] Dynamic subtest basic: SUCCESS (2.080s)
[123.934432] Starting dynamic subtest: contexts
[128.371089] Dynamic subtest contexts: SUCCESS (4.444s)
[128.379873] Starting dynamic subtest: fds
[132.208889] Dynamic subtest fds: SUCCESS (3.835s)
[132.218545] Starting dynamic subtest: userptr
[133.944564] Dynamic subtest userptr: SUCCESS (1.735s)
[133.947118] Subtest engines: SUCCESS (12.100s)
[134.162263] [034/133] (886s left) gem_eio (in-flight-immediate)
[134.417824] Starting subtest: in-flight-immediate
[143.175576] Subtest in-flight-immediate: SUCCESS (8.756s)
[143.373525] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true
[143.376842] [035/133] (877s left) prime_mmap (test_forked)
[143.442251] Starting subtest: test_forked
[143.444387] Starting dynamic subtest: test_forked-smem
[143.481304] Dynamic subtest test_forked-smem: SUCCESS (0.040s)
[143.483512] Subtest test_forked: SUCCESS (0.042s)
[143.604198] [036/133] (876s left) kms_dsc (dsc-with-formats)
[143.705905] Starting subtest: dsc-with-formats
[143.745999] Subtest dsc-with-formats: SKIP (0.001s)
[143.788954] [037/133] (876s left) prime_busy (hang)
[143.842196] Starting subtest: hang
[143.844486] Starting dynamic subtest: rcs0
[170.418564] Dynamic subtest rcs0: SUCCESS (26.570s)
[170.431685] Starting dynamic subtest: bcs0
[177.570240] Dynamic subtest bcs0: SUCCESS (7.152s)
[177.581201] Starting dynamic subtest: vcs0
[184.546922] Dynamic subtest vcs0: SUCCESS (6.974s)
[184.556932] Starting dynamic subtest: vcs1
[191.584723] Dynamic subtest vcs1: SUCCESS (7.037s)
[191.594403] Starting dynamic subtest: vecs0
[198.556988] Dynamic subtest vecs0: SUCCESS (6.974s)
[198.567998] Starting dynamic subtest: ccs0
[212.398924] Dynamic subtest ccs0: SUCCESS (13.838s)
[212.401591] Subtest hang: SUCCESS (68.551s)
[212.554804] [038/133] (808s left) kms_vblank (wait-idle)
[212.662916] Starting subtest: wait-idle
[212.665164] Starting dynamic subtest: pipe-A-eDP-1
[214.427444] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.764s)
[214.441371] Starting dynamic subtest: pipe-D-eDP-1
[216.889467] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.459s)
[216.891390] Subtest wait-idle: SUCCESS (4.226s)
[217.723714] [039/133] (803s left) kms_pm_rpm (package-g7)
[219.256982] Starting subtest: package-g7
[219.262547] Subtest package-g7: SKIP (0.000s)
[219.977453] [040/133] (800s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[220.092349] Starting subtest: flip-vs-cursor-varying-size
[228.653700] Subtest flip-vs-cursor-varying-size: SUCCESS (8.560s)
[229.502279] [041/133] (791s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[229.607430] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[236.992389] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.386s)
[237.159856] [042/133] (783s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[237.226426] Starting subtest: single-wait-all-for-submit-signaled
[237.228393] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[237.352489] [043/133] (783s left) perf (gen12-group-exclusive-stream-ctx-handle)
[237.442931] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[237.472198] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.030s)
[237.517444] [044/133] (783s left) gem_wait (busy)
[238.848080] Starting subtest: busy
[238.850540] Starting dynamic subtest: all-engines
[240.917581] Dynamic subtest all-engines: SUCCESS (2.067s)
[240.928241] Starting dynamic subtest: rcs0
[241.460040] Dynamic subtest rcs0: SUCCESS (0.542s)
[241.470716] Starting dynamic subtest: bcs0
[242.000316] Dynamic subtest bcs0: SUCCESS (0.540s)
[242.010501] Starting dynamic subtest: vcs0
[243.924767] Dynamic subtest vcs0: SUCCESS (1.922s)
[243.935274] Starting dynamic subtest: vcs1
[245.910727] Dynamic subtest vcs1: SUCCESS (1.984s)
[245.922636] Starting dynamic subtest: vecs0
[247.892274] Dynamic subtest vecs0: SUCCESS (1.979s)
[247.903810] Starting dynamic subtest: ccs0
[248.435727] Dynamic subtest ccs0: SUCCESS (0.543s)
[248.438382] Subtest busy: SUCCESS (9.587s)
[248.660576] [045/133] (772s left) gen9_exec_parse (bb-secure)
[248.726511] Subtest bb-secure: SKIP (0.000s)
[248.790029] [046/133] (772s left) kms_cursor_edge_walk (128x128-right-edge)
[248.893782] Starting subtest: 128x128-right-edge
[248.895975] Starting dynamic subtest: pipe-A-eDP-1
[252.373538] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.480s)
[252.382678] Starting dynamic subtest: pipe-D-eDP-1
[255.501470] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[255.503729] Subtest 128x128-right-edge: SUCCESS (6.608s)
[256.336293] [047/133] (764s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[256.450320] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[256.454336] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[256.589803] [048/133] (764s left) prime_mmap (test_forked_cpu_write)
[256.651220] Starting subtest: test_forked_cpu_write
[256.653155] Starting dynamic subtest: test_forked_cpu_write-smem
[256.658081] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s)
[256.660425] Subtest test_forked_cpu_write: SUCCESS (0.010s)
[256.771925] [049/133] (764s left) kms_addfb_basic (small-bo)
[256.866951] Starting subtest: small-bo
[256.869075] Subtest small-bo: SUCCESS (0.000s)
[256.997471] [050/133] (764s left) kms_chamelium_audio (dp-audio)
[257.380635] Subtest dp-audio: SKIP (0.000s)
[258.230387] [051/133] (762s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[258.636068] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[259.469721] [052/133] (761s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[259.559389] Starting subtest: psr-shrfb-scaledprimary
[265.399790] Subtest psr-shrfb-scaledprimary: SUCCESS (5.841s)
[265.556826] [053/133] (755s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[265.655173] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[265.659481] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[265.737528] [054/133] (755s left) perf (i915-ref-count)
[265.820477] Starting subtest: i915-ref-count
[265.847369] Subtest i915-ref-count: SUCCESS (0.023s)
[265.903364] [055/133] (755s left) kms_joiner (invalid-modeset-force-big-joiner)
[265.999740] Starting subtest: invalid-modeset-force-big-joiner
[266.004219] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[266.076526] [056/133] (755s left) kms_cursor_crc (cursor-alpha-opaque)
[266.173280] Starting subtest: cursor-alpha-opaque
[266.175477] Starting dynamic subtest: pipe-A-eDP-1
[266.793099] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.619s)
[266.801843] Starting dynamic subtest: pipe-D-eDP-1
[268.094855] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.299s)
[268.096860] Subtest cursor-alpha-opaque: SUCCESS (1.920s)
[268.900941] [057/133] (752s left) kms_legacy_colorkey (basic)
[269.001194] Starting subtest: basic
[269.003073] Starting dynamic subtest: pipe-A
[269.044530] Dynamic subtest pipe-A: SUCCESS (0.045s)
[269.055982] Starting dynamic subtest: pipe-B
[269.058322] Dynamic subtest pipe-B: SUCCESS (0.000s)
[269.065936] Starting dynamic subtest: pipe-C
[269.068307] Dynamic subtest pipe-C: SUCCESS (0.000s)
[269.076256] Starting dynamic subtest: pipe-D
[269.078455] Dynamic subtest pipe-D: SUCCESS (0.000s)
[269.080669] Subtest basic: SUCCESS (0.050s)
[269.139372] [058/133] (752s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[269.250375] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[269.254900] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[269.384814] [059/133] (752s left) kms_addfb_basic (bad-pitch-32)
[269.443990] Starting subtest: bad-pitch-32
[269.445927] Subtest bad-pitch-32: SUCCESS (0.000s)
[269.597657] [060/133] (751s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[269.653427] Starting subtest: x-tiled-to-vebox-y-tiled
[269.657867] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[269.847625] [061/133] (751s left) gem_exec_reloc (basic-range)
[269.910061] Subtest basic-range: SKIP (0.000s)
[269.994235] [062/133] (751s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[270.100391] Starting subtest: yf-tiled-64bpp-rotate-0
[270.104672] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[270.204987] [063/133] (751s left) syncobj_wait (wait-all-for-submit-snapshot)
[270.269561] Starting subtest: wait-all-for-submit-snapshot
[270.350227] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[270.437561] [064/133] (751s left) kms_async_flips (invalid-async-flip)
[270.530737] Starting subtest: invalid-async-flip
[270.905836] Starting dynamic subtest: pipe-A-eDP-1
[271.704762] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.799s)
[272.065613] Starting dynamic subtest: pipe-B-eDP-1
[272.838068] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.780s)
[273.193577] Starting dynamic subtest: pipe-C-eDP-1
[273.955292] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.770s)
[274.310562] Starting dynamic subtest: pipe-D-eDP-1
[275.107528] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.806s)
[275.109848] Subtest invalid-async-flip: SUCCESS (4.579s)
[276.253856] [065/133] (745s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[276.353251] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[276.355520] Starting dynamic subtest: A-eDP1
[279.962986] Dynamic subtest A-eDP1: SUCCESS (3.608s)
[279.971617] Starting dynamic subtest: B-eDP1
[283.157669] Dynamic subtest B-eDP1: SUCCESS (3.191s)
[283.166746] Starting dynamic subtest: C-eDP1
[286.265961] Dynamic subtest C-eDP1: SUCCESS (3.110s)
[286.274926] Starting dynamic subtest: D-eDP1
[289.370574] Dynamic subtest D-eDP1: SUCCESS (3.102s)
[289.372823] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.018s)
[290.182429] [066/133] (731s left) kms_frontbuffer_tracking (fbc-suspend)
[290.284665] Starting subtest: fbc-suspend
[328.657056] Subtest fbc-suspend: SUCCESS (7.625s)
[329.887333] [067/133] (691s left) syncobj_timeline (invalid-transfer-bad-pad)
[329.957701] Starting subtest: invalid-transfer-bad-pad
[329.960395] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[330.074272] [068/133] (691s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[330.180291] Starting subtest: 4-tiled-64bpp-rotate-90
[330.200008] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[330.350934] [069/133] (691s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[330.410854] Starting subtest: saturated-hostile-nopreempt
[330.413570] Starting dynamic subtest: rcs0
[330.497552] Dynamic subtest rcs0: SKIP (0.082s)
[330.508380] Starting dynamic subtest: bcs0
[330.516409] Dynamic subtest bcs0: SKIP (0.014s)
[330.525590] Starting dynamic subtest: vcs0
[330.534336] Dynamic subtest vcs0: SKIP (0.016s)
[330.543493] Starting dynamic subtest: vcs1
[330.551829] Dynamic subtest vcs1: SKIP (0.019s)
[330.560864] Starting dynamic subtest: vecs0
[330.573147] Dynamic subtest vecs0: SKIP (0.020s)
[330.582460] Starting dynamic subtest: ccs0
[330.592265] Dynamic subtest ccs0: SKIP (0.017s)
[330.597621] Subtest saturated-hostile-nopreempt: SKIP (0.176s)
[330.680923] [070/133] (691s left) gem_exec_big (single)
[330.745417] Starting subtest: single
[333.173302] Subtest single: SUCCESS (2.395s)
[333.416571] [071/133] (688s left) gem_exec_fence (submit67)
[333.645588] Starting subtest: submit67
[333.651474] Subtest submit67: SKIP (0.000s)
[335.699426] [072/133] (686s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[335.815439] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[335.820119] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[335.919762] [073/133] (686s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[336.050933] Starting subtest: fbc-rgb101010-draw-mmap-wc
[340.658797] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.583s)
[341.794828] [074/133] (680s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[341.902304] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[341.907308] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[341.999391] [075/133] (680s left) i915_drm_fdinfo (busy-idle)
[342.044878] Starting subtest: busy-idle
[342.047420] Starting dynamic subtest: rcs0
[342.069193] Dynamic subtest rcs0: SKIP (0.024s)
[342.079121] Starting dynamic subtest: bcs0
[342.084309] Dynamic subtest bcs0: SKIP (0.000s)
[342.095753] Starting dynamic subtest: vcs0
[342.101243] Dynamic subtest vcs0: SKIP (0.000s)
[342.110658] Starting dynamic subtest: vcs1
[342.116000] Dynamic subtest vcs1: SKIP (0.000s)
[342.125230] Starting dynamic subtest: vecs0
[342.130327] Dynamic subtest vecs0: SKIP (0.000s)
[342.139491] Starting dynamic subtest: ccs0
[342.144786] Dynamic subtest ccs0: SKIP (0.000s)
[342.149813] Subtest busy-idle: SKIP (0.029s)
[342.188538] [076/133] (680s left) kms_psr (psr2-primary-page-flip)
[342.280425] Starting subtest: psr2-primary-page-flip
[342.283241] Starting dynamic subtest: eDP-1
[344.047469] Dynamic subtest eDP-1: SUCCESS (1.759s)
[344.050366] Subtest psr2-primary-page-flip: SUCCESS (1.761s)
[344.939805] [077/133] (677s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[345.051486] Starting subtest: cursorA-vs-flipB-atomic
[345.056549] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[345.210305] [078/133] (677s left) kms_prop_blob (blob-prop-lifetime)
[345.270279] Starting subtest: blob-prop-lifetime
[345.272815] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[345.396086] [079/133] (677s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[345.491526] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[345.494435] Starting dynamic subtest: pipe-A
[345.604234] Dynamic subtest pipe-A: SKIP (0.107s)
[345.614055] Starting dynamic subtest: pipe-B
[346.814198] Dynamic subtest pipe-B: SKIP (1.206s)
[346.827415] Starting dynamic subtest: pipe-C
[347.959169] Dynamic subtest pipe-C: SUCCESS (1.149s)
[347.969053] Starting dynamic subtest: pipe-D
[349.184962] Dynamic subtest pipe-D: SUCCESS (1.223s)
[349.187567] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.687s)
[350.390273] [080/133] (672s left) kms_pipe_crc_basic (hang-read-crc)
[350.500263] Starting subtest: hang-read-crc
[350.502722] Starting dynamic subtest: pipe-A-eDP-1
[352.562952] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.060s)
[352.573279] Starting dynamic subtest: pipe-B-eDP-1
[355.266585] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.697s)
[355.276846] Starting dynamic subtest: pipe-C-eDP-1
[357.973532] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.708s)
[357.985873] Starting dynamic subtest: pipe-D-eDP-1
[360.627314] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.650s)
[360.629544] Subtest hang-read-crc: SUCCESS (10.121s)
[361.467735] [081/133] (661s left) kms_selftest (drm_format)
[361.517928] Starting subtest: drm_format
[361.529402] Starting dynamic subtest: drm_test_format_block_width_invalid
[361.667839] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.138s)
[361.680046] Starting dynamic subtest: drm_test_format_block_width_one_plane
[361.791903] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.122s)
[361.804405] Starting dynamic subtest: drm_test_format_block_width_two_plane
[361.906290] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.115s)
[361.917026] Starting dynamic subtest: drm_test_format_block_width_three_plane
[362.033575] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.125s)
[362.044817] Starting dynamic subtest: drm_test_format_block_width_tiled
[362.175964] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.142s)
[362.186483] Starting dynamic subtest: drm_test_format_block_height_invalid
[362.293860] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.115s)
[362.306535] Starting dynamic subtest: drm_test_format_block_height_one_plane
[362.418386] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.124s)
[362.429601] Starting dynamic subtest: drm_test_format_block_height_two_plane
[362.528453] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.110s)
[362.539377] Starting dynamic subtest: drm_test_format_block_height_three_plane
[362.662357] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.133s)
[362.673743] Starting dynamic subtest: drm_test_format_block_height_tiled
[362.790235] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.126s)
[362.801161] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[362.945378] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.153s)
[362.955562] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[363.095083] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.149s)
[363.105289] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[363.206060] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.111s)
[363.216734] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[363.328398] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.120s)
[363.337411] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[363.479425] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.149s)
[363.489020] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[363.610992] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.130s)
[363.620387] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[363.765535] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.154s)
[363.774703] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[363.891458] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.124s)
[363.894086] Subtest drm_format: SUCCESS (2.373s)
[364.076969] [082/133] (658s left) gem_close_race (multigpu-basic-process)
[364.158016] Starting subtest: multigpu-basic-process
[364.163316] Subtest multigpu-basic-process: SKIP (0.000s)
[364.428485] [083/133] (658s left) gem_set_tiling_vs_gtt
[364.550880] [084/133] (658s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[364.648285] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[364.650988] Starting dynamic subtest: pipe-A
[364.668384] Dynamic subtest pipe-A: SKIP (0.016s)
[364.678526] Starting dynamic subtest: pipe-B
[364.700040] Dynamic subtest pipe-B: SKIP (0.029s)
[364.710231] Starting dynamic subtest: pipe-C
[364.727202] Dynamic subtest pipe-C: SKIP (0.029s)
[364.736708] Starting dynamic subtest: pipe-D
[364.758325] Dynamic subtest pipe-D: SKIP (0.030s)
[364.762832] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.107s)
[364.886910] [085/133] (657s left) kms_addfb_basic (basic-y-tiled-legacy)
[364.956566] Starting subtest: basic-y-tiled-legacy
[364.962460] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[365.107900] [086/133] (657s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[365.208281] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[366.273329] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.067s)
[366.433236] [087/133] (656s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[366.493553] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[366.498304] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[366.693416] [088/133] (656s left) gem_caching (writes)
[366.765765] Subtest writes: SKIP (0.000s)
[366.854370] [089/133] (655s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[366.915347] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[367.019936] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[367.111137] [090/133] (655s left) kms_flip (wf_vblank-ts-check)
[367.208257] Starting subtest: wf_vblank-ts-check
[367.211017] Starting dynamic subtest: A-eDP1
[376.102186] Dynamic subtest A-eDP1: SUCCESS (8.894s)
[376.111850] Starting dynamic subtest: B-eDP1
[385.038909] Dynamic subtest B-eDP1: SUCCESS (8.933s)
[385.048766] Starting dynamic subtest: C-eDP1
[393.975284] Dynamic subtest C-eDP1: SUCCESS (8.930s)
[393.994954] Starting dynamic subtest: D-eDP1
[402.907713] Dynamic subtest D-eDP1: SUCCESS (8.929s)
[402.913801] Subtest wf_vblank-ts-check: SUCCESS (35.699s)
[404.147743] [091/133] (618s left) gem_lmem_evict (dontneed-evict-race)
[404.203171] Subtest dontneed-evict-race: SKIP (0.000s)
[404.246256] [092/133] (618s left) gem_mmap_gtt (medium-copy-odd)
[404.309333] Subtest medium-copy-odd: SKIP (0.000s)
[404.369534] [093/133] (618s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[404.463136] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[404.476566] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[404.545319] [094/133] (618s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[404.632453] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[404.635330] Starting dynamic subtest: pipe-A-eDP-1
[404.705022] Dynamic subtest pipe-A-eDP-1: SKIP (0.003s)
[404.715531] Starting dynamic subtest: pipe-B-eDP-1
[404.784656] Dynamic subtest pipe-B-eDP-1: SKIP (0.003s)
[404.794166] Starting dynamic subtest: pipe-C-eDP-1
[404.861180] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[404.871406] Starting dynamic subtest: pipe-D-eDP-1
[404.937108] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[404.942325] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.017s)
[406.899204] [095/133] (616s left) gem_exec_suspend (basic-s0)
[406.964322] Starting subtest: basic-S0
[406.967135] Starting dynamic subtest: smem
[426.979200] Dynamic subtest smem: SUCCESS (6.532s)
[426.982213] Subtest basic-S0: SUCCESS (6.534s)
[427.177599] [096/133] (595s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[427.297274] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[428.409100] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.089s)
[428.557939] [097/133] (594s left) gem_mmap_offset (bad-extensions)
[428.620376] Starting subtest: bad-extensions
[428.622073] Subtest bad-extensions: SUCCESS (0.000s)
[428.759763] [098/133] (594s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[428.886496] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[428.890187] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[429.049300] [099/133] (594s left) gem_mmap_gtt (cpuset-big-copy-odd)
[429.121870] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[429.199212] [100/133] (594s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[429.302105] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[429.306012] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[429.446810] [101/133] (593s left) kms_psr (fbc-psr2-sprite-render)
[429.544800] Starting subtest: fbc-psr2-sprite-render
[429.546784] Starting dynamic subtest: eDP-1
[429.550196] Dynamic subtest eDP-1: SKIP (0.000s)
[429.553640] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[429.629121] [102/133] (593s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[429.723581] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[429.726938] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[429.843796] [103/133] (593s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[429.924072] Starting subtest: crc-primary-basic-y-tiled-ccs
[429.925937] Starting dynamic subtest: pipe-A-eDP-1
[429.944823] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[429.957485] Starting dynamic subtest: pipe-B-eDP-1
[429.975488] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[429.984079] Starting dynamic subtest: pipe-C-eDP-1
[430.001933] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[430.010387] Starting dynamic subtest: pipe-D-eDP-1
[430.028648] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[430.032258] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[432.187872] [104/133] (591s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[432.292263] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[432.296710] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[432.433852] [105/133] (591s left) api_intel_bb (add-remove-objects)
[432.495071] Starting subtest: add-remove-objects
[432.500838] Subtest add-remove-objects: SUCCESS (0.007s)
[432.680443] [106/133] (590s left) sysfs_heartbeat_interval (nopreempt)
[432.732862] Starting subtest: nopreempt
[432.735193] Starting dynamic subtest: vecs0
[442.032680] Dynamic subtest vecs0: SUCCESS (9.239s)
[442.045487] Starting dynamic subtest: ccs0
[446.045558] Dynamic subtest ccs0: SUCCESS (3.999s)
[446.059845] Starting dynamic subtest: vcs0
[455.021533] Dynamic subtest vcs0: SUCCESS (8.960s)
[455.034426] Starting dynamic subtest: bcs0
[459.003340] Dynamic subtest bcs0: SUCCESS (3.975s)
[459.024365] Starting dynamic subtest: rcs0
[463.232082] Dynamic subtest rcs0: SUCCESS (4.227s)
[463.244269] Starting dynamic subtest: vcs1
[473.050492] Dynamic subtest vcs1: SUCCESS (9.798s)
[473.055127] Subtest nopreempt: SUCCESS (40.212s)
[473.136138] [107/133] (550s left) kms_getfb (getfb2-into-addfb2)
[473.259230] Starting subtest: getfb2-into-addfb2
[473.261524] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[473.397616] [108/133] (550s left) gem_close (basic)
[473.457926] Starting subtest: basic
[473.460356] Subtest basic: SUCCESS (0.000s)
[473.588940] [109/133] (550s left) gem_exec_schedule (preemptive-hang)
[473.767511] Starting subtest: preemptive-hang
[473.770122] Starting dynamic subtest: rcs0
[483.154883] Dynamic subtest rcs0: SUCCESS (9.381s)
[483.165233] Starting dynamic subtest: bcs0
[492.108998] Dynamic subtest bcs0: SUCCESS (8.952s)
[492.119372] Starting dynamic subtest: vcs0
[501.131341] Dynamic subtest vcs0: SUCCESS (9.017s)
[501.147880] Starting dynamic subtest: vcs1
[510.153411] Dynamic subtest vcs1: SUCCESS (9.017s)
[510.165226] Starting dynamic subtest: vecs0
[519.111994] Dynamic subtest vecs0: SUCCESS (8.952s)
[519.123963] Starting dynamic subtest: ccs0
[528.138591] Dynamic subtest ccs0: SUCCESS (9.029s)
[528.140644] Subtest preemptive-hang: SUCCESS (54.357s)
[528.406973] [110/133] (495s left) i915_drm_fdinfo (virtual-busy-idle)
[528.457259] Starting subtest: virtual-busy-idle
[528.461785] Subtest virtual-busy-idle: SKIP (0.000s)
[528.541216] [111/133] (495s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[528.651767] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[533.076915] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.432s)
[534.277294] [112/133] (489s left) gem_linear_blits (interruptible)
[534.504360] Starting subtest: interruptible
[538.523564] Subtest interruptible: SUCCESS (4.021s)
[538.685131] [113/133] (485s left) gem_ctx_persistence (engines-mixed)
[538.792145] Starting subtest: engines-mixed
[538.794450] Starting dynamic subtest: rcs0
[538.932162] Dynamic subtest rcs0: SUCCESS (0.139s)
[538.947237] Starting dynamic subtest: bcs0
[539.038038] Dynamic subtest bcs0: SUCCESS (0.104s)
[539.050371] Starting dynamic subtest: vcs0
[539.129002] Dynamic subtest vcs0: SUCCESS (0.089s)
[539.141168] Starting dynamic subtest: vcs1
[539.196944] Dynamic subtest vcs1: SUCCESS (0.066s)
[539.209464] Starting dynamic subtest: vecs0
[539.246773] Dynamic subtest vecs0: SUCCESS (0.048s)
[539.257139] Starting dynamic subtest: ccs0
[539.328953] Dynamic subtest ccs0: SUCCESS (0.081s)
[539.331406] Subtest engines-mixed: SUCCESS (0.538s)
[539.420705] [114/133] (484s left) perf_pmu (init-wait)
[539.458209] Starting subtest: init-wait
[539.461017] Starting dynamic subtest: rcs0
[539.463468] Dynamic subtest rcs0: SUCCESS (0.002s)
[539.473894] Starting dynamic subtest: bcs0
[539.476279] Dynamic subtest bcs0: SUCCESS (0.000s)
[539.487771] Starting dynamic subtest: vcs0
[539.489695] Dynamic subtest vcs0: SUCCESS (0.000s)
[539.498814] Starting dynamic subtest: vcs1
[539.500726] Dynamic subtest vcs1: SUCCESS (0.000s)
[539.509683] Starting dynamic subtest: vecs0
[539.511580] Dynamic subtest vecs0: SUCCESS (0.001s)
[539.520654] Starting dynamic subtest: ccs0
[539.522853] Dynamic subtest ccs0: SUCCESS (0.000s)
[539.525016] Subtest init-wait: SUCCESS (0.008s)
[539.605396] [115/133] (484s left) gem_exec_reloc (basic-gtt-cpu-active)
[539.677472] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[539.741531] [116/133] (484s left) kms_pm_lpsp (screens-disabled)
[540.855634] Starting subtest: screens-disabled
[540.859959] Subtest screens-disabled: SKIP (0.000s)
[540.938263] [117/133] (483s left) kms_flip (flip-vs-expired-vblank-interruptible)
[541.044567] Starting subtest: flip-vs-expired-vblank-interruptible
[541.046857] Starting dynamic subtest: A-eDP1
[549.748409] Dynamic subtest A-eDP1: SUCCESS (8.707s)
[549.760214] Starting dynamic subtest: B-eDP1
[558.377373] Dynamic subtest B-eDP1: SUCCESS (8.630s)
[558.388146] Starting dynamic subtest: C-eDP1
[567.008557] Dynamic subtest C-eDP1: SUCCESS (8.631s)
[567.022081] Starting dynamic subtest: D-eDP1
[575.626058] Dynamic subtest D-eDP1: SUCCESS (8.615s)
[575.631443] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.595s)
[576.901272] [118/133] (447s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[577.016705] Starting subtest: psr-1p-primscrn-cur-indfb-move
[584.412164] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.399s)
[584.576255] [119/133] (439s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[584.674283] Starting subtest: plane-all-modeset-transition-internal-panels
[584.676635] Starting dynamic subtest: pipe-A-eDP-1
[585.960541] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.285s)
[586.241127] Starting dynamic subtest: pipe-B-eDP-1
[587.288374] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.055s)
[587.562193] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.889s)
[588.412966] [120/133] (435s left) gem_userptr_blits (stress-mm)
[588.483873] Starting subtest: stress-mm
[593.852908] Subtest stress-mm: SUCCESS (5.369s)
[594.019684] [121/133] (430s left) syncobj_eventfd (invalid-bad-flags)
[594.091366] Starting subtest: invalid-bad-flags
[594.093616] Subtest invalid-bad-flags: SUCCESS (0.000s)
[594.224256] [122/133] (430s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[594.287220] Starting subtest: framebuffer-vs-set-tiling
[594.291913] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[594.462856] [123/133] (429s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[594.558823] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[594.563062] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[594.681432] [124/133] (429s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[594.740415] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[594.742589] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[594.873139] [125/133] (429s left) kms_flip (2x-modeset-vs-vblank-race)
[594.965097] Starting subtest: 2x-modeset-vs-vblank-race
[594.974826] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[595.066596] [126/133] (429s left) i915_query (query-regions-garbage-items)
[595.124040] Starting subtest: query-regions-garbage-items
[595.125656] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[595.247981] [127/133] (429s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[595.358689] Starting subtest: flip-primary-invalidate-overlay
[607.048086] Subtest flip-primary-invalidate-overlay: SUCCESS (11.688s)
[607.246996] [128/133] (417s left) gem_exec_balancer (full-late)
[607.315011] Starting subtest: full-late
[611.956747] Subtest full-late: SUCCESS (4.641s)
[612.325773] [129/133] (412s left) gem_exec_reloc (basic-write-wc)
[612.395852] Subtest basic-write-wc: SKIP (0.000s)
[612.480432] [130/133] (412s left) kms_force_connector_basic (force-load-detect)
[612.562664] Starting subtest: force-load-detect
[612.567328] Subtest force-load-detect: SKIP (0.000s)
[612.694538] [131/133] (411s left) kms_chamelium_hpd (hdmi-hpd-fast)
[613.076180] Subtest hdmi-hpd-fast: SKIP (0.000s)
[613.910907] [132/133] (410s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[614.000596] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[614.002690] Starting dynamic subtest: pipe-A-default-mode
[616.754805] Dynamic subtest pipe-A-default-mode: SUCCESS (2.751s)
[616.756957] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.753s)
[617.646700] [133/133] (407s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[617.760601] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[617.764755] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[617.865621] Closing watchdogs
results: parsing output: 0/ for test: kms_content_protection
results: parsing output: 1/ for test: core_getversion
results: parsing output: 2/ for test: kms_atomic_interruptible
results: parsing output: 3/ for test: kms_plane
results: parsing output: 4/ for test: kms_atomic_transition
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: perf
results: parsing output: 8/ for test: gem_eio
results: parsing output: 9/ for test: kms_color
results: parsing output: 10/ for test: gem_softpin
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: gem_ccs
results: parsing output: 17/ for test: perf
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_pxp
results: parsing output: 20/ for test: gem_eio
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: core_getstats
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: sw_sync
results: parsing output: 27/ for test: i915_pm_rps
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_cursor_crc
results: parsing output: 30/ for test: kms_dp_link_training
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_parallel
results: parsing output: 33/ for test: gem_eio
results: parsing output: 34/ for test: prime_mmap
results: parsing output: 35/ for test: kms_dsc
results: parsing output: 36/ for test: prime_busy
results: parsing output: 37/ for test: kms_vblank
results: parsing output: 38/ for test: kms_pm_rpm
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: perf
results: parsing output: 43/ for test: gem_wait
results: parsing output: 44/ for test: gen9_exec_parse
results: parsing output: 45/ for test: kms_cursor_edge_walk
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: prime_mmap
results: parsing output: 48/ for test: kms_addfb_basic
results: parsing output: 49/ for test: kms_chamelium_audio
results: parsing output: 50/ for test: kms_chamelium_edid
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: perf
results: parsing output: 54/ for test: kms_joiner
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: kms_legacy_colorkey
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_addfb_basic
results: parsing output: 59/ for test: gem_render_copy
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: kms_async_flips
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_ctx_persistence
results: parsing output: 69/ for test: gem_exec_big
results: parsing output: 70/ for test: gem_exec_fence
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: i915_drm_fdinfo
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_prop_blob
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: kms_pipe_crc_basic
results: parsing output: 80/ for test: kms_selftest
results: parsing output: 81/ for test: gem_close_race
results: parsing output: 82/ for test: gem_set_tiling_vs_gtt
results: parsing output: 83/ for test: kms_plane_scaling
results: parsing output: 84/ for test: kms_addfb_basic
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_render_copy
results: parsing output: 87/ for test: gem_caching
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: gem_lmem_evict
results: parsing output: 91/ for test: gem_mmap_gtt
results: parsing output: 92/ for test: kms_plane
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: gem_exec_suspend
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: gem_mmap_offset
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: gem_mmap_gtt
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: api_intel_bb
results: parsing output: 105/ for test: sysfs_heartbeat_interval
results: parsing output: 106/ for test: kms_getfb
results: parsing output: 107/ for test: gem_close
results: parsing output: 108/ for test: gem_exec_schedule
results: parsing output: 109/ for test: i915_drm_fdinfo
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_linear_blits
results: parsing output: 112/ for test: gem_ctx_persistence
results: parsing output: 113/ for test: perf_pmu
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: kms_pm_lpsp
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_atomic_transition
results: parsing output: 119/ for test: gem_userptr_blits
results: parsing output: 120/ for test: syncobj_eventfd
results: parsing output: 121/ for test: kms_addfb_basic
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: i915_query
results: parsing output: 126/ for test: kms_psr_stress_test
results: parsing output: 127/ for test: gem_exec_balancer
results: parsing output: 128/ for test: gem_exec_reloc
results: parsing output: 129/ for test: kms_force_connector_basic
results: parsing output: 130/ for test: kms_chamelium_hpd
results: parsing output: 131/ for test: kms_flip_scaled_crc
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.