builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-029 starttime: 1501756316.69 results: success (0) revision: 63e261ce8cb04c913d2e6b19ea451b7078d24dc1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-03 03:31:56.689056) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-03 03:31:56.689609) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-03 03:31:56.689911) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-03 03:31:56.771733) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:31:56.772154) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1501749590.223143-1665967280 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-03 03:31:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2017-08-03 03:31:57 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126336 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:31:56.938569) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:31:56.939003) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1501749590.223143-1665967280 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022133 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:31:57.016729) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 mins, 26 secs) (at 2017-08-03 03:31:57.017104) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 63e261ce8cb04c913d2e6b19ea451b7078d24dc1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 63e261ce8cb04c913d2e6b19ea451b7078d24dc1 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1501749590.223143-1665967280 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-03 03:31:57,639 truncating revision to first 12 chars 2017-08-03 03:31:57,639 Setting DEBUG logging. 2017-08-03 03:31:57,639 attempt 1/10 2017-08-03 03:31:57,639 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/63e261ce8cb0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-03 03:31:58,095 attempt 1/10 2017-08-03 03:31:58,844 current task status: no status available at this point. state: PENDING 2017-08-03 03:31:58,844 sleeping for 11.00s (attempt 1/10) 2017-08-03 03:32:09,856 attempt 2/10 2017-08-03 03:32:10,449 current task status: no status available at this point. state: PENDING 2017-08-03 03:32:10,449 sleeping for 15.50s (attempt 2/10) 2017-08-03 03:32:25,965 attempt 3/10 2017-08-03 03:32:26,520 current task status: no status available at this point. state: PENDING 2017-08-03 03:32:26,520 sleeping for 24.25s (attempt 3/10) 2017-08-03 03:32:50,795 attempt 4/10 2017-08-03 03:32:51,339 current task status: no status available at this point. state: PENDING 2017-08-03 03:32:51,339 sleeping for 36.38s (attempt 4/10) 2017-08-03 03:33:27,751 attempt 5/10 2017-08-03 03:33:28,346 current task status: no status available at this point. state: PENDING 2017-08-03 03:33:28,346 sleeping for 54.56s (attempt 5/10) 2017-08-03 03:34:22,963 attempt 6/10 2017-08-03 03:34:23,270 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-08-03 03:34:23,519 unpacking tar archive at: mozilla-central-63e261ce8cb0/testing/mozharness/ program finished with exit code 0 elapsedTime=146.188409 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 mins, 26 secs) (at 2017-08-03 03:34:23.258349) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-03 03:34:23.261710) ========= script_repo_revision: 63e261ce8cb04c913d2e6b19ea451b7078d24dc1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-03 03:34:23.262091) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-03 03:34:23.262351) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-03 03:34:23.270877) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-03 03:34:23.271182) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1501749590.223143-1665967280 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:34:23 INFO - MultiFileLogger online at 20170803 03:34:23 in /builds/slave/test 03:34:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:34:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:34:23 INFO - {'append_to_log': False, 03:34:23 INFO - 'base_work_dir': '/builds/slave/test', 03:34:23 INFO - 'blob_upload_branch': 'Firefox', 03:34:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:34:23 INFO - 'branch': 'Firefox', 03:34:23 INFO - 'buildbot_json_path': 'buildprops.json', 03:34:23 INFO - 'code_coverage': False, 03:34:23 INFO - 'config_files': ('talos/linux_config.py',), 03:34:23 INFO - 'default_actions': ('clobber', 03:34:23 INFO - 'read-buildbot-config', 03:34:23 INFO - 'download-and-extract', 03:34:23 INFO - 'populate-webroot', 03:34:23 INFO - 'create-virtualenv', 03:34:23 INFO - 'install', 03:34:23 INFO - 'setup-mitmproxy', 03:34:23 INFO - 'run-tests'), 03:34:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:34:23 INFO - 'disable_ccov_upload': False, 03:34:23 INFO - 'download_minidump_stackwalk': True, 03:34:23 INFO - 'download_symbols': 'ondemand', 03:34:23 INFO - 'enable_stylo': False, 03:34:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:34:23 INFO - 'tooltool.py': '/tools/tooltool.py', 03:34:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:34:23 INFO - '/tools/misc-python/virtualenv.py')}, 03:34:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:34:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:34:23 INFO - 'gecko_profile': False, 03:34:23 INFO - 'gecko_profile_interval': 0, 03:34:23 INFO - 'installer_path': 'installer.exe', 03:34:23 INFO - 'log_level': 'info', 03:34:23 INFO - 'log_name': 'talos', 03:34:23 INFO - 'log_to_console': True, 03:34:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:34:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:34:23 INFO - 'opt_config_files': (), 03:34:23 INFO - 'pip_index': False, 03:34:23 INFO - 'suite': 'dromaeojs-e10s', 03:34:23 INFO - 'system_bits': '32', 03:34:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:34:23 INFO - 'title': 'talos-linux64-ix-029', 03:34:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:34:23 INFO - 'use_talos_json': True, 03:34:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:34:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:34:23 INFO - 'work_dir': 'build'} 03:34:23 INFO - [mozharness: 2017-08-03 10:34:23.966753Z] Running clobber step. 03:34:23 INFO - Running pre-action listener: _resource_record_pre_action 03:34:23 INFO - Running main action method: clobber 03:34:23 INFO - rmtree: /builds/slave/test/build 03:34:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:34:24 INFO - Running post-action listener: _resource_record_post_action 03:34:24 INFO - [mozharness: 2017-08-03 10:34:24.992192Z] Finished clobber step (success) 03:34:24 INFO - [mozharness: 2017-08-03 10:34:24.992307Z] Running read-buildbot-config step. 03:34:24 INFO - Running pre-action listener: _resource_record_pre_action 03:34:24 INFO - Running main action method: read_buildbot_config 03:34:24 INFO - Using buildbot properties: 03:34:24 INFO - { 03:34:24 INFO - "project": "", 03:34:24 INFO - "product": "firefox", 03:34:24 INFO - "who": "archaeopteryx@coole-files.de", 03:34:24 INFO - "installer_path": "public/build/target.tar.bz2", 03:34:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 03:34:24 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:34:24 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 03:34:24 INFO - "stage_platform": "linux64-stylosequential", 03:34:24 INFO - "basedir": "/builds/slave/test", 03:34:24 INFO - "buildnumber": 134, 03:34:24 INFO - "platform": "ubuntu64_hw_styloseq", 03:34:24 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:34:24 INFO - "slavebuilddir": "test", 03:34:24 INFO - "taskId": "ce_7qNN2RlicQ4tkxlsWOQ", 03:34:24 INFO - "branch": "mozilla-central", 03:34:24 INFO - "script_repo_revision": "production", 03:34:24 INFO - "revision": "63e261ce8cb04c913d2e6b19ea451b7078d24dc1", 03:34:24 INFO - "slavename": "talos-linux64-ix-029", 03:34:24 INFO - "repo_path": "mozilla-central" 03:34:24 INFO - } 03:34:24 INFO - Finding installer, test and symbols from parent task. 03:34:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ce_7qNN2RlicQ4tkxlsWOQ'}, attempt #1 03:34:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ce_7qNN2RlicQ4tkxlsWOQ'}, attempt #1 03:34:25 INFO - Task dependencies: L44bNG-6R8C_EpcBDQJUNA 03:34:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA'}, attempt #1 03:34:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.tar.bz2 03:34:26 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.test_packages.json 03:34:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.crashreporter-symbols.zip 03:34:26 INFO - Running post-action listener: _resource_record_post_action 03:34:26 INFO - [mozharness: 2017-08-03 10:34:26.379786Z] Finished read-buildbot-config step (success) 03:34:26 INFO - [mozharness: 2017-08-03 10:34:26.380011Z] Running download-and-extract step. 03:34:26 INFO - Running pre-action listener: _resource_record_pre_action 03:34:26 INFO - Running main action method: download_and_extract 03:34:26 INFO - mkdir: /builds/slave/test/build/tests 03:34:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:26 INFO - trying https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.test_packages.json 03:34:26 INFO - Downloading https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:34:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:34:26 INFO - Downloaded 989 bytes. 03:34:26 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:34:26 INFO - Using the following test package requirements: 03:34:26 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:34:26 INFO - u'common': [u'target.common.tests.zip'], 03:34:26 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:34:26 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:34:26 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:34:26 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:34:26 INFO - u'mozbase': [u'target.common.tests.zip'], 03:34:26 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:34:26 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:34:26 INFO - u'web-platform': [u'target.common.tests.zip', 03:34:26 INFO - u'target.web-platform.tests.tar.gz'], 03:34:26 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:34:26 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:34:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.common.tests.zip 03:34:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:34:26 INFO - Fetch https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.common.tests.zip into memory 03:34:28 INFO - Content-Length response header: 54278281 03:34:28 INFO - Bytes received: 54278281 03:34:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:34:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.common.tests.zip 03:34:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:34:39 INFO - Fetch https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.common.tests.zip into memory 03:34:40 INFO - Content-Length response header: 54278281 03:34:40 INFO - Bytes received: 54278281 03:34:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.talos.tests.zip 03:34:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:34:52 INFO - Fetch https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.talos.tests.zip into memory 03:34:53 INFO - Content-Length response header: 14496464 03:34:53 INFO - Bytes received: 14496464 03:34:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:53 INFO - trying https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.tar.bz2 03:34:53 INFO - Downloading https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:34:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:34:54 INFO - Downloaded 62211648 bytes. 03:34:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.tar.bz2 03:34:54 INFO - mkdir: /builds/slave/test/properties 03:34:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:34:54 INFO - Writing to file /builds/slave/test/properties/build_url 03:34:54 INFO - Contents: 03:34:54 INFO - build_url:https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.tar.bz2 03:34:54 INFO - Running post-action listener: _resource_record_post_action 03:34:54 INFO - Running post-action listener: set_extra_try_arguments 03:34:54 INFO - [mozharness: 2017-08-03 10:34:54.519038Z] Finished download-and-extract step (success) 03:34:54 INFO - [mozharness: 2017-08-03 10:34:54.519137Z] Running populate-webroot step. 03:34:54 INFO - Running pre-action listener: _resource_record_pre_action 03:34:54 INFO - Running main action method: populate_webroot 03:34:54 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:34:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:34:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:34:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:34:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:34:54 INFO - 'tests': ['damp', 'tps']}, 03:34:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:34:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:34:54 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:34:54 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:34:54 INFO - 'other-e10s': {'tests': ['a11yr', 03:34:54 INFO - 'ts_paint', 03:34:54 INFO - 'tpaint', 03:34:54 INFO - 'sessionrestore', 03:34:54 INFO - 'sessionrestore_many_windows', 03:34:54 INFO - 'sessionrestore_no_auto_restore', 03:34:54 INFO - 'tabpaint']}, 03:34:54 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:34:54 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:34:54 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:34:54 INFO - 'talos_options': ['--mitmproxy', 03:34:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:34:54 INFO - '--firstNonBlankPaint'], 03:34:54 INFO - 'tests': ['quantum_pageload_google', 03:34:54 INFO - 'quantum_pageload_youtube', 03:34:54 INFO - 'quantum_pageload_amazon', 03:34:54 INFO - 'quantum_pageload_facebook']}, 03:34:54 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:34:54 INFO - 'talos_options': ['--stylo', 03:34:54 INFO - '--mitmproxy', 03:34:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:34:54 INFO - '--firstNonBlankPaint'], 03:34:54 INFO - 'tests': ['quantum_pageload_google', 03:34:54 INFO - 'quantum_pageload_youtube', 03:34:54 INFO - 'quantum_pageload_amazon', 03:34:54 INFO - 'quantum_pageload_facebook']}, 03:34:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:34:54 INFO - 'tsvgr_opacity', 03:34:54 INFO - 'tart', 03:34:54 INFO - 'tscrollx', 03:34:54 INFO - 'cart', 03:34:54 INFO - 'tsvg_static']}, 03:34:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:34:54 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:34:54 INFO - 'talos_options': ['--stylo', 03:34:54 INFO - '--stylo-threads=1', 03:34:54 INFO - '--mitmproxy', 03:34:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:34:54 INFO - '--firstNonBlankPaint'], 03:34:54 INFO - 'tests': ['tp6_google', 03:34:54 INFO - 'tp6_youtube', 03:34:54 INFO - 'tp6_amazon', 03:34:54 INFO - 'tp6_facebook']}, 03:34:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:34:54 INFO - 'talos_options': ['--xperf_path', 03:34:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:34:54 INFO - 'tests': ['tp5n']}}} 03:34:54 INFO - Running post-action listener: _resource_record_post_action 03:34:54 INFO - [mozharness: 2017-08-03 10:34:54.527860Z] Finished populate-webroot step (success) 03:34:54 INFO - [mozharness: 2017-08-03 10:34:54.527951Z] Running create-virtualenv step. 03:34:54 INFO - Running pre-action listener: _resource_record_pre_action 03:34:54 INFO - Running main action method: create_virtualenv 03:34:54 INFO - Creating virtualenv /builds/slave/test/build/venv 03:34:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:34:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:34:54 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:34:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:34:54 INFO - Using real prefix '/usr' 03:34:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:34:55 INFO - Installing distribute.............................................................................................................................................................................................done. 03:34:57 INFO - Installing pip.................done. 03:34:57 INFO - Return code: 0 03:34:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:34:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:34:57 INFO - Reading from file tmpfile_stdout 03:34:57 INFO - Output received: 03:34:57 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:34:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:34:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9e81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbb4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd57d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd54eb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd56240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1501749590.223143-1665967280', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:34:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:34:57 INFO - Using env: {'DISPLAY': ':0', 03:34:57 INFO - 'HOME': '/home/cltbld', 03:34:57 INFO - 'LANG': 'en_US.UTF-8', 03:34:57 INFO - 'LANGUAGE': 'en_US:en', 03:34:57 INFO - 'LOGNAME': 'cltbld', 03:34:57 INFO - 'MAIL': '/var/mail/cltbld', 03:34:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:57 INFO - 'MOZ_NO_REMOTE': '1', 03:34:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:57 INFO - 'NO_EM_RESTART': '1', 03:34:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:57 INFO - 'PWD': '/builds/slave/test', 03:34:57 INFO - 'SHELL': '/bin/bash', 03:34:57 INFO - 'SHLVL': '1', 03:34:57 INFO - 'TERM': 'linux', 03:34:57 INFO - 'TMOUT': '86400', 03:34:57 INFO - 'USER': 'cltbld', 03:34:57 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1501749590.223143-1665967280', 03:34:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:57 INFO - '_': '/tools/buildbot/bin/python'} 03:34:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:34:57 INFO - Cleaning up... 03:34:57 INFO - Return code: 0 03:34:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:34:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9e81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbb4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd57d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd54eb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd56240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1501749590.223143-1665967280', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:34:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:34:57 INFO - Using env: {'DISPLAY': ':0', 03:34:57 INFO - 'HOME': '/home/cltbld', 03:34:57 INFO - 'LANG': 'en_US.UTF-8', 03:34:57 INFO - 'LANGUAGE': 'en_US:en', 03:34:57 INFO - 'LOGNAME': 'cltbld', 03:34:57 INFO - 'MAIL': '/var/mail/cltbld', 03:34:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:57 INFO - 'MOZ_NO_REMOTE': '1', 03:34:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:57 INFO - 'NO_EM_RESTART': '1', 03:34:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:57 INFO - 'PWD': '/builds/slave/test', 03:34:57 INFO - 'SHELL': '/bin/bash', 03:34:57 INFO - 'SHLVL': '1', 03:34:57 INFO - 'TERM': 'linux', 03:34:57 INFO - 'TMOUT': '86400', 03:34:57 INFO - 'USER': 'cltbld', 03:34:57 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1501749590.223143-1665967280', 03:34:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:57 INFO - '_': '/tools/buildbot/bin/python'} 03:34:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:57 INFO - Downloading/unpacking psutil>=3.1.1 03:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:34:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:34:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:34:58 INFO - Installing collected packages: psutil 03:34:58 INFO - Running setup.py install for psutil 03:34:59 INFO - building 'psutil._psutil_linux' extension 03:34:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:34:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:34:59 INFO - building 'psutil._psutil_posix' extension 03:34:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:34:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:34:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:34:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:34:59 INFO - Successfully installed psutil 03:34:59 INFO - Cleaning up... 03:34:59 INFO - Return code: 0 03:34:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9e81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbb4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd57d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd54eb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd56240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1501749590.223143-1665967280', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:34:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:34:59 INFO - Using env: {'DISPLAY': ':0', 03:34:59 INFO - 'HOME': '/home/cltbld', 03:34:59 INFO - 'LANG': 'en_US.UTF-8', 03:34:59 INFO - 'LANGUAGE': 'en_US:en', 03:34:59 INFO - 'LOGNAME': 'cltbld', 03:34:59 INFO - 'MAIL': '/var/mail/cltbld', 03:34:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:59 INFO - 'MOZ_NO_REMOTE': '1', 03:34:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:59 INFO - 'NO_EM_RESTART': '1', 03:34:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:59 INFO - 'PWD': '/builds/slave/test', 03:34:59 INFO - 'SHELL': '/bin/bash', 03:34:59 INFO - 'SHLVL': '1', 03:34:59 INFO - 'TERM': 'linux', 03:34:59 INFO - 'TMOUT': '86400', 03:34:59 INFO - 'USER': 'cltbld', 03:34:59 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1501749590.223143-1665967280', 03:34:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:59 INFO - '_': '/tools/buildbot/bin/python'} 03:34:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:35:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:35:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:35:01 INFO - Installing collected packages: mozsystemmonitor 03:35:01 INFO - Running setup.py install for mozsystemmonitor 03:35:01 INFO - Successfully installed mozsystemmonitor 03:35:01 INFO - Cleaning up... 03:35:01 INFO - Return code: 0 03:35:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9e81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbb4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd57d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd54eb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd56240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1501749590.223143-1665967280', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:35:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:35:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:35:01 INFO - Using env: {'DISPLAY': ':0', 03:35:01 INFO - 'HOME': '/home/cltbld', 03:35:01 INFO - 'LANG': 'en_US.UTF-8', 03:35:01 INFO - 'LANGUAGE': 'en_US:en', 03:35:01 INFO - 'LOGNAME': 'cltbld', 03:35:01 INFO - 'MAIL': '/var/mail/cltbld', 03:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:01 INFO - 'MOZ_NO_REMOTE': '1', 03:35:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:01 INFO - 'NO_EM_RESTART': '1', 03:35:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:01 INFO - 'PWD': '/builds/slave/test', 03:35:01 INFO - 'SHELL': '/bin/bash', 03:35:01 INFO - 'SHLVL': '1', 03:35:01 INFO - 'TERM': 'linux', 03:35:01 INFO - 'TMOUT': '86400', 03:35:01 INFO - 'USER': 'cltbld', 03:35:01 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1501749590.223143-1665967280', 03:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:01 INFO - '_': '/tools/buildbot/bin/python'} 03:35:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:01 INFO - Downloading/unpacking jsonschema==2.5.1 03:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:35:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:02 INFO - Downloading functools32-3.2.3-2.tar.gz 03:35:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:35:02 INFO - warning: no files found matching '*.txt' 03:35:02 INFO - no previously-included directories found matching 'build' 03:35:02 INFO - no previously-included directories found matching 'dist' 03:35:02 INFO - no previously-included directories found matching '.git*' 03:35:02 INFO - Installing collected packages: jsonschema, functools32 03:35:02 INFO - Running setup.py install for functools32 03:35:02 INFO - warning: no files found matching '*.txt' 03:35:02 INFO - no previously-included directories found matching 'build' 03:35:02 INFO - no previously-included directories found matching 'dist' 03:35:02 INFO - no previously-included directories found matching '.git*' 03:35:02 INFO - Successfully installed jsonschema functools32 03:35:02 INFO - Cleaning up... 03:35:02 INFO - Return code: 0 03:35:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9e81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbb4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd57d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd54eb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd56240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1501749590.223143-1665967280', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:35:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:35:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:35:02 INFO - Using env: {'DISPLAY': ':0', 03:35:02 INFO - 'HOME': '/home/cltbld', 03:35:02 INFO - 'LANG': 'en_US.UTF-8', 03:35:02 INFO - 'LANGUAGE': 'en_US:en', 03:35:02 INFO - 'LOGNAME': 'cltbld', 03:35:02 INFO - 'MAIL': '/var/mail/cltbld', 03:35:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:02 INFO - 'MOZ_NO_REMOTE': '1', 03:35:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:02 INFO - 'NO_EM_RESTART': '1', 03:35:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:02 INFO - 'PWD': '/builds/slave/test', 03:35:02 INFO - 'SHELL': '/bin/bash', 03:35:02 INFO - 'SHLVL': '1', 03:35:02 INFO - 'TERM': 'linux', 03:35:02 INFO - 'TMOUT': '86400', 03:35:02 INFO - 'USER': 'cltbld', 03:35:02 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1501749590.223143-1665967280', 03:35:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:02 INFO - '_': '/tools/buildbot/bin/python'} 03:35:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:35:03 INFO - Cleaning up... 03:35:03 INFO - Return code: 0 03:35:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9e81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbb4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd57d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd54eb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd56240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1501749590.223143-1665967280', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:35:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:35:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:35:03 INFO - Using env: {'DISPLAY': ':0', 03:35:03 INFO - 'HOME': '/home/cltbld', 03:35:03 INFO - 'LANG': 'en_US.UTF-8', 03:35:03 INFO - 'LANGUAGE': 'en_US:en', 03:35:03 INFO - 'LOGNAME': 'cltbld', 03:35:03 INFO - 'MAIL': '/var/mail/cltbld', 03:35:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:03 INFO - 'MOZ_NO_REMOTE': '1', 03:35:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:03 INFO - 'NO_EM_RESTART': '1', 03:35:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:03 INFO - 'PWD': '/builds/slave/test', 03:35:03 INFO - 'SHELL': '/bin/bash', 03:35:03 INFO - 'SHLVL': '1', 03:35:03 INFO - 'TERM': 'linux', 03:35:03 INFO - 'TMOUT': '86400', 03:35:03 INFO - 'USER': 'cltbld', 03:35:03 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1501749590.223143-1665967280', 03:35:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:03 INFO - '_': '/tools/buildbot/bin/python'} 03:35:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:03 INFO - Downloading/unpacking blobuploader==1.2.4 03:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:04 INFO - Downloading blobuploader-1.2.4.tar.gz 03:35:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:35:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:35:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:04 INFO - Downloading docopt-0.6.1.tar.gz 03:35:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:35:04 INFO - Installing collected packages: blobuploader, requests, docopt 03:35:04 INFO - Running setup.py install for blobuploader 03:35:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:35:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:35:05 INFO - Running setup.py install for requests 03:35:05 INFO - Running setup.py install for docopt 03:35:05 INFO - Successfully installed blobuploader requests docopt 03:35:05 INFO - Cleaning up... 03:35:05 INFO - Return code: 0 03:35:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:35:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9e81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbb4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd57d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd54eb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd56240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1501749590.223143-1665967280', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:35:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:35:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:35:05 INFO - Using env: {'DISPLAY': ':0', 03:35:05 INFO - 'HOME': '/home/cltbld', 03:35:05 INFO - 'LANG': 'en_US.UTF-8', 03:35:05 INFO - 'LANGUAGE': 'en_US:en', 03:35:05 INFO - 'LOGNAME': 'cltbld', 03:35:05 INFO - 'MAIL': '/var/mail/cltbld', 03:35:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:05 INFO - 'MOZ_NO_REMOTE': '1', 03:35:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:05 INFO - 'NO_EM_RESTART': '1', 03:35:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:05 INFO - 'PWD': '/builds/slave/test', 03:35:05 INFO - 'SHELL': '/bin/bash', 03:35:05 INFO - 'SHLVL': '1', 03:35:05 INFO - 'TERM': 'linux', 03:35:05 INFO - 'TMOUT': '86400', 03:35:05 INFO - 'USER': 'cltbld', 03:35:05 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1501749590.223143-1665967280', 03:35:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:05 INFO - '_': '/tools/buildbot/bin/python'} 03:35:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:35:05 INFO - Running setup.py (path:/tmp/pip-NVwKSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:35:05 INFO - Running setup.py (path:/tmp/pip-JxKzBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:35:05 INFO - Running setup.py (path:/tmp/pip-hZkdfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:35:06 INFO - Running setup.py (path:/tmp/pip-7qNB8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:35:06 INFO - Running setup.py (path:/tmp/pip-ZDrcVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:35:06 INFO - Running setup.py (path:/tmp/pip-aMYX_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:35:06 INFO - Running setup.py (path:/tmp/pip-Djof2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:35:06 INFO - Running setup.py (path:/tmp/pip-aX2uKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:35:06 INFO - Running setup.py (path:/tmp/pip-WJQgqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:35:06 INFO - Running setup.py (path:/tmp/pip-zH4ePc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:35:06 INFO - Running setup.py (path:/tmp/pip-__7Uew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:35:06 INFO - Running setup.py (path:/tmp/pip-Nk4z2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:35:06 INFO - Running setup.py (path:/tmp/pip-gJvp2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:35:06 INFO - Running setup.py (path:/tmp/pip-_bnw4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:06 INFO - Running setup.py (path:/tmp/pip-XcrK6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:35:06 INFO - Running setup.py (path:/tmp/pip-1VCu6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:35:06 INFO - Running setup.py (path:/tmp/pip-cFazdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:35:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:35:07 INFO - Running setup.py install for manifestparser 03:35:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:35:07 INFO - Running setup.py install for mozcrash 03:35:07 INFO - Running setup.py install for mozdebug 03:35:07 INFO - Running setup.py install for mozdevice 03:35:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:35:07 INFO - Running setup.py install for mozfile 03:35:07 INFO - Running setup.py install for mozhttpd 03:35:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:35:07 INFO - Running setup.py install for mozinfo 03:35:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:35:07 INFO - Running setup.py install for mozInstall 03:35:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:35:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:35:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:35:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:35:07 INFO - Running setup.py install for mozleak 03:35:07 INFO - Running setup.py install for mozlog 03:35:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:35:08 INFO - Running setup.py install for moznetwork 03:35:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:35:08 INFO - Running setup.py install for mozprocess 03:35:08 INFO - Running setup.py install for mozprofile 03:35:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:35:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:35:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:35:08 INFO - Running setup.py install for mozrunner 03:35:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:35:08 INFO - Running setup.py install for mozscreenshot 03:35:08 INFO - Running setup.py install for moztest 03:35:08 INFO - Running setup.py install for mozversion 03:35:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:35:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:35:08 INFO - Cleaning up... 03:35:08 INFO - Return code: 0 03:35:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:35:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9e81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbb4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd57d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd54eb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd56240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1501749590.223143-1665967280', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:35:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:35:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:35:08 INFO - Using env: {'DISPLAY': ':0', 03:35:08 INFO - 'HOME': '/home/cltbld', 03:35:08 INFO - 'LANG': 'en_US.UTF-8', 03:35:08 INFO - 'LANGUAGE': 'en_US:en', 03:35:08 INFO - 'LOGNAME': 'cltbld', 03:35:08 INFO - 'MAIL': '/var/mail/cltbld', 03:35:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:08 INFO - 'MOZ_NO_REMOTE': '1', 03:35:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:08 INFO - 'NO_EM_RESTART': '1', 03:35:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:08 INFO - 'PWD': '/builds/slave/test', 03:35:08 INFO - 'SHELL': '/bin/bash', 03:35:08 INFO - 'SHLVL': '1', 03:35:08 INFO - 'TERM': 'linux', 03:35:08 INFO - 'TMOUT': '86400', 03:35:08 INFO - 'USER': 'cltbld', 03:35:08 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1501749590.223143-1665967280', 03:35:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:08 INFO - '_': '/tools/buildbot/bin/python'} 03:35:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:35:08 INFO - Running setup.py (path:/tmp/pip-5I5Liz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:35:09 INFO - Running setup.py (path:/tmp/pip-_lpt2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:35:09 INFO - Running setup.py (path:/tmp/pip-ISbDsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:35:09 INFO - Running setup.py (path:/tmp/pip-8nN3oj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:35:09 INFO - Running setup.py (path:/tmp/pip-gOIoFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:35:09 INFO - Running setup.py (path:/tmp/pip-gdJGYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:35:09 INFO - Running setup.py (path:/tmp/pip-LaT1rX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:35:09 INFO - Running setup.py (path:/tmp/pip-d7e3Su-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:35:09 INFO - Running setup.py (path:/tmp/pip-jN3lct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:35:09 INFO - Running setup.py (path:/tmp/pip-Iih50L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:35:09 INFO - Running setup.py (path:/tmp/pip-G5cRZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:35:09 INFO - Running setup.py (path:/tmp/pip-hNF9lK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:35:09 INFO - Running setup.py (path:/tmp/pip-pGcTkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:35:09 INFO - Running setup.py (path:/tmp/pip-3oUQHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:10 INFO - Running setup.py (path:/tmp/pip-nDNaCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:35:10 INFO - Running setup.py (path:/tmp/pip-MfWRj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:35:10 INFO - Running setup.py (path:/tmp/pip-FAR8PN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:35:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:11 INFO - Downloading blessings-1.6.tar.gz 03:35:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:35:11 INFO - Installing collected packages: blessings 03:35:11 INFO - Running setup.py install for blessings 03:35:11 INFO - Successfully installed blessings 03:35:11 INFO - Cleaning up... 03:35:11 INFO - Return code: 0 03:35:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:35:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:35:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:35:11 INFO - Reading from file tmpfile_stdout 03:35:11 INFO - Current package versions: 03:35:11 INFO - argparse == 1.2.1 03:35:11 INFO - blessings == 1.6 03:35:11 INFO - blobuploader == 1.2.4 03:35:11 INFO - docopt == 0.6.1 03:35:11 INFO - functools32 == 3.2.3-2 03:35:11 INFO - jsonschema == 2.5.1 03:35:11 INFO - manifestparser == 1.1 03:35:11 INFO - mozInstall == 1.13 03:35:11 INFO - mozcrash == 1.0 03:35:11 INFO - mozdebug == 0.1 03:35:11 INFO - mozdevice == 0.51 03:35:11 INFO - mozfile == 1.2 03:35:11 INFO - mozhttpd == 0.7 03:35:11 INFO - mozinfo == 0.10 03:35:11 INFO - mozleak == 0.1 03:35:11 INFO - mozlog == 3.5 03:35:11 INFO - moznetwork == 0.27 03:35:11 INFO - mozprocess == 0.25 03:35:11 INFO - mozprofile == 0.28 03:35:11 INFO - mozrunner == 6.13 03:35:11 INFO - mozscreenshot == 0.1 03:35:11 INFO - mozsystemmonitor == 0.3 03:35:11 INFO - moztest == 0.8 03:35:11 INFO - mozversion == 1.4 03:35:11 INFO - psutil == 3.1.1 03:35:11 INFO - requests == 1.2.3 03:35:11 INFO - wsgiref == 0.1.2 03:35:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:35:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9e81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbb4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd57d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd54eb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd56240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1501749590.223143-1665967280', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:35:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:35:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:35:11 INFO - Using env: {'DISPLAY': ':0', 03:35:11 INFO - 'HOME': '/home/cltbld', 03:35:11 INFO - 'LANG': 'en_US.UTF-8', 03:35:11 INFO - 'LANGUAGE': 'en_US:en', 03:35:11 INFO - 'LOGNAME': 'cltbld', 03:35:11 INFO - 'MAIL': '/var/mail/cltbld', 03:35:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:11 INFO - 'MOZ_NO_REMOTE': '1', 03:35:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:11 INFO - 'NO_EM_RESTART': '1', 03:35:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:11 INFO - 'PWD': '/builds/slave/test', 03:35:11 INFO - 'SHELL': '/bin/bash', 03:35:11 INFO - 'SHLVL': '1', 03:35:11 INFO - 'TERM': 'linux', 03:35:11 INFO - 'TMOUT': '86400', 03:35:11 INFO - 'USER': 'cltbld', 03:35:11 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1501749590.223143-1665967280', 03:35:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:11 INFO - '_': '/tools/buildbot/bin/python'} 03:35:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:35:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:35:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:35:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:35:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:35:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:35:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:35:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:35:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:35:12 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:35:13 INFO - Installing collected packages: simplejson 03:35:13 INFO - Running setup.py install for simplejson 03:35:13 INFO - building 'simplejson._speedups' extension 03:35:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:35:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:35:14 INFO - Successfully installed simplejson 03:35:14 INFO - Cleaning up... 03:35:14 INFO - Return code: 0 03:35:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:35:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9e81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbb4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd57d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd54eb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd56240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1501749590.223143-1665967280', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:35:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:35:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:35:14 INFO - Using env: {'DISPLAY': ':0', 03:35:14 INFO - 'HOME': '/home/cltbld', 03:35:14 INFO - 'LANG': 'en_US.UTF-8', 03:35:14 INFO - 'LANGUAGE': 'en_US:en', 03:35:14 INFO - 'LOGNAME': 'cltbld', 03:35:14 INFO - 'MAIL': '/var/mail/cltbld', 03:35:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:14 INFO - 'MOZ_NO_REMOTE': '1', 03:35:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:14 INFO - 'NO_EM_RESTART': '1', 03:35:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:14 INFO - 'PWD': '/builds/slave/test', 03:35:14 INFO - 'SHELL': '/bin/bash', 03:35:14 INFO - 'SHLVL': '1', 03:35:14 INFO - 'TERM': 'linux', 03:35:14 INFO - 'TMOUT': '86400', 03:35:14 INFO - 'USER': 'cltbld', 03:35:14 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1501749590.223143-1665967280', 03:35:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:14 INFO - '_': '/tools/buildbot/bin/python'} 03:35:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:35:14 INFO - Cleaning up... 03:35:14 INFO - Return code: 0 03:35:14 INFO - Running post-action listener: _resource_record_post_action 03:35:14 INFO - Running post-action listener: _start_resource_monitoring 03:35:14 INFO - Starting resource monitoring. 03:35:14 INFO - [mozharness: 2017-08-03 10:35:14.561447Z] Finished create-virtualenv step (success) 03:35:14 INFO - [mozharness: 2017-08-03 10:35:14.561960Z] Running install step. 03:35:14 INFO - Running pre-action listener: _resource_record_pre_action 03:35:14 INFO - Running main action method: install 03:35:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:35:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:35:14 INFO - Reading from file tmpfile_stdout 03:35:14 INFO - Detecting whether we're running mozinstall >=1.0... 03:35:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:35:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:35:14 INFO - Reading from file tmpfile_stdout 03:35:14 INFO - Output received: 03:35:14 INFO - Usage: mozinstall [options] installer 03:35:14 INFO - Options: 03:35:14 INFO - -h, --help show this help message and exit 03:35:14 INFO - -d DEST, --destination=DEST 03:35:14 INFO - Directory to install application into. [default: 03:35:14 INFO - "/builds/slave/test"] 03:35:14 INFO - --app=APP Application being installed. [default: firefox] 03:35:14 INFO - mkdir: /builds/slave/test/build/application 03:35:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:35:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:35:32 INFO - Reading from file tmpfile_stdout 03:35:32 INFO - Output received: 03:35:32 INFO - /builds/slave/test/build/application/firefox/firefox 03:35:32 INFO - Running post-action listener: _resource_record_post_action 03:35:32 INFO - [mozharness: 2017-08-03 10:35:32.917557Z] Finished install step (success) 03:35:32 INFO - [mozharness: 2017-08-03 10:35:32.917815Z] Running setup-mitmproxy step. 03:35:32 INFO - Running pre-action listener: _resource_record_pre_action 03:35:32 INFO - Running main action method: setup_mitmproxy 03:35:32 INFO - Skipping: mitmproxy is not required 03:35:32 INFO - Running post-action listener: _resource_record_post_action 03:35:32 INFO - [mozharness: 2017-08-03 10:35:32.918952Z] Finished setup-mitmproxy step (success) 03:35:32 INFO - [mozharness: 2017-08-03 10:35:32.919174Z] Running run-tests step. 03:35:32 INFO - Running pre-action listener: _resource_record_pre_action 03:35:32 INFO - Running pre-action listener: _set_gcov_prefix 03:35:32 INFO - Running main action method: run_tests 03:35:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:35:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:35:32 INFO - Python 2.7.3 03:35:32 INFO - Return code: 0 03:35:32 INFO - grabbing minidump binary from tooltool 03:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:32 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd54eb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd56240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:35:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:35:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:35:32 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:35:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:35:33 INFO - Return code: 0 03:35:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:35:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:35:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:35:33 INFO - ENV: RUST_BACKTRACE is now 1 03:35:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:35:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:35:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:35:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:35:33 INFO - Using env: {'DISPLAY': ':0', 03:35:33 INFO - 'HOME': '/home/cltbld', 03:35:33 INFO - 'LANG': 'en_US.UTF-8', 03:35:33 INFO - 'LANGUAGE': 'en_US:en', 03:35:33 INFO - 'LOGNAME': 'cltbld', 03:35:33 INFO - 'MAIL': '/var/mail/cltbld', 03:35:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:35:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:35:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:33 INFO - 'MOZ_NO_REMOTE': '1', 03:35:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:35:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:33 INFO - 'NO_EM_RESTART': '1', 03:35:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:33 INFO - 'PWD': '/builds/slave/test', 03:35:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:35:33 INFO - 'RUST_BACKTRACE': '1', 03:35:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:35:33 INFO - 'SHELL': '/bin/bash', 03:35:33 INFO - 'SHLVL': '1', 03:35:33 INFO - 'STYLO_FORCE_ENABLED': '1', 03:35:33 INFO - 'TERM': 'linux', 03:35:33 INFO - 'TMOUT': '86400', 03:35:33 INFO - 'USER': 'cltbld', 03:35:33 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1501749590.223143-1665967280', 03:35:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:33 INFO - '_': '/tools/buildbot/bin/python'} 03:35:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:35:33 INFO - mozversion application_buildid: 20170803094619 03:35:33 INFO - mozversion application_changeset: 63e261ce8cb04c913d2e6b19ea451b7078d24dc1 03:35:33 INFO - mozversion application_display_name: Nightly 03:35:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:35:33 INFO - mozversion application_name: Firefox 03:35:33 INFO - mozversion application_remotingname: firefox 03:35:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:35:33 INFO - mozversion application_vendor: Mozilla 03:35:33 INFO - mozversion application_version: 57.0a1 03:35:33 INFO - mozversion platform_buildid: 20170803094619 03:35:33 INFO - mozversion platform_changeset: 63e261ce8cb04c913d2e6b19ea451b7078d24dc1 03:35:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:35:33 INFO - mozversion platform_version: 57.0a1 03:35:33 INFO - using testdate: 1501756533 03:35:33 INFO - actual date: 1501756533 03:35:33 INFO - starting webserver on 'localhost:40488' 03:35:33 INFO - SUITE-START | Running 2 tests 03:35:33 INFO - TEST-START | dromaeo_css 03:35:33 INFO - Initialising browser for dromaeo_css test... 03:35:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40488/getInfo.html -profile /tmp/tmpbbnh9X/profile 03:35:33 INFO - TEST-INFO | started process 30784 (/builds/slave/test/build/application/firefox/firefox http://localhost:40488/getInfo.html) 03:35:40 INFO - TEST-INFO | 30784: exit 0 03:35:40 INFO - Browser initialized. 03:35:40 INFO - Running cycle 1/1 for dromaeo_css test... 03:35:40 INFO - TEST-INFO | started process 31007 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbbnh9X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:35:41 INFO - PID 31007 | 03:35:41 INFO - PID 31007 | (/builds/slave/test/build/application/firefox/firefox:31062): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:35:41 INFO - PID 31007 | 03:35:51 INFO - PID 31007 | RSS: Main: 174129152 03:35:51 INFO - PID 31007 | 03:38:51 INFO - PID 31007 | Cycle 1(1): loaded http://localhost:40488/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40488/tests/dromaeo/cssquery-ext.html) 03:38:52 INFO - PID 31007 | RSS: Main: 176349184 03:38:52 INFO - PID 31007 | 03:41:54 INFO - PID 31007 | Cycle 1(1): loaded http://localhost:40488/tests/dromaeo/cssquery-ext.html (next: http://localhost:40488/tests/dromaeo/cssquery-jquery.html) 03:41:54 INFO - PID 31007 | RSS: Main: 173281280 03:41:54 INFO - PID 31007 | 03:44:56 INFO - PID 31007 | Cycle 1(1): loaded http://localhost:40488/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40488/tests/dromaeo/cssquery-mootools.html) 03:44:57 INFO - PID 31007 | RSS: Main: 175599616 03:44:57 INFO - PID 31007 | 03:47:59 INFO - PID 31007 | Cycle 1(1): loaded http://localhost:40488/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40488/tests/dromaeo/cssquery-prototype.html) 03:47:59 INFO - PID 31007 | RSS: Main: 172670976 03:47:59 INFO - PID 31007 | 03:51:03 INFO - PID 31007 | Cycle 1(1): loaded http://localhost:40488/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40488/tests/dromaeo/cssquery-yui.html) 03:51:04 INFO - PID 31007 | RSS: Main: 177516544 03:51:04 INFO - PID 31007 | 03:54:06 INFO - PID 31007 | Cycle 1(1): loaded http://localhost:40488/tests/dromaeo/cssquery-yui.html (next: http://localhost:40488/tests/dromaeo/cssquery-dojo.html) 03:54:06 INFO - PID 31007 | RSS: Main: 178552832 03:54:06 INFO - PID 31007 | 03:54:06 INFO - PID 31007 | __start_tp_report 03:54:06 INFO - PID 31007 | _x_x_mozilla_page_load 03:54:06 INFO - PID 31007 | _x_x_mozilla_page_load_details 03:54:06 INFO - PID 31007 | |i|pagename|runs| 03:54:06 INFO - PID 31007 | |0;dojo.html;3139.4819854723974;3151.4327421064213;3170.5878235829337;3184.156198607368;3207.9679203207975;6116.052011938145;6178.5057195424315;6204.47261982732;6238.469730072944;6239.812805615838;6016.548758843082;6163.198784158064;6164.938350616492;6175.660338681382;6191.566590338678;5625.324961004665;5662.915056274159;5677.545796336304;5698.0313346730945;5747.2241247431475;5655.434456554352;5712.343080545728;5713.257276554063;5727.541796656257;5744.569157313197;5437.864053398657;5590.692511911843;5640;5692.288463942007;5708.22938903249;5604.3835178130375;5680.5455563554815;5691.9146212806845;5692.37383887772;5702.173184888209;5555.30558680165;5565.471280228372;5618.494335509824;5648.604597678164;5653.773849046033;6011.3086994995265;6087.391260873921;6113.877722445526;6146.569740118193;6185.103160041814;6600.273969863311;6604.669766511655;6623.867522649568;6649.833754156137;6654.467642588581;6626.237982632011;6659.500537459709;6735.191776986744;6741.224759152662;6744.359285867835;6036.728347224385;6128.816135515942;6149.477294430024;6232.096346029845;6241.594296370721;6753.08833307507;6778.76274330406;6795.082663840417;6800.897986530206;6806.727730890709;6429;6477.708503117371;6592.703328350236;6593.505487088391;6600;6682.064510968468;6688.665566721645;6703.93296067033;6706.429953454011;6708.027336036247;6600.339966003361;6605.570637908617;6615.272320044791;6641.66791660415;6695.933040669531;6499.935000650027;6576.967115164489;6604.405603495708;6689.264180940093;6707.731690732316;5309.33633295838;5324.7870085196155;5327.360716714019;5331.653442526223;5332.626716129834;4585.95414045862;4594.563516465931;4598.678092533491;4624.421947256593;4644.535546445396;5747.109198074305;5785.971070144622;5788.479036886616;5790.884182316414;5797.826065218051;6636.701348439332;6689.163854518185;6695.933040669628;6719.428848547928;6725.6973436195485;5761.366249712528;5841.912371314434;5844.12338149281;5846.210761547221;5863.0325996211;5822.272215973004;5829.679367634821;5899.144624029492;5900.586958912921;5901.704914754245;6306.716197771111;6411.903821442682;6434.2600600930555;6452;6517.608943463408;6679.632620205935;6697.531172817856;6718.664066796739;6735.6295403753265;6748.595084294958;6443.581167224115;6500.5449618526245;6505.544611877123;6521.9673901630185;6523.64119973406;6519.217693876765;6536.182977127859;6609.306022867722;6615.66921653925;6659.900101498384;6582.3746744059235;6628.6022838627905;6684.83287917806;6756.223034350916;6762.425193858577;6403.583767055126;6428.678566071584;6428.710708018057;6484.1894763154605;6488.318726533646;6446.806595802133;6450.387213214737;6454.677266136769;6455.741770329322;6515;6030.125631783455;6389.041643753474;6440.13058237132;6463.903041454288;6467.773627923;6414.262359828493;6506.544541882023;6509.121268628864;6565.671716414065;6588.275289718032;6223.37766223374;6294.24469063697;6312.968435157794;6377.202849643794;6391.265004524354 03:54:06 INFO - PID 31007 | |1;ext.html;843.4138273899638;876.6975393489246;904.0597778310557;906.5557876640448;1193.3794426898007;32211.67788322116;43129.78435107824;43380.34929476053;43483.56516434834;43514;43457.56542434575;43845.78077109618;43878;43939.56060439395;43984.34023489642;7368.5210461319975;7984.880226796603;7988.920110798905;7993.640286187136;7996;7868.701664225396;7958.283754462097;7979.760607181794;7994.920050799505;7996.200379962015;7944.920550794504;7970.760877173665;7978.441509094366;8000.799980000517;8029.237222463857;7939.920600793976;7963.8805417918775;7988.001499812494;7994.3204827589725;7995.160508146619;7872;7929.4845835021115;7930.0880398753725;7930.762077137695;7932.960335198287;40582.188356233004;40689.593104068874;40794;40800.18399631991;40955.385669214986;3489.9302013959577;3534.6465353464705;3542.025942865707;3544.1848374873925;3546.6098729139776;32748.67251327504;33152.6684733152;33298.16754581131;33353.16617084568;33397.499037514455;4827.08285425768;4989.301497790312;5009.298698182258;5027.321311622957;5032.723200223986;204036;204657;204776;204868;205378;52008.73995629998;52011.219831702554;52212;52237.47762522402;52334.73832630813;54835.72582137064;54837.451625484035;54862;55072.44927550753;55516.16725749117;15114.09315441077;15291.082535047934;16546.66906661884;16948.661026779395;16967.406140785013;12713;14148.85851141496;14296.57110286693;14353.712925741427;14355.210463424612;14970.62573435651;15187.772183417257;15246.161461119524;15251.542453726406;15427.30577124032;5769.59612827098;5967.701614919237;6133.1413602095745;6134.44789968896;6144.354842741537;996.1681995533811;1007.385494848142;1008.3647302199714;1011.0900189829213;1013.5084484025242;23372.415689607897;29818.254543636584;29923.551146732818;30027.549586756217;30640.08079757611;1088.1947358954476;1096.9122470202365;1103.8344248362648;1104.0670633314837;1112.6439539347493;12447.253164810141;12807.679808004874;13055.738885222243;13067.346632668328;13121.671958201121;236724;238736;239084;239149;239292;57210;57888;58010.70994645;58025.70987145037;58093;1438.74821906166;1500.6248437890745;1524.2531159731652;1524.5883611425074;1539.599704076948;23966.041358346167;28370.85814570914;28686.56970145408;28801;29314;56026.43973560212;56881;56955.71522142363;57002.714986424806;57019.144712828514;227450;227699;228019;229261;232008;33888.322233555686;34248;34257.48613770845;37139.81430092832;37576;45193;46428.767856160506;47620.28569571528;47671;48073.27890081722;33792;34268;34312.82843585866;34441.48337774885;34721.479177811845;33717.325653487285;33841;33863.153421164665;34015.65984340125;34369.48445773265;36669.816650916575;37291.44062839005;37389.81305093457;37413.25173496569;40439;35326;35448.93653190408;35705.74639356092;36104.819475902455;36274.455883161245;24603.876980614983;25237.369065773502;25377.365565861;25629.487410251317;25793.613095803954 03:54:06 INFO - PID 31007 | |2;jquery.html;574.4485294117646;576.3947854752508;582.3689297231762;587.8207146820218;601.7171929193279;22553.661695074567;22873.199438019674;23096.30711078666;23099.653505197413;23410.414739631495;26630.33424164397;26882.327941801417;27114.1865744028;27360.863195684044;27395.45209095817;6627.271000189975;6796.626185559792;6800.523963322569;6802.285759995203;6809.148856392951;6291.465225455819;6626.37049480301;6658.600483970953;6675.8331041724105;6722.226943901441;6555.475561955056;6560.343965603425;6570.441512471446;6574.835629109262;6578.079068930354;6550.246721627002;6553.049807777893;6575.638339891304;6579.111819904299;6581.308962558935;6089.117078023662;6099.45104940553;6126.142340072393;6130.632162070246;6141.692915354214;29951;30324;30592.388152236832;30607.540886886716;31231.531527027113;1873.2319748903021;1924.316867512027;1924.874883132592;1925.6148770245866;1926.2776458827939;18678.813211867844;19357.322493712792;19413.611727765507;19440.80559194404;19461.513462163417;2269.54609078185;2329.580675478413;2349.8707571083582;2359.6106642403984;2415.118481754165;139388;147216.52783472135;147532.26233868868;147848;147980.2600986999;14893.70212595742;14999.550013499613;15165.545033649008;15236.314365853563;16008.519744407686;23569.764302356758;23869.641955370684;23883.52232955366;23963.880180598986;24043.639345409832;9880.802383952281;9967.750806229757;10031.545425913202;10045.79908401828;10286.639967601099;9116.453012819253;9124.81750364989;9201.677941272023;9234.86147707785;9237.722868313962;7918.376732769769;8810.515421651871;8896.822063558693;8913.643454261886;9199.528075507887;2636.116900838202;2667.213172114231;2703.45930813838;2710.6069619905;2778.9444211115665;926.282131348197;942.533445944262;949.5252373813094;967.4727273635885;972.8832540095234;19235.13441895118;19606.803931960498;24169.395765105663;25603.87198063998;26341.604875926878;1030.4950574218578;1032.746976990627;1035.089121573026;1047.675220681591;1056.5245639462273;10907.291026083438;10969.670909872717;11103.333799971866;11186.384748838893;11379.487923043484;480890;482900;490624;492752;501108;113785;126232;127861;128139;128640;1237.2823762217893;1280.7310464802497;1298.68831480444;1314.493919840868;1315.6908126590245;20499;20742.792572074086;20883.37349879506;20916.37250882476;21014;55306;55974.72012640074;56337.154942676716;58036.419635803104;58235.417645823;73603;73768.26231737614;74589;74693.62653186699;74715;12322.568710095104;12950.546730864751;13974.650633734238;14583.85416145825;14857.182854943081;19545.60908781788;20080.19679212815;20327.8983605081;20516.589668206852;20634.793652063287;18264.81735182631;18435.262589496808;18551.72172417388;18589.907050464662;18665.160067797253;16065.19674016318;16136.273867675747;16300.347986080898;16314.102724350274;17678.64642707113;18050.458486245432;18764.7185292218;18950.52623684419;19162.52093697613;19216.807831921502;14231.430742770173;14564.708705825613;14607.050541714754;14622.707545849236;14662.706745865236;17709.734353984444;17831.197596107948;17869.642607148045;17954;18311.90844045771 03:54:06 INFO - PID 31007 | |3;mootools.html;1339.8794108530233;1368.9520866769665;1390.3604342002677;1399.8810101141405;1407.3244842475613;13646.2494562799;14079.859201407982;14400;14402.423903043878;14404.783928241071;14628.34172462239;14869.256537173153;14914.030588011772;14924;14926.328315225814;2536.5053814506177;2557.8465292082533;2563.333533281351;2570.434504409027;2663.2143517662334;2749;2787.6236708044357;2790.883646541379;2791.595218693298;2794.2874566985392;2638.353603367168;2682.557378032622;2710.2953232159584;2713.186044186746;2717.605947137664;2558.2453176313034;2583.4962182374443;2583.7932965362725;2648.8808003639883;2719.9592006119924;2607.4524349886547;2619.2404202781363;2647.669041369829;2647.973520264811;2649.0595838477448;13298.800517992238;13510.05429619927;13550;13565.982551308593;13570.45718171272;7551.584662843541;7765.456418050739;7779.611019449005;7811.687532498693;7817.648205830695;5180.352455943007;5270.947290527084;5313;5424.511793938525;5425.159100339453;1685.2584862660512;1722.7846519185102;1733.306677329066;1758.7625670534442;1760.3486709917283;22917.31248062561;23114.768852311598;23189.88405057964;23209.3037208884;23223.88388058066;6383.744650213939;6603.514209302868;6658.933410665928;6810.182778066564;6843.418309443654;16115.919420402823;16187.19064046793;16213.837861621232;16216.837831621533;16218.270177842025;7368.410527157815;7466.962665186639;7504.924950750423;7513.924860751432;7520.699172033167;5878.794242201588;6148.661823599656;6373.139626150503;6413.807585772434;6915.377616014583;5105.7191854448365;5228.581713462914;5300.655457395334;5354.892902142014;5356.839294821161;1468.3759402254213;1530.6632540840997;1559.407425178425;1566.3108232377717;1579.2498563182396;876.145757886056;900.7522931193975;901.8376692195468;903.7108125399809;914.1407077347272;7161.462890283249;7192.964035179791;7209.279072092749;7284.980102785615;7365;735.2243383230743;738.1253214940313;750.53091817614;757.7499425189674;961.8172547216006;4697.859064228079;4724.598409135193;4776.737279449594;4819.397575303087;5003.4746351633285;19276.90361548183;19361.903190483958;19840.206391744458;19970.30103946355;19999.500012499513;18422.171002304927;19396;19524.12141453638;19529.121189546506;19585.412437626896;10276.383416995004;10570.048695617277;10583.417912014913;10601.151907847354;10605.992430719223;7378.5437741975775;7944.44388892772;7972.760817175494;8046.959765201371;8263.214994575506;16654.833451665814;17037.48887533376;17255;17274.913625431793;17313.82686173122;17442.91278543599;17550.82449175543;17653.470395888144;17655.38206162778;17691.115444227995;13064;13192.934035329761;13258.86741132615;13357;13406.93296533511;13024.54414095502;13196.20822750638;13196.736065278448;13210.867891320964;13217.206967581977;9350.3454758169;10047.949760251444;10571.62999295021;10617.787644247226;10712.946435267773;10208.693739187836;10260.435676037889;10441.112505436819;10486.842697359698;10597.099246564128;9079.182873541413;9229.35394522377;9240;9242.861357079784;9244.075592440702;6975.337342952412;6976.825579360557;6986.266442023514;6990.545614535039;7033.788986330418;6802.319768023158;6882.4149947253045;6905.965470172818;6917.204521480095;6922.169339679271 03:54:06 INFO - PID 31007 | |4;prototype.html;493.92938639142693;498.46472863580175;517.7851191755419;519.2082074835872;523.1890569617094;6169.722362493693;6261.624302541851;6285.811425657238;6304.71628776705;6306.59007164534;5868.61853979491;6080;6093.756249750016;6102.626908945485;6207;4875.536824001714;4880.926196236822;4893.7063776173545;4905.607551395879;4915.336429582015;4849.296851956464;4858.4695820816505;4909.828156014541;4918.114739346916;4921.483244259355;4705.9058818823605;4738.549837765424;4780.282957556359;4893.632977526682;4916.213405855064;4801.711897286139;4839.830605928793;4869.610431165498;4872.366592343008;4902.558769710708;4334.609885110323;4356.934645980313;4378.452693413324;4405.8678239652545;4449.7997590108525;6116.663583502906;6153.200083989098;6163.137160797492;6182.412670796267;6196.411340922605;5655.26481557399;5657.773689052433;5659.40576239493;5683.886322273573;5685.118806584986;6478.643674597895;6481.384268494486;6577.243616984012;6602.834929126762;6661.16735408074;4753.47711751707;4799.112164249625;4824.131656301899;4826.276058591205;4830.661853670244;6713.295104014106;6810.62541560214;6868.278830722752;6884.345987131214;6928.272531384233;4833.516648335209;4892.975535122301;4982.476839931827;4987.351644286292;4994.001199760062;4935.506449355107;4959.355283813154;4987.950120498821;4991;5036.823711170092;5601.159826026129;5613.410591887875;5620.241267428926;5623.887522249532;5666.46168613981;6447.9355206447335;6485.383888530582;6570.5729127606555;6606.933930660728;6641.236257830411;1616.4342480131859;1657.7927759030122;1712.8715346349074;1742.4511278947346;1743.7733094697862;1390.4994202087241;1397.7344304582098;1404.2136403614008;1417.5747275817214;1429.9142051476945;5662.178984047372;5704.486596206361;5724.227229324071;5751.252337196138;5759.222504961776;6506.60960342381;6552.541322107502;6565.505108058907;6596.4393026592315;6710.228323742735;5759;5770.798022069207;5790.594658373873;5822.505087067562;5833.095870140135;3557.1462848916076;3572.8749493767596;3580.803055831954;3583.032581203113;3584.62361452049;6395.296517383084;6535.967320163369;6595.868082638416;6612.338766123349;6618.602883826986;6825.088975086984;6884.934519644187;6939.75710850128;6962.050625824777;7000.124984376953;6432.9678351607945;6455.903161452488;6512.251091124582;6571.539992200595;6615.140031795836;6642.335766423319;6712.697928593323;6747.561408508432;6759.864802704017;6781.220159681699;6582.901256481061;6633.3035031321015;6702.162229721285;6711.530192886451;6720.462363011045;6516.413522782972;6564.803055908139;6588.176477940257;6591.835204119743;6638.668066596748;4944.134776414185;4966.701997880139;4971.726555039508;4981.6014718823135;4988.625853061108;6652.733890644514;6670.366315200048;6718.798436046926;6782.355676210752;6806;6535.738570457129;6576.605403675795;6595.142631457879;6620.437262832713;6632.1709786276715;6503.804885853432;6517.7067031984625;6580.769673061612;6588.209414870246;6594.406503414716;6155.076738489083;6380.585261957958;6449.7420103195345;6547.770828020996;6559.180102487189;6247.3440288769025;6426.389492998158;6439.774607888701;6441.878706428494;6450.677466126769;6232.4418895276185;6239.563230573816;6256.624602523863;6256.812295631138;6262 03:54:06 INFO - PID 31007 | |5;yui.html;889.8754174415583;907.0430695616125;912.8265629530389;925.6667599664124;927.4296307770719;16984.235709393077;17729.734053989185;17906.462806115804;18032.54918627035;20256.89871550644;18758.53103672409;18848.62302753944;18858.33995810147;18860.056997150157;19053.52366190846;978.1636700620974;1012.1953047327393;1014.1177175856997;1028.8096702110097;1029.711680729397;1050.1703654113242;1053.947302634865;1054.104011590146;1054.4095306628274;1054.878688950769;1016.2428990402124;1093.1637297467444;1100.2628239079836;1101.1191047162279;1101.124605938277;1089.760252744399;1090.8745494268182;1090.9127269818396;1091.5251865438481;1091.9945400273027;781.9687212511493;782.0380931454287;782.6634547144726;782.7064850680995;782.7338704840324;16591;17223;17253.741193882102;17272.654546909118;17278.3952561661;20238.595228095503;20247.29134480301;20672.276470323617;20852.061657225462;20913.8954305229;14509.201993890332;15172.696546069017;15297.158656273901;15381.230938453033;15401.845981540266;3482.4428091505238;3522.189896323834;3528.435450327935;3548.1307079765365;3549.5563054618174;121996;128134;128268;128542;129733;14875.776863347059;15327.157006364534;15417.922910385601;15439.30523126462;15441.613959651098;29296.267593309913;29692;29895.850520747255;29959.25101872427;29966.85016574903;8525.44584601999;8935.508547029976;9009.864852027225;9021.684241051664;9026.593803278869;3603.4234522476277;3787.5454945406727;3787.981060094682;3841.654251117413;4018.557958624549;4996.225585034325;5150.4334523202415;5156.767945442464;5157.252198431206;5162.535371816554;982.8967958364411;1026.4559783314855;1039.163473403902;1053.1732589916878;1060.2260349944584;657.3754932813846;659.5317324699421;667.4293479075418;667.6428110960612;694.4652617484509;11636.301821890713;11734.70663233426;12198.634040978784;12801.295928723823;13222.801657975138;672.176583684982;688.2807466197835;701.9508634395544;702.034702284359;707.2255879811598;5512.724363781875;5539.19681646159;5629;5705.5435565154685;5834.329052159056;98868;103893;105011.89976200434;105423;107448;95771;96875;98636.50681746546;98739;99209;83018.58490707508;83658.5817070923;84332.15667843366;84609;84635;11844.940775296069;11943.462544185359;12129.150959432754;12159.878401215874;12299.93850030744;36125;37196.25607487781;37504.249915001004;38318.23363532769;38471.422928655535;64456.35543644503;69193.65403172951;69361;69742;70452;19006.334778282693;19662.901685492052;19762.20951161995;19793.703094453882;19999.60000800005;21564.137434502445;21905.233316833834;22189.55620887541;22288.219912302993;22361.888190558944;19110.33113841009;19271.325503607866;19363;19439.222431102597;19781.10985005707;19251.614967700287;19303.51741206481;19885.304014359426;19939.302124425576;19991.500212494804;17546.473605791845;18464.35374761877;18866;19329.903350483157;19376.4187074388;13191.602072994398;13778.242196679279;14187.858121419067;14319.57041288763;14702.926485367505;13789.241591712553;14772.852271477148;14894.627634309229;14953.700925981202;15095.622609434851 03:54:06 INFO - PID 31007 | __end_tp_report 03:54:06 INFO - PID 31007 | __start_cc_report 03:54:06 INFO - PID 31007 | _x_x_mozilla_cycle_collect,351 03:54:06 INFO - PID 31007 | __end_cc_report 03:54:06 INFO - PID 31007 | __startTimestamp1501757646377__endTimestamp 03:54:06 INFO - PID 31007 | 03:54:06 INFO - PID 31007 | ------- Summary: start ------- 03:54:06 INFO - PID 31007 | Number of tests: 6 03:54:06 INFO - PID 31007 | 03:54:06 INFO - PID 31007 | [#0] dojo.html Cycles:165 Average:6114.90 Median:6391.27 stddev:720.92 (11.3%) stddev-sans-first:684.30 03:54:06 INFO - PID 31007 | Values: 3139.5 3151.4 3170.6 3184.2 3208.0 6116.1 6178.5 6204.5 6238.5 6239.8 6016.5 6163.2 6164.9 6175.7 6191.6 5625.3 5662.9 5677.5 5698.0 5747.2 5655.4 5712.3 5713.3 5727.5 5744.6 5437.9 5590.7 5640.0 5692.3 5708.2 5604.4 5680.5 5691.9 5692.4 5702.2 5555.3 5565.5 5618.5 5648.6 5653.8 6011.3 6087.4 6113.9 6146.6 6185.1 6600.3 6604.7 6623.9 6649.8 6654.5 6626.2 6659.5 6735.2 6741.2 6744.4 6036.7 6128.8 6149.5 6232.1 6241.6 6753.1 6778.8 6795.1 6800.9 6806.7 6429.0 6477.7 6592.7 6593.5 6600.0 6682.1 6688.7 6703.9 6706.4 6708.0 6600.3 6605.6 6615.3 6641.7 6695.9 6499.9 6577.0 6604.4 6689.3 6707.7 5309.3 5324.8 5327.4 5331.7 5332.6 4586.0 4594.6 4598.7 4624.4 4644.5 5747.1 5786.0 5788.5 5790.9 5797.8 6636.7 6689.2 6695.9 6719.4 6725.7 5761.4 5841.9 5844.1 5846.2 5863.0 5822.3 5829.7 5899.1 5900.6 5901.7 6306.7 6411.9 6434.3 6452.0 6517.6 6679.6 6697.5 6718.7 6735.6 6748.6 6443.6 6500.5 6505.5 6522.0 6523.6 6519.2 6536.2 6609.3 6615.7 6659.9 6582.4 6628.6 6684.8 6756.2 6762.4 6403.6 6428.7 6428.7 6484.2 6488.3 6446.8 6450.4 6454.7 6455.7 6515.0 6030.1 6389.0 6440.1 6463.9 6467.8 6414.3 6506.5 6509.1 6565.7 6588.3 6223.4 6294.2 6313.0 6377.2 6391.3 03:54:06 INFO - PID 31007 | 03:54:06 INFO - PID 31007 | [#1] ext.html Cycles:180 Average:41006.51 Median:19626.18 stddev:58241.68 (296.8%) stddev-sans-first:58326.98 03:54:06 INFO - PID 31007 | Values: 843.4 876.7 904.1 906.6 1193.4 32211.7 43129.8 43380.3 43483.6 43514.0 43457.6 43845.8 43878.0 43939.6 43984.3 7368.5 7984.9 7988.9 7993.6 7996.0 7868.7 7958.3 7979.8 7994.9 7996.2 7944.9 7970.8 7978.4 8000.8 8029.2 7939.9 7963.9 7988.0 7994.3 7995.2 7872.0 7929.5 7930.1 7930.8 7933.0 40582.2 40689.6 40794.0 40800.2 40955.4 3489.9 3534.6 3542.0 3544.2 3546.6 32748.7 33152.7 33298.2 33353.2 33397.5 4827.1 4989.3 5009.3 5027.3 5032.7 204036.0 204657.0 204776.0 204868.0 205378.0 52008.7 52011.2 52212.0 52237.5 52334.7 54835.7 54837.5 54862.0 55072.4 55516.2 15114.1 15291.1 16546.7 16948.7 16967.4 12713.0 14148.9 14296.6 14353.7 14355.2 14970.6 15187.8 15246.2 15251.5 15427.3 5769.6 5967.7 6133.1 6134.4 6144.4 996.2 1007.4 1008.4 1011.1 1013.5 23372.4 29818.3 29923.6 30027.5 30640.1 1088.2 1096.9 1103.8 1104.1 1112.6 12447.3 12807.7 13055.7 13067.3 13121.7 236724.0 238736.0 239084.0 239149.0 239292.0 57210.0 57888.0 58010.7 58025.7 58093.0 1438.7 1500.6 1524.3 1524.6 1539.6 23966.0 28370.9 28686.6 28801.0 29314.0 56026.4 56881.0 56955.7 57002.7 57019.1 227450.0 227699.0 228019.0 229261.0 232008.0 33888.3 34248.0 34257.5 37139.8 37576.0 45193.0 46428.8 47620.3 47671.0 48073.3 33792.0 34268.0 34312.8 34441.5 34721.5 33717.3 33841.0 33863.2 34015.7 34369.5 36669.8 37291.4 37389.8 37413.3 40439.0 35326.0 35448.9 35705.7 36104.8 36274.5 24603.9 25237.4 25377.4 25629.5 25793.6 03:54:06 INFO - PID 31007 | 03:54:06 INFO - PID 31007 | [#2] jquery.html Cycles:180 Average:35478.87 Median:12870.00 stddev:83107.70 (645.7%) stddev-sans-first:83299.52 03:54:06 INFO - PID 31007 | Values: 574.4 576.4 582.4 587.8 601.7 22553.7 22873.2 23096.3 23099.7 23410.4 26630.3 26882.3 27114.2 27360.9 27395.5 6627.3 6796.6 6800.5 6802.3 6809.1 6291.5 6626.4 6658.6 6675.8 6722.2 6555.5 6560.3 6570.4 6574.8 6578.1 6550.2 6553.0 6575.6 6579.1 6581.3 6089.1 6099.5 6126.1 6130.6 6141.7 29951.0 30324.0 30592.4 30607.5 31231.5 1873.2 1924.3 1924.9 1925.6 1926.3 18678.8 19357.3 19413.6 19440.8 19461.5 2269.5 2329.6 2349.9 2359.6 2415.1 139388.0 147216.5 147532.3 147848.0 147980.3 14893.7 14999.6 15165.5 15236.3 16008.5 23569.8 23869.6 23883.5 23963.9 24043.6 9880.8 9967.8 10031.5 10045.8 10286.6 9116.5 9124.8 9201.7 9234.9 9237.7 7918.4 8810.5 8896.8 8913.6 9199.5 2636.1 2667.2 2703.5 2710.6 2778.9 926.3 942.5 949.5 967.5 972.9 19235.1 19606.8 24169.4 25603.9 26341.6 1030.5 1032.7 1035.1 1047.7 1056.5 10907.3 10969.7 11103.3 11186.4 11379.5 480890.0 482900.0 490624.0 492752.0 501108.0 113785.0 126232.0 127861.0 128139.0 128640.0 1237.3 1280.7 1298.7 1314.5 1315.7 20499.0 20742.8 20883.4 20916.4 21014.0 55306.0 55974.7 56337.2 58036.4 58235.4 73603.0 73768.3 74589.0 74693.6 74715.0 12322.6 12950.5 13974.7 14583.9 14857.2 19545.6 20080.2 20327.9 20516.6 20634.8 18264.8 18435.3 18551.7 18589.9 18665.2 16065.2 16136.3 16300.3 16314.1 17678.6 18050.5 18764.7 18950.5 19162.5 19216.8 14231.4 14564.7 14607.1 14622.7 14662.7 17709.7 17831.2 17869.6 17954.0 18311.9 03:54:06 INFO - PID 31007 | 03:54:06 INFO - PID 31007 | [#3] mootools.html Cycles:180 Average:8741.08 Median:2595.62 stddev:6043.19 (232.8%) stddev-sans-first:6034.56 03:54:06 INFO - PID 31007 | Values: 1339.9 1369.0 1390.4 1399.9 1407.3 13646.2 14079.9 14400.0 14402.4 14404.8 14628.3 14869.3 14914.0 14924.0 14926.3 2536.5 2557.8 2563.3 2570.4 2663.2 2749.0 2787.6 2790.9 2791.6 2794.3 2638.4 2682.6 2710.3 2713.2 2717.6 2558.2 2583.5 2583.8 2648.9 2720.0 2607.5 2619.2 2647.7 2648.0 2649.1 13298.8 13510.1 13550.0 13566.0 13570.5 7551.6 7765.5 7779.6 7811.7 7817.6 5180.4 5270.9 5313.0 5424.5 5425.2 1685.3 1722.8 1733.3 1758.8 1760.3 22917.3 23114.8 23189.9 23209.3 23223.9 6383.7 6603.5 6658.9 6810.2 6843.4 16115.9 16187.2 16213.8 16216.8 16218.3 7368.4 7467.0 7504.9 7513.9 7520.7 5878.8 6148.7 6373.1 6413.8 6915.4 5105.7 5228.6 5300.7 5354.9 5356.8 1468.4 1530.7 1559.4 1566.3 1579.2 876.1 900.8 901.8 903.7 914.1 7161.5 7193.0 7209.3 7285.0 7365.0 735.2 738.1 750.5 757.7 961.8 4697.9 4724.6 4776.7 4819.4 5003.5 19276.9 19361.9 19840.2 19970.3 19999.5 18422.2 19396.0 19524.1 19529.1 19585.4 10276.4 10570.0 10583.4 10601.2 10606.0 7378.5 7944.4 7972.8 8047.0 8263.2 16654.8 17037.5 17255.0 17274.9 17313.8 17442.9 17550.8 17653.5 17655.4 17691.1 13064.0 13192.9 13258.9 13357.0 13406.9 13024.5 13196.2 13196.7 13210.9 13217.2 9350.3 10047.9 10571.6 10617.8 10712.9 10208.7 10260.4 10441.1 10486.8 10597.1 9079.2 9229.4 9240.0 9242.9 9244.1 6975.3 6976.8 6986.3 6990.5 7033.8 6802.3 6882.4 6906.0 6917.2 6922.2 03:54:06 INFO - PID 31007 | 03:54:06 INFO - PID 31007 | [#4] prototype.html Cycles:180 Average:5485.58 Median:6154.14 stddev:1542.01 (25.1%) stddev-sans-first:1500.13 03:54:06 INFO - PID 31007 | Values: 493.9 498.5 517.8 519.2 523.2 6169.7 6261.6 6285.8 6304.7 6306.6 5868.6 6080.0 6093.8 6102.6 6207.0 4875.5 4880.9 4893.7 4905.6 4915.3 4849.3 4858.5 4909.8 4918.1 4921.5 4705.9 4738.5 4780.3 4893.6 4916.2 4801.7 4839.8 4869.6 4872.4 4902.6 4334.6 4356.9 4378.5 4405.9 4449.8 6116.7 6153.2 6163.1 6182.4 6196.4 5655.3 5657.8 5659.4 5683.9 5685.1 6478.6 6481.4 6577.2 6602.8 6661.2 4753.5 4799.1 4824.1 4826.3 4830.7 6713.3 6810.6 6868.3 6884.3 6928.3 4833.5 4893.0 4982.5 4987.4 4994.0 4935.5 4959.4 4988.0 4991.0 5036.8 5601.2 5613.4 5620.2 5623.9 5666.5 6447.9 6485.4 6570.6 6606.9 6641.2 1616.4 1657.8 1712.9 1742.5 1743.8 1390.5 1397.7 1404.2 1417.6 1429.9 5662.2 5704.5 5724.2 5751.3 5759.2 6506.6 6552.5 6565.5 6596.4 6710.2 5759.0 5770.8 5790.6 5822.5 5833.1 3557.1 3572.9 3580.8 3583.0 3584.6 6395.3 6536.0 6595.9 6612.3 6618.6 6825.1 6884.9 6939.8 6962.1 7000.1 6433.0 6455.9 6512.3 6571.5 6615.1 6642.3 6712.7 6747.6 6759.9 6781.2 6582.9 6633.3 6702.2 6711.5 6720.5 6516.4 6564.8 6588.2 6591.8 6638.7 4944.1 4966.7 4971.7 4981.6 4988.6 6652.7 6670.4 6718.8 6782.4 6806.0 6535.7 6576.6 6595.1 6620.4 6632.2 6503.8 6517.7 6580.8 6588.2 6594.4 6155.1 6380.6 6449.7 6547.8 6559.2 6247.3 6426.4 6439.8 6441.9 6450.7 6232.4 6239.6 6256.6 6256.8 6262.0 03:54:06 INFO - PID 31007 | 03:54:06 INFO - PID 31007 | [#5] yui.html Cycles:180 Average:23401.79 Median:19787.41 stddev:31600.02 (159.7%) stddev-sans-first:31643.46 03:54:06 INFO - PID 31007 | Values: 889.9 907.0 912.8 925.7 927.4 16984.2 17729.7 17906.5 18032.5 20256.9 18758.5 18848.6 18858.3 18860.1 19053.5 978.2 1012.2 1014.1 1028.8 1029.7 1050.2 1053.9 1054.1 1054.4 1054.9 1016.2 1093.2 1100.3 1101.1 1101.1 1089.8 1090.9 1090.9 1091.5 1092.0 782.0 782.0 782.7 782.7 782.7 16591.0 17223.0 17253.7 17272.7 17278.4 20238.6 20247.3 20672.3 20852.1 20913.9 14509.2 15172.7 15297.2 15381.2 15401.8 3482.4 3522.2 3528.4 3548.1 3549.6 121996.0 128134.0 128268.0 128542.0 129733.0 14875.8 15327.2 15417.9 15439.3 15441.6 29296.3 29692.0 29895.9 29959.3 29966.9 8525.4 8935.5 9009.9 9021.7 9026.6 3603.4 3787.5 3788.0 3841.7 4018.6 4996.2 5150.4 5156.8 5157.3 5162.5 982.9 1026.5 1039.2 1053.2 1060.2 657.4 659.5 667.4 667.6 694.5 11636.3 11734.7 12198.6 12801.3 13222.8 672.2 688.3 702.0 702.0 707.2 5512.7 5539.2 5629.0 5705.5 5834.3 98868.0 103893.0 105011.9 105423.0 107448.0 95771.0 96875.0 98636.5 98739.0 99209.0 83018.6 83658.6 84332.2 84609.0 84635.0 11844.9 11943.5 12129.2 12159.9 12299.9 36125.0 37196.3 37504.2 38318.2 38471.4 64456.4 69193.7 69361.0 69742.0 70452.0 19006.3 19662.9 19762.2 19793.7 19999.6 21564.1 21905.2 22189.6 22288.2 22361.9 19110.3 19271.3 19363.0 19439.2 19781.1 19251.6 19303.5 19885.3 19939.3 19991.5 17546.5 18464.4 18866.0 19329.9 19376.4 13191.6 13778.2 14187.9 14319.6 14702.9 13789.2 14772.9 14894.6 14953.7 15095.6 03:54:06 INFO - PID 31007 | -------- Summary: end -------- 03:54:06 INFO - PID 31007 | 03:54:07 INFO - TEST-INFO | 31007: exit 0 03:54:07 INFO - TEST-OK | dromaeo_css | took 1114000ms 03:54:07 INFO - TEST-START | kraken 03:54:07 INFO - Initialising browser for kraken test... 03:54:07 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40488/getInfo.html -profile /tmp/tmpbS_IEH/profile 03:54:07 INFO - TEST-INFO | started process 31375 (/builds/slave/test/build/application/firefox/firefox http://localhost:40488/getInfo.html) 03:54:13 INFO - TEST-INFO | 31375: exit 0 03:54:13 INFO - Browser initialized. 03:54:13 INFO - Running cycle 1/1 for kraken test... 03:54:13 INFO - TEST-INFO | started process 31601 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbS_IEH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:54:14 INFO - PID 31601 | 03:54:14 INFO - PID 31601 | (/builds/slave/test/build/application/firefox/firefox:31655): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:54:14 INFO - PID 31601 | 03:54:24 INFO - PID 31601 | RSS: Main: 173846528 03:54:24 INFO - PID 31601 | 03:54:27 INFO - PID 31601 | Cycle 1(1): loaded http://localhost:40488/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40488/tests/kraken/driver.html?testName=audio-beat-detection) 03:54:28 INFO - PID 31601 | RSS: Main: 178647040 03:54:28 INFO - PID 31601 | 03:54:31 INFO - PID 31601 | Cycle 1(1): loaded http://localhost:40488/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40488/tests/kraken/driver.html?testName=audio-dft) 03:54:31 INFO - PID 31601 | RSS: Main: 179146752 03:54:31 INFO - PID 31601 | 03:54:34 INFO - PID 31601 | Cycle 1(1): loaded http://localhost:40488/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40488/tests/kraken/driver.html?testName=audio-fft) 03:54:35 INFO - PID 31601 | RSS: Main: 173715456 03:54:35 INFO - PID 31601 | 03:54:37 INFO - PID 31601 | Cycle 1(1): loaded http://localhost:40488/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40488/tests/kraken/driver.html?testName=audio-oscillator) 03:54:38 INFO - PID 31601 | RSS: Main: 174227456 03:54:38 INFO - PID 31601 | 03:54:40 INFO - PID 31601 | Cycle 1(1): loaded http://localhost:40488/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40488/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:54:41 INFO - PID 31601 | RSS: Main: 174198784 03:54:41 INFO - PID 31601 | 03:54:44 INFO - PID 31601 | Cycle 1(1): loaded http://localhost:40488/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40488/tests/kraken/driver.html?testName=imaging-darkroom) 03:54:45 INFO - PID 31601 | RSS: Main: 177479680 03:54:45 INFO - PID 31601 | 03:54:48 INFO - PID 31601 | Cycle 1(1): loaded http://localhost:40488/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40488/tests/kraken/driver.html?testName=imaging-desaturate) 03:54:49 INFO - PID 31601 | RSS: Main: 176939008 03:54:49 INFO - PID 31601 | 03:54:52 INFO - PID 31601 | Cycle 1(1): loaded http://localhost:40488/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40488/tests/kraken/driver.html?testName=json-parse-financial) 03:54:52 INFO - PID 31601 | RSS: Main: 178143232 03:54:52 INFO - PID 31601 | 03:54:54 INFO - PID 31601 | Cycle 1(1): loaded http://localhost:40488/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40488/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:54:55 INFO - PID 31601 | RSS: Main: 178409472 03:54:55 INFO - PID 31601 | 03:54:57 INFO - PID 31601 | Cycle 1(1): loaded http://localhost:40488/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40488/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:54:57 INFO - PID 31601 | RSS: Main: 174960640 03:54:57 INFO - PID 31601 | 03:54:59 INFO - PID 31601 | Cycle 1(1): loaded http://localhost:40488/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40488/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:55:00 INFO - PID 31601 | RSS: Main: 175362048 03:55:00 INFO - PID 31601 | 03:55:03 INFO - PID 31601 | Cycle 1(1): loaded http://localhost:40488/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:55:04 INFO - PID 31601 | RSS: Main: 175771648 03:55:04 INFO - PID 31601 | 03:55:07 INFO - PID 31601 | Cycle 1(1): loaded http://localhost:40488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:55:07 INFO - PID 31601 | RSS: Main: 175435776 03:55:07 INFO - PID 31601 | 03:55:09 INFO - PID 31601 | Cycle 1(1): loaded http://localhost:40488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40488/tests/kraken/driver.html?testName=ai-astar) 03:55:09 INFO - PID 31601 | RSS: Main: 176803840 03:55:09 INFO - PID 31601 | 03:55:09 INFO - PID 31601 | __start_tp_report 03:55:09 INFO - PID 31601 | _x_x_mozilla_page_load 03:55:09 INFO - PID 31601 | _x_x_mozilla_page_load_details 03:55:09 INFO - PID 31601 | |i|pagename|runs| 03:55:09 INFO - PID 31601 | |0;ai-astar;98;108;105;108;108;112;113;100;111;113 03:55:09 INFO - PID 31601 | |1;audio-beat-detection;154;128;141;188;134;147;156;118;165;125 03:55:09 INFO - PID 31601 | |2;audio-dft;169;165;164;163;162;166;177;165;164;163 03:55:09 INFO - PID 31601 | |3;audio-fft;76;75;74;165;76;74;77;75;147;90 03:55:09 INFO - PID 31601 | |4;audio-oscillator;79;78;131;81;79;79;132;78;79;133 03:55:09 INFO - PID 31601 | |5;imaging-gaussian-blur;113;117;117;115;116;114;114;115;118;114 03:55:09 INFO - PID 31601 | |6;imaging-darkroom;155;151;152;150;150;151;150;162;153;156 03:55:09 INFO - PID 31601 | |7;imaging-desaturate;94;102;94;95;98;99;96;95;96;97 03:55:09 INFO - PID 31601 | |8;json-parse-financial;56;57;58;57;60;56;57;66;59;54 03:55:09 INFO - PID 31601 | |9;json-stringify-tinderbox;57;54;54;54;68;55;54;55;54;54 03:55:09 INFO - PID 31601 | |10;stanford-crypto-aes;77;80;78;82;78;93;84;80;93;75 03:55:09 INFO - PID 31601 | |11;stanford-crypto-ccm;133;133;133;143;132;123;133;144;124;163 03:55:09 INFO - PID 31601 | |12;stanford-crypto-pbkdf2;175;178;179;178;179;174;174;184;173;176 03:55:09 INFO - PID 31601 | |13;stanford-crypto-sha256-iterative;68;75;67;69;66;67;66;71;66;66 03:55:09 INFO - PID 31601 | __end_tp_report 03:55:09 INFO - PID 31601 | __start_cc_report 03:55:09 INFO - PID 31601 | _x_x_mozilla_cycle_collect,970 03:55:09 INFO - PID 31601 | __end_cc_report 03:55:09 INFO - PID 31601 | __startTimestamp1501757709820__endTimestamp 03:55:09 INFO - PID 31601 | 03:55:09 INFO - PID 31601 | ------- Summary: start ------- 03:55:09 INFO - PID 31601 | Number of tests: 14 03:55:09 INFO - PID 31601 | 03:55:09 INFO - PID 31601 | [#0] ai-astar Cycles:10 Average:107.60 Median:111.50 stddev:5.23 (4.7%) stddev-sans-first:4.24 03:55:09 INFO - PID 31601 | Values: 98.0 108.0 105.0 108.0 108.0 112.0 113.0 100.0 111.0 113.0 03:55:09 INFO - PID 31601 | 03:55:09 INFO - PID 31601 | [#1] audio-beat-detection Cycles:10 Average:145.60 Median:150.50 stddev:21.10 (14.0%) stddev-sans-first:22.16 03:55:09 INFO - PID 31601 | Values: 154.0 128.0 141.0 188.0 134.0 147.0 156.0 118.0 165.0 125.0 03:55:09 INFO - PID 31601 | 03:55:09 INFO - PID 31601 | [#2] audio-dft Cycles:10 Average:165.80 Median:165.00 stddev:4.39 (2.7%) stddev-sans-first:4.50 03:55:09 INFO - PID 31601 | Values: 169.0 165.0 164.0 163.0 162.0 166.0 177.0 165.0 164.0 163.0 03:55:09 INFO - PID 31601 | 03:55:09 INFO - PID 31601 | [#3] audio-fft Cycles:10 Average:92.90 Median:75.50 stddev:33.85 (44.8%) stddev-sans-first:35.35 03:55:09 INFO - PID 31601 | Values: 76.0 75.0 74.0 165.0 76.0 74.0 77.0 75.0 147.0 90.0 03:55:09 INFO - PID 31601 | 03:55:09 INFO - PID 31601 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:79.00 stddev:25.62 (32.4%) stddev-sans-first:26.52 03:55:09 INFO - PID 31601 | Values: 79.0 78.0 131.0 81.0 79.0 79.0 132.0 78.0 79.0 133.0 03:55:09 INFO - PID 31601 | 03:55:09 INFO - PID 31601 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:115.50 stddev:1.64 (1.4%) stddev-sans-first:1.51 03:55:09 INFO - PID 31601 | Values: 113.0 117.0 117.0 115.0 116.0 114.0 114.0 115.0 118.0 114.0 03:55:09 INFO - PID 31601 | 03:55:09 INFO - PID 31601 | [#6] imaging-darkroom Cycles:10 Average:153.00 Median:152.50 stddev:3.80 (2.5%) stddev-sans-first:3.96 03:55:09 INFO - PID 31601 | Values: 155.0 151.0 152.0 150.0 150.0 151.0 150.0 162.0 153.0 156.0 03:55:09 INFO - PID 31601 | 03:55:09 INFO - PID 31601 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:96.00 stddev:2.50 (2.6%) stddev-sans-first:2.47 03:55:09 INFO - PID 31601 | Values: 94.0 102.0 94.0 95.0 98.0 99.0 96.0 95.0 96.0 97.0 03:55:09 INFO - PID 31601 | 03:55:09 INFO - PID 31601 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:57.50 stddev:3.27 (5.7%) stddev-sans-first:3.38 03:55:09 INFO - PID 31601 | Values: 56.0 57.0 58.0 57.0 60.0 56.0 57.0 66.0 59.0 54.0 03:55:09 INFO - PID 31601 | 03:55:09 INFO - PID 31601 | [#9] json-stringify-tinderbox Cycles:10 Average:55.90 Median:54.50 stddev:4.36 (8.0%) stddev-sans-first:4.60 03:55:09 INFO - PID 31601 | Values: 57.0 54.0 54.0 54.0 68.0 55.0 54.0 55.0 54.0 54.0 03:55:09 INFO - PID 31601 | 03:55:09 INFO - PID 31601 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:81.00 stddev:6.32 (7.8%) stddev-sans-first:6.44 03:55:09 INFO - PID 31601 | Values: 77.0 80.0 78.0 82.0 78.0 93.0 84.0 80.0 93.0 75.0 03:55:09 INFO - PID 31601 | 03:55:09 INFO - PID 31601 | [#11] stanford-crypto-ccm Cycles:10 Average:136.10 Median:133.00 stddev:11.58 (8.7%) stddev-sans-first:12.23 03:55:09 INFO - PID 31601 | Values: 133.0 133.0 133.0 143.0 132.0 123.0 133.0 144.0 124.0 163.0 03:55:09 INFO - PID 31601 | 03:55:09 INFO - PID 31601 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.00 Median:178.00 stddev:3.30 (1.9%) stddev-sans-first:3.42 03:55:09 INFO - PID 31601 | Values: 175.0 178.0 179.0 178.0 179.0 174.0 174.0 184.0 173.0 176.0 03:55:09 INFO - PID 31601 | 03:55:09 INFO - PID 31601 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:67.50 stddev:2.92 (4.3%) stddev-sans-first:3.10 03:55:09 INFO - PID 31601 | Values: 68.0 75.0 67.0 69.0 66.0 67.0 66.0 71.0 66.0 66.0 03:55:09 INFO - PID 31601 | -------- Summary: end -------- 03:55:09 INFO - PID 31601 | 03:55:10 INFO - PID 31601 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:55:10 INFO - TEST-INFO | 31601: exit 0 03:55:10 INFO - TEST-OK | kraken | took 63347ms 03:55:10 INFO - SUITE-END | took 1177s 03:55:10 INFO - Completed test suite (00:19:37) 03:55:10 INFO - javascript benchmark 03:55:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8552.060374624769, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3139.4819854723974, 3151.4327421064213, 3170.5878235829337, 3184.156198607368, 3207.9679203207975, 6116.052011938145, 6178.5057195424315, 6204.47261982732, 6238.469730072944, 6239.812805615838, 6016.548758843082, 6163.198784158064, 6164.938350616492, 6175.660338681382, 6191.566590338678, 5625.324961004665, 5662.915056274159, 5677.545796336304, 5698.0313346730945, 5747.2241247431475, 5655.434456554352, 5712.343080545728, 5713.257276554063, 5727.541796656257, 5744.569157313197, 5437.864053398657, 5590.692511911843, 5640.0, 5692.288463942007, 5708.22938903249, 5604.3835178130375, 5680.5455563554815, 5691.9146212806845, 5692.37383887772, 5702.173184888209, 5555.30558680165, 5565.471280228372, 5618.494335509824, 5648.604597678164, 5653.773849046033, 6011.3086994995265, 6087.391260873921, 6113.877722445526, 6146.569740118193, 6185.103160041814, 6600.273969863311, 6604.669766511655, 6623.867522649568, 6649.833754156137, 6654.467642588581, 6626.237982632011, 6659.500537459709, 6735.191776986744, 6741.224759152662, 6744.359285867835, 6036.728347224385, 6128.816135515942, 6149.477294430024, 6232.096346029845, 6241.594296370721, 6753.08833307507, 6778.76274330406, 6795.082663840417, 6800.897986530206, 6806.727730890709, 6429.0, 6477.708503117371, 6592.703328350236, 6593.505487088391, 6600.0, 6682.064510968468, 6688.665566721645, 6703.93296067033, 6706.429953454011, 6708.027336036247, 6600.339966003361, 6605.570637908617, 6615.272320044791, 6641.66791660415, 6695.933040669531, 6499.935000650027, 6576.967115164489, 6604.405603495708, 6689.264180940093, 6707.731690732316, 5309.33633295838, 5324.7870085196155, 5327.360716714019, 5331.653442526223, 5332.626716129834, 4585.95414045862, 4594.563516465931, 4598.678092533491, 4624.421947256593, 4644.535546445396, 5747.109198074305, 5785.971070144622, 5788.479036886616, 5790.884182316414, 5797.826065218051, 6636.701348439332, 6689.163854518185, 6695.933040669628, 6719.428848547928, 6725.6973436195485, 5761.366249712528, 5841.912371314434, 5844.12338149281, 5846.210761547221, 5863.0325996211, 5822.272215973004, 5829.679367634821, 5899.144624029492, 5900.586958912921, 5901.704914754245, 6306.716197771111, 6411.903821442682, 6434.2600600930555, 6452.0, 6517.608943463408, 6679.632620205935, 6697.531172817856, 6718.664066796739, 6735.6295403753265, 6748.595084294958, 6443.581167224115, 6500.5449618526245, 6505.544611877123, 6521.9673901630185, 6523.64119973406, 6519.217693876765, 6536.182977127859, 6609.306022867722, 6615.66921653925, 6659.900101498384, 6582.3746744059235, 6628.6022838627905, 6684.83287917806, 6756.223034350916, 6762.425193858577, 6403.583767055126, 6428.678566071584, 6428.710708018057, 6484.1894763154605, 6488.318726533646, 6446.806595802133, 6450.387213214737, 6454.677266136769, 6455.741770329322, 6515.0, 6030.125631783455, 6389.041643753474, 6440.13058237132, 6463.903041454288, 6467.773627923, 6414.262359828493, 6506.544541882023, 6509.121268628864, 6565.671716414065, 6588.275289718032, 6223.37766223374, 6294.24469063697, 6312.968435157794, 6377.202849643794, 6391.265004524354], "value": 6061.258726566533, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [843.4138273899638, 876.6975393489246, 904.0597778310557, 906.5557876640448, 1193.3794426898007, 32211.67788322116, 43129.78435107824, 43380.34929476053, 43483.56516434834, 43514.0, 43457.56542434575, 43845.78077109618, 43878.0, 43939.56060439395, 43984.34023489642, 7368.5210461319975, 7984.880226796603, 7988.920110798905, 7993.640286187136, 7996.0, 7868.701664225396, 7958.283754462097, 7979.760607181794, 7994.920050799505, 7996.200379962015, 7944.920550794504, 7970.760877173665, 7978.441509094366, 8000.799980000517, 8029.237222463857, 7939.920600793976, 7963.8805417918775, 7988.001499812494, 7994.3204827589725, 7995.160508146619, 7872.0, 7929.4845835021115, 7930.0880398753725, 7930.762077137695, 7932.960335198287, 40582.188356233004, 40689.593104068874, 40794.0, 40800.18399631991, 40955.385669214986, 3489.9302013959577, 3534.6465353464705, 3542.025942865707, 3544.1848374873925, 3546.6098729139776, 32748.67251327504, 33152.6684733152, 33298.16754581131, 33353.16617084568, 33397.499037514455, 4827.08285425768, 4989.301497790312, 5009.298698182258, 5027.321311622957, 5032.723200223986, 204036.0, 204657.0, 204776.0, 204868.0, 205378.0, 52008.73995629998, 52011.219831702554, 52212.0, 52237.47762522402, 52334.73832630813, 54835.72582137064, 54837.451625484035, 54862.0, 55072.44927550753, 55516.16725749117, 15114.09315441077, 15291.082535047934, 16546.66906661884, 16948.661026779395, 16967.406140785013, 12713.0, 14148.85851141496, 14296.57110286693, 14353.712925741427, 14355.210463424612, 14970.62573435651, 15187.772183417257, 15246.161461119524, 15251.542453726406, 15427.30577124032, 5769.59612827098, 5967.701614919237, 6133.1413602095745, 6134.44789968896, 6144.354842741537, 996.1681995533811, 1007.385494848142, 1008.3647302199714, 1011.0900189829213, 1013.5084484025242, 23372.415689607897, 29818.254543636584, 29923.551146732818, 30027.549586756217, 30640.08079757611, 1088.1947358954476, 1096.9122470202365, 1103.8344248362648, 1104.0670633314837, 1112.6439539347493, 12447.253164810141, 12807.679808004874, 13055.738885222243, 13067.346632668328, 13121.671958201121, 236724.0, 238736.0, 239084.0, 239149.0, 239292.0, 57210.0, 57888.0, 58010.70994645, 58025.70987145037, 58093.0, 1438.74821906166, 1500.6248437890745, 1524.2531159731652, 1524.5883611425074, 1539.599704076948, 23966.041358346167, 28370.85814570914, 28686.56970145408, 28801.0, 29314.0, 56026.43973560212, 56881.0, 56955.71522142363, 57002.714986424806, 57019.144712828514, 227450.0, 227699.0, 228019.0, 229261.0, 232008.0, 33888.322233555686, 34248.0, 34257.48613770845, 37139.81430092832, 37576.0, 45193.0, 46428.767856160506, 47620.28569571528, 47671.0, 48073.27890081722, 33792.0, 34268.0, 34312.82843585866, 34441.48337774885, 34721.479177811845, 33717.325653487285, 33841.0, 33863.153421164665, 34015.65984340125, 34369.48445773265, 36669.816650916575, 37291.44062839005, 37389.81305093457, 37413.25173496569, 40439.0, 35326.0, 35448.93653190408, 35705.74639356092, 36104.819475902455, 36274.455883161245, 24603.876980614983, 25237.369065773502, 25377.365565861, 25629.487410251317, 25793.613095803954], "value": 18369.448706798903, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.4485294117646, 576.3947854752508, 582.3689297231762, 587.8207146820218, 601.7171929193279, 22553.661695074567, 22873.199438019674, 23096.30711078666, 23099.653505197413, 23410.414739631495, 26630.33424164397, 26882.327941801417, 27114.1865744028, 27360.863195684044, 27395.45209095817, 6627.271000189975, 6796.626185559792, 6800.523963322569, 6802.285759995203, 6809.148856392951, 6291.465225455819, 6626.37049480301, 6658.600483970953, 6675.8331041724105, 6722.226943901441, 6555.475561955056, 6560.343965603425, 6570.441512471446, 6574.835629109262, 6578.079068930354, 6550.246721627002, 6553.049807777893, 6575.638339891304, 6579.111819904299, 6581.308962558935, 6089.117078023662, 6099.45104940553, 6126.142340072393, 6130.632162070246, 6141.692915354214, 29951.0, 30324.0, 30592.388152236832, 30607.540886886716, 31231.531527027113, 1873.2319748903021, 1924.316867512027, 1924.874883132592, 1925.6148770245866, 1926.2776458827939, 18678.813211867844, 19357.322493712792, 19413.611727765507, 19440.80559194404, 19461.513462163417, 2269.54609078185, 2329.580675478413, 2349.8707571083582, 2359.6106642403984, 2415.118481754165, 139388.0, 147216.52783472135, 147532.26233868868, 147848.0, 147980.2600986999, 14893.70212595742, 14999.550013499613, 15165.545033649008, 15236.314365853563, 16008.519744407686, 23569.764302356758, 23869.641955370684, 23883.52232955366, 23963.880180598986, 24043.639345409832, 9880.802383952281, 9967.750806229757, 10031.545425913202, 10045.79908401828, 10286.639967601099, 9116.453012819253, 9124.81750364989, 9201.677941272023, 9234.86147707785, 9237.722868313962, 7918.376732769769, 8810.515421651871, 8896.822063558693, 8913.643454261886, 9199.528075507887, 2636.116900838202, 2667.213172114231, 2703.45930813838, 2710.6069619905, 2778.9444211115665, 926.282131348197, 942.533445944262, 949.5252373813094, 967.4727273635885, 972.8832540095234, 19235.13441895118, 19606.803931960498, 24169.395765105663, 25603.87198063998, 26341.604875926878, 1030.4950574218578, 1032.746976990627, 1035.089121573026, 1047.675220681591, 1056.5245639462273, 10907.291026083438, 10969.670909872717, 11103.333799971866, 11186.384748838893, 11379.487923043484, 480890.0, 482900.0, 490624.0, 492752.0, 501108.0, 113785.0, 126232.0, 127861.0, 128139.0, 128640.0, 1237.2823762217893, 1280.7310464802497, 1298.68831480444, 1314.493919840868, 1315.6908126590245, 20499.0, 20742.792572074086, 20883.37349879506, 20916.37250882476, 21014.0, 55306.0, 55974.72012640074, 56337.154942676716, 58036.419635803104, 58235.417645823, 73603.0, 73768.26231737614, 74589.0, 74693.62653186699, 74715.0, 12322.568710095104, 12950.546730864751, 13974.650633734238, 14583.85416145825, 14857.182854943081, 19545.60908781788, 20080.19679212815, 20327.8983605081, 20516.589668206852, 20634.793652063287, 18264.81735182631, 18435.262589496808, 18551.72172417388, 18589.907050464662, 18665.160067797253, 16065.19674016318, 16136.273867675747, 16300.347986080898, 16314.102724350274, 17678.64642707113, 18050.458486245432, 18764.7185292218, 18950.52623684419, 19162.52093697613, 19216.807831921502, 14231.430742770173, 14564.708705825613, 14607.050541714754, 14622.707545849236, 14662.706745865236, 17709.734353984444, 17831.197596107948, 17869.642607148045, 17954.0, 18311.90844045771], "value": 12101.919957714226, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.8794108530233, 1368.9520866769665, 1390.3604342002677, 1399.8810101141405, 1407.3244842475613, 13646.2494562799, 14079.859201407982, 14400.0, 14402.423903043878, 14404.783928241071, 14628.34172462239, 14869.256537173153, 14914.030588011772, 14924.0, 14926.328315225814, 2536.5053814506177, 2557.8465292082533, 2563.333533281351, 2570.434504409027, 2663.2143517662334, 2749.0, 2787.6236708044357, 2790.883646541379, 2791.595218693298, 2794.2874566985392, 2638.353603367168, 2682.557378032622, 2710.2953232159584, 2713.186044186746, 2717.605947137664, 2558.2453176313034, 2583.4962182374443, 2583.7932965362725, 2648.8808003639883, 2719.9592006119924, 2607.4524349886547, 2619.2404202781363, 2647.669041369829, 2647.973520264811, 2649.0595838477448, 13298.800517992238, 13510.05429619927, 13550.0, 13565.982551308593, 13570.45718171272, 7551.584662843541, 7765.456418050739, 7779.611019449005, 7811.687532498693, 7817.648205830695, 5180.352455943007, 5270.947290527084, 5313.0, 5424.511793938525, 5425.159100339453, 1685.2584862660512, 1722.7846519185102, 1733.306677329066, 1758.7625670534442, 1760.3486709917283, 22917.31248062561, 23114.768852311598, 23189.88405057964, 23209.3037208884, 23223.88388058066, 6383.744650213939, 6603.514209302868, 6658.933410665928, 6810.182778066564, 6843.418309443654, 16115.919420402823, 16187.19064046793, 16213.837861621232, 16216.837831621533, 16218.270177842025, 7368.410527157815, 7466.962665186639, 7504.924950750423, 7513.924860751432, 7520.699172033167, 5878.794242201588, 6148.661823599656, 6373.139626150503, 6413.807585772434, 6915.377616014583, 5105.7191854448365, 5228.581713462914, 5300.655457395334, 5354.892902142014, 5356.839294821161, 1468.3759402254213, 1530.6632540840997, 1559.407425178425, 1566.3108232377717, 1579.2498563182396, 876.145757886056, 900.7522931193975, 901.8376692195468, 903.7108125399809, 914.1407077347272, 7161.462890283249, 7192.964035179791, 7209.279072092749, 7284.980102785615, 7365.0, 735.2243383230743, 738.1253214940313, 750.53091817614, 757.7499425189674, 961.8172547216006, 4697.859064228079, 4724.598409135193, 4776.737279449594, 4819.397575303087, 5003.4746351633285, 19276.90361548183, 19361.903190483958, 19840.206391744458, 19970.30103946355, 19999.500012499513, 18422.171002304927, 19396.0, 19524.12141453638, 19529.121189546506, 19585.412437626896, 10276.383416995004, 10570.048695617277, 10583.417912014913, 10601.151907847354, 10605.992430719223, 7378.5437741975775, 7944.44388892772, 7972.760817175494, 8046.959765201371, 8263.214994575506, 16654.833451665814, 17037.48887533376, 17255.0, 17274.913625431793, 17313.82686173122, 17442.91278543599, 17550.82449175543, 17653.470395888144, 17655.38206162778, 17691.115444227995, 13064.0, 13192.934035329761, 13258.86741132615, 13357.0, 13406.93296533511, 13024.54414095502, 13196.20822750638, 13196.736065278448, 13210.867891320964, 13217.206967581977, 9350.3454758169, 10047.949760251444, 10571.62999295021, 10617.787644247226, 10712.946435267773, 10208.693739187836, 10260.435676037889, 10441.112505436819, 10486.842697359698, 10597.099246564128, 9079.182873541413, 9229.35394522377, 9240.0, 9242.861357079784, 9244.075592440702, 6975.337342952412, 6976.825579360557, 6986.266442023514, 6990.545614535039, 7033.788986330418, 6802.319768023158, 6882.4149947253045, 6905.965470172818, 6917.204521480095, 6922.169339679271], "value": 6327.862560417212, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.92938639142693, 498.46472863580175, 517.7851191755419, 519.2082074835872, 523.1890569617094, 6169.722362493693, 6261.624302541851, 6285.811425657238, 6304.71628776705, 6306.59007164534, 5868.61853979491, 6080.0, 6093.756249750016, 6102.626908945485, 6207.0, 4875.536824001714, 4880.926196236822, 4893.7063776173545, 4905.607551395879, 4915.336429582015, 4849.296851956464, 4858.4695820816505, 4909.828156014541, 4918.114739346916, 4921.483244259355, 4705.9058818823605, 4738.549837765424, 4780.282957556359, 4893.632977526682, 4916.213405855064, 4801.711897286139, 4839.830605928793, 4869.610431165498, 4872.366592343008, 4902.558769710708, 4334.609885110323, 4356.934645980313, 4378.452693413324, 4405.8678239652545, 4449.7997590108525, 6116.663583502906, 6153.200083989098, 6163.137160797492, 6182.412670796267, 6196.411340922605, 5655.26481557399, 5657.773689052433, 5659.40576239493, 5683.886322273573, 5685.118806584986, 6478.643674597895, 6481.384268494486, 6577.243616984012, 6602.834929126762, 6661.16735408074, 4753.47711751707, 4799.112164249625, 4824.131656301899, 4826.276058591205, 4830.661853670244, 6713.295104014106, 6810.62541560214, 6868.278830722752, 6884.345987131214, 6928.272531384233, 4833.516648335209, 4892.975535122301, 4982.476839931827, 4987.351644286292, 4994.001199760062, 4935.506449355107, 4959.355283813154, 4987.950120498821, 4991.0, 5036.823711170092, 5601.159826026129, 5613.410591887875, 5620.241267428926, 5623.887522249532, 5666.46168613981, 6447.9355206447335, 6485.383888530582, 6570.5729127606555, 6606.933930660728, 6641.236257830411, 1616.4342480131859, 1657.7927759030122, 1712.8715346349074, 1742.4511278947346, 1743.7733094697862, 1390.4994202087241, 1397.7344304582098, 1404.2136403614008, 1417.5747275817214, 1429.9142051476945, 5662.178984047372, 5704.486596206361, 5724.227229324071, 5751.252337196138, 5759.222504961776, 6506.60960342381, 6552.541322107502, 6565.505108058907, 6596.4393026592315, 6710.228323742735, 5759.0, 5770.798022069207, 5790.594658373873, 5822.505087067562, 5833.095870140135, 3557.1462848916076, 3572.8749493767596, 3580.803055831954, 3583.032581203113, 3584.62361452049, 6395.296517383084, 6535.967320163369, 6595.868082638416, 6612.338766123349, 6618.602883826986, 6825.088975086984, 6884.934519644187, 6939.75710850128, 6962.050625824777, 7000.124984376953, 6432.9678351607945, 6455.903161452488, 6512.251091124582, 6571.539992200595, 6615.140031795836, 6642.335766423319, 6712.697928593323, 6747.561408508432, 6759.864802704017, 6781.220159681699, 6582.901256481061, 6633.3035031321015, 6702.162229721285, 6711.530192886451, 6720.462363011045, 6516.413522782972, 6564.803055908139, 6588.176477940257, 6591.835204119743, 6638.668066596748, 4944.134776414185, 4966.701997880139, 4971.726555039508, 4981.6014718823135, 4988.625853061108, 6652.733890644514, 6670.366315200048, 6718.798436046926, 6782.355676210752, 6806.0, 6535.738570457129, 6576.605403675795, 6595.142631457879, 6620.437262832713, 6632.1709786276715, 6503.804885853432, 6517.7067031984625, 6580.769673061612, 6588.209414870246, 6594.406503414716, 6155.076738489083, 6380.585261957958, 6449.7420103195345, 6547.770828020996, 6559.180102487189, 6247.3440288769025, 6426.389492998158, 6439.774607888701, 6441.878706428494, 6450.677466126769, 6232.4418895276185, 6239.563230573816, 6256.624602523863, 6256.812295631138, 6262.0], "value": 5041.899728847325, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [889.8754174415583, 907.0430695616125, 912.8265629530389, 925.6667599664124, 927.4296307770719, 16984.235709393077, 17729.734053989185, 17906.462806115804, 18032.54918627035, 20256.89871550644, 18758.53103672409, 18848.62302753944, 18858.33995810147, 18860.056997150157, 19053.52366190846, 978.1636700620974, 1012.1953047327393, 1014.1177175856997, 1028.8096702110097, 1029.711680729397, 1050.1703654113242, 1053.947302634865, 1054.104011590146, 1054.4095306628274, 1054.878688950769, 1016.2428990402124, 1093.1637297467444, 1100.2628239079836, 1101.1191047162279, 1101.124605938277, 1089.760252744399, 1090.8745494268182, 1090.9127269818396, 1091.5251865438481, 1091.9945400273027, 781.9687212511493, 782.0380931454287, 782.6634547144726, 782.7064850680995, 782.7338704840324, 16591.0, 17223.0, 17253.741193882102, 17272.654546909118, 17278.3952561661, 20238.595228095503, 20247.29134480301, 20672.276470323617, 20852.061657225462, 20913.8954305229, 14509.201993890332, 15172.696546069017, 15297.158656273901, 15381.230938453033, 15401.845981540266, 3482.4428091505238, 3522.189896323834, 3528.435450327935, 3548.1307079765365, 3549.5563054618174, 121996.0, 128134.0, 128268.0, 128542.0, 129733.0, 14875.776863347059, 15327.157006364534, 15417.922910385601, 15439.30523126462, 15441.613959651098, 29296.267593309913, 29692.0, 29895.850520747255, 29959.25101872427, 29966.85016574903, 8525.44584601999, 8935.508547029976, 9009.864852027225, 9021.684241051664, 9026.593803278869, 3603.4234522476277, 3787.5454945406727, 3787.981060094682, 3841.654251117413, 4018.557958624549, 4996.225585034325, 5150.4334523202415, 5156.767945442464, 5157.252198431206, 5162.535371816554, 982.8967958364411, 1026.4559783314855, 1039.163473403902, 1053.1732589916878, 1060.2260349944584, 657.3754932813846, 659.5317324699421, 667.4293479075418, 667.6428110960612, 694.4652617484509, 11636.301821890713, 11734.70663233426, 12198.634040978784, 12801.295928723823, 13222.801657975138, 672.176583684982, 688.2807466197835, 701.9508634395544, 702.034702284359, 707.2255879811598, 5512.724363781875, 5539.19681646159, 5629.0, 5705.5435565154685, 5834.329052159056, 98868.0, 103893.0, 105011.89976200434, 105423.0, 107448.0, 95771.0, 96875.0, 98636.50681746546, 98739.0, 99209.0, 83018.58490707508, 83658.5817070923, 84332.15667843366, 84609.0, 84635.0, 11844.940775296069, 11943.462544185359, 12129.150959432754, 12159.878401215874, 12299.93850030744, 36125.0, 37196.25607487781, 37504.249915001004, 38318.23363532769, 38471.422928655535, 64456.35543644503, 69193.65403172951, 69361.0, 69742.0, 70452.0, 19006.334778282693, 19662.901685492052, 19762.20951161995, 19793.703094453882, 19999.60000800005, 21564.137434502445, 21905.233316833834, 22189.55620887541, 22288.219912302993, 22361.888190558944, 19110.33113841009, 19271.325503607866, 19363.0, 19439.222431102597, 19781.10985005707, 19251.614967700287, 19303.51741206481, 19885.304014359426, 19939.302124425576, 19991.500212494804, 17546.473605791845, 18464.35374761877, 18866.0, 19329.903350483157, 19376.4187074388, 13191.602072994398, 13778.242196679279, 14187.858121419067, 14319.57041288763, 14702.926485367505, 13789.241591712553, 14772.852271477148, 14894.627634309229, 14953.700925981202, 15095.622609434851], "value": 9099.784606227091, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1548.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 108.0, 105.0, 108.0, 108.0, 112.0, 113.0, 100.0, 111.0, 113.0], "value": 107.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 128.0, 141.0, 188.0, 134.0, 147.0, 156.0, 118.0, 165.0, 125.0], "value": 145.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 165.0, 164.0, 163.0, 162.0, 166.0, 177.0, 165.0, 164.0, 163.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 165.0, 76.0, 74.0, 77.0, 75.0, 147.0, 90.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 131.0, 81.0, 79.0, 79.0, 132.0, 78.0, 79.0, 133.0], "value": 94.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 117.0, 115.0, 116.0, 114.0, 114.0, 115.0, 118.0, 114.0], "value": 115.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 151.0, 152.0, 150.0, 150.0, 151.0, 150.0, 162.0, 153.0, 156.0], "value": 153.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 102.0, 94.0, 95.0, 98.0, 99.0, 96.0, 95.0, 96.0, 97.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 58.0, 57.0, 60.0, 56.0, 57.0, 66.0, 59.0, 54.0], "value": 58.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 54.0, 54.0, 68.0, 55.0, 54.0, 55.0, 54.0, 54.0], "value": 55.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 80.0, 78.0, 82.0, 78.0, 93.0, 84.0, 80.0, 93.0, 75.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 133.0, 133.0, 143.0, 132.0, 123.0, 133.0, 144.0, 124.0, 163.0], "value": 136.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 178.0, 179.0, 178.0, 179.0, 174.0, 174.0, 184.0, 173.0, 176.0], "value": 177.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 75.0, 67.0, 69.0, 66.0, 67.0, 66.0, 71.0, 66.0, 66.0], "value": 68.1, "unit": "score"}]}]} 03:55:11 INFO - Return code: 0 03:55:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:55:11 INFO - # TBPL SUCCESS # 03:55:11 INFO - Running post-action listener: _package_coverage_data 03:55:11 INFO - Running post-action listener: _resource_record_post_action 03:55:11 INFO - [mozharness: 2017-08-03 10:55:11.108762Z] Finished run-tests step (success) 03:55:11 INFO - Running post-run listener: _resource_record_post_run 03:55:11 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 431157248; Read time: 12; Write time: 588720 03:55:11 INFO - TinderboxPrint: CPU usage
13.2% 03:55:11 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 03:55:11 INFO - TinderboxPrint: I/O write bytes / time
431,157,248 / 588,720 03:55:11 INFO - TinderboxPrint: CPU idle
8,278.3 (86.8%) 03:55:11 INFO - TinderboxPrint: CPU user
1,205.5 (12.6%) 03:55:11 INFO - TinderboxPrint: Swap in / out
0 / 0 03:55:11 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106598400; Read time: 0; Write time: 140500 03:55:11 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:55:11 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 323903488; Read time: 0; Write time: 448164 03:55:11 INFO - Running post-run listener: _upload_blobber_files 03:55:11 INFO - Blob upload gear active. 03:55:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:55:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:55:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:55:12 INFO - (blobuploader) - INFO - Open directory for files ... 03:55:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:55:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:55:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:13 INFO - (blobuploader) - INFO - Done attempting. 03:55:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:55:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:55:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:13 INFO - (blobuploader) - INFO - Done attempting. 03:55:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:55:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:55:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:14 INFO - (blobuploader) - INFO - Done attempting. 03:55:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:55:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:55:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:21 INFO - (blobuploader) - INFO - Done attempting. 03:55:21 INFO - (blobuploader) - INFO - Iteration through files over. 03:55:21 INFO - Return code: 0 03:55:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:55:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:55:21 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a43141b6d093c7a853c42705747e1bcc6299ba1f621047c890b759ab9171f67afb750074c2c6091938ec6d670f793b2ed27a1fed03db1b33624ee44ad30358ad", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d2f5b36a512391b84043d3ccb75bbacd36370172db4239632afc6a92327a829f86f126d92e6f6b1e7ef90cc947d034e42828016efecb9ffb4a4a996e4d1c538e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20c13da29c8b1724530918c783bb3cf021a026bd0f0ad9be490f5cb85aece09a17cddbb27c22199707c29011e0841a04df0871d4772cb2335900e057eeadd4b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2db7e2ef4d23bb29911fcca37b6426c45a3b9db5a0c0e87ef31952248e10af9b93f561733b67cfe0edc1a21bcd43dc82f5c28fa7b41fec870ede30b11e4466f0"} 03:55:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:55:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:55:21 INFO - Contents: 03:55:21 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a43141b6d093c7a853c42705747e1bcc6299ba1f621047c890b759ab9171f67afb750074c2c6091938ec6d670f793b2ed27a1fed03db1b33624ee44ad30358ad", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d2f5b36a512391b84043d3ccb75bbacd36370172db4239632afc6a92327a829f86f126d92e6f6b1e7ef90cc947d034e42828016efecb9ffb4a4a996e4d1c538e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20c13da29c8b1724530918c783bb3cf021a026bd0f0ad9be490f5cb85aece09a17cddbb27c22199707c29011e0841a04df0871d4772cb2335900e057eeadd4b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2db7e2ef4d23bb29911fcca37b6426c45a3b9db5a0c0e87ef31952248e10af9b93f561733b67cfe0edc1a21bcd43dc82f5c28fa7b41fec870ede30b11e4466f0"} 03:55:21 INFO - Running post-run listener: copy_logs_to_upload_dir 03:55:21 INFO - Copying logs to upload dir... 03:55:21 INFO - mkdir: /builds/slave/test/build/upload/logs 03:55:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.435495 ========= master_lag: 0.32 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-03 03:55:21.026771) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-03 03:55:21.031029) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1501749590.223143-1665967280 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a43141b6d093c7a853c42705747e1bcc6299ba1f621047c890b759ab9171f67afb750074c2c6091938ec6d670f793b2ed27a1fed03db1b33624ee44ad30358ad", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d2f5b36a512391b84043d3ccb75bbacd36370172db4239632afc6a92327a829f86f126d92e6f6b1e7ef90cc947d034e42828016efecb9ffb4a4a996e4d1c538e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20c13da29c8b1724530918c783bb3cf021a026bd0f0ad9be490f5cb85aece09a17cddbb27c22199707c29011e0841a04df0871d4772cb2335900e057eeadd4b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2db7e2ef4d23bb29911fcca37b6426c45a3b9db5a0c0e87ef31952248e10af9b93f561733b67cfe0edc1a21bcd43dc82f5c28fa7b41fec870ede30b11e4466f0"} build_url:https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011214 build_url: 'https://queue.taskcluster.net/v1/task/L44bNG-6R8C_EpcBDQJUNA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a43141b6d093c7a853c42705747e1bcc6299ba1f621047c890b759ab9171f67afb750074c2c6091938ec6d670f793b2ed27a1fed03db1b33624ee44ad30358ad", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d2f5b36a512391b84043d3ccb75bbacd36370172db4239632afc6a92327a829f86f126d92e6f6b1e7ef90cc947d034e42828016efecb9ffb4a4a996e4d1c538e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20c13da29c8b1724530918c783bb3cf021a026bd0f0ad9be490f5cb85aece09a17cddbb27c22199707c29011e0841a04df0871d4772cb2335900e057eeadd4b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2db7e2ef4d23bb29911fcca37b6426c45a3b9db5a0c0e87ef31952248e10af9b93f561733b67cfe0edc1a21bcd43dc82f5c28fa7b41fec870ede30b11e4466f0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-03 03:55:21.058134) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:55:21.058475) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1501749590.223143-1665967280 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:55:21.142652) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-03 03:55:21.143000) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-03 03:55:21.143322) ========= ========= Total master_lag: 0.56 =========