[57.639417] Initializing watchdogs
[57.639466]   /dev/watchdog0
[57.653988] [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]
[57.659144] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.661473] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.664986] [001/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[57.785293] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[57.789454] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[57.889079] [002/133] (960s left) gem_exec_suspend (basic-s3-devices)
[57.944010] Starting subtest: basic-S3-devices
[57.946313] Starting dynamic subtest: smem
[69.911916] Dynamic subtest smem: SUCCESS (11.977s)
[69.914970] Subtest basic-S3-devices: SUCCESS (11.979s)
[70.116563] [003/133] (948s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[70.206536] Starting subtest: y-tiled-ccs-to-yf-tiled
[70.210706] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[70.404350] [004/133] (947s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[70.508964] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[70.511413] Starting dynamic subtest: pipe-A-eDP-1
[70.534523] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[70.545456] Starting dynamic subtest: pipe-B-eDP-1
[70.567104] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[70.574030] Starting dynamic subtest: pipe-C-eDP-1
[70.595777] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[70.602897] Starting dynamic subtest: pipe-D-eDP-1
[70.625628] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[70.630084] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[72.791194] [005/133] (945s left) kms_flip (bo-too-big)
[72.894407] Starting subtest: bo-too-big
[72.896754] Starting dynamic subtest: A-eDP1
[74.222596] Dynamic subtest A-eDP1: SUCCESS (1.328s)
[74.232811] Starting dynamic subtest: B-eDP1
[75.539629] Dynamic subtest B-eDP1: SUCCESS (1.316s)
[75.549295] Starting dynamic subtest: C-eDP1
[76.883449] Dynamic subtest C-eDP1: SUCCESS (1.343s)
[76.894071] Starting dynamic subtest: D-eDP1
[78.213463] Dynamic subtest D-eDP1: SUCCESS (1.329s)
[78.215879] Subtest bo-too-big: SUCCESS (5.322s)
[79.440006] [006/133] (938s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[79.488586] Starting subtest: multi-wait-available-unsubmitted-signaled
[79.490842] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[79.606014] [007/133] (938s left) kms_lease (lease-uevent)
[79.709091] Starting subtest: lease-uevent
[80.726568] Subtest lease-uevent: SUCCESS (1.018s)
[80.873701] [008/133] (937s left) gem_exec_fence (syncobj-timeline-wait)
[81.446412] Starting subtest: syncobj-timeline-wait
[82.945629] Subtest syncobj-timeline-wait: SUCCESS (1.501s)
[84.993354] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[84.996575] [009/133] (933s left) kms_chamelium_color (gamma)
[85.105083] Subtest gamma: SKIP (0.000s)
[85.149473] [010/133] (933s left) prime_mmap (test_errors)
[85.197718] Starting subtest: test_errors
[85.199628] Starting dynamic subtest: test_errors-smem
[85.296019] Dynamic subtest test_errors-smem: SUCCESS (0.100s)
[85.298830] Subtest test_errors: SUCCESS (0.100s)
[85.438249] [011/133] (933s left) i915_drm_fdinfo (idle)
[85.482084] Starting subtest: idle
[85.484105] Starting dynamic subtest: rcs0
[86.074376] Dynamic subtest rcs0: SUCCESS (0.593s)
[86.085164] Starting dynamic subtest: bcs0
[86.580354] Dynamic subtest bcs0: SUCCESS (0.504s)
[86.591624] Starting dynamic subtest: vcs0
[87.089064] Dynamic subtest vcs0: SUCCESS (0.504s)
[87.099173] Starting dynamic subtest: vcs1
[87.591049] Dynamic subtest vcs1: SUCCESS (0.504s)
[87.599941] Starting dynamic subtest: vecs0
[88.096743] Dynamic subtest vecs0: SUCCESS (0.504s)
[88.107107] Starting dynamic subtest: ccs0
[88.602217] Dynamic subtest ccs0: SUCCESS (0.504s)
[88.605069] Subtest idle: SUCCESS (3.120s)
[88.699923] [012/133] (929s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[88.811635] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[88.815950] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[88.934119] [013/133] (929s left) kms_invalid_mode (zero-hdisplay)
[89.028600] Starting subtest: zero-hdisplay
[89.030955] Starting dynamic subtest: pipe-A-eDP-1
[89.317645] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[89.326101] Starting dynamic subtest: pipe-B-eDP-1
[89.328408] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[89.338159] Starting dynamic subtest: pipe-C-eDP-1
[89.340345] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[89.348203] Starting dynamic subtest: pipe-D-eDP-1
[89.350299] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[89.352492] Subtest zero-hdisplay: SUCCESS (0.294s)
[90.176923] [014/133] (928s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[90.278751] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[90.281186] Starting dynamic subtest: pipe-A
[90.344239] Dynamic subtest pipe-A: SUCCESS (0.068s)
[90.356768] Starting dynamic subtest: pipe-B
[91.475769] Dynamic subtest pipe-B: SUCCESS (1.131s)
[91.489682] Starting dynamic subtest: pipe-C
[92.595401] Dynamic subtest pipe-C: SUCCESS (1.119s)
[92.605161] Starting dynamic subtest: pipe-D
[93.727736] Dynamic subtest pipe-D: SUCCESS (1.132s)
[93.730270] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.451s)
[94.905630] [015/133] (923s left) drm_read (fault-buffer)
[95.057682] Starting subtest: fault-buffer
[95.060039] Subtest fault-buffer: SUCCESS (0.000s)
[95.243971] [016/133] (923s left) gem_ccs (suspend-resume)
[95.310814] Starting subtest: suspend-resume
[95.315496] Subtest suspend-resume: SKIP (0.000s)
[95.447959] [017/133] (923s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[95.539986] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[95.542363] Starting dynamic subtest: pipe-A-eDP-1
[95.565164] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[95.575623] Starting dynamic subtest: pipe-B-eDP-1
[95.597326] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[95.605177] Starting dynamic subtest: pipe-C-eDP-1
[95.626636] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[95.634241] Starting dynamic subtest: pipe-D-eDP-1
[95.656158] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[95.660169] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[97.856488] [018/133] (920s left) gem_close (many-handles-one-vma)
[97.925014] Starting subtest: many-handles-one-vma
[97.952514] Subtest many-handles-one-vma: SUCCESS (0.028s)
[98.071203] [019/133] (920s left) gem_busy (extended)
[98.258722] Starting subtest: extended
[98.260850] Starting dynamic subtest: rcs0
[98.357690] Dynamic subtest rcs0: SUCCESS (0.099s)
[98.368244] Starting dynamic subtest: bcs0
[98.398400] Dynamic subtest bcs0: SUCCESS (0.040s)
[98.408598] Starting dynamic subtest: vcs0
[99.927936] Dynamic subtest vcs0: SUCCESS (1.527s)
[99.939218] Starting dynamic subtest: vcs1
[101.913907] Dynamic subtest vcs1: SUCCESS (1.984s)
[101.925655] Starting dynamic subtest: vecs0
[103.897509] Dynamic subtest vecs0: SUCCESS (1.982s)
[103.908634] Starting dynamic subtest: ccs0
[103.942910] Dynamic subtest ccs0: SUCCESS (0.047s)
[103.945376] Subtest extended: SUCCESS (5.685s)
[104.178123] [020/133] (914s left) kms_vblank (ts-continuation-suspend)
[104.296643] Starting subtest: ts-continuation-suspend
[104.298769] Starting dynamic subtest: pipe-A-eDP-1
[120.398755] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.527s)
[120.412788] Starting dynamic subtest: pipe-D-eDP-1
[137.391310] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.188s)
[137.393728] Subtest ts-continuation-suspend: SUCCESS (3.718s)
[138.216619] [021/133] (880s left) perf_pmu (semaphore-wait-idle)
[138.264575] Starting subtest: semaphore-wait-idle
[138.266372] Starting dynamic subtest: rcs0
[138.779145] Dynamic subtest rcs0: SUCCESS (0.517s)
[138.790600] Starting dynamic subtest: bcs0
[139.291115] Dynamic subtest bcs0: SUCCESS (0.514s)
[139.302566] Starting dynamic subtest: vcs0
[139.804050] Dynamic subtest vcs0: SUCCESS (0.515s)
[139.815865] Starting dynamic subtest: vcs1
[140.316204] Dynamic subtest vcs1: SUCCESS (0.514s)
[140.327476] Starting dynamic subtest: vecs0
[140.826853] Dynamic subtest vecs0: SUCCESS (0.512s)
[140.838588] Starting dynamic subtest: ccs0
[141.341044] Dynamic subtest ccs0: SUCCESS (0.516s)
[141.343752] Subtest semaphore-wait-idle: SUCCESS (3.096s)
[141.498710] [022/133] (877s left) kms_debugfs (display-off-read-all)
[141.611541] Starting subtest: display-off-read-all
[141.898492] Subtest display-off-read-all: SUCCESS (0.288s)
[142.715731] [023/133] (876s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[142.826252] Starting subtest: fbc-rgb101010-draw-blt
[147.618192] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.811s)
[148.830227] [024/133] (870s left) gem_ctx_param (invalid-get-no-zeromap)
[148.888440] Starting subtest: invalid-get-no-zeromap
[148.890764] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[149.036457] [025/133] (870s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[149.162156] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[149.166669] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[149.291314] [026/133] (869s left) gem_exec_big (single)
[149.355223] Starting subtest: single
[151.674096] Subtest single: SUCCESS (2.322s)
[151.926838] [027/133] (867s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[152.078995] Starting subtest: psr-rgb101010-draw-mmap-gtt
[152.082995] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[152.220597] [028/133] (867s left) gem_exec_flush (basic-uc-prw-default)
[152.290392] Starting subtest: basic-uc-prw-default
[157.741128] Subtest basic-uc-prw-default: SUCCESS (5.459s)
[157.948139] [029/133] (861s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[158.045639] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[158.049497] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[158.177895] [030/133] (861s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[158.282150] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[165.191582] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.917s)
[165.347641] [031/133] (854s left) gem_exec_create (forked)
[165.418690] Starting subtest: forked
[165.421058] Starting dynamic subtest: smem
[185.590626] Dynamic subtest smem: SUCCESS (20.171s)
[185.593330] Subtest forked: SUCCESS (20.171s)
[185.807844] [032/133] (833s left) kms_feature_discovery (display-1x)
[185.910814] Starting subtest: display-1x
[185.912774] Subtest display-1x: SUCCESS (0.000s)
[186.009221] [033/133] (833s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[186.124506] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[186.128568] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[186.262032] [034/133] (833s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[186.368552] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[186.373059] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[186.502658] [035/133] (833s left) gem_render_copy_redux (interruptible)
[186.572891] Starting subtest: interruptible
[186.829067] Subtest interruptible: SUCCESS (0.256s)
[187.006624] [036/133] (832s left) i915_pm_rpm (system-suspend-execbuf)
[188.559850] Starting subtest: system-suspend-execbuf
[246.948700] Subtest system-suspend-execbuf: SUCCESS (42.999s)
[247.333764] [037/133] (772s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[247.435646] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[247.440442] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[247.566479] [038/133] (772s left) gem_request_retire (retire-vma-not-inactive)
[247.624723] Starting subtest: retire-vma-not-inactive
[247.685532] Subtest retire-vma-not-inactive: SUCCESS (0.059s)
[247.840761] [039/133] (771s left) i915_pm_rps (thresholds-idle)
[247.905478] Starting subtest: thresholds-idle
[247.910342] Subtest thresholds-idle: SKIP (0.001s)
[248.036876] [040/133] (771s left) gem_ctx_persistence (legacy-engines-queued)
[248.098243] Starting subtest: legacy-engines-queued
[248.100744] Starting dynamic subtest: render
[248.186005] Dynamic subtest render: SUCCESS (0.087s)
[248.198465] Starting dynamic subtest: bsd1
[249.714235] Dynamic subtest bsd1: SUCCESS (1.524s)
[249.726700] Starting dynamic subtest: bsd2
[251.761205] Dynamic subtest bsd2: SUCCESS (2.043s)
[251.773696] Starting dynamic subtest: blt
[251.840961] Dynamic subtest blt: SUCCESS (0.079s)
[251.852480] Starting dynamic subtest: vebox
[253.745098] Dynamic subtest vebox: SUCCESS (1.900s)
[253.748135] Subtest legacy-engines-queued: SUCCESS (5.644s)
[253.850166] [041/133] (765s left) i915_hangman (gt-error-state-capture)
[253.907578] Starting subtest: gt-error-state-capture
[253.910467] Starting dynamic subtest: rcs0
[265.713419] Dynamic subtest rcs0: SUCCESS (11.804s)
[265.726745] Starting dynamic subtest: bcs0
[276.720932] Dynamic subtest bcs0: SUCCESS (11.007s)
[276.733902] Starting dynamic subtest: vcs0
[287.664340] Dynamic subtest vcs0: SUCCESS (10.944s)
[287.677876] Starting dynamic subtest: vcs1
[298.672334] Dynamic subtest vcs1: SUCCESS (11.009s)
[298.685392] Starting dynamic subtest: vecs0
[309.681620] Dynamic subtest vecs0: SUCCESS (11.005s)
[309.693920] Starting dynamic subtest: ccs0
[320.753208] Dynamic subtest ccs0: SUCCESS (11.066s)
[320.755908] Subtest gt-error-state-capture: SUCCESS (66.846s)
[320.860011] [042/133] (698s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[321.101098] Starting subtest: cursor-rapid-movement-128x42
[321.148413] Subtest cursor-rapid-movement-128x42: SKIP (0.043s)
[321.415918] [043/133] (698s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[321.476059] Subtest writes-after-reads-uncached: SKIP (0.000s)
[321.541718] [044/133] (698s left) gem_mmap_wc (coherency)
[321.595590] Subtest coherency: SKIP (0.000s)
[321.656788] [045/133] (698s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[321.726646] Starting subtest: single-wait-all-for-submit-signaled
[321.729734] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[321.824416] [046/133] (698s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[321.930408] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[325.659167] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.734s)
[326.820340] [047/133] (693s left) kms_psr (fbc-psr-primary-mmap-cpu)
[326.920482] Starting subtest: fbc-psr-primary-mmap-cpu
[326.923306] Starting dynamic subtest: eDP-1
[326.928523] Dynamic subtest eDP-1: SKIP (0.000s)
[326.934005] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[327.020801] [048/133] (693s left) kms_invalid_mode (bad-vsync-start)
[327.115139] Starting subtest: bad-vsync-start
[327.117733] Starting dynamic subtest: pipe-A-eDP-1
[327.403193] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[327.414543] Starting dynamic subtest: pipe-B-eDP-1
[327.417098] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[327.426705] Starting dynamic subtest: pipe-C-eDP-1
[327.429372] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[327.440401] Starting dynamic subtest: pipe-D-eDP-1
[327.442972] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[327.445276] Subtest bad-vsync-start: SUCCESS (0.295s)
[328.253822] [049/133] (691s left) gem_exec_reloc (basic-wc-gtt)
[328.327724] Subtest basic-wc-gtt: SKIP (0.000s)
[328.415202] [050/133] (691s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[328.476691] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[328.558258] [051/133] (691s left) kms_prop_blob (blob-multiple)
[328.612022] Starting subtest: blob-multiple
[328.614680] Subtest blob-multiple: SUCCESS (0.002s)
[328.760022] [052/133] (691s left) api_intel_allocator (open-vm)
[328.820091] Starting subtest: open-vm
[328.822757] Subtest open-vm: SUCCESS (0.003s)
[328.972907] [053/133] (691s left) kms_getfb (getfb-repeated-different-handles)
[329.080498] Starting subtest: getfb-repeated-different-handles
[329.083072] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[329.228789] [054/133] (691s left) kms_content_protection (legacy-hdcp14)
[329.379578] Starting subtest: legacy-hdcp14
[329.383294] Subtest legacy-hdcp14: SKIP (0.000s)
[329.539333] [055/133] (690s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[329.937471] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[330.736683] [056/133] (689s left) kms_flip (blocking-absolute-wf_vblank)
[330.837191] Starting subtest: blocking-absolute-wf_vblank
[330.839694] Starting dynamic subtest: A-eDP1
[339.622302] Dynamic subtest A-eDP1: SUCCESS (8.787s)
[339.633685] Starting dynamic subtest: B-eDP1
[348.358538] Dynamic subtest B-eDP1: SUCCESS (8.734s)
[348.375641] Starting dynamic subtest: C-eDP1
[357.074860] Dynamic subtest C-eDP1: SUCCESS (8.715s)
[357.086633] Starting dynamic subtest: D-eDP1
[365.800294] Dynamic subtest D-eDP1: SUCCESS (8.725s)
[365.806780] Subtest blocking-absolute-wf_vblank: SUCCESS (34.975s)
[367.039586] [057/133] (653s left) gem_mmap_offset (bad-object)
[367.115858] Starting subtest: bad-object
[367.118288] Subtest bad-object: SUCCESS (0.001s)
[367.253778] [058/133] (653s left) kms_psr (psr2-no-drrs)
[367.350514] Starting subtest: psr2-no-drrs
[367.353213] Starting dynamic subtest: eDP-1
[368.989422] Dynamic subtest eDP-1: SUCCESS (1.635s)
[368.991709] Subtest psr2-no-drrs: SUCCESS (1.636s)
[369.805419] [059/133] (650s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[369.867350] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[369.936307] [060/133] (650s left) kms_vblank (wait-idle)
[370.021741] Starting subtest: wait-idle
[370.024101] Starting dynamic subtest: pipe-A-eDP-1
[371.792298] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.770s)
[371.808307] Starting dynamic subtest: pipe-D-eDP-1
[374.235679] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.440s)
[374.238173] Subtest wait-idle: SUCCESS (4.214s)
[375.083800] [061/133] (645s left) gem_exec_whisper (basic-contexts-all)
[375.154415] Starting subtest: basic-contexts-all
[385.616042] Subtest basic-contexts-all: SUCCESS (10.463s)
[385.827000] [062/133] (634s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[385.939544] Starting subtest: x-tiled-16bpp-rotate-0
[387.240677] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.301s)
[387.407079] [063/133] (633s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[387.513025] Starting subtest: plane-primary-overlay-mutable-zpos
[390.994447] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.479s)
[392.210772] [064/133] (628s left) gen9_exec_parse (bb-start-cmd)
[392.283569] Subtest bb-start-cmd: SKIP (0.000s)
[392.371007] [065/133] (628s left) kms_cursor_crc (cursor-alpha-opaque)
[392.464303] Starting subtest: cursor-alpha-opaque
[392.466642] Starting dynamic subtest: pipe-A-eDP-1
[393.101496] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.636s)
[393.111752] Starting dynamic subtest: pipe-D-eDP-1
[394.361870] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.258s)
[394.364388] Subtest cursor-alpha-opaque: SUCCESS (1.897s)
[395.215844] [066/133] (625s left) kms_cursor_crc (cursor-sliding-64x64)
[395.391884] Starting subtest: cursor-sliding-64x64
[395.397551] Starting dynamic subtest: pipe-A-eDP-1
[398.633085] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.237s)
[398.676153] Starting dynamic subtest: pipe-D-eDP-1
[402.654274] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.985s)
[402.656553] Subtest cursor-sliding-64x64: SUCCESS (7.262s)
[403.546199] [067/133] (617s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[403.651842] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[410.394293] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.746s)
[410.552985] [068/133] (610s left) gem_ctx_shared (exec-single-timeline)
[410.623732] Starting subtest: exec-single-timeline
[410.626581] Starting dynamic subtest: rcs0
[411.694550] Dynamic subtest rcs0: SUCCESS (1.069s)
[411.708042] Starting dynamic subtest: bcs0
[412.783318] Dynamic subtest bcs0: SUCCESS (1.086s)
[412.796856] Starting dynamic subtest: vcs0
[413.873085] Dynamic subtest vcs0: SUCCESS (1.087s)
[413.885767] Starting dynamic subtest: vcs1
[414.960302] Dynamic subtest vcs1: SUCCESS (1.084s)
[414.973699] Starting dynamic subtest: vecs0
[416.047684] Dynamic subtest vecs0: SUCCESS (1.085s)
[416.060805] Starting dynamic subtest: ccs0
[417.135455] Dynamic subtest ccs0: SUCCESS (1.085s)
[417.138353] Subtest exec-single-timeline: SUCCESS (6.514s)
[417.831517] [069/133] (603s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[417.937909] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[417.940109] Starting dynamic subtest: pipe-A
[419.254983] Dynamic subtest pipe-A: SUCCESS (1.319s)
[419.271014] Starting dynamic subtest: pipe-B
[421.622989] Dynamic subtest pipe-B: SUCCESS (2.365s)
[421.639069] Starting dynamic subtest: pipe-C
[422.846181] Dynamic subtest pipe-C: SUCCESS (1.221s)
[422.856650] Starting dynamic subtest: pipe-D
[424.081547] Dynamic subtest pipe-D: SUCCESS (1.233s)
[424.084641] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (6.147s)
[425.298573] [070/133] (595s left) gem_wait (write-busy)
[425.377158] Starting subtest: write-busy
[425.379524] Starting dynamic subtest: all-engines
[426.008973] Dynamic subtest all-engines: SUCCESS (0.635s)
[426.021545] Starting dynamic subtest: rcs0
[426.569137] Dynamic subtest rcs0: SUCCESS (0.557s)
[426.586443] Starting dynamic subtest: bcs0
[427.120029] Dynamic subtest bcs0: SUCCESS (0.550s)
[427.136516] Starting dynamic subtest: vcs0
[428.753441] Dynamic subtest vcs0: SUCCESS (1.632s)
[428.768993] Starting dynamic subtest: vcs1
[430.737749] Dynamic subtest vcs1: SUCCESS (1.982s)
[430.754963] Starting dynamic subtest: vecs0
[432.786617] Dynamic subtest vecs0: SUCCESS (2.045s)
[432.803544] Starting dynamic subtest: ccs0
[433.337685] Dynamic subtest ccs0: SUCCESS (0.549s)
[433.340696] Subtest write-busy: SUCCESS (7.964s)
[433.559922] [071/133] (587s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[433.672991] Starting subtest: y-tiled-8bpp-rotate-0
[433.678526] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[433.798153] [072/133] (587s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[433.941413] Starting subtest: basic-busy-flip-before-cursor-legacy
[433.946621] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[434.106434] [073/133] (587s left) gem_basic (bad-close)
[434.153730] Starting subtest: bad-close
[434.158672] Subtest bad-close: SUCCESS (0.000s)
[434.287113] [074/133] (587s left) kms_big_fb (linear-16bpp-rotate-0)
[434.398708] Starting subtest: linear-16bpp-rotate-0
[435.755974] Subtest linear-16bpp-rotate-0: SUCCESS (1.357s)
[435.917075] [075/133] (585s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[440.948980] Starting subtest: pr-overlay-plane-update-continuous-sf
[440.954523] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.002s)
[441.821517] [076/133] (579s left) drm_read (short-buffer-wakeup)
[441.973102] Starting subtest: short-buffer-wakeup
[474.194974] Subtest short-buffer-wakeup: SUCCESS (32.216s)
[474.372382] [077/133] (547s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[474.470705] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[481.687797] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.218s)
[481.860609] [078/133] (539s left) kms_psr (fbc-pr-cursor-render)
[481.963490] Starting subtest: fbc-pr-cursor-render
[481.968764] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[482.075392] [079/133] (539s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[482.174531] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[482.177410] Starting dynamic subtest: pipe-A-eDP-1
[482.187565] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[482.198714] Starting dynamic subtest: pipe-B-eDP-1
[482.209454] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[482.219488] Starting dynamic subtest: pipe-C-eDP-1
[482.229964] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[482.239545] Starting dynamic subtest: pipe-D-eDP-1
[482.249853] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[482.255239] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[484.460160] [080/133] (537s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[484.561421] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[484.563929] Starting dynamic subtest: pipe-A-eDP-1
[485.831711] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.273s)
[485.841715] Starting dynamic subtest: pipe-B-eDP-1
[488.165331] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.332s)
[488.175621] Starting dynamic subtest: pipe-C-eDP-1
[490.491954] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.326s)
[490.501447] Starting dynamic subtest: pipe-D-eDP-1
[492.824838] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.331s)
[492.827542] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.267s)
[494.070914] [081/133] (527s left) sw_sync (sync_multi_timeline_wait)
[494.112565] Starting subtest: sync_multi_timeline_wait
[494.115124] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[494.206755] [082/133] (527s left) sysfs_heartbeat_interval (idempotent)
[494.273458] Starting subtest: idempotent
[494.276428] Starting dynamic subtest: vecs0
[494.279226] Dynamic subtest vecs0: SUCCESS (0.001s)
[494.290398] Starting dynamic subtest: ccs0
[494.293063] Dynamic subtest ccs0: SUCCESS (0.001s)
[494.302742] Starting dynamic subtest: vcs0
[494.305547] Dynamic subtest vcs0: SUCCESS (0.000s)
[494.315725] Starting dynamic subtest: bcs0
[494.318536] Dynamic subtest bcs0: SUCCESS (0.001s)
[494.328532] Starting dynamic subtest: rcs0
[494.331526] Dynamic subtest rcs0: SUCCESS (0.001s)
[494.341526] Starting dynamic subtest: vcs1
[494.344297] Dynamic subtest vcs1: SUCCESS (0.000s)
[494.346877] Subtest idempotent: SUCCESS (0.008s)
[494.414580] [083/133] (527s left) syncobj_eventfd (invalid-bad-pad)
[494.478135] Starting subtest: invalid-bad-pad
[494.480576] Subtest invalid-bad-pad: SUCCESS (0.000s)
[494.595064] [084/133] (527s left) kms_busy (extended-pageflip-hang-newfb)
[494.707057] Starting subtest: extended-pageflip-hang-newfb
[494.709442] Starting dynamic subtest: pipe-A
[521.585247] Dynamic subtest pipe-A: SUCCESS (26.878s)
[521.595706] Starting dynamic subtest: pipe-D
[536.548480] Dynamic subtest pipe-D: SUCCESS (14.961s)
[536.551253] Subtest extended-pageflip-hang-newfb: SUCCESS (41.844s)
[537.431635] [085/133] (484s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[542.479488] Starting subtest: psr2-cursor-plane-update-sf
[542.482333] Starting dynamic subtest: pipe-A-eDP-1
[543.784017] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.307s)
[543.798356] Starting dynamic subtest: pipe-B-eDP-1
[545.125383] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.338s)
[545.128066] Subtest psr2-cursor-plane-update-sf: SUCCESS (2.649s)
[546.009668] [086/133] (475s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[546.121502] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[546.801351] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.681s)
[547.015104] [087/133] (474s left) gem_exec_balancer (busy)
[547.082422] Starting subtest: busy
[548.737865] Subtest busy: SUCCESS (1.654s)
[549.091995] [088/133] (472s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[549.189466] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[549.194703] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[549.325416] [089/133] (472s left) vgem_slow (nohang)
[549.390552] Starting subtest: nohang
[559.535533] Subtest nohang: SUCCESS (10.146s)
[559.634993] [090/133] (462s left) gem_spin_batch (resubmit-new-all)
[559.705823] Starting subtest: resubmit-new-all
[559.708637] Starting dynamic subtest: rcs0
[559.735729] Dynamic subtest rcs0: SUCCESS (0.029s)
[559.752596] Starting dynamic subtest: bcs0
[559.758548] Dynamic subtest bcs0: SUCCESS (0.020s)
[559.772325] Starting dynamic subtest: vcs0
[559.774448] Dynamic subtest vcs0: SUCCESS (0.019s)
[559.784712] Starting dynamic subtest: vcs1
[559.794690] Dynamic subtest vcs1: SUCCESS (0.018s)
[559.804677] Starting dynamic subtest: vecs0
[559.812693] Dynamic subtest vecs0: SUCCESS (0.017s)
[559.822641] Starting dynamic subtest: ccs0
[559.832714] Dynamic subtest ccs0: SUCCESS (0.019s)
[559.835516] Subtest resubmit-new-all: SUCCESS (0.127s)
[561.814967] [091/133] (460s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[561.889747] Starting subtest: mixed-tiled-to-y-tiled-ccs
[561.895524] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[562.106313] [092/133] (460s left) syncobj_timeline (invalid-signal-illegal-point)
[562.170000] Starting subtest: invalid-signal-illegal-point
[562.172733] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[562.295480] [093/133] (459s left) gem_exec_schedule (preempt-contexts)
[562.389159] Starting subtest: preempt-contexts
[562.391771] Starting dynamic subtest: rcs0
[562.480520] Dynamic subtest rcs0: SUCCESS (0.102s)
[562.491561] Starting dynamic subtest: bcs0
[562.588176] Dynamic subtest bcs0: SUCCESS (0.107s)
[562.598574] Starting dynamic subtest: vcs0
[562.665753] Dynamic subtest vcs0: SUCCESS (0.075s)
[562.675491] Starting dynamic subtest: vcs1
[562.740054] Dynamic subtest vcs1: SUCCESS (0.074s)
[562.751460] Starting dynamic subtest: vecs0
[562.801933] Dynamic subtest vecs0: SUCCESS (0.061s)
[562.812277] Starting dynamic subtest: ccs0
[562.896564] Dynamic subtest ccs0: SUCCESS (0.094s)
[562.899528] Subtest preempt-contexts: SUCCESS (0.519s)
[563.882071] [094/133] (458s left) gem_pwrite_snooped
[564.050255] [095/133] (458s left) kms_tiled_display (basic-test-pattern)
[564.178878] Subtest basic-test-pattern: SKIP (0.000s)
[564.231117] [096/133] (458s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[564.329166] Starting subtest: psr-shrfb-scaledprimary
[570.113839] Subtest psr-shrfb-scaledprimary: SUCCESS (5.789s)
[570.289989] [097/133] (452s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[570.398449] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[570.403555] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[570.534005] [098/133] (451s left) gem_pwrite (basic-self)
[570.600718] Subtest basic-self: SKIP (0.000s)
[570.677701] [099/133] (451s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[572.917567] Starting subtest: dpms-mode-unset-non-lpsp
[574.082403] Subtest dpms-mode-unset-non-lpsp: SKIP (1.165s)
[574.479037] [100/133] (448s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[574.580831] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[574.586508] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[574.715029] [101/133] (447s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[574.821569] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[574.826551] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[574.954685] [102/133] (447s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[575.049269] Starting subtest: plane-lut1d-ctm3x4-lut1d
[575.062690] Starting dynamic subtest: pipe-A-eDP-1
[575.768044] Dynamic subtest pipe-A-eDP-1: FAIL (0.310s)
[576.428510] Starting dynamic subtest: pipe-B-eDP-1
[577.368490] Dynamic subtest pipe-B-eDP-1: FAIL (0.302s)
[577.760743] Starting dynamic subtest: pipe-C-eDP-1
[578.724399] Dynamic subtest pipe-C-eDP-1: FAIL (0.257s)
[579.090638] Starting dynamic subtest: pipe-D-eDP-1
[580.032294] Dynamic subtest pipe-D-eDP-1: FAIL (0.247s)
[580.035014] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.568s)
[580.495100] [103/133] (442s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[580.600486] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[587.393624] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.797s)
[587.547085] [104/133] (435s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[587.659180] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[594.624354] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.970s)
[594.799089] [105/133] (427s left) gem_exec_schedule (preempt-queue-contexts-chain)
[594.872622] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[595.183512] [106/133] (427s left) api_intel_bb (object-noreloc-keep-cache-simple)
[595.248184] Starting subtest: object-noreloc-keep-cache-simple
[595.251513] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.006s)
[595.403740] [107/133] (427s left) gem_mmap (bad-object)
[595.464294] Subtest bad-object: SKIP (0.000s)
[595.524200] [108/133] (427s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[595.622895] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[595.625201] Starting dynamic subtest: pipe-A-default-mode
[595.915063] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[595.919684] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.290s)
[596.772191] [109/133] (426s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[596.864728] Starting subtest: bo-too-small-due-to-tiling
[596.869741] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[597.000406] [110/133] (425s left) kms_psr (pr-sprite-blt)
[597.099199] Starting subtest: pr-sprite-blt
[597.103932] Subtest pr-sprite-blt: SKIP (0.000s)
[597.200582] [111/133] (425s left) kms_draw_crc (fill-fb)
[597.297746] Starting subtest: fill-fb
[597.781416] Subtest fill-fb: SUCCESS (0.486s)
[597.910067] [112/133] (425s left) perf_pmu (busy-idle)
[597.953122] Starting subtest: busy-idle
[597.954731] Starting dynamic subtest: rcs0
[598.625156] Dynamic subtest rcs0: SUCCESS (0.672s)
[598.638727] Starting dynamic subtest: bcs0
[599.300063] Dynamic subtest bcs0: SUCCESS (0.673s)
[599.313439] Starting dynamic subtest: vcs0
[600.786939] Dynamic subtest vcs0: SUCCESS (1.483s)
[600.799692] Starting dynamic subtest: vcs1
[602.770786] Dynamic subtest vcs1: SUCCESS (1.981s)
[602.783686] Starting dynamic subtest: vecs0
[604.754394] Dynamic subtest vecs0: SUCCESS (1.981s)
[604.767249] Starting dynamic subtest: ccs0
[605.429429] Dynamic subtest ccs0: SUCCESS (0.674s)
[605.432418] Subtest busy-idle: SUCCESS (7.479s)
[605.558726] [113/133] (417s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[605.662720] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[605.665026] Starting dynamic subtest: pipe-A-eDP-1
[605.730158] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[605.741210] Starting dynamic subtest: pipe-B-eDP-1
[605.808692] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[605.820015] Starting dynamic subtest: pipe-C-eDP-1
[605.886619] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[605.896506] Starting dynamic subtest: pipe-D-eDP-1
[605.961793] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[605.966862] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[607.919100] [114/133] (415s left) gem_exec_flush (basic-batch-kernel-default-uc)
[607.996284] Starting subtest: basic-batch-kernel-default-uc
[614.647970] Subtest basic-batch-kernel-default-uc: SUCCESS (6.654s)
[614.860562] [115/133] (408s left) gem_mmap_wc (write-read-distinct)
[614.922449] Subtest write-read-distinct: SKIP (0.000s)
[614.991622] [116/133] (408s left) kms_plane_lowres (tiling-x)
[615.096987] Starting subtest: tiling-x
[615.099193] Starting dynamic subtest: pipe-A-eDP-1
[615.103915] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[615.406741] Starting dynamic subtest: pipe-B-eDP-1
[615.412416] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[615.422505] Starting dynamic subtest: pipe-C-eDP-1
[615.427713] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[615.437573] Starting dynamic subtest: pipe-D-eDP-1
[615.442629] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[615.447603] Subtest tiling-x: SKIP (0.309s)
[616.240431] [117/133] (407s left) sw_sync (alloc_merge_fence)
[616.274716] Starting subtest: alloc_merge_fence
[616.277606] Subtest alloc_merge_fence: SUCCESS (0.000s)
[616.378949] [118/133] (406s left) kms_pm_backlight (fade)
[616.486215] Starting subtest: fade
[616.541260] Starting dynamic subtest: eDP-1
[619.245479] Dynamic subtest eDP-1: SUCCESS (2.703s)
[619.248398] Subtest fade: SUCCESS (2.758s)
[620.071451] [119/133] (403s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[620.162458] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[620.165071] Starting dynamic subtest: pipe-A-default-mode
[621.313478] Dynamic subtest pipe-A-default-mode: SKIP (1.148s)
[621.318205] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.150s)
[621.508469] [120/133] (401s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[621.576621] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[621.678422] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[621.781126] [121/133] (401s left) kms_psr (psr-cursor-mmap-cpu)
[621.889954] Starting subtest: psr-cursor-mmap-cpu
[621.892582] Starting dynamic subtest: eDP-1
[623.578698] Dynamic subtest eDP-1: SUCCESS (1.690s)
[623.581540] Subtest psr-cursor-mmap-cpu: SUCCESS (1.691s)
[624.476605] [122/133] (399s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[624.581603] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[625.271685] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.692s)
[625.480106] [123/133] (398s left) gem_exec_whisper (basic-queues-priority-all)
[625.543618] Starting subtest: basic-queues-priority-all
[649.123756] Subtest basic-queues-priority-all: SUCCESS (23.583s)
[649.335951] [124/133] (374s left) syncobj_timeline (etime-single-wait-all-submitted)
[649.390983] Starting subtest: etime-single-wait-all-submitted
[649.494466] Subtest etime-single-wait-all-submitted: SUCCESS (0.104s)
[649.598976] [125/133] (374s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[649.699273] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[649.704705] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[649.831603] [126/133] (373s left) kms_async_flips (async-flip-dpms)
[649.930545] Starting subtest: async-flip-dpms
[650.313619] Starting dynamic subtest: pipe-A-eDP-1
[654.171010] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.857s)
[654.545374] Starting dynamic subtest: pipe-B-eDP-1
[657.357519] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.820s)
[657.756271] Starting dynamic subtest: pipe-C-eDP-1
[660.537917] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.791s)
[660.918460] Starting dynamic subtest: pipe-D-eDP-1
[663.708728] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.798s)
[663.711650] Subtest async-flip-dpms: SUCCESS (13.783s)
[664.917391] [127/133] (358s left) gem_exec_reloc (basic-cpu-read-noreloc)
[664.979236] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[665.048604] [128/133] (358s left) syncobj_wait (invalid-reset-illegal-handle)
[665.116601] Starting subtest: invalid-reset-illegal-handle
[665.119595] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[665.259308] [129/133] (358s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[665.322240] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[665.421466] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[665.527922] [130/133] (358s left) gem_tiled_swapping (non-threaded)
[665.595743] Subtest non-threaded: SKIP (0.000s)
[665.665612] [131/133] (358s left) gem_exec_fence (syncobj-timeline-chain-engines)
[666.224325] Starting subtest: syncobj-timeline-chain-engines
[666.349866] Subtest syncobj-timeline-chain-engines: SUCCESS (0.126s)
[667.930468] [132/133] (355s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[668.057224] Starting subtest: flip-vs-cursor-legacy
[675.190742] Subtest flip-vs-cursor-legacy: SUCCESS (7.136s)
[676.039788] [133/133] (347s left) syncobj_basic (illegal-fd-to-handle)
[676.102579] Starting subtest: illegal-fd-to-handle
[676.105229] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[676.250642] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_exec_suspend
results: parsing output: 2/ for test: gem_render_copy
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: kms_lease
results: parsing output: 7/ for test: gem_exec_fence
results: parsing output: 8/ for test: kms_chamelium_color
results: parsing output: 9/ for test: prime_mmap
results: parsing output: 10/ for test: i915_drm_fdinfo
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_invalid_mode
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: drm_read
results: parsing output: 15/ for test: gem_ccs
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: gem_close
results: parsing output: 18/ for test: gem_busy
results: parsing output: 19/ for test: kms_vblank
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: kms_debugfs
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_ctx_param
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_exec_big
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_exec_flush
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_exec_create
results: parsing output: 31/ for test: kms_feature_discovery
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_render_copy_redux
results: parsing output: 35/ for test: i915_pm_rpm
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_request_retire
results: parsing output: 38/ for test: i915_pm_rps
results: parsing output: 39/ for test: gem_ctx_persistence
results: parsing output: 40/ for test: i915_hangman
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: gem_partial_pwrite_pread
results: parsing output: 43/ for test: gem_mmap_wc
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_invalid_mode
results: parsing output: 48/ for test: gem_exec_reloc
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: kms_prop_blob
results: parsing output: 51/ for test: api_intel_allocator
results: parsing output: 52/ for test: kms_getfb
results: parsing output: 53/ for test: kms_content_protection
results: parsing output: 54/ for test: kms_chamelium_hpd
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: gem_mmap_offset
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: gem_fenced_exec_thrash
results: parsing output: 59/ for test: kms_vblank
results: parsing output: 60/ for test: gem_exec_whisper
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_atomic
results: parsing output: 63/ for test: gen9_exec_parse
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_ctx_shared
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: gem_wait
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: gem_basic
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: drm_read
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: sw_sync
results: parsing output: 81/ for test: sysfs_heartbeat_interval
results: parsing output: 82/ for test: syncobj_eventfd
results: parsing output: 83/ for test: kms_busy
results: parsing output: 84/ for test: kms_psr2_sf
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_exec_balancer
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: vgem_slow
results: parsing output: 89/ for test: gem_spin_batch
results: parsing output: 90/ for test: gem_render_copy
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: gem_pwrite_snooped
results: parsing output: 94/ for test: kms_tiled_display
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_pwrite
results: parsing output: 98/ for test: kms_pm_rpm
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_color_pipeline
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: api_intel_bb
results: parsing output: 106/ for test: gem_mmap
results: parsing output: 107/ for test: kms_flip_scaled_crc
results: parsing output: 108/ for test: kms_addfb_basic
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: kms_draw_crc
results: parsing output: 111/ for test: perf_pmu
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: gem_exec_flush
results: parsing output: 114/ for test: gem_mmap_wc
results: parsing output: 115/ for test: kms_plane_lowres
results: parsing output: 116/ for test: sw_sync
results: parsing output: 117/ for test: kms_pm_backlight
results: parsing output: 118/ for test: kms_flip_scaled_crc
results: parsing output: 119/ for test: syncobj_wait
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: gem_exec_whisper
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_async_flips
results: parsing output: 126/ for test: gem_exec_reloc
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: gem_tiled_swapping
results: parsing output: 130/ for test: gem_exec_fence
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: syncobj_basic
Done.