[104.387598] Initializing watchdogs
[104.388511]   /dev/watchdog0
[104.518378] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:a001 Intel Pineview (Gen3) Atom Processor D4xx/D5xx/N4xx/N5xx Integrated Graphics Controller (DeskTop Board D510MO)
[104.560387] [001/161] (960s left) i915_module_load (load)
[106.203323] Starting subtest: load
[114.532156] Subtest load: SUCCESS (8.335s)
[115.076790] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[115.089730] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[115.119507] [002/161] (950s left) core_auth (basic-auth)
[115.777515] Starting subtest: basic-auth
[115.782753] Subtest basic-auth: SUCCESS (0.005s)
[116.108564] [003/161] (949s left) debugfs_test (read_all_entries)
[116.611863] Starting subtest: read_all_entries
[116.821483] Subtest read_all_entries: SUCCESS (0.212s)
[117.329281] [004/161] (948s left) debugfs_test (basic-hwmon)
[117.840576] Starting subtest: basic-hwmon
[117.850230] Subtest basic-hwmon: SKIP (0.000s)
[118.278151] [005/161] (948s left) debugfs_test (sysfs)
[118.787277] Starting subtest: sysfs
[118.919950] Subtest sysfs: SUCCESS (0.137s)
[119.274229] [006/161] (947s left) fbdev (eof)
[119.744230] Starting subtest: eof
[119.749456] Subtest eof: SUCCESS (0.002s)
[120.037422] [007/161] (947s left) fbdev (info)
[120.472434] Starting subtest: info
[120.476620] Subtest info: SUCCESS (0.000s)
[120.792864] [008/161] (946s left) fbdev (nullptr)
[121.255764] Starting subtest: nullptr
[121.260192] Subtest nullptr: SUCCESS (0.000s)
[121.555411] [009/161] (946s left) fbdev (read)
[122.003657] Starting subtest: read
[122.309373] Subtest read: SUCCESS (0.309s)
[122.601834] [010/161] (945s left) fbdev (write)
[123.051329] Starting subtest: write
[123.237612] Subtest write: SUCCESS (0.186s)
[123.542319] [011/161] (944s left) gem_basic (bad-close)
[124.001494] Starting subtest: bad-close
[124.008606] Subtest bad-close: SUCCESS (0.000s)
[124.305816] [012/161] (944s left) gem_basic (create-close)
[124.805634] Starting subtest: create-close
[124.815399] Subtest create-close: SUCCESS (0.002s)
[125.161604] [013/161] (943s left) gem_basic (create-fd-close)
[125.615447] Starting subtest: create-fd-close
[125.623809] Subtest create-fd-close: SUCCESS (0.001s)
[125.921972] [014/161] (943s left) gem_busy (busy@all-engines)
[126.468217] Starting subtest: busy
[126.472981] Starting dynamic subtest: all-engines
[126.608248] Dynamic subtest all-engines: SUCCESS (0.142s)
[126.613077] Subtest busy: SUCCESS (0.148s)
[127.326474] [015/161] (942s left) gem_close_race (basic-process)
[127.884458] Starting subtest: basic-process
[128.099968] Subtest basic-process: SUCCESS (0.221s)
[128.562127] [016/161] (941s left) gem_close_race (basic-threads)
[129.104389] Starting subtest: basic-threads
[130.661471] Subtest basic-threads: SUCCESS (1.560s)
[131.113912] [017/161] (938s left) gem_ctx_create (basic)
[131.589148] Subtest basic: SKIP (0.000s)
[131.884248] [018/161] (938s left) gem_ctx_create (basic-files)
[132.353645] Subtest basic-files: SKIP (0.000s)
[132.637486] [019/161] (937s left) gem_ctx_exec (basic)
[133.103716] Subtest basic: SKIP (0.000s)
[133.422682] [020/161] (937s left) gem_exec_basic (basic)
[133.945402] Starting subtest: basic
[133.950723] Starting dynamic subtest: rcs0-smem
[133.954584] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[133.958446] Subtest basic: SUCCESS (0.008s)
[134.421895] [021/161] (936s left) gem_exec_create (basic)
[134.950629] Starting subtest: basic
[134.956517] Starting dynamic subtest: smem
[137.112186] Dynamic subtest smem: SUCCESS (2.161s)
[137.115608] Subtest basic: SUCCESS (2.164s)
[137.563414] [022/161] (933s left) gem_exec_fence (basic-busy)
[138.320571] Starting subtest: basic-busy
[138.325816] Starting dynamic subtest: rcs0
[138.358867] Dynamic subtest rcs0: SUCCESS (0.042s)
[138.362794] Subtest basic-busy: SUCCESS (0.046s)
[139.546603] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[139.558605] [023/161] (932s left) gem_exec_fence (basic-wait)
[140.389581] Starting subtest: basic-wait
[140.395134] Starting dynamic subtest: rcs0
[140.435712] Dynamic subtest rcs0: SUCCESS (0.048s)
[140.440231] Subtest basic-wait: SUCCESS (0.052s)
[141.393644] [024/161] (930s left) gem_exec_fence (basic-await)
[142.151462] Starting subtest: basic-await
[142.156273] Starting dynamic subtest: rcs0
[142.300131] Dynamic subtest rcs0: SUCCESS (0.145s)
[142.304620] Subtest basic-await: SUCCESS (0.150s)
[143.293982] [025/161] (928s left) gem_exec_fence (nb-await)
[144.047643] Starting subtest: nb-await
[144.052794] Starting dynamic subtest: rcs0
[144.117332] Dynamic subtest rcs0: SUCCESS (0.066s)
[144.120986] Subtest nb-await: SUCCESS (0.073s)
[145.093419] [026/161] (927s left) gem_exec_gttfill (basic)
[145.631765] Starting subtest: basic
[155.456936] Subtest basic: SUCCESS (9.829s)
[155.982672] [027/161] (916s left) gem_exec_parallel (engines)
[156.748236] Starting subtest: engines
[156.752435] Starting dynamic subtest: basic
[160.826188] Dynamic subtest basic: SUCCESS (4.078s)
[160.876443] Starting dynamic subtest: contexts
[160.885424] Dynamic subtest contexts: SKIP (0.004s)
[160.937699] Starting dynamic subtest: fds
[160.944224] Dynamic subtest fds: SKIP (0.005s)
[160.983841] Starting dynamic subtest: userptr
[165.074305] Dynamic subtest userptr: SUCCESS (4.229s)
[165.078387] Subtest engines: SUCCESS (8.328s)
[165.576500] [028/161] (907s left) gem_exec_store (basic)
[166.114672] Starting subtest: basic
[166.161821] Subtest basic: SUCCESS (0.048s)
[166.659271] [029/161] (906s left) gem_flink_basic (bad-flink)
[167.107536] Starting subtest: bad-flink
[167.112568] Subtest bad-flink: SUCCESS (0.000s)
[167.457224] [030/161] (906s left) gem_flink_basic (bad-open)
[167.911058] Starting subtest: bad-open
[167.915788] Subtest bad-open: SUCCESS (0.000s)
[168.255956] [031/161] (905s left) gem_flink_basic (basic)
[168.713930] Starting subtest: basic
[168.718642] Subtest basic: SUCCESS (0.001s)
[169.071389] [032/161] (905s left) gem_flink_basic (double-flink)
[169.527168] Starting subtest: double-flink
[169.534626] Subtest double-flink: SUCCESS (0.001s)
[169.982684] [033/161] (904s left) gem_flink_basic (flink-lifetime)
[170.422519] Starting subtest: flink-lifetime
[170.432305] Subtest flink-lifetime: SUCCESS (0.009s)
[170.787987] [034/161] (904s left) gem_huc_copy (huc-copy)
[171.270446] Subtest huc-copy: SKIP (0.000s)
[171.599498] [035/161] (903s left) gem_linear_blits (basic)
[172.398651] Starting subtest: basic
[172.448249] Subtest basic: SUCCESS (0.054s)
[172.903900] [036/161] (902s left) gem_mmap (basic)
[173.608341] Starting subtest: basic
[173.631439] Subtest basic: SUCCESS (0.003s)
[173.957859] [037/161] (902s left) gem_mmap_gtt (basic)
[174.414553] Starting subtest: basic
[174.420606] Subtest basic: SUCCESS (0.005s)
[174.766352] [038/161] (901s left) gem_render_linear_blits (basic)
[175.241955] Starting subtest: basic
[175.385277] Subtest basic: SUCCESS (0.144s)
[175.730600] [039/161] (901s left) gem_render_tiled_blits (basic)
[176.187513] Starting subtest: basic
[176.362586] Subtest basic: SUCCESS (0.169s)
[176.701623] [040/161] (900s left) gem_ringfill (basic-all)
[177.294162] Starting subtest: basic-all
[178.557322] Subtest basic-all: SUCCESS (1.261s)
[178.926152] [041/161] (898s left) gem_softpin (allocator-basic)
[179.425852] Subtest allocator-basic: SKIP (0.000s)
[179.794891] [042/161] (897s left) gem_softpin (allocator-basic-reserve)
[180.276924] Subtest allocator-basic-reserve: SKIP (0.000s)
[180.648326] [043/161] (897s left) gem_softpin (safe-alignment)
[181.145889] Starting subtest: safe-alignment
[181.174831] Subtest safe-alignment: SUCCESS (0.025s)
[181.557867] [044/161] (896s left) gem_sync (basic-all)
[182.107889] Starting subtest: basic-all
[184.348673] Subtest basic-all: SUCCESS (2.243s)
[184.919942] [045/161] (893s left) gem_sync (basic-each)
[185.467104] Starting subtest: basic-each
[187.703570] Subtest basic-each: SUCCESS (2.236s)
[188.201110] [046/161] (890s left) gem_tiled_blits (basic)
[189.015777] Starting subtest: basic
[189.117877] Subtest basic: SUCCESS (0.104s)
[189.559638] [047/161] (889s left) gem_tiled_fence_blits (basic)
[190.661243] Starting subtest: basic
[190.733255] Subtest basic: SUCCESS (0.071s)
[191.178418] [048/161] (888s left) gem_tiled_pread_basic
[193.941907] [049/161] (886s left) gem_wait (busy@all-engines)
[194.539295] Starting subtest: busy
[194.544467] Starting dynamic subtest: all-engines
[195.072137] Dynamic subtest all-engines: SUCCESS (0.536s)
[195.076466] Subtest busy: SUCCESS (0.540s)
[195.737570] [050/161] (884s left) gem_wait (wait@all-engines)
[196.319266] Starting subtest: wait
[196.327359] Starting dynamic subtest: all-engines
[197.369930] Dynamic subtest all-engines: SUCCESS (1.050s)
[197.373719] Subtest wait: SUCCESS (1.054s)
[198.025767] [051/161] (882s left) i915_getparams_basic (basic-eu-total)
[198.476472] Starting subtest: basic-eu-total
[198.484113] Subtest basic-eu-total: SUCCESS (0.000s)
[198.848430] [052/161] (882s left) i915_getparams_basic (basic-subslice-total)
[199.302553] Starting subtest: basic-subslice-total
[199.310685] Subtest basic-subslice-total: SUCCESS (0.000s)
[199.662694] [053/161] (881s left) i915_hangman (error-state-basic)
[200.213872] Starting subtest: error-state-basic
[200.600743] Subtest error-state-basic: SUCCESS (0.380s)
[200.959600] [054/161] (880s left) i915_pciid
[201.761172] [055/161] (880s left) kms_addfb_basic (addfb25-4-tiled)
[202.284441] Starting subtest: addfb25-4-tiled
[202.289414] Subtest addfb25-4-tiled: SUCCESS (0.002s)
[202.651983] [056/161] (879s left) kms_addfb_basic (addfb25-bad-modifier)
[203.149488] Starting subtest: addfb25-bad-modifier
[203.153809] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[203.509483] [057/161] (879s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[204.021727] Starting subtest: addfb25-framebuffer-vs-set-tiling
[204.027405] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[204.380360] [058/161] (878s left) kms_addfb_basic (addfb25-modifier-no-flag)
[204.899547] Starting subtest: addfb25-modifier-no-flag
[204.904711] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[205.267310] [059/161] (878s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[205.769765] Starting subtest: addfb25-x-tiled-legacy
[205.774567] Subtest addfb25-x-tiled-legacy: SUCCESS (0.001s)
[206.151404] [060/161] (877s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[206.652450] Starting subtest: addfb25-x-tiled-mismatch-legacy
[206.656943] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s)
[207.034963] [061/161] (876s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[207.552900] Starting subtest: addfb25-yf-tiled-legacy
[207.556706] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[207.925572] [062/161] (876s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[208.439932] Starting subtest: addfb25-y-tiled-legacy
[208.444641] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s)
[208.837512] [063/161] (875s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[209.359625] Starting subtest: addfb25-y-tiled-small-legacy
[209.368691] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[209.722738] [064/161] (875s left) kms_addfb_basic (bad-pitch-0)
[210.182602] Starting subtest: bad-pitch-0
[210.187174] Subtest bad-pitch-0: SUCCESS (0.000s)
[210.606970] [065/161] (874s left) kms_addfb_basic (bad-pitch-1024)
[211.067434] Starting subtest: bad-pitch-1024
[211.071667] Subtest bad-pitch-1024: SUCCESS (0.000s)
[211.497526] [066/161] (874s left) kms_addfb_basic (bad-pitch-128)
[211.954657] Starting subtest: bad-pitch-128
[211.958577] Subtest bad-pitch-128: SUCCESS (0.000s)
[212.395888] [067/161] (873s left) kms_addfb_basic (bad-pitch-256)
[212.854075] Starting subtest: bad-pitch-256
[212.858881] Subtest bad-pitch-256: SUCCESS (0.000s)
[213.289219] [068/161] (873s left) kms_addfb_basic (bad-pitch-32)
[213.753409] Starting subtest: bad-pitch-32
[213.757770] Subtest bad-pitch-32: SUCCESS (0.000s)
[214.200611] [069/161] (872s left) kms_addfb_basic (bad-pitch-63)
[214.683548] Starting subtest: bad-pitch-63
[214.691336] Subtest bad-pitch-63: SUCCESS (0.000s)
[215.173233] [070/161] (871s left) kms_addfb_basic (bad-pitch-65536)
[215.631248] Starting subtest: bad-pitch-65536
[215.635787] Subtest bad-pitch-65536: SUCCESS (0.002s)
[216.038984] [071/161] (871s left) kms_addfb_basic (bad-pitch-999)
[216.488117] Starting subtest: bad-pitch-999
[216.493127] Subtest bad-pitch-999: SUCCESS (0.000s)
[216.910547] [072/161] (870s left) kms_addfb_basic (basic)
[217.371380] Starting subtest: basic
[217.376083] Subtest basic: SUCCESS (0.000s)
[217.787496] [073/161] (870s left) kms_addfb_basic (basic-x-tiled-legacy)
[218.251764] Starting subtest: basic-x-tiled-legacy
[218.255147] Subtest basic-x-tiled-legacy: SUCCESS (0.001s)
[218.682954] [074/161] (869s left) kms_addfb_basic (basic-y-tiled-legacy)
[219.147563] Starting subtest: basic-y-tiled-legacy
[219.151677] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[219.592552] [075/161] (869s left) kms_addfb_basic (bo-too-small)
[220.107386] Starting subtest: bo-too-small
[220.111301] Subtest bo-too-small: SUCCESS (0.002s)
[220.502919] [076/161] (868s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[220.991471] Starting subtest: bo-too-small-due-to-tiling
[220.995978] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[221.366375] [077/161] (867s left) kms_addfb_basic (clobberred-modifier)
[221.816649] Starting subtest: clobberred-modifier
[221.821746] Subtest clobberred-modifier: SUCCESS (0.001s)
[222.253246] [078/161] (867s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[222.719970] Starting subtest: framebuffer-vs-set-tiling
[222.723989] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[223.127612] [079/161] (866s left) kms_addfb_basic (invalid-get-prop)
[223.582081] Starting subtest: invalid-get-prop
[223.586817] Subtest invalid-get-prop: SUCCESS (0.000s)
[224.018966] [080/161] (866s left) kms_addfb_basic (invalid-get-prop-any)
[224.474269] Starting subtest: invalid-get-prop-any
[224.478841] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[224.903910] [081/161] (865s left) kms_addfb_basic (invalid-set-prop)
[225.364364] Starting subtest: invalid-set-prop
[225.368710] Subtest invalid-set-prop: SUCCESS (0.000s)
[225.795475] [082/161] (865s left) kms_addfb_basic (invalid-set-prop-any)
[226.249644] Starting subtest: invalid-set-prop-any
[226.254187] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[226.679954] [083/161] (864s left) kms_addfb_basic (no-handle)
[227.143568] Starting subtest: no-handle
[227.147717] Subtest no-handle: SUCCESS (0.000s)
[227.573800] [084/161] (864s left) kms_addfb_basic (size-max)
[228.079475] Starting subtest: size-max
[228.084173] Subtest size-max: SUCCESS (0.001s)
[228.445290] [085/161] (863s left) kms_addfb_basic (small-bo)
[228.966602] Starting subtest: small-bo
[228.970818] Subtest small-bo: SUCCESS (0.000s)
[229.334892] [086/161] (862s left) kms_addfb_basic (tile-pitch-mismatch)
[229.853793] Starting subtest: tile-pitch-mismatch
[229.859409] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[230.284236] [087/161] (862s left) kms_addfb_basic (too-high)
[230.798359] Starting subtest: too-high
[230.802681] Subtest too-high: SUCCESS (0.006s)
[231.202778] [088/161] (861s left) kms_addfb_basic (too-wide)
[231.698819] Starting subtest: too-wide
[231.703762] Subtest too-wide: SUCCESS (0.000s)
[232.081410] [089/161] (861s left) kms_addfb_basic (unused-handle)
[232.541325] Starting subtest: unused-handle
[232.545883] Subtest unused-handle: SUCCESS (0.000s)
[232.982963] [090/161] (860s left) kms_addfb_basic (unused-modifier)
[233.434995] Starting subtest: unused-modifier
[233.440153] Subtest unused-modifier: SUCCESS (0.000s)
[233.868520] [091/161] (860s left) kms_addfb_basic (unused-offsets)
[234.326486] Starting subtest: unused-offsets
[234.330995] Subtest unused-offsets: SUCCESS (0.000s)
[234.770468] [092/161] (859s left) kms_addfb_basic (unused-pitches)
[235.225518] Starting subtest: unused-pitches
[235.229358] Subtest unused-pitches: SUCCESS (0.001s)
[235.650210] [093/161] (858s left) kms_busy (basic)
[236.167944] Starting subtest: basic
[236.172900] Starting dynamic subtest: flip
[237.168183] Dynamic subtest flip: SUCCESS (0.998s)
[237.224080] Starting dynamic subtest: modeset
[237.231903] Dynamic subtest modeset: SKIP (0.000s)
[237.235958] Subtest basic: SUCCESS (1.007s)
[237.694153] [094/161] (857s left) kms_prop_blob (basic)
[238.161827] Starting subtest: basic
[238.166885] Subtest basic: SUCCESS (0.000s)
[238.525253] [095/161] (856s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[239.073692] Starting subtest: basic-busy-flip-before-cursor-atomic
[239.098678] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.025s)
[239.544485] [096/161] (856s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[240.068732] Starting subtest: basic-busy-flip-before-cursor-legacy
[241.264261] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.202s)
[241.920335] [097/161] (854s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[242.430464] Starting subtest: basic-flip-after-cursor-atomic
[242.437743] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[242.800120] [098/161] (853s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[243.296256] Starting subtest: basic-flip-after-cursor-legacy
[244.389985] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.093s)
[245.004936] [099/161] (851s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[245.511813] Starting subtest: basic-flip-after-cursor-varying-size
[246.594416] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.087s)
[247.100961] [100/161] (849s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[247.605920] Starting subtest: basic-flip-before-cursor-atomic
[247.615419] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[247.971373] [101/161] (849s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[248.466141] Starting subtest: basic-flip-before-cursor-legacy
[249.553408] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.090s)
[250.083739] [102/161] (847s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[250.586797] Starting subtest: basic-flip-before-cursor-varying-size
[251.667610] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.083s)
[252.194802] [103/161] (845s left) kms_dsc (dsc-basic)
[252.696770] Subtest dsc-basic: SKIP (0.000s)
[253.031274] [104/161] (845s left) kms_flip (basic-flip-vs-dpms)
[253.526401] Starting subtest: basic-flip-vs-dpms
[253.531791] Starting dynamic subtest: A-VGA1
[255.207932] Dynamic subtest A-VGA1: SUCCESS (1.671s)
[255.263157] Starting dynamic subtest: B-VGA1
[256.774869] Dynamic subtest B-VGA1: SUCCESS (1.562s)
[256.779457] Subtest basic-flip-vs-dpms: SUCCESS (3.243s)
[257.460585] [105/161] (841s left) kms_flip (basic-flip-vs-modeset)
[257.951881] Starting subtest: basic-flip-vs-modeset
[257.956416] Starting dynamic subtest: A-VGA1
[259.719869] Dynamic subtest A-VGA1: SUCCESS (1.745s)
[259.780304] Starting dynamic subtest: B-VGA1
[261.479163] Dynamic subtest B-VGA1: SUCCESS (1.765s)
[261.488347] Subtest basic-flip-vs-modeset: SUCCESS (3.523s)
[262.438467] [106/161] (836s left) kms_flip (basic-flip-vs-wf_vblank)
[263.434894] Starting subtest: basic-flip-vs-wf_vblank
[263.440670] Starting dynamic subtest: A-VGA1
[265.430245] Dynamic subtest A-VGA1: SUCCESS (1.982s)
[265.477480] Starting dynamic subtest: B-VGA1
[267.168334] Dynamic subtest B-VGA1: SUCCESS (1.737s)
[267.173762] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.733s)
[267.863292] [107/161] (831s left) kms_flip (basic-plain-flip)
[268.368974] Starting subtest: basic-plain-flip
[268.373385] Starting dynamic subtest: A-VGA1
[269.916179] Dynamic subtest A-VGA1: SUCCESS (1.541s)
[269.971408] Starting dynamic subtest: B-VGA1
[271.370466] Dynamic subtest B-VGA1: SUCCESS (1.442s)
[271.374944] Subtest basic-plain-flip: SUCCESS (2.996s)
[272.068533] [108/161] (827s left) kms_force_connector_basic (force-connector-state)
[272.613528] Starting subtest: force-connector-state
[272.908284] Subtest force-connector-state: SUCCESS (0.289s)
[273.587790] [109/161] (826s left) kms_force_connector_basic (force-edid)
[274.158390] Starting subtest: force-edid
[274.288881] Subtest force-edid: SUCCESS (0.131s)
[274.844277] [110/161] (825s left) kms_force_connector_basic (force-load-detect)
[275.448682] Starting subtest: force-load-detect
[275.981478] Subtest force-load-detect: SUCCESS (0.529s)
[276.613890] [111/161] (824s left) kms_force_connector_basic (prune-stale-modes)
[277.143210] Starting subtest: prune-stale-modes
[277.258541] Subtest prune-stale-modes: SUCCESS (0.116s)
[277.728104] [112/161] (823s left) kms_frontbuffer_tracking (basic)
[278.235321] Subtest basic: SKIP (0.000s)
[278.577652] [113/161] (823s left) kms_hdmi_inject (inject-audio)
[279.038575] Subtest inject-audio: SKIP (0.000s)
[279.377424] [114/161] (822s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[279.859485] Starting subtest: compare-crc-sanitycheck-xr24
[279.864372] Starting dynamic subtest: pipe-A-VGA-1
[280.247568] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.380s)
[280.306319] Starting dynamic subtest: pipe-B-VGA-1
[280.763340] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.504s)
[280.768098] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.899s)
[281.282229] [115/161] (821s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[281.782173] Starting subtest: compare-crc-sanitycheck-nv12
[281.795368] Starting dynamic subtest: pipe-A-VGA-1
[281.805510] Dynamic subtest pipe-A-VGA-1: SKIP (0.001s)
[281.855205] Starting dynamic subtest: pipe-B-VGA-1
[281.863167] Dynamic subtest pipe-B-VGA-1: SKIP (0.002s)
[281.871991] Subtest compare-crc-sanitycheck-nv12: SKIP (0.021s)
[282.173975] [116/161] (820s left) kms_pipe_crc_basic (hang-read-crc)
[282.666879] Starting subtest: hang-read-crc
[282.672727] Starting dynamic subtest: pipe-A-VGA-1
[284.001829] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.329s)
[284.059830] Starting dynamic subtest: pipe-B-VGA-1
[285.467484] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.455s)
[285.473349] Subtest hang-read-crc: SUCCESS (2.800s)
[285.953399] [117/161] (817s left) kms_pipe_crc_basic (nonblocking-crc)
[286.457469] Starting subtest: nonblocking-crc
[286.469996] Starting dynamic subtest: pipe-A-VGA-1
[287.056514] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.592s)
[287.127840] Starting dynamic subtest: pipe-B-VGA-1
[287.787904] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.721s)
[287.793532] Subtest nonblocking-crc: SUCCESS (1.331s)
[288.290743] [118/161] (815s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[288.811429] Starting subtest: nonblocking-crc-frame-sequence
[288.824358] Starting dynamic subtest: pipe-A-VGA-1
[289.439732] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.616s)
[289.502674] Starting dynamic subtest: pipe-B-VGA-1
[290.161378] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.714s)
[290.167535] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.348s)
[290.656725] [119/161] (813s left) kms_pipe_crc_basic (read-crc)
[291.174915] Starting subtest: read-crc
[291.180790] Starting dynamic subtest: pipe-A-VGA-1
[291.734525] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.553s)
[291.802843] Starting dynamic subtest: pipe-B-VGA-1
[292.390299] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.643s)
[292.450552] Subtest read-crc: SUCCESS (1.216s)
[292.889207] [120/161] (811s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[293.396587] Starting subtest: read-crc-frame-sequence
[293.401311] Starting dynamic subtest: pipe-A-VGA-1
[293.941347] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.538s)
[294.005659] Starting dynamic subtest: pipe-B-VGA-1
[294.593267] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.644s)
[294.598316] Subtest read-crc-frame-sequence: SUCCESS (1.202s)
[295.110587] [121/161] (809s left) kms_pm_backlight (basic-brightness)
[295.621778] Subtest basic-brightness: SKIP (0.000s)
[295.953464] [122/161] (808s left) kms_pm_rpm (basic-pci-d3-state)
[307.900175] Subtest basic-pci-d3-state: SKIP (0.000s)
[308.217592] [123/161] (796s left) kms_pm_rpm (basic-rte)
[308.652719] Starting subtest: basic-rte
[320.130745] Subtest basic-rte: SKIP (11.468s)
[320.466234] [124/161] (784s left) kms_psr (psr-primary-page-flip)
[320.971793] Subtest psr-primary-page-flip: SKIP (0.000s)
[321.304676] [125/161] (784s left) kms_psr (psr-cursor-plane-move)
[321.804540] Subtest psr-cursor-plane-move: SKIP (0.000s)
[322.136398] [126/161] (783s left) kms_psr (psr-sprite-plane-onoff)
[322.636601] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[322.977934] [127/161] (783s left) kms_psr (psr-primary-mmap-gtt)
[323.470496] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[323.807533] [128/161] (782s left) kms_setmode (basic-clone-single-crtc)
[324.260182] Starting subtest: basic-clone-single-crtc
[324.272792] Subtest basic-clone-single-crtc: SKIP (0.001s)
[324.614646] [129/161] (782s left) i915_pm_rps (basic-api)
[325.087374] Subtest basic-api: SKIP (0.000s)
[325.426840] [130/161] (781s left) prime_self_import (basic-llseek-bad)
[325.874565] Starting subtest: basic-llseek-bad
[325.884825] Subtest basic-llseek-bad: SUCCESS (0.013s)
[326.232654] [131/161] (781s left) prime_self_import (basic-llseek-size)
[326.670516] Starting subtest: basic-llseek-size
[326.698661] Subtest basic-llseek-size: SUCCESS (0.028s)
[327.047878] [132/161] (780s left) prime_self_import (basic-with_fd_dup)
[327.479522] Starting subtest: basic-with_fd_dup
[327.503497] Subtest basic-with_fd_dup: SUCCESS (0.022s)
[327.875492] [133/161] (780s left) prime_self_import (basic-with_one_bo)
[328.317297] Starting subtest: basic-with_one_bo
[328.341638] Subtest basic-with_one_bo: SUCCESS (0.028s)
[328.688318] [134/161] (779s left) prime_self_import (basic-with_one_bo_two_files)
[329.121933] Starting subtest: basic-with_one_bo_two_files
[329.144367] Subtest basic-with_one_bo_two_files: SUCCESS (0.019s)
[329.497985] [135/161] (779s left) prime_self_import (basic-with_two_bos)
[329.928595] Starting subtest: basic-with_two_bos
[329.949140] Subtest basic-with_two_bos: SUCCESS (0.022s)
[330.303782] [136/161] (778s left) prime_vgem (basic-fence-flip)
[330.785918] Starting subtest: basic-fence-flip
[331.453403] Subtest basic-fence-flip: SUCCESS (0.669s)
[331.839893] [137/161] (777s left) prime_vgem (basic-fence-mmap)
[332.336766] Starting subtest: basic-fence-mmap
[332.537718] Subtest basic-fence-mmap: SUCCESS (0.203s)
[332.906826] [138/161] (776s left) prime_vgem (basic-fence-read)
[333.400136] Starting subtest: basic-fence-read
[333.682554] Subtest basic-fence-read: SUCCESS (0.282s)
[334.056742] [139/161] (776s left) prime_vgem (basic-gtt)
[334.550689] Starting subtest: basic-gtt
[334.649168] Subtest basic-gtt: SUCCESS (0.094s)
[335.091372] [140/161] (775s left) prime_vgem (basic-read)
[335.568432] Starting subtest: basic-read
[335.679099] Subtest basic-read: SUCCESS (0.108s)
[336.045492] [141/161] (774s left) prime_vgem (basic-write)
[336.539165] Starting subtest: basic-write
[336.648822] Subtest basic-write: SUCCESS (0.116s)
[337.030687] [142/161] (774s left) vgem_basic (setversion)
[337.493172] Starting subtest: setversion
[337.500962] Subtest setversion: SUCCESS (0.000s)
[337.837855] [143/161] (773s left) vgem_basic (create)
[338.294566] Starting subtest: create
[338.299705] Subtest create: SUCCESS (0.003s)
[338.643874] [144/161] (773s left) vgem_basic (debugfs)
[339.095538] Starting subtest: debugfs
[339.100252] Subtest debugfs: SUCCESS (0.004s)
[339.443590] [145/161] (772s left) vgem_basic (dmabuf-export)
[339.891877] Starting subtest: dmabuf-export
[339.906697] Subtest dmabuf-export: SUCCESS (0.015s)
[340.283534] [146/161] (772s left) vgem_basic (dmabuf-fence)
[340.749608] Starting subtest: dmabuf-fence
[340.753815] Subtest dmabuf-fence: SUCCESS (0.004s)
[341.086521] [147/161] (771s left) vgem_basic (dmabuf-fence-before)
[341.529090] Starting subtest: dmabuf-fence-before
[341.533934] Subtest dmabuf-fence-before: SUCCESS (0.004s)
[341.880300] [148/161] (771s left) vgem_basic (dmabuf-mmap)
[342.328445] Starting subtest: dmabuf-mmap
[342.408274] Subtest dmabuf-mmap: SUCCESS (0.082s)
[342.757674] [149/161] (770s left) vgem_basic (mmap)
[343.215117] Starting subtest: mmap
[343.275584] Subtest mmap: SUCCESS (0.065s)
[343.627323] [150/161] (770s left) vgem_basic (second-client)
[344.083630] Starting subtest: second-client
[344.111269] Subtest second-client: SUCCESS (0.033s)
[344.461574] [151/161] (769s left) vgem_basic (sysfs)
[345.064676] Starting subtest: sysfs
[345.072372] Subtest sysfs: SUCCESS (0.007s)
[345.469921] [152/161] (768s left) core_hotunplug (unbind-rebind)
[346.434851] Starting subtest: unbind-rebind
[353.118536] Subtest unbind-rebind: SUCCESS (6.684s)
[353.662465] [153/161] (761s left) vgem_basic (unload)
[354.213317] Starting subtest: unload
[383.965710] Subtest unload: SUCCESS (29.748s)
[384.522398] [154/161] (730s left) i915_module_load (reload)
[384.970887] Starting subtest: reload
[395.012204] Subtest reload: SUCCESS (10.035s)
[395.598903] [155/161] (720s left) gem_lmem_swapping (basic)
[396.439850] Subtest basic: SKIP (0.000s)
[396.842977] [156/161] (719s left) gem_lmem_swapping (parallel-random-engines)
[397.323309] Subtest parallel-random-engines: SKIP (0.000s)
[397.655274] [157/161] (718s left) gem_lmem_swapping (random-engines)
[398.129706] Subtest random-engines: SKIP (0.000s)
[398.454273] [158/161] (718s left) gem_lmem_swapping (verify-random)
[398.920564] Subtest verify-random: SKIP (0.000s)
[399.259845] [159/161] (717s left) i915_pm_rpm (module-reload)
[411.185820] Subtest module-reload: SKIP (0.000s)
[411.513384] [160/161] (706s left) i915_selftest (live)
[414.464706] Starting subtest: live
[414.469606] Starting dynamic subtest: sanitycheck
[421.910556] Dynamic subtest sanitycheck: SUCCESS (7.442s)
[421.976563] Starting dynamic subtest: uncore
[429.349304] Dynamic subtest uncore: SUCCESS (7.431s)
[429.434934] Starting dynamic subtest: workarounds
[436.739434] Dynamic subtest workarounds: SUCCESS (7.384s)
[436.821612] Starting dynamic subtest: gt_engines
[444.399312] Dynamic subtest gt_engines: SUCCESS (7.656s)
[444.443674] Starting dynamic subtest: gt_timelines
[457.898499] Dynamic subtest gt_timelines: SUCCESS (13.493s)
[457.957617] Starting dynamic subtest: gt_contexts
[465.326562] Dynamic subtest gt_contexts: SUCCESS (7.423s)
[465.391262] Starting dynamic subtest: gt_lrc
[472.694959] Dynamic subtest gt_lrc: SUCCESS (7.360s)
[472.737890] Starting dynamic subtest: gt_mocs
[480.171307] Dynamic subtest gt_mocs: SUCCESS (7.467s)
[480.230948] Starting dynamic subtest: gt_pm
[488.118224] Dynamic subtest gt_pm: SUCCESS (7.944s)
[488.201209] Starting dynamic subtest: gt_heartbeat
[495.523088] Dynamic subtest gt_heartbeat: SUCCESS (7.399s)
[495.584852] Starting dynamic subtest: gt_tlb
[503.039376] Dynamic subtest gt_tlb: SUCCESS (7.511s)
[503.098649] Starting dynamic subtest: requests
[513.097443] Dynamic subtest requests: SUCCESS (10.054s)
[513.145693] Starting dynamic subtest: migrate
[520.515534] Dynamic subtest migrate: SUCCESS (7.408s)
[520.578106] Starting dynamic subtest: active
[527.973787] Dynamic subtest active: SUCCESS (7.454s)
[528.035643] Starting dynamic subtest: objects
[536.338822] Dynamic subtest objects: SUCCESS (8.357s)
[536.416824] Starting dynamic subtest: mman
[550.992118] Dynamic subtest mman: SUCCESS (14.648s)
[551.041305] Starting dynamic subtest: dmabuf
[558.524299] Dynamic subtest dmabuf: SUCCESS (7.526s)
[558.566555] Starting dynamic subtest: vma
[566.081569] Dynamic subtest vma: SUCCESS (7.551s)
[566.124337] Starting dynamic subtest: coherency
[579.095086] Dynamic subtest coherency: SUCCESS (13.006s)
[579.181760] Starting dynamic subtest: gtt
[589.598894] Dynamic subtest gtt: SUCCESS (10.500s)
[589.674360] Starting dynamic subtest: gem
[597.272375] Dynamic subtest gem: SUCCESS (7.664s)
[597.330425] Starting dynamic subtest: evict
[604.554384] Dynamic subtest evict: SUCCESS (7.275s)
[604.618740] Starting dynamic subtest: hugepages
[612.241505] Dynamic subtest hugepages: SUCCESS (7.679s)
[612.287529] Starting dynamic subtest: gem_contexts
[619.784870] Dynamic subtest gem_contexts: SUCCESS (7.534s)
[619.892536] Starting dynamic subtest: client
[627.238705] Dynamic subtest client: SUCCESS (7.444s)
[627.334288] Starting dynamic subtest: gem_migrate
[634.634348] Dynamic subtest gem_migrate: SUCCESS (7.384s)
[634.716336] Starting dynamic subtest: reset
[644.121484] Dynamic subtest reset: SUCCESS (9.482s)
[644.163804] Starting dynamic subtest: memory_region
[651.612477] Dynamic subtest memory_region: SUCCESS (7.483s)
[651.658500] Starting dynamic subtest: hangcheck
[660.157131] Dynamic subtest hangcheck: SUCCESS (8.539s)
[660.217748] Starting dynamic subtest: execlists
[667.632979] Dynamic subtest execlists: SUCCESS (7.470s)
[667.691621] Starting dynamic subtest: ring_submission
[675.147172] Dynamic subtest ring_submission: SUCCESS (7.504s)
[675.191613] Starting dynamic subtest: perf
[682.612505] Dynamic subtest perf: SUCCESS (7.461s)
[682.680360] Starting dynamic subtest: slpc
[690.046601] Dynamic subtest slpc: SUCCESS (7.423s)
[690.091388] Starting dynamic subtest: guc
[699.442164] Dynamic subtest guc: SUCCESS (9.388s)
[699.494154] Starting dynamic subtest: guc_multi_lrc
[706.896903] Dynamic subtest guc_multi_lrc: SUCCESS (7.448s)
[706.975837] Starting dynamic subtest: guc_hang
[714.359909] Dynamic subtest guc_hang: SUCCESS (7.455s)
[714.412834] Starting dynamic subtest: late_gt_pm
[721.801209] Dynamic subtest late_gt_pm: SUCCESS (7.431s)
[721.806498] Subtest live: SUCCESS (307.341s)
[722.074299] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[722.084544] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[722.097221] [161/161] (395s left) dmabuf (all-tests)
[722.568830] Starting subtest: all-tests
[722.572898] Starting dynamic subtest: sanitycheck
[722.682726] Dynamic subtest sanitycheck: SUCCESS (0.120s)
[722.744389] Starting dynamic subtest: dma_fence
[723.037570] Dynamic subtest dma_fence: SUCCESS (0.346s)
[723.088958] Starting dynamic subtest: dma_fence_chain