[57.256371] Initializing watchdogs
[57.256445]   /dev/watchdog0
[57.272580] [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.276937] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.279256] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.282446] [001/133] (960s left) prime_busy (after)
[57.358145] Starting subtest: after
[57.362665] Starting dynamic subtest: rcs0
[57.398790] Dynamic subtest rcs0: SUCCESS (0.038s)
[57.408428] Starting dynamic subtest: bcs0
[57.444321] Dynamic subtest bcs0: SUCCESS (0.045s)
[57.451644] Starting dynamic subtest: vcs0
[57.487508] Dynamic subtest vcs0: SUCCESS (0.043s)
[57.495759] Starting dynamic subtest: vcs1
[57.529331] Dynamic subtest vcs1: SUCCESS (0.042s)
[57.536353] Starting dynamic subtest: vecs0
[57.570753] Dynamic subtest vecs0: SUCCESS (0.042s)
[57.579887] Starting dynamic subtest: ccs0
[57.613327] Dynamic subtest ccs0: SUCCESS (0.042s)
[57.721260] Subtest after: SUCCESS (0.364s)
[57.791356] [002/133] (960s left) kms_vblank (query-forked-busy-hang)
[57.882743] Starting subtest: query-forked-busy-hang
[57.885108] Starting dynamic subtest: pipe-A-eDP-1
[85.648922] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.821s)
[85.666059] Starting dynamic subtest: pipe-D-eDP-1
[100.691483] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.038s)
[100.693864] Subtest query-forked-busy-hang: SUCCESS (42.862s)
[101.534921] [003/133] (916s left) kms_prop_blob (invalid-get-prop)
[101.597202] Starting subtest: invalid-get-prop
[101.599725] Subtest invalid-get-prop: SUCCESS (0.000s)
[101.691393] [004/133] (916s left) gem_tiled_swapping (non-threaded)
[101.748081] Subtest non-threaded: SKIP (0.000s)
[101.812691] [005/133] (916s left) perf (blocking)
[101.927467] Starting subtest: blocking
[101.929687] Starting dynamic subtest: 0-rcs0
[111.959059] Dynamic subtest 0-rcs0: SUCCESS (10.031s)
[111.966320] Starting dynamic subtest: 1-vecs0
[121.979214] Dynamic subtest 1-vecs0: SUCCESS (10.020s)
[121.981994] Subtest blocking: SUCCESS (20.052s)
[122.027132] [006/133] (895s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[122.092404] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[122.200799] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.109s)
[122.271342] [007/133] (895s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[122.365909] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[122.370351] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[122.456495] [008/133] (895s left) syncobj_timeline (wait-any-complex)
[122.514818] Starting subtest: wait-any-complex
[122.576421] Subtest wait-any-complex: SUCCESS (0.062s)
[122.651544] [009/133] (895s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[122.777738] Starting subtest: cursor-vs-flip-atomic-transitions
[153.259988] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.484s)
[154.138655] [010/133] (864s left) gem_exec_balancer (bonded-pair)
[154.211155] Starting subtest: bonded-pair
[154.215489] Subtest bonded-pair: SKIP (0.000s)
[154.510909] [011/133] (863s left) kms_psr (psr2-sprite-blt)
[154.603649] Starting subtest: psr2-sprite-blt
[154.605954] Starting dynamic subtest: eDP-1
[156.325397] Dynamic subtest eDP-1: SUCCESS (1.722s)
[156.327432] Subtest psr2-sprite-blt: SUCCESS (1.723s)
[157.193647] [012/133] (861s left) api_intel_bb (object-noreloc-keep-cache-simple)
[157.255276] Starting subtest: object-noreloc-keep-cache-simple
[157.259898] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.006s)
[157.355548] [013/133] (860s left) kms_cursor_crc (cursor-random-max-size)
[157.681823] Starting subtest: cursor-random-max-size
[157.688670] Subtest cursor-random-max-size: SKIP (0.000s)
[157.805129] [014/133] (860s left) gem_exec_params (larger-than-life-batch)
[157.880030] Starting subtest: larger-than-life-batch
[160.156768] Subtest larger-than-life-batch: SUCCESS (2.279s)
[160.966214] [015/133] (857s left) syncobj_wait (wait-all-delayed-signal)
[161.084655] Starting subtest: wait-all-delayed-signal
[161.188024] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[161.276967] [016/133] (857s left) kms_plane_lowres (tiling-4)
[161.377664] Starting subtest: tiling-4
[161.379999] Starting dynamic subtest: pipe-A-eDP-1
[161.384468] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[161.683311] Starting dynamic subtest: pipe-B-eDP-1
[161.687809] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[161.695396] Starting dynamic subtest: pipe-C-eDP-1
[161.700181] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[161.708209] Starting dynamic subtest: pipe-D-eDP-1
[161.713549] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[161.718449] Subtest tiling-4: SKIP (0.305s)
[162.537849] [017/133] (855s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[162.639162] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[162.643758] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[162.731327] [018/133] (855s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[162.835827] Starting subtest: y-tiled-64bpp-rotate-90
[162.840063] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[162.916224] [019/133] (855s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[163.001852] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[163.004063] Starting dynamic subtest: pipe-A-eDP-1
[195.313227] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.120s)
[195.323451] Starting dynamic subtest: pipe-B-eDP-1
[228.255988] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.720s)
[228.269092] Starting dynamic subtest: pipe-C-eDP-1
[261.226388] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.721s)
[261.236756] Starting dynamic subtest: pipe-D-eDP-1
[294.232306] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.674s)
[294.235387] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (14.240s)
[295.435814] [020/133] (723s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[295.536606] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[295.541278] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[295.613654] [021/133] (722s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[295.711473] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[296.502657] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.815s)
[296.672897] [022/133] (721s left) gem_exec_schedule (pi-common)
[296.865420] Starting subtest: pi-common
[296.867818] Starting dynamic subtest: rcs0
[296.940618] Dynamic subtest rcs0: SUCCESS (0.080s)
[296.952577] Starting dynamic subtest: bcs0
[296.968115] Dynamic subtest bcs0: SUCCESS (0.028s)
[296.981586] Starting dynamic subtest: vcs0
[296.995368] Dynamic subtest vcs0: SUCCESS (0.028s)
[297.008491] Starting dynamic subtest: vcs1
[297.021966] Dynamic subtest vcs1: SUCCESS (0.027s)
[297.033138] Starting dynamic subtest: vecs0
[297.048719] Dynamic subtest vecs0: SUCCESS (0.027s)
[297.060853] Starting dynamic subtest: ccs0
[297.077138] Dynamic subtest ccs0: SUCCESS (0.028s)
[297.079499] Subtest pi-common: SUCCESS (0.220s)
[297.301156] [FACT gem_exec_schedule (pi-common)] new: kernel.kmod_is_loaded.vgem: true
[297.304855] [023/133] (721s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[297.408807] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[297.411279] Starting dynamic subtest: pipe-A-eDP-1
[298.137270] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.734s)
[298.148073] Starting dynamic subtest: pipe-B-eDP-1
[299.893526] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.787s)
[299.903400] Starting dynamic subtest: pipe-C-eDP-1
[301.692845] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.825s)
[301.701554] Starting dynamic subtest: pipe-D-eDP-1
[303.516614] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.843s)
[303.518985] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.194s)
[304.634645] [024/133] (714s left) kms_color (legacy-gamma-reset)
[304.730428] Starting subtest: legacy-gamma-reset
[304.733174] Starting dynamic subtest: pipe-A-eDP-1
[305.115887] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.389s)
[305.124573] Starting dynamic subtest: pipe-B-eDP-1
[305.127378] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[305.136388] Starting dynamic subtest: pipe-C-eDP-1
[305.141617] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[305.150327] Starting dynamic subtest: pipe-D-eDP-1
[305.153115] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[305.155624] Subtest legacy-gamma-reset: SUCCESS (0.427s)
[305.952792] [025/133] (712s left) gem_ctx_persistence (legacy-engines-cleanup)
[306.003859] Starting subtest: legacy-engines-cleanup
[306.006589] Starting dynamic subtest: render
[306.074793] Dynamic subtest render: SUCCESS (0.071s)
[306.087149] Starting dynamic subtest: bsd1
[306.112604] Dynamic subtest bsd1: SUCCESS (0.036s)
[306.122745] Starting dynamic subtest: bsd2
[306.155526] Dynamic subtest bsd2: SUCCESS (0.042s)
[306.166356] Starting dynamic subtest: blt
[306.193604] Dynamic subtest blt: SUCCESS (0.036s)
[306.203242] Starting dynamic subtest: vebox
[306.213541] Dynamic subtest vebox: SUCCESS (0.019s)
[306.216268] Subtest legacy-engines-cleanup: SUCCESS (0.212s)
[306.334888] [026/133] (712s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[306.437951] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[306.443150] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[306.531860] [027/133] (712s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[306.632845] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[306.636295] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[306.731407] [028/133] (712s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[306.819758] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[306.821798] Starting dynamic subtest: pipe-A-eDP-1
[306.868597] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[306.876489] Starting dynamic subtest: pipe-B-eDP-1
[306.921921] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[306.929880] Starting dynamic subtest: pipe-C-eDP-1
[306.975240] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[306.983079] Starting dynamic subtest: pipe-D-eDP-1
[307.031021] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[307.034279] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[309.014879] [029/133] (709s left) kms_properties (crtc-properties-legacy)
[309.116426] Starting subtest: crtc-properties-legacy
[309.119161] Starting dynamic subtest: pipe-A-eDP-1
[309.556919] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.440s)
[309.567411] Starting dynamic subtest: pipe-B-eDP-1
[310.691265] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.138s)
[310.701326] Starting dynamic subtest: pipe-C-eDP-1
[311.820884] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.134s)
[311.834131] Starting dynamic subtest: pipe-D-eDP-1
[312.953841] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.136s)
[312.956437] Subtest crtc-properties-legacy: SUCCESS (3.852s)
[313.770989] [030/133] (705s left) gem_mmap (bad-offset)
[313.826593] Subtest bad-offset: SKIP (0.000s)
[313.888049] [031/133] (705s left) perf_pmu (idle)
[313.932556] Starting subtest: idle
[313.935372] Starting dynamic subtest: rcs0
[314.467792] Dynamic subtest rcs0: SUCCESS (0.537s)
[314.480643] Starting dynamic subtest: bcs0
[314.988031] Dynamic subtest bcs0: SUCCESS (0.518s)
[315.000022] Starting dynamic subtest: vcs0
[315.515888] Dynamic subtest vcs0: SUCCESS (0.527s)
[315.528996] Starting dynamic subtest: vcs1
[316.036012] Dynamic subtest vcs1: SUCCESS (0.519s)
[316.047617] Starting dynamic subtest: vecs0
[316.557596] Dynamic subtest vecs0: SUCCESS (0.521s)
[316.570935] Starting dynamic subtest: ccs0
[317.079726] Dynamic subtest ccs0: SUCCESS (0.521s)
[317.082650] Subtest idle: SUCCESS (3.158s)
[317.178402] [032/133] (701s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[317.276458] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[317.288373] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.010s)
[317.392523] [033/133] (701s left) gem_workarounds (reset)
[317.453323] Starting subtest: reset
[317.617381] Subtest reset: SUCCESS (0.163s)
[317.752016] [034/133] (701s left) perf (gen12-group-exclusive-stream-ctx-handle)
[317.869479] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[317.895381] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.024s)
[317.945098] [035/133] (701s left) kms_selftest (drm_plane_helper)
[317.990599] Starting subtest: drm_plane_helper
[317.999439] Starting dynamic subtest: drm_test_check_plane_state
[318.097642] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.098s)
[318.106931] Starting dynamic subtest: drm_test_check_invalid_plane_state
[318.189208] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.091s)
[318.191391] Subtest drm_plane_helper: SUCCESS (0.200s)
[318.335474] [036/133] (700s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[319.113167] Starting subtest: cursorB-vs-flipB-atomic-transitions
[319.117601] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[319.259839] [037/133] (699s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[319.360837] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[319.363325] Starting dynamic subtest: pipe-A-eDP-1
[319.386332] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[319.395546] Starting dynamic subtest: pipe-B-eDP-1
[319.418817] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[319.428202] Starting dynamic subtest: pipe-C-eDP-1
[319.452475] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[319.462683] Starting dynamic subtest: pipe-D-eDP-1
[319.488273] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[319.493020] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.011s)
[321.701397] [038/133] (697s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[321.803761] Starting subtest: fbcpsr-modesetfrombusy
[327.992587] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.195s)
[328.123731] [039/133] (691s left) gem_pxp (regular-baseline-src-copy-readible)
[328.256403] Starting subtest: regular-baseline-src-copy-readible
[328.314702] Subtest regular-baseline-src-copy-readible: SUCCESS (0.061s)
[328.429957] [040/133] (690s left) gem_exec_params (rel-constants-invalid)
[328.484231] Starting subtest: rel-constants-invalid
[328.486898] Subtest rel-constants-invalid: SUCCESS (0.000s)
[328.595608] [041/133] (690s left) gem_partial_pwrite_pread (reads-uncached)
[328.658497] Subtest reads-uncached: SKIP (0.000s)
[328.734688] [042/133] (690s left) gem_exec_fence (syncobj-timeline-export)
[329.303064] Starting subtest: syncobj-timeline-export
[329.309586] Subtest syncobj-timeline-export: SUCCESS (0.006s)
[331.155502] [043/133] (688s left) kms_chamelium_edid (hdmi-edid-read)
[331.554143] Subtest hdmi-edid-read: SKIP (0.000s)
[332.382517] [044/133] (687s left) gem_ppgtt (blt-vs-render-ctx0)
[332.429550] Starting subtest: blt-vs-render-ctx0
[365.174399] Subtest blt-vs-render-ctx0: SUCCESS (32.748s)
[365.304943] [045/133] (654s left) kms_feature_discovery (display-1x)
[365.449485] Starting subtest: display-1x
[365.452009] Subtest display-1x: SUCCESS (0.000s)
[365.524557] [046/133] (654s left) kms_plane_alpha_blend (alpha-7efc)
[365.617218] Starting subtest: alpha-7efc
[365.908634] Starting dynamic subtest: pipe-A-eDP-1
[366.531270] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.619s)
[366.558853] Starting dynamic subtest: pipe-D-eDP-1
[367.820129] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.271s)
[367.822690] Subtest alpha-7efc: SUCCESS (2.206s)
[368.663007] [047/133] (651s left) syncobj_wait (wait-any-interrupted)
[368.726392] Starting subtest: wait-any-interrupted
[368.831959] Subtest wait-any-interrupted: SUCCESS (0.104s)
[368.906596] [048/133] (650s left) syncobj_wait (invalid-single-wait-unsubmitted)
[368.957643] Starting subtest: invalid-single-wait-unsubmitted
[368.960075] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[369.064011] [049/133] (650s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[369.177214] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[369.182243] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[369.279063] [050/133] (650s left) kms_cursor_legacy (single-bo)
[369.393650] Starting subtest: single-bo
[369.396229] Starting dynamic subtest: pipe-A
[374.775426] Dynamic subtest pipe-A: SUCCESS (5.379s)
[374.786419] Starting dynamic subtest: pipe-B
[380.157750] Dynamic subtest pipe-B: SUCCESS (5.383s)
[380.170363] Starting dynamic subtest: pipe-C
[385.539762] Dynamic subtest pipe-C: SUCCESS (5.381s)
[385.551901] Starting dynamic subtest: pipe-D
[390.921514] Dynamic subtest pipe-D: SUCCESS (5.379s)
[390.934202] Starting dynamic subtest: all-pipes
[396.311960] Dynamic subtest all-pipes: SUCCESS (5.386s)
[396.314549] Subtest single-bo: SUCCESS (26.919s)
[396.459315] [051/133] (623s left) prime_mmap (test_aperture_limit)
[396.525143] Starting subtest: test_aperture_limit
[396.527150] Starting dynamic subtest: test_aperture_limit-smem
[396.535101] Dynamic subtest test_aperture_limit-smem: SKIP (0.009s)
[396.539750] Subtest test_aperture_limit: SKIP (0.010s)
[396.633940] [052/133] (623s left) gen3_render_tiledy_blits
[396.777407] [053/133] (623s left) kms_addfb_basic (bad-pitch-0)
[396.836236] Starting subtest: bad-pitch-0
[396.838722] Subtest bad-pitch-0: SUCCESS (0.000s)
[396.972245] [054/133] (623s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[397.072174] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[404.460603] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.389s)
[404.625013] [055/133] (615s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[404.715529] Starting subtest: fbc-psr-sprite-mmap-cpu
[404.717879] Starting dynamic subtest: eDP-1
[404.722582] Dynamic subtest eDP-1: SKIP (0.000s)
[404.727261] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[404.789270] [056/133] (615s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[404.881886] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[404.886868] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[404.953279] [057/133] (615s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[405.059242] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[405.064345] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[405.156746] [058/133] (615s left) gem_mmap_gtt (medium-copy)
[405.219044] Subtest medium-copy: SKIP (0.000s)
[405.276127] [059/133] (614s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[405.375396] Starting subtest: x-tiled-64bpp-rotate-270
[405.395480] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[405.509772] [060/133] (614s left) kms_lease (lease-invalid-plane)
[405.599232] Starting subtest: lease-invalid-plane
[405.601200] Starting dynamic subtest: pipe-A-eDP-1
[405.603221] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[405.612906] Starting dynamic subtest: pipe-B-eDP-1
[405.614651] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[405.624255] Starting dynamic subtest: pipe-C-eDP-1
[405.626479] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[405.636215] Starting dynamic subtest: pipe-D-eDP-1
[405.638095] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[405.640024] Subtest lease-invalid-plane: SUCCESS (0.004s)
[405.677377] [061/133] (614s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[405.774162] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[405.778322] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[405.861784] [062/133] (614s left) kms_psr (psr-sprite-plane-onoff)
[405.959090] Starting subtest: psr-sprite-plane-onoff
[405.961179] Starting dynamic subtest: eDP-1
[407.730231] Dynamic subtest eDP-1: SUCCESS (1.768s)
[407.732879] Subtest psr-sprite-plane-onoff: SUCCESS (1.770s)
[408.552244] [063/133] (611s left) kms_properties (plane-properties-legacy)
[408.640620] Starting subtest: plane-properties-legacy
[408.643622] Starting dynamic subtest: pipe-A-eDP-1
[409.236374] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.594s)
[409.249270] Starting dynamic subtest: pipe-B-eDP-1
[410.543934] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.306s)
[410.554518] Starting dynamic subtest: pipe-C-eDP-1
[411.853754] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.310s)
[411.865444] Starting dynamic subtest: pipe-D-eDP-1
[413.096507] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.241s)
[413.099299] Subtest plane-properties-legacy: SUCCESS (4.455s)
[413.902522] [064/133] (606s left) i915_drm_fdinfo (busy)
[413.954483] Starting subtest: busy
[413.957207] Starting dynamic subtest: rcs0
[413.965105] Dynamic subtest rcs0: SKIP (0.010s)
[413.981609] Starting dynamic subtest: bcs0
[413.987123] Dynamic subtest bcs0: SKIP (0.010s)
[413.998643] Starting dynamic subtest: vcs0
[414.003494] Dynamic subtest vcs0: SKIP (0.000s)
[414.015535] Starting dynamic subtest: vcs1
[414.021152] Dynamic subtest vcs1: SKIP (0.000s)
[414.033466] Starting dynamic subtest: vecs0
[414.038093] Dynamic subtest vecs0: SKIP (0.000s)
[414.047330] Starting dynamic subtest: ccs0
[414.051882] Dynamic subtest ccs0: SKIP (0.000s)
[414.056338] Subtest busy: SKIP (0.025s)
[414.096325] [065/133] (606s left) kms_cursor_crc (cursor-sliding-max-size)
[414.405991] Starting subtest: cursor-sliding-max-size
[414.414141] Subtest cursor-sliding-max-size: SKIP (0.000s)
[414.519990] [066/133] (605s left) gem_tiled_fence_blits (basic)
[414.576161] Subtest basic: SKIP (0.000s)
[414.632633] [067/133] (605s left) kms_chamelium_hpd (hdmi-hpd-fast)
[415.014595] Subtest hdmi-hpd-fast: SKIP (0.000s)
[415.817359] [068/133] (604s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[415.913158] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[415.915526] Starting dynamic subtest: pipe-A-eDP-1
[415.937199] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[415.947242] Starting dynamic subtest: pipe-B-eDP-1
[415.969612] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[415.979201] Starting dynamic subtest: pipe-C-eDP-1
[416.001244] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[416.010939] Starting dynamic subtest: pipe-D-eDP-1
[416.033429] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[416.036062] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.010s)
[418.188678] [069/133] (602s left) gem_exec_whisper (basic-contexts-forked-all)
[418.250084] Starting subtest: basic-contexts-forked-all
[442.245454] Subtest basic-contexts-forked-all: SUCCESS (23.992s)
[442.433684] [070/133] (578s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[442.538310] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[443.251777] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.715s)
[443.412364] [071/133] (577s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[443.503480] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[443.508420] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[443.602298] [072/133] (577s left) kms_async_flips (async-flip-suspend-resume)
[443.692868] Starting subtest: async-flip-suspend-resume
[444.067369] Starting dynamic subtest: pipe-A-eDP-1
[462.063445] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.003s)
[462.435427] Starting dynamic subtest: pipe-B-eDP-1
[480.066506] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.953s)
[480.444825] Starting dynamic subtest: pipe-C-eDP-1
[498.271448] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.158s)
[498.644257] Starting dynamic subtest: pipe-D-eDP-1
[517.064870] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.951s)
[517.067114] Subtest async-flip-suspend-resume: SUCCESS (13.569s)
[518.235322] [073/133] (502s left) i915_query (query-regions-garbage-items)
[518.290659] Starting subtest: query-regions-garbage-items
[518.292586] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[518.402392] [074/133] (502s left) i915_hangman (hangcheck-unterminated)
[518.462242] Starting subtest: hangcheck-unterminated
[530.126738] Subtest hangcheck-unterminated: SUCCESS (11.838s)
[530.253039] [075/133] (490s left) kms_psr (fbc-psr2-no-drrs)
[530.357363] Starting subtest: fbc-psr2-no-drrs
[530.359632] Starting dynamic subtest: eDP-1
[530.363837] Dynamic subtest eDP-1: SKIP (0.000s)
[530.368152] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[530.430584] [076/133] (490s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[530.519354] Starting subtest: primary-yf-tiled-reflect-x-180
[530.590915] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.071s)
[530.694821] [077/133] (490s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[530.798691] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[538.127388] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.362s)
[538.263527] [078/133] (482s left) gem_exec_fence (basic-wait)
[538.436382] Starting subtest: basic-wait
[538.438727] Starting dynamic subtest: rcs0
[538.512266] Dynamic subtest rcs0: SUCCESS (0.076s)
[538.524397] Starting dynamic subtest: bcs0
[538.567174] Dynamic subtest bcs0: SUCCESS (0.053s)
[538.579785] Starting dynamic subtest: vcs0
[538.624119] Dynamic subtest vcs0: SUCCESS (0.054s)
[538.635284] Starting dynamic subtest: vcs1
[538.680576] Dynamic subtest vcs1: SUCCESS (0.054s)
[538.692202] Starting dynamic subtest: vecs0
[538.739695] Dynamic subtest vecs0: SUCCESS (0.058s)
[538.751725] Starting dynamic subtest: ccs0
[538.794332] Dynamic subtest ccs0: SUCCESS (0.052s)
[538.796977] Subtest basic-wait: SUCCESS (0.361s)
[540.233123] [079/133] (480s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[540.295283] Starting subtest: basic-batch-kernel-default-cmd
[540.299621] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[540.484636] [080/133] (480s left) gem_exec_schedule (semaphore-noskip)
[540.546808] Starting subtest: semaphore-noskip
[540.986530] Subtest semaphore-noskip: SUCCESS (0.446s)
[541.328510] [081/133] (479s left) gem_busy (busy)
[541.383866] Starting subtest: busy
[541.386219] Starting dynamic subtest: all-engines
[541.448928] Dynamic subtest all-engines: SUCCESS (0.065s)
[541.459650] Starting dynamic subtest: rcs0
[543.160486] Dynamic subtest rcs0: SUCCESS (1.713s)
[543.172402] Starting dynamic subtest: bcs0
[543.214597] Dynamic subtest bcs0: SUCCESS (0.051s)
[543.225287] Starting dynamic subtest: vcs0
[543.253191] Dynamic subtest vcs0: SUCCESS (0.039s)
[543.263445] Starting dynamic subtest: vcs1
[545.142750] Dynamic subtest vcs1: SUCCESS (1.887s)
[545.155311] Starting dynamic subtest: vecs0
[547.125513] Dynamic subtest vecs0: SUCCESS (1.983s)
[547.136424] Starting dynamic subtest: ccs0
[549.173662] Dynamic subtest ccs0: SUCCESS (2.050s)
[549.175963] Subtest busy: SUCCESS (7.798s)
[549.503170] [082/133] (471s left) gem_lmem_swapping (massive-random)
[549.544952] Subtest massive-random: SKIP (0.000s)
[549.589180] [083/133] (471s left) gem_exec_reloc (basic-wc-read-active)
[549.652553] Subtest basic-wc-read-active: SKIP (0.000s)
[549.718948] [084/133] (471s left) syncobj_timeline (multi-wait-available-signaled)
[549.774774] Starting subtest: multi-wait-available-signaled
[549.777030] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[549.879109] [085/133] (471s left) kms_flip (flip-vs-rmfb)
[549.980812] Starting subtest: flip-vs-rmfb
[549.983005] Starting dynamic subtest: A-eDP1
[558.623770] Dynamic subtest A-eDP1: SUCCESS (8.635s)
[558.636186] Starting dynamic subtest: B-eDP1
[567.259972] Dynamic subtest B-eDP1: SUCCESS (8.630s)
[567.273158] Starting dynamic subtest: C-eDP1
[575.884613] Dynamic subtest C-eDP1: SUCCESS (8.621s)
[575.896567] Starting dynamic subtest: D-eDP1
[584.550139] Dynamic subtest D-eDP1: SUCCESS (8.665s)
[584.554508] Subtest flip-vs-rmfb: SUCCESS (34.565s)
[585.710651] [086/133] (435s left) kms_concurrent (multi-plane-atomic-lowres)
[585.801359] Starting subtest: multi-plane-atomic-lowres
[585.803719] Starting dynamic subtest: pipe-A-eDP-1
[586.335021] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.531s)
[586.345474] Starting dynamic subtest: pipe-B-eDP-1
[587.549126] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.214s)
[587.560203] Starting dynamic subtest: pipe-C-eDP-1
[588.793985] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.243s)
[588.804216] Starting dynamic subtest: pipe-D-eDP-1
[590.022038] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.226s)
[590.024208] Subtest multi-plane-atomic-lowres: SUCCESS (4.219s)
[590.859433] [087/133] (430s left) i915_pm_rpm (system-suspend-execbuf)
[592.400850] Starting subtest: system-suspend-execbuf
[650.900961] Subtest system-suspend-execbuf: SUCCESS (43.186s)
[651.293054] [088/133] (370s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[651.394459] Starting subtest: fbcpsr-tiling-y
[651.399606] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[651.482658] [089/133] (369s left) gem_create (create-ext-cpu-access-big)
[651.647844] Starting subtest: create-ext-cpu-access-big
[651.653418] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[651.723429] [090/133] (369s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[651.835603] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[651.838511] Starting dynamic subtest: pipe-A-eDP-1
[658.519447] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.683s)
[658.537159] Starting dynamic subtest: pipe-B-eDP-1
[665.412268] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.888s)
[665.414803] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.574s)
[666.281202] [091/133] (355s left) kms_invalid_mode (bad-vsync-start)
[666.376967] Starting subtest: bad-vsync-start
[666.379254] Starting dynamic subtest: pipe-A-eDP-1
[666.665609] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[666.675838] Starting dynamic subtest: pipe-B-eDP-1
[666.678461] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[666.688491] Starting dynamic subtest: pipe-C-eDP-1
[666.691437] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[666.701103] Starting dynamic subtest: pipe-D-eDP-1
[666.703713] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[666.706512] Subtest bad-vsync-start: SUCCESS (0.295s)
[667.508301] [092/133] (354s left) gem_exec_reloc (basic-gtt-noreloc)
[667.574272] Subtest basic-gtt-noreloc: SKIP (0.000s)
[667.658302] [093/133] (354s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[667.753558] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[667.758419] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[667.900237] [094/133] (353s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[668.004078] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[668.009117] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[668.141869] [095/133] (353s left) gem_ringfill (legacy-basic)
[673.741413] Starting subtest: legacy-basic
[673.744600] Starting dynamic subtest: default
[673.801552] Dynamic subtest default: SUCCESS (0.059s)
[673.815252] Starting dynamic subtest: render
[673.845105] Dynamic subtest render: SUCCESS (0.041s)
[673.856748] Starting dynamic subtest: bsd
[673.889452] Dynamic subtest bsd: SUCCESS (0.041s)
[673.901876] Starting dynamic subtest: bsd1
[673.934721] Dynamic subtest bsd1: SUCCESS (0.043s)
[673.951920] Starting dynamic subtest: bsd2
[673.982724] Dynamic subtest bsd2: SUCCESS (0.044s)
[673.998882] Starting dynamic subtest: blt
[674.030399] Dynamic subtest blt: SUCCESS (0.045s)
[674.046588] Starting dynamic subtest: vebox
[674.077090] Dynamic subtest vebox: SUCCESS (0.044s)
[674.080177] Subtest legacy-basic: SUCCESS (0.337s)
[674.169137] [096/133] (347s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[674.270310] Starting subtest: psr-rgb565-draw-mmap-cpu
[681.131515] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.863s)
[681.245266] [097/133] (340s left) gen7_exec_parse (basic-offset)
[681.309242] Subtest basic-offset: SKIP (0.000s)
[681.367020] [098/133] (340s left) gem_ctx_isolation (preservation-reset)
[681.537866] Starting subtest: preservation-reset
[681.540467] Starting dynamic subtest: rcs0
[681.827259] Dynamic subtest rcs0: SUCCESS (0.289s)
[681.840223] Starting dynamic subtest: bcs0
[682.139612] Dynamic subtest bcs0: SUCCESS (0.311s)
[682.151825] Starting dynamic subtest: vcs0
[682.462844] Dynamic subtest vcs0: SUCCESS (0.322s)
[682.477839] Starting dynamic subtest: vcs1
[684.021573] Dynamic subtest vcs1: SUCCESS (1.558s)
[684.034553] Starting dynamic subtest: vecs0
[685.996388] Dynamic subtest vecs0: SUCCESS (1.974s)
[686.008906] Starting dynamic subtest: ccs0
[688.059083] Dynamic subtest ccs0: SUCCESS (2.062s)
[688.061709] Subtest preservation-reset: SUCCESS (6.524s)
[688.197935] [099/133] (333s left) kms_cursor_crc (cursor-offscreen-32x32)
[688.344559] Starting subtest: cursor-offscreen-32x32
[688.394077] Subtest cursor-offscreen-32x32: SKIP (0.042s)
[688.695568] [100/133] (333s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[688.795973] Starting subtest: plane-primary-overlay-mutable-zpos
[692.289156] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.491s)
[693.484599] [101/133] (328s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[693.549502] Starting subtest: invalid-bsd2-flag-on-blt
[693.552318] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[693.652301] [102/133] (328s left) kms_addfb_basic (tile-pitch-mismatch)
[693.708580] Starting subtest: tile-pitch-mismatch
[693.713761] Subtest tile-pitch-mismatch: SKIP (0.000s)
[693.839127] [103/133] (328s left) kms_getfb (getfb-handle-protection)
[693.938077] Starting subtest: getfb-handle-protection
[693.961515] Subtest getfb-handle-protection: SUCCESS (0.024s)
[694.077544] [104/133] (328s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[694.177856] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[694.857749] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.681s)
[695.031065] [105/133] (327s left) syncobj_timeline (etime-single-wait-submitted)
[695.087706] Starting subtest: etime-single-wait-submitted
[695.188934] Subtest etime-single-wait-submitted: SUCCESS (0.103s)
[695.292327] [106/133] (326s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[695.386897] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[695.389270] Starting dynamic subtest: pipe-A
[695.407310] Dynamic subtest pipe-A: SKIP (0.016s)
[695.417466] Starting dynamic subtest: pipe-B
[695.438211] Dynamic subtest pipe-B: SKIP (0.030s)
[695.448214] Starting dynamic subtest: pipe-C
[695.469635] Dynamic subtest pipe-C: SKIP (0.031s)
[695.479162] Starting dynamic subtest: pipe-D
[695.499783] Dynamic subtest pipe-D: SKIP (0.030s)
[695.503599] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.110s)
[695.585057] [107/133] (326s left) kms_setmode (invalid-clone-single-crtc)
[695.642748] Starting subtest: invalid-clone-single-crtc
[695.650134] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[695.740883] [108/133] (326s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[695.831841] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[695.834214] Starting dynamic subtest: pipe-A
[695.894490] Dynamic subtest pipe-A: SUCCESS (0.065s)
[695.905159] Starting dynamic subtest: pipe-B
[697.016019] Dynamic subtest pipe-B: SUCCESS (1.120s)
[697.028695] Starting dynamic subtest: pipe-C
[698.145964] Dynamic subtest pipe-C: SUCCESS (1.129s)
[698.164728] Starting dynamic subtest: pipe-D
[699.280452] Dynamic subtest pipe-D: SUCCESS (1.134s)
[699.282952] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.453s)
[700.429276] [109/133] (321s left) kms_rotation_crc (cursor-rotation-180)
[700.523810] Starting subtest: cursor-rotation-180
[702.118464] Subtest cursor-rotation-180: SUCCESS (1.595s)
[703.289604] [110/133] (319s left) perf_pmu (all-busy-idle-check-all)
[703.336408] Starting subtest: all-busy-idle-check-all
[704.714219] Subtest all-busy-idle-check-all: SUCCESS (1.377s)
[704.826789] [111/133] (317s left) gem_mmap_offset (mmap-unmap)
[704.877550] Starting subtest: mmap-unmap
[704.880090] Starting dynamic subtest: smem0
[727.346648] Dynamic subtest smem0: SUCCESS (22.464s)
[727.349596] Subtest mmap-unmap: SUCCESS (22.465s)
[727.465743] [112/133] (295s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[727.569223] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[727.574342] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[727.643649] [113/133] (294s left) kms_properties (get_properties-sanity-atomic)
[727.732961] Starting subtest: get_properties-sanity-atomic
[727.735583] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[727.808223] [114/133] (294s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[727.899108] Starting subtest: extended-pageflip-modeset-hang-oldfb
[727.901720] Starting dynamic subtest: pipe-A
[735.788388] Dynamic subtest pipe-A: SUCCESS (7.891s)
[735.799041] Starting dynamic subtest: pipe-D
[744.415432] Dynamic subtest pipe-D: SUCCESS (8.622s)
[744.418302] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.518s)
[745.251685] [115/133] (277s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[745.346114] Starting subtest: 2x-plain-flip-ts-check-interruptible
[745.358143] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[745.435107] [116/133] (277s left) gem_mmap_offset (ptrace)
[745.495809] Starting subtest: ptrace
[745.498329] Starting dynamic subtest: smem0-wb
[745.518484] Dynamic subtest smem0-wb: SUCCESS (0.022s)
[745.528241] Starting dynamic subtest: smem0-wc
[745.539599] Dynamic subtest smem0-wc: SUCCESS (0.020s)
[745.549687] Starting dynamic subtest: smem0-uc
[745.561460] Dynamic subtest smem0-uc: SUCCESS (0.022s)
[745.564355] Subtest ptrace: SUCCESS (0.069s)
[745.666703] [117/133] (277s left) gem_softpin (evict-prime-sanity-check)
[745.728700] Starting subtest: evict-prime-sanity-check
[745.731406] Starting dynamic subtest: rcs0
[746.875608] Dynamic subtest rcs0: SUCCESS (1.149s)
[746.888473] Starting dynamic subtest: bcs0
[747.995285] Dynamic subtest bcs0: SUCCESS (1.117s)
[748.010848] Starting dynamic subtest: vcs0
[749.702462] Dynamic subtest vcs0: SUCCESS (1.703s)
[749.716362] Starting dynamic subtest: vcs1
[751.731840] Dynamic subtest vcs1: SUCCESS (2.026s)
[751.744065] Starting dynamic subtest: vecs0
[753.652787] Dynamic subtest vecs0: SUCCESS (1.918s)
[753.667344] Starting dynamic subtest: ccs0
[754.787582] Dynamic subtest ccs0: SUCCESS (1.134s)
[754.800557] Starting dynamic subtest: all
[755.903158] Dynamic subtest all: SUCCESS (1.114s)
[755.906185] Subtest evict-prime-sanity-check: SUCCESS (10.178s)
[755.992118] [118/133] (266s left) kms_psr (pr-cursor-blt)
[756.090410] Starting subtest: pr-cursor-blt
[756.095605] Subtest pr-cursor-blt: SKIP (0.000s)
[756.161895] [119/133] (266s left) gem_exec_flush (basic-wb-ro-before-default)
[756.217307] Starting subtest: basic-wb-ro-before-default
[761.674593] Subtest basic-wb-ro-before-default: SUCCESS (5.456s)
[761.859512] [120/133] (261s left) sysfs_timeslice_duration (timeout)
[761.922443] Starting subtest: timeout
[761.925174] Starting dynamic subtest: vecs0
[771.718279] Dynamic subtest vecs0: SUCCESS (9.796s)
[771.730178] Starting dynamic subtest: ccs0
[772.997066] Dynamic subtest ccs0: SUCCESS (1.277s)
[773.011499] Starting dynamic subtest: vcs0
[782.662587] Dynamic subtest vcs0: SUCCESS (9.665s)
[782.674979] Starting dynamic subtest: bcs0
[783.281464] Dynamic subtest bcs0: SUCCESS (0.617s)
[783.293127] Starting dynamic subtest: rcs0
[784.522649] Dynamic subtest rcs0: SUCCESS (1.239s)
[784.534436] Starting dynamic subtest: vcs1
[793.731433] Dynamic subtest vcs1: SUCCESS (9.206s)
[793.734394] Subtest timeout: SUCCESS (31.814s)
[793.807947] [121/133] (229s left) gem_ctx_shared (exec-shared-gtt)
[793.873603] Starting subtest: exec-shared-gtt
[793.876413] Starting dynamic subtest: rcs0
[793.889589] Dynamic subtest rcs0: SUCCESS (0.015s)
[793.900178] Starting dynamic subtest: bcs0
[793.902612] Dynamic subtest bcs0: SUCCESS (0.009s)
[793.914497] Starting dynamic subtest: vcs0
[793.916890] Dynamic subtest vcs0: SUCCESS (0.010s)
[793.927085] Starting dynamic subtest: vcs1
[793.929568] Dynamic subtest vcs1: SUCCESS (0.012s)
[793.939657] Starting dynamic subtest: vecs0
[793.941990] Dynamic subtest vecs0: SUCCESS (0.010s)
[793.952252] Starting dynamic subtest: ccs0
[793.954591] Dynamic subtest ccs0: SUCCESS (0.009s)
[793.957182] Subtest exec-shared-gtt: SUCCESS (0.070s)
[794.132884] [122/133] (228s left) api_intel_allocator (reloc-allocator)
[794.190447] Starting subtest: reloc-allocator
[794.192906] Starting dynamic subtest: basic
[794.195640] Dynamic subtest basic: SUCCESS (0.007s)
[794.207351] Starting dynamic subtest: parallel-one
[794.210096] Dynamic subtest parallel-one: SUCCESS (0.009s)
[794.220453] Starting dynamic subtest: print
[794.223308] Dynamic subtest print: SUCCESS (0.000s)
[794.233398] Starting dynamic subtest: reuse
[794.235885] Dynamic subtest reuse: SUCCESS (0.000s)
[794.245695] Starting dynamic subtest: fork-reopen-allocator
[794.248205] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[794.250412] Subtest reloc-allocator: SUCCESS (0.033s)
[794.338208] [123/133] (228s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[794.445227] Starting subtest: pr-overlay-plane-move-continuous-sf
[794.450584] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[794.527018] [124/133] (228s left) kms_pm_rpm (pm-caching)
[796.064885] Starting subtest: pm-caching
[796.070462] Subtest pm-caching: SKIP (0.000s)
[796.787634] [125/133] (226s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[796.882197] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[803.460246] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.582s)
[803.573218] [126/133] (219s left) gem_vm_create (invalid-destroy)
[803.624594] Starting subtest: invalid-destroy
[803.627574] Subtest invalid-destroy: SUCCESS (0.002s)
[803.728672] [127/133] (219s left) kms_flip (2x-nonexisting-fb-interruptible)
[803.823555] Starting subtest: 2x-nonexisting-fb-interruptible
[803.836337] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.011s)
[803.937903] [128/133] (219s left) device_reset (cold-reset-bound)
[803.985566] Starting subtest: cold-reset-bound
[803.991018] Subtest cold-reset-bound: SKIP (0.000s)
[804.092603] [129/133] (219s left) syncobj_timeline (invalid-query-illegal-handle)
[804.150418] Starting subtest: invalid-query-illegal-handle
[804.152754] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[804.267056] [130/133] (219s left) kms_pm_backlight (fade)
[804.361839] Starting subtest: fade
[804.413696] Starting dynamic subtest: eDP-1
[807.088853] Dynamic subtest eDP-1: SUCCESS (2.676s)
[807.091251] Subtest fade: SUCCESS (2.728s)
[807.918980] [131/133] (215s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[808.030378] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[808.034760] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[808.123505] [132/133] (215s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[808.219210] Starting subtest: fbcpsr-stridechange
[814.517544] Subtest fbcpsr-stridechange: SUCCESS (6.304s)
[814.641097] [133/133] (208s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[814.693484] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[814.798106] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[814.877450] Closing watchdogs
results: parsing output: 0/ for test: prime_busy
results: parsing output: 1/ for test: kms_vblank
results: parsing output: 2/ for test: kms_prop_blob
results: parsing output: 3/ for test: gem_tiled_swapping
results: parsing output: 4/ for test: perf
results: parsing output: 5/ for test: syncobj_wait
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_cursor_legacy
results: parsing output: 9/ for test: gem_exec_balancer
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: api_intel_bb
results: parsing output: 12/ for test: kms_cursor_crc
results: parsing output: 13/ for test: gem_exec_params
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: kms_plane_lowres
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: gem_exec_schedule
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_color
results: parsing output: 24/ for test: gem_ctx_persistence
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_properties
results: parsing output: 29/ for test: gem_mmap
results: parsing output: 30/ for test: perf_pmu
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: gem_workarounds
results: parsing output: 33/ for test: perf
results: parsing output: 34/ for test: kms_selftest
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: kms_ccs
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_pxp
results: parsing output: 39/ for test: gem_exec_params
results: parsing output: 40/ for test: gem_partial_pwrite_pread
results: parsing output: 41/ for test: gem_exec_fence
results: parsing output: 42/ for test: kms_chamelium_edid
results: parsing output: 43/ for test: gem_ppgtt
results: parsing output: 44/ for test: kms_feature_discovery
results: parsing output: 45/ for test: kms_plane_alpha_blend
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: syncobj_wait
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_cursor_legacy
results: parsing output: 50/ for test: prime_mmap
results: parsing output: 51/ for test: gen3_render_tiledy_blits
results: parsing output: 52/ for test: kms_addfb_basic
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: kms_flip_scaled_crc
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_mmap_gtt
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_lease
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: kms_properties
results: parsing output: 63/ for test: i915_drm_fdinfo
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: gem_tiled_fence_blits
results: parsing output: 66/ for test: kms_chamelium_hpd
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: gem_exec_whisper
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_async_flips
results: parsing output: 72/ for test: i915_query
results: parsing output: 73/ for test: i915_hangman
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_rotation_crc
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_exec_fence
results: parsing output: 78/ for test: gem_exec_flush
results: parsing output: 79/ for test: gem_exec_schedule
results: parsing output: 80/ for test: gem_busy
results: parsing output: 81/ for test: gem_lmem_swapping
results: parsing output: 82/ for test: gem_exec_reloc
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: kms_concurrent
results: parsing output: 86/ for test: i915_pm_rpm
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_create
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: kms_invalid_mode
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_ringfill
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gen7_exec_parse
results: parsing output: 97/ for test: gem_ctx_isolation
results: parsing output: 98/ for test: kms_cursor_crc
results: parsing output: 99/ for test: kms_atomic
results: parsing output: 100/ for test: gem_exec_params
results: parsing output: 101/ for test: kms_addfb_basic
results: parsing output: 102/ for test: kms_getfb
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_plane_scaling
results: parsing output: 106/ for test: kms_setmode
results: parsing output: 107/ for test: kms_plane_scaling
results: parsing output: 108/ for test: kms_rotation_crc
results: parsing output: 109/ for test: perf_pmu
results: parsing output: 110/ for test: gem_mmap_offset
results: parsing output: 111/ for test: kms_plane
results: parsing output: 112/ for test: kms_properties
results: parsing output: 113/ for test: kms_busy
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: gem_mmap_offset
results: parsing output: 116/ for test: gem_softpin
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: gem_exec_flush
results: parsing output: 119/ for test: sysfs_timeslice_duration
results: parsing output: 120/ for test: gem_ctx_shared
results: parsing output: 121/ for test: api_intel_allocator
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: kms_pm_rpm
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_vm_create
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: device_reset
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: kms_pm_backlight
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: syncobj_timeline
Done.