[152.121547] Initializing watchdogs
[152.122134]   /dev/watchdog0
[152.191976] [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
[152.210920] [001/161] (960s left) i915_module_load (load)
[152.501827] Starting subtest: load
[158.147744] Subtest load: SUCCESS (5.647s)
[158.488059] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[158.513559] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[158.541275] [002/161] (954s left) core_auth (basic-auth)
[159.043425] Starting subtest: basic-auth
[159.047139] Subtest basic-auth: SUCCESS (0.003s)
[159.305167] [003/161] (953s left) debugfs_test (read_all_entries)
[159.608722] Starting subtest: read_all_entries
[159.857783] Subtest read_all_entries: SUCCESS (0.250s)
[160.596520] [004/161] (952s left) debugfs_test (basic-hwmon)
[160.874216] Starting subtest: basic-hwmon
[160.877832] Subtest basic-hwmon: SKIP (0.002s)
[161.544116] [005/161] (952s left) debugfs_test (sysfs)
[161.830513] Starting subtest: sysfs
[162.385238] Subtest sysfs: SUCCESS (0.556s)
[163.369383] [006/161] (950s left) fbdev (eof)
[163.654738] Starting subtest: eof
[163.657545] Subtest eof: SUCCESS (0.003s)
[163.859339] [007/161] (950s left) fbdev (info)
[164.108647] Starting subtest: info
[164.111398] Subtest info: SUCCESS (0.000s)
[164.334325] [008/161] (949s left) fbdev (nullptr)
[164.597890] Starting subtest: nullptr
[164.602603] Subtest nullptr: SUCCESS (0.000s)
[164.809210] [009/161] (949s left) fbdev (read)
[165.062957] Starting subtest: read
[167.164587] Subtest read: SUCCESS (2.093s)
[167.367632] [010/161] (947s left) fbdev (write)
[167.634656] Starting subtest: write
[168.732484] Subtest write: SUCCESS (1.095s)
[168.938723] [011/161] (945s left) gem_basic (bad-close)
[169.192495] Starting subtest: bad-close
[169.198539] Subtest bad-close: SUCCESS (0.000s)
[169.415082] [012/161] (945s left) gem_basic (create-close)
[169.677235] Starting subtest: create-close
[169.680837] Subtest create-close: SUCCESS (0.001s)
[169.926154] [013/161] (945s left) gem_basic (create-fd-close)
[170.185354] Starting subtest: create-fd-close
[170.192233] Subtest create-fd-close: SUCCESS (0.001s)
[170.407882] [014/161] (944s left) gem_busy (busy@all-engines)
[170.736145] Starting subtest: busy
[170.737717] Starting dynamic subtest: all-engines
[171.039584] Dynamic subtest all-engines: SUCCESS (0.295s)
[171.041494] Subtest busy: SUCCESS (0.297s)
[171.595471] [015/161] (943s left) gem_close_race (basic-process)
[171.920141] Starting subtest: basic-process
[172.093582] Subtest basic-process: SUCCESS (0.178s)
[172.448653] [016/161] (943s left) gem_close_race (basic-threads)
[172.789198] Starting subtest: basic-threads
[174.012973] Subtest basic-threads: SUCCESS (1.224s)
[174.356219] [017/161] (941s left) gem_ctx_create (basic)
[174.674891] Starting subtest: basic
[174.676856] Subtest basic: SUCCESS (0.000s)
[175.019585] [018/161] (940s left) gem_ctx_create (basic-files)
[175.330900] Starting subtest: basic-files
[177.412956] Subtest basic-files: SUCCESS (2.083s)
[177.765385] [019/161] (938s left) gem_ctx_exec (basic)
[178.040779] Starting subtest: basic
[178.057762] Subtest basic: SUCCESS (0.018s)
[178.281177] [020/161] (937s left) gem_exec_basic (basic)
[178.583047] Starting subtest: basic
[178.586428] Starting dynamic subtest: rcs0-smem
[178.590278] Dynamic subtest rcs0-smem: SUCCESS (0.006s)
[178.639286] Starting dynamic subtest: bcs0-smem
[178.640661] Dynamic subtest bcs0-smem: SUCCESS (0.024s)
[178.668572] Starting dynamic subtest: vcs0-smem
[178.671595] Dynamic subtest vcs0-smem: SUCCESS (0.003s)
[178.704851] Starting dynamic subtest: vecs0-smem
[178.706984] Dynamic subtest vecs0-smem: SUCCESS (0.003s)
[178.709847] Subtest basic: SUCCESS (0.045s)
[178.976870] [021/161] (937s left) gem_exec_create (basic)
[179.290057] Starting subtest: basic
[179.292493] Starting dynamic subtest: smem
[181.394698] Dynamic subtest smem: SUCCESS (2.099s)
[181.397128] Subtest basic: SUCCESS (2.100s)
[181.749556] [022/161] (934s left) gem_exec_fence (basic-busy)
[182.241530] Starting subtest: basic-busy
[182.244740] Starting dynamic subtest: rcs0
[182.279685] Dynamic subtest rcs0: SUCCESS (0.035s)
[182.308404] Starting dynamic subtest: bcs0
[182.321632] Dynamic subtest bcs0: SUCCESS (0.037s)
[182.347900] Starting dynamic subtest: vcs0
[182.357208] Dynamic subtest vcs0: SUCCESS (0.033s)
[182.384049] Starting dynamic subtest: vecs0
[182.391782] Dynamic subtest vecs0: SUCCESS (0.031s)
[182.395894] Subtest basic-busy: SUCCESS (0.153s)
[183.417466] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[183.426528] [023/161] (933s left) gem_exec_fence (basic-wait)
[183.904344] Starting subtest: basic-wait
[183.909545] Starting dynamic subtest: rcs0
[183.927899] Dynamic subtest rcs0: SUCCESS (0.025s)
[183.966827] Starting dynamic subtest: bcs0
[183.968578] Dynamic subtest bcs0: SUCCESS (0.037s)
[183.997180] Starting dynamic subtest: vcs0
[184.018076] Dynamic subtest vcs0: SUCCESS (0.051s)
[184.055056] Starting dynamic subtest: vecs0
[184.064330] Dynamic subtest vecs0: SUCCESS (0.044s)
[184.066979] Subtest basic-wait: SUCCESS (0.164s)
[184.917624] [024/161] (932s left) gem_exec_fence (basic-await)
[185.414095] Starting subtest: basic-await
[185.417469] Starting dynamic subtest: rcs0
[185.634190] Dynamic subtest rcs0: SUCCESS (0.220s)
[185.659290] Starting dynamic subtest: bcs0
[185.860712] Dynamic subtest bcs0: SUCCESS (0.221s)
[185.913335] Starting dynamic subtest: vcs0
[186.232239] Dynamic subtest vcs0: SUCCESS (0.357s)
[186.257418] Starting dynamic subtest: vecs0
[186.446679] Dynamic subtest vecs0: SUCCESS (0.222s)
[186.448288] Subtest basic-await: SUCCESS (1.030s)
[187.311628] [025/161] (929s left) gem_exec_fence (nb-await)
[187.800112] Starting subtest: nb-await
[187.803132] Starting dynamic subtest: rcs0
[187.905367] Dynamic subtest rcs0: SUCCESS (0.101s)
[187.930346] Starting dynamic subtest: bcs0
[188.008340] Dynamic subtest bcs0: SUCCESS (0.103s)
[188.034247] Starting dynamic subtest: vcs0
[188.105307] Dynamic subtest vcs0: SUCCESS (0.091s)
[188.136919] Starting dynamic subtest: vecs0
[188.204976] Dynamic subtest vecs0: SUCCESS (0.099s)
[188.206940] Subtest nb-await: SUCCESS (0.403s)
[189.038819] [026/161] (928s left) gem_exec_gttfill (basic)
[189.354564] Starting subtest: basic
[190.837876] Subtest basic: SKIP (1.431s)
[191.209798] [027/161] (926s left) gem_exec_parallel (engines)
[191.695598] Starting subtest: engines
[191.697981] Starting dynamic subtest: basic
[198.317888] Dynamic subtest basic: SUCCESS (6.629s)
[198.345698] Starting dynamic subtest: contexts
[207.956213] Dynamic subtest contexts: SUCCESS (9.630s)
[207.985514] Starting dynamic subtest: fds
[218.972196] Dynamic subtest fds: SUCCESS (11.014s)
[219.006046] Starting dynamic subtest: userptr
[225.258587] Dynamic subtest userptr: SUCCESS (6.280s)
[225.261233] Subtest engines: SUCCESS (33.565s)
[225.669207] [028/161] (892s left) gem_exec_store (basic)
[225.994149] Starting subtest: basic
[226.072856] Subtest basic: SUCCESS (0.085s)
[226.451712] [029/161] (891s left) gem_flink_basic (bad-flink)
[226.726097] Starting subtest: bad-flink
[226.730518] Subtest bad-flink: SUCCESS (0.000s)
[226.972533] [030/161] (891s left) gem_flink_basic (bad-open)
[227.228101] Starting subtest: bad-open
[227.230521] Subtest bad-open: SUCCESS (0.000s)
[227.472669] [031/161] (890s left) gem_flink_basic (basic)
[227.729194] Starting subtest: basic
[227.732807] Subtest basic: SUCCESS (0.000s)
[227.999076] [032/161] (890s left) gem_flink_basic (double-flink)
[228.258797] Starting subtest: double-flink
[228.261605] Subtest double-flink: SUCCESS (0.000s)
[228.516214] [033/161] (890s left) gem_flink_basic (flink-lifetime)
[228.769236] Starting subtest: flink-lifetime
[228.775698] Subtest flink-lifetime: SUCCESS (0.007s)
[229.019472] [034/161] (889s left) gem_huc_copy (huc-copy)
[229.296931] Subtest huc-copy: SKIP (0.000s)
[229.529268] [035/161] (889s left) gem_linear_blits (basic)
[230.134740] Subtest basic: SKIP (0.000s)
[230.345351] [036/161] (888s left) gem_mmap (basic)
[230.789506] Starting subtest: basic
[230.803165] Subtest basic: SUCCESS (0.002s)
[231.055962] [037/161] (888s left) gem_mmap_gtt (basic)
[231.324356] Starting subtest: basic
[231.326754] Subtest basic: SUCCESS (0.003s)
[231.570473] [038/161] (888s left) gem_render_linear_blits (basic)
[231.855975] Starting subtest: basic
[232.001971] Subtest basic: SUCCESS (0.139s)
[232.218726] [039/161] (887s left) gem_render_tiled_blits (basic)
[232.499080] Starting subtest: basic
[232.660470] Subtest basic: SUCCESS (0.157s)
[232.865805] [040/161] (887s left) gem_ringfill (basic-all)
[233.399410] Starting subtest: basic-all
[234.780633] Subtest basic-all: SUCCESS (1.375s)
[235.038281] [041/161] (885s left) gem_softpin (allocator-basic)
[235.314454] Starting subtest: allocator-basic
[235.685647] Subtest allocator-basic: SUCCESS (0.357s)
[235.966812] [042/161] (884s left) gem_softpin (allocator-basic-reserve)
[236.235895] Starting subtest: allocator-basic-reserve
[236.630225] Subtest allocator-basic-reserve: SUCCESS (0.376s)
[236.960338] [043/161] (883s left) gem_softpin (safe-alignment)
[237.240289] Starting subtest: safe-alignment
[237.296127] Subtest safe-alignment: SUCCESS (0.047s)
[237.522155] [044/161] (883s left) gem_sync (basic-all)
[237.835174] Starting subtest: basic-all
[240.873828] Subtest basic-all: SUCCESS (3.037s)
[241.249606] [045/161] (879s left) gem_sync (basic-each)
[241.558131] Starting subtest: basic-each
[244.234155] Subtest basic-each: SUCCESS (2.673s)
[244.651589] [046/161] (876s left) gem_tiled_blits (basic)
[245.180363] Subtest basic: SKIP (0.000s)
[245.379686] [047/161] (876s left) gem_tiled_fence_blits (basic)
[246.241115] Starting subtest: basic
[246.302700] Subtest basic: SUCCESS (0.066s)
[246.600448] [048/161] (875s left) gem_tiled_pread_basic
[248.024901] [049/161] (873s left) gem_wait (busy@all-engines)
[248.370160] Starting subtest: busy
[248.373452] Starting dynamic subtest: all-engines
[248.900388] Dynamic subtest all-engines: SUCCESS (0.533s)
[248.903252] Subtest busy: SUCCESS (0.536s)
[249.373361] [050/161] (872s left) gem_wait (wait@all-engines)
[249.722404] Starting subtest: wait
[249.724642] Starting dynamic subtest: all-engines
[250.775996] Dynamic subtest all-engines: SUCCESS (1.051s)
[250.778643] Subtest wait: SUCCESS (1.057s)
[251.261049] [051/161] (870s left) i915_getparams_basic (basic-eu-total)
[251.518527] Starting subtest: basic-eu-total
[251.523359] Subtest basic-eu-total: SUCCESS (0.000s)
[251.754170] [052/161] (870s left) i915_getparams_basic (basic-subslice-total)
[252.011207] Starting subtest: basic-subslice-total
[252.014382] Subtest basic-subslice-total: SUCCESS (0.000s)
[252.252726] [053/161] (870s left) i915_hangman (error-state-basic)
[252.548244] Starting subtest: error-state-basic
[252.586563] Subtest error-state-basic: SUCCESS (0.023s)
[252.918432] [054/161] (869s left) i915_pciid
[253.483279] [055/161] (869s left) kms_addfb_basic (addfb25-4-tiled)
[254.208603] Starting subtest: addfb25-4-tiled
[254.214566] Subtest addfb25-4-tiled: SUCCESS (0.002s)
[254.478182] [056/161] (868s left) kms_addfb_basic (addfb25-bad-modifier)
[255.194588] Starting subtest: addfb25-bad-modifier
[255.198304] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[255.429270] [057/161] (868s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[256.158755] Starting subtest: addfb25-framebuffer-vs-set-tiling
[256.162889] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.001s)
[256.418939] [058/161] (867s left) kms_addfb_basic (addfb25-modifier-no-flag)
[257.148984] Starting subtest: addfb25-modifier-no-flag
[257.152559] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[257.373625] [059/161] (866s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[258.122445] Starting subtest: addfb25-x-tiled-legacy
[258.124816] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[258.388256] [060/161] (865s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[259.110972] Starting subtest: addfb25-x-tiled-mismatch-legacy
[259.114520] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[259.363126] [061/161] (864s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[260.070337] Starting subtest: addfb25-yf-tiled-legacy
[260.071917] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[260.317501] [062/161] (864s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[261.147692] Starting subtest: addfb25-y-tiled-legacy
[261.153726] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[261.390507] [063/161] (863s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[262.125847] Starting subtest: addfb25-y-tiled-small-legacy
[262.132839] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[262.373975] [064/161] (862s left) kms_addfb_basic (bad-pitch-0)
[262.638393] Starting subtest: bad-pitch-0
[262.640130] Subtest bad-pitch-0: SUCCESS (0.000s)
[263.349713] [065/161] (861s left) kms_addfb_basic (bad-pitch-1024)
[263.612264] Starting subtest: bad-pitch-1024
[263.616329] Subtest bad-pitch-1024: SUCCESS (0.000s)
[264.322491] [066/161] (860s left) kms_addfb_basic (bad-pitch-128)
[264.582797] Starting subtest: bad-pitch-128
[264.585349] Subtest bad-pitch-128: SUCCESS (0.000s)
[265.295153] [067/161] (860s left) kms_addfb_basic (bad-pitch-256)
[265.557141] Starting subtest: bad-pitch-256
[265.559664] Subtest bad-pitch-256: SUCCESS (0.000s)
[266.271425] [068/161] (859s left) kms_addfb_basic (bad-pitch-32)
[266.546633] Starting subtest: bad-pitch-32
[266.548247] Subtest bad-pitch-32: SUCCESS (0.000s)
[267.276656] [069/161] (858s left) kms_addfb_basic (bad-pitch-63)
[267.530660] Starting subtest: bad-pitch-63
[267.532947] Subtest bad-pitch-63: SUCCESS (0.000s)
[268.226514] [070/161] (857s left) kms_addfb_basic (bad-pitch-65536)
[268.485834] Starting subtest: bad-pitch-65536
[268.488789] Subtest bad-pitch-65536: SUCCESS (0.002s)
[269.220493] [071/161] (856s left) kms_addfb_basic (bad-pitch-999)
[269.481523] Starting subtest: bad-pitch-999
[269.485084] Subtest bad-pitch-999: SUCCESS (0.000s)
[270.204698] [072/161] (856s left) kms_addfb_basic (basic)
[270.464460] Starting subtest: basic
[270.467125] Subtest basic: SUCCESS (0.000s)
[271.193734] [073/161] (855s left) kms_addfb_basic (basic-x-tiled-legacy)
[271.451569] Starting subtest: basic-x-tiled-legacy
[271.455233] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[272.175340] [074/161] (854s left) kms_addfb_basic (basic-y-tiled-legacy)
[272.436193] Starting subtest: basic-y-tiled-legacy
[272.438229] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[273.166412] [075/161] (853s left) kms_addfb_basic (bo-too-small)
[273.896375] Starting subtest: bo-too-small
[273.898337] Subtest bo-too-small: SUCCESS (0.001s)
[274.173115] [076/161] (852s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[274.954194] Starting subtest: bo-too-small-due-to-tiling
[274.957129] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[275.208398] [077/161] (852s left) kms_addfb_basic (clobberred-modifier)
[275.463696] Starting subtest: clobberred-modifier
[275.466969] Subtest clobberred-modifier: SUCCESS (0.000s)
[276.266717] [078/161] (851s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[276.533166] Starting subtest: framebuffer-vs-set-tiling
[276.535127] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[277.225731] [079/161] (850s left) kms_addfb_basic (invalid-get-prop)
[277.492473] Starting subtest: invalid-get-prop
[277.494333] Subtest invalid-get-prop: SUCCESS (0.000s)
[278.218700] [080/161] (849s left) kms_addfb_basic (invalid-get-prop-any)
[278.477861] Starting subtest: invalid-get-prop-any
[278.479953] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[279.201586] [081/161] (848s left) kms_addfb_basic (invalid-set-prop)
[279.463455] Starting subtest: invalid-set-prop
[279.467143] Subtest invalid-set-prop: SUCCESS (0.000s)
[280.209385] [082/161] (848s left) kms_addfb_basic (invalid-set-prop-any)
[280.469743] Starting subtest: invalid-set-prop-any
[280.473439] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[281.203268] [083/161] (847s left) kms_addfb_basic (no-handle)
[281.467243] Starting subtest: no-handle
[281.469585] Subtest no-handle: SUCCESS (0.000s)
[282.149780] [084/161] (846s left) kms_addfb_basic (size-max)
[282.899198] Starting subtest: size-max
[282.901604] Subtest size-max: SUCCESS (0.000s)
[283.161707] [085/161] (845s left) kms_addfb_basic (small-bo)
[283.892609] Starting subtest: small-bo
[283.895389] Subtest small-bo: SUCCESS (0.000s)
[284.140906] [086/161] (844s left) kms_addfb_basic (tile-pitch-mismatch)
[284.399132] Starting subtest: tile-pitch-mismatch
[284.401355] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[285.108480] [087/161] (844s left) kms_addfb_basic (too-high)
[285.836840] Starting subtest: too-high
[285.839619] Subtest too-high: SUCCESS (0.004s)
[286.085113] [088/161] (843s left) kms_addfb_basic (too-wide)
[286.802920] Starting subtest: too-wide
[286.805638] Subtest too-wide: SUCCESS (0.000s)
[287.046912] [089/161] (842s left) kms_addfb_basic (unused-handle)
[287.307676] Starting subtest: unused-handle
[287.310895] Subtest unused-handle: SUCCESS (0.000s)
[288.036645] [090/161] (841s left) kms_addfb_basic (unused-modifier)
[288.297458] Starting subtest: unused-modifier
[288.299436] Subtest unused-modifier: SUCCESS (0.000s)
[289.049034] [091/161] (840s left) kms_addfb_basic (unused-offsets)
[289.312685] Starting subtest: unused-offsets
[289.315776] Subtest unused-offsets: SUCCESS (0.000s)
[290.032620] [092/161] (840s left) kms_addfb_basic (unused-pitches)
[290.295379] Starting subtest: unused-pitches
[290.297947] Subtest unused-pitches: SUCCESS (0.000s)
[291.067820] [093/161] (839s left) kms_busy (basic)
[291.826926] Starting subtest: basic
[291.833683] Starting dynamic subtest: flip
[292.804100] Dynamic subtest flip: SUCCESS (0.969s)
[292.878178] Starting dynamic subtest: modeset
[294.739096] Dynamic subtest modeset: SUCCESS (1.904s)
[294.741126] Subtest basic: SUCCESS (2.901s)
[295.405611] [094/161] (835s left) kms_prop_blob (basic)
[295.673727] Starting subtest: basic
[295.678706] Subtest basic: SUCCESS (0.000s)
[295.912363] [095/161] (834s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[296.672639] Starting subtest: basic-busy-flip-before-cursor-atomic
[297.749276] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.069s)
[298.429540] [096/161] (832s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[299.186663] Starting subtest: basic-busy-flip-before-cursor-legacy
[300.268579] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.078s)
[300.926566] [097/161] (830s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[301.641650] Starting subtest: basic-flip-after-cursor-atomic
[302.685517] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.034s)
[303.306385] [098/161] (828s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[304.043997] Starting subtest: basic-flip-after-cursor-legacy
[305.085772] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.036s)
[305.675735] [099/161] (825s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[306.527118] Starting subtest: basic-flip-after-cursor-varying-size
[307.599117] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.057s)
[308.202681] [100/161] (823s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[308.947068] Starting subtest: basic-flip-before-cursor-atomic
[310.001125] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.043s)
[310.624966] [101/161] (821s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[311.389909] Starting subtest: basic-flip-before-cursor-legacy
[312.437721] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.045s)
[313.080443] [102/161] (819s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[314.022700] Starting subtest: basic-flip-before-cursor-varying-size
[315.074583] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.047s)
[315.692176] [103/161] (816s left) kms_dsc (dsc-basic)
[316.439109] Subtest dsc-basic: SKIP (0.000s)
[316.658557] [104/161] (815s left) kms_flip (basic-flip-vs-dpms)
[317.444575] Starting subtest: basic-flip-vs-dpms
[317.458292] Starting dynamic subtest: C-HDMI-A2
[320.158739] Dynamic subtest C-HDMI-A2: SUCCESS (2.685s)
[320.161319] Subtest basic-flip-vs-dpms: SUCCESS (2.719s)
[320.831330] [105/161] (811s left) kms_flip (basic-flip-vs-modeset)
[321.687927] Starting subtest: basic-flip-vs-modeset
[321.703258] Starting dynamic subtest: C-HDMI-A2
[324.451690] Dynamic subtest C-HDMI-A2: SUCCESS (2.747s)
[324.458051] Subtest basic-flip-vs-modeset: SUCCESS (2.772s)
[325.150603] [106/161] (807s left) kms_flip (basic-flip-vs-wf_vblank)
[325.943462] Starting subtest: basic-flip-vs-wf_vblank
[325.960067] Starting dynamic subtest: C-HDMI-A2
[328.931653] Dynamic subtest C-HDMI-A2: SUCCESS (2.968s)
[328.935720] Subtest basic-flip-vs-wf_vblank: SUCCESS (2.992s)
[329.257759] [107/161] (803s left) kms_flip (basic-plain-flip)
[330.052563] Starting subtest: basic-plain-flip
[330.064718] Starting dynamic subtest: C-HDMI-A2
[332.560167] Dynamic subtest C-HDMI-A2: SUCCESS (2.491s)
[332.562712] Subtest basic-plain-flip: SUCCESS (2.516s)
[332.887612] [108/161] (800s left) kms_force_connector_basic (force-connector-state)
[333.280110] Starting subtest: force-connector-state
[334.196340] Subtest force-connector-state: SUCCESS (0.916s)
[335.763681] [109/161] (797s left) kms_force_connector_basic (force-edid)
[336.225111] Starting subtest: force-edid
[336.343147] Subtest force-edid: SUCCESS (0.110s)
[337.342782] [110/161] (796s left) kms_force_connector_basic (force-load-detect)
[337.750054] Starting subtest: force-load-detect
[337.755598] Subtest force-load-detect: SKIP (0.000s)
[338.418989] [111/161] (795s left) kms_force_connector_basic (prune-stale-modes)
[338.853256] Starting subtest: prune-stale-modes
[339.014416] Subtest prune-stale-modes: SUCCESS (0.166s)
[339.974357] [112/161] (794s left) kms_frontbuffer_tracking (basic)
[340.751904] Starting subtest: basic
[345.766128] Subtest basic: SUCCESS (5.010s)
[346.030282] [113/161] (788s left) kms_hdmi_inject (inject-audio)
[346.421690] Starting subtest: inject-audio
[347.098789] Subtest inject-audio: SUCCESS (0.611s)
[347.773801] [114/161] (786s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[348.557904] Starting subtest: compare-crc-sanitycheck-xr24
[348.561553] Starting dynamic subtest: pipe-C-HDMI-A-2
[349.108435] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.546s)
[349.112586] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.555s)
[349.738536] [115/161] (785s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[350.447280] Starting subtest: compare-crc-sanitycheck-nv12
[350.463780] Starting dynamic subtest: pipe-C-HDMI-A-2
[350.472734] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[350.478268] Subtest compare-crc-sanitycheck-nv12: SKIP (0.010s)
[350.723899] [116/161] (784s left) kms_pipe_crc_basic (hang-read-crc)
[351.532092] Starting subtest: hang-read-crc
[351.535177] Starting dynamic subtest: pipe-C-HDMI-A-2
[353.058147] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.530s)
[353.059866] Subtest hang-read-crc: SUCCESS (1.539s)
[353.648929] [117/161] (781s left) kms_pipe_crc_basic (nonblocking-crc)
[354.433573] Starting subtest: nonblocking-crc
[354.436488] Starting dynamic subtest: pipe-C-HDMI-A-2
[355.169594] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.730s)
[355.172680] Subtest nonblocking-crc: SUCCESS (0.739s)
[355.758644] [118/161] (779s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[356.548723] Starting subtest: nonblocking-crc-frame-sequence
[356.555192] Starting dynamic subtest: pipe-C-HDMI-A-2
[357.282533] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.722s)
[357.284637] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.737s)
[357.996866] [119/161] (777s left) kms_pipe_crc_basic (read-crc)
[358.740084] Starting subtest: read-crc
[358.745839] Starting dynamic subtest: pipe-C-HDMI-A-2
[359.425215] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.673s)
[359.426633] Subtest read-crc: SUCCESS (0.690s)
[360.038511] [120/161] (775s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[360.819597] Starting subtest: read-crc-frame-sequence
[360.821862] Starting dynamic subtest: pipe-C-HDMI-A-2
[361.502058] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.678s)
[361.504421] Subtest read-crc-frame-sequence: SUCCESS (0.686s)
[362.120430] [121/161] (773s left) kms_pm_backlight (basic-brightness)
[362.907570] Subtest basic-brightness: SKIP (0.000s)
[363.142066] [122/161] (773s left) kms_pm_rpm (basic-pci-d3-state)
[365.559694] Starting subtest: basic-pci-d3-state
[365.961967] Subtest basic-pci-d3-state: SUCCESS (0.388s)
[366.487435] [123/161] (769s left) kms_pm_rpm (basic-rte)
[366.741586] Starting subtest: basic-rte
[369.183399] Subtest basic-rte: SUCCESS (2.442s)
[370.348371] [124/161] (766s left) kms_psr (psr-primary-page-flip)
[371.131663] Subtest psr-primary-page-flip: SKIP (0.000s)
[371.339087] [125/161] (765s left) kms_psr (psr-cursor-plane-move)
[372.130879] Subtest psr-cursor-plane-move: SKIP (0.000s)
[372.458075] [126/161] (764s left) kms_psr (psr-sprite-plane-onoff)
[373.416647] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[373.643862] [127/161] (763s left) kms_psr (psr-primary-mmap-gtt)
[374.455125] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[374.688916] [128/161] (762s left) kms_setmode (basic-clone-single-crtc)
[374.956257] Starting subtest: basic-clone-single-crtc
[374.963218] Subtest basic-clone-single-crtc: SKIP (0.001s)
[375.218360] [129/161] (762s left) i915_pm_rps (basic-api)
[375.505608] Starting subtest: basic-api
[375.522732] Subtest basic-api: SUCCESS (0.017s)
[375.786792] [130/161] (762s left) prime_self_import (basic-llseek-bad)
[376.048844] Starting subtest: basic-llseek-bad
[376.053686] Subtest basic-llseek-bad: SUCCESS (0.011s)
[376.311737] [131/161] (761s left) prime_self_import (basic-llseek-size)
[376.566214] Starting subtest: basic-llseek-size
[376.585582] Subtest basic-llseek-size: SUCCESS (0.018s)
[376.910710] [132/161] (761s left) prime_self_import (basic-with_fd_dup)
[377.170195] Starting subtest: basic-with_fd_dup
[377.174308] Subtest basic-with_fd_dup: SUCCESS (0.013s)
[377.453835] [133/161] (761s left) prime_self_import (basic-with_one_bo)
[377.703568] Starting subtest: basic-with_one_bo
[377.717629] Subtest basic-with_one_bo: SUCCESS (0.014s)
[377.978735] [134/161] (760s left) prime_self_import (basic-with_one_bo_two_files)
[378.224656] Starting subtest: basic-with_one_bo_two_files
[378.245626] Subtest basic-with_one_bo_two_files: SUCCESS (0.017s)
[378.515449] [135/161] (760s left) prime_self_import (basic-with_two_bos)
[378.761716] Starting subtest: basic-with_two_bos
[378.781706] Subtest basic-with_two_bos: SUCCESS (0.021s)
[379.035896] [136/161] (760s left) prime_vgem (basic-fence-flip)
[379.349185] Starting subtest: basic-fence-flip
[380.248689] Subtest basic-fence-flip: SKIP (0.896s)
[380.567234] [137/161] (758s left) prime_vgem (basic-fence-mmap)
[380.903203] Starting subtest: basic-fence-mmap
[381.058902] Subtest basic-fence-mmap: SUCCESS (0.154s)
[381.328842] [138/161] (758s left) prime_vgem (basic-fence-read)
[381.628144] Starting subtest: basic-fence-read
[381.885993] Subtest basic-fence-read: SUCCESS (0.255s)
[382.152488] [139/161] (757s left) prime_vgem (basic-gtt)
[382.463542] Starting subtest: basic-gtt
[382.517150] Subtest basic-gtt: SUCCESS (0.048s)
[382.781371] [140/161] (757s left) prime_vgem (basic-read)
[383.073674] Starting subtest: basic-read
[383.197378] Subtest basic-read: SUCCESS (0.115s)
[383.463119] [141/161] (756s left) prime_vgem (basic-write)
[383.762515] Starting subtest: basic-write
[383.912904] Subtest basic-write: SUCCESS (0.156s)
[384.197809] [142/161] (756s left) vgem_basic (setversion)
[384.475534] Starting subtest: setversion
[384.480180] Subtest setversion: SUCCESS (0.000s)
[384.715543] [143/161] (755s left) vgem_basic (create)
[384.981965] Starting subtest: create
[384.984882] Subtest create: SUCCESS (0.001s)
[385.223895] [144/161] (755s left) vgem_basic (debugfs)
[385.505688] Starting subtest: debugfs
[385.509591] Subtest debugfs: SUCCESS (0.002s)
[385.749695] [145/161] (755s left) vgem_basic (dmabuf-export)
[386.025485] Starting subtest: dmabuf-export
[386.031064] Subtest dmabuf-export: SUCCESS (0.010s)
[386.272970] [146/161] (754s left) vgem_basic (dmabuf-fence)
[386.536087] Starting subtest: dmabuf-fence
[386.540806] Subtest dmabuf-fence: SUCCESS (0.004s)
[386.762830] [147/161] (754s left) vgem_basic (dmabuf-fence-before)
[387.028836] Starting subtest: dmabuf-fence-before
[387.030898] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[387.262920] [148/161] (754s left) vgem_basic (dmabuf-mmap)
[387.537613] Starting subtest: dmabuf-mmap
[387.580481] Subtest dmabuf-mmap: SUCCESS (0.045s)
[387.861598] [149/161] (753s left) vgem_basic (mmap)
[388.141592] Starting subtest: mmap
[388.168935] Subtest mmap: SUCCESS (0.032s)
[388.408867] [150/161] (753s left) vgem_basic (second-client)
[388.680831] Starting subtest: second-client
[388.713691] Subtest second-client: SUCCESS (0.030s)
[388.931329] [151/161] (753s left) vgem_basic (sysfs)
[389.207584] Starting subtest: sysfs
[389.210552] Subtest sysfs: SUCCESS (0.002s)
[389.437329] [152/161] (752s left) core_hotunplug (unbind-rebind)
[389.900087] Starting subtest: unbind-rebind
[395.905981] Subtest unbind-rebind: SUCCESS (6.005s)
[396.199186] [153/161] (746s left) vgem_basic (unload)
[396.551783] Starting subtest: unload
[425.877123] Subtest unload: SUCCESS (29.316s)
[426.360880] [154/161] (716s left) i915_module_load (reload)
[426.618411] Starting subtest: reload
[433.973905] Subtest reload: SUCCESS (7.340s)
[434.476151] [155/161] (708s left) gem_lmem_swapping (basic)
[435.145111] Subtest basic: SKIP (0.000s)
[435.513205] [156/161] (708s left) gem_lmem_swapping (parallel-random-engines)
[435.889141] Subtest parallel-random-engines: SKIP (0.000s)
[436.102998] [157/161] (707s left) gem_lmem_swapping (random-engines)
[436.378467] Subtest random-engines: SKIP (0.000s)
[436.605180] [158/161] (707s left) gem_lmem_swapping (verify-random)
[436.892590] Subtest verify-random: SKIP (0.000s)
[437.100995] [159/161] (707s left) i915_pm_rpm (module-reload)
[439.772345] Starting subtest: module-reload
[459.004341] Subtest module-reload: SUCCESS (19.228s)
[459.151045] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[459.157230] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[459.167930] [160/161] (685s left) i915_selftest (live)
[459.458639] Starting subtest: live
[459.462518] Starting dynamic subtest: sanitycheck
[463.874428] Dynamic subtest sanitycheck: SUCCESS (4.411s)
[463.912189] Starting dynamic subtest: uncore
[468.235744] Dynamic subtest uncore: SUCCESS (4.348s)
[468.285378] Starting dynamic subtest: workarounds
[472.940470] Dynamic subtest workarounds: SUCCESS (4.697s)
[472.966367] Starting dynamic subtest: gt_engines
[477.870495] Dynamic subtest gt_engines: SUCCESS (4.922s)
[477.903510] Starting dynamic subtest: gt_timelines
[509.274819] Dynamic subtest gt_timelines: SUCCESS (31.392s)
[509.325523] Starting dynamic subtest: gt_contexts
[513.996819] Dynamic subtest gt_contexts: SUCCESS (4.717s)
[514.037935] Starting dynamic subtest: gt_lrc
[521.572406] Dynamic subtest gt_lrc: SUCCESS (7.559s)
[521.605527] Starting dynamic subtest: gt_mocs
[526.004845] Dynamic subtest gt_mocs: SUCCESS (4.422s)
[526.036641] Starting dynamic subtest: gt_pm
[531.675755] Dynamic subtest gt_pm: SUCCESS (5.664s)
[531.700816] Starting dynamic subtest: gt_heartbeat
[536.134217] Dynamic subtest gt_heartbeat: SUCCESS (4.446s)
[536.183155] Starting dynamic subtest: gt_tlb
[541.077680] Dynamic subtest gt_tlb: SUCCESS (4.938s)
[541.132482] Starting dynamic subtest: requests
[551.687252] Dynamic subtest requests: SUCCESS (10.594s)
[551.718654] Starting dynamic subtest: migrate
[559.645139] Dynamic subtest migrate: SUCCESS (7.945s)
[559.678049] Starting dynamic subtest: active
[564.119820] Dynamic subtest active: SUCCESS (4.461s)
[564.144941] Starting dynamic subtest: objects
[570.892756] Dynamic subtest objects: SUCCESS (6.769s)
[570.948659] Starting dynamic subtest: mman
[582.100545] Dynamic subtest mman: SUCCESS (11.185s)
[582.133802] Starting dynamic subtest: dmabuf
[586.601791] Dynamic subtest dmabuf: SUCCESS (4.493s)
[586.665488] Starting dynamic subtest: vma
[591.143208] Dynamic subtest vma: SUCCESS (4.525s)
[591.227211] Starting dynamic subtest: coherency
[600.806212] Dynamic subtest coherency: SUCCESS (9.600s)
[600.834062] Starting dynamic subtest: gtt
[612.347710] Dynamic subtest gtt: SUCCESS (11.519s)
[612.394641] Starting dynamic subtest: gem
[617.968346] Dynamic subtest gem: SUCCESS (5.631s)
[618.023234] Starting dynamic subtest: evict
[629.231801] Dynamic subtest evict: SUCCESS (11.249s)
[629.283243] Starting dynamic subtest: hugepages
[634.141389] Dynamic subtest hugepages: SUCCESS (4.908s)
[634.185534] Starting dynamic subtest: gem_contexts
[663.726168] Dynamic subtest gem_contexts: SUCCESS (29.567s)
[663.752030] Starting dynamic subtest: client
[668.316268] Dynamic subtest client: SUCCESS (4.581s)
[668.350405] Starting dynamic subtest: gem_migrate
[672.843352] Dynamic subtest gem_migrate: SUCCESS (4.518s)
[672.879142] Starting dynamic subtest: reset
[684.648956] Dynamic subtest reset: SUCCESS (11.798s)
[684.674318] Starting dynamic subtest: memory_region
[688.951427] Dynamic subtest memory_region: SUCCESS (4.294s)
[688.999546] Starting dynamic subtest: hangcheck
[716.821139] Dynamic subtest hangcheck: SUCCESS (27.857s)
[716.852048] Starting dynamic subtest: execlists
[727.359676] Dynamic subtest execlists: SUCCESS (10.527s)
[727.393315] Starting dynamic subtest: ring_submission
[731.675506] Dynamic subtest ring_submission: SUCCESS (4.308s)
[731.762192] Starting dynamic subtest: perf
[736.459217] Dynamic subtest perf: SUCCESS (4.771s)
[736.495083] Starting dynamic subtest: slpc
[740.925533] Dynamic subtest slpc: SUCCESS (4.462s)
[740.977980] Starting dynamic subtest: guc
[745.227144] Dynamic subtest guc: SUCCESS (4.294s)
[745.252494] Starting dynamic subtest: guc_multi_lrc
[749.641108] Dynamic subtest guc_multi_lrc: SUCCESS (4.403s)
[749.666464] Starting dynamic subtest: guc_hang
[754.130910] Dynamic subtest guc_hang: SUCCESS (4.483s)
[754.167553] Starting dynamic subtest: late_gt_pm
[758.501592] Dynamic subtest late_gt_pm: SUCCESS (4.361s)
[758.503368] Subtest live: SUCCESS (299.042s)
[758.666190] [161/161] (386s left) dmabuf (all-tests)
[758.934353] Starting subtest: all-tests
[758.936232] Starting dynamic subtest: sanitycheck
[759.020738] Dynamic subtest sanitycheck: SUCCESS (0.085s)
[759.066497] Starting dynamic subtest: dma_fence
[759.274168] Dynamic subtest dma_fence: SUCCESS (0.241s)
[759.336294] Starting dynamic subtest: dma_fence_chain