[60.177457] Initializing watchdogs
[60.177531]   /dev/watchdog0
[60.203058] [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]
[60.207425] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.209740] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.212971] [001/134] (960s left) dumb_buffer (map-uaf)
[60.290870] Starting subtest: map-uaf
[60.295874] Subtest map-uaf: SUCCESS (0.004s)
[60.419655] [002/134] (960s left) kms_cursor_crc (cursor-size-hints)
[60.553911] Starting subtest: cursor-size-hints
[60.555951] Starting dynamic subtest: pipe-A-eDP-1
[61.216574] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.663s)
[61.224931] Starting dynamic subtest: pipe-D-eDP-1
[62.464272] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.246s)
[62.466359] Subtest cursor-size-hints: SUCCESS (1.911s)
[63.281084] [003/134] (957s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[63.386442] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[63.391011] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[64.520154] [004/134] (956s left) syncobj_wait (single-wait-for-submit-signaled)
[64.579960] Starting subtest: single-wait-for-submit-signaled
[64.582413] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[64.701450] [005/134] (956s left) gem_workarounds (basic-read)
[64.784703] Starting subtest: basic-read
[64.793689] Subtest basic-read: SUCCESS (0.010s)
[64.893796] [006/134] (956s left) kms_dp_linktrain_fallback (dsc-fallback)
[64.993177] Starting subtest: dsc-fallback
[64.999965] Subtest dsc-fallback: SKIP (0.000s)
[65.075819] [007/134] (955s left) gem_create (create-invalid-size)
[65.133569] Starting subtest: create-invalid-size
[65.135936] Subtest create-invalid-size: SUCCESS (0.000s)
[65.340343] [008/134] (955s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[65.446866] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[65.451544] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[65.566891] [009/134] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[65.671299] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[72.303933] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.636s)
[72.467839] [010/134] (948s left) gem_partial_pwrite_pread (reads)
[72.553686] Subtest reads: SKIP (0.000s)
[72.642326] [011/134] (948s left) api_intel_bb (object-reloc-purge-cache)
[72.709954] Starting subtest: object-reloc-purge-cache
[72.714268] Subtest object-reloc-purge-cache: SKIP (0.003s)
[72.858742] [012/134] (948s left) gem_render_copy (y-tiled-to-vebox-linear)
[72.909136] Starting subtest: y-tiled-to-vebox-linear
[72.913570] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[73.099013] [013/134] (948s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[73.192469] Starting subtest: 2x-absolute-wf_vblank-interruptible
[73.203805] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.010s)
[73.288277] [014/134] (947s left) gem_softpin (allocator-nopin)
[73.344667] Starting subtest: allocator-nopin
[73.434518] Subtest allocator-nopin: SUCCESS (0.089s)
[73.584201] [015/134] (947s left) kms_pm_rpm (drm-resources-equal)
[75.110813] Starting subtest: drm-resources-equal
[80.507100] Subtest drm-resources-equal: SUCCESS (5.398s)
[80.604468] [016/134] (940s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[80.702862] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[80.705287] Starting dynamic subtest: pipe-A
[81.049878] Dynamic subtest pipe-A: SUCCESS (0.349s)
[81.058878] Starting dynamic subtest: pipe-B
[82.421100] Dynamic subtest pipe-B: SUCCESS (1.371s)
[82.429906] Starting dynamic subtest: pipe-C
[83.872892] Dynamic subtest pipe-C: SUCCESS (1.451s)
[83.881631] Starting dynamic subtest: pipe-D
[85.281997] Dynamic subtest pipe-D: SUCCESS (1.409s)
[85.284311] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.581s)
[86.463926] [017/134] (934s left) gem_ctx_persistence (engines-hang)
[86.539090] Starting subtest: engines-hang
[86.541436] Starting dynamic subtest: rcs0
[86.604743] Dynamic subtest rcs0: SUCCESS (0.065s)
[86.617254] Starting dynamic subtest: bcs0
[86.754798] Dynamic subtest bcs0: SUCCESS (0.149s)
[86.764934] Starting dynamic subtest: vcs0
[86.859740] Dynamic subtest vcs0: SUCCESS (0.104s)
[86.869788] Starting dynamic subtest: vcs1
[86.964984] Dynamic subtest vcs1: SUCCESS (0.104s)
[86.975295] Starting dynamic subtest: vecs0
[87.061595] Dynamic subtest vecs0: SUCCESS (0.096s)
[87.071592] Starting dynamic subtest: ccs0
[87.169198] Dynamic subtest ccs0: SUCCESS (0.106s)
[87.172037] Subtest engines-hang: SUCCESS (0.630s)
[87.259212] [018/134] (934s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[87.372936] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[87.398421] Starting dynamic subtest: pipe-A-plane-0
[87.402302] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[87.411171] Starting dynamic subtest: pipe-A-plane-3
[87.414862] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[87.421740] Starting dynamic subtest: pipe-A-plane-5
[87.425239] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[88.449438] Starting dynamic subtest: pipe-B-plane-0
[88.453865] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[88.463249] Starting dynamic subtest: pipe-B-plane-3
[88.467967] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[88.475293] Starting dynamic subtest: pipe-B-plane-5
[88.479617] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[88.778393] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (1.403s)
[89.658074] [019/134] (931s left) i915_pm_rc6_residency (media-rc6-accuracy)
[89.718310] Starting subtest: media-rc6-accuracy
[89.722647] Subtest media-rc6-accuracy: SKIP (0.000s)
[89.831959] [020/134] (931s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[89.941734] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[89.946024] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[90.068341] [021/134] (931s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[90.160887] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[90.163264] Starting dynamic subtest: pipe-A-default-mode
[92.854465] Dynamic subtest pipe-A-default-mode: SUCCESS (2.694s)
[92.856796] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.695s)
[93.722376] [022/134] (927s left) kms_chamelium_hpd (vga-hpd-fast)
[94.120091] Subtest vga-hpd-fast: SKIP (0.000s)
[94.920904] [023/134] (926s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[94.986440] Starting subtest: etime-single-wait-all-for-submit-submitted
[95.092304] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.106s)
[95.175849] [024/134] (926s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[95.271242] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[95.273620] Starting dynamic subtest: pipe-A-eDP-1
[95.282781] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[95.297902] Starting dynamic subtest: pipe-B-eDP-1
[95.306339] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[95.317641] Starting dynamic subtest: pipe-C-eDP-1
[95.326554] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[95.333597] Starting dynamic subtest: pipe-D-eDP-1
[95.342170] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[95.346522] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.003s)
[97.517107] [025/134] (924s left) kms_psr (psr-cursor-mmap-cpu)
[97.612011] Starting subtest: psr-cursor-mmap-cpu
[97.614466] Starting dynamic subtest: eDP-1
[99.292227] Dynamic subtest eDP-1: SUCCESS (1.680s)
[99.294670] Subtest psr-cursor-mmap-cpu: SUCCESS (1.681s)
[100.166739] [026/134] (921s left) kms_sequence (get-forked-busy)
[100.270697] Starting subtest: get-forked-busy
[100.272763] Starting dynamic subtest: pipe-A-eDP-1
[102.206089] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s)
[102.215332] Starting dynamic subtest: pipe-B-eDP-1
[104.765542] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.559s)
[104.774384] Starting dynamic subtest: pipe-C-eDP-1
[107.387470] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.620s)
[107.397088] Starting dynamic subtest: pipe-D-eDP-1
[109.937792] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.551s)
[109.940216] Subtest get-forked-busy: SUCCESS (9.669s)
[110.745898] [027/134] (911s left) sysfs_timeslice_duration (invalid)
[110.815550] Starting subtest: invalid
[110.817964] Starting dynamic subtest: vecs0
[110.820380] Dynamic subtest vecs0: SUCCESS (0.000s)
[110.829357] Starting dynamic subtest: ccs0
[110.831221] Dynamic subtest ccs0: SUCCESS (0.000s)
[110.837935] Starting dynamic subtest: vcs0
[110.839860] Dynamic subtest vcs0: SUCCESS (0.000s)
[110.846784] Starting dynamic subtest: bcs0
[110.848647] Dynamic subtest bcs0: SUCCESS (0.000s)
[110.855920] Starting dynamic subtest: rcs0
[110.857793] Dynamic subtest rcs0: SUCCESS (0.000s)
[110.865101] Starting dynamic subtest: vcs1
[110.867249] Dynamic subtest vcs1: SUCCESS (0.000s)
[110.869395] Subtest invalid: SUCCESS (0.004s)
[110.944410] [028/134] (910s left) perf (i915-ref-count)
[111.022815] Starting subtest: i915-ref-count
[111.096597] Subtest i915-ref-count: SUCCESS (0.072s)
[111.154261] [029/134] (910s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[111.220778] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[111.223194] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[111.345009] [030/134] (910s left) kms_rmfb (close-fd)
[111.438153] Starting subtest: close-fd
[111.440386] Starting dynamic subtest: pipe-A-eDP-1
[111.545181] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[111.554080] Starting dynamic subtest: pipe-B-eDP-1
[112.705590] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.155s)
[112.714490] Starting dynamic subtest: pipe-C-eDP-1
[113.926827] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.226s)
[113.935501] Starting dynamic subtest: pipe-D-eDP-1
[115.059876] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s)
[115.062220] Subtest close-fd: SUCCESS (3.623s)
[116.275764] [031/134] (905s left) template (b)
[116.341731] Starting subtest: B
[116.343830] Subtest B: SUCCESS (0.000s)
[116.448572] [032/134] (905s left) kms_plane (pixel-format-linear-modifier)
[116.549000] Starting subtest: pixel-format-linear-modifier
[116.574732] Starting dynamic subtest: pipe-A-plane-0
[120.152093] Dynamic subtest pipe-A-plane-0: SUCCESS (3.578s)
[120.159996] Starting dynamic subtest: pipe-A-plane-3
[121.864487] Dynamic subtest pipe-A-plane-3: SUCCESS (1.712s)
[121.871732] Starting dynamic subtest: pipe-A-plane-5
[122.074521] Dynamic subtest pipe-A-plane-5: SUCCESS (0.209s)
[123.153758] Starting dynamic subtest: pipe-B-plane-0
[126.591900] Dynamic subtest pipe-B-plane-0: SUCCESS (3.444s)
[126.602458] Starting dynamic subtest: pipe-B-plane-3
[128.315223] Dynamic subtest pipe-B-plane-3: SUCCESS (1.722s)
[128.323022] Starting dynamic subtest: pipe-B-plane-5
[128.514249] Dynamic subtest pipe-B-plane-5: SUCCESS (0.199s)
[128.825068] Subtest pixel-format-linear-modifier: SUCCESS (12.276s)
[129.636493] [033/134] (892s left) gem_ctx_shared (q-promotion)
[129.709056] Starting subtest: Q-promotion
[129.711252] Starting dynamic subtest: rcs0
[129.867639] Dynamic subtest rcs0: SUCCESS (0.158s)
[129.882684] Starting dynamic subtest: vcs0
[129.951077] Dynamic subtest vcs0: SUCCESS (0.083s)
[129.966662] Starting dynamic subtest: vcs1
[130.030605] Dynamic subtest vcs1: SUCCESS (0.078s)
[130.046029] Starting dynamic subtest: vecs0
[130.105840] Dynamic subtest vecs0: SUCCESS (0.073s)
[130.121420] Starting dynamic subtest: ccs0
[130.184622] Dynamic subtest ccs0: SUCCESS (0.078s)
[130.187574] Subtest Q-promotion: SUCCESS (0.475s)
[132.065371] [FACT gem_ctx_shared (q-promotion)] new: kernel.kmod_is_loaded.vgem: true
[132.068973] [034/134] (889s left) kms_cursor_crc (cursor-offscreen-max-size)
[132.371148] Starting subtest: cursor-offscreen-max-size
[132.377403] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[132.520922] [035/134] (889s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[132.617198] Starting subtest: fbc-psr-sprite-mmap-gtt
[132.619409] Starting dynamic subtest: eDP-1
[132.623459] Dynamic subtest eDP-1: SKIP (0.000s)
[132.627517] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[132.700117] [036/134] (889s left) sw_sync (sync_merge_invalid)
[132.737392] Starting subtest: sync_merge_invalid
[132.762333] Subtest sync_merge_invalid: SUCCESS (0.025s)
[132.869205] [037/134] (889s left) i915_drm_fdinfo (busy-idle-check-all)
[132.910612] Starting subtest: busy-idle-check-all
[132.913094] Starting dynamic subtest: rcs0
[132.917726] Dynamic subtest rcs0: SKIP (0.003s)
[132.927953] Starting dynamic subtest: bcs0
[132.932675] Dynamic subtest bcs0: SKIP (0.000s)
[132.945678] Starting dynamic subtest: vcs0
[132.950295] Dynamic subtest vcs0: SKIP (0.000s)
[132.959334] Starting dynamic subtest: vcs1
[132.963364] Dynamic subtest vcs1: SKIP (0.000s)
[132.970636] Starting dynamic subtest: vecs0
[132.974702] Dynamic subtest vecs0: SKIP (0.000s)
[132.981644] Starting dynamic subtest: ccs0
[132.985678] Dynamic subtest ccs0: SKIP (0.000s)
[132.989772] Subtest busy-idle-check-all: SKIP (0.008s)
[133.028530] [038/134] (889s left) i915_module_load (reload)
[133.068087] Starting subtest: reload
[138.075570] Subtest reload: SUCCESS (5.009s)
[138.115689] [039/134] (884s left) gem_exec_suspend (basic-s3)
[139.910847] Starting subtest: basic-S3
[139.913266] Starting dynamic subtest: smem
[161.247914] Dynamic subtest smem: SUCCESS (6.989s)
[161.250917] Subtest basic-S3: SUCCESS (6.991s)
[161.443558] [040/134] (860s left) gem_close (many-handles-one-vma)
[161.516471] Starting subtest: many-handles-one-vma
[161.540750] Subtest many-handles-one-vma: SUCCESS (0.025s)
[161.692026] [041/134] (860s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[161.804601] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[161.806853] Starting dynamic subtest: pipe-A-eDP-1
[161.832212] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[161.842569] Starting dynamic subtest: pipe-B-eDP-1
[161.866387] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[161.874770] Starting dynamic subtest: pipe-C-eDP-1
[161.898544] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[161.906853] Starting dynamic subtest: pipe-D-eDP-1
[161.933391] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[161.937980] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[164.048398] [042/134] (858s left) gem_exec_balancer (parallel-out-fence)
[164.312842] Starting subtest: parallel-out-fence
[165.445275] Subtest parallel-out-fence: SUCCESS (1.132s)
[165.583988] [043/134] (856s left) gem_exec_reloc (basic-gtt-read)
[165.640210] Subtest basic-gtt-read: SKIP (0.000s)
[165.730447] [044/134] (856s left) kms_invalid_mode (bad-vsync-start)
[165.843032] Starting subtest: bad-vsync-start
[165.845476] Starting dynamic subtest: pipe-A-eDP-1
[166.125246] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[166.134860] Starting dynamic subtest: pipe-B-eDP-1
[166.137122] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[166.145415] Starting dynamic subtest: pipe-C-eDP-1
[166.147679] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[166.155609] Starting dynamic subtest: pipe-D-eDP-1
[166.157529] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[166.159419] Subtest bad-vsync-start: SUCCESS (0.290s)
[166.983101] [045/134] (855s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[167.087945] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[167.092349] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[167.216406] [046/134] (855s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[167.312420] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[167.316607] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[167.459039] [047/134] (855s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[167.571481] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[174.112377] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.542s)
[174.260567] [048/134] (848s left) perf_pmu (busy-idle)
[174.303280] Starting subtest: busy-idle
[174.305697] Starting dynamic subtest: rcs0
[175.018417] Dynamic subtest rcs0: SUCCESS (0.716s)
[175.030105] Starting dynamic subtest: bcs0
[175.691205] Dynamic subtest bcs0: SUCCESS (0.670s)
[175.701195] Starting dynamic subtest: vcs0
[177.247235] Dynamic subtest vcs0: SUCCESS (1.552s)
[177.258242] Starting dynamic subtest: vcs1
[179.230995] Dynamic subtest vcs1: SUCCESS (1.980s)
[179.242445] Starting dynamic subtest: vecs0
[181.214837] Dynamic subtest vecs0: SUCCESS (1.981s)
[181.228739] Starting dynamic subtest: ccs0
[181.886404] Dynamic subtest ccs0: SUCCESS (0.670s)
[181.888993] Subtest busy-idle: SUCCESS (7.583s)
[182.023452] [049/134] (840s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[182.160393] Starting subtest: short-flip-after-cursor-toggle
[183.086644] Subtest short-flip-after-cursor-toggle: SUCCESS (0.923s)
[183.935407] [050/134] (838s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[184.038308] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[184.040548] Starting dynamic subtest: pipe-A
[184.058457] Dynamic subtest pipe-A: SKIP (0.018s)
[184.067505] Starting dynamic subtest: pipe-B
[184.096117] Dynamic subtest pipe-B: SKIP (0.035s)
[184.104898] Starting dynamic subtest: pipe-C
[184.130406] Dynamic subtest pipe-C: SKIP (0.035s)
[184.138954] Starting dynamic subtest: pipe-D
[184.162218] Dynamic subtest pipe-D: SKIP (0.031s)
[184.166254] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.121s)
[184.289225] [051/134] (838s left) kms_vblank (ts-continuation-modeset)
[184.389516] Starting subtest: ts-continuation-modeset
[184.391415] Starting dynamic subtest: pipe-A-eDP-1
[185.900495] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.510s)
[185.914749] Starting dynamic subtest: pipe-D-eDP-1
[188.064822] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.162s)
[188.067179] Subtest ts-continuation-modeset: SUCCESS (3.676s)
[188.873323] [052/134] (833s left) gem_exec_fence (keep-in-fence)
[189.064523] Starting subtest: keep-in-fence
[189.067206] Starting dynamic subtest: rcs0
[189.118828] Dynamic subtest rcs0: SUCCESS (0.055s)
[189.129875] Starting dynamic subtest: bcs0
[189.172741] Dynamic subtest bcs0: SUCCESS (0.052s)
[189.183361] Starting dynamic subtest: vcs0
[190.243758] Dynamic subtest vcs0: SUCCESS (1.063s)
[190.254568] Starting dynamic subtest: vcs1
[192.224148] Dynamic subtest vcs1: SUCCESS (1.982s)
[192.236573] Starting dynamic subtest: vecs0
[194.271698] Dynamic subtest vecs0: SUCCESS (2.045s)
[194.283899] Starting dynamic subtest: ccs0
[194.520814] Dynamic subtest ccs0: SUCCESS (0.248s)
[194.523456] Subtest keep-in-fence: SUCCESS (5.458s)
[196.357141] [053/134] (826s left) gem_basic (create-close)
[196.426890] Starting subtest: create-close
[196.431613] Subtest create-close: SUCCESS (0.000s)
[196.576364] [054/134] (826s left) kms_chamelium_color (gamma)
[196.683429] Subtest gamma: SKIP (0.000s)
[196.736322] [055/134] (826s left) perf_pmu (init-sema)
[196.773150] Starting subtest: init-sema
[196.775669] Starting dynamic subtest: rcs0
[196.777997] Dynamic subtest rcs0: SUCCESS (0.002s)
[196.789398] Starting dynamic subtest: bcs0
[196.791891] Dynamic subtest bcs0: SUCCESS (0.001s)
[196.802686] Starting dynamic subtest: vcs0
[196.804579] Dynamic subtest vcs0: SUCCESS (0.001s)
[196.812763] Starting dynamic subtest: vcs1
[196.814673] Dynamic subtest vcs1: SUCCESS (0.000s)
[196.822775] Starting dynamic subtest: vecs0
[196.824703] Dynamic subtest vecs0: SUCCESS (0.000s)
[196.832512] Starting dynamic subtest: ccs0
[196.834387] Dynamic subtest ccs0: SUCCESS (0.000s)
[196.836230] Subtest init-sema: SUCCESS (0.008s)
[196.922475] [056/134] (826s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[197.037464] Starting subtest: fbc-pr-sprite-mmap-cpu
[197.041521] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[197.122623] [057/134] (825s left) kms_lease (lease-get)
[197.237471] Starting subtest: lease-get
[197.240095] Starting dynamic subtest: pipe-A-eDP-1
[197.242963] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[197.254839] Starting dynamic subtest: pipe-B-eDP-1
[197.257080] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[197.266106] Starting dynamic subtest: pipe-C-eDP-1
[197.268422] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[197.276953] Starting dynamic subtest: pipe-D-eDP-1
[197.278754] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[197.280522] Subtest lease-get: SUCCESS (0.011s)
[197.382435] [058/134] (825s left) gem_lmem_swapping (parallel-random-verify-ccs)
[197.432012] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[197.485641] [059/134] (825s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[197.548971] Starting subtest: y-tiled-ccs-to-x-tiled
[197.552499] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[197.775299] [060/134] (825s left) gem_exec_balancer (bonded-false-hang)
[198.043066] Starting subtest: bonded-false-hang
[198.048092] Subtest bonded-false-hang: SKIP (0.000s)
[198.162220] [061/134] (825s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[203.183644] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[203.187958] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.003s)
[204.036132] [062/134] (819s left) gen7_exec_parse (basic-allowed)
[204.095296] Subtest basic-allowed: SKIP (0.000s)
[204.164585] [063/134] (819s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[204.255524] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[204.257736] Starting dynamic subtest: pipe-A-eDP-1
[204.278487] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[204.289060] Starting dynamic subtest: pipe-B-eDP-1
[204.308401] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[204.316893] Starting dynamic subtest: pipe-C-eDP-1
[204.336119] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[204.345221] Starting dynamic subtest: pipe-D-eDP-1
[204.364449] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[204.366741] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[206.510674] [064/134] (816s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[211.558982] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[211.563685] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.002s)
[212.461582] [065/134] (810s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[212.567500] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[212.572275] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[212.675863] [066/134] (810s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[212.777475] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[212.779752] Starting dynamic subtest: pipe-A-eDP-1
[212.938276] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.150s)
[212.948038] Starting dynamic subtest: pipe-B-eDP-1
[212.966930] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[212.977924] Starting dynamic subtest: pipe-C-eDP-1
[212.997376] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[213.006066] Starting dynamic subtest: pipe-D-eDP-1
[213.025592] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[213.027826] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.187s)
[215.317129] [067/134] (808s left) kms_flip (flip-vs-panning)
[215.418228] Starting subtest: flip-vs-panning
[215.420569] Starting dynamic subtest: A-eDP1
[224.114226] Dynamic subtest A-eDP1: SUCCESS (8.695s)
[224.125096] Starting dynamic subtest: B-eDP1
[232.859929] Dynamic subtest B-eDP1: SUCCESS (8.744s)
[232.869708] Starting dynamic subtest: C-eDP1
[241.572388] Dynamic subtest C-eDP1: SUCCESS (8.710s)
[241.583431] Starting dynamic subtest: D-eDP1
[250.302722] Dynamic subtest D-eDP1: SUCCESS (8.729s)
[250.306834] Subtest flip-vs-panning: SUCCESS (34.886s)
[251.482519] [068/134] (772s left) syncobj_eventfd (timeline-wait)
[251.538971] Starting subtest: timeline-wait
[251.547050] Subtest timeline-wait: SUCCESS (0.010s)
[251.669294] [069/134] (771s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[251.765428] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[251.769567] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[251.897752] [070/134] (771s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[251.987955] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[251.990246] Starting dynamic subtest: A-eDP1
[255.603698] Dynamic subtest A-eDP1: SUCCESS (3.611s)
[255.614376] Starting dynamic subtest: B-eDP1
[258.805855] Dynamic subtest B-eDP1: SUCCESS (3.201s)
[258.816533] Starting dynamic subtest: C-eDP1
[261.908782] Dynamic subtest C-eDP1: SUCCESS (3.102s)
[261.918459] Starting dynamic subtest: D-eDP1
[265.036107] Dynamic subtest D-eDP1: SUCCESS (3.126s)
[265.038614] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.049s)
[265.844484] [071/134] (757s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[265.956444] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[266.956978] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.000s)
[267.094262] [072/134] (756s left) gem_mmap_offset (oob-read)
[267.152782] Starting subtest: oob-read
[267.155217] Subtest oob-read: SUCCESS (0.000s)
[267.273791] [073/134] (756s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[267.383705] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[267.385746] Starting dynamic subtest: pipe-A-default-mode
[267.704469] Dynamic subtest pipe-A-default-mode: SKIP (0.319s)
[267.709005] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.321s)
[268.489763] [074/134] (755s left) gem_pxp (regular-baseline-src-copy-readible)
[268.613755] Starting subtest: regular-baseline-src-copy-readible
[268.671661] Subtest regular-baseline-src-copy-readible: SUCCESS (0.059s)
[268.803603] [075/134] (755s left) kms_3d (basic)
[268.861339] Starting subtest: basic
[270.825329] Subtest basic: SUCCESS (1.965s)
[271.350098] [076/134] (752s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[271.458069] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[271.462221] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[271.573610] [077/134] (752s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[271.669109] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[271.673489] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[271.788646] [078/134] (752s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[271.889573] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[271.894025] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[271.996139] [079/134] (752s left) gem_exec_schedule (fairslice-all)
[272.057919] Starting subtest: fairslice-all
[274.109692] Subtest fairslice-all: SUCCESS (2.055s)
[275.354093] [080/134] (748s left) kms_properties (plane-properties-atomic)
[275.439233] Starting subtest: plane-properties-atomic
[275.441606] Starting dynamic subtest: pipe-A-eDP-1
[275.994835] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.556s)
[276.005081] Starting dynamic subtest: pipe-B-eDP-1
[277.262297] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.266s)
[277.271535] Starting dynamic subtest: pipe-C-eDP-1
[278.556524] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.292s)
[278.565715] Starting dynamic subtest: pipe-D-eDP-1
[279.846846] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.289s)
[279.849356] Subtest plane-properties-atomic: SUCCESS (4.409s)
[280.718771] [081/134] (743s left) gem_cs_tlb (engines)
[280.790405] Starting subtest: engines
[280.792598] Starting dynamic subtest: rcs0
[282.946396] Dynamic subtest rcs0: SUCCESS (2.151s)
[282.959578] Starting dynamic subtest: bcs0
[285.098134] Dynamic subtest bcs0: SUCCESS (2.150s)
[285.107997] Starting dynamic subtest: vcs0
[287.250725] Dynamic subtest vcs0: SUCCESS (2.152s)
[287.260286] Starting dynamic subtest: vcs1
[289.404704] Dynamic subtest vcs1: SUCCESS (2.153s)
[289.414798] Starting dynamic subtest: vecs0
[291.557520] Dynamic subtest vecs0: SUCCESS (2.152s)
[291.568868] Starting dynamic subtest: ccs0
[293.712137] Dynamic subtest ccs0: SUCCESS (2.153s)
[293.714328] Subtest engines: SUCCESS (12.917s)
[293.872989] [082/134] (730s left) kms_scaling_modes (scaling-mode-none)
[293.969861] Starting subtest: scaling-mode-none
[293.971861] Starting dynamic subtest: pipe-A-eDP-1
[294.069604] Dynamic subtest pipe-A-eDP-1: SKIP (0.098s)
[294.079790] Starting dynamic subtest: pipe-B-eDP-1
[294.103226] Dynamic subtest pipe-B-eDP-1: SKIP (0.031s)
[294.112427] Starting dynamic subtest: pipe-C-eDP-1
[294.138939] Dynamic subtest pipe-C-eDP-1: SKIP (0.034s)
[294.157915] Starting dynamic subtest: pipe-D-eDP-1
[294.172974] Dynamic subtest pipe-D-eDP-1: SKIP (0.034s)
[294.177316] Subtest scaling-mode-none: SKIP (0.204s)
[294.306271] [083/134] (729s left) kms_psr (pr-sprite-render)
[294.403420] Starting subtest: pr-sprite-render
[294.407711] Subtest pr-sprite-render: SKIP (0.000s)
[294.494497] [084/134] (729s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-pwrite)
[294.597312] Starting subtest: fbc-abgr161616f-draw-pwrite
[294.601464] Subtest fbc-abgr161616f-draw-pwrite: SKIP (0.000s)
[294.715628] [085/134] (729s left) kms_flip (2x-flip-vs-expired-vblank)
[294.812763] Starting subtest: 2x-flip-vs-expired-vblank
[294.824302] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[294.963188] [086/134] (729s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[295.061558] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[295.065151] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[295.185572] [087/134] (729s left) kms_content_protection (srm)
[295.318866] Starting subtest: srm
[295.325015] Subtest srm: SKIP (0.002s)
[295.493098] [088/134] (728s left) gem_userptr_blits (process-exit-busy)
[295.568214] Starting subtest: process-exit-busy
[295.580229] Subtest process-exit-busy: SUCCESS (0.012s)
[295.724761] [089/134] (728s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[295.822275] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[295.825801] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[295.945748] [090/134] (728s left) kms_color (invalid-degamma-lut-sizes)
[296.042316] Starting subtest: invalid-degamma-lut-sizes
[296.044187] Starting dynamic subtest: pipe-A
[296.345686] Dynamic subtest pipe-A: SUCCESS (0.304s)
[296.355481] Starting dynamic subtest: pipe-B
[296.357752] Dynamic subtest pipe-B: SUCCESS (0.001s)
[296.366804] Starting dynamic subtest: pipe-C
[296.368952] Dynamic subtest pipe-C: SUCCESS (0.001s)
[296.378046] Starting dynamic subtest: pipe-D
[296.380282] Dynamic subtest pipe-D: SUCCESS (0.001s)
[296.382476] Subtest invalid-degamma-lut-sizes: SUCCESS (0.314s)
[297.219588] [091/134] (727s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[297.325427] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[297.329380] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[297.456344] [092/134] (727s left) kms_pipe_crc_basic (nonblocking-crc)
[297.560269] Starting subtest: nonblocking-crc
[297.562490] Starting dynamic subtest: pipe-A-eDP-1
[298.312224] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.752s)
[298.322120] Starting dynamic subtest: pipe-B-eDP-1
[299.707558] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.392s)
[299.717810] Starting dynamic subtest: pipe-C-eDP-1
[301.027612] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.321s)
[301.041010] Starting dynamic subtest: pipe-D-eDP-1
[302.429448] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.398s)
[302.431286] Subtest nonblocking-crc: SUCCESS (4.869s)
[303.330589] [093/134] (721s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[303.435475] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[304.226459] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.793s)
[304.432222] [094/134] (720s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[304.536231] Starting subtest: 4-tiled-8bpp-rotate-0
[305.772762] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.237s)
[305.941104] [095/134] (718s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[306.048281] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[306.051829] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[306.202200] [096/134] (718s left) gem_exec_schedule (u-semaphore-codependency)
[306.271292] Starting subtest: u-semaphore-codependency
[306.280054] Subtest u-semaphore-codependency: SUCCESS (0.014s)
[306.663369] [097/134] (718s left) syncobj_timeline (wait-any-snapshot)
[306.719554] Starting subtest: wait-any-snapshot
[306.799696] Subtest wait-any-snapshot: SUCCESS (0.081s)
[306.901164] [098/134] (717s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[306.964272] Subtest no-spare-fences-busy: SKIP (0.000s)
[307.032566] [099/134] (717s left) kms_dsc (dsc-with-output-formats-with-bpc)
[307.131948] Starting subtest: dsc-with-output-formats-with-bpc
[307.188412] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[307.231057] [100/134] (717s left) gem_userptr_blits (dmabuf-unsync)
[307.309845] Subtest dmabuf-unsync: SKIP (0.000s)
[307.434120] [101/134] (717s left) kms_prop_blob (blob-prop-core)
[307.490309] Starting subtest: blob-prop-core
[307.492673] Subtest blob-prop-core: SUCCESS (0.000s)
[307.608544] [102/134] (717s left) gem_exec_reloc (basic-gtt-cpu)
[307.680438] Subtest basic-gtt-cpu: SKIP (0.000s)
[307.760868] [103/134] (717s left) syncobj_timeline (invalid-query-bad-pad)
[307.817012] Starting subtest: invalid-query-bad-pad
[307.818886] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[307.925014] [104/134] (717s left) vgem_basic (dmabuf-export)
[307.967612] Starting subtest: dmabuf-export
[308.029530] Subtest dmabuf-export: SUCCESS (0.058s)
[308.146761] [105/134] (716s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-gtt)
[308.245259] Starting subtest: psr-abgr161616f-draw-mmap-gtt
[308.248621] Subtest psr-abgr161616f-draw-mmap-gtt: SKIP (0.000s)
[308.365523] [106/134] (716s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[308.471630] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[308.475191] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[308.605051] [107/134] (716s left) gem_gpgpu_fill (basic)
[308.672978] Starting subtest: basic
[308.675115] Starting dynamic subtest: smem
[308.679508] Dynamic subtest smem: SUCCESS (0.008s)
[308.681555] Subtest basic: SUCCESS (0.009s)
[308.851767] [108/134] (716s left) gem_mmap_gtt (basic-copy)
[308.909818] Subtest basic-copy: SKIP (0.000s)
[308.968068] [109/134] (716s left) gen9_exec_parse (batch-invalid-length)
[309.020087] Subtest batch-invalid-length: SKIP (0.000s)
[309.087674] [110/134] (716s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[309.179631] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[309.183327] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[309.284048] [111/134] (716s left) gem_tiled_wc
[309.401578] [112/134] (716s left) gem_exec_capture (userptr)
[309.461636] Starting subtest: userptr
[310.311214] Subtest userptr: SUCCESS (0.850s)
[310.469111] [113/134] (714s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[310.576537] Starting subtest: flip-vs-dpms-off-vs-modeset
[310.578892] Starting dynamic subtest: A-eDP1
[314.227014] Dynamic subtest A-eDP1: SUCCESS (3.649s)
[314.236494] Starting dynamic subtest: B-eDP1
[317.542859] Dynamic subtest B-eDP1: SUCCESS (3.315s)
[317.553678] Starting dynamic subtest: C-eDP1
[320.830556] Dynamic subtest C-eDP1: SUCCESS (3.285s)
[320.840931] Starting dynamic subtest: D-eDP1
[324.128587] Dynamic subtest D-eDP1: SUCCESS (3.296s)
[324.130876] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.553s)
[325.024687] [114/134] (700s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[325.135362] Starting subtest: fbc-rgb565-draw-pwrite
[329.732210] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.600s)
[330.923047] [115/134] (694s left) gem_exec_whisper (basic-contexts-forked-all)
[330.995574] Starting subtest: basic-contexts-forked-all
[351.120383] Subtest basic-contexts-forked-all: SUCCESS (20.122s)
[351.314469] [116/134] (674s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[351.460715] Starting subtest: cursorB-vs-flipB-atomic
[351.465454] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[351.632084] [117/134] (673s left) gem_pread (exhaustion)
[351.692207] Subtest exhaustion: SKIP (0.000s)
[351.758552] [118/134] (673s left) gem_ctx_persistence (heartbeat-hostile)
[351.819470] Starting subtest: heartbeat-hostile
[351.824247] Subtest heartbeat-hostile: SKIP (0.000s)
[351.946841] [119/134] (673s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[352.051127] Starting subtest: extended-pageflip-modeset-hang-oldfb
[352.053409] Starting dynamic subtest: pipe-A
[359.967070] Dynamic subtest pipe-A: SUCCESS (7.912s)
[359.977540] Starting dynamic subtest: pipe-D
[368.574080] Dynamic subtest pipe-D: SUCCESS (8.603s)
[368.576427] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.521s)
[369.407869] [120/134] (656s left) gem_sync (basic-store-each)
[369.484554] Starting subtest: basic-store-each
[371.865997] Subtest basic-store-each: SUCCESS (2.391s)
[372.064828] [121/134] (653s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[372.169507] Starting subtest: psr-shrfb-scaledprimary
[377.912603] Subtest psr-shrfb-scaledprimary: SUCCESS (5.744s)
[378.052891] [122/134] (647s left) dmabuf_sync_file (import-multiple-read-only)
[378.099877] Starting subtest: import-multiple-read-only
[378.102303] Subtest import-multiple-read-only: SUCCESS (0.003s)
[378.168656] [123/134] (647s left) kms_atomic_interruptible (universal-setplane-primary)
[378.254400] Starting subtest: universal-setplane-primary
[378.256731] Starting dynamic subtest: pipe-A-eDP-1
[385.703410] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.448s)
[385.705733] Subtest universal-setplane-primary: SUCCESS (7.449s)
[386.517781] [124/134] (639s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[386.630527] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[393.268606] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.640s)
[393.433329] [125/134] (632s left) kms_cursor_edge_walk (128x128-right-edge)
[393.538282] Starting subtest: 128x128-right-edge
[393.540387] Starting dynamic subtest: pipe-A-eDP-1
[397.030974] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.492s)
[397.045548] Starting dynamic subtest: pipe-D-eDP-1
[400.217268] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.185s)
[400.219550] Subtest 128x128-right-edge: SUCCESS (6.680s)
[401.031377] [126/134] (624s left) api_intel_allocator (two-level-inception)
[401.099460] Starting subtest: two-level-inception
[406.496831] Subtest two-level-inception: SUCCESS (5.398s)
[406.655706] [127/134] (619s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[406.761953] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[406.766436] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[406.917465] [128/134] (619s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[406.985448] Starting subtest: wait-all-for-submit-delayed-submit
[407.087025] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[407.182384] [129/134] (618s left) gem_exec_schedule (pi-ringfull)
[407.367120] Starting subtest: pi-ringfull
[407.369357] Starting dynamic subtest: rcs0
[407.418032] Dynamic subtest rcs0: SUCCESS (0.053s)
[407.429933] Starting dynamic subtest: bcs0
[407.470325] Dynamic subtest bcs0: SUCCESS (0.051s)
[407.481545] Starting dynamic subtest: vcs0
[407.515322] Dynamic subtest vcs0: SUCCESS (0.044s)
[407.526366] Starting dynamic subtest: vcs1
[407.555839] Dynamic subtest vcs1: SUCCESS (0.039s)
[407.570588] Starting dynamic subtest: vecs0
[407.587895] Dynamic subtest vecs0: SUCCESS (0.031s)
[407.597995] Starting dynamic subtest: ccs0
[407.620161] Dynamic subtest ccs0: SUCCESS (0.031s)
[407.622389] Subtest pi-ringfull: SUCCESS (0.256s)
[407.878615] [130/134] (618s left) kms_async_flips (crc-atomic)
[407.977102] Starting subtest: crc-atomic
[408.350310] Starting dynamic subtest: pipe-A-eDP-1
[411.282998] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.931s)
[411.668053] Starting dynamic subtest: pipe-B-eDP-1
[414.585746] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.926s)
[414.970235] Starting dynamic subtest: pipe-C-eDP-1
[417.853376] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.893s)
[418.229222] Starting dynamic subtest: pipe-D-eDP-1
[421.168401] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.950s)
[421.170730] Subtest crc-atomic: SUCCESS (13.193s)
[422.420868] [131/134] (603s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[427.483592] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[427.485865] Starting dynamic subtest: pipe-A-eDP-1
[433.947617] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.461s)
[433.960023] Starting dynamic subtest: pipe-B-eDP-1
[440.439107] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.491s)
[440.441734] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.957s)
[441.304892] [132/134] (584s left) i915_suspend (fence-restore-tiled2untiled)
[441.360125] Starting subtest: fence-restore-tiled2untiled
[441.364183] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[441.471029] [133/134] (584s left) prime_busy (after)
[441.533893] Starting subtest: after
[441.539348] Starting dynamic subtest: rcs0
[441.586657] Dynamic subtest rcs0: SUCCESS (0.050s)
[441.598411] Starting dynamic subtest: bcs0
[441.667475] Dynamic subtest bcs0: SUCCESS (0.080s)
[441.679938] Starting dynamic subtest: vcs0
[441.707263] Dynamic subtest vcs0: SUCCESS (0.039s)
[441.716955] Starting dynamic subtest: vcs1
[441.748248] Dynamic subtest vcs1: SUCCESS (0.040s)
[441.757814] Starting dynamic subtest: vecs0
[441.789663] Dynamic subtest vecs0: SUCCESS (0.041s)
[441.799274] Starting dynamic subtest: ccs0
[441.829985] Dynamic subtest ccs0: SUCCESS (0.040s)
[441.940039] Subtest after: SUCCESS (0.404s)
[442.025524] [134/134] (584s left) prime_mmap (test_refcounting)
[442.085093] Starting subtest: test_refcounting
[442.087216] Starting dynamic subtest: test_refcounting-smem
[442.114226] Dynamic subtest test_refcounting-smem: SUCCESS (0.030s)
[442.116715] Subtest test_refcounting: SUCCESS (0.031s)
[442.248367] Closing watchdogs
results: parsing output: 0/ for test: dumb_buffer
results: parsing output: 1/ for test: kms_cursor_crc
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: gem_workarounds
results: parsing output: 5/ for test: kms_dp_linktrain_fallback
results: parsing output: 6/ for test: gem_create
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_partial_pwrite_pread
results: parsing output: 10/ for test: api_intel_bb
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: gem_softpin
results: parsing output: 14/ for test: kms_pm_rpm
results: parsing output: 15/ for test: kms_plane_scaling
results: parsing output: 16/ for test: gem_ctx_persistence
results: parsing output: 17/ for test: kms_plane
results: parsing output: 18/ for test: i915_pm_rc6_residency
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_flip_scaled_crc
results: parsing output: 21/ for test: kms_chamelium_hpd
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_sequence
results: parsing output: 26/ for test: sysfs_timeslice_duration
results: parsing output: 27/ for test: perf
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: kms_rmfb
results: parsing output: 30/ for test: template
results: parsing output: 31/ for test: kms_plane
results: parsing output: 32/ for test: gem_ctx_shared
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: sw_sync
results: parsing output: 36/ for test: i915_drm_fdinfo
results: parsing output: 37/ for test: i915_module_load
results: parsing output: 38/ for test: gem_exec_suspend
results: parsing output: 39/ for test: gem_close
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: gem_exec_balancer
results: parsing output: 42/ for test: gem_exec_reloc
results: parsing output: 43/ for test: kms_invalid_mode
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: perf_pmu
results: parsing output: 48/ for test: kms_cursor_legacy
results: parsing output: 49/ for test: kms_plane_scaling
results: parsing output: 50/ for test: kms_vblank
results: parsing output: 51/ for test: gem_exec_fence
results: parsing output: 52/ for test: gem_basic
results: parsing output: 53/ for test: kms_chamelium_color
results: parsing output: 54/ for test: perf_pmu
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_lease
results: parsing output: 57/ for test: gem_lmem_swapping
results: parsing output: 58/ for test: gem_render_copy
results: parsing output: 59/ for test: gem_exec_balancer
results: parsing output: 60/ for test: kms_psr2_sf
results: parsing output: 61/ for test: gen7_exec_parse
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_psr2_sf
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: syncobj_eventfd
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: gem_mmap_offset
results: parsing output: 72/ for test: kms_flip_scaled_crc
results: parsing output: 73/ for test: gem_pxp
results: parsing output: 74/ for test: kms_3d
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: gem_exec_schedule
results: parsing output: 79/ for test: kms_properties
results: parsing output: 80/ for test: gem_cs_tlb
results: parsing output: 81/ for test: kms_scaling_modes
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_content_protection
results: parsing output: 87/ for test: gem_userptr_blits
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_color
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_pipe_crc_basic
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_exec_schedule
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: gem_fenced_exec_thrash
results: parsing output: 98/ for test: kms_dsc
results: parsing output: 99/ for test: gem_userptr_blits
results: parsing output: 100/ for test: kms_prop_blob
results: parsing output: 101/ for test: gem_exec_reloc
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: vgem_basic
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_gpgpu_fill
results: parsing output: 107/ for test: gem_mmap_gtt
results: parsing output: 108/ for test: gen9_exec_parse
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: gem_tiled_wc
results: parsing output: 111/ for test: gem_exec_capture
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_exec_whisper
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: gem_pread
results: parsing output: 117/ for test: gem_ctx_persistence
results: parsing output: 118/ for test: kms_busy
results: parsing output: 119/ for test: gem_sync
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: dmabuf_sync_file
results: parsing output: 122/ for test: kms_atomic_interruptible
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_cursor_edge_walk
results: parsing output: 125/ for test: api_intel_allocator
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: gem_exec_schedule
results: parsing output: 129/ for test: kms_async_flips
results: parsing output: 130/ for test: kms_psr2_sf
results: parsing output: 131/ for test: i915_suspend
results: parsing output: 132/ for test: prime_busy
results: parsing output: 133/ for test: prime_mmap
Done.