[106.809457] Initializing watchdogs
[106.810349]   /dev/watchdog0
[106.981977] [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)
[107.030868] [001/161] (960s left) i915_module_load (load)
[108.810920] Starting subtest: load
[117.198273] Subtest load: SUCCESS (8.389s)
[117.653904] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[117.668478] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[117.696428] [002/161] (950s left) core_auth (basic-auth)
[118.311502] Starting subtest: basic-auth
[118.315873] Subtest basic-auth: SUCCESS (0.004s)
[118.648614] [003/161] (949s left) debugfs_test (read_all_entries)
[119.206453] Starting subtest: read_all_entries
[119.432536] Subtest read_all_entries: SUCCESS (0.224s)
[119.830462] [004/161] (948s left) debugfs_test (basic-hwmon)
[120.357213] Starting subtest: basic-hwmon
[120.366630] Subtest basic-hwmon: SKIP (0.000s)
[120.724330] [005/161] (948s left) debugfs_test (sysfs)
[121.244658] Starting subtest: sysfs
[121.470619] Subtest sysfs: SUCCESS (0.229s)
[122.026493] [006/161] (947s left) fbdev (eof)
[122.568287] Starting subtest: eof
[122.573461] Subtest eof: SUCCESS (0.006s)
[122.896581] [007/161] (946s left) fbdev (info)
[123.379499] Starting subtest: info
[123.386951] Subtest info: SUCCESS (0.000s)
[123.746590] [008/161] (946s left) fbdev (nullptr)
[124.298444] Starting subtest: nullptr
[124.303357] Subtest nullptr: SUCCESS (0.001s)
[124.636351] [009/161] (945s left) fbdev (read)
[125.097200] Starting subtest: read
[125.438193] Subtest read: SUCCESS (0.342s)
[125.855466] [010/161] (944s left) fbdev (write)
[126.380317] Starting subtest: write
[126.599276] Subtest write: SUCCESS (0.219s)
[126.931902] [011/161] (943s left) gem_basic (bad-close)
[127.439187] Starting subtest: bad-close
[127.451173] Subtest bad-close: SUCCESS (0.000s)
[127.787775] [012/161] (943s left) gem_basic (create-close)
[128.296176] Starting subtest: create-close
[128.315947] Subtest create-close: SUCCESS (0.001s)
[128.652608] [013/161] (942s left) gem_basic (create-fd-close)
[129.139319] Starting subtest: create-fd-close
[129.155347] Subtest create-fd-close: SUCCESS (0.001s)
[129.524681] [014/161] (942s left) gem_busy (busy@all-engines)
[130.134085] Starting subtest: busy
[130.137788] Starting dynamic subtest: all-engines
[130.276590] Dynamic subtest all-engines: SUCCESS (0.144s)
[130.280995] Subtest busy: SUCCESS (0.150s)
[131.176549] [015/161] (941s left) gem_close_race (basic-process)
[131.899391] Starting subtest: basic-process
[132.138926] Subtest basic-process: SUCCESS (0.251s)
[132.675422] [016/161] (939s left) gem_close_race (basic-threads)
[133.342763] Starting subtest: basic-threads
[135.216057] Subtest basic-threads: SUCCESS (1.871s)
[135.682246] [017/161] (937s left) gem_ctx_create (basic)
[136.188997] Subtest basic: SKIP (0.000s)
[136.564362] [018/161] (936s left) gem_ctx_create (basic-files)
[137.085303] Subtest basic-files: SKIP (0.000s)
[137.421999] [019/161] (936s left) gem_ctx_exec (basic)
[137.910874] Subtest basic: SKIP (0.000s)
[138.231431] [020/161] (935s left) gem_exec_basic (basic)
[138.762176] Starting subtest: basic
[138.766612] Starting dynamic subtest: rcs0-smem
[138.770768] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[138.774168] Subtest basic: SUCCESS (0.009s)
[139.277728] [021/161] (934s left) gem_exec_create (basic)
[139.873849] Starting subtest: basic
[139.882346] Starting dynamic subtest: smem
[142.062318] Dynamic subtest smem: SUCCESS (2.187s)
[142.066178] Subtest basic: SUCCESS (2.190s)
[142.519153] [022/161] (931s left) gem_exec_fence (basic-busy)
[143.378390] Starting subtest: basic-busy
[143.385149] Starting dynamic subtest: rcs0
[143.433716] Dynamic subtest rcs0: SUCCESS (0.053s)
[143.447078] Subtest basic-busy: SUCCESS (0.064s)
[144.671535] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[144.685729] [023/161] (929s left) gem_exec_fence (basic-wait)
[145.553593] Starting subtest: basic-wait
[145.558767] Starting dynamic subtest: rcs0
[145.609848] Dynamic subtest rcs0: SUCCESS (0.054s)
[145.613466] Subtest basic-wait: SUCCESS (0.059s)
[146.636760] [024/161] (928s left) gem_exec_fence (basic-await)
[147.481498] Starting subtest: basic-await
[147.486163] Starting dynamic subtest: rcs0
[147.643427] Dynamic subtest rcs0: SUCCESS (0.161s)
[147.649814] Subtest basic-await: SUCCESS (0.169s)
[148.632933] [025/161] (926s left) gem_exec_fence (nb-await)
[149.387272] Starting subtest: nb-await
[149.391992] Starting dynamic subtest: rcs0
[149.455818] Dynamic subtest rcs0: SUCCESS (0.068s)
[149.460103] Subtest nb-await: SUCCESS (0.074s)
[150.485181] [026/161] (925s left) gem_exec_gttfill (basic)
[151.036657] Starting subtest: basic
[161.400740] Subtest basic: SUCCESS (10.364s)
[161.994340] [027/161] (914s left) gem_exec_parallel (engines)
[162.847104] Starting subtest: engines
[162.850856] Starting dynamic subtest: basic
[167.496392] Dynamic subtest basic: SUCCESS (4.654s)
[167.556291] Starting dynamic subtest: contexts
[167.574431] Dynamic subtest contexts: SKIP (0.004s)
[167.628943] Starting dynamic subtest: fds
[167.636694] Dynamic subtest fds: SKIP (0.004s)
[167.676644] Starting dynamic subtest: userptr
[172.016237] Dynamic subtest userptr: SUCCESS (4.501s)
[172.021593] Subtest engines: SUCCESS (9.175s)
[172.540835] [028/161] (903s left) gem_exec_store (basic)
[173.100378] Starting subtest: basic
[173.146437] Subtest basic: SUCCESS (0.052s)
[173.676245] [029/161] (903s left) gem_flink_basic (bad-flink)
[174.152972] Starting subtest: bad-flink
[174.156846] Subtest bad-flink: SUCCESS (0.000s)
[174.516853] [030/161] (902s left) gem_flink_basic (bad-open)
[174.990968] Starting subtest: bad-open
[174.996811] Subtest bad-open: SUCCESS (0.000s)
[175.384554] [031/161] (902s left) gem_flink_basic (basic)
[175.869548] Starting subtest: basic
[175.874393] Subtest basic: SUCCESS (0.001s)
[176.238223] [032/161] (901s left) gem_flink_basic (double-flink)
[176.705551] Starting subtest: double-flink
[176.710306] Subtest double-flink: SUCCESS (0.001s)
[177.064564] [033/161] (901s left) gem_flink_basic (flink-lifetime)
[177.510254] Starting subtest: flink-lifetime
[177.524907] Subtest flink-lifetime: SUCCESS (0.010s)
[177.889315] [034/161] (900s left) gem_huc_copy (huc-copy)
[178.364514] Subtest huc-copy: SKIP (0.000s)
[178.690520] [035/161] (900s left) gem_linear_blits (basic)
[179.482745] Starting subtest: basic
[179.543420] Subtest basic: SUCCESS (0.056s)
[180.006711] [036/161] (899s left) gem_mmap (basic)
[180.734813] Starting subtest: basic
[180.773532] Subtest basic: SUCCESS (0.003s)
[181.116273] [037/161] (898s left) gem_mmap_gtt (basic)
[181.647451] Starting subtest: basic
[181.652749] Subtest basic: SUCCESS (0.005s)
[181.996882] [038/161] (897s left) gem_render_linear_blits (basic)
[182.467801] Starting subtest: basic
[182.622900] Subtest basic: SUCCESS (0.154s)
[182.953860] [039/161] (897s left) gem_render_tiled_blits (basic)
[183.443696] Starting subtest: basic
[183.616390] Subtest basic: SUCCESS (0.168s)
[183.975724] [040/161] (896s left) gem_ringfill (basic-all)
[184.603378] Starting subtest: basic-all
[185.836905] Subtest basic-all: SUCCESS (1.228s)
[186.207288] [041/161] (894s left) gem_softpin (allocator-basic)
[186.745544] Subtest allocator-basic: SKIP (0.000s)
[187.102203] [042/161] (893s left) gem_softpin (allocator-basic-reserve)
[187.590581] Subtest allocator-basic-reserve: SKIP (0.000s)
[187.957946] [043/161] (893s left) gem_softpin (safe-alignment)
[188.440720] Starting subtest: safe-alignment
[188.461240] Subtest safe-alignment: SUCCESS (0.026s)
[188.816975] [044/161] (892s left) gem_sync (basic-all)
[189.362219] Starting subtest: basic-all
[191.813849] Subtest basic-all: SUCCESS (2.451s)
[192.326942] [045/161] (889s left) gem_sync (basic-each)
[192.892217] Starting subtest: basic-each
[195.204417] Subtest basic-each: SUCCESS (2.316s)
[195.700754] [046/161] (886s left) gem_tiled_blits (basic)
[196.679686] Starting subtest: basic
[196.793483] Subtest basic: SUCCESS (0.123s)
[197.260454] [047/161] (885s left) gem_tiled_fence_blits (basic)
[198.413917] Starting subtest: basic
[198.486749] Subtest basic: SUCCESS (0.073s)
[198.965363] [048/161] (884s left) gem_tiled_pread_basic
[202.057156] [049/161] (881s left) gem_wait (busy@all-engines)
[202.703367] Starting subtest: busy
[202.708752] Starting dynamic subtest: all-engines
[203.250413] Dynamic subtest all-engines: SUCCESS (0.546s)
[203.254857] Subtest busy: SUCCESS (0.552s)
[203.928781] [050/161] (879s left) gem_wait (wait@all-engines)
[204.553697] Starting subtest: wait
[204.558781] Starting dynamic subtest: all-engines
[205.603157] Dynamic subtest all-engines: SUCCESS (1.050s)
[205.607830] Subtest wait: SUCCESS (1.053s)
[206.293977] [051/161] (877s left) i915_getparams_basic (basic-eu-total)
[206.757241] Starting subtest: basic-eu-total
[206.769739] Subtest basic-eu-total: SUCCESS (0.000s)
[207.120844] [052/161] (877s left) i915_getparams_basic (basic-subslice-total)
[207.589446] Starting subtest: basic-subslice-total
[207.599699] Subtest basic-subslice-total: SUCCESS (0.000s)
[207.956757] [053/161] (876s left) i915_hangman (error-state-basic)
[208.468814] Starting subtest: error-state-basic
[208.900429] Subtest error-state-basic: SUCCESS (0.437s)
[209.276970] [054/161] (875s left) i915_pciid
[210.171187] [055/161] (875s left) kms_addfb_basic (addfb25-4-tiled)
[210.720791] Starting subtest: addfb25-4-tiled
[210.726282] Subtest addfb25-4-tiled: SUCCESS (0.003s)
[211.130359] [056/161] (874s left) kms_addfb_basic (addfb25-bad-modifier)
[211.730958] Starting subtest: addfb25-bad-modifier
[211.737972] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[212.120681] [057/161] (874s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[212.655809] Starting subtest: addfb25-framebuffer-vs-set-tiling
[212.663311] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.004s)
[213.049178] [058/161] (873s left) kms_addfb_basic (addfb25-modifier-no-flag)
[213.571349] Starting subtest: addfb25-modifier-no-flag
[213.574994] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[213.971592] [059/161] (872s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[214.518722] Starting subtest: addfb25-x-tiled-legacy
[214.523853] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[214.964379] [060/161] (872s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[215.507152] Starting subtest: addfb25-x-tiled-mismatch-legacy
[215.514544] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s)
[216.011903] [061/161] (871s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[216.547629] Starting subtest: addfb25-yf-tiled-legacy
[216.553999] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[216.979370] [062/161] (871s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[217.589804] Starting subtest: addfb25-y-tiled-legacy
[217.594553] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s)
[217.955448] [063/161] (870s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[218.486279] Starting subtest: addfb25-y-tiled-small-legacy
[218.498854] Subtest addfb25-y-tiled-small-legacy: SKIP (0.001s)
[218.880778] [064/161] (869s left) kms_addfb_basic (bad-pitch-0)
[219.366900] Starting subtest: bad-pitch-0
[219.372239] Subtest bad-pitch-0: SUCCESS (0.000s)
[219.808436] [065/161] (869s left) kms_addfb_basic (bad-pitch-1024)
[220.301816] Starting subtest: bad-pitch-1024
[220.306766] Subtest bad-pitch-1024: SUCCESS (0.000s)
[220.766544] [066/161] (868s left) kms_addfb_basic (bad-pitch-128)
[221.246574] Starting subtest: bad-pitch-128
[221.251560] Subtest bad-pitch-128: SUCCESS (0.000s)
[221.722713] [067/161] (868s left) kms_addfb_basic (bad-pitch-256)
[222.225748] Starting subtest: bad-pitch-256
[222.229311] Subtest bad-pitch-256: SUCCESS (0.000s)
[222.789590] [068/161] (867s left) kms_addfb_basic (bad-pitch-32)
[223.299527] Starting subtest: bad-pitch-32
[223.304732] Subtest bad-pitch-32: SUCCESS (0.000s)
[223.744190] [069/161] (866s left) kms_addfb_basic (bad-pitch-63)
[224.277616] Starting subtest: bad-pitch-63
[224.281957] Subtest bad-pitch-63: SUCCESS (0.000s)
[224.711501] [070/161] (866s left) kms_addfb_basic (bad-pitch-65536)
[225.191877] Starting subtest: bad-pitch-65536
[225.195962] Subtest bad-pitch-65536: SUCCESS (0.002s)
[225.688845] [071/161] (865s left) kms_addfb_basic (bad-pitch-999)
[226.176350] Starting subtest: bad-pitch-999
[226.179947] Subtest bad-pitch-999: SUCCESS (0.000s)
[226.715719] [072/161] (864s left) kms_addfb_basic (basic)
[227.193458] Starting subtest: basic
[227.197619] Subtest basic: SUCCESS (0.001s)
[227.693367] [073/161] (864s left) kms_addfb_basic (basic-x-tiled-legacy)
[228.178485] Starting subtest: basic-x-tiled-legacy
[228.183782] Subtest basic-x-tiled-legacy: SUCCESS (0.001s)
[228.639401] [074/161] (863s left) kms_addfb_basic (basic-y-tiled-legacy)
[229.143240] Starting subtest: basic-y-tiled-legacy
[229.149745] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[229.733738] [075/161] (863s left) kms_addfb_basic (bo-too-small)
[230.344867] Starting subtest: bo-too-small
[230.354440] Subtest bo-too-small: SUCCESS (0.002s)
[230.920885] [076/161] (862s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[231.481434] Starting subtest: bo-too-small-due-to-tiling
[231.486612] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[231.903350] [077/161] (861s left) kms_addfb_basic (clobberred-modifier)
[232.407292] Starting subtest: clobberred-modifier
[232.411734] Subtest clobberred-modifier: SUCCESS (0.001s)
[232.835561] [078/161] (861s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[233.310124] Starting subtest: framebuffer-vs-set-tiling
[233.315153] Subtest framebuffer-vs-set-tiling: SUCCESS (0.002s)
[233.778379] [079/161] (860s left) kms_addfb_basic (invalid-get-prop)
[234.261400] Starting subtest: invalid-get-prop
[234.265722] Subtest invalid-get-prop: SUCCESS (0.000s)
[234.689355] [080/161] (860s left) kms_addfb_basic (invalid-get-prop-any)
[235.188860] Starting subtest: invalid-get-prop-any
[235.194398] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[235.657596] [081/161] (859s left) kms_addfb_basic (invalid-set-prop)
[236.147422] Starting subtest: invalid-set-prop
[236.152322] Subtest invalid-set-prop: SUCCESS (0.000s)
[236.618485] [082/161] (858s left) kms_addfb_basic (invalid-set-prop-any)
[237.089446] Starting subtest: invalid-set-prop-any
[237.094638] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[237.528099] [083/161] (858s left) kms_addfb_basic (no-handle)
[238.021742] Starting subtest: no-handle
[238.027134] Subtest no-handle: SUCCESS (0.000s)
[238.474517] [084/161] (857s left) kms_addfb_basic (size-max)
[239.012587] Starting subtest: size-max
[239.017583] Subtest size-max: SUCCESS (0.002s)
[239.401226] [085/161] (857s left) kms_addfb_basic (small-bo)
[239.928489] Starting subtest: small-bo
[239.932251] Subtest small-bo: SUCCESS (0.000s)
[240.344859] [086/161] (856s left) kms_addfb_basic (tile-pitch-mismatch)
[240.856402] Starting subtest: tile-pitch-mismatch
[240.861583] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[241.350700] [087/161] (855s left) kms_addfb_basic (too-high)
[241.968257] Starting subtest: too-high
[241.973860] Subtest too-high: SUCCESS (0.006s)
[242.361815] [088/161] (855s left) kms_addfb_basic (too-wide)
[242.900801] Starting subtest: too-wide
[242.907679] Subtest too-wide: SUCCESS (0.000s)
[243.342696] [089/161] (854s left) kms_addfb_basic (unused-handle)
[243.802188] Starting subtest: unused-handle
[243.807500] Subtest unused-handle: SUCCESS (0.000s)
[244.394505] [090/161] (854s left) kms_addfb_basic (unused-modifier)
[244.868895] Starting subtest: unused-modifier
[244.873233] Subtest unused-modifier: SUCCESS (0.000s)
[245.350266] [091/161] (853s left) kms_addfb_basic (unused-offsets)
[245.843146] Starting subtest: unused-offsets
[245.848099] Subtest unused-offsets: SUCCESS (0.000s)
[246.263143] [092/161] (852s left) kms_addfb_basic (unused-pitches)
[246.746721] Starting subtest: unused-pitches
[246.752867] Subtest unused-pitches: SUCCESS (0.000s)
[247.182397] [093/161] (852s left) kms_busy (basic)
[247.711533] Starting subtest: basic
[247.716335] Starting dynamic subtest: flip
[248.823739] Dynamic subtest flip: SUCCESS (1.100s)
[248.880258] Starting dynamic subtest: modeset
[248.887639] Dynamic subtest modeset: SKIP (0.000s)
[248.891240] Subtest basic: SUCCESS (1.112s)
[249.383090] [094/161] (850s left) kms_prop_blob (basic)
[249.842768] Starting subtest: basic
[249.848087] Subtest basic: SUCCESS (0.000s)
[250.197142] [095/161] (849s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[250.721266] Starting subtest: basic-busy-flip-before-cursor-atomic
[250.740799] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.021s)
[251.173569] [096/161] (849s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[251.778684] Starting subtest: basic-busy-flip-before-cursor-legacy
[252.976192] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.195s)
[253.575921] [097/161] (847s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[254.092165] Starting subtest: basic-flip-after-cursor-atomic
[254.101693] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[254.493302] [098/161] (846s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[255.042529] Starting subtest: basic-flip-after-cursor-legacy
[256.142831] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.099s)
[256.788460] [099/161] (844s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[257.304857] Starting subtest: basic-flip-after-cursor-varying-size
[258.395104] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.089s)
[258.907278] [100/161] (843s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[259.404288] Starting subtest: basic-flip-before-cursor-atomic
[259.413089] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[259.799155] [101/161] (842s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[260.330157] Starting subtest: basic-flip-before-cursor-legacy
[261.427387] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.100s)
[262.012604] [102/161] (840s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[262.564464] Starting subtest: basic-flip-before-cursor-varying-size
[263.700249] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.133s)
[264.246656] [103/161] (838s left) kms_dsc (dsc-basic)
[264.795403] Subtest dsc-basic: SKIP (0.000s)
[265.177570] [104/161] (838s left) kms_flip (basic-flip-vs-dpms)
[265.729939] Starting subtest: basic-flip-vs-dpms
[265.737610] Starting dynamic subtest: A-VGA1
[267.470451] Dynamic subtest A-VGA1: SUCCESS (1.736s)
[267.539955] Starting dynamic subtest: B-VGA1
[269.135672] Dynamic subtest B-VGA1: SUCCESS (1.642s)
[269.140286] Subtest basic-flip-vs-dpms: SUCCESS (3.404s)
[269.845294] [105/161] (833s left) kms_flip (basic-flip-vs-modeset)
[270.373565] Starting subtest: basic-flip-vs-modeset
[270.378815] Starting dynamic subtest: A-VGA1
[272.023689] Dynamic subtest A-VGA1: SUCCESS (1.652s)
[272.079945] Starting dynamic subtest: B-VGA1
[273.622078] Dynamic subtest B-VGA1: SUCCESS (1.574s)
[273.626308] Subtest basic-flip-vs-modeset: SUCCESS (3.237s)
[274.303567] [106/161] (829s left) kms_flip (basic-flip-vs-wf_vblank)
[274.913737] Starting subtest: basic-flip-vs-wf_vblank
[274.918869] Starting dynamic subtest: A-VGA1
[276.791329] Dynamic subtest A-VGA1: SUCCESS (1.873s)
[276.847082] Starting dynamic subtest: B-VGA1
[278.582130] Dynamic subtest B-VGA1: SUCCESS (1.778s)
[278.586421] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.663s)
[279.339656] [107/161] (825s left) kms_flip (basic-plain-flip)
[279.881453] Starting subtest: basic-plain-flip
[279.894758] Starting dynamic subtest: A-VGA1
[281.459919] Dynamic subtest A-VGA1: SUCCESS (1.566s)
[281.513993] Starting dynamic subtest: B-VGA1
[282.928509] Dynamic subtest B-VGA1: SUCCESS (1.463s)
[282.944385] Subtest basic-plain-flip: SUCCESS (3.061s)
[283.740655] [108/161] (821s left) kms_force_connector_basic (force-connector-state)
[284.354400] Starting subtest: force-connector-state
[284.652801] Subtest force-connector-state: SUCCESS (0.296s)
[285.351717] [109/161] (819s left) kms_force_connector_basic (force-edid)
[285.955302] Starting subtest: force-edid
[286.073763] Subtest force-edid: SUCCESS (0.113s)
[286.677470] [110/161] (818s left) kms_force_connector_basic (force-load-detect)
[287.345406] Starting subtest: force-load-detect
[287.811243] Subtest force-load-detect: SUCCESS (0.465s)
[288.525266] [111/161] (817s left) kms_force_connector_basic (prune-stale-modes)
[289.147922] Starting subtest: prune-stale-modes
[289.254308] Subtest prune-stale-modes: SUCCESS (0.110s)
[289.790688] [112/161] (816s left) kms_frontbuffer_tracking (basic)
[290.363389] Subtest basic: SKIP (0.000s)
[290.750867] [113/161] (816s left) kms_hdmi_inject (inject-audio)
[291.225189] Subtest inject-audio: SKIP (0.000s)
[291.625182] [114/161] (815s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[292.238182] Starting subtest: compare-crc-sanitycheck-xr24
[292.244423] Starting dynamic subtest: pipe-A-VGA-1
[292.637246] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.392s)
[292.698734] Starting dynamic subtest: pipe-B-VGA-1
[293.209592] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.548s)
[293.218078] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.968s)
[293.985829] [115/161] (813s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[294.569802] Starting subtest: compare-crc-sanitycheck-nv12
[294.574720] Starting dynamic subtest: pipe-A-VGA-1
[294.586546] Dynamic subtest pipe-A-VGA-1: SKIP (0.001s)
[294.636650] Starting dynamic subtest: pipe-B-VGA-1
[294.644163] Dynamic subtest pipe-B-VGA-1: SKIP (0.002s)
[294.652695] Subtest compare-crc-sanitycheck-nv12: SKIP (0.021s)
[294.984399] [116/161] (813s left) kms_pipe_crc_basic (hang-read-crc)
[295.521361] Starting subtest: hang-read-crc
[295.526823] Starting dynamic subtest: pipe-A-VGA-1
[296.898113] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.373s)
[296.952102] Starting dynamic subtest: pipe-B-VGA-1
[298.397506] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.491s)
[298.402208] Subtest hang-read-crc: SUCCESS (2.883s)
[298.956912] [117/161] (809s left) kms_pipe_crc_basic (nonblocking-crc)
[299.486616] Starting subtest: nonblocking-crc
[299.499248] Starting dynamic subtest: pipe-A-VGA-1
[300.084613] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.591s)
[300.143721] Starting dynamic subtest: pipe-B-VGA-1
[300.847513] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.749s)
[300.851747] Subtest nonblocking-crc: SUCCESS (1.357s)
[301.506848] [118/161] (807s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[302.132627] Starting subtest: nonblocking-crc-frame-sequence
[302.136528] Starting dynamic subtest: pipe-A-VGA-1
[302.747552] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.609s)
[302.816742] Starting dynamic subtest: pipe-B-VGA-1
[303.518363] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.757s)
[303.524787] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.387s)
[304.059817] [119/161] (805s left) kms_pipe_crc_basic (read-crc)
[304.593484] Starting subtest: read-crc
[304.597701] Starting dynamic subtest: pipe-A-VGA-1
[305.158097] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.559s)
[305.229742] Starting dynamic subtest: pipe-B-VGA-1
[305.879328] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.716s)
[305.884867] Subtest read-crc: SUCCESS (1.293s)
[306.428804] [120/161] (803s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[306.996604] Starting subtest: read-crc-frame-sequence
[307.002198] Starting dynamic subtest: pipe-A-VGA-1
[307.577796] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.574s)
[307.686880] Starting dynamic subtest: pipe-B-VGA-1
[308.249895] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.663s)
[308.253522] Subtest read-crc-frame-sequence: SUCCESS (1.256s)
[308.815317] [121/161] (801s left) kms_pm_backlight (basic-brightness)
[309.372232] Subtest basic-brightness: SKIP (0.000s)
[309.704165] [122/161] (800s left) kms_pm_rpm (basic-pci-d3-state)
[321.721550] Subtest basic-pci-d3-state: SKIP (0.000s)
[322.100112] [123/161] (788s left) kms_pm_rpm (basic-rte)
[322.561700] Starting subtest: basic-rte
[334.082820] Subtest basic-rte: SKIP (11.514s)
[334.435962] [124/161] (776s left) kms_psr (psr-primary-page-flip)
[334.956719] Subtest psr-primary-page-flip: SKIP (0.000s)
[335.347538] [125/161] (776s left) kms_psr (psr-cursor-plane-move)
[335.902435] Subtest psr-cursor-plane-move: SKIP (0.000s)
[336.304174] [126/161] (775s left) kms_psr (psr-sprite-plane-onoff)
[336.834579] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[337.185228] [127/161] (775s left) kms_psr (psr-primary-mmap-gtt)
[337.716465] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[338.143375] [128/161] (774s left) kms_setmode (basic-clone-single-crtc)
[338.625610] Starting subtest: basic-clone-single-crtc
[338.638514] Subtest basic-clone-single-crtc: SKIP (0.001s)
[339.004710] [129/161] (773s left) i915_pm_rps (basic-api)
[339.486938] Subtest basic-api: SKIP (0.000s)
[339.834652] [130/161] (773s left) prime_self_import (basic-llseek-bad)
[340.294571] Starting subtest: basic-llseek-bad
[340.316253] Subtest basic-llseek-bad: SUCCESS (0.017s)
[340.675769] [131/161] (772s left) prime_self_import (basic-llseek-size)
[341.163826] Starting subtest: basic-llseek-size
[341.193066] Subtest basic-llseek-size: SUCCESS (0.034s)
[341.570754] [132/161] (772s left) prime_self_import (basic-with_fd_dup)
[342.021234] Starting subtest: basic-with_fd_dup
[342.042829] Subtest basic-with_fd_dup: SUCCESS (0.021s)
[342.416405] [133/161] (771s left) prime_self_import (basic-with_one_bo)
[342.878670] Starting subtest: basic-with_one_bo
[342.901555] Subtest basic-with_one_bo: SUCCESS (0.024s)
[343.293754] [134/161] (771s left) prime_self_import (basic-with_one_bo_two_files)
[343.766772] Starting subtest: basic-with_one_bo_two_files
[343.790138] Subtest basic-with_one_bo_two_files: SUCCESS (0.021s)
[344.162894] [135/161] (770s left) prime_self_import (basic-with_two_bos)
[344.627237] Starting subtest: basic-with_two_bos
[344.656119] Subtest basic-with_two_bos: SUCCESS (0.027s)
[345.031652] [136/161] (770s left) prime_vgem (basic-fence-flip)
[345.543306] Starting subtest: basic-fence-flip
[346.292605] Subtest basic-fence-flip: SUCCESS (0.738s)
[346.797185] [137/161] (768s left) prime_vgem (basic-fence-mmap)
[347.328164] Starting subtest: basic-fence-mmap
[347.535788] Subtest basic-fence-mmap: SUCCESS (0.215s)
[347.904978] [138/161] (768s left) prime_vgem (basic-fence-read)
[348.406444] Starting subtest: basic-fence-read
[348.690704] Subtest basic-fence-read: SUCCESS (0.284s)
[349.119988] [139/161] (767s left) prime_vgem (basic-gtt)
[349.611114] Starting subtest: basic-gtt
[349.689258] Subtest basic-gtt: SUCCESS (0.078s)
[350.054896] [140/161] (766s left) prime_vgem (basic-read)
[350.547787] Starting subtest: basic-read
[350.650844] Subtest basic-read: SUCCESS (0.106s)
[351.019143] [141/161] (765s left) prime_vgem (basic-write)
[351.536860] Starting subtest: basic-write
[351.649251] Subtest basic-write: SUCCESS (0.119s)
[352.043330] [142/161] (765s left) vgem_basic (setversion)
[352.517794] Starting subtest: setversion
[352.527386] Subtest setversion: SUCCESS (0.000s)
[352.873789] [143/161] (764s left) vgem_basic (create)
[353.341378] Starting subtest: create
[353.348791] Subtest create: SUCCESS (0.003s)
[353.693388] [144/161] (764s left) vgem_basic (debugfs)
[354.191045] Starting subtest: debugfs
[354.197370] Subtest debugfs: SUCCESS (0.004s)
[354.550436] [145/161] (763s left) vgem_basic (dmabuf-export)
[355.045766] Starting subtest: dmabuf-export
[355.060587] Subtest dmabuf-export: SUCCESS (0.012s)
[355.412348] [146/161] (763s left) vgem_basic (dmabuf-fence)
[355.894480] Starting subtest: dmabuf-fence
[355.899470] Subtest dmabuf-fence: SUCCESS (0.005s)
[356.253358] [147/161] (762s left) vgem_basic (dmabuf-fence-before)
[356.745198] Starting subtest: dmabuf-fence-before
[356.749366] Subtest dmabuf-fence-before: SUCCESS (0.003s)
[357.111468] [148/161] (762s left) vgem_basic (dmabuf-mmap)
[357.613141] Starting subtest: dmabuf-mmap
[357.696820] Subtest dmabuf-mmap: SUCCESS (0.093s)
[358.068805] [149/161] (761s left) vgem_basic (mmap)
[358.554381] Starting subtest: mmap
[358.621238] Subtest mmap: SUCCESS (0.066s)
[358.988432] [150/161] (761s left) vgem_basic (second-client)
[359.459843] Starting subtest: second-client
[359.490629] Subtest second-client: SUCCESS (0.033s)
[359.851897] [151/161] (760s left) vgem_basic (sysfs)
[360.366324] Starting subtest: sysfs
[360.371242] Subtest sysfs: SUCCESS (0.006s)
[360.728209] [152/161] (760s left) core_hotunplug (unbind-rebind)
[361.611951] Starting subtest: unbind-rebind
[367.799880] Subtest unbind-rebind: SUCCESS (6.176s)
[368.141815] [153/161] (752s left) vgem_basic (unload)
[368.615611] Starting subtest: unload
[398.396169] Subtest unload: SUCCESS (29.782s)
[398.987637] [154/161] (722s left) i915_module_load (reload)
[399.472527] Starting subtest: reload
[410.184203] Subtest reload: SUCCESS (10.628s)
[411.204482] [155/161] (711s left) gem_lmem_swapping (basic)
[411.825279] Subtest basic: SKIP (0.000s)
[412.154137] [156/161] (710s left) gem_lmem_swapping (parallel-random-engines)
[412.664733] Subtest parallel-random-engines: SKIP (0.000s)
[413.009246] [157/161] (710s left) gem_lmem_swapping (random-engines)
[413.501060] Subtest random-engines: SKIP (0.000s)
[413.833213] [158/161] (709s left) gem_lmem_swapping (verify-random)
[414.327913] Subtest verify-random: SKIP (0.000s)
[414.728492] [159/161] (709s left) i915_pm_rpm (module-reload)
[426.693241] Subtest module-reload: SKIP (0.000s)
[427.040547] [160/161] (697s left) i915_selftest (live)
[430.148733] Starting subtest: live
[430.152708] Starting dynamic subtest: sanitycheck
[438.089649] Dynamic subtest sanitycheck: SUCCESS (7.939s)
[438.171972] Starting dynamic subtest: uncore
[445.646850] Dynamic subtest uncore: SUCCESS (7.548s)
[445.706085] Starting dynamic subtest: workarounds
[453.331939] Dynamic subtest workarounds: SUCCESS (7.685s)
[453.377271] Starting dynamic subtest: gt_engines
[460.919569] Dynamic subtest gt_engines: SUCCESS (7.581s)
[460.995663] Starting dynamic subtest: gt_timelines
[475.819117] Dynamic subtest gt_timelines: SUCCESS (14.893s)
[475.875171] Starting dynamic subtest: gt_contexts
[483.646937] Dynamic subtest gt_contexts: SUCCESS (7.818s)
[483.705562] Starting dynamic subtest: gt_lrc
[491.128151] Dynamic subtest gt_lrc: SUCCESS (7.467s)
[491.210515] Starting dynamic subtest: gt_mocs
[498.767312] Dynamic subtest gt_mocs: SUCCESS (7.637s)
[498.807927] Starting dynamic subtest: gt_pm
[506.805835] Dynamic subtest gt_pm: SUCCESS (8.034s)
[506.852267] Starting dynamic subtest: gt_heartbeat
[514.492748] Dynamic subtest gt_heartbeat: SUCCESS (7.682s)
[514.546713] Starting dynamic subtest: gt_tlb
[522.161859] Dynamic subtest gt_tlb: SUCCESS (7.660s)
[522.207782] Starting dynamic subtest: requests
[532.584981] Dynamic subtest requests: SUCCESS (10.420s)
[532.632345] Starting dynamic subtest: migrate
[540.129246] Dynamic subtest migrate: SUCCESS (7.538s)
[540.174289] Starting dynamic subtest: active
[548.027937] Dynamic subtest active: SUCCESS (7.891s)
[548.082423] Starting dynamic subtest: objects
[556.350875] Dynamic subtest objects: SUCCESS (8.314s)
[556.414706] Starting dynamic subtest: mman
[571.888263] Dynamic subtest mman: SUCCESS (15.531s)
[571.945086] Starting dynamic subtest: dmabuf
[579.952125] Dynamic subtest dmabuf: SUCCESS (8.056s)
[579.993906] Starting dynamic subtest: vma
[587.751321] Dynamic subtest vma: SUCCESS (7.794s)
[587.834379] Starting dynamic subtest: coherency
[601.113603] Dynamic subtest coherency: SUCCESS (13.359s)
[601.204504] Starting dynamic subtest: gtt
[611.738486] Dynamic subtest gtt: SUCCESS (10.615s)
[611.835953] Starting dynamic subtest: gem
[619.596212] Dynamic subtest gem: SUCCESS (7.851s)
[619.663725] Starting dynamic subtest: evict
[627.217326] Dynamic subtest evict: SUCCESS (7.609s)
[627.280826] Starting dynamic subtest: hugepages
[634.873238] Dynamic subtest hugepages: SUCCESS (7.650s)
[634.942062] Starting dynamic subtest: gem_contexts
[642.385860] Dynamic subtest gem_contexts: SUCCESS (7.501s)
[642.440147] Starting dynamic subtest: client
[650.209147] Dynamic subtest client: SUCCESS (7.815s)
[650.254061] Starting dynamic subtest: gem_migrate
[657.858083] Dynamic subtest gem_migrate: SUCCESS (7.644s)
[657.959906] Starting dynamic subtest: reset
[667.579704] Dynamic subtest reset: SUCCESS (9.716s)
[667.674435] Starting dynamic subtest: memory_region
[675.134163] Dynamic subtest memory_region: SUCCESS (7.545s)
[675.196995] Starting dynamic subtest: hangcheck
[683.834544] Dynamic subtest hangcheck: SUCCESS (8.689s)
[683.894835] Starting dynamic subtest: execlists
[691.343659] Dynamic subtest execlists: SUCCESS (7.508s)
[691.433192] Starting dynamic subtest: ring_submission
[700.430135] Dynamic subtest ring_submission: SUCCESS (9.072s)
[700.484567] Starting dynamic subtest: perf
[707.985605] Dynamic subtest perf: SUCCESS (7.555s)
[708.066187] Starting dynamic subtest: slpc
[715.270335] Dynamic subtest slpc: SUCCESS (7.279s)
[715.327681] Starting dynamic subtest: guc
[722.768870] Dynamic subtest guc: SUCCESS (7.492s)
[722.864242] Starting dynamic subtest: guc_multi_lrc
[730.093850] Dynamic subtest guc_multi_lrc: SUCCESS (7.317s)
[730.144690] Starting dynamic subtest: guc_hang
[737.488157] Dynamic subtest guc_hang: SUCCESS (7.385s)
[737.574837] Starting dynamic subtest: late_gt_pm
[744.790463] Dynamic subtest late_gt_pm: SUCCESS (7.299s)
[744.794551] Subtest live: SUCCESS (314.645s)
[745.031771] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[745.042541] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[745.059255] [161/161] (379s left) dmabuf (all-tests)
[745.519895] Starting subtest: all-tests
[745.525875] Starting dynamic subtest: sanitycheck
[745.628223] Dynamic subtest sanitycheck: SUCCESS (0.106s)
[745.684610] Starting dynamic subtest: dma_fence
[745.950095] Dynamic subtest dma_fence: SUCCESS (0.314s)
[745.997058] Starting dynamic subtest: dma_fence_chain