[58.436047] Initializing watchdogs
[58.436094]   /dev/watchdog0
[58.449948] [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.454180] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.456338] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.459998] [001/133] (960s left) kms_psr (pr-primary-blt)
[58.574107] Starting subtest: pr-primary-blt
[58.578369] Subtest pr-primary-blt: SKIP (0.000s)
[58.650716] [002/133] (960s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[58.736404] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[58.738641] Starting dynamic subtest: pipe-A
[58.822122] Dynamic subtest pipe-A: SUCCESS (0.087s)
[58.828556] Starting dynamic subtest: pipe-B
[60.016685] Dynamic subtest pipe-B: SUCCESS (1.184s)
[60.024091] Starting dynamic subtest: pipe-C
[61.141975] Dynamic subtest pipe-C: SUCCESS (1.117s)
[61.150853] Starting dynamic subtest: pipe-D
[62.276794] Dynamic subtest pipe-D: SUCCESS (1.128s)
[62.279097] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.518s)
[63.443759] [003/133] (955s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[63.509028] Starting subtest: x-tiled-to-vebox-y-tiled
[63.513684] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[63.688917] [004/133] (955s left) kms_color_pipeline (plane-lut1d-lut1d)
[63.795127] Starting subtest: plane-lut1d-lut1d
[63.930251] Starting dynamic subtest: pipe-A-plane-0
[64.097383] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s)
[64.104406] Starting dynamic subtest: pipe-A-plane-1
[64.231287] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[64.238529] Starting dynamic subtest: pipe-A-plane-2
[64.365301] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[65.540759] Starting dynamic subtest: pipe-B-plane-0
[65.680797] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[65.687664] Starting dynamic subtest: pipe-B-plane-1
[65.825772] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s)
[65.833424] Starting dynamic subtest: pipe-B-plane-2
[65.992733] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[67.231338] Starting dynamic subtest: pipe-C-plane-0
[67.379777] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[67.387665] Starting dynamic subtest: pipe-C-plane-1
[67.546987] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[67.555162] Starting dynamic subtest: pipe-C-plane-2
[67.691896] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[68.922348] Starting dynamic subtest: pipe-D-plane-0
[69.060366] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[69.068960] Starting dynamic subtest: pipe-D-plane-1
[69.227790] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[69.236001] Starting dynamic subtest: pipe-D-plane-2
[69.383670] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[69.685662] Subtest plane-lut1d-lut1d: SUCCESS (5.872s)
[70.494921] [005/133] (948s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[70.603256] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[70.605631] Starting dynamic subtest: pipe-A-eDP-1
[70.663859] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[70.670593] Starting dynamic subtest: pipe-B-eDP-1
[70.730836] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[70.739519] Starting dynamic subtest: pipe-C-eDP-1
[70.796452] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[70.804863] Starting dynamic subtest: pipe-D-eDP-1
[70.861162] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[70.865149] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.007s)
[72.873767] [006/133] (946s left) kms_vblank (crtc-id)
[72.975112] Starting subtest: crtc-id
[72.977366] Starting dynamic subtest: pipe-A-eDP-1
[73.438487] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.462s)
[73.450834] Starting dynamic subtest: pipe-D-eDP-1
[74.617620] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.174s)
[74.619544] Subtest crtc-id: SUCCESS (1.638s)
[75.456304] [007/133] (943s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[75.504162] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[75.611494] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.107s)
[75.682336] [008/133] (943s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[75.739334] Starting subtest: y-tiled-to-vebox-x-tiled
[75.743725] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[75.917413] [009/133] (943s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[76.018085] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[76.022258] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[76.084943] [010/133] (943s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[76.175298] Starting subtest: psr-farfromfence-mmap-gtt
[76.179586] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[76.276209] [011/133] (943s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[76.367939] Starting subtest: async-flip-with-page-flip-events-tiled
[76.756228] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[79.583787] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.770s)
[79.594054] Starting dynamic subtest: pipe-A-eDP-1-4
[81.769942] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.185s)
[81.780544] Starting dynamic subtest: pipe-A-eDP-1-4
[83.729960] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.010s)
[83.737302] Starting dynamic subtest: pipe-A-eDP-1-x
[85.962301] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.179s)
[86.280795] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[89.118789] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.794s)
[89.128174] Starting dynamic subtest: pipe-B-eDP-1-4
[91.308245] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.186s)
[91.316893] Starting dynamic subtest: pipe-B-eDP-1-4
[93.266756] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[93.273807] Starting dynamic subtest: pipe-B-eDP-1-x
[95.543248] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.224s)
[95.868935] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[98.652232] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.733s)
[98.662893] Starting dynamic subtest: pipe-C-eDP-1-4
[100.817022] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.163s)
[100.827532] Starting dynamic subtest: pipe-C-eDP-1-4
[102.775636] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[102.784222] Starting dynamic subtest: pipe-C-eDP-1-x
[105.018594] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.190s)
[105.330059] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[108.139046] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.813s)
[108.148760] Starting dynamic subtest: pipe-D-eDP-1-4
[110.313697] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[110.323748] Starting dynamic subtest: pipe-D-eDP-1-4
[112.324730] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[112.334608] Starting dynamic subtest: pipe-D-eDP-1-x
[114.557240] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[114.559579] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.116s)
[115.732311] [012/133] (903s left) gem_exec_whisper (basic-queues-priority)
[115.802627] Starting subtest: basic-queues-priority
[139.053411] Subtest basic-queues-priority: SUCCESS (23.247s)
[139.245244] [013/133] (880s left) kms_prop_blob (blob-prop-validate)
[139.301402] Starting subtest: blob-prop-validate
[139.304055] Subtest blob-prop-validate: SUCCESS (0.000s)
[139.423221] [014/133] (880s left) gem_mmap_wc (write-cpu-read-wc)
[139.472696] Subtest write-cpu-read-wc: SKIP (0.000s)
[139.534616] [015/133] (879s left) api_intel_bb (add-remove-objects)
[139.582790] Starting subtest: add-remove-objects
[139.589344] Subtest add-remove-objects: SUCCESS (0.008s)
[139.668228] [016/133] (879s left) i915_hangman (hangcheck-unterminated)
[139.723122] Starting subtest: hangcheck-unterminated
[150.904054] Subtest hangcheck-unterminated: SUCCESS (11.180s)
[151.029970] [017/133] (868s left) gem_ctx_param (invalid-param-set)
[151.084847] Starting subtest: invalid-param-set
[151.087807] Subtest invalid-param-set: SUCCESS (0.000s)
[151.153082] [018/133] (868s left) perf (stress-open-close)
[151.266741] Starting subtest: stress-open-close
[151.269044] Starting dynamic subtest: 0-rcs0
[153.440861] Dynamic subtest 0-rcs0: SUCCESS (2.174s)
[153.450724] Starting dynamic subtest: 1-vcs1
[155.603098] Dynamic subtest 1-vcs1: SUCCESS (2.162s)
[155.605067] Subtest stress-open-close: SUCCESS (4.337s)
[155.639298] [019/133] (863s left) fbdev (eof)
[155.686762] Starting subtest: eof
[155.688806] Subtest eof: SUCCESS (0.000s)
[155.765393] [020/133] (863s left) syncobj_timeline (invalid-query-bad-pad)
[155.821693] Starting subtest: invalid-query-bad-pad
[155.823591] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[155.938212] [021/133] (863s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[156.335896] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[157.133340] [022/133] (862s left) gem_mmap_gtt (medium-copy-odd)
[157.186786] Subtest medium-copy-odd: SKIP (0.000s)
[157.235768] [023/133] (862s left) gem_eio (wait-wedge-immediate)
[157.452096] Starting subtest: wait-wedge-immediate
[159.004177] Subtest wait-wedge-immediate: SUCCESS (1.551s)
[159.142472] [024/133] (860s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[159.234741] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[166.040647] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.810s)
[166.173990] [025/133] (853s left) kms_pm_dc (dc6-psr)
[167.276436] Starting subtest: dc6-psr
[170.244460] Subtest dc6-psr: SUCCESS (2.970s)
[171.044681] [026/133] (848s left) gem_exec_fence (submit)
[171.224905] Starting subtest: submit
[171.229951] Subtest submit: SKIP (0.000s)
[172.958473] [FACT gem_exec_fence (submit)] new: kernel.kmod_is_loaded.vgem: true
[172.962347] [027/133] (846s left) gem_ctx_persistence (heartbeat-close)
[173.022505] Starting subtest: heartbeat-close
[173.026985] Subtest heartbeat-close: SKIP (0.000s)
[173.121882] [028/133] (846s left) sysfs_preempt_timeout (invalid)
[173.173743] Starting subtest: invalid
[173.176125] Starting dynamic subtest: vecs0
[173.178503] Dynamic subtest vecs0: SUCCESS (0.000s)
[173.188095] Starting dynamic subtest: ccs0
[173.189947] Dynamic subtest ccs0: SUCCESS (0.000s)
[173.197575] Starting dynamic subtest: vcs0
[173.199773] Dynamic subtest vcs0: SUCCESS (0.000s)
[173.207684] Starting dynamic subtest: bcs0
[173.210042] Dynamic subtest bcs0: SUCCESS (0.000s)
[173.217478] Starting dynamic subtest: rcs0
[173.219581] Dynamic subtest rcs0: SUCCESS (0.000s)
[173.231079] Starting dynamic subtest: vcs1
[173.233369] Dynamic subtest vcs1: SUCCESS (0.000s)
[173.235491] Subtest invalid: SUCCESS (0.004s)
[173.285464] [029/133] (846s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[173.376050] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[173.378213] Starting dynamic subtest: pipe-A-eDP-1
[173.406724] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[173.415984] Starting dynamic subtest: pipe-B-eDP-1
[173.437251] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[173.444728] Starting dynamic subtest: pipe-C-eDP-1
[173.465983] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[173.476175] Starting dynamic subtest: pipe-D-eDP-1
[173.498153] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[173.502504] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[175.601447] [030/133] (844s left) kms_feature_discovery (display-2x)
[175.705520] Starting subtest: display-2x
[175.709964] Subtest display-2x: SKIP (0.000s)
[175.774655] [031/133] (844s left) kms_async_flips (invalid-async-flip-atomic)
[175.861625] Starting subtest: invalid-async-flip-atomic
[176.235130] Starting dynamic subtest: pipe-A-eDP-1
[177.023590] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.789s)
[177.379722] Starting dynamic subtest: pipe-B-eDP-1
[178.154627] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.782s)
[178.514832] Starting dynamic subtest: pipe-C-eDP-1
[179.277374] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.768s)
[179.633987] Starting dynamic subtest: pipe-D-eDP-1
[180.404740] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.780s)
[180.407189] Subtest invalid-async-flip-atomic: SUCCESS (4.546s)
[181.555745] [032/133] (838s left) kms_sequence (get-forked-busy)
[181.656889] Starting subtest: get-forked-busy
[181.658777] Starting dynamic subtest: pipe-A-eDP-1
[183.590436] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.933s)
[183.599529] Starting dynamic subtest: pipe-B-eDP-1
[186.155232] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.563s)
[186.164288] Starting dynamic subtest: pipe-C-eDP-1
[188.782449] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.626s)
[188.793954] Starting dynamic subtest: pipe-D-eDP-1
[191.330857] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.548s)
[191.333464] Subtest get-forked-busy: SUCCESS (9.675s)
[192.137847] [033/133] (828s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[192.269616] Starting subtest: cursorB-vs-flipA-legacy
[192.274357] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[192.409974] [034/133] (827s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[192.514705] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[192.518961] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[192.626351] [035/133] (827s left) kms_chamelium_color (ctm-green-to-red)
[192.717045] Subtest ctm-green-to-red: SKIP (0.000s)
[192.759884] [036/133] (827s left) kms_content_protection (content-type-change)
[192.896973] Starting subtest: content-type-change
[192.901596] Subtest content-type-change: SKIP (0.000s)
[193.008063] [037/133] (827s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[193.122862] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[194.125914] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.002s)
[194.969421] [038/133] (825s left) api_intel_bb (intel-bb-blit-x)
[195.025124] Starting subtest: intel-bb-blit-x
[198.917031] Subtest intel-bb-blit-x: SUCCESS (3.892s)
[199.034910] [039/133] (821s left) i915_pm_rpm (gem-execbuf)
[201.087193] Starting subtest: gem-execbuf
[201.090196] Starting dynamic subtest: smem0
[202.815061] Dynamic subtest smem0: SUCCESS (1.727s)
[202.817441] Subtest gem-execbuf: SUCCESS (1.729s)
[202.910209] [040/133] (817s left) gem_create (create-size-update)
[202.963050] Starting subtest: create-size-update
[202.965243] Subtest create-size-update: SUCCESS (0.000s)
[203.169381] [041/133] (817s left) kms_cursor_crc (cursor-onscreen-128x42)
[203.402664] Starting subtest: cursor-onscreen-128x42
[203.447503] Subtest cursor-onscreen-128x42: SKIP (0.041s)
[203.665134] [042/133] (816s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[203.763849] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[211.016689] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.256s)
[211.153206] [043/133] (809s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[211.262578] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[211.266575] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[211.367516] [044/133] (809s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[211.451349] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[211.453914] Starting dynamic subtest: pipe-A-eDP-1
[211.477414] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[211.490279] Starting dynamic subtest: pipe-B-eDP-1
[211.511071] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[211.518501] Starting dynamic subtest: pipe-C-eDP-1
[211.539577] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[211.546865] Starting dynamic subtest: pipe-D-eDP-1
[211.567959] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[211.572190] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.005s)
[213.660113] [045/133] (806s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[213.770507] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[213.774832] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[213.874907] [046/133] (806s left) gem_softpin (allocator-basic-reserve)
[213.924490] Starting subtest: allocator-basic-reserve
[213.989637] Subtest allocator-basic-reserve: SUCCESS (0.067s)
[214.116559] [047/133] (806s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[214.205101] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[221.145238] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.942s)
[221.245386] [048/133] (799s left) kms_frontbuffer_tracking (psr-slowdraw)
[221.336567] Starting subtest: psr-slowdraw
[246.432129] Subtest psr-slowdraw: SUCCESS (25.096s)
[246.548456] [049/133] (774s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[246.644171] Starting subtest: fbc-pr-cursor-mmap-cpu
[246.648554] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[246.718410] [050/133] (774s left) gen3_render_mixed_blits
[246.835526] [051/133] (774s left) vgem_basic (debugfs)
[246.880820] Starting subtest: debugfs
[246.883110] Subtest debugfs: SUCCESS (0.000s)
[246.936561] [052/133] (773s left) gem_ctx_param (invalid-param-get)
[246.989020] Starting subtest: invalid-param-get
[246.991247] Subtest invalid-param-get: SUCCESS (0.002s)
[247.111354] [053/133] (773s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[247.213455] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[248.226870] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.012s)
[248.348321] [054/133] (772s left) kms_plane (pixel-format-4-tiled-modifier)
[248.452067] Starting subtest: pixel-format-4-tiled-modifier
[248.477529] Starting dynamic subtest: pipe-A-plane-0
[249.132825] Dynamic subtest pipe-A-plane-0: SUCCESS (0.655s)
[249.142966] Starting dynamic subtest: pipe-A-plane-3
[249.544071] Dynamic subtest pipe-A-plane-3: SUCCESS (0.409s)
[249.553870] Starting dynamic subtest: pipe-A-plane-5
[249.557331] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[250.631228] Starting dynamic subtest: pipe-B-plane-0
[251.324779] Dynamic subtest pipe-B-plane-0: SUCCESS (0.700s)
[251.333681] Starting dynamic subtest: pipe-B-plane-3
[251.779533] Dynamic subtest pipe-B-plane-3: SUCCESS (0.455s)
[251.788338] Starting dynamic subtest: pipe-B-plane-5
[251.791808] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[252.099832] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.649s)
[252.916387] [055/133] (768s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[253.014258] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[253.016512] Starting dynamic subtest: pipe-A-default-mode
[254.182055] Dynamic subtest pipe-A-default-mode: SKIP (1.164s)
[254.186207] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.165s)
[254.338437] [056/133] (766s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[254.718306] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[255.547437] [057/133] (765s left) syncobj_wait (wait-for-submit-snapshot)
[255.604709] Starting subtest: wait-for-submit-snapshot
[255.684910] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[255.757660] [058/133] (765s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[255.862722] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[255.866999] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[255.974426] [059/133] (765s left) kms_atomic_interruptible (legacy-cursor)
[256.074071] Starting subtest: legacy-cursor
[256.076220] Starting dynamic subtest: pipe-A-eDP-1
[263.495305] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.420s)
[263.497655] Subtest legacy-cursor: SUCCESS (7.422s)
[264.342436] [060/133] (756s left) kms_frontbuffer_tracking (fbc-tiling-y)
[264.452746] Starting subtest: fbc-tiling-y
[264.457010] Subtest fbc-tiling-y: SKIP (0.000s)
[264.544510] [061/133] (756s left) kms_fence_pin_leak
[264.726959] [062/133] (756s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[264.838729] Starting subtest: flip-vs-cursor-atomic
[271.915188] Subtest flip-vs-cursor-atomic: SUCCESS (7.074s)
[272.770236] [063/133] (748s left) kms_big_fb (linear-16bpp-rotate-0)
[272.871270] Starting subtest: linear-16bpp-rotate-0
[274.316896] Subtest linear-16bpp-rotate-0: SUCCESS (1.445s)
[274.428311] [064/133] (746s left) gem_exec_schedule (u-submit-golden-slice)
[274.493492] Starting subtest: u-submit-golden-slice
[274.495332] Starting dynamic subtest: rcs0
[274.522423] Dynamic subtest rcs0: SUCCESS (0.035s)
[274.530603] Starting dynamic subtest: bcs0
[274.563756] Dynamic subtest bcs0: SUCCESS (0.041s)
[274.575436] Starting dynamic subtest: vcs0
[274.593919] Dynamic subtest vcs0: SUCCESS (0.030s)
[274.601938] Starting dynamic subtest: vcs1
[274.625476] Dynamic subtest vcs1: SUCCESS (0.031s)
[274.633879] Starting dynamic subtest: vecs0
[274.655181] Dynamic subtest vecs0: SUCCESS (0.029s)
[274.663071] Starting dynamic subtest: ccs0
[274.689058] Dynamic subtest ccs0: SUCCESS (0.033s)
[274.690983] Subtest u-submit-golden-slice: SUCCESS (0.202s)
[276.010347] [065/133] (745s left) kms_vblank (ts-continuation-modeset-hang)
[276.120194] Starting subtest: ts-continuation-modeset-hang
[276.122399] Starting dynamic subtest: pipe-A-eDP-1
[302.747651] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.625s)
[302.761490] Starting dynamic subtest: pipe-D-eDP-1
[327.631092] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.879s)
[327.633453] Subtest ts-continuation-modeset-hang: SUCCESS (51.510s)
[328.497992] [066/133] (692s left) i915_suspend (sysfs-reader)
[328.558013] Starting subtest: sysfs-reader
[346.059708] Subtest sysfs-reader: SUCCESS (3.187s)
[346.134723] [067/133] (675s left) gem_caching (reads)
[346.217337] Subtest reads: SKIP (0.000s)
[346.290358] [068/133] (675s left) kms_psr (fbc-psr2-sprite-render)
[346.387028] Starting subtest: fbc-psr2-sprite-render
[346.389184] Starting dynamic subtest: eDP-1
[346.393047] Dynamic subtest eDP-1: SKIP (0.000s)
[346.396901] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[346.462543] [069/133] (675s left) kms_cursor_edge_walk (256x256-top-edge)
[346.546026] Starting subtest: 256x256-top-edge
[346.548155] Starting dynamic subtest: pipe-A-eDP-1
[350.095591] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.427s)
[350.107319] Starting dynamic subtest: pipe-D-eDP-1
[353.359693] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.190s)
[353.361983] Subtest 256x256-top-edge: SUCCESS (6.620s)
[354.183935] [070/133] (667s left) kms_lease (page-flip-implicit-plane)
[354.272931] Starting subtest: page-flip-implicit-plane
[354.274843] Starting dynamic subtest: pipe-A-eDP-1
[354.744828] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.466s)
[354.755295] Starting dynamic subtest: pipe-B-eDP-1
[355.950893] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.187s)
[355.960050] Starting dynamic subtest: pipe-C-eDP-1
[357.071253] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.103s)
[357.081507] Starting dynamic subtest: pipe-D-eDP-1
[358.204025] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.122s)
[358.206436] Subtest page-flip-implicit-plane: SUCCESS (3.885s)
[359.061452] [071/133] (662s left) gen9_exec_parse (bb-oversize)
[359.115656] Subtest bb-oversize: SKIP (0.000s)
[359.189643] [072/133] (662s left) kms_plane (plane-panning-top-left)
[359.290663] Starting subtest: plane-panning-top-left
[359.292928] Starting dynamic subtest: pipe-A
[361.059411] Dynamic subtest pipe-A: SUCCESS (1.754s)
[361.068672] Starting dynamic subtest: pipe-B
[363.404263] Dynamic subtest pipe-B: SUCCESS (2.332s)
[363.406658] Subtest plane-panning-top-left: SUCCESS (4.088s)
[364.224848] [073/133] (657s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[364.332369] Starting subtest: fbc-rgb101010-draw-blt
[368.942352] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.595s)
[370.050150] [074/133] (651s left) dumb_buffer (invalid-bpp)
[370.110696] Starting subtest: invalid-bpp
[370.112935] Subtest invalid-bpp: SUCCESS (0.000s)
[370.213282] [075/133] (651s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[370.314684] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[370.326204] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[370.419019] [076/133] (651s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[370.523607] Starting subtest: basic-flip-before-cursor-atomic
[371.442742] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.918s)
[372.276753] [077/133] (649s left) gem_exec_balancer (noheartbeat)
[372.542571] Starting subtest: noheartbeat
[372.547589] Subtest noheartbeat: SKIP (0.000s)
[372.639091] [078/133] (649s left) gem_readwrite (beyond-eob)
[372.706470] Subtest beyond-EOB: SKIP (0.000s)
[372.773331] [079/133] (649s left) gem_ppgtt (blt-vs-render-ctx0)
[372.826451] Starting subtest: blt-vs-render-ctx0
[405.905149] Subtest blt-vs-render-ctx0: SUCCESS (33.055s)
[406.041608] [080/133] (616s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[406.205376] Starting subtest: cursorB-vs-flipB-atomic
[406.209811] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[406.346319] [081/133] (615s left) kms_flip (basic-flip-vs-modeset)
[406.431849] Starting subtest: basic-flip-vs-modeset
[406.437884] Starting dynamic subtest: A-eDP1
[409.092091] Dynamic subtest A-eDP1: SUCCESS (2.653s)
[409.112859] Starting dynamic subtest: B-eDP1
[411.246619] Dynamic subtest B-eDP1: SUCCESS (2.151s)
[411.256337] Starting dynamic subtest: C-eDP1
[413.327446] Dynamic subtest C-eDP1: SUCCESS (2.079s)
[413.336887] Starting dynamic subtest: D-eDP1
[415.503200] Dynamic subtest D-eDP1: SUCCESS (2.174s)
[415.505362] Subtest basic-flip-vs-modeset: SUCCESS (9.067s)
[416.295590] [082/133] (605s left) gem_exec_reloc (basic-cpu-gtt)
[416.357664] Subtest basic-cpu-gtt: SKIP (0.000s)
[416.443463] [083/133] (605s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[416.539542] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[416.543583] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[416.646554] [084/133] (605s left) perf_pmu (init-wait)
[416.697199] Starting subtest: init-wait
[416.699454] Starting dynamic subtest: rcs0
[416.701725] Dynamic subtest rcs0: SUCCESS (0.002s)
[416.711881] Starting dynamic subtest: bcs0
[416.713771] Dynamic subtest bcs0: SUCCESS (0.000s)
[416.722437] Starting dynamic subtest: vcs0
[416.724374] Dynamic subtest vcs0: SUCCESS (0.001s)
[416.732902] Starting dynamic subtest: vcs1
[416.734847] Dynamic subtest vcs1: SUCCESS (0.000s)
[416.743255] Starting dynamic subtest: vecs0
[416.745137] Dynamic subtest vecs0: SUCCESS (0.001s)
[416.754242] Starting dynamic subtest: ccs0
[416.756447] Dynamic subtest ccs0: SUCCESS (0.000s)
[416.758698] Subtest init-wait: SUCCESS (0.008s)
[416.805684] [085/133] (605s left) gem_exec_schedule (u-submit-early-slice)
[416.882904] Starting subtest: u-submit-early-slice
[416.885098] Starting dynamic subtest: rcs0
[416.918846] Dynamic subtest rcs0: SUCCESS (0.043s)
[416.930649] Starting dynamic subtest: bcs0
[416.958384] Dynamic subtest bcs0: SUCCESS (0.039s)
[416.971084] Starting dynamic subtest: vcs0
[417.000121] Dynamic subtest vcs0: SUCCESS (0.041s)
[417.009591] Starting dynamic subtest: vcs1
[417.036442] Dynamic subtest vcs1: SUCCESS (0.035s)
[417.046425] Starting dynamic subtest: vecs0
[417.089200] Dynamic subtest vecs0: SUCCESS (0.052s)
[417.099698] Starting dynamic subtest: ccs0
[417.127224] Dynamic subtest ccs0: SUCCESS (0.038s)
[417.129613] Subtest u-submit-early-slice: SUCCESS (0.252s)
[418.300801] [086/133] (604s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[418.406796] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[419.418587] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.011s)
[419.516329] [087/133] (602s left) vgem_basic (unload)
[419.551814] Starting subtest: unload
[448.684047] Subtest unload: SUCCESS (29.074s)
[448.746613] [088/133] (573s left) perf (invalid-oa-metric-set-id)
[448.864373] Starting subtest: invalid-oa-metric-set-id
[448.874725] Subtest invalid-oa-metric-set-id: SUCCESS (0.009s)
[448.914262] [089/133] (573s left) i915_drm_fdinfo (all-busy-check-all)
[448.955270] Starting subtest: all-busy-check-all
[448.962560] Subtest all-busy-check-all: SKIP (0.004s)
[449.035491] [090/133] (573s left) gem_exec_params (mmapped)
[449.128811] Starting subtest: mmapped
[449.136528] Subtest mmapped: SUCCESS (0.008s)
[449.264351] [091/133] (573s left) kms_invalid_mode (zero-hdisplay)
[449.360342] Starting subtest: zero-hdisplay
[449.362661] Starting dynamic subtest: pipe-A-eDP-1
[449.654006] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s)
[449.663568] Starting dynamic subtest: pipe-B-eDP-1
[449.665433] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[449.673812] Starting dynamic subtest: pipe-C-eDP-1
[449.675929] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[449.688215] Starting dynamic subtest: pipe-D-eDP-1
[449.690443] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[449.692793] Subtest zero-hdisplay: SUCCESS (0.300s)
[450.539149] [092/133] (572s left) perf (global-sseu-config)
[450.624243] Starting subtest: global-sseu-config
[450.628874] Subtest global-sseu-config: SKIP (0.000s)
[450.670061] [093/133] (571s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[450.772362] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[450.776341] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[450.860875] [094/133] (571s left) kms_psr (psr2-no-drrs)
[450.955463] Starting subtest: psr2-no-drrs
[450.957740] Starting dynamic subtest: eDP-1
[452.514778] Dynamic subtest eDP-1: SUCCESS (1.560s)
[452.517136] Subtest psr2-no-drrs: SUCCESS (1.561s)
[453.304773] [095/133] (569s left) gem_ctx_sseu (mmap-args)
[453.363272] Subtest mmap-args: SKIP (0.000s)
[453.434274] [096/133] (569s left) gem_pxp (display-protected-crc)
[453.556908] Starting subtest: display-protected-crc
[455.192819] Subtest display-protected-crc: SUCCESS (1.638s)
[455.312562] [097/133] (567s left) kms_cursor_legacy (single-bo)
[455.422521] Starting subtest: single-bo
[455.424449] Starting dynamic subtest: pipe-A
[460.857834] Dynamic subtest pipe-A: SUCCESS (5.379s)
[460.869441] Starting dynamic subtest: pipe-B
[466.238353] Dynamic subtest pipe-B: SUCCESS (5.380s)
[466.250650] Starting dynamic subtest: pipe-C
[471.620822] Dynamic subtest pipe-C: SUCCESS (5.380s)
[471.632563] Starting dynamic subtest: pipe-D
[477.003367] Dynamic subtest pipe-D: SUCCESS (5.379s)
[477.015367] Starting dynamic subtest: all-pipes
[482.392916] Dynamic subtest all-pipes: SUCCESS (5.387s)
[482.395265] Subtest single-bo: SUCCESS (26.918s)
[482.490867] [098/133] (540s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[482.537222] Starting subtest: invalid-multi-wait-all-unsubmitted
[482.539384] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[482.617927] [099/133] (540s left) gem_exec_schedule (implicit-write-read)
[482.680549] Starting subtest: implicit-write-read
[482.682476] Starting dynamic subtest: rcs0
[482.790920] Dynamic subtest rcs0: SUCCESS (0.120s)
[482.801182] Starting dynamic subtest: vcs0
[482.881540] Dynamic subtest vcs0: SUCCESS (0.089s)
[482.892430] Starting dynamic subtest: vcs1
[482.967402] Dynamic subtest vcs1: SUCCESS (0.084s)
[482.978990] Starting dynamic subtest: vecs0
[483.046617] Dynamic subtest vecs0: SUCCESS (0.079s)
[483.056298] Starting dynamic subtest: ccs0
[483.140666] Dynamic subtest ccs0: SUCCESS (0.093s)
[483.143052] Subtest implicit-write-read: SUCCESS (0.470s)
[484.246165] [100/133] (538s left) gem_exec_balancer (parallel-keep-submit-fence)
[484.514617] Starting subtest: parallel-keep-submit-fence
[485.552558] Subtest parallel-keep-submit-fence: SUCCESS (1.037s)
[485.675816] [101/133] (537s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[485.848869] Starting subtest: cursor-rapid-movement-64x64
[485.854256] Starting dynamic subtest: pipe-A-eDP-1
[486.410420] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.556s)
[486.437571] Starting dynamic subtest: pipe-D-eDP-1
[487.597251] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.167s)
[487.599678] Subtest cursor-rapid-movement-64x64: SUCCESS (1.748s)
[488.460890] [102/133] (534s left) syncobj_wait (multi-wait-all-submitted-signaled)
[488.517557] Starting subtest: multi-wait-all-submitted-signaled
[488.620435] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.103s)
[488.710593] [103/133] (534s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[488.762446] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[488.870238] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.107s)
[488.959279] [104/133] (534s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[489.052000] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[489.056403] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[489.143057] [105/133] (534s left) gem_flink_basic (double-flink)
[489.202375] Starting subtest: double-flink
[489.204293] Subtest double-flink: SUCCESS (0.000s)
[489.285978] [106/133] (533s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[489.390702] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[495.978517] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.591s)
[496.105229] [107/133] (527s left) kms_psr (fbc-pr-suspend)
[496.208435] Starting subtest: fbc-pr-suspend
[496.212422] Subtest fbc-pr-suspend: SKIP (0.000s)
[496.281137] [108/133] (526s left) gem_ctx_isolation (nonpriv)
[496.348297] Starting subtest: nonpriv
[496.350519] Starting dynamic subtest: rcs0
[496.566806] Dynamic subtest rcs0: SUCCESS (0.221s)
[496.578941] Starting dynamic subtest: bcs0
[496.801861] Dynamic subtest bcs0: SUCCESS (0.233s)
[496.813899] Starting dynamic subtest: vcs0
[497.035096] Dynamic subtest vcs0: SUCCESS (0.233s)
[497.045451] Starting dynamic subtest: vcs1
[498.428276] Dynamic subtest vcs1: SUCCESS (1.391s)
[498.437577] Starting dynamic subtest: vecs0
[500.439595] Dynamic subtest vecs0: SUCCESS (2.010s)
[500.449147] Starting dynamic subtest: ccs0
[502.487117] Dynamic subtest ccs0: SUCCESS (2.046s)
[502.489376] Subtest nonpriv: SUCCESS (6.141s)
[502.716249] [109/133] (520s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[502.805411] Starting subtest: bad-rotation-90-y-tiled-ccs
[502.807796] Starting dynamic subtest: pipe-A-eDP-1
[502.831385] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[502.841380] Starting dynamic subtest: pipe-B-eDP-1
[502.863639] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[502.872755] Starting dynamic subtest: pipe-C-eDP-1
[502.894714] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[502.903960] Starting dynamic subtest: pipe-D-eDP-1
[502.925972] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[502.930605] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.004s)
[505.078640] [110/133] (518s left) gem_ctx_bad_destroy (invalid-pad)
[505.137075] Starting subtest: invalid-pad
[505.139455] Subtest invalid-pad: SUCCESS (0.000s)
[505.222921] [111/133] (518s left) syncobj_timeline (signal-array)
[505.275997] Starting subtest: signal-array
[505.278223] Subtest signal-array: SUCCESS (0.000s)
[505.369590] [112/133] (518s left) gem_tiled_swapping (non-threaded)
[505.420765] Subtest non-threaded: SKIP (0.000s)
[505.488582] [113/133] (517s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[505.577808] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[505.581972] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[505.678388] [114/133] (517s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[505.779882] Starting subtest: y-tiled-16bpp-rotate-0
[505.783995] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[505.865405] [115/133] (517s left) gem_media_vme
[505.993011] [116/133] (517s left) syncobj_wait (invalid-signal-one-illegal-handle)
[506.041721] Starting subtest: invalid-signal-one-illegal-handle
[506.043585] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[506.155684] [117/133] (517s left) syncobj_timeline (multi-wait-available-submitted)
[506.209031] Starting subtest: multi-wait-available-submitted
[506.211087] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[506.341183] [118/133] (517s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[506.451443] Starting subtest: cursor-vs-flip-atomic-transitions
[536.338704] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.876s)
[537.214080] [119/133] (486s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[537.305029] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[537.309335] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[537.376365] [120/133] (486s left) gem_vm_create (invalid-destroy)
[537.443328] Starting subtest: invalid-destroy
[537.445206] Subtest invalid-destroy: SUCCESS (0.002s)
[537.540183] [121/133] (486s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[537.640508] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[537.645114] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[537.745281] [122/133] (486s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[537.845601] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[537.847761] Starting dynamic subtest: pipe-A-default-mode
[538.970444] Dynamic subtest pipe-A-default-mode: SKIP (1.124s)
[538.974470] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.125s)
[539.129349] [123/133] (484s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[539.233822] Starting subtest: 4-tiled-16bpp-rotate-270
[539.256180] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[539.364211] [124/133] (484s left) prime_self_import (basic-with_fd_dup)
[539.405733] Starting subtest: basic-with_fd_dup
[539.422578] Subtest basic-with_fd_dup: SUCCESS (0.021s)
[539.531414] [125/133] (484s left) kms_flip (flip-vs-fences-interruptible)
[539.624425] Starting subtest: flip-vs-fences-interruptible
[539.628722] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[539.722609] [126/133] (484s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[539.818830] Starting subtest: yf-tiled-64bpp-rotate-90
[539.823254] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[539.933035] [127/133] (484s left) kms_plane_alpha_blend (coverage-7efc)
[540.034246] Starting subtest: coverage-7efc
[540.320066] Starting dynamic subtest: pipe-A-eDP-1
[540.886936] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.566s)
[540.917194] Starting dynamic subtest: pipe-D-eDP-1
[542.185214] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.278s)
[542.187539] Subtest coverage-7efc: SUCCESS (2.153s)
[543.017322] [128/133] (481s left) kms_pm_rpm (modeset-non-lpsp)
[544.535185] Starting subtest: modeset-non-lpsp
[545.681197] Subtest modeset-non-lpsp: SKIP (1.146s)
[546.084453] [129/133] (478s left) kms_psr (psr-no-drrs)
[546.176259] Starting subtest: psr-no-drrs
[546.178648] Starting dynamic subtest: eDP-1
[547.833918] Dynamic subtest eDP-1: SUCCESS (1.656s)
[547.836094] Subtest psr-no-drrs: SUCCESS (1.657s)
[548.720029] [130/133] (475s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[548.818274] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[548.822207] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[548.920488] [131/133] (475s left) gem_mmap_offset (mmap-unmap)
[548.981440] Starting subtest: mmap-unmap
[548.983666] Starting dynamic subtest: smem0
[571.056139] Dynamic subtest smem0: SUCCESS (22.019s)
[571.058849] Subtest mmap-unmap: SUCCESS (22.020s)
[571.125287] [132/133] (453s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[571.220215] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[571.224546] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[571.297389] [133/133] (453s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[571.389749] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[571.400542] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[571.473938] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_plane_scaling
results: parsing output: 2/ for test: gem_render_copy
results: parsing output: 3/ for test: kms_color_pipeline
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: kms_vblank
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: gem_render_copy
results: parsing output: 8/ for test: kms_psr2_sf
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_async_flips
results: parsing output: 11/ for test: gem_exec_whisper
results: parsing output: 12/ for test: kms_prop_blob
results: parsing output: 13/ for test: gem_mmap_wc
results: parsing output: 14/ for test: api_intel_bb
results: parsing output: 15/ for test: i915_hangman
results: parsing output: 16/ for test: gem_ctx_param
results: parsing output: 17/ for test: perf
results: parsing output: 18/ for test: fbdev
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_chamelium_hpd
results: parsing output: 21/ for test: gem_mmap_gtt
results: parsing output: 22/ for test: gem_eio
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_pm_dc
results: parsing output: 25/ for test: gem_exec_fence
results: parsing output: 26/ for test: gem_ctx_persistence
results: parsing output: 27/ for test: sysfs_preempt_timeout
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: kms_feature_discovery
results: parsing output: 30/ for test: kms_async_flips
results: parsing output: 31/ for test: kms_sequence
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_chamelium_color
results: parsing output: 35/ for test: kms_content_protection
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: api_intel_bb
results: parsing output: 38/ for test: i915_pm_rpm
results: parsing output: 39/ for test: gem_create
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_softpin
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: gen3_render_mixed_blits
results: parsing output: 50/ for test: vgem_basic
results: parsing output: 51/ for test: gem_ctx_param
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_plane
results: parsing output: 54/ for test: kms_flip_scaled_crc
results: parsing output: 55/ for test: kms_chamelium_edid
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_atomic_interruptible
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_fence_pin_leak
results: parsing output: 61/ for test: kms_cursor_legacy
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: gem_exec_schedule
results: parsing output: 64/ for test: kms_vblank
results: parsing output: 65/ for test: i915_suspend
results: parsing output: 66/ for test: gem_caching
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: kms_cursor_edge_walk
results: parsing output: 69/ for test: kms_lease
results: parsing output: 70/ for test: gen9_exec_parse
results: parsing output: 71/ for test: kms_plane
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: dumb_buffer
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: gem_exec_balancer
results: parsing output: 77/ for test: gem_readwrite
results: parsing output: 78/ for test: gem_ppgtt
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: perf_pmu
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: vgem_basic
results: parsing output: 87/ for test: perf
results: parsing output: 88/ for test: i915_drm_fdinfo
results: parsing output: 89/ for test: gem_exec_params
results: parsing output: 90/ for test: kms_invalid_mode
results: parsing output: 91/ for test: perf
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: gem_ctx_sseu
results: parsing output: 95/ for test: gem_pxp
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: syncobj_wait
results: parsing output: 98/ for test: gem_exec_schedule
results: parsing output: 99/ for test: gem_exec_balancer
results: parsing output: 100/ for test: kms_cursor_crc
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_flink_basic
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: gem_ctx_isolation
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: gem_ctx_bad_destroy
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: gem_tiled_swapping
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: gem_media_vme
results: parsing output: 115/ for test: syncobj_wait
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: kms_flip_scaled_crc
results: parsing output: 119/ for test: gem_vm_create
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_flip_scaled_crc
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: prime_self_import
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: kms_plane_alpha_blend
results: parsing output: 127/ for test: kms_pm_rpm
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_mmap_offset
results: parsing output: 131/ for test: kms_plane
results: parsing output: 132/ for test: kms_flip
Done.