[77.576829] Initializing watchdogs
[77.577341]   /dev/watchdog0
[77.659564] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:22b1 Intel Cherryview (Gen8) Atom/Celeron/Pentium Processor x5-E8000/J3xxx/N3xxx Integrated Graphics Controller
[77.681515] [001/161] (960s left) i915_module_load (load)
[78.641997] Starting subtest: load
[84.473752] Subtest load: SUCCESS (5.787s)
[84.947716] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[84.968912] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[84.991864] [002/161] (953s left) core_auth (basic-auth)
[85.480277] Starting subtest: basic-auth
[85.499233] Subtest basic-auth: SUCCESS (0.010s)
[85.847340] [003/161] (953s left) debugfs_test (read_all_entries)
[86.238441] Starting subtest: read_all_entries
[86.537747] Subtest read_all_entries: SUCCESS (0.299s)
[87.281719] [004/161] (951s left) debugfs_test (basic-hwmon)
[87.572685] Starting subtest: basic-hwmon
[87.578757] Subtest basic-hwmon: SKIP (0.000s)
[88.278373] [005/161] (951s left) debugfs_test (sysfs)
[88.567460] Starting subtest: sysfs
[88.979227] Subtest sysfs: SUCCESS (0.408s)
[89.705621] [006/161] (949s left) fbdev (eof)
[90.042636] Starting subtest: eof
[90.045464] Subtest eof: SUCCESS (0.004s)
[90.258801] [007/161] (949s left) fbdev (info)
[90.511118] Starting subtest: info
[90.513299] Subtest info: SUCCESS (0.000s)
[90.749146] [008/161] (949s left) fbdev (nullptr)
[91.017489] Starting subtest: nullptr
[91.019000] Subtest nullptr: SUCCESS (0.001s)
[91.249523] [009/161] (948s left) fbdev (read)
[91.520461] Starting subtest: read
[93.798737] Subtest read: SUCCESS (2.278s)
[94.029321] [010/161] (946s left) fbdev (write)
[94.288741] Starting subtest: write
[95.428557] Subtest write: SUCCESS (1.139s)
[95.651721] [011/161] (944s left) gem_basic (bad-close)
[95.920442] Starting subtest: bad-close
[95.927932] Subtest bad-close: SUCCESS (0.000s)
[96.205684] [012/161] (944s left) gem_basic (create-close)
[96.463666] Starting subtest: create-close
[96.471151] Subtest create-close: SUCCESS (0.000s)
[96.702459] [013/161] (944s left) gem_basic (create-fd-close)
[96.968257] Starting subtest: create-fd-close
[96.972469] Subtest create-fd-close: SUCCESS (0.001s)
[97.201209] [014/161] (943s left) gem_busy (busy@all-engines)
[97.540123] Starting subtest: busy
[97.544275] Starting dynamic subtest: all-engines
[97.751341] Dynamic subtest all-engines: SUCCESS (0.213s)
[97.754069] Subtest busy: SUCCESS (0.216s)
[98.330538] [015/161] (942s left) gem_close_race (basic-process)
[98.653137] Starting subtest: basic-process
[98.796787] Subtest basic-process: SUCCESS (0.145s)
[99.149242] [016/161] (942s left) gem_close_race (basic-threads)
[99.484100] Starting subtest: basic-threads
[100.718380] Subtest basic-threads: SUCCESS (1.234s)
[101.079978] [017/161] (940s left) gem_ctx_create (basic)
[101.398380] Starting subtest: basic
[101.400084] Subtest basic: SUCCESS (0.000s)
[101.762525] [018/161] (940s left) gem_ctx_create (basic-files)
[102.088691] Starting subtest: basic-files
[104.163513] Subtest basic-files: SUCCESS (2.079s)
[104.531467] [019/161] (937s left) gem_ctx_exec (basic)
[104.805430] Starting subtest: basic
[104.829762] Subtest basic: SUCCESS (0.020s)
[105.075781] [020/161] (937s left) gem_exec_basic (basic)
[105.378286] Starting subtest: basic
[105.384449] Starting dynamic subtest: rcs0-smem
[105.389965] Dynamic subtest rcs0-smem: SUCCESS (0.005s)
[105.414114] Starting dynamic subtest: bcs0-smem
[105.415829] Dynamic subtest bcs0-smem: SUCCESS (0.003s)
[105.439703] Starting dynamic subtest: vcs0-smem
[105.441422] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[105.465783] Starting dynamic subtest: vecs0-smem
[105.467504] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[105.469219] Subtest basic: SUCCESS (0.018s)
[105.764492] [021/161] (936s left) gem_exec_create (basic)
[106.085663] Starting subtest: basic
[106.088147] Starting dynamic subtest: smem
[108.205256] Dynamic subtest smem: SUCCESS (2.105s)
[108.207068] Subtest basic: SUCCESS (2.109s)
[108.557414] [022/161] (933s left) gem_exec_fence (basic-busy)
[109.058121] Starting subtest: basic-busy
[109.059969] Starting dynamic subtest: rcs0
[109.087959] Dynamic subtest rcs0: SUCCESS (0.033s)
[109.120306] Starting dynamic subtest: bcs0
[109.130448] Dynamic subtest bcs0: SUCCESS (0.039s)
[109.156380] Starting dynamic subtest: vcs0
[109.169153] Dynamic subtest vcs0: SUCCESS (0.038s)
[109.194294] Starting dynamic subtest: vecs0
[109.203938] Dynamic subtest vecs0: SUCCESS (0.031s)
[109.206300] Subtest basic-busy: SUCCESS (0.150s)
[110.227520] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[110.237934] [023/161] (932s left) gem_exec_fence (basic-wait)
[110.730189] Starting subtest: basic-wait
[110.735233] Starting dynamic subtest: rcs0
[110.756362] Dynamic subtest rcs0: SUCCESS (0.023s)
[110.784120] Starting dynamic subtest: bcs0
[110.809570] Dynamic subtest bcs0: SUCCESS (0.053s)
[110.852986] Starting dynamic subtest: vcs0
[110.855682] Dynamic subtest vcs0: SUCCESS (0.039s)
[110.881393] Starting dynamic subtest: vecs0
[110.899347] Dynamic subtest vecs0: SUCCESS (0.044s)
[110.901468] Subtest basic-wait: SUCCESS (0.171s)
[111.782482] [024/161] (931s left) gem_exec_fence (basic-await)
[112.275448] Starting subtest: basic-await
[112.279324] Starting dynamic subtest: rcs0
[112.519284] Dynamic subtest rcs0: SUCCESS (0.240s)
[112.546313] Starting dynamic subtest: bcs0
[112.749423] Dynamic subtest bcs0: SUCCESS (0.223s)
[112.775072] Starting dynamic subtest: vcs0
[113.007146] Dynamic subtest vcs0: SUCCESS (0.254s)
[113.033646] Starting dynamic subtest: vecs0
[113.238529] Dynamic subtest vecs0: SUCCESS (0.224s)
[113.240612] Subtest basic-await: SUCCESS (0.964s)
[114.111792] [025/161] (928s left) gem_exec_fence (nb-await)
[114.601284] Starting subtest: nb-await
[114.604516] Starting dynamic subtest: rcs0
[114.700851] Dynamic subtest rcs0: SUCCESS (0.096s)
[114.727383] Starting dynamic subtest: bcs0
[114.804225] Dynamic subtest bcs0: SUCCESS (0.096s)
[114.829990] Starting dynamic subtest: vcs0
[114.910237] Dynamic subtest vcs0: SUCCESS (0.101s)
[114.940524] Starting dynamic subtest: vecs0
[115.012709] Dynamic subtest vecs0: SUCCESS (0.099s)
[115.014666] Subtest nb-await: SUCCESS (0.404s)
[115.873386] [026/161] (927s left) gem_exec_gttfill (basic)
[116.197657] Starting subtest: basic
[149.394965] Subtest basic: SUCCESS (33.190s)
[149.813338] [027/161] (893s left) gem_exec_parallel (engines)
[150.312159] Starting subtest: engines
[150.316628] Starting dynamic subtest: basic
[159.260181] Dynamic subtest basic: SUCCESS (8.952s)
[159.295093] Starting dynamic subtest: contexts
[169.737184] Dynamic subtest contexts: SUCCESS (10.471s)
[169.766349] Starting dynamic subtest: fds
[181.451279] Dynamic subtest fds: SUCCESS (11.708s)
[181.522136] Starting dynamic subtest: userptr
[188.538249] Dynamic subtest userptr: SUCCESS (7.086s)
[188.541406] Subtest engines: SUCCESS (38.233s)
[188.984760] [028/161] (854s left) gem_exec_store (basic)
[189.318221] Starting subtest: basic
[189.411109] Subtest basic: SUCCESS (0.094s)
[189.793683] [029/161] (854s left) gem_flink_basic (bad-flink)
[190.056315] Starting subtest: bad-flink
[190.058751] Subtest bad-flink: SUCCESS (0.000s)
[190.317702] [030/161] (853s left) gem_flink_basic (bad-open)
[190.579028] Starting subtest: bad-open
[190.580805] Subtest bad-open: SUCCESS (0.000s)
[190.832142] [031/161] (853s left) gem_flink_basic (basic)
[191.095137] Starting subtest: basic
[191.098426] Subtest basic: SUCCESS (0.000s)
[191.357419] [032/161] (853s left) gem_flink_basic (double-flink)
[191.622239] Starting subtest: double-flink
[191.624687] Subtest double-flink: SUCCESS (0.000s)
[191.886722] [033/161] (852s left) gem_flink_basic (flink-lifetime)
[192.151876] Starting subtest: flink-lifetime
[192.161439] Subtest flink-lifetime: SUCCESS (0.010s)
[192.439469] [034/161] (852s left) gem_huc_copy (huc-copy)
[192.722198] Subtest huc-copy: SKIP (0.000s)
[192.944675] [035/161] (852s left) gem_linear_blits (basic)
[193.566164] Starting subtest: basic
[193.613629] Subtest basic: SUCCESS (0.042s)
[193.935255] [036/161] (851s left) gem_mmap (basic)
[194.354090] Starting subtest: basic
[194.366330] Subtest basic: SUCCESS (0.001s)
[194.602268] [037/161] (850s left) gem_mmap_gtt (basic)
[194.865221] Starting subtest: basic
[194.868347] Subtest basic: SUCCESS (0.004s)
[195.134931] [038/161] (850s left) gem_render_linear_blits (basic)
[195.416843] Starting subtest: basic
[195.542735] Subtest basic: SUCCESS (0.123s)
[195.763707] [039/161] (850s left) gem_render_tiled_blits (basic)
[196.036233] Starting subtest: basic
[196.228309] Subtest basic: SUCCESS (0.176s)
[196.486368] [040/161] (849s left) gem_ringfill (basic-all)
[197.032707] Starting subtest: basic-all
[198.453783] Subtest basic-all: SUCCESS (1.432s)
[198.734744] [041/161] (847s left) gem_softpin (allocator-basic)
[199.023793] Starting subtest: allocator-basic
[199.395479] Subtest allocator-basic: SUCCESS (0.363s)
[199.757602] [042/161] (846s left) gem_softpin (allocator-basic-reserve)
[200.044724] Starting subtest: allocator-basic-reserve
[200.418863] Subtest allocator-basic-reserve: SUCCESS (0.377s)
[200.791644] [043/161] (846s left) gem_softpin (safe-alignment)
[201.070454] Starting subtest: safe-alignment
[201.123999] Subtest safe-alignment: SUCCESS (0.051s)
[201.426958] [044/161] (845s left) gem_sync (basic-all)
[201.752289] Starting subtest: basic-all
[204.933699] Subtest basic-all: SUCCESS (3.178s)
[205.340374] [045/161] (841s left) gem_sync (basic-each)
[205.656656] Starting subtest: basic-each
[208.370648] Subtest basic-each: SUCCESS (2.710s)
[208.773923] [046/161] (838s left) gem_tiled_blits (basic)
[209.279284] Starting subtest: basic
[209.365125] Subtest basic: SUCCESS (0.085s)
[209.661646] [047/161] (838s left) gem_tiled_fence_blits (basic)
[210.339243] Starting subtest: basic
[210.417183] Subtest basic: SUCCESS (0.074s)
[210.756718] [048/161] (837s left) gem_tiled_pread_basic
[212.236180] [049/161] (835s left) gem_wait (busy@all-engines)
[212.590968] Starting subtest: busy
[212.594707] Starting dynamic subtest: all-engines
[213.140554] Dynamic subtest all-engines: SUCCESS (0.544s)
[213.145237] Subtest busy: SUCCESS (0.545s)
[213.676689] [050/161] (834s left) gem_wait (wait@all-engines)
[214.031808] Starting subtest: wait
[214.034514] Starting dynamic subtest: all-engines
[215.077544] Dynamic subtest all-engines: SUCCESS (1.045s)
[215.081135] Subtest wait: SUCCESS (1.048s)
[215.589522] [051/161] (833s left) i915_getparams_basic (basic-eu-total)
[215.853763] Starting subtest: basic-eu-total
[215.860845] Subtest basic-eu-total: SUCCESS (0.000s)
[216.103470] [052/161] (832s left) i915_getparams_basic (basic-subslice-total)
[216.369353] Starting subtest: basic-subslice-total
[216.374434] Subtest basic-subslice-total: SUCCESS (0.000s)
[216.629959] [053/161] (832s left) i915_hangman (error-state-basic)
[216.944161] Starting subtest: error-state-basic
[217.003058] Subtest error-state-basic: SUCCESS (0.058s)
[217.299153] [054/161] (831s left) i915_pciid
[217.821232] [055/161] (831s left) kms_addfb_basic (addfb25-4-tiled)
[218.601362] Starting subtest: addfb25-4-tiled
[218.604560] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[218.861231] [056/161] (830s left) kms_addfb_basic (addfb25-bad-modifier)
[219.601500] Starting subtest: addfb25-bad-modifier
[219.606172] Subtest addfb25-bad-modifier: SUCCESS (0.003s)
[219.859811] [057/161] (829s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[220.618313] Starting subtest: addfb25-framebuffer-vs-set-tiling
[220.620764] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[220.913784] [058/161] (829s left) kms_addfb_basic (addfb25-modifier-no-flag)
[221.649316] Starting subtest: addfb25-modifier-no-flag
[221.651658] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[221.907534] [059/161] (828s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[222.662323] Starting subtest: addfb25-x-tiled-legacy
[222.665394] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[222.940189] [060/161] (827s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[223.684728] Starting subtest: addfb25-x-tiled-mismatch-legacy
[223.687176] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[223.961743] [061/161] (826s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[224.684436] Starting subtest: addfb25-yf-tiled-legacy
[224.686149] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[224.941931] [062/161] (825s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[225.718490] Starting subtest: addfb25-y-tiled-legacy
[225.721386] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[225.967828] [063/161] (825s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[226.697884] Starting subtest: addfb25-y-tiled-small-legacy
[226.704587] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[226.978812] [064/161] (824s left) kms_addfb_basic (bad-pitch-0)
[227.253662] Starting subtest: bad-pitch-0
[227.257571] Subtest bad-pitch-0: SUCCESS (0.000s)
[227.964820] [065/161] (823s left) kms_addfb_basic (bad-pitch-1024)
[228.236527] Starting subtest: bad-pitch-1024
[228.238972] Subtest bad-pitch-1024: SUCCESS (0.000s)
[228.978876] [066/161] (822s left) kms_addfb_basic (bad-pitch-128)
[229.248668] Starting subtest: bad-pitch-128
[229.250753] Subtest bad-pitch-128: SUCCESS (0.000s)
[229.979779] [067/161] (821s left) kms_addfb_basic (bad-pitch-256)
[230.256241] Starting subtest: bad-pitch-256
[230.258482] Subtest bad-pitch-256: SUCCESS (0.000s)
[231.009427] [068/161] (821s left) kms_addfb_basic (bad-pitch-32)
[231.279211] Starting subtest: bad-pitch-32
[231.282164] Subtest bad-pitch-32: SUCCESS (0.000s)
[231.972064] [069/161] (820s left) kms_addfb_basic (bad-pitch-63)
[232.243107] Starting subtest: bad-pitch-63
[232.248125] Subtest bad-pitch-63: SUCCESS (0.000s)
[232.965798] [070/161] (819s left) kms_addfb_basic (bad-pitch-65536)
[233.229105] Starting subtest: bad-pitch-65536
[233.231181] Subtest bad-pitch-65536: SUCCESS (0.001s)
[233.961336] [071/161] (818s left) kms_addfb_basic (bad-pitch-999)
[234.233401] Starting subtest: bad-pitch-999
[234.236186] Subtest bad-pitch-999: SUCCESS (0.000s)
[234.932074] [072/161] (817s left) kms_addfb_basic (basic)
[235.212681] Starting subtest: basic
[235.215864] Subtest basic: SUCCESS (0.000s)
[235.979588] [073/161] (817s left) kms_addfb_basic (basic-x-tiled-legacy)
[236.260719] Starting subtest: basic-x-tiled-legacy
[236.263652] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[236.954531] [074/161] (816s left) kms_addfb_basic (basic-y-tiled-legacy)
[237.232404] Starting subtest: basic-y-tiled-legacy
[237.234993] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[237.957370] [075/161] (815s left) kms_addfb_basic (bo-too-small)
[238.711722] Starting subtest: bo-too-small
[238.714472] Subtest bo-too-small: SUCCESS (0.003s)
[238.988411] [076/161] (814s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[239.715519] Starting subtest: bo-too-small-due-to-tiling
[239.718219] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[239.983843] [077/161] (813s left) kms_addfb_basic (clobberred-modifier)
[240.250160] Starting subtest: clobberred-modifier
[240.252619] Subtest clobberred-modifier: SUCCESS (0.000s)
[240.993174] [078/161] (813s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[241.262670] Starting subtest: framebuffer-vs-set-tiling
[241.265760] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[242.415247] [079/161] (812s left) kms_addfb_basic (invalid-get-prop)
[242.756538] Starting subtest: invalid-get-prop
[242.762482] Subtest invalid-get-prop: SUCCESS (0.000s)
[244.091964] [080/161] (810s left) kms_addfb_basic (invalid-get-prop-any)
[244.397307] Starting subtest: invalid-get-prop-any
[244.398904] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[245.112576] [081/161] (810s left) kms_addfb_basic (invalid-set-prop)
[245.390534] Starting subtest: invalid-set-prop
[245.394316] Subtest invalid-set-prop: SUCCESS (0.000s)
[246.170269] [082/161] (809s left) kms_addfb_basic (invalid-set-prop-any)
[246.435846] Starting subtest: invalid-set-prop-any
[246.437815] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[247.166385] [083/161] (808s left) kms_addfb_basic (no-handle)
[247.436626] Starting subtest: no-handle
[247.439388] Subtest no-handle: SUCCESS (0.000s)
[248.171891] [084/161] (807s left) kms_addfb_basic (size-max)
[248.917287] Starting subtest: size-max
[248.919632] Subtest size-max: SUCCESS (0.000s)
[249.182656] [085/161] (806s left) kms_addfb_basic (small-bo)
[249.939440] Starting subtest: small-bo
[249.943267] Subtest small-bo: SUCCESS (0.000s)
[250.194405] [086/161] (806s left) kms_addfb_basic (tile-pitch-mismatch)
[250.469726] Starting subtest: tile-pitch-mismatch
[250.472836] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[251.217549] [087/161] (805s left) kms_addfb_basic (too-high)
[251.960860] Starting subtest: too-high
[251.963761] Subtest too-high: SUCCESS (0.004s)
[252.227442] [088/161] (804s left) kms_addfb_basic (too-wide)
[252.984224] Starting subtest: too-wide
[252.986103] Subtest too-wide: SUCCESS (0.000s)
[253.240117] [089/161] (803s left) kms_addfb_basic (unused-handle)
[253.509066] Starting subtest: unused-handle
[253.511555] Subtest unused-handle: SUCCESS (0.000s)
[254.236916] [090/161] (802s left) kms_addfb_basic (unused-modifier)
[254.507950] Starting subtest: unused-modifier
[254.512202] Subtest unused-modifier: SUCCESS (0.000s)
[255.230479] [091/161] (801s left) kms_addfb_basic (unused-offsets)
[255.493261] Starting subtest: unused-offsets
[255.494963] Subtest unused-offsets: SUCCESS (0.000s)
[256.221660] [092/161] (801s left) kms_addfb_basic (unused-pitches)
[256.493730] Starting subtest: unused-pitches
[256.497711] Subtest unused-pitches: SUCCESS (0.000s)
[257.266738] [093/161] (800s left) kms_busy (basic)
[258.027420] Starting subtest: basic
[258.029392] Starting dynamic subtest: flip
[259.111171] Dynamic subtest flip: SUCCESS (1.048s)
[259.155204] Starting dynamic subtest: modeset
[261.170155] Dynamic subtest modeset: SUCCESS (2.089s)
[261.172455] Subtest basic: SUCCESS (3.148s)
[261.892694] [094/161] (795s left) kms_prop_blob (basic)
[262.155339] Starting subtest: basic
[262.158343] Subtest basic: SUCCESS (0.000s)
[262.404092] [095/161] (795s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[263.189685] Starting subtest: basic-busy-flip-before-cursor-atomic
[264.249621] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.060s)
[264.883616] [096/161] (793s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[265.625185] Starting subtest: basic-busy-flip-before-cursor-legacy
[266.690350] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.065s)
[267.316469] [097/161] (791s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[268.082770] Starting subtest: basic-flip-after-cursor-atomic
[269.128142] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.045s)
[269.782544] [098/161] (788s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[270.557124] Starting subtest: basic-flip-after-cursor-legacy
[271.601659] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.048s)
[272.238497] [099/161] (786s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[273.015094] Starting subtest: basic-flip-after-cursor-varying-size
[274.078456] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.062s)
[274.727468] [100/161] (784s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[275.491161] Starting subtest: basic-flip-before-cursor-atomic
[276.536421] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.050s)
[277.166489] [101/161] (782s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[277.907221] Starting subtest: basic-flip-before-cursor-legacy
[278.953252] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.050s)
[279.576197] [102/161] (779s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[280.372274] Starting subtest: basic-flip-before-cursor-varying-size
[281.419939] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.047s)
[282.058406] [103/161] (777s left) kms_dsc (dsc-basic)
[282.818102] Subtest dsc-basic: SKIP (0.000s)
[283.038930] [104/161] (776s left) kms_flip (basic-flip-vs-dpms)
[283.820117] Starting subtest: basic-flip-vs-dpms
[283.835298] Starting dynamic subtest: C-HDMI-A2
[286.473066] Dynamic subtest C-HDMI-A2: SUCCESS (2.626s)
[286.478063] Subtest basic-flip-vs-dpms: SUCCESS (2.652s)
[287.229354] [105/161] (772s left) kms_flip (basic-flip-vs-modeset)
[288.000660] Starting subtest: basic-flip-vs-modeset
[288.011256] Starting dynamic subtest: C-HDMI-A2
[290.922564] Dynamic subtest C-HDMI-A2: SUCCESS (2.881s)
[290.929209] Subtest basic-flip-vs-modeset: SUCCESS (2.910s)
[291.671899] [106/161] (768s left) kms_flip (basic-flip-vs-wf_vblank)
[292.474137] Starting subtest: basic-flip-vs-wf_vblank
[292.480654] Starting dynamic subtest: C-HDMI-A2
[295.423604] Dynamic subtest C-HDMI-A2: SUCCESS (2.938s)
[295.426511] Subtest basic-flip-vs-wf_vblank: SUCCESS (2.958s)
[295.770805] [107/161] (764s left) kms_flip (basic-plain-flip)
[296.515467] Starting subtest: basic-plain-flip
[296.523065] Starting dynamic subtest: C-HDMI-A2
[299.048954] Dynamic subtest C-HDMI-A2: SUCCESS (2.523s)
[299.054405] Subtest basic-plain-flip: SUCCESS (2.546s)
[299.396094] [108/161] (761s left) kms_force_connector_basic (force-connector-state)
[299.836888] Starting subtest: force-connector-state
[300.857386] Subtest force-connector-state: SUCCESS (0.997s)
[302.446815] [109/161] (758s left) kms_force_connector_basic (force-edid)
[302.891139] Starting subtest: force-edid
[303.035809] Subtest force-edid: SUCCESS (0.123s)
[303.947788] [110/161] (757s left) kms_force_connector_basic (force-load-detect)
[304.407605] Starting subtest: force-load-detect
[304.413383] Subtest force-load-detect: SKIP (0.000s)
[305.121345] [111/161] (756s left) kms_force_connector_basic (prune-stale-modes)
[305.548530] Starting subtest: prune-stale-modes
[305.715516] Subtest prune-stale-modes: SUCCESS (0.168s)
[306.702924] [112/161] (754s left) kms_frontbuffer_tracking (basic)
[307.592152] Starting subtest: basic
[312.754231] Subtest basic: SUCCESS (5.155s)
[313.034438] [113/161] (748s left) kms_hdmi_inject (inject-audio)
[313.442721] Starting subtest: inject-audio
[314.091144] Subtest inject-audio: SUCCESS (0.646s)
[314.859614] [114/161] (747s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[315.696698] Starting subtest: compare-crc-sanitycheck-xr24
[315.707141] Starting dynamic subtest: pipe-C-HDMI-A-2
[316.301117] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.568s)
[316.303952] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.587s)
[317.085169] [115/161] (745s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[317.877462] Starting subtest: compare-crc-sanitycheck-nv12
[317.879553] Starting dynamic subtest: pipe-C-HDMI-A-2
[317.886205] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[317.890504] Subtest compare-crc-sanitycheck-nv12: SKIP (0.011s)
[318.145426] [116/161] (744s left) kms_pipe_crc_basic (hang-read-crc)
[318.913225] Starting subtest: hang-read-crc
[318.925421] Starting dynamic subtest: pipe-C-HDMI-A-2
[320.625170] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.699s)
[320.626888] Subtest hang-read-crc: SUCCESS (1.714s)
[321.289794] [117/161] (741s left) kms_pipe_crc_basic (nonblocking-crc)
[322.103536] Starting subtest: nonblocking-crc
[322.106642] Starting dynamic subtest: pipe-C-HDMI-A-2
[322.853386] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.742s)
[322.866920] Subtest nonblocking-crc: SUCCESS (0.761s)
[323.538537] [118/161] (739s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[324.296596] Starting subtest: nonblocking-crc-frame-sequence
[324.298223] Starting dynamic subtest: pipe-C-HDMI-A-2
[325.053220] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.757s)
[325.056866] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.766s)
[325.649131] [119/161] (737s left) kms_pipe_crc_basic (read-crc)
[326.472887] Starting subtest: read-crc
[326.484648] Starting dynamic subtest: pipe-C-HDMI-A-2
[327.175286] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.691s)
[327.190934] Subtest read-crc: SUCCESS (0.710s)
[327.836943] [120/161] (735s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[328.643216] Starting subtest: read-crc-frame-sequence
[328.656305] Starting dynamic subtest: pipe-C-HDMI-A-2
[329.316791] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.658s)
[329.325180] Subtest read-crc-frame-sequence: SUCCESS (0.679s)
[329.945454] [121/161] (733s left) kms_pm_backlight (basic-brightness)
[330.743048] Subtest basic-brightness: SKIP (0.000s)
[330.996143] [122/161] (732s left) kms_pm_rpm (basic-pci-d3-state)
[333.506070] Starting subtest: basic-pci-d3-state
[333.885306] Subtest basic-pci-d3-state: SUCCESS (0.362s)
[334.423305] [123/161] (729s left) kms_pm_rpm (basic-rte)
[334.681127] Starting subtest: basic-rte
[337.176146] Subtest basic-rte: SUCCESS (2.476s)
[338.335307] [124/161] (725s left) kms_psr (psr-primary-page-flip)
[339.139589] Subtest psr-primary-page-flip: SKIP (0.000s)
[339.386868] [125/161] (724s left) kms_psr (psr-cursor-plane-move)
[340.196718] Subtest psr-cursor-plane-move: SKIP (0.000s)
[340.446232] [126/161] (724s left) kms_psr (psr-sprite-plane-onoff)
[341.242899] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[341.475192] [127/161] (723s left) kms_psr (psr-primary-mmap-gtt)
[342.262964] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[342.495946] [128/161] (722s left) kms_setmode (basic-clone-single-crtc)
[342.784446] Starting subtest: basic-clone-single-crtc
[342.792194] Subtest basic-clone-single-crtc: SKIP (0.001s)
[343.039775] [129/161] (722s left) i915_pm_rps (basic-api)
[343.332338] Starting subtest: basic-api
[343.346401] Subtest basic-api: SUCCESS (0.016s)
[343.621768] [130/161] (721s left) prime_self_import (basic-llseek-bad)
[343.895241] Starting subtest: basic-llseek-bad
[343.900759] Subtest basic-llseek-bad: SUCCESS (0.018s)
[344.167957] [131/161] (721s left) prime_self_import (basic-llseek-size)
[344.431739] Starting subtest: basic-llseek-size
[344.454998] Subtest basic-llseek-size: SUCCESS (0.022s)
[344.802584] [132/161] (721s left) prime_self_import (basic-with_fd_dup)
[345.067362] Starting subtest: basic-with_fd_dup
[345.081735] Subtest basic-with_fd_dup: SUCCESS (0.015s)
[345.344346] [133/161] (720s left) prime_self_import (basic-with_one_bo)
[345.615202] Starting subtest: basic-with_one_bo
[345.623756] Subtest basic-with_one_bo: SUCCESS (0.020s)
[345.900168] [134/161] (720s left) prime_self_import (basic-with_one_bo_two_files)
[346.171547] Starting subtest: basic-with_one_bo_two_files
[346.182082] Subtest basic-with_one_bo_two_files: SUCCESS (0.019s)
[346.446630] [135/161] (720s left) prime_self_import (basic-with_two_bos)
[346.707612] Starting subtest: basic-with_two_bos
[346.722715] Subtest basic-with_two_bos: SUCCESS (0.016s)
[347.028700] [136/161] (719s left) prime_vgem (basic-fence-flip)
[347.345662] Starting subtest: basic-fence-flip
[348.271543] Subtest basic-fence-flip: SKIP (0.908s)
[348.571429] [137/161] (718s left) prime_vgem (basic-fence-mmap)
[348.877378] Starting subtest: basic-fence-mmap
[348.999780] Subtest basic-fence-mmap: SUCCESS (0.123s)
[349.266298] [138/161] (717s left) prime_vgem (basic-fence-read)
[349.573346] Starting subtest: basic-fence-read
[349.851544] Subtest basic-fence-read: SUCCESS (0.278s)
[350.141928] [139/161] (717s left) prime_vgem (basic-gtt)
[350.447409] Starting subtest: basic-gtt
[350.508964] Subtest basic-gtt: SUCCESS (0.053s)
[350.798150] [140/161] (716s left) prime_vgem (basic-read)
[351.094631] Starting subtest: basic-read
[351.219273] Subtest basic-read: SUCCESS (0.113s)
[351.506635] [141/161] (716s left) prime_vgem (basic-write)
[351.821125] Starting subtest: basic-write
[351.980335] Subtest basic-write: SUCCESS (0.164s)
[352.264964] [142/161] (715s left) vgem_basic (setversion)
[352.541041] Starting subtest: setversion
[352.546046] Subtest setversion: SUCCESS (0.000s)
[352.797665] [143/161] (715s left) vgem_basic (create)
[353.074394] Starting subtest: create
[353.076638] Subtest create: SUCCESS (0.001s)
[353.320125] [144/161] (715s left) vgem_basic (debugfs)
[353.608463] Starting subtest: debugfs
[353.612725] Subtest debugfs: SUCCESS (0.002s)
[353.863458] [145/161] (714s left) vgem_basic (dmabuf-export)
[354.149266] Starting subtest: dmabuf-export
[354.155469] Subtest dmabuf-export: SUCCESS (0.011s)
[354.396527] [146/161] (714s left) vgem_basic (dmabuf-fence)
[354.676804] Starting subtest: dmabuf-fence
[354.678711] Subtest dmabuf-fence: SUCCESS (0.002s)
[354.910484] [147/161] (714s left) vgem_basic (dmabuf-fence-before)
[355.191432] Starting subtest: dmabuf-fence-before
[355.194297] Subtest dmabuf-fence-before: SUCCESS (0.002s)
[355.451219] [148/161] (713s left) vgem_basic (dmabuf-mmap)
[355.720948] Starting subtest: dmabuf-mmap
[355.766463] Subtest dmabuf-mmap: SUCCESS (0.046s)
[356.008315] [149/161] (713s left) vgem_basic (mmap)
[356.287210] Starting subtest: mmap
[356.323441] Subtest mmap: SUCCESS (0.035s)
[356.580112] [150/161] (713s left) vgem_basic (second-client)
[356.860704] Starting subtest: second-client
[356.892380] Subtest second-client: SUCCESS (0.029s)
[357.142932] [151/161] (712s left) vgem_basic (sysfs)
[357.431995] Starting subtest: sysfs
[357.435242] Subtest sysfs: SUCCESS (0.005s)
[357.693708] [152/161] (712s left) core_hotunplug (unbind-rebind)
[358.187979] Starting subtest: unbind-rebind
[364.507085] Subtest unbind-rebind: SUCCESS (6.303s)
[364.838853] [153/161] (705s left) vgem_basic (unload)
[365.127181] Starting subtest: unload
[394.415209] Subtest unload: SUCCESS (29.281s)
[394.871308] [154/161] (675s left) i915_module_load (reload)
[395.140329] Starting subtest: reload
[402.876083] Subtest reload: SUCCESS (7.733s)
[403.400199] [155/161] (667s left) gem_lmem_swapping (basic)
[404.361277] Subtest basic: SKIP (0.000s)
[404.705946] [156/161] (666s left) gem_lmem_swapping (parallel-random-engines)
[404.998098] Subtest parallel-random-engines: SKIP (0.000s)
[405.214886] [157/161] (666s left) gem_lmem_swapping (random-engines)
[405.503470] Subtest random-engines: SKIP (0.000s)
[405.739386] [158/161] (666s left) gem_lmem_swapping (verify-random)
[406.031066] Subtest verify-random: SKIP (0.000s)
[406.265252] [159/161] (665s left) i915_pm_rpm (module-reload)
[409.136271] Starting subtest: module-reload
[428.588112] Subtest module-reload: SUCCESS (19.469s)
[428.729272] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[428.734741] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[428.744136] [160/161] (643s left) i915_selftest (live)
[429.036318] Starting subtest: live
[429.038290] Starting dynamic subtest: sanitycheck
[433.918315] Dynamic subtest sanitycheck: SUCCESS (4.875s)
[433.965387] Starting dynamic subtest: uncore
[438.484461] Dynamic subtest uncore: SUCCESS (4.559s)
[438.521335] Starting dynamic subtest: workarounds
[443.282066] Dynamic subtest workarounds: SUCCESS (4.782s)
[443.327494] Starting dynamic subtest: gt_engines
[448.489697] Dynamic subtest gt_engines: SUCCESS (5.199s)
[448.532025] Starting dynamic subtest: gt_timelines
[480.432202] Dynamic subtest gt_timelines: SUCCESS (31.922s)
[480.464372] Starting dynamic subtest: gt_contexts
[485.173233] Dynamic subtest gt_contexts: SUCCESS (4.725s)
[485.235338] Starting dynamic subtest: gt_lrc
[493.131760] Dynamic subtest gt_lrc: SUCCESS (7.950s)
[493.185167] Starting dynamic subtest: gt_mocs
[497.776473] Dynamic subtest gt_mocs: SUCCESS (4.625s)
[497.848687] Starting dynamic subtest: gt_pm
[503.417173] Dynamic subtest gt_pm: SUCCESS (5.626s)
[503.482110] Starting dynamic subtest: gt_heartbeat
[507.820514] Dynamic subtest gt_heartbeat: SUCCESS (4.398s)
[507.861846] Starting dynamic subtest: gt_tlb
[512.819671] Dynamic subtest gt_tlb: SUCCESS (4.988s)
[512.872462] Starting dynamic subtest: requests
[523.839883] Dynamic subtest requests: SUCCESS (11.012s)
[523.893695] Starting dynamic subtest: migrate
[532.255485] Dynamic subtest migrate: SUCCESS (8.397s)
[532.303309] Starting dynamic subtest: active
[536.903162] Dynamic subtest active: SUCCESS (4.637s)
[536.963576] Starting dynamic subtest: objects
[542.681789] Dynamic subtest objects: SUCCESS (5.766s)
[542.727138] Starting dynamic subtest: mman
[553.967773] Dynamic subtest mman: SUCCESS (11.279s)
[554.006638] Starting dynamic subtest: dmabuf
[558.593990] Dynamic subtest dmabuf: SUCCESS (4.613s)
[558.637606] Starting dynamic subtest: vma
[563.110092] Dynamic subtest vma: SUCCESS (4.499s)
[563.170844] Starting dynamic subtest: coherency
[574.404444] Dynamic subtest coherency: SUCCESS (11.286s)
[574.442034] Starting dynamic subtest: gtt
[586.714586] Dynamic subtest gtt: SUCCESS (12.301s)
[586.774904] Starting dynamic subtest: gem
[592.590181] Dynamic subtest gem: SUCCESS (5.857s)
[592.640438] Starting dynamic subtest: evict
[603.879413] Dynamic subtest evict: SUCCESS (11.277s)
[603.908404] Starting dynamic subtest: hugepages
[608.982317] Dynamic subtest hugepages: SUCCESS (5.093s)
[609.027740] Starting dynamic subtest: gem_contexts
[638.882578] Dynamic subtest gem_contexts: SUCCESS (29.890s)
[638.920195] Starting dynamic subtest: client
[643.600171] Dynamic subtest client: SUCCESS (4.697s)
[643.640447] Starting dynamic subtest: gem_migrate
[648.346132] Dynamic subtest gem_migrate: SUCCESS (4.723s)
[648.397391] Starting dynamic subtest: reset
[661.035579] Dynamic subtest reset: SUCCESS (12.677s)
[661.093381] Starting dynamic subtest: memory_region
[665.658695] Dynamic subtest memory_region: SUCCESS (4.610s)
[665.696659] Starting dynamic subtest: hangcheck
[693.988238] Dynamic subtest hangcheck: SUCCESS (28.321s)
[694.028237] Starting dynamic subtest: execlists
[704.935251] Dynamic subtest execlists: SUCCESS (10.940s)
[704.980170] Starting dynamic subtest: ring_submission
[710.000102] Dynamic subtest ring_submission: SUCCESS (5.044s)
[710.048946] Starting dynamic subtest: perf
[715.043226] Dynamic subtest perf: SUCCESS (5.029s)
[715.105585] Starting dynamic subtest: slpc
[719.718795] Dynamic subtest slpc: SUCCESS (4.659s)
[719.763291] Starting dynamic subtest: guc
[724.305335] Dynamic subtest guc: SUCCESS (4.578s)
[724.332184] Starting dynamic subtest: guc_multi_lrc
[728.802856] Dynamic subtest guc_multi_lrc: SUCCESS (4.493s)
[728.863379] Starting dynamic subtest: guc_hang
[733.318195] Dynamic subtest guc_hang: SUCCESS (4.501s)
[733.373795] Starting dynamic subtest: late_gt_pm
[738.080542] Dynamic subtest late_gt_pm: SUCCESS (4.754s)
[738.091592] Subtest live: SUCCESS (309.044s)
[738.266517] [161/161] (334s left) dmabuf (all-tests)
[738.563689] Starting subtest: all-tests
[738.580662] Starting dynamic subtest: sanitycheck
[738.631150] Dynamic subtest sanitycheck: SUCCESS (0.061s)
[738.842205] Starting dynamic subtest: dma_fence
[739.079578] Dynamic subtest dma_fence: SUCCESS (0.435s)
[739.143517] Starting dynamic subtest: dma_fence_chain