[58.281506] Initializing watchdogs
[58.281549]   /dev/watchdog0
[58.295571] [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.300500] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.302845] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.306216] [001/133] (960s left) gem_create (hog-create)
[58.379797] Starting subtest: hog-create
[58.382481] Starting dynamic subtest: smem0
[90.905882] Dynamic subtest smem0: SUCCESS (32.498s)
[90.908918] Subtest hog-create: SUCCESS (32.499s)
[91.097979] [002/133] (927s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[91.167959] Starting subtest: multi-wait-all-available-submitted-signaled
[91.170405] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s)
[91.278202] [003/133] (927s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[91.385522] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[91.389688] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[91.489888] [004/133] (927s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[91.577328] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[91.581649] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[91.680581] [005/133] (927s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[91.775609] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[91.779628] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[91.860856] [006/133] (927s left) kms_pipe_crc_basic (suspend-read-crc)
[91.951934] Starting subtest: suspend-read-crc
[91.953976] Starting dynamic subtest: pipe-A-eDP-1
[109.320330] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.664s)
[109.331824] Starting dynamic subtest: pipe-B-eDP-1
[127.345607] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.140s)
[127.354851] Starting dynamic subtest: pipe-C-eDP-1
[145.310272] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.123s)
[145.319139] Starting dynamic subtest: pipe-D-eDP-1
[163.288457] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.070s)
[163.290446] Subtest suspend-read-crc: SUCCESS (12.001s)
[164.128644] [007/133] (854s left) kms_psr (psr2-basic)
[164.245440] Starting subtest: psr2-basic
[164.247787] Starting dynamic subtest: eDP-1
[165.842766] Dynamic subtest eDP-1: SUCCESS (1.574s)
[165.844949] Subtest psr2-basic: SUCCESS (1.574s)
[166.642588] [008/133] (852s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[166.774830] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[176.127039] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.290s)
[176.940105] [009/133] (842s left) kms_flip (wf_vblank-ts-check)
[177.030744] Starting subtest: wf_vblank-ts-check
[177.033091] Starting dynamic subtest: A-eDP1
[186.001194] Dynamic subtest A-eDP1: SUCCESS (8.951s)
[186.009503] Starting dynamic subtest: B-eDP1
[194.943060] Dynamic subtest B-eDP1: SUCCESS (8.934s)
[194.953231] Starting dynamic subtest: C-eDP1
[203.858852] Dynamic subtest C-eDP1: SUCCESS (8.917s)
[203.869007] Starting dynamic subtest: D-eDP1
[212.791082] Dynamic subtest D-eDP1: SUCCESS (8.931s)
[212.795896] Subtest wf_vblank-ts-check: SUCCESS (35.742s)
[214.018414] [010/133] (805s left) kms_big_fb (y-tiled-addfb-size-overflow)
[214.133457] Starting subtest: y-tiled-addfb-size-overflow
[214.137640] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[214.218985] [011/133] (804s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[214.304967] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[214.307259] Starting dynamic subtest: pipe-A-eDP-1
[214.332665] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[214.343434] Starting dynamic subtest: pipe-B-eDP-1
[214.366910] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[214.374446] Starting dynamic subtest: pipe-C-eDP-1
[214.398352] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[214.406050] Starting dynamic subtest: pipe-D-eDP-1
[214.429979] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[214.434361] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[216.564815] [012/133] (802s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[216.663282] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[216.667742] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[216.773711] [013/133] (802s left) gem_eio (hibernate)
[217.007812] Starting subtest: hibernate
[231.658985] Subtest hibernate: SUCCESS (14.646s)
[240.827912] [014/133] (787s left) kms_psr (fbc-pr-primary-mmap-gtt)
[240.943637] Starting subtest: fbc-pr-primary-mmap-gtt
[240.947822] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[241.014316] [015/133] (787s left) kms_plane_cursor (viewport)
[241.106216] Starting subtest: viewport
[241.110878] Starting dynamic subtest: pipe-A-eDP-1-size-64
[243.626965] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.522s)
[243.687019] Starting dynamic subtest: pipe-A-eDP-1-size-128
[246.271905] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.594s)
[246.331563] Starting dynamic subtest: pipe-A-eDP-1-size-256
[248.850965] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.527s)
[249.211128] Starting dynamic subtest: pipe-B-eDP-1-size-64
[252.460906] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.259s)
[252.521606] Starting dynamic subtest: pipe-B-eDP-1-size-128
[255.140452] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.627s)
[255.201000] Starting dynamic subtest: pipe-B-eDP-1-size-256
[257.908322] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.715s)
[258.269091] Starting dynamic subtest: pipe-C-eDP-1-size-64
[261.157917] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.899s)
[261.196420] Starting dynamic subtest: pipe-C-eDP-1-size-128
[263.381019] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.191s)
[263.419166] Starting dynamic subtest: pipe-C-eDP-1-size-256
[265.658995] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.247s)
[265.987220] Starting dynamic subtest: pipe-D-eDP-1-size-64
[268.919244] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.943s)
[268.957902] Starting dynamic subtest: pipe-D-eDP-1-size-128
[271.153055] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.203s)
[271.191909] Starting dynamic subtest: pipe-D-eDP-1-size-256
[273.375935] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.191s)
[273.696893] Subtest viewport: SUCCESS (32.586s)
[274.551585] [016/133] (753s left) i915_pm_rpm (gem-execbuf)
[276.300051] Starting subtest: gem-execbuf
[276.303152] Starting dynamic subtest: smem0
[278.551143] Dynamic subtest smem0: SUCCESS (2.249s)
[278.553183] Subtest gem-execbuf: SUCCESS (2.250s)
[278.634377] [017/133] (749s left) dmabuf_sync_file (export-multiwait)
[278.749821] Starting subtest: export-multiwait
[278.752020] Subtest export-multiwait: SUCCESS (0.002s)
[278.800618] [FACT dmabuf_sync_file (export-multiwait)] new: kernel.kmod_is_loaded.vgem: true
[278.804334] [018/133] (749s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[278.906171] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[278.910731] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[278.989039] [019/133] (749s left) i915_query (query-topology-unsupported)
[279.050642] Starting subtest: query-topology-unsupported
[279.055308] Subtest query-topology-unsupported: SKIP (0.000s)
[279.171126] [020/133] (749s left) perf_pmu (semaphore-wait-idle)
[279.214813] Starting subtest: semaphore-wait-idle
[279.216784] Starting dynamic subtest: rcs0
[279.729392] Dynamic subtest rcs0: SUCCESS (0.514s)
[279.742101] Starting dynamic subtest: bcs0
[280.244699] Dynamic subtest bcs0: SUCCESS (0.513s)
[280.257783] Starting dynamic subtest: vcs0
[280.759391] Dynamic subtest vcs0: SUCCESS (0.511s)
[280.772473] Starting dynamic subtest: vcs1
[281.273215] Dynamic subtest vcs1: SUCCESS (0.511s)
[281.285807] Starting dynamic subtest: vecs0
[281.786913] Dynamic subtest vecs0: SUCCESS (0.510s)
[281.800486] Starting dynamic subtest: ccs0
[282.303411] Dynamic subtest ccs0: SUCCESS (0.512s)
[282.306818] Subtest semaphore-wait-idle: SUCCESS (3.090s)
[282.435185] [021/133] (746s left) gem_mmap_wc (write-cpu-read-wc)
[282.508056] Subtest write-cpu-read-wc: SKIP (0.000s)
[282.569800] [022/133] (746s left) kms_properties (plane-properties-atomic)
[282.665665] Starting subtest: plane-properties-atomic
[282.668023] Starting dynamic subtest: pipe-A-eDP-1
[283.212261] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.546s)
[283.223096] Starting dynamic subtest: pipe-B-eDP-1
[284.490167] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.274s)
[284.500464] Starting dynamic subtest: pipe-C-eDP-1
[285.807337] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.316s)
[285.818290] Starting dynamic subtest: pipe-D-eDP-1
[287.041037] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s)
[287.043367] Subtest plane-properties-atomic: SUCCESS (4.375s)
[287.837174] [023/133] (740s left) perf (buffer-fill)
[287.976698] Starting subtest: buffer-fill
[287.978688] Starting dynamic subtest: 0-rcs0
[290.218732] Dynamic subtest 0-rcs0: SUCCESS (2.242s)
[290.230130] Starting dynamic subtest: 1-vcs1
[294.650330] Dynamic subtest 1-vcs1: SUCCESS (4.429s)
[294.653064] Subtest buffer-fill: SUCCESS (6.674s)
[294.701183] [024/133] (734s left) kms_content_protection (legacy)
[294.849475] Starting subtest: legacy
[294.854080] Subtest legacy: SKIP (0.000s)
[294.985869] [025/133] (733s left) perf_pmu (busy)
[295.032738] Starting subtest: busy
[295.035159] Starting dynamic subtest: rcs0
[295.612765] Dynamic subtest rcs0: SUCCESS (0.581s)
[295.625396] Starting dynamic subtest: bcs0
[296.170700] Dynamic subtest bcs0: SUCCESS (0.555s)
[296.183210] Starting dynamic subtest: vcs0
[298.113871] Dynamic subtest vcs0: SUCCESS (1.938s)
[298.129937] Starting dynamic subtest: vcs1
[300.033986] Dynamic subtest vcs1: SUCCESS (1.917s)
[300.046976] Starting dynamic subtest: vecs0
[302.082121] Dynamic subtest vecs0: SUCCESS (2.044s)
[302.101661] Starting dynamic subtest: ccs0
[302.660478] Dynamic subtest ccs0: SUCCESS (0.576s)
[302.663439] Subtest busy: SUCCESS (7.629s)
[302.781895] [026/133] (726s left) gem_sync (basic-store-each)
[302.851640] Starting subtest: basic-store-each
[305.436413] Subtest basic-store-each: SUCCESS (2.594s)
[305.628083] [027/133] (723s left) kms_properties (invalid-properties-legacy)
[305.738626] Starting subtest: invalid-properties-legacy
[305.846577] Subtest invalid-properties-legacy: SUCCESS (0.108s)
[305.923419] [028/133] (723s left) perf_pmu (init-sema)
[305.969879] Starting subtest: init-sema
[305.972258] Starting dynamic subtest: rcs0
[305.974542] Dynamic subtest rcs0: SUCCESS (0.001s)
[305.985796] Starting dynamic subtest: bcs0
[305.988048] Dynamic subtest bcs0: SUCCESS (0.000s)
[305.997585] Starting dynamic subtest: vcs0
[305.999996] Dynamic subtest vcs0: SUCCESS (0.001s)
[306.009498] Starting dynamic subtest: vcs1
[306.011768] Dynamic subtest vcs1: SUCCESS (0.000s)
[306.021052] Starting dynamic subtest: vecs0
[306.023290] Dynamic subtest vecs0: SUCCESS (0.001s)
[306.032783] Starting dynamic subtest: ccs0
[306.035128] Dynamic subtest ccs0: SUCCESS (0.000s)
[306.037339] Subtest init-sema: SUCCESS (0.007s)
[306.091036] [029/133] (722s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[306.144132] Starting subtest: mixed-tiled-to-y-tiled-ccs
[306.148523] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[306.332857] [030/133] (722s left) gem_close (many-handles-one-vma)
[306.390332] Starting subtest: many-handles-one-vma
[306.411684] Subtest many-handles-one-vma: SUCCESS (0.021s)
[306.506600] [031/133] (722s left) gem_partial_pwrite_pread (reads-uncached)
[306.568281] Subtest reads-uncached: SKIP (0.000s)
[306.659280] [032/133] (722s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[306.767010] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[306.771495] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[306.867373] [033/133] (722s left) gem_mmap_gtt (pf-nonblock)
[306.935842] Subtest pf-nonblock: SKIP (0.000s)
[307.011045] [034/133] (722s left) kms_color (ctm-0-75)
[307.100459] Starting subtest: ctm-0-75
[307.102637] Starting dynamic subtest: pipe-A-eDP-1
[312.001657] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.901s)
[312.011921] Starting dynamic subtest: pipe-B-eDP-1
[317.682924] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.676s)
[317.693270] Starting dynamic subtest: pipe-C-eDP-1
[323.041714] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.359s)
[323.052264] Starting dynamic subtest: pipe-D-eDP-1
[328.369305] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.323s)
[328.371452] Subtest ctm-0-75: SUCCESS (21.262s)
[329.211742] [035/133] (700s left) kms_psr (psr-sprite-blt)
[329.312394] Starting subtest: psr-sprite-blt
[329.314620] Starting dynamic subtest: eDP-1
[331.035219] Dynamic subtest eDP-1: SUCCESS (1.722s)
[331.037626] Subtest psr-sprite-blt: SUCCESS (1.723s)
[331.873969] [036/133] (697s left) kms_flip (absolute-wf_vblank-interruptible)
[331.965501] Starting subtest: absolute-wf_vblank-interruptible
[331.967764] Starting dynamic subtest: A-eDP1
[340.727890] Dynamic subtest A-eDP1: SUCCESS (8.758s)
[340.738138] Starting dynamic subtest: B-eDP1
[349.464456] Dynamic subtest B-eDP1: SUCCESS (8.732s)
[349.478417] Starting dynamic subtest: C-eDP1
[358.177645] Dynamic subtest C-eDP1: SUCCESS (8.708s)
[358.187818] Starting dynamic subtest: D-eDP1
[366.904456] Dynamic subtest D-eDP1: SUCCESS (8.723s)
[366.909909] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.931s)
[368.138055] [037/133] (661s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[368.236166] Starting subtest: psr-rgb565-draw-render
[375.253934] Subtest psr-rgb565-draw-render: SUCCESS (7.019s)
[375.381344] [038/133] (653s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[375.506782] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[375.510858] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[375.610659] [039/133] (653s left) gem_exec_reloc (basic-cpu-read-active)
[375.675729] Subtest basic-cpu-read-active: SKIP (0.000s)
[375.752492] [040/133] (653s left) i915_hangman (gt-error-state-capture)
[375.816514] Starting subtest: gt-error-state-capture
[375.818494] Starting dynamic subtest: rcs0
[387.040474] Dynamic subtest rcs0: SUCCESS (11.220s)
[387.059812] Starting dynamic subtest: bcs0
[399.072140] Dynamic subtest bcs0: SUCCESS (12.025s)
[399.085639] Starting dynamic subtest: vcs0
[410.016522] Dynamic subtest vcs0: SUCCESS (10.938s)
[410.037862] Starting dynamic subtest: vcs1
[421.984223] Dynamic subtest vcs1: SUCCESS (11.960s)
[422.004334] Starting dynamic subtest: vecs0
[432.032239] Dynamic subtest vecs0: SUCCESS (10.041s)
[432.045542] Starting dynamic subtest: ccs0
[444.063732] Dynamic subtest ccs0: SUCCESS (12.024s)
[444.066744] Subtest gt-error-state-capture: SUCCESS (68.225s)
[444.197944] [041/133] (585s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[444.259755] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[444.264350] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[444.449048] [042/133] (585s left) syncobj_wait (wait-zero-handles)
[444.502252] Starting subtest: wait-zero-handles
[444.504598] Subtest wait-zero-handles: SUCCESS (0.000s)
[444.613383] [043/133] (584s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[444.716188] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[451.347840] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.632s)
[451.501096] [044/133] (578s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[451.783303] Starting subtest: cursor-rapid-movement-256x256
[451.785467] Starting dynamic subtest: pipe-A-eDP-1
[452.349512] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s)
[452.380392] Starting dynamic subtest: pipe-D-eDP-1
[453.583073] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.211s)
[453.585396] Subtest cursor-rapid-movement-256x256: SUCCESS (1.801s)
[454.443019] [045/133] (575s left) gem_ctx_persistence (legacy-engines-hang)
[454.500596] Starting subtest: legacy-engines-hang
[454.502827] Starting dynamic subtest: render
[454.567565] Dynamic subtest render: SUCCESS (0.066s)
[454.583635] Starting dynamic subtest: bsd1
[454.672399] Dynamic subtest bsd1: SUCCESS (0.103s)
[454.688727] Starting dynamic subtest: bsd2
[454.758247] Dynamic subtest bsd2: SUCCESS (0.083s)
[454.770546] Starting dynamic subtest: blt
[454.852548] Dynamic subtest blt: SUCCESS (0.092s)
[454.865242] Starting dynamic subtest: vebox
[454.949199] Dynamic subtest vebox: SUCCESS (0.094s)
[454.951567] Subtest legacy-engines-hang: SUCCESS (0.450s)
[455.031053] [046/133] (574s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[455.130442] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[455.135027] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[456.275901] [047/133] (573s left) kms_invalid_mode (zero-clock)
[456.364864] Starting subtest: zero-clock
[456.367323] Starting dynamic subtest: pipe-A-eDP-1
[456.651452] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[456.662246] Starting dynamic subtest: pipe-B-eDP-1
[456.664644] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[456.674363] Starting dynamic subtest: pipe-C-eDP-1
[456.676315] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[456.685971] Starting dynamic subtest: pipe-D-eDP-1
[456.688226] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[456.690604] Subtest zero-clock: SUCCESS (0.291s)
[457.525126] [048/133] (572s left) gem_exec_balancer (parallel-balancer)
[457.806303] Starting subtest: parallel-balancer
[458.721085] Subtest parallel-balancer: SUCCESS (0.917s)
[458.816869] [049/133] (571s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[458.912230] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[465.957936] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.045s)
[466.063104] [050/133] (563s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[466.170314] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[466.174767] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[466.273278] [051/133] (563s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[466.375821] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[466.378112] Starting dynamic subtest: pipe-A
[466.402068] Dynamic subtest pipe-A: SKIP (0.019s)
[466.412354] Starting dynamic subtest: pipe-B
[466.432832] Dynamic subtest pipe-B: SKIP (0.032s)
[466.443915] Starting dynamic subtest: pipe-C
[466.464051] Dynamic subtest pipe-C: SKIP (0.032s)
[466.473939] Starting dynamic subtest: pipe-D
[466.498392] Dynamic subtest pipe-D: SKIP (0.032s)
[466.502352] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.119s)
[466.594385] [052/133] (563s left) gem_basic (create-close)
[466.651371] Starting subtest: create-close
[466.655888] Subtest create-close: SUCCESS (0.000s)
[466.738459] [053/133] (563s left) vgem_basic (sysfs)
[466.785314] Starting subtest: sysfs
[466.787485] Subtest sysfs: SUCCESS (0.000s)
[466.844878] [054/133] (563s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[466.931090] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[466.933075] Starting dynamic subtest: pipe-A-eDP-1
[466.952634] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[466.964821] Starting dynamic subtest: pipe-B-eDP-1
[466.982535] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[466.992098] Starting dynamic subtest: pipe-C-eDP-1
[467.009810] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[467.020833] Starting dynamic subtest: pipe-D-eDP-1
[467.038906] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[467.042267] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[469.107365] [055/133] (561s left) gem_exec_reloc (basic-write-read)
[469.170405] Subtest basic-write-read: SKIP (0.000s)
[469.248629] [056/133] (560s left) kms_psr (fbc-pr-basic)
[469.337707] Starting subtest: fbc-pr-basic
[469.342189] Subtest fbc-pr-basic: SKIP (0.000s)
[469.412530] [057/133] (560s left) kms_addfb_basic (bad-pitch-256)
[469.474733] Starting subtest: bad-pitch-256
[469.477038] Subtest bad-pitch-256: SUCCESS (0.000s)
[469.637249] [058/133] (560s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[469.697966] Starting subtest: etime-multi-wait-available-unsubmitted
[469.806023] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.107s)
[469.898805] [059/133] (560s left) kms_vblank (wait-busy)
[469.994661] Starting subtest: wait-busy
[469.996893] Starting dynamic subtest: pipe-A-eDP-1
[471.881810] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.885s)
[471.897120] Starting dynamic subtest: pipe-D-eDP-1
[474.464337] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.578s)
[474.466313] Subtest wait-busy: SUCCESS (4.467s)
[475.264498] [060/133] (555s left) kms_atomic_interruptible (legacy-pageflip)
[475.357436] Starting subtest: legacy-pageflip
[475.359751] Starting dynamic subtest: pipe-A-eDP-1
[482.807216] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.443s)
[482.809359] Subtest legacy-pageflip: SUCCESS (7.445s)
[483.629446] [061/133] (546s left) gem_softpin (reverse)
[483.697265] Starting subtest: reverse
[483.704141] Subtest reverse: SUCCESS (0.007s)
[483.829971] [062/133] (546s left) gem_tiled_pread_pwrite
[483.951261] [063/133] (546s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[484.033008] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[484.034986] Starting dynamic subtest: pipe-A-eDP-1
[484.177194] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.135s)
[484.189924] Starting dynamic subtest: pipe-B-eDP-1
[484.209550] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[484.219351] Starting dynamic subtest: pipe-C-eDP-1
[484.238850] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[484.248371] Starting dynamic subtest: pipe-D-eDP-1
[484.267743] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[484.269605] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.144s)
[486.492129] [064/133] (544s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[486.584623] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[486.589128] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[486.675164] [065/133] (543s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[486.774764] Starting subtest: x-tiled-32bpp-rotate-270
[486.797000] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[486.909523] [066/133] (543s left) kms_atomic (plane-overlay-legacy)
[487.005516] Starting subtest: plane-overlay-legacy
[487.007756] Starting dynamic subtest: pipe-A-eDP-1
[487.419252] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.413s)
[487.421650] Subtest plane-overlay-legacy: SUCCESS (0.415s)
[488.219716] [067/133] (542s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[488.318428] Starting subtest: fb-8bpc-vs-panel-8bpc
[488.320737] Starting dynamic subtest: pipe-A-eDP-1
[489.687432] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.369s)
[489.689899] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.371s)
[490.489652] [068/133] (540s left) kms_properties (crtc-properties-atomic)
[490.580685] Starting subtest: crtc-properties-atomic
[490.582960] Starting dynamic subtest: pipe-A-eDP-1
[491.016879] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.434s)
[491.027506] Starting dynamic subtest: pipe-B-eDP-1
[492.136402] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.119s)
[492.154237] Starting dynamic subtest: pipe-C-eDP-1
[493.263410] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.125s)
[493.275039] Starting dynamic subtest: pipe-D-eDP-1
[494.405009] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.139s)
[494.407256] Subtest crtc-properties-atomic: SUCCESS (3.823s)
[495.210211] [069/133] (535s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[495.305385] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[502.177609] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.883s)
[502.291273] [070/133] (528s left) gem_exec_parallel (fds)
[502.363827] Starting subtest: fds
[502.366298] Starting dynamic subtest: rcs0
[504.924738] Dynamic subtest rcs0: SUCCESS (2.562s)
[504.935252] Starting dynamic subtest: bcs0
[508.731930] Dynamic subtest bcs0: SUCCESS (3.809s)
[508.745420] Starting dynamic subtest: vcs0
[512.561988] Dynamic subtest vcs0: SUCCESS (3.833s)
[512.575132] Starting dynamic subtest: vcs1
[518.145738] Dynamic subtest vcs1: SUCCESS (5.586s)
[518.160649] Starting dynamic subtest: vecs0
[522.300534] Dynamic subtest vecs0: SUCCESS (4.155s)
[522.312740] Starting dynamic subtest: ccs0
[526.597759] Dynamic subtest ccs0: SUCCESS (4.298s)
[526.599962] Subtest fds: SUCCESS (24.254s)
[526.792948] [071/133] (504s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[526.888329] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[534.438656] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.558s)
[534.622844] [072/133] (496s left) gem_exec_store (cachelines)
[534.694370] Starting subtest: cachelines
[534.696648] Starting dynamic subtest: rcs0
[534.762014] Dynamic subtest rcs0: SUCCESS (0.068s)
[534.774823] Starting dynamic subtest: bcs0
[534.821380] Dynamic subtest bcs0: SUCCESS (0.058s)
[534.833704] Starting dynamic subtest: vcs0
[534.868877] Dynamic subtest vcs0: SUCCESS (0.046s)
[534.879946] Starting dynamic subtest: vcs1
[534.920258] Dynamic subtest vcs1: SUCCESS (0.049s)
[534.931875] Starting dynamic subtest: vecs0
[534.974038] Dynamic subtest vecs0: SUCCESS (0.052s)
[534.988702] Starting dynamic subtest: ccs0
[535.026996] Dynamic subtest ccs0: SUCCESS (0.052s)
[535.029605] Subtest cachelines: SUCCESS (0.336s)
[535.213864] [073/133] (495s left) gem_exec_reloc (basic-write-wc-active)
[535.267710] Subtest basic-write-wc-active: SKIP (0.000s)
[535.350217] [074/133] (495s left) kms_lease (empty-lease)
[535.434869] Starting subtest: empty-lease
[535.437146] Starting dynamic subtest: pipe-A-eDP-1
[535.439379] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[535.450352] Starting dynamic subtest: pipe-B-eDP-1
[535.452563] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[535.462732] Starting dynamic subtest: pipe-C-eDP-1
[535.464944] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[535.475174] Starting dynamic subtest: pipe-D-eDP-1
[535.477294] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[535.479396] Subtest empty-lease: SUCCESS (0.009s)
[535.554623] [075/133] (495s left) gem_exec_balancer (parallel-keep-submit-fence)
[535.813629] Starting subtest: parallel-keep-submit-fence
[537.059159] Subtest parallel-keep-submit-fence: SUCCESS (1.246s)
[537.178173] [076/133] (493s left) kms_psr (psr2-primary-blt)
[537.281594] Starting subtest: psr2-primary-blt
[537.283840] Starting dynamic subtest: eDP-1
[539.003661] Dynamic subtest eDP-1: SUCCESS (1.722s)
[539.006253] Subtest psr2-primary-blt: SUCCESS (1.723s)
[539.875211] [077/133] (491s left) api_intel_allocator (execbuf-with-allocator)
[539.925516] Starting subtest: execbuf-with-allocator
[539.929841] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[540.076456] [078/133] (491s left) kms_sequence (get-busy)
[540.166716] Starting subtest: get-busy
[540.168638] Starting dynamic subtest: pipe-A-eDP-1
[542.098196] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.933s)
[542.109515] Starting dynamic subtest: pipe-B-eDP-1
[544.667642] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.568s)
[544.678450] Starting dynamic subtest: pipe-C-eDP-1
[547.281345] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.616s)
[547.292187] Starting dynamic subtest: pipe-D-eDP-1
[549.820244] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.535s)
[549.822340] Subtest get-busy: SUCCESS (9.658s)
[550.611508] [079/133] (480s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[550.708341] Starting subtest: fbc-psr2-sprite-mmap-gtt
[550.710473] Starting dynamic subtest: eDP-1
[550.714445] Dynamic subtest eDP-1: SKIP (0.000s)
[550.718463] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[550.783298] [080/133] (480s left) gem_exec_schedule (u-fairslice-all)
[550.857571] Starting subtest: u-fairslice-all
[552.917235] Subtest u-fairslice-all: SUCCESS (2.063s)
[553.213377] [081/133] (478s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[553.311335] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[562.655227] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.348s)
[562.780731] [082/133] (468s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[562.869623] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[562.896545] Starting dynamic subtest: pipe-A-plane-0
[563.184987] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[563.196026] Starting dynamic subtest: pipe-A-plane-3
[563.418473] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[564.525215] Starting dynamic subtest: pipe-B-plane-0
[564.827274] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[564.843274] Starting dynamic subtest: pipe-B-plane-3
[565.059883] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[565.377320] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.508s)
[566.198210] [083/133] (465s left) syncobj_basic (bad-destroy)
[566.249145] Starting subtest: bad-destroy
[566.251107] Subtest bad-destroy: SUCCESS (0.000s)
[566.370881] [084/133] (465s left) api_intel_bb (delta-check)
[566.427270] Starting subtest: delta-check
[566.429527] Subtest delta-check: SUCCESS (0.005s)
[566.559449] [085/133] (464s left) kms_busy (extended-modeset-hang-newfb)
[566.659812] Starting subtest: extended-modeset-hang-newfb
[566.662180] Starting dynamic subtest: pipe-A
[600.993470] Dynamic subtest pipe-A: SUCCESS (34.339s)
[601.004646] Starting dynamic subtest: pipe-D
[624.010339] Dynamic subtest pipe-D: SUCCESS (23.014s)
[624.012710] Subtest extended-modeset-hang-newfb: SUCCESS (57.358s)
[624.803109] [086/133] (406s left) kms_feature_discovery (display)
[624.913468] Starting subtest: display
[624.915741] Subtest display: SUCCESS (0.000s)
[624.991458] [087/133] (406s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[625.079571] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[625.084067] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[626.232707] [088/133] (405s left) syncobj_timeline (reset-unsignaled)
[626.291160] Starting subtest: reset-unsignaled
[626.293518] Subtest reset-unsignaled: SUCCESS (0.000s)
[626.406540] [089/133] (405s left) perf_pmu (all-busy-idle-check-all)
[626.454710] Starting subtest: all-busy-idle-check-all
[628.098123] Subtest all-busy-idle-check-all: SUCCESS (1.646s)
[628.216637] [090/133] (403s left) gem_exec_fence (syncobj-timeline-wait)
[628.818538] Starting subtest: syncobj-timeline-wait
[630.103713] Subtest syncobj-timeline-wait: SUCCESS (1.285s)
[632.157294] [091/133] (399s left) gem_exec_params (sol-reset-not-gen7)
[632.209154] Starting subtest: sol-reset-not-gen7
[632.216164] Subtest sol-reset-not-gen7: SUCCESS (0.005s)
[632.305975] [092/133] (399s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[632.415586] Starting subtest: 4-tiled-64bpp-rotate-180
[634.089196] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.673s)
[634.273184] [093/133] (397s left) i915_suspend (debugfs-reader)
[634.323241] Starting subtest: debugfs-reader
[654.673485] Subtest debugfs-reader: SUCCESS (5.423s)
[662.907581] [094/133] (377s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[663.037466] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[663.041657] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[663.110093] [095/133] (377s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[663.222957] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[664.254569] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.011s)
[664.372370] [096/133] (375s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[664.763306] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[665.633873] [097/133] (374s left) gem_exec_schedule (preempt-queue-contexts)
[665.712281] Subtest preempt-queue-contexts: SKIP (0.000s)
[666.030133] [098/133] (374s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[666.088505] Starting subtest: wait-all-for-submit-delayed-submit
[666.192061] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[666.290374] [099/133] (374s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[666.676226] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[667.490162] [100/133] (372s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[667.588326] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[671.607672] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (3.986s)
[672.750332] [101/133] (367s left) gem_mmap (bad-size)
[672.807377] Subtest bad-size: SKIP (0.000s)
[672.871074] [102/133] (367s left) gem_ctx_isolation (nonpriv)
[672.936345] Starting subtest: nonpriv
[672.938607] Starting dynamic subtest: rcs0
[673.166057] Dynamic subtest rcs0: SUCCESS (0.228s)
[673.179760] Starting dynamic subtest: bcs0
[673.406334] Dynamic subtest bcs0: SUCCESS (0.238s)
[673.419443] Starting dynamic subtest: vcs0
[673.644225] Dynamic subtest vcs0: SUCCESS (0.235s)
[673.657326] Starting dynamic subtest: vcs1
[675.235761] Dynamic subtest vcs1: SUCCESS (1.583s)
[675.248038] Starting dynamic subtest: vecs0
[677.257416] Dynamic subtest vecs0: SUCCESS (2.012s)
[677.273546] Starting dynamic subtest: ccs0
[679.268346] Dynamic subtest ccs0: SUCCESS (2.004s)
[679.270835] Subtest nonpriv: SUCCESS (6.306s)
[679.514989] [103/133] (360s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[679.625474] Starting subtest: yf-tiled-8bpp-rotate-0
[679.629768] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[679.739461] [104/133] (360s left) kms_pm_rpm (system-suspend-modeset)
[681.264585] Starting subtest: system-suspend-modeset
[703.771924] Subtest system-suspend-modeset: SUCCESS (7.429s)
[704.189810] [105/133] (336s left) syncobj_eventfd (binary-wait-before-signal)
[704.244451] Starting subtest: binary-wait-before-signal
[704.273992] Subtest binary-wait-before-signal: SUCCESS (0.030s)
[704.356351] [106/133] (336s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[704.449976] Starting subtest: pr-cursor-plane-update-sf
[704.454253] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[704.524879] [107/133] (336s left) gem_userptr_blits (unsync-unmap-after-close)
[704.593053] Subtest unsync-unmap-after-close: SKIP (0.000s)
[704.721446] [108/133] (336s left) kms_cursor_crc (cursor-offscreen-256x256)
[704.984629] Starting subtest: cursor-offscreen-256x256
[704.994667] Starting dynamic subtest: pipe-A-eDP-1
[706.983979] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.962s)
[707.020131] Starting dynamic subtest: pipe-D-eDP-1
[709.633667] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.594s)
[709.635953] Subtest cursor-offscreen-256x256: SUCCESS (4.593s)
[710.507900] [109/133] (330s left) gem_busy (semaphore)
[710.698036] Subtest semaphore: SKIP (0.000s)
[710.915637] [110/133] (329s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[711.009091] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[711.011240] Starting dynamic subtest: pipe-A
[712.243295] Dynamic subtest pipe-A: SUCCESS (1.228s)
[712.255079] Starting dynamic subtest: pipe-B
[714.525974] Dynamic subtest pipe-B: SUCCESS (2.269s)
[714.536868] Starting dynamic subtest: pipe-C
[715.740268] Dynamic subtest pipe-C: SUCCESS (1.205s)
[715.752283] Starting dynamic subtest: pipe-D
[716.968645] Dynamic subtest pipe-D: SUCCESS (1.226s)
[716.971026] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.932s)
[718.172306] [111/133] (322s left) gem_exec_fence (syncobj-export)
[718.611274] Starting subtest: syncobj-export
[718.621339] Subtest syncobj-export: SUCCESS (0.011s)
[720.206557] [112/133] (320s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[720.304142] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[727.088977] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.775s)
[727.204613] [113/133] (313s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[727.338904] Starting subtest: cursorB-vs-flipB-varying-size
[727.343423] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[727.485785] [114/133] (313s left) gen9_exec_parse (cmd-crossing-page)
[727.549059] Subtest cmd-crossing-page: SKIP (0.000s)
[727.627075] [115/133] (313s left) gem_wait (write-busy)
[727.693182] Starting subtest: write-busy
[727.695575] Starting dynamic subtest: all-engines
[728.279170] Dynamic subtest all-engines: SUCCESS (0.585s)
[728.301411] Starting dynamic subtest: rcs0
[728.828247] Dynamic subtest rcs0: SUCCESS (0.547s)
[728.845911] Starting dynamic subtest: bcs0
[729.375238] Dynamic subtest bcs0: SUCCESS (0.545s)
[729.392336] Starting dynamic subtest: vcs0
[731.040017] Dynamic subtest vcs0: SUCCESS (1.661s)
[731.058313] Starting dynamic subtest: vcs1
[733.087207] Dynamic subtest vcs1: SUCCESS (2.043s)
[733.105237] Starting dynamic subtest: vecs0
[735.072509] Dynamic subtest vecs0: SUCCESS (1.981s)
[735.091352] Starting dynamic subtest: ccs0
[735.622828] Dynamic subtest ccs0: SUCCESS (0.549s)
[735.625224] Subtest write-busy: SUCCESS (7.924s)
[735.871495] [116/133] (305s left) gem_lmem_swapping (parallel-multi)
[735.923617] Subtest parallel-multi: SKIP (0.000s)
[735.971587] [117/133] (305s left) gem_userptr_blits (dmabuf-sync)
[736.032430] Starting subtest: dmabuf-sync
[736.036758] Subtest dmabuf-sync: SKIP (0.002s)
[736.182237] [118/133] (305s left) gem_pxp (create-regular-buffer)
[736.305222] Starting subtest: create-regular-buffer
[736.307749] Subtest create-regular-buffer: SUCCESS (0.000s)
[736.414739] [119/133] (304s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[736.500362] Starting subtest: plane-primary-toggle-with-vblank-wait
[736.502710] Starting dynamic subtest: pipe-A-eDP-1
[736.673715] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[736.995875] Starting dynamic subtest: pipe-B-eDP-1
[737.926971] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.942s)
[738.229250] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.728s)
[739.100517] [120/133] (302s left) gem_userptr_blits (unsync-overlap)
[739.169791] Subtest unsync-overlap: SKIP (0.000s)
[739.302863] [121/133] (302s left) kms_cursor_crc (cursor-sliding-32x32)
[739.462240] Starting subtest: cursor-sliding-32x32
[739.513097] Subtest cursor-sliding-32x32: SKIP (0.044s)
[739.796107] [122/133] (301s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[739.894084] Starting subtest: yf-tiled-32bpp-rotate-180
[739.898363] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[739.995815] [123/133] (301s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[742.226123] Starting subtest: dpms-mode-unset-lpsp
[746.273258] Subtest dpms-mode-unset-lpsp: SUCCESS (4.051s)
[746.650949] [124/133] (294s left) i915_drm_fdinfo (memory-info-purgeable)
[746.690596] Starting subtest: memory-info-purgeable
[746.692937] Starting dynamic subtest: smem0
[749.180740] Dynamic subtest smem0: SUCCESS (2.492s)
[749.182850] Subtest memory-info-purgeable: SUCCESS (2.493s)
[749.264139] [125/133] (292s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[749.371122] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[756.287247] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.916s)
[756.426798] [126/133] (285s left) kms_getfb (getfb-addfb-different-handles)
[756.532564] Starting subtest: getfb-addfb-different-handles
[756.534726] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[756.642202] [127/133] (284s left) kms_async_flips (async-flip-hang)
[756.737395] Starting subtest: async-flip-hang
[757.122049] Starting dynamic subtest: pipe-A-eDP-1
[783.546687] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.415s)
[783.922159] Starting dynamic subtest: pipe-B-eDP-1
[799.552398] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.632s)
[799.941425] Starting dynamic subtest: pipe-C-eDP-1
[815.544587] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.616s)
[815.918835] Starting dynamic subtest: pipe-D-eDP-1
[831.546856] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.636s)
[831.549522] Subtest async-flip-hang: SUCCESS (74.801s)
[832.744196] [128/133] (208s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[832.861489] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[832.865916] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[832.955421] [129/133] (208s left) kms_frontbuffer_tracking (basic)
[833.049472] Starting subtest: basic
[836.288969] Subtest basic: SUCCESS (3.246s)
[836.408621] [130/133] (205s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[836.508713] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[836.512128] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[836.596697] [131/133] (205s left) prime_vgem (basic-fence-read)
[836.678349] Starting subtest: basic-fence-read
[836.690186] Subtest basic-fence-read: SKIP (0.009s)
[836.815326] [132/133] (205s left) gem_ctx_sseu (invalid-sseu)
[836.890164] Subtest invalid-sseu: SKIP (0.000s)
[836.962119] [133/133] (204s left) kms_properties (get_properties-sanity-atomic)
[837.051008] Starting subtest: get_properties-sanity-atomic
[837.052994] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[837.129942] Closing watchdogs
results: parsing output: 0/ for test: gem_create
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_flip_scaled_crc
results: parsing output: 5/ for test: kms_pipe_crc_basic
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: kms_flip
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_eio
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_plane_cursor
results: parsing output: 15/ for test: i915_pm_rpm
results: parsing output: 16/ for test: dmabuf_sync_file
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: i915_query
results: parsing output: 19/ for test: perf_pmu
results: parsing output: 20/ for test: gem_mmap_wc
results: parsing output: 21/ for test: kms_properties
results: parsing output: 22/ for test: perf
results: parsing output: 23/ for test: kms_content_protection
results: parsing output: 24/ for test: perf_pmu
results: parsing output: 25/ for test: gem_sync
results: parsing output: 26/ for test: kms_properties
results: parsing output: 27/ for test: perf_pmu
results: parsing output: 28/ for test: gem_render_copy
results: parsing output: 29/ for test: gem_close
results: parsing output: 30/ for test: gem_partial_pwrite_pread
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_mmap_gtt
results: parsing output: 33/ for test: kms_color
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_exec_reloc
results: parsing output: 39/ for test: i915_hangman
results: parsing output: 40/ for test: gem_render_copy
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_cursor_crc
results: parsing output: 44/ for test: gem_ctx_persistence
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: kms_invalid_mode
results: parsing output: 47/ for test: gem_exec_balancer
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_plane_scaling
results: parsing output: 51/ for test: gem_basic
results: parsing output: 52/ for test: vgem_basic
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: gem_exec_reloc
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_addfb_basic
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: kms_vblank
results: parsing output: 59/ for test: kms_atomic_interruptible
results: parsing output: 60/ for test: gem_softpin
results: parsing output: 61/ for test: gem_tiled_pread_pwrite
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_flip_scaled_crc
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_atomic
results: parsing output: 66/ for test: kms_dither
results: parsing output: 67/ for test: kms_properties
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_exec_parallel
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_exec_store
results: parsing output: 72/ for test: gem_exec_reloc
results: parsing output: 73/ for test: kms_lease
results: parsing output: 74/ for test: gem_exec_balancer
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: api_intel_allocator
results: parsing output: 77/ for test: kms_sequence
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: gem_exec_schedule
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_plane
results: parsing output: 82/ for test: syncobj_basic
results: parsing output: 83/ for test: api_intel_bb
results: parsing output: 84/ for test: kms_busy
results: parsing output: 85/ for test: kms_feature_discovery
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: perf_pmu
results: parsing output: 89/ for test: gem_exec_fence
results: parsing output: 90/ for test: gem_exec_params
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: i915_suspend
results: parsing output: 93/ for test: kms_psr2_sf
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_chamelium_edid
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: kms_chamelium_hpd
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_mmap
results: parsing output: 101/ for test: gem_ctx_isolation
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_pm_rpm
results: parsing output: 104/ for test: syncobj_eventfd
results: parsing output: 105/ for test: kms_psr2_sf
results: parsing output: 106/ for test: gem_userptr_blits
results: parsing output: 107/ for test: kms_cursor_crc
results: parsing output: 108/ for test: gem_busy
results: parsing output: 109/ for test: kms_plane_scaling
results: parsing output: 110/ for test: gem_exec_fence
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_cursor_legacy
results: parsing output: 113/ for test: gen9_exec_parse
results: parsing output: 114/ for test: gem_wait
results: parsing output: 115/ for test: gem_lmem_swapping
results: parsing output: 116/ for test: gem_userptr_blits
results: parsing output: 117/ for test: gem_pxp
results: parsing output: 118/ for test: kms_atomic_transition
results: parsing output: 119/ for test: gem_userptr_blits
results: parsing output: 120/ for test: kms_cursor_crc
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_pm_rpm
results: parsing output: 123/ for test: i915_drm_fdinfo
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_getfb
results: parsing output: 126/ for test: kms_async_flips
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: prime_vgem
results: parsing output: 131/ for test: gem_ctx_sseu
results: parsing output: 132/ for test: kms_properties
Done.