[145.884689] Initializing watchdogs
[145.885558]   /dev/watchdog0
[146.012930] [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)
[146.045534] [001/161] (960s left) i915_module_load (load)
[147.635457] Starting subtest: load
[157.478956] Subtest load: SUCCESS (9.846s)
[158.228968] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[158.242562] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[158.275696] [002/161] (948s left) core_auth (basic-auth)
[159.059817] Starting subtest: basic-auth
[159.069516] Subtest basic-auth: SUCCESS (0.007s)
[159.418653] [003/161] (948s left) debugfs_test (read_all_entries)
[159.978163] Starting subtest: read_all_entries
[160.195257] Subtest read_all_entries: SUCCESS (0.218s)
[160.678393] [004/161] (947s left) debugfs_test (basic-hwmon)
[161.144197] Starting subtest: basic-hwmon
[161.151857] Subtest basic-hwmon: SKIP (0.000s)
[161.516416] [005/161] (946s left) debugfs_test (sysfs)
[161.999882] Starting subtest: sysfs
[162.162987] Subtest sysfs: SUCCESS (0.155s)
[162.551883] [006/161] (945s left) fbdev (eof)
[163.068933] Starting subtest: eof
[163.078197] Subtest eof: SUCCESS (0.003s)
[163.370363] [007/161] (945s left) fbdev (info)
[163.809267] Starting subtest: info
[163.812862] Subtest info: SUCCESS (0.000s)
[164.114644] [008/161] (944s left) fbdev (nullptr)
[164.567470] Starting subtest: nullptr
[164.571411] Subtest nullptr: SUCCESS (0.001s)
[164.869912] [009/161] (944s left) fbdev (read)
[165.314770] Starting subtest: read
[165.621398] Subtest read: SUCCESS (0.307s)
[165.912350] [010/161] (943s left) fbdev (write)
[166.369368] Starting subtest: write
[166.557569] Subtest write: SUCCESS (0.192s)
[166.853693] [011/161] (943s left) gem_basic (bad-close)
[167.301192] Starting subtest: bad-close
[167.310759] Subtest bad-close: SUCCESS (0.000s)
[167.598463] [012/161] (942s left) gem_basic (create-close)
[168.051799] Starting subtest: create-close
[168.059347] Subtest create-close: SUCCESS (0.001s)
[168.371469] [013/161] (942s left) gem_basic (create-fd-close)
[168.808263] Starting subtest: create-fd-close
[168.818445] Subtest create-fd-close: SUCCESS (0.001s)
[169.120543] [014/161] (941s left) gem_busy (busy@all-engines)
[169.657494] Starting subtest: busy
[169.661752] Starting dynamic subtest: all-engines
[169.796438] Dynamic subtest all-engines: SUCCESS (0.143s)
[169.802157] Subtest busy: SUCCESS (0.147s)
[170.505805] [015/161] (940s left) gem_close_race (basic-process)
[171.047127] Starting subtest: basic-process
[171.261562] Subtest basic-process: SUCCESS (0.221s)
[171.728399] [016/161] (939s left) gem_close_race (basic-threads)
[172.257404] Starting subtest: basic-threads
[173.861807] Subtest basic-threads: SUCCESS (1.602s)
[174.311258] [017/161] (937s left) gem_ctx_create (basic)
[174.778369] Subtest basic: SKIP (0.000s)
[175.066607] [018/161] (936s left) gem_ctx_create (basic-files)
[175.531508] Subtest basic-files: SKIP (0.000s)
[175.819366] [019/161] (936s left) gem_ctx_exec (basic)
[176.291576] Subtest basic: SKIP (0.000s)
[176.605210] [020/161] (935s left) gem_exec_basic (basic)
[177.120433] Starting subtest: basic
[177.125412] Starting dynamic subtest: rcs0-smem
[177.129626] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[177.132932] Subtest basic: SUCCESS (0.009s)
[177.583177] [021/161] (935s left) gem_exec_create (basic)
[178.174276] Starting subtest: basic
[178.178220] Starting dynamic subtest: smem
[180.333296] Dynamic subtest smem: SUCCESS (2.163s)
[180.337537] Subtest basic: SUCCESS (2.167s)
[180.800717] [022/161] (932s left) gem_exec_fence (basic-busy)
[181.551950] Starting subtest: basic-busy
[181.557351] Starting dynamic subtest: rcs0
[181.602347] Dynamic subtest rcs0: SUCCESS (0.053s)
[181.606120] Subtest basic-busy: SUCCESS (0.057s)
[182.786431] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[182.798715] [023/161] (930s left) gem_exec_fence (basic-wait)
[183.554740] Starting subtest: basic-wait
[183.558633] Starting dynamic subtest: rcs0
[183.599691] Dynamic subtest rcs0: SUCCESS (0.046s)
[183.603132] Subtest basic-wait: SUCCESS (0.051s)
[184.569641] [024/161] (928s left) gem_exec_fence (basic-await)
[185.327267] Starting subtest: basic-await
[185.331721] Starting dynamic subtest: rcs0
[185.472502] Dynamic subtest rcs0: SUCCESS (0.146s)
[185.477944] Subtest basic-await: SUCCESS (0.152s)
[186.440527] [025/161] (927s left) gem_exec_fence (nb-await)
[187.193299] Starting subtest: nb-await
[187.198169] Starting dynamic subtest: rcs0
[187.260247] Dynamic subtest rcs0: SUCCESS (0.064s)
[187.265513] Subtest nb-await: SUCCESS (0.068s)
[188.229122] [026/161] (925s left) gem_exec_gttfill (basic)
[188.772127] Starting subtest: basic
[198.959179] Subtest basic: SUCCESS (10.191s)
[199.523310] [027/161] (915s left) gem_exec_parallel (engines)
[200.273836] Starting subtest: engines
[200.278490] Starting dynamic subtest: basic
[204.523958] Dynamic subtest basic: SUCCESS (4.247s)
[204.584236] Starting dynamic subtest: contexts
[204.591837] Dynamic subtest contexts: SKIP (0.004s)
[204.632946] Starting dynamic subtest: fds
[204.640360] Dynamic subtest fds: SKIP (0.004s)
[204.680187] Starting dynamic subtest: userptr
[208.989314] Dynamic subtest userptr: SUCCESS (4.451s)
[208.993133] Subtest engines: SUCCESS (8.718s)
[209.495464] [028/161] (905s left) gem_exec_store (basic)
[210.028256] Starting subtest: basic
[210.079448] Subtest basic: SUCCESS (0.053s)
[210.568347] [029/161] (904s left) gem_flink_basic (bad-flink)
[211.020787] Starting subtest: bad-flink
[211.024592] Subtest bad-flink: SUCCESS (0.000s)
[211.370929] [030/161] (904s left) gem_flink_basic (bad-open)
[211.824569] Starting subtest: bad-open
[211.828438] Subtest bad-open: SUCCESS (0.000s)
[212.176886] [031/161] (903s left) gem_flink_basic (basic)
[212.631396] Starting subtest: basic
[212.635311] Subtest basic: SUCCESS (0.001s)
[212.998412] [032/161] (903s left) gem_flink_basic (double-flink)
[213.446976] Starting subtest: double-flink
[213.451618] Subtest double-flink: SUCCESS (0.001s)
[213.810897] [033/161] (902s left) gem_flink_basic (flink-lifetime)
[214.258087] Starting subtest: flink-lifetime
[214.263481] Subtest flink-lifetime: SUCCESS (0.010s)
[214.620880] [034/161] (902s left) gem_huc_copy (huc-copy)
[215.113343] Subtest huc-copy: SKIP (0.000s)
[215.432119] [035/161] (901s left) gem_linear_blits (basic)
[216.207122] Starting subtest: basic
[216.269880] Subtest basic: SUCCESS (0.064s)
[216.716415] [036/161] (900s left) gem_mmap (basic)
[217.417701] Starting subtest: basic
[217.436951] Subtest basic: SUCCESS (0.004s)
[217.773532] [037/161] (899s left) gem_mmap_gtt (basic)
[218.230328] Starting subtest: basic
[218.235405] Subtest basic: SUCCESS (0.005s)
[218.582924] [038/161] (899s left) gem_render_linear_blits (basic)
[219.048516] Starting subtest: basic
[219.189177] Subtest basic: SUCCESS (0.143s)
[219.515274] [039/161] (898s left) gem_render_tiled_blits (basic)
[219.969772] Starting subtest: basic
[220.127515] Subtest basic: SUCCESS (0.156s)
[220.467576] [040/161] (898s left) gem_ringfill (basic-all)
[221.053166] Starting subtest: basic-all
[222.278931] Subtest basic-all: SUCCESS (1.229s)
[222.649967] [041/161] (896s left) gem_softpin (allocator-basic)
[223.202770] Subtest allocator-basic: SKIP (0.000s)
[223.545738] [042/161] (895s left) gem_softpin (allocator-basic-reserve)
[224.016644] Subtest allocator-basic-reserve: SKIP (0.000s)
[224.362859] [043/161] (895s left) gem_softpin (safe-alignment)
[224.838296] Starting subtest: safe-alignment
[224.857693] Subtest safe-alignment: SUCCESS (0.029s)
[225.230332] [044/161] (894s left) gem_sync (basic-all)
[225.764384] Starting subtest: basic-all
[227.979594] Subtest basic-all: SUCCESS (2.210s)
[228.475604] [045/161] (891s left) gem_sync (basic-each)
[229.010862] Starting subtest: basic-each
[231.498668] Subtest basic-each: SUCCESS (2.489s)
[231.986820] [046/161] (888s left) gem_tiled_blits (basic)
[232.845272] Starting subtest: basic
[232.957815] Subtest basic: SUCCESS (0.114s)
[233.392815] [047/161] (887s left) gem_tiled_fence_blits (basic)
[234.495224] Starting subtest: basic
[234.559539] Subtest basic: SUCCESS (0.068s)
[234.996168] [048/161] (886s left) gem_tiled_pread_basic
[237.778637] [049/161] (883s left) gem_wait (busy@all-engines)
[238.419743] Starting subtest: busy
[238.424766] Starting dynamic subtest: all-engines
[238.955920] Dynamic subtest all-engines: SUCCESS (0.535s)
[238.962287] Subtest busy: SUCCESS (0.539s)
[239.637437] [050/161] (882s left) gem_wait (wait@all-engines)
[240.243386] Starting subtest: wait
[240.247660] Starting dynamic subtest: all-engines
[241.290818] Dynamic subtest all-engines: SUCCESS (1.052s)
[241.294692] Subtest wait: SUCCESS (1.056s)
[241.944476] [051/161] (880s left) i915_getparams_basic (basic-eu-total)
[242.384706] Starting subtest: basic-eu-total
[242.396336] Subtest basic-eu-total: SUCCESS (0.000s)
[242.742675] [052/161] (879s left) i915_getparams_basic (basic-subslice-total)
[243.226239] Starting subtest: basic-subslice-total
[243.236569] Subtest basic-subslice-total: SUCCESS (0.002s)
[243.582694] [053/161] (879s left) i915_hangman (error-state-basic)
[244.066640] Starting subtest: error-state-basic
[244.483249] Subtest error-state-basic: SUCCESS (0.416s)
[244.819262] [054/161] (878s left) i915_pciid
[245.631592] [055/161] (877s left) kms_addfb_basic (addfb25-4-tiled)
[246.155125] Starting subtest: addfb25-4-tiled
[246.159602] Subtest addfb25-4-tiled: SUCCESS (0.002s)
[246.527977] [056/161] (877s left) kms_addfb_basic (addfb25-bad-modifier)
[247.037449] Starting subtest: addfb25-bad-modifier
[247.042848] Subtest addfb25-bad-modifier: SUCCESS (0.003s)
[247.421244] [057/161] (876s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[247.935703] Starting subtest: addfb25-framebuffer-vs-set-tiling
[247.940717] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.001s)
[248.303157] [058/161] (876s left) kms_addfb_basic (addfb25-modifier-no-flag)
[248.787758] Starting subtest: addfb25-modifier-no-flag
[248.792767] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[249.170967] [059/161] (875s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[249.689522] Starting subtest: addfb25-x-tiled-legacy
[249.693728] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[250.075236] [060/161] (875s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[250.569534] Starting subtest: addfb25-x-tiled-mismatch-legacy
[250.574718] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s)
[250.950562] [061/161] (874s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[251.456641] Starting subtest: addfb25-yf-tiled-legacy
[251.462146] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[251.821492] [062/161] (874s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[252.327225] Starting subtest: addfb25-y-tiled-legacy
[252.331675] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s)
[252.691423] [063/161] (873s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[253.278585] Starting subtest: addfb25-y-tiled-small-legacy
[253.285117] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[253.636699] [064/161] (872s left) kms_addfb_basic (bad-pitch-0)
[254.095534] Starting subtest: bad-pitch-0
[254.099371] Subtest bad-pitch-0: SUCCESS (0.000s)
[254.542850] [065/161] (872s left) kms_addfb_basic (bad-pitch-1024)
[255.004604] Starting subtest: bad-pitch-1024
[255.009601] Subtest bad-pitch-1024: SUCCESS (0.000s)
[255.428691] [066/161] (871s left) kms_addfb_basic (bad-pitch-128)
[255.884882] Starting subtest: bad-pitch-128
[255.889816] Subtest bad-pitch-128: SUCCESS (0.000s)
[256.293270] [067/161] (871s left) kms_addfb_basic (bad-pitch-256)
[256.746624] Starting subtest: bad-pitch-256
[256.750700] Subtest bad-pitch-256: SUCCESS (0.000s)
[257.191984] [068/161] (870s left) kms_addfb_basic (bad-pitch-32)
[257.651911] Starting subtest: bad-pitch-32
[257.657756] Subtest bad-pitch-32: SUCCESS (0.000s)
[258.093493] [069/161] (870s left) kms_addfb_basic (bad-pitch-63)
[258.546703] Starting subtest: bad-pitch-63
[258.550534] Subtest bad-pitch-63: SUCCESS (0.000s)
[258.979893] [070/161] (869s left) kms_addfb_basic (bad-pitch-65536)
[259.431256] Starting subtest: bad-pitch-65536
[259.435136] Subtest bad-pitch-65536: SUCCESS (0.002s)
[259.861727] [071/161] (868s left) kms_addfb_basic (bad-pitch-999)
[260.320578] Starting subtest: bad-pitch-999
[260.325440] Subtest bad-pitch-999: SUCCESS (0.000s)
[260.737136] [072/161] (868s left) kms_addfb_basic (basic)
[261.189570] Starting subtest: basic
[261.194786] Subtest basic: SUCCESS (0.000s)
[261.595363] [073/161] (867s left) kms_addfb_basic (basic-x-tiled-legacy)
[262.047704] Starting subtest: basic-x-tiled-legacy
[262.052546] Subtest basic-x-tiled-legacy: SUCCESS (0.001s)
[262.467646] [074/161] (867s left) kms_addfb_basic (basic-y-tiled-legacy)
[262.927408] Starting subtest: basic-y-tiled-legacy
[262.931897] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[263.331879] [075/161] (866s left) kms_addfb_basic (bo-too-small)
[263.831472] Starting subtest: bo-too-small
[263.836356] Subtest bo-too-small: SUCCESS (0.002s)
[264.213397] [076/161] (866s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[264.708748] Starting subtest: bo-too-small-due-to-tiling
[264.714312] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[265.096443] [077/161] (865s left) kms_addfb_basic (clobberred-modifier)
[265.546866] Starting subtest: clobberred-modifier
[265.551666] Subtest clobberred-modifier: SUCCESS (0.001s)
[265.946128] [078/161] (865s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[266.403522] Starting subtest: framebuffer-vs-set-tiling
[266.406985] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[266.862586] [079/161] (864s left) kms_addfb_basic (invalid-get-prop)
[267.318505] Starting subtest: invalid-get-prop
[267.322738] Subtest invalid-get-prop: SUCCESS (0.000s)
[267.742740] [080/161] (864s left) kms_addfb_basic (invalid-get-prop-any)
[268.276771] Starting subtest: invalid-get-prop-any
[268.281368] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[268.711925] [081/161] (863s left) kms_addfb_basic (invalid-set-prop)
[269.162668] Starting subtest: invalid-set-prop
[269.167664] Subtest invalid-set-prop: SUCCESS (0.000s)
[269.600087] [082/161] (862s left) kms_addfb_basic (invalid-set-prop-any)
[270.052442] Starting subtest: invalid-set-prop-any
[270.057179] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[270.442200] [083/161] (862s left) kms_addfb_basic (no-handle)
[270.896835] Starting subtest: no-handle
[270.901239] Subtest no-handle: SUCCESS (0.000s)
[271.317218] [084/161] (861s left) kms_addfb_basic (size-max)
[271.820188] Starting subtest: size-max
[271.825380] Subtest size-max: SUCCESS (0.001s)
[272.199819] [085/161] (861s left) kms_addfb_basic (small-bo)
[272.698153] Starting subtest: small-bo
[272.703441] Subtest small-bo: SUCCESS (0.000s)
[273.078701] [086/161] (860s left) kms_addfb_basic (tile-pitch-mismatch)
[273.540485] Starting subtest: tile-pitch-mismatch
[273.544125] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[273.965201] [087/161] (860s left) kms_addfb_basic (too-high)
[274.467170] Starting subtest: too-high
[274.474065] Subtest too-high: SUCCESS (0.006s)
[274.888700] [088/161] (859s left) kms_addfb_basic (too-wide)
[275.392820] Starting subtest: too-wide
[275.398247] Subtest too-wide: SUCCESS (0.000s)
[275.772930] [089/161] (859s left) kms_addfb_basic (unused-handle)
[276.224585] Starting subtest: unused-handle
[276.229326] Subtest unused-handle: SUCCESS (0.000s)
[276.673696] [090/161] (858s left) kms_addfb_basic (unused-modifier)
[277.122209] Starting subtest: unused-modifier
[277.126822] Subtest unused-modifier: SUCCESS (0.000s)
[277.531849] [091/161] (857s left) kms_addfb_basic (unused-offsets)
[277.983661] Starting subtest: unused-offsets
[277.988398] Subtest unused-offsets: SUCCESS (0.000s)
[278.408191] [092/161] (857s left) kms_addfb_basic (unused-pitches)
[278.855319] Starting subtest: unused-pitches
[278.860277] Subtest unused-pitches: SUCCESS (0.000s)
[279.252163] [093/161] (856s left) kms_busy (basic)
[279.768181] Starting subtest: basic
[279.780972] Starting dynamic subtest: flip
[280.790907] Dynamic subtest flip: SUCCESS (1.011s)
[280.841742] Starting dynamic subtest: modeset
[280.848661] Dynamic subtest modeset: SKIP (0.000s)
[280.851883] Subtest basic: SUCCESS (1.024s)
[281.337299] [094/161] (855s left) kms_prop_blob (basic)
[281.797457] Starting subtest: basic
[281.802761] Subtest basic: SUCCESS (0.000s)
[282.157520] [095/161] (854s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[282.662370] Starting subtest: basic-busy-flip-before-cursor-atomic
[282.682324] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.018s)
[283.167843] [096/161] (854s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[283.663255] Starting subtest: basic-busy-flip-before-cursor-legacy
[284.764837] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.104s)
[285.276709] [097/161] (852s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[285.775273] Starting subtest: basic-flip-after-cursor-atomic
[285.783620] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[286.157988] [098/161] (851s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[286.664456] Starting subtest: basic-flip-after-cursor-legacy
[287.753346] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.087s)
[288.254957] [099/161] (849s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[288.756550] Starting subtest: basic-flip-after-cursor-varying-size
[289.846862] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.090s)
[290.391828] [100/161] (848s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[290.889876] Starting subtest: basic-flip-before-cursor-atomic
[290.899145] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[291.248254] [101/161] (847s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[291.758545] Starting subtest: basic-flip-before-cursor-legacy
[292.860977] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.103s)
[293.385442] [102/161] (845s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[293.883645] Starting subtest: basic-flip-before-cursor-varying-size
[294.969671] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.087s)
[295.491573] [103/161] (843s left) kms_dsc (dsc-basic)
[295.991416] Subtest dsc-basic: SKIP (0.000s)
[296.331565] [104/161] (843s left) kms_flip (basic-flip-vs-dpms)
[296.834284] Starting subtest: basic-flip-vs-dpms
[296.839516] Starting dynamic subtest: A-VGA1
[298.561349] Dynamic subtest A-VGA1: SUCCESS (1.713s)
[298.616727] Starting dynamic subtest: B-VGA1
[300.113355] Dynamic subtest B-VGA1: SUCCESS (1.540s)
[300.117969] Subtest basic-flip-vs-dpms: SUCCESS (3.267s)
[300.796689] [105/161] (839s left) kms_flip (basic-flip-vs-modeset)
[301.306890] Starting subtest: basic-flip-vs-modeset
[301.311934] Starting dynamic subtest: A-VGA1
[302.991110] Dynamic subtest A-VGA1: SUCCESS (1.678s)
[303.049129] Starting dynamic subtest: B-VGA1
[304.514844] Dynamic subtest B-VGA1: SUCCESS (1.520s)
[304.520229] Subtest basic-flip-vs-modeset: SUCCESS (3.210s)
[305.176104] [106/161] (835s left) kms_flip (basic-flip-vs-wf_vblank)
[305.683754] Starting subtest: basic-flip-vs-wf_vblank
[305.688538] Starting dynamic subtest: A-VGA1
[307.512140] Dynamic subtest A-VGA1: SUCCESS (1.825s)
[307.562556] Starting dynamic subtest: B-VGA1
[309.259090] Dynamic subtest B-VGA1: SUCCESS (1.738s)
[309.264969] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.580s)
[309.975741] [107/161] (830s left) kms_flip (basic-plain-flip)
[310.475615] Starting subtest: basic-plain-flip
[310.480675] Starting dynamic subtest: A-VGA1
[312.042420] Dynamic subtest A-VGA1: SUCCESS (1.556s)
[312.096829] Starting dynamic subtest: B-VGA1
[313.483358] Dynamic subtest B-VGA1: SUCCESS (1.437s)
[313.490668] Subtest basic-plain-flip: SUCCESS (3.005s)
[314.177502] [108/161] (826s left) kms_force_connector_basic (force-connector-state)
[314.705753] Starting subtest: force-connector-state
[315.002149] Subtest force-connector-state: SUCCESS (0.271s)
[315.888363] [109/161] (825s left) kms_force_connector_basic (force-edid)
[316.723118] Starting subtest: force-edid
[316.845811] Subtest force-edid: SUCCESS (0.135s)
[317.363949] [110/161] (824s left) kms_force_connector_basic (force-load-detect)
[317.881988] Starting subtest: force-load-detect
[318.383537] Subtest force-load-detect: SUCCESS (0.504s)
[319.017547] [111/161] (823s left) kms_force_connector_basic (prune-stale-modes)
[319.605104] Starting subtest: prune-stale-modes
[319.711652] Subtest prune-stale-modes: SUCCESS (0.113s)
[320.170667] [112/161] (822s left) kms_frontbuffer_tracking (basic)
[320.680946] Subtest basic: SKIP (0.000s)
[321.008649] [113/161] (821s left) kms_hdmi_inject (inject-audio)
[321.466956] Subtest inject-audio: SKIP (0.000s)
[321.815946] [114/161] (821s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[322.324991] Starting subtest: compare-crc-sanitycheck-xr24
[322.329778] Starting dynamic subtest: pipe-A-VGA-1
[322.706459] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.374s)
[322.765426] Starting dynamic subtest: pipe-B-VGA-1
[323.239126] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.533s)
[323.243785] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.922s)
[323.763800] [115/161] (819s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[324.263960] Starting subtest: compare-crc-sanitycheck-nv12
[324.270268] Starting dynamic subtest: pipe-A-VGA-1
[324.281334] Dynamic subtest pipe-A-VGA-1: SKIP (0.001s)
[324.337078] Starting dynamic subtest: pipe-B-VGA-1
[324.345421] Dynamic subtest pipe-B-VGA-1: SKIP (0.001s)
[324.354548] Subtest compare-crc-sanitycheck-nv12: SKIP (0.021s)
[324.649913] [116/161] (819s left) kms_pipe_crc_basic (hang-read-crc)
[325.145498] Starting subtest: hang-read-crc
[325.154641] Starting dynamic subtest: pipe-A-VGA-1
[326.490667] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.335s)
[326.553144] Starting dynamic subtest: pipe-B-VGA-1
[327.976465] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.479s)
[327.985901] Subtest hang-read-crc: SUCCESS (2.832s)
[328.500162] [117/161] (815s left) kms_pipe_crc_basic (nonblocking-crc)
[328.997513] Starting subtest: nonblocking-crc
[329.002468] Starting dynamic subtest: pipe-A-VGA-1
[329.594383] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.593s)
[329.650071] Starting dynamic subtest: pipe-B-VGA-1
[330.357219] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.752s)
[330.361316] Subtest nonblocking-crc: SUCCESS (1.363s)
[330.868581] [118/161] (813s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[331.384113] Starting subtest: nonblocking-crc-frame-sequence
[331.388815] Starting dynamic subtest: pipe-A-VGA-1
[331.977344] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.590s)
[332.036846] Starting dynamic subtest: pipe-B-VGA-1
[332.716108] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.733s)
[332.719965] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.339s)
[333.237585] [119/161] (811s left) kms_pipe_crc_basic (read-crc)
[333.755113] Starting subtest: read-crc
[333.759448] Starting dynamic subtest: pipe-A-VGA-1
[334.285581] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.525s)
[334.342797] Starting dynamic subtest: pipe-B-VGA-1
[334.972636] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.665s)
[334.983311] Subtest read-crc: SUCCESS (1.209s)
[335.497690] [120/161] (809s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[335.995227] Starting subtest: read-crc-frame-sequence
[336.000647] Starting dynamic subtest: pipe-A-VGA-1
[336.510092] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.508s)
[336.568987] Starting dynamic subtest: pipe-B-VGA-1
[337.188538] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.669s)
[337.192870] Subtest read-crc-frame-sequence: SUCCESS (1.198s)
[337.717116] [121/161] (807s left) kms_pm_backlight (basic-brightness)
[338.215995] Subtest basic-brightness: SKIP (0.000s)
[338.557176] [122/161] (807s left) kms_pm_rpm (basic-pci-d3-state)
[350.479939] Subtest basic-pci-d3-state: SKIP (0.000s)
[350.796873] [123/161] (795s left) kms_pm_rpm (basic-rte)
[351.243265] Starting subtest: basic-rte
[362.705742] Subtest basic-rte: SKIP (11.455s)
[363.037771] [124/161] (783s left) kms_psr (psr-primary-page-flip)
[363.548719] Subtest psr-primary-page-flip: SKIP (0.000s)
[363.872355] [125/161] (782s left) kms_psr (psr-cursor-plane-move)
[364.368595] Subtest psr-cursor-plane-move: SKIP (0.000s)
[364.705669] [126/161] (782s left) kms_psr (psr-sprite-plane-onoff)
[365.199892] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[365.548218] [127/161] (781s left) kms_psr (psr-primary-mmap-gtt)
[366.051431] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[366.374762] [128/161] (781s left) kms_setmode (basic-clone-single-crtc)
[366.824222] Starting subtest: basic-clone-single-crtc
[366.837552] Subtest basic-clone-single-crtc: SKIP (0.001s)
[367.181198] [129/161] (780s left) i915_pm_rps (basic-api)
[367.651949] Subtest basic-api: SKIP (0.000s)
[367.991716] [130/161] (780s left) prime_self_import (basic-llseek-bad)
[368.430317] Starting subtest: basic-llseek-bad
[368.448192] Subtest basic-llseek-bad: SUCCESS (0.014s)
[368.793466] [131/161] (780s left) prime_self_import (basic-llseek-size)
[369.230829] Starting subtest: basic-llseek-size
[369.250890] Subtest basic-llseek-size: SUCCESS (0.024s)
[369.614652] [132/161] (779s left) prime_self_import (basic-with_fd_dup)
[370.048343] Starting subtest: basic-with_fd_dup
[370.069622] Subtest basic-with_fd_dup: SUCCESS (0.022s)
[370.429967] [133/161] (779s left) prime_self_import (basic-with_one_bo)
[370.865576] Starting subtest: basic-with_one_bo
[370.892842] Subtest basic-with_one_bo: SUCCESS (0.027s)
[371.257582] [134/161] (778s left) prime_self_import (basic-with_one_bo_two_files)
[371.692445] Starting subtest: basic-with_one_bo_two_files
[371.709524] Subtest basic-with_one_bo_two_files: SUCCESS (0.017s)
[372.073462] [135/161] (778s left) prime_self_import (basic-with_two_bos)
[372.511649] Starting subtest: basic-with_two_bos
[372.535305] Subtest basic-with_two_bos: SUCCESS (0.023s)
[372.963945] [136/161] (777s left) prime_vgem (basic-fence-flip)
[373.444879] Starting subtest: basic-fence-flip
[374.115725] Subtest basic-fence-flip: SUCCESS (0.675s)
[374.504226] [137/161] (776s left) prime_vgem (basic-fence-mmap)
[374.980290] Starting subtest: basic-fence-mmap
[375.178818] Subtest basic-fence-mmap: SUCCESS (0.201s)
[375.554863] [138/161] (775s left) prime_vgem (basic-fence-read)
[376.034719] Starting subtest: basic-fence-read
[376.293367] Subtest basic-fence-read: SUCCESS (0.260s)
[376.675882] [139/161] (774s left) prime_vgem (basic-gtt)
[377.142597] Starting subtest: basic-gtt
[377.220580] Subtest basic-gtt: SUCCESS (0.077s)
[377.595166] [140/161] (774s left) prime_vgem (basic-read)
[378.078549] Starting subtest: basic-read
[378.184614] Subtest basic-read: SUCCESS (0.106s)
[378.555407] [141/161] (773s left) prime_vgem (basic-write)
[379.032979] Starting subtest: basic-write
[379.140532] Subtest basic-write: SUCCESS (0.111s)
[379.500363] [142/161] (772s left) vgem_basic (setversion)
[379.961939] Starting subtest: setversion
[379.970141] Subtest setversion: SUCCESS (0.000s)
[380.304478] [143/161] (772s left) vgem_basic (create)
[380.763763] Starting subtest: create
[380.768706] Subtest create: SUCCESS (0.003s)
[381.102462] [144/161] (771s left) vgem_basic (debugfs)
[381.560959] Starting subtest: debugfs
[381.566540] Subtest debugfs: SUCCESS (0.004s)
[381.907599] [145/161] (771s left) vgem_basic (dmabuf-export)
[382.375292] Starting subtest: dmabuf-export
[382.389550] Subtest dmabuf-export: SUCCESS (0.015s)
[382.756740] [146/161] (770s left) vgem_basic (dmabuf-fence)
[383.216492] Starting subtest: dmabuf-fence
[383.221963] Subtest dmabuf-fence: SUCCESS (0.006s)
[383.557425] [147/161] (770s left) vgem_basic (dmabuf-fence-before)
[384.014595] Starting subtest: dmabuf-fence-before
[384.018331] Subtest dmabuf-fence-before: SUCCESS (0.004s)
[384.356440] [148/161] (769s left) vgem_basic (dmabuf-mmap)
[384.816366] Starting subtest: dmabuf-mmap
[384.893616] Subtest dmabuf-mmap: SUCCESS (0.083s)
[385.243923] [149/161] (769s left) vgem_basic (mmap)
[385.698880] Starting subtest: mmap
[385.748542] Subtest mmap: SUCCESS (0.058s)
[386.095639] [150/161] (768s left) vgem_basic (second-client)
[386.544161] Starting subtest: second-client
[386.576463] Subtest second-client: SUCCESS (0.033s)
[386.930507] [151/161] (768s left) vgem_basic (sysfs)
[387.398623] Starting subtest: sysfs
[387.403129] Subtest sysfs: SUCCESS (0.006s)
[387.764173] [152/161] (767s left) core_hotunplug (unbind-rebind)
[388.561566] Starting subtest: unbind-rebind
[394.543260] Subtest unbind-rebind: SUCCESS (5.978s)
[394.887303] [153/161] (761s left) vgem_basic (unload)
[395.326929] Starting subtest: unload
[424.907951] Subtest unload: SUCCESS (29.573s)
[425.443831] [154/161] (730s left) i915_module_load (reload)
[425.886846] Starting subtest: reload
[435.915097] Subtest reload: SUCCESS (10.015s)
[436.579468] [155/161] (720s left) gem_lmem_swapping (basic)
[437.337164] Subtest basic: SKIP (0.000s)
[437.676263] [156/161] (719s left) gem_lmem_swapping (parallel-random-engines)
[438.152995] Subtest parallel-random-engines: SKIP (0.000s)
[438.492775] [157/161] (719s left) gem_lmem_swapping (random-engines)
[438.964202] Subtest random-engines: SKIP (0.000s)
[439.293792] [158/161] (718s left) gem_lmem_swapping (verify-random)
[439.763759] Subtest verify-random: SKIP (0.000s)
[440.093576] [159/161] (718s left) i915_pm_rpm (module-reload)
[452.056813] Subtest module-reload: SKIP (0.000s)
[452.385920] [160/161] (706s left) i915_selftest (live)
[455.235771] Starting subtest: live
[455.240830] Starting dynamic subtest: sanitycheck
[462.629775] Dynamic subtest sanitycheck: SUCCESS (7.397s)
[462.678966] Starting dynamic subtest: uncore
[470.041393] Dynamic subtest uncore: SUCCESS (7.405s)
[470.123237] Starting dynamic subtest: workarounds
[477.446587] Dynamic subtest workarounds: SUCCESS (7.401s)
[477.494655] Starting dynamic subtest: gt_engines
[484.947368] Dynamic subtest gt_engines: SUCCESS (7.494s)
[484.989088] Starting dynamic subtest: gt_timelines
[498.440436] Dynamic subtest gt_timelines: SUCCESS (13.489s)
[498.484776] Starting dynamic subtest: gt_contexts
[505.878314] Dynamic subtest gt_contexts: SUCCESS (7.431s)
[505.960508] Starting dynamic subtest: gt_lrc
[513.272177] Dynamic subtest gt_lrc: SUCCESS (7.388s)
[513.318897] Starting dynamic subtest: gt_mocs
[520.652777] Dynamic subtest gt_mocs: SUCCESS (7.376s)
[520.744790] Starting dynamic subtest: gt_pm
[528.465234] Dynamic subtest gt_pm: SUCCESS (7.806s)
[528.544654] Starting dynamic subtest: gt_heartbeat
[535.871845] Dynamic subtest gt_heartbeat: SUCCESS (7.401s)
[535.925221] Starting dynamic subtest: gt_tlb
[543.218226] Dynamic subtest gt_tlb: SUCCESS (7.340s)
[543.265739] Starting dynamic subtest: requests
[553.212665] Dynamic subtest requests: SUCCESS (9.988s)
[553.255735] Starting dynamic subtest: migrate
[560.520976] Dynamic subtest migrate: SUCCESS (7.301s)
[560.583812] Starting dynamic subtest: active
[568.104082] Dynamic subtest active: SUCCESS (7.580s)
[568.182316] Starting dynamic subtest: objects
[576.264698] Dynamic subtest objects: SUCCESS (8.154s)
[576.358764] Starting dynamic subtest: mman
[590.964940] Dynamic subtest mman: SUCCESS (14.694s)
[591.008435] Starting dynamic subtest: dmabuf
[598.493634] Dynamic subtest dmabuf: SUCCESS (7.522s)
[598.549848] Starting dynamic subtest: vma
[606.041126] Dynamic subtest vma: SUCCESS (7.536s)
[606.093540] Starting dynamic subtest: coherency
[619.145560] Dynamic subtest coherency: SUCCESS (13.097s)
[619.195345] Starting dynamic subtest: gtt
[629.407818] Dynamic subtest gtt: SUCCESS (10.256s)
[629.455934] Starting dynamic subtest: gem
[636.950248] Dynamic subtest gem: SUCCESS (7.536s)
[636.999634] Starting dynamic subtest: evict
[644.461231] Dynamic subtest evict: SUCCESS (7.503s)
[644.508960] Starting dynamic subtest: hugepages
[651.851143] Dynamic subtest hugepages: SUCCESS (7.383s)
[651.949266] Starting dynamic subtest: gem_contexts
[659.542562] Dynamic subtest gem_contexts: SUCCESS (7.684s)
[659.640733] Starting dynamic subtest: client
[666.838755] Dynamic subtest client: SUCCESS (7.290s)
[666.891328] Starting dynamic subtest: gem_migrate
[674.372936] Dynamic subtest gem_migrate: SUCCESS (7.528s)
[674.424804] Starting dynamic subtest: reset
[683.828256] Dynamic subtest reset: SUCCESS (9.446s)
[683.877337] Starting dynamic subtest: memory_region
[691.273172] Dynamic subtest memory_region: SUCCESS (7.437s)
[691.336960] Starting dynamic subtest: hangcheck
[701.369204] Dynamic subtest hangcheck: SUCCESS (10.091s)
[701.417109] Starting dynamic subtest: execlists
[708.799259] Dynamic subtest execlists: SUCCESS (7.422s)
[708.841522] Starting dynamic subtest: ring_submission
[716.193686] Dynamic subtest ring_submission: SUCCESS (7.388s)
[716.235703] Starting dynamic subtest: perf
[723.588168] Dynamic subtest perf: SUCCESS (7.388s)
[723.691280] Starting dynamic subtest: slpc
[730.931612] Dynamic subtest slpc: SUCCESS (7.338s)
[730.981348] Starting dynamic subtest: guc
[738.272387] Dynamic subtest guc: SUCCESS (7.334s)
[738.344342] Starting dynamic subtest: guc_multi_lrc
[745.664130] Dynamic subtest guc_multi_lrc: SUCCESS (7.382s)
[745.718311] Starting dynamic subtest: guc_hang
[753.102342] Dynamic subtest guc_hang: SUCCESS (7.432s)
[753.154377] Starting dynamic subtest: late_gt_pm
[760.539961] Dynamic subtest late_gt_pm: SUCCESS (7.428s)
[760.554212] Subtest live: SUCCESS (305.306s)
[760.798378] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[760.808981] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[760.826083] [161/161] (397s left) dmabuf (all-tests)
[761.291781] Starting subtest: all-tests
[761.296343] Starting dynamic subtest: sanitycheck
[761.414910] Dynamic subtest sanitycheck: SUCCESS (0.129s)
[761.481422] Starting dynamic subtest: dma_fence
[761.713589] Dynamic subtest dma_fence: SUCCESS (0.292s)
[761.764702] Starting dynamic subtest: dma_fence_chain