[104.804906] Initializing watchdogs
[104.806816]   /dev/watchdog0
[105.042077] [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)
[105.106879] [001/161] (960s left) i915_module_load (load)
[107.533379] Starting subtest: load
[115.593671] Subtest load: SUCCESS (8.057s)
[115.956591] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[115.967343] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[115.988300] [002/161] (950s left) core_auth (basic-auth)
[116.543781] Starting subtest: basic-auth
[116.549533] Subtest basic-auth: SUCCESS (0.005s)
[116.938505] [003/161] (949s left) debugfs_test (read_all_entries)
[117.437184] Starting subtest: read_all_entries
[117.671733] Subtest read_all_entries: SUCCESS (0.238s)
[118.047272] [004/161] (948s left) debugfs_test (basic-hwmon)
[118.509139] Starting subtest: basic-hwmon
[118.516989] Subtest basic-hwmon: SKIP (0.000s)
[118.871268] [005/161] (948s left) debugfs_test (sysfs)
[119.335755] Starting subtest: sysfs
[119.479392] Subtest sysfs: SUCCESS (0.140s)
[119.838781] [006/161] (947s left) fbdev (eof)
[120.335895] Starting subtest: eof
[120.341361] Subtest eof: SUCCESS (0.005s)
[120.627351] [007/161] (946s left) fbdev (info)
[121.087307] Starting subtest: info
[121.091775] Subtest info: SUCCESS (0.000s)
[121.379840] [008/161] (946s left) fbdev (nullptr)
[121.833696] Starting subtest: nullptr
[121.837333] Subtest nullptr: SUCCESS (0.000s)
[122.134266] [009/161] (945s left) fbdev (read)
[122.587129] Starting subtest: read
[122.888088] Subtest read: SUCCESS (0.303s)
[123.192671] [010/161] (945s left) fbdev (write)
[123.652501] Starting subtest: write
[123.834243] Subtest write: SUCCESS (0.184s)
[124.134633] [011/161] (944s left) gem_basic (bad-close)
[124.587755] Starting subtest: bad-close
[124.595589] Subtest bad-close: SUCCESS (0.000s)
[124.886821] [012/161] (943s left) gem_basic (create-close)
[125.336991] Starting subtest: create-close
[125.345495] Subtest create-close: SUCCESS (0.002s)
[125.651849] [013/161] (943s left) gem_basic (create-fd-close)
[126.106475] Starting subtest: create-fd-close
[126.114700] Subtest create-fd-close: SUCCESS (0.001s)
[126.411185] [014/161] (942s left) gem_busy (busy@all-engines)
[126.938323] Starting subtest: busy
[126.944392] Starting dynamic subtest: all-engines
[127.078380] Dynamic subtest all-engines: SUCCESS (0.138s)
[127.082807] Subtest busy: SUCCESS (0.143s)
[127.776850] [015/161] (941s left) gem_close_race (basic-process)
[128.301464] Starting subtest: basic-process
[128.507500] Subtest basic-process: SUCCESS (0.205s)
[128.957422] [016/161] (940s left) gem_close_race (basic-threads)
[129.497107] Starting subtest: basic-threads
[131.033341] Subtest basic-threads: SUCCESS (1.544s)
[131.494886] [017/161] (938s left) gem_ctx_create (basic)
[132.042563] Subtest basic: SKIP (0.000s)
[132.333093] [018/161] (938s left) gem_ctx_create (basic-files)
[132.800338] Subtest basic-files: SKIP (0.000s)
[133.098512] [019/161] (937s left) gem_ctx_exec (basic)
[133.565136] Subtest basic: SKIP (0.000s)
[133.886490] [020/161] (937s left) gem_exec_basic (basic)
[134.406450] Starting subtest: basic
[134.410443] Starting dynamic subtest: rcs0-smem
[134.413855] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[134.417157] Subtest basic: SUCCESS (0.009s)
[134.875918] [021/161] (936s left) gem_exec_create (basic)
[135.411620] Starting subtest: basic
[135.416307] Starting dynamic subtest: smem
[137.559533] Dynamic subtest smem: SUCCESS (2.154s)
[137.562985] Subtest basic: SUCCESS (2.156s)
[138.034329] [022/161] (933s left) gem_exec_fence (basic-busy)
[138.786827] Starting subtest: basic-busy
[138.791996] Starting dynamic subtest: rcs0
[138.836435] Dynamic subtest rcs0: SUCCESS (0.047s)
[138.840564] Subtest basic-busy: SUCCESS (0.050s)
[140.025595] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[140.038440] [023/161] (931s left) gem_exec_fence (basic-wait)
[140.783420] Starting subtest: basic-wait
[140.788940] Starting dynamic subtest: rcs0
[140.827849] Dynamic subtest rcs0: SUCCESS (0.042s)
[140.831921] Subtest basic-wait: SUCCESS (0.046s)
[141.793485] [024/161] (930s left) gem_exec_fence (basic-await)
[142.536758] Starting subtest: basic-await
[142.541655] Starting dynamic subtest: rcs0
[142.687072] Dynamic subtest rcs0: SUCCESS (0.146s)
[142.690439] Subtest basic-await: SUCCESS (0.151s)
[143.653526] [025/161] (928s left) gem_exec_fence (nb-await)
[144.395937] Starting subtest: nb-await
[144.399385] Starting dynamic subtest: rcs0
[144.464080] Dynamic subtest rcs0: SUCCESS (0.068s)
[144.467524] Subtest nb-await: SUCCESS (0.072s)
[145.427991] [026/161] (927s left) gem_exec_gttfill (basic)
[145.965919] Starting subtest: basic
[155.700820] Subtest basic: SUCCESS (9.733s)
[156.261454] [027/161] (916s left) gem_exec_parallel (engines)
[157.029315] Starting subtest: engines
[157.033340] Starting dynamic subtest: basic
[161.582925] Dynamic subtest basic: SUCCESS (4.556s)
[161.648357] Starting dynamic subtest: contexts
[161.665568] Dynamic subtest contexts: SKIP (0.003s)
[161.727197] Starting dynamic subtest: fds
[161.741186] Dynamic subtest fds: SKIP (0.003s)
[161.797802] Starting dynamic subtest: userptr
[165.865476] Dynamic subtest userptr: SUCCESS (4.270s)
[165.869997] Subtest engines: SUCCESS (8.840s)
[166.358207] [028/161] (907s left) gem_exec_store (basic)
[166.887497] Starting subtest: basic
[166.926101] Subtest basic: SUCCESS (0.040s)
[167.428622] [029/161] (906s left) gem_flink_basic (bad-flink)
[167.875836] Starting subtest: bad-flink
[167.879624] Subtest bad-flink: SUCCESS (0.000s)
[168.231474] [030/161] (905s left) gem_flink_basic (bad-open)
[168.674850] Starting subtest: bad-open
[168.679669] Subtest bad-open: SUCCESS (0.000s)
[169.021179] [031/161] (905s left) gem_flink_basic (basic)
[169.467186] Starting subtest: basic
[169.471653] Subtest basic: SUCCESS (0.001s)
[169.818977] [032/161] (904s left) gem_flink_basic (double-flink)
[170.274624] Starting subtest: double-flink
[170.279480] Subtest double-flink: SUCCESS (0.001s)
[170.626593] [033/161] (904s left) gem_flink_basic (flink-lifetime)
[171.069449] Starting subtest: flink-lifetime
[171.075553] Subtest flink-lifetime: SUCCESS (0.009s)
[171.429951] [034/161] (903s left) gem_huc_copy (huc-copy)
[171.893333] Subtest huc-copy: SKIP (0.000s)
[172.218502] [035/161] (903s left) gem_linear_blits (basic)
[173.010376] Starting subtest: basic
[173.064258] Subtest basic: SUCCESS (0.052s)
[173.505611] [036/161] (902s left) gem_mmap (basic)
[174.195526] Starting subtest: basic
[174.216075] Subtest basic: SUCCESS (0.003s)
[174.549777] [037/161] (901s left) gem_mmap_gtt (basic)
[175.003469] Starting subtest: basic
[175.009623] Subtest basic: SUCCESS (0.006s)
[175.356552] [038/161] (901s left) gem_render_linear_blits (basic)
[175.824227] Starting subtest: basic
[175.971444] Subtest basic: SUCCESS (0.146s)
[176.328138] [039/161] (900s left) gem_render_tiled_blits (basic)
[176.849535] Starting subtest: basic
[177.051438] Subtest basic: SUCCESS (0.209s)
[177.377953] [040/161] (899s left) gem_ringfill (basic-all)
[177.945893] Starting subtest: basic-all
[179.161906] Subtest basic-all: SUCCESS (1.218s)
[179.521698] [041/161] (898s left) gem_softpin (allocator-basic)
[179.984163] Subtest allocator-basic: SKIP (0.000s)
[180.332288] [042/161] (897s left) gem_softpin (allocator-basic-reserve)
[180.791580] Subtest allocator-basic-reserve: SKIP (0.000s)
[181.142865] [043/161] (897s left) gem_softpin (safe-alignment)
[181.602398] Starting subtest: safe-alignment
[181.615464] Subtest safe-alignment: SUCCESS (0.019s)
[181.964407] [044/161] (896s left) gem_sync (basic-all)
[182.499899] Starting subtest: basic-all
[185.119099] Subtest basic-all: SUCCESS (2.624s)
[185.609931] [045/161] (893s left) gem_sync (basic-each)
[186.140286] Starting subtest: basic-each
[188.766358] Subtest basic-each: SUCCESS (2.629s)
[189.256743] [046/161] (889s left) gem_tiled_blits (basic)
[190.052861] Starting subtest: basic
[190.151817] Subtest basic: SUCCESS (0.106s)
[190.629894] [047/161] (888s left) gem_tiled_fence_blits (basic)
[191.750541] Starting subtest: basic
[191.826234] Subtest basic: SUCCESS (0.087s)
[192.298237] [048/161] (887s left) gem_tiled_pread_basic
[195.228924] [049/161] (884s left) gem_wait (busy@all-engines)
[195.833450] Starting subtest: busy
[195.838405] Starting dynamic subtest: all-engines
[196.367224] Dynamic subtest all-engines: SUCCESS (0.539s)
[196.371262] Subtest busy: SUCCESS (0.543s)
[197.026247] [050/161] (883s left) gem_wait (wait@all-engines)
[197.609667] Starting subtest: wait
[197.613930] Starting dynamic subtest: all-engines
[198.668213] Dynamic subtest all-engines: SUCCESS (1.055s)
[198.672812] Subtest wait: SUCCESS (1.059s)
[199.318105] [051/161] (881s left) i915_getparams_basic (basic-eu-total)
[199.751771] Starting subtest: basic-eu-total
[199.761104] Subtest basic-eu-total: SUCCESS (0.000s)
[200.092626] [052/161] (881s left) i915_getparams_basic (basic-subslice-total)
[200.541331] Starting subtest: basic-subslice-total
[200.550857] Subtest basic-subslice-total: SUCCESS (0.000s)
[200.898331] [053/161] (880s left) i915_hangman (error-state-basic)
[201.377679] Starting subtest: error-state-basic
[201.761561] Subtest error-state-basic: SUCCESS (0.390s)
[202.145682] [054/161] (879s left) i915_pciid
[202.952300] [055/161] (879s left) kms_addfb_basic (addfb25-4-tiled)
[203.461864] Starting subtest: addfb25-4-tiled
[203.467245] Subtest addfb25-4-tiled: SUCCESS (0.002s)
[203.816767] [056/161] (878s left) kms_addfb_basic (addfb25-bad-modifier)
[204.325913] Starting subtest: addfb25-bad-modifier
[204.331206] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[204.706140] [057/161] (877s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[205.212375] Starting subtest: addfb25-framebuffer-vs-set-tiling
[205.217466] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[205.578853] [058/161] (877s left) kms_addfb_basic (addfb25-modifier-no-flag)
[206.075707] Starting subtest: addfb25-modifier-no-flag
[206.080377] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[206.454768] [059/161] (876s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[207.041442] Starting subtest: addfb25-x-tiled-legacy
[207.046256] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[207.406299] [060/161] (876s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[207.895882] Starting subtest: addfb25-x-tiled-mismatch-legacy
[207.900612] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s)
[208.274331] [061/161] (875s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[208.779511] Starting subtest: addfb25-yf-tiled-legacy
[208.783975] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[209.138739] [062/161] (875s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[209.649421] Starting subtest: addfb25-y-tiled-legacy
[209.654307] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s)
[210.002254] [063/161] (874s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[210.497217] Starting subtest: addfb25-y-tiled-small-legacy
[210.505491] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[210.860709] [064/161] (874s left) kms_addfb_basic (bad-pitch-0)
[211.306928] Starting subtest: bad-pitch-0
[211.310477] Subtest bad-pitch-0: SUCCESS (0.000s)
[211.726740] [065/161] (873s left) kms_addfb_basic (bad-pitch-1024)
[212.175614] Starting subtest: bad-pitch-1024
[212.179810] Subtest bad-pitch-1024: SUCCESS (0.000s)
[212.595148] [066/161] (873s left) kms_addfb_basic (bad-pitch-128)
[213.046675] Starting subtest: bad-pitch-128
[213.050513] Subtest bad-pitch-128: SUCCESS (0.000s)
[213.460549] [067/161] (872s left) kms_addfb_basic (bad-pitch-256)
[213.920901] Starting subtest: bad-pitch-256
[213.925647] Subtest bad-pitch-256: SUCCESS (0.000s)
[214.334755] [068/161] (871s left) kms_addfb_basic (bad-pitch-32)
[214.784430] Starting subtest: bad-pitch-32
[214.789140] Subtest bad-pitch-32: SUCCESS (0.000s)
[215.254773] [069/161] (871s left) kms_addfb_basic (bad-pitch-63)
[215.701830] Starting subtest: bad-pitch-63
[215.707149] Subtest bad-pitch-63: SUCCESS (0.000s)
[216.113080] [070/161] (870s left) kms_addfb_basic (bad-pitch-65536)
[216.572126] Starting subtest: bad-pitch-65536
[216.576693] Subtest bad-pitch-65536: SUCCESS (0.002s)
[216.982980] [071/161] (870s left) kms_addfb_basic (bad-pitch-999)
[217.433127] Starting subtest: bad-pitch-999
[217.436692] Subtest bad-pitch-999: SUCCESS (0.000s)
[217.855902] [072/161] (869s left) kms_addfb_basic (basic)
[218.300428] Starting subtest: basic
[218.305502] Subtest basic: SUCCESS (0.001s)
[218.713920] [073/161] (869s left) kms_addfb_basic (basic-x-tiled-legacy)
[219.178795] Starting subtest: basic-x-tiled-legacy
[219.183503] Subtest basic-x-tiled-legacy: SUCCESS (0.001s)
[219.642354] [074/161] (868s left) kms_addfb_basic (basic-y-tiled-legacy)
[220.096981] Starting subtest: basic-y-tiled-legacy
[220.101749] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[220.530617] [075/161] (868s left) kms_addfb_basic (bo-too-small)
[221.034513] Starting subtest: bo-too-small
[221.040564] Subtest bo-too-small: SUCCESS (0.002s)
[221.405987] [076/161] (867s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[221.984742] Starting subtest: bo-too-small-due-to-tiling
[221.990168] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[222.346166] [077/161] (866s left) kms_addfb_basic (clobberred-modifier)
[222.793509] Starting subtest: clobberred-modifier
[222.797668] Subtest clobberred-modifier: SUCCESS (0.001s)
[223.216402] [078/161] (866s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[223.672231] Starting subtest: framebuffer-vs-set-tiling
[223.676865] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[224.086814] [079/161] (865s left) kms_addfb_basic (invalid-get-prop)
[224.533659] Starting subtest: invalid-get-prop
[224.538151] Subtest invalid-get-prop: SUCCESS (0.000s)
[224.965580] [080/161] (865s left) kms_addfb_basic (invalid-get-prop-any)
[225.418511] Starting subtest: invalid-get-prop-any
[225.422632] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[225.833262] [081/161] (864s left) kms_addfb_basic (invalid-set-prop)
[226.276621] Starting subtest: invalid-set-prop
[226.281748] Subtest invalid-set-prop: SUCCESS (0.000s)
[226.689576] [082/161] (864s left) kms_addfb_basic (invalid-set-prop-any)
[227.138463] Starting subtest: invalid-set-prop-any
[227.143318] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[227.557875] [083/161] (863s left) kms_addfb_basic (no-handle)
[228.007344] Starting subtest: no-handle
[228.011839] Subtest no-handle: SUCCESS (0.000s)
[228.411974] [084/161] (863s left) kms_addfb_basic (size-max)
[228.910710] Starting subtest: size-max
[228.916766] Subtest size-max: SUCCESS (0.001s)
[229.297719] [085/161] (862s left) kms_addfb_basic (small-bo)
[229.803384] Starting subtest: small-bo
[229.809290] Subtest small-bo: SUCCESS (0.000s)
[230.178660] [086/161] (861s left) kms_addfb_basic (tile-pitch-mismatch)
[230.628698] Starting subtest: tile-pitch-mismatch
[230.632600] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[231.083826] [087/161] (861s left) kms_addfb_basic (too-high)
[231.581659] Starting subtest: too-high
[231.586469] Subtest too-high: SUCCESS (0.006s)
[231.969547] [088/161] (860s left) kms_addfb_basic (too-wide)
[232.471946] Starting subtest: too-wide
[232.476764] Subtest too-wide: SUCCESS (0.000s)
[232.851361] [089/161] (860s left) kms_addfb_basic (unused-handle)
[233.292158] Starting subtest: unused-handle
[233.296300] Subtest unused-handle: SUCCESS (0.000s)
[233.712369] [090/161] (859s left) kms_addfb_basic (unused-modifier)
[234.159144] Starting subtest: unused-modifier
[234.164785] Subtest unused-modifier: SUCCESS (0.000s)
[234.589961] [091/161] (859s left) kms_addfb_basic (unused-offsets)
[235.100639] Starting subtest: unused-offsets
[235.108362] Subtest unused-offsets: SUCCESS (0.000s)
[235.562307] [092/161] (858s left) kms_addfb_basic (unused-pitches)
[236.029399] Starting subtest: unused-pitches
[236.034714] Subtest unused-pitches: SUCCESS (0.003s)
[236.446282] [093/161] (857s left) kms_busy (basic)
[237.023757] Starting subtest: basic
[237.034721] Starting dynamic subtest: flip
[238.031263] Dynamic subtest flip: SUCCESS (0.997s)
[238.083312] Starting dynamic subtest: modeset
[238.089361] Dynamic subtest modeset: SKIP (0.001s)
[238.092460] Subtest basic: SUCCESS (1.012s)
[238.551188] [094/161] (856s left) kms_prop_blob (basic)
[239.002851] Starting subtest: basic
[239.009589] Subtest basic: SUCCESS (0.000s)
[239.345510] [095/161] (855s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[239.837672] Starting subtest: basic-busy-flip-before-cursor-atomic
[239.857281] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.015s)
[240.223609] [096/161] (855s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[240.725302] Starting subtest: basic-busy-flip-before-cursor-legacy
[241.829838] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.105s)
[242.339994] [097/161] (853s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[242.838783] Starting subtest: basic-flip-after-cursor-atomic
[242.846672] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[243.196341] [098/161] (852s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[243.688959] Starting subtest: basic-flip-after-cursor-legacy
[244.773596] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.088s)
[245.293091] [099/161] (850s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[245.784194] Starting subtest: basic-flip-after-cursor-varying-size
[246.870344] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.087s)
[247.425749] [100/161] (849s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[247.921629] Starting subtest: basic-flip-before-cursor-atomic
[247.929477] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[248.283857] [101/161] (848s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[248.771819] Starting subtest: basic-flip-before-cursor-legacy
[249.859863] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.089s)
[250.362523] [102/161] (846s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[250.864982] Starting subtest: basic-flip-before-cursor-varying-size
[251.952236] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.087s)
[252.472824] [103/161] (845s left) kms_dsc (dsc-basic)
[252.966219] Subtest dsc-basic: SKIP (0.000s)
[253.297992] [104/161] (844s left) kms_flip (basic-flip-vs-dpms)
[253.787291] Starting subtest: basic-flip-vs-dpms
[253.792326] Starting dynamic subtest: A-VGA1
[255.430133] Dynamic subtest A-VGA1: SUCCESS (1.647s)
[255.493118] Starting dynamic subtest: B-VGA1
[256.988428] Dynamic subtest B-VGA1: SUCCESS (1.548s)
[256.996125] Subtest basic-flip-vs-dpms: SUCCESS (3.211s)
[257.696606] [105/161] (840s left) kms_flip (basic-flip-vs-modeset)
[258.207383] Starting subtest: basic-flip-vs-modeset
[258.212522] Starting dynamic subtest: A-VGA1
[259.921534] Dynamic subtest A-VGA1: SUCCESS (1.708s)
[259.970185] Starting dynamic subtest: B-VGA1
[261.402437] Dynamic subtest B-VGA1: SUCCESS (1.472s)
[261.409230] Subtest basic-flip-vs-modeset: SUCCESS (3.193s)
[262.020549] [106/161] (836s left) kms_flip (basic-flip-vs-wf_vblank)
[262.531391] Starting subtest: basic-flip-vs-wf_vblank
[262.536160] Starting dynamic subtest: A-VGA1
[264.357251] Dynamic subtest A-VGA1: SUCCESS (1.818s)
[264.412997] Starting dynamic subtest: B-VGA1
[266.092641] Dynamic subtest B-VGA1: SUCCESS (1.731s)
[266.097458] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.562s)
[266.877635] [107/161] (832s left) kms_flip (basic-plain-flip)
[267.416607] Starting subtest: basic-plain-flip
[267.420951] Starting dynamic subtest: A-VGA1
[268.964959] Dynamic subtest A-VGA1: SUCCESS (1.538s)
[269.021187] Starting dynamic subtest: B-VGA1
[270.398465] Dynamic subtest B-VGA1: SUCCESS (1.433s)
[270.402617] Subtest basic-plain-flip: SUCCESS (2.981s)
[271.108422] [108/161] (828s left) kms_force_connector_basic (force-connector-state)
[271.647941] Starting subtest: force-connector-state
[271.918777] Subtest force-connector-state: SUCCESS (0.267s)
[272.594447] [109/161] (827s left) kms_force_connector_basic (force-edid)
[273.121687] Starting subtest: force-edid
[273.207897] Subtest force-edid: SUCCESS (0.081s)
[273.643384] [110/161] (826s left) kms_force_connector_basic (force-load-detect)
[274.191598] Starting subtest: force-load-detect
[274.700682] Subtest force-load-detect: SUCCESS (0.506s)
[275.315132] [111/161] (824s left) kms_force_connector_basic (prune-stale-modes)
[275.850121] Starting subtest: prune-stale-modes
[275.960712] Subtest prune-stale-modes: SUCCESS (0.101s)
[276.426457] [112/161] (824s left) kms_frontbuffer_tracking (basic)
[276.930594] Subtest basic: SKIP (0.000s)
[277.270442] [113/161] (823s left) kms_hdmi_inject (inject-audio)
[277.735369] Subtest inject-audio: SKIP (0.000s)
[278.062189] [114/161] (823s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[278.551973] Starting subtest: compare-crc-sanitycheck-xr24
[278.564805] Starting dynamic subtest: pipe-A-VGA-1
[278.941600] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.376s)
[278.999139] Starting dynamic subtest: pipe-B-VGA-1
[279.452647] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.506s)
[279.457727] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.900s)
[280.000624] [115/161] (821s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[280.496587] Starting subtest: compare-crc-sanitycheck-nv12
[280.508619] Starting dynamic subtest: pipe-A-VGA-1
[280.518113] Dynamic subtest pipe-A-VGA-1: SKIP (0.001s)
[280.568476] Starting dynamic subtest: pipe-B-VGA-1
[280.575670] Dynamic subtest pipe-B-VGA-1: SKIP (0.001s)
[280.584152] Subtest compare-crc-sanitycheck-nv12: SKIP (0.021s)
[280.907455] [116/161] (821s left) kms_pipe_crc_basic (hang-read-crc)
[281.414636] Starting subtest: hang-read-crc
[281.418436] Starting dynamic subtest: pipe-A-VGA-1
[282.791225] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.368s)
[282.851410] Starting dynamic subtest: pipe-B-VGA-1
[284.237469] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.439s)
[284.241104] Subtest hang-read-crc: SUCCESS (2.824s)
[284.744597] [117/161] (817s left) kms_pipe_crc_basic (nonblocking-crc)
[285.242883] Starting subtest: nonblocking-crc
[285.248178] Starting dynamic subtest: pipe-A-VGA-1
[285.827244] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.577s)
[285.888764] Starting dynamic subtest: pipe-B-VGA-1
[286.536721] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.700s)
[286.541687] Subtest nonblocking-crc: SUCCESS (1.293s)
[287.041812] [118/161] (815s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[287.546326] Starting subtest: nonblocking-crc-frame-sequence
[287.551407] Starting dynamic subtest: pipe-A-VGA-1
[288.142348] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.590s)
[288.192676] Starting dynamic subtest: pipe-B-VGA-1
[288.895614] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.744s)
[288.900608] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.354s)
[289.405606] [119/161] (813s left) kms_pipe_crc_basic (read-crc)
[289.910227] Starting subtest: read-crc
[289.914757] Starting dynamic subtest: pipe-A-VGA-1
[290.439390] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.528s)
[290.502502] Starting dynamic subtest: pipe-B-VGA-1
[291.092272] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.646s)
[291.097049] Subtest read-crc: SUCCESS (1.189s)
[291.599708] [120/161] (811s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[292.105822] Starting subtest: read-crc-frame-sequence
[292.110581] Starting dynamic subtest: pipe-A-VGA-1
[292.648211] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.536s)
[292.696807] Starting dynamic subtest: pipe-B-VGA-1
[293.324709] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.667s)
[293.328528] Subtest read-crc-frame-sequence: SUCCESS (1.226s)
[293.874798] [121/161] (809s left) kms_pm_backlight (basic-brightness)
[294.370592] Subtest basic-brightness: SKIP (0.000s)
[294.721505] [122/161] (809s left) kms_pm_rpm (basic-pci-d3-state)
[306.619255] Subtest basic-pci-d3-state: SKIP (0.000s)
[306.946171] [123/161] (797s left) kms_pm_rpm (basic-rte)
[307.380917] Starting subtest: basic-rte
[318.826515] Subtest basic-rte: SKIP (11.438s)
[319.151098] [124/161] (785s left) kms_psr (psr-primary-page-flip)
[319.632527] Subtest psr-primary-page-flip: SKIP (0.000s)
[319.951678] [125/161] (784s left) kms_psr (psr-cursor-plane-move)
[320.450386] Subtest psr-cursor-plane-move: SKIP (0.000s)
[320.785841] [126/161] (784s left) kms_psr (psr-sprite-plane-onoff)
[321.286435] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[321.620604] [127/161] (783s left) kms_psr (psr-primary-mmap-gtt)
[322.125063] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[322.458696] [128/161] (783s left) kms_setmode (basic-clone-single-crtc)
[322.912239] Starting subtest: basic-clone-single-crtc
[322.924613] Subtest basic-clone-single-crtc: SKIP (0.001s)
[323.266330] [129/161] (782s left) i915_pm_rps (basic-api)
[323.733288] Subtest basic-api: SKIP (0.000s)
[324.059782] [130/161] (782s left) prime_self_import (basic-llseek-bad)
[324.498305] Starting subtest: basic-llseek-bad
[324.518568] Subtest basic-llseek-bad: SUCCESS (0.014s)
[324.859558] [131/161] (781s left) prime_self_import (basic-llseek-size)
[325.296599] Starting subtest: basic-llseek-size
[325.320745] Subtest basic-llseek-size: SUCCESS (0.028s)
[325.686605] [132/161] (781s left) prime_self_import (basic-with_fd_dup)
[326.127661] Starting subtest: basic-with_fd_dup
[326.146468] Subtest basic-with_fd_dup: SUCCESS (0.019s)
[326.507447] [133/161] (780s left) prime_self_import (basic-with_one_bo)
[327.022801] Starting subtest: basic-with_one_bo
[327.041669] Subtest basic-with_one_bo: SUCCESS (0.020s)
[327.379662] [134/161] (780s left) prime_self_import (basic-with_one_bo_two_files)
[327.815792] Starting subtest: basic-with_one_bo_two_files
[327.834871] Subtest basic-with_one_bo_two_files: SUCCESS (0.018s)
[328.183443] [135/161] (779s left) prime_self_import (basic-with_two_bos)
[328.628286] Starting subtest: basic-with_two_bos
[328.647618] Subtest basic-with_two_bos: SUCCESS (0.023s)
[329.018981] [136/161] (779s left) prime_vgem (basic-fence-flip)
[329.504133] Starting subtest: basic-fence-flip
[330.191685] Subtest basic-fence-flip: SUCCESS (0.687s)
[330.568324] [137/161] (778s left) prime_vgem (basic-fence-mmap)
[331.051582] Starting subtest: basic-fence-mmap
[331.247660] Subtest basic-fence-mmap: SUCCESS (0.202s)
[331.603732] [138/161] (777s left) prime_vgem (basic-fence-read)
[332.085866] Starting subtest: basic-fence-read
[332.344164] Subtest basic-fence-read: SUCCESS (0.263s)
[332.709680] [139/161] (776s left) prime_vgem (basic-gtt)
[333.185150] Starting subtest: basic-gtt
[333.261762] Subtest basic-gtt: SUCCESS (0.078s)
[333.625702] [140/161] (776s left) prime_vgem (basic-read)
[334.095581] Starting subtest: basic-read
[334.197771] Subtest basic-read: SUCCESS (0.104s)
[334.568717] [141/161] (775s left) prime_vgem (basic-write)
[335.057740] Starting subtest: basic-write
[335.165550] Subtest basic-write: SUCCESS (0.114s)
[335.523162] [142/161] (774s left) vgem_basic (setversion)
[335.983985] Starting subtest: setversion
[335.991305] Subtest setversion: SUCCESS (0.000s)
[336.324907] [143/161] (774s left) vgem_basic (create)
[336.777217] Starting subtest: create
[336.782565] Subtest create: SUCCESS (0.004s)
[337.121832] [144/161] (773s left) vgem_basic (debugfs)
[337.579664] Starting subtest: debugfs
[337.583469] Subtest debugfs: SUCCESS (0.004s)
[337.925386] [145/161] (773s left) vgem_basic (dmabuf-export)
[338.380536] Starting subtest: dmabuf-export
[338.398249] Subtest dmabuf-export: SUCCESS (0.013s)
[338.754741] [146/161] (772s left) vgem_basic (dmabuf-fence)
[339.211979] Starting subtest: dmabuf-fence
[339.216563] Subtest dmabuf-fence: SUCCESS (0.005s)
[339.556621] [147/161] (772s left) vgem_basic (dmabuf-fence-before)
[340.018568] Starting subtest: dmabuf-fence-before
[340.023554] Subtest dmabuf-fence-before: SUCCESS (0.003s)
[340.356645] [148/161] (771s left) vgem_basic (dmabuf-mmap)
[340.818514] Starting subtest: dmabuf-mmap
[340.891462] Subtest dmabuf-mmap: SUCCESS (0.080s)
[341.226370] [149/161] (771s left) vgem_basic (mmap)
[341.666758] Starting subtest: mmap
[341.750894] Subtest mmap: SUCCESS (0.085s)
[342.138348] [150/161] (770s left) vgem_basic (second-client)
[342.601441] Starting subtest: second-client
[342.634503] Subtest second-client: SUCCESS (0.033s)
[342.977765] [151/161] (770s left) vgem_basic (sysfs)
[343.438203] Starting subtest: sysfs
[343.443725] Subtest sysfs: SUCCESS (0.006s)
[343.775926] [152/161] (769s left) core_hotunplug (unbind-rebind)
[344.514891] Starting subtest: unbind-rebind
[350.660673] Subtest unbind-rebind: SUCCESS (6.145s)
[350.985944] [153/161] (762s left) vgem_basic (unload)
[351.433800] Starting subtest: unload
[381.089833] Subtest unload: SUCCESS (29.657s)
[381.653274] [154/161] (732s left) i915_module_load (reload)
[382.098297] Starting subtest: reload
[392.276485] Subtest reload: SUCCESS (10.170s)
[392.858094] [155/161] (721s left) gem_lmem_swapping (basic)
[393.551248] Subtest basic: SKIP (0.000s)
[393.886511] [156/161] (721s left) gem_lmem_swapping (parallel-random-engines)
[394.352326] Subtest parallel-random-engines: SKIP (0.000s)
[394.675843] [157/161] (720s left) gem_lmem_swapping (random-engines)
[395.141451] Subtest random-engines: SKIP (0.000s)
[395.455313] [158/161] (720s left) gem_lmem_swapping (verify-random)
[395.915986] Subtest verify-random: SKIP (0.000s)
[396.242381] [159/161] (719s left) i915_pm_rpm (module-reload)
[408.156068] Subtest module-reload: SKIP (0.000s)
[408.477850] [160/161] (707s left) i915_selftest (live)
[411.479355] Starting subtest: live
[411.483643] Starting dynamic subtest: sanitycheck
[418.852165] Dynamic subtest sanitycheck: SUCCESS (7.374s)
[418.944320] Starting dynamic subtest: uncore
[426.099810] Dynamic subtest uncore: SUCCESS (7.236s)
[426.187128] Starting dynamic subtest: workarounds
[433.574479] Dynamic subtest workarounds: SUCCESS (7.471s)
[433.651183] Starting dynamic subtest: gt_engines
[440.914855] Dynamic subtest gt_engines: SUCCESS (7.331s)
[440.956964] Starting dynamic subtest: gt_timelines
[454.275466] Dynamic subtest gt_timelines: SUCCESS (13.359s)
[454.325201] Starting dynamic subtest: gt_contexts
[461.494795] Dynamic subtest gt_contexts: SUCCESS (7.212s)
[461.561710] Starting dynamic subtest: gt_lrc
[468.728676] Dynamic subtest gt_lrc: SUCCESS (7.225s)
[468.795671] Starting dynamic subtest: gt_mocs
[476.046099] Dynamic subtest gt_mocs: SUCCESS (7.310s)
[476.091962] Starting dynamic subtest: gt_pm
[483.796818] Dynamic subtest gt_pm: SUCCESS (7.746s)
[483.886860] Starting dynamic subtest: gt_heartbeat
[491.109083] Dynamic subtest gt_heartbeat: SUCCESS (7.306s)
[491.156351] Starting dynamic subtest: gt_tlb
[498.448724] Dynamic subtest gt_tlb: SUCCESS (7.334s)
[498.498605] Starting dynamic subtest: requests
[508.471732] Dynamic subtest requests: SUCCESS (10.016s)
[508.514052] Starting dynamic subtest: migrate
[515.781487] Dynamic subtest migrate: SUCCESS (7.304s)
[515.868834] Starting dynamic subtest: active
[523.242221] Dynamic subtest active: SUCCESS (7.452s)
[523.319185] Starting dynamic subtest: objects
[531.478888] Dynamic subtest objects: SUCCESS (8.228s)
[531.567862] Starting dynamic subtest: mman
[546.281631] Dynamic subtest mman: SUCCESS (14.798s)
[546.323727] Starting dynamic subtest: dmabuf
[553.856312] Dynamic subtest dmabuf: SUCCESS (7.570s)
[553.903274] Starting dynamic subtest: vma
[561.172390] Dynamic subtest vma: SUCCESS (7.311s)
[561.228783] Starting dynamic subtest: coherency
[574.193330] Dynamic subtest coherency: SUCCESS (13.015s)
[574.283968] Starting dynamic subtest: gtt
[584.227874] Dynamic subtest gtt: SUCCESS (10.029s)
[584.275263] Starting dynamic subtest: gem
[591.664973] Dynamic subtest gem: SUCCESS (7.432s)
[591.711202] Starting dynamic subtest: evict
[598.978553] Dynamic subtest evict: SUCCESS (7.307s)
[599.029514] Starting dynamic subtest: hugepages
[606.282224] Dynamic subtest hugepages: SUCCESS (7.299s)
[606.329104] Starting dynamic subtest: gem_contexts
[613.662596] Dynamic subtest gem_contexts: SUCCESS (7.374s)
[613.705970] Starting dynamic subtest: client
[620.953441] Dynamic subtest client: SUCCESS (7.284s)
[621.006438] Starting dynamic subtest: gem_migrate
[628.343140] Dynamic subtest gem_migrate: SUCCESS (7.387s)
[628.394957] Starting dynamic subtest: reset
[637.662993] Dynamic subtest reset: SUCCESS (9.313s)
[637.719781] Starting dynamic subtest: memory_region
[645.034809] Dynamic subtest memory_region: SUCCESS (7.365s)
[645.079857] Starting dynamic subtest: hangcheck
[653.402275] Dynamic subtest hangcheck: SUCCESS (8.360s)
[653.495187] Starting dynamic subtest: execlists
[660.729133] Dynamic subtest execlists: SUCCESS (7.317s)
[660.812136] Starting dynamic subtest: ring_submission
[668.008092] Dynamic subtest ring_submission: SUCCESS (7.275s)
[668.108842] Starting dynamic subtest: perf
[675.283991] Dynamic subtest perf: SUCCESS (7.268s)
[675.330649] Starting dynamic subtest: slpc
[682.527510] Dynamic subtest slpc: SUCCESS (7.236s)
[682.573339] Starting dynamic subtest: guc
[689.910867] Dynamic subtest guc: SUCCESS (7.375s)
[689.982634] Starting dynamic subtest: guc_multi_lrc
[698.417125] Dynamic subtest guc_multi_lrc: SUCCESS (8.498s)
[698.481253] Starting dynamic subtest: guc_hang
[705.975139] Dynamic subtest guc_hang: SUCCESS (7.551s)
[706.026547] Starting dynamic subtest: late_gt_pm
[713.166199] Dynamic subtest late_gt_pm: SUCCESS (7.184s)
[713.170102] Subtest live: SUCCESS (301.687s)
[713.410695] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[713.420680] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[713.433436] [161/161] (403s left) dmabuf (all-tests)
[713.895608] Starting subtest: all-tests
[713.899236] Starting dynamic subtest: sanitycheck
[714.025393] Dynamic subtest sanitycheck: SUCCESS (0.134s)
[714.082565] Starting dynamic subtest: dma_fence
[714.310972] Dynamic subtest dma_fence: SUCCESS (0.279s)
[714.358910] Starting dynamic subtest: dma_fence_chain