[57.244577] Initializing watchdogs
[57.244727]   /dev/watchdog0
[57.259332] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[57.263179] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.265115] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.268230] [001/133] (960s left) gem_exec_fence (basic-await)
[57.465711] Starting subtest: basic-await
[57.468143] Starting dynamic subtest: rcs0
[57.547981] Dynamic subtest rcs0: SUCCESS (0.083s)
[57.561647] Starting dynamic subtest: bcs0
[57.627504] Dynamic subtest bcs0: SUCCESS (0.079s)
[57.637062] Starting dynamic subtest: vcs0
[57.701240] Dynamic subtest vcs0: SUCCESS (0.074s)
[57.710941] Starting dynamic subtest: vcs1
[57.773874] Dynamic subtest vcs1: SUCCESS (0.073s)
[57.785653] Starting dynamic subtest: vecs0
[57.847048] Dynamic subtest vecs0: SUCCESS (0.073s)
[57.856815] Starting dynamic subtest: ccs0
[57.922933] Dynamic subtest ccs0: SUCCESS (0.076s)
[57.925501] Subtest basic-await: SUCCESS (0.461s)
[59.962534] [FACT gem_exec_fence (basic-await)] new: kernel.kmod_is_loaded.vgem: true
[59.965857] [002/133] (957s left) kms_big_fb (linear-8bpp-rotate-0)
[60.048643] Starting subtest: linear-8bpp-rotate-0
[61.321082] Subtest linear-8bpp-rotate-0: SUCCESS (1.280s)
[61.442724] [003/133] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[61.522456] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[61.525823] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[61.621524] [004/133] (956s left) gem_exec_params (rel-constants-invalid)
[61.671083] Starting subtest: rel-constants-invalid
[61.672993] Subtest rel-constants-invalid: SUCCESS (0.000s)
[61.762465] [005/133] (956s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[61.838047] Starting subtest: 4-tiled-addfb-size-offset-overflow
[61.839773] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[61.940701] [006/133] (956s left) gem_sync (basic-store-all)
[62.015111] Starting subtest: basic-store-all
[64.199683] Subtest basic-store-all: SUCCESS (2.201s)
[64.386487] [007/133] (953s left) gem_mmap_gtt (fault-concurrent-x)
[64.441822] Subtest fault-concurrent-X: SKIP (0.000s)
[64.503206] [008/133] (953s left) kms_chamelium_color (ctm-blue-to-red)
[64.580598] Subtest ctm-blue-to-red: SKIP (0.000s)
[64.631832] [009/133] (953s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[64.708901] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[64.711217] Starting dynamic subtest: pipe-A-default-mode
[67.444288] Dynamic subtest pipe-A-default-mode: SUCCESS (2.743s)
[67.446685] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.744s)
[68.289037] [010/133] (949s left) kms_hdr (static-toggle)
[68.358672] Starting subtest: static-toggle
[68.364799] Subtest static-toggle: SKIP (0.000s)
[68.440437] [011/133] (949s left) prime_vgem (fence-wait)
[68.503355] Starting subtest: fence-wait
[68.505365] Starting dynamic subtest: rcs0
[69.537993] Dynamic subtest rcs0: SUCCESS (1.036s)
[69.547062] Starting dynamic subtest: bcs0
[70.582343] Dynamic subtest bcs0: SUCCESS (1.045s)
[70.593280] Starting dynamic subtest: vcs0
[71.629042] Dynamic subtest vcs0: SUCCESS (1.047s)
[71.639670] Starting dynamic subtest: vcs1
[72.671978] Dynamic subtest vcs1: SUCCESS (1.043s)
[72.682851] Starting dynamic subtest: vecs0
[73.714259] Dynamic subtest vecs0: SUCCESS (1.042s)
[73.725233] Starting dynamic subtest: ccs0
[74.757708] Dynamic subtest ccs0: SUCCESS (1.043s)
[74.760166] Subtest fence-wait: SUCCESS (6.262s)
[74.869036] [012/133] (943s left) gen7_exec_parse (cmd-crossing-page)
[74.923154] Subtest cmd-crossing-page: SKIP (0.000s)
[74.993188] [013/133] (943s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[75.077649] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[75.081995] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[75.167058] [014/133] (943s left) kms_chamelium_hpd (dp-hpd-storm)
[75.544118] Subtest dp-hpd-storm: SKIP (0.000s)
[76.391735] [015/133] (941s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[76.476505] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[76.478533] Starting dynamic subtest: pipe-A-eDP-1
[77.352054] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.870s)
[77.360208] Starting dynamic subtest: pipe-B-eDP-1
[78.880538] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.525s)
[78.888627] Starting dynamic subtest: pipe-C-eDP-1
[80.339363] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.459s)
[80.348553] Starting dynamic subtest: pipe-D-eDP-1
[81.905126] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.567s)
[81.907321] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.424s)
[83.100695] [016/133] (935s left) kms_content_protection (legacy-hdcp14)
[83.245436] Starting subtest: legacy-hdcp14
[83.250020] Subtest legacy-hdcp14: SKIP (0.000s)
[83.395394] [017/133] (935s left) kms_plane_multiple (tiling-yf)
[83.469925] Starting subtest: tiling-yf
[83.474194] Subtest tiling-yf: SKIP (0.000s)
[83.588194] [018/133] (934s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[83.666632] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[83.671376] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[84.778844] [019/133] (933s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[84.867456] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[91.835338] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.971s)
[92.006694] [020/133] (926s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[92.080330] Starting subtest: invalidate-primary-flip-overlay
[102.807282] Subtest invalidate-primary-flip-overlay: SUCCESS (10.728s)
[102.910416] [021/133] (915s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[103.000450] Starting subtest: y-tiled-32bpp-rotate-180
[103.004051] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[103.094791] [022/133] (915s left) kms_lease (atomic-implicit-crtc)
[103.176013] Starting subtest: atomic-implicit-crtc
[103.177979] Starting dynamic subtest: pipe-A-eDP-1
[103.187253] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[103.199297] Starting dynamic subtest: pipe-B-eDP-1
[103.208504] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[103.220250] Starting dynamic subtest: pipe-C-eDP-1
[103.229074] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[103.239510] Starting dynamic subtest: pipe-D-eDP-1
[103.248106] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[103.249850] Subtest atomic-implicit-crtc: SUCCESS (0.033s)
[103.316669] [023/133] (915s left) kms_cursor_crc (cursor-dpms)
[103.428762] Starting subtest: cursor-dpms
[103.430726] Starting dynamic subtest: pipe-A-eDP-1
[106.503318] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.072s)
[106.512514] Starting dynamic subtest: pipe-D-eDP-1
[110.102426] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.598s)
[110.104328] Subtest cursor-dpms: SUCCESS (6.671s)
[110.959243] [024/133] (907s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[111.020872] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[111.023691] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[111.109440] [025/133] (907s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[111.192553] Starting subtest: x-tiled-32bpp-rotate-270
[111.212150] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[111.312642] [026/133] (907s left) kms_cursor_crc (cursor-tearing-position-change)
[111.396960] Starting subtest: cursor-tearing-position-change
[111.399219] Starting dynamic subtest: pipe-A-eDP-1
[111.951640] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.552s)
[111.960653] Starting dynamic subtest: pipe-D-eDP-1
[113.152060] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.199s)
[113.153998] Subtest cursor-tearing-position-change: SUCCESS (1.753s)
[113.984861] [027/133] (904s left) api_intel_allocator (execbuf-with-allocator)
[114.041922] Starting subtest: execbuf-with-allocator
[114.046852] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[114.174206] [028/133] (904s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[114.263217] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[114.289460] Starting dynamic subtest: pipe-A-plane-0
[114.578690] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[114.586986] Starting dynamic subtest: pipe-A-plane-3
[114.811578] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[114.820666] Starting dynamic subtest: pipe-A-plane-5
[114.824917] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[115.876409] Starting dynamic subtest: pipe-B-plane-0
[116.169547] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[116.179554] Starting dynamic subtest: pipe-B-plane-3
[116.402862] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[116.410187] Starting dynamic subtest: pipe-B-plane-5
[116.414322] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[116.720858] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.458s)
[117.548546] [029/133] (901s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[117.649272] Starting subtest: cursorB-vs-flipA-varying-size
[117.654993] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[117.811845] [030/133] (901s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[117.891418] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[117.895628] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[117.985119] [031/133] (901s left) gem_exec_reloc (basic-gtt-read-active)
[118.043791] Subtest basic-gtt-read-active: SKIP (0.000s)
[118.117585] [032/133] (900s left) kms_async_flips (crc-atomic)
[118.187280] Starting subtest: crc-atomic
[118.560141] Starting dynamic subtest: pipe-A-eDP-1
[121.457176] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.894s)
[121.832539] Starting dynamic subtest: pipe-B-eDP-1
[124.700316] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.876s)
[125.086708] Starting dynamic subtest: pipe-C-eDP-1
[128.018097] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.938s)
[128.387312] Starting dynamic subtest: pipe-D-eDP-1
[131.234498] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.853s)
[131.236919] Subtest crc-atomic: SUCCESS (13.047s)
[132.406818] [033/133] (886s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[132.492970] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[132.497348] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[132.563405] [034/133] (886s left) api_intel_bb (object-noreloc-purge-cache-simple)
[132.621802] Starting subtest: object-noreloc-purge-cache-simple
[132.624487] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.005s)
[132.767665] [035/133] (886s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[132.980959] Starting subtest: cursor-rapid-movement-256x85
[133.028555] Subtest cursor-rapid-movement-256x85: SKIP (0.043s)
[133.209994] [036/133] (886s left) syncobj_wait (wait-all-snapshot)
[133.265390] Starting subtest: wait-all-snapshot
[133.344931] Subtest wait-all-snapshot: SUCCESS (0.081s)
[133.435737] [037/133] (885s left) gem_eio (kms)
[133.685755] Starting subtest: kms
[153.293968] Subtest kms: SUCCESS (19.607s)
[154.472933] [038/133] (864s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[154.570499] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[154.574894] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[154.669474] [039/133] (864s left) gem_render_copy_redux (interruptible)
[154.737729] Starting subtest: interruptible
[155.106642] Subtest interruptible: SUCCESS (0.369s)
[155.218533] [040/133] (864s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[155.289721] Starting subtest: fbcpsr-slowdraw
[180.375203] Subtest fbcpsr-slowdraw: SUCCESS (25.086s)
[180.507930] [041/133] (838s left) syncobj_basic (bad-handle-to-fd)
[180.566398] Starting subtest: bad-handle-to-fd
[180.568770] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[180.665846] [042/133] (838s left) gem_exec_reloc (basic-gtt-read)
[180.720528] Subtest basic-gtt-read: SKIP (0.000s)
[180.807412] [043/133] (838s left) kms_atomic_transition (plane-all-modeset-transition)
[180.882485] Starting subtest: plane-all-modeset-transition
[180.886881] Subtest plane-all-modeset-transition: SKIP (0.000s)
[180.954869] [044/133] (838s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[181.029660] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[181.033922] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[181.130504] [045/133] (838s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[181.184687] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[181.293800] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.108s)
[181.383668] [046/133] (838s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[181.493271] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[190.491992] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (8.998s)
[191.357107] [047/133] (828s left) kms_chamelium_frames (hdmi-crc-multiple)
[191.714438] Subtest hdmi-crc-multiple: SKIP (0.000s)
[192.531924] [048/133] (827s left) kms_sequence (get-idle)
[192.612572] Starting subtest: get-idle
[192.614962] Starting dynamic subtest: pipe-A-eDP-1
[194.431753] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.819s)
[194.444250] Starting dynamic subtest: pipe-B-eDP-1
[196.921494] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.488s)
[196.930485] Starting dynamic subtest: pipe-C-eDP-1
[199.347230] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.426s)
[199.355598] Starting dynamic subtest: pipe-D-eDP-1
[201.779139] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.430s)
[201.781273] Subtest get-idle: SUCCESS (9.168s)
[202.599026] [049/133] (817s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[202.675093] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[202.677410] Starting dynamic subtest: pipe-A-eDP-1
[202.697851] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[202.711963] Starting dynamic subtest: pipe-B-eDP-1
[202.732401] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[202.742074] Starting dynamic subtest: pipe-C-eDP-1
[202.761524] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[202.769355] Starting dynamic subtest: pipe-D-eDP-1
[202.788379] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[202.790538] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.006s)
[204.877294] [050/133] (814s left) kms_feature_discovery (display-4x)
[204.951326] Starting subtest: display-4x
[204.955611] Subtest display-4x: SKIP (0.000s)
[205.023392] [051/133] (814s left) kms_cursor_legacy (single-move)
[205.123261] Starting subtest: single-move
[205.125504] Starting dynamic subtest: pipe-A
[210.560202] Dynamic subtest pipe-A: SUCCESS (5.380s)
[210.569780] Starting dynamic subtest: pipe-B
[215.941727] Dynamic subtest pipe-B: SUCCESS (5.380s)
[215.951782] Starting dynamic subtest: pipe-C
[221.323754] Dynamic subtest pipe-C: SUCCESS (5.379s)
[221.333548] Starting dynamic subtest: pipe-D
[226.705493] Dynamic subtest pipe-D: SUCCESS (5.379s)
[226.715753] Starting dynamic subtest: all-pipes
[232.097757] Dynamic subtest all-pipes: SUCCESS (5.386s)
[232.099876] Subtest single-move: SUCCESS (26.918s)
[232.186814] [052/133] (787s left) kms_plane_scaling (planes-scaler-unity-scaling)
[232.274798] Starting subtest: planes-scaler-unity-scaling
[232.277171] Starting dynamic subtest: pipe-A
[232.336819] Dynamic subtest pipe-A: SUCCESS (0.064s)
[232.346181] Starting dynamic subtest: pipe-B
[233.495357] Dynamic subtest pipe-B: SUCCESS (1.158s)
[233.505396] Starting dynamic subtest: pipe-C
[234.614788] Dynamic subtest pipe-C: SUCCESS (1.119s)
[234.623379] Starting dynamic subtest: pipe-D
[235.750694] Dynamic subtest pipe-D: SUCCESS (1.135s)
[235.753078] Subtest planes-scaler-unity-scaling: SUCCESS (3.478s)
[236.910951] [053/133] (783s left) gem_pxp (fail-invalid-protected-context)
[237.039073] Starting subtest: fail-invalid-protected-context
[237.041547] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[237.169310] [054/133] (782s left) sw_sync (timeline_closed_signaled)
[237.205396] Starting subtest: timeline_closed_signaled
[237.207583] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[237.267928] [055/133] (782s left) kms_addfb_basic (bad-pitch-32)
[237.328129] Starting subtest: bad-pitch-32
[237.330409] Subtest bad-pitch-32: SUCCESS (0.000s)
[237.454709] [056/133] (782s left) kms_psr2_su (page_flip-nv12)
[237.518041] Subtest page_flip-NV12: SKIP (0.000s)
[237.578644] [057/133] (782s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[237.659325] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[244.508989] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.854s)
[244.636843] [058/133] (775s left) kms_pm_rpm (modeset-non-lpsp)
[246.143058] Starting subtest: modeset-non-lpsp
[247.301094] Subtest modeset-non-lpsp: SKIP (1.158s)
[247.676962] [059/133] (772s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[247.730698] Starting subtest: multi-wait-all-for-submit-available-submitted
[247.733046] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[247.819452] [060/133] (772s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[247.892060] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[247.894291] Starting dynamic subtest: A-eDP1
[251.503471] Dynamic subtest A-eDP1: SUCCESS (3.612s)
[251.513018] Starting dynamic subtest: B-eDP1
[254.709327] Dynamic subtest B-eDP1: SUCCESS (3.204s)
[254.718592] Starting dynamic subtest: C-eDP1
[257.803285] Dynamic subtest C-eDP1: SUCCESS (3.091s)
[257.812751] Starting dynamic subtest: D-eDP1
[260.919367] Dynamic subtest D-eDP1: SUCCESS (3.116s)
[260.921574] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.029s)
[261.715155] [061/133] (758s left) gem_workarounds (basic-read)
[261.775865] Starting subtest: basic-read
[261.787526] Subtest basic-read: SUCCESS (0.012s)
[261.900438] [062/133] (758s left) i915_drm_fdinfo (virtual-idle)
[261.941838] Starting subtest: virtual-idle
[265.000947] Subtest virtual-idle: SUCCESS (3.057s)
[265.091600] [063/133] (755s left) kms_vrr (negative-basic)
[265.195379] Starting subtest: negative-basic
[265.202067] Starting dynamic subtest: pipe-A-eDP-1
[270.672644] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.416s)
[270.914949] Subtest negative-basic: SUCCESS (5.717s)
[271.746284] [064/133] (748s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[271.837081] Starting subtest: yf-tiled-8bpp-rotate-0
[271.841439] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[271.931452] [065/133] (748s left) kms_psr (fbc-psr-primary-blt)
[272.004842] Starting subtest: fbc-psr-primary-blt
[272.007109] Starting dynamic subtest: eDP-1
[272.011607] Dynamic subtest eDP-1: SKIP (0.000s)
[272.016091] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[272.077243] [066/133] (748s left) gem_exec_schedule (manyslice)
[272.144575] Starting subtest: manyslice
[272.146716] Starting dynamic subtest: rcs0
[277.293345] Dynamic subtest rcs0: SUCCESS (5.104s)
[277.304367] Starting dynamic subtest: bcs0
[283.896325] Dynamic subtest bcs0: SUCCESS (6.601s)
[283.907896] Starting dynamic subtest: vcs0
[289.468567] Dynamic subtest vcs0: SUCCESS (5.570s)
[289.480130] Starting dynamic subtest: vcs1
[295.035029] Dynamic subtest vcs1: SUCCESS (5.564s)
[295.047823] Starting dynamic subtest: vecs0
[300.601534] Dynamic subtest vecs0: SUCCESS (5.564s)
[300.616444] Starting dynamic subtest: ccs0
[306.693877] Dynamic subtest ccs0: SUCCESS (6.142s)
[306.696829] Subtest manyslice: SUCCESS (34.555s)
[306.998579] [067/133] (713s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[307.094162] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[307.098119] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[307.187847] [068/133] (713s left) kms_fbcon_fbt (fbc)
[307.250992] Starting subtest: fbc
[313.591799] Subtest fbc: SUCCESS (6.341s)
[314.764967] [069/133] (705s left) gem_create (create-ext-cpu-access-big)
[314.948426] Starting subtest: create-ext-cpu-access-big
[314.953079] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[315.024703] [070/133] (705s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[315.086095] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[315.088390] Starting dynamic subtest: pipe-A-eDP-1
[315.149945] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[315.159926] Starting dynamic subtest: pipe-B-eDP-1
[315.217441] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[315.226460] Starting dynamic subtest: pipe-C-eDP-1
[315.283652] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[315.295423] Starting dynamic subtest: pipe-D-eDP-1
[315.350165] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[315.354098] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.009s)
[317.342967] [071/133] (703s left) gem_ctx_isolation (clean)
[317.411481] Starting subtest: clean
[317.413375] Starting dynamic subtest: rcs0
[317.454337] Dynamic subtest rcs0: SUCCESS (0.045s)
[317.467145] Starting dynamic subtest: bcs0
[317.517591] Dynamic subtest bcs0: SUCCESS (0.062s)
[317.527441] Starting dynamic subtest: vcs0
[317.592486] Dynamic subtest vcs0: SUCCESS (0.074s)
[317.602607] Starting dynamic subtest: vcs1
[318.826949] Dynamic subtest vcs1: SUCCESS (1.233s)
[318.837067] Starting dynamic subtest: vecs0
[320.875700] Dynamic subtest vecs0: SUCCESS (2.047s)
[320.886200] Starting dynamic subtest: ccs0
[322.861567] Dynamic subtest ccs0: SUCCESS (1.985s)
[322.864064] Subtest clean: SUCCESS (5.453s)
[323.098778] [072/133] (697s left) kms_rotation_crc (sprite-rotation-180)
[323.176743] Starting subtest: sprite-rotation-180
[329.932211] Subtest sprite-rotation-180: SUCCESS (6.756s)
[331.117971] [073/133] (689s left) gem_exec_whisper (basic-sync-all)
[331.180566] Starting subtest: basic-sync-all
[338.431783] Subtest basic-sync-all: SUCCESS (7.247s)
[338.619435] [074/133] (682s left) i915_pm_rpm (sysfs-read)
[340.120077] Starting subtest: sysfs-read
[341.264917] Subtest sysfs-read: SUCCESS (1.145s)
[341.637850] [075/133] (679s left) kms_plane (plane-panning-bottom-right-suspend)
[341.714792] Starting subtest: plane-panning-bottom-right-suspend
[341.717030] Starting dynamic subtest: pipe-A
[360.238359] Dynamic subtest pipe-A: SUCCESS (3.730s)
[360.249046] Starting dynamic subtest: pipe-B
[379.216209] Dynamic subtest pipe-B: SUCCESS (3.558s)
[379.218147] Subtest plane-panning-bottom-right-suspend: SUCCESS (7.291s)
[380.023145] [076/133] (640s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[380.118066] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[380.122345] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[380.226920] [077/133] (640s left) kms_vblank (wait-busy-hang)
[380.305332] Starting subtest: wait-busy-hang
[380.307590] Starting dynamic subtest: pipe-A-eDP-1
[406.996747] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.900s)
[407.011514] Starting dynamic subtest: pipe-D-eDP-1
[430.931082] Dynamic subtest pipe-D-eDP-1: SUCCESS (23.924s)
[430.933390] Subtest wait-busy-hang: SUCCESS (50.829s)
[431.772186] [078/133] (589s left) i915_selftest (mock)
[436.308402] Starting subtest: mock
[436.311108] Starting dynamic subtest: sanitycheck
[436.962829] Dynamic subtest sanitycheck: SUCCESS (0.655s)
[436.972643] Starting dynamic subtest: shmem
[437.609743] Dynamic subtest shmem: SUCCESS (0.645s)
[437.619754] Starting dynamic subtest: fence
[445.299945] Dynamic subtest fence: SUCCESS (7.689s)
[445.309380] Starting dynamic subtest: scatterlist
[446.942269] Dynamic subtest scatterlist: SUCCESS (1.641s)
[446.952080] Starting dynamic subtest: syncmap
[450.005633] Dynamic subtest syncmap: SUCCESS (3.062s)
[450.015762] Starting dynamic subtest: uncore
[450.661956] Dynamic subtest uncore: SUCCESS (0.655s)
[450.671715] Starting dynamic subtest: ring
[451.350201] Dynamic subtest ring: SUCCESS (0.686s)
[451.359680] Starting dynamic subtest: engine
[452.010774] Dynamic subtest engine: SUCCESS (0.659s)
[452.020518] Starting dynamic subtest: timelines
[455.803825] Dynamic subtest timelines: SUCCESS (3.791s)
[455.813642] Starting dynamic subtest: requests
[459.631003] Dynamic subtest requests: SUCCESS (3.826s)
[459.642420] Starting dynamic subtest: objects
[460.356656] Dynamic subtest objects: SUCCESS (0.725s)
[460.366212] Starting dynamic subtest: phys
[461.109738] Dynamic subtest phys: SUCCESS (0.752s)
[461.118969] Starting dynamic subtest: dmabuf
[461.866518] Dynamic subtest dmabuf: SUCCESS (0.755s)
[461.876012] Starting dynamic subtest: vma
[467.564242] Dynamic subtest vma: SUCCESS (5.697s)
[467.573988] Starting dynamic subtest: evict
[469.029613] Dynamic subtest evict: SUCCESS (1.464s)
[469.039203] Starting dynamic subtest: gtt
[472.572148] Dynamic subtest gtt: SUCCESS (3.541s)
[472.581912] Starting dynamic subtest: hugepages
[473.411110] Dynamic subtest hugepages: SUCCESS (0.838s)
[473.420892] Starting dynamic subtest: memory_region
[475.894820] Dynamic subtest memory_region: SUCCESS (2.481s)
[475.897744] Subtest mock: SUCCESS (39.595s)
[475.945994] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[475.946767] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[475.951060] [079/133] (545s left) gem_readwrite (write-bad-handle)
[477.375271] Subtest write-bad-handle: SKIP (0.000s)
[477.439910] [FACT gem_readwrite (write-bad-handle)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[477.440991] [FACT gem_readwrite (write-bad-handle)] new: kernel.kmod_is_loaded.i915: true
[477.444706] [080/133] (543s left) syncobj_timeline (reset-during-wait-for-submit)
[477.509905] Starting subtest: reset-during-wait-for-submit
[477.612347] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[477.693241] [081/133] (543s left) fbdev (write)
[477.729270] Starting subtest: write
[478.081334] Subtest write: SUCCESS (0.350s)
[478.133994] [082/133] (543s left) gem_eio (in-flight-1us)
[478.288170] Starting subtest: in-flight-1us
[485.750344] Subtest in-flight-1us: SUCCESS (7.459s)
[485.911338] [083/133] (535s left) syncobj_wait (invalid-wait-bad-flags)
[485.974461] Starting subtest: invalid-wait-bad-flags
[485.977204] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[486.065277] [084/133] (535s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[486.141050] Starting subtest: primary-x-tiled-reflect-x-180
[493.275566] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.133s)
[494.428489] [085/133] (526s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[494.528363] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[494.532339] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[494.625524] [086/133] (526s left) perf_pmu (enable-race)
[494.670017] Starting subtest: enable-race
[494.672101] Starting dynamic subtest: rcs0
[507.450426] Dynamic subtest rcs0: SUCCESS (12.762s)
[507.466024] Starting dynamic subtest: bcs0
[520.195210] Dynamic subtest bcs0: SUCCESS (12.744s)
[520.205669] Starting dynamic subtest: vcs0
[536.127498] Dynamic subtest vcs0: SUCCESS (15.950s)
[536.139635] Starting dynamic subtest: vcs1
[552.127433] Dynamic subtest vcs1: SUCCESS (15.999s)
[552.139823] Starting dynamic subtest: vecs0
[568.126236] Dynamic subtest vecs0: SUCCESS (15.999s)
[568.138399] Starting dynamic subtest: ccs0
[580.902048] Dynamic subtest ccs0: SUCCESS (12.762s)
[580.904116] Subtest enable-race: SUCCESS (86.230s)
[581.002265] [087/133] (440s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[581.099333] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[581.103658] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[581.207311] [088/133] (440s left) gem_exec_schedule (implicit-boths)
[581.276450] Starting subtest: implicit-boths
[581.278703] Starting dynamic subtest: rcs0
[581.389791] Dynamic subtest rcs0: SUCCESS (0.122s)
[581.400535] Starting dynamic subtest: vcs0
[581.475537] Dynamic subtest vcs0: SUCCESS (0.085s)
[581.487020] Starting dynamic subtest: vcs1
[581.557676] Dynamic subtest vcs1: SUCCESS (0.081s)
[581.569348] Starting dynamic subtest: vecs0
[581.635235] Dynamic subtest vecs0: SUCCESS (0.076s)
[581.646868] Starting dynamic subtest: ccs0
[581.723899] Dynamic subtest ccs0: SUCCESS (0.088s)
[581.726617] Subtest implicit-boths: SUCCESS (0.457s)
[583.260805] [089/133] (438s left) gem_exec_schedule (u-fairslice)
[583.348930] Starting subtest: u-fairslice
[583.351002] Starting dynamic subtest: rcs0
[585.368064] Dynamic subtest rcs0: SUCCESS (2.024s)
[585.378608] Starting dynamic subtest: bcs0
[587.437815] Dynamic subtest bcs0: SUCCESS (2.025s)
[587.448960] Starting dynamic subtest: vcs0
[589.413863] Dynamic subtest vcs0: SUCCESS (2.021s)
[589.424147] Starting dynamic subtest: vcs1
[591.437483] Dynamic subtest vcs1: SUCCESS (2.023s)
[591.447702] Starting dynamic subtest: vecs0
[593.456706] Dynamic subtest vecs0: SUCCESS (2.019s)
[593.465763] Starting dynamic subtest: ccs0
[595.484746] Dynamic subtest ccs0: SUCCESS (2.027s)
[595.486858] Subtest u-fairslice: SUCCESS (12.146s)
[595.784230] [090/133] (425s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[595.883486] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[596.708156] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.826s)
[597.000323] [091/133] (424s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[597.077541] Starting subtest: compare-crc-sanitycheck-xr24
[597.079871] Starting dynamic subtest: pipe-A-eDP-1
[597.707403] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.630s)
[597.716738] Starting dynamic subtest: pipe-B-eDP-1
[598.993042] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.283s)
[599.003431] Starting dynamic subtest: pipe-C-eDP-1
[600.243419] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.249s)
[600.253153] Starting dynamic subtest: pipe-D-eDP-1
[601.491447] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.249s)
[601.493809] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.417s)
[602.338384] [092/133] (419s left) kms_properties (plane-properties-atomic)
[602.421355] Starting subtest: plane-properties-atomic
[602.423296] Starting dynamic subtest: pipe-A-eDP-1
[602.984647] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.561s)
[602.995290] Starting dynamic subtest: pipe-B-eDP-1
[604.308882] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.324s)
[604.318642] Starting dynamic subtest: pipe-C-eDP-1
[605.549700] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.239s)
[605.559619] Starting dynamic subtest: pipe-D-eDP-1
[606.789140] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.237s)
[606.791117] Subtest plane-properties-atomic: SUCCESS (4.366s)
[607.597186] [093/133] (414s left) gem_ringfill (legacy-basic)
[613.185957] Starting subtest: legacy-basic
[613.188888] Starting dynamic subtest: default
[613.243612] Dynamic subtest default: SUCCESS (0.057s)
[613.255298] Starting dynamic subtest: render
[613.286066] Dynamic subtest render: SUCCESS (0.040s)
[613.296773] Starting dynamic subtest: bsd
[613.332412] Dynamic subtest bsd: SUCCESS (0.043s)
[613.344523] Starting dynamic subtest: bsd1
[613.373778] Dynamic subtest bsd1: SUCCESS (0.039s)
[613.385024] Starting dynamic subtest: bsd2
[613.417858] Dynamic subtest bsd2: SUCCESS (0.042s)
[613.427491] Starting dynamic subtest: blt
[613.463870] Dynamic subtest blt: SUCCESS (0.043s)
[613.474170] Starting dynamic subtest: vebox
[613.508538] Dynamic subtest vebox: SUCCESS (0.042s)
[613.510923] Subtest legacy-basic: SUCCESS (0.325s)
[613.586935] [094/133] (408s left) gem_mmap_wc (read)
[613.647610] Subtest read: SKIP (0.000s)
[613.713498] [095/133] (408s left) kms_psr (psr2-cursor-mmap-gtt)
[613.795899] Starting subtest: psr2-cursor-mmap-gtt
[613.798231] Starting dynamic subtest: eDP-1
[615.481003] Dynamic subtest eDP-1: SUCCESS (1.684s)
[615.483329] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.685s)
[616.278783] [096/133] (405s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[616.374658] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[616.378720] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[616.475913] [097/133] (405s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[616.554771] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[616.558752] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[616.657803] [098/133] (405s left) gem_exec_balancer (full-pulse)
[616.721364] Starting subtest: full-pulse
[620.997853] Subtest full-pulse: SUCCESS (4.275s)
[621.292781] [099/133] (400s left) gem_exec_whisper (basic-fds-priority-all)
[621.361952] Starting subtest: basic-fds-priority-all
[645.153819] Subtest basic-fds-priority-all: SUCCESS (23.785s)
[645.337461] [100/133] (376s left) kms_pm_backlight (basic-brightness)
[645.412842] Starting subtest: basic-brightness
[645.462585] Starting dynamic subtest: eDP-1
[645.784243] Dynamic subtest eDP-1: SUCCESS (0.319s)
[645.787040] Subtest basic-brightness: SUCCESS (0.370s)
[646.619140] [101/133] (375s left) gem_ctx_persistence (legacy-engines-mixed-process)
[646.676975] Starting subtest: legacy-engines-mixed-process
[646.679261] Starting dynamic subtest: render
[648.188347] Dynamic subtest render: SUCCESS (1.511s)
[648.199744] Starting dynamic subtest: bsd1
[650.174397] Dynamic subtest bsd1: SUCCESS (1.984s)
[650.186088] Starting dynamic subtest: bsd2
[652.161288] Dynamic subtest bsd2: SUCCESS (1.985s)
[652.172988] Starting dynamic subtest: blt
[654.152797] Dynamic subtest blt: SUCCESS (1.990s)
[654.164446] Starting dynamic subtest: vebox
[656.112686] Dynamic subtest vebox: SUCCESS (1.955s)
[656.115082] Subtest legacy-engines-mixed-process: SUCCESS (9.432s)
[656.188557] [102/133] (365s left) gem_exec_reloc (basic-wc-gtt-active)
[656.240641] Subtest basic-wc-gtt-active: SKIP (0.000s)
[656.304962] [103/133] (365s left) gem_wait (await)
[656.361969] Starting subtest: await
[656.364257] Starting dynamic subtest: all-engines
[657.523016] Dynamic subtest all-engines: SUCCESS (1.164s)
[657.536603] Starting dynamic subtest: rcs0
[658.595995] Dynamic subtest rcs0: SUCCESS (1.071s)
[658.611212] Starting dynamic subtest: bcs0
[659.658165] Dynamic subtest bcs0: SUCCESS (1.059s)
[659.675678] Starting dynamic subtest: vcs0
[660.714453] Dynamic subtest vcs0: SUCCESS (1.055s)
[660.731353] Starting dynamic subtest: vcs1
[661.770375] Dynamic subtest vcs1: SUCCESS (1.054s)
[661.786035] Starting dynamic subtest: vecs0
[662.827362] Dynamic subtest vecs0: SUCCESS (1.054s)
[662.845863] Starting dynamic subtest: ccs0
[663.886440] Dynamic subtest ccs0: SUCCESS (1.057s)
[663.889331] Subtest await: SUCCESS (7.529s)
[664.087857] [104/133] (358s left) kms_psr (fbc-psr2-sprite-blt)
[664.172807] Starting subtest: fbc-psr2-sprite-blt
[664.175122] Starting dynamic subtest: eDP-1
[664.179363] Dynamic subtest eDP-1: SKIP (0.000s)
[664.183712] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[664.244878] [105/133] (357s left) i915_drm_fdinfo (virtual-busy-hang)
[664.284162] Starting subtest: virtual-busy-hang
[664.288911] Subtest virtual-busy-hang: SKIP (0.000s)
[664.373592] [106/133] (357s left) gem_exec_create (madvise)
[664.432931] Starting subtest: madvise
[664.435371] Starting dynamic subtest: smem
[684.582358] Dynamic subtest smem: SUCCESS (20.149s)
[684.584702] Subtest madvise: SUCCESS (20.150s)
[685.393900] [107/133] (336s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[685.485313] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[685.489726] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[685.586931] [108/133] (336s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[685.676926] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[685.680791] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[685.743423] [109/133] (336s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[685.817221] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[685.821387] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[685.905533] [110/133] (336s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[685.997441] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[692.577828] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.585s)
[692.715039] [111/133] (329s left) gem_exec_fence (syncobj-timeline-repeat)
[693.294278] Starting subtest: syncobj-timeline-repeat
[693.530324] Subtest syncobj-timeline-repeat: SUCCESS (0.236s)
[694.220742] [112/133] (328s left) gem_mmap_gtt (basic-write-read)
[694.272242] Subtest basic-write-read: SKIP (0.000s)
[694.333987] [113/133] (328s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[694.430534] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[694.434617] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[694.527717] [114/133] (327s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[694.570628] Starting subtest: single-wait-all-for-submit-signaled
[694.572963] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[694.666461] [115/133] (327s left) kms_async_flips (async-flip-suspend-resume)
[694.732309] Starting subtest: async-flip-suspend-resume
[695.117942] Starting dynamic subtest: pipe-A-eDP-1
[712.830991] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.712s)
[713.225917] Starting dynamic subtest: pipe-B-eDP-1
[730.851134] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.958s)
[731.222769] Starting dynamic subtest: pipe-C-eDP-1
[748.858063] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.984s)
[749.220957] Starting dynamic subtest: pipe-D-eDP-1
[766.827747] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.911s)
[766.830395] Subtest async-flip-suspend-resume: SUCCESS (14.072s)
[768.024926] [116/133] (254s left) kms_flip (2x-flip-vs-dpms-on-nop)
[768.104128] Starting subtest: 2x-flip-vs-dpms-on-nop
[768.111914] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.008s)
[768.188410] [117/133] (254s left) prime_vgem (basic-fence-read)
[768.265598] Starting subtest: basic-fence-read
[768.272761] Subtest basic-fence-read: SKIP (0.006s)
[768.379732] [118/133] (254s left) gem_unref_active_buffers
[768.567842] [119/133] (254s left) kms_psr (pr-primary-mmap-gtt)
[768.633112] Starting subtest: pr-primary-mmap-gtt
[768.637280] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[768.717356] [120/133] (254s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[768.777223] Starting subtest: etime-single-wait-available-unsubmitted
[768.879742] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.107s)
[768.956143] [121/133] (253s left) syncobj_wait (single-wait-for-submit-signaled)
[769.014957] Starting subtest: single-wait-for-submit-signaled
[769.017186] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[769.115731] [122/133] (253s left) gem_ctx_bad_destroy (invalid-ctx)
[769.159027] Starting subtest: invalid-ctx
[769.161375] Subtest invalid-ctx: SUCCESS (0.000s)
[769.236165] [123/133] (253s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[769.355847] Starting subtest: protected-encrypted-src-copy-not-readible
[769.465716] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.113s)
[769.592766] [124/133] (253s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[769.667928] Starting subtest: 2x-absolute-wf_vblank-interruptible
[769.676178] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.007s)
[769.784511] [125/133] (253s left) gem_userptr_blits (relocations)
[769.854198] Starting subtest: relocations
[769.858196] Subtest relocations: SKIP (0.001s)
[769.977145] [126/133] (253s left) kms_properties (colorop-properties-legacy)
[770.042200] Starting subtest: colorop-properties-legacy
[770.044395] Starting dynamic subtest: pipe-A-eDP-1
[770.413528] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.377s)
[770.423286] Starting dynamic subtest: pipe-B-eDP-1
[771.442743] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.046s)
[771.452848] Starting dynamic subtest: pipe-C-eDP-1
[772.470184] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.041s)
[772.480304] Starting dynamic subtest: pipe-D-eDP-1
[773.506892] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.049s)
[773.508957] Subtest colorop-properties-legacy: SUCCESS (3.518s)
[774.300173] [127/133] (248s left) gem_mmap_gtt (hang-user)
[774.350025] Subtest hang-user: SKIP (0.000s)
[774.406729] [128/133] (248s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[774.488652] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[778.906072] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.458s)
[780.056795] [129/133] (243s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[780.134425] Starting subtest: plane-lut1d-ctm3x4
[780.279790] Starting dynamic subtest: pipe-A-plane-0
[780.607186] Dynamic subtest pipe-A-plane-0: FAIL (0.156s)
[780.619200] Starting dynamic subtest: pipe-A-plane-1
[780.835456] Dynamic subtest pipe-A-plane-1: FAIL (0.184s)
[780.844375] Starting dynamic subtest: pipe-A-plane-2
[781.073134] Dynamic subtest pipe-A-plane-2: FAIL (0.199s)
[782.037790] Starting dynamic subtest: pipe-B-plane-0
[782.479390] Dynamic subtest pipe-B-plane-0: FAIL (0.163s)
[782.489292] Starting dynamic subtest: pipe-B-plane-1
[782.806727] Dynamic subtest pipe-B-plane-1: FAIL (0.201s)
[782.817874] Starting dynamic subtest: pipe-B-plane-2
[783.119428] Dynamic subtest pipe-B-plane-2: FAIL (0.187s)
[783.757521] Starting dynamic subtest: pipe-C-plane-0
[784.242439] Dynamic subtest pipe-C-plane-0: FAIL (0.129s)
[784.253622] Starting dynamic subtest: pipe-C-plane-1
[784.651775] Dynamic subtest pipe-C-plane-1: FAIL (0.607s)
[784.667525] Starting dynamic subtest: pipe-C-plane-2
[785.040250] Dynamic subtest pipe-C-plane-2: FAIL (0.171s)
[785.892426] Starting dynamic subtest: pipe-D-plane-0
[786.501439] Dynamic subtest pipe-D-plane-0: FAIL (0.162s)
[786.512548] Starting dynamic subtest: pipe-D-plane-1
[786.960443] Dynamic subtest pipe-D-plane-1: FAIL (0.602s)
[786.970531] Starting dynamic subtest: pipe-D-plane-2
[787.390407] Dynamic subtest pipe-D-plane-2: FAIL (0.543s)
[787.497476] Subtest plane-lut1d-ctm3x4: FAIL (7.392s)
[788.346392] [130/133] (234s left) sysfs_timeslice_duration (duration)
[788.411311] Starting subtest: duration
[788.413460] Starting dynamic subtest: vecs0
[803.307333] Dynamic subtest vecs0: SUCCESS (14.906s)
[803.319876] Starting dynamic subtest: ccs0
[816.466504] Dynamic subtest ccs0: SUCCESS (13.135s)
[816.476452] Starting dynamic subtest: vcs0
[831.338094] Dynamic subtest vcs0: SUCCESS (14.891s)
[831.350501] Starting dynamic subtest: bcs0
[844.484780] Dynamic subtest bcs0: SUCCESS (13.119s)
[844.497699] Starting dynamic subtest: rcs0
[857.602414] Dynamic subtest rcs0: SUCCESS (13.151s)
[857.613898] Starting dynamic subtest: vcs1
[871.401447] Dynamic subtest vcs1: SUCCESS (13.792s)
[871.404646] Subtest duration: SUCCESS (83.009s)
[871.484565] [131/133] (151s left) gem_spin_batch (resubmit-new)
[871.566628] Starting subtest: resubmit-new
[871.569053] Starting dynamic subtest: rcs0
[871.581318] Dynamic subtest rcs0: SUCCESS (0.014s)
[871.591911] Starting dynamic subtest: bcs0
[871.593821] Dynamic subtest bcs0: SUCCESS (0.008s)
[871.603954] Starting dynamic subtest: vcs0
[871.606183] Dynamic subtest vcs0: SUCCESS (0.006s)
[871.616160] Starting dynamic subtest: vcs1
[871.618178] Dynamic subtest vcs1: SUCCESS (0.009s)
[871.628061] Starting dynamic subtest: vecs0
[871.630216] Dynamic subtest vecs0: SUCCESS (0.006s)
[871.639955] Starting dynamic subtest: ccs0
[871.642190] Dynamic subtest ccs0: SUCCESS (0.008s)
[871.644416] Subtest resubmit-new: SUCCESS (0.056s)
[873.474204] [132/133] (149s left) gem_userptr_blits (create-destroy-sync)
[873.546800] Starting subtest: create-destroy-sync
[878.615933] Subtest create-destroy-sync: SUCCESS (5.013s)
[878.684003] [133/133] (144s left) dmabuf_sync_file (export-multiwait)
[878.725927] Starting subtest: export-multiwait
[878.727818] Subtest export-multiwait: SUCCESS (0.001s)
[878.810340] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_fence
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_exec_params
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: gem_sync
results: parsing output: 6/ for test: gem_mmap_gtt
results: parsing output: 7/ for test: kms_chamelium_color
results: parsing output: 8/ for test: kms_flip_scaled_crc
results: parsing output: 9/ for test: kms_hdr
results: parsing output: 10/ for test: prime_vgem
results: parsing output: 11/ for test: gen7_exec_parse
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_chamelium_hpd
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_content_protection
results: parsing output: 16/ for test: kms_plane_multiple
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_psr_stress_test
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_lease
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: syncobj_wait
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_cursor_crc
results: parsing output: 26/ for test: api_intel_allocator
results: parsing output: 27/ for test: kms_plane
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_exec_reloc
results: parsing output: 31/ for test: kms_async_flips
results: parsing output: 32/ for test: kms_flip_scaled_crc
results: parsing output: 33/ for test: api_intel_bb
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: gem_eio
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: gem_render_copy_redux
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: syncobj_basic
results: parsing output: 41/ for test: gem_exec_reloc
results: parsing output: 42/ for test: kms_atomic_transition
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: kms_chamelium_frames
results: parsing output: 47/ for test: kms_sequence
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_feature_discovery
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: kms_plane_scaling
results: parsing output: 52/ for test: gem_pxp
results: parsing output: 53/ for test: sw_sync
results: parsing output: 54/ for test: kms_addfb_basic
results: parsing output: 55/ for test: kms_psr2_su
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_pm_rpm
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: gem_workarounds
results: parsing output: 61/ for test: i915_drm_fdinfo
results: parsing output: 62/ for test: kms_vrr
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_fbcon_fbt
results: parsing output: 68/ for test: gem_create
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: gem_ctx_isolation
results: parsing output: 71/ for test: kms_rotation_crc
results: parsing output: 72/ for test: gem_exec_whisper
results: parsing output: 73/ for test: i915_pm_rpm
results: parsing output: 74/ for test: kms_plane
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_vblank
results: parsing output: 77/ for test: i915_selftest
results: parsing output: 78/ for test: gem_readwrite
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: fbdev
results: parsing output: 81/ for test: gem_eio
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: kms_rotation_crc
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: perf_pmu
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_exec_schedule
results: parsing output: 88/ for test: gem_exec_schedule
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_pipe_crc_basic
results: parsing output: 91/ for test: kms_properties
results: parsing output: 92/ for test: gem_ringfill
results: parsing output: 93/ for test: gem_mmap_wc
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_exec_balancer
results: parsing output: 98/ for test: gem_exec_whisper
results: parsing output: 99/ for test: kms_pm_backlight
results: parsing output: 100/ for test: gem_ctx_persistence
results: parsing output: 101/ for test: gem_exec_reloc
results: parsing output: 102/ for test: gem_wait
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: i915_drm_fdinfo
results: parsing output: 105/ for test: gem_exec_create
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_psr2_sf
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_exec_fence
results: parsing output: 111/ for test: gem_mmap_gtt
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_async_flips
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: prime_vgem
results: parsing output: 117/ for test: gem_unref_active_buffers
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: syncobj_wait
results: parsing output: 121/ for test: gem_ctx_bad_destroy
results: parsing output: 122/ for test: gem_pxp
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: gem_userptr_blits
results: parsing output: 125/ for test: kms_properties
results: parsing output: 126/ for test: gem_mmap_gtt
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_color_pipeline
results: parsing output: 129/ for test: sysfs_timeslice_duration
results: parsing output: 130/ for test: gem_spin_batch
results: parsing output: 131/ for test: gem_userptr_blits
results: parsing output: 132/ for test: dmabuf_sync_file
Done.