[74.122106] Initializing watchdogs
[74.122384]   /dev/watchdog0
[74.149821] [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)
[74.157499] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[74.162501] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[74.166481] [001/131] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[74.562461] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[74.563813] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[74.992183] [002/131] (959s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[75.367566] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[77.382413] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (2.015s)
[77.858323] [003/131] (956s left) kms_cursor_crc (cursor-offscreen-256x85)
[78.240999] Starting subtest: cursor-offscreen-256x85
[78.297699] Subtest cursor-offscreen-256x85: SKIP (0.056s)
[78.736667] [004/131] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[79.102316] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[79.103494] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[79.535431] [005/131] (955s left) kms_pm_rpm (pm-tiling)
[91.180762] Subtest pm-tiling: SKIP (0.000s)
[91.424194] [006/131] (943s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[91.889265] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[92.230735] [007/131] (942s left) gem_pxp (regular-baseline-src-copy-readible)
[94.803220] Starting subtest: regular-baseline-src-copy-readible
[94.805345] Subtest regular-baseline-src-copy-readible: SKIP (0.000s)
[94.890724] [008/131] (940s left) gem_ctx_persistence (engines-persistence)
[94.952686] Subtest engines-persistence: SKIP (0.000s)
[94.996367] [009/131] (940s left) api_intel_allocator (reopen-fork)
[95.052369] Starting subtest: reopen-fork
[98.381156] Subtest reopen-fork: SUCCESS (3.328s)
[98.468147] [010/131] (936s left) gem_mmap_wc (write-prefaulted)
[98.524187] Starting subtest: write-prefaulted
[98.668776] Subtest write-prefaulted: SUCCESS (0.145s)
[98.768114] [011/131] (936s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[98.822298] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[98.872303] [012/131] (936s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-pwrite)
[99.241706] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-pwrite
[101.051436] Subtest fbc-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (1.810s)
[101.525790] [013/131] (933s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[101.894444] Starting subtest: cursorB-vs-flipA-legacy
[101.896362] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s)
[102.340160] [014/131] (932s left) fbdev (read)
[102.396419] Starting subtest: read
[102.777096] Subtest read: SUCCESS (0.380s)
[102.853508] [015/131] (932s left) gem_exec_suspend (basic-s4-devices)
[102.914631] Starting subtest: basic-S4-devices
[102.915295] Starting dynamic subtest: smem
[110.707219] Dynamic subtest smem: SUCCESS (7.793s)
[110.708310] Subtest basic-S4-devices: SUCCESS (7.793s)
[116.904731] [016/131] (924s left) gem_exec_schedule (u-submit-late-slice)
[117.000350] Subtest u-submit-late-slice: SKIP (0.000s)
[117.191273] [017/131] (924s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[117.247747] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[117.294890] [018/131] (924s left) gem_readwrite (write-bad-handle)
[117.352287] Starting subtest: write-bad-handle
[117.353692] Subtest write-bad-handle: SUCCESS (0.000s)
[117.471205] [019/131] (924s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[117.829223] Starting subtest: primary-4-tiled-reflect-x-0
[117.830874] Subtest primary-4-tiled-reflect-x-0: SKIP (0.001s)
[118.269390] [020/131] (923s left) gem_ctx_shared (q-smoketest)
[118.335117] Subtest Q-smoketest: SKIP (0.000s)
[118.418883] [021/131] (923s left) syncobj_wait (single-wait-signaled)
[118.473863] Starting subtest: single-wait-signaled
[118.474628] Subtest single-wait-signaled: SUCCESS (0.000s)
[118.567398] [022/131] (923s left) kms_chamelium_hpd (vga-hpd)
[119.005075] Subtest vga-hpd: SKIP (0.000s)
[119.337024] [023/131] (922s left) gem_lmem_swapping (massive)
[119.398712] Subtest massive: SKIP (0.000s)
[119.453229] [024/131] (922s left) gen9_exec_parse (batch-without-end)
[119.509239] Subtest batch-without-end: SKIP (0.000s)
[119.569175] [025/131] (922s left) gem_exec_flush (basic-wb-pro-default)
[119.635443] Starting subtest: basic-wb-pro-default
[125.082593] Subtest basic-wb-pro-default: SUCCESS (5.447s)
[125.284490] [026/131] (916s left) gem_exec_schedule (preempt-contexts)
[125.352869] Subtest preempt-contexts: SKIP (0.000s)
[125.545721] [027/131] (916s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[125.911977] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[125.913280] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[126.356176] [028/131] (915s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[126.415396] Starting subtest: multi-wait-all-for-submit-signaled
[126.416961] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[126.515137] [029/131] (915s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[126.570935] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[126.673034] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.101s)
[126.763052] [030/131] (915s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[127.125806] Starting subtest: cursorA-vs-flipB-varying-size
[127.127243] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[127.562966] [031/131] (914s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[127.620568] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[127.621980] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[127.713720] [032/131] (914s left) kms_rotation_crc (bad-tiling)
[128.073321] Starting subtest: bad-tiling
[128.076633] Subtest bad-tiling: SKIP (0.001s)
[128.506706] [033/131] (913s left) kms_flip (flip-vs-suspend)
[128.875047] Starting subtest: flip-vs-suspend
[128.875796] Starting dynamic subtest: A-VGA1
[196.647087] Dynamic subtest A-VGA1: SUCCESS (2.833s)
[196.659017] Starting dynamic subtest: B-VGA1
[264.651438] Dynamic subtest B-VGA1: SUCCESS (2.779s)
[264.664727] Starting dynamic subtest: A-HDMI-A1
[332.639090] Dynamic subtest A-HDMI-A1: SUCCESS (2.902s)
[332.652845] Starting dynamic subtest: B-HDMI-A1
[401.659092] Dynamic subtest B-HDMI-A1: SUCCESS (2.907s)
[401.664111] Subtest flip-vs-suspend: SUCCESS (11.979s)
[409.220718] [034/131] (639s left) gem_set_tiling_vs_pwrite
[409.422263] [035/131] (639s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[409.802631] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[411.844569] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (1.981s)
[412.356326] [036/131] (636s left) gem_exec_whisper (basic-queues-priority-all)
[412.430352] Starting subtest: basic-queues-priority-all
[412.431779] Subtest basic-queues-priority-all: SKIP (0.001s)
[412.650967] [037/131] (636s left) gem_exec_balancer (persistence)
[412.708948] Subtest persistence: SKIP (0.000s)
[412.800328] [038/131] (636s left) prime_busy (hang)
[412.860478] Starting subtest: hang
[412.861226] Starting dynamic subtest: rcs0
[418.624926] Dynamic subtest rcs0: SUCCESS (5.673s)
[418.638350] Starting dynamic subtest: bcs0
[424.636904] Dynamic subtest bcs0: SUCCESS (5.965s)
[424.649563] Starting dynamic subtest: vcs0
[430.646354] Dynamic subtest vcs0: SUCCESS (5.987s)
[430.647137] Subtest hang: SUCCESS (17.627s)
[430.773344] [039/131] (618s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[431.141173] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[431.142785] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[431.585208] [040/131] (617s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[431.948518] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[431.949857] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[432.389316] [041/131] (617s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[432.753799] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[432.755343] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[433.187430] [042/131] (616s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[433.558943] Starting subtest: plane-downscale-factor-0-75-with-rotation
[433.559672] Starting dynamic subtest: pipe-A
[433.561444] Dynamic subtest pipe-A: SKIP (0.002s)
[433.574031] Starting dynamic subtest: pipe-B
[433.575953] Dynamic subtest pipe-B: SKIP (0.001s)
[433.577025] Subtest plane-downscale-factor-0-75-with-rotation: SKIP (0.005s)
[434.007581] [043/131] (615s left) kms_rotation_crc (exhaust-fences)
[434.376817] Starting subtest: exhaust-fences
[434.378214] Subtest exhaust-fences: SKIP (0.000s)
[434.821430] [044/131] (614s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[435.187449] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[435.188763] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[435.635299] [045/131] (614s left) gem_basic (multigpu-create-close)
[435.695570] Starting subtest: multigpu-create-close
[435.697085] Subtest multigpu-create-close: SKIP (0.000s)
[435.793066] [046/131] (614s left) sw_sync (sync_random_merge)
[435.845966] Starting subtest: sync_random_merge
[435.941635] Subtest sync_random_merge: SUCCESS (0.095s)
[436.022601] [047/131] (613s left) kms_dp_link_training (uhbr-mst)
[436.382061] Starting subtest: uhbr-mst
[436.383159] Subtest uhbr-mst: SKIP (0.000s)
[436.659232] [048/131] (613s left) gem_exec_balancer (bonded-pair)
[436.723779] Subtest bonded-pair: SKIP (0.000s)
[436.816539] [049/131] (613s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[436.874199] Starting subtest: basic-gtt-wc-noreloc
[436.878828] Subtest basic-gtt-wc-noreloc: SUCCESS (0.005s)
[437.622708] [050/131] (612s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-render)
[437.994603] Starting subtest: psr-1p-offscren-pri-indfb-draw-render
[437.995719] Subtest psr-1p-offscren-pri-indfb-draw-render: SKIP (0.000s)
[438.438617] [051/131] (611s left) kms_psr (psr-cursor-blt)
[438.802375] Subtest psr-cursor-blt: SKIP (0.000s)
[439.034480] [052/131] (611s left) kms_addfb_basic (too-wide)
[439.399696] Starting subtest: too-wide
[439.400335] Subtest too-wide: SUCCESS (0.000s)
[439.833401] [053/131] (610s left) gem_busy (close-race)
[439.904282] Starting subtest: close-race
[462.083795] Subtest close-race: SUCCESS (22.174s)
[462.432715] [FACT gem_busy (close-race)] new: kernel.kmod_is_loaded.vgem: true
[462.439383] [054/131] (587s left) i915_pm_rps (min-max-config-loaded)
[462.617809] Starting subtest: min-max-config-loaded
[462.948303] Subtest min-max-config-loaded: SUCCESS (0.330s)
[463.082152] [055/131] (587s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[463.458980] Starting subtest: 4-tiled-8bpp-rotate-90
[463.460622] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.000s)
[463.895700] [056/131] (586s left) gem_exec_params (rel-constants-invalid)
[463.953913] Starting subtest: rel-constants-invalid
[463.954719] Subtest rel-constants-invalid: SUCCESS (0.000s)
[464.062115] [057/131] (586s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[464.115395] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[464.180460] [058/131] (586s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[464.241965] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[464.244147] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[464.449401] [059/131] (586s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[464.506317] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.000s)
[464.579924] [060/131] (586s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[464.945755] Starting subtest: primary-y-tiled-reflect-x-270
[464.947140] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[465.393113] [061/131] (585s left) kms_plane_alpha_blend (constant-alpha-max)
[465.756908] Starting subtest: constant-alpha-max
[465.932298] Subtest constant-alpha-max: SKIP (0.176s)
[466.561130] [062/131] (584s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[466.932107] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[466.933733] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[467.374723] [063/131] (583s left) kms_vblank (invalid)
[467.739034] Starting subtest: invalid
[467.739885] Starting dynamic subtest: pipe-A-HDMI-A-1
[467.949895] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.210s)
[467.951249] Subtest invalid: SUCCESS (0.212s)
[468.500959] [064/131] (582s left) perf_pmu (module-unload)
[468.582077] Starting subtest: module-unload
[475.135534] Subtest module-unload: FAIL (6.532s)
[475.168305] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[475.169523] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[475.171962] [065/131] (575s left) syncobj_timeline (multi-wait-submitted-signaled)
[477.183525] Starting subtest: multi-wait-submitted-signaled
[477.184541] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[477.246978] [FACT syncobj_timeline (multi-wait-submitted-signaled)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[477.248681] [FACT syncobj_timeline (multi-wait-submitted-signaled)] new: kernel.kmod_is_loaded.i915: true
[477.252886] [066/131] (573s left) sysfs_timeslice_duration (duration)
[477.318099] Starting subtest: duration
[477.321222] Starting dynamic subtest: vcs0
[477.322699] Dynamic subtest vcs0: SKIP (0.000s)
[477.339273] Starting dynamic subtest: bcs0
[477.340527] Dynamic subtest bcs0: SKIP (0.000s)
[477.353234] Starting dynamic subtest: rcs0
[477.354481] Dynamic subtest rcs0: SKIP (0.000s)
[477.355591] Subtest duration: SKIP (0.009s)
[477.416678] [067/131] (573s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[477.787987] Starting subtest: cursor-rapid-movement-512x170
[477.789303] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[478.234617] [068/131] (572s left) kms_chamelium_audio (dp-audio)
[478.680883] Subtest dp-audio: SKIP (0.000s)
[479.018411] [069/131] (572s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[479.084388] Starting subtest: basic-gtt-cpu-noreloc
[479.089030] Subtest basic-gtt-cpu-noreloc: SUCCESS (0.005s)
[479.830075] [070/131] (571s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[480.184947] Starting subtest: flip-vs-cursor-crc-atomic
[480.757339] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.571s)
[481.312856] [071/131] (569s left) kms_lease (empty-lease)
[481.672591] Starting subtest: empty-lease
[481.673221] Starting dynamic subtest: pipe-A-HDMI-A-1
[481.673937] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[481.688666] Starting dynamic subtest: pipe-B-HDMI-A-1
[481.689278] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[481.689967] Subtest empty-lease: SUCCESS (0.006s)
[482.225192] [072/131] (569s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[482.314306] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[482.385446] [073/131] (568s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[482.751835] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[482.752959] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[483.202083] [074/131] (568s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[483.564689] Starting subtest: yf-tiled-addfb-size-overflow
[483.565921] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[484.002358] [075/131] (567s left) kms_cursor_crc (cursor-random-128x42)
[484.370299] Starting subtest: cursor-random-128x42
[484.428950] Subtest cursor-random-128x42: SKIP (0.056s)
[484.867883] [076/131] (566s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[485.234152] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[485.235317] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[485.686391] [077/131] (565s left) perf_pmu (busy-accuracy-98)
[485.750294] Starting subtest: busy-accuracy-98
[485.751116] Starting dynamic subtest: rcs0
[485.752881] Dynamic subtest rcs0: SKIP (0.000s)
[485.769627] Starting dynamic subtest: bcs0
[485.771880] Dynamic subtest bcs0: SKIP (0.000s)
[485.792001] Starting dynamic subtest: vcs0
[485.793903] Dynamic subtest vcs0: SKIP (0.000s)
[485.795636] Subtest busy-accuracy-98: SKIP (0.005s)
[485.861696] [078/131] (565s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[486.223904] Starting subtest: x-tiled-32bpp-rotate-90
[486.246499] Subtest x-tiled-32bpp-rotate-90: SKIP (0.022s)
[486.701549] [079/131] (564s left) kms_pm_backlight (bad-brightness)
[487.062423] Subtest bad-brightness: SKIP (0.000s)
[487.318999] [080/131] (564s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[487.682628] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[487.683734] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[488.129150] [081/131] (563s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[488.487920] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[490.904750] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (2.416s)
[491.393340] [082/131] (560s left) gem_exec_fence (submit-chain)
[491.572959] Subtest submit-chain: SKIP (0.000s)
[491.963708] [083/131] (559s left) kms_plane_multiple (tiling-y)
[492.320330] Starting subtest: tiling-y
[492.321793] Subtest tiling-y: SKIP (0.000s)
[492.754174] [084/131] (559s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[493.119716] Starting subtest: fbcpsr-tiling-4
[493.121111] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[493.554963] [085/131] (558s left) kms_chamelium_color (ctm-0-75)
[493.913411] Subtest ctm-0-75: SKIP (0.000s)
[494.144477] [086/131] (557s left) kms_psr (fbc-psr-primary-blt)
[494.505829] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[494.751233] [087/131] (557s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[494.808144] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[494.894304] [088/131] (557s left) gem_exec_schedule (deep)
[494.960855] Subtest deep: SKIP (0.000s)
[495.165635] [089/131] (557s left) perf (invalid-oa-format-id)
[495.340168] Subtest invalid-oa-format-id: SKIP (0.000s)
[495.412840] [090/131] (556s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[495.776187] Starting subtest: plane-use-after-nonblocking-unbind
[495.776852] Starting dynamic subtest: pipe-A-HDMI-A-1
[495.879974] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.103s)
[495.976838] Starting dynamic subtest: pipe-B-HDMI-A-1
[496.241239] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.276s)
[496.323249] Subtest plane-use-after-nonblocking-unbind: SUCCESS (0.548s)
[496.861849] [091/131] (555s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-pwrite)
[497.224690] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-pwrite
[497.226209] Subtest fbcpsr-1p-offscren-pri-indfb-draw-pwrite: SKIP (0.000s)
[497.674153] [092/131] (554s left) gem_ctx_engines (execute-oneforall)
[497.742245] Starting subtest: execute-oneforall
[497.831253] Subtest execute-oneforall: SUCCESS (0.087s)
[498.057783] [093/131] (554s left) kms_setmode (invalid-clone-exclusive-crtc)
[498.113280] Starting subtest: invalid-clone-exclusive-crtc
[498.115204] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[498.206778] [094/131] (554s left) kms_big_fb (y-tiled-addfb)
[498.568620] Starting subtest: y-tiled-addfb
[498.569841] Subtest y-tiled-addfb: SKIP (0.000s)
[499.008481] [095/131] (553s left) gem_userptr_blits (probe)
[499.098779] Starting subtest: probe
[499.293936] Subtest probe: SUCCESS (0.197s)
[499.404124] [096/131] (553s left) kms_invalid_mode (clock-too-high)
[499.759099] Starting subtest: clock-too-high
[499.759778] Starting dynamic subtest: pipe-A-HDMI-A-1
[499.851529] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.090s)
[499.866914] Starting dynamic subtest: pipe-B-HDMI-A-1
[499.867950] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[499.869142] Subtest clock-too-high: SUCCESS (0.096s)
[500.411866] [097/131] (552s left) kms_cursor_edge_walk (128x128-top-edge)
[500.772426] Starting subtest: 128x128-top-edge
[500.773361] Starting dynamic subtest: pipe-A-HDMI-A-1
[504.197338] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.422s)
[504.211884] Starting dynamic subtest: pipe-B-HDMI-A-1
[507.539912] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.343s)
[507.540778] Subtest 128x128-top-edge: SUCCESS (6.770s)
[508.092105] [098/131] (544s left) gem_linear_blits (normal)
[508.340380] Starting subtest: normal
[510.283565] Subtest normal: SUCCESS (1.948s)
[510.401292] [099/131] (542s left) kms_vblank (wait-busy-hang)
[510.851742] Starting subtest: wait-busy-hang
[510.855043] Starting dynamic subtest: pipe-A-HDMI-A-1
[516.682031] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (5.832s)
[516.701117] Starting dynamic subtest: pipe-B-HDMI-A-1
[522.699851] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.019s)
[522.700515] Subtest wait-busy-hang: SUCCESS (11.857s)
[523.254210] [100/131] (529s left) gem_mmap_gtt (coherency)
[523.315706] Starting subtest: coherency
[523.372464] Subtest coherency: SUCCESS (0.057s)
[523.484496] [101/131] (529s left) api_intel_bb (simple-bb)
[523.541115] Starting subtest: simple-bb
[523.541805] Subtest simple-bb: SUCCESS (0.002s)
[523.667909] [102/131] (529s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[524.032464] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[524.272354] [103/131] (528s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[524.327218] Starting subtest: cpuset-medium-copy-XY
[525.949314] Subtest cpuset-medium-copy-XY: SUCCESS (1.624s)
[526.056269] [104/131] (527s left) syncobj_timeline (single-wait-available-submitted)
[526.240266] Starting subtest: single-wait-available-submitted
[526.241057] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[526.343830] [105/131] (526s left) gem_userptr_blits (sync-unmap)
[526.418391] Starting subtest: sync-unmap
[526.431585] Subtest sync-unmap: SUCCESS (0.014s)
[526.573523] [106/131] (526s left) kms_psr (pr-sprite-mmap-cpu)
[526.934557] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[527.173339] [107/131] (526s left) gem_exec_fence (syncobj-timeline-wait)
[527.490877] Starting subtest: syncobj-timeline-wait
[527.523774] Subtest syncobj-timeline-wait: SUCCESS (0.034s)
[527.753729] [108/131] (525s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[528.117136] Starting subtest: x-tiled-8bpp-rotate-270
[528.134002] Subtest x-tiled-8bpp-rotate-270: SKIP (0.014s)
[528.603818] [109/131] (524s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[528.966930] Starting subtest: fbc-rgb101010-draw-render
[531.556217] Subtest fbc-rgb101010-draw-render: SUCCESS (2.591s)
[532.027234] [110/131] (521s left) gem_exec_params (invalid-fence-in)
[532.090149] Starting subtest: invalid-fence-in
[532.090858] Subtest invalid-fence-in: SUCCESS (0.000s)
[532.209483] [111/131] (521s left) i915_selftest (live)
[533.188203] Starting subtest: live
[533.189054] Starting dynamic subtest: sanitycheck
[535.128399] Dynamic subtest sanitycheck: SUCCESS (1.940s)
[535.143994] Starting dynamic subtest: uncore
[536.689282] Dynamic subtest uncore: SUCCESS (1.560s)
[536.703069] Starting dynamic subtest: workarounds
[538.502205] Dynamic subtest workarounds: SUCCESS (1.812s)
[538.517740] Starting dynamic subtest: gt_engines
[540.008133] Dynamic subtest gt_engines: SUCCESS (1.504s)
[540.023733] Starting dynamic subtest: gt_timelines
[544.205106] Dynamic subtest gt_timelines: SUCCESS (4.196s)
[544.221063] Starting dynamic subtest: gt_contexts
[545.811297] Dynamic subtest gt_contexts: SUCCESS (1.605s)
[545.826505] Starting dynamic subtest: gt_lrc
[547.607310] Dynamic subtest gt_lrc: SUCCESS (1.794s)
[547.623242] Starting dynamic subtest: gt_mocs
[549.173200] Dynamic subtest gt_mocs: SUCCESS (1.564s)
[549.188960] Starting dynamic subtest: gt_pm
[560.310155] Dynamic subtest gt_pm: SUCCESS (11.136s)
[560.330738] Starting dynamic subtest: gt_heartbeat
[561.907309] Dynamic subtest gt_heartbeat: SUCCESS (1.595s)
[561.922306] Starting dynamic subtest: gt_tlb
[563.430206] Dynamic subtest gt_tlb: SUCCESS (1.521s)
[563.444471] Starting dynamic subtest: requests
[569.882369] Dynamic subtest requests: SUCCESS (6.450s)
[569.898344] Starting dynamic subtest: migrate
[571.611147] Dynamic subtest migrate: SUCCESS (1.727s)
[571.625064] Starting dynamic subtest: active
[573.158147] Dynamic subtest active: SUCCESS (1.545s)
[573.172881] Starting dynamic subtest: objects
[575.026146] Dynamic subtest objects: SUCCESS (1.866s)
[575.041960] Starting dynamic subtest: mman
[580.477216] Dynamic subtest mman: SUCCESS (5.449s)
[580.497577] Starting dynamic subtest: dmabuf
[582.084173] Dynamic subtest dmabuf: SUCCESS (1.605s)
[582.099930] Starting dynamic subtest: vma
[583.851412] Dynamic subtest vma: SUCCESS (1.765s)
[583.866502] Starting dynamic subtest: coherency
[586.511189] Dynamic subtest coherency: SUCCESS (2.658s)
[586.527197] Starting dynamic subtest: gtt
[591.174181] Dynamic subtest gtt: SUCCESS (4.660s)
[591.190112] Starting dynamic subtest: gem
[593.231845] Dynamic subtest gem: SUCCESS (2.055s)
[593.247368] Starting dynamic subtest: evict
[594.982594] Dynamic subtest evict: SUCCESS (1.749s)
[594.998529] Starting dynamic subtest: hugepages
[597.098139] Dynamic subtest hugepages: SUCCESS (2.114s)
[597.115709] Starting dynamic subtest: gem_contexts
[602.232326] Dynamic subtest gem_contexts: SUCCESS (5.131s)
[602.252833] Starting dynamic subtest: client
[603.747138] Dynamic subtest client: SUCCESS (1.513s)
[603.762934] Starting dynamic subtest: gem_migrate
[605.247394] Dynamic subtest gem_migrate: SUCCESS (1.498s)
[605.261359] Starting dynamic subtest: reset
[606.999270] Dynamic subtest reset: SUCCESS (1.750s)
[607.014781] Starting dynamic subtest: memory_region
[608.556158] Dynamic subtest memory_region: SUCCESS (1.555s)
[608.570367] Starting dynamic subtest: hangcheck
[611.833681] Dynamic subtest hangcheck: SUCCESS (3.275s)
[611.849504] Starting dynamic subtest: execlists
[613.547256] Dynamic subtest execlists: SUCCESS (1.712s)
[613.561382] Starting dynamic subtest: ring_submission
[615.052196] Dynamic subtest ring_submission: SUCCESS (1.503s)
[615.066431] Starting dynamic subtest: perf
[616.809211] Dynamic subtest perf: SUCCESS (1.755s)
[616.829652] Starting dynamic subtest: slpc
[618.335725] Dynamic subtest slpc: SUCCESS (1.525s)
[618.356620] Starting dynamic subtest: guc
[619.897488] Dynamic subtest guc: SUCCESS (1.558s)
[619.913084] Starting dynamic subtest: guc_multi_lrc
[621.393198] Dynamic subtest guc_multi_lrc: SUCCESS (1.494s)
[621.409864] Starting dynamic subtest: guc_hang
[622.955380] Dynamic subtest guc_hang: SUCCESS (1.560s)
[622.969702] Starting dynamic subtest: late_gt_pm
[624.748214] Dynamic subtest late_gt_pm: SUCCESS (1.790s)
[624.749160] Subtest live: SUCCESS (91.555s)
[624.788563] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[624.789819] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[624.792412] [112/131] (428s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[627.073610] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[627.316496] [FACT kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[627.318362] [FACT kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)] new: kernel.kmod_is_loaded.i915: true
[627.322633] [113/131] (426s left) perf (gen8-unprivileged-single-ctx-counters)
[627.503506] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[627.569529] [114/131] (426s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[627.935158] Starting subtest: fbcpsr-rgb101010-draw-render
[627.936270] Subtest fbcpsr-rgb101010-draw-render: SKIP (0.000s)
[628.377805] [115/131] (425s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[628.737145] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[628.738912] Starting dynamic subtest: AB-VGA1-HDMI-A1
[659.534500] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.794s)
[659.537627] Subtest 2x-flip-vs-blocking-wf-vblank: SUCCESS (30.798s)
[660.189177] [116/131] (393s left) kms_psr (fbc-pr-sprite-render)
[660.547669] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[660.782851] [117/131] (393s left) gen7_exec_parse (chained-batch)
[660.844126] Subtest chained-batch: SKIP (0.000s)
[660.915101] [118/131] (392s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[661.275980] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[661.277623] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[661.726416] [119/131] (392s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[662.085393] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[662.331190] [120/131] (391s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[662.690900] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[665.398421] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SUCCESS (2.705s)
[665.885005] [121/131] (388s left) gem_ctx_param (invalid-ctx-get)
[665.946170] Starting subtest: invalid-ctx-get
[665.947032] Subtest invalid-ctx-get: SUCCESS (0.000s)
[666.051146] [122/131] (388s left) kms_atomic (plane-cursor-legacy)
[666.408491] Starting subtest: plane-cursor-legacy
[666.409341] Starting dynamic subtest: pipe-A-HDMI-A-1
[666.595481] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.186s)
[666.596276] Subtest plane-cursor-legacy: SUCCESS (0.189s)
[667.148661] [123/131] (386s left) gem_render_copy (linear-to-vebox-yf-tiled)
[667.220266] Starting subtest: linear-to-vebox-yf-tiled
[667.222527] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[667.447557] [124/131] (386s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[667.807151] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[667.808672] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[668.247843] [125/131] (385s left) i915_pciid
[668.396573] [126/131] (385s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[668.755999] Starting subtest: bo-too-small-due-to-tiling
[668.756689] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[669.196860] [127/131] (385s left) gem_exec_params (sol-reset-invalid)
[669.259367] Starting subtest: sol-reset-invalid
[669.262652] Subtest sol-reset-invalid: SUCCESS (0.003s)
[669.385578] [128/131] (385s left) gem_pipe_control_store_loop (fresh-buffer)
[669.442945] Starting subtest: fresh-buffer
[671.595397] Subtest fresh-buffer: SUCCESS (2.152s)
[671.726804] [129/131] (382s left) kms_atomic_interruptible (atomic-setmode)
[672.085810] Starting subtest: atomic-setmode
[672.087966] Starting dynamic subtest: pipe-A-HDMI-A-1
[678.376194] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.287s)
[678.376943] Subtest atomic-setmode: SUCCESS (6.290s)
[678.937598] [130/131] (375s left) kms_pm_rpm (cursor)
[690.537911] Subtest cursor: SKIP (0.000s)
[690.772991] [131/131] (363s left) i915_fb_tiling (basic-x-tiling)
[690.835948] Starting subtest: basic-x-tiling
[690.836643] Subtest basic-x-tiling: SUCCESS (0.000s)
[690.945638] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_cursor_crc
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_pm_rpm
results: parsing output: 5/ for test: kms_chamelium_hpd
results: parsing output: 6/ for test: gem_pxp
results: parsing output: 7/ for test: gem_ctx_persistence
results: parsing output: 8/ for test: api_intel_allocator
results: parsing output: 9/ for test: gem_mmap_wc
results: parsing output: 10/ for test: kms_flip_scaled_crc
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: fbdev
results: parsing output: 14/ for test: gem_exec_suspend
results: parsing output: 15/ for test: gem_exec_schedule
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: gem_readwrite
results: parsing output: 18/ for test: kms_rotation_crc
results: parsing output: 19/ for test: gem_ctx_shared
results: parsing output: 20/ for test: syncobj_wait
results: parsing output: 21/ for test: kms_chamelium_hpd
results: parsing output: 22/ for test: gem_lmem_swapping
results: parsing output: 23/ for test: gen9_exec_parse
results: parsing output: 24/ for test: gem_exec_flush
results: parsing output: 25/ for test: gem_exec_schedule
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: kms_cursor_legacy
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: kms_rotation_crc
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_exec_whisper
results: parsing output: 36/ for test: gem_exec_balancer
results: parsing output: 37/ for test: prime_busy
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_plane_scaling
results: parsing output: 42/ for test: kms_rotation_crc
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_basic
results: parsing output: 45/ for test: sw_sync
results: parsing output: 46/ for test: kms_dp_link_training
results: parsing output: 47/ for test: gem_exec_balancer
results: parsing output: 48/ for test: gem_exec_reloc
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: kms_addfb_basic
results: parsing output: 52/ for test: gem_busy
results: parsing output: 53/ for test: i915_pm_rps
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: gem_exec_params
results: parsing output: 56/ for test: kms_pipe_b_c_ivb
results: parsing output: 57/ for test: gem_render_copy
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_rotation_crc
results: parsing output: 60/ for test: kms_plane_alpha_blend
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_vblank
results: parsing output: 63/ for test: perf_pmu
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: sysfs_timeslice_duration
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: kms_chamelium_audio
results: parsing output: 68/ for test: gem_exec_reloc
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: kms_lease
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: perf_pmu
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_pm_backlight
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_exec_fence
results: parsing output: 82/ for test: kms_plane_multiple
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_chamelium_color
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: gem_exec_schedule
results: parsing output: 88/ for test: perf
results: parsing output: 89/ for test: kms_atomic_transition
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_ctx_engines
results: parsing output: 92/ for test: kms_setmode
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: gem_userptr_blits
results: parsing output: 95/ for test: kms_invalid_mode
results: parsing output: 96/ for test: kms_cursor_edge_walk
results: parsing output: 97/ for test: gem_linear_blits
results: parsing output: 98/ for test: kms_vblank
results: parsing output: 99/ for test: gem_mmap_gtt
results: parsing output: 100/ for test: api_intel_bb
results: parsing output: 101/ for test: kms_psr2_sf
results: parsing output: 102/ for test: gem_mmap_gtt
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: gem_userptr_blits
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: gem_exec_fence
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_exec_params
results: parsing output: 110/ for test: i915_selftest
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: perf
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: gen7_exec_parse
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_ctx_param
results: parsing output: 121/ for test: kms_atomic
results: parsing output: 122/ for test: gem_render_copy
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: i915_pciid
results: parsing output: 125/ for test: kms_addfb_basic
results: parsing output: 126/ for test: gem_exec_params
results: parsing output: 127/ for test: gem_pipe_control_store_loop
results: parsing output: 128/ for test: kms_atomic_interruptible
results: parsing output: 129/ for test: kms_pm_rpm
results: parsing output: 130/ for test: i915_fb_tiling
Done.