[73.680906] Initializing watchdogs [73.681124] /dev/watchdog0 [73.700892] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:0102 Intel Sandybridge (Gen6) 2nd Generation Core Processor Family Integrated Graphics Controller (XPS 8300) [73.709478] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [73.713196] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [73.716499] [001/133] (960s left) gem_exec_suspend (basic-s0) [73.824426] Starting subtest: basic-S0 [73.825262] Starting dynamic subtest: smem [90.245832] Dynamic subtest smem: SUCCESS (1.491s) [90.247367] Subtest basic-S0: SUCCESS (1.492s) [98.463183] [002/133] (943s left) kms_flip (2x-flip-vs-expired-vblank) [98.974575] Starting subtest: 2x-flip-vs-expired-vblank [98.975769] Starting dynamic subtest: AB-VGA1-HDMI-A1 [129.433245] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.536s) [129.434973] Subtest 2x-flip-vs-expired-vblank: SUCCESS (30.540s) [129.682925] [003/133] (912s left) kms_big_fb (4-tiled-16bpp-rotate-0) [130.191695] Starting subtest: 4-tiled-16bpp-rotate-0 [130.193351] Subtest 4-tiled-16bpp-rotate-0: SKIP (0.000s) [130.297162] [004/133] (912s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu) [130.784058] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu [130.785704] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [130.917914] [005/133] (911s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling) [130.973887] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s) [131.023846] [006/133] (911s left) kms_chamelium_edid (dp-edid-read) [131.621952] Subtest dp-edid-read: SKIP (0.000s) [131.839955] [007/133] (910s left) kms_prop_blob (blob-prop-lifetime) [131.904953] Starting subtest: blob-prop-lifetime [131.905721] Subtest blob-prop-lifetime: SUCCESS (0.001s) [131.993002] [008/133] (910s left) kms_flip (flip-vs-wf_vblank-interruptible) [132.490560] Starting subtest: flip-vs-wf_vblank-interruptible [132.491232] Starting dynamic subtest: A-VGA1 [133.545126] Dynamic subtest A-VGA1: SUCCESS (1.054s) [133.556829] Starting dynamic subtest: B-VGA1 [134.498910] Dynamic subtest B-VGA1: SUCCESS (0.953s) [134.510801] Starting dynamic subtest: A-HDMI-A1 [135.670399] Dynamic subtest A-HDMI-A1: SUCCESS (1.171s) [135.681678] Starting dynamic subtest: B-HDMI-A1 [136.871038] Dynamic subtest B-HDMI-A1: SUCCESS (1.200s) [136.872041] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (4.383s) [137.052051] [009/133] (905s left) kms_psr (pr-suspend) [137.539717] Subtest pr-suspend: SKIP (0.000s) [137.597198] [010/133] (905s left) kms_vblank (ts-continuation-modeset) [138.086398] Starting subtest: ts-continuation-modeset [138.087474] Starting dynamic subtest: pipe-A-VGA-1 [138.470641] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.384s) [138.485802] Starting dynamic subtest: pipe-A-HDMI-A-1 [138.887033] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.415s) [138.897684] Starting dynamic subtest: pipe-B-VGA-1 [139.140768] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.253s) [139.152957] Starting dynamic subtest: pipe-B-HDMI-A-1 [139.553093] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.411s) [139.554059] Subtest ts-continuation-modeset: SUCCESS (1.468s) [139.805954] [011/133] (902s left) syncobj_wait (multi-wait-submitted-signaled) [139.873838] Starting subtest: multi-wait-submitted-signaled [139.876117] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s) [139.965876] [012/133] (902s left) kms_flip (2x-nonexisting-fb) [140.446839] Starting subtest: 2x-nonexisting-fb [140.449594] Starting dynamic subtest: AB-VGA1-HDMI-A1 [140.836099] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (0.388s) [140.837303] Subtest 2x-nonexisting-fb: SUCCESS (0.390s) [141.090392] [013/133] (901s left) kms_chamelium_hpd (common-hpd-after-suspend) [141.680032] Subtest common-hpd-after-suspend: SKIP (0.000s) [141.881814] [014/133] (900s left) kms_plane_alpha_blend (alpha-basic) [142.362057] Starting subtest: alpha-basic [142.590818] Subtest alpha-basic: SKIP (0.229s) [142.946897] [015/133] (899s left) kms_content_protection (atomic-dpms-hdcp14) [143.463802] Starting subtest: atomic-dpms-hdcp14 [143.465428] Subtest atomic-dpms-hdcp14: SKIP (0.000s) [143.579715] [016/133] (899s left) kms_cursor_crc (cursor-offscreen-256x256) [144.070361] Starting subtest: cursor-offscreen-256x256 [144.096035] Starting dynamic subtest: pipe-A-VGA-1 [146.563843] Dynamic subtest pipe-A-VGA-1: SUCCESS (2.469s) [146.608934] Starting dynamic subtest: pipe-B-HDMI-A-1 [148.988620] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.390s) [148.989463] Subtest cursor-offscreen-256x256: SUCCESS (4.920s) [149.252918] [017/133] (893s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [149.750568] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt [149.752294] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [149.859796] [018/133] (893s left) gem_ctx_isolation (dirty-create) [149.929923] Starting subtest: dirty-create [149.930883] Starting dynamic subtest: rcs0 [150.487823] Dynamic subtest rcs0: SUCCESS (0.558s) [150.488707] Subtest dirty-create: SUCCESS (0.559s) [150.715386] [019/133] (892s left) syncobj_wait (wait-any-interrupted) [150.768304] Starting subtest: wait-any-interrupted [150.876640] Subtest wait-any-interrupted: SUCCESS (0.108s) [150.966982] [020/133] (892s left) api_intel_allocator (fork-simple-stress-signal) [151.020833] Starting subtest: fork-simple-stress-signal [156.464349] Subtest fork-simple-stress-signal: SUCCESS (5.445s) [156.553849] [021/133] (886s left) kms_psr (fbc-psr-primary-page-flip) [157.041577] Subtest fbc-psr-primary-page-flip: SKIP (0.000s) [157.095173] [022/133] (886s left) kms_psr (fbc-psr2-primary-render) [157.587916] Subtest fbc-psr2-primary-render: SKIP (0.000s) [157.648034] [023/133] (885s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt) [158.141286] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt [158.142887] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [158.253761] [024/133] (885s left) kms_plane_multiple (tiling-yf) [158.737342] Starting subtest: tiling-yf [158.739381] Subtest tiling-yf: SKIP (0.000s) [158.828619] [025/133] (884s left) kms_addfb_basic (addfb25-y-tiled-legacy) [159.322511] Starting subtest: addfb25-y-tiled-legacy [159.323393] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [159.427693] [026/133] (883s left) i915_pm_rc6_residency (rc6-accuracy) [159.486984] Starting subtest: rc6-accuracy [159.487853] Starting dynamic subtest: gt0 [162.657195] Dynamic subtest gt0: SUCCESS (3.169s) [162.658241] Subtest rc6-accuracy: SUCCESS (3.171s) [162.753402] [027/133] (880s left) syncobj_eventfd (binary-wait-before-signal) [162.813866] Starting subtest: binary-wait-before-signal [162.844651] Subtest binary-wait-before-signal: SUCCESS (0.031s) [162.932654] [028/133] (880s left) syncobj_basic (bad-handle-to-fd) [162.988818] Starting subtest: bad-handle-to-fd [162.989681] Subtest bad-handle-to-fd: SUCCESS (0.000s) [163.086074] [029/133] (880s left) gem_exec_balancer (invalid-bonds) [163.147443] Subtest invalid-bonds: SKIP (0.000s) [163.231922] [030/133] (880s left) gem_userptr_blits (mmap-offset-banned) [163.303244] Starting subtest: mmap-offset-banned [163.304194] Starting dynamic subtest: gtt [163.305036] Dynamic subtest gtt: SUCCESS (0.000s) [163.316503] Starting dynamic subtest: wb [163.317475] Dynamic subtest wb: SUCCESS (0.000s) [163.329338] Starting dynamic subtest: wc [163.330072] Dynamic subtest wc: SUCCESS (0.000s) [163.345360] Starting dynamic subtest: uc [163.346457] Dynamic subtest uc: SUCCESS (0.000s) [163.347355] Subtest mmap-offset-banned: SUCCESS (0.003s) [163.420295] [031/133] (880s left) gem_exec_reloc (basic-write-cpu) [163.480786] Starting subtest: basic-write-cpu [163.483827] Subtest basic-write-cpu: SUCCESS (0.003s) [164.001860] [032/133] (879s left) kms_addfb_basic (too-high) [164.489358] Starting subtest: too-high [164.491548] Subtest too-high: SUCCESS (0.002s) [164.618742] [033/133] (879s left) perf (non-system-wide-paranoid) [164.749917] Subtest non-system-wide-paranoid: SKIP (0.000s) [164.807001] [034/133] (878s left) kms_chamelium_color (ctm-0-50) [165.286664] Subtest ctm-0-50: SKIP (0.000s) [165.348227] [035/133] (878s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite) [165.839288] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite [165.841070] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [165.946535] [036/133] (877s left) tools_test (tools_test) [166.013906] Starting subtest: tools_test [166.134034] Subtest tools_test: SUCCESS (0.127s) [166.210848] [037/133] (877s left) gem_ctx_exec (basic-close-race) [166.274657] Starting subtest: basic-close-race [171.769202] Subtest basic-close-race: SUCCESS (5.496s) [171.885657] [038/133] (872s left) perf (invalid-oa-format-id) [172.016431] Subtest invalid-oa-format-id: SKIP (0.000s) [172.073565] [039/133] (871s left) kms_pm_rpm (basic-pci-d3-state) [183.847634] Subtest basic-pci-d3-state: SKIP (0.000s) [183.911191] [040/133] (860s left) kms_psr (psr-primary-mmap-gtt) [184.398262] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [184.461675] [041/133] (859s left) gem_mmap_gtt (cpuset-big-copy) [184.518094] Starting subtest: cpuset-big-copy [187.785091] Subtest cpuset-big-copy: SUCCESS (3.267s) [188.097486] [042/133] (856s left) gem_mmap_gtt (zero-extend) [188.256029] Starting subtest: zero-extend [188.257158] Subtest zero-extend: SUCCESS (0.000s) [188.366042] [043/133] (855s left) kms_frontbuffer_tracking (psr-suspend) [188.865125] Starting subtest: psr-suspend [188.866467] Subtest psr-suspend: SKIP (0.000s) [188.972360] [044/133] (855s left) kms_debugfs (display-off-read-all) [189.458976] Starting subtest: display-off-read-all [189.579897] Subtest display-off-read-all: SUCCESS (0.121s) [189.817296] [045/133] (854s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc) [190.305205] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc [191.759841] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SUCCESS (1.454s) [191.918238] [046/133] (852s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [192.412298] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu [192.413720] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [192.540696] [047/133] (851s left) gem_exec_fence (long-history) [192.789424] Starting subtest: long-history [192.859107] Subtest long-history: SUCCESS (0.071s) [193.192149] [FACT gem_exec_fence (long-history)] new: kernel.kmod_is_loaded.vgem: true [193.195588] [048/133] (851s left) gem_ringfill (engines-basic) [193.361393] Starting subtest: engines-basic [193.362369] Starting dynamic subtest: rcs0 [193.387562] Dynamic subtest rcs0: SUCCESS (0.026s) [193.403834] Starting dynamic subtest: bcs0 [193.406567] Dynamic subtest bcs0: SUCCESS (0.017s) [193.407783] Subtest engines-basic: SUCCESS (0.047s) [193.510163] [049/133] (850s left) gem_exec_schedule (pi-common) [193.582207] Subtest pi-common: SKIP (0.000s) [193.781698] [050/133] (850s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [194.265124] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [194.267112] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [194.371602] [051/133] (850s left) kms_vrr (negative-basic) [194.861284] Starting subtest: negative-basic [194.865120] Subtest negative-basic: SKIP (0.000s) [194.955570] [052/133] (849s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [195.443822] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s) [195.501037] [053/133] (849s left) dmabuf_sync_file (import-multiple-read-only) [195.574508] Starting subtest: import-multiple-read-only [195.580879] Subtest import-multiple-read-only: SUCCESS (0.009s) [195.657351] [054/133] (849s left) i915_pm_freq_api (freq-reset-multiple) [195.715070] Subtest freq-reset-multiple: SKIP (0.000s) [195.783189] [055/133] (848s left) prime_busy (before-wait) [195.847162] Starting subtest: before-wait [195.854813] Starting dynamic subtest: rcs0 [195.871752] Dynamic subtest rcs0: SUCCESS (0.017s) [195.888211] Starting dynamic subtest: bcs0 [195.889079] Dynamic subtest bcs0: SUCCESS (0.015s) [195.902570] Starting dynamic subtest: vcs0 [195.903421] Dynamic subtest vcs0: SUCCESS (0.014s) [196.012897] Subtest before-wait: SUCCESS (0.164s) [196.108594] [056/133] (848s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180) [196.601987] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180 [196.604084] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [196.705447] [057/133] (848s left) api_intel_bb (object-reloc-purge-cache) [196.765522] Starting subtest: object-reloc-purge-cache [196.768848] Subtest object-reloc-purge-cache: SUCCESS (0.004s) [196.892540] [058/133] (848s left) gem_partial_pwrite_pread (write) [196.952086] Starting subtest: write [200.825642] Subtest write: SUCCESS (3.872s) [200.950087] [059/133] (844s left) kms_big_fb (y-tiled-16bpp-rotate-90) [201.445763] Starting subtest: y-tiled-16bpp-rotate-90 [201.447426] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s) [201.565572] [060/133] (843s left) gem_mmap_wc (write-prefaulted) [201.629694] Starting subtest: write-prefaulted [201.772886] Subtest write-prefaulted: SUCCESS (0.143s) [201.877564] [061/133] (843s left) gem_exec_balancer (waits) [201.943228] Subtest waits: SKIP (0.000s) [202.042420] [062/133] (843s left) gem_ctx_persistence (heartbeat-hostile) [202.107040] Subtest heartbeat-hostile: SKIP (0.000s) [202.171547] [063/133] (843s left) kms_setmode (invalid-clone-single-crtc) [202.230467] Starting subtest: invalid-clone-single-crtc [202.452881] Subtest invalid-clone-single-crtc: SKIP (0.222s) [202.718047] [064/133] (842s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt) [203.209074] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt [203.211466] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [203.318541] [065/133] (841s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [203.387030] Starting subtest: x-tiled-to-vebox-y-tiled [203.389222] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s) [203.600252] [066/133] (841s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw) [204.083162] Starting subtest: fbc-1p-pri-indfb-multidraw [218.210715] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (14.126s) [218.486061] [067/133] (826s left) kms_cursor_crc (cursor-rapid-movement-max-size) [218.988752] Starting subtest: cursor-rapid-movement-max-size [218.991335] Subtest cursor-rapid-movement-max-size: SKIP (0.000s) [219.100877] [068/133] (826s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt) [219.587634] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt [219.589285] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [219.699756] [069/133] (825s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip) [220.189992] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip [220.191648] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [220.304322] [070/133] (825s left) perf (short-reads) [220.492775] Subtest short-reads: SKIP (0.000s) [220.556920] [071/133] (825s left) gem_exec_schedule (thriceslice) [220.625056] Subtest thriceslice: SKIP (0.000s) [220.829313] [072/133] (824s left) i915_pm_rps (thresholds-park) [220.894609] Starting subtest: thresholds-park [220.895529] Starting dynamic subtest: gt0 [235.624331] Dynamic subtest gt0: SUCCESS (14.730s) [235.625713] Subtest thresholds-park: SUCCESS (14.732s) [235.732008] [073/133] (809s left) syncobj_timeline (single-wait-for-submit-available-submitted) [235.793726] Starting subtest: single-wait-for-submit-available-submitted [235.794586] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.001s) [235.898317] [074/133] (809s left) gem_mmap_wc (write-read) [235.956193] Starting subtest: write-read [235.970399] Subtest write-read: SUCCESS (0.015s) [236.098601] [075/133] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [236.583366] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [236.585363] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [236.697341] [076/133] (809s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format) [237.176734] Starting subtest: plane-upscale-20x20-with-pixel-format [237.177683] Starting dynamic subtest: pipe-A [237.180495] Dynamic subtest pipe-A: SKIP (0.002s) [237.194002] Starting dynamic subtest: pipe-B [237.197789] Dynamic subtest pipe-B: SKIP (0.002s) [237.199841] Subtest plane-upscale-20x20-with-pixel-format: SKIP (0.006s) [237.282374] [077/133] (808s left) gem_userptr_blits (map-fixed-invalidate-busy) [237.362396] Starting subtest: map-fixed-invalidate-busy [237.363541] Starting dynamic subtest: gtt [238.370962] Dynamic subtest gtt: SUCCESS (1.008s) [238.384621] Starting dynamic subtest: wb [239.356670] Dynamic subtest wb: SUCCESS (0.985s) [239.369856] Starting dynamic subtest: wc [240.334189] Dynamic subtest wc: SUCCESS (0.975s) [240.348137] Starting dynamic subtest: uc [241.310115] Dynamic subtest uc: SUCCESS (0.976s) [241.311028] Subtest map-fixed-invalidate-busy: SUCCESS (3.949s) [241.447409] [078/133] (804s left) gem_mmap_gtt (basic-small-bo-tiledx) [241.505587] Starting subtest: basic-small-bo-tiledX [241.768234] Subtest basic-small-bo-tiledX: SUCCESS (0.263s) [241.908375] [079/133] (804s left) gem_exec_flush (basic-wb-ro-before-default) [242.087109] Starting subtest: basic-wb-ro-before-default [247.535157] Subtest basic-wb-ro-before-default: SUCCESS (5.449s) [247.739661] [080/133] (798s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping) [248.234625] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping [248.236858] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s) [248.336824] [081/133] (797s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180) [248.837715] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180 [248.839651] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.002s) [248.948512] [082/133] (797s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt) [249.438406] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt [250.923813] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (1.486s) [251.161506] [083/133] (795s left) kms_flip (wf_vblank-ts-check-interruptible) [251.647177] Starting subtest: wf_vblank-ts-check-interruptible [251.649897] Starting dynamic subtest: A-VGA1 [259.791130] Dynamic subtest A-VGA1: SUCCESS (8.144s) [259.806278] Starting dynamic subtest: B-VGA1 [267.761126] Dynamic subtest B-VGA1: SUCCESS (7.970s) [267.776450] Starting dynamic subtest: A-HDMI-A1 [275.915886] Dynamic subtest A-HDMI-A1: SUCCESS (8.154s) [275.930752] Starting dynamic subtest: B-HDMI-A1 [284.112343] Dynamic subtest B-HDMI-A1: SUCCESS (8.190s) [284.115137] Subtest wf_vblank-ts-check-interruptible: SUCCESS (32.470s) [284.294428] [084/133] (762s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs) [284.355866] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.000s) [284.418433] [085/133] (761s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu) [284.899727] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu [286.399851] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SUCCESS (1.501s) [286.554642] [086/133] (759s left) kms_flip (absolute-wf_vblank-interruptible) [287.038581] Starting subtest: absolute-wf_vblank-interruptible [287.040656] Starting dynamic subtest: A-VGA1 [294.830419] Dynamic subtest A-VGA1: SUCCESS (7.792s) [294.845167] Starting dynamic subtest: B-VGA1 [302.544037] Dynamic subtest B-VGA1: SUCCESS (7.713s) [302.560713] Starting dynamic subtest: A-HDMI-A1 [310.405149] Dynamic subtest A-HDMI-A1: SUCCESS (7.860s) [310.418267] Starting dynamic subtest: B-HDMI-A1 [318.304564] Dynamic subtest B-HDMI-A1: SUCCESS (7.899s) [318.305640] Subtest absolute-wf_vblank-interruptible: SUCCESS (31.275s) [318.504594] [087/133] (727s left) gem_lmem_swapping (heavy-verify-random) [318.577897] Subtest heavy-verify-random: SKIP (0.000s) [318.630611] [088/133] (727s left) perf_pmu (interrupts) [318.690793] Starting subtest: interrupts [319.739482] Subtest interrupts: SUCCESS (1.048s) [319.853231] [089/133] (726s left) kms_psr (psr2-cursor-render) [320.331427] Subtest psr2-cursor-render: SKIP (0.000s) [320.397367] [090/133] (726s left) syncobj_wait (multi-wait-all-signaled) [320.459184] Starting subtest: multi-wait-all-signaled [320.460540] Subtest multi-wait-all-signaled: SUCCESS (0.001s) [320.561793] [091/133] (726s left) gem_render_copy (y-tiled) [320.632310] Starting subtest: y-tiled [320.633305] Starting dynamic subtest: smem [320.698109] Dynamic subtest smem: SUCCESS (0.065s) [320.698966] Subtest y-tiled: SUCCESS (0.067s) [320.915618] [092/133] (725s left) kms_big_fb (x-tiled-32bpp-rotate-270) [321.401680] Starting subtest: x-tiled-32bpp-rotate-270 [321.498661] Subtest x-tiled-32bpp-rotate-270: SKIP (0.097s) [321.757933] [093/133] (725s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff) [322.249310] Starting subtest: psr-2p-primscrn-spr-indfb-onoff [322.250954] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [322.352604] [094/133] (724s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs) [322.408226] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.000s) [322.464643] [095/133] (724s left) sysfs_defaults (readonly) [322.523602] Starting subtest: readonly [322.525764] Starting dynamic subtest: vcs0 [322.526620] Dynamic subtest vcs0: SUCCESS (0.000s) [322.541360] Starting dynamic subtest: bcs0 [322.542631] Dynamic subtest bcs0: SUCCESS (0.001s) [322.557707] Starting dynamic subtest: rcs0 [322.559061] Dynamic subtest rcs0: SUCCESS (0.000s) [322.560121] Subtest readonly: SUCCESS (0.006s) [322.618409] [096/133] (724s left) kms_plane (plane-position-hole) [323.090726] Starting subtest: plane-position-hole [323.425717] Starting dynamic subtest: pipe-A-plane-1 [323.780836] Dynamic subtest pipe-A-plane-1: SUCCESS (0.355s) [323.794881] Starting dynamic subtest: pipe-A-plane-2 [323.796426] Dynamic subtest pipe-A-plane-2: SUCCESS (0.005s) [324.094717] Starting dynamic subtest: pipe-B-plane-1 [324.516677] Dynamic subtest pipe-B-plane-1: SUCCESS (0.428s) [324.530620] Starting dynamic subtest: pipe-B-plane-2 [324.532983] Dynamic subtest pipe-B-plane-2: SUCCESS (0.011s) [324.534323] Subtest plane-position-hole: SUCCESS (1.435s) [324.783454] [097/133] (722s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen) [325.267830] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen [325.269326] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [325.382562] [098/133] (721s left) sw_sync (sync_merge_invalid) [325.442268] Starting subtest: sync_merge_invalid [325.446623] Subtest sync_merge_invalid: SUCCESS (0.006s) [325.513702] [099/133] (721s left) gem_gtt_cpu_tlb [325.681812] [100/133] (721s left) gem_softpin (allocator-evict) [325.747863] Subtest allocator-evict: SKIP (0.000s) [325.858775] [101/133] (721s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [325.912740] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s) [325.981279] [102/133] (721s left) gem_eio (in-flight-immediate) [326.051404] Starting subtest: in-flight-immediate [327.429442] Subtest in-flight-immediate: SUCCESS (1.377s) [327.949463] [103/133] (719s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled) [328.013470] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [328.014159] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s) [328.112688] [104/133] (719s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling) [328.173580] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SKIP (0.000s) [328.243763] [105/133] (719s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area) [328.723480] Subtest psr2-plane-move-sf-dmg-area: SKIP (0.000s) [328.790669] [106/133] (718s left) kms_big_fb (linear-64bpp-rotate-270) [329.279640] Starting subtest: linear-64bpp-rotate-270 [329.365337] Subtest linear-64bpp-rotate-270: SKIP (0.083s) [329.601654] [107/133] (717s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc) [329.666364] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s) [329.730751] [108/133] (717s left) sw_sync (alloc_merge_fence) [329.786150] Starting subtest: alloc_merge_fence [329.786969] Subtest alloc_merge_fence: SUCCESS (0.000s) [329.872588] [109/133] (717s left) i915_drm_fdinfo (most-busy-idle-check-all) [329.934583] Subtest most-busy-idle-check-all: SKIP (0.000s) [329.994811] [110/133] (717s left) kms_invalid_mode (zero-vdisplay) [330.475155] Starting subtest: zero-vdisplay [330.476141] Starting dynamic subtest: pipe-A-VGA-1 [330.597847] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.125s) [330.616329] Starting dynamic subtest: pipe-A-HDMI-A-1 [330.617637] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s) [330.635275] Starting dynamic subtest: pipe-B-VGA-1 [330.636173] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.000s) [330.652915] Starting dynamic subtest: pipe-B-HDMI-A-1 [330.653788] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s) [330.654616] Subtest zero-vdisplay: SUCCESS (0.135s) [330.864435] [111/133] (716s left) kms_frontbuffer_tracking (fbc-tiling-y) [331.345660] Starting subtest: fbc-tiling-y [331.347336] Subtest fbc-tiling-y: SKIP (0.000s) [331.465449] [112/133] (716s left) kms_pm_rpm (fences-dpms) [343.232548] Subtest fences-dpms: SKIP (0.000s) [343.300624] [113/133] (704s left) kms_cursor_edge_walk (64x64-top-edge) [343.794098] Starting subtest: 64x64-top-edge [343.795002] Starting dynamic subtest: pipe-A-VGA-1 [347.187773] Dynamic subtest pipe-A-VGA-1: SUCCESS (3.392s) [347.203290] Starting dynamic subtest: pipe-B-HDMI-A-1 [350.518526] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.329s) [350.519236] Subtest 64x64-top-edge: SUCCESS (6.726s) [350.785387] [114/133] (697s left) gem_exec_params (rs-invalid) [350.852409] Starting subtest: rs-invalid [350.854697] Subtest rs-invalid: SUCCESS (0.002s) [350.991862] [115/133] (697s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt) [351.467692] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt [353.319140] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (1.850s) [353.562385] [116/133] (694s left) gem_tiled_blits (interruptible) [353.782090] Starting subtest: interruptible [361.152900] Subtest interruptible: SUCCESS (7.370s) [361.250702] [117/133] (686s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled) [361.428244] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled [361.431135] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s) [361.529134] [118/133] (686s left) kms_lease (empty-lease) [362.022248] Starting subtest: empty-lease [362.023166] Starting dynamic subtest: pipe-A-VGA-1 [362.023900] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.001s) [362.040959] Starting dynamic subtest: pipe-A-HDMI-A-1 [362.043054] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s) [362.058253] Starting dynamic subtest: pipe-B-VGA-1 [362.062229] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.000s) [362.076712] Starting dynamic subtest: pipe-B-HDMI-A-1 [362.077780] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s) [362.078934] Subtest empty-lease: SUCCESS (0.013s) [362.130057] [119/133] (686s left) vgem_slow (nohang) [362.199635] Starting subtest: nohang [372.406962] Subtest nohang: SUCCESS (10.207s) [372.500030] [120/133] (675s left) syncobj_timeline (etime-single-wait-available-unsubmitted) [372.562400] Starting subtest: etime-single-wait-available-unsubmitted [372.668592] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.106s) [372.773868] [121/133] (675s left) gen9_exec_parse (allowed-all) [372.835830] Subtest allowed-all: SKIP (0.000s) [372.899915] [122/133] (675s left) perf_pmu (init-wait) [372.964196] Starting subtest: init-wait [372.965579] Starting dynamic subtest: rcs0 [372.966388] Dynamic subtest rcs0: SUCCESS (0.001s) [372.982839] Starting dynamic subtest: bcs0 [372.984056] Dynamic subtest bcs0: SUCCESS (0.000s) [372.999567] Starting dynamic subtest: vcs0 [373.000747] Dynamic subtest vcs0: SUCCESS (0.000s) [373.001848] Subtest init-wait: SUCCESS (0.006s) [373.072456] [123/133] (675s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [373.139326] Starting subtest: y-tiled-ccs-to-y-tiled [373.140404] Starting dynamic subtest: smem [373.142363] Dynamic subtest smem: SKIP (0.000s) [373.144357] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.002s) [373.349601] [124/133] (675s left) gem_ccs (block-multicopy-inplace) [373.411615] Subtest block-multicopy-inplace: SKIP (0.000s) [373.484820] [125/133] (675s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [373.973631] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [373.977073] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.002s) [374.084413] [126/133] (674s left) kms_sequence (get-forked-busy) [374.560797] Starting subtest: get-forked-busy [374.562661] Starting dynamic subtest: pipe-A-VGA-1 [377.079652] Dynamic subtest pipe-A-VGA-1: SUCCESS (2.517s) [377.095396] Starting dynamic subtest: pipe-A-HDMI-A-1 [379.520407] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.439s) [379.536327] Starting dynamic subtest: pipe-B-VGA-1 [381.885263] Dynamic subtest pipe-B-VGA-1: SUCCESS (2.362s) [381.901982] Starting dynamic subtest: pipe-B-HDMI-A-1 [384.344027] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.456s) [384.344975] Subtest get-forked-busy: SUCCESS (9.784s) [384.593295] [127/133] (664s left) gem_exec_create (basic) [384.664121] Starting subtest: basic [384.665232] Starting dynamic subtest: smem [386.711212] Dynamic subtest smem: SUCCESS (2.046s) [386.714900] Subtest basic: SUCCESS (2.049s) [386.919826] [128/133] (661s left) kms_feature_discovery (chamelium) [387.396608] Starting subtest: chamelium [387.398699] Subtest chamelium: SKIP (0.000s) [387.501914] [129/133] (661s left) kms_frontbuffer_tracking (fbc-suspend) [387.997225] Starting subtest: fbc-suspend [425.086519] Subtest fbc-suspend: SUCCESS (4.423s) [430.334332] [130/133] (623s left) kms_addfb_basic (basic) [430.414348] Starting subtest: basic [430.415034] Subtest basic: SUCCESS (0.000s) [430.960944] [131/133] (622s left) gem_exec_params (no-blt) [431.022441] Starting subtest: no-blt [431.023349] Subtest no-blt: SUCCESS (0.000s) [431.140203] [132/133] (622s left) kms_color (invalid-gamma-lut-sizes) [431.626659] Starting subtest: invalid-gamma-lut-sizes [431.627677] Starting dynamic subtest: pipe-A [431.726687] Dynamic subtest pipe-A: SUCCESS (0.096s) [431.747916] Starting dynamic subtest: pipe-B [431.748775] Dynamic subtest pipe-B: SUCCESS (0.001s) [431.749542] Subtest invalid-gamma-lut-sizes: SUCCESS (0.100s) [432.002110] [133/133] (621s left) gem_ctx_shared (exec-single-timeline) [432.066956] Subtest exec-single-timeline: SKIP (0.000s) [432.167641] 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.