[100.399864] Initializing watchdogs
[100.399909]   /dev/watchdog0
[100.415960] [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]
[100.420104] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[100.422192] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[100.425924] [001/130] (960s left) kms_busy (basic)
[100.547015] Starting subtest: basic
[100.549144] Starting dynamic subtest: flip
[101.189102] Dynamic subtest flip: SUCCESS (0.639s)
[101.197914] Starting dynamic subtest: modeset
[104.616979] Dynamic subtest modeset: SUCCESS (3.428s)
[104.619477] Subtest basic: SUCCESS (4.068s)
[105.408090] [002/130] (955s left) gem_ctx_sseu (engines)
[105.471512] Subtest engines: SKIP (0.000s)
[105.531070] [003/130] (955s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[105.623055] Starting subtest: crc-primary-basic-y-tiled-ccs
[105.625323] Starting dynamic subtest: pipe-A-eDP-1
[105.649266] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[105.657902] Starting dynamic subtest: pipe-B-eDP-1
[105.678882] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[105.685836] Starting dynamic subtest: pipe-C-eDP-1
[105.707207] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[105.715090] Starting dynamic subtest: pipe-D-eDP-1
[105.736701] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[105.741110] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.004s)
[107.761655] [004/130] (953s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[107.860646] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[108.938779] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.078s)
[109.120179] [005/130] (951s left) gem_exec_schedule (pi-shared-iova)
[109.299486] Starting subtest: pi-shared-iova
[109.301536] Starting dynamic subtest: rcs0
[109.371681] Dynamic subtest rcs0: SUCCESS (0.076s)
[109.382619] Starting dynamic subtest: vcs0
[109.423212] Dynamic subtest vcs0: SUCCESS (0.051s)
[109.432832] Starting dynamic subtest: vcs1
[109.473213] Dynamic subtest vcs1: SUCCESS (0.050s)
[109.483407] Starting dynamic subtest: vecs0
[109.519485] Dynamic subtest vecs0: SUCCESS (0.046s)
[109.530618] Starting dynamic subtest: ccs0
[109.575078] Dynamic subtest ccs0: SUCCESS (0.056s)
[109.577614] Subtest pi-shared-iova: SUCCESS (0.279s)
[111.035194] [006/130] (950s left) kms_draw_crc (fill-fb)
[111.122503] Starting subtest: fill-fb
[111.579189] Subtest fill-fb: SUCCESS (0.459s)
[111.690642] [007/130] (949s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-wc)
[111.797551] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-wc
[118.350219] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (6.554s)
[118.481334] [008/130] (942s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[118.582115] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[118.584621] Starting dynamic subtest: pipe-A
[118.668488] Dynamic subtest pipe-A: SUCCESS (0.087s)
[118.679342] Starting dynamic subtest: pipe-B
[119.783568] Dynamic subtest pipe-B: SUCCESS (1.115s)
[119.792302] Starting dynamic subtest: pipe-C
[120.883149] Dynamic subtest pipe-C: SUCCESS (1.099s)
[120.892877] Starting dynamic subtest: pipe-D
[122.009909] Dynamic subtest pipe-D: SUCCESS (1.126s)
[122.012429] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.428s)
[123.159387] [009/130] (938s left) gem_userptr_blits (sync-unmap-cycles)
[123.231235] Starting subtest: sync-unmap-cycles
[128.600711] Subtest sync-unmap-cycles: SUCCESS (5.370s)
[128.741598] [010/130] (932s left) gem_userptr_blits (dmabuf-unsync)
[128.807247] Subtest dmabuf-unsync: SKIP (0.000s)
[128.954984] [011/130] (932s left) kms_sequence (queue-busy)
[129.055583] Starting subtest: queue-busy
[129.057366] Starting dynamic subtest: pipe-A-eDP-1
[130.995513] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.936s)
[131.004062] Starting dynamic subtest: pipe-B-eDP-1
[133.549181] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.553s)
[133.557928] Starting dynamic subtest: pipe-C-eDP-1
[136.162544] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.613s)
[136.169922] Starting dynamic subtest: pipe-D-eDP-1
[138.695836] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.534s)
[138.698170] Subtest queue-busy: SUCCESS (9.638s)
[139.566320] [012/130] (921s left) fbdev (read)
[139.607585] Starting subtest: read
[140.132958] Subtest read: SUCCESS (0.523s)
[140.192926] [013/130] (921s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[140.299430] Starting subtest: basic-modeset-with-all-modifiers-formats
[140.674398] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[141.439782] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.766s)
[141.448255] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[141.461994] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.022s)
[141.469392] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[141.484966] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[141.496382] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[141.695566] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.211s)
[141.702848] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[141.717528] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s)
[141.724453] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[141.739917] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[141.750428] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[141.762210] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[141.769171] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[141.784430] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s)
[141.794535] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[141.806209] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s)
[141.813035] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[141.828774] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[141.835609] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[141.851033] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[141.858101] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[141.873308] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[141.880223] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[142.073599] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.200s)
[142.085092] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[142.095479] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[142.104387] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[142.117710] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[142.127317] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[142.139959] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[142.147043] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[142.162411] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[142.169633] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[142.184603] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[142.191660] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[142.206885] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[142.219440] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[142.229250] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[142.238411] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[142.250721] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[142.257870] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[142.462134] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.211s)
[142.468781] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[142.484237] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s)
[142.490805] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[142.506606] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[142.513165] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[142.528855] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[142.535438] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[142.550919] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[142.557708] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[142.573186] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[142.579659] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[142.595438] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[142.601928] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[142.617724] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[142.624380] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[142.639889] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[143.019572] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.720s)
[143.809125] [014/130] (917s left) kms_lease (lease-unleased-crtc)
[143.907223] Starting subtest: lease-unleased-crtc
[143.909648] Starting dynamic subtest: pipe-A-eDP-1
[144.195485] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[144.204670] Starting dynamic subtest: pipe-B-eDP-1
[144.962687] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.765s)
[144.972583] Starting dynamic subtest: pipe-C-eDP-1
[144.974883] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[144.984372] Starting dynamic subtest: pipe-D-eDP-1
[144.986606] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[144.988733] Subtest lease-unleased-crtc: SUCCESS (1.068s)
[145.316854] [015/130] (916s left) i915_pm_rpm (system-suspend)
[147.049984] Starting subtest: system-suspend
[165.772712] Subtest system-suspend: SUCCESS (2.957s)
[166.124097] [016/130] (895s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[166.232482] Starting subtest: bad-aux-stride-y-tiled-ccs
[166.234893] Starting dynamic subtest: pipe-A-eDP-1
[166.257263] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[166.266623] Starting dynamic subtest: pipe-B-eDP-1
[166.287567] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[166.294556] Starting dynamic subtest: pipe-C-eDP-1
[166.315481] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[166.322325] Starting dynamic subtest: pipe-D-eDP-1
[166.342992] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[166.347290] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.003s)
[168.405438] [017/130] (893s left) kms_flip (2x-plain-flip-interruptible)
[168.496992] Starting subtest: 2x-plain-flip-interruptible
[168.507725] Subtest 2x-plain-flip-interruptible: SKIP (0.010s)
[168.604057] [018/130] (892s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[168.706572] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[168.710484] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[168.822612] [019/130] (892s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[173.781537] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[173.783980] Starting dynamic subtest: pipe-A-eDP-1
[174.566084] Dynamic subtest pipe-A-eDP-1: SKIP (0.790s)
[174.574718] Starting dynamic subtest: pipe-B-eDP-1
[175.689086] Dynamic subtest pipe-B-eDP-1: SKIP (1.135s)
[175.693843] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.928s)
[176.854755] [020/130] (884s left) gem_exec_fence (invalid-fence-array)
[177.308914] Starting subtest: invalid-fence-array
[177.314790] Subtest invalid-fence-array: SUCCESS (0.003s)
[178.771677] [FACT gem_exec_fence (invalid-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[178.774269] [021/130] (882s left) gem_exec_schedule (pi-distinct-iova)
[178.943272] Starting subtest: pi-distinct-iova
[178.945652] Starting dynamic subtest: rcs0
[179.018145] Dynamic subtest rcs0: SUCCESS (0.078s)
[179.031338] Starting dynamic subtest: vcs0
[179.077488] Dynamic subtest vcs0: SUCCESS (0.060s)
[179.089687] Starting dynamic subtest: vcs1
[179.141002] Dynamic subtest vcs1: SUCCESS (0.063s)
[179.152149] Starting dynamic subtest: vecs0
[179.195024] Dynamic subtest vecs0: SUCCESS (0.054s)
[179.207546] Starting dynamic subtest: ccs0
[179.253102] Dynamic subtest ccs0: SUCCESS (0.059s)
[179.255514] Subtest pi-distinct-iova: SUCCESS (0.316s)
[180.750154] [022/130] (880s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[185.770432] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[185.775377] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[186.621940] [023/130] (875s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[186.722791] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[186.725117] Starting dynamic subtest: pipe-A-eDP-1
[186.771836] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.049s)
[186.781589] Starting dynamic subtest: pipe-B-eDP-1
[186.820481] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.048s)
[186.829570] Starting dynamic subtest: pipe-C-eDP-1
[186.869428] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.048s)
[186.878370] Starting dynamic subtest: pipe-D-eDP-1
[186.917878] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.048s)
[186.920224] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.196s)
[189.060698] [024/130] (872s left) kms_vrr (negative-basic)
[189.161589] Starting subtest: negative-basic
[189.168243] Starting dynamic subtest: pipe-A-eDP-1
[194.613155] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.453s)
[194.891880] Subtest negative-basic: SUCCESS (5.738s)
[195.676405] [025/130] (866s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[195.786685] Starting subtest: 4-tiled-16bpp-rotate-270
[195.805921] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[195.916652] [026/130] (865s left) perf_pmu (most-busy-idle-check-all)
[195.954046] Starting subtest: most-busy-idle-check-all
[195.955920] Starting dynamic subtest: rcs0
[197.687034] Dynamic subtest rcs0: SUCCESS (1.733s)
[197.702252] Starting dynamic subtest: bcs0
[199.671863] Dynamic subtest bcs0: SUCCESS (1.982s)
[199.684030] Starting dynamic subtest: vcs0
[201.654004] Dynamic subtest vcs0: SUCCESS (1.980s)
[201.665266] Starting dynamic subtest: vcs1
[203.702049] Dynamic subtest vcs1: SUCCESS (2.046s)
[203.713993] Starting dynamic subtest: vecs0
[205.685577] Dynamic subtest vecs0: SUCCESS (1.982s)
[205.696516] Starting dynamic subtest: ccs0
[207.670505] Dynamic subtest ccs0: SUCCESS (1.983s)
[207.673343] Subtest most-busy-idle-check-all: SUCCESS (11.716s)
[207.775040] [027/130] (854s left) kms_pm_backlight (brightness-with-dpms)
[207.881550] Starting subtest: brightness-with-dpms
[207.946322] Starting dynamic subtest: eDP-1
[210.446226] Dynamic subtest eDP-1: SUCCESS (2.502s)
[210.448679] Subtest brightness-with-dpms: SUCCESS (2.567s)
[211.308423] [028/130] (850s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[211.353611] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[211.457924] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.104s)
[211.531884] [029/130] (850s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[211.654560] Starting subtest: verify-pxp-key-change-after-suspend-resume
[218.711114] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.060s)
[218.825285] [030/130] (843s left) kms_pipe_crc_basic (suspend-read-crc)
[218.911626] Starting subtest: suspend-read-crc
[218.914106] Starting dynamic subtest: pipe-A-eDP-1
[236.599749] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.279s)
[236.609503] Starting dynamic subtest: pipe-B-eDP-1
[254.598067] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.905s)
[254.607811] Starting dynamic subtest: pipe-C-eDP-1
[272.539103] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.799s)
[272.547982] Starting dynamic subtest: pipe-D-eDP-1
[290.552807] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.761s)
[290.555224] Subtest suspend-read-crc: SUCCESS (10.747s)
[291.327214] [031/130] (770s left) sw_sync (alloc_merge_fence)
[291.363997] Starting subtest: alloc_merge_fence
[291.366294] Subtest alloc_merge_fence: SUCCESS (0.000s)
[291.420157] [032/130] (770s left) gem_exec_balancer (individual)
[291.467262] Starting subtest: individual
[292.870120] Subtest individual: SUCCESS (1.444s)
[293.181916] [033/130] (768s left) gem_create (hog-create)
[293.235831] Starting subtest: hog-create
[293.238573] Starting dynamic subtest: smem0
[325.902721] Dynamic subtest smem0: SUCCESS (32.856s)
[325.905438] Subtest hog-create: SUCCESS (32.857s)
[326.088949] [034/130] (736s left) gem_exec_reloc (basic-cpu-wc)
[326.159094] Subtest basic-cpu-wc: SKIP (0.000s)
[326.227043] [035/130] (735s left) gem_ctx_sseu (invalid-args)
[326.279926] Subtest invalid-args: SKIP (0.000s)
[326.343069] [036/130] (735s left) kms_flip (flip-vs-fences-interruptible)
[326.441326] Starting subtest: flip-vs-fences-interruptible
[326.446442] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[326.560149] [037/130] (735s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[326.664810] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[326.669513] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[326.772641] [038/130] (735s left) kms_prime (basic-crc-hybrid)
[326.854553] Subtest basic-crc-hybrid: SKIP (0.000s)
[326.937855] [039/130] (735s left) gem_softpin (allocator-fork)
[327.008065] Starting subtest: allocator-fork
[329.222317] Subtest allocator-fork: SUCCESS (2.210s)
[329.364197] [040/130] (733s left) sw_sync (sync_multi_producer_single_consumer)
[329.397860] Starting subtest: sync_multi_producer_single_consumer
[330.472562] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[330.534640] [041/130] (731s left) core_auth (getclient-simple)
[330.569510] Starting subtest: getclient-simple
[330.578543] Subtest getclient-simple: SUCCESS (0.012s)
[330.701416] [042/130] (731s left) gem_ctx_create (basic)
[330.763440] Starting subtest: basic
[330.766060] Subtest basic: SUCCESS (0.000s)
[330.946518] [043/130] (731s left) gem_exec_reloc (basic-softpin)
[331.010664] Subtest basic-softpin: SKIP (0.000s)
[331.107364] [044/130] (731s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[331.224777] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[337.810790] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.586s)
[337.944682] [045/130] (724s left) i915_drm_fdinfo (idle)
[337.982971] Starting subtest: idle
[337.985661] Starting dynamic subtest: rcs0
[338.562559] Dynamic subtest rcs0: SUCCESS (0.577s)
[338.579055] Starting dynamic subtest: bcs0
[339.067578] Dynamic subtest bcs0: SUCCESS (0.504s)
[339.077828] Starting dynamic subtest: vcs0
[339.573035] Dynamic subtest vcs0: SUCCESS (0.503s)
[339.582806] Starting dynamic subtest: vcs1
[340.078548] Dynamic subtest vcs1: SUCCESS (0.503s)
[340.089581] Starting dynamic subtest: vecs0
[340.584148] Dynamic subtest vecs0: SUCCESS (0.503s)
[340.594956] Starting dynamic subtest: ccs0
[341.089396] Dynamic subtest ccs0: SUCCESS (0.503s)
[341.092324] Subtest idle: SUCCESS (3.106s)
[341.164253] [046/130] (721s left) gem_exec_schedule (timeslicing)
[341.239612] Starting subtest: timeslicing
[341.242084] Starting dynamic subtest: rcs0
[341.252043] Dynamic subtest rcs0: SUCCESS (0.025s)
[341.262592] Starting dynamic subtest: bcs0
[341.273758] Dynamic subtest bcs0: SUCCESS (0.021s)
[341.283329] Starting dynamic subtest: vcs0
[341.297109] Dynamic subtest vcs0: SUCCESS (0.022s)
[341.305571] Starting dynamic subtest: vcs1
[341.320128] Dynamic subtest vcs1: SUCCESS (0.023s)
[341.328595] Starting dynamic subtest: vecs0
[341.346150] Dynamic subtest vecs0: SUCCESS (0.025s)
[341.359420] Starting dynamic subtest: ccs0
[341.373552] Dynamic subtest ccs0: SUCCESS (0.027s)
[341.376221] Subtest timeslicing: SUCCESS (0.147s)
[342.866568] [047/130] (719s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[342.966504] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[342.971530] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[343.080473] [048/130] (719s left) kms_invalid_mode (zero-vdisplay)
[343.181764] Starting subtest: zero-vdisplay
[343.184314] Starting dynamic subtest: pipe-A-eDP-1
[343.463550] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[343.473791] Starting dynamic subtest: pipe-B-eDP-1
[343.476286] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[343.484677] Starting dynamic subtest: pipe-C-eDP-1
[343.487197] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[343.495795] Starting dynamic subtest: pipe-D-eDP-1
[343.498247] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[343.500686] Subtest zero-vdisplay: SUCCESS (0.288s)
[344.289878] [049/130] (718s left) kms_dsc (dsc-with-bpc)
[344.378749] Starting subtest: dsc-with-bpc
[344.417248] Subtest dsc-with-bpc: SKIP (0.001s)
[344.454054] [050/130] (718s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[344.544646] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[344.547499] Starting dynamic subtest: pipe-A-eDP-1
[344.558166] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[344.568932] Starting dynamic subtest: pipe-B-eDP-1
[344.578797] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[344.588610] Starting dynamic subtest: pipe-C-eDP-1
[344.598198] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[344.607548] Starting dynamic subtest: pipe-D-eDP-1
[344.617289] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[344.621812] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[346.758990] [051/130] (716s left) kms_psr (psr2-sprite-mmap-cpu)
[346.849258] Starting subtest: psr2-sprite-mmap-cpu
[346.851508] Starting dynamic subtest: eDP-1
[348.549102] Dynamic subtest eDP-1: SUCCESS (1.698s)
[348.551639] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.699s)
[349.413909] [052/130] (713s left) kms_psr (pr-primary-blt)
[349.524682] Starting subtest: pr-primary-blt
[349.529811] Subtest pr-primary-blt: SKIP (0.000s)
[349.595541] [053/130] (713s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[349.697428] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[350.553100] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.859s)
[350.734388] [054/130] (712s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[350.842578] Starting subtest: y-tiled-32bpp-rotate-90
[350.847236] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[350.932386] [055/130] (712s left) gem_mmap_gtt (ptrace)
[350.994618] Subtest ptrace: SKIP (0.000s)
[351.061788] [056/130] (711s left) perf (invalid-create-userspace-config)
[351.173433] Starting subtest: invalid-create-userspace-config
[351.175765] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[351.215389] [057/130] (711s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[351.371347] Starting subtest: cursor-rapid-movement-32x32
[351.416337] Subtest cursor-rapid-movement-32x32: SKIP (0.038s)
[351.684998] [058/130] (711s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[351.786207] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[359.215293] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.432s)
[359.360634] [059/130] (703s left) kms_cursor_legacy (single-bo)
[359.485078] Starting subtest: single-bo
[359.487397] Starting dynamic subtest: pipe-A
[364.866535] Dynamic subtest pipe-A: SUCCESS (5.380s)
[364.877178] Starting dynamic subtest: pipe-B
[370.247211] Dynamic subtest pipe-B: SUCCESS (5.379s)
[370.259494] Starting dynamic subtest: pipe-C
[375.627164] Dynamic subtest pipe-C: SUCCESS (5.379s)
[375.639454] Starting dynamic subtest: pipe-D
[381.010519] Dynamic subtest pipe-D: SUCCESS (5.382s)
[381.022417] Starting dynamic subtest: all-pipes
[386.399840] Dynamic subtest all-pipes: SUCCESS (5.387s)
[386.402459] Subtest single-bo: SUCCESS (26.917s)
[386.548999] [060/130] (676s left) kms_getfb (getfb-handle-zero)
[386.635417] Starting subtest: getfb-handle-zero
[386.637937] Subtest getfb-handle-zero: SUCCESS (0.000s)
[386.734303] [061/130] (676s left) kms_setmode (invalid-clone-exclusive-crtc)
[386.785718] Starting subtest: invalid-clone-exclusive-crtc
[386.793432] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[386.887451] [062/130] (676s left) syncobj_wait (single-wait-all-for-submit-submitted)
[386.946638] Starting subtest: single-wait-all-for-submit-submitted
[387.046668] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.101s)
[387.123300] [063/130] (676s left) i915_suspend (fence-restore-untiled)
[387.169246] Starting subtest: fence-restore-untiled
[387.174377] Subtest fence-restore-untiled: SKIP (0.000s)
[387.264324] [064/130] (676s left) kms_fbcon_fbt (fbc-suspend)
[387.309012] Starting subtest: fbc-suspend
[437.065739] Subtest fbc-suspend: SUCCESS (18.906s)
[438.168956] [065/130] (625s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[438.564862] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[439.361550] [066/130] (624s left) vgem_basic (sysfs)
[439.397151] Starting subtest: sysfs
[439.399306] Subtest sysfs: SUCCESS (0.000s)
[439.453014] [067/130] (624s left) perf_pmu (all-busy-idle-check-all)
[439.490147] Starting subtest: all-busy-idle-check-all
[440.191607] Subtest all-busy-idle-check-all: FAIL (0.663s)
[441.023289] [068/130] (622s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[441.112202] Starting subtest: primary-y-tiled-reflect-x-270
[441.116684] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[441.188052] [069/130] (622s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[441.275160] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[441.285996] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[441.363619] [070/130] (622s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[441.451140] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[441.453690] Starting dynamic subtest: pipe-A-default-mode
[441.743631] Dynamic subtest pipe-A-default-mode: SKIP (0.293s)
[441.748481] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.295s)
[442.548362] [071/130] (621s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[442.643301] Starting subtest: random-ccs-data-y-tiled-ccs
[442.645746] Starting dynamic subtest: pipe-A-eDP-1
[442.672603] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[442.681695] Starting dynamic subtest: pipe-B-eDP-1
[442.707634] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[442.716505] Starting dynamic subtest: pipe-C-eDP-1
[442.741382] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[442.750130] Starting dynamic subtest: pipe-D-eDP-1
[442.775395] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[442.779936] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[444.767954] [072/130] (618s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[444.860723] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[444.870394] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.010s)
[444.985281] [073/130] (618s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[445.040723] Starting subtest: yf-tiled-to-vebox-yf-tiled
[445.046061] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[445.224120] [074/130] (618s left) gem_exec_create (forked)
[445.284693] Starting subtest: forked
[445.287259] Starting dynamic subtest: smem
[465.969717] Dynamic subtest smem: SUCCESS (20.771s)
[465.972746] Subtest forked: SUCCESS (20.772s)
[466.155707] [075/130] (597s left) gem_lmem_swapping (parallel-random-verify-ccs)
[466.196520] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[466.240512] [076/130] (597s left) gem_partial_pwrite_pread (reads-display)
[466.306436] Subtest reads-display: SKIP (0.000s)
[466.382238] [077/130] (597s left) kms_content_protection (lic-type-0)
[466.544588] Starting subtest: lic-type-0
[469.894237] Subtest lic-type-0: SKIP (3.351s)
[471.065321] [078/130] (592s left) gen9_exec_parse (bb-start-far)
[471.113750] Subtest bb-start-far: SKIP (0.000s)
[471.190160] [079/130] (592s left) gem_create (create-ext-cpu-access-big)
[471.353366] Starting subtest: create-ext-cpu-access-big
[471.359566] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[471.433267] [080/130] (592s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[471.557595] Starting subtest: cursorB-vs-flipA-toggle
[471.562433] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[471.701104] [081/130] (592s left) kms_fb_coherency (memset-crc)
[471.800638] Starting subtest: memset-crc
[471.802885] Starting dynamic subtest: mmap-offset-wc
[472.199185] Dynamic subtest mmap-offset-wc: SUCCESS (0.399s)
[472.488007] Starting dynamic subtest: mmap-offset-uc
[478.553517] Dynamic subtest mmap-offset-uc: SUCCESS (6.072s)
[478.847605] Subtest memset-crc: SUCCESS (7.043s)
[479.719354] [082/130] (584s left) gem_exec_gttfill (engines)
[479.786454] Starting subtest: engines
[479.789013] Starting dynamic subtest: rcs0
[504.304351] Dynamic subtest rcs0: SUCCESS (24.516s)
[504.317302] Starting dynamic subtest: bcs0
[529.633738] Dynamic subtest bcs0: SUCCESS (25.335s)
[529.643856] Starting dynamic subtest: vcs0
[554.760934] Dynamic subtest vcs0: SUCCESS (25.119s)
[554.771053] Starting dynamic subtest: vcs1
[579.909707] Dynamic subtest vcs1: SUCCESS (25.146s)
[579.921980] Starting dynamic subtest: vecs0
[605.043715] Dynamic subtest vecs0: SUCCESS (25.135s)
[605.056284] Starting dynamic subtest: ccs0
[630.101015] Dynamic subtest ccs0: SUCCESS (25.060s)
[630.103710] Subtest engines: SUCCESS (150.322s)
[630.288115] [083/130] (433s left) gem_mmap_gtt (basic)
[630.399425] Subtest basic: SKIP (0.000s)
[630.469376] [084/130] (433s left) kms_cursor_crc (cursor-onscreen-128x42)
[630.689542] Starting subtest: cursor-onscreen-128x42
[630.732007] Subtest cursor-onscreen-128x42: SKIP (0.037s)
[630.964849] [085/130] (433s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[631.070641] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[631.075691] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[631.188432] [086/130] (433s left) kms_pm_dc (dc5-psr)
[632.301291] Starting subtest: dc5-psr
[635.179288] Subtest dc5-psr: SUCCESS (2.876s)
[636.017544] [087/130] (428s left) core_getstats
[636.174924] [088/130] (428s left) i915_pm_freq_api (freq-reset-multiple)
[636.226486] Starting subtest: freq-reset-multiple
[636.229375] Starting dynamic subtest: gt0
[645.831362] Dynamic subtest gt0: SUCCESS (9.604s)
[645.842711] Starting dynamic subtest: gt1
[654.146379] Dynamic subtest gt1: SUCCESS (8.315s)
[654.149014] Subtest freq-reset-multiple: SUCCESS (17.920s)
[654.221360] [089/130] (410s left) gem_ctx_persistence (engines-hang)
[654.291280] Starting subtest: engines-hang
[654.293588] Starting dynamic subtest: rcs0
[654.452992] Dynamic subtest rcs0: SUCCESS (0.161s)
[654.464511] Starting dynamic subtest: bcs0
[654.574952] Dynamic subtest bcs0: SUCCESS (0.120s)
[654.587586] Starting dynamic subtest: vcs0
[654.695626] Dynamic subtest vcs0: SUCCESS (0.119s)
[654.707751] Starting dynamic subtest: vcs1
[654.816157] Dynamic subtest vcs1: SUCCESS (0.118s)
[654.827701] Starting dynamic subtest: vecs0
[654.928144] Dynamic subtest vecs0: SUCCESS (0.110s)
[654.941604] Starting dynamic subtest: ccs0
[655.005209] Dynamic subtest ccs0: SUCCESS (0.075s)
[655.007866] Subtest engines-hang: SUCCESS (0.714s)
[655.145278] [090/130] (409s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[655.262381] Starting subtest: cursor-vs-flip-legacy
[684.594356] Subtest cursor-vs-flip-legacy: SUCCESS (29.327s)
[685.443340] [091/130] (379s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[685.542108] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[685.547513] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[685.662846] [092/130] (378s left) kms_panel_fitting (atomic-fastset)
[685.756409] Starting subtest: atomic-fastset
[685.758858] Starting dynamic subtest: pipe-A-eDP-1
[685.916919] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.159s)
[685.929145] Starting dynamic subtest: pipe-B-eDP-1
[687.192294] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.274s)
[687.202877] Starting dynamic subtest: pipe-C-eDP-1
[688.371530] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.177s)
[688.382351] Starting dynamic subtest: pipe-D-eDP-1
[689.501640] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[689.504628] Subtest atomic-fastset: SUCCESS (3.743s)
[690.740486] [093/130] (373s left) gem_ctx_param (invalid-param-set)
[690.793959] Starting subtest: invalid-param-set
[690.796637] Subtest invalid-param-set: SUCCESS (0.000s)
[690.871379] [094/130] (373s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[690.974231] Starting subtest: yf-tiled-8bpp-rotate-0
[690.979414] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[691.078634] [095/130] (373s left) api_intel_bb (crc32)
[691.134751] Starting subtest: crc32
[691.136903] Starting dynamic subtest: rcs0-smem0
[691.405437] Dynamic subtest rcs0-smem0: SUCCESS (0.270s)
[691.416888] Starting dynamic subtest: bcs0-smem0
[691.723566] Dynamic subtest bcs0-smem0: SUCCESS (0.316s)
[691.734833] Starting dynamic subtest: vcs0-smem0
[692.057061] Dynamic subtest vcs0-smem0: SUCCESS (0.333s)
[692.070283] Starting dynamic subtest: vcs1-smem0
[692.376627] Dynamic subtest vcs1-smem0: SUCCESS (0.317s)
[692.386765] Starting dynamic subtest: vecs0-smem0
[692.728191] Dynamic subtest vecs0-smem0: SUCCESS (0.349s)
[692.740993] Starting dynamic subtest: ccs0-smem0
[693.034976] Dynamic subtest ccs0-smem0: SUCCESS (0.304s)
[693.037711] Subtest crc32: SUCCESS (1.901s)
[693.169542] [096/130] (371s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[693.270564] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[696.923631] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.657s)
[698.123365] [097/130] (366s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[698.219690] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[698.224642] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[698.316542] [098/130] (366s left) syncobj_timeline (single-wait-all-available-signaled)
[698.380634] Starting subtest: single-wait-all-available-signaled
[698.382998] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[698.500908] [099/130] (366s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[698.602455] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[698.607492] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[698.689499] [100/130] (366s left) perf (global-sseu-config-invalid)
[698.791182] Starting subtest: global-sseu-config-invalid
[698.796453] Subtest global-sseu-config-invalid: SKIP (0.000s)
[698.837110] [101/130] (366s left) gem_sync (basic-many-each)
[698.911534] Starting subtest: basic-many-each
[701.192723] Subtest basic-many-each: SUCCESS (2.293s)
[701.380109] [102/130] (363s left) kms_psr (fbc-pr-dpms)
[701.472655] Starting subtest: fbc-pr-dpms
[701.477900] Subtest fbc-pr-dpms: SKIP (0.000s)
[701.541217] [103/130] (363s left) gem_userptr_blits (map-fixed-invalidate-busy)
[701.614361] Starting subtest: map-fixed-invalidate-busy
[701.618759] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[701.756766] [104/130] (363s left) kms_chamelium_color (ctm-green-to-red)
[701.848492] Subtest ctm-green-to-red: SKIP (0.000s)
[701.896110] [105/130] (363s left) gem_softpin (evict-snoop)
[701.959121] Starting subtest: evict-snoop
[701.964539] Subtest evict-snoop: SKIP (0.000s)
[702.089939] [106/130] (363s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[702.193052] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[709.484524] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.294s)
[709.612369] [107/130] (355s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[709.717470] Starting subtest: x-tiled-64bpp-rotate-90
[709.736786] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[709.872256] [108/130] (355s left) gem_exec_flush (basic-wb-ro-default)
[709.938729] Starting subtest: basic-wb-ro-default
[715.388767] Subtest basic-wb-ro-default: SUCCESS (5.448s)
[715.575843] [109/130] (349s left) gem_exec_whisper (basic-fds-all)
[715.647264] Starting subtest: basic-fds-all
[727.208594] Subtest basic-fds-all: SUCCESS (11.557s)
[727.394583] [110/130] (337s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[727.501473] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[727.504011] Starting dynamic subtest: pipe-A-default-mode
[727.794305] Dynamic subtest pipe-A-default-mode: SKIP (0.290s)
[727.799796] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.291s)
[728.646069] [111/130] (336s left) gem_render_copy (y-tiled)
[728.716589] Starting subtest: y-tiled
[728.722447] Subtest y-tiled: SKIP (0.000s)
[728.906360] [112/130] (336s left) kms_psr (psr2-primary-page-flip)
[728.998582] Starting subtest: psr2-primary-page-flip
[729.001285] Starting dynamic subtest: eDP-1
[730.723523] Dynamic subtest eDP-1: SUCCESS (1.722s)
[730.725955] Subtest psr2-primary-page-flip: SUCCESS (1.723s)
[731.596447] [113/130] (333s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[731.659347] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[731.661860] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[731.775192] [114/130] (333s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[731.843050] Starting subtest: single-wait-all-for-submit-signaled
[731.845631] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[731.936470] [115/130] (333s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[732.042519] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[739.165751] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.128s)
[739.356685] [116/130] (326s left) gem_exec_params (dr1-dirt)
[739.413143] Starting subtest: DR1-dirt
[739.415423] Subtest DR1-dirt: SUCCESS (0.000s)
[739.531056] [117/130] (326s left) kms_plane_lowres (tiling-4)
[739.624446] Starting subtest: tiling-4
[739.627179] Starting dynamic subtest: pipe-A-eDP-1
[739.632252] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[739.920504] Starting dynamic subtest: pipe-B-eDP-1
[739.925283] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[739.935720] Starting dynamic subtest: pipe-C-eDP-1
[739.940635] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[739.950998] Starting dynamic subtest: pipe-D-eDP-1
[739.955410] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[739.960581] Subtest tiling-4: SKIP (0.289s)
[740.713091] [118/130] (324s left) gem_spin_batch (legacy-resubmit)
[740.777216] Starting subtest: legacy-resubmit
[740.779480] Starting dynamic subtest: default
[740.784061] Dynamic subtest default: SUCCESS (0.006s)
[740.793661] Starting dynamic subtest: render
[740.796105] Dynamic subtest render: SUCCESS (0.001s)
[740.807033] Starting dynamic subtest: bsd
[740.809691] Dynamic subtest bsd: SUCCESS (0.004s)
[740.819525] Starting dynamic subtest: bsd1
[740.822197] Dynamic subtest bsd1: SUCCESS (0.004s)
[740.832559] Starting dynamic subtest: bsd2
[740.835190] Dynamic subtest bsd2: SUCCESS (0.001s)
[740.844579] Starting dynamic subtest: blt
[740.847195] Dynamic subtest blt: SUCCESS (0.003s)
[740.856608] Starting dynamic subtest: vebox
[740.859555] Dynamic subtest vebox: SUCCESS (0.003s)
[740.862236] Subtest legacy-resubmit: SUCCESS (0.028s)
[741.050261] [119/130] (324s left) kms_color (ctm-0-25)
[741.143466] Starting subtest: ctm-0-25
[741.146531] Starting dynamic subtest: pipe-A-eDP-1
[744.690969] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.547s)
[744.706522] Starting dynamic subtest: pipe-B-eDP-1
[748.761961] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.068s)
[748.774900] Starting dynamic subtest: pipe-C-eDP-1
[752.676354] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.914s)
[752.688992] Starting dynamic subtest: pipe-D-eDP-1
[756.652854] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.977s)
[756.655099] Subtest ctm-0-25: SUCCESS (15.508s)
[757.503073] [120/130] (308s left) gem_mmap_gtt (basic-write-read)
[757.565434] Subtest basic-write-read: SKIP (0.000s)
[757.629616] [121/130] (308s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[757.686594] Starting subtest: invalid-single-wait-unsubmitted
[757.689464] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[757.792280] [122/130] (308s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[757.892394] Starting subtest: fbc-psr-cursor-mmap-cpu
[757.894889] Starting dynamic subtest: eDP-1
[757.899418] Dynamic subtest eDP-1: SKIP (0.000s)
[757.904124] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[757.971852] [123/130] (307s left) kms_selftest (drm_format_helper)
[758.011849] Starting subtest: drm_format_helper
[758.067360] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[758.222615] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.155s)
[758.232428] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[758.371949] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.147s)
[758.383415] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[758.488309] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.116s)
[758.498643] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[758.639497] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.149s)
[758.650295] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[758.771432] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.131s)
[758.781489] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[758.908467] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.138s)
[758.921141] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[759.042353] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.134s)
[759.053386] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[759.169276] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.126s)
[759.179534] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[759.302308] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.131s)
[759.312011] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[759.430695] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.126s)
[759.441548] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[759.561000] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.130s)
[759.571427] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[759.709441] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.146s)
[759.719323] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[759.848105] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.140s)
[759.859596] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[759.988250] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.138s)
[760.000574] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[760.142548] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.155s)
[760.155281] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[760.292078] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.147s)
[760.304397] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[760.456551] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.164s)
[760.458575] Subtest drm_format_helper: SUCCESS (2.443s)
[760.657458] [124/130] (305s left) gem_wait (invalid-buf)
[760.719167] Starting subtest: invalid-buf
[760.721693] Subtest invalid-buf: SUCCESS (0.000s)
[760.918207] [125/130] (305s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[761.053582] Starting subtest: flip-vs-cursor-crc-legacy
[761.688853] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.636s)
[762.534086] [126/130] (303s left) kms_getfb (getfb2-into-addfb2)
[762.631431] Starting subtest: getfb2-into-addfb2
[762.633884] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[762.730065] [127/130] (303s left) gem_mmap_offset (open-flood)
[762.793482] Starting subtest: open-flood
[784.279281] Subtest open-flood: SUCCESS (21.489s)
[784.411002] [128/130] (281s left) prime_vgem (fence-wait)
[784.503303] Starting subtest: fence-wait
[784.505057] Starting dynamic subtest: rcs0
[785.563574] Dynamic subtest rcs0: SUCCESS (1.060s)
[785.576736] Starting dynamic subtest: bcs0
[786.651492] Dynamic subtest bcs0: SUCCESS (1.088s)
[786.664748] Starting dynamic subtest: vcs0
[787.694176] Dynamic subtest vcs0: SUCCESS (1.042s)
[787.707596] Starting dynamic subtest: vcs1
[788.736866] Dynamic subtest vcs1: SUCCESS (1.041s)
[788.750365] Starting dynamic subtest: vecs0
[789.780070] Dynamic subtest vecs0: SUCCESS (1.042s)
[789.793638] Starting dynamic subtest: ccs0
[790.951022] Dynamic subtest ccs0: SUCCESS (1.170s)
[790.953851] Subtest fence-wait: SUCCESS (6.449s)
[791.095500] [129/130] (275s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[791.204230] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[791.209465] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[791.320367] [130/130] (274s left) gem_vm_create (isolation)
[791.379640] Starting subtest: isolation
[791.388704] Subtest isolation: SUCCESS (0.008s)
[791.501297] Closing watchdogs
results: parsing output: 0/ for test: kms_busy
results: parsing output: 1/ for test: gem_ctx_sseu
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: kms_draw_crc
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_plane_scaling
results: parsing output: 8/ for test: gem_userptr_blits
results: parsing output: 9/ for test: gem_userptr_blits
results: parsing output: 10/ for test: kms_sequence
results: parsing output: 11/ for test: fbdev
results: parsing output: 12/ for test: kms_async_flips
results: parsing output: 13/ for test: kms_lease
results: parsing output: 14/ for test: i915_pm_rpm
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_psr2_sf
results: parsing output: 19/ for test: gem_exec_fence
results: parsing output: 20/ for test: gem_exec_schedule
results: parsing output: 21/ for test: kms_psr2_sf
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_vrr
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: perf_pmu
results: parsing output: 26/ for test: kms_pm_backlight
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: gem_pxp
results: parsing output: 29/ for test: kms_pipe_crc_basic
results: parsing output: 30/ for test: sw_sync
results: parsing output: 31/ for test: gem_exec_balancer
results: parsing output: 32/ for test: gem_create
results: parsing output: 33/ for test: gem_exec_reloc
results: parsing output: 34/ for test: gem_ctx_sseu
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_prime
results: parsing output: 38/ for test: gem_softpin
results: parsing output: 39/ for test: sw_sync
results: parsing output: 40/ for test: core_auth
results: parsing output: 41/ for test: gem_ctx_create
results: parsing output: 42/ for test: gem_exec_reloc
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: i915_drm_fdinfo
results: parsing output: 45/ for test: gem_exec_schedule
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_invalid_mode
results: parsing output: 48/ for test: kms_dsc
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: gem_mmap_gtt
results: parsing output: 55/ for test: perf
results: parsing output: 56/ for test: kms_cursor_crc
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_cursor_legacy
results: parsing output: 59/ for test: kms_getfb
results: parsing output: 60/ for test: kms_setmode
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: i915_suspend
results: parsing output: 63/ for test: kms_fbcon_fbt
results: parsing output: 64/ for test: kms_chamelium_hpd
results: parsing output: 65/ for test: vgem_basic
results: parsing output: 66/ for test: perf_pmu
results: parsing output: 67/ for test: kms_rotation_crc
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: kms_flip_scaled_crc
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: gem_render_copy
results: parsing output: 73/ for test: gem_exec_create
results: parsing output: 74/ for test: gem_lmem_swapping
results: parsing output: 75/ for test: gem_partial_pwrite_pread
results: parsing output: 76/ for test: kms_content_protection
results: parsing output: 77/ for test: gen9_exec_parse
results: parsing output: 78/ for test: gem_create
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: kms_fb_coherency
results: parsing output: 81/ for test: gem_exec_gttfill
results: parsing output: 82/ for test: gem_mmap_gtt
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_pm_dc
results: parsing output: 86/ for test: core_getstats
results: parsing output: 87/ for test: i915_pm_freq_api
results: parsing output: 88/ for test: gem_ctx_persistence
results: parsing output: 89/ for test: kms_cursor_legacy
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_panel_fitting
results: parsing output: 92/ for test: gem_ctx_param
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: api_intel_bb
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: perf
results: parsing output: 100/ for test: gem_sync
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: gem_userptr_blits
results: parsing output: 103/ for test: kms_chamelium_color
results: parsing output: 104/ for test: gem_softpin
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: gem_exec_flush
results: parsing output: 108/ for test: gem_exec_whisper
results: parsing output: 109/ for test: kms_flip_scaled_crc
results: parsing output: 110/ for test: gem_render_copy
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_exec_params
results: parsing output: 116/ for test: kms_plane_lowres
results: parsing output: 117/ for test: gem_spin_batch
results: parsing output: 118/ for test: kms_color
results: parsing output: 119/ for test: gem_mmap_gtt
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_selftest
results: parsing output: 123/ for test: gem_wait
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: kms_getfb
results: parsing output: 126/ for test: gem_mmap_offset
results: parsing output: 127/ for test: prime_vgem
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_vm_create
Done.