[58.702121] Initializing watchdogs
[58.702168]   /dev/watchdog0
[58.718399] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.723575] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.726397] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.729687] [001/133] (960s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[58.858682] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[58.862695] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[58.940979] [002/133] (960s left) kms_hdr (bpc-switch-dpms)
[59.040448] Starting subtest: bpc-switch-dpms
[60.093995] Starting dynamic subtest: pipe-A-eDP-1
[64.628951] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.535s)
[64.631456] Subtest bpc-switch-dpms: SUCCESS (5.591s)
[64.783324] [003/133] (954s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[64.888184] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[64.892173] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[65.002598] [004/133] (954s left) gem_pxp (display-protected-crc)
[65.130777] Starting subtest: display-protected-crc
[66.805065] Subtest display-protected-crc: SUCCESS (1.674s)
[66.982173] [005/133] (952s left) kms_cursor_crc (cursor-alpha-transparent)
[67.255904] Starting subtest: cursor-alpha-transparent
[67.258246] Starting dynamic subtest: pipe-A-eDP-1
[67.927225] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.670s)
[67.935983] Starting dynamic subtest: pipe-D-eDP-1
[69.169791] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.241s)
[69.172167] Subtest cursor-alpha-transparent: SUCCESS (1.913s)
[70.045740] [006/133] (949s left) i915_query (query-topology-garbage-items)
[70.101647] Starting subtest: query-topology-garbage-items
[70.103797] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[70.227810] [007/133] (949s left) kms_psr2_su (page_flip-xrgb8888)
[70.283961] Subtest page_flip-XRGB8888: SKIP (0.000s)
[70.351739] [008/133] (949s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[70.736436] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[71.548673] [009/133] (948s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[71.651946] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[71.654317] Starting dynamic subtest: pipe-A-eDP-1
[73.699106] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.049s)
[73.707367] Starting dynamic subtest: pipe-B-eDP-1
[75.938098] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.238s)
[75.948040] Starting dynamic subtest: pipe-C-eDP-1
[78.119669] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.181s)
[78.126612] Starting dynamic subtest: pipe-D-eDP-1
[80.211672] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.091s)
[80.213612] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.562s)
[81.411927] [010/133] (938s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[81.519830] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[86.786233] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.269s)
[87.921469] [011/133] (931s left) kms_flip (plain-flip-ts-check-interruptible)
[88.028787] Starting subtest: plain-flip-ts-check-interruptible
[88.031119] Starting dynamic subtest: A-eDP1
[96.886026] Dynamic subtest A-eDP1: SUCCESS (8.854s)
[96.896685] Starting dynamic subtest: B-eDP1
[105.725185] Dynamic subtest B-eDP1: SUCCESS (8.837s)
[105.734954] Starting dynamic subtest: C-eDP1
[114.540644] Dynamic subtest C-eDP1: SUCCESS (8.814s)
[114.549160] Starting dynamic subtest: D-eDP1
[123.361680] Dynamic subtest D-eDP1: SUCCESS (8.820s)
[123.366710] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.336s)
[124.565312] [012/133] (895s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[124.647063] Starting subtest: verify-pxp-execution-after-suspend-resume
[131.842694] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.196s)
[138.006357] [013/133] (887s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[138.077328] Starting subtest: invalid-single-wait-unsubmitted
[138.079583] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[138.200300] [014/133] (887s left) i915_drm_fdinfo (memory-info-purgeable)
[138.234923] Starting subtest: memory-info-purgeable
[138.237133] Starting dynamic subtest: smem0
[141.032986] Dynamic subtest smem0: SUCCESS (2.799s)
[141.035110] Subtest memory-info-purgeable: SUCCESS (2.800s)
[141.115146] [015/133] (884s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[141.224681] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[145.398042] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.175s)
[146.616563] [016/133] (879s left) prime_busy (before-wait)
[146.684703] Starting subtest: before-wait
[146.686996] Starting dynamic subtest: rcs0
[146.712252] Dynamic subtest rcs0: SUCCESS (0.025s)
[146.722232] Starting dynamic subtest: bcs0
[146.769096] Dynamic subtest bcs0: SUCCESS (0.056s)
[146.778724] Starting dynamic subtest: vcs0
[146.809411] Dynamic subtest vcs0: SUCCESS (0.040s)
[146.817993] Starting dynamic subtest: vcs1
[146.851354] Dynamic subtest vcs1: SUCCESS (0.042s)
[146.860082] Starting dynamic subtest: vecs0
[146.891966] Dynamic subtest vecs0: SUCCESS (0.040s)
[146.900654] Starting dynamic subtest: ccs0
[146.931571] Dynamic subtest ccs0: SUCCESS (0.039s)
[147.040980] Subtest before-wait: SUCCESS (0.355s)
[147.136386] [017/133] (878s left) api_intel_bb (simple-bb)
[147.194113] Starting subtest: simple-bb
[147.198997] Subtest simple-bb: SUCCESS (0.007s)
[147.342186] [018/133] (878s left) kms_draw_crc (draw-method-mmap-gtt)
[147.430747] Starting subtest: draw-method-mmap-gtt
[147.435063] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[147.545240] [019/133] (878s left) perf (sysctl-defaults)
[147.613659] Starting subtest: sysctl-defaults
[147.616049] Subtest sysctl-defaults: SUCCESS (0.000s)
[147.705855] [020/133] (878s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[147.810181] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[154.821425] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.012s)
[155.000332] [021/133] (871s left) kms_flip (nonexisting-fb)
[155.096017] Starting subtest: nonexisting-fb
[155.098334] Starting dynamic subtest: A-eDP1
[156.294658] Dynamic subtest A-eDP1: SUCCESS (1.198s)
[156.304038] Starting dynamic subtest: B-eDP1
[157.432450] Dynamic subtest B-eDP1: SUCCESS (1.137s)
[157.442529] Starting dynamic subtest: C-eDP1
[158.563279] Dynamic subtest C-eDP1: SUCCESS (1.129s)
[158.572324] Starting dynamic subtest: D-eDP1
[159.692284] Dynamic subtest D-eDP1: SUCCESS (1.127s)
[159.694582] Subtest nonexisting-fb: SUCCESS (4.600s)
[160.905621] [022/133] (865s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[161.022211] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[161.026626] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[161.100985] [023/133] (864s left) gem_exec_schedule (timeslicing)
[161.183390] Starting subtest: timeslicing
[161.185248] Starting dynamic subtest: rcs0
[161.198353] Dynamic subtest rcs0: SUCCESS (0.024s)
[161.212596] Starting dynamic subtest: bcs0
[161.219866] Dynamic subtest bcs0: SUCCESS (0.020s)
[161.228497] Starting dynamic subtest: vcs0
[161.241238] Dynamic subtest vcs0: SUCCESS (0.021s)
[161.249174] Starting dynamic subtest: vcs1
[161.267009] Dynamic subtest vcs1: SUCCESS (0.024s)
[161.277596] Starting dynamic subtest: vecs0
[161.288420] Dynamic subtest vecs0: SUCCESS (0.020s)
[161.301935] Starting dynamic subtest: ccs0
[161.308269] Dynamic subtest ccs0: SUCCESS (0.019s)
[161.310744] Subtest timeslicing: SUCCESS (0.135s)
[162.948189] [024/133] (863s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[163.060163] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[163.064496] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[163.187802] [025/133] (862s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[163.318275] Starting subtest: flip-vs-cursor-atomic-transitions
[170.822583] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.503s)
[171.635054] [026/133] (854s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[171.723723] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[171.728039] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[171.819543] [027/133] (854s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[171.941351] Starting subtest: basic-flip-after-cursor-legacy
[172.854950] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.912s)
[173.659366] [028/133] (852s left) prime_self_import (export-vs-gem_close-race)
[173.699836] Starting subtest: export-vs-gem_close-race
[178.778678] Subtest export-vs-gem_close-race: SUCCESS (5.080s)
[178.878208] [029/133] (847s left) gem_mmap_gtt (zero-extend)
[178.954394] Subtest zero-extend: SKIP (0.000s)
[179.048644] [030/133] (847s left) gem_ctx_persistence (legacy-engines-persistence)
[179.146949] Starting subtest: legacy-engines-persistence
[179.149513] Starting dynamic subtest: render
[180.027800] Dynamic subtest render: SUCCESS (0.879s)
[180.041071] Starting dynamic subtest: bsd1
[180.851913] Dynamic subtest bsd1: SUCCESS (0.821s)
[180.864848] Starting dynamic subtest: bsd2
[181.668966] Dynamic subtest bsd2: SUCCESS (0.814s)
[181.681160] Starting dynamic subtest: blt
[182.441496] Dynamic subtest blt: SUCCESS (0.770s)
[182.452695] Starting dynamic subtest: vebox
[183.277332] Dynamic subtest vebox: SUCCESS (0.833s)
[183.279942] Subtest legacy-engines-persistence: SUCCESS (4.131s)
[183.372141] [031/133] (843s left) i915_module_load (reload)
[183.405174] Starting subtest: reload
[188.407544] Subtest reload: SUCCESS (5.002s)
[188.445393] [032/133] (838s left) kms_color (degamma)
[189.919923] Starting subtest: degamma
[189.922128] Starting dynamic subtest: pipe-A-eDP-1
[190.667407] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.748s)
[190.677563] Starting dynamic subtest: pipe-B-eDP-1
[192.055561] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.385s)
[192.064154] Starting dynamic subtest: pipe-C-eDP-1
[193.424969] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.371s)
[193.434683] Starting dynamic subtest: pipe-D-eDP-1
[194.777432] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.352s)
[194.779752] Subtest degamma: SUCCESS (4.859s)
[195.600167] [033/133] (830s left) prime_vgem (basic-fence-mmap)
[195.724592] Starting subtest: basic-fence-mmap
[195.729243] Subtest basic-fence-mmap: SKIP (0.000s)
[195.845725] [FACT prime_vgem (basic-fence-mmap)] new: kernel.kmod_is_loaded.vgem: true
[195.849095] [034/133] (830s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[195.954624] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[195.958581] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[196.083503] [035/133] (830s left) gem_lmem_swapping (parallel-random-engines)
[196.132339] Subtest parallel-random-engines: SKIP (0.000s)
[196.175360] [036/133] (830s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[196.272079] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[203.377865] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.106s)
[203.553564] [037/133] (823s left) perf_pmu (init-busy)
[203.600234] Starting subtest: init-busy
[203.602452] Starting dynamic subtest: rcs0
[203.604675] Dynamic subtest rcs0: SUCCESS (0.002s)
[203.613470] Starting dynamic subtest: bcs0
[203.615359] Dynamic subtest bcs0: SUCCESS (0.000s)
[203.622864] Starting dynamic subtest: vcs0
[203.624679] Dynamic subtest vcs0: SUCCESS (0.001s)
[203.632267] Starting dynamic subtest: vcs1
[203.634109] Dynamic subtest vcs1: SUCCESS (0.000s)
[203.641351] Starting dynamic subtest: vecs0
[203.643244] Dynamic subtest vecs0: SUCCESS (0.001s)
[203.650622] Starting dynamic subtest: ccs0
[203.652531] Dynamic subtest ccs0: SUCCESS (0.000s)
[203.654425] Subtest init-busy: SUCCESS (0.008s)
[203.740092] [038/133] (822s left) kms_frontbuffer_tracking (fbc-1p-rte)
[203.835327] Starting subtest: fbc-1p-rte
[209.256905] Subtest fbc-1p-rte: SUCCESS (5.426s)
[210.484181] [039/133] (816s left) gem_ringfill (basic-all)
[215.895969] Starting subtest: basic-all
[217.064416] Subtest basic-all: SUCCESS (1.169s)
[217.239288] [040/133] (809s left) kms_cursor_edge_walk (128x128-left-edge)
[217.342307] Starting subtest: 128x128-left-edge
[217.344522] Starting dynamic subtest: pipe-A-eDP-1
[220.818438] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.473s)
[220.826821] Starting dynamic subtest: pipe-D-eDP-1
[223.929387] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.109s)
[223.931688] Subtest 128x128-left-edge: SUCCESS (6.585s)
[224.755161] [041/133] (802s left) gem_vm_create (create-ext)
[224.825165] Starting subtest: create-ext
[224.830437] Subtest create-ext: SUCCESS (0.004s)
[224.977976] [042/133] (801s left) gem_exec_capture (userptr)
[225.038939] Starting subtest: userptr
[225.875304] Subtest userptr: SUCCESS (0.833s)
[226.025078] [043/133] (800s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[226.257844] Starting subtest: cursor-rapid-movement-256x256
[226.263414] Starting dynamic subtest: pipe-A-eDP-1
[226.810753] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.547s)
[226.840591] Starting dynamic subtest: pipe-D-eDP-1
[228.055845] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.222s)
[228.058152] Subtest cursor-rapid-movement-256x256: SUCCESS (1.797s)
[228.925220] [044/133] (798s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[229.036483] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[229.038798] Starting dynamic subtest: pipe-A-eDP-1
[229.061675] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[229.072177] Starting dynamic subtest: pipe-B-eDP-1
[229.092608] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[229.100885] Starting dynamic subtest: pipe-C-eDP-1
[229.122447] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[229.131953] Starting dynamic subtest: pipe-D-eDP-1
[229.154168] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[229.158519] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[231.186285] [045/133] (795s left) kms_invalid_mode (zero-hdisplay)
[231.290668] Starting subtest: zero-hdisplay
[231.292873] Starting dynamic subtest: pipe-A-eDP-1
[231.573536] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[231.582619] Starting dynamic subtest: pipe-B-eDP-1
[231.584548] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[231.592137] Starting dynamic subtest: pipe-C-eDP-1
[231.594012] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[231.602270] Starting dynamic subtest: pipe-D-eDP-1
[231.604516] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[231.606727] Subtest zero-hdisplay: SUCCESS (0.291s)
[232.412878] [046/133] (794s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[232.522493] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[233.511843] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.989s)
[233.671405] [047/133] (793s left) gem_softpin (evict-snoop)
[233.734758] Starting subtest: evict-snoop
[233.738947] Subtest evict-snoop: SKIP (0.000s)
[233.881121] [048/133] (793s left) prime_vgem (basic-write)
[233.966858] Starting subtest: basic-write
[233.976427] Subtest basic-write: SKIP (0.008s)
[234.101650] [049/133] (793s left) kms_atomic (plane-invalid-params)
[234.197235] Starting subtest: plane-invalid-params
[234.198825] Starting dynamic subtest: pipe-A-eDP-1
[234.599270] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.401s)
[234.601609] Subtest plane-invalid-params: SUCCESS (0.403s)
[235.443232] [050/133] (791s left) gem_userptr_blits (unsync-unmap-cycles)
[235.521947] Subtest unsync-unmap-cycles: SKIP (0.000s)
[235.681561] [051/133] (791s left) gem_exec_schedule (preempt-contexts)
[235.759286] Starting subtest: preempt-contexts
[235.761602] Starting dynamic subtest: rcs0
[235.810678] Dynamic subtest rcs0: SUCCESS (0.058s)
[235.818998] Starting dynamic subtest: bcs0
[235.865881] Dynamic subtest bcs0: SUCCESS (0.055s)
[235.876051] Starting dynamic subtest: vcs0
[235.918884] Dynamic subtest vcs0: SUCCESS (0.052s)
[235.927628] Starting dynamic subtest: vcs1
[235.974104] Dynamic subtest vcs1: SUCCESS (0.050s)
[235.982355] Starting dynamic subtest: vecs0
[236.017605] Dynamic subtest vecs0: SUCCESS (0.044s)
[236.027249] Starting dynamic subtest: ccs0
[236.060618] Dynamic subtest ccs0: SUCCESS (0.043s)
[236.062721] Subtest preempt-contexts: SUCCESS (0.309s)
[238.029482] [052/133] (789s left) syncobj_wait (wait-any-interrupted)
[238.099526] Starting subtest: wait-any-interrupted
[238.202362] Subtest wait-any-interrupted: SUCCESS (0.102s)
[238.303344] [053/133] (789s left) gem_madvise (dontneed-before-exec)
[238.338564] Starting subtest: dontneed-before-exec
[238.364179] Subtest dontneed-before-exec: SKIP (0.025s)
[238.435906] [054/133] (788s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[238.528816] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[238.531037] Starting dynamic subtest: pipe-A-eDP-1
[238.552839] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[238.564270] Starting dynamic subtest: pipe-B-eDP-1
[238.586845] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[238.602699] Starting dynamic subtest: pipe-C-eDP-1
[238.624619] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[238.640521] Starting dynamic subtest: pipe-D-eDP-1
[238.662890] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[238.667329] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[240.793120] [055/133] (786s left) kms_psr (psr2-basic)
[240.892885] Starting subtest: psr2-basic
[240.895171] Starting dynamic subtest: eDP-1
[242.452777] Dynamic subtest eDP-1: SUCCESS (1.559s)
[242.454966] Subtest psr2-basic: SUCCESS (1.560s)
[243.250952] [056/133] (784s left) kms_chamelium_color (gamma)
[243.338231] Subtest gamma: SKIP (0.000s)
[243.384246] [057/133] (784s left) i915_pm_rpm (system-suspend-devices)
[245.016943] Starting subtest: system-suspend-devices
[252.660231] Subtest system-suspend-devices: SUCCESS (7.645s)
[259.080488] [058/133] (774s left) kms_chamelium_color (ctm-0-25)
[259.191293] Subtest ctm-0-25: SKIP (0.000s)
[259.236805] [059/133] (774s left) kms_rotation_crc (primary-rotation-90)
[259.332168] Starting subtest: primary-rotation-90
[259.336272] Subtest primary-rotation-90: SKIP (0.001s)
[259.416947] [060/133] (774s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[259.511928] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[259.912309] Starting dynamic subtest: pipe-A-eDP-1
[262.618180] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.705s)
[262.985635] Starting dynamic subtest: pipe-B-eDP-1
[265.752592] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.773s)
[266.121760] Starting dynamic subtest: pipe-C-eDP-1
[268.884403] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.768s)
[269.259762] Starting dynamic subtest: pipe-D-eDP-1
[272.023902] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.775s)
[272.026365] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.512s)
[273.217449] [061/133] (760s left) gem_exec_whisper (basic-queues)
[273.281783] Starting subtest: basic-queues
[278.353830] Subtest basic-queues: SUCCESS (5.071s)
[278.556503] [062/133] (755s left) kms_big_fb (4-tiled-addfb-size-overflow)
[278.674971] Starting subtest: 4-tiled-addfb-size-overflow
[278.677300] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[278.782466] [063/133] (754s left) gem_eio (suspend)
[279.050736] Starting subtest: suspend
[291.313387] Subtest suspend: SUCCESS (12.260s)
[301.499490] [064/133] (742s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[301.602876] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[301.605205] Starting dynamic subtest: pipe-A
[301.664850] Dynamic subtest pipe-A: SUCCESS (0.064s)
[301.675399] Starting dynamic subtest: pipe-B
[302.791617] Dynamic subtest pipe-B: SUCCESS (1.126s)
[302.802310] Starting dynamic subtest: pipe-C
[303.901263] Dynamic subtest pipe-C: SUCCESS (1.108s)
[303.910786] Starting dynamic subtest: pipe-D
[305.019198] Dynamic subtest pipe-D: SUCCESS (1.117s)
[305.021702] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.419s)
[306.194540] [065/133] (737s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[306.302271] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[306.306192] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[306.429626] [066/133] (737s left) kms_psr (fbc-psr2-suspend)
[306.542900] Starting subtest: fbc-psr2-suspend
[306.545068] Starting dynamic subtest: eDP-1
[306.548875] Dynamic subtest eDP-1: SKIP (0.000s)
[306.552786] Subtest fbc-psr2-suspend: SKIP (0.001s)
[306.630769] [067/133] (737s left) gem_ctx_sseu (engines)
[306.705165] Subtest engines: SKIP (0.000s)
[306.789693] [068/133] (737s left) kms_vblank (wait-idle)
[306.889744] Starting subtest: wait-idle
[306.891926] Starting dynamic subtest: pipe-A-eDP-1
[308.653426] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.761s)
[308.668828] Starting dynamic subtest: pipe-D-eDP-1
[311.112461] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.455s)
[311.114753] Subtest wait-idle: SUCCESS (4.222s)
[311.955201] [069/133] (732s left) kms_busy (extended-pageflip-hang-oldfb)
[312.058266] Starting subtest: extended-pageflip-hang-oldfb
[312.060571] Starting dynamic subtest: pipe-A
[312.462056] Dynamic subtest pipe-A: SUCCESS (0.402s)
[312.471492] Starting dynamic subtest: pipe-D
[313.594970] Dynamic subtest pipe-D: SUCCESS (1.131s)
[313.597072] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.538s)
[314.427423] [070/133] (729s left) kms_dp_linktrain_fallback (dsc-fallback)
[314.528671] Starting subtest: dsc-fallback
[314.534678] Subtest dsc-fallback: SKIP (0.000s)
[314.625502] [071/133] (729s left) perf_pmu (invalid-init)
[314.669226] Starting subtest: invalid-init
[314.671615] Subtest invalid-init: SUCCESS (0.000s)
[314.832099] [072/133] (729s left) kms_addfb_basic (bad-pitch-63)
[314.890609] Starting subtest: bad-pitch-63
[314.892582] Subtest bad-pitch-63: SUCCESS (0.000s)
[315.072765] [073/133] (729s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[315.177423] Starting subtest: fbc-2p-pri-indfb-multidraw
[315.181650] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[315.318417] [074/133] (728s left) perf_pmu (busy-double-start)
[315.354681] Starting subtest: busy-double-start
[315.356474] Starting dynamic subtest: rcs0
[318.993864] Dynamic subtest rcs0: FAIL (3.589s)
[319.004181] Starting dynamic subtest: bcs0
[322.574689] Dynamic subtest bcs0: SUCCESS (3.631s)
[322.585968] Starting dynamic subtest: vcs0
[326.422728] Dynamic subtest vcs0: SUCCESS (3.846s)
[326.434739] Starting dynamic subtest: vcs1
[330.501561] Dynamic subtest vcs1: SUCCESS (4.077s)
[330.513382] Starting dynamic subtest: vecs0
[334.443803] Dynamic subtest vecs0: SUCCESS (3.940s)
[334.455675] Starting dynamic subtest: ccs0
[338.078760] Dynamic subtest ccs0: FAIL (3.566s)
[338.081361] Subtest busy-double-start: FAIL (22.660s)
[338.156274] [075/133] (706s left) gem_exec_balancer (parallel-bb-first)
[338.423654] Starting subtest: parallel-bb-first
[339.358412] Subtest parallel-bb-first: SUCCESS (0.935s)
[339.914967] [076/133] (704s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[340.036959] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[340.081508] [077/133] (704s left) gem_mmap_gtt (bad-object)
[340.140239] Subtest bad-object: SKIP (0.000s)
[340.211148] [078/133] (704s left) gem_pread (snoop)
[340.274753] Subtest snoop: SKIP (0.000s)
[340.348183] [079/133] (704s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[340.440997] Starting subtest: y-tiled-addfb-size-offset-overflow
[340.445210] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[340.567533] [080/133] (703s left) syncobj_basic (bad-handle-to-fd)
[340.627390] Starting subtest: bad-handle-to-fd
[340.629569] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[340.751295] [081/133] (703s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[340.800344] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[340.904941] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s)
[340.994182] [082/133] (703s left) gem_ppgtt (blt-vs-render-ctx0)
[341.044063] Starting subtest: blt-vs-render-ctx0
[374.223343] Subtest blt-vs-render-ctx0: SUCCESS (33.176s)
[374.382897] [083/133] (670s left) kms_pm_rpm (pm-tiling)
[375.994415] Starting subtest: pm-tiling
[375.998869] Subtest pm-tiling: SKIP (0.000s)
[376.752836] [084/133] (667s left) perf_pmu (all-busy-idle-check-all)
[376.791102] Starting subtest: all-busy-idle-check-all
[377.941424] Subtest all-busy-idle-check-all: SUCCESS (1.152s)
[378.052642] [085/133] (666s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[378.117719] Subtest untiled-to-tiled: SKIP (0.000s)
[378.201248] [086/133] (666s left) gem_create (create-ext-set-pat)
[378.385560] Starting subtest: create-ext-set-pat
[378.387529] Subtest create-ext-set-pat: SUCCESS (0.001s)
[378.503948] [087/133] (666s left) kms_plane_lowres (tiling-4)
[378.588831] Starting subtest: tiling-4
[378.591164] Starting dynamic subtest: pipe-A-eDP-1
[378.595505] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[378.882533] Starting dynamic subtest: pipe-B-eDP-1
[378.888244] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[378.898548] Starting dynamic subtest: pipe-C-eDP-1
[378.904189] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[378.925275] Starting dynamic subtest: pipe-D-eDP-1
[378.929719] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[378.934043] Subtest tiling-4: SKIP (0.292s)
[379.771367] [088/133] (665s left) syncobj_timeline (wait-any-interrupted)
[379.835547] Starting subtest: wait-any-interrupted
[379.939612] Subtest wait-any-interrupted: SUCCESS (0.102s)
[380.042939] [089/133] (664s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[380.144103] Starting subtest: pr-cursor-plane-move-continuous-sf
[380.148178] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[380.240768] [090/133] (664s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[380.309192] Starting subtest: etime-multi-wait-all-for-submit-submitted
[380.416959] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.106s)
[380.522429] [091/133] (664s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[380.645768] Starting subtest: short-flip-after-cursor-atomic-transitions
[381.607752] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.959s)
[382.505568] [092/133] (662s left) drm_mm (drm_mm)
[382.550167] Starting subtest: drm_mm
[382.592594] Starting dynamic subtest: drm_test_mm_init
[382.738068] Dynamic subtest drm_test_mm_init: SUCCESS (0.145s)
[382.749098] Starting dynamic subtest: drm_test_mm_debug
[382.884203] Dynamic subtest drm_test_mm_debug: SUCCESS (0.144s)
[382.895946] Starting dynamic subtest: drm_test_mm_align32
[383.017966] Dynamic subtest drm_test_mm_align32: SUCCESS (0.134s)
[383.029122] Starting dynamic subtest: drm_test_mm_align64
[383.158101] Dynamic subtest drm_test_mm_align64: SUCCESS (0.138s)
[383.167797] Starting dynamic subtest: drm_test_mm_lowest
[383.285070] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.125s)
[383.295688] Starting dynamic subtest: drm_test_mm_highest
[383.442222] Dynamic subtest drm_test_mm_highest: SUCCESS (0.155s)
[383.444274] Subtest drm_mm: SUCCESS (0.890s)
[383.690578] [093/133] (661s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[383.782260] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[383.786781] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[384.931906] [094/133] (660s left) gem_exec_balancer (smoke)
[384.991128] Starting subtest: smoke
[407.548618] Subtest smoke: SUCCESS (22.555s)
[408.466312] [095/133] (636s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[408.580404] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[409.692579] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.112s)
[409.851696] [096/133] (635s left) kms_flip (2x-flip-vs-fences-interruptible)
[409.949535] Starting subtest: 2x-flip-vs-fences-interruptible
[409.953029] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[410.103768] [097/133] (635s left) kms_content_protection (legacy-hdcp14)
[410.249932] Starting subtest: legacy-hdcp14
[410.253847] Subtest legacy-hdcp14: SKIP (0.000s)
[410.379536] [098/133] (634s left) gem_mmap_gtt (basic-write-read)
[410.436815] Subtest basic-write-read: SKIP (0.000s)
[410.507087] [099/133] (634s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[410.605104] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[410.606934] Starting dynamic subtest: pipe-A-eDP-1
[410.665594] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[410.973420] Starting dynamic subtest: pipe-B-eDP-1
[411.822388] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.858s)
[412.137946] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.531s)
[412.998489] [100/133] (632s left) kms_lease (invalid-create-leases)
[413.102280] Starting subtest: invalid-create-leases
[413.106734] Subtest invalid-create-leases: SUCCESS (0.005s)
[413.270219] [101/133] (632s left) gem_exec_reloc (basic-cpu-wc)
[413.344127] Subtest basic-cpu-wc: SKIP (0.000s)
[413.417770] [102/133] (632s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[413.518846] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[413.521162] Starting dynamic subtest: pipe-A
[413.756627] Dynamic subtest pipe-A: SUCCESS (0.240s)
[413.767024] Starting dynamic subtest: pipe-B
[415.066958] Dynamic subtest pipe-B: SUCCESS (1.309s)
[415.077306] Starting dynamic subtest: pipe-C
[416.390066] Dynamic subtest pipe-C: SUCCESS (1.322s)
[416.405397] Starting dynamic subtest: pipe-D
[417.718131] Dynamic subtest pipe-D: SUCCESS (1.327s)
[417.720422] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.202s)
[418.905412] [103/133] (626s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[418.999312] Starting subtest: primary-yf-tiled-reflect-x-180
[419.060739] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.060s)
[419.176736] [104/133] (626s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[419.273390] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[419.277721] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[419.403551] [105/133] (626s left) perf (invalid-oa-metric-set-id)
[419.534391] Starting subtest: invalid-oa-metric-set-id
[419.546992] Subtest invalid-oa-metric-set-id: SUCCESS (0.013s)
[419.588870] [106/133] (626s left) gem_exec_fence (syncobj-repeat)
[420.037822] Starting subtest: syncobj-repeat
[420.219902] Subtest syncobj-repeat: SUCCESS (0.181s)
[422.034030] [107/133] (623s left) kms_rotation_crc (multiplane-rotation)
[422.134122] Starting subtest: multiplane-rotation
[439.672855] Subtest multiplane-rotation: SUCCESS (17.538s)
[439.819142] [108/133] (605s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[439.890202] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[439.892087] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[440.030194] [109/133] (605s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[440.134939] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[440.138292] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[440.264091] [110/133] (605s left) syncobj_timeline (etime-single-wait-all-submitted)
[440.326423] Starting subtest: etime-single-wait-all-submitted
[440.433034] Subtest etime-single-wait-all-submitted: SUCCESS (0.106s)
[440.522108] [111/133] (605s left) gem_exec_params (invalid-flag)
[440.590662] Starting subtest: invalid-flag
[440.593092] Subtest invalid-flag: SUCCESS (0.000s)
[440.728258] [112/133] (605s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[440.828506] Starting subtest: yf-tiled-64bpp-rotate-0
[440.832873] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[440.935379] [113/133] (604s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[441.032132] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[442.127482] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: FAIL (0.509s)
[442.169589] [114/133] (603s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[442.260462] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[442.287116] Starting dynamic subtest: pipe-A-plane-0
[442.577191] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[442.586759] Starting dynamic subtest: pipe-A-plane-3
[442.820905] Dynamic subtest pipe-A-plane-3: SUCCESS (0.241s)
[443.885505] Starting dynamic subtest: pipe-B-plane-0
[444.176995] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[444.190112] Starting dynamic subtest: pipe-B-plane-3
[444.411712] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[444.730439] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.470s)
[445.571075] [115/133] (600s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[445.679640] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[454.259620] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.583s)
[454.401089] [116/133] (591s left) api_intel_bb (add-remove-objects)
[454.462489] Starting subtest: add-remove-objects
[454.467165] Subtest add-remove-objects: SUCCESS (0.007s)
[454.574372] [117/133] (591s left) kms_pm_rpm (cursor-dpms)
[456.101996] Starting subtest: cursor-dpms
[456.107216] Subtest cursor-dpms: SKIP (0.000s)
[456.851918] [118/133] (589s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[456.948142] Starting subtest: fbcpsr-rgb101010-draw-render
[463.706048] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.760s)
[463.843444] [119/133] (582s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[463.945675] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[463.949736] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[464.046844] [120/133] (582s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[464.147748] Starting subtest: disable-crc-after-crtc
[464.149922] Starting dynamic subtest: pipe-A-eDP-1
[465.792708] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.643s)
[465.803701] Starting dynamic subtest: pipe-B-eDP-1
[468.056720] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.265s)
[468.067735] Starting dynamic subtest: pipe-C-eDP-1
[470.294339] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.234s)
[470.305138] Starting dynamic subtest: pipe-D-eDP-1
[472.571555] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.275s)
[472.573676] Subtest disable-crc-after-crtc: SUCCESS (8.424s)
[473.416361] [121/133] (572s left) gem_ctx_isolation (clean)
[473.478864] Starting subtest: clean
[473.481260] Starting dynamic subtest: rcs0
[473.530690] Dynamic subtest rcs0: SUCCESS (0.052s)
[473.542405] Starting dynamic subtest: bcs0
[473.628754] Dynamic subtest bcs0: SUCCESS (0.097s)
[473.640813] Starting dynamic subtest: vcs0
[473.726857] Dynamic subtest vcs0: SUCCESS (0.096s)
[473.737446] Starting dynamic subtest: vcs1
[474.905082] Dynamic subtest vcs1: SUCCESS (1.178s)
[474.917037] Starting dynamic subtest: vecs0
[476.937954] Dynamic subtest vecs0: SUCCESS (2.032s)
[476.949178] Starting dynamic subtest: ccs0
[478.942040] Dynamic subtest ccs0: SUCCESS (2.003s)
[478.944516] Subtest clean: SUCCESS (5.464s)
[479.211168] [122/133] (567s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[479.274533] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[479.276904] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[479.396997] [123/133] (566s left) kms_psr (fbc-psr2-primary-page-flip)
[479.496857] Starting subtest: fbc-psr2-primary-page-flip
[479.499183] Starting dynamic subtest: eDP-1
[479.503464] Dynamic subtest eDP-1: SKIP (0.000s)
[479.507805] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[479.582866] [124/133] (566s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[479.685572] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[479.689920] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[479.797561] [125/133] (566s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[479.910293] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[479.914363] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[480.051425] [126/133] (566s left) kms_psr (psr-basic)
[480.154512] Starting subtest: psr-basic
[480.156465] Starting dynamic subtest: eDP-1
[481.795393] Dynamic subtest eDP-1: SUCCESS (1.640s)
[481.797261] Subtest psr-basic: SUCCESS (1.641s)
[482.694409] [127/133] (563s left) gem_softpin (allocator-fork)
[482.757724] Starting subtest: allocator-fork
[484.969406] Subtest allocator-fork: SUCCESS (2.210s)
[485.126139] [128/133] (561s left) gen9_exec_parse (bb-start-cmd)
[485.194575] Subtest bb-start-cmd: SKIP (0.000s)
[485.284341] [129/133] (561s left) gem_barrier_race (remote-request)
[485.351800] Starting subtest: remote-request
[485.353718] Starting dynamic subtest: rcs0
[490.508289] Dynamic subtest rcs0: SUCCESS (5.159s)
[490.510244] Subtest remote-request: SUCCESS (5.160s)
[490.680483] [130/133] (555s left) gem_exec_flush (basic-uc-ro-default)
[490.756336] Starting subtest: basic-uc-ro-default
[496.214578] Subtest basic-uc-ro-default: SUCCESS (5.462s)
[496.414046] [131/133] (550s left) gem_exec_schedule (implicit-boths)
[496.496931] Starting subtest: implicit-boths
[496.499153] Starting dynamic subtest: rcs0
[496.688178] Dynamic subtest rcs0: SUCCESS (0.198s)
[496.699732] Starting dynamic subtest: vcs0
[496.804650] Dynamic subtest vcs0: SUCCESS (0.115s)
[496.818321] Starting dynamic subtest: vcs1
[496.910881] Dynamic subtest vcs1: SUCCESS (0.107s)
[496.923483] Starting dynamic subtest: vecs0
[497.035944] Dynamic subtest vecs0: SUCCESS (0.124s)
[497.051571] Starting dynamic subtest: ccs0
[497.174748] Dynamic subtest ccs0: SUCCESS (0.138s)
[497.177266] Subtest implicit-boths: SUCCESS (0.686s)
[498.010683] [132/133] (548s left) sysfs_timeslice_duration (timeout)
[498.065692] Starting subtest: timeout
[498.067513] Starting dynamic subtest: vecs0
[507.947841] Dynamic subtest vecs0: SUCCESS (9.880s)
[507.959598] Starting dynamic subtest: ccs0
[509.402108] Dynamic subtest ccs0: SUCCESS (1.453s)
[509.416448] Starting dynamic subtest: vcs0
[518.961312] Dynamic subtest vcs0: SUCCESS (9.556s)
[518.974158] Starting dynamic subtest: bcs0
[519.644524] Dynamic subtest bcs0: SUCCESS (0.682s)
[519.655065] Starting dynamic subtest: rcs0
[521.030840] Dynamic subtest rcs0: SUCCESS (1.385s)
[521.047398] Starting dynamic subtest: vcs1
[530.920525] Dynamic subtest vcs1: SUCCESS (9.885s)
[530.923511] Subtest timeout: SUCCESS (32.856s)
[531.016705] [133/133] (515s left) syncobj_wait (multi-wait-for-submit-submitted)
[531.088568] Starting subtest: multi-wait-for-submit-submitted
[531.192545] Subtest multi-wait-for-submit-submitted: SUCCESS (0.103s)
[531.284443] 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.