[104.252803] Initializing watchdogs
[104.253666]   /dev/watchdog0
[104.381667] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:a001 Intel Pineview (Gen3) Atom Processor D4xx/D5xx/N4xx/N5xx Integrated Graphics Controller (DeskTop Board D510MO)
[104.425627] [001/161] (960s left) i915_module_load (load)
[106.020250] Starting subtest: load
[114.025543] Subtest load: SUCCESS (8.010s)
[114.581574] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[114.597626] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[114.628833] [002/161] (950s left) core_auth (basic-auth)
[115.513267] Starting subtest: basic-auth
[115.522454] Subtest basic-auth: SUCCESS (0.005s)
[115.892731] [003/161] (949s left) debugfs_test (read_all_entries)
[116.361876] Starting subtest: read_all_entries
[116.572232] Subtest read_all_entries: SUCCESS (0.210s)
[116.925482] [004/161] (949s left) debugfs_test (basic-hwmon)
[117.391894] Starting subtest: basic-hwmon
[117.400941] Subtest basic-hwmon: SKIP (0.000s)
[117.741467] [005/161] (948s left) debugfs_test (sysfs)
[118.228651] Starting subtest: sysfs
[118.385304] Subtest sysfs: SUCCESS (0.159s)
[118.763473] [006/161] (947s left) fbdev (eof)
[119.236482] Starting subtest: eof
[119.241619] Subtest eof: SUCCESS (0.005s)
[119.528587] [007/161] (947s left) fbdev (info)
[119.970923] Starting subtest: info
[119.975622] Subtest info: SUCCESS (0.000s)
[120.265502] [008/161] (946s left) fbdev (nullptr)
[120.714382] Starting subtest: nullptr
[120.719507] Subtest nullptr: SUCCESS (0.001s)
[121.013122] [009/161] (946s left) fbdev (read)
[121.448984] Starting subtest: read
[121.753101] Subtest read: SUCCESS (0.304s)
[122.048134] [010/161] (945s left) fbdev (write)
[122.487356] Starting subtest: write
[122.670743] Subtest write: SUCCESS (0.184s)
[122.971976] [011/161] (945s left) gem_basic (bad-close)
[123.421627] Starting subtest: bad-close
[123.429632] Subtest bad-close: SUCCESS (0.000s)
[123.718098] [012/161] (944s left) gem_basic (create-close)
[124.169689] Starting subtest: create-close
[124.178524] Subtest create-close: SUCCESS (0.001s)
[124.489209] [013/161] (944s left) gem_basic (create-fd-close)
[124.928766] Starting subtest: create-fd-close
[124.938297] Subtest create-fd-close: SUCCESS (0.002s)
[125.245558] [014/161] (943s left) gem_busy (busy@all-engines)
[125.779955] Starting subtest: busy
[125.784560] Starting dynamic subtest: all-engines
[125.911928] Dynamic subtest all-engines: SUCCESS (0.136s)
[125.916448] Subtest busy: SUCCESS (0.144s)
[126.640753] [015/161] (942s left) gem_close_race (basic-process)
[127.164455] Starting subtest: basic-process
[127.384266] Subtest basic-process: SUCCESS (0.222s)
[127.837722] [016/161] (941s left) gem_close_race (basic-threads)
[128.368490] Starting subtest: basic-threads
[130.052286] Subtest basic-threads: SUCCESS (1.684s)
[130.505830] [017/161] (939s left) gem_ctx_create (basic)
[130.968516] Subtest basic: SKIP (0.000s)
[131.251531] [018/161] (938s left) gem_ctx_create (basic-files)
[131.718495] Subtest basic-files: SKIP (0.000s)
[132.014200] [019/161] (938s left) gem_ctx_exec (basic)
[132.480378] Subtest basic: SKIP (0.000s)
[132.782364] [020/161] (937s left) gem_exec_basic (basic)
[133.292499] Starting subtest: basic
[133.297296] Starting dynamic subtest: rcs0-smem
[133.302321] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[133.305941] Subtest basic: SUCCESS (0.010s)
[133.758191] [021/161] (937s left) gem_exec_create (basic)
[134.293990] Starting subtest: basic
[134.298928] Starting dynamic subtest: smem
[136.456212] Dynamic subtest smem: SUCCESS (2.161s)
[136.459754] Subtest basic: SUCCESS (2.166s)
[136.918341] [022/161] (934s left) gem_exec_fence (basic-busy)
[137.740156] Starting subtest: basic-busy
[137.749891] Starting dynamic subtest: rcs0
[137.788927] Dynamic subtest rcs0: SUCCESS (0.057s)
[137.792557] Subtest basic-busy: SUCCESS (0.061s)
[139.083735] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[139.098619] [023/161] (932s left) gem_exec_fence (basic-wait)
[139.884271] Starting subtest: basic-wait
[139.889761] Starting dynamic subtest: rcs0
[139.914821] Dynamic subtest rcs0: SUCCESS (0.031s)
[139.918854] Subtest basic-wait: SUCCESS (0.036s)
[140.864604] [024/161] (930s left) gem_exec_fence (basic-await)
[141.617236] Starting subtest: basic-await
[141.622373] Starting dynamic subtest: rcs0
[141.771813] Dynamic subtest rcs0: SUCCESS (0.156s)
[141.776481] Subtest basic-await: SUCCESS (0.161s)
[142.737332] [025/161] (929s left) gem_exec_fence (nb-await)
[143.491853] Starting subtest: nb-await
[143.496574] Starting dynamic subtest: rcs0
[143.554278] Dynamic subtest rcs0: SUCCESS (0.064s)
[143.558290] Subtest nb-await: SUCCESS (0.067s)
[144.608539] [026/161] (927s left) gem_exec_gttfill (basic)
[145.121820] Starting subtest: basic
[154.962928] Subtest basic: SUCCESS (9.840s)
[155.494136] [027/161] (917s left) gem_exec_parallel (engines)
[156.246101] Starting subtest: engines
[156.250577] Starting dynamic subtest: basic
[160.367137] Dynamic subtest basic: SUCCESS (4.121s)
[160.417851] Starting dynamic subtest: contexts
[160.424784] Dynamic subtest contexts: SKIP (0.004s)
[160.470089] Starting dynamic subtest: fds
[160.476471] Dynamic subtest fds: SKIP (0.005s)
[160.517369] Starting dynamic subtest: userptr
[164.519617] Dynamic subtest userptr: SUCCESS (4.136s)
[164.523778] Subtest engines: SUCCESS (8.279s)
[165.008847] [028/161] (907s left) gem_exec_store (basic)
[165.532862] Starting subtest: basic
[165.576068] Subtest basic: SUCCESS (0.049s)
[166.064322] [029/161] (907s left) gem_flink_basic (bad-flink)
[166.508106] Starting subtest: bad-flink
[166.512451] Subtest bad-flink: SUCCESS (0.000s)
[166.855351] [030/161] (906s left) gem_flink_basic (bad-open)
[167.304491] Starting subtest: bad-open
[167.308860] Subtest bad-open: SUCCESS (0.000s)
[167.659532] [031/161] (906s left) gem_flink_basic (basic)
[168.102901] Starting subtest: basic
[168.106594] Subtest basic: SUCCESS (0.001s)
[168.457914] [032/161] (905s left) gem_flink_basic (double-flink)
[168.903995] Starting subtest: double-flink
[168.908872] Subtest double-flink: SUCCESS (0.001s)
[169.270999] [033/161] (905s left) gem_flink_basic (flink-lifetime)
[169.722749] Starting subtest: flink-lifetime
[169.728497] Subtest flink-lifetime: SUCCESS (0.010s)
[170.065437] [034/161] (904s left) gem_huc_copy (huc-copy)
[170.520320] Subtest huc-copy: SKIP (0.000s)
[170.844264] [035/161] (904s left) gem_linear_blits (basic)
[171.687307] Starting subtest: basic
[171.744803] Subtest basic: SUCCESS (0.060s)
[172.198642] [036/161] (903s left) gem_mmap (basic)
[172.958832] Starting subtest: basic
[172.983264] Subtest basic: SUCCESS (0.004s)
[173.345478] [037/161] (902s left) gem_mmap_gtt (basic)
[173.929902] Starting subtest: basic
[173.939705] Subtest basic: SUCCESS (0.007s)
[174.376568] [038/161] (901s left) gem_render_linear_blits (basic)
[174.845527] Starting subtest: basic
[174.990251] Subtest basic: SUCCESS (0.140s)
[175.314136] [039/161] (901s left) gem_render_tiled_blits (basic)
[175.773266] Starting subtest: basic
[175.930608] Subtest basic: SUCCESS (0.157s)
[176.263250] [040/161] (900s left) gem_ringfill (basic-all)
[176.829998] Starting subtest: basic-all
[178.058233] Subtest basic-all: SUCCESS (1.225s)
[178.411915] [041/161] (898s left) gem_softpin (allocator-basic)
[178.866091] Subtest allocator-basic: SKIP (0.000s)
[179.213901] [042/161] (898s left) gem_softpin (allocator-basic-reserve)
[179.681743] Subtest allocator-basic-reserve: SKIP (0.000s)
[180.031998] [043/161] (897s left) gem_softpin (safe-alignment)
[180.495346] Starting subtest: safe-alignment
[180.511123] Subtest safe-alignment: SUCCESS (0.022s)
[180.880345] [044/161] (897s left) gem_sync (basic-all)
[181.428477] Starting subtest: basic-all
[184.053471] Subtest basic-all: SUCCESS (2.625s)
[184.547941] [045/161] (893s left) gem_sync (basic-each)
[185.082610] Starting subtest: basic-each
[187.232726] Subtest basic-each: SUCCESS (2.154s)
[187.732123] [046/161] (890s left) gem_tiled_blits (basic)
[188.553762] Starting subtest: basic
[188.664316] Subtest basic: SUCCESS (0.108s)
[189.188665] [047/161] (889s left) gem_tiled_fence_blits (basic)
[190.268376] Starting subtest: basic
[190.339542] Subtest basic: SUCCESS (0.071s)
[190.777978] [048/161] (888s left) gem_tiled_pread_basic
[193.682891] [049/161] (886s left) gem_wait (busy@all-engines)
[194.266788] Starting subtest: busy
[194.271635] Starting dynamic subtest: all-engines
[194.814338] Dynamic subtest all-engines: SUCCESS (0.546s)
[194.818902] Subtest busy: SUCCESS (0.550s)
[195.458470] [050/161] (884s left) gem_wait (wait@all-engines)
[196.044875] Starting subtest: wait
[196.049800] Starting dynamic subtest: all-engines
[197.090506] Dynamic subtest all-engines: SUCCESS (1.049s)
[197.095904] Subtest wait: SUCCESS (1.053s)
[197.739542] [051/161] (882s left) i915_getparams_basic (basic-eu-total)
[198.184370] Starting subtest: basic-eu-total
[198.191411] Subtest basic-eu-total: SUCCESS (0.000s)
[198.542575] [052/161] (882s left) i915_getparams_basic (basic-subslice-total)
[198.995978] Starting subtest: basic-subslice-total
[199.003938] Subtest basic-subslice-total: SUCCESS (0.000s)
[199.340441] [053/161] (881s left) i915_hangman (error-state-basic)
[199.813850] Starting subtest: error-state-basic
[200.216951] Subtest error-state-basic: SUCCESS (0.392s)
[200.559678] [054/161] (880s left) i915_pciid
[201.356602] [055/161] (880s left) kms_addfb_basic (addfb25-4-tiled)
[201.880109] Starting subtest: addfb25-4-tiled
[201.884344] Subtest addfb25-4-tiled: SUCCESS (0.002s)
[202.241162] [056/161] (879s left) kms_addfb_basic (addfb25-bad-modifier)
[202.745284] Starting subtest: addfb25-bad-modifier
[202.750913] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[203.105644] [057/161] (879s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[203.614616] Starting subtest: addfb25-framebuffer-vs-set-tiling
[203.619325] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.001s)
[204.091587] [058/161] (878s left) kms_addfb_basic (addfb25-modifier-no-flag)
[204.597353] Starting subtest: addfb25-modifier-no-flag
[204.601874] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[204.975234] [059/161] (877s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[205.480510] Starting subtest: addfb25-x-tiled-legacy
[205.484972] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[205.852683] [060/161] (877s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[206.357735] Starting subtest: addfb25-x-tiled-mismatch-legacy
[206.361300] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[206.733963] [061/161] (876s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[207.253846] Starting subtest: addfb25-yf-tiled-legacy
[207.258692] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[207.609177] [062/161] (876s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[208.109105] Starting subtest: addfb25-y-tiled-legacy
[208.113228] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s)
[208.484772] [063/161] (875s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[208.984741] Starting subtest: addfb25-y-tiled-small-legacy
[208.991770] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[209.377802] [064/161] (875s left) kms_addfb_basic (bad-pitch-0)
[209.819274] Starting subtest: bad-pitch-0
[209.823555] Subtest bad-pitch-0: SUCCESS (0.000s)
[210.243422] [065/161] (874s left) kms_addfb_basic (bad-pitch-1024)
[210.689773] Starting subtest: bad-pitch-1024
[210.694939] Subtest bad-pitch-1024: SUCCESS (0.000s)
[211.117356] [066/161] (874s left) kms_addfb_basic (bad-pitch-128)
[211.571722] Starting subtest: bad-pitch-128
[211.576911] Subtest bad-pitch-128: SUCCESS (0.000s)
[211.975890] [067/161] (873s left) kms_addfb_basic (bad-pitch-256)
[212.432280] Starting subtest: bad-pitch-256
[212.437048] Subtest bad-pitch-256: SUCCESS (0.000s)
[212.866861] [068/161] (872s left) kms_addfb_basic (bad-pitch-32)
[213.320850] Starting subtest: bad-pitch-32
[213.325783] Subtest bad-pitch-32: SUCCESS (0.000s)
[213.738384] [069/161] (872s left) kms_addfb_basic (bad-pitch-63)
[214.186663] Starting subtest: bad-pitch-63
[214.190487] Subtest bad-pitch-63: SUCCESS (0.000s)
[214.617315] [070/161] (871s left) kms_addfb_basic (bad-pitch-65536)
[215.060551] Starting subtest: bad-pitch-65536
[215.065596] Subtest bad-pitch-65536: SUCCESS (0.002s)
[215.486145] [071/161] (871s left) kms_addfb_basic (bad-pitch-999)
[215.943417] Starting subtest: bad-pitch-999
[215.948113] Subtest bad-pitch-999: SUCCESS (0.000s)
[216.353481] [072/161] (870s left) kms_addfb_basic (basic)
[216.802971] Starting subtest: basic
[216.806505] Subtest basic: SUCCESS (0.001s)
[217.226188] [073/161] (870s left) kms_addfb_basic (basic-x-tiled-legacy)
[217.672813] Starting subtest: basic-x-tiled-legacy
[217.677665] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[218.107626] [074/161] (869s left) kms_addfb_basic (basic-y-tiled-legacy)
[218.552835] Starting subtest: basic-y-tiled-legacy
[218.556510] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[219.089275] [075/161] (869s left) kms_addfb_basic (bo-too-small)
[219.603841] Starting subtest: bo-too-small
[219.608609] Subtest bo-too-small: SUCCESS (0.002s)
[219.977545] [076/161] (868s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[220.479717] Starting subtest: bo-too-small-due-to-tiling
[220.484956] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[220.852124] [077/161] (867s left) kms_addfb_basic (clobberred-modifier)
[221.298588] Starting subtest: clobberred-modifier
[221.303580] Subtest clobberred-modifier: SUCCESS (0.000s)
[221.719926] [078/161] (867s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[222.168835] Starting subtest: framebuffer-vs-set-tiling
[222.173063] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[222.582158] [079/161] (866s left) kms_addfb_basic (invalid-get-prop)
[223.029739] Starting subtest: invalid-get-prop
[223.034478] Subtest invalid-get-prop: SUCCESS (0.000s)
[223.438447] [080/161] (866s left) kms_addfb_basic (invalid-get-prop-any)
[223.887891] Starting subtest: invalid-get-prop-any
[223.892382] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[224.317157] [081/161] (865s left) kms_addfb_basic (invalid-set-prop)
[224.762189] Starting subtest: invalid-set-prop
[224.766471] Subtest invalid-set-prop: SUCCESS (0.000s)
[225.193847] [082/161] (865s left) kms_addfb_basic (invalid-set-prop-any)
[225.640533] Starting subtest: invalid-set-prop-any
[225.645432] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[226.076471] [083/161] (864s left) kms_addfb_basic (no-handle)
[226.525095] Starting subtest: no-handle
[226.529747] Subtest no-handle: SUCCESS (0.000s)
[226.937322] [084/161] (864s left) kms_addfb_basic (size-max)
[227.426849] Starting subtest: size-max
[227.431474] Subtest size-max: SUCCESS (0.001s)
[227.787170] [085/161] (863s left) kms_addfb_basic (small-bo)
[228.279521] Starting subtest: small-bo
[228.284620] Subtest small-bo: SUCCESS (0.000s)
[228.635696] [086/161] (863s left) kms_addfb_basic (tile-pitch-mismatch)
[229.086752] Starting subtest: tile-pitch-mismatch
[229.092214] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[229.509177] [087/161] (862s left) kms_addfb_basic (too-high)
[229.998882] Starting subtest: too-high
[230.003958] Subtest too-high: SUCCESS (0.005s)
[230.376538] [088/161] (861s left) kms_addfb_basic (too-wide)
[230.886513] Starting subtest: too-wide
[230.891569] Subtest too-wide: SUCCESS (0.000s)
[231.237231] [089/161] (861s left) kms_addfb_basic (unused-handle)
[231.686900] Starting subtest: unused-handle
[231.692617] Subtest unused-handle: SUCCESS (0.000s)
[232.131913] [090/161] (860s left) kms_addfb_basic (unused-modifier)
[232.583985] Starting subtest: unused-modifier
[232.588583] Subtest unused-modifier: SUCCESS (0.000s)
[232.993160] [091/161] (860s left) kms_addfb_basic (unused-offsets)
[233.437521] Starting subtest: unused-offsets
[233.441829] Subtest unused-offsets: SUCCESS (0.000s)
[233.944610] [092/161] (859s left) kms_addfb_basic (unused-pitches)
[234.407515] Starting subtest: unused-pitches
[234.412177] Subtest unused-pitches: SUCCESS (0.001s)
[234.825364] [093/161] (859s left) kms_busy (basic)
[235.330590] Starting subtest: basic
[235.335565] Starting dynamic subtest: flip
[236.389354] Dynamic subtest flip: SUCCESS (1.051s)
[236.442501] Starting dynamic subtest: modeset
[236.451086] Dynamic subtest modeset: SKIP (0.000s)
[236.454937] Subtest basic: SUCCESS (1.062s)
[236.915307] [094/161] (857s left) kms_prop_blob (basic)
[237.373591] Starting subtest: basic
[237.378450] Subtest basic: SUCCESS (0.000s)
[237.727871] [095/161] (856s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[238.245265] Starting subtest: basic-busy-flip-before-cursor-atomic
[238.271559] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.022s)
[238.641116] [096/161] (856s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[239.144618] Starting subtest: basic-busy-flip-before-cursor-legacy
[240.245062] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.104s)
[240.760290] [097/161] (854s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[241.273603] Starting subtest: basic-flip-after-cursor-atomic
[241.281798] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[241.623881] [098/161] (854s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[242.126456] Starting subtest: basic-flip-after-cursor-legacy
[243.206227] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.082s)
[243.727789] [099/161] (852s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[244.223720] Starting subtest: basic-flip-after-cursor-varying-size
[245.310597] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.085s)
[245.807711] [100/161] (850s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[246.308615] Starting subtest: basic-flip-before-cursor-atomic
[246.315300] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[246.683921] [101/161] (849s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[247.173940] Starting subtest: basic-flip-before-cursor-legacy
[248.275130] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.099s)
[248.853920] [102/161] (848s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[249.354466] Starting subtest: basic-flip-before-cursor-varying-size
[250.457523] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.101s)
[250.979397] [103/161] (846s left) kms_dsc (dsc-basic)
[251.472834] Subtest dsc-basic: SKIP (0.000s)
[251.809262] [104/161] (845s left) kms_flip (basic-flip-vs-dpms)
[252.315656] Starting subtest: basic-flip-vs-dpms
[252.320685] Starting dynamic subtest: A-VGA1
[253.984328] Dynamic subtest A-VGA1: SUCCESS (1.669s)
[254.033377] Starting dynamic subtest: B-VGA1
[255.555558] Dynamic subtest B-VGA1: SUCCESS (1.565s)
[255.559934] Subtest basic-flip-vs-dpms: SUCCESS (3.248s)
[256.228915] [105/161] (841s left) kms_flip (basic-flip-vs-modeset)
[256.724098] Starting subtest: basic-flip-vs-modeset
[256.728934] Starting dynamic subtest: A-VGA1
[258.364824] Dynamic subtest A-VGA1: SUCCESS (1.634s)
[258.419489] Starting dynamic subtest: B-VGA1
[259.871070] Dynamic subtest B-VGA1: SUCCESS (1.501s)
[259.874966] Subtest basic-flip-vs-modeset: SUCCESS (3.147s)
[260.513556] [106/161] (837s left) kms_flip (basic-flip-vs-wf_vblank)
[261.010415] Starting subtest: basic-flip-vs-wf_vblank
[261.015431] Starting dynamic subtest: A-VGA1
[262.836237] Dynamic subtest A-VGA1: SUCCESS (1.823s)
[262.890332] Starting dynamic subtest: B-VGA1
[264.566452] Dynamic subtest B-VGA1: SUCCESS (1.722s)
[264.570688] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.556s)
[265.256649] [107/161] (833s left) kms_flip (basic-plain-flip)
[265.759959] Starting subtest: basic-plain-flip
[265.765309] Starting dynamic subtest: A-VGA1
[267.312874] Dynamic subtest A-VGA1: SUCCESS (1.543s)
[267.365330] Starting dynamic subtest: B-VGA1
[268.752225] Dynamic subtest B-VGA1: SUCCESS (1.432s)
[268.756724] Subtest basic-plain-flip: SUCCESS (2.986s)
[269.457131] [108/161] (829s left) kms_force_connector_basic (force-connector-state)
[270.014704] Starting subtest: force-connector-state
[270.320987] Subtest force-connector-state: SUCCESS (0.310s)
[270.996502] [109/161] (828s left) kms_force_connector_basic (force-edid)
[271.532499] Starting subtest: force-edid
[271.644254] Subtest force-edid: SUCCESS (0.117s)
[272.106239] [110/161] (827s left) kms_force_connector_basic (force-load-detect)
[272.616530] Starting subtest: force-load-detect
[273.096209] Subtest force-load-detect: SUCCESS (0.486s)
[273.696536] [111/161] (826s left) kms_force_connector_basic (prune-stale-modes)
[274.249510] Starting subtest: prune-stale-modes
[274.350415] Subtest prune-stale-modes: SUCCESS (0.097s)
[274.793335] [112/161] (825s left) kms_frontbuffer_tracking (basic)
[275.295830] Subtest basic: SKIP (0.000s)
[275.621164] [113/161] (824s left) kms_hdmi_inject (inject-audio)
[276.067995] Subtest inject-audio: SKIP (0.000s)
[276.413984] [114/161] (824s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[276.908231] Starting subtest: compare-crc-sanitycheck-xr24
[276.913074] Starting dynamic subtest: pipe-A-VGA-1
[277.299675] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.388s)
[277.363140] Starting dynamic subtest: pipe-B-VGA-1
[277.818195] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.511s)
[277.822785] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.916s)
[278.351213] [115/161] (822s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[278.888465] Starting subtest: compare-crc-sanitycheck-nv12
[278.894235] Starting dynamic subtest: pipe-A-VGA-1
[278.901382] Dynamic subtest pipe-A-VGA-1: SKIP (0.002s)
[278.945839] Starting dynamic subtest: pipe-B-VGA-1
[278.952254] Dynamic subtest pipe-B-VGA-1: SKIP (0.002s)
[278.958675] Subtest compare-crc-sanitycheck-nv12: SKIP (0.022s)
[279.282327] [116/161] (822s left) kms_pipe_crc_basic (hang-read-crc)
[279.787849] Starting subtest: hang-read-crc
[279.792811] Starting dynamic subtest: pipe-A-VGA-1
[281.115350] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.327s)
[281.164114] Starting dynamic subtest: pipe-B-VGA-1
[282.533828] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.406s)
[282.538780] Subtest hang-read-crc: SUCCESS (2.750s)
[283.034226] [117/161] (818s left) kms_pipe_crc_basic (nonblocking-crc)
[283.538646] Starting subtest: nonblocking-crc
[283.543588] Starting dynamic subtest: pipe-A-VGA-1
[284.119171] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.578s)
[284.188320] Starting dynamic subtest: pipe-B-VGA-1
[284.837980] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.711s)
[284.843651] Subtest nonblocking-crc: SUCCESS (1.305s)
[285.338989] [118/161] (816s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[285.847544] Starting subtest: nonblocking-crc-frame-sequence
[285.852312] Starting dynamic subtest: pipe-A-VGA-1
[286.442595] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.592s)
[286.503694] Starting dynamic subtest: pipe-B-VGA-1
[287.152670] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.699s)
[287.157754] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.307s)
[287.647276] [119/161] (814s left) kms_pipe_crc_basic (read-crc)
[288.160366] Starting subtest: read-crc
[288.165411] Starting dynamic subtest: pipe-A-VGA-1
[288.684062] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.523s)
[288.753111] Starting dynamic subtest: pipe-B-VGA-1
[289.335850] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.639s)
[289.341150] Subtest read-crc: SUCCESS (1.179s)
[289.834267] [120/161] (813s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[290.322814] Starting subtest: read-crc-frame-sequence
[290.334807] Starting dynamic subtest: pipe-A-VGA-1
[290.846578] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.513s)
[290.909658] Starting dynamic subtest: pipe-B-VGA-1
[291.496783] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.648s)
[291.500577] Subtest read-crc-frame-sequence: SUCCESS (1.177s)
[292.016494] [121/161] (811s left) kms_pm_backlight (basic-brightness)
[292.509144] Subtest basic-brightness: SKIP (0.000s)
[292.874666] [122/161] (810s left) kms_pm_rpm (basic-pci-d3-state)
[304.806261] Subtest basic-pci-d3-state: SKIP (0.000s)
[305.133468] [123/161] (798s left) kms_pm_rpm (basic-rte)
[305.567531] Starting subtest: basic-rte
[317.035861] Subtest basic-rte: SKIP (11.460s)
[317.361804] [124/161] (786s left) kms_psr (psr-primary-page-flip)
[317.858873] Subtest psr-primary-page-flip: SKIP (0.000s)
[318.190556] [125/161] (786s left) kms_psr (psr-cursor-plane-move)
[318.694279] Subtest psr-cursor-plane-move: SKIP (0.000s)
[319.044995] [126/161] (785s left) kms_psr (psr-sprite-plane-onoff)
[319.549141] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[319.868768] [127/161] (785s left) kms_psr (psr-primary-mmap-gtt)
[320.364084] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[320.701639] [128/161] (784s left) kms_setmode (basic-clone-single-crtc)
[321.158368] Starting subtest: basic-clone-single-crtc
[321.171150] Subtest basic-clone-single-crtc: SKIP (0.001s)
[321.506460] [129/161] (784s left) i915_pm_rps (basic-api)
[321.966262] Subtest basic-api: SKIP (0.000s)
[322.301180] [130/161] (783s left) prime_self_import (basic-llseek-bad)
[322.740333] Starting subtest: basic-llseek-bad
[322.750576] Subtest basic-llseek-bad: SUCCESS (0.013s)
[323.105630] [131/161] (783s left) prime_self_import (basic-llseek-size)
[323.540331] Starting subtest: basic-llseek-size
[323.560968] Subtest basic-llseek-size: SUCCESS (0.025s)
[324.003431] [132/161] (782s left) prime_self_import (basic-with_fd_dup)
[324.437532] Starting subtest: basic-with_fd_dup
[324.458665] Subtest basic-with_fd_dup: SUCCESS (0.023s)
[324.803723] [133/161] (782s left) prime_self_import (basic-with_one_bo)
[325.242844] Starting subtest: basic-with_one_bo
[325.259388] Subtest basic-with_one_bo: SUCCESS (0.020s)
[325.600130] [134/161] (781s left) prime_self_import (basic-with_one_bo_two_files)
[326.033846] Starting subtest: basic-with_one_bo_two_files
[326.052629] Subtest basic-with_one_bo_two_files: SUCCESS (0.016s)
[326.439753] [135/161] (781s left) prime_self_import (basic-with_two_bos)
[326.873682] Starting subtest: basic-with_two_bos
[326.890351] Subtest basic-with_two_bos: SUCCESS (0.019s)
[327.251717] [136/161] (780s left) prime_vgem (basic-fence-flip)
[327.749234] Starting subtest: basic-fence-flip
[328.412680] Subtest basic-fence-flip: SUCCESS (0.666s)
[328.792879] [137/161] (779s left) prime_vgem (basic-fence-mmap)
[329.273146] Starting subtest: basic-fence-mmap
[329.476107] Subtest basic-fence-mmap: SUCCESS (0.202s)
[329.847594] [138/161] (778s left) prime_vgem (basic-fence-read)
[330.328682] Starting subtest: basic-fence-read
[330.584417] Subtest basic-fence-read: SUCCESS (0.261s)
[330.947982] [139/161] (778s left) prime_vgem (basic-gtt)
[331.431883] Starting subtest: basic-gtt
[331.515290] Subtest basic-gtt: SUCCESS (0.087s)
[331.882779] [140/161] (777s left) prime_vgem (basic-read)
[332.366463] Starting subtest: basic-read
[332.491875] Subtest basic-read: SUCCESS (0.125s)
[332.886827] [141/161] (776s left) prime_vgem (basic-write)
[333.377504] Starting subtest: basic-write
[333.510240] Subtest basic-write: SUCCESS (0.132s)
[333.881617] [142/161] (776s left) vgem_basic (setversion)
[334.339535] Starting subtest: setversion
[334.348261] Subtest setversion: SUCCESS (0.000s)
[334.685700] [143/161] (775s left) vgem_basic (create)
[335.134463] Starting subtest: create
[335.137833] Subtest create: SUCCESS (0.003s)
[335.477649] [144/161] (775s left) vgem_basic (debugfs)
[335.925266] Starting subtest: debugfs
[335.929856] Subtest debugfs: SUCCESS (0.004s)
[336.262750] [145/161] (774s left) vgem_basic (dmabuf-export)
[336.708107] Starting subtest: dmabuf-export
[336.721137] Subtest dmabuf-export: SUCCESS (0.018s)
[337.083666] [146/161] (774s left) vgem_basic (dmabuf-fence)
[337.543774] Starting subtest: dmabuf-fence
[337.548566] Subtest dmabuf-fence: SUCCESS (0.005s)
[337.877660] [147/161] (773s left) vgem_basic (dmabuf-fence-before)
[338.327229] Starting subtest: dmabuf-fence-before
[338.332557] Subtest dmabuf-fence-before: SUCCESS (0.005s)
[338.684189] [148/161] (773s left) vgem_basic (dmabuf-mmap)
[339.211471] Starting subtest: dmabuf-mmap
[339.287126] Subtest dmabuf-mmap: SUCCESS (0.084s)
[339.630864] [149/161] (772s left) vgem_basic (mmap)
[340.075490] Starting subtest: mmap
[340.128645] Subtest mmap: SUCCESS (0.058s)
[340.467788] [150/161] (772s left) vgem_basic (second-client)
[340.909404] Starting subtest: second-client
[340.944760] Subtest second-client: SUCCESS (0.031s)
[341.284686] [151/161] (771s left) vgem_basic (sysfs)
[341.740938] Starting subtest: sysfs
[341.745999] Subtest sysfs: SUCCESS (0.006s)
[342.085900] [152/161] (771s left) core_hotunplug (unbind-rebind)
[342.839877] Starting subtest: unbind-rebind
[349.004827] Subtest unbind-rebind: SUCCESS (6.160s)
[349.326621] [153/161] (764s left) vgem_basic (unload)
[349.772408] Starting subtest: unload
[379.407399] Subtest unload: SUCCESS (29.625s)
[379.969443] [154/161] (733s left) i915_module_load (reload)
[380.398159] Starting subtest: reload
[390.435675] Subtest reload: SUCCESS (10.031s)
[391.250976] [155/161] (723s left) gem_lmem_swapping (basic)
[392.048627] Subtest basic: SKIP (0.000s)
[392.364661] [156/161] (722s left) gem_lmem_swapping (parallel-random-engines)
[392.841072] Subtest parallel-random-engines: SKIP (0.000s)
[393.173251] [157/161] (722s left) gem_lmem_swapping (random-engines)
[393.627303] Subtest random-engines: SKIP (0.000s)
[393.943542] [158/161] (721s left) gem_lmem_swapping (verify-random)
[394.401428] Subtest verify-random: SKIP (0.000s)
[394.719587] [159/161] (721s left) i915_pm_rpm (module-reload)
[406.623985] Subtest module-reload: SKIP (0.000s)
[406.940518] [160/161] (709s left) i915_selftest (live)
[409.810178] Starting subtest: live
[409.814367] Starting dynamic subtest: sanitycheck
[417.221993] Dynamic subtest sanitycheck: SUCCESS (7.410s)
[417.279298] Starting dynamic subtest: uncore
[424.603086] Dynamic subtest uncore: SUCCESS (7.376s)
[424.648671] Starting dynamic subtest: workarounds
[431.886230] Dynamic subtest workarounds: SUCCESS (7.276s)
[431.935772] Starting dynamic subtest: gt_engines
[439.127757] Dynamic subtest gt_engines: SUCCESS (7.234s)
[439.213473] Starting dynamic subtest: gt_timelines
[452.509513] Dynamic subtest gt_timelines: SUCCESS (13.378s)
[452.556820] Starting dynamic subtest: gt_contexts
[459.842435] Dynamic subtest gt_contexts: SUCCESS (7.323s)
[459.925138] Starting dynamic subtest: gt_lrc
[467.100438] Dynamic subtest gt_lrc: SUCCESS (7.255s)
[467.158939] Starting dynamic subtest: gt_mocs
[474.516391] Dynamic subtest gt_mocs: SUCCESS (7.408s)
[474.600371] Starting dynamic subtest: gt_pm
[482.267392] Dynamic subtest gt_pm: SUCCESS (7.746s)
[482.346876] Starting dynamic subtest: gt_heartbeat
[489.744358] Dynamic subtest gt_heartbeat: SUCCESS (7.470s)
[489.854602] Starting dynamic subtest: gt_tlb
[497.057124] Dynamic subtest gt_tlb: SUCCESS (7.305s)
[497.097471] Starting dynamic subtest: requests
[507.076367] Dynamic subtest requests: SUCCESS (10.014s)
[507.122162] Starting dynamic subtest: migrate
[514.301737] Dynamic subtest migrate: SUCCESS (7.220s)
[514.388090] Starting dynamic subtest: active
[521.764325] Dynamic subtest active: SUCCESS (7.456s)
[521.806092] Starting dynamic subtest: objects
[529.812919] Dynamic subtest objects: SUCCESS (8.044s)
[529.858388] Starting dynamic subtest: mman
[544.533758] Dynamic subtest mman: SUCCESS (14.713s)
[544.573829] Starting dynamic subtest: dmabuf
[552.075562] Dynamic subtest dmabuf: SUCCESS (7.538s)
[552.124525] Starting dynamic subtest: vma
[559.339661] Dynamic subtest vma: SUCCESS (7.257s)
[559.421528] Starting dynamic subtest: coherency
[572.098242] Dynamic subtest coherency: SUCCESS (12.753s)
[572.150675] Starting dynamic subtest: gtt
[582.268887] Dynamic subtest gtt: SUCCESS (10.165s)
[582.314051] Starting dynamic subtest: gem
[589.833869] Dynamic subtest gem: SUCCESS (7.559s)
[589.881099] Starting dynamic subtest: evict
[597.219559] Dynamic subtest evict: SUCCESS (7.379s)
[597.267344] Starting dynamic subtest: hugepages
[604.617539] Dynamic subtest hugepages: SUCCESS (7.392s)
[604.686476] Starting dynamic subtest: gem_contexts
[612.067853] Dynamic subtest gem_contexts: SUCCESS (7.443s)
[612.154646] Starting dynamic subtest: client
[619.426284] Dynamic subtest client: SUCCESS (7.349s)
[619.469688] Starting dynamic subtest: gem_migrate
[626.733461] Dynamic subtest gem_migrate: SUCCESS (7.301s)
[626.783975] Starting dynamic subtest: reset
[636.089468] Dynamic subtest reset: SUCCESS (9.346s)
[636.148873] Starting dynamic subtest: memory_region
[643.464205] Dynamic subtest memory_region: SUCCESS (7.370s)
[643.510942] Starting dynamic subtest: hangcheck
[651.801141] Dynamic subtest hangcheck: SUCCESS (8.329s)
[651.869460] Starting dynamic subtest: execlists
[659.221444] Dynamic subtest execlists: SUCCESS (7.415s)
[659.280813] Starting dynamic subtest: ring_submission
[666.575673] Dynamic subtest ring_submission: SUCCESS (7.346s)
[666.623086] Starting dynamic subtest: perf
[673.837102] Dynamic subtest perf: SUCCESS (7.252s)
[673.935187] Starting dynamic subtest: slpc
[681.113659] Dynamic subtest slpc: SUCCESS (7.269s)
[681.197652] Starting dynamic subtest: guc
[688.356518] Dynamic subtest guc: SUCCESS (7.237s)
[688.444255] Starting dynamic subtest: guc_multi_lrc
[696.499468] Dynamic subtest guc_multi_lrc: SUCCESS (8.130s)
[696.548801] Starting dynamic subtest: guc_hang
[704.111436] Dynamic subtest guc_hang: SUCCESS (7.608s)
[704.176269] Starting dynamic subtest: late_gt_pm
[711.411860] Dynamic subtest late_gt_pm: SUCCESS (7.293s)
[711.424895] Subtest live: SUCCESS (301.599s)
[711.673343] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[711.683209] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[711.695742] [161/161] (404s left) dmabuf (all-tests)
[712.157754] Starting subtest: all-tests
[712.161652] Starting dynamic subtest: sanitycheck
[712.298440] Dynamic subtest sanitycheck: SUCCESS (0.136s)
[712.360653] Starting dynamic subtest: dma_fence
[712.615250] Dynamic subtest dma_fence: SUCCESS (0.308s)
[712.669962] Starting dynamic subtest: dma_fence_chain