[87.564338] Initializing watchdogs
[87.564560]   /dev/watchdog0
[87.640710] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3184 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 605]
[87.653940] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[87.660212] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[87.665798] [001/133] (960s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[87.849586] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[87.852701] Starting dynamic subtest: pipe-A-HDMI-A-1
[87.856047] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[87.870218] Starting dynamic subtest: pipe-A-HDMI-A-2
[87.873641] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[87.887518] Starting dynamic subtest: pipe-B-HDMI-A-1
[87.891212] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[87.905154] Starting dynamic subtest: pipe-B-HDMI-A-2
[87.908971] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[87.923035] Starting dynamic subtest: pipe-C-HDMI-A-1
[87.926548] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[87.961070] Starting dynamic subtest: pipe-C-HDMI-A-2
[87.964495] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[87.966013] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.018s)
[88.772751] [002/133] (959s left) i915_query (query-topology-known-pci-ids)
[88.866367] Starting subtest: query-topology-known-pci-ids
[88.868526] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[89.018162] [003/133] (959s left) gem_spin_batch (resubmit-new)
[89.138482] Starting subtest: resubmit-new
[89.139712] Starting dynamic subtest: rcs0
[89.149265] Dynamic subtest rcs0: SUCCESS (0.011s)
[89.168396] Starting dynamic subtest: bcs0
[89.169571] Dynamic subtest bcs0: SUCCESS (0.013s)
[89.186706] Starting dynamic subtest: vcs0
[89.189554] Dynamic subtest vcs0: SUCCESS (0.010s)
[89.205652] Starting dynamic subtest: vecs0
[89.206547] Dynamic subtest vecs0: SUCCESS (0.007s)
[89.207580] Subtest resubmit-new: SUCCESS (0.045s)
[89.477507] [004/133] (958s left) kms_draw_crc (draw-method-render)
[89.645894] Starting subtest: draw-method-render
[89.646866] Starting dynamic subtest: xrgb8888-untiled
[90.190034] Dynamic subtest xrgb8888-untiled: SUCCESS (0.543s)
[90.204578] Starting dynamic subtest: rgb565-untiled
[90.521903] Dynamic subtest rgb565-untiled: SUCCESS (0.331s)
[90.538841] Starting dynamic subtest: xrgb2101010-untiled
[90.838693] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.316s)
[90.857092] Starting dynamic subtest: xbgr16161616f-untiled
[91.223583] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.383s)
[91.238092] Starting dynamic subtest: xrgb8888-xtiled
[91.439490] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.217s)
[91.454320] Starting dynamic subtest: rgb565-xtiled
[91.622727] Dynamic subtest rgb565-xtiled: SUCCESS (0.181s)
[91.639486] Starting dynamic subtest: xrgb2101010-xtiled
[91.823253] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.198s)
[91.837941] Starting dynamic subtest: xbgr16161616f-xtiled
[92.056295] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.232s)
[92.071091] Starting dynamic subtest: xrgb8888-ytiled
[92.256360] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.199s)
[92.271536] Starting dynamic subtest: rgb565-ytiled
[92.439054] Dynamic subtest rgb565-ytiled: SUCCESS (0.182s)
[92.454460] Starting dynamic subtest: xrgb2101010-ytiled
[92.622705] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.182s)
[92.637677] Starting dynamic subtest: xbgr16161616f-ytiled
[92.856348] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.233s)
[92.857430] Subtest draw-method-render: SUCCESS (3.210s)
[93.141939] [005/133] (955s left) gem_exec_schedule (noreorder)
[93.384656] Starting subtest: noreorder
[93.385601] Starting dynamic subtest: rcs0
[93.449070] Dynamic subtest rcs0: SUCCESS (0.063s)
[93.465357] Starting dynamic subtest: bcs0
[93.510028] Dynamic subtest bcs0: SUCCESS (0.059s)
[93.529483] Starting dynamic subtest: vcs0
[93.582255] Dynamic subtest vcs0: SUCCESS (0.069s)
[93.601722] Starting dynamic subtest: vecs0
[93.643906] Dynamic subtest vecs0: SUCCESS (0.062s)
[93.645161] Subtest noreorder: SUCCESS (0.259s)
[93.913330] [006/133] (954s left) gem_ctx_shared (disjoint-timelines)
[94.026572] Starting subtest: disjoint-timelines
[94.096393] Subtest disjoint-timelines: SUCCESS (0.070s)
[94.403920] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.vgem: true
[94.407805] [007/133] (954s left) gem_tiled_wb
[139.295154] [008/133] (909s left) gem_partial_pwrite_pread (write-snoop)
[139.399458] Starting subtest: write-snoop
[152.095900] Subtest write-snoop: SUCCESS (12.696s)
[152.302944] [009/133] (896s left) api_intel_allocator (fork-simple-stress-signal)
[152.396433] Starting subtest: fork-simple-stress-signal
[157.885917] Subtest fork-simple-stress-signal: SUCCESS (5.489s)
[158.051596] [010/133] (890s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[158.147411] Starting subtest: invalid-multi-wait-unsubmitted
[158.148470] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.001s)
[158.313105] [011/133] (890s left) gem_exec_gttfill (multigpu-basic)
[158.535943] Starting subtest: multigpu-basic
[181.560810] Subtest multigpu-basic: SUCCESS (23.027s)
[181.695355] [012/133] (867s left) gem_fence_thrash (bo-write-verify-threaded-y)
[181.848570] Starting subtest: bo-write-verify-threaded-y
[187.075768] Subtest bo-write-verify-threaded-y: SUCCESS (5.228s)
[187.261092] [013/133] (861s left) kms_pm_dc (dc3co-vpb-simulation)
[188.452939] Starting subtest: dc3co-vpb-simulation
[188.454691] Subtest dc3co-vpb-simulation: SKIP (0.000s)
[188.605221] [014/133] (860s left) i915_drm_fdinfo (busy-idle-check-all)
[188.705131] Starting subtest: busy-idle-check-all
[188.706037] Starting dynamic subtest: rcs0
[189.334954] Dynamic subtest rcs0: SUCCESS (0.630s)
[189.352581] Starting dynamic subtest: bcs0
[189.969512] Dynamic subtest bcs0: SUCCESS (0.633s)
[189.986905] Starting dynamic subtest: vcs0
[190.601980] Dynamic subtest vcs0: SUCCESS (0.632s)
[190.619854] Starting dynamic subtest: vecs0
[191.233072] Dynamic subtest vecs0: SUCCESS (0.630s)
[191.235114] Subtest busy-idle-check-all: SUCCESS (2.529s)
[191.379882] [015/133] (857s left) kms_psr (pr-cursor-plane-move)
[191.547133] Subtest pr-cursor-plane-move: SKIP (0.000s)
[191.653757] [016/133] (857s left) perf_pmu (idle-no-semaphores)
[191.752353] Starting subtest: idle-no-semaphores
[191.753239] Starting dynamic subtest: rcs0
[192.275289] Dynamic subtest rcs0: SUCCESS (0.521s)
[192.294835] Starting dynamic subtest: bcs0
[192.792429] Dynamic subtest bcs0: SUCCESS (0.515s)
[192.810029] Starting dynamic subtest: vcs0
[193.304588] Dynamic subtest vcs0: SUCCESS (0.513s)
[193.322682] Starting dynamic subtest: vecs0
[193.818875] Dynamic subtest vecs0: SUCCESS (0.512s)
[193.819986] Subtest idle-no-semaphores: SUCCESS (2.068s)
[193.983962] [017/133] (855s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[194.148600] Starting subtest: basic-busy-flip-before-cursor-varying-size
[194.150374] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[194.305958] [018/133] (855s left) syncobj_timeline (invalid-signal-zero-handles)
[194.397480] Starting subtest: invalid-signal-zero-handles
[194.398480] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[194.566704] [019/133] (855s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[194.728731] Starting subtest: fb-8bpc-vs-panel-8bpc
[194.729792] Starting dynamic subtest: pipe-A-HDMI-A-1
[195.470991] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.739s)
[195.495750] Starting dynamic subtest: pipe-A-HDMI-A-2
[195.964815] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.492s)
[195.965857] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.238s)
[196.268545] [020/133] (853s left) gem_mmap_offset (basic-uaf)
[196.357763] Starting subtest: basic-uaf
[196.362159] Subtest basic-uaf: SUCCESS (0.003s)
[196.539234] [021/133] (853s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[196.711583] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[199.076511] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SUCCESS (2.365s)
[199.370344] [022/133] (850s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[199.464450] Starting subtest: multi-wait-all-for-submit-signaled
[199.466475] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[199.629820] [023/133] (850s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[199.721954] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[199.830098] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.107s)
[199.995350] [024/133] (850s left) gem_eio (in-flight-internal-10ms)
[200.107264] Starting subtest: in-flight-internal-10ms
[200.205263] Subtest in-flight-internal-10ms: SUCCESS (0.098s)
[200.453439] [025/133] (849s left) gem_userptr_blits (map-fixed-invalidate-busy)
[200.573793] Starting subtest: map-fixed-invalidate-busy
[200.575230] Starting dynamic subtest: gtt
[203.559671] Dynamic subtest gtt: SUCCESS (2.986s)
[203.579460] Starting dynamic subtest: wb
[206.457584] Dynamic subtest wb: SUCCESS (2.897s)
[206.476202] Starting dynamic subtest: wc
[209.343497] Dynamic subtest wc: SUCCESS (2.884s)
[209.364437] Starting dynamic subtest: uc
[212.236748] Dynamic subtest uc: SUCCESS (2.893s)
[212.237854] Subtest map-fixed-invalidate-busy: SUCCESS (11.664s)
[212.468667] [026/133] (837s left) perf_pmu (busy)
[212.564399] Starting subtest: busy
[212.565445] Starting dynamic subtest: rcs0
[213.109982] Dynamic subtest rcs0: SUCCESS (0.545s)
[213.130966] Starting dynamic subtest: bcs0
[213.651039] Dynamic subtest bcs0: SUCCESS (0.540s)
[213.675580] Starting dynamic subtest: vcs0
[214.198455] Dynamic subtest vcs0: SUCCESS (0.546s)
[214.219987] Starting dynamic subtest: vecs0
[214.743833] Dynamic subtest vecs0: SUCCESS (0.544s)
[214.745223] Subtest busy: SUCCESS (2.179s)
[214.920216] [027/133] (835s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[215.085464] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[215.088558] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[217.272162] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (2.182s)
[217.291256] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[219.016176] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (1.741s)
[219.035533] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[220.708868] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.690s)
[220.710184] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (5.623s)
[221.026482] [028/133] (829s left) gem_exec_fence (expired-history)
[221.538853] Starting subtest: expired-history
[227.409789] Subtest expired-history: SUCCESS (5.875s)
[228.053860] [029/133] (822s left) gem_exec_params (batch-first)
[228.154627] Starting subtest: batch-first
[228.163816] Subtest batch-first: SUCCESS (0.009s)
[228.377645] [030/133] (822s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[228.551886] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[228.555953] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[239.532213] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.974s)
[239.552798] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[250.463893] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.929s)
[250.487330] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[261.381465] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.910s)
[261.382467] Subtest 2x-plain-flip-fb-recreate-interruptible: SUCCESS (32.826s)
[261.965790] [031/133] (788s left) gem_exec_balancer (hang)
[262.192956] Starting subtest: hang
[266.081751] Subtest hang: SUCCESS (3.889s)
[266.267687] [032/133] (784s left) kms_cursor_crc (cursor-onscreen-256x256)
[266.444218] Starting subtest: cursor-onscreen-256x256
[266.480219] Starting dynamic subtest: pipe-A-HDMI-A-1
[269.156733] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.676s)
[269.228195] Starting dynamic subtest: pipe-C-HDMI-A-1
[271.593616] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.378s)
[271.596096] Subtest cursor-onscreen-256x256: SUCCESS (5.146s)
[271.902042] [033/133] (779s left) gem_userptr_blits (vma-merge)
[272.036592] Starting subtest: vma-merge
[272.199740] Subtest vma-merge: SUCCESS (0.164s)
[272.368934] [034/133] (778s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[272.549530] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[272.553420] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[272.718324] [035/133] (778s left) gem_ctx_isolation (nonpriv)
[272.829968] Starting subtest: nonpriv
[272.831258] Starting dynamic subtest: rcs0
[274.792271] Dynamic subtest rcs0: SUCCESS (1.959s)
[274.811611] Starting dynamic subtest: bcs0
[277.192966] Dynamic subtest bcs0: SUCCESS (2.401s)
[277.217276] Starting dynamic subtest: vcs0
[279.075020] Dynamic subtest vcs0: SUCCESS (1.881s)
[279.094180] Starting dynamic subtest: vecs0
[280.989060] Dynamic subtest vecs0: SUCCESS (1.910s)
[280.990293] Subtest nonpriv: SUCCESS (8.158s)
[281.270972] [036/133] (769s left) gem_mmap_gtt (cpuset-medium-copy)
[281.364295] Starting subtest: cpuset-medium-copy
[289.914164] Subtest cpuset-medium-copy: SUCCESS (8.550s)
[290.155932] [037/133] (761s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[290.455052] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[290.457165] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[290.615773] [038/133] (760s left) gem_exec_schedule (preempt-user)
[290.752357] Starting subtest: preempt-user
[290.754117] Starting dynamic subtest: rcs0
[290.809122] Dynamic subtest rcs0: SUCCESS (0.055s)
[290.830398] Starting dynamic subtest: bcs0
[290.879170] Dynamic subtest bcs0: SUCCESS (0.070s)
[290.902345] Starting dynamic subtest: vcs0
[290.928892] Dynamic subtest vcs0: SUCCESS (0.048s)
[290.952421] Starting dynamic subtest: vecs0
[290.976887] Dynamic subtest vecs0: SUCCESS (0.046s)
[290.978728] Subtest preempt-user: SUCCESS (0.227s)
[291.402753] [039/133] (760s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[291.580294] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[291.582130] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[291.767305] [040/133] (759s left) kms_invalid_mode (bad-vsync-end)
[291.933487] Starting subtest: bad-vsync-end
[291.934440] Starting dynamic subtest: pipe-A-HDMI-A-1
[292.319797] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.386s)
[292.340352] Starting dynamic subtest: pipe-A-HDMI-A-2
[292.341291] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s)
[292.360862] Starting dynamic subtest: pipe-B-HDMI-A-1
[292.361893] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[292.381513] Starting dynamic subtest: pipe-B-HDMI-A-2
[292.382471] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s)
[292.401989] Starting dynamic subtest: pipe-C-HDMI-A-1
[292.402964] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[292.424618] Starting dynamic subtest: pipe-C-HDMI-A-2
[292.425566] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.001s)
[292.426384] Subtest bad-vsync-end: SUCCESS (0.415s)
[292.635675] [041/133] (759s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[292.795692] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[292.799267] Starting dynamic subtest: pipe-A-valid-mode
[293.749262] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.947s)
[293.750227] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SUCCESS (0.951s)
[294.056148] [042/133] (757s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[294.149527] Starting subtest: multi-wait-all-for-submit-submitted
[294.253861] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.103s)
[294.418999] [043/133] (757s left) core_getversion (all-cards)
[294.510794] Starting subtest: all-cards
[294.550350] Subtest all-cards: SUCCESS (0.041s)
[294.642911] [044/133] (757s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[294.809789] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[294.914987] [045/133] (757s left) kms_vblank (invalid)
[295.079868] Starting subtest: invalid
[295.082978] Starting dynamic subtest: pipe-A-HDMI-A-1
[295.701939] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.620s)
[295.702980] Subtest invalid: SUCCESS (0.624s)
[296.002304] [046/133] (756s left) gem_exec_schedule (u-submit-golden-slice)
[296.122779] Starting subtest: u-submit-golden-slice
[296.123960] Starting dynamic subtest: rcs0
[296.167091] Dynamic subtest rcs0: SUCCESS (0.043s)
[296.193703] Starting dynamic subtest: bcs0
[296.213363] Dynamic subtest bcs0: SUCCESS (0.044s)
[296.238515] Starting dynamic subtest: vcs0
[296.253283] Dynamic subtest vcs0: SUCCESS (0.038s)
[296.276955] Starting dynamic subtest: vecs0
[296.294781] Dynamic subtest vecs0: SUCCESS (0.039s)
[296.296313] Subtest u-submit-golden-slice: SUCCESS (0.174s)
[296.725854] [047/133] (755s left) i915_suspend (fence-restore-untiled)
[296.817311] Starting subtest: fence-restore-untiled
[316.974348] Subtest fence-restore-untiled: SUCCESS (4.596s)
[322.179024] [048/133] (735s left) kms_flip (modeset-vs-vblank-race)
[322.357932] Starting subtest: modeset-vs-vblank-race
[322.358879] Starting dynamic subtest: A-HDMI-A1
[325.218754] Dynamic subtest A-HDMI-A1: SUCCESS (2.785s)
[325.244070] Starting dynamic subtest: B-HDMI-A1
[327.682876] Dynamic subtest B-HDMI-A1: SUCCESS (2.409s)
[327.708664] Starting dynamic subtest: C-HDMI-A1
[330.130790] Dynamic subtest C-HDMI-A1: SUCCESS (2.405s)
[330.159125] Starting dynamic subtest: A-HDMI-A2
[332.706722] Dynamic subtest A-HDMI-A2: SUCCESS (2.545s)
[332.731807] Starting dynamic subtest: B-HDMI-A2
[335.158778] Dynamic subtest B-HDMI-A2: SUCCESS (2.423s)
[335.181514] Starting dynamic subtest: C-HDMI-A2
[337.598357] Dynamic subtest C-HDMI-A2: SUCCESS (2.421s)
[337.599446] Subtest modeset-vs-vblank-race: SUCCESS (15.009s)
[338.074304] [049/133] (719s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[338.293938] Starting subtest: yf-tiled-64bpp-rotate-180
[338.296420] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[338.456881] [050/133] (719s left) fbdev (pan)
[338.546001] Starting subtest: pan
[338.590823] Subtest pan: SUCCESS (0.046s)
[338.800136] [051/133] (718s left) gem_eio (in-flight-contexts-immediate)
[338.911070] Starting subtest: in-flight-contexts-immediate
[350.605913] Subtest in-flight-contexts-immediate: SUCCESS (11.667s)
[350.905545] [052/133] (706s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[351.083121] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[351.085285] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[351.256152] [053/133] (706s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[351.418453] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[351.419353] Starting dynamic subtest: pipe-A
[352.484547] Dynamic subtest pipe-A: SUCCESS (1.066s)
[352.511735] Starting dynamic subtest: pipe-B
[353.548680] Dynamic subtest pipe-B: SUCCESS (1.060s)
[353.575945] Starting dynamic subtest: pipe-C
[354.612432] Dynamic subtest pipe-C: SUCCESS (1.060s)
[354.617644] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (3.196s)
[355.118208] [054/133] (702s left) prime_mmap_coherency (write)
[355.222729] Starting subtest: write
[360.613569] Subtest write: SUCCESS (5.388s)
[361.091219] [055/133] (696s left) gem_exec_reloc (basic-write-read-noreloc)
[361.199799] Starting subtest: basic-write-read-noreloc
[361.204105] Subtest basic-write-read-noreloc: SUCCESS (0.007s)
[361.448457] [056/133] (696s left) kms_psr (fbc-psr-no-drrs)
[361.617375] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[361.727944] [057/133] (696s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[361.908468] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[363.446261] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.536s)
[363.782586] [058/133] (694s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[363.950442] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[364.062976] [059/133] (694s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[364.163096] Starting subtest: writes-after-reads-uncached
[382.230933] Subtest writes-after-reads-uncached: SUCCESS (18.060s)
[382.427889] [060/133] (676s left) kms_lease (possible-crtcs-filtering)
[382.594407] Starting subtest: possible-crtcs-filtering
[382.600847] Subtest possible-crtcs-filtering: SUCCESS (0.007s)
[382.774800] [061/133] (675s left) gem_exec_reloc (basic-wc-noreloc)
[382.881166] Starting subtest: basic-wc-noreloc
[382.890985] Subtest basic-wc-noreloc: SUCCESS (0.011s)
[383.136669] [062/133] (675s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[383.300749] Starting subtest: plane-upscale-factor-0-25-with-rotation
[383.301685] Starting dynamic subtest: pipe-A
[386.763535] Dynamic subtest pipe-A: SKIP (3.458s)
[386.786359] Starting dynamic subtest: pipe-B
[390.263790] Dynamic subtest pipe-B: SKIP (3.496s)
[390.293324] Starting dynamic subtest: pipe-C
[393.772560] Dynamic subtest pipe-C: SKIP (3.499s)
[393.776126] Subtest plane-upscale-factor-0-25-with-rotation: SKIP (10.464s)
[394.297016] [063/133] (664s left) gem_exec_fence (submit-chain)
[394.584222] Starting subtest: submit-chain
[394.602191] Subtest submit-chain: SUCCESS (0.021s)
[395.315032] [064/133] (663s left) i915_pm_rps (engine-order)
[395.419708] Starting subtest: engine-order
[407.278727] Subtest engine-order: SUCCESS (11.842s)
[407.551251] [065/133] (651s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[407.718834] Starting subtest: basic-max-pipe-crc-check
[407.720592] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[407.832894] [066/133] (651s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[407.927235] Starting subtest: single-wait-all-for-submit-available-signaled
[407.928280] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[408.089340] [067/133] (651s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[408.255334] Starting subtest: bad-aux-stride-y-tiled-ccs
[408.256361] Starting dynamic subtest: pipe-A-HDMI-A-1
[408.263957] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.003s)
[408.288113] Starting dynamic subtest: pipe-A-HDMI-A-2
[408.295849] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s)
[408.319387] Starting dynamic subtest: pipe-B-HDMI-A-1
[408.326933] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s)
[408.350200] Starting dynamic subtest: pipe-B-HDMI-A-2
[408.384963] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s)
[408.407956] Starting dynamic subtest: pipe-C-HDMI-A-1
[408.418317] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[408.441223] Starting dynamic subtest: pipe-C-HDMI-A-2
[408.449127] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[408.450368] Subtest bad-aux-stride-y-tiled-ccs: SUCCESS (0.038s)
[409.193008] [068/133] (650s left) prime_vgem (basic-fence-flip)
[409.316567] Starting subtest: basic-fence-flip
[409.790140] Subtest basic-fence-flip: SUCCESS (0.472s)
[409.981091] [069/133] (649s left) gen7_exec_parse (oacontrol-tracking)
[410.084830] Subtest oacontrol-tracking: SKIP (0.000s)
[410.199595] [070/133] (649s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[410.365569] Starting subtest: crc-primary-basic-y-tiled-ccs
[410.367438] Starting dynamic subtest: pipe-A-HDMI-A-1
[410.896289] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.525s)
[410.920387] Starting dynamic subtest: pipe-A-HDMI-A-2
[411.346170] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.444s)
[411.390399] Starting dynamic subtest: pipe-B-HDMI-A-1
[411.805203] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.453s)
[411.829236] Starting dynamic subtest: pipe-B-HDMI-A-2
[412.214996] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.404s)
[412.270760] Starting dynamic subtest: pipe-C-HDMI-A-1
[412.280004] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[412.303712] Starting dynamic subtest: pipe-C-HDMI-A-2
[412.312325] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[412.313282] Subtest crc-primary-basic-y-tiled-ccs: SUCCESS (1.862s)
[412.985964] [071/133] (646s left) kms_psr (psr2-cursor-mmap-gtt)
[413.154233] Subtest psr2-cursor-mmap-gtt: SKIP (0.000s)
[413.263888] [072/133] (646s left) api_intel_bb (lot-of-buffers)
[413.356016] Starting subtest: lot-of-buffers
[418.450777] Subtest lot-of-buffers: SUCCESS (5.095s)
[418.809060] [073/133] (640s left) kms_chamelium_hpd (common-hpd-after-suspend)
[419.344396] Subtest common-hpd-after-suspend: SKIP (0.000s)
[419.585849] [074/133] (640s left) syncobj_eventfd (binary-wait)
[419.681651] Starting subtest: binary-wait
[419.690519] Subtest binary-wait: SUCCESS (0.011s)
[419.853877] [075/133] (640s left) kms_psr (psr-primary-blt)
[420.020604] Subtest psr-primary-blt: SKIP (0.000s)
[420.130045] [076/133] (639s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[420.310101] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[420.311848] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[420.488238] [077/133] (639s left) gem_ctx_persistence (legacy-engines-hang)
[420.588545] Starting subtest: legacy-engines-hang
[420.593223] Starting dynamic subtest: render
[420.639271] Dynamic subtest render: SUCCESS (0.047s)
[420.667497] Starting dynamic subtest: bsd
[420.689541] Dynamic subtest bsd: SUCCESS (0.046s)
[420.719522] Starting dynamic subtest: blt
[420.721997] Dynamic subtest blt: SKIP (0.004s)
[420.757436] Starting dynamic subtest: vebox
[420.758722] Dynamic subtest vebox: SUCCESS (0.041s)
[420.759803] Subtest legacy-engines-hang: SUCCESS (0.156s)
[420.930081] [078/133] (639s left) kms_atomic (atomic-plane-damage)
[421.095910] Starting subtest: atomic-plane-damage
[421.997844] Subtest atomic-plane-damage: SKIP (0.902s)
[422.488177] [079/133] (637s left) sysfs_timeslice_duration (idempotent)
[422.598161] Starting subtest: idempotent
[422.601358] Starting dynamic subtest: vecs0
[422.602266] Dynamic subtest vecs0: SUCCESS (0.002s)
[422.629435] Starting dynamic subtest: vcs0
[422.630659] Dynamic subtest vcs0: SUCCESS (0.002s)
[422.660212] Starting dynamic subtest: bcs0
[422.661523] Dynamic subtest bcs0: SUCCESS (0.002s)
[422.685135] Starting dynamic subtest: rcs0
[422.686168] Dynamic subtest rcs0: SUCCESS (0.002s)
[422.687231] Subtest idempotent: SUCCESS (0.021s)
[422.773500] [080/133] (637s left) kms_fence_pin_leak
[426.074096] [081/133] (634s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[426.254764] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[428.852373] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (2.599s)
[429.197019] [082/133] (631s left) gem_exec_params (rel-constants-invalid-ring)
[429.301052] Starting subtest: rel-constants-invalid-ring
[429.302397] Subtest rel-constants-invalid-ring: SUCCESS (0.001s)
[429.478951] [083/133] (631s left) kms_color (ctm-0-75)
[429.647705] Starting subtest: ctm-0-75
[429.648535] Starting dynamic subtest: pipe-A-HDMI-A-1
[432.355596] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.707s)
[432.387970] Starting dynamic subtest: pipe-A-HDMI-A-2
[434.824739] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.463s)
[434.848732] Starting dynamic subtest: pipe-B-HDMI-A-1
[437.202103] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.374s)
[437.231335] Starting dynamic subtest: pipe-B-HDMI-A-2
[439.602056] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.395s)
[439.643086] Starting dynamic subtest: pipe-C-HDMI-A-1
[442.014620] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.403s)
[442.038485] Starting dynamic subtest: pipe-C-HDMI-A-2
[444.416621] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.403s)
[444.417656] Subtest ctm-0-75: SUCCESS (14.769s)
[444.725672] [084/133] (616s left) i915_query (query-topology-unsupported)
[444.831387] Starting subtest: query-topology-unsupported
[444.833286] Subtest query-topology-unsupported: SKIP (0.000s)
[445.000150] [085/133] (615s left) i915_hangman (engine-error-state-capture)
[445.114256] Starting subtest: engine-error-state-capture
[445.117705] Starting dynamic subtest: rcs0
[449.131318] Dynamic subtest rcs0: SUCCESS (4.015s)
[449.157889] Starting dynamic subtest: bcs0
[453.144552] Dynamic subtest bcs0: SUCCESS (4.009s)
[453.171906] Starting dynamic subtest: vcs0
[457.141054] Dynamic subtest vcs0: SUCCESS (3.992s)
[457.168208] Starting dynamic subtest: vecs0
[461.098801] Dynamic subtest vecs0: SUCCESS (3.953s)
[461.103353] Subtest engine-error-state-capture: SUCCESS (15.985s)
[461.330467] [086/133] (599s left) gem_pread (self)
[461.424042] Starting subtest: self
[461.466409] Subtest self: SUCCESS (0.043s)
[461.646824] [087/133] (599s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[461.816330] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (0.000s)
[461.925096] [088/133] (599s left) syncobj_wait (invalid-wait-illegal-handle)
[462.020347] Starting subtest: invalid-wait-illegal-handle
[462.021427] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[462.198711] [089/133] (599s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[462.381860] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[462.383726] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[462.561785] [090/133] (598s left) gem_userptr_blits (create-destroy-sync)
[462.684186] Starting subtest: create-destroy-sync
[467.719712] Subtest create-destroy-sync: SUCCESS (5.034s)
[467.968695] [091/133] (593s left) kms_addfb_basic (unused-modifier)
[468.060052] Starting subtest: unused-modifier
[468.061171] Subtest unused-modifier: SUCCESS (0.000s)
[468.327610] [092/133] (593s left) kms_properties (connector-properties-atomic)
[468.495982] Starting subtest: connector-properties-atomic
[468.498108] Starting dynamic subtest: pipe-A-HDMI-A-1
[470.293638] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.795s)
[470.321295] Starting dynamic subtest: pipe-A-HDMI-A-2
[472.004081] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.699s)
[472.005149] Subtest connector-properties-atomic: SUCCESS (3.504s)
[472.314416] [093/133] (589s left) kms_vblank (wait-forked)
[472.481763] Starting subtest: wait-forked
[472.485015] Starting dynamic subtest: pipe-A-HDMI-A-1
[475.175927] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.689s)
[475.202425] Starting dynamic subtest: pipe-A-HDMI-A-2
[477.636499] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.451s)
[477.664934] Starting dynamic subtest: pipe-C-HDMI-A-1
[480.073867] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.427s)
[480.097531] Starting dynamic subtest: pipe-C-HDMI-A-2
[482.506465] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.428s)
[482.509202] Subtest wait-forked: SUCCESS (10.021s)
[482.815429] [094/133] (578s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[482.995597] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[482.997341] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[483.181539] [095/133] (578s left) kms_content_protection (dp-mst-type-1)
[483.382773] Starting subtest: dp-mst-type-1
[483.386790] Subtest dp-mst-type-1: SKIP (0.000s)
[483.548902] [096/133] (578s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[483.716310] Starting subtest: primary-x-tiled-reflect-x-0
[483.718095] Subtest primary-x-tiled-reflect-x-0: SKIP (0.003s)
[483.867136] [097/133] (578s left) kms_big_fb (linear-32bpp-rotate-180)
[484.051370] Starting subtest: linear-32bpp-rotate-180
[489.929451] Subtest linear-32bpp-rotate-180: SUCCESS (5.878s)
[490.501571] [098/133] (571s left) gem_exercise_blt (fast-copy-emit)
[490.602315] Starting subtest: fast-copy-emit
[490.603579] Starting dynamic subtest: linear-smem-smem-emit
[490.650421] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.047s)
[490.679195] Starting dynamic subtest: ymajor-smem-smem-emit
[490.694658] Dynamic subtest ymajor-smem-smem-emit: SUCCESS (0.041s)
[490.720834] Starting dynamic subtest: yfmajor-smem-smem-emit
[490.739168] Dynamic subtest yfmajor-smem-smem-emit: SUCCESS (0.039s)
[490.763030] Starting dynamic subtest: tile64-smem-smem-emit
[490.778639] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.039s)
[490.783070] Subtest fast-copy-emit: SUCCESS (0.178s)
[490.965897] [099/133] (571s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[491.143949] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[491.145804] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[491.334551] [100/133] (570s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[491.499843] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[491.729517] Starting dynamic subtest: pipe-A-plane-0
[492.029357] Dynamic subtest pipe-A-plane-0: SUCCESS (0.299s)
[492.065433] Starting dynamic subtest: pipe-A-plane-1
[492.311830] Dynamic subtest pipe-A-plane-1: SUCCESS (0.279s)
[492.339213] Starting dynamic subtest: pipe-A-plane-2
[492.578986] Dynamic subtest pipe-A-plane-2: SUCCESS (0.264s)
[492.617416] Starting dynamic subtest: pipe-A-plane-3
[492.845680] Dynamic subtest pipe-A-plane-3: SUCCESS (0.263s)
[492.872172] Starting dynamic subtest: pipe-A-plane-4
[492.874010] Dynamic subtest pipe-A-plane-4: SKIP (0.000s)
[493.212240] Starting dynamic subtest: pipe-B-plane-0
[493.456298] Dynamic subtest pipe-B-plane-0: SUCCESS (0.266s)
[493.490445] Starting dynamic subtest: pipe-B-plane-1
[493.739497] Dynamic subtest pipe-B-plane-1: SUCCESS (0.280s)
[493.773707] Starting dynamic subtest: pipe-B-plane-2
[494.006425] Dynamic subtest pipe-B-plane-2: SUCCESS (0.264s)
[494.033768] Starting dynamic subtest: pipe-B-plane-3
[494.273078] Dynamic subtest pipe-B-plane-3: SUCCESS (0.264s)
[494.301796] Starting dynamic subtest: pipe-B-plane-4
[494.324452] Dynamic subtest pipe-B-plane-4: SKIP (0.000s)
[494.488887] Subtest pixel-format-yf-tiled-ccs-modifier: SUCCESS (2.985s)
[494.801560] [101/133] (567s left) kms_psr (fbc-psr2-dpms)
[494.970357] Subtest fbc-psr2-dpms: SKIP (0.000s)
[495.081872] [102/133] (567s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[495.246738] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[495.247639] Starting dynamic subtest: pipe-A-HDMI-A-1
[495.288894] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.012s)
[495.314052] Starting dynamic subtest: pipe-A-HDMI-A-2
[495.364307] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.013s)
[495.389337] Starting dynamic subtest: pipe-B-HDMI-A-1
[495.431196] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.011s)
[495.454704] Starting dynamic subtest: pipe-B-HDMI-A-2
[495.487318] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.011s)
[495.510514] Starting dynamic subtest: pipe-C-HDMI-A-1
[495.545337] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.014s)
[495.568984] Starting dynamic subtest: pipe-C-HDMI-A-2
[495.605499] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.013s)
[495.607340] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.106s)
[496.256375] [103/133] (566s left) perf (i915-ref-count)
[496.471705] Starting subtest: i915-ref-count
[496.558859] Subtest i915-ref-count: SUCCESS (0.090s)
[496.684244] [104/133] (565s left) gem_exec_reloc (basic-wc-cpu-active)
[496.789964] Starting subtest: basic-wc-cpu-active
[496.928169] Subtest basic-wc-cpu-active: SUCCESS (0.140s)
[497.176176] [105/133] (565s left) kms_hdr (invalid-metadata-sizes)
[497.341139] Starting subtest: invalid-metadata-sizes
[524.424719] Subtest invalid-metadata-sizes: SKIP (27.076s)
[524.876368] [106/133] (537s left) vgem_basic (mmap)
[525.007835] Starting subtest: mmap
[525.025507] Subtest mmap: SUCCESS (0.019s)
[525.179410] [107/133] (537s left) kms_busy (extended-modeset-hang-oldfb)
[525.357711] Starting subtest: extended-modeset-hang-oldfb
[525.358969] Starting dynamic subtest: pipe-A
[529.782826] Dynamic subtest pipe-A: SUCCESS (4.415s)
[529.806785] Starting dynamic subtest: pipe-C
[533.719749] Dynamic subtest pipe-C: SUCCESS (3.934s)
[533.721726] Subtest extended-modeset-hang-oldfb: SUCCESS (8.363s)
[534.048590] [108/133] (528s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[534.228107] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[536.380096] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SUCCESS (2.151s)
[536.634664] [109/133] (526s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[536.806807] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[536.807772] Starting dynamic subtest: pipe-A-valid-mode
[537.681351] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.870s)
[537.682382] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SUCCESS (0.875s)
[538.012547] [110/133] (525s left) gem_exec_reloc (basic-gtt-active)
[538.116375] Starting subtest: basic-gtt-active
[538.261079] Subtest basic-gtt-active: SUCCESS (0.144s)
[538.495228] [111/133] (524s left) gem_mmap (short-mmap)
[538.590965] Starting subtest: short-mmap
[538.592271] Subtest short-mmap: SUCCESS (0.000s)
[538.762936] [112/133] (524s left) kms_plane_cursor (primary)
[538.931537] Starting subtest: primary
[538.933572] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[541.554985] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.622s)
[541.629622] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[544.037141] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.431s)
[544.113038] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[546.554928] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.466s)
[546.813038] Starting dynamic subtest: pipe-B-HDMI-A-2-size-64
[549.308105] Dynamic subtest pipe-B-HDMI-A-2-size-64: SUCCESS (2.519s)
[549.364653] Starting dynamic subtest: pipe-B-HDMI-A-2-size-128
[551.790773] Dynamic subtest pipe-B-HDMI-A-2-size-128: SUCCESS (2.449s)
[551.847496] Starting dynamic subtest: pipe-B-HDMI-A-2-size-256
[554.273881] Dynamic subtest pipe-B-HDMI-A-2-size-256: SUCCESS (2.449s)
[554.512970] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64
[557.012120] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (2.522s)
[557.073516] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128
[559.479193] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (2.431s)
[559.534922] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256
[561.960827] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (2.449s)
[562.177887] Subtest primary: SUCCESS (23.253s)
[562.477783] [113/133] (500s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[562.660359] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[562.665509] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[567.153054] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (4.489s)
[567.181038] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[571.620194] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (4.460s)
[571.646709] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[575.937038] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (4.313s)
[575.940793] Subtest 2x-modeset-vs-vblank-race-interruptible: SUCCESS (13.278s)
[576.537265] [114/133] (487s left) syncobj_timeline (reset-during-wait-for-submit)
[576.656914] Starting subtest: reset-during-wait-for-submit
[576.758870] Subtest reset-during-wait-for-submit: SUCCESS (0.104s)
[576.914919] [115/133] (486s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[577.095527] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[577.097533] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[577.283108] [116/133] (486s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[577.468460] Starting subtest: x-tiled-32bpp-rotate-270
[577.757290] Subtest x-tiled-32bpp-rotate-270: SKIP (0.288s)
[578.050222] [117/133] (485s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[578.152199] Starting subtest: no-spare-fences-busy-interruptible
[580.343637] Subtest no-spare-fences-busy-interruptible: SUCCESS (2.189s)
[580.582766] [118/133] (483s left) kms_cursor_crc (cursor-random-64x64)
[580.757564] Starting subtest: cursor-random-64x64
[580.793147] Starting dynamic subtest: pipe-A-HDMI-A-1
[584.937506] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.141s)
[585.014027] Starting dynamic subtest: pipe-C-HDMI-A-1
[588.844422] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.850s)
[588.845300] Subtest cursor-random-64x64: SUCCESS (8.085s)
[589.174085] [119/133] (474s left) gem_create (create-ext-cpu-access-big)
[589.387582] Starting subtest: create-ext-cpu-access-big
[589.389734] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[589.558766] [120/133] (474s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[590.080384] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[590.327554] [121/133] (473s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[590.491373] Starting subtest: random-ccs-data-y-tiled-ccs
[590.493295] Starting dynamic subtest: pipe-A-HDMI-A-1
[590.926148] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.428s)
[590.950076] Starting dynamic subtest: pipe-A-HDMI-A-2
[591.359104] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.426s)
[591.382808] Starting dynamic subtest: pipe-B-HDMI-A-1
[591.819495] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.456s)
[591.843404] Starting dynamic subtest: pipe-B-HDMI-A-2
[592.246388] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.421s)
[592.270900] Starting dynamic subtest: pipe-C-HDMI-A-1
[592.280753] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[592.304950] Starting dynamic subtest: pipe-C-HDMI-A-2
[592.314098] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[592.314978] Subtest random-ccs-data-y-tiled-ccs: SUCCESS (1.763s)
[592.971796] [122/133] (471s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[593.159998] Starting subtest: 4-tiled-32bpp-rotate-180
[593.162299] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s)
[593.336715] [123/133] (471s left) kms_addfb_basic (addfb25-4-tiled)
[593.502597] Starting subtest: addfb25-4-tiled
[593.503672] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[593.671432] [124/133] (470s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[593.849380] Starting subtest: fbcpsr-indfb-scaledprimary
[593.851330] Subtest fbcpsr-indfb-scaledprimary: SKIP (0.000s)
[594.019569] [125/133] (470s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[594.188153] Starting subtest: cursorB-vs-flipA-varying-size
[605.484581] Subtest cursorB-vs-flipA-varying-size: SUCCESS (11.294s)
[605.809264] [126/133] (458s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[605.998402] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[608.919535] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (2.920s)
[609.242807] [127/133] (455s left) kms_pm_rpm (package-g7)
[611.115855] Starting subtest: package-g7
[611.117773] Subtest package-g7: SKIP (0.000s)
[611.480397] [128/133] (453s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[611.660116] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[611.661946] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[611.862563] [129/133] (453s left) kms_flip (flip-vs-expired-vblank)
[612.027442] Starting subtest: flip-vs-expired-vblank
[612.031019] Starting dynamic subtest: A-HDMI-A1
[617.662193] Dynamic subtest A-HDMI-A1: SUCCESS (5.629s)
[617.691808] Starting dynamic subtest: B-HDMI-A1
[623.044988] Dynamic subtest B-HDMI-A1: SUCCESS (5.379s)
[623.074223] Starting dynamic subtest: C-HDMI-A1
[628.426086] Dynamic subtest C-HDMI-A1: SUCCESS (5.376s)
[628.456489] Starting dynamic subtest: A-HDMI-A2
[633.817925] Dynamic subtest A-HDMI-A2: SUCCESS (5.387s)
[633.844976] Starting dynamic subtest: B-HDMI-A2
[639.199079] Dynamic subtest B-HDMI-A2: SUCCESS (5.373s)
[639.223192] Starting dynamic subtest: C-HDMI-A2
[644.579337] Dynamic subtest C-HDMI-A2: SUCCESS (5.379s)
[644.581228] Subtest flip-vs-expired-vblank: SUCCESS (32.552s)
[645.068286] [130/133] (420s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[645.255450] Starting subtest: y-tiled-64bpp-rotate-0
[652.578668] Subtest y-tiled-64bpp-rotate-0: SUCCESS (7.321s)
[653.601026] [131/133] (411s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[653.790682] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[657.046133] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (3.254s)
[657.351329] [132/133] (407s left) gem_ringfill (legacy-basic)
[657.693069] Starting subtest: legacy-basic
[657.694072] Starting dynamic subtest: default
[657.714592] Dynamic subtest default: SUCCESS (0.022s)
[657.745759] Starting dynamic subtest: render
[657.747407] Dynamic subtest render: SUCCESS (0.028s)
[657.776921] Starting dynamic subtest: bsd
[657.777932] Dynamic subtest bsd: SUCCESS (0.016s)
[657.805387] Starting dynamic subtest: bsd1
[657.807256] Dynamic subtest bsd1: SUCCESS (0.022s)
[657.832968] Starting dynamic subtest: blt
[657.834373] Dynamic subtest blt: SUCCESS (0.025s)
[657.863017] Starting dynamic subtest: vebox
[657.864775] Dynamic subtest vebox: SUCCESS (0.016s)
[657.866092] Subtest legacy-basic: SUCCESS (0.153s)
[658.022989] [133/133] (407s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[658.133999] Starting subtest: x-tiled-to-vebox-y-tiled
[658.135763] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[658.402192] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: i915_query
results: parsing output: 2/ for test: gem_spin_batch
results: parsing output: 3/ for test: kms_draw_crc
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: gem_ctx_shared
results: parsing output: 6/ for test: gem_tiled_wb
results: parsing output: 7/ for test: gem_partial_pwrite_pread
results: parsing output: 8/ for test: api_intel_allocator
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: gem_exec_gttfill
results: parsing output: 11/ for test: gem_fence_thrash
results: parsing output: 12/ for test: kms_pm_dc
results: parsing output: 13/ for test: i915_drm_fdinfo
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: perf_pmu
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_dither
results: parsing output: 19/ for test: gem_mmap_offset
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: syncobj_wait
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: gem_eio
results: parsing output: 24/ for test: gem_userptr_blits
results: parsing output: 25/ for test: perf_pmu
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: gem_exec_fence
results: parsing output: 28/ for test: gem_exec_params
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: gem_exec_balancer
results: parsing output: 31/ for test: kms_cursor_crc
results: parsing output: 32/ for test: gem_userptr_blits
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_ctx_isolation
results: parsing output: 35/ for test: gem_mmap_gtt
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_invalid_mode
results: parsing output: 40/ for test: kms_flip_scaled_crc
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: core_getversion
results: parsing output: 43/ for test: kms_psr2_sf
results: parsing output: 44/ for test: kms_vblank
results: parsing output: 45/ for test: gem_exec_schedule
results: parsing output: 46/ for test: i915_suspend
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: fbdev
results: parsing output: 50/ for test: gem_eio
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_plane_scaling
results: parsing output: 53/ for test: prime_mmap_coherency
results: parsing output: 54/ for test: gem_exec_reloc
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_psr2_sf
results: parsing output: 58/ for test: gem_partial_pwrite_pread
results: parsing output: 59/ for test: kms_lease
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: kms_plane_scaling
results: parsing output: 62/ for test: gem_exec_fence
results: parsing output: 63/ for test: i915_pm_rps
results: parsing output: 64/ for test: kms_multipipe_modeset
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: prime_vgem
results: parsing output: 68/ for test: gen7_exec_parse
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: api_intel_bb
results: parsing output: 72/ for test: kms_chamelium_hpd
results: parsing output: 73/ for test: syncobj_eventfd
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_ctx_persistence
results: parsing output: 77/ for test: kms_atomic
results: parsing output: 78/ for test: sysfs_timeslice_duration
results: parsing output: 79/ for test: kms_fence_pin_leak
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_exec_params
results: parsing output: 82/ for test: kms_color
results: parsing output: 83/ for test: i915_query
results: parsing output: 84/ for test: i915_hangman
results: parsing output: 85/ for test: gem_pread
results: parsing output: 86/ for test: kms_psr2_sf
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_userptr_blits
results: parsing output: 90/ for test: kms_addfb_basic
results: parsing output: 91/ for test: kms_properties
results: parsing output: 92/ for test: kms_vblank
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_content_protection
results: parsing output: 95/ for test: kms_rotation_crc
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: gem_exercise_blt
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_plane
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: perf
results: parsing output: 103/ for test: gem_exec_reloc
results: parsing output: 104/ for test: kms_hdr
results: parsing output: 105/ for test: vgem_basic
results: parsing output: 106/ for test: kms_busy
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_flip_scaled_crc
results: parsing output: 109/ for test: gem_exec_reloc
results: parsing output: 110/ for test: gem_mmap
results: parsing output: 111/ for test: kms_plane_cursor
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: gem_fenced_exec_thrash
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: gem_create
results: parsing output: 119/ for test: kms_chamelium_edid
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_addfb_basic
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_pm_rpm
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_ringfill
results: parsing output: 132/ for test: gem_render_copy
Done.