[127.165471] Initializing watchdogs [127.165848] /dev/watchdog0 [127.255574] [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 [127.282628] [001/162] (960s left) i915_module_load (load) [127.596236] Starting subtest: load [134.219874] Subtest load: SUCCESS (6.618s) [134.547189] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [134.557546] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [134.578591] [002/162] (953s left) core_auth (basic-auth) [134.954911] Starting subtest: basic-auth [134.959281] Subtest basic-auth: SUCCESS (0.010s) [135.172239] [003/162] (953s left) core_debugfs (read-all-entries) [135.424219] Starting subtest: read-all-entries [135.435099] Subtest read-all-entries: SUCCESS (0.016s) [135.623467] [004/162] (952s left) core_sysfs (read-all-entries) [135.877219] Starting subtest: read-all-entries [135.895676] Subtest read-all-entries: SUCCESS (0.020s) [136.081995] [005/162] (952s left) fbdev (eof) [136.353576] Subtest eof: SKIP (0.000s) [136.534157] [006/162] (952s left) fbdev (info) [136.822274] Subtest info: SKIP (0.000s) [137.000607] [007/162] (952s left) fbdev (nullptr) [137.290786] Subtest nullptr: SKIP (0.000s) [137.474297] [008/162] (951s left) fbdev (read) [137.754613] Subtest read: SKIP (0.000s) [137.933512] [009/162] (951s left) fbdev (write) [138.218205] Subtest write: SKIP (0.000s) [138.398548] [010/162] (951s left) gem_basic (bad-close) [138.669798] Starting subtest: bad-close [138.678458] Subtest bad-close: SUCCESS (0.000s) [138.876735] [011/162] (950s left) gem_basic (create-close) [139.117246] Starting subtest: create-close [139.125312] Subtest create-close: SUCCESS (0.004s) [139.329321] [012/162] (950s left) gem_basic (create-fd-close) [139.555703] Starting subtest: create-fd-close [139.562154] Subtest create-fd-close: SUCCESS (0.001s) [139.749542] [013/162] (950s left) gem_busy (busy@all-engines) [140.088553] Starting subtest: busy [140.090788] Starting dynamic subtest: all-engines [140.299922] Dynamic subtest all-engines: SUCCESS (0.205s) [140.304479] Subtest busy: SUCCESS (0.212s) [140.839966] [014/162] (949s left) gem_close_race (basic-process) [141.180697] Starting subtest: basic-process [141.331352] Subtest basic-process: SUCCESS (0.153s) [141.663998] [015/162] (948s left) gem_close_race (basic-threads) [141.989208] Starting subtest: basic-threads [143.266964] Subtest basic-threads: SUCCESS (1.278s) [143.588423] [016/162] (947s left) gem_ctx_create (basic) [143.977632] Starting subtest: basic [143.980216] Subtest basic: SUCCESS (0.001s) [144.301384] [017/162] (946s left) gem_ctx_create (basic-files) [144.601204] Starting subtest: basic-files [146.663208] Subtest basic-files: SUCCESS (2.064s) [146.989758] [018/162] (944s left) gem_ctx_exec (basic) [147.243645] Starting subtest: basic [147.261464] Subtest basic: SUCCESS (0.019s) [147.471955] [019/162] (943s left) gem_exec_basic (basic) [147.736729] Starting subtest: basic [147.742339] Starting dynamic subtest: rcs0-smem [147.745673] Dynamic subtest rcs0-smem: SUCCESS (0.008s) [147.788683] Starting dynamic subtest: bcs0-smem [147.791559] Dynamic subtest bcs0-smem: SUCCESS (0.004s) [147.822647] Starting dynamic subtest: vcs0-smem [147.824523] Dynamic subtest vcs0-smem: SUCCESS (0.003s) [147.855434] Starting dynamic subtest: vecs0-smem [147.857232] Dynamic subtest vecs0-smem: SUCCESS (0.004s) [147.858955] Subtest basic: SUCCESS (0.027s) [148.111875] [020/162] (943s left) gem_exec_create (basic) [148.406674] Starting subtest: basic [148.412153] Starting dynamic subtest: smem [150.496751] Dynamic subtest smem: SUCCESS (2.092s) [150.498558] Subtest basic: SUCCESS (2.094s) [150.821447] [021/162] (940s left) gem_exec_fence (basic-busy) [151.293489] Starting subtest: basic-busy [151.297708] Starting dynamic subtest: rcs0 [151.336655] Dynamic subtest rcs0: SUCCESS (0.039s) [151.381577] Starting dynamic subtest: bcs0 [151.389185] Dynamic subtest bcs0: SUCCESS (0.049s) [151.461744] Starting dynamic subtest: vcs0 [151.466588] Dynamic subtest vcs0: SUCCESS (0.027s) [151.498166] Starting dynamic subtest: vecs0 [151.501326] Dynamic subtest vecs0: SUCCESS (0.026s) [151.503086] Subtest basic-busy: SUCCESS (0.161s) [152.460996] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [152.473635] [022/162] (939s left) gem_exec_fence (basic-wait) [152.948986] Starting subtest: basic-wait [152.952183] Starting dynamic subtest: rcs0 [152.983824] Dynamic subtest rcs0: SUCCESS (0.032s) [153.078188] Starting dynamic subtest: bcs0 [153.080736] Dynamic subtest bcs0: SUCCESS (0.035s) [153.113659] Starting dynamic subtest: vcs0 [153.115442] Dynamic subtest vcs0: SUCCESS (0.024s) [153.147383] Starting dynamic subtest: vecs0 [153.149138] Dynamic subtest vecs0: SUCCESS (0.032s) [153.150802] Subtest basic-wait: SUCCESS (0.129s) [153.914517] [023/162] (938s left) gem_exec_fence (basic-await) [154.446239] Starting subtest: basic-await [154.453686] Starting dynamic subtest: rcs0 [154.667274] Dynamic subtest rcs0: SUCCESS (0.225s) [154.716332] Starting dynamic subtest: bcs0 [154.879833] Dynamic subtest bcs0: SUCCESS (0.209s) [154.930845] Starting dynamic subtest: vcs0 [155.106114] Dynamic subtest vcs0: SUCCESS (0.219s) [155.143491] Starting dynamic subtest: vecs0 [155.312645] Dynamic subtest vecs0: SUCCESS (0.194s) [155.315878] Subtest basic-await: SUCCESS (0.869s) [156.136935] [024/162] (936s left) gem_exec_fence (nb-await) [156.593700] Starting subtest: nb-await [156.598124] Starting dynamic subtest: rcs0 [156.696577] Dynamic subtest rcs0: SUCCESS (0.098s) [156.737247] Starting dynamic subtest: bcs0 [156.782635] Dynamic subtest bcs0: SUCCESS (0.084s) [156.823233] Starting dynamic subtest: vcs0 [156.882580] Dynamic subtest vcs0: SUCCESS (0.099s) [156.922270] Starting dynamic subtest: vecs0 [156.970318] Dynamic subtest vecs0: SUCCESS (0.085s) [156.972548] Subtest nb-await: SUCCESS (0.377s) [157.787223] [025/162] (934s left) gem_exec_gttfill (basic) [158.081976] Starting subtest: basic [193.094257] Subtest basic: SUCCESS (35.015s) [193.478144] [026/162] (899s left) gem_exec_parallel (engines) [194.101410] Starting subtest: engines [194.108431] Starting dynamic subtest: basic [201.115172] Dynamic subtest basic: SUCCESS (7.036s) [201.168404] Starting dynamic subtest: contexts [212.148334] Dynamic subtest contexts: SUCCESS (11.028s) [212.198909] Starting dynamic subtest: fds [226.127849] Dynamic subtest fds: SUCCESS (13.975s) [226.196484] Starting dynamic subtest: userptr [233.123972] Dynamic subtest userptr: SUCCESS (6.995s) [233.126520] Subtest engines: SUCCESS (39.051s) [233.537124] [027/162] (859s left) gem_exec_store (basic) [233.834583] Starting subtest: basic [233.923286] Subtest basic: SUCCESS (0.090s) [234.280954] [028/162] (858s left) gem_flink_basic (bad-flink) [234.511670] Starting subtest: bad-flink [234.515810] Subtest bad-flink: SUCCESS (0.000s) [234.721984] [029/162] (858s left) gem_flink_basic (bad-open) [234.960891] Starting subtest: bad-open [234.966688] Subtest bad-open: SUCCESS (0.000s) [235.189899] [030/162] (858s left) gem_flink_basic (basic) [235.411864] Starting subtest: basic [235.415384] Subtest basic: SUCCESS (0.000s) [235.649322] [031/162] (858s left) gem_flink_basic (double-flink) [235.889200] Starting subtest: double-flink [235.894729] Subtest double-flink: SUCCESS (0.000s) [236.162421] [032/162] (858s left) gem_flink_basic (flink-lifetime) [236.395787] Starting subtest: flink-lifetime [236.408295] Subtest flink-lifetime: SUCCESS (0.009s) [236.627451] [033/162] (857s left) gem_huc_copy (huc-copy) [236.891289] Subtest huc-copy: SKIP (0.000s) [237.109992] [034/162] (857s left) gem_linear_blits (basic) [237.809943] Starting subtest: basic [237.859905] Subtest basic: SUCCESS (0.055s) [238.145744] [035/162] (856s left) gem_mmap (basic) [238.571531] Starting subtest: basic [238.586371] Subtest basic: SUCCESS (0.002s) [238.847542] [036/162] (856s left) gem_mmap_gtt (basic) [239.095129] Starting subtest: basic [239.106185] Subtest basic: SUCCESS (0.004s) [239.320596] [037/162] (856s left) gem_render_linear_blits (basic) [239.577340] Starting subtest: basic [239.717089] Subtest basic: SUCCESS (0.134s) [239.943232] [038/162] (855s left) gem_render_tiled_blits (basic) [240.186421] Starting subtest: basic [240.384758] Subtest basic: SUCCESS (0.188s) [240.623421] [039/162] (855s left) gem_ringfill (basic-all) [241.224959] Starting subtest: basic-all [242.608829] Subtest basic-all: SUCCESS (1.383s) [242.845288] [040/162] (853s left) gem_softpin (allocator-basic) [243.118213] Starting subtest: allocator-basic [243.555867] Subtest allocator-basic: SUCCESS (0.418s) [243.839834] [041/162] (852s left) gem_softpin (allocator-basic-reserve) [244.110265] Starting subtest: allocator-basic-reserve [244.542677] Subtest allocator-basic-reserve: SUCCESS (0.433s) [244.853453] [042/162] (851s left) gem_softpin (safe-alignment) [245.129251] Starting subtest: safe-alignment [245.195469] Subtest safe-alignment: SUCCESS (0.064s) [245.427537] [043/162] (851s left) gem_sync (basic-all) [245.713239] Starting subtest: basic-all [249.556499] Subtest basic-all: SUCCESS (3.846s) [249.912976] [044/162] (847s left) gem_sync (basic-each) [250.221442] Starting subtest: basic-each [253.000705] Subtest basic-each: SUCCESS (2.781s) [253.368941] [045/162] (843s left) gem_tiled_blits (basic) [253.955831] Starting subtest: basic [254.069602] Subtest basic: SUCCESS (0.122s) [254.345844] [046/162] (843s left) gem_tiled_fence_blits (basic) [255.070651] Starting subtest: basic [255.143752] Subtest basic: SUCCESS (0.070s) [255.415275] [047/162] (842s left) gem_tiled_pread_basic (basic) [255.837596] Starting subtest: basic [256.854461] Subtest basic: SUCCESS (1.025s) [257.080917] [048/162] (840s left) gem_wait (busy@all-engines) [257.398226] Starting subtest: busy [257.404224] Starting dynamic subtest: all-engines [257.933233] Dynamic subtest all-engines: SUCCESS (0.536s) [257.939184] Subtest busy: SUCCESS (0.539s) [258.369893] [049/162] (839s left) gem_wait (wait@all-engines) [258.680272] Starting subtest: wait [258.684157] Starting dynamic subtest: all-engines [259.737238] Dynamic subtest all-engines: SUCCESS (1.060s) [259.742203] Subtest wait: SUCCESS (1.066s) [260.174961] [050/162] (838s left) i915_getparams_basic (basic-eu-total) [260.425635] Starting subtest: basic-eu-total [260.432660] Subtest basic-eu-total: SUCCESS (0.000s) [260.642476] [051/162] (837s left) i915_getparams_basic (basic-subslice-total) [260.891511] Starting subtest: basic-subslice-total [260.899392] Subtest basic-subslice-total: SUCCESS (0.000s) [261.103928] [052/162] (837s left) i915_hangman (error-state-basic) [261.387143] Starting subtest: error-state-basic [261.426826] Subtest error-state-basic: SUCCESS (0.037s) [261.726603] [053/162] (837s left) i915_pciid [262.181951] [054/162] (837s left) intel_hwmon (hwmon-read) [262.417529] Subtest hwmon-read: SKIP (0.000s) [262.637975] [055/162] (836s left) intel_hwmon (hwmon-write) [262.866811] Subtest hwmon-write: SKIP (0.000s) [263.090466] [056/162] (836s left) kms_addfb_basic (addfb25-4-tiled) [263.764222] Starting subtest: addfb25-4-tiled [263.766548] Subtest addfb25-4-tiled: SUCCESS (0.003s) [264.003179] [057/162] (835s left) kms_addfb_basic (addfb25-bad-modifier) [264.535612] Starting subtest: addfb25-bad-modifier [264.539754] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [264.756683] [058/162] (835s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [265.409764] Starting subtest: addfb25-framebuffer-vs-set-tiling [265.412151] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.001s) [265.648275] [059/162] (834s left) kms_addfb_basic (addfb25-modifier-no-flag) [266.181265] Starting subtest: addfb25-modifier-no-flag [266.184908] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [266.422118] [060/162] (834s left) kms_addfb_basic (addfb25-x-tiled-legacy) [267.126274] Starting subtest: addfb25-x-tiled-legacy [267.133333] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [267.362486] [061/162] (833s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [267.947513] Starting subtest: addfb25-x-tiled-mismatch-legacy [267.951188] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.003s) [268.189767] [062/162] (832s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [268.835747] Starting subtest: addfb25-yf-tiled-legacy [268.842108] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.005s) [269.227562] [063/162] (832s left) kms_addfb_basic (addfb25-y-tiled-legacy) [269.828603] Starting subtest: addfb25-y-tiled-legacy [269.834299] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s) [270.062313] [064/162] (831s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [270.633844] Starting subtest: addfb25-y-tiled-small-legacy [270.643735] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [270.874211] [065/162] (830s left) kms_addfb_basic (bad-pitch-0) [271.115206] Starting subtest: bad-pitch-0 [271.118520] Subtest bad-pitch-0: SUCCESS (0.000s) [271.711649] [066/162] (830s left) kms_addfb_basic (bad-pitch-1024) [271.949816] Starting subtest: bad-pitch-1024 [271.951965] Subtest bad-pitch-1024: SUCCESS (0.000s) [272.501886] [067/162] (829s left) kms_addfb_basic (bad-pitch-128) [272.738315] Starting subtest: bad-pitch-128 [272.741504] Subtest bad-pitch-128: SUCCESS (0.000s) [273.243894] [068/162] (829s left) kms_addfb_basic (bad-pitch-256) [273.495321] Starting subtest: bad-pitch-256 [273.499150] Subtest bad-pitch-256: SUCCESS (0.000s) [274.094452] [069/162] (828s left) kms_addfb_basic (bad-pitch-32) [274.338941] Starting subtest: bad-pitch-32 [274.341199] Subtest bad-pitch-32: SUCCESS (0.000s) [274.954268] [070/162] (827s left) kms_addfb_basic (bad-pitch-63) [275.183553] Starting subtest: bad-pitch-63 [275.188598] Subtest bad-pitch-63: SUCCESS (0.000s) [275.776426] [071/162] (827s left) kms_addfb_basic (bad-pitch-65536) [276.011677] Starting subtest: bad-pitch-65536 [276.015166] Subtest bad-pitch-65536: SUCCESS (0.001s) [276.599486] [072/162] (826s left) kms_addfb_basic (bad-pitch-999) [276.841470] Starting subtest: bad-pitch-999 [276.845781] Subtest bad-pitch-999: SUCCESS (0.000s) [277.430487] [073/162] (826s left) kms_addfb_basic (basic) [277.669354] Starting subtest: basic [277.673263] Subtest basic: SUCCESS (0.001s) [278.245088] [074/162] (825s left) kms_addfb_basic (basic-x-tiled-legacy) [278.487258] Starting subtest: basic-x-tiled-legacy [278.491193] Subtest basic-x-tiled-legacy: SUCCESS (0.001s) [279.029233] [075/162] (825s left) kms_addfb_basic (basic-y-tiled-legacy) [279.263252] Starting subtest: basic-y-tiled-legacy [279.265374] Subtest basic-y-tiled-legacy: SUCCESS (0.002s) [279.881950] [076/162] (824s left) kms_addfb_basic (bo-too-small) [280.512943] Starting subtest: bo-too-small [280.518391] Subtest bo-too-small: SUCCESS (0.003s) [280.747507] [077/162] (823s left) kms_addfb_basic (bo-too-small-due-to-tiling) [281.391634] Starting subtest: bo-too-small-due-to-tiling [281.395353] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s) [281.623520] [078/162] (823s left) kms_addfb_basic (clobberred-modifier) [281.857269] Starting subtest: clobberred-modifier [281.862764] Subtest clobberred-modifier: SUCCESS (0.000s) [282.419285] [079/162] (822s left) kms_addfb_basic (framebuffer-vs-set-tiling) [282.665893] Starting subtest: framebuffer-vs-set-tiling [282.669617] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [283.239945] [080/162] (821s left) kms_addfb_basic (invalid-get-prop) [283.487673] Starting subtest: invalid-get-prop [283.491240] Subtest invalid-get-prop: SUCCESS (0.000s) [284.189785] [081/162] (821s left) kms_addfb_basic (invalid-get-prop-any) [284.419954] Starting subtest: invalid-get-prop-any [284.423702] Subtest invalid-get-prop-any: SUCCESS (0.000s) [284.995243] [082/162] (820s left) kms_addfb_basic (invalid-set-prop) [285.231992] Starting subtest: invalid-set-prop [285.236242] Subtest invalid-set-prop: SUCCESS (0.000s) [285.780445] [083/162] (820s left) kms_addfb_basic (invalid-set-prop-any) [286.020663] Starting subtest: invalid-set-prop-any [286.025319] Subtest invalid-set-prop-any: SUCCESS (0.000s) [286.610415] [084/162] (819s left) kms_addfb_basic (no-handle) [286.842356] Starting subtest: no-handle [286.846174] Subtest no-handle: SUCCESS (0.000s) [287.414542] [085/162] (818s left) kms_addfb_basic (size-max) [288.004712] Starting subtest: size-max [288.009256] Subtest size-max: SUCCESS (0.002s) [288.248575] [086/162] (818s left) kms_addfb_basic (small-bo) [288.836384] Starting subtest: small-bo [288.840153] Subtest small-bo: SUCCESS (0.000s) [289.064956] [087/162] (817s left) kms_addfb_basic (tile-pitch-mismatch) [289.313228] Starting subtest: tile-pitch-mismatch [289.316314] Subtest tile-pitch-mismatch: SUCCESS (0.002s) [289.860520] [088/162] (817s left) kms_addfb_basic (too-high) [290.473285] Starting subtest: too-high [290.475856] Subtest too-high: SUCCESS (0.006s) [290.714277] [089/162] (816s left) kms_addfb_basic (too-wide) [291.264146] Starting subtest: too-wide [291.265920] Subtest too-wide: SUCCESS (0.000s) [291.498930] [090/162] (815s left) kms_addfb_basic (unused-handle) [291.742537] Starting subtest: unused-handle [291.745762] Subtest unused-handle: SUCCESS (0.000s) [292.321492] [091/162] (815s left) kms_addfb_basic (unused-modifier) [292.561253] Starting subtest: unused-modifier [292.564314] Subtest unused-modifier: SUCCESS (0.000s) [293.091095] [092/162] (814s left) kms_addfb_basic (unused-offsets) [293.323569] Starting subtest: unused-offsets [293.327333] Subtest unused-offsets: SUCCESS (0.000s) [293.904242] [093/162] (814s left) kms_addfb_basic (unused-pitches) [294.146920] Starting subtest: unused-pitches [294.151219] Subtest unused-pitches: SUCCESS (0.000s) [294.685417] [094/162] (813s left) kms_busy (basic) [295.298859] Subtest basic: SKIP (0.000s) [295.517754] [095/162] (813s left) kms_prop_blob (basic) [295.744611] Starting subtest: basic [295.748702] Subtest basic: SUCCESS (0.000s) [295.965778] [096/162] (812s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [296.531235] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [296.740379] [097/162] (812s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [297.301184] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [297.574375] [098/162] (811s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [298.180284] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [298.381888] [099/162] (811s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [299.083850] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [299.359798] [100/162] (810s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [299.941639] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [300.148350] [101/162] (809s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [300.816889] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [301.019061] [102/162] (809s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [301.656619] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [301.881272] [103/162] (808s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [302.489449] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [302.712669] [104/162] (807s left) kms_dsc (dsc-basic) [303.270201] Subtest dsc-basic: SKIP (0.000s) [303.493378] [105/162] (807s left) kms_flip (basic-flip-vs-dpms) [304.028166] Starting subtest: basic-flip-vs-dpms [304.045180] Subtest basic-flip-vs-dpms: SKIP (0.007s) [304.326768] [106/162] (806s left) kms_flip (basic-flip-vs-modeset) [304.909684] Starting subtest: basic-flip-vs-modeset [304.926200] Subtest basic-flip-vs-modeset: SKIP (0.008s) [305.210275] [107/162] (806s left) kms_flip (basic-flip-vs-wf_vblank) [305.798108] Starting subtest: basic-flip-vs-wf_vblank [305.806573] Subtest basic-flip-vs-wf_vblank: SKIP (0.008s) [306.095352] [108/162] (805s left) kms_flip (basic-plain-flip) [306.703224] Starting subtest: basic-plain-flip [306.717538] Subtest basic-plain-flip: SKIP (0.012s) [306.995231] [109/162] (804s left) kms_force_connector_basic (force-connector-state) [307.385741] Starting subtest: force-connector-state [308.339164] Subtest force-connector-state: SUCCESS (0.941s) [310.001496] [110/162] (802s left) kms_force_connector_basic (force-edid) [310.415221] Starting subtest: force-edid [310.659676] Subtest force-edid: SUCCESS (0.230s) [311.384446] [111/162] (801s left) kms_force_connector_basic (force-load-detect) [311.795737] Starting subtest: force-load-detect [311.806244] Subtest force-load-detect: SKIP (0.000s) [312.371842] [112/162] (800s left) kms_force_connector_basic (prune-stale-modes) [312.763478] Starting subtest: prune-stale-modes [313.163945] Subtest prune-stale-modes: SUCCESS (0.399s) [314.059105] [113/162] (798s left) kms_frontbuffer_tracking (basic) [314.655207] Subtest basic: SKIP (0.000s) [314.893242] [114/162] (798s left) kms_hdmi_inject (inject-audio) [315.138278] Starting subtest: inject-audio [315.753138] Subtest inject-audio: SUCCESS (0.615s) [316.239993] [115/162] (797s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [316.783789] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [317.031603] [116/162] (796s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [317.625943] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [317.879914] [117/162] (796s left) kms_pipe_crc_basic (hang-read-crc) [318.488683] Subtest hang-read-crc: SKIP (0.000s) [318.730729] [118/162] (795s left) kms_pipe_crc_basic (nonblocking-crc) [319.316330] Subtest nonblocking-crc: SKIP (0.000s) [319.548796] [119/162] (794s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [320.167169] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [320.416488] [120/162] (794s left) kms_pipe_crc_basic (read-crc) [320.996584] Subtest read-crc: SKIP (0.000s) [321.233127] [121/162] (793s left) kms_pipe_crc_basic (read-crc-frame-sequence) [321.808149] Subtest read-crc-frame-sequence: SKIP (0.000s) [322.043691] [122/162] (793s left) kms_pm_backlight (basic-brightness) [322.604660] Subtest basic-brightness: SKIP (0.000s) [322.860761] [123/162] (792s left) kms_pm_rpm (basic-pci-d3-state) [324.830948] Starting subtest: basic-pci-d3-state [325.076304] Subtest basic-pci-d3-state: SUCCESS (0.243s) [325.307831] [124/162] (790s left) kms_pm_rpm (basic-rte) [325.538618] Starting subtest: basic-rte [327.393877] Subtest basic-rte: SUCCESS (1.856s) [327.886249] [125/162] (787s left) kms_psr (psr-primary-page-flip) [328.511573] Subtest psr-primary-page-flip: SKIP (0.000s) [328.782613] [126/162] (787s left) kms_psr (psr-cursor-plane-move) [329.404406] Subtest psr-cursor-plane-move: SKIP (0.000s) [329.649893] [127/162] (786s left) kms_psr (psr-sprite-plane-onoff) [330.266916] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [330.531783] [128/162] (785s left) kms_psr (psr-primary-mmap-gtt) [331.107200] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [331.349334] [129/162] (785s left) kms_setmode (basic-clone-single-crtc) [331.602423] Starting subtest: basic-clone-single-crtc [331.611405] Subtest basic-clone-single-crtc: SKIP (0.001s) [331.851858] [130/162] (785s left) i915_pm_rps (basic-api) [332.159323] Starting subtest: basic-api [332.187593] Subtest basic-api: SUCCESS (0.027s) [332.433515] [131/162] (784s left) prime_self_import (basic-llseek-bad) [332.666069] Starting subtest: basic-llseek-bad [332.678988] Subtest basic-llseek-bad: SUCCESS (0.012s) [332.930769] [132/162] (784s left) prime_self_import (basic-llseek-size) [333.162357] Starting subtest: basic-llseek-size [333.175149] Subtest basic-llseek-size: SUCCESS (0.018s) [333.440151] [133/162] (784s left) prime_self_import (basic-with_fd_dup) [333.678147] Starting subtest: basic-with_fd_dup [333.700148] Subtest basic-with_fd_dup: SUCCESS (0.025s) [333.940262] [134/162] (783s left) prime_self_import (basic-with_one_bo) [334.166983] Starting subtest: basic-with_one_bo [334.181701] Subtest basic-with_one_bo: SUCCESS (0.016s) [334.439806] [135/162] (783s left) prime_self_import (basic-with_one_bo_two_files) [334.668710] Starting subtest: basic-with_one_bo_two_files [334.696336] Subtest basic-with_one_bo_two_files: SUCCESS (0.024s) [334.940892] [136/162] (783s left) prime_self_import (basic-with_two_bos) [335.171229] Starting subtest: basic-with_two_bos [335.186626] Subtest basic-with_two_bos: SUCCESS (0.016s) [335.437446] [137/162] (783s left) prime_vgem (basic-fence-flip) [335.726665] Starting subtest: basic-fence-flip [336.064219] Subtest basic-fence-flip: SKIP (0.336s) [336.356887] [138/162] (782s left) prime_vgem (basic-fence-mmap) [336.673687] Starting subtest: basic-fence-mmap [336.852712] Subtest basic-fence-mmap: SUCCESS (0.183s) [337.113754] [139/162] (781s left) prime_vgem (basic-fence-read) [337.386114] Starting subtest: basic-fence-read [337.669392] Subtest basic-fence-read: SUCCESS (0.287s) [337.934758] [140/162] (781s left) prime_vgem (basic-gtt) [338.216938] Starting subtest: basic-gtt [338.290344] Subtest basic-gtt: SUCCESS (0.066s) [338.550607] [141/162] (780s left) prime_vgem (basic-read) [338.813860] Starting subtest: basic-read [338.962991] Subtest basic-read: SUCCESS (0.142s) [339.211803] [142/162] (780s left) prime_vgem (basic-write) [339.487935] Starting subtest: basic-write [339.675472] Subtest basic-write: SUCCESS (0.187s) [339.943617] [143/162] (779s left) vgem_basic (setversion) [340.186166] Starting subtest: setversion [340.194238] Subtest setversion: SUCCESS (0.000s) [340.419771] [144/162] (779s left) vgem_basic (create) [340.664623] Starting subtest: create [340.802955] Subtest create: FAIL (0.102s) [341.011459] [145/162] (779s left) vgem_basic (debugfs) [341.256668] Starting subtest: debugfs [341.262378] Subtest debugfs: SUCCESS (0.003s) [341.497214] [146/162] (779s left) vgem_basic (dmabuf-export) [341.750180] Starting subtest: dmabuf-export [341.754946] Subtest dmabuf-export: SUCCESS (0.013s) [342.006980] [147/162] (778s left) vgem_basic (dmabuf-fence) [342.261921] Starting subtest: dmabuf-fence [342.277132] Subtest dmabuf-fence: SUCCESS (0.006s) [342.564239] [148/162] (778s left) vgem_basic (dmabuf-fence-before) [342.811133] Starting subtest: dmabuf-fence-before [342.814780] Subtest dmabuf-fence-before: SUCCESS (0.002s) [343.050162] [149/162] (778s left) vgem_basic (dmabuf-mmap) [343.296631] Starting subtest: dmabuf-mmap [343.370706] Subtest dmabuf-mmap: SUCCESS (0.071s) [343.608161] [150/162] (777s left) vgem_basic (mmap) [343.880403] Starting subtest: mmap [343.908716] Subtest mmap: SUCCESS (0.045s) [344.143176] [151/162] (777s left) vgem_basic (second-client) [344.387347] Starting subtest: second-client [344.421660] Subtest second-client: SUCCESS (0.031s) [344.673967] [152/162] (777s left) vgem_basic (sysfs) [344.911547] Starting subtest: sysfs [344.917748] Subtest sysfs: SUCCESS (0.004s) [345.156391] [153/162] (777s left) core_hotunplug (unbind-rebind) [345.583296] Starting subtest: unbind-rebind [352.234348] Subtest unbind-rebind: SUCCESS (6.643s) [352.464316] [154/162] (770s left) vgem_basic (unload) [352.706720] Starting subtest: unload [382.035544] Subtest unload: SUCCESS (29.324s) [382.402845] [155/162] (740s left) i915_module_load (reload) [382.631945] Starting subtest: reload [391.925527] Subtest reload: SUCCESS (9.287s) [392.531628] [156/162] (730s left) gem_lmem_swapping (basic) [392.909232] Subtest basic: SKIP (0.000s) [393.132734] [157/162] (730s left) gem_lmem_swapping (parallel-random-engines) [393.423256] Subtest parallel-random-engines: SKIP (0.000s) [393.641234] [158/162] (730s left) gem_lmem_swapping (random-engines) [393.927324] Subtest random-engines: SKIP (0.000s) [394.167428] [159/162] (729s left) gem_lmem_swapping (verify-random) [394.440378] Subtest verify-random: SKIP (0.000s) [394.660910] [160/162] (729s left) i915_pm_rpm (module-reload) [396.623652] Starting subtest: module-reload [419.680775] Subtest module-reload: SUCCESS (23.057s) [419.882564] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [419.888564] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [419.896780] [161/162] (704s left) i915_selftest (live) [420.165113] Starting subtest: live [420.167317] Starting dynamic subtest: sanitycheck [427.427644] Dynamic subtest sanitycheck: SUCCESS (7.267s) [427.466821] Starting dynamic subtest: uncore [434.566223] Dynamic subtest uncore: SUCCESS (7.137s) [434.628746] Starting dynamic subtest: workarounds [442.195544] Dynamic subtest workarounds: SUCCESS (7.618s) [442.235186] Starting dynamic subtest: gt_engines [450.142239] Dynamic subtest gt_engines: SUCCESS (7.944s) [450.197399] Starting dynamic subtest: gt_timelines [490.492528] Dynamic subtest gt_timelines: SUCCESS (40.340s) [490.542213] Starting dynamic subtest: gt_contexts [498.808386] Dynamic subtest gt_contexts: SUCCESS (8.312s) [498.847939] Starting dynamic subtest: gt_lrc [510.066447] Dynamic subtest gt_lrc: SUCCESS (11.255s) [510.149697] Starting dynamic subtest: gt_mocs [517.050214] Dynamic subtest gt_mocs: SUCCESS (6.975s) [517.096586] Starting dynamic subtest: gt_pm [526.067578] Dynamic subtest gt_pm: SUCCESS (9.010s) [526.185285] Starting dynamic subtest: gt_heartbeat [534.038044] Dynamic subtest gt_heartbeat: SUCCESS (7.957s) [534.085228] Starting dynamic subtest: gt_tlb [542.117120] Dynamic subtest gt_tlb: SUCCESS (8.071s) [542.161387] Starting dynamic subtest: requests [555.993714] Dynamic subtest requests: SUCCESS (13.873s) [556.039465] Starting dynamic subtest: migrate [568.001501] Dynamic subtest migrate: SUCCESS (11.999s) [568.043978] Starting dynamic subtest: active [575.502854] Dynamic subtest active: SUCCESS (7.494s) [575.542539] Starting dynamic subtest: objects [584.407174] Dynamic subtest objects: SUCCESS (8.902s) [584.483463] Starting dynamic subtest: mman [598.961910] Dynamic subtest mman: SUCCESS (14.546s) [599.092107] Starting dynamic subtest: dmabuf [606.335633] Dynamic subtest dmabuf: SUCCESS (7.362s) [606.429041] Starting dynamic subtest: vma [613.763111] Dynamic subtest vma: SUCCESS (7.416s) [613.915760] Starting dynamic subtest: coherency [628.758923] Dynamic subtest coherency: SUCCESS (14.987s) [628.896183] Starting dynamic subtest: gtt [644.135797] Dynamic subtest gtt: SUCCESS (15.365s) [644.205683] Starting dynamic subtest: gem [652.940936] Dynamic subtest gem: SUCCESS (8.796s) [652.990436] Starting dynamic subtest: evict [669.362646] Dynamic subtest evict: SUCCESS (16.419s) [669.410654] Starting dynamic subtest: hugepages [677.367712] Dynamic subtest hugepages: SUCCESS (7.998s) [677.414308] Starting dynamic subtest: gem_contexts [715.481791] Dynamic subtest gem_contexts: SUCCESS (38.110s) [715.541228] Starting dynamic subtest: client [723.084721] Dynamic subtest client: SUCCESS (7.589s) [723.130693] Starting dynamic subtest: gem_migrate [730.413865] Dynamic subtest gem_migrate: SUCCESS (7.323s) [730.460850] Starting dynamic subtest: reset [746.070541] Dynamic subtest reset: SUCCESS (15.652s) [746.115947] Starting dynamic subtest: memory_region [753.240648] Dynamic subtest memory_region: SUCCESS (7.161s) [753.287660] Starting dynamic subtest: hangcheck [784.240448] Dynamic subtest hangcheck: SUCCESS (30.991s) [784.288857] Starting dynamic subtest: execlists [798.143624] Dynamic subtest execlists: SUCCESS (13.898s) [798.190438] Starting dynamic subtest: ring_submission [805.299293] Dynamic subtest ring_submission: SUCCESS (7.148s) [805.373344] Starting dynamic subtest: perf [812.790858] Dynamic subtest perf: SUCCESS (7.479s) [812.832553] Starting dynamic subtest: slpc [819.991712] Dynamic subtest slpc: SUCCESS (7.195s) [820.038818] Starting dynamic subtest: guc [827.259598] Dynamic subtest guc: SUCCESS (7.260s) [827.302353] Starting dynamic subtest: guc_multi_lrc [834.515179] Dynamic subtest guc_multi_lrc: SUCCESS (7.250s) [834.562804] Starting dynamic subtest: guc_hang [841.841978] Dynamic subtest guc_hang: SUCCESS (7.321s) [841.890182] Starting dynamic subtest: late_gt_pm [849.299616] Dynamic subtest late_gt_pm: SUCCESS (7.452s) [849.302964] Subtest live: SUCCESS (429.155s) [849.476419] [162/162] (275s left) dmabuf (all-tests) [849.716672] Starting subtest: all-tests [849.724045] Subtest all-tests: SKIP (0.000s) [849.877418] 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.