[58.187596] Initializing watchdogs
[58.187651]   /dev/watchdog0
[58.202570] [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.207466] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.209760] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.213107] [001/132] (960s left) gem_eio (in-flight-1us)
[58.397798] Starting subtest: in-flight-1us
[65.567261] Subtest in-flight-1us: SUCCESS (7.169s)
[65.707816] [FACT gem_eio (in-flight-1us)] new: kernel.kmod_is_loaded.vgem: true
[65.710890] [002/132] (953s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[65.759172] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[65.866338] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[65.951986] [003/132] (952s left) kms_flip (flip-vs-wf_vblank-interruptible)
[66.041257] Starting subtest: flip-vs-wf_vblank-interruptible
[66.043669] Starting dynamic subtest: A-eDP1
[67.954694] Dynamic subtest A-eDP1: SUCCESS (1.913s)
[67.963534] Starting dynamic subtest: B-eDP1
[69.872684] Dynamic subtest B-eDP1: SUCCESS (1.915s)
[69.882962] Starting dynamic subtest: C-eDP1
[71.792080] Dynamic subtest C-eDP1: SUCCESS (1.918s)
[71.802317] Starting dynamic subtest: D-eDP1
[73.733676] Dynamic subtest D-eDP1: SUCCESS (1.942s)
[73.738704] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.697s)
[74.970719] [004/132] (943s left) kms_cursor_edge_walk (128x128-left-edge)
[75.067320] Starting subtest: 128x128-left-edge
[75.069784] Starting dynamic subtest: pipe-A-eDP-1
[78.536438] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.469s)
[78.546669] Starting dynamic subtest: pipe-D-eDP-1
[81.664253] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.127s)
[81.666735] Subtest 128x128-left-edge: SUCCESS (6.598s)
[82.459973] [005/132] (936s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[82.566119] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[82.570281] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[82.671178] [006/132] (936s left) gem_exec_endless (dispatch)
[82.738595] Starting subtest: dispatch
[82.740999] Starting dynamic subtest: rcs0
[82.745753] Dynamic subtest rcs0: SUCCESS (0.005s)
[82.757985] Starting dynamic subtest: bcs0
[82.762452] Dynamic subtest bcs0: SUCCESS (0.006s)
[82.771376] Starting dynamic subtest: vcs0
[82.775236] Dynamic subtest vcs0: SUCCESS (0.005s)
[82.783230] Starting dynamic subtest: vcs1
[82.787565] Dynamic subtest vcs1: SUCCESS (0.009s)
[82.795865] Starting dynamic subtest: vecs0
[82.800207] Dynamic subtest vecs0: SUCCESS (0.005s)
[82.807670] Starting dynamic subtest: ccs0
[82.812048] Dynamic subtest ccs0: SUCCESS (0.005s)
[82.814212] Subtest dispatch: SUCCESS (0.036s)
[83.969390] [007/132] (934s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[84.079587] Starting subtest: 4-tiled-32bpp-rotate-90
[84.099190] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[84.222144] [008/132] (934s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[84.333273] Starting subtest: pr-primary-plane-update-sf-dmg-area
[84.337406] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[84.402399] [009/132] (934s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[84.494095] Starting subtest: fbc-rgb101010-draw-blt
[89.095335] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.604s)
[90.278861] [010/132] (928s left) gem_exec_schedule (implicit-boths)
[90.354593] Starting subtest: implicit-boths
[90.356868] Starting dynamic subtest: rcs0
[90.454988] Dynamic subtest rcs0: SUCCESS (0.107s)
[90.464724] Starting dynamic subtest: vcs0
[90.547361] Dynamic subtest vcs0: SUCCESS (0.092s)
[90.562027] Starting dynamic subtest: vcs1
[90.636313] Dynamic subtest vcs1: SUCCESS (0.089s)
[90.648165] Starting dynamic subtest: vecs0
[90.713046] Dynamic subtest vecs0: SUCCESS (0.076s)
[90.723920] Starting dynamic subtest: ccs0
[90.806089] Dynamic subtest ccs0: SUCCESS (0.093s)
[90.808522] Subtest implicit-boths: SUCCESS (0.458s)
[92.015811] [011/132] (927s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[92.116339] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[96.680039] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.568s)
[97.879210] [012/132] (921s left) gem_exec_flush (basic-uc-pro-default)
[97.972187] Starting subtest: basic-uc-pro-default
[103.438312] Subtest basic-uc-pro-default: SUCCESS (5.469s)
[103.627591] [013/132] (915s left) gem_flink_race (flink_close)
[103.663312] Starting subtest: flink_close
[108.750338] Subtest flink_close: SUCCESS (5.087s)
[108.829049] [014/132] (910s left) gem_userptr_blits (vma-merge)
[108.903134] Starting subtest: vma-merge
[108.953530] Subtest vma-merge: SUCCESS (0.051s)
[109.107587] [015/132] (910s left) kms_vblank (wait-busy-hang)
[109.229668] Starting subtest: wait-busy-hang
[109.231569] Starting dynamic subtest: pipe-A-eDP-1
[135.638069] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.406s)
[135.656129] Starting dynamic subtest: pipe-D-eDP-1
[150.690631] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.052s)
[150.693044] Subtest wait-busy-hang: SUCCESS (41.462s)
[151.521163] [016/132] (867s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[151.632445] Starting subtest: yf-tiled-32bpp-rotate-90
[151.636987] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[151.732821] [017/132] (867s left) syncobj_timeline (reset-unsignaled)
[151.796624] Starting subtest: reset-unsignaled
[151.798745] Subtest reset-unsignaled: SUCCESS (0.000s)
[151.897940] [018/132] (867s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[151.983616] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[151.985861] Starting dynamic subtest: pipe-A
[153.042493] Dynamic subtest pipe-A: SUCCESS (1.061s)
[153.052525] Starting dynamic subtest: pipe-B
[155.137606] Dynamic subtest pipe-B: SUCCESS (2.094s)
[155.152336] Starting dynamic subtest: pipe-C
[156.341588] Dynamic subtest pipe-C: SUCCESS (1.203s)
[156.350303] Starting dynamic subtest: pipe-D
[157.493124] Dynamic subtest pipe-D: SUCCESS (1.151s)
[157.495572] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.511s)
[158.692992] [019/132] (860s left) gem_exec_params (rsvd2-dirt)
[158.748459] Starting subtest: rsvd2-dirt
[158.753259] Subtest rsvd2-dirt: SKIP (0.000s)
[158.854325] [020/132] (860s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[158.958689] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[158.962829] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[159.057657] [021/132] (860s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[159.161591] Starting subtest: psr-shrfb-scaledprimary
[164.976629] Subtest psr-shrfb-scaledprimary: SUCCESS (5.816s)
[165.103102] [022/132] (854s left) gem_spin_batch (engines)
[165.166897] Starting subtest: engines
[165.169280] Starting dynamic subtest: rcs0
[168.406063] Dynamic subtest rcs0: SUCCESS (3.234s)
[168.416205] Starting dynamic subtest: bcs0
[171.643100] Dynamic subtest bcs0: SUCCESS (3.235s)
[171.653967] Starting dynamic subtest: vcs0
[174.879885] Dynamic subtest vcs0: SUCCESS (3.235s)
[174.889062] Starting dynamic subtest: vcs1
[178.118161] Dynamic subtest vcs1: SUCCESS (3.236s)
[178.127453] Starting dynamic subtest: vecs0
[181.357045] Dynamic subtest vecs0: SUCCESS (3.237s)
[181.370678] Starting dynamic subtest: ccs0
[184.592924] Dynamic subtest ccs0: SUCCESS (3.234s)
[184.595497] Subtest engines: SUCCESS (19.422s)
[184.829051] [023/132] (834s left) gem_lmem_swapping (verify-random-ccs)
[184.873438] Subtest verify-random-ccs: SKIP (0.000s)
[184.919902] [024/132] (834s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[185.022070] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[185.026732] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[185.118685] [025/132] (834s left) syncobj_timeline (wait-any-interrupted)
[185.175727] Starting subtest: wait-any-interrupted
[185.277631] Subtest wait-any-interrupted: SUCCESS (0.102s)
[185.353942] [026/132] (834s left) kms_frontbuffer_tracking (fbc-stridechange)
[185.451437] Starting subtest: fbc-stridechange
[188.702021] Subtest fbc-stridechange: SUCCESS (3.254s)
[189.821743] [027/132] (829s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[189.985209] Starting subtest: cursor-rapid-movement-64x64
[189.990070] Starting dynamic subtest: pipe-A-eDP-1
[190.522365] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.531s)
[190.550914] Starting dynamic subtest: pipe-D-eDP-1
[191.732799] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.190s)
[191.734832] Subtest cursor-rapid-movement-64x64: SUCCESS (1.746s)
[192.582813] [028/132] (827s left) kms_psr (psr2-sprite-plane-onoff)
[192.685201] Starting subtest: psr2-sprite-plane-onoff
[192.687525] Starting dynamic subtest: eDP-1
[194.404171] Dynamic subtest eDP-1: SUCCESS (1.719s)
[194.406528] Subtest psr2-sprite-plane-onoff: SUCCESS (1.720s)
[195.252866] [029/132] (824s left) gem_reg_read (bad-register)
[195.314510] Starting subtest: bad-register
[195.316897] Subtest bad-register: SUCCESS (0.000s)
[195.431405] [030/132] (824s left) kms_big_fb (linear-64bpp-rotate-0)
[195.526880] Starting subtest: linear-64bpp-rotate-0
[197.226285] Subtest linear-64bpp-rotate-0: SUCCESS (1.701s)
[197.395662] [031/132] (822s left) gem_exec_await (wide-contexts)
[197.602497] Starting subtest: wide-contexts
[220.739084] Subtest wide-contexts: SUCCESS (23.134s)
[220.936288] [032/132] (799s left) i915_pm_freq_api (freq-reset)
[221.040338] Starting subtest: freq-reset
[221.042709] Starting dynamic subtest: gt0
[221.247170] Dynamic subtest gt0: SUCCESS (0.203s)
[221.255535] Starting dynamic subtest: gt1
[221.418419] Dynamic subtest gt1: SUCCESS (0.171s)
[221.421210] Subtest freq-reset: SUCCESS (0.377s)
[221.497059] [033/132] (798s left) gem_render_copy_redux (interruptible)
[221.561977] Starting subtest: interruptible
[222.031623] Subtest interruptible: SUCCESS (0.472s)
[222.175156] [034/132] (797s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[222.280156] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[222.282320] Starting dynamic subtest: pipe-A-eDP-1
[223.164991] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.879s)
[223.174106] Starting dynamic subtest: pipe-B-eDP-1
[224.695398] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.527s)
[224.705354] Starting dynamic subtest: pipe-C-eDP-1
[226.162342] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.467s)
[226.171810] Starting dynamic subtest: pipe-D-eDP-1
[227.700418] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.537s)
[227.702340] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.414s)
[228.866094] [035/132] (791s left) gem_exec_params (sol-reset-not-gen7)
[228.936802] Starting subtest: sol-reset-not-gen7
[228.939125] Subtest sol-reset-not-gen7: SUCCESS (0.002s)
[229.061681] [036/132] (791s left) kms_flip (flip-vs-panning-vs-hang)
[229.153840] Starting subtest: flip-vs-panning-vs-hang
[229.156235] Starting dynamic subtest: A-eDP1
[280.426827] Dynamic subtest A-eDP1: SUCCESS (51.271s)
[280.439257] Starting dynamic subtest: D-eDP1
[329.407903] Dynamic subtest D-eDP1: SUCCESS (48.976s)
[329.410256] Subtest flip-vs-panning-vs-hang: SUCCESS (100.252s)
[330.629007] [037/132] (689s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[330.738795] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[330.743164] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[330.835185] [038/132] (689s left) dmabuf_sync_file (export-wait-after-attach)
[330.877268] Starting subtest: export-wait-after-attach
[330.879190] Subtest export-wait-after-attach: SUCCESS (0.001s)
[330.936598] [039/132] (689s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[331.035342] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[331.037620] Starting dynamic subtest: pipe-A-eDP-1
[331.096728] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[331.105031] Starting dynamic subtest: pipe-B-eDP-1
[331.164057] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[331.174154] Starting dynamic subtest: pipe-C-eDP-1
[331.232136] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[331.242621] Starting dynamic subtest: pipe-D-eDP-1
[331.300055] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[331.304240] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.008s)
[333.217843] [040/132] (687s left) kms_plane (plane-position-hole)
[333.317082] Starting subtest: plane-position-hole
[333.848953] Starting dynamic subtest: pipe-A-plane-1
[335.084211] Dynamic subtest pipe-A-plane-1: SUCCESS (1.235s)
[335.094229] Starting dynamic subtest: pipe-A-plane-2
[336.326654] Dynamic subtest pipe-A-plane-2: SUCCESS (1.243s)
[336.336714] Starting dynamic subtest: pipe-A-plane-3
[337.666060] Dynamic subtest pipe-A-plane-3: SUCCESS (1.338s)
[337.675835] Starting dynamic subtest: pipe-A-plane-4
[339.010408] Dynamic subtest pipe-A-plane-4: SUCCESS (1.346s)
[339.019477] Starting dynamic subtest: pipe-A-plane-5
[339.037359] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[340.238205] Starting dynamic subtest: pipe-B-plane-1
[341.553429] Dynamic subtest pipe-B-plane-1: SUCCESS (1.324s)
[341.563032] Starting dynamic subtest: pipe-B-plane-2
[342.875892] Dynamic subtest pipe-B-plane-2: SUCCESS (1.320s)
[342.885584] Starting dynamic subtest: pipe-B-plane-3
[344.111432] Dynamic subtest pipe-B-plane-3: SUCCESS (1.232s)
[344.121306] Starting dynamic subtest: pipe-B-plane-4
[345.361187] Dynamic subtest pipe-B-plane-4: SUCCESS (1.251s)
[345.370298] Starting dynamic subtest: pipe-B-plane-5
[345.391274] Dynamic subtest pipe-B-plane-5: SUCCESS (0.028s)
[345.393546] Subtest plane-position-hole: SUCCESS (12.074s)
[346.159859] [041/132] (674s left) gem_pxp (create-valid-protected-context)
[346.296802] Starting subtest: create-valid-protected-context
[346.299594] Subtest create-valid-protected-context: SUCCESS (0.002s)
[346.404469] [042/132] (674s left) gem_exec_reloc (basic-write-wc-active)
[346.463985] Subtest basic-write-wc-active: SKIP (0.000s)
[346.547274] [043/132] (673s left) gem_exec_await (wide-all)
[346.731538] Starting subtest: wide-all
[369.608816] Subtest wide-all: SUCCESS (22.876s)
[369.809498] [044/132] (650s left) gem_eio (wait-wedge-1us)
[370.083556] Starting subtest: wait-wedge-1us
[371.944242] Subtest wait-wedge-1us: SUCCESS (1.860s)
[372.071499] [045/132] (648s left) perf_pmu (busy-start)
[372.119928] Starting subtest: busy-start
[372.122072] Starting dynamic subtest: rcs0
[374.671069] Dynamic subtest rcs0: SUCCESS (2.551s)
[374.682896] Starting dynamic subtest: bcs0
[377.221024] Dynamic subtest bcs0: SUCCESS (2.548s)
[377.233920] Starting dynamic subtest: vcs0
[380.884695] Dynamic subtest vcs0: SUCCESS (3.660s)
[380.897402] Starting dynamic subtest: vcs1
[384.916410] Dynamic subtest vcs1: SUCCESS (4.029s)
[384.928907] Starting dynamic subtest: vecs0
[388.884310] Dynamic subtest vecs0: SUCCESS (3.965s)
[388.896906] Starting dynamic subtest: ccs0
[391.434314] Dynamic subtest ccs0: SUCCESS (2.549s)
[391.437160] Subtest busy-start: SUCCESS (19.316s)
[391.541027] [046/132] (629s left) gem_lmem_swapping (heavy-random)
[391.594911] Subtest heavy-random: SKIP (0.000s)
[391.640697] [047/132] (628s left) gem_ctx_persistence (heartbeat-hang)
[391.696958] Starting subtest: heartbeat-hang
[391.701426] Subtest heartbeat-hang: SKIP (0.000s)
[391.803643] [048/132] (628s left) gem_exec_reloc (basic-cpu-wc)
[391.861594] Subtest basic-cpu-wc: SKIP (0.000s)
[391.930110] [049/132] (628s left) i915_pm_rpm (debugfs-read)
[394.091612] Starting subtest: debugfs-read
[395.253058] Subtest debugfs-read: SUCCESS (1.156s)
[395.639669] [050/132] (625s left) syncobj_wait (wait-for-submit-delayed-submit)
[395.708295] Starting subtest: wait-for-submit-delayed-submit
[395.809834] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[395.887662] [051/132] (624s left) kms_selftest (drm_plane_helper)
[395.936489] Starting subtest: drm_plane_helper
[395.946022] Starting dynamic subtest: drm_test_check_plane_state
[396.051476] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.105s)
[396.061347] Starting dynamic subtest: drm_test_check_invalid_plane_state
[396.139218] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.086s)
[396.141567] Subtest drm_plane_helper: SUCCESS (0.203s)
[396.303424] [052/132] (624s left) gem_exec_balancer (parallel-balancer)
[396.570043] Starting subtest: parallel-balancer
[397.474513] Subtest parallel-balancer: SUCCESS (0.908s)
[397.577206] [053/132] (623s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[397.692056] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[397.696543] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[397.813656] [054/132] (623s left) i915_selftest (live)
[399.474965] Starting subtest: live
[399.477725] Starting dynamic subtest: sanitycheck
[403.833809] Dynamic subtest sanitycheck: SUCCESS (4.357s)
[403.844134] Starting dynamic subtest: uncore
[408.089960] Dynamic subtest uncore: SUCCESS (4.254s)
[408.098609] Starting dynamic subtest: workarounds
[411.213425] Dynamic subtest workarounds: SUCCESS (3.122s)
[411.223490] Starting dynamic subtest: gt_engines
[415.796555] Dynamic subtest gt_engines: SUCCESS (4.580s)
[415.805066] Starting dynamic subtest: gt_timelines
[431.476335] Dynamic subtest gt_timelines: SUCCESS (15.676s)
[431.486071] Starting dynamic subtest: gt_contexts
[435.844868] Dynamic subtest gt_contexts: SUCCESS (4.367s)
[435.854164] Starting dynamic subtest: gt_lrc
[440.174510] Dynamic subtest gt_lrc: SUCCESS (4.328s)
[440.184228] Starting dynamic subtest: gt_mocs
[443.121534] Dynamic subtest gt_mocs: SUCCESS (2.945s)
[443.130853] Starting dynamic subtest: gt_pm
[449.833079] Dynamic subtest gt_pm: SUCCESS (6.711s)
[449.847896] Starting dynamic subtest: gt_heartbeat
[452.583402] Dynamic subtest gt_heartbeat: SUCCESS (2.748s)
[452.593626] Starting dynamic subtest: gt_tlb
[461.908373] Dynamic subtest gt_tlb: SUCCESS (9.322s)
[461.918828] Starting dynamic subtest: requests
[473.327442] Dynamic subtest requests: SUCCESS (11.417s)
[473.342054] Starting dynamic subtest: migrate
[479.004755] Dynamic subtest migrate: SUCCESS (5.676s)
[479.013898] Starting dynamic subtest: active
[483.341845] Dynamic subtest active: SUCCESS (4.334s)
[483.351439] Starting dynamic subtest: objects
[486.533437] Dynamic subtest objects: SUCCESS (3.190s)
[486.543528] Starting dynamic subtest: mman
[491.338514] Dynamic subtest mman: SUCCESS (4.803s)
[491.347630] Starting dynamic subtest: dmabuf
[494.121786] Dynamic subtest dmabuf: SUCCESS (2.781s)
[494.131699] Starting dynamic subtest: vma
[496.834977] Dynamic subtest vma: SUCCESS (2.712s)
[496.845310] Starting dynamic subtest: coherency
[500.292673] Dynamic subtest coherency: SUCCESS (3.456s)
[500.302064] Starting dynamic subtest: gtt
[512.223365] Dynamic subtest gtt: SUCCESS (11.928s)
[512.232992] Starting dynamic subtest: gem
[518.620528] Dynamic subtest gem: SUCCESS (6.380s)
[518.630140] Starting dynamic subtest: evict
[522.676076] Dynamic subtest evict: SUCCESS (4.070s)
[522.685675] Starting dynamic subtest: hugepages
[531.476043] Dynamic subtest hugepages: SUCCESS (8.799s)
[531.485783] Starting dynamic subtest: gem_contexts
[560.543935] Dynamic subtest gem_contexts: SUCCESS (29.066s)
[560.553280] Starting dynamic subtest: client
[564.843510] Dynamic subtest client: SUCCESS (4.298s)
[564.853074] Starting dynamic subtest: gem_migrate
[567.525054] Dynamic subtest gem_migrate: SUCCESS (2.679s)
[567.534855] Starting dynamic subtest: reset
[570.298585] Dynamic subtest reset: SUCCESS (2.772s)
[570.307852] Starting dynamic subtest: memory_region
[574.658907] Dynamic subtest memory_region: SUCCESS (4.359s)
[574.672188] Starting dynamic subtest: hangcheck
[587.526094] Dynamic subtest hangcheck: SUCCESS (12.866s)
[587.535855] Starting dynamic subtest: execlists
[591.863370] Dynamic subtest execlists: SUCCESS (4.335s)
[591.873268] Starting dynamic subtest: ring_submission
[596.122340] Dynamic subtest ring_submission: SUCCESS (4.257s)
[596.132063] Starting dynamic subtest: perf
[598.923845] Dynamic subtest perf: SUCCESS (2.801s)
[598.933424] Starting dynamic subtest: slpc
[612.981249] Dynamic subtest slpc: SUCCESS (14.054s)
[612.990955] Starting dynamic subtest: guc
[616.847718] Dynamic subtest guc: SUCCESS (3.865s)
[616.858213] Starting dynamic subtest: guc_multi_lrc
[621.173433] Dynamic subtest guc_multi_lrc: SUCCESS (4.323s)
[621.183548] Starting dynamic subtest: guc_hang
[626.160320] Dynamic subtest guc_hang: SUCCESS (4.986s)
[626.169686] Starting dynamic subtest: late_gt_pm
[628.877379] Dynamic subtest late_gt_pm: SUCCESS (2.716s)
[628.880134] Subtest live: SUCCESS (229.398s)
[628.908903] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[628.909641] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[628.912770] [055/132] (392s left) syncobj_wait (single-wait-for-submit-signaled)
[630.481675] Starting subtest: single-wait-for-submit-signaled
[630.484096] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[630.578941] [FACT syncobj_wait (single-wait-for-submit-signaled)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[630.580265] [FACT syncobj_wait (single-wait-for-submit-signaled)] new: kernel.kmod_is_loaded.i915: true
[630.584075] [056/132] (390s left) fbdev (info)
[630.634908] Starting subtest: info
[630.636798] Subtest info: SUCCESS (0.000s)
[630.707445] [057/132] (390s left) kms_psr (psr-sprite-render)
[630.806207] Starting subtest: psr-sprite-render
[630.808433] Starting dynamic subtest: eDP-1
[632.609631] Dynamic subtest eDP-1: SUCCESS (1.801s)
[632.611891] Subtest psr-sprite-render: SUCCESS (1.802s)
[633.450282] [058/132] (387s left) kms_plane_lowres (tiling-yf)
[633.542881] Starting subtest: tiling-yf
[633.547190] Subtest tiling-yf: SKIP (0.000s)
[633.615481] [059/132] (387s left) syncobj_timeline (invalid-signal-bad-pad)
[633.675989] Starting subtest: invalid-signal-bad-pad
[633.678326] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[633.771154] [060/132] (387s left) gem_ctx_exec (basic-norecovery)
[633.836419] Starting subtest: basic-norecovery
[634.005515] Subtest basic-norecovery: SUCCESS (0.169s)
[634.143174] [061/132] (387s left) kms_pm_backlight (fade-with-dpms)
[634.243923] Starting subtest: fade-with-dpms
[636.423486] Starting dynamic subtest: eDP-1
[638.922166] Dynamic subtest eDP-1: SUCCESS (2.500s)
[638.924509] Subtest fade-with-dpms: SUCCESS (4.680s)
[639.727053] [062/132] (381s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[639.819000] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[639.821302] Starting dynamic subtest: pipe-A-eDP-1
[639.976020] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.149s)
[639.987066] Starting dynamic subtest: pipe-B-eDP-1
[640.007061] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[640.016073] Starting dynamic subtest: pipe-C-eDP-1
[640.035445] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[640.043526] Starting dynamic subtest: pipe-D-eDP-1
[640.063783] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[640.065764] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.158s)
[642.302417] [063/132] (378s left) kms_psr (fbc-pr-primary-render)
[642.397357] Starting subtest: fbc-pr-primary-render
[642.401684] Subtest fbc-pr-primary-render: SKIP (0.000s)
[642.468184] [064/132] (378s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[642.557829] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[649.867537] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.312s)
[650.006134] [065/132] (371s left) kms_hdr (bpc-switch-dpms)
[650.101421] Starting subtest: bpc-switch-dpms
[651.198090] Starting dynamic subtest: pipe-A-eDP-1
[655.736203] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.540s)
[655.738487] Subtest bpc-switch-dpms: SUCCESS (5.638s)
[655.837520] [066/132] (365s left) kms_chamelium_edid (dp-edid-resolution-list)
[656.216821] Subtest dp-edid-resolution-list: SKIP (0.000s)
[657.002455] [067/132] (364s left) gem_eio (unwedge-stress)
[657.141740] Starting subtest: unwedge-stress
[657.144148] Starting dynamic subtest: render
[660.313440] Dynamic subtest render: SUCCESS (3.168s)
[660.329692] Starting dynamic subtest: bsd1
[678.171725] Dynamic subtest bsd1: SUCCESS (17.857s)
[678.188501] Starting dynamic subtest: bsd2
[696.224186] Dynamic subtest bsd2: SUCCESS (18.051s)
[696.240698] Starting dynamic subtest: blt
[696.244989] Dynamic subtest blt: SKIP (0.000s)
[696.254061] Starting dynamic subtest: vebox
[714.213629] Dynamic subtest vebox: SUCCESS (17.988s)
[714.215864] Subtest unwedge-stress: SUCCESS (57.069s)
[715.965537] [068/132] (305s left) kms_color (invalid-gamma-lut-sizes)
[716.062231] Starting subtest: invalid-gamma-lut-sizes
[716.064485] Starting dynamic subtest: pipe-A
[716.352682] Dynamic subtest pipe-A: SUCCESS (0.289s)
[716.362709] Starting dynamic subtest: pipe-B
[716.365189] Dynamic subtest pipe-B: SUCCESS (0.000s)
[716.374237] Starting dynamic subtest: pipe-C
[716.376736] Dynamic subtest pipe-C: SUCCESS (0.000s)
[716.385698] Starting dynamic subtest: pipe-D
[716.387756] Dynamic subtest pipe-D: SUCCESS (0.000s)
[716.389735] Subtest invalid-gamma-lut-sizes: SUCCESS (0.293s)
[717.150775] [069/132] (304s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[717.214383] Starting subtest: x-tiled-to-vebox-yf-tiled
[717.218587] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[717.397411] [070/132] (304s left) gem_exec_schedule (reorder-wide)
[717.580907] Subtest reorder-wide: SKIP (0.000s)
[717.763558] [071/132] (303s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[717.867374] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[717.871720] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[717.961444] [072/132] (303s left) gem_eio (wait-10ms)
[718.106584] Starting subtest: wait-10ms
[718.295276] Subtest wait-10ms: SUCCESS (0.188s)
[718.414851] [073/132] (303s left) gen9_exec_parse (bb-start-cmd)
[718.468279] Subtest bb-start-cmd: SKIP (0.000s)
[718.537679] [074/132] (303s left) kms_cursor_crc (cursor-offscreen-32x32)
[718.727502] Starting subtest: cursor-offscreen-32x32
[718.776664] Subtest cursor-offscreen-32x32: SKIP (0.045s)
[719.059476] [075/132] (302s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[719.159262] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[719.162690] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[719.232335] [076/132] (302s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[719.321332] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[719.435823] [077/132] (302s left) gem_mmap_gtt (basic-short)
[719.486278] Subtest basic-short: SKIP (0.000s)
[719.548819] [078/132] (302s left) kms_psr (pr-cursor-plane-move)
[719.636468] Starting subtest: pr-cursor-plane-move
[719.640159] Subtest pr-cursor-plane-move: SKIP (0.000s)
[719.708420] [079/132] (302s left) kms_chamelium_color (ctm-blue-to-red)
[719.799902] Subtest ctm-blue-to-red: SKIP (0.000s)
[719.845701] [080/132] (302s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[719.929121] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[719.932502] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[720.025885] [081/132] (302s left) prime_vgem (basic-blt)
[720.097475] Starting subtest: basic-blt
[720.124822] Subtest basic-blt: SUCCESS (0.027s)
[720.252475] [082/132] (301s left) gem_exec_schedule (preempt-queue-contexts)
[720.312728] Subtest preempt-queue-contexts: SKIP (0.000s)
[720.622608] [083/132] (301s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[720.714375] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[720.725858] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.010s)
[720.826678] [084/132] (301s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[720.920713] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[720.925090] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[721.006789] [085/132] (301s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[721.059319] Starting subtest: y-tiled-ccs-to-yf-tiled
[721.063839] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[721.244741] [086/132] (301s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[721.337096] Starting subtest: psr-rgb565-draw-mmap-cpu
[728.118192] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.785s)
[728.229584] [087/132] (294s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[728.323602] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[728.328036] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[729.421714] [088/132] (292s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[729.528324] Starting subtest: coverage-vs-premult-vs-constant
[729.826254] Starting dynamic subtest: pipe-A-eDP-1
[730.426757] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.598s)
[730.437610] Starting dynamic subtest: pipe-D-eDP-1
[731.754716] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s)
[731.757095] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.226s)
[732.592121] [089/132] (289s left) gem_mmap_wc (read-write-distinct)
[732.655195] Subtest read-write-distinct: SKIP (0.000s)
[732.730657] [090/132] (289s left) api_intel_bb (blit-noreloc-purge-cache)
[732.793414] Starting subtest: blit-noreloc-purge-cache
[732.801514] Subtest blit-noreloc-purge-cache: SUCCESS (0.011s)
[732.887534] [091/132] (289s left) kms_content_protection (dp-mst-lic-type-1)
[733.020648] Starting subtest: dp-mst-lic-type-1
[733.025304] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[733.155770] [092/132] (289s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[733.255276] Starting subtest: modeset-transition-nonblocking-fencing
[733.257409] Starting dynamic subtest: 1x-outputs
[744.147676] Dynamic subtest 1x-outputs: SUCCESS (10.891s)
[744.150564] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.893s)
[745.015912] [093/132] (277s left) kms_lease (setcrtc-implicit-plane)
[745.117366] Starting subtest: setcrtc-implicit-plane
[745.119671] Starting dynamic subtest: pipe-A-eDP-1
[745.593426] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.473s)
[745.612875] Starting dynamic subtest: pipe-B-eDP-1
[746.758172] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.165s)
[746.769445] Starting dynamic subtest: pipe-C-eDP-1
[747.848755] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.090s)
[747.858944] Starting dynamic subtest: pipe-D-eDP-1
[748.987051] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s)
[748.988980] Subtest setcrtc-implicit-plane: SUCCESS (3.868s)
[749.828156] [094/132] (272s left) api_intel_bb (lot-of-buffers)
[749.895217] Starting subtest: lot-of-buffers
[750.953277] Subtest lot-of-buffers: SUCCESS (1.058s)
[751.431891] [095/132] (271s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[751.538714] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[751.543246] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[751.634531] [096/132] (271s left) kms_psr (fbc-pr-primary-blt)
[751.731276] Starting subtest: fbc-pr-primary-blt
[751.735702] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[751.819218] [097/132] (270s left) gem_close_race (multigpu-basic-threads)
[751.890614] Starting subtest: multigpu-basic-threads
[751.895453] Subtest multigpu-basic-threads: SKIP (0.000s)
[752.124809] [098/132] (270s left) perf_pmu (busy)
[752.165196] Starting subtest: busy
[752.167403] Starting dynamic subtest: rcs0
[752.755845] Dynamic subtest rcs0: SUCCESS (0.590s)
[752.768237] Starting dynamic subtest: bcs0
[753.317784] Dynamic subtest bcs0: SUCCESS (0.559s)
[753.329988] Starting dynamic subtest: vcs0
[754.900070] Dynamic subtest vcs0: SUCCESS (1.579s)
[754.913303] Starting dynamic subtest: vcs1
[756.885921] Dynamic subtest vcs1: SUCCESS (1.983s)
[756.898991] Starting dynamic subtest: vecs0
[758.932622] Dynamic subtest vecs0: SUCCESS (2.044s)
[758.944819] Starting dynamic subtest: ccs0
[759.511778] Dynamic subtest ccs0: SUCCESS (0.578s)
[759.514584] Subtest busy: SUCCESS (7.348s)
[759.616363] [099/132] (263s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[759.742443] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[759.746755] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[759.888467] [100/132] (262s left) kms_cursor_legacy (single-move)
[760.017155] Starting subtest: single-move
[760.019337] Starting dynamic subtest: pipe-A
[765.399968] Dynamic subtest pipe-A: SUCCESS (5.379s)
[765.412484] Starting dynamic subtest: pipe-B
[770.782680] Dynamic subtest pipe-B: SUCCESS (5.380s)
[770.794587] Starting dynamic subtest: pipe-C
[776.164545] Dynamic subtest pipe-C: SUCCESS (5.379s)
[776.176415] Starting dynamic subtest: pipe-D
[781.545893] Dynamic subtest pipe-D: SUCCESS (5.378s)
[781.557642] Starting dynamic subtest: all-pipes
[786.934912] Dynamic subtest all-pipes: SUCCESS (5.386s)
[786.937445] Subtest single-move: SUCCESS (26.916s)
[787.092436] [101/132] (235s left) gem_exec_reloc (basic-wc)
[787.141716] Subtest basic-wc: SKIP (0.000s)
[787.221343] [102/132] (235s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[787.337658] Starting subtest: 2x-long-cursor-vs-flip-atomic
[787.341933] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[787.484430] [103/132] (235s left) gem_exec_whisper (basic-fds-all)
[787.544266] Starting subtest: basic-fds-all
[798.895418] Subtest basic-fds-all: SUCCESS (11.349s)
[799.084978] [104/132] (223s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[799.194032] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[806.819404] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.629s)
[806.944633] [105/132] (216s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[807.044628] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[807.049060] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[807.142537] [106/132] (216s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[807.228076] Starting subtest: fbc-psr2-sprite-mmap-gtt
[807.230226] Starting dynamic subtest: eDP-1
[807.234132] Dynamic subtest eDP-1: SKIP (0.000s)
[807.238148] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[807.302479] [107/132] (215s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[807.388404] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[807.392824] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[807.459633] [108/132] (215s left) kms_draw_crc (draw-method-mmap-gtt)
[807.551401] Starting subtest: draw-method-mmap-gtt
[807.555797] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[807.667883] [109/132] (215s left) gem_exec_reloc (basic-write-read-noreloc)
[807.723909] Subtest basic-write-read-noreloc: SKIP (0.000s)
[807.793037] [110/132] (215s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[807.895417] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[807.897429] Starting dynamic subtest: pipe-A-default-mode
[809.017986] Dynamic subtest pipe-A-default-mode: SKIP (1.118s)
[809.022281] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.120s)
[809.173108] [111/132] (214s left) gem_userptr_blits (process-exit)
[809.248472] Starting subtest: process-exit
[809.250740] Subtest process-exit: SUCCESS (0.007s)
[809.372710] [112/132] (214s left) kms_rotation_crc (primary-rotation-90)
[809.463415] Starting subtest: primary-rotation-90
[809.467871] Subtest primary-rotation-90: SKIP (0.001s)
[809.555229] [113/132] (213s left) gem_ctx_shared (q-smoketest)
[809.620415] Starting subtest: Q-smoketest
[809.622871] Starting dynamic subtest: rcs0
[815.172519] Dynamic subtest rcs0: SUCCESS (5.503s)
[815.183673] Starting dynamic subtest: bcs0
[820.658757] Dynamic subtest bcs0: SUCCESS (5.481s)
[820.670514] Starting dynamic subtest: vcs0
[826.124413] Dynamic subtest vcs0: SUCCESS (5.470s)
[826.135188] Starting dynamic subtest: vcs1
[831.598626] Dynamic subtest vcs1: SUCCESS (5.474s)
[831.609590] Starting dynamic subtest: vecs0
[837.080706] Dynamic subtest vecs0: SUCCESS (5.475s)
[837.093423] Starting dynamic subtest: ccs0
[842.558058] Dynamic subtest ccs0: SUCCESS (5.482s)
[842.560059] Subtest Q-smoketest: SUCCESS (32.891s)
[842.700306] [114/132] (180s left) sysfs_timeslice_duration (timeout)
[842.764301] Starting subtest: timeout
[842.766677] Starting dynamic subtest: vecs0
[851.921044] Dynamic subtest vecs0: SUCCESS (9.153s)
[851.933551] Starting dynamic subtest: ccs0
[853.213062] Dynamic subtest ccs0: SUCCESS (1.292s)
[853.225635] Starting dynamic subtest: vcs0
[862.929498] Dynamic subtest vcs0: SUCCESS (9.713s)
[862.943860] Starting dynamic subtest: bcs0
[863.558833] Dynamic subtest bcs0: SUCCESS (0.627s)
[863.569232] Starting dynamic subtest: rcs0
[864.831713] Dynamic subtest rcs0: SUCCESS (1.271s)
[864.843475] Starting dynamic subtest: vcs1
[873.945775] Dynamic subtest vcs1: SUCCESS (9.112s)
[873.948465] Subtest timeout: SUCCESS (31.179s)
[874.035503] [115/132] (149s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[874.166390] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[905.779799] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.615s)
[906.603363] [116/132] (116s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[906.673468] Starting subtest: etime-single-wait-all-available-unsubmitted
[906.775790] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.103s)
[906.867546] [117/132] (116s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[907.263497] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[908.122815] [118/132] (115s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[908.229982] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[915.746278] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.518s)
[915.883514] [119/132] (107s left) sw_sync (sync_multi_producer_single_consumer)
[915.931443] Starting subtest: sync_multi_producer_single_consumer
[917.006754] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[917.069468] [120/132] (106s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[917.170999] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[917.176489] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[917.266729] [121/132] (106s left) gem_exec_fence (submit3)
[917.441817] Starting subtest: submit3
[917.446376] Subtest submit3: SKIP (0.000s)
[919.017932] [122/132] (104s left) gem_exec_params (invalid-bsd2-flag-on-render)
[919.090175] Starting subtest: invalid-bsd2-flag-on-render
[919.092103] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[919.192718] [123/132] (104s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[919.319352] Starting subtest: flip-vs-cursor-busy-crc-atomic
[920.112925] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.796s)
[920.974716] [124/132] (102s left) kms_joiner (basic-big-joiner)
[921.075352] Starting subtest: basic-big-joiner
[921.079755] Subtest basic-big-joiner: SKIP (0.000s)
[921.148546] [125/132] (102s left) gem_mmap_offset (partial-remap)
[921.201049] Starting subtest: partial-remap
[921.203316] Starting dynamic subtest: smem0
[921.211956] Dynamic subtest smem0: SUCCESS (0.003s)
[921.213812] Subtest partial-remap: SUCCESS (0.004s)
[921.326705] [126/132] (102s left) gem_unfence_active_buffers
[921.494634] [127/132] (102s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[921.555387] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[921.633584] [128/132] (102s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[921.725482] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[922.574192] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.850s)
[922.739464] [129/132] (101s left) gen9_exec_parse (shadow-peek)
[922.804095] Subtest shadow-peek: SKIP (0.000s)
[922.875468] [130/132] (101s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[922.971332] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[922.975637] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[923.061929] [131/132] (101s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[923.162956] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[923.165235] Starting dynamic subtest: pipe-A-default-mode
[924.345231] Dynamic subtest pipe-A-default-mode: SKIP (1.179s)
[924.349661] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.182s)
[924.491122] [132/132] ( 99s left) kms_frontbuffer_tracking (psr-1p-rte)
[924.590623] Starting subtest: psr-1p-rte
[929.981777] Subtest psr-1p-rte: SUCCESS (5.395s)
[930.104924] Closing watchdogs
results: parsing output: 0/ for test: gem_eio
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: kms_flip
results: parsing output: 3/ for test: kms_cursor_edge_walk
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: gem_exec_endless
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_psr2_sf
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_exec_flush
results: parsing output: 12/ for test: gem_flink_race
results: parsing output: 13/ for test: gem_userptr_blits
results: parsing output: 14/ for test: kms_vblank
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: kms_plane_scaling
results: parsing output: 18/ for test: gem_exec_params
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_spin_batch
results: parsing output: 22/ for test: gem_lmem_swapping
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: gem_reg_read
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: gem_exec_await
results: parsing output: 31/ for test: i915_pm_freq_api
results: parsing output: 32/ for test: gem_render_copy_redux
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: gem_exec_params
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: dmabuf_sync_file
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: kms_plane
results: parsing output: 40/ for test: gem_pxp
results: parsing output: 41/ for test: gem_exec_reloc
results: parsing output: 42/ for test: gem_exec_await
results: parsing output: 43/ for test: gem_eio
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: gem_lmem_swapping
results: parsing output: 46/ for test: gem_ctx_persistence
results: parsing output: 47/ for test: gem_exec_reloc
results: parsing output: 48/ for test: i915_pm_rpm
results: parsing output: 49/ for test: syncobj_wait
results: parsing output: 50/ for test: kms_selftest
results: parsing output: 51/ for test: gem_exec_balancer
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: i915_selftest
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: fbdev
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: kms_plane_lowres
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: gem_ctx_exec
results: parsing output: 60/ for test: kms_pm_backlight
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_hdr
results: parsing output: 65/ for test: kms_chamelium_edid
results: parsing output: 66/ for test: gem_eio
results: parsing output: 67/ for test: kms_color
results: parsing output: 68/ for test: gem_render_copy
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_eio
results: parsing output: 72/ for test: gen9_exec_parse
results: parsing output: 73/ for test: kms_cursor_crc
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: kms_addfb_basic
results: parsing output: 76/ for test: gem_mmap_gtt
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: kms_chamelium_color
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: prime_vgem
results: parsing output: 81/ for test: gem_exec_schedule
results: parsing output: 82/ for test: kms_flip
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_render_copy
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: kms_plane_alpha_blend
results: parsing output: 88/ for test: gem_mmap_wc
results: parsing output: 89/ for test: api_intel_bb
results: parsing output: 90/ for test: kms_content_protection
results: parsing output: 91/ for test: kms_atomic_transition
results: parsing output: 92/ for test: kms_lease
results: parsing output: 93/ for test: api_intel_bb
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: gem_close_race
results: parsing output: 97/ for test: perf_pmu
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: gem_exec_reloc
results: parsing output: 101/ for test: kms_cursor_legacy
results: parsing output: 102/ for test: gem_exec_whisper
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: kms_plane
results: parsing output: 107/ for test: kms_draw_crc
results: parsing output: 108/ for test: gem_exec_reloc
results: parsing output: 109/ for test: kms_flip_scaled_crc
results: parsing output: 110/ for test: gem_userptr_blits
results: parsing output: 111/ for test: kms_rotation_crc
results: parsing output: 112/ for test: gem_ctx_shared
results: parsing output: 113/ for test: sysfs_timeslice_duration
results: parsing output: 114/ for test: kms_cursor_legacy
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: kms_chamelium_hpd
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: sw_sync
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_exec_fence
results: parsing output: 121/ for test: gem_exec_params
results: parsing output: 122/ for test: kms_cursor_legacy
results: parsing output: 123/ for test: kms_joiner
results: parsing output: 124/ for test: gem_mmap_offset
results: parsing output: 125/ for test: gem_unfence_active_buffers
results: parsing output: 126/ for test: gem_fenced_exec_thrash
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: gen9_exec_parse
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_flip_scaled_crc
results: parsing output: 131/ for test: kms_frontbuffer_tracking
Done.