[94.141364] Initializing watchdogs
[94.141567]   /dev/watchdog0
[94.183528] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[94.198549] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[94.205527] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[94.214357] [001/156] (960s left) kms_big_fb (x-tiled-addfb-size-overflow)
[94.458451] Starting subtest: x-tiled-addfb-size-overflow
[94.462131] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.002s)
[94.612628] [002/156] (960s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[94.832209] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[95.606056] Subtest hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SUCCESS (0.775s)
[95.936821] [003/156] (958s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-blt)
[96.159986] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-blt
[97.349260] Subtest hdr-2p-scndscrn-pri-indfb-draw-blt: SUCCESS (1.191s)
[97.531701] [004/156] (957s left) gem_flink_basic (bad-open)
[97.650592] Starting subtest: bad-open
[97.655993] Subtest bad-open: SUCCESS (0.000s)
[97.790533] [005/156] (957s left) kms_chamelium_frames (vga-frame-dump)
[98.399602] Subtest vga-frame-dump: SKIP (0.000s)
[98.770264] [006/156] (956s left) kms_draw_crc (draw-method-pwrite)
[98.982277] Starting subtest: draw-method-pwrite
[98.986487] Starting dynamic subtest: xrgb8888-untiled
[99.471096] Dynamic subtest xrgb8888-untiled: SUCCESS (0.488s)
[99.502496] Starting dynamic subtest: rgb565-untiled
[99.736080] Dynamic subtest rgb565-untiled: SUCCESS (0.266s)
[99.771788] Starting dynamic subtest: xrgb2101010-untiled
[100.018793] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.283s)
[100.042817] Starting dynamic subtest: xbgr16161616f-untiled
[100.301413] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.283s)
[100.322729] Starting dynamic subtest: xrgb8888-xtiled
[100.605179] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.300s)
[100.626730] Starting dynamic subtest: rgb565-xtiled
[100.919454] Dynamic subtest rgb565-xtiled: SUCCESS (0.313s)
[100.940445] Starting dynamic subtest: xrgb2101010-xtiled
[101.201779] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.280s)
[101.222906] Starting dynamic subtest: xbgr16161616f-xtiled
[101.503325] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.299s)
[101.523739] Starting dynamic subtest: xrgb8888-ytiled
[102.020960] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.517s)
[102.042051] Starting dynamic subtest: rgb565-ytiled
[102.503136] Dynamic subtest rgb565-ytiled: SUCCESS (0.482s)
[102.523492] Starting dynamic subtest: xrgb2101010-ytiled
[103.001704] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.498s)
[103.023686] Starting dynamic subtest: xbgr16161616f-ytiled
[103.551105] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.549s)
[103.555937] Subtest draw-method-pwrite: SUCCESS (4.572s)
[103.833209] [007/156] (951s left) gem_flink_basic (basic)
[103.949828] Starting subtest: basic
[103.953299] Subtest basic: SUCCESS (0.000s)
[104.094616] [008/156] (951s left) kms_cursor_crc (cursor-offscreen-32x32)
[104.300427] Starting subtest: cursor-offscreen-32x32
[104.535116] Subtest cursor-offscreen-32x32: SKIP (0.232s)
[104.696309] [009/156] (950s left) kms_getfb (getfb-handle-valid)
[104.885161] Starting subtest: getfb-handle-valid
[104.889101] Subtest getfb-handle-valid: SUCCESS (0.000s)
[105.028189] [010/156] (950s left) kms_psr (pr-primary-blt)
[105.222175] Subtest pr-primary-blt: SKIP (0.000s)
[105.333188] [011/156] (950s left) kms_color_pipeline (plane-lut1d)
[105.528737] Starting subtest: plane-lut1d
[107.167320] Subtest plane-lut1d: SKIP (1.628s)
[107.525818] [012/156] (948s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[107.755872] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[107.762647] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[107.894993] [013/156] (948s left) gem_exec_reloc (basic-cpu-active)
[108.036718] Starting subtest: basic-cpu-active
[108.179458] Subtest basic-cpu-active: SUCCESS (0.146s)
[108.394783] [014/156] (947s left) gem_exec_reloc (basic-wc-cpu)
[108.525977] Starting subtest: basic-wc-cpu
[108.544155] Subtest basic-wc-cpu: SUCCESS (0.019s)
[108.760530] [015/156] (947s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[108.948273] Starting subtest: primary-y-tiled-reflect-x-270
[108.957507] Subtest primary-y-tiled-reflect-x-270: SKIP (0.002s)
[109.094470] [016/156] (947s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[109.303930] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[109.312082] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[109.443651] [017/156] (946s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[109.640905] Starting subtest: addfb25-y-tiled-small-legacy
[109.644614] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s)
[109.793715] [018/156] (946s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[110.007424] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc
[110.796519] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (0.788s)
[111.105622] [019/156] (945s left) kms_frontbuffer_tracking (hdr-1p-pri-indfb-multidraw)
[111.326207] Starting subtest: hdr-1p-pri-indfb-multidraw
[114.261414] Subtest hdr-1p-pri-indfb-multidraw: SUCCESS (2.934s)
[114.574301] [020/156] (942s left) kms_chamelium_hpd (common-hpd-after-suspend)
[115.305826] Subtest common-hpd-after-suspend: SKIP (0.000s)
[115.953460] [021/156] (941s left) kms_pm_backlight (fade)
[116.587590] Subtest fade: SKIP (0.000s)
[116.676483] [022/156] (940s left) gem_exec_params (secure-non-root)
[116.807222] Starting subtest: secure-non-root
[116.814301] Subtest secure-non-root: SKIP (0.000s)
[116.977469] [023/156] (940s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[117.176208] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[119.803647] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.630s)
[120.098575] [024/156] (937s left) kms_plane (pixel-format-y-tiled-modifier)
[120.293413] Starting subtest: pixel-format-y-tiled-modifier
[120.519229] Starting dynamic subtest: pipe-A-plane-0
[121.051812] Dynamic subtest pipe-A-plane-0: SUCCESS (0.533s)
[121.074663] Starting dynamic subtest: pipe-A-plane-1
[121.569599] Dynamic subtest pipe-A-plane-1: SUCCESS (0.516s)
[121.592100] Starting dynamic subtest: pipe-A-plane-2
[122.070555] Dynamic subtest pipe-A-plane-2: SUCCESS (0.500s)
[122.092597] Starting dynamic subtest: pipe-A-plane-3
[122.552425] Dynamic subtest pipe-A-plane-3: SUCCESS (0.481s)
[122.576547] Starting dynamic subtest: pipe-A-plane-4
[122.588083] Dynamic subtest pipe-A-plane-4: SKIP (0.000s)
[122.951656] Starting dynamic subtest: pipe-B-plane-0
[123.415845] Dynamic subtest pipe-B-plane-0: SUCCESS (0.483s)
[123.439147] Starting dynamic subtest: pipe-B-plane-1
[123.932475] Dynamic subtest pipe-B-plane-1: SUCCESS (0.514s)
[123.955051] Starting dynamic subtest: pipe-B-plane-2
[124.401484] Dynamic subtest pipe-B-plane-2: SUCCESS (0.466s)
[124.423409] Starting dynamic subtest: pipe-B-plane-3
[124.866459] Dynamic subtest pipe-B-plane-3: SUCCESS (0.465s)
[124.896687] Starting dynamic subtest: pipe-B-plane-4
[124.910862] Dynamic subtest pipe-B-plane-4: SKIP (0.000s)
[125.102338] Subtest pixel-format-y-tiled-modifier: SUCCESS (4.812s)
[125.464462] [025/156] (932s left) kms_getfb (getfb-handle-not-fb)
[125.674722] Starting subtest: getfb-handle-not-fb
[125.678103] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[125.826480] [026/156] (931s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-pgflip-blt)
[126.043636] Starting subtest: fbchdr-2p-scndscrn-shrfb-pgflip-blt
[127.333404] Subtest fbchdr-2p-scndscrn-shrfb-pgflip-blt: SUCCESS (1.285s)
[127.533789] [027/156] (930s left) gem_exec_schedule (u-independent)
[127.706769] Starting subtest: u-independent
[127.715111] Starting dynamic subtest: rcs0
[127.899139] Dynamic subtest rcs0: SUCCESS (0.210s)
[127.945865] Starting dynamic subtest: bcs0
[128.113369] Dynamic subtest bcs0: SUCCESS (0.199s)
[128.160829] Starting dynamic subtest: vcs0
[128.273679] Dynamic subtest vcs0: SUCCESS (0.171s)
[128.318478] Starting dynamic subtest: vecs0
[128.437781] Dynamic subtest vecs0: SUCCESS (0.161s)
[128.441540] Subtest u-independent: SUCCESS (0.751s)
[128.842664] [028/156] (928s left) i915_module_load (resize-bar)
[128.956453] Starting subtest: resize-bar
[128.973699] Subtest resize-bar: SKIP (0.019s)
[129.087660] [029/156] (928s left) gem_pwrite (basic-self)
[129.199972] Starting subtest: basic-self
[129.405075] Subtest basic-self: SUCCESS (0.209s)
[129.561660] [030/156] (928s left) gem_ctx_freq (sysfs)
[129.689643] Starting subtest: sysfs
[129.693092] Starting dynamic subtest: gt0
[134.592708] Dynamic subtest gt0: SUCCESS (4.905s)
[134.596952] Subtest sysfs: SUCCESS (4.907s)
[134.746409] [031/156] (923s left) gem_ccs (large-ctrl-surf-copy)
[134.872235] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[134.986370] [032/156] (923s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[135.196667] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[138.018084] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (2.831s)
[138.314629] [033/156] (919s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[138.528202] Starting subtest: fbcpsr-rgb565-draw-pwrite
[138.535280] Subtest fbcpsr-rgb565-draw-pwrite: SKIP (0.000s)
[138.682870] [034/156] (919s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[138.880273] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s)
[138.989539] [035/156] (919s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[141.002686] Starting subtest: gem-execbuf-stress-pc8
[141.059243] Subtest gem-execbuf-stress-pc8: SKIP (0.052s)
[141.486822] [036/156] (917s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[141.710315] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[144.166577] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SUCCESS (2.463s)
[144.375745] [037/156] (914s left) kms_flip (2x-flip-vs-panning-interruptible)
[144.589705] Starting subtest: 2x-flip-vs-panning-interruptible
[144.599146] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[155.443770] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.844s)
[155.475380] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[166.220064] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.770s)
[166.249814] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[176.987152] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.752s)
[176.992063] Subtest 2x-flip-vs-panning-interruptible: SUCCESS (32.394s)
[177.660228] [038/156] (881s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-msflip-blt)
[177.881639] Starting subtest: fbchdr-2p-primscrn-indfb-msflip-blt
[179.047489] Subtest fbchdr-2p-primscrn-indfb-msflip-blt: SUCCESS (1.171s)
[179.253223] [039/156] (879s left) kms_big_fb (linear-32bpp-rotate-270)
[179.469632] Starting subtest: linear-32bpp-rotate-270
[180.041075] Subtest linear-32bpp-rotate-270: SKIP (0.562s)
[180.307490] [040/156] (878s left) gem_mmap_gtt (big-copy-xy)
[180.422577] Starting subtest: big-copy-XY
[191.785103] Subtest big-copy-XY: SUCCESS (11.365s)
[191.963846] [041/156] (867s left) kms_flip (2x-flip-vs-fences-interruptible)
[192.326518] Starting subtest: 2x-flip-vs-fences-interruptible
[192.335652] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[203.268811] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.931s)
[203.303556] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[214.181662] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.902s)
[214.212735] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[224.968741] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.781s)
[224.974624] Subtest 2x-flip-vs-fences-interruptible: SUCCESS (32.640s)
[225.623341] [042/156] (833s left) gem_exec_balancer (hog)
[225.768288] Starting subtest: hog
[230.148216] Subtest hog: SUCCESS (4.381s)
[230.441256] [043/156] (828s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[230.641072] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[230.644781] Starting dynamic subtest: pipe-A-HDMI-A-1
[230.661068] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[230.709094] Starting dynamic subtest: pipe-A-HDMI-A-2
[230.727865] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[230.775193] Starting dynamic subtest: pipe-B-HDMI-A-1
[230.793881] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[230.818764] Starting dynamic subtest: pipe-B-HDMI-A-2
[230.831110] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[230.855969] Starting dynamic subtest: pipe-C-HDMI-A-1
[230.868380] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[230.893162] Starting dynamic subtest: pipe-C-HDMI-A-2
[230.906063] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[230.912394] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.036s)
[231.740747] [044/156] (827s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[231.947357] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[231.953475] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[232.096380] [045/156] (827s left) kms_content_protection (legacy-hdcp14)
[232.315665] Starting subtest: legacy-hdcp14
[232.342243] Subtest legacy-hdcp14: SKIP (0.012s)
[232.492619] [046/156] (827s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[232.635559] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[232.640545] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.003s)
[232.791733] [047/156] (826s left) kms_cursor_crc (cursor-sliding-64x64)
[233.003900] Starting subtest: cursor-sliding-64x64
[233.075715] Starting dynamic subtest: pipe-A-HDMI-A-1
[237.095103] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.018s)
[237.214634] Starting dynamic subtest: pipe-C-HDMI-A-1
[240.936146] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.761s)
[240.939934] Subtest cursor-sliding-64x64: SUCCESS (7.931s)
[241.347802] [048/156] (818s left) dumb_buffer (create-clear)
[241.466260] Starting subtest: create-clear
[275.742240] Subtest create-clear: SUCCESS (34.276s)
[275.935495] [049/156] (783s left) i915_drm_fdinfo (all-busy-idle-check-all)
[276.055276] Starting subtest: all-busy-idle-check-all
[276.679908] Subtest all-busy-idle-check-all: SUCCESS (0.625s)
[276.827178] [050/156] (783s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[277.033543] Starting subtest: 2x-long-flip-vs-cursor-legacy
[282.608079] Subtest 2x-long-flip-vs-cursor-legacy: SUCCESS (5.577s)
[282.958428] [051/156] (777s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[283.161880] Starting subtest: flip-vs-cursor-atomic-transitions
[297.709283] Subtest flip-vs-cursor-atomic-transitions: FAIL (13.560s)
[297.803878] [052/156] (762s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[298.013628] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[298.018518] Starting dynamic subtest: pipe-A-HDMI-A-1
[298.200253] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.012s)
[298.249316] Starting dynamic subtest: pipe-A-HDMI-A-2
[298.389364] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.012s)
[298.414322] Starting dynamic subtest: pipe-B-HDMI-A-1
[298.548867] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.013s)
[298.573758] Starting dynamic subtest: pipe-B-HDMI-A-2
[298.758424] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.012s)
[298.808394] Starting dynamic subtest: pipe-C-HDMI-A-1
[298.937036] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.013s)
[298.961706] Starting dynamic subtest: pipe-C-HDMI-A-2
[299.093923] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.012s)
[299.099445] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.111s)
[299.233773] [053/156] (761s left) kms_prop_blob (blob-prop-lifetime)
[299.354076] Starting subtest: blob-prop-lifetime
[299.358154] Subtest blob-prop-lifetime: SUCCESS (0.002s)
[299.503777] [054/156] (760s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[299.690270] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[299.698684] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[299.839126] [055/156] (760s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[300.067150] Starting subtest: yf-tiled-8bpp-rotate-0
[300.074727] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[300.222292] [056/156] (760s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-render)
[300.446131] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-render
[301.674075] Subtest hdr-2p-primscrn-spr-indfb-draw-render: SUCCESS (1.230s)
[301.895056] [057/156] (758s left) gem_spin_batch (spin-all-new)
[302.041940] Starting subtest: spin-all-new
[302.078244] Subtest spin-all-new: SUCCESS (0.033s)
[302.830705] [058/156] (758s left) gem_mmap_gtt (cpuset-basic-small-copy)
[303.425926] Starting subtest: cpuset-basic-small-copy
[307.007985] Subtest cpuset-basic-small-copy: SUCCESS (3.871s)
[307.177948] [059/156] (754s left) gem_exec_whisper (basic-contexts-all)
[307.466177] Starting subtest: basic-contexts-all
[318.499088] Subtest basic-contexts-all: SUCCESS (11.033s)
[318.788236] [060/156] (742s left) gem_mmap_offset (blt-coherency)
[318.911217] Starting subtest: blt-coherency
[318.924357] Subtest blt-coherency: SUCCESS (0.018s)
[319.084202] [061/156] (742s left) kms_pipe_crc_basic (read-crc)
[319.296896] Starting subtest: read-crc
[319.301247] Starting dynamic subtest: pipe-A-HDMI-A-1
[320.525277] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.229s)
[320.564858] Starting dynamic subtest: pipe-B-HDMI-A-2
[321.210465] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.677s)
[321.255156] Starting dynamic subtest: pipe-C-HDMI-A-1
[321.909508] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.690s)
[321.912949] Subtest read-crc: SUCCESS (2.618s)
[322.252646] [062/156] (739s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[322.468572] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[322.475112] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[322.619432] [063/156] (739s left) kms_getfb (getfb2-handle-not-fb)
[322.815882] Starting subtest: getfb2-handle-not-fb
[322.820300] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[322.967516] [064/156] (738s left) gem_exec_fence (syncobj-timeline-chain-engines)
[323.791636] Starting subtest: syncobj-timeline-chain-engines
[323.916788] Subtest syncobj-timeline-chain-engines: SUCCESS (0.131s)
[324.219757] [FACT gem_exec_fence (syncobj-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[324.228195] [065/156] (737s left) api_intel_allocator (default-alignment)
[324.350143] Starting subtest: default-alignment
[324.355113] Subtest default-alignment: SUCCESS (0.005s)
[324.525881] [066/156] (737s left) kms_flip (2x-blocking-wf_vblank)
[324.720495] Starting subtest: 2x-blocking-wf_vblank
[324.734467] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[335.904954] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.177s)
[335.939490] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[346.987082] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (11.074s)
[347.019265] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[358.182028] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (11.182s)
[358.187483] Subtest 2x-blocking-wf_vblank: SUCCESS (33.462s)
[358.838300] [067/156] (703s left) kms_lease (lease-again)
[359.045145] Starting subtest: lease-again
[359.052144] Starting dynamic subtest: pipe-A-HDMI-A-1
[359.058126] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.018s)
[359.148469] Starting dynamic subtest: pipe-A-HDMI-A-2
[359.152631] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.005s)
[359.195110] Starting dynamic subtest: pipe-B-HDMI-A-1
[359.199081] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.006s)
[359.259215] Starting dynamic subtest: pipe-B-HDMI-A-2
[359.262669] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.010s)
[359.288629] Starting dynamic subtest: pipe-C-HDMI-A-1
[359.291777] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.008s)
[359.318500] Starting dynamic subtest: pipe-C-HDMI-A-2
[359.321579] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.007s)
[359.324756] Subtest lease-again: SUCCESS (0.136s)
[359.427306] [068/156] (702s left) syncobj_timeline (wait-delayed-signal)
[359.543689] Starting subtest: wait-delayed-signal
[359.646761] Subtest wait-delayed-signal: SUCCESS (0.107s)
[359.839341] [069/156] (702s left) gem_mmap_gtt (basic-write-read-distinct)
[359.956180] Starting subtest: basic-write-read-distinct
[359.961097] Subtest basic-write-read-distinct: SUCCESS (0.009s)
[360.128429] [070/156] (702s left) kms_force_connector_basic (force-edid)
[360.439082] Starting subtest: force-edid
[360.636023] Subtest force-edid: SUCCESS (0.196s)
[361.027667] [071/156] (701s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[361.260519] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[361.268445] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[361.426685] [072/156] (701s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[361.661294] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[361.667755] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[361.826559] [073/156] (701s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-render)
[362.053269] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-render
[362.059672] Subtest psrhdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[362.224924] [074/156] (700s left) gem_ringfill (engines-basic)
[362.631069] Starting subtest: engines-basic
[362.635180] Starting dynamic subtest: rcs0
[362.656440] Dynamic subtest rcs0: SUCCESS (0.021s)
[362.711318] Starting dynamic subtest: bcs0
[362.714892] Dynamic subtest bcs0: SUCCESS (0.035s)
[362.753503] Starting dynamic subtest: vcs0
[362.760411] Dynamic subtest vcs0: SUCCESS (0.023s)
[362.788077] Starting dynamic subtest: vecs0
[362.791185] Dynamic subtest vecs0: SUCCESS (0.027s)
[362.794304] Subtest engines-basic: SUCCESS (0.126s)
[362.930338] [075/156] (700s left) prime_vgem (basic-gtt)
[363.071734] Starting subtest: basic-gtt
[363.110770] Subtest basic-gtt: SUCCESS (0.040s)
[363.278933] [076/156] (699s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[363.396196] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[363.504499] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.110s)
[363.688564] [077/156] (699s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[363.914117] Starting subtest: y-tiled-32bpp-rotate-90
[369.217789] Subtest y-tiled-32bpp-rotate-90: SUCCESS (5.305s)
[369.689418] [078/156] (693s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-pgflip-blt)
[369.918322] Starting subtest: psrhdr-2p-scndscrn-indfb-pgflip-blt
[369.925375] Subtest psrhdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[370.080242] [079/156] (693s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[370.289857] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[370.420377] [080/156] (693s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[370.630580] Starting subtest: 2x-long-cursor-vs-flip-legacy
[423.028893] Subtest 2x-long-cursor-vs-flip-legacy: SUCCESS (52.395s)
[423.434033] [081/156] (640s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[423.671315] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[423.675310] Starting dynamic subtest: pipe-A-HDMI-A-1
[423.720277] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[423.774481] Starting dynamic subtest: pipe-A-HDMI-A-2
[423.824343] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[423.876667] Starting dynamic subtest: pipe-B-HDMI-A-1
[423.908400] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[423.936591] Starting dynamic subtest: pipe-B-HDMI-A-2
[423.968596] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[423.995257] Starting dynamic subtest: pipe-C-HDMI-A-1
[424.026101] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[424.053470] Starting dynamic subtest: pipe-C-HDMI-A-2
[424.085115] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[424.091027] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SKIP (0.041s)
[425.185269] [082/156] (638s left) kms_flip (flip-vs-panning-vs-hang)
[425.718325] Starting subtest: flip-vs-panning-vs-hang
[425.787632] Starting dynamic subtest: A-HDMI-A1
[438.666172] Dynamic subtest A-HDMI-A1: SUCCESS (13.159s)
[438.695048] Starting dynamic subtest: C-HDMI-A1
[451.639302] Dynamic subtest C-HDMI-A1: SUCCESS (12.967s)
[451.670077] Starting dynamic subtest: A-HDMI-A2
[465.681724] Dynamic subtest A-HDMI-A2: SUCCESS (14.037s)
[465.711146] Starting dynamic subtest: C-HDMI-A2
[478.652864] Dynamic subtest C-HDMI-A2: SUCCESS (12.967s)
[478.657229] Subtest flip-vs-panning-vs-hang: SUCCESS (53.152s)
[479.213606] [083/156] (585s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[479.435024] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[481.002966] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.570s)
[481.296308] [084/156] (583s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[481.515187] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[484.288914] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SUCCESS (2.774s)
[484.524566] [085/156] (579s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[484.751695] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[484.759327] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[484.916090] [086/156] (579s left) gem_ctx_param (basic)
[485.025979] Starting subtest: basic
[485.029435] Subtest basic: SUCCESS (0.000s)
[485.208445] [087/156] (579s left) kms_vblank (query-busy-hang)
[485.411125] Starting subtest: query-busy-hang
[485.414343] Starting dynamic subtest: pipe-A-HDMI-A-1
[492.870805] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.454s)
[492.923500] Starting dynamic subtest: pipe-A-HDMI-A-2
[499.845068] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (6.966s)
[499.912255] Starting dynamic subtest: pipe-C-HDMI-A-1
[506.857984] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (7.007s)
[506.905500] Starting dynamic subtest: pipe-C-HDMI-A-2
[513.850975] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (6.983s)
[513.857347] Subtest query-busy-hang: SUCCESS (28.447s)
[514.169062] [088/156] (550s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-plflip-blt)
[514.386486] Starting subtest: fbchdr-2p-primscrn-shrfb-plflip-blt
[515.882493] Subtest fbchdr-2p-primscrn-shrfb-plflip-blt: SUCCESS (1.492s)
[516.112414] [089/156] (548s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt)
[516.343101] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt
[516.350776] Subtest fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[516.516672] [090/156] (548s left) gem_ccs (suspend-resume)
[516.654170] Subtest suspend-resume: SKIP (0.000s)
[516.787578] [091/156] (548s left) gem_lmem_swapping (parallel-random-verify)
[516.921156] Subtest parallel-random-verify: SKIP (0.000s)
[517.040977] [092/156] (548s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[517.156807] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[517.162119] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.001s)
[517.310807] [093/156] (548s left) syncobj_basic (bad-destroy-pad)
[517.424785] Starting subtest: bad-destroy-pad
[517.428733] Subtest bad-destroy-pad: SUCCESS (0.000s)
[517.579831] [094/156] (547s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[517.800925] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[517.811101] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[517.964378] [095/156] (547s left) prime_mmap (test_map_unmap)
[518.079872] Starting subtest: test_map_unmap
[518.083040] Starting dynamic subtest: test_map_unmap-smem
[518.092827] Dynamic subtest test_map_unmap-smem: SUCCESS (0.008s)
[518.096796] Subtest test_map_unmap: SUCCESS (0.012s)
[518.247938] [096/156] (547s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-pwrite)
[518.461102] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-pwrite
[518.468509] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[518.634846] [097/156] (547s left) gem_eio (create-ext)
[518.798644] Starting subtest: create-ext
[518.856257] Subtest create-ext: SUCCESS (0.069s)
[519.133210] [098/156] (546s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[519.332311] Starting subtest: short-flip-after-cursor-atomic-transitions
[520.957020] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.624s)
[521.380136] [099/156] (544s left) i915_query (engine-info)
[521.496663] Starting subtest: engine-info
[521.501298] Subtest engine-info: SUCCESS (0.004s)
[521.666396] [100/156] (544s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[521.865795] Starting subtest: short-flip-before-cursor-toggle
[523.213064] Subtest short-flip-before-cursor-toggle: SUCCESS (1.349s)
[523.585534] [101/156] (542s left) gem_pxp (reject-modify-context-protection-on)
[526.285716] Starting subtest: reject-modify-context-protection-on
[526.294515] Subtest reject-modify-context-protection-on: SKIP (0.000s)
[526.446253] [102/156] (539s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-msflip-blt)
[526.663793] Starting subtest: hdr-2p-primscrn-indfb-msflip-blt
[527.903695] Subtest hdr-2p-primscrn-indfb-msflip-blt: SUCCESS (1.243s)
[528.110680] [103/156] (538s left) gem_exec_schedule (implicit-read-write)
[528.272059] Starting subtest: implicit-read-write
[528.277095] Starting dynamic subtest: rcs0
[528.403532] Dynamic subtest rcs0: SUCCESS (0.132s)
[528.470427] Starting dynamic subtest: bcs0
[528.568613] Dynamic subtest bcs0: SUCCESS (0.152s)
[528.626021] Starting dynamic subtest: vcs0
[528.718819] Dynamic subtest vcs0: SUCCESS (0.147s)
[528.785088] Starting dynamic subtest: vecs0
[528.872975] Dynamic subtest vecs0: SUCCESS (0.141s)
[528.880386] Subtest implicit-read-write: SUCCESS (0.610s)
[529.291168] [104/156] (537s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[529.496066] Starting subtest: flip-vs-cursor-crc-legacy
[530.635749] Subtest flip-vs-cursor-crc-legacy: SUCCESS (1.140s)
[531.005564] [105/156] (535s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-pwrite)
[531.225804] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-pwrite
[532.048985] Subtest fbchdr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (0.824s)
[532.396589] [106/156] (534s left) kms_psr (psr2-sprite-plane-move)
[532.606859] Subtest psr2-sprite-plane-move: SKIP (0.000s)
[532.735118] [107/156] (534s left) syncobj_timeline (invalid-signal-zero-handles)
[532.861124] Starting subtest: invalid-signal-zero-handles
[532.864242] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[533.019324] [108/156] (534s left) sysfs_preempt_timeout (timeout)
[533.137032] Starting subtest: timeout
[533.141136] Starting dynamic subtest: vecs0
[533.987950] Dynamic subtest vecs0: SUCCESS (0.847s)
[534.022098] Starting dynamic subtest: vcs0
[534.818044] Dynamic subtest vcs0: SUCCESS (0.825s)
[534.849461] Starting dynamic subtest: bcs0
[535.647046] Dynamic subtest bcs0: SUCCESS (0.825s)
[535.679828] Starting dynamic subtest: rcs0
[536.490035] Dynamic subtest rcs0: SUCCESS (0.838s)
[536.494190] Subtest timeout: SUCCESS (3.351s)
[536.660235] [109/156] (530s left) kms_psr (psr-sprite-mmap-cpu)
[536.849477] Subtest psr-sprite-mmap-cpu: SKIP (0.000s)
[536.974486] [110/156] (530s left) perf (buffer-fill)
[537.254367] Starting subtest: buffer-fill
[537.259885] Starting dynamic subtest: 0-rcs0
[540.399665] Dynamic subtest 0-rcs0: SUCCESS (3.153s)
[540.404985] Subtest buffer-fill: SUCCESS (3.156s)
[540.527976] [111/156] (526s left) gem_readwrite (beyond-eob)
[540.642483] Starting subtest: beyond-EOB
[540.650458] Subtest beyond-EOB: SUCCESS (0.000s)
[540.823249] [112/156] (526s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[541.040352] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[541.049292] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[541.197615] [113/156] (526s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[541.418830] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[541.426143] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[541.581705] [114/156] (526s left) gem_ctx_persistence (hang)
[541.707450] Starting subtest: hang
[541.723176] Subtest hang: SKIP (0.011s)
[541.876507] [115/156] (525s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[542.089535] Starting subtest: psr-rgb101010-draw-pwrite
[542.097084] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[542.274408] [116/156] (525s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-pgflip-blt)
[542.494297] Starting subtest: psrhdr-1p-primscrn-indfb-pgflip-blt
[542.502091] Subtest psrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[542.662298] [117/156] (525s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt)
[542.890533] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt
[542.896933] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[543.064889] [118/156] (525s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[543.286293] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[543.293619] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[543.446631] [119/156] (524s left) kms_frontbuffer_tracking (hdr-rgb565-draw-pwrite)
[543.651017] Starting subtest: hdr-rgb565-draw-pwrite
[544.709089] Subtest hdr-rgb565-draw-pwrite: SUCCESS (1.059s)
[545.041995] [120/156] (523s left) kms_vrr (flip-suspend)
[545.253139] Starting subtest: flip-suspend
[545.266529] Subtest flip-suspend: SKIP (0.000s)
[545.414918] [121/156] (523s left) kms_cursor_crc (cursor-sliding-256x256)
[545.631581] Starting subtest: cursor-sliding-256x256
[545.740664] Starting dynamic subtest: pipe-A-HDMI-A-1
[550.019514] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.280s)
[550.158555] Starting dynamic subtest: pipe-C-HDMI-A-1
[553.842685] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.736s)
[553.847593] Subtest cursor-sliding-256x256: SUCCESS (8.210s)
[554.261059] [122/156] (514s left) perf_pmu (idle)
[554.379518] Starting subtest: idle
[554.382933] Starting dynamic subtest: rcs0
[554.895723] Dynamic subtest rcs0: SUCCESS (0.513s)
[554.924949] Starting dynamic subtest: bcs0
[555.418908] Dynamic subtest bcs0: SUCCESS (0.515s)
[555.446991] Starting dynamic subtest: vcs0
[555.928728] Dynamic subtest vcs0: SUCCESS (0.510s)
[555.958548] Starting dynamic subtest: vecs0
[556.446660] Dynamic subtest vecs0: SUCCESS (0.511s)
[556.450244] Subtest idle: SUCCESS (2.066s)
[556.611160] [123/156] (512s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[556.807209] Starting subtest: flip-vs-cursor-legacy
[575.134102] Subtest flip-vs-cursor-legacy: SUCCESS (18.336s)
[575.476376] [124/156] (493s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[575.670186] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[575.674125] Starting dynamic subtest: pipe-A-HDMI-A-1
[575.752512] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[575.808221] Starting dynamic subtest: pipe-A-HDMI-A-2
[575.857056] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[575.885713] Starting dynamic subtest: pipe-B-HDMI-A-1
[575.918948] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[575.947453] Starting dynamic subtest: pipe-B-HDMI-A-2
[575.978854] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[576.006395] Starting dynamic subtest: pipe-C-HDMI-A-1
[576.038822] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[576.067265] Starting dynamic subtest: pipe-C-HDMI-A-2
[576.096116] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[576.101775] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.033s)
[576.845182] [125/156] (492s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[577.066099] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[580.241406] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (3.174s)
[580.586483] [126/156] (488s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[580.787118] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[580.910474] [127/156] (488s left) gem_exec_balancer (smoke)
[581.053238] Starting subtest: smoke
[585.495524] Subtest smoke: SUCCESS (4.447s)
[585.800251] [128/156] (483s left) kms_pm_dc (dc9-dpms)
[587.013299] Starting subtest: dc9-dpms
[587.024981] Subtest dc9-dpms: SKIP (0.000s)
[587.185494] [129/156] (482s left) kms_atomic (atomic-invalid-params)
[587.385554] Starting subtest: atomic-invalid-params
[587.390340] Starting dynamic subtest: pipe-A-HDMI-A-1
[587.956130] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.567s)
[587.960693] Subtest atomic-invalid-params: SUCCESS (0.574s)
[588.360310] [130/156] (481s left) kms_properties (invalid-properties-legacy)
[588.554086] Starting subtest: invalid-properties-legacy
[588.708270] Subtest invalid-properties-legacy: SUCCESS (0.158s)
[588.888184] [131/156] (480s left) kms_cdclk (mode-transition)
[589.011585] Subtest mode-transition: SKIP (0.000s)
[589.144233] [132/156] (480s left) gem_wait (invalid-buf)
[589.268377] Starting subtest: invalid-buf
[589.272301] Subtest invalid-buf: SUCCESS (0.000s)
[589.610194] [133/156] (480s left) gen9_exec_parse (basic-rejected)
[589.744785] Starting subtest: basic-rejected
[589.753410] Subtest basic-rejected: SUCCESS (0.005s)
[590.070231] [134/156] (479s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[590.270510] Subtest psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[590.388424] [135/156] (479s left) gem_wait (busy)
[590.538118] Starting subtest: busy
[590.542493] Starting dynamic subtest: all-engines
[591.061560] Dynamic subtest all-engines: SUCCESS (0.522s)
[591.096177] Starting dynamic subtest: rcs0
[591.582341] Dynamic subtest rcs0: SUCCESS (0.516s)
[591.617403] Starting dynamic subtest: bcs0
[592.104073] Dynamic subtest bcs0: SUCCESS (0.515s)
[592.132048] Starting dynamic subtest: vcs0
[592.616920] Dynamic subtest vcs0: SUCCESS (0.512s)
[592.646757] Starting dynamic subtest: vecs0
[593.136120] Dynamic subtest vecs0: SUCCESS (0.515s)
[593.139422] Subtest busy: SUCCESS (2.599s)
[593.473113] [136/156] (476s left) prime_busy (after-wait)
[593.598262] Starting subtest: after-wait
[593.613927] Starting dynamic subtest: rcs0
[593.625101] Dynamic subtest rcs0: SUCCESS (0.011s)
[593.675821] Starting dynamic subtest: bcs0
[593.683521] Dynamic subtest bcs0: SUCCESS (0.008s)
[593.718107] Starting dynamic subtest: vcs0
[593.722788] Dynamic subtest vcs0: SUCCESS (0.014s)
[593.755869] Starting dynamic subtest: vecs0
[593.760300] Dynamic subtest vecs0: SUCCESS (0.022s)
[593.794535] Subtest after-wait: SUCCESS (0.198s)
[593.974786] [137/156] (476s left) syncobj_timeline (host-signal-points)
[594.088819] Starting subtest: host-signal-points
[594.110493] Subtest host-signal-points: SUCCESS (0.027s)
[594.275742] [138/156] (476s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[594.483691] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[594.491192] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[594.645530] [139/156] (475s left) kms_psr (fbc-psr-sprite-render)
[594.849580] Subtest fbc-psr-sprite-render: SKIP (0.000s)
[594.970841] [140/156] (475s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[595.171537] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[595.175244] Starting dynamic subtest: pipe-A-valid-mode
[596.249402] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.083s)
[596.254485] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SUCCESS (1.088s)
[596.670471] [141/156] (474s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-pwrite)
[596.890864] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-pwrite
[596.897619] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[597.054477] [142/156] (473s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[597.265603] Starting subtest: plane-downscale-factor-0-75-with-rotation
[597.270747] Starting dynamic subtest: pipe-A
[601.592796] Dynamic subtest pipe-A: SKIP (4.321s)
[601.657053] Starting dynamic subtest: pipe-B
[607.908893] Dynamic subtest pipe-B: SKIP (6.321s)
[607.967428] Starting dynamic subtest: pipe-C
[613.312249] Dynamic subtest pipe-C: SKIP (5.398s)
[613.320425] Subtest plane-downscale-factor-0-75-with-rotation: SKIP (16.051s)
[613.897342] [143/156] (457s left) syncobj_wait (multi-wait-submitted-signaled)
[614.055764] Starting subtest: multi-wait-submitted-signaled
[614.059213] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[614.220555] [144/156] (456s left) gem_exec_reloc (basic-write-cpu-noreloc)
[614.354697] Starting subtest: basic-write-cpu-noreloc
[614.366281] Subtest basic-write-cpu-noreloc: SUCCESS (0.012s)
[614.637172] [145/156] (456s left) kms_plane_multiple (tiling-4)
[614.845645] Starting subtest: tiling-4
[614.852548] Subtest tiling-4: SKIP (0.001s)
[615.002285] [146/156] (456s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[615.234904] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[615.240994] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[615.403349] [147/156] (456s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[615.626199] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[615.634600] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[615.785437] [148/156] (455s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[616.010123] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[618.959655] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (2.954s)
[619.305639] [149/156] (452s left) vgem_basic (sysfs)
[619.450933] Starting subtest: sysfs
[619.454375] Subtest sysfs: SUCCESS (0.002s)
[619.587514] [150/156] (452s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-render)
[619.813396] Starting subtest: fbchdr-rgb101010-draw-render
[620.567422] Subtest fbchdr-rgb101010-draw-render: SUCCESS (0.754s)
[620.854927] [151/156] (451s left) gem_exec_schedule (independent)
[621.018619] Starting subtest: independent
[621.024997] Starting dynamic subtest: rcs0
[621.170970] Dynamic subtest rcs0: SUCCESS (0.159s)
[621.232253] Starting dynamic subtest: bcs0
[621.355318] Dynamic subtest bcs0: SUCCESS (0.179s)
[621.418603] Starting dynamic subtest: vcs0
[621.540083] Dynamic subtest vcs0: SUCCESS (0.182s)
[621.594907] Starting dynamic subtest: vecs0
[621.696383] Dynamic subtest vecs0: SUCCESS (0.151s)
[621.699693] Subtest independent: SUCCESS (0.689s)
[622.104663] [152/156] (449s left) perf (non-zero-reason)
[622.329367] Starting subtest: non-zero-reason
[622.335075] Starting dynamic subtest: 0-rcs0
[677.138459] Dynamic subtest 0-rcs0: SUCCESS (54.811s)
[677.141775] Subtest non-zero-reason: SUCCESS (54.815s)
[677.267908] [153/156] (394s left) api_intel_bb (intel-bb-blit-y)
[677.383807] Starting subtest: intel-bb-blit-y
[680.643992] Subtest intel-bb-blit-y: SUCCESS (3.263s)
[680.849984] [154/156] (391s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[681.070246] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[681.077744] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[681.236464] [155/156] (391s left) kms_busy (extended-modeset-hang-newfb)
[681.446849] Starting subtest: extended-modeset-hang-newfb
[681.450667] Starting dynamic subtest: pipe-A
[689.963064] Dynamic subtest pipe-A: SUCCESS (8.514s)
[690.007332] Starting dynamic subtest: pipe-C
[697.947470] Dynamic subtest pipe-C: SUCCESS (7.973s)
[697.950945] Subtest extended-modeset-hang-newfb: SUCCESS (16.509s)
[698.345498] [156/156] (374s left) kms_invalid_mode (bad-vsync-start)
[698.554510] Starting subtest: bad-vsync-start
[698.560473] Starting dynamic subtest: pipe-A-HDMI-A-1
[698.975108] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.428s)
[699.034545] Starting dynamic subtest: pipe-A-HDMI-A-2
[699.038850] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s)
[699.092442] Starting dynamic subtest: pipe-B-HDMI-A-1
[699.095991] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s)
[699.147085] Starting dynamic subtest: pipe-B-HDMI-A-2
[699.149987] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.004s)
[699.181328] Starting dynamic subtest: pipe-C-HDMI-A-1
[699.184587] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.002s)
[699.224354] Starting dynamic subtest: pipe-C-HDMI-A-2
[699.228553] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.002s)
[699.231917] Subtest bad-vsync-start: SUCCESS (0.471s)
[699.362977] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_flink_basic
results: parsing output: 4/ for test: kms_chamelium_frames
results: parsing output: 5/ for test: kms_draw_crc
results: parsing output: 6/ for test: gem_flink_basic
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: kms_getfb
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_color_pipeline
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_exec_reloc
results: parsing output: 13/ for test: gem_exec_reloc
results: parsing output: 14/ for test: kms_rotation_crc
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_addfb_basic
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_chamelium_hpd
results: parsing output: 20/ for test: kms_pm_backlight
results: parsing output: 21/ for test: gem_exec_params
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_plane
results: parsing output: 24/ for test: kms_getfb
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_exec_schedule
results: parsing output: 27/ for test: i915_module_load
results: parsing output: 28/ for test: gem_pwrite
results: parsing output: 29/ for test: gem_ctx_freq
results: parsing output: 30/ for test: gem_ccs
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: i915_pm_rpm
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: gem_mmap_gtt
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: gem_exec_balancer
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: kms_flip_scaled_crc
results: parsing output: 44/ for test: kms_content_protection
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: kms_cursor_crc
results: parsing output: 47/ for test: dumb_buffer
results: parsing output: 48/ for test: i915_drm_fdinfo
results: parsing output: 49/ for test: kms_cursor_legacy
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_prop_blob
results: parsing output: 53/ for test: kms_cursor_legacy
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_spin_batch
results: parsing output: 57/ for test: gem_mmap_gtt
results: parsing output: 58/ for test: gem_exec_whisper
results: parsing output: 59/ for test: gem_mmap_offset
results: parsing output: 60/ for test: kms_pipe_crc_basic
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_getfb
results: parsing output: 63/ for test: gem_exec_fence
results: parsing output: 64/ for test: api_intel_allocator
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_lease
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: kms_force_connector_basic
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_ringfill
results: parsing output: 74/ for test: prime_vgem
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_psr2_sf
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_ctx_param
results: parsing output: 86/ for test: kms_vblank
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_ccs
results: parsing output: 90/ for test: gem_lmem_swapping
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: syncobj_basic
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: prime_mmap
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_eio
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: i915_query
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: gem_pxp
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_exec_schedule
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: sysfs_preempt_timeout
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: perf
results: parsing output: 110/ for test: gem_readwrite
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: gem_ctx_persistence
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_vrr
results: parsing output: 120/ for test: kms_cursor_crc
results: parsing output: 121/ for test: perf_pmu
results: parsing output: 122/ for test: kms_cursor_legacy
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_psr2_sf
results: parsing output: 126/ for test: gem_exec_balancer
results: parsing output: 127/ for test: kms_pm_dc
results: parsing output: 128/ for test: kms_atomic
results: parsing output: 129/ for test: kms_properties
results: parsing output: 130/ for test: kms_cdclk
results: parsing output: 131/ for test: gem_wait
results: parsing output: 132/ for test: gen9_exec_parse
results: parsing output: 133/ for test: kms_psr2_sf
results: parsing output: 134/ for test: gem_wait
results: parsing output: 135/ for test: prime_busy
results: parsing output: 136/ for test: syncobj_timeline
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_psr
results: parsing output: 139/ for test: kms_flip_scaled_crc
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: kms_plane_scaling
results: parsing output: 142/ for test: syncobj_wait
results: parsing output: 143/ for test: gem_exec_reloc
results: parsing output: 144/ for test: kms_plane_multiple
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: vgem_basic
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: gem_exec_schedule
results: parsing output: 151/ for test: perf
results: parsing output: 152/ for test: api_intel_bb
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: kms_busy
results: parsing output: 155/ for test: kms_invalid_mode
Done.