[57.808240] Initializing watchdogs
[57.808289]   /dev/watchdog0
[57.822905] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.827162] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.829601] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.833245] [001/133] (960s left) gem_exec_params (dr4-dirt)
[57.913841] Starting subtest: DR4-dirt
[57.916176] Subtest DR4-dirt: SUCCESS (0.000s)
[58.010322] [002/133] (960s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[58.105698] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[58.108009] Starting dynamic subtest: pipe-A
[58.367053] Dynamic subtest pipe-A: SUCCESS (0.262s)
[58.380930] Starting dynamic subtest: pipe-B
[59.657244] Dynamic subtest pipe-B: SUCCESS (1.289s)
[59.665516] Starting dynamic subtest: pipe-C
[60.997064] Dynamic subtest pipe-C: SUCCESS (1.339s)
[61.003682] Starting dynamic subtest: pipe-D
[62.339102] Dynamic subtest pipe-D: SUCCESS (1.341s)
[62.341511] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.235s)
[63.498144] [003/133] (954s left) kms_psr (psr2-cursor-blt)
[63.591089] Starting subtest: psr2-cursor-blt
[63.593420] Starting dynamic subtest: eDP-1
[65.262355] Dynamic subtest eDP-1: SUCCESS (1.672s)
[65.264951] Subtest psr2-cursor-blt: SUCCESS (1.672s)
[66.055998] [004/133] (952s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[66.156324] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[66.181426] Starting dynamic subtest: pipe-A-plane-0
[66.603988] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[66.612974] Starting dynamic subtest: pipe-A-plane-3
[66.870170] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s)
[67.946485] Starting dynamic subtest: pipe-B-plane-0
[68.384447] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[68.392366] Starting dynamic subtest: pipe-B-plane-3
[68.639901] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[68.955511] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.800s)
[69.827386] [005/133] (948s left) kms_atomic (plane-primary-legacy)
[69.942152] Starting subtest: plane-primary-legacy
[69.944334] Starting dynamic subtest: pipe-A-eDP-1
[70.414279] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.472s)
[70.416648] Subtest plane-primary-legacy: SUCCESS (0.473s)
[71.233563] [006/133] (947s left) syncobj_wait (signal)
[71.298554] Starting subtest: signal
[71.300938] Subtest signal: SUCCESS (0.000s)
[71.382658] [007/133] (947s left) gem_create (busy-create)
[71.437905] Starting subtest: busy-create
[71.440018] Starting dynamic subtest: smem0
[104.920526] Dynamic subtest smem0: SUCCESS (33.481s)
[104.922943] Subtest busy-create: SUCCESS (33.482s)
[105.098313] [008/133] (913s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[105.198293] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[105.200684] Starting dynamic subtest: pipe-A
[105.537484] Dynamic subtest pipe-A: SUCCESS (0.339s)
[105.546992] Starting dynamic subtest: pipe-B
[106.947234] Dynamic subtest pipe-B: SUCCESS (1.409s)
[106.955886] Starting dynamic subtest: pipe-C
[108.363408] Dynamic subtest pipe-C: SUCCESS (1.416s)
[108.372776] Starting dynamic subtest: pipe-D
[109.802278] Dynamic subtest pipe-D: SUCCESS (1.438s)
[109.804755] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.604s)
[110.958917] [009/133] (907s left) kms_flip (bo-too-big)
[111.055192] Starting subtest: bo-too-big
[111.057074] Starting dynamic subtest: A-eDP1
[112.317130] Dynamic subtest A-eDP1: SUCCESS (1.264s)
[112.328932] Starting dynamic subtest: B-eDP1
[113.643066] Dynamic subtest B-eDP1: SUCCESS (1.324s)
[113.650772] Starting dynamic subtest: C-eDP1
[114.991288] Dynamic subtest C-eDP1: SUCCESS (1.347s)
[115.002080] Starting dynamic subtest: D-eDP1
[116.315972] Dynamic subtest D-eDP1: SUCCESS (1.323s)
[116.321114] Subtest bo-too-big: SUCCESS (5.269s)
[117.515430] [010/133] (901s left) kms_invalid_mode (overflow-vrefresh)
[117.600323] Starting subtest: overflow-vrefresh
[117.602686] Starting dynamic subtest: pipe-A-eDP-1
[117.883656] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[117.892062] Starting dynamic subtest: pipe-B-eDP-1
[117.894333] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[117.901231] Starting dynamic subtest: pipe-C-eDP-1
[117.903583] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[117.910568] Starting dynamic subtest: pipe-D-eDP-1
[117.912960] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[117.915738] Subtest overflow-vrefresh: SUCCESS (0.289s)
[118.741093] [011/133] (899s left) sysfs_timeslice_duration (timeout)
[118.801738] Starting subtest: timeout
[118.804287] Starting dynamic subtest: vecs0
[127.894871] Dynamic subtest vecs0: SUCCESS (9.090s)
[127.902715] Starting dynamic subtest: ccs0
[129.142887] Dynamic subtest ccs0: SUCCESS (1.248s)
[129.156869] Starting dynamic subtest: vcs0
[138.900955] Dynamic subtest vcs0: SUCCESS (9.756s)
[138.912859] Starting dynamic subtest: bcs0
[139.547878] Dynamic subtest bcs0: SUCCESS (0.648s)
[139.557475] Starting dynamic subtest: rcs0
[140.843795] Dynamic subtest rcs0: SUCCESS (1.292s)
[140.853594] Starting dynamic subtest: vcs1
[150.936864] Dynamic subtest vcs1: SUCCESS (10.091s)
[150.939371] Subtest timeout: SUCCESS (32.132s)
[151.036577] [012/133] (867s left) kms_psr (psr-sprite-blt)
[151.138786] Starting subtest: psr-sprite-blt
[151.141075] Starting dynamic subtest: eDP-1
[152.854358] Dynamic subtest eDP-1: SUCCESS (1.715s)
[152.856780] Subtest psr-sprite-blt: SUCCESS (1.716s)
[153.694138] [013/133] (865s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[153.749598] Starting subtest: stress-mm-invalidate-close-overlap
[155.896557] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[156.012690] [014/133] (862s left) kms_prop_blob (blob-prop-lifetime)
[156.085083] Starting subtest: blob-prop-lifetime
[156.087465] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[156.197358] [015/133] (862s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[156.303361] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[163.309218] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.009s)
[164.515631] [016/133] (854s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[164.612740] Starting subtest: extended-modeset-hang-oldfb-with-reset
[164.615193] Starting dynamic subtest: pipe-A
[176.590541] Dynamic subtest pipe-A: SUCCESS (11.977s)
[176.602827] Starting dynamic subtest: pipe-D
[188.866331] Dynamic subtest pipe-D: SUCCESS (12.273s)
[188.868539] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.254s)
[189.666972] [017/133] (829s left) gem_ctx_shared (single-timeline)
[189.748239] Starting subtest: single-timeline
[189.768206] Subtest single-timeline: SUCCESS (0.014s)
[189.981792] [018/133] (828s left) perf_pmu (busy-check-all)
[190.017017] Starting subtest: busy-check-all
[190.019323] Starting dynamic subtest: rcs0
[190.568765] Dynamic subtest rcs0: SUCCESS (0.552s)
[190.580093] Starting dynamic subtest: bcs0
[191.116552] Dynamic subtest bcs0: SUCCESS (0.547s)
[191.130739] Starting dynamic subtest: vcs0
[192.917043] Dynamic subtest vcs0: SUCCESS (1.798s)
[192.927884] Starting dynamic subtest: vcs1
[194.900548] Dynamic subtest vcs1: SUCCESS (1.982s)
[194.911939] Starting dynamic subtest: vecs0
[196.884373] Dynamic subtest vecs0: SUCCESS (1.982s)
[196.894994] Starting dynamic subtest: ccs0
[197.438259] Dynamic subtest ccs0: SUCCESS (0.554s)
[197.440713] Subtest busy-check-all: SUCCESS (7.423s)
[197.545661] [019/133] (821s left) gem_userptr_blits (probe)
[197.627116] Starting subtest: probe
[197.702669] Subtest probe: SUCCESS (0.075s)
[197.806206] [020/133] (821s left) i915_drm_fdinfo (most-busy-idle-check-all)
[197.846873] Starting subtest: most-busy-idle-check-all
[197.848807] Starting dynamic subtest: rcs0
[197.853498] Dynamic subtest rcs0: SKIP (0.004s)
[197.862409] Starting dynamic subtest: bcs0
[197.866893] Dynamic subtest bcs0: SKIP (0.000s)
[197.874607] Starting dynamic subtest: vcs0
[197.879101] Dynamic subtest vcs0: SKIP (0.000s)
[197.886582] Starting dynamic subtest: vcs1
[197.890988] Dynamic subtest vcs1: SKIP (0.000s)
[197.898586] Starting dynamic subtest: vecs0
[197.903100] Dynamic subtest vecs0: SKIP (0.000s)
[197.910178] Starting dynamic subtest: ccs0
[197.914218] Dynamic subtest ccs0: SKIP (0.000s)
[197.918202] Subtest most-busy-idle-check-all: SKIP (0.008s)
[197.952184] [021/133] (821s left) kms_big_fb (linear-16bpp-rotate-0)
[198.077721] Starting subtest: linear-16bpp-rotate-0
[199.544895] Subtest linear-16bpp-rotate-0: SUCCESS (1.467s)
[199.686144] [022/133] (819s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[199.792042] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[199.795389] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[199.876753] [023/133] (819s left) gem_readwrite (new-obj)
[199.934873] Subtest new-obj: SKIP (0.000s)
[199.993548] [024/133] (819s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[200.085515] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[200.089077] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[200.192565] [025/133] (819s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[200.288300] Starting subtest: flip-vs-dpms-off-vs-modeset
[200.289967] Starting dynamic subtest: A-eDP1
[203.890496] Dynamic subtest A-eDP1: SUCCESS (3.601s)
[203.899691] Starting dynamic subtest: B-eDP1
[207.088121] Dynamic subtest B-eDP1: SUCCESS (3.197s)
[207.105588] Starting dynamic subtest: C-eDP1
[210.195864] Dynamic subtest C-eDP1: SUCCESS (3.108s)
[210.203974] Starting dynamic subtest: D-eDP1
[213.336226] Dynamic subtest D-eDP1: SUCCESS (3.139s)
[213.338639] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.051s)
[214.158291] [026/133] (805s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[214.269299] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[214.271527] Starting dynamic subtest: pipe-A-eDP-1
[214.715911] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.418s)
[214.726272] Starting dynamic subtest: pipe-B-eDP-1
[216.159772] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.443s)
[216.169548] Starting dynamic subtest: pipe-C-eDP-1
[217.542631] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.382s)
[217.553159] Starting dynamic subtest: pipe-D-eDP-1
[218.869631] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[218.871728] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.575s)
[220.044728] [027/133] (799s left) syncobj_wait (wait-any-interrupted)
[220.105622] Starting subtest: wait-any-interrupted
[220.208171] Subtest wait-any-interrupted: SUCCESS (0.103s)
[220.280320] [028/133] (799s left) kms_selftest (drm_plane_helper)
[220.318864] Starting subtest: drm_plane_helper
[220.362919] Starting dynamic subtest: drm_test_check_plane_state
[220.479441] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.115s)
[220.488549] Starting dynamic subtest: drm_test_check_invalid_plane_state
[220.568958] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.090s)
[220.571450] Subtest drm_plane_helper: SUCCESS (0.250s)
[220.729730] [029/133] (798s left) kms_lease (lease-uevent)
[220.813918] Starting subtest: lease-uevent
[221.821341] Subtest lease-uevent: SUCCESS (1.010s)
[221.898050] [030/133] (797s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[222.039754] Starting subtest: dp-mst-type-1-suspend-resume
[222.044649] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[222.165249] [031/133] (797s left) syncobj_wait (wait-all-delayed-signal)
[222.215059] Starting subtest: wait-all-delayed-signal
[222.318566] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[222.405167] [032/133] (797s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[222.465706] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[222.524904] [033/133] (797s left) syncobj_wait (wait-all-for-submit-complex)
[222.578720] Starting subtest: wait-all-for-submit-complex
[222.791880] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[222.870670] [034/133] (796s left) core_setmaster (master-drop-set-root)
[222.934426] Starting subtest: master-drop-set-root
[222.950078] Subtest master-drop-set-root: SUCCESS (0.016s)
[222.997252] [035/133] (796s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[223.130059] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[223.134496] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[224.270074] [036/133] (795s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[224.336653] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[224.341531] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[224.517777] [037/133] (795s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[224.623850] Starting subtest: 4-tiled-32bpp-rotate-180
[226.005955] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.382s)
[226.127408] [038/133] (793s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[226.247636] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[232.994793] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.750s)
[233.092775] [039/133] (786s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[233.184312] Starting subtest: bad-rotation-90-yf-tiled-ccs
[233.186554] Starting dynamic subtest: pipe-A-eDP-1
[233.209281] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[233.219574] Starting dynamic subtest: pipe-B-eDP-1
[233.241243] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[233.248892] Starting dynamic subtest: pipe-C-eDP-1
[233.270441] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[233.278180] Starting dynamic subtest: pipe-D-eDP-1
[233.300174] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[233.304193] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.004s)
[235.349575] [040/133] (784s left) gem_mmap_wc (coherency)
[235.399125] Subtest coherency: SKIP (0.000s)
[235.463645] [041/133] (784s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[235.511663] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[235.513969] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[235.597563] [042/133] (784s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[235.689622] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[235.693980] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[235.790915] [043/133] (784s left) kms_plane_alpha_blend (constant-alpha-mid)
[235.886439] Starting subtest: constant-alpha-mid
[236.186860] Starting dynamic subtest: pipe-A-eDP-1
[236.980573] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.792s)
[236.989150] Starting dynamic subtest: pipe-D-eDP-1
[238.445606] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.463s)
[238.447609] Subtest constant-alpha-mid: SUCCESS (2.561s)
[239.324064] [044/133] (780s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[239.419113] Starting subtest: psr2-overlay-plane-update-continuous-sf
[239.421354] Starting dynamic subtest: pipe-A-eDP-1
[240.528278] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.113s)
[240.537048] Starting dynamic subtest: pipe-B-eDP-1
[242.281530] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.751s)
[242.283518] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.867s)
[243.097495] [045/133] (776s left) gem_exec_whisper (basic-contexts-priority)
[243.171966] Starting subtest: basic-contexts-priority
[266.645231] Subtest basic-contexts-priority: SUCCESS (23.469s)
[266.822210] [046/133] (753s left) kms_feature_discovery (chamelium)
[266.922910] Starting subtest: chamelium
[266.927258] Subtest chamelium: SKIP (0.000s)
[267.003059] [047/133] (753s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[267.127940] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[267.277937] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.151s)
[267.400591] [048/133] (752s left) gem_exec_balancer (persistence)
[267.656027] Starting subtest: persistence
[268.541373] Subtest persistence: SUCCESS (0.886s)
[268.665696] [049/133] (751s left) gem_render_copy (linear)
[268.728363] Starting subtest: linear
[268.730561] Starting dynamic subtest: smem
[268.763798] Dynamic subtest smem: SUCCESS (0.038s)
[268.766189] Subtest linear: SUCCESS (0.039s)
[268.945923] [050/133] (751s left) i915_pm_rps (thresholds)
[269.001820] Starting subtest: thresholds
[269.006265] Subtest thresholds: SKIP (0.001s)
[269.111951] [051/133] (751s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[269.212521] Starting subtest: yf-tiled-32bpp-rotate-0
[269.217039] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[269.314729] [052/133] (750s left) api_intel_bb (object-reloc-purge-cache)
[269.367774] Starting subtest: object-reloc-purge-cache
[269.371959] Subtest object-reloc-purge-cache: SKIP (0.002s)
[269.476983] [053/133] (750s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[269.565312] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[269.569214] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[269.668648] [054/133] (750s left) kms_chamelium_hpd (hdmi-hpd-storm)
[270.045556] Subtest hdmi-hpd-storm: SKIP (0.000s)
[270.897494] [055/133] (749s left) gem_caching (writes)
[270.970627] Subtest writes: SKIP (0.000s)
[271.039570] [056/133] (749s left) kms_cursor_legacy (forked-bo)
[271.159073] Starting subtest: forked-bo
[271.161488] Starting dynamic subtest: pipe-A
[276.613065] Dynamic subtest pipe-A: SUCCESS (5.451s)
[276.625041] Starting dynamic subtest: pipe-B
[282.093962] Dynamic subtest pipe-B: SUCCESS (5.478s)
[282.108577] Starting dynamic subtest: pipe-C
[287.573195] Dynamic subtest pipe-C: SUCCESS (5.476s)
[287.588429] Starting dynamic subtest: pipe-D
[293.057039] Dynamic subtest pipe-D: SUCCESS (5.481s)
[293.068370] Starting dynamic subtest: all-pipes
[298.537070] Dynamic subtest all-pipes: SUCCESS (5.477s)
[298.539546] Subtest forked-bo: SUCCESS (27.375s)
[298.677404] [057/133] (721s left) kms_async_flips (crc)
[298.779060] Starting subtest: crc
[299.172530] Starting dynamic subtest: pipe-A-eDP-1
[302.068245] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.893s)
[302.448432] Starting dynamic subtest: pipe-B-eDP-1
[305.377773] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.939s)
[305.764336] Starting dynamic subtest: pipe-C-eDP-1
[308.683866] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.930s)
[309.049223] Starting dynamic subtest: pipe-D-eDP-1
[311.896424] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.857s)
[311.898780] Subtest crc: SUCCESS (13.116s)
[313.075200] [058/133] (707s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[313.183304] Starting subtest: yf-tiled-8bpp-rotate-90
[313.187233] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[313.279242] [059/133] (707s left) gem_ctx_bad_destroy (invalid-pad)
[313.337847] Starting subtest: invalid-pad
[313.340163] Subtest invalid-pad: SUCCESS (0.000s)
[313.408712] [060/133] (707s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[313.513241] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[313.515430] Starting dynamic subtest: pipe-A-eDP-1
[313.537918] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[313.547490] Starting dynamic subtest: pipe-B-eDP-1
[313.568359] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[313.576586] Starting dynamic subtest: pipe-C-eDP-1
[313.597250] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[313.605511] Starting dynamic subtest: pipe-D-eDP-1
[313.627306] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[313.631323] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[315.760288] [061/133] (704s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[315.848821] Starting subtest: y-tiled-16bpp-rotate-180
[315.853096] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[315.955996] [062/133] (704s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[316.046746] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[316.051047] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[316.141809] [063/133] (704s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[316.234332] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[316.238595] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[316.329646] [064/133] (704s left) gem_exec_parallel (engines)
[316.389157] Starting subtest: engines
[316.391353] Starting dynamic subtest: basic
[317.923888] Dynamic subtest basic: SUCCESS (1.533s)
[317.932306] Starting dynamic subtest: contexts
[322.235291] Dynamic subtest contexts: SUCCESS (4.309s)
[322.243334] Starting dynamic subtest: fds
[326.144305] Dynamic subtest fds: SUCCESS (3.896s)
[326.154673] Starting dynamic subtest: userptr
[327.902295] Dynamic subtest userptr: SUCCESS (1.767s)
[327.904982] Subtest engines: SUCCESS (11.513s)
[328.090337] [065/133] (692s left) kms_cursor_crc (cursor-onscreen-256x85)
[328.359729] Starting subtest: cursor-onscreen-256x85
[328.405123] Subtest cursor-onscreen-256x85: SKIP (0.041s)
[328.580477] [066/133] (692s left) gem_exec_flush (basic-uc-prw-default)
[328.637203] Starting subtest: basic-uc-prw-default
[334.103633] Subtest basic-uc-prw-default: SUCCESS (5.466s)
[334.292438] [067/133] (686s left) kms_pm_rpm (modeset-lpsp)
[336.027918] Starting subtest: modeset-lpsp
[337.505464] Subtest modeset-lpsp: SUCCESS (1.478s)
[337.602303] [068/133] (683s left) i915_hangman (gt-error-state-capture)
[337.652873] Starting subtest: gt-error-state-capture
[337.654825] Starting dynamic subtest: rcs0
[348.851434] Dynamic subtest rcs0: SUCCESS (11.198s)
[348.862942] Starting dynamic subtest: bcs0
[360.883432] Dynamic subtest bcs0: SUCCESS (12.029s)
[360.895426] Starting dynamic subtest: vcs0
[372.850953] Dynamic subtest vcs0: SUCCESS (11.964s)
[372.861789] Starting dynamic subtest: vcs1
[384.819594] Dynamic subtest vcs1: SUCCESS (11.965s)
[384.831215] Starting dynamic subtest: vecs0
[395.828413] Dynamic subtest vecs0: SUCCESS (11.005s)
[395.839629] Starting dynamic subtest: ccs0
[407.859550] Dynamic subtest ccs0: SUCCESS (12.028s)
[407.862119] Subtest gt-error-state-capture: SUCCESS (70.207s)
[407.937135] [069/133] (613s left) kms_psr (psr2-primary-page-flip)
[408.042711] Starting subtest: psr2-primary-page-flip
[408.044843] Starting dynamic subtest: eDP-1
[409.735564] Dynamic subtest eDP-1: SUCCESS (1.691s)
[409.737505] Subtest psr2-primary-page-flip: SUCCESS (1.692s)
[410.614113] [070/133] (610s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[410.744470] Starting subtest: x-tiled-64bpp-rotate-0
[412.422306] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.676s)
[412.583127] [071/133] (608s left) i915_pm_rps (min-max-config-loaded)
[412.634152] Starting subtest: min-max-config-loaded
[412.638665] Subtest min-max-config-loaded: SKIP (0.001s)
[412.735784] [072/133] (608s left) perf_pmu (busy-no-semaphores)
[412.774250] Starting subtest: busy-no-semaphores
[412.775801] Starting dynamic subtest: rcs0
[413.333538] Dynamic subtest rcs0: SUCCESS (0.557s)
[413.345056] Starting dynamic subtest: bcs0
[413.883629] Dynamic subtest bcs0: SUCCESS (0.547s)
[413.895280] Starting dynamic subtest: vcs0
[414.434505] Dynamic subtest vcs0: SUCCESS (0.547s)
[414.445432] Starting dynamic subtest: vcs1
[416.407209] Dynamic subtest vcs1: SUCCESS (1.971s)
[416.417724] Starting dynamic subtest: vecs0
[418.458511] Dynamic subtest vecs0: SUCCESS (2.049s)
[418.470078] Starting dynamic subtest: ccs0
[420.441256] Dynamic subtest ccs0: SUCCESS (1.979s)
[420.444384] Subtest busy-no-semaphores: SUCCESS (7.668s)
[420.560583] [073/133] (600s left) kms_flip (blocking-wf_vblank)
[420.675210] Starting subtest: blocking-wf_vblank
[420.677606] Starting dynamic subtest: A-eDP1
[429.570616] Dynamic subtest A-eDP1: SUCCESS (8.897s)
[429.580586] Starting dynamic subtest: B-eDP1
[438.504565] Dynamic subtest B-eDP1: SUCCESS (8.932s)
[438.513053] Starting dynamic subtest: C-eDP1
[447.413491] Dynamic subtest C-eDP1: SUCCESS (8.907s)
[447.427646] Starting dynamic subtest: D-eDP1
[456.352123] Dynamic subtest D-eDP1: SUCCESS (8.937s)
[456.357440] Subtest blocking-wf_vblank: SUCCESS (35.684s)
[457.575886] [074/133] (563s left) gem_mmap_wc (read-write)
[457.637135] Subtest read-write: SKIP (0.000s)
[457.701396] [075/133] (563s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[457.815478] Starting subtest: basic-flip-after-cursor-varying-size
[458.742696] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.925s)
[459.596972] [076/133] (561s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[459.653031] Starting subtest: etime-multi-wait-all-for-submit-submitted
[459.760893] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.107s)
[459.846856] [077/133] (561s left) kms_properties (plane-properties-legacy)
[459.936417] Starting subtest: plane-properties-legacy
[459.938826] Starting dynamic subtest: pipe-A-eDP-1
[460.479508] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.545s)
[460.488921] Starting dynamic subtest: pipe-B-eDP-1
[461.772349] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.290s)
[461.781666] Starting dynamic subtest: pipe-C-eDP-1
[463.006264] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.231s)
[463.015815] Starting dynamic subtest: pipe-D-eDP-1
[464.243179] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.236s)
[464.245086] Subtest plane-properties-legacy: SUCCESS (4.307s)
[465.046470] [078/133] (556s left) gem_exec_fence (syncobj-invalid-flags)
[465.565606] Starting subtest: syncobj-invalid-flags
[465.567598] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[466.963811] [FACT gem_exec_fence (syncobj-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[466.967463] [079/133] (554s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[467.051098] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[467.055324] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[467.128651] [080/133] (554s left) gem_mmap_gtt (basic-small-bo-tiledy)
[467.191402] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[467.256423] [081/133] (554s left) syncobj_basic (bad-destroy)
[467.318735] Starting subtest: bad-destroy
[467.321086] Subtest bad-destroy: SUCCESS (0.000s)
[467.433689] [082/133] (554s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[467.536808] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[474.474374] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.939s)
[474.610444] [083/133] (546s left) gem_exec_balancer (hang)
[474.873410] Starting subtest: hang
[476.882307] Subtest hang: SUCCESS (2.009s)
[477.000319] [084/133] (544s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[477.083123] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[477.085431] Starting dynamic subtest: pipe-A-eDP-1
[477.929305] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.840s)
[477.937877] Starting dynamic subtest: pipe-B-eDP-1
[479.570129] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.636s)
[479.580031] Starting dynamic subtest: pipe-C-eDP-1
[481.092310] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.522s)
[481.100995] Starting dynamic subtest: pipe-D-eDP-1
[482.599608] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.505s)
[482.601805] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.509s)
[483.786906] [085/133] (537s left) prime_vgem (basic-blt)
[483.856653] Starting subtest: basic-blt
[483.882824] Subtest basic-blt: SUCCESS (0.028s)
[483.999245] [086/133] (537s left) gem_exec_schedule (implicit-write-read)
[484.066788] Starting subtest: implicit-write-read
[484.068967] Starting dynamic subtest: rcs0
[484.174302] Dynamic subtest rcs0: SUCCESS (0.117s)
[484.185800] Starting dynamic subtest: vcs0
[484.284991] Dynamic subtest vcs0: SUCCESS (0.110s)
[484.295904] Starting dynamic subtest: vcs1
[484.370104] Dynamic subtest vcs1: SUCCESS (0.085s)
[484.381352] Starting dynamic subtest: vecs0
[484.448494] Dynamic subtest vecs0: SUCCESS (0.077s)
[484.462353] Starting dynamic subtest: ccs0
[484.540432] Dynamic subtest ccs0: SUCCESS (0.091s)
[484.542962] Subtest implicit-write-read: SUCCESS (0.484s)
[486.006489] [087/133] (535s left) gem_userptr_blits (coherency-unsync)
[486.067625] Subtest coherency-unsync: SKIP (0.000s)
[486.196753] [088/133] (535s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[486.298040] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[486.302230] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[486.384906] [089/133] (535s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[486.480459] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[486.491483] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.010s)
[486.569470] [090/133] (535s left) gem_softpin (evict-prime)
[486.631228] Starting subtest: evict-prime
[486.633627] Starting dynamic subtest: rcs0
[487.786202] Dynamic subtest rcs0: SUCCESS (1.154s)
[487.798800] Starting dynamic subtest: bcs0
[488.898604] Dynamic subtest bcs0: SUCCESS (1.111s)
[488.907699] Starting dynamic subtest: vcs0
[490.838235] Dynamic subtest vcs0: SUCCESS (1.937s)
[490.847909] Starting dynamic subtest: vcs1
[492.882335] Dynamic subtest vcs1: SUCCESS (2.042s)
[492.891988] Starting dynamic subtest: vecs0
[494.870471] Dynamic subtest vecs0: SUCCESS (1.985s)
[494.882695] Starting dynamic subtest: ccs0
[496.008071] Dynamic subtest ccs0: SUCCESS (1.136s)
[496.019288] Starting dynamic subtest: all
[497.872770] Dynamic subtest all: SUCCESS (1.861s)
[497.875729] Subtest evict-prime: SUCCESS (11.241s)
[497.969199] [091/133] (523s left) gem_ctx_param (invalid-get-engines)
[498.021958] Starting subtest: invalid-get-engines
[498.024413] Subtest invalid-get-engines: SUCCESS (0.001s)
[498.138865] [092/133] (523s left) gem_exec_schedule (timeslicing)
[498.200067] Starting subtest: timeslicing
[498.202395] Starting dynamic subtest: rcs0
[498.212879] Dynamic subtest rcs0: SUCCESS (0.023s)
[498.226143] Starting dynamic subtest: bcs0
[498.239283] Dynamic subtest bcs0: SUCCESS (0.025s)
[498.251074] Starting dynamic subtest: vcs0
[498.264239] Dynamic subtest vcs0: SUCCESS (0.024s)
[498.275809] Starting dynamic subtest: vcs1
[498.287936] Dynamic subtest vcs1: SUCCESS (0.023s)
[498.296557] Starting dynamic subtest: vecs0
[498.312145] Dynamic subtest vecs0: SUCCESS (0.022s)
[498.320373] Starting dynamic subtest: ccs0
[498.338459] Dynamic subtest ccs0: SUCCESS (0.025s)
[498.340782] Subtest timeslicing: SUCCESS (0.149s)
[499.970685] [093/133] (521s left) kms_color_pipeline (plane-ctm3x4)
[500.073011] Starting subtest: plane-ctm3x4
[500.197113] Starting dynamic subtest: pipe-A-plane-0
[500.496345] Dynamic subtest pipe-A-plane-0: FAIL (0.132s)
[500.504817] Starting dynamic subtest: pipe-A-plane-1
[500.712648] Dynamic subtest pipe-A-plane-1: FAIL (0.141s)
[500.722297] Starting dynamic subtest: pipe-A-plane-2
[500.954890] Dynamic subtest pipe-A-plane-2: FAIL (0.144s)
[501.767600] Starting dynamic subtest: pipe-B-plane-0
[502.141164] Dynamic subtest pipe-B-plane-0: FAIL (0.123s)
[502.151621] Starting dynamic subtest: pipe-B-plane-1
[502.449537] Dynamic subtest pipe-B-plane-1: FAIL (0.142s)
[502.458894] Starting dynamic subtest: pipe-B-plane-2
[502.764253] Dynamic subtest pipe-B-plane-2: FAIL (0.140s)
[503.433727] Starting dynamic subtest: pipe-C-plane-0
[503.880721] Dynamic subtest pipe-C-plane-0: FAIL (0.107s)
[503.891597] Starting dynamic subtest: pipe-C-plane-1
[504.273160] Dynamic subtest pipe-C-plane-1: FAIL (0.579s)
[504.281628] Starting dynamic subtest: pipe-C-plane-2
[504.623830] Dynamic subtest pipe-C-plane-2: FAIL (0.143s)
[505.441726] Starting dynamic subtest: pipe-D-plane-0
[505.994706] Dynamic subtest pipe-D-plane-0: FAIL (0.129s)
[506.004709] Starting dynamic subtest: pipe-D-plane-1
[506.439076] Dynamic subtest pipe-D-plane-1: FAIL (0.598s)
[506.448517] Starting dynamic subtest: pipe-D-plane-2
[506.843247] Dynamic subtest pipe-D-plane-2: FAIL (0.514s)
[506.995717] Subtest plane-ctm3x4: FAIL (6.923s)
[507.788964] [094/133] (514s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[507.918705] Starting subtest: cursorA-vs-flipA-legacy
[519.038606] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.117s)
[519.917169] [095/133] (502s left) kms_cursor_crc (cursor-random-32x32)
[520.063763] Starting subtest: cursor-random-32x32
[520.109483] Subtest cursor-random-32x32: SKIP (0.042s)
[520.419373] [096/133] (501s left) sw_sync (alloc_merge_fence)
[520.457873] Starting subtest: alloc_merge_fence
[520.460042] Subtest alloc_merge_fence: SUCCESS (0.000s)
[520.516246] [097/133] (501s left) syncobj_wait (multi-wait-all-signaled)
[520.567838] Starting subtest: multi-wait-all-signaled
[520.570169] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[520.666438] [098/133] (501s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[520.714270] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[520.716609] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[520.810924] [099/133] (501s left) gem_render_tiled_blits (basic)
[520.878089] Subtest basic: SKIP (0.000s)
[520.950745] [100/133] (501s left) kms_pm_backlight (fade-with-suspend)
[521.039316] Starting subtest: fade-with-suspend
[537.504508] Starting dynamic subtest: eDP-1
[540.001459] Dynamic subtest eDP-1: SUCCESS (2.494s)
[540.003767] Subtest fade-with-suspend: SUCCESS (4.528s)
[540.826507] [101/133] (481s left) kms_cursor_crc (cursor-suspend)
[540.977348] Starting subtest: cursor-suspend
[540.979654] Starting dynamic subtest: pipe-A-eDP-1
[573.974084] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.137s)
[573.991018] Starting dynamic subtest: pipe-D-eDP-1
[607.984447] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.805s)
[607.986571] Subtest cursor-suspend: SUCCESS (6.946s)
[608.791910] [102/133] (413s left) gem_lmem_swapping (parallel-random-engines)
[608.839066] Subtest parallel-random-engines: SKIP (0.000s)
[608.880848] [103/133] (413s left) syncobj_timeline (invalid-query-bad-pad)
[608.930971] Starting subtest: invalid-query-bad-pad
[608.933187] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[609.027021] [104/133] (413s left) api_intel_bb (blit-noreloc-purge-cache)
[609.087423] Starting subtest: blit-noreloc-purge-cache
[609.095102] Subtest blit-noreloc-purge-cache: SUCCESS (0.011s)
[609.190856] [105/133] (413s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[609.299203] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[609.303618] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[609.390731] [106/133] (413s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[609.441046] Starting subtest: mixed-tiled-to-y-tiled-ccs
[609.445523] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[609.624574] [107/133] (412s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[609.721737] Starting subtest: psr-1p-primscrn-cur-indfb-move
[617.074338] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.346s)
[617.199099] [108/133] (405s left) kms_psr (fbc-psr-no-drrs)
[617.294607] Starting subtest: fbc-psr-no-drrs
[617.296919] Starting dynamic subtest: eDP-1
[617.301057] Dynamic subtest eDP-1: SKIP (0.000s)
[617.305170] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[617.379457] [109/133] (405s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[617.478355] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[617.482644] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[617.590261] [110/133] (405s left) kms_rotation_crc (bad-pixel-format)
[617.698648] Starting subtest: bad-pixel-format
[617.703013] Subtest bad-pixel-format: SKIP (0.001s)
[617.772365] [111/133] (404s left) kms_psr (fbc-pr-sprite-render)
[617.876472] Starting subtest: fbc-pr-sprite-render
[617.880783] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[617.949225] [112/133] (404s left) syncobj_timeline (wait-all-delayed-signal)
[618.009960] Starting subtest: wait-all-delayed-signal
[618.113961] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[618.218051] [113/133] (404s left) gem_ctx_persistence (legacy-engines-hang)
[618.275704] Starting subtest: legacy-engines-hang
[618.278247] Starting dynamic subtest: render
[618.405063] Dynamic subtest render: SUCCESS (0.129s)
[618.420550] Starting dynamic subtest: bsd1
[618.501345] Dynamic subtest bsd1: SUCCESS (0.093s)
[618.513309] Starting dynamic subtest: bsd2
[618.601141] Dynamic subtest bsd2: SUCCESS (0.097s)
[618.615473] Starting dynamic subtest: blt
[618.682028] Dynamic subtest blt: SUCCESS (0.078s)
[618.692874] Starting dynamic subtest: vebox
[618.816974] Dynamic subtest vebox: SUCCESS (0.132s)
[618.819391] Subtest legacy-engines-hang: SUCCESS (0.542s)
[618.908922] [114/133] (403s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[618.963750] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[619.069387] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s)
[619.145656] [115/133] (403s left) gem_exec_suspend (basic-s4-devices)
[619.200147] Starting subtest: basic-S4-devices
[619.202584] Starting dynamic subtest: smem
[630.410373] Dynamic subtest smem: SUCCESS (11.200s)
[630.413441] Subtest basic-S4-devices: SUCCESS (11.203s)
[636.643338] [116/133] (392s left) gem_busy (extended)
[636.869138] Starting subtest: extended
[636.871704] Starting dynamic subtest: rcs0
[636.966796] Dynamic subtest rcs0: SUCCESS (0.097s)
[636.979363] Starting dynamic subtest: bcs0
[637.011790] Dynamic subtest bcs0: SUCCESS (0.043s)
[637.023059] Starting dynamic subtest: vcs0
[638.409225] Dynamic subtest vcs0: SUCCESS (1.393s)
[638.422584] Starting dynamic subtest: vcs1
[640.393752] Dynamic subtest vcs1: SUCCESS (1.980s)
[640.407025] Starting dynamic subtest: vecs0
[642.377652] Dynamic subtest vecs0: SUCCESS (1.980s)
[642.390581] Starting dynamic subtest: ccs0
[642.422277] Dynamic subtest ccs0: SUCCESS (0.044s)
[642.424844] Subtest extended: SUCCESS (5.552s)
[642.680247] [117/133] (386s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[642.779453] Starting subtest: fbcpsr-tiling-4
[649.738754] Subtest fbcpsr-tiling-4: SUCCESS (6.958s)
[649.867564] [118/133] (379s left) kms_vblank (ts-continuation-modeset-hang)
[649.955689] Starting subtest: ts-continuation-modeset-hang
[649.957960] Starting dynamic subtest: pipe-A-eDP-1
[676.184499] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.214s)
[676.199579] Starting dynamic subtest: pipe-D-eDP-1
[701.138129] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.941s)
[701.140517] Subtest ts-continuation-modeset-hang: SUCCESS (51.159s)
[701.987765] [119/133] (327s left) gen9_exec_parse (secure-batches)
[702.040206] Subtest secure-batches: SKIP (0.000s)
[702.119094] [120/133] (327s left) kms_chamelium_edid (dp-edid-read)
[702.491064] Subtest dp-edid-read: SKIP (0.000s)
[703.291200] [121/133] (325s left) gem_userptr_blits (forbidden-operations)
[703.353694] Starting subtest: forbidden-operations
[703.358266] Subtest forbidden-operations: SKIP (0.000s)
[703.492606] [122/133] (325s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[703.600018] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[703.604097] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[703.686674] [123/133] (325s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[703.801865] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[703.806499] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[703.907587] [124/133] (325s left) gem_mmap_gtt (isolation)
[703.960599] Subtest isolation: SKIP (0.000s)
[704.022280] [125/133] (325s left) gem_mmap_gtt (cpuset-big-copy-xy)
[704.078689] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[704.141802] [126/133] (325s left) vgem_basic (setversion)
[704.183889] Starting subtest: setversion
[704.187968] Subtest setversion: SUCCESS (0.000s)
[704.266275] [127/133] (325s left) kms_plane_multiple (tiling-4)
[704.352091] Starting subtest: tiling-4
[704.354099] Starting dynamic subtest: pipe-A-eDP-1
[708.199917] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.844s)
[708.210634] Starting dynamic subtest: pipe-B-eDP-1
[712.591639] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.387s)
[712.604546] Starting dynamic subtest: pipe-C-eDP-1
[717.006731] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.413s)
[717.017639] Starting dynamic subtest: pipe-D-eDP-1
[721.327745] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.318s)
[721.329969] Subtest tiling-4: SUCCESS (16.967s)
[722.135764] [128/133] (307s left) kms_atomic_interruptible (legacy-pageflip)
[722.235225] Starting subtest: legacy-pageflip
[722.237470] Starting dynamic subtest: pipe-A-eDP-1
[729.647847] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.409s)
[729.650053] Subtest legacy-pageflip: SUCCESS (7.410s)
[730.491254] [129/133] (299s left) gem_ppgtt (blt-vs-render-ctxn)
[730.545941] Starting subtest: blt-vs-render-ctxN
[763.569068] Subtest blt-vs-render-ctxN: SUCCESS (33.004s)
[763.695056] [130/133] (265s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[763.854404] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[772.436147] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.580s)
[772.539703] [131/133] (257s left) gem_eio (in-flight-contexts-immediate)
[772.787640] Starting subtest: in-flight-contexts-immediate
[784.415583] Subtest in-flight-contexts-immediate: SUCCESS (11.623s)
[784.605851] [132/133] (245s left) perf (oa-formats)
[784.765243] Starting subtest: oa-formats
[784.767466] Starting dynamic subtest: 0-rcs0
[784.777734] Dynamic subtest 0-rcs0: SUCCESS (0.014s)
[784.788121] Starting dynamic subtest: 1-vecs0
[784.800142] Dynamic subtest 1-vecs0: SUCCESS (0.022s)
[784.802456] Subtest oa-formats: SUCCESS (0.038s)
[784.849224] [133/133] (244s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[784.910915] Starting subtest: multi-wait-all-for-submit-submitted
[785.012907] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.102s)
[785.084812] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_params
results: parsing output: 1/ for test: kms_plane_scaling
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_plane
results: parsing output: 4/ for test: kms_atomic
results: parsing output: 5/ for test: syncobj_wait
results: parsing output: 6/ for test: gem_create
results: parsing output: 7/ for test: kms_plane_scaling
results: parsing output: 8/ for test: kms_flip
results: parsing output: 9/ for test: kms_invalid_mode
results: parsing output: 10/ for test: sysfs_timeslice_duration
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: gem_userptr_blits
results: parsing output: 13/ for test: kms_prop_blob
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_busy
results: parsing output: 16/ for test: gem_ctx_shared
results: parsing output: 17/ for test: perf_pmu
results: parsing output: 18/ for test: gem_userptr_blits
results: parsing output: 19/ for test: i915_drm_fdinfo
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_readwrite
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: syncobj_wait
results: parsing output: 27/ for test: kms_selftest
results: parsing output: 28/ for test: kms_lease
results: parsing output: 29/ for test: kms_content_protection
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: kms_pipe_b_c_ivb
results: parsing output: 32/ for test: syncobj_wait
results: parsing output: 33/ for test: core_setmaster
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: gem_render_copy
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: gem_mmap_wc
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_plane_alpha_blend
results: parsing output: 43/ for test: kms_psr2_sf
results: parsing output: 44/ for test: gem_exec_whisper
results: parsing output: 45/ for test: kms_feature_discovery
results: parsing output: 46/ for test: gem_pxp
results: parsing output: 47/ for test: gem_exec_balancer
results: parsing output: 48/ for test: gem_render_copy
results: parsing output: 49/ for test: i915_pm_rps
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: api_intel_bb
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_chamelium_hpd
results: parsing output: 54/ for test: gem_caching
results: parsing output: 55/ for test: kms_cursor_legacy
results: parsing output: 56/ for test: kms_async_flips
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: gem_ctx_bad_destroy
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_exec_parallel
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: gem_exec_flush
results: parsing output: 66/ for test: kms_pm_rpm
results: parsing output: 67/ for test: i915_hangman
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: i915_pm_rps
results: parsing output: 71/ for test: perf_pmu
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: gem_mmap_wc
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_properties
results: parsing output: 77/ for test: gem_exec_fence
results: parsing output: 78/ for test: kms_flip_scaled_crc
results: parsing output: 79/ for test: gem_mmap_gtt
results: parsing output: 80/ for test: syncobj_basic
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_exec_balancer
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: prime_vgem
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: gem_userptr_blits
results: parsing output: 87/ for test: kms_psr2_sf
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: gem_softpin
results: parsing output: 90/ for test: gem_ctx_param
results: parsing output: 91/ for test: gem_exec_schedule
results: parsing output: 92/ for test: kms_color_pipeline
results: parsing output: 93/ for test: kms_cursor_legacy
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: sw_sync
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: gem_render_tiled_blits
results: parsing output: 99/ for test: kms_pm_backlight
results: parsing output: 100/ for test: kms_cursor_crc
results: parsing output: 101/ for test: gem_lmem_swapping
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: api_intel_bb
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_render_copy
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_rotation_crc
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: gem_ctx_persistence
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: gem_exec_suspend
results: parsing output: 115/ for test: gem_busy
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_vblank
results: parsing output: 118/ for test: gen9_exec_parse
results: parsing output: 119/ for test: kms_chamelium_edid
results: parsing output: 120/ for test: gem_userptr_blits
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_mmap_gtt
results: parsing output: 124/ for test: gem_mmap_gtt
results: parsing output: 125/ for test: vgem_basic
results: parsing output: 126/ for test: kms_plane_multiple
results: parsing output: 127/ for test: kms_atomic_interruptible
results: parsing output: 128/ for test: gem_ppgtt
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_eio
results: parsing output: 131/ for test: perf
results: parsing output: 132/ for test: syncobj_wait
Done.