[73.176218] Initializing watchdogs [73.176333] /dev/watchdog0 [73.194331] [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.201298] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [73.204857] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [73.208090] [001/132] (960s left) gem_blits (basic) [73.852213] Starting subtest: basic [75.736951] Subtest basic: SUCCESS (1.886s) [75.851362] [002/132] (957s left) syncobj_wait (multi-wait-all-for-submit-submitted) [75.919444] Starting subtest: multi-wait-all-for-submit-submitted [76.022828] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.103s) [76.114753] [003/132] (957s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled) [76.189576] Starting subtest: yf-tiled-ccs-to-yf-tiled [76.190862] Starting dynamic subtest: smem [76.192884] Dynamic subtest smem: SKIP (0.000s) [76.194376] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s) [76.381811] [004/132] (957s left) kms_vblank (invalid) [76.752289] Starting subtest: invalid [76.753255] Starting dynamic subtest: pipe-A-HDMI-A-1 [77.107860] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.356s) [77.108678] Subtest invalid: SUCCESS (0.357s) [77.653919] [005/132] (956s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt) [78.042952] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt [78.044392] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [78.479048] [006/132] (955s left) kms_setmode (basic) [78.541087] Starting subtest: basic [78.701380] Starting dynamic subtest: pipe-A-HDMI-A-1 [80.888986] Dynamic subtest pipe-A-HDMI-A-1: FAIL (2.165s) [80.982349] Starting dynamic subtest: pipe-B-HDMI-A-1 [83.138047] Dynamic subtest pipe-B-HDMI-A-1: FAIL (2.144s) [83.190869] Subtest basic: FAIL (4.653s) [83.384012] [007/132] (950s left) gem_pxp (reject-modify-context-protection-off-3) [85.968306] Starting subtest: reject-modify-context-protection-off-3 [85.970541] Subtest reject-modify-context-protection-off-3: SKIP (0.000s) [86.045992] [008/132] (947s left) gem_exec_fence (syncobj-unused-fence) [86.294200] Starting subtest: syncobj-unused-fence [86.296087] Subtest syncobj-unused-fence: SUCCESS (0.002s) [86.649303] [FACT gem_exec_fence (syncobj-unused-fence)] new: kernel.kmod_is_loaded.vgem: true [86.651903] [009/132] (947s left) i915_pm_freq_api (freq-reset-multiple) [86.716310] Subtest freq-reset-multiple: SKIP (0.000s) [86.776968] [010/132] (947s left) kms_getfb (getfb2-handle-zero) [86.839891] Starting subtest: getfb2-handle-zero [86.840952] Subtest getfb2-handle-zero: SUCCESS (0.000s) [86.934354] [011/132] (947s left) vgem_basic (mmap) [87.004580] Starting subtest: mmap [87.015884] Subtest mmap: SUCCESS (0.013s) [87.085144] [012/132] (947s left) kms_psr (psr2-sprite-mmap-cpu) [87.453960] Subtest psr2-sprite-mmap-cpu: SKIP (0.000s) [87.688302] [013/132] (946s left) syncobj_timeline (wait-all-delayed-signal) [87.753231] Starting subtest: wait-all-delayed-signal [87.855833] Subtest wait-all-delayed-signal: SUCCESS (0.102s) [87.953693] [014/132] (946s left) kms_cursor_legacy (cursora-vs-flipb-legacy) [88.328824] Starting subtest: cursorA-vs-flipB-legacy [88.330527] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s) [88.769445] [015/132] (945s left) prime_vgem (coherency-gtt) [88.854654] Starting subtest: coherency-gtt [88.872489] Subtest coherency-gtt: SUCCESS (0.017s) [88.980629] [016/132] (945s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [89.368025] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip [89.914514] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.546s) [90.461272] [017/132] (943s left) api_intel_allocator (default-alignment) [90.526141] Starting subtest: default-alignment [90.532265] Subtest default-alignment: SUCCESS (0.006s) [90.662906] [018/132] (943s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt) [91.039954] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt [91.041677] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [91.473787] [019/132] (943s left) gem_exec_schedule (preemptive-hang) [91.549097] Subtest preemptive-hang: SKIP (0.000s) [91.745773] [020/132] (942s left) drm_fdinfo (virtual-busy-idle-all) [91.808856] Subtest virtual-busy-idle-all: SKIP (0.000s) [91.868177] [021/132] (942s left) gem_mmap_offset (oob-read) [91.928290] Starting subtest: oob-read [91.929138] Subtest oob-read: SUCCESS (0.001s) [92.040368] [022/132] (942s left) gem_sync (basic-each) [92.113635] Starting subtest: basic-each [94.212790] Subtest basic-each: SUCCESS (2.099s) [94.423679] [023/132] (940s left) gem_mmap_wc (write) [94.484073] Starting subtest: write [94.594730] Subtest write: SUCCESS (0.110s) [94.700262] [024/132] (940s left) perf (polling-small-buf) [94.808619] Subtest polling-small-buf: SKIP (0.000s) [94.861577] [025/132] (939s left) prime_mmap (test_aperture_limit) [94.924068] Starting subtest: test_aperture_limit [94.924908] Starting dynamic subtest: test_aperture_limit-smem [94.931865] Dynamic subtest test_aperture_limit-smem: SUCCESS (0.008s) [94.932746] Subtest test_aperture_limit: SUCCESS (0.009s) [95.036527] [026/132] (939s left) gem_exec_reloc (basic-range) [95.099376] Starting subtest: basic-range [95.111253] Subtest basic-range: SUCCESS (0.012s) [95.866234] [027/132] (939s left) syncobj_timeline (wait-all-for-submit-snapshot) [95.930851] Starting subtest: wait-all-for-submit-snapshot [96.015326] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s) [96.099109] [028/132] (938s left) kms_frontbuffer_tracking (psr-2p-rte) [96.473909] Starting subtest: psr-2p-rte [96.475230] Subtest psr-2p-rte: SKIP (0.000s) [96.913729] [029/132] (938s left) sw_sync (sync_multi_consumer) [96.977411] Starting subtest: sync_multi_consumer [97.992505] Subtest sync_multi_consumer: SUCCESS (1.016s) [98.062604] [030/132] (937s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted) [98.127163] Starting subtest: etime-single-wait-all-for-submit-unsubmitted [98.231164] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s) [98.330541] [031/132] (936s left) kms_cursor_legacy (single-move) [98.698948] Starting subtest: single-move [98.699807] Starting dynamic subtest: pipe-A [104.087874] Dynamic subtest pipe-A: SUCCESS (5.387s) [104.098427] Starting dynamic subtest: pipe-B [109.478281] Dynamic subtest pipe-B: SUCCESS (5.390s) [109.487601] Starting dynamic subtest: all-pipes [114.866829] Dynamic subtest all-pipes: SUCCESS (5.388s) [114.867757] Subtest single-move: SUCCESS (16.167s) [115.311710] [032/132] (919s left) gem_exec_balancer (waits) [115.375941] Subtest waits: SKIP (0.000s) [115.468722] [033/132] (919s left) gem_exec_schedule (deep) [115.546390] Subtest deep: SKIP (0.000s) [115.742224] [034/132] (919s left) kms_cursor_legacy (cursor-vs-flip-toggle) [116.107176] Starting subtest: cursor-vs-flip-toggle [149.240060] Subtest cursor-vs-flip-toggle: SUCCESS (33.132s) [149.784427] [035/132] (885s left) kms_psr (pr-sprite-mmap-gtt) [150.158120] Subtest pr-sprite-mmap-gtt: SKIP (0.000s) [150.392201] [036/132] (885s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip) [150.774374] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip [150.775974] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [151.218755] [037/132] (884s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt) [151.591274] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt [151.592570] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [152.032975] [038/132] (883s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render) [152.411948] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render [152.413360] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [152.848787] [039/132] (882s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt) [153.224889] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt [153.226479] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [153.664839] [040/132] (881s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling) [153.728247] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SKIP (0.000s) [153.790769] [041/132] (881s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc) [154.169026] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc [156.059906] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (1.890s) [156.538322] [042/132] (879s left) kms_psr (fbc-psr-primary-page-flip) [156.914197] Subtest fbc-psr-primary-page-flip: SKIP (0.000s) [157.152799] [043/132] (878s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format) [157.531874] Starting subtest: plane-downscale-factor-0-75-with-pixel-format [157.532809] Starting dynamic subtest: pipe-A [157.535204] Dynamic subtest pipe-A: SKIP (0.001s) [157.544238] Starting dynamic subtest: pipe-B [157.546301] Dynamic subtest pipe-B: SKIP (0.001s) [157.547780] Subtest plane-downscale-factor-0-75-with-pixel-format: SKIP (0.003s) [157.968967] [044/132] (877s left) drm_fdinfo (busy) [158.037816] Subtest busy: SKIP (0.000s) [158.096791] [045/132] (877s left) kms_cursor_crc (cursor-sliding-64x64) [158.470677] Starting subtest: cursor-sliding-64x64 [158.473583] Starting dynamic subtest: pipe-A-HDMI-A-1 [162.015120] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.540s) [162.049579] Starting dynamic subtest: pipe-B-HDMI-A-1 [165.593484] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.551s) [165.594355] Subtest cursor-sliding-64x64: SUCCESS (7.123s) [166.161297] [046/132] (869s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc) [166.234873] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s) [166.285847] [047/132] (869s left) gem_userptr_blits (readonly-unsync) [166.349383] Subtest readonly-unsync: SKIP (0.000s) [166.497776] [048/132] (869s left) i915_pm_rpm (gem-idle) [168.069878] Subtest gem-idle: SKIP (0.000s) [168.296889] [049/132] (867s left) gem_wait (await) [168.388405] Starting subtest: await [168.389206] Starting dynamic subtest: all-engines [169.424030] Dynamic subtest all-engines: SUCCESS (1.035s) [169.434207] Starting dynamic subtest: rcs0 [170.445483] Dynamic subtest rcs0: SUCCESS (1.020s) [170.454432] Starting dynamic subtest: bcs0 [171.470890] Dynamic subtest bcs0: SUCCESS (1.024s) [171.481821] Starting dynamic subtest: vcs0 [172.493658] Dynamic subtest vcs0: SUCCESS (1.021s) [172.494802] Subtest await: SUCCESS (4.105s) [172.711207] [050/132] (863s left) kms_chamelium_hpd (dp-hpd-fast) [173.146907] Subtest dp-hpd-fast: SKIP (0.000s) [173.499787] [051/132] (862s left) kms_pm_dc (dc5-retention-flops) [174.567597] Subtest dc5-retention-flops: SKIP (0.000s) [174.625892] [052/132] (861s left) gen9_exec_parse (basic-rejected) [174.693186] Subtest basic-rejected: SKIP (0.000s) [174.743100] [053/132] (861s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [175.119676] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [175.121203] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [175.549167] [054/132] (860s left) core_hotunplug (unbind-rebind) [175.652081] Starting subtest: unbind-rebind [179.474812] Subtest unbind-rebind: SUCCESS (3.823s) [179.522164] [055/132] (856s left) sysfs_timeslice_duration (invalid) [179.592020] Starting subtest: invalid [179.593902] Starting dynamic subtest: vcs0 [179.595408] Dynamic subtest vcs0: SKIP (0.000s) [179.607375] Starting dynamic subtest: bcs0 [179.609501] Dynamic subtest bcs0: SKIP (0.000s) [179.622502] Starting dynamic subtest: rcs0 [179.624552] Dynamic subtest rcs0: SKIP (0.000s) [179.626596] Subtest invalid: SKIP (0.003s) [179.696163] [056/132] (856s left) kms_chamelium_color (ctm-green-to-red) [180.067593] Subtest ctm-green-to-red: SKIP (0.000s) [180.315208] [057/132] (856s left) perf_pmu (busy-start) [180.384284] Starting subtest: busy-start [180.385189] Starting dynamic subtest: rcs0 [182.900651] Dynamic subtest rcs0: SUCCESS (2.516s) [182.920664] Starting dynamic subtest: bcs0 [185.424558] Dynamic subtest bcs0: SUCCESS (2.523s) [185.442655] Starting dynamic subtest: vcs0 [188.442731] Dynamic subtest vcs0: SUCCESS (3.017s) [188.443966] Subtest busy-start: SUCCESS (8.058s) [188.539839] [058/132] (847s left) gem_exec_flush (basic-uc-pro-default) [188.612192] Starting subtest: basic-uc-pro-default [194.081099] Subtest basic-uc-pro-default: SUCCESS (5.469s) [194.277982] [059/132] (842s left) gem_readwrite (new-obj) [194.338638] Starting subtest: new-obj [194.340171] Subtest new-obj: SUCCESS (0.000s) [194.464234] [060/132] (842s left) gem_create (create-massive) [194.522316] Starting subtest: create-massive [194.523278] Subtest create-massive: SUCCESS (0.000s) [194.727952] [061/132] (841s left) prime_mmap (test_userptr) [194.791800] Starting subtest: test_userptr [194.792680] Starting dynamic subtest: test_userptr-smem [194.793581] Dynamic subtest test_userptr-smem: SUCCESS (0.000s) [194.794387] Subtest test_userptr: SUCCESS (0.002s) [194.894149] [062/132] (841s left) gem_exec_schedule (u-fairslice) [194.972700] Subtest u-fairslice: SKIP (0.000s) [195.175854] [063/132] (841s left) gem_exec_reloc (basic-wc-cpu) [195.236494] Starting subtest: basic-wc-cpu [195.240181] Subtest basic-wc-cpu: SUCCESS (0.004s) [195.972927] [064/132] (840s left) perf (gen12-oa-tlb-invalidate) [196.111429] Subtest gen12-oa-tlb-invalidate: SKIP (0.000s) [196.164255] [065/132] (840s left) kms_atomic (test-only) [196.522598] Starting subtest: test-only [196.745595] Starting dynamic subtest: pipe-A-HDMI-A-1 [197.251451] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.505s) [197.252533] Subtest test-only: SUCCESS (0.729s) [197.822834] [066/132] (839s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc) [197.894563] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s) [197.966476] [067/132] (839s left) gem_eio (in-flight-1us) [198.040348] Starting subtest: in-flight-1us [199.434948] Subtest in-flight-1us: SUCCESS (1.395s) [200.188195] [068/132] (836s left) kms_content_protection (atomic-dpms) [200.581666] Starting subtest: atomic-dpms [200.804191] Subtest atomic-dpms: SKIP (0.221s) [201.459487] [069/132] (835s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling) [201.527021] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s) [201.582902] [070/132] (835s left) kms_big_fb (x-tiled-addfb-size-overflow) [201.957779] Starting subtest: x-tiled-addfb-size-overflow [201.959365] Subtest x-tiled-addfb-size-overflow: SKIP (0.000s) [202.539717] [071/132] (834s left) kms_ccs (bad-aux-stride-yf-tiled-ccs) [202.607010] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.000s) [202.660292] [072/132] (834s left) kms_legacy_colorkey (basic) [203.026304] Starting subtest: basic [203.027021] Starting dynamic subtest: pipe-A [203.027809] Dynamic subtest pipe-A: SUCCESS (0.000s) [203.039271] Starting dynamic subtest: pipe-B [203.040371] Dynamic subtest pipe-B: SUCCESS (0.000s) [203.041545] Subtest basic: SUCCESS (0.002s) [203.469738] [073/132] (833s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt) [203.846624] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt [203.848226] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [204.285195] [074/132] (833s left) syncobj_wait (invalid-multi-wait-unsubmitted) [204.351616] Starting subtest: invalid-multi-wait-unsubmitted [204.352320] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [204.452757] [075/132] (832s left) gem_mmap (short-mmap) [204.514232] Starting subtest: short-mmap [204.515168] Subtest short-mmap: SUCCESS (0.000s) [204.618832] [076/132] (832s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [204.989887] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu [204.991471] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [205.437419] [077/132] (832s left) gem_exec_balancer (bonded-false-hang) [205.506913] Subtest bonded-false-hang: SKIP (0.000s) [205.600634] [078/132] (831s left) gem_madvise (dontneed-before-pwrite) [205.661850] Starting subtest: dontneed-before-pwrite [205.663651] Subtest dontneed-before-pwrite: SUCCESS (0.003s) [205.783662] [079/132] (831s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled) [205.844625] Starting subtest: multi-wait-all-for-submit-available-signaled [205.846591] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s) [205.946224] [080/132] (831s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite) [206.322522] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite [206.323963] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [206.764313] [081/132] (830s left) kms_addfb_basic (legacy-format) [206.828954] Starting subtest: legacy-format [206.893702] Subtest legacy-format: SUCCESS (0.060s) [207.621574] [082/132] (830s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff) [207.999721] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff [208.001293] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [208.439673] [083/132] (829s left) kms_cursor_legacy (cursora-vs-flipb-varying-size) [208.794723] Starting subtest: cursorA-vs-flipB-varying-size [208.796138] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s) [209.216744] [084/132] (828s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move) [209.573292] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move [209.574742] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [209.998560] [085/132] (827s left) kms_plane_multiple (tiling-y) [210.351037] Starting subtest: tiling-y [210.352399] Subtest tiling-y: SKIP (0.000s) [210.781433] [086/132] (827s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-25) [211.134071] Starting subtest: planes-upscale-20x20-downscale-factor-0-25 [211.134735] Starting dynamic subtest: pipe-A [211.136734] Dynamic subtest pipe-A: SKIP (0.001s) [211.147933] Starting dynamic subtest: pipe-B [211.149792] Dynamic subtest pipe-B: SKIP (0.001s) [211.151088] Subtest planes-upscale-20x20-downscale-factor-0-25: SKIP (0.004s) [211.562372] [087/132] (826s left) gem_mmap_gtt (big-copy-odd) [211.625528] Starting subtest: big-copy-odd [213.727287] Subtest big-copy-odd: SUCCESS (2.101s) [213.850681] [088/132] (824s left) tools_test (tools_test) [214.032643] Starting subtest: tools_test [214.152727] Subtest tools_test: SUCCESS (0.126s) [214.232321] [089/132] (823s left) kms_lease (lease-again) [214.612901] Starting subtest: lease-again [214.613822] Starting dynamic subtest: pipe-A-HDMI-A-1 [214.616687] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.002s) [214.633134] Starting dynamic subtest: pipe-B-HDMI-A-1 [214.633827] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s) [214.634545] Subtest lease-again: SUCCESS (0.009s) [215.067399] [090/132] (823s left) kms_cursor_crc (cursor-random-512x512) [215.463441] Starting subtest: cursor-random-512x512 [215.464800] Subtest cursor-random-512x512: SKIP (0.001s) [215.911428] [091/132] (822s left) kms_flip (flip-vs-panning-interruptible) [216.297313] Starting subtest: flip-vs-panning-interruptible [216.299497] Starting dynamic subtest: A-VGA1 [224.091620] Dynamic subtest A-VGA1: SUCCESS (7.792s) [224.105338] Starting dynamic subtest: B-VGA1 [231.798021] Dynamic subtest B-VGA1: SUCCESS (7.703s) [231.814975] Starting dynamic subtest: A-HDMI-A1 [239.553779] Dynamic subtest A-HDMI-A1: SUCCESS (7.752s) [239.570039] Starting dynamic subtest: B-HDMI-A1 [247.367691] Dynamic subtest B-HDMI-A1: SUCCESS (7.809s) [247.369611] Subtest flip-vs-panning-interruptible: SUCCESS (31.072s) [247.972756] [092/132] (790s left) syncobj_wait (wait-all-snapshot) [248.050993] Starting subtest: wait-all-snapshot [248.135254] Subtest wait-all-snapshot: SUCCESS (0.082s) [248.236655] [093/132] (790s left) kms_fbc_dirty_rect (fbc-dirty-rectangle-dirtyfb-tests) [248.855288] Subtest fbc-dirty-rectangle-dirtyfb-tests: SKIP (0.000s) [248.939753] [FACT kms_fbc_dirty_rect (fbc-dirty-rectangle-dirtyfb-tests)] new: kernel.kmod_is_loaded.xe: true [248.942709] [094/132] (789s left) kms_addfb_basic (clobberred-modifier) [249.004966] Starting subtest: clobberred-modifier [249.005804] Subtest clobberred-modifier: SUCCESS (0.000s) [249.769475] [095/132] (788s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [250.143694] Starting subtest: psr-2p-primscrn-cur-indfb-move [250.145258] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [250.583356] [096/132] (787s left) gem_userptr_blits (sd-probe) [250.661894] Starting subtest: sd-probe [250.662690] Subtest sd-probe: SUCCESS (0.000s) [250.818443] [097/132] (787s left) gem_create (create-invalid-size) [250.886958] Starting subtest: create-invalid-size [250.887776] Subtest create-invalid-size: SUCCESS (0.000s) [251.101705] [098/132] (787s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc) [251.167931] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s) [251.247403] [099/132] (787s left) gem_exec_balancer (parallel-out-fence) [251.314420] Subtest parallel-out-fence: SKIP (0.000s) [251.415577] [100/132] (787s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf) [251.781417] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [252.004736] [101/132] (786s left) gem_ctx_persistence (heartbeat-hang) [252.075769] Subtest heartbeat-hang: SKIP (0.000s) [252.137116] [102/132] (786s left) kms_cursor_crc (cursor-dpms) [252.501208] Starting subtest: cursor-dpms [252.502010] Starting dynamic subtest: pipe-A-HDMI-A-1 [253.539228] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.032s) [253.550821] Starting dynamic subtest: pipe-B-HDMI-A-1 [254.519453] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.982s) [254.520195] Subtest cursor-dpms: SUCCESS (2.019s) [255.092213] [103/132] (783s left) kms_hdr (static-toggle-suspend) [255.477326] Starting subtest: static-toggle-suspend [255.479688] Subtest static-toggle-suspend: SKIP (0.000s) [255.911601] [104/132] (783s left) kms_rotation_crc (multiplane-rotation-cropping-bottom) [256.282724] Starting subtest: multiplane-rotation-cropping-bottom [256.284166] Subtest multiplane-rotation-cropping-bottom: SKIP (0.000s) [256.730331] [105/132] (782s left) gem_mmap_wc (write-read-distinct) [256.797407] Starting subtest: write-read-distinct [256.811448] Subtest write-read-distinct: SUCCESS (0.014s) [256.928392] [106/132] (782s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic) [257.299407] Starting subtest: flip-vs-cursor-crc-atomic [257.804385] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.504s) [258.352395] [107/132] (780s left) intel_sysfs_debugfs (i915-debugfs-read-all-entries-display-on) [258.732539] Starting subtest: i915-debugfs-read-all-entries-display-on [258.922738] Subtest i915-debugfs-read-all-entries-display-on: SUCCESS (0.192s) [259.421487] [108/132] (779s left) gem_reg_read (timestamp-monotonic) [259.485200] Starting subtest: timestamp-monotonic [263.722611] Subtest timestamp-monotonic: SUCCESS (4.238s) [263.826074] [109/132] (775s left) syncobj_wait (multi-wait-for-submit-submitted-signaled) [263.889338] Starting subtest: multi-wait-for-submit-submitted-signaled [263.889991] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s) [263.990796] [110/132] (775s left) gem_workarounds (suspend-resume) [264.065427] Starting subtest: suspend-resume [281.147622] Subtest suspend-resume: SUCCESS (0.551s) [288.200807] [111/132] (774s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode) [288.642872] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s) [288.981081] [112/132] (773s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip) [289.356555] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip [289.358044] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [289.798073] [113/132] (772s left) gem_mmap_gtt (cpuset-big-copy-xy) [289.867360] Starting subtest: cpuset-big-copy-XY [293.151498] Subtest cpuset-big-copy-XY: SUCCESS (3.301s) [293.328122] [114/132] (769s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted) [293.497869] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted [293.605205] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.107s) [293.707128] [115/132] (769s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs) [293.769669] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.000s) [293.835435] [116/132] (769s left) gem_exec_whisper (basic-contexts-forked) [293.915127] Starting subtest: basic-contexts-forked [296.066714] Subtest basic-contexts-forked: SUCCESS (2.157s) [296.280669] [117/132] (766s left) gem_ctx_shared (exec-single-timeline) [296.348355] Subtest exec-single-timeline: SKIP (0.000s) [296.456499] [118/132] (766s left) kms_force_connector_basic (prune-stale-modes) [296.534287] Starting subtest: prune-stale-modes [296.564875] Subtest prune-stale-modes: SUCCESS (0.026s) [297.061563] [119/132] (766s left) api_intel_allocator (simple-allocator) [297.131073] Starting subtest: simple-allocator [297.131775] Starting dynamic subtest: basic [297.135146] Dynamic subtest basic: SUCCESS (0.005s) [297.154153] Starting dynamic subtest: parallel-one [297.444835] Dynamic subtest parallel-one: SUCCESS (0.308s) [297.459485] Starting dynamic subtest: print [297.460335] Dynamic subtest print: SUCCESS (0.000s) [297.478043] Starting dynamic subtest: reuse [297.478811] Dynamic subtest reuse: SUCCESS (0.000s) [297.499613] Starting dynamic subtest: reserve [297.500745] Dynamic subtest reserve: SUCCESS (0.000s) [297.523842] Starting dynamic subtest: fork-reopen-allocator [297.525064] Dynamic subtest fork-reopen-allocator: SUCCESS (0.023s) [297.526090] Subtest simple-allocator: SUCCESS (0.346s) [297.601493] [120/132] (765s left) kms_pm_rpm (fences) [299.234109] Subtest fences: SKIP (0.000s) [299.484832] [121/132] (763s left) kms_psr (fbc-pr-cursor-blt) [299.854778] Subtest fbc-pr-cursor-blt: SKIP (0.000s) [300.084695] [122/132] (763s left) kms_big_fb (y-tiled-32bpp-rotate-0) [300.458599] Starting subtest: y-tiled-32bpp-rotate-0 [300.461030] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s) [300.908267] [123/132] (762s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite) [301.284243] Starting subtest: fbcpsr-rgb565-draw-pwrite [301.285840] Subtest fbcpsr-rgb565-draw-pwrite: SKIP (0.000s) [301.720895] [124/132] (761s left) kms_psr (fbc-pr-primary-page-flip) [302.096116] Subtest fbc-pr-primary-page-flip: SKIP (0.000s) [302.327439] [125/132] (761s left) gem_lmem_swapping (heavy-verify-random) [302.394677] Subtest heavy-verify-random: SKIP (0.000s) [302.463775] [126/132] (761s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt) [302.839316] Starting subtest: fbc-rgb101010-draw-blt [305.420195] Subtest fbc-rgb101010-draw-blt: SUCCESS (2.584s) [305.890377] [127/132] (757s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted) [305.961545] Starting subtest: invalid-multi-wait-all-unsubmitted [305.962445] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [306.061570] [128/132] (757s left) kms_flip (blocking-absolute-wf_vblank-interruptible) [306.442821] Starting subtest: blocking-absolute-wf_vblank-interruptible [306.445470] Starting dynamic subtest: A-VGA1 [314.174449] Dynamic subtest A-VGA1: SUCCESS (7.736s) [314.190784] Starting dynamic subtest: B-VGA1 [321.862306] Dynamic subtest B-VGA1: SUCCESS (7.685s) [321.878661] Starting dynamic subtest: A-HDMI-A1 [329.714714] Dynamic subtest A-HDMI-A1: SUCCESS (7.850s) [329.733525] Starting dynamic subtest: B-HDMI-A1 [337.611372] Dynamic subtest B-HDMI-A1: SUCCESS (7.895s) [337.614838] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (31.179s) [338.241446] [129/132] (725s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf) [338.616160] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [338.844716] [130/132] (724s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc) [339.218997] Starting subtest: fbc-rgb565-draw-mmap-wc [341.040694] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (1.823s) [341.514422] [131/132] (722s left) gem_ringfill (legacy-basic) [341.687184] Starting subtest: legacy-basic [341.688070] Starting dynamic subtest: default [341.727251] Dynamic subtest default: SUCCESS (0.038s) [341.750829] Starting dynamic subtest: render [341.751857] Dynamic subtest render: SUCCESS (0.021s) [341.769711] Starting dynamic subtest: bsd [341.772398] Dynamic subtest bsd: SKIP (0.000s) [341.793830] Starting dynamic subtest: bsd1 [341.796237] Dynamic subtest bsd1: SKIP (0.000s) [341.817244] Starting dynamic subtest: blt [341.818608] Dynamic subtest blt: SUCCESS (0.015s) [341.819754] Subtest legacy-basic: SUCCESS (0.086s) [341.877645] [132/132] (721s left) kms_vblank (query-busy-hang) [342.245698] Starting subtest: query-busy-hang [342.246652] Starting dynamic subtest: pipe-A-HDMI-A-1 [348.323153] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.077s) [348.339514] Starting dynamic subtest: pipe-B-HDMI-A-1 [354.285634] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (5.963s) [354.286338] Subtest query-busy-hang: SUCCESS (12.045s) [354.837527] Closing watchdogs results: parsing output: 0/ for test: gem_blits results: parsing output: 1/ for test: syncobj_wait results: parsing output: 2/ for test: gem_render_copy results: parsing output: 3/ for test: kms_vblank results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: kms_setmode results: parsing output: 6/ for test: gem_pxp results: parsing output: 7/ for test: gem_exec_fence results: parsing output: 8/ for test: i915_pm_freq_api results: parsing output: 9/ for test: kms_getfb results: parsing output: 10/ for test: vgem_basic results: parsing output: 11/ for test: kms_psr results: parsing output: 12/ for test: syncobj_timeline results: parsing output: 13/ for test: kms_cursor_legacy results: parsing output: 14/ for test: prime_vgem results: parsing output: 15/ for test: kms_big_fb results: parsing output: 16/ for test: api_intel_allocator results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: gem_exec_schedule results: parsing output: 19/ for test: drm_fdinfo results: parsing output: 20/ for test: gem_mmap_offset results: parsing output: 21/ for test: gem_sync results: parsing output: 22/ for test: gem_mmap_wc results: parsing output: 23/ for test: perf results: parsing output: 24/ for test: prime_mmap results: parsing output: 25/ for test: gem_exec_reloc results: parsing output: 26/ for test: syncobj_timeline results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: sw_sync results: parsing output: 29/ for test: syncobj_timeline results: parsing output: 30/ for test: kms_cursor_legacy results: parsing output: 31/ for test: gem_exec_balancer results: parsing output: 32/ for test: gem_exec_schedule results: parsing output: 33/ for test: kms_cursor_legacy results: parsing output: 34/ for test: kms_psr results: parsing output: 35/ for test: kms_big_fb results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_flip_scaled_crc results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: kms_psr results: parsing output: 42/ for test: kms_plane_scaling results: parsing output: 43/ for test: drm_fdinfo results: parsing output: 44/ for test: kms_cursor_crc results: parsing output: 45/ for test: kms_ccs results: parsing output: 46/ for test: gem_userptr_blits results: parsing output: 47/ for test: i915_pm_rpm results: parsing output: 48/ for test: gem_wait results: parsing output: 49/ for test: kms_chamelium_hpd results: parsing output: 50/ for test: kms_pm_dc results: parsing output: 51/ for test: gen9_exec_parse results: parsing output: 52/ for test: kms_big_fb results: parsing output: 53/ for test: core_hotunplug results: parsing output: 54/ for test: sysfs_timeslice_duration results: parsing output: 55/ for test: kms_chamelium_color results: parsing output: 56/ for test: perf_pmu results: parsing output: 57/ for test: gem_exec_flush results: parsing output: 58/ for test: gem_readwrite results: parsing output: 59/ for test: gem_create results: parsing output: 60/ for test: prime_mmap results: parsing output: 61/ for test: gem_exec_schedule results: parsing output: 62/ for test: gem_exec_reloc results: parsing output: 63/ for test: perf results: parsing output: 64/ for test: kms_atomic results: parsing output: 65/ for test: kms_ccs results: parsing output: 66/ for test: gem_eio results: parsing output: 67/ for test: kms_content_protection results: parsing output: 68/ for test: kms_flip_scaled_crc results: parsing output: 69/ for test: kms_big_fb results: parsing output: 70/ for test: kms_ccs results: parsing output: 71/ for test: kms_legacy_colorkey results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: syncobj_wait results: parsing output: 74/ for test: gem_mmap results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: gem_exec_balancer results: parsing output: 77/ for test: gem_madvise results: parsing output: 78/ for test: syncobj_timeline 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_cursor_legacy results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_plane_multiple results: parsing output: 85/ for test: kms_plane_scaling results: parsing output: 86/ for test: gem_mmap_gtt results: parsing output: 87/ for test: tools_test results: parsing output: 88/ for test: kms_lease results: parsing output: 89/ for test: kms_cursor_crc results: parsing output: 90/ for test: kms_flip results: parsing output: 91/ for test: syncobj_wait results: parsing output: 92/ for test: kms_fbc_dirty_rect results: parsing output: 93/ for test: kms_addfb_basic results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: gem_userptr_blits results: parsing output: 96/ for test: gem_create results: parsing output: 97/ for test: kms_ccs results: parsing output: 98/ for test: gem_exec_balancer results: parsing output: 99/ for test: kms_psr2_sf results: parsing output: 100/ for test: gem_ctx_persistence results: parsing output: 101/ for test: kms_cursor_crc results: parsing output: 102/ for test: kms_hdr results: parsing output: 103/ for test: kms_rotation_crc results: parsing output: 104/ for test: gem_mmap_wc results: parsing output: 105/ for test: kms_cursor_legacy results: parsing output: 106/ for test: intel_sysfs_debugfs results: parsing output: 107/ for test: gem_reg_read results: parsing output: 108/ for test: syncobj_wait results: parsing output: 109/ for test: gem_workarounds results: parsing output: 110/ for test: kms_chamelium_hpd results: parsing output: 111/ for test: kms_big_fb results: parsing output: 112/ for test: gem_mmap_gtt results: parsing output: 113/ for test: syncobj_timeline results: parsing output: 114/ for test: kms_ccs results: parsing output: 115/ for test: gem_exec_whisper results: parsing output: 116/ for test: gem_ctx_shared results: parsing output: 117/ for test: kms_force_connector_basic results: parsing output: 118/ for test: api_intel_allocator results: parsing output: 119/ for test: kms_pm_rpm results: parsing output: 120/ for test: kms_psr results: parsing output: 121/ for test: kms_big_fb results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: kms_psr results: parsing output: 124/ for test: gem_lmem_swapping results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: syncobj_timeline results: parsing output: 127/ for test: kms_flip results: parsing output: 128/ for test: kms_psr2_sf results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: gem_ringfill results: parsing output: 131/ for test: kms_vblank Done.