[33.014970] Initializing watchdogs [33.015190] /dev/watchdog0 [33.029584] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:591d Intel Kabylake (Gen9) HD Graphics P630 [33.036195] [001/162] (960s left) i915_module_load (load) [33.784334] Starting subtest: load [36.194101] Subtest load: SUCCESS (2.469s) [36.226150] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [36.227335] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [36.232474] [002/162] (957s left) core_auth (basic-auth) [36.293761] Starting subtest: basic-auth [36.296897] Subtest basic-auth: SUCCESS (0.001s) [36.333624] [003/162] (957s left) core_debugfs (read-all-entries) [36.377973] Starting subtest: read-all-entries [36.381209] Subtest read-all-entries: SUCCESS (0.002s) [36.418621] [004/162] (957s left) core_sysfs (read-all-entries) [36.466893] Starting subtest: read-all-entries [36.470098] Subtest read-all-entries: SUCCESS (0.003s) [36.507855] [005/162] (957s left) fbdev (eof) [36.561750] Subtest eof: SKIP (0.000s) [36.598630] [006/162] (957s left) fbdev (info) [36.649630] Subtest info: SKIP (0.000s) [36.686741] [007/162] (957s left) fbdev (nullptr) [36.737627] Subtest nullptr: SKIP (0.000s) [36.777131] [008/162] (957s left) fbdev (read) [36.831269] Subtest read: SKIP (0.000s) [36.869421] [009/162] (956s left) fbdev (write) [36.924562] Subtest write: SKIP (0.000s) [36.961843] [010/162] (956s left) gem_basic (bad-close) [37.008978] Starting subtest: bad-close [37.015064] Subtest bad-close: SUCCESS (0.000s) [37.053411] [011/162] (956s left) gem_basic (create-close) [37.101922] Starting subtest: create-close [37.108345] Subtest create-close: SUCCESS (0.000s) [37.160941] [012/162] (956s left) gem_basic (create-fd-close) [37.210987] Starting subtest: create-fd-close [37.217793] Subtest create-fd-close: SUCCESS (0.000s) [37.266442] [013/162] (956s left) gem_busy (busy@all-engines) [37.337349] Starting subtest: busy [37.340548] Starting dynamic subtest: all-engines [37.362747] Dynamic subtest all-engines: SUCCESS (0.026s) [37.366212] Subtest busy: SUCCESS (0.026s) [37.672910] [014/162] (956s left) gem_close_race (basic-process) [37.729656] Starting subtest: basic-process [37.787537] Subtest basic-process: SUCCESS (0.058s) [37.930363] [015/162] (956s left) gem_close_race (basic-threads) [37.988748] Starting subtest: basic-threads [39.187583] Subtest basic-threads: SUCCESS (1.199s) [39.336879] [016/162] (954s left) gem_ctx_create (basic) [39.392584] Starting subtest: basic [39.395722] Subtest basic: SUCCESS (0.000s) [39.540881] [017/162] (954s left) gem_ctx_create (basic-files) [39.595538] Starting subtest: basic-files [41.604070] Subtest basic-files: SUCCESS (2.011s) [41.800254] [018/162] (952s left) gem_ctx_exec (basic) [41.852097] Starting subtest: basic [41.855066] Subtest basic: SUCCESS (0.004s) [41.930374] [019/162] (952s left) gem_exec_basic (basic) [41.979668] Starting subtest: basic [41.982714] Starting dynamic subtest: rcs0-smem [41.985859] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [41.995767] Starting dynamic subtest: bcs0-smem [41.998871] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [42.008161] Starting dynamic subtest: vcs0-smem [42.011257] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [42.020778] Starting dynamic subtest: vecs0-smem [42.024047] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [42.027328] Subtest basic: SUCCESS (0.005s) [42.153935] [020/162] (952s left) gem_exec_create (basic) [42.210146] Starting subtest: basic [42.213192] Starting dynamic subtest: smem [44.270297] Dynamic subtest smem: SUCCESS (2.060s) [44.273486] Subtest basic: SUCCESS (2.060s) [44.413620] [021/162] (949s left) gem_exec_fence (basic-busy) [44.582223] Starting subtest: basic-busy [44.585410] Starting dynamic subtest: rcs0 [44.610422] Dynamic subtest rcs0: SUCCESS (0.028s) [44.624125] Starting dynamic subtest: bcs0 [44.640334] Dynamic subtest bcs0: SUCCESS (0.030s) [44.651111] Starting dynamic subtest: vcs0 [44.667168] Dynamic subtest vcs0: SUCCESS (0.027s) [44.677156] Starting dynamic subtest: vecs0 [44.700229] Dynamic subtest vecs0: SUCCESS (0.033s) [44.703551] Subtest basic-busy: SUCCESS (0.119s) [45.218310] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [45.222457] [022/162] (949s left) gem_exec_fence (basic-wait) [45.389483] Starting subtest: basic-wait [45.392939] Starting dynamic subtest: rcs0 [45.421470] Dynamic subtest rcs0: SUCCESS (0.032s) [45.436164] Starting dynamic subtest: bcs0 [45.456151] Dynamic subtest bcs0: SUCCESS (0.035s) [45.468128] Starting dynamic subtest: vcs0 [45.487852] Dynamic subtest vcs0: SUCCESS (0.031s) [45.507554] Starting dynamic subtest: vecs0 [45.524609] Dynamic subtest vecs0: SUCCESS (0.036s) [45.528356] Subtest basic-wait: SUCCESS (0.135s) [46.033359] [023/162] (948s left) gem_exec_fence (basic-await) [46.205495] Starting subtest: basic-await [46.210376] Starting dynamic subtest: rcs0 [46.281391] Dynamic subtest rcs0: SUCCESS (0.077s) [46.298496] Starting dynamic subtest: bcs0 [46.370198] Dynamic subtest bcs0: SUCCESS (0.086s) [46.385796] Starting dynamic subtest: vcs0 [46.459017] Dynamic subtest vcs0: SUCCESS (0.086s) [46.476503] Starting dynamic subtest: vecs0 [46.549798] Dynamic subtest vecs0: SUCCESS (0.088s) [46.553206] Subtest basic-await: SUCCESS (0.340s) [47.044258] [024/162] (947s left) gem_exec_fence (nb-await) [47.229872] Starting subtest: nb-await [47.233308] Starting dynamic subtest: rcs0 [47.289445] Dynamic subtest rcs0: SUCCESS (0.062s) [47.300901] Starting dynamic subtest: bcs0 [47.347429] Dynamic subtest bcs0: SUCCESS (0.056s) [47.366542] Starting dynamic subtest: vcs0 [47.411771] Dynamic subtest vcs0: SUCCESS (0.062s) [47.432596] Starting dynamic subtest: vecs0 [47.478789] Dynamic subtest vecs0: SUCCESS (0.064s) [47.482698] Subtest nb-await: SUCCESS (0.247s) [47.993540] [025/162] (946s left) gem_exec_gttfill (basic) [48.050764] Starting subtest: basic [51.377782] Subtest basic: SUCCESS (3.262s) [51.535639] [026/162] (943s left) gem_exec_parallel (engines) [51.668443] Starting subtest: engines [51.671850] Starting dynamic subtest: basic [53.814659] Dynamic subtest basic: SUCCESS (2.118s) [53.825433] Starting dynamic subtest: contexts [56.699958] Dynamic subtest contexts: SUCCESS (2.858s) [56.711868] Starting dynamic subtest: fds [58.711786] Dynamic subtest fds: SUCCESS (1.998s) [58.722661] Starting dynamic subtest: userptr [61.035821] Dynamic subtest userptr: SUCCESS (2.312s) [61.039224] Subtest engines: SUCCESS (9.287s) [61.205941] [027/162] (933s left) gem_exec_store (basic) [61.267469] Starting subtest: basic [61.315364] Subtest basic: SUCCESS (0.050s) [61.463732] [028/162] (933s left) gem_flink_basic (bad-flink) [61.515156] Starting subtest: bad-flink [61.518623] Subtest bad-flink: SUCCESS (0.000s) [61.563878] [029/162] (933s left) gem_flink_basic (bad-open) [61.610958] Starting subtest: bad-open [61.614137] Subtest bad-open: SUCCESS (0.000s) [61.657481] [030/162] (933s left) gem_flink_basic (basic) [61.705046] Starting subtest: basic [61.708290] Subtest basic: SUCCESS (0.000s) [61.767716] [031/162] (933s left) gem_flink_basic (double-flink) [61.814889] Starting subtest: double-flink [61.818182] Subtest double-flink: SUCCESS (0.000s) [61.875148] [032/162] (932s left) gem_flink_basic (flink-lifetime) [61.922544] Starting subtest: flink-lifetime [61.925690] Subtest flink-lifetime: SUCCESS (0.001s) [61.984585] [033/162] (932s left) gem_huc_copy (huc-copy) [62.036612] Starting subtest: huc-copy [62.042941] Subtest huc-copy: SKIP (0.000s) [62.100247] [034/162] (932s left) gem_linear_blits (basic) [62.215640] Starting subtest: basic [62.225064] Subtest basic: SUCCESS (0.007s) [62.314384] [035/162] (932s left) gem_mmap (basic) [62.444958] Starting subtest: basic [62.460220] Subtest basic: SUCCESS (0.000s) [62.505667] [036/162] (932s left) gem_mmap_gtt (basic) [62.556319] Starting subtest: basic [62.560071] Subtest basic: SUCCESS (0.001s) [62.602822] [037/162] (932s left) gem_render_linear_blits (basic) [62.652725] Starting subtest: basic [62.677162] Subtest basic: SUCCESS (0.025s) [62.739602] [038/162] (932s left) gem_render_tiled_blits (basic) [62.790842] Starting subtest: basic [62.819395] Subtest basic: SUCCESS (0.029s) [62.880795] [039/162] (932s left) gem_ringfill (basic-all) [63.108341] Starting subtest: basic-all [64.248318] Subtest basic-all: SUCCESS (1.136s) [64.328895] [040/162] (930s left) gem_softpin (allocator-basic) [64.383418] Starting subtest: allocator-basic [64.477246] Subtest allocator-basic: SUCCESS (0.096s) [64.560087] [041/162] (930s left) gem_softpin (allocator-basic-reserve) [64.611447] Starting subtest: allocator-basic-reserve [64.706807] Subtest allocator-basic-reserve: SUCCESS (0.096s) [64.778347] [042/162] (930s left) gem_softpin (safe-alignment) [64.833345] Starting subtest: safe-alignment [64.842127] Subtest safe-alignment: SUCCESS (0.011s) [64.920849] [043/162] (930s left) gem_sync (basic-all) [64.997175] Starting subtest: basic-all [67.247597] Subtest basic-all: SUCCESS (2.266s) [67.403242] [044/162] (928s left) gem_sync (basic-each) [67.523893] Starting subtest: basic-each [69.615346] Subtest basic-each: SUCCESS (2.105s) [69.768462] [045/162] (925s left) gem_tiled_blits (basic) [69.871912] Starting subtest: basic [69.886202] Subtest basic: SUCCESS (0.014s) [69.983424] [046/162] (925s left) gem_tiled_fence_blits (basic) [70.175489] Starting subtest: basic [70.186185] Subtest basic: SUCCESS (0.010s) [70.274020] [047/162] (925s left) gem_tiled_pread_basic (basic) [70.406466] Starting subtest: basic [70.521647] Subtest basic: SUCCESS (0.122s) [70.581354] [048/162] (925s left) gem_wait (busy@all-engines) [70.641572] Starting subtest: busy [70.644853] Starting dynamic subtest: all-engines [71.168084] Dynamic subtest all-engines: SUCCESS (0.523s) [71.171581] Subtest busy: SUCCESS (0.523s) [71.323720] [049/162] (924s left) gem_wait (wait@all-engines) [71.386198] Starting subtest: wait [71.389465] Starting dynamic subtest: all-engines [72.407630] Dynamic subtest all-engines: SUCCESS (1.023s) [72.411509] Subtest wait: SUCCESS (1.024s) [72.570349] [050/162] (923s left) i915_getparams_basic (basic-eu-total) [72.617814] Starting subtest: basic-eu-total [72.624180] Subtest basic-eu-total: SUCCESS (0.000s) [72.666570] [051/162] (923s left) i915_getparams_basic (basic-subslice-total) [72.711148] Starting subtest: basic-subslice-total [72.717219] Subtest basic-subslice-total: SUCCESS (0.000s) [72.760939] [052/162] (923s left) i915_hangman (error-state-basic) [72.821715] Starting subtest: error-state-basic [72.825881] Subtest error-state-basic: SUCCESS (0.005s) [72.895461] [053/162] (922s left) i915_pciid [73.043905] [054/162] (922s left) intel_hwmon (hwmon-read) [73.093848] Subtest hwmon-read: SKIP (0.000s) [73.135540] [055/162] (922s left) intel_hwmon (hwmon-write) [73.186952] Subtest hwmon-write: SKIP (0.000s) [73.230709] [056/162] (922s left) kms_addfb_basic (addfb25-4-tiled) [73.317814] Starting subtest: addfb25-4-tiled [73.320782] Subtest addfb25-4-tiled: SUCCESS (0.000s) [73.380347] [057/162] (922s left) kms_addfb_basic (addfb25-bad-modifier) [73.469918] Starting subtest: addfb25-bad-modifier [73.474884] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [73.528724] [058/162] (922s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [73.610055] Starting subtest: addfb25-framebuffer-vs-set-tiling [73.613337] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [73.673164] [059/162] (922s left) kms_addfb_basic (addfb25-modifier-no-flag) [73.758615] Starting subtest: addfb25-modifier-no-flag [73.761630] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [73.803665] [060/162] (922s left) kms_addfb_basic (addfb25-x-tiled-legacy) [73.885830] Starting subtest: addfb25-x-tiled-legacy [73.889240] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [73.954573] [061/162] (922s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [74.033572] Starting subtest: addfb25-x-tiled-mismatch-legacy [74.036568] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [74.094363] [062/162] (922s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [74.173777] Starting subtest: addfb25-yf-tiled-legacy [74.176871] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [74.258424] [063/162] (922s left) kms_addfb_basic (addfb25-y-tiled-legacy) [74.336162] Starting subtest: addfb25-y-tiled-legacy [74.339201] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [74.407170] [064/162] (921s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [74.487440] Starting subtest: addfb25-y-tiled-small-legacy [74.490381] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [74.542879] [065/162] (921s left) kms_addfb_basic (bad-pitch-0) [74.596713] Starting subtest: bad-pitch-0 [74.600429] Subtest bad-pitch-0: SUCCESS (0.000s) [74.684546] [066/162] (921s left) kms_addfb_basic (bad-pitch-1024) [74.739461] Starting subtest: bad-pitch-1024 [74.742769] Subtest bad-pitch-1024: SUCCESS (0.000s) [74.828293] [067/162] (921s left) kms_addfb_basic (bad-pitch-128) [74.881811] Starting subtest: bad-pitch-128 [74.887285] Subtest bad-pitch-128: SUCCESS (0.000s) [74.970318] [068/162] (921s left) kms_addfb_basic (bad-pitch-256) [75.022072] Starting subtest: bad-pitch-256 [75.025804] Subtest bad-pitch-256: SUCCESS (0.000s) [75.118412] [069/162] (921s left) kms_addfb_basic (bad-pitch-32) [75.170645] Starting subtest: bad-pitch-32 [75.173894] Subtest bad-pitch-32: SUCCESS (0.000s) [75.266561] [070/162] (921s left) kms_addfb_basic (bad-pitch-63) [75.316391] Starting subtest: bad-pitch-63 [75.320854] Subtest bad-pitch-63: SUCCESS (0.000s) [75.416618] [071/162] (921s left) kms_addfb_basic (bad-pitch-65536) [75.466944] Starting subtest: bad-pitch-65536 [75.472317] Subtest bad-pitch-65536: SUCCESS (0.000s) [75.556306] [072/162] (921s left) kms_addfb_basic (bad-pitch-999) [75.609111] Starting subtest: bad-pitch-999 [75.612056] Subtest bad-pitch-999: SUCCESS (0.000s) [75.685516] [073/162] (921s left) kms_addfb_basic (basic) [75.736757] Starting subtest: basic [75.740221] Subtest basic: SUCCESS (0.000s) [75.823226] [074/162] (920s left) kms_addfb_basic (basic-x-tiled-legacy) [75.876360] Starting subtest: basic-x-tiled-legacy [75.879473] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [75.965594] [075/162] (920s left) kms_addfb_basic (basic-y-tiled-legacy) [76.015885] Starting subtest: basic-y-tiled-legacy [76.020313] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [76.113503] [076/162] (920s left) kms_addfb_basic (bo-too-small) [76.191096] Starting subtest: bo-too-small [76.194342] Subtest bo-too-small: SUCCESS (0.000s) [76.250977] [077/162] (920s left) kms_addfb_basic (bo-too-small-due-to-tiling) [76.353825] Starting subtest: bo-too-small-due-to-tiling [76.356986] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [76.534842] [078/162] (920s left) kms_addfb_basic (clobberred-modifier) [76.918672] Starting subtest: clobberred-modifier [76.983048] Subtest clobberred-modifier: SUCCESS (0.000s) [77.397939] [079/162] (920s left) kms_addfb_basic (framebuffer-vs-set-tiling) [77.725213] Starting subtest: framebuffer-vs-set-tiling [77.831192] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [77.877209] [080/162] (919s left) kms_addfb_basic (invalid-get-prop) [77.927476] Starting subtest: invalid-get-prop [77.933132] Subtest invalid-get-prop: SUCCESS (0.000s) [78.029462] [081/162] (919s left) kms_addfb_basic (invalid-get-prop-any) [78.078288] Starting subtest: invalid-get-prop-any [78.082417] Subtest invalid-get-prop-any: SUCCESS (0.000s) [78.180238] [082/162] (919s left) kms_addfb_basic (invalid-set-prop) [78.229563] Starting subtest: invalid-set-prop [78.232936] Subtest invalid-set-prop: SUCCESS (0.000s) [78.316461] [083/162] (919s left) kms_addfb_basic (invalid-set-prop-any) [78.370271] Starting subtest: invalid-set-prop-any [78.373072] Subtest invalid-set-prop-any: SUCCESS (0.000s) [78.455230] [084/162] (919s left) kms_addfb_basic (no-handle) [78.505177] Starting subtest: no-handle [78.508675] Subtest no-handle: SUCCESS (0.000s) [78.596932] [085/162] (919s left) kms_addfb_basic (size-max) [78.677076] Starting subtest: size-max [78.680553] Subtest size-max: SUCCESS (0.000s) [78.750267] [086/162] (919s left) kms_addfb_basic (small-bo) [78.828588] Starting subtest: small-bo [78.831705] Subtest small-bo: SUCCESS (0.000s) [78.891799] [087/162] (918s left) kms_addfb_basic (tile-pitch-mismatch) [78.942792] Starting subtest: tile-pitch-mismatch [78.946061] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [79.032848] [088/162] (918s left) kms_addfb_basic (too-high) [79.111641] Starting subtest: too-high [79.115031] Subtest too-high: SUCCESS (0.001s) [79.172037] [089/162] (918s left) kms_addfb_basic (too-wide) [79.251143] Starting subtest: too-wide [79.254187] Subtest too-wide: SUCCESS (0.000s) [79.315842] [090/162] (918s left) kms_addfb_basic (unused-handle) [79.369478] Starting subtest: unused-handle [79.372556] Subtest unused-handle: SUCCESS (0.000s) [79.460183] [091/162] (918s left) kms_addfb_basic (unused-modifier) [79.513216] Starting subtest: unused-modifier [79.516234] Subtest unused-modifier: SUCCESS (0.000s) [79.598251] [092/162] (918s left) kms_addfb_basic (unused-offsets) [79.651573] Starting subtest: unused-offsets [79.654456] Subtest unused-offsets: SUCCESS (0.000s) [79.726883] [093/162] (918s left) kms_addfb_basic (unused-pitches) [79.777035] Starting subtest: unused-pitches [79.781388] Subtest unused-pitches: SUCCESS (0.000s) [79.870053] [094/162] (918s left) kms_busy (basic) [79.953189] Subtest basic: SKIP (0.000s) [79.996507] [095/162] (918s left) kms_prop_blob (basic) [80.048724] Starting subtest: basic [80.051882] Subtest basic: SUCCESS (0.000s) [80.095443] [096/162] (918s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [80.196936] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [80.250676] [097/162] (918s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [80.349950] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [80.395687] [098/162] (917s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [80.498767] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [80.543389] [099/162] (917s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [80.645105] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [80.690281] [100/162] (917s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [80.789479] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [80.834902] [101/162] (917s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [80.931982] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [80.977718] [102/162] (917s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [81.080766] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [81.126182] [103/162] (917s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [81.225172] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [81.269785] [104/162] (917s left) kms_dsc (dsc-basic) [81.350859] Subtest dsc-basic: SKIP (0.000s) [81.392853] [105/162] (917s left) kms_flip (basic-flip-vs-dpms) [81.475616] Starting subtest: basic-flip-vs-dpms [81.481938] Subtest basic-flip-vs-dpms: SKIP (0.001s) [81.540997] [106/162] (917s left) kms_flip (basic-flip-vs-modeset) [81.620594] Starting subtest: basic-flip-vs-modeset [81.626327] Subtest basic-flip-vs-modeset: SKIP (0.001s) [81.668715] [107/162] (917s left) kms_flip (basic-flip-vs-wf_vblank) [81.748298] Starting subtest: basic-flip-vs-wf_vblank [81.754199] Subtest basic-flip-vs-wf_vblank: SKIP (0.001s) [81.811763] [108/162] (916s left) kms_flip (basic-plain-flip) [81.894424] Starting subtest: basic-plain-flip [81.901195] Subtest basic-plain-flip: SKIP (0.001s) [81.954956] [109/162] (916s left) kms_force_connector_basic (force-connector-state) [82.102648] Starting subtest: force-connector-state [82.183035] Subtest force-connector-state: SUCCESS (0.077s) [82.335377] [110/162] (916s left) kms_force_connector_basic (force-edid) [82.491057] Starting subtest: force-edid [82.737435] Subtest force-edid: SUCCESS (0.178s) [83.211030] [111/162] (916s left) kms_force_connector_basic (force-load-detect) [83.532269] Starting subtest: force-load-detect [83.661898] Subtest force-load-detect: SKIP (0.000s) [84.109611] [112/162] (915s left) kms_force_connector_basic (prune-stale-modes) [84.262478] Starting subtest: prune-stale-modes [84.425009] Subtest prune-stale-modes: SUCCESS (0.168s) [84.510143] [113/162] (915s left) kms_frontbuffer_tracking (basic) [84.591347] Subtest basic: SKIP (0.000s) [84.648915] [114/162] (915s left) kms_hdmi_inject (inject-audio) [84.699299] Starting subtest: inject-audio [84.705644] Subtest inject-audio: SKIP (0.000s) [84.755377] [115/162] (915s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [84.839493] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [84.882397] [116/162] (915s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [84.963603] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [85.007143] [117/162] (914s left) kms_pipe_crc_basic (hang-read-crc) [85.086605] Subtest hang-read-crc: SKIP (0.000s) [85.130198] [118/162] (914s left) kms_pipe_crc_basic (nonblocking-crc) [85.211560] Subtest nonblocking-crc: SKIP (0.000s) [85.253954] [119/162] (914s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [85.333201] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [85.376349] [120/162] (914s left) kms_pipe_crc_basic (read-crc) [85.457480] Subtest read-crc: SKIP (0.000s) [85.499230] [121/162] (914s left) kms_pipe_crc_basic (read-crc-frame-sequence) [85.587510] Subtest read-crc-frame-sequence: SKIP (0.000s) [85.630047] [122/162] (914s left) kms_pm_backlight (basic-brightness) [85.709014] Subtest basic-brightness: SKIP (0.000s) [85.752439] [123/162] (914s left) kms_pm_rpm (basic-pci-d3-state) [97.144992] Starting subtest: basic-pci-d3-state [97.317327] Subtest basic-pci-d3-state: SUCCESS (0.171s) [97.369793] [124/162] (902s left) kms_pm_rpm (basic-rte) [97.417877] Starting subtest: basic-rte [108.909406] Subtest basic-rte: SUCCESS (11.490s) [109.217609] [125/162] (891s left) kms_psr (psr-primary-page-flip) [109.298054] Subtest psr-primary-page-flip: SKIP (0.000s) [109.344876] [126/162] (891s left) kms_psr (psr-cursor-plane-move) [109.422677] Subtest psr-cursor-plane-move: SKIP (0.000s) [109.465959] [127/162] (890s left) kms_psr (psr-sprite-plane-onoff) [109.545572] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [109.590176] [128/162] (890s left) kms_psr (psr-primary-mmap-gtt) [109.667897] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [109.711317] [129/162] (890s left) kms_setmode (basic-clone-single-crtc) [109.764044] Starting subtest: basic-clone-single-crtc [109.773914] Subtest basic-clone-single-crtc: SKIP (0.000s) [109.821175] [130/162] (890s left) i915_pm_rps (basic-api) [109.874542] Starting subtest: basic-api [109.878549] Subtest basic-api: SUCCESS (0.003s) [109.928825] [131/162] (890s left) prime_self_import (basic-llseek-bad) [109.977558] Starting subtest: basic-llseek-bad [109.984075] Subtest basic-llseek-bad: SUCCESS (0.002s) [110.046096] [132/162] (890s left) prime_self_import (basic-llseek-size) [110.095423] Starting subtest: basic-llseek-size [110.101957] Subtest basic-llseek-size: SUCCESS (0.003s) [110.162150] [133/162] (890s left) prime_self_import (basic-with_fd_dup) [110.206659] Starting subtest: basic-with_fd_dup [110.213049] Subtest basic-with_fd_dup: SUCCESS (0.003s) [110.274367] [134/162] (890s left) prime_self_import (basic-with_one_bo) [110.319380] Starting subtest: basic-with_one_bo [110.325654] Subtest basic-with_one_bo: SUCCESS (0.002s) [110.369767] [135/162] (890s left) prime_self_import (basic-with_one_bo_two_files) [110.416153] Starting subtest: basic-with_one_bo_two_files [110.422473] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [110.485368] [136/162] (890s left) prime_self_import (basic-with_two_bos) [110.530743] Starting subtest: basic-with_two_bos [110.536756] Subtest basic-with_two_bos: SUCCESS (0.002s) [110.600100] [137/162] (890s left) prime_vgem (basic-fence-flip) [110.652356] Starting subtest: basic-fence-flip [110.690711] Subtest basic-fence-flip: SKIP (0.036s) [110.737545] [138/162] (890s left) prime_vgem (basic-fence-mmap) [110.789580] Starting subtest: basic-fence-mmap [110.811143] Subtest basic-fence-mmap: SUCCESS (0.022s) [110.881785] [139/162] (890s left) prime_vgem (basic-fence-read) [110.934145] Starting subtest: basic-fence-read [110.977361] Subtest basic-fence-read: SUCCESS (0.044s) [111.042310] [140/162] (889s left) prime_vgem (basic-gtt) [111.102576] Starting subtest: basic-gtt [111.108959] Subtest basic-gtt: SUCCESS (0.011s) [111.177053] [141/162] (889s left) prime_vgem (basic-read) [111.232747] Starting subtest: basic-read [111.251145] Subtest basic-read: SUCCESS (0.023s) [111.329191] [142/162] (889s left) prime_vgem (basic-write) [111.382262] Starting subtest: basic-write [111.401439] Subtest basic-write: SUCCESS (0.022s) [111.469956] [143/162] (889s left) vgem_basic (setversion) [111.523762] Starting subtest: setversion [111.530025] Subtest setversion: SUCCESS (0.000s) [111.576660] [144/162] (889s left) vgem_basic (create) [111.628855] Starting subtest: create [111.632186] Subtest create: SUCCESS (0.000s) [111.678350] [145/162] (889s left) vgem_basic (debugfs) [111.727773] Starting subtest: debugfs [111.731079] Subtest debugfs: SUCCESS (0.000s) [111.779366] [146/162] (889s left) vgem_basic (dmabuf-export) [111.829439] Starting subtest: dmabuf-export [111.836150] Subtest dmabuf-export: SUCCESS (0.002s) [111.898535] [147/162] (889s left) vgem_basic (dmabuf-fence) [111.980414] Starting subtest: dmabuf-fence [111.983708] Subtest dmabuf-fence: SUCCESS (0.001s) [112.044246] [148/162] (889s left) vgem_basic (dmabuf-fence-before) [112.096668] Starting subtest: dmabuf-fence-before [112.100161] Subtest dmabuf-fence-before: SUCCESS (0.000s) [112.150574] [149/162] (889s left) vgem_basic (dmabuf-mmap) [112.203945] Starting subtest: dmabuf-mmap [112.207286] Subtest dmabuf-mmap: SUCCESS (0.008s) [112.252055] [150/162] (889s left) vgem_basic (mmap) [112.300913] Starting subtest: mmap [112.303978] Subtest mmap: SUCCESS (0.005s) [112.348868] [151/162] (889s left) vgem_basic (second-client) [112.397904] Starting subtest: second-client [112.404179] Subtest second-client: SUCCESS (0.002s) [112.455540] [152/162] (889s left) vgem_basic (sysfs) [112.507511] Starting subtest: sysfs [112.510453] Subtest sysfs: SUCCESS (0.000s) [112.559965] [153/162] (889s left) core_hotunplug (unbind-rebind) [112.664779] Starting subtest: unbind-rebind [116.108753] Subtest unbind-rebind: SUCCESS (3.443s) [116.152859] [154/162] (885s left) vgem_basic (unload) [116.201880] Starting subtest: unload [145.065395] Subtest unload: SUCCESS (28.863s) [145.127537] [155/162] (856s left) i915_module_load (reload) [145.175067] Starting subtest: reload [147.583664] Subtest reload: SUCCESS (2.411s) [147.626771] [156/162] (854s left) gem_lmem_swapping (basic) [148.087231] Subtest basic: SKIP (0.000s) [148.499497] [157/162] (853s left) gem_lmem_swapping (parallel-random-engines) [148.921993] Subtest parallel-random-engines: SKIP (0.000s) [149.161605] [158/162] (853s left) gem_lmem_swapping (random-engines) [149.217441] Subtest random-engines: SKIP (0.000s) [149.260392] [159/162] (853s left) gem_lmem_swapping (verify-random) [149.308532] Subtest verify-random: SKIP (0.000s) [149.351610] [160/162] (853s left) i915_pm_rpm (module-reload) [160.641599] Starting subtest: module-reload [188.229355] Subtest module-reload: SUCCESS (27.585s) [188.275471] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [188.276814] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [188.280978] [161/162] (814s left) i915_selftest (live) [188.334221] Starting subtest: live [188.337516] Starting dynamic subtest: sanitycheck [190.388669] Dynamic subtest sanitycheck: SUCCESS (2.058s) [190.399172] Starting dynamic subtest: uncore [192.439719] Dynamic subtest uncore: SUCCESS (2.051s) [192.450390] Starting dynamic subtest: workarounds [194.695392] Dynamic subtest workarounds: SUCCESS (2.246s) [194.706794] Starting dynamic subtest: gt_engines [197.225464] Dynamic subtest gt_engines: SUCCESS (2.533s) [197.237489] Starting dynamic subtest: gt_timelines [205.930081] Dynamic subtest gt_timelines: SUCCESS (8.709s) [205.941309] Starting dynamic subtest: gt_contexts [208.116883] Dynamic subtest gt_contexts: SUCCESS (2.176s) [208.128018] Starting dynamic subtest: gt_lrc [212.618560] Dynamic subtest gt_lrc: SUCCESS (4.511s) [212.632840] Starting dynamic subtest: gt_mocs [214.848076] Dynamic subtest gt_mocs: SUCCESS (2.189s) [214.912222] Starting dynamic subtest: gt_pm [221.222581] Dynamic subtest gt_pm: SUCCESS (6.413s) [221.233199] Starting dynamic subtest: gt_heartbeat [223.280207] Dynamic subtest gt_heartbeat: SUCCESS (2.054s) [223.292240] Starting dynamic subtest: gt_tlb [226.511265] Dynamic subtest gt_tlb: SUCCESS (3.230s) [226.523399] Starting dynamic subtest: requests [234.782654] Dynamic subtest requests: SUCCESS (8.273s) [234.793454] Starting dynamic subtest: migrate [239.897633] Dynamic subtest migrate: SUCCESS (5.114s) [239.908236] Starting dynamic subtest: active [241.976643] Dynamic subtest active: SUCCESS (2.075s) [241.988171] Starting dynamic subtest: objects [244.595034] Dynamic subtest objects: SUCCESS (2.579s) [244.658921] Starting dynamic subtest: mman [249.736701] Dynamic subtest mman: SUCCESS (5.182s) [249.751228] Starting dynamic subtest: dmabuf [251.877256] Dynamic subtest dmabuf: SUCCESS (2.129s) [251.889220] Starting dynamic subtest: vma [253.930216] Dynamic subtest vma: SUCCESS (2.060s) [253.942307] Starting dynamic subtest: coherency [256.696895] Dynamic subtest coherency: SUCCESS (2.768s) [256.708073] Starting dynamic subtest: gtt [266.145665] Dynamic subtest gtt: SUCCESS (9.448s) [266.156614] Starting dynamic subtest: gem [268.355613] Dynamic subtest gem: SUCCESS (2.209s) [268.367050] Starting dynamic subtest: evict [271.563738] Dynamic subtest evict: SUCCESS (3.207s) [271.578386] Starting dynamic subtest: hugepages [280.087576] Dynamic subtest hugepages: SUCCESS (8.523s) [280.102468] Starting dynamic subtest: gem_contexts [294.752474] Dynamic subtest gem_contexts: SUCCESS (14.664s) [294.766626] Starting dynamic subtest: client [296.866997] Dynamic subtest client: SUCCESS (2.112s) [296.878503] Starting dynamic subtest: gem_migrate [298.908879] Dynamic subtest gem_migrate: SUCCESS (2.042s) [298.920743] Starting dynamic subtest: reset [301.162700] Dynamic subtest reset: SUCCESS (2.253s) [301.173382] Starting dynamic subtest: memory_region [303.211746] Dynamic subtest memory_region: SUCCESS (2.048s) [303.223074] Starting dynamic subtest: hangcheck [328.438432] Dynamic subtest hangcheck: SUCCESS (25.222s) [328.452367] Starting dynamic subtest: execlists [338.632843] Dynamic subtest execlists: SUCCESS (10.196s) [338.644068] Starting dynamic subtest: ring_submission [340.674290] Dynamic subtest ring_submission: SUCCESS (2.038s) [340.686198] Starting dynamic subtest: perf [342.809734] Dynamic subtest perf: SUCCESS (2.137s) [342.820850] Starting dynamic subtest: slpc [344.903893] Dynamic subtest slpc: SUCCESS (2.093s) [344.914919] Starting dynamic subtest: guc [346.966560] Dynamic subtest guc: SUCCESS (2.062s) [346.977686] Starting dynamic subtest: guc_multi_lrc [349.036627] Dynamic subtest guc_multi_lrc: SUCCESS (2.069s) [349.047818] Starting dynamic subtest: guc_hang [351.088928] Dynamic subtest guc_hang: SUCCESS (2.051s) [351.100091] Starting dynamic subtest: late_gt_pm [353.187401] Dynamic subtest late_gt_pm: SUCCESS (2.089s) [353.190502] Subtest live: SUCCESS (164.842s) [353.226106] [162/162] (649s left) dmabuf (all-tests) [353.285879] Starting subtest: all-tests [353.288933] Starting dynamic subtest: sanitycheck [353.353036] Dynamic subtest sanitycheck: SUCCESS (0.066s) [353.365224] Starting dynamic subtest: dma_fence [353.526244] Dynamic subtest dma_fence: SUCCESS (0.169s) [353.540333] Starting dynamic subtest: dma_fence_chain [364.488988] Dynamic subtest dma_fence_chain: SUCCESS (10.963s) [364.503314] Starting dynamic subtest: dma_fence_unwrap [364.556918] Dynamic subtest dma_fence_unwrap: SUCCESS (0.065s) [364.568980] Starting dynamic subtest: dma_resv [364.624771] Dynamic subtest dma_resv: SUCCESS (0.065s) [364.628061] Subtest all-tests: SUCCESS (11.341s) [364.661333] 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.