builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-039 starttime: 1464312265.9 results: success (0) buildid: 20160526154450 builduid: dcd6d57a3b5f4eeaaa3232260e68df0e revision: ed8629e891d9e655af2e1e79fe8c32e8cbcf44b5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 18:24:25.896584) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 18:24:25.897366) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 18:24:25.897906) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 18:24:25.915470) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 18:24:25.915739) ========= 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=5bd038846534b2fdfa68eeae000001e2-1464311654.180325-566984253 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-26 18:24:26-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 214M=0s 2016-05-26 18:24:26 (214 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099923 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 18:24:26.032137) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 18:24:26.032828) ========= 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=5bd038846534b2fdfa68eeae000001e2-1464311654.180325-566984253 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021315 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 18:24:26.083281) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 18:24:26.083638) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ed8629e891d9e655af2e1e79fe8c32e8cbcf44b5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev ed8629e891d9e655af2e1e79fe8c32e8cbcf44b5 --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=5bd038846534b2fdfa68eeae000001e2-1464311654.180325-566984253 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-26 18:24:26,474 truncating revision to first 12 chars 2016-05-26 18:24:26,474 Setting DEBUG logging. 2016-05-26 18:24:26,474 attempt 1/10 2016-05-26 18:24:26,474 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ed8629e891d9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-26 18:24:26,839 unpacking tar archive at: fx-team-ed8629e891d9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.673272 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 18:24:26.770086) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 18:24:26.770421) ========= script_repo_revision: ed8629e891d9e655af2e1e79fe8c32e8cbcf44b5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 18:24:26.770939) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 18:24:26.771542) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 18:24:26.780282) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-26 18:24:26.780601) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=5bd038846534b2fdfa68eeae000001e2-1464311654.180325-566984253 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:24:27 INFO - MultiFileLogger online at 20160526 18:24:27 in /builds/slave/test 18:24:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 18:24:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:24:27 INFO - {'append_to_log': False, 18:24:27 INFO - 'base_work_dir': '/builds/slave/test', 18:24:27 INFO - 'blob_upload_branch': 'Fx-Team', 18:24:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:24:27 INFO - 'branch': 'Fx-Team', 18:24:27 INFO - 'buildbot_json_path': 'buildprops.json', 18:24:27 INFO - 'config_files': ('talos/linux_config.py',), 18:24:27 INFO - 'default_actions': ('clobber', 18:24:27 INFO - 'read-buildbot-config', 18:24:27 INFO - 'download-and-extract', 18:24:27 INFO - 'populate-webroot', 18:24:27 INFO - 'create-virtualenv', 18:24:27 INFO - 'install', 18:24:27 INFO - 'run-tests'), 18:24:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:24:27 INFO - 'download_minidump_stackwalk': True, 18:24:27 INFO - 'download_symbols': 'ondemand', 18:24:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:24:27 INFO - 'tooltool.py': '/tools/tooltool.py', 18:24:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:24:27 INFO - '/tools/misc-python/virtualenv.py')}, 18:24:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:24:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:24:27 INFO - 'installer_path': 'installer.exe', 18:24:27 INFO - 'log_level': 'info', 18:24:27 INFO - 'log_name': 'talos', 18:24:27 INFO - 'log_to_console': True, 18:24:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:24:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:24:27 INFO - 'opt_config_files': (), 18:24:27 INFO - 'pip_index': False, 18:24:27 INFO - 'sps_profile': False, 18:24:27 INFO - 'sps_profile_interval': 0, 18:24:27 INFO - 'suite': 'dromaeojs', 18:24:27 INFO - 'system_bits': '32', 18:24:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:24:27 INFO - 'title': 'talos-linux64-ix-039', 18:24:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:24:27 INFO - 'use_talos_json': True, 18:24:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:24:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:24:27 INFO - 'work_dir': 'build'} 18:24:27 INFO - ##### 18:24:27 INFO - ##### Running clobber step. 18:24:27 INFO - ##### 18:24:27 INFO - Running pre-action listener: _resource_record_pre_action 18:24:27 INFO - Running main action method: clobber 18:24:27 INFO - rmtree: /builds/slave/test/build 18:24:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:24:28 INFO - Running post-action listener: _resource_record_post_action 18:24:28 INFO - ##### 18:24:28 INFO - ##### Finished clobber step (success) 18:24:28 INFO - ##### 18:24:28 INFO - ##### 18:24:28 INFO - ##### Running read-buildbot-config step. 18:24:28 INFO - ##### 18:24:28 INFO - Running pre-action listener: _resource_record_pre_action 18:24:28 INFO - Running main action method: read_buildbot_config 18:24:28 INFO - Using buildbot properties: 18:24:28 INFO - { 18:24:28 INFO - "project": "", 18:24:28 INFO - "product": "firefox", 18:24:28 INFO - "script_repo_revision": "production", 18:24:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:24:28 INFO - "repository": "", 18:24:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 18:24:28 INFO - "buildid": "20160526154450", 18:24:28 INFO - "pgo_build": "True", 18:24:28 INFO - "basedir": "/builds/slave/test", 18:24:28 INFO - "buildnumber": 721, 18:24:28 INFO - "slavename": "talos-linux64-ix-039", 18:24:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:24:28 INFO - "platform": "ubuntu64_hw", 18:24:28 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 18:24:28 INFO - "branch": "fx-team", 18:24:28 INFO - "repo_path": "integration/fx-team", 18:24:28 INFO - "revision": "ed8629e891d9e655af2e1e79fe8c32e8cbcf44b5", 18:24:28 INFO - "stage_platform": "linux64-pgo", 18:24:28 INFO - "builduid": "dcd6d57a3b5f4eeaaa3232260e68df0e", 18:24:28 INFO - "slavebuilddir": "test" 18:24:28 INFO - } 18:24:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/SwsAjrwvSfe5IvP9pY34OA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 18:24:28 INFO - Running post-action listener: _resource_record_post_action 18:24:28 INFO - ##### 18:24:28 INFO - ##### Finished read-buildbot-config step (success) 18:24:28 INFO - ##### 18:24:28 INFO - ##### 18:24:28 INFO - ##### Running download-and-extract step. 18:24:28 INFO - ##### 18:24:28 INFO - Running pre-action listener: _resource_record_pre_action 18:24:28 INFO - Running main action method: download_and_extract 18:24:28 INFO - mkdir: /builds/slave/test/build/tests 18:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:28 INFO - https://queue.taskcluster.net/v1/task/SwsAjrwvSfe5IvP9pY34OA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:24:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwsAjrwvSfe5IvP9pY34OA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:24:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwsAjrwvSfe5IvP9pY34OA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:24:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwsAjrwvSfe5IvP9pY34OA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:24:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwsAjrwvSfe5IvP9pY34OA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:24:29 INFO - Downloaded 1361 bytes. 18:24:29 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:24:29 INFO - Using the following test package requirements: 18:24:29 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 18:24:29 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:24:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:24:29 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:24:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:24:29 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:24:29 INFO - u'jsshell-linux-x86_64.zip'], 18:24:29 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:24:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:24:29 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 18:24:29 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:24:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:24:29 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:24:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:24:29 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:24:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:24:29 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:24:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:24:29 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:29 INFO - https://queue.taskcluster.net/v1/task/SwsAjrwvSfe5IvP9pY34OA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:24:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwsAjrwvSfe5IvP9pY34OA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:24:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwsAjrwvSfe5IvP9pY34OA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:24:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwsAjrwvSfe5IvP9pY34OA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:24:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwsAjrwvSfe5IvP9pY34OA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:24:41 INFO - Downloaded 24408308 bytes. 18:24:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:24:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:24:42 INFO - Return code: 0 18:24:42 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:24:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:42 INFO - https://queue.taskcluster.net/v1/task/SwsAjrwvSfe5IvP9pY34OA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:24:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwsAjrwvSfe5IvP9pY34OA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:24:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwsAjrwvSfe5IvP9pY34OA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:24:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwsAjrwvSfe5IvP9pY34OA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:24:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwsAjrwvSfe5IvP9pY34OA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:24:43 INFO - Downloaded 24408308 bytes. 18:24:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:24:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:24:44 INFO - Return code: 0 18:24:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:44 INFO - https://queue.taskcluster.net/v1/task/SwsAjrwvSfe5IvP9pY34OA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:24:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwsAjrwvSfe5IvP9pY34OA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 18:24:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwsAjrwvSfe5IvP9pY34OA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 18:24:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwsAjrwvSfe5IvP9pY34OA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 18:24:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwsAjrwvSfe5IvP9pY34OA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:24:45 INFO - Downloaded 10834034 bytes. 18:24:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:24:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 18:24:45 INFO - Return code: 0 18:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:45 INFO - https://queue.taskcluster.net/v1/task/SwsAjrwvSfe5IvP9pY34OA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:24:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwsAjrwvSfe5IvP9pY34OA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:24:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwsAjrwvSfe5IvP9pY34OA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:24:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwsAjrwvSfe5IvP9pY34OA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:24:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SwsAjrwvSfe5IvP9pY34OA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:24:47 INFO - Downloaded 58699999 bytes. 18:24:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SwsAjrwvSfe5IvP9pY34OA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:24:47 INFO - mkdir: /builds/slave/test/properties 18:24:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:24:47 INFO - Writing to file /builds/slave/test/properties/build_url 18:24:47 INFO - Contents: 18:24:47 INFO - build_url:https://queue.taskcluster.net/v1/task/SwsAjrwvSfe5IvP9pY34OA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:24:48 INFO - Running post-action listener: _resource_record_post_action 18:24:48 INFO - Running post-action listener: set_extra_try_arguments 18:24:48 INFO - ##### 18:24:48 INFO - ##### Finished download-and-extract step (success) 18:24:48 INFO - ##### 18:24:48 INFO - ##### 18:24:48 INFO - ##### Running populate-webroot step. 18:24:48 INFO - ##### 18:24:48 INFO - Running pre-action listener: _resource_record_pre_action 18:24:48 INFO - Running main action method: populate_webroot 18:24:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:24:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:24:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:24:48 INFO - '--tppagecycles', 18:24:48 INFO - '7'], 18:24:48 INFO - 'tests': ['tsvgm']}}, 18:24:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:24:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:24:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:24:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:24:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:24:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:24:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:24:48 INFO - 'talos_options': ['--disable-e10s'], 18:24:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:24:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:24:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:24:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:24:48 INFO - 'talos_options': ['--disable-e10s'], 18:24:48 INFO - 'tests': ['damp', 'tps']}, 18:24:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:24:48 INFO - 'tests': ['damp', 'tps']}, 18:24:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:24:48 INFO - 'tests': ['dromaeo_dom']}, 18:24:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:24:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:24:48 INFO - 'tests': ['a11yr', 18:24:48 INFO - 'ts_paint', 18:24:48 INFO - 'tpaint', 18:24:48 INFO - 'sessionrestore', 18:24:48 INFO - 'sessionrestore_no_auto_restore', 18:24:48 INFO - 'tabpaint']}, 18:24:48 INFO - 'other-e10s': {'tests': ['a11yr', 18:24:48 INFO - 'ts_paint', 18:24:48 INFO - 'tpaint', 18:24:48 INFO - 'sessionrestore', 18:24:48 INFO - 'sessionrestore_no_auto_restore', 18:24:48 INFO - 'tabpaint']}, 18:24:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:24:48 INFO - 'ts_paint', 18:24:48 INFO - 'tpaint', 18:24:48 INFO - 'sessionrestore', 18:24:48 INFO - 'sessionrestore_no_auto_restore', 18:24:48 INFO - 'tabpaint']}, 18:24:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:24:48 INFO - 'ts_paint', 18:24:48 INFO - 'tpaint', 18:24:48 INFO - 'sessionrestore', 18:24:48 INFO - 'sessionrestore_no_auto_restore', 18:24:48 INFO - 'tabpaint']}, 18:24:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:24:48 INFO - 'tests': ['a11yr', 18:24:48 INFO - 'ts_paint', 18:24:48 INFO - 'tpaint', 18:24:48 INFO - 'sessionrestore', 18:24:48 INFO - 'sessionrestore_no_auto_restore', 18:24:48 INFO - 'tabpaint']}, 18:24:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:24:48 INFO - 'tests': ['a11yr', 18:24:48 INFO - 'ts_paint', 18:24:48 INFO - 'tpaint', 18:24:48 INFO - 'sessionrestore', 18:24:48 INFO - 'sessionrestore_no_auto_restore', 18:24:48 INFO - 'tabpaint']}, 18:24:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:24:48 INFO - 'tests': ['tsvgx', 18:24:48 INFO - 'tsvgr_opacity', 18:24:48 INFO - 'tart', 18:24:48 INFO - 'tscrollx', 18:24:48 INFO - 'cart']}, 18:24:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:24:48 INFO - 'tsvgr_opacity', 18:24:48 INFO - 'tart', 18:24:48 INFO - 'tscrollx', 18:24:48 INFO - 'cart']}, 18:24:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:24:48 INFO - 'talos_options': ['--disable-e10s'], 18:24:48 INFO - 'tests': ['tp5o']}, 18:24:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:24:48 INFO - 'tests': ['tp5o']}, 18:24:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:24:48 INFO - 'talos_options': ['--disable-e10s', 18:24:48 INFO - '--xperf_path', 18:24:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:24:48 INFO - 'tests': ['tp5n']}, 18:24:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:24:48 INFO - 'talos_options': ['--xperf_path', 18:24:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:24:48 INFO - 'tests': ['tp5n']}}, 18:24:48 INFO - 'talos.zip': {'path': '', 18:24:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:24:48 INFO - Running post-action listener: _resource_record_post_action 18:24:48 INFO - ##### 18:24:48 INFO - ##### Finished populate-webroot step (success) 18:24:48 INFO - ##### 18:24:48 INFO - ##### 18:24:48 INFO - ##### Running create-virtualenv step. 18:24:48 INFO - ##### 18:24:48 INFO - Running pre-action listener: _resource_record_pre_action 18:24:48 INFO - Running main action method: create_virtualenv 18:24:48 INFO - Creating virtualenv /builds/slave/test/build/venv 18:24:48 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 18:24:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:24:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:24:48 INFO - Using real prefix '/usr' 18:24:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:24:48 INFO - Installing distribute.............................................................................................................................................................................................done. 18:24:50 INFO - Installing pip.................done. 18:24:50 INFO - Return code: 0 18:24:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:50 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f208d945f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b34770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc39c0>, '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 0x2bc48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464311654.180325-566984253', '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 18:24:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 18:24:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:24:50 INFO - Using env: {'DISPLAY': ':0', 18:24:50 INFO - 'HOME': '/home/cltbld', 18:24:50 INFO - 'LANG': 'en_US.UTF-8', 18:24:50 INFO - 'LANGUAGE': 'en_US:en', 18:24:50 INFO - 'LOGNAME': 'cltbld', 18:24:50 INFO - 'MAIL': '/var/mail/cltbld', 18:24:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:50 INFO - 'MOZ_NO_REMOTE': '1', 18:24:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:24:50 INFO - 'NO_EM_RESTART': '1', 18:24:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:24:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:50 INFO - 'PWD': '/builds/slave/test', 18:24:50 INFO - 'SHELL': '/bin/bash', 18:24:50 INFO - 'SHLVL': '1', 18:24:50 INFO - 'TERM': 'linux', 18:24:50 INFO - 'TMOUT': '86400', 18:24:50 INFO - 'USER': 'cltbld', 18:24:50 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464311654.180325-566984253', 18:24:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:50 INFO - '_': '/tools/buildbot/bin/python'} 18:24:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:50 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 18:24:50 INFO - Cleaning up... 18:24:50 INFO - Return code: 0 18:24:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:50 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f208d945f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b34770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc39c0>, '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 0x2bc48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464311654.180325-566984253', '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 18:24:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 18:24:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:24:50 INFO - Using env: {'DISPLAY': ':0', 18:24:50 INFO - 'HOME': '/home/cltbld', 18:24:50 INFO - 'LANG': 'en_US.UTF-8', 18:24:50 INFO - 'LANGUAGE': 'en_US:en', 18:24:50 INFO - 'LOGNAME': 'cltbld', 18:24:50 INFO - 'MAIL': '/var/mail/cltbld', 18:24:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:50 INFO - 'MOZ_NO_REMOTE': '1', 18:24:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:24:50 INFO - 'NO_EM_RESTART': '1', 18:24:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:24:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:50 INFO - 'PWD': '/builds/slave/test', 18:24:50 INFO - 'SHELL': '/bin/bash', 18:24:50 INFO - 'SHLVL': '1', 18:24:50 INFO - 'TERM': 'linux', 18:24:50 INFO - 'TMOUT': '86400', 18:24:50 INFO - 'USER': 'cltbld', 18:24:50 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464311654.180325-566984253', 18:24:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:50 INFO - '_': '/tools/buildbot/bin/python'} 18:24:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:51 INFO - Downloading/unpacking psutil>=3.1.1 18:24:51 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 18:24:51 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 18:24:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:51 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 18:24:51 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 18:24:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:24:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:24:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:24:53 INFO - Installing collected packages: psutil 18:24:53 INFO - Running setup.py install for psutil 18:24:53 INFO - building 'psutil._psutil_linux' extension 18:24:53 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 18:24:53 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 18:24:53 INFO - building 'psutil._psutil_posix' extension 18:24:53 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 18:24:53 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 18:24:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:24:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:24:53 INFO - Successfully installed psutil 18:24:53 INFO - Cleaning up... 18:24:53 INFO - Return code: 0 18:24:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:53 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f208d945f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b34770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc39c0>, '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 0x2bc48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464311654.180325-566984253', '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 18:24:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 18:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:24:53 INFO - Using env: {'DISPLAY': ':0', 18:24:53 INFO - 'HOME': '/home/cltbld', 18:24:53 INFO - 'LANG': 'en_US.UTF-8', 18:24:53 INFO - 'LANGUAGE': 'en_US:en', 18:24:53 INFO - 'LOGNAME': 'cltbld', 18:24:53 INFO - 'MAIL': '/var/mail/cltbld', 18:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:53 INFO - 'MOZ_NO_REMOTE': '1', 18:24:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:24:53 INFO - 'NO_EM_RESTART': '1', 18:24:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:53 INFO - 'PWD': '/builds/slave/test', 18:24:53 INFO - 'SHELL': '/bin/bash', 18:24:53 INFO - 'SHLVL': '1', 18:24:53 INFO - 'TERM': 'linux', 18:24:53 INFO - 'TMOUT': '86400', 18:24:53 INFO - 'USER': 'cltbld', 18:24:53 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464311654.180325-566984253', 18:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:53 INFO - '_': '/tools/buildbot/bin/python'} 18:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:24:53 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 18:24:53 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 18:24:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:53 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 18:24:53 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 18:24:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:24:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:24:55 INFO - Installing collected packages: mozsystemmonitor 18:24:55 INFO - Running setup.py install for mozsystemmonitor 18:24:55 INFO - Successfully installed mozsystemmonitor 18:24:55 INFO - Cleaning up... 18:24:56 INFO - Return code: 0 18:24:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:56 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f208d945f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b34770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc39c0>, '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 0x2bc48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464311654.180325-566984253', '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 18:24:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 18:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:24:56 INFO - Using env: {'DISPLAY': ':0', 18:24:56 INFO - 'HOME': '/home/cltbld', 18:24:56 INFO - 'LANG': 'en_US.UTF-8', 18:24:56 INFO - 'LANGUAGE': 'en_US:en', 18:24:56 INFO - 'LOGNAME': 'cltbld', 18:24:56 INFO - 'MAIL': '/var/mail/cltbld', 18:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:56 INFO - 'MOZ_NO_REMOTE': '1', 18:24:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:24:56 INFO - 'NO_EM_RESTART': '1', 18:24:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:56 INFO - 'PWD': '/builds/slave/test', 18:24:56 INFO - 'SHELL': '/bin/bash', 18:24:56 INFO - 'SHLVL': '1', 18:24:56 INFO - 'TERM': 'linux', 18:24:56 INFO - 'TMOUT': '86400', 18:24:56 INFO - 'USER': 'cltbld', 18:24:56 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464311654.180325-566984253', 18:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:56 INFO - '_': '/tools/buildbot/bin/python'} 18:24:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:56 INFO - Downloading/unpacking blobuploader==1.2.4 18:24:56 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 18:24:56 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 18:24:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:56 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 18:24:56 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 18:24:58 INFO - Downloading blobuploader-1.2.4.tar.gz 18:24:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:24:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:24:58 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 18:24:58 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 18:24:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:58 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 18:24:58 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 18:24:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:24:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:24:58 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 18:24:58 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 18:24:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:58 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 18:24:58 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 18:24:58 INFO - Downloading docopt-0.6.1.tar.gz 18:24:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:24:58 INFO - Installing collected packages: blobuploader, requests, docopt 18:24:58 INFO - Running setup.py install for blobuploader 18:24:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:24:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:24:59 INFO - Running setup.py install for requests 18:24:59 INFO - Running setup.py install for docopt 18:24:59 INFO - Successfully installed blobuploader requests docopt 18:24:59 INFO - Cleaning up... 18:24:59 INFO - Return code: 0 18:24:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:59 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f208d945f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b34770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc39c0>, '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 0x2bc48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464311654.180325-566984253', '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 18:24:59 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 18:24:59 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:24:59 INFO - Using env: {'DISPLAY': ':0', 18:24:59 INFO - 'HOME': '/home/cltbld', 18:24:59 INFO - 'LANG': 'en_US.UTF-8', 18:24:59 INFO - 'LANGUAGE': 'en_US:en', 18:24:59 INFO - 'LOGNAME': 'cltbld', 18:24:59 INFO - 'MAIL': '/var/mail/cltbld', 18:24:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:59 INFO - 'MOZ_NO_REMOTE': '1', 18:24:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:24:59 INFO - 'NO_EM_RESTART': '1', 18:24:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:24:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:59 INFO - 'PWD': '/builds/slave/test', 18:24:59 INFO - 'SHELL': '/bin/bash', 18:24:59 INFO - 'SHLVL': '1', 18:24:59 INFO - 'TERM': 'linux', 18:24:59 INFO - 'TMOUT': '86400', 18:24:59 INFO - 'USER': 'cltbld', 18:24:59 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464311654.180325-566984253', 18:24:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:59 INFO - '_': '/tools/buildbot/bin/python'} 18:24:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:24:59 INFO - Running setup.py (path:/tmp/pip-VaBRa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:24:59 INFO - Running setup.py (path:/tmp/pip-xaXIVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:24:59 INFO - Running setup.py (path:/tmp/pip-659X6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:24:59 INFO - Running setup.py (path:/tmp/pip-8bz7UV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:25:00 INFO - Running setup.py (path:/tmp/pip-HCtrNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:25:00 INFO - Running setup.py (path:/tmp/pip-2MSz0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:25:00 INFO - Running setup.py (path:/tmp/pip-k6IOgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:25:00 INFO - Running setup.py (path:/tmp/pip-QoJar4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:25:00 INFO - Running setup.py (path:/tmp/pip-BykDCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:25:00 INFO - Running setup.py (path:/tmp/pip-kdCBj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:25:00 INFO - Running setup.py (path:/tmp/pip-EOXd2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:25:00 INFO - Running setup.py (path:/tmp/pip-tsWXub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:25:00 INFO - Running setup.py (path:/tmp/pip-kDamM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:25:00 INFO - Running setup.py (path:/tmp/pip-6tA9Ax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:25:00 INFO - Running setup.py (path:/tmp/pip-x5Ipbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:25:00 INFO - Running setup.py (path:/tmp/pip-i7bHNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:25:00 INFO - Running setup.py (path:/tmp/pip-_Oxu6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:25:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:25:00 INFO - Running setup.py install for manifestparser 18:25:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:25:01 INFO - Running setup.py install for mozcrash 18:25:01 INFO - Running setup.py install for mozdebug 18:25:01 INFO - Running setup.py install for mozdevice 18:25:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:25:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:25:01 INFO - Running setup.py install for mozfile 18:25:01 INFO - Running setup.py install for mozhttpd 18:25:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:25:01 INFO - Running setup.py install for mozinfo 18:25:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:25:01 INFO - Running setup.py install for mozInstall 18:25:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:25:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:25:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:25:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:25:01 INFO - Running setup.py install for mozleak 18:25:01 INFO - Running setup.py install for mozlog 18:25:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:25:01 INFO - Running setup.py install for moznetwork 18:25:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:25:02 INFO - Running setup.py install for mozprocess 18:25:02 INFO - Running setup.py install for mozprofile 18:25:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:25:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:25:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:25:02 INFO - Running setup.py install for mozrunner 18:25:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:25:02 INFO - Running setup.py install for mozscreenshot 18:25:02 INFO - Running setup.py install for moztest 18:25:02 INFO - Running setup.py install for mozversion 18:25:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:25:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:25:02 INFO - Cleaning up... 18:25:02 INFO - Return code: 0 18:25:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:02 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f208d945f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b34770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc39c0>, '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 0x2bc48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464311654.180325-566984253', '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 18:25:02 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 18:25:02 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:25:02 INFO - Using env: {'DISPLAY': ':0', 18:25:02 INFO - 'HOME': '/home/cltbld', 18:25:02 INFO - 'LANG': 'en_US.UTF-8', 18:25:02 INFO - 'LANGUAGE': 'en_US:en', 18:25:02 INFO - 'LOGNAME': 'cltbld', 18:25:02 INFO - 'MAIL': '/var/mail/cltbld', 18:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:02 INFO - 'MOZ_NO_REMOTE': '1', 18:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:02 INFO - 'NO_EM_RESTART': '1', 18:25:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:02 INFO - 'PWD': '/builds/slave/test', 18:25:02 INFO - 'SHELL': '/bin/bash', 18:25:02 INFO - 'SHLVL': '1', 18:25:02 INFO - 'TERM': 'linux', 18:25:02 INFO - 'TMOUT': '86400', 18:25:02 INFO - 'USER': 'cltbld', 18:25:02 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464311654.180325-566984253', 18:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:02 INFO - '_': '/tools/buildbot/bin/python'} 18:25:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:25:02 INFO - Running setup.py (path:/tmp/pip-wkEOe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:25:03 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)) 18:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:25:03 INFO - Running setup.py (path:/tmp/pip-3c419R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 18:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:25:03 INFO - Running setup.py (path:/tmp/pip-ruVxgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:25:03 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)) 18:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:25:03 INFO - Running setup.py (path:/tmp/pip-mfB7bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 18:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:25:03 INFO - Running setup.py (path:/tmp/pip-vh0Agq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:25:03 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)) 18:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:25:03 INFO - Running setup.py (path:/tmp/pip-6ZW0LD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:25:03 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)) 18:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:25:03 INFO - Running setup.py (path:/tmp/pip-nhA4Dz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 18:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:25:03 INFO - Running setup.py (path:/tmp/pip-sJuuJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 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)) 18:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:25:03 INFO - Running setup.py (path:/tmp/pip-5olSpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:25:03 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)) 18:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:25:03 INFO - Running setup.py (path:/tmp/pip-ORfrcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 18:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:25:03 INFO - Running setup.py (path:/tmp/pip-X9zBFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:25:03 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)) 18:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:25:03 INFO - Running setup.py (path:/tmp/pip-SWj2Wd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 18:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:25:03 INFO - Running setup.py (path:/tmp/pip-BLJTdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:25:03 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)) 18:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:25:03 INFO - Running setup.py (path:/tmp/pip-NEOnQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 18:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:25:03 INFO - Running setup.py (path:/tmp/pip-eo7yjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:25:04 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)) 18:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:25:04 INFO - Running setup.py (path:/tmp/pip-3bfBdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 18:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:25:04 INFO - Running setup.py (path:/tmp/pip-FNTWIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:25:04 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)) 18:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:25:04 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)) 18:25:04 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:25:04 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:25:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:25: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 18:25: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 18:25:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:25:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:25: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 18:25: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 18:25:06 INFO - Downloading blessings-1.6.tar.gz 18:25:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:25:06 INFO - Installing collected packages: blessings 18:25:06 INFO - Running setup.py install for blessings 18:25:06 INFO - Successfully installed blessings 18:25:06 INFO - Cleaning up... 18:25:06 INFO - Return code: 0 18:25:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:25:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:25:06 INFO - Reading from file tmpfile_stdout 18:25:06 INFO - Current package versions: 18:25:06 INFO - argparse == 1.2.1 18:25:06 INFO - blessings == 1.6 18:25:06 INFO - blobuploader == 1.2.4 18:25:06 INFO - docopt == 0.6.1 18:25:06 INFO - manifestparser == 1.1 18:25:06 INFO - mozInstall == 1.12 18:25:06 INFO - mozcrash == 0.17 18:25:06 INFO - mozdebug == 0.1 18:25:06 INFO - mozdevice == 0.48 18:25:06 INFO - mozfile == 1.2 18:25:06 INFO - mozhttpd == 0.7 18:25:06 INFO - mozinfo == 0.9 18:25:06 INFO - mozleak == 0.1 18:25:06 INFO - mozlog == 3.2 18:25:06 INFO - moznetwork == 0.27 18:25:06 INFO - mozprocess == 0.22 18:25:06 INFO - mozprofile == 0.28 18:25:06 INFO - mozrunner == 6.11 18:25:06 INFO - mozscreenshot == 0.1 18:25:06 INFO - mozsystemmonitor == 0.3 18:25:06 INFO - moztest == 0.7 18:25:06 INFO - mozversion == 1.4 18:25:06 INFO - psutil == 3.1.1 18:25:06 INFO - requests == 1.2.3 18:25:06 INFO - wsgiref == 0.1.2 18:25:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:06 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f208d945f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b34770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc39c0>, '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 0x2bc48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464311654.180325-566984253', '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 18:25:06 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 18:25:06 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:25:06 INFO - Using env: {'DISPLAY': ':0', 18:25:06 INFO - 'HOME': '/home/cltbld', 18:25:06 INFO - 'LANG': 'en_US.UTF-8', 18:25:06 INFO - 'LANGUAGE': 'en_US:en', 18:25:06 INFO - 'LOGNAME': 'cltbld', 18:25:06 INFO - 'MAIL': '/var/mail/cltbld', 18:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:06 INFO - 'MOZ_NO_REMOTE': '1', 18:25:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:06 INFO - 'NO_EM_RESTART': '1', 18:25:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:06 INFO - 'PWD': '/builds/slave/test', 18:25:06 INFO - 'SHELL': '/bin/bash', 18:25:06 INFO - 'SHLVL': '1', 18:25:06 INFO - 'TERM': 'linux', 18:25:06 INFO - 'TMOUT': '86400', 18:25:06 INFO - 'USER': 'cltbld', 18:25:06 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464311654.180325-566984253', 18:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:06 INFO - '_': '/tools/buildbot/bin/python'} 18:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:07 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)) 18:25:07 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)) 18:25:07 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)) 18:25:07 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)) 18:25:07 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)) 18:25:07 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)) 18:25:07 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)) 18:25:07 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)) 18:25:07 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)) 18:25:07 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)) 18:25:07 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)) 18:25:07 INFO - Cleaning up... 18:25:07 INFO - Return code: 0 18:25:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:07 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f208d945f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b34770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc39c0>, '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 0x2bc48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464311654.180325-566984253', '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 18:25:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:25:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:25:07 INFO - Using env: {'DISPLAY': ':0', 18:25:07 INFO - 'HOME': '/home/cltbld', 18:25:07 INFO - 'LANG': 'en_US.UTF-8', 18:25:07 INFO - 'LANGUAGE': 'en_US:en', 18:25:07 INFO - 'LOGNAME': 'cltbld', 18:25:07 INFO - 'MAIL': '/var/mail/cltbld', 18:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:07 INFO - 'MOZ_NO_REMOTE': '1', 18:25:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:07 INFO - 'NO_EM_RESTART': '1', 18:25:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:07 INFO - 'PWD': '/builds/slave/test', 18:25:07 INFO - 'SHELL': '/bin/bash', 18:25:07 INFO - 'SHLVL': '1', 18:25:07 INFO - 'TERM': 'linux', 18:25:07 INFO - 'TMOUT': '86400', 18:25:07 INFO - 'USER': 'cltbld', 18:25:07 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464311654.180325-566984253', 18:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:07 INFO - '_': '/tools/buildbot/bin/python'} 18:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:07 INFO - Downloading/unpacking jsonschema 18:25:07 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 18:25:07 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 18:25:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:25:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:25:07 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 18:25:07 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 18:25:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:25:09 INFO - Downloading/unpacking functools32 (from jsonschema) 18:25:09 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 18:25:09 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 18:25:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:25:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:25:09 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 18:25:09 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 18:25:09 INFO - Downloading functools32-3.2.3-2.tar.gz 18:25:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:25:09 INFO - warning: no files found matching '*.txt' 18:25:09 INFO - no previously-included directories found matching 'build' 18:25:09 INFO - no previously-included directories found matching 'dist' 18:25:09 INFO - no previously-included directories found matching '.git*' 18:25:09 INFO - Installing collected packages: jsonschema, functools32 18:25:09 INFO - Running setup.py install for functools32 18:25:09 INFO - warning: no files found matching '*.txt' 18:25:09 INFO - no previously-included directories found matching 'build' 18:25:09 INFO - no previously-included directories found matching 'dist' 18:25:09 INFO - no previously-included directories found matching '.git*' 18:25:09 INFO - Successfully installed jsonschema functools32 18:25:09 INFO - Cleaning up... 18:25:09 INFO - Return code: 0 18:25:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:09 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f208d945f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b34770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc39c0>, '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 0x2bc48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464311654.180325-566984253', '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 18:25:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 18:25:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:25:09 INFO - Using env: {'DISPLAY': ':0', 18:25:09 INFO - 'HOME': '/home/cltbld', 18:25:09 INFO - 'LANG': 'en_US.UTF-8', 18:25:09 INFO - 'LANGUAGE': 'en_US:en', 18:25:09 INFO - 'LOGNAME': 'cltbld', 18:25:09 INFO - 'MAIL': '/var/mail/cltbld', 18:25:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:09 INFO - 'MOZ_NO_REMOTE': '1', 18:25:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:09 INFO - 'NO_EM_RESTART': '1', 18:25:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:09 INFO - 'PWD': '/builds/slave/test', 18:25:09 INFO - 'SHELL': '/bin/bash', 18:25:09 INFO - 'SHLVL': '1', 18:25:09 INFO - 'TERM': 'linux', 18:25:09 INFO - 'TMOUT': '86400', 18:25:09 INFO - 'USER': 'cltbld', 18:25:09 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464311654.180325-566984253', 18:25:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:09 INFO - '_': '/tools/buildbot/bin/python'} 18:25:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:09 INFO - Downloading/unpacking flake8 18:25:09 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 18:25:09 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 18:25:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:25:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:25:09 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 18:25:09 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 18:25:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:25:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:25:11 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 18:25:11 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 18:25:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:25:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:25:11 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 18:25:11 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 18:25:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:25:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:25: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 18:25: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 18:25:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:25:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:25: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 18:25: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 18:25:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:25: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 18:25: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 18:25:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:25:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:25: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 18:25: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 18:25:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:25:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:25:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:25:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:25:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:25:12 INFO - no previously-included directories found matching 'docs/_build' 18:25:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:25:12 INFO - Running setup.py install for pep8 18:25:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:25:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:25:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:25:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:25:12 INFO - no previously-included directories found matching 'docs/_build' 18:25:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:25:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:25:12 INFO - Cleaning up... 18:25:12 INFO - Return code: 0 18:25:12 INFO - Running post-action listener: _resource_record_post_action 18:25:12 INFO - Running post-action listener: _start_resource_monitoring 18:25:12 INFO - Starting resource monitoring. 18:25:12 INFO - ##### 18:25:12 INFO - ##### Finished create-virtualenv step (success) 18:25:12 INFO - ##### 18:25:12 INFO - ##### 18:25:12 INFO - ##### Running install step. 18:25:12 INFO - ##### 18:25:12 INFO - Running pre-action listener: _resource_record_pre_action 18:25:12 INFO - Running main action method: install 18:25:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:25:13 INFO - Reading from file tmpfile_stdout 18:25:13 INFO - Detecting whether we're running mozinstall >=1.0... 18:25:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:25:13 INFO - Reading from file tmpfile_stdout 18:25:13 INFO - Output received: 18:25:13 INFO - Usage: mozinstall [options] installer 18:25:13 INFO - Options: 18:25:13 INFO - -h, --help show this help message and exit 18:25:13 INFO - -d DEST, --destination=DEST 18:25:13 INFO - Directory to install application into. [default: 18:25:13 INFO - "/builds/slave/test"] 18:25:13 INFO - --app=APP Application being installed. [default: firefox] 18:25:13 INFO - mkdir: /builds/slave/test/build/application 18:25:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:25:29 INFO - Reading from file tmpfile_stdout 18:25:29 INFO - Output received: 18:25:29 INFO - /builds/slave/test/build/application/firefox/firefox 18:25:29 INFO - Running post-action listener: _resource_record_post_action 18:25:29 INFO - ##### 18:25:29 INFO - ##### Finished install step (success) 18:25:29 INFO - ##### 18:25:29 INFO - ##### 18:25:29 INFO - ##### Running run-tests step. 18:25:29 INFO - ##### 18:25:29 INFO - Running pre-action listener: _resource_record_pre_action 18:25:29 INFO - Running main action method: run_tests 18:25:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:25:29 INFO - Python 2.7.3 18:25:29 INFO - Return code: 0 18:25:29 INFO - grabbing minidump binary from tooltool 18:25:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:29 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 0x2bc39c0>, '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 0x2bc48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:25:29 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 18:25:29 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 18:25:29 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 18:25:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:25:29 INFO - Return code: 0 18:25:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:25:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:25:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:25:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:25:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:25:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:25:30 INFO - Return code: 0 18:25:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SwsAjrwvSfe5IvP9pY34OA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:25:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SwsAjrwvSfe5IvP9pY34OA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:25:30 INFO - Using env: {'DISPLAY': ':0', 18:25:30 INFO - 'HOME': '/home/cltbld', 18:25:30 INFO - 'LANG': 'en_US.UTF-8', 18:25:30 INFO - 'LANGUAGE': 'en_US:en', 18:25:30 INFO - 'LOGNAME': 'cltbld', 18:25:30 INFO - 'MAIL': '/var/mail/cltbld', 18:25:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:25:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:25:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:30 INFO - 'MOZ_NO_REMOTE': '1', 18:25:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:25:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:30 INFO - 'NO_EM_RESTART': '1', 18:25:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:30 INFO - 'PWD': '/builds/slave/test', 18:25:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:25:30 INFO - 'SHELL': '/bin/bash', 18:25:30 INFO - 'SHLVL': '1', 18:25:30 INFO - 'TERM': 'linux', 18:25:30 INFO - 'TMOUT': '86400', 18:25:30 INFO - 'USER': 'cltbld', 18:25:30 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464311654.180325-566984253', 18:25:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:30 INFO - '_': '/tools/buildbot/bin/python'} 18:25:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SwsAjrwvSfe5IvP9pY34OA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:25:31 INFO - mozversion application_buildid: 20160526154450 18:25:31 INFO - mozversion application_changeset: ed8629e891d9e655af2e1e79fe8c32e8cbcf44b5 18:25:31 INFO - mozversion application_display_name: Nightly 18:25:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:25:31 INFO - mozversion application_name: Firefox 18:25:31 INFO - mozversion application_remotingname: firefox 18:25:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:25:31 INFO - mozversion application_vendor: Mozilla 18:25:31 INFO - mozversion application_version: 49.0a1 18:25:31 INFO - mozversion platform_buildid: 20160526154450 18:25:31 INFO - mozversion platform_changeset: ed8629e891d9e655af2e1e79fe8c32e8cbcf44b5 18:25:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:25:31 INFO - mozversion platform_version: 49.0a1 18:25:31 INFO - using testdate: 1464312331 18:25:31 INFO - actual date: 1464312331 18:25:31 INFO - starting webserver on 'localhost:46572' 18:25:31 INFO - SUITE-START | Running 2 tests 18:25:31 INFO - TEST-START | dromaeo_css 18:25:31 INFO - operating with platform_type : linux_ 18:25:31 INFO - Initialising browser for dromaeo_css test... 18:25:31 INFO - TEST-INFO | started process 1317 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbQKCVv/profile http://localhost:46572/getInfo.html) 18:25:35 INFO - PROCESS | 1317 | __metrics Screen width/height:1600/1200 18:25:35 INFO - PROCESS | 1317 | colorDepth:24 18:25:35 INFO - PROCESS | 1317 | Browser inner width/height: 1024/697 18:25:35 INFO - PROCESS | 1317 | __metrics 18:25:36 ERROR - PROCESS | 1317 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:25:36 INFO - TEST-INFO | 1317: exit 0 18:25:36 INFO - Browser initialized. 18:25:36 INFO - Running cycle 1/1 for dromaeo_css test... 18:25:36 INFO - TEST-INFO | started process 1398 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbQKCVv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:25:48 INFO - PROCESS | 1398 | RSS: Main: 155574272 18:25:48 INFO - PROCESS | 1398 | 18:26:39 INFO - PROCESS | 1398 | 1464312399921 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:28:47 INFO - PROCESS | 1398 | Cycle 1(1): loaded http://localhost:46572/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46572/tests/dromaeo/cssquery-ext.html) 18:28:48 INFO - PROCESS | 1398 | RSS: Main: 257388544 18:28:48 INFO - PROCESS | 1398 | 18:31:51 INFO - PROCESS | 1398 | Cycle 1(1): loaded http://localhost:46572/tests/dromaeo/cssquery-ext.html (next: http://localhost:46572/tests/dromaeo/cssquery-jquery.html) 18:31:51 INFO - PROCESS | 1398 | RSS: Main: 243240960 18:31:51 INFO - PROCESS | 1398 | 18:34:53 INFO - PROCESS | 1398 | Cycle 1(1): loaded http://localhost:46572/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46572/tests/dromaeo/cssquery-mootools.html) 18:34:54 INFO - PROCESS | 1398 | RSS: Main: 245530624 18:34:54 INFO - PROCESS | 1398 | 18:37:56 INFO - PROCESS | 1398 | Cycle 1(1): loaded http://localhost:46572/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46572/tests/dromaeo/cssquery-prototype.html) 18:37:56 INFO - PROCESS | 1398 | RSS: Main: 238563328 18:37:56 INFO - PROCESS | 1398 | 18:40:59 INFO - PROCESS | 1398 | Cycle 1(1): loaded http://localhost:46572/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46572/tests/dromaeo/cssquery-yui.html) 18:41:00 INFO - PROCESS | 1398 | RSS: Main: 209453056 18:41:00 INFO - PROCESS | 1398 | 18:44:02 INFO - PROCESS | 1398 | Cycle 1(1): loaded http://localhost:46572/tests/dromaeo/cssquery-yui.html (next: http://localhost:46572/tests/dromaeo/cssquery-dojo.html) 18:44:02 INFO - PROCESS | 1398 | RSS: Main: 270094336 18:44:02 INFO - PROCESS | 1398 | 18:44:02 INFO - PROCESS | 1398 | __start_tp_report 18:44:02 INFO - PROCESS | 1398 | _x_x_mozilla_page_load 18:44:02 INFO - PROCESS | 1398 | _x_x_mozilla_page_load_details 18:44:02 INFO - PROCESS | 1398 | |i|pagename|runs| 18:44:02 INFO - PROCESS | 1398 | |0;dojo.html;3128.640206376266;3147.2446612812923;3172.2069482629336;3197.360527894422;3206.887758928438;5287.365516138059;5365.946340536593;5384.919226211605;5509.118541033436;5530.668159910403;5351.197320401941;5403.135498320269;5405.675659460425;5491.972540137293;5492.066348720717;4901.509849015097;4950.603951683856;5009.44896061433;5017.974910125445;5080.720560369178;4987.625928055392;5009.499050094998;5029.748512574357;5058;5058.064258112243;4806.59143972761;4842.29786680931;4849.539293767087;4853.587445067174;4877.000214955943;4830.106430310404;4852.296417019547;4897.41231052276;4911.852644420673;4964.67729597575;4796.808127674889;4862.051899879525;4877.951220487821;4901.534354236342;4922.655414121013;5266.078436273637;5372.597055220874;5379.193121031837;5424.918626220609;5453.918191227135;5866.384029676908;5868.207791948075;5890.087036509348;5892.204552385459;5892.558058145656;5558.44415558445;5665.773369065232;5718.1136923776885;5887.793927212527;5947.672877991708;5437.429069947678;5459.044667183227;5459.918101228484;5485.424030476783;5486.643368181056;5902;5913.172155898178;5972.970135149383;5975;5975.954208013581;5381.892362152735;5655.886882262332;5714.514266287412;5722.456366645162;5736.110902810071;5860.2967643883;5907;5907.261592300963;5909.113632955091;5916.3787802281;5777.740001699934;5786.566007549451;5791.305043394819;5791.478766910998;5792.8551786204835;5488.807891723771;5698.715064246771;5741.827745167651;5752.568557358215;5787.536997040227;4399.494058183286;4400.955990440055;4401.2517871961845;4401.493828209796;4437.622802061861;3802.296575133609;3906.4140378942816;3916.177602703407;3930.9803450983136;3937.842486300573;5394.487523685244;5397.73011349431;5452.618316717871;5540.279763630783;5544.750486228129;5852.648841069549;5887.5289976802605;5889.116632505073;5889.322727886262;5942.643441393444;5486.039943009957;5492.862678432991;5493.725313734298;5497.47773961473;5498.725063746797;4862.854114376574;4899.926501102486;4951.133551628451;4962.305277261186;4977.676451030671;5934.317553481319;5934.851628709231;5937.406259374115;5939.970300148558;5942.732577034044;5676.262085928803;5817.098349755879;5818;5825;5829.125631155361;5992.310884248367;6075.1798507200965;6100.938990610037;6117.480014198843;6127.908081378872;5791.362950075572;5792.507636850914;5821.155932389695;5827.6794776286015;5829.358770535323;5560.277163968658;5802.506786923159;5922.289325280994;5940.702964851826;5943.940560594338;5688.54491640676;5744.396838331915;5748.137779333133;5751.511121554715;5807.535397168132;5737.942620573741;5743.511801496919;5747.396523364986;5753.165790960204;5755.223044888887;5390.595705322195;5451.918221226764;5492.697901615449;5635.971820140873;5646.153077038312;5629.211910332639;5663.150527420919;5676;5682.374938756816;5687.630304030225;5539.695316757617;5543.695096769717;5545.750441230073;5548.889022219452;5587 18:44:02 INFO - PROCESS | 1398 | |1;ext.html;599.2060519811248;629.4932579273684;635.3265538529163;647.9092926990222;650.4178760009794;33023.174420639465;35981;44451.55548444518;45068.54931450685;45372;45115;45414.318785218165;45718.54281457185;45737.54262457375;45794.313085303664;8729.999999999984;8970.730878073668;8974.371793974424;8977.281817454588;8978.595963181673;8787.25308348791;8904.287656987426;8932.821343573125;8957.641694332218;8964.058773828752;8972.102789721008;8985.23625491834;9010.189082982562;9025.413348132382;9029.864552031691;8954.417962832427;8999.910000899972;9005.909940900605;9009.414388064755;9014.819703605892;8799.120087991214;8901.109889011112;8918.73243802687;8923.10768923109;8923.732288031304;42505.36241956373;42875;43011.35482967758;43057.13885722299;43067.56932430667;3587.964120358789;3640.4903313536124;3649.6897763689853;3717.628237176261;3928.88213353597;32561;32989.6701032989;33220;33790.49314260288;34442.31115377678;4359.324304732771;4378.824847006116;4395.516493185747;4399.296112621997;4433.490148632916;244650;244940;245294;245843;246385;31843.84078079595;59854;60151.69924150351;60213.69893150506;60289.39710602925;33742.662573374444;35567.82216088903;35580.28839423249;35604.465933010506;35758.463623045674;14313.928430357782;14462.638434039023;14491.20298383599;14496.34766435513;14497;12784.360781960864;12855.29295888735;12867.549635762703;12932.870671293354;12962.157459765085;8274.420790544724;8350.874736878952;8378;8416.284615807603;8422;3207.5188721691934;3264.588505012268;3265.2653153040374;3281.506914353963;3307.4542700454635;1040.4953597505205;1042.5604086437772;1115.4924509348227;1132.2357408749226;1137.4540220693948;32668.346633067205;33112.668873310955;33118.66881331156;33216.83391583075;33322.500162497585;1120.523777394604;1151.6314779270554;1178.6287319494331;1183.621241202807;1205.5057426455112;16705;17407;17505.7374139388;17578.91210543939;17717.822821771875;541849;545112;547790;548169;548607;60447.69776151091;61065;61097;61110.38889611047;61155.38844611586;1240.3736113262744;1376.2499437806418;1395.8255218097536;1401.5725203812935;1403.4947418929178;32775.836120819244;33992.320153596294;34127.31745365128;34396.65603343934;34546.65453345434;51795;52029.219561705846;52268.21597676114;52309.215361768845;52359;298660;299103;299405;300276;300653;24993;27139.72860271372;27926;27996.44007119887;28050.719492804812;48134.759326203144;48603.51396486131;48939.265911010654;49880.750596246784;50219.497805021485;41682.37476437795;42413.575864240964;43216;43383;43737.56262437335;42442;42480.1503969925;42715.35926961036;43052.35421468743;43285.70142895718;41309.79345103255;42036.57963420449;42546.787266063475;42575.7871210642;42610.78694606631;36037.47737658339;36827.57450037676;37518.2496350066;38253.61746382501;38587;28909.56635650425;29201.561976569945;29219.85390073036;29224.70775292305;29316 18:44:02 INFO - PROCESS | 1398 | |2;jquery.html;381.73660174479613;385.9150986782907;387.5156054931336;396.8670495384046;414.5253684531212;14513.49202777903;16971.49085527433;18490.445286641407;20124.4968875778;20137.697934530974;18632.906835465838;18712.625747485075;19245.230190792387;19619.803801961974;19629.50926226845;5521.171824226358;5578.497935185833;5700.515456186229;5709.400512946143;5715.799947001856;4089.8159582818844;5636.915446268309;5646.943530564703;5654.915176272339;6026.668533230671;6295.496360291166;6388.201474815648;6405.231372235338;6414.454771344442;6415.101885736;6242.719077641495;6323.430891219812;6372.1397611322345;6379.170707807978;6395.584287021329;5593.916091258634;5605.607607467479;5611.3546942101775;5619.241402410663;5651.689157096358;24338.148164814145;24882;25743;27572.724272757216;27607.585886211524;2390.8804559771943;2436.3665446983737;2539.5047965646704;2706.7624147275087;2708.295843080813;15658.765118523232;16347.673046539003;16388.6722265554;16515.91742041282;16951.83048169515;2136.42316574524;2141.550274442369;2178.59695956247;2270.2167752125492;2317.73346065203;94329;97297.5135124334;99067;100122.49938750333;101323.49338253336;17663.73504397435;17873.910630447026;18043.458696239133;18257.726134107997;18569.44291671252;26211.475770484485;28629.284267893054;30571.08286751401;32503.837480812446;32573.18567035843;9946.154576861049;9996.200303975664;10074.3955362677;10143.28996970205;10168.237382196365;8030.879536806952;8107.1892810718455;8218.63016164274;8365.498070115813;8423.595611737239;9161;9190.88144089882;9218.124278193562;9271.490068046322;9384.263911176455;3559.430491121408;3580.6419358064504;3592.3354179476883;3701.407774756026;3711.294853977736;909.417972497602;938.5166639180827;964.5322018820866;1091.4542728635681;1109.378747901178;18847.434576962714;19062.61874762497;19819.207231710858;19947.700784488243;19989.200431982557;1015.4668798880647;1024.7489365105596;1026.7997740440542;1038.2939601071344;1039.3088596083671;10460.73848153787;11152.386618736047;11176.385298808644;11196.216264861545;11214.775704486028;459901;467113;470783;478760;486821;91088;94292.52853735688;94556.52721736486;95636;96950.51524742332;1018.4805749067881;1028.9897101029044;1034.9327293726035;1051.0488008352454;1052.7156071325242;17471.82528174702;17514.38699645506;17671.116444178;17754;18030.639387212446;38994.90553491843;39814.2037159261;40819.59180408277;41048;41133.58866411298;55650;57558.136627949774;57749.422505776085;57794.4220557789;57845;8063.87904181426;8153.959230203811;8158.877616835871;8283.751487455385;8326.500409975179;11960.222585531912;13497.32513374347;13517.797233041709;13596.728065438438;13886.722265554834;11614.187006909773;11768.470418831344;11879.940600296943;12042.397880106135;12280.570180043656;11486.540538378706;11736.413179341169;11942.761144777229;12060.457279422622;12096.092793040732;11923.224990375598;11987.40062996864;12020.398980051137;12261.87738122643;12311.69220769488;8240.62917168717;8255.669773209245;8406;8540.572971351283;8941.37410381267;10558.947205264232;12267.57063502773;12275.324857132944;12316.81524777147;12322 18:44:02 INFO - PROCESS | 1398 | |3;mootools.html;1321.4185758266367;1478.7190433817577;1532.7700844873268;1638.3364737281406;1841.4107485604611;8305.335573154149;8663;8700.738977830668;8918.643254269822;8960.462372257669;8758.956205218981;8963.462192268453;8968.641254349819;8969.103089691027;8970.058143894896;1963.9214431422727;2031.2687432524278;2034.52188735647;2300.700908881847;2341.426350544119;2260.954780904381;2349.9060037598474;2355.2110043135485;2370.3955491349766;2373.2761507740133;2297.632378819389;2300.850444721096;2318.466752646892;2320.0255892525097;2338.731045929714;1950.8489990905434;2216.2021672198;2305.9077636894503;2337.906483740648;2338.2517594369724;2312.5490529346785;2349.424391024193;2349.706286714161;2353.0470159585393;2356;8733.388662793606;8784.12158784123;8794.780130496725;8795.252403545706;8795.516246606434;4882.658213925027;4961.05739909416;4963.3299504566785;5019.121653710586;5019.623528235397;3171.6194056713343;3281.8523166457567;3361.5798025246845;3434.175797808533;3450.102973226979;1054.7363159210197;1104.861892263467;1141.8743938166795;1142.0520967596874;1160.4081918221684;12073.094517911104;12107.213031152947;12131.21147125434;12139.696507587292;12149.210301330386;4392.077663690597;4429.025614364835;4489.451139356916;4492.550744925481;4558.8632341029825;10253.384796912209;10282.434466104436;10282.485875706185;10292.073713365833;10295.3822770634;5191.506806853343;5217.869553261123;5225.059489291888;5226.425093239741;5228.503292187236;3982.5021872265966;4532.546745325441;4582.816687332469;4644.024754801462;4714.811407543729;3968.543617483969;3972.106276087915;4053.9391909121387;4058.4723985881647;4105.548389677133;1251.3430449014159;1262.2741923394085;1270.815731718914;1284.1460428814732;1305.7519071376407;912.133473200449;969.6315400147898;1012.3015119567475;1016.9322211677709;1032.6230925712061;5907.172995780594;6148.631082135086;6216.906746398808;6246.094316324198;6313.210848643919;403.75371023675535;408.2610475040187;413.23138961531527;419.490319262098;421.0988484642867;4231.746095234295;4271.273883439822;4298.849540266076;4303.419038429772;4403.031333106712;10425.478726063819;10827.67516974492;10839;10846.891531084746;10905;10129.746756331151;10641.201909856793;10669.19981001428;10812;10891.509882055327;8141.715039973691;8197.303229225583;8238.09380968093;8268.710595129141;8275.54484503346;5999.430054144849;6178.66017369031;6273.749050037947;6275.905861411991;6299.842503937438;10139.442330671589;10159.085682288629;10159.593616255563;10238.846417303597;10275.17798576097;9261.212796912338;9548.045195480396;9589.136977672042;9822.459764713009;9881.308308418342;7016.929830701628;7404.92595074064;7584.241575842371;7841.960790196013;8004.199580041949;8423.915760842314;8426.662933482592;8485.066642669179;8493.235608795238;8496.27781638543;7463.589502577193;7469.253074692705;7490.363319117936;7691;7741.419393545394;7173.713051478091;7251.1298644160925;7300.415966722543;7428.294312040348;7508.249175082448;6597.472202223907;6631.204255489372;6670.599764014175;6675.399214070757;6679.899801502884;4881.072596206709;4943.159662857251;5033.597312214941;5060.493950605058;5093.719845408538;5140.845774626767;5237.476252374732;5274.7890084396195;5284.339457567804;5352.866178345573 18:44:02 INFO - PROCESS | 1398 | |4;prototype.html;304.90852744176743;317.723580484978;321.7056393400039;326.2756680170023;327.17551769540756;5171.534561889429;5260.6336740505385;5326.38746544147;5395.678058875581;5408.21580870774;5345.545628621562;5345.652532585379;5354.785808567653;5357.08929481988;5366.141417373211;4128.256913755523;4134.152498737752;4139.606737359946;4153.937690934646;4195.790210489478;3906.609339066085;3907.745996510232;4133.710640255168;4144.357624568197;4169.228692691847;4093.385992101179;4104.384342348657;4109.1370812129335;4117.958820411787;4134.7519148851015;4103.835846566134;4123.278426275405;4128.60778226068;4129.339305711072;4135.6898232632675;3508.15804206991;3671.706263498914;3677.3013127505687;3687.4468829675493;3701.4632878232505;5135.64050516464;5146.253793199965;5148.5623721983675;5156.710822294426;5159.509846564571;4726.243800991825;4727.763611819395;4729.952700472985;4738.360321356642;4752.5485078917445;5449.536789372908;5509.173623956399;5529.474699903502;5582.692951887645;5601.495865372095;4040.1313717550574;4062.131419547012;4078.714489985702;4092.4270602115726;4092.529359123709;5792.797252096157;5806.477417032445;5818.3308919474375;5821.2141360916585;5828;3942.6057394260342;4101.323281658493;4132.772697501606;4143.585641435892;4159.878461984349;4160.355144952538;4163.417121602978;4169.374593810892;4175.478065241845;4177.8328866845595;4691.366665500113;4756.334113224151;4757.286407038902;4758.714477131383;4764.094821983812;5358.633548445122;5552.69460179694;5573.554115670737;5616.5787565932715;5622.8313150605545;1410.9770416447993;1444.2056868722161;1446.2045874768835;1454.574516973372;1459.3651761483789;912.9224015958717;923.4367036107968;926.0831776541175;931.4225180388067;947.9905200947902;4780.641451891122;4784.607696151924;4794.832180873653;4819.469858315582;4853.034521018993;5069.822556210589;5112.565431938253;5131.4868513148385;5165.431802501797;5168.405633352138;4660.906781864412;4782.760861956888;4822.758862056883;4827.0450467560695;4842.564169224716;2692.986535067312;2723.414465889843;2726.986365068162;2733.5512178545405;2751.408447183865;5176.482351764794;5205.167173252262;5266;5273.6572122811895;5310.831617044244;4897.4857639948;5166.966606678679;5190.792368305301;5211.941283193118;5218.999075531508;5155.793768249303;5221.817236396708;5282.788688452496;5333.413324534298;5341.893162136813;5040.596752259884;5124.615653825904;5142.531584839223;5202.453742356998;5246.554042906396;4809.495003024632;5125.564327032244;5131.769070391916;5137.717425541481;5164.295782391727;5305.60207984395;5306.761195746123;5306.930297184024;5328.268312798434;5348.812791552433;3905.804709764557;3982.5619181889388;4059.573744756758;4067.979660101799;4085.182963407271;5671.461211184931;5680.346760122638;5706.372299047019;5719.0277652798295;5727.68497732612;5290.523852853262;5556.333240011063;5566.721663916869;5571.66570005801;5581.665100094007;5484.725763711878;5510.448955104457;5516.503514683698;5531.557475401878;5536.889262214652;5396.78412863481;5478.24696097245;5504.055330398218;5513.8345849624575;5526.253955715927;5482.369527504388;5631.267935168402;5643.71781410936;5655.830325090089;5670.574706896917;5374.892502150014;5435.701036443033;5442.891142177055;5444.176200972718;5536.806211782568 18:44:02 INFO - PROCESS | 1398 | |5;yui.html;777.6889244302279;789.0452552411582;842.3303473738378;853.2235665544348;855.5080828523596;13182.802257966126;14286.785698214522;14512.63718407039;14550.19973901435;14571.344289506971;13942.302884855768;13982.860171398283;13998.860011399884;14002.649933751636;14015;675.7938828657258;802.5866678660494;815.2214635023568;824.8474032304013;827.6358402302998;805.3114587028094;817.146082343952;819.692615269274;820.0815087102453;820.2003047029159;860.4622111180512;862.659249596409;863.7711006583261;863.8142799298149;864.1056506515757;716.824378027384;835.2315869400136;858.6007506509441;860.0152825015385;863.7883718488979;624.6658037949675;625.7152995387088;626.1765778001912;626.5520153090562;626.7493002798872;11461;11512.079033677286;11517.424128793611;11529.077673786078;11531.13516486267;12983.935080324538;13765.311734413339;13777.380017899119;13816.516421925286;13995.37020834065;12159.209651372632;12424;12494.375281235993;12520;12594.937025314815;4369.344598310247;4493.96638773084;4520.706154100006;4561.156186105581;4576.359309696645;55906.72046639781;56047.71976140134;56282.43717562813;56821.71589142069;58674.119888202134;11071.889281107085;11166.497507612177;11209.55161793519;11496.77006459866;11532.538698452136;19229.90385048066;19249;19249.422517324503;19400.8059919399;20248.493787655425;7995.360371170293;8135.6100466593625;8186.672533098728;8257.174282571696;8321.583920803936;4446.466424029137;4560.2019646562385;4584.747838868828;4728.38530990969;4737.431508219036;3336.2326664867214;3422.315536892582;3430.9485357719655;3437.845296961643;3444.1733983843696;516.6564234783901;589.5872888977733;599.2958274028;613.0558939233531;616.7070641445277;581.8894410062074;754.2683596910988;791.3076058448858;798.5248776977689;826.8470332988417;9775.804483910282;10014.899851001397;10109.39343639384;10181.236407269484;10250.128739057114;777.9338756205673;784.4617003952003;802.626778547978;804.2640983500149;808.2967817998261;4513.616342610849;4691.906161876744;4810.903781924412;4895.730734809548;4951.653384263139;65256.67371663206;65625.67187164034;67041.66479167671;67815;68409.89540627578;57640.71179644075;57719.711401443565;57858.42141578614;58144.418555814744;59480.70259648761;54376;54519.45480545144;54681.45318546764;54889.176662350896;55126.724366378716;8787.428817127122;8802;8939.955300223457;8942.150495702897;9025.954870225607;33985;37019;37210.44184337183;37379.81310093432;37439.251214976095;49142;49291;49926.00739925978;49936.25095623496;50382.49617503778;11923.10576706733;12227.44976476043;12420.813687794871;12592.685182870502;12812.935935320264;13628.52300169529;13922.164670119826;14144.363503642566;14355.282235888373;14874;12787.424565894371;12885.742285154432;13077.542286019943;13086.214827110403;13186.736265274832;13154.736905262032;13199;13279.867201327863;13315.866841331463;13353.065285429926;13130.737385252432;13339.399727012114;13416.664583385493;13614.319284035957;13943.30283485842;10754.40850753216;10978.505967231335;11036;11292.717682057686;11394.145439091935;11102;11276.492557835081;11329.206955513035;11400.372979486208;11436.599719009795 18:44:02 INFO - PROCESS | 1398 | __end_tp_report 18:44:02 INFO - PROCESS | 1398 | __start_cc_report 18:44:02 INFO - PROCESS | 1398 | _x_x_mozilla_cycle_collect,887 18:44:02 INFO - PROCESS | 1398 | __end_cc_report 18:44:02 INFO - PROCESS | 1398 | __startTimestamp1464313442826__endTimestamp 18:44:02 INFO - PROCESS | 1398 | 18:44:02 INFO - PROCESS | 1398 | ------- Summary: start ------- 18:44:02 INFO - PROCESS | 1398 | Number of tests: 6 18:44:02 INFO - PROCESS | 1398 | 18:44:02 INFO - PROCESS | 1398 | [#0] dojo.html Cycles:165 Average:5390.56 Median:5545.75 stddev:624.38 (11.3%) stddev-sans-first:600.56 18:44:02 INFO - PROCESS | 1398 | Values: 3128.6 3147.2 3172.2 3197.4 3206.9 5287.4 5365.9 5384.9 5509.1 5530.7 5351.2 5403.1 5405.7 5492.0 5492.1 4901.5 4950.6 5009.4 5018.0 5080.7 4987.6 5009.5 5029.7 5058.0 5058.1 4806.6 4842.3 4849.5 4853.6 4877.0 4830.1 4852.3 4897.4 4911.9 4964.7 4796.8 4862.1 4878.0 4901.5 4922.7 5266.1 5372.6 5379.2 5424.9 5453.9 5866.4 5868.2 5890.1 5892.2 5892.6 5558.4 5665.8 5718.1 5887.8 5947.7 5437.4 5459.0 5459.9 5485.4 5486.6 5902.0 5913.2 5973.0 5975.0 5976.0 5381.9 5655.9 5714.5 5722.5 5736.1 5860.3 5907.0 5907.3 5909.1 5916.4 5777.7 5786.6 5791.3 5791.5 5792.9 5488.8 5698.7 5741.8 5752.6 5787.5 4399.5 4401.0 4401.3 4401.5 4437.6 3802.3 3906.4 3916.2 3931.0 3937.8 5394.5 5397.7 5452.6 5540.3 5544.8 5852.6 5887.5 5889.1 5889.3 5942.6 5486.0 5492.9 5493.7 5497.5 5498.7 4862.9 4899.9 4951.1 4962.3 4977.7 5934.3 5934.9 5937.4 5940.0 5942.7 5676.3 5817.1 5818.0 5825.0 5829.1 5992.3 6075.2 6100.9 6117.5 6127.9 5791.4 5792.5 5821.2 5827.7 5829.4 5560.3 5802.5 5922.3 5940.7 5943.9 5688.5 5744.4 5748.1 5751.5 5807.5 5737.9 5743.5 5747.4 5753.2 5755.2 5390.6 5451.9 5492.7 5636.0 5646.2 5629.2 5663.2 5676.0 5682.4 5687.6 5539.7 5543.7 5545.8 5548.9 5587.0 18:44:02 INFO - PROCESS | 1398 | 18:44:02 INFO - PROCESS | 1398 | [#1] ext.html Cycles:180 Average:53006.08 Median:42225.08 stddev:102908.03 (243.7%) stddev-sans-first:103121.49 18:44:02 INFO - PROCESS | 1398 | Values: 599.2 629.5 635.3 647.9 650.4 33023.2 35981.0 44451.6 45068.5 45372.0 45115.0 45414.3 45718.5 45737.5 45794.3 8730.0 8970.7 8974.4 8977.3 8978.6 8787.3 8904.3 8932.8 8957.6 8964.1 8972.1 8985.2 9010.2 9025.4 9029.9 8954.4 8999.9 9005.9 9009.4 9014.8 8799.1 8901.1 8918.7 8923.1 8923.7 42505.4 42875.0 43011.4 43057.1 43067.6 3588.0 3640.5 3649.7 3717.6 3928.9 32561.0 32989.7 33220.0 33790.5 34442.3 4359.3 4378.8 4395.5 4399.3 4433.5 244650.0 244940.0 245294.0 245843.0 246385.0 31843.8 59854.0 60151.7 60213.7 60289.4 33742.7 35567.8 35580.3 35604.5 35758.5 14313.9 14462.6 14491.2 14496.3 14497.0 12784.4 12855.3 12867.5 12932.9 12962.2 8274.4 8350.9 8378.0 8416.3 8422.0 3207.5 3264.6 3265.3 3281.5 3307.5 1040.5 1042.6 1115.5 1132.2 1137.5 32668.3 33112.7 33118.7 33216.8 33322.5 1120.5 1151.6 1178.6 1183.6 1205.5 16705.0 17407.0 17505.7 17578.9 17717.8 541849.0 545112.0 547790.0 548169.0 548607.0 60447.7 61065.0 61097.0 61110.4 61155.4 1240.4 1376.2 1395.8 1401.6 1403.5 32775.8 33992.3 34127.3 34396.7 34546.7 51795.0 52029.2 52268.2 52309.2 52359.0 298660.0 299103.0 299405.0 300276.0 300653.0 24993.0 27139.7 27926.0 27996.4 28050.7 48134.8 48603.5 48939.3 49880.8 50219.5 41682.4 42413.6 43216.0 43383.0 43737.6 42442.0 42480.2 42715.4 43052.4 43285.7 41309.8 42036.6 42546.8 42575.8 42610.8 36037.5 36827.6 37518.2 38253.6 38587.0 28909.6 29201.6 29219.9 29224.7 29316.0 18:44:02 INFO - PROCESS | 1398 | 18:44:02 INFO - PROCESS | 1398 | [#2] jquery.html Cycles:180 Average:30164.98 Median:15140.51 stddev:78274.52 (517.0%) stddev-sans-first:78462.16 18:44:02 INFO - PROCESS | 1398 | Values: 381.7 385.9 387.5 396.9 414.5 14513.5 16971.5 18490.4 20124.5 20137.7 18632.9 18712.6 19245.2 19619.8 19629.5 5521.2 5578.5 5700.5 5709.4 5715.8 4089.8 5636.9 5646.9 5654.9 6026.7 6295.5 6388.2 6405.2 6414.5 6415.1 6242.7 6323.4 6372.1 6379.2 6395.6 5593.9 5605.6 5611.4 5619.2 5651.7 24338.1 24882.0 25743.0 27572.7 27607.6 2390.9 2436.4 2539.5 2706.8 2708.3 15658.8 16347.7 16388.7 16515.9 16951.8 2136.4 2141.6 2178.6 2270.2 2317.7 94329.0 97297.5 99067.0 100122.5 101323.5 17663.7 17873.9 18043.5 18257.7 18569.4 26211.5 28629.3 30571.1 32503.8 32573.2 9946.2 9996.2 10074.4 10143.3 10168.2 8030.9 8107.2 8218.6 8365.5 8423.6 9161.0 9190.9 9218.1 9271.5 9384.3 3559.4 3580.6 3592.3 3701.4 3711.3 909.4 938.5 964.5 1091.5 1109.4 18847.4 19062.6 19819.2 19947.7 19989.2 1015.5 1024.7 1026.8 1038.3 1039.3 10460.7 11152.4 11176.4 11196.2 11214.8 459901.0 467113.0 470783.0 478760.0 486821.0 91088.0 94292.5 94556.5 95636.0 96950.5 1018.5 1029.0 1034.9 1051.0 1052.7 17471.8 17514.4 17671.1 17754.0 18030.6 38994.9 39814.2 40819.6 41048.0 41133.6 55650.0 57558.1 57749.4 57794.4 57845.0 8063.9 8154.0 8158.9 8283.8 8326.5 11960.2 13497.3 13517.8 13596.7 13886.7 11614.2 11768.5 11879.9 12042.4 12280.6 11486.5 11736.4 11942.8 12060.5 12096.1 11923.2 11987.4 12020.4 12261.9 12311.7 8240.6 8255.7 8406.0 8540.6 8941.4 10558.9 12267.6 12275.3 12316.8 12322.0 18:44:02 INFO - PROCESS | 1398 | 18:44:02 INFO - PROCESS | 1398 | [#3] mootools.html Cycles:180 Average:5722.94 Median:4459.24 stddev:3273.52 (73.4%) stddev-sans-first:3265.99 18:44:02 INFO - PROCESS | 1398 | Values: 1321.4 1478.7 1532.8 1638.3 1841.4 8305.3 8663.0 8700.7 8918.6 8960.5 8759.0 8963.5 8968.6 8969.1 8970.1 1963.9 2031.3 2034.5 2300.7 2341.4 2261.0 2349.9 2355.2 2370.4 2373.3 2297.6 2300.9 2318.5 2320.0 2338.7 1950.8 2216.2 2305.9 2337.9 2338.3 2312.5 2349.4 2349.7 2353.0 2356.0 8733.4 8784.1 8794.8 8795.3 8795.5 4882.7 4961.1 4963.3 5019.1 5019.6 3171.6 3281.9 3361.6 3434.2 3450.1 1054.7 1104.9 1141.9 1142.1 1160.4 12073.1 12107.2 12131.2 12139.7 12149.2 4392.1 4429.0 4489.5 4492.6 4558.9 10253.4 10282.4 10282.5 10292.1 10295.4 5191.5 5217.9 5225.1 5226.4 5228.5 3982.5 4532.5 4582.8 4644.0 4714.8 3968.5 3972.1 4053.9 4058.5 4105.5 1251.3 1262.3 1270.8 1284.1 1305.8 912.1 969.6 1012.3 1016.9 1032.6 5907.2 6148.6 6216.9 6246.1 6313.2 403.8 408.3 413.2 419.5 421.1 4231.7 4271.3 4298.8 4303.4 4403.0 10425.5 10827.7 10839.0 10846.9 10905.0 10129.7 10641.2 10669.2 10812.0 10891.5 8141.7 8197.3 8238.1 8268.7 8275.5 5999.4 6178.7 6273.7 6275.9 6299.8 10139.4 10159.1 10159.6 10238.8 10275.2 9261.2 9548.0 9589.1 9822.5 9881.3 7016.9 7404.9 7584.2 7842.0 8004.2 8423.9 8426.7 8485.1 8493.2 8496.3 7463.6 7469.3 7490.4 7691.0 7741.4 7173.7 7251.1 7300.4 7428.3 7508.2 6597.5 6631.2 6670.6 6675.4 6679.9 4881.1 4943.2 5033.6 5060.5 5093.7 5140.8 5237.5 5274.8 5284.3 5352.9 18:44:02 INFO - PROCESS | 1398 | 18:44:02 INFO - PROCESS | 1398 | [#4] prototype.html Cycles:180 Average:4534.68 Median:5140.12 stddev:1303.29 (25.4%) stddev-sans-first:1267.69 18:44:02 INFO - PROCESS | 1398 | Values: 304.9 317.7 321.7 326.3 327.2 5171.5 5260.6 5326.4 5395.7 5408.2 5345.5 5345.7 5354.8 5357.1 5366.1 4128.3 4134.2 4139.6 4153.9 4195.8 3906.6 3907.7 4133.7 4144.4 4169.2 4093.4 4104.4 4109.1 4118.0 4134.8 4103.8 4123.3 4128.6 4129.3 4135.7 3508.2 3671.7 3677.3 3687.4 3701.5 5135.6 5146.3 5148.6 5156.7 5159.5 4726.2 4727.8 4730.0 4738.4 4752.5 5449.5 5509.2 5529.5 5582.7 5601.5 4040.1 4062.1 4078.7 4092.4 4092.5 5792.8 5806.5 5818.3 5821.2 5828.0 3942.6 4101.3 4132.8 4143.6 4159.9 4160.4 4163.4 4169.4 4175.5 4177.8 4691.4 4756.3 4757.3 4758.7 4764.1 5358.6 5552.7 5573.6 5616.6 5622.8 1411.0 1444.2 1446.2 1454.6 1459.4 912.9 923.4 926.1 931.4 948.0 4780.6 4784.6 4794.8 4819.5 4853.0 5069.8 5112.6 5131.5 5165.4 5168.4 4660.9 4782.8 4822.8 4827.0 4842.6 2693.0 2723.4 2727.0 2733.6 2751.4 5176.5 5205.2 5266.0 5273.7 5310.8 4897.5 5167.0 5190.8 5211.9 5219.0 5155.8 5221.8 5282.8 5333.4 5341.9 5040.6 5124.6 5142.5 5202.5 5246.6 4809.5 5125.6 5131.8 5137.7 5164.3 5305.6 5306.8 5306.9 5328.3 5348.8 3905.8 3982.6 4059.6 4068.0 4085.2 5671.5 5680.3 5706.4 5719.0 5727.7 5290.5 5556.3 5566.7 5571.7 5581.7 5484.7 5510.4 5516.5 5531.6 5536.9 5396.8 5478.2 5504.1 5513.8 5526.3 5482.4 5631.3 5643.7 5655.8 5670.6 5374.9 5435.7 5442.9 5444.2 5536.8 18:44:02 INFO - PROCESS | 1398 | 18:44:02 INFO - PROCESS | 1398 | [#5] yui.html Cycles:180 Average:15540.64 Median:4568.76 stddev:18331.03 (401.2%) stddev-sans-first:18348.93 18:44:02 INFO - PROCESS | 1398 | Values: 777.7 789.0 842.3 853.2 855.5 13182.8 14286.8 14512.6 14550.2 14571.3 13942.3 13982.9 13998.9 14002.6 14015.0 675.8 802.6 815.2 824.8 827.6 805.3 817.1 819.7 820.1 820.2 860.5 862.7 863.8 863.8 864.1 716.8 835.2 858.6 860.0 863.8 624.7 625.7 626.2 626.6 626.7 11461.0 11512.1 11517.4 11529.1 11531.1 12983.9 13765.3 13777.4 13816.5 13995.4 12159.2 12424.0 12494.4 12520.0 12594.9 4369.3 4494.0 4520.7 4561.2 4576.4 55906.7 56047.7 56282.4 56821.7 58674.1 11071.9 11166.5 11209.6 11496.8 11532.5 19229.9 19249.0 19249.4 19400.8 20248.5 7995.4 8135.6 8186.7 8257.2 8321.6 4446.5 4560.2 4584.7 4728.4 4737.4 3336.2 3422.3 3430.9 3437.8 3444.2 516.7 589.6 599.3 613.1 616.7 581.9 754.3 791.3 798.5 826.8 9775.8 10014.9 10109.4 10181.2 10250.1 777.9 784.5 802.6 804.3 808.3 4513.6 4691.9 4810.9 4895.7 4951.7 65256.7 65625.7 67041.7 67815.0 68409.9 57640.7 57719.7 57858.4 58144.4 59480.7 54376.0 54519.5 54681.5 54889.2 55126.7 8787.4 8802.0 8940.0 8942.2 9026.0 33985.0 37019.0 37210.4 37379.8 37439.3 49142.0 49291.0 49926.0 49936.3 50382.5 11923.1 12227.4 12420.8 12592.7 12812.9 13628.5 13922.2 14144.4 14355.3 14874.0 12787.4 12885.7 13077.5 13086.2 13186.7 13154.7 13199.0 13279.9 13315.9 13353.1 13130.7 13339.4 13416.7 13614.3 13943.3 10754.4 10978.5 11036.0 11292.7 11394.1 11102.0 11276.5 11329.2 11400.4 11436.6 18:44:02 INFO - PROCESS | 1398 | -------- Summary: end -------- 18:44:02 INFO - PROCESS | 1398 | 18:44:03 INFO - TEST-INFO | 1398: exit 0 18:44:03 INFO - TEST-OK | dromaeo_css | took 1112511ms 18:44:03 INFO - TEST-START | kraken 18:44:03 INFO - operating with platform_type : linux_ 18:44:03 INFO - Initialising browser for kraken test... 18:44:03 INFO - TEST-INFO | started process 1582 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfB16L7/profile http://localhost:46572/getInfo.html) 18:44:07 INFO - PROCESS | 1582 | __metrics Screen width/height:1600/1200 18:44:07 INFO - PROCESS | 1582 | colorDepth:24 18:44:07 INFO - PROCESS | 1582 | Browser inner width/height: 1024/697 18:44:07 INFO - PROCESS | 1582 | __metrics 18:44:08 ERROR - PROCESS | 1582 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:44:09 INFO - TEST-INFO | 1582: exit 0 18:44:09 INFO - Browser initialized. 18:44:09 INFO - Running cycle 1/1 for kraken test... 18:44:09 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfB16L7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:44:21 INFO - PROCESS | 1664 | RSS: Main: 155279360 18:44:21 INFO - PROCESS | 1664 | 18:44:23 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:46572/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46572/tests/kraken/driver.html?testName=audio-beat-detection) 18:44:24 INFO - PROCESS | 1664 | RSS: Main: 211521536 18:44:24 INFO - PROCESS | 1664 | 18:44:27 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:46572/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46572/tests/kraken/driver.html?testName=audio-dft) 18:44:27 INFO - PROCESS | 1664 | RSS: Main: 199725056 18:44:27 INFO - PROCESS | 1664 | 18:44:31 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:46572/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46572/tests/kraken/driver.html?testName=audio-fft) 18:44:31 INFO - PROCESS | 1664 | RSS: Main: 267567104 18:44:31 INFO - PROCESS | 1664 | 18:44:33 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:46572/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46572/tests/kraken/driver.html?testName=audio-oscillator) 18:44:34 INFO - PROCESS | 1664 | RSS: Main: 176775168 18:44:34 INFO - PROCESS | 1664 | 18:44:36 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:46572/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46572/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:44:37 INFO - PROCESS | 1664 | RSS: Main: 181174272 18:44:37 INFO - PROCESS | 1664 | 18:44:40 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:46572/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46572/tests/kraken/driver.html?testName=imaging-darkroom) 18:44:40 INFO - PROCESS | 1664 | RSS: Main: 217464832 18:44:40 INFO - PROCESS | 1664 | 18:44:44 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:46572/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46572/tests/kraken/driver.html?testName=imaging-desaturate) 18:44:44 INFO - PROCESS | 1664 | RSS: Main: 218275840 18:44:44 INFO - PROCESS | 1664 | 18:44:47 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:46572/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46572/tests/kraken/driver.html?testName=json-parse-financial) 18:44:48 INFO - PROCESS | 1664 | RSS: Main: 219189248 18:44:48 INFO - PROCESS | 1664 | 18:44:49 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:46572/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46572/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:44:50 INFO - PROCESS | 1664 | RSS: Main: 206868480 18:44:50 INFO - PROCESS | 1664 | 18:44:52 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:46572/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46572/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:44:52 INFO - PROCESS | 1664 | RSS: Main: 209854464 18:44:52 INFO - PROCESS | 1664 | 18:44:54 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:46572/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46572/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:44:55 INFO - PROCESS | 1664 | RSS: Main: 219934720 18:44:55 INFO - PROCESS | 1664 | 18:44:58 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:46572/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46572/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:44:58 INFO - PROCESS | 1664 | RSS: Main: 227139584 18:44:58 INFO - PROCESS | 1664 | 18:45:01 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:46572/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46572/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:45:01 INFO - PROCESS | 1664 | RSS: Main: 224858112 18:45:01 INFO - PROCESS | 1664 | 18:45:03 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:46572/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46572/tests/kraken/driver.html?testName=ai-astar) 18:45:03 INFO - PROCESS | 1664 | RSS: Main: 270282752 18:45:03 INFO - PROCESS | 1664 | 18:45:03 INFO - PROCESS | 1664 | __start_tp_report 18:45:03 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 18:45:03 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 18:45:03 INFO - PROCESS | 1664 | |i|pagename|runs| 18:45:03 INFO - PROCESS | 1664 | |0;ai-astar;110;106;111;112;111;114;110;110;110;110 18:45:03 INFO - PROCESS | 1664 | |1;audio-beat-detection;168;123;126;188;126;125;152;126;168;126 18:45:03 INFO - PROCESS | 1664 | |2;audio-dft;161;160;160;161;160;162;162;161;162;161 18:45:03 INFO - PROCESS | 1664 | |3;audio-fft;75;76;73;111;76;75;75;76;119;74 18:45:03 INFO - PROCESS | 1664 | |4;audio-oscillator;84;83;123;84;83;87;123;83;84;134 18:45:03 INFO - PROCESS | 1664 | |5;imaging-gaussian-blur;117;117;117;118;117;116;117;117;117;117 18:45:03 INFO - PROCESS | 1664 | |6;imaging-darkroom;146;146;144;145;146;145;146;145;146;145 18:45:03 INFO - PROCESS | 1664 | |7;imaging-desaturate;95;95;97;95;95;94;95;95;94;94 18:45:03 INFO - PROCESS | 1664 | |8;json-parse-financial;53;54;54;53;54;53;53;66;52;51 18:45:03 INFO - PROCESS | 1664 | |9;json-stringify-tinderbox;62;62;60;61;61;61;61;62;62;61 18:45:03 INFO - PROCESS | 1664 | |10;stanford-crypto-aes;78;79;79;78;79;80;81;79;79;80 18:45:03 INFO - PROCESS | 1664 | |11;stanford-crypto-ccm;131;121;130;132;135;119;119;127;177;137 18:45:03 INFO - PROCESS | 1664 | |12;stanford-crypto-pbkdf2;157;160;161;155;157;161;155;156;156;159 18:45:03 INFO - PROCESS | 1664 | |13;stanford-crypto-sha256-iterative;61;64;62;62;65;62;63;62;61;62 18:45:03 INFO - PROCESS | 1664 | __end_tp_report 18:45:03 INFO - PROCESS | 1664 | __start_cc_report 18:45:03 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,1667 18:45:03 INFO - PROCESS | 1664 | __end_cc_report 18:45:03 INFO - PROCESS | 1664 | __startTimestamp1464313503817__endTimestamp 18:45:03 INFO - PROCESS | 1664 | 18:45:03 INFO - PROCESS | 1664 | ------- Summary: start ------- 18:45:03 INFO - PROCESS | 1664 | Number of tests: 14 18:45:03 INFO - PROCESS | 1664 | 18:45:03 INFO - PROCESS | 1664 | [#0] ai-astar Cycles:10 Average:110.40 Median:110.50 stddev:2.01 (1.8%) stddev-sans-first:2.13 18:45:03 INFO - PROCESS | 1664 | Values: 110.0 106.0 111.0 112.0 111.0 114.0 110.0 110.0 110.0 110.0 18:45:03 INFO - PROCESS | 1664 | 18:45:03 INFO - PROCESS | 1664 | [#1] audio-beat-detection Cycles:10 Average:142.80 Median:139.00 stddev:24.12 (17.4%) stddev-sans-first:23.80 18:45:03 INFO - PROCESS | 1664 | Values: 168.0 123.0 126.0 188.0 126.0 125.0 152.0 126.0 168.0 126.0 18:45:03 INFO - PROCESS | 1664 | 18:45:03 INFO - PROCESS | 1664 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 18:45:03 INFO - PROCESS | 1664 | Values: 161.0 160.0 160.0 161.0 160.0 162.0 162.0 161.0 162.0 161.0 18:45:03 INFO - PROCESS | 1664 | 18:45:03 INFO - PROCESS | 1664 | [#3] audio-fft Cycles:10 Average:83.00 Median:75.00 stddev:17.00 (22.7%) stddev-sans-first:17.78 18:45:03 INFO - PROCESS | 1664 | Values: 75.0 76.0 73.0 111.0 76.0 75.0 75.0 76.0 119.0 74.0 18:45:03 INFO - PROCESS | 1664 | 18:45:03 INFO - PROCESS | 1664 | [#4] audio-oscillator Cycles:10 Average:96.80 Median:83.50 stddev:20.86 (25.0%) stddev-sans-first:21.60 18:45:03 INFO - PROCESS | 1664 | Values: 84.0 83.0 123.0 84.0 83.0 87.0 123.0 83.0 84.0 134.0 18:45:03 INFO - PROCESS | 1664 | 18:45:03 INFO - PROCESS | 1664 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 18:45:03 INFO - PROCESS | 1664 | Values: 117.0 117.0 117.0 118.0 117.0 116.0 117.0 117.0 117.0 117.0 18:45:03 INFO - PROCESS | 1664 | 18:45:03 INFO - PROCESS | 1664 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 18:45:03 INFO - PROCESS | 1664 | Values: 146.0 146.0 144.0 145.0 146.0 145.0 146.0 145.0 146.0 145.0 18:45:03 INFO - PROCESS | 1664 | 18:45:03 INFO - PROCESS | 1664 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 18:45:03 INFO - PROCESS | 1664 | Values: 95.0 95.0 97.0 95.0 95.0 94.0 95.0 95.0 94.0 94.0 18:45:03 INFO - PROCESS | 1664 | 18:45:03 INFO - PROCESS | 1664 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:53.50 stddev:4.22 (7.9%) stddev-sans-first:4.45 18:45:03 INFO - PROCESS | 1664 | Values: 53.0 54.0 54.0 53.0 54.0 53.0 53.0 66.0 52.0 51.0 18:45:03 INFO - PROCESS | 1664 | 18:45:03 INFO - PROCESS | 1664 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.50 stddev:0.67 (1.1%) stddev-sans-first:0.67 18:45:03 INFO - PROCESS | 1664 | Values: 62.0 62.0 60.0 61.0 61.0 61.0 61.0 62.0 62.0 61.0 18:45:03 INFO - PROCESS | 1664 | 18:45:03 INFO - PROCESS | 1664 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:79.00 stddev:0.92 (1.2%) stddev-sans-first:0.87 18:45:03 INFO - PROCESS | 1664 | Values: 78.0 79.0 79.0 78.0 79.0 80.0 81.0 79.0 79.0 80.0 18:45:03 INFO - PROCESS | 1664 | 18:45:03 INFO - PROCESS | 1664 | [#11] stanford-crypto-ccm Cycles:10 Average:132.80 Median:131.50 stddev:16.80 (12.8%) stddev-sans-first:17.81 18:45:03 INFO - PROCESS | 1664 | Values: 131.0 121.0 130.0 132.0 135.0 119.0 119.0 127.0 177.0 137.0 18:45:03 INFO - PROCESS | 1664 | 18:45:03 INFO - PROCESS | 1664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.70 Median:158.00 stddev:2.36 (1.5%) stddev-sans-first:2.49 18:45:03 INFO - PROCESS | 1664 | Values: 157.0 160.0 161.0 155.0 157.0 161.0 155.0 156.0 156.0 159.0 18:45:03 INFO - PROCESS | 1664 | 18:45:03 INFO - PROCESS | 1664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.00 stddev:1.26 (2.0%) stddev-sans-first:1.24 18:45:03 INFO - PROCESS | 1664 | Values: 61.0 64.0 62.0 62.0 65.0 62.0 63.0 62.0 61.0 62.0 18:45:03 INFO - PROCESS | 1664 | -------- Summary: end -------- 18:45:03 INFO - PROCESS | 1664 | 18:45:04 INFO - TEST-INFO | 1664: exit 0 18:45:04 INFO - TEST-OK | kraken | took 61183ms 18:45:04 INFO - SUITE-END | took 1173s 18:45:04 INFO - Completed test suite (00:19:33) 18:45:04 INFO - javascript benchmark 18:45:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3128.640206376266, 3147.2446612812923, 3172.2069482629336, 3197.360527894422, 3206.887758928438, 5287.365516138059, 5365.946340536593, 5384.919226211605, 5509.118541033436, 5530.668159910403, 5351.197320401941, 5403.135498320269, 5405.675659460425, 5491.972540137293, 5492.066348720717, 4901.509849015097, 4950.603951683856, 5009.44896061433, 5017.974910125445, 5080.720560369178, 4987.625928055392, 5009.499050094998, 5029.748512574357, 5058.0, 5058.064258112243, 4806.59143972761, 4842.29786680931, 4849.539293767087, 4853.587445067174, 4877.000214955943, 4830.106430310404, 4852.296417019547, 4897.41231052276, 4911.852644420673, 4964.67729597575, 4796.808127674889, 4862.051899879525, 4877.951220487821, 4901.534354236342, 4922.655414121013, 5266.078436273637, 5372.597055220874, 5379.193121031837, 5424.918626220609, 5453.918191227135, 5866.384029676908, 5868.207791948075, 5890.087036509348, 5892.204552385459, 5892.558058145656, 5558.44415558445, 5665.773369065232, 5718.1136923776885, 5887.793927212527, 5947.672877991708, 5437.429069947678, 5459.044667183227, 5459.918101228484, 5485.424030476783, 5486.643368181056, 5902.0, 5913.172155898178, 5972.970135149383, 5975.0, 5975.954208013581, 5381.892362152735, 5655.886882262332, 5714.514266287412, 5722.456366645162, 5736.110902810071, 5860.2967643883, 5907.0, 5907.261592300963, 5909.113632955091, 5916.3787802281, 5777.740001699934, 5786.566007549451, 5791.305043394819, 5791.478766910998, 5792.8551786204835, 5488.807891723771, 5698.715064246771, 5741.827745167651, 5752.568557358215, 5787.536997040227, 4399.494058183286, 4400.955990440055, 4401.2517871961845, 4401.493828209796, 4437.622802061861, 3802.296575133609, 3906.4140378942816, 3916.177602703407, 3930.9803450983136, 3937.842486300573, 5394.487523685244, 5397.73011349431, 5452.618316717871, 5540.279763630783, 5544.750486228129, 5852.648841069549, 5887.5289976802605, 5889.116632505073, 5889.322727886262, 5942.643441393444, 5486.039943009957, 5492.862678432991, 5493.725313734298, 5497.47773961473, 5498.725063746797, 4862.854114376574, 4899.926501102486, 4951.133551628451, 4962.305277261186, 4977.676451030671, 5934.317553481319, 5934.851628709231, 5937.406259374115, 5939.970300148558, 5942.732577034044, 5676.262085928803, 5817.098349755879, 5818.0, 5825.0, 5829.125631155361, 5992.310884248367, 6075.1798507200965, 6100.938990610037, 6117.480014198843, 6127.908081378872, 5791.362950075572, 5792.507636850914, 5821.155932389695, 5827.6794776286015, 5829.358770535323, 5560.277163968658, 5802.506786923159, 5922.289325280994, 5940.702964851826, 5943.940560594338, 5688.54491640676, 5744.396838331915, 5748.137779333133, 5751.511121554715, 5807.535397168132, 5737.942620573741, 5743.511801496919, 5747.396523364986, 5753.165790960204, 5755.223044888887, 5390.595705322195, 5451.918221226764, 5492.697901615449, 5635.971820140873, 5646.153077038312, 5629.211910332639, 5663.150527420919, 5676.0, 5682.374938756816, 5687.630304030225, 5539.695316757617, 5543.695096769717, 5545.750441230073, 5548.889022219452, 5587.0], "value": 5348.003694988249, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.2060519811248, 629.4932579273684, 635.3265538529163, 647.9092926990222, 650.4178760009794, 33023.174420639465, 35981.0, 44451.55548444518, 45068.54931450685, 45372.0, 45115.0, 45414.318785218165, 45718.54281457185, 45737.54262457375, 45794.313085303664, 8729.999999999984, 8970.730878073668, 8974.371793974424, 8977.281817454588, 8978.595963181673, 8787.25308348791, 8904.287656987426, 8932.821343573125, 8957.641694332218, 8964.058773828752, 8972.102789721008, 8985.23625491834, 9010.189082982562, 9025.413348132382, 9029.864552031691, 8954.417962832427, 8999.910000899972, 9005.909940900605, 9009.414388064755, 9014.819703605892, 8799.120087991214, 8901.109889011112, 8918.73243802687, 8923.10768923109, 8923.732288031304, 42505.36241956373, 42875.0, 43011.35482967758, 43057.13885722299, 43067.56932430667, 3587.964120358789, 3640.4903313536124, 3649.6897763689853, 3717.628237176261, 3928.88213353597, 32561.0, 32989.6701032989, 33220.0, 33790.49314260288, 34442.31115377678, 4359.324304732771, 4378.824847006116, 4395.516493185747, 4399.296112621997, 4433.490148632916, 244650.0, 244940.0, 245294.0, 245843.0, 246385.0, 31843.84078079595, 59854.0, 60151.69924150351, 60213.69893150506, 60289.39710602925, 33742.662573374444, 35567.82216088903, 35580.28839423249, 35604.465933010506, 35758.463623045674, 14313.928430357782, 14462.638434039023, 14491.20298383599, 14496.34766435513, 14497.0, 12784.360781960864, 12855.29295888735, 12867.549635762703, 12932.870671293354, 12962.157459765085, 8274.420790544724, 8350.874736878952, 8378.0, 8416.284615807603, 8422.0, 3207.5188721691934, 3264.588505012268, 3265.2653153040374, 3281.506914353963, 3307.4542700454635, 1040.4953597505205, 1042.5604086437772, 1115.4924509348227, 1132.2357408749226, 1137.4540220693948, 32668.346633067205, 33112.668873310955, 33118.66881331156, 33216.83391583075, 33322.500162497585, 1120.523777394604, 1151.6314779270554, 1178.6287319494331, 1183.621241202807, 1205.5057426455112, 16705.0, 17407.0, 17505.7374139388, 17578.91210543939, 17717.822821771875, 541849.0, 545112.0, 547790.0, 548169.0, 548607.0, 60447.69776151091, 61065.0, 61097.0, 61110.38889611047, 61155.38844611586, 1240.3736113262744, 1376.2499437806418, 1395.8255218097536, 1401.5725203812935, 1403.4947418929178, 32775.836120819244, 33992.320153596294, 34127.31745365128, 34396.65603343934, 34546.65453345434, 51795.0, 52029.219561705846, 52268.21597676114, 52309.215361768845, 52359.0, 298660.0, 299103.0, 299405.0, 300276.0, 300653.0, 24993.0, 27139.72860271372, 27926.0, 27996.44007119887, 28050.719492804812, 48134.759326203144, 48603.51396486131, 48939.265911010654, 49880.750596246784, 50219.497805021485, 41682.37476437795, 42413.575864240964, 43216.0, 43383.0, 43737.56262437335, 42442.0, 42480.1503969925, 42715.35926961036, 43052.35421468743, 43285.70142895718, 41309.79345103255, 42036.57963420449, 42546.787266063475, 42575.7871210642, 42610.78694606631, 36037.47737658339, 36827.57450037676, 37518.2496350066, 38253.61746382501, 38587.0, 28909.56635650425, 29201.561976569945, 29219.85390073036, 29224.70775292305, 29316.0], "value": 18812.18094273358, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.73660174479613, 385.9150986782907, 387.5156054931336, 396.8670495384046, 414.5253684531212, 14513.49202777903, 16971.49085527433, 18490.445286641407, 20124.4968875778, 20137.697934530974, 18632.906835465838, 18712.625747485075, 19245.230190792387, 19619.803801961974, 19629.50926226845, 5521.171824226358, 5578.497935185833, 5700.515456186229, 5709.400512946143, 5715.799947001856, 4089.8159582818844, 5636.915446268309, 5646.943530564703, 5654.915176272339, 6026.668533230671, 6295.496360291166, 6388.201474815648, 6405.231372235338, 6414.454771344442, 6415.101885736, 6242.719077641495, 6323.430891219812, 6372.1397611322345, 6379.170707807978, 6395.584287021329, 5593.916091258634, 5605.607607467479, 5611.3546942101775, 5619.241402410663, 5651.689157096358, 24338.148164814145, 24882.0, 25743.0, 27572.724272757216, 27607.585886211524, 2390.8804559771943, 2436.3665446983737, 2539.5047965646704, 2706.7624147275087, 2708.295843080813, 15658.765118523232, 16347.673046539003, 16388.6722265554, 16515.91742041282, 16951.83048169515, 2136.42316574524, 2141.550274442369, 2178.59695956247, 2270.2167752125492, 2317.73346065203, 94329.0, 97297.5135124334, 99067.0, 100122.49938750333, 101323.49338253336, 17663.73504397435, 17873.910630447026, 18043.458696239133, 18257.726134107997, 18569.44291671252, 26211.475770484485, 28629.284267893054, 30571.08286751401, 32503.837480812446, 32573.18567035843, 9946.154576861049, 9996.200303975664, 10074.3955362677, 10143.28996970205, 10168.237382196365, 8030.879536806952, 8107.1892810718455, 8218.63016164274, 8365.498070115813, 8423.595611737239, 9161.0, 9190.88144089882, 9218.124278193562, 9271.490068046322, 9384.263911176455, 3559.430491121408, 3580.6419358064504, 3592.3354179476883, 3701.407774756026, 3711.294853977736, 909.417972497602, 938.5166639180827, 964.5322018820866, 1091.4542728635681, 1109.378747901178, 18847.434576962714, 19062.61874762497, 19819.207231710858, 19947.700784488243, 19989.200431982557, 1015.4668798880647, 1024.7489365105596, 1026.7997740440542, 1038.2939601071344, 1039.3088596083671, 10460.73848153787, 11152.386618736047, 11176.385298808644, 11196.216264861545, 11214.775704486028, 459901.0, 467113.0, 470783.0, 478760.0, 486821.0, 91088.0, 94292.52853735688, 94556.52721736486, 95636.0, 96950.51524742332, 1018.4805749067881, 1028.9897101029044, 1034.9327293726035, 1051.0488008352454, 1052.7156071325242, 17471.82528174702, 17514.38699645506, 17671.116444178, 17754.0, 18030.639387212446, 38994.90553491843, 39814.2037159261, 40819.59180408277, 41048.0, 41133.58866411298, 55650.0, 57558.136627949774, 57749.422505776085, 57794.4220557789, 57845.0, 8063.87904181426, 8153.959230203811, 8158.877616835871, 8283.751487455385, 8326.500409975179, 11960.222585531912, 13497.32513374347, 13517.797233041709, 13596.728065438438, 13886.722265554834, 11614.187006909773, 11768.470418831344, 11879.940600296943, 12042.397880106135, 12280.570180043656, 11486.540538378706, 11736.413179341169, 11942.761144777229, 12060.457279422622, 12096.092793040732, 11923.224990375598, 11987.40062996864, 12020.398980051137, 12261.87738122643, 12311.69220769488, 8240.62917168717, 8255.669773209245, 8406.0, 8540.572971351283, 8941.37410381267, 10558.947205264232, 12267.57063502773, 12275.324857132944, 12316.81524777147, 12322.0], "value": 10280.945327764262, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1321.4185758266367, 1478.7190433817577, 1532.7700844873268, 1638.3364737281406, 1841.4107485604611, 8305.335573154149, 8663.0, 8700.738977830668, 8918.643254269822, 8960.462372257669, 8758.956205218981, 8963.462192268453, 8968.641254349819, 8969.103089691027, 8970.058143894896, 1963.9214431422727, 2031.2687432524278, 2034.52188735647, 2300.700908881847, 2341.426350544119, 2260.954780904381, 2349.9060037598474, 2355.2110043135485, 2370.3955491349766, 2373.2761507740133, 2297.632378819389, 2300.850444721096, 2318.466752646892, 2320.0255892525097, 2338.731045929714, 1950.8489990905434, 2216.2021672198, 2305.9077636894503, 2337.906483740648, 2338.2517594369724, 2312.5490529346785, 2349.424391024193, 2349.706286714161, 2353.0470159585393, 2356.0, 8733.388662793606, 8784.12158784123, 8794.780130496725, 8795.252403545706, 8795.516246606434, 4882.658213925027, 4961.05739909416, 4963.3299504566785, 5019.121653710586, 5019.623528235397, 3171.6194056713343, 3281.8523166457567, 3361.5798025246845, 3434.175797808533, 3450.102973226979, 1054.7363159210197, 1104.861892263467, 1141.8743938166795, 1142.0520967596874, 1160.4081918221684, 12073.094517911104, 12107.213031152947, 12131.21147125434, 12139.696507587292, 12149.210301330386, 4392.077663690597, 4429.025614364835, 4489.451139356916, 4492.550744925481, 4558.8632341029825, 10253.384796912209, 10282.434466104436, 10282.485875706185, 10292.073713365833, 10295.3822770634, 5191.506806853343, 5217.869553261123, 5225.059489291888, 5226.425093239741, 5228.503292187236, 3982.5021872265966, 4532.546745325441, 4582.816687332469, 4644.024754801462, 4714.811407543729, 3968.543617483969, 3972.106276087915, 4053.9391909121387, 4058.4723985881647, 4105.548389677133, 1251.3430449014159, 1262.2741923394085, 1270.815731718914, 1284.1460428814732, 1305.7519071376407, 912.133473200449, 969.6315400147898, 1012.3015119567475, 1016.9322211677709, 1032.6230925712061, 5907.172995780594, 6148.631082135086, 6216.906746398808, 6246.094316324198, 6313.210848643919, 403.75371023675535, 408.2610475040187, 413.23138961531527, 419.490319262098, 421.0988484642867, 4231.746095234295, 4271.273883439822, 4298.849540266076, 4303.419038429772, 4403.031333106712, 10425.478726063819, 10827.67516974492, 10839.0, 10846.891531084746, 10905.0, 10129.746756331151, 10641.201909856793, 10669.19981001428, 10812.0, 10891.509882055327, 8141.715039973691, 8197.303229225583, 8238.09380968093, 8268.710595129141, 8275.54484503346, 5999.430054144849, 6178.66017369031, 6273.749050037947, 6275.905861411991, 6299.842503937438, 10139.442330671589, 10159.085682288629, 10159.593616255563, 10238.846417303597, 10275.17798576097, 9261.212796912338, 9548.045195480396, 9589.136977672042, 9822.459764713009, 9881.308308418342, 7016.929830701628, 7404.92595074064, 7584.241575842371, 7841.960790196013, 8004.199580041949, 8423.915760842314, 8426.662933482592, 8485.066642669179, 8493.235608795238, 8496.27781638543, 7463.589502577193, 7469.253074692705, 7490.363319117936, 7691.0, 7741.419393545394, 7173.713051478091, 7251.1298644160925, 7300.415966722543, 7428.294312040348, 7508.249175082448, 6597.472202223907, 6631.204255489372, 6670.599764014175, 6675.399214070757, 6679.899801502884, 4881.072596206709, 4943.159662857251, 5033.597312214941, 5060.493950605058, 5093.719845408538, 5140.845774626767, 5237.476252374732, 5274.7890084396195, 5284.339457567804, 5352.866178345573], "value": 4494.018417530546, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.90852744176743, 317.723580484978, 321.7056393400039, 326.2756680170023, 327.17551769540756, 5171.534561889429, 5260.6336740505385, 5326.38746544147, 5395.678058875581, 5408.21580870774, 5345.545628621562, 5345.652532585379, 5354.785808567653, 5357.08929481988, 5366.141417373211, 4128.256913755523, 4134.152498737752, 4139.606737359946, 4153.937690934646, 4195.790210489478, 3906.609339066085, 3907.745996510232, 4133.710640255168, 4144.357624568197, 4169.228692691847, 4093.385992101179, 4104.384342348657, 4109.1370812129335, 4117.958820411787, 4134.7519148851015, 4103.835846566134, 4123.278426275405, 4128.60778226068, 4129.339305711072, 4135.6898232632675, 3508.15804206991, 3671.706263498914, 3677.3013127505687, 3687.4468829675493, 3701.4632878232505, 5135.64050516464, 5146.253793199965, 5148.5623721983675, 5156.710822294426, 5159.509846564571, 4726.243800991825, 4727.763611819395, 4729.952700472985, 4738.360321356642, 4752.5485078917445, 5449.536789372908, 5509.173623956399, 5529.474699903502, 5582.692951887645, 5601.495865372095, 4040.1313717550574, 4062.131419547012, 4078.714489985702, 4092.4270602115726, 4092.529359123709, 5792.797252096157, 5806.477417032445, 5818.3308919474375, 5821.2141360916585, 5828.0, 3942.6057394260342, 4101.323281658493, 4132.772697501606, 4143.585641435892, 4159.878461984349, 4160.355144952538, 4163.417121602978, 4169.374593810892, 4175.478065241845, 4177.8328866845595, 4691.366665500113, 4756.334113224151, 4757.286407038902, 4758.714477131383, 4764.094821983812, 5358.633548445122, 5552.69460179694, 5573.554115670737, 5616.5787565932715, 5622.8313150605545, 1410.9770416447993, 1444.2056868722161, 1446.2045874768835, 1454.574516973372, 1459.3651761483789, 912.9224015958717, 923.4367036107968, 926.0831776541175, 931.4225180388067, 947.9905200947902, 4780.641451891122, 4784.607696151924, 4794.832180873653, 4819.469858315582, 4853.034521018993, 5069.822556210589, 5112.565431938253, 5131.4868513148385, 5165.431802501797, 5168.405633352138, 4660.906781864412, 4782.760861956888, 4822.758862056883, 4827.0450467560695, 4842.564169224716, 2692.986535067312, 2723.414465889843, 2726.986365068162, 2733.5512178545405, 2751.408447183865, 5176.482351764794, 5205.167173252262, 5266.0, 5273.6572122811895, 5310.831617044244, 4897.4857639948, 5166.966606678679, 5190.792368305301, 5211.941283193118, 5218.999075531508, 5155.793768249303, 5221.817236396708, 5282.788688452496, 5333.413324534298, 5341.893162136813, 5040.596752259884, 5124.615653825904, 5142.531584839223, 5202.453742356998, 5246.554042906396, 4809.495003024632, 5125.564327032244, 5131.769070391916, 5137.717425541481, 5164.295782391727, 5305.60207984395, 5306.761195746123, 5306.930297184024, 5328.268312798434, 5348.812791552433, 3905.804709764557, 3982.5619181889388, 4059.573744756758, 4067.979660101799, 4085.182963407271, 5671.461211184931, 5680.346760122638, 5706.372299047019, 5719.0277652798295, 5727.68497732612, 5290.523852853262, 5556.333240011063, 5566.721663916869, 5571.66570005801, 5581.665100094007, 5484.725763711878, 5510.448955104457, 5516.503514683698, 5531.557475401878, 5536.889262214652, 5396.78412863481, 5478.24696097245, 5504.055330398218, 5513.8345849624575, 5526.253955715927, 5482.369527504388, 5631.267935168402, 5643.71781410936, 5655.830325090089, 5670.574706896917, 5374.892502150014, 5435.701036443033, 5442.891142177055, 5444.176200972718, 5536.806211782568], "value": 4118.881139107486, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [777.6889244302279, 789.0452552411582, 842.3303473738378, 853.2235665544348, 855.5080828523596, 13182.802257966126, 14286.785698214522, 14512.63718407039, 14550.19973901435, 14571.344289506971, 13942.302884855768, 13982.860171398283, 13998.860011399884, 14002.649933751636, 14015.0, 675.7938828657258, 802.5866678660494, 815.2214635023568, 824.8474032304013, 827.6358402302998, 805.3114587028094, 817.146082343952, 819.692615269274, 820.0815087102453, 820.2003047029159, 860.4622111180512, 862.659249596409, 863.7711006583261, 863.8142799298149, 864.1056506515757, 716.824378027384, 835.2315869400136, 858.6007506509441, 860.0152825015385, 863.7883718488979, 624.6658037949675, 625.7152995387088, 626.1765778001912, 626.5520153090562, 626.7493002798872, 11461.0, 11512.079033677286, 11517.424128793611, 11529.077673786078, 11531.13516486267, 12983.935080324538, 13765.311734413339, 13777.380017899119, 13816.516421925286, 13995.37020834065, 12159.209651372632, 12424.0, 12494.375281235993, 12520.0, 12594.937025314815, 4369.344598310247, 4493.96638773084, 4520.706154100006, 4561.156186105581, 4576.359309696645, 55906.72046639781, 56047.71976140134, 56282.43717562813, 56821.71589142069, 58674.119888202134, 11071.889281107085, 11166.497507612177, 11209.55161793519, 11496.77006459866, 11532.538698452136, 19229.90385048066, 19249.0, 19249.422517324503, 19400.8059919399, 20248.493787655425, 7995.360371170293, 8135.6100466593625, 8186.672533098728, 8257.174282571696, 8321.583920803936, 4446.466424029137, 4560.2019646562385, 4584.747838868828, 4728.38530990969, 4737.431508219036, 3336.2326664867214, 3422.315536892582, 3430.9485357719655, 3437.845296961643, 3444.1733983843696, 516.6564234783901, 589.5872888977733, 599.2958274028, 613.0558939233531, 616.7070641445277, 581.8894410062074, 754.2683596910988, 791.3076058448858, 798.5248776977689, 826.8470332988417, 9775.804483910282, 10014.899851001397, 10109.39343639384, 10181.236407269484, 10250.128739057114, 777.9338756205673, 784.4617003952003, 802.626778547978, 804.2640983500149, 808.2967817998261, 4513.616342610849, 4691.906161876744, 4810.903781924412, 4895.730734809548, 4951.653384263139, 65256.67371663206, 65625.67187164034, 67041.66479167671, 67815.0, 68409.89540627578, 57640.71179644075, 57719.711401443565, 57858.42141578614, 58144.418555814744, 59480.70259648761, 54376.0, 54519.45480545144, 54681.45318546764, 54889.176662350896, 55126.724366378716, 8787.428817127122, 8802.0, 8939.955300223457, 8942.150495702897, 9025.954870225607, 33985.0, 37019.0, 37210.44184337183, 37379.81310093432, 37439.251214976095, 49142.0, 49291.0, 49926.00739925978, 49936.25095623496, 50382.49617503778, 11923.10576706733, 12227.44976476043, 12420.813687794871, 12592.685182870502, 12812.935935320264, 13628.52300169529, 13922.164670119826, 14144.363503642566, 14355.282235888373, 14874.0, 12787.424565894371, 12885.742285154432, 13077.542286019943, 13086.214827110403, 13186.736265274832, 13154.736905262032, 13199.0, 13279.867201327863, 13315.866841331463, 13353.065285429926, 13130.737385252432, 13339.399727012114, 13416.664583385493, 13614.319284035957, 13943.30283485842, 10754.40850753216, 10978.505967231335, 11036.0, 11292.717682057686, 11394.145439091935, 11102.0, 11276.492557835081, 11329.206955513035, 11400.372979486208, 11436.599719009795], "value": 6946.140444032782, "unit": "score"}], "name": "dromaeo_css", "value": 7144.601242512732, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 111.0, 112.0, 111.0, 114.0, 110.0, 110.0, 110.0, 110.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 123.0, 126.0, 188.0, 126.0, 125.0, 152.0, 126.0, 168.0, 126.0], "value": 142.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 161.0, 160.0, 162.0, 162.0, 161.0, 162.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 73.0, 111.0, 76.0, 75.0, 75.0, 76.0, 119.0, 74.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 123.0, 84.0, 83.0, 87.0, 123.0, 83.0, 84.0, 134.0], "value": 96.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 144.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 53.0, 54.0, 53.0, 53.0, 66.0, 52.0, 51.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 60.0, 61.0, 61.0, 61.0, 61.0, 62.0, 62.0, 61.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 79.0, 78.0, 79.0, 80.0, 81.0, 79.0, 79.0, 80.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 121.0, 130.0, 132.0, 135.0, 119.0, 119.0, 127.0, 177.0, 137.0], "value": 132.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 160.0, 161.0, 155.0, 157.0, 161.0, 155.0, 156.0, 156.0, 159.0], "value": 157.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 64.0, 62.0, 62.0, 65.0, 62.0, 63.0, 62.0, 61.0, 62.0], "value": 62.4, "unit": "score"}], "name": "kraken", "value": 1499.0, "alertThreshold": 2.0}]} 18:45:05 INFO - Return code: 0 18:45:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:45:05 ERROR - # TBPL SUCCESS # 18:45:05 INFO - Running post-action listener: _resource_record_post_action 18:45:05 INFO - ##### 18:45:05 INFO - ##### Finished run-tests step (success) 18:45:05 INFO - ##### 18:45:05 INFO - Running post-run listener: _resource_record_post_run 18:45:05 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 538263552; Read time: 16; Write time: 717012 18:45:05 INFO - TinderboxPrint: CPU usage
13.2% 18:45:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 18:45:05 INFO - TinderboxPrint: I/O write bytes / time
538,263,552 / 717,012 18:45:05 INFO - TinderboxPrint: CPU idle
8,254.7 (86.8%) 18:45:05 INFO - TinderboxPrint: CPU user
1,209.9 (12.7%) 18:45:05 INFO - TinderboxPrint: Swap in / out
0 / 0 18:45:05 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 247078912; Read time: 0; Write time: 446092 18:45:05 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288849920; Read time: 16; Write time: 269652 18:45:05 INFO - Running post-run listener: _upload_blobber_files 18:45:05 INFO - Blob upload gear active. 18:45:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:45:05 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 18:45:05 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:45:05 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:45:06 INFO - (blobuploader) - INFO - Open directory for files ... 18:45:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:45:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:45:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:45:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:45:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:45:10 INFO - (blobuploader) - INFO - Done attempting. 18:45:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:45:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:45:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:45:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:45:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:45:11 INFO - (blobuploader) - INFO - Done attempting. 18:45:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:45:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:45:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:45:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:45:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:45:12 INFO - (blobuploader) - INFO - Done attempting. 18:45:12 INFO - (blobuploader) - INFO - Iteration through files over. 18:45:12 INFO - Return code: 0 18:45:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:45:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:45:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c2ce74cac3509ab5f073842e1c6f9e7e12a4a05a1a625afd6675952ba864475e204aeb6c0c9c1d80cf9d8fc61613411526f6f3a86563caec647b8ba901506a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cbc3ac03af9eb692161ea1326fc09830a740df8246c90f1089688279380adac656f44b26e07c219782451e05867d5e18fdbfc1fbcfa92f80f35286260f51096a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc5505c4a792aa96954a7114e738e5770edf43d6c81169cc5d2d0c6594e45572f2139d96b7645b46db20085eb174d900e94d6cdbf3aee341b2115b8670ad6ea0"} 18:45:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:45:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:45:12 INFO - Contents: 18:45:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c2ce74cac3509ab5f073842e1c6f9e7e12a4a05a1a625afd6675952ba864475e204aeb6c0c9c1d80cf9d8fc61613411526f6f3a86563caec647b8ba901506a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cbc3ac03af9eb692161ea1326fc09830a740df8246c90f1089688279380adac656f44b26e07c219782451e05867d5e18fdbfc1fbcfa92f80f35286260f51096a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc5505c4a792aa96954a7114e738e5770edf43d6c81169cc5d2d0c6594e45572f2139d96b7645b46db20085eb174d900e94d6cdbf3aee341b2115b8670ad6ea0"} 18:45:12 INFO - Running post-run listener: copy_logs_to_upload_dir 18:45:12 INFO - Copying logs to upload dir... 18:45:12 INFO - mkdir: /builds/slave/test/build/upload/logs 18:45:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.262259 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-26 18:45:12.050882) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 18:45:12.054874) ========= 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=5bd038846534b2fdfa68eeae000001e2-1464311654.180325-566984253 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c2ce74cac3509ab5f073842e1c6f9e7e12a4a05a1a625afd6675952ba864475e204aeb6c0c9c1d80cf9d8fc61613411526f6f3a86563caec647b8ba901506a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cbc3ac03af9eb692161ea1326fc09830a740df8246c90f1089688279380adac656f44b26e07c219782451e05867d5e18fdbfc1fbcfa92f80f35286260f51096a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc5505c4a792aa96954a7114e738e5770edf43d6c81169cc5d2d0c6594e45572f2139d96b7645b46db20085eb174d900e94d6cdbf3aee341b2115b8670ad6ea0"} build_url:https://queue.taskcluster.net/v1/task/SwsAjrwvSfe5IvP9pY34OA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011442 build_url: 'https://queue.taskcluster.net/v1/task/SwsAjrwvSfe5IvP9pY34OA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c2ce74cac3509ab5f073842e1c6f9e7e12a4a05a1a625afd6675952ba864475e204aeb6c0c9c1d80cf9d8fc61613411526f6f3a86563caec647b8ba901506a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cbc3ac03af9eb692161ea1326fc09830a740df8246c90f1089688279380adac656f44b26e07c219782451e05867d5e18fdbfc1fbcfa92f80f35286260f51096a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc5505c4a792aa96954a7114e738e5770edf43d6c81169cc5d2d0c6594e45572f2139d96b7645b46db20085eb174d900e94d6cdbf3aee341b2115b8670ad6ea0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 18:45:12.080845) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 18:45:12.081191) ========= 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=5bd038846534b2fdfa68eeae000001e2-1464311654.180325-566984253 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 18:45:12.168204) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 18:45:12.168564) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 18:45:12.168898) ========= ========= Total master_lag: 0.16 =========