[58.352377] Initializing watchdogs
[58.352424]   /dev/watchdog0
[58.366779] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.371223] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.373424] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.376971] [001/155] (960s left) gem_gtt_cpu_tlb
[58.513666] [002/155] (960s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[58.617664] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[59.430657] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.829s)
[59.611571] [003/155] (959s left) perf (invalid-remove-userspace-config)
[59.728278] Starting subtest: invalid-remove-userspace-config
[59.736214] Subtest invalid-remove-userspace-config: SUCCESS (0.010s)
[59.780767] [004/155] (959s left) kms_prop_blob (invalid-set-prop)
[59.826112] Starting subtest: invalid-set-prop
[59.828368] Subtest invalid-set-prop: SUCCESS (0.000s)
[59.924062] [005/155] (959s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[60.012721] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[66.766273] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.828s)
[66.896561] [006/155] (952s left) kms_invalid_mode (int-max-clock)
[67.006376] Starting subtest: int-max-clock
[67.008623] Starting dynamic subtest: pipe-A-eDP-1
[67.298073] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s)
[67.308587] Starting dynamic subtest: pipe-B-eDP-1
[67.310574] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[67.317775] Starting dynamic subtest: pipe-C-eDP-1
[67.319957] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[67.327045] Starting dynamic subtest: pipe-D-eDP-1
[67.330127] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[67.333103] Subtest int-max-clock: SUCCESS (0.299s)
[68.090590] [007/155] (951s left) gem_pxp (reject-modify-context-protection-off-3)
[68.211469] Starting subtest: reject-modify-context-protection-off-3
[68.214126] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[68.348500] [008/155] (950s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-move)
[68.439134] Starting subtest: hdr-2p-scndscrn-spr-indfb-move
[68.443280] Subtest hdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[68.517183] [009/155] (950s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[68.600280] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[68.602605] Starting dynamic subtest: pipe-A-eDP-1
[101.240872] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.735s)
[101.250253] Starting dynamic subtest: pipe-B-eDP-1
[134.169446] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.705s)
[134.179571] Starting dynamic subtest: pipe-C-eDP-1
[167.185726] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.748s)
[167.195731] Starting dynamic subtest: pipe-D-eDP-1
[200.165049] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.640s)
[200.167599] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (14.830s)
[201.372390] [010/155] (817s left) gem_exec_params (sol-reset-invalid)
[201.437126] Starting subtest: sol-reset-invalid
[201.441929] Subtest sol-reset-invalid: SUCCESS (0.002s)
[203.539859] [011/155] (815s left) kms_draw_crc (draw-method-blt)
[203.621165] Starting subtest: draw-method-blt
[203.623515] Starting dynamic subtest: xrgb8888-untiled
[203.879210] Dynamic subtest xrgb8888-untiled: SUCCESS (0.266s)
[203.888115] Starting dynamic subtest: rgb565-untiled
[204.095151] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[204.104609] Starting dynamic subtest: xrgb2101010-untiled
[204.311579] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[204.320555] Starting dynamic subtest: xbgr16161616f-untiled
[204.538464] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.232s)
[204.547442] Starting dynamic subtest: xrgb8888-xtiled
[204.659158] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[204.667542] Starting dynamic subtest: rgb565-xtiled
[204.766337] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s)
[204.774901] Starting dynamic subtest: xrgb2101010-xtiled
[204.874625] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[204.884849] Starting dynamic subtest: xbgr16161616f-xtiled
[204.971780] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.099s)
[204.980147] Starting dynamic subtest: xrgb8888-4tiled
[205.080806] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.111s)
[205.089977] Starting dynamic subtest: rgb565-4tiled
[205.178579] Dynamic subtest rgb565-4tiled: SUCCESS (0.099s)
[205.187056] Starting dynamic subtest: xrgb2101010-4tiled
[205.286538] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.111s)
[205.295565] Starting dynamic subtest: xbgr16161616f-4tiled
[205.406376] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.122s)
[205.408297] Subtest draw-method-blt: SUCCESS (1.834s)
[205.529261] [012/155] (813s left) gem_userptr_blits (sync-unmap-cycles)
[205.595552] Starting subtest: sync-unmap-cycles
[210.892709] Subtest sync-unmap-cycles: SUCCESS (5.381s)
[211.024131] [013/155] (808s left) prime_vgem (basic-gtt)
[211.216061] Starting subtest: basic-gtt
[211.220036] Subtest basic-gtt: SKIP (0.000s)
[211.333949] [FACT prime_vgem (basic-gtt)] new: kernel.kmod_is_loaded.vgem: true
[211.336676] [014/155] (808s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[211.720032] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[212.555886] [015/155] (806s left) kms_sequence (queue-idle)
[212.655444] Starting subtest: queue-idle
[212.657417] Starting dynamic subtest: pipe-A-eDP-1
[214.455485] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.813s)
[214.467523] Starting dynamic subtest: pipe-B-eDP-1
[216.928799] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.486s)
[216.938411] Starting dynamic subtest: pipe-C-eDP-1
[219.437629] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.520s)
[219.446998] Starting dynamic subtest: pipe-D-eDP-1
[221.866075] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.436s)
[221.868025] Subtest queue-idle: SUCCESS (9.259s)
[222.676233] [016/155] (796s left) gem_ppgtt (blt-vs-render-ctxn)
[222.733547] Starting subtest: blt-vs-render-ctxN
[255.630469] Subtest blt-vs-render-ctxN: SUCCESS (32.888s)
[255.757755] [017/155] (763s left) syncobj_wait (reset-multiple-signaled)
[255.865466] Starting subtest: reset-multiple-signaled
[255.867940] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[255.971407] [018/155] (763s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[256.086037] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[256.090194] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[256.205100] [019/155] (763s left) kms_psr (fbc-psr-basic)
[256.290367] Starting subtest: fbc-psr-basic
[256.292282] Starting dynamic subtest: eDP-1
[256.296366] Dynamic subtest eDP-1: SKIP (0.000s)
[256.300828] Subtest fbc-psr-basic: SKIP (0.001s)
[256.365332] [020/155] (763s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[256.422031] Starting subtest: wait-all-for-submit-delayed-submit
[256.528262] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s)
[256.615210] [021/155] (763s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[256.738590] Starting subtest: cursorB-vs-flipA-legacy
[256.743335] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[256.882911] [022/155] (762s left) kms_plane_alpha_blend (alpha-basic)
[256.989165] Starting subtest: alpha-basic
[257.270352] Starting dynamic subtest: pipe-A-eDP-1
[259.205511] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.933s)
[259.230768] Starting dynamic subtest: pipe-D-eDP-1
[261.840043] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.616s)
[261.842499] Subtest alpha-basic: SUCCESS (4.852s)
[262.670700] [023/155] (757s left) kms_pm_rpm (pm-caching)
[264.522166] Starting subtest: pm-caching
[264.527053] Subtest pm-caching: SKIP (0.000s)
[264.991535] [024/155] (754s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-pwrite)
[265.084961] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-pwrite
[265.089199] Subtest hdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[265.192008] [025/155] (754s left) gem_softpin (allocator-nopin)
[265.251463] Starting subtest: allocator-nopin
[265.344628] Subtest allocator-nopin: SUCCESS (0.093s)
[265.455816] [026/155] (754s left) kms_frontbuffer_tracking (fbchdr-tiling-4)
[265.549649] Starting subtest: fbchdr-tiling-4
[265.554141] Subtest fbchdr-tiling-4: SKIP (0.000s)
[265.653947] [027/155] (754s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[265.773675] Starting subtest: short-flip-after-cursor-toggle
[266.695867] Subtest short-flip-after-cursor-toggle: SUCCESS (0.919s)
[267.518389] [028/155] (752s left) syncobj_wait (wait-all-for-submit-complex)
[267.581575] Starting subtest: wait-all-for-submit-complex
[267.794353] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[267.869727] [029/155] (752s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[267.969420] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[267.979695] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.010s)
[268.056642] [030/155] (751s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[268.155053] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[268.157336] Starting dynamic subtest: pipe-A-eDP-1
[268.180226] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[268.191753] Starting dynamic subtest: pipe-B-eDP-1
[268.213402] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[268.222068] Starting dynamic subtest: pipe-C-eDP-1
[268.243751] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[268.252347] Starting dynamic subtest: pipe-D-eDP-1
[268.274250] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[268.278609] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[270.479953] [031/155] (749s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[270.583617] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[270.587833] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[270.691323] [032/155] (749s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[270.786919] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[270.791448] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[270.904296] [033/155] (749s left) kms_plane (plane-panning-bottom-right-suspend)
[271.000139] Starting subtest: plane-panning-bottom-right-suspend
[271.002318] Starting dynamic subtest: pipe-A
[289.399097] Dynamic subtest pipe-A: SUCCESS (2.798s)
[289.413457] Starting dynamic subtest: pipe-B
[307.390222] Dynamic subtest pipe-B: SUCCESS (3.515s)
[307.392465] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.316s)
[308.210754] [034/155] (712s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[308.312582] Starting subtest: fbc-pr-cursor-mmap-cpu
[308.316694] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[308.385035] [035/155] (711s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[308.496213] Starting subtest: fbc-rgb101010-draw-pwrite
[311.692559] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (3.304s)
[312.813428] [036/155] (707s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[312.924218] Starting subtest: x-tiled-8bpp-rotate-90
[312.944743] Subtest x-tiled-8bpp-rotate-90: SKIP (0.020s)
[313.056232] [037/155] (707s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-pgflip-blt)
[313.161746] Starting subtest: hdr-2p-primscrn-shrfb-pgflip-blt
[313.166066] Subtest hdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[313.253201] [038/155] (707s left) perf (i915-ref-count)
[313.320617] Starting subtest: i915-ref-count
[313.359297] Subtest i915-ref-count: SUCCESS (0.036s)
[313.414440] [039/155] (707s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-indfb-pgflip-blt)
[313.524588] Starting subtest: fbchdr-2p-scndscrn-indfb-pgflip-blt
[313.528564] Subtest fbchdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[313.640881] [040/155] (706s left) kms_chamelium_edid (dp-mode-timings)
[314.034219] Subtest dp-mode-timings: SKIP (0.000s)
[314.884467] [041/155] (705s left) gen9_exec_parse (unaligned-jump)
[314.947479] Subtest unaligned-jump: SKIP (0.000s)
[315.044826] [042/155] (705s left) gem_lmem_swapping (verify-random-ccs)
[315.088175] Subtest verify-random-ccs: SKIP (0.000s)
[315.126590] [043/155] (705s left) gem_ctx_shared (q-smoketest)
[315.195814] Starting subtest: Q-smoketest
[315.198355] Starting dynamic subtest: rcs0
[320.675981] Dynamic subtest rcs0: SUCCESS (5.491s)
[320.687137] Starting dynamic subtest: bcs0
[326.136479] Dynamic subtest bcs0: SUCCESS (5.493s)
[326.153196] Starting dynamic subtest: vcs0
[331.612749] Dynamic subtest vcs0: SUCCESS (5.487s)
[331.626460] Starting dynamic subtest: vcs1
[337.094656] Dynamic subtest vcs1: SUCCESS (5.494s)
[337.106260] Starting dynamic subtest: vecs0
[342.589982] Dynamic subtest vecs0: SUCCESS (5.483s)
[342.600632] Starting dynamic subtest: ccs0
[348.078586] Dynamic subtest ccs0: SUCCESS (5.485s)
[348.080761] Subtest Q-smoketest: SUCCESS (32.942s)
[348.231640] [044/155] (672s left) i915_hangman (gt-error-state-capture)
[348.303937] Starting subtest: gt-error-state-capture
[348.306394] Starting dynamic subtest: rcs0
[359.600153] Dynamic subtest rcs0: SUCCESS (11.290s)
[359.614315] Starting dynamic subtest: bcs0
[371.630767] Dynamic subtest bcs0: SUCCESS (12.029s)
[371.644613] Starting dynamic subtest: vcs0
[383.538232] Dynamic subtest vcs0: SUCCESS (11.907s)
[383.551487] Starting dynamic subtest: vcs1
[392.559526] Dynamic subtest vcs1: SUCCESS (9.020s)
[392.573873] Starting dynamic subtest: vecs0
[403.567032] Dynamic subtest vecs0: SUCCESS (11.006s)
[403.579631] Starting dynamic subtest: ccs0
[415.599582] Dynamic subtest ccs0: SUCCESS (12.024s)
[415.602653] Subtest gt-error-state-capture: SUCCESS (67.294s)
[415.695329] [045/155] (604s left) perf (invalid-create-userspace-config)
[415.791722] Starting subtest: invalid-create-userspace-config
[415.797506] Subtest invalid-create-userspace-config: SUCCESS (0.003s)
[415.836467] [046/155] (604s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite)
[415.953112] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite
[415.957173] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[416.058138] [047/155] (604s left) gem_mmap_offset (partial-mmap)
[416.121637] Starting subtest: partial-mmap
[416.124104] Starting dynamic subtest: smem0
[416.126407] Dynamic subtest smem0: SUCCESS (0.003s)
[416.128306] Subtest partial-mmap: SUCCESS (0.004s)
[416.233666] [048/155] (604s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[416.329210] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[420.721769] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.398s)
[421.879677] [049/155] (598s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[421.981332] Starting subtest: pr-plane-move-sf-dmg-area
[421.985260] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[422.051748] [050/155] (598s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-blt)
[422.154241] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-blt
[422.158420] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[422.247718] [051/155] (598s left) gem_mmap_gtt (coherency)
[422.296814] Subtest coherency: SKIP (0.000s)
[422.351272] [052/155] (598s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[422.399668] Starting subtest: invalid-single-wait-unsubmitted
[422.401981] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[422.510348] [053/155] (598s left) gem_exec_balancer (sliced)
[422.564736] Starting subtest: sliced
[422.568703] Subtest sliced: SKIP (0.000s)
[422.850209] [054/155] (598s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[422.943704] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[422.948083] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[423.042482] [055/155] (598s left) kms_content_protection (content-type-change)
[423.172193] Starting subtest: content-type-change
[423.176696] Subtest content-type-change: SKIP (0.000s)
[423.311210] [056/155] (597s left) gem_exec_flush (basic-wb-rw-default)
[423.382642] Starting subtest: basic-wb-rw-default
[428.842122] Subtest basic-wb-rw-default: SUCCESS (5.460s)
[429.042169] [057/155] (592s left) api_intel_bb (intel-bb-blit-none)
[429.102002] Starting subtest: intel-bb-blit-none
[433.183776] Subtest intel-bb-blit-none: SUCCESS (4.080s)
[433.308434] [058/155] (587s left) syncobj_wait (multi-wait-submitted-signaled)
[433.371047] Starting subtest: multi-wait-submitted-signaled
[433.373403] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[433.470292] [059/155] (587s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[433.573331] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[434.596569] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.024s)
[434.718897] [060/155] (586s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-pwrite)
[434.823761] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-pwrite
[434.827356] Subtest hdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[434.918053] [061/155] (586s left) kms_cursor_crc (cursor-offscreen-32x10)
[435.083519] Starting subtest: cursor-offscreen-32x10
[435.133024] Subtest cursor-offscreen-32x10: SKIP (0.045s)
[435.415426] [062/155] (585s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[435.508790] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[435.510791] Starting dynamic subtest: pipe-A
[435.571272] Dynamic subtest pipe-A: SUCCESS (0.065s)
[435.583255] Starting dynamic subtest: pipe-B
[436.697887] Dynamic subtest pipe-B: SUCCESS (1.125s)
[436.708998] Starting dynamic subtest: pipe-C
[437.812406] Dynamic subtest pipe-C: SUCCESS (1.113s)
[437.824548] Starting dynamic subtest: pipe-D
[438.948575] Dynamic subtest pipe-D: SUCCESS (1.136s)
[438.950976] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.442s)
[440.105387] [063/155] (581s left) gem_exec_reloc (basic-gtt-wc-active)
[440.165945] Subtest basic-gtt-wc-active: SKIP (0.000s)
[440.238989] [064/155] (581s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[440.280143] Starting subtest: etime-single-wait-for-submit-submitted
[440.388706] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.108s)
[440.466307] [065/155] (581s left) perf_pmu (most-busy-check-all)
[440.504586] Starting subtest: most-busy-check-all
[440.506913] Starting dynamic subtest: rcs0
[441.617580] Dynamic subtest rcs0: SUCCESS (1.113s)
[441.629377] Starting dynamic subtest: bcs0
[443.601336] Dynamic subtest bcs0: SUCCESS (1.982s)
[443.614801] Starting dynamic subtest: vcs0
[445.649637] Dynamic subtest vcs0: SUCCESS (2.045s)
[445.662534] Starting dynamic subtest: vcs1
[447.632612] Dynamic subtest vcs1: SUCCESS (1.981s)
[447.646707] Starting dynamic subtest: vecs0
[449.616781] Dynamic subtest vecs0: SUCCESS (1.982s)
[449.630714] Starting dynamic subtest: ccs0
[451.667036] Dynamic subtest ccs0: SUCCESS (2.048s)
[451.670254] Subtest most-busy-check-all: SUCCESS (11.164s)
[451.779104] [066/155] (569s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[451.901968] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[451.906714] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[452.057395] [067/155] (569s left) kms_frontbuffer_tracking (psrhdr-suspend)
[452.152007] Starting subtest: psrhdr-suspend
[452.156530] Subtest psrhdr-suspend: SKIP (0.000s)
[452.255159] [068/155] (569s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[452.318054] Starting subtest: y-tiled-to-vebox-yf-tiled
[452.322574] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[452.516741] [069/155] (569s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-pwrite)
[452.618436] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-pwrite
[452.622629] Subtest hdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[452.710554] [070/155] (568s left) gen7_exec_parse (cmd-crossing-page)
[452.776069] Subtest cmd-crossing-page: SKIP (0.000s)
[452.841159] [071/155] (568s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[452.939159] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[452.950139] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.010s)
[453.055631] [072/155] (568s left) kms_psr (psr-no-drrs)
[453.149078] Starting subtest: psr-no-drrs
[453.151484] Starting dynamic subtest: eDP-1
[454.790794] Dynamic subtest eDP-1: SUCCESS (1.640s)
[454.793175] Subtest psr-no-drrs: SUCCESS (1.641s)
[455.665971] [073/155] (566s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[455.760104] Starting subtest: extended-pageflip-modeset-hang-oldfb
[455.762262] Starting dynamic subtest: pipe-A
[463.650963] Dynamic subtest pipe-A: SUCCESS (7.893s)
[463.663618] Starting dynamic subtest: pipe-D
[472.268833] Dynamic subtest pipe-D: SUCCESS (8.614s)
[472.271738] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.512s)
[473.117242] [074/155] (548s left) kms_chamelium_color (ctm-max)
[473.218460] Subtest ctm-max: SKIP (0.000s)
[473.267377] [075/155] (548s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[473.381292] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[473.385166] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[473.482339] [076/155] (548s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[473.582903] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[473.587447] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[473.689825] [077/155] (548s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[473.790548] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[473.792522] Starting dynamic subtest: pipe-A-eDP-1
[474.216799] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.428s)
[474.230551] Starting dynamic subtest: pipe-B-eDP-1
[474.246638] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.004s)
[474.256968] Starting dynamic subtest: pipe-C-eDP-1
[474.272487] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[474.282301] Starting dynamic subtest: pipe-D-eDP-1
[474.297507] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[474.299050] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.445s)
[476.726082] [078/155] (545s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[476.818335] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[476.843316] Starting dynamic subtest: pipe-A-plane-0
[477.120829] Dynamic subtest pipe-A-plane-0: SUCCESS (0.278s)
[477.133214] Starting dynamic subtest: pipe-A-plane-3
[477.331865] Dynamic subtest pipe-A-plane-3: SUCCESS (0.210s)
[478.408261] Starting dynamic subtest: pipe-B-plane-0
[478.687686] Dynamic subtest pipe-B-plane-0: SUCCESS (0.289s)
[478.698574] Starting dynamic subtest: pipe-B-plane-3
[478.898603] Dynamic subtest pipe-B-plane-3: SUCCESS (0.210s)
[479.212575] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.395s)
[480.082314] [079/155] (542s left) kms_addfb_basic (no-handle)
[480.138456] Starting subtest: no-handle
[480.140969] Subtest no-handle: SUCCESS (0.000s)
[480.269149] [080/155] (541s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-pwrite)
[480.362543] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-pwrite
[480.366763] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[480.460536] [081/155] (541s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[480.573373] Starting subtest: primary-x-tiled-reflect-x-180
[487.605879] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.036s)
[488.842751] [082/155] (533s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[488.957543] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[488.961952] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[489.049427] [083/155] (533s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-render)
[489.149125] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-render
[489.153589] Subtest psrhdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[489.242016] [084/155] (533s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[489.360016] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[493.510855] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.156s)
[494.658390] [085/155] (527s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[494.748740] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[494.752733] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[494.836217] [086/155] (527s left) kms_psr (fbc-psr2-basic)
[494.932990] Starting subtest: fbc-psr2-basic
[494.935310] Starting dynamic subtest: eDP-1
[494.939559] Dynamic subtest eDP-1: SKIP (0.000s)
[494.943751] Subtest fbc-psr2-basic: SKIP (0.001s)
[495.019624] [087/155] (527s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[495.120010] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[495.124254] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[495.229862] [088/155] (527s left) fbdev (write)
[495.264660] Starting subtest: write
[495.838211] Subtest write: SUCCESS (0.574s)
[495.901337] [089/155] (526s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-render)
[496.031121] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-render
[496.035656] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[496.128374] [090/155] (526s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[496.224128] Starting subtest: psr-farfromfence-mmap-gtt
[496.228497] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[496.335658] [091/155] (526s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[496.435924] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[503.761936] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.333s)
[503.897807] [092/155] (518s left) gem_userptr_blits (map-fixed-invalidate)
[503.965465] Starting subtest: map-fixed-invalidate
[503.969868] Subtest map-fixed-invalidate: SKIP (0.000s)
[504.091958] [093/155] (518s left) gem_exec_reloc (basic-scanout)
[504.156322] Subtest basic-scanout: SKIP (0.000s)
[504.235941] [094/155] (518s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[504.285595] Starting subtest: etime-multi-wait-all-available-unsubmitted
[504.388857] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.102s)
[504.466436] [095/155] (518s left) kms_color (legacy-gamma)
[504.564098] Starting subtest: legacy-gamma
[504.566224] Starting dynamic subtest: pipe-A-eDP-1
[505.277956] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.713s)
[505.288826] Starting dynamic subtest: pipe-B-eDP-1
[506.693412] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.414s)
[506.704591] Starting dynamic subtest: pipe-C-eDP-1
[508.040994] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.349s)
[508.052735] Starting dynamic subtest: pipe-D-eDP-1
[509.375657] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s)
[509.378009] Subtest legacy-gamma: SUCCESS (4.812s)
[510.188280] [096/155] (512s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-blt)
[510.294990] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-blt
[510.299273] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[510.390172] [097/155] (512s left) core_auth (basic-auth)
[510.442526] Starting subtest: basic-auth
[510.444781] Subtest basic-auth: SUCCESS (0.001s)
[510.564408] [098/155] (512s left) gem_exec_fence (syncobj-timeline-chain-engines)
[511.132983] Starting subtest: syncobj-timeline-chain-engines
[511.277408] Subtest syncobj-timeline-chain-engines: SUCCESS (0.145s)
[512.775753] [099/155] (510s left) kms_cursor_legacy (torture-bo)
[512.898651] Starting subtest: torture-bo
[512.900979] Starting dynamic subtest: pipe-A
[518.632160] Dynamic subtest pipe-A: SUCCESS (5.732s)
[518.651969] Starting dynamic subtest: pipe-B
[525.085101] Dynamic subtest pipe-B: SUCCESS (6.453s)
[525.103570] Starting dynamic subtest: pipe-C
[531.533729] Dynamic subtest pipe-C: SUCCESS (6.447s)
[531.550919] Starting dynamic subtest: pipe-D
[538.942881] Dynamic subtest pipe-D: SUCCESS (7.402s)
[538.954770] Starting dynamic subtest: all-pipes
[546.395017] Dynamic subtest all-pipes: SUCCESS (7.447s)
[546.397655] Subtest torture-bo: SUCCESS (33.494s)
[546.558683] [100/155] (476s left) gem_ctx_persistence (hang)
[546.624446] Starting subtest: hang
[546.629174] Subtest hang: SKIP (0.000s)
[546.725652] [101/155] (476s left) kms_flip (2x-flip-vs-dpms-on-nop)
[546.824028] Starting subtest: 2x-flip-vs-dpms-on-nop
[546.835217] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.010s)
[546.933150] [102/155] (476s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[547.024565] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[553.845197] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.823s)
[553.961099] [103/155] (469s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[554.062350] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[554.066514] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[554.164225] [104/155] (469s left) perf_pmu (busy-hang)
[554.205540] Starting subtest: busy-hang
[554.207929] Starting dynamic subtest: rcs0
[555.479043] Dynamic subtest rcs0: SUCCESS (1.275s)
[555.490712] Starting dynamic subtest: bcs0
[556.713295] Dynamic subtest bcs0: SUCCESS (1.229s)
[556.727011] Starting dynamic subtest: vcs0
[559.123619] Dynamic subtest vcs0: SUCCESS (2.408s)
[559.136140] Starting dynamic subtest: vcs1
[561.176584] Dynamic subtest vcs1: SUCCESS (2.051s)
[561.189978] Starting dynamic subtest: vecs0
[563.155317] Dynamic subtest vecs0: SUCCESS (1.977s)
[563.168465] Starting dynamic subtest: ccs0
[564.380080] Dynamic subtest ccs0: SUCCESS (1.226s)
[564.382998] Subtest busy-hang: SUCCESS (10.176s)
[564.480099] [105/155] (458s left) prime_self_import (basic-llseek-bad)
[564.519356] Starting subtest: basic-llseek-bad
[564.541191] Subtest basic-llseek-bad: SUCCESS (0.020s)
[564.647947] [106/155] (458s left) sysfs_preempt_timeout (idempotent)
[564.703679] Starting subtest: idempotent
[564.706172] Starting dynamic subtest: vecs0
[564.708574] Dynamic subtest vecs0: SUCCESS (0.000s)
[564.721651] Starting dynamic subtest: ccs0
[564.723721] Dynamic subtest ccs0: SUCCESS (0.000s)
[564.736694] Starting dynamic subtest: vcs0
[564.739010] Dynamic subtest vcs0: SUCCESS (0.000s)
[564.749350] Starting dynamic subtest: bcs0
[564.751264] Dynamic subtest bcs0: SUCCESS (0.000s)
[564.761243] Starting dynamic subtest: rcs0
[564.763160] Dynamic subtest rcs0: SUCCESS (0.000s)
[564.773138] Starting dynamic subtest: vcs1
[564.775037] Dynamic subtest vcs1: SUCCESS (0.000s)
[564.776946] Subtest idempotent: SUCCESS (0.006s)
[564.818442] [107/155] (458s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[564.921530] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[569.207368] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.291s)
[570.437096] [108/155] (452s left) gem_ctx_persistence (engines-mixed)
[570.490761] Starting subtest: engines-mixed
[570.493296] Starting dynamic subtest: rcs0
[570.568460] Dynamic subtest rcs0: SUCCESS (0.077s)
[570.580456] Starting dynamic subtest: bcs0
[570.624589] Dynamic subtest bcs0: SUCCESS (0.054s)
[570.638764] Starting dynamic subtest: vcs0
[570.682480] Dynamic subtest vcs0: SUCCESS (0.056s)
[570.696958] Starting dynamic subtest: vcs1
[570.741939] Dynamic subtest vcs1: SUCCESS (0.057s)
[570.754709] Starting dynamic subtest: vecs0
[570.803846] Dynamic subtest vecs0: SUCCESS (0.060s)
[570.816729] Starting dynamic subtest: ccs0
[570.848624] Dynamic subtest ccs0: SUCCESS (0.043s)
[570.850967] Subtest engines-mixed: SUCCESS (0.358s)
[570.928313] [109/155] (452s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[571.024961] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[577.809266] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.789s)
[577.943519] [110/155] (445s left) gem_compute (compute-square)
[577.997067] Starting subtest: compute-square
[578.000620] Subtest compute-square: SUCCESS (0.006s)
[578.120708] [111/155] (445s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[578.226652] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[578.231213] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[578.337866] [112/155] (445s left) kms_async_flips (async-flip-dpms)
[578.430272] Starting subtest: async-flip-dpms
[578.819702] Starting dynamic subtest: pipe-A-eDP-1
[582.765878] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.947s)
[583.136474] Starting dynamic subtest: pipe-B-eDP-1
[586.023394] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.894s)
[586.406174] Starting dynamic subtest: pipe-C-eDP-1
[589.199969] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.801s)
[589.576323] Starting dynamic subtest: pipe-D-eDP-1
[592.391520] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.824s)
[592.393798] Subtest async-flip-dpms: SUCCESS (13.961s)
[593.571402] [113/155] (429s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-pwrite)
[593.680083] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-pwrite
[593.684101] Subtest hdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[593.779388] [114/155] (429s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[593.879121] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[593.881425] Starting dynamic subtest: pipe-A-default-mode
[595.033004] Dynamic subtest pipe-A-default-mode: SKIP (1.151s)
[595.037552] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.152s)
[595.200230] [115/155] (428s left) i915_pm_rpm (system-suspend-devices)
[596.820451] Starting subtest: system-suspend-devices
[604.473360] Subtest system-suspend-devices: SUCCESS (7.656s)
[604.868790] [116/155] (418s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[605.173676] Starting subtest: cursor-rapid-movement-max-size
[605.179859] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[605.305710] [117/155] (418s left) kms_flip (dpms-off-confusion-interruptible)
[605.392237] Starting subtest: dpms-off-confusion-interruptible
[605.394587] Starting dynamic subtest: A-eDP1
[614.073135] Dynamic subtest A-eDP1: SUCCESS (8.680s)
[614.088975] Starting dynamic subtest: B-eDP1
[622.693617] Dynamic subtest B-eDP1: SUCCESS (8.618s)
[622.708698] Starting dynamic subtest: C-eDP1
[631.319942] Dynamic subtest C-eDP1: SUCCESS (8.625s)
[631.331510] Starting dynamic subtest: D-eDP1
[639.949503] Dynamic subtest D-eDP1: SUCCESS (8.628s)
[639.951885] Subtest dpms-off-confusion-interruptible: SUCCESS (34.563s)
[641.116686] [118/155] (382s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[641.202190] Starting subtest: basic-max-pipe-crc-check
[641.206581] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[641.253504] [119/155] (382s left) kms_psr (psr-sprite-render)
[641.350109] Starting subtest: psr-sprite-render
[641.352417] Starting dynamic subtest: eDP-1
[643.130685] Dynamic subtest eDP-1: SUCCESS (1.782s)
[643.132990] Subtest psr-sprite-render: SUCCESS (1.783s)
[643.980071] [120/155] (379s left) gem_exec_suspend (basic-s3-devices)
[644.046979] Starting subtest: basic-S3-devices
[644.049239] Starting dynamic subtest: smem
[654.608711] Dynamic subtest smem: SUCCESS (10.561s)
[654.611657] Subtest basic-S3-devices: SUCCESS (10.563s)
[654.794196] [121/155] (369s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[654.896925] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[664.425235] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.534s)
[664.565749] [122/155] (359s left) dmabuf_sync_file (export-before-signal)
[664.606927] Starting subtest: export-before-signal
[664.609130] Subtest export-before-signal: SUCCESS (0.001s)
[664.661815] [123/155] (359s left) gem_exec_schedule (semaphore-noskip)
[664.732313] Starting subtest: semaphore-noskip
[665.143370] Subtest semaphore-noskip: SUCCESS (0.417s)
[665.496777] [124/155] (358s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[665.593976] Starting subtest: 4-tiled-8bpp-rotate-0
[666.774908] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.181s)
[666.900500] [125/155] (357s left) gem_exec_schedule (implicit-write-read)
[666.977227] Starting subtest: implicit-write-read
[666.978838] Starting dynamic subtest: rcs0
[667.085869] Dynamic subtest rcs0: SUCCESS (0.114s)
[667.097456] Starting dynamic subtest: vcs0
[667.173286] Dynamic subtest vcs0: SUCCESS (0.087s)
[667.185755] Starting dynamic subtest: vcs1
[667.255592] Dynamic subtest vcs1: SUCCESS (0.081s)
[667.266040] Starting dynamic subtest: vecs0
[667.345356] Dynamic subtest vecs0: SUCCESS (0.089s)
[667.361696] Starting dynamic subtest: ccs0
[667.425821] Dynamic subtest ccs0: SUCCESS (0.079s)
[667.428285] Subtest implicit-write-read: SUCCESS (0.455s)
[668.742367] [126/155] (355s left) kms_flip (2x-flip-vs-panning)
[668.835566] Starting subtest: 2x-flip-vs-panning
[668.843400] Subtest 2x-flip-vs-panning: SKIP (0.010s)
[668.970040] [127/155] (355s left) syncobj_timeline (single-wait-all-available-signaled)
[669.017463] Starting subtest: single-wait-all-available-signaled
[669.019778] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[669.133853] [128/155] (355s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[669.226629] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[669.228707] Starting dynamic subtest: pipe-A-eDP-1
[669.290371] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[669.302971] Starting dynamic subtest: pipe-B-eDP-1
[669.361109] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[669.373252] Starting dynamic subtest: pipe-C-eDP-1
[669.430543] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[669.442265] Starting dynamic subtest: pipe-D-eDP-1
[669.499495] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[669.503711] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[671.497473] [129/155] (352s left) gem_lmem_swapping (parallel-random-engines)
[671.538187] Subtest parallel-random-engines: SKIP (0.000s)
[671.584459] [130/155] (352s left) kms_addfb_basic (bad-pitch-32)
[671.638939] Starting subtest: bad-pitch-32
[671.641267] Subtest bad-pitch-32: SUCCESS (0.000s)
[671.778515] [131/155] (352s left) gem_pread (bench)
[671.841289] Subtest bench: SKIP (0.000s)
[671.898824] [132/155] (352s left) kms_cursor_crc (cursor-sliding-64x64)
[672.076084] Starting subtest: cursor-sliding-64x64
[672.081198] Starting dynamic subtest: pipe-A-eDP-1
[675.307382] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.225s)
[675.337712] Starting dynamic subtest: pipe-D-eDP-1
[679.206806] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.877s)
[679.208793] Subtest cursor-sliding-64x64: SUCCESS (7.132s)
[680.056099] [133/155] (344s left) gem_exec_store (basic)
[680.111004] Starting subtest: basic
[680.220139] Subtest basic: SUCCESS (0.110s)
[680.404097] [134/155] (344s left) gem_exec_reloc (basic-wc-cpu-active)
[680.472699] Subtest basic-wc-cpu-active: SKIP (0.000s)
[680.547817] [135/155] (343s left) kms_setmode (invalid-clone-single-crtc-stealing)
[680.616493] Starting subtest: invalid-clone-single-crtc-stealing
[680.623121] Subtest invalid-clone-single-crtc-stealing: SKIP (0.001s)
[680.724351] [136/155] (343s left) gem_exec_params (cliprects-invalid)
[680.778760] Starting subtest: cliprects-invalid
[680.780977] Subtest cliprects-invalid: SUCCESS (0.000s)
[680.884282] [137/155] (343s left) kms_vblank (query-idle-hang)
[680.982164] Starting subtest: query-idle-hang
[680.984108] Starting dynamic subtest: pipe-A-eDP-1
[707.410517] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.429s)
[707.426235] Starting dynamic subtest: pipe-D-eDP-1
[722.441315] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.032s)
[722.443592] Subtest query-idle-hang: SUCCESS (41.465s)
[723.309637] [138/155] (301s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[723.401153] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[723.405272] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[723.501872] [139/155] (301s left) kms_atomic (plane-invalid-params)
[723.587273] Starting subtest: plane-invalid-params
[723.589463] Starting dynamic subtest: pipe-A-eDP-1
[723.982500] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.394s)
[723.984681] Subtest plane-invalid-params: SUCCESS (0.396s)
[724.838521] [140/155] (299s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[724.938977] Starting subtest: y-tiled-32bpp-rotate-90
[724.943446] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[725.064090] [141/155] (299s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-pwrite)
[725.160550] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-pwrite
[725.165058] Subtest psrhdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[725.258589] [142/155] (299s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[725.381242] Starting subtest: basic-flip-before-cursor-atomic
[726.334387] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.951s)
[727.182625] [143/155] (297s left) gem_exec_balancer (full-late)
[727.236512] Starting subtest: full-late
[731.530656] Subtest full-late: SUCCESS (4.294s)
[731.867268] [144/155] (293s left) i915_suspend (forcewake)
[731.931746] Starting subtest: forcewake
[764.018724] Subtest forcewake: SUCCESS (2.215s)
[765.107445] [145/155] (260s left) kms_psr (psr2-cursor-mmap-cpu)
[765.206582] Starting subtest: psr2-cursor-mmap-cpu
[765.209354] Starting dynamic subtest: eDP-1
[766.990871] Dynamic subtest eDP-1: SUCCESS (1.776s)
[766.993506] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.777s)
[767.882591] [146/155] (258s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-onoff)
[767.984112] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-onoff
[767.988983] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[768.106460] [147/155] (257s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[768.205945] Starting subtest: yf-tiled-addfb-size-overflow
[768.211487] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[768.301904] [148/155] (257s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-indfb-plflip-blt)
[768.396959] Starting subtest: psrhdr-2p-primscrn-indfb-plflip-blt
[768.401936] Subtest psrhdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[768.489913] [149/155] (257s left) api_intel_allocator (two-level-inception)
[768.549859] Starting subtest: two-level-inception
[773.965432] Subtest two-level-inception: SUCCESS (5.401s)
[774.094292] [150/155] (252s left) kms_pm_dc (dc9-dpms)
[775.199044] Starting subtest: dc9-dpms
[779.556484] Subtest dc9-dpms: SUCCESS (4.353s)
[779.630953] [151/155] (246s left) gem_wait (write-busy)
[779.692989] Starting subtest: write-busy
[779.695912] Starting dynamic subtest: all-engines
[780.300474] Dynamic subtest all-engines: SUCCESS (0.606s)
[780.319652] Starting dynamic subtest: rcs0
[780.855725] Dynamic subtest rcs0: SUCCESS (0.554s)
[780.874506] Starting dynamic subtest: bcs0
[781.407475] Dynamic subtest bcs0: SUCCESS (0.550s)
[781.426141] Starting dynamic subtest: vcs0
[782.525507] Dynamic subtest vcs0: SUCCESS (1.114s)
[782.543096] Starting dynamic subtest: vcs1
[784.508950] Dynamic subtest vcs1: SUCCESS (1.979s)
[784.528675] Starting dynamic subtest: vecs0
[786.492563] Dynamic subtest vecs0: SUCCESS (1.979s)
[786.511129] Starting dynamic subtest: ccs0
[787.044259] Dynamic subtest ccs0: SUCCESS (0.550s)
[787.047046] Subtest write-busy: SUCCESS (7.345s)
[787.246293] [152/155] (239s left) prime_vgem (basic-fence-blt)
[787.342092] Starting subtest: basic-fence-blt
[787.436403] Subtest basic-fence-blt: SUCCESS (0.094s)
[787.550920] [153/155] (238s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[787.658355] Starting subtest: psr-rgb565-draw-pwrite
[794.789874] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.133s)
[794.892867] [154/155] (231s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-move)
[795.005598] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-move
[795.010960] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[795.106330] [155/155] (231s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[795.210579] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[795.215555] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[795.312616] Closing watchdogs
results: parsing output: 0/ for test: gem_gtt_cpu_tlb
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: perf
results: parsing output: 3/ for test: kms_prop_blob
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_invalid_mode
results: parsing output: 6/ for test: gem_pxp
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: gem_exec_params
results: parsing output: 10/ for test: kms_draw_crc
results: parsing output: 11/ for test: gem_userptr_blits
results: parsing output: 12/ for test: prime_vgem
results: parsing output: 13/ for test: kms_chamelium_hpd
results: parsing output: 14/ for test: kms_sequence
results: parsing output: 15/ for test: gem_ppgtt
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: kms_plane_alpha_blend
results: parsing output: 22/ for test: kms_pm_rpm
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_softpin
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_plane
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: perf
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_chamelium_edid
results: parsing output: 40/ for test: gen9_exec_parse
results: parsing output: 41/ for test: gem_lmem_swapping
results: parsing output: 42/ for test: gem_ctx_shared
results: parsing output: 43/ for test: i915_hangman
results: parsing output: 44/ for test: perf
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_mmap_offset
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_psr2_sf
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_mmap_gtt
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: gem_exec_balancer
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_content_protection
results: parsing output: 55/ for test: gem_exec_flush
results: parsing output: 56/ for test: api_intel_bb
results: parsing output: 57/ for test: syncobj_wait
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_cursor_crc
results: parsing output: 61/ for test: kms_plane_scaling
results: parsing output: 62/ for test: gem_exec_reloc
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: perf_pmu
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_render_copy
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gen7_exec_parse
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: kms_busy
results: parsing output: 73/ for test: kms_chamelium_color
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: kms_plane
results: parsing output: 78/ for test: kms_addfb_basic
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_rotation_crc
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_plane
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: fbdev
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_userptr_blits
results: parsing output: 92/ for test: gem_exec_reloc
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_color
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: core_auth
results: parsing output: 97/ for test: gem_exec_fence
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: gem_ctx_persistence
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: perf_pmu
results: parsing output: 104/ for test: prime_self_import
results: parsing output: 105/ for test: sysfs_preempt_timeout
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_ctx_persistence
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_compute
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_async_flips
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_flip_scaled_crc
results: parsing output: 114/ for test: i915_pm_rpm
results: parsing output: 115/ for test: kms_cursor_crc
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: kms_multipipe_modeset
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: gem_exec_suspend
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: dmabuf_sync_file
results: parsing output: 122/ for test: gem_exec_schedule
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_exec_schedule
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: gem_lmem_swapping
results: parsing output: 129/ for test: kms_addfb_basic
results: parsing output: 130/ for test: gem_pread
results: parsing output: 131/ for test: kms_cursor_crc
results: parsing output: 132/ for test: gem_exec_store
results: parsing output: 133/ for test: gem_exec_reloc
results: parsing output: 134/ for test: kms_setmode
results: parsing output: 135/ for test: gem_exec_params
results: parsing output: 136/ for test: kms_vblank
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_atomic
results: parsing output: 139/ for test: kms_big_fb
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: kms_cursor_legacy
results: parsing output: 142/ for test: gem_exec_balancer
results: parsing output: 143/ for test: i915_suspend
results: parsing output: 144/ for test: kms_psr
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_big_fb
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: api_intel_allocator
results: parsing output: 149/ for test: kms_pm_dc
results: parsing output: 150/ for test: gem_wait
results: parsing output: 151/ for test: prime_vgem
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: kms_frontbuffer_tracking
Done.