[57.180598] Initializing watchdogs
[57.180643]   /dev/watchdog0
[57.195174] [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]
[57.199808] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.202041] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.205238] [001/132] (960s left) kms_psr (psr2-primary-mmap-gtt)
[57.323783] Starting subtest: psr2-primary-mmap-gtt
[57.326088] Starting dynamic subtest: eDP-1
[58.734935] Dynamic subtest eDP-1: SKIP (1.410s)
[58.740158] Subtest psr2-primary-mmap-gtt: SKIP (1.411s)
[58.846433] [002/132] (958s left) gem_exec_reloc (basic-write-gtt-active)
[58.921416] Subtest basic-write-gtt-active: SKIP (0.000s)
[58.990397] [003/132] (958s left) prime_self_import (export-vs-gem_close-race)
[59.022623] Starting subtest: export-vs-gem_close-race
[64.125314] Subtest export-vs-gem_close-race: SUCCESS (5.108s)
[64.198588] [004/132] (953s left) kms_feature_discovery (psr2)
[64.307632] Starting subtest: psr2
[64.309779] Subtest psr2: SUCCESS (0.000s)
[64.381050] [005/132] (953s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[64.496772] Starting subtest: extended-modeset-hang-newfb-with-reset
[64.498710] Starting dynamic subtest: pipe-A
[78.350631] Dynamic subtest pipe-A: SUCCESS (13.863s)
[78.359988] Starting dynamic subtest: pipe-D
[94.234437] Dynamic subtest pipe-D: SUCCESS (15.886s)
[94.236375] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.753s)
[95.028981] [006/132] (922s left) gem_ctx_param (get-priority-new-ctx)
[95.093166] Starting subtest: get-priority-new-ctx
[95.095821] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[95.209966] [007/132] (922s left) gem_exec_fence (submit67)
[95.381765] Starting subtest: submit67
[95.386684] Subtest submit67: SKIP (0.000s)
[97.355564] [FACT gem_exec_fence (submit67)] new: kernel.kmod_is_loaded.vgem: true
[97.358881] [008/132] (920s left) gem_exec_params (secure-non-master)
[97.417352] Starting subtest: secure-non-master
[97.421790] Subtest secure-non-master: SKIP (0.000s)
[97.511019] [009/132] (920s left) gem_softpin (evict-active)
[97.566779] Starting subtest: evict-active
[97.582035] Subtest evict-active: SUCCESS (0.014s)
[97.717224] [010/132] (920s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[97.818528] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[97.820935] Starting dynamic subtest: pipe-A-eDP-1
[97.892931] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[97.903478] Starting dynamic subtest: pipe-B-eDP-1
[99.012976] Dynamic subtest pipe-B-eDP-1: SKIP (1.118s)
[99.018169] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.198s)
[100.285980] [011/132] (917s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[100.376662] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[100.379071] Starting dynamic subtest: pipe-A-eDP-1
[100.624845] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.217s)
[100.632766] Starting dynamic subtest: pipe-B-eDP-1
[101.855375] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.230s)
[101.865714] Starting dynamic subtest: pipe-C-eDP-1
[103.078940] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.225s)
[103.088626] Starting dynamic subtest: pipe-D-eDP-1
[104.296667] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.216s)
[104.298857] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.891s)
[105.435516] [012/132] (912s left) drm_mm (drm_mm)
[105.470577] Starting subtest: drm_mm
[105.479961] Starting dynamic subtest: drm_test_mm_init
[105.575454] Dynamic subtest drm_test_mm_init: SUCCESS (0.096s)
[105.584841] Starting dynamic subtest: drm_test_mm_debug
[105.664432] Dynamic subtest drm_test_mm_debug: SUCCESS (0.088s)
[105.674077] Starting dynamic subtest: drm_test_mm_align32
[105.751513] Dynamic subtest drm_test_mm_align32: SUCCESS (0.088s)
[105.761069] Starting dynamic subtest: drm_test_mm_align64
[105.853351] Dynamic subtest drm_test_mm_align64: SUCCESS (0.102s)
[105.862800] Starting dynamic subtest: drm_test_mm_lowest
[105.946280] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.092s)
[105.955931] Starting dynamic subtest: drm_test_mm_highest
[106.042643] Dynamic subtest drm_test_mm_highest: SUCCESS (0.096s)
[106.044817] Subtest drm_mm: SUCCESS (0.571s)
[106.209142] [013/132] (911s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[106.305600] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[106.310091] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[106.388234] [014/132] (911s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[106.471747] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[106.475798] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[107.562933] [015/132] (910s left) kms_lease (lease-get)
[107.654232] Starting subtest: lease-get
[107.656658] Starting dynamic subtest: pipe-A-eDP-1
[107.658983] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[107.667842] Starting dynamic subtest: pipe-B-eDP-1
[107.670138] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[107.677905] Starting dynamic subtest: pipe-C-eDP-1
[107.680189] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[107.687840] Starting dynamic subtest: pipe-D-eDP-1
[107.690147] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[107.692436] Subtest lease-get: SUCCESS (0.007s)
[107.769926] [016/132] (910s left) kms_flip (flip-vs-fences)
[107.862650] Starting subtest: flip-vs-fences
[107.866993] Subtest flip-vs-fences: SKIP (0.000s)
[107.976226] [017/132] (910s left) i915_pm_rpm (debugfs-forcewake-user)
[109.492579] Starting subtest: debugfs-forcewake-user
[120.883253] Subtest debugfs-forcewake-user: SUCCESS (11.393s)
[121.278997] [018/132] (897s left) gem_exec_params (dr1-dirt)
[121.336714] Starting subtest: DR1-dirt
[121.338891] Subtest DR1-dirt: SUCCESS (0.000s)
[121.446399] [019/132] (896s left) i915_hangman (detector)
[121.516430] Starting subtest: detector
[121.518828] Starting dynamic subtest: rcs0
[132.252266] Dynamic subtest rcs0: SUCCESS (10.735s)
[132.266694] Starting dynamic subtest: bcs0
[144.220052] Dynamic subtest bcs0: SUCCESS (11.966s)
[144.231778] Starting dynamic subtest: vcs0
[156.188034] Dynamic subtest vcs0: SUCCESS (11.966s)
[156.198874] Starting dynamic subtest: vcs1
[167.197053] Dynamic subtest vcs1: SUCCESS (11.007s)
[167.208849] Starting dynamic subtest: vecs0
[178.205471] Dynamic subtest vecs0: SUCCESS (11.007s)
[178.216597] Starting dynamic subtest: ccs0
[189.277659] Dynamic subtest ccs0: SUCCESS (11.070s)
[189.280520] Subtest detector: SUCCESS (67.760s)
[189.360449] [020/132] (829s left) gem_ctx_persistence (heartbeat-hang)
[189.423800] Starting subtest: heartbeat-hang
[189.428639] Subtest heartbeat-hang: SKIP (0.000s)
[189.561853] [021/132] (828s left) kms_flip (basic-flip-vs-wf_vblank)
[189.653962] Starting subtest: basic-flip-vs-wf_vblank
[189.656359] Starting dynamic subtest: A-eDP1
[191.597325] Dynamic subtest A-eDP1: SUCCESS (1.945s)
[191.608184] Starting dynamic subtest: B-eDP1
[193.530117] Dynamic subtest B-eDP1: SUCCESS (1.932s)
[193.538739] Starting dynamic subtest: C-eDP1
[195.449592] Dynamic subtest C-eDP1: SUCCESS (1.917s)
[195.460219] Starting dynamic subtest: D-eDP1
[197.384880] Dynamic subtest D-eDP1: SUCCESS (1.935s)
[197.387258] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.736s)
[198.620281] [022/132] (819s left) gen9_exec_parse (unaligned-jump)
[198.680812] Subtest unaligned-jump: SKIP (0.000s)
[198.754185] [023/132] (819s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[198.816710] Starting subtest: etime-multi-wait-all-available-unsubmitted
[198.922297] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.106s)
[198.999203] [024/132] (819s left) gem_pxp (create-protected-buffer)
[199.121097] Starting subtest: create-protected-buffer
[199.123846] Subtest create-protected-buffer: SUCCESS (0.000s)
[199.263305] [025/132] (819s left) perf_pmu (event-wait)
[199.313631] Starting subtest: event-wait
[199.315841] Starting dynamic subtest: rcs0
[199.320222] Dynamic subtest rcs0: SKIP (0.000s)
[199.324280] Subtest event-wait: SKIP (0.000s)
[199.412855] [026/132] (819s left) kms_plane_alpha_blend (alpha-opaque-fb)
[199.511054] Starting subtest: alpha-opaque-fb
[199.796109] Starting dynamic subtest: pipe-A-eDP-1
[200.400991] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.605s)
[200.409347] Starting dynamic subtest: pipe-D-eDP-1
[201.807228] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.403s)
[201.809638] Subtest alpha-opaque-fb: SUCCESS (2.296s)
[202.680582] [027/132] (816s left) api_intel_bb (object-noreloc-purge-cache-simple)
[202.738731] Starting subtest: object-noreloc-purge-cache-simple
[202.741881] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.006s)
[202.886791] [028/132] (815s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[203.002048] Starting subtest: 2x-cursor-vs-flip-atomic
[203.006613] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[203.150449] [029/132] (815s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[203.244151] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[203.248555] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[203.347441] [030/132] (815s left) gen3_render_mixed_blits
[203.466114] [031/132] (815s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[203.561925] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[204.230317] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.670s)
[204.402898] [032/132] (814s left) gem_ctx_persistence (engines-cleanup)
[204.472432] Starting subtest: engines-cleanup
[204.474639] Starting dynamic subtest: rcs0
[204.547421] Dynamic subtest rcs0: SUCCESS (0.076s)
[204.559457] Starting dynamic subtest: bcs0
[204.585107] Dynamic subtest bcs0: SUCCESS (0.038s)
[204.593697] Starting dynamic subtest: vcs0
[204.636525] Dynamic subtest vcs0: SUCCESS (0.050s)
[204.646802] Starting dynamic subtest: vcs1
[204.675667] Dynamic subtest vcs1: SUCCESS (0.038s)
[204.684953] Starting dynamic subtest: vecs0
[204.713474] Dynamic subtest vecs0: SUCCESS (0.037s)
[204.721776] Starting dynamic subtest: ccs0
[204.730230] Dynamic subtest ccs0: SUCCESS (0.016s)
[204.732401] Subtest engines-cleanup: SUCCESS (0.260s)
[204.849371] [033/132] (814s left) gem_lmem_swapping (heavy-verify-random-ccs)
[204.892769] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[204.937738] [034/132] (814s left) dumb_buffer (map-valid)
[204.985844] Starting subtest: map-valid
[204.988217] Subtest map-valid: SUCCESS (0.000s)
[205.082053] [035/132] (814s left) kms_atomic_interruptible (atomic-setmode)
[205.180025] Starting subtest: atomic-setmode
[205.181871] Starting dynamic subtest: pipe-A-eDP-1
[212.075440] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.892s)
[212.077436] Subtest atomic-setmode: SUCCESS (6.893s)
[212.940302] [036/132] (806s left) gem_linear_blits (basic)
[213.288423] Starting subtest: basic
[213.298430] Subtest basic: SUCCESS (0.010s)
[213.445966] [037/132] (805s left) gem_exec_schedule (u-independent)
[213.558309] Starting subtest: u-independent
[213.560630] Starting dynamic subtest: rcs0
[215.295668] Dynamic subtest rcs0: SUCCESS (1.746s)
[215.307281] Starting dynamic subtest: vcs0
[217.284601] Dynamic subtest vcs0: SUCCESS (1.988s)
[217.296189] Starting dynamic subtest: vcs1
[219.337674] Dynamic subtest vcs1: SUCCESS (2.052s)
[219.350614] Starting dynamic subtest: vecs0
[221.317407] Dynamic subtest vecs0: SUCCESS (1.978s)
[221.329080] Starting dynamic subtest: ccs0
[223.294235] Dynamic subtest ccs0: SUCCESS (1.975s)
[223.297042] Subtest u-independent: SUCCESS (9.746s)
[223.598413] [038/132] (795s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[223.717360] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[228.173211] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.464s)
[229.344259] [039/132] (789s left) syncobj_timeline (invalid-transfer-bad-pad)
[229.404066] Starting subtest: invalid-transfer-bad-pad
[229.406254] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[229.507780] [040/132] (789s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[229.605513] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[236.860458] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.258s)
[237.029555] [041/132] (782s left) kms_atomic (plane-immutable-zpos)
[237.124600] Starting subtest: plane-immutable-zpos
[237.126884] Starting dynamic subtest: pipe-A-eDP-1
[237.771054] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.646s)
[237.773507] Subtest plane-immutable-zpos: SUCCESS (0.647s)
[238.608933] [042/132] (780s left) gem_render_copy (linear-to-vebox-yf-tiled)
[238.678066] Starting subtest: linear-to-vebox-yf-tiled
[238.682547] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[238.857255] [043/132] (780s left) gem_exec_params (rs-invalid)
[238.930053] Starting subtest: rs-invalid
[238.932778] Subtest rs-invalid: SUCCESS (0.004s)
[239.049856] [044/132] (780s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[239.161307] Starting subtest: yf-tiled-addfb-size-overflow
[239.165711] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[239.264116] [045/132] (780s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[239.374663] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[239.376975] Starting dynamic subtest: pipe-A-eDP-1
[255.817841] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.448s)
[255.832346] Starting dynamic subtest: pipe-B-eDP-1
[272.975450] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.153s)
[272.977692] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.604s)
[273.774255] [046/132] (745s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[273.889660] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[273.893962] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[273.983242] [047/132] (745s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[274.081259] Starting subtest: fbcpsr-2p-rte
[274.085513] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[274.189141] [048/132] (745s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[274.285687] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[274.289980] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[274.358343] [049/132] (745s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[274.474155] Starting subtest: 4-tiled-32bpp-rotate-0
[275.842078] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.368s)
[275.973817] [050/132] (743s left) gem_ctx_shared (q-smoketest)
[276.047518] Starting subtest: Q-smoketest
[276.049138] Starting dynamic subtest: rcs0
[281.607919] Dynamic subtest rcs0: SUCCESS (5.515s)
[281.620430] Starting dynamic subtest: bcs0
[287.088814] Dynamic subtest bcs0: SUCCESS (5.480s)
[287.100374] Starting dynamic subtest: vcs0
[292.562096] Dynamic subtest vcs0: SUCCESS (5.467s)
[292.572620] Starting dynamic subtest: vcs1
[298.032871] Dynamic subtest vcs1: SUCCESS (5.470s)
[298.042245] Starting dynamic subtest: vecs0
[303.512186] Dynamic subtest vecs0: SUCCESS (5.478s)
[303.523806] Starting dynamic subtest: ccs0
[309.004162] Dynamic subtest ccs0: SUCCESS (5.494s)
[309.006463] Subtest Q-smoketest: SUCCESS (32.909s)
[309.143721] [051/132] (710s left) gem_exec_reloc (basic-write-gtt-noreloc)
[309.209619] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[309.274939] [052/132] (710s left) gem_exec_balancer (waits)
[309.341696] Starting subtest: waits
[315.845359] Subtest waits: SUCCESS (6.501s)
[316.189800] [053/132] (703s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[316.591483] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[317.389089] [054/132] (702s left) gem_exec_params (invalid-ring2)
[317.453554] Starting subtest: invalid-ring2
[317.455924] Subtest invalid-ring2: SUCCESS (0.000s)
[317.551598] [055/132] (702s left) perf_pmu (busy-accuracy-98)
[317.596125] Starting subtest: busy-accuracy-98
[317.598364] Starting dynamic subtest: rcs0
[320.634921] Dynamic subtest rcs0: SUCCESS (3.035s)
[320.646728] Starting dynamic subtest: bcs0
[323.691160] Dynamic subtest bcs0: SUCCESS (3.054s)
[323.700264] Starting dynamic subtest: vcs0
[326.736609] Dynamic subtest vcs0: SUCCESS (3.043s)
[326.746860] Starting dynamic subtest: vcs1
[329.782394] Dynamic subtest vcs1: SUCCESS (3.043s)
[329.791461] Starting dynamic subtest: vecs0
[332.821788] Dynamic subtest vecs0: SUCCESS (3.038s)
[332.832740] Starting dynamic subtest: ccs0
[335.884476] Dynamic subtest ccs0: SUCCESS (3.060s)
[335.886869] Subtest busy-accuracy-98: SUCCESS (18.286s)
[336.001262] [056/132] (684s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[336.105277] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[336.109142] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[336.243814] [057/132] (683s left) kms_rotation_crc (sprite-rotation-90)
[336.345250] Starting subtest: sprite-rotation-90
[336.349076] Subtest sprite-rotation-90: SKIP (0.001s)
[336.417619] [058/132] (683s left) gem_exec_schedule (smoketest-all)
[336.491763] Starting subtest: smoketest-all
[368.868809] Subtest smoketest-all: SUCCESS (32.333s)
[370.400965] [059/132] (649s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[370.498453] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[370.502588] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[370.599324] [060/132] (649s left) gem_exec_balancer (full)
[370.669351] Starting subtest: full
[375.098792] Subtest full: SUCCESS (4.429s)
[375.416410] [061/132] (644s left) gen9_exec_parse (bb-start-far)
[375.474808] Subtest bb-start-far: SKIP (0.000s)
[375.566420] [062/132] (644s left) kms_big_fb (linear-64bpp-rotate-270)
[375.669151] Starting subtest: linear-64bpp-rotate-270
[375.691185] Subtest linear-64bpp-rotate-270: SKIP (0.021s)
[375.836071] [063/132] (644s left) kms_vblank (ts-continuation-suspend)
[375.936141] Starting subtest: ts-continuation-suspend
[375.938305] Starting dynamic subtest: pipe-A-eDP-1
[392.486118] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.697s)
[392.503073] Starting dynamic subtest: pipe-D-eDP-1
[409.470486] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.200s)
[409.472458] Subtest ts-continuation-suspend: SUCCESS (3.902s)
[410.282546] [064/132] (610s left) kms_plane_multiple (2x-tiling-x)
[410.386654] Starting subtest: 2x-tiling-x
[410.391111] Subtest 2x-tiling-x: SKIP (0.000s)
[410.462763] [065/132] (609s left) gem_ctx_engines (execute-oneforall)
[410.529610] Starting subtest: execute-oneforall
[411.072854] Subtest execute-oneforall: SUCCESS (0.545s)
[412.033577] [066/132] (608s left) kms_psr (fbc-pr-sprite-render)
[412.138945] Starting subtest: fbc-pr-sprite-render
[412.145166] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[412.206138] [067/132] (608s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[412.298012] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[412.325410] Starting dynamic subtest: pipe-A-plane-0
[412.613115] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[412.623064] Starting dynamic subtest: pipe-A-plane-3
[412.845687] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[412.858653] Starting dynamic subtest: pipe-A-plane-5
[412.863111] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[413.944321] Starting dynamic subtest: pipe-B-plane-0
[414.232260] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[414.241962] Starting dynamic subtest: pipe-B-plane-3
[414.467527] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[414.488557] Starting dynamic subtest: pipe-B-plane-5
[414.494244] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[414.783883] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.493s)
[415.616748] [068/132] (604s left) kms_content_protection (dp-mst-type-1)
[415.752378] Starting subtest: dp-mst-type-1
[415.756939] Subtest dp-mst-type-1: SKIP (0.000s)
[415.896320] [069/132] (604s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[415.992042] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[415.993935] Starting dynamic subtest: pipe-A-eDP-1
[416.017208] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.027s)
[416.027558] Starting dynamic subtest: pipe-B-eDP-1
[416.046850] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.021s)
[416.057116] Starting dynamic subtest: pipe-C-eDP-1
[416.076080] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[416.086327] Starting dynamic subtest: pipe-D-eDP-1
[416.105630] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[416.107871] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.097s)
[418.276145] [070/132] (602s left) gem_exec_reloc (basic-write-cpu-active)
[418.329966] Subtest basic-write-cpu-active: SKIP (0.000s)
[418.395857] [071/132] (602s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[418.487213] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[418.491527] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[418.590739] [072/132] (602s left) kms_cursor_edge_walk (64x64-right-edge)
[418.682131] Starting subtest: 64x64-right-edge
[418.684386] Starting dynamic subtest: pipe-A-eDP-1
[422.151226] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.474s)
[422.161424] Starting dynamic subtest: pipe-D-eDP-1
[425.263850] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.113s)
[425.266268] Subtest 64x64-right-edge: SUCCESS (6.590s)
[426.072123] [073/132] (594s left) syncobj_wait (invalid-signal-zero-handles)
[426.132325] Starting subtest: invalid-signal-zero-handles
[426.134620] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[426.252655] [074/132] (594s left) kms_psr (pr-cursor-mmap-gtt)
[426.352346] Starting subtest: pr-cursor-mmap-gtt
[426.356931] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[426.426712] [075/132] (594s left) kms_plane_scaling (intel-max-src-size)
[426.513760] Starting subtest: intel-max-src-size
[426.520216] Subtest intel-max-src-size: SKIP (0.000s)
[426.625781] [076/132] (594s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[426.712985] Starting subtest: primary-y-tiled-reflect-x-270
[426.717122] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[426.798314] [077/132] (594s left) kms_chamelium_frames (hdmi-crc-single)
[427.181687] Subtest hdmi-crc-single: SKIP (0.000s)
[427.990221] [078/132] (593s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[428.095045] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[428.099116] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[428.183672] [079/132] (592s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[428.289691] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[433.581750] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.300s)
[434.719657] [080/132] (586s left) gem_ctx_param (invalid-param-get)
[434.775380] Starting subtest: invalid-param-get
[434.777804] Subtest invalid-param-get: SUCCESS (0.001s)
[434.890506] [081/132] (586s left) kms_psr (psr-sprite-mmap-cpu)
[434.982046] Starting subtest: psr-sprite-mmap-cpu
[434.984362] Starting dynamic subtest: eDP-1
[436.707774] Dynamic subtest eDP-1: SUCCESS (1.727s)
[436.710192] Subtest psr-sprite-mmap-cpu: SUCCESS (1.728s)
[437.553425] [082/132] (583s left) kms_pm_backlight (basic-brightness)
[437.651352] Starting subtest: basic-brightness
[437.699724] Starting dynamic subtest: eDP-1
[438.215195] Dynamic subtest eDP-1: SUCCESS (0.514s)
[438.217567] Subtest basic-brightness: SUCCESS (0.566s)
[439.086833] [083/132] (582s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[439.180208] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[439.182539] Starting dynamic subtest: pipe-A-eDP-1
[439.205295] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[439.217861] Starting dynamic subtest: pipe-B-eDP-1
[439.239261] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[439.248595] Starting dynamic subtest: pipe-C-eDP-1
[439.270101] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[439.279163] Starting dynamic subtest: pipe-D-eDP-1
[439.301555] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[439.305984] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[441.366260] [084/132] (579s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[441.480511] Starting subtest: 2x-flip-vs-cursor-legacy
[441.484864] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[441.627081] [085/132] (579s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[441.720424] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[441.722537] Starting dynamic subtest: pipe-A
[441.741689] Dynamic subtest pipe-A: SKIP (0.017s)
[441.752282] Starting dynamic subtest: pipe-B
[441.771836] Dynamic subtest pipe-B: SKIP (0.029s)
[441.782006] Starting dynamic subtest: pipe-C
[441.798504] Dynamic subtest pipe-C: SKIP (0.028s)
[441.808563] Starting dynamic subtest: pipe-D
[441.827916] Dynamic subtest pipe-D: SKIP (0.028s)
[441.832041] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.105s)
[441.946869] [086/132] (579s left) gem_wait (write-busy)
[442.010931] Starting subtest: write-busy
[442.013324] Starting dynamic subtest: all-engines
[442.629589] Dynamic subtest all-engines: SUCCESS (0.618s)
[442.648091] Starting dynamic subtest: rcs0
[443.186534] Dynamic subtest rcs0: SUCCESS (0.554s)
[443.204929] Starting dynamic subtest: bcs0
[443.737833] Dynamic subtest bcs0: SUCCESS (0.550s)
[443.756135] Starting dynamic subtest: vcs0
[444.932936] Dynamic subtest vcs0: SUCCESS (1.192s)
[444.949985] Starting dynamic subtest: vcs1
[446.915501] Dynamic subtest vcs1: SUCCESS (1.980s)
[446.933765] Starting dynamic subtest: vecs0
[448.898613] Dynamic subtest vecs0: SUCCESS (1.981s)
[448.915547] Starting dynamic subtest: ccs0
[449.449155] Dynamic subtest ccs0: SUCCESS (0.549s)
[449.451634] Subtest write-busy: SUCCESS (7.437s)
[449.652953] [087/132] (571s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[449.752787] Starting subtest: y-tiled-addfb-size-offset-overflow
[449.757236] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[449.847657] [088/132] (571s left) kms_async_flips (crc)
[449.953997] Starting subtest: crc
[450.337753] Starting dynamic subtest: pipe-A-eDP-1
[453.276101] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.936s)
[453.660098] Starting dynamic subtest: pipe-B-eDP-1
[456.599571] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.948s)
[456.986974] Starting dynamic subtest: pipe-C-eDP-1
[459.888136] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.910s)
[460.255986] Starting dynamic subtest: pipe-D-eDP-1
[463.115255] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.869s)
[463.117631] Subtest crc: SUCCESS (13.165s)
[464.294626] [089/132] (557s left) sw_sync (sync_busy_fork)
[464.337637] Starting subtest: sync_busy_fork
[465.350268] Subtest sync_busy_fork: SUCCESS (1.012s)
[465.430537] [090/132] (556s left) kms_psr (fbc-psr-cursor-plane-onoff)
[465.520998] Starting subtest: fbc-psr-cursor-plane-onoff
[465.523422] Starting dynamic subtest: eDP-1
[465.527731] Dynamic subtest eDP-1: SKIP (0.000s)
[465.532113] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[465.596599] [091/132] (555s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[465.649954] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[465.750797] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[465.830004] [092/132] (555s left) kms_addfb_basic (bad-pitch-256)
[465.883530] Starting subtest: bad-pitch-256
[465.885489] Subtest bad-pitch-256: SUCCESS (0.000s)
[466.011154] [093/132] (555s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[466.164407] Starting subtest: cursor-rapid-movement-32x10
[466.208703] Subtest cursor-rapid-movement-32x10: SKIP (0.039s)
[466.473815] [094/132] (555s left) kms_invalid_mode (int-max-clock)
[466.565806] Starting subtest: int-max-clock
[466.567573] Starting dynamic subtest: pipe-A-eDP-1
[466.852504] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[466.863106] Starting dynamic subtest: pipe-B-eDP-1
[466.865068] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[466.874604] Starting dynamic subtest: pipe-C-eDP-1
[466.876844] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[466.885780] Starting dynamic subtest: pipe-D-eDP-1
[466.887709] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[466.889554] Subtest int-max-clock: SUCCESS (0.293s)
[467.733709] [095/132] (554s left) syncobj_timeline (wait-all-snapshot)
[467.802335] Starting subtest: wait-all-snapshot
[467.883850] Subtest wait-all-snapshot: SUCCESS (0.081s)
[467.962054] [096/132] (553s left) gem_softpin (softpin)
[468.019090] Starting subtest: softpin
[500.376191] Subtest softpin: SUCCESS (32.364s)
[500.512172] [097/132] (521s left) gem_basic (create-close)
[500.578458] Starting subtest: create-close
[500.582563] Subtest create-close: SUCCESS (0.000s)
[500.675738] [098/132] (521s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[500.786332] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[510.928574] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (10.142s)
[511.061329] [099/132] (510s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[511.165199] Starting subtest: psr-modesetfrombusy
[517.362167] Subtest psr-modesetfrombusy: SUCCESS (6.198s)
[517.514667] [100/132] (504s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[517.612763] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[524.992474] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.379s)
[525.131777] [101/132] (496s left) gem_caching (reads)
[525.194080] Subtest reads: SKIP (0.000s)
[525.271325] [102/132] (496s left) sysfs_preempt_timeout (invalid)
[525.326953] Starting subtest: invalid
[525.329277] Starting dynamic subtest: vecs0
[525.331599] Dynamic subtest vecs0: SUCCESS (0.000s)
[525.343892] Starting dynamic subtest: ccs0
[525.346208] Dynamic subtest ccs0: SUCCESS (0.000s)
[525.356499] Starting dynamic subtest: vcs0
[525.358627] Dynamic subtest vcs0: SUCCESS (0.000s)
[525.367934] Starting dynamic subtest: bcs0
[525.369738] Dynamic subtest bcs0: SUCCESS (0.000s)
[525.380510] Starting dynamic subtest: rcs0
[525.382379] Dynamic subtest rcs0: SUCCESS (0.000s)
[525.392410] Starting dynamic subtest: vcs1
[525.394265] Dynamic subtest vcs1: SUCCESS (0.000s)
[525.396064] Subtest invalid: SUCCESS (0.006s)
[525.433316] [103/132] (496s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[525.546085] Starting subtest: x-tiled-64bpp-rotate-180
[527.136740] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.590s)
[527.307324] [104/132] (494s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[527.412979] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[534.495219] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.084s)
[534.600053] [105/132] (487s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[534.716479] Starting subtest: modeset-atomic-cursor-hotspot
[534.721120] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[534.865958] [106/132] (487s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[534.974392] Starting subtest: cursorB-vs-flipA-toggle
[534.978970] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[535.120851] [107/132] (487s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[535.222090] Starting subtest: pr-cursor-plane-move-continuous-sf
[535.226104] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[535.292068] [108/132] (487s left) gem_exec_schedule (independent)
[535.361473] Starting subtest: independent
[535.363612] Starting dynamic subtest: rcs0
[536.899760] Dynamic subtest rcs0: SUCCESS (1.547s)
[536.913413] Starting dynamic subtest: vcs0
[538.957442] Dynamic subtest vcs0: SUCCESS (2.056s)
[538.968929] Starting dynamic subtest: vcs1
[540.940468] Dynamic subtest vcs1: SUCCESS (1.981s)
[540.953481] Starting dynamic subtest: vecs0
[542.924077] Dynamic subtest vecs0: SUCCESS (1.982s)
[542.936871] Starting dynamic subtest: ccs0
[544.899439] Dynamic subtest ccs0: SUCCESS (1.973s)
[544.902011] Subtest independent: SUCCESS (9.549s)
[545.205560] [109/132] (477s left) kms_color (ctm-0-25)
[545.308607] Starting subtest: ctm-0-25
[545.310650] Starting dynamic subtest: pipe-A-eDP-1
[548.755681] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.446s)
[548.766426] Starting dynamic subtest: pipe-B-eDP-1
[552.946362] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.192s)
[552.957651] Starting dynamic subtest: pipe-C-eDP-1
[556.915607] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.967s)
[556.926219] Starting dynamic subtest: pipe-D-eDP-1
[560.881808] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.968s)
[560.884122] Subtest ctm-0-25: SUCCESS (15.577s)
[561.725082] [110/132] (460s left) gem_exec_reloc (basic-gtt-cpu)
[561.792310] Subtest basic-gtt-cpu: SKIP (0.000s)
[561.865334] [111/132] (460s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[561.993325] Starting subtest: cursorA-vs-flipB-atomic
[561.997605] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[562.138616] [112/132] (460s left) kms_cursor_crc (cursor-onscreen-128x128)
[562.339157] Starting subtest: cursor-onscreen-128x128
[562.343785] Starting dynamic subtest: pipe-A-eDP-1
[564.443670] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.102s)
[564.495223] Starting dynamic subtest: pipe-D-eDP-1
[567.208237] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.721s)
[567.210551] Subtest cursor-onscreen-128x128: SUCCESS (4.868s)
[568.018247] [113/132] (454s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[568.082892] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[568.087673] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[568.258933] [114/132] (454s left) kms_draw_crc (draw-method-blt)
[568.365794] Starting subtest: draw-method-blt
[568.368095] Starting dynamic subtest: xrgb8888-untiled
[568.609765] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[568.619609] Starting dynamic subtest: rgb565-untiled
[568.841790] Dynamic subtest rgb565-untiled: SUCCESS (0.232s)
[568.851833] Starting dynamic subtest: xrgb2101010-untiled
[569.041833] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.198s)
[569.057096] Starting dynamic subtest: xbgr16161616f-untiled
[569.241499] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.199s)
[569.251997] Starting dynamic subtest: xrgb8888-xtiled
[569.352578] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.110s)
[569.365175] Starting dynamic subtest: rgb565-xtiled
[569.475051] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[569.487693] Starting dynamic subtest: xrgb2101010-xtiled
[569.575196] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.099s)
[569.584964] Starting dynamic subtest: xbgr16161616f-xtiled
[569.685795] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.110s)
[569.695986] Starting dynamic subtest: xrgb8888-4tiled
[569.841330] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[569.853998] Starting dynamic subtest: rgb565-4tiled
[569.963686] Dynamic subtest rgb565-4tiled: SUCCESS (0.120s)
[569.973363] Starting dynamic subtest: xrgb2101010-4tiled
[570.085618] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[570.095635] Starting dynamic subtest: xbgr16161616f-4tiled
[570.241320] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.155s)
[570.243157] Subtest draw-method-blt: SUCCESS (1.878s)
[570.373310] [115/132] (452s left) gem_exec_reloc (basic-range)
[570.445753] Subtest basic-range: SKIP (0.000s)
[570.517787] [116/132] (452s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[570.575994] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[570.577813] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[570.684960] [117/132] (452s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[570.778881] Starting subtest: crc-primary-suspend-y-tiled-ccs
[570.780720] Starting dynamic subtest: pipe-A-eDP-1
[570.788061] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[570.798210] Starting dynamic subtest: pipe-B-eDP-1
[570.805452] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[570.814839] Starting dynamic subtest: pipe-C-eDP-1
[570.821101] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[570.830281] Starting dynamic subtest: pipe-D-eDP-1
[570.836426] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[570.839467] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[572.986104] [118/132] (449s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[573.092856] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[577.046022] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (3.958s)
[578.183005] [119/132] (444s left) kms_pipe_crc_basic (bad-source)
[578.285981] Starting subtest: bad-source
[578.288249] Subtest bad-source: SUCCESS (0.000s)
[578.363408] [120/132] (444s left) prime_vgem (shrink)
[578.430216] Starting subtest: shrink
[578.463246] Subtest shrink: SUCCESS (0.030s)
[578.551276] [121/132] (444s left) gem_exec_whisper (basic-fds-forked-all)
[578.615497] Starting subtest: basic-fds-forked-all
[598.386701] Subtest basic-fds-forked-all: SUCCESS (19.773s)
[598.575939] [122/132] (424s left) i915_power (sanity)
[598.633077] Starting subtest: sanity
[602.682763] Subtest sanity: SUCCESS (4.045s)
[603.981452] [123/132] (418s left) gem_render_linear_blits (basic)
[604.038677] Starting subtest: basic
[604.072391] Subtest basic: SUCCESS (0.033s)
[604.158617] [124/132] (418s left) perf (polling)
[604.289690] Starting subtest: polling
[604.291854] Starting dynamic subtest: 0-rcs0
[614.303974] Dynamic subtest 0-rcs0: SUCCESS (10.016s)
[614.315331] Starting dynamic subtest: 1-vcs0
[624.323041] Dynamic subtest 1-vcs0: SUCCESS (10.020s)
[624.325406] Subtest polling: SUCCESS (20.039s)
[624.373192] [125/132] (398s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[624.463835] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[624.467975] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[624.565841] [126/132] (398s left) kms_selftest (drm_dp_mst_helper)
[624.610032] Starting subtest: drm_dp_mst_helper
[624.675370] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[624.805366] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.130s)
[624.817741] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[624.918602] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.112s)
[624.931160] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[625.031150] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.113s)
[625.033400] Subtest drm_dp_mst_helper: SUCCESS (0.421s)
[625.187037] [127/132] (397s left) gem_mmap_gtt (cpuset-medium-copy)
[625.247586] Subtest cpuset-medium-copy: SKIP (0.000s)
[625.304214] [128/132] (397s left) syncobj_wait (invalid-signal-one-illegal-handle)
[625.357729] Starting subtest: invalid-signal-one-illegal-handle
[625.359709] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[625.471150] [129/132] (397s left) gem_spin_batch (spin-each)
[625.537730] Starting subtest: spin-each
[628.807276] Subtest spin-each: SUCCESS (3.262s)
[628.988686] [130/132] (394s left) gem_mmap_offset (bad-extensions)
[629.050438] Starting subtest: bad-extensions
[629.052794] Subtest bad-extensions: SUCCESS (0.000s)
[629.153363] [131/132] (394s left) api_intel_allocator (standalone)
[629.215861] Starting subtest: standalone
[629.236539] Subtest standalone: SUCCESS (0.022s)
[629.367699] [132/132] (393s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[629.459841] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[629.463888] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[629.559229] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: gem_exec_reloc
results: parsing output: 2/ for test: prime_self_import
results: parsing output: 3/ for test: kms_feature_discovery
results: parsing output: 4/ for test: kms_busy
results: parsing output: 5/ for test: gem_ctx_param
results: parsing output: 6/ for test: gem_exec_fence
results: parsing output: 7/ for test: gem_exec_params
results: parsing output: 8/ for test: gem_softpin
results: parsing output: 9/ for test: kms_psr2_sf
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: drm_mm
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_lease
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: i915_pm_rpm
results: parsing output: 17/ for test: gem_exec_params
results: parsing output: 18/ for test: i915_hangman
results: parsing output: 19/ for test: gem_ctx_persistence
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: gen9_exec_parse
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: gem_pxp
results: parsing output: 24/ for test: perf_pmu
results: parsing output: 25/ for test: kms_plane_alpha_blend
results: parsing output: 26/ for test: api_intel_bb
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gen3_render_mixed_blits
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: gem_ctx_persistence
results: parsing output: 32/ for test: gem_lmem_swapping
results: parsing output: 33/ for test: dumb_buffer
results: parsing output: 34/ for test: kms_atomic_interruptible
results: parsing output: 35/ for test: gem_linear_blits
results: parsing output: 36/ for test: gem_exec_schedule
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_atomic
results: parsing output: 41/ for test: gem_render_copy
results: parsing output: 42/ for test: gem_exec_params
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_psr2_sf
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_flip_scaled_crc
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: gem_ctx_shared
results: parsing output: 50/ for test: gem_exec_reloc
results: parsing output: 51/ for test: gem_exec_balancer
results: parsing output: 52/ for test: kms_chamelium_hpd
results: parsing output: 53/ for test: gem_exec_params
results: parsing output: 54/ for test: perf_pmu
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_rotation_crc
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_balancer
results: parsing output: 60/ for test: gen9_exec_parse
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_vblank
results: parsing output: 63/ for test: kms_plane_multiple
results: parsing output: 64/ for test: gem_ctx_engines
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: kms_plane
results: parsing output: 67/ for test: kms_content_protection
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: gem_exec_reloc
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_cursor_edge_walk
results: parsing output: 72/ for test: syncobj_wait
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_plane_scaling
results: parsing output: 75/ for test: kms_rotation_crc
results: parsing output: 76/ for test: kms_chamelium_frames
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_ctx_param
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: kms_pm_backlight
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: kms_plane_scaling
results: parsing output: 85/ for test: gem_wait
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: kms_async_flips
results: parsing output: 88/ for test: sw_sync
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_addfb_basic
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: kms_invalid_mode
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: gem_softpin
results: parsing output: 96/ for test: gem_basic
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_caching
results: parsing output: 101/ for test: sysfs_preempt_timeout
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_psr2_sf
results: parsing output: 107/ for test: gem_exec_schedule
results: parsing output: 108/ for test: kms_color
results: parsing output: 109/ for test: gem_exec_reloc
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: kms_cursor_crc
results: parsing output: 112/ for test: gem_render_copy
results: parsing output: 113/ for test: kms_draw_crc
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_pipe_crc_basic
results: parsing output: 119/ for test: prime_vgem
results: parsing output: 120/ for test: gem_exec_whisper
results: parsing output: 121/ for test: i915_power
results: parsing output: 122/ for test: gem_render_linear_blits
results: parsing output: 123/ for test: perf
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_selftest
results: parsing output: 126/ for test: gem_mmap_gtt
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: gem_spin_batch
results: parsing output: 129/ for test: gem_mmap_offset
results: parsing output: 130/ for test: api_intel_allocator
results: parsing output: 131/ for test: kms_frontbuffer_tracking
Done.