[39.466241] Initializing watchdogs [39.466338] /dev/watchdog0 [39.474875] [001/130] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite) [39.595432] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite [39.600097] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [39.670915] [002/130] (960s left) gem_exec_schedule (preempt-queue-contexts-chain) [39.754823] Subtest preempt-queue-contexts-chain: SKIP (0.000s) [40.024997] [003/130] (959s left) gem_exec_fence (parallel) [40.204758] Starting subtest: parallel [40.207281] Starting dynamic subtest: rcs0 [42.354432] Dynamic subtest rcs0: SUCCESS (2.150s) [42.363476] Starting dynamic subtest: bcs0 [44.506981] Dynamic subtest bcs0: SUCCESS (2.153s) [44.515151] Starting dynamic subtest: vcs0 [46.656559] Dynamic subtest vcs0: SUCCESS (2.149s) [46.665761] Starting dynamic subtest: vcs1 [48.807962] Dynamic subtest vcs1: SUCCESS (2.151s) [48.817122] Starting dynamic subtest: vecs0 [50.968151] Dynamic subtest vecs0: SUCCESS (2.154s) [50.976416] Starting dynamic subtest: ccs0 [53.179128] Dynamic subtest ccs0: SUCCESS (2.157s) [53.181241] Subtest parallel: SUCCESS (12.916s) [53.987234] [004/130] (946s left) kms_pm_dc (dc5-retention-flops) [54.105983] Starting subtest: dc5-retention-flops [54.110669] Subtest dc5-retention-flops: SKIP (0.000s) [54.154678] [005/130] (945s left) perf_pmu (init-busy) [54.195800] Starting subtest: init-busy [54.198333] Starting dynamic subtest: rcs0 [54.200745] Dynamic subtest rcs0: SUCCESS (0.001s) [54.208605] Starting dynamic subtest: bcs0 [54.210930] Dynamic subtest bcs0: SUCCESS (0.000s) [54.217171] Starting dynamic subtest: vcs0 [54.219092] Dynamic subtest vcs0: SUCCESS (0.001s) [54.224811] Starting dynamic subtest: vcs1 [54.226663] Dynamic subtest vcs1: SUCCESS (0.000s) [54.232476] Starting dynamic subtest: vecs0 [54.234345] Dynamic subtest vecs0: SUCCESS (0.001s) [54.239964] Starting dynamic subtest: ccs0 [54.241836] Dynamic subtest ccs0: SUCCESS (0.000s) [54.243748] Subtest init-busy: SUCCESS (0.004s) [54.323587] [006/130] (945s left) kms_psr (fbc-psr-cursor-render) [54.415050] Starting subtest: fbc-psr-cursor-render [54.417492] Starting dynamic subtest: eDP-1 [54.422098] Dynamic subtest eDP-1: SKIP (0.000s) [54.426688] Subtest fbc-psr-cursor-render: SKIP (0.000s) [54.466233] [007/130] (945s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt) [54.570109] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt [54.574381] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [54.657802] [008/130] (945s left) kms_vblank (ts-continuation-modeset-hang) [54.753928] Starting subtest: ts-continuation-modeset-hang [54.756307] Starting dynamic subtest: pipe-A-eDP-1 [81.692924] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.811s) [81.706858] Starting dynamic subtest: pipe-D-eDP-1 [96.660069] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.960s) [96.662323] Subtest ts-continuation-modeset-hang: SUCCESS (41.774s) [97.534263] [009/130] (902s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render) [97.644455] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render [97.648948] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [97.733462] [010/130] (902s left) kms_chamelium_hpd (hdmi-hpd-after-suspend) [98.128673] Subtest hdmi-hpd-after-suspend: SKIP (0.000s) [98.983541] [011/130] (901s left) gem_pxp (hw-rejects-pxp-context) [99.111577] Subtest hw-rejects-pxp-context: SKIP (0.000s) [99.203742] [012/130] (901s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu) [99.340161] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu [99.344485] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [99.427641] [013/130] (900s left) kms_flip (flip-vs-panning) [99.526465] Starting subtest: flip-vs-panning [99.528889] Starting dynamic subtest: A-eDP1 [108.365790] Dynamic subtest A-eDP1: SUCCESS (8.838s) [108.372300] Starting dynamic subtest: B-eDP1 [117.137388] Dynamic subtest B-eDP1: SUCCESS (8.769s) [117.146031] Starting dynamic subtest: C-eDP1 [125.891276] Dynamic subtest C-eDP1: SUCCESS (8.752s) [125.900706] Starting dynamic subtest: D-eDP1 [134.660324] Dynamic subtest D-eDP1: SUCCESS (8.769s) [134.662483] Subtest flip-vs-panning: SUCCESS (35.134s) [135.929569] [014/130] (864s left) i915_pm_rps (fence-order) [135.990529] Starting subtest: fence-order [138.896353] Subtest fence-order: SUCCESS (2.903s) [138.951791] [015/130] (861s left) kms_fbcon_fbt (fbc) [139.013226] Starting subtest: fbc [144.501394] Subtest fbc: SUCCESS (5.488s) [144.548694] [016/130] (855s left) i915_hangman (engine-engine-error) [144.616569] Starting subtest: engine-engine-error [144.618833] Starting dynamic subtest: rcs0 [145.846514] Dynamic subtest rcs0: SUCCESS (1.228s) [145.854813] Starting dynamic subtest: bcs0 [147.893350] Dynamic subtest bcs0: SUCCESS (2.046s) [147.906171] Starting dynamic subtest: vcs0 [149.877476] Dynamic subtest vcs0: SUCCESS (1.983s) [149.888574] Starting dynamic subtest: vcs1 [151.861464] Dynamic subtest vcs1: SUCCESS (1.983s) [151.871580] Starting dynamic subtest: vecs0 [153.843701] Dynamic subtest vecs0: SUCCESS (1.982s) [153.855091] Starting dynamic subtest: ccs0 [155.894059] Dynamic subtest ccs0: SUCCESS (2.050s) [155.896262] Subtest engine-engine-error: SUCCESS (11.276s) [155.952702] [017/130] (844s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [156.065978] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling [156.068408] Starting dynamic subtest: pipe-A-default-mode [156.352649] Dynamic subtest pipe-A-default-mode: SKIP (0.282s) [156.357499] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.282s) [157.246199] [018/130] (843s left) gem_eio (in-flight-contexts-1us) [157.451886] Starting subtest: in-flight-contexts-1us [165.938086] Subtest in-flight-contexts-1us: SUCCESS (8.484s) [166.048643] [019/130] (834s left) kms_flip (basic-flip-vs-dpms) [166.146269] Starting subtest: basic-flip-vs-dpms [166.148423] Starting dynamic subtest: A-eDP1 [168.815496] Dynamic subtest A-eDP1: SUCCESS (2.669s) [168.825078] Starting dynamic subtest: B-eDP1 [171.121135] Dynamic subtest B-eDP1: SUCCESS (2.304s) [171.130739] Starting dynamic subtest: C-eDP1 [173.435604] Dynamic subtest C-eDP1: SUCCESS (2.315s) [173.444440] Starting dynamic subtest: D-eDP1 [175.742767] Dynamic subtest D-eDP1: SUCCESS (2.306s) [175.745195] Subtest basic-flip-vs-dpms: SUCCESS (9.599s) [176.636736] [020/130] (823s left) kms_hdr (brightness-with-hdr) [176.739753] Starting subtest: brightness-with-hdr [176.746210] Subtest brightness-with-hdr: SKIP (0.000s) [176.790723] [021/130] (823s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs) [176.891995] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs [176.894385] Starting dynamic subtest: pipe-A-eDP-1 [176.903302] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [176.910699] Starting dynamic subtest: pipe-B-eDP-1 [176.919307] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [176.926663] Starting dynamic subtest: pipe-C-eDP-1 [176.935215] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [176.942070] Starting dynamic subtest: pipe-D-eDP-1 [176.950157] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [176.954248] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.003s) [179.263599] [022/130] (821s left) gem_exec_reloc (basic-write-read-active) [179.323340] Subtest basic-write-read-active: SKIP (0.000s) [179.393865] [023/130] (821s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render) [179.512295] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render [179.516468] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [179.581803] [024/130] (821s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip) [179.687493] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip [180.552369] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.865s) [180.665347] [025/130] (819s left) drm_fdinfo (virtual-busy-hang) [180.705041] Starting subtest: virtual-busy-hang [180.709221] Subtest virtual-busy-hang: SKIP (0.000s) [180.751387] [026/130] (819s left) gem_exec_balancer (busy) [180.807813] Starting subtest: busy [182.967182] Subtest busy: SUCCESS (2.158s) [183.258880] [027/130] (817s left) kms_frontbuffer_tracking (fbc-suspend) [183.374143] Starting subtest: fbc-suspend [220.549987] Subtest fbc-suspend: SUCCESS (6.237s) [220.656626] [028/130] (810s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite) [220.756304] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite [225.335341] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.512s) [225.418467] [029/130] (806s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270) [225.517409] Starting subtest: primary-yf-tiled-reflect-x-270 [225.522026] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s) [225.571276] [030/130] (806s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [225.638896] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s) [225.769657] [031/130] (805s left) gem_exec_params (sol-reset-invalid) [225.834875] Starting subtest: sol-reset-invalid [225.837200] Subtest sol-reset-invalid: SUCCESS (0.002s) [227.785559] [032/130] (803s left) kms_cursor_crc (cursor-onscreen-32x32) [227.915313] Starting subtest: cursor-onscreen-32x32 [227.951822] Subtest cursor-onscreen-32x32: SKIP (0.031s) [228.206709] [033/130] (803s left) gem_exec_flush (basic-wb-ro-default) [228.264936] Starting subtest: basic-wb-ro-default [233.767904] Subtest basic-wb-ro-default: SUCCESS (5.471s) [233.940005] [034/130] (797s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted) [233.989227] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted [234.091559] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.103s) [234.151101] [035/130] (797s left) perf (blocking) [234.347717] Starting subtest: blocking [234.350296] Starting dynamic subtest: 0-rcs0 [244.369850] Dynamic subtest 0-rcs0: SUCCESS (9.998s) [244.379113] Starting dynamic subtest: 1-vcs1 [254.394588] Dynamic subtest 1-vcs1: SUCCESS (10.024s) [254.397067] Subtest blocking: SUCCESS (20.023s) [254.420146] [036/130] (777s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf) [259.551918] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf [259.556614] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s) [260.431128] [037/130] (771s left) gem_ctx_shared (create-shared-gtt) [260.502308] Starting subtest: create-shared-gtt [262.654632] Subtest create-shared-gtt: SUCCESS (2.151s) [263.006091] [038/130] (768s left) kms_color (invalid-degamma-lut-sizes) [263.104233] Starting subtest: invalid-degamma-lut-sizes [263.106532] Starting dynamic subtest: pipe-A [263.402611] Dynamic subtest pipe-A: SUCCESS (0.294s) [263.410661] Starting dynamic subtest: pipe-B [263.413078] Dynamic subtest pipe-B: SUCCESS (0.001s) [263.421287] Starting dynamic subtest: pipe-C [263.423650] Dynamic subtest pipe-C: SUCCESS (0.000s) [263.431375] Starting dynamic subtest: pipe-D [263.433627] Dynamic subtest pipe-D: SUCCESS (0.000s) [263.435892] Subtest invalid-degamma-lut-sizes: SUCCESS (0.297s) [264.279679] [039/130] (767s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled) [264.339835] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [264.342143] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s) [264.420660] [040/130] (767s left) syncobj_wait (invalid-multi-wait-all-unsubmitted) [264.476509] Starting subtest: invalid-multi-wait-all-unsubmitted [264.478837] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [264.561549] [041/130] (767s left) kms_big_fb (linear-8bpp-rotate-180) [264.672782] Starting subtest: linear-8bpp-rotate-180 [265.720482] Subtest linear-8bpp-rotate-180: SUCCESS (1.046s) [265.832379] [042/130] (766s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu) [265.942986] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu [269.132030] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (3.194s) [269.248612] [043/130] (762s left) gem_mmap_gtt (cpuset-basic-small-copy) [269.311356] Subtest cpuset-basic-small-copy: SKIP (0.000s) [269.357655] [044/130] (762s left) gem_ctx_engines (invalid-engines) [269.412647] Starting subtest: invalid-engines [269.458609] Subtest invalid-engines: FAIL (0.005s) [269.582470] [045/130] (762s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt) [269.695007] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt [269.698606] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [269.769230] [046/130] (762s left) gem_ctx_sseu (engines) [269.836148] Subtest engines: SKIP (0.000s) [269.904632] [047/130] (762s left) core_getclient [270.055749] [048/130] (762s left) fbdev (read) [270.104741] Starting subtest: read [270.629543] Subtest read: SUCCESS (0.522s) [270.671196] [049/130] (761s left) gem_exec_reloc (basic-cpu-gtt) [270.738462] Subtest basic-cpu-gtt: SKIP (0.000s) [270.791419] [050/130] (761s left) kms_psr (fbc-pr-basic) [270.887307] Starting subtest: fbc-pr-basic [270.891700] Subtest fbc-pr-basic: SKIP (0.000s) [270.939888] [051/130] (761s left) syncobj_timeline (32bits-limit) [270.999000] Starting subtest: 32bits-limit [271.001210] Subtest 32bits-limit: SUCCESS (0.001s) [271.092894] [052/130] (761s left) kms_cursor_crc (cursor-alpha-opaque) [271.188259] Starting subtest: cursor-alpha-opaque [271.190540] Starting dynamic subtest: pipe-A-eDP-1 [271.776054] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.583s) [271.784965] Starting dynamic subtest: pipe-D-eDP-1 [273.100331] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s) [273.102551] Subtest cursor-alpha-opaque: SUCCESS (1.910s) [273.967374] [053/130] (758s left) gen3_mixed_blits [274.076682] [054/130] (758s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs) [274.141076] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs [274.145615] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s) [274.304545] [055/130] (757s left) kms_big_fb (y-tiled-8bpp-rotate-0) [274.413915] Starting subtest: y-tiled-8bpp-rotate-0 [274.418487] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s) [274.490445] [056/130] (757s left) syncobj_basic (bad-create-flags) [274.550682] Starting subtest: bad-create-flags [274.552681] Subtest bad-create-flags: SUCCESS (0.000s) [274.641321] [057/130] (757s left) api_intel_bb (simple-bb-ctx) [274.697809] Starting subtest: simple-bb-ctx [274.703662] Subtest simple-bb-ctx: SUCCESS (0.007s) [274.845060] [058/130] (757s left) kms_chamelium_audio (hdmi-audio) [275.239994] Subtest hdmi-audio: SKIP (0.000s) [276.091683] [059/130] (756s left) kms_cursor_legacy (cursorb-vs-flipb-atomic) [276.214902] Starting subtest: cursorB-vs-flipB-atomic [276.219499] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s) [276.303201] [060/130] (756s left) syncobj_wait (wait-any-complex) [276.356098] Starting subtest: wait-any-complex [276.419813] Subtest wait-any-complex: SUCCESS (0.063s) [276.474882] [061/130] (755s left) api_intel_allocator (simple-allocator) [276.533649] Starting subtest: simple-allocator [276.535884] Starting dynamic subtest: basic [276.537755] Dynamic subtest basic: SUCCESS (0.004s) [276.548112] Starting dynamic subtest: parallel-one [276.714649] Dynamic subtest parallel-one: SUCCESS (0.178s) [276.724322] Starting dynamic subtest: print [276.726559] Dynamic subtest print: SUCCESS (0.000s) [276.737880] Starting dynamic subtest: reuse [276.740185] Dynamic subtest reuse: SUCCESS (0.000s) [276.748285] Starting dynamic subtest: reserve [276.750662] Dynamic subtest reserve: SUCCESS (0.000s) [276.758376] Starting dynamic subtest: fork-reopen-allocator [276.760519] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s) [276.762721] Subtest simple-allocator: SUCCESS (0.199s) [276.832322] [062/130] (755s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation) [276.936317] Starting subtest: plane-scaler-with-clipping-clamping-rotation [276.938646] Starting dynamic subtest: pipe-A [277.199492] Dynamic subtest pipe-A: SUCCESS (0.263s) [277.208663] Starting dynamic subtest: pipe-B [278.585449] Dynamic subtest pipe-B: SUCCESS (1.385s) [278.593878] Starting dynamic subtest: pipe-C [279.931113] Dynamic subtest pipe-C: SUCCESS (1.345s) [279.939669] Starting dynamic subtest: pipe-D [281.276235] Dynamic subtest pipe-D: SUCCESS (1.344s) [281.278647] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.340s) [282.512099] [063/130] (749s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt) [282.621437] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt [282.625856] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [282.695166] [064/130] (749s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation) [282.793442] Starting subtest: plane-upscale-factor-0-25-with-rotation [282.795692] Starting dynamic subtest: pipe-A [283.020659] Dynamic subtest pipe-A: SUCCESS (0.227s) [283.029621] Starting dynamic subtest: pipe-B [284.410189] Dynamic subtest pipe-B: SUCCESS (1.389s) [284.418734] Starting dynamic subtest: pipe-C [285.752888] Dynamic subtest pipe-C: SUCCESS (1.342s) [285.762092] Starting dynamic subtest: pipe-D [287.096625] Dynamic subtest pipe-D: SUCCESS (1.343s) [287.099037] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.303s) [288.335176] [065/130] (744s left) kms_draw_crc (draw-method-mmap-wc) [288.440746] Starting subtest: draw-method-mmap-wc [288.443032] Starting dynamic subtest: xrgb8888-untiled [288.641362] Dynamic subtest xrgb8888-untiled: SUCCESS (0.202s) [288.652104] Starting dynamic subtest: rgb565-untiled [288.830205] Dynamic subtest rgb565-untiled: SUCCESS (0.187s) [288.838827] Starting dynamic subtest: xrgb2101010-untiled [289.008026] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.177s) [289.016830] Starting dynamic subtest: xrgb8888-xtiled [289.119350] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.110s) [289.127424] Starting dynamic subtest: rgb565-xtiled [289.230768] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s) [289.244077] Starting dynamic subtest: xrgb2101010-xtiled [289.341268] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s) [289.350018] Starting dynamic subtest: xrgb8888-4tiled [289.474606] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.132s) [289.482630] Starting dynamic subtest: rgb565-4tiled [289.596655] Dynamic subtest rgb565-4tiled: SUCCESS (0.121s) [289.605016] Starting dynamic subtest: xrgb2101010-4tiled [289.707910] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.111s) [289.709959] Subtest draw-method-mmap-wc: SUCCESS (1.269s) [289.781673] [066/130] (742s left) gem_ppgtt (flink-and-close-vma-leak) [289.840560] Starting subtest: flink-and-close-vma-leak [289.881922] Subtest flink-and-close-vma-leak: SUCCESS (0.041s) [289.984322] [067/130] (742s left) gem_softpin (noreloc) [290.053448] Starting subtest: noreloc [295.451503] Subtest noreloc: SUCCESS (5.395s) [295.571822] [068/130] (736s left) gem_render_copy (x-tiled) [295.633393] Starting subtest: x-tiled [295.635744] Starting dynamic subtest: smem [295.680851] Dynamic subtest smem: SUCCESS (0.047s) [295.683183] Subtest x-tiled: SUCCESS (0.048s) [295.900339] [069/130] (736s left) gem_mmap_wc (write-cpu-read-wc-unflushed) [295.955572] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s) [296.001466] [070/130] (736s left) gem_ctx_param (invalid-ctx-get) [296.058275] Starting subtest: invalid-ctx-get [296.060644] Subtest invalid-ctx-get: SUCCESS (0.000s) [296.106817] [071/130] (736s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled) [296.174961] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled [296.177282] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s) [296.279012] [072/130] (736s left) kms_prop_blob (basic) [296.354924] Starting subtest: basic [296.357351] Subtest basic: SUCCESS (0.000s) [296.451575] [073/130] (736s left) kms_psr (psr-sprite-plane-onoff) [296.559050] Starting subtest: psr-sprite-plane-onoff [296.561326] Starting dynamic subtest: eDP-1 [298.398740] Dynamic subtest eDP-1: SUCCESS (1.837s) [298.401750] Subtest psr-sprite-plane-onoff: SUCCESS (1.838s) [299.278235] [074/130] (733s left) gem_ctx_persistence (file) [299.344674] Starting subtest: file [299.500483] Subtest file: SUCCESS (0.156s) [299.611358] [075/130] (733s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt) [299.722061] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt [299.726091] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [299.806809] [076/130] (732s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [299.910888] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [304.171929] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (4.264s) [304.276374] [077/130] (728s left) kms_plane_cursor (viewport) [304.396696] Starting subtest: viewport [304.401334] Starting dynamic subtest: pipe-A-eDP-1-size-64 [307.095547] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.699s) [307.155129] Starting dynamic subtest: pipe-A-eDP-1-size-128 [309.863044] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.714s) [309.929789] Starting dynamic subtest: pipe-A-eDP-1-size-256 [312.655456] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.736s) [313.003328] Starting dynamic subtest: pipe-B-eDP-1-size-64 [316.491809] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.501s) [316.550324] Starting dynamic subtest: pipe-B-eDP-1-size-128 [319.269332] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.725s) [319.329534] Starting dynamic subtest: pipe-B-eDP-1-size-256 [322.069624] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.748s) [322.420449] Starting dynamic subtest: pipe-C-eDP-1-size-64 [325.540326] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.133s) [325.577388] Starting dynamic subtest: pipe-C-eDP-1-size-128 [327.929748] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.358s) [327.968962] Starting dynamic subtest: pipe-C-eDP-1-size-256 [330.285855] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.324s) [330.615502] Starting dynamic subtest: pipe-D-eDP-1-size-64 [333.734468] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.128s) [333.772372] Starting dynamic subtest: pipe-D-eDP-1-size-128 [336.111564] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.345s) [336.150825] Starting dynamic subtest: pipe-D-eDP-1-size-256 [338.489630] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.347s) [338.808347] Subtest viewport: SUCCESS (34.415s) [339.671908] [078/130] (693s left) kms_addfb_basic (bad-pitch-128) [339.734641] Starting subtest: bad-pitch-128 [339.736591] Subtest bad-pitch-128: SUCCESS (0.000s) [339.865781] [079/130] (692s left) gem_exec_capture (capture-invisible) [339.925716] Starting subtest: capture-invisible [339.928085] Starting dynamic subtest: smem0 [339.932319] Dynamic subtest smem0: SKIP (0.000s) [339.936599] Subtest capture-invisible: SKIP (0.001s) [340.014562] [080/130] (692s left) syncobj_wait (invalid-single-wait-unsubmitted) [340.058129] Starting subtest: invalid-single-wait-unsubmitted [340.060372] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [340.142442] [081/130] (692s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [340.236493] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [340.240772] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [340.311942] [082/130] (692s left) kms_flip (dpms-off-confusion-interruptible) [340.422369] Starting subtest: dpms-off-confusion-interruptible [340.424550] Starting dynamic subtest: A-eDP1 [349.138686] Dynamic subtest A-eDP1: SUCCESS (8.714s) [349.149228] Starting dynamic subtest: B-eDP1 [357.845383] Dynamic subtest B-eDP1: SUCCESS (8.706s) [357.854297] Starting dynamic subtest: C-eDP1 [366.604439] Dynamic subtest C-eDP1: SUCCESS (8.756s) [366.613222] Starting dynamic subtest: D-eDP1 [375.305782] Dynamic subtest D-eDP1: SUCCESS (8.698s) [375.311793] Subtest dpms-off-confusion-interruptible: SUCCESS (34.885s) [376.591732] [083/130] (656s left) kms_psr (pr-cursor-mmap-gtt) [376.690427] Starting subtest: pr-cursor-mmap-gtt [376.694947] Subtest pr-cursor-mmap-gtt: SKIP (0.000s) [376.743901] [084/130] (656s left) gen9_exec_parse (batch-without-end) [376.815370] Subtest batch-without-end: SKIP (0.000s) [376.860115] [085/130] (656s left) kms_hdmi_inject (inject-audio) [377.198059] Starting subtest: inject-audio [377.504187] Subtest inject-audio: SUCCESS (0.307s) [378.096617] [086/130] (654s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [378.204151] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [378.783589] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.581s) [378.901900] [087/130] (654s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt) [379.010628] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt [379.015040] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [379.100360] [088/130] (653s left) gem_exec_whisper (basic-queues-forked) [379.170965] Starting subtest: basic-queues-forked [399.651398] Subtest basic-queues-forked: SUCCESS (20.476s) [399.818097] [089/130] (633s left) kms_psr (fbc-psr2-primary-mmap-gtt) [399.910383] Starting subtest: fbc-psr2-primary-mmap-gtt [399.912749] Starting dynamic subtest: eDP-1 [399.916971] Dynamic subtest eDP-1: SKIP (0.000s) [399.921290] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s) [399.965482] [090/130] (633s left) kms_dirtyfb (psr-dirtyfb-ioctl) [400.054616] Starting subtest: psr-dirtyfb-ioctl [400.056909] Starting dynamic subtest: A-eDP-1 [401.842926] Dynamic subtest A-eDP-1: SUCCESS (1.787s) [401.845295] Subtest psr-dirtyfb-ioctl: SUCCESS (1.788s) [402.777090] [091/130] (630s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render) [402.892960] Starting subtest: fbc-rgb101010-draw-render [406.485185] Subtest fbc-rgb101010-draw-render: SUCCESS (3.596s) [406.591450] [092/130] (626s left) kms_chamelium_edid (hdmi-mode-timings) [406.981572] Subtest hdmi-mode-timings: SKIP (0.000s) [407.866738] [093/130] (625s left) kms_cursor_crc (cursor-sliding-512x170) [408.135509] Starting subtest: cursor-sliding-512x170 [408.139191] Subtest cursor-sliding-512x170: SKIP (0.001s) [408.265573] [094/130] (624s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu) [408.366096] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu [410.864232] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.502s) [410.957089] [095/130] (622s left) gem_exec_reloc (basic-active) [411.005953] Subtest basic-active: SKIP (0.000s) [411.051397] [096/130] (622s left) gem_spin_batch (user-each) [411.104531] Starting subtest: user-each [414.381212] Subtest user-each: SUCCESS (3.269s) [414.782515] [097/130] (618s left) kms_psr (psr2-primary-mmap-cpu) [414.890077] Starting subtest: psr2-primary-mmap-cpu [414.892470] Starting dynamic subtest: eDP-1 [416.676987] Dynamic subtest eDP-1: SUCCESS (1.784s) [416.679361] Subtest psr2-primary-mmap-cpu: SUCCESS (1.786s) [417.552800] [098/130] (615s left) syncobj_timeline (wait-for-submit-complex) [417.624199] Starting subtest: wait-for-submit-complex [417.684586] Subtest wait-for-submit-complex: SUCCESS (0.062s) [417.741086] [099/130] (615s left) gem_mmap_offset (open-flood) [417.804845] Starting subtest: open-flood [439.303806] Subtest open-flood: SUCCESS (21.495s) [439.408133] [100/130] (593s left) gen7_exec_parse (chained-batch) [439.474697] Subtest chained-batch: SKIP (0.000s) [439.541196] [101/130] (593s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling) [439.631615] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling [439.633538] Starting dynamic subtest: pipe-A-default-mode [440.817427] Dynamic subtest pipe-A-default-mode: SKIP (1.181s) [440.822170] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.182s) [440.941217] [102/130] (592s left) gem_softpin (evict-active) [441.003881] Starting subtest: evict-active [441.009558] Subtest evict-active: SUCCESS (0.006s) [441.130152] [103/130] (592s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [441.236325] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [441.238664] Starting dynamic subtest: pipe-A-eDP-1 [443.228063] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.990s) [443.237328] Starting dynamic subtest: pipe-B-eDP-1 [445.349841] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.123s) [445.359237] Starting dynamic subtest: pipe-C-eDP-1 [447.463218] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.112s) [447.472292] Starting dynamic subtest: pipe-D-eDP-1 [449.541321] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.078s) [449.543570] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.306s) [450.830520] [104/130] (582s left) kms_tiled_display (basic-test-pattern) [450.953304] Subtest basic-test-pattern: SKIP (0.000s) [450.979123] [105/130] (582s left) gem_exec_schedule (u-fairslice-all) [451.047152] Starting subtest: u-fairslice-all [453.106967] Subtest u-fairslice-all: SUCCESS (2.064s) [453.384456] [106/130] (579s left) kms_big_fb (4-tiled-16bpp-rotate-0) [453.492927] Starting subtest: 4-tiled-16bpp-rotate-0 [454.559883] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.069s) [454.698975] [107/130] (578s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [454.807545] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [459.429779] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.623s) [459.546844] [108/130] (573s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs) [459.640319] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs [459.642583] Starting dynamic subtest: pipe-A-eDP-1 [459.665880] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [459.676883] Starting dynamic subtest: pipe-B-eDP-1 [459.698796] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [459.707859] Starting dynamic subtest: pipe-C-eDP-1 [459.729916] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [459.738325] Starting dynamic subtest: pipe-D-eDP-1 [459.760432] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [459.764482] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s) [461.967445] [109/130] (571s left) dmabuf_sync_file (export-multiwait) [462.012904] Starting subtest: export-multiwait [462.015310] Subtest export-multiwait: SUCCESS (0.000s) [462.047472] [110/130] (571s left) kms_plane_alpha_blend (alpha-basic) [462.157498] Starting subtest: alpha-basic [462.451003] Starting dynamic subtest: pipe-A-eDP-1 [464.345961] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.893s) [464.369848] Starting dynamic subtest: pipe-D-eDP-1 [467.050659] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.688s) [467.052988] Subtest alpha-basic: SUCCESS (4.893s) [467.921208] [111/130] (565s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [467.979211] Starting subtest: y-tiled-ccs-to-y-tiled [467.983677] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s) [468.145438] [112/130] (565s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw) [468.254105] Starting subtest: psr-2p-pri-indfb-multidraw [468.258395] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s) [468.345426] [113/130] (565s left) kms_atomic_interruptible (legacy-setmode) [468.444332] Starting subtest: legacy-setmode [468.446640] Starting dynamic subtest: pipe-A-eDP-1 [475.314753] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.871s) [475.317130] Subtest legacy-setmode: SUCCESS (6.872s) [476.176821] [114/130] (557s left) prime_vgem (busy) [476.242716] Starting subtest: busy [476.245127] Starting dynamic subtest: rcs0 [476.302451] Dynamic subtest rcs0: SUCCESS (0.059s) [476.311254] Starting dynamic subtest: bcs0 [476.356682] Dynamic subtest bcs0: SUCCESS (0.054s) [476.365436] Starting dynamic subtest: vcs0 [476.403019] Dynamic subtest vcs0: SUCCESS (0.045s) [476.412485] Starting dynamic subtest: vcs1 [476.448965] Dynamic subtest vcs1: SUCCESS (0.045s) [476.457609] Starting dynamic subtest: vecs0 [476.495588] Dynamic subtest vecs0: SUCCESS (0.046s) [476.504426] Starting dynamic subtest: ccs0 [476.543129] Dynamic subtest ccs0: SUCCESS (0.047s) [476.545414] Subtest busy: SUCCESS (0.301s) [476.642229] [115/130] (556s left) gem_lmem_swapping (heavy-verify-multi-ccs) [476.687429] Subtest heavy-verify-multi-ccs: SKIP (0.000s) [476.721376] [116/130] (556s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area) [481.854462] Starting subtest: pr-primary-plane-update-sf-dmg-area [481.859342] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.002s) [482.767561] [117/130] (550s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [482.869310] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip [482.873605] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [482.946035] [118/130] (550s left) syncobj_timeline (wait-all-interrupted) [483.003019] Starting subtest: wait-all-interrupted [483.103566] Subtest wait-all-interrupted: SUCCESS (0.101s) [483.156661] [119/130] (550s left) perf_pmu (cpu-hotplug) [483.194982] Starting subtest: cpu-hotplug [483.201898] Subtest cpu-hotplug: SKIP (0.004s) [483.298325] [120/130] (550s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-wc) [483.394615] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-wc [487.896168] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (4.504s) [488.013213] [121/130] (545s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt) [488.125282] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt [488.129444] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [488.200163] [122/130] (545s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc) [488.302024] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc [488.304332] Starting dynamic subtest: pipe-A-eDP-1 [488.711051] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.376s) [488.726437] Starting dynamic subtest: pipe-B-eDP-1 [490.156527] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.445s) [490.167965] Starting dynamic subtest: pipe-C-eDP-1 [491.605576] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.449s) [491.616484] Starting dynamic subtest: pipe-D-eDP-1 [493.010271] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.404s) [493.012536] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.678s) [494.223478] [123/130] (539s left) kms_addfb_basic (invalid-smem-bo-on-discrete) [494.272299] Starting subtest: invalid-smem-bo-on-discrete [494.276538] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s) [494.402835] [124/130] (539s left) perf (gen12-invalid-class-instance) [494.503633] Starting subtest: gen12-invalid-class-instance [494.513094] Subtest gen12-invalid-class-instance: SUCCESS (0.007s) [494.534059] [125/130] (539s left) gem_ppgtt (blt-vs-render-ctxn) [494.587809] Starting subtest: blt-vs-render-ctxN [527.694106] Subtest blt-vs-render-ctxN: SUCCESS (33.102s) [527.814385] [126/130] (505s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0) [527.973969] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0 [527.977936] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s) [528.075826] [127/130] (505s left) gem_eio (in-flight-internal-10ms) [528.307056] Starting subtest: in-flight-internal-10ms [529.836330] Subtest in-flight-internal-10ms: SUCCESS (1.529s) [529.988370] [128/130] (503s left) kms_joiner (basic-ultra-joiner) [530.093063] Starting subtest: basic-ultra-joiner [530.097472] Subtest basic-ultra-joiner: SKIP (0.000s) [530.140131] [129/130] (503s left) gem_render_copy (yf-tiled-ccs-to-x-tiled) [530.209625] Starting subtest: yf-tiled-ccs-to-x-tiled [530.214144] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s) [530.372987] [130/130] (503s left) kms_addfb_basic (bad-pitch-256) [530.468400] Starting subtest: bad-pitch-256 [530.470809] Subtest bad-pitch-256: SUCCESS (0.000s) [530.586323] Closing watchdogs Done.