[88.705344] Initializing watchdogs [88.705741] /dev/watchdog0 [88.790745] [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 [88.810941] [001/162] (960s left) i915_module_load (load) [89.077125] Starting subtest: load [94.745578] Subtest load: SUCCESS (5.666s) [94.999162] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [95.013403] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [95.027339] [002/162] (954s left) core_auth (basic-auth) [95.370610] Starting subtest: basic-auth [95.379225] Subtest basic-auth: SUCCESS (0.010s) [95.573195] [003/162] (954s left) core_debugfs (read-all-entries) [95.815608] Starting subtest: read-all-entries [95.823682] Subtest read-all-entries: SUCCESS (0.012s) [96.009084] [004/162] (953s left) core_sysfs (read-all-entries) [96.239188] Starting subtest: read-all-entries [96.262205] Subtest read-all-entries: SUCCESS (0.020s) [96.435209] [005/162] (953s left) fbdev (eof) [96.707155] Subtest eof: SKIP (0.000s) [96.877498] [006/162] (953s left) fbdev (info) [97.143626] Subtest info: SKIP (0.000s) [97.306823] [007/162] (953s left) fbdev (nullptr) [97.576244] Subtest nullptr: SKIP (0.000s) [97.746976] [008/162] (952s left) fbdev (read) [98.022885] Subtest read: SKIP (0.000s) [98.217668] [009/162] (952s left) fbdev (write) [98.490970] Subtest write: SKIP (0.000s) [98.675334] [010/162] (952s left) gem_basic (bad-close) [98.918742] Starting subtest: bad-close [98.929192] Subtest bad-close: SUCCESS (0.000s) [99.097408] [011/162] (952s left) gem_basic (create-close) [99.325763] Starting subtest: create-close [99.333210] Subtest create-close: SUCCESS (0.001s) [99.501431] [012/162] (951s left) gem_basic (create-fd-close) [99.752360] Starting subtest: create-fd-close [99.778222] Subtest create-fd-close: SUCCESS (0.001s) [99.988628] [013/162] (951s left) gem_busy (busy@all-engines) [100.282744] Starting subtest: busy [100.286187] Starting dynamic subtest: all-engines [100.451905] Dynamic subtest all-engines: SUCCESS (0.173s) [100.453856] Subtest busy: SUCCESS (0.174s) [100.966648] [014/162] (950s left) gem_close_race (basic-process) [101.272285] Starting subtest: basic-process [101.429868] Subtest basic-process: SUCCESS (0.162s) [101.836546] [015/162] (950s left) gem_close_race (basic-threads) [102.239795] Starting subtest: basic-threads [103.590113] Subtest basic-threads: SUCCESS (1.348s) [103.920535] [016/162] (948s left) gem_ctx_create (basic) [104.204365] Starting subtest: basic [104.209199] Subtest basic: SUCCESS (0.000s) [104.579545] [017/162] (947s left) gem_ctx_create (basic-files) [104.863556] Starting subtest: basic-files [106.926511] Subtest basic-files: SUCCESS (2.064s) [107.353287] [018/162] (945s left) gem_ctx_exec (basic) [107.586875] Starting subtest: basic [107.606229] Subtest basic: SUCCESS (0.019s) [107.792693] [019/162] (945s left) gem_exec_basic (basic) [108.050517] Starting subtest: basic [108.055145] Starting dynamic subtest: rcs0-smem [108.058806] Dynamic subtest rcs0-smem: SUCCESS (0.008s) [108.095552] Starting dynamic subtest: bcs0-smem [108.097244] Dynamic subtest bcs0-smem: SUCCESS (0.003s) [108.124455] Starting dynamic subtest: vcs0-smem [108.126281] Dynamic subtest vcs0-smem: SUCCESS (0.003s) [108.153288] Starting dynamic subtest: vecs0-smem [108.155141] Dynamic subtest vecs0-smem: SUCCESS (0.003s) [108.156828] Subtest basic: SUCCESS (0.025s) [108.387494] [020/162] (944s left) gem_exec_create (basic) [108.675261] Starting subtest: basic [108.677334] Starting dynamic subtest: smem [110.763420] Dynamic subtest smem: SUCCESS (2.090s) [110.767658] Subtest basic: SUCCESS (2.093s) [111.063190] [021/162] (942s left) gem_exec_fence (basic-busy) [111.491500] Starting subtest: basic-busy [111.494195] Starting dynamic subtest: rcs0 [111.533627] Dynamic subtest rcs0: SUCCESS (0.040s) [111.566204] Starting dynamic subtest: bcs0 [111.569551] Dynamic subtest bcs0: SUCCESS (0.035s) [111.612418] Starting dynamic subtest: vcs0 [111.615839] Dynamic subtest vcs0: SUCCESS (0.030s) [111.645939] Starting dynamic subtest: vecs0 [111.648857] Dynamic subtest vecs0: SUCCESS (0.027s) [111.650482] Subtest basic-busy: SUCCESS (0.146s) [112.593680] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [112.604237] [022/162] (940s left) gem_exec_fence (basic-wait) [113.041293] Starting subtest: basic-wait [113.046482] Starting dynamic subtest: rcs0 [113.077731] Dynamic subtest rcs0: SUCCESS (0.035s) [113.107250] Starting dynamic subtest: bcs0 [113.114914] Dynamic subtest bcs0: SUCCESS (0.034s) [113.147727] Starting dynamic subtest: vcs0 [113.152942] Dynamic subtest vcs0: SUCCESS (0.036s) [113.183925] Starting dynamic subtest: vecs0 [113.185728] Dynamic subtest vecs0: SUCCESS (0.027s) [113.187495] Subtest basic-wait: SUCCESS (0.147s) [113.976784] [023/162] (939s left) gem_exec_fence (basic-await) [114.409426] Starting subtest: basic-await [114.412293] Starting dynamic subtest: rcs0 [114.626062] Dynamic subtest rcs0: SUCCESS (0.210s) [114.794640] Starting dynamic subtest: bcs0 [115.013637] Dynamic subtest bcs0: SUCCESS (0.381s) [115.043681] Starting dynamic subtest: vcs0 [115.208576] Dynamic subtest vcs0: SUCCESS (0.192s) [115.241247] Starting dynamic subtest: vecs0 [115.390786] Dynamic subtest vecs0: SUCCESS (0.183s) [115.393641] Subtest basic-await: SUCCESS (0.980s) [116.200530] [024/162] (937s left) gem_exec_fence (nb-await) [116.634624] Starting subtest: nb-await [116.637377] Starting dynamic subtest: rcs0 [116.742200] Dynamic subtest rcs0: SUCCESS (0.103s) [116.780658] Starting dynamic subtest: bcs0 [116.831248] Dynamic subtest bcs0: SUCCESS (0.083s) [116.868994] Starting dynamic subtest: vcs0 [116.911827] Dynamic subtest vcs0: SUCCESS (0.079s) [116.950300] Starting dynamic subtest: vecs0 [116.991633] Dynamic subtest vecs0: SUCCESS (0.083s) [116.993601] Subtest nb-await: SUCCESS (0.355s) [117.790551] [025/162] (936s left) gem_exec_gttfill (basic) [118.064120] Starting subtest: basic [150.853392] Subtest basic: SUCCESS (32.787s) [151.215736] [026/162] (903s left) gem_exec_parallel (engines) [151.700274] Starting subtest: engines [151.704367] Starting dynamic subtest: basic [160.724410] Dynamic subtest basic: SUCCESS (9.029s) [160.766300] Starting dynamic subtest: contexts [171.159269] Dynamic subtest contexts: SUCCESS (10.423s) [171.206560] Starting dynamic subtest: fds [183.573548] Dynamic subtest fds: SUCCESS (12.416s) [183.630541] Starting dynamic subtest: userptr [190.337281] Dynamic subtest userptr: SUCCESS (6.757s) [190.339385] Subtest engines: SUCCESS (38.646s) [190.718151] [027/162] (863s left) gem_exec_store (basic) [190.990267] Starting subtest: basic [191.097756] Subtest basic: SUCCESS (0.108s) [191.445395] [028/162] (863s left) gem_flink_basic (bad-flink) [191.673213] Starting subtest: bad-flink [191.676274] Subtest bad-flink: SUCCESS (0.000s) [191.870254] [029/162] (863s left) gem_flink_basic (bad-open) [192.091194] Starting subtest: bad-open [192.093426] Subtest bad-open: SUCCESS (0.000s) [192.282897] [030/162] (862s left) gem_flink_basic (basic) [192.509309] Starting subtest: basic [192.511160] Subtest basic: SUCCESS (0.001s) [192.725313] [031/162] (862s left) gem_flink_basic (double-flink) [192.946762] Starting subtest: double-flink [192.949274] Subtest double-flink: SUCCESS (0.000s) [193.163315] [032/162] (862s left) gem_flink_basic (flink-lifetime) [193.389205] Starting subtest: flink-lifetime [193.397829] Subtest flink-lifetime: SUCCESS (0.009s) [193.605893] [033/162] (862s left) gem_huc_copy (huc-copy) [193.849220] Subtest huc-copy: SKIP (0.000s) [194.057421] [034/162] (861s left) gem_linear_blits (basic) [194.615215] Starting subtest: basic [194.664424] Subtest basic: SUCCESS (0.051s) [194.910820] [035/162] (861s left) gem_mmap (basic) [195.300347] Starting subtest: basic [195.318280] Subtest basic: SUCCESS (0.002s) [195.523847] [036/162] (860s left) gem_mmap_gtt (basic) [195.757898] Starting subtest: basic [195.766518] Subtest basic: SUCCESS (0.008s) [195.988576] [037/162] (860s left) gem_render_linear_blits (basic) [196.242728] Starting subtest: basic [196.365229] Subtest basic: SUCCESS (0.118s) [196.625675] [038/162] (860s left) gem_render_tiled_blits (basic) [196.862266] Starting subtest: basic [197.059538] Subtest basic: SUCCESS (0.188s) [197.265452] [039/162] (859s left) gem_ringfill (basic-all) [197.788342] Starting subtest: basic-all [199.133448] Subtest basic-all: SUCCESS (1.350s) [199.354338] [040/162] (857s left) gem_softpin (allocator-basic) [199.601590] Starting subtest: allocator-basic [200.039080] Subtest allocator-basic: SUCCESS (0.426s) [200.309854] [041/162] (857s left) gem_softpin (allocator-basic-reserve) [200.552830] Starting subtest: allocator-basic-reserve [200.963325] Subtest allocator-basic-reserve: SUCCESS (0.408s) [201.253218] [042/162] (856s left) gem_softpin (safe-alignment) [201.502268] Starting subtest: safe-alignment [201.555652] Subtest safe-alignment: SUCCESS (0.050s) [201.780421] [043/162] (856s left) gem_sync (basic-all) [202.062811] Starting subtest: basic-all [205.818369] Subtest basic-all: SUCCESS (3.756s) [206.163526] [044/162] (851s left) gem_sync (basic-each) [206.441496] Starting subtest: basic-each [209.398347] Subtest basic-each: SUCCESS (2.955s) [209.743136] [045/162] (848s left) gem_tiled_blits (basic) [210.202531] Starting subtest: basic [210.292766] Subtest basic: SUCCESS (0.085s) [210.537472] [046/162] (848s left) gem_tiled_fence_blits (basic) [211.203341] Starting subtest: basic [211.277602] Subtest basic: SUCCESS (0.073s) [211.519076] [047/162] (847s left) gem_tiled_pread_basic (basic) [211.917538] Starting subtest: basic [212.971342] Subtest basic: SUCCESS (1.050s) [213.195646] [048/162] (845s left) gem_wait (busy@all-engines) [213.492651] Starting subtest: busy [213.494845] Starting dynamic subtest: all-engines [214.036895] Dynamic subtest all-engines: SUCCESS (0.548s) [214.047450] Subtest busy: SUCCESS (0.553s) [214.448565] [049/162] (844s left) gem_wait (wait@all-engines) [214.750186] Starting subtest: wait [214.753274] Starting dynamic subtest: all-engines [215.800337] Dynamic subtest all-engines: SUCCESS (1.047s) [215.808700] Subtest wait: SUCCESS (1.051s) [216.209950] [050/162] (843s left) i915_getparams_basic (basic-eu-total) [216.442934] Starting subtest: basic-eu-total [216.452337] Subtest basic-eu-total: SUCCESS (0.000s) [216.655417] [051/162] (842s left) i915_getparams_basic (basic-subslice-total) [216.889304] Starting subtest: basic-subslice-total [216.901535] Subtest basic-subslice-total: SUCCESS (0.000s) [217.163662] [052/162] (842s left) i915_hangman (error-state-basic) [217.462339] Starting subtest: error-state-basic [217.501936] Subtest error-state-basic: SUCCESS (0.048s) [217.767876] [053/162] (842s left) i915_pciid [218.201209] [054/162] (842s left) intel_hwmon (hwmon-read) [218.438596] Subtest hwmon-read: SKIP (0.000s) [218.645973] [055/162] (841s left) intel_hwmon (hwmon-write) [218.873930] Subtest hwmon-write: SKIP (0.000s) [219.085620] [056/162] (841s left) kms_addfb_basic (addfb25-4-tiled) [219.704153] Starting subtest: addfb25-4-tiled [219.711107] Subtest addfb25-4-tiled: SUCCESS (0.001s) [220.002745] [057/162] (841s left) kms_addfb_basic (addfb25-bad-modifier) [220.647987] Starting subtest: addfb25-bad-modifier [220.652580] Subtest addfb25-bad-modifier: SUCCESS (0.006s) [220.999079] [058/162] (840s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [221.578253] Starting subtest: addfb25-framebuffer-vs-set-tiling [221.583838] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [221.929941] [059/162] (839s left) kms_addfb_basic (addfb25-modifier-no-flag) [222.600309] Starting subtest: addfb25-modifier-no-flag [222.605350] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [222.947634] [060/162] (839s left) kms_addfb_basic (addfb25-x-tiled-legacy) [223.536459] Starting subtest: addfb25-x-tiled-legacy [223.541828] Subtest addfb25-x-tiled-legacy: SUCCESS (0.001s) [223.761540] [061/162] (838s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [224.338582] Starting subtest: addfb25-x-tiled-mismatch-legacy [224.344228] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [224.552847] [062/162] (837s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [225.163717] Starting subtest: addfb25-yf-tiled-legacy [225.169289] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s) [225.392187] [063/162] (837s left) kms_addfb_basic (addfb25-y-tiled-legacy) [225.957656] Starting subtest: addfb25-y-tiled-legacy [225.962879] Subtest addfb25-y-tiled-legacy: SUCCESS (0.004s) [226.179711] [064/162] (836s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [226.797850] Starting subtest: addfb25-y-tiled-small-legacy [226.803891] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [227.017661] [065/162] (836s left) kms_addfb_basic (bad-pitch-0) [227.268273] Starting subtest: bad-pitch-0 [227.274149] Subtest bad-pitch-0: SUCCESS (0.000s) [227.843406] [066/162] (835s left) kms_addfb_basic (bad-pitch-1024) [228.073679] Starting subtest: bad-pitch-1024 [228.075844] Subtest bad-pitch-1024: SUCCESS (0.000s) [228.607464] [067/162] (834s left) kms_addfb_basic (bad-pitch-128) [228.855277] Starting subtest: bad-pitch-128 [228.857335] Subtest bad-pitch-128: SUCCESS (0.000s) [229.406730] [068/162] (834s left) kms_addfb_basic (bad-pitch-256) [229.636317] Starting subtest: bad-pitch-256 [229.639284] Subtest bad-pitch-256: SUCCESS (0.000s) [230.194779] [069/162] (833s left) kms_addfb_basic (bad-pitch-32) [230.427097] Starting subtest: bad-pitch-32 [230.430588] Subtest bad-pitch-32: SUCCESS (0.000s) [230.970647] [070/162] (833s left) kms_addfb_basic (bad-pitch-63) [231.208194] Starting subtest: bad-pitch-63 [231.210448] Subtest bad-pitch-63: SUCCESS (0.000s) [231.751463] [071/162] (832s left) kms_addfb_basic (bad-pitch-65536) [231.991237] Starting subtest: bad-pitch-65536 [231.993519] Subtest bad-pitch-65536: SUCCESS (0.002s) [232.595721] [072/162] (832s left) kms_addfb_basic (bad-pitch-999) [232.829828] Starting subtest: bad-pitch-999 [232.835066] Subtest bad-pitch-999: SUCCESS (0.000s) [233.433697] [073/162] (831s left) kms_addfb_basic (basic) [233.663875] Starting subtest: basic [233.668273] Subtest basic: SUCCESS (0.001s) [234.217864] [074/162] (830s left) kms_addfb_basic (basic-x-tiled-legacy) [234.448997] Starting subtest: basic-x-tiled-legacy [234.452435] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [235.136134] [075/162] (830s left) kms_addfb_basic (basic-y-tiled-legacy) [235.377167] Starting subtest: basic-y-tiled-legacy [235.381236] Subtest basic-y-tiled-legacy: SUCCESS (0.002s) [235.949485] [076/162] (829s left) kms_addfb_basic (bo-too-small) [236.533265] Starting subtest: bo-too-small [236.538510] Subtest bo-too-small: SUCCESS (0.003s) [236.765847] [077/162] (828s left) kms_addfb_basic (bo-too-small-due-to-tiling) [237.356531] Starting subtest: bo-too-small-due-to-tiling [237.359392] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s) [237.584316] [078/162] (828s left) kms_addfb_basic (clobberred-modifier) [237.825567] Starting subtest: clobberred-modifier [237.830151] Subtest clobberred-modifier: SUCCESS (0.001s) [238.422871] [079/162] (827s left) kms_addfb_basic (framebuffer-vs-set-tiling) [238.662187] Starting subtest: framebuffer-vs-set-tiling [238.664286] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s) [239.212227] [080/162] (827s left) kms_addfb_basic (invalid-get-prop) [239.439898] Starting subtest: invalid-get-prop [239.442494] Subtest invalid-get-prop: SUCCESS (0.000s) [239.983633] [081/162] (826s left) kms_addfb_basic (invalid-get-prop-any) [240.229788] Starting subtest: invalid-get-prop-any [240.233253] Subtest invalid-get-prop-any: SUCCESS (0.000s) [240.801186] [082/162] (825s left) kms_addfb_basic (invalid-set-prop) [241.033183] Starting subtest: invalid-set-prop [241.037208] Subtest invalid-set-prop: SUCCESS (0.000s) [241.619851] [083/162] (825s left) kms_addfb_basic (invalid-set-prop-any) [241.856393] Starting subtest: invalid-set-prop-any [241.860315] Subtest invalid-set-prop-any: SUCCESS (0.000s) [242.448503] [084/162] (824s left) kms_addfb_basic (no-handle) [242.687157] Starting subtest: no-handle [242.691174] Subtest no-handle: SUCCESS (0.000s) [243.247987] [085/162] (824s left) kms_addfb_basic (size-max) [243.789349] Starting subtest: size-max [243.792259] Subtest size-max: SUCCESS (0.002s) [244.007533] [086/162] (823s left) kms_addfb_basic (small-bo) [244.573175] Starting subtest: small-bo [244.576224] Subtest small-bo: SUCCESS (0.000s) [244.791325] [087/162] (822s left) kms_addfb_basic (tile-pitch-mismatch) [245.023771] Starting subtest: tile-pitch-mismatch [245.027160] Subtest tile-pitch-mismatch: SUCCESS (0.002s) [245.615070] [088/162] (822s left) kms_addfb_basic (too-high) [246.245107] Starting subtest: too-high [246.254593] Subtest too-high: SUCCESS (0.006s) [246.466370] [089/162] (821s left) kms_addfb_basic (too-wide) [247.005845] Starting subtest: too-wide [247.010641] Subtest too-wide: SUCCESS (0.000s) [247.222665] [090/162] (821s left) kms_addfb_basic (unused-handle) [247.461039] Starting subtest: unused-handle [247.466657] Subtest unused-handle: SUCCESS (0.000s) [248.039737] [091/162] (820s left) kms_addfb_basic (unused-modifier) [248.265793] Starting subtest: unused-modifier [248.269976] Subtest unused-modifier: SUCCESS (0.000s) [248.808727] [092/162] (820s left) kms_addfb_basic (unused-offsets) [249.037416] Starting subtest: unused-offsets [249.040277] Subtest unused-offsets: SUCCESS (0.000s) [249.625130] [093/162] (819s left) kms_addfb_basic (unused-pitches) [249.902139] Starting subtest: unused-pitches [249.904616] Subtest unused-pitches: SUCCESS (0.000s) [250.415536] [094/162] (818s left) kms_busy (basic) [251.013247] Subtest basic: SKIP (0.000s) [251.234194] [095/162] (818s left) kms_prop_blob (basic) [251.461526] Starting subtest: basic [251.465169] Subtest basic: SUCCESS (0.000s) [251.673891] [096/162] (818s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [252.351980] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [252.548078] [097/162] (817s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [253.121163] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [253.325502] [098/162] (816s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [253.909570] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [254.116701] [099/162] (816s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [254.664642] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [254.853875] [100/162] (815s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [255.421429] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [255.634745] [101/162] (815s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [256.289600] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [256.491710] [102/162] (814s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [257.097370] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [257.290754] [103/162] (813s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [257.855423] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [258.119093] [104/162] (813s left) kms_dsc (dsc-basic) [258.726317] Subtest dsc-basic: SKIP (0.000s) [258.932325] [105/162] (812s left) kms_flip (basic-flip-vs-dpms) [259.527139] Starting subtest: basic-flip-vs-dpms [259.535235] Subtest basic-flip-vs-dpms: SKIP (0.010s) [259.809650] [106/162] (812s left) kms_flip (basic-flip-vs-modeset) [260.419638] Starting subtest: basic-flip-vs-modeset [260.432922] Subtest basic-flip-vs-modeset: SKIP (0.010s) [260.707717] [107/162] (811s left) kms_flip (basic-flip-vs-wf_vblank) [261.232153] Starting subtest: basic-flip-vs-wf_vblank [261.268951] Subtest basic-flip-vs-wf_vblank: SKIP (0.041s) [261.551494] [108/162] (810s left) kms_flip (basic-plain-flip) [262.154318] Starting subtest: basic-plain-flip [262.166097] Subtest basic-plain-flip: SKIP (0.008s) [262.431530] [109/162] (810s left) kms_force_connector_basic (force-connector-state) [262.773585] Starting subtest: force-connector-state [263.622647] Subtest force-connector-state: SUCCESS (0.830s) [264.743213] [110/162] (807s left) kms_force_connector_basic (force-edid) [265.145524] Starting subtest: force-edid [265.436192] Subtest force-edid: SUCCESS (0.294s) [266.383688] [111/162] (806s left) kms_force_connector_basic (force-load-detect) [267.024288] Starting subtest: force-load-detect [267.037834] Subtest force-load-detect: SKIP (0.000s) [267.792608] [112/162] (805s left) kms_force_connector_basic (prune-stale-modes) [268.159256] Starting subtest: prune-stale-modes [268.484645] Subtest prune-stale-modes: SUCCESS (0.328s) [269.099416] [113/162] (804s left) kms_frontbuffer_tracking (basic) [269.687234] Subtest basic: SKIP (0.000s) [269.899509] [114/162] (803s left) kms_hdmi_inject (inject-audio) [270.129172] Starting subtest: inject-audio [270.604430] Subtest inject-audio: SUCCESS (0.474s) [271.114753] [115/162] (802s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [271.713504] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [271.953388] [116/162] (802s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [272.513728] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [272.751465] [117/162] (801s left) kms_pipe_crc_basic (hang-read-crc) [273.328306] Subtest hang-read-crc: SKIP (0.000s) [273.567648] [118/162] (801s left) kms_pipe_crc_basic (nonblocking-crc) [274.166448] Subtest nonblocking-crc: SKIP (0.000s) [274.385964] [119/162] (800s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [274.972100] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [275.192544] [120/162] (799s left) kms_pipe_crc_basic (read-crc) [275.827310] Subtest read-crc: SKIP (0.000s) [276.052489] [121/162] (799s left) kms_pipe_crc_basic (read-crc-frame-sequence) [276.584829] Subtest read-crc-frame-sequence: SKIP (0.000s) [276.803363] [122/162] (798s left) kms_pm_backlight (basic-brightness) [277.323158] Subtest basic-brightness: SKIP (0.000s) [277.557978] [123/162] (798s left) kms_pm_rpm (basic-pci-d3-state) [279.436618] Starting subtest: basic-pci-d3-state [279.655169] Subtest basic-pci-d3-state: SUCCESS (0.212s) [279.908537] [124/162] (796s left) kms_pm_rpm (basic-rte) [280.127453] Starting subtest: basic-rte [281.942155] Subtest basic-rte: SUCCESS (1.812s) [282.404158] [125/162] (793s left) kms_psr (psr-primary-page-flip) [282.965405] Subtest psr-primary-page-flip: SKIP (0.000s) [283.201453] [126/162] (793s left) kms_psr (psr-cursor-plane-move) [283.790735] Subtest psr-cursor-plane-move: SKIP (0.000s) [284.015309] [127/162] (792s left) kms_psr (psr-sprite-plane-onoff) [284.599379] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [284.827461] [128/162] (792s left) kms_psr (psr-primary-mmap-gtt) [285.411168] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [285.653399] [129/162] (791s left) kms_setmode (basic-clone-single-crtc) [285.894224] Starting subtest: basic-clone-single-crtc [285.907293] Subtest basic-clone-single-crtc: SKIP (0.001s) [286.120319] [130/162] (791s left) i915_pm_rps (basic-api) [286.406471] Starting subtest: basic-api [286.426324] Subtest basic-api: SUCCESS (0.018s) [286.666771] [131/162] (790s left) prime_self_import (basic-llseek-bad) [286.903212] Starting subtest: basic-llseek-bad [286.909719] Subtest basic-llseek-bad: SUCCESS (0.011s) [287.153334] [132/162] (790s left) prime_self_import (basic-llseek-size) [287.377912] Starting subtest: basic-llseek-size [287.395293] Subtest basic-llseek-size: SUCCESS (0.021s) [287.630393] [133/162] (790s left) prime_self_import (basic-with_fd_dup) [287.849404] Starting subtest: basic-with_fd_dup [287.870297] Subtest basic-with_fd_dup: SUCCESS (0.019s) [288.109238] [134/162] (790s left) prime_self_import (basic-with_one_bo) [288.327797] Starting subtest: basic-with_one_bo [288.355334] Subtest basic-with_one_bo: SUCCESS (0.026s) [288.596778] [135/162] (789s left) prime_self_import (basic-with_one_bo_two_files) [288.822531] Starting subtest: basic-with_one_bo_two_files [288.837241] Subtest basic-with_one_bo_two_files: SUCCESS (0.016s) [289.077396] [136/162] (789s left) prime_self_import (basic-with_two_bos) [289.309738] Starting subtest: basic-with_two_bos [289.325472] Subtest basic-with_two_bos: SUCCESS (0.023s) [289.567164] [137/162] (789s left) prime_vgem (basic-fence-flip) [289.855358] Starting subtest: basic-fence-flip [290.159682] Subtest basic-fence-flip: SKIP (0.299s) [290.399375] [138/162] (788s left) prime_vgem (basic-fence-mmap) [290.664183] Starting subtest: basic-fence-mmap [290.811154] Subtest basic-fence-mmap: SUCCESS (0.140s) [291.058171] [139/162] (788s left) prime_vgem (basic-fence-read) [291.383281] Starting subtest: basic-fence-read [291.653512] Subtest basic-fence-read: SUCCESS (0.275s) [291.894323] [140/162] (787s left) prime_vgem (basic-gtt) [292.166177] Starting subtest: basic-gtt [292.233112] Subtest basic-gtt: SUCCESS (0.072s) [292.494476] [141/162] (787s left) prime_vgem (basic-read) [292.767195] Starting subtest: basic-read [292.903563] Subtest basic-read: SUCCESS (0.138s) [293.152877] [142/162] (786s left) prime_vgem (basic-write) [293.428144] Starting subtest: basic-write [293.604124] Subtest basic-write: SUCCESS (0.176s) [293.853752] [143/162] (786s left) vgem_basic (setversion) [294.097230] Starting subtest: setversion [294.102856] Subtest setversion: SUCCESS (0.001s) [294.313564] [144/162] (786s left) vgem_basic (create) [294.552173] Starting subtest: create [294.555560] Subtest create: SUCCESS (0.001s) [294.778480] [145/162] (785s left) vgem_basic (debugfs) [295.009864] Starting subtest: debugfs [295.014197] Subtest debugfs: SUCCESS (0.003s) [295.234449] [146/162] (785s left) vgem_basic (dmabuf-export) [295.476936] Starting subtest: dmabuf-export [295.496962] Subtest dmabuf-export: SUCCESS (0.015s) [295.729742] [147/162] (785s left) vgem_basic (dmabuf-fence) [295.964546] Starting subtest: dmabuf-fence [295.968202] Subtest dmabuf-fence: SUCCESS (0.004s) [296.186266] [148/162] (784s left) vgem_basic (dmabuf-fence-before) [296.428259] Starting subtest: dmabuf-fence-before [296.431412] Subtest dmabuf-fence-before: SUCCESS (0.004s) [296.667980] [149/162] (784s left) vgem_basic (dmabuf-mmap) [296.911115] Starting subtest: dmabuf-mmap [296.953635] Subtest dmabuf-mmap: SUCCESS (0.045s) [297.188621] [150/162] (784s left) vgem_basic (mmap) [297.435296] Starting subtest: mmap [297.458136] Subtest mmap: SUCCESS (0.039s) [297.686811] [151/162] (784s left) vgem_basic (second-client) [297.918946] Starting subtest: second-client [297.932227] Subtest second-client: SUCCESS (0.018s) [298.151592] [152/162] (783s left) vgem_basic (sysfs) [298.400361] Starting subtest: sysfs [298.406133] Subtest sysfs: SUCCESS (0.006s) [298.634915] [153/162] (783s left) core_hotunplug (unbind-rebind) [299.049516] Starting subtest: unbind-rebind [304.661527] Subtest unbind-rebind: SUCCESS (5.610s) [304.892939] [154/162] (777s left) vgem_basic (unload) [305.123210] Starting subtest: unload [334.350767] Subtest unload: SUCCESS (29.237s) [334.703364] [155/162] (747s left) i915_module_load (reload) [334.934777] Starting subtest: reload [342.513254] Subtest reload: SUCCESS (7.582s) [342.939385] [156/162] (740s left) gem_lmem_swapping (basic) [343.235367] Subtest basic: SKIP (0.000s) [343.444589] [157/162] (739s left) gem_lmem_swapping (parallel-random-engines) [343.696966] Subtest parallel-random-engines: SKIP (0.000s) [343.907341] [158/162] (739s left) gem_lmem_swapping (random-engines) [344.183079] Subtest random-engines: SKIP (0.000s) [344.393520] [159/162] (739s left) gem_lmem_swapping (verify-random) [344.649516] Subtest verify-random: SKIP (0.000s) [344.870258] [160/162] (739s left) i915_pm_rpm (module-reload) [346.701072] Starting subtest: module-reload [365.584240] Subtest module-reload: SUCCESS (18.884s) [365.729839] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [365.735910] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [365.743372] [161/162] (718s left) i915_selftest (live) [366.009176] Starting subtest: live [366.012866] Starting dynamic subtest: sanitycheck [372.189111] Dynamic subtest sanitycheck: SUCCESS (6.188s) [372.227993] Starting dynamic subtest: uncore [378.215454] Dynamic subtest uncore: SUCCESS (6.017s) [378.252461] Starting dynamic subtest: workarounds [384.686423] Dynamic subtest workarounds: SUCCESS (6.441s) [384.832872] Starting dynamic subtest: gt_engines [391.085171] Dynamic subtest gt_engines: SUCCESS (6.416s) [391.120642] Starting dynamic subtest: gt_timelines [429.337257] Dynamic subtest gt_timelines: SUCCESS (38.249s) [429.379831] Starting dynamic subtest: gt_contexts [436.208509] Dynamic subtest gt_contexts: SUCCESS (6.859s) [436.245258] Starting dynamic subtest: gt_lrc [445.878853] Dynamic subtest gt_lrc: SUCCESS (9.667s) [445.917997] Starting dynamic subtest: gt_mocs [451.642757] Dynamic subtest gt_mocs: SUCCESS (5.754s) [451.676804] Starting dynamic subtest: gt_pm [458.841154] Dynamic subtest gt_pm: SUCCESS (7.195s) [458.884991] Starting dynamic subtest: gt_heartbeat [465.018413] Dynamic subtest gt_heartbeat: SUCCESS (6.167s) [465.054574] Starting dynamic subtest: gt_tlb [471.795819] Dynamic subtest gt_tlb: SUCCESS (6.768s) [471.830492] Starting dynamic subtest: requests [484.579031] Dynamic subtest requests: SUCCESS (12.780s) [484.617782] Starting dynamic subtest: migrate [494.969298] Dynamic subtest migrate: SUCCESS (10.383s) [495.022387] Starting dynamic subtest: active [501.084721] Dynamic subtest active: SUCCESS (6.099s) [501.125206] Starting dynamic subtest: objects [509.032191] Dynamic subtest objects: SUCCESS (7.941s) [509.070583] Starting dynamic subtest: mman [522.227890] Dynamic subtest mman: SUCCESS (13.189s) [522.266887] Starting dynamic subtest: dmabuf [528.517315] Dynamic subtest dmabuf: SUCCESS (6.278s) [528.560271] Starting dynamic subtest: vma [534.391327] Dynamic subtest vma: SUCCESS (5.857s) [534.449500] Starting dynamic subtest: coherency [546.079361] Dynamic subtest coherency: SUCCESS (11.685s) [546.131471] Starting dynamic subtest: gtt [560.623121] Dynamic subtest gtt: SUCCESS (14.524s) [560.660552] Starting dynamic subtest: gem [568.140722] Dynamic subtest gem: SUCCESS (7.514s) [568.176437] Starting dynamic subtest: evict [582.750252] Dynamic subtest evict: SUCCESS (14.604s) [582.787896] Starting dynamic subtest: hugepages [589.559104] Dynamic subtest hugepages: SUCCESS (6.802s) [589.598314] Starting dynamic subtest: gem_contexts [623.701434] Dynamic subtest gem_contexts: SUCCESS (34.136s) [623.746436] Starting dynamic subtest: client [629.828069] Dynamic subtest client: SUCCESS (6.116s) [629.868258] Starting dynamic subtest: gem_migrate [635.765952] Dynamic subtest gem_migrate: SUCCESS (5.931s) [635.913043] Starting dynamic subtest: reset [650.260920] Dynamic subtest reset: SUCCESS (14.486s) [650.304463] Starting dynamic subtest: memory_region [656.429051] Dynamic subtest memory_region: SUCCESS (6.153s) [656.533233] Starting dynamic subtest: hangcheck [686.418876] Dynamic subtest hangcheck: SUCCESS (29.981s) [686.459474] Starting dynamic subtest: execlists [699.609304] Dynamic subtest execlists: SUCCESS (13.176s) [699.741209] Starting dynamic subtest: ring_submission [705.813247] Dynamic subtest ring_submission: SUCCESS (6.200s) [705.853331] Starting dynamic subtest: perf [712.251300] Dynamic subtest perf: SUCCESS (6.430s) [712.297766] Starting dynamic subtest: slpc [718.172802] Dynamic subtest slpc: SUCCESS (5.911s) [718.208748] Starting dynamic subtest: guc [723.892208] Dynamic subtest guc: SUCCESS (5.717s) [723.946923] Starting dynamic subtest: guc_multi_lrc [730.143938] Dynamic subtest guc_multi_lrc: SUCCESS (6.240s) [730.263060] Starting dynamic subtest: guc_hang [735.906337] Dynamic subtest guc_hang: SUCCESS (5.743s) [735.983582] Starting dynamic subtest: late_gt_pm [742.078369] Dynamic subtest late_gt_pm: SUCCESS (6.167s) [742.085160] Subtest live: SUCCESS (376.074s) [742.248673] [162/162] (342s left) dmabuf (all-tests) [742.493216] Starting subtest: all-tests [742.498332] Starting dynamic subtest: sanitycheck [742.555433] Dynamic subtest sanitycheck: SUCCESS (0.064s) [742.653178] Starting dynamic subtest: dma_fence [742.788148] Dynamic subtest dma_fence: SUCCESS (0.217s) [742.868523] Starting dynamic subtest: dma_fence_chain [742.876840] Dynamic subtest dma_fence_chain: SKIP (0.001s) [742.923229] Starting dynamic subtest: dma_fence_unwrap [742.925120] Dynamic subtest dma_fence_unwrap: SUCCESS (0.063s) [742.960261] Starting dynamic subtest: dma_resv [742.962056] Dynamic subtest dma_resv: SUCCESS (0.075s) [742.963781] Subtest all-tests: SUCCESS (0.458s) [743.102821] Closing watchdogs results: parsing output: 0/ for test: i915_module_load results: parsing output: 1/ for test: core_auth results: parsing output: 2/ for test: core_debugfs results: parsing output: 3/ for test: core_sysfs results: parsing output: 4/ for test: fbdev results: parsing output: 5/ for test: fbdev results: parsing output: 6/ for test: fbdev results: parsing output: 7/ for test: fbdev results: parsing output: 8/ for test: fbdev results: parsing output: 9/ for test: gem_basic results: parsing output: 10/ for test: gem_basic results: parsing output: 11/ for test: gem_basic results: parsing output: 12/ for test: gem_busy results: parsing output: 13/ for test: gem_close_race results: parsing output: 14/ for test: gem_close_race results: parsing output: 15/ for test: gem_ctx_create results: parsing output: 16/ for test: gem_ctx_create results: parsing output: 17/ for test: gem_ctx_exec results: parsing output: 18/ for test: gem_exec_basic results: parsing output: 19/ for test: gem_exec_create results: parsing output: 20/ for test: gem_exec_fence results: parsing output: 21/ for test: gem_exec_fence results: parsing output: 22/ for test: gem_exec_fence results: parsing output: 23/ for test: gem_exec_fence results: parsing output: 24/ for test: gem_exec_gttfill results: parsing output: 25/ for test: gem_exec_parallel results: parsing output: 26/ for test: gem_exec_store results: parsing output: 27/ for test: gem_flink_basic results: parsing output: 28/ for test: gem_flink_basic results: parsing output: 29/ for test: gem_flink_basic results: parsing output: 30/ for test: gem_flink_basic results: parsing output: 31/ for test: gem_flink_basic results: parsing output: 32/ for test: gem_huc_copy results: parsing output: 33/ for test: gem_linear_blits results: parsing output: 34/ for test: gem_mmap results: parsing output: 35/ for test: gem_mmap_gtt results: parsing output: 36/ for test: gem_render_linear_blits results: parsing output: 37/ for test: gem_render_tiled_blits results: parsing output: 38/ for test: gem_ringfill results: parsing output: 39/ for test: gem_softpin results: parsing output: 40/ for test: gem_softpin results: parsing output: 41/ for test: gem_softpin results: parsing output: 42/ for test: gem_sync results: parsing output: 43/ for test: gem_sync results: parsing output: 44/ for test: gem_tiled_blits results: parsing output: 45/ for test: gem_tiled_fence_blits results: parsing output: 46/ for test: gem_tiled_pread_basic results: parsing output: 47/ for test: gem_wait results: parsing output: 48/ for test: gem_wait results: parsing output: 49/ for test: i915_getparams_basic results: parsing output: 50/ for test: i915_getparams_basic results: parsing output: 51/ for test: i915_hangman results: parsing output: 52/ for test: i915_pciid results: parsing output: 53/ for test: intel_hwmon results: parsing output: 54/ for test: intel_hwmon results: parsing output: 55/ for test: kms_addfb_basic results: parsing output: 56/ for test: kms_addfb_basic results: parsing output: 57/ for test: kms_addfb_basic results: parsing output: 58/ for test: kms_addfb_basic results: parsing output: 59/ for test: kms_addfb_basic results: parsing output: 60/ for test: kms_addfb_basic results: parsing output: 61/ for test: kms_addfb_basic results: parsing output: 62/ for test: kms_addfb_basic results: parsing output: 63/ for test: kms_addfb_basic results: parsing output: 64/ for test: kms_addfb_basic results: parsing output: 65/ for test: kms_addfb_basic results: parsing output: 66/ for test: kms_addfb_basic results: parsing output: 67/ for test: kms_addfb_basic results: parsing output: 68/ for test: kms_addfb_basic results: parsing output: 69/ for test: kms_addfb_basic results: parsing output: 70/ for test: kms_addfb_basic results: parsing output: 71/ for test: kms_addfb_basic results: parsing output: 72/ for test: kms_addfb_basic results: parsing output: 73/ for test: kms_addfb_basic results: parsing output: 74/ for test: kms_addfb_basic results: parsing output: 75/ for test: kms_addfb_basic results: parsing output: 76/ for test: kms_addfb_basic results: parsing output: 77/ for test: kms_addfb_basic results: parsing output: 78/ for test: kms_addfb_basic results: parsing output: 79/ for test: kms_addfb_basic results: parsing output: 80/ for test: kms_addfb_basic results: parsing output: 81/ for test: kms_addfb_basic results: parsing output: 82/ for test: kms_addfb_basic results: parsing output: 83/ for test: kms_addfb_basic results: parsing output: 84/ for test: kms_addfb_basic results: parsing output: 85/ for test: kms_addfb_basic results: parsing output: 86/ for test: kms_addfb_basic results: parsing output: 87/ for test: kms_addfb_basic results: parsing output: 88/ for test: kms_addfb_basic results: parsing output: 89/ for test: kms_addfb_basic results: parsing output: 90/ for test: kms_addfb_basic results: parsing output: 91/ for test: kms_addfb_basic results: parsing output: 92/ for test: kms_addfb_basic results: parsing output: 93/ for test: kms_busy results: parsing output: 94/ for test: kms_prop_blob results: parsing output: 95/ for test: kms_cursor_legacy results: parsing output: 96/ for test: kms_cursor_legacy results: parsing output: 97/ for test: kms_cursor_legacy results: parsing output: 98/ for test: kms_cursor_legacy results: parsing output: 99/ for test: kms_cursor_legacy results: parsing output: 100/ for test: kms_cursor_legacy results: parsing output: 101/ for test: kms_cursor_legacy results: parsing output: 102/ for test: kms_cursor_legacy results: parsing output: 103/ for test: kms_dsc results: parsing output: 104/ for test: kms_flip results: parsing output: 105/ for test: kms_flip results: parsing output: 106/ for test: kms_flip results: parsing output: 107/ for test: kms_flip results: parsing output: 108/ for test: kms_force_connector_basic results: parsing output: 109/ for test: kms_force_connector_basic results: parsing output: 110/ for test: kms_force_connector_basic results: parsing output: 111/ for test: kms_force_connector_basic results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_hdmi_inject results: parsing output: 114/ for test: kms_pipe_crc_basic results: parsing output: 115/ for test: kms_pipe_crc_basic results: parsing output: 116/ for test: kms_pipe_crc_basic results: parsing output: 117/ for test: kms_pipe_crc_basic results: parsing output: 118/ for test: kms_pipe_crc_basic results: parsing output: 119/ for test: kms_pipe_crc_basic results: parsing output: 120/ for test: kms_pipe_crc_basic results: parsing output: 121/ for test: kms_pm_backlight results: parsing output: 122/ for test: kms_pm_rpm results: parsing output: 123/ for test: kms_pm_rpm results: parsing output: 124/ for test: kms_psr results: parsing output: 125/ for test: kms_psr results: parsing output: 126/ for test: kms_psr results: parsing output: 127/ for test: kms_psr results: parsing output: 128/ for test: kms_setmode results: parsing output: 129/ for test: i915_pm_rps results: parsing output: 130/ for test: prime_self_import results: parsing output: 131/ for test: prime_self_import results: parsing output: 132/ for test: prime_self_import results: parsing output: 133/ for test: prime_self_import results: parsing output: 134/ for test: prime_self_import results: parsing output: 135/ for test: prime_self_import results: parsing output: 136/ for test: prime_vgem results: parsing output: 137/ for test: prime_vgem results: parsing output: 138/ for test: prime_vgem results: parsing output: 139/ for test: prime_vgem results: parsing output: 140/ for test: prime_vgem results: parsing output: 141/ for test: prime_vgem results: parsing output: 142/ for test: vgem_basic results: parsing output: 143/ for test: vgem_basic results: parsing output: 144/ for test: vgem_basic results: parsing output: 145/ for test: vgem_basic results: parsing output: 146/ for test: vgem_basic results: parsing output: 147/ for test: vgem_basic results: parsing output: 148/ for test: vgem_basic results: parsing output: 149/ for test: vgem_basic results: parsing output: 150/ for test: vgem_basic results: parsing output: 151/ for test: vgem_basic results: parsing output: 152/ for test: core_hotunplug results: parsing output: 153/ for test: vgem_basic results: parsing output: 154/ for test: i915_module_load results: parsing output: 155/ for test: gem_lmem_swapping results: parsing output: 156/ for test: gem_lmem_swapping results: parsing output: 157/ for test: gem_lmem_swapping results: parsing output: 158/ for test: gem_lmem_swapping results: parsing output: 159/ for test: i915_pm_rpm results: parsing output: 160/ for test: i915_selftest results: parsing output: 161/ for test: dmabuf Done.