[148.171247] Initializing watchdogs
[148.171932]   /dev/watchdog0
[148.318720] [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)
[148.370904] [001/161] (960s left) i915_module_load (load)
[150.007764] Starting subtest: load
[157.664434] Subtest load: SUCCESS (7.655s)
[158.063806] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[158.073571] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[158.095545] [002/161] (951s left) core_auth (basic-auth)
[158.611971] Starting subtest: basic-auth
[158.617942] Subtest basic-auth: SUCCESS (0.004s)
[158.929657] [003/161] (950s left) debugfs_test (read_all_entries)
[159.410869] Starting subtest: read_all_entries
[159.636325] Subtest read_all_entries: SUCCESS (0.224s)
[160.019280] [004/161] (949s left) debugfs_test (basic-hwmon)
[160.486995] Starting subtest: basic-hwmon
[160.496839] Subtest basic-hwmon: SKIP (0.000s)
[160.845411] [005/161] (949s left) debugfs_test (sysfs)
[161.315391] Starting subtest: sysfs
[161.454748] Subtest sysfs: SUCCESS (0.143s)
[161.811949] [006/161] (948s left) fbdev (eof)
[162.320791] Starting subtest: eof
[162.326432] Subtest eof: SUCCESS (0.004s)
[162.614455] [007/161] (948s left) fbdev (info)
[163.053350] Starting subtest: info
[163.058543] Subtest info: SUCCESS (0.000s)
[163.387346] [008/161] (947s left) fbdev (nullptr)
[163.895570] Starting subtest: nullptr
[163.900501] Subtest nullptr: SUCCESS (0.001s)
[164.181148] [009/161] (947s left) fbdev (read)
[164.631595] Starting subtest: read
[164.933955] Subtest read: SUCCESS (0.305s)
[165.227476] [010/161] (946s left) fbdev (write)
[165.681894] Starting subtest: write
[165.862474] Subtest write: SUCCESS (0.183s)
[166.165818] [011/161] (945s left) gem_basic (bad-close)
[166.615569] Starting subtest: bad-close
[166.623440] Subtest bad-close: SUCCESS (0.000s)
[166.916933] [012/161] (945s left) gem_basic (create-close)
[167.518949] Starting subtest: create-close
[167.530560] Subtest create-close: SUCCESS (0.001s)
[167.855152] [013/161] (944s left) gem_basic (create-fd-close)
[168.316721] Starting subtest: create-fd-close
[168.323867] Subtest create-fd-close: SUCCESS (0.001s)
[168.640838] [014/161] (944s left) gem_busy (busy@all-engines)
[169.202161] Starting subtest: busy
[169.207150] Starting dynamic subtest: all-engines
[169.339123] Dynamic subtest all-engines: SUCCESS (0.141s)
[169.343528] Subtest busy: SUCCESS (0.146s)
[170.034474] [015/161] (942s left) gem_close_race (basic-process)
[170.571814] Starting subtest: basic-process
[170.785591] Subtest basic-process: SUCCESS (0.215s)
[171.239411] [016/161] (941s left) gem_close_race (basic-threads)
[171.775240] Starting subtest: basic-threads
[173.420925] Subtest basic-threads: SUCCESS (1.651s)
[173.868491] [017/161] (939s left) gem_ctx_create (basic)
[174.328599] Subtest basic: SKIP (0.000s)
[174.617370] [018/161] (939s left) gem_ctx_create (basic-files)
[175.079653] Subtest basic-files: SKIP (0.000s)
[175.364773] [019/161] (938s left) gem_ctx_exec (basic)
[175.834262] Subtest basic: SKIP (0.000s)
[176.165510] [020/161] (938s left) gem_exec_basic (basic)
[176.690488] Starting subtest: basic
[176.695966] Starting dynamic subtest: rcs0-smem
[176.699527] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[176.703221] Subtest basic: SUCCESS (0.010s)
[177.164581] [021/161] (937s left) gem_exec_create (basic)
[177.695457] Starting subtest: basic
[177.699843] Starting dynamic subtest: smem
[179.852228] Dynamic subtest smem: SUCCESS (2.160s)
[179.856089] Subtest basic: SUCCESS (2.163s)
[180.307269] [022/161] (934s left) gem_exec_fence (basic-busy)
[181.056378] Starting subtest: basic-busy
[181.066517] Starting dynamic subtest: rcs0
[181.094473] Dynamic subtest rcs0: SUCCESS (0.035s)
[181.099542] Subtest basic-busy: SUCCESS (0.040s)
[182.273458] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[182.286337] [023/161] (932s left) gem_exec_fence (basic-wait)
[183.040373] Starting subtest: basic-wait
[183.044976] Starting dynamic subtest: rcs0
[183.074630] Dynamic subtest rcs0: SUCCESS (0.036s)
[183.078905] Subtest basic-wait: SUCCESS (0.041s)
[184.030684] [024/161] (931s left) gem_exec_fence (basic-await)
[184.789655] Starting subtest: basic-await
[184.793683] Starting dynamic subtest: rcs0
[184.942415] Dynamic subtest rcs0: SUCCESS (0.152s)
[184.946229] Subtest basic-await: SUCCESS (0.156s)
[185.901397] [025/161] (929s left) gem_exec_fence (nb-await)
[186.653522] Starting subtest: nb-await
[186.658733] Starting dynamic subtest: rcs0
[186.720966] Dynamic subtest rcs0: SUCCESS (0.064s)
[186.724764] Subtest nb-await: SUCCESS (0.069s)
[187.704674] [026/161] (928s left) gem_exec_gttfill (basic)
[188.238000] Starting subtest: basic
[198.151909] Subtest basic: SUCCESS (9.917s)
[198.699184] [027/161] (917s left) gem_exec_parallel (engines)
[199.471643] Starting subtest: engines
[199.476629] Starting dynamic subtest: basic
[203.508840] Dynamic subtest basic: SUCCESS (4.039s)
[203.557654] Starting dynamic subtest: contexts
[203.565640] Dynamic subtest contexts: SKIP (0.005s)
[203.606604] Starting dynamic subtest: fds
[203.613815] Dynamic subtest fds: SKIP (0.003s)
[203.654664] Starting dynamic subtest: userptr
[207.709432] Dynamic subtest userptr: SUCCESS (4.184s)
[207.713420] Subtest engines: SUCCESS (8.242s)
[208.201387] [028/161] (908s left) gem_exec_store (basic)
[208.823569] Starting subtest: basic
[208.878604] Subtest basic: SUCCESS (0.058s)
[209.370787] [029/161] (907s left) gem_flink_basic (bad-flink)
[209.824910] Starting subtest: bad-flink
[209.831723] Subtest bad-flink: SUCCESS (0.000s)
[210.168622] [030/161] (907s left) gem_flink_basic (bad-open)
[210.619754] Starting subtest: bad-open
[210.624558] Subtest bad-open: SUCCESS (0.000s)
[210.973557] [031/161] (906s left) gem_flink_basic (basic)
[211.423692] Starting subtest: basic
[211.428171] Subtest basic: SUCCESS (0.001s)
[211.775741] [032/161] (906s left) gem_flink_basic (double-flink)
[212.235589] Starting subtest: double-flink
[212.242732] Subtest double-flink: SUCCESS (0.001s)
[212.599227] [033/161] (905s left) gem_flink_basic (flink-lifetime)
[213.037254] Starting subtest: flink-lifetime
[213.052092] Subtest flink-lifetime: SUCCESS (0.009s)
[213.400433] [034/161] (905s left) gem_huc_copy (huc-copy)
[213.868917] Subtest huc-copy: SKIP (0.000s)
[214.187543] [035/161] (904s left) gem_linear_blits (basic)
[214.959733] Starting subtest: basic
[215.006432] Subtest basic: SUCCESS (0.052s)
[215.463700] [036/161] (903s left) gem_mmap (basic)
[216.155145] Starting subtest: basic
[216.175457] Subtest basic: SUCCESS (0.003s)
[216.521955] [037/161] (903s left) gem_mmap_gtt (basic)
[216.978421] Starting subtest: basic
[216.982723] Subtest basic: SUCCESS (0.006s)
[217.351528] [038/161] (902s left) gem_render_linear_blits (basic)
[217.826582] Starting subtest: basic
[217.970576] Subtest basic: SUCCESS (0.139s)
[218.318978] [039/161] (901s left) gem_render_tiled_blits (basic)
[218.779731] Starting subtest: basic
[218.942749] Subtest basic: SUCCESS (0.163s)
[219.296841] [040/161] (901s left) gem_ringfill (basic-all)
[219.872089] Starting subtest: basic-all
[221.098603] Subtest basic-all: SUCCESS (1.228s)
[221.462167] [041/161] (899s left) gem_softpin (allocator-basic)
[221.931834] Subtest allocator-basic: SKIP (0.000s)
[222.275352] [042/161] (898s left) gem_softpin (allocator-basic-reserve)
[222.732613] Subtest allocator-basic-reserve: SKIP (0.000s)
[223.098324] [043/161] (898s left) gem_softpin (safe-alignment)
[223.641812] Starting subtest: safe-alignment
[223.655493] Subtest safe-alignment: SUCCESS (0.018s)
[224.023295] [044/161] (897s left) gem_sync (basic-all)
[224.561664] Starting subtest: basic-all
[226.824254] Subtest basic-all: SUCCESS (2.264s)
[227.363274] [045/161] (894s left) gem_sync (basic-each)
[227.930432] Starting subtest: basic-each
[230.160370] Subtest basic-each: SUCCESS (2.226s)
[230.652853] [046/161] (891s left) gem_tiled_blits (basic)
[231.465964] Starting subtest: basic
[231.575444] Subtest basic: SUCCESS (0.109s)
[232.002553] [047/161] (890s left) gem_tiled_fence_blits (basic)
[233.104617] Starting subtest: basic
[233.178388] Subtest basic: SUCCESS (0.074s)
[233.620802] [048/161] (889s left) gem_tiled_pread_basic
[236.252117] [049/161] (887s left) gem_wait (busy@all-engines)
[236.847450] Starting subtest: busy
[236.853199] Starting dynamic subtest: all-engines
[237.387271] Dynamic subtest all-engines: SUCCESS (0.540s)
[237.392144] Subtest busy: SUCCESS (0.544s)
[238.060328] [050/161] (885s left) gem_wait (wait@all-engines)
[238.737155] Starting subtest: wait
[238.742941] Starting dynamic subtest: all-engines
[239.784486] Dynamic subtest all-engines: SUCCESS (1.046s)
[239.788945] Subtest wait: SUCCESS (1.050s)
[240.459230] [051/161] (883s left) i915_getparams_basic (basic-eu-total)
[240.905773] Starting subtest: basic-eu-total
[240.913255] Subtest basic-eu-total: SUCCESS (0.001s)
[241.246196] [052/161] (883s left) i915_getparams_basic (basic-subslice-total)
[241.688957] Starting subtest: basic-subslice-total
[241.698507] Subtest basic-subslice-total: SUCCESS (0.001s)
[242.033820] [053/161] (882s left) i915_hangman (error-state-basic)
[242.518418] Starting subtest: error-state-basic
[242.912241] Subtest error-state-basic: SUCCESS (0.395s)
[243.262526] [054/161] (881s left) i915_pciid
[244.071891] [055/161] (881s left) kms_addfb_basic (addfb25-4-tiled)
[244.586952] Starting subtest: addfb25-4-tiled
[244.592294] Subtest addfb25-4-tiled: SUCCESS (0.002s)
[244.944482] [056/161] (880s left) kms_addfb_basic (addfb25-bad-modifier)
[245.448306] Starting subtest: addfb25-bad-modifier
[245.454384] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[245.832130] [057/161] (880s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[246.336351] Starting subtest: addfb25-framebuffer-vs-set-tiling
[246.341828] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[246.695138] [058/161] (879s left) kms_addfb_basic (addfb25-modifier-no-flag)
[247.198399] Starting subtest: addfb25-modifier-no-flag
[247.203887] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[247.583400] [059/161] (879s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[248.100911] Starting subtest: addfb25-x-tiled-legacy
[248.105121] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[248.489871] [060/161] (878s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[249.011965] Starting subtest: addfb25-x-tiled-mismatch-legacy
[249.016427] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s)
[249.366276] [061/161] (878s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[249.876803] Starting subtest: addfb25-yf-tiled-legacy
[249.880884] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[250.224338] [062/161] (877s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[250.738088] Starting subtest: addfb25-y-tiled-legacy
[250.743480] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s)
[251.102460] [063/161] (876s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[251.625435] Starting subtest: addfb25-y-tiled-small-legacy
[251.632667] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[251.980140] [064/161] (876s left) kms_addfb_basic (bad-pitch-0)
[252.441180] Starting subtest: bad-pitch-0
[252.445727] Subtest bad-pitch-0: SUCCESS (0.000s)
[252.870926] [065/161] (875s left) kms_addfb_basic (bad-pitch-1024)
[253.368637] Starting subtest: bad-pitch-1024
[253.374217] Subtest bad-pitch-1024: SUCCESS (0.000s)
[253.839949] [066/161] (875s left) kms_addfb_basic (bad-pitch-128)
[254.292315] Starting subtest: bad-pitch-128
[254.298762] Subtest bad-pitch-128: SUCCESS (0.000s)
[254.734666] [067/161] (874s left) kms_addfb_basic (bad-pitch-256)
[255.187653] Starting subtest: bad-pitch-256
[255.193102] Subtest bad-pitch-256: SUCCESS (0.000s)
[255.602988] [068/161] (874s left) kms_addfb_basic (bad-pitch-32)
[256.061431] Starting subtest: bad-pitch-32
[256.067137] Subtest bad-pitch-32: SUCCESS (0.000s)
[256.489649] [069/161] (873s left) kms_addfb_basic (bad-pitch-63)
[256.947658] Starting subtest: bad-pitch-63
[256.952838] Subtest bad-pitch-63: SUCCESS (0.000s)
[257.372533] [070/161] (872s left) kms_addfb_basic (bad-pitch-65536)
[257.828538] Starting subtest: bad-pitch-65536
[257.832762] Subtest bad-pitch-65536: SUCCESS (0.002s)
[258.262106] [071/161] (872s left) kms_addfb_basic (bad-pitch-999)
[258.720728] Starting subtest: bad-pitch-999
[258.726103] Subtest bad-pitch-999: SUCCESS (0.000s)
[259.150589] [072/161] (871s left) kms_addfb_basic (basic)
[259.609418] Starting subtest: basic
[259.613937] Subtest basic: SUCCESS (0.000s)
[260.044597] [073/161] (871s left) kms_addfb_basic (basic-x-tiled-legacy)
[260.505148] Starting subtest: basic-x-tiled-legacy
[260.510392] Subtest basic-x-tiled-legacy: SUCCESS (0.001s)
[261.056774] [074/161] (870s left) kms_addfb_basic (basic-y-tiled-legacy)
[261.538104] Starting subtest: basic-y-tiled-legacy
[261.544674] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[261.990760] [075/161] (870s left) kms_addfb_basic (bo-too-small)
[262.553062] Starting subtest: bo-too-small
[262.558560] Subtest bo-too-small: SUCCESS (0.002s)
[262.942573] [076/161] (869s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[263.481585] Starting subtest: bo-too-small-due-to-tiling
[263.489891] Subtest bo-too-small-due-to-tiling: SUCCESS (0.003s)
[263.899518] [077/161] (868s left) kms_addfb_basic (clobberred-modifier)
[264.350351] Starting subtest: clobberred-modifier
[264.357346] Subtest clobberred-modifier: SUCCESS (0.001s)
[264.771425] [078/161] (868s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[265.232511] Starting subtest: framebuffer-vs-set-tiling
[265.237462] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[265.657737] [079/161] (867s left) kms_addfb_basic (invalid-get-prop)
[266.122097] Starting subtest: invalid-get-prop
[266.125960] Subtest invalid-get-prop: SUCCESS (0.000s)
[266.546805] [080/161] (867s left) kms_addfb_basic (invalid-get-prop-any)
[266.992912] Starting subtest: invalid-get-prop-any
[266.998821] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[267.406302] [081/161] (866s left) kms_addfb_basic (invalid-set-prop)
[267.863401] Starting subtest: invalid-set-prop
[267.868248] Subtest invalid-set-prop: SUCCESS (0.000s)
[268.294874] [082/161] (866s left) kms_addfb_basic (invalid-set-prop-any)
[268.803775] Starting subtest: invalid-set-prop-any
[268.808941] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[269.190599] [083/161] (865s left) kms_addfb_basic (no-handle)
[269.643831] Starting subtest: no-handle
[269.649270] Subtest no-handle: SUCCESS (0.000s)
[270.061279] [084/161] (864s left) kms_addfb_basic (size-max)
[270.564177] Starting subtest: size-max
[270.568294] Subtest size-max: SUCCESS (0.001s)
[270.956176] [085/161] (864s left) kms_addfb_basic (small-bo)
[271.466304] Starting subtest: small-bo
[271.471879] Subtest small-bo: SUCCESS (0.000s)
[271.822172] [086/161] (863s left) kms_addfb_basic (tile-pitch-mismatch)
[272.281336] Starting subtest: tile-pitch-mismatch
[272.285636] Subtest tile-pitch-mismatch: SUCCESS (0.003s)
[272.700759] [087/161] (863s left) kms_addfb_basic (too-high)
[273.196336] Starting subtest: too-high
[273.202272] Subtest too-high: SUCCESS (0.006s)
[273.584980] [088/161] (862s left) kms_addfb_basic (too-wide)
[274.097222] Starting subtest: too-wide
[274.101456] Subtest too-wide: SUCCESS (0.000s)
[274.496349] [089/161] (862s left) kms_addfb_basic (unused-handle)
[274.950331] Starting subtest: unused-handle
[274.955322] Subtest unused-handle: SUCCESS (0.000s)
[275.375324] [090/161] (861s left) kms_addfb_basic (unused-modifier)
[275.828768] Starting subtest: unused-modifier
[275.833799] Subtest unused-modifier: SUCCESS (0.000s)
[276.226354] [091/161] (861s left) kms_addfb_basic (unused-offsets)
[276.677314] Starting subtest: unused-offsets
[276.682593] Subtest unused-offsets: SUCCESS (0.000s)
[277.113562] [092/161] (860s left) kms_addfb_basic (unused-pitches)
[277.569721] Starting subtest: unused-pitches
[277.573568] Subtest unused-pitches: SUCCESS (0.000s)
[277.995467] [093/161] (859s left) kms_busy (basic)
[278.514232] Starting subtest: basic
[278.526888] Starting dynamic subtest: flip
[279.536070] Dynamic subtest flip: SUCCESS (1.014s)
[279.589273] Starting dynamic subtest: modeset
[279.597320] Dynamic subtest modeset: SKIP (0.000s)
[279.601602] Subtest basic: SUCCESS (1.029s)
[280.062269] [094/161] (858s left) kms_prop_blob (basic)
[280.517715] Starting subtest: basic
[280.523632] Subtest basic: SUCCESS (0.000s)
[280.871222] [095/161] (857s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[281.381674] Starting subtest: basic-busy-flip-before-cursor-atomic
[281.403689] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.017s)
[281.760175] [096/161] (857s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[282.260822] Starting subtest: basic-busy-flip-before-cursor-legacy
[283.374156] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.108s)
[283.934834] [097/161] (855s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[284.425369] Starting subtest: basic-flip-after-cursor-atomic
[284.435318] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[284.799612] [098/161] (854s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[285.312247] Starting subtest: basic-flip-after-cursor-legacy
[286.415268] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.105s)
[286.929410] [099/161] (852s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[287.436325] Starting subtest: basic-flip-after-cursor-varying-size
[288.525338] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.089s)
[289.035972] [100/161] (851s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[289.541578] Starting subtest: basic-flip-before-cursor-atomic
[289.549474] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[289.912717] [101/161] (850s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[290.406725] Starting subtest: basic-flip-before-cursor-legacy
[291.493493] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.085s)
[292.004748] [102/161] (848s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[292.487970] Starting subtest: basic-flip-before-cursor-varying-size
[293.574523] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.088s)
[294.092322] [103/161] (847s left) kms_dsc (dsc-basic)
[294.600082] Subtest dsc-basic: SKIP (0.000s)
[294.964749] [104/161] (846s left) kms_flip (basic-flip-vs-dpms)
[295.480350] Starting subtest: basic-flip-vs-dpms
[295.485552] Starting dynamic subtest: A-VGA1
[297.158532] Dynamic subtest A-VGA1: SUCCESS (1.671s)
[297.213689] Starting dynamic subtest: B-VGA1
[298.765197] Dynamic subtest B-VGA1: SUCCESS (1.591s)
[298.773967] Subtest basic-flip-vs-dpms: SUCCESS (3.274s)
[299.445696] [105/161] (842s left) kms_flip (basic-flip-vs-modeset)
[299.965913] Starting subtest: basic-flip-vs-modeset
[299.972153] Starting dynamic subtest: A-VGA1
[301.642619] Dynamic subtest A-VGA1: SUCCESS (1.675s)
[301.693333] Starting dynamic subtest: B-VGA1
[303.149529] Dynamic subtest B-VGA1: SUCCESS (1.498s)
[303.155606] Subtest basic-flip-vs-modeset: SUCCESS (3.186s)
[303.762805] [106/161] (838s left) kms_flip (basic-flip-vs-wf_vblank)
[304.272445] Starting subtest: basic-flip-vs-wf_vblank
[304.278445] Starting dynamic subtest: A-VGA1
[306.117934] Dynamic subtest A-VGA1: SUCCESS (1.841s)
[306.167758] Starting dynamic subtest: B-VGA1
[307.867409] Dynamic subtest B-VGA1: SUCCESS (1.736s)
[307.871491] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.590s)
[308.541683] [107/161] (833s left) kms_flip (basic-plain-flip)
[309.031080] Starting subtest: basic-plain-flip
[309.036766] Starting dynamic subtest: A-VGA1
[310.570856] Dynamic subtest A-VGA1: SUCCESS (1.537s)
[310.625989] Starting dynamic subtest: B-VGA1
[312.014534] Dynamic subtest B-VGA1: SUCCESS (1.434s)
[312.019397] Subtest basic-plain-flip: SUCCESS (2.982s)
[312.705900] [108/161] (830s left) kms_force_connector_basic (force-connector-state)
[313.235802] Starting subtest: force-connector-state
[313.649242] Subtest force-connector-state: SUCCESS (0.391s)
[314.429293] [109/161] (828s left) kms_force_connector_basic (force-edid)
[315.029948] Starting subtest: force-edid
[315.178526] Subtest force-edid: SUCCESS (0.152s)
[315.829968] [110/161] (827s left) kms_force_connector_basic (force-load-detect)
[316.383806] Starting subtest: force-load-detect
[316.875494] Subtest force-load-detect: SUCCESS (0.488s)
[317.482728] [111/161] (826s left) kms_force_connector_basic (prune-stale-modes)
[318.058627] Starting subtest: prune-stale-modes
[318.160666] Subtest prune-stale-modes: SUCCESS (0.115s)
[318.607092] [112/161] (825s left) kms_frontbuffer_tracking (basic)
[319.124104] Subtest basic: SKIP (0.000s)
[319.487458] [113/161] (825s left) kms_hdmi_inject (inject-audio)
[319.939241] Subtest inject-audio: SKIP (0.000s)
[320.262307] [114/161] (824s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[320.768173] Starting subtest: compare-crc-sanitycheck-xr24
[320.777099] Starting dynamic subtest: pipe-A-VGA-1
[321.165909] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.390s)
[321.233285] Starting dynamic subtest: pipe-B-VGA-1
[321.694470] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.514s)
[321.701084] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.922s)
[322.208323] [115/161] (823s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[322.706747] Starting subtest: compare-crc-sanitycheck-nv12
[322.714062] Starting dynamic subtest: pipe-A-VGA-1
[322.725312] Dynamic subtest pipe-A-VGA-1: SKIP (0.001s)
[322.775794] Starting dynamic subtest: pipe-B-VGA-1
[322.782338] Dynamic subtest pipe-B-VGA-1: SKIP (0.001s)
[322.792257] Subtest compare-crc-sanitycheck-nv12: SKIP (0.019s)
[323.095959] [116/161] (822s left) kms_pipe_crc_basic (hang-read-crc)
[323.592888] Starting subtest: hang-read-crc
[323.597959] Starting dynamic subtest: pipe-A-VGA-1
[324.936720] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.334s)
[325.000628] Starting dynamic subtest: pipe-B-VGA-1
[326.367495] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.426s)
[326.374152] Subtest hang-read-crc: SUCCESS (2.778s)
[326.866820] [117/161] (819s left) kms_pipe_crc_basic (nonblocking-crc)
[327.384267] Starting subtest: nonblocking-crc
[327.389487] Starting dynamic subtest: pipe-A-VGA-1
[327.980473] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.591s)
[328.088365] Starting dynamic subtest: pipe-B-VGA-1
[328.712400] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.720s)
[328.717609] Subtest nonblocking-crc: SUCCESS (1.332s)
[329.230316] [118/161] (817s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[329.735112] Starting subtest: nonblocking-crc-frame-sequence
[329.745889] Starting dynamic subtest: pipe-A-VGA-1
[330.351426] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.603s)
[330.412471] Starting dynamic subtest: pipe-B-VGA-1
[331.068398] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.709s)
[331.073868] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.331s)
[331.561542] [119/161] (815s left) kms_pipe_crc_basic (read-crc)
[332.072786] Starting subtest: read-crc
[332.087201] Starting dynamic subtest: pipe-A-VGA-1
[332.603960] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.521s)
[332.676493] Starting dynamic subtest: pipe-B-VGA-1
[333.245609] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.633s)
[333.251717] Subtest read-crc: SUCCESS (1.172s)
[333.779730] [120/161] (813s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[334.293371] Starting subtest: read-crc-frame-sequence
[334.298660] Starting dynamic subtest: pipe-A-VGA-1
[334.840132] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.534s)
[334.901823] Starting dynamic subtest: pipe-B-VGA-1
[335.476116] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.631s)
[335.481567] Subtest read-crc-frame-sequence: SUCCESS (1.184s)
[335.964513] [121/161] (811s left) kms_pm_backlight (basic-brightness)
[336.472569] Subtest basic-brightness: SKIP (0.000s)
[336.809721] [122/161] (810s left) kms_pm_rpm (basic-pci-d3-state)
[348.728369] Subtest basic-pci-d3-state: SKIP (0.000s)
[349.050764] [123/161] (798s left) kms_pm_rpm (basic-rte)
[349.484308] Starting subtest: basic-rte
[360.979222] Subtest basic-rte: SKIP (11.485s)
[361.306318] [124/161] (786s left) kms_psr (psr-primary-page-flip)
[361.820724] Subtest psr-primary-page-flip: SKIP (0.000s)
[362.135233] [125/161] (786s left) kms_psr (psr-cursor-plane-move)
[362.651446] Subtest psr-cursor-plane-move: SKIP (0.000s)
[362.991894] [126/161] (785s left) kms_psr (psr-sprite-plane-onoff)
[363.484648] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[363.805216] [127/161] (785s left) kms_psr (psr-primary-mmap-gtt)
[364.301333] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[364.640700] [128/161] (784s left) kms_setmode (basic-clone-single-crtc)
[365.095472] Starting subtest: basic-clone-single-crtc
[365.109393] Subtest basic-clone-single-crtc: SKIP (0.001s)
[365.445845] [129/161] (784s left) i915_pm_rps (basic-api)
[365.936546] Subtest basic-api: SKIP (0.000s)
[366.306295] [130/161] (783s left) prime_self_import (basic-llseek-bad)
[366.756562] Starting subtest: basic-llseek-bad
[366.774691] Subtest basic-llseek-bad: SUCCESS (0.015s)
[367.131743] [131/161] (783s left) prime_self_import (basic-llseek-size)
[367.580367] Starting subtest: basic-llseek-size
[367.605530] Subtest basic-llseek-size: SUCCESS (0.033s)
[367.964293] [132/161] (782s left) prime_self_import (basic-with_fd_dup)
[368.400230] Starting subtest: basic-with_fd_dup
[368.419497] Subtest basic-with_fd_dup: SUCCESS (0.019s)
[368.778421] [133/161] (782s left) prime_self_import (basic-with_one_bo)
[369.215742] Starting subtest: basic-with_one_bo
[369.239331] Subtest basic-with_one_bo: SUCCESS (0.024s)
[369.596734] [134/161] (781s left) prime_self_import (basic-with_one_bo_two_files)
[370.026621] Starting subtest: basic-with_one_bo_two_files
[370.045437] Subtest basic-with_one_bo_two_files: SUCCESS (0.017s)
[370.402599] [135/161] (781s left) prime_self_import (basic-with_two_bos)
[370.834264] Starting subtest: basic-with_two_bos
[370.853795] Subtest basic-with_two_bos: SUCCESS (0.023s)
[371.220153] [136/161] (780s left) prime_vgem (basic-fence-flip)
[371.713511] Starting subtest: basic-fence-flip
[372.386751] Subtest basic-fence-flip: SUCCESS (0.671s)
[372.771824] [137/161] (779s left) prime_vgem (basic-fence-mmap)
[373.252636] Starting subtest: basic-fence-mmap
[373.537259] Subtest basic-fence-mmap: SUCCESS (0.283s)
[373.904101] [138/161] (778s left) prime_vgem (basic-fence-read)
[374.384577] Starting subtest: basic-fence-read
[374.646562] Subtest basic-fence-read: SUCCESS (0.268s)
[375.010356] [139/161] (778s left) prime_vgem (basic-gtt)
[375.479821] Starting subtest: basic-gtt
[375.562988] Subtest basic-gtt: SUCCESS (0.081s)
[375.937795] [140/161] (777s left) prime_vgem (basic-read)
[376.405245] Starting subtest: basic-read
[376.523672] Subtest basic-read: SUCCESS (0.121s)
[376.886745] [141/161] (776s left) prime_vgem (basic-write)
[377.371949] Starting subtest: basic-write
[377.483108] Subtest basic-write: SUCCESS (0.117s)
[377.854247] [142/161] (776s left) vgem_basic (setversion)
[378.314116] Starting subtest: setversion
[378.323381] Subtest setversion: SUCCESS (0.000s)
[378.658915] [143/161] (775s left) vgem_basic (create)
[379.111599] Starting subtest: create
[379.117395] Subtest create: SUCCESS (0.002s)
[379.459835] [144/161] (775s left) vgem_basic (debugfs)
[379.896966] Starting subtest: debugfs
[379.902476] Subtest debugfs: SUCCESS (0.004s)
[380.239240] [145/161] (774s left) vgem_basic (dmabuf-export)
[380.694327] Starting subtest: dmabuf-export
[380.712828] Subtest dmabuf-export: SUCCESS (0.014s)
[381.059502] [146/161] (774s left) vgem_basic (dmabuf-fence)
[381.511380] Starting subtest: dmabuf-fence
[381.517301] Subtest dmabuf-fence: SUCCESS (0.005s)
[381.881316] [147/161] (773s left) vgem_basic (dmabuf-fence-before)
[382.349952] Starting subtest: dmabuf-fence-before
[382.355362] Subtest dmabuf-fence-before: SUCCESS (0.004s)
[382.694165] [148/161] (773s left) vgem_basic (dmabuf-mmap)
[383.160194] Starting subtest: dmabuf-mmap
[383.243880] Subtest dmabuf-mmap: SUCCESS (0.085s)
[383.587799] [149/161] (772s left) vgem_basic (mmap)
[384.051175] Starting subtest: mmap
[384.108842] Subtest mmap: SUCCESS (0.065s)
[384.460842] [150/161] (772s left) vgem_basic (second-client)
[384.917457] Starting subtest: second-client
[384.944584] Subtest second-client: SUCCESS (0.033s)
[385.291135] [151/161] (771s left) vgem_basic (sysfs)
[385.749879] Starting subtest: sysfs
[385.754420] Subtest sysfs: SUCCESS (0.005s)
[386.093536] [152/161] (771s left) core_hotunplug (unbind-rebind)
[386.848190] Starting subtest: unbind-rebind
[392.966727] Subtest unbind-rebind: SUCCESS (6.111s)
[393.287413] [153/161] (764s left) vgem_basic (unload)
[393.745502] Starting subtest: unload
[423.436494] Subtest unload: SUCCESS (29.696s)
[423.957492] [154/161] (733s left) i915_module_load (reload)
[424.394701] Starting subtest: reload
[434.512865] Subtest reload: SUCCESS (10.114s)
[435.340556] [155/161] (723s left) gem_lmem_swapping (basic)
[436.036846] Subtest basic: SKIP (0.000s)
[436.366654] [156/161] (722s left) gem_lmem_swapping (parallel-random-engines)
[436.844451] Subtest parallel-random-engines: SKIP (0.000s)
[437.166834] [157/161] (722s left) gem_lmem_swapping (random-engines)
[437.634412] Subtest random-engines: SKIP (0.000s)
[437.950282] [158/161] (721s left) gem_lmem_swapping (verify-random)
[438.419372] Subtest verify-random: SKIP (0.000s)
[438.752314] [159/161] (721s left) i915_pm_rpm (module-reload)
[450.682281] Subtest module-reload: SKIP (0.000s)
[451.010734] [160/161] (709s left) i915_selftest (live)
[453.962945] Starting subtest: live
[453.966823] Starting dynamic subtest: sanitycheck
[461.415969] Dynamic subtest sanitycheck: SUCCESS (7.452s)
[461.477863] Starting dynamic subtest: uncore
[468.862304] Dynamic subtest uncore: SUCCESS (7.442s)
[468.922910] Starting dynamic subtest: workarounds
[476.154899] Dynamic subtest workarounds: SUCCESS (7.288s)
[476.214586] Starting dynamic subtest: gt_engines
[483.666574] Dynamic subtest gt_engines: SUCCESS (7.503s)
[483.743845] Starting dynamic subtest: gt_timelines
[497.197090] Dynamic subtest gt_timelines: SUCCESS (13.529s)
[497.245392] Starting dynamic subtest: gt_contexts
[504.552516] Dynamic subtest gt_contexts: SUCCESS (7.349s)
[504.593522] Starting dynamic subtest: gt_lrc
[511.911974] Dynamic subtest gt_lrc: SUCCESS (7.356s)
[511.971972] Starting dynamic subtest: gt_mocs
[519.277758] Dynamic subtest gt_mocs: SUCCESS (7.361s)
[519.328515] Starting dynamic subtest: gt_pm
[527.005533] Dynamic subtest gt_pm: SUCCESS (7.720s)
[527.055518] Starting dynamic subtest: gt_heartbeat
[534.328734] Dynamic subtest gt_heartbeat: SUCCESS (7.319s)
[534.381306] Starting dynamic subtest: gt_tlb
[541.731181] Dynamic subtest gt_tlb: SUCCESS (7.397s)
[541.787383] Starting dynamic subtest: requests
[551.672711] Dynamic subtest requests: SUCCESS (9.935s)
[551.723856] Starting dynamic subtest: migrate
[558.993333] Dynamic subtest migrate: SUCCESS (7.315s)
[559.041614] Starting dynamic subtest: active
[566.342992] Dynamic subtest active: SUCCESS (7.342s)
[566.421426] Starting dynamic subtest: objects
[574.589979] Dynamic subtest objects: SUCCESS (8.242s)
[574.641362] Starting dynamic subtest: mman
[589.416614] Dynamic subtest mman: SUCCESS (14.821s)
[589.495952] Starting dynamic subtest: dmabuf
[596.964361] Dynamic subtest dmabuf: SUCCESS (7.540s)
[597.039766] Starting dynamic subtest: vma
[604.522630] Dynamic subtest vma: SUCCESS (7.554s)
[604.568153] Starting dynamic subtest: coherency
[617.560576] Dynamic subtest coherency: SUCCESS (13.032s)
[617.649457] Starting dynamic subtest: gtt
[628.052603] Dynamic subtest gtt: SUCCESS (10.485s)
[628.128397] Starting dynamic subtest: gem
[635.701454] Dynamic subtest gem: SUCCESS (7.644s)
[635.749623] Starting dynamic subtest: evict
[643.128254] Dynamic subtest evict: SUCCESS (7.416s)
[643.186881] Starting dynamic subtest: hugepages
[650.649870] Dynamic subtest hugepages: SUCCESS (7.519s)
[650.692933] Starting dynamic subtest: gem_contexts
[658.046275] Dynamic subtest gem_contexts: SUCCESS (7.392s)
[658.093847] Starting dynamic subtest: client
[665.560789] Dynamic subtest client: SUCCESS (7.508s)
[665.614114] Starting dynamic subtest: gem_migrate
[673.134134] Dynamic subtest gem_migrate: SUCCESS (7.562s)
[673.194359] Starting dynamic subtest: reset
[683.372302] Dynamic subtest reset: SUCCESS (10.235s)
[683.443197] Starting dynamic subtest: memory_region
[690.801584] Dynamic subtest memory_region: SUCCESS (7.423s)
[690.844649] Starting dynamic subtest: hangcheck
[700.631456] Dynamic subtest hangcheck: SUCCESS (9.825s)
[700.680721] Starting dynamic subtest: execlists
[707.980283] Dynamic subtest execlists: SUCCESS (7.343s)
[708.028493] Starting dynamic subtest: ring_submission
[715.320280] Dynamic subtest ring_submission: SUCCESS (7.331s)
[715.416332] Starting dynamic subtest: perf
[722.657442] Dynamic subtest perf: SUCCESS (7.331s)
[722.758527] Starting dynamic subtest: slpc
[730.023761] Dynamic subtest slpc: SUCCESS (7.360s)
[730.119826] Starting dynamic subtest: guc
[737.451593] Dynamic subtest guc: SUCCESS (7.418s)
[737.501384] Starting dynamic subtest: guc_multi_lrc
[744.894401] Dynamic subtest guc_multi_lrc: SUCCESS (7.435s)
[744.948430] Starting dynamic subtest: guc_hang
[752.231541] Dynamic subtest guc_hang: SUCCESS (7.332s)
[752.282159] Starting dynamic subtest: late_gt_pm
[759.540132] Dynamic subtest late_gt_pm: SUCCESS (7.299s)
[759.546613] Subtest live: SUCCESS (305.578s)
[759.789224] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[759.800143] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[759.811953] [161/161] (400s left) dmabuf (all-tests)
[760.275350] Starting subtest: all-tests
[760.280209] Starting dynamic subtest: sanitycheck
[760.398428] Dynamic subtest sanitycheck: SUCCESS (0.130s)
[760.459847] Starting dynamic subtest: dma_fence
[760.690443] Dynamic subtest dma_fence: SUCCESS (0.285s)
[760.747770] Starting dynamic subtest: dma_fence_chain