[69.688199] Initializing watchdogs
[69.688403]   /dev/watchdog0
[69.707634] [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)
[69.715466] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[69.719027] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[69.722293] [001/133] (960s left) kms_cursor_crc (cursor-tearing-position-change)
[70.227477] Starting subtest: cursor-tearing-position-change
[70.228793] Starting dynamic subtest: pipe-A-VGA-1
[70.672197] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.443s)
[70.681971] Starting dynamic subtest: pipe-B-HDMI-A-1
[71.038317] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.365s)
[71.039283] Subtest cursor-tearing-position-change: SUCCESS (0.811s)
[71.314777] [002/133] (958s left) kms_psr (fbc-pr-primary-page-flip)
[71.794612] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[71.846863] [003/133] (958s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[72.329062] Starting subtest: 2x-long-flip-vs-cursor-atomic
[77.505847] Subtest 2x-long-flip-vs-cursor-atomic: SUCCESS (5.176s)
[77.752945] [004/133] (952s left) gem_exec_reloc (basic-write-read)
[77.815263] Starting subtest: basic-write-read
[77.817358] Subtest basic-write-read: SUCCESS (0.002s)
[78.340875] [005/133] (952s left) i915_suspend (forcewake)
[78.395798] Starting subtest: forcewake
[115.193739] Subtest forcewake: SUCCESS (4.658s)
[120.240806] [006/133] (915s left) gem_ctx_shared (detached-shared-gtt)
[120.307141] Subtest detached-shared-gtt: SKIP (0.000s)
[120.402835] [007/133] (915s left) vgem_basic (dmabuf-fence-before)
[120.520617] Starting subtest: dmabuf-fence-before
[120.521776] Subtest dmabuf-fence-before: SUCCESS (0.002s)
[120.604773] [FACT vgem_basic (dmabuf-fence-before)] new: kernel.kmod_is_loaded.vgem: true
[120.607049] [008/133] (914s left) api_intel_bb (bb-with-allocator)
[120.667646] Starting subtest: bb-with-allocator
[120.669183] Subtest bb-with-allocator: SKIP (0.000s)
[120.777668] [009/133] (914s left) gem_exec_fence (concurrent)
[120.957665] Subtest concurrent: SKIP (0.000s)
[121.353002] [010/133] (914s left) kms_atomic_interruptible (atomic-setmode)
[121.853893] Starting subtest: atomic-setmode
[121.856454] Starting dynamic subtest: pipe-A-VGA-1
[128.116918] Dynamic subtest pipe-A-VGA-1: SUCCESS (6.104s)
[128.117476] Subtest atomic-setmode: SUCCESS (6.105s)
[128.394899] [011/133] (907s left) perf (mi-rpc)
[128.517083] Subtest mi-rpc: SKIP (0.000s)
[128.574629] [012/133] (907s left) kms_plane_scaling (intel-max-src-size)
[129.065126] Starting subtest: intel-max-src-size
[129.067034] Subtest intel-max-src-size: SKIP (0.000s)
[129.157471] [013/133] (906s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[129.654934] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[129.656439] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[129.765391] [014/133] (906s left) gen9_exec_parse (basic-rejected)
[129.825891] Subtest basic-rejected: SKIP (0.000s)
[129.897573] [015/133] (906s left) gem_softpin (noreloc-s3)
[129.957335] Starting subtest: noreloc-S3
[167.159382] Subtest noreloc-S3: SUCCESS (5.395s)
[174.215419] [016/133] (868s left) gem_render_copy_redux (flink-interruptible)
[174.281787] Starting subtest: flink-interruptible
[175.477084] Subtest flink-interruptible: SUCCESS (1.160s)
[175.599053] [017/133] (867s left) perf_pmu (frequency)
[175.659232] Starting subtest: frequency
[175.661173] Starting dynamic subtest: gt0
[177.779413] Dynamic subtest gt0: SUCCESS (2.048s)
[177.795278] Starting dynamic subtest: idle-gt0
[178.299478] Dynamic subtest idle-gt0: SUCCESS (0.505s)
[178.300817] Subtest frequency: SUCCESS (2.559s)
[178.401115] [018/133] (864s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[178.457960] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[178.526009] [019/133] (864s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[179.025843] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[180.948768] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (1.883s)
[181.083948] [020/133] (862s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[181.579112] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[181.580381] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[181.699203] [021/133] (861s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[181.756843] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (0.000s)
[181.829894] [022/133] (861s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[182.332247] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[182.333473] Subtest psr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[182.443058] [023/133] (860s left) kms_sequence (get-idle)
[182.932594] Starting subtest: get-idle
[182.933552] Starting dynamic subtest: pipe-A-VGA-1
[185.275867] Dynamic subtest pipe-A-VGA-1: SUCCESS (2.314s)
[185.290415] Starting dynamic subtest: pipe-A-HDMI-A-1
[187.554824] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.256s)
[187.568685] Starting dynamic subtest: pipe-B-VGA-1
[189.766662] Dynamic subtest pipe-B-VGA-1: SUCCESS (2.196s)
[189.780100] Starting dynamic subtest: pipe-B-HDMI-A-1
[192.053537] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.274s)
[192.054392] Subtest get-idle: SUCCESS (9.045s)
[192.299770] [024/133] (851s left) gem_exec_fence (invalid-timeline-fence-array)
[192.617015] Starting subtest: invalid-timeline-fence-array
[192.622637] Subtest invalid-timeline-fence-array: SUCCESS (0.006s)
[192.869307] [025/133] (850s left) kms_chamelium_hpd (vga-hpd)
[193.453792] Subtest vga-hpd: SKIP (0.000s)
[193.669918] [026/133] (849s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[194.163557] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[194.164703] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[194.270667] [027/133] (849s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[194.767066] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[194.769904] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.001s)
[194.875315] [028/133] (848s left) kms_psr (fbc-psr-cursor-render)
[195.359069] Subtest fbc-psr-cursor-render: SKIP (0.000s)
[195.421662] [029/133] (848s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[195.908552] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[195.910316] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[196.009259] [030/133] (847s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[196.065016] Starting subtest: single-wait-all-for-submit-available-submitted
[196.065729] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[196.166866] [031/133] (847s left) gem_ctx_engines (execute-one)
[196.232655] Starting subtest: execute-one
[196.588685] Subtest execute-one: SUCCESS (0.355s)
[196.794256] [032/133] (847s left) kms_content_protection (lic-type-1)
[197.296296] Starting subtest: lic-type-1
[197.298017] Subtest lic-type-1: SKIP (0.000s)
[197.408821] [033/133] (846s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[197.894544] Starting subtest: yf-tiled-64bpp-rotate-90
[197.895813] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[198.010778] [034/133] (845s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[198.071262] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[198.174379] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.102s)
[198.277345] [035/133] (845s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[198.767260] Starting subtest: flip-vs-cursor-atomic
[208.672881] Subtest flip-vs-cursor-atomic: SUCCESS (9.897s)
[208.930046] [036/133] (835s left) kms_pm_rpm (pc8-residency)
[220.713593] Subtest pc8-residency: SKIP (0.000s)
[220.778503] [037/133] (823s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[220.848284] Starting subtest: yf-tiled-to-vebox-y-tiled
[220.850271] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[221.054622] [038/133] (823s left) gem_pwrite (basic-random)
[221.108061] Starting subtest: basic-random
[226.820130] Subtest basic-random: SUCCESS (5.708s)
[226.951494] [039/133] (817s left) sysfs_heartbeat_interval (precise)
[227.098816] Starting subtest: precise
[227.100304] Starting dynamic subtest: vcs0
[227.101440] Dynamic subtest vcs0: SKIP (0.000s)
[227.116865] Starting dynamic subtest: bcs0
[227.119318] Dynamic subtest bcs0: SKIP (0.000s)
[227.134680] Starting dynamic subtest: rcs0
[227.137092] Dynamic subtest rcs0: SKIP (0.000s)
[227.139060] Subtest precise: SKIP (0.003s)
[227.205227] [040/133] (817s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[227.702725] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[227.703731] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[227.831565] [041/133] (816s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[228.326948] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[228.328424] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[228.434830] [042/133] (815s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[228.927542] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[231.385925] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (2.457s)
[231.645302] [043/133] (812s left) kms_big_fb (linear-16bpp-rotate-270)
[232.140476] Starting subtest: linear-16bpp-rotate-270
[232.241740] Subtest linear-16bpp-rotate-270: SKIP (0.100s)
[232.464276] [044/133] (812s left) kms_cursor_crc (cursor-sliding-128x42)
[232.969866] Starting subtest: cursor-sliding-128x42
[233.021364] Subtest cursor-sliding-128x42: SKIP (0.050s)
[233.142520] [045/133] (811s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[233.202201] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[233.254929] [046/133] (811s left) gem_lmem_swapping (parallel-random-engines)
[233.327099] Subtest parallel-random-engines: SKIP (0.000s)
[233.388126] [047/133] (811s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[233.872752] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[235.319418] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SUCCESS (1.446s)
[235.470242] [048/133] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[235.954449] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[235.955517] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[236.085850] [049/133] (808s left) kms_psr (pr-sprite-plane-move)
[236.568913] Subtest pr-sprite-plane-move: SKIP (0.000s)
[236.631748] [050/133] (808s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[237.119480] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[237.240763] Starting dynamic subtest: pipe-A-plane-0
[237.942716] Dynamic subtest pipe-A-plane-0: SUCCESS (0.702s)
[237.959214] Starting dynamic subtest: pipe-A-plane-1
[238.310854] Dynamic subtest pipe-A-plane-1: SUCCESS (0.366s)
[238.532702] Starting dynamic subtest: pipe-B-plane-0
[239.698128] Dynamic subtest pipe-B-plane-0: SUCCESS (1.180s)
[239.715411] Starting dynamic subtest: pipe-B-plane-1
[240.064303] Dynamic subtest pipe-B-plane-1: SUCCESS (0.364s)
[240.163549] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.043s)
[240.442179] [051/133] (804s left) gem_mmap_gtt (basic-copy)
[240.501259] Starting subtest: basic-copy
[240.715783] Subtest basic-copy: SUCCESS (0.215s)
[240.839319] [052/133] (804s left) kms_plane_multiple (2x-tiling-x)
[241.320499] Starting subtest: 2x-tiling-x
[241.321298] Starting dynamic subtest: pipe-A-VGA-1-pipe-B-HDMI-A-1
[241.995443] Dynamic subtest pipe-A-VGA-1-pipe-B-HDMI-A-1: SUCCESS (0.674s)
[242.044837] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-B-VGA-1
[242.824795] Dynamic subtest pipe-A-HDMI-A-1-pipe-B-VGA-1: SUCCESS (0.793s)
[242.862006] Starting dynamic subtest: pipe-B-VGA-1-pipe-A-HDMI-A-1
[243.535057] Dynamic subtest pipe-B-VGA-1-pipe-A-HDMI-A-1: SUCCESS (0.691s)
[243.567599] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-A-VGA-1
[244.394101] Dynamic subtest pipe-B-HDMI-A-1-pipe-A-VGA-1: SUCCESS (0.839s)
[244.410838] Subtest 2x-tiling-x: SUCCESS (3.090s)
[244.599449] [053/133] (800s left) gem_exec_schedule (u-submit-golden-slice)
[244.674437] Subtest u-submit-golden-slice: SKIP (0.000s)
[244.884010] [054/133] (800s left) kms_lease (possible-crtcs-filtering)
[245.360560] Starting subtest: possible-crtcs-filtering
[245.362217] Subtest possible-crtcs-filtering: SUCCESS (0.003s)
[245.466903] [055/133] (799s left) kms_frontbuffer_tracking (basic)
[245.951264] Starting subtest: basic
[248.293083] Subtest basic: SUCCESS (2.338s)
[248.514308] [056/133] (796s left) core_setmaster (master-drop-set-root)
[248.615765] Starting subtest: master-drop-set-root
[248.644447] Subtest master-drop-set-root: SUCCESS (0.027s)
[248.710854] [057/133] (796s left) kms_vblank (query-forked)
[249.192458] Starting subtest: query-forked
[249.193283] Starting dynamic subtest: pipe-A-VGA-1
[251.590411] Dynamic subtest pipe-A-VGA-1: SUCCESS (2.395s)
[251.606010] Starting dynamic subtest: pipe-A-HDMI-A-1
[253.904100] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.311s)
[253.920828] Starting dynamic subtest: pipe-B-VGA-1
[256.168011] Dynamic subtest pipe-B-VGA-1: SUCCESS (2.261s)
[256.184186] Starting dynamic subtest: pipe-B-HDMI-A-1
[258.499369] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.327s)
[258.500047] Subtest query-forked: SUCCESS (9.303s)
[258.810393] [058/133] (786s left) gem_madvise (dontneed-before-pwrite)
[258.869234] Starting subtest: dontneed-before-pwrite
[258.871389] Subtest dontneed-before-pwrite: SUCCESS (0.002s)
[258.979658] [059/133] (786s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[259.459800] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[259.461055] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[259.568126] [060/133] (785s left) i915_pm_rpm (system-suspend-devices)
[271.385017] Subtest system-suspend-devices: SKIP (0.000s)
[271.457630] [061/133] (773s left) kms_psr (psr2-cursor-mmap-cpu)
[271.933354] Subtest psr2-cursor-mmap-cpu: SKIP (0.000s)
[271.997432] [062/133] (773s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[272.472634] Starting subtest: primary-y-tiled-reflect-x-270
[272.473758] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[272.573481] [063/133] (772s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[273.054844] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[273.056804] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[273.174038] [064/133] (772s left) api_intel_bb (object-reloc-purge-cache)
[273.231640] Starting subtest: object-reloc-purge-cache
[273.233495] Subtest object-reloc-purge-cache: SUCCESS (0.003s)
[273.354762] [065/133] (772s left) i915_drm_fdinfo (memory-info-idle)
[273.411405] Subtest memory-info-idle: SKIP (0.000s)
[273.470182] [066/133] (772s left) kms_big_fb (y-tiled-addfb-size-overflow)
[273.957576] Starting subtest: y-tiled-addfb-size-overflow
[273.959019] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[274.078453] [067/133] (771s left) gem_ctx_bad_destroy (invalid-ctx)
[274.135371] Starting subtest: invalid-ctx
[274.136073] Subtest invalid-ctx: SUCCESS (0.000s)
[274.236027] [068/133] (771s left) gem_exec_fence (basic-busy-all)
[274.305349] Starting subtest: basic-busy-all
[274.337234] Subtest basic-busy-all: SUCCESS (0.032s)
[274.821110] [069/133] (771s left) prime_vgem (basic-fence-read)
[274.899290] Starting subtest: basic-fence-read
[274.944075] Subtest basic-fence-read: SUCCESS (0.044s)
[275.051934] [070/133] (770s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[275.533956] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[277.399726] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (1.866s)
[277.640013] [071/133] (768s left) gem_flink_basic (bad-open)
[277.700756] Starting subtest: bad-open
[277.701380] Subtest bad-open: SUCCESS (0.000s)
[277.820817] [072/133] (768s left) gem_exec_balancer (bonded-dual)
[277.882503] Subtest bonded-dual: SKIP (0.000s)
[277.985418] [073/133] (768s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[278.047878] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[278.116529] [074/133] (767s left) gem_spin_batch (user-each)
[278.184338] Starting subtest: user-each
[281.521222] Subtest user-each: SUCCESS (3.338s)
[281.747132] [075/133] (764s left) perf_pmu (idle)
[281.805633] Starting subtest: idle
[281.806325] Starting dynamic subtest: rcs0
[282.330195] Dynamic subtest rcs0: SUCCESS (0.521s)
[282.348697] Starting dynamic subtest: bcs0
[282.849570] Dynamic subtest bcs0: SUCCESS (0.518s)
[282.866967] Starting dynamic subtest: vcs0
[283.372292] Dynamic subtest vcs0: SUCCESS (0.520s)
[283.376217] Subtest idle: SUCCESS (1.568s)
[283.479307] [076/133] (762s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[283.538440] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[283.603965] [077/133] (762s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[284.080697] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[284.161975] [078/133] (762s left) kms_addfb_basic (clobberred-modifier)
[284.221828] Starting subtest: clobberred-modifier
[284.222558] Subtest clobberred-modifier: SUCCESS (0.000s)
[284.749803] [079/133] (761s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[285.227728] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[285.286295] [080/133] (761s left) gem_workarounds (basic-read-fd)
[285.359212] Starting subtest: basic-read-fd
[285.364180] Subtest basic-read-fd: SUCCESS (0.005s)
[285.489523] [081/133] (761s left) gem_ctx_persistence (process)
[285.553446] Subtest process: SKIP (0.000s)
[285.617429] [082/133] (760s left) perf (polling)
[285.778622] Subtest polling: SKIP (0.000s)
[285.836463] [083/133] (760s left) gem_userptr_blits (coherency-sync)
[285.915957] Starting subtest: coherency-sync
[312.043785] Subtest coherency-sync: SUCCESS (26.130s)
[312.184044] [084/133] (734s left) gem_exec_fence (syncobj-wait)
[312.478295] Starting subtest: syncobj-wait
[312.508720] Subtest syncobj-wait: SUCCESS (0.030s)
[312.856287] [085/133] (733s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[312.911036] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[312.979246] [086/133] (733s left) kms_draw_crc (draw-method-blt)
[313.464813] Starting subtest: draw-method-blt
[313.465607] Starting dynamic subtest: xrgb8888-untiled
[313.790242] Dynamic subtest xrgb8888-untiled: SUCCESS (0.325s)
[313.807176] Starting dynamic subtest: rgb565-untiled
[314.058194] Dynamic subtest rgb565-untiled: SUCCESS (0.266s)
[314.076474] Starting dynamic subtest: xrgb2101010-untiled
[314.342473] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.282s)
[314.359640] Starting dynamic subtest: xbgr16161616f-untiled
[314.626724] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.282s)
[314.644335] Starting dynamic subtest: xrgb8888-xtiled
[314.760532] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.131s)
[314.778504] Starting dynamic subtest: rgb565-xtiled
[314.893638] Dynamic subtest rgb565-xtiled: SUCCESS (0.130s)
[314.910231] Starting dynamic subtest: xrgb2101010-xtiled
[315.027928] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.132s)
[315.044784] Starting dynamic subtest: xbgr16161616f-xtiled
[315.178338] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.148s)
[315.181071] Subtest draw-method-blt: SUCCESS (1.715s)
[315.421515] [087/133] (731s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[315.481252] Starting subtest: writes-after-reads-uncached
[320.528457] Subtest writes-after-reads-uncached: SUCCESS (5.046s)
[320.659166] [088/133] (726s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[321.148705] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[322.805195] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SUCCESS (1.656s)
[322.974257] [089/133] (723s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[323.456609] Starting subtest: extended-pageflip-modeset-hang-oldfb
[323.458920] Starting dynamic subtest: pipe-A
[329.864157] Dynamic subtest pipe-A: SUCCESS (6.403s)
[329.880766] Starting dynamic subtest: pipe-B
[335.843078] Dynamic subtest pipe-B: SUCCESS (5.976s)
[335.845233] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (12.386s)
[336.117095] [090/133] (710s left) kms_plane_scaling (planes-downscale-factor-0-75)
[336.598963] Starting subtest: planes-downscale-factor-0-75
[336.599518] Starting dynamic subtest: pipe-A
[336.601419] Dynamic subtest pipe-A: SKIP (0.002s)
[336.620370] Starting dynamic subtest: pipe-B
[336.623728] Dynamic subtest pipe-B: SKIP (0.002s)
[336.625504] Subtest planes-downscale-factor-0-75: SKIP (0.008s)
[336.698313] [091/133] (710s left) syncobj_wait (invalid-reset-zero-handles)
[336.763784] Starting subtest: invalid-reset-zero-handles
[336.764441] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[336.867247] [092/133] (710s left) kms_cursor_crc (cursor-onscreen-128x42)
[337.349757] Starting subtest: cursor-onscreen-128x42
[337.402537] Subtest cursor-onscreen-128x42: SKIP (0.051s)
[337.534937] [093/133] (709s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[338.018469] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[338.020102] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[338.135718] [094/133] (709s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[338.618148] Starting subtest: x-tiled-16bpp-rotate-90
[338.703595] Subtest x-tiled-16bpp-rotate-90: SKIP (0.084s)
[338.941844] [095/133] (708s left) prime_mmap (test_dup)
[339.000717] Starting subtest: test_dup
[339.001327] Starting dynamic subtest: test_dup-smem
[339.002861] Dynamic subtest test_dup-smem: SUCCESS (0.003s)
[339.004614] Subtest test_dup: SUCCESS (0.004s)
[339.121460] [096/133] (708s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[339.194301] Starting subtest: y-tiled-ccs-to-y-tiled
[339.196224] Starting dynamic subtest: smem
[339.197868] Dynamic subtest smem: SKIP (0.000s)
[339.199516] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.002s)
[339.410612] [097/133] (707s left) kms_pipe_crc_basic (nonblocking-crc)
[339.888406] Starting subtest: nonblocking-crc
[339.889388] Starting dynamic subtest: pipe-A-VGA-1
[340.530194] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.640s)
[340.546868] Starting dynamic subtest: pipe-B-HDMI-A-1
[341.127578] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.594s)
[341.128184] Subtest nonblocking-crc: SUCCESS (1.239s)
[341.390834] [098/133] (706s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[341.988487] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[342.220955] [099/133] (705s left) kms_getfb (getfb2-into-addfb2)
[342.699687] Starting subtest: getfb2-into-addfb2
[342.700335] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[342.806846] [100/133] (704s left) kms_3d (basic)
[342.867657] Starting subtest: basic
[346.379165] Subtest basic: SUCCESS (3.511s)
[346.800160] [101/133] (700s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[358.570191] Subtest dpms-mode-unset-non-lpsp: SKIP (0.000s)
[358.641199] [102/133] (689s left) gem_ctx_persistence (engines-cleanup)
[358.702968] Subtest engines-cleanup: SKIP (0.000s)
[358.778979] [103/133] (688s left) gem_softpin (evict-snoop)
[358.838804] Starting subtest: evict-snoop
[358.840245] Subtest evict-snoop: SKIP (0.000s)
[358.945752] [104/133] (688s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[359.012232] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[359.012845] Starting dynamic subtest: smem
[359.014098] Dynamic subtest smem: SKIP (0.000s)
[359.015614] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.002s)
[359.226006] [105/133] (688s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[359.715955] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[359.717009] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[359.843612] [106/133] (688s left) prime_busy (after-wait)
[359.903397] Starting subtest: after-wait
[359.910809] Starting dynamic subtest: rcs0
[359.924773] Dynamic subtest rcs0: SUCCESS (0.014s)
[359.944721] Starting dynamic subtest: bcs0
[359.945675] Dynamic subtest bcs0: SUCCESS (0.015s)
[359.961153] Starting dynamic subtest: vcs0
[359.961771] Dynamic subtest vcs0: SUCCESS (0.017s)
[360.069309] Subtest after-wait: SUCCESS (0.163s)
[360.170421] [107/133] (687s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[360.225862] Starting subtest: invalid-single-wait-unsubmitted
[360.226538] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[360.328869] [108/133] (687s left) gem_exec_schedule (preempt)
[360.400849] Subtest preempt: SKIP (0.000s)
[360.606235] [109/133] (687s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[361.086261] Starting subtest: cursorB-vs-flipA-atomic-transitions
[372.040041] Subtest cursorB-vs-flipA-atomic-transitions: SUCCESS (10.946s)
[372.304781] [110/133] (675s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[372.369435] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[372.371302] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[372.465718] [111/133] (675s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[372.524356] Subtest invalidate-primary-flip-overlay: SKIP (0.000s)
[372.611171] [112/133] (675s left) gem_mmap_offset (mmap-unmap)
[372.671996] Starting subtest: mmap-unmap
[372.672560] Starting dynamic subtest: smem0
[443.076046] Dynamic subtest smem0: SUCCESS (70.409s)
[443.077978] Subtest mmap-unmap: SUCCESS (70.411s)
[443.249055] [113/133] (605s left) gem_userptr_blits (sd-probe)
[443.308412] Starting subtest: sd-probe
[443.310315] Subtest sd-probe: SUCCESS (0.001s)
[443.432445] [114/133] (604s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[443.486428] Starting subtest: etime-single-wait-for-submit-submitted
[443.590419] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.103s)
[443.688509] [115/133] (604s left) kms_color (ctm-red-to-blue)
[444.162718] Starting subtest: ctm-red-to-blue
[444.163378] Starting dynamic subtest: pipe-A-VGA-1
[444.694446] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.532s)
[444.711619] Starting dynamic subtest: pipe-A-HDMI-A-1
[445.190535] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.494s)
[445.207642] Starting dynamic subtest: pipe-B-VGA-1
[445.602605] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.410s)
[445.619770] Starting dynamic subtest: pipe-B-HDMI-A-1
[446.117082] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.514s)
[446.118645] Subtest ctm-red-to-blue: SUCCESS (1.957s)
[446.404799] [116/133] (602s left) kms_flip (2x-flip-vs-suspend-interruptible)
[446.889485] Starting subtest: 2x-flip-vs-suspend-interruptible
[446.891723] Starting dynamic subtest: AB-VGA1-HDMI-A1
[537.046350] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (12.456s)
[537.050480] Subtest 2x-flip-vs-suspend-interruptible: SUCCESS (12.653s)
[544.117115] [117/133] (511s left) gem_bad_reloc (negative-reloc-lut)
[544.179644] Starting subtest: negative-reloc-lut
[544.180787] Subtest negative-reloc-lut: SKIP (0.000s)
[544.297635] [118/133] (511s left) kms_atomic_transition (modeset-transition-fencing)
[544.780913] Starting subtest: modeset-transition-fencing
[544.781468] Starting dynamic subtest: 1x-outputs
[545.584849] Dynamic subtest 1x-outputs: SUCCESS (0.768s)
[545.607327] Starting dynamic subtest: 2x-outputs
[547.817532] Dynamic subtest 2x-outputs: SUCCESS (2.154s)
[547.820161] Subtest modeset-transition-fencing: SUCCESS (2.927s)
[548.111748] [119/133] (507s left) gem_readwrite (write-bad-handle)
[548.169967] Starting subtest: write-bad-handle
[548.172365] Subtest write-bad-handle: SUCCESS (0.000s)
[548.283332] [120/133] (507s left) gem_eio (wait-10ms)
[548.350558] Starting subtest: wait-10ms
[548.394780] Subtest wait-10ms: SUCCESS (0.043s)
[548.932939] [121/133] (506s left) gem_mmap_gtt (cpuset-big-copy-xy)
[548.993959] Starting subtest: cpuset-big-copy-XY
[552.410615] Subtest cpuset-big-copy-XY: SUCCESS (3.345s)
[552.625056] [122/133] (503s left) kms_vrr (seamless-rr-switch-virtual)
[553.206067] Starting subtest: seamless-rr-switch-virtual
[553.208395] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[553.321183] [123/133] (502s left) perf_pmu (all-busy-idle-check-all)
[553.390376] Starting subtest: all-busy-idle-check-all
[554.018017] Subtest all-busy-idle-check-all: SUCCESS (0.618s)
[554.124505] [124/133] (501s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[554.609978] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[554.612439] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[554.725194] [125/133] (501s left) gem_exec_schedule (u-lateslice)
[554.802119] Subtest u-lateslice: SKIP (0.000s)
[555.011436] [126/133] (501s left) kms_invalid_mode (zero-vdisplay)
[555.494252] Starting subtest: zero-vdisplay
[555.496272] Starting dynamic subtest: pipe-A-VGA-1
[555.616696] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.118s)
[555.636295] Starting dynamic subtest: pipe-A-HDMI-A-1
[555.637392] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[555.657916] Starting dynamic subtest: pipe-B-VGA-1
[555.658608] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.001s)
[555.675791] Starting dynamic subtest: pipe-B-HDMI-A-1
[555.676453] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[555.677064] Subtest zero-vdisplay: SUCCESS (0.133s)
[555.916137] [127/133] (500s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[555.976875] Starting subtest: basic-cpu-gtt-noreloc
[555.979612] Subtest basic-cpu-gtt-noreloc: SUCCESS (0.003s)
[556.503157] [128/133] (499s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[556.986741] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[556.987842] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[557.115912] [129/133] (499s left) gem_exec_reloc (basic-cpu-read)
[557.177600] Starting subtest: basic-cpu-read
[557.179840] Subtest basic-cpu-read: SUCCESS (0.003s)
[557.702098] [130/133] (498s left) gem_mmap_gtt (basic-small-bo)
[557.760741] Starting subtest: basic-small-bo
[557.959776] Subtest basic-small-bo: SUCCESS (0.197s)
[558.093615] [131/133] (498s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[558.665334] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[558.738244] [132/133] (497s left) kms_flip (2x-dpms-vs-vblank-race)
[559.214601] Starting subtest: 2x-dpms-vs-vblank-race
[559.216839] Starting dynamic subtest: AB-VGA1-HDMI-A1
[570.044837] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (10.783s)
[570.047041] Subtest 2x-dpms-vs-vblank-race: SUCCESS (10.789s)
[570.323987] [133/133] (486s left) i915_hangman (gt-engine-error)
[570.398968] Starting subtest: gt-engine-error
[570.400260] Subtest gt-engine-error: SKIP (0.000s)
[570.472928] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: kms_cursor_legacy
results: parsing output: 3/ for test: gem_exec_reloc
results: parsing output: 4/ for test: i915_suspend
results: parsing output: 5/ for test: gem_ctx_shared
results: parsing output: 6/ for test: vgem_basic
results: parsing output: 7/ for test: api_intel_bb
results: parsing output: 8/ for test: gem_exec_fence
results: parsing output: 9/ for test: kms_atomic_interruptible
results: parsing output: 10/ for test: perf
results: parsing output: 11/ for test: kms_plane_scaling
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gen9_exec_parse
results: parsing output: 14/ for test: gem_softpin
results: parsing output: 15/ for test: gem_render_copy_redux
results: parsing output: 16/ for test: perf_pmu
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_flip_scaled_crc
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_sequence
results: parsing output: 23/ for test: gem_exec_fence
results: parsing output: 24/ for test: kms_chamelium_hpd
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: gem_ctx_engines
results: parsing output: 31/ for test: kms_content_protection
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_cursor_legacy
results: parsing output: 35/ for test: kms_pm_rpm
results: parsing output: 36/ for test: gem_render_copy
results: parsing output: 37/ for test: gem_pwrite
results: parsing output: 38/ for test: sysfs_heartbeat_interval
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_frontbuffer_tracking
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: kms_cursor_crc
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: gem_lmem_swapping
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_plane
results: parsing output: 50/ for test: gem_mmap_gtt
results: parsing output: 51/ for test: kms_plane_multiple
results: parsing output: 52/ for test: gem_exec_schedule
results: parsing output: 53/ for test: kms_lease
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: core_setmaster
results: parsing output: 56/ for test: kms_vblank
results: parsing output: 57/ for test: gem_madvise
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: i915_pm_rpm
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_rotation_crc
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: api_intel_bb
results: parsing output: 64/ for test: i915_drm_fdinfo
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: gem_ctx_bad_destroy
results: parsing output: 67/ for test: gem_exec_fence
results: parsing output: 68/ for test: prime_vgem
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_flink_basic
results: parsing output: 71/ for test: gem_exec_balancer
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: gem_spin_batch
results: parsing output: 74/ for test: perf_pmu
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_psr2_sf
results: parsing output: 77/ for test: kms_addfb_basic
results: parsing output: 78/ for test: kms_psr2_sf
results: parsing output: 79/ for test: gem_workarounds
results: parsing output: 80/ for test: gem_ctx_persistence
results: parsing output: 81/ for test: perf
results: parsing output: 82/ for test: gem_userptr_blits
results: parsing output: 83/ for test: gem_exec_fence
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: kms_draw_crc
results: parsing output: 86/ for test: gem_partial_pwrite_pread
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_busy
results: parsing output: 89/ for test: kms_plane_scaling
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: kms_cursor_crc
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: prime_mmap
results: parsing output: 95/ for test: gem_render_copy
results: parsing output: 96/ for test: kms_pipe_crc_basic
results: parsing output: 97/ for test: kms_chamelium_edid
results: parsing output: 98/ for test: kms_getfb
results: parsing output: 99/ for test: kms_3d
results: parsing output: 100/ for test: kms_pm_rpm
results: parsing output: 101/ for test: gem_ctx_persistence
results: parsing output: 102/ for test: gem_softpin
results: parsing output: 103/ for test: gem_render_copy
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: prime_busy
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: gem_exec_schedule
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: kms_psr_stress_test
results: parsing output: 111/ for test: gem_mmap_offset
results: parsing output: 112/ for test: gem_userptr_blits
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_color
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: gem_bad_reloc
results: parsing output: 117/ for test: kms_atomic_transition
results: parsing output: 118/ for test: gem_readwrite
results: parsing output: 119/ for test: gem_eio
results: parsing output: 120/ for test: gem_mmap_gtt
results: parsing output: 121/ for test: kms_vrr
results: parsing output: 122/ for test: perf_pmu
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_exec_schedule
results: parsing output: 125/ for test: kms_invalid_mode
results: parsing output: 126/ for test: gem_exec_reloc
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_exec_reloc
results: parsing output: 129/ for test: gem_mmap_gtt
results: parsing output: 130/ for test: kms_psr2_sf
results: parsing output: 131/ for test: kms_flip
results: parsing output: 132/ for test: i915_hangman
Done.