[57.177803] Initializing watchdogs
[57.177891]   /dev/watchdog0
[57.195877] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[57.200121] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.202115] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.205545] [001/156] (960s left) gem_render_linear_blits (basic)
[57.287043] Starting subtest: basic
[57.332428] Subtest basic: SUCCESS (0.045s)
[57.412977] [002/156] (960s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[57.489930] Starting subtest: stress-mm-invalidate-close-overlap
[59.636925] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[59.750822] [003/156] (958s left) gem_exec_params (sol-reset-invalid)
[59.808024] Starting subtest: sol-reset-invalid
[59.810388] Subtest sol-reset-invalid: SUCCESS (0.003s)
[61.302349] [004/156] (956s left) gem_exec_endless (dispatch)
[61.372055] Starting subtest: dispatch
[61.374474] Starting dynamic subtest: rcs0
[61.378848] Dynamic subtest rcs0: SUCCESS (0.005s)
[61.392904] Starting dynamic subtest: bcs0
[61.397626] Dynamic subtest bcs0: SUCCESS (0.004s)
[61.407028] Starting dynamic subtest: vcs0
[61.411007] Dynamic subtest vcs0: SUCCESS (0.004s)
[61.418087] Starting dynamic subtest: vcs1
[61.422317] Dynamic subtest vcs1: SUCCESS (0.004s)
[61.429058] Starting dynamic subtest: vecs0
[61.433329] Dynamic subtest vecs0: SUCCESS (0.004s)
[61.440122] Starting dynamic subtest: ccs0
[61.444274] Dynamic subtest ccs0: SUCCESS (0.004s)
[61.446176] Subtest dispatch: SUCCESS (0.028s)
[63.267205] [005/156] (954s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[63.345063] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[63.347290] Starting dynamic subtest: pipe-A-eDP-1
[63.356187] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[63.365486] Starting dynamic subtest: pipe-B-eDP-1
[63.374969] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[63.383595] Starting dynamic subtest: pipe-C-eDP-1
[63.392583] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[63.399807] Starting dynamic subtest: pipe-D-eDP-1
[63.408382] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[63.412460] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[65.621209] [006/156] (952s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[65.668056] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[65.672691] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[65.848688] [007/156] (952s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[65.920952] Starting subtest: nonblocking-crc-frame-sequence
[65.923415] Starting dynamic subtest: pipe-A-eDP-1
[66.661569] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.739s)
[66.673293] Starting dynamic subtest: pipe-B-eDP-1
[68.122200] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.459s)
[68.131279] Starting dynamic subtest: pipe-C-eDP-1
[69.498093] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s)
[69.505879] Starting dynamic subtest: pipe-D-eDP-1
[70.828055] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[70.830625] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.907s)
[71.641052] [008/156] (946s left) perf_pmu (most-busy-check-all)
[71.682374] Starting subtest: most-busy-check-all
[71.684807] Starting dynamic subtest: rcs0
[73.212837] Dynamic subtest rcs0: SUCCESS (1.529s)
[73.224134] Starting dynamic subtest: bcs0
[75.197092] Dynamic subtest bcs0: SUCCESS (1.982s)
[75.208973] Starting dynamic subtest: vcs0
[77.244993] Dynamic subtest vcs0: SUCCESS (2.048s)
[77.256582] Starting dynamic subtest: vcs1
[79.229553] Dynamic subtest vcs1: SUCCESS (1.983s)
[79.238842] Starting dynamic subtest: vecs0
[81.212916] Dynamic subtest vecs0: SUCCESS (1.982s)
[81.222678] Starting dynamic subtest: ccs0
[83.261854] Dynamic subtest ccs0: SUCCESS (2.048s)
[83.264607] Subtest most-busy-check-all: SUCCESS (11.578s)
[83.371278] [009/156] (934s left) sysfs_timeslice_duration (duration)
[83.428327] Starting subtest: duration
[83.430650] Starting dynamic subtest: vecs0
[97.115994] Dynamic subtest vecs0: SUCCESS (13.684s)
[97.126566] Starting dynamic subtest: ccs0
[110.257517] Dynamic subtest ccs0: SUCCESS (13.139s)
[110.268564] Starting dynamic subtest: vcs0
[124.123710] Dynamic subtest vcs0: SUCCESS (13.864s)
[124.135030] Starting dynamic subtest: bcs0
[137.266918] Dynamic subtest bcs0: SUCCESS (13.144s)
[137.278546] Starting dynamic subtest: rcs0
[150.393986] Dynamic subtest rcs0: SUCCESS (13.126s)
[150.405057] Starting dynamic subtest: vcs1
[165.146613] Dynamic subtest vcs1: SUCCESS (14.748s)
[165.149190] Subtest duration: SUCCESS (81.713s)
[165.222956] [010/156] (852s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-move)
[165.319651] Starting subtest: hdr-2p-scndscrn-spr-indfb-move
[165.324089] Subtest hdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[165.435533] [011/156] (852s left) kms_chamelium_color (ctm-green-to-red)
[165.514501] Subtest ctm-green-to-red: SKIP (0.000s)
[165.554920] [012/156] (852s left) kms_vblank (ts-continuation-dpms-rpm)
[165.643790] Starting subtest: ts-continuation-dpms-rpm
[165.646154] Starting dynamic subtest: pipe-A-eDP-1
[168.108235] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.462s)
[168.122372] Starting dynamic subtest: pipe-D-eDP-1
[170.377953] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.264s)
[170.381962] Subtest ts-continuation-dpms-rpm: SUCCESS (4.728s)
[171.266600] [013/156] (846s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render)
[171.352655] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render
[171.356793] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[171.446396] [014/156] (846s left) kms_plane_scaling (planes-downscale-factor-0-75)
[171.525182] Starting subtest: planes-downscale-factor-0-75
[171.527769] Starting dynamic subtest: pipe-A
[171.550252] Dynamic subtest pipe-A: SKIP (0.021s)
[171.558552] Starting dynamic subtest: pipe-B
[171.580887] Dynamic subtest pipe-B: SKIP (0.032s)
[171.589175] Starting dynamic subtest: pipe-C
[171.613644] Dynamic subtest pipe-C: SKIP (0.032s)
[171.621839] Starting dynamic subtest: pipe-D
[171.645640] Dynamic subtest pipe-D: SKIP (0.031s)
[171.649817] Subtest planes-downscale-factor-0-75: SKIP (0.117s)
[171.746287] [015/156] (846s left) kms_draw_crc (draw-method-render)
[171.830937] Starting subtest: draw-method-render
[171.833259] Starting dynamic subtest: xrgb8888-untiled
[172.084193] Dynamic subtest xrgb8888-untiled: SUCCESS (0.255s)
[172.093259] Starting dynamic subtest: rgb565-untiled
[172.306401] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[172.315508] Starting dynamic subtest: xrgb2101010-untiled
[172.539447] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.233s)
[172.547633] Starting dynamic subtest: xbgr16161616f-untiled
[172.783567] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[172.791623] Starting dynamic subtest: xrgb8888-xtiled
[172.906385] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[172.914645] Starting dynamic subtest: rgb565-xtiled
[173.017801] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s)
[173.028604] Starting dynamic subtest: xrgb2101010-xtiled
[173.128486] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[173.137277] Starting dynamic subtest: xbgr16161616f-xtiled
[173.261976] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[173.271624] Starting dynamic subtest: xrgb8888-4tiled
[173.384285] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[173.392290] Starting dynamic subtest: rgb565-4tiled
[173.495082] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[173.504198] Starting dynamic subtest: xrgb2101010-4tiled
[173.617453] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[173.625657] Starting dynamic subtest: xbgr16161616f-4tiled
[173.750556] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[173.752644] Subtest draw-method-render: SUCCESS (1.921s)
[173.862698] [016/156] (844s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-pwrite)
[173.952217] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-pwrite
[173.955686] Subtest fbchdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[174.050694] [017/156] (844s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[174.141350] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[174.144875] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[174.234217] [018/156] (844s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[174.277935] Starting subtest: multi-wait-available-submitted-signaled
[174.279990] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[174.389424] [019/156] (843s left) sw_sync (sync_multi_producer_single_consumer)
[174.422292] Starting subtest: sync_multi_producer_single_consumer
[175.497283] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[175.558558] [020/156] (842s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[175.636287] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[175.640597] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[175.703438] [021/156] (842s left) gem_vm_create (invalid-create)
[175.756383] Starting subtest: invalid-create
[175.758414] Subtest invalid-create: SUCCESS (0.002s)
[175.867339] [022/156] (842s left) kms_frontbuffer_tracking (fbcpsrhdr-suspend)
[175.944286] Starting subtest: fbcpsrhdr-suspend
[175.948919] Subtest fbcpsrhdr-suspend: SKIP (0.000s)
[176.033427] [023/156] (842s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[176.110589] Starting subtest: 4-tiled-16bpp-rotate-270
[176.128455] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.018s)
[176.229265] [024/156] (842s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-pwrite)
[176.316261] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-pwrite
[176.320590] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[176.406852] [025/156] (842s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[176.516352] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[177.498443] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.981s)
[178.299990] [026/156] (840s left) gem_pxp (protected-raw-src-copy-not-readible)
[178.419561] Starting subtest: protected-raw-src-copy-not-readible
[178.500082] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.082s)
[178.602980] [027/156] (840s left) kms_cursor_crc (cursor-offscreen-128x42)
[178.794478] Starting subtest: cursor-offscreen-128x42
[178.838388] Subtest cursor-offscreen-128x42: SKIP (0.041s)
[179.017606] [028/156] (839s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[179.094659] Starting subtest: yf-tiled-64bpp-rotate-180
[179.099219] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[179.192251] [029/156] (839s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[179.268110] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[179.271868] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[179.344280] [030/156] (839s left) i915_suspend (debugfs-reader)
[179.398743] Starting subtest: debugfs-reader
[197.646324] Subtest debugfs-reader: SUCCESS (3.360s)
[197.834176] [031/156] (821s left) gem_mmap_wc (write-read-distinct)
[197.904451] Subtest write-read-distinct: SKIP (0.000s)
[197.969311] [032/156] (821s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[198.051494] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[198.055592] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[198.150984] [033/156] (820s left) kms_properties (invalid-properties-legacy)
[198.217044] Starting subtest: invalid-properties-legacy
[198.310885] Subtest invalid-properties-legacy: SUCCESS (0.093s)
[198.398078] [034/156] (820s left) kms_pm_rpm (pc8-residency)
[200.204074] Starting subtest: pc8-residency
[200.208911] Subtest pc8-residency: SKIP (0.000s)
[200.657621] [035/156] (818s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-onoff)
[200.745976] Starting subtest: psrhdr-1p-primscrn-spr-indfb-onoff
[200.750256] Subtest psrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[200.837884] [036/156] (818s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[201.198565] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[201.979182] [037/156] (817s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[202.069691] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[202.805900] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.737s)
[202.961854] [038/156] (816s left) kms_addfb_basic (bad-pitch-999)
[203.021267] Starting subtest: bad-pitch-999
[203.023272] Subtest bad-pitch-999: SUCCESS (0.000s)
[203.155986] [039/156] (816s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-blt)
[203.234958] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-blt
[203.239267] Subtest psrhdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[203.334377] [040/156] (816s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[203.407546] Subtest untiled-to-tiled: SKIP (0.000s)
[203.478357] [041/156] (815s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[203.574570] Starting subtest: flip-vs-cursor-toggle
[212.428945] Subtest flip-vs-cursor-toggle: SUCCESS (8.849s)
[213.233863] [042/156] (806s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[213.308515] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[213.312731] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[213.381501] [043/156] (806s left) kms_async_flips (async-flip-hang)
[213.449661] Starting subtest: async-flip-hang
[213.826730] Starting dynamic subtest: pipe-A-eDP-1
[229.637531] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.807s)
[230.011377] Starting dynamic subtest: pipe-B-eDP-1
[245.629560] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.626s)
[246.011969] Starting dynamic subtest: pipe-C-eDP-1
[261.631626] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.622s)
[262.009231] Starting dynamic subtest: pipe-D-eDP-1
[277.632099] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.626s)
[277.634465] Subtest async-flip-hang: SUCCESS (64.178s)
[278.886043] [044/156] (740s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[278.979771] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[278.984180] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[279.069840] [045/156] (740s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[279.167370] Starting subtest: cursorA-vs-flipB-varying-size
[279.171931] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[279.323010] [046/156] (740s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[279.408733] Starting subtest: yf-tiled-16bpp-rotate-0
[279.413154] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[279.506590] [047/156] (740s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[279.584882] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[279.588964] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[279.669723] [048/156] (739s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen)
[279.753881] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen
[279.758074] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[279.850073] [049/156] (739s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt)
[279.931217] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt
[279.934901] Subtest fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[280.016116] [050/156] (739s left) syncobj_timeline (multi-wait-all-signaled)
[280.061580] Starting subtest: multi-wait-all-signaled
[280.063722] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[280.178692] [051/156] (739s left) gem_ctx_persistence (heartbeat-many)
[280.243308] Starting subtest: heartbeat-many
[280.247187] Subtest heartbeat-many: SKIP (0.000s)
[280.348104] [052/156] (739s left) gen7_exec_parse (basic-rejected)
[280.410513] Subtest basic-rejected: SKIP (0.000s)
[280.478209] [053/156] (739s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-pwrite)
[280.562147] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-pwrite
[280.565823] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[280.650737] [054/156] (739s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[280.728972] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[280.730974] Starting dynamic subtest: pipe-A-eDP-1
[280.751225] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[280.762757] Starting dynamic subtest: pipe-B-eDP-1
[280.780590] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[280.789468] Starting dynamic subtest: pipe-C-eDP-1
[280.807395] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[280.815857] Starting dynamic subtest: pipe-D-eDP-1
[280.835718] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[280.839129] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[283.052100] [055/156] (736s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[283.134514] Starting subtest: plane-all-modeset-transition-internal-panels
[283.136812] Starting dynamic subtest: pipe-A-eDP-1
[284.487793] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.353s)
[284.765093] Starting dynamic subtest: pipe-B-eDP-1
[285.810133] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.055s)
[286.080292] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.944s)
[286.918621] [056/156] (733s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[286.997494] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[296.341240] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.350s)
[296.464698] [057/156] (723s left) gem_softpin (evict-prime)
[296.522146] Starting subtest: evict-prime
[296.524599] Starting dynamic subtest: rcs0
[297.678818] Dynamic subtest rcs0: SUCCESS (1.156s)
[297.690405] Starting dynamic subtest: bcs0
[298.797504] Dynamic subtest bcs0: SUCCESS (1.117s)
[298.808296] Starting dynamic subtest: vcs0
[300.137964] Dynamic subtest vcs0: SUCCESS (1.339s)
[300.151150] Starting dynamic subtest: vcs1
[302.137250] Dynamic subtest vcs1: SUCCESS (1.998s)
[302.151703] Starting dynamic subtest: vecs0
[304.103303] Dynamic subtest vecs0: SUCCESS (1.964s)
[304.116675] Starting dynamic subtest: ccs0
[305.231700] Dynamic subtest ccs0: SUCCESS (1.128s)
[305.243050] Starting dynamic subtest: all
[307.102774] Dynamic subtest all: SUCCESS (1.868s)
[307.105794] Subtest evict-prime: SUCCESS (10.581s)
[307.177787] [058/156] (712s left) gem_ctx_param (invalid-ctx-set)
[307.232626] Starting subtest: invalid-ctx-set
[307.234956] Subtest invalid-ctx-set: SUCCESS (0.001s)
[307.331258] [059/156] (712s left) kms_chamelium_frames (vga-frame-dump)
[307.705601] Subtest vga-frame-dump: SKIP (0.000s)
[308.496425] [060/156] (711s left) gem_exec_flush (basic-wb-ro-default)
[308.553681] Starting subtest: basic-wb-ro-default
[314.002639] Subtest basic-wb-ro-default: SUCCESS (5.450s)
[314.187922] [061/156] (705s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[314.271484] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[314.275585] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[314.372889] [062/156] (705s left) kms_hdr (static-swap)
[314.448836] Starting subtest: static-swap
[314.451129] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[314.455424] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[314.465515] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[314.469518] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[314.473543] Subtest static-swap: SKIP (0.002s)
[314.519790] [063/156] (705s left) kms_plane_lowres (tiling-y)
[314.591805] Starting subtest: tiling-y
[314.595999] Subtest tiling-y: SKIP (0.000s)
[314.661240] [064/156] (705s left) kms_addfb_basic (invalid-get-prop)
[314.710702] Starting subtest: invalid-get-prop
[314.712831] Subtest invalid-get-prop: SUCCESS (0.000s)
[314.820406] [065/156] (705s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-indfb-msflip-blt)
[314.900990] Starting subtest: fbchdr-2p-scndscrn-indfb-msflip-blt
[314.905450] Subtest fbchdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[314.988159] [066/156] (705s left) kms_content_protection (lic-type-0)
[315.112000] Starting subtest: lic-type-0
[315.116599] Subtest lic-type-0: SKIP (0.000s)
[315.226469] [067/156] (705s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[315.301094] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[315.307111] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[316.445443] [068/156] (703s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[316.530148] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[316.534730] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[316.646185] [069/156] (703s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[316.752478] Starting subtest: flip-vs-cursor-atomic
[324.134392] Subtest flip-vs-cursor-atomic: SUCCESS (7.381s)
[324.971295] [070/156] (695s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[325.046569] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[325.050679] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[325.133453] [071/156] (695s left) gem_exec_balancer (hang)
[325.385014] Starting subtest: hang
[327.143156] Subtest hang: SUCCESS (1.758s)
[327.251659] [072/156] (693s left) kms_pm_dc (dc5-dpms-negative)
[328.344502] Starting subtest: dc5-dpms-negative
[328.348589] Subtest dc5-dpms-negative: SKIP (0.000s)
[328.412515] [073/156] (692s left) gem_huc_copy (huc-copy)
[328.469040] Starting subtest: huc-copy
[328.471467] Subtest huc-copy: SUCCESS (0.003s)
[328.591783] [074/156] (692s left) kms_selftest (drm_plane_helper)
[328.628567] Starting subtest: drm_plane_helper
[328.680282] Starting dynamic subtest: drm_test_check_plane_state
[328.772269] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.090s)
[328.783239] Starting dynamic subtest: drm_test_check_invalid_plane_state
[328.874228] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.102s)
[328.876562] Subtest drm_plane_helper: SUCCESS (0.244s)
[329.035281] [075/156] (691s left) gem_eio (create)
[329.252148] Starting subtest: create
[329.566441] Subtest create: SUCCESS (0.316s)
[329.699646] [076/156] (691s left) gem_exec_fence (syncobj-wait)
[330.131282] Starting subtest: syncobj-wait
[331.137960] Subtest syncobj-wait: SUCCESS (1.005s)
[331.486867] [FACT gem_exec_fence (syncobj-wait)] new: kernel.kmod_is_loaded.vgem: true
[331.490324] [077/156] (689s left) gem_mmap_wc (write)
[331.544666] Subtest write: SKIP (0.000s)
[331.600270] [078/156] (689s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[331.690017] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[341.060866] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.375s)
[341.189739] [079/156] (679s left) kms_psr (fbc-pr-primary-blt)
[341.266605] Starting subtest: fbc-pr-primary-blt
[341.270755] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[341.341378] [080/156] (679s left) api_intel_allocator (execbuf-with-allocator)
[341.399753] Starting subtest: execbuf-with-allocator
[341.404233] Subtest execbuf-with-allocator: SUCCESS (0.005s)
[341.504371] [081/156] (679s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[341.577622] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[341.582005] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[341.688842] [082/156] (679s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[341.765646] Starting subtest: x-tiled-16bpp-rotate-0
[343.121405] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.356s)
[343.245037] [083/156] (677s left) kms_lease (lessee-list)
[343.318882] Starting subtest: lessee-list
[343.320952] Starting dynamic subtest: pipe-A-eDP-1
[343.322893] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[343.333171] Starting dynamic subtest: pipe-B-eDP-1
[343.334787] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[343.344742] Starting dynamic subtest: pipe-C-eDP-1
[343.346364] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[343.355755] Starting dynamic subtest: pipe-D-eDP-1
[343.357489] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[343.359233] Subtest lessee-list: SUCCESS (0.009s)
[343.452265] [084/156] (677s left) kms_properties (plane-properties-legacy)
[343.532712] Starting subtest: plane-properties-legacy
[343.535431] Starting dynamic subtest: pipe-A-eDP-1
[344.072800] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.538s)
[344.083706] Starting dynamic subtest: pipe-B-eDP-1
[345.327985] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.255s)
[345.338635] Starting dynamic subtest: pipe-C-eDP-1
[346.568874] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.237s)
[346.579240] Starting dynamic subtest: pipe-D-eDP-1
[347.809518] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.241s)
[347.811903] Subtest plane-properties-legacy: SUCCESS (4.277s)
[348.625140] [085/156] (672s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-render)
[348.697831] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-render
[348.702021] Subtest hdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[348.795176] [086/156] (672s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[348.876227] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[353.556845] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (4.687s)
[353.656238] [087/156] (667s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[353.747000] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[353.751110] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[353.855225] [088/156] (667s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-pwrite)
[353.938633] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-pwrite
[353.942854] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[354.047948] [089/156] (667s left) kms_psr (fbc-psr2-cursor-blt)
[354.136026] Starting subtest: fbc-psr2-cursor-blt
[354.138297] Starting dynamic subtest: eDP-1
[354.142705] Dynamic subtest eDP-1: SKIP (0.000s)
[354.147167] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[354.209186] [090/156] (667s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt)
[354.294276] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt
[354.298337] Subtest fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[354.404512] [091/156] (666s left) gen9_exec_parse (valid-registers)
[354.464459] Subtest valid-registers: SKIP (0.000s)
[354.531778] [092/156] (666s left) kms_psr (fbc-psr-basic)
[354.608521] Starting subtest: fbc-psr-basic
[354.610572] Starting dynamic subtest: eDP-1
[354.614238] Dynamic subtest eDP-1: SKIP (0.000s)
[354.617843] Subtest fbc-psr-basic: SKIP (0.001s)
[354.677644] [093/156] (666s left) gem_ppgtt (shrink-vs-evict-any)
[354.741167] Starting subtest: shrink-vs-evict-any
[360.128284] Subtest shrink-vs-evict-any: SUCCESS (5.385s)
[360.223507] [094/156] (661s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[360.482684] Starting subtest: cursor-rapid-movement-512x512
[360.487083] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[360.629328] [095/156] (660s left) perf_pmu (busy-double-start)
[360.671620] Starting subtest: busy-double-start
[360.673555] Starting dynamic subtest: rcs0
[364.239996] Dynamic subtest rcs0: SUCCESS (3.570s)
[364.250625] Starting dynamic subtest: bcs0
[367.813886] Dynamic subtest bcs0: SUCCESS (3.572s)
[367.827287] Starting dynamic subtest: vcs0
[371.647642] Dynamic subtest vcs0: SUCCESS (3.831s)
[371.659634] Starting dynamic subtest: vcs1
[375.664800] Dynamic subtest vcs1: SUCCESS (4.015s)
[375.679027] Starting dynamic subtest: vecs0
[379.617766] Dynamic subtest vecs0: SUCCESS (3.951s)
[379.630801] Starting dynamic subtest: ccs0
[383.195697] Dynamic subtest ccs0: SUCCESS (3.575s)
[383.198340] Subtest busy-double-start: SUCCESS (22.526s)
[383.310307] [096/156] (638s left) kms_psr (pr-primary-page-flip)
[383.398319] Starting subtest: pr-primary-page-flip
[383.402134] Subtest pr-primary-page-flip: SKIP (0.000s)
[383.469781] [097/156] (638s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[383.562165] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[383.566437] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[383.658493] [098/156] (637s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[383.746871] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[383.750995] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[383.845929] [099/156] (637s left) prime_udl
[383.930908] [100/156] (637s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-onoff)
[384.014765] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-onoff
[384.019228] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[384.129328] [101/156] (637s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-pwrite)
[384.210618] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-pwrite
[384.214206] Subtest hdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[384.316210] [102/156] (637s left) gem_mmap_wc (write-cpu-read-wc)
[384.366376] Subtest write-cpu-read-wc: SKIP (0.000s)
[384.423182] [103/156] (637s left) i915_pm_rps (thresholds)
[384.472258] Starting subtest: thresholds
[384.476180] Subtest thresholds: SKIP (0.000s)
[384.567889] [104/156] (637s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[384.640219] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[384.643764] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[384.740766] [105/156] (637s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[384.812039] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[384.815488] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[384.905142] [106/156] (637s left) syncobj_timeline (wait-for-submit-delayed-submit)
[384.957305] Starting subtest: wait-for-submit-delayed-submit
[385.059881] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[385.145749] [107/156] (636s left) gem_userptr_blits (coherency-sync)
[385.204616] Starting subtest: coherency-sync
[385.491692] Subtest coherency-sync: SKIP (0.251s)
[385.587572] [108/156] (636s left) prime_mmap (test_forked)
[385.683756] Starting subtest: test_forked
[385.685772] Starting dynamic subtest: test_forked-smem
[385.721998] Dynamic subtest test_forked-smem: SUCCESS (0.041s)
[385.724779] Subtest test_forked: SUCCESS (0.041s)
[385.840064] [109/156] (636s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-blt)
[385.929419] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-blt
[385.933861] Subtest hdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[386.028158] [110/156] (636s left) core_setmaster (master-drop-set-user)
[386.122571] Starting subtest: master-drop-set-user
[386.133193] Subtest master-drop-set-user: SUCCESS (0.012s)
[386.172537] [111/156] (636s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[386.221639] Starting subtest: framebuffer-vs-set-tiling
[386.225819] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[386.361815] [112/156] (635s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[386.439581] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[386.443676] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[386.545421] [113/156] (635s left) kms_flip (busy-flip)
[386.627463] Starting subtest: busy-flip
[386.629511] Starting dynamic subtest: A-eDP1
[388.371088] Dynamic subtest A-eDP1: SUCCESS (1.744s)
[388.382558] Starting dynamic subtest: B-eDP1
[390.101556] Dynamic subtest B-eDP1: SUCCESS (1.728s)
[390.114310] Starting dynamic subtest: C-eDP1
[391.821596] Dynamic subtest C-eDP1: SUCCESS (1.719s)
[391.833186] Starting dynamic subtest: D-eDP1
[393.475261] Dynamic subtest D-eDP1: SUCCESS (1.653s)
[393.477492] Subtest busy-flip: SUCCESS (6.852s)
[394.640846] [114/156] (627s left) syncobj_timeline (host-signal-points)
[394.705156] Starting subtest: host-signal-points
[394.710245] Subtest host-signal-points: SUCCESS (0.005s)
[394.831172] [115/156] (627s left) prime_busy (after)
[394.886893] Starting subtest: after
[394.892775] Starting dynamic subtest: rcs0
[394.927239] Dynamic subtest rcs0: SUCCESS (0.037s)
[394.939606] Starting dynamic subtest: bcs0
[394.980355] Dynamic subtest bcs0: SUCCESS (0.052s)
[394.991490] Starting dynamic subtest: vcs0
[395.019909] Dynamic subtest vcs0: SUCCESS (0.039s)
[395.029964] Starting dynamic subtest: vcs1
[395.059971] Dynamic subtest vcs1: SUCCESS (0.039s)
[395.069936] Starting dynamic subtest: vecs0
[395.099866] Dynamic subtest vecs0: SUCCESS (0.039s)
[395.110345] Starting dynamic subtest: ccs0
[395.140116] Dynamic subtest ccs0: SUCCESS (0.039s)
[395.248216] Subtest after: SUCCESS (0.359s)
[395.331350] [116/156] (627s left) gem_exec_schedule (pi-distinct-iova)
[395.525453] Starting subtest: pi-distinct-iova
[395.527742] Starting dynamic subtest: rcs0
[395.603751] Dynamic subtest rcs0: SUCCESS (0.082s)
[395.614385] Starting dynamic subtest: vcs0
[395.662280] Dynamic subtest vcs0: SUCCESS (0.056s)
[395.673121] Starting dynamic subtest: vcs1
[395.720779] Dynamic subtest vcs1: SUCCESS (0.057s)
[395.734038] Starting dynamic subtest: vecs0
[395.776024] Dynamic subtest vecs0: SUCCESS (0.055s)
[395.789244] Starting dynamic subtest: ccs0
[395.843871] Dynamic subtest ccs0: SUCCESS (0.066s)
[395.846368] Subtest pi-distinct-iova: SUCCESS (0.325s)
[397.177398] [117/156] (625s left) kms_psr (psr2-primary-mmap-cpu)
[397.265244] Starting subtest: psr2-primary-mmap-cpu
[397.267498] Starting dynamic subtest: eDP-1
[399.030273] Dynamic subtest eDP-1: SUCCESS (1.764s)
[399.032721] Subtest psr2-primary-mmap-cpu: SUCCESS (1.765s)
[399.904238] [118/156] (622s left) gem_exec_flush (basic-wb-pro-default)
[399.965839] Starting subtest: basic-wb-pro-default
[405.420906] Subtest basic-wb-pro-default: SUCCESS (5.455s)
[405.609199] [119/156] (616s left) fbdev (info)
[405.651283] Starting subtest: info
[405.653355] Subtest info: SUCCESS (0.000s)
[405.733316] [120/156] (616s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-pwrite)
[405.812193] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-pwrite
[405.816715] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[405.905213] [121/156] (616s left) gem_softpin (softpin)
[405.967448] Starting subtest: softpin
[438.308452] Subtest softpin: SUCCESS (32.336s)
[438.415638] [122/156] (584s left) i915_module_load (reload)
[438.453971] Starting subtest: reload
[444.511482] Subtest reload: SUCCESS (6.062s)
[444.553069] [123/156] (578s left) kms_frontbuffer_tracking (fbchdr-2p-shrfb-fliptrack-mmap-gtt)
[446.056741] Starting subtest: fbchdr-2p-shrfb-fliptrack-mmap-gtt
[446.060800] Subtest fbchdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[446.132809] [124/156] (576s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[446.222060] Starting subtest: 4-tiled-32bpp-rotate-270
[446.254596] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.032s)
[446.362952] [125/156] (576s left) gem_ctx_isolation (clean)
[446.423800] Starting subtest: clean
[446.426150] Starting dynamic subtest: rcs0
[446.483018] Dynamic subtest rcs0: SUCCESS (0.059s)
[446.493340] Starting dynamic subtest: bcs0
[446.525164] Dynamic subtest bcs0: SUCCESS (0.041s)
[446.534750] Starting dynamic subtest: vcs0
[446.590210] Dynamic subtest vcs0: SUCCESS (0.064s)
[446.600259] Starting dynamic subtest: vcs1
[448.099814] Dynamic subtest vcs1: SUCCESS (1.508s)
[448.110226] Starting dynamic subtest: vecs0
[450.174366] Dynamic subtest vecs0: SUCCESS (2.073s)
[450.185935] Starting dynamic subtest: ccs0
[452.157335] Dynamic subtest ccs0: SUCCESS (1.982s)
[452.159951] Subtest clean: SUCCESS (5.733s)
[452.389357] [126/156] (570s left) kms_invalid_mode (int-max-clock)
[452.473984] Starting subtest: int-max-clock
[452.476271] Starting dynamic subtest: pipe-A-eDP-1
[452.764449] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[452.776822] Starting dynamic subtest: pipe-B-eDP-1
[452.778682] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[452.788106] Starting dynamic subtest: pipe-C-eDP-1
[452.790260] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[452.802899] Starting dynamic subtest: pipe-D-eDP-1
[452.805455] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[452.807690] Subtest int-max-clock: SUCCESS (0.296s)
[453.592457] [127/156] (569s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[453.637789] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[453.746377] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s)
[453.833063] [128/156] (569s left) gem_create (create-ext-placement-each)
[453.999902] Starting subtest: create-ext-placement-each
[454.002685] Subtest create-ext-placement-each: SUCCESS (0.000s)
[454.086212] [129/156] (568s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[454.157719] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[454.160153] Starting dynamic subtest: pipe-A
[454.222087] Dynamic subtest pipe-A: SUCCESS (0.066s)
[454.232837] Starting dynamic subtest: pipe-B
[455.412384] Dynamic subtest pipe-B: SUCCESS (1.189s)
[455.422456] Starting dynamic subtest: pipe-C
[456.526838] Dynamic subtest pipe-C: SUCCESS (1.114s)
[456.537515] Starting dynamic subtest: pipe-D
[457.662255] Dynamic subtest pipe-D: SUCCESS (1.134s)
[457.664652] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.508s)
[458.824175] [130/156] (564s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[458.907164] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[458.916749] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.008s)
[459.006368] [131/156] (564s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[459.100661] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[465.858878] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.764s)
[466.010459] [132/156] (557s left) gem_fence_thrash (bo-copy)
[466.053298] Starting subtest: bo-copy
[466.075414] Subtest bo-copy: SKIP (0.020s)
[466.141786] [133/156] (556s left) gem_userptr_blits (access-control)
[466.220592] Starting subtest: access-control
[466.224762] Subtest access-control: SKIP (0.000s)
[466.341774] [134/156] (556s left) kms_flip (2x-flip-vs-suspend)
[466.421635] Starting subtest: 2x-flip-vs-suspend
[466.426099] Subtest 2x-flip-vs-suspend: SKIP (0.001s)
[466.536427] [135/156] (556s left) drm_read (empty-nonblock)
[466.668283] Starting subtest: empty-nonblock
[466.670625] Subtest empty-nonblock: SUCCESS (0.000s)
[466.795786] [136/156] (556s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[466.890575] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[498.581770] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.687s)
[499.395008] [137/156] (523s left) kms_cursor_legacy (single-bo)
[499.496409] Starting subtest: single-bo
[499.498631] Starting dynamic subtest: pipe-A
[504.879449] Dynamic subtest pipe-A: SUCCESS (5.378s)
[504.892170] Starting dynamic subtest: pipe-B
[510.262573] Dynamic subtest pipe-B: SUCCESS (5.379s)
[510.279233] Starting dynamic subtest: pipe-C
[515.643907] Dynamic subtest pipe-C: SUCCESS (5.378s)
[515.660857] Starting dynamic subtest: pipe-D
[521.025136] Dynamic subtest pipe-D: SUCCESS (5.378s)
[521.037657] Starting dynamic subtest: all-pipes
[526.412985] Dynamic subtest all-pipes: SUCCESS (5.385s)
[526.415512] Subtest single-bo: SUCCESS (26.913s)
[526.557541] [138/156] (496s left) kms_color (legacy-gamma)
[526.646627] Starting subtest: legacy-gamma
[526.648988] Starting dynamic subtest: pipe-A-eDP-1
[527.374617] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.729s)
[527.384324] Starting dynamic subtest: pipe-B-eDP-1
[528.823236] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.446s)
[528.833632] Starting dynamic subtest: pipe-C-eDP-1
[530.173413] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.349s)
[530.183359] Starting dynamic subtest: pipe-D-eDP-1
[531.501228] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[531.503601] Subtest legacy-gamma: SUCCESS (4.856s)
[532.325057] [139/156] (491s left) api_intel_bb (destroy-bb)
[532.386386] Starting subtest: destroy-bb
[532.393038] Subtest destroy-bb: SUCCESS (0.007s)
[532.521864] [140/156] (490s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[532.596027] Starting subtest: pr-cursor-plane-move-continuous-sf
[532.600127] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[532.661376] [141/156] (490s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[532.746645] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[532.751236] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[532.840024] [142/156] (490s left) gem_exec_store (pages)
[532.903611] Starting subtest: pages
[532.906049] Starting dynamic subtest: rcs0
[533.005373] Dynamic subtest rcs0: SUCCESS (0.104s)
[533.015955] Starting dynamic subtest: bcs0
[533.082398] Dynamic subtest bcs0: SUCCESS (0.075s)
[533.092078] Starting dynamic subtest: vcs0
[533.153495] Dynamic subtest vcs0: SUCCESS (0.070s)
[533.163137] Starting dynamic subtest: vcs1
[533.228967] Dynamic subtest vcs1: SUCCESS (0.074s)
[533.238705] Starting dynamic subtest: vecs0
[533.311569] Dynamic subtest vecs0: SUCCESS (0.082s)
[533.322038] Starting dynamic subtest: ccs0
[533.389284] Dynamic subtest ccs0: SUCCESS (0.076s)
[533.391425] Subtest pages: SUCCESS (0.490s)
[533.575613] [143/156] (489s left) gem_exec_schedule (semaphore-power)
[533.756740] Subtest semaphore-power: SKIP (0.000s)
[533.932537] [144/156] (489s left) prime_vgem (basic-fence-flip)
[534.004007] Starting subtest: basic-fence-flip
[534.283049] Subtest basic-fence-flip: SUCCESS (0.279s)
[534.387454] [145/156] (489s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[534.465844] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[534.469876] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[534.566006] [146/156] (489s left) gem_mmap_offset (bad-extensions)
[534.623090] Starting subtest: bad-extensions
[534.625315] Subtest bad-extensions: SUCCESS (0.000s)
[534.718913] [147/156] (488s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[534.802058] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[534.805976] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[534.900474] [148/156] (488s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[534.983284] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[539.521147] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.546s)
[540.737008] [149/156] (483s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[540.814329] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[548.135156] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.325s)
[548.272686] [150/156] (475s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[548.357742] Starting subtest: cursor-tearing-framebuffer-change
[548.359674] Starting dynamic subtest: pipe-A-eDP-1
[548.924323] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.566s)
[548.935424] Starting dynamic subtest: pipe-D-eDP-1
[550.167295] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.243s)
[550.169693] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.812s)
[551.009010] [151/156] (472s left) perf (invalid-remove-userspace-config)
[551.154184] Starting subtest: invalid-remove-userspace-config
[551.159647] Subtest invalid-remove-userspace-config: SUCCESS (0.007s)
[551.211098] [152/156] (472s left) kms_psr (psr-sprite-blt)
[551.280956] Starting subtest: psr-sprite-blt
[551.283293] Starting dynamic subtest: eDP-1
[553.032561] Dynamic subtest eDP-1: SUCCESS (1.750s)
[553.034770] Subtest psr-sprite-blt: SUCCESS (1.751s)
[553.892382] [153/156] (470s left) gem_exec_fence (submit-chain)
[554.073364] Starting subtest: submit-chain
[554.088644] Subtest submit-chain: SUCCESS (0.018s)
[556.192157] [154/156] (467s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-render)
[556.287585] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-render
[556.291656] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[556.387663] [155/156] (467s left) gem_lmem_swapping (random-engines)
[556.430779] Subtest random-engines: SKIP (0.000s)
[556.480938] [156/156] (467s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[556.559849] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[556.562057] Starting dynamic subtest: pipe-A-eDP-1
[556.584451] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[556.597703] Starting dynamic subtest: pipe-B-eDP-1
[556.619133] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[556.628820] Starting dynamic subtest: pipe-C-eDP-1
[556.650522] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[556.659838] Starting dynamic subtest: pipe-D-eDP-1
[556.681793] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[556.685948] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[558.835007] Closing watchdogs
results: parsing output: 0/ for test: gem_render_linear_blits
results: parsing output: 1/ for test: gem_userptr_blits
results: parsing output: 2/ for test: gem_exec_params
results: parsing output: 3/ for test: gem_exec_endless
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: gem_render_copy
results: parsing output: 6/ for test: kms_pipe_crc_basic
results: parsing output: 7/ for test: perf_pmu
results: parsing output: 8/ for test: sysfs_timeslice_duration
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_chamelium_color
results: parsing output: 11/ for test: kms_vblank
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: kms_draw_crc
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: sw_sync
results: parsing output: 19/ for test: kms_psr2_sf
results: parsing output: 20/ for test: gem_vm_create
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: gem_pxp
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_plane
results: parsing output: 29/ for test: i915_suspend
results: parsing output: 30/ for test: gem_mmap_wc
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_properties
results: parsing output: 33/ for test: kms_pm_rpm
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_chamelium_hpd
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_addfb_basic
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_set_tiling_vs_blt
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: kms_flip_scaled_crc
results: parsing output: 42/ for test: kms_async_flips
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_flip_scaled_crc
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: gem_ctx_persistence
results: parsing output: 51/ for test: gen7_exec_parse
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_atomic_transition
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_softpin
results: parsing output: 57/ for test: gem_ctx_param
results: parsing output: 58/ for test: kms_chamelium_frames
results: parsing output: 59/ for test: gem_exec_flush
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_hdr
results: parsing output: 62/ for test: kms_plane_lowres
results: parsing output: 63/ for test: kms_addfb_basic
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_content_protection
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_exec_balancer
results: parsing output: 71/ for test: kms_pm_dc
results: parsing output: 72/ for test: gem_huc_copy
results: parsing output: 73/ for test: kms_selftest
results: parsing output: 74/ for test: gem_eio
results: parsing output: 75/ for test: gem_exec_fence
results: parsing output: 76/ for test: gem_mmap_wc
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: api_intel_allocator
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_lease
results: parsing output: 83/ for test: kms_properties
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gen9_exec_parse
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: gem_ppgtt
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: perf_pmu
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: prime_udl
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_mmap_wc
results: parsing output: 102/ for test: i915_pm_rps
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: gem_userptr_blits
results: parsing output: 107/ for test: prime_mmap
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: core_setmaster
results: parsing output: 110/ for test: kms_addfb_basic
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: prime_busy
results: parsing output: 115/ for test: gem_exec_schedule
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: gem_exec_flush
results: parsing output: 118/ for test: fbdev
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_softpin
results: parsing output: 121/ for test: i915_module_load
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_ctx_isolation
results: parsing output: 125/ for test: kms_invalid_mode
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: gem_create
results: parsing output: 128/ for test: kms_plane_scaling
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_fence_thrash
results: parsing output: 132/ for test: gem_userptr_blits
results: parsing output: 133/ for test: kms_flip
results: parsing output: 134/ for test: drm_read
results: parsing output: 135/ for test: kms_cursor_legacy
results: parsing output: 136/ for test: kms_cursor_legacy
results: parsing output: 137/ for test: kms_color
results: parsing output: 138/ for test: api_intel_bb
results: parsing output: 139/ for test: kms_psr2_sf
results: parsing output: 140/ for test: kms_big_fb
results: parsing output: 141/ for test: gem_exec_store
results: parsing output: 142/ for test: gem_exec_schedule
results: parsing output: 143/ for test: prime_vgem
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: gem_mmap_offset
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_cursor_crc
results: parsing output: 150/ for test: perf
results: parsing output: 151/ for test: kms_psr
results: parsing output: 152/ for test: gem_exec_fence
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: gem_lmem_swapping
results: parsing output: 155/ for test: kms_ccs
Done.