[58.691244] Initializing watchdogs
[58.691319]   /dev/watchdog0
[58.706445] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.711132] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.713336] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.716872] [001/133] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[58.840490] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[63.070960] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.245s)
[64.225898] [002/133] (955s left) gem_render_copy (linear-to-vebox-yf-tiled)
[64.290617] Starting subtest: linear-to-vebox-yf-tiled
[64.295657] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[64.468749] [003/133] (954s left) syncobj_timeline (invalid-signal-bad-pad)
[64.526898] Starting subtest: invalid-signal-bad-pad
[64.529174] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[64.607319] [004/133] (954s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[64.713069] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[64.717144] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[64.802035] [005/133] (954s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[64.897435] Starting subtest: async-flip-with-page-flip-events-tiled
[65.270811] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[68.089736] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.822s)
[68.097857] Starting dynamic subtest: pipe-A-eDP-1-4
[70.263077] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[70.273264] Starting dynamic subtest: pipe-A-eDP-1-4
[72.270349] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[72.279505] Starting dynamic subtest: pipe-A-eDP-1-x
[74.458942] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[74.822969] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[77.615037] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.799s)
[77.625581] Starting dynamic subtest: pipe-B-eDP-1-4
[79.800901] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.186s)
[79.811519] Starting dynamic subtest: pipe-B-eDP-1-4
[81.809721] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[81.817531] Starting dynamic subtest: pipe-B-eDP-1-x
[83.999949] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.190s)
[84.376580] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[87.146098] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.775s)
[87.154774] Starting dynamic subtest: pipe-C-eDP-1-4
[89.320433] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[89.330466] Starting dynamic subtest: pipe-C-eDP-1-4
[91.331377] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[91.339411] Starting dynamic subtest: pipe-C-eDP-1-x
[93.510051] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[93.872448] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[96.681050] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.814s)
[96.688865] Starting dynamic subtest: pipe-D-eDP-1-4
[98.854873] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[98.862568] Starting dynamic subtest: pipe-D-eDP-1-4
[100.865295] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[100.873064] Starting dynamic subtest: pipe-D-eDP-1-x
[103.055057] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.189s)
[103.057449] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.167s)
[104.265435] [006/133] (915s left) kms_flip (flip-vs-dpms-on-nop)
[104.360217] Starting subtest: flip-vs-dpms-on-nop
[104.362606] Starting dynamic subtest: A-eDP1
[106.266701] Dynamic subtest A-eDP1: SUCCESS (1.908s)
[106.276095] Starting dynamic subtest: B-eDP1
[108.104804] Dynamic subtest B-eDP1: SUCCESS (1.836s)
[108.116231] Starting dynamic subtest: C-eDP1
[109.931430] Dynamic subtest C-eDP1: SUCCESS (1.826s)
[109.941092] Starting dynamic subtest: D-eDP1
[111.765768] Dynamic subtest D-eDP1: SUCCESS (1.833s)
[111.770688] Subtest flip-vs-dpms-on-nop: SUCCESS (7.414s)
[112.935777] [007/133] (906s left) i915_drm_fdinfo (busy-hang)
[112.986646] Starting subtest: busy-hang
[112.988588] Starting dynamic subtest: rcs0
[113.013626] Dynamic subtest rcs0: SKIP (0.027s)
[113.023226] Starting dynamic subtest: bcs0
[113.027219] Dynamic subtest bcs0: SKIP (0.001s)
[113.034825] Starting dynamic subtest: vcs0
[113.039162] Dynamic subtest vcs0: SKIP (0.000s)
[113.046826] Starting dynamic subtest: vcs1
[113.050873] Dynamic subtest vcs1: SKIP (0.001s)
[113.057951] Starting dynamic subtest: vecs0
[113.062065] Dynamic subtest vecs0: SKIP (0.000s)
[113.069095] Starting dynamic subtest: ccs0
[113.073153] Dynamic subtest ccs0: SKIP (0.000s)
[113.077185] Subtest busy-hang: SKIP (0.031s)
[113.111252] [008/133] (906s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[113.204684] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[113.206946] Starting dynamic subtest: pipe-A-eDP-1
[113.226582] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[113.235633] Starting dynamic subtest: pipe-B-eDP-1
[113.254767] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[113.264609] Starting dynamic subtest: pipe-C-eDP-1
[113.283197] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[113.290531] Starting dynamic subtest: pipe-D-eDP-1
[113.309696] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[113.311621] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s)
[115.507423] [009/133] (904s left) dmabuf_sync_file (export-before-signal)
[115.607179] Starting subtest: export-before-signal
[115.609442] Subtest export-before-signal: SUCCESS (0.001s)
[115.661425] [FACT dmabuf_sync_file (export-before-signal)] new: kernel.kmod_is_loaded.vgem: true
[115.664899] [010/133] (903s left) gem_mmap_offset (partial-unmap)
[115.719019] Starting subtest: partial-unmap
[115.721069] Starting dynamic subtest: smem0
[116.227578] Dynamic subtest smem0: SUCCESS (0.509s)
[116.230456] Subtest partial-unmap: SUCCESS (0.509s)
[116.335062] [011/133] (903s left) kms_cursor_edge_walk (256x256-top-edge)
[116.432699] Starting subtest: 256x256-top-edge
[116.436403] Starting dynamic subtest: pipe-A-eDP-1
[119.921338] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.491s)
[119.930302] Starting dynamic subtest: pipe-D-eDP-1
[123.102342] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.181s)
[123.104754] Subtest 256x256-top-edge: SUCCESS (6.673s)
[123.932443] [012/133] (895s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[123.988774] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[124.043999] [013/133] (895s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[124.148100] Starting subtest: psr2-cursor-plane-update-sf
[124.150344] Starting dynamic subtest: pipe-A-eDP-1
[124.723905] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.578s)
[124.733658] Starting dynamic subtest: pipe-B-eDP-1
[126.016662] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.291s)
[126.019076] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.872s)
[126.876729] [014/133] (892s left) kms_hdr (invalid-metadata-sizes)
[126.967572] Starting subtest: invalid-metadata-sizes
[126.974072] Subtest invalid-metadata-sizes: SKIP (0.000s)
[127.052194] [015/133] (892s left) perf_pmu (init-wait)
[127.089042] Starting subtest: init-wait
[127.091392] Starting dynamic subtest: rcs0
[127.093879] Dynamic subtest rcs0: SUCCESS (0.002s)
[127.102022] Starting dynamic subtest: bcs0
[127.104197] Dynamic subtest bcs0: SUCCESS (0.000s)
[127.111771] Starting dynamic subtest: vcs0
[127.113962] Dynamic subtest vcs0: SUCCESS (0.001s)
[127.121420] Starting dynamic subtest: vcs1
[127.123612] Dynamic subtest vcs1: SUCCESS (0.001s)
[127.131290] Starting dynamic subtest: vecs0
[127.133134] Dynamic subtest vecs0: SUCCESS (0.001s)
[127.140170] Starting dynamic subtest: ccs0
[127.142400] Dynamic subtest ccs0: SUCCESS (0.000s)
[127.144553] Subtest init-wait: SUCCESS (0.006s)
[127.187938] [016/133] (892s left) perf (unprivileged-single-ctx-counters)
[127.318809] Starting subtest: unprivileged-single-ctx-counters
[127.322594] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[127.367177] [017/133] (892s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[127.473141] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[127.477555] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[127.570882] [018/133] (892s left) gem_exec_create (legacy)
[127.622562] Starting subtest: legacy
[127.624981] Starting dynamic subtest: smem
[130.905034] Dynamic subtest smem: SUCCESS (3.280s)
[130.907456] Subtest legacy: SUCCESS (3.281s)
[131.089500] [019/133] (888s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[131.203873] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[131.205878] Starting dynamic subtest: pipe-A
[131.540941] Dynamic subtest pipe-A: SUCCESS (0.339s)
[131.549737] Starting dynamic subtest: pipe-B
[133.010661] Dynamic subtest pipe-B: SUCCESS (1.469s)
[133.018484] Starting dynamic subtest: pipe-C
[134.407485] Dynamic subtest pipe-C: SUCCESS (1.396s)
[134.416805] Starting dynamic subtest: pipe-D
[135.851070] Dynamic subtest pipe-D: SUCCESS (1.443s)
[135.853420] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.649s)
[137.009232] [020/133] (882s left) kms_tiled_display (basic-test-pattern)
[137.116867] Subtest basic-test-pattern: SKIP (0.000s)
[137.163395] [021/133] (882s left) kms_flip (flip-vs-wf_vblank-interruptible)
[137.253718] Starting subtest: flip-vs-wf_vblank-interruptible
[137.256045] Starting dynamic subtest: A-eDP1
[139.155421] Dynamic subtest A-eDP1: SUCCESS (1.900s)
[139.165618] Starting dynamic subtest: B-eDP1
[141.094194] Dynamic subtest B-eDP1: SUCCESS (1.937s)
[141.107733] Starting dynamic subtest: C-eDP1
[143.012788] Dynamic subtest C-eDP1: SUCCESS (1.917s)
[143.021547] Starting dynamic subtest: D-eDP1
[144.937197] Dynamic subtest D-eDP1: SUCCESS (1.922s)
[144.942078] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.689s)
[146.182660] [022/133] (873s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[146.299050] Starting subtest: fbc-tiling-linear
[149.975777] Subtest fbc-tiling-linear: SUCCESS (3.681s)
[151.182151] [023/133] (868s left) gem_exec_balancer (busy)
[151.238641] Starting subtest: busy
[152.921210] Subtest busy: SUCCESS (1.681s)
[153.238640] [024/133] (866s left) i915_pm_rps (engine-order)
[153.291252] Starting subtest: engine-order
[159.818987] Subtest engine-order: SUCCESS (6.526s)
[159.961688] [025/133] (860s left) gem_userptr_blits (map-fixed-invalidate)
[160.043182] Starting subtest: map-fixed-invalidate
[160.047213] Subtest map-fixed-invalidate: SKIP (0.000s)
[160.142645] [026/133] (860s left) kms_addfb_basic (clobberred-modifier)
[160.194529] Starting subtest: clobberred-modifier
[160.200207] Subtest clobberred-modifier: SKIP (0.000s)
[160.334786] [027/133] (859s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[160.425775] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[160.427932] Starting dynamic subtest: pipe-A-eDP-1
[160.510988] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[160.519948] Starting dynamic subtest: pipe-B-eDP-1
[161.656290] Dynamic subtest pipe-B-eDP-1: SKIP (1.144s)
[161.660814] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.235s)
[162.930131] [028/133] (857s left) gem_exec_schedule (out-order)
[163.011164] Starting subtest: out-order
[163.013155] Starting dynamic subtest: rcs0
[163.114530] Dynamic subtest rcs0: SUCCESS (0.105s)
[163.126149] Starting dynamic subtest: vcs0
[163.197858] Dynamic subtest vcs0: SUCCESS (0.082s)
[163.208416] Starting dynamic subtest: vcs1
[163.292885] Dynamic subtest vcs1: SUCCESS (0.094s)
[163.306745] Starting dynamic subtest: vecs0
[163.386333] Dynamic subtest vecs0: SUCCESS (0.092s)
[163.397050] Starting dynamic subtest: ccs0
[163.488629] Dynamic subtest ccs0: SUCCESS (0.102s)
[163.491200] Subtest out-order: SUCCESS (0.482s)
[164.986310] [029/133] (855s left) kms_vrr (flip-basic-fastset)
[165.074280] Starting subtest: flip-basic-fastset
[165.080793] Subtest flip-basic-fastset: SKIP (0.000s)
[165.151224] [030/133] (855s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[165.240821] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[165.245138] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[166.357285] [031/133] (854s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[166.469060] Starting subtest: y-tiled-32bpp-rotate-0
[166.473258] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[166.576637] [032/133] (853s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[167.136790] Starting subtest: syncobj-timeline-invalid-wait
[167.139471] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.003s)
[169.009932] [033/133] (851s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[169.070400] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[169.075187] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[169.258863] [034/133] (851s left) gem_sync (basic-all)
[169.334717] Starting subtest: basic-all
[172.350288] Subtest basic-all: SUCCESS (3.025s)
[172.544340] [035/133] (848s left) syncobj_timeline (wait-all-delayed-signal)
[172.596877] Starting subtest: wait-all-delayed-signal
[172.701519] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[172.797765] [036/133] (847s left) kms_cursor_crc (cursor-offscreen-128x42)
[173.075925] Starting subtest: cursor-offscreen-128x42
[173.126841] Subtest cursor-offscreen-128x42: SKIP (0.045s)
[173.379767] [037/133] (847s left) i915_hangman (error-state-basic)
[173.441507] Starting subtest: error-state-basic
[173.608394] Subtest error-state-basic: SUCCESS (0.167s)
[173.698587] [038/133] (847s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[173.748077] Starting subtest: etime-single-wait-for-submit-submitted
[173.858499] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.109s)
[173.932364] [039/133] (846s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[174.321236] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[175.164625] [040/133] (845s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[175.255565] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[175.259372] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[175.357970] [041/133] (845s left) perf (gen12-oa-tlb-invalidate)
[175.459893] Starting subtest: gen12-oa-tlb-invalidate
[175.462459] Starting dynamic subtest: 0-rcs0
[185.499359] Dynamic subtest 0-rcs0: SUCCESS (10.037s)
[185.508625] Starting dynamic subtest: 1-vecs0
[195.549984] Dynamic subtest 1-vecs0: SUCCESS (10.050s)
[195.552349] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.088s)
[195.599864] [042/133] (825s left) gem_exec_reloc (basic-cpu-wc)
[195.655273] Subtest basic-cpu-wc: SKIP (0.000s)
[195.724116] [043/133] (825s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[195.830399] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[195.834797] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[195.920468] [044/133] (825s left) gem_mmap_gtt (basic-small-bo)
[195.982444] Subtest basic-small-bo: SKIP (0.000s)
[196.050766] [045/133] (824s left) gem_lmem_swapping (massive)
[196.095116] Subtest massive: SKIP (0.000s)
[196.139847] [046/133] (824s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[196.235265] Starting subtest: fbc-psr-sprite-mmap-gtt
[196.237147] Starting dynamic subtest: eDP-1
[196.241231] Dynamic subtest eDP-1: SKIP (0.000s)
[196.245304] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[196.307851] [047/133] (824s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[196.408427] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[196.412539] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[196.508842] [048/133] (824s left) kms_lease (lease-invalid-connector)
[196.615426] Starting subtest: lease-invalid-connector
[196.617367] Starting dynamic subtest: pipe-A-eDP-1
[196.619189] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[196.628342] Starting dynamic subtest: pipe-B-eDP-1
[196.630238] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[196.638940] Starting dynamic subtest: pipe-C-eDP-1
[196.641020] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[196.651798] Starting dynamic subtest: pipe-D-eDP-1
[196.653599] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[196.655385] Subtest lease-invalid-connector: SUCCESS (0.004s)
[196.691084] [049/133] (824s left) perf (create-destroy-userspace-config)
[196.788469] Starting subtest: create-destroy-userspace-config
[196.810473] Subtest create-destroy-userspace-config: SUCCESS (0.020s)
[196.856721] [050/133] (824s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[196.954030] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[196.955951] Starting dynamic subtest: pipe-A-eDP-1
[214.227975] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.723s)
[214.237820] Starting dynamic subtest: pipe-B-eDP-1
[232.183705] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.799s)
[232.194624] Starting dynamic subtest: pipe-C-eDP-1
[250.163524] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.752s)
[250.173648] Starting dynamic subtest: pipe-D-eDP-1
[268.161406] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.768s)
[268.163938] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (11.048s)
[274.402010] [051/133] (751s left) gem_spin_batch (engines)
[274.474274] Starting subtest: engines
[274.476675] Starting dynamic subtest: rcs0
[277.714676] Dynamic subtest rcs0: SUCCESS (3.270s)
[277.725917] Starting dynamic subtest: bcs0
[280.945442] Dynamic subtest bcs0: SUCCESS (3.257s)
[280.955596] Starting dynamic subtest: vcs0
[284.177510] Dynamic subtest vcs0: SUCCESS (3.248s)
[284.188610] Starting dynamic subtest: vcs1
[287.436571] Dynamic subtest vcs1: SUCCESS (3.244s)
[287.447810] Starting dynamic subtest: vecs0
[290.641026] Dynamic subtest vecs0: SUCCESS (3.238s)
[290.653060] Starting dynamic subtest: ccs0
[293.876185] Dynamic subtest ccs0: SUCCESS (3.239s)
[293.878664] Subtest engines: SUCCESS (19.511s)
[294.106022] [052/133] (732s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[294.201454] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[294.206615] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[294.277176] [053/133] (732s left) prime_self_import (basic-with_one_bo_two_files)
[294.312196] Starting subtest: basic-with_one_bo_two_files
[294.327783] Subtest basic-with_one_bo_two_files: SUCCESS (0.018s)
[294.435612] [054/133] (731s left) kms_flip (flip-vs-rmfb-interruptible)
[294.523595] Starting subtest: flip-vs-rmfb-interruptible
[294.526215] Starting dynamic subtest: A-eDP1
[303.155605] Dynamic subtest A-eDP1: SUCCESS (8.641s)
[303.168556] Starting dynamic subtest: B-eDP1
[311.781442] Dynamic subtest B-eDP1: SUCCESS (8.624s)
[311.791711] Starting dynamic subtest: C-eDP1
[320.435405] Dynamic subtest C-eDP1: SUCCESS (8.654s)
[320.448776] Starting dynamic subtest: D-eDP1
[329.066144] Dynamic subtest D-eDP1: SUCCESS (8.631s)
[329.071006] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.561s)
[330.216593] [055/133] (696s left) gem_mmap_gtt (cpuset-medium-copy)
[330.298384] Subtest cpuset-medium-copy: SKIP (0.000s)
[330.364167] [056/133] (696s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[330.466131] Starting subtest: fbcpsr-slowdraw
[355.647267] Subtest fbcpsr-slowdraw: SUCCESS (25.193s)
[355.822330] [057/133] (670s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[355.929708] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[355.934785] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[356.031606] [058/133] (670s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[356.128552] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[362.863310] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.741s)
[362.967293] [059/133] (663s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[363.061892] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[363.067415] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[363.171068] [060/133] (663s left) gem_wait (await)
[363.237800] Starting subtest: await
[363.240281] Starting dynamic subtest: all-engines
[364.316759] Dynamic subtest all-engines: SUCCESS (1.078s)
[364.334192] Starting dynamic subtest: rcs0
[365.377064] Dynamic subtest rcs0: SUCCESS (1.059s)
[365.394712] Starting dynamic subtest: bcs0
[366.438484] Dynamic subtest bcs0: SUCCESS (1.059s)
[366.456015] Starting dynamic subtest: vcs0
[367.498817] Dynamic subtest vcs0: SUCCESS (1.058s)
[367.514979] Starting dynamic subtest: vcs1
[368.555698] Dynamic subtest vcs1: SUCCESS (1.056s)
[368.574450] Starting dynamic subtest: vecs0
[369.617036] Dynamic subtest vecs0: SUCCESS (1.058s)
[369.634622] Starting dynamic subtest: ccs0
[370.678959] Dynamic subtest ccs0: SUCCESS (1.058s)
[370.681727] Subtest await: SUCCESS (7.443s)
[370.883910] [061/133] (655s left) kms_rotation_crc (bad-pixel-format)
[370.988608] Starting subtest: bad-pixel-format
[370.993723] Subtest bad-pixel-format: SKIP (0.001s)
[371.062973] [062/133] (655s left) syncobj_wait (multi-wait-submitted-signaled)
[371.117695] Starting subtest: multi-wait-submitted-signaled
[371.120270] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[371.231096] [063/133] (655s left) kms_color (degamma)
[371.324434] Starting subtest: degamma
[371.326762] Starting dynamic subtest: pipe-A-eDP-1
[372.066714] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.743s)
[372.077029] Starting dynamic subtest: pipe-B-eDP-1
[373.563934] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.495s)
[373.574287] Starting dynamic subtest: pipe-C-eDP-1
[374.995698] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.429s)
[375.005698] Starting dynamic subtest: pipe-D-eDP-1
[376.434358] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.436s)
[376.436641] Subtest degamma: SUCCESS (5.106s)
[377.313429] [064/133] (649s left) syncobj_timeline (wait-for-submit-snapshot)
[377.365446] Starting subtest: wait-for-submit-snapshot
[377.447775] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[377.531850] [065/133] (649s left) prime_mmap (test_correct)
[377.595446] Starting subtest: test_correct
[377.598118] Starting dynamic subtest: test_correct-smem
[377.632695] Dynamic subtest test_correct-smem: SUCCESS (0.037s)
[377.635586] Subtest test_correct: SUCCESS (0.038s)
[377.736215] [066/133] (649s left) gem_exec_flush (basic-uc-set-default)
[377.815002] Starting subtest: basic-uc-set-default
[383.282159] Subtest basic-uc-set-default: SUCCESS (5.459s)
[383.470413] [067/133] (643s left) kms_dsc (dsc-fractional-bpp)
[383.572667] Starting subtest: dsc-fractional-bpp
[383.588482] Subtest dsc-fractional-bpp: SKIP (0.000s)
[383.647175] [068/133] (643s left) gem_flink_basic (bad-flink)
[383.700655] Starting subtest: bad-flink
[383.703098] Subtest bad-flink: SUCCESS (0.000s)
[383.803374] [069/133] (643s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[383.902444] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[388.640935] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.742s)
[389.791097] [070/133] (637s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[389.884075] Starting subtest: fbc-psr2-primary-mmap-cpu
[389.886669] Starting dynamic subtest: eDP-1
[389.891459] Dynamic subtest eDP-1: SKIP (0.000s)
[389.896259] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[389.973318] [071/133] (637s left) gem_fence_thrash (bo-write-verify-threaded-y)
[390.015810] Starting subtest: bo-write-verify-threaded-y
[390.030607] Subtest bo-write-verify-threaded-y: SKIP (0.013s)
[390.091377] [072/133] (637s left) kms_fbcon_fbt (psr-suspend)
[390.145027] Starting subtest: psr-suspend
[441.014216] Subtest psr-suspend: SUCCESS (20.618s)
[443.099991] [073/133] (586s left) kms_flip (basic-flip-vs-modeset)
[443.210695] Starting subtest: basic-flip-vs-modeset
[443.215530] Starting dynamic subtest: A-eDP1
[445.858329] Dynamic subtest A-eDP1: SUCCESS (2.658s)
[445.868946] Starting dynamic subtest: B-eDP1
[448.097748] Dynamic subtest B-eDP1: SUCCESS (2.250s)
[448.111042] Starting dynamic subtest: C-eDP1
[450.269689] Dynamic subtest C-eDP1: SUCCESS (2.179s)
[450.280702] Starting dynamic subtest: D-eDP1
[452.424368] Dynamic subtest D-eDP1: SUCCESS (2.160s)
[452.427116] Subtest basic-flip-vs-modeset: SUCCESS (9.257s)
[453.231257] [074/133] (576s left) gem_mmap_wc (invalid-flags)
[453.286023] Subtest invalid-flags: SKIP (0.000s)
[453.345833] [075/133] (576s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[453.437994] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[453.442181] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[453.514969] [076/133] (575s left) kms_chamelium_edid (dp-edid-resolution-list)
[453.891862] Subtest dp-edid-resolution-list: SKIP (0.000s)
[454.737600] [077/133] (574s left) prime_busy (hang)
[454.801238] Starting subtest: hang
[454.803660] Starting dynamic subtest: rcs0
[480.941091] Dynamic subtest rcs0: SUCCESS (26.153s)
[480.952033] Starting dynamic subtest: bcs0
[488.033310] Dynamic subtest bcs0: SUCCESS (7.091s)
[488.042985] Starting dynamic subtest: vcs0
[495.067617] Dynamic subtest vcs0: SUCCESS (7.038s)
[495.079868] Starting dynamic subtest: vcs1
[502.041904] Dynamic subtest vcs1: SUCCESS (6.975s)
[502.054465] Starting dynamic subtest: vecs0
[509.019200] Dynamic subtest vecs0: SUCCESS (6.978s)
[509.031114] Starting dynamic subtest: ccs0
[522.919449] Dynamic subtest ccs0: SUCCESS (13.904s)
[522.922435] Subtest hang: SUCCESS (68.146s)
[523.044753] [078/133] (506s left) gem_exec_alignment (pi)
[523.116150] Starting subtest: pi
[574.628721] Subtest pi: SUCCESS (51.504s)
[575.744611] [079/133] (453s left) gen3_render_linear_blits
[575.912777] [080/133] (453s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[576.010304] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[576.012554] Starting dynamic subtest: pipe-A
[576.031927] Dynamic subtest pipe-A: SKIP (0.018s)
[576.043083] Starting dynamic subtest: pipe-B
[576.066899] Dynamic subtest pipe-B: SKIP (0.033s)
[576.077192] Starting dynamic subtest: pipe-C
[576.098512] Dynamic subtest pipe-C: SKIP (0.031s)
[576.109357] Starting dynamic subtest: pipe-D
[576.129434] Dynamic subtest pipe-D: SKIP (0.031s)
[576.133559] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.117s)
[576.238923] [081/133] (453s left) gem_mmap_offset (pf-nonblock)
[576.288307] Starting subtest: pf-nonblock
[576.292967] Subtest pf-nonblock: SUCCESS (0.006s)
[576.427850] [082/133] (453s left) syncobj_wait (reset-unsignaled)
[576.487990] Starting subtest: reset-unsignaled
[576.490057] Subtest reset-unsignaled: SUCCESS (0.000s)
[576.580221] [083/133] (453s left) kms_pm_rpm (dpms-non-lpsp)
[578.527340] Starting subtest: dpms-non-lpsp
[578.532419] Subtest dpms-non-lpsp: SKIP (0.001s)
[578.899247] [084/133] (450s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[579.007273] Starting subtest: x-tiled-16bpp-rotate-90
[579.026427] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s)
[579.141763] [085/133] (450s left) kms_psr (pr-primary-page-flip)
[579.234099] Starting subtest: pr-primary-page-flip
[579.238490] Subtest pr-primary-page-flip: SKIP (0.000s)
[579.317169] [086/133] (450s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[579.409006] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[579.413066] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[579.506966] [087/133] (450s left) syncobj_eventfd (timeline-wait-before-signal)
[579.570472] Starting subtest: timeline-wait-before-signal
[579.600680] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[579.680054] [088/133] (450s left) kms_debugfs (display-on-read-all)
[579.784988] Starting subtest: display-on-read-all
[579.949693] Subtest display-on-read-all: SUCCESS (0.168s)
[580.087281] [089/133] (449s left) api_intel_bb (render-ccs)
[580.147370] Starting subtest: render-ccs
[580.513682] Subtest render-ccs: SUCCESS (0.366s)
[580.607038] [090/133] (449s left) gem_ctx_freq (sysfs)
[580.664557] Starting subtest: sysfs
[580.666949] Starting dynamic subtest: gt0
[586.169486] Dynamic subtest gt0: SUCCESS (5.507s)
[586.183632] Starting dynamic subtest: gt1
[627.409802] Dynamic subtest gt1: SUCCESS (41.245s)
[627.412851] Subtest sysfs: SUCCESS (46.755s)
[627.529702] [091/133] (402s left) kms_atomic (test-only)
[627.628370] Starting subtest: test-only
[627.673712] Starting dynamic subtest: pipe-A-eDP-1
[630.177828] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.503s)
[630.180220] Subtest test-only: SUCCESS (2.550s)
[630.974459] [092/133] (399s left) i915_pm_rps (thresholds-idle)
[631.052207] Starting subtest: thresholds-idle
[631.057047] Subtest thresholds-idle: SKIP (0.000s)
[631.170741] [093/133] (399s left) gem_busy (parallel)
[631.353219] Starting subtest: parallel
[631.355358] Starting dynamic subtest: rcs0
[633.426470] Dynamic subtest rcs0: SUCCESS (2.073s)
[633.439380] Starting dynamic subtest: bcs0
[635.411267] Dynamic subtest bcs0: SUCCESS (1.982s)
[635.424816] Starting dynamic subtest: vcs0
[637.394403] Dynamic subtest vcs0: SUCCESS (1.981s)
[637.407409] Starting dynamic subtest: vcs1
[639.379268] Dynamic subtest vcs1: SUCCESS (1.982s)
[639.392487] Starting dynamic subtest: vecs0
[641.426854] Dynamic subtest vecs0: SUCCESS (2.045s)
[641.440196] Starting dynamic subtest: ccs0
[643.411257] Dynamic subtest ccs0: SUCCESS (1.982s)
[643.414340] Subtest parallel: SUCCESS (12.062s)
[643.635168] [094/133] (386s left) kms_cursor_crc (cursor-size-hints)
[643.778014] Starting subtest: cursor-size-hints
[643.780329] Starting dynamic subtest: pipe-A-eDP-1
[644.387573] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.608s)
[644.397778] Starting dynamic subtest: pipe-D-eDP-1
[645.642882] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.254s)
[645.645358] Subtest cursor-size-hints: SUCCESS (1.865s)
[646.436202] [095/133] (383s left) gem_exec_reloc (basic-wc)
[646.507177] Subtest basic-wc: SKIP (0.000s)
[646.587458] [096/133] (383s left) gem_mmap_gtt (basic-read-write)
[646.644713] Subtest basic-read-write: SKIP (0.000s)
[646.707291] [097/133] (383s left) kms_rotation_crc (sprite-rotation-270)
[646.798858] Starting subtest: sprite-rotation-270
[646.803052] Subtest sprite-rotation-270: SKIP (0.001s)
[646.871505] [098/133] (383s left) kms_content_protection (atomic-hdcp14)
[647.019527] Starting subtest: atomic-hdcp14
[647.024081] Subtest atomic-hdcp14: SKIP (0.000s)
[647.144731] [099/133] (383s left) kms_flip (flip-vs-fences-interruptible)
[647.244716] Starting subtest: flip-vs-fences-interruptible
[647.248831] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[647.364614] [100/133] (383s left) kms_scaling_modes (scaling-mode-full)
[647.453610] Starting subtest: scaling-mode-full
[647.455487] Starting dynamic subtest: pipe-A-eDP-1
[647.545529] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.093s)
[647.555910] Starting dynamic subtest: pipe-B-eDP-1
[648.763736] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.217s)
[648.777207] Starting dynamic subtest: pipe-C-eDP-1
[649.894029] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.128s)
[649.904800] Starting dynamic subtest: pipe-D-eDP-1
[651.023506] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[651.025809] Subtest scaling-mode-full: SUCCESS (3.573s)
[652.186677] [101/133] (378s left) perf (enable-disable)
[652.291994] Starting subtest: enable-disable
[652.294262] Starting dynamic subtest: 0-rcs0
[654.574448] Dynamic subtest 0-rcs0: SUCCESS (2.280s)
[654.585563] Starting dynamic subtest: 1-vcs1
[659.082225] Dynamic subtest 1-vcs1: SUCCESS (4.510s)
[659.085038] Subtest enable-disable: SUCCESS (6.792s)
[659.135425] [102/133] (371s left) gem_exec_whisper (basic-contexts-forked-all)
[659.199380] Starting subtest: basic-contexts-forked-all
[679.448429] Subtest basic-contexts-forked-all: SUCCESS (20.243s)
[679.636662] [103/133] (350s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[679.736207] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[679.738436] Starting dynamic subtest: pipe-A-eDP-1
[679.809953] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[679.821810] Starting dynamic subtest: pipe-B-eDP-1
[680.968049] Dynamic subtest pipe-B-eDP-1: SKIP (1.155s)
[680.972859] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.236s)
[682.163895] [104/133] (348s left) api_intel_allocator (gem-pool)
[682.217878] Starting subtest: gem-pool
[682.223494] Subtest gem-pool: SUCCESS (0.008s)
[682.319539] [105/133] (348s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[682.434857] Starting subtest: cursorA-vs-flipB-atomic
[682.439403] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[682.624060] [106/133] (348s left) gen7_exec_parse (basic-offset)
[682.700968] Subtest basic-offset: SKIP (0.000s)
[682.774520] [107/133] (348s left) kms_invalid_mode (bad-vsync-start)
[682.872705] Starting subtest: bad-vsync-start
[682.874958] Starting dynamic subtest: pipe-A-eDP-1
[683.158224] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[683.169329] Starting dynamic subtest: pipe-B-eDP-1
[683.171682] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[683.181952] Starting dynamic subtest: pipe-C-eDP-1
[683.184026] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[683.194124] Starting dynamic subtest: pipe-D-eDP-1
[683.196259] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[683.198403] Subtest bad-vsync-start: SUCCESS (0.293s)
[683.992007] [108/133] (346s left) gem_exec_params (readonly)
[684.060170] Starting subtest: readonly
[684.065049] Subtest readonly: SUCCESS (0.002s)
[684.192098] [109/133] (346s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[684.294904] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[684.908202] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.615s)
[685.071987] [110/133] (345s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[685.171214] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[685.173382] Starting dynamic subtest: pipe-A-eDP-1
[685.193201] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[685.204065] Starting dynamic subtest: pipe-B-eDP-1
[685.223082] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[685.234493] Starting dynamic subtest: pipe-C-eDP-1
[685.253706] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[685.265004] Starting dynamic subtest: pipe-D-eDP-1
[685.284430] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[685.286309] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[687.472232] [111/133] (343s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[687.574270] Starting subtest: fbc-shrfb-scaledprimary
[690.531323] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.959s)
[691.672863] [112/133] (339s left) kms_cdclk (mode-transition)
[691.762654] Starting subtest: mode-transition
[691.765054] Starting dynamic subtest: pipe-A-eDP-1
[692.056189] Dynamic subtest pipe-A-eDP-1: SKIP (0.291s)
[692.067589] Starting dynamic subtest: pipe-B-eDP-1
[692.072284] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[692.082816] Starting dynamic subtest: pipe-C-eDP-1
[692.087623] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[692.098284] Starting dynamic subtest: pipe-D-eDP-1
[692.102616] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[692.106964] Subtest mode-transition: SKIP (0.298s)
[692.867987] [113/133] (338s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[692.974530] Starting subtest: 4-tiled-8bpp-rotate-0
[694.188909] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.215s)
[694.304445] [114/133] (336s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[694.380284] Starting subtest: map-fixed-invalidate-overlap
[694.384099] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[694.508823] [115/133] (336s left) kms_psr (psr2-cursor-mmap-gtt)
[694.598556] Starting subtest: psr2-cursor-mmap-gtt
[694.600425] Starting dynamic subtest: eDP-1
[696.356466] Dynamic subtest eDP-1: SUCCESS (1.755s)
[696.359147] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.757s)
[697.241727] [116/133] (334s left) kms_pm_rpm (i2c)
[699.576419] Starting subtest: i2c
[704.936592] Subtest i2c: SUCCESS (5.363s)
[705.065602] [117/133] (326s left) kms_plane_alpha_blend (alpha-7efc)
[705.157199] Starting subtest: alpha-7efc
[705.443873] Starting dynamic subtest: pipe-A-eDP-1
[706.058822] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.614s)
[706.101010] Starting dynamic subtest: pipe-D-eDP-1
[707.349346] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.265s)
[707.351421] Subtest alpha-7efc: SUCCESS (2.190s)
[708.218077] [118/133] (323s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[708.311540] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[708.315544] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[708.385394] [119/133] (322s left) gem_create (create-ext-set-pat)
[708.557284] Starting subtest: create-ext-set-pat
[708.559969] Subtest create-ext-set-pat: SUCCESS (0.001s)
[708.659535] [120/133] (322s left) gem_ctx_persistence (legacy-engines-mixed)
[708.729346] Starting subtest: legacy-engines-mixed
[708.732109] Starting dynamic subtest: render
[708.810996] Dynamic subtest render: SUCCESS (0.081s)
[708.825515] Starting dynamic subtest: bsd1
[708.859846] Dynamic subtest bsd1: SUCCESS (0.045s)
[708.871361] Starting dynamic subtest: bsd2
[708.914315] Dynamic subtest bsd2: SUCCESS (0.052s)
[708.927972] Starting dynamic subtest: blt
[708.974161] Dynamic subtest blt: SUCCESS (0.057s)
[708.987341] Starting dynamic subtest: vebox
[709.035585] Dynamic subtest vebox: SUCCESS (0.058s)
[709.038453] Subtest legacy-engines-mixed: SUCCESS (0.307s)
[709.135192] [121/133] (322s left) gem_exec_flush (basic-batch-kernel-default-uc)
[709.203062] Starting subtest: basic-batch-kernel-default-uc
[716.336228] Subtest basic-batch-kernel-default-uc: SUCCESS (7.130s)
[716.540526] [122/133] (314s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[716.638017] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[716.642160] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[716.752981] [123/133] (314s left) kms_big_fb (linear-32bpp-rotate-0)
[716.845426] Starting subtest: linear-32bpp-rotate-0
[718.337088] Subtest linear-32bpp-rotate-0: SUCCESS (1.493s)
[718.502361] [124/133] (313s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[718.569550] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[718.649970] [125/133] (312s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[718.739190] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[718.742758] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[718.835216] [126/133] (312s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[718.953694] Starting subtest: flip-vs-cursor-atomic
[726.444458] Subtest flip-vs-cursor-atomic: SUCCESS (7.489s)
[727.247520] [127/133] (304s left) syncobj_timeline (reset-during-wait-for-submit)
[727.304988] Starting subtest: reset-during-wait-for-submit
[727.406643] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[727.501239] [128/133] (304s left) i915_query (query-topology-kernel-writes)
[727.553629] Starting subtest: query-topology-kernel-writes
[727.555574] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[727.665996] [129/133] (304s left) gem_exec_schedule (submit-early-slice)
[727.751965] Starting subtest: submit-early-slice
[727.754503] Starting dynamic subtest: rcs0
[727.794069] Dynamic subtest rcs0: SUCCESS (0.042s)
[727.805797] Starting dynamic subtest: bcs0
[727.832394] Dynamic subtest bcs0: SUCCESS (0.038s)
[727.843166] Starting dynamic subtest: vcs0
[727.874911] Dynamic subtest vcs0: SUCCESS (0.042s)
[727.885796] Starting dynamic subtest: vcs1
[727.911013] Dynamic subtest vcs1: SUCCESS (0.034s)
[727.924528] Starting dynamic subtest: vecs0
[727.945597] Dynamic subtest vecs0: SUCCESS (0.035s)
[727.958447] Starting dynamic subtest: ccs0
[727.982637] Dynamic subtest ccs0: SUCCESS (0.035s)
[727.984970] Subtest submit-early-slice: SUCCESS (0.231s)
[729.463029] [130/133] (302s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[729.581843] Starting subtest: short-flip-before-cursor-atomic-transitions
[730.531494] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.948s)
[731.391711] [131/133] (300s left) gem_unfence_active_buffers
[731.548603] [132/133] (300s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[731.644539] Starting subtest: fbc-farfromfence-mmap-gtt
[731.648956] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[731.744269] [133/133] (300s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[731.843047] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[738.508980] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.668s)
[738.644876] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_render_copy
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_async_flips
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: i915_drm_fdinfo
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: dmabuf_sync_file
results: parsing output: 9/ for test: gem_mmap_offset
results: parsing output: 10/ for test: kms_cursor_edge_walk
results: parsing output: 11/ for test: kms_pipe_b_c_ivb
results: parsing output: 12/ for test: kms_psr2_sf
results: parsing output: 13/ for test: kms_hdr
results: parsing output: 14/ for test: perf_pmu
results: parsing output: 15/ for test: perf
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: gem_exec_create
results: parsing output: 18/ for test: kms_plane_scaling
results: parsing output: 19/ for test: kms_tiled_display
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_exec_balancer
results: parsing output: 23/ for test: i915_pm_rps
results: parsing output: 24/ for test: gem_userptr_blits
results: parsing output: 25/ for test: kms_addfb_basic
results: parsing output: 26/ for test: kms_psr2_sf
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: kms_vrr
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: gem_exec_fence
results: parsing output: 32/ for test: gem_render_copy
results: parsing output: 33/ for test: gem_sync
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_cursor_crc
results: parsing output: 36/ for test: i915_hangman
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: kms_chamelium_hpd
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: perf
results: parsing output: 41/ for test: gem_exec_reloc
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_mmap_gtt
results: parsing output: 44/ for test: gem_lmem_swapping
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_lease
results: parsing output: 48/ for test: perf
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: gem_spin_batch
results: parsing output: 51/ for test: kms_plane
results: parsing output: 52/ for test: prime_self_import
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: gem_mmap_gtt
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_wait
results: parsing output: 60/ for test: kms_rotation_crc
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: kms_color
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: prime_mmap
results: parsing output: 65/ for test: gem_exec_flush
results: parsing output: 66/ for test: kms_dsc
results: parsing output: 67/ for test: gem_flink_basic
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: gem_fence_thrash
results: parsing output: 71/ for test: kms_fbcon_fbt
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: gem_mmap_wc
results: parsing output: 74/ for test: kms_flip_scaled_crc
results: parsing output: 75/ for test: kms_chamelium_edid
results: parsing output: 76/ for test: prime_busy
results: parsing output: 77/ for test: gem_exec_alignment
results: parsing output: 78/ for test: gen3_render_linear_blits
results: parsing output: 79/ for test: kms_plane_scaling
results: parsing output: 80/ for test: gem_mmap_offset
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: kms_pm_rpm
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: syncobj_eventfd
results: parsing output: 87/ for test: kms_debugfs
results: parsing output: 88/ for test: api_intel_bb
results: parsing output: 89/ for test: gem_ctx_freq
results: parsing output: 90/ for test: kms_atomic
results: parsing output: 91/ for test: i915_pm_rps
results: parsing output: 92/ for test: gem_busy
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: gem_mmap_gtt
results: parsing output: 96/ for test: kms_rotation_crc
results: parsing output: 97/ for test: kms_content_protection
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: kms_scaling_modes
results: parsing output: 100/ for test: perf
results: parsing output: 101/ for test: gem_exec_whisper
results: parsing output: 102/ for test: kms_psr2_sf
results: parsing output: 103/ for test: api_intel_allocator
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: gen7_exec_parse
results: parsing output: 106/ for test: kms_invalid_mode
results: parsing output: 107/ for test: gem_exec_params
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_cdclk
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: gem_userptr_blits
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_pm_rpm
results: parsing output: 116/ for test: kms_plane_alpha_blend
results: parsing output: 117/ for test: kms_plane
results: parsing output: 118/ for test: gem_create
results: parsing output: 119/ for test: gem_ctx_persistence
results: parsing output: 120/ for test: gem_exec_flush
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: gem_exec_reloc
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_cursor_legacy
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: i915_query
results: parsing output: 128/ for test: gem_exec_schedule
results: parsing output: 129/ for test: kms_cursor_legacy
results: parsing output: 130/ for test: gem_unfence_active_buffers
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.