[58.599046] Initializing watchdogs
[58.599096]   /dev/watchdog0
[58.613765] [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.617971] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.620286] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.623675] [001/131] (960s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[58.750229] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[58.754832] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.002s)
[58.897400] [002/131] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[59.010846] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[59.015382] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[59.147364] [003/131] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[59.251767] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[59.255990] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[59.367134] [004/131] (959s left) gem_barrier_race (remote-request)
[59.438909] Starting subtest: remote-request
[59.441358] Starting dynamic subtest: rcs0
[64.598652] Dynamic subtest rcs0: SUCCESS (5.162s)
[64.600620] Subtest remote-request: SUCCESS (5.162s)
[64.808697] [005/131] (954s left) api_intel_bb (add-remove-objects)
[64.877059] Starting subtest: add-remove-objects
[64.887931] Subtest add-remove-objects: SUCCESS (0.012s)
[65.046782] [006/131] (954s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[65.144066] Starting subtest: 4-tiled-16bpp-rotate-0
[66.477063] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.333s)
[66.627576] [007/131] (952s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[66.731377] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[66.733112] Starting dynamic subtest: pipe-A-eDP-1
[67.027464] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.273s)
[67.035919] Starting dynamic subtest: pipe-B-eDP-1
[68.272653] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.232s)
[68.281673] Starting dynamic subtest: pipe-C-eDP-1
[69.492649] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.206s)
[69.499195] Starting dynamic subtest: pipe-D-eDP-1
[70.716132] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.238s)
[70.718019] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.955s)
[71.978733] [008/131] (947s left) gem_mmap_wc (read)
[72.037846] Subtest read: SKIP (0.000s)
[72.112179] [009/131] (947s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[72.171343] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[72.229547] [010/131] (947s left) gem_render_copy (y-tiled)
[72.272843] Starting subtest: y-tiled
[72.277322] Subtest y-tiled: SKIP (0.000s)
[72.474869] [011/131] (947s left) perf (per-context-mode-unprivileged)
[72.579174] Starting subtest: per-context-mode-unprivileged
[72.584037] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[72.619298] [012/131] (946s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[72.673628] Starting subtest: wait-all-for-submit-delayed-submit
[72.777542] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[72.875139] [013/131] (946s left) kms_invalid_mode (bad-vtotal)
[72.987352] Starting subtest: bad-vtotal
[72.989713] Starting dynamic subtest: pipe-A-eDP-1
[73.270515] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[73.278868] Starting dynamic subtest: pipe-B-eDP-1
[73.281025] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[73.287542] Starting dynamic subtest: pipe-C-eDP-1
[73.289822] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[73.296650] Starting dynamic subtest: pipe-D-eDP-1
[73.298555] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[73.300459] Subtest bad-vtotal: SUCCESS (0.288s)
[74.108882] [014/131] (945s left) i915_drm_fdinfo (virtual-busy-idle)
[74.147452] Starting subtest: virtual-busy-idle
[74.151898] Subtest virtual-busy-idle: SKIP (0.000s)
[74.230775] [015/131] (945s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[74.293782] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[74.357816] [016/131] (945s left) gen9_exec_parse (bb-chained)
[74.418267] Subtest bb-chained: SKIP (0.000s)
[74.477573] [017/131] (945s left) kms_psr (fbc-psr-primary-page-flip)
[74.575059] Starting subtest: fbc-psr-primary-page-flip
[74.577036] Starting dynamic subtest: eDP-1
[74.581226] Dynamic subtest eDP-1: SKIP (0.000s)
[74.585392] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[74.670102] [018/131] (945s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[74.764767] Starting subtest: random-ccs-data-y-tiled-ccs
[74.766994] Starting dynamic subtest: pipe-A-eDP-1
[74.791785] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[74.800032] Starting dynamic subtest: pipe-B-eDP-1
[74.823221] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[74.829672] Starting dynamic subtest: pipe-C-eDP-1
[74.852843] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[74.859261] Starting dynamic subtest: pipe-D-eDP-1
[74.882271] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[74.886583] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.003s)
[77.057173] [019/131] (942s left) sysfs_timeslice_duration (invalid)
[77.126827] Starting subtest: invalid
[77.129415] Starting dynamic subtest: vecs0
[77.131847] Dynamic subtest vecs0: SUCCESS (0.000s)
[77.140372] Starting dynamic subtest: ccs0
[77.142768] Dynamic subtest ccs0: SUCCESS (0.000s)
[77.149758] Starting dynamic subtest: vcs0
[77.151944] Dynamic subtest vcs0: SUCCESS (0.000s)
[77.158978] Starting dynamic subtest: bcs0
[77.161129] Dynamic subtest bcs0: SUCCESS (0.000s)
[77.168138] Starting dynamic subtest: rcs0
[77.170262] Dynamic subtest rcs0: SUCCESS (0.000s)
[77.177072] Starting dynamic subtest: vcs1
[77.179194] Dynamic subtest vcs1: SUCCESS (0.000s)
[77.181381] Subtest invalid: SUCCESS (0.003s)
[77.262869] [020/131] (942s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[77.358221] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[77.362353] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[77.477401] [021/131] (942s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[77.570766] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[77.573038] Starting dynamic subtest: pipe-A-default-mode
[77.872203] Dynamic subtest pipe-A-default-mode: SKIP (0.300s)
[77.876722] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.301s)
[78.688616] [022/131] (941s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[78.749425] Starting subtest: saturated-hostile-nopreempt
[78.751555] Starting dynamic subtest: rcs0
[78.838467] Dynamic subtest rcs0: SKIP (0.086s)
[78.846060] Starting dynamic subtest: bcs0
[78.854533] Dynamic subtest bcs0: SKIP (0.016s)
[78.861446] Starting dynamic subtest: vcs0
[78.870453] Dynamic subtest vcs0: SKIP (0.015s)
[78.877291] Starting dynamic subtest: vcs1
[78.886553] Dynamic subtest vcs1: SKIP (0.016s)
[78.893416] Starting dynamic subtest: vecs0
[78.907647] Dynamic subtest vecs0: SKIP (0.021s)
[78.914629] Starting dynamic subtest: ccs0
[78.926626] Dynamic subtest ccs0: SKIP (0.018s)
[78.930745] Subtest saturated-hostile-nopreempt: SKIP (0.176s)
[79.021938] [023/131] (940s left) gem_ctx_param (set-priority-not-supported)
[79.078607] Starting subtest: set-priority-not-supported
[79.082678] Subtest set-priority-not-supported: SKIP (0.000s)
[79.172634] [024/131] (940s left) kms_cursor_crc (cursor-sliding-128x128)
[79.371847] Starting subtest: cursor-sliding-128x128
[79.374174] Starting dynamic subtest: pipe-A-eDP-1
[82.578357] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.204s)
[82.613658] Starting dynamic subtest: pipe-D-eDP-1
[86.428351] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.820s)
[86.430798] Subtest cursor-sliding-128x128: SUCCESS (7.057s)
[87.254423] [025/131] (932s left) kms_psr (psr-cursor-mmap-cpu)
[87.353361] Starting subtest: psr-cursor-mmap-cpu
[87.355725] Starting dynamic subtest: eDP-1
[89.035167] Dynamic subtest eDP-1: SUCCESS (1.681s)
[89.037454] Subtest psr-cursor-mmap-cpu: SUCCESS (1.682s)
[89.924115] [026/131] (930s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[90.032033] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[96.843975] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.816s)
[96.992182] [027/131] (923s left) gem_ctx_persistence (engines-hostile)
[97.063284] Starting subtest: engines-hostile
[97.065736] Starting dynamic subtest: rcs0
[97.154042] Dynamic subtest rcs0: SUCCESS (0.090s)
[97.164975] Starting dynamic subtest: bcs0
[97.272958] Dynamic subtest bcs0: SUCCESS (0.118s)
[97.283480] Starting dynamic subtest: vcs0
[97.389861] Dynamic subtest vcs0: SUCCESS (0.116s)
[97.399959] Starting dynamic subtest: vcs1
[97.509301] Dynamic subtest vcs1: SUCCESS (0.118s)
[97.520205] Starting dynamic subtest: vecs0
[97.636332] Dynamic subtest vecs0: SUCCESS (0.126s)
[97.646768] Starting dynamic subtest: ccs0
[97.752279] Dynamic subtest ccs0: SUCCESS (0.115s)
[97.754941] Subtest engines-hostile: SUCCESS (0.689s)
[97.850677] [028/131] (922s left) kms_setmode (basic-clone-single-crtc)
[97.916314] Starting subtest: basic-clone-single-crtc
[97.921776] Subtest basic-clone-single-crtc: SKIP (0.000s)
[98.046826] [029/131] (922s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[103.071610] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[103.073830] Starting dynamic subtest: pipe-A-eDP-1
[114.779155] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.707s)
[114.788158] Starting dynamic subtest: pipe-B-eDP-1
[126.516885] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.734s)
[126.519115] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (23.445s)
[127.398398] [030/131] (892s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[127.495941] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[134.042209] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.549s)
[134.212247] [031/131] (886s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[134.307805] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[134.312241] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[135.419750] [032/131] (884s left) gem_exec_reloc (basic-gtt-wc)
[135.483422] Subtest basic-gtt-wc: SKIP (0.000s)
[135.565126] [033/131] (884s left) gem_tiled_pread_basic
[135.674751] [034/131] (884s left) kms_sequence (queue-busy)
[135.772834] Starting subtest: queue-busy
[135.775057] Starting dynamic subtest: pipe-A-eDP-1
[137.730044] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.953s)
[137.741622] Starting dynamic subtest: pipe-B-eDP-1
[141.087273] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.355s)
[141.097078] Starting dynamic subtest: pipe-C-eDP-1
[143.198907] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.110s)
[143.207730] Starting dynamic subtest: pipe-D-eDP-1
[145.745603] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.545s)
[145.747770] Subtest queue-busy: SUCCESS (9.970s)
[146.565549] [035/131] (873s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[146.630598] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[146.632808] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[146.808854] [036/131] (873s left) gem_ppgtt (blt-vs-render-ctxn)
[146.893078] Starting subtest: blt-vs-render-ctxN
[179.917471] Subtest blt-vs-render-ctxN: SUCCESS (33.023s)
[180.080193] [037/131] (840s left) kms_psr (pr-primary-mmap-cpu)
[180.219888] Starting subtest: pr-primary-mmap-cpu
[180.224203] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[180.316423] [038/131] (840s left) kms_plane_scaling (planes-downscale-factor-0-75)
[180.413069] Starting subtest: planes-downscale-factor-0-75
[180.415344] Starting dynamic subtest: pipe-A
[180.434048] Dynamic subtest pipe-A: SKIP (0.019s)
[180.442674] Starting dynamic subtest: pipe-B
[180.465624] Dynamic subtest pipe-B: SKIP (0.031s)
[180.474120] Starting dynamic subtest: pipe-C
[180.498970] Dynamic subtest pipe-C: SKIP (0.031s)
[180.507072] Starting dynamic subtest: pipe-D
[180.529579] Dynamic subtest pipe-D: SKIP (0.032s)
[180.533960] Subtest planes-downscale-factor-0-75: SKIP (0.115s)
[180.657862] [039/131] (839s left) gem_softpin (evict-active)
[180.724285] Starting subtest: evict-active
[180.729517] Subtest evict-active: SUCCESS (0.005s)
[180.884820] [040/131] (839s left) syncobj_timeline (device-submit-unordered)
[180.949946] Starting subtest: device-submit-unordered
[180.952046] Subtest device-submit-unordered: SUCCESS (0.000s)
[181.066635] [041/131] (839s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[181.166658] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[181.170345] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[181.301500] [042/131] (839s left) gem_exec_schedule (submit-late-slice)
[181.369948] Starting subtest: submit-late-slice
[181.371705] Starting dynamic subtest: rcs0
[181.395775] Dynamic subtest rcs0: SUCCESS (0.031s)
[181.405518] Starting dynamic subtest: bcs0
[181.429643] Dynamic subtest bcs0: SUCCESS (0.033s)
[181.436993] Starting dynamic subtest: vcs0
[181.459703] Dynamic subtest vcs0: SUCCESS (0.030s)
[181.467361] Starting dynamic subtest: vcs1
[181.489903] Dynamic subtest vcs1: SUCCESS (0.030s)
[181.497746] Starting dynamic subtest: vecs0
[181.520730] Dynamic subtest vecs0: SUCCESS (0.030s)
[181.528581] Starting dynamic subtest: ccs0
[181.550180] Dynamic subtest ccs0: SUCCESS (0.029s)
[181.552052] Subtest submit-late-slice: SUCCESS (0.186s)
[183.072665] [043/131] (837s left) kms_plane (pixel-format)
[183.175632] Starting subtest: pixel-format
[183.202486] Starting dynamic subtest: pipe-A-plane-0
[187.857703] Dynamic subtest pipe-A-plane-0: SUCCESS (4.655s)
[187.867976] Starting dynamic subtest: pipe-A-plane-3
[190.091253] Dynamic subtest pipe-A-plane-3: SUCCESS (2.231s)
[190.103977] Starting dynamic subtest: pipe-A-plane-5
[190.302061] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s)
[191.424184] Starting dynamic subtest: pipe-B-plane-0
[196.193023] Dynamic subtest pipe-B-plane-0: SUCCESS (4.778s)
[196.203120] Starting dynamic subtest: pipe-B-plane-3
[198.459910] Dynamic subtest pipe-B-plane-3: SUCCESS (2.266s)
[198.469338] Starting dynamic subtest: pipe-B-plane-5
[198.670921] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s)
[198.976751] Subtest pixel-format: SUCCESS (15.802s)
[199.828430] [044/131] (820s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[199.927782] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[199.930085] Starting dynamic subtest: pipe-A-eDP-1
[199.950371] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[199.960125] Starting dynamic subtest: pipe-B-eDP-1
[199.979753] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[199.987563] Starting dynamic subtest: pipe-C-eDP-1
[200.006904] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[200.016084] Starting dynamic subtest: pipe-D-eDP-1
[200.035287] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[200.037457] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[202.191397] [045/131] (818s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[202.287768] Starting subtest: 2x-plain-flip-ts-check-interruptible
[202.300351] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[202.398906] [046/131] (818s left) api_intel_bb (reset-flags)
[202.458864] Starting subtest: reset-flags
[202.469749] Subtest reset-flags: SUCCESS (0.011s)
[202.639945] [047/131] (818s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[202.697134] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[202.776827] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.027s)
[202.817259] [048/131] (818s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[207.841347] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[207.846073] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.003s)
[208.699545] [049/131] (812s left) i915_suspend (sysfs-reader)
[208.762432] Starting subtest: sysfs-reader
[227.212810] Subtest sysfs-reader: SUCCESS (7.360s)
[237.284464] [050/131] (793s left) gem_mmap_gtt (basic-wc)
[237.363763] Subtest basic-wc: SKIP (0.000s)
[237.471285] [051/131] (793s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[237.582620] Starting subtest: fbc-rgb565-draw-mmap-gtt
[237.586761] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[237.716519] [052/131] (793s left) gem_exec_flush (basic-uc-set-default)
[237.784397] Starting subtest: basic-uc-set-default
[243.275024] Subtest basic-uc-set-default: SUCCESS (5.453s)
[243.447215] [053/131] (787s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[243.557969] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[250.472431] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.915s)
[250.651900] [054/131] (780s left) kms_flip (2x-plain-flip)
[250.751246] Starting subtest: 2x-plain-flip
[250.762798] Subtest 2x-plain-flip: SKIP (0.013s)
[250.908790] [055/131] (780s left) core_setmaster_vs_auth
[251.078504] [056/131] (780s left) gem_userptr_blits (dmabuf-unsync)
[251.155434] Subtest dmabuf-unsync: SKIP (0.000s)
[251.312825] [057/131] (780s left) kms_scaling_modes (scaling-mode-center)
[251.414362] Starting subtest: scaling-mode-center
[251.416720] Starting dynamic subtest: pipe-A-eDP-1
[251.507168] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s)
[251.524173] Starting dynamic subtest: pipe-B-eDP-1
[252.678840] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.168s)
[252.691322] Starting dynamic subtest: pipe-C-eDP-1
[253.788575] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.106s)
[253.800022] Starting dynamic subtest: pipe-D-eDP-1
[254.916649] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s)
[254.918982] Subtest scaling-mode-center: SUCCESS (3.504s)
[256.105707] [058/131] (775s left) gem_exec_flush (basic-batch-kernel-default-wb)
[256.167537] Starting subtest: basic-batch-kernel-default-wb
[263.423289] Subtest basic-batch-kernel-default-wb: SUCCESS (7.255s)
[263.640574] [059/131] (767s left) perf (i915-ref-count)
[263.747075] Starting subtest: i915-ref-count
[263.784429] Subtest i915-ref-count: SUCCESS (0.037s)
[263.839129] [060/131] (767s left) kms_lease (page-flip-implicit-plane)
[263.934833] Starting subtest: page-flip-implicit-plane
[263.937059] Starting dynamic subtest: pipe-A-eDP-1
[264.414817] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.480s)
[264.424796] Starting dynamic subtest: pipe-B-eDP-1
[265.506753] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.090s)
[265.518479] Starting dynamic subtest: pipe-C-eDP-1
[266.631445] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.120s)
[266.643145] Starting dynamic subtest: pipe-D-eDP-1
[267.764616] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s)
[267.766753] Subtest page-flip-implicit-plane: SUCCESS (3.829s)
[268.625543] [061/131] (762s left) gem_softpin (allocator-evict)
[268.698485] Starting subtest: allocator-evict
[268.700917] Starting dynamic subtest: rcs0
[292.326003] Dynamic subtest rcs0: SUCCESS (23.627s)
[292.337414] Starting dynamic subtest: bcs0
[316.256636] Dynamic subtest bcs0: SUCCESS (23.926s)
[316.268874] Starting dynamic subtest: vcs0
[340.209684] Dynamic subtest vcs0: SUCCESS (23.949s)
[340.221111] Starting dynamic subtest: vcs1
[364.102121] Dynamic subtest vcs1: SUCCESS (23.891s)
[364.113509] Starting dynamic subtest: vecs0
[387.856426] Dynamic subtest vecs0: SUCCESS (23.751s)
[387.867735] Starting dynamic subtest: ccs0
[411.740377] Dynamic subtest ccs0: SUCCESS (23.881s)
[411.742824] Subtest allocator-evict: SUCCESS (143.035s)
[411.844766] [062/131] (619s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[412.003076] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[412.005383] Starting dynamic subtest: pipe-A-eDP-1
[412.025493] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[412.036172] Starting dynamic subtest: pipe-B-eDP-1
[412.055605] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[412.064184] Starting dynamic subtest: pipe-C-eDP-1
[412.083145] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[412.091503] Starting dynamic subtest: pipe-D-eDP-1
[412.110864] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[412.112754] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[414.264205] [063/131] (617s left) kms_content_protection (content-type-change)
[414.424670] Starting subtest: content-type-change
[414.429090] Subtest content-type-change: SKIP (0.000s)
[414.557080] [064/131] (617s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[414.718620] Starting subtest: cursor-rapid-movement-32x10
[414.765244] Subtest cursor-rapid-movement-32x10: SKIP (0.042s)
[415.054652] [065/131] (616s left) syncobj_basic (bad-destroy)
[415.118593] Starting subtest: bad-destroy
[415.120504] Subtest bad-destroy: SUCCESS (0.000s)
[415.245500] [066/131] (616s left) kms_flip (bo-too-big-interruptible)
[415.347551] Starting subtest: bo-too-big-interruptible
[415.351685] Starting dynamic subtest: A-eDP1
[416.692764] Dynamic subtest A-eDP1: SUCCESS (1.342s)
[416.703034] Starting dynamic subtest: B-eDP1
[417.924924] Dynamic subtest B-eDP1: SUCCESS (1.231s)
[417.933659] Starting dynamic subtest: C-eDP1
[419.182880] Dynamic subtest C-eDP1: SUCCESS (1.257s)
[419.194388] Starting dynamic subtest: D-eDP1
[420.510917] Dynamic subtest D-eDP1: SUCCESS (1.327s)
[420.513406] Subtest bo-too-big-interruptible: SUCCESS (5.165s)
[421.734910] [067/131] (610s left) kms_pm_dc (dc6-dpms)
[422.857837] Starting subtest: dc6-dpms
[424.891370] Subtest dc6-dpms: SUCCESS (2.031s)
[424.990336] [068/131] (606s left) gen9_exec_parse (unaligned-jump)
[425.059502] Subtest unaligned-jump: SKIP (0.000s)
[425.132789] [069/131] (606s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[425.245827] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[426.325958] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.080s)
[426.482858] [070/131] (605s left) perf_pmu (init-wait)
[426.530670] Starting subtest: init-wait
[426.532542] Starting dynamic subtest: rcs0
[426.534526] Dynamic subtest rcs0: SUCCESS (0.002s)
[426.548480] Starting dynamic subtest: bcs0
[426.550214] Dynamic subtest bcs0: SUCCESS (0.001s)
[426.560575] Starting dynamic subtest: vcs0
[426.562657] Dynamic subtest vcs0: SUCCESS (0.001s)
[426.572780] Starting dynamic subtest: vcs1
[426.574588] Dynamic subtest vcs1: SUCCESS (0.001s)
[426.582357] Starting dynamic subtest: vecs0
[426.584166] Dynamic subtest vecs0: SUCCESS (0.001s)
[426.592156] Starting dynamic subtest: ccs0
[426.594014] Dynamic subtest ccs0: SUCCESS (0.000s)
[426.596153] Subtest init-wait: SUCCESS (0.011s)
[426.678013] [071/131] (605s left) kms_getfb (getfb-handle-not-fb)
[426.776558] Starting subtest: getfb-handle-not-fb
[426.778536] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[426.914227] [072/131] (605s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[426.972615] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[426.974220] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[427.100800] [073/131] (604s left) kms_dsc (dsc-with-bpc-formats)
[427.194193] Starting subtest: dsc-with-bpc-formats
[427.282592] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[427.319089] [074/131] (604s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[427.714855] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[428.561627] [075/131] (603s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[428.666282] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[428.670285] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[428.804080] [076/131] (603s left) syncobj_timeline (invalid-signal-zero-handles)
[428.870917] Starting subtest: invalid-signal-zero-handles
[428.873375] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[429.000851] [077/131] (603s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[429.096402] Starting subtest: addfb25-y-tiled-legacy
[429.098716] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[429.228460] [078/131] (603s left) gem_exec_fence (invalid-timeline-fence-array)
[429.832895] Starting subtest: invalid-timeline-fence-array
[429.835693] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[431.143727] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[431.147276] [079/131] (601s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[431.234529] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[431.239294] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[431.448490] [080/131] (600s left) kms_psr (fbc-psr2-dpms)
[431.559000] Starting subtest: fbc-psr2-dpms
[431.561347] Starting dynamic subtest: eDP-1
[431.565492] Dynamic subtest eDP-1: SKIP (0.000s)
[431.569726] Subtest fbc-psr2-dpms: SKIP (0.001s)
[431.658381] [081/131] (600s left) gem_exec_alignment (many)
[431.723881] Starting subtest: many
[454.465784] Subtest many: SUCCESS (22.738s)
[455.996682] [082/131] (576s left) gem_mmap_offset (ptrace)
[456.108674] Starting subtest: ptrace
[456.113791] Starting dynamic subtest: smem0-wb
[456.134953] Dynamic subtest smem0-wb: SUCCESS (0.021s)
[456.145766] Starting dynamic subtest: smem0-wc
[456.153861] Dynamic subtest smem0-wc: SUCCESS (0.018s)
[456.162427] Starting dynamic subtest: smem0-uc
[456.174254] Dynamic subtest smem0-uc: SUCCESS (0.019s)
[456.176390] Subtest ptrace: SUCCESS (0.069s)
[456.299765] [083/131] (576s left) gem_exec_schedule (noreorder-priority)
[456.488570] Starting subtest: noreorder-priority
[456.491610] Starting dynamic subtest: rcs0
[457.667346] Dynamic subtest rcs0: SUCCESS (1.179s)
[457.678773] Starting dynamic subtest: vcs0
[459.015614] Dynamic subtest vcs0: SUCCESS (1.344s)
[459.027754] Starting dynamic subtest: vcs1
[460.977441] Dynamic subtest vcs1: SUCCESS (1.959s)
[460.989386] Starting dynamic subtest: vecs0
[463.044407] Dynamic subtest vecs0: SUCCESS (2.065s)
[463.056125] Starting dynamic subtest: ccs0
[464.194905] Dynamic subtest ccs0: SUCCESS (1.150s)
[464.197634] Subtest noreorder-priority: SUCCESS (7.709s)
[464.407163] [084/131] (568s left) gem_ctx_engines (execute-one)
[464.467495] Starting subtest: execute-one
[467.595658] Subtest execute-one: SUCCESS (3.129s)
[469.032488] [085/131] (563s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[469.165686] Starting subtest: flip-vs-cursor-legacy
[476.267949] Subtest flip-vs-cursor-legacy: SUCCESS (7.103s)
[477.121104] [086/131] (555s left) perf_pmu (busy-double-start)
[477.161551] Starting subtest: busy-double-start
[477.163490] Starting dynamic subtest: rcs0
[480.800347] Dynamic subtest rcs0: FAIL (3.589s)
[480.811829] Starting dynamic subtest: bcs0
[484.382194] Dynamic subtest bcs0: FAIL (3.563s)
[484.393064] Starting dynamic subtest: vcs0
[488.536966] Dynamic subtest vcs0: SUCCESS (4.223s)
[488.548647] Starting dynamic subtest: vcs1
[492.549892] Dynamic subtest vcs1: SUCCESS (4.011s)
[492.561917] Starting dynamic subtest: vecs0
[496.491800] Dynamic subtest vecs0: SUCCESS (3.940s)
[496.503508] Starting dynamic subtest: ccs0
[500.124741] Dynamic subtest ccs0: FAIL (3.565s)
[500.126647] Subtest busy-double-start: FAIL (22.901s)
[500.201073] [087/131] (532s left) gem_exec_alignment (single)
[500.265540] Starting subtest: single
[500.270947] Subtest single: SUCCESS (0.004s)
[500.434205] [088/131] (532s left) gem_exec_balancer (parallel)
[500.691608] Starting subtest: parallel
[501.617828] Subtest parallel: SUCCESS (0.926s)
[501.995930] [089/131] (530s left) kms_dp_aux_dev
[502.373875] [090/131] (530s left) kms_flip (basic-flip-vs-modeset)
[502.478895] Starting subtest: basic-flip-vs-modeset
[502.481125] Starting dynamic subtest: A-eDP1
[505.070631] Dynamic subtest A-eDP1: SUCCESS (2.591s)
[505.080921] Starting dynamic subtest: B-eDP1
[507.230924] Dynamic subtest B-eDP1: SUCCESS (2.158s)
[507.240818] Starting dynamic subtest: C-eDP1
[509.400139] Dynamic subtest C-eDP1: SUCCESS (2.167s)
[509.410832] Starting dynamic subtest: D-eDP1
[511.583196] Dynamic subtest D-eDP1: SUCCESS (2.181s)
[511.585499] Subtest basic-flip-vs-modeset: SUCCESS (9.107s)
[512.446817] [091/131] (520s left) gem_exec_capture (capture-recoverable)
[512.516664] Starting subtest: capture-recoverable
[512.519040] Subtest capture-recoverable: SUCCESS (0.003s)
[512.685059] [092/131] (520s left) gem_userptr_blits (create-destroy-sync)
[512.756272] Starting subtest: create-destroy-sync
[517.815353] Subtest create-destroy-sync: SUCCESS (5.009s)
[517.915991] [093/131] (515s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[518.015427] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[518.019788] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[518.128515] [094/131] (514s left) kms_mmap_write_crc (main)
[518.227143] Starting subtest: main
[518.229383] Starting dynamic subtest: pipe-A-eDP-1
[521.627995] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.399s)
[521.630436] Subtest main: SUCCESS (3.401s)
[522.452429] [095/131] (510s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[522.560156] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[522.564373] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[522.697023] [096/131] (510s left) kms_content_protection (srm)
[522.848140] Starting subtest: srm
[522.854918] Subtest srm: SKIP (0.003s)
[523.026839] [097/131] (510s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[523.147094] Starting subtest: cursorB-vs-flipA-toggle
[523.151465] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[523.322789] [098/131] (509s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[523.418998] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[523.422350] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[523.566881] [099/131] (509s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[523.666960] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[523.670237] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[523.803157] [100/131] (509s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[523.908313] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[523.911906] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[524.068143] [101/131] (509s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[524.172837] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[524.176298] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[524.303547] [102/131] (509s left) gem_mmap (bad-object)
[524.371833] Subtest bad-object: SKIP (0.000s)
[524.447265] [103/131] (508s left) kms_chamelium_frames (hdmi-aspect-ratio)
[524.848724] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[525.630302] [104/131] (507s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[525.729239] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[525.733677] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[525.855500] [105/131] (507s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[525.965143] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[526.923664] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.957s)
[527.099744] [106/131] (506s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[527.207935] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[527.211565] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[527.347019] [107/131] (506s left) gem_exec_params (rs-invalid)
[527.409348] Starting subtest: rs-invalid
[527.413485] Subtest rs-invalid: SUCCESS (0.003s)
[527.581381] [108/131] (505s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[527.684377] Starting subtest: x-tiled-64bpp-rotate-180
[529.163654] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.479s)
[529.367830] [109/131] (504s left) gem_mmap_offset (blt-coherency)
[529.426343] Starting subtest: blt-coherency
[529.431029] Subtest blt-coherency: SUCCESS (0.007s)
[529.582675] [110/131] (504s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[529.689040] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[530.689937] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.000s)
[530.866812] [111/131] (502s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[530.965275] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[530.968941] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[531.098439] [112/131] (502s left) gem_fence_thrash (bo-write-verify-threaded-none)
[531.135693] Starting subtest: bo-write-verify-threaded-none
[531.154577] Subtest bo-write-verify-threaded-none: SKIP (0.016s)
[531.231423] [113/131] (502s left) dmabuf_sync_file (import-basic)
[531.270268] Starting subtest: import-basic
[531.272084] Subtest import-basic: SUCCESS (0.001s)
[531.352410] [114/131] (502s left) gem_exec_whisper (basic-contexts-forked-all)
[531.405038] Starting subtest: basic-contexts-forked-all
[551.924956] Subtest basic-contexts-forked-all: SUCCESS (20.464s)
[552.075186] [115/131] (481s left) kms_vblank (ts-continuation-idle-hang)
[552.171731] Starting subtest: ts-continuation-idle-hang
[552.173994] Starting dynamic subtest: pipe-A-eDP-1
[578.727267] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.553s)
[578.744792] Starting dynamic subtest: pipe-D-eDP-1
[603.754180] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.021s)
[603.756388] Subtest ts-continuation-idle-hang: SUCCESS (51.579s)
[604.640044] [116/131] (429s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[604.752931] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[609.236690] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.489s)
[610.445872] [117/131] (423s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[610.555824] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[618.102799] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.548s)
[618.310104] [118/131] (415s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[623.431436] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[623.433673] Starting dynamic subtest: pipe-A-eDP-1
[629.952552] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.519s)
[629.963315] Starting dynamic subtest: pipe-B-eDP-1
[636.603770] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.651s)
[636.605943] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.174s)
[637.505641] [119/131] (396s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[637.565594] Starting subtest: mixed-tiled-to-y-tiled-ccs
[637.569877] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[637.774228] [120/131] (396s left) gem_exec_reloc (basic-cpu-read-active)
[637.830674] Subtest basic-cpu-read-active: SKIP (0.000s)
[637.914333] [121/131] (396s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[638.021126] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[638.023424] Starting dynamic subtest: pipe-A
[638.427750] Dynamic subtest pipe-A: SUCCESS (0.409s)
[638.437694] Starting dynamic subtest: pipe-B
[639.874478] Dynamic subtest pipe-B: SUCCESS (1.446s)
[639.885812] Starting dynamic subtest: pipe-C
[641.307213] Dynamic subtest pipe-C: SUCCESS (1.431s)
[641.316948] Starting dynamic subtest: pipe-D
[642.769451] Dynamic subtest pipe-D: SUCCESS (1.461s)
[642.771618] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.751s)
[643.937494] [122/131] (390s left) syncobj_wait (single-wait-for-submit-signaled)
[643.992149] Starting subtest: single-wait-for-submit-signaled
[643.994467] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[644.121237] [123/131] (390s left) gem_exec_params (no-blt)
[644.170781] Starting subtest: no-blt
[644.175617] Subtest no-blt: SUCCESS (0.002s)
[644.334561] [124/131] (389s left) kms_rotation_crc (bad-tiling)
[644.423180] Starting subtest: bad-tiling
[644.427641] Subtest bad-tiling: SKIP (0.001s)
[644.521920] [125/131] (389s left) kms_prime (basic-crc-vgem)
[644.607705] Starting subtest: basic-crc-vgem
[644.610038] Starting dynamic subtest: second-to-first
[645.635613] Dynamic subtest second-to-first: SUCCESS (1.031s)
[645.637501] Subtest basic-crc-vgem: SUCCESS (1.032s)
[645.741916] [126/131] (388s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[645.850370] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[645.852177] Starting dynamic subtest: pipe-A-default-mode
[646.140004] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[646.144695] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.287s)
[646.969937] [127/131] (387s left) i915_pm_rpm (gem-pread)
[649.202144] Starting subtest: gem-pread
[651.241283] Subtest gem-pread: SUCCESS (2.043s)
[651.355039] [128/131] (383s left) gem_userptr_blits (userfault)
[651.418993] Starting subtest: userfault
[651.421381] Subtest userfault: SUCCESS (0.007s)
[651.593047] [129/131] (382s left) syncobj_timeline (multi-wait-signaled)
[651.646049] Starting subtest: multi-wait-signaled
[651.648355] Subtest multi-wait-signaled: SUCCESS (0.000s)
[651.782436] [130/131] (382s left) gem_exec_whisper (basic-sync-all)
[651.855406] Starting subtest: basic-sync-all
[658.739942] Subtest basic-sync-all: SUCCESS (6.882s)
[658.955028] [131/131] (375s left) drm_read (short-buffer-nonblock)
[659.137630] Starting subtest: short-buffer-nonblock
[659.139803] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[659.315187] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_barrier_race
results: parsing output: 4/ for test: api_intel_bb
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: gem_mmap_wc
results: parsing output: 8/ for test: gem_mmap_gtt
results: parsing output: 9/ for test: gem_render_copy
results: parsing output: 10/ for test: perf
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_invalid_mode
results: parsing output: 13/ for test: i915_drm_fdinfo
results: parsing output: 14/ for test: kms_pipe_b_c_ivb
results: parsing output: 15/ for test: gen9_exec_parse
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: sysfs_timeslice_duration
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_flip_scaled_crc
results: parsing output: 21/ for test: gem_ctx_persistence
results: parsing output: 22/ for test: gem_ctx_param
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_ctx_persistence
results: parsing output: 27/ for test: kms_setmode
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: gem_tiled_pread_basic
results: parsing output: 33/ for test: kms_sequence
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: gem_ppgtt
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_plane_scaling
results: parsing output: 38/ for test: gem_softpin
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_exec_schedule
results: parsing output: 42/ for test: kms_plane
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: api_intel_bb
results: parsing output: 46/ for test: sriov_basic
results: parsing output: 47/ for test: kms_psr2_sf
results: parsing output: 48/ for test: i915_suspend
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_exec_flush
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: core_setmaster_vs_auth
results: parsing output: 55/ for test: gem_userptr_blits
results: parsing output: 56/ for test: kms_scaling_modes
results: parsing output: 57/ for test: gem_exec_flush
results: parsing output: 58/ for test: perf
results: parsing output: 59/ for test: kms_lease
results: parsing output: 60/ for test: gem_softpin
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_content_protection
results: parsing output: 63/ for test: kms_cursor_crc
results: parsing output: 64/ for test: syncobj_basic
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_pm_dc
results: parsing output: 67/ for test: gen9_exec_parse
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: kms_getfb
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: kms_dsc
results: parsing output: 73/ for test: kms_chamelium_hpd
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_addfb_basic
results: parsing output: 77/ for test: gem_exec_fence
results: parsing output: 78/ for test: gem_render_copy
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: gem_exec_alignment
results: parsing output: 81/ for test: gem_mmap_offset
results: parsing output: 82/ for test: gem_exec_schedule
results: parsing output: 83/ for test: gem_ctx_engines
results: parsing output: 84/ for test: kms_cursor_legacy
results: parsing output: 85/ for test: perf_pmu
results: parsing output: 86/ for test: gem_exec_alignment
results: parsing output: 87/ for test: gem_exec_balancer
results: parsing output: 88/ for test: kms_dp_aux_dev
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: gem_exec_capture
results: parsing output: 91/ for test: gem_userptr_blits
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_mmap_write_crc
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_content_protection
results: parsing output: 96/ for test: kms_cursor_legacy
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: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_mmap
results: parsing output: 102/ for test: kms_chamelium_frames
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_exec_params
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: gem_mmap_offset
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_fence_thrash
results: parsing output: 112/ for test: dmabuf_sync_file
results: parsing output: 113/ for test: gem_exec_whisper
results: parsing output: 114/ for test: kms_vblank
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_psr2_sf
results: parsing output: 118/ for test: gem_render_copy
results: parsing output: 119/ for test: gem_exec_reloc
results: parsing output: 120/ for test: kms_plane_scaling
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: gem_exec_params
results: parsing output: 123/ for test: kms_rotation_crc
results: parsing output: 124/ for test: kms_prime
results: parsing output: 125/ for test: kms_flip_scaled_crc
results: parsing output: 126/ for test: i915_pm_rpm
results: parsing output: 127/ for test: gem_userptr_blits
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: gem_exec_whisper
results: parsing output: 130/ for test: drm_read
Done.