[59.784809] Initializing watchdogs
[59.784857]   /dev/watchdog0
[59.799697] [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]
[59.805201] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.807433] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.810602] [001/132] (960s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[60.214327] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[60.998088] [002/132] (959s left) gen7_exec_parse (basic-allocation)
[61.061700] Subtest basic-allocation: SKIP (0.000s)
[61.137600] [003/132] (959s left) kms_debugfs (display-on-read-all)
[61.226992] Starting subtest: display-on-read-all
[61.420324] Subtest display-on-read-all: SUCCESS (0.195s)
[61.541643] [004/132] (958s left) gen9_exec_parse (bb-oversize)
[61.606559] Subtest bb-oversize: SKIP (0.000s)
[61.669630] [005/132] (958s left) gem_exec_schedule (semaphore-resolve)
[61.738479] Starting subtest: semaphore-resolve
[61.770219] Subtest semaphore-resolve: SUCCESS (0.039s)
[62.094155] [006/132] (958s left) kms_addfb_basic (master-rmfb)
[62.151041] Starting subtest: master-rmfb
[62.153389] Subtest master-rmfb: SUCCESS (0.001s)
[62.278746] [007/132] (958s left) gem_exec_fence (basic-busy)
[62.460725] Starting subtest: basic-busy
[62.463256] Starting dynamic subtest: rcs0
[62.530624] Dynamic subtest rcs0: SUCCESS (0.070s)
[62.539921] Starting dynamic subtest: bcs0
[62.584740] Dynamic subtest bcs0: SUCCESS (0.054s)
[62.593302] Starting dynamic subtest: vcs0
[62.642864] Dynamic subtest vcs0: SUCCESS (0.057s)
[62.650600] Starting dynamic subtest: vcs1
[62.699143] Dynamic subtest vcs1: SUCCESS (0.056s)
[62.706826] Starting dynamic subtest: vecs0
[62.754025] Dynamic subtest vecs0: SUCCESS (0.054s)
[62.761378] Starting dynamic subtest: ccs0
[62.811938] Dynamic subtest ccs0: SUCCESS (0.057s)
[62.814330] Subtest basic-busy: SUCCESS (0.354s)
[65.001124] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[65.004206] [008/132] (955s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[65.111170] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[65.115557] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[65.203206] [009/132] (955s left) vgem_basic (setversion)
[65.243814] Starting subtest: setversion
[65.248177] Subtest setversion: SUCCESS (0.000s)
[65.299713] [010/132] (955s left) kms_psr (pr-primary-blt)
[65.395760] Starting subtest: pr-primary-blt
[65.399814] Subtest pr-primary-blt: SKIP (0.000s)
[65.472552] [011/132] (955s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[65.537685] Starting subtest: single-wait-all-for-submit-available-submitted
[65.540089] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[65.642600] [012/132] (955s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[65.699488] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[65.771598] [013/132] (955s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[65.841548] Starting subtest: legacy-engines-hostile-preempt
[65.843987] Starting dynamic subtest: render
[65.924460] Dynamic subtest render: SUCCESS (0.084s)
[65.935490] Starting dynamic subtest: bsd1
[68.010543] Dynamic subtest bsd1: SUCCESS (2.087s)
[68.020902] Starting dynamic subtest: bsd2
[69.883889] Dynamic subtest bsd2: SUCCESS (1.875s)
[69.894063] Starting dynamic subtest: blt
[69.952929] Dynamic subtest blt: SUCCESS (0.069s)
[69.962701] Starting dynamic subtest: vebox
[71.887157] Dynamic subtest vebox: SUCCESS (1.933s)
[71.890486] Subtest legacy-engines-hostile-preempt: SUCCESS (6.056s)
[71.962868] [014/132] (948s left) kms_invalid_mode (zero-clock)
[72.062382] Starting subtest: zero-clock
[72.065241] Starting dynamic subtest: pipe-A-eDP-1
[72.347534] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[72.355513] Starting dynamic subtest: pipe-B-eDP-1
[72.357780] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[72.364879] Starting dynamic subtest: pipe-C-eDP-1
[72.367253] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[72.374902] Starting dynamic subtest: pipe-D-eDP-1
[72.376792] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[72.378680] Subtest zero-clock: SUCCESS (0.291s)
[73.236376] [015/132] (947s left) gem_mmap_offset (oob-read)
[73.306114] Starting subtest: oob-read
[73.308443] Subtest oob-read: SUCCESS (0.000s)
[73.413991] [016/132] (947s left) api_intel_allocator (execbuf-with-allocator)
[73.474679] Starting subtest: execbuf-with-allocator
[73.478791] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[73.594316] [017/132] (947s left) sysfs_timeslice_duration (invalid)
[73.657630] Starting subtest: invalid
[73.659967] Starting dynamic subtest: vecs0
[73.662384] Dynamic subtest vecs0: SUCCESS (0.000s)
[73.671065] Starting dynamic subtest: ccs0
[73.673167] Dynamic subtest ccs0: SUCCESS (0.000s)
[73.680455] Starting dynamic subtest: vcs0
[73.682611] Dynamic subtest vcs0: SUCCESS (0.000s)
[73.689984] Starting dynamic subtest: bcs0
[73.691902] Dynamic subtest bcs0: SUCCESS (0.000s)
[73.699206] Starting dynamic subtest: rcs0
[73.701064] Dynamic subtest rcs0: SUCCESS (0.000s)
[73.711975] Starting dynamic subtest: vcs1
[73.714176] Dynamic subtest vcs1: SUCCESS (0.000s)
[73.716335] Subtest invalid: SUCCESS (0.003s)
[73.764627] [018/132] (947s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[73.861440] Starting subtest: fbc-pr-cursor-plane-update-sf
[73.865652] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[73.926868] [019/132] (947s left) gem_exec_fence (submit-chain)
[74.099484] Starting subtest: submit-chain
[74.119899] Subtest submit-chain: SUCCESS (0.021s)
[76.022788] [020/132] (945s left) gem_flink_race (flink_name)
[76.067424] Starting subtest: flink_name
[81.483615] Subtest flink_name: SUCCESS (5.401s)
[81.580594] [021/132] (939s left) kms_flip (wf_vblank-ts-check-interruptible)
[81.677984] Starting subtest: wf_vblank-ts-check-interruptible
[81.680676] Starting dynamic subtest: A-eDP1
[90.548872] Dynamic subtest A-eDP1: SUCCESS (8.868s)
[90.559564] Starting dynamic subtest: B-eDP1
[99.474605] Dynamic subtest B-eDP1: SUCCESS (8.922s)
[99.485536] Starting dynamic subtest: C-eDP1
[108.400281] Dynamic subtest C-eDP1: SUCCESS (8.924s)
[108.410447] Starting dynamic subtest: D-eDP1
[117.335578] Dynamic subtest D-eDP1: SUCCESS (8.934s)
[117.338153] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.656s)
[118.568487] [022/132] (902s left) perf_pmu (semaphore-busy)
[118.613708] Starting subtest: semaphore-busy
[118.615711] Starting dynamic subtest: rcs0
[120.227060] Dynamic subtest rcs0: SUCCESS (1.610s)
[120.238277] Starting dynamic subtest: bcs0
[121.858792] Dynamic subtest bcs0: SUCCESS (1.629s)
[121.869951] Starting dynamic subtest: vcs0
[126.415598] Dynamic subtest vcs0: SUCCESS (4.556s)
[126.424763] Starting dynamic subtest: vcs1
[132.431175] Dynamic subtest vcs1: SUCCESS (6.014s)
[132.439966] Starting dynamic subtest: vecs0
[138.383795] Dynamic subtest vecs0: SUCCESS (5.951s)
[138.393296] Starting dynamic subtest: ccs0
[141.521730] Dynamic subtest ccs0: SUCCESS (3.136s)
[141.524053] Subtest semaphore-busy: SUCCESS (22.905s)
[141.635644] [023/132] (879s left) syncobj_eventfd (binary-wait-before-signal)
[141.691832] Starting subtest: binary-wait-before-signal
[141.722737] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[141.801350] [024/132] (879s left) gem_create (create-ext-placement-each)
[141.958335] Starting subtest: create-ext-placement-each
[141.961029] Subtest create-ext-placement-each: SUCCESS (0.000s)
[142.060346] [025/132] (879s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[142.108406] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[142.113332] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[142.292310] [026/132] (879s left) gem_tiled_swapping (non-threaded)
[142.344130] Subtest non-threaded: SKIP (0.000s)
[142.399199] [027/132] (879s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[142.496228] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[142.500641] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[142.596346] [028/132] (878s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[142.702679] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[142.715739] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[142.823465] [029/132] (878s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[142.926598] Starting subtest: fbc-psr-sprite-mmap-gtt
[142.928809] Starting dynamic subtest: eDP-1
[142.933100] Dynamic subtest eDP-1: SKIP (0.000s)
[142.937214] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s)
[142.997485] [030/132] (878s left) gem_bad_reloc (negative-reloc-bltcopy)
[143.060680] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[143.135593] [031/132] (878s left) gem_ctx_isolation (preservation)
[143.188387] Starting subtest: preservation
[143.190773] Starting dynamic subtest: rcs0
[143.325779] Dynamic subtest rcs0: SUCCESS (0.137s)
[143.335024] Starting dynamic subtest: bcs0
[143.477815] Dynamic subtest bcs0: SUCCESS (0.153s)
[143.487904] Starting dynamic subtest: vcs0
[143.618557] Dynamic subtest vcs0: SUCCESS (0.141s)
[143.627188] Starting dynamic subtest: vcs1
[145.032716] Dynamic subtest vcs1: SUCCESS (1.412s)
[145.043704] Starting dynamic subtest: vecs0
[147.016587] Dynamic subtest vecs0: SUCCESS (1.983s)
[147.027723] Starting dynamic subtest: ccs0
[149.077481] Dynamic subtest ccs0: SUCCESS (2.060s)
[149.080076] Subtest preservation: SUCCESS (5.888s)
[149.312600] [032/132] (872s left) kms_plane (planar-pixel-format-settings)
[149.405985] Starting subtest: planar-pixel-format-settings
[149.476164] Subtest planar-pixel-format-settings: SUCCESS (0.071s)
[149.589453] [033/132] (872s left) kms_pm_rpm (dpms-non-lpsp)
[151.116583] Starting subtest: dpms-non-lpsp
[151.121531] Subtest dpms-non-lpsp: SKIP (0.001s)
[151.817245] [034/132] (869s left) kms_psr (psr2-cursor-plane-move)
[151.906248] Starting subtest: psr2-cursor-plane-move
[151.908565] Starting dynamic subtest: eDP-1
[153.571052] Dynamic subtest eDP-1: SUCCESS (1.666s)
[153.573624] Subtest psr2-cursor-plane-move: SUCCESS (1.667s)
[154.363617] [035/132] (867s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[154.458715] Starting subtest: x-tiled-8bpp-rotate-90
[154.479734] Subtest x-tiled-8bpp-rotate-90: SKIP (0.020s)
[154.571527] [036/132] (867s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[154.688941] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[161.272886] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.589s)
[161.387090] [037/132] (860s left) kms_addfb_basic (addfb25-bad-modifier)
[161.479821] Starting subtest: addfb25-bad-modifier
[161.481785] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[161.563758] [038/132] (860s left) kms_psr (fbc-pr-cursor-render)
[161.656562] Starting subtest: fbc-pr-cursor-render
[161.660839] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[161.731296] [039/132] (860s left) i915_pm_rps (thresholds-idle-park)
[161.790609] Starting subtest: thresholds-idle-park
[161.794649] Subtest thresholds-idle-park: SKIP (0.001s)
[161.888575] [040/132] (860s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[161.992768] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[161.994961] Starting dynamic subtest: pipe-A-eDP-1
[162.017236] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[162.026863] Starting dynamic subtest: pipe-B-eDP-1
[162.048247] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[162.056625] Starting dynamic subtest: pipe-C-eDP-1
[162.077691] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[162.085489] Starting dynamic subtest: pipe-D-eDP-1
[162.107235] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[162.111225] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[164.247116] [041/132] (857s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[164.346142] Starting subtest: x-tiled-addfb-size-offset-overflow
[164.348450] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[164.453193] [042/132] (857s left) gem_mmap_gtt (medium-copy-xy)
[164.518166] Subtest medium-copy-XY: SKIP (0.000s)
[164.577122] [043/132] (857s left) syncobj_basic (bad-create-flags)
[164.626327] Starting subtest: bad-create-flags
[164.628662] Subtest bad-create-flags: SUCCESS (0.000s)
[164.733187] [044/132] (857s left) perf_pmu (enable-race)
[164.778620] Starting subtest: enable-race
[164.780984] Starting dynamic subtest: rcs0
[177.552324] Dynamic subtest rcs0: SUCCESS (12.775s)
[177.563071] Starting dynamic subtest: bcs0
[190.292601] Dynamic subtest bcs0: SUCCESS (12.739s)
[190.303374] Starting dynamic subtest: vcs0
[205.844536] Dynamic subtest vcs0: SUCCESS (15.550s)
[205.856050] Starting dynamic subtest: vcs1
[221.908664] Dynamic subtest vcs1: SUCCESS (16.062s)
[221.920625] Starting dynamic subtest: vecs0
[237.909482] Dynamic subtest vecs0: SUCCESS (15.999s)
[237.920825] Starting dynamic subtest: ccs0
[250.652032] Dynamic subtest ccs0: SUCCESS (12.743s)
[250.654374] Subtest enable-race: SUCCESS (85.874s)
[250.773799] [045/132] (771s left) kms_busy (extended-pageflip-hang-oldfb)
[250.866359] Starting subtest: extended-pageflip-hang-oldfb
[250.868714] Starting dynamic subtest: pipe-A
[251.282760] Dynamic subtest pipe-A: SUCCESS (0.414s)
[251.293720] Starting dynamic subtest: pipe-D
[252.365452] Dynamic subtest pipe-D: SUCCESS (1.080s)
[252.367812] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.498s)
[253.205286] [046/132] (768s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[253.303629] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[253.306319] Starting dynamic subtest: pipe-A-eDP-1
[269.441332] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.527s)
[269.454815] Starting dynamic subtest: pipe-B-eDP-1
[286.425067] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.472s)
[286.436970] Starting dynamic subtest: pipe-C-eDP-1
[303.402163] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.453s)
[303.411924] Starting dynamic subtest: pipe-D-eDP-1
[320.380886] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.366s)
[320.383177] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.822s)
[321.512863] [047/132] (700s left) kms_atomic_transition (modeset-transition-fencing)
[321.609139] Starting subtest: modeset-transition-fencing
[321.610996] Starting dynamic subtest: 1x-outputs
[332.319946] Dynamic subtest 1x-outputs: SUCCESS (10.867s)
[332.322430] Subtest modeset-transition-fencing: SUCCESS (10.869s)
[333.180277] [048/132] (689s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[333.269386] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[333.271543] Starting dynamic subtest: pipe-A-default-mode
[334.437960] Dynamic subtest pipe-A-default-mode: SKIP (1.171s)
[334.442175] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.173s)
[334.579445] [049/132] (687s left) kms_big_fb (linear-32bpp-rotate-0)
[334.681527] Starting subtest: linear-32bpp-rotate-0
[336.165932] Subtest linear-32bpp-rotate-0: SUCCESS (1.491s)
[336.289679] [050/132] (686s left) gem_render_copy_redux (flink)
[336.348619] Starting subtest: flink
[337.086286] Subtest flink: SUCCESS (0.743s)
[337.230920] [051/132] (685s left) api_intel_bb (object-reloc-keep-cache)
[337.282913] Starting subtest: object-reloc-keep-cache
[337.286565] Subtest object-reloc-keep-cache: SKIP (0.002s)
[337.404051] [052/132] (685s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[337.498836] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[337.502090] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[337.573809] [053/132] (684s left) gem_exec_whisper (basic-queues-priority)
[337.643055] Starting subtest: basic-queues-priority
[360.734933] Subtest basic-queues-priority: SUCCESS (23.107s)
[360.924956] [054/132] (661s left) syncobj_wait (reset-multiple-signaled)
[360.984967] Starting subtest: reset-multiple-signaled
[360.987507] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[361.094130] [055/132] (661s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[361.207637] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[365.622394] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.416s)
[366.792561] [056/132] (655s left) gem_caching (reads)
[366.856346] Subtest reads: SKIP (0.000s)
[366.925343] [057/132] (655s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[367.030449] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[367.034793] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[367.113195] [058/132] (655s left) fbdev (pan)
[367.150168] Starting subtest: pan
[367.173390] Subtest pan: SUCCESS (0.027s)
[367.242664] [059/132] (655s left) gem_exec_balancer (bonded-chain)
[367.315121] Starting subtest: bonded-chain
[374.337965] Subtest bonded-chain: SUCCESS (7.020s)
[374.659891] [060/132] (648s left) gem_pxp (verify-pxp-stale-buf-execution)
[374.797821] Starting subtest: verify-pxp-stale-buf-execution
[375.864846] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.068s)
[375.994510] [061/132] (646s left) kms_cursor_edge_walk (256x256-left-edge)
[376.087117] Starting subtest: 256x256-left-edge
[376.089414] Starting dynamic subtest: pipe-A-eDP-1
[379.538934] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.452s)
[379.550241] Starting dynamic subtest: pipe-D-eDP-1
[382.675242] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.135s)
[382.677590] Subtest 256x256-left-edge: SUCCESS (6.590s)
[383.521351] [062/132] (639s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[383.630766] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[383.635410] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[383.752129] [063/132] (639s left) kms_plane_lowres (tiling-y)
[383.839102] Starting subtest: tiling-y
[383.843145] Subtest tiling-y: SKIP (0.000s)
[383.912485] [064/132] (639s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[383.963843] Starting subtest: etime-multi-wait-available-unsubmitted
[384.070539] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.106s)
[384.148489] [065/132] (638s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[384.203109] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[384.260542] [066/132] (638s left) kms_big_fb (yf-tiled-addfb)
[384.349883] Starting subtest: yf-tiled-addfb
[384.354167] Subtest yf-tiled-addfb: SKIP (0.000s)
[384.432526] [067/132] (638s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[384.532552] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[384.536713] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[384.638079] [068/132] (638s left) perf (blocking-parameterized)
[384.767281] Starting subtest: blocking-parameterized
[404.788428] Subtest blocking-parameterized: SUCCESS (20.025s)
[404.837306] [069/132] (618s left) kms_lease (empty-lease)
[404.921999] Starting subtest: empty-lease
[404.924401] Starting dynamic subtest: pipe-A-eDP-1
[404.926647] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[404.937467] Starting dynamic subtest: pipe-B-eDP-1
[404.939821] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[404.948570] Starting dynamic subtest: pipe-C-eDP-1
[404.950496] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[404.959266] Starting dynamic subtest: pipe-D-eDP-1
[404.961166] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[404.963210] Subtest empty-lease: SUCCESS (0.014s)
[405.055676] [070/132] (618s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[405.152980] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[405.155292] Starting dynamic subtest: pipe-A-eDP-1
[405.177586] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[405.189221] Starting dynamic subtest: pipe-B-eDP-1
[405.211207] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[405.220459] Starting dynamic subtest: pipe-C-eDP-1
[405.242172] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[405.251078] Starting dynamic subtest: pipe-D-eDP-1
[405.273000] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[405.277112] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s)
[407.431836] [071/132] (615s left) kms_cdclk (mode-transition)
[407.526105] Starting subtest: mode-transition
[407.528396] Starting dynamic subtest: pipe-A-eDP-1
[407.814620] Dynamic subtest pipe-A-eDP-1: SKIP (0.288s)
[407.825531] Starting dynamic subtest: pipe-B-eDP-1
[407.830325] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[407.841655] Starting dynamic subtest: pipe-C-eDP-1
[407.846091] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[407.855329] Starting dynamic subtest: pipe-D-eDP-1
[407.859247] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[407.863165] Subtest mode-transition: SKIP (0.295s)
[408.677413] [072/132] (614s left) i915_pm_rps (basic-api)
[408.743844] Starting subtest: basic-api
[408.748626] Subtest basic-api: SKIP (0.000s)
[408.842314] [073/132] (614s left) kms_plane_scaling (planes-upscale-factor-0-25)
[408.937639] Starting subtest: planes-upscale-factor-0-25
[408.939948] Starting dynamic subtest: pipe-A
[408.998074] Dynamic subtest pipe-A: SUCCESS (0.062s)
[409.008320] Starting dynamic subtest: pipe-B
[410.182846] Dynamic subtest pipe-B: SUCCESS (1.184s)
[410.194730] Starting dynamic subtest: pipe-C
[411.305972] Dynamic subtest pipe-C: SUCCESS (1.122s)
[411.315302] Starting dynamic subtest: pipe-D
[412.427467] Dynamic subtest pipe-D: SUCCESS (1.121s)
[412.429789] Subtest planes-upscale-factor-0-25: SUCCESS (3.493s)
[413.581337] [074/132] (609s left) kms_setmode (basic-clone-single-crtc)
[413.644748] Starting subtest: basic-clone-single-crtc
[413.651104] Subtest basic-clone-single-crtc: SKIP (0.000s)
[413.739478] [075/132] (609s left) gem_exec_capture (userptr)
[413.797723] Starting subtest: userptr
[414.631089] Subtest userptr: SUCCESS (0.833s)
[414.752497] [076/132] (608s left) gem_exec_reloc (basic-cpu-gtt)
[414.812668] Subtest basic-cpu-gtt: SKIP (0.000s)
[414.893407] [077/132] (608s left) gem_exec_whisper (basic-normal)
[414.957722] Starting subtest: basic-normal
[419.384841] Subtest basic-normal: SUCCESS (4.423s)
[419.569415] [078/132] (603s left) kms_vblank (wait-busy-hang)
[419.688074] Starting subtest: wait-busy-hang
[419.690242] Starting dynamic subtest: pipe-A-eDP-1
[446.115626] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.419s)
[446.130810] Starting dynamic subtest: pipe-D-eDP-1
[471.145083] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.028s)
[471.147226] Subtest wait-busy-hang: SUCCESS (51.452s)
[471.947882] [079/132] (551s left) perf (non-sampling-read-error)
[472.043138] Starting subtest: non-sampling-read-error
[472.055555] Subtest non-sampling-read-error: SUCCESS (0.012s)
[472.101618] [080/132] (551s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[472.209813] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[479.290113] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.086s)
[479.421453] [081/132] (544s left) prime_self_import (basic-with_fd_dup)
[479.458076] Starting subtest: basic-with_fd_dup
[479.480560] Subtest basic-with_fd_dup: SUCCESS (0.025s)
[479.597891] [082/132] (544s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[479.696202] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[479.700560] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[479.825477] [083/132] (543s left) kms_atomic_transition (plane-all-modeset-transition)
[479.929777] Starting subtest: plane-all-modeset-transition
[479.934276] Subtest plane-all-modeset-transition: SKIP (0.000s)
[480.019033] [084/132] (543s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[480.116488] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[480.128414] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[480.208852] [085/132] (543s left) syncobj_wait (invalid-wait-bad-flags)
[480.261226] Starting subtest: invalid-wait-bad-flags
[480.263071] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[480.356945] [086/132] (543s left) gem_set_tiling_vs_gtt
[480.484220] [087/132] (543s left) i915_drm_fdinfo (most-busy-check-all)
[480.526085] Starting subtest: most-busy-check-all
[480.528275] Starting dynamic subtest: rcs0
[480.532328] Dynamic subtest rcs0: SKIP (0.004s)
[480.547964] Starting dynamic subtest: bcs0
[480.551649] Dynamic subtest bcs0: SKIP (0.000s)
[480.560881] Starting dynamic subtest: vcs0
[480.564523] Dynamic subtest vcs0: SKIP (0.000s)
[480.574504] Starting dynamic subtest: vcs1
[480.578122] Dynamic subtest vcs1: SKIP (0.000s)
[480.586949] Starting dynamic subtest: vecs0
[480.590643] Dynamic subtest vecs0: SKIP (0.000s)
[480.599761] Starting dynamic subtest: ccs0
[480.603446] Dynamic subtest ccs0: SKIP (0.000s)
[480.607047] Subtest most-busy-check-all: SKIP (0.009s)
[480.643743] [088/132] (543s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[480.741956] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[480.752906] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s)
[480.832784] [089/132] (543s left) i915_fb_tiling (basic-x-tiling)
[480.909001] Subtest basic-x-tiling: SKIP (0.000s)
[480.967483] [090/132] (543s left) kms_content_protection (legacy-hdcp14)
[481.100610] Starting subtest: legacy-hdcp14
[481.104488] Subtest legacy-hdcp14: SKIP (0.000s)
[481.216404] [091/132] (542s left) kms_scaling_modes (scaling-mode-center)
[481.322318] Starting subtest: scaling-mode-center
[481.324263] Starting dynamic subtest: pipe-A-eDP-1
[481.427314] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.105s)
[481.439323] Starting dynamic subtest: pipe-B-eDP-1
[482.583151] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.153s)
[482.595544] Starting dynamic subtest: pipe-C-eDP-1
[483.722398] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.135s)
[483.732887] Starting dynamic subtest: pipe-D-eDP-1
[484.845243] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.121s)
[484.847517] Subtest scaling-mode-center: SUCCESS (3.525s)
[486.012612] [092/132] (538s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[486.110399] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[486.136227] Starting dynamic subtest: pipe-A-plane-0
[486.424836] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[486.437362] Starting dynamic subtest: pipe-A-plane-3
[486.658261] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[486.670157] Starting dynamic subtest: pipe-A-plane-5
[486.674723] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[487.791981] Starting dynamic subtest: pipe-B-plane-0
[488.083728] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[488.096098] Starting dynamic subtest: pipe-B-plane-3
[488.317188] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[488.327245] Starting dynamic subtest: pipe-B-plane-5
[488.331571] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[488.634327] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.526s)
[489.469786] [093/132] (534s left) gem_exec_await (wide-contexts)
[489.701824] Starting subtest: wide-contexts
[513.340071] Subtest wide-contexts: SUCCESS (23.640s)
[513.538526] [094/132] (510s left) gem_exec_schedule (implicit-read-write)
[513.659040] Starting subtest: implicit-read-write
[513.661452] Starting dynamic subtest: rcs0
[513.831599] Dynamic subtest rcs0: SUCCESS (0.180s)
[513.843271] Starting dynamic subtest: vcs0
[513.934825] Dynamic subtest vcs0: SUCCESS (0.104s)
[513.950905] Starting dynamic subtest: vcs1
[514.067547] Dynamic subtest vcs1: SUCCESS (0.131s)
[514.080484] Starting dynamic subtest: vecs0
[514.167745] Dynamic subtest vecs0: SUCCESS (0.099s)
[514.180394] Starting dynamic subtest: ccs0
[514.289513] Dynamic subtest ccs0: SUCCESS (0.121s)
[514.292052] Subtest implicit-read-write: SUCCESS (0.639s)
[515.465434] [095/132] (508s left) kms_addfb_basic (unused-pitches)
[515.533321] Starting subtest: unused-pitches
[515.535275] Subtest unused-pitches: SUCCESS (0.000s)
[515.676923] [096/132] (508s left) sw_sync (sync_busy)
[515.711125] Starting subtest: sync_busy
[515.713335] Subtest sync_busy: SUCCESS (0.002s)
[515.782703] [097/132] (508s left) gem_ctx_shared (q-independent)
[515.844395] Starting subtest: Q-independent
[515.846240] Starting dynamic subtest: rcs0
[515.915298] Dynamic subtest rcs0: SUCCESS (0.073s)
[515.925448] Starting dynamic subtest: vcs0
[515.957000] Dynamic subtest vcs0: SUCCESS (0.041s)
[515.968392] Starting dynamic subtest: vcs1
[515.994862] Dynamic subtest vcs1: SUCCESS (0.037s)
[516.005526] Starting dynamic subtest: vecs0
[516.032592] Dynamic subtest vecs0: SUCCESS (0.037s)
[516.043252] Starting dynamic subtest: ccs0
[516.080310] Dynamic subtest ccs0: SUCCESS (0.047s)
[516.082460] Subtest Q-independent: SUCCESS (0.239s)
[517.437112] [098/132] (507s left) drm_read (short-buffer-wakeup)
[517.611901] Starting subtest: short-buffer-wakeup
[549.821649] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[549.958255] [099/132] (474s left) kms_cursor_crc (cursor-onscreen-32x32)
[550.113606] Starting subtest: cursor-onscreen-32x32
[550.161987] Subtest cursor-onscreen-32x32: SKIP (0.044s)
[550.432505] [100/132] (474s left) gem_render_copy (linear)
[550.490722] Starting subtest: linear
[550.492953] Starting dynamic subtest: smem
[550.533522] Dynamic subtest smem: SUCCESS (0.042s)
[550.535957] Subtest linear: SUCCESS (0.043s)
[550.755978] [101/132] (473s left) gem_mmap (pf-nonblock)
[550.811662] Subtest pf-nonblock: SKIP (0.000s)
[550.877007] [102/132] (473s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[550.969280] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[550.973463] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[551.072591] [103/132] (473s left) kms_getfb (getfb2-handle-not-fb)
[551.161121] Starting subtest: getfb2-handle-not-fb
[551.163381] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[551.301919] [104/132] (473s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[551.385138] Starting subtest: stress-xrgb8888-4tiled
[557.386249] Subtest stress-xrgb8888-4tiled: SUCCESS (6.000s)
[557.452995] [105/132] (467s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[557.543571] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[557.545503] Starting dynamic subtest: pipe-A-eDP-1
[557.593543] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[557.604098] Starting dynamic subtest: pipe-B-eDP-1
[557.650393] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[557.660707] Starting dynamic subtest: pipe-C-eDP-1
[557.705675] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[557.714705] Starting dynamic subtest: pipe-D-eDP-1
[557.760396] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[557.763709] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.010s)
[559.820607] [106/132] (465s left) gem_userptr_blits (invalid-null-pointer)
[559.876833] Starting subtest: invalid-null-pointer
[559.879173] Subtest invalid-null-pointer: SUCCESS (0.001s)
[560.021429] [107/132] (464s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[560.129855] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[567.500957] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.373s)
[567.626865] [108/132] (457s left) syncobj_timeline (multi-wait-submitted-signaled)
[567.679663] Starting subtest: multi-wait-submitted-signaled
[567.681935] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[567.795228] [109/132] (457s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[567.904213] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[567.908247] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[568.015367] [110/132] (457s left) gem_exec_fence (syncobj-timeline-signal)
[568.585532] Starting subtest: syncobj-timeline-signal
[568.593086] Subtest syncobj-timeline-signal: SUCCESS (0.009s)
[570.448158] [111/132] (454s left) kms_psr (fbc-pr-sprite-plane-onoff)
[570.544125] Starting subtest: fbc-pr-sprite-plane-onoff
[570.548881] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[570.617933] [112/132] (454s left) kms_feature_discovery (display-1x)
[570.716000] Starting subtest: display-1x
[570.718093] Subtest display-1x: SUCCESS (0.000s)
[570.795120] [113/132] (454s left) perf (rc6-disable)
[570.913742] Starting subtest: rc6-disable
[571.104865] Subtest rc6-disable: SUCCESS (0.191s)
[571.165259] [114/132] (454s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[571.219164] Starting subtest: invalid-bsd1-flag-on-blt
[571.221437] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[571.319505] [115/132] (453s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[571.407765] Starting subtest: psr-rgb565-draw-mmap-wc
[578.218725] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.812s)
[578.348254] [116/132] (446s left) kms_selftest (drm_format)
[578.392786] Starting subtest: drm_format
[578.402185] Starting dynamic subtest: drm_test_format_block_width_invalid
[578.510546] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.106s)
[578.525197] Starting dynamic subtest: drm_test_format_block_width_one_plane
[578.607754] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.096s)
[578.619717] Starting dynamic subtest: drm_test_format_block_width_two_plane
[578.716260] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.107s)
[578.727049] Starting dynamic subtest: drm_test_format_block_width_three_plane
[578.793052] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.075s)
[578.804667] Starting dynamic subtest: drm_test_format_block_width_tiled
[578.901118] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.109s)
[578.912632] Starting dynamic subtest: drm_test_format_block_height_invalid
[578.990840] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.089s)
[579.000937] Starting dynamic subtest: drm_test_format_block_height_one_plane
[579.087413] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.093s)
[579.099598] Starting dynamic subtest: drm_test_format_block_height_two_plane
[579.180076] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.093s)
[579.191305] Starting dynamic subtest: drm_test_format_block_height_three_plane
[579.273010] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.092s)
[579.284086] Starting dynamic subtest: drm_test_format_block_height_tiled
[579.373068] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.099s)
[579.384203] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[579.482096] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.108s)
[579.493386] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[579.582741] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.100s)
[579.593569] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[579.700059] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.115s)
[579.711587] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[579.823087] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.123s)
[579.832658] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[579.926263] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.103s)
[579.936371] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[580.016266] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.090s)
[580.025710] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[580.127211] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.110s)
[580.138925] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[580.209552] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.082s)
[580.211823] Subtest drm_format: SUCCESS (1.816s)
[580.359439] [117/132] (444s left) kms_cursor_crc (cursor-random-256x256)
[580.606309] Starting subtest: cursor-random-256x256
[580.611844] Starting dynamic subtest: pipe-A-eDP-1
[584.032321] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.420s)
[584.066616] Starting dynamic subtest: pipe-D-eDP-1
[588.094182] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.038s)
[588.096142] Subtest cursor-random-256x256: SUCCESS (7.484s)
[588.941319] [118/132] (436s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[589.029262] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[595.969392] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.943s)
[596.095440] [119/132] (429s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[596.208392] Starting subtest: 4-tiled-16bpp-rotate-90
[596.229854] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.021s)
[596.341456] [120/132] (429s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[596.395581] Starting subtest: multi-wait-all-for-submit-available-signaled
[596.397827] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[596.496734] [121/132] (429s left) kms_color (deep-color)
[596.590657] Starting subtest: deep-color
[597.666165] Starting dynamic subtest: pipe-A-eDP-1-gamma
[598.385406] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.721s)
[598.395162] Starting dynamic subtest: pipe-A-eDP-1-degamma
[599.863780] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.475s)
[599.874311] Starting dynamic subtest: pipe-A-eDP-1-ctm
[601.299078] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.434s)
[602.064961] Starting dynamic subtest: pipe-B-eDP-1-gamma
[602.768312] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.719s)
[602.778837] Starting dynamic subtest: pipe-B-eDP-1-degamma
[604.252674] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.483s)
[604.263823] Starting dynamic subtest: pipe-B-eDP-1-ctm
[605.688766] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.433s)
[606.454327] Starting dynamic subtest: pipe-C-eDP-1-gamma
[607.157968] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.711s)
[607.170691] Starting dynamic subtest: pipe-C-eDP-1-degamma
[608.522313] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.363s)
[608.533061] Starting dynamic subtest: pipe-C-eDP-1-ctm
[609.962885] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.440s)
[610.756885] Starting dynamic subtest: pipe-D-eDP-1-gamma
[611.483339] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.733s)
[611.493720] Starting dynamic subtest: pipe-D-eDP-1-degamma
[612.979532] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.495s)
[612.994102] Starting dynamic subtest: pipe-D-eDP-1-ctm
[614.383790] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.403s)
[614.385734] Subtest deep-color: SUCCESS (17.792s)
[615.222841] [122/132] (410s left) syncobj_wait (wait-all-delayed-signal)
[615.290760] Starting subtest: wait-all-delayed-signal
[615.393701] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[615.474707] [123/132] (410s left) perf (blocking)
[615.582156] Starting subtest: blocking
[615.584567] Starting dynamic subtest: 0-rcs0
[625.605366] Dynamic subtest 0-rcs0: SUCCESS (10.021s)
[625.616293] Starting dynamic subtest: 1-vcs1
[635.626608] Dynamic subtest 1-vcs1: SUCCESS (10.019s)
[635.629293] Subtest blocking: SUCCESS (20.043s)
[635.678333] [124/132] (389s left) gem_spin_batch (resubmit-new)
[635.742837] Starting subtest: resubmit-new
[635.745258] Starting dynamic subtest: rcs0
[635.750901] Dynamic subtest rcs0: SUCCESS (0.008s)
[635.762338] Starting dynamic subtest: bcs0
[635.764649] Dynamic subtest bcs0: SUCCESS (0.005s)
[635.774648] Starting dynamic subtest: vcs0
[635.776594] Dynamic subtest vcs0: SUCCESS (0.005s)
[635.786605] Starting dynamic subtest: vcs1
[635.788838] Dynamic subtest vcs1: SUCCESS (0.004s)
[635.798638] Starting dynamic subtest: vecs0
[635.800854] Dynamic subtest vecs0: SUCCESS (0.004s)
[635.810689] Starting dynamic subtest: ccs0
[635.812982] Dynamic subtest ccs0: SUCCESS (0.004s)
[635.815228] Subtest resubmit-new: SUCCESS (0.035s)
[637.414649] [125/132] (388s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[637.519263] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[637.521611] Starting dynamic subtest: A-eDP1
[641.147453] Dynamic subtest A-eDP1: SUCCESS (3.629s)
[641.157818] Starting dynamic subtest: B-eDP1
[644.351759] Dynamic subtest B-eDP1: SUCCESS (3.203s)
[644.362206] Starting dynamic subtest: C-eDP1
[647.454971] Dynamic subtest C-eDP1: SUCCESS (3.100s)
[647.465985] Starting dynamic subtest: D-eDP1
[650.557258] Dynamic subtest D-eDP1: SUCCESS (3.102s)
[650.559590] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.042s)
[651.358951] [126/132] (374s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[651.464532] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[651.468858] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[651.556644] [127/132] (374s left) perf (oa-exponents)
[651.654430] Starting subtest: oa-exponents
[651.656710] Starting dynamic subtest: 0-rcs0
[653.408659] Dynamic subtest 0-rcs0: SUCCESS (1.752s)
[653.419366] Starting dynamic subtest: 1-vcs0
[655.241425] Dynamic subtest 1-vcs0: SUCCESS (1.832s)
[655.243695] Subtest oa-exponents: SUCCESS (3.586s)
[655.293413] [128/132] (370s left) gem_mmap_gtt (medium-copy)
[655.360341] Subtest medium-copy: SKIP (0.000s)
[655.426391] [129/132] (370s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[655.523962] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[655.528267] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[655.631412] [130/132] (370s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[655.745189] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[655.749807] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[655.834441] [131/132] (370s left) kms_chamelium_frames (hdmi-crc-single)
[656.212699] Subtest hdmi-crc-single: SKIP (0.000s)
[657.064703] [132/132] (368s left) gem_mmap_gtt (fault-concurrent-x)
[657.116125] Subtest fault-concurrent-X: SKIP (0.000s)
[657.182593] Closing watchdogs
results: parsing output: 0/ for test: kms_chamelium_hpd
results: parsing output: 1/ for test: gen7_exec_parse
results: parsing output: 2/ for test: kms_debugfs
results: parsing output: 3/ for test: gen9_exec_parse
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: kms_addfb_basic
results: parsing output: 6/ for test: gem_exec_fence
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: vgem_basic
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: gem_exec_reloc
results: parsing output: 12/ for test: gem_ctx_persistence
results: parsing output: 13/ for test: kms_invalid_mode
results: parsing output: 14/ for test: gem_mmap_offset
results: parsing output: 15/ for test: api_intel_allocator
results: parsing output: 16/ for test: sysfs_timeslice_duration
results: parsing output: 17/ for test: kms_psr2_sf
results: parsing output: 18/ for test: gem_exec_fence
results: parsing output: 19/ for test: gem_flink_race
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: perf_pmu
results: parsing output: 22/ for test: syncobj_eventfd
results: parsing output: 23/ for test: gem_create
results: parsing output: 24/ for test: gem_render_copy
results: parsing output: 25/ for test: gem_tiled_swapping
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: gem_bad_reloc
results: parsing output: 30/ for test: gem_ctx_isolation
results: parsing output: 31/ for test: kms_plane
results: parsing output: 32/ for test: kms_pm_rpm
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_addfb_basic
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: i915_pm_rps
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: gem_mmap_gtt
results: parsing output: 42/ for test: syncobj_basic
results: parsing output: 43/ for test: perf_pmu
results: parsing output: 44/ for test: kms_busy
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: kms_atomic_transition
results: parsing output: 47/ for test: kms_flip_scaled_crc
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: gem_render_copy_redux
results: parsing output: 50/ for test: api_intel_bb
results: parsing output: 51/ for test: kms_psr2_sf
results: parsing output: 52/ for test: gem_exec_whisper
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_caching
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: fbdev
results: parsing output: 58/ for test: gem_exec_balancer
results: parsing output: 59/ for test: gem_pxp
results: parsing output: 60/ for test: kms_cursor_edge_walk
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_plane_lowres
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: kms_pipe_b_c_ivb
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: perf
results: parsing output: 68/ for test: kms_lease
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: kms_cdclk
results: parsing output: 71/ for test: i915_pm_rps
results: parsing output: 72/ for test: kms_plane_scaling
results: parsing output: 73/ for test: kms_setmode
results: parsing output: 74/ for test: gem_exec_capture
results: parsing output: 75/ for test: gem_exec_reloc
results: parsing output: 76/ for test: gem_exec_whisper
results: parsing output: 77/ for test: kms_vblank
results: parsing output: 78/ for test: perf
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: prime_self_import
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_atomic_transition
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: gem_set_tiling_vs_gtt
results: parsing output: 86/ for test: i915_drm_fdinfo
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: i915_fb_tiling
results: parsing output: 89/ for test: kms_content_protection
results: parsing output: 90/ for test: kms_scaling_modes
results: parsing output: 91/ for test: kms_plane
results: parsing output: 92/ for test: gem_exec_await
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: kms_addfb_basic
results: parsing output: 95/ for test: sw_sync
results: parsing output: 96/ for test: gem_ctx_shared
results: parsing output: 97/ for test: drm_read
results: parsing output: 98/ for test: kms_cursor_crc
results: parsing output: 99/ for test: gem_render_copy
results: parsing output: 100/ for test: gem_mmap
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_getfb
results: parsing output: 103/ for test: kms_pipe_stress
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: gem_userptr_blits
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_exec_fence
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: kms_feature_discovery
results: parsing output: 112/ for test: perf
results: parsing output: 113/ for test: gem_exec_params
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_selftest
results: parsing output: 116/ for test: kms_cursor_crc
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: kms_color
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: perf
results: parsing output: 123/ for test: gem_spin_batch
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: perf
results: parsing output: 127/ for test: gem_mmap_gtt
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_chamelium_frames
results: parsing output: 131/ for test: gem_mmap_gtt
Done.