[77.250418] Initializing watchdogs
[77.250783]   /dev/watchdog0
[77.320544] [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
[77.339554] [001/161] (960s left) i915_module_load (load)
[78.315388] Starting subtest: load
[83.799495] Subtest load: SUCCESS (5.444s)
[84.204836] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[84.227999] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[84.254369] [002/161] (954s left) core_auth (basic-auth)
[84.753195] Starting subtest: basic-auth
[84.768195] Subtest basic-auth: SUCCESS (0.010s)
[85.078229] [003/161] (953s left) debugfs_test (read_all_entries)
[85.437790] Starting subtest: read_all_entries
[85.790159] Subtest read_all_entries: SUCCESS (0.351s)
[86.524893] [004/161] (952s left) debugfs_test (basic-hwmon)
[86.816207] Starting subtest: basic-hwmon
[86.819565] Subtest basic-hwmon: SKIP (0.000s)
[87.512238] [005/161] (951s left) debugfs_test (sysfs)
[87.794725] Starting subtest: sysfs
[88.233986] Subtest sysfs: SUCCESS (0.439s)
[88.934850] [006/161] (950s left) fbdev (eof)
[89.234026] Starting subtest: eof
[89.237817] Subtest eof: SUCCESS (0.003s)
[89.437716] [007/161] (949s left) fbdev (info)
[89.691515] Starting subtest: info
[89.694300] Subtest info: SUCCESS (0.000s)
[89.906360] [008/161] (949s left) fbdev (nullptr)
[90.170491] Starting subtest: nullptr
[90.173887] Subtest nullptr: SUCCESS (0.000s)
[90.388571] [009/161] (949s left) fbdev (read)
[90.658482] Starting subtest: read
[92.736382] Subtest read: SUCCESS (2.067s)
[92.937595] [010/161] (946s left) fbdev (write)
[93.208096] Starting subtest: write
[94.312411] Subtest write: SUCCESS (1.094s)
[94.504716] [011/161] (945s left) gem_basic (bad-close)
[94.770932] Starting subtest: bad-close
[94.775522] Subtest bad-close: SUCCESS (0.000s)
[94.993622] [012/161] (945s left) gem_basic (create-close)
[95.250336] Starting subtest: create-close
[95.257754] Subtest create-close: SUCCESS (0.001s)
[95.521190] [013/161] (944s left) gem_basic (create-fd-close)
[95.785210] Starting subtest: create-fd-close
[95.789852] Subtest create-fd-close: SUCCESS (0.001s)
[96.003644] [014/161] (944s left) gem_busy (busy@all-engines)
[96.325475] Starting subtest: busy
[96.331245] Starting dynamic subtest: all-engines
[96.531547] Dynamic subtest all-engines: SUCCESS (0.207s)
[96.533218] Subtest busy: SUCCESS (0.211s)
[97.077334] [015/161] (943s left) gem_close_race (basic-process)
[97.421156] Starting subtest: basic-process
[97.562941] Subtest basic-process: SUCCESS (0.143s)
[97.904918] [016/161] (942s left) gem_close_race (basic-threads)
[98.236188] Starting subtest: basic-threads
[99.522617] Subtest basic-threads: SUCCESS (1.289s)
[99.878504] [017/161] (941s left) gem_ctx_create (basic)
[100.200414] Starting subtest: basic
[100.201930] Subtest basic: SUCCESS (0.000s)
[100.549231] [018/161] (940s left) gem_ctx_create (basic-files)
[100.867453] Starting subtest: basic-files
[102.940454] Subtest basic-files: SUCCESS (2.073s)
[103.294518] [019/161] (937s left) gem_ctx_exec (basic)
[103.562750] Starting subtest: basic
[103.579851] Subtest basic: SUCCESS (0.016s)
[103.815200] [020/161] (937s left) gem_exec_basic (basic)
[104.109293] Starting subtest: basic
[104.112864] Starting dynamic subtest: rcs0-smem
[104.116432] Dynamic subtest rcs0-smem: SUCCESS (0.005s)
[104.153606] Starting dynamic subtest: bcs0-smem
[104.156464] Dynamic subtest bcs0-smem: SUCCESS (0.004s)
[104.183627] Starting dynamic subtest: vcs0-smem
[104.187375] Dynamic subtest vcs0-smem: SUCCESS (0.023s)
[104.211905] Starting dynamic subtest: vecs0-smem
[104.216268] Dynamic subtest vecs0-smem: SUCCESS (0.004s)
[104.219485] Subtest basic: SUCCESS (0.042s)
[104.513270] [021/161] (937s left) gem_exec_create (basic)
[104.827813] Starting subtest: basic
[104.830403] Starting dynamic subtest: smem
[106.939528] Dynamic subtest smem: SUCCESS (2.105s)
[106.942199] Subtest basic: SUCCESS (2.112s)
[107.285854] [022/161] (934s left) gem_exec_fence (basic-busy)
[107.775160] Starting subtest: basic-busy
[107.776788] Starting dynamic subtest: rcs0
[107.808429] Dynamic subtest rcs0: SUCCESS (0.034s)
[107.838230] Starting dynamic subtest: bcs0
[107.842474] Dynamic subtest bcs0: SUCCESS (0.033s)
[107.866385] Starting dynamic subtest: vcs0
[107.887137] Dynamic subtest vcs0: SUCCESS (0.042s)
[107.910947] Starting dynamic subtest: vecs0
[107.930777] Dynamic subtest vecs0: SUCCESS (0.038s)
[107.932556] Subtest basic-busy: SUCCESS (0.155s)
[108.926881] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[108.940401] [023/161] (933s left) gem_exec_fence (basic-wait)
[109.422203] Starting subtest: basic-wait
[109.425075] Starting dynamic subtest: rcs0
[109.447078] Dynamic subtest rcs0: SUCCESS (0.027s)
[109.471559] Starting dynamic subtest: bcs0
[109.489223] Dynamic subtest bcs0: SUCCESS (0.038s)
[109.514279] Starting dynamic subtest: vcs0
[109.536959] Dynamic subtest vcs0: SUCCESS (0.048s)
[109.561607] Starting dynamic subtest: vecs0
[109.572724] Dynamic subtest vecs0: SUCCESS (0.034s)
[109.575401] Subtest basic-wait: SUCCESS (0.157s)
[110.410938] [024/161] (931s left) gem_exec_fence (basic-await)
[110.912130] Starting subtest: basic-await
[110.915341] Starting dynamic subtest: rcs0
[111.137372] Dynamic subtest rcs0: SUCCESS (0.222s)
[111.173131] Starting dynamic subtest: bcs0
[111.406276] Dynamic subtest bcs0: SUCCESS (0.266s)
[111.433736] Starting dynamic subtest: vcs0
[111.641771] Dynamic subtest vcs0: SUCCESS (0.233s)
[111.669248] Starting dynamic subtest: vecs0
[111.879173] Dynamic subtest vecs0: SUCCESS (0.236s)
[111.884228] Subtest basic-await: SUCCESS (0.966s)
[112.722219] [025/161] (929s left) gem_exec_fence (nb-await)
[113.203187] Starting subtest: nb-await
[113.206079] Starting dynamic subtest: rcs0
[113.302804] Dynamic subtest rcs0: SUCCESS (0.093s)
[113.328426] Starting dynamic subtest: bcs0
[113.404177] Dynamic subtest bcs0: SUCCESS (0.101s)
[113.429934] Starting dynamic subtest: vcs0
[113.502976] Dynamic subtest vcs0: SUCCESS (0.098s)
[113.529099] Starting dynamic subtest: vecs0
[113.600556] Dynamic subtest vecs0: SUCCESS (0.098s)
[113.602221] Subtest nb-await: SUCCESS (0.396s)
[114.440930] [026/161] (928s left) gem_exec_gttfill (basic)
[114.759130] Starting subtest: basic
[116.725272] Subtest basic: SKIP (1.943s)
[117.118813] [027/161] (925s left) gem_exec_parallel (engines)
[117.622258] Starting subtest: engines
[117.623885] Starting dynamic subtest: basic
[123.910166] Dynamic subtest basic: SUCCESS (6.290s)
[123.950708] Starting dynamic subtest: contexts
[134.510652] Dynamic subtest contexts: SUCCESS (10.593s)
[134.555626] Starting dynamic subtest: fds
[145.539516] Dynamic subtest fds: SUCCESS (11.030s)
[145.571603] Starting dynamic subtest: userptr
[151.828635] Dynamic subtest userptr: SUCCESS (6.289s)
[151.830370] Subtest engines: SUCCESS (34.208s)
[152.259679] [028/161] (890s left) gem_exec_store (basic)
[152.591573] Starting subtest: basic
[152.673271] Subtest basic: SUCCESS (0.083s)
[153.057480] [029/161] (890s left) gem_flink_basic (bad-flink)
[153.324265] Starting subtest: bad-flink
[153.326248] Subtest bad-flink: SUCCESS (0.000s)
[153.553419] [030/161] (889s left) gem_flink_basic (bad-open)
[153.813526] Starting subtest: bad-open
[153.817344] Subtest bad-open: SUCCESS (0.000s)
[154.105186] [031/161] (889s left) gem_flink_basic (basic)
[154.363393] Starting subtest: basic
[154.365827] Subtest basic: SUCCESS (0.001s)
[154.632337] [032/161] (889s left) gem_flink_basic (double-flink)
[154.888555] Starting subtest: double-flink
[154.892157] Subtest double-flink: SUCCESS (0.000s)
[155.141686] [033/161] (888s left) gem_flink_basic (flink-lifetime)
[155.418147] Starting subtest: flink-lifetime
[155.430095] Subtest flink-lifetime: SUCCESS (0.017s)
[155.695627] [034/161] (888s left) gem_huc_copy (huc-copy)
[155.972308] Subtest huc-copy: SKIP (0.000s)
[156.175975] [035/161] (888s left) gem_linear_blits (basic)
[156.857072] Subtest basic: SKIP (0.000s)
[157.072234] [036/161] (887s left) gem_mmap (basic)
[157.514641] Starting subtest: basic
[157.527105] Subtest basic: SUCCESS (0.001s)
[157.768385] [037/161] (887s left) gem_mmap_gtt (basic)
[158.028979] Starting subtest: basic
[158.030758] Subtest basic: SUCCESS (0.004s)
[158.278708] [038/161] (886s left) gem_render_linear_blits (basic)
[158.572322] Starting subtest: basic
[158.699480] Subtest basic: SUCCESS (0.121s)
[158.906586] [039/161] (886s left) gem_render_tiled_blits (basic)
[159.176652] Starting subtest: basic
[159.349380] Subtest basic: SUCCESS (0.159s)
[159.552055] [040/161] (885s left) gem_ringfill (basic-all)
[160.060363] Starting subtest: basic-all
[161.420256] Subtest basic-all: SUCCESS (1.349s)
[161.656831] [041/161] (883s left) gem_softpin (allocator-basic)
[161.928678] Starting subtest: allocator-basic
[162.318101] Subtest allocator-basic: SUCCESS (0.385s)
[162.623229] [042/161] (883s left) gem_softpin (allocator-basic-reserve)
[162.896217] Starting subtest: allocator-basic-reserve
[163.278747] Subtest allocator-basic-reserve: SUCCESS (0.366s)
[163.576594] [043/161] (882s left) gem_softpin (safe-alignment)
[163.855672] Starting subtest: safe-alignment
[163.918364] Subtest safe-alignment: SUCCESS (0.058s)
[164.163874] [044/161] (881s left) gem_sync (basic-all)
[164.486255] Starting subtest: basic-all
[167.531822] Subtest basic-all: SUCCESS (3.048s)
[167.931669] [045/161] (878s left) gem_sync (basic-each)
[168.247343] Starting subtest: basic-each
[171.224669] Subtest basic-each: SUCCESS (2.977s)
[171.580360] [046/161] (874s left) gem_tiled_blits (basic)
[172.131735] Subtest basic: SKIP (0.000s)
[172.355627] [047/161] (874s left) gem_tiled_fence_blits (basic)
[173.059194] Starting subtest: basic
[173.121597] Subtest basic: SUCCESS (0.064s)
[173.431653] [048/161] (873s left) gem_tiled_pread_basic
[174.857915] [049/161] (872s left) gem_wait (busy@all-engines)
[175.216540] Starting subtest: busy
[175.219261] Starting dynamic subtest: all-engines
[175.740999] Dynamic subtest all-engines: SUCCESS (0.532s)
[175.748127] Subtest busy: SUCCESS (0.537s)
[176.231068] [050/161] (871s left) gem_wait (wait@all-engines)
[176.584580] Starting subtest: wait
[176.587118] Starting dynamic subtest: all-engines
[177.638957] Dynamic subtest all-engines: SUCCESS (1.051s)
[177.642121] Subtest wait: SUCCESS (1.054s)
[178.133392] [051/161] (869s left) i915_getparams_basic (basic-eu-total)
[178.386916] Starting subtest: basic-eu-total
[178.392949] Subtest basic-eu-total: SUCCESS (0.000s)
[178.619178] [052/161] (869s left) i915_getparams_basic (basic-subslice-total)
[178.877403] Starting subtest: basic-subslice-total
[178.885613] Subtest basic-subslice-total: SUCCESS (0.000s)
[179.121594] [053/161] (868s left) i915_hangman (error-state-basic)
[179.418816] Starting subtest: error-state-basic
[179.472142] Subtest error-state-basic: SUCCESS (0.053s)
[179.763674] [054/161] (868s left) i915_pciid
[180.275755] [055/161] (868s left) kms_addfb_basic (addfb25-4-tiled)
[181.027814] Starting subtest: addfb25-4-tiled
[181.031749] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[181.275668] [056/161] (867s left) kms_addfb_basic (addfb25-bad-modifier)
[182.038989] Starting subtest: addfb25-bad-modifier
[182.040707] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[182.284813] [057/161] (866s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[183.024695] Starting subtest: addfb25-framebuffer-vs-set-tiling
[183.026884] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[183.306836] [058/161] (865s left) kms_addfb_basic (addfb25-modifier-no-flag)
[184.029488] Starting subtest: addfb25-modifier-no-flag
[184.031304] Subtest addfb25-modifier-no-flag: SUCCESS (0.001s)
[184.291549] [059/161] (864s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[185.030494] Starting subtest: addfb25-x-tiled-legacy
[185.034777] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[185.294228] [060/161] (864s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[186.041224] Starting subtest: addfb25-x-tiled-mismatch-legacy
[186.043242] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[186.318653] [061/161] (863s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[187.036646] Starting subtest: addfb25-yf-tiled-legacy
[187.038721] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[187.301521] [062/161] (862s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[188.047356] Starting subtest: addfb25-y-tiled-legacy
[188.049312] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[188.326896] [063/161] (861s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[189.034148] Starting subtest: addfb25-y-tiled-small-legacy
[189.040688] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[189.276806] [064/161] (860s left) kms_addfb_basic (bad-pitch-0)
[189.544296] Starting subtest: bad-pitch-0
[189.547099] Subtest bad-pitch-0: SUCCESS (0.000s)
[190.213506] [065/161] (860s left) kms_addfb_basic (bad-pitch-1024)
[190.481985] Starting subtest: bad-pitch-1024
[190.485677] Subtest bad-pitch-1024: SUCCESS (0.000s)
[191.216548] [066/161] (859s left) kms_addfb_basic (bad-pitch-128)
[191.482649] Starting subtest: bad-pitch-128
[191.487459] Subtest bad-pitch-128: SUCCESS (0.000s)
[192.194274] [067/161] (858s left) kms_addfb_basic (bad-pitch-256)
[192.456220] Starting subtest: bad-pitch-256
[192.458145] Subtest bad-pitch-256: SUCCESS (0.000s)
[193.152518] [068/161] (857s left) kms_addfb_basic (bad-pitch-32)
[193.415897] Starting subtest: bad-pitch-32
[193.418940] Subtest bad-pitch-32: SUCCESS (0.000s)
[194.114705] [069/161] (857s left) kms_addfb_basic (bad-pitch-63)
[194.385322] Starting subtest: bad-pitch-63
[194.389183] Subtest bad-pitch-63: SUCCESS (0.000s)
[195.135987] [070/161] (856s left) kms_addfb_basic (bad-pitch-65536)
[195.404886] Starting subtest: bad-pitch-65536
[195.407743] Subtest bad-pitch-65536: SUCCESS (0.001s)
[196.138924] [071/161] (855s left) kms_addfb_basic (bad-pitch-999)
[196.397820] Starting subtest: bad-pitch-999
[196.400484] Subtest bad-pitch-999: SUCCESS (0.002s)
[197.148876] [072/161] (854s left) kms_addfb_basic (basic)
[197.418587] Starting subtest: basic
[197.421205] Subtest basic: SUCCESS (0.000s)
[198.132411] [073/161] (853s left) kms_addfb_basic (basic-x-tiled-legacy)
[198.404186] Starting subtest: basic-x-tiled-legacy
[198.405720] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[199.176760] [074/161] (852s left) kms_addfb_basic (basic-y-tiled-legacy)
[199.439355] Starting subtest: basic-y-tiled-legacy
[199.447900] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[200.163723] [075/161] (852s left) kms_addfb_basic (bo-too-small)
[200.952282] Starting subtest: bo-too-small
[200.954950] Subtest bo-too-small: SUCCESS (0.003s)
[201.211200] [076/161] (851s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[201.963923] Starting subtest: bo-too-small-due-to-tiling
[201.967970] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[202.209175] [077/161] (850s left) kms_addfb_basic (clobberred-modifier)
[202.466144] Starting subtest: clobberred-modifier
[202.468501] Subtest clobberred-modifier: SUCCESS (0.000s)
[203.400768] [078/161] (849s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[203.720519] Starting subtest: framebuffer-vs-set-tiling
[203.722089] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[204.666867] [079/161] (848s left) kms_addfb_basic (invalid-get-prop)
[204.967332] Starting subtest: invalid-get-prop
[204.971147] Subtest invalid-get-prop: SUCCESS (0.000s)
[205.954561] [080/161] (847s left) kms_addfb_basic (invalid-get-prop-any)
[206.250133] Starting subtest: invalid-get-prop-any
[206.252181] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[207.298571] [081/161] (846s left) kms_addfb_basic (invalid-set-prop)
[207.597880] Starting subtest: invalid-set-prop
[207.605319] Subtest invalid-set-prop: SUCCESS (0.000s)
[208.613750] [082/161] (845s left) kms_addfb_basic (invalid-set-prop-any)
[208.894567] Starting subtest: invalid-set-prop-any
[208.899857] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[209.892623] [083/161] (844s left) kms_addfb_basic (no-handle)
[210.170574] Starting subtest: no-handle
[210.174264] Subtest no-handle: SUCCESS (0.000s)
[211.177301] [084/161] (843s left) kms_addfb_basic (size-max)
[212.033615] Starting subtest: size-max
[212.039997] Subtest size-max: SUCCESS (0.001s)
[212.346964] [085/161] (842s left) kms_addfb_basic (small-bo)
[213.230796] Starting subtest: small-bo
[213.234380] Subtest small-bo: SUCCESS (0.000s)
[213.498084] [086/161] (841s left) kms_addfb_basic (tile-pitch-mismatch)
[213.768183] Starting subtest: tile-pitch-mismatch
[213.771099] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[214.456615] [087/161] (840s left) kms_addfb_basic (too-high)
[215.234456] Starting subtest: too-high
[215.243622] Subtest too-high: SUCCESS (0.008s)
[215.654944] [088/161] (839s left) kms_addfb_basic (too-wide)
[216.390537] Starting subtest: too-wide
[216.394582] Subtest too-wide: SUCCESS (0.000s)
[216.664642] [089/161] (839s left) kms_addfb_basic (unused-handle)
[216.932843] Starting subtest: unused-handle
[216.936896] Subtest unused-handle: SUCCESS (0.000s)
[217.681225] [090/161] (838s left) kms_addfb_basic (unused-modifier)
[217.948557] Starting subtest: unused-modifier
[217.951940] Subtest unused-modifier: SUCCESS (0.000s)
[218.703461] [091/161] (837s left) kms_addfb_basic (unused-offsets)
[218.962207] Starting subtest: unused-offsets
[218.963704] Subtest unused-offsets: SUCCESS (0.000s)
[219.678366] [092/161] (836s left) kms_addfb_basic (unused-pitches)
[219.943783] Starting subtest: unused-pitches
[219.947491] Subtest unused-pitches: SUCCESS (0.000s)
[220.699205] [093/161] (835s left) kms_busy (basic)
[221.458581] Starting subtest: basic
[221.468600] Starting dynamic subtest: flip
[222.383762] Dynamic subtest flip: SUCCESS (0.916s)
[222.431870] Starting dynamic subtest: modeset
[224.386157] Dynamic subtest modeset: SUCCESS (1.999s)
[224.394143] Subtest basic: SUCCESS (2.934s)
[225.073285] [094/161] (831s left) kms_prop_blob (basic)
[225.338767] Starting subtest: basic
[225.341190] Subtest basic: SUCCESS (0.000s)
[225.600680] [095/161] (831s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[226.351128] Starting subtest: basic-busy-flip-before-cursor-atomic
[227.419153] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.062s)
[228.021976] [096/161] (829s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[228.787198] Starting subtest: basic-busy-flip-before-cursor-legacy
[229.852752] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.062s)
[230.525501] [097/161] (826s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[231.276651] Starting subtest: basic-flip-after-cursor-atomic
[232.326446] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.044s)
[233.136670] [098/161] (824s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[234.031033] Starting subtest: basic-flip-after-cursor-legacy
[235.063971] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.041s)
[235.751396] [099/161] (821s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[236.505707] Starting subtest: basic-flip-after-cursor-varying-size
[237.565891] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.053s)
[238.139819] [100/161] (819s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[238.908332] Starting subtest: basic-flip-before-cursor-atomic
[239.958639] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.046s)
[240.560540] [101/161] (817s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[241.355473] Starting subtest: basic-flip-before-cursor-legacy
[242.409095] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.042s)
[243.020587] [102/161] (815s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[243.732083] Starting subtest: basic-flip-before-cursor-varying-size
[244.792142] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.055s)
[245.381930] [103/161] (813s left) kms_dsc (dsc-basic)
[246.138950] Subtest dsc-basic: SKIP (0.000s)
[246.372778] [104/161] (812s left) kms_flip (basic-flip-vs-dpms)
[247.131349] Starting subtest: basic-flip-vs-dpms
[247.145113] Starting dynamic subtest: C-HDMI-A2
[249.890210] Dynamic subtest C-HDMI-A2: SUCCESS (2.741s)
[249.891801] Subtest basic-flip-vs-dpms: SUCCESS (2.762s)
[250.547080] [105/161] (808s left) kms_flip (basic-flip-vs-modeset)
[251.307885] Starting subtest: basic-flip-vs-modeset
[251.316472] Starting dynamic subtest: C-HDMI-A2
[253.822359] Dynamic subtest C-HDMI-A2: SUCCESS (2.489s)
[253.827709] Subtest basic-flip-vs-modeset: SUCCESS (2.518s)
[254.505815] [106/161] (804s left) kms_flip (basic-flip-vs-wf_vblank)
[255.260665] Starting subtest: basic-flip-vs-wf_vblank
[255.279636] Starting dynamic subtest: C-HDMI-A2
[258.230055] Dynamic subtest C-HDMI-A2: SUCCESS (2.942s)
[258.231693] Subtest basic-flip-vs-wf_vblank: SUCCESS (2.959s)
[258.563367] [107/161] (800s left) kms_flip (basic-plain-flip)
[259.345158] Starting subtest: basic-plain-flip
[259.352511] Starting dynamic subtest: C-HDMI-A2
[261.850320] Dynamic subtest C-HDMI-A2: SUCCESS (2.491s)
[261.853979] Subtest basic-plain-flip: SUCCESS (2.506s)
[262.182071] [108/161] (797s left) kms_force_connector_basic (force-connector-state)
[262.565989] Starting subtest: force-connector-state
[263.481652] Subtest force-connector-state: SUCCESS (0.919s)
[265.171247] [109/161] (794s left) kms_force_connector_basic (force-edid)
[265.709356] Starting subtest: force-edid
[265.801171] Subtest force-edid: SUCCESS (0.078s)
[266.834206] [110/161] (793s left) kms_force_connector_basic (force-load-detect)
[267.358131] Starting subtest: force-load-detect
[267.365311] Subtest force-load-detect: SKIP (0.000s)
[268.110202] [111/161] (792s left) kms_force_connector_basic (prune-stale-modes)
[268.518196] Starting subtest: prune-stale-modes
[268.665352] Subtest prune-stale-modes: SUCCESS (0.148s)
[269.651614] [112/161] (790s left) kms_frontbuffer_tracking (basic)
[270.480882] Starting subtest: basic
[275.514155] Subtest basic: SUCCESS (5.033s)
[275.800331] [113/161] (784s left) kms_hdmi_inject (inject-audio)
[276.186870] Starting subtest: inject-audio
[276.839969] Subtest inject-audio: SUCCESS (0.589s)
[277.477078] [114/161] (783s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[278.256533] Starting subtest: compare-crc-sanitycheck-xr24
[278.260135] Starting dynamic subtest: pipe-C-HDMI-A-2
[278.821689] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.556s)
[278.827156] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.567s)
[279.441645] [115/161] (781s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[280.225965] Starting subtest: compare-crc-sanitycheck-nv12
[280.244300] Starting dynamic subtest: pipe-C-HDMI-A-2
[280.247719] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[280.254970] Subtest compare-crc-sanitycheck-nv12: SKIP (0.016s)
[280.505467] [116/161] (780s left) kms_pipe_crc_basic (hang-read-crc)
[281.253915] Starting subtest: hang-read-crc
[281.266174] Starting dynamic subtest: pipe-C-HDMI-A-2
[282.868595] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.606s)
[282.877380] Subtest hang-read-crc: SUCCESS (1.619s)
[283.492989] [117/161] (777s left) kms_pipe_crc_basic (nonblocking-crc)
[284.293945] Starting subtest: nonblocking-crc
[284.299122] Starting dynamic subtest: pipe-C-HDMI-A-2
[285.039277] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.731s)
[285.041222] Subtest nonblocking-crc: SUCCESS (0.751s)
[285.647241] [118/161] (776s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[286.416213] Starting subtest: nonblocking-crc-frame-sequence
[286.426473] Starting dynamic subtest: pipe-C-HDMI-A-2
[287.162057] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.731s)
[287.164550] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.746s)
[287.822490] [119/161] (774s left) kms_pipe_crc_basic (read-crc)
[288.580682] Starting subtest: read-crc
[288.582291] Starting dynamic subtest: pipe-C-HDMI-A-2
[289.228623] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.645s)
[289.230237] Subtest read-crc: SUCCESS (0.657s)
[289.889817] [120/161] (772s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[290.730969] Starting subtest: read-crc-frame-sequence
[290.732643] Starting dynamic subtest: pipe-C-HDMI-A-2
[291.419291] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.681s)
[291.421629] Subtest read-crc-frame-sequence: SUCCESS (0.697s)
[292.020877] [121/161] (770s left) kms_pm_backlight (basic-brightness)
[292.808619] Subtest basic-brightness: SKIP (0.000s)
[293.027422] [122/161] (769s left) kms_pm_rpm (basic-pci-d3-state)
[295.428489] Starting subtest: basic-pci-d3-state
[295.800943] Subtest basic-pci-d3-state: SUCCESS (0.361s)
[296.300334] [123/161] (766s left) kms_pm_rpm (basic-rte)
[296.553368] Starting subtest: basic-rte
[299.100419] Subtest basic-rte: SUCCESS (2.545s)
[300.171603] [124/161] (762s left) kms_psr (psr-primary-page-flip)
[300.946117] Subtest psr-primary-page-flip: SKIP (0.000s)
[301.152822] [125/161] (761s left) kms_psr (psr-cursor-plane-move)
[301.950677] Subtest psr-cursor-plane-move: SKIP (0.000s)
[302.157670] [126/161] (761s left) kms_psr (psr-sprite-plane-onoff)
[302.909691] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[303.148739] [127/161] (760s left) kms_psr (psr-primary-mmap-gtt)
[303.943433] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[304.154637] [128/161] (759s left) kms_setmode (basic-clone-single-crtc)
[304.422836] Starting subtest: basic-clone-single-crtc
[304.434240] Subtest basic-clone-single-crtc: SKIP (0.001s)
[304.698630] [129/161] (759s left) i915_pm_rps (basic-api)
[304.990388] Starting subtest: basic-api
[305.011058] Subtest basic-api: SUCCESS (0.020s)
[305.292957] [130/161] (758s left) prime_self_import (basic-llseek-bad)
[305.567270] Starting subtest: basic-llseek-bad
[305.588818] Subtest basic-llseek-bad: SUCCESS (0.018s)
[305.859908] [131/161] (758s left) prime_self_import (basic-llseek-size)
[306.111232] Starting subtest: basic-llseek-size
[306.121923] Subtest basic-llseek-size: SUCCESS (0.017s)
[306.382468] [132/161] (758s left) prime_self_import (basic-with_fd_dup)
[306.633698] Starting subtest: basic-with_fd_dup
[306.646100] Subtest basic-with_fd_dup: SUCCESS (0.014s)
[306.903760] [133/161] (757s left) prime_self_import (basic-with_one_bo)
[307.155576] Starting subtest: basic-with_one_bo
[307.170592] Subtest basic-with_one_bo: SUCCESS (0.015s)
[307.434385] [134/161] (757s left) prime_self_import (basic-with_one_bo_two_files)
[307.691775] Starting subtest: basic-with_one_bo_two_files
[307.710614] Subtest basic-with_one_bo_two_files: SUCCESS (0.015s)
[307.958739] [135/161] (757s left) prime_self_import (basic-with_two_bos)
[308.215086] Starting subtest: basic-with_two_bos
[308.228720] Subtest basic-with_two_bos: SUCCESS (0.014s)
[308.481177] [136/161] (756s left) prime_vgem (basic-fence-flip)
[308.790304] Starting subtest: basic-fence-flip
[309.648121] Subtest basic-fence-flip: SKIP (0.839s)
[309.919197] [137/161] (755s left) prime_vgem (basic-fence-mmap)
[310.223163] Starting subtest: basic-fence-mmap
[310.352350] Subtest basic-fence-mmap: SUCCESS (0.125s)
[310.618157] [138/161] (755s left) prime_vgem (basic-fence-read)
[310.902638] Starting subtest: basic-fence-read
[311.165646] Subtest basic-fence-read: SUCCESS (0.257s)
[311.418471] [139/161] (754s left) prime_vgem (basic-gtt)
[311.715120] Starting subtest: basic-gtt
[311.772458] Subtest basic-gtt: SUCCESS (0.046s)
[312.045834] [140/161] (754s left) prime_vgem (basic-read)
[312.339718] Starting subtest: basic-read
[312.461827] Subtest basic-read: SUCCESS (0.112s)
[312.718537] [141/161] (753s left) prime_vgem (basic-write)
[313.022771] Starting subtest: basic-write
[313.184305] Subtest basic-write: SUCCESS (0.159s)
[313.460269] [142/161] (753s left) vgem_basic (setversion)
[313.734864] Starting subtest: setversion
[313.738929] Subtest setversion: SUCCESS (0.000s)
[313.964877] [143/161] (752s left) vgem_basic (create)
[314.255288] Starting subtest: create
[314.256830] Subtest create: SUCCESS (0.001s)
[314.483910] [144/161] (752s left) vgem_basic (debugfs)
[314.750659] Starting subtest: debugfs
[314.752631] Subtest debugfs: SUCCESS (0.003s)
[314.990605] [145/161] (752s left) vgem_basic (dmabuf-export)
[315.269224] Starting subtest: dmabuf-export
[315.282962] Subtest dmabuf-export: SUCCESS (0.011s)
[315.546791] [146/161] (751s left) vgem_basic (dmabuf-fence)
[315.839571] Starting subtest: dmabuf-fence
[315.843587] Subtest dmabuf-fence: SUCCESS (0.002s)
[316.070900] [147/161] (751s left) vgem_basic (dmabuf-fence-before)
[316.356990] Starting subtest: dmabuf-fence-before
[316.360452] Subtest dmabuf-fence-before: SUCCESS (0.002s)
[316.592790] [148/161] (751s left) vgem_basic (dmabuf-mmap)
[316.869490] Starting subtest: dmabuf-mmap
[316.911212] Subtest dmabuf-mmap: SUCCESS (0.047s)
[317.158817] [149/161] (750s left) vgem_basic (mmap)
[317.438854] Starting subtest: mmap
[317.466463] Subtest mmap: SUCCESS (0.031s)
[317.705120] [150/161] (750s left) vgem_basic (second-client)
[317.978663] Starting subtest: second-client
[318.020696] Subtest second-client: SUCCESS (0.032s)
[318.259321] [151/161] (750s left) vgem_basic (sysfs)
[318.547500] Starting subtest: sysfs
[318.550763] Subtest sysfs: SUCCESS (0.003s)
[318.785845] [152/161] (749s left) core_hotunplug (unbind-rebind)
[319.247572] Starting subtest: unbind-rebind
[325.980396] Subtest unbind-rebind: SUCCESS (6.725s)
[326.270972] [153/161] (742s left) vgem_basic (unload)
[326.551108] Starting subtest: unload
[355.832153] Subtest unload: SUCCESS (29.270s)
[356.236335] [154/161] (712s left) i915_module_load (reload)
[356.493807] Starting subtest: reload
[363.815386] Subtest reload: SUCCESS (7.319s)
[364.318200] [155/161] (705s left) gem_lmem_swapping (basic)
[364.871160] Subtest basic: SKIP (0.000s)
[365.672139] [156/161] (704s left) gem_lmem_swapping (parallel-random-engines)
[366.049629] Subtest parallel-random-engines: SKIP (0.000s)
[366.256106] [157/161] (704s left) gem_lmem_swapping (random-engines)
[366.556096] Subtest random-engines: SKIP (0.000s)
[366.776375] [158/161] (703s left) gem_lmem_swapping (verify-random)
[367.055978] Subtest verify-random: SKIP (0.000s)
[367.259062] [159/161] (703s left) i915_pm_rpm (module-reload)
[369.940860] Starting subtest: module-reload
[388.138613] Subtest module-reload: SUCCESS (18.194s)
[388.270991] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[388.277059] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[388.294891] [160/161] (682s left) i915_selftest (live)
[388.586073] Starting subtest: live
[388.587704] Starting dynamic subtest: sanitycheck
[393.133453] Dynamic subtest sanitycheck: SUCCESS (4.550s)
[393.176950] Starting dynamic subtest: uncore
[397.539625] Dynamic subtest uncore: SUCCESS (4.379s)
[397.588781] Starting dynamic subtest: workarounds
[402.176582] Dynamic subtest workarounds: SUCCESS (4.622s)
[402.243932] Starting dynamic subtest: gt_engines
[407.079149] Dynamic subtest gt_engines: SUCCESS (4.895s)
[407.110141] Starting dynamic subtest: gt_timelines
[440.652607] Dynamic subtest gt_timelines: SUCCESS (33.568s)
[440.710308] Starting dynamic subtest: gt_contexts
[445.185164] Dynamic subtest gt_contexts: SUCCESS (4.504s)
[445.226542] Starting dynamic subtest: gt_lrc
[453.252471] Dynamic subtest gt_lrc: SUCCESS (8.061s)
[453.298981] Starting dynamic subtest: gt_mocs
[457.360707] Dynamic subtest gt_mocs: SUCCESS (4.090s)
[457.400862] Starting dynamic subtest: gt_pm
[463.059808] Dynamic subtest gt_pm: SUCCESS (5.688s)
[463.124261] Starting dynamic subtest: gt_heartbeat
[467.684613] Dynamic subtest gt_heartbeat: SUCCESS (4.614s)
[467.742149] Starting dynamic subtest: gt_tlb
[472.729510] Dynamic subtest gt_tlb: SUCCESS (5.035s)
[472.775252] Starting dynamic subtest: requests
[483.756873] Dynamic subtest requests: SUCCESS (11.020s)
[483.809190] Starting dynamic subtest: migrate
[492.383503] Dynamic subtest migrate: SUCCESS (8.620s)
[492.409489] Starting dynamic subtest: active
[496.928200] Dynamic subtest active: SUCCESS (4.530s)
[496.959890] Starting dynamic subtest: objects
[503.796901] Dynamic subtest objects: SUCCESS (6.868s)
[503.852320] Starting dynamic subtest: mman
[515.761769] Dynamic subtest mman: SUCCESS (11.931s)
[515.815822] Starting dynamic subtest: dmabuf
[520.414999] Dynamic subtest dmabuf: SUCCESS (4.642s)
[520.449510] Starting dynamic subtest: vma
[524.948504] Dynamic subtest vma: SUCCESS (4.524s)
[524.990851] Starting dynamic subtest: coherency
[536.482448] Dynamic subtest coherency: SUCCESS (11.530s)
[536.521687] Starting dynamic subtest: gtt
[548.425674] Dynamic subtest gtt: SUCCESS (11.934s)
[548.490736] Starting dynamic subtest: gem
[554.051237] Dynamic subtest gem: SUCCESS (5.604s)
[554.077672] Starting dynamic subtest: evict
[568.393767] Dynamic subtest evict: SUCCESS (14.338s)
[568.431999] Starting dynamic subtest: hugepages
[573.365643] Dynamic subtest hugepages: SUCCESS (4.960s)
[573.421286] Starting dynamic subtest: gem_contexts
[606.108471] Dynamic subtest gem_contexts: SUCCESS (32.730s)
[606.135713] Starting dynamic subtest: client
[610.765162] Dynamic subtest client: SUCCESS (4.637s)
[610.801977] Starting dynamic subtest: gem_migrate
[614.941331] Dynamic subtest gem_migrate: SUCCESS (4.172s)
[614.991334] Starting dynamic subtest: reset
[630.787946] Dynamic subtest reset: SUCCESS (15.827s)
[630.817876] Starting dynamic subtest: memory_region
[635.149488] Dynamic subtest memory_region: SUCCESS (4.354s)
[635.182847] Starting dynamic subtest: hangcheck
[663.252560] Dynamic subtest hangcheck: SUCCESS (28.093s)
[663.304900] Starting dynamic subtest: execlists
[674.322319] Dynamic subtest execlists: SUCCESS (11.060s)
[674.348976] Starting dynamic subtest: ring_submission
[678.740404] Dynamic subtest ring_submission: SUCCESS (4.415s)
[678.788309] Starting dynamic subtest: perf
[683.413151] Dynamic subtest perf: SUCCESS (4.659s)
[683.477802] Starting dynamic subtest: slpc
[687.880046] Dynamic subtest slpc: SUCCESS (4.462s)
[687.905570] Starting dynamic subtest: guc
[692.254524] Dynamic subtest guc: SUCCESS (4.365s)
[692.291998] Starting dynamic subtest: guc_multi_lrc
[697.206657] Dynamic subtest guc_multi_lrc: SUCCESS (4.942s)
[697.241384] Starting dynamic subtest: guc_hang
[701.506514] Dynamic subtest guc_hang: SUCCESS (4.290s)
[701.562219] Starting dynamic subtest: late_gt_pm
[706.021715] Dynamic subtest late_gt_pm: SUCCESS (4.503s)
[706.023863] Subtest live: SUCCESS (317.429s)
[706.190767] [161/161] (365s left) dmabuf (all-tests)
[706.475035] Starting subtest: all-tests
[706.490089] Starting dynamic subtest: sanitycheck
[706.555425] Dynamic subtest sanitycheck: SUCCESS (0.068s)
[706.617190] Starting dynamic subtest: dma_fence
[706.876674] Dynamic subtest dma_fence: SUCCESS (0.304s)
[706.908932] Starting dynamic subtest: dma_fence_chain
[730.539185] Dynamic subtest dma_fence_chain: SUCCESS (23.647s)
[730.572390] Starting dynamic subtest: dma_fence_unwrap
[730.621035] Dynamic subtest dma_fence_unwrap: SUCCESS (0.084s)
[730.662655] Starting dynamic subtest: dma_resv
[730.726367] Dynamic subtest dma_resv: SUCCESS (0.091s)
[730.727957] Subtest all-tests: SUCCESS (24.250s)
[730.858705] Closing watchdogs
Done.