[51.596256] Initializing watchdogs
[51.596318]   /dev/watchdog0
[51.611706] [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]
[51.616289] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[51.618533] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[51.621856] [001/156] (960s left) gem_lmem_swapping (parallel-random-verify)
[51.691516] Subtest parallel-random-verify: SKIP (0.000s)
[51.734175] [002/156] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[51.851197] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[51.855175] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[51.965907] [003/156] (960s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-indfb-pgflip-blt)
[52.075801] Starting subtest: psrhdr-2p-primscrn-indfb-pgflip-blt
[52.080866] Subtest psrhdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[52.172768] [004/156] (960s left) gem_softpin (noreloc-interruptible)
[52.250635] Starting subtest: noreloc-interruptible
[57.645620] Subtest noreloc-interruptible: SUCCESS (5.390s)
[57.780485] [005/156] (954s left) gen9_exec_parse (batch-zero-length)
[57.835972] Subtest batch-zero-length: SKIP (0.000s)
[57.899549] [006/156] (954s left) gem_userptr_blits (access-control)
[57.973611] Starting subtest: access-control
[57.978163] Subtest access-control: SKIP (0.000s)
[58.089505] [007/156] (954s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[58.191710] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[58.193971] Starting dynamic subtest: pipe-A-default-mode
[60.969876] Dynamic subtest pipe-A-default-mode: SUCCESS (2.776s)
[60.972651] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.778s)
[61.810788] [008/156] (950s left) gem_spin_batch (spin-all)
[61.885614] Starting subtest: spin-all
[61.898660] Subtest spin-all: SUCCESS (0.012s)
[63.368890] [009/156] (949s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[63.752704] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[64.539271] [010/156] (947s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[64.650167] Starting subtest: x-tiled-16bpp-rotate-270
[64.668539] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[64.783181] [011/156] (947s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[64.884066] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[64.888039] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[64.968105] [012/156] (947s left) gem_mmap_gtt (cpuset-basic-small-copy)
[65.020872] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[65.081166] [013/156] (947s left) kms_cursor_crc (cursor-offscreen-64x64)
[65.256864] Starting subtest: cursor-offscreen-64x64
[65.259252] Starting dynamic subtest: pipe-A-eDP-1
[67.211562] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.952s)
[67.244429] Starting dynamic subtest: pipe-D-eDP-1
[69.861956] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.622s)
[69.864426] Subtest cursor-offscreen-64x64: SUCCESS (4.605s)
[70.733024] [014/156] (941s left) kms_flip (bo-too-big)
[70.820421] Starting subtest: bo-too-big
[70.822299] Starting dynamic subtest: A-eDP1
[72.162513] Dynamic subtest A-eDP1: SUCCESS (1.343s)
[72.172066] Starting dynamic subtest: B-eDP1
[73.512589] Dynamic subtest B-eDP1: SUCCESS (1.349s)
[73.523720] Starting dynamic subtest: C-eDP1
[74.836768] Dynamic subtest C-eDP1: SUCCESS (1.323s)
[74.849601] Starting dynamic subtest: D-eDP1
[76.169657] Dynamic subtest D-eDP1: SUCCESS (1.331s)
[76.175837] Subtest bo-too-big: SUCCESS (5.356s)
[77.365791] [015/156] (935s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[77.460657] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[77.464835] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[77.557441] [016/156] (935s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[77.648575] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[77.650686] Starting dynamic subtest: pipe-A-eDP-1
[79.933090] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.286s)
[79.941066] Starting dynamic subtest: pipe-B-eDP-1
[82.502352] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.568s)
[82.510980] Starting dynamic subtest: pipe-C-eDP-1
[84.757536] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.254s)
[84.766581] Starting dynamic subtest: pipe-D-eDP-1
[87.037324] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.278s)
[87.039362] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (9.390s)
[88.277133] [017/156] (924s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[88.392633] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[89.526262] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.135s)
[89.633941] [018/156] (923s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[89.742794] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[89.747065] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[89.821322] [019/156] (922s left) gem_exec_balancer (invalid-balancer)
[89.880625] Starting subtest: invalid-balancer
[90.823539] Subtest invalid-balancer: SUCCESS (0.942s)
[91.123566] [020/156] (921s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[91.246841] Starting subtest: cursorA-vs-flipA-varying-size
[102.384650] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.136s)
[103.213754] [021/156] (909s left) core_sysfs (read-all-entries)
[103.280431] Starting subtest: read-all-entries
[103.286216] Subtest read-all-entries: SUCCESS (0.004s)
[103.362209] [022/156] (909s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[103.455302] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[103.457608] Starting dynamic subtest: pipe-A-eDP-1
[103.480745] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[103.491067] Starting dynamic subtest: pipe-B-eDP-1
[103.512334] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[103.520134] Starting dynamic subtest: pipe-C-eDP-1
[103.541821] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[103.549667] Starting dynamic subtest: pipe-D-eDP-1
[103.571647] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[103.575780] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[105.759283] [023/156] (907s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-blt)
[105.864202] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-blt
[105.868155] Subtest hdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[105.966225] [024/156] (907s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[106.062677] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[113.154274] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.097s)
[113.265935] [025/156] (899s left) kms_flip (basic-flip-vs-wf_vblank)
[113.364080] Starting subtest: basic-flip-vs-wf_vblank
[113.366282] Starting dynamic subtest: A-eDP1
[115.345614] Dynamic subtest A-eDP1: SUCCESS (1.982s)
[115.356422] Starting dynamic subtest: B-eDP1
[117.287078] Dynamic subtest B-eDP1: SUCCESS (1.940s)
[117.297241] Starting dynamic subtest: C-eDP1
[119.213851] Dynamic subtest C-eDP1: SUCCESS (1.924s)
[119.225465] Starting dynamic subtest: D-eDP1
[121.139741] Dynamic subtest D-eDP1: SUCCESS (1.924s)
[121.142046] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.780s)
[122.363945] [026/156] (890s left) kms_chamelium_edid (dp-edid-read)
[122.757942] Subtest dp-edid-read: SKIP (0.000s)
[123.579495] [027/156] (889s left) i915_pciid
[123.716779] [028/156] (889s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[123.815954] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[123.828080] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[123.901642] [029/156] (889s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[123.997749] Starting subtest: primary-4-tiled-reflect-x-0
[130.933880] Subtest primary-4-tiled-reflect-x-0: SUCCESS (6.938s)
[132.148336] [030/156] (881s left) perf (stress-open-close)
[132.284592] Starting subtest: stress-open-close
[132.286541] Starting dynamic subtest: 0-rcs0
[134.448871] Dynamic subtest 0-rcs0: SUCCESS (2.166s)
[134.458516] Starting dynamic subtest: 1-vcs1
[136.614135] Dynamic subtest 1-vcs1: SUCCESS (2.164s)
[136.616150] Subtest stress-open-close: SUCCESS (4.333s)
[136.661626] [031/156] (876s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-msflip-blt)
[136.763732] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-msflip-blt
[136.767231] Subtest fbcpsrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[136.857428] [032/156] (876s left) kms_sequence (queue-idle)
[136.954785] Starting subtest: queue-idle
[136.957064] Starting dynamic subtest: pipe-A-eDP-1
[138.755920] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.802s)
[138.766731] Starting dynamic subtest: pipe-B-eDP-1
[141.222584] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.466s)
[141.231980] Starting dynamic subtest: pipe-C-eDP-1
[143.746583] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.522s)
[143.755463] Starting dynamic subtest: pipe-D-eDP-1
[146.176447] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.427s)
[146.178841] Subtest queue-idle: SUCCESS (9.222s)
[146.987615] [033/156] (866s left) kms_chamelium_audio (hdmi-audio)
[147.368551] Subtest hdmi-audio: SKIP (0.000s)
[148.208236] [034/156] (865s left) gem_exec_reloc (basic-wc-active)
[148.274230] Subtest basic-wc-active: SKIP (0.000s)
[148.343272] [035/156] (865s left) kms_color (deep-color)
[148.435052] Starting subtest: deep-color
[149.498455] Starting dynamic subtest: pipe-A-eDP-1-gamma
[150.212111] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.716s)
[150.221443] Starting dynamic subtest: pipe-A-eDP-1-degamma
[151.710769] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.496s)
[151.721033] Starting dynamic subtest: pipe-A-eDP-1-ctm
[153.145872] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.436s)
[153.912105] Starting dynamic subtest: pipe-B-eDP-1-gamma
[154.619326] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.714s)
[154.628807] Starting dynamic subtest: pipe-B-eDP-1-degamma
[156.104087] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.485s)
[156.112495] Starting dynamic subtest: pipe-B-eDP-1-ctm
[157.542906] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.437s)
[158.313934] Starting dynamic subtest: pipe-C-eDP-1-gamma
[159.000707] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.697s)
[159.010420] Starting dynamic subtest: pipe-C-eDP-1-degamma
[160.395327] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.391s)
[160.404100] Starting dynamic subtest: pipe-C-eDP-1-ctm
[161.843793] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.449s)
[162.636421] Starting dynamic subtest: pipe-D-eDP-1-gamma
[163.333198] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.702s)
[163.341680] Starting dynamic subtest: pipe-D-eDP-1-degamma
[164.802057] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.470s)
[164.810573] Starting dynamic subtest: pipe-D-eDP-1-ctm
[166.231945] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.427s)
[166.234303] Subtest deep-color: SUCCESS (17.796s)
[167.089980] [036/156] (846s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-blt)
[167.193898] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-blt
[167.198306] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[167.294708] [037/156] (846s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[167.406832] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[167.410828] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[167.510491] [038/156] (846s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[167.566416] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[167.570976] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[167.751151] [039/156] (845s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[167.852393] Starting subtest: disable-crc-after-crtc
[167.854798] Starting dynamic subtest: pipe-A-eDP-1
[169.541565] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.691s)
[169.551837] Starting dynamic subtest: pipe-B-eDP-1
[171.905974] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.362s)
[171.914989] Starting dynamic subtest: pipe-C-eDP-1
[174.170774] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.263s)
[174.180023] Starting dynamic subtest: pipe-D-eDP-1
[176.429847] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.259s)
[176.432229] Subtest disable-crc-after-crtc: SUCCESS (8.581s)
[177.256757] [040/156] (836s left) gem_wait (write-wait)
[177.327437] Starting subtest: write-wait
[177.329342] Starting dynamic subtest: all-engines
[178.458604] Dynamic subtest all-engines: SUCCESS (1.134s)
[178.475080] Starting dynamic subtest: rcs0
[179.513853] Dynamic subtest rcs0: SUCCESS (1.053s)
[179.531334] Starting dynamic subtest: bcs0
[180.571333] Dynamic subtest bcs0: SUCCESS (1.055s)
[180.588669] Starting dynamic subtest: vcs0
[181.626339] Dynamic subtest vcs0: SUCCESS (1.052s)
[181.644797] Starting dynamic subtest: vcs1
[182.680729] Dynamic subtest vcs1: SUCCESS (1.051s)
[182.696752] Starting dynamic subtest: vecs0
[183.734371] Dynamic subtest vecs0: SUCCESS (1.051s)
[183.750877] Starting dynamic subtest: ccs0
[184.791966] Dynamic subtest ccs0: SUCCESS (1.055s)
[184.795047] Subtest write-wait: SUCCESS (7.468s)
[184.997378] [FACT gem_wait (write-wait)] new: kernel.kmod_is_loaded.vgem: true
[185.000675] [041/156] (828s left) i915_pm_rps (thresholds-idle-park)
[185.057787] Starting subtest: thresholds-idle-park
[185.062595] Subtest thresholds-idle-park: SKIP (0.001s)
[185.174681] [042/156] (828s left) kms_frontbuffer_tracking (hdr-shrfb-scaledprimary)
[185.275670] Starting subtest: hdr-shrfb-scaledprimary
[185.279729] Subtest hdr-shrfb-scaledprimary: SKIP (0.000s)
[185.357261] [043/156] (828s left) syncobj_timeline (wait-all-for-submit-snapshot)
[185.420552] Starting subtest: wait-all-for-submit-snapshot
[185.503442] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s)
[185.581345] [044/156] (828s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-render)
[185.679150] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-render
[185.683083] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[185.779510] [045/156] (828s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[185.887668] Starting subtest: yf-tiled-addfb-size-offset-overflow
[185.892269] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[185.977251] [046/156] (827s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-render)
[186.075727] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-render
[186.079054] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[186.180597] [047/156] (827s left) kms_psr (psr-dpms)
[186.264513] Starting subtest: psr-dpms
[186.266415] Starting dynamic subtest: eDP-1
[189.300160] Dynamic subtest eDP-1: SUCCESS (3.034s)
[189.302433] Subtest psr-dpms: SUCCESS (3.035s)
[190.154726] [048/156] (823s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[190.255284] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[190.259522] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[190.355378] [049/156] (823s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-msflip-blt)
[190.456201] Starting subtest: psrhdr-2p-scndscrn-shrfb-msflip-blt
[190.460266] Subtest psrhdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[190.551453] [050/156] (823s left) prime_vgem (basic-fence-mmap)
[190.612870] Starting subtest: basic-fence-mmap
[190.617477] Subtest basic-fence-mmap: SKIP (0.000s)
[190.704840] [051/156] (823s left) kms_flip (flip-vs-expired-vblank-interruptible)
[190.800497] Starting subtest: flip-vs-expired-vblank-interruptible
[190.802835] Starting dynamic subtest: A-eDP1
[199.453424] Dynamic subtest A-eDP1: SUCCESS (8.651s)
[199.464784] Starting dynamic subtest: B-eDP1
[208.084867] Dynamic subtest B-eDP1: SUCCESS (8.630s)
[208.095589] Starting dynamic subtest: C-eDP1
[216.709899] Dynamic subtest C-eDP1: SUCCESS (8.624s)
[216.721262] Starting dynamic subtest: D-eDP1
[225.344316] Dynamic subtest D-eDP1: SUCCESS (8.632s)
[225.349137] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.549s)
[226.528315] [052/156] (787s left) perf_pmu (busy-no-semaphores)
[226.568183] Starting subtest: busy-no-semaphores
[226.570532] Starting dynamic subtest: rcs0
[227.132507] Dynamic subtest rcs0: SUCCESS (0.564s)
[227.142306] Starting dynamic subtest: bcs0
[227.681475] Dynamic subtest bcs0: SUCCESS (0.545s)
[227.696278] Starting dynamic subtest: vcs0
[228.231546] Dynamic subtest vcs0: SUCCESS (0.548s)
[228.243081] Starting dynamic subtest: vcs1
[229.863819] Dynamic subtest vcs1: SUCCESS (1.628s)
[229.874507] Starting dynamic subtest: vecs0
[231.846821] Dynamic subtest vecs0: SUCCESS (1.980s)
[231.857099] Starting dynamic subtest: ccs0
[233.832484] Dynamic subtest ccs0: SUCCESS (1.984s)
[233.835564] Subtest busy-no-semaphores: SUCCESS (7.266s)
[233.980653] [053/156] (780s left) kms_frontbuffer_tracking (fbchdr-suspend)
[234.086617] Starting subtest: fbchdr-suspend
[234.090969] Subtest fbchdr-suspend: SKIP (0.000s)
[234.188207] [054/156] (780s left) gem_ctx_sseu (invalid-sseu)
[234.251448] Subtest invalid-sseu: SKIP (0.000s)
[234.312146] [055/156] (779s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[234.397968] Starting subtest: fbc-psr2-primary-mmap-gtt
[234.400273] Starting dynamic subtest: eDP-1
[234.404595] Dynamic subtest eDP-1: SKIP (0.000s)
[234.408961] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[234.474638] [056/156] (779s left) gem_mmap_wc (copy)
[234.525323] Subtest copy: SKIP (0.000s)
[234.588530] [057/156] (779s left) kms_joiner (basic-force-ultra-joiner)
[234.693507] Starting subtest: basic-force-ultra-joiner
[234.697492] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[234.763431] [058/156] (779s left) kms_big_fb (linear-addfb)
[234.856488] Starting subtest: linear-addfb
[234.858498] Subtest linear-addfb: SUCCESS (0.000s)
[234.961953] [059/156] (779s left) sw_sync (sync_busy_fork_unixsocket)
[235.002116] Starting subtest: sync_busy_fork_unixsocket
[235.010415] Subtest sync_busy_fork_unixsocket: SUCCESS (0.010s)
[235.074346] [060/156] (779s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-shrfb-plflip-blt)
[235.170051] Starting subtest: hdr-2p-scndscrn-shrfb-plflip-blt
[235.173611] Subtest hdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[235.261673] [061/156] (779s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[235.312430] Starting subtest: etime-single-wait-available-unsubmitted
[235.421748] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.108s)
[235.511685] [062/156] (779s left) kms_plane_lowres (tiling-yf)
[235.604115] Starting subtest: tiling-yf
[235.608369] Subtest tiling-yf: SKIP (0.000s)
[235.679731] [063/156] (778s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[235.781270] Starting subtest: fbcpsr-modesetfrombusy
[242.106597] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.331s)
[242.235995] [064/156] (772s left) gem_pxp (create-regular-context-1)
[242.350396] Starting subtest: create-regular-context-1
[242.352547] Subtest create-regular-context-1: SUCCESS (0.001s)
[242.456404] [065/156] (772s left) gem_exec_schedule (preempt-user)
[242.523206] Starting subtest: preempt-user
[242.524902] Starting dynamic subtest: rcs0
[242.540801] Dynamic subtest rcs0: SUCCESS (0.022s)
[242.553447] Starting dynamic subtest: bcs0
[242.566823] Dynamic subtest bcs0: SUCCESS (0.025s)
[242.577601] Starting dynamic subtest: vcs0
[242.586909] Dynamic subtest vcs0: SUCCESS (0.020s)
[242.596329] Starting dynamic subtest: vcs1
[242.609940] Dynamic subtest vcs1: SUCCESS (0.022s)
[242.618979] Starting dynamic subtest: vecs0
[242.628153] Dynamic subtest vecs0: SUCCESS (0.017s)
[242.637564] Starting dynamic subtest: ccs0
[242.649153] Dynamic subtest ccs0: SUCCESS (0.020s)
[242.651083] Subtest preempt-user: SUCCESS (0.132s)
[244.401140] [066/156] (770s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[244.505302] Starting subtest: y-tiled-8bpp-rotate-90
[244.509765] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[244.596120] [067/156] (770s left) fbdev (eof)
[244.634921] Starting subtest: eof
[244.637603] Subtest eof: SUCCESS (0.000s)
[244.707222] [068/156] (770s left) kms_frontbuffer_tracking (fbc-1p-rte)
[244.814840] Starting subtest: fbc-1p-rte
[250.244057] Subtest fbc-1p-rte: SUCCESS (5.434s)
[251.396092] [069/156] (763s left) kms_pm_backlight (basic-brightness)
[251.500356] Starting subtest: basic-brightness
[251.548755] Starting dynamic subtest: eDP-1
[252.074316] Dynamic subtest eDP-1: SUCCESS (0.524s)
[252.076887] Subtest basic-brightness: SUCCESS (0.575s)
[252.917469] [070/156] (761s left) kms_pm_rpm (pm-tiling)
[254.444231] Starting subtest: pm-tiling
[254.449561] Subtest pm-tiling: SKIP (0.000s)
[255.162653] [071/156] (759s left) kms_vblank (ts-continuation-modeset)
[255.252085] Starting subtest: ts-continuation-modeset
[255.254188] Starting dynamic subtest: pipe-A-eDP-1
[256.732775] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.480s)
[256.746747] Starting dynamic subtest: pipe-D-eDP-1
[258.918078] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.183s)
[258.920390] Subtest ts-continuation-modeset: SUCCESS (3.666s)
[259.727901] [072/156] (755s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[259.833787] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc
[259.837823] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[259.951168] [073/156] (755s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[260.051568] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[260.055720] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[260.159239] [074/156] (754s left) syncobj_wait (wait-all-for-submit-complex)
[260.205065] Starting subtest: wait-all-for-submit-complex
[260.418401] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[260.492961] [075/156] (754s left) gem_flink_race (flink_close)
[260.529979] Starting subtest: flink_close
[265.615075] Subtest flink_close: SUCCESS (5.084s)
[265.691279] [076/156] (749s left) gem_exec_schedule (preempt-other)
[265.766385] Starting subtest: preempt-other
[265.768645] Starting dynamic subtest: rcs0
[265.901294] Dynamic subtest rcs0: SUCCESS (0.137s)
[265.915637] Starting dynamic subtest: bcs0
[266.024739] Dynamic subtest bcs0: SUCCESS (0.123s)
[266.039192] Starting dynamic subtest: vcs0
[266.148738] Dynamic subtest vcs0: SUCCESS (0.123s)
[266.159056] Starting dynamic subtest: vcs1
[266.268493] Dynamic subtest vcs1: SUCCESS (0.117s)
[266.285978] Starting dynamic subtest: vecs0
[266.389967] Dynamic subtest vecs0: SUCCESS (0.121s)
[266.404072] Starting dynamic subtest: ccs0
[266.506298] Dynamic subtest ccs0: SUCCESS (0.116s)
[266.508693] Subtest preempt-other: SUCCESS (0.745s)
[267.457237] [077/156] (747s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-move)
[267.553798] Starting subtest: psrhdr-1p-primscrn-cur-indfb-move
[267.558076] Subtest psrhdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[267.661601] [078/156] (747s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[267.765896] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[267.769958] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[267.866668] [079/156] (747s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[267.968163] Starting subtest: pr-plane-move-sf-dmg-area
[267.972258] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[268.034142] [080/156] (747s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[268.136188] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[268.140231] Subtest hdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[268.223433] [081/156] (747s left) i915_pm_rc6_residency (rc6-accuracy)
[268.279204] Starting subtest: rc6-accuracy
[268.281362] Starting dynamic subtest: gt0
[271.450020] Dynamic subtest gt0: SUCCESS (3.169s)
[271.459718] Starting dynamic subtest: gt1
[274.622074] Dynamic subtest gt1: SUCCESS (3.168s)
[274.624690] Subtest rc6-accuracy: SUCCESS (6.343s)
[274.716671] [082/156] (740s left) gem_softpin (softpin)
[274.776776] Starting subtest: softpin
[307.153557] Subtest softpin: SUCCESS (32.369s)
[307.260975] [083/156] (708s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-blt)
[307.366867] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-blt
[307.371188] Subtest hdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[307.472429] [084/156] (708s left) gem_pxp (protected-raw-src-copy-not-readible)
[307.574726] Starting subtest: protected-raw-src-copy-not-readible
[307.631290] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.059s)
[307.759691] [085/156] (707s left) template (a)
[307.822105] Starting subtest: A
[307.824323] Subtest A: SUCCESS (0.000s)
[307.933584] [086/156] (707s left) kms_psr (fbc-pr-cursor-plane-onoff)
[308.031275] Starting subtest: fbc-pr-cursor-plane-onoff
[308.035724] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[308.124424] [087/156] (707s left) api_intel_bb (crc32)
[308.187282] Starting subtest: crc32
[308.189201] Starting dynamic subtest: rcs0-smem0
[308.498194] Dynamic subtest rcs0-smem0: SUCCESS (0.310s)
[308.514026] Starting dynamic subtest: bcs0-smem0
[308.813588] Dynamic subtest bcs0-smem0: SUCCESS (0.313s)
[308.826688] Starting dynamic subtest: vcs0-smem0
[309.174853] Dynamic subtest vcs0-smem0: SUCCESS (0.358s)
[309.185906] Starting dynamic subtest: vcs1-smem0
[309.583623] Dynamic subtest vcs1-smem0: SUCCESS (0.405s)
[309.595095] Starting dynamic subtest: vecs0-smem0
[309.974165] Dynamic subtest vecs0-smem0: SUCCESS (0.388s)
[309.987940] Starting dynamic subtest: ccs0-smem0
[310.323081] Dynamic subtest ccs0-smem0: SUCCESS (0.345s)
[310.325760] Subtest crc32: SUCCESS (2.137s)
[310.463754] [088/156] (705s left) gem_exec_gttfill (all-engines)
[310.526798] Starting subtest: all-engines
[334.388682] Subtest all-engines: SUCCESS (23.862s)
[334.578694] [089/156] (681s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[334.720672] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[334.725230] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[334.821405] [090/156] (680s left) syncobj_wait (single-wait-all-for-submit-submitted)
[334.891646] Starting subtest: single-wait-all-for-submit-submitted
[334.998342] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.104s)
[335.076432] [091/156] (680s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[335.134175] Starting subtest: multi-wait-available-submitted-signaled
[335.136432] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[335.234492] [092/156] (680s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[335.318944] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[335.321217] Starting dynamic subtest: pipe-A-eDP-1
[335.345531] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[335.357559] Starting dynamic subtest: pipe-B-eDP-1
[335.381179] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[335.391181] Starting dynamic subtest: pipe-C-eDP-1
[335.415080] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[335.424698] Starting dynamic subtest: pipe-D-eDP-1
[335.448948] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[335.453641] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[337.583902] [093/156] (678s left) kms_draw_crc (draw-method-render)
[337.672027] Starting subtest: draw-method-render
[337.673930] Starting dynamic subtest: xrgb8888-untiled
[337.924823] Dynamic subtest xrgb8888-untiled: SUCCESS (0.255s)
[337.934683] Starting dynamic subtest: rgb565-untiled
[338.160600] Dynamic subtest rgb565-untiled: SUCCESS (0.233s)
[338.171310] Starting dynamic subtest: xrgb2101010-untiled
[338.391898] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.232s)
[338.402104] Starting dynamic subtest: xbgr16161616f-untiled
[338.635825] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.243s)
[338.645654] Starting dynamic subtest: xrgb8888-xtiled
[338.769382] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[338.780788] Starting dynamic subtest: rgb565-xtiled
[338.891529] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[338.904624] Starting dynamic subtest: xrgb2101010-xtiled
[339.013792] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.120s)
[339.023731] Starting dynamic subtest: xbgr16161616f-xtiled
[339.146939] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[339.157705] Starting dynamic subtest: xrgb8888-4tiled
[339.279940] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.132s)
[339.289971] Starting dynamic subtest: rgb565-4tiled
[339.403591] Dynamic subtest rgb565-4tiled: SUCCESS (0.121s)
[339.413391] Starting dynamic subtest: xrgb2101010-4tiled
[339.526121] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[339.536147] Starting dynamic subtest: xbgr16161616f-4tiled
[339.658039] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.132s)
[339.659996] Subtest draw-method-render: SUCCESS (1.989s)
[339.777499] [094/156] (676s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[339.834671] Starting subtest: invalid-multi-wait-all-unsubmitted
[339.836705] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[339.943906] [095/156] (676s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-blt)
[340.039376] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-blt
[340.042902] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[340.157090] [096/156] (675s left) gem_exec_whisper (basic-fds-all)
[340.222491] Starting subtest: basic-fds-all
[352.325302] Subtest basic-fds-all: SUCCESS (12.097s)
[352.506570] [097/156] (663s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[352.606984] Starting subtest: blocking-absolute-wf_vblank-interruptible
[352.609367] Starting dynamic subtest: A-eDP1
[361.334956] Dynamic subtest A-eDP1: SUCCESS (8.726s)
[361.346821] Starting dynamic subtest: B-eDP1
[370.067339] Dynamic subtest B-eDP1: SUCCESS (8.730s)
[370.082866] Starting dynamic subtest: C-eDP1
[378.788943] Dynamic subtest C-eDP1: SUCCESS (8.719s)
[378.802076] Starting dynamic subtest: D-eDP1
[387.521477] Dynamic subtest D-eDP1: SUCCESS (8.731s)
[387.523962] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.916s)
[388.732734] [098/156] (627s left) gem_ctx_persistence (engines-mixed-process)
[388.787807] Starting subtest: engines-mixed-process
[388.790098] Starting dynamic subtest: rcs0
[390.313041] Dynamic subtest rcs0: SUCCESS (1.525s)
[390.325474] Starting dynamic subtest: bcs0
[392.370067] Dynamic subtest bcs0: SUCCESS (2.056s)
[392.381069] Starting dynamic subtest: vcs0
[394.351713] Dynamic subtest vcs0: SUCCESS (1.980s)
[394.362345] Starting dynamic subtest: vcs1
[396.314466] Dynamic subtest vcs1: SUCCESS (1.961s)
[396.325080] Starting dynamic subtest: vecs0
[398.314487] Dynamic subtest vecs0: SUCCESS (1.998s)
[398.326754] Starting dynamic subtest: ccs0
[400.299058] Dynamic subtest ccs0: SUCCESS (1.983s)
[400.301438] Subtest engines-mixed-process: SUCCESS (11.512s)
[400.382090] [099/156] (615s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[400.481648] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[400.860411] Starting dynamic subtest: pipe-A-eDP-1
[403.610947] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.749s)
[403.986979] Starting dynamic subtest: pipe-B-eDP-1
[406.740681] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.764s)
[407.103629] Starting dynamic subtest: pipe-C-eDP-1
[409.867675] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.772s)
[410.243111] Starting dynamic subtest: pipe-D-eDP-1
[413.001162] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.767s)
[413.003898] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.521s)
[414.195169] [100/156] (601s left) kms_getfb (getfb-addfb-different-handles)
[414.284071] Starting subtest: getfb-addfb-different-handles
[414.286059] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[414.404564] [101/156] (601s left) gem_exec_fence (basic-busy-all)
[414.462815] Starting subtest: basic-busy-all
[414.545945] Subtest basic-busy-all: SUCCESS (0.083s)
[416.389019] [102/156] (599s left) kms_content_protection (lic-type-0)
[416.530892] Starting subtest: lic-type-0
[416.535311] Subtest lic-type-0: SKIP (0.000s)
[416.658099] [103/156] (599s left) kms_pm_dc (dc9-dpms)
[417.755574] Starting subtest: dc9-dpms
[419.198476] Subtest dc9-dpms: SUCCESS (1.442s)
[419.286115] [104/156] (597s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[419.396664] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[419.401149] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[419.503330] [105/156] (596s left) kms_psr (psr2-cursor-mmap-cpu)
[419.598080] Starting subtest: psr2-cursor-mmap-cpu
[419.600296] Starting dynamic subtest: eDP-1
[421.331076] Dynamic subtest eDP-1: SUCCESS (1.733s)
[421.333338] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.734s)
[422.228097] [106/156] (594s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[422.322753] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[422.349355] Starting dynamic subtest: pipe-A-plane-0
[422.638627] Dynamic subtest pipe-A-plane-0: SUCCESS (0.288s)
[422.649391] Starting dynamic subtest: pipe-A-plane-3
[422.872557] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[424.012805] Starting dynamic subtest: pipe-B-plane-0
[424.304565] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[424.314582] Starting dynamic subtest: pipe-B-plane-3
[424.537402] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[424.857040] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.536s)
[425.690113] [107/156] (590s left) kms_properties (plane-properties-atomic)
[425.787184] Starting subtest: plane-properties-atomic
[425.789097] Starting dynamic subtest: pipe-A-eDP-1
[426.343758] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.554s)
[426.354983] Starting dynamic subtest: pipe-B-eDP-1
[427.640227] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.298s)
[427.652360] Starting dynamic subtest: pipe-C-eDP-1
[428.872449] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.229s)
[428.883173] Starting dynamic subtest: pipe-D-eDP-1
[430.093553] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.220s)
[430.095752] Subtest plane-properties-atomic: SUCCESS (4.307s)
[430.907673] [108/156] (585s left) prime_vgem (coherency-gtt)
[430.976972] Starting subtest: coherency-gtt
[430.982208] Subtest coherency-gtt: SKIP (0.000s)
[431.085550] [109/156] (585s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[431.183167] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[431.185357] Starting dynamic subtest: pipe-A-eDP-1
[431.335635] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.142s)
[431.348072] Starting dynamic subtest: pipe-B-eDP-1
[431.368447] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[431.378311] Starting dynamic subtest: pipe-C-eDP-1
[431.397743] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[431.407153] Starting dynamic subtest: pipe-D-eDP-1
[431.427738] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[431.429637] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.152s)
[433.663609] [110/156] (582s left) kms_display_modes (extended-mode-basic)
[433.756286] Starting subtest: extended-mode-basic
[433.760285] Subtest extended-mode-basic: SKIP (0.000s)
[433.805303] [111/156] (582s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[433.914711] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[433.918959] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[434.017692] [112/156] (582s left) gem_exec_fence (syncobj-signal)
[434.439505] Starting subtest: syncobj-signal
[434.445459] Subtest syncobj-signal: SUCCESS (0.006s)
[436.403561] [113/156] (580s left) gem_ctx_engines (invalid-engines)
[436.458655] Starting subtest: invalid-engines
[436.473423] Subtest invalid-engines: SUCCESS (0.015s)
[436.710524] [114/156] (580s left) gem_mmap_gtt (flink-race)
[436.771052] Subtest flink-race: SKIP (0.000s)
[436.830060] [115/156] (579s left) gem_exec_params (no-blt)
[436.892701] Starting subtest: no-blt
[436.898297] Subtest no-blt: SUCCESS (0.003s)
[437.023835] [116/156] (579s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-move)
[437.136388] Starting subtest: hdr-2p-primscrn-cur-indfb-move
[437.140829] Subtest hdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[437.236895] [117/156] (579s left) api_intel_bb (intel-bb-blit-x)
[437.291955] Starting subtest: intel-bb-blit-x
[441.225111] Subtest intel-bb-blit-x: SUCCESS (3.933s)
[441.370803] [118/156] (575s left) sysfs_heartbeat_interval (idempotent)
[441.431698] Starting subtest: idempotent
[441.433994] Starting dynamic subtest: vecs0
[441.436189] Dynamic subtest vecs0: SUCCESS (0.001s)
[441.448052] Starting dynamic subtest: ccs0
[441.450267] Dynamic subtest ccs0: SUCCESS (0.002s)
[441.459756] Starting dynamic subtest: vcs0
[441.461592] Dynamic subtest vcs0: SUCCESS (0.000s)
[441.471401] Starting dynamic subtest: bcs0
[441.473259] Dynamic subtest bcs0: SUCCESS (0.002s)
[441.482694] Starting dynamic subtest: rcs0
[441.484654] Dynamic subtest rcs0: SUCCESS (0.003s)
[441.495064] Starting dynamic subtest: vcs1
[441.497712] Dynamic subtest vcs1: SUCCESS (0.001s)
[441.500076] Subtest idempotent: SUCCESS (0.014s)
[441.562185] [119/156] (575s left) syncobj_timeline (invalid-wait-illegal-handle)
[441.621308] Starting subtest: invalid-wait-illegal-handle
[441.623668] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[441.742436] [120/156] (575s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[441.853069] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[449.020321] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.172s)
[449.171285] [121/156] (567s left) gem_ctx_persistence (legacy-engines-persistence)
[449.226385] Starting subtest: legacy-engines-persistence
[449.228730] Starting dynamic subtest: render
[450.010927] Dynamic subtest render: SUCCESS (0.783s)
[450.023464] Starting dynamic subtest: bsd1
[450.782831] Dynamic subtest bsd1: SUCCESS (0.769s)
[450.797043] Starting dynamic subtest: bsd2
[451.555817] Dynamic subtest bsd2: SUCCESS (0.769s)
[451.571031] Starting dynamic subtest: blt
[452.314715] Dynamic subtest blt: SUCCESS (0.756s)
[452.330034] Starting dynamic subtest: vebox
[453.093649] Dynamic subtest vebox: SUCCESS (0.776s)
[453.096091] Subtest legacy-engines-persistence: SUCCESS (3.868s)
[453.188733] [122/156] (563s left) kms_plane_alpha_blend (constant-alpha-min)
[453.288193] Starting subtest: constant-alpha-min
[453.593585] Starting dynamic subtest: pipe-A-eDP-1
[454.325258] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.730s)
[454.338247] Starting dynamic subtest: pipe-D-eDP-1
[455.800277] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.472s)
[455.802564] Subtest constant-alpha-min: SUCCESS (2.512s)
[456.681945] [123/156] (560s left) kms_force_connector_basic (force-load-detect)
[456.768152] Starting subtest: force-load-detect
[456.772654] Subtest force-load-detect: SKIP (0.000s)
[456.897967] [124/156] (560s left) gem_exec_flush (basic-uc-pro-default)
[456.963357] Starting subtest: basic-uc-pro-default
[462.425279] Subtest basic-uc-pro-default: SUCCESS (5.463s)
[462.622946] [125/156] (554s left) i915_drm_fdinfo (virtual-busy-all)
[462.663074] Starting subtest: virtual-busy-all
[462.667084] Subtest virtual-busy-all: SKIP (0.000s)
[462.732819] [126/156] (554s left) gem_eio (wait-wedge-immediate)
[462.952739] Starting subtest: wait-wedge-immediate
[464.435104] Subtest wait-wedge-immediate: SUCCESS (1.482s)
[464.582806] [127/156] (552s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-render)
[464.681731] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-render
[464.685706] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[464.798268] [128/156] (552s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[464.898260] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[472.360597] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.469s)
[472.497113] [129/156] (544s left) perf_pmu (pmu-read)
[472.542540] Starting subtest: pmu-read
[472.547299] Subtest pmu-read: SUCCESS (0.003s)
[472.644704] [130/156] (544s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[472.743128] Starting subtest: fbcpsr-tiling-4
[479.883195] Subtest fbcpsr-tiling-4: SUCCESS (7.145s)
[480.022449] [131/156] (537s left) kms_rotation_crc (primary-rotation-270)
[480.115738] Starting subtest: primary-rotation-270
[480.120179] Subtest primary-rotation-270: SKIP (0.001s)
[480.194440] [132/156] (537s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[480.290676] Starting subtest: 4-tiled-64bpp-rotate-270
[480.310501] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.019s)
[480.413364] [133/156] (537s left) kms_plane (plane-position-covered)
[480.498421] Starting subtest: plane-position-covered
[481.022320] Starting dynamic subtest: pipe-A-plane-1
[482.371788] Dynamic subtest pipe-A-plane-1: SUCCESS (1.350s)
[482.382079] Starting dynamic subtest: pipe-A-plane-2
[483.673786] Dynamic subtest pipe-A-plane-2: SUCCESS (1.303s)
[483.685561] Starting dynamic subtest: pipe-A-plane-3
[485.006596] Dynamic subtest pipe-A-plane-3: SUCCESS (1.332s)
[485.017864] Starting dynamic subtest: pipe-A-plane-4
[486.337163] Dynamic subtest pipe-A-plane-4: SUCCESS (1.327s)
[486.348797] Starting dynamic subtest: pipe-A-plane-5
[486.361119] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[487.619483] Starting dynamic subtest: pipe-B-plane-1
[488.923103] Dynamic subtest pipe-B-plane-1: SUCCESS (1.313s)
[488.934165] Starting dynamic subtest: pipe-B-plane-2
[490.276832] Dynamic subtest pipe-B-plane-2: SUCCESS (1.354s)
[490.287713] Starting dynamic subtest: pipe-B-plane-3
[491.613327] Dynamic subtest pipe-B-plane-3: SUCCESS (1.335s)
[491.624156] Starting dynamic subtest: pipe-B-plane-4
[492.909208] Dynamic subtest pipe-B-plane-4: SUCCESS (1.297s)
[492.920871] Starting dynamic subtest: pipe-B-plane-5
[492.937324] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[492.939593] Subtest plane-position-covered: SUCCESS (12.439s)
[493.798395] [134/156] (523s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[493.893051] Starting subtest: fbc-rgb101010-draw-blt
[496.421403] Subtest fbc-rgb101010-draw-blt: SUCCESS (2.533s)
[497.615596] [135/156] (520s left) syncobj_eventfd (invalid-illegal-handle)
[497.675878] Starting subtest: invalid-illegal-handle
[497.678073] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[497.793396] [136/156] (519s left) kms_cursor_crc (cursor-sliding-32x10)
[497.966867] Starting subtest: cursor-sliding-32x10
[498.014416] Subtest cursor-sliding-32x10: SKIP (0.045s)
[498.294195] [137/156] (519s left) syncobj_basic (bad-pad-handle-to-fd)
[498.343983] Starting subtest: bad-pad-handle-to-fd
[498.345892] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[498.426266] [138/156] (519s left) gem_mmap_gtt (basic-read-write)
[498.479538] Subtest basic-read-write: SKIP (0.000s)
[498.534110] [139/156] (519s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-wc)
[498.628044] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-wc
[498.631627] Subtest fbcpsrhdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[498.719837] [140/156] (519s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[498.830744] Starting subtest: cursorA-vs-flipA-atomic-transitions
[510.000414] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.167s)
[510.827631] [141/156] (507s left) kms_hdr (static-toggle-suspend)
[510.943163] Starting subtest: static-toggle-suspend
[510.945501] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[510.949927] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[510.961087] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[510.965219] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[510.969391] Subtest static-toggle-suspend: SKIP (0.003s)
[511.017468] [142/156] (506s left) gem_exec_balancer (parallel-keep-in-fence)
[511.280210] Starting subtest: parallel-keep-in-fence
[512.548065] Subtest parallel-keep-in-fence: SUCCESS (1.268s)
[512.644797] [143/156] (505s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[512.742937] Starting subtest: psr-1p-primscrn-spr-indfb-move
[520.188072] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.449s)
[520.351693] [144/156] (497s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[520.518662] Starting subtest: cursor-rapid-movement-32x10
[520.571594] Subtest cursor-rapid-movement-32x10: SKIP (0.047s)
[520.846653] [145/156] (497s left) gem_mmap_wc (write-read)
[520.907252] Subtest write-read: SKIP (0.000s)
[520.972979] [146/156] (497s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt)
[521.073615] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt
[521.077972] Subtest fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[521.157927] [147/156] (497s left) kms_psr (fbc-psr-sprite-blt)
[521.243576] Starting subtest: fbc-psr-sprite-blt
[521.245488] Starting dynamic subtest: eDP-1
[521.248800] Dynamic subtest eDP-1: SKIP (0.000s)
[521.252180] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[521.315255] [148/156] (496s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[521.404975] Starting subtest: psr-shrfb-scaledprimary
[527.251026] Subtest psr-shrfb-scaledprimary: SUCCESS (5.849s)
[527.363655] [149/156] (490s left) kms_atomic (plane-primary-legacy)
[527.462108] Starting subtest: plane-primary-legacy
[527.464298] Starting dynamic subtest: pipe-A-eDP-1
[527.891049] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.428s)
[527.893416] Subtest plane-primary-legacy: SUCCESS (0.430s)
[528.730166] [150/156] (489s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[528.788486] Starting subtest: multi-wait-all-for-submit-signaled
[528.790756] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[528.892482] [151/156] (489s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[529.013688] Starting subtest: cursorA-vs-flipA-legacy
[540.140143] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.124s)
[540.964425] [152/156] (477s left) sw_sync (sync_busy)
[541.000266] Starting subtest: sync_busy
[541.002190] Subtest sync_busy: SUCCESS (0.002s)
[541.080268] [153/156] (477s left) perf (low-oa-exponent-permissions)
[541.178747] Starting subtest: low-oa-exponent-permissions
[541.210046] Subtest low-oa-exponent-permissions: SUCCESS (0.031s)
[541.254492] [154/156] (477s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[541.351247] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[541.355774] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[541.449283] [155/156] (477s left) gem_basic (bad-close)
[541.491416] Starting subtest: bad-close
[541.495953] Subtest bad-close: SUCCESS (0.000s)
[541.586709] [156/156] (477s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[541.684891] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[541.689089] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[541.775805] Closing watchdogs
results: parsing output: 0/ for test: gem_lmem_swapping
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_softpin
results: parsing output: 4/ for test: gen9_exec_parse
results: parsing output: 5/ for test: gem_userptr_blits
results: parsing output: 6/ for test: kms_flip_scaled_crc
results: parsing output: 7/ for test: gem_spin_batch
results: parsing output: 8/ for test: kms_chamelium_hpd
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_mmap_gtt
results: parsing output: 12/ for test: kms_cursor_crc
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: kms_psr2_sf
results: parsing output: 18/ for test: gem_exec_balancer
results: parsing output: 19/ for test: kms_cursor_legacy
results: parsing output: 20/ for test: core_sysfs
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: kms_chamelium_edid
results: parsing output: 26/ for test: i915_pciid
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: kms_rotation_crc
results: parsing output: 29/ for test: perf
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_sequence
results: parsing output: 32/ for test: kms_chamelium_audio
results: parsing output: 33/ for test: gem_exec_reloc
results: parsing output: 34/ for test: kms_color
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_render_copy
results: parsing output: 38/ for test: kms_pipe_crc_basic
results: parsing output: 39/ for test: gem_wait
results: parsing output: 40/ for test: i915_pm_rps
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: prime_vgem
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: perf_pmu
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_ctx_sseu
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: gem_mmap_wc
results: parsing output: 56/ for test: kms_joiner
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: sw_sync
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_plane_lowres
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_pxp
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: fbdev
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_pm_backlight
results: parsing output: 69/ for test: kms_pm_rpm
results: parsing output: 70/ for test: kms_vblank
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: gem_flink_race
results: parsing output: 75/ for test: gem_exec_schedule
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_psr2_sf
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: i915_pm_rc6_residency
results: parsing output: 81/ for test: gem_softpin
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_pxp
results: parsing output: 84/ for test: template
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: api_intel_bb
results: parsing output: 87/ for test: gem_exec_gttfill
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_draw_crc
results: parsing output: 93/ for test: syncobj_wait
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_exec_whisper
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: gem_ctx_persistence
results: parsing output: 98/ for test: kms_async_flips
results: parsing output: 99/ for test: kms_getfb
results: parsing output: 100/ for test: gem_exec_fence
results: parsing output: 101/ for test: kms_content_protection
results: parsing output: 102/ for test: kms_pm_dc
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: kms_plane
results: parsing output: 106/ for test: kms_properties
results: parsing output: 107/ for test: prime_vgem
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_display_modes
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_exec_fence
results: parsing output: 112/ for test: gem_ctx_engines
results: parsing output: 113/ for test: gem_mmap_gtt
results: parsing output: 114/ for test: gem_exec_params
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: api_intel_bb
results: parsing output: 117/ for test: sysfs_heartbeat_interval
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_ctx_persistence
results: parsing output: 121/ for test: kms_plane_alpha_blend
results: parsing output: 122/ for test: kms_force_connector_basic
results: parsing output: 123/ for test: gem_exec_flush
results: parsing output: 124/ for test: i915_drm_fdinfo
results: parsing output: 125/ for test: gem_eio
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: perf_pmu
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_rotation_crc
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: kms_plane
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: syncobj_eventfd
results: parsing output: 135/ for test: kms_cursor_crc
results: parsing output: 136/ for test: syncobj_basic
results: parsing output: 137/ for test: gem_mmap_gtt
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: kms_cursor_legacy
results: parsing output: 140/ for test: kms_hdr
results: parsing output: 141/ for test: gem_exec_balancer
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_cursor_crc
results: parsing output: 144/ for test: gem_mmap_wc
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_psr
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_atomic
results: parsing output: 149/ for test: syncobj_wait
results: parsing output: 150/ for test: kms_cursor_legacy
results: parsing output: 151/ for test: sw_sync
results: parsing output: 152/ for test: perf
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: gem_basic
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.