[57.995880] Initializing watchdogs
[57.995945]   /dev/watchdog0
[58.011068] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[58.016955] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.019442] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.021283] [001/156] (960s left) gem_ctx_param (root-set)
[58.060465] Starting subtest: root-set
[58.061172] Subtest root-set: SUCCESS (0.000s)
[58.149695] [002/156] (960s left) kms_flip (2x-plain-flip-ts-check)
[58.241196] Starting subtest: 2x-plain-flip-ts-check
[58.249790] Subtest 2x-plain-flip-ts-check: SKIP (0.009s)
[58.359600] [003/156] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt)
[58.455367] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt
[58.456718] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[58.606814] [004/156] (960s left) kms_big_fb (4-tiled-addfb-size-overflow)
[58.706796] Starting subtest: 4-tiled-addfb-size-overflow
[58.708218] Subtest 4-tiled-addfb-size-overflow: SKIP (0.000s)
[58.852954] [005/156] (959s left) kms_lease (implicit-plane-lease)
[58.940787] Starting subtest: implicit-plane-lease
[58.942384] Subtest implicit-plane-lease: SUCCESS (0.002s)
[59.081522] [006/156] (959s left) syncobj_wait (invalid-reset-zero-handles)
[59.117344] Starting subtest: invalid-reset-zero-handles
[59.118060] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[59.231819] [007/156] (959s left) gem_userptr_blits (userfault)
[59.272953] Starting subtest: userfault
[59.274955] Subtest userfault: SUCCESS (0.003s)
[59.440355] [008/156] (959s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[59.532138] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[59.533489] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[59.687362] [009/156] (959s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt)
[59.780309] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt
[59.781656] Subtest fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[59.895932] [010/156] (958s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[59.988592] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[59.989994] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[60.123514] [011/156] (958s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[60.220868] Starting subtest: yf-tiled-16bpp-rotate-180
[60.222304] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[60.331587] [012/156] (958s left) perf_pmu (all-busy-idle-check-all)
[60.367902] Starting subtest: all-busy-idle-check-all
[60.993228] Subtest all-busy-idle-check-all: SUCCESS (0.625s)
[61.092550] [013/156] (957s left) kms_psr (pr-no-drrs)
[61.181471] Subtest pr-no-drrs: SKIP (0.000s)
[61.226138] [014/156] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[61.317414] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[61.318810] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[61.451513] [015/156] (957s left) api_intel_bb (destroy-bb)
[61.484454] Starting subtest: destroy-bb
[61.491614] Subtest destroy-bb: SUCCESS (0.007s)
[61.624705] [016/156] (957s left) perf (gen12-group-exclusive-stream-sample-oa)
[61.724983] Starting subtest: gen12-group-exclusive-stream-sample-oa
[61.734652] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.010s)
[61.781717] [017/156] (957s left) perf_pmu (semaphore-wait-idle)
[61.819006] Starting subtest: semaphore-wait-idle
[61.819794] Starting dynamic subtest: rcs0
[62.337405] Dynamic subtest rcs0: SUCCESS (0.509s)
[62.345981] Starting dynamic subtest: bcs0
[62.848673] Dynamic subtest bcs0: SUCCESS (0.511s)
[62.856997] Starting dynamic subtest: vcs0
[63.359566] Dynamic subtest vcs0: SUCCESS (0.510s)
[63.367976] Starting dynamic subtest: vcs1
[63.870920] Dynamic subtest vcs1: SUCCESS (0.511s)
[63.879265] Starting dynamic subtest: vecs0
[64.381632] Dynamic subtest vecs0: SUCCESS (0.510s)
[64.382638] Subtest semaphore-wait-idle: SUCCESS (2.554s)
[64.503154] [018/156] (954s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[64.541691] Starting subtest: yf-tiled-to-vebox-x-tiled
[64.542388] Starting dynamic subtest: smem
[64.642611] Dynamic subtest smem: SUCCESS (0.101s)
[64.643347] Subtest yf-tiled-to-vebox-x-tiled: SUCCESS (0.101s)
[64.868106] [019/156] (954s left) kms_psr (psr-cursor-blt)
[64.959294] Subtest psr-cursor-blt: SKIP (0.000s)
[65.001756] [020/156] (954s left) kms_flip (2x-nonexisting-fb-interruptible)
[65.094511] Starting subtest: 2x-nonexisting-fb-interruptible
[65.103274] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.009s)
[65.247560] [021/156] (954s left) gen9_exec_parse (bb-large)
[65.284936] Subtest bb-large: SKIP (0.000s)
[65.326543] [022/156] (954s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[65.366394] Starting subtest: yf-tiled-ccs-to-x-tiled
[65.367160] Starting dynamic subtest: smem
[65.467481] Dynamic subtest smem: SUCCESS (0.101s)
[65.468269] Subtest yf-tiled-ccs-to-x-tiled: SUCCESS (0.101s)
[65.706628] [023/156] (953s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[65.798460] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[65.799814] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[65.929338] [024/156] (953s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[66.016592] Starting subtest: cursor-vs-flip-toggle
[98.569153] Subtest cursor-vs-flip-toggle: SUCCESS (32.552s)
[98.780371] [025/156] (920s left) syncobj_wait (single-wait-signaled)
[98.816609] Starting subtest: single-wait-signaled
[98.817350] Subtest single-wait-signaled: SUCCESS (0.001s)
[98.911553] [026/156] (920s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[99.005375] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[99.006769] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[99.120669] [027/156] (920s left) gem_ctx_persistence (engines-hostile)
[99.159140] Starting subtest: engines-hostile
[99.159904] Starting dynamic subtest: rcs0
[99.194661] Dynamic subtest rcs0: SUCCESS (0.035s)
[99.208742] Starting dynamic subtest: bcs0
[99.294560] Dynamic subtest bcs0: SUCCESS (0.099s)
[99.308238] Starting dynamic subtest: vcs0
[99.387550] Dynamic subtest vcs0: SUCCESS (0.092s)
[99.400957] Starting dynamic subtest: vcs1
[99.484489] Dynamic subtest vcs1: SUCCESS (0.096s)
[99.498866] Starting dynamic subtest: vecs0
[99.576496] Dynamic subtest vecs0: SUCCESS (0.091s)
[99.577689] Subtest engines-hostile: SUCCESS (0.417s)
[99.673963] [028/156] (919s left) i915_drm_fdinfo (memory-info-purgeable)
[99.710418] Starting subtest: memory-info-purgeable
[99.711132] Starting dynamic subtest: smem0
[100.903755] Dynamic subtest smem0: SUCCESS (1.193s)
[100.904966] Subtest memory-info-purgeable: SUCCESS (1.193s)
[100.998513] [029/156] (918s left) syncobj_wait (wait-all-for-submit-complex)
[101.033992] Starting subtest: wait-all-for-submit-complex
[101.258116] Subtest wait-all-for-submit-complex: SUCCESS (0.215s)
[101.356434] [030/156] (918s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[101.446365] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[101.447117] Starting dynamic subtest: pipe-A-HDMI-A-1
[101.465122] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[101.471582] Starting dynamic subtest: pipe-B-HDMI-A-1
[101.490477] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[101.496620] Starting dynamic subtest: pipe-C-HDMI-A-1
[101.513997] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[101.519986] Starting dynamic subtest: pipe-D-HDMI-A-1
[101.537686] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[101.539063] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.011s)
[101.753119] [031/156] (917s left) kms_properties (invalid-properties-legacy)
[101.846707] Starting subtest: invalid-properties-legacy
[102.056027] Subtest invalid-properties-legacy: SUCCESS (0.201s)
[102.149281] [032/156] (917s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[102.184486] Starting subtest: etime-multi-wait-all-for-submit-submitted
[102.292934] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.108s)
[102.399448] [033/156] (917s left) kms_content_protection (suspend-resume)
[102.491303] Starting subtest: suspend-resume
[102.496568] Subtest suspend-resume: SKIP (0.004s)
[102.646309] [034/156] (917s left) gem_exec_fence (basic-busy)
[102.812228] Starting subtest: basic-busy
[102.813119] Starting dynamic subtest: rcs0
[102.841345] Dynamic subtest rcs0: SUCCESS (0.030s)
[102.854923] Starting dynamic subtest: bcs0
[102.872564] Dynamic subtest bcs0: SUCCESS (0.030s)
[102.885129] Starting dynamic subtest: vcs0
[102.911523] Dynamic subtest vcs0: SUCCESS (0.038s)
[102.923970] Starting dynamic subtest: vcs1
[102.942377] Dynamic subtest vcs1: SUCCESS (0.030s)
[102.954347] Starting dynamic subtest: vecs0
[102.967327] Dynamic subtest vecs0: SUCCESS (0.025s)
[102.968776] Subtest basic-busy: SUCCESS (0.156s)
[103.480473] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[103.484223] [035/156] (916s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[103.579642] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[103.580996] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[103.690656] [036/156] (916s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[103.778902] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[103.779680] Starting dynamic subtest: pipe-A-HDMI-A-1
[103.786818] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[103.796345] Starting dynamic subtest: pipe-B-HDMI-A-1
[103.803357] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[103.812632] Starting dynamic subtest: pipe-C-HDMI-A-1
[103.819569] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[103.826014] Starting dynamic subtest: pipe-D-HDMI-A-1
[103.833050] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[103.834379] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[104.089491] [037/156] (915s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[104.176822] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[104.178141] Starting dynamic subtest: pipe-A
[104.321254] Dynamic subtest pipe-A: SUCCESS (0.144s)
[104.333437] Starting dynamic subtest: pipe-B
[104.498904] Dynamic subtest pipe-B: SUCCESS (0.177s)
[104.511880] Starting dynamic subtest: pipe-C
[104.677350] Dynamic subtest pipe-C: SUCCESS (0.178s)
[104.690354] Starting dynamic subtest: pipe-D
[104.855709] Dynamic subtest pipe-D: SUCCESS (0.178s)
[104.856726] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.679s)
[105.077266] [038/156] (914s left) syncobj_timeline (single-wait-available-signaled)
[105.113486] Starting subtest: single-wait-available-signaled
[105.114210] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[105.231767] [039/156] (914s left) api_intel_bb (blit-noreloc-keep-cache)
[105.266597] Starting subtest: blit-noreloc-keep-cache
[105.272791] Subtest blit-noreloc-keep-cache: SUCCESS (0.007s)
[105.401030] [040/156] (914s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-plflip-blt)
[105.494743] Starting subtest: psrhdr-2p-scndscrn-shrfb-plflip-blt
[105.496095] Subtest psrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[105.631543] [041/156] (914s left) i915_query (query-regions-sanity-check)
[105.664439] Starting subtest: query-regions-sanity-check
[105.675214] Subtest query-regions-sanity-check: SUCCESS (0.011s)
[105.820543] [042/156] (914s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[105.906753] Starting subtest: flip-vs-cursor-toggle
[118.130192] Subtest flip-vs-cursor-toggle: SUCCESS (12.223s)
[118.316919] [043/156] (901s left) kms_psr (fbc-psr-basic)
[118.407384] Subtest fbc-psr-basic: SKIP (0.000s)
[118.456427] [044/156] (901s left) gem_ppgtt (flink-and-close-vma-leak)
[118.495447] Starting subtest: flink-and-close-vma-leak
[118.499403] Subtest flink-and-close-vma-leak: SUCCESS (0.005s)
[118.646586] [045/156] (901s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[118.739398] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[118.740782] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[118.873010] [046/156] (901s left) kms_flip (2x-blocking-wf_vblank)
[118.959272] Starting subtest: 2x-blocking-wf_vblank
[118.967527] Subtest 2x-blocking-wf_vblank: SKIP (0.008s)
[119.081459] [047/156] (901s left) kms_big_fb (y-tiled-addfb)
[119.177770] Starting subtest: y-tiled-addfb
[119.178529] Subtest y-tiled-addfb: SUCCESS (0.000s)
[119.327641] [048/156] (901s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-plflip-blt)
[119.419443] Starting subtest: hdr-1p-primscrn-shrfb-plflip-blt
[119.420897] Subtest hdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[119.554891] [049/156] (900s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[119.642769] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[119.643466] Starting dynamic subtest: pipe-A-HDMI-A-1
[136.044850] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.640s)
[136.060834] Starting dynamic subtest: pipe-B-HDMI-A-1
[152.982672] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.507s)
[153.000162] Starting dynamic subtest: pipe-C-HDMI-A-1
[169.982837] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.516s)
[170.003029] Starting dynamic subtest: pipe-D-HDMI-A-1
[186.995302] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.495s)
[186.996310] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SUCCESS (6.169s)
[200.290161] [050/156] (833s left) gem_userptr_blits (invalid-null-pointer)
[200.339046] Starting subtest: invalid-null-pointer
[200.339811] Subtest invalid-null-pointer: SUCCESS (0.001s)
[200.483975] [051/156] (833s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[200.582551] Starting subtest: cursorA-vs-flipB-toggle
[200.584857] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[200.710887] [052/156] (832s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[200.803230] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[203.186426] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SUCCESS (2.383s)
[203.381488] [053/156] (830s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[203.474014] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[203.475383] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[203.595697] [054/156] (830s left) kms_addfb_basic (too-high)
[203.684583] Starting subtest: too-high
[203.685344] Subtest too-high: SUCCESS (0.001s)
[203.804045] [055/156] (829s left) syncobj_timeline (multi-wait-submitted-signaled)
[203.838958] Starting subtest: multi-wait-submitted-signaled
[203.839737] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[203.936575] [056/156] (829s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[204.034969] Starting subtest: x-tiled-8bpp-rotate-180
[205.558491] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.523s)
[205.720957] [057/156] (828s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[205.812916] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[205.854463] [058/156] (828s left) kms_draw_crc (draw-method-mmap-gtt)
[205.942040] Starting subtest: draw-method-mmap-gtt
[205.942837] Starting dynamic subtest: xrgb8888-untiled
[206.241840] Dynamic subtest xrgb8888-untiled: SUCCESS (0.299s)
[206.257679] Starting dynamic subtest: rgb565-untiled
[206.545430] Dynamic subtest rgb565-untiled: SUCCESS (0.303s)
[206.553784] Starting dynamic subtest: xrgb2101010-untiled
[206.811141] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.264s)
[206.826739] Starting dynamic subtest: xbgr16161616f-untiled
[207.114590] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.302s)
[207.125570] Starting dynamic subtest: xrgb8888-xtiled
[207.266858] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.151s)
[207.282696] Starting dynamic subtest: rgb565-xtiled
[207.437356] Dynamic subtest rgb565-xtiled: SUCCESS (0.170s)
[207.447385] Starting dynamic subtest: xrgb2101010-xtiled
[207.570029] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.132s)
[207.584281] Starting dynamic subtest: xbgr16161616f-xtiled
[207.722033] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.151s)
[207.731493] Starting dynamic subtest: xrgb8888-ytiled
[207.873914] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.151s)
[207.891507] Starting dynamic subtest: rgb565-ytiled
[208.044727] Dynamic subtest rgb565-ytiled: SUCCESS (0.170s)
[208.061858] Starting dynamic subtest: xrgb2101010-ytiled
[208.196478] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.151s)
[208.212969] Starting dynamic subtest: xbgr16161616f-ytiled
[208.367328] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.170s)
[208.368315] Subtest draw-method-mmap-gtt: SUCCESS (2.425s)
[208.510496] [059/156] (825s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-blt)
[208.604080] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-blt
[208.612708] Subtest psrhdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[208.719091] [060/156] (825s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-plflip-blt)
[208.811020] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-plflip-blt
[208.812340] Subtest fbcpsrhdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[208.945957] [061/156] (825s left) kms_color_pipeline (plane-lut1d-lut1d)
[209.034688] Starting subtest: plane-lut1d-lut1d
[209.221433] Starting dynamic subtest: pipe-A-plane-0
[209.411159] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s)
[209.426750] Starting dynamic subtest: pipe-A-plane-1
[209.581336] Dynamic subtest pipe-A-plane-1: SUCCESS (0.170s)
[209.594093] Starting dynamic subtest: pipe-A-plane-2
[209.752645] Dynamic subtest pipe-A-plane-2: SUCCESS (0.170s)
[210.041805] Starting dynamic subtest: pipe-B-plane-0
[210.195473] Dynamic subtest pipe-B-plane-0: SUCCESS (0.170s)
[210.212836] Starting dynamic subtest: pipe-B-plane-1
[210.366017] Dynamic subtest pipe-B-plane-1: SUCCESS (0.169s)
[210.382142] Starting dynamic subtest: pipe-B-plane-2
[210.537165] Dynamic subtest pipe-B-plane-2: SUCCESS (0.170s)
[210.818677] Starting dynamic subtest: pipe-C-plane-0
[210.979192] Dynamic subtest pipe-C-plane-0: SUCCESS (0.170s)
[210.996049] Starting dynamic subtest: pipe-C-plane-1
[211.149604] Dynamic subtest pipe-C-plane-1: SUCCESS (0.169s)
[211.166343] Starting dynamic subtest: pipe-C-plane-2
[211.320410] Dynamic subtest pipe-C-plane-2: SUCCESS (0.170s)
[211.623039] Starting dynamic subtest: pipe-D-plane-0
[211.783824] Dynamic subtest pipe-D-plane-0: SUCCESS (0.170s)
[211.797199] Starting dynamic subtest: pipe-D-plane-1
[211.954901] Dynamic subtest pipe-D-plane-1: SUCCESS (0.170s)
[211.965790] Starting dynamic subtest: pipe-D-plane-2
[212.125445] Dynamic subtest pipe-D-plane-2: SUCCESS (0.170s)
[212.168656] Subtest plane-lut1d-lut1d: SUCCESS (3.134s)
[212.321900] [062/156] (821s left) gem_tiled_pread_basic (basic)
[212.357205] Starting subtest: basic
[212.437832] Subtest basic: SUCCESS (0.081s)
[212.569761] [063/156] (821s left) kms_vblank (query-idle-hang)
[212.659697] Starting subtest: query-idle-hang
[212.660412] Starting dynamic subtest: pipe-A-HDMI-A-1
[226.704047] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.043s)
[226.715353] Starting dynamic subtest: pipe-D-HDMI-A-1
[241.015553] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (14.294s)
[241.016257] Subtest query-idle-hang: SUCCESS (28.343s)
[241.214847] [064/156] (792s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[241.251319] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[241.356642] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[241.461112] [065/156] (792s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[241.551453] Starting subtest: primary-yf-tiled-reflect-x-0
[241.659225] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.107s)
[241.774580] [066/156] (792s left) i915_hangman (hangcheck-unterminated)
[241.817890] Starting subtest: hangcheck-unterminated
[251.111377] Subtest hangcheck-unterminated: SUCCESS (9.293s)
[251.271713] [067/156] (783s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[251.367496] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[253.271377] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (1.905s)
[253.433617] [068/156] (780s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[253.524143] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.000s)
[253.568745] [069/156] (780s left) gem_flink_basic (double-flink)
[253.602878] Starting subtest: double-flink
[253.603596] Subtest double-flink: SUCCESS (0.000s)
[253.737043] [070/156] (780s left) gem_exec_reloc (basic-write-gtt-active)
[253.775696] Starting subtest: basic-write-gtt-active
[253.906699] Subtest basic-write-gtt-active: SUCCESS (0.123s)
[254.059617] [071/156] (780s left) gem_mmap_wc (write-wc-read-gtt)
[254.093364] Starting subtest: write-wc-read-gtt
[254.404960] Subtest write-wc-read-gtt: SUCCESS (0.303s)
[254.510931] [072/156] (779s left) syncobj_wait (wait-zero-handles)
[254.546516] Starting subtest: wait-zero-handles
[254.547222] Subtest wait-zero-handles: SUCCESS (0.000s)
[254.644059] [073/156] (779s left) kms_getfb (getfb2-handle-not-fb)
[254.736018] Starting subtest: getfb2-handle-not-fb
[254.736790] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[254.856453] [074/156] (779s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[254.946356] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[254.947836] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[255.065504] [075/156] (779s left) prime_busy (before-wait)
[255.103681] Starting subtest: before-wait
[255.107722] Starting dynamic subtest: rcs0
[255.134683] Dynamic subtest rcs0: SUCCESS (0.027s)
[255.142685] Starting dynamic subtest: bcs0
[255.156124] Dynamic subtest bcs0: SUCCESS (0.020s)
[255.166369] Starting dynamic subtest: vcs0
[255.171062] Dynamic subtest vcs0: SUCCESS (0.014s)
[255.179703] Starting dynamic subtest: vcs1
[255.183115] Dynamic subtest vcs1: SUCCESS (0.011s)
[255.190741] Starting dynamic subtest: vecs0
[255.197040] Dynamic subtest vecs0: SUCCESS (0.013s)
[255.306020] Subtest before-wait: SUCCESS (0.201s)
[255.426513] [076/156] (779s left) kms_busy (basic-hang)
[255.518691] Starting subtest: basic-hang
[255.519364] Starting dynamic subtest: flip-pipe-A
[256.088767] Dynamic subtest flip-pipe-A: SUCCESS (0.569s)
[256.097217] Starting dynamic subtest: modeset-pipe-A
[256.850438] Dynamic subtest modeset-pipe-A: SUCCESS (0.761s)
[256.861074] Starting dynamic subtest: flip-pipe-D
[257.314426] Dynamic subtest flip-pipe-D: SUCCESS (0.460s)
[257.322269] Starting dynamic subtest: modeset-pipe-D
[258.011889] Dynamic subtest modeset-pipe-D: SUCCESS (0.697s)
[258.012603] Subtest basic-hang: SUCCESS (2.494s)
[258.223691] [077/156] (776s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[258.321249] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[258.322594] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[258.450883] [078/156] (776s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[258.544002] Starting subtest: flip-vs-cursor-crc-atomic
[259.075082] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.531s)
[259.296249] [079/156] (775s left) gem_userptr_blits (sync-unmap-cycles)
[259.341904] Starting subtest: sync-unmap-cycles
[264.753533] Subtest sync-unmap-cycles: SUCCESS (5.377s)
[264.874307] [080/156] (769s left) kms_pm_dc (dc5-dpms-negative)
[265.970565] Starting subtest: dc5-dpms-negative
[270.221287] Subtest dc5-dpms-negative: SUCCESS (4.216s)
[270.277342] [081/156] (764s left) gem_exec_schedule (implicit-boths)
[270.322664] Starting subtest: implicit-boths
[270.323355] Starting dynamic subtest: rcs0
[270.387693] Dynamic subtest rcs0: SUCCESS (0.065s)
[270.398925] Starting dynamic subtest: bcs0
[270.450449] Dynamic subtest bcs0: SUCCESS (0.061s)
[270.462281] Starting dynamic subtest: vcs0
[270.516573] Dynamic subtest vcs0: SUCCESS (0.065s)
[270.529191] Starting dynamic subtest: vcs1
[270.583613] Dynamic subtest vcs1: SUCCESS (0.066s)
[270.596572] Starting dynamic subtest: vecs0
[270.649280] Dynamic subtest vecs0: SUCCESS (0.064s)
[270.650187] Subtest implicit-boths: SUCCESS (0.328s)
[271.025581] [082/156] (763s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[271.119692] Starting subtest: bad-rotation-90-y-tiled-ccs
[271.120380] Starting dynamic subtest: pipe-A-HDMI-A-1
[271.126975] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[271.135122] Starting dynamic subtest: pipe-B-HDMI-A-1
[271.141677] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[271.149539] Starting dynamic subtest: pipe-C-HDMI-A-1
[271.155975] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[271.163651] Starting dynamic subtest: pipe-D-HDMI-A-1
[271.170374] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[271.171658] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.005s)
[271.415177] [083/156] (763s left) drm_read (short-buffer-wakeup)
[271.538990] Starting subtest: short-buffer-wakeup
[303.764074] Subtest short-buffer-wakeup: SUCCESS (32.214s)
[303.926811] [084/156] (731s left) kms_lease (multimaster-lease)
[304.017351] Starting subtest: multimaster-lease
[304.019320] Subtest multimaster-lease: SUCCESS (0.002s)
[304.147602] [085/156] (730s left) prime_self_import (basic-llseek-size)
[304.180095] Starting subtest: basic-llseek-size
[304.181511] Subtest basic-llseek-size: SUCCESS (0.002s)
[304.318743] [086/156] (730s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[304.407660] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[304.452793] [087/156] (730s left) kms_frontbuffer_tracking (fbchdr-2p-rte)
[304.546223] Starting subtest: fbchdr-2p-rte
[304.547593] Subtest fbchdr-2p-rte: SKIP (0.000s)
[304.679277] [088/156] (730s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[304.775762] Starting subtest: yf-tiled-64bpp-rotate-180
[304.777170] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[304.926709] [089/156] (730s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-plflip-blt)
[305.021012] Starting subtest: fbchdr-2p-scndscrn-shrfb-plflip-blt
[305.022418] Subtest fbchdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[305.133969] [090/156] (730s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[305.226932] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[307.610078] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (2.384s)
[307.791430] [091/156] (727s left) kms_chamelium_audio (hdmi-audio)
[307.921407] Subtest hdmi-audio: SKIP (0.000s)
[308.035115] [092/156] (727s left) kms_vblank (accuracy-idle)
[308.125673] Starting subtest: accuracy-idle
[308.126411] Starting dynamic subtest: pipe-A-HDMI-A-1
[310.696626] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.569s)
[310.706235] Starting dynamic subtest: pipe-D-HDMI-A-1
[313.187686] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.474s)
[313.188421] Subtest accuracy-idle: SUCCESS (5.048s)
[313.382767] [093/156] (722s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-msflip-blt)
[313.480416] Starting subtest: fbchdr-2p-primscrn-indfb-msflip-blt
[313.481776] Subtest fbchdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[313.603537] [094/156] (721s left) kms_psr (fbc-pr-primary-render)
[313.691803] Subtest fbc-pr-primary-render: SKIP (0.000s)
[313.743966] [095/156] (721s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[313.836186] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[313.837552] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[313.988577] [096/156] (721s left) gem_ccs (ctrl-surf-copy)
[314.026373] Starting subtest: ctrl-surf-copy
[314.027818] Subtest ctrl-surf-copy: SKIP (0.000s)
[314.141608] [097/156] (721s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[314.235772] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[314.237175] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[314.348857] [098/156] (721s left) gem_lmem_swapping (heavy-verify-random)
[314.387279] Subtest heavy-verify-random: SKIP (0.000s)
[314.451676] [099/156] (721s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[314.486107] Starting subtest: multi-wait-all-available-submitted-signaled
[314.486819] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s)
[314.595633] [100/156] (721s left) kms_plane (plane-position-hole-dpms)
[314.683880] Starting subtest: plane-position-hole-dpms
[315.033930] Starting dynamic subtest: pipe-A-plane-1
[315.505419] Dynamic subtest pipe-A-plane-1: SUCCESS (0.473s)
[315.513537] Starting dynamic subtest: pipe-A-plane-2
[315.970652] Dynamic subtest pipe-A-plane-2: SUCCESS (0.464s)
[315.979380] Starting dynamic subtest: pipe-A-plane-3
[316.439650] Dynamic subtest pipe-A-plane-3: SUCCESS (0.467s)
[316.448676] Starting dynamic subtest: pipe-A-plane-4
[316.909763] Dynamic subtest pipe-A-plane-4: SUCCESS (0.469s)
[316.918520] Starting dynamic subtest: pipe-A-plane-5
[317.355475] Dynamic subtest pipe-A-plane-5: SUCCESS (0.444s)
[317.364642] Starting dynamic subtest: pipe-A-plane-6
[317.821035] Dynamic subtest pipe-A-plane-6: SUCCESS (0.464s)
[317.829139] Starting dynamic subtest: pipe-A-plane-7
[317.830610] Dynamic subtest pipe-A-plane-7: SUCCESS (0.002s)
[318.121198] Starting dynamic subtest: pipe-B-plane-1
[318.556664] Dynamic subtest pipe-B-plane-1: SUCCESS (0.442s)
[318.564927] Starting dynamic subtest: pipe-B-plane-2
[318.981232] Dynamic subtest pipe-B-plane-2: SUCCESS (0.423s)
[318.989408] Starting dynamic subtest: pipe-B-plane-3
[319.412924] Dynamic subtest pipe-B-plane-3: SUCCESS (0.431s)
[319.422767] Starting dynamic subtest: pipe-B-plane-4
[319.837794] Dynamic subtest pipe-B-plane-4: SUCCESS (0.424s)
[319.847830] Starting dynamic subtest: pipe-B-plane-5
[320.260999] Dynamic subtest pipe-B-plane-5: SUCCESS (0.422s)
[320.269078] Starting dynamic subtest: pipe-B-plane-6
[320.704671] Dynamic subtest pipe-B-plane-6: SUCCESS (0.443s)
[320.712929] Starting dynamic subtest: pipe-B-plane-7
[320.714308] Dynamic subtest pipe-B-plane-7: SUCCESS (0.002s)
[320.714985] Subtest plane-position-hole-dpms: SUCCESS (6.025s)
[320.894152] [101/156] (714s left) kms_atomic (test-only)
[320.987904] Starting subtest: test-only
[321.056320] Starting dynamic subtest: pipe-A-HDMI-A-1
[321.470776] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.416s)
[321.471471] Subtest test-only: SUCCESS (0.484s)
[321.674036] [102/156] (714s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[321.763021] Starting subtest: psr-dirtyfb-ioctl
[321.767066] Subtest psr-dirtyfb-ioctl: SKIP (0.000s)
[321.882063] [103/156] (713s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[321.976635] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[321.978095] Subtest hdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[322.108633] [104/156] (713s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[322.199823] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[322.201995] Starting dynamic subtest: pipe-A-valid-mode
[323.164022] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.962s)
[323.164799] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SUCCESS (0.964s)
[323.360976] [105/156] (712s left) gem_userptr_blits (create-destroy-sync)
[323.406542] Starting subtest: create-destroy-sync
[328.462577] Subtest create-destroy-sync: SUCCESS (5.018s)
[328.554534] [106/156] (707s left) gem_exec_schedule (preempt-other)
[328.600814] Starting subtest: preempt-other
[328.601543] Starting dynamic subtest: rcs0
[328.628883] Dynamic subtest rcs0: SUCCESS (0.027s)
[328.637627] Starting dynamic subtest: bcs0
[328.656778] Dynamic subtest bcs0: SUCCESS (0.027s)
[328.667326] Starting dynamic subtest: vcs0
[328.685703] Dynamic subtest vcs0: SUCCESS (0.027s)
[328.694539] Starting dynamic subtest: vcs1
[328.713283] Dynamic subtest vcs1: SUCCESS (0.027s)
[328.723994] Starting dynamic subtest: vecs0
[328.741417] Dynamic subtest vecs0: SUCCESS (0.027s)
[328.742181] Subtest preempt-other: SUCCESS (0.141s)
[329.070266] [107/156] (706s left) gem_mmap_gtt (cpuset-big-copy-xy)
[329.103867] Starting subtest: cpuset-big-copy-XY
[349.803760] Subtest cpuset-big-copy-XY: SUCCESS (20.698s)
[349.908865] [108/156] (686s left) kms_cursor_legacy (forked-bo)
[350.032011] Starting subtest: forked-bo
[350.032726] Starting dynamic subtest: pipe-A
[355.484370] Dynamic subtest pipe-A: SUCCESS (5.416s)
[355.495891] Starting dynamic subtest: pipe-B
[360.879253] Dynamic subtest pipe-B: SUCCESS (5.419s)
[360.889919] Starting dynamic subtest: pipe-C
[366.333400] Dynamic subtest pipe-C: SUCCESS (5.428s)
[366.347623] Starting dynamic subtest: pipe-D
[371.763189] Dynamic subtest pipe-D: SUCCESS (5.427s)
[371.783273] Starting dynamic subtest: all-pipes
[377.192133] Dynamic subtest all-pipes: SUCCESS (5.426s)
[377.193001] Subtest forked-bo: SUCCESS (27.124s)
[377.266873] [109/156] (658s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[377.364297] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-wc
[377.365971] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[377.498160] [110/156] (658s left) kms_chamelium_edid (dp-edid-read)
[377.645554] Subtest dp-edid-read: SKIP (0.000s)
[377.756205] [111/156] (658s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-cpu)
[377.849233] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-cpu
[377.850714] Subtest fbcpsrhdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[377.972886] [112/156] (658s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[378.065211] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[380.503772] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (2.438s)
[380.705273] [113/156] (655s left) gem_ctx_engines (invalid-engines)
[380.749211] Starting subtest: invalid-engines
[380.754457] Subtest invalid-engines: SUCCESS (0.005s)
[380.952611] [114/156] (655s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[381.048523] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[381.049999] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[381.160093] [115/156] (655s left) kms_frontbuffer_tracking (fbchdr-1p-pri-indfb-multidraw)
[381.252064] Starting subtest: fbchdr-1p-pri-indfb-multidraw
[381.253447] Subtest fbchdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[381.369313] [116/156] (655s left) gem_exec_reloc (basic-wc-cpu)
[381.407194] Starting subtest: basic-wc-cpu
[381.412361] Subtest basic-wc-cpu: SUCCESS (0.005s)
[381.597327] [117/156] (654s left) kms_cursor_crc (cursor-offscreen-256x85)
[381.695041] Starting subtest: cursor-offscreen-256x85
[381.699769] Starting dynamic subtest: pipe-A-HDMI-A-1
[384.443358] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.743s)
[384.475585] Starting dynamic subtest: pipe-D-HDMI-A-1
[387.073649] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.607s)
[387.074354] Subtest cursor-offscreen-256x85: SUCCESS (5.379s)
[387.279796] [118/156] (649s left) gem_exec_balancer (parallel)
[387.442068] Subtest parallel: SKIP (0.000s)
[387.564226] [119/156] (649s left) kms_cursor_crc (cursor-random-64x64)
[387.658238] Starting subtest: cursor-random-64x64
[387.662975] Starting dynamic subtest: pipe-A-HDMI-A-1
[391.887895] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.224s)
[391.919721] Starting dynamic subtest: pipe-D-HDMI-A-1
[396.041741] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (4.128s)
[396.042436] Subtest cursor-random-64x64: SUCCESS (8.382s)
[396.246642] [120/156] (640s left) gem_exec_flush (basic-uc-pro-default)
[396.290904] Starting subtest: basic-uc-pro-default
[401.722564] Subtest basic-uc-pro-default: SUCCESS (5.431s)
[401.952845] [121/156] (634s left) gem_exec_store (cachelines)
[401.995044] Starting subtest: cachelines
[401.995774] Starting dynamic subtest: rcs0
[402.071615] Dynamic subtest rcs0: SUCCESS (0.076s)
[402.089854] Starting dynamic subtest: bcs0
[402.109590] Dynamic subtest bcs0: SUCCESS (0.036s)
[402.125224] Starting dynamic subtest: vcs0
[402.140328] Dynamic subtest vcs0: SUCCESS (0.029s)
[402.153814] Starting dynamic subtest: vcs1
[402.172453] Dynamic subtest vcs1: SUCCESS (0.030s)
[402.186870] Starting dynamic subtest: vecs0
[402.210555] Dynamic subtest vecs0: SUCCESS (0.036s)
[402.211538] Subtest cachelines: SUCCESS (0.216s)
[402.429923] [122/156] (634s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-indfb-plflip-blt)
[402.524751] Starting subtest: psrhdr-2p-primscrn-indfb-plflip-blt
[402.526147] Subtest psrhdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[402.657521] [123/156] (634s left) gem_readwrite (new-obj)
[402.691525] Starting subtest: new-obj
[402.693020] Subtest new-obj: SUCCESS (0.000s)
[402.827794] [124/156] (633s left) i915_pm_rps (thresholds)
[402.867409] Starting subtest: thresholds
[402.868134] Starting dynamic subtest: gt0
[412.935133] Dynamic subtest gt0: SUCCESS (10.066s)
[412.936410] Subtest thresholds: SUCCESS (10.068s)
[413.034787] [125/156] (623s left) gem_ctx_persistence (legacy-engines-persistence)
[413.073641] Starting subtest: legacy-engines-persistence
[413.074350] Starting dynamic subtest: render
[413.813315] Dynamic subtest render: SUCCESS (0.739s)
[413.824983] Starting dynamic subtest: bsd1
[414.581448] Dynamic subtest bsd1: SUCCESS (0.766s)
[414.592598] Starting dynamic subtest: bsd2
[415.352412] Dynamic subtest bsd2: SUCCESS (0.768s)
[415.364311] Starting dynamic subtest: blt
[416.110265] Dynamic subtest blt: SUCCESS (0.755s)
[416.122072] Starting dynamic subtest: vebox
[416.881395] Dynamic subtest vebox: SUCCESS (0.768s)
[416.882375] Subtest legacy-engines-persistence: SUCCESS (3.808s)
[417.004489] [126/156] (619s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-wc)
[417.099215] Starting subtest: fbchdr-rgb565-draw-mmap-wc
[417.100627] Subtest fbchdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[417.230164] [127/156] (619s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-plflip-blt)
[417.323793] Starting subtest: fbchdr-1p-primscrn-shrfb-plflip-blt
[417.325162] Subtest fbchdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[417.457867] [128/156] (619s left) gem_mmap_offset (partial-mmap)
[417.491781] Starting subtest: partial-mmap
[417.492487] Starting dynamic subtest: smem0
[417.495376] Dynamic subtest smem0: SUCCESS (0.003s)
[417.496611] Subtest partial-mmap: SUCCESS (0.005s)
[417.648025] [129/156] (619s left) kms_draw_crc (fill-fb)
[417.738036] Starting subtest: fill-fb
[418.167973] Subtest fill-fb: SUCCESS (0.430s)
[418.293184] [130/156] (618s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[418.387377] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[418.388732] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[418.521926] [131/156] (618s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[418.614953] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-wc
[418.616329] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[418.729918] [132/156] (618s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-pgflip-blt)
[418.822374] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-pgflip-blt
[418.823771] Subtest fbcpsrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[418.938891] [133/156] (618s left) kms_async_flips (alternate-sync-async-flip)
[419.028042] Starting subtest: alternate-sync-async-flip
[419.221748] Starting dynamic subtest: pipe-A-HDMI-A-1
[421.326993] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.096s)
[421.510895] Starting dynamic subtest: pipe-B-HDMI-A-1
[423.592655] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.081s)
[423.763957] Starting dynamic subtest: pipe-C-HDMI-A-1
[425.849295] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.085s)
[425.995402] Starting dynamic subtest: pipe-D-HDMI-A-1
[428.080376] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.084s)
[428.081378] Subtest alternate-sync-async-flip: SUCCESS (9.044s)
[428.369676] [134/156] (608s left) gem_exec_schedule (u-submit-early-slice)
[428.424248] Starting subtest: u-submit-early-slice
[428.424953] Starting dynamic subtest: rcs0
[428.453864] Dynamic subtest rcs0: SUCCESS (0.029s)
[428.463754] Starting dynamic subtest: bcs0
[428.479711] Dynamic subtest bcs0: SUCCESS (0.025s)
[428.489908] Starting dynamic subtest: vcs0
[428.505708] Dynamic subtest vcs0: SUCCESS (0.025s)
[428.515444] Starting dynamic subtest: vcs1
[428.531785] Dynamic subtest vcs1: SUCCESS (0.025s)
[428.541478] Starting dynamic subtest: vecs0
[428.559280] Dynamic subtest vecs0: SUCCESS (0.026s)
[428.560074] Subtest u-submit-early-slice: SUCCESS (0.135s)
[428.904190] [135/156] (608s left) kms_pipe_crc_basic (nonblocking-crc)
[428.996844] Starting subtest: nonblocking-crc
[428.997553] Starting dynamic subtest: pipe-A-HDMI-A-1
[429.654254] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.656s)
[429.663999] Starting dynamic subtest: pipe-B-HDMI-A-1
[430.246181] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.590s)
[430.256224] Starting dynamic subtest: pipe-C-HDMI-A-1
[430.809372] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.561s)
[430.822148] Starting dynamic subtest: pipe-D-HDMI-A-1
[431.396993] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.584s)
[431.397686] Subtest nonblocking-crc: SUCCESS (2.399s)
[431.549475] [136/156] (605s left) gem_mmap_gtt (medium-copy-odd)
[431.585365] Starting subtest: medium-copy-odd
[435.084468] Subtest medium-copy-odd: SUCCESS (3.498s)
[435.193665] [137/156] (602s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-onoff)
[435.343224] Starting subtest: hdr-2p-scndscrn-spr-indfb-onoff
[435.344641] Subtest hdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[435.458283] [138/156] (601s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[435.551639] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[435.553049] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[435.686063] [139/156] (601s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[435.727324] Starting subtest: etime-single-wait-all-available-unsubmitted
[435.828590] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.101s)
[435.933093] [140/156] (601s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[436.025362] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[436.026736] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[436.161120] [141/156] (601s left) kms_psr (psr-sprite-render)
[436.250821] Subtest psr-sprite-render: SKIP (0.000s)
[436.297274] [142/156] (601s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[436.385938] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[436.387336] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[436.502691] [143/156] (601s left) syncobj_wait (invalid-wait-bad-flags)
[436.538048] Starting subtest: invalid-wait-bad-flags
[436.538763] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[436.634774] [144/156] (601s left) gem_ctx_shared (q-smoketest)
[436.679518] Starting subtest: Q-smoketest
[436.680306] Starting dynamic subtest: rcs0
[442.121281] Dynamic subtest rcs0: SUCCESS (5.425s)
[442.130448] Starting dynamic subtest: bcs0
[447.570659] Dynamic subtest bcs0: SUCCESS (5.422s)
[447.581064] Starting dynamic subtest: vcs0
[452.994845] Dynamic subtest vcs0: SUCCESS (5.424s)
[453.005085] Starting dynamic subtest: vcs1
[458.421305] Dynamic subtest vcs1: SUCCESS (5.423s)
[458.432992] Starting dynamic subtest: vecs0
[463.849834] Dynamic subtest vecs0: SUCCESS (5.426s)
[463.850713] Subtest Q-smoketest: SUCCESS (27.128s)
[464.018170] [145/156] (573s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[464.111772] Starting subtest: flip-vs-cursor-varying-size
[475.928480] Subtest flip-vs-cursor-varying-size: SUCCESS (11.816s)
[476.125679] [146/156] (561s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[476.217922] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[476.219348] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[476.334651] [147/156] (561s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-indfb-msflip-blt)
[476.427408] Starting subtest: psrhdr-2p-primscrn-indfb-msflip-blt
[476.428791] Subtest psrhdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[476.543433] [148/156] (561s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[476.578827] Starting subtest: multi-wait-for-submit-unsubmitted
[476.684900] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[476.809218] [149/156] (561s left) kms_big_fb (linear-64bpp-rotate-270)
[476.924718] Starting subtest: linear-64bpp-rotate-270
[476.995768] Subtest linear-64bpp-rotate-270: SKIP (0.070s)
[477.150406] [150/156] (560s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[477.243429] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[477.244834] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[477.359459] [151/156] (560s left) gem_exec_fence (syncobj-import)
[477.695782] Starting subtest: syncobj-import
[477.699209] Subtest syncobj-import: SUCCESS (0.003s)
[478.024203] [152/156] (560s left) gem_linear_blits (normal)
[478.119758] Starting subtest: normal
[481.742428] Subtest normal: SUCCESS (3.622s)
[481.910853] [153/156] (556s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[482.059967] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[482.061381] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[482.197317] [154/156] (555s left) kms_addfb_basic (clobberred-modifier)
[482.232435] Starting subtest: clobberred-modifier
[482.233183] Subtest clobberred-modifier: SUCCESS (0.000s)
[482.444768] [155/156] (555s left) kms_pm_rpm (system-suspend-modeset)
[483.861288] Starting subtest: system-suspend-modeset
[504.146542] Subtest system-suspend-modeset: SUCCESS (4.899s)
[510.390680] [156/156] (533s left) kms_chamelium_hpd (hdmi-hpd-fast)
[510.536541] Subtest hdmi-hpd-fast: SKIP (0.000s)
[510.646582] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_param
results: parsing output: 1/ for test: kms_flip
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_lease
results: parsing output: 5/ for test: syncobj_wait
results: parsing output: 6/ for test: gem_userptr_blits
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: perf_pmu
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: api_intel_bb
results: parsing output: 15/ for test: perf
results: parsing output: 16/ for test: perf_pmu
results: parsing output: 17/ for test: gem_render_copy
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: gen9_exec_parse
results: parsing output: 21/ for test: gem_render_copy
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_ctx_persistence
results: parsing output: 27/ for test: i915_drm_fdinfo
results: parsing output: 28/ for test: syncobj_wait
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: kms_properties
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: kms_content_protection
results: parsing output: 33/ for test: gem_exec_fence
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: kms_plane_scaling
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: api_intel_bb
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: i915_query
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: gem_ppgtt
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: gem_userptr_blits
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_addfb_basic
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_psr2_sf
results: parsing output: 57/ for test: kms_draw_crc
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_color_pipeline
results: parsing output: 61/ for test: gem_tiled_pread_basic
results: parsing output: 62/ for test: kms_vblank
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: kms_rotation_crc
results: parsing output: 65/ for test: i915_hangman
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: gem_flink_basic
results: parsing output: 69/ for test: gem_exec_reloc
results: parsing output: 70/ for test: gem_mmap_wc
results: parsing output: 71/ for test: syncobj_wait
results: parsing output: 72/ for test: kms_getfb
results: parsing output: 73/ for test: kms_plane
results: parsing output: 74/ for test: prime_busy
results: parsing output: 75/ for test: kms_busy
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: gem_userptr_blits
results: parsing output: 79/ for test: kms_pm_dc
results: parsing output: 80/ for test: gem_exec_schedule
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: drm_read
results: parsing output: 83/ for test: kms_lease
results: parsing output: 84/ for test: prime_self_import
results: parsing output: 85/ for test: kms_psr2_sf
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_big_fb
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_chamelium_audio
results: parsing output: 91/ for test: kms_vblank
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_ccs
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_lmem_swapping
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: kms_plane
results: parsing output: 100/ for test: kms_atomic
results: parsing output: 101/ for test: kms_dirtyfb
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_flip_scaled_crc
results: parsing output: 104/ for test: gem_userptr_blits
results: parsing output: 105/ for test: gem_exec_schedule
results: parsing output: 106/ for test: gem_mmap_gtt
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_chamelium_edid
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_ctx_engines
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_exec_reloc
results: parsing output: 116/ for test: kms_cursor_crc
results: parsing output: 117/ for test: gem_exec_balancer
results: parsing output: 118/ for test: kms_cursor_crc
results: parsing output: 119/ for test: gem_exec_flush
results: parsing output: 120/ for test: gem_exec_store
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_readwrite
results: parsing output: 123/ for test: i915_pm_rps
results: parsing output: 124/ for test: gem_ctx_persistence
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_mmap_offset
results: parsing output: 128/ for test: kms_draw_crc
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_async_flips
results: parsing output: 133/ for test: gem_exec_schedule
results: parsing output: 134/ for test: kms_pipe_crc_basic
results: parsing output: 135/ for test: gem_mmap_gtt
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: syncobj_timeline
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_psr
results: parsing output: 141/ for test: kms_flip_scaled_crc
results: parsing output: 142/ for test: syncobj_wait
results: parsing output: 143/ for test: gem_ctx_shared
results: parsing output: 144/ for test: kms_cursor_legacy
results: parsing output: 145/ for test: kms_plane
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: syncobj_wait
results: parsing output: 148/ for test: kms_big_fb
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: gem_exec_fence
results: parsing output: 151/ for test: gem_linear_blits
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: kms_addfb_basic
results: parsing output: 154/ for test: kms_pm_rpm
results: parsing output: 155/ for test: kms_chamelium_hpd
Done.