[64.380200] Initializing watchdogs
[64.380579]   /dev/watchdog0
[64.433501] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:5a85 Intel Broxton (Gen9) HD Graphics 500
[64.464668] [001/161] (960s left) i915_module_load (load)
[65.128150] Starting subtest: load
[69.751080] Subtest load: SUCCESS (4.659s)
[69.963462] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[69.971678] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[70.002191] [002/161] (955s left) core_auth (basic-auth)
[70.353287] Starting subtest: basic-auth
[70.373343] Subtest basic-auth: SUCCESS (0.002s)
[70.565224] [003/161] (954s left) debugfs_test (read_all_entries)
[70.875089] Starting subtest: read_all_entries
[71.012406] Subtest read_all_entries: SUCCESS (0.159s)
[71.332206] [004/161] (954s left) debugfs_test (basic-hwmon)
[71.570467] Starting subtest: basic-hwmon
[71.613274] Subtest basic-hwmon: SKIP (0.000s)
[71.854062] [005/161] (953s left) debugfs_test (sysfs)
[72.131056] Starting subtest: sysfs
[72.276144] Subtest sysfs: SUCCESS (0.172s)
[72.561964] [006/161] (953s left) fbdev (eof)
[72.789948] Starting subtest: eof
[72.812514] Subtest eof: SUCCESS (0.001s)
[72.982933] [007/161] (953s left) fbdev (info)
[73.227833] Starting subtest: info
[73.247987] Subtest info: SUCCESS (0.000s)
[73.404089] [008/161] (952s left) fbdev (nullptr)
[73.654516] Starting subtest: nullptr
[73.676903] Subtest nullptr: SUCCESS (0.000s)
[73.829125] [009/161] (952s left) fbdev (read)
[74.082227] Starting subtest: read
[75.548189] Subtest read: SUCCESS (1.499s)
[75.707612] [010/161] (950s left) fbdev (write)
[75.963839] Starting subtest: write
[76.709285] Subtest write: SUCCESS (0.782s)
[76.875383] [011/161] (949s left) gem_basic (bad-close)
[77.137818] Starting subtest: bad-close
[77.184076] Subtest bad-close: SUCCESS (0.000s)
[77.347204] [012/161] (949s left) gem_basic (create-close)
[77.616228] Starting subtest: create-close
[77.664258] Subtest create-close: SUCCESS (0.000s)
[77.827506] [013/161] (949s left) gem_basic (create-fd-close)
[78.075809] Starting subtest: create-fd-close
[78.118980] Subtest create-fd-close: SUCCESS (0.000s)
[78.274486] [014/161] (948s left) gem_busy (busy@all-engines)
[78.543925] Starting subtest: busy
[78.566108] Starting dynamic subtest: all-engines
[78.648957] Dynamic subtest all-engines: SUCCESS (0.113s)
[78.672301] Subtest busy: SUCCESS (0.113s)
[79.143476] [015/161] (948s left) gem_close_race (basic-process)
[79.406451] Starting subtest: basic-process
[79.508659] Subtest basic-process: SUCCESS (0.109s)
[79.801871] [016/161] (947s left) gem_close_race (basic-threads)
[80.048886] Starting subtest: basic-threads
[81.367293] Subtest basic-threads: SUCCESS (1.308s)
[81.648336] [017/161] (945s left) gem_ctx_create (basic)
[81.892209] Starting subtest: basic
[81.912753] Subtest basic: SUCCESS (0.000s)
[82.182058] [018/161] (945s left) gem_ctx_create (basic-files)
[82.446775] Starting subtest: basic-files
[84.495511] Subtest basic-files: SUCCESS (2.044s)
[84.791669] [019/161] (943s left) gem_ctx_exec (basic)
[85.059949] Starting subtest: basic
[85.085683] Subtest basic: SUCCESS (0.011s)
[85.258470] [020/161] (942s left) gem_exec_basic (basic)
[85.545655] Starting subtest: basic
[85.566572] Starting dynamic subtest: rcs0-smem
[85.586826] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[85.631227] Starting dynamic subtest: bcs0-smem
[85.654946] Dynamic subtest bcs0-smem: SUCCESS (0.003s)
[85.704232] Starting dynamic subtest: vcs0-smem
[85.724714] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[85.768286] Starting dynamic subtest: vecs0-smem
[85.791094] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[85.811985] Subtest basic: SUCCESS (0.013s)
[85.967777] [021/161] (942s left) gem_exec_create (basic)
[86.209126] Starting subtest: basic
[86.231894] Starting dynamic subtest: smem
[88.300992] Dynamic subtest smem: SUCCESS (2.075s)
[88.321721] Subtest basic: SUCCESS (2.076s)
[88.578800] [022/161] (939s left) gem_exec_fence (basic-busy)
[88.957737] Starting subtest: basic-busy
[88.978317] Starting dynamic subtest: rcs0
[89.023094] Dynamic subtest rcs0: SUCCESS (0.037s)
[89.076701] Starting dynamic subtest: bcs0
[89.125488] Dynamic subtest bcs0: SUCCESS (0.039s)
[89.187809] Starting dynamic subtest: vcs0
[89.231648] Dynamic subtest vcs0: SUCCESS (0.054s)
[89.273382] Starting dynamic subtest: vecs0
[89.314550] Dynamic subtest vecs0: SUCCESS (0.029s)
[89.337274] Subtest basic-busy: SUCCESS (0.160s)
[90.015540] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[90.039806] [023/161] (938s left) gem_exec_fence (basic-wait)
[90.420053] Starting subtest: basic-wait
[90.440398] Starting dynamic subtest: rcs0
[90.463302] Dynamic subtest rcs0: SUCCESS (0.031s)
[90.512106] Starting dynamic subtest: bcs0
[90.533129] Dynamic subtest bcs0: SUCCESS (0.039s)
[90.590136] Starting dynamic subtest: vcs0
[90.613514] Dynamic subtest vcs0: SUCCESS (0.034s)
[90.669159] Starting dynamic subtest: vecs0
[90.689536] Dynamic subtest vecs0: SUCCESS (0.033s)
[90.709497] Subtest basic-wait: SUCCESS (0.139s)
[91.367389] [024/161] (937s left) gem_exec_fence (basic-await)
[91.733497] Starting subtest: basic-await
[91.757342] Starting dynamic subtest: rcs0
[91.895082] Dynamic subtest rcs0: SUCCESS (0.164s)
[91.940524] Starting dynamic subtest: bcs0
[92.060888] Dynamic subtest bcs0: SUCCESS (0.163s)
[92.104133] Starting dynamic subtest: vcs0
[92.230460] Dynamic subtest vcs0: SUCCESS (0.167s)
[92.274183] Starting dynamic subtest: vecs0
[92.398959] Dynamic subtest vecs0: SUCCESS (0.167s)
[92.422430] Subtest basic-await: SUCCESS (0.665s)
[93.222444] [025/161] (935s left) gem_exec_fence (nb-await)
[93.585607] Starting subtest: nb-await
[93.606960] Starting dynamic subtest: rcs0
[93.667504] Dynamic subtest rcs0: SUCCESS (0.081s)
[93.715504] Starting dynamic subtest: bcs0
[93.765815] Dynamic subtest bcs0: SUCCESS (0.099s)
[93.814269] Starting dynamic subtest: vcs0
[93.865704] Dynamic subtest vcs0: SUCCESS (0.098s)
[93.912461] Starting dynamic subtest: vecs0
[93.957367] Dynamic subtest vecs0: SUCCESS (0.073s)
[93.978686] Subtest nb-await: SUCCESS (0.355s)
[94.752121] [026/161] (934s left) gem_exec_gttfill (basic)
[94.997094] Starting subtest: basic
[125.330795] Subtest basic: SUCCESS (30.335s)
[125.665621] [027/161] (903s left) gem_exec_parallel (engines)
[126.069570] Starting subtest: engines
[126.089632] Starting dynamic subtest: basic
[130.396304] Dynamic subtest basic: SUCCESS (4.154s)
[130.444444] Starting dynamic subtest: contexts
[135.991616] Dynamic subtest contexts: SUCCESS (5.629s)
[136.040039] Starting dynamic subtest: fds
[141.500359] Dynamic subtest fds: SUCCESS (5.504s)
[141.546809] Starting dynamic subtest: userptr
[145.709823] Dynamic subtest userptr: SUCCESS (4.189s)
[145.732479] Subtest engines: SUCCESS (19.479s)
[145.907262] [028/161] (883s left) gem_exec_store (basic)
[146.249302] Starting subtest: basic
[146.270583] Subtest basic: SUCCESS (0.078s)
[146.542726] [029/161] (883s left) gem_flink_basic (bad-flink)
[146.805640] Starting subtest: bad-flink
[146.827843] Subtest bad-flink: SUCCESS (0.000s)
[146.994351] [030/161] (882s left) gem_flink_basic (bad-open)
[147.258227] Starting subtest: bad-open
[147.282247] Subtest bad-open: SUCCESS (0.000s)
[147.448600] [031/161] (882s left) gem_flink_basic (basic)
[147.671379] Starting subtest: basic
[147.693991] Subtest basic: SUCCESS (0.000s)
[147.882315] [032/161] (882s left) gem_flink_basic (double-flink)
[148.106112] Starting subtest: double-flink
[148.126753] Subtest double-flink: SUCCESS (0.000s)
[148.296424] [033/161] (882s left) gem_flink_basic (flink-lifetime)
[148.560568] Starting subtest: flink-lifetime
[148.582808] Subtest flink-lifetime: SUCCESS (0.004s)
[148.748707] [034/161] (881s left) gem_huc_copy (huc-copy)
[148.989427] Starting subtest: huc-copy
[149.033206] Subtest huc-copy: SKIP (0.000s)
[149.198068] [035/161] (881s left) gem_linear_blits (basic)
[149.623584] Starting subtest: basic
[149.647139] Subtest basic: SUCCESS (0.022s)
[149.923463] [036/161] (880s left) gem_mmap (basic)
[150.328714] Starting subtest: basic
[150.438715] Subtest basic: SUCCESS (0.001s)
[150.610935] [037/161] (880s left) gem_mmap_gtt (basic)
[150.866496] Starting subtest: basic
[150.887235] Subtest basic: SUCCESS (0.002s)
[151.056574] [038/161] (880s left) gem_render_linear_blits (basic)
[151.320773] Starting subtest: basic
[151.428695] Subtest basic: SUCCESS (0.098s)
[151.602657] [039/161] (879s left) gem_render_tiled_blits (basic)
[151.848869] Starting subtest: basic
[151.977396] Subtest basic: SUCCESS (0.135s)
[152.141770] [040/161] (879s left) gem_ringfill (basic-all)
[152.723461] Starting subtest: basic-all
[153.923263] Subtest basic-all: SUCCESS (1.223s)
[154.142245] [041/161] (877s left) gem_softpin (allocator-basic)
[154.392376] Starting subtest: allocator-basic
[154.662519] Subtest allocator-basic: SUCCESS (0.283s)
[154.873439] [042/161] (877s left) gem_softpin (allocator-basic-reserve)
[155.139554] Starting subtest: allocator-basic-reserve
[155.386853] Subtest allocator-basic-reserve: SUCCESS (0.290s)
[155.608415] [043/161] (876s left) gem_softpin (safe-alignment)
[155.871199] Starting subtest: safe-alignment
[155.892438] Subtest safe-alignment: SUCCESS (0.037s)
[156.091750] [044/161] (876s left) gem_sync (basic-all)
[156.528889] Starting subtest: basic-all
[158.617843] Subtest basic-all: SUCCESS (2.264s)
[158.924439] [045/161] (873s left) gem_sync (basic-each)
[159.345104] Starting subtest: basic-each
[161.531988] Subtest basic-each: SUCCESS (2.349s)
[161.835708] [046/161] (870s left) gem_tiled_blits (basic)
[162.198588] Starting subtest: basic
[162.265049] Subtest basic: SUCCESS (0.066s)
[162.560371] [047/161] (870s left) gem_tiled_fence_blits (basic)
[163.101781] Starting subtest: basic
[163.144058] Subtest basic: SUCCESS (0.044s)
[163.448209] [048/161] (869s left) gem_tiled_pread_basic
[164.299777] [049/161] (868s left) gem_wait (busy@all-engines)
[164.571112] Starting subtest: busy
[164.593398] Starting dynamic subtest: all-engines
[165.113516] Dynamic subtest all-engines: SUCCESS (0.526s)
[165.136929] Subtest busy: SUCCESS (0.527s)
[165.455870] [050/161] (867s left) gem_wait (wait@all-engines)
[165.717308] Starting subtest: wait
[165.738479] Starting dynamic subtest: all-engines
[166.771535] Dynamic subtest all-engines: SUCCESS (1.048s)
[166.792197] Subtest wait: SUCCESS (1.049s)
[167.115376] [051/161] (866s left) i915_getparams_basic (basic-eu-total)
[167.355383] Starting subtest: basic-eu-total
[167.399813] Subtest basic-eu-total: SUCCESS (0.000s)
[167.567307] [052/161] (866s left) i915_getparams_basic (basic-subslice-total)
[167.834864] Starting subtest: basic-subslice-total
[167.880704] Subtest basic-subslice-total: SUCCESS (0.000s)
[168.052091] [053/161] (865s left) i915_hangman (error-state-basic)
[168.319531] Starting subtest: error-state-basic
[168.341141] Subtest error-state-basic: SUCCESS (0.024s)
[168.544410] [054/161] (865s left) i915_pciid
[168.998274] [055/161] (865s left) kms_addfb_basic (addfb25-4-tiled)
[169.412875] Starting subtest: addfb25-4-tiled
[169.435134] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[169.606970] [056/161] (864s left) kms_addfb_basic (addfb25-bad-modifier)
[169.963056] Starting subtest: addfb25-bad-modifier
[169.985468] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[170.151408] [057/161] (864s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[170.487230] Starting subtest: addfb25-framebuffer-vs-set-tiling
[170.507605] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[170.700168] [058/161] (864s left) kms_addfb_basic (addfb25-modifier-no-flag)
[171.053332] Starting subtest: addfb25-modifier-no-flag
[171.073325] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[171.244101] [059/161] (863s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[171.607449] Starting subtest: addfb25-x-tiled-legacy
[171.627424] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[171.805389] [060/161] (863s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[172.163905] Starting subtest: addfb25-x-tiled-mismatch-legacy
[172.189191] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[172.373772] [061/161] (862s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[172.751658] Starting subtest: addfb25-yf-tiled-legacy
[172.778792] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[172.967341] [062/161] (862s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[173.315272] Starting subtest: addfb25-y-tiled-legacy
[173.335116] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[173.532275] [063/161] (862s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[173.879507] Starting subtest: addfb25-y-tiled-small-legacy
[173.902275] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s)
[174.073355] [064/161] (861s left) kms_addfb_basic (bad-pitch-0)
[174.317398] Starting subtest: bad-pitch-0
[174.337360] Subtest bad-pitch-0: SUCCESS (0.000s)
[174.622274] [065/161] (861s left) kms_addfb_basic (bad-pitch-1024)
[174.884867] Starting subtest: bad-pitch-1024
[174.911514] Subtest bad-pitch-1024: SUCCESS (0.000s)
[175.201979] [066/161] (860s left) kms_addfb_basic (bad-pitch-128)
[175.464576] Starting subtest: bad-pitch-128
[175.484086] Subtest bad-pitch-128: SUCCESS (0.000s)
[175.749720] [067/161] (860s left) kms_addfb_basic (bad-pitch-256)
[176.011453] Starting subtest: bad-pitch-256
[176.032777] Subtest bad-pitch-256: SUCCESS (0.000s)
[176.295272] [068/161] (860s left) kms_addfb_basic (bad-pitch-32)
[176.535644] Starting subtest: bad-pitch-32
[176.556468] Subtest bad-pitch-32: SUCCESS (0.000s)
[176.846883] [069/161] (859s left) kms_addfb_basic (bad-pitch-63)
[177.114728] Starting subtest: bad-pitch-63
[177.136503] Subtest bad-pitch-63: SUCCESS (0.000s)
[177.373677] [070/161] (859s left) kms_addfb_basic (bad-pitch-65536)
[177.636710] Starting subtest: bad-pitch-65536
[177.657482] Subtest bad-pitch-65536: SUCCESS (0.001s)
[177.925148] [071/161] (859s left) kms_addfb_basic (bad-pitch-999)
[178.167641] Starting subtest: bad-pitch-999
[178.189655] Subtest bad-pitch-999: SUCCESS (0.000s)
[178.475280] [072/161] (858s left) kms_addfb_basic (basic)
[178.716042] Starting subtest: basic
[178.737033] Subtest basic: SUCCESS (0.000s)
[179.027296] [073/161] (858s left) kms_addfb_basic (basic-x-tiled-legacy)
[179.285699] Starting subtest: basic-x-tiled-legacy
[179.306261] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[179.569902] [074/161] (857s left) kms_addfb_basic (basic-y-tiled-legacy)
[179.832530] Starting subtest: basic-y-tiled-legacy
[179.851791] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[180.140528] [075/161] (857s left) kms_addfb_basic (bo-too-small)
[180.471275] Starting subtest: bo-too-small
[180.493572] Subtest bo-too-small: SUCCESS (0.001s)
[180.657667] [076/161] (857s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[181.012574] Starting subtest: bo-too-small-due-to-tiling
[181.033959] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[181.200739] [077/161] (856s left) kms_addfb_basic (clobberred-modifier)
[181.469095] Starting subtest: clobberred-modifier
[181.496838] Subtest clobberred-modifier: SUCCESS (0.000s)
[181.771667] [078/161] (856s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[182.073699] Starting subtest: framebuffer-vs-set-tiling
[182.101214] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[182.347780] [079/161] (855s left) kms_addfb_basic (invalid-get-prop)
[182.623122] Starting subtest: invalid-get-prop
[182.648080] Subtest invalid-get-prop: SUCCESS (0.000s)
[182.914288] [080/161] (855s left) kms_addfb_basic (invalid-get-prop-any)
[183.162156] Starting subtest: invalid-get-prop-any
[183.184562] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[183.473975] [081/161] (855s left) kms_addfb_basic (invalid-set-prop)
[183.713613] Starting subtest: invalid-set-prop
[183.736793] Subtest invalid-set-prop: SUCCESS (0.000s)
[184.010086] [082/161] (854s left) kms_addfb_basic (invalid-set-prop-any)
[184.262950] Starting subtest: invalid-set-prop-any
[184.283196] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[184.545676] [083/161] (854s left) kms_addfb_basic (no-handle)
[184.791871] Starting subtest: no-handle
[184.815496] Subtest no-handle: SUCCESS (0.000s)
[185.062860] [084/161] (854s left) kms_addfb_basic (size-max)
[185.430456] Starting subtest: size-max
[185.450915] Subtest size-max: SUCCESS (0.000s)
[185.621886] [085/161] (853s left) kms_addfb_basic (small-bo)
[185.987544] Starting subtest: small-bo
[186.007916] Subtest small-bo: SUCCESS (0.000s)
[186.181176] [086/161] (853s left) kms_addfb_basic (tile-pitch-mismatch)
[186.449636] Starting subtest: tile-pitch-mismatch
[186.472200] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[186.729953] [087/161] (852s left) kms_addfb_basic (too-high)
[187.087639] Starting subtest: too-high
[187.111271] Subtest too-high: SUCCESS (0.002s)
[187.278479] [088/161] (852s left) kms_addfb_basic (too-wide)
[187.631208] Starting subtest: too-wide
[187.651534] Subtest too-wide: SUCCESS (0.000s)
[187.826150] [089/161] (852s left) kms_addfb_basic (unused-handle)
[188.076027] Starting subtest: unused-handle
[188.098175] Subtest unused-handle: SUCCESS (0.000s)
[188.387668] [090/161] (851s left) kms_addfb_basic (unused-modifier)
[188.627291] Starting subtest: unused-modifier
[188.650628] Subtest unused-modifier: SUCCESS (0.000s)
[188.944792] [091/161] (851s left) kms_addfb_basic (unused-offsets)
[189.207292] Starting subtest: unused-offsets
[189.230087] Subtest unused-offsets: SUCCESS (0.000s)
[189.497625] [092/161] (851s left) kms_addfb_basic (unused-pitches)
[189.762083] Starting subtest: unused-pitches
[189.784627] Subtest unused-pitches: SUCCESS (0.000s)
[190.046902] [093/161] (850s left) kms_busy (basic)
[190.402466] Starting subtest: basic
[190.422704] Starting dynamic subtest: flip
[191.242199] Dynamic subtest flip: SUCCESS (0.829s)
[191.464778] Starting dynamic subtest: modeset
[192.664337] Dynamic subtest modeset: SUCCESS (1.436s)
[192.687352] Subtest basic: SUCCESS (2.270s)
[193.142378] [094/161] (847s left) kms_prop_blob (basic)
[193.428186] Starting subtest: basic
[193.452051] Subtest basic: SUCCESS (0.000s)
[193.623554] [095/161] (847s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[193.967967] Starting subtest: basic-busy-flip-before-cursor-atomic
[194.012185] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[194.183704] [096/161] (847s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[194.548986] Starting subtest: basic-busy-flip-before-cursor-legacy
[194.595792] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[194.764849] [097/161] (846s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[195.112169] Starting subtest: basic-flip-after-cursor-atomic
[196.105532] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.998s)
[196.540346] [098/161] (844s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[196.878592] Starting subtest: basic-flip-after-cursor-legacy
[197.890930] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.986s)
[198.296482] [099/161] (843s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[198.627103] Starting subtest: basic-flip-after-cursor-varying-size
[199.619384] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.991s)
[200.099789] [100/161] (841s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[200.443248] Starting subtest: basic-flip-before-cursor-atomic
[201.428342] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.992s)
[201.884513] [101/161] (840s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[202.221091] Starting subtest: basic-flip-before-cursor-legacy
[203.232681] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.992s)
[203.671255] [102/161] (838s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[204.023041] Starting subtest: basic-flip-before-cursor-varying-size
[205.065775] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.992s)
[205.448564] [103/161] (836s left) kms_dsc (dsc-basic)
[205.804078] Subtest dsc-basic: SKIP (0.000s)
[205.976241] [104/161] (836s left) kms_flip (basic-flip-vs-dpms)
[206.352076] Starting subtest: basic-flip-vs-dpms
[206.372339] Starting dynamic subtest: A-DP1
[207.586632] Dynamic subtest A-DP1: SUCCESS (1.261s)
[207.635203] Starting dynamic subtest: B-DP1
[208.739949] Dynamic subtest B-DP1: SUCCESS (1.153s)
[208.787744] Starting dynamic subtest: C-DP1
[209.915337] Dynamic subtest C-DP1: SUCCESS (1.163s)
[209.938461] Subtest basic-flip-vs-dpms: SUCCESS (3.586s)
[210.404161] [105/161] (832s left) kms_flip (basic-flip-vs-modeset)
[210.767655] Starting subtest: basic-flip-vs-modeset
[210.787856] Starting dynamic subtest: A-DP1
[212.043840] Dynamic subtest A-DP1: SUCCESS (1.266s)
[212.095125] Starting dynamic subtest: B-DP1
[213.177124] Dynamic subtest B-DP1: SUCCESS (1.149s)
[213.225743] Starting dynamic subtest: C-DP1
[214.340987] Dynamic subtest C-DP1: SUCCESS (1.150s)
[214.381739] Subtest basic-flip-vs-modeset: SUCCESS (3.576s)
[214.797153] [106/161] (828s left) kms_flip (basic-flip-vs-wf_vblank)
[215.163833] Starting subtest: basic-flip-vs-wf_vblank
[215.185301] Starting dynamic subtest: A-DP1
[216.607539] Dynamic subtest A-DP1: SUCCESS (1.457s)
[216.658240] Starting dynamic subtest: B-DP1
[218.031787] Dynamic subtest B-DP1: SUCCESS (1.422s)
[218.085310] Starting dynamic subtest: C-DP1
[219.457219] Dynamic subtest C-DP1: SUCCESS (1.421s)
[219.479402] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.311s)
[219.996210] [107/161] (823s left) kms_flip (basic-plain-flip)
[220.360108] Starting subtest: basic-plain-flip
[220.388420] Starting dynamic subtest: A-DP1
[221.519959] Dynamic subtest A-DP1: SUCCESS (1.168s)
[221.566932] Starting dynamic subtest: B-DP1
[222.672460] Dynamic subtest B-DP1: SUCCESS (1.137s)
[222.727193] Starting dynamic subtest: C-DP1
[223.811715] Dynamic subtest C-DP1: SUCCESS (1.136s)
[223.839280] Subtest basic-plain-flip: SUCCESS (3.454s)
[224.341270] [108/161] (818s left) kms_force_connector_basic (force-connector-state)
[224.642405] Subtest force-connector-state: SKIP (0.000s)
[224.816995] [109/161] (818s left) kms_force_connector_basic (force-edid)
[225.107737] Subtest force-edid: SKIP (0.000s)
[225.286771] [110/161] (818s left) kms_force_connector_basic (force-load-detect)
[225.561726] Subtest force-load-detect: SKIP (0.000s)
[225.738747] [111/161] (818s left) kms_force_connector_basic (prune-stale-modes)
[226.036921] Subtest prune-stale-modes: SKIP (0.000s)
[226.218399] [112/161] (817s left) kms_frontbuffer_tracking (basic)
[226.653046] Starting subtest: basic
[230.343366] Subtest basic: SUCCESS (3.761s)
[230.545147] [113/161] (813s left) kms_hdmi_inject (inject-audio)
[230.835917] Subtest inject-audio: SKIP (0.000s)
[231.012266] [114/161] (813s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[231.388989] Starting subtest: compare-crc-sanitycheck-xr24
[231.410710] Starting dynamic subtest: pipe-A-DP-1
[231.836479] Dynamic subtest pipe-A-DP-1: SUCCESS (0.465s)
[231.920127] Starting dynamic subtest: pipe-B-DP-1
[232.468305] Dynamic subtest pipe-B-DP-1: SUCCESS (0.628s)
[232.517577] Starting dynamic subtest: pipe-C-DP-1
[233.116116] Dynamic subtest pipe-C-DP-1: SUCCESS (0.636s)
[233.136933] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.743s)
[233.557256] [115/161] (811s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[233.896827] Starting subtest: compare-crc-sanitycheck-nv12
[233.920094] Starting dynamic subtest: pipe-A-DP-1
[233.964165] Dynamic subtest pipe-A-DP-1: SKIP (0.001s)
[234.032720] Starting dynamic subtest: pipe-B-DP-1
[234.079256] Dynamic subtest pipe-B-DP-1: SKIP (0.001s)
[234.167645] Starting dynamic subtest: pipe-C-DP-1
[234.219980] Dynamic subtest pipe-C-DP-1: SKIP (0.001s)
[234.271858] Subtest compare-crc-sanitycheck-nv12: SKIP (0.017s)
[234.473422] [116/161] (810s left) kms_pipe_crc_basic (hang-read-crc)
[234.848389] Starting subtest: hang-read-crc
[234.875489] Starting dynamic subtest: pipe-A-DP-1
[236.149547] Dynamic subtest pipe-A-DP-1: SUCCESS (1.314s)
[236.223168] Starting dynamic subtest: pipe-B-DP-1
[237.619093] Dynamic subtest pipe-B-DP-1: SUCCESS (1.471s)
[237.669348] Starting dynamic subtest: pipe-C-DP-1
[239.105288] Dynamic subtest pipe-C-DP-1: SUCCESS (1.471s)
[239.125885] Subtest hang-read-crc: SUCCESS (4.270s)
[239.524928] [117/161] (805s left) kms_pipe_crc_basic (nonblocking-crc)
[239.870521] Starting subtest: nonblocking-crc
[239.891721] Starting dynamic subtest: pipe-A-DP-1
[240.525738] Dynamic subtest pipe-A-DP-1: SUCCESS (0.648s)
[240.617976] Starting dynamic subtest: pipe-B-DP-1
[241.359130] Dynamic subtest pipe-B-DP-1: SUCCESS (0.814s)
[241.408479] Starting dynamic subtest: pipe-C-DP-1
[242.178190] Dynamic subtest pipe-C-DP-1: SUCCESS (0.810s)
[242.198461] Subtest nonblocking-crc: SUCCESS (2.287s)
[242.590298] [118/161] (802s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[242.930783] Starting subtest: nonblocking-crc-frame-sequence
[242.958870] Starting dynamic subtest: pipe-A-DP-1
[243.595144] Dynamic subtest pipe-A-DP-1: SUCCESS (0.653s)
[243.647664] Starting dynamic subtest: pipe-B-DP-1
[244.407955] Dynamic subtest pipe-B-DP-1: SUCCESS (0.801s)
[244.473389] Starting dynamic subtest: pipe-C-DP-1
[245.213958] Dynamic subtest pipe-C-DP-1: SUCCESS (0.797s)
[245.235600] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.266s)
[245.634166] [119/161] (799s left) kms_pipe_crc_basic (read-crc)
[245.971711] Starting subtest: read-crc
[245.992189] Starting dynamic subtest: pipe-A-DP-1
[246.582116] Dynamic subtest pipe-A-DP-1: SUCCESS (0.582s)
[246.632823] Starting dynamic subtest: pipe-B-DP-1
[247.300514] Dynamic subtest pipe-B-DP-1: SUCCESS (0.717s)
[247.347918] Starting dynamic subtest: pipe-C-DP-1
[248.047437] Dynamic subtest pipe-C-DP-1: SUCCESS (0.745s)
[248.070243] Subtest read-crc: SUCCESS (2.058s)
[248.476724] [120/161] (796s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[248.824495] Starting subtest: read-crc-frame-sequence
[248.846507] Starting dynamic subtest: pipe-A-DP-1
[249.415074] Dynamic subtest pipe-A-DP-1: SUCCESS (0.569s)
[249.465220] Starting dynamic subtest: pipe-B-DP-1
[250.158504] Dynamic subtest pipe-B-DP-1: SUCCESS (0.740s)
[250.226286] Starting dynamic subtest: pipe-C-DP-1
[250.896985] Dynamic subtest pipe-C-DP-1: SUCCESS (0.733s)
[250.917997] Subtest read-crc-frame-sequence: SUCCESS (2.058s)
[251.313438] [121/161] (794s left) kms_pm_backlight (basic-brightness)
[251.669856] Subtest basic-brightness: SKIP (0.000s)
[251.845415] [122/161] (793s left) kms_pm_rpm (basic-pci-d3-state)
[253.735810] Starting subtest: basic-pci-d3-state
[254.379124] Subtest basic-pci-d3-state: SUCCESS (0.664s)
[254.703180] [123/161] (791s left) kms_pm_rpm (basic-rte)
[254.952549] Starting subtest: basic-rte
[257.140141] Subtest basic-rte: SUCCESS (2.217s)
[258.112298] [124/161] (788s left) kms_psr (psr-primary-page-flip)
[258.485356] Subtest psr-primary-page-flip: SKIP (0.000s)
[258.657785] [125/161] (787s left) kms_psr (psr-cursor-plane-move)
[259.020385] Subtest psr-cursor-plane-move: SKIP (0.000s)
[259.215215] [126/161] (787s left) kms_psr (psr-sprite-plane-onoff)
[259.562211] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[259.741378] [127/161] (786s left) kms_psr (psr-primary-mmap-gtt)
[260.106784] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[260.286496] [128/161] (786s left) kms_setmode (basic-clone-single-crtc)
[260.565310] Starting subtest: basic-clone-single-crtc
[260.637101] Subtest basic-clone-single-crtc: SKIP (0.000s)
[260.813511] [129/161] (786s left) i915_pm_rps (basic-api)
[261.070527] Starting subtest: basic-api
[261.093349] Subtest basic-api: SUCCESS (0.008s)
[261.291709] [130/161] (785s left) prime_self_import (basic-llseek-bad)
[261.547814] Starting subtest: basic-llseek-bad
[261.592731] Subtest basic-llseek-bad: SUCCESS (0.005s)
[261.769557] [131/161] (785s left) prime_self_import (basic-llseek-size)
[261.995802] Starting subtest: basic-llseek-size
[262.039863] Subtest basic-llseek-size: SUCCESS (0.008s)
[262.219252] [132/161] (785s left) prime_self_import (basic-with_fd_dup)
[262.449616] Starting subtest: basic-with_fd_dup
[262.495400] Subtest basic-with_fd_dup: SUCCESS (0.007s)
[262.674323] [133/161] (785s left) prime_self_import (basic-with_one_bo)
[262.924150] Starting subtest: basic-with_one_bo
[262.969918] Subtest basic-with_one_bo: SUCCESS (0.007s)
[263.141517] [134/161] (784s left) prime_self_import (basic-with_one_bo_two_files)
[263.387142] Starting subtest: basic-with_one_bo_two_files
[263.442094] Subtest basic-with_one_bo_two_files: SUCCESS (0.007s)
[263.631966] [135/161] (784s left) prime_self_import (basic-with_two_bos)
[263.900137] Starting subtest: basic-with_two_bos
[263.951986] Subtest basic-with_two_bos: SUCCESS (0.008s)
[264.151078] [136/161] (784s left) prime_vgem (basic-fence-flip)
[264.457970] Starting subtest: basic-fence-flip
[265.095373] Subtest basic-fence-flip: SUCCESS (0.667s)
[265.322991] [137/161] (783s left) prime_vgem (basic-fence-mmap)
[265.613754] Starting subtest: basic-fence-mmap
[265.660537] Subtest basic-fence-mmap: SUCCESS (0.073s)
[265.857795] [138/161] (782s left) prime_vgem (basic-fence-read)
[266.123657] Starting subtest: basic-fence-read
[266.215165] Subtest basic-fence-read: SUCCESS (0.141s)
[266.423972] [139/161] (782s left) prime_vgem (basic-gtt)
[266.719408] Starting subtest: basic-gtt
[266.740754] Subtest basic-gtt: SUCCESS (0.032s)
[266.959721] [140/161] (782s left) prime_vgem (basic-read)
[267.252128] Starting subtest: basic-read
[267.273608] Subtest basic-read: SUCCESS (0.065s)
[267.477220] [141/161] (781s left) prime_vgem (basic-write)
[267.754129] Starting subtest: basic-write
[267.801202] Subtest basic-write: SUCCESS (0.095s)
[267.998387] [142/161] (781s left) vgem_basic (setversion)
[268.285328] Starting subtest: setversion
[268.330222] Subtest setversion: SUCCESS (0.000s)
[268.509823] [143/161] (781s left) vgem_basic (create)
[268.785067] Starting subtest: create
[268.808818] Subtest create: SUCCESS (0.001s)
[269.011193] [144/161] (780s left) vgem_basic (debugfs)
[269.280850] Starting subtest: debugfs
[269.304805] Subtest debugfs: SUCCESS (0.001s)
[269.482204] [145/161] (780s left) vgem_basic (dmabuf-export)
[269.734534] Starting subtest: dmabuf-export
[269.776966] Subtest dmabuf-export: SUCCESS (0.005s)
[269.954912] [146/161] (780s left) vgem_basic (dmabuf-fence)
[270.211377] Starting subtest: dmabuf-fence
[270.234539] Subtest dmabuf-fence: SUCCESS (0.002s)
[270.410971] [147/161] (780s left) vgem_basic (dmabuf-fence-before)
[270.680678] Starting subtest: dmabuf-fence-before
[270.704410] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[270.882388] [148/161] (779s left) vgem_basic (dmabuf-mmap)
[271.132872] Starting subtest: dmabuf-mmap
[271.154300] Subtest dmabuf-mmap: SUCCESS (0.036s)
[271.330461] [149/161] (779s left) vgem_basic (mmap)
[271.604890] Starting subtest: mmap
[271.628338] Subtest mmap: SUCCESS (0.024s)
[271.804222] [150/161] (779s left) vgem_basic (second-client)
[272.073873] Starting subtest: second-client
[272.120985] Subtest second-client: SUCCESS (0.032s)
[272.296553] [151/161] (778s left) vgem_basic (sysfs)
[272.546088] Starting subtest: sysfs
[272.566849] Subtest sysfs: SUCCESS (0.001s)
[272.764728] [152/161] (778s left) core_hotunplug (unbind-rebind)
[273.162208] Starting subtest: unbind-rebind
[277.714978] Subtest unbind-rebind: SUCCESS (4.546s)
[277.890904] [153/161] (773s left) vgem_basic (unload)
[278.169627] Starting subtest: unload
[307.430700] Subtest unload: SUCCESS (29.150s)
[307.602911] [154/161] (744s left) i915_module_load (reload)
[307.831780] Starting subtest: reload
[313.678385] Subtest reload: SUCCESS (5.869s)
[313.960493] [155/161] (738s left) gem_lmem_swapping (basic)
[314.277194] Subtest basic: SKIP (0.000s)
[314.456235] [156/161] (737s left) gem_lmem_swapping (parallel-random-engines)
[314.726873] Subtest parallel-random-engines: SKIP (0.000s)
[314.898784] [157/161] (737s left) gem_lmem_swapping (random-engines)
[315.160869] Subtest random-engines: SKIP (0.000s)
[315.336395] [158/161] (737s left) gem_lmem_swapping (verify-random)
[315.626548] Subtest verify-random: SKIP (0.000s)
[315.797809] [159/161] (737s left) i915_pm_rpm (module-reload)
[317.958890] Starting subtest: module-reload
[332.855107] Subtest module-reload: SUCCESS (14.924s)
[332.980150] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[332.983665] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[333.007801] [160/161] (720s left) i915_selftest (live)
[333.258793] Starting subtest: live
[333.279116] Starting dynamic subtest: sanitycheck
[337.050508] Dynamic subtest sanitycheck: SUCCESS (3.816s)
[337.108684] Starting dynamic subtest: uncore
[340.847121] Dynamic subtest uncore: SUCCESS (3.788s)
[340.906800] Starting dynamic subtest: workarounds
[345.104620] Dynamic subtest workarounds: SUCCESS (4.255s)
[345.162732] Starting dynamic subtest: gt_engines
[349.548474] Dynamic subtest gt_engines: SUCCESS (4.437s)
[349.606836] Starting dynamic subtest: gt_timelines
[373.301083] Dynamic subtest gt_timelines: SUCCESS (23.744s)
[373.361929] Starting dynamic subtest: gt_contexts
[377.573403] Dynamic subtest gt_contexts: SUCCESS (4.267s)
[377.619208] Starting dynamic subtest: gt_lrc
[384.260343] Dynamic subtest gt_lrc: SUCCESS (6.681s)
[384.306077] Starting dynamic subtest: gt_mocs
[388.403818] Dynamic subtest gt_mocs: SUCCESS (4.140s)
[388.449779] Starting dynamic subtest: gt_pm
[402.019400] Dynamic subtest gt_pm: SUCCESS (13.614s)
[402.062464] Starting dynamic subtest: gt_heartbeat
[406.081360] Dynamic subtest gt_heartbeat: SUCCESS (4.059s)
[406.122865] Starting dynamic subtest: gt_tlb
[411.181370] Dynamic subtest gt_tlb: SUCCESS (5.096s)
[411.225157] Starting dynamic subtest: requests
[421.899887] Dynamic subtest requests: SUCCESS (10.713s)
[421.941729] Starting dynamic subtest: migrate
[429.302694] Dynamic subtest migrate: SUCCESS (7.396s)
[429.344794] Starting dynamic subtest: active
[433.358415] Dynamic subtest active: SUCCESS (4.051s)
[433.402439] Starting dynamic subtest: objects
[439.843089] Dynamic subtest objects: SUCCESS (6.479s)
[439.886336] Starting dynamic subtest: mman
[450.202278] Dynamic subtest mman: SUCCESS (10.355s)
[450.287041] Starting dynamic subtest: dmabuf
[454.390315] Dynamic subtest dmabuf: SUCCESS (4.184s)
[454.435204] Starting dynamic subtest: vma
[458.342654] Dynamic subtest vma: SUCCESS (3.947s)
[458.394522] Starting dynamic subtest: coherency
[466.133261] Dynamic subtest coherency: SUCCESS (7.787s)
[466.199891] Starting dynamic subtest: gtt
[477.313256] Dynamic subtest gtt: SUCCESS (11.174s)
[477.358775] Starting dynamic subtest: gem
[482.928615] Dynamic subtest gem: SUCCESS (5.614s)
[482.971166] Starting dynamic subtest: evict
[491.850173] Dynamic subtest evict: SUCCESS (8.915s)
[491.896830] Starting dynamic subtest: hugepages
[502.370863] Dynamic subtest hugepages: SUCCESS (10.515s)
[502.430743] Starting dynamic subtest: gem_contexts
[529.027234] Dynamic subtest gem_contexts: SUCCESS (26.643s)
[529.069732] Starting dynamic subtest: client
[533.087156] Dynamic subtest client: SUCCESS (4.063s)
[533.130283] Starting dynamic subtest: gem_migrate
[536.993595] Dynamic subtest gem_migrate: SUCCESS (3.902s)
[537.039453] Starting dynamic subtest: reset
[551.747506] Dynamic subtest reset: SUCCESS (14.751s)
[551.789606] Starting dynamic subtest: memory_region
[555.705678] Dynamic subtest memory_region: SUCCESS (3.951s)
[555.765501] Starting dynamic subtest: hangcheck
[582.859357] Dynamic subtest hangcheck: SUCCESS (27.152s)
[582.900792] Starting dynamic subtest: execlists
[597.563695] Dynamic subtest execlists: SUCCESS (14.700s)
[597.623646] Starting dynamic subtest: ring_submission
[601.518486] Dynamic subtest ring_submission: SUCCESS (3.949s)
[601.560029] Starting dynamic subtest: perf
[605.668291] Dynamic subtest perf: SUCCESS (4.145s)
[605.730818] Starting dynamic subtest: slpc
[609.683751] Dynamic subtest slpc: SUCCESS (4.011s)
[609.724973] Starting dynamic subtest: guc
[613.521064] Dynamic subtest guc: SUCCESS (3.823s)
[613.564310] Starting dynamic subtest: guc_multi_lrc
[617.374452] Dynamic subtest guc_multi_lrc: SUCCESS (3.852s)
[617.422510] Starting dynamic subtest: guc_hang
[621.402595] Dynamic subtest guc_hang: SUCCESS (4.027s)
[621.444712] Starting dynamic subtest: late_gt_pm
[625.550224] Dynamic subtest late_gt_pm: SUCCESS (4.145s)
[625.570769] Subtest live: SUCCESS (292.317s)
[625.727769] [161/161] (427s left) dmabuf (all-tests)
������������������������������������������������������������������������������������������������������������������������������������������������������������������������������������������������������������������������������������