[118.667863] Initializing watchdogs [118.668360] /dev/watchdog0 [118.752986] [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 [118.772783] [001/162] (960s left) i915_module_load (load) [119.050840] Starting subtest: load [124.549691] Subtest load: SUCCESS (5.500s) [124.862176] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [124.883874] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [124.907943] [002/162] (954s left) core_auth (basic-auth) [125.381903] Starting subtest: basic-auth [125.390090] Subtest basic-auth: SUCCESS (0.006s) [125.564649] [003/162] (954s left) core_debugfs (read-all-entries) [125.793984] Starting subtest: read-all-entries [125.805597] Subtest read-all-entries: SUCCESS (0.014s) [125.988399] [004/162] (954s left) core_sysfs (read-all-entries) [126.204154] Starting subtest: read-all-entries [126.219146] Subtest read-all-entries: SUCCESS (0.017s) [126.392838] [005/162] (953s left) fbdev (eof) [126.658966] Subtest eof: SKIP (0.000s) [126.827923] [006/162] (953s left) fbdev (info) [127.092200] Subtest info: SKIP (0.000s) [127.294720] [007/162] (953s left) fbdev (nullptr) [127.563711] Subtest nullptr: SKIP (0.000s) [127.722842] [008/162] (953s left) fbdev (read) [127.984158] Subtest read: SKIP (0.000s) [128.142577] [009/162] (952s left) fbdev (write) [128.416851] Subtest write: SKIP (0.000s) [128.579347] [010/162] (952s left) gem_basic (bad-close) [128.796464] Starting subtest: bad-close [128.803363] Subtest bad-close: SUCCESS (0.000s) [128.964394] [011/162] (952s left) gem_basic (create-close) [129.200230] Starting subtest: create-close [129.212110] Subtest create-close: SUCCESS (0.004s) [129.412276] [012/162] (952s left) gem_basic (create-fd-close) [129.636219] Starting subtest: create-fd-close [129.639990] Subtest create-fd-close: SUCCESS (0.001s) [129.853207] [013/162] (951s left) gem_busy (busy@all-engines) [130.147397] Starting subtest: busy [130.151689] Starting dynamic subtest: all-engines [130.320923] Dynamic subtest all-engines: SUCCESS (0.173s) [130.325769] Subtest busy: SUCCESS (0.178s) [130.838059] [014/162] (950s left) gem_close_race (basic-process) [131.122953] Starting subtest: basic-process [131.249523] Subtest basic-process: SUCCESS (0.128s) [131.577644] [015/162] (950s left) gem_close_race (basic-threads) [131.865496] Starting subtest: basic-threads [133.107745] Subtest basic-threads: SUCCESS (1.241s) [133.416535] [016/162] (948s left) gem_ctx_create (basic) [133.691906] Starting subtest: basic [133.693880] Subtest basic: SUCCESS (0.000s) [133.996841] [017/162] (948s left) gem_ctx_create (basic-files) [134.280709] Starting subtest: basic-files [136.340179] Subtest basic-files: SUCCESS (2.064s) [136.676765] [018/162] (945s left) gem_ctx_exec (basic) [136.916584] Starting subtest: basic [136.942139] Subtest basic: SUCCESS (0.021s) [137.128599] [019/162] (945s left) gem_exec_basic (basic) [137.374727] Starting subtest: basic [137.378248] Starting dynamic subtest: rcs0-smem [137.389102] Dynamic subtest rcs0-smem: SUCCESS (0.010s) [137.424566] Starting dynamic subtest: bcs0-smem [137.426345] Dynamic subtest bcs0-smem: SUCCESS (0.003s) [137.465805] Starting dynamic subtest: vcs0-smem [137.467908] Dynamic subtest vcs0-smem: SUCCESS (0.025s) [137.528169] Starting dynamic subtest: vecs0-smem [137.530086] Dynamic subtest vecs0-smem: SUCCESS (0.003s) [137.535203] Subtest basic: SUCCESS (0.048s) [137.724449] [020/162] (945s left) gem_exec_create (basic) [137.992184] Starting subtest: basic [137.994702] Starting dynamic subtest: smem [140.079456] Dynamic subtest smem: SUCCESS (2.085s) [140.082819] Subtest basic: SUCCESS (2.093s) [140.387791] [021/162] (942s left) gem_exec_fence (basic-busy) [140.815343] Starting subtest: basic-busy [140.817096] Starting dynamic subtest: rcs0 [140.851547] Dynamic subtest rcs0: SUCCESS (0.034s) [140.878685] Starting dynamic subtest: bcs0 [140.895219] Dynamic subtest bcs0: SUCCESS (0.038s) [140.926094] Starting dynamic subtest: vcs0 [140.939846] Dynamic subtest vcs0: SUCCESS (0.045s) [140.967258] Starting dynamic subtest: vecs0 [140.980991] Dynamic subtest vecs0: SUCCESS (0.034s) [140.983332] Subtest basic-busy: SUCCESS (0.162s) [141.917666] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [141.929119] [022/162] (941s left) gem_exec_fence (basic-wait) [142.369885] Starting subtest: basic-wait [142.379070] Starting dynamic subtest: rcs0 [142.411844] Dynamic subtest rcs0: SUCCESS (0.033s) [142.439446] Starting dynamic subtest: bcs0 [142.450199] Dynamic subtest bcs0: SUCCESS (0.035s) [142.478877] Starting dynamic subtest: vcs0 [142.489306] Dynamic subtest vcs0: SUCCESS (0.040s) [142.519440] Starting dynamic subtest: vecs0 [142.532567] Dynamic subtest vecs0: SUCCESS (0.038s) [142.534436] Subtest basic-wait: SUCCESS (0.163s) [143.333927] [023/162] (940s left) gem_exec_fence (basic-await) [143.765278] Starting subtest: basic-await [143.767502] Starting dynamic subtest: rcs0 [143.959572] Dynamic subtest rcs0: SUCCESS (0.190s) [143.993700] Starting dynamic subtest: bcs0 [144.152242] Dynamic subtest bcs0: SUCCESS (0.188s) [144.178720] Starting dynamic subtest: vcs0 [144.352678] Dynamic subtest vcs0: SUCCESS (0.195s) [144.378865] Starting dynamic subtest: vecs0 [144.557230] Dynamic subtest vecs0: SUCCESS (0.202s) [144.559608] Subtest basic-await: SUCCESS (0.795s) [145.336457] [024/162] (938s left) gem_exec_fence (nb-await) [145.757442] Starting subtest: nb-await [145.760219] Starting dynamic subtest: rcs0 [145.860399] Dynamic subtest rcs0: SUCCESS (0.101s) [145.887807] Starting dynamic subtest: bcs0 [145.961439] Dynamic subtest bcs0: SUCCESS (0.096s) [145.995064] Starting dynamic subtest: vcs0 [146.065205] Dynamic subtest vcs0: SUCCESS (0.094s) [146.093148] Starting dynamic subtest: vecs0 [146.165182] Dynamic subtest vecs0: SUCCESS (0.105s) [146.168411] Subtest nb-await: SUCCESS (0.412s) [147.037648] [025/162] (936s left) gem_exec_gttfill (basic) [147.310187] Starting subtest: basic [179.977132] Subtest basic: SUCCESS (32.664s) [180.489805] [026/162] (903s left) gem_exec_parallel (engines) [180.947366] Starting subtest: engines [180.956138] Starting dynamic subtest: basic [189.304676] Dynamic subtest basic: SUCCESS (8.364s) [189.340328] Starting dynamic subtest: contexts [201.527148] Dynamic subtest contexts: SUCCESS (12.219s) [201.632109] Starting dynamic subtest: fds [220.458158] Dynamic subtest fds: SUCCESS (18.921s) [220.494807] Starting dynamic subtest: userptr [226.957520] Dynamic subtest userptr: SUCCESS (6.499s) [226.959367] Subtest engines: SUCCESS (46.021s) [227.310298] [027/162] (857s left) gem_exec_store (basic) [227.603206] Starting subtest: basic [227.685274] Subtest basic: SUCCESS (0.084s) [228.027790] [028/162] (856s left) gem_flink_basic (bad-flink) [228.238226] Starting subtest: bad-flink [228.241812] Subtest bad-flink: SUCCESS (0.000s) [228.506640] [029/162] (856s left) gem_flink_basic (bad-open) [228.721778] Starting subtest: bad-open [228.723719] Subtest bad-open: SUCCESS (0.000s) [228.936750] [030/162] (856s left) gem_flink_basic (basic) [229.157959] Starting subtest: basic [229.159869] Subtest basic: SUCCESS (0.001s) [229.364757] [031/162] (855s left) gem_flink_basic (double-flink) [229.582255] Starting subtest: double-flink [229.584794] Subtest double-flink: SUCCESS (0.000s) [229.848325] [032/162] (855s left) gem_flink_basic (flink-lifetime) [230.074699] Starting subtest: flink-lifetime [230.085716] Subtest flink-lifetime: SUCCESS (0.009s) [230.331918] [033/162] (855s left) gem_huc_copy (huc-copy) [230.569819] Subtest huc-copy: SKIP (0.000s) [230.765319] [034/162] (855s left) gem_linear_blits (basic) [231.652754] Starting subtest: basic [231.705335] Subtest basic: SUCCESS (0.059s) [231.954791] [035/162] (854s left) gem_mmap (basic) [232.335314] Starting subtest: basic [232.349717] Subtest basic: SUCCESS (0.002s) [232.537413] [036/162] (853s left) gem_mmap_gtt (basic) [232.756995] Starting subtest: basic [232.764672] Subtest basic: SUCCESS (0.007s) [233.021913] [037/162] (853s left) gem_render_linear_blits (basic) [233.272890] Starting subtest: basic [233.408711] Subtest basic: SUCCESS (0.134s) [233.616323] [038/162] (853s left) gem_render_tiled_blits (basic) [233.850237] Starting subtest: basic [234.044335] Subtest basic: SUCCESS (0.183s) [234.261404] [039/162] (852s left) gem_ringfill (basic-all) [234.758598] Starting subtest: basic-all [236.112605] Subtest basic-all: SUCCESS (1.355s) [236.340534] [040/162] (850s left) gem_softpin (allocator-basic) [236.582670] Starting subtest: allocator-basic [236.984519] Subtest allocator-basic: SUCCESS (0.402s) [237.245305] [041/162] (850s left) gem_softpin (allocator-basic-reserve) [237.494654] Starting subtest: allocator-basic-reserve [237.919731] Subtest allocator-basic-reserve: SUCCESS (0.407s) [238.174140] [042/162] (849s left) gem_softpin (safe-alignment) [238.418288] Starting subtest: safe-alignment [238.475179] Subtest safe-alignment: SUCCESS (0.053s) [238.745297] [043/162] (848s left) gem_sync (basic-all) [239.013801] Starting subtest: basic-all [242.387192] Subtest basic-all: SUCCESS (3.371s) [242.724561] [044/162] (845s left) gem_sync (basic-each) [242.986767] Starting subtest: basic-each [245.808409] Subtest basic-each: SUCCESS (2.819s) [246.134709] [045/162] (842s left) gem_tiled_blits (basic) [246.555517] Starting subtest: basic [246.654925] Subtest basic: SUCCESS (0.093s) [246.868851] [046/162] (841s left) gem_tiled_fence_blits (basic) [247.510348] Starting subtest: basic [247.582807] Subtest basic: SUCCESS (0.067s) [247.809443] [047/162] (840s left) gem_tiled_pread_basic (basic) [248.189233] Starting subtest: basic [249.332645] Subtest basic: SUCCESS (1.139s) [249.530661] [048/162] (839s left) gem_wait (busy@all-engines) [249.826179] Starting subtest: busy [249.828279] Starting dynamic subtest: all-engines [250.353086] Dynamic subtest all-engines: SUCCESS (0.532s) [250.354846] Subtest busy: SUCCESS (0.534s) [250.753694] [049/162] (838s left) gem_wait (wait@all-engines) [251.050648] Starting subtest: wait [251.054423] Starting dynamic subtest: all-engines [252.099640] Dynamic subtest all-engines: SUCCESS (1.049s) [252.103685] Subtest wait: SUCCESS (1.053s) [252.506103] [050/162] (836s left) i915_getparams_basic (basic-eu-total) [252.728249] Starting subtest: basic-eu-total [252.741750] Subtest basic-eu-total: SUCCESS (0.000s) [252.942614] [051/162] (836s left) i915_getparams_basic (basic-subslice-total) [253.161245] Starting subtest: basic-subslice-total [253.166738] Subtest basic-subslice-total: SUCCESS (0.000s) [253.364444] [052/162] (836s left) i915_hangman (error-state-basic) [253.621426] Starting subtest: error-state-basic [253.653841] Subtest error-state-basic: SUCCESS (0.025s) [253.900836] [053/162] (835s left) i915_pciid [254.320417] [054/162] (835s left) intel_hwmon (hwmon-read) [254.534384] Subtest hwmon-read: SKIP (0.000s) [254.730268] [055/162] (835s left) intel_hwmon (hwmon-write) [254.961286] Subtest hwmon-write: SKIP (0.000s) [255.160933] [056/162] (835s left) kms_addfb_basic (addfb25-4-tiled) [255.783333] Starting subtest: addfb25-4-tiled [255.786395] Subtest addfb25-4-tiled: SUCCESS (0.002s) [255.996648] [057/162] (834s left) kms_addfb_basic (addfb25-bad-modifier) [256.471830] Starting subtest: addfb25-bad-modifier [256.474813] Subtest addfb25-bad-modifier: SUCCESS (0.002s) [256.687407] [058/162] (834s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [257.179368] Starting subtest: addfb25-framebuffer-vs-set-tiling [257.182279] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [257.453565] [059/162] (833s left) kms_addfb_basic (addfb25-modifier-no-flag) [258.034678] Starting subtest: addfb25-modifier-no-flag [258.037928] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [258.242995] [060/162] (833s left) kms_addfb_basic (addfb25-x-tiled-legacy) [258.835055] Starting subtest: addfb25-x-tiled-legacy [258.838085] Subtest addfb25-x-tiled-legacy: SUCCESS (0.002s) [259.057515] [061/162] (832s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [259.706839] Starting subtest: addfb25-x-tiled-mismatch-legacy [259.710190] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.007s) [259.950095] [062/162] (831s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [260.482120] Starting subtest: addfb25-yf-tiled-legacy [260.484695] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s) [260.688241] [063/162] (831s left) kms_addfb_basic (addfb25-y-tiled-legacy) [261.258302] Starting subtest: addfb25-y-tiled-legacy [261.260888] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s) [261.472341] [064/162] (830s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [262.008302] Starting subtest: addfb25-y-tiled-small-legacy [262.014918] Subtest addfb25-y-tiled-small-legacy: SKIP (0.001s) [262.218576] [065/162] (830s left) kms_addfb_basic (bad-pitch-0) [262.438296] Starting subtest: bad-pitch-0 [262.440283] Subtest bad-pitch-0: SUCCESS (0.000s) [262.955296] [066/162] (829s left) kms_addfb_basic (bad-pitch-1024) [263.180202] Starting subtest: bad-pitch-1024 [263.182932] Subtest bad-pitch-1024: SUCCESS (0.000s) [263.740572] [067/162] (828s left) kms_addfb_basic (bad-pitch-128) [263.962452] Starting subtest: bad-pitch-128 [263.964500] Subtest bad-pitch-128: SUCCESS (0.002s) [264.504864] [068/162] (828s left) kms_addfb_basic (bad-pitch-256) [264.721729] Starting subtest: bad-pitch-256 [264.723926] Subtest bad-pitch-256: SUCCESS (0.000s) [265.295419] [069/162] (827s left) kms_addfb_basic (bad-pitch-32) [265.516633] Starting subtest: bad-pitch-32 [265.518708] Subtest bad-pitch-32: SUCCESS (0.000s) [266.068920] [070/162] (827s left) kms_addfb_basic (bad-pitch-63) [266.304138] Starting subtest: bad-pitch-63 [266.305968] Subtest bad-pitch-63: SUCCESS (0.000s) [266.848338] [071/162] (826s left) kms_addfb_basic (bad-pitch-65536) [267.072941] Starting subtest: bad-pitch-65536 [267.077119] Subtest bad-pitch-65536: SUCCESS (0.001s) [267.596393] [072/162] (826s left) kms_addfb_basic (bad-pitch-999) [267.813859] Starting subtest: bad-pitch-999 [267.816438] Subtest bad-pitch-999: SUCCESS (0.000s) [268.363940] [073/162] (825s left) kms_addfb_basic (basic) [268.575363] Starting subtest: basic [268.577645] Subtest basic: SUCCESS (0.000s) [269.144895] [074/162] (825s left) kms_addfb_basic (basic-x-tiled-legacy) [269.462804] Starting subtest: basic-x-tiled-legacy [269.464731] Subtest basic-x-tiled-legacy: SUCCESS (0.001s) [269.986626] [075/162] (824s left) kms_addfb_basic (basic-y-tiled-legacy) [270.203124] Starting subtest: basic-y-tiled-legacy [270.206213] Subtest basic-y-tiled-legacy: SUCCESS (0.001s) [270.748121] [076/162] (823s left) kms_addfb_basic (bo-too-small) [271.305580] Starting subtest: bo-too-small [271.313118] Subtest bo-too-small: SUCCESS (0.005s) [271.531110] [077/162] (823s left) kms_addfb_basic (bo-too-small-due-to-tiling) [272.063100] Starting subtest: bo-too-small-due-to-tiling [272.065594] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s) [272.304591] [078/162] (822s left) kms_addfb_basic (clobberred-modifier) [272.515643] Starting subtest: clobberred-modifier [272.519759] Subtest clobberred-modifier: SUCCESS (0.001s) [273.069814] [079/162] (822s left) kms_addfb_basic (framebuffer-vs-set-tiling) [273.294725] Starting subtest: framebuffer-vs-set-tiling [273.297880] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [273.834263] [080/162] (821s left) kms_addfb_basic (invalid-get-prop) [274.056768] Starting subtest: invalid-get-prop [274.060199] Subtest invalid-get-prop: SUCCESS (0.000s) [274.540146] [081/162] (821s left) kms_addfb_basic (invalid-get-prop-any) [274.836256] Starting subtest: invalid-get-prop-any [274.838374] Subtest invalid-get-prop-any: SUCCESS (0.000s) [275.378894] [082/162] (820s left) kms_addfb_basic (invalid-set-prop) [275.609759] Starting subtest: invalid-set-prop [275.615698] Subtest invalid-set-prop: SUCCESS (0.000s) [276.139930] [083/162] (819s left) kms_addfb_basic (invalid-set-prop-any) [276.357380] Starting subtest: invalid-set-prop-any [276.360568] Subtest invalid-set-prop-any: SUCCESS (0.000s) [276.905802] [084/162] (819s left) kms_addfb_basic (no-handle) [277.139112] Starting subtest: no-handle [277.140930] Subtest no-handle: SUCCESS (0.000s) [277.637339] [085/162] (818s left) kms_addfb_basic (size-max) [278.184649] Starting subtest: size-max [278.190566] Subtest size-max: SUCCESS (0.001s) [278.404989] [086/162] (818s left) kms_addfb_basic (small-bo) [278.954632] Starting subtest: small-bo [278.957217] Subtest small-bo: SUCCESS (0.000s) [279.184750] [087/162] (817s left) kms_addfb_basic (tile-pitch-mismatch) [279.422849] Starting subtest: tile-pitch-mismatch [279.425303] Subtest tile-pitch-mismatch: SUCCESS (0.002s) [280.022871] [088/162] (817s left) kms_addfb_basic (too-high) [280.570340] Starting subtest: too-high [280.573887] Subtest too-high: SUCCESS (0.005s) [280.792679] [089/162] (816s left) kms_addfb_basic (too-wide) [281.318256] Starting subtest: too-wide [281.322799] Subtest too-wide: SUCCESS (0.000s) [281.523392] [090/162] (815s left) kms_addfb_basic (unused-handle) [281.743171] Starting subtest: unused-handle [281.744826] Subtest unused-handle: SUCCESS (0.000s) [282.275871] [091/162] (815s left) kms_addfb_basic (unused-modifier) [282.504209] Starting subtest: unused-modifier [282.507601] Subtest unused-modifier: SUCCESS (0.000s) [283.061423] [092/162] (814s left) kms_addfb_basic (unused-offsets) [283.281563] Starting subtest: unused-offsets [283.284579] Subtest unused-offsets: SUCCESS (0.000s) [283.802407] [093/162] (814s left) kms_addfb_basic (unused-pitches) [284.030719] Starting subtest: unused-pitches [284.033822] Subtest unused-pitches: SUCCESS (0.000s) [284.581881] [094/162] (813s left) kms_busy (basic) [285.187592] Subtest basic: SKIP (0.000s) [285.389231] [095/162] (813s left) kms_prop_blob (basic) [285.608894] Starting subtest: basic [285.612848] Subtest basic: SUCCESS (0.001s) [285.822549] [096/162] (812s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [286.335995] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [286.529954] [097/162] (812s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [287.155152] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [287.353867] [098/162] (811s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [287.893803] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [288.099948] [099/162] (811s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [288.666326] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [288.874883] [100/162] (810s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [289.412495] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [289.625485] [101/162] (810s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [290.327581] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [290.518687] [102/162] (809s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [291.103910] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [291.362080] [103/162] (808s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [291.883112] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [292.081542] [104/162] (808s left) kms_dsc (dsc-basic) [292.648884] Subtest dsc-basic: SKIP (0.000s) [292.844827] [105/162] (807s left) kms_flip (basic-flip-vs-dpms) [293.429376] Starting subtest: basic-flip-vs-dpms [293.439128] Subtest basic-flip-vs-dpms: SKIP (0.009s) [293.704296] [106/162] (807s left) kms_flip (basic-flip-vs-modeset) [294.302857] Starting subtest: basic-flip-vs-modeset [294.310973] Subtest basic-flip-vs-modeset: SKIP (0.009s) [294.567747] [107/162] (806s left) kms_flip (basic-flip-vs-wf_vblank) [295.104143] Starting subtest: basic-flip-vs-wf_vblank [295.114905] Subtest basic-flip-vs-wf_vblank: SKIP (0.010s) [295.380214] [108/162] (805s left) kms_flip (basic-plain-flip) [295.955661] Starting subtest: basic-plain-flip [295.969224] Subtest basic-plain-flip: SKIP (0.012s) [296.211882] [109/162] (805s left) kms_force_connector_basic (force-connector-state) [296.571960] Starting subtest: force-connector-state [297.342187] Subtest force-connector-state: SUCCESS (0.766s) [298.229934] [110/162] (803s left) kms_force_connector_basic (force-edid) [298.586319] Starting subtest: force-edid [298.691285] Subtest force-edid: SUCCESS (0.109s) [299.304443] [111/162] (802s left) kms_force_connector_basic (force-load-detect) [299.687775] Starting subtest: force-load-detect [299.693389] Subtest force-load-detect: SKIP (0.000s) [300.195558] [112/162] (801s left) kms_force_connector_basic (prune-stale-modes) [300.556415] Starting subtest: prune-stale-modes [300.772190] Subtest prune-stale-modes: SUCCESS (0.202s) [301.342205] [113/162] (800s left) kms_frontbuffer_tracking (basic) [301.906705] Subtest basic: SKIP (0.000s) [302.149550] [114/162] (800s left) kms_hdmi_inject (inject-audio) [302.380888] Starting subtest: inject-audio [302.812397] Subtest inject-audio: SUCCESS (0.439s) [303.282553] [115/162] (799s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [303.834587] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [304.039714] [116/162] (798s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [304.643820] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [304.975981] [117/162] (798s left) kms_pipe_crc_basic (hang-read-crc) [305.548664] Subtest hang-read-crc: SKIP (0.000s) [305.771996] [118/162] (797s left) kms_pipe_crc_basic (nonblocking-crc) [306.303933] Subtest nonblocking-crc: SKIP (0.000s) [306.529864] [119/162] (797s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [307.093844] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [307.334242] [120/162] (796s left) kms_pipe_crc_basic (read-crc) [307.818468] Subtest read-crc: SKIP (0.000s) [308.037711] [121/162] (796s left) kms_pipe_crc_basic (read-crc-frame-sequence) [308.583133] Subtest read-crc-frame-sequence: SKIP (0.000s) [308.795408] [122/162] (795s left) kms_pm_backlight (basic-brightness) [309.352126] Subtest basic-brightness: SKIP (0.000s) [309.580630] [123/162] (794s left) kms_pm_rpm (basic-pci-d3-state) [311.577942] Starting subtest: basic-pci-d3-state [311.793277] Subtest basic-pci-d3-state: SUCCESS (0.215s) [312.031481] [124/162] (792s left) kms_pm_rpm (basic-rte) [312.239636] Starting subtest: basic-rte [314.092051] Subtest basic-rte: SUCCESS (1.849s) [314.548370] [125/162] (790s left) kms_psr (psr-primary-page-flip) [315.093178] Subtest psr-primary-page-flip: SKIP (0.000s) [315.312596] [126/162] (789s left) kms_psr (psr-cursor-plane-move) [315.895253] Subtest psr-cursor-plane-move: SKIP (0.000s) [316.136253] [127/162] (789s left) kms_psr (psr-sprite-plane-onoff) [316.686725] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [316.913778] [128/162] (788s left) kms_psr (psr-primary-mmap-gtt) [317.396850] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [317.618382] [129/162] (788s left) kms_setmode (basic-clone-single-crtc) [317.850126] Starting subtest: basic-clone-single-crtc [317.857939] Subtest basic-clone-single-crtc: SKIP (0.001s) [318.083519] [130/162] (787s left) i915_pm_rps (basic-api) [318.368693] Starting subtest: basic-api [318.383863] Subtest basic-api: SUCCESS (0.020s) [318.632729] [131/162] (787s left) prime_self_import (basic-llseek-bad) [318.845770] Starting subtest: basic-llseek-bad [318.857698] Subtest basic-llseek-bad: SUCCESS (0.013s) [319.084759] [132/162] (787s left) prime_self_import (basic-llseek-size) [319.303108] Starting subtest: basic-llseek-size [319.317501] Subtest basic-llseek-size: SUCCESS (0.015s) [319.534668] [133/162] (787s left) prime_self_import (basic-with_fd_dup) [319.761642] Starting subtest: basic-with_fd_dup [319.799602] Subtest basic-with_fd_dup: SUCCESS (0.044s) [320.074543] [134/162] (786s left) prime_self_import (basic-with_one_bo) [320.286123] Starting subtest: basic-with_one_bo [320.308790] Subtest basic-with_one_bo: SUCCESS (0.027s) [320.548617] [135/162] (786s left) prime_self_import (basic-with_one_bo_two_files) [320.769147] Starting subtest: basic-with_one_bo_two_files [320.782762] Subtest basic-with_one_bo_two_files: SUCCESS (0.019s) [321.003569] [136/162] (786s left) prime_self_import (basic-with_two_bos) [321.218642] Starting subtest: basic-with_two_bos [321.230835] Subtest basic-with_two_bos: SUCCESS (0.020s) [321.472739] [137/162] (785s left) prime_vgem (basic-fence-flip) [321.737678] Starting subtest: basic-fence-flip [322.069160] Subtest basic-fence-flip: SKIP (0.332s) [322.332144] [138/162] (785s left) prime_vgem (basic-fence-mmap) [322.592346] Starting subtest: basic-fence-mmap [322.706603] Subtest basic-fence-mmap: SUCCESS (0.115s) [322.956367] [139/162] (784s left) prime_vgem (basic-fence-read) [323.237729] Starting subtest: basic-fence-read [323.527096] Subtest basic-fence-read: SUCCESS (0.267s) [323.788652] [140/162] (784s left) prime_vgem (basic-gtt) [324.049311] Starting subtest: basic-gtt [324.103069] Subtest basic-gtt: SUCCESS (0.043s) [324.333714] [141/162] (783s left) prime_vgem (basic-read) [324.592598] Starting subtest: basic-read [324.704146] Subtest basic-read: SUCCESS (0.114s) [324.976102] [142/162] (783s left) prime_vgem (basic-write) [325.240039] Starting subtest: basic-write [325.413154] Subtest basic-write: SUCCESS (0.174s) [325.651982] [143/162] (783s left) vgem_basic (setversion) [325.876860] Starting subtest: setversion [325.880880] Subtest setversion: SUCCESS (0.000s) [326.138881] [144/162] (782s left) vgem_basic (create) [326.365509] Starting subtest: create [326.368640] Subtest create: SUCCESS (0.003s) [326.610531] [145/162] (782s left) vgem_basic (debugfs) [326.831328] Starting subtest: debugfs [326.833389] Subtest debugfs: SUCCESS (0.002s) [327.048953] [146/162] (782s left) vgem_basic (dmabuf-export) [327.278545] Starting subtest: dmabuf-export [327.293414] Subtest dmabuf-export: SUCCESS (0.014s) [327.520483] [147/162] (782s left) vgem_basic (dmabuf-fence) [327.737809] Starting subtest: dmabuf-fence [327.741137] Subtest dmabuf-fence: SUCCESS (0.003s) [327.958463] [148/162] (781s left) vgem_basic (dmabuf-fence-before) [328.185405] Starting subtest: dmabuf-fence-before [328.187986] Subtest dmabuf-fence-before: SUCCESS (0.002s) [328.402392] [149/162] (781s left) vgem_basic (dmabuf-mmap) [328.621674] Starting subtest: dmabuf-mmap [328.666364] Subtest dmabuf-mmap: SUCCESS (0.045s) [328.887634] [150/162] (781s left) vgem_basic (mmap) [329.120118] Starting subtest: mmap [329.153302] Subtest mmap: SUCCESS (0.034s) [329.381533] [151/162] (781s left) vgem_basic (second-client) [329.602608] Starting subtest: second-client [329.624656] Subtest second-client: SUCCESS (0.020s) [329.844439] [152/162] (780s left) vgem_basic (sysfs) [330.073742] Starting subtest: sysfs [330.075571] Subtest sysfs: SUCCESS (0.002s) [330.300566] [153/162] (780s left) core_hotunplug (unbind-rebind) [330.712086] Starting subtest: unbind-rebind [336.084681] Subtest unbind-rebind: SUCCESS (5.366s) [336.287334] [154/162] (774s left) vgem_basic (unload) [336.504115] Starting subtest: unload [365.714983] Subtest unload: SUCCESS (29.215s) [366.056633] [155/162] (745s left) i915_module_load (reload) [366.279363] Starting subtest: reload [373.399228] Subtest reload: SUCCESS (7.113s) [373.904356] [156/162] (737s left) gem_lmem_swapping (basic) [374.228168] Subtest basic: SKIP (0.000s) [374.428956] [157/162] (737s left) gem_lmem_swapping (parallel-random-engines) [374.666246] Subtest parallel-random-engines: SKIP (0.000s) [374.866545] [158/162] (737s left) gem_lmem_swapping (random-engines) [375.121740] Subtest random-engines: SKIP (0.000s) [375.329976] [159/162] (737s left) gem_lmem_swapping (verify-random) [375.578174] Subtest verify-random: SKIP (0.000s) [375.782549] [160/162] (736s left) i915_pm_rpm (module-reload) [377.716897] Starting subtest: module-reload [395.517458] Subtest module-reload: SUCCESS (17.802s) [395.662722] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [395.668458] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [395.674973] [161/162] (717s left) i915_selftest (live) [395.933099] Starting subtest: live [395.936304] Starting dynamic subtest: sanitycheck [401.531270] Dynamic subtest sanitycheck: SUCCESS (5.606s) [401.575701] Starting dynamic subtest: uncore [407.123586] Dynamic subtest uncore: SUCCESS (5.585s) [407.199096] Starting dynamic subtest: workarounds [412.971300] Dynamic subtest workarounds: SUCCESS (5.836s) [413.027262] Starting dynamic subtest: gt_engines [419.099287] Dynamic subtest gt_engines: SUCCESS (6.120s) [419.129905] Starting dynamic subtest: gt_timelines [455.996134] Dynamic subtest gt_timelines: SUCCESS (36.891s) [456.025332] Starting dynamic subtest: gt_contexts [461.801472] Dynamic subtest gt_contexts: SUCCESS (5.802s) [461.855547] Starting dynamic subtest: gt_lrc [471.175142] Dynamic subtest gt_lrc: SUCCESS (9.365s) [471.221258] Starting dynamic subtest: gt_mocs [476.614480] Dynamic subtest gt_mocs: SUCCESS (5.433s) [476.711216] Starting dynamic subtest: gt_pm [483.749224] Dynamic subtest gt_pm: SUCCESS (7.125s) [483.785801] Starting dynamic subtest: gt_heartbeat [489.217608] Dynamic subtest gt_heartbeat: SUCCESS (5.459s) [489.269222] Starting dynamic subtest: gt_tlb [495.394299] Dynamic subtest gt_tlb: SUCCESS (6.167s) [495.423989] Starting dynamic subtest: requests [507.392732] Dynamic subtest requests: SUCCESS (11.994s) [507.426780] Starting dynamic subtest: migrate [517.504145] Dynamic subtest migrate: SUCCESS (10.107s) [517.539517] Starting dynamic subtest: active [523.164716] Dynamic subtest active: SUCCESS (5.651s) [523.203116] Starting dynamic subtest: objects [531.102474] Dynamic subtest objects: SUCCESS (7.935s) [531.147694] Starting dynamic subtest: mman [544.128340] Dynamic subtest mman: SUCCESS (13.017s) [544.169898] Starting dynamic subtest: dmabuf [549.757491] Dynamic subtest dmabuf: SUCCESS (5.626s) [549.810056] Starting dynamic subtest: vma [555.522140] Dynamic subtest vma: SUCCESS (5.753s) [555.589486] Starting dynamic subtest: coherency [567.041333] Dynamic subtest coherency: SUCCESS (11.506s) [567.080676] Starting dynamic subtest: gtt [580.992725] Dynamic subtest gtt: SUCCESS (13.944s) [581.028844] Starting dynamic subtest: gem [587.820750] Dynamic subtest gem: SUCCESS (6.821s) [587.852218] Starting dynamic subtest: evict [601.644096] Dynamic subtest evict: SUCCESS (13.812s) [601.674661] Starting dynamic subtest: hugepages [607.963868] Dynamic subtest hugepages: SUCCESS (6.319s) [608.008740] Starting dynamic subtest: gem_contexts [642.685343] Dynamic subtest gem_contexts: SUCCESS (34.704s) [642.722049] Starting dynamic subtest: client [648.555568] Dynamic subtest client: SUCCESS (5.862s) [648.593179] Starting dynamic subtest: gem_migrate [654.135181] Dynamic subtest gem_migrate: SUCCESS (5.569s) [654.176526] Starting dynamic subtest: reset [668.239117] Dynamic subtest reset: SUCCESS (14.096s) [668.276233] Starting dynamic subtest: memory_region [673.813092] Dynamic subtest memory_region: SUCCESS (5.566s) [673.885507] Starting dynamic subtest: hangcheck [702.869977] Dynamic subtest hangcheck: SUCCESS (29.046s) [702.916345] Starting dynamic subtest: execlists [714.912852] Dynamic subtest execlists: SUCCESS (12.033s) [714.982306] Starting dynamic subtest: ring_submission [720.445174] Dynamic subtest ring_submission: SUCCESS (5.522s) [720.531048] Starting dynamic subtest: perf [726.889125] Dynamic subtest perf: SUCCESS (6.435s) [726.926048] Starting dynamic subtest: slpc [732.697238] Dynamic subtest slpc: SUCCESS (5.800s) [732.852201] Starting dynamic subtest: guc [738.560149] Dynamic subtest guc: SUCCESS (5.851s) [738.589765] Starting dynamic subtest: guc_multi_lrc [744.150210] Dynamic subtest guc_multi_lrc: SUCCESS (5.583s) [744.188271] Starting dynamic subtest: guc_hang [749.864213] Dynamic subtest guc_hang: SUCCESS (5.703s) [749.943926] Starting dynamic subtest: late_gt_pm [755.640759] Dynamic subtest late_gt_pm: SUCCESS (5.695s) [755.644838] Subtest live: SUCCESS (359.634s) [755.784703] [162/162] (357s left) dmabuf (all-tests) [756.050241] Starting subtest: all-tests [756.053656] Starting dynamic subtest: sanitycheck [756.094589] Dynamic subtest sanitycheck: SUCCESS (0.052s) [756.139547] Starting dynamic subtest: dma_fence [756.445710] Dynamic subtest dma_fence: SUCCESS (0.331s) [756.494159] Starting dynamic subtest: dma_fence_chain [756.499747] Dynamic subtest dma_fence_chain: SKIP (0.001s) [756.529170] Starting dynamic subtest: dma_fence_unwrap [756.530776] Dynamic subtest dma_fence_unwrap: SUCCESS (0.063s) [756.561989] Starting dynamic subtest: dma_resv [756.632743] Dynamic subtest dma_resv: SUCCESS (0.101s) [756.634536] Subtest all-tests: SUCCESS (0.596s) [756.784312] 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.