[101.821242] Initializing watchdogs
[101.821911]   /dev/watchdog0
[101.950913] [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)
[101.993549] [001/161] (960s left) i915_module_load (load)
[103.601760] Starting subtest: load
[111.846375] Subtest load: SUCCESS (8.246s)
[112.370203] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[112.385142] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[112.419790] [002/161] (950s left) core_auth (basic-auth)
[113.177284] Starting subtest: basic-auth
[113.183552] Subtest basic-auth: SUCCESS (0.005s)
[113.535736] [003/161] (949s left) debugfs_test (read_all_entries)
[114.017799] Starting subtest: read_all_entries
[114.271183] Subtest read_all_entries: SUCCESS (0.252s)
[114.628300] [004/161] (949s left) debugfs_test (basic-hwmon)
[115.118420] Starting subtest: basic-hwmon
[115.125803] Subtest basic-hwmon: SKIP (0.000s)
[115.485769] [005/161] (948s left) debugfs_test (sysfs)
[115.954632] Starting subtest: sysfs
[116.097894] Subtest sysfs: SUCCESS (0.139s)
[116.477161] [006/161] (947s left) fbdev (eof)
[116.975089] Starting subtest: eof
[116.978621] Subtest eof: SUCCESS (0.004s)
[117.263776] [007/161] (947s left) fbdev (info)
[117.707735] Starting subtest: info
[117.713502] Subtest info: SUCCESS (0.000s)
[117.996158] [008/161] (946s left) fbdev (nullptr)
[118.450708] Starting subtest: nullptr
[118.455177] Subtest nullptr: SUCCESS (0.001s)
[118.745349] [009/161] (946s left) fbdev (read)
[119.199741] Starting subtest: read
[119.501859] Subtest read: SUCCESS (0.304s)
[119.857180] [010/161] (945s left) fbdev (write)
[120.312636] Starting subtest: write
[120.496887] Subtest write: SUCCESS (0.185s)
[120.804581] [011/161] (944s left) gem_basic (bad-close)
[121.253855] Starting subtest: bad-close
[121.264098] Subtest bad-close: SUCCESS (0.000s)
[121.565476] [012/161] (944s left) gem_basic (create-close)
[122.028696] Starting subtest: create-close
[122.039174] Subtest create-close: SUCCESS (0.001s)
[122.348937] [013/161] (943s left) gem_basic (create-fd-close)
[122.798529] Starting subtest: create-fd-close
[122.809438] Subtest create-fd-close: SUCCESS (0.002s)
[123.114296] [014/161] (943s left) gem_busy (busy@all-engines)
[123.655375] Starting subtest: busy
[123.659700] Starting dynamic subtest: all-engines
[123.791667] Dynamic subtest all-engines: SUCCESS (0.139s)
[123.795630] Subtest busy: SUCCESS (0.143s)
[124.503152] [015/161] (942s left) gem_close_race (basic-process)
[125.039704] Starting subtest: basic-process
[125.249750] Subtest basic-process: SUCCESS (0.211s)
[125.706688] [016/161] (941s left) gem_close_race (basic-threads)
[126.238551] Starting subtest: basic-threads
[127.786642] Subtest basic-threads: SUCCESS (1.548s)
[128.242113] [017/161] (939s left) gem_ctx_create (basic)
[128.704083] Subtest basic: SKIP (0.000s)
[129.021494] [018/161] (938s left) gem_ctx_create (basic-files)
[129.510472] Subtest basic-files: SKIP (0.000s)
[129.794360] [019/161] (938s left) gem_ctx_exec (basic)
[130.262947] Subtest basic: SKIP (0.000s)
[130.561726] [020/161] (937s left) gem_exec_basic (basic)
[131.074812] Starting subtest: basic
[131.080209] Starting dynamic subtest: rcs0-smem
[131.083732] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[131.086978] Subtest basic: SUCCESS (0.007s)
[131.535529] [021/161] (936s left) gem_exec_create (basic)
[132.061704] Starting subtest: basic
[132.068777] Starting dynamic subtest: smem
[134.223197] Dynamic subtest smem: SUCCESS (2.164s)
[134.226587] Subtest basic: SUCCESS (2.167s)
[134.700555] [022/161] (934s left) gem_exec_fence (basic-busy)
[135.526873] Starting subtest: basic-busy
[135.531723] Starting dynamic subtest: rcs0
[135.565890] Dynamic subtest rcs0: SUCCESS (0.040s)
[135.570949] Subtest basic-busy: SUCCESS (0.044s)
[136.767372] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[136.780517] [023/161] (932s left) gem_exec_fence (basic-wait)
[137.563883] Starting subtest: basic-wait
[137.569710] Starting dynamic subtest: rcs0
[137.601345] Dynamic subtest rcs0: SUCCESS (0.035s)
[137.605218] Subtest basic-wait: SUCCESS (0.041s)
[138.562735] [024/161] (930s left) gem_exec_fence (basic-await)
[139.308429] Starting subtest: basic-await
[139.313438] Starting dynamic subtest: rcs0
[139.469322] Dynamic subtest rcs0: SUCCESS (0.157s)
[139.474363] Subtest basic-await: SUCCESS (0.162s)
[140.413984] [025/161] (929s left) gem_exec_fence (nb-await)
[141.153518] Starting subtest: nb-await
[141.157821] Starting dynamic subtest: rcs0
[141.220256] Dynamic subtest rcs0: SUCCESS (0.069s)
[141.224562] Subtest nb-await: SUCCESS (0.073s)
[142.212538] [026/161] (927s left) gem_exec_gttfill (basic)
[142.796516] Starting subtest: basic
[154.038858] Subtest basic: SUCCESS (11.250s)
[154.576676] [027/161] (915s left) gem_exec_parallel (engines)
[155.325414] Starting subtest: engines
[155.329467] Starting dynamic subtest: basic
[159.675421] Dynamic subtest basic: SUCCESS (4.350s)
[159.728172] Starting dynamic subtest: contexts
[159.736603] Dynamic subtest contexts: SKIP (0.005s)
[159.791953] Starting dynamic subtest: fds
[159.798932] Dynamic subtest fds: SKIP (0.004s)
[159.838559] Starting dynamic subtest: userptr
[163.906493] Dynamic subtest userptr: SUCCESS (4.211s)
[163.909910] Subtest engines: SUCCESS (8.583s)
[164.398404] [028/161] (906s left) gem_exec_store (basic)
[164.993639] Starting subtest: basic
[165.046640] Subtest basic: SUCCESS (0.053s)
[165.530461] [029/161] (905s left) gem_flink_basic (bad-flink)
[165.975975] Starting subtest: bad-flink
[165.980215] Subtest bad-flink: SUCCESS (0.000s)
[166.316228] [030/161] (904s left) gem_flink_basic (bad-open)
[166.765330] Starting subtest: bad-open
[166.769226] Subtest bad-open: SUCCESS (0.000s)
[167.117908] [031/161] (904s left) gem_flink_basic (basic)
[167.558922] Starting subtest: basic
[167.562722] Subtest basic: SUCCESS (0.001s)
[167.915308] [032/161] (903s left) gem_flink_basic (double-flink)
[168.364651] Starting subtest: double-flink
[168.368281] Subtest double-flink: SUCCESS (0.001s)
[168.751385] [033/161] (903s left) gem_flink_basic (flink-lifetime)
[169.253340] Starting subtest: flink-lifetime
[169.259825] Subtest flink-lifetime: SUCCESS (0.012s)
[169.666801] [034/161] (902s left) gem_huc_copy (huc-copy)
[170.142160] Subtest huc-copy: SKIP (0.000s)
[170.457468] [035/161] (902s left) gem_linear_blits (basic)
[171.302717] Starting subtest: basic
[171.350831] Subtest basic: SUCCESS (0.049s)
[171.788514] [036/161] (901s left) gem_mmap (basic)
[172.480908] Starting subtest: basic
[172.501337] Subtest basic: SUCCESS (0.003s)
[172.831787] [037/161] (900s left) gem_mmap_gtt (basic)
[173.281971] Starting subtest: basic
[173.287311] Subtest basic: SUCCESS (0.005s)
[173.632692] [038/161] (900s left) gem_render_linear_blits (basic)
[174.100786] Starting subtest: basic
[174.225458] Subtest basic: SUCCESS (0.129s)
[174.559477] [039/161] (899s left) gem_render_tiled_blits (basic)
[175.015516] Starting subtest: basic
[175.170477] Subtest basic: SUCCESS (0.156s)
[175.495509] [040/161] (898s left) gem_ringfill (basic-all)
[176.074941] Starting subtest: basic-all
[177.287952] Subtest basic-all: SUCCESS (1.217s)
[177.636905] [041/161] (897s left) gem_softpin (allocator-basic)
[178.124540] Subtest allocator-basic: SKIP (0.000s)
[178.473517] [042/161] (896s left) gem_softpin (allocator-basic-reserve)
[178.934504] Subtest allocator-basic-reserve: SKIP (0.000s)
[179.270418] [043/161] (896s left) gem_softpin (safe-alignment)
[179.769563] Starting subtest: safe-alignment
[179.783556] Subtest safe-alignment: SUCCESS (0.024s)
[180.170465] [044/161] (895s left) gem_sync (basic-all)
[180.693765] Starting subtest: basic-all
[182.860582] Subtest basic-all: SUCCESS (2.162s)
[183.341583] [045/161] (892s left) gem_sync (basic-each)
[183.864458] Starting subtest: basic-each
[186.023944] Subtest basic-each: SUCCESS (2.162s)
[186.513367] [046/161] (889s left) gem_tiled_blits (basic)
[187.342899] Starting subtest: basic
[187.443509] Subtest basic: SUCCESS (0.107s)
[187.882666] [047/161] (888s left) gem_tiled_fence_blits (basic)
[188.966065] Starting subtest: basic
[189.035644] Subtest basic: SUCCESS (0.072s)
[189.466720] [048/161] (887s left) gem_tiled_pread_basic
[192.259720] [049/161] (885s left) gem_wait (busy@all-engines)
[192.850850] Starting subtest: busy
[192.855935] Starting dynamic subtest: all-engines
[193.381408] Dynamic subtest all-engines: SUCCESS (0.526s)
[193.386076] Subtest busy: SUCCESS (0.530s)
[194.041473] [050/161] (883s left) gem_wait (wait@all-engines)
[194.636346] Starting subtest: wait
[194.641808] Starting dynamic subtest: all-engines
[195.691000] Dynamic subtest all-engines: SUCCESS (1.067s)
[195.696531] Subtest wait: SUCCESS (1.072s)
[196.341494] [051/161] (881s left) i915_getparams_basic (basic-eu-total)
[196.788795] Starting subtest: basic-eu-total
[196.794820] Subtest basic-eu-total: SUCCESS (0.001s)
[197.136831] [052/161] (881s left) i915_getparams_basic (basic-subslice-total)
[197.573313] Starting subtest: basic-subslice-total
[197.582576] Subtest basic-subslice-total: SUCCESS (0.000s)
[197.920394] [053/161] (880s left) i915_hangman (error-state-basic)
[198.406856] Starting subtest: error-state-basic
[198.796538] Subtest error-state-basic: SUCCESS (0.392s)
[199.133346] [054/161] (879s left) i915_pciid
[199.919547] [055/161] (879s left) kms_addfb_basic (addfb25-4-tiled)
[200.435949] Starting subtest: addfb25-4-tiled
[200.440444] Subtest addfb25-4-tiled: SUCCESS (0.002s)
[200.812833] [056/161] (878s left) kms_addfb_basic (addfb25-bad-modifier)
[201.295685] Starting subtest: addfb25-bad-modifier
[201.300889] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[201.680206] [057/161] (878s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[202.177169] Starting subtest: addfb25-framebuffer-vs-set-tiling
[202.183242] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[202.549719] [058/161] (877s left) kms_addfb_basic (addfb25-modifier-no-flag)
[203.055575] Starting subtest: addfb25-modifier-no-flag
[203.059000] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[203.413213] [059/161] (877s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[203.915616] Starting subtest: addfb25-x-tiled-legacy
[203.920200] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[204.285962] [060/161] (876s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[204.785538] Starting subtest: addfb25-x-tiled-mismatch-legacy
[204.789606] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s)
[205.157704] [061/161] (876s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[205.656571] Starting subtest: addfb25-yf-tiled-legacy
[205.660768] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[206.007488] [062/161] (875s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[206.502723] Starting subtest: addfb25-y-tiled-legacy
[206.507921] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s)
[206.860578] [063/161] (874s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[207.357343] Starting subtest: addfb25-y-tiled-small-legacy
[207.364118] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[207.708582] [064/161] (874s left) kms_addfb_basic (bad-pitch-0)
[208.154324] Starting subtest: bad-pitch-0
[208.158915] Subtest bad-pitch-0: SUCCESS (0.000s)
[208.602532] [065/161] (873s left) kms_addfb_basic (bad-pitch-1024)
[209.048288] Starting subtest: bad-pitch-1024
[209.053876] Subtest bad-pitch-1024: SUCCESS (0.000s)
[209.482465] [066/161] (873s left) kms_addfb_basic (bad-pitch-128)
[210.009135] Starting subtest: bad-pitch-128
[210.015401] Subtest bad-pitch-128: SUCCESS (0.000s)
[210.444457] [067/161] (872s left) kms_addfb_basic (bad-pitch-256)
[210.905794] Starting subtest: bad-pitch-256
[210.910796] Subtest bad-pitch-256: SUCCESS (0.000s)
[211.331490] [068/161] (872s left) kms_addfb_basic (bad-pitch-32)
[211.779812] Starting subtest: bad-pitch-32
[211.783837] Subtest bad-pitch-32: SUCCESS (0.000s)
[212.202513] [069/161] (871s left) kms_addfb_basic (bad-pitch-63)
[212.651523] Starting subtest: bad-pitch-63
[212.655901] Subtest bad-pitch-63: SUCCESS (0.000s)
[213.061284] [070/161] (870s left) kms_addfb_basic (bad-pitch-65536)
[213.515912] Starting subtest: bad-pitch-65536
[213.520578] Subtest bad-pitch-65536: SUCCESS (0.002s)
[213.938882] [071/161] (870s left) kms_addfb_basic (bad-pitch-999)
[214.390952] Starting subtest: bad-pitch-999
[214.396470] Subtest bad-pitch-999: SUCCESS (0.000s)
[214.821384] [072/161] (869s left) kms_addfb_basic (basic)
[215.265506] Starting subtest: basic
[215.269882] Subtest basic: SUCCESS (0.000s)
[215.687770] [073/161] (869s left) kms_addfb_basic (basic-x-tiled-legacy)
[216.149364] Starting subtest: basic-x-tiled-legacy
[216.153993] Subtest basic-x-tiled-legacy: SUCCESS (0.001s)
[216.553928] [074/161] (868s left) kms_addfb_basic (basic-y-tiled-legacy)
[217.011606] Starting subtest: basic-y-tiled-legacy
[217.016257] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[217.450573] [075/161] (868s left) kms_addfb_basic (bo-too-small)
[217.938543] Starting subtest: bo-too-small
[217.944829] Subtest bo-too-small: SUCCESS (0.002s)
[218.326773] [076/161] (867s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[218.823414] Starting subtest: bo-too-small-due-to-tiling
[218.828150] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[219.182184] [077/161] (867s left) kms_addfb_basic (clobberred-modifier)
[219.632406] Starting subtest: clobberred-modifier
[219.637306] Subtest clobberred-modifier: SUCCESS (0.001s)
[220.050757] [078/161] (866s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[220.517715] Starting subtest: framebuffer-vs-set-tiling
[220.522789] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[220.920324] [079/161] (866s left) kms_addfb_basic (invalid-get-prop)
[221.368124] Starting subtest: invalid-get-prop
[221.371688] Subtest invalid-get-prop: SUCCESS (0.000s)
[221.884324] [080/161] (865s left) kms_addfb_basic (invalid-get-prop-any)
[222.353994] Starting subtest: invalid-get-prop-any
[222.358118] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[222.758892] [081/161] (864s left) kms_addfb_basic (invalid-set-prop)
[223.209911] Starting subtest: invalid-set-prop
[223.217299] Subtest invalid-set-prop: SUCCESS (0.000s)
[223.726778] [082/161] (864s left) kms_addfb_basic (invalid-set-prop-any)
[224.327353] Starting subtest: invalid-set-prop-any
[224.332327] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[224.893709] [083/161] (863s left) kms_addfb_basic (no-handle)
[225.455750] Starting subtest: no-handle
[225.459619] Subtest no-handle: SUCCESS (0.000s)
[225.897332] [084/161] (863s left) kms_addfb_basic (size-max)
[226.493206] Starting subtest: size-max
[226.497887] Subtest size-max: SUCCESS (0.001s)
[226.927700] [085/161] (862s left) kms_addfb_basic (small-bo)
[227.504316] Starting subtest: small-bo
[227.512550] Subtest small-bo: SUCCESS (0.001s)
[227.994422] [086/161] (861s left) kms_addfb_basic (tile-pitch-mismatch)
[228.577204] Starting subtest: tile-pitch-mismatch
[228.585690] Subtest tile-pitch-mismatch: SUCCESS (0.007s)
[229.053903] [087/161] (861s left) kms_addfb_basic (too-high)
[229.560769] Starting subtest: too-high
[229.565525] Subtest too-high: SUCCESS (0.006s)
[230.007730] [088/161] (860s left) kms_addfb_basic (too-wide)
[230.547229] Starting subtest: too-wide
[230.551821] Subtest too-wide: SUCCESS (0.000s)
[230.994863] [089/161] (859s left) kms_addfb_basic (unused-handle)
[231.571356] Starting subtest: unused-handle
[231.578218] Subtest unused-handle: SUCCESS (0.000s)
[232.181963] [090/161] (859s left) kms_addfb_basic (unused-modifier)
[232.658517] Starting subtest: unused-modifier
[232.663623] Subtest unused-modifier: SUCCESS (0.000s)
[233.088193] [091/161] (858s left) kms_addfb_basic (unused-offsets)
[233.547329] Starting subtest: unused-offsets
[233.552515] Subtest unused-offsets: SUCCESS (0.000s)
[233.981153] [092/161] (858s left) kms_addfb_basic (unused-pitches)
[234.528930] Starting subtest: unused-pitches
[234.535705] Subtest unused-pitches: SUCCESS (0.003s)
[235.033470] [093/161] (857s left) kms_busy (basic)
[235.567369] Starting subtest: basic
[235.571645] Starting dynamic subtest: flip
[236.811093] Dynamic subtest flip: SUCCESS (1.239s)
[236.873957] Starting dynamic subtest: modeset
[236.888733] Dynamic subtest modeset: SKIP (0.000s)
[236.893674] Subtest basic: SUCCESS (1.252s)
[237.519470] [094/161] (855s left) kms_prop_blob (basic)
[238.069932] Starting subtest: basic
[238.074453] Subtest basic: SUCCESS (0.000s)
[238.440131] [095/161] (854s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[238.999496] Starting subtest: basic-busy-flip-before-cursor-atomic
[239.025889] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.024s)
[239.467842] [096/161] (854s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[240.031714] Starting subtest: basic-busy-flip-before-cursor-legacy
[241.137097] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.105s)
[241.642593] [097/161] (852s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[242.132773] Starting subtest: basic-flip-after-cursor-atomic
[242.141595] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[242.490127] [098/161] (851s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[242.986567] Starting subtest: basic-flip-after-cursor-legacy
[244.070614] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.087s)
[244.569855] [099/161] (849s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[245.057658] Starting subtest: basic-flip-after-cursor-varying-size
[246.144924] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.089s)
[246.660143] [100/161] (848s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[247.146345] Starting subtest: basic-flip-before-cursor-atomic
[247.154818] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[247.493507] [101/161] (847s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[247.989725] Starting subtest: basic-flip-before-cursor-legacy
[249.073191] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.088s)
[249.568500] [102/161] (845s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[250.062267] Starting subtest: basic-flip-before-cursor-varying-size
[251.161857] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.098s)
[251.671219] [103/161] (844s left) kms_dsc (dsc-basic)
[252.171811] Subtest dsc-basic: SKIP (0.000s)
[252.491521] [104/161] (843s left) kms_flip (basic-flip-vs-dpms)
[252.988423] Starting subtest: basic-flip-vs-dpms
[252.992869] Starting dynamic subtest: A-VGA1
[254.695324] Dynamic subtest A-VGA1: SUCCESS (1.704s)
[254.752627] Starting dynamic subtest: B-VGA1
[256.305096] Dynamic subtest B-VGA1: SUCCESS (1.600s)
[256.309597] Subtest basic-flip-vs-dpms: SUCCESS (3.323s)
[256.984346] [105/161] (839s left) kms_flip (basic-flip-vs-modeset)
[257.473653] Starting subtest: basic-flip-vs-modeset
[257.477735] Starting dynamic subtest: A-VGA1
[259.143347] Dynamic subtest A-VGA1: SUCCESS (1.661s)
[259.191593] Starting dynamic subtest: B-VGA1
[260.618586] Dynamic subtest B-VGA1: SUCCESS (1.465s)
[260.629124] Subtest basic-flip-vs-modeset: SUCCESS (3.137s)
[261.239411] [106/161] (835s left) kms_flip (basic-flip-vs-wf_vblank)
[261.744639] Starting subtest: basic-flip-vs-wf_vblank
[261.749442] Starting dynamic subtest: A-VGA1
[263.576956] Dynamic subtest A-VGA1: SUCCESS (1.822s)
[263.628880] Starting dynamic subtest: B-VGA1
[265.302165] Dynamic subtest B-VGA1: SUCCESS (1.728s)
[265.306471] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.560s)
[266.022076] [107/161] (831s left) kms_flip (basic-plain-flip)
[266.519862] Starting subtest: basic-plain-flip
[266.523451] Starting dynamic subtest: A-VGA1
[268.063609] Dynamic subtest A-VGA1: SUCCESS (1.527s)
[268.115651] Starting dynamic subtest: B-VGA1
[269.499676] Dynamic subtest B-VGA1: SUCCESS (1.438s)
[269.504253] Subtest basic-plain-flip: SUCCESS (2.976s)
[270.264417] [108/161] (827s left) kms_force_connector_basic (force-connector-state)
[270.812377] Starting subtest: force-connector-state
[271.090236] Subtest force-connector-state: SUCCESS (0.271s)
[271.747232] [109/161] (826s left) kms_force_connector_basic (force-edid)
[272.298259] Starting subtest: force-edid
[272.402493] Subtest force-edid: SUCCESS (0.097s)
[272.824727] [110/161] (825s left) kms_force_connector_basic (force-load-detect)
[273.356716] Starting subtest: force-load-detect
[273.875794] Subtest force-load-detect: SUCCESS (0.524s)
[274.494786] [111/161] (823s left) kms_force_connector_basic (prune-stale-modes)
[275.033847] Starting subtest: prune-stale-modes
[275.134433] Subtest prune-stale-modes: SUCCESS (0.099s)
[275.583691] [112/161] (823s left) kms_frontbuffer_tracking (basic)
[276.096131] Subtest basic: SKIP (0.000s)
[276.431246] [113/161] (822s left) kms_hdmi_inject (inject-audio)
[276.884262] Subtest inject-audio: SKIP (0.000s)
[277.209082] [114/161] (822s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[277.708919] Starting subtest: compare-crc-sanitycheck-xr24
[277.713595] Starting dynamic subtest: pipe-A-VGA-1
[278.112330] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.404s)
[278.200952] Starting dynamic subtest: pipe-B-VGA-1
[278.730823] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.587s)
[278.736548] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.032s)
[279.254658] [115/161] (820s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[279.742630] Starting subtest: compare-crc-sanitycheck-nv12
[279.747198] Starting dynamic subtest: pipe-A-VGA-1
[279.756475] Dynamic subtest pipe-A-VGA-1: SKIP (0.001s)
[279.814357] Starting dynamic subtest: pipe-B-VGA-1
[279.822384] Dynamic subtest pipe-B-VGA-1: SKIP (0.001s)
[279.830689] Subtest compare-crc-sanitycheck-nv12: SKIP (0.016s)
[280.132802] [116/161] (819s left) kms_pipe_crc_basic (hang-read-crc)
[280.629099] Starting subtest: hang-read-crc
[280.633960] Starting dynamic subtest: pipe-A-VGA-1
[281.965386] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.331s)
[282.024183] Starting dynamic subtest: pipe-B-VGA-1
[283.438339] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.466s)
[283.441900] Subtest hang-read-crc: SUCCESS (2.814s)
[283.954686] [117/161] (816s left) kms_pipe_crc_basic (nonblocking-crc)
[284.448622] Starting subtest: nonblocking-crc
[284.453981] Starting dynamic subtest: pipe-A-VGA-1
[285.074999] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.623s)
[285.142404] Starting dynamic subtest: pipe-B-VGA-1
[285.825435] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.745s)
[285.829289] Subtest nonblocking-crc: SUCCESS (1.385s)
[286.322929] [118/161] (814s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[286.835954] Starting subtest: nonblocking-crc-frame-sequence
[286.840876] Starting dynamic subtest: pipe-A-VGA-1
[287.436115] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.592s)
[287.501452] Starting dynamic subtest: pipe-B-VGA-1
[288.176202] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.727s)
[288.181181] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.340s)
[288.681103] [119/161] (812s left) kms_pipe_crc_basic (read-crc)
[289.190135] Starting subtest: read-crc
[289.193916] Starting dynamic subtest: pipe-A-VGA-1
[289.715280] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.526s)
[289.782372] Starting dynamic subtest: pipe-B-VGA-1
[290.360878] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.634s)
[290.366230] Subtest read-crc: SUCCESS (1.176s)
[290.877771] [120/161] (810s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[291.355155] Starting subtest: read-crc-frame-sequence
[291.367605] Starting dynamic subtest: pipe-A-VGA-1
[291.908420] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.543s)
[291.975563] Starting dynamic subtest: pipe-B-VGA-1
[292.574310] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.654s)
[292.580129] Subtest read-crc-frame-sequence: SUCCESS (1.218s)
[293.065167] [121/161] (808s left) kms_pm_backlight (basic-brightness)
[293.569113] Subtest basic-brightness: SKIP (0.000s)
[293.910788] [122/161] (808s left) kms_pm_rpm (basic-pci-d3-state)
[305.859933] Subtest basic-pci-d3-state: SKIP (0.000s)
[306.186235] [123/161] (796s left) kms_pm_rpm (basic-rte)
[306.624122] Starting subtest: basic-rte
[318.095490] Subtest basic-rte: SKIP (11.461s)
[318.413636] [124/161] (784s left) kms_psr (psr-primary-page-flip)
[318.901159] Subtest psr-primary-page-flip: SKIP (0.000s)
[319.226471] [125/161] (783s left) kms_psr (psr-cursor-plane-move)
[319.715099] Subtest psr-cursor-plane-move: SKIP (0.000s)
[320.049958] [126/161] (783s left) kms_psr (psr-sprite-plane-onoff)
[320.549616] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[320.890411] [127/161] (782s left) kms_psr (psr-primary-mmap-gtt)
[321.389651] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[321.713585] [128/161] (782s left) kms_setmode (basic-clone-single-crtc)
[322.160066] Starting subtest: basic-clone-single-crtc
[322.172823] Subtest basic-clone-single-crtc: SKIP (0.001s)
[322.511566] [129/161] (781s left) i915_pm_rps (basic-api)
[322.967878] Subtest basic-api: SKIP (0.000s)
[323.301559] [130/161] (781s left) prime_self_import (basic-llseek-bad)
[323.732813] Starting subtest: basic-llseek-bad
[323.744998] Subtest basic-llseek-bad: SUCCESS (0.013s)
[324.116921] [131/161] (780s left) prime_self_import (basic-llseek-size)
[324.547678] Starting subtest: basic-llseek-size
[324.567945] Subtest basic-llseek-size: SUCCESS (0.024s)
[324.928560] [132/161] (780s left) prime_self_import (basic-with_fd_dup)
[325.363363] Starting subtest: basic-with_fd_dup
[325.381682] Subtest basic-with_fd_dup: SUCCESS (0.019s)
[325.748688] [133/161] (779s left) prime_self_import (basic-with_one_bo)
[326.175892] Starting subtest: basic-with_one_bo
[326.194805] Subtest basic-with_one_bo: SUCCESS (0.023s)
[326.538526] [134/161] (779s left) prime_self_import (basic-with_one_bo_two_files)
[326.966529] Starting subtest: basic-with_one_bo_two_files
[326.985925] Subtest basic-with_one_bo_two_files: SUCCESS (0.018s)
[327.332326] [135/161] (778s left) prime_self_import (basic-with_two_bos)
[327.769193] Starting subtest: basic-with_two_bos
[327.789530] Subtest basic-with_two_bos: SUCCESS (0.019s)
[328.147403] [136/161] (778s left) prime_vgem (basic-fence-flip)
[328.632152] Starting subtest: basic-fence-flip
[329.324496] Subtest basic-fence-flip: SUCCESS (0.692s)
[329.735666] [137/161] (777s left) prime_vgem (basic-fence-mmap)
[330.248505] Starting subtest: basic-fence-mmap
[330.460094] Subtest basic-fence-mmap: SUCCESS (0.207s)
[330.815798] [138/161] (776s left) prime_vgem (basic-fence-read)
[331.284804] Starting subtest: basic-fence-read
[331.534659] Subtest basic-fence-read: SUCCESS (0.252s)
[331.902628] [139/161] (775s left) prime_vgem (basic-gtt)
[332.381402] Starting subtest: basic-gtt
[332.453580] Subtest basic-gtt: SUCCESS (0.075s)
[332.819336] [140/161] (775s left) prime_vgem (basic-read)
[333.294812] Starting subtest: basic-read
[333.399251] Subtest basic-read: SUCCESS (0.103s)
[333.783314] [141/161] (774s left) prime_vgem (basic-write)
[334.249274] Starting subtest: basic-write
[334.363665] Subtest basic-write: SUCCESS (0.115s)
[334.731525] [142/161] (773s left) vgem_basic (setversion)
[335.177839] Starting subtest: setversion
[335.185106] Subtest setversion: SUCCESS (0.000s)
[335.521690] [143/161] (773s left) vgem_basic (create)
[335.977792] Starting subtest: create
[335.981861] Subtest create: SUCCESS (0.003s)
[336.322617] [144/161] (772s left) vgem_basic (debugfs)
[336.779683] Starting subtest: debugfs
[336.784358] Subtest debugfs: SUCCESS (0.004s)
[337.114866] [145/161] (772s left) vgem_basic (dmabuf-export)
[337.568522] Starting subtest: dmabuf-export
[337.580842] Subtest dmabuf-export: SUCCESS (0.015s)
[337.932375] [146/161] (771s left) vgem_basic (dmabuf-fence)
[338.379906] Starting subtest: dmabuf-fence
[338.384299] Subtest dmabuf-fence: SUCCESS (0.005s)
[338.722951] [147/161] (771s left) vgem_basic (dmabuf-fence-before)
[339.161909] Starting subtest: dmabuf-fence-before
[339.166721] Subtest dmabuf-fence-before: SUCCESS (0.003s)
[339.507088] [148/161] (770s left) vgem_basic (dmabuf-mmap)
[339.964734] Starting subtest: dmabuf-mmap
[340.036774] Subtest dmabuf-mmap: SUCCESS (0.079s)
[340.370941] [149/161] (770s left) vgem_basic (mmap)
[340.827771] Starting subtest: mmap
[340.886181] Subtest mmap: SUCCESS (0.060s)
[341.221153] [150/161] (769s left) vgem_basic (second-client)
[341.665134] Starting subtest: second-client
[341.695109] Subtest second-client: SUCCESS (0.032s)
[342.043902] [151/161] (769s left) vgem_basic (sysfs)
[342.501297] Starting subtest: sysfs
[342.506562] Subtest sysfs: SUCCESS (0.005s)
[342.839995] [152/161] (768s left) core_hotunplug (unbind-rebind)
[343.614325] Starting subtest: unbind-rebind
[349.687992] Subtest unbind-rebind: SUCCESS (6.073s)
[350.021347] [153/161] (761s left) vgem_basic (unload)
[350.467835] Starting subtest: unload
[380.131746] Subtest unload: SUCCESS (29.667s)
[380.672671] [154/161] (731s left) i915_module_load (reload)
[381.116145] Starting subtest: reload
[391.035709] Subtest reload: SUCCESS (9.919s)
[391.937334] [155/161] (721s left) gem_lmem_swapping (basic)
[392.653152] Subtest basic: SKIP (0.000s)
[392.971199] [156/161] (720s left) gem_lmem_swapping (parallel-random-engines)
[393.443756] Subtest parallel-random-engines: SKIP (0.000s)
[393.774402] [157/161] (720s left) gem_lmem_swapping (random-engines)
[394.238993] Subtest random-engines: SKIP (0.000s)
[394.552609] [158/161] (719s left) gem_lmem_swapping (verify-random)
[395.015891] Subtest verify-random: SKIP (0.000s)
[395.337199] [159/161] (719s left) i915_pm_rpm (module-reload)
[407.294874] Subtest module-reload: SKIP (0.000s)
[407.616562] [160/161] (707s left) i915_selftest (live)
[410.504712] Starting subtest: live
[410.508353] Starting dynamic subtest: sanitycheck
[417.828219] Dynamic subtest sanitycheck: SUCCESS (7.325s)
[417.870921] Starting dynamic subtest: uncore
[425.082514] Dynamic subtest uncore: SUCCESS (7.249s)
[425.126063] Starting dynamic subtest: workarounds
[432.471622] Dynamic subtest workarounds: SUCCESS (7.381s)
[432.551794] Starting dynamic subtest: gt_engines
[439.903187] Dynamic subtest gt_engines: SUCCESS (7.423s)
[439.982899] Starting dynamic subtest: gt_timelines
[453.472478] Dynamic subtest gt_timelines: SUCCESS (13.567s)
[453.514693] Starting dynamic subtest: gt_contexts
[460.876652] Dynamic subtest gt_contexts: SUCCESS (7.398s)
[460.928380] Starting dynamic subtest: gt_lrc
[468.406173] Dynamic subtest gt_lrc: SUCCESS (7.523s)
[468.464268] Starting dynamic subtest: gt_mocs
[475.739117] Dynamic subtest gt_mocs: SUCCESS (7.328s)
[475.793986] Starting dynamic subtest: gt_pm
[483.464208] Dynamic subtest gt_pm: SUCCESS (7.718s)
[483.541237] Starting dynamic subtest: gt_heartbeat
[490.858498] Dynamic subtest gt_heartbeat: SUCCESS (7.388s)
[490.905755] Starting dynamic subtest: gt_tlb
[498.323263] Dynamic subtest gt_tlb: SUCCESS (7.457s)
[498.371372] Starting dynamic subtest: requests
[508.330705] Dynamic subtest requests: SUCCESS (10.005s)
[508.370846] Starting dynamic subtest: migrate
[515.746927] Dynamic subtest migrate: SUCCESS (7.409s)
[515.826661] Starting dynamic subtest: active
[523.141168] Dynamic subtest active: SUCCESS (7.387s)
[523.197370] Starting dynamic subtest: objects
[531.353904] Dynamic subtest objects: SUCCESS (8.206s)
[531.407097] Starting dynamic subtest: mman
[546.075925] Dynamic subtest mman: SUCCESS (14.716s)
[546.149624] Starting dynamic subtest: dmabuf
[553.440835] Dynamic subtest dmabuf: SUCCESS (7.360s)
[553.482227] Starting dynamic subtest: vma
[560.888432] Dynamic subtest vma: SUCCESS (7.442s)
[560.968906] Starting dynamic subtest: coherency
[573.824894] Dynamic subtest coherency: SUCCESS (12.929s)
[573.871055] Starting dynamic subtest: gtt
[583.954186] Dynamic subtest gtt: SUCCESS (10.120s)
[584.013085] Starting dynamic subtest: gem
[591.536155] Dynamic subtest gem: SUCCESS (7.576s)
[591.576088] Starting dynamic subtest: evict
[598.817387] Dynamic subtest evict: SUCCESS (7.272s)
[598.859441] Starting dynamic subtest: hugepages
[606.257234] Dynamic subtest hugepages: SUCCESS (7.435s)
[606.331536] Starting dynamic subtest: gem_contexts
[613.545291] Dynamic subtest gem_contexts: SUCCESS (7.281s)
[613.606818] Starting dynamic subtest: client
[620.862380] Dynamic subtest client: SUCCESS (7.309s)
[620.919607] Starting dynamic subtest: gem_migrate
[628.302456] Dynamic subtest gem_migrate: SUCCESS (7.435s)
[628.351765] Starting dynamic subtest: reset
[638.727722] Dynamic subtest reset: SUCCESS (10.416s)
[638.812235] Starting dynamic subtest: memory_region
[646.384444] Dynamic subtest memory_region: SUCCESS (7.650s)
[646.436238] Starting dynamic subtest: hangcheck
[654.823288] Dynamic subtest hangcheck: SUCCESS (8.432s)
[654.884220] Starting dynamic subtest: execlists
[662.176967] Dynamic subtest execlists: SUCCESS (7.345s)
[662.220817] Starting dynamic subtest: ring_submission
[669.465229] Dynamic subtest ring_submission: SUCCESS (7.281s)
[669.508296] Starting dynamic subtest: perf
[676.858200] Dynamic subtest perf: SUCCESS (7.386s)
[676.907699] Starting dynamic subtest: slpc
[684.274483] Dynamic subtest slpc: SUCCESS (7.404s)
[684.333723] Starting dynamic subtest: guc
[691.708609] Dynamic subtest guc: SUCCESS (7.432s)
[691.757487] Starting dynamic subtest: guc_multi_lrc
[700.628820] Dynamic subtest guc_multi_lrc: SUCCESS (8.912s)
[700.723652] Starting dynamic subtest: guc_hang
[708.063559] Dynamic subtest guc_hang: SUCCESS (7.427s)
[708.122808] Starting dynamic subtest: late_gt_pm
[715.347389] Dynamic subtest late_gt_pm: SUCCESS (7.278s)
[715.352682] Subtest live: SUCCESS (304.844s)
[715.605290] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[715.615227] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[715.627697] [161/161] (399s left) dmabuf (all-tests)
[716.092607] Starting subtest: all-tests
[716.096678] Starting dynamic subtest: sanitycheck
[716.193419] Dynamic subtest sanitycheck: SUCCESS (0.105s)
[716.258412] Starting dynamic subtest: dma_fence
[716.471427] Dynamic subtest dma_fence: SUCCESS (0.271s)
[716.517325] Starting dynamic subtest: dma_fence_chain