[116.582700] Initializing watchdogs [116.582746] /dev/watchdog0 [116.597115] [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] [116.601418] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [116.603535] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [116.609366] [001/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt) [116.736799] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt [116.740671] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [116.859515] [002/133] (960s left) gem_exec_suspend (basic-s3-devices) [116.929525] Starting subtest: basic-S3-devices [116.931887] Starting dynamic subtest: smem [128.920360] Dynamic subtest smem: SUCCESS (11.987s) [128.923246] Subtest basic-S3-devices: SUCCESS (11.988s) [129.120438] [003/133] (948s left) gem_render_copy (y-tiled-ccs-to-yf-tiled) [129.201490] Starting subtest: y-tiled-ccs-to-yf-tiled [129.206054] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s) [129.409924] [004/133] (947s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs) [129.508911] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs [129.511303] Starting dynamic subtest: pipe-A-eDP-1 [129.535091] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [129.549193] Starting dynamic subtest: pipe-B-eDP-1 [129.571871] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [129.581607] Starting dynamic subtest: pipe-C-eDP-1 [129.603617] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [129.611851] Starting dynamic subtest: pipe-D-eDP-1 [129.634947] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [129.639174] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.003s) [131.775356] [005/133] (945s left) kms_flip (bo-too-big) [131.874096] Starting subtest: bo-too-big [131.876079] Starting dynamic subtest: A-eDP1 [133.200579] Dynamic subtest A-eDP1: SUCCESS (1.329s) [133.212862] Starting dynamic subtest: B-eDP1 [134.529912] Dynamic subtest B-eDP1: SUCCESS (1.329s) [134.540475] Starting dynamic subtest: C-eDP1 [135.868264] Dynamic subtest C-eDP1: SUCCESS (1.338s) [135.879202] Starting dynamic subtest: D-eDP1 [137.204195] Dynamic subtest D-eDP1: SUCCESS (1.336s) [137.208891] Subtest bo-too-big: SUCCESS (5.341s) [138.442851] [006/133] (938s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [138.506048] Starting subtest: multi-wait-available-unsubmitted-signaled [138.508352] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s) [138.633392] [007/133] (938s left) kms_lease (lease-uevent) [138.737083] Starting subtest: lease-uevent [139.755222] Subtest lease-uevent: SUCCESS (1.019s) [139.892060] [008/133] (937s left) gem_exec_fence (syncobj-timeline-wait) [140.484061] Starting subtest: syncobj-timeline-wait [141.929448] Subtest syncobj-timeline-wait: SUCCESS (1.446s) [144.014918] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true [144.018076] [009/133] (933s left) kms_chamelium_color (gamma) [144.120543] Subtest gamma: SKIP (0.000s) [144.166624] [010/133] (933s left) prime_mmap (test_errors) [144.218598] Starting subtest: test_errors [144.220826] Starting dynamic subtest: test_errors-smem [144.307097] Dynamic subtest test_errors-smem: SUCCESS (0.090s) [144.309641] Subtest test_errors: SUCCESS (0.090s) [144.420445] [011/133] (933s left) i915_drm_fdinfo (idle) [144.460131] Starting subtest: idle [144.462263] Starting dynamic subtest: rcs0 [145.012043] Dynamic subtest rcs0: SUCCESS (0.553s) [145.022805] Starting dynamic subtest: bcs0 [145.545928] Dynamic subtest bcs0: SUCCESS (0.531s) [145.556719] Starting dynamic subtest: vcs0 [146.050840] Dynamic subtest vcs0: SUCCESS (0.504s) [146.061419] Starting dynamic subtest: vcs1 [146.555812] Dynamic subtest vcs1: SUCCESS (0.504s) [146.566082] Starting dynamic subtest: vecs0 [147.061123] Dynamic subtest vecs0: SUCCESS (0.504s) [147.072188] Starting dynamic subtest: ccs0 [147.565896] Dynamic subtest ccs0: SUCCESS (0.504s) [147.568905] Subtest idle: SUCCESS (3.107s) [147.664707] [012/133] (929s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [147.759638] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu [147.763874] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [147.876686] [013/133] (929s left) kms_invalid_mode (zero-hdisplay) [147.976786] Starting subtest: zero-hdisplay [147.979118] Starting dynamic subtest: pipe-A-eDP-1 [148.265940] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s) [148.274594] Starting dynamic subtest: pipe-B-eDP-1 [148.276509] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [148.283825] Starting dynamic subtest: pipe-C-eDP-1 [148.285725] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [148.293367] Starting dynamic subtest: pipe-D-eDP-1 [148.295493] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [148.297637] Subtest zero-hdisplay: SUCCESS (0.296s) [149.170401] [014/133] (928s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [149.288942] Starting subtest: planes-downscale-factor-0-75-unity-scaling [149.291264] Starting dynamic subtest: pipe-A [149.355163] Dynamic subtest pipe-A: SUCCESS (0.068s) [149.369078] Starting dynamic subtest: pipe-B [150.474276] Dynamic subtest pipe-B: SUCCESS (1.119s) [150.484314] Starting dynamic subtest: pipe-C [151.586290] Dynamic subtest pipe-C: SUCCESS (1.112s) [151.595177] Starting dynamic subtest: pipe-D [152.732374] Dynamic subtest pipe-D: SUCCESS (1.146s) [152.734735] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.447s) [153.899947] [015/133] (923s left) drm_read (fault-buffer) [154.053029] Starting subtest: fault-buffer [154.055662] Subtest fault-buffer: SUCCESS (0.000s) [154.210566] [016/133] (923s left) gem_ccs (suspend-resume) [154.271794] Starting subtest: suspend-resume [154.275831] Subtest suspend-resume: SKIP (0.000s) [154.407783] [017/133] (923s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs) [154.502515] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs [154.504831] Starting dynamic subtest: pipe-A-eDP-1 [154.527896] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [154.538158] Starting dynamic subtest: pipe-B-eDP-1 [154.558102] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [154.566135] Starting dynamic subtest: pipe-C-eDP-1 [154.586827] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [154.595768] Starting dynamic subtest: pipe-D-eDP-1 [154.616869] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [154.621149] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.003s) [156.759184] [018/133] (920s left) gem_close (many-handles-one-vma) [156.829459] Starting subtest: many-handles-one-vma [156.856260] Subtest many-handles-one-vma: SUCCESS (0.027s) [157.002318] [019/133] (920s left) gem_busy (extended) [157.193661] Starting subtest: extended [157.195879] Starting dynamic subtest: rcs0 [157.291845] Dynamic subtest rcs0: SUCCESS (0.099s) [157.303366] Starting dynamic subtest: bcs0 [157.333789] Dynamic subtest bcs0: SUCCESS (0.041s) [157.343801] Starting dynamic subtest: vcs0 [158.933490] Dynamic subtest vcs0: SUCCESS (1.597s) [158.945099] Starting dynamic subtest: vcs1 [160.916841] Dynamic subtest vcs1: SUCCESS (1.982s) [160.928240] Starting dynamic subtest: vecs0 [162.900394] Dynamic subtest vecs0: SUCCESS (1.982s) [162.911841] Starting dynamic subtest: ccs0 [162.942887] Dynamic subtest ccs0: SUCCESS (0.044s) [162.945239] Subtest extended: SUCCESS (5.749s) [163.182158] [020/133] (914s left) kms_vblank (ts-continuation-suspend) [163.278641] Starting subtest: ts-continuation-suspend [163.280585] Starting dynamic subtest: pipe-A-eDP-1 [179.197148] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.531s) [179.211148] Starting dynamic subtest: pipe-D-eDP-1 [196.210517] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.192s) [196.212953] Subtest ts-continuation-suspend: SUCCESS (3.726s) [197.080147] [021/133] (880s left) perf_pmu (semaphore-wait-idle) [197.123073] Starting subtest: semaphore-wait-idle [197.125261] Starting dynamic subtest: rcs0 [197.650358] Dynamic subtest rcs0: SUCCESS (0.514s) [197.662478] Starting dynamic subtest: bcs0 [198.173391] Dynamic subtest bcs0: SUCCESS (0.511s) [198.185705] Starting dynamic subtest: vcs0 [198.696149] Dynamic subtest vcs0: SUCCESS (0.511s) [198.707698] Starting dynamic subtest: vcs1 [199.218048] Dynamic subtest vcs1: SUCCESS (0.511s) [199.230142] Starting dynamic subtest: vecs0 [199.740888] Dynamic subtest vecs0: SUCCESS (0.512s) [199.753132] Starting dynamic subtest: ccs0 [200.264260] Dynamic subtest ccs0: SUCCESS (0.513s) [200.266942] Subtest semaphore-wait-idle: SUCCESS (3.081s) [200.421532] [022/133] (877s left) kms_debugfs (display-off-read-all) [200.521898] Starting subtest: display-off-read-all [200.815259] Subtest display-off-read-all: SUCCESS (0.289s) [201.705833] [023/133] (876s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt) [201.812026] Starting subtest: fbc-rgb101010-draw-blt [206.438059] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.584s) [207.640781] [024/133] (870s left) gem_ctx_param (invalid-get-no-zeromap) [207.688387] Starting subtest: invalid-get-no-zeromap [207.690682] Subtest invalid-get-no-zeromap: SUCCESS (0.001s) [207.825237] [025/133] (870s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt) [207.929531] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt [207.933763] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [208.083889] [026/133] (870s left) gem_exec_big (single) [208.148653] Starting subtest: single [210.464727] Subtest single: SUCCESS (2.301s) [210.703697] [027/133] (867s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt) [210.859246] Starting subtest: psr-rgb101010-draw-mmap-gtt [210.863710] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [210.995459] [028/133] (867s left) gem_exec_flush (basic-uc-prw-default) [211.053163] Starting subtest: basic-uc-prw-default [216.543400] Subtest basic-uc-prw-default: SUCCESS (5.474s) [216.747578] [029/133] (861s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [216.852457] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [216.856817] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [216.989094] [030/133] (861s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render) [217.097468] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render [223.857548] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.752s) [224.035151] [031/133] (854s left) gem_exec_create (forked) [224.102877] Starting subtest: forked [224.105281] Starting dynamic subtest: smem [246.075808] Dynamic subtest smem: SUCCESS (21.982s) [246.078635] Subtest forked: SUCCESS (21.983s) [246.287363] [032/133] (832s left) kms_feature_discovery (display-1x) [246.399214] Starting subtest: display-1x [246.401606] Subtest display-1x: SUCCESS (0.000s) [246.498997] [033/133] (831s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc) [246.586125] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc [246.590568] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [246.706955] [034/133] (831s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move) [246.812480] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move [246.816959] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [246.948822] [035/133] (831s left) gem_render_copy_redux (interruptible) [247.012908] Starting subtest: interruptible [247.263547] Subtest interruptible: SUCCESS (0.252s) [247.415972] [036/133] (831s left) i915_pm_rpm (system-suspend-execbuf) [249.261848] Starting subtest: system-suspend-execbuf [308.782405] Subtest system-suspend-execbuf: SUCCESS (44.752s) [309.193054] [037/133] (769s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt) [309.300243] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt [309.304594] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [309.429593] [038/133] (769s left) gem_request_retire (retire-vma-not-inactive) [309.492827] Starting subtest: retire-vma-not-inactive [309.552718] Subtest retire-vma-not-inactive: SUCCESS (0.058s) [309.713347] [039/133] (768s left) i915_pm_rps (thresholds-idle) [309.776566] Starting subtest: thresholds-idle [309.780602] Subtest thresholds-idle: SKIP (0.000s) [309.901230] [040/133] (768s left) gem_ctx_persistence (legacy-engines-queued) [309.962233] Starting subtest: legacy-engines-queued [309.964601] Starting dynamic subtest: render [310.049368] Dynamic subtest render: SUCCESS (0.086s) [310.061706] Starting dynamic subtest: bsd1 [311.619221] Dynamic subtest bsd1: SUCCESS (1.565s) [311.632130] Starting dynamic subtest: bsd2 [313.600431] Dynamic subtest bsd2: SUCCESS (1.978s) [313.612638] Starting dynamic subtest: blt [313.656384] Dynamic subtest blt: SUCCESS (0.056s) [313.668297] Starting dynamic subtest: vebox [315.584957] Dynamic subtest vebox: SUCCESS (1.924s) [315.588066] Subtest legacy-engines-queued: SUCCESS (5.620s) [315.691147] [041/133] (763s left) i915_hangman (gt-error-state-capture) [315.761580] Starting subtest: gt-error-state-capture [315.763887] Starting dynamic subtest: rcs0 [327.616895] Dynamic subtest rcs0: SUCCESS (11.851s) [327.630430] Starting dynamic subtest: bcs0 [339.584291] Dynamic subtest bcs0: SUCCESS (11.960s) [339.596564] Starting dynamic subtest: vcs0 [351.552808] Dynamic subtest vcs0: SUCCESS (11.961s) [351.565058] Starting dynamic subtest: vcs1 [363.521381] Dynamic subtest vcs1: SUCCESS (11.963s) [363.533345] Starting dynamic subtest: vecs0 [373.568753] Dynamic subtest vecs0: SUCCESS (10.049s) [373.580889] Starting dynamic subtest: ccs0 [385.601092] Dynamic subtest ccs0: SUCCESS (12.032s) [385.604057] Subtest gt-error-state-capture: SUCCESS (69.829s) [385.767487] [042/133] (692s left) kms_cursor_crc (cursor-rapid-movement-128x42) [386.015975] Starting subtest: cursor-rapid-movement-128x42 [386.062766] Subtest cursor-rapid-movement-128x42: SKIP (0.041s) [386.313242] [043/133] (692s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [386.368934] Subtest writes-after-reads-uncached: SKIP (0.000s) [386.458390] [044/133] (692s left) gem_mmap_wc (coherency) [386.510767] Subtest coherency: SKIP (0.000s) [386.576871] [045/133] (692s left) syncobj_timeline (single-wait-all-for-submit-signaled) [386.637596] Starting subtest: single-wait-all-for-submit-signaled [386.639864] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s) [386.775863] [046/133] (692s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render) [386.866491] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render [390.573052] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.710s) [391.788570] [047/133] (687s left) kms_psr (fbc-psr-primary-mmap-cpu) [391.891197] Starting subtest: fbc-psr-primary-mmap-cpu [391.893551] Starting dynamic subtest: eDP-1 [391.898115] Dynamic subtest eDP-1: SKIP (0.000s) [391.902754] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s) [392.022706] [048/133] (687s left) kms_invalid_mode (bad-vsync-start) [392.149065] Starting subtest: bad-vsync-start [392.151310] Starting dynamic subtest: pipe-A-eDP-1 [392.440972] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s) [392.451230] Starting dynamic subtest: pipe-B-eDP-1 [392.453321] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [392.462107] Starting dynamic subtest: pipe-C-eDP-1 [392.464283] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [392.473479] Starting dynamic subtest: pipe-D-eDP-1 [392.475690] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [392.477936] Subtest bad-vsync-start: SUCCESS (0.299s) [393.302602] [049/133] (685s left) gem_exec_reloc (basic-wc-gtt) [393.354932] Subtest basic-wc-gtt: SKIP (0.000s) [393.423770] [050/133] (685s left) gem_mmap_gtt (cpuset-medium-copy-xy) [393.486025] Subtest cpuset-medium-copy-XY: SKIP (0.000s) [393.553955] [051/133] (685s left) kms_prop_blob (blob-multiple) [393.612297] Starting subtest: blob-multiple [393.614543] Subtest blob-multiple: SUCCESS (0.002s) [393.756194] [052/133] (685s left) api_intel_allocator (open-vm) [393.827771] Starting subtest: open-vm [393.830188] Subtest open-vm: SUCCESS (0.003s) [393.998824] [053/133] (685s left) kms_getfb (getfb-repeated-different-handles) [394.101959] Starting subtest: getfb-repeated-different-handles [394.103997] Subtest getfb-repeated-different-handles: SUCCESS (0.000s) [394.232323] [054/133] (685s left) kms_content_protection (legacy-hdcp14) [394.370956] Starting subtest: legacy-hdcp14 [394.374881] Subtest legacy-hdcp14: SKIP (0.000s) [394.537634] [055/133] (684s left) kms_chamelium_hpd (hdmi-hpd-after-suspend) [394.922353] Subtest hdmi-hpd-after-suspend: SKIP (0.000s) [395.696490] [056/133] (683s left) kms_flip (blocking-absolute-wf_vblank) [395.792944] Starting subtest: blocking-absolute-wf_vblank [395.795394] Starting dynamic subtest: A-eDP1 [404.568293] Dynamic subtest A-eDP1: SUCCESS (8.773s) [404.577985] Starting dynamic subtest: B-eDP1 [413.291461] Dynamic subtest B-eDP1: SUCCESS (8.721s) [413.303225] Starting dynamic subtest: C-eDP1 [422.010113] Dynamic subtest C-eDP1: SUCCESS (8.715s) [422.020138] Starting dynamic subtest: D-eDP1 [430.737823] Dynamic subtest D-eDP1: SUCCESS (8.723s) [430.742928] Subtest blocking-absolute-wf_vblank: SUCCESS (34.947s) [431.978904] [057/133] (647s left) gem_mmap_offset (bad-object) [432.046650] Starting subtest: bad-object [432.048984] Subtest bad-object: SUCCESS (0.001s) [432.201734] [058/133] (647s left) kms_psr (psr2-no-drrs) [432.307082] Starting subtest: psr2-no-drrs [432.309470] Starting dynamic subtest: eDP-1 [433.914864] Dynamic subtest eDP-1: SUCCESS (1.606s) [433.916820] Subtest psr2-no-drrs: SUCCESS (1.607s) [434.735995] [059/133] (644s left) gem_fenced_exec_thrash (no-spare-fences-interruptible) [434.792510] Subtest no-spare-fences-interruptible: SKIP (0.000s) [434.878000] [060/133] (644s left) kms_vblank (wait-idle) [434.986004] Starting subtest: wait-idle [434.988326] Starting dynamic subtest: pipe-A-eDP-1 [436.737688] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.751s) [436.757416] Starting dynamic subtest: pipe-D-eDP-1 [439.151071] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.411s) [439.153549] Subtest wait-idle: SUCCESS (4.166s) [440.006141] [061/133] (639s left) gem_exec_whisper (basic-contexts-all) [440.066151] Starting subtest: basic-contexts-all [451.586970] Subtest basic-contexts-all: SUCCESS (11.513s) [451.796835] [062/133] (627s left) kms_big_fb (x-tiled-16bpp-rotate-0) [451.915650] Starting subtest: x-tiled-16bpp-rotate-0 [453.151786] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.234s) [453.330058] [063/133] (626s left) kms_atomic (plane-primary-overlay-mutable-zpos) [453.421598] Starting subtest: plane-primary-overlay-mutable-zpos [456.815005] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.392s) [458.026015] [064/133] (621s left) gen9_exec_parse (bb-start-cmd) [458.107853] Subtest bb-start-cmd: SKIP (0.000s) [458.191466] [065/133] (621s left) kms_cursor_crc (cursor-alpha-opaque) [458.281567] Starting subtest: cursor-alpha-opaque [458.284063] Starting dynamic subtest: pipe-A-eDP-1 [458.912587] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.630s) [458.921816] Starting dynamic subtest: pipe-D-eDP-1 [460.186648] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.273s) [460.188893] Subtest cursor-alpha-opaque: SUCCESS (1.906s) [461.088791] [066/133] (618s left) kms_cursor_crc (cursor-sliding-64x64) [461.281597] Starting subtest: cursor-sliding-64x64 [461.286597] Starting dynamic subtest: pipe-A-eDP-1 [464.538830] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.250s) [464.576486] Starting dynamic subtest: pipe-D-eDP-1 [468.475989] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.910s) [468.477852] Subtest cursor-sliding-64x64: SUCCESS (7.189s) [469.369374] [067/133] (610s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render) [469.471939] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render [476.226635] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.755s) [476.386713] [068/133] (603s left) gem_ctx_shared (exec-single-timeline) [476.447131] Starting subtest: exec-single-timeline [476.449488] Starting dynamic subtest: rcs0 [477.503307] Dynamic subtest rcs0: SUCCESS (1.053s) [477.515494] Starting dynamic subtest: bcs0 [478.590987] Dynamic subtest bcs0: SUCCESS (1.085s) [478.604654] Starting dynamic subtest: vcs0 [479.679566] Dynamic subtest vcs0: SUCCESS (1.085s) [479.693681] Starting dynamic subtest: vcs1 [480.794159] Dynamic subtest vcs1: SUCCESS (1.085s) [480.811455] Starting dynamic subtest: vecs0 [481.856275] Dynamic subtest vecs0: SUCCESS (1.085s) [481.869551] Starting dynamic subtest: ccs0 [482.943597] Dynamic subtest ccs0: SUCCESS (1.084s) [482.946346] Subtest exec-single-timeline: SUCCESS (6.494s) [483.636912] [069/133] (596s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format) [483.731011] Starting subtest: plane-downscale-factor-0-75-with-pixel-format [483.733259] Starting dynamic subtest: pipe-A [484.914083] Dynamic subtest pipe-A: SUCCESS (1.185s) [484.925502] Starting dynamic subtest: pipe-B [487.143345] Dynamic subtest pipe-B: SUCCESS (2.226s) [487.153081] Starting dynamic subtest: pipe-C [488.300117] Dynamic subtest pipe-C: SUCCESS (1.155s) [488.310850] Starting dynamic subtest: pipe-D [489.531440] Dynamic subtest pipe-D: SUCCESS (1.230s) [489.533777] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.802s) [490.742012] [070/133] (589s left) gem_wait (write-busy) [490.821515] Starting subtest: write-busy [490.824019] Starting dynamic subtest: all-engines [491.443527] Dynamic subtest all-engines: SUCCESS (0.622s) [491.460065] Starting dynamic subtest: rcs0 [492.001256] Dynamic subtest rcs0: SUCCESS (0.556s) [492.018739] Starting dynamic subtest: bcs0 [492.555907] Dynamic subtest bcs0: SUCCESS (0.554s) [492.571582] Starting dynamic subtest: vcs0 [493.667103] Dynamic subtest vcs0: SUCCESS (1.109s) [493.684410] Starting dynamic subtest: vcs1 [495.649382] Dynamic subtest vcs1: SUCCESS (1.981s) [495.666134] Starting dynamic subtest: vecs0 [497.635970] Dynamic subtest vecs0: SUCCESS (1.985s) [497.652902] Starting dynamic subtest: ccs0 [498.187388] Dynamic subtest ccs0: SUCCESS (0.550s) [498.190257] Subtest write-busy: SUCCESS (7.369s) [498.414971] [071/133] (581s left) kms_big_fb (y-tiled-8bpp-rotate-0) [498.513923] Starting subtest: y-tiled-8bpp-rotate-0 [498.518593] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s) [498.630108] [072/133] (581s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [498.756791] Starting subtest: basic-busy-flip-before-cursor-legacy [498.761046] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [498.925930] [073/133] (581s left) gem_basic (bad-close) [498.982572] Starting subtest: bad-close [498.986835] Subtest bad-close: SUCCESS (0.000s) [499.121189] [074/133] (581s left) kms_big_fb (linear-16bpp-rotate-0) [499.223299] Starting subtest: linear-16bpp-rotate-0 [500.534084] Subtest linear-16bpp-rotate-0: SUCCESS (1.310s) [500.704774] [075/133] (579s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf) [505.684082] Starting subtest: pr-overlay-plane-update-continuous-sf [505.688837] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.002s) [506.556786] [076/133] (573s left) drm_read (short-buffer-wakeup) [506.707076] Starting subtest: short-buffer-wakeup [538.920930] Subtest short-buffer-wakeup: SUCCESS (32.215s) [539.097144] [077/133] (541s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite) [539.194083] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite [546.289077] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.097s) [546.463813] [078/133] (533s left) kms_psr (fbc-pr-cursor-render) [546.567611] Starting subtest: fbc-pr-cursor-render [546.571732] Subtest fbc-pr-cursor-render: SKIP (0.000s) [546.678017] [079/133] (533s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs) [546.761301] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs [546.763617] Starting dynamic subtest: pipe-A-eDP-1 [546.772212] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [546.782620] Starting dynamic subtest: pipe-B-eDP-1 [546.791766] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [546.802443] Starting dynamic subtest: pipe-C-eDP-1 [546.809946] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [546.819068] Starting dynamic subtest: pipe-D-eDP-1 [546.827212] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [546.831195] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s) [548.961694] [080/133] (531s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs) [549.054266] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs [549.056426] Starting dynamic subtest: pipe-A-eDP-1 [550.261953] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.208s) [550.271381] Starting dynamic subtest: pipe-B-eDP-1 [552.559600] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.298s) [552.569955] Starting dynamic subtest: pipe-C-eDP-1 [554.874910] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.314s) [554.886291] Starting dynamic subtest: pipe-D-eDP-1 [557.124151] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.248s) [557.126368] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.072s) [558.302214] [081/133] (522s left) sw_sync (sync_multi_timeline_wait) [558.342848] Starting subtest: sync_multi_timeline_wait [558.345242] Subtest sync_multi_timeline_wait: SUCCESS (0.000s) [558.431372] [082/133] (522s left) sysfs_heartbeat_interval (idempotent) [558.486051] Starting subtest: idempotent [558.488429] Starting dynamic subtest: vecs0 [558.490788] Dynamic subtest vecs0: SUCCESS (0.001s) [558.502126] Starting dynamic subtest: ccs0 [558.504282] Dynamic subtest ccs0: SUCCESS (0.001s) [558.513583] Starting dynamic subtest: vcs0 [558.515758] Dynamic subtest vcs0: SUCCESS (0.000s) [558.524669] Starting dynamic subtest: bcs0 [558.526797] Dynamic subtest bcs0: SUCCESS (0.001s) [558.535594] Starting dynamic subtest: rcs0 [558.537733] Dynamic subtest rcs0: SUCCESS (0.000s) [558.547112] Starting dynamic subtest: vcs1 [558.549375] Dynamic subtest vcs1: SUCCESS (0.000s) [558.551672] Subtest idempotent: SUCCESS (0.007s) [558.630959] [083/133] (521s left) syncobj_eventfd (invalid-bad-pad) [558.694102] Starting subtest: invalid-bad-pad [558.696384] Subtest invalid-bad-pad: SUCCESS (0.000s) [558.804108] [084/133] (521s left) kms_busy (extended-pageflip-hang-newfb) [558.910390] Starting subtest: extended-pageflip-hang-newfb [558.912638] Starting dynamic subtest: pipe-A [585.416796] Dynamic subtest pipe-A: SUCCESS (26.501s) [585.434123] Starting dynamic subtest: pipe-D [610.433792] Dynamic subtest pipe-D: SUCCESS (25.014s) [610.436351] Subtest extended-pageflip-hang-newfb: SUCCESS (51.520s) [611.275411] [085/133] (469s left) kms_psr2_sf (psr2-cursor-plane-update-sf) [616.305777] Starting subtest: psr2-cursor-plane-update-sf [616.308089] Starting dynamic subtest: pipe-A-eDP-1 [617.622771] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.314s) [617.633658] Starting dynamic subtest: pipe-B-eDP-1 [618.944231] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.321s) [618.946688] Subtest psr2-cursor-plane-update-sf: SUCCESS (2.639s) [619.878626] [086/133] (460s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [619.993382] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip [620.650812] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.659s) [620.859936] [087/133] (459s left) gem_exec_balancer (busy) [620.925696] Starting subtest: busy [622.647990] Subtest busy: SUCCESS (1.723s) [622.999677] [088/133] (457s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt) [623.095932] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt [623.100231] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [623.240191] [089/133] (457s left) vgem_slow (nohang) [623.289396] Starting subtest: nohang [633.664270] Subtest nohang: SUCCESS (10.375s) [633.756953] [090/133] (447s left) gem_spin_batch (resubmit-new-all) [633.828420] Starting subtest: resubmit-new-all [633.831814] Starting dynamic subtest: rcs0 [633.854587] Dynamic subtest rcs0: SUCCESS (0.027s) [633.866272] Starting dynamic subtest: bcs0 [633.871768] Dynamic subtest bcs0: SUCCESS (0.016s) [633.881723] Starting dynamic subtest: vcs0 [633.888421] Dynamic subtest vcs0: SUCCESS (0.016s) [633.897910] Starting dynamic subtest: vcs1 [633.909016] Dynamic subtest vcs1: SUCCESS (0.019s) [633.924065] Starting dynamic subtest: vecs0 [633.931182] Dynamic subtest vecs0: SUCCESS (0.021s) [633.945724] Starting dynamic subtest: ccs0 [633.953565] Dynamic subtest ccs0: SUCCESS (0.021s) [633.955951] Subtest resubmit-new-all: SUCCESS (0.127s) [635.687102] [091/133] (445s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs) [635.749241] Starting subtest: mixed-tiled-to-y-tiled-ccs [635.753143] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s) [635.957498] [092/133] (445s left) syncobj_timeline (invalid-signal-illegal-point) [636.010105] Starting subtest: invalid-signal-illegal-point [636.012297] Subtest invalid-signal-illegal-point: SUCCESS (0.000s) [636.145775] [093/133] (444s left) gem_exec_schedule (preempt-contexts) [636.224113] Starting subtest: preempt-contexts [636.226011] Starting dynamic subtest: rcs0 [636.320104] Dynamic subtest rcs0: SUCCESS (0.102s) [636.330738] Starting dynamic subtest: bcs0 [636.401449] Dynamic subtest bcs0: SUCCESS (0.081s) [636.412012] Starting dynamic subtest: vcs0 [636.457163] Dynamic subtest vcs0: SUCCESS (0.054s) [636.467382] Starting dynamic subtest: vcs1 [636.519241] Dynamic subtest vcs1: SUCCESS (0.062s) [636.530049] Starting dynamic subtest: vecs0 [636.583066] Dynamic subtest vecs0: SUCCESS (0.062s) [636.594116] Starting dynamic subtest: ccs0 [636.671516] Dynamic subtest ccs0: SUCCESS (0.087s) [636.673936] Subtest preempt-contexts: SUCCESS (0.454s) [637.748975] [094/133] (443s left) gem_pwrite_snooped [637.906280] [095/133] (443s left) kms_tiled_display (basic-test-pattern) [638.018589] Subtest basic-test-pattern: SKIP (0.000s) [638.063426] [096/133] (443s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary) [638.161788] Starting subtest: psr-shrfb-scaledprimary [643.913450] Subtest psr-shrfb-scaledprimary: SUCCESS (5.753s) [644.087528] [097/133] (437s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [644.198190] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [644.202806] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [644.339050] [098/133] (436s left) gem_pwrite (basic-self) [644.411498] Subtest basic-self: SKIP (0.000s) [644.478967] [099/133] (436s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [646.804124] Starting subtest: dpms-mode-unset-non-lpsp [647.968008] Subtest dpms-mode-unset-non-lpsp: SKIP (1.163s) [648.370019] [100/133] (432s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [648.472111] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [648.477044] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [648.611558] [101/133] (432s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render) [648.719245] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render [648.723241] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [648.862246] [102/133] (432s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d) [648.978525] Starting subtest: plane-lut1d-ctm3x4-lut1d [648.998309] Starting dynamic subtest: pipe-A-eDP-1 [649.677333] Dynamic subtest pipe-A-eDP-1: FAIL (0.352s) [650.416769] Starting dynamic subtest: pipe-B-eDP-1 [651.273623] Dynamic subtest pipe-B-eDP-1: FAIL (0.324s) [651.758416] Starting dynamic subtest: pipe-C-eDP-1 [652.579954] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s) [653.094868] Starting dynamic subtest: pipe-D-eDP-1 [653.938717] Dynamic subtest pipe-D-eDP-1: FAIL (0.257s) [653.941080] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.666s) [654.508331] [103/133] (426s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render) [654.615139] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render [661.357026] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.743s) [661.528770] [104/133] (419s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff) [661.637080] Starting subtest: psr-1p-primscrn-cur-indfb-onoff [668.688881] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.052s) [668.834462] [105/133] (412s left) gem_exec_schedule (preempt-queue-contexts-chain) [668.899870] Subtest preempt-queue-contexts-chain: SKIP (0.000s) [669.212994] [106/133] (412s left) api_intel_bb (object-noreloc-keep-cache-simple) [669.264953] Starting subtest: object-noreloc-keep-cache-simple [669.267592] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.005s) [669.386351] [107/133] (412s left) gem_mmap (bad-object) [669.453379] Subtest bad-object: SKIP (0.000s) [669.525794] [108/133] (412s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling) [669.621555] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling [669.623917] Starting dynamic subtest: pipe-A-default-mode [669.916848] Dynamic subtest pipe-A-default-mode: SKIP (0.292s) [669.921312] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.293s) [670.770826] [109/133] (410s left) kms_addfb_basic (bo-too-small-due-to-tiling) [670.861246] Starting subtest: bo-too-small-due-to-tiling [670.865588] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [670.972597] [110/133] (410s left) kms_psr (pr-sprite-blt) [671.051266] Starting subtest: pr-sprite-blt [671.055811] Subtest pr-sprite-blt: SKIP (0.000s) [671.149516] [111/133] (410s left) kms_draw_crc (fill-fb) [671.239404] Starting subtest: fill-fb [671.701294] Subtest fill-fb: SUCCESS (0.464s) [671.833983] [112/133] (410s left) perf_pmu (busy-idle) [671.869090] Starting subtest: busy-idle [671.871085] Starting dynamic subtest: rcs0 [672.583332] Dynamic subtest rcs0: SUCCESS (0.715s) [672.595988] Starting dynamic subtest: bcs0 [673.244262] Dynamic subtest bcs0: SUCCESS (0.658s) [673.257035] Starting dynamic subtest: vcs0 [674.658100] Dynamic subtest vcs0: SUCCESS (1.410s) [674.668566] Starting dynamic subtest: vcs1 [676.641932] Dynamic subtest vcs1: SUCCESS (1.980s) [676.654598] Starting dynamic subtest: vecs0 [678.627742] Dynamic subtest vecs0: SUCCESS (1.983s) [678.640898] Starting dynamic subtest: ccs0 [679.297243] Dynamic subtest ccs0: SUCCESS (0.668s) [679.299891] Subtest busy-idle: SUCCESS (7.429s) [679.410689] [113/133] (402s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs) [679.507485] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs [679.509753] Starting dynamic subtest: pipe-A-eDP-1 [679.568790] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [679.580385] Starting dynamic subtest: pipe-B-eDP-1 [679.637027] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [679.647784] Starting dynamic subtest: pipe-C-eDP-1 [679.704882] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [679.716612] Starting dynamic subtest: pipe-D-eDP-1 [679.775189] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [679.779419] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.008s) [681.842438] [114/133] (400s left) gem_exec_flush (basic-batch-kernel-default-uc) [681.900208] Starting subtest: basic-batch-kernel-default-uc [688.976846] Subtest basic-batch-kernel-default-uc: SUCCESS (7.076s) [689.198160] [115/133] (392s left) gem_mmap_wc (write-read-distinct) [689.261408] Subtest write-read-distinct: SKIP (0.000s) [689.323677] [116/133] (392s left) kms_plane_lowres (tiling-x) [689.416503] Starting subtest: tiling-x [689.418791] Starting dynamic subtest: pipe-A-eDP-1 [689.423355] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [689.722595] Starting dynamic subtest: pipe-B-eDP-1 [689.727461] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [689.739158] Starting dynamic subtest: pipe-C-eDP-1 [689.743902] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [689.753444] Starting dynamic subtest: pipe-D-eDP-1 [689.757893] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [689.762380] Subtest tiling-x: SKIP (0.305s) [690.557089] [117/133] (391s left) sw_sync (alloc_merge_fence) [690.598383] Starting subtest: alloc_merge_fence [690.600830] Subtest alloc_merge_fence: SUCCESS (0.000s) [690.692569] [118/133] (391s left) kms_pm_backlight (fade) [690.794139] Starting subtest: fade [690.847335] Starting dynamic subtest: eDP-1 [693.522328] Dynamic subtest eDP-1: SUCCESS (2.674s) [693.524507] Subtest fade: SUCCESS (2.726s) [694.378172] [119/133] (387s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling) [694.460435] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling [694.462597] Starting dynamic subtest: pipe-A-default-mode [695.615891] Dynamic subtest pipe-A-default-mode: SKIP (1.151s) [695.620260] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.153s) [695.784114] [120/133] (386s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [695.845175] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [695.950475] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s) [696.050049] [121/133] (386s left) kms_psr (psr-cursor-mmap-cpu) [696.131409] Starting subtest: psr-cursor-mmap-cpu [696.133633] Starting dynamic subtest: eDP-1 [697.873418] Dynamic subtest eDP-1: SUCCESS (1.740s) [697.875845] Subtest psr-cursor-mmap-cpu: SUCCESS (1.741s) [698.775463] [122/133] (383s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [698.889399] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [699.546712] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.659s) [699.763470] [123/133] (382s left) gem_exec_whisper (basic-queues-priority-all) [699.840880] Starting subtest: basic-queues-priority-all [722.070226] Subtest basic-queues-priority-all: SUCCESS (22.220s) [722.283084] [124/133] (360s left) syncobj_timeline (etime-single-wait-all-submitted) [722.352246] Starting subtest: etime-single-wait-all-submitted [722.453893] Subtest etime-single-wait-all-submitted: SUCCESS (0.103s) [722.562570] [125/133] (359s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff) [722.654795] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff [722.658889] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [722.793347] [126/133] (359s left) kms_async_flips (async-flip-dpms) [722.879118] Starting subtest: async-flip-dpms [723.254095] Starting dynamic subtest: pipe-A-eDP-1 [727.066109] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.811s) [727.433575] Starting dynamic subtest: pipe-B-eDP-1 [730.240814] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.814s) [730.607403] Starting dynamic subtest: pipe-C-eDP-1 [733.406373] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.806s) [733.788716] Starting dynamic subtest: pipe-D-eDP-1 [736.569710] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.787s) [736.572166] Subtest async-flip-dpms: SUCCESS (13.688s) [737.767106] [127/133] (344s left) gem_exec_reloc (basic-cpu-read-noreloc) [737.859215] Subtest basic-cpu-read-noreloc: SKIP (0.000s) [738.104097] [128/133] (344s left) syncobj_wait (invalid-reset-illegal-handle) [738.347269] Starting subtest: invalid-reset-illegal-handle [738.349810] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [738.536135] [129/133] (344s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [738.622076] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [738.725957] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s) [738.827724] [130/133] (343s left) gem_tiled_swapping (non-threaded) [738.891475] Subtest non-threaded: SKIP (0.000s) [738.954335] [131/133] (343s left) gem_exec_fence (syncobj-timeline-chain-engines) [739.489205] Starting subtest: syncobj-timeline-chain-engines [739.609953] Subtest syncobj-timeline-chain-engines: SUCCESS (0.121s) [740.780592] [132/133] (341s left) kms_cursor_legacy (flip-vs-cursor-legacy) [740.918793] Starting subtest: flip-vs-cursor-legacy [747.923808] Subtest flip-vs-cursor-legacy: SUCCESS (7.004s) [748.799734] [133/133] (333s left) syncobj_basic (illegal-fd-to-handle) [748.863634] Starting subtest: illegal-fd-to-handle [748.865527] Subtest illegal-fd-to-handle: SUCCESS (0.000s) [749.006190] 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.