[59.824307] Initializing watchdogs [59.824388] /dev/watchdog0 [59.839237] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [59.843732] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.846039] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.849307] [001/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt) [59.966677] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt [59.971021] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [60.099671] [002/133] (960s left) gem_exec_suspend (basic-s3-devices) [60.167432] Starting subtest: basic-S3-devices [60.169945] Starting dynamic subtest: smem [71.893225] Dynamic subtest smem: SUCCESS (11.765s) [71.895821] Subtest basic-S3-devices: SUCCESS (11.766s) [81.122782] [003/133] (948s left) gem_render_copy (y-tiled-ccs-to-yf-tiled) [81.215888] Starting subtest: y-tiled-ccs-to-yf-tiled [81.220447] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s) [81.425573] [004/133] (948s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs) [81.532696] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs [81.535050] Starting dynamic subtest: pipe-A-eDP-1 [81.557451] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [81.566408] Starting dynamic subtest: pipe-B-eDP-1 [81.588064] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [81.595666] Starting dynamic subtest: pipe-C-eDP-1 [81.617084] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [81.624448] Starting dynamic subtest: pipe-D-eDP-1 [81.647311] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [81.651401] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s) [84.065022] [005/133] (945s left) kms_flip (bo-too-big) [84.162362] Starting subtest: bo-too-big [84.164377] Starting dynamic subtest: A-eDP1 [85.508250] Dynamic subtest A-eDP1: SUCCESS (1.347s) [85.517710] Starting dynamic subtest: B-eDP1 [86.834404] Dynamic subtest B-eDP1: SUCCESS (1.326s) [86.842013] Starting dynamic subtest: C-eDP1 [88.172885] Dynamic subtest C-eDP1: SUCCESS (1.336s) [88.183696] Starting dynamic subtest: D-eDP1 [89.511969] Dynamic subtest D-eDP1: SUCCESS (1.337s) [89.514551] Subtest bo-too-big: SUCCESS (5.353s) [90.750863] [006/133] (938s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [90.816793] Starting subtest: multi-wait-available-unsubmitted-signaled [90.819166] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s) [90.943675] [007/133] (938s left) kms_lease (lease-uevent) [91.042080] Starting subtest: lease-uevent [92.063353] Subtest lease-uevent: SUCCESS (1.019s) [92.194729] [008/133] (937s left) gem_exec_fence (syncobj-timeline-wait) [92.771526] Starting subtest: syncobj-timeline-wait [93.929084] Subtest syncobj-timeline-wait: SUCCESS (1.157s) [94.194927] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true [94.198126] [009/133] (935s left) kms_chamelium_color (gamma) [94.304312] Subtest gamma: SKIP (0.000s) [94.350833] [010/133] (935s left) prime_mmap (test_errors) [94.413725] Starting subtest: test_errors [94.415698] Starting dynamic subtest: test_errors-smem [94.507049] Dynamic subtest test_errors-smem: SUCCESS (0.094s) [94.509821] Subtest test_errors: SUCCESS (0.095s) [94.619673] [011/133] (935s left) i915_drm_fdinfo (idle) [94.658364] Starting subtest: idle [94.660632] Starting dynamic subtest: rcs0 [95.242736] Dynamic subtest rcs0: SUCCESS (0.584s) [95.257086] Starting dynamic subtest: bcs0 [95.749902] Dynamic subtest bcs0: SUCCESS (0.504s) [95.760679] Starting dynamic subtest: vcs0 [96.254829] Dynamic subtest vcs0: SUCCESS (0.503s) [96.265881] Starting dynamic subtest: vcs1 [96.760083] Dynamic subtest vcs1: SUCCESS (0.504s) [96.770809] Starting dynamic subtest: vecs0 [97.266208] Dynamic subtest vecs0: SUCCESS (0.504s) [97.277045] Starting dynamic subtest: ccs0 [97.774102] Dynamic subtest ccs0: SUCCESS (0.504s) [97.776677] Subtest idle: SUCCESS (3.112s) [97.876242] [012/133] (931s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [97.990312] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu [97.994286] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [98.114672] [013/133] (931s left) kms_invalid_mode (zero-hdisplay) [98.214296] Starting subtest: zero-hdisplay [98.216493] Starting dynamic subtest: pipe-A-eDP-1 [98.502700] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s) [98.510867] Starting dynamic subtest: pipe-B-eDP-1 [98.512824] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [98.520277] Starting dynamic subtest: pipe-C-eDP-1 [98.522247] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [98.530058] Starting dynamic subtest: pipe-D-eDP-1 [98.532264] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [98.534489] Subtest zero-hdisplay: SUCCESS (0.296s) [99.372702] [014/133] (930s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [99.482068] Starting subtest: planes-downscale-factor-0-75-unity-scaling [99.484357] Starting dynamic subtest: pipe-A [99.545035] Dynamic subtest pipe-A: SUCCESS (0.065s) [99.555082] Starting dynamic subtest: pipe-B [100.682625] Dynamic subtest pipe-B: SUCCESS (1.137s) [100.693189] Starting dynamic subtest: pipe-C [101.795389] Dynamic subtest pipe-C: SUCCESS (1.112s) [101.804943] Starting dynamic subtest: pipe-D [102.939941] Dynamic subtest pipe-D: SUCCESS (1.144s) [102.942312] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.460s) [104.123877] [015/133] (925s left) drm_read (fault-buffer) [104.279979] Starting subtest: fault-buffer [104.282451] Subtest fault-buffer: SUCCESS (0.000s) [104.453427] [016/133] (925s left) gem_ccs (suspend-resume) [104.534161] Starting subtest: suspend-resume [104.538394] Subtest suspend-resume: SKIP (0.000s) [104.684720] [017/133] (925s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs) [104.774753] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs [104.776971] Starting dynamic subtest: pipe-A-eDP-1 [104.799231] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [104.809526] Starting dynamic subtest: pipe-B-eDP-1 [104.830137] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [104.838352] Starting dynamic subtest: pipe-C-eDP-1 [104.859974] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [104.868565] Starting dynamic subtest: pipe-D-eDP-1 [104.890589] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [104.894668] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.003s) [107.102641] [018/133] (922s left) gem_close (many-handles-one-vma) [107.153673] Starting subtest: many-handles-one-vma [107.178863] Subtest many-handles-one-vma: SUCCESS (0.025s) [107.349496] [019/133] (922s left) gem_busy (extended) [107.532647] Starting subtest: extended [107.535072] Starting dynamic subtest: rcs0 [107.652992] Dynamic subtest rcs0: SUCCESS (0.120s) [107.663645] Starting dynamic subtest: bcs0 [107.694397] Dynamic subtest bcs0: SUCCESS (0.041s) [107.704318] Starting dynamic subtest: vcs0 [108.885050] Dynamic subtest vcs0: SUCCESS (1.188s) [108.899213] Starting dynamic subtest: vcs1 [110.868768] Dynamic subtest vcs1: SUCCESS (1.982s) [110.880108] Starting dynamic subtest: vecs0 [112.906240] Dynamic subtest vecs0: SUCCESS (1.983s) [112.917089] Starting dynamic subtest: ccs0 [112.918996] Dynamic subtest ccs0: SUCCESS (0.044s) [112.920941] Subtest extended: SUCCESS (5.363s) [113.148175] [020/133] (917s left) kms_vblank (ts-continuation-suspend) [113.247399] Starting subtest: ts-continuation-suspend [113.249298] Starting dynamic subtest: pipe-A-eDP-1 [130.121737] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.932s) [130.136125] Starting dynamic subtest: pipe-D-eDP-1 [148.128691] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.602s) [148.131102] Subtest ts-continuation-suspend: SUCCESS (4.538s) [159.031152] [021/133] (881s left) perf_pmu (semaphore-wait-idle) [159.080289] Starting subtest: semaphore-wait-idle [159.082437] Starting dynamic subtest: rcs0 [159.600518] Dynamic subtest rcs0: SUCCESS (0.538s) [159.611440] Starting dynamic subtest: bcs0 [160.115493] Dynamic subtest bcs0: SUCCESS (0.531s) [160.126119] Starting dynamic subtest: vcs0 [160.627058] Dynamic subtest vcs0: SUCCESS (0.527s) [160.637369] Starting dynamic subtest: vcs1 [161.138836] Dynamic subtest vcs1: SUCCESS (0.526s) [161.149927] Starting dynamic subtest: vecs0 [161.653404] Dynamic subtest vecs0: SUCCESS (0.527s) [161.664717] Starting dynamic subtest: ccs0 [162.168199] Dynamic subtest ccs0: SUCCESS (0.526s) [162.170731] Subtest semaphore-wait-idle: SUCCESS (3.185s) [163.328658] [022/133] (876s left) kms_debugfs (display-off-read-all) [163.426442] Starting subtest: display-off-read-all [163.719684] Subtest display-off-read-all: SUCCESS (0.300s) [164.526036] [023/133] (875s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt) [164.638074] Starting subtest: fbc-rgb101010-draw-blt [169.177822] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.607s) [170.361008] [024/133] (870s left) gem_ctx_param (invalid-get-no-zeromap) [170.422487] Starting subtest: invalid-get-no-zeromap [170.424915] Subtest invalid-get-no-zeromap: SUCCESS (0.002s) [170.557293] [025/133] (869s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt) [170.669900] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt [170.674011] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [170.779706] [026/133] (869s left) gem_exec_big (single) [170.850617] Starting subtest: single [173.180646] Subtest single: SUCCESS (2.342s) [173.447733] [027/133] (867s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt) [173.600631] Starting subtest: psr-rgb101010-draw-mmap-gtt [173.605053] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [173.741085] [028/133] (866s left) gem_exec_flush (basic-uc-prw-default) [173.815941] Starting subtest: basic-uc-prw-default [179.282638] Subtest basic-uc-prw-default: SUCCESS (5.476s) [179.475015] [029/133] (861s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [179.584120] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [179.588170] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [179.712890] [030/133] (860s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render) [179.817178] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render [186.674814] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.873s) [186.825475] [031/133] (853s left) gem_exec_create (forked) [186.903922] Starting subtest: forked [186.906530] Starting dynamic subtest: smem [208.284065] Dynamic subtest smem: SUCCESS (21.376s) [208.286905] Subtest forked: SUCCESS (21.378s) [208.493226] [032/133] (832s left) kms_feature_discovery (display-1x) [208.596743] Starting subtest: display-1x [208.598676] Subtest display-1x: SUCCESS (0.000s) [208.703663] [033/133] (832s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc) [208.794038] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc [208.798001] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [208.930897] [034/133] (831s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move) [209.028323] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move [209.032604] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [209.168694] [035/133] (831s left) gem_render_copy_redux (interruptible) [209.231053] Starting subtest: interruptible [209.483152] Subtest interruptible: SUCCESS (0.253s) [209.641901] [036/133] (831s left) i915_pm_rpm (system-suspend-execbuf) [211.383638] Starting subtest: system-suspend-execbuf [270.295997] Subtest system-suspend-execbuf: SUCCESS (43.281s) [270.692079] [037/133] (770s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt) [270.792976] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt [270.797400] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [270.932096] [038/133] (770s left) gem_request_retire (retire-vma-not-inactive) [270.994168] Starting subtest: retire-vma-not-inactive [271.055810] Subtest retire-vma-not-inactive: SUCCESS (0.058s) [271.225423] [039/133] (769s left) i915_pm_rps (thresholds-idle) [271.303176] Starting subtest: thresholds-idle [271.307671] Subtest thresholds-idle: SKIP (0.001s) [271.438843] [040/133] (769s left) gem_ctx_persistence (legacy-engines-queued) [271.509989] Starting subtest: legacy-engines-queued [271.512328] Starting dynamic subtest: render [271.629096] Dynamic subtest render: SUCCESS (0.118s) [271.641042] Starting dynamic subtest: bsd1 [273.136112] Dynamic subtest bsd1: SUCCESS (1.505s) [273.148804] Starting dynamic subtest: bsd2 [275.118326] Dynamic subtest bsd2: SUCCESS (1.980s) [275.128906] Starting dynamic subtest: blt [275.199278] Dynamic subtest blt: SUCCESS (0.080s) [275.210456] Starting dynamic subtest: vebox [277.166270] Dynamic subtest vebox: SUCCESS (1.963s) [277.169210] Subtest legacy-engines-queued: SUCCESS (5.656s) [277.271512] [041/133] (763s left) i915_hangman (gt-error-state-capture) [277.341217] Starting subtest: gt-error-state-capture [277.343611] Starting dynamic subtest: rcs0 [289.135849] Dynamic subtest rcs0: SUCCESS (11.789s) [289.148175] Starting dynamic subtest: bcs0 [300.144494] Dynamic subtest bcs0: SUCCESS (11.006s) [300.155879] Starting dynamic subtest: vcs0 [312.111293] Dynamic subtest vcs0: SUCCESS (11.968s) [312.126581] Starting dynamic subtest: vcs1 [323.119300] Dynamic subtest vcs1: SUCCESS (11.009s) [323.131499] Starting dynamic subtest: vecs0 [335.206975] Dynamic subtest vecs0: SUCCESS (12.034s) [335.218285] Starting dynamic subtest: ccs0 [347.183598] Dynamic subtest ccs0: SUCCESS (12.028s) [347.186355] Subtest gt-error-state-capture: SUCCESS (69.845s) [347.290439] [042/133] (693s left) kms_cursor_crc (cursor-rapid-movement-128x42) [347.517908] Starting subtest: cursor-rapid-movement-128x42 [347.566530] Subtest cursor-rapid-movement-128x42: SKIP (0.045s) [347.816502] [043/133] (693s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [347.874519] Subtest writes-after-reads-uncached: SKIP (0.000s) [347.931440] [044/133] (693s left) gem_mmap_wc (coherency) [347.991597] Subtest coherency: SKIP (0.000s) [348.057561] [045/133] (693s left) syncobj_timeline (single-wait-all-for-submit-signaled) [348.128548] Starting subtest: single-wait-all-for-submit-signaled [348.130975] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [348.225014] [046/133] (693s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render) [348.320314] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render [352.050423] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.733s) [353.188052] [047/133] (688s left) kms_psr (fbc-psr-primary-mmap-cpu) [353.284332] Starting subtest: fbc-psr-primary-mmap-cpu [353.286658] Starting dynamic subtest: eDP-1 [353.291018] Dynamic subtest eDP-1: SKIP (0.000s) [353.295525] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s) [353.387480] [048/133] (688s left) kms_invalid_mode (bad-vsync-start) [353.475394] Starting subtest: bad-vsync-start [353.477692] Starting dynamic subtest: pipe-A-eDP-1 [353.761654] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s) [353.771343] Starting dynamic subtest: pipe-B-eDP-1 [353.773483] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [353.782357] Starting dynamic subtest: pipe-C-eDP-1 [353.784591] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [353.792948] Starting dynamic subtest: pipe-D-eDP-1 [353.794876] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [353.796822] Subtest bad-vsync-start: SUCCESS (0.291s) [354.607881] [049/133] (686s left) gem_exec_reloc (basic-wc-gtt) [354.677603] Subtest basic-wc-gtt: SKIP (0.000s) [354.751662] [050/133] (686s left) gem_mmap_gtt (cpuset-medium-copy-xy) [354.819053] Subtest cpuset-medium-copy-XY: SKIP (0.000s) [354.886543] [051/133] (686s left) kms_prop_blob (blob-multiple) [354.947343] Starting subtest: blob-multiple [354.949709] Subtest blob-multiple: SUCCESS (0.002s) [355.096023] [052/133] (686s left) api_intel_allocator (open-vm) [355.150421] Starting subtest: open-vm [355.152711] Subtest open-vm: SUCCESS (0.003s) [355.297208] [053/133] (686s left) kms_getfb (getfb-repeated-different-handles) [355.394060] Starting subtest: getfb-repeated-different-handles [355.396324] Subtest getfb-repeated-different-handles: SUCCESS (0.000s) [355.530106] [054/133] (686s left) kms_content_protection (legacy-hdcp14) [355.670538] Starting subtest: legacy-hdcp14 [355.674317] Subtest legacy-hdcp14: SKIP (0.000s) [355.850332] [055/133] (685s left) kms_chamelium_hpd (hdmi-hpd-after-suspend) [356.239423] Subtest hdmi-hpd-after-suspend: SKIP (0.000s) [357.102707] [056/133] (684s left) kms_flip (blocking-absolute-wf_vblank) [357.202364] Starting subtest: blocking-absolute-wf_vblank [357.204621] Starting dynamic subtest: A-eDP1 [366.008442] Dynamic subtest A-eDP1: SUCCESS (8.771s) [366.019998] Starting dynamic subtest: B-eDP1 [374.738525] Dynamic subtest B-eDP1: SUCCESS (8.729s) [374.750842] Starting dynamic subtest: C-eDP1 [383.462040] Dynamic subtest C-eDP1: SUCCESS (8.710s) [383.473859] Starting dynamic subtest: D-eDP1 [392.186881] Dynamic subtest D-eDP1: SUCCESS (8.723s) [392.189330] Subtest blocking-absolute-wf_vblank: SUCCESS (34.942s) [393.377134] [057/133] (648s left) gem_mmap_offset (bad-object) [393.435211] Starting subtest: bad-object [393.437394] Subtest bad-object: SUCCESS (0.001s) [393.567803] [058/133] (648s left) kms_psr (psr2-no-drrs) [393.666278] Starting subtest: psr2-no-drrs [393.668652] Starting dynamic subtest: eDP-1 [395.239498] Dynamic subtest eDP-1: SUCCESS (1.573s) [395.241694] Subtest psr2-no-drrs: SUCCESS (1.574s) [396.055060] [059/133] (645s left) gem_fenced_exec_thrash (no-spare-fences-interruptible) [396.107965] Subtest no-spare-fences-interruptible: SKIP (0.000s) [396.197703] [060/133] (645s left) kms_vblank (wait-idle) [396.286980] Starting subtest: wait-idle [396.289171] Starting dynamic subtest: pipe-A-eDP-1 [398.039737] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.751s) [398.055375] Starting dynamic subtest: pipe-D-eDP-1 [400.472700] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.431s) [400.474896] Subtest wait-idle: SUCCESS (4.186s) [401.328561] [061/133] (640s left) gem_exec_whisper (basic-contexts-all) [401.400924] Starting subtest: basic-contexts-all [412.509379] Subtest basic-contexts-all: SUCCESS (11.109s) [412.717307] [062/133] (629s left) kms_big_fb (x-tiled-16bpp-rotate-0) [412.836208] Starting subtest: x-tiled-16bpp-rotate-0 [414.114873] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.278s) [414.284719] [063/133] (627s left) kms_atomic (plane-primary-overlay-mutable-zpos) [414.373252] Starting subtest: plane-primary-overlay-mutable-zpos [417.842133] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.468s) [419.060505] [064/133] (623s left) gen9_exec_parse (bb-start-cmd) [419.130703] Subtest bb-start-cmd: SKIP (0.000s) [419.215216] [065/133] (622s left) kms_cursor_crc (cursor-alpha-opaque) [419.319833] Starting subtest: cursor-alpha-opaque [419.321900] Starting dynamic subtest: pipe-A-eDP-1 [419.940309] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.619s) [419.950852] Starting dynamic subtest: pipe-D-eDP-1 [421.201758] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.260s) [421.203645] Subtest cursor-alpha-opaque: SUCCESS (1.882s) [422.044499] [066/133] (620s left) kms_cursor_crc (cursor-sliding-64x64) [422.221734] Starting subtest: cursor-sliding-64x64 [422.226576] Starting dynamic subtest: pipe-A-eDP-1 [425.454100] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.230s) [425.488946] Starting dynamic subtest: pipe-D-eDP-1 [429.406140] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.930s) [429.408499] Subtest cursor-sliding-64x64: SUCCESS (7.186s) [430.298149] [067/133] (611s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render) [430.401315] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render [437.177641] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.780s) [437.340336] [068/133] (604s left) gem_ctx_shared (exec-single-timeline) [437.412983] Starting subtest: exec-single-timeline [437.415278] Starting dynamic subtest: rcs0 [438.445001] Dynamic subtest rcs0: SUCCESS (1.030s) [438.457458] Starting dynamic subtest: bcs0 [439.534862] Dynamic subtest bcs0: SUCCESS (1.087s) [439.548266] Starting dynamic subtest: vcs0 [440.624005] Dynamic subtest vcs0: SUCCESS (1.087s) [440.636562] Starting dynamic subtest: vcs1 [441.710809] Dynamic subtest vcs1: SUCCESS (1.084s) [441.724995] Starting dynamic subtest: vecs0 [442.798652] Dynamic subtest vecs0: SUCCESS (1.085s) [442.811963] Starting dynamic subtest: ccs0 [443.889227] Dynamic subtest ccs0: SUCCESS (1.088s) [443.891845] Subtest exec-single-timeline: SUCCESS (6.478s) [444.110973] [069/133] (598s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format) [444.219011] Starting subtest: plane-downscale-factor-0-75-with-pixel-format [444.221274] Starting dynamic subtest: pipe-A [445.458477] Dynamic subtest pipe-A: SUCCESS (1.241s) [445.470519] Starting dynamic subtest: pipe-B [447.804886] Dynamic subtest pipe-B: SUCCESS (2.346s) [447.814928] Starting dynamic subtest: pipe-C [448.994581] Dynamic subtest pipe-C: SUCCESS (1.189s) [449.005094] Starting dynamic subtest: pipe-D [450.220318] Dynamic subtest pipe-D: SUCCESS (1.225s) [450.222476] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (6.006s) [451.452301] [070/133] (590s left) gem_wait (write-busy) [451.527104] Starting subtest: write-busy [451.529647] Starting dynamic subtest: all-engines [452.168111] Dynamic subtest all-engines: SUCCESS (0.640s) [452.178915] Starting dynamic subtest: rcs0 [452.730874] Dynamic subtest rcs0: SUCCESS (0.560s) [452.749185] Starting dynamic subtest: bcs0 [453.281594] Dynamic subtest bcs0: SUCCESS (0.550s) [453.300135] Starting dynamic subtest: vcs0 [455.185309] Dynamic subtest vcs0: SUCCESS (1.901s) [455.201180] Starting dynamic subtest: vcs1 [457.168094] Dynamic subtest vcs1: SUCCESS (1.981s) [457.184493] Starting dynamic subtest: vecs0 [459.152349] Dynamic subtest vecs0: SUCCESS (1.982s) [459.169131] Starting dynamic subtest: ccs0 [459.706828] Dynamic subtest ccs0: SUCCESS (0.553s) [459.709417] Subtest write-busy: SUCCESS (8.182s) [459.931748] [071/133] (582s left) kms_big_fb (y-tiled-8bpp-rotate-0) [460.045851] Starting subtest: y-tiled-8bpp-rotate-0 [460.050300] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s) [460.185449] [072/133] (582s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [460.301813] Starting subtest: basic-busy-flip-before-cursor-legacy [460.306282] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [460.474591] [073/133] (582s left) gem_basic (bad-close) [460.529301] Starting subtest: bad-close [460.533583] Subtest bad-close: SUCCESS (0.000s) [460.652271] [074/133] (581s left) kms_big_fb (linear-16bpp-rotate-0) [460.758864] Starting subtest: linear-16bpp-rotate-0 [462.191849] Subtest linear-16bpp-rotate-0: SUCCESS (1.434s) [462.339673] [075/133] (580s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf) [467.294894] Starting subtest: pr-overlay-plane-update-continuous-sf [467.299380] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.002s) [468.152351] [076/133] (574s left) drm_read (short-buffer-wakeup) [468.318427] Starting subtest: short-buffer-wakeup [500.543125] Subtest short-buffer-wakeup: SUCCESS (32.215s) [500.720792] [077/133] (541s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite) [500.824476] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite [508.053503] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.229s) [508.225657] [078/133] (534s left) kms_psr (fbc-pr-cursor-render) [508.312889] Starting subtest: fbc-pr-cursor-render [508.317055] Subtest fbc-pr-cursor-render: SKIP (0.000s) [508.411019] [079/133] (534s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs) [508.504054] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs [508.506225] Starting dynamic subtest: pipe-A-eDP-1 [508.514703] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [508.524718] Starting dynamic subtest: pipe-B-eDP-1 [508.533417] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [508.543295] Starting dynamic subtest: pipe-C-eDP-1 [508.551306] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [508.559918] Starting dynamic subtest: pipe-D-eDP-1 [508.567945] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [508.571919] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s) [510.840408] [080/133] (531s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs) [510.947398] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs [510.949297] Starting dynamic subtest: pipe-A-eDP-1 [512.218658] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.272s) [512.228182] Starting dynamic subtest: pipe-B-eDP-1 [514.555880] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.335s) [514.565453] Starting dynamic subtest: pipe-C-eDP-1 [516.917750] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.361s) [516.928115] Starting dynamic subtest: pipe-D-eDP-1 [519.224186] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.305s) [519.226549] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.278s) [520.460168] [081/133] (522s left) sw_sync (sync_multi_timeline_wait) [520.495145] Starting subtest: sync_multi_timeline_wait [520.497516] Subtest sync_multi_timeline_wait: SUCCESS (0.000s) [520.570722] [082/133] (522s left) sysfs_heartbeat_interval (idempotent) [520.624476] Starting subtest: idempotent [520.626670] Starting dynamic subtest: vecs0 [520.628998] Dynamic subtest vecs0: SUCCESS (0.001s) [520.639018] Starting dynamic subtest: ccs0 [520.640915] Dynamic subtest ccs0: SUCCESS (0.001s) [520.649496] Starting dynamic subtest: vcs0 [520.651344] Dynamic subtest vcs0: SUCCESS (0.000s) [520.660090] Starting dynamic subtest: bcs0 [520.661988] Dynamic subtest bcs0: SUCCESS (0.001s) [520.670824] Starting dynamic subtest: rcs0 [520.672745] Dynamic subtest rcs0: SUCCESS (0.001s) [520.681688] Starting dynamic subtest: vcs1 [520.683560] Dynamic subtest vcs1: SUCCESS (0.000s) [520.685793] Subtest idempotent: SUCCESS (0.008s) [520.773742] [083/133] (522s left) syncobj_eventfd (invalid-bad-pad) [520.844854] Starting subtest: invalid-bad-pad [520.847535] Subtest invalid-bad-pad: SUCCESS (0.000s) [521.002388] [084/133] (521s left) kms_busy (extended-pageflip-hang-newfb) [521.104200] Starting subtest: extended-pageflip-hang-newfb [521.106470] Starting dynamic subtest: pipe-A [547.937251] Dynamic subtest pipe-A: SUCCESS (26.831s) [547.953825] Starting dynamic subtest: pipe-D [573.041333] Dynamic subtest pipe-D: SUCCESS (25.103s) [573.043563] Subtest extended-pageflip-hang-newfb: SUCCESS (51.940s) [573.907178] [085/133] (469s left) kms_psr2_sf (psr2-cursor-plane-update-sf) [578.977250] Starting subtest: psr2-cursor-plane-update-sf [578.979457] Starting dynamic subtest: pipe-A-eDP-1 [580.268775] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.289s) [580.279130] Starting dynamic subtest: pipe-B-eDP-1 [581.596966] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.326s) [581.599322] Subtest psr2-cursor-plane-update-sf: SUCCESS (2.619s) [582.498030] [086/133] (460s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [582.597141] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip [583.243128] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.648s) [583.444374] [087/133] (459s left) gem_exec_balancer (busy) [583.499819] Starting subtest: busy [585.187608] Subtest busy: SUCCESS (1.686s) [585.523151] [088/133] (457s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt) [585.625161] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt [585.629351] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [585.737407] [089/133] (457s left) vgem_slow (nohang) [585.785932] Starting subtest: nohang [596.320648] Subtest nohang: SUCCESS (10.485s) [596.364446] [090/133] (446s left) gem_spin_batch (resubmit-new-all) [596.441901] Starting subtest: resubmit-new-all [596.444433] Starting dynamic subtest: rcs0 [596.466615] Dynamic subtest rcs0: SUCCESS (0.024s) [596.478891] Starting dynamic subtest: bcs0 [596.485219] Dynamic subtest bcs0: SUCCESS (0.018s) [596.499826] Starting dynamic subtest: vcs0 [596.506592] Dynamic subtest vcs0: SUCCESS (0.020s) [596.517663] Starting dynamic subtest: vcs1 [596.522859] Dynamic subtest vcs1: SUCCESS (0.015s) [596.532561] Starting dynamic subtest: vecs0 [596.542616] Dynamic subtest vecs0: SUCCESS (0.019s) [596.556606] Starting dynamic subtest: ccs0 [596.564475] Dynamic subtest ccs0: SUCCESS (0.021s) [596.566730] Subtest resubmit-new-all: SUCCESS (0.123s) [598.231498] [091/133] (445s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs) [598.309192] Starting subtest: mixed-tiled-to-y-tiled-ccs [598.314211] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s) [598.528418] [092/133] (444s left) syncobj_timeline (invalid-signal-illegal-point) [598.588865] Starting subtest: invalid-signal-illegal-point [598.591289] Subtest invalid-signal-illegal-point: SUCCESS (0.000s) [598.734246] [093/133] (444s left) gem_exec_schedule (preempt-contexts) [598.809972] Starting subtest: preempt-contexts [598.812486] Starting dynamic subtest: rcs0 [598.901925] Dynamic subtest rcs0: SUCCESS (0.099s) [598.912573] Starting dynamic subtest: bcs0 [598.984900] Dynamic subtest bcs0: SUCCESS (0.082s) [598.995796] Starting dynamic subtest: vcs0 [599.043304] Dynamic subtest vcs0: SUCCESS (0.058s) [599.053556] Starting dynamic subtest: vcs1 [599.096428] Dynamic subtest vcs1: SUCCESS (0.052s) [599.106044] Starting dynamic subtest: vecs0 [599.180309] Dynamic subtest vecs0: SUCCESS (0.083s) [599.190601] Starting dynamic subtest: ccs0 [599.261494] Dynamic subtest ccs0: SUCCESS (0.079s) [599.263780] Subtest preempt-contexts: SUCCESS (0.459s) [600.293569] [094/133] (443s left) gem_pwrite_snooped [600.454132] [095/133] (443s left) kms_tiled_display (basic-test-pattern) [600.574832] Subtest basic-test-pattern: SKIP (0.000s) [600.622644] [096/133] (442s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary) [600.726725] Starting subtest: psr-shrfb-scaledprimary [606.497356] Subtest psr-shrfb-scaledprimary: SUCCESS (5.774s) [606.658224] [097/133] (436s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [606.769048] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [606.773629] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [606.894003] [098/133] (436s left) gem_pwrite (basic-self) [606.947728] Subtest basic-self: SKIP (0.000s) [607.010054] [099/133] (436s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [609.344939] Starting subtest: dpms-mode-unset-non-lpsp [610.507453] Subtest dpms-mode-unset-non-lpsp: SKIP (1.165s) [610.926481] [100/133] (432s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [611.033717] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [611.038173] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [611.168401] [101/133] (432s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render) [611.286652] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render [611.291052] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [611.421588] [102/133] (432s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d) [611.516180] Starting subtest: plane-lut1d-ctm3x4-lut1d [611.529153] Starting dynamic subtest: pipe-A-eDP-1 [612.187988] Dynamic subtest pipe-A-eDP-1: FAIL (0.331s) [612.980837] Starting dynamic subtest: pipe-B-eDP-1 [613.820098] Dynamic subtest pipe-B-eDP-1: FAIL (0.313s) [614.412984] Starting dynamic subtest: pipe-C-eDP-1 [615.259052] Dynamic subtest pipe-C-eDP-1: FAIL (0.258s) [615.747936] Starting dynamic subtest: pipe-D-eDP-1 [616.572252] Dynamic subtest pipe-D-eDP-1: FAIL (0.246s) [616.574581] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.768s) [617.157860] [103/133] (426s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render) [617.269946] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render [624.028612] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.761s) [624.209741] [104/133] (419s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff) [624.316947] Starting subtest: psr-1p-primscrn-cur-indfb-onoff [631.376199] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.062s) [631.547999] [105/133] (412s left) gem_exec_schedule (preempt-queue-contexts-chain) [631.627670] Subtest preempt-queue-contexts-chain: SKIP (0.000s) [631.940121] [106/133] (411s left) api_intel_bb (object-noreloc-keep-cache-simple) [632.008594] Starting subtest: object-noreloc-keep-cache-simple [632.013541] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.006s) [632.182258] [107/133] (411s left) gem_mmap (bad-object) [632.245830] Subtest bad-object: SKIP (0.000s) [632.319935] [108/133] (411s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling) [632.425018] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling [632.427227] Starting dynamic subtest: pipe-A-default-mode [632.713351] Dynamic subtest pipe-A-default-mode: SKIP (0.285s) [632.717696] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.287s) [633.617513] [109/133] (410s left) kms_addfb_basic (bo-too-small-due-to-tiling) [633.713018] Starting subtest: bo-too-small-due-to-tiling [633.717428] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [633.857429] [110/133] (410s left) kms_psr (pr-sprite-blt) [633.952619] Starting subtest: pr-sprite-blt [633.956676] Subtest pr-sprite-blt: SKIP (0.000s) [634.053311] [111/133] (410s left) kms_draw_crc (fill-fb) [634.151413] Starting subtest: fill-fb [634.602163] Subtest fill-fb: SUCCESS (0.453s) [634.748102] [112/133] (409s left) perf_pmu (busy-idle) [634.792548] Starting subtest: busy-idle [634.794138] Starting dynamic subtest: rcs0 [635.515886] Dynamic subtest rcs0: SUCCESS (0.724s) [635.527919] Starting dynamic subtest: bcs0 [636.186902] Dynamic subtest bcs0: SUCCESS (0.669s) [636.199091] Starting dynamic subtest: vcs0 [638.160215] Dynamic subtest vcs0: SUCCESS (1.970s) [638.172095] Starting dynamic subtest: vcs1 [640.144936] Dynamic subtest vcs1: SUCCESS (1.982s) [640.157467] Starting dynamic subtest: vecs0 [642.192841] Dynamic subtest vecs0: SUCCESS (2.045s) [642.204736] Starting dynamic subtest: ccs0 [642.862923] Dynamic subtest ccs0: SUCCESS (0.669s) [642.865271] Subtest busy-idle: SUCCESS (8.074s) [643.005510] [113/133] (401s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs) [643.106972] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs [643.109041] Starting dynamic subtest: pipe-A-eDP-1 [643.165818] Dynamic subtest pipe-A-eDP-1: SKIP (0.002s) [643.175846] Starting dynamic subtest: pipe-B-eDP-1 [643.231159] Dynamic subtest pipe-B-eDP-1: SKIP (0.002s) [643.242583] Starting dynamic subtest: pipe-C-eDP-1 [643.298718] Dynamic subtest pipe-C-eDP-1: SKIP (0.002s) [643.309535] Starting dynamic subtest: pipe-D-eDP-1 [643.366404] Dynamic subtest pipe-D-eDP-1: SKIP (0.002s) [643.370915] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.016s) [645.379489] [114/133] (398s left) gem_exec_flush (basic-batch-kernel-default-uc) [645.459156] Starting subtest: basic-batch-kernel-default-uc [652.666531] Subtest basic-batch-kernel-default-uc: SUCCESS (7.209s) [652.880878] [115/133] (391s left) gem_mmap_wc (write-read-distinct) [652.949097] Subtest write-read-distinct: SKIP (0.000s) [653.018168] [116/133] (391s left) kms_plane_lowres (tiling-x) [653.118145] Starting subtest: tiling-x [653.120391] Starting dynamic subtest: pipe-A-eDP-1 [653.124821] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [653.433087] Starting dynamic subtest: pipe-B-eDP-1 [653.437354] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [653.446300] Starting dynamic subtest: pipe-C-eDP-1 [653.450543] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [653.459607] Starting dynamic subtest: pipe-D-eDP-1 [653.463650] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [653.467621] Subtest tiling-x: SKIP (0.315s) [654.315610] [117/133] (390s left) sw_sync (alloc_merge_fence) [654.356314] Starting subtest: alloc_merge_fence [654.358752] Subtest alloc_merge_fence: SUCCESS (0.000s) [654.439513] [118/133] (389s left) kms_pm_backlight (fade) [654.531713] Starting subtest: fade [654.581175] Starting dynamic subtest: eDP-1 [657.261172] Dynamic subtest eDP-1: SUCCESS (2.678s) [657.263482] Subtest fade: SUCCESS (2.730s) [658.148102] [119/133] (386s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling) [658.244802] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling [658.246949] Starting dynamic subtest: pipe-A-default-mode [659.384818] Dynamic subtest pipe-A-default-mode: SKIP (1.136s) [659.389113] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.137s) [659.563968] [120/133] (384s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [659.624706] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [659.732903] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s) [659.833135] [121/133] (384s left) kms_psr (psr-cursor-mmap-cpu) [659.936359] Starting subtest: psr-cursor-mmap-cpu [659.938707] Starting dynamic subtest: eDP-1 [661.638550] Dynamic subtest eDP-1: SUCCESS (1.704s) [661.641025] Subtest psr-cursor-mmap-cpu: SUCCESS (1.705s) [662.532666] [122/133] (382s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [662.654008] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [663.288526] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.637s) [663.520500] [123/133] (381s left) gem_exec_whisper (basic-queues-priority-all) [663.589045] Starting subtest: basic-queues-priority-all [687.421432] Subtest basic-queues-priority-all: SUCCESS (23.783s) [687.582257] [124/133] (357s left) syncobj_timeline (etime-single-wait-all-submitted) [687.642890] Starting subtest: etime-single-wait-all-submitted [687.748224] Subtest etime-single-wait-all-submitted: SUCCESS (0.106s) [687.854352] [125/133] (356s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff) [687.975012] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff [687.979216] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [688.107056] [126/133] (356s left) kms_async_flips (async-flip-dpms) [688.194759] Starting subtest: async-flip-dpms [688.568763] Starting dynamic subtest: pipe-A-eDP-1 [692.426406] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.858s) [692.809260] Starting dynamic subtest: pipe-B-eDP-1 [695.583986] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.786s) [695.951454] Starting dynamic subtest: pipe-C-eDP-1 [698.743979] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.801s) [699.132345] Starting dynamic subtest: pipe-D-eDP-1 [701.911575] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.789s) [701.913862] Subtest async-flip-dpms: SUCCESS (13.720s) [703.116443] [127/133] (341s left) gem_exec_reloc (basic-cpu-read-noreloc) [703.182206] Subtest basic-cpu-read-noreloc: SKIP (0.000s) [703.258371] [128/133] (341s left) syncobj_wait (invalid-reset-illegal-handle) [703.310000] Starting subtest: invalid-reset-illegal-handle [703.312420] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [703.448674] [129/133] (341s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [703.506437] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [703.613251] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s) [703.719048] [130/133] (341s left) gem_tiled_swapping (non-threaded) [703.774709] Subtest non-threaded: SKIP (0.000s) [703.843616] [131/133] (341s left) gem_exec_fence (syncobj-timeline-chain-engines) [704.388045] Starting subtest: syncobj-timeline-chain-engines [704.506526] Subtest syncobj-timeline-chain-engines: SUCCESS (0.118s) [706.329270] [132/133] (338s left) kms_cursor_legacy (flip-vs-cursor-legacy) [706.459669] Starting subtest: flip-vs-cursor-legacy [713.506206] Subtest flip-vs-cursor-legacy: SUCCESS (7.046s) [714.348678] [133/133] (330s left) syncobj_basic (illegal-fd-to-handle) [714.415777] Starting subtest: illegal-fd-to-handle [714.417719] Subtest illegal-fd-to-handle: SUCCESS (0.000s) [714.553514] 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.