[62.857290] Initializing watchdogs
[62.857332]   /dev/watchdog0
[62.871779] [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]
[62.876096] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.878390] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.881871] [001/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[63.014202] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[63.018726] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[63.104879] [002/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[63.201515] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[63.205516] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[63.289173] [003/133] (960s left) kms_psr (fbc-psr-primary-mmap-gtt)
[63.377581] Starting subtest: fbc-psr-primary-mmap-gtt
[63.379915] Starting dynamic subtest: eDP-1
[63.384138] Dynamic subtest eDP-1: SKIP (0.000s)
[63.388356] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[63.445640] [004/133] (960s left) kms_pm_backlight (fade-with-dpms)
[63.534738] Starting subtest: fade-with-dpms
[65.739113] Starting dynamic subtest: eDP-1
[68.235430] Dynamic subtest eDP-1: SUCCESS (2.504s)
[68.237800] Subtest fade-with-dpms: SUCCESS (4.717s)
[69.037701] [005/133] (954s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[69.132301] Starting subtest: basic-modeset-with-all-modifiers-formats
[69.503490] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[70.328725] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.828s)
[70.338850] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[70.350013] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.020s)
[70.360016] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[70.372314] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[70.382850] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[70.527234] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[70.534623] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[70.549688] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s)
[70.559341] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[70.571792] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[70.578765] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[70.594185] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[70.601102] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[70.616201] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s)
[70.623153] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[70.638410] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s)
[70.645382] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[70.661212] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[70.671239] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[70.683023] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[70.690073] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[70.704599] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[70.712241] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[70.849297] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.144s)
[70.856942] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[70.871322] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[70.878494] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[70.893134] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[70.901022] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[70.915724] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[70.922792] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[70.938044] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[70.945424] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[70.960965] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[70.971761] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[70.982286] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[70.988973] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[71.004465] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[71.014056] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[71.026190] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[71.033093] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[71.170848] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.145s)
[71.177543] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[71.192987] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s)
[71.199515] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[71.215361] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[71.222350] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[71.237662] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s)
[71.244291] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[71.260702] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[71.271518] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[71.281909] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[71.288963] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[71.304033] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.021s)
[71.310895] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[71.326058] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[71.333093] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[71.348396] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[71.733485] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.608s)
[72.495857] [006/133] (951s left) kms_pm_rpm (pc8-residency)
[74.010916] Starting subtest: pc8-residency
[74.015701] Subtest pc8-residency: SKIP (0.000s)
[74.733724] [007/133] (948s left) kms_legacy_colorkey (basic)
[74.827308] Starting subtest: basic
[74.829576] Starting dynamic subtest: pipe-A
[74.872661] Dynamic subtest pipe-A: SUCCESS (0.045s)
[74.882848] Starting dynamic subtest: pipe-B
[74.885193] Dynamic subtest pipe-B: SUCCESS (0.001s)
[74.892323] Starting dynamic subtest: pipe-C
[74.894580] Dynamic subtest pipe-C: SUCCESS (0.001s)
[74.901352] Starting dynamic subtest: pipe-D
[74.903354] Dynamic subtest pipe-D: SUCCESS (0.001s)
[74.905162] Subtest basic: SUCCESS (0.049s)
[74.947893] [008/133] (948s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[75.039100] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[75.043653] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[75.107625] [009/133] (948s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[75.197145] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[75.201598] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[75.275679] [010/133] (948s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[75.365251] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[75.369382] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[75.452920] [011/133] (948s left) i915_query (query-topology-coherent-slice-mask)
[75.500993] Starting subtest: query-topology-coherent-slice-mask
[75.505687] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[75.591906] [012/133] (948s left) gem_ctx_persistence (engines-mixed)
[75.647746] Starting subtest: engines-mixed
[75.649942] Starting dynamic subtest: rcs0
[75.726530] Dynamic subtest rcs0: SUCCESS (0.079s)
[75.735416] Starting dynamic subtest: bcs0
[75.773564] Dynamic subtest bcs0: SUCCESS (0.049s)
[75.781545] Starting dynamic subtest: vcs0
[75.819287] Dynamic subtest vcs0: SUCCESS (0.045s)
[75.831806] Starting dynamic subtest: vcs1
[75.867319] Dynamic subtest vcs1: SUCCESS (0.047s)
[75.877031] Starting dynamic subtest: vecs0
[75.908230] Dynamic subtest vecs0: SUCCESS (0.040s)
[75.917203] Starting dynamic subtest: ccs0
[75.975285] Dynamic subtest ccs0: SUCCESS (0.067s)
[75.977533] Subtest engines-mixed: SUCCESS (0.331s)
[76.051186] [013/133] (947s left) kms_dsc (dsc-with-bpc-formats)
[76.154043] Starting subtest: dsc-with-bpc-formats
[76.246246] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[76.280093] [014/133] (947s left) gem_ctx_sseu (mmap-args)
[76.345476] Subtest mmap-args: SKIP (0.000s)
[76.424294] [015/133] (947s left) syncobj_timeline (wait-for-submit-complex)
[76.475337] Starting subtest: wait-for-submit-complex
[76.536920] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[76.619062] [016/133] (947s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[76.740082] Starting subtest: verify-pxp-key-change-after-suspend-resume
[83.980069] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.245s)
[84.112158] [017/133] (939s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[84.190737] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[84.298527] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[84.387348] [018/133] (939s left) gem_exec_params (rel-constants-invalid-ring)
[84.447238] Starting subtest: rel-constants-invalid-ring
[84.449530] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[84.540942] [019/133] (939s left) kms_cursor_crc (cursor-onscreen-32x10)
[84.700637] Starting subtest: cursor-onscreen-32x10
[84.749238] Subtest cursor-onscreen-32x10: SKIP (0.044s)
[85.015888] [020/133] (939s left) gem_wait (wait)
[85.080564] Starting subtest: wait
[85.082954] Starting dynamic subtest: all-engines
[86.870101] Dynamic subtest all-engines: SUCCESS (1.787s)
[86.882502] Starting dynamic subtest: rcs0
[87.915462] Dynamic subtest rcs0: SUCCESS (1.046s)
[87.926902] Starting dynamic subtest: bcs0
[88.961162] Dynamic subtest bcs0: SUCCESS (1.045s)
[88.969562] Starting dynamic subtest: vcs0
[90.007454] Dynamic subtest vcs0: SUCCESS (1.045s)
[90.018386] Starting dynamic subtest: vcs1
[91.052317] Dynamic subtest vcs1: SUCCESS (1.044s)
[91.062581] Starting dynamic subtest: vecs0
[92.095075] Dynamic subtest vecs0: SUCCESS (1.042s)
[92.105628] Starting dynamic subtest: ccs0
[93.142928] Dynamic subtest ccs0: SUCCESS (1.046s)
[93.145783] Subtest wait: SUCCESS (8.061s)
[93.342848] [021/133] (930s left) gem_create (create-ext-cpu-access-sanity-check)
[93.514098] Starting subtest: create-ext-cpu-access-sanity-check
[93.518817] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[93.591903] [022/133] (930s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[93.679777] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[93.682196] Starting dynamic subtest: pipe-A-default-mode
[96.403714] Dynamic subtest pipe-A-default-mode: SUCCESS (2.721s)
[96.405989] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.722s)
[97.236187] [023/133] (926s left) gem_ringfill (engines-basic)
[102.937373] Starting subtest: engines-basic
[102.939604] Starting dynamic subtest: rcs0
[102.985231] Dynamic subtest rcs0: SUCCESS (0.050s)
[102.995746] Starting dynamic subtest: bcs0
[103.029062] Dynamic subtest bcs0: SUCCESS (0.043s)
[103.038872] Starting dynamic subtest: vcs0
[103.072190] Dynamic subtest vcs0: SUCCESS (0.042s)
[103.080735] Starting dynamic subtest: vcs1
[103.116202] Dynamic subtest vcs1: SUCCESS (0.043s)
[103.126455] Starting dynamic subtest: vecs0
[103.159035] Dynamic subtest vecs0: SUCCESS (0.042s)
[103.168259] Starting dynamic subtest: ccs0
[103.205041] Dynamic subtest ccs0: SUCCESS (0.045s)
[103.207635] Subtest engines-basic: SUCCESS (0.270s)
[103.285358] [FACT gem_ringfill (engines-basic)] new: kernel.kmod_is_loaded.vgem: true
[103.288594] [024/133] (920s left) kms_psr (psr-sprite-render)
[103.399525] Starting subtest: psr-sprite-render
[103.401765] Starting dynamic subtest: eDP-1
[105.163275] Dynamic subtest eDP-1: SUCCESS (1.763s)
[105.165580] Subtest psr-sprite-render: SUCCESS (1.763s)
[106.002619] [025/133] (918s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[106.525350] Starting subtest: syncobj-timeline-invalid-flags
[106.528311] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[108.003251] [026/133] (916s left) gem_ctx_persistence (legacy-engines-mixed)
[108.055906] Starting subtest: legacy-engines-mixed
[108.058150] Starting dynamic subtest: render
[108.155687] Dynamic subtest render: SUCCESS (0.099s)
[108.166738] Starting dynamic subtest: bsd1
[108.209870] Dynamic subtest bsd1: SUCCESS (0.052s)
[108.220551] Starting dynamic subtest: bsd2
[108.262996] Dynamic subtest bsd2: SUCCESS (0.051s)
[108.273572] Starting dynamic subtest: blt
[108.317768] Dynamic subtest blt: SUCCESS (0.054s)
[108.328124] Starting dynamic subtest: vebox
[108.366602] Dynamic subtest vebox: SUCCESS (0.047s)
[108.369082] Subtest legacy-engines-mixed: SUCCESS (0.311s)
[108.444215] [027/133] (915s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[108.545732] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[112.971580] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.428s)
[114.111851] [028/133] (910s left) kms_atomic (plane-overlay-legacy)
[114.211000] Starting subtest: plane-overlay-legacy
[114.213422] Starting dynamic subtest: pipe-A-eDP-1
[114.628772] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.418s)
[114.631023] Subtest plane-overlay-legacy: SUCCESS (0.419s)
[115.432755] [029/133] (909s left) gem_exec_reloc (basic-wc-noreloc)
[115.487580] Subtest basic-wc-noreloc: SKIP (0.000s)
[115.615195] [030/133] (908s left) syncobj_timeline (single-wait-all-available-submitted)
[115.679175] Starting subtest: single-wait-all-available-submitted
[115.681604] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[115.801091] [031/133] (908s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[115.885406] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[115.887731] Starting dynamic subtest: pipe-A-eDP-1
[115.897076] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[115.908649] Starting dynamic subtest: pipe-B-eDP-1
[115.920894] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[115.929147] Starting dynamic subtest: pipe-C-eDP-1
[115.937705] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[115.945573] Starting dynamic subtest: pipe-D-eDP-1
[115.953911] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[115.958130] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[118.116195] [032/133] (906s left) gem_busy (semaphore)
[118.307445] Subtest semaphore: SKIP (0.000s)
[118.543514] [033/133] (906s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[118.654935] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[118.659412] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[118.799925] [034/133] (905s left) kms_chamelium_frames (hdmi-crc-single)
[119.185376] Subtest hdmi-crc-single: SKIP (0.000s)
[120.019987] [035/133] (904s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[120.133036] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[129.178233] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.042s)
[129.981166] [036/133] (894s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[130.089065] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[130.093142] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[130.192031] [037/133] (894s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[130.285143] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[130.287076] Starting dynamic subtest: pipe-A-eDP-1
[131.097922] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.806s)
[131.111349] Starting dynamic subtest: pipe-B-eDP-1
[132.619355] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.520s)
[132.627886] Starting dynamic subtest: pipe-C-eDP-1
[134.099660] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.478s)
[134.108048] Starting dynamic subtest: pipe-D-eDP-1
[135.638918] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.538s)
[135.641238] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.347s)
[136.797277] [038/133] (888s left) kms_chamelium_hpd (dp-hpd-fast)
[137.179270] Subtest dp-hpd-fast: SKIP (0.000s)
[138.009021] [039/133] (886s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[138.104164] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[138.108501] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[138.184963] [040/133] (886s left) gem_exercise_blt (fast-copy-emit)
[138.259856] Starting subtest: fast-copy-emit
[138.262314] Starting dynamic subtest: linear-smem-smem-emit
[138.281612] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.022s)
[138.292698] Starting dynamic subtest: xmajor-smem-smem-emit
[138.298819] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s)
[138.306785] Starting dynamic subtest: tile4-smem-smem-emit
[138.318063] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.019s)
[138.326185] Starting dynamic subtest: tile64-smem-smem-emit
[138.334983] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[138.337307] Subtest fast-copy-emit: SUCCESS (0.076s)
[138.453438] [041/133] (886s left) vgem_basic (dmabuf-export)
[138.501646] Starting subtest: dmabuf-export
[138.514868] Subtest dmabuf-export: SUCCESS (0.015s)
[138.607371] [042/133] (886s left) prime_self_import (basic-with_fd_dup)
[138.647393] Starting subtest: basic-with_fd_dup
[138.662488] Subtest basic-with_fd_dup: SUCCESS (0.016s)
[138.765056] [043/133] (886s left) prime_vgem (coherency-blt)
[138.854473] Starting subtest: coherency-blt
[139.950472] Subtest coherency-blt: SUCCESS (1.097s)
[140.072552] [044/133] (885s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[140.193501] Starting subtest: flip-vs-cursor-busy-crc-legacy
[141.008339] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.816s)
[141.858500] [045/133] (883s left) gem_mmap (bad-offset)
[141.915055] Subtest bad-offset: SKIP (0.000s)
[141.972903] [046/133] (883s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[142.042359] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[142.103331] [047/133] (883s left) gem_exec_reloc (basic-write-wc)
[142.178270] Subtest basic-write-wc: SKIP (0.000s)
[142.244796] [048/133] (883s left) i915_pm_rpm (gem-pread)
[144.058196] Starting subtest: gem-pread
[146.154958] Subtest gem-pread: SUCCESS (2.097s)
[146.245028] [049/133] (879s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[146.348319] Starting subtest: disable-crc-after-crtc
[146.350725] Starting dynamic subtest: pipe-A-eDP-1
[147.947369] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.598s)
[147.957477] Starting dynamic subtest: pipe-B-eDP-1
[150.227819] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.279s)
[150.239123] Starting dynamic subtest: pipe-C-eDP-1
[152.472508] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.244s)
[152.481805] Starting dynamic subtest: pipe-D-eDP-1
[154.756698] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.282s)
[154.759027] Subtest disable-crc-after-crtc: SUCCESS (8.408s)
[155.573302] [050/133] (869s left) kms_content_protection (uevent-hdcp14)
[155.719097] Starting subtest: uevent-hdcp14
[155.723805] Subtest uevent-hdcp14: SKIP (0.000s)
[155.839894] [051/133] (869s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[155.932493] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[155.936602] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[156.046830] [052/133] (869s left) gem_exec_reloc (basic-cpu-gtt)
[156.111059] Subtest basic-cpu-gtt: SKIP (0.000s)
[156.172632] [053/133] (869s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[156.268964] Starting subtest: psr2-cursor-plane-update-sf
[156.271182] Starting dynamic subtest: pipe-A-eDP-1
[156.836772] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.572s)
[156.845902] Starting dynamic subtest: pipe-B-eDP-1
[158.160324] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.323s)
[158.162725] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.897s)
[159.027341] [054/133] (866s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[159.119871] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[159.122177] Starting dynamic subtest: pipe-A-eDP-1
[159.180308] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[159.188671] Starting dynamic subtest: pipe-B-eDP-1
[159.245938] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[159.255499] Starting dynamic subtest: pipe-C-eDP-1
[159.312547] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[159.321954] Starting dynamic subtest: pipe-D-eDP-1
[159.379746] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[159.384350] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[161.292041] [055/133] (864s left) gem_mmap_gtt (fault-concurrent-y)
[161.344702] Subtest fault-concurrent-Y: SKIP (0.000s)
[161.405675] [056/133] (864s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[161.503207] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[161.505501] Starting dynamic subtest: pipe-A-eDP-1
[161.528743] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[161.539118] Starting dynamic subtest: pipe-B-eDP-1
[161.560916] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[161.568753] Starting dynamic subtest: pipe-C-eDP-1
[161.590760] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[161.598608] Starting dynamic subtest: pipe-D-eDP-1
[161.621089] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[161.625192] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[163.717567] [057/133] (862s left) syncobj_timeline (invalid-signal-zero-handles)
[163.792470] Starting subtest: invalid-signal-zero-handles
[163.794770] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[163.917955] [058/133] (861s left) api_intel_allocator (alloc-simple)
[163.982053] Starting subtest: alloc-simple
[163.984486] Subtest alloc-simple: SUCCESS (0.003s)
[164.090764] [059/133] (861s left) gem_pwrite (basic-exhaustion)
[164.150778] Subtest basic-exhaustion: SKIP (0.000s)
[164.206676] [060/133] (861s left) gem_exec_balancer (smoke)
[164.266511] Starting subtest: smoke
[186.779601] Subtest smoke: SUCCESS (22.510s)
[188.071611] [061/133] (837s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[188.182368] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[188.186726] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[188.286810] [062/133] (837s left) gem_mmap_wc (invalid-flags)
[188.335375] Subtest invalid-flags: SKIP (0.000s)
[188.407090] [063/133] (837s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[188.504875] Starting subtest: x-tiled-32bpp-rotate-270
[188.526492] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[188.637247] [064/133] (837s left) gem_exec_parallel (userptr)
[188.699493] Starting subtest: userptr
[188.701720] Starting dynamic subtest: rcs0
[190.111415] Dynamic subtest rcs0: SUCCESS (1.411s)
[190.120951] Starting dynamic subtest: bcs0
[191.608439] Dynamic subtest bcs0: SUCCESS (1.496s)
[191.618614] Starting dynamic subtest: vcs0
[194.901610] Dynamic subtest vcs0: SUCCESS (3.289s)
[194.911420] Starting dynamic subtest: vcs1
[196.886372] Dynamic subtest vcs1: SUCCESS (1.982s)
[196.897947] Starting dynamic subtest: vecs0
[198.869508] Dynamic subtest vecs0: SUCCESS (1.981s)
[198.880885] Starting dynamic subtest: ccs0
[200.391385] Dynamic subtest ccs0: SUCCESS (1.521s)
[200.393835] Subtest userptr: SUCCESS (11.693s)
[200.578454] [065/133] (825s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[200.689571] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[200.693993] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[200.794168] [066/133] (825s left) gem_exec_await (wide-all)
[201.032841] Starting subtest: wide-all
[224.847217] Subtest wide-all: SUCCESS (23.816s)
[225.052174] [067/133] (801s left) perf_pmu (render-node-busy-idle)
[225.174672] Starting subtest: render-node-busy-idle
[225.177157] Starting dynamic subtest: rcs0
[225.875768] Dynamic subtest rcs0: SUCCESS (0.700s)
[225.886589] Starting dynamic subtest: bcs0
[226.546031] Dynamic subtest bcs0: SUCCESS (0.668s)
[226.557918] Starting dynamic subtest: vcs0
[227.926871] Dynamic subtest vcs0: SUCCESS (1.377s)
[227.939253] Starting dynamic subtest: vcs1
[229.910871] Dynamic subtest vcs1: SUCCESS (1.981s)
[229.922996] Starting dynamic subtest: vecs0
[231.829577] Dynamic subtest vecs0: SUCCESS (1.917s)
[231.841689] Starting dynamic subtest: ccs0
[232.495270] Dynamic subtest ccs0: SUCCESS (0.664s)
[232.497789] Subtest render-node-busy-idle: SUCCESS (7.322s)
[232.572410] [068/133] (793s left) kms_hdr (static-toggle-dpms)
[232.674863] Starting subtest: static-toggle-dpms
[232.681194] Subtest static-toggle-dpms: SKIP (0.000s)
[232.755336] [069/133] (793s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[232.867167] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[233.725876] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.860s)
[233.915380] [070/133] (792s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[234.013136] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[234.017079] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[234.130564] [071/133] (792s left) i915_drm_fdinfo (basics)
[234.184443] Starting subtest: basics
[234.186770] Subtest basics: SUCCESS (0.000s)
[234.255671] [072/133] (792s left) gem_exec_parallel (basic)
[234.314369] Starting subtest: basic
[234.316624] Starting dynamic subtest: rcs0
[235.750048] Dynamic subtest rcs0: SUCCESS (1.435s)
[235.761145] Starting dynamic subtest: bcs0
[237.208500] Dynamic subtest bcs0: SUCCESS (1.456s)
[237.221192] Starting dynamic subtest: vcs0
[238.886042] Dynamic subtest vcs0: SUCCESS (1.673s)
[238.898394] Starting dynamic subtest: vcs1
[240.854698] Dynamic subtest vcs1: SUCCESS (1.966s)
[240.867290] Starting dynamic subtest: vecs0
[242.902537] Dynamic subtest vecs0: SUCCESS (2.045s)
[242.915040] Starting dynamic subtest: ccs0
[244.373474] Dynamic subtest ccs0: SUCCESS (1.469s)
[244.376045] Subtest basic: SUCCESS (10.060s)
[244.577461] [073/133] (781s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[244.681070] Starting subtest: y-tiled-16bpp-rotate-270
[244.685529] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[244.782020] [074/133] (781s left) kms_cursor_legacy (single-bo)
[244.899611] Starting subtest: single-bo
[244.901451] Starting dynamic subtest: pipe-A
[250.281196] Dynamic subtest pipe-A: SUCCESS (5.379s)
[250.291082] Starting dynamic subtest: pipe-B
[255.665914] Dynamic subtest pipe-B: SUCCESS (5.382s)
[255.677733] Starting dynamic subtest: pipe-C
[261.048024] Dynamic subtest pipe-C: SUCCESS (5.379s)
[261.059650] Starting dynamic subtest: pipe-D
[266.432687] Dynamic subtest pipe-D: SUCCESS (5.382s)
[266.444787] Starting dynamic subtest: all-pipes
[271.823061] Dynamic subtest all-pipes: SUCCESS (5.387s)
[271.825335] Subtest single-bo: SUCCESS (26.923s)
[271.968994] [075/133] (754s left) perf (gen12-group-exclusive-stream-ctx-handle)
[272.128529] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[272.157850] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.029s)
[272.205592] [076/133] (754s left) kms_rotation_crc (bad-pixel-format)
[273.886914] Starting subtest: bad-pixel-format
[273.891250] Subtest bad-pixel-format: SKIP (0.001s)
[273.970840] [077/133] (752s left) gem_close_race (basic-process)
[274.036213] Starting subtest: basic-process
[274.089213] Subtest basic-process: SUCCESS (0.052s)
[274.271755] [078/133] (752s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[274.368589] Starting subtest: psr-rgb101010-draw-mmap-gtt
[274.372843] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[274.452801] [079/133] (752s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[274.548454] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[274.552874] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[275.685618] [080/133] (751s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[275.784325] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[282.487829] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.706s)
[282.622914] [081/133] (744s left) kms_addfb_basic (unused-handle)
[282.683844] Starting subtest: unused-handle
[282.686192] Subtest unused-handle: SUCCESS (0.000s)
[282.809356] [082/133] (744s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[282.898247] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[282.902467] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[282.992931] [083/133] (743s left) kms_hdmi_inject (inject-4k)
[283.340788] Starting subtest: inject-4k
[283.657529] Subtest inject-4k: SUCCESS (0.318s)
[284.172380] [084/133] (742s left) syncobj_timeline (multi-wait-available-submitted)
[284.238263] Starting subtest: multi-wait-available-submitted
[284.240699] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[284.333290] [085/133] (742s left) gem_exec_whisper (basic-contexts-all)
[284.405515] Starting subtest: basic-contexts-all
[295.863060] Subtest basic-contexts-all: SUCCESS (11.452s)
[296.045780] [086/133] (730s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[296.146187] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[296.150493] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[296.238908] [087/133] (730s left) kms_plane_multiple (tiling-4)
[296.339168] Starting subtest: tiling-4
[296.341482] Starting dynamic subtest: pipe-A-eDP-1
[300.165571] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.826s)
[300.175275] Starting dynamic subtest: pipe-B-eDP-1
[304.762810] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.596s)
[304.772918] Starting dynamic subtest: pipe-C-eDP-1
[309.349577] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.584s)
[309.359918] Starting dynamic subtest: pipe-D-eDP-1
[313.954073] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.606s)
[313.956494] Subtest tiling-4: SUCCESS (17.618s)
[314.820863] [088/133] (712s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[314.940722] Starting subtest: yf-tiled-64bpp-rotate-270
[314.945369] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[315.029511] [089/133] (712s left) gem_exec_create (forked)
[315.097667] Starting subtest: forked
[315.099672] Starting dynamic subtest: smem
[335.301514] Dynamic subtest smem: SUCCESS (20.206s)
[335.303970] Subtest forked: SUCCESS (20.207s)
[335.506912] [090/133] (691s left) gen9_exec_parse (batch-without-end)
[335.568491] Subtest batch-without-end: SKIP (0.000s)
[335.645844] [091/133] (691s left) gem_basic (create-fd-close)
[335.714520] Starting subtest: create-fd-close
[335.719196] Subtest create-fd-close: SUCCESS (0.000s)
[335.812642] [092/133] (691s left) kms_plane_scaling (planes-downscale-factor-0-75)
[335.899777] Starting subtest: planes-downscale-factor-0-75
[335.901991] Starting dynamic subtest: pipe-A
[335.919940] Dynamic subtest pipe-A: SKIP (0.017s)
[335.930123] Starting dynamic subtest: pipe-B
[335.951132] Dynamic subtest pipe-B: SKIP (0.030s)
[335.960858] Starting dynamic subtest: pipe-C
[335.981434] Dynamic subtest pipe-C: SKIP (0.030s)
[335.990999] Starting dynamic subtest: pipe-D
[336.012145] Dynamic subtest pipe-D: SKIP (0.030s)
[336.016586] Subtest planes-downscale-factor-0-75: SKIP (0.110s)
[336.120678] [093/133] (691s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[336.223634] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[336.227942] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[336.323293] [094/133] (691s left) kms_psr (psr-cursor-blt)
[336.421379] Starting subtest: psr-cursor-blt
[336.423557] Starting dynamic subtest: eDP-1
[338.180332] Dynamic subtest eDP-1: SUCCESS (1.760s)
[338.182683] Subtest psr-cursor-blt: SUCCESS (1.761s)
[339.010701] [095/133] (688s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[339.115242] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[339.119288] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[339.204175] [096/133] (688s left) kms_flip (2x-flip-vs-fences)
[339.296212] Starting subtest: 2x-flip-vs-fences
[339.300254] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[339.421881] [097/133] (688s left) gem_readwrite (write-bad-handle)
[339.475315] Subtest write-bad-handle: SKIP (0.000s)
[339.545848] [098/133] (687s left) drm_read (empty-block)
[339.680204] Starting subtest: empty-block
[340.680917] Subtest empty-block: SUCCESS (1.000s)
[340.802939] [099/133] (686s left) api_intel_bb (simple-bb-ctx)
[340.858305] Starting subtest: simple-bb-ctx
[340.867155] Subtest simple-bb-ctx: SUCCESS (0.009s)
[340.988585] [100/133] (686s left) gem_mmap_gtt (coherency)
[341.055145] Subtest coherency: SKIP (0.000s)
[341.122990] [101/133] (686s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[341.228741] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[341.232873] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[341.315531] [102/133] (686s left) kms_fbcon_fbt (psr)
[341.388342] Starting subtest: psr
[348.900254] Subtest psr: SUCCESS (7.509s)
[348.975904] [103/133] (678s left) gem_exec_schedule (pi-shared-iova)
[349.162896] Starting subtest: pi-shared-iova
[349.165308] Starting dynamic subtest: rcs0
[349.237385] Dynamic subtest rcs0: SUCCESS (0.076s)
[349.248562] Starting dynamic subtest: vcs0
[349.294960] Dynamic subtest vcs0: SUCCESS (0.058s)
[349.311229] Starting dynamic subtest: vcs1
[349.355056] Dynamic subtest vcs1: SUCCESS (0.059s)
[349.369755] Starting dynamic subtest: vecs0
[349.418363] Dynamic subtest vecs0: SUCCESS (0.062s)
[349.433531] Starting dynamic subtest: ccs0
[349.479826] Dynamic subtest ccs0: SUCCESS (0.059s)
[349.482558] Subtest pi-shared-iova: SUCCESS (0.319s)
[351.019262] [104/133] (676s left) kms_psr (psr2-cursor-mmap-cpu)
[351.116988] Starting subtest: psr2-cursor-mmap-cpu
[351.119153] Starting dynamic subtest: eDP-1
[352.860599] Dynamic subtest eDP-1: SUCCESS (1.743s)
[352.863056] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.744s)
[353.717780] [105/133] (674s left) kms_cursor_crc (cursor-sliding-256x256)
[353.969984] Starting subtest: cursor-sliding-256x256
[353.980292] Starting dynamic subtest: pipe-A-eDP-1
[357.188389] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.207s)
[357.217640] Starting dynamic subtest: pipe-D-eDP-1
[361.103585] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.893s)
[361.105486] Subtest cursor-sliding-256x256: SUCCESS (7.131s)
[361.918574] [106/133] (665s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[362.003325] Starting subtest: fbc-psr2-sprite-mmap-cpu
[362.005654] Starting dynamic subtest: eDP-1
[362.010138] Dynamic subtest eDP-1: SKIP (0.000s)
[362.014619] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[362.078253] [107/133] (665s left) kms_cursor_crc (cursor-random-512x512)
[362.349500] Starting subtest: cursor-random-512x512
[362.353895] Subtest cursor-random-512x512: SKIP (0.001s)
[362.498195] [108/133] (665s left) kms_big_fb (linear-64bpp-rotate-270)
[362.590932] Starting subtest: linear-64bpp-rotate-270
[362.610750] Subtest linear-64bpp-rotate-270: SKIP (0.019s)
[362.713258] [109/133] (665s left) gem_exec_flush (basic-batch-kernel-default-wb)
[362.779232] Starting subtest: basic-batch-kernel-default-wb
[370.260318] Subtest basic-batch-kernel-default-wb: SUCCESS (7.481s)
[370.455912] [110/133] (657s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[370.530687] Starting subtest: basic-batch-kernel-default-cmd
[370.534983] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[370.714234] [111/133] (657s left) gem_exec_schedule (u-independent)
[370.799896] Starting subtest: u-independent
[370.801907] Starting dynamic subtest: rcs0
[371.927424] Dynamic subtest rcs0: SUCCESS (1.133s)
[371.940543] Starting dynamic subtest: vcs0
[373.927291] Dynamic subtest vcs0: SUCCESS (1.997s)
[373.940656] Starting dynamic subtest: vcs1
[375.902667] Dynamic subtest vcs1: SUCCESS (1.973s)
[375.917794] Starting dynamic subtest: vecs0
[377.962748] Dynamic subtest vecs0: SUCCESS (2.058s)
[377.976200] Starting dynamic subtest: ccs0
[379.925855] Dynamic subtest ccs0: SUCCESS (1.961s)
[379.929048] Subtest u-independent: SUCCESS (9.133s)
[380.227905] [112/133] (647s left) syncobj_eventfd (binary-wait-before-signal)
[380.295781] Starting subtest: binary-wait-before-signal
[380.326384] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[380.406501] [113/133] (647s left) gem_exec_balancer (hog)
[380.463949] Starting subtest: hog
[380.468546] Subtest hog: SKIP (0.000s)
[380.779376] [114/133] (647s left) perf (whitelisted-registers-userspace-config)
[380.876871] Starting subtest: whitelisted-registers-userspace-config
[380.879448] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[380.922243] [115/133] (647s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[381.030097] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[381.032571] Starting dynamic subtest: pipe-A-eDP-1
[387.584513] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.558s)
[387.595547] Starting dynamic subtest: pipe-B-eDP-1
[394.465604] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.878s)
[394.467885] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.439s)
[395.309522] [116/133] (632s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[395.416543] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[395.420891] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[395.480368] [117/133] (632s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[395.528813] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[395.531144] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[395.622762] [118/133] (632s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[395.717411] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[395.719906] Starting dynamic subtest: pipe-A-default-mode
[396.838834] Dynamic subtest pipe-A-default-mode: SKIP (1.119s)
[396.843348] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.121s)
[396.998940] [119/133] (631s left) kms_flip (wf_vblank-ts-check-interruptible)
[397.092835] Starting subtest: wf_vblank-ts-check-interruptible
[397.095061] Starting dynamic subtest: A-eDP1
[406.022111] Dynamic subtest A-eDP1: SUCCESS (8.926s)
[406.045416] Starting dynamic subtest: B-eDP1
[414.922521] Dynamic subtest B-eDP1: SUCCESS (8.897s)
[414.932035] Starting dynamic subtest: C-eDP1
[423.811248] Dynamic subtest C-eDP1: SUCCESS (8.885s)
[423.821873] Starting dynamic subtest: D-eDP1
[432.705292] Dynamic subtest D-eDP1: SUCCESS (8.892s)
[432.710278] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.616s)
[433.922985] [120/133] (594s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[433.981720] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[434.090367] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[434.180890] [121/133] (594s left) kms_getfb (getfb2-into-addfb2)
[434.273963] Starting subtest: getfb2-into-addfb2
[434.276152] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[434.374450] [122/133] (594s left) i915_pm_freq_api (freq-basic-api)
[434.432534] Starting subtest: freq-basic-api
[434.434926] Starting dynamic subtest: gt0
[434.437157] Dynamic subtest gt0: SUCCESS (0.003s)
[434.448995] Starting dynamic subtest: gt1
[434.451124] Dynamic subtest gt1: SUCCESS (0.003s)
[434.453201] Subtest freq-basic-api: SUCCESS (0.007s)
[434.546097] [123/133] (594s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[434.648032] Starting subtest: 4-tiled-64bpp-rotate-270
[434.669314] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.019s)
[434.792585] [124/133] (593s left) kms_vblank (query-idle-hang)
[434.887913] Starting subtest: query-idle-hang
[434.889811] Starting dynamic subtest: pipe-A-eDP-1
[461.666366] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.775s)
[461.691516] Starting dynamic subtest: pipe-D-eDP-1
[486.667846] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.000s)
[486.670319] Subtest query-idle-hang: SUCCESS (51.780s)
[487.509997] [125/133] (541s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[487.604350] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[494.798454] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.196s)
[494.920258] [126/133] (533s left) i915_query (query-topology-garbage-items)
[494.984716] Starting subtest: query-topology-garbage-items
[494.986835] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[495.079216] [127/133] (533s left) gem_softpin (allocator-nopin)
[495.148186] Starting subtest: allocator-nopin
[495.246908] Subtest allocator-nopin: SUCCESS (0.099s)
[495.368055] [128/133] (533s left) gem_userptr_blits (coherency-unsync)
[495.431059] Subtest coherency-unsync: SKIP (0.000s)
[495.578462] [129/133] (533s left) kms_vblank (accuracy-idle)
[495.663472] Starting subtest: accuracy-idle
[495.665449] Starting dynamic subtest: pipe-A-eDP-1
[497.431054] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.769s)
[497.446527] Starting dynamic subtest: pipe-D-eDP-1
[499.911652] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.475s)
[499.913931] Subtest accuracy-idle: SUCCESS (4.248s)
[500.716411] [130/133] (528s left) kms_color_pipeline (plane-lut1d)
[500.814161] Starting subtest: plane-lut1d
[500.937767] Starting dynamic subtest: pipe-A-plane-0
[501.267622] Dynamic subtest pipe-A-plane-0: FAIL (0.158s)
[501.279105] Starting dynamic subtest: pipe-A-plane-1
[501.490746] Dynamic subtest pipe-A-plane-1: FAIL (0.160s)
[501.501876] Starting dynamic subtest: pipe-A-plane-2
[501.731486] Dynamic subtest pipe-A-plane-2: FAIL (0.166s)
[502.566886] Starting dynamic subtest: pipe-B-plane-0
[503.026665] Dynamic subtest pipe-B-plane-0: FAIL (0.197s)
[503.038239] Starting dynamic subtest: pipe-B-plane-1
[503.341041] Dynamic subtest pipe-B-plane-1: FAIL (0.176s)
[503.352470] Starting dynamic subtest: pipe-B-plane-2
[503.631504] Dynamic subtest pipe-B-plane-2: FAIL (0.155s)
[504.297623] Starting dynamic subtest: pipe-C-plane-0
[504.766959] Dynamic subtest pipe-C-plane-0: FAIL (0.129s)
[504.778047] Starting dynamic subtest: pipe-C-plane-1
[505.162476] Dynamic subtest pipe-C-plane-1: FAIL (0.132s)
[505.178187] Starting dynamic subtest: pipe-C-plane-2
[505.517770] Dynamic subtest pipe-C-plane-2: FAIL (0.606s)
[506.360748] Starting dynamic subtest: pipe-D-plane-0
[506.934998] Dynamic subtest pipe-D-plane-0: FAIL (0.140s)
[506.945753] Starting dynamic subtest: pipe-D-plane-1
[507.385387] Dynamic subtest pipe-D-plane-1: FAIL (0.604s)
[507.396777] Starting dynamic subtest: pipe-D-plane-2
[507.817544] Dynamic subtest pipe-D-plane-2: FAIL (0.561s)
[507.970430] Subtest plane-lut1d: FAIL (7.156s)
[508.800537] [131/133] (520s left) kms_plane (plane-panning-top-left)
[508.899142] Starting subtest: plane-panning-top-left
[508.901340] Starting dynamic subtest: pipe-A
[510.634216] Dynamic subtest pipe-A: SUCCESS (1.736s)
[510.645701] Starting dynamic subtest: pipe-B
[513.017769] Dynamic subtest pipe-B: SUCCESS (2.382s)
[513.020391] Subtest plane-panning-top-left: SUCCESS (4.121s)
[513.819637] [132/133] (515s left) dmabuf_sync_file (import-basic)
[513.869143] Starting subtest: import-basic
[513.871389] Subtest import-basic: SUCCESS (0.002s)
[513.933337] [133/133] (515s left) kms_flip (2x-dpms-vs-vblank-race)
[514.021493] Starting subtest: 2x-dpms-vs-vblank-race
[514.029659] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s)
[514.138251] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_pm_backlight
results: parsing output: 4/ for test: kms_async_flips
results: parsing output: 5/ for test: kms_pm_rpm
results: parsing output: 6/ for test: kms_legacy_colorkey
results: parsing output: 7/ for test: kms_plane
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: i915_query
results: parsing output: 11/ for test: gem_ctx_persistence
results: parsing output: 12/ for test: kms_dsc
results: parsing output: 13/ for test: gem_ctx_sseu
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: gem_pxp
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: gem_exec_params
results: parsing output: 18/ for test: kms_cursor_crc
results: parsing output: 19/ for test: gem_wait
results: parsing output: 20/ for test: gem_create
results: parsing output: 21/ for test: kms_flip_scaled_crc
results: parsing output: 22/ for test: gem_ringfill
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: gem_exec_fence
results: parsing output: 25/ for test: gem_ctx_persistence
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_atomic
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: gem_busy
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: kms_chamelium_frames
results: parsing output: 34/ for test: kms_cursor_legacy
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_ccs
results: parsing output: 37/ for test: kms_chamelium_hpd
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_exercise_blt
results: parsing output: 40/ for test: vgem_basic
results: parsing output: 41/ for test: prime_self_import
results: parsing output: 42/ for test: prime_vgem
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: gem_mmap
results: parsing output: 45/ for test: kms_pipe_b_c_ivb
results: parsing output: 46/ for test: gem_exec_reloc
results: parsing output: 47/ for test: i915_pm_rpm
results: parsing output: 48/ for test: kms_pipe_crc_basic
results: parsing output: 49/ for test: kms_content_protection
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_exec_reloc
results: parsing output: 52/ for test: kms_psr2_sf
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: gem_mmap_gtt
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: api_intel_allocator
results: parsing output: 58/ for test: gem_pwrite
results: parsing output: 59/ for test: gem_exec_balancer
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_mmap_wc
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: gem_exec_parallel
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_exec_await
results: parsing output: 66/ for test: perf_pmu
results: parsing output: 67/ for test: kms_hdr
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: i915_drm_fdinfo
results: parsing output: 71/ for test: gem_exec_parallel
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_cursor_legacy
results: parsing output: 74/ for test: perf
results: parsing output: 75/ for test: kms_rotation_crc
results: parsing output: 76/ for test: gem_close_race
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_addfb_basic
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_hdmi_inject
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gem_exec_whisper
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_plane_multiple
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: gem_exec_create
results: parsing output: 89/ for test: gen9_exec_parse
results: parsing output: 90/ for test: gem_basic
results: parsing output: 91/ for test: kms_plane_scaling
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: gem_readwrite
results: parsing output: 97/ for test: drm_read
results: parsing output: 98/ for test: api_intel_bb
results: parsing output: 99/ for test: gem_mmap_gtt
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_fbcon_fbt
results: parsing output: 102/ for test: gem_exec_schedule
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: kms_cursor_crc
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: kms_cursor_crc
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: gem_exec_flush
results: parsing output: 109/ for test: gem_exec_flush
results: parsing output: 110/ for test: gem_exec_schedule
results: parsing output: 111/ for test: syncobj_eventfd
results: parsing output: 112/ for test: gem_exec_balancer
results: parsing output: 113/ for test: perf
results: parsing output: 114/ for test: kms_psr2_sf
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: syncobj_wait
results: parsing output: 117/ for test: kms_flip_scaled_crc
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: syncobj_wait
results: parsing output: 120/ for test: kms_getfb
results: parsing output: 121/ for test: i915_pm_freq_api
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_vblank
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: i915_query
results: parsing output: 126/ for test: gem_softpin
results: parsing output: 127/ for test: gem_userptr_blits
results: parsing output: 128/ for test: kms_vblank
results: parsing output: 129/ for test: kms_color_pipeline
results: parsing output: 130/ for test: kms_plane
results: parsing output: 131/ for test: dmabuf_sync_file
results: parsing output: 132/ for test: kms_flip
Done.