[58.978857] Initializing watchdogs
[58.978974]   /dev/watchdog0
[59.013596] [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]
[59.027626] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.033032] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.037912] [001/133] (960s left) kms_psr (psr-no-drrs)
[59.171731] Starting subtest: psr-no-drrs
[59.174033] Starting dynamic subtest: eDP-1
[60.813028] Dynamic subtest eDP-1: SUCCESS (1.644s)
[60.815374] Subtest psr-no-drrs: SUCCESS (1.644s)
[61.692535] [002/133] (957s left) perf (non-sampling-read-error)
[61.827128] Starting subtest: non-sampling-read-error
[61.837746] Subtest non-sampling-read-error: SUCCESS (0.009s)
[61.880222] [003/133] (957s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[61.983117] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[65.893576] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.916s)
[67.112171] [004/133] (952s left) kms_pm_rpm (i2c)
[69.006978] Starting subtest: i2c
[74.397465] Subtest i2c: SUCCESS (5.394s)
[74.487352] [005/133] (945s left) gem_mmap_gtt (flink-race)
[74.545053] Subtest flink-race: SKIP (0.000s)
[74.605872] [006/133] (945s left) gen7_exec_parse (load-register-reg)
[74.668547] Subtest load-register-reg: SKIP (0.000s)
[74.728945] [007/133] (945s left) kms_chamelium_color (ctm-max)
[74.832864] Subtest ctm-max: SKIP (0.000s)
[74.874426] [008/133] (944s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[74.932072] Starting subtest: wait-all-for-submit-delayed-submit
[75.036480] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s)
[75.123733] [009/133] (944s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[75.227238] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[75.231624] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[75.324371] [010/133] (944s left) gem_mmap_wc (set-cache-level)
[75.380621] Subtest set-cache-level: SKIP (0.000s)
[75.434714] [011/133] (944s left) kms_selftest (drm_dp_mst_helper)
[75.471689] Starting subtest: drm_dp_mst_helper
[75.476238] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[75.562750] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.084s)
[75.569565] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[75.673164] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.110s)
[75.680950] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[75.778229] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.107s)
[75.780523] Subtest drm_dp_mst_helper: SUCCESS (0.309s)
[75.954918] [012/133] (944s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[76.050761] Starting subtest: fbcpsr-tiling-y
[76.055164] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[76.128408] [013/133] (943s left) kms_atomic_interruptible (legacy-pageflip)
[76.210808] Starting subtest: legacy-pageflip
[76.213146] Starting dynamic subtest: pipe-A-eDP-1
[83.601190] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.390s)
[83.603554] Subtest legacy-pageflip: SUCCESS (7.390s)
[84.441846] [014/133] (935s left) gem_exec_schedule (pi-ringfull)
[84.637485] Starting subtest: pi-ringfull
[84.639398] Starting dynamic subtest: rcs0
[84.679867] Dynamic subtest rcs0: SUCCESS (0.045s)
[84.691488] Starting dynamic subtest: bcs0
[84.707707] Dynamic subtest bcs0: SUCCESS (0.028s)
[84.718707] Starting dynamic subtest: vcs0
[84.734557] Dynamic subtest vcs0: SUCCESS (0.027s)
[84.746031] Starting dynamic subtest: vcs1
[84.762086] Dynamic subtest vcs1: SUCCESS (0.027s)
[84.773725] Starting dynamic subtest: vecs0
[84.787776] Dynamic subtest vecs0: SUCCESS (0.025s)
[84.798928] Starting dynamic subtest: ccs0
[84.814306] Dynamic subtest ccs0: SUCCESS (0.026s)
[84.816428] Subtest pi-ringfull: SUCCESS (0.180s)
[85.031317] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true
[85.034581] [015/133] (935s left) dmabuf_sync_file (export-before-signal)
[85.088334] Starting subtest: export-before-signal
[85.090582] Subtest export-before-signal: SUCCESS (0.001s)
[85.144741] [016/133] (934s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[85.209548] Starting subtest: multi-wait-for-submit-submitted-signaled
[85.211894] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[85.321652] [017/133] (934s left) kms_pm_lpsp (screens-disabled)
[86.430350] Starting subtest: screens-disabled
[86.434646] Subtest screens-disabled: SKIP (0.000s)
[86.513659] [018/133] (933s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[86.571810] Starting subtest: y-tiled-ccs-to-x-tiled
[86.576549] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[86.764609] [019/133] (933s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[86.831111] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[86.835726] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[87.011133] [020/133] (933s left) kms_flip (2x-flip-vs-suspend)
[87.117668] Starting subtest: 2x-flip-vs-suspend
[87.127853] Subtest 2x-flip-vs-suspend: SKIP (0.010s)
[87.232119] [021/133] (933s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[87.347080] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[87.351414] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[87.433559] [022/133] (932s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[87.488695] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[87.595238] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s)
[87.683701] [023/133] (932s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[87.771466] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[87.773786] Starting dynamic subtest: pipe-A-eDP-1
[88.594727] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.816s)
[88.603283] Starting dynamic subtest: pipe-B-eDP-1
[90.158385] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.562s)
[90.167200] Starting dynamic subtest: pipe-C-eDP-1
[91.666647] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.507s)
[91.679133] Starting dynamic subtest: pipe-D-eDP-1
[93.203411] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.535s)
[93.205624] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.423s)
[94.369420] [024/133] (926s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[94.471253] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[95.493574] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.023s)
[95.601518] [025/133] (924s left) kms_feature_discovery (dp-mst)
[95.692789] Starting subtest: dp-mst
[95.696743] Subtest dp-mst: SKIP (0.000s)
[95.762992] [026/133] (924s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[95.845039] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[95.846867] Starting dynamic subtest: pipe-A-default-mode
[97.048877] Dynamic subtest pipe-A-default-mode: SKIP (1.200s)
[97.053225] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.201s)
[97.180865] [027/133] (923s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[97.280836] Starting subtest: fbc-psr2-cursor-mmap-cpu
[97.282761] Starting dynamic subtest: eDP-1
[97.286729] Dynamic subtest eDP-1: SKIP (0.000s)
[97.290795] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[97.351222] [028/133] (923s left) gem_exec_params (cliprects_ptr-dirt)
[97.418605] Starting subtest: cliprects_ptr-dirt
[97.420795] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[97.547288] [029/133] (923s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[97.634522] Starting subtest: compare-crc-sanitycheck-xr24
[97.637032] Starting dynamic subtest: pipe-A-eDP-1
[98.254624] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.620s)
[98.262476] Starting dynamic subtest: pipe-B-eDP-1
[99.504081] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.248s)
[99.512298] Starting dynamic subtest: pipe-C-eDP-1
[100.776258] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.274s)
[100.785445] Starting dynamic subtest: pipe-D-eDP-1
[102.000538] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.221s)
[102.002826] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.367s)
[102.842342] [030/133] (917s left) i915_pm_freq_api (freq-suspend)
[102.905561] Starting subtest: freq-suspend
[102.907937] Starting dynamic subtest: gt0
[119.028988] Dynamic subtest gt0: SUCCESS (2.096s)
[119.042378] Starting dynamic subtest: gt1
[135.024938] Dynamic subtest gt1: SUCCESS (1.220s)
[135.027284] Subtest freq-suspend: SUCCESS (3.318s)
[135.111596] [031/133] (885s left) drm_read (fault-buffer)
[135.259852] Starting subtest: fault-buffer
[135.262373] Subtest fault-buffer: SUCCESS (0.000s)
[135.385791] [032/133] (885s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[135.491102] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[142.809127] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.362s)
[143.955358] [033/133] (876s left) gem_exec_reloc (basic-concurrent0)
[144.012506] Subtest basic-concurrent0: SKIP (0.000s)
[144.071615] [034/133] (876s left) gem_lmem_swapping (random)
[144.112765] Subtest random: SKIP (0.000s)
[144.161228] [035/133] (876s left) gem_ctx_persistence (heartbeat-close)
[144.213050] Starting subtest: heartbeat-close
[144.217600] Subtest heartbeat-close: SKIP (0.000s)
[144.313851] [036/133] (876s left) api_intel_allocator (execbuf-with-allocator)
[144.373950] Starting subtest: execbuf-with-allocator
[144.384392] Subtest execbuf-with-allocator: SUCCESS (0.012s)
[144.501010] [037/133] (876s left) syncobj_wait (single-wait-all-submitted)
[144.567333] Starting subtest: single-wait-all-submitted
[144.674040] Subtest single-wait-all-submitted: SUCCESS (0.106s)
[144.751011] [038/133] (876s left) gem_exec_schedule (u-fairslice)
[144.826990] Starting subtest: u-fairslice
[144.829300] Starting dynamic subtest: rcs0
[146.845741] Dynamic subtest rcs0: SUCCESS (2.030s)
[146.857164] Starting dynamic subtest: bcs0
[148.871125] Dynamic subtest bcs0: SUCCESS (2.030s)
[148.880424] Starting dynamic subtest: vcs0
[150.897224] Dynamic subtest vcs0: SUCCESS (2.028s)
[150.908427] Starting dynamic subtest: vcs1
[152.921303] Dynamic subtest vcs1: SUCCESS (2.025s)
[152.931129] Starting dynamic subtest: vecs0
[154.942215] Dynamic subtest vecs0: SUCCESS (2.024s)
[154.952633] Starting dynamic subtest: ccs0
[156.961373] Dynamic subtest ccs0: SUCCESS (2.021s)
[156.963436] Subtest u-fairslice: SUCCESS (12.161s)
[157.258393] [039/133] (863s left) gem_exec_schedule (u-submit-late-slice)
[157.328824] Starting subtest: u-submit-late-slice
[157.331261] Starting dynamic subtest: rcs0
[157.380027] Dynamic subtest rcs0: SUCCESS (0.058s)
[157.396108] Starting dynamic subtest: bcs0
[157.437827] Dynamic subtest bcs0: SUCCESS (0.057s)
[157.446275] Starting dynamic subtest: vcs0
[157.485165] Dynamic subtest vcs0: SUCCESS (0.046s)
[157.495304] Starting dynamic subtest: vcs1
[157.537983] Dynamic subtest vcs1: SUCCESS (0.050s)
[157.547855] Starting dynamic subtest: vecs0
[157.582455] Dynamic subtest vecs0: SUCCESS (0.045s)
[157.592595] Starting dynamic subtest: ccs0
[157.627349] Dynamic subtest ccs0: SUCCESS (0.044s)
[157.629784] Subtest u-submit-late-slice: SUCCESS (0.306s)
[158.843764] [040/133] (862s left) perf_pmu (busy-accuracy-50)
[158.883177] Starting subtest: busy-accuracy-50
[158.885736] Starting dynamic subtest: rcs0
[160.423440] Dynamic subtest rcs0: SUCCESS (1.540s)
[160.434307] Starting dynamic subtest: bcs0
[161.971834] Dynamic subtest bcs0: SUCCESS (1.547s)
[161.980917] Starting dynamic subtest: vcs0
[163.512885] Dynamic subtest vcs0: SUCCESS (1.542s)
[163.523129] Starting dynamic subtest: vcs1
[165.053140] Dynamic subtest vcs1: SUCCESS (1.540s)
[165.063208] Starting dynamic subtest: vecs0
[166.595545] Dynamic subtest vecs0: SUCCESS (1.541s)
[166.606332] Starting dynamic subtest: ccs0
[168.141007] Dynamic subtest ccs0: SUCCESS (1.543s)
[168.143602] Subtest busy-accuracy-50: SUCCESS (9.261s)
[168.258095] [041/133] (852s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[168.361642] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[168.744531] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[171.480184] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.733s)
[171.495436] Starting dynamic subtest: pipe-A-eDP-1-4
[173.665804] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.185s)
[173.677433] Starting dynamic subtest: pipe-A-eDP-1-4
[175.675867] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[175.687701] Starting dynamic subtest: pipe-A-eDP-1-x
[177.866918] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.188s)
[178.231999] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[181.012342] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.786s)
[181.022902] Starting dynamic subtest: pipe-B-eDP-1-4
[183.197319] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[183.208482] Starting dynamic subtest: pipe-B-eDP-1-4
[185.206542] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[185.216527] Starting dynamic subtest: pipe-B-eDP-1-x
[187.395804] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[187.760138] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[190.532914] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.782s)
[190.541532] Starting dynamic subtest: pipe-C-eDP-1-4
[192.718778] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.185s)
[192.729770] Starting dynamic subtest: pipe-C-eDP-1-4
[194.728235] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[194.736823] Starting dynamic subtest: pipe-C-eDP-1-x
[196.906396] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[197.270413] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[200.061855] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.800s)
[200.073254] Starting dynamic subtest: pipe-D-eDP-1-4
[202.236062] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[202.247968] Starting dynamic subtest: pipe-D-eDP-1-4
[204.245144] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[204.257407] Starting dynamic subtest: pipe-D-eDP-1-x
[206.423007] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[206.425397] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.069s)
[207.639592] [042/133] (813s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[207.745932] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[212.191294] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.451s)
[213.320701] [043/133] (807s left) kms_vblank (ts-continuation-suspend)
[213.422990] Starting subtest: ts-continuation-suspend
[213.425495] Starting dynamic subtest: pipe-A-eDP-1
[230.549495] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.791s)
[230.566953] Starting dynamic subtest: pipe-D-eDP-1
[247.342430] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.223s)
[247.344860] Subtest ts-continuation-suspend: SUCCESS (4.017s)
[248.187151] [044/133] (773s left) perf (invalid-oa-exponent)
[248.305873] Starting subtest: invalid-oa-exponent
[248.319341] Subtest invalid-oa-exponent: SUCCESS (0.011s)
[248.360499] [045/133] (772s left) gem_create (hog-create)
[248.415746] Starting subtest: hog-create
[248.418404] Starting dynamic subtest: smem0
[281.580622] Dynamic subtest smem0: SUCCESS (33.217s)
[281.583648] Subtest hog-create: SUCCESS (33.219s)
[281.770643] [046/133] (739s left) kms_cursor_crc (cursor-sliding-64x64)
[281.966658] Starting subtest: cursor-sliding-64x64
[281.972417] Starting dynamic subtest: pipe-A-eDP-1
[285.206398] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.232s)
[285.234014] Starting dynamic subtest: pipe-D-eDP-1
[289.076582] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.849s)
[289.079631] Subtest cursor-sliding-64x64: SUCCESS (7.107s)
[289.947820] [047/133] (731s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[290.048060] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[290.050481] Starting dynamic subtest: pipe-A-eDP-1
[290.883721] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.828s)
[290.897457] Starting dynamic subtest: pipe-B-eDP-1
[292.370587] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.485s)
[292.379437] Starting dynamic subtest: pipe-C-eDP-1
[293.891976] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.521s)
[293.901485] Starting dynamic subtest: pipe-D-eDP-1
[295.388759] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.493s)
[295.391494] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.332s)
[296.578113] [048/133] (724s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[296.683252] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[296.688214] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[296.778502] [049/133] (724s left) kms_psr (psr2-cursor-blt)
[296.865315] Starting subtest: psr2-cursor-blt
[296.867834] Starting dynamic subtest: eDP-1
[298.566200] Dynamic subtest eDP-1: SUCCESS (1.701s)
[298.568906] Subtest psr2-cursor-blt: SUCCESS (1.702s)
[299.473530] [050/133] (722s left) kms_psr (psr-cursor-blt)
[299.565275] Starting subtest: psr-cursor-blt
[299.568421] Starting dynamic subtest: eDP-1
[301.266514] Dynamic subtest eDP-1: SUCCESS (1.704s)
[301.269471] Subtest psr-cursor-blt: SUCCESS (1.705s)
[302.124379] [051/133] (719s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[302.280638] Starting subtest: dp-mst-lic-type-0-hdcp14
[302.285600] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[302.392090] [052/133] (719s left) kms_flip (2x-modeset-vs-vblank-race)
[302.489125] Starting subtest: 2x-modeset-vs-vblank-race
[302.498316] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[302.577828] [053/133] (719s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[302.817275] Starting subtest: cursor-rapid-movement-128x42
[302.866050] Subtest cursor-rapid-movement-128x42: SKIP (0.045s)
[303.077356] [054/133] (718s left) gem_ctx_persistence (engines-persistence)
[303.150323] Starting subtest: engines-persistence
[303.152566] Starting dynamic subtest: rcs0
[303.912215] Dynamic subtest rcs0: SUCCESS (0.764s)
[303.926626] Starting dynamic subtest: bcs0
[304.675101] Dynamic subtest bcs0: SUCCESS (0.761s)
[304.686384] Starting dynamic subtest: vcs0
[305.425281] Dynamic subtest vcs0: SUCCESS (0.748s)
[305.435627] Starting dynamic subtest: vcs1
[306.209359] Dynamic subtest vcs1: SUCCESS (0.782s)
[306.221670] Starting dynamic subtest: vecs0
[306.986205] Dynamic subtest vecs0: SUCCESS (0.774s)
[306.998155] Starting dynamic subtest: ccs0
[307.750288] Dynamic subtest ccs0: SUCCESS (0.762s)
[307.753532] Subtest engines-persistence: SUCCESS (4.604s)
[307.833173] [055/133] (713s left) syncobj_wait (multi-wait-all-submitted-signaled)
[307.887466] Starting subtest: multi-wait-all-submitted-signaled
[307.991481] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.105s)
[308.074473] [056/133] (713s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[308.182362] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[308.188227] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[308.273789] [057/133] (713s left) gem_pwrite_snooped
[308.412023] [058/133] (713s left) syncobj_wait (reset-multiple-signaled)
[308.459197] Starting subtest: reset-multiple-signaled
[308.461499] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[308.546980] [059/133] (713s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[308.919255] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[309.749425] [060/133] (712s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[309.857093] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[309.862381] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[310.002413] [061/133] (712s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[310.086040] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[310.090490] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[310.194669] [062/133] (711s left) kms_flip (dpms-vs-vblank-race-interruptible)
[310.301597] Starting subtest: dpms-vs-vblank-race-interruptible
[310.304372] Starting dynamic subtest: A-eDP1
[315.235388] Dynamic subtest A-eDP1: SUCCESS (4.931s)
[315.245655] Starting dynamic subtest: B-eDP1
[319.833243] Dynamic subtest B-eDP1: SUCCESS (4.597s)
[319.842843] Starting dynamic subtest: C-eDP1
[324.456483] Dynamic subtest C-eDP1: SUCCESS (4.623s)
[324.465494] Starting dynamic subtest: D-eDP1
[329.090895] Dynamic subtest D-eDP1: SUCCESS (4.636s)
[329.097400] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.799s)
[329.966301] [063/133] (692s left) gen7_exec_parse (basic-allocation)
[330.032209] Subtest basic-allocation: SKIP (0.000s)
[330.123043] [064/133] (692s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[330.220611] Starting subtest: psr-rgb101010-draw-mmap-wc
[337.257526] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.042s)
[337.360417] [065/133] (684s left) kms_properties (connector-properties-atomic)
[337.457317] Starting subtest: connector-properties-atomic
[337.460210] Starting dynamic subtest: pipe-A-eDP-1
[345.202619] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.747s)
[345.212046] Starting dynamic subtest: pipe-None-DP-1
[345.216766] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[345.224737] Starting dynamic subtest: pipe-None-HDMI-A-1
[345.228798] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[345.237386] Starting dynamic subtest: pipe-None-DP-2
[345.242027] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[345.250578] Starting dynamic subtest: pipe-None-HDMI-A-2
[345.255298] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[345.263493] Starting dynamic subtest: pipe-None-DP-3
[345.268369] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[345.277324] Starting dynamic subtest: pipe-None-DP-4
[345.281998] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[345.284182] Subtest connector-properties-atomic: SUCCESS (7.758s)
[346.075964] [066/133] (676s left) kms_psr (fbc-pr-primary-mmap-cpu)
[346.178135] Starting subtest: fbc-pr-primary-mmap-cpu
[346.183579] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[346.250137] [067/133] (676s left) gem_exec_balancer (smoke)
[346.321991] Starting subtest: smoke
[368.907657] Subtest smoke: SUCCESS (22.578s)
[370.669959] [068/133] (651s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[370.778391] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[370.781220] Starting dynamic subtest: pipe-A-eDP-1
[370.851354] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[370.861354] Starting dynamic subtest: pipe-B-eDP-1
[370.930458] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[370.940218] Starting dynamic subtest: pipe-C-eDP-1
[371.009166] Dynamic subtest pipe-C-eDP-1: SKIP (0.003s)
[371.018588] Starting dynamic subtest: pipe-D-eDP-1
[371.084444] Dynamic subtest pipe-D-eDP-1: SKIP (0.003s)
[371.089813] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.019s)
[373.056402] [069/133] (649s left) gem_mmap_wc (coherency)
[373.127365] Subtest coherency: SKIP (0.000s)
[373.195126] [070/133] (649s left) perf_pmu (idle)
[373.238431] Starting subtest: idle
[373.241482] Starting dynamic subtest: rcs0
[373.786307] Dynamic subtest rcs0: SUCCESS (0.548s)
[373.796718] Starting dynamic subtest: bcs0
[374.302734] Dynamic subtest bcs0: SUCCESS (0.513s)
[374.318248] Starting dynamic subtest: vcs0
[374.825654] Dynamic subtest vcs0: SUCCESS (0.519s)
[374.837675] Starting dynamic subtest: vcs1
[375.353533] Dynamic subtest vcs1: SUCCESS (0.519s)
[375.364147] Starting dynamic subtest: vecs0
[375.869455] Dynamic subtest vecs0: SUCCESS (0.518s)
[375.882381] Starting dynamic subtest: ccs0
[376.392056] Dynamic subtest ccs0: SUCCESS (0.520s)
[376.395209] Subtest idle: SUCCESS (3.155s)
[376.517022] [071/133] (646s left) gem_exec_whisper (basic-queues-priority-all)
[376.585091] Starting subtest: basic-queues-priority-all
[398.938503] Subtest basic-queues-priority-all: SUCCESS (22.351s)
[399.132860] [072/133] (623s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[399.234626] Starting subtest: 4-tiled-8bpp-rotate-0
[400.428278] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.193s)
[400.550588] [073/133] (622s left) api_intel_bb (lot-of-buffers)
[400.606291] Starting subtest: lot-of-buffers
[401.621483] Subtest lot-of-buffers: SUCCESS (1.016s)
[402.121927] [074/133] (620s left) kms_flip (2x-dpms-vs-vblank-race)
[402.209260] Starting subtest: 2x-dpms-vs-vblank-race
[402.218870] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[402.298256] [075/133] (620s left) vgem_basic (debugfs)
[402.338341] Starting subtest: debugfs
[402.341571] Subtest debugfs: SUCCESS (0.001s)
[402.404300] [076/133] (620s left) gem_mmap_gtt (basic-small-bo-tiledx)
[402.458848] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[402.519364] [077/133] (620s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[402.606330] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[402.611348] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[402.701339] [078/133] (620s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[402.835851] Starting subtest: cursor-vs-flip-toggle
[433.704253] Subtest cursor-vs-flip-toggle: SUCCESS (30.873s)
[434.562157] [079/133] (588s left) kms_addfb_basic (bad-pitch-32)
[434.629222] Starting subtest: bad-pitch-32
[434.631964] Subtest bad-pitch-32: SUCCESS (0.000s)
[434.758471] [080/133] (588s left) gem_mmap_wc (write-read-distinct)
[434.821360] Subtest write-read-distinct: SKIP (0.000s)
[434.886608] [081/133] (588s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[434.983404] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[434.989286] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[435.079185] [082/133] (587s left) gem_ctx_param (invalid-size-set)
[435.138129] Starting subtest: invalid-size-set
[435.141135] Subtest invalid-size-set: SUCCESS (0.001s)
[435.257051] [083/133] (587s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[435.349407] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[435.351972] Starting dynamic subtest: pipe-A-eDP-1
[435.491406] Dynamic subtest pipe-A-eDP-1: SKIP (0.144s)
[435.500872] Starting dynamic subtest: pipe-B-eDP-1
[436.633396] Dynamic subtest pipe-B-eDP-1: SKIP (1.140s)
[436.638444] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.287s)
[437.820411] [084/133] (585s left) gem_userptr_blits (coherency-sync)
[437.897711] Starting subtest: coherency-sync
[438.260656] Subtest coherency-sync: SKIP (0.327s)
[438.381593] [085/133] (584s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[438.525485] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[445.073618] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.552s)
[445.184705] [086/133] (578s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[445.290467] Starting subtest: y-tiled-16bpp-rotate-0
[445.295352] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[445.390196] [087/133] (577s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[445.524763] Starting subtest: verify-pxp-execution-after-suspend-resume
[452.563525] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.040s)
[452.688882] [088/133] (570s left) kms_getfb (getfb-reject-nv12)
[452.794461] Starting subtest: getfb-reject-nv12
[452.797404] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[452.878949] [089/133] (570s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[452.992595] Starting subtest: yf-tiled-32bpp-rotate-180
[452.998024] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[453.114100] [090/133] (570s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[453.219488] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[453.245444] Starting dynamic subtest: pipe-A-plane-0
[453.589271] Dynamic subtest pipe-A-plane-0: SUCCESS (0.344s)
[453.604353] Starting dynamic subtest: pipe-A-plane-3
[453.834109] Dynamic subtest pipe-A-plane-3: SUCCESS (0.242s)
[453.843163] Starting dynamic subtest: pipe-A-plane-5
[453.847363] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[454.913215] Starting dynamic subtest: pipe-B-plane-0
[455.214589] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[455.224293] Starting dynamic subtest: pipe-B-plane-3
[455.447592] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[455.457533] Starting dynamic subtest: pipe-B-plane-5
[455.463580] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[455.763983] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.544s)
[456.611319] [091/133] (566s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[456.716176] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[463.464551] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.751s)
[463.622253] [092/133] (559s left) kms_cursor_legacy (forked-move)
[463.744325] Starting subtest: forked-move
[463.747306] Starting dynamic subtest: pipe-A
[469.205617] Dynamic subtest pipe-A: SUCCESS (5.458s)
[469.218276] Starting dynamic subtest: pipe-B
[474.698943] Dynamic subtest pipe-B: SUCCESS (5.490s)
[474.711237] Starting dynamic subtest: pipe-C
[480.165813] Dynamic subtest pipe-C: SUCCESS (5.465s)
[480.178350] Starting dynamic subtest: pipe-D
[485.630886] Dynamic subtest pipe-D: SUCCESS (5.463s)
[485.642561] Starting dynamic subtest: all-pipes
[491.099622] Dynamic subtest all-pipes: SUCCESS (5.467s)
[491.102791] Subtest forked-move: SUCCESS (27.351s)
[491.243479] [093/133] (532s left) kms_joiner (basic-force-ultra-joiner)
[491.345109] Starting subtest: basic-force-ultra-joiner
[491.349888] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[491.411801] [094/133] (532s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[491.508416] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[491.511581] Starting dynamic subtest: pipe-A-eDP-1
[491.583845] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.077s)
[491.895187] Starting dynamic subtest: pipe-B-eDP-1
[492.705107] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.819s)
[492.995498] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.486s)
[493.860271] [095/133] (529s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[493.959245] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[501.178569] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.221s)
[501.291323] [096/133] (522s left) fbdev (read)
[501.342706] Starting subtest: read
[501.866780] Subtest read: SUCCESS (0.523s)
[501.943990] [097/133] (521s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[502.005623] Subtest no-spare-fences-busy: SKIP (0.000s)
[502.078920] [098/133] (521s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[502.178376] Starting subtest: fbc-shrfb-scaledprimary
[505.204927] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.030s)
[506.422420] [099/133] (517s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[507.979340] Starting subtest: gem-execbuf-stress-pc8
[508.014987] Subtest gem-execbuf-stress-pc8: SKIP (0.037s)
[508.736406] [100/133] (515s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[508.826923] Starting subtest: plane-lut1d-ctm3x4
[508.996212] Starting dynamic subtest: pipe-A-plane-0
[509.151435] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s)
[509.161583] Starting dynamic subtest: pipe-A-plane-1
[509.307188] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[509.319431] Starting dynamic subtest: pipe-A-plane-2
[509.452276] Dynamic subtest pipe-A-plane-2: SUCCESS (0.143s)
[510.633927] Starting dynamic subtest: pipe-B-plane-0
[510.778966] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[510.789437] Starting dynamic subtest: pipe-B-plane-1
[510.922826] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s)
[510.932588] Starting dynamic subtest: pipe-B-plane-2
[511.055750] Dynamic subtest pipe-B-plane-2: SUCCESS (0.132s)
[512.245586] Starting dynamic subtest: pipe-C-plane-0
[512.393326] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[512.406608] Starting dynamic subtest: pipe-C-plane-1
[512.537381] Dynamic subtest pipe-C-plane-1: SUCCESS (0.143s)
[512.547483] Starting dynamic subtest: pipe-C-plane-2
[512.682429] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[513.868145] Starting dynamic subtest: pipe-D-plane-0
[513.991010] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[514.001598] Starting dynamic subtest: pipe-D-plane-1
[514.135426] Dynamic subtest pipe-D-plane-1: SUCCESS (0.143s)
[514.148447] Starting dynamic subtest: pipe-D-plane-2
[514.279850] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[514.565386] Subtest plane-lut1d-ctm3x4: SUCCESS (5.739s)
[515.442817] [101/133] (508s left) gem_tiled_pread_pwrite
[515.560670] [102/133] (508s left) gem_softpin (safe-alignment)
[515.618961] Starting subtest: safe-alignment
[515.644136] Subtest safe-alignment: SUCCESS (0.025s)
[517.650439] [103/133] (506s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[517.763361] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[517.766085] Starting dynamic subtest: pipe-A
[519.024338] Dynamic subtest pipe-A: SUCCESS (1.263s)
[519.043916] Starting dynamic subtest: pipe-B
[521.286796] Dynamic subtest pipe-B: SUCCESS (2.260s)
[521.296177] Starting dynamic subtest: pipe-C
[522.442107] Dynamic subtest pipe-C: SUCCESS (1.154s)
[522.451002] Starting dynamic subtest: pipe-D
[523.594947] Dynamic subtest pipe-D: SUCCESS (1.152s)
[523.597440] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.835s)
[524.791337] [104/133] (499s left) kms_cursor_crc (cursor-onscreen-512x170)
[525.111300] Starting subtest: cursor-onscreen-512x170
[525.115976] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[525.249374] [105/133] (498s left) i915_suspend (fence-restore-tiled2untiled)
[525.307230] Starting subtest: fence-restore-tiled2untiled
[525.312634] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[525.397580] [106/133] (498s left) kms_plane_scaling (planes-scaler-unity-scaling)
[525.484749] Starting subtest: planes-scaler-unity-scaling
[525.487426] Starting dynamic subtest: pipe-A
[525.546451] Dynamic subtest pipe-A: SUCCESS (0.064s)
[525.557535] Starting dynamic subtest: pipe-B
[526.727584] Dynamic subtest pipe-B: SUCCESS (1.180s)
[526.737597] Starting dynamic subtest: pipe-C
[527.829624] Dynamic subtest pipe-C: SUCCESS (1.101s)
[527.840978] Starting dynamic subtest: pipe-D
[528.955831] Dynamic subtest pipe-D: SUCCESS (1.126s)
[528.958495] Subtest planes-scaler-unity-scaling: SUCCESS (3.474s)
[530.124802] [107/133] (493s left) gem_exec_balancer (individual)
[530.191050] Starting subtest: individual
[531.620305] Subtest individual: SUCCESS (1.428s)
[531.937348] [108/133] (492s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[532.037846] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[532.042827] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[532.133210] [109/133] (492s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[532.230649] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[532.235886] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[532.316280] [110/133] (491s left) gem_exec_fence (keep-in-fence)
[532.506066] Starting subtest: keep-in-fence
[532.508033] Starting dynamic subtest: rcs0
[532.559565] Dynamic subtest rcs0: SUCCESS (0.056s)
[532.570620] Starting dynamic subtest: bcs0
[532.613532] Dynamic subtest bcs0: SUCCESS (0.052s)
[532.624604] Starting dynamic subtest: vcs0
[534.636050] Dynamic subtest vcs0: SUCCESS (2.020s)
[534.648747] Starting dynamic subtest: vcs1
[536.618682] Dynamic subtest vcs1: SUCCESS (1.979s)
[536.630595] Starting dynamic subtest: vecs0
[538.603591] Dynamic subtest vecs0: SUCCESS (1.982s)
[538.616612] Starting dynamic subtest: ccs0
[538.835066] Dynamic subtest ccs0: SUCCESS (0.229s)
[538.837837] Subtest keep-in-fence: SUCCESS (6.333s)
[540.740008] [111/133] (483s left) core_auth (basic-auth)
[540.794424] Starting subtest: basic-auth
[540.797405] Subtest basic-auth: SUCCESS (0.001s)
[540.891586] [112/133] (483s left) syncobj_timeline (invalid-wait-illegal-handle)
[540.949893] Starting subtest: invalid-wait-illegal-handle
[540.952770] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[541.048642] [113/133] (483s left) prime_vgem (basic-write)
[541.120159] Starting subtest: basic-write
[541.140713] Subtest basic-write: SKIP (0.021s)
[541.252893] [114/133] (483s left) syncobj_wait (multi-wait-all-submitted)
[541.312908] Starting subtest: multi-wait-all-submitted
[541.413916] Subtest multi-wait-all-submitted: SUCCESS (0.103s)
[541.531671] [115/133] (482s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[541.593453] Starting subtest: etime-single-wait-all-available-unsubmitted
[541.692516] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.101s)
[541.774400] [116/133] (482s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[541.865822] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[541.869756] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[541.946359] [117/133] (482s left) kms_big_fb (linear-8bpp-rotate-90)
[542.045180] Starting subtest: linear-8bpp-rotate-90
[542.068942] Subtest linear-8bpp-rotate-90: SKIP (0.022s)
[542.185055] [118/133] (482s left) kms_psr (fbc-psr-cursor-blt)
[542.279375] Starting subtest: fbc-psr-cursor-blt
[542.281608] Starting dynamic subtest: eDP-1
[542.285600] Dynamic subtest eDP-1: SKIP (0.000s)
[542.289811] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[542.349792] [119/133] (482s left) kms_atomic_transition (modeset-transition)
[542.443176] Starting subtest: modeset-transition
[542.444960] Starting dynamic subtest: 1x-outputs
[553.386363] Dynamic subtest 1x-outputs: SUCCESS (10.942s)
[553.389425] Subtest modeset-transition: SUCCESS (10.944s)
[554.260204] [120/133] (470s left) i915_drm_fdinfo (memory-info-shared)
[554.309271] Starting subtest: memory-info-shared
[554.312360] Starting dynamic subtest: smem0
[554.362441] Dynamic subtest smem0: SUCCESS (0.052s)
[554.365463] Subtest memory-info-shared: SUCCESS (0.053s)
[554.449443] [121/133] (470s left) sysfs_timeslice_duration (invalid)
[554.510566] Starting subtest: invalid
[554.513435] Starting dynamic subtest: vecs0
[554.516446] Dynamic subtest vecs0: SUCCESS (0.000s)
[554.527372] Starting dynamic subtest: ccs0
[554.530210] Dynamic subtest ccs0: SUCCESS (0.000s)
[554.539634] Starting dynamic subtest: vcs0
[554.542337] Dynamic subtest vcs0: SUCCESS (0.000s)
[554.551817] Starting dynamic subtest: bcs0
[554.554608] Dynamic subtest bcs0: SUCCESS (0.000s)
[554.564419] Starting dynamic subtest: rcs0
[554.566826] Dynamic subtest rcs0: SUCCESS (0.000s)
[554.576425] Starting dynamic subtest: vcs1
[554.579247] Dynamic subtest vcs1: SUCCESS (0.000s)
[554.581886] Subtest invalid: SUCCESS (0.005s)
[554.620629] [122/133] (470s left) kms_setmode (invalid-clone-single-crtc-stealing)
[554.685579] Starting subtest: invalid-clone-single-crtc-stealing
[554.694044] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[554.782957] [123/133] (469s left) gem_ctx_sseu (invalid-sseu)
[554.835786] Subtest invalid-sseu: SKIP (0.000s)
[554.908605] [124/133] (469s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[555.001617] Starting subtest: blocking-absolute-wf_vblank-interruptible
[555.004570] Starting dynamic subtest: A-eDP1
[563.715840] Dynamic subtest A-eDP1: SUCCESS (8.714s)
[563.728073] Starting dynamic subtest: B-eDP1
[572.427675] Dynamic subtest B-eDP1: SUCCESS (8.711s)
[572.452041] Starting dynamic subtest: C-eDP1
[581.144181] Dynamic subtest C-eDP1: SUCCESS (8.714s)
[581.158589] Starting dynamic subtest: D-eDP1
[589.869257] Dynamic subtest D-eDP1: SUCCESS (8.725s)
[589.874786] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.877s)
[591.080209] [125/133] (433s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[591.471374] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[592.283213] [126/133] (432s left) kms_tv_load_detect (load-detect)
[592.343369] Subtest load-detect: SKIP (0.000s)
[592.412106] [127/133] (432s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[592.507315] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[592.509988] Starting dynamic subtest: pipe-A-eDP-1
[592.535352] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[592.546413] Starting dynamic subtest: pipe-B-eDP-1
[592.571614] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[592.581517] Starting dynamic subtest: pipe-C-eDP-1
[592.607464] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[592.619615] Starting dynamic subtest: pipe-D-eDP-1
[592.645579] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[592.650288] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[594.762798] [128/133] (430s left) gem_mmap_wc (write-prefaulted)
[594.824563] Subtest write-prefaulted: SKIP (0.000s)
[594.884979] [129/133] (430s left) kms_plane_lowres (tiling-yf)
[594.980932] Starting subtest: tiling-yf
[594.985581] Subtest tiling-yf: SKIP (0.000s)
[595.053617] [130/133] (429s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[595.142362] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[595.150452] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.010s)
[595.227332] [131/133] (429s left) kms_lease (cursor-implicit-plane)
[595.324068] Starting subtest: cursor-implicit-plane
[595.326098] Starting dynamic subtest: pipe-A-eDP-1
[595.783145] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.460s)
[595.794161] Starting dynamic subtest: pipe-B-eDP-1
[596.887099] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.100s)
[596.899506] Starting dynamic subtest: pipe-C-eDP-1
[597.992387] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.107s)
[598.003454] Starting dynamic subtest: pipe-D-eDP-1
[599.146489] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.152s)
[599.149095] Subtest cursor-implicit-plane: SUCCESS (3.825s)
[599.983139] [132/133] (425s left) kms_prop_blob (invalid-set-prop)
[600.039954] Starting subtest: invalid-set-prop
[600.042162] Subtest invalid-set-prop: SUCCESS (0.000s)
[600.132778] [133/133] (425s left) prime_vgem (basic-blt)
[600.196337] Starting subtest: basic-blt
[600.224302] Subtest basic-blt: SUCCESS (0.027s)
[600.363131] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: perf
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_pm_rpm
results: parsing output: 4/ for test: gem_mmap_gtt
results: parsing output: 5/ for test: gen7_exec_parse
results: parsing output: 6/ for test: kms_chamelium_color
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_mmap_wc
results: parsing output: 10/ for test: kms_selftest
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_atomic_interruptible
results: parsing output: 13/ for test: gem_exec_schedule
results: parsing output: 14/ for test: dmabuf_sync_file
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_pm_lpsp
results: parsing output: 17/ for test: gem_render_copy
results: parsing output: 18/ for test: gem_render_copy
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_feature_discovery
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: gem_exec_params
results: parsing output: 28/ for test: kms_pipe_crc_basic
results: parsing output: 29/ for test: i915_pm_freq_api
results: parsing output: 30/ for test: drm_read
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: gem_lmem_swapping
results: parsing output: 34/ for test: gem_ctx_persistence
results: parsing output: 35/ for test: api_intel_allocator
results: parsing output: 36/ for test: syncobj_wait
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: gem_exec_schedule
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: kms_async_flips
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_vblank
results: parsing output: 43/ for test: perf
results: parsing output: 44/ for test: gem_create
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_content_protection
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: gem_ctx_persistence
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_pwrite_snooped
results: parsing output: 57/ for test: syncobj_wait
results: parsing output: 58/ for test: kms_chamelium_edid
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: gen7_exec_parse
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_properties
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: gem_exec_balancer
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: gem_mmap_wc
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: gem_exec_whisper
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: api_intel_bb
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: vgem_basic
results: parsing output: 75/ for test: gem_mmap_gtt
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: kms_addfb_basic
results: parsing output: 79/ for test: gem_mmap_wc
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_ctx_param
results: parsing output: 82/ for test: kms_psr2_sf
results: parsing output: 83/ for test: gem_userptr_blits
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_pxp
results: parsing output: 87/ for test: kms_getfb
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_plane
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: kms_joiner
results: parsing output: 93/ for test: kms_atomic_transition
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: fbdev
results: parsing output: 96/ for test: gem_fenced_exec_thrash
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: i915_pm_rpm
results: parsing output: 99/ for test: kms_color_pipeline
results: parsing output: 100/ for test: gem_tiled_pread_pwrite
results: parsing output: 101/ for test: gem_softpin
results: parsing output: 102/ for test: kms_plane_scaling
results: parsing output: 103/ for test: kms_cursor_crc
results: parsing output: 104/ for test: i915_suspend
results: parsing output: 105/ for test: kms_plane_scaling
results: parsing output: 106/ for test: gem_exec_balancer
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_exec_fence
results: parsing output: 110/ for test: core_auth
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: prime_vgem
results: parsing output: 113/ for test: syncobj_wait
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: kms_atomic_transition
results: parsing output: 119/ for test: i915_drm_fdinfo
results: parsing output: 120/ for test: sysfs_timeslice_duration
results: parsing output: 121/ for test: kms_setmode
results: parsing output: 122/ for test: gem_ctx_sseu
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: kms_chamelium_hpd
results: parsing output: 125/ for test: kms_tv_load_detect
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: gem_mmap_wc
results: parsing output: 128/ for test: kms_plane_lowres
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_lease
results: parsing output: 131/ for test: kms_prop_blob
results: parsing output: 132/ for test: prime_vgem
Done.