builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-046 starttime: 1463454951.73 results: success (0) buildid: 20160516173016 builduid: 1557819d61294a6b8fc8022ab87cecc4 revision: cf83a5943afc01c163b8fbe438e332a31f08701a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 20:15:51.729029) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 20:15:51.729640) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 20:15:51.730133) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 20:15:51.747575) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 20:15:51.748070) ========= 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=652eb03db935cfc1c15ebda0000001ad-1463454951.648315-2130897345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-16 20:15:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-05-16 20:15:52 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.072856 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 20:15:51.835016) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 20:15:51.835338) ========= 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=652eb03db935cfc1c15ebda0000001ad-1463454951.648315-2130897345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021028 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 20:15:51.884623) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-16 20:15:51.884995) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cf83a5943afc01c163b8fbe438e332a31f08701a --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 cf83a5943afc01c163b8fbe438e332a31f08701a --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=652eb03db935cfc1c15ebda0000001ad-1463454951.648315-2130897345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-16 20:15:52,556 truncating revision to first 12 chars 2016-05-16 20:15:52,556 Setting DEBUG logging. 2016-05-16 20:15:52,556 attempt 1/10 2016-05-16 20:15:52,556 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cf83a5943afc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-16 20:15:53,315 unpacking tar archive at: fx-team-cf83a5943afc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.065729 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-16 20:15:52.963404) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 20:15:52.963766) ========= script_repo_revision: cf83a5943afc01c163b8fbe438e332a31f08701a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 20:15:52.964145) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 20:15:52.964413) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 20:15:52.971475) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-16 20:15:52.971784) ========= /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=652eb03db935cfc1c15ebda0000001ad-1463454951.648315-2130897345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:15:53 INFO - MultiFileLogger online at 20160516 20:15:53 in /builds/slave/test 20:15:53 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 20:15:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:15:53 INFO - {'append_to_log': False, 20:15:53 INFO - 'base_work_dir': '/builds/slave/test', 20:15:53 INFO - 'blob_upload_branch': 'Fx-Team', 20:15:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:15:53 INFO - 'branch': 'Fx-Team', 20:15:53 INFO - 'buildbot_json_path': 'buildprops.json', 20:15:53 INFO - 'config_files': ('talos/linux_config.py',), 20:15:53 INFO - 'default_actions': ('clobber', 20:15:53 INFO - 'read-buildbot-config', 20:15:53 INFO - 'download-and-extract', 20:15:53 INFO - 'populate-webroot', 20:15:53 INFO - 'create-virtualenv', 20:15:53 INFO - 'install', 20:15:53 INFO - 'run-tests'), 20:15:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:15:53 INFO - 'download_minidump_stackwalk': True, 20:15:53 INFO - 'download_symbols': 'ondemand', 20:15:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:15:53 INFO - 'tooltool.py': '/tools/tooltool.py', 20:15:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:15:53 INFO - '/tools/misc-python/virtualenv.py')}, 20:15:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:15:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:15:53 INFO - 'installer_path': 'installer.exe', 20:15:53 INFO - 'log_level': 'info', 20:15:53 INFO - 'log_name': 'talos', 20:15:53 INFO - 'log_to_console': True, 20:15:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:15:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:15:53 INFO - 'opt_config_files': (), 20:15:53 INFO - 'pip_index': False, 20:15:53 INFO - 'sps_profile': False, 20:15:53 INFO - 'sps_profile_interval': 0, 20:15:53 INFO - 'suite': 'dromaeojs', 20:15:53 INFO - 'system_bits': '32', 20:15:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:15:53 INFO - 'title': 'talos-linux64-ix-046', 20:15:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:15:53 INFO - 'use_talos_json': True, 20:15:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:15:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:15:53 INFO - 'work_dir': 'build'} 20:15:53 INFO - ##### 20:15:53 INFO - ##### Running clobber step. 20:15:53 INFO - ##### 20:15:53 INFO - Running pre-action listener: _resource_record_pre_action 20:15:53 INFO - Running main action method: clobber 20:15:53 INFO - rmtree: /builds/slave/test/build 20:15:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:15:54 INFO - Running post-action listener: _resource_record_post_action 20:15:54 INFO - ##### 20:15:54 INFO - ##### Finished clobber step (success) 20:15:54 INFO - ##### 20:15:54 INFO - ##### 20:15:54 INFO - ##### Running read-buildbot-config step. 20:15:54 INFO - ##### 20:15:54 INFO - Running pre-action listener: _resource_record_pre_action 20:15:54 INFO - Running main action method: read_buildbot_config 20:15:54 INFO - Using buildbot properties: 20:15:54 INFO - { 20:15:54 INFO - "project": "", 20:15:54 INFO - "product": "firefox", 20:15:54 INFO - "script_repo_revision": "production", 20:15:54 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:15:54 INFO - "repository": "", 20:15:54 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:15:54 INFO - "buildid": "20160516173016", 20:15:54 INFO - "pgo_build": "True", 20:15:54 INFO - "basedir": "/builds/slave/test", 20:15:54 INFO - "buildnumber": 1158, 20:15:54 INFO - "slavename": "talos-linux64-ix-046", 20:15:54 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:15:54 INFO - "platform": "ubuntu64_hw", 20:15:54 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:15:54 INFO - "branch": "fx-team", 20:15:54 INFO - "repo_path": "integration/fx-team", 20:15:54 INFO - "revision": "cf83a5943afc01c163b8fbe438e332a31f08701a", 20:15:54 INFO - "stage_platform": "linux64-pgo", 20:15:54 INFO - "builduid": "1557819d61294a6b8fc8022ab87cecc4", 20:15:54 INFO - "slavebuilddir": "test" 20:15:54 INFO - } 20:15:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 20:15:54 INFO - Running post-action listener: _resource_record_post_action 20:15:54 INFO - ##### 20:15:54 INFO - ##### Finished read-buildbot-config step (success) 20:15:54 INFO - ##### 20:15:54 INFO - ##### 20:15:54 INFO - ##### Running download-and-extract step. 20:15:54 INFO - ##### 20:15:54 INFO - Running pre-action listener: _resource_record_pre_action 20:15:54 INFO - Running main action method: download_and_extract 20:15:54 INFO - mkdir: /builds/slave/test/build/tests 20:15:54 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')]} 20:15:54 INFO - https://queue.taskcluster.net/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:15:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:15:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:15:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/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 20:15:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/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 20:15:55 INFO - Downloaded 1361 bytes. 20:15:55 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:15:55 INFO - Using the following test package requirements: 20:15:55 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:15:55 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:15:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:15:55 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:15:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:15:55 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:15:55 INFO - u'jsshell-linux-x86_64.zip'], 20:15:55 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:15:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:15:55 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:15:55 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:15:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:15:55 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:15:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:15:55 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:15:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:15:55 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:15:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:15:55 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:15:55 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')]} 20:15:55 INFO - https://queue.taskcluster.net/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:15:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:15:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:15:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/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 20:15:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/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 20:15:56 INFO - Downloaded 24023206 bytes. 20:15:56 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'] 20:15:56 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 20:15:58 INFO - Return code: 0 20:15:58 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 20:15:58 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')]} 20:15:58 INFO - https://queue.taskcluster.net/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:15:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:15:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:15:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/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 20:15:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/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 20:16:00 INFO - Downloaded 24023206 bytes. 20:16:00 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'] 20:16:00 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 20:16:01 INFO - Return code: 0 20:16:01 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')]} 20:16:01 INFO - https://queue.taskcluster.net/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:16:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:16:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:16:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/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 20:16:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/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 20:16:03 INFO - Downloaded 10840194 bytes. 20:16:03 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'] 20:16:03 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 20:16:03 INFO - Return code: 0 20:16:03 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')]} 20:16:03 INFO - https://queue.taskcluster.net/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:16:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:16:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:16:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/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 20:16:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/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 20:16:04 INFO - Downloaded 58427509 bytes. 20:16:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:16:04 INFO - mkdir: /builds/slave/test/properties 20:16:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:16:04 INFO - Writing to file /builds/slave/test/properties/build_url 20:16:04 INFO - Contents: 20:16:04 INFO - build_url:https://queue.taskcluster.net/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:16:05 INFO - Running post-action listener: _resource_record_post_action 20:16:05 INFO - Running post-action listener: set_extra_try_arguments 20:16:05 INFO - ##### 20:16:05 INFO - ##### Finished download-and-extract step (success) 20:16:05 INFO - ##### 20:16:05 INFO - ##### 20:16:05 INFO - ##### Running populate-webroot step. 20:16:05 INFO - ##### 20:16:05 INFO - Running pre-action listener: _resource_record_pre_action 20:16:05 INFO - Running main action method: populate_webroot 20:16:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:16:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:16:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:16:05 INFO - '--tppagecycles', 20:16:05 INFO - '7'], 20:16:05 INFO - 'tests': ['tsvgm']}}, 20:16:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:16:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:16:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:16:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:16:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:16:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:16:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:05 INFO - 'talos_options': ['--disable-e10s'], 20:16:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:16:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:16:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:05 INFO - 'talos_options': ['--disable-e10s'], 20:16:05 INFO - 'tests': ['damp', 'tps']}, 20:16:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:05 INFO - 'tests': ['damp', 'tps']}, 20:16:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:16:05 INFO - 'tests': ['dromaeo_dom']}, 20:16:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:16:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:16:05 INFO - 'tests': ['a11yr', 20:16:05 INFO - 'ts_paint', 20:16:05 INFO - 'tpaint', 20:16:05 INFO - 'sessionrestore', 20:16:05 INFO - 'sessionrestore_no_auto_restore', 20:16:05 INFO - 'tabpaint']}, 20:16:05 INFO - 'other-e10s': {'tests': ['a11yr', 20:16:05 INFO - 'ts_paint', 20:16:05 INFO - 'tpaint', 20:16:05 INFO - 'sessionrestore', 20:16:05 INFO - 'sessionrestore_no_auto_restore', 20:16:05 INFO - 'tabpaint']}, 20:16:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:16:05 INFO - 'ts_paint', 20:16:05 INFO - 'tpaint', 20:16:05 INFO - 'sessionrestore', 20:16:05 INFO - 'sessionrestore_no_auto_restore', 20:16:05 INFO - 'tabpaint']}, 20:16:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:16:05 INFO - 'ts_paint', 20:16:05 INFO - 'tpaint', 20:16:05 INFO - 'sessionrestore', 20:16:05 INFO - 'sessionrestore_no_auto_restore', 20:16:05 INFO - 'tabpaint']}, 20:16:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:16:05 INFO - 'tests': ['a11yr', 20:16:05 INFO - 'ts_paint', 20:16:05 INFO - 'tpaint', 20:16:05 INFO - 'sessionrestore', 20:16:05 INFO - 'sessionrestore_no_auto_restore', 20:16:05 INFO - 'tabpaint']}, 20:16:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:16:05 INFO - 'tests': ['a11yr', 20:16:05 INFO - 'ts_paint', 20:16:05 INFO - 'tpaint', 20:16:05 INFO - 'sessionrestore', 20:16:05 INFO - 'sessionrestore_no_auto_restore', 20:16:05 INFO - 'tabpaint']}, 20:16:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:16:05 INFO - 'tests': ['tsvgx', 20:16:05 INFO - 'tsvgr_opacity', 20:16:05 INFO - 'tart', 20:16:05 INFO - 'tscrollx', 20:16:05 INFO - 'cart']}, 20:16:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:16:05 INFO - 'tsvgr_opacity', 20:16:05 INFO - 'tart', 20:16:05 INFO - 'tscrollx', 20:16:05 INFO - 'cart']}, 20:16:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:05 INFO - 'talos_options': ['--disable-e10s'], 20:16:05 INFO - 'tests': ['tp5o']}, 20:16:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:05 INFO - 'tests': ['tp5o']}, 20:16:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:05 INFO - 'talos_options': ['--disable-e10s', 20:16:05 INFO - '--xperf_path', 20:16:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:16:05 INFO - 'tests': ['tp5n']}, 20:16:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:05 INFO - 'talos_options': ['--xperf_path', 20:16:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:16:05 INFO - 'tests': ['tp5n']}}, 20:16:05 INFO - 'talos.zip': {'path': '', 20:16:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:16:05 INFO - Running post-action listener: _resource_record_post_action 20:16:05 INFO - ##### 20:16:05 INFO - ##### Finished populate-webroot step (success) 20:16:05 INFO - ##### 20:16:05 INFO - ##### 20:16:05 INFO - ##### Running create-virtualenv step. 20:16:05 INFO - ##### 20:16:05 INFO - Running pre-action listener: _resource_record_pre_action 20:16:05 INFO - Running main action method: create_virtualenv 20:16:05 INFO - Creating virtualenv /builds/slave/test/build/venv 20:16:05 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 20:16:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:16:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:16:05 INFO - Using real prefix '/usr' 20:16:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:16:06 INFO - Installing distribute.............................................................................................................................................................................................done. 20:16:07 INFO - Installing pip.................done. 20:16:07 INFO - Return code: 0 20:16:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:16: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')]} 20:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16: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')]} 20:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6bcbbdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a91770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b209c0>, '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 0x2b218c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b21d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1463454951.648315-2130897345', '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 20:16: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', 'pip>=1.5'] in /builds/slave/test/build 20:16: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 pip>=1.5 20:16:07 INFO - Using env: {'DISPLAY': ':0', 20:16:07 INFO - 'HOME': '/home/cltbld', 20:16:07 INFO - 'LANG': 'en_US.UTF-8', 20:16:07 INFO - 'LANGUAGE': 'en_US:en', 20:16:07 INFO - 'LOGNAME': 'cltbld', 20:16:07 INFO - 'MAIL': '/var/mail/cltbld', 20:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:07 INFO - 'MOZ_NO_REMOTE': '1', 20:16:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:07 INFO - 'NO_EM_RESTART': '1', 20:16:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:07 INFO - 'PWD': '/builds/slave/test', 20:16:07 INFO - 'SHELL': '/bin/bash', 20:16:07 INFO - 'SHLVL': '1', 20:16:07 INFO - 'TERM': 'linux', 20:16:07 INFO - 'TMOUT': '86400', 20:16:07 INFO - 'USER': 'cltbld', 20:16:07 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1463454951.648315-2130897345', 20:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:07 INFO - '_': '/tools/buildbot/bin/python'} 20:16:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:08 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 20:16:08 INFO - Cleaning up... 20:16:08 INFO - Return code: 0 20:16:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:16:08 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')]} 20:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:08 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')]} 20:16:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:08 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 0x7f6bcbbdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a91770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b209c0>, '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 0x2b218c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b21d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1463454951.648315-2130897345', '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 20:16:08 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 20:16:08 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 20:16:08 INFO - Using env: {'DISPLAY': ':0', 20:16:08 INFO - 'HOME': '/home/cltbld', 20:16:08 INFO - 'LANG': 'en_US.UTF-8', 20:16:08 INFO - 'LANGUAGE': 'en_US:en', 20:16:08 INFO - 'LOGNAME': 'cltbld', 20:16:08 INFO - 'MAIL': '/var/mail/cltbld', 20:16:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:08 INFO - 'MOZ_NO_REMOTE': '1', 20:16:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:08 INFO - 'NO_EM_RESTART': '1', 20:16:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:08 INFO - 'PWD': '/builds/slave/test', 20:16:08 INFO - 'SHELL': '/bin/bash', 20:16:08 INFO - 'SHLVL': '1', 20:16:08 INFO - 'TERM': 'linux', 20:16:08 INFO - 'TMOUT': '86400', 20:16:08 INFO - 'USER': 'cltbld', 20:16:08 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1463454951.648315-2130897345', 20:16:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:08 INFO - '_': '/tools/buildbot/bin/python'} 20:16:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:08 INFO - Downloading/unpacking psutil>=3.1.1 20:16:08 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 20:16:08 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 20:16:08 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 20:16:08 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 20:16:08 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 20:16:08 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 20:16:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:16:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:16:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:16:10 INFO - Installing collected packages: psutil 20:16:10 INFO - Running setup.py install for psutil 20:16:10 INFO - building 'psutil._psutil_linux' extension 20:16:10 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 20:16:10 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 20:16:10 INFO - building 'psutil._psutil_posix' extension 20:16:10 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 20:16:10 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 20:16:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:16:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:16:10 INFO - Successfully installed psutil 20:16:10 INFO - Cleaning up... 20:16:10 INFO - Return code: 0 20:16:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:16:10 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')]} 20:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:10 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')]} 20:16:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:10 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 0x7f6bcbbdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a91770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b209c0>, '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 0x2b218c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b21d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1463454951.648315-2130897345', '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 20:16:10 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 20:16:10 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 20:16:10 INFO - Using env: {'DISPLAY': ':0', 20:16:10 INFO - 'HOME': '/home/cltbld', 20:16:10 INFO - 'LANG': 'en_US.UTF-8', 20:16:10 INFO - 'LANGUAGE': 'en_US:en', 20:16:10 INFO - 'LOGNAME': 'cltbld', 20:16:10 INFO - 'MAIL': '/var/mail/cltbld', 20:16:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:10 INFO - 'MOZ_NO_REMOTE': '1', 20:16:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:10 INFO - 'NO_EM_RESTART': '1', 20:16:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:10 INFO - 'PWD': '/builds/slave/test', 20:16:10 INFO - 'SHELL': '/bin/bash', 20:16:10 INFO - 'SHLVL': '1', 20:16:10 INFO - 'TERM': 'linux', 20:16:10 INFO - 'TMOUT': '86400', 20:16:10 INFO - 'USER': 'cltbld', 20:16:10 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1463454951.648315-2130897345', 20:16:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:10 INFO - '_': '/tools/buildbot/bin/python'} 20:16:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:16: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 20:16: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 20:16: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 20:16: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 20:16: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 20:16: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 20:16:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:16:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:16:13 INFO - Installing collected packages: mozsystemmonitor 20:16:13 INFO - Running setup.py install for mozsystemmonitor 20:16:13 INFO - Successfully installed mozsystemmonitor 20:16:13 INFO - Cleaning up... 20:16:13 INFO - Return code: 0 20:16:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:16:13 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')]} 20:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:13 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')]} 20:16:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:13 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 0x7f6bcbbdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a91770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b209c0>, '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 0x2b218c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b21d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1463454951.648315-2130897345', '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 20:16:13 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 20:16:13 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 20:16:13 INFO - Using env: {'DISPLAY': ':0', 20:16:13 INFO - 'HOME': '/home/cltbld', 20:16:13 INFO - 'LANG': 'en_US.UTF-8', 20:16:13 INFO - 'LANGUAGE': 'en_US:en', 20:16:13 INFO - 'LOGNAME': 'cltbld', 20:16:13 INFO - 'MAIL': '/var/mail/cltbld', 20:16:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:13 INFO - 'MOZ_NO_REMOTE': '1', 20:16:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:13 INFO - 'NO_EM_RESTART': '1', 20:16:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:13 INFO - 'PWD': '/builds/slave/test', 20:16:13 INFO - 'SHELL': '/bin/bash', 20:16:13 INFO - 'SHLVL': '1', 20:16:13 INFO - 'TERM': 'linux', 20:16:13 INFO - 'TMOUT': '86400', 20:16:13 INFO - 'USER': 'cltbld', 20:16:13 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1463454951.648315-2130897345', 20:16:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:13 INFO - '_': '/tools/buildbot/bin/python'} 20:16:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:13 INFO - Downloading/unpacking blobuploader==1.2.4 20:16:13 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 20:16:13 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 20:16:13 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 20:16:13 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 20:16:13 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 20:16:13 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 20:16:15 INFO - Downloading blobuploader-1.2.4.tar.gz 20:16:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:16:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:16:15 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 20:16:15 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 20:16:15 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 20:16:15 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 20:16:15 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 20:16:15 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 20:16:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:16:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:16:15 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 20:16:15 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 20:16:15 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 20:16:15 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 20:16:15 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 20:16:15 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 20:16:16 INFO - Downloading docopt-0.6.1.tar.gz 20:16:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:16:16 INFO - Installing collected packages: blobuploader, requests, docopt 20:16:16 INFO - Running setup.py install for blobuploader 20:16:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:16:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:16:16 INFO - Running setup.py install for requests 20:16:16 INFO - Running setup.py install for docopt 20:16:16 INFO - Successfully installed blobuploader requests docopt 20:16:16 INFO - Cleaning up... 20:16:16 INFO - Return code: 0 20:16:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:16:16 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')]} 20:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:16 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')]} 20:16:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:16 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 0x7f6bcbbdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a91770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b209c0>, '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 0x2b218c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b21d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1463454951.648315-2130897345', '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 20:16:16 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 20:16:16 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 20:16:16 INFO - Using env: {'DISPLAY': ':0', 20:16:16 INFO - 'HOME': '/home/cltbld', 20:16:16 INFO - 'LANG': 'en_US.UTF-8', 20:16:16 INFO - 'LANGUAGE': 'en_US:en', 20:16:16 INFO - 'LOGNAME': 'cltbld', 20:16:16 INFO - 'MAIL': '/var/mail/cltbld', 20:16:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:16 INFO - 'MOZ_NO_REMOTE': '1', 20:16:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:16 INFO - 'NO_EM_RESTART': '1', 20:16:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:16 INFO - 'PWD': '/builds/slave/test', 20:16:16 INFO - 'SHELL': '/bin/bash', 20:16:16 INFO - 'SHLVL': '1', 20:16:16 INFO - 'TERM': 'linux', 20:16:16 INFO - 'TMOUT': '86400', 20:16:16 INFO - 'USER': 'cltbld', 20:16:16 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1463454951.648315-2130897345', 20:16:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:16 INFO - '_': '/tools/buildbot/bin/python'} 20:16:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:16:16 INFO - Running setup.py (path:/tmp/pip-NnlvSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:16:16 INFO - Running setup.py (path:/tmp/pip-k2SBmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:16:17 INFO - Running setup.py (path:/tmp/pip-hD_Rfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:16:17 INFO - Running setup.py (path:/tmp/pip-Xa28VT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:16:17 INFO - Running setup.py (path:/tmp/pip-vaJFkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:16:17 INFO - Running setup.py (path:/tmp/pip-pOuo8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:16:17 INFO - Running setup.py (path:/tmp/pip-MgbTNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:16:17 INFO - Running setup.py (path:/tmp/pip-q4m_2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:16:17 INFO - Running setup.py (path:/tmp/pip-ib5nEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:16:17 INFO - Running setup.py (path:/tmp/pip-ZInz6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:16:17 INFO - Running setup.py (path:/tmp/pip-DIHGa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:16:17 INFO - Running setup.py (path:/tmp/pip-udFeK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:16:17 INFO - Running setup.py (path:/tmp/pip-edst6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:16:17 INFO - Running setup.py (path:/tmp/pip-0b6p74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:16:17 INFO - Running setup.py (path:/tmp/pip-mHpC2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:16:18 INFO - Running setup.py (path:/tmp/pip-W8hXFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:16:18 INFO - Running setup.py (path:/tmp/pip-XiezOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:16:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:16:18 INFO - Running setup.py install for manifestparser 20:16:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:16:18 INFO - Running setup.py install for mozcrash 20:16:18 INFO - Running setup.py install for mozdebug 20:16:18 INFO - Running setup.py install for mozdevice 20:16:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:16:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:16:18 INFO - Running setup.py install for mozfile 20:16:18 INFO - Running setup.py install for mozhttpd 20:16:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:16:18 INFO - Running setup.py install for mozinfo 20:16:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:16:18 INFO - Running setup.py install for mozInstall 20:16:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:16:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:16:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:16:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:16:18 INFO - Running setup.py install for mozleak 20:16:19 INFO - Running setup.py install for mozlog 20:16:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:16:19 INFO - Running setup.py install for moznetwork 20:16:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:16:19 INFO - Running setup.py install for mozprocess 20:16:19 INFO - Running setup.py install for mozprofile 20:16:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:16:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:16:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:16:19 INFO - Running setup.py install for mozrunner 20:16:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:16:19 INFO - Running setup.py install for mozscreenshot 20:16:19 INFO - Running setup.py install for moztest 20:16:19 INFO - Running setup.py install for mozversion 20:16:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:16:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:16:19 INFO - Cleaning up... 20:16:19 INFO - Return code: 0 20:16:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:16:19 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')]} 20:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:19 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')]} 20:16:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:19 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 0x7f6bcbbdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a91770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b209c0>, '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 0x2b218c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b21d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1463454951.648315-2130897345', '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 20:16:19 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 20:16:19 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 20:16:19 INFO - Using env: {'DISPLAY': ':0', 20:16:19 INFO - 'HOME': '/home/cltbld', 20:16:19 INFO - 'LANG': 'en_US.UTF-8', 20:16:19 INFO - 'LANGUAGE': 'en_US:en', 20:16:19 INFO - 'LOGNAME': 'cltbld', 20:16:19 INFO - 'MAIL': '/var/mail/cltbld', 20:16:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:19 INFO - 'MOZ_NO_REMOTE': '1', 20:16:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:19 INFO - 'NO_EM_RESTART': '1', 20:16:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:19 INFO - 'PWD': '/builds/slave/test', 20:16:19 INFO - 'SHELL': '/bin/bash', 20:16:19 INFO - 'SHLVL': '1', 20:16:19 INFO - 'TERM': 'linux', 20:16:19 INFO - 'TMOUT': '86400', 20:16:19 INFO - 'USER': 'cltbld', 20:16:19 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1463454951.648315-2130897345', 20:16:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:19 INFO - '_': '/tools/buildbot/bin/python'} 20:16:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:16:20 INFO - Running setup.py (path:/tmp/pip-KgvhRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:16:20 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)) 20:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:16:20 INFO - Running setup.py (path:/tmp/pip-w5f0nD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:16:20 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)) 20:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:16:20 INFO - Running setup.py (path:/tmp/pip-tLKBrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:16:20 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)) 20:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:16:20 INFO - Running setup.py (path:/tmp/pip-mlqALH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:16:20 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)) 20:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:16:20 INFO - Running setup.py (path:/tmp/pip-QWvZrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:16:20 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)) 20:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:16:20 INFO - Running setup.py (path:/tmp/pip-xYw6IY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:16:20 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)) 20:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:16:20 INFO - Running setup.py (path:/tmp/pip-keczb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:16:20 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)) 20:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:16:20 INFO - Running setup.py (path:/tmp/pip-iSOEbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:16:20 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)) 20:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:16:20 INFO - Running setup.py (path:/tmp/pip-bhaGbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:16:20 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)) 20:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:16:20 INFO - Running setup.py (path:/tmp/pip-DRQWq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:16:20 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)) 20:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:16:20 INFO - Running setup.py (path:/tmp/pip-HAbTPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:16:20 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)) 20:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:16:20 INFO - Running setup.py (path:/tmp/pip-fRoxTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:16:20 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)) 20:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:16:21 INFO - Running setup.py (path:/tmp/pip-KJLFRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:16:21 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)) 20:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:16:21 INFO - Running setup.py (path:/tmp/pip-_GxrOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:16:21 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)) 20:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:16:21 INFO - Running setup.py (path:/tmp/pip-ya_txX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:16:21 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)) 20:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:16:21 INFO - Running setup.py (path:/tmp/pip-b2sD_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:16:21 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)) 20:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:16:21 INFO - Running setup.py (path:/tmp/pip-hKN2x6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:16:21 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)) 20:16:21 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)) 20:16:21 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)) 20:16:21 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)) 20:16:21 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)) 20:16:21 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)) 20:16:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:16:21 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 20:16:21 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 20:16:21 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 20:16:21 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 20:16:21 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 20:16:21 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 20:16:23 INFO - Downloading blessings-1.6.tar.gz 20:16:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:16:23 INFO - Installing collected packages: blessings 20:16:23 INFO - Running setup.py install for blessings 20:16:23 INFO - Successfully installed blessings 20:16:23 INFO - Cleaning up... 20:16:23 INFO - Return code: 0 20:16:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:16:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:16:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:16:23 INFO - Reading from file tmpfile_stdout 20:16:23 INFO - Current package versions: 20:16:23 INFO - argparse == 1.2.1 20:16:23 INFO - blessings == 1.6 20:16:23 INFO - blobuploader == 1.2.4 20:16:23 INFO - docopt == 0.6.1 20:16:23 INFO - manifestparser == 1.1 20:16:23 INFO - mozInstall == 1.12 20:16:23 INFO - mozcrash == 0.17 20:16:23 INFO - mozdebug == 0.1 20:16:23 INFO - mozdevice == 0.48 20:16:23 INFO - mozfile == 1.2 20:16:23 INFO - mozhttpd == 0.7 20:16:23 INFO - mozinfo == 0.9 20:16:23 INFO - mozleak == 0.1 20:16:23 INFO - mozlog == 3.2 20:16:23 INFO - moznetwork == 0.27 20:16:23 INFO - mozprocess == 0.22 20:16:23 INFO - mozprofile == 0.28 20:16:23 INFO - mozrunner == 6.11 20:16:23 INFO - mozscreenshot == 0.1 20:16:23 INFO - mozsystemmonitor == 0.3 20:16:23 INFO - moztest == 0.7 20:16:23 INFO - mozversion == 1.4 20:16:23 INFO - psutil == 3.1.1 20:16:23 INFO - requests == 1.2.3 20:16:23 INFO - wsgiref == 0.1.2 20:16:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:16:23 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')]} 20:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:23 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')]} 20:16:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:23 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 0x7f6bcbbdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a91770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b209c0>, '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 0x2b218c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b21d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1463454951.648315-2130897345', '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 20:16:23 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 20:16:23 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 20:16:23 INFO - Using env: {'DISPLAY': ':0', 20:16:23 INFO - 'HOME': '/home/cltbld', 20:16:23 INFO - 'LANG': 'en_US.UTF-8', 20:16:23 INFO - 'LANGUAGE': 'en_US:en', 20:16:23 INFO - 'LOGNAME': 'cltbld', 20:16:23 INFO - 'MAIL': '/var/mail/cltbld', 20:16:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:23 INFO - 'MOZ_NO_REMOTE': '1', 20:16:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:23 INFO - 'NO_EM_RESTART': '1', 20:16:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:23 INFO - 'PWD': '/builds/slave/test', 20:16:23 INFO - 'SHELL': '/bin/bash', 20:16:23 INFO - 'SHLVL': '1', 20:16:23 INFO - 'TERM': 'linux', 20:16:23 INFO - 'TMOUT': '86400', 20:16:23 INFO - 'USER': 'cltbld', 20:16:23 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1463454951.648315-2130897345', 20:16:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:23 INFO - '_': '/tools/buildbot/bin/python'} 20:16:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:23 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)) 20:16:23 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)) 20:16:23 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)) 20:16:23 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)) 20:16:23 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)) 20:16:23 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)) 20:16:23 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)) 20:16:23 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)) 20:16:23 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)) 20:16:23 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)) 20:16:23 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)) 20:16:23 INFO - Cleaning up... 20:16:23 INFO - Return code: 0 20:16:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:16:23 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')]} 20:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:23 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')]} 20:16:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:23 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 0x7f6bcbbdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a91770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b209c0>, '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 0x2b218c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b21d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1463454951.648315-2130897345', '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 20:16:23 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 20:16:23 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 20:16:23 INFO - Using env: {'DISPLAY': ':0', 20:16:23 INFO - 'HOME': '/home/cltbld', 20:16:23 INFO - 'LANG': 'en_US.UTF-8', 20:16:23 INFO - 'LANGUAGE': 'en_US:en', 20:16:23 INFO - 'LOGNAME': 'cltbld', 20:16:23 INFO - 'MAIL': '/var/mail/cltbld', 20:16:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:23 INFO - 'MOZ_NO_REMOTE': '1', 20:16:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:23 INFO - 'NO_EM_RESTART': '1', 20:16:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:23 INFO - 'PWD': '/builds/slave/test', 20:16:23 INFO - 'SHELL': '/bin/bash', 20:16:23 INFO - 'SHLVL': '1', 20:16:23 INFO - 'TERM': 'linux', 20:16:23 INFO - 'TMOUT': '86400', 20:16:23 INFO - 'USER': 'cltbld', 20:16:23 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1463454951.648315-2130897345', 20:16:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:23 INFO - '_': '/tools/buildbot/bin/python'} 20:16:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:24 INFO - Downloading/unpacking jsonschema 20:16:24 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 20:16:24 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 20:16:24 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 20:16:24 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 20:16:24 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 20:16:24 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 20:16:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:16:26 INFO - Downloading/unpacking functools32 (from jsonschema) 20:16:26 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 20:16:26 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 20:16:26 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 20:16:26 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 20:16:26 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 20:16:26 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 20:16:26 INFO - Downloading functools32-3.2.3-2.tar.gz 20:16:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:16:26 INFO - warning: no files found matching '*.txt' 20:16:26 INFO - no previously-included directories found matching 'build' 20:16:26 INFO - no previously-included directories found matching 'dist' 20:16:26 INFO - no previously-included directories found matching '.git*' 20:16:26 INFO - Installing collected packages: jsonschema, functools32 20:16:26 INFO - Running setup.py install for functools32 20:16:26 INFO - warning: no files found matching '*.txt' 20:16:26 INFO - no previously-included directories found matching 'build' 20:16:26 INFO - no previously-included directories found matching 'dist' 20:16:26 INFO - no previously-included directories found matching '.git*' 20:16:26 INFO - Successfully installed jsonschema functools32 20:16:26 INFO - Cleaning up... 20:16:26 INFO - Return code: 0 20:16:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:16:26 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')]} 20:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:26 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')]} 20:16:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:26 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 0x7f6bcbbdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a91770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b209c0>, '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 0x2b218c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b21d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1463454951.648315-2130897345', '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 20:16:26 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 20:16:26 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 20:16:26 INFO - Using env: {'DISPLAY': ':0', 20:16:26 INFO - 'HOME': '/home/cltbld', 20:16:26 INFO - 'LANG': 'en_US.UTF-8', 20:16:26 INFO - 'LANGUAGE': 'en_US:en', 20:16:26 INFO - 'LOGNAME': 'cltbld', 20:16:26 INFO - 'MAIL': '/var/mail/cltbld', 20:16:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:26 INFO - 'MOZ_NO_REMOTE': '1', 20:16:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:26 INFO - 'NO_EM_RESTART': '1', 20:16:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:26 INFO - 'PWD': '/builds/slave/test', 20:16:26 INFO - 'SHELL': '/bin/bash', 20:16:26 INFO - 'SHLVL': '1', 20:16:26 INFO - 'TERM': 'linux', 20:16:26 INFO - 'TMOUT': '86400', 20:16:26 INFO - 'USER': 'cltbld', 20:16:26 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1463454951.648315-2130897345', 20:16:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:26 INFO - '_': '/tools/buildbot/bin/python'} 20:16:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:26 INFO - Downloading/unpacking flake8 20:16:26 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 20:16:26 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 20:16:26 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 20:16:26 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 20:16:26 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 20:16:26 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 20:16:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:16:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:16:28 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 20:16:28 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 20:16:28 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 20:16:28 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 20:16:28 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 20:16:28 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 20:16:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:16:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:16:28 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 20:16:28 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 20:16:28 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 20:16:28 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 20:16:28 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 20:16:28 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 20:16:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:16:29 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 20:16:29 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 20:16:29 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 20:16:29 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 20:16:29 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 20:16:29 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 20:16:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:16:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:16:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:16:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:16:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:16:29 INFO - no previously-included directories found matching 'docs/_build' 20:16:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:16:29 INFO - Running setup.py install for pep8 20:16:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:16:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:16:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:16:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:16:29 INFO - no previously-included directories found matching 'docs/_build' 20:16:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:16:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:16:29 INFO - Cleaning up... 20:16:29 INFO - Return code: 0 20:16:29 INFO - Running post-action listener: _resource_record_post_action 20:16:29 INFO - Running post-action listener: _start_resource_monitoring 20:16:29 INFO - Starting resource monitoring. 20:16:29 INFO - ##### 20:16:29 INFO - ##### Finished create-virtualenv step (success) 20:16:29 INFO - ##### 20:16:29 INFO - ##### 20:16:29 INFO - ##### Running install step. 20:16:29 INFO - ##### 20:16:29 INFO - Running pre-action listener: _resource_record_pre_action 20:16:29 INFO - Running main action method: install 20:16:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:16:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:16:29 INFO - Reading from file tmpfile_stdout 20:16:29 INFO - Detecting whether we're running mozinstall >=1.0... 20:16:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:16:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:16:29 INFO - Reading from file tmpfile_stdout 20:16:29 INFO - Output received: 20:16:29 INFO - Usage: mozinstall [options] installer 20:16:29 INFO - Options: 20:16:29 INFO - -h, --help show this help message and exit 20:16:29 INFO - -d DEST, --destination=DEST 20:16:29 INFO - Directory to install application into. [default: 20:16:29 INFO - "/builds/slave/test"] 20:16:29 INFO - --app=APP Application being installed. [default: firefox] 20:16:29 INFO - mkdir: /builds/slave/test/build/application 20:16:29 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'] 20:16:29 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 20:16:46 INFO - Reading from file tmpfile_stdout 20:16:46 INFO - Output received: 20:16:46 INFO - /builds/slave/test/build/application/firefox/firefox 20:16:46 INFO - Running post-action listener: _resource_record_post_action 20:16:46 INFO - ##### 20:16:46 INFO - ##### Finished install step (success) 20:16:46 INFO - ##### 20:16:46 INFO - ##### 20:16:46 INFO - ##### Running run-tests step. 20:16:46 INFO - ##### 20:16:46 INFO - Running pre-action listener: _resource_record_pre_action 20:16:46 INFO - Running main action method: run_tests 20:16:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:16:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:16:46 INFO - Python 2.7.3 20:16:46 INFO - Return code: 0 20:16:46 INFO - grabbing minidump binary from tooltool 20:16:46 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')]} 20:16:46 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 0x2b209c0>, '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 0x2b218c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b21d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:16:46 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 20:16:46 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 20:16:46 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 20:16:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:16:46 INFO - Return code: 0 20:16:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:16:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:16:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:16:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:16:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:16:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:16:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:16:47 INFO - Return code: 0 20:16:47 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/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 20:16:47 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/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 20:16:47 INFO - Using env: {'DISPLAY': ':0', 20:16:47 INFO - 'HOME': '/home/cltbld', 20:16:47 INFO - 'LANG': 'en_US.UTF-8', 20:16:47 INFO - 'LANGUAGE': 'en_US:en', 20:16:47 INFO - 'LOGNAME': 'cltbld', 20:16:47 INFO - 'MAIL': '/var/mail/cltbld', 20:16:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:16:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:47 INFO - 'MOZ_NO_REMOTE': '1', 20:16:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:16:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:47 INFO - 'NO_EM_RESTART': '1', 20:16:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:47 INFO - 'PWD': '/builds/slave/test', 20:16:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:16:47 INFO - 'SHELL': '/bin/bash', 20:16:47 INFO - 'SHLVL': '1', 20:16:47 INFO - 'TERM': 'linux', 20:16:47 INFO - 'TMOUT': '86400', 20:16:47 INFO - 'USER': 'cltbld', 20:16:47 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1463454951.648315-2130897345', 20:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:47 INFO - '_': '/tools/buildbot/bin/python'} 20:16:47 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/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 20:16:47 INFO - mozversion application_buildid: 20160516173016 20:16:47 INFO - mozversion application_changeset: cf83a5943afc01c163b8fbe438e332a31f08701a 20:16:47 INFO - mozversion application_display_name: Nightly 20:16:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:16:47 INFO - mozversion application_name: Firefox 20:16:47 INFO - mozversion application_remotingname: firefox 20:16:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:16:47 INFO - mozversion application_vendor: Mozilla 20:16:47 INFO - mozversion application_version: 49.0a1 20:16:47 INFO - mozversion platform_buildid: 20160516173016 20:16:47 INFO - mozversion platform_changeset: cf83a5943afc01c163b8fbe438e332a31f08701a 20:16:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:16:47 INFO - mozversion platform_version: 49.0a1 20:16:47 INFO - using testdate: 1463455007 20:16:47 INFO - actual date: 1463455007 20:16:47 INFO - starting webserver on 'localhost:56745' 20:16:47 INFO - SUITE-START | Running 2 tests 20:16:47 INFO - TEST-START | dromaeo_css 20:16:47 INFO - operating with platform_type : linux_ 20:16:47 INFO - Initialising browser for dromaeo_css test... 20:16:47 INFO - TEST-INFO | started process 31360 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2jDQXc/profile http://localhost:56745/getInfo.html) 20:16:51 INFO - PROCESS | 31360 | __metrics Screen width/height:1600/1200 20:16:51 INFO - PROCESS | 31360 | colorDepth:24 20:16:51 INFO - PROCESS | 31360 | Browser inner width/height: 1024/697 20:16:51 INFO - PROCESS | 31360 | __metrics 20:16:52 ERROR - PROCESS | 31360 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:16:53 INFO - TEST-INFO | 31360: exit 0 20:16:53 INFO - Browser initialized. 20:16:53 INFO - Running cycle 1/1 for dromaeo_css test... 20:16:53 INFO - TEST-INFO | started process 31441 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2jDQXc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:17:05 INFO - PROCESS | 31441 | RSS: Main: 152453120 20:17:05 INFO - PROCESS | 31441 | 20:17:56 INFO - PROCESS | 31441 | 1463455076878 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] 20:20:04 INFO - PROCESS | 31441 | Cycle 1(1): loaded http://localhost:56745/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56745/tests/dromaeo/cssquery-ext.html) 20:20:05 INFO - PROCESS | 31441 | RSS: Main: 253161472 20:20:05 INFO - PROCESS | 31441 | 20:23:07 INFO - PROCESS | 31441 | Cycle 1(1): loaded http://localhost:56745/tests/dromaeo/cssquery-ext.html (next: http://localhost:56745/tests/dromaeo/cssquery-jquery.html) 20:23:08 INFO - PROCESS | 31441 | RSS: Main: 237629440 20:23:08 INFO - PROCESS | 31441 | 20:26:10 INFO - PROCESS | 31441 | Cycle 1(1): loaded http://localhost:56745/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56745/tests/dromaeo/cssquery-mootools.html) 20:26:11 INFO - PROCESS | 31441 | RSS: Main: 237105152 20:26:11 INFO - PROCESS | 31441 | 20:29:13 INFO - PROCESS | 31441 | Cycle 1(1): loaded http://localhost:56745/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56745/tests/dromaeo/cssquery-prototype.html) 20:29:13 INFO - PROCESS | 31441 | RSS: Main: 231108608 20:29:13 INFO - PROCESS | 31441 | 20:32:16 INFO - PROCESS | 31441 | Cycle 1(1): loaded http://localhost:56745/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56745/tests/dromaeo/cssquery-yui.html) 20:32:17 INFO - PROCESS | 31441 | RSS: Main: 215535616 20:32:17 INFO - PROCESS | 31441 | 20:35:19 INFO - PROCESS | 31441 | Cycle 1(1): loaded http://localhost:56745/tests/dromaeo/cssquery-yui.html (next: http://localhost:56745/tests/dromaeo/cssquery-dojo.html) 20:35:19 INFO - PROCESS | 31441 | RSS: Main: 270065664 20:35:19 INFO - PROCESS | 31441 | 20:35:19 INFO - PROCESS | 31441 | __start_tp_report 20:35:19 INFO - PROCESS | 31441 | _x_x_mozilla_page_load 20:35:19 INFO - PROCESS | 31441 | _x_x_mozilla_page_load_details 20:35:19 INFO - PROCESS | 31441 | |i|pagename|runs| 20:35:19 INFO - PROCESS | 31441 | |0;dojo.html;3139.827309497977;3156.352947645733;3172.5717028201193;3183.8567264473095;3206.486962086067;5243.580513558915;5332.54673352765;5337.973310133453;5418.864528386793;5450.318710161235;5224.111900976834;5247.947520524794;5364.088105022146;5418.349798024233;5439.129739241722;4785.210440277358;4845.079434907374;4860.586850117745;4868.318435419044;5085.415177254607;4953.083679519283;4970.428400733907;5008.373953255843;5019.447860735316;5034.798608055673;4785.90428191436;4854.611631069523;4876.731779752147;4878.243872199815;4881.829135980259;4858.5384388483035;4877.561019508261;4937.8271760488215;4939.234418665113;4980.9252861207115;4760.595349395306;4891.217405215149;4899.926501102486;4918.9508104919205;4947.529984651453;5272.841814745564;5337.386200586904;5348.277982472356;5407.891842163135;5410.404855465935;5701.14482827575;5742.827715168552;5769.653820770725;5775.249217601727;5775.537956963475;5647.0964645656495;5650.434956504358;5857.472827445507;5887.911681324784;5890.145928840337;5100.489951004907;5396.325459317585;5398.568114550826;5399.460053994609;5400.351957765093;5897.5871688982215;5905.586608937419;5907.084401917709;5908;5910.468057874726;5470.070088085035;5611.242482264842;5613.607047506635;5635.267415235993;5660.85847853807;5757.913631295534;5767.625104368287;5774.769009239667;5776;5815.360310365856;5677.971610141923;5691.430856914359;5695.886082278331;5696.145578163226;5697.886042279214;5555.666660000413;5670.518005969457;5682.857928551819;5713.114467257498;5798.710064496759;4334.479862416467;4355.324924636687;4361.345798130305;4361.847335343247;4396;3845.9230815383535;3859.498265225559;3868.5357757069332;3882.378819388884;3893.279743247508;5280.155175171954;5304.840854774363;5333.679979201261;5336.092864213093;5345;5684.602077854511;5703.287089113861;5704.572157088235;5706.743196556165;5754.625949313365;5325.573954083664;5326.786928522815;5333.973330133324;5335.0663633863915;5394.676319420847;4716.9292460613115;4740.525947405301;4785.066911952136;4788.090262850117;4793.257045158006;5969.224000879858;6008.068749343859;6008.218931538872;6011.879762404727;6013.939860601338;5666.405027472221;5816.1857339973285;5825.533957283323;5828;5835.737391817293;5888.558358123244;5919.171316015675;5937.673427961504;5949.881002379841;5955.047192449188;5656.547476201977;5661.433856614306;5663.518600918803;5663.7451314690115;5684.545236381162;5594.1608758686525;5685.431456854281;5780.421957804186;5796.101604251179;5803.680797556175;5550.111982082847;5574.9163762542785;5577.8047768327915;5582.86042848932;5656.717164141859;5520.613557050968;5547.306586676666;5553.805616803393;5554.555635549227;5569.832905012856;5278.498542638443;5448.210009548672;5471.644343117685;5489.066858633962;5545.639533430314;5639.548836093185;5684.204211410323;5690.402507736628;5702.743376547983;5709.457601527848;5529.170624406211;5536.7785288588;5540.529055030368;5542.057850165401;5548.861278468071 20:35:19 INFO - PROCESS | 31441 | |1;ext.html;608.8903997280488;644.3524258120588;653.9313372095927;656.6519744535395;661.3882159002922;33775;36367.63632363679;36640.45039324412;47227.76386118065;48383.516164838344;46269;46661.30008049882;46691.29963050557;46697.53302466974;46767.29849052267;8906.910930890705;9046.909530904673;9053.275737940981;9053.95473022634;9061;8901.243394311492;8993.910060899372;8995.41529800564;8995.595198216064;8996.415233009866;9034.141756533152;9067.183953444188;9067.274618030575;9068;9068.410553314014;8873;8966.103389661046;8978.82042359149;8988.280937525014;8992.820143597157;8855.557222138867;8930.732078037605;8933.285337173076;8940;8953.820923581558;42356.57643423557;42642.78678606618;42729.57270427287;42742.57257427417;42750.358744618854;3376.1222082258546;3496.912577185565;3527.5943266524164;3552.8401221944814;3921.627445392683;33119.83440082784;33820.661793381994;33874.66125338765;34017;35441.82279088614;4143.19207754488;4148.004478925036;4173.800194664211;4181.874543763692;4183.790810459495;325819;326544;326856;327488;327999;35230.82384588061;58481;59204.40795591989;59233.40766592279;59327.406725933055;35488.46767298492;37460.438093428624;37647.4352884707;37663.4350484743;37688.81155594205;16037.599060023593;16205.513834584981;16221.351145954266;16222.269997850126;16225.918870405809;13533.39099740514;13658.658533536742;13667.658308542168;13801.930990345185;13843.792343114861;8735.956320218485;8762.4742515448;8762.510373236564;8768.07935166811;8840.071792461698;3284.901452956415;3284.9343013140083;3345.0062194335933;3374.0552645259368;3375.071855239829;1016.1616666250226;1017.5573625472942;1057.904788569017;1112.360392774142;1114.3035602748282;30187.849060754557;30410.695893040785;30542;30708.53937190944;31028.844855775576;1128.2948157401624;1159.1658395223765;1205.5720219322013;1236.9257844529357;1306.8497122830995;16672.916635416746;16698.332066717438;16914.91542542304;16926.963711529657;17038.57403564896;531483;537607;537699;537879;538470;59472;59638.40361596328;59949.400505995254;60014.399856000884;60025.699871500365;1299.330844615024;1338.7857942729117;1405.4237762517523;1537.162246575619;1625.9349626015064;30895.422419049268;34913.47629785504;35088.29823403569;35259.118522037155;35263.91578529283;51897.740511297205;52776.47223527716;52798.73600631972;52862.73568632132;52980.205296919805;450793;457193;458312;458802;459522;44620;44885.326720099874;45354.31968520541;46038;47966.52033479621;49358.50641493539;49397.25904111513;49909.75045124751;50134.24798628096;50470.74764626153;42707;43033.354499681904;43296;43300.35049474324;43384.13231735284;41566.376504353066;42268.577314226466;42759.7862010688;42999;43781.19893867481;43350.13299734051;43449;43614;44492;44537.777311113234;36982.26035479329;38290.808545957094;38459.6154038456;38480.23039539137;39037;28658.426831463672;28889.277768055967;29204.561931570617;29612.259693507836;29679.703202967696 20:35:19 INFO - PROCESS | 31441 | |2;jquery.html;399.8980260033691;402.2217010085484;417.64837181617514;420.3442629497981;430.9052008558118;18321.633567328678;18803.43589692308;19372.70940935887;19653.115609797558;19685;11597.594084207054;11682.240654357462;11699.649010529698;12215.144939854192;12480.188787728792;5219.451957544469;5352.304200453955;5365.490278423544;5374.247605335257;5393;3710.9257814843686;3867.7872717000555;3869.941950870739;3898.161895192533;5276.762545685453;5612.859678508029;5884.058550631899;5894.086416605433;5976;5981.850453738648;5727.427257274281;5836.416358364172;5847.0352391855295;5912.526997840162;5936.079907614327;3675.4119340905327;5315.654482458628;5645.971770141123;5660.5471562274915;5682.034054210794;13315.733685326337;13442.529511467052;13917.58247252584;13975.65060873476;13982.790258146035;2281.863088214712;2316.293530473205;2318.188633978111;2385.85684858909;2450.6079027355536;9745.463999480025;10051.547680354402;10099.394036357842;10228.590856365736;10375.066244037997;1980.4553747719349;1991.6713742232514;1995.5609765851489;2023.908924098419;2063.2056658186557;73574;74878.62560687216;76571.61714191393;76781.61609191974;82195.58902205451;10151.593936242467;11285;11317.886821131848;11451.88548114525;11640.883591164149;16080.276387562588;16232.918835405748;16274.349026039063;16295.51113466598;16308.266128024268;8465.195806398382;8517.190866867762;8624.870626940601;8640.092790257058;8681.913180868236;8207.466514676527;8258.091609922903;8321.375896807764;8376;8379.329653627696;4722.693024953367;4826.227803551415;4898.995705880286;4991.575716064175;5010;1731.337915601012;1912.135667723958;1956.0219890054973;2092.4873406015317;2093.6545469997586;888.2583043158905;959.827231098409;1014.4015031131668;1035.77213013137;1075.2580719303655;17029.82970170307;18405.263789448272;18569.44291671252;18778.154983025797;19098.71351929722;1002.3885429887763;1014.4217795856291;1016.8322226832638;1050.4905121016302;1103.0238239158402;10284.177265818716;10805.675829725122;10812.945935270272;10867.184961127947;10911.781764364827;413691;429677;469516;471739;476076;93860.53069734608;94202.52898735463;94775.52612236894;96242.51878740561;96301.40684524697;1049.3231865446896;1051.0750539525168;1056.1603525197486;1067.6263307842348;1072.8337107748312;16582;16969;17057.48827535176;17251.3962011329;17489.825101749328;39920;40357;40580.59419405886;41463.75608731622;41761.37357939694;55917;57604;57978.420215797305;58059.129113062496;59225.703871480364;8641.783955400913;8644.870326944974;8687.739367818975;8739.21347078766;8899.73300800977;10018.599256029676;12489.437975291316;12850.807237891626;12956.28740419286;13018.088733788543;11455.59905403307;11636.825447618461;11819.881801181878;11855.881441185478;12131.575394861491;11522.82715759281;11605.129615278718;11629.418529073344;11644.6506604802;11644.767104658029;11333.943330283295;11550.711232219262;11941;11991.64025079249;12463.875361246271;8634.481931084156;8656.956715216384;8697.08680588529;8826.823463530822;8954.641814327615;10990.615328463466;11464.31214127155;11984.28094314344;12135.878641213474;12478.750424991267 20:35:19 INFO - PROCESS | 31441 | |3;mootools.html;1362.7342668179708;1498.0637101811367;1542.0901668015872;1634.967300653987;1773.0602780526317;8513.276371508422;8894.332925030625;8905.866412003825;9031.819363612723;9130.315226358016;8646.870296945535;8843.690470833522;8888.06675299094;8900.02099769025;8900.688475903346;2010.3566858605252;2072.720182775321;2284.8286378521593;2313.6298192289237;2320.0951628864755;2359.905603775847;2391.6173412254043;2391.784739373456;2393.5212957408503;2394.628832530952;2254.6167151584186;2266.8639881607073;2277.3054218463362;2278.897449614763;2287;1982.6431242376439;2203.0857194264363;2206.3711842125;2234.7765223477686;2280;2228.665700144975;2245.8877056147126;2248.168177774234;2249.5388445368662;2251.200823707593;8698.56507174645;8751.3874028818;8757.036725960203;8763;8763.693270735494;4985.401751789808;5134.1528647773075;5135.6918584885025;5138;5138.023775482684;3244.1727359523406;3264.8857289994735;3421.5894092709036;3430.2281986553076;3439.329330780499;1121.3047910295668;1130.0846314485293;1130.2540323386609;1130.8190689489725;1139.5897476908306;13011.934940325333;13023.934880325538;13024.283664398454;13043.54347597839;13054.673633159153;4568;4767.523247675204;4786.282057691375;4815.927761083586;4896.143174944371;10110.8483372748;10155.086042256233;10221.131203847608;10225.539850706587;10228.232882533839;5289.074411977888;5292.788288468418;5295.285136506599;5296.3379577552805;5296.682199068068;4356.6732495063;4855.708657480563;4991.550760431579;5006.0989021975665;5006.499350064964;3944.4280579315837;3964.801759911993;3998.5601583825755;4042.413849991735;4100.65144462724;1208.9032877369789;1236.4992178167677;1238.0961897814645;1245.2092920995053;1263.4377701922556;825.1130035212171;923.8337099322187;946.7917058247175;959.6689142245914;997.4015590645555;5956.76172953077;5975.372585878507;6005.549583781234;6016.278046634345;6039.78860739872;945.7351941456403;1058.9735256618646;1060.98145780052;1071.9303245289032;1102.9172812039128;3944.8224829882724;4034.495688038995;4062.857799977046;4095.877123686294;4171.3325867860995;11375.943120284512;11523.250988685708;11644.068474522019;11664.825027624423;11676;11527.88472115268;11543.07655387567;11600.6519804406;11611.419429028514;11627.418629068512;8164.550949697705;8325.292350150185;8463;8466.534340611202;8509.574521273911;5915.822525324247;6092.847678808065;6162.106494558354;6223.937760622517;6228.159198508143;10357.4303413313;10557.102646274845;10565.788684226427;10840.67477975662;10868.402237876993;10713.464326783786;10793.892061079603;10802.459877006275;10885.401302928414;11081.445927703744;7502.099748030271;7895.447318687637;7900.2889739923685;8003.559804210591;8102.554359510284;9058.54707264621;9087.31845111606;9111.225545828678;9135;9151.084891511062;7891.84216315659;8007;8050.114487406264;8107.594620269081;8131.471454355448;7715.421343399155;7763.844723105393;7784.9610751945875;7958.0848202457455;7987.201279871966;7190.06529151207;7199.71201151948;7251.23861994483;7271.309225623558;7273.127224733066;4927.137750893651;5045.11710450677;5154.871128221825;5180.041692286939;5193.532582067481;4897.510248975074;4930.926036109533;5103.43862175153;5296.2055691646565;5307.336582927134 20:35:19 INFO - PROCESS | 31441 | |4;prototype.html;336.7053827900587;338.1208856971872;341.4945880097454;343.47791357137146;344.3904289407748;5230.816921407752;5279.8416047518585;5289.117431000104;5330.253764472967;5359.598030147735;5226.268322434853;5234.947650523493;5235.1885457754015;5253.133233016557;5292.3913749918775;3929.351656976595;4016.15660711251;4156.272652285853;4194.203101410738;4219.746815191083;4089.1208390196102;4100.323446631317;4121.278776214165;4142.9378559321485;4190.413342132104;3919.529656441217;4110.835566577333;4119.590039826705;4121.649659778923;4130.793460326987;3809.7142714296538;3981.820818063194;4021.296273152201;4127;4131.607497287783;3636.7636103653176;3665.157013886821;3667.1382225177063;3680.0983758978955;3690.907727306812;5084.339035925343;5097.8215762448135;5116.283720279127;5117.53942145205;5131.846044618667;4544.590986811203;4673.742944138071;4708.952910470885;4710.293455981596;4726.314684370747;5426.321709786277;5456.290682211326;5462.453754624546;5468.808591699271;5514.641548299348;4003.919921601552;4011.919761604781;4036.616521430459;4043.696722745806;4056.5132184137797;5442.285680010784;5681.948839464712;5683.687397193153;5684.857878553028;5722.227499287585;3995.300822356076;3996.2207369562657;4026.6979976501293;4026.8187931543152;4031.9395209071886;4062.2484840304637;4088.652464540488;4113.177364527047;4116.403121547359;4121.5466298707115;4405.273129933589;4662;4669.322948172496;4707.176244157259;4747.928781068286;5516.062269414209;5547.44525547442;5552.750126244328;5553.444655534495;5564.721763911788;1404.3820718883658;1404.8735613794809;1408.9577312680635;1421.8435972043067;1424.4658253155067;877.4466303058198;885.880406145175;890.3055616619048;910.2172131966504;925.9351845370759;5228.92156617651;5238.73806309683;5242.636914402283;5305.336832895888;5359.866003349869;5632.295963004624;5706.773043795604;5715.2855893013375;5716.114002329562;5719.971400142973;5107.952869661711;5323.547498462596;5332.68003919766;5356.143017117242;5404.8108316208745;2955.985220073886;2991.745701615387;3010.443068032421;3028.5911401960893;3039.1034644779843;5857.414258574108;5860.296764388216;5868.178455016301;5874.618149820248;5897.911531327033;5593.720313984284;5729.942700573024;5802.738876750556;5805.883882322414;5807.767689292381;5709.22925405065;5800.245968024215;5849.005669036274;5871.768727883377;5896.17453556511;5427.782888684566;5664.603477756682;5682.090865461506;5720.656760594377;5725.770969161354;5520.1167813149705;5580.665160090245;5598.180591307922;5611.80358687444;5633.1831884375715;5802.245708057925;5843.211166492469;5878.177055212359;5912.73392697321;5917.437843404869;3617.276544691125;3675.7243206760136;3685.723570732152;3690.723195760275;3710.2579484103826;5075.416327122281;5101.3113229715;5104.744762761921;5107.770150343169;5162.922556161736;5021.221710634857;5029.968856384359;5044.394672639307;5067.695938243717;5074.594032477319;4834;5028.84913452597;5046.77289521965;5050.368703912011;5050.368703912011;4878.609711223023;4960.379952505937;4971.328870602567;4986.12742770021;5257.526822585985;5424.593155513273;5533.6403133796175;5542.140968149944;5578.721063946705;5637.830865074055;5466;5476.479734425223;5480.945190548044;5482.342118945592;5484.561235101262 20:35:19 INFO - PROCESS | 31441 | |5;yui.html;814.8370325934812;816.379551540829;868.0885070675793;870.1472556894244;894.1728900766789;14517.927410362947;15307.617309567253;15328.693426131498;15494.61263468414;15531;13583.52457663982;13621.523246686367;13631.659208519792;13639.386227619756;13639.590812275648;684.5687217053262;813.9348852091848;825.5418242875202;841.6549214821924;845.8900342955438;834.4867906237681;838.2874556626849;840.5839109640737;840.8570543007672;841.2891107014563;726.2120599149929;898.0884402331639;899.7120921305185;900.8648702694583;902.4540153207314;869.6825658634584;879.4591326334322;880.8634661627458;889.5641135843455;889.8798662180587;649.9025146228056;650.1905128115479;650.4731167754135;650.9056186852927;651.0592194279268;14309.928450357682;14379.424823007068;14415.78376324356;14439;14460.855391446055;13268.60194194166;13310.267935263557;13379.732405351839;13677.384517696628;13792.172469651852;12142.286686541649;12342.321172335518;12364.876351236462;12505.437255323532;12868.420921058574;4419.315006174048;4483.170613436525;4532.773361331921;4557.612602928755;4601.792919318638;52880;53217.733911330586;53232;55323.17015244775;56064.43935560633;10892.564297428173;10945.471344761943;11010.559577616805;11018.228723989243;11215;19492.610147796964;19706.408807735792;19720.506987325432;19729.40811775649;19738.30915917936;7954.642041108164;8025.157358477276;8076.232757887991;8341.499510029296;8469.618867150994;4507.774611269423;4518.277075667943;4708.4820669726305;4798.184308667535;4825.4933232010835;3440.6043305020244;3513.156842357867;3536.6109727929907;3548.8580456781956;3556.76881002734;638.7476946606065;691.246541270018;721.989170162448;722.663961258007;730.5032577847115;749.86877296474;753.8793792993205;757.5454727163658;762.9465937384441;774.3263360875961;10283.209710047178;10302.587896484056;10347.793044139074;10358.948205259076;10394.636187733544;693.2651389527117;749.3555542233674;773.818152734107;787.7282337593521;788.2787249666491;4948.950510494849;4984.227444745998;5003.374578177728;5040.79836806531;5047.141985862412;75275;76211;77517.61241193757;77824;78990.21009789943;64575.67712161503;65389.673051635385;65565.34434655592;66654.33345666579;67072;58749.706251469324;59054;59195.40804591985;59760.70119649374;59988.700056498565;9025.458472491671;9058.230050445522;9103.590338434655;9192.448453092837;9205.217556507503;39049.414258785575;39430.4227830895;39465.40801888031;39646.80176599098;40797.59202407938;43854.78072609616;44936.550634494546;45355.773221133684;47247.52752472431;54645;12919.547815826401;12949.611511654666;13071.607851764462;13113.475460981454;13239.470421183045;14362.784558231844;14472.27638618086;14599.489017884323;14765.483208087666;14803.703925921205;13052.934735326642;13498.325083745576;13732.65668358299;13906.304684765519;14009.859901400856;13507;13512.391942362814;13707.794383084462;13739.175649461064;13938.094023888414;13433.059685821898;13646.181229125887;13691.589252322447;13825.792613111013;13931;10484.161267098461;10854.29447085937;11221.382823944761;11261.774764504828;11315.717107072389;11127.888721112686;11255.606053788078;11354;11370.54517819278;11463.31220126795 20:35:19 INFO - PROCESS | 31441 | __end_tp_report 20:35:19 INFO - PROCESS | 31441 | __start_cc_report 20:35:19 INFO - PROCESS | 31441 | _x_x_mozilla_cycle_collect,858 20:35:19 INFO - PROCESS | 31441 | __end_cc_report 20:35:19 INFO - PROCESS | 31441 | __startTimestamp1463456119798__endTimestamp 20:35:19 INFO - PROCESS | 31441 | 20:35:19 INFO - PROCESS | 31441 | ------- Summary: start ------- 20:35:19 INFO - PROCESS | 31441 | Number of tests: 6 20:35:19 INFO - PROCESS | 31441 | 20:35:19 INFO - PROCESS | 31441 | [#0] dojo.html Cycles:165 Average:5321.44 Median:5536.78 stddev:605.80 (10.9%) stddev-sans-first:582.99 20:35:19 INFO - PROCESS | 31441 | Values: 3139.8 3156.4 3172.6 3183.9 3206.5 5243.6 5332.5 5338.0 5418.9 5450.3 5224.1 5247.9 5364.1 5418.3 5439.1 4785.2 4845.1 4860.6 4868.3 5085.4 4953.1 4970.4 5008.4 5019.4 5034.8 4785.9 4854.6 4876.7 4878.2 4881.8 4858.5 4877.6 4937.8 4939.2 4980.9 4760.6 4891.2 4899.9 4919.0 4947.5 5272.8 5337.4 5348.3 5407.9 5410.4 5701.1 5742.8 5769.7 5775.2 5775.5 5647.1 5650.4 5857.5 5887.9 5890.1 5100.5 5396.3 5398.6 5399.5 5400.4 5897.6 5905.6 5907.1 5908.0 5910.5 5470.1 5611.2 5613.6 5635.3 5660.9 5757.9 5767.6 5774.8 5776.0 5815.4 5678.0 5691.4 5695.9 5696.1 5697.9 5555.7 5670.5 5682.9 5713.1 5798.7 4334.5 4355.3 4361.3 4361.8 4396.0 3845.9 3859.5 3868.5 3882.4 3893.3 5280.2 5304.8 5333.7 5336.1 5345.0 5684.6 5703.3 5704.6 5706.7 5754.6 5325.6 5326.8 5334.0 5335.1 5394.7 4716.9 4740.5 4785.1 4788.1 4793.3 5969.2 6008.1 6008.2 6011.9 6013.9 5666.4 5816.2 5825.5 5828.0 5835.7 5888.6 5919.2 5937.7 5949.9 5955.0 5656.5 5661.4 5663.5 5663.7 5684.5 5594.2 5685.4 5780.4 5796.1 5803.7 5550.1 5574.9 5577.8 5582.9 5656.7 5520.6 5547.3 5553.8 5554.6 5569.8 5278.5 5448.2 5471.6 5489.1 5545.6 5639.5 5684.2 5690.4 5702.7 5709.5 5529.2 5536.8 5540.5 5542.1 5548.9 20:35:19 INFO - PROCESS | 31441 | 20:35:19 INFO - PROCESS | 31441 | [#1] ext.html Cycles:180 Average:60049.82 Median:42746.47 stddev:119042.59 (278.5%) stddev-sans-first:119292.88 20:35:19 INFO - PROCESS | 31441 | Values: 608.9 644.4 653.9 656.7 661.4 33775.0 36367.6 36640.5 47227.8 48383.5 46269.0 46661.3 46691.3 46697.5 46767.3 8906.9 9046.9 9053.3 9054.0 9061.0 8901.2 8993.9 8995.4 8995.6 8996.4 9034.1 9067.2 9067.3 9068.0 9068.4 8873.0 8966.1 8978.8 8988.3 8992.8 8855.6 8930.7 8933.3 8940.0 8953.8 42356.6 42642.8 42729.6 42742.6 42750.4 3376.1 3496.9 3527.6 3552.8 3921.6 33119.8 33820.7 33874.7 34017.0 35441.8 4143.2 4148.0 4173.8 4181.9 4183.8 325819.0 326544.0 326856.0 327488.0 327999.0 35230.8 58481.0 59204.4 59233.4 59327.4 35488.5 37460.4 37647.4 37663.4 37688.8 16037.6 16205.5 16221.4 16222.3 16225.9 13533.4 13658.7 13667.7 13801.9 13843.8 8736.0 8762.5 8762.5 8768.1 8840.1 3284.9 3284.9 3345.0 3374.1 3375.1 1016.2 1017.6 1057.9 1112.4 1114.3 30187.8 30410.7 30542.0 30708.5 31028.8 1128.3 1159.2 1205.6 1236.9 1306.8 16672.9 16698.3 16914.9 16927.0 17038.6 531483.0 537607.0 537699.0 537879.0 538470.0 59472.0 59638.4 59949.4 60014.4 60025.7 1299.3 1338.8 1405.4 1537.2 1625.9 30895.4 34913.5 35088.3 35259.1 35263.9 51897.7 52776.5 52798.7 52862.7 52980.2 450793.0 457193.0 458312.0 458802.0 459522.0 44620.0 44885.3 45354.3 46038.0 47966.5 49358.5 49397.3 49909.8 50134.2 50470.7 42707.0 43033.4 43296.0 43300.4 43384.1 41566.4 42268.6 42759.8 42999.0 43781.2 43350.1 43449.0 43614.0 44492.0 44537.8 36982.3 38290.8 38459.6 38480.2 39037.0 28658.4 28889.3 29204.6 29612.3 29679.7 20:35:19 INFO - PROCESS | 31441 | 20:35:19 INFO - PROCESS | 31441 | [#2] jquery.html Cycles:180 Average:27386.13 Median:2093.07 stddev:74957.81 (3581.2%) stddev-sans-first:75140.70 20:35:19 INFO - PROCESS | 31441 | Values: 399.9 402.2 417.6 420.3 430.9 18321.6 18803.4 19372.7 19653.1 19685.0 11597.6 11682.2 11699.6 12215.1 12480.2 5219.5 5352.3 5365.5 5374.2 5393.0 3710.9 3867.8 3869.9 3898.2 5276.8 5612.9 5884.1 5894.1 5976.0 5981.9 5727.4 5836.4 5847.0 5912.5 5936.1 3675.4 5315.7 5646.0 5660.5 5682.0 13315.7 13442.5 13917.6 13975.7 13982.8 2281.9 2316.3 2318.2 2385.9 2450.6 9745.5 10051.5 10099.4 10228.6 10375.1 1980.5 1991.7 1995.6 2023.9 2063.2 73574.0 74878.6 76571.6 76781.6 82195.6 10151.6 11285.0 11317.9 11451.9 11640.9 16080.3 16232.9 16274.3 16295.5 16308.3 8465.2 8517.2 8624.9 8640.1 8681.9 8207.5 8258.1 8321.4 8376.0 8379.3 4722.7 4826.2 4899.0 4991.6 5010.0 1731.3 1912.1 1956.0 2092.5 2093.7 888.3 959.8 1014.4 1035.8 1075.3 17029.8 18405.3 18569.4 18778.2 19098.7 1002.4 1014.4 1016.8 1050.5 1103.0 10284.2 10805.7 10812.9 10867.2 10911.8 413691.0 429677.0 469516.0 471739.0 476076.0 93860.5 94202.5 94775.5 96242.5 96301.4 1049.3 1051.1 1056.2 1067.6 1072.8 16582.0 16969.0 17057.5 17251.4 17489.8 39920.0 40357.0 40580.6 41463.8 41761.4 55917.0 57604.0 57978.4 58059.1 59225.7 8641.8 8644.9 8687.7 8739.2 8899.7 10018.6 12489.4 12850.8 12956.3 13018.1 11455.6 11636.8 11819.9 11855.9 12131.6 11522.8 11605.1 11629.4 11644.7 11644.8 11333.9 11550.7 11941.0 11991.6 12463.9 8634.5 8657.0 8697.1 8826.8 8954.6 10990.6 11464.3 11984.3 12135.9 12478.8 20:35:19 INFO - PROCESS | 31441 | 20:35:19 INFO - PROCESS | 31441 | [#3] mootools.html Cycles:180 Average:5939.16 Median:4667.76 stddev:3479.28 (74.5%) stddev-sans-first:3472.05 20:35:19 INFO - PROCESS | 31441 | Values: 1362.7 1498.1 1542.1 1635.0 1773.1 8513.3 8894.3 8905.9 9031.8 9130.3 8646.9 8843.7 8888.1 8900.0 8900.7 2010.4 2072.7 2284.8 2313.6 2320.1 2359.9 2391.6 2391.8 2393.5 2394.6 2254.6 2266.9 2277.3 2278.9 2287.0 1982.6 2203.1 2206.4 2234.8 2280.0 2228.7 2245.9 2248.2 2249.5 2251.2 8698.6 8751.4 8757.0 8763.0 8763.7 4985.4 5134.2 5135.7 5138.0 5138.0 3244.2 3264.9 3421.6 3430.2 3439.3 1121.3 1130.1 1130.3 1130.8 1139.6 13011.9 13023.9 13024.3 13043.5 13054.7 4568.0 4767.5 4786.3 4815.9 4896.1 10110.8 10155.1 10221.1 10225.5 10228.2 5289.1 5292.8 5295.3 5296.3 5296.7 4356.7 4855.7 4991.6 5006.1 5006.5 3944.4 3964.8 3998.6 4042.4 4100.7 1208.9 1236.5 1238.1 1245.2 1263.4 825.1 923.8 946.8 959.7 997.4 5956.8 5975.4 6005.5 6016.3 6039.8 945.7 1059.0 1061.0 1071.9 1102.9 3944.8 4034.5 4062.9 4095.9 4171.3 11375.9 11523.3 11644.1 11664.8 11676.0 11527.9 11543.1 11600.7 11611.4 11627.4 8164.6 8325.3 8463.0 8466.5 8509.6 5915.8 6092.8 6162.1 6223.9 6228.2 10357.4 10557.1 10565.8 10840.7 10868.4 10713.5 10793.9 10802.5 10885.4 11081.4 7502.1 7895.4 7900.3 8003.6 8102.6 9058.5 9087.3 9111.2 9135.0 9151.1 7891.8 8007.0 8050.1 8107.6 8131.5 7715.4 7763.8 7785.0 7958.1 7987.2 7190.1 7199.7 7251.2 7271.3 7273.1 4927.1 5045.1 5154.9 5180.0 5193.5 4897.5 4930.9 5103.4 5296.2 5307.3 20:35:19 INFO - PROCESS | 31441 | 20:35:19 INFO - PROCESS | 31441 | [#4] prototype.html Cycles:180 Average:4586.55 Median:5112.12 stddev:1347.87 (26.4%) stddev-sans-first:1313.37 20:35:19 INFO - PROCESS | 31441 | Values: 336.7 338.1 341.5 343.5 344.4 5230.8 5279.8 5289.1 5330.3 5359.6 5226.3 5234.9 5235.2 5253.1 5292.4 3929.4 4016.2 4156.3 4194.2 4219.7 4089.1 4100.3 4121.3 4142.9 4190.4 3919.5 4110.8 4119.6 4121.6 4130.8 3809.7 3981.8 4021.3 4127.0 4131.6 3636.8 3665.2 3667.1 3680.1 3690.9 5084.3 5097.8 5116.3 5117.5 5131.8 4544.6 4673.7 4709.0 4710.3 4726.3 5426.3 5456.3 5462.5 5468.8 5514.6 4003.9 4011.9 4036.6 4043.7 4056.5 5442.3 5681.9 5683.7 5684.9 5722.2 3995.3 3996.2 4026.7 4026.8 4031.9 4062.2 4088.7 4113.2 4116.4 4121.5 4405.3 4662.0 4669.3 4707.2 4747.9 5516.1 5547.4 5552.8 5553.4 5564.7 1404.4 1404.9 1409.0 1421.8 1424.5 877.4 885.9 890.3 910.2 925.9 5228.9 5238.7 5242.6 5305.3 5359.9 5632.3 5706.8 5715.3 5716.1 5720.0 5108.0 5323.5 5332.7 5356.1 5404.8 2956.0 2991.7 3010.4 3028.6 3039.1 5857.4 5860.3 5868.2 5874.6 5897.9 5593.7 5729.9 5802.7 5805.9 5807.8 5709.2 5800.2 5849.0 5871.8 5896.2 5427.8 5664.6 5682.1 5720.7 5725.8 5520.1 5580.7 5598.2 5611.8 5633.2 5802.2 5843.2 5878.2 5912.7 5917.4 3617.3 3675.7 3685.7 3690.7 3710.3 5075.4 5101.3 5104.7 5107.8 5162.9 5021.2 5030.0 5044.4 5067.7 5074.6 4834.0 5028.8 5046.8 5050.4 5050.4 4878.6 4960.4 4971.3 4986.1 5257.5 5424.6 5533.6 5542.1 5578.7 5637.8 5466.0 5476.5 5480.9 5482.3 5484.6 20:35:19 INFO - PROCESS | 31441 | 20:35:19 INFO - PROCESS | 31441 | [#5] yui.html Cycles:180 Average:16298.88 Median:4525.53 stddev:19783.24 (437.1%) stddev-sans-first:19804.56 20:35:19 INFO - PROCESS | 31441 | Values: 814.8 816.4 868.1 870.1 894.2 14517.9 15307.6 15328.7 15494.6 15531.0 13583.5 13621.5 13631.7 13639.4 13639.6 684.6 813.9 825.5 841.7 845.9 834.5 838.3 840.6 840.9 841.3 726.2 898.1 899.7 900.9 902.5 869.7 879.5 880.9 889.6 889.9 649.9 650.2 650.5 650.9 651.1 14309.9 14379.4 14415.8 14439.0 14460.9 13268.6 13310.3 13379.7 13677.4 13792.2 12142.3 12342.3 12364.9 12505.4 12868.4 4419.3 4483.2 4532.8 4557.6 4601.8 52880.0 53217.7 53232.0 55323.2 56064.4 10892.6 10945.5 11010.6 11018.2 11215.0 19492.6 19706.4 19720.5 19729.4 19738.3 7954.6 8025.2 8076.2 8341.5 8469.6 4507.8 4518.3 4708.5 4798.2 4825.5 3440.6 3513.2 3536.6 3548.9 3556.8 638.7 691.2 722.0 722.7 730.5 749.9 753.9 757.5 762.9 774.3 10283.2 10302.6 10347.8 10358.9 10394.6 693.3 749.4 773.8 787.7 788.3 4949.0 4984.2 5003.4 5040.8 5047.1 75275.0 76211.0 77517.6 77824.0 78990.2 64575.7 65389.7 65565.3 66654.3 67072.0 58749.7 59054.0 59195.4 59760.7 59988.7 9025.5 9058.2 9103.6 9192.4 9205.2 39049.4 39430.4 39465.4 39646.8 40797.6 43854.8 44936.6 45355.8 47247.5 54645.0 12919.5 12949.6 13071.6 13113.5 13239.5 14362.8 14472.3 14599.5 14765.5 14803.7 13052.9 13498.3 13732.7 13906.3 14009.9 13507.0 13512.4 13707.8 13739.2 13938.1 13433.1 13646.2 13691.6 13825.8 13931.0 10484.2 10854.3 11221.4 11261.8 11315.7 11127.9 11255.6 11354.0 11370.5 11463.3 20:35:19 INFO - PROCESS | 31441 | -------- Summary: end -------- 20:35:19 INFO - PROCESS | 31441 | 20:35:20 INFO - TEST-INFO | 31441: exit 0 20:35:20 INFO - TEST-OK | dromaeo_css | took 1112789ms 20:35:20 INFO - TEST-START | kraken 20:35:20 INFO - operating with platform_type : linux_ 20:35:20 INFO - Initialising browser for kraken test... 20:35:20 INFO - TEST-INFO | started process 31624 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuAQsSF/profile http://localhost:56745/getInfo.html) 20:35:24 INFO - PROCESS | 31624 | __metrics Screen width/height:1600/1200 20:35:24 INFO - PROCESS | 31624 | colorDepth:24 20:35:24 INFO - PROCESS | 31624 | Browser inner width/height: 1024/697 20:35:24 INFO - PROCESS | 31624 | __metrics 20:35:25 ERROR - PROCESS | 31624 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:35:26 INFO - TEST-INFO | 31624: exit 0 20:35:26 INFO - Browser initialized. 20:35:26 INFO - Running cycle 1/1 for kraken test... 20:35:26 INFO - TEST-INFO | started process 31706 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuAQsSF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:35:38 INFO - PROCESS | 31706 | RSS: Main: 152469504 20:35:38 INFO - PROCESS | 31706 | 20:35:40 INFO - PROCESS | 31706 | Cycle 1(1): loaded http://localhost:56745/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56745/tests/kraken/driver.html?testName=audio-beat-detection) 20:35:41 INFO - PROCESS | 31706 | RSS: Main: 209117184 20:35:41 INFO - PROCESS | 31706 | 20:35:44 INFO - PROCESS | 31706 | Cycle 1(1): loaded http://localhost:56745/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56745/tests/kraken/driver.html?testName=audio-dft) 20:35:44 INFO - PROCESS | 31706 | RSS: Main: 196825088 20:35:44 INFO - PROCESS | 31706 | 20:35:48 INFO - PROCESS | 31706 | Cycle 1(1): loaded http://localhost:56745/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56745/tests/kraken/driver.html?testName=audio-fft) 20:35:48 INFO - PROCESS | 31706 | RSS: Main: 265261056 20:35:48 INFO - PROCESS | 31706 | 20:35:50 INFO - PROCESS | 31706 | Cycle 1(1): loaded http://localhost:56745/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56745/tests/kraken/driver.html?testName=audio-oscillator) 20:35:51 INFO - PROCESS | 31706 | RSS: Main: 174452736 20:35:51 INFO - PROCESS | 31706 | 20:35:53 INFO - PROCESS | 31706 | Cycle 1(1): loaded http://localhost:56745/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56745/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:35:54 INFO - PROCESS | 31706 | RSS: Main: 178884608 20:35:54 INFO - PROCESS | 31706 | 20:35:57 INFO - PROCESS | 31706 | Cycle 1(1): loaded http://localhost:56745/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56745/tests/kraken/driver.html?testName=imaging-darkroom) 20:35:58 INFO - PROCESS | 31706 | RSS: Main: 215044096 20:35:58 INFO - PROCESS | 31706 | 20:36:01 INFO - PROCESS | 31706 | Cycle 1(1): loaded http://localhost:56745/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56745/tests/kraken/driver.html?testName=imaging-desaturate) 20:36:02 INFO - PROCESS | 31706 | RSS: Main: 213254144 20:36:02 INFO - PROCESS | 31706 | 20:36:05 INFO - PROCESS | 31706 | Cycle 1(1): loaded http://localhost:56745/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56745/tests/kraken/driver.html?testName=json-parse-financial) 20:36:05 INFO - PROCESS | 31706 | RSS: Main: 213970944 20:36:05 INFO - PROCESS | 31706 | 20:36:07 INFO - PROCESS | 31706 | Cycle 1(1): loaded http://localhost:56745/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56745/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:36:08 INFO - PROCESS | 31706 | RSS: Main: 202301440 20:36:08 INFO - PROCESS | 31706 | 20:36:09 INFO - PROCESS | 31706 | Cycle 1(1): loaded http://localhost:56745/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56745/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:36:10 INFO - PROCESS | 31706 | RSS: Main: 207069184 20:36:10 INFO - PROCESS | 31706 | 20:36:12 INFO - PROCESS | 31706 | Cycle 1(1): loaded http://localhost:56745/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56745/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:36:13 INFO - PROCESS | 31706 | RSS: Main: 217251840 20:36:13 INFO - PROCESS | 31706 | 20:36:15 INFO - PROCESS | 31706 | Cycle 1(1): loaded http://localhost:56745/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56745/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:36:16 INFO - PROCESS | 31706 | RSS: Main: 220295168 20:36:16 INFO - PROCESS | 31706 | 20:36:19 INFO - PROCESS | 31706 | Cycle 1(1): loaded http://localhost:56745/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56745/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:36:19 INFO - PROCESS | 31706 | RSS: Main: 218206208 20:36:19 INFO - PROCESS | 31706 | 20:36:21 INFO - PROCESS | 31706 | Cycle 1(1): loaded http://localhost:56745/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56745/tests/kraken/driver.html?testName=ai-astar) 20:36:21 INFO - PROCESS | 31706 | RSS: Main: 263766016 20:36:21 INFO - PROCESS | 31706 | 20:36:21 INFO - PROCESS | 31706 | __start_tp_report 20:36:21 INFO - PROCESS | 31706 | _x_x_mozilla_page_load 20:36:21 INFO - PROCESS | 31706 | _x_x_mozilla_page_load_details 20:36:21 INFO - PROCESS | 31706 | |i|pagename|runs| 20:36:21 INFO - PROCESS | 31706 | |0;ai-astar;110;106;108;109;118;108;109;109;109;109 20:36:21 INFO - PROCESS | 31706 | |1;audio-beat-detection;156;129;159;221;125;154;154;125;182;126 20:36:21 INFO - PROCESS | 31706 | |2;audio-dft;161;162;161;162;162;162;161;161;163;160 20:36:21 INFO - PROCESS | 31706 | |3;audio-fft;75;75;75;143;75;75;76;75;133;75 20:36:21 INFO - PROCESS | 31706 | |4;audio-oscillator;92;92;146;91;91;92;137;92;92;126 20:36:21 INFO - PROCESS | 31706 | |5;imaging-gaussian-blur;117;116;116;116;116;117;116;116;117;118 20:36:21 INFO - PROCESS | 31706 | |6;imaging-darkroom;145;150;145;145;144;145;145;145;145;146 20:36:21 INFO - PROCESS | 31706 | |7;imaging-desaturate;95;94;94;94;96;95;96;95;96;95 20:36:21 INFO - PROCESS | 31706 | |8;json-parse-financial;56;56;56;57;55;56;56;119;53;53 20:36:21 INFO - PROCESS | 31706 | |9;json-stringify-tinderbox;60;60;60;60;59;60;60;59;60;59 20:36:21 INFO - PROCESS | 31706 | |10;stanford-crypto-aes;77;78;76;79;78;77;78;78;78;80 20:36:21 INFO - PROCESS | 31706 | |11;stanford-crypto-ccm;122;121;120;117;126;116;118;115;237;120 20:36:21 INFO - PROCESS | 31706 | |12;stanford-crypto-pbkdf2;160;159;165;163;165;157;162;161;163;156 20:36:21 INFO - PROCESS | 31706 | |13;stanford-crypto-sha256-iterative;65;63;63;64;64;64;61;63;62;61 20:36:21 INFO - PROCESS | 31706 | __end_tp_report 20:36:21 INFO - PROCESS | 31706 | __start_cc_report 20:36:21 INFO - PROCESS | 31706 | _x_x_mozilla_cycle_collect,1799 20:36:21 INFO - PROCESS | 31706 | __end_cc_report 20:36:21 INFO - PROCESS | 31706 | __startTimestamp1463456181762__endTimestamp 20:36:21 INFO - PROCESS | 31706 | 20:36:21 INFO - PROCESS | 31706 | ------- Summary: start ------- 20:36:21 INFO - PROCESS | 31706 | Number of tests: 14 20:36:21 INFO - PROCESS | 31706 | 20:36:21 INFO - PROCESS | 31706 | [#0] ai-astar Cycles:10 Average:109.50 Median:109.00 stddev:3.17 (2.9%) stddev-sans-first:3.36 20:36:21 INFO - PROCESS | 31706 | Values: 110.0 106.0 108.0 109.0 118.0 108.0 109.0 109.0 109.0 109.0 20:36:21 INFO - PROCESS | 31706 | 20:36:21 INFO - PROCESS | 31706 | [#1] audio-beat-detection Cycles:10 Average:153.10 Median:155.00 stddev:30.52 (19.7%) stddev-sans-first:32.36 20:36:21 INFO - PROCESS | 31706 | Values: 156.0 129.0 159.0 221.0 125.0 154.0 154.0 125.0 182.0 126.0 20:36:21 INFO - PROCESS | 31706 | 20:36:21 INFO - PROCESS | 31706 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 20:36:21 INFO - PROCESS | 31706 | Values: 161.0 162.0 161.0 162.0 162.0 162.0 161.0 161.0 163.0 160.0 20:36:21 INFO - PROCESS | 31706 | 20:36:21 INFO - PROCESS | 31706 | [#3] audio-fft Cycles:10 Average:87.70 Median:75.00 stddev:26.62 (35.5%) stddev-sans-first:27.83 20:36:21 INFO - PROCESS | 31706 | Values: 75.0 75.0 75.0 143.0 75.0 75.0 76.0 75.0 133.0 75.0 20:36:21 INFO - PROCESS | 31706 | 20:36:21 INFO - PROCESS | 31706 | [#4] audio-oscillator Cycles:10 Average:105.10 Median:92.00 stddev:22.07 (24.0%) stddev-sans-first:22.89 20:36:21 INFO - PROCESS | 31706 | Values: 92.0 92.0 146.0 91.0 91.0 92.0 137.0 92.0 92.0 126.0 20:36:21 INFO - PROCESS | 31706 | 20:36:21 INFO - PROCESS | 31706 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:116.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 20:36:21 INFO - PROCESS | 31706 | Values: 117.0 116.0 116.0 116.0 116.0 117.0 116.0 116.0 117.0 118.0 20:36:21 INFO - PROCESS | 31706 | 20:36:21 INFO - PROCESS | 31706 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.00 stddev:1.65 (1.1%) stddev-sans-first:1.74 20:36:21 INFO - PROCESS | 31706 | Values: 145.0 150.0 145.0 145.0 144.0 145.0 145.0 145.0 145.0 146.0 20:36:21 INFO - PROCESS | 31706 | 20:36:21 INFO - PROCESS | 31706 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 20:36:21 INFO - PROCESS | 31706 | Values: 95.0 94.0 94.0 94.0 96.0 95.0 96.0 95.0 96.0 95.0 20:36:21 INFO - PROCESS | 31706 | 20:36:21 INFO - PROCESS | 31706 | [#8] json-parse-financial Cycles:10 Average:61.70 Median:56.00 stddev:20.18 (36.0%) stddev-sans-first:21.30 20:36:21 INFO - PROCESS | 31706 | Values: 56.0 56.0 56.0 57.0 55.0 56.0 56.0 119.0 53.0 53.0 20:36:21 INFO - PROCESS | 31706 | 20:36:21 INFO - PROCESS | 31706 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 20:36:21 INFO - PROCESS | 31706 | Values: 60.0 60.0 60.0 60.0 59.0 60.0 60.0 59.0 60.0 59.0 20:36:21 INFO - PROCESS | 31706 | 20:36:21 INFO - PROCESS | 31706 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:78.00 stddev:1.10 (1.4%) stddev-sans-first:1.12 20:36:21 INFO - PROCESS | 31706 | Values: 77.0 78.0 76.0 79.0 78.0 77.0 78.0 78.0 78.0 80.0 20:36:21 INFO - PROCESS | 31706 | 20:36:21 INFO - PROCESS | 31706 | [#11] stanford-crypto-ccm Cycles:10 Average:131.20 Median:120.50 stddev:37.31 (31.0%) stddev-sans-first:39.43 20:36:21 INFO - PROCESS | 31706 | Values: 122.0 121.0 120.0 117.0 126.0 116.0 118.0 115.0 237.0 120.0 20:36:21 INFO - PROCESS | 31706 | 20:36:21 INFO - PROCESS | 31706 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.10 Median:162.50 stddev:3.11 (1.9%) stddev-sans-first:3.27 20:36:21 INFO - PROCESS | 31706 | Values: 160.0 159.0 165.0 163.0 165.0 157.0 162.0 161.0 163.0 156.0 20:36:21 INFO - PROCESS | 31706 | 20:36:21 INFO - PROCESS | 31706 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.50 stddev:1.33 (2.1%) stddev-sans-first:1.20 20:36:21 INFO - PROCESS | 31706 | Values: 65.0 63.0 63.0 64.0 64.0 64.0 61.0 63.0 62.0 61.0 20:36:21 INFO - PROCESS | 31706 | -------- Summary: end -------- 20:36:21 INFO - PROCESS | 31706 | 20:36:22 INFO - TEST-INFO | 31706: exit 0 20:36:22 INFO - TEST-OK | kraken | took 62204ms 20:36:22 INFO - SUITE-END | took 1174s 20:36:22 INFO - Completed test suite (00:19:35) 20:36:22 INFO - javascript benchmark 20:36:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3139.827309497977, 3156.352947645733, 3172.5717028201193, 3183.8567264473095, 3206.486962086067, 5243.580513558915, 5332.54673352765, 5337.973310133453, 5418.864528386793, 5450.318710161235, 5224.111900976834, 5247.947520524794, 5364.088105022146, 5418.349798024233, 5439.129739241722, 4785.210440277358, 4845.079434907374, 4860.586850117745, 4868.318435419044, 5085.415177254607, 4953.083679519283, 4970.428400733907, 5008.373953255843, 5019.447860735316, 5034.798608055673, 4785.90428191436, 4854.611631069523, 4876.731779752147, 4878.243872199815, 4881.829135980259, 4858.5384388483035, 4877.561019508261, 4937.8271760488215, 4939.234418665113, 4980.9252861207115, 4760.595349395306, 4891.217405215149, 4899.926501102486, 4918.9508104919205, 4947.529984651453, 5272.841814745564, 5337.386200586904, 5348.277982472356, 5407.891842163135, 5410.404855465935, 5701.14482827575, 5742.827715168552, 5769.653820770725, 5775.249217601727, 5775.537956963475, 5647.0964645656495, 5650.434956504358, 5857.472827445507, 5887.911681324784, 5890.145928840337, 5100.489951004907, 5396.325459317585, 5398.568114550826, 5399.460053994609, 5400.351957765093, 5897.5871688982215, 5905.586608937419, 5907.084401917709, 5908.0, 5910.468057874726, 5470.070088085035, 5611.242482264842, 5613.607047506635, 5635.267415235993, 5660.85847853807, 5757.913631295534, 5767.625104368287, 5774.769009239667, 5776.0, 5815.360310365856, 5677.971610141923, 5691.430856914359, 5695.886082278331, 5696.145578163226, 5697.886042279214, 5555.666660000413, 5670.518005969457, 5682.857928551819, 5713.114467257498, 5798.710064496759, 4334.479862416467, 4355.324924636687, 4361.345798130305, 4361.847335343247, 4396.0, 3845.9230815383535, 3859.498265225559, 3868.5357757069332, 3882.378819388884, 3893.279743247508, 5280.155175171954, 5304.840854774363, 5333.679979201261, 5336.092864213093, 5345.0, 5684.602077854511, 5703.287089113861, 5704.572157088235, 5706.743196556165, 5754.625949313365, 5325.573954083664, 5326.786928522815, 5333.973330133324, 5335.0663633863915, 5394.676319420847, 4716.9292460613115, 4740.525947405301, 4785.066911952136, 4788.090262850117, 4793.257045158006, 5969.224000879858, 6008.068749343859, 6008.218931538872, 6011.879762404727, 6013.939860601338, 5666.405027472221, 5816.1857339973285, 5825.533957283323, 5828.0, 5835.737391817293, 5888.558358123244, 5919.171316015675, 5937.673427961504, 5949.881002379841, 5955.047192449188, 5656.547476201977, 5661.433856614306, 5663.518600918803, 5663.7451314690115, 5684.545236381162, 5594.1608758686525, 5685.431456854281, 5780.421957804186, 5796.101604251179, 5803.680797556175, 5550.111982082847, 5574.9163762542785, 5577.8047768327915, 5582.86042848932, 5656.717164141859, 5520.613557050968, 5547.306586676666, 5553.805616803393, 5554.555635549227, 5569.832905012856, 5278.498542638443, 5448.210009548672, 5471.644343117685, 5489.066858633962, 5545.639533430314, 5639.548836093185, 5684.204211410323, 5690.402507736628, 5702.743376547983, 5709.457601527848, 5529.170624406211, 5536.7785288588, 5540.529055030368, 5542.057850165401, 5548.861278468071], "value": 5281.02382514996, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.8903997280488, 644.3524258120588, 653.9313372095927, 656.6519744535395, 661.3882159002922, 33775.0, 36367.63632363679, 36640.45039324412, 47227.76386118065, 48383.516164838344, 46269.0, 46661.30008049882, 46691.29963050557, 46697.53302466974, 46767.29849052267, 8906.910930890705, 9046.909530904673, 9053.275737940981, 9053.95473022634, 9061.0, 8901.243394311492, 8993.910060899372, 8995.41529800564, 8995.595198216064, 8996.415233009866, 9034.141756533152, 9067.183953444188, 9067.274618030575, 9068.0, 9068.410553314014, 8873.0, 8966.103389661046, 8978.82042359149, 8988.280937525014, 8992.820143597157, 8855.557222138867, 8930.732078037605, 8933.285337173076, 8940.0, 8953.820923581558, 42356.57643423557, 42642.78678606618, 42729.57270427287, 42742.57257427417, 42750.358744618854, 3376.1222082258546, 3496.912577185565, 3527.5943266524164, 3552.8401221944814, 3921.627445392683, 33119.83440082784, 33820.661793381994, 33874.66125338765, 34017.0, 35441.82279088614, 4143.19207754488, 4148.004478925036, 4173.800194664211, 4181.874543763692, 4183.790810459495, 325819.0, 326544.0, 326856.0, 327488.0, 327999.0, 35230.82384588061, 58481.0, 59204.40795591989, 59233.40766592279, 59327.406725933055, 35488.46767298492, 37460.438093428624, 37647.4352884707, 37663.4350484743, 37688.81155594205, 16037.599060023593, 16205.513834584981, 16221.351145954266, 16222.269997850126, 16225.918870405809, 13533.39099740514, 13658.658533536742, 13667.658308542168, 13801.930990345185, 13843.792343114861, 8735.956320218485, 8762.4742515448, 8762.510373236564, 8768.07935166811, 8840.071792461698, 3284.901452956415, 3284.9343013140083, 3345.0062194335933, 3374.0552645259368, 3375.071855239829, 1016.1616666250226, 1017.5573625472942, 1057.904788569017, 1112.360392774142, 1114.3035602748282, 30187.849060754557, 30410.695893040785, 30542.0, 30708.53937190944, 31028.844855775576, 1128.2948157401624, 1159.1658395223765, 1205.5720219322013, 1236.9257844529357, 1306.8497122830995, 16672.916635416746, 16698.332066717438, 16914.91542542304, 16926.963711529657, 17038.57403564896, 531483.0, 537607.0, 537699.0, 537879.0, 538470.0, 59472.0, 59638.40361596328, 59949.400505995254, 60014.399856000884, 60025.699871500365, 1299.330844615024, 1338.7857942729117, 1405.4237762517523, 1537.162246575619, 1625.9349626015064, 30895.422419049268, 34913.47629785504, 35088.29823403569, 35259.118522037155, 35263.91578529283, 51897.740511297205, 52776.47223527716, 52798.73600631972, 52862.73568632132, 52980.205296919805, 450793.0, 457193.0, 458312.0, 458802.0, 459522.0, 44620.0, 44885.326720099874, 45354.31968520541, 46038.0, 47966.52033479621, 49358.50641493539, 49397.25904111513, 49909.75045124751, 50134.24798628096, 50470.74764626153, 42707.0, 43033.354499681904, 43296.0, 43300.35049474324, 43384.13231735284, 41566.376504353066, 42268.577314226466, 42759.7862010688, 42999.0, 43781.19893867481, 43350.13299734051, 43449.0, 43614.0, 44492.0, 44537.777311113234, 36982.26035479329, 38290.808545957094, 38459.6154038456, 38480.23039539137, 39037.0, 28658.426831463672, 28889.277768055967, 29204.561931570617, 29612.259693507836, 29679.703202967696], "value": 19621.64476340303, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.8980260033691, 402.2217010085484, 417.64837181617514, 420.3442629497981, 430.9052008558118, 18321.633567328678, 18803.43589692308, 19372.70940935887, 19653.115609797558, 19685.0, 11597.594084207054, 11682.240654357462, 11699.649010529698, 12215.144939854192, 12480.188787728792, 5219.451957544469, 5352.304200453955, 5365.490278423544, 5374.247605335257, 5393.0, 3710.9257814843686, 3867.7872717000555, 3869.941950870739, 3898.161895192533, 5276.762545685453, 5612.859678508029, 5884.058550631899, 5894.086416605433, 5976.0, 5981.850453738648, 5727.427257274281, 5836.416358364172, 5847.0352391855295, 5912.526997840162, 5936.079907614327, 3675.4119340905327, 5315.654482458628, 5645.971770141123, 5660.5471562274915, 5682.034054210794, 13315.733685326337, 13442.529511467052, 13917.58247252584, 13975.65060873476, 13982.790258146035, 2281.863088214712, 2316.293530473205, 2318.188633978111, 2385.85684858909, 2450.6079027355536, 9745.463999480025, 10051.547680354402, 10099.394036357842, 10228.590856365736, 10375.066244037997, 1980.4553747719349, 1991.6713742232514, 1995.5609765851489, 2023.908924098419, 2063.2056658186557, 73574.0, 74878.62560687216, 76571.61714191393, 76781.61609191974, 82195.58902205451, 10151.593936242467, 11285.0, 11317.886821131848, 11451.88548114525, 11640.883591164149, 16080.276387562588, 16232.918835405748, 16274.349026039063, 16295.51113466598, 16308.266128024268, 8465.195806398382, 8517.190866867762, 8624.870626940601, 8640.092790257058, 8681.913180868236, 8207.466514676527, 8258.091609922903, 8321.375896807764, 8376.0, 8379.329653627696, 4722.693024953367, 4826.227803551415, 4898.995705880286, 4991.575716064175, 5010.0, 1731.337915601012, 1912.135667723958, 1956.0219890054973, 2092.4873406015317, 2093.6545469997586, 888.2583043158905, 959.827231098409, 1014.4015031131668, 1035.77213013137, 1075.2580719303655, 17029.82970170307, 18405.263789448272, 18569.44291671252, 18778.154983025797, 19098.71351929722, 1002.3885429887763, 1014.4217795856291, 1016.8322226832638, 1050.4905121016302, 1103.0238239158402, 10284.177265818716, 10805.675829725122, 10812.945935270272, 10867.184961127947, 10911.781764364827, 413691.0, 429677.0, 469516.0, 471739.0, 476076.0, 93860.53069734608, 94202.52898735463, 94775.52612236894, 96242.51878740561, 96301.40684524697, 1049.3231865446896, 1051.0750539525168, 1056.1603525197486, 1067.6263307842348, 1072.8337107748312, 16582.0, 16969.0, 17057.48827535176, 17251.3962011329, 17489.825101749328, 39920.0, 40357.0, 40580.59419405886, 41463.75608731622, 41761.37357939694, 55917.0, 57604.0, 57978.420215797305, 58059.129113062496, 59225.703871480364, 8641.783955400913, 8644.870326944974, 8687.739367818975, 8739.21347078766, 8899.73300800977, 10018.599256029676, 12489.437975291316, 12850.807237891626, 12956.28740419286, 13018.088733788543, 11455.59905403307, 11636.825447618461, 11819.881801181878, 11855.881441185478, 12131.575394861491, 11522.82715759281, 11605.129615278718, 11629.418529073344, 11644.6506604802, 11644.767104658029, 11333.943330283295, 11550.711232219262, 11941.0, 11991.64025079249, 12463.875361246271, 8634.481931084156, 8656.956715216384, 8697.08680588529, 8826.823463530822, 8954.641814327615, 10990.615328463466, 11464.31214127155, 11984.28094314344, 12135.878641213474, 12478.750424991267], "value": 8908.976961481767, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1362.7342668179708, 1498.0637101811367, 1542.0901668015872, 1634.967300653987, 1773.0602780526317, 8513.276371508422, 8894.332925030625, 8905.866412003825, 9031.819363612723, 9130.315226358016, 8646.870296945535, 8843.690470833522, 8888.06675299094, 8900.02099769025, 8900.688475903346, 2010.3566858605252, 2072.720182775321, 2284.8286378521593, 2313.6298192289237, 2320.0951628864755, 2359.905603775847, 2391.6173412254043, 2391.784739373456, 2393.5212957408503, 2394.628832530952, 2254.6167151584186, 2266.8639881607073, 2277.3054218463362, 2278.897449614763, 2287.0, 1982.6431242376439, 2203.0857194264363, 2206.3711842125, 2234.7765223477686, 2280.0, 2228.665700144975, 2245.8877056147126, 2248.168177774234, 2249.5388445368662, 2251.200823707593, 8698.56507174645, 8751.3874028818, 8757.036725960203, 8763.0, 8763.693270735494, 4985.401751789808, 5134.1528647773075, 5135.6918584885025, 5138.0, 5138.023775482684, 3244.1727359523406, 3264.8857289994735, 3421.5894092709036, 3430.2281986553076, 3439.329330780499, 1121.3047910295668, 1130.0846314485293, 1130.2540323386609, 1130.8190689489725, 1139.5897476908306, 13011.934940325333, 13023.934880325538, 13024.283664398454, 13043.54347597839, 13054.673633159153, 4568.0, 4767.523247675204, 4786.282057691375, 4815.927761083586, 4896.143174944371, 10110.8483372748, 10155.086042256233, 10221.131203847608, 10225.539850706587, 10228.232882533839, 5289.074411977888, 5292.788288468418, 5295.285136506599, 5296.3379577552805, 5296.682199068068, 4356.6732495063, 4855.708657480563, 4991.550760431579, 5006.0989021975665, 5006.499350064964, 3944.4280579315837, 3964.801759911993, 3998.5601583825755, 4042.413849991735, 4100.65144462724, 1208.9032877369789, 1236.4992178167677, 1238.0961897814645, 1245.2092920995053, 1263.4377701922556, 825.1130035212171, 923.8337099322187, 946.7917058247175, 959.6689142245914, 997.4015590645555, 5956.76172953077, 5975.372585878507, 6005.549583781234, 6016.278046634345, 6039.78860739872, 945.7351941456403, 1058.9735256618646, 1060.98145780052, 1071.9303245289032, 1102.9172812039128, 3944.8224829882724, 4034.495688038995, 4062.857799977046, 4095.877123686294, 4171.3325867860995, 11375.943120284512, 11523.250988685708, 11644.068474522019, 11664.825027624423, 11676.0, 11527.88472115268, 11543.07655387567, 11600.6519804406, 11611.419429028514, 11627.418629068512, 8164.550949697705, 8325.292350150185, 8463.0, 8466.534340611202, 8509.574521273911, 5915.822525324247, 6092.847678808065, 6162.106494558354, 6223.937760622517, 6228.159198508143, 10357.4303413313, 10557.102646274845, 10565.788684226427, 10840.67477975662, 10868.402237876993, 10713.464326783786, 10793.892061079603, 10802.459877006275, 10885.401302928414, 11081.445927703744, 7502.099748030271, 7895.447318687637, 7900.2889739923685, 8003.559804210591, 8102.554359510284, 9058.54707264621, 9087.31845111606, 9111.225545828678, 9135.0, 9151.084891511062, 7891.84216315659, 8007.0, 8050.114487406264, 8107.594620269081, 8131.471454355448, 7715.421343399155, 7763.844723105393, 7784.9610751945875, 7958.0848202457455, 7987.201279871966, 7190.06529151207, 7199.71201151948, 7251.23861994483, 7271.309225623558, 7273.127224733066, 4927.137750893651, 5045.11710450677, 5154.871128221825, 5180.041692286939, 5193.532582067481, 4897.510248975074, 4930.926036109533, 5103.43862175153, 5296.2055691646565, 5307.336582927134], "value": 4701.404407084306, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.7053827900587, 338.1208856971872, 341.4945880097454, 343.47791357137146, 344.3904289407748, 5230.816921407752, 5279.8416047518585, 5289.117431000104, 5330.253764472967, 5359.598030147735, 5226.268322434853, 5234.947650523493, 5235.1885457754015, 5253.133233016557, 5292.3913749918775, 3929.351656976595, 4016.15660711251, 4156.272652285853, 4194.203101410738, 4219.746815191083, 4089.1208390196102, 4100.323446631317, 4121.278776214165, 4142.9378559321485, 4190.413342132104, 3919.529656441217, 4110.835566577333, 4119.590039826705, 4121.649659778923, 4130.793460326987, 3809.7142714296538, 3981.820818063194, 4021.296273152201, 4127.0, 4131.607497287783, 3636.7636103653176, 3665.157013886821, 3667.1382225177063, 3680.0983758978955, 3690.907727306812, 5084.339035925343, 5097.8215762448135, 5116.283720279127, 5117.53942145205, 5131.846044618667, 4544.590986811203, 4673.742944138071, 4708.952910470885, 4710.293455981596, 4726.314684370747, 5426.321709786277, 5456.290682211326, 5462.453754624546, 5468.808591699271, 5514.641548299348, 4003.919921601552, 4011.919761604781, 4036.616521430459, 4043.696722745806, 4056.5132184137797, 5442.285680010784, 5681.948839464712, 5683.687397193153, 5684.857878553028, 5722.227499287585, 3995.300822356076, 3996.2207369562657, 4026.6979976501293, 4026.8187931543152, 4031.9395209071886, 4062.2484840304637, 4088.652464540488, 4113.177364527047, 4116.403121547359, 4121.5466298707115, 4405.273129933589, 4662.0, 4669.322948172496, 4707.176244157259, 4747.928781068286, 5516.062269414209, 5547.44525547442, 5552.750126244328, 5553.444655534495, 5564.721763911788, 1404.3820718883658, 1404.8735613794809, 1408.9577312680635, 1421.8435972043067, 1424.4658253155067, 877.4466303058198, 885.880406145175, 890.3055616619048, 910.2172131966504, 925.9351845370759, 5228.92156617651, 5238.73806309683, 5242.636914402283, 5305.336832895888, 5359.866003349869, 5632.295963004624, 5706.773043795604, 5715.2855893013375, 5716.114002329562, 5719.971400142973, 5107.952869661711, 5323.547498462596, 5332.68003919766, 5356.143017117242, 5404.8108316208745, 2955.985220073886, 2991.745701615387, 3010.443068032421, 3028.5911401960893, 3039.1034644779843, 5857.414258574108, 5860.296764388216, 5868.178455016301, 5874.618149820248, 5897.911531327033, 5593.720313984284, 5729.942700573024, 5802.738876750556, 5805.883882322414, 5807.767689292381, 5709.22925405065, 5800.245968024215, 5849.005669036274, 5871.768727883377, 5896.17453556511, 5427.782888684566, 5664.603477756682, 5682.090865461506, 5720.656760594377, 5725.770969161354, 5520.1167813149705, 5580.665160090245, 5598.180591307922, 5611.80358687444, 5633.1831884375715, 5802.245708057925, 5843.211166492469, 5878.177055212359, 5912.73392697321, 5917.437843404869, 3617.276544691125, 3675.7243206760136, 3685.723570732152, 3690.723195760275, 3710.2579484103826, 5075.416327122281, 5101.3113229715, 5104.744762761921, 5107.770150343169, 5162.922556161736, 5021.221710634857, 5029.968856384359, 5044.394672639307, 5067.695938243717, 5074.594032477319, 4834.0, 5028.84913452597, 5046.77289521965, 5050.368703912011, 5050.368703912011, 4878.609711223023, 4960.379952505937, 4971.328870602567, 4986.12742770021, 5257.526822585985, 5424.593155513273, 5533.6403133796175, 5542.140968149944, 5578.721063946705, 5637.830865074055, 5466.0, 5476.479734425223, 5480.945190548044, 5482.342118945592, 5484.561235101262], "value": 4160.324888139951, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [814.8370325934812, 816.379551540829, 868.0885070675793, 870.1472556894244, 894.1728900766789, 14517.927410362947, 15307.617309567253, 15328.693426131498, 15494.61263468414, 15531.0, 13583.52457663982, 13621.523246686367, 13631.659208519792, 13639.386227619756, 13639.590812275648, 684.5687217053262, 813.9348852091848, 825.5418242875202, 841.6549214821924, 845.8900342955438, 834.4867906237681, 838.2874556626849, 840.5839109640737, 840.8570543007672, 841.2891107014563, 726.2120599149929, 898.0884402331639, 899.7120921305185, 900.8648702694583, 902.4540153207314, 869.6825658634584, 879.4591326334322, 880.8634661627458, 889.5641135843455, 889.8798662180587, 649.9025146228056, 650.1905128115479, 650.4731167754135, 650.9056186852927, 651.0592194279268, 14309.928450357682, 14379.424823007068, 14415.78376324356, 14439.0, 14460.855391446055, 13268.60194194166, 13310.267935263557, 13379.732405351839, 13677.384517696628, 13792.172469651852, 12142.286686541649, 12342.321172335518, 12364.876351236462, 12505.437255323532, 12868.420921058574, 4419.315006174048, 4483.170613436525, 4532.773361331921, 4557.612602928755, 4601.792919318638, 52880.0, 53217.733911330586, 53232.0, 55323.17015244775, 56064.43935560633, 10892.564297428173, 10945.471344761943, 11010.559577616805, 11018.228723989243, 11215.0, 19492.610147796964, 19706.408807735792, 19720.506987325432, 19729.40811775649, 19738.30915917936, 7954.642041108164, 8025.157358477276, 8076.232757887991, 8341.499510029296, 8469.618867150994, 4507.774611269423, 4518.277075667943, 4708.4820669726305, 4798.184308667535, 4825.4933232010835, 3440.6043305020244, 3513.156842357867, 3536.6109727929907, 3548.8580456781956, 3556.76881002734, 638.7476946606065, 691.246541270018, 721.989170162448, 722.663961258007, 730.5032577847115, 749.86877296474, 753.8793792993205, 757.5454727163658, 762.9465937384441, 774.3263360875961, 10283.209710047178, 10302.587896484056, 10347.793044139074, 10358.948205259076, 10394.636187733544, 693.2651389527117, 749.3555542233674, 773.818152734107, 787.7282337593521, 788.2787249666491, 4948.950510494849, 4984.227444745998, 5003.374578177728, 5040.79836806531, 5047.141985862412, 75275.0, 76211.0, 77517.61241193757, 77824.0, 78990.21009789943, 64575.67712161503, 65389.673051635385, 65565.34434655592, 66654.33345666579, 67072.0, 58749.706251469324, 59054.0, 59195.40804591985, 59760.70119649374, 59988.700056498565, 9025.458472491671, 9058.230050445522, 9103.590338434655, 9192.448453092837, 9205.217556507503, 39049.414258785575, 39430.4227830895, 39465.40801888031, 39646.80176599098, 40797.59202407938, 43854.78072609616, 44936.550634494546, 45355.773221133684, 47247.52752472431, 54645.0, 12919.547815826401, 12949.611511654666, 13071.607851764462, 13113.475460981454, 13239.470421183045, 14362.784558231844, 14472.27638618086, 14599.489017884323, 14765.483208087666, 14803.703925921205, 13052.934735326642, 13498.325083745576, 13732.65668358299, 13906.304684765519, 14009.859901400856, 13507.0, 13512.391942362814, 13707.794383084462, 13739.175649461064, 13938.094023888414, 13433.059685821898, 13646.181229125887, 13691.589252322447, 13825.792613111013, 13931.0, 10484.161267098461, 10854.29447085937, 11221.382823944761, 11261.774764504828, 11315.717107072389, 11127.888721112686, 11255.606053788078, 11354.0, 11370.54517819278, 11463.31220126795], "value": 7183.548484447694, "unit": "score"}], "name": "dromaeo_css", "value": 7114.917860711401, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 108.0, 109.0, 118.0, 108.0, 109.0, 109.0, 109.0, 109.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 129.0, 159.0, 221.0, 125.0, 154.0, 154.0, 125.0, 182.0, 126.0], "value": 153.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 162.0, 162.0, 162.0, 161.0, 161.0, 163.0, 160.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 143.0, 75.0, 75.0, 76.0, 75.0, 133.0, 75.0], "value": 87.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 146.0, 91.0, 91.0, 92.0, 137.0, 92.0, 92.0, 126.0], "value": 105.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 116.0, 116.0, 117.0, 118.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 150.0, 145.0, 145.0, 144.0, 145.0, 145.0, 145.0, 145.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 57.0, 55.0, 56.0, 56.0, 119.0, 53.0, 53.0], "value": 61.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 59.0, 60.0, 60.0, 59.0, 60.0, 59.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 76.0, 79.0, 78.0, 77.0, 78.0, 78.0, 78.0, 80.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 121.0, 120.0, 117.0, 126.0, 116.0, 118.0, 115.0, 237.0, 120.0], "value": 131.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 165.0, 163.0, 165.0, 157.0, 162.0, 161.0, 163.0, 156.0], "value": 161.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 64.0, 64.0, 64.0, 61.0, 63.0, 62.0, 61.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1528.5, "alertThreshold": 2.0}]} 20:36:23 INFO - Return code: 0 20:36:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:36:23 ERROR - # TBPL SUCCESS # 20:36:23 INFO - Running post-action listener: _resource_record_post_action 20:36:23 INFO - ##### 20:36:23 INFO - ##### Finished run-tests step (success) 20:36:23 INFO - ##### 20:36:23 INFO - Running post-run listener: _resource_record_post_run 20:36:23 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536809472; Read time: 16; Write time: 448208 20:36:23 INFO - TinderboxPrint: CPU usage
13.1% 20:36:23 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 20:36:23 INFO - TinderboxPrint: I/O write bytes / time
536,809,472 / 448,208 20:36:23 INFO - TinderboxPrint: CPU idle
8,272.4 (86.9%) 20:36:23 INFO - TinderboxPrint: CPU user
1,206.4 (12.7%) 20:36:23 INFO - TinderboxPrint: Swap in / out
0 / 0 20:36:23 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246501376; Read time: 0; Write time: 246692 20:36:23 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290308096; Read time: 16; Write time: 201516 20:36:23 INFO - Running post-run listener: _upload_blobber_files 20:36:23 INFO - Blob upload gear active. 20:36:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:36:23 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 20:36:23 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'] 20:36:23 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 20:36:24 INFO - (blobuploader) - INFO - Open directory for files ... 20:36:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:36:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:36:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:36:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:36:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:36:25 INFO - (blobuploader) - INFO - Done attempting. 20:36:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:36:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:36:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:36:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:36:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:36:26 INFO - (blobuploader) - INFO - Done attempting. 20:36:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:36:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:36:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:36:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:36:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:36:30 INFO - (blobuploader) - INFO - Done attempting. 20:36:30 INFO - (blobuploader) - INFO - Iteration through files over. 20:36:30 INFO - Return code: 0 20:36:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:36:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:36:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/29cb8a6d2cc9364bbe5852133a1a2c83ebffd784fb698ec8468ebaf9eaf9812b4500110306e0d0abf43952e4b3f679369afafe9198a7d31a126f43eb93c22b59", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dfc15a35024b585023bc21dbe8b939c45287adacc729ed90ce5bd0ae6ba10d85277f573777adb04562069a08e6ab03473eea7a30e7fff55d84586c1295768de3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a87d37449ae631fc9b62bb149f5897bc899d1bc5aa436e08db36a397e8faefd0d4be5040d73587a4a86919a6fac499f0843ee1869c36d67cbce2be587c68971f"} 20:36:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:36:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:36:30 INFO - Contents: 20:36:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/29cb8a6d2cc9364bbe5852133a1a2c83ebffd784fb698ec8468ebaf9eaf9812b4500110306e0d0abf43952e4b3f679369afafe9198a7d31a126f43eb93c22b59", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dfc15a35024b585023bc21dbe8b939c45287adacc729ed90ce5bd0ae6ba10d85277f573777adb04562069a08e6ab03473eea7a30e7fff55d84586c1295768de3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a87d37449ae631fc9b62bb149f5897bc899d1bc5aa436e08db36a397e8faefd0d4be5040d73587a4a86919a6fac499f0843ee1869c36d67cbce2be587c68971f"} 20:36:30 INFO - Running post-run listener: copy_logs_to_upload_dir 20:36:30 INFO - Copying logs to upload dir... 20:36:30 INFO - mkdir: /builds/slave/test/build/upload/logs 20:36:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.624264 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-16 20:36:29.615761) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 20:36:29.619341) ========= 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=652eb03db935cfc1c15ebda0000001ad-1463454951.648315-2130897345 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/29cb8a6d2cc9364bbe5852133a1a2c83ebffd784fb698ec8468ebaf9eaf9812b4500110306e0d0abf43952e4b3f679369afafe9198a7d31a126f43eb93c22b59", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dfc15a35024b585023bc21dbe8b939c45287adacc729ed90ce5bd0ae6ba10d85277f573777adb04562069a08e6ab03473eea7a30e7fff55d84586c1295768de3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a87d37449ae631fc9b62bb149f5897bc899d1bc5aa436e08db36a397e8faefd0d4be5040d73587a4a86919a6fac499f0843ee1869c36d67cbce2be587c68971f"} build_url:https://queue.taskcluster.net/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011365 build_url: 'https://queue.taskcluster.net/v1/task/Y3HsucFLTr26WQZZFgJcEg/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/29cb8a6d2cc9364bbe5852133a1a2c83ebffd784fb698ec8468ebaf9eaf9812b4500110306e0d0abf43952e4b3f679369afafe9198a7d31a126f43eb93c22b59", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dfc15a35024b585023bc21dbe8b939c45287adacc729ed90ce5bd0ae6ba10d85277f573777adb04562069a08e6ab03473eea7a30e7fff55d84586c1295768de3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a87d37449ae631fc9b62bb149f5897bc899d1bc5aa436e08db36a397e8faefd0d4be5040d73587a4a86919a6fac499f0843ee1869c36d67cbce2be587c68971f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 20:36:29.645002) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 20:36:29.645343) ========= 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=652eb03db935cfc1c15ebda0000001ad-1463454951.648315-2130897345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004299 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 20:36:29.729634) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 20:36:29.729956) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 20:36:29.730278) ========= ========= Total master_lag: 0.17 =========