[58.364799] Initializing watchdogs
[58.364847]   /dev/watchdog0
[58.379979] [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.384526] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.386940] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.390382] [001/133] (960s left) syncobj_timeline (invalid-query-illegal-handle)
[58.477561] Starting subtest: invalid-query-illegal-handle
[58.480038] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[58.583322] [002/133] (960s left) gem_lmem_swapping (smem-oom)
[58.625401] Subtest smem-oom: SKIP (0.000s)
[58.673135] [003/133] (960s left) prime_mmap (test_invalid_sync_flags)
[58.724967] Starting subtest: test_invalid_sync_flags
[58.727363] Starting dynamic subtest: test_invalid_sync_flags-smem
[58.729539] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[58.731839] Subtest test_invalid_sync_flags: SUCCESS (0.000s)
[58.822428] [004/133] (960s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[58.915717] Starting subtest: psr-rgb565-draw-blt
[65.947942] Subtest psr-rgb565-draw-blt: SUCCESS (7.030s)
[66.034150] [005/133] (953s left) gem_userptr_blits (probe)
[66.116461] Starting subtest: probe
[66.201603] Subtest probe: SUCCESS (0.085s)
[66.314981] [006/133] (952s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[66.440763] Starting subtest: cursorB-vs-flipA-atomic-transitions
[66.445551] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[66.599191] [007/133] (952s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[66.818457] Starting subtest: cursor-rapid-movement-128x128
[66.823385] Starting dynamic subtest: pipe-A-eDP-1
[67.435000] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.609s)
[67.468890] Starting dynamic subtest: pipe-D-eDP-1
[68.679133] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.216s)
[68.681195] Subtest cursor-rapid-movement-128x128: SUCCESS (1.857s)
[69.520210] [008/133] (949s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[69.626769] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[76.720783] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.096s)
[76.831241] [009/133] (942s left) kms_color (invalid-gamma-lut-sizes)
[76.930607] Starting subtest: invalid-gamma-lut-sizes
[76.932901] Starting dynamic subtest: pipe-A
[77.222790] Dynamic subtest pipe-A: SUCCESS (0.293s)
[77.232757] Starting dynamic subtest: pipe-B
[77.235845] Dynamic subtest pipe-B: SUCCESS (0.000s)
[77.243666] Starting dynamic subtest: pipe-C
[77.246806] Dynamic subtest pipe-C: SUCCESS (0.000s)
[77.254258] Starting dynamic subtest: pipe-D
[77.256480] Dynamic subtest pipe-D: SUCCESS (0.000s)
[77.258374] Subtest invalid-gamma-lut-sizes: SUCCESS (0.295s)
[78.078697] [010/133] (941s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[78.172969] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[78.175190] Starting dynamic subtest: pipe-A-eDP-1
[78.326774] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.147s)
[78.334655] Starting dynamic subtest: pipe-B-eDP-1
[78.354660] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[78.364911] Starting dynamic subtest: pipe-C-eDP-1
[78.385340] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[78.392563] Starting dynamic subtest: pipe-D-eDP-1
[78.412067] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[78.413923] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.183s)
[80.628855] [011/133] (938s left) perf_pmu (multi-client)
[80.668949] Starting subtest: multi-client
[80.671320] Starting dynamic subtest: rcs0
[81.728787] Dynamic subtest rcs0: SUCCESS (1.058s)
[81.738139] Starting dynamic subtest: bcs0
[82.779061] Dynamic subtest bcs0: SUCCESS (1.049s)
[82.789325] Starting dynamic subtest: vcs0
[83.826807] Dynamic subtest vcs0: SUCCESS (1.049s)
[83.837500] Starting dynamic subtest: vcs1
[84.943147] Dynamic subtest vcs1: SUCCESS (1.113s)
[84.953092] Starting dynamic subtest: vecs0
[86.930092] Dynamic subtest vecs0: SUCCESS (1.985s)
[86.940124] Starting dynamic subtest: ccs0
[88.911844] Dynamic subtest ccs0: SUCCESS (1.982s)
[88.914481] Subtest multi-client: SUCCESS (8.242s)
[89.025056] [012/133] (930s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[89.122958] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[89.125294] Starting dynamic subtest: pipe-A-eDP-1
[89.145769] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[89.155345] Starting dynamic subtest: pipe-B-eDP-1
[89.174904] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[89.182796] Starting dynamic subtest: pipe-C-eDP-1
[89.202286] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[89.210162] Starting dynamic subtest: pipe-D-eDP-1
[89.229490] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[89.231685] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[91.378896] [013/133] (927s left) gem_exec_capture (capture)
[91.444308] Starting subtest: capture
[91.446608] Starting dynamic subtest: rcs0-smem
[92.257801] Dynamic subtest rcs0-smem: SUCCESS (0.812s)
[92.268040] Starting dynamic subtest: bcs0-smem
[93.151789] Dynamic subtest bcs0-smem: SUCCESS (0.894s)
[93.159920] Starting dynamic subtest: vcs0-smem
[93.963288] Dynamic subtest vcs0-smem: SUCCESS (0.808s)
[93.971181] Starting dynamic subtest: vcs1-smem
[94.768014] Dynamic subtest vcs1-smem: SUCCESS (0.805s)
[94.778281] Starting dynamic subtest: vecs0-smem
[96.164319] Dynamic subtest vecs0-smem: FAIL (1.340s)
[96.173875] Starting dynamic subtest: ccs0-smem
[97.422127] Dynamic subtest ccs0-smem: SUCCESS (1.315s)
[97.424341] Subtest capture: FAIL (5.977s)
[97.542468] [014/133] (921s left) syncobj_timeline (single-wait-all-available-submitted)
[97.598751] Starting subtest: single-wait-all-available-submitted
[97.601087] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[97.705369] [015/133] (921s left) gem_workarounds (reset-fd)
[97.773121] Starting subtest: reset-fd
[97.935672] Subtest reset-fd: SUCCESS (0.163s)
[98.073881] [016/133] (921s left) gem_busy (extended)
[98.263043] Starting subtest: extended
[98.265710] Starting dynamic subtest: rcs0
[98.366936] Dynamic subtest rcs0: SUCCESS (0.104s)
[98.378082] Starting dynamic subtest: bcs0
[98.410968] Dynamic subtest bcs0: SUCCESS (0.043s)
[98.421027] Starting dynamic subtest: vcs0
[99.929049] Dynamic subtest vcs0: SUCCESS (1.515s)
[99.940687] Starting dynamic subtest: vcs1
[101.913339] Dynamic subtest vcs1: SUCCESS (1.983s)
[101.924678] Starting dynamic subtest: vecs0
[103.897489] Dynamic subtest vecs0: SUCCESS (1.983s)
[103.908491] Starting dynamic subtest: ccs0
[103.941835] Dynamic subtest ccs0: SUCCESS (0.045s)
[103.944192] Subtest extended: SUCCESS (5.680s)
[104.210280] [017/133] (915s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[104.276537] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[104.281178] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[104.476576] [018/133] (915s left) kms_plane_cursor (overlay)
[104.579936] Starting subtest: overlay
[104.584686] Starting dynamic subtest: pipe-A-eDP-1-size-64
[107.197587] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.618s)
[107.257630] Starting dynamic subtest: pipe-A-eDP-1-size-128
[109.876410] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.627s)
[109.935188] Starting dynamic subtest: pipe-A-eDP-1-size-256
[112.610363] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.683s)
[112.962583] Starting dynamic subtest: pipe-B-eDP-1-size-64
[116.228067] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.279s)
[116.288895] Starting dynamic subtest: pipe-B-eDP-1-size-128
[118.863030] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.582s)
[118.923359] Starting dynamic subtest: pipe-B-eDP-1-size-256
[121.485971] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.571s)
[121.835272] Starting dynamic subtest: pipe-C-eDP-1-size-64
[124.718453] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.895s)
[124.754957] Starting dynamic subtest: pipe-C-eDP-1-size-128
[126.952509] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.203s)
[126.990147] Starting dynamic subtest: pipe-C-eDP-1-size-256
[129.407191] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.425s)
[129.739090] Starting dynamic subtest: pipe-D-eDP-1-size-64
[132.687192] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.960s)
[132.726711] Starting dynamic subtest: pipe-D-eDP-1-size-128
[134.909888] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.192s)
[134.947728] Starting dynamic subtest: pipe-D-eDP-1-size-256
[137.188177] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.247s)
[137.510921] Subtest overlay: SUCCESS (32.932s)
[138.302937] [019/133] (881s left) gem_ctx_exec (basic-norecovery)
[138.358202] Starting subtest: basic-norecovery
[138.709156] Subtest basic-norecovery: SUCCESS (0.351s)
[138.824157] [020/133] (880s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[138.889597] Starting subtest: x-tiled-to-vebox-yf-tiled
[138.893974] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[139.070556] [021/133] (880s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[139.167495] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[139.171859] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[139.238290] [022/133] (880s left) kms_big_fb (linear-32bpp-rotate-90)
[139.338176] Starting subtest: linear-32bpp-rotate-90
[139.357420] Subtest linear-32bpp-rotate-90: SKIP (0.019s)
[139.471068] [023/133] (880s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[139.565763] Starting subtest: yf-tiled-16bpp-rotate-270
[139.570270] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[139.663814] [024/133] (880s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[139.795401] Starting subtest: basic-busy-flip-before-cursor-legacy
[139.799889] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[139.944227] [025/133] (879s left) kms_chamelium_color (ctm-blue-to-red)
[140.038977] Subtest ctm-blue-to-red: SKIP (0.000s)
[140.082602] [026/133] (879s left) gem_ctx_shared (q-smoketest)
[140.146439] Starting subtest: Q-smoketest
[140.148505] Starting dynamic subtest: rcs0
[145.749436] Dynamic subtest rcs0: SUCCESS (5.497s)
[145.759545] Starting dynamic subtest: bcs0
[151.241354] Dynamic subtest bcs0: SUCCESS (5.491s)
[151.251732] Starting dynamic subtest: vcs0
[156.728262] Dynamic subtest vcs0: SUCCESS (5.486s)
[156.739432] Starting dynamic subtest: vcs1
[162.215645] Dynamic subtest vcs1: SUCCESS (5.480s)
[162.225862] Starting dynamic subtest: vecs0
[167.696913] Dynamic subtest vecs0: SUCCESS (5.484s)
[167.709926] Starting dynamic subtest: ccs0
[173.131339] Dynamic subtest ccs0: SUCCESS (5.482s)
[173.133734] Subtest Q-smoketest: SUCCESS (32.929s)
[173.272914] [027/133] (846s left) gem_ctx_create (basic)
[173.331272] Starting subtest: basic
[173.333607] Subtest basic: SUCCESS (0.000s)
[173.517497] [028/133] (846s left) kms_psr (psr-suspend)
[173.612122] Starting subtest: psr-suspend
[173.614507] Starting dynamic subtest: eDP-1
[191.454253] Dynamic subtest eDP-1: SUCCESS (2.960s)
[191.456465] Subtest psr-suspend: SUCCESS (2.961s)
[192.327592] [029/133] (827s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[192.447577] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[199.384606] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.892s)
[199.507880] [030/133] (820s left) kms_atomic_interruptible (universal-setplane-primary)
[199.607901] Starting subtest: universal-setplane-primary
[199.610173] Starting dynamic subtest: pipe-A-eDP-1
[207.026707] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.396s)
[207.028840] Subtest universal-setplane-primary: SUCCESS (7.397s)
[207.887419] [031/133] (812s left) gem_exec_schedule (preempt-engines)
[207.953623] Starting subtest: preempt-engines
[207.955964] Starting dynamic subtest: rcs0
[210.263018] Dynamic subtest rcs0: SUCCESS (2.257s)
[210.275696] Starting dynamic subtest: bcs0
[212.490334] Dynamic subtest bcs0: SUCCESS (2.224s)
[212.502531] Starting dynamic subtest: vcs0
[214.762463] Dynamic subtest vcs0: SUCCESS (2.268s)
[214.773569] Starting dynamic subtest: vcs1
[217.052702] Dynamic subtest vcs1: SUCCESS (2.286s)
[217.065631] Starting dynamic subtest: vecs0
[219.324535] Dynamic subtest vecs0: SUCCESS (2.268s)
[219.335606] Starting dynamic subtest: ccs0
[221.634853] Dynamic subtest ccs0: SUCCESS (2.307s)
[221.638165] Subtest preempt-engines: SUCCESS (13.621s)
[221.886040] [032/133] (798s left) perf_pmu (rc6)
[221.932094] Starting subtest: rc6
[221.934245] Starting dynamic subtest: gt0
[228.356692] Dynamic subtest gt0: SUCCESS (6.368s)
[228.368882] Starting dynamic subtest: runtime-pm-gt0
[236.096175] Dynamic subtest runtime-pm-gt0: SUCCESS (7.785s)
[236.106473] Starting dynamic subtest: runtime-pm-long-gt0
[248.623419] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.519s)
[248.633592] Starting dynamic subtest: other-idle-gt0
[254.970191] Dynamic subtest other-idle-gt0: SUCCESS (6.340s)
[254.981165] Starting dynamic subtest: gt1
[261.313949] Dynamic subtest gt1: SUCCESS (6.339s)
[261.325901] Starting dynamic subtest: runtime-pm-gt1
[268.819730] Dynamic subtest runtime-pm-gt1: SUCCESS (7.499s)
[268.831620] Starting dynamic subtest: runtime-pm-long-gt1
[281.317389] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.489s)
[281.329278] Starting dynamic subtest: other-idle-gt1
[287.715626] Dynamic subtest other-idle-gt1: SUCCESS (6.341s)
[287.718101] Subtest rc6: SUCCESS (65.700s)
[288.784656] [033/133] (731s left) kms_joiner (invalid-modeset-force-big-joiner)
[288.910095] Starting subtest: invalid-modeset-force-big-joiner
[288.914322] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[288.954657] [034/133] (731s left) perf (global-sseu-config)
[289.046212] Starting subtest: global-sseu-config
[289.049693] Subtest global-sseu-config: SKIP (0.000s)
[289.095524] [035/133] (731s left) gem_mmap_gtt (basic-small-copy-xy)
[289.153014] Subtest basic-small-copy-XY: SKIP (0.000s)
[289.223136] [036/133] (731s left) gem_exec_reloc (basic-write-read)
[289.283439] Subtest basic-write-read: SKIP (0.000s)
[289.355582] [037/133] (730s left) kms_flip (flip-vs-rmfb-interruptible)
[289.444729] Starting subtest: flip-vs-rmfb-interruptible
[289.446513] Starting dynamic subtest: A-eDP1
[298.100930] Dynamic subtest A-eDP1: SUCCESS (8.663s)
[298.113693] Starting dynamic subtest: B-eDP1
[306.722221] Dynamic subtest B-eDP1: SUCCESS (8.623s)
[306.732161] Starting dynamic subtest: C-eDP1
[315.367709] Dynamic subtest C-eDP1: SUCCESS (8.647s)
[315.380600] Starting dynamic subtest: D-eDP1
[324.002889] Dynamic subtest D-eDP1: SUCCESS (8.635s)
[324.007248] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.581s)
[325.139961] [038/133] (695s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[325.212253] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[325.291385] [039/133] (695s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[325.397241] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[325.401359] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[325.482156] [040/133] (694s left) gem_eio (in-flight-internal-1us)
[325.702165] Starting subtest: in-flight-internal-1us
[326.850140] Subtest in-flight-internal-1us: SUCCESS (1.147s)
[326.970344] [041/133] (693s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[327.070853] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[327.072976] Starting dynamic subtest: pipe-A-eDP-1
[327.094865] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[327.106578] Starting dynamic subtest: pipe-B-eDP-1
[327.126780] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[327.135774] Starting dynamic subtest: pipe-C-eDP-1
[327.156419] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[327.165668] Starting dynamic subtest: pipe-D-eDP-1
[327.188008] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[327.192584] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[329.306121] [042/133] (691s left) gem_create (create-ext-cpu-access-sanity-check)
[329.468017] Starting subtest: create-ext-cpu-access-sanity-check
[329.473039] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[329.524240] [043/133] (691s left) gem_ctx_create (basic-files)
[329.590244] Starting subtest: basic-files
[331.602077] Subtest basic-files: SUCCESS (2.012s)
[332.824066] [044/133] (687s left) kms_sequence (queue-idle)
[332.923658] Starting subtest: queue-idle
[332.925895] Starting dynamic subtest: pipe-A-eDP-1
[334.715675] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.794s)
[334.725726] Starting dynamic subtest: pipe-B-eDP-1
[337.210224] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.494s)
[337.220285] Starting dynamic subtest: pipe-C-eDP-1
[339.725580] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.512s)
[339.738331] Starting dynamic subtest: pipe-D-eDP-1
[342.160804] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.434s)
[342.163158] Subtest queue-idle: SUCCESS (9.239s)
[342.976339] [045/133] (677s left) prime_mmap (test_map_unmap)
[343.045726] Starting subtest: test_map_unmap
[343.048075] Starting dynamic subtest: test_map_unmap-smem
[343.079014] Dynamic subtest test_map_unmap-smem: SUCCESS (0.036s)
[343.081432] Subtest test_map_unmap: SUCCESS (0.037s)
[343.160465] [046/133] (677s left) core_setmaster_vs_auth
[343.289483] [047/133] (677s left) dumb_buffer (create-clear)
[343.343952] Starting subtest: create-clear
[377.323285] Subtest create-clear: SUCCESS (33.920s)
[377.364627] [048/133] (643s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[377.476435] Starting subtest: fbc-rgb101010-draw-blt
[382.066707] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.590s)
[383.149129] [049/133] (637s left) gem_exec_whisper (basic-sync-all)
[383.216405] Starting subtest: basic-sync-all
[390.564269] Subtest basic-sync-all: SUCCESS (7.343s)
[390.724052] [050/133] (630s left) syncobj_timeline (wait-for-submit-snapshot)
[390.783444] Starting subtest: wait-for-submit-snapshot
[390.865675] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[390.919985] [051/133] (630s left) kms_psr (fbc-psr-primary-page-flip)
[391.029050] Starting subtest: fbc-psr-primary-page-flip
[391.031402] Starting dynamic subtest: eDP-1
[391.035819] Dynamic subtest eDP-1: SKIP (0.000s)
[391.040220] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[391.082201] [052/133] (629s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[391.659043] Starting subtest: syncobj-timeline-multiple-ext-nodes
[391.661186] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[392.889910] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[392.893320] [053/133] (628s left) gem_render_copy (y-tiled-ccs-to-linear)
[392.944011] Starting subtest: y-tiled-ccs-to-linear
[392.948222] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[393.104132] [054/133] (627s left) gem_exec_reloc (basic-wc-active)
[393.157330] Subtest basic-wc-active: SKIP (0.000s)
[393.247195] [055/133] (627s left) kms_plane (plane-position-hole)
[393.360141] Starting subtest: plane-position-hole
[393.897121] Starting dynamic subtest: pipe-A-plane-1
[395.142507] Dynamic subtest pipe-A-plane-1: SUCCESS (1.247s)
[395.153025] Starting dynamic subtest: pipe-A-plane-2
[396.374479] Dynamic subtest pipe-A-plane-2: SUCCESS (1.230s)
[396.385436] Starting dynamic subtest: pipe-A-plane-3
[397.620053] Dynamic subtest pipe-A-plane-3: SUCCESS (1.246s)
[397.631274] Starting dynamic subtest: pipe-A-plane-4
[398.891316] Dynamic subtest pipe-A-plane-4: SUCCESS (1.268s)
[398.902096] Starting dynamic subtest: pipe-A-plane-5
[398.914933] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[400.131057] Starting dynamic subtest: pipe-B-plane-1
[401.484979] Dynamic subtest pipe-B-plane-1: SUCCESS (1.361s)
[401.495297] Starting dynamic subtest: pipe-B-plane-2
[402.801058] Dynamic subtest pipe-B-plane-2: SUCCESS (1.313s)
[402.811708] Starting dynamic subtest: pipe-B-plane-3
[404.128432] Dynamic subtest pipe-B-plane-3: SUCCESS (1.326s)
[404.139096] Starting dynamic subtest: pipe-B-plane-4
[405.436360] Dynamic subtest pipe-B-plane-4: SUCCESS (1.309s)
[405.447795] Starting dynamic subtest: pipe-B-plane-5
[405.463709] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[405.465861] Subtest plane-position-hole: SUCCESS (12.100s)
[406.217940] [056/133] (614s left) gem_mmap_wc (write)
[406.284750] Subtest write: SKIP (0.000s)
[406.348963] [057/133] (614s left) gem_ctx_persistence (heartbeat-many)
[406.400038] Starting subtest: heartbeat-many
[406.404638] Subtest heartbeat-many: SKIP (0.000s)
[406.472590] [058/133] (614s left) gem_exec_schedule (reorder-wide)
[406.659690] Subtest reorder-wide: SKIP (0.000s)
[406.815483] [059/133] (614s left) i915_query (query-topology-coherent-slice-mask)
[406.874490] Starting subtest: query-topology-coherent-slice-mask
[406.879068] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[406.952958] [060/133] (614s left) kms_lease (lease-get)
[407.051628] Starting subtest: lease-get
[407.053937] Starting dynamic subtest: pipe-A-eDP-1
[407.056031] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[407.066451] Starting dynamic subtest: pipe-B-eDP-1
[407.068550] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[407.078840] Starting dynamic subtest: pipe-C-eDP-1
[407.080952] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[407.090494] Starting dynamic subtest: pipe-D-eDP-1
[407.092711] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[407.094837] Subtest lease-get: SUCCESS (0.012s)
[407.153182] [061/133] (614s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[407.212402] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[407.287213] [062/133] (614s left) syncobj_eventfd (binary-wait-signaled)
[407.338225] Starting subtest: binary-wait-signaled
[407.340181] Subtest binary-wait-signaled: SUCCESS (0.000s)
[407.412877] [063/133] (614s left) kms_vblank (query-forked-busy-hang)
[407.509072] Starting subtest: query-forked-busy-hang
[407.511282] Starting dynamic subtest: pipe-A-eDP-1
[433.523629] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.018s)
[433.539192] Starting dynamic subtest: pipe-D-eDP-1
[448.575570] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.051s)
[448.577983] Subtest query-forked-busy-hang: SUCCESS (41.074s)
[449.379588] [064/133] (572s left) i915_pm_rps (min-max-config-loaded)
[449.441584] Starting subtest: min-max-config-loaded
[449.446091] Subtest min-max-config-loaded: SKIP (0.001s)
[449.495114] [065/133] (572s left) gem_readwrite (read-bad-handle)
[449.550169] Subtest read-bad-handle: SKIP (0.000s)
[449.611196] [066/133] (571s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[449.734894] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[449.739277] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[449.857168] [067/133] (571s left) kms_addfb_basic (basic)
[449.907630] Starting subtest: basic
[449.909948] Subtest basic: SUCCESS (0.000s)
[450.019821] [068/133] (571s left) kms_cursor_crc (cursor-onscreen-64x21)
[450.211513] Starting subtest: cursor-onscreen-64x21
[450.258934] Subtest cursor-onscreen-64x21: SKIP (0.043s)
[450.588958] [069/133] (571s left) gem_close_race (basic-process)
[450.682354] Starting subtest: basic-process
[450.726002] Subtest basic-process: SUCCESS (0.046s)
[450.894579] [070/133] (570s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[450.991423] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[450.995581] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[451.073406] [071/133] (570s left) gem_mmap_wc (write-wc-read-gtt)
[451.131715] Subtest write-wc-read-gtt: SKIP (0.000s)
[451.199779] [072/133] (570s left) kms_pm_rpm (modeset-pc8-residency-stress)
[452.927004] Starting subtest: modeset-pc8-residency-stress
[452.932134] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[453.428177] [073/133] (568s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[453.525053] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[453.529732] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[453.594425] [074/133] (568s left) i915_query (engine-info-invalid)
[453.648155] Starting subtest: engine-info-invalid
[453.650327] Subtest engine-info-invalid: SUCCESS (0.000s)
[453.737659] [075/133] (568s left) kms_content_protection (srm)
[453.868347] Starting subtest: srm
[453.875837] Subtest srm: SKIP (0.003s)
[453.980072] [076/133] (568s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[454.073961] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[454.099500] Starting dynamic subtest: pipe-A-plane-0
[454.387862] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[454.399871] Starting dynamic subtest: pipe-A-plane-3
[454.621123] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[454.633297] Starting dynamic subtest: pipe-A-plane-5
[454.637029] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[455.727871] Starting dynamic subtest: pipe-B-plane-0
[456.030470] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[456.040453] Starting dynamic subtest: pipe-B-plane-3
[456.275193] Dynamic subtest pipe-B-plane-3: SUCCESS (0.243s)
[456.285465] Starting dynamic subtest: pipe-B-plane-5
[456.289881] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[456.582923] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.511s)
[457.377084] [077/133] (564s left) kms_panel_fitting (legacy)
[457.473034] Starting subtest: legacy
[457.475402] Starting dynamic subtest: pipe-A-eDP-1
[458.038223] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.567s)
[458.067294] Starting dynamic subtest: pipe-B-eDP-1
[459.683101] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.626s)
[459.711599] Starting dynamic subtest: pipe-C-eDP-1
[461.247566] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.545s)
[461.274438] Starting dynamic subtest: pipe-D-eDP-1
[462.798568] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.530s)
[462.800934] Subtest legacy: SUCCESS (5.326s)
[464.001609] [078/133] (558s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[464.102413] Starting subtest: pr-primary-plane-update-sf-dmg-area
[464.106450] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[464.152912] [079/133] (557s left) kms_pm_backlight (bad-brightness)
[464.240771] Starting subtest: bad-brightness
[464.292835] Starting dynamic subtest: eDP-1
[464.601580] Dynamic subtest eDP-1: SUCCESS (0.309s)
[464.604218] Subtest bad-brightness: SUCCESS (0.360s)
[465.426010] [080/133] (556s left) kms_cursor_legacy (forked-bo)
[465.548798] Starting subtest: forked-bo
[465.550657] Starting dynamic subtest: pipe-A
[471.067307] Dynamic subtest pipe-A: SUCCESS (5.454s)
[471.079217] Starting dynamic subtest: pipe-B
[476.559027] Dynamic subtest pipe-B: SUCCESS (5.499s)
[476.570580] Starting dynamic subtest: pipe-C
[482.045447] Dynamic subtest pipe-C: SUCCESS (5.484s)
[482.057521] Starting dynamic subtest: pipe-D
[487.511813] Dynamic subtest pipe-D: SUCCESS (5.463s)
[487.534428] Starting dynamic subtest: all-pipes
[493.049462] Dynamic subtest all-pipes: SUCCESS (5.536s)
[493.051860] Subtest forked-bo: SUCCESS (27.447s)
[493.127514] [081/133] (529s left) kms_flip (dpms-vs-vblank-race)
[493.236146] Starting subtest: dpms-vs-vblank-race
[493.238637] Starting dynamic subtest: A-eDP1
[498.234592] Dynamic subtest A-eDP1: SUCCESS (4.995s)
[498.245452] Starting dynamic subtest: B-eDP1
[502.862030] Dynamic subtest B-eDP1: SUCCESS (4.624s)
[502.874897] Starting dynamic subtest: C-eDP1
[506.444212] Dynamic subtest C-eDP1: SUCCESS (3.582s)
[506.454693] Starting dynamic subtest: D-eDP1
[509.954093] Dynamic subtest D-eDP1: SUCCESS (3.510s)
[509.956361] Subtest dpms-vs-vblank-race: SUCCESS (16.720s)
[510.810069] [082/133] (511s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[510.924329] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[510.928459] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[510.999216] [083/133] (511s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[511.112163] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[511.116393] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[511.182907] [084/133] (511s left) gem_exec_balancer (bonded-false-hang)
[511.441322] Starting subtest: bonded-false-hang
[511.446761] Subtest bonded-false-hang: SKIP (0.000s)
[511.522519] [085/133] (510s left) api_intel_allocator (default-alignment)
[511.575370] Starting subtest: default-alignment
[511.577821] Subtest default-alignment: SUCCESS (0.003s)
[511.673324] [086/133] (510s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[511.782194] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[511.786702] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[511.860257] [087/133] (510s left) gem_exec_params (larger-than-life-batch)
[511.925403] Starting subtest: larger-than-life-batch
[514.325619] Subtest larger-than-life-batch: SUCCESS (2.398s)
[514.849426] [088/133] (507s left) gem_userptr_blits (readonly-unsync)
[514.974390] Subtest readonly-unsync: SKIP (0.000s)
[515.062113] [089/133] (507s left) kms_psr (pr-cursor-plane-onoff)
[515.168487] Starting subtest: pr-cursor-plane-onoff
[515.172825] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[515.218931] [090/133] (507s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[515.327338] Starting subtest: short-flip-after-cursor-atomic-transitions
[516.328158] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.999s)
[517.153268] [091/133] (505s left) i915_fb_tiling (basic-x-tiling)
[517.210025] Subtest basic-x-tiling: SKIP (0.000s)
[517.280219] [092/133] (505s left) kms_chamelium_frames (dp-crc-multiple)
[517.658283] Subtest dp-crc-multiple: SKIP (0.000s)
[518.473099] [093/133] (504s left) gem_mmap_gtt (isolation)
[518.532691] Subtest isolation: SKIP (0.000s)
[518.595546] [094/133] (504s left) gen9_exec_parse (allowed-all)
[518.668662] Subtest allowed-all: SKIP (0.000s)
[518.760980] [095/133] (504s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[518.818389] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[518.820681] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[518.873269] [096/133] (504s left) kms_psr (fbc-psr2-cursor-render)
[518.966818] Starting subtest: fbc-psr2-cursor-render
[518.969168] Starting dynamic subtest: eDP-1
[518.973635] Dynamic subtest eDP-1: SKIP (0.000s)
[518.978091] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[519.019182] [097/133] (503s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[519.116982] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[519.121170] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[519.207630] [098/133] (503s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[519.317638] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[519.986933] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.670s)
[520.139497] [099/133] (502s left) kms_psr2_su (page_flip-p010)
[520.205397] Subtest page_flip-P010: SKIP (0.000s)
[520.266312] [100/133] (502s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[520.357894] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[524.570521] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.216s)
[525.685642] [101/133] (497s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[525.778540] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[525.782952] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[525.852275] [102/133] (497s left) sw_sync (sync_expired_merge)
[525.890209] Starting subtest: sync_expired_merge
[526.964710] Subtest sync_expired_merge: SUCCESS (1.074s)
[527.005356] [103/133] (496s left) gem_eio (unwedge-stress)
[527.238838] Starting subtest: unwedge-stress
[527.241070] Starting dynamic subtest: render
[532.259748] Dynamic subtest render: SUCCESS (5.017s)
[532.277704] Starting dynamic subtest: bsd1
[564.261908] Dynamic subtest bsd1: SUCCESS (31.996s)
[564.280096] Starting dynamic subtest: bsd2
[591.857181] Dynamic subtest bsd2: SUCCESS (27.587s)
[591.873351] Starting dynamic subtest: blt
[591.877898] Dynamic subtest blt: SKIP (0.000s)
[591.887308] Starting dynamic subtest: vebox
[615.867728] Dynamic subtest vebox: SUCCESS (24.004s)
[615.869701] Subtest unwedge-stress: SUCCESS (88.610s)
[617.742230] [104/133] (405s left) gem_partial_pwrite_pread (write)
[617.801376] Subtest write: SKIP (0.000s)
[617.877413] [105/133] (405s left) gem_spin_batch (resubmit-new-all)
[617.932608] Starting subtest: resubmit-new-all
[617.935100] Starting dynamic subtest: rcs0
[617.946435] Dynamic subtest rcs0: SUCCESS (0.014s)
[617.958972] Starting dynamic subtest: bcs0
[617.960886] Dynamic subtest bcs0: SUCCESS (0.009s)
[617.971682] Starting dynamic subtest: vcs0
[617.973890] Dynamic subtest vcs0: SUCCESS (0.011s)
[617.986814] Starting dynamic subtest: vcs1
[617.988615] Dynamic subtest vcs1: SUCCESS (0.014s)
[617.998719] Starting dynamic subtest: vecs0
[618.000809] Dynamic subtest vecs0: SUCCESS (0.009s)
[618.010761] Starting dynamic subtest: ccs0
[618.012614] Dynamic subtest ccs0: SUCCESS (0.010s)
[618.014421] Subtest resubmit-new-all: SUCCESS (0.073s)
[619.791539] [106/133] (403s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[620.185956] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[621.012497] [107/133] (402s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[621.121968] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[621.126044] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[621.186956] [108/133] (402s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[621.284976] Starting subtest: x-tiled-8bpp-rotate-270
[621.306107] Subtest x-tiled-8bpp-rotate-270: SKIP (0.020s)
[621.401313] [109/133] (402s left) gen9_exec_parse (shadow-peek)
[621.454342] Subtest shadow-peek: SKIP (0.000s)
[621.516106] [110/133] (401s left) kms_flip (blocking-absolute-wf_vblank)
[621.598029] Starting subtest: blocking-absolute-wf_vblank
[621.600424] Starting dynamic subtest: A-eDP1
[630.302372] Dynamic subtest A-eDP1: SUCCESS (8.701s)
[630.322337] Starting dynamic subtest: B-eDP1
[639.066605] Dynamic subtest B-eDP1: SUCCESS (8.724s)
[639.080795] Starting dynamic subtest: C-eDP1
[647.795986] Dynamic subtest C-eDP1: SUCCESS (8.714s)
[647.807963] Starting dynamic subtest: D-eDP1
[656.536715] Dynamic subtest D-eDP1: SUCCESS (8.732s)
[656.539582] Subtest blocking-absolute-wf_vblank: SUCCESS (34.887s)
[657.721587] [111/133] (365s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[657.821450] Starting subtest: psr-1p-primscrn-spr-indfb-move
[665.509866] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.690s)
[665.638664] [112/133] (357s left) api_intel_bb (intel-bb-blit-y)
[665.704076] Starting subtest: intel-bb-blit-y
[669.683887] Subtest intel-bb-blit-y: SUCCESS (3.978s)
[669.774027] [113/133] (353s left) kms_force_connector_basic (force-load-detect)
[669.868725] Starting subtest: force-load-detect
[669.873138] Subtest force-load-detect: SKIP (0.000s)
[669.961856] [114/133] (353s left) kms_psr (psr2-primary-render)
[670.052551] Starting subtest: psr2-primary-render
[670.054833] Starting dynamic subtest: eDP-1
[671.805596] Dynamic subtest eDP-1: SUCCESS (1.752s)
[671.807828] Subtest psr2-primary-render: SUCCESS (1.753s)
[672.654549] [115/133] (351s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[672.757498] Starting subtest: stress-xrgb8888-xtiled
[678.622775] Subtest stress-xrgb8888-xtiled: SUCCESS (5.869s)
[678.675633] [116/133] (345s left) kms_prop_blob (invalid-set-prop-any)
[678.725836] Starting subtest: invalid-set-prop-any
[678.727401] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[678.794376] [117/133] (345s left) sriov_basic (bind-unbind-vf)
[678.850780] Starting subtest: bind-unbind-vf
[678.853014] Starting dynamic subtest: vf-1
[678.921488] Dynamic subtest vf-1: FAIL (0.026s)
[678.934783] Starting dynamic subtest: vf-2
[678.993462] Dynamic subtest vf-2: FAIL (0.004s)
[679.005243] Starting dynamic subtest: vf-3
[679.066176] Dynamic subtest vf-3: FAIL (0.003s)
[679.076847] Starting dynamic subtest: vf-4
[679.136999] Dynamic subtest vf-4: FAIL (0.004s)
[679.147901] Starting dynamic subtest: vf-5
[679.206918] Dynamic subtest vf-5: FAIL (0.004s)
[679.217708] Starting dynamic subtest: vf-6
[679.278084] Dynamic subtest vf-6: FAIL (0.004s)
[679.289362] Starting dynamic subtest: vf-7
[679.350212] Dynamic subtest vf-7: FAIL (0.004s)
[679.360821] Starting dynamic subtest: vf-random
[679.418574] Dynamic subtest vf-random: FAIL (0.004s)
[679.429198] Starting dynamic subtest: vf-last
[679.490005] Dynamic subtest vf-last: FAIL (0.004s)
[679.491839] Subtest bind-unbind-vf: FAIL (0.498s)
[679.530114] [118/133] (344s left) kms_pm_backlight (brightness-with-dpms)
[679.619840] Starting subtest: brightness-with-dpms
[679.668999] Starting dynamic subtest: eDP-1
[682.061994] Dynamic subtest eDP-1: SUCCESS (2.390s)
[682.064177] Subtest brightness-with-dpms: SUCCESS (2.442s)
[682.911761] [119/133] (340s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[682.978395] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[682.980537] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[683.053521] [120/133] (340s left) kms_getfb (getfb2-into-addfb2)
[683.146779] Starting subtest: getfb2-into-addfb2
[683.149061] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[683.219927] [121/133] (340s left) gem_exec_whisper (basic-queues)
[683.284402] Starting subtest: basic-queues
[689.917522] Subtest basic-queues: SUCCESS (6.633s)
[690.079549] [122/133] (333s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[690.185426] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[690.189949] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[690.264183] [123/133] (333s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[690.366214] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[690.370413] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[690.440142] [124/133] (333s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[690.548498] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[697.915034] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.373s)
[698.041823] [125/133] (326s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[698.143162] Starting subtest: y-tiled-64bpp-rotate-90
[698.147622] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[698.227247] [126/133] (325s left) kms_fbcon_fbt (psr)
[698.289533] Starting subtest: psr
[705.589632] Subtest psr: SUCCESS (7.299s)
[705.670814] [127/133] (318s left) kms_cursor_crc (cursor-sliding-512x512)
[705.948586] Starting subtest: cursor-sliding-512x512
[705.952916] Subtest cursor-sliding-512x512: SKIP (0.001s)
[706.084056] [128/133] (318s left) kms_draw_crc (draw-method-render)
[706.174017] Starting subtest: draw-method-render
[706.176002] Starting dynamic subtest: xrgb8888-untiled
[706.438601] Dynamic subtest xrgb8888-untiled: SUCCESS (0.266s)
[706.451504] Starting dynamic subtest: rgb565-untiled
[706.693457] Dynamic subtest rgb565-untiled: SUCCESS (0.255s)
[706.703668] Starting dynamic subtest: xrgb2101010-untiled
[706.926670] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.232s)
[706.937258] Starting dynamic subtest: xbgr16161616f-untiled
[707.171190] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[707.181762] Starting dynamic subtest: xrgb8888-xtiled
[707.293404] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[707.304206] Starting dynamic subtest: rgb565-xtiled
[707.415521] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[707.426223] Starting dynamic subtest: xrgb2101010-xtiled
[707.538150] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[707.550600] Starting dynamic subtest: xbgr16161616f-xtiled
[707.672443] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[707.683127] Starting dynamic subtest: xrgb8888-4tiled
[707.804285] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.132s)
[707.814482] Starting dynamic subtest: rgb565-4tiled
[707.926703] Dynamic subtest rgb565-4tiled: SUCCESS (0.120s)
[707.939252] Starting dynamic subtest: xrgb2101010-4tiled
[708.048639] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.120s)
[708.059180] Starting dynamic subtest: xbgr16161616f-4tiled
[708.181949] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[708.183941] Subtest draw-method-render: SUCCESS (2.011s)
[708.242996] [129/133] (316s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[708.374695] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[708.386755] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[708.441725] [130/133] (315s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[708.579209] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[708.581395] Starting dynamic subtest: pipe-A-default-mode
[709.779377] Dynamic subtest pipe-A-default-mode: SKIP (1.197s)
[709.783753] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.200s)
[709.937524] [131/133] (314s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[710.044701] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[710.047563] Starting dynamic subtest: pipe-A-eDP-1
[710.326041] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.251s)
[710.338719] Starting dynamic subtest: pipe-B-eDP-1
[711.663892] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.337s)
[711.675704] Starting dynamic subtest: pipe-C-eDP-1
[712.925731] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.261s)
[712.937913] Starting dynamic subtest: pipe-D-eDP-1
[714.157382] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s)
[714.159497] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.084s)
[715.353715] [132/133] (309s left) kms_async_flips (test-cursor-atomic)
[715.453843] Starting subtest: test-cursor-atomic
[715.829558] Starting dynamic subtest: pipe-A-eDP-1
[716.651906] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.824s)
[717.034417] Starting dynamic subtest: pipe-B-eDP-1
[717.782853] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.757s)
[718.163018] Starting dynamic subtest: pipe-C-eDP-1
[718.919146] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.766s)
[719.284884] Starting dynamic subtest: pipe-D-eDP-1
[720.044616] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.767s)
[720.046938] Subtest test-cursor-atomic: SUCCESS (4.593s)
[721.197597] [133/133] (303s left) kms_addfb_basic (legacy-format)
[721.250839] Starting subtest: legacy-format
[721.278942] Subtest legacy-format: SUCCESS (0.027s)
[721.403124] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: gem_lmem_swapping
results: parsing output: 2/ for test: prime_mmap
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_userptr_blits
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: kms_cursor_crc
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_color
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: perf_pmu
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: gem_exec_capture
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: gem_workarounds
results: parsing output: 15/ for test: gem_busy
results: parsing output: 16/ for test: gem_render_copy
results: parsing output: 17/ for test: kms_plane_cursor
results: parsing output: 18/ for test: gem_ctx_exec
results: parsing output: 19/ for test: gem_render_copy
results: parsing output: 20/ for test: kms_flip_scaled_crc
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: kms_chamelium_color
results: parsing output: 25/ for test: gem_ctx_shared
results: parsing output: 26/ for test: gem_ctx_create
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_atomic_interruptible
results: parsing output: 30/ for test: gem_exec_schedule
results: parsing output: 31/ for test: perf_pmu
results: parsing output: 32/ for test: kms_joiner
results: parsing output: 33/ for test: perf
results: parsing output: 34/ for test: gem_mmap_gtt
results: parsing output: 35/ for test: gem_exec_reloc
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: gem_exec_reloc
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_eio
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: gem_create
results: parsing output: 42/ for test: gem_ctx_create
results: parsing output: 43/ for test: kms_sequence
results: parsing output: 44/ for test: prime_mmap
results: parsing output: 45/ for test: core_setmaster_vs_auth
results: parsing output: 46/ for test: dumb_buffer
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_exec_whisper
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: gem_exec_fence
results: parsing output: 52/ for test: gem_render_copy
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: kms_plane
results: parsing output: 55/ for test: gem_mmap_wc
results: parsing output: 56/ for test: gem_ctx_persistence
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: i915_query
results: parsing output: 59/ for test: kms_lease
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: syncobj_eventfd
results: parsing output: 62/ for test: kms_vblank
results: parsing output: 63/ for test: i915_pm_rps
results: parsing output: 64/ for test: gem_readwrite
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: kms_addfb_basic
results: parsing output: 67/ for test: kms_cursor_crc
results: parsing output: 68/ for test: gem_close_race
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_mmap_wc
results: parsing output: 71/ for test: kms_pm_rpm
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: i915_query
results: parsing output: 74/ for test: kms_content_protection
results: parsing output: 75/ for test: kms_plane
results: parsing output: 76/ for test: kms_panel_fitting
results: parsing output: 77/ for test: kms_psr2_sf
results: parsing output: 78/ for test: kms_pm_backlight
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: gem_exec_balancer
results: parsing output: 84/ for test: api_intel_allocator
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_exec_params
results: parsing output: 87/ for test: gem_userptr_blits
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_cursor_legacy
results: parsing output: 90/ for test: i915_fb_tiling
results: parsing output: 91/ for test: kms_chamelium_frames
results: parsing output: 92/ for test: gem_mmap_gtt
results: parsing output: 93/ for test: gen9_exec_parse
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_psr2_su
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: sw_sync
results: parsing output: 102/ for test: gem_eio
results: parsing output: 103/ for test: gem_partial_pwrite_pread
results: parsing output: 104/ for test: gem_spin_batch
results: parsing output: 105/ for test: kms_chamelium_hpd
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: gen9_exec_parse
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: api_intel_bb
results: parsing output: 112/ for test: kms_force_connector_basic
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: kms_pipe_stress
results: parsing output: 115/ for test: kms_prop_blob
results: parsing output: 116/ for test: sriov_basic
results: parsing output: 117/ for test: kms_pm_backlight
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: kms_getfb
results: parsing output: 120/ for test: gem_exec_whisper
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_fbcon_fbt
results: parsing output: 126/ for test: kms_cursor_crc
results: parsing output: 127/ for test: kms_draw_crc
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: kms_flip_scaled_crc
results: parsing output: 130/ for test: kms_ccs
results: parsing output: 131/ for test: kms_async_flips
results: parsing output: 132/ for test: kms_addfb_basic
Done.