[56.140039] Initializing watchdogs
[56.140148]   /dev/watchdog0
[56.154648] [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]
[56.158708] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.160937] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.164218] [001/134] (960s left) kms_flip (flip-vs-rmfb-interruptible)
[56.303935] Starting subtest: flip-vs-rmfb-interruptible
[56.306460] Starting dynamic subtest: A-eDP1
[64.965439] Dynamic subtest A-eDP1: SUCCESS (8.661s)
[64.973339] Starting dynamic subtest: B-eDP1
[73.588482] Dynamic subtest B-eDP1: SUCCESS (8.622s)
[73.596857] Starting dynamic subtest: C-eDP1
[82.196731] Dynamic subtest C-eDP1: SUCCESS (8.607s)
[82.205614] Starting dynamic subtest: D-eDP1
[90.836749] Dynamic subtest D-eDP1: SUCCESS (8.639s)
[90.841750] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.536s)
[92.030806] [002/134] (924s left) kms_addfb_basic (bo-too-small)
[92.131986] Starting subtest: bo-too-small
[92.133864] Subtest bo-too-small: SUCCESS (0.000s)
[92.250742] [003/134] (924s left) gem_mmap_gtt (basic-write-read-distinct)
[92.308240] Subtest basic-write-read-distinct: SKIP (0.000s)
[92.368706] [004/134] (924s left) syncobj_wait (multi-wait-for-submit-signaled)
[92.428489] Starting subtest: multi-wait-for-submit-signaled
[92.430751] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[92.562543] [005/134] (924s left) gem_ccs (ctrl-surf-copy-new-ctx)
[92.629167] Starting subtest: ctrl-surf-copy-new-ctx
[92.633506] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[92.736997] [006/134] (924s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[92.797480] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[92.799742] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[92.922305] [007/134] (923s left) kms_feature_discovery (display-3x)
[93.021291] Starting subtest: display-3x
[93.024911] Subtest display-3x: SKIP (0.000s)
[93.115499] [008/134] (923s left) api_intel_allocator (reloc-allocator)
[93.178935] Starting subtest: reloc-allocator
[93.180609] Starting dynamic subtest: basic
[93.185069] Dynamic subtest basic: SUCCESS (0.006s)
[93.193547] Starting dynamic subtest: parallel-one
[93.195550] Dynamic subtest parallel-one: SUCCESS (0.007s)
[93.206836] Starting dynamic subtest: print
[93.208808] Dynamic subtest print: SUCCESS (0.000s)
[93.214902] Starting dynamic subtest: reuse
[93.216742] Dynamic subtest reuse: SUCCESS (0.000s)
[93.222678] Starting dynamic subtest: fork-reopen-allocator
[93.224526] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[93.226356] Subtest reloc-allocator: SUCCESS (0.030s)
[93.347349] [009/134] (923s left) gem_exec_gttfill (basic)
[93.417772] Starting subtest: basic
[95.954645] Subtest basic: SUCCESS (2.537s)
[96.156964] [010/134] (920s left) gem_exec_schedule (preempt-queue-contexts-chain)
[96.282698] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[96.585377] [011/134] (920s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[96.655777] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[96.720362] [012/134] (920s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[96.839559] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[100.755658] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.917s)
[101.916228] [013/134] (915s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[102.046777] Starting subtest: cursorB-vs-flipA-legacy
[102.051259] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[102.210816] [014/134] (914s left) gem_render_copy (yf-tiled-ccs-to-linear)
[102.261188] Starting subtest: yf-tiled-ccs-to-linear
[102.265600] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[102.451514] [015/134] (914s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[102.554828] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[102.559100] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[102.690637] [016/134] (914s left) gem_exec_schedule (fairslice)
[102.762181] Starting subtest: fairslice
[102.764319] Starting dynamic subtest: rcs0
[104.781066] Dynamic subtest rcs0: SUCCESS (2.024s)
[104.793540] Starting dynamic subtest: bcs0
[106.803050] Dynamic subtest bcs0: SUCCESS (2.019s)
[106.811847] Starting dynamic subtest: vcs0
[108.823413] Dynamic subtest vcs0: SUCCESS (2.017s)
[108.832074] Starting dynamic subtest: vcs1
[110.841639] Dynamic subtest vcs1: SUCCESS (2.016s)
[110.849829] Starting dynamic subtest: vecs0
[112.859585] Dynamic subtest vecs0: SUCCESS (2.019s)
[112.868584] Starting dynamic subtest: ccs0
[114.878248] Dynamic subtest ccs0: SUCCESS (2.019s)
[114.880215] Subtest fairslice: SUCCESS (12.122s)
[115.185719] [017/134] (902s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[115.295831] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[115.298133] Starting dynamic subtest: pipe-A-default-mode
[118.028071] Dynamic subtest pipe-A-default-mode: SUCCESS (2.729s)
[118.029994] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.731s)
[118.866293] [018/134] (898s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[118.966144] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[118.970338] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[119.121435] [019/134] (898s left) gem_userptr_blits (set-cache-level)
[119.188480] Starting subtest: set-cache-level
[119.192836] Subtest set-cache-level: SKIP (0.000s)
[119.340459] [020/134] (898s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[119.446270] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[119.457212] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.010s)
[119.556340] [021/134] (897s left) gem_softpin (evict-active-interruptible)
[119.629116] Starting subtest: evict-active-interruptible
[119.631618] Subtest evict-active-interruptible: SUCCESS (0.006s)
[119.785575] [022/134] (897s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[119.877607] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[119.879446] Starting dynamic subtest: pipe-A-eDP-1
[119.895705] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.019s)
[119.907668] Starting dynamic subtest: pipe-B-eDP-1
[119.924437] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s)
[119.932605] Starting dynamic subtest: pipe-C-eDP-1
[119.949297] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[119.957944] Starting dynamic subtest: pipe-D-eDP-1
[119.974859] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[119.976789] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.082s)
[122.224617] [023/134] (895s left) kms_psr (fbc-psr2-dpms)
[122.327079] Starting subtest: fbc-psr2-dpms
[122.329214] Starting dynamic subtest: eDP-1
[122.333123] Dynamic subtest eDP-1: SKIP (0.000s)
[122.337110] Subtest fbc-psr2-dpms: SKIP (0.001s)
[122.407688] [024/134] (895s left) gem_tiled_pread_basic
[122.529024] [025/134] (895s left) gem_sync (basic-store-all)
[122.597667] Starting subtest: basic-store-all
[125.526875] Subtest basic-store-all: SUCCESS (2.939s)
[125.734688] [026/134] (891s left) kms_atomic_transition (plane-all-transition-fencing)
[125.840951] Starting subtest: plane-all-transition-fencing
[125.843293] Starting dynamic subtest: pipe-A-eDP-1
[128.334858] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[128.649827] Starting dynamic subtest: pipe-B-eDP-1
[131.840924] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.199s)
[132.142776] Subtest plane-all-transition-fencing: SUCCESS (6.301s)
[132.997874] [027/134] (884s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[133.116231] Starting subtest: crc-primary-basic-yf-tiled-ccs
[133.118504] Starting dynamic subtest: pipe-A-eDP-1
[133.141415] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[133.150813] Starting dynamic subtest: pipe-B-eDP-1
[133.171221] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[133.178867] Starting dynamic subtest: pipe-C-eDP-1
[133.200991] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[133.210189] Starting dynamic subtest: pipe-D-eDP-1
[133.231877] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[133.236044] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[135.428044] [028/134] (882s left) gem_exec_reloc (basic-cpu-gtt)
[135.499367] Subtest basic-cpu-gtt: SKIP (0.000s)
[135.572530] [029/134] (882s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[135.629874] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[135.634489] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[135.822861] [030/134] (881s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[135.890046] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[135.955449] [031/134] (881s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[136.059833] Starting subtest: fbc-shrfb-scaledprimary
[139.088775] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.032s)
[140.244133] [032/134] (877s left) gem_eio (in-flight-contexts-1us)
[140.488056] Starting subtest: in-flight-contexts-1us
[151.914682] Subtest in-flight-contexts-1us: SUCCESS (11.424s)
[152.110255] [033/134] (865s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[152.207661] Starting subtest: coverage-vs-premult-vs-constant
[152.484915] Starting dynamic subtest: pipe-A-eDP-1
[153.050864] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.563s)
[153.059364] Starting dynamic subtest: pipe-D-eDP-1
[154.329455] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.276s)
[154.331837] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.122s)
[155.190225] [034/134] (862s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[155.297078] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[155.301135] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[155.432353] [035/134] (862s left) kms_pwrite_crc
[157.103479] [036/134] (860s left) gem_lmem_swapping (heavy-multi)
[157.143544] Subtest heavy-multi: SKIP (0.000s)
[157.185197] [037/134] (860s left) gem_exec_schedule (preempt-other-chain)
[157.254079] Starting subtest: preempt-other-chain
[157.256249] Starting dynamic subtest: rcs0
[157.325290] Dynamic subtest rcs0: SUCCESS (0.080s)
[157.339193] Starting dynamic subtest: bcs0
[157.399274] Dynamic subtest bcs0: SUCCESS (0.073s)
[157.411195] Starting dynamic subtest: vcs0
[157.476110] Dynamic subtest vcs0: SUCCESS (0.076s)
[157.487196] Starting dynamic subtest: vcs1
[157.553142] Dynamic subtest vcs1: SUCCESS (0.077s)
[157.562921] Starting dynamic subtest: vecs0
[157.629041] Dynamic subtest vecs0: SUCCESS (0.075s)
[157.643191] Starting dynamic subtest: ccs0
[157.703918] Dynamic subtest ccs0: SUCCESS (0.074s)
[157.706235] Subtest preempt-other-chain: SUCCESS (0.460s)
[159.059150] [038/134] (859s left) kms_psr (psr-cursor-plane-move)
[159.176353] Starting subtest: psr-cursor-plane-move
[159.178652] Starting dynamic subtest: eDP-1
[160.889850] Dynamic subtest eDP-1: SUCCESS (1.713s)
[160.892169] Subtest psr-cursor-plane-move: SUCCESS (1.714s)
[161.762573] [039/134] (856s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[161.870336] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[161.872631] Starting dynamic subtest: pipe-A-eDP-1
[161.896386] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[161.904871] Starting dynamic subtest: pipe-B-eDP-1
[161.928050] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[161.935190] Starting dynamic subtest: pipe-C-eDP-1
[161.957911] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[161.965230] Starting dynamic subtest: pipe-D-eDP-1
[161.989145] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[161.993169] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[164.046816] [040/134] (854s left) dmabuf_sync_file (import-multiple-read-only)
[164.143773] Starting subtest: import-multiple-read-only
[164.146169] Subtest import-multiple-read-only: SUCCESS (0.003s)
[164.217714] [FACT dmabuf_sync_file (import-multiple-read-only)] new: kernel.kmod_is_loaded.vgem: true
[164.220951] [041/134] (853s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[164.327831] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[165.406533] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.078s)
[165.560145] [042/134] (852s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[165.660356] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[165.662266] Starting dynamic subtest: pipe-A-eDP-1
[165.681203] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[165.689402] Starting dynamic subtest: pipe-B-eDP-1
[165.707541] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[165.714444] Starting dynamic subtest: pipe-C-eDP-1
[165.732177] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[165.739071] Starting dynamic subtest: pipe-D-eDP-1
[165.756904] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[165.760276] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.006s)
[167.904254] [043/134] (850s left) gem_softpin (noreloc-interruptible)
[167.979734] Starting subtest: noreloc-interruptible
[173.379646] Subtest noreloc-interruptible: SUCCESS (5.398s)
[173.541150] [044/134] (844s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[173.648118] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[173.650403] Starting dynamic subtest: pipe-A
[173.671673] Dynamic subtest pipe-A: SKIP (0.018s)
[173.680164] Starting dynamic subtest: pipe-B
[173.706131] Dynamic subtest pipe-B: SKIP (0.032s)
[173.715519] Starting dynamic subtest: pipe-C
[173.737752] Dynamic subtest pipe-C: SKIP (0.033s)
[173.747013] Starting dynamic subtest: pipe-D
[173.772091] Dynamic subtest pipe-D: SKIP (0.033s)
[173.776523] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.121s)
[173.894895] [045/134] (844s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[173.955612] Starting subtest: multi-wait-all-for-submit-available-signaled
[173.957793] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[174.089878] [046/134] (844s left) gem_exec_balancer (bonded-sync)
[174.163990] Starting subtest: bonded-sync
[174.168689] Subtest bonded-sync: SKIP (0.000s)
[174.486501] [047/134] (843s left) gem_exec_fence (submit-chain)
[174.672152] Starting subtest: submit-chain
[174.694674] Subtest submit-chain: SUCCESS (0.025s)
[176.995739] [048/134] (841s left) vgem_basic (bad-handle)
[177.049535] Starting subtest: bad-handle
[177.051484] Subtest bad-handle: SUCCESS (0.000s)
[177.116235] [049/134] (841s left) kms_flip (basic-plain-flip)
[177.225311] Starting subtest: basic-plain-flip
[177.227654] Starting dynamic subtest: A-eDP1
[178.915982] Dynamic subtest A-eDP1: SUCCESS (1.692s)
[178.933630] Starting dynamic subtest: B-eDP1
[180.640490] Dynamic subtest B-eDP1: SUCCESS (1.722s)
[180.650893] Starting dynamic subtest: C-eDP1
[182.259246] Dynamic subtest C-eDP1: SUCCESS (1.617s)
[182.268393] Starting dynamic subtest: D-eDP1
[183.893131] Dynamic subtest D-eDP1: SUCCESS (1.633s)
[183.895435] Subtest basic-plain-flip: SUCCESS (6.674s)
[185.094107] [050/134] (833s left) gem_set_tiling_vs_pwrite
[185.222338] [051/134] (833s left) api_intel_bb (purge-bb)
[185.280790] Starting subtest: purge-bb
[185.283063] Subtest purge-bb: SUCCESS (0.004s)
[185.431519] [052/134] (833s left) gem_ctx_persistence (engines-hang)
[185.496222] Starting subtest: engines-hang
[185.498086] Starting dynamic subtest: rcs0
[185.597967] Dynamic subtest rcs0: SUCCESS (0.104s)
[185.608841] Starting dynamic subtest: bcs0
[185.703503] Dynamic subtest bcs0: SUCCESS (0.104s)
[185.714073] Starting dynamic subtest: vcs0
[185.805487] Dynamic subtest vcs0: SUCCESS (0.100s)
[185.816139] Starting dynamic subtest: vcs1
[185.915510] Dynamic subtest vcs1: SUCCESS (0.108s)
[185.926249] Starting dynamic subtest: vecs0
[186.035304] Dynamic subtest vecs0: SUCCESS (0.118s)
[186.045774] Starting dynamic subtest: ccs0
[186.117213] Dynamic subtest ccs0: SUCCESS (0.080s)
[186.119383] Subtest engines-hang: SUCCESS (0.626s)
[186.253356] [053/134] (832s left) kms_psr2_su (page_flip-nv12)
[186.304830] Subtest page_flip-NV12: SKIP (0.000s)
[186.368211] [054/134] (832s left) gem_exec_reloc (basic-wc-cpu)
[186.430179] Subtest basic-wc-cpu: SKIP (0.000s)
[186.500355] [055/134] (832s left) syncobj_wait (wait-any-snapshot)
[186.565808] Starting subtest: wait-any-snapshot
[186.646659] Subtest wait-any-snapshot: SUCCESS (0.081s)
[186.734934] [056/134] (832s left) drm_read (empty-nonblock)
[186.876108] Starting subtest: empty-nonblock
[186.877675] Subtest empty-nonblock: SUCCESS (0.000s)
[187.001474] [057/134] (831s left) gen9_exec_parse (batch-invalid-length)
[187.063717] Subtest batch-invalid-length: SKIP (0.000s)
[187.135530] [058/134] (831s left) gen3_render_mixed_blits
[187.263181] [059/134] (831s left) gem_ctx_create (basic)
[187.330464] Starting subtest: basic
[187.332436] Subtest basic: SUCCESS (0.000s)
[187.525604] [060/134] (831s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[187.613191] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[187.615356] Starting dynamic subtest: pipe-A-default-mode
[187.900198] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[187.904554] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.286s)
[188.713609] [061/134] (830s left) gem_mmap_gtt (ptrace)
[188.773718] Subtest ptrace: SKIP (0.000s)
[188.828392] [062/134] (830s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[188.938989] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[188.943156] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[189.046800] [063/134] (830s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-mmap-gtt)
[189.139049] Starting subtest: fbcpsr-abgr161616f-draw-mmap-gtt
[189.143096] Subtest fbcpsr-abgr161616f-draw-mmap-gtt: SKIP (0.000s)
[189.243587] [064/134] (829s left) syncobj_wait (multi-wait-all-signaled)
[189.300663] Starting subtest: multi-wait-all-signaled
[189.302929] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[189.406846] [065/134] (829s left) kms_prop_blob (invalid-set-prop-any)
[189.470470] Starting subtest: invalid-set-prop-any
[189.472396] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[189.609603] [066/134] (829s left) gem_lmem_swapping (verify-random)
[189.650088] Subtest verify-random: SKIP (0.000s)
[189.699392] [067/134] (829s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[189.742891] Starting subtest: single-wait-all-for-submit-available-signaled
[189.744540] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[189.861605] [068/134] (829s left) syncobj_timeline (reset-multiple-signaled)
[189.917363] Starting subtest: reset-multiple-signaled
[189.919353] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[190.049073] [069/134] (829s left) kms_chamelium_hpd (hdmi-hpd)
[190.433714] Subtest hdmi-hpd: SKIP (0.000s)
[191.207502] [070/134] (828s left) perf_pmu (rc6-all-gts)
[191.253341] Starting subtest: rc6-all-gts
[197.632219] Subtest rc6-all-gts: SUCCESS (6.380s)
[198.506507] [071/134] (820s left) kms_lease (simple-lease)
[198.609821] Starting subtest: simple-lease
[198.612104] Starting dynamic subtest: pipe-A-eDP-1
[199.106474] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.497s)
[199.115765] Starting dynamic subtest: pipe-B-eDP-1
[200.580358] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.471s)
[200.588606] Starting dynamic subtest: pipe-C-eDP-1
[201.952590] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.372s)
[201.962173] Starting dynamic subtest: pipe-D-eDP-1
[203.380499] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.425s)
[203.382858] Subtest simple-lease: SUCCESS (4.771s)
[204.197062] [072/134] (815s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[204.301505] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[210.878390] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.579s)
[211.049018] [073/134] (808s left) kms_cursor_crc (cursor-onscreen-128x128)
[211.250590] Starting subtest: cursor-onscreen-128x128
[211.255463] Starting dynamic subtest: pipe-A-eDP-1
[213.356797] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.100s)
[213.384812] Starting dynamic subtest: pipe-D-eDP-1
[216.174829] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.798s)
[216.177325] Subtest cursor-onscreen-128x128: SUCCESS (4.923s)
[216.995412] [074/134] (802s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[217.112667] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[224.034906] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.926s)
[224.174917] [075/134] (795s left) kms_pm_rpm (modeset-non-lpsp)
[226.108171] Starting subtest: modeset-non-lpsp
[227.257776] Subtest modeset-non-lpsp: SKIP (1.147s)
[227.640933] [076/134] (791s left) gem_exec_suspend (basic-s3-devices)
[227.714311] Starting subtest: basic-S3-devices
[227.716677] Starting dynamic subtest: smem
[238.933528] Dynamic subtest smem: SUCCESS (11.219s)
[238.936366] Subtest basic-S3-devices: SUCCESS (11.222s)
[239.143590] [077/134] (780s left) i915_drm_fdinfo (idle)
[239.197532] Starting subtest: idle
[239.199865] Starting dynamic subtest: rcs0
[239.804309] Dynamic subtest rcs0: SUCCESS (0.606s)
[239.816082] Starting dynamic subtest: bcs0
[240.311485] Dynamic subtest bcs0: SUCCESS (0.503s)
[240.323344] Starting dynamic subtest: vcs0
[240.817339] Dynamic subtest vcs0: SUCCESS (0.503s)
[240.828851] Starting dynamic subtest: vcs1
[241.323092] Dynamic subtest vcs1: SUCCESS (0.503s)
[241.334990] Starting dynamic subtest: vecs0
[241.828880] Dynamic subtest vecs0: SUCCESS (0.503s)
[241.840875] Starting dynamic subtest: ccs0
[242.334202] Dynamic subtest ccs0: SUCCESS (0.503s)
[242.337052] Subtest idle: SUCCESS (3.136s)
[242.432265] [078/134] (777s left) kms_joiner (invalid-modeset-ultra-joiner)
[242.530150] Starting subtest: invalid-modeset-ultra-joiner
[242.534562] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[242.619149] [079/134] (777s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[242.721914] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[242.726359] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[242.839772] [080/134] (776s left) syncobj_basic (bad-create-flags)
[242.903590] Starting subtest: bad-create-flags
[242.905575] Subtest bad-create-flags: SUCCESS (0.000s)
[243.031400] [081/134] (776s left) syncobj_basic (bad-flags-fd-to-handle)
[243.095072] Starting subtest: bad-flags-fd-to-handle
[243.097387] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[243.231163] [082/134] (776s left) gem_pxp (display-protected-crc)
[243.352304] Starting subtest: display-protected-crc
[245.401063] Subtest display-protected-crc: SUCCESS (2.050s)
[245.565904] [083/134] (774s left) gem_softpin (safe-alignment)
[245.630969] Starting subtest: safe-alignment
[245.652072] Subtest safe-alignment: SUCCESS (0.021s)
[246.982304] [084/134] (772s left) i915_drm_fdinfo (virtual-busy-idle-all)
[247.030802] Starting subtest: virtual-busy-idle-all
[247.035477] Subtest virtual-busy-idle-all: SKIP (0.000s)
[247.129473] [085/134] (772s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[247.231267] Starting subtest: fb-8bpc-vs-panel-8bpc
[247.233452] Starting dynamic subtest: pipe-A-eDP-1
[248.643900] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.411s)
[248.646097] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.412s)
[249.527351] [086/134] (770s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[249.625580] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[249.629957] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[249.762358] [087/134] (770s left) i915_query (hwconfig_table)
[249.827882] Starting subtest: hwconfig_table
[250.132392] Subtest hwconfig_table: SUCCESS (0.001s)
[250.215134] [088/134] (769s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[250.329056] Starting subtest: basic-modeset-with-all-modifiers-formats
[250.701463] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[251.497916] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.797s)
[251.507518] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[251.519365] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[251.527916] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[251.541658] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[251.550364] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[251.686168] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.144s)
[251.695030] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[251.708435] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[251.716986] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[251.730479] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[251.739087] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[251.752762] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[251.761334] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[251.775069] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s)
[251.783794] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[251.797235] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[251.806064] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[251.819579] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[251.828180] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[251.841702] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[251.850489] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[251.863636] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[251.872182] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[252.008559] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.144s)
[252.018165] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[252.030621] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[252.039809] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[252.052620] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[252.061068] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[252.075154] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[252.083701] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[252.097377] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.021s)
[252.105927] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[252.119501] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[252.128014] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[252.141812] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[252.150279] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[252.164125] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[252.172690] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[252.186307] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[252.194782] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[252.331547] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.144s)
[252.347709] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[252.353069] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[252.367438] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[252.375257] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[252.385816] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[252.397423] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s)
[252.405559] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[252.419647] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[252.427806] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[252.441868] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[252.450662] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[252.464059] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[252.472492] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[252.486447] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[252.495360] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[252.508652] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[252.889545] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.562s)
[253.694621] [089/134] (766s left) kms_getfb (getfb2-handle-not-fb)
[253.796318] Starting subtest: getfb2-handle-not-fb
[253.798631] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[253.909104] [090/134] (766s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[254.111944] Starting subtest: cursor-rapid-movement-64x21
[254.164268] Subtest cursor-rapid-movement-64x21: SKIP (0.050s)
[254.426930] [091/134] (765s left) kms_cursor_crc (cursor-sliding-512x512)
[254.702571] Starting subtest: cursor-sliding-512x512
[254.706315] Subtest cursor-sliding-512x512: SKIP (0.001s)
[254.888646] [092/134] (765s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[255.004398] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[255.008220] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[255.100419] [093/134] (765s left) kms_big_fb (linear-16bpp-rotate-0)
[255.213068] Starting subtest: linear-16bpp-rotate-0
[256.659746] Subtest linear-16bpp-rotate-0: SUCCESS (1.445s)
[256.866741] [094/134] (763s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[256.976851] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[256.980272] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[257.147318] [095/134] (763s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[257.251203] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[257.254765] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[257.383071] [096/134] (763s left) kms_psr (fbc-psr-no-drrs)
[257.475379] Starting subtest: fbc-psr-no-drrs
[257.477277] Starting dynamic subtest: eDP-1
[257.480689] Dynamic subtest eDP-1: SKIP (0.000s)
[257.484074] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[257.571144] [097/134] (763s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[257.676444] Starting subtest: primary-4-tiled-reflect-x-180
[264.749068] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.073s)
[265.965564] [098/134] (754s left) kms_content_protection (lic-type-1)
[266.110388] Starting subtest: lic-type-1
[266.115104] Subtest lic-type-1: SKIP (0.000s)
[266.252251] [099/134] (754s left) gem_ctx_shared (create-shared-gtt)
[266.319380] Starting subtest: create-shared-gtt
[268.481368] Subtest create-shared-gtt: SUCCESS (2.151s)
[269.011301] [100/134] (751s left) kms_flip (modeset-vs-vblank-race)
[269.100352] Starting subtest: modeset-vs-vblank-race
[269.102696] Starting dynamic subtest: A-eDP1
[273.794575] Dynamic subtest A-eDP1: SUCCESS (4.693s)
[273.806880] Starting dynamic subtest: B-eDP1
[278.521189] Dynamic subtest B-eDP1: SUCCESS (4.724s)
[278.533523] Starting dynamic subtest: C-eDP1
[283.041233] Dynamic subtest C-eDP1: SUCCESS (4.518s)
[283.051631] Starting dynamic subtest: D-eDP1
[287.577511] Dynamic subtest D-eDP1: SUCCESS (4.535s)
[287.580085] Subtest modeset-vs-vblank-race: SUCCESS (18.480s)
[288.883350] [101/134] (731s left) kms_plane_multiple (2x-tiling-none)
[288.989061] Starting subtest: 2x-tiling-none
[288.993236] Subtest 2x-tiling-none: SKIP (0.000s)
[289.084092] [102/134] (731s left) kms_async_flips (test-cursor)
[289.174967] Starting subtest: test-cursor
[289.179069] Subtest test-cursor: SKIP (0.000s)
[290.377175] [103/134] (730s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[290.464578] Starting subtest: y-tiled-16bpp-rotate-180
[290.468828] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[290.600200] [104/134] (730s left) gem_ctx_persistence (heartbeat-hang)
[290.663255] Starting subtest: heartbeat-hang
[290.667685] Subtest heartbeat-hang: SKIP (0.000s)
[290.796369] [105/134] (730s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[290.901167] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[290.903284] Starting dynamic subtest: pipe-A-eDP-1
[291.068378] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.156s)
[291.078038] Starting dynamic subtest: pipe-B-eDP-1
[291.096748] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[291.106049] Starting dynamic subtest: pipe-C-eDP-1
[291.125381] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[291.134097] Starting dynamic subtest: pipe-D-eDP-1
[291.153189] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[291.155373] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.190s)
[293.341873] [106/134] (727s left) kms_flip (2x-absolute-wf_vblank)
[293.446202] Starting subtest: 2x-absolute-wf_vblank
[293.454193] Subtest 2x-absolute-wf_vblank: SKIP (0.010s)
[293.545423] [107/134] (727s left) kms_chamelium_frames (hdmi-crc-fast)
[293.940307] Subtest hdmi-crc-fast: SKIP (0.000s)
[294.751695] [108/134] (726s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[294.806325] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[294.913509] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[295.012040] [109/134] (726s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[295.104665] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[295.108992] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[295.219819] [110/134] (725s left) gem_exec_params (invalid-ring2)
[295.289565] Starting subtest: invalid-ring2
[295.291962] Subtest invalid-ring2: SUCCESS (0.001s)
[295.419846] [111/134] (725s left) prime_busy (hang-wait)
[295.479457] Starting subtest: hang-wait
[295.481693] Starting dynamic subtest: rcs0
[321.394653] Dynamic subtest rcs0: SUCCESS (25.913s)
[321.403200] Starting dynamic subtest: bcs0
[328.550565] Dynamic subtest bcs0: SUCCESS (7.153s)
[328.560481] Starting dynamic subtest: vcs0
[335.531038] Dynamic subtest vcs0: SUCCESS (6.977s)
[335.539652] Starting dynamic subtest: vcs1
[342.497317] Dynamic subtest vcs1: SUCCESS (6.965s)
[342.506172] Starting dynamic subtest: vecs0
[349.535567] Dynamic subtest vecs0: SUCCESS (7.035s)
[349.544291] Starting dynamic subtest: ccs0
[363.376218] Dynamic subtest ccs0: SUCCESS (13.836s)
[363.378536] Subtest hang-wait: SUCCESS (67.894s)
[363.571817] [112/134] (657s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[363.674868] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[363.677183] Starting dynamic subtest: pipe-A
[363.742354] Dynamic subtest pipe-A: SUCCESS (0.069s)
[363.757321] Starting dynamic subtest: pipe-B
[364.877200] Dynamic subtest pipe-B: SUCCESS (1.134s)
[364.888482] Starting dynamic subtest: pipe-C
[365.975231] Dynamic subtest pipe-C: SUCCESS (1.097s)
[365.985300] Starting dynamic subtest: pipe-D
[367.110680] Dynamic subtest pipe-D: SUCCESS (1.133s)
[367.113073] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.439s)
[368.291935] [113/134] (652s left) kms_vblank (query-forked-busy)
[368.392162] Starting subtest: query-forked-busy
[368.394522] Starting dynamic subtest: pipe-A-eDP-1
[370.294564] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.902s)
[370.309810] Starting dynamic subtest: pipe-D-eDP-1
[372.848726] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.551s)
[372.851116] Subtest query-forked-busy: SUCCESS (4.457s)
[373.660259] [114/134] (647s left) gem_reg_read (timestamp-monotonic)
[373.718549] Starting subtest: timestamp-monotonic
[378.013333] Subtest timestamp-monotonic: SUCCESS (4.293s)
[378.099347] [115/134] (643s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[378.209478] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[378.213809] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[378.345039] [116/134] (643s left) i915_pm_rpm (gem-execbuf)
[380.075060] Starting subtest: gem-execbuf
[380.077814] Starting dynamic subtest: smem0
[381.568302] Dynamic subtest smem0: SUCCESS (1.494s)
[381.570188] Subtest gem-execbuf: SUCCESS (1.496s)
[381.665356] [117/134] (639s left) gem_exec_whisper (basic-fds)
[381.734442] Starting subtest: basic-fds
[388.853874] Subtest basic-fds: SUCCESS (7.114s)
[389.047940] [118/134] (632s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[389.154973] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[389.182686] Starting dynamic subtest: pipe-A-plane-0
[389.605228] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[389.622444] Starting dynamic subtest: pipe-A-plane-3
[389.860068] Dynamic subtest pipe-A-plane-3: SUCCESS (0.253s)
[389.870095] Starting dynamic subtest: pipe-A-plane-5
[389.874482] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[391.001948] Starting dynamic subtest: pipe-B-plane-0
[391.415796] Dynamic subtest pipe-B-plane-0: SUCCESS (0.422s)
[391.425235] Starting dynamic subtest: pipe-B-plane-3
[391.671630] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[391.681303] Starting dynamic subtest: pipe-B-plane-5
[391.685820] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[391.987819] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.833s)
[392.798848] [119/134] (628s left) gem_exec_balancer (parallel-bb-first)
[393.046987] Starting subtest: parallel-bb-first
[393.932443] Subtest parallel-bb-first: SUCCESS (0.886s)
[394.952609] [120/134] (626s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[395.063286] Starting subtest: 4-tiled-8bpp-rotate-90
[395.083844] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.020s)
[395.231158] [121/134] (626s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[395.346335] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[395.351080] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[395.473444] [122/134] (626s left) kms_psr (pr-sprite-mmap-gtt)
[395.567336] Starting subtest: pr-sprite-mmap-gtt
[395.571727] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[395.655459] [123/134] (626s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[395.747113] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[396.504522] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.759s)
[396.678498] [124/134] (625s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[396.782672] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[404.175239] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.395s)
[404.333258] [125/134] (617s left) kms_vblank (ts-continuation-modeset-rpm)
[404.440058] Starting subtest: ts-continuation-modeset-rpm
[404.442225] Starting dynamic subtest: pipe-A-eDP-1
[407.005785] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.564s)
[407.031365] Starting dynamic subtest: pipe-D-eDP-1
[409.277700] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.269s)
[409.280028] Subtest ts-continuation-modeset-rpm: SUCCESS (4.838s)
[410.153561] [126/134] (611s left) gem_mmap_gtt (basic-read)
[410.206505] Subtest basic-read: SKIP (0.000s)
[410.272270] [127/134] (611s left) gem_blits (basic)
[410.336065] Starting subtest: basic
[411.603719] Subtest basic: SUCCESS (1.266s)
[411.754433] [128/134] (610s left) kms_color (ctm-signed)
[411.846917] Starting subtest: ctm-signed
[411.849174] Starting dynamic subtest: pipe-A-eDP-1
[413.936312] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.089s)
[413.946189] Starting dynamic subtest: pipe-B-eDP-1
[416.783574] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.846s)
[416.793325] Starting dynamic subtest: pipe-C-eDP-1
[419.532763] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.750s)
[419.543166] Starting dynamic subtest: pipe-D-eDP-1
[422.182976] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.646s)
[422.185135] Subtest ctm-signed: SUCCESS (10.334s)
[423.016996] [129/134] (598s left) gem_eio (throttle)
[423.245572] Starting subtest: throttle
[423.597087] Subtest throttle: SUCCESS (0.349s)
[423.756591] [130/134] (598s left) syncobj_wait (invalid-signal-illegal-handle)
[423.818755] Starting subtest: invalid-signal-illegal-handle
[423.820812] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[423.940817] [131/134] (598s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[424.041377] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[424.044849] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[424.171312] [132/134] (597s left) kms_pm_backlight (fade-with-suspend)
[424.263756] Starting subtest: fade-with-suspend
[440.569059] Starting dynamic subtest: eDP-1
[443.232437] Dynamic subtest eDP-1: SUCCESS (2.667s)
[443.234793] Subtest fade-with-suspend: SUCCESS (3.918s)
[444.102797] [133/134] (578s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[449.260094] Starting subtest: psr2-overlay-plane-move-continuous-sf
[449.262267] Starting dynamic subtest: pipe-A-eDP-1
[455.952513] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.685s)
[455.962194] Starting dynamic subtest: pipe-B-eDP-1
[462.706593] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.750s)
[462.708932] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.440s)
[463.591344] [134/134] (558s left) perf (gen12-oa-tlb-invalidate)
[463.743793] Starting subtest: gen12-oa-tlb-invalidate
[463.745994] Starting dynamic subtest: 0-rcs0
[473.804048] Dynamic subtest 0-rcs0: SUCCESS (10.056s)
[473.814877] Starting dynamic subtest: 1-vecs0
[483.848210] Dynamic subtest 1-vecs0: SUCCESS (10.044s)
[483.850741] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.102s)
[483.889386] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: kms_addfb_basic
results: parsing output: 2/ for test: gem_mmap_gtt
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: gem_ccs
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: kms_feature_discovery
results: parsing output: 7/ for test: api_intel_allocator
results: parsing output: 8/ for test: gem_exec_gttfill
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: kms_pipe_b_c_ivb
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: gem_render_copy
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_exec_schedule
results: parsing output: 16/ for test: kms_flip_scaled_crc
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_userptr_blits
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: gem_softpin
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: gem_tiled_pread_basic
results: parsing output: 24/ for test: gem_sync
results: parsing output: 25/ for test: kms_atomic_transition
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: gem_exec_reloc
results: parsing output: 28/ for test: gem_render_copy
results: parsing output: 29/ for test: gem_fenced_exec_thrash
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_eio
results: parsing output: 32/ for test: kms_plane_alpha_blend
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_pwrite_crc
results: parsing output: 35/ for test: gem_lmem_swapping
results: parsing output: 36/ for test: gem_exec_schedule
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: dmabuf_sync_file
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: gem_softpin
results: parsing output: 43/ for test: kms_plane_scaling
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: gem_exec_balancer
results: parsing output: 46/ for test: gem_exec_fence
results: parsing output: 47/ for test: vgem_basic
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 50/ for test: api_intel_bb
results: parsing output: 51/ for test: gem_ctx_persistence
results: parsing output: 52/ for test: kms_psr2_su
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: drm_read
results: parsing output: 56/ for test: gen9_exec_parse
results: parsing output: 57/ for test: gen3_render_mixed_blits
results: parsing output: 58/ for test: gem_ctx_create
results: parsing output: 59/ for test: kms_flip_scaled_crc
results: parsing output: 60/ for test: gem_mmap_gtt
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: kms_prop_blob
results: parsing output: 65/ for test: gem_lmem_swapping
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: kms_chamelium_hpd
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: kms_lease
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_cursor_crc
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_pm_rpm
results: parsing output: 75/ for test: gem_exec_suspend
results: parsing output: 76/ for test: i915_drm_fdinfo
results: parsing output: 77/ for test: kms_joiner
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: syncobj_basic
results: parsing output: 80/ for test: syncobj_basic
results: parsing output: 81/ for test: gem_pxp
results: parsing output: 82/ for test: gem_softpin
results: parsing output: 83/ for test: i915_drm_fdinfo
results: parsing output: 84/ for test: kms_dither
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: i915_query
results: parsing output: 87/ for test: kms_async_flips
results: parsing output: 88/ for test: kms_getfb
results: parsing output: 89/ for test: kms_cursor_crc
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_rotation_crc
results: parsing output: 97/ for test: kms_content_protection
results: parsing output: 98/ for test: gem_ctx_shared
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: kms_plane_multiple
results: parsing output: 101/ for test: kms_async_flips
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: gem_ctx_persistence
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: kms_chamelium_frames
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_params
results: parsing output: 110/ for test: prime_busy
results: parsing output: 111/ for test: kms_plane_scaling
results: parsing output: 112/ for test: kms_vblank
results: parsing output: 113/ for test: gem_reg_read
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: i915_pm_rpm
results: parsing output: 116/ for test: gem_exec_whisper
results: parsing output: 117/ for test: kms_plane
results: parsing output: 118/ for test: gem_exec_balancer
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_vblank
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: gem_blits
results: parsing output: 127/ for test: kms_color
results: parsing output: 128/ for test: gem_eio
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_pm_backlight
results: parsing output: 132/ for test: kms_psr2_sf
results: parsing output: 133/ for test: perf
Done.