[74.625926] Initializing watchdogs
[74.626881]   /dev/watchdog0
[74.747177] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:22b1 Intel Cherryview (Gen8) Atom/Celeron/Pentium Processor x5-E8000/J3xxx/N3xxx Integrated Graphics Controller
[74.784313] [001/162] (960s left) i915_module_load (load)
[75.261172] Starting subtest: load
[81.217110] Subtest load: SUCCESS (6.000s)
[81.447246] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[81.462394] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[81.483244] [002/162] (954s left) core_auth (basic-auth)
[81.929768] Starting subtest: basic-auth
[81.940332] Subtest basic-auth: SUCCESS (0.018s)
[82.192898] [003/162] (953s left) core_debugfs (read-all-entries)
[82.467514] Starting subtest: read-all-entries
[82.477223] Subtest read-all-entries: SUCCESS (0.013s)
[82.693769] [004/162] (953s left) core_sysfs (read-all-entries)
[82.910931] Starting subtest: read-all-entries
[82.927676] Subtest read-all-entries: SUCCESS (0.018s)
[83.152095] [005/162] (952s left) fbdev (eof)
[83.388362] Starting subtest: eof
[83.390476] Subtest eof: SUCCESS (0.002s)
[83.595808] [006/162] (952s left) fbdev (info)
[83.804588] Starting subtest: info
[83.806963] Subtest info: SUCCESS (0.000s)
[84.040748] [007/162] (952s left) fbdev (nullptr)
[84.271337] Starting subtest: nullptr
[84.272874] Subtest nullptr: SUCCESS (0.001s)
[84.476796] [008/162] (952s left) fbdev (read)
[84.721121] Starting subtest: read
[86.796957] Subtest read: SUCCESS (2.076s)
[87.014289] [009/162] (949s left) fbdev (write)
[87.234868] Starting subtest: write
[88.325251] Subtest write: SUCCESS (1.088s)
[88.534912] [010/162] (948s left) gem_basic (bad-close)
[88.748886] Starting subtest: bad-close
[88.756411] Subtest bad-close: SUCCESS (0.000s)
[88.948604] [011/162] (948s left) gem_basic (create-close)
[89.165943] Starting subtest: create-close
[89.169870] Subtest create-close: SUCCESS (0.001s)
[89.378614] [012/162] (947s left) gem_basic (create-fd-close)
[89.592570] Starting subtest: create-fd-close
[89.598697] Subtest create-fd-close: SUCCESS (0.001s)
[89.803987] [013/162] (947s left) gem_busy (busy@all-engines)
[90.084502] Starting subtest: busy
[90.086153] Starting dynamic subtest: all-engines
[90.244737] Dynamic subtest all-engines: SUCCESS (0.162s)
[90.246591] Subtest busy: SUCCESS (0.167s)
[90.797938] [014/162] (946s left) gem_close_race (basic-process)
[91.089114] Starting subtest: basic-process
[91.251808] Subtest basic-process: SUCCESS (0.167s)
[91.601759] [015/162] (946s left) gem_close_race (basic-threads)
[91.876155] Starting subtest: basic-threads
[93.151478] Subtest basic-threads: SUCCESS (1.274s)
[93.487756] [016/162] (944s left) gem_ctx_create (basic)
[93.752897] Starting subtest: basic
[93.754960] Subtest basic: SUCCESS (0.000s)
[94.098964] [017/162] (944s left) gem_ctx_create (basic-files)
[94.357801] Starting subtest: basic-files
[96.412568] Subtest basic-files: SUCCESS (2.056s)
[96.764669] [018/162] (941s left) gem_ctx_exec (basic)
[96.996609] Starting subtest: basic
[97.011694] Subtest basic: SUCCESS (0.014s)
[97.236157] [019/162] (941s left) gem_exec_basic (basic)
[97.481225] Starting subtest: basic
[97.487781] Starting dynamic subtest: rcs0-smem
[97.491927] Dynamic subtest rcs0-smem: SUCCESS (0.006s)
[97.518214] Starting dynamic subtest: bcs0-smem
[97.520568] Dynamic subtest bcs0-smem: SUCCESS (0.003s)
[97.547954] Starting dynamic subtest: vcs0-smem
[97.549468] Dynamic subtest vcs0-smem: SUCCESS (0.004s)
[97.575391] Starting dynamic subtest: vecs0-smem
[97.578194] Dynamic subtest vecs0-smem: SUCCESS (0.024s)
[97.581253] Subtest basic: SUCCESS (0.045s)
[97.884825] [020/162] (940s left) gem_exec_create (basic)
[98.140854] Starting subtest: basic
[98.142786] Starting dynamic subtest: smem
[100.217121] Dynamic subtest smem: SUCCESS (2.081s)
[100.220316] Subtest basic: SUCCESS (2.083s)
[100.557303] [021/162] (938s left) gem_exec_fence (basic-busy)
[100.965294] Starting subtest: basic-busy
[100.970215] Starting dynamic subtest: rcs0
[100.996410] Dynamic subtest rcs0: SUCCESS (0.029s)
[101.021547] Starting dynamic subtest: bcs0
[101.035511] Dynamic subtest bcs0: SUCCESS (0.043s)
[101.072473] Starting dynamic subtest: vcs0
[101.091177] Dynamic subtest vcs0: SUCCESS (0.050s)
[101.117120] Starting dynamic subtest: vecs0
[101.131255] Dynamic subtest vecs0: SUCCESS (0.038s)
[101.134410] Subtest basic-busy: SUCCESS (0.170s)
[102.088539] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[102.101555] [022/162] (936s left) gem_exec_fence (basic-wait)
[102.517741] Starting subtest: basic-wait
[102.521970] Starting dynamic subtest: rcs0
[102.547816] Dynamic subtest rcs0: SUCCESS (0.031s)
[102.579204] Starting dynamic subtest: bcs0
[102.594046] Dynamic subtest bcs0: SUCCESS (0.042s)
[102.619738] Starting dynamic subtest: vcs0
[102.638240] Dynamic subtest vcs0: SUCCESS (0.042s)
[102.668789] Starting dynamic subtest: vecs0
[102.693095] Dynamic subtest vecs0: SUCCESS (0.051s)
[102.694676] Subtest basic-wait: SUCCESS (0.179s)
[103.508803] [023/162] (935s left) gem_exec_fence (basic-await)
[103.925629] Starting subtest: basic-await
[103.929614] Starting dynamic subtest: rcs0
[104.112520] Dynamic subtest rcs0: SUCCESS (0.187s)
[104.138855] Starting dynamic subtest: bcs0
[104.304527] Dynamic subtest bcs0: SUCCESS (0.183s)
[104.331453] Starting dynamic subtest: vcs0
[104.500382] Dynamic subtest vcs0: SUCCESS (0.190s)
[104.526733] Starting dynamic subtest: vecs0
[104.681547] Dynamic subtest vecs0: SUCCESS (0.181s)
[104.683559] Subtest basic-await: SUCCESS (0.759s)
[105.507498] [024/162] (933s left) gem_exec_fence (nb-await)
[105.915493] Starting subtest: nb-await
[105.917924] Starting dynamic subtest: rcs0
[106.014675] Dynamic subtest rcs0: SUCCESS (0.096s)
[106.048478] Starting dynamic subtest: bcs0
[106.122454] Dynamic subtest bcs0: SUCCESS (0.095s)
[106.151609] Starting dynamic subtest: vcs0
[106.230454] Dynamic subtest vcs0: SUCCESS (0.105s)
[106.257917] Starting dynamic subtest: vecs0
[106.324361] Dynamic subtest vecs0: SUCCESS (0.104s)
[106.328275] Subtest nb-await: SUCCESS (0.408s)
[107.158830] [025/162] (932s left) gem_exec_gttfill (basic)
[107.425277] Starting subtest: basic
[108.547695] Subtest basic: SKIP (1.092s)
[108.926378] [026/162] (930s left) gem_exec_parallel (engines)
[109.370757] Starting subtest: engines
[109.372992] Starting dynamic subtest: basic
[115.621936] Dynamic subtest basic: SUCCESS (6.253s)
[115.653405] Starting dynamic subtest: contexts
[126.156870] Dynamic subtest contexts: SUCCESS (10.524s)
[126.185567] Starting dynamic subtest: fds
[138.688823] Dynamic subtest fds: SUCCESS (12.531s)
[138.720894] Starting dynamic subtest: userptr
[144.871293] Dynamic subtest userptr: SUCCESS (6.181s)
[144.872910] Subtest engines: SUCCESS (35.497s)
[145.265243] [027/162] (894s left) gem_exec_store (basic)
[145.536277] Starting subtest: basic
[145.614761] Subtest basic: SUCCESS (0.080s)
[145.976507] [028/162] (894s left) gem_flink_basic (bad-flink)
[146.191537] Starting subtest: bad-flink
[146.195292] Subtest bad-flink: SUCCESS (0.000s)
[146.436799] [029/162] (893s left) gem_flink_basic (bad-open)
[146.646999] Starting subtest: bad-open
[146.650121] Subtest bad-open: SUCCESS (0.000s)
[146.885318] [030/162] (893s left) gem_flink_basic (basic)
[147.101762] Starting subtest: basic
[147.103652] Subtest basic: SUCCESS (0.001s)
[147.348964] [031/162] (893s left) gem_flink_basic (double-flink)
[147.558686] Starting subtest: double-flink
[147.562463] Subtest double-flink: SUCCESS (0.001s)
[147.810202] [032/162] (893s left) gem_flink_basic (flink-lifetime)
[148.026160] Starting subtest: flink-lifetime
[148.031834] Subtest flink-lifetime: SUCCESS (0.008s)
[148.290804] [033/162] (892s left) gem_huc_copy (huc-copy)
[148.514213] Subtest huc-copy: SKIP (0.000s)
[148.706718] [034/162] (892s left) gem_linear_blits (basic)
[149.287758] Subtest basic: SKIP (0.000s)
[149.497585] [035/162] (891s left) gem_mmap (basic)
[149.875792] Starting subtest: basic
[149.890625] Subtest basic: SUCCESS (0.001s)
[150.111347] [036/162] (891s left) gem_mmap_gtt (basic)
[150.322572] Starting subtest: basic
[150.324715] Subtest basic: SUCCESS (0.004s)
[150.579942] [037/162] (891s left) gem_render_linear_blits (basic)
[150.838673] Starting subtest: basic
[150.973408] Subtest basic: SUCCESS (0.133s)
[151.171409] [038/162] (890s left) gem_render_tiled_blits (basic)
[151.394775] Starting subtest: basic
[151.578476] Subtest basic: SUCCESS (0.173s)
[151.781994] [039/162] (890s left) gem_ringfill (basic-all)
[152.261854] Starting subtest: basic-all
[153.594409] Subtest basic-all: SUCCESS (1.320s)
[153.836684] [040/162] (888s left) gem_softpin (allocator-basic)
[154.119347] Starting subtest: allocator-basic
[154.643797] Subtest allocator-basic: SUCCESS (0.499s)
[154.895910] [041/162] (887s left) gem_softpin (allocator-basic-reserve)
[155.125829] Starting subtest: allocator-basic-reserve
[155.525566] Subtest allocator-basic-reserve: SUCCESS (0.397s)
[155.879706] [042/162] (886s left) gem_softpin (safe-alignment)
[156.117824] Starting subtest: safe-alignment
[156.171685] Subtest safe-alignment: SUCCESS (0.048s)
[156.421477] [043/162] (886s left) gem_sync (basic-all)
[156.683561] Starting subtest: basic-all
[160.025687] Subtest basic-all: SUCCESS (3.339s)
[160.397843] [044/162] (882s left) gem_sync (basic-each)
[160.661124] Starting subtest: basic-each
[163.438528] Subtest basic-each: SUCCESS (2.777s)
[163.814705] [045/162] (879s left) gem_tiled_blits (basic)
[164.274692] Subtest basic: SKIP (0.000s)
[164.474513] [046/162] (879s left) gem_tiled_fence_blits (basic)
[165.088254] Starting subtest: basic
[165.155536] Subtest basic: SUCCESS (0.067s)
[165.425483] [047/162] (878s left) gem_tiled_pread_basic
[166.856593] [048/162] (877s left) gem_wait (busy@all-engines)
[167.147872] Starting subtest: busy
[167.150594] Starting dynamic subtest: all-engines
[167.682055] Dynamic subtest all-engines: SUCCESS (0.538s)
[167.693078] Subtest busy: SUCCESS (0.545s)
[168.137586] [049/162] (876s left) gem_wait (wait@all-engines)
[168.421776] Starting subtest: wait
[168.424447] Starting dynamic subtest: all-engines
[169.472209] Dynamic subtest all-engines: SUCCESS (1.047s)
[169.473843] Subtest wait: SUCCESS (1.050s)
[169.893608] [050/162] (874s left) i915_getparams_basic (basic-eu-total)
[170.107821] Starting subtest: basic-eu-total
[170.113257] Subtest basic-eu-total: SUCCESS (0.000s)
[170.350455] [051/162] (874s left) i915_getparams_basic (basic-subslice-total)
[170.568759] Starting subtest: basic-subslice-total
[170.572924] Subtest basic-subslice-total: SUCCESS (0.001s)
[170.790150] [052/162] (873s left) i915_hangman (error-state-basic)
[171.051167] Starting subtest: error-state-basic
[171.094177] Subtest error-state-basic: SUCCESS (0.048s)
[171.367216] [053/162] (873s left) i915_pciid
[171.814956] [054/162] (873s left) intel_hwmon (hwmon-read)
[172.025785] Subtest hwmon-read: SKIP (0.000s)
[172.224185] [055/162] (873s left) intel_hwmon (hwmon-write)
[172.434936] Subtest hwmon-write: SKIP (0.000s)
[172.639917] [056/162] (872s left) kms_addfb_basic (addfb25-4-tiled)
[173.374436] Starting subtest: addfb25-4-tiled
[173.377069] Subtest addfb25-4-tiled: SUCCESS (0.002s)
[173.612820] [057/162] (872s left) kms_addfb_basic (addfb25-bad-modifier)
[174.305065] Starting subtest: addfb25-bad-modifier
[174.308191] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[174.537971] [058/162] (871s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[175.284563] Starting subtest: addfb25-framebuffer-vs-set-tiling
[175.287646] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.002s)
[175.535480] [059/162] (870s left) kms_addfb_basic (addfb25-modifier-no-flag)
[176.254574] Starting subtest: addfb25-modifier-no-flag
[176.256813] Subtest addfb25-modifier-no-flag: SUCCESS (0.001s)
[176.498480] [060/162] (869s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[177.168917] Starting subtest: addfb25-x-tiled-legacy
[177.173585] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[177.412338] [061/162] (869s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[178.121503] Starting subtest: addfb25-x-tiled-mismatch-legacy
[178.123117] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[178.366738] [062/162] (868s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[179.095466] Starting subtest: addfb25-yf-tiled-legacy
[179.098175] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[179.351159] [063/162] (867s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[180.052303] Starting subtest: addfb25-y-tiled-legacy
[180.053941] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[180.300758] [064/162] (866s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[181.010830] Starting subtest: addfb25-y-tiled-small-legacy
[181.015846] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[181.255986] [065/162] (865s left) kms_addfb_basic (bad-pitch-0)
[181.479203] Starting subtest: bad-pitch-0
[181.481162] Subtest bad-pitch-0: SUCCESS (0.000s)
[182.238896] [066/162] (865s left) kms_addfb_basic (bad-pitch-1024)
[182.473906] Starting subtest: bad-pitch-1024
[182.475918] Subtest bad-pitch-1024: SUCCESS (0.000s)
[183.202723] [067/162] (864s left) kms_addfb_basic (bad-pitch-128)
[183.425870] Starting subtest: bad-pitch-128
[183.429622] Subtest bad-pitch-128: SUCCESS (0.000s)
[184.165224] [068/162] (863s left) kms_addfb_basic (bad-pitch-256)
[184.383865] Starting subtest: bad-pitch-256
[184.387280] Subtest bad-pitch-256: SUCCESS (0.000s)
[185.143442] [069/162] (862s left) kms_addfb_basic (bad-pitch-32)
[185.364452] Starting subtest: bad-pitch-32
[185.365868] Subtest bad-pitch-32: SUCCESS (0.000s)
[186.126353] [070/162] (862s left) kms_addfb_basic (bad-pitch-63)
[186.336110] Starting subtest: bad-pitch-63
[186.338966] Subtest bad-pitch-63: SUCCESS (0.000s)
[187.097386] [071/162] (861s left) kms_addfb_basic (bad-pitch-65536)
[187.310577] Starting subtest: bad-pitch-65536
[187.313264] Subtest bad-pitch-65536: SUCCESS (0.001s)
[188.021064] [072/162] (860s left) kms_addfb_basic (bad-pitch-999)
[188.249568] Starting subtest: bad-pitch-999
[188.251080] Subtest bad-pitch-999: SUCCESS (0.000s)
[189.445850] [073/162] (859s left) kms_addfb_basic (basic)
[189.888167] Starting subtest: basic
[189.892585] Subtest basic: SUCCESS (0.000s)
[191.074386] [074/162] (858s left) kms_addfb_basic (basic-x-tiled-legacy)
[191.462466] Starting subtest: basic-x-tiled-legacy
[191.466056] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[192.243762] [075/162] (857s left) kms_addfb_basic (basic-y-tiled-legacy)
[192.468773] Starting subtest: basic-y-tiled-legacy
[192.471504] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[193.182345] [076/162] (856s left) kms_addfb_basic (bo-too-small)
[193.865176] Starting subtest: bo-too-small
[193.868966] Subtest bo-too-small: SUCCESS (0.001s)
[194.114351] [077/162] (855s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[194.799852] Starting subtest: bo-too-small-due-to-tiling
[194.805168] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[195.046495] [078/162] (854s left) kms_addfb_basic (clobberred-modifier)
[195.267201] Starting subtest: clobberred-modifier
[195.268753] Subtest clobberred-modifier: SUCCESS (0.000s)
[196.004476] [079/162] (854s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[196.225116] Starting subtest: framebuffer-vs-set-tiling
[196.227129] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[196.937734] [080/162] (853s left) kms_addfb_basic (invalid-get-prop)
[197.155916] Starting subtest: invalid-get-prop
[197.158878] Subtest invalid-get-prop: SUCCESS (0.000s)
[197.867825] [081/162] (852s left) kms_addfb_basic (invalid-get-prop-any)
[198.087127] Starting subtest: invalid-get-prop-any
[198.090698] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[198.854335] [082/162] (851s left) kms_addfb_basic (invalid-set-prop)
[199.081497] Starting subtest: invalid-set-prop
[199.084830] Subtest invalid-set-prop: SUCCESS (0.000s)
[199.776293] [083/162] (851s left) kms_addfb_basic (invalid-set-prop-any)
[199.993363] Starting subtest: invalid-set-prop-any
[199.995630] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[200.704617] [084/162] (850s left) kms_addfb_basic (no-handle)
[200.919195] Starting subtest: no-handle
[200.920799] Subtest no-handle: SUCCESS (0.000s)
[201.628674] [085/162] (849s left) kms_addfb_basic (size-max)
[202.331279] Starting subtest: size-max
[202.333260] Subtest size-max: SUCCESS (0.001s)
[202.591630] [086/162] (848s left) kms_addfb_basic (small-bo)
[203.292567] Starting subtest: small-bo
[203.307600] Subtest small-bo: SUCCESS (0.002s)
[203.551836] [087/162] (848s left) kms_addfb_basic (tile-pitch-mismatch)
[203.778847] Starting subtest: tile-pitch-mismatch
[203.783978] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[204.552840] [088/162] (847s left) kms_addfb_basic (too-high)
[205.314231] Starting subtest: too-high
[205.316203] Subtest too-high: SUCCESS (0.004s)
[205.563903] [089/162] (846s left) kms_addfb_basic (too-wide)
[206.250925] Starting subtest: too-wide
[206.253149] Subtest too-wide: SUCCESS (0.000s)
[206.500399] [090/162] (845s left) kms_addfb_basic (unused-handle)
[206.713467] Starting subtest: unused-handle
[206.716715] Subtest unused-handle: SUCCESS (0.000s)
[207.422354] [091/162] (844s left) kms_addfb_basic (unused-modifier)
[207.638126] Starting subtest: unused-modifier
[207.641324] Subtest unused-modifier: SUCCESS (0.000s)
[208.352505] [092/162] (844s left) kms_addfb_basic (unused-offsets)
[208.576212] Starting subtest: unused-offsets
[208.579417] Subtest unused-offsets: SUCCESS (0.000s)
[209.322931] [093/162] (843s left) kms_addfb_basic (unused-pitches)
[209.536284] Starting subtest: unused-pitches
[209.538936] Subtest unused-pitches: SUCCESS (0.000s)
[210.231408] [094/162] (842s left) kms_busy (basic)
[210.926782] Starting subtest: basic
[210.939564] Starting dynamic subtest: flip
[211.848985] Dynamic subtest flip: SUCCESS (0.920s)
[211.915510] Starting dynamic subtest: modeset
[213.844137] Dynamic subtest modeset: SUCCESS (1.988s)
[213.852590] Subtest basic: SUCCESS (2.919s)
[214.564892] [095/162] (838s left) kms_prop_blob (basic)
[214.808614] Starting subtest: basic
[214.812695] Subtest basic: SUCCESS (0.000s)
[215.054886] [096/162] (838s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[215.761440] Starting subtest: basic-busy-flip-before-cursor-atomic
[216.987179] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.214s)
[217.591783] [097/162] (835s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[218.292950] Starting subtest: basic-busy-flip-before-cursor-legacy
[219.451628] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.156s)
[220.096888] [098/162] (833s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[220.829897] Starting subtest: basic-flip-after-cursor-atomic
[221.942157] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.109s)
[222.620640] [099/162] (831s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[223.351506] Starting subtest: basic-flip-after-cursor-legacy
[224.496328] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.140s)
[225.115911] [100/162] (828s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[225.838442] Starting subtest: basic-flip-after-cursor-varying-size
[226.977139] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.147s)
[227.625600] [101/162] (826s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[228.359943] Starting subtest: basic-flip-before-cursor-atomic
[229.485146] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.124s)
[230.107057] [102/162] (824s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[230.827875] Starting subtest: basic-flip-before-cursor-legacy
[232.039717] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.214s)
[232.657350] [103/162] (822s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[233.345193] Starting subtest: basic-flip-before-cursor-varying-size
[234.456762] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.100s)
[235.087286] [104/162] (819s left) kms_dsc (dsc-basic)
[235.831537] Subtest dsc-basic: SKIP (0.000s)
[236.029892] [105/162] (819s left) kms_flip (basic-flip-vs-dpms)
[236.746946] Starting subtest: basic-flip-vs-dpms
[236.758048] Starting dynamic subtest: C-HDMI-A2
[239.641140] Dynamic subtest C-HDMI-A2: SUCCESS (2.885s)
[239.646212] Subtest basic-flip-vs-dpms: SUCCESS (2.901s)
[240.346474] [106/162] (814s left) kms_flip (basic-flip-vs-modeset)
[241.087545] Starting subtest: basic-flip-vs-modeset
[241.092637] Starting dynamic subtest: C-HDMI-A2
[244.008326] Dynamic subtest C-HDMI-A2: SUCCESS (2.902s)
[244.009891] Subtest basic-flip-vs-modeset: SUCCESS (2.922s)
[244.714902] [107/162] (810s left) kms_flip (basic-flip-vs-wf_vblank)
[245.502463] Starting subtest: basic-flip-vs-wf_vblank
[245.518989] Starting dynamic subtest: C-HDMI-A2
[248.336234] Dynamic subtest C-HDMI-A2: SUCCESS (2.802s)
[248.339309] Subtest basic-flip-vs-wf_vblank: SUCCESS (2.825s)
[248.622659] [108/162] (807s left) kms_flip (basic-plain-flip)
[249.323203] Starting subtest: basic-plain-flip
[249.330950] Starting dynamic subtest: C-HDMI-A2
[251.871114] Dynamic subtest C-HDMI-A2: SUCCESS (2.529s)
[251.874213] Subtest basic-plain-flip: SUCCESS (2.548s)
[252.171926] [109/162] (803s left) kms_force_connector_basic (force-connector-state)
[252.517517] Starting subtest: force-connector-state
[253.452101] Subtest force-connector-state: SUCCESS (0.936s)
[255.040549] [110/162] (801s left) kms_force_connector_basic (force-edid)
[255.423104] Starting subtest: force-edid
[255.498248] Subtest force-edid: SUCCESS (0.062s)
[256.420946] [111/162] (799s left) kms_force_connector_basic (force-load-detect)
[256.809735] Starting subtest: force-load-detect
[256.816922] Subtest force-load-detect: SKIP (0.000s)
[257.450546] [112/162] (799s left) kms_force_connector_basic (prune-stale-modes)
[257.811760] Starting subtest: prune-stale-modes
[257.880970] Subtest prune-stale-modes: SUCCESS (0.074s)
[258.882414] [113/162] (797s left) kms_frontbuffer_tracking (basic)
[259.677267] Starting subtest: basic
[264.837210] Subtest basic: SUCCESS (5.155s)
[265.108830] [114/162] (791s left) kms_hdmi_inject (inject-audio)
[265.447789] Starting subtest: inject-audio
[266.089732] Subtest inject-audio: SUCCESS (0.640s)
[266.826216] [115/162] (790s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[267.615834] Starting subtest: compare-crc-sanitycheck-xr24
[267.617917] Starting dynamic subtest: pipe-C-HDMI-A-2
[268.204164] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.569s)
[268.208686] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.589s)
[268.852793] [116/162] (788s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[269.591508] Starting subtest: compare-crc-sanitycheck-nv12
[269.593028] Starting dynamic subtest: pipe-C-HDMI-A-2
[269.597547] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[269.605631] Subtest compare-crc-sanitycheck-nv12: SKIP (0.011s)
[269.858557] [117/162] (787s left) kms_pipe_crc_basic (hang-read-crc)
[270.585981] Starting subtest: hang-read-crc
[270.590583] Starting dynamic subtest: pipe-C-HDMI-A-2
[272.215763] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.626s)
[272.219388] Subtest hang-read-crc: SUCCESS (1.634s)
[272.886365] [118/162] (784s left) kms_pipe_crc_basic (nonblocking-crc)
[273.684490] Starting subtest: nonblocking-crc
[273.687183] Starting dynamic subtest: pipe-C-HDMI-A-2
[274.409267] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.731s)
[274.418234] Subtest nonblocking-crc: SUCCESS (0.743s)
[275.064596] [119/162] (782s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[275.752323] Starting subtest: nonblocking-crc-frame-sequence
[275.769567] Starting dynamic subtest: pipe-C-HDMI-A-2
[276.534259] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.765s)
[276.537292] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.782s)
[277.188598] [120/162] (780s left) kms_pipe_crc_basic (read-crc)
[277.959921] Starting subtest: read-crc
[277.964229] Starting dynamic subtest: pipe-C-HDMI-A-2
[278.643871] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.681s)
[278.645471] Subtest read-crc: SUCCESS (0.692s)
[279.274999] [121/162] (778s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[280.144905] Starting subtest: read-crc-frame-sequence
[280.146560] Starting dynamic subtest: pipe-C-HDMI-A-2
[280.816546] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.674s)
[280.821574] Subtest read-crc-frame-sequence: SUCCESS (0.685s)
[281.485296] [122/162] (776s left) kms_pm_backlight (basic-brightness)
[282.242100] Subtest basic-brightness: SKIP (0.000s)
[282.451769] [123/162] (776s left) kms_pm_rpm (basic-pci-d3-state)
[284.779946] Starting subtest: basic-pci-d3-state
[285.162838] Subtest basic-pci-d3-state: SUCCESS (0.372s)
[285.676603] [124/162] (773s left) kms_pm_rpm (basic-rte)
[285.894666] Starting subtest: basic-rte
[288.343611] Subtest basic-rte: SUCCESS (2.439s)
[289.461256] [125/162] (769s left) kms_psr (psr-primary-page-flip)
[290.214032] Subtest psr-primary-page-flip: SKIP (0.000s)
[290.426699] [126/162] (768s left) kms_psr (psr-cursor-plane-move)
[291.154239] Subtest psr-cursor-plane-move: SKIP (0.000s)
[291.410940] [127/162] (767s left) kms_psr (psr-sprite-plane-onoff)
[292.168502] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[292.383589] [128/162] (767s left) kms_psr (psr-primary-mmap-gtt)
[293.127951] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[293.343861] [129/162] (766s left) kms_setmode (basic-clone-single-crtc)
[293.569868] Starting subtest: basic-clone-single-crtc
[293.577287] Subtest basic-clone-single-crtc: SKIP (0.001s)
[293.850341] [130/162] (766s left) i915_pm_rps (basic-api)
[294.108436] Starting subtest: basic-api
[294.122763] Subtest basic-api: SUCCESS (0.017s)
[294.385877] [131/162] (765s left) prime_self_import (basic-llseek-bad)
[294.663506] Starting subtest: basic-llseek-bad
[294.670558] Subtest basic-llseek-bad: SUCCESS (0.011s)
[294.910625] [132/162] (765s left) prime_self_import (basic-llseek-size)
[295.163266] Starting subtest: basic-llseek-size
[295.175229] Subtest basic-llseek-size: SUCCESS (0.018s)
[295.426793] [133/162] (765s left) prime_self_import (basic-with_fd_dup)
[295.635276] Starting subtest: basic-with_fd_dup
[295.650627] Subtest basic-with_fd_dup: SUCCESS (0.015s)
[295.892948] [134/162] (764s left) prime_self_import (basic-with_one_bo)
[296.108634] Starting subtest: basic-with_one_bo
[296.123624] Subtest basic-with_one_bo: SUCCESS (0.022s)
[296.379734] [135/162] (764s left) prime_self_import (basic-with_one_bo_two_files)
[296.592765] Starting subtest: basic-with_one_bo_two_files
[296.607348] Subtest basic-with_one_bo_two_files: SUCCESS (0.014s)
[296.841599] [136/162] (764s left) prime_self_import (basic-with_two_bos)
[297.046517] Starting subtest: basic-with_two_bos
[297.063344] Subtest basic-with_two_bos: SUCCESS (0.016s)
[297.324315] [137/162] (764s left) prime_vgem (basic-fence-flip)
[297.588569] Starting subtest: basic-fence-flip
[298.512801] Subtest basic-fence-flip: SKIP (0.886s)
[298.745396] [138/162] (762s left) prime_vgem (basic-fence-mmap)
[298.994944] Starting subtest: basic-fence-mmap
[299.106026] Subtest basic-fence-mmap: SUCCESS (0.110s)
[299.365860] [139/162] (762s left) prime_vgem (basic-fence-read)
[299.622397] Starting subtest: basic-fence-read
[299.884977] Subtest basic-fence-read: SUCCESS (0.256s)
[300.132972] [140/162] (761s left) prime_vgem (basic-gtt)
[300.400177] Starting subtest: basic-gtt
[300.449926] Subtest basic-gtt: SUCCESS (0.046s)
[300.707360] [141/162] (761s left) prime_vgem (basic-read)
[300.970982] Starting subtest: basic-read
[301.098344] Subtest basic-read: SUCCESS (0.120s)
[301.369839] [142/162] (760s left) prime_vgem (basic-write)
[301.618680] Starting subtest: basic-write
[301.792953] Subtest basic-write: SUCCESS (0.172s)
[302.048774] [143/162] (760s left) vgem_basic (setversion)
[302.284468] Starting subtest: setversion
[302.287337] Subtest setversion: SUCCESS (0.000s)
[302.517139] [144/162] (760s left) vgem_basic (create)
[302.750216] Starting subtest: create
[302.753530] Subtest create: SUCCESS (0.002s)
[302.977390] [145/162] (759s left) vgem_basic (debugfs)
[303.219226] Starting subtest: debugfs
[303.220731] Subtest debugfs: SUCCESS (0.002s)
[303.450636] [146/162] (759s left) vgem_basic (dmabuf-export)
[303.692143] Starting subtest: dmabuf-export
[303.695402] Subtest dmabuf-export: SUCCESS (0.013s)
[303.945797] [147/162] (759s left) vgem_basic (dmabuf-fence)
[304.184475] Starting subtest: dmabuf-fence
[304.187670] Subtest dmabuf-fence: SUCCESS (0.002s)
[304.415829] [148/162] (759s left) vgem_basic (dmabuf-fence-before)
[304.635810] Starting subtest: dmabuf-fence-before
[304.638875] Subtest dmabuf-fence-before: SUCCESS (0.002s)
[304.860964] [149/162] (758s left) vgem_basic (dmabuf-mmap)
[305.098774] Starting subtest: dmabuf-mmap
[305.145189] Subtest dmabuf-mmap: SUCCESS (0.044s)
[305.388903] [150/162] (758s left) vgem_basic (mmap)
[305.615360] Starting subtest: mmap
[305.643121] Subtest mmap: SUCCESS (0.030s)
[305.876248] [151/162] (758s left) vgem_basic (second-client)
[306.119374] Starting subtest: second-client
[306.166569] Subtest second-client: SUCCESS (0.046s)
[306.392522] [152/162] (757s left) vgem_basic (sysfs)
[306.614502] Starting subtest: sysfs
[306.616642] Subtest sysfs: SUCCESS (0.003s)
[306.850450] [153/162] (757s left) core_hotunplug (unbind-rebind)
[307.284143] Starting subtest: unbind-rebind
[313.821743] Subtest unbind-rebind: SUCCESS (6.536s)
[314.029959] [154/162] (750s left) vgem_basic (unload)
[314.252607] Starting subtest: unload
[343.564182] Subtest unload: SUCCESS (29.302s)
[343.940997] [155/162] (720s left) i915_module_load (reload)
[344.155224] Starting subtest: reload
[351.771883] Subtest reload: SUCCESS (7.622s)
[352.278222] [156/162] (713s left) gem_lmem_swapping (basic)
[352.661817] Subtest basic: SKIP (0.000s)
[352.887871] [157/162] (712s left) gem_lmem_swapping (parallel-random-engines)
[353.135889] Subtest parallel-random-engines: SKIP (0.000s)
[353.353683] [158/162] (712s left) gem_lmem_swapping (random-engines)
[353.607138] Subtest random-engines: SKIP (0.000s)
[353.820917] [159/162] (712s left) gem_lmem_swapping (verify-random)
[354.058104] Subtest verify-random: SKIP (0.000s)
[354.271508] [160/162] (711s left) i915_pm_rpm (module-reload)
[357.011150] Starting subtest: module-reload
[376.574432] Subtest module-reload: SUCCESS (19.560s)
[376.699902] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[376.706151] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[376.715501] [161/162] (689s left) i915_selftest (live)
[376.959573] Starting subtest: live
[376.961889] Starting dynamic subtest: sanitycheck
[382.114105] Dynamic subtest sanitycheck: SUCCESS (5.151s)
[382.163813] Starting dynamic subtest: uncore
[387.367814] Dynamic subtest uncore: SUCCESS (5.244s)
[387.405851] Starting dynamic subtest: workarounds
[393.276944] Dynamic subtest workarounds: SUCCESS (5.894s)
[393.302078] Starting dynamic subtest: gt_engines
[399.045672] Dynamic subtest gt_engines: SUCCESS (5.762s)
[399.072682] Starting dynamic subtest: gt_timelines
[435.567631] Dynamic subtest gt_timelines: SUCCESS (36.508s)
[435.593649] Starting dynamic subtest: gt_contexts
[440.919260] Dynamic subtest gt_contexts: SUCCESS (5.351s)
[440.945913] Starting dynamic subtest: gt_lrc
[449.369057] Dynamic subtest gt_lrc: SUCCESS (8.443s)
[449.401391] Starting dynamic subtest: gt_mocs
[454.404639] Dynamic subtest gt_mocs: SUCCESS (5.026s)
[454.438687] Starting dynamic subtest: gt_pm
[460.944379] Dynamic subtest gt_pm: SUCCESS (6.526s)
[460.970420] Starting dynamic subtest: gt_heartbeat
[466.310081] Dynamic subtest gt_heartbeat: SUCCESS (5.358s)
[466.335201] Starting dynamic subtest: gt_tlb
[472.348662] Dynamic subtest gt_tlb: SUCCESS (6.032s)
[472.375343] Starting dynamic subtest: requests
[484.008903] Dynamic subtest requests: SUCCESS (11.652s)
[484.035684] Starting dynamic subtest: migrate
[493.518856] Dynamic subtest migrate: SUCCESS (9.503s)
[493.550557] Starting dynamic subtest: active
[498.547139] Dynamic subtest active: SUCCESS (5.011s)
[498.589923] Starting dynamic subtest: objects
[505.288698] Dynamic subtest objects: SUCCESS (6.731s)
[505.319379] Starting dynamic subtest: mman
[517.272098] Dynamic subtest mman: SUCCESS (11.973s)
[517.297836] Starting dynamic subtest: dmabuf
[522.633380] Dynamic subtest dmabuf: SUCCESS (5.352s)
[522.660969] Starting dynamic subtest: vma
[527.844188] Dynamic subtest vma: SUCCESS (5.207s)
[527.893549] Starting dynamic subtest: coherency
[539.065102] Dynamic subtest coherency: SUCCESS (11.208s)
[539.096765] Starting dynamic subtest: gtt
[552.128144] Dynamic subtest gtt: SUCCESS (13.052s)
[552.153493] Starting dynamic subtest: gem
[558.724437] Dynamic subtest gem: SUCCESS (6.589s)
[558.751080] Starting dynamic subtest: evict
[571.695583] Dynamic subtest evict: SUCCESS (12.970s)
[571.727671] Starting dynamic subtest: hugepages
[577.256498] Dynamic subtest hugepages: SUCCESS (5.553s)
[577.297926] Starting dynamic subtest: gem_contexts
[610.146489] Dynamic subtest gem_contexts: SUCCESS (32.874s)
[610.228226] Starting dynamic subtest: client
[615.501192] Dynamic subtest client: SUCCESS (5.332s)
[615.545075] Starting dynamic subtest: gem_migrate
[620.537931] Dynamic subtest gem_migrate: SUCCESS (5.036s)
[620.573701] Starting dynamic subtest: reset
[633.027592] Dynamic subtest reset: SUCCESS (12.477s)
[633.053217] Starting dynamic subtest: memory_region
[637.961091] Dynamic subtest memory_region: SUCCESS (4.925s)
[637.990969] Starting dynamic subtest: hangcheck
[666.370435] Dynamic subtest hangcheck: SUCCESS (28.402s)
[666.395814] Starting dynamic subtest: execlists
[677.848065] Dynamic subtest execlists: SUCCESS (11.472s)
[677.876723] Starting dynamic subtest: ring_submission
[682.922037] Dynamic subtest ring_submission: SUCCESS (5.065s)
[682.951328] Starting dynamic subtest: perf
[688.525681] Dynamic subtest perf: SUCCESS (5.596s)
[688.551651] Starting dynamic subtest: slpc
[693.670739] Dynamic subtest slpc: SUCCESS (5.137s)
[693.707877] Starting dynamic subtest: guc
[698.914315] Dynamic subtest guc: SUCCESS (5.233s)
[698.959237] Starting dynamic subtest: guc_multi_lrc
[703.956157] Dynamic subtest guc_multi_lrc: SUCCESS (5.041s)
[704.036788] Starting dynamic subtest: guc_hang
[709.076657] Dynamic subtest guc_hang: SUCCESS (5.107s)
[709.125154] Starting dynamic subtest: late_gt_pm
[714.374118] Dynamic subtest late_gt_pm: SUCCESS (5.286s)
[714.376544] Subtest live: SUCCESS (337.408s)
[714.524498] [162/162] (351s left) dmabuf (all-tests)
[714.772117] Starting subtest: all-tests
[714.774223] Starting dynamic subtest: sanitycheck
[714.858100] Dynamic subtest sanitycheck: SUCCESS (0.077s)
[714.896276] Starting dynamic subtest: dma_fence
[715.158798] Dynamic subtest dma_fence: SUCCESS (0.291s)
[715.202794] Starting dynamic subtest: dma_fence_chain