[59.049763] Initializing watchdogs [59.049811] /dev/watchdog0 [59.064852] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [59.069373] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.071641] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.073517] [001/133] (960s left) gem_exec_suspend (basic-s0) [59.140568] Starting subtest: basic-S0 [59.141689] Starting dynamic subtest: smem [79.823054] Dynamic subtest smem: SUCCESS (6.736s) [79.824435] Subtest basic-S0: SUCCESS (6.737s) [89.017110] [002/133] (939s left) kms_flip (2x-flip-vs-expired-vblank) [89.112949] Starting subtest: 2x-flip-vs-expired-vblank [89.124319] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s) [89.194358] [003/133] (939s left) kms_big_fb (4-tiled-16bpp-rotate-0) [89.299116] Starting subtest: 4-tiled-16bpp-rotate-0 [90.689017] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.390s) [90.817456] [004/133] (937s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu) [90.911004] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu [90.912693] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [90.995793] [005/133] (937s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling) [91.086911] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling [91.088486] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s) [91.155527] [006/133] (937s left) kms_chamelium_edid (dp-edid-read) [91.551732] Subtest dp-edid-read: SKIP (0.000s) [92.319296] [007/133] (936s left) kms_prop_blob (blob-prop-lifetime) [92.362383] Starting subtest: blob-prop-lifetime [92.363349] Subtest blob-prop-lifetime: SUCCESS (0.001s) [92.441907] [008/133] (936s left) kms_flip (flip-vs-wf_vblank-interruptible) [92.533758] Starting subtest: flip-vs-wf_vblank-interruptible [92.536777] Starting dynamic subtest: A-eDP1 [94.418298] Dynamic subtest A-eDP1: SUCCESS (1.882s) [94.428076] Starting dynamic subtest: B-eDP1 [96.353293] Dynamic subtest B-eDP1: SUCCESS (1.933s) [96.362718] Starting dynamic subtest: C-eDP1 [98.282977] Dynamic subtest C-eDP1: SUCCESS (1.927s) [98.293633] Starting dynamic subtest: D-eDP1 [100.215558] Dynamic subtest D-eDP1: SUCCESS (1.932s) [100.219165] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.685s) [101.443613] [009/133] (927s left) kms_psr (pr-suspend) [101.537585] Starting subtest: pr-suspend [101.539603] Subtest pr-suspend: SKIP (0.000s) [101.602707] [010/133] (927s left) kms_vblank (ts-continuation-modeset) [101.688589] Starting subtest: ts-continuation-modeset [101.689590] Starting dynamic subtest: pipe-A-eDP-1 [103.211943] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.524s) [103.220711] Starting dynamic subtest: pipe-D-eDP-1 [105.372745] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.159s) [105.373859] Subtest ts-continuation-modeset: SUCCESS (3.686s) [106.172901] [011/133] (922s left) syncobj_wait (multi-wait-submitted-signaled) [106.215281] Starting subtest: multi-wait-submitted-signaled [106.216229] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [106.312516] [012/133] (922s left) kms_flip (2x-nonexisting-fb) [106.408186] Starting subtest: 2x-nonexisting-fb [106.418593] Subtest 2x-nonexisting-fb: SKIP (0.011s) [106.495198] [013/133] (922s left) kms_chamelium_hpd (common-hpd-after-suspend) [106.880914] Subtest common-hpd-after-suspend: SKIP (0.000s) [107.681006] [014/133] (921s left) kms_plane_alpha_blend (alpha-basic) [107.765696] Starting subtest: alpha-basic [108.049194] Starting dynamic subtest: pipe-A-eDP-1 [109.961848] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.912s) [109.994776] Starting dynamic subtest: pipe-D-eDP-1 [112.688037] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.700s) [112.688933] Subtest alpha-basic: SUCCESS (4.924s) [113.562292] [015/133] (915s left) kms_content_protection (atomic-dpms-hdcp14) [113.701955] Starting subtest: atomic-dpms-hdcp14 [113.704386] Subtest atomic-dpms-hdcp14: SKIP (0.000s) [113.823725] [016/133] (915s left) kms_cursor_crc (cursor-offscreen-256x256) [114.062765] Starting subtest: cursor-offscreen-256x256 [114.065872] Starting dynamic subtest: pipe-A-eDP-1 [115.997750] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.931s) [116.026388] Starting dynamic subtest: pipe-D-eDP-1 [118.555732] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.536s) [118.556709] Subtest cursor-offscreen-256x256: SUCCESS (4.492s) [119.420553] [017/133] (909s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [119.514319] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt [119.516233] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [119.614397] [018/133] (909s left) gem_ctx_isolation (dirty-create) [119.667534] Starting subtest: dirty-create [119.668484] Starting dynamic subtest: rcs0 [119.844220] Dynamic subtest rcs0: SUCCESS (0.176s) [119.851388] Starting dynamic subtest: bcs0 [120.049165] Dynamic subtest bcs0: SUCCESS (0.204s) [120.058398] Starting dynamic subtest: vcs0 [120.263198] Dynamic subtest vcs0: SUCCESS (0.213s) [120.269705] Starting dynamic subtest: vcs1 [122.034965] Dynamic subtest vcs1: SUCCESS (1.771s) [122.041525] Starting dynamic subtest: vecs0 [124.031553] Dynamic subtest vecs0: SUCCESS (1.997s) [124.040570] Starting dynamic subtest: ccs0 [126.052238] Dynamic subtest ccs0: SUCCESS (2.021s) [126.053201] Subtest dirty-create: SUCCESS (6.386s) [126.301661] [019/133] (902s left) syncobj_wait (wait-any-interrupted) [126.352515] Starting subtest: wait-any-interrupted [126.455823] Subtest wait-any-interrupted: SUCCESS (0.102s) [126.527198] [020/133] (902s left) api_intel_allocator (fork-simple-stress-signal) [126.569217] Starting subtest: fork-simple-stress-signal [131.981004] Subtest fork-simple-stress-signal: SUCCESS (5.404s) [132.087069] [021/133] (897s left) kms_psr (fbc-psr-primary-page-flip) [132.191575] Starting subtest: fbc-psr-primary-page-flip [132.192601] Starting dynamic subtest: eDP-1 [132.194487] Dynamic subtest eDP-1: SKIP (0.000s) [132.196371] Subtest fbc-psr-primary-page-flip: SKIP (0.001s) [132.270565] [022/133] (896s left) kms_psr (fbc-psr2-primary-render) [132.368405] Starting subtest: fbc-psr2-primary-render [132.369451] Starting dynamic subtest: eDP-1 [132.371015] Dynamic subtest eDP-1: SKIP (0.000s) [132.372628] Subtest fbc-psr2-primary-render: SKIP (0.001s) [132.438736] [023/133] (896s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt) [132.549186] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt [140.230242] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.683s) [140.360647] [024/133] (888s left) kms_plane_multiple (tiling-yf) [140.438425] Starting subtest: tiling-yf [140.440151] Subtest tiling-yf: SKIP (0.000s) [140.505428] [025/133] (888s left) kms_addfb_basic (addfb25-y-tiled-legacy) [140.586486] Starting subtest: addfb25-y-tiled-legacy [140.587410] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [140.675059] [026/133] (888s left) i915_pm_rc6_residency (rc6-accuracy) [140.718036] Starting subtest: rc6-accuracy [140.718922] Starting dynamic subtest: gt0 [143.898319] Dynamic subtest gt0: SUCCESS (3.170s) [143.907429] Starting dynamic subtest: gt1 [147.105135] Dynamic subtest gt1: SUCCESS (3.169s) [147.106369] Subtest rc6-accuracy: SUCCESS (6.343s) [147.133837] [027/133] (882s left) syncobj_eventfd (binary-wait-before-signal) [147.181526] Starting subtest: binary-wait-before-signal [147.211442] Subtest binary-wait-before-signal: SUCCESS (0.030s) [147.277378] [028/133] (882s left) syncobj_basic (bad-handle-to-fd) [147.332360] Starting subtest: bad-handle-to-fd [147.333334] Subtest bad-handle-to-fd: SUCCESS (0.000s) [147.446842] [029/133] (882s left) gem_exec_balancer (invalid-bonds) [147.522261] Starting subtest: invalid-bonds [147.524431] Subtest invalid-bonds: SKIP (0.000s) [147.824453] [030/133] (881s left) gem_userptr_blits (mmap-offset-banned) [147.888105] Starting subtest: mmap-offset-banned [147.889269] Starting dynamic subtest: wb [147.890178] Dynamic subtest wb: SUCCESS (0.000s) [147.898250] Starting dynamic subtest: wc [147.899077] Dynamic subtest wc: SUCCESS (0.000s) [147.905832] Starting dynamic subtest: uc [147.906713] Dynamic subtest uc: SUCCESS (0.000s) [147.907577] Subtest mmap-offset-banned: SUCCESS (0.001s) [148.029799] [031/133] (881s left) gem_exec_reloc (basic-write-cpu) [148.092591] Subtest basic-write-cpu: SKIP (0.000s) [148.152105] [032/133] (881s left) kms_addfb_basic (too-high) [148.245194] Starting subtest: too-high [148.246043] Subtest too-high: SUCCESS (0.001s) [148.334594] [033/133] (881s left) perf (non-system-wide-paranoid) [148.448005] Starting subtest: non-system-wide-paranoid [148.473217] Subtest non-system-wide-paranoid: SUCCESS (0.025s) [148.514395] [034/133] (881s left) kms_chamelium_color (ctm-0-50) [148.600710] Subtest ctm-0-50: SKIP (0.000s) [148.638861] [035/133] (881s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite) [148.730576] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite [148.732324] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [148.822587] [036/133] (880s left) tools_test (tools_test) [148.857575] Starting subtest: tools_test [148.927205] Subtest tools_test: SUCCESS (0.076s) [148.997215] [037/133] (880s left) gem_ctx_exec (basic-close-race) [149.052339] Starting subtest: basic-close-race [154.709605] Subtest basic-close-race: SUCCESS (5.613s) [154.795149] [038/133] (874s left) perf (invalid-oa-format-id) [154.901647] Starting subtest: invalid-oa-format-id [154.921392] Subtest invalid-oa-format-id: SUCCESS (0.018s) [154.960923] [039/133] (874s left) kms_pm_rpm (basic-pci-d3-state) [156.990433] Starting subtest: basic-pci-d3-state [158.481535] Subtest basic-pci-d3-state: SUCCESS (1.492s) [158.576503] [040/133] (871s left) kms_psr (psr-primary-mmap-gtt) [158.668659] Starting subtest: psr-primary-mmap-gtt [158.669601] Starting dynamic subtest: eDP-1 [160.143368] Dynamic subtest eDP-1: SKIP (1.465s) [160.145289] Subtest psr-primary-mmap-gtt: SKIP (1.466s) [160.263603] [041/133] (869s left) gem_mmap_gtt (cpuset-big-copy) [160.312334] Subtest cpuset-big-copy: SKIP (0.000s) [160.372727] [042/133] (869s left) gem_mmap_gtt (zero-extend) [160.424405] Subtest zero-extend: SKIP (0.000s) [160.486824] [043/133] (869s left) kms_frontbuffer_tracking (psr-suspend) [160.580294] Starting subtest: psr-suspend [198.980341] Subtest psr-suspend: SUCCESS (8.697s) [205.101225] [044/133] (830s left) kms_debugfs (display-off-read-all) [205.199901] Starting subtest: display-off-read-all [205.489728] Subtest display-off-read-all: SUCCESS (0.291s) [206.287661] [045/133] (829s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc) [206.380160] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc [206.381981] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [206.472699] [046/133] (829s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [206.556221] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu [213.712283] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.154s) [213.812818] [047/133] (822s left) gem_exec_fence (long-history) [214.272547] Starting subtest: long-history [221.309285] Subtest long-history: SUCCESS (7.028s) [221.776572] [FACT gem_exec_fence (long-history)] new: kernel.kmod_is_loaded.vgem: true [221.778565] [048/133] (814s left) gem_ringfill (engines-basic) [227.543506] Starting subtest: engines-basic [227.544686] Starting dynamic subtest: rcs0 [227.606299] Dynamic subtest rcs0: SUCCESS (0.069s) [227.616726] Starting dynamic subtest: bcs0 [227.652475] Dynamic subtest bcs0: SUCCESS (0.044s) [227.663607] Starting dynamic subtest: vcs0 [227.694818] Dynamic subtest vcs0: SUCCESS (0.041s) [227.703903] Starting dynamic subtest: vcs1 [227.739020] Dynamic subtest vcs1: SUCCESS (0.042s) [227.748906] Starting dynamic subtest: vecs0 [227.782582] Dynamic subtest vecs0: SUCCESS (0.042s) [227.791671] Starting dynamic subtest: ccs0 [227.828499] Dynamic subtest ccs0: SUCCESS (0.044s) [227.829679] Subtest engines-basic: SUCCESS (0.293s) [227.903575] [049/133] (808s left) gem_exec_schedule (pi-common) [228.097394] Starting subtest: pi-common [228.098591] Starting dynamic subtest: rcs0 [228.120972] Dynamic subtest rcs0: SUCCESS (0.031s) [228.128549] Starting dynamic subtest: bcs0 [228.150353] Dynamic subtest bcs0: SUCCESS (0.029s) [228.157993] Starting dynamic subtest: vcs0 [228.180817] Dynamic subtest vcs0: SUCCESS (0.030s) [228.188673] Starting dynamic subtest: vcs1 [228.212054] Dynamic subtest vcs1: SUCCESS (0.031s) [228.219955] Starting dynamic subtest: vecs0 [228.243266] Dynamic subtest vecs0: SUCCESS (0.030s) [228.250940] Starting dynamic subtest: ccs0 [228.273658] Dynamic subtest ccs0: SUCCESS (0.030s) [228.274506] Subtest pi-common: SUCCESS (0.184s) [228.504643] [050/133] (807s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [228.601550] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [228.603380] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [228.682731] [051/133] (807s left) kms_vrr (negative-basic) [228.769242] Starting subtest: negative-basic [228.771903] Starting dynamic subtest: pipe-A-eDP-1 [234.233500] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.416s) [234.495002] Subtest negative-basic: SUCCESS (5.726s) [235.287803] [052/133] (800s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [235.386896] Starting subtest: fbc-psr2-plane-move-sf-dmg-area [235.387688] Starting dynamic subtest: pipe-A-eDP-1 [235.476045] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s) [235.484665] Starting dynamic subtest: pipe-B-eDP-1 [236.675087] Dynamic subtest pipe-B-eDP-1: SKIP (1.197s) [236.676728] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.289s) [237.868588] [053/133] (798s left) dmabuf_sync_file (import-multiple-read-only) [237.903380] Starting subtest: import-multiple-read-only [237.905670] Subtest import-multiple-read-only: SUCCESS (0.003s) [237.954720] [054/133] (798s left) i915_pm_freq_api (freq-reset-multiple) [238.007645] Starting subtest: freq-reset-multiple [238.008643] Starting dynamic subtest: gt0 [247.744473] Dynamic subtest gt0: SUCCESS (9.735s) [247.753408] Starting dynamic subtest: gt1 [256.381852] Dynamic subtest gt1: SUCCESS (8.624s) [256.383305] Subtest freq-reset-multiple: SUCCESS (18.361s) [256.443185] [055/133] (779s left) prime_busy (before-wait) [256.494852] Starting subtest: before-wait [256.497948] Starting dynamic subtest: rcs0 [256.536142] Dynamic subtest rcs0: SUCCESS (0.038s) [256.544241] Starting dynamic subtest: bcs0 [256.595067] Dynamic subtest bcs0: SUCCESS (0.058s) [256.602070] Starting dynamic subtest: vcs0 [256.637419] Dynamic subtest vcs0: SUCCESS (0.042s) [256.644445] Starting dynamic subtest: vcs1 [256.679929] Dynamic subtest vcs1: SUCCESS (0.041s) [256.689108] Starting dynamic subtest: vecs0 [256.720564] Dynamic subtest vecs0: SUCCESS (0.041s) [256.728967] Starting dynamic subtest: ccs0 [256.762491] Dynamic subtest ccs0: SUCCESS (0.041s) [256.870021] Subtest before-wait: SUCCESS (0.374s) [256.945326] [056/133] (779s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180) [257.050478] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180 [257.052232] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [257.142496] [057/133] (779s left) api_intel_bb (object-reloc-purge-cache) [257.191593] Starting subtest: object-reloc-purge-cache [257.195171] Subtest object-reloc-purge-cache: SKIP (0.004s) [257.318825] [058/133] (779s left) gem_partial_pwrite_pread (write) [257.366066] Subtest write: SKIP (0.000s) [257.432052] [059/133] (779s left) kms_big_fb (y-tiled-16bpp-rotate-90) [257.521691] Starting subtest: y-tiled-16bpp-rotate-90 [257.523351] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s) [257.630130] [060/133] (778s left) gem_mmap_wc (write-prefaulted) [257.686022] Subtest write-prefaulted: SKIP (0.000s) [257.739685] [061/133] (778s left) gem_exec_balancer (waits) [257.796738] Starting subtest: waits [264.409679] Subtest waits: SUCCESS (6.567s) [264.656084] [062/133] (771s left) gem_ctx_persistence (heartbeat-hostile) [264.727686] Starting subtest: heartbeat-hostile [264.729723] Subtest heartbeat-hostile: SKIP (0.000s) [264.842053] [063/133] (771s left) kms_setmode (invalid-clone-single-crtc) [264.893040] Starting subtest: invalid-clone-single-crtc [264.895646] Subtest invalid-clone-single-crtc: SKIP (0.000s) [265.003999] [064/133] (771s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt) [265.097407] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt [265.099021] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [265.216711] [065/133] (771s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [265.273007] Starting subtest: x-tiled-to-vebox-y-tiled [265.275085] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s) [265.448311] [066/133] (771s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw) [265.538397] Starting subtest: fbc-1p-pri-indfb-multidraw [278.504206] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (12.966s) [279.896925] [067/133] (756s left) kms_cursor_crc (cursor-rapid-movement-max-size) [280.227398] Starting subtest: cursor-rapid-movement-max-size [280.230028] Subtest cursor-rapid-movement-max-size: SKIP (0.000s) [280.371273] [068/133] (756s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt) [280.461695] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt [287.281952] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.821s) [287.391424] [069/133] (749s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip) [287.489449] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip [288.512564] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.023s) [288.628153] [070/133] (748s left) perf (short-reads) [288.720426] Starting subtest: short-reads [288.731999] Subtest short-reads: SUCCESS (0.011s) [288.772949] [071/133] (748s left) gem_exec_schedule (thriceslice) [288.835331] Starting subtest: thriceslice [288.836238] Starting dynamic subtest: rcs0 [288.863560] Dynamic subtest rcs0: SUCCESS (0.028s) [288.873223] Starting dynamic subtest: bcs0 [288.893079] Dynamic subtest bcs0: SUCCESS (0.028s) [288.900948] Starting dynamic subtest: vcs0 [288.943330] Dynamic subtest vcs0: SUCCESS (0.049s) [288.953742] Starting dynamic subtest: vcs1 [288.973360] Dynamic subtest vcs1: SUCCESS (0.029s) [288.980575] Starting dynamic subtest: vecs0 [289.003126] Dynamic subtest vecs0: SUCCESS (0.029s) [289.010853] Starting dynamic subtest: ccs0 [289.033974] Dynamic subtest ccs0: SUCCESS (0.030s) [289.035062] Subtest thriceslice: SUCCESS (0.199s) [289.332577] [072/133] (747s left) i915_pm_rps (thresholds-park) [289.393545] Starting subtest: thresholds-park [289.395346] Subtest thresholds-park: SKIP (0.000s) [289.486694] [073/133] (747s left) syncobj_timeline (single-wait-for-submit-available-submitted) [289.528234] Starting subtest: single-wait-for-submit-available-submitted [289.529112] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s) [289.616258] [074/133] (747s left) gem_mmap_wc (write-read) [289.658778] Subtest write-read: SKIP (0.000s) [289.721426] [075/133] (747s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [289.810296] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [289.811798] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [289.898439] [076/133] (747s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format) [289.985906] Starting subtest: plane-upscale-20x20-with-pixel-format [289.986802] Starting dynamic subtest: pipe-A [291.046338] Dynamic subtest pipe-A: SUCCESS (1.061s) [291.055282] Starting dynamic subtest: pipe-B [293.194211] Dynamic subtest pipe-B: SUCCESS (2.146s) [293.203934] Starting dynamic subtest: pipe-C [294.392240] Dynamic subtest pipe-C: SUCCESS (1.197s) [294.400672] Starting dynamic subtest: pipe-D [295.622019] Dynamic subtest pipe-D: SUCCESS (1.229s) [295.624059] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.638s) [296.820601] [077/133] (740s left) gem_userptr_blits (map-fixed-invalidate-busy) [296.881078] Starting subtest: map-fixed-invalidate-busy [296.882758] Subtest map-fixed-invalidate-busy: SKIP (0.000s) [296.992239] [078/133] (740s left) gem_mmap_gtt (basic-small-bo-tiledx) [297.033937] Subtest basic-small-bo-tiledX: SKIP (0.000s) [297.092540] [079/133] (740s left) gem_exec_flush (basic-wb-ro-before-default) [297.153163] Starting subtest: basic-wb-ro-before-default [302.604699] Subtest basic-wb-ro-before-default: SUCCESS (5.451s) [302.787658] [080/133] (734s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping) [302.882059] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping [302.884343] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s) [302.954281] [081/133] (734s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180) [303.043166] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180 [303.044945] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [303.131486] [082/133] (734s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt) [303.208623] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt [307.388179] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.180s) [308.532734] [083/133] (728s left) kms_flip (wf_vblank-ts-check-interruptible) [308.628386] Starting subtest: wf_vblank-ts-check-interruptible [308.631116] Starting dynamic subtest: A-eDP1 [317.579737] Dynamic subtest A-eDP1: SUCCESS (8.925s) [317.589606] Starting dynamic subtest: B-eDP1 [326.518959] Dynamic subtest B-eDP1: SUCCESS (8.937s) [326.528619] Starting dynamic subtest: C-eDP1 [335.452745] Dynamic subtest C-eDP1: SUCCESS (8.919s) [335.463012] Starting dynamic subtest: D-eDP1 [344.390547] Dynamic subtest D-eDP1: SUCCESS (8.934s) [344.391701] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.732s) [345.577999] [084/133] (691s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs) [345.670952] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs [345.671764] Starting dynamic subtest: pipe-A-eDP-1 [345.692247] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [345.700327] Starting dynamic subtest: pipe-B-eDP-1 [345.721250] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [345.728906] Starting dynamic subtest: pipe-C-eDP-1 [345.749520] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [345.756727] Starting dynamic subtest: pipe-D-eDP-1 [345.778076] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [345.779636] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s) [347.940480] [085/133] (689s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu) [348.053033] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu [348.054635] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [348.155652] [086/133] (689s left) kms_flip (absolute-wf_vblank-interruptible) [348.245258] Starting subtest: absolute-wf_vblank-interruptible [348.246156] Starting dynamic subtest: A-eDP1 [357.022690] Dynamic subtest A-eDP1: SUCCESS (8.752s) [357.032512] Starting dynamic subtest: B-eDP1 [365.757527] Dynamic subtest B-eDP1: SUCCESS (8.733s) [365.766925] Starting dynamic subtest: C-eDP1 [374.491068] Dynamic subtest C-eDP1: SUCCESS (8.718s) [374.500320] Starting dynamic subtest: D-eDP1 [383.191309] Dynamic subtest D-eDP1: SUCCESS (8.736s) [383.194774] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.952s) [384.399086] [087/133] (653s left) gem_lmem_swapping (heavy-verify-random) [384.436576] Subtest heavy-verify-random: SKIP (0.000s) [384.473181] [088/133] (652s left) perf_pmu (interrupts) [384.509670] Starting subtest: interrupts [385.601208] Subtest interrupts: SUCCESS (1.082s) [385.694908] [089/133] (651s left) kms_psr (psr2-cursor-render) [385.779108] Starting subtest: psr2-cursor-render [385.779933] Starting dynamic subtest: eDP-1 [387.498774] Dynamic subtest eDP-1: SUCCESS (1.719s) [387.499703] Subtest psr2-cursor-render: SUCCESS (1.720s) [388.385350] [090/133] (649s left) syncobj_wait (multi-wait-all-signaled) [388.440939] Starting subtest: multi-wait-all-signaled [388.441865] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [388.544778] [091/133] (649s left) gem_render_copy (y-tiled) [388.614470] Starting subtest: y-tiled [388.616631] Subtest y-tiled: SKIP (0.000s) [388.790596] [092/133] (648s left) kms_big_fb (x-tiled-32bpp-rotate-270) [388.878223] Starting subtest: x-tiled-32bpp-rotate-270 [388.898571] Subtest x-tiled-32bpp-rotate-270: SKIP (0.020s) [389.009690] [093/133] (648s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff) [389.105016] Starting subtest: psr-2p-primscrn-spr-indfb-onoff [389.106655] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [389.205044] [094/133] (648s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs) [389.290428] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs [389.291402] Starting dynamic subtest: pipe-A-eDP-1 [389.300270] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [389.308745] Starting dynamic subtest: pipe-B-eDP-1 [389.318718] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [389.326762] Starting dynamic subtest: pipe-C-eDP-1 [389.334707] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [389.342184] Starting dynamic subtest: pipe-D-eDP-1 [389.350483] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [389.352114] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s) [391.465121] [095/133] (646s left) sysfs_defaults (readonly) [391.523115] Starting subtest: readonly [391.524069] Starting dynamic subtest: vecs0 [391.524957] Dynamic subtest vecs0: SUCCESS (0.000s) [391.533584] Starting dynamic subtest: ccs0 [391.534460] Dynamic subtest ccs0: SUCCESS (0.000s) [391.542342] Starting dynamic subtest: vcs0 [391.543249] Dynamic subtest vcs0: SUCCESS (0.000s) [391.553554] Starting dynamic subtest: bcs0 [391.554449] Dynamic subtest bcs0: SUCCESS (0.000s) [391.561982] Starting dynamic subtest: rcs0 [391.562852] Dynamic subtest rcs0: SUCCESS (0.000s) [391.570743] Starting dynamic subtest: vcs1 [391.571788] Dynamic subtest vcs1: SUCCESS (0.000s) [391.572681] Subtest readonly: SUCCESS (0.006s) [391.622244] [096/133] (646s left) kms_plane (plane-position-hole) [391.708647] Starting subtest: plane-position-hole [392.210701] Starting dynamic subtest: pipe-A-plane-1 [393.494519] Dynamic subtest pipe-A-plane-1: SUCCESS (1.285s) [393.502995] Starting dynamic subtest: pipe-A-plane-2 [394.780389] Dynamic subtest pipe-A-plane-2: SUCCESS (1.285s) [394.788794] Starting dynamic subtest: pipe-A-plane-3 [396.121430] Dynamic subtest pipe-A-plane-3: SUCCESS (1.342s) [396.129758] Starting dynamic subtest: pipe-A-plane-4 [397.463263] Dynamic subtest pipe-A-plane-4: SUCCESS (1.340s) [397.471938] Starting dynamic subtest: pipe-A-plane-5 [397.489885] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s) [398.708663] Starting dynamic subtest: pipe-B-plane-1 [400.050277] Dynamic subtest pipe-B-plane-1: SUCCESS (1.349s) [400.058437] Starting dynamic subtest: pipe-B-plane-2 [401.354363] Dynamic subtest pipe-B-plane-2: SUCCESS (1.302s) [401.362547] Starting dynamic subtest: pipe-B-plane-3 [402.684390] Dynamic subtest pipe-B-plane-3: SUCCESS (1.330s) [402.697420] Starting dynamic subtest: pipe-B-plane-4 [404.041661] Dynamic subtest pipe-B-plane-4: SUCCESS (1.357s) [404.049694] Starting dynamic subtest: pipe-B-plane-5 [404.067383] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s) [404.068268] Subtest plane-position-hole: SUCCESS (12.359s) [404.891107] [097/133] (632s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen) [404.982117] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen [404.983779] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [405.062047] [098/133] (632s left) sw_sync (sync_merge_invalid) [405.097397] Starting subtest: sync_merge_invalid [405.110900] Subtest sync_merge_invalid: SUCCESS (0.014s) [405.176149] [099/133] (632s left) gem_gtt_cpu_tlb [405.291954] [100/133] (632s left) gem_softpin (allocator-evict) [405.357180] Starting subtest: allocator-evict [405.358165] Starting dynamic subtest: rcs0 [428.639664] Dynamic subtest rcs0: SUCCESS (23.281s) [428.650494] Starting dynamic subtest: bcs0 [452.552835] Dynamic subtest bcs0: SUCCESS (23.909s) [452.561626] Starting dynamic subtest: vcs0 [476.562747] Dynamic subtest vcs0: SUCCESS (24.006s) [476.571095] Starting dynamic subtest: vcs1 [500.286754] Dynamic subtest vcs1: SUCCESS (23.721s) [500.298456] Starting dynamic subtest: vecs0 [524.077091] Dynamic subtest vecs0: SUCCESS (23.787s) [524.088147] Starting dynamic subtest: ccs0 [548.263868] Dynamic subtest ccs0: SUCCESS (24.183s) [548.264719] Subtest allocator-evict: SUCCESS (142.897s) [548.354688] [101/133] (489s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [548.483959] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc [548.485018] Starting dynamic subtest: pipe-A-eDP-1 [548.493131] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [548.503277] Starting dynamic subtest: pipe-B-eDP-1 [548.510865] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [548.519394] Starting dynamic subtest: pipe-C-eDP-1 [548.526557] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [548.534985] Starting dynamic subtest: pipe-D-eDP-1 [548.542148] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [548.542898] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s) [550.745212] [102/133] (487s left) gem_eio (in-flight-immediate) [550.976885] Starting subtest: in-flight-immediate [559.471899] Subtest in-flight-immediate: SUCCESS (8.493s) [559.584432] [103/133] (478s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled) [559.634508] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [559.635528] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s) [559.725084] [104/133] (478s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling) [559.804184] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling [559.805069] Starting dynamic subtest: pipe-A-default-mode [562.608523] Dynamic subtest pipe-A-default-mode: SUCCESS (2.802s) [562.609609] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.804s) [563.422914] [105/133] (474s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area) [563.522239] Starting subtest: psr2-plane-move-sf-dmg-area [563.523051] Starting dynamic subtest: pipe-A-eDP-1 [568.081997] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.560s) [568.091718] Starting dynamic subtest: pipe-B-eDP-1 [573.420622] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.337s) [573.421499] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.900s) [574.277211] [106/133] (463s left) kms_big_fb (linear-64bpp-rotate-270) [574.378060] Starting subtest: linear-64bpp-rotate-270 [574.398241] Subtest linear-64bpp-rotate-270: SKIP (0.018s) [574.495882] [107/133] (463s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc) [574.586516] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc [574.587432] Starting dynamic subtest: pipe-A-eDP-1 [575.457250] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.867s) [575.465965] Starting dynamic subtest: pipe-B-eDP-1 [577.099609] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.641s) [577.108049] Starting dynamic subtest: pipe-C-eDP-1 [578.610692] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.502s) [578.619828] Starting dynamic subtest: pipe-D-eDP-1 [580.161302] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.557s) [580.162306] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.573s) [581.318442] [108/133] (456s left) sw_sync (alloc_merge_fence) [581.355857] Starting subtest: alloc_merge_fence [581.356865] Subtest alloc_merge_fence: SUCCESS (0.000s) [581.416166] [109/133] (456s left) i915_drm_fdinfo (most-busy-idle-check-all) [581.456880] Starting subtest: most-busy-idle-check-all [581.457958] Starting dynamic subtest: rcs0 [581.460820] Dynamic subtest rcs0: SKIP (0.003s) [581.469058] Starting dynamic subtest: bcs0 [581.470765] Dynamic subtest bcs0: SKIP (0.000s) [581.478792] Starting dynamic subtest: vcs0 [581.480683] Dynamic subtest vcs0: SKIP (0.000s) [581.488610] Starting dynamic subtest: vcs1 [581.490320] Dynamic subtest vcs1: SKIP (0.000s) [581.498460] Starting dynamic subtest: vecs0 [581.500152] Dynamic subtest vecs0: SKIP (0.000s) [581.508179] Starting dynamic subtest: ccs0 [581.509808] Dynamic subtest ccs0: SKIP (0.000s) [581.511577] Subtest most-busy-idle-check-all: SKIP (0.009s) [581.541327] [110/133] (456s left) kms_invalid_mode (zero-vdisplay) [581.627751] Starting subtest: zero-vdisplay [581.628606] Starting dynamic subtest: pipe-A-eDP-1 [581.925068] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s) [581.933441] Starting dynamic subtest: pipe-B-eDP-1 [581.934275] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [581.942258] Starting dynamic subtest: pipe-C-eDP-1 [581.943109] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [581.951045] Starting dynamic subtest: pipe-D-eDP-1 [581.951862] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [581.952975] Subtest zero-vdisplay: SUCCESS (0.303s) [582.748939] [111/133] (455s left) kms_frontbuffer_tracking (fbc-tiling-y) [582.851226] Starting subtest: fbc-tiling-y [582.852782] Subtest fbc-tiling-y: SKIP (0.000s) [582.942062] [112/133] (455s left) kms_pm_rpm (fences-dpms) [584.683784] Starting subtest: fences-dpms [584.686592] Subtest fences-dpms: SKIP (0.000s) [585.182613] [113/133] (453s left) kms_cursor_edge_walk (64x64-top-edge) [585.262892] Starting subtest: 64x64-top-edge [585.263688] Starting dynamic subtest: pipe-A-eDP-1 [588.744545] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.480s) [588.754380] Starting dynamic subtest: pipe-D-eDP-1 [591.878109] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.131s) [591.879053] Subtest 64x64-top-edge: SUCCESS (6.615s) [592.675756] [114/133] (445s left) gem_exec_params (rs-invalid) [592.733663] Starting subtest: rs-invalid [592.737553] Subtest rs-invalid: SUCCESS (0.003s) [592.867987] [115/133] (445s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt) [592.968727] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt [597.475194] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.506s) [598.682595] [116/133] (439s left) gem_tiled_blits (interruptible) [598.738074] Subtest interruptible: SKIP (0.000s) [598.805030] [117/133] (439s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled) [598.854378] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled [598.855295] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s) [598.950464] [118/133] (439s left) kms_lease (empty-lease) [599.038258] Starting subtest: empty-lease [599.039091] Starting dynamic subtest: pipe-A-eDP-1 [599.041150] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [599.049641] Starting dynamic subtest: pipe-B-eDP-1 [599.050445] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [599.058552] Starting dynamic subtest: pipe-C-eDP-1 [599.059389] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [599.067692] Starting dynamic subtest: pipe-D-eDP-1 [599.068566] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [599.069397] Subtest empty-lease: SUCCESS (0.010s) [599.165533] [119/133] (439s left) vgem_slow (nohang) [599.208210] Starting subtest: nohang [609.562734] Subtest nohang: SUCCESS (10.308s) [609.594664] [120/133] (428s left) syncobj_timeline (etime-single-wait-available-unsubmitted) [609.657441] Starting subtest: etime-single-wait-available-unsubmitted [609.761267] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.103s) [609.838961] [121/133] (428s left) gen9_exec_parse (allowed-all) [609.915590] Subtest allowed-all: SKIP (0.000s) [609.979732] [122/133] (428s left) perf_pmu (init-wait) [610.021180] Starting subtest: init-wait [610.022097] Starting dynamic subtest: rcs0 [610.024034] Dynamic subtest rcs0: SUCCESS (0.002s) [610.033941] Starting dynamic subtest: bcs0 [610.034767] Dynamic subtest bcs0: SUCCESS (0.000s) [610.043080] Starting dynamic subtest: vcs0 [610.043937] Dynamic subtest vcs0: SUCCESS (0.000s) [610.051997] Starting dynamic subtest: vcs1 [610.052823] Dynamic subtest vcs1: SUCCESS (0.001s) [610.061362] Starting dynamic subtest: vecs0 [610.062230] Dynamic subtest vecs0: SUCCESS (0.001s) [610.070781] Starting dynamic subtest: ccs0 [610.071659] Dynamic subtest ccs0: SUCCESS (0.000s) [610.072500] Subtest init-wait: SUCCESS (0.008s) [610.120872] [123/133] (428s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [610.194854] Starting subtest: y-tiled-ccs-to-y-tiled [610.196732] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s) [610.374671] [124/133] (428s left) gem_ccs (block-multicopy-inplace) [610.427719] Starting subtest: block-multicopy-inplace [610.429781] Subtest block-multicopy-inplace: SKIP (0.000s) [610.537030] [125/133] (428s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [610.634622] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [611.494018] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.859s) [611.672274] [126/133] (427s left) kms_sequence (get-forked-busy) [611.764068] Starting subtest: get-forked-busy [611.764895] Starting dynamic subtest: pipe-A-eDP-1 [613.700314] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.935s) [613.709220] Starting dynamic subtest: pipe-B-eDP-1 [616.311416] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.610s) [616.319797] Starting dynamic subtest: pipe-C-eDP-1 [618.900104] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.587s) [618.908774] Starting dynamic subtest: pipe-D-eDP-1 [621.519007] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.617s) [621.519725] Subtest get-forked-busy: SUCCESS (9.755s) [622.394354] [127/133] (416s left) gem_exec_create (basic) [622.446902] Starting subtest: basic [622.447745] Starting dynamic subtest: smem [626.581764] Dynamic subtest smem: SUCCESS (4.126s) [626.583312] Subtest basic: SUCCESS (4.128s) [626.754998] [128/133] (412s left) kms_feature_discovery (chamelium) [626.854925] Starting subtest: chamelium [626.856501] Subtest chamelium: SKIP (0.000s) [626.923903] [129/133] (411s left) kms_frontbuffer_tracking (fbc-suspend) [627.015268] Starting subtest: fbc-suspend [665.913298] Subtest fbc-suspend: SUCCESS (8.201s) [670.152831] [130/133] (371s left) kms_addfb_basic (basic) [670.207755] Starting subtest: basic [670.208560] Subtest basic: SUCCESS (0.000s) [670.338926] [131/133] (371s left) gem_exec_params (no-blt) [670.395021] Starting subtest: no-blt [670.397533] Subtest no-blt: SUCCESS (0.002s) [670.498844] [132/133] (371s left) kms_color (invalid-gamma-lut-sizes) [670.586864] Starting subtest: invalid-gamma-lut-sizes [670.587754] Starting dynamic subtest: pipe-A [670.876105] Dynamic subtest pipe-A: SUCCESS (0.289s) [670.884492] Starting dynamic subtest: pipe-B [670.885307] Dynamic subtest pipe-B: SUCCESS (0.000s) [670.893448] Starting dynamic subtest: pipe-C [670.894305] Dynamic subtest pipe-C: SUCCESS (0.000s) [670.902590] Starting dynamic subtest: pipe-D [670.903411] Dynamic subtest pipe-D: SUCCESS (0.000s) [670.904327] Subtest invalid-gamma-lut-sizes: SUCCESS (0.293s) [671.713780] [133/133] (370s left) gem_ctx_shared (exec-single-timeline) [671.766440] Starting subtest: exec-single-timeline [671.767421] Starting dynamic subtest: rcs0 [672.859813] Dynamic subtest rcs0: SUCCESS (1.082s) [672.874321] Starting dynamic subtest: bcs0 [673.947374] Dynamic subtest bcs0: SUCCESS (1.083s) [673.959762] Starting dynamic subtest: vcs0 [675.035452] Dynamic subtest vcs0: SUCCESS (1.084s) [675.047067] Starting dynamic subtest: vcs1 [676.123999] Dynamic subtest vcs1: SUCCESS (1.084s) [676.139175] Starting dynamic subtest: vecs0 [677.210979] Dynamic subtest vecs0: SUCCESS (1.083s) [677.224768] Starting dynamic subtest: ccs0 [678.300285] Dynamic subtest ccs0: SUCCESS (1.085s) [678.301632] Subtest exec-single-timeline: SUCCESS (6.517s) [679.268725] Closing watchdogs results: parsing output: 0/ for test: gem_exec_suspend results: parsing output: 1/ for test: kms_flip results: parsing output: 2/ for test: kms_big_fb results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: kms_flip_scaled_crc results: parsing output: 5/ for test: kms_chamelium_edid results: parsing output: 6/ for test: kms_prop_blob results: parsing output: 7/ for test: kms_flip results: parsing output: 8/ for test: kms_psr results: parsing output: 9/ for test: kms_vblank results: parsing output: 10/ for test: syncobj_wait results: parsing output: 11/ for test: kms_flip results: parsing output: 12/ for test: kms_chamelium_hpd results: parsing output: 13/ for test: kms_plane_alpha_blend results: parsing output: 14/ for test: kms_content_protection results: parsing output: 15/ for test: kms_cursor_crc results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: gem_ctx_isolation results: parsing output: 18/ for test: syncobj_wait results: parsing output: 19/ for test: api_intel_allocator results: parsing output: 20/ for test: kms_psr results: parsing output: 21/ for test: kms_psr results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_plane_multiple results: parsing output: 24/ for test: kms_addfb_basic results: parsing output: 25/ for test: i915_pm_rc6_residency results: parsing output: 26/ for test: syncobj_eventfd results: parsing output: 27/ for test: syncobj_basic results: parsing output: 28/ for test: gem_exec_balancer results: parsing output: 29/ for test: gem_userptr_blits results: parsing output: 30/ for test: gem_exec_reloc results: parsing output: 31/ for test: kms_addfb_basic results: parsing output: 32/ for test: perf results: parsing output: 33/ for test: kms_chamelium_color results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: tools_test results: parsing output: 36/ for test: gem_ctx_exec results: parsing output: 37/ for test: perf results: parsing output: 38/ for test: kms_pm_rpm results: parsing output: 39/ for test: kms_psr results: parsing output: 40/ for test: gem_mmap_gtt results: parsing output: 41/ for test: gem_mmap_gtt results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: kms_debugfs results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: gem_exec_fence results: parsing output: 47/ for test: gem_ringfill results: parsing output: 48/ for test: gem_exec_schedule results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: kms_vrr results: parsing output: 51/ for test: kms_psr2_sf results: parsing output: 52/ for test: dmabuf_sync_file results: parsing output: 53/ for test: i915_pm_freq_api results: parsing output: 54/ for test: prime_busy results: parsing output: 55/ for test: kms_big_fb results: parsing output: 56/ for test: api_intel_bb results: parsing output: 57/ for test: gem_partial_pwrite_pread results: parsing output: 58/ for test: kms_big_fb results: parsing output: 59/ for test: gem_mmap_wc results: parsing output: 60/ for test: gem_exec_balancer results: parsing output: 61/ for test: gem_ctx_persistence results: parsing output: 62/ for test: kms_setmode results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: gem_render_copy results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: kms_cursor_crc results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: kms_big_fb results: parsing output: 69/ for test: perf results: parsing output: 70/ for test: gem_exec_schedule results: parsing output: 71/ for test: i915_pm_rps results: parsing output: 72/ for test: syncobj_timeline results: parsing output: 73/ for test: gem_mmap_wc results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_plane_scaling results: parsing output: 76/ for test: gem_userptr_blits results: parsing output: 77/ for test: gem_mmap_gtt results: parsing output: 78/ for test: gem_exec_flush results: parsing output: 79/ for test: kms_plane results: parsing output: 80/ for test: kms_big_fb results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_flip results: parsing output: 83/ for test: kms_ccs results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_flip results: parsing output: 86/ for test: gem_lmem_swapping results: parsing output: 87/ for test: perf_pmu results: parsing output: 88/ for test: kms_psr results: parsing output: 89/ for test: syncobj_wait results: parsing output: 90/ for test: gem_render_copy results: parsing output: 91/ for test: kms_big_fb results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: kms_ccs results: parsing output: 94/ for test: sysfs_defaults results: parsing output: 95/ for test: kms_plane results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: sw_sync results: parsing output: 98/ for test: gem_gtt_cpu_tlb results: parsing output: 99/ for test: gem_softpin results: parsing output: 100/ for test: kms_ccs results: parsing output: 101/ for test: gem_eio results: parsing output: 102/ for test: syncobj_timeline results: parsing output: 103/ for test: kms_flip_scaled_crc results: parsing output: 104/ for test: kms_psr2_sf results: parsing output: 105/ for test: kms_big_fb results: parsing output: 106/ for test: kms_ccs results: parsing output: 107/ for test: sw_sync results: parsing output: 108/ for test: i915_drm_fdinfo results: parsing output: 109/ for test: kms_invalid_mode results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_pm_rpm results: parsing output: 112/ for test: kms_cursor_edge_walk results: parsing output: 113/ for test: gem_exec_params results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: gem_tiled_blits results: parsing output: 116/ for test: syncobj_timeline results: parsing output: 117/ for test: kms_lease results: parsing output: 118/ for test: vgem_slow results: parsing output: 119/ for test: syncobj_timeline results: parsing output: 120/ for test: gen9_exec_parse results: parsing output: 121/ for test: perf_pmu results: parsing output: 122/ for test: gem_render_copy results: parsing output: 123/ for test: gem_ccs results: parsing output: 124/ for test: kms_big_fb results: parsing output: 125/ for test: kms_sequence results: parsing output: 126/ for test: gem_exec_create results: parsing output: 127/ for test: kms_feature_discovery results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: kms_addfb_basic results: parsing output: 130/ for test: gem_exec_params results: parsing output: 131/ for test: kms_color results: parsing output: 132/ for test: gem_ctx_shared Done.