[60.782163] Initializing watchdogs
[60.782213]   /dev/watchdog0
[60.796800] [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]
[60.801380] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.803576] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.805502] [001/133] (960s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[60.915083] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[60.916858] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[60.987958] [002/133] (960s left) kms_hdr (bpc-switch-dpms)
[61.075891] Starting subtest: bpc-switch-dpms
[62.119627] Starting dynamic subtest: pipe-A-eDP-1
[66.652800] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.525s)
[66.653925] Subtest bpc-switch-dpms: SUCCESS (5.567s)
[66.878122] [003/133] (954s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[67.187045] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[67.189038] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[67.559242] [004/133] (953s left) gem_pxp (display-protected-crc)
[67.806286] Starting subtest: display-protected-crc
[69.454288] Subtest display-protected-crc: SUCCESS (1.647s)
[69.586997] [005/133] (951s left) kms_cursor_crc (cursor-alpha-transparent)
[69.686800] Starting subtest: cursor-alpha-transparent
[69.688299] Starting dynamic subtest: pipe-A-eDP-1
[70.312083] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.625s)
[70.318227] Starting dynamic subtest: pipe-D-eDP-1
[71.586781] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.272s)
[71.587775] Subtest cursor-alpha-transparent: SUCCESS (1.899s)
[72.380979] [006/133] (949s left) i915_query (query-topology-garbage-items)
[72.438192] Starting subtest: query-topology-garbage-items
[72.439224] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[72.578102] [007/133] (948s left) kms_psr2_su (page_flip-xrgb8888)
[72.639915] Subtest page_flip-XRGB8888: SKIP (0.000s)
[72.695603] [008/133] (948s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[73.070936] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[73.888043] [009/133] (947s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[73.969196] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[73.970097] Starting dynamic subtest: pipe-A-eDP-1
[76.087223] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.117s)
[76.093549] Starting dynamic subtest: pipe-B-eDP-1
[78.277386] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.189s)
[78.283860] Starting dynamic subtest: pipe-C-eDP-1
[80.273367] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.995s)
[80.279613] Starting dynamic subtest: pipe-D-eDP-1
[82.353557] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.079s)
[82.354459] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.384s)
[83.579925] [010/133] (938s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[83.685372] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[89.052815] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.368s)
[90.187702] [011/133] (931s left) kms_flip (plain-flip-ts-check-interruptible)
[90.286840] Starting subtest: plain-flip-ts-check-interruptible
[90.289292] Starting dynamic subtest: A-eDP1
[99.194560] Dynamic subtest A-eDP1: SUCCESS (8.881s)
[99.204340] Starting dynamic subtest: B-eDP1
[108.004371] Dynamic subtest B-eDP1: SUCCESS (8.832s)
[108.012981] Starting dynamic subtest: C-eDP1
[116.865712] Dynamic subtest C-eDP1: SUCCESS (8.824s)
[116.874584] Starting dynamic subtest: D-eDP1
[125.702719] Dynamic subtest D-eDP1: SUCCESS (8.835s)
[125.703857] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.385s)
[126.833582] [012/133] (894s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[126.895060] Starting subtest: verify-pxp-execution-after-suspend-resume
[134.082375] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.187s)
[143.300716] [013/133] (887s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[143.360374] Starting subtest: invalid-single-wait-unsubmitted
[143.361325] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[143.455431] [014/133] (887s left) i915_drm_fdinfo (memory-info-purgeable)
[143.486291] Starting subtest: memory-info-purgeable
[143.487185] Starting dynamic subtest: smem0
[146.208917] Dynamic subtest smem0: SUCCESS (2.721s)
[146.210237] Subtest memory-info-purgeable: SUCCESS (2.722s)
[146.287098] [015/133] (884s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[146.377325] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[150.629297] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.251s)
[151.839309] [016/133] (878s left) prime_busy (before-wait)
[151.904129] Starting subtest: before-wait
[151.907449] Starting dynamic subtest: rcs0
[151.957540] Dynamic subtest rcs0: SUCCESS (0.050s)
[151.963697] Starting dynamic subtest: bcs0
[152.033500] Dynamic subtest bcs0: SUCCESS (0.075s)
[152.039889] Starting dynamic subtest: vcs0
[152.072757] Dynamic subtest vcs0: SUCCESS (0.039s)
[152.078933] Starting dynamic subtest: vcs1
[152.111816] Dynamic subtest vcs1: SUCCESS (0.039s)
[152.118105] Starting dynamic subtest: vecs0
[152.150865] Dynamic subtest vecs0: SUCCESS (0.039s)
[152.157033] Starting dynamic subtest: ccs0
[152.189718] Dynamic subtest ccs0: SUCCESS (0.038s)
[152.296833] Subtest before-wait: SUCCESS (0.392s)
[152.375734] [017/133] (878s left) api_intel_bb (simple-bb)
[152.426521] Starting subtest: simple-bb
[152.430936] Subtest simple-bb: SUCCESS (0.005s)
[152.584979] [018/133] (878s left) kms_draw_crc (draw-method-mmap-gtt)
[152.678358] Starting subtest: draw-method-mmap-gtt
[152.680095] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[152.799676] [019/133] (878s left) perf (sysctl-defaults)
[152.876858] Starting subtest: sysctl-defaults
[152.877789] Subtest sysctl-defaults: SUCCESS (0.000s)
[152.966316] [020/133] (877s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[153.058969] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[160.064439] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.005s)
[160.242486] [021/133] (870s left) kms_flip (nonexisting-fb)
[160.348048] Starting subtest: nonexisting-fb
[160.349051] Starting dynamic subtest: A-eDP1
[161.530585] Dynamic subtest A-eDP1: SUCCESS (1.181s)
[161.537278] Starting dynamic subtest: B-eDP1
[162.665649] Dynamic subtest B-eDP1: SUCCESS (1.134s)
[162.673699] Starting dynamic subtest: C-eDP1
[163.805129] Dynamic subtest C-eDP1: SUCCESS (1.138s)
[163.813604] Starting dynamic subtest: D-eDP1
[164.936986] Dynamic subtest D-eDP1: SUCCESS (1.131s)
[164.939504] Subtest nonexisting-fb: SUCCESS (4.592s)
[166.128239] [022/133] (864s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[166.231912] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[166.233556] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[166.307209] [023/133] (864s left) gem_exec_schedule (timeslicing)
[166.380773] Starting subtest: timeslicing
[166.381699] Starting dynamic subtest: rcs0
[166.402769] Dynamic subtest rcs0: SUCCESS (0.022s)
[166.411715] Starting dynamic subtest: bcs0
[166.422966] Dynamic subtest bcs0: SUCCESS (0.020s)
[166.429849] Starting dynamic subtest: vcs0
[166.443911] Dynamic subtest vcs0: SUCCESS (0.020s)
[166.450466] Starting dynamic subtest: vcs1
[166.464157] Dynamic subtest vcs1: SUCCESS (0.020s)
[166.470629] Starting dynamic subtest: vecs0
[166.484281] Dynamic subtest vecs0: SUCCESS (0.019s)
[166.490851] Starting dynamic subtest: ccs0
[166.505225] Dynamic subtest ccs0: SUCCESS (0.020s)
[166.506261] Subtest timeslicing: SUCCESS (0.125s)
[167.937968] [024/133] (863s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[168.025748] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[168.027610] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[168.135667] [025/133] (862s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[168.264441] Starting subtest: flip-vs-cursor-atomic-transitions
[175.812851] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.547s)
[176.661759] [026/133] (854s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[176.756478] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[176.758235] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[176.833085] [027/133] (854s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[176.948093] Starting subtest: basic-flip-after-cursor-legacy
[177.863067] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.914s)
[178.684862] [028/133] (852s left) prime_self_import (export-vs-gem_close-race)
[178.717651] Starting subtest: export-vs-gem_close-race
[183.820758] Subtest export-vs-gem_close-race: SUCCESS (5.102s)
[183.912360] [029/133] (847s left) gem_mmap_gtt (zero-extend)
[183.979138] Subtest zero-extend: SKIP (0.000s)
[184.046197] [030/133] (847s left) gem_ctx_persistence (legacy-engines-persistence)
[184.112464] Starting subtest: legacy-engines-persistence
[184.113468] Starting dynamic subtest: render
[184.954628] Dynamic subtest render: SUCCESS (0.841s)
[184.966182] Starting dynamic subtest: bsd1
[185.776757] Dynamic subtest bsd1: SUCCESS (0.819s)
[185.787820] Starting dynamic subtest: bsd2
[186.566731] Dynamic subtest bsd2: SUCCESS (0.787s)
[186.576551] Starting dynamic subtest: blt
[187.440695] Dynamic subtest blt: SUCCESS (0.871s)
[187.451889] Starting dynamic subtest: vebox
[188.270808] Dynamic subtest vebox: SUCCESS (0.827s)
[188.272424] Subtest legacy-engines-persistence: SUCCESS (4.159s)
[188.368527] [031/133] (842s left) i915_module_load (reload)
[188.402975] Starting subtest: reload
[193.410416] Subtest reload: SUCCESS (5.008s)
[193.444165] [032/133] (837s left) kms_color (degamma)
[194.911237] Starting subtest: degamma
[194.912523] Starting dynamic subtest: pipe-A-eDP-1
[195.655615] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.745s)
[195.662229] Starting dynamic subtest: pipe-B-eDP-1
[197.078532] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.422s)
[197.084927] Starting dynamic subtest: pipe-C-eDP-1
[198.444187] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.365s)
[198.451083] Starting dynamic subtest: pipe-D-eDP-1
[199.778981] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.333s)
[199.779902] Subtest degamma: SUCCESS (4.868s)
[200.579413] [033/133] (830s left) prime_vgem (basic-fence-mmap)
[200.691955] Starting subtest: basic-fence-mmap
[200.693852] Subtest basic-fence-mmap: SKIP (0.000s)
[200.807684] [FACT prime_vgem (basic-fence-mmap)] new: kernel.kmod_is_loaded.vgem: true
[200.809683] [034/133] (830s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[200.897527] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[200.899179] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[201.041381] [035/133] (830s left) gem_lmem_swapping (parallel-random-engines)
[201.079240] Subtest parallel-random-engines: SKIP (0.000s)
[201.111698] [036/133] (830s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[201.200533] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[208.268902] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.069s)
[208.423930] [037/133] (823s left) perf_pmu (init-busy)
[208.460542] Starting subtest: init-busy
[208.461380] Starting dynamic subtest: rcs0
[208.463558] Dynamic subtest rcs0: SUCCESS (0.002s)
[208.471046] Starting dynamic subtest: bcs0
[208.472260] Dynamic subtest bcs0: SUCCESS (0.000s)
[208.478871] Starting dynamic subtest: vcs0
[208.479809] Dynamic subtest vcs0: SUCCESS (0.001s)
[208.486063] Starting dynamic subtest: vcs1
[208.486933] Dynamic subtest vcs1: SUCCESS (0.001s)
[208.493199] Starting dynamic subtest: vecs0
[208.494073] Dynamic subtest vecs0: SUCCESS (0.001s)
[208.500359] Starting dynamic subtest: ccs0
[208.501398] Dynamic subtest ccs0: SUCCESS (0.000s)
[208.502261] Subtest init-busy: SUCCESS (0.008s)
[208.589892] [038/133] (822s left) kms_frontbuffer_tracking (fbc-1p-rte)
[208.688866] Starting subtest: fbc-1p-rte
[214.161094] Subtest fbc-1p-rte: SUCCESS (5.473s)
[215.374732] [039/133] (816s left) gem_ringfill (basic-all)
[220.897819] Starting subtest: basic-all
[222.051091] Subtest basic-all: SUCCESS (1.151s)
[222.214018] [040/133] (809s left) kms_cursor_edge_walk (128x128-left-edge)
[222.307962] Starting subtest: 128x128-left-edge
[222.308861] Starting dynamic subtest: pipe-A-eDP-1
[225.761090] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.452s)
[225.767910] Starting dynamic subtest: pipe-D-eDP-1
[228.880049] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s)
[228.880897] Subtest 128x128-left-edge: SUCCESS (6.573s)
[229.680401] [041/133] (801s left) gem_vm_create (create-ext)
[229.739891] Starting subtest: create-ext
[229.744327] Subtest create-ext: SUCCESS (0.004s)
[229.866728] [042/133] (801s left) gem_exec_capture (userptr)
[229.921796] Starting subtest: userptr
[230.756964] Subtest userptr: SUCCESS (0.836s)
[230.893774] [043/133] (800s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[231.125980] Starting subtest: cursor-rapid-movement-256x256
[231.128462] Starting dynamic subtest: pipe-A-eDP-1
[231.675864] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.547s)
[231.703625] Starting dynamic subtest: pipe-D-eDP-1
[232.892061] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.193s)
[232.893499] Subtest cursor-rapid-movement-256x256: SUCCESS (1.766s)
[233.755901] [044/133] (797s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[233.851359] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[233.852405] Starting dynamic subtest: pipe-A-eDP-1
[233.861165] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[233.868821] Starting dynamic subtest: pipe-B-eDP-1
[233.877211] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[233.884364] Starting dynamic subtest: pipe-C-eDP-1
[233.893337] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[233.900092] Starting dynamic subtest: pipe-D-eDP-1
[233.908495] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[233.910296] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[236.024783] [045/133] (795s left) kms_invalid_mode (zero-hdisplay)
[236.131367] Starting subtest: zero-hdisplay
[236.132277] Starting dynamic subtest: pipe-A-eDP-1
[236.421391] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[236.428263] Starting dynamic subtest: pipe-B-eDP-1
[236.429114] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[236.435481] Starting dynamic subtest: pipe-C-eDP-1
[236.436394] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[236.442905] Starting dynamic subtest: pipe-D-eDP-1
[236.443842] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[236.444777] Subtest zero-hdisplay: SUCCESS (0.296s)
[237.253922] [046/133] (794s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[237.354031] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[238.343878] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.990s)
[238.507394] [047/133] (793s left) gem_softpin (evict-snoop)
[238.580242] Starting subtest: evict-snoop
[238.581860] Subtest evict-snoop: SKIP (0.000s)
[238.701453] [048/133] (793s left) prime_vgem (basic-write)
[238.783156] Starting subtest: basic-write
[238.791688] Subtest basic-write: SKIP (0.008s)
[238.915410] [049/133] (792s left) kms_atomic (plane-invalid-params)
[239.012195] Starting subtest: plane-invalid-params
[239.012991] Starting dynamic subtest: pipe-A-eDP-1
[239.413650] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.400s)
[239.414561] Subtest plane-invalid-params: SUCCESS (0.402s)
[240.305401] [050/133] (791s left) gem_userptr_blits (unsync-unmap-cycles)
[240.366383] Subtest unsync-unmap-cycles: SKIP (0.000s)
[240.502238] [051/133] (791s left) gem_exec_schedule (preempt-contexts)
[240.573378] Starting subtest: preempt-contexts
[240.574234] Starting dynamic subtest: rcs0
[240.652689] Dynamic subtest rcs0: SUCCESS (0.079s)
[240.660041] Starting dynamic subtest: bcs0
[240.699844] Dynamic subtest bcs0: SUCCESS (0.046s)
[240.706990] Starting dynamic subtest: vcs0
[240.741926] Dynamic subtest vcs0: SUCCESS (0.041s)
[240.749158] Starting dynamic subtest: vcs1
[240.787535] Dynamic subtest vcs1: SUCCESS (0.044s)
[240.798555] Starting dynamic subtest: vecs0
[240.836042] Dynamic subtest vecs0: SUCCESS (0.048s)
[240.843703] Starting dynamic subtest: ccs0
[240.882523] Dynamic subtest ccs0: SUCCESS (0.045s)
[240.883295] Subtest preempt-contexts: SUCCESS (0.309s)
[242.072676] [052/133] (789s left) syncobj_wait (wait-any-interrupted)
[242.130289] Starting subtest: wait-any-interrupted
[242.232802] Subtest wait-any-interrupted: SUCCESS (0.102s)
[242.316694] [053/133] (789s left) gem_madvise (dontneed-before-exec)
[242.343658] Starting subtest: dontneed-before-exec
[242.373159] Subtest dontneed-before-exec: SKIP (0.028s)
[242.442959] [054/133] (789s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[242.529014] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[242.529941] Starting dynamic subtest: pipe-A-eDP-1
[242.538212] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[242.547330] Starting dynamic subtest: pipe-B-eDP-1
[242.555339] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[242.562711] Starting dynamic subtest: pipe-C-eDP-1
[242.570625] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[242.577546] Starting dynamic subtest: pipe-D-eDP-1
[242.585626] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[242.587245] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[244.853944] [055/133] (787s left) kms_psr (psr2-basic)
[244.948385] Starting subtest: psr2-basic
[244.949276] Starting dynamic subtest: eDP-1
[246.536484] Dynamic subtest eDP-1: SUCCESS (1.588s)
[246.537350] Subtest psr2-basic: SUCCESS (1.589s)
[247.339362] [056/133] (784s left) kms_chamelium_color (gamma)
[247.426133] Subtest gamma: SKIP (0.000s)
[247.464837] [057/133] (784s left) i915_pm_rpm (system-suspend-devices)
[248.985808] Starting subtest: system-suspend-devices
[256.634588] Subtest system-suspend-devices: SUCCESS (7.651s)
[262.082677] [058/133] (775s left) kms_chamelium_color (ctm-0-25)
[262.184851] Subtest ctm-0-25: SKIP (0.000s)
[262.223408] [059/133] (775s left) kms_rotation_crc (primary-rotation-90)
[262.319113] Starting subtest: primary-rotation-90
[262.320695] Subtest primary-rotation-90: SKIP (0.001s)
[262.399529] [060/133] (774s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[262.488405] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[262.860773] Starting dynamic subtest: pipe-A-eDP-1
[265.684974] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.815s)
[266.049574] Starting dynamic subtest: pipe-B-eDP-1
[268.815911] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.764s)
[269.169499] Starting dynamic subtest: pipe-C-eDP-1
[271.946611] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.775s)
[272.297164] Starting dynamic subtest: pipe-D-eDP-1
[275.072633] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.773s)
[275.073635] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.576s)
[276.251299] [061/133] (761s left) gem_exec_whisper (basic-queues)
[276.315126] Starting subtest: basic-queues
[281.918130] Subtest basic-queues: SUCCESS (5.593s)
[282.100249] [062/133] (755s left) kms_big_fb (4-tiled-addfb-size-overflow)
[282.209588] Starting subtest: 4-tiled-addfb-size-overflow
[282.210904] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[282.339834] [063/133] (755s left) gem_eio (suspend)
[282.568240] Starting subtest: suspend
[294.819497] Subtest suspend: SUCCESS (12.251s)
[302.007166] [064/133] (742s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[302.106277] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[302.107164] Starting dynamic subtest: pipe-A
[302.170364] Dynamic subtest pipe-A: SUCCESS (0.065s)
[302.178945] Starting dynamic subtest: pipe-B
[303.316182] Dynamic subtest pipe-B: SUCCESS (1.145s)
[303.326260] Starting dynamic subtest: pipe-C
[304.435801] Dynamic subtest pipe-C: SUCCESS (1.118s)
[304.446270] Starting dynamic subtest: pipe-D
[305.574279] Dynamic subtest pipe-D: SUCCESS (1.137s)
[305.577659] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.470s)
[306.743603] [065/133] (737s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[306.840407] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[306.842115] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[306.950649] [066/133] (737s left) kms_psr (fbc-psr2-suspend)
[307.041044] Starting subtest: fbc-psr2-suspend
[307.041972] Starting dynamic subtest: eDP-1
[307.043744] Dynamic subtest eDP-1: SKIP (0.000s)
[307.045481] Subtest fbc-psr2-suspend: SKIP (0.001s)
[307.134780] [067/133] (737s left) gem_ctx_sseu (engines)
[307.196264] Subtest engines: SKIP (0.000s)
[307.280359] [068/133] (737s left) kms_vblank (wait-idle)
[307.381682] Starting subtest: wait-idle
[307.382560] Starting dynamic subtest: pipe-A-eDP-1
[309.134990] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.753s)
[309.144621] Starting dynamic subtest: pipe-D-eDP-1
[311.580431] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.444s)
[311.581425] Subtest wait-idle: SUCCESS (4.200s)
[312.403701] [069/133] (732s left) kms_busy (extended-pageflip-hang-oldfb)
[312.510378] Starting subtest: extended-pageflip-hang-oldfb
[312.511358] Starting dynamic subtest: pipe-A
[312.912152] Dynamic subtest pipe-A: SUCCESS (0.400s)
[312.921209] Starting dynamic subtest: pipe-D
[314.018592] Dynamic subtest pipe-D: SUCCESS (1.104s)
[314.019495] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.509s)
[314.875748] [070/133] (729s left) kms_dp_linktrain_fallback (dsc-fallback)
[314.978058] Starting subtest: dsc-fallback
[314.980577] Subtest dsc-fallback: SKIP (0.000s)
[315.060090] [071/133] (729s left) perf_pmu (invalid-init)
[315.091412] Starting subtest: invalid-init
[315.092363] Subtest invalid-init: SUCCESS (0.000s)
[315.211591] [072/133] (729s left) kms_addfb_basic (bad-pitch-63)
[315.269529] Starting subtest: bad-pitch-63
[315.270563] Subtest bad-pitch-63: SUCCESS (0.000s)
[315.426847] [073/133] (729s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[315.530126] Starting subtest: fbc-2p-pri-indfb-multidraw
[315.531818] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[315.649788] [074/133] (729s left) perf_pmu (busy-double-start)
[315.686942] Starting subtest: busy-double-start
[315.687929] Starting dynamic subtest: rcs0
[319.295198] Dynamic subtest rcs0: FAIL (3.587s)
[319.304693] Starting dynamic subtest: bcs0
[322.855471] Dynamic subtest bcs0: SUCCESS (3.580s)
[322.865825] Starting dynamic subtest: vcs0
[327.484778] Dynamic subtest vcs0: SUCCESS (4.626s)
[327.498286] Starting dynamic subtest: vcs1
[331.460732] Dynamic subtest vcs1: SUCCESS (3.974s)
[331.473410] Starting dynamic subtest: vecs0
[335.466586] Dynamic subtest vecs0: SUCCESS (4.004s)
[335.481324] Starting dynamic subtest: ccs0
[339.067455] Dynamic subtest ccs0: FAIL (3.566s)
[339.068379] Subtest busy-double-start: FAIL (23.347s)
[339.155958] [075/133] (705s left) gem_exec_balancer (parallel-bb-first)
[339.428021] Starting subtest: parallel-bb-first
[340.394647] Subtest parallel-bb-first: SUCCESS (0.966s)
[340.939559] [076/133] (703s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[341.058549] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[341.101466] [077/133] (703s left) gem_mmap_gtt (bad-object)
[341.163701] Subtest bad-object: SKIP (0.000s)
[341.230241] [078/133] (703s left) gem_pread (snoop)
[341.285827] Subtest snoop: SKIP (0.000s)
[341.355437] [079/133] (703s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[341.459559] Starting subtest: y-tiled-addfb-size-offset-overflow
[341.461274] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[341.579263] [080/133] (703s left) syncobj_basic (bad-handle-to-fd)
[341.634501] Starting subtest: bad-handle-to-fd
[341.635385] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[341.760950] [081/133] (703s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[341.819057] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[341.922713] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s)
[342.011457] [082/133] (703s left) gem_ppgtt (blt-vs-render-ctx0)
[342.076569] Starting subtest: blt-vs-render-ctx0
[375.138873] Subtest blt-vs-render-ctx0: SUCCESS (33.052s)
[375.282281] [083/133] (669s left) kms_pm_rpm (pm-tiling)
[377.089500] Starting subtest: pm-tiling
[377.092392] Subtest pm-tiling: SKIP (0.000s)
[377.599131] [084/133] (667s left) perf_pmu (all-busy-idle-check-all)
[377.637308] Starting subtest: all-busy-idle-check-all
[378.914704] Subtest all-busy-idle-check-all: SUCCESS (1.266s)
[379.007213] [085/133] (666s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[379.063237] Subtest untiled-to-tiled: SKIP (0.000s)
[379.134731] [086/133] (666s left) gem_create (create-ext-set-pat)
[379.301467] Starting subtest: create-ext-set-pat
[379.302799] Subtest create-ext-set-pat: SUCCESS (0.001s)
[379.417394] [087/133] (665s left) kms_plane_lowres (tiling-4)
[379.512913] Starting subtest: tiling-4
[379.514432] Starting dynamic subtest: pipe-A-eDP-1
[379.516188] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[379.816720] Starting dynamic subtest: pipe-B-eDP-1
[379.818529] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[379.829053] Starting dynamic subtest: pipe-C-eDP-1
[379.830756] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[379.839036] Starting dynamic subtest: pipe-D-eDP-1
[379.841053] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[379.842840] Subtest tiling-4: SKIP (0.305s)
[380.610368] [088/133] (664s left) syncobj_timeline (wait-any-interrupted)
[380.685651] Starting subtest: wait-any-interrupted
[380.786059] Subtest wait-any-interrupted: SUCCESS (0.101s)
[380.871119] [089/133] (664s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[380.953380] Starting subtest: pr-cursor-plane-move-continuous-sf
[380.955169] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[381.033868] [090/133] (664s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[381.101712] Starting subtest: etime-multi-wait-all-for-submit-submitted
[381.202533] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.108s)
[381.283458] [091/133] (664s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[381.414052] Starting subtest: short-flip-after-cursor-atomic-transitions
[382.372653] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.959s)
[383.243939] [092/133] (662s left) drm_mm (drm_mm)
[383.278686] Starting subtest: drm_mm
[383.326677] Starting dynamic subtest: drm_test_mm_init
[383.445491] Dynamic subtest drm_test_mm_init: SUCCESS (0.119s)
[383.455716] Starting dynamic subtest: drm_test_mm_debug
[383.562969] Dynamic subtest drm_test_mm_debug: SUCCESS (0.117s)
[383.572690] Starting dynamic subtest: drm_test_mm_align32
[383.704947] Dynamic subtest drm_test_mm_align32: SUCCESS (0.133s)
[383.715212] Starting dynamic subtest: drm_test_mm_align64
[383.846055] Dynamic subtest drm_test_mm_align64: SUCCESS (0.141s)
[383.856263] Starting dynamic subtest: drm_test_mm_lowest
[383.980574] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.133s)
[383.989073] Starting dynamic subtest: drm_test_mm_highest
[384.109694] Dynamic subtest drm_test_mm_highest: SUCCESS (0.127s)
[384.110600] Subtest drm_mm: SUCCESS (0.821s)
[384.306124] [093/133] (661s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[384.403273] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[384.404952] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[385.568772] [094/133] (659s left) gem_exec_balancer (smoke)
[385.632707] Starting subtest: smoke
[408.326679] Subtest smoke: SUCCESS (22.648s)
[409.939260] [095/133] (635s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[410.049905] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[411.116750] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.067s)
[411.293396] [096/133] (634s left) kms_flip (2x-flip-vs-fences-interruptible)
[411.398924] Starting subtest: 2x-flip-vs-fences-interruptible
[411.400856] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[411.506592] [097/133] (634s left) kms_content_protection (legacy-hdcp14)
[411.655490] Starting subtest: legacy-hdcp14
[411.657379] Subtest legacy-hdcp14: SKIP (0.000s)
[411.814197] [098/133] (633s left) gem_mmap_gtt (basic-write-read)
[411.877750] Subtest basic-write-read: SKIP (0.000s)
[411.941357] [099/133] (633s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[412.044089] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[412.044909] Starting dynamic subtest: pipe-A-eDP-1
[412.106811] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[412.414058] Starting dynamic subtest: pipe-B-eDP-1
[413.252520] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.846s)
[413.548443] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.504s)
[414.432266] [100/133] (631s left) kms_lease (invalid-create-leases)
[414.526470] Starting subtest: invalid-create-leases
[414.532503] Subtest invalid-create-leases: SUCCESS (0.006s)
[414.694225] [101/133] (631s left) gem_exec_reloc (basic-cpu-wc)
[414.758291] Subtest basic-cpu-wc: SKIP (0.000s)
[414.836108] [102/133] (630s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[414.937260] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[414.938091] Starting dynamic subtest: pipe-A
[415.165252] Dynamic subtest pipe-A: SUCCESS (0.229s)
[415.173934] Starting dynamic subtest: pipe-B
[416.486224] Dynamic subtest pipe-B: SUCCESS (1.320s)
[416.494968] Starting dynamic subtest: pipe-C
[417.829096] Dynamic subtest pipe-C: SUCCESS (1.342s)
[417.839070] Starting dynamic subtest: pipe-D
[419.151654] Dynamic subtest pipe-D: SUCCESS (1.322s)
[419.152593] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.216s)
[420.345630] [103/133] (625s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[420.443535] Starting subtest: primary-yf-tiled-reflect-x-180
[420.515640] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.072s)
[420.628892] [104/133] (625s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[420.719614] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[420.721487] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[420.859420] [105/133] (625s left) perf (invalid-oa-metric-set-id)
[420.994545] Starting subtest: invalid-oa-metric-set-id
[421.005333] Subtest invalid-oa-metric-set-id: SUCCESS (0.011s)
[421.041980] [106/133] (624s left) gem_exec_fence (syncobj-repeat)
[421.497107] Starting subtest: syncobj-repeat
[421.697393] Subtest syncobj-repeat: SUCCESS (0.190s)
[423.043798] [107/133] (622s left) kms_rotation_crc (multiplane-rotation)
[423.140320] Starting subtest: multiplane-rotation
[440.611365] Subtest multiplane-rotation: SUCCESS (17.471s)
[440.769063] [108/133] (605s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[440.836437] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[440.837583] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[440.964090] [109/133] (605s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[441.063872] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[441.065656] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[441.187888] [110/133] (604s left) syncobj_timeline (etime-single-wait-all-submitted)
[441.244504] Starting subtest: etime-single-wait-all-submitted
[441.347587] Subtest etime-single-wait-all-submitted: SUCCESS (0.102s)
[441.438174] [111/133] (604s left) gem_exec_params (invalid-flag)
[441.500616] Starting subtest: invalid-flag
[441.501597] Subtest invalid-flag: SUCCESS (0.000s)
[441.617952] [112/133] (604s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[441.719604] Starting subtest: yf-tiled-64bpp-rotate-0
[441.721403] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[441.840706] [113/133] (604s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[441.941060] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[442.896812] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.956s)
[443.061912] [114/133] (603s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[443.168397] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[443.196690] Starting dynamic subtest: pipe-A-plane-0
[443.485247] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[443.493987] Starting dynamic subtest: pipe-A-plane-3
[443.718539] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[444.827563] Starting dynamic subtest: pipe-B-plane-0
[445.119050] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[445.127848] Starting dynamic subtest: pipe-B-plane-3
[445.352459] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[445.660980] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.492s)
[446.500131] [115/133] (599s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[446.598422] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[455.508856] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.911s)
[455.640851] [116/133] (590s left) api_intel_bb (add-remove-objects)
[455.697502] Starting subtest: add-remove-objects
[455.703891] Subtest add-remove-objects: SUCCESS (0.007s)
[455.829874] [117/133] (590s left) kms_pm_rpm (cursor-dpms)
[458.052335] Starting subtest: cursor-dpms
[458.054645] Subtest cursor-dpms: SKIP (0.000s)
[458.434441] [118/133] (587s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[458.524682] Starting subtest: fbcpsr-rgb101010-draw-render
[465.279953] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.756s)
[465.434106] [119/133] (580s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[465.538351] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[465.540015] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[465.665365] [120/133] (580s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[465.771471] Starting subtest: disable-crc-after-crtc
[465.772371] Starting dynamic subtest: pipe-A-eDP-1
[467.467698] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.696s)
[467.476537] Starting dynamic subtest: pipe-B-eDP-1
[469.729982] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.261s)
[469.740246] Starting dynamic subtest: pipe-C-eDP-1
[471.996304] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.263s)
[472.005305] Starting dynamic subtest: pipe-D-eDP-1
[474.262254] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.266s)
[474.263525] Subtest disable-crc-after-crtc: SUCCESS (8.492s)
[475.094873] [121/133] (571s left) gem_ctx_isolation (clean)
[475.158058] Starting subtest: clean
[475.159144] Starting dynamic subtest: rcs0
[475.221516] Dynamic subtest rcs0: SUCCESS (0.063s)
[475.232390] Starting dynamic subtest: bcs0
[475.299431] Dynamic subtest bcs0: SUCCESS (0.077s)
[475.310310] Starting dynamic subtest: vcs0
[475.380385] Dynamic subtest vcs0: SUCCESS (0.080s)
[475.391440] Starting dynamic subtest: vcs1
[476.890513] Dynamic subtest vcs1: SUCCESS (1.509s)
[476.901258] Starting dynamic subtest: vecs0
[478.935743] Dynamic subtest vecs0: SUCCESS (2.045s)
[478.946714] Starting dynamic subtest: ccs0
[480.973203] Dynamic subtest ccs0: SUCCESS (2.036s)
[480.974147] Subtest clean: SUCCESS (5.815s)
[481.207980] [122/133] (565s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[481.261776] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[481.262812] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[481.379991] [123/133] (565s left) kms_psr (fbc-psr2-primary-page-flip)
[481.470119] Starting subtest: fbc-psr2-primary-page-flip
[481.471129] Starting dynamic subtest: eDP-1
[481.472964] Dynamic subtest eDP-1: SKIP (0.000s)
[481.474822] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[481.553275] [124/133] (565s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[481.649404] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[481.651186] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[481.775449] [125/133] (564s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[481.874998] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[481.876762] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[481.989420] [126/133] (564s left) kms_psr (psr-basic)
[482.078140] Starting subtest: psr-basic
[482.079045] Starting dynamic subtest: eDP-1
[483.653843] Dynamic subtest eDP-1: SUCCESS (1.575s)
[483.654681] Subtest psr-basic: SUCCESS (1.576s)
[484.524207] [127/133] (562s left) gem_softpin (allocator-fork)
[484.594629] Starting subtest: allocator-fork
[486.852758] Subtest allocator-fork: SUCCESS (2.212s)
[486.956500] [128/133] (559s left) gen9_exec_parse (bb-start-cmd)
[487.017614] Subtest bb-start-cmd: SKIP (0.000s)
[487.082074] [129/133] (559s left) gem_barrier_race (remote-request)
[487.137326] Starting subtest: remote-request
[487.138672] Starting dynamic subtest: rcs0
[492.316076] Dynamic subtest rcs0: SUCCESS (5.170s)
[492.318190] Subtest remote-request: SUCCESS (5.172s)
[492.464318] [130/133] (554s left) gem_exec_flush (basic-uc-ro-default)
[492.517666] Starting subtest: basic-uc-ro-default
[498.014977] Subtest basic-uc-ro-default: SUCCESS (5.497s)
[498.224349] [131/133] (548s left) gem_exec_schedule (implicit-boths)
[498.289702] Starting subtest: implicit-boths
[498.291050] Starting dynamic subtest: rcs0
[498.488894] Dynamic subtest rcs0: SUCCESS (0.199s)
[498.502453] Starting dynamic subtest: vcs0
[498.620841] Dynamic subtest vcs0: SUCCESS (0.131s)
[498.632687] Starting dynamic subtest: vcs1
[498.725043] Dynamic subtest vcs1: SUCCESS (0.104s)
[498.736615] Starting dynamic subtest: vecs0
[498.827797] Dynamic subtest vecs0: SUCCESS (0.101s)
[498.838943] Starting dynamic subtest: ccs0
[498.957980] Dynamic subtest ccs0: SUCCESS (0.129s)
[498.959475] Subtest implicit-boths: SUCCESS (0.669s)
[500.049315] [132/133] (546s left) sysfs_timeslice_duration (timeout)
[500.098269] Starting subtest: timeout
[500.099188] Starting dynamic subtest: vecs0
[509.938959] Dynamic subtest vecs0: SUCCESS (9.830s)
[509.950300] Starting dynamic subtest: ccs0
[511.295881] Dynamic subtest ccs0: SUCCESS (1.363s)
[511.309782] Starting dynamic subtest: vcs0
[520.945669] Dynamic subtest vcs0: SUCCESS (9.638s)
[520.956735] Starting dynamic subtest: bcs0
[521.671501] Dynamic subtest bcs0: SUCCESS (0.732s)
[521.682680] Starting dynamic subtest: rcs0
[523.032198] Dynamic subtest rcs0: SUCCESS (1.359s)
[523.044989] Starting dynamic subtest: vcs1
[532.886363] Dynamic subtest vcs1: SUCCESS (9.853s)
[532.889531] Subtest timeout: SUCCESS (32.788s)
[532.973538] [133/133] (513s left) syncobj_wait (multi-wait-for-submit-submitted)
[533.033541] Starting subtest: multi-wait-for-submit-submitted
[533.139895] Subtest multi-wait-for-submit-submitted: SUCCESS (0.104s)
[533.235120] Closing watchdogs
results: parsing output: 0/ for test: kms_flip_scaled_crc
results: parsing output: 1/ for test: kms_hdr
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_pxp
results: parsing output: 4/ for test: kms_cursor_crc
results: parsing output: 5/ for test: i915_query
results: parsing output: 6/ for test: kms_psr2_su
results: parsing output: 7/ for test: kms_chamelium_hpd
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: gem_pxp
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: i915_drm_fdinfo
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: prime_busy
results: parsing output: 16/ for test: api_intel_bb
results: parsing output: 17/ for test: kms_draw_crc
results: parsing output: 18/ for test: perf
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: kms_psr2_sf
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: prime_self_import
results: parsing output: 28/ for test: gem_mmap_gtt
results: parsing output: 29/ for test: gem_ctx_persistence
results: parsing output: 30/ for test: i915_module_load
results: parsing output: 31/ for test: kms_color
results: parsing output: 32/ for test: prime_vgem
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_lmem_swapping
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: perf_pmu
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_ringfill
results: parsing output: 39/ for test: kms_cursor_edge_walk
results: parsing output: 40/ for test: gem_vm_create
results: parsing output: 41/ for test: gem_exec_capture
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: kms_invalid_mode
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: gem_softpin
results: parsing output: 47/ for test: prime_vgem
results: parsing output: 48/ for test: kms_atomic
results: parsing output: 49/ for test: gem_userptr_blits
results: parsing output: 50/ for test: gem_exec_schedule
results: parsing output: 51/ for test: syncobj_wait
results: parsing output: 52/ for test: gem_madvise
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: kms_chamelium_color
results: parsing output: 56/ for test: i915_pm_rpm
results: parsing output: 57/ for test: kms_chamelium_color
results: parsing output: 58/ for test: kms_rotation_crc
results: parsing output: 59/ for test: kms_async_flips
results: parsing output: 60/ for test: gem_exec_whisper
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: gem_eio
results: parsing output: 63/ for test: kms_plane_scaling
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: gem_ctx_sseu
results: parsing output: 67/ for test: kms_vblank
results: parsing output: 68/ for test: kms_busy
results: parsing output: 69/ for test: kms_dp_linktrain_fallback
results: parsing output: 70/ for test: perf_pmu
results: parsing output: 71/ for test: kms_addfb_basic
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: perf_pmu
results: parsing output: 74/ for test: gem_exec_balancer
results: parsing output: 75/ for test: kms_tiled_display
results: parsing output: 76/ for test: gem_mmap_gtt
results: parsing output: 77/ for test: gem_pread
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: syncobj_basic
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: gem_ppgtt
results: parsing output: 82/ for test: kms_pm_rpm
results: parsing output: 83/ for test: perf_pmu
results: parsing output: 84/ for test: gem_set_tiling_vs_blt
results: parsing output: 85/ for test: gem_create
results: parsing output: 86/ for test: kms_plane_lowres
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: kms_psr2_sf
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: drm_mm
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: gem_exec_balancer
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: kms_content_protection
results: parsing output: 97/ for test: gem_mmap_gtt
results: parsing output: 98/ for test: kms_atomic_transition
results: parsing output: 99/ for test: kms_lease
results: parsing output: 100/ for test: gem_exec_reloc
results: parsing output: 101/ for test: kms_plane_scaling
results: parsing output: 102/ for test: kms_rotation_crc
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: perf
results: parsing output: 105/ for test: gem_exec_fence
results: parsing output: 106/ for test: kms_rotation_crc
results: parsing output: 107/ for test: syncobj_wait
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: gem_exec_params
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_plane
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: api_intel_bb
results: parsing output: 116/ for test: kms_pm_rpm
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_pipe_crc_basic
results: parsing output: 120/ for test: gem_ctx_isolation
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: gem_softpin
results: parsing output: 127/ for test: gen9_exec_parse
results: parsing output: 128/ for test: gem_barrier_race
results: parsing output: 129/ for test: gem_exec_flush
results: parsing output: 130/ for test: gem_exec_schedule
results: parsing output: 131/ for test: sysfs_timeslice_duration
results: parsing output: 132/ for test: syncobj_wait
Done.