[106.744321] Initializing watchdogs
[106.745106]   /dev/watchdog0
[106.873964] [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)
[106.906562] [001/161] (960s left) i915_module_load (load)
[108.522941] Starting subtest: load
[116.632871] Subtest load: SUCCESS (8.119s)
[117.214298] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[117.228715] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[117.260555] [002/161] (950s left) core_auth (basic-auth)
[118.038905] Starting subtest: basic-auth
[118.045449] Subtest basic-auth: SUCCESS (0.005s)
[118.460537] [003/161] (949s left) debugfs_test (read_all_entries)
[118.974385] Starting subtest: read_all_entries
[119.228810] Subtest read_all_entries: SUCCESS (0.243s)
[119.955429] [004/161] (949s left) debugfs_test (basic-hwmon)
[120.523599] Starting subtest: basic-hwmon
[120.532927] Subtest basic-hwmon: SKIP (0.000s)
[121.007346] [005/161] (948s left) debugfs_test (sysfs)
[121.528513] Starting subtest: sysfs
[121.747617] Subtest sysfs: SUCCESS (0.219s)
[122.204868] [006/161] (947s left) fbdev (eof)
[122.711949] Starting subtest: eof
[122.717624] Subtest eof: SUCCESS (0.003s)
[123.026745] [007/161] (947s left) fbdev (info)
[123.467227] Starting subtest: info
[123.472872] Subtest info: SUCCESS (0.000s)
[123.798862] [008/161] (946s left) fbdev (nullptr)
[124.255341] Starting subtest: nullptr
[124.261257] Subtest nullptr: SUCCESS (0.002s)
[124.556385] [009/161] (946s left) fbdev (read)
[125.023891] Starting subtest: read
[125.365212] Subtest read: SUCCESS (0.344s)
[125.677661] [010/161] (945s left) fbdev (write)
[126.161255] Starting subtest: write
[126.349841] Subtest write: SUCCESS (0.192s)
[126.646205] [011/161] (944s left) gem_basic (bad-close)
[127.175636] Starting subtest: bad-close
[127.183816] Subtest bad-close: SUCCESS (0.000s)
[127.481949] [012/161] (944s left) gem_basic (create-close)
[127.926833] Starting subtest: create-close
[127.936802] Subtest create-close: SUCCESS (0.001s)
[128.270638] [013/161] (943s left) gem_basic (create-fd-close)
[128.719762] Starting subtest: create-fd-close
[128.727861] Subtest create-fd-close: SUCCESS (0.001s)
[129.027095] [014/161] (943s left) gem_busy (busy@all-engines)
[129.554434] Starting subtest: busy
[129.559398] Starting dynamic subtest: all-engines
[129.695142] Dynamic subtest all-engines: SUCCESS (0.142s)
[129.700805] Subtest busy: SUCCESS (0.146s)
[130.414561] [015/161] (941s left) gem_close_race (basic-process)
[130.956173] Starting subtest: basic-process
[131.175520] Subtest basic-process: SUCCESS (0.222s)
[131.651165] [016/161] (941s left) gem_close_race (basic-threads)
[132.284783] Starting subtest: basic-threads
[133.948363] Subtest basic-threads: SUCCESS (1.665s)
[134.423674] [017/161] (938s left) gem_ctx_create (basic)
[134.909479] Subtest basic: SKIP (0.000s)
[135.196332] [018/161] (938s left) gem_ctx_create (basic-files)
[135.658740] Subtest basic-files: SKIP (0.000s)
[135.971959] [019/161] (937s left) gem_ctx_exec (basic)
[136.441123] Subtest basic: SKIP (0.000s)
[136.741697] [020/161] (937s left) gem_exec_basic (basic)
[137.256767] Starting subtest: basic
[137.261514] Starting dynamic subtest: rcs0-smem
[137.265257] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[137.268686] Subtest basic: SUCCESS (0.008s)
[137.725099] [021/161] (936s left) gem_exec_create (basic)
[138.260487] Starting subtest: basic
[138.264515] Starting dynamic subtest: smem
[140.423114] Dynamic subtest smem: SUCCESS (2.168s)
[140.426801] Subtest basic: SUCCESS (2.171s)
[140.932899] [022/161] (933s left) gem_exec_fence (basic-busy)
[141.709165] Starting subtest: basic-busy
[141.713847] Starting dynamic subtest: rcs0
[141.756179] Dynamic subtest rcs0: SUCCESS (0.044s)
[141.761357] Subtest basic-busy: SUCCESS (0.048s)
[142.994874] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[143.007691] [023/161] (931s left) gem_exec_fence (basic-wait)
[143.756366] Starting subtest: basic-wait
[143.762287] Starting dynamic subtest: rcs0
[143.803933] Dynamic subtest rcs0: SUCCESS (0.042s)
[143.807989] Subtest basic-wait: SUCCESS (0.048s)
[144.772654] [024/161] (930s left) gem_exec_fence (basic-await)
[145.524660] Starting subtest: basic-await
[145.529147] Starting dynamic subtest: rcs0
[145.679635] Dynamic subtest rcs0: SUCCESS (0.149s)
[145.683608] Subtest basic-await: SUCCESS (0.153s)
[146.651214] [025/161] (928s left) gem_exec_fence (nb-await)
[147.460322] Starting subtest: nb-await
[147.468417] Starting dynamic subtest: rcs0
[147.531757] Dynamic subtest rcs0: SUCCESS (0.069s)
[147.536762] Subtest nb-await: SUCCESS (0.074s)
[148.497557] [026/161] (927s left) gem_exec_gttfill (basic)
[149.035232] Starting subtest: basic
[159.041501] Subtest basic: SUCCESS (10.012s)
[159.591777] [027/161] (916s left) gem_exec_parallel (engines)
[160.417614] Starting subtest: engines
[160.423468] Starting dynamic subtest: basic
[164.784871] Dynamic subtest basic: SUCCESS (4.368s)
[164.839422] Starting dynamic subtest: contexts
[164.847109] Dynamic subtest contexts: SKIP (0.004s)
[164.888696] Starting dynamic subtest: fds
[164.896619] Dynamic subtest fds: SKIP (0.005s)
[164.937485] Starting dynamic subtest: userptr
[169.502561] Dynamic subtest userptr: SUCCESS (4.696s)
[169.507732] Subtest engines: SUCCESS (9.088s)
[170.017497] [028/161] (906s left) gem_exec_store (basic)
[170.579657] Starting subtest: basic
[170.628984] Subtest basic: SUCCESS (0.057s)
[171.127938] [029/161] (905s left) gem_flink_basic (bad-flink)
[171.586597] Starting subtest: bad-flink
[171.591687] Subtest bad-flink: SUCCESS (0.000s)
[171.943470] [030/161] (904s left) gem_flink_basic (bad-open)
[172.394964] Starting subtest: bad-open
[172.401611] Subtest bad-open: SUCCESS (0.000s)
[172.729269] [031/161] (904s left) gem_flink_basic (basic)
[173.177941] Starting subtest: basic
[173.182948] Subtest basic: SUCCESS (0.001s)
[173.555512] [032/161] (904s left) gem_flink_basic (double-flink)
[174.015649] Starting subtest: double-flink
[174.019964] Subtest double-flink: SUCCESS (0.001s)
[174.379402] [033/161] (903s left) gem_flink_basic (flink-lifetime)
[174.831801] Starting subtest: flink-lifetime
[174.843223] Subtest flink-lifetime: SUCCESS (0.010s)
[175.237939] [034/161] (902s left) gem_huc_copy (huc-copy)
[175.760883] Subtest huc-copy: SKIP (0.000s)
[176.139757] [035/161] (902s left) gem_linear_blits (basic)
[177.264560] Starting subtest: basic
[177.318195] Subtest basic: SUCCESS (0.059s)
[177.772177] [036/161] (901s left) gem_mmap (basic)
[178.494449] Starting subtest: basic
[178.518277] Subtest basic: SUCCESS (0.003s)
[178.870971] [037/161] (900s left) gem_mmap_gtt (basic)
[179.363910] Starting subtest: basic
[179.369986] Subtest basic: SUCCESS (0.005s)
[179.749312] [038/161] (899s left) gem_render_linear_blits (basic)
[180.224571] Starting subtest: basic
[180.400986] Subtest basic: SUCCESS (0.176s)
[180.766420] [039/161] (899s left) gem_render_tiled_blits (basic)
[181.253130] Starting subtest: basic
[181.431889] Subtest basic: SUCCESS (0.177s)
[181.809964] [040/161] (898s left) gem_ringfill (basic-all)
[182.422676] Starting subtest: basic-all
[183.650877] Subtest basic-all: SUCCESS (1.226s)
[184.055170] [041/161] (896s left) gem_softpin (allocator-basic)
[184.531551] Subtest allocator-basic: SKIP (0.000s)
[184.895581] [042/161] (896s left) gem_softpin (allocator-basic-reserve)
[185.412155] Subtest allocator-basic-reserve: SKIP (0.000s)
[185.817804] [043/161] (895s left) gem_softpin (safe-alignment)
[186.298315] Starting subtest: safe-alignment
[186.313426] Subtest safe-alignment: SUCCESS (0.021s)
[186.722939] [044/161] (894s left) gem_sync (basic-all)
[187.287306] Starting subtest: basic-all
[189.534350] Subtest basic-all: SUCCESS (2.249s)
[190.026967] [045/161] (891s left) gem_sync (basic-each)
[190.564756] Starting subtest: basic-each
[192.893723] Subtest basic-each: SUCCESS (2.331s)
[193.416701] [046/161] (888s left) gem_tiled_blits (basic)
[194.458515] Starting subtest: basic
[194.563658] Subtest basic: SUCCESS (0.106s)
[195.063894] [047/161] (887s left) gem_tiled_fence_blits (basic)
[196.336139] Starting subtest: basic
[196.425161] Subtest basic: SUCCESS (0.090s)
[197.007231] [048/161] (886s left) gem_tiled_pread_basic
[200.075131] [049/161] (883s left) gem_wait (busy@all-engines)
[200.715104] Starting subtest: busy
[200.719199] Starting dynamic subtest: all-engines
[201.249533] Dynamic subtest all-engines: SUCCESS (0.537s)
[201.255791] Subtest busy: SUCCESS (0.541s)
[201.900944] [050/161] (881s left) gem_wait (wait@all-engines)
[202.478968] Starting subtest: wait
[202.483645] Starting dynamic subtest: all-engines
[203.528950] Dynamic subtest all-engines: SUCCESS (1.049s)
[203.534149] Subtest wait: SUCCESS (1.055s)
[204.184697] [051/161] (879s left) i915_getparams_basic (basic-eu-total)
[204.635570] Starting subtest: basic-eu-total
[204.643604] Subtest basic-eu-total: SUCCESS (0.000s)
[204.989587] [052/161] (879s left) i915_getparams_basic (basic-subslice-total)
[205.437691] Starting subtest: basic-subslice-total
[205.449819] Subtest basic-subslice-total: SUCCESS (0.001s)
[205.802821] [053/161] (878s left) i915_hangman (error-state-basic)
[206.283805] Starting subtest: error-state-basic
[206.686956] Subtest error-state-basic: SUCCESS (0.395s)
[207.176488] [054/161] (877s left) i915_pciid
[207.984772] [055/161] (877s left) kms_addfb_basic (addfb25-4-tiled)
[208.512767] Starting subtest: addfb25-4-tiled
[208.518410] Subtest addfb25-4-tiled: SUCCESS (0.002s)
[208.892547] [056/161] (876s left) kms_addfb_basic (addfb25-bad-modifier)
[209.391310] Starting subtest: addfb25-bad-modifier
[209.396269] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[209.769878] [057/161] (876s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[210.273972] Starting subtest: addfb25-framebuffer-vs-set-tiling
[210.279599] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[210.640370] [058/161] (875s left) kms_addfb_basic (addfb25-modifier-no-flag)
[211.161253] Starting subtest: addfb25-modifier-no-flag
[211.166433] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[211.524510] [059/161] (875s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[212.046146] Starting subtest: addfb25-x-tiled-legacy
[212.051546] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[212.422723] [060/161] (874s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[212.929883] Starting subtest: addfb25-x-tiled-mismatch-legacy
[212.934556] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s)
[213.303788] [061/161] (874s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[213.818116] Starting subtest: addfb25-yf-tiled-legacy
[213.825311] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[214.179705] [062/161] (873s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[214.726160] Starting subtest: addfb25-y-tiled-legacy
[214.732099] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s)
[215.119127] [063/161] (872s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[215.616512] Starting subtest: addfb25-y-tiled-small-legacy
[215.626721] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[215.977546] [064/161] (872s left) kms_addfb_basic (bad-pitch-0)
[216.467550] Starting subtest: bad-pitch-0
[216.473300] Subtest bad-pitch-0: SUCCESS (0.000s)
[216.934200] [065/161] (871s left) kms_addfb_basic (bad-pitch-1024)
[217.462594] Starting subtest: bad-pitch-1024
[217.469141] Subtest bad-pitch-1024: SUCCESS (0.000s)
[217.929750] [066/161] (871s left) kms_addfb_basic (bad-pitch-128)
[218.380704] Starting subtest: bad-pitch-128
[218.385601] Subtest bad-pitch-128: SUCCESS (0.000s)
[218.824208] [067/161] (870s left) kms_addfb_basic (bad-pitch-256)
[219.304692] Starting subtest: bad-pitch-256
[219.311729] Subtest bad-pitch-256: SUCCESS (0.000s)
[219.739426] [068/161] (869s left) kms_addfb_basic (bad-pitch-32)
[220.197280] Starting subtest: bad-pitch-32
[220.201947] Subtest bad-pitch-32: SUCCESS (0.000s)
[220.606675] [069/161] (869s left) kms_addfb_basic (bad-pitch-63)
[221.056230] Starting subtest: bad-pitch-63
[221.061522] Subtest bad-pitch-63: SUCCESS (0.000s)
[221.473805] [070/161] (868s left) kms_addfb_basic (bad-pitch-65536)
[222.021176] Starting subtest: bad-pitch-65536
[222.026089] Subtest bad-pitch-65536: SUCCESS (0.002s)
[222.459495] [071/161] (868s left) kms_addfb_basic (bad-pitch-999)
[222.935646] Starting subtest: bad-pitch-999
[222.942223] Subtest bad-pitch-999: SUCCESS (0.000s)
[223.365856] [072/161] (867s left) kms_addfb_basic (basic)
[223.813373] Starting subtest: basic
[223.817805] Subtest basic: SUCCESS (0.001s)
[224.236904] [073/161] (867s left) kms_addfb_basic (basic-x-tiled-legacy)
[224.721849] Starting subtest: basic-x-tiled-legacy
[224.726695] Subtest basic-x-tiled-legacy: SUCCESS (0.001s)
[225.145384] [074/161] (866s left) kms_addfb_basic (basic-y-tiled-legacy)
[225.608322] Starting subtest: basic-y-tiled-legacy
[225.613407] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[226.015794] [075/161] (865s left) kms_addfb_basic (bo-too-small)
[226.556405] Starting subtest: bo-too-small
[226.561796] Subtest bo-too-small: SUCCESS (0.002s)
[226.916111] [076/161] (865s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[227.451141] Starting subtest: bo-too-small-due-to-tiling
[227.459448] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[227.812981] [077/161] (864s left) kms_addfb_basic (clobberred-modifier)
[228.260776] Starting subtest: clobberred-modifier
[228.265087] Subtest clobberred-modifier: SUCCESS (0.001s)
[228.695947] [078/161] (864s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[229.150244] Starting subtest: framebuffer-vs-set-tiling
[229.154813] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[229.592998] [079/161] (863s left) kms_addfb_basic (invalid-get-prop)
[230.042234] Starting subtest: invalid-get-prop
[230.048287] Subtest invalid-get-prop: SUCCESS (0.000s)
[230.494757] [080/161] (863s left) kms_addfb_basic (invalid-get-prop-any)
[230.951402] Starting subtest: invalid-get-prop-any
[230.955806] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[231.375170] [081/161] (862s left) kms_addfb_basic (invalid-set-prop)
[231.837473] Starting subtest: invalid-set-prop
[231.842144] Subtest invalid-set-prop: SUCCESS (0.000s)
[232.256641] [082/161] (862s left) kms_addfb_basic (invalid-set-prop-any)
[232.705588] Starting subtest: invalid-set-prop-any
[232.711654] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[233.128090] [083/161] (861s left) kms_addfb_basic (no-handle)
[233.582086] Starting subtest: no-handle
[233.585918] Subtest no-handle: SUCCESS (0.000s)
[234.003174] [084/161] (860s left) kms_addfb_basic (size-max)
[234.503597] Starting subtest: size-max
[234.509131] Subtest size-max: SUCCESS (0.001s)
[234.881182] [085/161] (860s left) kms_addfb_basic (small-bo)
[235.374245] Starting subtest: small-bo
[235.379651] Subtest small-bo: SUCCESS (0.000s)
[235.749714] [086/161] (859s left) kms_addfb_basic (tile-pitch-mismatch)
[236.220580] Starting subtest: tile-pitch-mismatch
[236.224749] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[236.661217] [087/161] (859s left) kms_addfb_basic (too-high)
[237.238352] Starting subtest: too-high
[237.243522] Subtest too-high: SUCCESS (0.005s)
[237.631613] [088/161] (858s left) kms_addfb_basic (too-wide)
[238.147796] Starting subtest: too-wide
[238.153615] Subtest too-wide: SUCCESS (0.000s)
[238.509263] [089/161] (858s left) kms_addfb_basic (unused-handle)
[238.969492] Starting subtest: unused-handle
[238.974420] Subtest unused-handle: SUCCESS (0.000s)
[239.380602] [090/161] (857s left) kms_addfb_basic (unused-modifier)
[239.842483] Starting subtest: unused-modifier
[239.847644] Subtest unused-modifier: SUCCESS (0.000s)
[240.243533] [091/161] (857s left) kms_addfb_basic (unused-offsets)
[240.694093] Starting subtest: unused-offsets
[240.698933] Subtest unused-offsets: SUCCESS (0.000s)
[241.124504] [092/161] (856s left) kms_addfb_basic (unused-pitches)
[241.572097] Starting subtest: unused-pitches
[241.577435] Subtest unused-pitches: SUCCESS (0.000s)
[241.994811] [093/161] (855s left) kms_busy (basic)
[242.528585] Starting subtest: basic
[242.533459] Starting dynamic subtest: flip
[243.629396] Dynamic subtest flip: SUCCESS (1.092s)
[243.698693] Starting dynamic subtest: modeset
[243.707836] Dynamic subtest modeset: SKIP (0.000s)
[243.712441] Subtest basic: SUCCESS (1.125s)
[244.140294] [094/161] (854s left) kms_prop_blob (basic)
[244.602903] Starting subtest: basic
[244.607960] Subtest basic: SUCCESS (0.000s)
[244.963220] [095/161] (853s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[245.488136] Starting subtest: basic-busy-flip-before-cursor-atomic
[245.506108] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.019s)
[245.863923] [096/161] (853s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[246.348426] Starting subtest: basic-busy-flip-before-cursor-legacy
[247.456678] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.106s)
[247.955377] [097/161] (851s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[248.461207] Starting subtest: basic-flip-after-cursor-atomic
[248.471071] Subtest basic-flip-after-cursor-atomic: SKIP (0.001s)
[248.836807] [098/161] (850s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[249.340223] Starting subtest: basic-flip-after-cursor-legacy
[250.435445] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.094s)
[250.931517] [099/161] (848s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[251.419892] Starting subtest: basic-flip-after-cursor-varying-size
[252.510216] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.089s)
[253.013554] [100/161] (847s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[253.541510] Starting subtest: basic-flip-before-cursor-atomic
[253.551124] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[253.909447] [101/161] (846s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[254.410825] Starting subtest: basic-flip-before-cursor-legacy
[255.495819] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.087s)
[256.026459] [102/161] (844s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[256.533166] Starting subtest: basic-flip-before-cursor-varying-size
[257.617868] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.089s)
[258.135359] [103/161] (842s left) kms_dsc (dsc-basic)
[258.625400] Subtest dsc-basic: SKIP (0.000s)
[258.966795] [104/161] (842s left) kms_flip (basic-flip-vs-dpms)
[259.478545] Starting subtest: basic-flip-vs-dpms
[259.482839] Starting dynamic subtest: A-VGA1
[261.134911] Dynamic subtest A-VGA1: SUCCESS (1.649s)
[261.192373] Starting dynamic subtest: B-VGA1
[262.658658] Dynamic subtest B-VGA1: SUCCESS (1.521s)
[262.664569] Subtest basic-flip-vs-dpms: SUCCESS (3.182s)
[263.343842] [105/161] (838s left) kms_flip (basic-flip-vs-modeset)
[263.840902] Starting subtest: basic-flip-vs-modeset
[263.846346] Starting dynamic subtest: A-VGA1
[265.524773] Dynamic subtest A-VGA1: SUCCESS (1.679s)
[265.581231] Starting dynamic subtest: B-VGA1
[267.047965] Dynamic subtest B-VGA1: SUCCESS (1.516s)
[267.052929] Subtest basic-flip-vs-modeset: SUCCESS (3.211s)
[267.691270] [106/161] (834s left) kms_flip (basic-flip-vs-wf_vblank)
[268.193891] Starting subtest: basic-flip-vs-wf_vblank
[268.200600] Starting dynamic subtest: A-VGA1
[270.031622] Dynamic subtest A-VGA1: SUCCESS (1.822s)
[270.077485] Starting dynamic subtest: B-VGA1
[271.760134] Dynamic subtest B-VGA1: SUCCESS (1.733s)
[271.766403] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.567s)
[272.494667] [107/161] (829s left) kms_flip (basic-plain-flip)
[273.013804] Starting subtest: basic-plain-flip
[273.019759] Starting dynamic subtest: A-VGA1
[274.568165] Dynamic subtest A-VGA1: SUCCESS (1.551s)
[274.624981] Starting dynamic subtest: B-VGA1
[276.012372] Dynamic subtest B-VGA1: SUCCESS (1.438s)
[276.017935] Subtest basic-plain-flip: SUCCESS (3.001s)
[276.720993] [108/161] (826s left) kms_force_connector_basic (force-connector-state)
[277.260728] Starting subtest: force-connector-state
[277.571829] Subtest force-connector-state: SUCCESS (0.306s)
[278.240328] [109/161] (824s left) kms_force_connector_basic (force-edid)
[278.792768] Starting subtest: force-edid
[278.908810] Subtest force-edid: SUCCESS (0.114s)
[279.365600] [110/161] (824s left) kms_force_connector_basic (force-load-detect)
[279.923137] Starting subtest: force-load-detect
[280.443811] Subtest force-load-detect: SUCCESS (0.517s)
[281.156765] [111/161] (822s left) kms_force_connector_basic (prune-stale-modes)
[281.802486] Starting subtest: prune-stale-modes
[281.979806] Subtest prune-stale-modes: SUCCESS (0.167s)
[282.534691] [112/161] (821s left) kms_frontbuffer_tracking (basic)
[283.117425] Subtest basic: SKIP (0.000s)
[283.462275] [113/161] (821s left) kms_hdmi_inject (inject-audio)
[283.922624] Subtest inject-audio: SKIP (0.000s)
[284.260365] [114/161] (820s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[284.764382] Starting subtest: compare-crc-sanitycheck-xr24
[284.769602] Starting dynamic subtest: pipe-A-VGA-1
[285.210367] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.436s)
[285.272069] Starting dynamic subtest: pipe-B-VGA-1
[285.780179] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.557s)
[285.787392] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.012s)
[286.496657] [115/161] (818s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[287.037690] Starting subtest: compare-crc-sanitycheck-nv12
[287.050747] Starting dynamic subtest: pipe-A-VGA-1
[287.060862] Dynamic subtest pipe-A-VGA-1: SKIP (0.001s)
[287.111631] Starting dynamic subtest: pipe-B-VGA-1
[287.119961] Dynamic subtest pipe-B-VGA-1: SKIP (0.002s)
[287.129083] Subtest compare-crc-sanitycheck-nv12: SKIP (0.021s)
[287.430680] [116/161] (818s left) kms_pipe_crc_basic (hang-read-crc)
[287.930157] Starting subtest: hang-read-crc
[287.935936] Starting dynamic subtest: pipe-A-VGA-1
[289.286965] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.353s)
[289.336722] Starting dynamic subtest: pipe-B-VGA-1
[290.745917] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.448s)
[290.751608] Subtest hang-read-crc: SUCCESS (2.820s)
[291.244407] [117/161] (814s left) kms_pipe_crc_basic (nonblocking-crc)
[291.750233] Starting subtest: nonblocking-crc
[291.756300] Starting dynamic subtest: pipe-A-VGA-1
[292.356774] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.602s)
[292.407497] Starting dynamic subtest: pipe-B-VGA-1
[293.082425] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.713s)
[293.087431] Subtest nonblocking-crc: SUCCESS (1.335s)
[293.582387] [118/161] (812s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[294.106749] Starting subtest: nonblocking-crc-frame-sequence
[294.112543] Starting dynamic subtest: pipe-A-VGA-1
[294.704346] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.589s)
[294.754937] Starting dynamic subtest: pipe-B-VGA-1
[295.452719] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.740s)
[295.456882] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.348s)
[295.974144] [119/161] (810s left) kms_pipe_crc_basic (read-crc)
[296.478550] Starting subtest: read-crc
[296.482878] Starting dynamic subtest: pipe-A-VGA-1
[297.045726] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.559s)
[297.127914] Starting dynamic subtest: pipe-B-VGA-1
[297.706661] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.651s)
[297.712441] Subtest read-crc: SUCCESS (1.231s)
[298.217883] [120/161] (808s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[298.708304] Starting subtest: read-crc-frame-sequence
[298.719119] Starting dynamic subtest: pipe-A-VGA-1
[299.277434] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.560s)
[299.328501] Starting dynamic subtest: pipe-B-VGA-1
[299.948818] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.659s)
[299.954366] Subtest read-crc-frame-sequence: SUCCESS (1.239s)
[300.450704] [121/161] (806s left) kms_pm_backlight (basic-brightness)
[300.959852] Subtest basic-brightness: SKIP (0.000s)
[301.290829] [122/161] (806s left) kms_pm_rpm (basic-pci-d3-state)
[313.209498] Subtest basic-pci-d3-state: SKIP (0.000s)
[313.532099] [123/161] (794s left) kms_pm_rpm (basic-rte)
[313.993231] Starting subtest: basic-rte
[325.466109] Subtest basic-rte: SKIP (11.463s)
[325.797151] [124/161] (782s left) kms_psr (psr-primary-page-flip)
[326.297747] Subtest psr-primary-page-flip: SKIP (0.000s)
[326.610358] [125/161] (782s left) kms_psr (psr-cursor-plane-move)
[327.193725] Subtest psr-cursor-plane-move: SKIP (0.000s)
[327.526543] [126/161] (781s left) kms_psr (psr-sprite-plane-onoff)
[328.036344] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[328.386730] [127/161] (780s left) kms_psr (psr-primary-mmap-gtt)
[328.889509] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[329.246583] [128/161] (780s left) kms_setmode (basic-clone-single-crtc)
[329.703762] Starting subtest: basic-clone-single-crtc
[329.719295] Subtest basic-clone-single-crtc: SKIP (0.001s)
[330.050304] [129/161] (779s left) i915_pm_rps (basic-api)
[330.519227] Subtest basic-api: SKIP (0.000s)
[330.842568] [130/161] (779s left) prime_self_import (basic-llseek-bad)
[331.284621] Starting subtest: basic-llseek-bad
[331.297537] Subtest basic-llseek-bad: SUCCESS (0.014s)
[331.654363] [131/161] (778s left) prime_self_import (basic-llseek-size)
[332.088682] Starting subtest: basic-llseek-size
[332.113623] Subtest basic-llseek-size: SUCCESS (0.026s)
[332.468986] [132/161] (778s left) prime_self_import (basic-with_fd_dup)
[332.903612] Starting subtest: basic-with_fd_dup
[332.926290] Subtest basic-with_fd_dup: SUCCESS (0.020s)
[333.275834] [133/161] (777s left) prime_self_import (basic-with_one_bo)
[333.726802] Starting subtest: basic-with_one_bo
[333.753775] Subtest basic-with_one_bo: SUCCESS (0.029s)
[334.113309] [134/161] (777s left) prime_self_import (basic-with_one_bo_two_files)
[334.556518] Starting subtest: basic-with_one_bo_two_files
[334.579299] Subtest basic-with_one_bo_two_files: SUCCESS (0.020s)
[334.946726] [135/161] (776s left) prime_self_import (basic-with_two_bos)
[335.406818] Starting subtest: basic-with_two_bos
[335.425788] Subtest basic-with_two_bos: SUCCESS (0.023s)
[335.800957] [136/161] (776s left) prime_vgem (basic-fence-flip)
[336.328122] Starting subtest: basic-fence-flip
[337.073997] Subtest basic-fence-flip: SUCCESS (0.736s)
[337.471882] [137/161] (775s left) prime_vgem (basic-fence-mmap)
[338.037516] Starting subtest: basic-fence-mmap
[338.235788] Subtest basic-fence-mmap: SUCCESS (0.199s)
[338.610963] [138/161] (774s left) prime_vgem (basic-fence-read)
[339.089864] Starting subtest: basic-fence-read
[339.357808] Subtest basic-fence-read: SUCCESS (0.272s)
[339.725953] [139/161] (773s left) prime_vgem (basic-gtt)
[340.200442] Starting subtest: basic-gtt
[340.282570] Subtest basic-gtt: SUCCESS (0.080s)
[340.659943] [140/161] (772s left) prime_vgem (basic-read)
[341.146870] Starting subtest: basic-read
[341.253166] Subtest basic-read: SUCCESS (0.112s)
[341.630468] [141/161] (772s left) prime_vgem (basic-write)
[342.171329] Starting subtest: basic-write
[342.283495] Subtest basic-write: SUCCESS (0.117s)
[342.639566] [142/161] (771s left) vgem_basic (setversion)
[343.102447] Starting subtest: setversion
[343.110439] Subtest setversion: SUCCESS (0.000s)
[343.438582] [143/161] (771s left) vgem_basic (create)
[343.905184] Starting subtest: create
[343.909790] Subtest create: SUCCESS (0.002s)
[344.246423] [144/161] (770s left) vgem_basic (debugfs)
[344.703081] Starting subtest: debugfs
[344.708869] Subtest debugfs: SUCCESS (0.004s)
[345.050212] [145/161] (770s left) vgem_basic (dmabuf-export)
[345.517356] Starting subtest: dmabuf-export
[345.529457] Subtest dmabuf-export: SUCCESS (0.012s)
[345.926136] [146/161] (769s left) vgem_basic (dmabuf-fence)
[346.385598] Starting subtest: dmabuf-fence
[346.390352] Subtest dmabuf-fence: SUCCESS (0.005s)
[346.728139] [147/161] (769s left) vgem_basic (dmabuf-fence-before)
[347.185452] Starting subtest: dmabuf-fence-before
[347.189748] Subtest dmabuf-fence-before: SUCCESS (0.004s)
[347.529472] [148/161] (768s left) vgem_basic (dmabuf-mmap)
[348.006519] Starting subtest: dmabuf-mmap
[348.077134] Subtest dmabuf-mmap: SUCCESS (0.080s)
[348.411787] [149/161] (767s left) vgem_basic (mmap)
[348.866103] Starting subtest: mmap
[348.925294] Subtest mmap: SUCCESS (0.061s)
[349.260664] [150/161] (767s left) vgem_basic (second-client)
[349.703548] Starting subtest: second-client
[349.735320] Subtest second-client: SUCCESS (0.031s)
[350.078977] [151/161] (766s left) vgem_basic (sysfs)
[350.558494] Starting subtest: sysfs
[350.564229] Subtest sysfs: SUCCESS (0.006s)
[350.933743] [152/161] (766s left) core_hotunplug (unbind-rebind)
[351.700363] Starting subtest: unbind-rebind
[357.579695] Subtest unbind-rebind: SUCCESS (5.871s)
[357.942849] [153/161] (759s left) vgem_basic (unload)
[358.393175] Starting subtest: unload
[388.091846] Subtest unload: SUCCESS (29.702s)
[388.612364] [154/161] (729s left) i915_module_load (reload)
[389.044447] Starting subtest: reload
[398.945205] Subtest reload: SUCCESS (9.884s)
[399.838670] [155/161] (719s left) gem_lmem_swapping (basic)
[400.717556] Subtest basic: SKIP (0.000s)
[401.052140] [156/161] (718s left) gem_lmem_swapping (parallel-random-engines)
[401.555408] Subtest parallel-random-engines: SKIP (0.000s)
[402.152444] [157/161] (717s left) gem_lmem_swapping (random-engines)
[402.685598] Subtest random-engines: SKIP (0.000s)
[403.023370] [158/161] (717s left) gem_lmem_swapping (verify-random)
[403.495406] Subtest verify-random: SKIP (0.000s)
[403.818883] [159/161] (716s left) i915_pm_rpm (module-reload)
[415.769140] Subtest module-reload: SKIP (0.000s)
[416.102746] [160/161] (704s left) i915_selftest (live)
[419.173668] Starting subtest: live
[419.178376] Starting dynamic subtest: sanitycheck
[426.561461] Dynamic subtest sanitycheck: SUCCESS (7.390s)
[426.631743] Starting dynamic subtest: uncore
[434.226132] Dynamic subtest uncore: SUCCESS (7.656s)
[434.286101] Starting dynamic subtest: workarounds
[441.670602] Dynamic subtest workarounds: SUCCESS (7.443s)
[441.726613] Starting dynamic subtest: gt_engines
[449.157744] Dynamic subtest gt_engines: SUCCESS (7.478s)
[449.217711] Starting dynamic subtest: gt_timelines
[463.006610] Dynamic subtest gt_timelines: SUCCESS (13.844s)
[463.053470] Starting dynamic subtest: gt_contexts
[470.576174] Dynamic subtest gt_contexts: SUCCESS (7.553s)
[470.639839] Starting dynamic subtest: gt_lrc
[478.698956] Dynamic subtest gt_lrc: SUCCESS (8.124s)
[478.761224] Starting dynamic subtest: gt_mocs
[487.200232] Dynamic subtest gt_mocs: SUCCESS (8.496s)
[487.246363] Starting dynamic subtest: gt_pm
[494.902144] Dynamic subtest gt_pm: SUCCESS (7.695s)
[494.998553] Starting dynamic subtest: gt_heartbeat
[502.403494] Dynamic subtest gt_heartbeat: SUCCESS (7.495s)
[502.488296] Starting dynamic subtest: gt_tlb
[509.879605] Dynamic subtest gt_tlb: SUCCESS (7.470s)
[509.940249] Starting dynamic subtest: requests
[519.974949] Dynamic subtest requests: SUCCESS (10.090s)
[520.023542] Starting dynamic subtest: migrate
[527.673384] Dynamic subtest migrate: SUCCESS (7.685s)
[527.719658] Starting dynamic subtest: active
[535.192944] Dynamic subtest active: SUCCESS (7.514s)
[535.253568] Starting dynamic subtest: objects
[543.388665] Dynamic subtest objects: SUCCESS (8.191s)
[543.474308] Starting dynamic subtest: mman
[558.325706] Dynamic subtest mman: SUCCESS (14.931s)
[558.403909] Starting dynamic subtest: dmabuf
[565.907926] Dynamic subtest dmabuf: SUCCESS (7.576s)
[565.954694] Starting dynamic subtest: vma
[573.810384] Dynamic subtest vma: SUCCESS (7.897s)
[573.859253] Starting dynamic subtest: coherency
[586.956230] Dynamic subtest coherency: SUCCESS (13.139s)
[587.001530] Starting dynamic subtest: gtt
[597.411857] Dynamic subtest gtt: SUCCESS (10.449s)
[597.483790] Starting dynamic subtest: gem
[605.094759] Dynamic subtest gem: SUCCESS (7.677s)
[605.186511] Starting dynamic subtest: evict
[612.650556] Dynamic subtest evict: SUCCESS (7.545s)
[612.719661] Starting dynamic subtest: hugepages
[620.198122] Dynamic subtest hugepages: SUCCESS (7.535s)
[620.244518] Starting dynamic subtest: gem_contexts
[627.831178] Dynamic subtest gem_contexts: SUCCESS (7.624s)
[627.919568] Starting dynamic subtest: client
[635.319079] Dynamic subtest client: SUCCESS (7.481s)
[635.380493] Starting dynamic subtest: gem_migrate
[642.929288] Dynamic subtest gem_migrate: SUCCESS (7.603s)
[643.017471] Starting dynamic subtest: reset
[652.335478] Dynamic subtest reset: SUCCESS (9.396s)
[652.426333] Starting dynamic subtest: memory_region
[659.855689] Dynamic subtest memory_region: SUCCESS (7.517s)
[659.936423] Starting dynamic subtest: hangcheck
[668.420667] Dynamic subtest hangcheck: SUCCESS (8.552s)
[668.472788] Starting dynamic subtest: execlists
[675.851529] Dynamic subtest execlists: SUCCESS (7.422s)
[675.913346] Starting dynamic subtest: ring_submission
[683.282375] Dynamic subtest ring_submission: SUCCESS (7.422s)
[683.374694] Starting dynamic subtest: perf
[690.985901] Dynamic subtest perf: SUCCESS (7.694s)
[691.047417] Starting dynamic subtest: slpc
[699.405195] Dynamic subtest slpc: SUCCESS (8.410s)
[699.468247] Starting dynamic subtest: guc
[706.980285] Dynamic subtest guc: SUCCESS (7.571s)
[707.046202] Starting dynamic subtest: guc_multi_lrc
[714.495683] Dynamic subtest guc_multi_lrc: SUCCESS (7.504s)
[714.547310] Starting dynamic subtest: guc_hang
[721.980342] Dynamic subtest guc_hang: SUCCESS (7.478s)
[722.031382] Starting dynamic subtest: late_gt_pm
[729.400401] Dynamic subtest late_gt_pm: SUCCESS (7.411s)
[729.405744] Subtest live: SUCCESS (310.231s)
[729.668832] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[729.679456] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[729.691858] [161/161] (391s left) dmabuf (all-tests)
[730.175416] Starting subtest: all-tests
[730.180155] Starting dynamic subtest: sanitycheck
[730.317767] Dynamic subtest sanitycheck: SUCCESS (0.148s)
[730.382547] Starting dynamic subtest: dma_fence
[730.604981] Dynamic subtest dma_fence: SUCCESS (0.280s)
[730.653415] Starting dynamic subtest: dma_fence_chain