[88.286642] Initializing watchdogs [88.286833] /dev/watchdog0 [88.298487] [001/170] (960s left) i915_module_load (load) [88.474395] Starting subtest: load [91.147420] Subtest load: SUCCESS (2.674s) [91.183846] [002/170] (957s left) core_auth (basic-auth) [91.402840] Starting subtest: basic-auth [91.405901] Subtest basic-auth: SUCCESS (0.002s) [91.492278] [003/170] (957s left) debugfs_test (read_all_entries) [91.643789] Starting subtest: read_all_entries [91.711718] Subtest read_all_entries: SUCCESS (0.068s) [91.824449] [004/170] (957s left) debugfs_test (basic-hwmon) [91.969198] Starting subtest: basic-hwmon [91.971463] Subtest basic-hwmon: SKIP (0.000s) [92.075456] [005/170] (956s left) fbdev (eof) [92.228588] Starting subtest: eof [92.229861] Subtest eof: SUCCESS (0.000s) [92.293172] [006/170] (956s left) fbdev (info) [92.430234] Starting subtest: info [92.431567] Subtest info: SUCCESS (0.000s) [92.510308] [007/170] (956s left) fbdev (nullptr) [92.661455] Starting subtest: nullptr [92.662680] Subtest nullptr: SUCCESS (0.000s) [92.727919] [008/170] (956s left) fbdev (read) [92.878323] Starting subtest: read [99.999257] Subtest read: SUCCESS (7.087s) [100.044585] [009/170] (948s left) fbdev (write) [100.195690] Starting subtest: write [103.978902] Subtest write: SUCCESS (3.749s) [104.027063] [010/170] (944s left) gem_basic (bad-close) [104.164542] Starting subtest: bad-close [104.166773] Subtest bad-close: SUCCESS (0.000s) [104.242225] [011/170] (944s left) gem_basic (create-close) [104.379601] Starting subtest: create-close [104.381666] Subtest create-close: SUCCESS (0.000s) [104.475616] [012/170] (944s left) gem_basic (create-fd-close) [104.614550] Starting subtest: create-fd-close [104.616579] Subtest create-fd-close: SUCCESS (0.000s) [104.709437] [013/170] (944s left) gem_busy (busy@all-engines) [104.865910] Starting subtest: busy [104.867157] Starting dynamic subtest: all-engines [104.922816] Dynamic subtest all-engines: SUCCESS (0.057s) [104.924235] Subtest busy: SUCCESS (0.057s) [105.311103] [014/170] (943s left) gem_close_race (basic-process) [105.471496] Starting subtest: basic-process [105.548996] Subtest basic-process: SUCCESS (0.077s) [105.745203] [015/170] (943s left) gem_close_race (basic-threads) [105.896247] Starting subtest: basic-threads [107.074484] Subtest basic-threads: SUCCESS (1.178s) [107.294719] [016/170] (941s left) gem_ctx_create (basic) [107.463058] Starting subtest: basic [107.464264] Subtest basic: SUCCESS (0.000s) [107.661476] [017/170] (941s left) gem_ctx_create (basic-files) [107.816356] Starting subtest: basic-files [109.840479] Subtest basic-files: SUCCESS (2.024s) [110.047924] [018/170] (939s left) gem_ctx_exec (basic) [110.206409] Starting subtest: basic [110.210686] Subtest basic: SUCCESS (0.005s) [110.325307] [019/170] (938s left) gem_exec_basic (basic) [110.483710] Starting subtest: basic [110.484911] Starting dynamic subtest: rcs0-smem [110.486138] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [110.497344] Starting dynamic subtest: bcs0-smem [110.498552] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [110.508541] Starting dynamic subtest: vcs0-smem [110.509773] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [110.519790] Starting dynamic subtest: vecs0-smem [110.521083] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [110.522330] Subtest basic: SUCCESS (0.006s) [110.693651] [020/170] (938s left) gem_exec_create (basic) [110.859253] Starting subtest: basic [110.860404] Starting dynamic subtest: smem [112.927462] Dynamic subtest smem: SUCCESS (2.055s) [112.928787] Subtest basic: SUCCESS (2.055s) [113.139520] [021/170] (936s left) gem_exec_fence (basic-busy) [113.453260] Starting subtest: basic-busy [113.454656] Starting dynamic subtest: rcs0 [113.474971] Dynamic subtest rcs0: SUCCESS (0.030s) [113.486831] Starting dynamic subtest: bcs0 [113.501998] Dynamic subtest bcs0: SUCCESS (0.027s) [113.512761] Starting dynamic subtest: vcs0 [113.523381] Dynamic subtest vcs0: SUCCESS (0.022s) [113.534295] Starting dynamic subtest: vecs0 [113.547950] Dynamic subtest vecs0: SUCCESS (0.024s) [113.549296] Subtest basic-busy: SUCCESS (0.104s) [114.161356] [022/170] (935s left) gem_exec_fence (basic-wait) [114.462210] Starting subtest: basic-wait [114.463583] Starting dynamic subtest: rcs0 [114.494481] Dynamic subtest rcs0: SUCCESS (0.040s) [114.511414] Starting dynamic subtest: bcs0 [114.524375] Dynamic subtest bcs0: SUCCESS (0.030s) [114.535892] Starting dynamic subtest: vcs0 [114.547882] Dynamic subtest vcs0: SUCCESS (0.024s) [114.559022] Starting dynamic subtest: vecs0 [114.572706] Dynamic subtest vecs0: SUCCESS (0.025s) [114.574057] Subtest basic-wait: SUCCESS (0.119s) [115.111613] [023/170] (934s left) gem_exec_fence (basic-await) [115.411990] Starting subtest: basic-await [115.413124] Starting dynamic subtest: rcs0 [115.506359] Dynamic subtest rcs0: SUCCESS (0.102s) [115.532518] Starting dynamic subtest: bcs0 [115.645992] Dynamic subtest bcs0: SUCCESS (0.131s) [115.670957] Starting dynamic subtest: vcs0 [115.764044] Dynamic subtest vcs0: SUCCESS (0.126s) [115.791423] Starting dynamic subtest: vecs0 [115.902885] Dynamic subtest vecs0: SUCCESS (0.129s) [115.905116] Subtest basic-await: SUCCESS (0.490s) [116.495042] [024/170] (932s left) gem_exec_fence (nb-await) [116.796997] Starting subtest: nb-await [116.798105] Starting dynamic subtest: rcs0 [116.855279] Dynamic subtest rcs0: SUCCESS (0.065s) [116.873554] Starting dynamic subtest: bcs0 [116.924214] Dynamic subtest bcs0: SUCCESS (0.069s) [116.948531] Starting dynamic subtest: vcs0 [116.999603] Dynamic subtest vcs0: SUCCESS (0.075s) [117.036881] Starting dynamic subtest: vecs0 [117.079331] Dynamic subtest vecs0: SUCCESS (0.080s) [117.080645] Subtest nb-await: SUCCESS (0.291s) [117.628489] [025/170] (931s left) gem_exec_gttfill (basic) [117.774860] Starting subtest: basic [125.268203] Subtest basic: SUCCESS (7.485s) [125.448405] [026/170] (923s left) gem_exec_parallel (engines) [125.678697] Starting subtest: engines [125.679811] Starting dynamic subtest: basic [128.055237] Dynamic subtest basic: SUCCESS (2.356s) [128.067997] Starting dynamic subtest: contexts [131.596682] Dynamic subtest contexts: SUCCESS (3.553s) [131.609742] Starting dynamic subtest: fds [136.537398] Dynamic subtest fds: SUCCESS (4.949s) [136.552838] Starting dynamic subtest: userptr [139.098213] Dynamic subtest userptr: SUCCESS (2.530s) [139.100142] Subtest engines: SUCCESS (13.388s) [139.266581] [027/170] (910s left) gem_exec_store (basic) [139.420346] Starting subtest: basic [139.478986] Subtest basic: SUCCESS (0.058s) [139.680503] [028/170] (909s left) gem_flink_basic (bad-flink) [139.815835] Starting subtest: bad-flink [139.817063] Subtest bad-flink: SUCCESS (0.000s) [139.895758] [029/170] (909s left) gem_flink_basic (bad-open) [140.032733] Starting subtest: bad-open [140.033942] Subtest bad-open: SUCCESS (0.000s) [140.112217] [030/170] (909s left) gem_flink_basic (basic) [140.249621] Starting subtest: basic [140.250689] Subtest basic: SUCCESS (0.000s) [140.345465] [031/170] (909s left) gem_flink_basic (double-flink) [140.482146] Starting subtest: double-flink [140.483259] Subtest double-flink: SUCCESS (0.000s) [140.579613] [032/170] (908s left) gem_flink_basic (flink-lifetime) [140.716527] Starting subtest: flink-lifetime [140.719187] Subtest flink-lifetime: SUCCESS (0.002s) [140.829619] [033/170] (908s left) gem_huc_copy (huc-copy) [140.971425] Starting subtest: huc-copy [140.973763] Subtest huc-copy: SKIP (0.000s) [141.096038] [034/170] (908s left) gem_linear_blits (basic) [141.408312] Starting subtest: basic [141.420928] Subtest basic: SUCCESS (0.013s) [141.547943] [035/170] (908s left) gem_mmap (basic) [141.743535] Starting subtest: basic [141.749013] Subtest basic: SUCCESS (0.001s) [141.846253] [036/170] (907s left) gem_mmap_gtt (basic) [141.986494] Starting subtest: basic [141.987650] Subtest basic: SUCCESS (0.001s) [142.061578] [037/170] (907s left) gem_render_linear_blits (basic) [142.202438] Starting subtest: basic [142.252280] Subtest basic: SUCCESS (0.049s) [142.310826] [038/170] (907s left) gem_render_tiled_blits (basic) [142.454438] Starting subtest: basic [142.514439] Subtest basic: SUCCESS (0.060s) [142.598697] [039/170] (907s left) gem_ringfill (basic-all) [142.879877] Starting subtest: basic-all [144.124069] Subtest basic-all: SUCCESS (1.236s) [144.198134] [040/170] (905s left) gem_softpin (allocator-basic) [144.343434] Starting subtest: allocator-basic [144.511127] Subtest allocator-basic: SUCCESS (0.159s) [144.630937] [041/170] (905s left) gem_softpin (allocator-basic-reserve) [144.773777] Starting subtest: allocator-basic-reserve [144.939824] Subtest allocator-basic-reserve: SUCCESS (0.157s) [145.049336] [042/170] (904s left) gem_softpin (safe-alignment) [145.201564] Starting subtest: safe-alignment [145.221728] Subtest safe-alignment: SUCCESS (0.020s) [145.346190] [043/170] (904s left) gem_sync (basic-all) [145.499291] Starting subtest: basic-all [147.723443] Subtest basic-all: SUCCESS (2.209s) [147.913246] [044/170] (901s left) gem_sync (basic-each) [148.067390] Starting subtest: basic-each [150.372208] Subtest basic-each: SUCCESS (2.304s) [150.586963] [045/170] (899s left) gem_tiled_blits (basic) [150.885253] Starting subtest: basic [150.912881] Subtest basic: SUCCESS (0.028s) [151.031362] [046/170] (898s left) gem_tiled_fence_blits (basic) [151.403876] Starting subtest: basic [151.430642] Subtest basic: SUCCESS (0.027s) [151.560696] [047/170] (898s left) gem_tiled_pread_basic [152.096757] [048/170] (897s left) gem_wait (busy@all-engines) [152.261649] Starting subtest: busy [152.262831] Starting dynamic subtest: all-engines [152.791437] Dynamic subtest all-engines: SUCCESS (0.530s) [152.792519] Subtest busy: SUCCESS (0.530s) [153.030448] [049/170] (896s left) gem_wait (wait@all-engines) [153.193488] Starting subtest: wait [153.194493] Starting dynamic subtest: all-engines [154.232550] Dynamic subtest all-engines: SUCCESS (1.040s) [154.233729] Subtest wait: SUCCESS (1.040s) [154.480833] [050/170] (895s left) i915_getparams_basic (basic-eu-total) [154.620701] Starting subtest: basic-eu-total [154.622878] Subtest basic-eu-total: SUCCESS (0.000s) [154.696108] [051/170] (895s left) i915_getparams_basic (basic-subslice-total) [154.831176] Starting subtest: basic-subslice-total [154.833299] Subtest basic-subslice-total: SUCCESS (0.000s) [154.912554] [052/170] (895s left) i915_hangman (error-state-basic) [155.064505] Starting subtest: error-state-basic [155.075044] Subtest error-state-basic: SUCCESS (0.011s) [155.163362] [053/170] (894s left) i915_pciid [155.379562] [054/170] (894s left) kms_addfb_basic (addfb25-bad-modifier) [155.520212] Starting subtest: addfb25-bad-modifier [155.521241] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [155.645759] [055/170] (894s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [155.783815] Starting subtest: addfb25-framebuffer-vs-set-tiling [155.785077] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [155.913396] [056/170] (894s left) kms_addfb_basic (addfb25-modifier-no-flag) [156.051978] Starting subtest: addfb25-modifier-no-flag [156.053091] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [156.179582] [057/170] (894s left) kms_addfb_basic (addfb25-x-tiled-legacy) [156.318073] Starting subtest: addfb25-x-tiled-legacy [156.319115] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [156.446282] [058/170] (893s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [156.584477] Starting subtest: addfb25-x-tiled-mismatch-legacy [156.585536] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [156.712990] [059/170] (893s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [156.879977] Starting subtest: addfb25-yf-tiled-legacy [156.881114] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [156.979278] [060/170] (893s left) kms_addfb_basic (addfb25-y-tiled-legacy) [157.145126] Starting subtest: addfb25-y-tiled-legacy [157.146218] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [157.229332] [061/170] (893s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [157.395643] Starting subtest: addfb25-y-tiled-small-legacy [157.396835] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [157.478966] [062/170] (892s left) kms_addfb_basic (bad-pitch-0) [157.616420] Starting subtest: bad-pitch-0 [157.617455] Subtest bad-pitch-0: SUCCESS (0.000s) [157.729040] [063/170] (892s left) kms_addfb_basic (bad-pitch-1024) [157.865531] Starting subtest: bad-pitch-1024 [157.866625] Subtest bad-pitch-1024: SUCCESS (0.000s) [157.996220] [064/170] (892s left) kms_addfb_basic (bad-pitch-128) [158.132782] Starting subtest: bad-pitch-128 [158.134114] Subtest bad-pitch-128: SUCCESS (0.000s) [158.245521] [065/170] (892s left) kms_addfb_basic (bad-pitch-256) [158.383464] Starting subtest: bad-pitch-256 [158.384488] Subtest bad-pitch-256: SUCCESS (0.000s) [158.495789] [066/170] (891s left) kms_addfb_basic (bad-pitch-32) [158.633878] Starting subtest: bad-pitch-32 [158.635729] Subtest bad-pitch-32: SUCCESS (0.000s) [158.762883] [067/170] (891s left) kms_addfb_basic (bad-pitch-63) [158.900744] Starting subtest: bad-pitch-63 [158.901877] Subtest bad-pitch-63: SUCCESS (0.000s) [159.029470] [068/170] (891s left) kms_addfb_basic (bad-pitch-65536) [159.166470] Starting subtest: bad-pitch-65536 [159.167582] Subtest bad-pitch-65536: SUCCESS (0.000s) [159.296188] [069/170] (891s left) kms_addfb_basic (bad-pitch-999) [159.432568] Starting subtest: bad-pitch-999 [159.433688] Subtest bad-pitch-999: SUCCESS (0.000s) [159.562869] [070/170] (891s left) kms_addfb_basic (basic) [159.700656] Starting subtest: basic [159.701792] Subtest basic: SUCCESS (0.000s) [159.829325] [071/170] (890s left) kms_addfb_basic (basic-x-tiled-legacy) [159.966770] Starting subtest: basic-x-tiled-legacy [159.967803] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [160.096542] [072/170] (890s left) kms_addfb_basic (basic-y-tiled-legacy) [160.234680] Starting subtest: basic-y-tiled-legacy [160.235811] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [160.362599] [073/170] (890s left) kms_addfb_basic (bo-too-small) [160.530413] Starting subtest: bo-too-small [160.531603] Subtest bo-too-small: SUCCESS (0.000s) [160.629887] [074/170] (890s left) kms_addfb_basic (bo-too-small-due-to-tiling) [160.795578] Starting subtest: bo-too-small-due-to-tiling [160.796737] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [160.896244] [075/170] (889s left) kms_addfb_basic (clobberred-modifier) [161.033476] Starting subtest: clobberred-modifier [161.034519] Subtest clobberred-modifier: SUCCESS (0.000s) [161.162817] [076/170] (889s left) kms_addfb_basic (framebuffer-vs-set-tiling) [161.301491] Starting subtest: framebuffer-vs-set-tiling [161.302600] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [161.452277] [077/170] (889s left) kms_addfb_basic (invalid-get-prop) [161.589954] Starting subtest: invalid-get-prop [161.591116] Subtest invalid-get-prop: SUCCESS (0.000s) [161.712367] [078/170] (889s left) kms_addfb_basic (invalid-get-prop-any) [161.848542] Starting subtest: invalid-get-prop-any [161.849834] Subtest invalid-get-prop-any: SUCCESS (0.000s) [161.980364] [079/170] (888s left) kms_addfb_basic (invalid-set-prop) [162.118516] Starting subtest: invalid-set-prop [162.119550] Subtest invalid-set-prop: SUCCESS (0.000s) [162.246059] [080/170] (888s left) kms_addfb_basic (invalid-set-prop-any) [162.383469] Starting subtest: invalid-set-prop-any [162.384566] Subtest invalid-set-prop-any: SUCCESS (0.000s) [162.512529] [081/170] (888s left) kms_addfb_basic (no-handle) [162.657706] Starting subtest: no-handle [162.658817] Subtest no-handle: SUCCESS (0.000s) [162.779479] [082/170] (888s left) kms_addfb_basic (size-max) [162.944225] Starting subtest: size-max [162.945373] Subtest size-max: SUCCESS (0.000s) [163.046239] [083/170] (887s left) kms_addfb_basic (small-bo) [163.211972] Starting subtest: small-bo [163.213324] Subtest small-bo: SUCCESS (0.000s) [163.313061] [084/170] (887s left) kms_addfb_basic (tile-pitch-mismatch) [163.451976] Starting subtest: tile-pitch-mismatch [163.453208] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [163.579851] [085/170] (887s left) kms_addfb_basic (too-high) [163.744253] Starting subtest: too-high [163.745407] Subtest too-high: SUCCESS (0.001s) [163.845796] [086/170] (887s left) kms_addfb_basic (too-wide) [164.011475] Starting subtest: too-wide [164.012646] Subtest too-wide: SUCCESS (0.000s) [164.113068] [087/170] (886s left) kms_addfb_basic (unused-handle) [164.249701] Starting subtest: unused-handle [164.250843] Subtest unused-handle: SUCCESS (0.000s) [164.381540] [088/170] (886s left) kms_addfb_basic (unused-modifier) [164.518702] Starting subtest: unused-modifier [164.519811] Subtest unused-modifier: SUCCESS (0.000s) [164.646810] [089/170] (886s left) kms_addfb_basic (unused-offsets) [164.785543] Starting subtest: unused-offsets [164.786589] Subtest unused-offsets: SUCCESS (0.000s) [164.914896] [090/170] (886s left) kms_addfb_basic (unused-pitches) [165.052656] Starting subtest: unused-pitches [165.053733] Subtest unused-pitches: SUCCESS (0.000s) [165.179768] [091/170] (885s left) kms_busy (basic) [165.358389] Starting subtest: basic [165.360631] Starting dynamic subtest: flip [166.347519] Dynamic subtest flip: SUCCESS (0.986s) [166.363569] Starting dynamic subtest: modeset [170.229844] Dynamic subtest modeset: SUCCESS (3.880s) [170.230904] Subtest basic: SUCCESS (4.869s) [171.199240] [092/170] (879s left) kms_chamelium_hpd (dp-hpd-fast) [171.683323] Subtest dp-hpd-fast: SKIP (0.000s) [172.552513] [093/170] (878s left) kms_chamelium_edid (dp-edid-read) [173.036375] Subtest dp-edid-read: SKIP (0.000s) [173.896179] [094/170] (877s left) kms_chamelium_frames (dp-crc-fast) [174.380292] Subtest dp-crc-fast: SKIP (0.000s) [175.239807] [095/170] (876s left) kms_chamelium_hpd (hdmi-hpd-fast) [175.723699] Subtest hdmi-hpd-fast: SKIP (0.000s) [176.582580] [096/170] (874s left) kms_chamelium_edid (hdmi-edid-read) [177.065736] Subtest hdmi-edid-read: SKIP (0.000s) [177.927175] [097/170] (873s left) kms_chamelium_frames (hdmi-crc-fast) [178.411879] Subtest hdmi-crc-fast: SKIP (0.000s) [179.299204] [098/170] (872s left) kms_chamelium_hpd (vga-hpd-fast) [179.784485] Subtest vga-hpd-fast: SKIP (0.000s) [180.681380] [099/170] (870s left) kms_chamelium_edid (vga-edid-read) [181.163072] Subtest vga-edid-read: SKIP (0.000s) [182.024079] [100/170] (869s left) kms_prop_blob (basic) [182.162538] Starting subtest: basic [182.163647] Subtest basic: SUCCESS (0.000s) [182.245087] [101/170] (869s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [182.412328] Starting subtest: basic-busy-flip-before-cursor-atomic [182.414352] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [182.491109] [102/170] (868s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [182.658706] Starting subtest: basic-busy-flip-before-cursor-legacy [182.660721] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [182.741207] [103/170] (868s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [182.905550] Starting subtest: basic-flip-after-cursor-atomic [184.193109] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.286s) [185.151859] [104/170] (866s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [185.318096] Starting subtest: basic-flip-after-cursor-legacy [186.607149] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.290s) [187.580657] [105/170] (863s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [187.746384] Starting subtest: basic-flip-after-cursor-varying-size [189.041508] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.296s) [190.013254] [106/170] (861s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [190.178457] Starting subtest: basic-flip-before-cursor-atomic [191.472348] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.293s) [192.443749] [107/170] (859s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [192.621206] Starting subtest: basic-flip-before-cursor-legacy [193.906777] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.285s) [194.875524] [108/170] (856s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [195.041662] Starting subtest: basic-flip-before-cursor-varying-size [196.321213] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.280s) [197.254546] [109/170] (854s left) kms_flip (basic-flip-vs-dpms) [197.402059] Starting subtest: basic-flip-vs-dpms [197.404846] Starting dynamic subtest: A-eDP1 [200.249651] Dynamic subtest A-eDP1: SUCCESS (2.845s) [200.265851] Starting dynamic subtest: B-eDP1 [202.598988] Dynamic subtest B-eDP1: SUCCESS (2.348s) [202.615912] Starting dynamic subtest: C-eDP1 [204.968555] Dynamic subtest C-eDP1: SUCCESS (2.369s) [204.977134] Subtest basic-flip-vs-dpms: SUCCESS (7.570s) [205.884861] [110/170] (845s left) kms_flip (basic-flip-vs-modeset) [206.029265] Starting subtest: basic-flip-vs-modeset [206.033107] Starting dynamic subtest: A-eDP1 [208.886084] Dynamic subtest A-eDP1: SUCCESS (2.851s) [208.901955] Starting dynamic subtest: B-eDP1 [211.251036] Dynamic subtest B-eDP1: SUCCESS (2.365s) [211.269874] Starting dynamic subtest: C-eDP1 [213.602762] Dynamic subtest C-eDP1: SUCCESS (2.352s) [213.605240] Subtest basic-flip-vs-modeset: SUCCESS (7.576s) [214.533948] [111/170] (837s left) kms_flip (basic-flip-vs-wf_vblank) [214.679985] Starting subtest: basic-flip-vs-wf_vblank [214.682995] Starting dynamic subtest: A-eDP1 [216.991399] Dynamic subtest A-eDP1: SUCCESS (2.309s) [217.007370] Starting dynamic subtest: B-eDP1 [219.274437] Dynamic subtest B-eDP1: SUCCESS (2.282s) [219.290920] Starting dynamic subtest: C-eDP1 [221.514872] Dynamic subtest C-eDP1: SUCCESS (2.240s) [221.517407] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.839s) [222.779298] [112/170] (828s left) kms_flip (basic-plain-flip) [222.923357] Starting subtest: basic-plain-flip [222.927065] Starting dynamic subtest: A-eDP1 [224.961167] Dynamic subtest A-eDP1: SUCCESS (2.034s) [224.977119] Starting dynamic subtest: B-eDP1 [226.927259] Dynamic subtest B-eDP1: SUCCESS (1.965s) [226.943421] Starting dynamic subtest: C-eDP1 [228.912216] Dynamic subtest C-eDP1: SUCCESS (1.984s) [228.914699] Subtest basic-plain-flip: SUCCESS (5.992s) [230.205542] [113/170] (821s left) kms_force_connector_basic (force-connector-state) [230.349040] Starting subtest: force-connector-state [232.053751] Subtest force-connector-state: SUCCESS (1.703s) [232.660652] [114/170] (819s left) kms_force_connector_basic (force-edid) [232.803459] Starting subtest: force-edid [233.056665] Subtest force-edid: SUCCESS (0.252s) [233.177379] [115/170] (818s left) kms_force_connector_basic (force-load-detect) [233.319387] Starting subtest: force-load-detect [233.321817] Subtest force-load-detect: SKIP (0.000s) [233.443972] [116/170] (818s left) kms_force_connector_basic (prune-stale-modes) [233.587563] Starting subtest: prune-stale-modes [233.896127] Subtest prune-stale-modes: SUCCESS (0.305s) [234.027382] [117/170] (817s left) kms_frontbuffer_tracking (basic) [234.204156] Starting subtest: basic [237.510214] Subtest basic: SUCCESS (3.306s) [237.612339] [118/170] (814s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [237.785837] Starting subtest: compare-crc-sanitycheck [237.788811] Starting dynamic subtest: pipe-A-eDP-1 [238.473236] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.685s) [238.492604] Starting dynamic subtest: pipe-B-eDP-1 [239.841652] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.363s) [239.860264] Starting dynamic subtest: pipe-C-eDP-1 [241.381919] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.535s) [241.387974] Subtest compare-crc-sanitycheck: SUCCESS (3.596s) [242.294325] [119/170] (809s left) kms_pipe_crc_basic (hang-read-crc) [242.477107] Starting subtest: hang-read-crc [242.480114] Starting dynamic subtest: pipe-A-eDP-1 [244.792449] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.313s) [244.810516] Starting dynamic subtest: pipe-B-eDP-1 [247.764446] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.969s) [247.783506] Starting dynamic subtest: pipe-C-eDP-1 [251.059495] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.290s) [251.060583] Subtest hang-read-crc: SUCCESS (8.584s) [252.021959] [120/170] (799s left) kms_pipe_crc_basic (nonblocking-crc) [252.191731] Starting subtest: nonblocking-crc [252.194816] Starting dynamic subtest: pipe-A-eDP-1 [253.048051] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.853s) [253.068780] Starting dynamic subtest: pipe-B-eDP-1 [254.610797] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.558s) [254.630144] Starting dynamic subtest: pipe-C-eDP-1 [256.321459] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.706s) [256.322525] Subtest nonblocking-crc: SUCCESS (4.130s) [257.270035] [121/170] (794s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [257.437515] Starting subtest: nonblocking-crc-frame-sequence [257.440548] Starting dynamic subtest: pipe-A-eDP-1 [258.297075] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.856s) [258.315385] Starting dynamic subtest: pipe-B-eDP-1 [259.872950] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.571s) [259.891240] Starting dynamic subtest: pipe-C-eDP-1 [261.579300] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.702s) [261.580415] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.142s) [262.517766] [122/170] (789s left) kms_pipe_crc_basic (read-crc) [262.686378] Starting subtest: read-crc [262.689458] Starting dynamic subtest: pipe-A-eDP-1 [263.477829] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.787s) [263.496073] Starting dynamic subtest: pipe-B-eDP-1 [264.964392] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.482s) [264.984254] Starting dynamic subtest: pipe-C-eDP-1 [266.606118] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.636s) [266.607283] Subtest read-crc: SUCCESS (3.919s) [267.573350] [123/170] (784s left) kms_pipe_crc_basic (read-crc-frame-sequence) [267.744165] Starting subtest: read-crc-frame-sequence [267.747208] Starting dynamic subtest: pipe-A-eDP-1 [268.534125] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.787s) [268.552986] Starting dynamic subtest: pipe-B-eDP-1 [270.021379] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.482s) [270.039860] Starting dynamic subtest: pipe-C-eDP-1 [271.658701] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.631s) [271.659790] Subtest read-crc-frame-sequence: SUCCESS (3.914s) [272.591044] [124/170] (779s left) kms_psr (primary_page_flip) [272.762978] Starting subtest: primary_page_flip [276.989554] Subtest primary_page_flip: SUCCESS (4.228s) [277.941948] [125/170] (774s left) kms_psr (cursor_plane_move) [278.112565] Starting subtest: cursor_plane_move [282.265224] Subtest cursor_plane_move: SUCCESS (4.153s) [283.189979] [126/170] (768s left) kms_psr (sprite_plane_onoff) [283.359398] Starting subtest: sprite_plane_onoff [287.651646] Subtest sprite_plane_onoff: SUCCESS (4.278s) [288.566122] [127/170] (763s left) kms_psr (primary_mmap_gtt) [288.735644] Starting subtest: primary_mmap_gtt [292.907749] Subtest primary_mmap_gtt: SUCCESS (4.170s) [293.877100] [128/170] (758s left) kms_setmode (basic-clone-single-crtc) [294.021608] Starting subtest: basic-clone-single-crtc [294.024824] Subtest basic-clone-single-crtc: SKIP (0.000s) [294.110044] [129/170] (758s left) i915_pm_backlight (basic-brightness) [294.282134] Starting subtest: basic-brightness [294.400936] Starting dynamic subtest: eDP-1 [294.938492] Dynamic subtest eDP-1: SUCCESS (0.545s) [294.939757] Subtest basic-brightness: SUCCESS (0.658s) [295.863038] [130/170] (756s left) i915_pm_rpm (basic-pci-d3-state) [297.753880] Starting subtest: basic-pci-d3-state [302.164735] Subtest basic-pci-d3-state: SUCCESS (4.407s) [302.329118] [131/170] (749s left) i915_pm_rpm (basic-rte) [302.466051] Starting subtest: basic-rte [308.624544] Subtest basic-rte: SUCCESS (6.158s) [310.093421] [132/170] (742s left) i915_pm_rps (basic-api) [310.240277] Starting subtest: basic-api [310.244363] Subtest basic-api: SUCCESS (0.004s) [310.325743] [133/170] (741s left) prime_self_import (basic-llseek-bad) [310.463141] Starting subtest: basic-llseek-bad [310.467690] Subtest basic-llseek-bad: SUCCESS (0.003s) [310.558492] [134/170] (741s left) prime_self_import (basic-llseek-size) [310.695963] Starting subtest: basic-llseek-size [310.700524] Subtest basic-llseek-size: SUCCESS (0.004s) [310.808645] [135/170] (741s left) prime_self_import (basic-with_fd_dup) [310.945816] Starting subtest: basic-with_fd_dup [310.950447] Subtest basic-with_fd_dup: SUCCESS (0.004s) [311.058162] [136/170] (741s left) prime_self_import (basic-with_one_bo) [311.194499] Starting subtest: basic-with_one_bo [311.199427] Subtest basic-with_one_bo: SUCCESS (0.005s) [311.276138] [137/170] (741s left) prime_self_import (basic-with_one_bo_two_files) [311.413377] Starting subtest: basic-with_one_bo_two_files [311.417811] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [311.514566] [138/170] (740s left) prime_self_import (basic-with_two_bos) [311.651982] Starting subtest: basic-with_two_bos [311.656749] Subtest basic-with_two_bos: SUCCESS (0.004s) [311.764620] [139/170] (740s left) prime_vgem (basic-fence-flip) [311.913392] Starting subtest: basic-fence-flip [312.437912] Subtest basic-fence-flip: SUCCESS (0.524s) [312.564566] [140/170] (739s left) prime_vgem (basic-fence-mmap) [312.713402] Starting subtest: basic-fence-mmap [312.761628] Subtest basic-fence-mmap: SUCCESS (0.048s) [312.864310] [141/170] (739s left) prime_vgem (basic-fence-read) [313.013599] Starting subtest: basic-fence-read [313.086424] Subtest basic-fence-read: SUCCESS (0.072s) [313.182199] [142/170] (739s left) prime_vgem (basic-gtt) [313.329796] Starting subtest: basic-gtt [313.352761] Subtest basic-gtt: SUCCESS (0.023s) [313.455295] [143/170] (739s left) prime_vgem (basic-read) [313.620387] Starting subtest: basic-read [313.655357] Subtest basic-read: SUCCESS (0.035s) [313.747876] [144/170] (738s left) prime_vgem (basic-write) [313.896367] Starting subtest: basic-write [313.938457] Subtest basic-write: SUCCESS (0.042s) [314.030541] [145/170] (738s left) vgem_basic (setversion) [314.172467] Starting subtest: setversion [314.174767] Subtest setversion: SUCCESS (0.000s) [314.247596] [146/170] (738s left) vgem_basic (create) [314.389135] Starting subtest: create [314.390236] Subtest create: SUCCESS (0.000s) [314.464618] [147/170] (738s left) vgem_basic (debugfs) [314.605742] Starting subtest: debugfs [314.606892] Subtest debugfs: SUCCESS (0.001s) [314.679689] [148/170] (738s left) vgem_basic (dmabuf-export) [314.822321] Starting subtest: dmabuf-export [314.832181] Subtest dmabuf-export: SUCCESS (0.008s) [314.930562] [149/170] (737s left) vgem_basic (dmabuf-fence) [315.072483] Starting subtest: dmabuf-fence [315.073721] Subtest dmabuf-fence: SUCCESS (0.001s) [315.148630] [150/170] (737s left) vgem_basic (dmabuf-fence-before) [315.309274] Starting subtest: dmabuf-fence-before [315.310421] Subtest dmabuf-fence-before: SUCCESS (0.000s) [315.377415] [151/170] (737s left) vgem_basic (dmabuf-mmap) [315.524967] Starting subtest: dmabuf-mmap [315.549262] Subtest dmabuf-mmap: SUCCESS (0.026s) [315.627080] [152/170] (737s left) vgem_basic (mmap) [315.774478] Starting subtest: mmap [315.790045] Subtest mmap: SUCCESS (0.017s) [315.860831] [153/170] (737s left) vgem_basic (second-client) [316.008701] Starting subtest: second-client [316.057386] Subtest second-client: SUCCESS (0.049s) [316.126625] [154/170] (736s left) vgem_basic (sysfs) [316.275170] Starting subtest: sysfs [316.276214] Subtest sysfs: SUCCESS (0.001s) [316.343645] [155/170] (736s left) core_hotunplug (unbind-rebind) [316.524270] Starting subtest: unbind-rebind [318.957654] Subtest unbind-rebind: SUCCESS (2.431s) [318.993660] [156/170] (734s left) vgem_basic (unload) [319.134360] Starting subtest: unload [348.152180] Subtest unload: SUCCESS (28.983s) [348.261904] [157/170] (704s left) i915_module_load (reload) [348.401259] Starting subtest: reload [351.868346] Subtest reload: SUCCESS (3.469s) [351.898191] [158/170] (701s left) gem_lmem_swapping (basic) [352.058375] Subtest basic: SKIP (0.000s) [352.102944] [159/170] (700s left) gem_lmem_swapping (parallel-random-engines) [352.246274] Subtest parallel-random-engines: SKIP (0.000s) [352.302774] [160/170] (700s left) gem_lmem_swapping (random-engines) [352.446676] Subtest random-engines: SKIP (0.000s) [352.502546] [161/170] (700s left) gem_lmem_swapping (verify-random) [352.647727] Subtest verify-random: SKIP (0.000s) [352.702779] [162/170] (700s left) i915_pm_rpm (module-reload) [365.221335] Starting subtest: module-reload [400.028673] Subtest module-reload: SUCCESS (34.799s) [400.053106] [163/170] (653s left) i915_selftest (live) [400.197702] Starting subtest: live [400.198995] Starting dynamic subtest: sanitycheck [402.071628] Dynamic subtest sanitycheck: SUCCESS (1.864s) [402.085967] Starting dynamic subtest: uncore [403.858372] Dynamic subtest uncore: SUCCESS (1.785s) [403.872447] Starting dynamic subtest: workarounds [405.852417] Dynamic subtest workarounds: SUCCESS (1.992s) [405.866608] Starting dynamic subtest: gt_engines [408.094414] Dynamic subtest gt_engines: SUCCESS (2.240s) [408.108633] Starting dynamic subtest: gt_timelines [420.711776] Dynamic subtest gt_timelines: SUCCESS (12.615s) [420.726209] Starting dynamic subtest: gt_contexts [422.623878] Dynamic subtest gt_contexts: SUCCESS (1.910s) [422.639225] Starting dynamic subtest: gt_lrc [427.055417] Dynamic subtest gt_lrc: SUCCESS (4.430s) [427.069753] Starting dynamic subtest: gt_mocs [428.974551] Dynamic subtest gt_mocs: SUCCESS (1.917s) [428.988965] Starting dynamic subtest: gt_pm [434.070681] Dynamic subtest gt_pm: SUCCESS (5.094s) [434.084900] Starting dynamic subtest: gt_heartbeat [435.984438] Dynamic subtest gt_heartbeat: SUCCESS (1.912s) [435.998813] Starting dynamic subtest: gt_tlb [439.143731] Dynamic subtest gt_tlb: SUCCESS (3.157s) [439.158260] Starting dynamic subtest: requests [446.773377] Dynamic subtest requests: SUCCESS (7.628s) [446.787758] Starting dynamic subtest: migrate [451.346957] Dynamic subtest migrate: SUCCESS (4.571s) [451.362832] Starting dynamic subtest: active [453.146669] Dynamic subtest active: SUCCESS (1.798s) [453.161287] Starting dynamic subtest: objects [456.533262] Dynamic subtest objects: SUCCESS (3.385s) [456.547660] Starting dynamic subtest: mman [463.449293] Dynamic subtest mman: SUCCESS (6.914s) [463.463812] Starting dynamic subtest: dmabuf [465.330439] Dynamic subtest dmabuf: SUCCESS (1.879s) [465.345096] Starting dynamic subtest: vma [467.170432] Dynamic subtest vma: SUCCESS (1.838s) [467.185168] Starting dynamic subtest: coherency [473.460438] Dynamic subtest coherency: SUCCESS (6.288s) [473.474938] Starting dynamic subtest: gtt [482.867225] Dynamic subtest gtt: SUCCESS (9.405s) [482.881942] Starting dynamic subtest: gem [484.855129] Dynamic subtest gem: SUCCESS (1.986s) [484.869689] Starting dynamic subtest: evict [488.665401] Dynamic subtest evict: SUCCESS (3.809s) [488.679932] Starting dynamic subtest: hugepages [495.623564] Dynamic subtest hugepages: SUCCESS (6.956s) [495.638330] Starting dynamic subtest: gem_contexts [511.050334] Dynamic subtest gem_contexts: SUCCESS (15.399s) [511.065372] Starting dynamic subtest: client [512.855181] Dynamic subtest client: SUCCESS (1.829s) [512.870054] Starting dynamic subtest: gem_migrate [514.642448] Dynamic subtest gem_migrate: SUCCESS (1.786s) [514.657678] Starting dynamic subtest: reset [519.996817] Dynamic subtest reset: SUCCESS (5.352s) [520.012094] Starting dynamic subtest: memory_region [521.813305] Dynamic subtest memory_region: SUCCESS (1.815s) [521.828405] Starting dynamic subtest: hangcheck [546.213426] Dynamic subtest hangcheck: SUCCESS (24.398s) [546.228379] Starting dynamic subtest: execlists [556.423478] Dynamic subtest execlists: SUCCESS (10.208s) [556.438399] Starting dynamic subtest: ring_submission [558.238267] Dynamic subtest ring_submission: SUCCESS (1.813s) [558.253447] Starting dynamic subtest: perf [560.178429] Dynamic subtest perf: SUCCESS (1.938s) [560.194089] Starting dynamic subtest: slpc [562.017390] Dynamic subtest slpc: SUCCESS (1.837s) [562.032385] Starting dynamic subtest: guc [563.802442] Dynamic subtest guc: SUCCESS (1.783s) [563.817600] Starting dynamic subtest: guc_multi_lrc [565.602224] Dynamic subtest guc_multi_lrc: SUCCESS (1.798s) [565.617176] Starting dynamic subtest: guc_hang [567.454399] Dynamic subtest guc_hang: SUCCESS (1.851s) [567.469545] Starting dynamic subtest: late_gt_pm [569.302697] Dynamic subtest late_gt_pm: SUCCESS (1.846s) [569.304069] Subtest live: SUCCESS (169.096s) [569.498035] [164/170] (483s left) dmabuf (all-tests) [569.638678] Starting subtest: all-tests [569.639906] Starting dynamic subtest: sanitycheck [569.703741] Dynamic subtest sanitycheck: SUCCESS (0.063s) [569.720804] Starting dynamic subtest: dma_fence [569.891287] Dynamic subtest dma_fence: SUCCESS (0.185s) [569.907314] Starting dynamic subtest: dma_fence_chain [587.413103] Dynamic subtest dma_fence_chain: SUCCESS (17.511s) [587.426773] Starting dynamic subtest: dma_fence_unwrap [587.469575] Dynamic subtest dma_fence_unwrap: SUCCESS (0.064s) [587.487070] Starting dynamic subtest: dma_resv [587.553723] Dynamic subtest dma_resv: SUCCESS (0.082s) [587.555780] Subtest all-tests: SUCCESS (17.914s) [587.586714] [165/170] (465s left) i915_suspend (basic-s2idle-without-i915) [587.723836] Starting subtest: basic-s2idle-without-i915 [611.489347] Subtest basic-s2idle-without-i915: SUCCESS (8.347s) [611.805360] [166/170] (456s left) i915_suspend (basic-s3-without-i915) [611.958535] Starting subtest: basic-s3-without-i915 [635.699218] Subtest basic-s3-without-i915: SUCCESS (7.401s) [635.969837] [167/170] (449s left) gem_exec_suspend (basic-s0) [636.126125] Starting subtest: basic-S0 [636.127280] Starting dynamic subtest: smem [655.603542] Dynamic subtest smem: SUCCESS (3.977s) [655.604608] Subtest basic-S0: SUCCESS (3.978s) [655.808279] [168/170] (444s left) gem_exec_suspend (basic-s3) [655.954545] Starting subtest: basic-S3 [655.955662] Starting dynamic subtest: smem [674.598388] Dynamic subtest smem: SUCCESS (3.823s) [674.599453] Subtest basic-S3: SUCCESS (3.824s) [674.798758] [169/170] (440s left) kms_chamelium_hpd (common-hpd-after-suspend) [675.273295] Subtest common-hpd-after-suspend: SKIP (0.000s) [676.168558] [170/170] (439s left) kms_pipe_crc_basic (suspend-read-crc) [676.333143] Starting subtest: suspend-read-crc [676.336219] Starting dynamic subtest: pipe-A-eDP-1 [694.532476] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.461s) [694.554174] Starting dynamic subtest: pipe-B-eDP-1 [712.485537] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.118s) [712.508875] Starting dynamic subtest: pipe-C-eDP-1 [731.485780] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.269s) [731.486954] Subtest suspend-read-crc: SUCCESS (8.863s) [732.382334] Closing watchdogs Done.