[58.431547] Initializing watchdogs
[58.431595]   /dev/watchdog0
[58.446217] [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]
[58.450983] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.453198] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.456401] [001/133] (960s left) gem_exec_balancer (parallel-bb-first)
[58.748530] Starting subtest: parallel-bb-first
[59.724835] Subtest parallel-bb-first: SUCCESS (0.976s)
[60.335659] [002/133] (958s left) kms_atomic_transition (plane-all-transition-fencing)
[60.437899] Starting subtest: plane-all-transition-fencing
[60.440360] Starting dynamic subtest: pipe-A-eDP-1
[62.982936] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.546s)
[63.304794] Starting dynamic subtest: pipe-B-eDP-1
[66.513068] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.216s)
[66.833621] Subtest plane-all-transition-fencing: SUCCESS (6.395s)
[67.652889] [003/133] (951s left) kms_panel_fitting (atomic-fastset)
[67.749336] Starting subtest: atomic-fastset
[67.751796] Starting dynamic subtest: pipe-A-eDP-1
[67.893051] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.146s)
[67.902852] Starting dynamic subtest: pipe-B-eDP-1
[69.101734] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.207s)
[69.109657] Starting dynamic subtest: pipe-C-eDP-1
[70.299832] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.197s)
[70.308943] Starting dynamic subtest: pipe-D-eDP-1
[71.525435] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.226s)
[71.527634] Subtest atomic-fastset: SUCCESS (3.779s)
[72.788105] [004/133] (946s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[72.896353] Starting subtest: crc-primary-suspend-y-tiled-ccs
[72.899175] Starting dynamic subtest: pipe-A-eDP-1
[72.910181] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[72.920852] Starting dynamic subtest: pipe-B-eDP-1
[72.931308] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[72.939390] Starting dynamic subtest: pipe-C-eDP-1
[72.949408] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[72.957027] Starting dynamic subtest: pipe-D-eDP-1
[72.966111] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[72.970684] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.006s)
[75.118096] [005/133] (944s left) kms_psr (pr-primary-blt)
[75.200253] Starting subtest: pr-primary-blt
[75.204245] Subtest pr-primary-blt: SKIP (0.000s)
[75.280586] [006/133] (943s left) syncobj_wait (wait-all-snapshot)
[75.334734] Starting subtest: wait-all-snapshot
[75.415732] Subtest wait-all-snapshot: SUCCESS (0.081s)
[75.487967] [007/133] (943s left) kms_cursor_crc (cursor-offscreen-32x32)
[75.636346] Starting subtest: cursor-offscreen-32x32
[75.686019] Subtest cursor-offscreen-32x32: SKIP (0.045s)
[75.977875] [008/133] (943s left) kms_properties (plane-properties-legacy)
[76.072322] Starting subtest: plane-properties-legacy
[76.074178] Starting dynamic subtest: pipe-A-eDP-1
[76.635589] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.563s)
[76.645546] Starting dynamic subtest: pipe-B-eDP-1
[77.910804] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.274s)
[77.920305] Starting dynamic subtest: pipe-C-eDP-1
[79.231083] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.318s)
[79.241480] Starting dynamic subtest: pipe-D-eDP-1
[80.468468] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.237s)
[80.470645] Subtest plane-properties-legacy: SUCCESS (4.396s)
[81.270821] [009/133] (938s left) kms_atomic_interruptible (legacy-setmode)
[81.364620] Starting subtest: legacy-setmode
[81.366921] Starting dynamic subtest: pipe-A-eDP-1
[88.247471] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.881s)
[88.249734] Subtest legacy-setmode: SUCCESS (6.882s)
[89.045706] [010/133] (930s left) api_intel_bb (reset-flags)
[89.103213] Starting subtest: reset-flags
[89.108622] Subtest reset-flags: SUCCESS (0.008s)
[89.228498] [011/133] (930s left) gem_pxp (regular-baseline-src-copy-readible)
[89.355427] Starting subtest: regular-baseline-src-copy-readible
[89.412474] Subtest regular-baseline-src-copy-readible: SUCCESS (0.060s)
[89.527830] [012/133] (929s left) kms_pm_rpm (fences-dpms)
[91.458421] Starting subtest: fences-dpms
[91.463702] Subtest fences-dpms: SKIP (0.000s)
[91.851947] [013/133] (927s left) gem_spin_batch (legacy)
[91.912424] Starting subtest: legacy
[91.914815] Starting dynamic subtest: default
[95.153557] Dynamic subtest default: SUCCESS (3.235s)
[95.163279] Starting dynamic subtest: render
[98.388672] Dynamic subtest render: SUCCESS (3.234s)
[98.398238] Starting dynamic subtest: bsd
[101.626575] Dynamic subtest bsd: SUCCESS (3.235s)
[101.636741] Starting dynamic subtest: bsd1
[104.863238] Dynamic subtest bsd1: SUCCESS (3.235s)
[104.873321] Starting dynamic subtest: bsd2
[108.096334] Dynamic subtest bsd2: SUCCESS (3.230s)
[108.105619] Starting dynamic subtest: blt
[111.333866] Dynamic subtest blt: SUCCESS (3.235s)
[111.343440] Starting dynamic subtest: vebox
[114.569845] Dynamic subtest vebox: SUCCESS (3.233s)
[114.572225] Subtest legacy: SUCCESS (22.654s)
[115.344363] [014/133] (904s left) gem_userptr_blits (map-fixed-invalidate-busy)
[115.404651] Starting subtest: map-fixed-invalidate-busy
[115.409642] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[115.541207] [015/133] (903s left) gem_mmap_offset (mmap-boundaries)
[115.594239] Starting subtest: mmap-boundaries
[115.596225] Starting dynamic subtest: smem0
[115.881297] Dynamic subtest smem0: SUCCESS (0.289s)
[115.884039] Subtest mmap-boundaries: SUCCESS (0.289s)
[115.999306] [016/133] (903s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[116.100757] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[116.102948] Starting dynamic subtest: pipe-A-eDP-1
[116.391311] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.259s)
[116.401595] Starting dynamic subtest: pipe-B-eDP-1
[117.731355] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.342s)
[117.739637] Starting dynamic subtest: pipe-C-eDP-1
[119.040827] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.305s)
[119.050441] Starting dynamic subtest: pipe-D-eDP-1
[120.239285] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.201s)
[120.241250] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.111s)
[121.362163] [017/133] (898s left) kms_properties (crtc-properties-atomic)
[121.453067] Starting subtest: crtc-properties-atomic
[121.455324] Starting dynamic subtest: pipe-A-eDP-1
[121.889179] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.436s)
[121.898080] Starting dynamic subtest: pipe-B-eDP-1
[123.025305] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.134s)
[123.036704] Starting dynamic subtest: pipe-C-eDP-1
[124.157600] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.133s)
[124.167235] Starting dynamic subtest: pipe-D-eDP-1
[125.285487] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s)
[125.287490] Subtest crtc-properties-atomic: SUCCESS (3.833s)
[126.100426] [018/133] (893s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[126.195624] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[126.199798] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[126.325020] [019/133] (893s left) prime_busy (after-wait)
[126.378486] Starting subtest: after-wait
[126.383136] Starting dynamic subtest: rcs0
[126.412649] Dynamic subtest rcs0: SUCCESS (0.031s)
[126.423071] Starting dynamic subtest: bcs0
[126.464244] Dynamic subtest bcs0: SUCCESS (0.051s)
[126.473437] Starting dynamic subtest: vcs0
[126.504991] Dynamic subtest vcs0: SUCCESS (0.041s)
[126.514197] Starting dynamic subtest: vcs1
[126.547249] Dynamic subtest vcs1: SUCCESS (0.041s)
[126.555250] Starting dynamic subtest: vecs0
[126.587330] Dynamic subtest vecs0: SUCCESS (0.040s)
[126.595119] Starting dynamic subtest: ccs0
[126.628977] Dynamic subtest ccs0: SUCCESS (0.041s)
[126.738740] Subtest after-wait: SUCCESS (0.358s)
[126.809238] [020/133] (892s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[126.902596] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[126.906666] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[126.965996] [021/133] (892s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[127.068634] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[127.072776] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[127.177939] [022/133] (892s left) gem_exec_reloc (basic-wc)
[127.233630] Subtest basic-wc: SKIP (0.000s)
[127.293934] [023/133] (892s left) kms_vblank (crtc-id)
[127.388096] Starting subtest: crtc-id
[127.389946] Starting dynamic subtest: pipe-A-eDP-1
[127.830637] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.442s)
[127.844543] Starting dynamic subtest: pipe-D-eDP-1
[128.917489] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.083s)
[128.919756] Subtest crtc-id: SUCCESS (1.529s)
[129.757403] [024/133] (890s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[129.883429] Starting subtest: 2x-cursor-vs-flip-atomic
[129.888055] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[130.023152] [025/133] (889s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[130.120807] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[130.123050] Starting dynamic subtest: pipe-A-default-mode
[131.305174] Dynamic subtest pipe-A-default-mode: SKIP (1.182s)
[131.309128] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.183s)
[131.447842] [026/133] (888s left) kms_psr (psr-primary-blt)
[131.530833] Starting subtest: psr-primary-blt
[131.533039] Starting dynamic subtest: eDP-1
[133.263588] Dynamic subtest eDP-1: SUCCESS (1.732s)
[133.265767] Subtest psr-primary-blt: SUCCESS (1.732s)
[134.136429] [027/133] (885s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[134.237690] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[134.240126] Starting dynamic subtest: A-eDP1
[143.180308] Dynamic subtest A-eDP1: SUCCESS (8.942s)
[143.190581] Starting dynamic subtest: B-eDP1
[152.111492] Dynamic subtest B-eDP1: SUCCESS (8.929s)
[152.119182] Starting dynamic subtest: C-eDP1
[161.028071] Dynamic subtest C-eDP1: SUCCESS (8.912s)
[161.037088] Starting dynamic subtest: D-eDP1
[169.964585] Dynamic subtest D-eDP1: SUCCESS (8.934s)
[169.967192] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.725s)
[171.186436] [028/133] (848s left) gem_reg_read (bad-register)
[171.246031] Starting subtest: bad-register
[171.248197] Subtest bad-register: SUCCESS (0.000s)
[171.337798] [029/133] (848s left) gem_ctx_param (invalid-set-no-zeromap)
[171.397828] Starting subtest: invalid-set-no-zeromap
[171.399779] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[171.467015] [030/133] (848s left) kms_chamelium_audio (dp-audio)
[171.848525] Subtest dp-audio: SKIP (0.000s)
[172.699942] [031/133] (847s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[172.800646] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[173.846794] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.047s)
[173.962832] [032/133] (846s left) prime_mmap (test_forked_cpu_write)
[174.018514] Starting subtest: test_forked_cpu_write
[174.020724] Starting dynamic subtest: test_forked_cpu_write-smem
[174.027448] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s)
[174.029269] Subtest test_forked_cpu_write: SUCCESS (0.010s)
[174.122897] [033/133] (846s left) gem_exec_fence (parallel)
[174.291107] Starting subtest: parallel
[174.293921] Starting dynamic subtest: rcs0
[176.443069] Dynamic subtest rcs0: SUCCESS (2.153s)
[176.452596] Starting dynamic subtest: bcs0
[178.595175] Dynamic subtest bcs0: SUCCESS (2.151s)
[178.604821] Starting dynamic subtest: vcs0
[180.744060] Dynamic subtest vcs0: SUCCESS (2.148s)
[180.753824] Starting dynamic subtest: vcs1
[182.898163] Dynamic subtest vcs1: SUCCESS (2.152s)
[182.908587] Starting dynamic subtest: vecs0
[185.053060] Dynamic subtest vecs0: SUCCESS (2.154s)
[185.062478] Starting dynamic subtest: ccs0
[187.210840] Dynamic subtest ccs0: SUCCESS (2.157s)
[187.213144] Subtest parallel: SUCCESS (12.921s)
[188.390733] [FACT gem_exec_fence (parallel)] new: kernel.kmod_is_loaded.vgem: true
[188.394276] [034/133] (831s left) syncobj_timeline (wait-all-snapshot)
[188.452710] Starting subtest: wait-all-snapshot
[188.535066] Subtest wait-all-snapshot: SUCCESS (0.082s)
[188.617201] [035/133] (831s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[188.720257] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[188.724207] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[188.832384] [036/133] (831s left) kms_cursor_edge_walk (256x256-top-bottom)
[188.930085] Starting subtest: 256x256-top-bottom
[188.932331] Starting dynamic subtest: pipe-A-eDP-1
[192.385753] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.457s)
[192.396456] Starting dynamic subtest: pipe-D-eDP-1
[195.517277] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.127s)
[195.519424] Subtest 256x256-top-bottom: SUCCESS (6.586s)
[196.327375] [037/133] (824s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[196.425039] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[196.427306] Starting dynamic subtest: pipe-A-eDP-1
[196.449741] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[196.459786] Starting dynamic subtest: pipe-B-eDP-1
[196.481640] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[196.489708] Starting dynamic subtest: pipe-C-eDP-1
[196.511330] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[196.519125] Starting dynamic subtest: pipe-D-eDP-1
[196.541201] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[196.545210] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[198.680737] [038/133] (821s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[198.785863] Starting subtest: x-tiled-32bpp-rotate-270
[198.805082] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[198.917357] [039/133] (821s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[199.007584] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[199.011979] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[199.116901] [040/133] (821s left) kms_psr (fbc-psr2-sprite-blt)
[199.205796] Starting subtest: fbc-psr2-sprite-blt
[199.208091] Starting dynamic subtest: eDP-1
[199.212241] Dynamic subtest eDP-1: SKIP (0.000s)
[199.216323] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[199.283486] [041/133] (821s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[199.341431] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[199.441509] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[199.518803] [042/133] (821s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[199.613239] Starting subtest: psr-rgb565-draw-pwrite
[206.709540] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.097s)
[206.831968] [043/133] (813s left) gem_mmap_wc (write-wc-read-gtt)
[206.890212] Subtest write-wc-read-gtt: SKIP (0.000s)
[206.959964] [044/133] (813s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[207.060620] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[207.065397] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[207.185592] [045/133] (813s left) syncobj_timeline (32bits-limit)
[207.233066] Starting subtest: 32bits-limit
[207.235277] Subtest 32bits-limit: SUCCESS (0.001s)
[207.316227] [046/133] (813s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[207.406544] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[207.410950] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[207.514630] [047/133] (813s left) gem_basic (create-close)
[207.562742] Starting subtest: create-close
[207.566903] Subtest create-close: SUCCESS (0.000s)
[207.659552] [048/133] (813s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[207.761462] Starting subtest: yf-tiled-16bpp-rotate-180
[207.765034] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[207.866464] [049/133] (812s left) prime_self_import (basic-with_one_bo)
[207.899109] Starting subtest: basic-with_one_bo
[207.920199] Subtest basic-with_one_bo: SUCCESS (0.022s)
[208.039434] [050/133] (812s left) gem_mmap_gtt (basic-write-gtt)
[208.090217] Subtest basic-write-gtt: SKIP (0.000s)
[208.146164] [051/133] (812s left) kms_getfb (getfb2-into-addfb2)
[208.230651] Starting subtest: getfb2-into-addfb2
[208.232609] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[208.351430] [052/133] (812s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[208.445340] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[208.448809] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[208.548540] [053/133] (812s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[208.635556] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[216.013250] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.379s)
[216.138211] [054/133] (804s left) gem_create (create-ext-cpu-access-big)
[216.311899] Starting subtest: create-ext-cpu-access-big
[216.316692] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[216.385374] [055/133] (804s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[216.485897] Starting subtest: y-tiled-32bpp-rotate-90
[216.490403] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[216.596238] [056/133] (804s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[216.712355] Starting subtest: cursorB-vs-flipB-atomic
[216.716813] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[216.857139] [057/133] (804s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[216.963505] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[216.967774] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[217.058352] [058/133] (804s left) kms_cursor_legacy (single-move)
[217.175401] Starting subtest: single-move
[217.177616] Starting dynamic subtest: pipe-A
[222.558399] Dynamic subtest pipe-A: SUCCESS (5.379s)
[222.570699] Starting dynamic subtest: pipe-B
[227.943451] Dynamic subtest pipe-B: SUCCESS (5.383s)
[227.951787] Starting dynamic subtest: pipe-C
[233.327909] Dynamic subtest pipe-C: SUCCESS (5.381s)
[233.338704] Starting dynamic subtest: pipe-D
[238.711893] Dynamic subtest pipe-D: SUCCESS (5.380s)
[238.723641] Starting dynamic subtest: all-pipes
[244.101654] Dynamic subtest all-pipes: SUCCESS (5.384s)
[244.103822] Subtest single-move: SUCCESS (26.921s)
[244.245565] [059/133] (777s left) core_getversion (basic)
[244.287491] Starting subtest: basic
[244.291706] Subtest basic: SUCCESS (0.000s)
[244.353894] [060/133] (776s left) kms_async_flips (test-cursor)
[244.437960] Starting subtest: test-cursor
[244.821930] Starting dynamic subtest: pipe-A-eDP-1
[245.640872] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.821s)
[246.025217] Starting dynamic subtest: pipe-B-eDP-1
[246.774841] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.760s)
[247.149297] Starting dynamic subtest: pipe-C-eDP-1
[247.906652] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.766s)
[248.277100] Starting dynamic subtest: pipe-D-eDP-1
[249.030805] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.764s)
[249.033163] Subtest test-cursor: SUCCESS (4.595s)
[250.212290] [061/133] (771s left) syncobj_timeline (multi-wait-all-available-submitted)
[250.260206] Starting subtest: multi-wait-all-available-submitted
[250.262455] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[250.365445] [062/133] (771s left) kms_flip_tiling (flip-change-tiling)
[250.453358] Starting subtest: flip-change-tiling
[250.455587] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[250.658037] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.205s)
[250.669447] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[250.792226] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[250.802846] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[250.925485] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[250.936081] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[251.069074] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[251.080359] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[251.213194] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[251.227122] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[251.357609] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[251.368815] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[251.501919] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.142s)
[251.516693] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[251.624744] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.120s)
[251.635313] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[251.771120] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.143s)
[251.784982] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[251.913635] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.141s)
[251.925850] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[252.057775] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[252.072261] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[252.201888] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[252.212307] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[252.347263] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.142s)
[252.359574] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[252.492820] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.142s)
[252.505350] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[252.613691] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.120s)
[252.624250] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[252.758050] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[252.770640] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[252.902694] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[252.913943] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[253.057984] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.153s)
[253.071532] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[253.202611] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[253.214986] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[253.347737] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[253.360032] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[253.491453] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[253.502216] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[253.613050] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s)
[253.626578] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[253.758851] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.142s)
[253.770616] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[253.901983] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s)
[253.917035] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[254.045787] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[254.059407] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[254.190329] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[254.205173] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[254.335012] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[254.349208] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[254.479267] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s)
[254.494184] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[254.602411] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.120s)
[254.612043] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[254.774285] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.170s)
[254.786297] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[254.918594] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[254.930323] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[255.062678] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[255.074554] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[255.207605] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[255.219483] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[255.351625] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s)
[255.362378] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[255.497515] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.143s)
[255.509825] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[255.618435] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.119s)
[255.670042] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[256.873964] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.210s)
[256.885742] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[257.008720] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[257.020418] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[257.142511] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.132s)
[257.154279] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[257.325230] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.180s)
[257.335812] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[257.468346] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[257.479994] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[257.612743] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[257.624418] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[257.746345] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[257.758219] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[257.857386] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[257.868687] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[257.991878] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[258.003345] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[258.136070] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[258.147917] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[258.279262] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[258.291622] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[258.423722] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[258.435098] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[258.557706] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[258.571953] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[258.703227] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.142s)
[258.715377] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[258.824311] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.119s)
[258.835482] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[258.968775] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[258.980892] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[259.113382] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[259.125610] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[259.257383] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[259.268695] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[259.401628] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[259.413148] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[259.546965] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[259.559097] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[259.691182] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[259.703043] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[259.812673] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s)
[259.823358] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[259.956999] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.142s)
[259.971918] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[260.101025] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.142s)
[260.114942] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[260.245885] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[260.257452] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[260.390276] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[260.405330] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[260.534913] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[260.549751] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[260.690576] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.152s)
[260.702228] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[260.823919] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.131s)
[260.837621] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[260.979508] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.153s)
[260.991496] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[261.123767] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[261.135249] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[261.268043] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[261.278919] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[261.412606] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[261.426524] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[261.568200] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.153s)
[261.582180] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[261.712882] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s)
[261.731332] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[261.846073] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.130s)
[261.899283] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[263.097450] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.205s)
[263.109318] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[263.196967] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[263.207636] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[263.297232] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[263.307693] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[263.408128] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[263.419947] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[263.530118] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.120s)
[263.541176] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[263.681053] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.147s)
[263.690890] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[263.791650] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.109s)
[263.801808] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[263.891610] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[263.903349] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[263.990887] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[264.004102] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[264.102046] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[264.112135] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[264.212661] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[264.223183] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[264.323989] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.110s)
[264.333578] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[264.424603] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[264.436083] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[264.524669] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[264.536064] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[264.635979] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[264.647463] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[264.746666] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.108s)
[264.759049] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[264.857286] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[264.868318] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[264.968215] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s)
[264.979031] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[265.079688] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.110s)
[265.090035] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[265.179962] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.098s)
[265.190999] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[265.279943] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.099s)
[265.289864] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[265.390939] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.109s)
[265.400894] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[265.501533] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.109s)
[265.515846] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[265.623792] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.121s)
[265.632877] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[265.735114] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s)
[265.746874] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[265.846408] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s)
[265.857594] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[265.956871] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s)
[265.968082] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[266.068336] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.109s)
[266.079351] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[266.179850] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.109s)
[266.190820] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[266.290757] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s)
[266.302052] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[266.390779] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.098s)
[266.402864] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[266.490520] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.099s)
[266.501082] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[266.601981] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[266.614983] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[266.712693] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.110s)
[266.726730] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[266.824517] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.109s)
[266.835755] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[266.946790] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.120s)
[266.988714] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[268.231637] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.250s)
[268.246092] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[268.331256] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[268.344926] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[268.442482] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.109s)
[268.452111] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[268.553490] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[268.563794] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[268.663696] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[268.674851] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[268.775133] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s)
[268.784301] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[268.887072] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.109s)
[268.899067] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[268.986779] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[268.997396] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[269.098247] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.109s)
[269.109980] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[269.208722] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[269.219550] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[269.319204] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[269.331994] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[269.430393] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s)
[269.440740] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[269.530891] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[269.542813] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[269.641840] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.109s)
[269.655180] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[269.742578] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.097s)
[269.754216] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[269.853332] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[269.864686] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[269.963752] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[269.975963] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[270.074895] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s)
[270.085138] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[270.186094] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s)
[270.197507] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[270.286674] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.098s)
[270.298435] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[270.386537] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.099s)
[270.397235] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[270.497561] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s)
[270.508490] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[270.619208] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.120s)
[270.631457] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[270.741247] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.121s)
[270.754488] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[270.852572] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s)
[270.863446] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[270.964022] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s)
[270.974637] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[271.074921] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.109s)
[271.086758] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[271.186097] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.110s)
[271.196043] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[271.297193] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.109s)
[271.308190] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[271.419498] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.120s)
[271.428679] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[271.530205] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[271.539961] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[271.642217] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s)
[271.651906] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[271.753337] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[271.764655] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[271.863990] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.110s)
[271.877566] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[271.974961] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.109s)
[271.989042] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[272.086341] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s)
[272.119160] Subtest flip-change-tiling: SUCCESS (21.668s)
[273.323571] [063/133] (748s left) gem_eio (in-flight-internal-immediate)
[273.566269] Starting subtest: in-flight-internal-immediate
[275.418940] Subtest in-flight-internal-immediate: SUCCESS (1.854s)
[275.570052] [064/133] (745s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[275.662393] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[275.664788] Starting dynamic subtest: pipe-A-eDP-1
[275.759061] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[275.768631] Starting dynamic subtest: pipe-B-eDP-1
[276.899175] Dynamic subtest pipe-B-eDP-1: SKIP (1.137s)
[276.903811] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.242s)
[278.092565] [065/133] (743s left) kms_plane (pixel-format-4-tiled-modifier)
[278.192166] Starting subtest: pixel-format-4-tiled-modifier
[278.219075] Starting dynamic subtest: pipe-A-plane-0
[278.907697] Dynamic subtest pipe-A-plane-0: SUCCESS (0.689s)
[278.917687] Starting dynamic subtest: pipe-A-plane-3
[279.329476] Dynamic subtest pipe-A-plane-3: SUCCESS (0.420s)
[279.338367] Starting dynamic subtest: pipe-A-plane-5
[279.341784] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[280.471489] Starting dynamic subtest: pipe-B-plane-0
[281.164616] Dynamic subtest pipe-B-plane-0: SUCCESS (0.700s)
[281.174406] Starting dynamic subtest: pipe-B-plane-3
[281.575995] Dynamic subtest pipe-B-plane-3: SUCCESS (0.410s)
[281.585185] Starting dynamic subtest: pipe-B-plane-5
[281.589055] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[281.885548] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.693s)
[282.743300] [066/133] (738s left) syncobj_wait (invalid-reset-zero-handles)
[282.796154] Starting subtest: invalid-reset-zero-handles
[282.798396] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[282.912198] [067/133] (738s left) kms_pm_backlight (bad-brightness)
[283.005077] Starting subtest: bad-brightness
[283.054234] Starting dynamic subtest: eDP-1
[283.373870] Dynamic subtest eDP-1: SUCCESS (0.319s)
[283.376349] Subtest bad-brightness: SUCCESS (0.370s)
[284.195542] [068/133] (737s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[284.457066] Starting subtest: cursor-rapid-movement-256x85
[284.507646] Subtest cursor-rapid-movement-256x85: SKIP (0.046s)
[284.699645] [069/133] (736s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[284.793712] Starting subtest: fbcpsr-1p-rte
[291.810646] Subtest fbcpsr-1p-rte: SUCCESS (7.020s)
[292.001291] [070/133] (729s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[292.092998] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[298.943225] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.853s)
[299.067822] [071/133] (722s left) perf (invalid-create-userspace-config)
[299.199318] Starting subtest: invalid-create-userspace-config
[299.201471] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[299.244246] [072/133] (722s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[300.784719] Starting subtest: modeset-non-lpsp-stress-no-wait
[300.833741] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.051s)
[301.488277] [073/133] (720s left) kms_plane (planar-pixel-format-settings)
[301.592044] Starting subtest: planar-pixel-format-settings
[301.661247] Subtest planar-pixel-format-settings: SUCCESS (0.070s)
[301.779099] [074/133] (720s left) kms_color (ctm-negative)
[301.870396] Starting subtest: ctm-negative
[301.872316] Starting dynamic subtest: pipe-A-eDP-1
[302.597240] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.726s)
[302.606813] Starting dynamic subtest: pipe-B-eDP-1
[304.042808] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.445s)
[304.051850] Starting dynamic subtest: pipe-C-eDP-1
[305.384624] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.342s)
[305.393994] Starting dynamic subtest: pipe-D-eDP-1
[306.714077] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.329s)
[306.716263] Subtest ctm-negative: SUCCESS (4.845s)
[307.529338] [075/133] (714s left) gem_busy (extended)
[307.708825] Starting subtest: extended
[307.711390] Starting dynamic subtest: rcs0
[307.797693] Dynamic subtest rcs0: SUCCESS (0.089s)
[307.809977] Starting dynamic subtest: bcs0
[307.840504] Dynamic subtest bcs0: SUCCESS (0.041s)
[307.853108] Starting dynamic subtest: vcs0
[309.319479] Dynamic subtest vcs0: SUCCESS (1.473s)
[309.331838] Starting dynamic subtest: vcs1
[311.302248] Dynamic subtest vcs1: SUCCESS (1.980s)
[311.314253] Starting dynamic subtest: vecs0
[313.287647] Dynamic subtest vecs0: SUCCESS (1.982s)
[313.299698] Starting dynamic subtest: ccs0
[313.334877] Dynamic subtest ccs0: SUCCESS (0.046s)
[313.337372] Subtest extended: SUCCESS (5.627s)
[313.560585] [076/133] (708s left) gem_exec_schedule (fifo)
[313.636352] Starting subtest: fifo
[313.638359] Starting dynamic subtest: rcs0
[313.807053] Dynamic subtest rcs0: SUCCESS (0.178s)
[313.835729] Starting dynamic subtest: vcs0
[313.923909] Dynamic subtest vcs0: SUCCESS (0.118s)
[313.938217] Starting dynamic subtest: vcs1
[314.028400] Dynamic subtest vcs1: SUCCESS (0.104s)
[314.039902] Starting dynamic subtest: vecs0
[314.137381] Dynamic subtest vecs0: SUCCESS (0.107s)
[314.149662] Starting dynamic subtest: ccs0
[314.268576] Dynamic subtest ccs0: SUCCESS (0.129s)
[314.271279] Subtest fifo: SUCCESS (0.642s)
[315.442143] [077/133] (706s left) perf (create-destroy-userspace-config)
[315.541036] Starting subtest: create-destroy-userspace-config
[315.566076] Subtest create-destroy-userspace-config: SUCCESS (0.024s)
[315.615214] [078/133] (706s left) kms_fb_coherency (memset-crc)
[315.703218] Starting subtest: memset-crc
[315.705111] Starting dynamic subtest: mmap-offset-wc
[316.101772] Dynamic subtest mmap-offset-wc: SUCCESS (0.398s)
[316.390697] Starting dynamic subtest: mmap-offset-uc
[322.578720] Dynamic subtest mmap-offset-uc: SUCCESS (6.197s)
[322.870076] Subtest memset-crc: SUCCESS (7.166s)
[323.707170] [079/133] (698s left) gem_exec_reloc (basic-write-read-active)
[323.778093] Subtest basic-write-read-active: SKIP (0.000s)
[323.833914] [080/133] (698s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[323.930396] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[330.803499] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.876s)
[330.929338] [081/133] (691s left) i915_getparams_basic (basic-subslice-total)
[330.987289] Starting subtest: basic-subslice-total
[330.991240] Subtest basic-subslice-total: SUCCESS (0.000s)
[331.070435] [082/133] (691s left) gem_sync (basic-store-each)
[331.146642] Starting subtest: basic-store-each
[333.604686] Subtest basic-store-each: SUCCESS (2.468s)
[333.805579] [083/133] (688s left) gem_exec_whisper (basic-fds-forked)
[333.877462] Starting subtest: basic-fds-forked
[357.894040] Subtest basic-fds-forked: SUCCESS (24.013s)
[358.081406] [084/133] (664s left) sysfs_heartbeat_interval (invalid)
[358.141267] Starting subtest: invalid
[358.143525] Starting dynamic subtest: vecs0
[358.145801] Dynamic subtest vecs0: SUCCESS (0.000s)
[358.156080] Starting dynamic subtest: ccs0
[358.157987] Dynamic subtest ccs0: SUCCESS (0.000s)
[358.167584] Starting dynamic subtest: vcs0
[358.169740] Dynamic subtest vcs0: SUCCESS (0.000s)
[358.179297] Starting dynamic subtest: bcs0
[358.181157] Dynamic subtest bcs0: SUCCESS (0.000s)
[358.190150] Starting dynamic subtest: rcs0
[358.192033] Dynamic subtest rcs0: SUCCESS (0.000s)
[358.200968] Starting dynamic subtest: vcs1
[358.202903] Dynamic subtest vcs1: SUCCESS (0.000s)
[358.204834] Subtest invalid: SUCCESS (0.005s)
[358.245033] [085/133] (664s left) kms_chamelium_frames (hdmi-crc-single)
[358.625218] Subtest hdmi-crc-single: SKIP (0.000s)
[359.441849] [086/133] (662s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[359.537627] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[359.542086] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[359.633777] [087/133] (662s left) i915_pm_rpm (debugfs-forcewake-user)
[361.458585] Starting subtest: debugfs-forcewake-user
[372.850984] Subtest debugfs-forcewake-user: SUCCESS (11.392s)
[373.241848] [088/133] (649s left) kms_content_protection (atomic-dpms)
[373.398725] Starting subtest: atomic-dpms
[373.403366] Subtest atomic-dpms: SKIP (0.000s)
[373.529785] [089/133] (648s left) syncobj_timeline (multi-wait-available-signaled)
[373.587761] Starting subtest: multi-wait-available-signaled
[373.590093] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[373.696350] [090/133] (648s left) gem_exec_schedule (pi-userfault)
[373.870228] Starting subtest: pi-userfault
[373.872634] Starting dynamic subtest: rcs0
[373.874914] Dynamic subtest rcs0: SUCCESS (0.009s)
[373.884993] Starting dynamic subtest: bcs0
[373.887254] Dynamic subtest bcs0: SUCCESS (0.008s)
[373.897887] Starting dynamic subtest: vcs0
[373.900452] Dynamic subtest vcs0: SUCCESS (0.008s)
[373.910425] Starting dynamic subtest: vcs1
[373.912548] Dynamic subtest vcs1: SUCCESS (0.011s)
[373.922579] Starting dynamic subtest: vecs0
[373.924819] Dynamic subtest vecs0: SUCCESS (0.010s)
[373.934723] Starting dynamic subtest: ccs0
[373.936741] Dynamic subtest ccs0: SUCCESS (0.009s)
[373.938730] Subtest pi-userfault: SUCCESS (0.059s)
[374.121577] [091/133] (648s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[374.216056] Starting subtest: fbc-psr-sprite-mmap-gtt
[374.218447] Starting dynamic subtest: eDP-1
[374.223028] Dynamic subtest eDP-1: SKIP (0.000s)
[374.227604] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[374.290314] [092/133] (648s left) kms_lease (lease-unleased-crtc)
[374.389220] Starting subtest: lease-unleased-crtc
[374.391491] Starting dynamic subtest: pipe-A-eDP-1
[374.686343] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.296s)
[374.697464] Starting dynamic subtest: pipe-B-eDP-1
[375.484793] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.796s)
[375.497176] Starting dynamic subtest: pipe-C-eDP-1
[375.499500] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.005s)
[375.508944] Starting dynamic subtest: pipe-D-eDP-1
[375.510817] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.005s)
[375.512631] Subtest lease-unleased-crtc: SUCCESS (1.112s)
[375.872174] [093/133] (646s left) gem_mmap_wc (fault-concurrent)
[375.928449] Subtest fault-concurrent: SKIP (0.000s)
[375.989702] [094/133] (646s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[376.092397] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[376.096802] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[376.207081] [095/133] (646s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[376.264777] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[376.266999] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[376.362845] [096/133] (646s left) gen9_exec_parse (cmd-crossing-page)
[376.422391] Subtest cmd-crossing-page: SKIP (0.000s)
[376.506635] [097/133] (646s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[376.600676] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[376.604701] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[376.699488] [098/133] (646s left) kms_chamelium_hpd (common-hpd-after-suspend)
[377.082213] Subtest common-hpd-after-suspend: SKIP (0.000s)
[377.890385] [099/133] (645s left) kms_addfb_basic (addfb25-4-tiled)
[377.985267] Starting subtest: addfb25-4-tiled
[377.987376] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[378.078870] [100/133] (644s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[378.198422] Starting subtest: basic-flip-after-cursor-legacy
[379.125119] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.927s)
[379.943369] [101/133] (643s left) gem_exec_reloc (basic-cpu-wc-active)
[380.005415] Subtest basic-cpu-wc-active: SKIP (0.000s)
[380.072235] [102/133] (642s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[380.170082] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[380.174263] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[380.271788] [103/133] (642s left) kms_psr (fbc-pr-cursor-plane-move)
[380.365384] Starting subtest: fbc-pr-cursor-plane-move
[380.369745] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[380.437346] [104/133] (642s left) syncobj_wait (wait-delayed-signal)
[380.494079] Starting subtest: wait-delayed-signal
[380.595732] Subtest wait-delayed-signal: SUCCESS (0.102s)
[380.678256] [105/133] (642s left) perf (non-zero-reason)
[380.758770] Starting subtest: non-zero-reason
[380.761185] Starting dynamic subtest: 0-rcs0
[386.261654] Dynamic subtest 0-rcs0: SUCCESS (5.500s)
[386.275321] Starting dynamic subtest: 1-vecs0
[390.198588] Dynamic subtest 1-vecs0: SUCCESS (3.936s)
[390.201300] Subtest non-zero-reason: SUCCESS (9.438s)
[390.247996] [106/133] (632s left) gem_lmem_swapping (random-engines)
[390.286342] Subtest random-engines: SKIP (0.000s)
[390.324578] [107/133] (632s left) gem_exec_nop (basic-parallel)
[390.397800] Starting subtest: basic-parallel
[406.280770] Subtest basic-parallel: SUCCESS (15.891s)
[406.507089] [108/133] (616s left) gem_softpin (32b-excludes-last-page)
[406.559314] Starting subtest: 32b-excludes-last-page
[406.564938] Subtest 32b-excludes-last-page: SUCCESS (0.006s)
[406.678453] [109/133] (616s left) kms_vblank (ts-continuation-dpms-suspend)
[406.768910] Starting subtest: ts-continuation-dpms-suspend
[406.771230] Starting dynamic subtest: pipe-A-eDP-1
[423.999315] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.984s)
[424.015158] Starting dynamic subtest: pipe-D-eDP-1
[441.978159] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.509s)
[441.980502] Subtest ts-continuation-dpms-suspend: SUCCESS (4.496s)
[442.795956] [110/133] (580s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[442.888009] Starting subtest: sprite-rotation-90-pos-100-0
[442.892471] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[442.962276] [111/133] (580s left) kms_plane_multiple (2x-tiling-y)
[443.053911] Starting subtest: 2x-tiling-y
[443.058376] Subtest 2x-tiling-y: SKIP (0.000s)
[443.140233] [112/133] (580s left) gem_ctx_shared (detached-shared-gtt)
[443.202260] Starting subtest: detached-shared-gtt
[445.357937] Subtest detached-shared-gtt: SUCCESS (2.154s)
[445.709752] [113/133] (577s left) i915_drm_fdinfo (idle)
[445.747602] Starting subtest: idle
[445.749700] Starting dynamic subtest: rcs0
[446.310611] Dynamic subtest rcs0: SUCCESS (0.563s)
[446.322866] Starting dynamic subtest: bcs0
[446.818649] Dynamic subtest bcs0: SUCCESS (0.503s)
[446.832026] Starting dynamic subtest: vcs0
[447.324627] Dynamic subtest vcs0: SUCCESS (0.503s)
[447.337010] Starting dynamic subtest: vcs1
[447.831081] Dynamic subtest vcs1: SUCCESS (0.503s)
[447.846891] Starting dynamic subtest: vecs0
[448.336824] Dynamic subtest vecs0: SUCCESS (0.503s)
[448.349393] Starting dynamic subtest: ccs0
[448.860665] Dynamic subtest ccs0: SUCCESS (0.502s)
[448.864723] Subtest idle: SUCCESS (3.090s)
[448.916230] [114/133] (574s left) kms_invalid_mode (bad-hsync-start)
[449.021264] Starting subtest: bad-hsync-start
[449.023471] Starting dynamic subtest: pipe-A-eDP-1
[449.309065] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[449.319333] Starting dynamic subtest: pipe-B-eDP-1
[449.321484] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[449.331757] Starting dynamic subtest: pipe-C-eDP-1
[449.333743] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[449.343501] Starting dynamic subtest: pipe-D-eDP-1
[449.345390] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[449.347247] Subtest bad-hsync-start: SUCCESS (0.291s)
[450.114281] [115/133] (573s left) gem_ctx_shared (q-in-order)
[450.181704] Starting subtest: Q-in-order
[450.183924] Starting dynamic subtest: rcs0
[450.307744] Dynamic subtest rcs0: SUCCESS (0.124s)
[450.318718] Starting dynamic subtest: vcs0
[450.401890] Dynamic subtest vcs0: SUCCESS (0.093s)
[450.420138] Starting dynamic subtest: vcs1
[450.490112] Dynamic subtest vcs1: SUCCESS (0.087s)
[450.512018] Starting dynamic subtest: vecs0
[450.572653] Dynamic subtest vecs0: SUCCESS (0.080s)
[450.594689] Starting dynamic subtest: ccs0
[450.657784] Dynamic subtest ccs0: SUCCESS (0.084s)
[450.660145] Subtest Q-in-order: SUCCESS (0.477s)
[452.136512] [116/133] (571s left) gem_exec_schedule (thriceslice)
[452.214038] Starting subtest: thriceslice
[452.216044] Starting dynamic subtest: rcs0
[452.260886] Dynamic subtest rcs0: SUCCESS (0.056s)
[452.274741] Starting dynamic subtest: bcs0
[452.292669] Dynamic subtest bcs0: SUCCESS (0.029s)
[452.303433] Starting dynamic subtest: vcs0
[452.322414] Dynamic subtest vcs0: SUCCESS (0.029s)
[452.333210] Starting dynamic subtest: vcs1
[452.351377] Dynamic subtest vcs1: SUCCESS (0.028s)
[452.361742] Starting dynamic subtest: vecs0
[452.402596] Dynamic subtest vecs0: SUCCESS (0.050s)
[452.415770] Starting dynamic subtest: ccs0
[452.457954] Dynamic subtest ccs0: SUCCESS (0.053s)
[452.460607] Subtest thriceslice: SUCCESS (0.254s)
[452.768443] [117/133] (570s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[452.868208] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[456.446103] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.578s)
[457.638979] [118/133] (566s left) kms_flip (2x-flip-vs-dpms-on-nop)
[457.735244] Starting subtest: 2x-flip-vs-dpms-on-nop
[457.744341] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[457.834256] [119/133] (565s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[457.921552] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[457.923837] Starting dynamic subtest: A-eDP1
[461.797093] Dynamic subtest A-eDP1: SUCCESS (3.871s)
[461.808279] Starting dynamic subtest: B-eDP1
[464.994851] Dynamic subtest B-eDP1: SUCCESS (3.193s)
[465.006176] Starting dynamic subtest: C-eDP1
[468.115430] Dynamic subtest C-eDP1: SUCCESS (3.119s)
[468.128692] Starting dynamic subtest: D-eDP1
[471.335908] Dynamic subtest D-eDP1: SUCCESS (3.219s)
[471.338206] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.412s)
[472.141597] [120/133] (551s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[472.245504] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[472.250082] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[472.349346] [121/133] (551s left) kms_flip (2x-plain-flip-fb-recreate)
[472.439275] Starting subtest: 2x-plain-flip-fb-recreate
[472.450955] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s)
[472.531220] [122/133] (551s left) perf_pmu (rc6-suspend)
[472.573178] Starting subtest: rc6-suspend
[494.584833] Subtest rc6-suspend: SUCCESS (7.452s)
[495.609968] [123/133] (528s left) gem_exec_reloc (basic-write-wc-active)
[495.681046] Subtest basic-write-wc-active: SKIP (0.000s)
[495.762956] [124/133] (528s left) kms_scaling_modes (scaling-mode-none)
[495.851718] Starting subtest: scaling-mode-none
[495.854027] Starting dynamic subtest: pipe-A-eDP-1
[495.952566] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[495.964365] Starting dynamic subtest: pipe-B-eDP-1
[495.988435] Dynamic subtest pipe-B-eDP-1: SKIP (0.033s)
[496.000547] Starting dynamic subtest: pipe-C-eDP-1
[496.023473] Dynamic subtest pipe-C-eDP-1: SKIP (0.033s)
[496.035174] Starting dynamic subtest: pipe-D-eDP-1
[496.056566] Dynamic subtest pipe-D-eDP-1: SKIP (0.032s)
[496.060671] Subtest scaling-mode-none: SKIP (0.204s)
[496.167748] [125/133] (527s left) gem_vm_create (execbuf)
[496.221707] Starting subtest: execbuf
[496.229523] Subtest execbuf: SUCCESS (0.008s)
[496.348357] [126/133] (527s left) kms_psr (psr-cursor-render)
[496.438917] Starting subtest: psr-cursor-render
[496.441397] Starting dynamic subtest: eDP-1
[498.201440] Dynamic subtest eDP-1: SUCCESS (1.761s)
[498.204206] Subtest psr-cursor-render: SUCCESS (1.762s)
[499.070364] [127/133] (525s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[499.152657] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[499.155330] Starting dynamic subtest: pipe-A-eDP-1
[499.181930] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[499.193580] Starting dynamic subtest: pipe-B-eDP-1
[499.218536] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[499.229146] Starting dynamic subtest: pipe-C-eDP-1
[499.255005] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[499.265794] Starting dynamic subtest: pipe-D-eDP-1
[499.291557] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[499.296711] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[501.360447] [128/133] (522s left) kms_plane_alpha_blend (alpha-opaque-fb)
[501.460655] Starting subtest: alpha-opaque-fb
[501.756887] Starting dynamic subtest: pipe-A-eDP-1
[502.470238] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[502.482270] Starting dynamic subtest: pipe-D-eDP-1
[503.825399] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.352s)
[503.827703] Subtest alpha-opaque-fb: SUCCESS (2.362s)
[504.630362] [129/133] (519s left) gem_lmem_swapping (parallel-random-verify)
[504.674801] Subtest parallel-random-verify: SKIP (0.000s)
[504.715553] [130/133] (519s left) gem_exec_balancer (persistence)
[504.974515] Starting subtest: persistence
[505.900306] Subtest persistence: SUCCESS (0.924s)
[506.015797] [131/133] (518s left) api_intel_bb (delta-check)
[506.069917] Starting subtest: delta-check
[506.075383] Subtest delta-check: SUCCESS (0.006s)
[506.198749] [132/133] (518s left) kms_big_fb (linear-8bpp-rotate-270)
[506.287233] Starting subtest: linear-8bpp-rotate-270
[506.309659] Subtest linear-8bpp-rotate-270: SKIP (0.021s)
[506.413260] [133/133] (517s left) i915_query (query-topology-garbage-items)
[506.478933] Starting subtest: query-topology-garbage-items
[506.481221] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[506.577553] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_balancer
results: parsing output: 1/ for test: kms_atomic_transition
results: parsing output: 2/ for test: kms_panel_fitting
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: syncobj_wait
results: parsing output: 6/ for test: kms_cursor_crc
results: parsing output: 7/ for test: kms_properties
results: parsing output: 8/ for test: kms_atomic_interruptible
results: parsing output: 9/ for test: api_intel_bb
results: parsing output: 10/ for test: gem_pxp
results: parsing output: 11/ for test: kms_pm_rpm
results: parsing output: 12/ for test: gem_spin_batch
results: parsing output: 13/ for test: gem_userptr_blits
results: parsing output: 14/ for test: gem_mmap_offset
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: kms_properties
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: prime_busy
results: parsing output: 19/ for test: kms_psr2_sf
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_exec_reloc
results: parsing output: 22/ for test: kms_vblank
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: kms_flip_scaled_crc
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: gem_reg_read
results: parsing output: 28/ for test: gem_ctx_param
results: parsing output: 29/ for test: kms_chamelium_audio
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: prime_mmap
results: parsing output: 32/ for test: gem_exec_fence
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_cursor_edge_walk
results: parsing output: 36/ for test: kms_ccs
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_mmap_wc
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_basic
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: prime_self_import
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: kms_getfb
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_create
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_cursor_legacy
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: core_getversion
results: parsing output: 59/ for test: kms_async_flips
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_flip_tiling
results: parsing output: 62/ for test: gem_eio
results: parsing output: 63/ for test: kms_psr2_sf
results: parsing output: 64/ for test: kms_plane
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: kms_pm_backlight
results: parsing output: 67/ for test: kms_cursor_crc
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: perf
results: parsing output: 71/ for test: kms_pm_rpm
results: parsing output: 72/ for test: kms_plane
results: parsing output: 73/ for test: kms_color
results: parsing output: 74/ for test: gem_busy
results: parsing output: 75/ for test: gem_exec_schedule
results: parsing output: 76/ for test: perf
results: parsing output: 77/ for test: kms_fb_coherency
results: parsing output: 78/ for test: gem_exec_reloc
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: i915_getparams_basic
results: parsing output: 81/ for test: gem_sync
results: parsing output: 82/ for test: gem_exec_whisper
results: parsing output: 83/ for test: sysfs_heartbeat_interval
results: parsing output: 84/ for test: kms_chamelium_frames
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: i915_pm_rpm
results: parsing output: 87/ for test: kms_content_protection
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: gem_exec_schedule
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: kms_lease
results: parsing output: 92/ for test: gem_mmap_wc
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: gen9_exec_parse
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_chamelium_hpd
results: parsing output: 98/ for test: kms_addfb_basic
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: gem_exec_reloc
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: perf
results: parsing output: 105/ for test: gem_lmem_swapping
results: parsing output: 106/ for test: gem_exec_nop
results: parsing output: 107/ for test: gem_softpin
results: parsing output: 108/ for test: kms_vblank
results: parsing output: 109/ for test: kms_rotation_crc
results: parsing output: 110/ for test: kms_plane_multiple
results: parsing output: 111/ for test: gem_ctx_shared
results: parsing output: 112/ for test: i915_drm_fdinfo
results: parsing output: 113/ for test: kms_invalid_mode
results: parsing output: 114/ for test: gem_ctx_shared
results: parsing output: 115/ for test: gem_exec_schedule
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: perf_pmu
results: parsing output: 122/ for test: gem_exec_reloc
results: parsing output: 123/ for test: kms_scaling_modes
results: parsing output: 124/ for test: gem_vm_create
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: kms_plane_alpha_blend
results: parsing output: 128/ for test: gem_lmem_swapping
results: parsing output: 129/ for test: gem_exec_balancer
results: parsing output: 130/ for test: api_intel_bb
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: i915_query
Done.