[66.369795] Initializing watchdogs
[66.369843]   /dev/watchdog0
[66.384839] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[66.389395] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[66.391585] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[66.393621] [001/133] (960s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[66.493206] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[66.495089] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[66.563562] [002/133] (960s left) gem_mmap_wc (read-write-distinct)
[66.608945] Subtest read-write-distinct: SKIP (0.000s)
[66.667431] [003/133] (960s left) gem_tiled_swapping (non-threaded)
[66.769755] Subtest non-threaded: SKIP (0.000s)
[66.835660] [004/133] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[66.936910] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[74.297387] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.373s)
[74.426114] [005/133] (952s left) kms_plane_cursor (primary)
[74.517538] Starting subtest: primary
[74.520242] Starting dynamic subtest: pipe-A-eDP-1-size-64
[77.092392] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.577s)
[77.116485] Starting dynamic subtest: pipe-A-eDP-1-size-128
[79.659067] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.550s)
[79.683367] Starting dynamic subtest: pipe-A-eDP-1-size-256
[82.260342] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.583s)
[82.571801] Starting dynamic subtest: pipe-B-eDP-1-size-64
[85.896262] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.331s)
[85.920244] Starting dynamic subtest: pipe-B-eDP-1-size-128
[88.475536] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.561s)
[88.499902] Starting dynamic subtest: pipe-B-eDP-1-size-256
[91.034386] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.541s)
[91.351748] Starting dynamic subtest: pipe-C-eDP-1-size-64
[94.252474] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.907s)
[94.277258] Starting dynamic subtest: pipe-C-eDP-1-size-128
[96.508422] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.236s)
[96.534243] Starting dynamic subtest: pipe-C-eDP-1-size-256
[98.741894] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.214s)
[99.057085] Starting dynamic subtest: pipe-D-eDP-1-size-64
[102.000312] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.949s)
[102.024859] Starting dynamic subtest: pipe-D-eDP-1-size-128
[104.211586] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.191s)
[104.236250] Starting dynamic subtest: pipe-D-eDP-1-size-256
[106.400547] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.169s)
[106.705789] Subtest primary: SUCCESS (32.188s)
[107.520847] [006/133] (919s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[107.607258] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[107.608102] Starting dynamic subtest: pipe-A-eDP-1
[107.616702] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[107.623310] Starting dynamic subtest: pipe-B-eDP-1
[107.631911] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[107.640449] Starting dynamic subtest: pipe-C-eDP-1
[107.648764] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[107.654657] Starting dynamic subtest: pipe-D-eDP-1
[107.662889] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[107.664454] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[109.869660] [007/133] (917s left) syncobj_timeline (etime-multi-wait-all-submitted)
[109.923257] Starting subtest: etime-multi-wait-all-submitted
[110.028762] Subtest etime-multi-wait-all-submitted: SUCCESS (0.104s)
[110.108937] [008/133] (917s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[110.204569] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[110.205455] Starting dynamic subtest: pipe-A-eDP-1
[116.070298] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.864s)
[116.076742] Starting dynamic subtest: pipe-B-eDP-1
[122.751466] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.681s)
[122.752372] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.547s)
[123.606140] [009/133] (903s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[123.704402] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[123.706263] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[123.803039] [010/133] (903s left) prime_mmap (test_forked_cpu_write)
[123.844874] Starting subtest: test_forked_cpu_write
[123.845773] Starting dynamic subtest: test_forked_cpu_write-smem
[123.852543] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s)
[123.853484] Subtest test_forked_cpu_write: SUCCESS (0.009s)
[123.953661] [011/133] (903s left) gem_ctx_param (set-priority-range)
[124.008256] Starting subtest: set-priority-range
[124.023357] Subtest set-priority-range: SUCCESS (0.016s)
[124.127167] [012/133] (903s left) kms_content_protection (mei-interface)
[124.264331] Starting subtest: mei-interface
[124.266404] Subtest mei-interface: SKIP (0.001s)
[124.382812] [013/133] (902s left) kms_cursor_crc (cursor-random-256x85)
[124.647420] Starting subtest: cursor-random-256x85
[124.700503] Subtest cursor-random-256x85: SKIP (0.051s)
[124.863066] [014/133] (902s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[124.946960] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[124.948722] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[125.037175] [015/133] (902s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[125.135768] Starting subtest: y-tiled-16bpp-rotate-0
[125.137474] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[125.235272] [016/133] (902s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[125.342938] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[126.224121] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.881s)
[126.374936] [017/133] (901s left) gem_exec_reloc (basic-gtt-noreloc)
[126.436910] Subtest basic-gtt-noreloc: SKIP (0.000s)
[126.506232] [018/133] (900s left) kms_draw_crc (draw-method-pwrite)
[126.599606] Starting subtest: draw-method-pwrite
[126.600511] Starting dynamic subtest: xrgb8888-untiled
[127.211289] Dynamic subtest xrgb8888-untiled: SUCCESS (0.612s)
[127.219616] Starting dynamic subtest: rgb565-untiled
[127.688611] Dynamic subtest rgb565-untiled: SUCCESS (0.477s)
[127.694599] Starting dynamic subtest: xrgb2101010-untiled
[128.267257] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.577s)
[128.280237] Starting dynamic subtest: xbgr16161616f-untiled
[129.078038] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.808s)
[129.087947] Starting dynamic subtest: xrgb8888-xtiled
[130.966653] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.887s)
[130.973113] Starting dynamic subtest: rgb565-xtiled
[132.167169] Dynamic subtest rgb565-xtiled: SUCCESS (1.199s)
[132.181395] Starting dynamic subtest: xrgb2101010-xtiled
[134.066725] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.899s)
[134.074745] Starting dynamic subtest: xbgr16161616f-xtiled
[137.555852] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.487s)
[137.562202] Starting dynamic subtest: xrgb8888-4tiled
[138.722417] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.166s)
[138.729084] Starting dynamic subtest: rgb565-4tiled
[139.344748] Dynamic subtest rgb565-4tiled: SUCCESS (0.621s)
[139.363409] Starting dynamic subtest: xrgb2101010-4tiled
[140.544964] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.197s)
[140.553304] Starting dynamic subtest: xbgr16161616f-4tiled
[143.711777] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.165s)
[143.714061] Subtest draw-method-pwrite: SUCCESS (17.114s)
[143.807872] [019/133] (883s left) gem_mmap_gtt (cpuset-big-copy-xy)
[143.860905] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[143.920320] [020/133] (883s left) gem_exec_fence (basic-wait-all)
[143.978756] Starting subtest: basic-wait-all
[144.075211] Subtest basic-wait-all: SUCCESS (0.096s)
[146.017239] [FACT gem_exec_fence (basic-wait-all)] new: kernel.kmod_is_loaded.vgem: true
[146.019851] [021/133] (881s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[146.115364] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[146.117201] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[146.188562] [022/133] (881s left) gen3_render_linear_blits
[146.290208] [023/133] (881s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[146.412084] Starting subtest: basic-flip-before-cursor-legacy
[147.327247] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.914s)
[148.138895] [024/133] (879s left) kms_pm_dc (dc5-psr)
[149.233111] Starting subtest: dc5-psr
[152.119645] Subtest dc5-psr: SUCCESS (2.886s)
[152.968249] [025/133] (874s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[153.061445] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[153.062966] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[153.160747] [026/133] (874s left) gem_exec_whisper (basic-queues-priority-all)
[153.232939] Starting subtest: basic-queues-priority-all
[173.225450] Subtest basic-queues-priority-all: SUCCESS (19.984s)
[173.396840] [027/133] (854s left) core_getversion (all-cards)
[173.432328] Starting subtest: all-cards
[173.445706] Subtest all-cards: SUCCESS (0.013s)
[173.481902] [028/133] (854s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[173.597518] Starting subtest: cursorB-vs-flipB-atomic-transitions
[173.599284] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[173.734856] [029/133] (854s left) api_intel_allocator (open-vm)
[173.787327] Starting subtest: open-vm
[173.791812] Subtest open-vm: SUCCESS (0.005s)
[173.893959] [030/133] (853s left) perf (polling)
[174.009074] Starting subtest: polling
[174.010147] Starting dynamic subtest: 0-rcs0
[184.045129] Dynamic subtest 0-rcs0: SUCCESS (10.027s)
[184.053745] Starting dynamic subtest: 1-vcs0
[194.102156] Dynamic subtest 1-vcs0: SUCCESS (10.020s)
[194.103220] Subtest polling: SUCCESS (20.049s)
[194.135883] [031/133] (833s left) gem_exec_schedule (smoketest-all)
[194.190480] Starting subtest: smoketest-all
[226.556887] Subtest smoketest-all: SUCCESS (32.338s)
[227.917466] [032/133] (799s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[228.011907] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[228.013720] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[228.128766] [033/133] (799s left) kms_psr (psr2-basic)
[228.212832] Starting subtest: psr2-basic
[228.213731] Starting dynamic subtest: eDP-1
[229.846600] Dynamic subtest eDP-1: SUCCESS (1.633s)
[229.847519] Subtest psr2-basic: SUCCESS (1.635s)
[230.645517] [034/133] (797s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[230.730401] Starting subtest: fbcpsr-suspend
[271.638168] Subtest fbcpsr-suspend: SUCCESS (10.970s)
[274.781873] [035/133] (756s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[274.843234] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[274.951891] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.107s)
[275.041474] [036/133] (756s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[275.132624] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[275.133478] Starting dynamic subtest: pipe-A-eDP-1
[275.155185] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[275.163311] Starting dynamic subtest: pipe-B-eDP-1
[275.186161] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[275.194375] Starting dynamic subtest: pipe-C-eDP-1
[275.215186] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[275.222593] Starting dynamic subtest: pipe-D-eDP-1
[275.244851] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[275.246383] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s)
[277.361304] [037/133] (753s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[277.460091] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[277.461809] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[277.563197] [038/133] (753s left) kms_plane (planar-pixel-format-settings)
[277.661045] Starting subtest: planar-pixel-format-settings
[277.727413] Subtest planar-pixel-format-settings: SUCCESS (0.068s)
[277.826258] [039/133] (753s left) kms_prime (basic-modeset-hybrid)
[277.904048] Subtest basic-modeset-hybrid: SKIP (0.000s)
[277.990222] [040/133] (753s left) gem_flink_race (flink_name)
[278.027925] Starting subtest: flink_name
[283.364504] Subtest flink_name: SUCCESS (5.389s)
[283.453182] [041/133] (747s left) gem_spin_batch (user-each)
[283.515244] Starting subtest: user-each
[286.824548] Subtest user-each: SUCCESS (3.299s)
[288.857296] [042/133] (742s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[288.955537] Starting subtest: bo-too-small-due-to-tiling
[288.957370] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[289.056820] [043/133] (742s left) gem_wait (write-busy)
[289.134300] Starting subtest: write-busy
[289.135365] Starting dynamic subtest: all-engines
[289.746104] Dynamic subtest all-engines: SUCCESS (0.615s)
[289.758262] Starting dynamic subtest: rcs0
[290.305352] Dynamic subtest rcs0: SUCCESS (0.560s)
[290.320594] Starting dynamic subtest: bcs0
[290.855585] Dynamic subtest bcs0: SUCCESS (0.552s)
[290.871059] Starting dynamic subtest: vcs0
[292.887372] Dynamic subtest vcs0: SUCCESS (2.028s)
[292.895652] Starting dynamic subtest: vcs1
[294.872136] Dynamic subtest vcs1: SUCCESS (1.986s)
[294.879896] Starting dynamic subtest: vecs0
[296.856483] Dynamic subtest vecs0: SUCCESS (1.987s)
[296.864922] Starting dynamic subtest: ccs0
[297.394175] Dynamic subtest ccs0: SUCCESS (0.550s)
[297.395289] Subtest write-busy: SUCCESS (8.293s)
[297.589682] [044/133] (733s left) gem_ctx_param (invalid-get-no-zeromap)
[297.637030] Starting subtest: invalid-get-no-zeromap
[297.638106] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[297.726581] [045/133] (733s left) gem_eio (execbuf)
[297.922314] Starting subtest: execbuf
[298.198385] Subtest execbuf: SUCCESS (0.276s)
[298.309724] [046/133] (733s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[298.399589] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[302.880356] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.487s)
[304.070135] [047/133] (727s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[304.148474] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[304.149380] Starting dynamic subtest: pipe-A-default-mode
[305.314262] Dynamic subtest pipe-A-default-mode: SKIP (1.164s)
[305.315855] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.166s)
[305.458661] [048/133] (725s left) kms_psr (fbc-psr2-sprite-blt)
[305.553049] Starting subtest: fbc-psr2-sprite-blt
[305.553990] Starting dynamic subtest: eDP-1
[305.555797] Dynamic subtest eDP-1: SKIP (0.000s)
[305.557656] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[305.633900] [049/133] (725s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[305.724653] Starting subtest: primary-y-tiled-reflect-x-270
[305.726431] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[305.794888] [050/133] (725s left) gem_exec_schedule (lateslice)
[305.852377] Starting subtest: lateslice
[305.853334] Starting dynamic subtest: rcs0
[305.872876] Dynamic subtest rcs0: SUCCESS (0.021s)
[305.882359] Starting dynamic subtest: bcs0
[305.894396] Dynamic subtest bcs0: SUCCESS (0.021s)
[305.908729] Starting dynamic subtest: vcs0
[305.913313] Dynamic subtest vcs0: SUCCESS (0.018s)
[305.921759] Starting dynamic subtest: vcs1
[305.934894] Dynamic subtest vcs1: SUCCESS (0.021s)
[305.942880] Starting dynamic subtest: vecs0
[305.953612] Dynamic subtest vecs0: SUCCESS (0.018s)
[305.961405] Starting dynamic subtest: ccs0
[305.972178] Dynamic subtest ccs0: SUCCESS (0.018s)
[305.973075] Subtest lateslice: SUCCESS (0.121s)
[307.924426] [051/133] (723s left) gem_ctx_param (invalid-ctx-set)
[307.968013] Starting subtest: invalid-ctx-set
[307.968953] Subtest invalid-ctx-set: SUCCESS (0.001s)
[308.057678] [052/133] (723s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[308.157986] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[308.159826] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[308.225964] [053/133] (723s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[308.315008] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[312.674799] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.361s)
[313.877156] [054/133] (717s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[313.968665] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[313.969559] Starting dynamic subtest: pipe-A-eDP-1
[313.978269] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[313.986393] Starting dynamic subtest: pipe-B-eDP-1
[313.995214] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[314.005275] Starting dynamic subtest: pipe-C-eDP-1
[314.013014] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[314.021001] Starting dynamic subtest: pipe-D-eDP-1
[314.029015] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[314.030564] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[316.239138] [055/133] (715s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[316.342173] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[316.343996] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[316.442198] [056/133] (715s left) kms_flip (wf_vblank-ts-check-interruptible)
[316.542041] Starting subtest: wf_vblank-ts-check-interruptible
[316.544339] Starting dynamic subtest: A-eDP1
[325.500344] Dynamic subtest A-eDP1: SUCCESS (8.934s)
[325.510661] Starting dynamic subtest: B-eDP1
[334.419152] Dynamic subtest B-eDP1: SUCCESS (8.921s)
[334.429031] Starting dynamic subtest: C-eDP1
[343.344307] Dynamic subtest C-eDP1: SUCCESS (8.914s)
[343.362048] Starting dynamic subtest: D-eDP1
[352.270777] Dynamic subtest D-eDP1: SUCCESS (8.929s)
[352.271797] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.711s)
[353.466185] [057/133] (678s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[353.522050] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[353.623031] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.101s)
[353.708133] [058/133] (678s left) kms_universal_plane (universal-plane-pageflip-windowed)
[353.805793] Starting subtest: universal-plane-pageflip-windowed
[353.806621] Starting dynamic subtest: pipe-A-eDP-1
[354.397511] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.592s)
[354.405450] Starting dynamic subtest: pipe-B-eDP-1
[355.603102] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.205s)
[355.612249] Starting dynamic subtest: pipe-C-eDP-1
[356.802695] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.196s)
[356.810870] Starting dynamic subtest: pipe-D-eDP-1
[358.037253] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s)
[358.038422] Subtest universal-plane-pageflip-windowed: SUCCESS (4.234s)
[358.883951] [059/133] (672s left) kms_chamelium_color (ctm-max)
[358.986994] Subtest ctm-max: SKIP (0.000s)
[359.034928] [060/133] (672s left) gem_bad_reloc (negative-reloc-bltcopy)
[359.095857] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[359.159378] [061/133] (672s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[359.526613] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[360.294883] [062/133] (671s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[360.391934] Starting subtest: yf-tiled-64bpp-rotate-180
[360.393731] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[360.470236] [063/133] (671s left) gem_fence_thrash (bo-write-verify-threaded-none)
[360.504290] Starting subtest: bo-write-verify-threaded-none
[360.534314] Subtest bo-write-verify-threaded-none: SKIP (0.028s)
[360.601976] [064/133] (671s left) gem_mmap_wc (bad-offset)
[360.657509] Subtest bad-offset: SKIP (0.000s)
[360.714937] [065/133] (671s left) kms_vblank (query-idle-hang)
[360.795843] Starting subtest: query-idle-hang
[360.796931] Starting dynamic subtest: pipe-A-eDP-1
[387.669388] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.865s)
[387.679441] Starting dynamic subtest: pipe-D-eDP-1
[411.661018] Dynamic subtest pipe-D-eDP-1: SUCCESS (23.989s)
[411.661966] Subtest query-idle-hang: SUCCESS (50.859s)
[412.499615] [066/133] (619s left) prime_busy (after)
[412.549393] Starting subtest: after
[412.552674] Starting dynamic subtest: rcs0
[412.599815] Dynamic subtest rcs0: SUCCESS (0.047s)
[412.610113] Starting dynamic subtest: bcs0
[412.639559] Dynamic subtest bcs0: SUCCESS (0.039s)
[412.650933] Starting dynamic subtest: vcs0
[412.681007] Dynamic subtest vcs0: SUCCESS (0.040s)
[412.689577] Starting dynamic subtest: vcs1
[412.721091] Dynamic subtest vcs1: SUCCESS (0.039s)
[412.729215] Starting dynamic subtest: vecs0
[412.761317] Dynamic subtest vecs0: SUCCESS (0.039s)
[412.770664] Starting dynamic subtest: ccs0
[412.801973] Dynamic subtest ccs0: SUCCESS (0.040s)
[412.909729] Subtest after: SUCCESS (0.359s)
[412.988393] [067/133] (619s left) kms_atomic_interruptible (universal-setplane-cursor)
[413.078270] Starting subtest: universal-setplane-cursor
[413.079147] Starting dynamic subtest: pipe-A-eDP-1
[420.502552] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.424s)
[420.503298] Subtest universal-setplane-cursor: SUCCESS (7.425s)
[421.365168] [068/133] (610s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[421.452657] Starting subtest: stress-xrgb8888-xtiled
[427.252111] Subtest stress-xrgb8888-xtiled: SUCCESS (5.800s)
[427.302510] [069/133] (604s left) kms_chamelium_frames (dp-crc-single)
[427.691318] Subtest dp-crc-single: SKIP (0.000s)
[428.464893] [070/133] (603s left) gem_tiled_partial_pwrite_pread (writes)
[428.516895] Subtest writes: SKIP (0.000s)
[428.583740] [071/133] (603s left) api_intel_bb (destroy-bb)
[428.639506] Starting subtest: destroy-bb
[428.647928] Subtest destroy-bb: SUCCESS (0.009s)
[428.770915] [072/133] (603s left) fbdev (read)
[428.812365] Starting subtest: read
[429.355569] Subtest read: SUCCESS (0.532s)
[429.417188] [073/133] (602s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[429.506979] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[429.507925] Starting dynamic subtest: pipe-A
[429.571179] Dynamic subtest pipe-A: SUCCESS (0.065s)
[429.581698] Starting dynamic subtest: pipe-B
[430.719699] Dynamic subtest pipe-B: SUCCESS (1.147s)
[430.732285] Starting dynamic subtest: pipe-C
[431.839693] Dynamic subtest pipe-C: SUCCESS (1.119s)
[431.851226] Starting dynamic subtest: pipe-D
[432.968414] Dynamic subtest pipe-D: SUCCESS (1.128s)
[432.969488] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.464s)
[434.111133] [074/133] (598s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[434.208149] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[434.209889] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[434.289580] [075/133] (598s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[434.388801] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[434.390489] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[434.479081] [076/133] (597s left) kms_prop_blob (blob-prop-core)
[434.526009] Starting subtest: blob-prop-core
[434.526917] Subtest blob-prop-core: SUCCESS (0.000s)
[434.610506] [077/133] (597s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[434.700003] Starting subtest: fbcpsr-rgb565-draw-blt
[441.841115] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.144s)
[441.961588] [078/133] (590s left) gen7_exec_parse (oacontrol-tracking)
[442.023224] Subtest oacontrol-tracking: SKIP (0.000s)
[442.070717] [079/133] (590s left) kms_lease (possible-crtcs-filtering)
[442.163669] Starting subtest: possible-crtcs-filtering
[442.170602] Subtest possible-crtcs-filtering: SUCCESS (0.008s)
[442.270562] [080/133] (590s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[442.356689] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[442.358289] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[442.437447] [081/133] (590s left) gem_ctx_param (invalid-size-get)
[442.484308] Starting subtest: invalid-size-get
[442.485445] Subtest invalid-size-get: SUCCESS (0.001s)
[442.571495] [082/133] (590s left) i915_pm_rps (engine-order)
[442.620009] Starting subtest: engine-order
[449.112343] Subtest engine-order: SUCCESS (6.486s)
[449.230142] [083/133] (583s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[449.353988] Starting subtest: flip-vs-cursor-busy-crc-atomic
[450.172084] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.817s)
[450.964296] [084/133] (581s left) i915_module_load (reload-no-display)
[451.004731] Starting subtest: reload-no-display
[458.229512] Subtest reload-no-display: SUCCESS (7.220s)
[458.251597] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[458.252311] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[458.254162] [085/133] (574s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[459.892376] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[460.738087] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.847s)
[460.924614] [FACT kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[460.925845] [FACT kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)] new: kernel.kmod_is_loaded.i915: true
[460.928766] [086/133] (571s left) kms_rotation_crc (bad-tiling)
[461.011911] Starting subtest: bad-tiling
[461.013645] Subtest bad-tiling: SKIP (0.001s)
[461.078650] [087/133] (571s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[461.170601] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[461.172353] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[461.261682] [088/133] (571s left) syncobj_timeline (wait-all-snapshot)
[461.312614] Starting subtest: wait-all-snapshot
[461.395021] Subtest wait-all-snapshot: SUCCESS (0.082s)
[461.464247] [089/133] (571s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[461.558357] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[461.559924] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[461.663415] [090/133] (571s left) syncobj_basic (illegal-fd-to-handle)
[461.710294] Starting subtest: illegal-fd-to-handle
[461.711202] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[461.801803] [091/133] (571s left) kms_cursor_crc (cursor-onscreen-128x42)
[462.026512] Starting subtest: cursor-onscreen-128x42
[462.082278] Subtest cursor-onscreen-128x42: SKIP (0.054s)
[462.256893] [092/133] (570s left) perf_pmu (busy-hang)
[462.293787] Starting subtest: busy-hang
[462.294636] Starting dynamic subtest: rcs0
[463.539127] Dynamic subtest rcs0: SUCCESS (1.244s)
[463.548594] Starting dynamic subtest: bcs0
[464.741582] Dynamic subtest bcs0: SUCCESS (1.204s)
[464.752923] Starting dynamic subtest: vcs0
[466.384270] Dynamic subtest vcs0: SUCCESS (1.640s)
[466.394172] Starting dynamic subtest: vcs1
[468.366159] Dynamic subtest vcs1: SUCCESS (1.979s)
[468.375839] Starting dynamic subtest: vecs0
[470.349117] Dynamic subtest vecs0: SUCCESS (1.983s)
[470.357816] Starting dynamic subtest: ccs0
[471.561174] Dynamic subtest ccs0: SUCCESS (1.210s)
[471.562634] Subtest busy-hang: SUCCESS (9.270s)
[471.667200] [093/133] (561s left) kms_dp_link_training (non-uhbr-mst)
[471.764648] Starting subtest: non-uhbr-mst
[471.768139] Subtest non-uhbr-mst: SKIP (0.000s)
[471.834226] [094/133] (561s left) gem_ctx_persistence (process)
[471.886794] Starting subtest: process
[472.058159] Subtest process: SUCCESS (0.171s)
[472.130415] [095/133] (560s left) kms_hdr (bpc-switch-dpms)
[472.212560] Starting subtest: bpc-switch-dpms
[473.321173] Starting dynamic subtest: pipe-A-eDP-1
[477.825563] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.505s)
[477.826592] Subtest bpc-switch-dpms: SUCCESS (5.615s)
[477.934735] [096/133] (555s left) gem_exec_balancer (bonded-sync)
[477.989140] Starting subtest: bonded-sync
[477.991248] Subtest bonded-sync: SKIP (0.000s)
[478.286095] [097/133] (554s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[478.340380] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[478.342322] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[478.529262] [098/133] (554s left) kms_psr (fbc-psr-cursor-plane-move)
[478.621981] Starting subtest: fbc-psr-cursor-plane-move
[478.622986] Starting dynamic subtest: eDP-1
[478.624879] Dynamic subtest eDP-1: SKIP (0.000s)
[478.626511] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[478.691936] [099/133] (554s left) gem_ctx_exec (basic-invalid-context)
[478.752922] Starting subtest: basic-invalid-context
[478.757252] Subtest basic-invalid-context: SUCCESS (0.006s)
[478.861684] [100/133] (554s left) kms_joiner (basic-force-ultra-joiner)
[478.957798] Starting subtest: basic-force-ultra-joiner
[478.959372] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[479.025191] [101/133] (554s left) gem_madvise (dontneed-before-pwrite)
[479.057315] Starting subtest: dontneed-before-pwrite
[479.070072] Subtest dontneed-before-pwrite: SKIP (0.012s)
[479.121310] [102/133] (554s left) i915_drm_fdinfo (virtual-busy-all)
[479.160614] Starting subtest: virtual-busy-all
[479.162660] Subtest virtual-busy-all: SKIP (0.000s)
[479.242139] [103/133] (554s left) gem_pwrite_snooped
[479.376262] [104/133] (554s left) kms_cursor_crc (cursor-size-change)
[479.464838] Starting subtest: cursor-size-change
[479.465678] Starting dynamic subtest: pipe-A-eDP-1
[480.275251] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.811s)
[480.283587] Starting dynamic subtest: pipe-D-eDP-1
[481.740747] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.463s)
[481.741619] Subtest cursor-size-change: SUCCESS (2.277s)
[482.550942] [105/133] (550s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[482.635897] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[482.636859] Starting dynamic subtest: pipe-A-eDP-1
[499.210422] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.806s)
[499.218365] Starting dynamic subtest: pipe-B-eDP-1
[517.175962] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.820s)
[517.183970] Starting dynamic subtest: pipe-C-eDP-1
[535.157128] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.750s)
[535.165927] Starting dynamic subtest: pipe-D-eDP-1
[553.163913] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.782s)
[553.164769] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (10.163s)
[559.456411] [106/133] (479s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[559.575467] Starting subtest: 4-tiled-16bpp-rotate-90
[559.595371] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s)
[559.704682] [107/133] (478s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[559.799842] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[559.802143] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[559.905824] [108/133] (478s left) i915_pm_rps (thresholds)
[559.981550] Starting subtest: thresholds
[559.983535] Subtest thresholds: SKIP (0.001s)
[560.085432] [109/133] (478s left) gem_ctx_shared (exec-single-timeline)
[560.137060] Starting subtest: exec-single-timeline
[560.138048] Starting dynamic subtest: rcs0
[561.217128] Dynamic subtest rcs0: SUCCESS (1.107s)
[561.227868] Starting dynamic subtest: bcs0
[562.305464] Dynamic subtest bcs0: SUCCESS (1.116s)
[562.315320] Starting dynamic subtest: vcs0
[563.396113] Dynamic subtest vcs0: SUCCESS (1.116s)
[563.406826] Starting dynamic subtest: vcs1
[564.482298] Dynamic subtest vcs1: SUCCESS (1.107s)
[564.492751] Starting dynamic subtest: vecs0
[565.570083] Dynamic subtest vecs0: SUCCESS (1.106s)
[565.581026] Starting dynamic subtest: ccs0
[566.658246] Dynamic subtest ccs0: SUCCESS (1.104s)
[566.659572] Subtest exec-single-timeline: SUCCESS (6.673s)
[567.253596] [110/133] (471s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[567.305720] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[567.306560] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[567.402424] [111/133] (471s left) intel_hwmon (hwmon-read)
[567.464446] Subtest hwmon-read: SKIP (0.000s)
[567.532012] [112/133] (471s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[567.628737] Starting subtest: 4-tiled-16bpp-rotate-0
[568.937143] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.325s)
[569.066036] [113/133] (469s left) gem_flink_basic (flink-lifetime)
[569.118010] Starting subtest: flink-lifetime
[569.118869] Subtest flink-lifetime: SUCCESS (0.002s)
[569.209715] [114/133] (469s left) gem_exec_big (single)
[569.264423] Starting subtest: single
[574.330933] Subtest single: SUCCESS (5.098s)
[574.575490] [115/133] (464s left) kms_frontbuffer_tracking (psr-1p-rte)
[574.708881] Starting subtest: psr-1p-rte
[580.132202] Subtest psr-1p-rte: SUCCESS (5.447s)
[580.255976] [116/133] (458s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[580.341850] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[580.343430] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[580.449695] [117/133] (458s left) gem_exec_schedule (fifo)
[580.519680] Starting subtest: fifo
[580.520965] Starting dynamic subtest: rcs0
[580.630918] Dynamic subtest rcs0: SUCCESS (0.111s)
[580.642861] Starting dynamic subtest: vcs0
[580.717356] Dynamic subtest vcs0: SUCCESS (0.086s)
[580.729115] Starting dynamic subtest: vcs1
[580.794419] Dynamic subtest vcs1: SUCCESS (0.076s)
[580.805918] Starting dynamic subtest: vecs0
[580.869329] Dynamic subtest vecs0: SUCCESS (0.074s)
[580.880527] Starting dynamic subtest: ccs0
[580.951294] Dynamic subtest ccs0: SUCCESS (0.080s)
[580.952721] Subtest fifo: SUCCESS (0.433s)
[582.366727] [118/133] (456s left) gem_pxp (reject-modify-context-protection-off-3)
[582.495433] Starting subtest: reject-modify-context-protection-off-3
[582.496888] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[582.601927] [119/133] (456s left) gem_mmap_offset (bad-object)
[582.661846] Starting subtest: bad-object
[582.662767] Subtest bad-object: SUCCESS (0.001s)
[582.775695] [120/133] (456s left) gem_eio (in-flight-internal-10ms)
[583.025252] Starting subtest: in-flight-internal-10ms
[584.310406] Subtest in-flight-internal-10ms: SUCCESS (1.287s)
[584.436750] [121/133] (454s left) kms_atomic_transition (plane-all-transition)
[584.522831] Starting subtest: plane-all-transition
[584.523746] Starting dynamic subtest: pipe-A-eDP-1
[587.013211] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[587.319525] Starting dynamic subtest: pipe-B-eDP-1
[590.584337] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.277s)
[590.882677] Subtest plane-all-transition: SUCCESS (6.370s)
[591.692069] [122/133] (447s left) gem_exec_fence (syncobj-signal)
[592.136843] Starting subtest: syncobj-signal
[592.141711] Subtest syncobj-signal: SUCCESS (0.005s)
[593.254766] [123/133] (445s left) gem_exec_schedule (u-semaphore-user)
[593.320332] Starting subtest: u-semaphore-user
[593.379652] Subtest u-semaphore-user: SUCCESS (0.059s)
[595.280817] [124/133] (443s left) gem_basic (create-fd-close)
[595.331178] Starting subtest: create-fd-close
[595.332787] Subtest create-fd-close: SUCCESS (0.000s)
[595.438300] [125/133] (443s left) syncobj_timeline (invalid-signal-illegal-handle)
[595.495102] Starting subtest: invalid-signal-illegal-handle
[595.496059] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[595.593523] [126/133] (443s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[595.692234] Starting subtest: fbc-rgb101010-draw-render
[600.316362] Subtest fbc-rgb101010-draw-render: SUCCESS (4.622s)
[601.500106] [127/133] (437s left) gem_exec_suspend (basic-s0)
[601.558789] Starting subtest: basic-S0
[601.559615] Starting dynamic subtest: smem
[622.516737] Dynamic subtest smem: SUCCESS (6.660s)
[622.518291] Subtest basic-S0: SUCCESS (6.662s)
[628.727010] [128/133] (416s left) kms_cursor_edge_walk (256x256-left-edge)
[628.807923] Starting subtest: 256x256-left-edge
[628.808873] Starting dynamic subtest: pipe-A-eDP-1
[632.228656] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.420s)
[632.237804] Starting dynamic subtest: pipe-D-eDP-1
[635.348246] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s)
[635.349307] Subtest 256x256-left-edge: SUCCESS (6.540s)
[636.171246] [129/133] (409s left) sysfs_preempt_timeout (invalid)
[636.227734] Starting subtest: invalid
[636.228652] Starting dynamic subtest: vecs0
[636.229577] Dynamic subtest vecs0: SUCCESS (0.000s)
[636.242571] Starting dynamic subtest: ccs0
[636.243398] Dynamic subtest ccs0: SUCCESS (0.000s)
[636.251884] Starting dynamic subtest: vcs0
[636.252919] Dynamic subtest vcs0: SUCCESS (0.000s)
[636.260753] Starting dynamic subtest: bcs0
[636.261617] Dynamic subtest bcs0: SUCCESS (0.000s)
[636.269402] Starting dynamic subtest: rcs0
[636.270306] Dynamic subtest rcs0: SUCCESS (0.001s)
[636.278095] Starting dynamic subtest: vcs1
[636.278998] Dynamic subtest vcs1: SUCCESS (0.000s)
[636.279883] Subtest invalid: SUCCESS (0.009s)
[636.312109] [130/133] (409s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[636.403635] Starting subtest: primary-4-tiled-reflect-x-180
[643.453093] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.051s)
[644.619104] [131/133] (400s left) kms_vrr (flipline)
[644.710895] Starting subtest: flipline
[644.713442] Subtest flipline: SKIP (0.000s)
[644.794716] [132/133] (400s left) kms_psr (psr2-cursor-render)
[644.878662] Starting subtest: psr2-cursor-render
[644.879447] Starting dynamic subtest: eDP-1
[646.610901] Dynamic subtest eDP-1: SUCCESS (1.732s)
[646.611767] Subtest psr2-cursor-render: SUCCESS (1.733s)
[647.421036] [133/133] (398s left) kms_color_pipeline (plane-lut1d-lut1d)
[647.519366] Starting subtest: plane-lut1d-lut1d
[647.680520] Starting dynamic subtest: pipe-A-plane-0
[647.961468] Dynamic subtest pipe-A-plane-0: FAIL (0.206s)
[647.973916] Starting dynamic subtest: pipe-A-plane-1
[648.147010] Dynamic subtest pipe-A-plane-1: FAIL (0.185s)
[648.156261] Starting dynamic subtest: pipe-A-plane-2
[648.343178] Dynamic subtest pipe-A-plane-2: FAIL (0.180s)
[649.457771] Starting dynamic subtest: pipe-B-plane-0
[649.711510] Dynamic subtest pipe-B-plane-0: FAIL (0.175s)
[649.720128] Starting dynamic subtest: pipe-B-plane-1
[649.883729] Dynamic subtest pipe-B-plane-1: FAIL (0.166s)
[649.892631] Starting dynamic subtest: pipe-B-plane-2
[650.051386] Dynamic subtest pipe-B-plane-2: FAIL (0.166s)
[651.097100] Starting dynamic subtest: pipe-C-plane-0
[651.362829] Dynamic subtest pipe-C-plane-0: FAIL (0.140s)
[651.372503] Starting dynamic subtest: pipe-C-plane-1
[651.511495] Dynamic subtest pipe-C-plane-1: FAIL (0.155s)
[651.520478] Starting dynamic subtest: pipe-C-plane-2
[651.691559] Dynamic subtest pipe-C-plane-2: FAIL (0.166s)
[652.714544] Starting dynamic subtest: pipe-D-plane-0
[653.046780] Dynamic subtest pipe-D-plane-0: FAIL (0.185s)
[653.056196] Starting dynamic subtest: pipe-D-plane-1
[653.227719] Dynamic subtest pipe-D-plane-1: FAIL (0.133s)
[653.236439] Starting dynamic subtest: pipe-D-plane-2
[653.425120] Dynamic subtest pipe-D-plane-2: FAIL (0.332s)
[653.646088] Subtest plane-lut1d-lut1d: FAIL (6.253s)
[654.443313] Closing watchdogs
results: parsing output: 0/ for test: kms_plane
results: parsing output: 1/ for test: gem_mmap_wc
results: parsing output: 2/ for test: gem_tiled_swapping
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_plane_cursor
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_psr2_sf
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: prime_mmap
results: parsing output: 10/ for test: gem_ctx_param
results: parsing output: 11/ for test: kms_content_protection
results: parsing output: 12/ for test: kms_cursor_crc
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: gem_exec_reloc
results: parsing output: 17/ for test: kms_draw_crc
results: parsing output: 18/ for test: gem_mmap_gtt
results: parsing output: 19/ for test: gem_exec_fence
results: parsing output: 20/ for test: kms_flip_scaled_crc
results: parsing output: 21/ for test: gen3_render_linear_blits
results: parsing output: 22/ for test: kms_cursor_legacy
results: parsing output: 23/ for test: kms_pm_dc
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: gem_exec_whisper
results: parsing output: 26/ for test: core_getversion
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: api_intel_allocator
results: parsing output: 29/ for test: perf
results: parsing output: 30/ for test: gem_exec_schedule
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_plane
results: parsing output: 38/ for test: kms_prime
results: parsing output: 39/ for test: gem_flink_race
results: parsing output: 40/ for test: gem_spin_batch
results: parsing output: 41/ for test: kms_addfb_basic
results: parsing output: 42/ for test: gem_wait
results: parsing output: 43/ for test: gem_ctx_param
results: parsing output: 44/ for test: gem_eio
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_flip_scaled_crc
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: kms_rotation_crc
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: gem_ctx_param
results: parsing output: 51/ for test: kms_flip_scaled_crc
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: kms_universal_plane
results: parsing output: 58/ for test: kms_chamelium_color
results: parsing output: 59/ for test: gem_bad_reloc
results: parsing output: 60/ for test: kms_chamelium_hpd
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: gem_fence_thrash
results: parsing output: 63/ for test: gem_mmap_wc
results: parsing output: 64/ for test: kms_vblank
results: parsing output: 65/ for test: prime_busy
results: parsing output: 66/ for test: kms_atomic_interruptible
results: parsing output: 67/ for test: kms_pipe_stress
results: parsing output: 68/ for test: kms_chamelium_frames
results: parsing output: 69/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 70/ for test: api_intel_bb
results: parsing output: 71/ for test: fbdev
results: parsing output: 72/ for test: kms_plane_scaling
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_prop_blob
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gen7_exec_parse
results: parsing output: 78/ for test: kms_lease
results: parsing output: 79/ for test: kms_psr2_sf
results: parsing output: 80/ for test: gem_ctx_param
results: parsing output: 81/ for test: i915_pm_rps
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: i915_module_load
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_rotation_crc
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: syncobj_basic
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: perf_pmu
results: parsing output: 92/ for test: kms_dp_link_training
results: parsing output: 93/ for test: gem_ctx_persistence
results: parsing output: 94/ for test: kms_hdr
results: parsing output: 95/ for test: gem_exec_balancer
results: parsing output: 96/ for test: gem_render_copy
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: gem_ctx_exec
results: parsing output: 99/ for test: kms_joiner
results: parsing output: 100/ for test: gem_madvise
results: parsing output: 101/ for test: i915_drm_fdinfo
results: parsing output: 102/ for test: gem_pwrite_snooped
results: parsing output: 103/ for test: kms_cursor_crc
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: i915_pm_rps
results: parsing output: 108/ for test: gem_ctx_shared
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: intel_hwmon
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: gem_flink_basic
results: parsing output: 113/ for test: gem_exec_big
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: gem_pxp
results: parsing output: 118/ for test: gem_mmap_offset
results: parsing output: 119/ for test: gem_eio
results: parsing output: 120/ for test: kms_atomic_transition
results: parsing output: 121/ for test: gem_exec_fence
results: parsing output: 122/ for test: gem_exec_schedule
results: parsing output: 123/ for test: gem_basic
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_exec_suspend
results: parsing output: 127/ for test: kms_cursor_edge_walk
results: parsing output: 128/ for test: sysfs_preempt_timeout
results: parsing output: 129/ for test: kms_rotation_crc
results: parsing output: 130/ for test: kms_vrr
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: kms_color_pipeline
Done.