[63.647190] Initializing watchdogs
[63.647236]   /dev/watchdog0
[63.660883] [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]
[63.665200] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[63.667546] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.671285] [001/133] (960s left) gem_ctx_sseu (invalid-args)
[63.764227] Subtest invalid-args: SKIP (0.000s)
[63.823535] [002/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[63.940310] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[63.944408] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[64.020524] [003/133] (960s left) kms_legacy_colorkey (invalid-plane)
[64.102092] Starting subtest: invalid-plane
[64.104045] Starting dynamic subtest: zero-id
[64.105993] Dynamic subtest zero-id: SUCCESS (0.000s)
[64.112269] Starting dynamic subtest: outrange-id
[64.114607] Dynamic subtest outrange-id: SUCCESS (0.000s)
[64.116767] Subtest invalid-plane: SUCCESS (0.000s)
[64.166196] [004/133] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[64.268526] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[71.992102] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.716s)
[72.112227] [005/133] (952s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[72.201041] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[72.203431] Starting dynamic subtest: pipe-A-eDP-1
[72.226660] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[72.235792] Starting dynamic subtest: pipe-B-eDP-1
[72.257386] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[72.263765] Starting dynamic subtest: pipe-C-eDP-1
[72.285183] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[72.291569] Starting dynamic subtest: pipe-D-eDP-1
[72.313320] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[72.317317] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[74.518871] [006/133] (949s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[74.611878] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[74.616306] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[74.704226] [007/133] (949s left) kms_vblank (wait-forked)
[74.799088] Starting subtest: wait-forked
[74.801395] Starting dynamic subtest: pipe-A-eDP-1
[76.621137] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.821s)
[76.637247] Starting dynamic subtest: pipe-D-eDP-1
[79.129094] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.505s)
[79.131365] Subtest wait-forked: SUCCESS (4.329s)
[80.011373] [008/133] (944s left) gem_mmap_gtt (zero-extend)
[80.076768] Subtest zero-extend: SKIP (0.000s)
[80.128935] [009/133] (944s left) gem_userptr_blits (access-control)
[80.194077] Starting subtest: access-control
[80.198331] Subtest access-control: SKIP (0.000s)
[80.295334] [010/133] (944s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[80.391250] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[80.395095] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[80.481826] [011/133] (944s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[80.581779] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[80.585953] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[80.654743] [012/133] (943s left) syncobj_wait (multi-wait-all-submitted-signaled)
[80.720670] Starting subtest: multi-wait-all-submitted-signaled
[80.826751] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.105s)
[80.909354] [013/133] (943s left) gem_spin_batch (spin-all)
[80.967676] Starting subtest: spin-all
[80.982355] Subtest spin-all: SUCCESS (0.014s)
[82.938918] [014/133] (941s left) gem_exec_params (larger-than-life-batch)
[82.994180] Starting subtest: larger-than-life-batch
[85.105447] Subtest larger-than-life-batch: SUCCESS (2.109s)
[85.955032] [015/133] (938s left) kms_invalid_mode (bad-vsync-start)
[86.092276] Starting subtest: bad-vsync-start
[86.094626] Starting dynamic subtest: pipe-A-eDP-1
[86.377234] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[86.386575] Starting dynamic subtest: pipe-B-eDP-1
[86.388457] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[86.395296] Starting dynamic subtest: pipe-C-eDP-1
[86.397187] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[86.404307] Starting dynamic subtest: pipe-D-eDP-1
[86.406521] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[86.408634] Subtest bad-vsync-start: SUCCESS (0.292s)
[87.264878] [016/133] (937s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[87.380021] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[87.384513] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[87.464526] [017/133] (937s left) gen7_exec_parse (chained-batch)
[87.522391] Subtest chained-batch: SKIP (0.000s)
[87.584825] [018/133] (937s left) perf (blocking)
[87.745666] Starting subtest: blocking
[87.747847] Starting dynamic subtest: 0-rcs0
[97.757639] Dynamic subtest 0-rcs0: SUCCESS (10.009s)
[97.766491] Starting dynamic subtest: 1-vcs0
[107.782977] Dynamic subtest 1-vcs0: SUCCESS (10.023s)
[107.785868] Subtest blocking: SUCCESS (20.034s)
[107.827748] [019/133] (917s left) gem_ppgtt (blt-vs-render-ctx0)
[107.883560] Starting subtest: blt-vs-render-ctx0
[140.656316] Subtest blt-vs-render-ctx0: SUCCESS (32.768s)
[140.807211] [020/133] (884s left) kms_psr (psr-sprite-plane-move)
[140.945066] Starting subtest: psr-sprite-plane-move
[140.947433] Starting dynamic subtest: eDP-1
[142.684796] Dynamic subtest eDP-1: SUCCESS (1.741s)
[142.687267] Subtest psr-sprite-plane-move: SUCCESS (1.742s)
[143.503865] [021/133] (881s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[143.629816] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[152.764494] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.134s)
[153.626608] [022/133] (871s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[153.730709] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[153.735280] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[153.832425] [023/133] (871s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[153.930929] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[153.933277] Starting dynamic subtest: pipe-A-eDP-1
[153.955739] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[153.964141] Starting dynamic subtest: pipe-B-eDP-1
[153.985744] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[153.992833] Starting dynamic subtest: pipe-C-eDP-1
[154.014360] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[154.021161] Starting dynamic subtest: pipe-D-eDP-1
[154.042487] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[154.046626] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[156.101810] [024/133] (868s left) kms_psr (fbc-psr2-cursor-render)
[156.207938] Starting subtest: fbc-psr2-cursor-render
[156.210098] Starting dynamic subtest: eDP-1
[156.214297] Dynamic subtest eDP-1: SKIP (0.000s)
[156.218594] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[156.276487] [025/133] (868s left) kms_prime (basic-modeset-hybrid)
[156.361569] Subtest basic-modeset-hybrid: SKIP (0.000s)
[156.528231] [FACT kms_prime (basic-modeset-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[156.531252] [026/133] (868s left) syncobj_timeline (signal-array)
[156.590831] Starting subtest: signal-array
[156.593099] Subtest signal-array: SUCCESS (0.000s)
[156.689288] [027/133] (868s left) i915_pm_rpm (debugfs-read)
[158.208926] Starting subtest: debugfs-read
[159.374273] Subtest debugfs-read: SUCCESS (1.166s)
[159.753685] [028/133] (865s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[159.866083] Starting subtest: y-tiled-16bpp-rotate-270
[159.870315] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[159.949854] [029/133] (865s left) kms_cursor_crc (cursor-sliding-128x128)
[160.175469] Starting subtest: cursor-sliding-128x128
[160.177723] Starting dynamic subtest: pipe-A-eDP-1
[163.411142] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.233s)
[163.438300] Starting dynamic subtest: pipe-D-eDP-1
[167.344674] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.911s)
[167.346846] Subtest cursor-sliding-128x128: SUCCESS (7.169s)
[168.205450] [030/133] (857s left) gem_exec_balancer (parallel-keep-in-fence)
[168.461079] Starting subtest: parallel-keep-in-fence
[169.582684] Subtest parallel-keep-in-fence: SUCCESS (1.123s)
[169.701859] [031/133] (855s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[169.757334] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[169.821838] [032/133] (855s left) gem_pxp (fail-invalid-protected-context)
[169.945464] Starting subtest: fail-invalid-protected-context
[169.947527] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[170.049013] [033/133] (855s left) gem_exec_schedule (semaphore-user)
[170.125488] Starting subtest: semaphore-user
[170.175378] Subtest semaphore-user: SUCCESS (0.056s)
[171.964944] [034/133] (853s left) kms_pm_backlight (bad-brightness)
[172.068030] Starting subtest: bad-brightness
[172.117185] Starting dynamic subtest: eDP-1
[172.444624] Dynamic subtest eDP-1: SUCCESS (0.324s)
[172.446534] Subtest bad-brightness: SUCCESS (0.375s)
[173.245800] [035/133] (852s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[173.293615] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[173.374417] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.028s)
[173.413246] [036/133] (852s left) kms_color (deep-color)
[173.505673] Starting subtest: deep-color
[174.619472] Starting dynamic subtest: pipe-A-eDP-1-gamma
[175.349225] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.729s)
[175.357699] Starting dynamic subtest: pipe-A-eDP-1-degamma
[176.831722] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.484s)
[176.839634] Starting dynamic subtest: pipe-A-eDP-1-ctm
[178.254399] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.421s)
[179.037646] Starting dynamic subtest: pipe-B-eDP-1-gamma
[179.710571] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.682s)
[179.722886] Starting dynamic subtest: pipe-B-eDP-1-degamma
[181.135930] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.423s)
[181.144888] Starting dynamic subtest: pipe-B-eDP-1-ctm
[182.536641] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.401s)
[183.325328] Starting dynamic subtest: pipe-C-eDP-1-gamma
[184.005869] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.686s)
[184.016077] Starting dynamic subtest: pipe-C-eDP-1-degamma
[185.375601] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.370s)
[185.384888] Starting dynamic subtest: pipe-C-eDP-1-ctm
[186.800505] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.425s)
[187.611782] Starting dynamic subtest: pipe-D-eDP-1-gamma
[188.302061] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.695s)
[188.310066] Starting dynamic subtest: pipe-D-eDP-1-degamma
[189.678698] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.377s)
[189.688066] Starting dynamic subtest: pipe-D-eDP-1-ctm
[191.105070] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.425s)
[191.107333] Subtest deep-color: SUCCESS (17.598s)
[191.970065] [037/133] (833s left) gem_exec_balancer (full-pulse)
[192.032177] Starting subtest: full-pulse
[196.775526] Subtest full-pulse: SUCCESS (4.746s)
[197.120233] [038/133] (828s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[197.252489] Starting subtest: 2x-cursor-vs-flip-legacy
[197.257120] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[197.397856] [039/133] (828s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[197.454978] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[197.561863] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.107s)
[197.636195] [040/133] (828s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[197.737889] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[197.743112] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[197.837904] [041/133] (827s left) gem_exec_schedule (noreorder-priority)
[198.021831] Starting subtest: noreorder-priority
[198.024647] Starting dynamic subtest: rcs0
[199.166039] Dynamic subtest rcs0: SUCCESS (1.145s)
[199.178895] Starting dynamic subtest: vcs0
[200.921680] Dynamic subtest vcs0: SUCCESS (1.752s)
[200.933565] Starting dynamic subtest: vcs1
[202.904420] Dynamic subtest vcs1: SUCCESS (1.981s)
[202.915429] Starting dynamic subtest: vecs0
[204.881872] Dynamic subtest vecs0: SUCCESS (1.975s)
[204.893049] Starting dynamic subtest: ccs0
[206.026093] Dynamic subtest ccs0: SUCCESS (1.144s)
[206.028930] Subtest noreorder-priority: SUCCESS (8.006s)
[206.228443] [042/133] (819s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[206.333950] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[206.338302] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[206.404821] [043/133] (819s left) sw_sync (sync_busy_fork_unixsocket)
[206.440280] Starting subtest: sync_busy_fork_unixsocket
[206.446420] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s)
[206.502991] [044/133] (819s left) kms_pm_dc (dc6-psr)
[207.600120] Starting subtest: dc6-psr
[210.481480] Subtest dc6-psr: SUCCESS (2.880s)
[211.299741] [045/133] (814s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[211.394372] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[211.396680] Starting dynamic subtest: pipe-A-eDP-1
[211.733220] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.298s)
[211.740674] Starting dynamic subtest: pipe-B-eDP-1
[212.965896] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.237s)
[212.974596] Starting dynamic subtest: pipe-C-eDP-1
[214.165306] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.200s)
[214.174638] Starting dynamic subtest: pipe-D-eDP-1
[215.428838] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.260s)
[215.430810] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.001s)
[216.619865] [046/133] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[216.720674] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[216.724935] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[216.817197] [047/133] (809s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[216.920045] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[216.924196] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[216.997394] [048/133] (808s left) kms_flip (flip-vs-wf_vblank-interruptible)
[217.082344] Starting subtest: flip-vs-wf_vblank-interruptible
[217.084679] Starting dynamic subtest: A-eDP1
[218.973741] Dynamic subtest A-eDP1: SUCCESS (1.890s)
[218.983391] Starting dynamic subtest: B-eDP1
[220.906836] Dynamic subtest B-eDP1: SUCCESS (1.932s)
[220.919610] Starting dynamic subtest: C-eDP1
[222.829739] Dynamic subtest C-eDP1: SUCCESS (1.922s)
[222.840444] Starting dynamic subtest: D-eDP1
[224.673253] Dynamic subtest D-eDP1: SUCCESS (1.841s)
[224.678470] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.595s)
[225.903868] [049/133] (800s left) perf_pmu (busy-accuracy-2)
[225.943785] Starting subtest: busy-accuracy-2
[225.946636] Starting dynamic subtest: rcs0
[228.987045] Dynamic subtest rcs0: SUCCESS (3.042s)
[228.997641] Starting dynamic subtest: bcs0
[232.045458] Dynamic subtest bcs0: SUCCESS (3.056s)
[232.055944] Starting dynamic subtest: vcs0
[235.094070] Dynamic subtest vcs0: SUCCESS (3.046s)
[235.111748] Starting dynamic subtest: vcs1
[238.148102] Dynamic subtest vcs1: SUCCESS (3.051s)
[238.158631] Starting dynamic subtest: vecs0
[241.195829] Dynamic subtest vecs0: SUCCESS (3.046s)
[241.204317] Starting dynamic subtest: ccs0
[244.255406] Dynamic subtest ccs0: SUCCESS (3.056s)
[244.258029] Subtest busy-accuracy-2: SUCCESS (18.311s)
[244.370198] [050/133] (781s left) i915_suspend (basic-s3-without-i915)
[244.411256] Starting subtest: basic-s3-without-i915
[247.656936] Subtest basic-s3-without-i915: SKIP (3.240s)
[249.251623] [051/133] (776s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[249.355140] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[249.357481] Starting dynamic subtest: A-eDP1
[252.953561] Dynamic subtest A-eDP1: SUCCESS (3.596s)
[252.961841] Starting dynamic subtest: B-eDP1
[256.160492] Dynamic subtest B-eDP1: SUCCESS (3.206s)
[256.168602] Starting dynamic subtest: C-eDP1
[259.273043] Dynamic subtest C-eDP1: SUCCESS (3.109s)
[259.281770] Starting dynamic subtest: D-eDP1
[262.393885] Dynamic subtest D-eDP1: SUCCESS (3.120s)
[262.396193] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.039s)
[263.185124] [052/133] (762s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[263.247421] Starting subtest: multi-wait-for-submit-submitted-signaled
[263.249711] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[263.341164] [053/133] (762s left) gem_mmap_gtt (basic-copy)
[263.400024] Subtest basic-copy: SKIP (0.000s)
[263.467614] [054/133] (762s left) gem_ctx_persistence (engines-queued)
[263.535664] Starting subtest: engines-queued
[263.538081] Starting dynamic subtest: rcs0
[263.613806] Dynamic subtest rcs0: SUCCESS (0.077s)
[263.623534] Starting dynamic subtest: bcs0
[263.665507] Dynamic subtest bcs0: SUCCESS (0.050s)
[263.675593] Starting dynamic subtest: vcs0
[264.887423] Dynamic subtest vcs0: SUCCESS (1.217s)
[264.898796] Starting dynamic subtest: vcs1
[266.868082] Dynamic subtest vcs1: SUCCESS (1.977s)
[266.878827] Starting dynamic subtest: vecs0
[268.852953] Dynamic subtest vecs0: SUCCESS (1.981s)
[268.864694] Starting dynamic subtest: ccs0
[269.025242] Dynamic subtest ccs0: SUCCESS (0.171s)
[269.027773] Subtest engines-queued: SUCCESS (5.490s)
[269.134455] [055/133] (757s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[269.232889] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[269.237270] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[269.304135] [056/133] (757s left) kms_cursor_edge_walk (128x128-right-edge)
[269.395614] Starting subtest: 128x128-right-edge
[269.397777] Starting dynamic subtest: pipe-A-eDP-1
[272.858218] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.462s)
[272.866493] Starting dynamic subtest: pipe-D-eDP-1
[275.976928] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s)
[275.979136] Subtest 128x128-right-edge: SUCCESS (6.583s)
[276.777976] [057/133] (749s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[276.872190] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[278.075082] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.201s)
[278.208782] [058/133] (748s left) gem_mmap_wc (set-cache-level)
[278.266374] Subtest set-cache-level: SKIP (0.000s)
[278.320229] [059/133] (748s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[278.419362] Starting subtest: fbc-rgb101010-draw-pwrite
[283.974360] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.557s)
[285.097460] [060/133] (741s left) kms_prop_blob (invalid-set-prop-any)
[285.147928] Starting subtest: invalid-set-prop-any
[285.150136] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[285.241583] [061/133] (741s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[285.292815] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[285.297462] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[285.473580] [062/133] (741s left) gem_tiled_fence_blits (normal)
[285.541473] Subtest normal: SKIP (0.000s)
[285.603875] [063/133] (740s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[285.693156] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[286.328240] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.637s)
[286.491907] [064/133] (740s left) gem_pxp (reject-modify-context-protection-off-2)
[286.616569] Starting subtest: reject-modify-context-protection-off-2
[286.619056] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[286.721148] [065/133] (739s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[286.817232] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[286.821309] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[286.922204] [066/133] (739s left) kms_chamelium_hpd (dp-hpd-storm)
[287.305494] Subtest dp-hpd-storm: SKIP (0.000s)
[288.086973] [067/133] (738s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[288.195672] Starting subtest: addfb25-y-tiled-small-legacy
[288.199900] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[288.291794] [068/133] (738s left) dumb_buffer (map-invalid-size)
[288.346561] Starting subtest: map-invalid-size
[288.349078] Subtest map-invalid-size: SUCCESS (0.000s)
[288.460931] [069/133] (738s left) gem_watchdog (default-virtual)
[288.526423] Starting subtest: default-virtual
[294.799105] Subtest default-virtual: SUCCESS (6.283s)
[294.894327] [070/133] (731s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[295.002138] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[301.848967] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.850s)
[301.978315] [071/133] (724s left) gem_render_copy (linear)
[302.039818] Starting subtest: linear
[302.042229] Starting dynamic subtest: smem
[302.080915] Dynamic subtest smem: SUCCESS (0.040s)
[302.083434] Subtest linear: SUCCESS (0.041s)
[302.262663] [072/133] (724s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[302.362602] Starting subtest: psr-2p-primscrn-cur-indfb-move
[302.367065] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[302.456157] [073/133] (724s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[302.545308] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[311.896630] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.353s)
[312.035769] [074/133] (714s left) kms_chamelium_color (ctm-max)
[312.138281] Subtest ctm-max: SKIP (0.000s)
[312.185591] [075/133] (714s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[312.249590] Starting subtest: single-wait-all-for-submit-unsubmitted
[312.353469] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[312.431689] [076/133] (714s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[312.517569] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[319.833493] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.318s)
[319.967965] [077/133] (707s left) syncobj_wait (wait-any-snapshot)
[320.022937] Starting subtest: wait-any-snapshot
[320.103452] Subtest wait-any-snapshot: SUCCESS (0.081s)
[320.175360] [078/133] (707s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[320.267668] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[321.236030] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.968s)
[321.333409] [079/133] (705s left) kms_feature_discovery (psr1)
[321.422257] Starting subtest: psr1
[321.424502] Subtest psr1: SUCCESS (0.000s)
[321.492478] [080/133] (705s left) gem_busy (semaphore)
[321.679722] Subtest semaphore: SKIP (0.000s)
[321.887076] [081/133] (705s left) api_intel_bb (object-reloc-keep-cache)
[321.949175] Starting subtest: object-reloc-keep-cache
[321.953624] Subtest object-reloc-keep-cache: SKIP (0.002s)
[322.086058] [082/133] (705s left) kms_pipe_crc_basic (read-crc)
[322.181142] Starting subtest: read-crc
[322.183655] Starting dynamic subtest: pipe-A-eDP-1
[322.886460] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.704s)
[322.896165] Starting dynamic subtest: pipe-B-eDP-1
[324.215576] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.330s)
[324.224876] Starting dynamic subtest: pipe-C-eDP-1
[325.522791] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.306s)
[325.532096] Starting dynamic subtest: pipe-D-eDP-1
[326.844412] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.317s)
[326.846723] Subtest read-crc: SUCCESS (4.663s)
[327.659863] [083/133] (699s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[327.763808] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[327.768167] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[327.848740] [084/133] (699s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[327.901156] Starting subtest: legacy-engines-hostile-preempt
[327.903466] Starting dynamic subtest: render
[327.982796] Dynamic subtest render: SUCCESS (0.080s)
[327.994688] Starting dynamic subtest: bsd1
[329.934257] Dynamic subtest bsd1: SUCCESS (1.947s)
[329.945480] Starting dynamic subtest: bsd2
[331.916393] Dynamic subtest bsd2: SUCCESS (1.979s)
[331.927415] Starting dynamic subtest: blt
[331.975490] Dynamic subtest blt: SUCCESS (0.058s)
[331.988025] Starting dynamic subtest: vebox
[333.911331] Dynamic subtest vebox: SUCCESS (1.931s)
[333.913998] Subtest legacy-engines-hostile-preempt: SUCCESS (6.009s)
[333.989605] [085/133] (693s left) kms_content_protection (atomic-dpms-hdcp14)
[334.137711] Starting subtest: atomic-dpms-hdcp14
[334.142173] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[334.246357] [086/133] (693s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[334.335044] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[334.339224] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[334.405252] [087/133] (693s left) i915_drm_fdinfo (isolation)
[334.448102] Starting subtest: isolation
[334.449919] Starting dynamic subtest: rcs0
[334.464689] Dynamic subtest rcs0: SKIP (0.016s)
[334.472502] Starting dynamic subtest: bcs0
[334.483687] Dynamic subtest bcs0: SKIP (0.018s)
[334.491584] Starting dynamic subtest: vcs0
[334.495653] Dynamic subtest vcs0: SKIP (0.000s)
[334.504021] Starting dynamic subtest: vcs1
[334.508423] Dynamic subtest vcs1: SKIP (0.000s)
[334.516198] Starting dynamic subtest: vecs0
[334.520205] Dynamic subtest vecs0: SKIP (0.000s)
[334.527544] Starting dynamic subtest: ccs0
[334.531646] Dynamic subtest ccs0: SKIP (0.000s)
[334.535767] Subtest isolation: SKIP (0.039s)
[334.571254] [088/133] (693s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[334.665671] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[334.669776] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[334.772044] [089/133] (692s left) syncobj_wait (invalid-wait-illegal-handle)
[334.827611] Starting subtest: invalid-wait-illegal-handle
[334.829552] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[334.923079] [090/133] (692s left) kms_plane_multiple (tiling-none)
[335.019433] Starting subtest: tiling-none
[335.021181] Starting dynamic subtest: pipe-A-eDP-1
[338.687062] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.667s)
[338.695497] Starting dynamic subtest: pipe-B-eDP-1
[343.034291] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.347s)
[343.044446] Starting dynamic subtest: pipe-C-eDP-1
[347.366489] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.329s)
[347.375681] Starting dynamic subtest: pipe-D-eDP-1
[351.701554] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.333s)
[351.703951] Subtest tiling-none: SUCCESS (16.680s)
[352.511564] [091/133] (675s left) kms_psr (fbc-psr-sprite-render)
[352.606245] Starting subtest: fbc-psr-sprite-render
[352.608163] Starting dynamic subtest: eDP-1
[352.612249] Dynamic subtest eDP-1: SKIP (0.000s)
[352.616301] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[352.679818] [092/133] (675s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[352.736204] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[352.793780] [093/133] (674s left) kms_psr (psr2-dpms)
[352.883266] Starting subtest: psr2-dpms
[352.885572] Starting dynamic subtest: eDP-1
[355.739095] Dynamic subtest eDP-1: SUCCESS (2.856s)
[355.741482] Subtest psr2-dpms: SUCCESS (2.857s)
[356.617071] [094/133] (671s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[356.709067] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[356.719842] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.010s)
[356.823284] [095/133] (671s left) gem_exec_fence (keep-in-fence)
[357.007032] Starting subtest: keep-in-fence
[357.009844] Starting dynamic subtest: rcs0
[357.070924] Dynamic subtest rcs0: SUCCESS (0.064s)
[357.081829] Starting dynamic subtest: bcs0
[357.124599] Dynamic subtest bcs0: SUCCESS (0.051s)
[357.135544] Starting dynamic subtest: vcs0
[358.870887] Dynamic subtest vcs0: SUCCESS (1.742s)
[358.882072] Starting dynamic subtest: vcs1
[360.919310] Dynamic subtest vcs1: SUCCESS (2.045s)
[360.929807] Starting dynamic subtest: vecs0
[362.902512] Dynamic subtest vecs0: SUCCESS (1.981s)
[362.917729] Starting dynamic subtest: ccs0
[363.144048] Dynamic subtest ccs0: SUCCESS (0.239s)
[363.147074] Subtest keep-in-fence: SUCCESS (6.138s)
[364.938475] [096/133] (662s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[365.044357] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[365.048703] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[365.133136] [097/133] (662s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[365.226559] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[365.230683] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[365.323305] [098/133] (662s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[365.419121] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[365.421392] Starting dynamic subtest: pipe-A-eDP-1
[365.444573] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[365.455480] Starting dynamic subtest: pipe-B-eDP-1
[365.477104] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[365.485479] Starting dynamic subtest: pipe-C-eDP-1
[365.507241] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[365.515565] Starting dynamic subtest: pipe-D-eDP-1
[365.537992] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[365.542343] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[367.669187] [099/133] (660s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[367.757989] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[367.762326] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[367.827463] [100/133] (660s left) kms_atomic_interruptible (legacy-pageflip)
[367.916334] Starting subtest: legacy-pageflip
[367.918538] Starting dynamic subtest: pipe-A-eDP-1
[375.324194] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.407s)
[375.326627] Subtest legacy-pageflip: SUCCESS (7.409s)
[376.143879] [101/133] (651s left) perf_pmu (busy-idle-no-semaphores)
[376.191224] Starting subtest: busy-idle-no-semaphores
[376.193548] Starting dynamic subtest: rcs0
[376.843962] Dynamic subtest rcs0: SUCCESS (0.653s)
[376.853660] Starting dynamic subtest: bcs0
[377.497976] Dynamic subtest bcs0: SUCCESS (0.651s)
[377.509625] Starting dynamic subtest: vcs0
[378.150993] Dynamic subtest vcs0: SUCCESS (0.651s)
[378.162270] Starting dynamic subtest: vcs1
[379.517064] Dynamic subtest vcs1: SUCCESS (1.364s)
[379.528320] Starting dynamic subtest: vecs0
[381.502277] Dynamic subtest vecs0: SUCCESS (1.982s)
[381.513786] Starting dynamic subtest: ccs0
[383.553498] Dynamic subtest ccs0: SUCCESS (2.047s)
[383.556255] Subtest busy-idle-no-semaphores: SUCCESS (7.363s)
[383.671360] [102/133] (644s left) syncobj_timeline (invalid-transfer-bad-pad)
[383.730139] Starting subtest: invalid-transfer-bad-pad
[383.732463] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[383.839764] [103/133] (644s left) gem_exec_parallel (fds)
[383.912365] Starting subtest: fds
[383.914839] Starting dynamic subtest: rcs0
[387.171232] Dynamic subtest rcs0: SUCCESS (3.256s)
[387.182874] Starting dynamic subtest: bcs0
[390.308187] Dynamic subtest bcs0: SUCCESS (3.134s)
[390.327775] Starting dynamic subtest: vcs0
[394.195289] Dynamic subtest vcs0: SUCCESS (3.885s)
[394.206390] Starting dynamic subtest: vcs1
[398.190315] Dynamic subtest vcs1: SUCCESS (3.992s)
[398.201760] Starting dynamic subtest: vecs0
[402.152152] Dynamic subtest vecs0: SUCCESS (3.960s)
[402.163840] Starting dynamic subtest: ccs0
[405.631431] Dynamic subtest ccs0: SUCCESS (3.476s)
[405.634225] Subtest fds: SUCCESS (21.719s)
[405.830991] [104/133] (622s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[405.932512] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[405.936685] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[406.021989] [105/133] (622s left) gem_exec_schedule (u-submit-golden-slice)
[406.100751] Starting subtest: u-submit-golden-slice
[406.103020] Starting dynamic subtest: rcs0
[406.129070] Dynamic subtest rcs0: SUCCESS (0.035s)
[406.138553] Starting dynamic subtest: bcs0
[406.157217] Dynamic subtest bcs0: SUCCESS (0.028s)
[406.165592] Starting dynamic subtest: vcs0
[406.189831] Dynamic subtest vcs0: SUCCESS (0.031s)
[406.203514] Starting dynamic subtest: vcs1
[406.219605] Dynamic subtest vcs1: SUCCESS (0.030s)
[406.228891] Starting dynamic subtest: vecs0
[406.248468] Dynamic subtest vecs0: SUCCESS (0.028s)
[406.259254] Starting dynamic subtest: ccs0
[406.279846] Dynamic subtest ccs0: SUCCESS (0.031s)
[406.282097] Subtest u-submit-golden-slice: SUCCESS (0.186s)
[407.995844] [106/133] (620s left) kms_plane (plane-position-hole)
[408.087927] Starting subtest: plane-position-hole
[408.604461] Starting dynamic subtest: pipe-A-plane-1
[409.915755] Dynamic subtest pipe-A-plane-1: SUCCESS (1.311s)
[409.925036] Starting dynamic subtest: pipe-A-plane-2
[411.163077] Dynamic subtest pipe-A-plane-2: SUCCESS (1.245s)
[411.175158] Starting dynamic subtest: pipe-A-plane-3
[412.484401] Dynamic subtest pipe-A-plane-3: SUCCESS (1.323s)
[412.494186] Starting dynamic subtest: pipe-A-plane-4
[413.810065] Dynamic subtest pipe-A-plane-4: SUCCESS (1.325s)
[413.819178] Starting dynamic subtest: pipe-A-plane-5
[413.841367] Dynamic subtest pipe-A-plane-5: SUCCESS (0.029s)
[415.065296] Starting dynamic subtest: pipe-B-plane-1
[416.399070] Dynamic subtest pipe-B-plane-1: SUCCESS (1.340s)
[416.408603] Starting dynamic subtest: pipe-B-plane-2
[417.707175] Dynamic subtest pipe-B-plane-2: SUCCESS (1.305s)
[417.716774] Starting dynamic subtest: pipe-B-plane-3
[419.043018] Dynamic subtest pipe-B-plane-3: SUCCESS (1.336s)
[419.051696] Starting dynamic subtest: pipe-B-plane-4
[420.410296] Dynamic subtest pipe-B-plane-4: SUCCESS (1.368s)
[420.419628] Starting dynamic subtest: pipe-B-plane-5
[420.435899] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[420.438109] Subtest plane-position-hole: SUCCESS (12.348s)
[421.254862] [107/133] (607s left) kms_getfb (getfb-addfb-different-handles)
[421.346156] Starting subtest: getfb-addfb-different-handles
[421.348445] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[421.463232] [108/133] (606s left) kms_sequence (get-forked)
[421.561255] Starting subtest: get-forked
[421.563157] Starting dynamic subtest: pipe-A-eDP-1
[423.451678] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.891s)
[423.461795] Starting dynamic subtest: pipe-B-eDP-1
[425.988120] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.535s)
[425.998092] Starting dynamic subtest: pipe-C-eDP-1
[428.519334] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.530s)
[428.529776] Starting dynamic subtest: pipe-D-eDP-1
[431.029586] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.508s)
[431.031948] Subtest get-forked: SUCCESS (9.469s)
[431.874173] [109/133] (596s left) gem_create (create-massive)
[431.919117] Starting subtest: create-massive
[431.921376] Subtest create-massive: SUCCESS (0.000s)
[432.115095] [110/133] (596s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[432.165541] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[432.224334] [111/133] (596s left) kms_async_flips (invalid-async-flip)
[432.317246] Starting subtest: invalid-async-flip
[432.708199] Starting dynamic subtest: pipe-A-eDP-1
[433.508956] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.801s)
[433.869089] Starting dynamic subtest: pipe-B-eDP-1
[434.649205] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.788s)
[435.010132] Starting dynamic subtest: pipe-C-eDP-1
[435.776721] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.773s)
[436.130489] Starting dynamic subtest: pipe-D-eDP-1
[436.900880] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.781s)
[436.903308] Subtest invalid-async-flip: SUCCESS (4.586s)
[438.050251] [112/133] (590s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[438.107582] Subtest writes-after-reads-uncached: SKIP (0.000s)
[438.184376] [113/133] (590s left) kms_psr (pr-suspend)
[438.275054] Starting subtest: pr-suspend
[438.279436] Subtest pr-suspend: SKIP (0.000s)
[438.347853] [114/133] (590s left) kms_properties (invalid-properties-atomic)
[438.440371] Starting subtest: invalid-properties-atomic
[438.739617] Subtest invalid-properties-atomic: SUCCESS (0.299s)
[438.817964] [115/133] (589s left) gem_readwrite (new-obj)
[438.880638] Subtest new-obj: SKIP (0.000s)
[438.940860] [116/133] (589s left) kms_properties (crtc-properties-legacy)
[439.032109] Starting subtest: crtc-properties-legacy
[439.034415] Starting dynamic subtest: pipe-A-eDP-1
[439.467752] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.435s)
[439.481302] Starting dynamic subtest: pipe-B-eDP-1
[440.601804] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.133s)
[440.618835] Starting dynamic subtest: pipe-C-eDP-1
[441.726506] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.125s)
[441.736429] Starting dynamic subtest: pipe-D-eDP-1
[442.867263] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.139s)
[442.869612] Subtest crtc-properties-legacy: SUCCESS (3.838s)
[443.669832] [117/133] (585s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[443.763543] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[443.767949] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[443.854373] [118/133] (584s left) tools_test (tools_test)
[443.910076] Starting subtest: tools_test
[443.957991] Subtest tools_test: SUCCESS (0.067s)
[444.037460] [119/133] (584s left) kms_cursor_legacy (single-move)
[444.159580] Starting subtest: single-move
[444.161484] Starting dynamic subtest: pipe-A
[449.541605] Dynamic subtest pipe-A: SUCCESS (5.378s)
[449.553210] Starting dynamic subtest: pipe-B
[454.924020] Dynamic subtest pipe-B: SUCCESS (5.380s)
[454.935210] Starting dynamic subtest: pipe-C
[460.306526] Dynamic subtest pipe-C: SUCCESS (5.379s)
[460.319871] Starting dynamic subtest: pipe-D
[465.688243] Dynamic subtest pipe-D: SUCCESS (5.379s)
[465.699237] Starting dynamic subtest: all-pipes
[471.076934] Dynamic subtest all-pipes: SUCCESS (5.385s)
[471.079705] Subtest single-move: SUCCESS (26.915s)
[471.222117] [120/133] (557s left) kms_cursor_crc (cursor-onscreen-32x10)
[471.377957] Starting subtest: cursor-onscreen-32x10
[471.426363] Subtest cursor-onscreen-32x10: SKIP (0.043s)
[471.677337] [121/133] (557s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[471.786692] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[471.790697] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[471.860099] [122/133] (557s left) gem_ctx_create (basic)
[471.908797] Starting subtest: basic
[471.911185] Subtest basic: SUCCESS (0.000s)
[472.089790] [123/133] (556s left) sw_sync (timeline_closed)
[472.131833] Starting subtest: timeline_closed
[472.134040] Subtest timeline_closed: SUCCESS (0.000s)
[472.191145] [124/133] (556s left) syncobj_wait (wait-zero-handles)
[472.243226] Starting subtest: wait-zero-handles
[472.245149] Subtest wait-zero-handles: SUCCESS (0.000s)
[472.338674] [125/133] (556s left) api_intel_allocator (execbuf-with-allocator)
[472.387130] Starting subtest: execbuf-with-allocator
[472.389396] Subtest execbuf-with-allocator: SUCCESS (0.005s)
[472.475952] [126/133] (556s left) syncobj_timeline (host-signal-points)
[472.522443] Starting subtest: host-signal-points
[472.524635] Subtest host-signal-points: SUCCESS (0.004s)
[472.638060] [127/133] (556s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[472.738250] Starting subtest: 4-tiled-64bpp-rotate-270
[472.758247] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.019s)
[472.864446] [128/133] (556s left) gem_exec_whisper (basic-sync-all)
[472.916416] Starting subtest: basic-sync-all
[478.930119] Subtest basic-sync-all: SUCCESS (6.013s)
[479.114285] [129/133] (550s left) kms_psr (fbc-pr-primary-mmap-gtt)
[479.214594] Starting subtest: fbc-pr-primary-mmap-gtt
[479.219308] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[479.285936] [130/133] (550s left) i915_pm_freq_api (freq-suspend)
[479.343076] Starting subtest: freq-suspend
[479.345705] Starting dynamic subtest: gt0
[495.138776] Dynamic subtest gt0: SUCCESS (1.396s)
[495.153035] Starting dynamic subtest: gt1
[511.127797] Dynamic subtest gt1: SUCCESS (1.221s)
[511.142696] Subtest freq-suspend: SUCCESS (2.620s)
[512.220155] [131/133] (518s left) sw_sync (sync_busy)
[512.264440] Starting subtest: sync_busy
[512.266869] Subtest sync_busy: SUCCESS (0.002s)
[512.317730] [132/133] (518s left) kms_chamelium_edid (vga-edid-read)
[512.716537] Subtest vga-edid-read: SKIP (0.000s)
[513.557052] [133/133] (516s left) kms_addfb_basic (too-high)
[513.650680] Starting subtest: too-high
[513.652901] Subtest too-high: SUCCESS (0.000s)
[513.755164] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_sseu
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_legacy_colorkey
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_vblank
results: parsing output: 7/ for test: gem_mmap_gtt
results: parsing output: 8/ for test: gem_userptr_blits
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: gem_spin_batch
results: parsing output: 13/ for test: gem_exec_params
results: parsing output: 14/ for test: kms_invalid_mode
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: gen7_exec_parse
results: parsing output: 17/ for test: perf
results: parsing output: 18/ for test: gem_ppgtt
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: kms_prime
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: i915_pm_rpm
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_cursor_crc
results: parsing output: 29/ for test: gem_exec_balancer
results: parsing output: 30/ for test: gem_exec_reloc
results: parsing output: 31/ for test: gem_pxp
results: parsing output: 32/ for test: gem_exec_schedule
results: parsing output: 33/ for test: kms_pm_backlight
results: parsing output: 34/ for test: sriov_basic
results: parsing output: 35/ for test: kms_color
results: parsing output: 36/ for test: gem_exec_balancer
results: parsing output: 37/ for test: kms_cursor_legacy
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_exec_schedule
results: parsing output: 41/ for test: kms_flip_scaled_crc
results: parsing output: 42/ for test: sw_sync
results: parsing output: 43/ for test: kms_pm_dc
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: perf_pmu
results: parsing output: 49/ for test: i915_suspend
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: gem_mmap_gtt
results: parsing output: 53/ for test: gem_ctx_persistence
results: parsing output: 54/ for test: kms_plane
results: parsing output: 55/ for test: kms_cursor_edge_walk
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: gem_mmap_wc
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_prop_blob
results: parsing output: 60/ for test: gem_render_copy
results: parsing output: 61/ for test: gem_tiled_fence_blits
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: gem_pxp
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_chamelium_hpd
results: parsing output: 66/ for test: kms_addfb_basic
results: parsing output: 67/ for test: dumb_buffer
results: parsing output: 68/ for test: gem_watchdog
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_render_copy
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_chamelium_color
results: parsing output: 74/ for test: syncobj_wait
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: syncobj_wait
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_feature_discovery
results: parsing output: 79/ for test: gem_busy
results: parsing output: 80/ for test: api_intel_bb
results: parsing output: 81/ for test: kms_pipe_crc_basic
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_ctx_persistence
results: parsing output: 84/ for test: kms_content_protection
results: parsing output: 85/ for test: kms_flip_scaled_crc
results: parsing output: 86/ for test: i915_drm_fdinfo
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: syncobj_wait
results: parsing output: 89/ for test: kms_plane_multiple
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: kms_pipe_b_c_ivb
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: gem_exec_fence
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: kms_psr2_sf
results: parsing output: 99/ for test: kms_atomic_interruptible
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: gem_exec_parallel
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: kms_plane
results: parsing output: 106/ for test: kms_getfb
results: parsing output: 107/ for test: kms_sequence
results: parsing output: 108/ for test: gem_create
results: parsing output: 109/ for test: gem_mmap_gtt
results: parsing output: 110/ for test: kms_async_flips
results: parsing output: 111/ for test: gem_partial_pwrite_pread
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: kms_properties
results: parsing output: 114/ for test: gem_readwrite
results: parsing output: 115/ for test: kms_properties
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: tools_test
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: kms_cursor_crc
results: parsing output: 120/ for test: kms_flip_scaled_crc
results: parsing output: 121/ for test: gem_ctx_create
results: parsing output: 122/ for test: sw_sync
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: api_intel_allocator
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: gem_exec_whisper
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: i915_pm_freq_api
results: parsing output: 130/ for test: sw_sync
results: parsing output: 131/ for test: kms_chamelium_edid
results: parsing output: 132/ for test: kms_addfb_basic
Done.