builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1464297409.61 results: success (0) buildid: 20160526113032 builduid: c1ecc818be864fe0bfd3af06230504fe revision: 7b2fc29e5d9db05f171dea679a3e5d50f8a9e2d6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 14:16:49.611318) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 14:16:49.611774) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 14:16:49.612047) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 14:16:49.628563) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 14:16:49.628969) ========= 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=836cfdc75598d54cb747368e000001a9-1464297284.619721-1106222388 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-26 14:16:49-- 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% 42.9M=0s 2016-05-26 14:16:49 (42.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.072600 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 14:16:49.715205) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 14:16:49.715517) ========= 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=836cfdc75598d54cb747368e000001a9-1464297284.619721-1106222388 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016131 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 14:16:49.764829) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-26 14:16:49.765239) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7b2fc29e5d9db05f171dea679a3e5d50f8a9e2d6 --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 7b2fc29e5d9db05f171dea679a3e5d50f8a9e2d6 --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=836cfdc75598d54cb747368e000001a9-1464297284.619721-1106222388 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-26 14:16:49,899 truncating revision to first 12 chars 2016-05-26 14:16:49,899 Setting DEBUG logging. 2016-05-26 14:16:49,899 attempt 1/10 2016-05-26 14:16:49,899 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7b2fc29e5d9d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-26 14:16:50,817 unpacking tar archive at: fx-team-7b2fc29e5d9d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.269172 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-26 14:16:51.048159) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 14:16:51.048473) ========= script_repo_revision: 7b2fc29e5d9db05f171dea679a3e5d50f8a9e2d6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 14:16:51.048911) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 14:16:51.049205) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 14:16:51.060061) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-26 14:16:51.060398) ========= /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=836cfdc75598d54cb747368e000001a9-1464297284.619721-1106222388 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:16:51 INFO - MultiFileLogger online at 20160526 14:16:51 in /builds/slave/test 14:16:51 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 14:16:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:16:51 INFO - {'append_to_log': False, 14:16:51 INFO - 'base_work_dir': '/builds/slave/test', 14:16:51 INFO - 'blob_upload_branch': 'Fx-Team', 14:16:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:16:51 INFO - 'branch': 'Fx-Team', 14:16:51 INFO - 'buildbot_json_path': 'buildprops.json', 14:16:51 INFO - 'config_files': ('talos/linux_config.py',), 14:16:51 INFO - 'default_actions': ('clobber', 14:16:51 INFO - 'read-buildbot-config', 14:16:51 INFO - 'download-and-extract', 14:16:51 INFO - 'populate-webroot', 14:16:51 INFO - 'create-virtualenv', 14:16:51 INFO - 'install', 14:16:51 INFO - 'run-tests'), 14:16:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:16:51 INFO - 'download_minidump_stackwalk': True, 14:16:51 INFO - 'download_symbols': 'ondemand', 14:16:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:16:51 INFO - 'tooltool.py': '/tools/tooltool.py', 14:16:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:16:51 INFO - '/tools/misc-python/virtualenv.py')}, 14:16:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:16:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:16:51 INFO - 'installer_path': 'installer.exe', 14:16:51 INFO - 'log_level': 'info', 14:16:51 INFO - 'log_name': 'talos', 14:16:51 INFO - 'log_to_console': True, 14:16:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:16:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:16:51 INFO - 'opt_config_files': (), 14:16:51 INFO - 'pip_index': False, 14:16:51 INFO - 'sps_profile': False, 14:16:51 INFO - 'sps_profile_interval': 0, 14:16:51 INFO - 'suite': 'dromaeojs', 14:16:51 INFO - 'system_bits': '32', 14:16:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:16:51 INFO - 'title': 'talos-linux64-ix-028', 14:16:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:16:51 INFO - 'use_talos_json': True, 14:16:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:16:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:16:51 INFO - 'work_dir': 'build'} 14:16:51 INFO - ##### 14:16:51 INFO - ##### Running clobber step. 14:16:51 INFO - ##### 14:16:51 INFO - Running pre-action listener: _resource_record_pre_action 14:16:51 INFO - Running main action method: clobber 14:16:51 INFO - rmtree: /builds/slave/test/build 14:16:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:16:51 INFO - Running post-action listener: _resource_record_post_action 14:16:51 INFO - ##### 14:16:51 INFO - ##### Finished clobber step (success) 14:16:51 INFO - ##### 14:16:51 INFO - ##### 14:16:51 INFO - ##### Running read-buildbot-config step. 14:16:51 INFO - ##### 14:16:51 INFO - Running pre-action listener: _resource_record_pre_action 14:16:51 INFO - Running main action method: read_buildbot_config 14:16:51 INFO - Using buildbot properties: 14:16:51 INFO - { 14:16:51 INFO - "project": "", 14:16:51 INFO - "product": "firefox", 14:16:51 INFO - "script_repo_revision": "production", 14:16:51 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:16:51 INFO - "repository": "", 14:16:51 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:16:51 INFO - "buildid": "20160526113032", 14:16:51 INFO - "pgo_build": "True", 14:16:51 INFO - "basedir": "/builds/slave/test", 14:16:51 INFO - "buildnumber": 1193, 14:16:51 INFO - "slavename": "talos-linux64-ix-028", 14:16:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:16:51 INFO - "platform": "ubuntu64_hw", 14:16:51 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:16:51 INFO - "branch": "fx-team", 14:16:51 INFO - "repo_path": "integration/fx-team", 14:16:51 INFO - "revision": "7b2fc29e5d9db05f171dea679a3e5d50f8a9e2d6", 14:16:51 INFO - "stage_platform": "linux64-pgo", 14:16:51 INFO - "builduid": "c1ecc818be864fe0bfd3af06230504fe", 14:16:51 INFO - "slavebuilddir": "test" 14:16:51 INFO - } 14:16:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/IcNAXxo9SI2y_FlMmLjxYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:16:51 INFO - Running post-action listener: _resource_record_post_action 14:16:51 INFO - ##### 14:16:51 INFO - ##### Finished read-buildbot-config step (success) 14:16:51 INFO - ##### 14:16:51 INFO - ##### 14:16:51 INFO - ##### Running download-and-extract step. 14:16:51 INFO - ##### 14:16:51 INFO - Running pre-action listener: _resource_record_pre_action 14:16:51 INFO - Running main action method: download_and_extract 14:16:51 INFO - mkdir: /builds/slave/test/build/tests 14:16:51 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')]} 14:16:51 INFO - https://queue.taskcluster.net/v1/task/IcNAXxo9SI2y_FlMmLjxYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:16:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IcNAXxo9SI2y_FlMmLjxYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:16:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IcNAXxo9SI2y_FlMmLjxYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:16:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IcNAXxo9SI2y_FlMmLjxYw/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 14:16:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IcNAXxo9SI2y_FlMmLjxYw/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 14:16:54 INFO - Downloaded 1361 bytes. 14:16:55 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:16:55 INFO - Using the following test package requirements: 14:16:55 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:16:55 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:16:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:16:55 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:16:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:16:55 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:16:55 INFO - u'jsshell-linux-x86_64.zip'], 14:16:55 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:16:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:16:55 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:16:55 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:16:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:16:55 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:16:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:16:55 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:16:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:16:55 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:16:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:16:55 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:16: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')]} 14:16:55 INFO - https://queue.taskcluster.net/v1/task/IcNAXxo9SI2y_FlMmLjxYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:16:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IcNAXxo9SI2y_FlMmLjxYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:16:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IcNAXxo9SI2y_FlMmLjxYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:16:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IcNAXxo9SI2y_FlMmLjxYw/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 14:16:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IcNAXxo9SI2y_FlMmLjxYw/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 14:16:56 INFO - Downloaded 24408308 bytes. 14:16: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'] 14:16: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 14:16:57 INFO - Return code: 0 14:16:57 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 14:16:57 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')]} 14:16:57 INFO - https://queue.taskcluster.net/v1/task/IcNAXxo9SI2y_FlMmLjxYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:16:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IcNAXxo9SI2y_FlMmLjxYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:16:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IcNAXxo9SI2y_FlMmLjxYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:16:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IcNAXxo9SI2y_FlMmLjxYw/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 14:16:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IcNAXxo9SI2y_FlMmLjxYw/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 14:17:00 INFO - Downloaded 24408308 bytes. 14:17: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'] 14:17: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 14:17:01 INFO - Return code: 0 14:17: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')]} 14:17:01 INFO - https://queue.taskcluster.net/v1/task/IcNAXxo9SI2y_FlMmLjxYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:17:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IcNAXxo9SI2y_FlMmLjxYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:17:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IcNAXxo9SI2y_FlMmLjxYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:17:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IcNAXxo9SI2y_FlMmLjxYw/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 14:17:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IcNAXxo9SI2y_FlMmLjxYw/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 14:17:03 INFO - Downloaded 10834034 bytes. 14:17: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'] 14:17: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 14:17:03 INFO - Return code: 0 14:17: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')]} 14:17:03 INFO - https://queue.taskcluster.net/v1/task/IcNAXxo9SI2y_FlMmLjxYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:17:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IcNAXxo9SI2y_FlMmLjxYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:17:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IcNAXxo9SI2y_FlMmLjxYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:17:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IcNAXxo9SI2y_FlMmLjxYw/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 14:17:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IcNAXxo9SI2y_FlMmLjxYw/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 14:17:05 INFO - Downloaded 58671760 bytes. 14:17:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IcNAXxo9SI2y_FlMmLjxYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:17:05 INFO - mkdir: /builds/slave/test/properties 14:17:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:17:05 INFO - Writing to file /builds/slave/test/properties/build_url 14:17:05 INFO - Contents: 14:17:05 INFO - build_url:https://queue.taskcluster.net/v1/task/IcNAXxo9SI2y_FlMmLjxYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:17:05 INFO - Running post-action listener: _resource_record_post_action 14:17:05 INFO - Running post-action listener: set_extra_try_arguments 14:17:05 INFO - ##### 14:17:05 INFO - ##### Finished download-and-extract step (success) 14:17:05 INFO - ##### 14:17:05 INFO - ##### 14:17:05 INFO - ##### Running populate-webroot step. 14:17:05 INFO - ##### 14:17:05 INFO - Running pre-action listener: _resource_record_pre_action 14:17:05 INFO - Running main action method: populate_webroot 14:17:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:17:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:17:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:17:05 INFO - '--tppagecycles', 14:17:05 INFO - '7'], 14:17:05 INFO - 'tests': ['tsvgm']}}, 14:17:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:17:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:17:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:17:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:17:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:17:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:17:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:05 INFO - 'talos_options': ['--disable-e10s'], 14:17:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:17:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:17:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:05 INFO - 'talos_options': ['--disable-e10s'], 14:17:05 INFO - 'tests': ['damp', 'tps']}, 14:17:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:05 INFO - 'tests': ['damp', 'tps']}, 14:17:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:17:05 INFO - 'tests': ['dromaeo_dom']}, 14:17:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:17:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:17:05 INFO - 'tests': ['a11yr', 14:17:05 INFO - 'ts_paint', 14:17:05 INFO - 'tpaint', 14:17:05 INFO - 'sessionrestore', 14:17:05 INFO - 'sessionrestore_no_auto_restore', 14:17:05 INFO - 'tabpaint']}, 14:17:05 INFO - 'other-e10s': {'tests': ['a11yr', 14:17:05 INFO - 'ts_paint', 14:17:05 INFO - 'tpaint', 14:17:05 INFO - 'sessionrestore', 14:17:05 INFO - 'sessionrestore_no_auto_restore', 14:17:05 INFO - 'tabpaint']}, 14:17:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:17:05 INFO - 'ts_paint', 14:17:05 INFO - 'tpaint', 14:17:05 INFO - 'sessionrestore', 14:17:05 INFO - 'sessionrestore_no_auto_restore', 14:17:05 INFO - 'tabpaint']}, 14:17:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:17:05 INFO - 'ts_paint', 14:17:05 INFO - 'tpaint', 14:17:05 INFO - 'sessionrestore', 14:17:05 INFO - 'sessionrestore_no_auto_restore', 14:17:05 INFO - 'tabpaint']}, 14:17:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:17:05 INFO - 'tests': ['a11yr', 14:17:05 INFO - 'ts_paint', 14:17:05 INFO - 'tpaint', 14:17:05 INFO - 'sessionrestore', 14:17:05 INFO - 'sessionrestore_no_auto_restore', 14:17:05 INFO - 'tabpaint']}, 14:17:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:17:05 INFO - 'tests': ['a11yr', 14:17:05 INFO - 'ts_paint', 14:17:05 INFO - 'tpaint', 14:17:05 INFO - 'sessionrestore', 14:17:05 INFO - 'sessionrestore_no_auto_restore', 14:17:05 INFO - 'tabpaint']}, 14:17:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:17:05 INFO - 'tests': ['tsvgx', 14:17:05 INFO - 'tsvgr_opacity', 14:17:05 INFO - 'tart', 14:17:05 INFO - 'tscrollx', 14:17:05 INFO - 'cart']}, 14:17:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:17:05 INFO - 'tsvgr_opacity', 14:17:05 INFO - 'tart', 14:17:05 INFO - 'tscrollx', 14:17:05 INFO - 'cart']}, 14:17:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:05 INFO - 'talos_options': ['--disable-e10s'], 14:17:05 INFO - 'tests': ['tp5o']}, 14:17:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:05 INFO - 'tests': ['tp5o']}, 14:17:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:05 INFO - 'talos_options': ['--disable-e10s', 14:17:05 INFO - '--xperf_path', 14:17:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:17:05 INFO - 'tests': ['tp5n']}, 14:17:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:05 INFO - 'talos_options': ['--xperf_path', 14:17:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:17:05 INFO - 'tests': ['tp5n']}}, 14:17:05 INFO - 'talos.zip': {'path': '', 14:17:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:17:05 INFO - Running post-action listener: _resource_record_post_action 14:17:05 INFO - ##### 14:17:05 INFO - ##### Finished populate-webroot step (success) 14:17:05 INFO - ##### 14:17:05 INFO - ##### 14:17:05 INFO - ##### Running create-virtualenv step. 14:17:05 INFO - ##### 14:17:05 INFO - Running pre-action listener: _resource_record_pre_action 14:17:05 INFO - Running main action method: create_virtualenv 14:17:05 INFO - Creating virtualenv /builds/slave/test/build/venv 14:17: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 14:17:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:17:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:17:05 INFO - Using real prefix '/usr' 14:17:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:17:06 INFO - Installing distribute.............................................................................................................................................................................................done. 14:17:08 INFO - Installing pip.................done. 14:17:08 INFO - Return code: 0 14:17:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:17: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')]} 14:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17: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')]} 14:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4a070d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1619770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a89c0>, '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 0x16a98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a9d50>, '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': '836cfdc75598d54cb747368e000001a9-1464297284.619721-1106222388', '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 14:17: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', 'pip>=1.5'] in /builds/slave/test/build 14:17: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 pip>=1.5 14:17:08 INFO - Using env: {'DISPLAY': ':0', 14:17:08 INFO - 'HOME': '/home/cltbld', 14:17:08 INFO - 'LANG': 'en_US.UTF-8', 14:17:08 INFO - 'LANGUAGE': 'en_US:en', 14:17:08 INFO - 'LOGNAME': 'cltbld', 14:17:08 INFO - 'MAIL': '/var/mail/cltbld', 14:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:08 INFO - 'MOZ_NO_REMOTE': '1', 14:17:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:08 INFO - 'NO_EM_RESTART': '1', 14:17:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:08 INFO - 'PWD': '/builds/slave/test', 14:17:08 INFO - 'SHELL': '/bin/bash', 14:17:08 INFO - 'SHLVL': '1', 14:17:08 INFO - 'TERM': 'linux', 14:17:08 INFO - 'TMOUT': '86400', 14:17:08 INFO - 'USER': 'cltbld', 14:17:08 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1464297284.619721-1106222388', 14:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:08 INFO - '_': '/tools/buildbot/bin/python'} 14:17:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17: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 14:17:08 INFO - Cleaning up... 14:17:08 INFO - Return code: 0 14:17:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:17: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')]} 14:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17: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')]} 14:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17: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 0x7f4a070d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1619770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a89c0>, '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 0x16a98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a9d50>, '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': '836cfdc75598d54cb747368e000001a9-1464297284.619721-1106222388', '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 14:17: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 14:17: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 14:17:08 INFO - Using env: {'DISPLAY': ':0', 14:17:08 INFO - 'HOME': '/home/cltbld', 14:17:08 INFO - 'LANG': 'en_US.UTF-8', 14:17:08 INFO - 'LANGUAGE': 'en_US:en', 14:17:08 INFO - 'LOGNAME': 'cltbld', 14:17:08 INFO - 'MAIL': '/var/mail/cltbld', 14:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:08 INFO - 'MOZ_NO_REMOTE': '1', 14:17:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:08 INFO - 'NO_EM_RESTART': '1', 14:17:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:08 INFO - 'PWD': '/builds/slave/test', 14:17:08 INFO - 'SHELL': '/bin/bash', 14:17:08 INFO - 'SHLVL': '1', 14:17:08 INFO - 'TERM': 'linux', 14:17:08 INFO - 'TMOUT': '86400', 14:17:08 INFO - 'USER': 'cltbld', 14:17:08 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1464297284.619721-1106222388', 14:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:08 INFO - '_': '/tools/buildbot/bin/python'} 14:17:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:08 INFO - Downloading/unpacking psutil>=3.1.1 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:17:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:17:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:17:10 INFO - Installing collected packages: psutil 14:17:10 INFO - Running setup.py install for psutil 14:17:10 INFO - building 'psutil._psutil_linux' extension 14:17: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 14:17:11 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 14:17:11 INFO - building 'psutil._psutil_posix' extension 14:17:11 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 14:17:11 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 14:17:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:17:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:17:11 INFO - Successfully installed psutil 14:17:11 INFO - Cleaning up... 14:17:11 INFO - Return code: 0 14:17:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:17:11 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')]} 14:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:11 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')]} 14:17:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:11 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 0x7f4a070d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1619770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a89c0>, '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 0x16a98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a9d50>, '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': '836cfdc75598d54cb747368e000001a9-1464297284.619721-1106222388', '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 14:17:11 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 14:17:11 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 14:17:11 INFO - Using env: {'DISPLAY': ':0', 14:17:11 INFO - 'HOME': '/home/cltbld', 14:17:11 INFO - 'LANG': 'en_US.UTF-8', 14:17:11 INFO - 'LANGUAGE': 'en_US:en', 14:17:11 INFO - 'LOGNAME': 'cltbld', 14:17:11 INFO - 'MAIL': '/var/mail/cltbld', 14:17:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:11 INFO - 'MOZ_NO_REMOTE': '1', 14:17:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:11 INFO - 'NO_EM_RESTART': '1', 14:17:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:11 INFO - 'PWD': '/builds/slave/test', 14:17:11 INFO - 'SHELL': '/bin/bash', 14:17:11 INFO - 'SHLVL': '1', 14:17:11 INFO - 'TERM': 'linux', 14:17:11 INFO - 'TMOUT': '86400', 14:17:11 INFO - 'USER': 'cltbld', 14:17:11 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1464297284.619721-1106222388', 14:17:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:11 INFO - '_': '/tools/buildbot/bin/python'} 14:17:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:17:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:17:13 INFO - Installing collected packages: mozsystemmonitor 14:17:13 INFO - Running setup.py install for mozsystemmonitor 14:17:13 INFO - Successfully installed mozsystemmonitor 14:17:13 INFO - Cleaning up... 14:17:13 INFO - Return code: 0 14:17:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:17: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')]} 14:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17: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')]} 14:17:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17: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 0x7f4a070d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1619770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a89c0>, '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 0x16a98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a9d50>, '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': '836cfdc75598d54cb747368e000001a9-1464297284.619721-1106222388', '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 14:17: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 14:17: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 14:17:13 INFO - Using env: {'DISPLAY': ':0', 14:17:13 INFO - 'HOME': '/home/cltbld', 14:17:13 INFO - 'LANG': 'en_US.UTF-8', 14:17:13 INFO - 'LANGUAGE': 'en_US:en', 14:17:13 INFO - 'LOGNAME': 'cltbld', 14:17:13 INFO - 'MAIL': '/var/mail/cltbld', 14:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:13 INFO - 'MOZ_NO_REMOTE': '1', 14:17:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:13 INFO - 'NO_EM_RESTART': '1', 14:17:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:13 INFO - 'PWD': '/builds/slave/test', 14:17:13 INFO - 'SHELL': '/bin/bash', 14:17:13 INFO - 'SHLVL': '1', 14:17:13 INFO - 'TERM': 'linux', 14:17:13 INFO - 'TMOUT': '86400', 14:17:13 INFO - 'USER': 'cltbld', 14:17:13 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1464297284.619721-1106222388', 14:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:13 INFO - '_': '/tools/buildbot/bin/python'} 14:17:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:13 INFO - Downloading/unpacking blobuploader==1.2.4 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17:15 INFO - Downloading blobuploader-1.2.4.tar.gz 14:17:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:17:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:17:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:17:16 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 14:17:16 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 14:17:16 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 14:17:16 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 14:17:16 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 14:17:16 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 14:17:16 INFO - Downloading docopt-0.6.1.tar.gz 14:17:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:17:16 INFO - Installing collected packages: blobuploader, requests, docopt 14:17:16 INFO - Running setup.py install for blobuploader 14:17:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:17:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:17:16 INFO - Running setup.py install for requests 14:17:16 INFO - Running setup.py install for docopt 14:17:17 INFO - Successfully installed blobuploader requests docopt 14:17:17 INFO - Cleaning up... 14:17:17 INFO - Return code: 0 14:17:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:17:17 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')]} 14:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:17 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')]} 14:17:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:17 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 0x7f4a070d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1619770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a89c0>, '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 0x16a98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a9d50>, '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': '836cfdc75598d54cb747368e000001a9-1464297284.619721-1106222388', '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 14:17:17 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 14:17:17 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 14:17:17 INFO - Using env: {'DISPLAY': ':0', 14:17:17 INFO - 'HOME': '/home/cltbld', 14:17:17 INFO - 'LANG': 'en_US.UTF-8', 14:17:17 INFO - 'LANGUAGE': 'en_US:en', 14:17:17 INFO - 'LOGNAME': 'cltbld', 14:17:17 INFO - 'MAIL': '/var/mail/cltbld', 14:17:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:17 INFO - 'MOZ_NO_REMOTE': '1', 14:17:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:17 INFO - 'NO_EM_RESTART': '1', 14:17:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:17 INFO - 'PWD': '/builds/slave/test', 14:17:17 INFO - 'SHELL': '/bin/bash', 14:17:17 INFO - 'SHLVL': '1', 14:17:17 INFO - 'TERM': 'linux', 14:17:17 INFO - 'TMOUT': '86400', 14:17:17 INFO - 'USER': 'cltbld', 14:17:17 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1464297284.619721-1106222388', 14:17:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:17 INFO - '_': '/tools/buildbot/bin/python'} 14:17:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:17:17 INFO - Running setup.py (path:/tmp/pip-w8uIlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:17:17 INFO - Running setup.py (path:/tmp/pip-ClhgKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:17:17 INFO - Running setup.py (path:/tmp/pip-pZ0Nq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:17:17 INFO - Running setup.py (path:/tmp/pip-5QNWJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:17:17 INFO - Running setup.py (path:/tmp/pip-9Cwgj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:17:17 INFO - Running setup.py (path:/tmp/pip-F1h9Fw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:17:17 INFO - Running setup.py (path:/tmp/pip-dMqnVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:17:17 INFO - Running setup.py (path:/tmp/pip-9ZveY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:17:17 INFO - Running setup.py (path:/tmp/pip-xncvT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:17:17 INFO - Running setup.py (path:/tmp/pip-xGQuYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:17:17 INFO - Running setup.py (path:/tmp/pip-4z0P3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:17:18 INFO - Running setup.py (path:/tmp/pip-FYEEnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:17:18 INFO - Running setup.py (path:/tmp/pip-6aOE8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:17:18 INFO - Running setup.py (path:/tmp/pip-qusGCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:17:18 INFO - Running setup.py (path:/tmp/pip-VZ2mr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:17:18 INFO - Running setup.py (path:/tmp/pip-63Os7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:17:18 INFO - Running setup.py (path:/tmp/pip-ojlRrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:17:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:17:18 INFO - Running setup.py install for manifestparser 14:17:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:17:18 INFO - Running setup.py install for mozcrash 14:17:18 INFO - Running setup.py install for mozdebug 14:17:18 INFO - Running setup.py install for mozdevice 14:17:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:17:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:17:18 INFO - Running setup.py install for mozfile 14:17:19 INFO - Running setup.py install for mozhttpd 14:17:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:17:19 INFO - Running setup.py install for mozinfo 14:17:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:17:19 INFO - Running setup.py install for mozInstall 14:17:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:17:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:17:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:17:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:17:19 INFO - Running setup.py install for mozleak 14:17:19 INFO - Running setup.py install for mozlog 14:17:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:17:19 INFO - Running setup.py install for moznetwork 14:17:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:17:19 INFO - Running setup.py install for mozprocess 14:17:19 INFO - Running setup.py install for mozprofile 14:17:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:17:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:17:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:17:19 INFO - Running setup.py install for mozrunner 14:17:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:17:19 INFO - Running setup.py install for mozscreenshot 14:17:20 INFO - Running setup.py install for moztest 14:17:20 INFO - Running setup.py install for mozversion 14:17:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:17:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:17:20 INFO - Cleaning up... 14:17:20 INFO - Return code: 0 14:17:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:17:20 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')]} 14:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:20 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')]} 14:17:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:20 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 0x7f4a070d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1619770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a89c0>, '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 0x16a98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a9d50>, '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': '836cfdc75598d54cb747368e000001a9-1464297284.619721-1106222388', '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 14:17:20 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 14:17:20 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 14:17:20 INFO - Using env: {'DISPLAY': ':0', 14:17:20 INFO - 'HOME': '/home/cltbld', 14:17:20 INFO - 'LANG': 'en_US.UTF-8', 14:17:20 INFO - 'LANGUAGE': 'en_US:en', 14:17:20 INFO - 'LOGNAME': 'cltbld', 14:17:20 INFO - 'MAIL': '/var/mail/cltbld', 14:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:20 INFO - 'MOZ_NO_REMOTE': '1', 14:17:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:20 INFO - 'NO_EM_RESTART': '1', 14:17:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:20 INFO - 'PWD': '/builds/slave/test', 14:17:20 INFO - 'SHELL': '/bin/bash', 14:17:20 INFO - 'SHLVL': '1', 14:17:20 INFO - 'TERM': 'linux', 14:17:20 INFO - 'TMOUT': '86400', 14:17:20 INFO - 'USER': 'cltbld', 14:17:20 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1464297284.619721-1106222388', 14:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:20 INFO - '_': '/tools/buildbot/bin/python'} 14:17:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:17:20 INFO - Running setup.py (path:/tmp/pip-L9ToVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:17: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)) 14:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:17:20 INFO - Running setup.py (path:/tmp/pip-sl32mn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:17: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)) 14:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:17:20 INFO - Running setup.py (path:/tmp/pip-ULMNyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:17: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)) 14:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:17:20 INFO - Running setup.py (path:/tmp/pip-P_joPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:17: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)) 14:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:17:20 INFO - Running setup.py (path:/tmp/pip-jbh_na-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:17: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)) 14:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:17:20 INFO - Running setup.py (path:/tmp/pip-i0Nd36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:17: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)) 14:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:17:20 INFO - Running setup.py (path:/tmp/pip-SE4qwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:17: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)) 14:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:17:21 INFO - Running setup.py (path:/tmp/pip-GT8mrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:17:21 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)) 14:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:17:21 INFO - Running setup.py (path:/tmp/pip-1AbghP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:17:21 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)) 14:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:17:21 INFO - Running setup.py (path:/tmp/pip-26yJvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:17:21 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)) 14:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:17:21 INFO - Running setup.py (path:/tmp/pip-_FK89M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:17:21 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)) 14:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:17:21 INFO - Running setup.py (path:/tmp/pip-1vvCs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:17:21 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)) 14:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:17:21 INFO - Running setup.py (path:/tmp/pip-lhw30b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:17: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)) 14:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:17:21 INFO - Running setup.py (path:/tmp/pip-N_bQxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:17: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)) 14:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:17:21 INFO - Running setup.py (path:/tmp/pip-fSmiI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:17: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)) 14:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:17:21 INFO - Running setup.py (path:/tmp/pip-PreFZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:17: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)) 14:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:17:21 INFO - Running setup.py (path:/tmp/pip-nNUMpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:17: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)) 14:17: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)) 14:17: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)) 14:17: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)) 14:17: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)) 14:17: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)) 14:17:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17:23 INFO - Downloading blessings-1.6.tar.gz 14:17:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:17:23 INFO - Installing collected packages: blessings 14:17:23 INFO - Running setup.py install for blessings 14:17:23 INFO - Successfully installed blessings 14:17:23 INFO - Cleaning up... 14:17:23 INFO - Return code: 0 14:17:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:17:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:17:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:17:24 INFO - Reading from file tmpfile_stdout 14:17:24 INFO - Current package versions: 14:17:24 INFO - argparse == 1.2.1 14:17:24 INFO - blessings == 1.6 14:17:24 INFO - blobuploader == 1.2.4 14:17:24 INFO - docopt == 0.6.1 14:17:24 INFO - manifestparser == 1.1 14:17:24 INFO - mozInstall == 1.12 14:17:24 INFO - mozcrash == 0.17 14:17:24 INFO - mozdebug == 0.1 14:17:24 INFO - mozdevice == 0.48 14:17:24 INFO - mozfile == 1.2 14:17:24 INFO - mozhttpd == 0.7 14:17:24 INFO - mozinfo == 0.9 14:17:24 INFO - mozleak == 0.1 14:17:24 INFO - mozlog == 3.2 14:17:24 INFO - moznetwork == 0.27 14:17:24 INFO - mozprocess == 0.22 14:17:24 INFO - mozprofile == 0.28 14:17:24 INFO - mozrunner == 6.11 14:17:24 INFO - mozscreenshot == 0.1 14:17:24 INFO - mozsystemmonitor == 0.3 14:17:24 INFO - moztest == 0.7 14:17:24 INFO - mozversion == 1.4 14:17:24 INFO - psutil == 3.1.1 14:17:24 INFO - requests == 1.2.3 14:17:24 INFO - wsgiref == 0.1.2 14:17:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:17:24 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')]} 14:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:24 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')]} 14:17:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:24 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 0x7f4a070d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1619770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a89c0>, '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 0x16a98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a9d50>, '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': '836cfdc75598d54cb747368e000001a9-1464297284.619721-1106222388', '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 14:17:24 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 14:17:24 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 14:17:24 INFO - Using env: {'DISPLAY': ':0', 14:17:24 INFO - 'HOME': '/home/cltbld', 14:17:24 INFO - 'LANG': 'en_US.UTF-8', 14:17:24 INFO - 'LANGUAGE': 'en_US:en', 14:17:24 INFO - 'LOGNAME': 'cltbld', 14:17:24 INFO - 'MAIL': '/var/mail/cltbld', 14:17:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:24 INFO - 'MOZ_NO_REMOTE': '1', 14:17:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:24 INFO - 'NO_EM_RESTART': '1', 14:17:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:24 INFO - 'PWD': '/builds/slave/test', 14:17:24 INFO - 'SHELL': '/bin/bash', 14:17:24 INFO - 'SHLVL': '1', 14:17:24 INFO - 'TERM': 'linux', 14:17:24 INFO - 'TMOUT': '86400', 14:17:24 INFO - 'USER': 'cltbld', 14:17:24 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1464297284.619721-1106222388', 14:17:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:24 INFO - '_': '/tools/buildbot/bin/python'} 14:17:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:24 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)) 14:17:24 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)) 14:17:24 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)) 14:17:24 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)) 14:17:24 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)) 14:17:24 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)) 14:17:24 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)) 14:17:24 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)) 14:17:24 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)) 14:17:24 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)) 14:17:24 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)) 14:17:24 INFO - Cleaning up... 14:17:24 INFO - Return code: 0 14:17:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:17:24 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')]} 14:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:24 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')]} 14:17:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:24 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 0x7f4a070d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1619770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a89c0>, '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 0x16a98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a9d50>, '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': '836cfdc75598d54cb747368e000001a9-1464297284.619721-1106222388', '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 14:17:24 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 14:17:24 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 14:17:24 INFO - Using env: {'DISPLAY': ':0', 14:17:24 INFO - 'HOME': '/home/cltbld', 14:17:24 INFO - 'LANG': 'en_US.UTF-8', 14:17:24 INFO - 'LANGUAGE': 'en_US:en', 14:17:24 INFO - 'LOGNAME': 'cltbld', 14:17:24 INFO - 'MAIL': '/var/mail/cltbld', 14:17:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:24 INFO - 'MOZ_NO_REMOTE': '1', 14:17:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:24 INFO - 'NO_EM_RESTART': '1', 14:17:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:24 INFO - 'PWD': '/builds/slave/test', 14:17:24 INFO - 'SHELL': '/bin/bash', 14:17:24 INFO - 'SHLVL': '1', 14:17:24 INFO - 'TERM': 'linux', 14:17:24 INFO - 'TMOUT': '86400', 14:17:24 INFO - 'USER': 'cltbld', 14:17:24 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1464297284.619721-1106222388', 14:17:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:24 INFO - '_': '/tools/buildbot/bin/python'} 14:17:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:24 INFO - Downloading/unpacking jsonschema 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:17:26 INFO - Downloading/unpacking functools32 (from jsonschema) 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17:26 INFO - Downloading functools32-3.2.3-2.tar.gz 14:17:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:17:26 INFO - warning: no files found matching '*.txt' 14:17:26 INFO - no previously-included directories found matching 'build' 14:17:26 INFO - no previously-included directories found matching 'dist' 14:17:26 INFO - no previously-included directories found matching '.git*' 14:17:26 INFO - Installing collected packages: jsonschema, functools32 14:17:26 INFO - Running setup.py install for functools32 14:17:26 INFO - warning: no files found matching '*.txt' 14:17:26 INFO - no previously-included directories found matching 'build' 14:17:26 INFO - no previously-included directories found matching 'dist' 14:17:26 INFO - no previously-included directories found matching '.git*' 14:17:26 INFO - Successfully installed jsonschema functools32 14:17:26 INFO - Cleaning up... 14:17:26 INFO - Return code: 0 14:17:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:17: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')]} 14:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17: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')]} 14:17:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17: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 0x7f4a070d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1619770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a89c0>, '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 0x16a98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a9d50>, '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': '836cfdc75598d54cb747368e000001a9-1464297284.619721-1106222388', '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 14:17: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 14:17: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 14:17:26 INFO - Using env: {'DISPLAY': ':0', 14:17:26 INFO - 'HOME': '/home/cltbld', 14:17:26 INFO - 'LANG': 'en_US.UTF-8', 14:17:26 INFO - 'LANGUAGE': 'en_US:en', 14:17:26 INFO - 'LOGNAME': 'cltbld', 14:17:26 INFO - 'MAIL': '/var/mail/cltbld', 14:17:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:26 INFO - 'MOZ_NO_REMOTE': '1', 14:17:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:26 INFO - 'NO_EM_RESTART': '1', 14:17:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:26 INFO - 'PWD': '/builds/slave/test', 14:17:26 INFO - 'SHELL': '/bin/bash', 14:17:26 INFO - 'SHLVL': '1', 14:17:26 INFO - 'TERM': 'linux', 14:17:26 INFO - 'TMOUT': '86400', 14:17:26 INFO - 'USER': 'cltbld', 14:17:26 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1464297284.619721-1106222388', 14:17:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:26 INFO - '_': '/tools/buildbot/bin/python'} 14:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:27 INFO - Downloading/unpacking flake8 14:17:27 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 14:17:27 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 14:17:27 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 14:17:27 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 14:17:27 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 14:17:27 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 14:17:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:17:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:17:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:17:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:17:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:17:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:17:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:17:29 INFO - no previously-included directories found matching 'docs/_build' 14:17:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:17:29 INFO - Running setup.py install for pep8 14:17:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:17:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:17:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:17:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:17:29 INFO - no previously-included directories found matching 'docs/_build' 14:17:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:17:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:17:29 INFO - Cleaning up... 14:17:30 INFO - Return code: 0 14:17:30 INFO - Running post-action listener: _resource_record_post_action 14:17:30 INFO - Running post-action listener: _start_resource_monitoring 14:17:30 INFO - Starting resource monitoring. 14:17:30 INFO - ##### 14:17:30 INFO - ##### Finished create-virtualenv step (success) 14:17:30 INFO - ##### 14:17:30 INFO - ##### 14:17:30 INFO - ##### Running install step. 14:17:30 INFO - ##### 14:17:30 INFO - Running pre-action listener: _resource_record_pre_action 14:17:30 INFO - Running main action method: install 14:17:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:17:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:17:30 INFO - Reading from file tmpfile_stdout 14:17:30 INFO - Detecting whether we're running mozinstall >=1.0... 14:17:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:17:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:17:30 INFO - Reading from file tmpfile_stdout 14:17:30 INFO - Output received: 14:17:30 INFO - Usage: mozinstall [options] installer 14:17:30 INFO - Options: 14:17:30 INFO - -h, --help show this help message and exit 14:17:30 INFO - -d DEST, --destination=DEST 14:17:30 INFO - Directory to install application into. [default: 14:17:30 INFO - "/builds/slave/test"] 14:17:30 INFO - --app=APP Application being installed. [default: firefox] 14:17:30 INFO - mkdir: /builds/slave/test/build/application 14:17:30 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'] 14:17:30 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 14:17:47 INFO - Reading from file tmpfile_stdout 14:17:47 INFO - Output received: 14:17:47 INFO - /builds/slave/test/build/application/firefox/firefox 14:17:47 INFO - Running post-action listener: _resource_record_post_action 14:17:47 INFO - ##### 14:17:47 INFO - ##### Finished install step (success) 14:17:47 INFO - ##### 14:17:47 INFO - ##### 14:17:47 INFO - ##### Running run-tests step. 14:17:47 INFO - ##### 14:17:47 INFO - Running pre-action listener: _resource_record_pre_action 14:17:47 INFO - Running main action method: run_tests 14:17:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:17:47 INFO - Python 2.7.3 14:17:47 INFO - Return code: 0 14:17:47 INFO - grabbing minidump binary from tooltool 14:17:47 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')]} 14:17:47 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 0x16a89c0>, '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 0x16a98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a9d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:17:47 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 14:17:47 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 14:17:47 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 14:17:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:17:47 INFO - Return code: 0 14:17:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:17:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:17:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:17:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:17:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:17:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:17:48 INFO - Return code: 0 14:17:48 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/IcNAXxo9SI2y_FlMmLjxYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 14:17:48 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/IcNAXxo9SI2y_FlMmLjxYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 14:17:48 INFO - Using env: {'DISPLAY': ':0', 14:17:48 INFO - 'HOME': '/home/cltbld', 14:17:48 INFO - 'LANG': 'en_US.UTF-8', 14:17:48 INFO - 'LANGUAGE': 'en_US:en', 14:17:48 INFO - 'LOGNAME': 'cltbld', 14:17:48 INFO - 'MAIL': '/var/mail/cltbld', 14:17:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:17:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:48 INFO - 'MOZ_NO_REMOTE': '1', 14:17:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:17:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:48 INFO - 'NO_EM_RESTART': '1', 14:17:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:48 INFO - 'PWD': '/builds/slave/test', 14:17:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:17:48 INFO - 'SHELL': '/bin/bash', 14:17:48 INFO - 'SHLVL': '1', 14:17:48 INFO - 'TERM': 'linux', 14:17:48 INFO - 'TMOUT': '86400', 14:17:48 INFO - 'USER': 'cltbld', 14:17:48 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1464297284.619721-1106222388', 14:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:48 INFO - '_': '/tools/buildbot/bin/python'} 14:17:48 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/IcNAXxo9SI2y_FlMmLjxYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 14:17:48 INFO - mozversion application_buildid: 20160526113032 14:17:48 INFO - mozversion application_changeset: 7b2fc29e5d9db05f171dea679a3e5d50f8a9e2d6 14:17:48 INFO - mozversion application_display_name: Nightly 14:17:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:17:48 INFO - mozversion application_name: Firefox 14:17:48 INFO - mozversion application_remotingname: firefox 14:17:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:17:48 INFO - mozversion application_vendor: Mozilla 14:17:48 INFO - mozversion application_version: 49.0a1 14:17:48 INFO - mozversion platform_buildid: 20160526113032 14:17:48 INFO - mozversion platform_changeset: 7b2fc29e5d9db05f171dea679a3e5d50f8a9e2d6 14:17:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:17:48 INFO - mozversion platform_version: 49.0a1 14:17:48 INFO - using testdate: 1464297468 14:17:48 INFO - actual date: 1464297468 14:17:48 INFO - starting webserver on 'localhost:39644' 14:17:48 INFO - SUITE-START | Running 2 tests 14:17:48 INFO - TEST-START | dromaeo_css 14:17:48 INFO - operating with platform_type : linux_ 14:17:48 INFO - Initialising browser for dromaeo_css test... 14:17:48 INFO - TEST-INFO | started process 6719 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbOBgp0/profile http://localhost:39644/getInfo.html) 14:17:52 INFO - PROCESS | 6719 | __metrics Screen width/height:1600/1200 14:17:52 INFO - PROCESS | 6719 | colorDepth:24 14:17:52 INFO - PROCESS | 6719 | Browser inner width/height: 1024/697 14:17:52 INFO - PROCESS | 6719 | __metrics 14:17:53 ERROR - PROCESS | 6719 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:17:54 INFO - TEST-INFO | 6719: exit 0 14:17:54 INFO - Browser initialized. 14:17:54 INFO - Running cycle 1/1 for dromaeo_css test... 14:17:54 INFO - TEST-INFO | started process 6799 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbOBgp0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:18:06 INFO - PROCESS | 6799 | RSS: Main: 155009024 14:18:06 INFO - PROCESS | 6799 | 14:18:57 INFO - PROCESS | 6799 | 1464297537165 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] 14:21:05 INFO - PROCESS | 6799 | Cycle 1(1): loaded http://localhost:39644/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39644/tests/dromaeo/cssquery-ext.html) 14:21:06 INFO - PROCESS | 6799 | RSS: Main: 254087168 14:21:06 INFO - PROCESS | 6799 | 14:24:08 INFO - PROCESS | 6799 | Cycle 1(1): loaded http://localhost:39644/tests/dromaeo/cssquery-ext.html (next: http://localhost:39644/tests/dromaeo/cssquery-jquery.html) 14:24:09 INFO - PROCESS | 6799 | RSS: Main: 240349184 14:24:09 INFO - PROCESS | 6799 | 14:27:11 INFO - PROCESS | 6799 | Cycle 1(1): loaded http://localhost:39644/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39644/tests/dromaeo/cssquery-mootools.html) 14:27:12 INFO - PROCESS | 6799 | RSS: Main: 246358016 14:27:12 INFO - PROCESS | 6799 | 14:30:14 INFO - PROCESS | 6799 | Cycle 1(1): loaded http://localhost:39644/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39644/tests/dromaeo/cssquery-prototype.html) 14:30:14 INFO - PROCESS | 6799 | RSS: Main: 240070656 14:30:14 INFO - PROCESS | 6799 | 14:33:17 INFO - PROCESS | 6799 | Cycle 1(1): loaded http://localhost:39644/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39644/tests/dromaeo/cssquery-yui.html) 14:33:17 INFO - PROCESS | 6799 | RSS: Main: 200212480 14:33:17 INFO - PROCESS | 6799 | 14:36:20 INFO - PROCESS | 6799 | Cycle 1(1): loaded http://localhost:39644/tests/dromaeo/cssquery-yui.html (next: http://localhost:39644/tests/dromaeo/cssquery-dojo.html) 14:36:20 INFO - PROCESS | 6799 | RSS: Main: 304144384 14:36:20 INFO - PROCESS | 6799 | 14:36:20 INFO - PROCESS | 6799 | __start_tp_report 14:36:20 INFO - PROCESS | 6799 | _x_x_mozilla_page_load 14:36:20 INFO - PROCESS | 6799 | _x_x_mozilla_page_load_details 14:36:20 INFO - PROCESS | 6799 | |i|pagename|runs| 14:36:20 INFO - PROCESS | 6799 | |0;dojo.html;3133.8589763460627;3137.5293705944114;3163.066895265896;3174.587303650528;3198.6161660600733;5298.23175639532;5308;5366.4633536646415;5396;5397.514223719864;5302.390225124112;5321.866953326169;5348.705821179843;5358.973205133979;5364.678119312844;4745.383100196969;4758.952410475894;4879.463259041502;4919.483454237307;4945.060438516671;4828.155072862252;4913.26301054841;4942.01159768046;4955.612428520002;4964.230544265644;4776.092542416947;4836.46798852126;4843.200871856175;4894.559489645949;4911.607071434312;4868.2210846264425;4880.951190488086;4884.120858245515;4916.729579873106;4923.679960802537;4726.550977657152;4818.7831547580445;4854.466008739071;4867.902641947177;4895.11887860185;5325.467453254682;5383.488568585978;5404.297441332641;5432.13085906257;5432.891342173174;5838.970805145989;5878.235829342201;5880.8235752927485;5883.911741323884;5884.735186916556;5676.517496012844;5729.255196824428;5772.7113644317615;5777.942220577783;5813.6802475863815;5450.4549545045575;5472.972635136839;5478.835634930959;5479.232907392969;5489.231507588941;5967.254093238345;5967.761289548456;5976.940230597638;5980.372060933626;5986.4013598639785;5513.062779327524;5615.494605485526;5675.829725108253;5680.744366503517;5725.914111288334;5776.913346299725;5802.187693722883;5839.357670656224;5848.912266316009;5869.178315035813;5703.600747947687;5752.482276595127;5781.797637082682;5782.074868021096;5785.797497087582;5572.4706152915405;5691.089425691869;5749.137629355547;5772.2207501986695;5805.187273781674;4407.27279998803;4409.955900440955;4414.690971631955;4423.955760442419;4450.977745111254;3858.7491813032625;3930.272899513542;3933.2330195612153;3960.3663413853646;3991.022199561068;5437.048516509595;5475.342958844964;5518.91721624176;5524.364698059774;5549.611527193058;5794.565407594448;5815.79644712433;5823.88352232953;5842.240508733922;5892.027815410409;5368.651037682538;5519.779208831682;5535.280413546213;5542.334919809568;5558.6942718150085;4977.352944117241;5045.84862454127;5055.140626093573;5059.443461219263;5066.138756411419;6032.909506357408;6044.455998960115;6044.486218671462;6047.0929360596265;6048.183495228176;5649.576281778801;5735.0537161369575;5836.503897168788;5837.737301821513;5849.970750146222;5990.6705131218205;6037.75848966054;6083.756649733961;6085.4523092921845;6086.178365920544;5709.286339207599;5714.885702285847;5734.856628584152;5759.740811663569;5770.163326317745;5719.28508936383;5832.562557808266;5855;5859.707014649336;5860.824175274749;5673.120666296731;5729.713514324184;5739.426057394227;5753.626014309057;5767.106098554731;5709.51469125129;5719.971400142973;5721.342045664802;5725.141228815544;5729.28383952006;5482.725863706878;5495.752691128829;5612.747426365905;5623.88752224945;5633.549316054788;5643.3792282848035;5730.054541000855;5743.282089738783;5747.971260143672;5748.45389687979;5529.972350138384;5560.36055853582;5582.49757521825;5588.888222235451;5622.803201887914 14:36:20 INFO - PROCESS | 6799 | |1;ext.html;578.661483032426;625.9593126446782;627;627.1564745417412;629.7827249598888;33583.66416335836;36339.81830090849;43633.563664363384;44468.77765611168;44587;46020;46492.53507464924;46546;46644.76677616616;46765.298520522134;8702.086280940504;8884.555772211395;8895.644174233055;8897.911020889806;8898.644054237822;8718.651253949834;8797.428167169146;8799.868001979976;8852.690155844546;8854.822903541957;8830.293576513895;8921;8922.375433719642;8934.86597701035;8936.910630893673;8830.514321712304;8881.156290152425;8884.511351875644;8885.511296878669;8893.199612034883;8677.132286771335;8710.085441028665;8719.869201961976;8756.387052906299;8812.69155579558;41767.37348939738;42178;42296.15407691829;42436;42446.15107697829;3534.3461459629793;3634.1096431374217;3722.7021838252876;3725.18046029873;4006.2679029473106;32129.51805722916;32253.51619725706;32708.672913270802;32790;33440.49839252413;4247.256730072225;4258.212230737293;4274.187904298174;4301.376300436419;4432.933505997413;340111;340391.9999999975;340552;341631;342316;34170;34948.825255874064;58407;59108.70445647744;59225.703871480364;36319;36370.45444318337;36476.27047459089;36491.27017459636;36544.81727591345;15760.76358854618;15888.126153061461;15898.364065437485;15900.52298431049;15909.204539772965;13185.077044606785;13192.20846749198;13218.867811321956;13224.074314798065;13249;8280.461769984931;8293.129221431784;8298.709545166012;8345.706415505607;8366.498010119412;3231.8545665445113;3232.191952011997;3244.6917542833394;3259.7392208623255;3291.555639988571;1007.1590222164575;1052.6736711619421;1105.6738262212666;1119.630521927778;1139.0602752729033;32117.35765284681;32629.836850816067;33004.50493242603;33023.339533209684;33206.66793332084;1060.0459586372326;1127.4926283172442;1154.8902854228834;1159.3623507071077;1193.4604360375192;17084;17325.2203650836;17328;17461.912690436468;17517.562060948578;531637;543218;548583;549873;551848;57539;57974.42025579775;57997;58040.4195958035;58177;1245.7508498300376;1286.6654669785923;1353.9796903046658;1372.1561239837429;1373.25844044217;30280.242993925327;33876.83061584676;33933;33988.660113398546;34334.82832585821;49640.503594965034;50192;50201.74899125481;50218.49781502138;50234.497655022984;316091;319857;320966;321660;322714;25996.61005084963;27321.863390683713;27587.31031724223;27998.160055198376;28170.2957426066;47510.52489475061;47787.522124779694;48024.82538455106;48058.75970620265;48543.271850921556;40596.1880762389;41072.38391424191;41991.16017679568;44369.10216380141;45095.77452112718;41638.791806040776;41714.80844378632;42155.3676694856;42272.15455690931;42496.15007699891;40862.38706419346;41026.92298077596;41239.587604123575;42166.15667686691;42318;36916.446253306756;37185.814070929475;37419.714607211106;38132;38205.23589528138;28656.713432865403;28684.569731454463;28713;28940.56589151122;28963 14:36:20 INFO - PROCESS | 6799 | |2;jquery.html;387.02662803050316;389.2060197197717;398.2930298719772;403.9858604948827;409.9528554216266;14390.496332628334;16694.499165025038;18193.272269109235;18960.241590336387;19041.809581904177;18549.90725046373;18675.066246687646;19010.954397508132;19148;19252.42242732717;5564.221009058725;5765.596408251424;5772.163036359725;5775.191473193756;5784.884302313952;4195.727277726954;5613.270274864262;5679.233303504016;6005.819825405223;6356.904646430307;6394.744210231585;6430.421262086411;6434.806955791334;6438.291787903327;6446.645434501101;6175.475084617813;6364;6373.075903993941;6374.426301632829;6402.359764023584;5382.085045542267;5561.610687251894;5586.888262234733;5587.776488940438;5603.215549823028;22360.10559577615;22875.428114297276;23080.076796928104;23128.76871231283;23134.652980205312;2385.976140238593;2593.9235217384953;2707.512647723409;2825.27955371379;3123.453395655751;13942.442302307896;14016.859831401658;14213.644658883508;14931.25343732809;14955.177465239407;1991.0841013133975;1999.4304470990203;2033.176563491788;2040.540878302385;2068.7620923593827;49705.25442118371;50024.49975500235;55684.75066009059;58807.411925880624;58938.705306473625;9366.812663746687;10187.592496300065;10335.069843714102;10929.781404371868;11081.612143574936;15099.924500377429;15178.696426071638;15316.770248446282;15328.386864525293;15338.616534586725;8414.915850841535;8453.957730211432;8457.323414126979;8550.957245213734;8607.741767746978;8174.67301307941;8183.624801271789;8316.257684042204;8324.25081742646;8455.577221138918;4578.5650363215445;4735.934414756721;4737.194676904935;4747.074320507468;4769.976150119227;1890.1966664167674;1890.7258447525032;1932.748742663473;1990.910409031597;1998.450426132796;974.6052848596188;987.9061489158519;998.4658207858906;1006.7332156978407;1034.1571619130384;18506.167222475022;18676.43970680882;18946.905265473586;18979.43061708151;19271.325503607306;959.8385952996813;964.9758756031156;1018.5060245780791;1041.7603951091291;1080.5407701726735;10529.631462898762;10640.148788096934;10759.408232547285;10800.729981750519;10855.185861060294;469923;475663;482919;483325;488165;61866.38133618606;85442.57278713692;91358;91574.54212729027;101532.49233753784;828.4076885027234;853.8206976534997;855.9614817333235;886.9467831930104;935.2704890185666;17275.481735547954;17472.82527174712;17708.203130858885;17715;17892;40892.97767555835;41637;41774.37338439865;42414.57585424106;44386.334204986306;57382.13926791018;57912;59984;60483;61103;8240.83518329618;8506.447080939719;8533.487990720576;8597.355198360023;8616.35377346689;9361.531923403938;12909.031822613153;13162;13267.734645307233;13281;11614.477348519506;11678.182527223013;11847.644570662895;12070.637880863587;12350.876491234972;11401.543938242377;11549.711257218301;11706.88293117092;11787.351695656822;11848.940755296167;11682.12384071181;11908.642740717793;12089.33508656997;12102.636920892388;12214.816777748163;8359.874601881098;8531.952331440285;8541.95729021351;8701.17338852808;8834.734957951272;8892.28861691076;10895.400752958663;11691.415429228335;11742.884425979519;11849.111316651459 14:36:20 INFO - PROCESS | 6799 | |3;mootools.html;1354.092757852239;1510.509084547522;1530.3113598880502;1656.7100757367466;1804.5578833185864;8749.21257086862;9108.681196158128;9141.085891410856;9355.438673679584;9357.298202634813;9041.367104302684;9238.86141707875;9249.95375023124;9254.6298148074;9258.444493330406;2096.4549217203485;2164.3398763377163;2168.620491414004;2404.675368825208;2438.5488684593406;2380.571497130516;2458.0659349447187;2469.6172093325563;2482.515909397668;2485.2420011896365;2401.1215176281034;2419.552382809186;2425.6361545768186;2443.486867757773;2445.7798798108165;2091.435312465626;2341.7120583678907;2379.6311571706415;2409.927702168929;2415.1546958564536;2415.347856078849;2446.8164887633498;2449.0326321103066;2449.106076282162;2452.865092419916;8938.597763100675;8966.68616598416;8998.59506322217;8999;9004.369694121415;5321.122014867542;5445.591580631469;5449.727513624303;5453.645513041679;5456.372517160498;3344.7658663893535;3369.2587630721446;3583.301256255031;3598.8200589970397;3600.4419315006216;1075.5858994287178;1080.7568297133162;1085.2945585369494;1105.8783533811275;1182.4383417876527;12896.161749486253;12904.096713230172;12914.935425322814;12921.741565168739;12936.417861196174;4739.905201895943;4925.103835023542;4993.925091123563;4997.325361076281;5124.5131712487255;10812.189085818594;10814.243002989873;10868.836967445495;10886.72783180411;10896.509657065451;5533.916991245134;5546.195801608744;5548.778048878;5566.526845218121;5571.220029195916;4452.198604251266;4842.176829938919;4980.05378977993;5022.497750225021;5147.510986456281;4068.7965601719798;4068.8372465101065;4118.794060296973;4209.7474151551005;4212.957870421318;1311.9832130099248;1348.7032852772375;1357.6537982814318;1362.843273023615;1378.7457506976166;859.8280343931239;983.8622592837008;989.4904124375952;1023.4371095897227;1025.21474092546;6325.367463253638;6378.553501254868;6471.611703297817;6549.24683661385;6550.0829883816305;465.2137886971008;471.8513668194508;472.2514814019817;475.8881662809237;478.4163320748681;4378.343248512685;4419.0940857124215;4444.155610434007;4509.34614480905;4540.704854184468;11209.719757005976;11549.88450115505;11591.826122608;11617.477213525412;11618.88381116195;10844;11319.717007074889;11324.037456816262;11579.826302605468;11592.826107608393;8348;8434.313137372428;8561.743147705578;8648.827023459622;8661.956690216508;6277.591956522994;6289.40250676185;6306.117143599991;6444.065610486547;6474.70863811139;10349.74125646865;10561.313514621525;10567.260291779501;10597.62908298206;10638.308509946828;10826;10848.728781780519;10886.67339979802;10970.286931349438;10971.615993440191;8151.83696326082;8249.091790384711;8301;8383.95808020956;8404.243618074403;8797;8905.287576993695;8919.197272245528;8920.509371984603;8928.73213803587;7847.332976697045;8066.314363278952;8241.052278987754;8242.052164001216;8366.288865446506;7813.609319533887;7913.327367173854;7952.284294413299;7954.323882470055;7968.561729104955;7151.642417878981;7211.819704507429;7255.419566434778;7387.593682347522;7400.814979625552;5290.65610735301;5344.5991550634635;5395.514403703685;5460.535854452416;5461.481159289861;5476.945230547803;5492.1778827702765;5546.639468434539;5670.546356291569;5707.714614269187 14:36:20 INFO - PROCESS | 6799 | |4;prototype.html;297.6576936522998;311.7692907248636;314.84100529232734;317.9809211447313;317.99682003179976;5184.8703782405455;5272.077386457374;5388.703621300831;5399.298091248142;5431.321084864392;5290.841274761763;5315.521603055724;5319.734013299339;5322.201669749539;5326.493983071602;4115.629593336599;4127.587241275864;4127.731697439672;4129.4012368206595;4136;3867.1878905429753;3885.9805700971456;4055.9797201013953;4108.342665173573;4133.793310334487;4039.3738970459626;4050.4936882889638;4060.5127384713874;4062.9796851015853;4075.673946084321;4052.4398106728972;4058.4115303281005;4066.2883995300704;4071.75569465833;4078.7960601969785;3493.283876805249;3569.464580312974;3577.3918433866306;3594.6405359463843;3606.747527673064;5059;5062.265971434122;5073.923891141636;5094.388673359221;5113;4662.7668616569035;4666.903277729731;4677.321788340671;4677.4854765975715;4693.929591056137;5294.987904596267;5549.5005449509335;5552.194931734876;5562.3047119110115;5580.441955804387;3954.7033972451895;3967.107400834818;3977.6420122189143;3980.3034468967817;3989.6409323161056;5758.510526605243;5761.308642962829;5771.740271687742;5771.769129234825;5782.7686892523825;4071.6156506787834;4072.552019277877;4078.1435898461064;4086.836526538965;4090.754554726726;3814.504114465102;4006.8397264109694;4017.9397309040387;4018.1963607278076;4029.798510074543;4615.930761038587;4635.351050852883;4641.535846415399;4642.907141857144;4646.512116227815;5566.165075238666;5567.415421380778;5593.944060559424;5596.4403559644525;5611.9438805612235;1283.1787655900232;1295.8768916952874;1379.9586012419643;1387.458891032498;1391.8051472793818;862.9309655227567;880.300161371711;894.342658146262;897.8069715011304;904.8280826642916;4848.733319667452;4873.31773551703;4896.779644915988;4905;4941.308216849644;4985.351904252424;5015;5043.394792624908;5127.846164615067;5129.9743501283;4554.027369468164;4759.762461759968;4766.713997160182;4822.324874517571;4883.804647814119;2653.601959706021;2662.988064535464;2664.4804263168885;2680.3701130234767;2681.1554360376417;5201.973990130025;5226.294450249244;5229.398619158769;5239;5244.816431424882;4869.488703686062;5141.460146684619;5168.7415629218385;5179.48205179479;5179.533841954242;5224.6342756008235;5242.370915490165;5272.367315922037;5291.814786482455;5292.470752924677;5043.2939388486375;5070.518300761421;5078.720670363018;5096.796128154832;5111.131107711623;4770.880727981828;4961.454240033666;4999.300097986357;5054.2923990642075;5069.645124841226;5148.764296568871;5206.843794686166;5236.266922630911;5236.528712415901;5253.632245742914;3597.514335564665;3651.356889399834;3655.7258205635217;3669.7798132112157;3764.7364684471822;5561.860953476195;5724.141378793214;5762.24251603265;5762.8847423050465;5792.333881603501;5554.972225138848;5570.749316280696;5614.326280846324;5620.667423019565;5651.915221271766;5343.744220108194;5519.2824932758485;5565.415631358811;5633.155026746021;5645.294338207724;5531.617095726068;5532.944670553243;5538.224648549126;5552.5280351168985;5572.3034620672415;5609.681724794752;5642.915356269741;5645.520130788929;5650.316099852537;5689.374168841507;5276.60170054928;5520.91718624229;5554.833354999357;5564.19319198722;5564.721763911707 14:36:20 INFO - PROCESS | 6799 | |5;yui.html;818.3862103422432;843.6119385082861;844.3414136973163;846.7586737779731;849.6856163219605;15171.241437928114;15981.680366392666;15982.84017159828;16000.439984600542;16005.519834404957;14296.92851535741;14325.856741432583;14328;14333.641658958531;14334.928325358385;669.1969636436272;781.1641543548377;807.7132617920641;808.6280311056921;810.1372038778711;806.2743530822278;810.9878351824727;812.1513018895268;813.4712436916022;814.7881550796776;714.118064190724;857.8412993596205;858.1504310732362;858.5449711652834;859.4456575508793;728.0135416510605;729.3727394440776;824.3240542754974;854.5513605357175;856.6873091321685;621.1118101115403;625.5683578330937;626.0577830365316;626.0859145647361;626.5363630913091;14450.783238251435;14453.349599267953;14467.059641123398;14489.42042318306;14504.70990580193;13648.590542283748;14115.576532704035;14270.714585708332;14306.070105443114;14335.78496322556;12128.332941688204;12326.568570100004;12342.938285308606;12369.257844529267;12632.11575189737;4404.471463424377;4422.181896349186;4429.092036132617;4500.212462819027;4511.977440112779;57923.42076579222;58013;58528.99999999957;59061;59064.40935590632;10665.626703065356;10807.62155971261;10818.350898946088;10898.128149748001;11029.83455248172;20255.59488810245;20470.59058818815;20484.79515204829;20513.794862051487;20515.79484205139;8372.748817535483;8548.615312310962;8599.39804213699;8750.03749587545;8810.118988101138;4721.409823772028;4741.834035808799;4799.832005879847;4847.587955023862;4964.801407943714;3423.281110966725;3513.5432393789156;3530.135116896377;3540.681338679531;3540.9822950885596;640.6572483721187;652.3509108437136;659.0674196012588;659.3143131143653;681.6353251010686;625.8404106952698;634.314939864954;697.870893884633;735.9558426494427;757.5379018798528;10100.292979491513;10190;10219.948900255451;10349.482525873676;10357.9482102589;639.7696829141505;672.8519725660346;734.1263895963785;737.8081698758361;743.6393349225622;4713.151632706145;4777.880552986134;4827;4836.854894353175;4851.684640498356;67349.66325168342;67819.98270025855;68868.6556567224;68960.65519672369;71636;63154;63175;63381.68309158517;64584.35415645783;64966.67516662481;53722.99999999922;56684;56741.43258567444;56938;57990.130148047814;9588.616455341988;10315.432651203955;10376.948115259376;10438.37369757817;10456.581736730446;36781;37300.62699372972;38385;38561;38684.6131538681;46811;51004;51749.48250517446;53409.198862017874;53929.19106213489;13015.674608134872;13018.739625207254;13176.341182941007;13214.735705285648;13255.469781209029;13795.754921884116;14264;14408.495702650356;14710.485133020293;15281.08313501149;12659.81010284828;13552.322383880964;13583.52457663977;14236.715265694835;14239;13485.932570337478;13486.05597608158;13507.257100859548;13539.59381218565;13807.86192138106;13430.529931452353;13793.86206137966;13932;14116.647083822576;14555.345009474811;11532.481038353126;11582.768344633228;11657.262695361194;11922.105842062054;11930.701732456411;11673.824892626788;11805.881941180478;12038.699032524257;12093.395330233629;12098.334591597546 14:36:20 INFO - PROCESS | 6799 | __end_tp_report 14:36:20 INFO - PROCESS | 6799 | __start_cc_report 14:36:20 INFO - PROCESS | 6799 | _x_x_mozilla_cycle_collect,816 14:36:20 INFO - PROCESS | 6799 | __end_cc_report 14:36:20 INFO - PROCESS | 6799 | __startTimestamp1464298580735__endTimestamp 14:36:20 INFO - PROCESS | 6799 | 14:36:20 INFO - PROCESS | 6799 | ------- Summary: start ------- 14:36:20 INFO - PROCESS | 6799 | Number of tests: 6 14:36:20 INFO - PROCESS | 6799 | 14:36:20 INFO - PROCESS | 6799 | [#0] dojo.html Cycles:165 Average:5382.74 Median:5588.89 stddev:623.46 (11.2%) stddev-sans-first:599.90 14:36:20 INFO - PROCESS | 6799 | Values: 3133.9 3137.5 3163.1 3174.6 3198.6 5298.2 5308.0 5366.5 5396.0 5397.5 5302.4 5321.9 5348.7 5359.0 5364.7 4745.4 4759.0 4879.5 4919.5 4945.1 4828.2 4913.3 4942.0 4955.6 4964.2 4776.1 4836.5 4843.2 4894.6 4911.6 4868.2 4881.0 4884.1 4916.7 4923.7 4726.6 4818.8 4854.5 4867.9 4895.1 5325.5 5383.5 5404.3 5432.1 5432.9 5839.0 5878.2 5880.8 5883.9 5884.7 5676.5 5729.3 5772.7 5777.9 5813.7 5450.5 5473.0 5478.8 5479.2 5489.2 5967.3 5967.8 5976.9 5980.4 5986.4 5513.1 5615.5 5675.8 5680.7 5725.9 5776.9 5802.2 5839.4 5848.9 5869.2 5703.6 5752.5 5781.8 5782.1 5785.8 5572.5 5691.1 5749.1 5772.2 5805.2 4407.3 4410.0 4414.7 4424.0 4451.0 3858.7 3930.3 3933.2 3960.4 3991.0 5437.0 5475.3 5518.9 5524.4 5549.6 5794.6 5815.8 5823.9 5842.2 5892.0 5368.7 5519.8 5535.3 5542.3 5558.7 4977.4 5045.8 5055.1 5059.4 5066.1 6032.9 6044.5 6044.5 6047.1 6048.2 5649.6 5735.1 5836.5 5837.7 5850.0 5990.7 6037.8 6083.8 6085.5 6086.2 5709.3 5714.9 5734.9 5759.7 5770.2 5719.3 5832.6 5855.0 5859.7 5860.8 5673.1 5729.7 5739.4 5753.6 5767.1 5709.5 5720.0 5721.3 5725.1 5729.3 5482.7 5495.8 5612.7 5623.9 5633.5 5643.4 5730.1 5743.3 5748.0 5748.5 5530.0 5560.4 5582.5 5588.9 5622.8 14:36:20 INFO - PROCESS | 6799 | 14:36:20 INFO - PROCESS | 6799 | [#1] ext.html Cycles:180 Average:55840.79 Median:40944.66 stddev:110125.69 (269.0%) stddev-sans-first:110356.46 14:36:20 INFO - PROCESS | 6799 | Values: 578.7 626.0 627.0 627.2 629.8 33583.7 36339.8 43633.6 44468.8 44587.0 46020.0 46492.5 46546.0 46644.8 46765.3 8702.1 8884.6 8895.6 8897.9 8898.6 8718.7 8797.4 8799.9 8852.7 8854.8 8830.3 8921.0 8922.4 8934.9 8936.9 8830.5 8881.2 8884.5 8885.5 8893.2 8677.1 8710.1 8719.9 8756.4 8812.7 41767.4 42178.0 42296.2 42436.0 42446.2 3534.3 3634.1 3722.7 3725.2 4006.3 32129.5 32253.5 32708.7 32790.0 33440.5 4247.3 4258.2 4274.2 4301.4 4432.9 340111.0 340392.0 340552.0 341631.0 342316.0 34170.0 34948.8 58407.0 59108.7 59225.7 36319.0 36370.5 36476.3 36491.3 36544.8 15760.8 15888.1 15898.4 15900.5 15909.2 13185.1 13192.2 13218.9 13224.1 13249.0 8280.5 8293.1 8298.7 8345.7 8366.5 3231.9 3232.2 3244.7 3259.7 3291.6 1007.2 1052.7 1105.7 1119.6 1139.1 32117.4 32629.8 33004.5 33023.3 33206.7 1060.0 1127.5 1154.9 1159.4 1193.5 17084.0 17325.2 17328.0 17461.9 17517.6 531637.0 543218.0 548583.0 549873.0 551848.0 57539.0 57974.4 57997.0 58040.4 58177.0 1245.8 1286.7 1354.0 1372.2 1373.3 30280.2 33876.8 33933.0 33988.7 34334.8 49640.5 50192.0 50201.7 50218.5 50234.5 316091.0 319857.0 320966.0 321660.0 322714.0 25996.6 27321.9 27587.3 27998.2 28170.3 47510.5 47787.5 48024.8 48058.8 48543.3 40596.2 41072.4 41991.2 44369.1 45095.8 41638.8 41714.8 42155.4 42272.2 42496.2 40862.4 41026.9 41239.6 42166.2 42318.0 36916.4 37185.8 37419.7 38132.0 38205.2 28656.7 28684.6 28713.0 28940.6 28963.0 14:36:20 INFO - PROCESS | 6799 | 14:36:20 INFO - PROCESS | 6799 | [#2] jquery.html Cycles:180 Average:27952.68 Median:401.14 stddev:78744.38 (19630.2%) stddev-sans-first:78938.07 14:36:20 INFO - PROCESS | 6799 | Values: 387.0 389.2 398.3 404.0 410.0 14390.5 16694.5 18193.3 18960.2 19041.8 18549.9 18675.1 19011.0 19148.0 19252.4 5564.2 5765.6 5772.2 5775.2 5784.9 4195.7 5613.3 5679.2 6005.8 6356.9 6394.7 6430.4 6434.8 6438.3 6446.6 6175.5 6364.0 6373.1 6374.4 6402.4 5382.1 5561.6 5586.9 5587.8 5603.2 22360.1 22875.4 23080.1 23128.8 23134.7 2386.0 2593.9 2707.5 2825.3 3123.5 13942.4 14016.9 14213.6 14931.3 14955.2 1991.1 1999.4 2033.2 2040.5 2068.8 49705.3 50024.5 55684.8 58807.4 58938.7 9366.8 10187.6 10335.1 10929.8 11081.6 15099.9 15178.7 15316.8 15328.4 15338.6 8414.9 8454.0 8457.3 8551.0 8607.7 8174.7 8183.6 8316.3 8324.3 8455.6 4578.6 4735.9 4737.2 4747.1 4770.0 1890.2 1890.7 1932.7 1990.9 1998.5 974.6 987.9 998.5 1006.7 1034.2 18506.2 18676.4 18946.9 18979.4 19271.3 959.8 965.0 1018.5 1041.8 1080.5 10529.6 10640.1 10759.4 10800.7 10855.2 469923.0 475663.0 482919.0 483325.0 488165.0 61866.4 85442.6 91358.0 91574.5 101532.5 828.4 853.8 856.0 886.9 935.3 17275.5 17472.8 17708.2 17715.0 17892.0 40893.0 41637.0 41774.4 42414.6 44386.3 57382.1 57912.0 59984.0 60483.0 61103.0 8240.8 8506.4 8533.5 8597.4 8616.4 9361.5 12909.0 13162.0 13267.7 13281.0 11614.5 11678.2 11847.6 12070.6 12350.9 11401.5 11549.7 11706.9 11787.4 11848.9 11682.1 11908.6 12089.3 12102.6 12214.8 8359.9 8532.0 8542.0 8701.2 8834.7 8892.3 10895.4 11691.4 11742.9 11849.1 14:36:20 INFO - PROCESS | 6799 | 14:36:20 INFO - PROCESS | 6799 | [#3] mootools.html Cycles:180 Average:6071.08 Median:2606.08 stddev:3492.03 (134.0%) stddev-sans-first:3483.83 14:36:20 INFO - PROCESS | 6799 | Values: 1354.1 1510.5 1530.3 1656.7 1804.6 8749.2 9108.7 9141.1 9355.4 9357.3 9041.4 9238.9 9250.0 9254.6 9258.4 2096.5 2164.3 2168.6 2404.7 2438.5 2380.6 2458.1 2469.6 2482.5 2485.2 2401.1 2419.6 2425.6 2443.5 2445.8 2091.4 2341.7 2379.6 2409.9 2415.2 2415.3 2446.8 2449.0 2449.1 2452.9 8938.6 8966.7 8998.6 8999.0 9004.4 5321.1 5445.6 5449.7 5453.6 5456.4 3344.8 3369.3 3583.3 3598.8 3600.4 1075.6 1080.8 1085.3 1105.9 1182.4 12896.2 12904.1 12914.9 12921.7 12936.4 4739.9 4925.1 4993.9 4997.3 5124.5 10812.2 10814.2 10868.8 10886.7 10896.5 5533.9 5546.2 5548.8 5566.5 5571.2 4452.2 4842.2 4980.1 5022.5 5147.5 4068.8 4068.8 4118.8 4209.7 4213.0 1312.0 1348.7 1357.7 1362.8 1378.7 859.8 983.9 989.5 1023.4 1025.2 6325.4 6378.6 6471.6 6549.2 6550.1 465.2 471.9 472.3 475.9 478.4 4378.3 4419.1 4444.2 4509.3 4540.7 11209.7 11549.9 11591.8 11617.5 11618.9 10844.0 11319.7 11324.0 11579.8 11592.8 8348.0 8434.3 8561.7 8648.8 8662.0 6277.6 6289.4 6306.1 6444.1 6474.7 10349.7 10561.3 10567.3 10597.6 10638.3 10826.0 10848.7 10886.7 10970.3 10971.6 8151.8 8249.1 8301.0 8384.0 8404.2 8797.0 8905.3 8919.2 8920.5 8928.7 7847.3 8066.3 8241.1 8242.1 8366.3 7813.6 7913.3 7952.3 7954.3 7968.6 7151.6 7211.8 7255.4 7387.6 7400.8 5290.7 5344.6 5395.5 5460.5 5461.5 5476.9 5492.2 5546.6 5670.5 5707.7 14:36:20 INFO - PROCESS | 6799 | 14:36:20 INFO - PROCESS | 6799 | [#4] prototype.html Cycles:180 Average:4494.02 Median:5065.96 stddev:1325.44 (26.2%) stddev-sans-first:1291.19 14:36:20 INFO - PROCESS | 6799 | Values: 297.7 311.8 314.8 318.0 318.0 5184.9 5272.1 5388.7 5399.3 5431.3 5290.8 5315.5 5319.7 5322.2 5326.5 4115.6 4127.6 4127.7 4129.4 4136.0 3867.2 3886.0 4056.0 4108.3 4133.8 4039.4 4050.5 4060.5 4063.0 4075.7 4052.4 4058.4 4066.3 4071.8 4078.8 3493.3 3569.5 3577.4 3594.6 3606.7 5059.0 5062.3 5073.9 5094.4 5113.0 4662.8 4666.9 4677.3 4677.5 4693.9 5295.0 5549.5 5552.2 5562.3 5580.4 3954.7 3967.1 3977.6 3980.3 3989.6 5758.5 5761.3 5771.7 5771.8 5782.8 4071.6 4072.6 4078.1 4086.8 4090.8 3814.5 4006.8 4017.9 4018.2 4029.8 4615.9 4635.4 4641.5 4642.9 4646.5 5566.2 5567.4 5593.9 5596.4 5611.9 1283.2 1295.9 1380.0 1387.5 1391.8 862.9 880.3 894.3 897.8 904.8 4848.7 4873.3 4896.8 4905.0 4941.3 4985.4 5015.0 5043.4 5127.8 5130.0 4554.0 4759.8 4766.7 4822.3 4883.8 2653.6 2663.0 2664.5 2680.4 2681.2 5202.0 5226.3 5229.4 5239.0 5244.8 4869.5 5141.5 5168.7 5179.5 5179.5 5224.6 5242.4 5272.4 5291.8 5292.5 5043.3 5070.5 5078.7 5096.8 5111.1 4770.9 4961.5 4999.3 5054.3 5069.6 5148.8 5206.8 5236.3 5236.5 5253.6 3597.5 3651.4 3655.7 3669.8 3764.7 5561.9 5724.1 5762.2 5762.9 5792.3 5555.0 5570.7 5614.3 5620.7 5651.9 5343.7 5519.3 5565.4 5633.2 5645.3 5531.6 5532.9 5538.2 5552.5 5572.3 5609.7 5642.9 5645.5 5650.3 5689.4 5276.6 5520.9 5554.8 5564.2 5564.7 14:36:20 INFO - PROCESS | 6799 | 14:36:20 INFO - PROCESS | 6799 | [#5] yui.html Cycles:180 Average:16259.41 Median:4425.64 stddev:19172.61 (433.2%) stddev-sans-first:19191.33 14:36:20 INFO - PROCESS | 6799 | Values: 818.4 843.6 844.3 846.8 849.7 15171.2 15981.7 15982.8 16000.4 16005.5 14296.9 14325.9 14328.0 14333.6 14334.9 669.2 781.2 807.7 808.6 810.1 806.3 811.0 812.2 813.5 814.8 714.1 857.8 858.2 858.5 859.4 728.0 729.4 824.3 854.6 856.7 621.1 625.6 626.1 626.1 626.5 14450.8 14453.3 14467.1 14489.4 14504.7 13648.6 14115.6 14270.7 14306.1 14335.8 12128.3 12326.6 12342.9 12369.3 12632.1 4404.5 4422.2 4429.1 4500.2 4512.0 57923.4 58013.0 58529.0 59061.0 59064.4 10665.6 10807.6 10818.4 10898.1 11029.8 20255.6 20470.6 20484.8 20513.8 20515.8 8372.7 8548.6 8599.4 8750.0 8810.1 4721.4 4741.8 4799.8 4847.6 4964.8 3423.3 3513.5 3530.1 3540.7 3541.0 640.7 652.4 659.1 659.3 681.6 625.8 634.3 697.9 736.0 757.5 10100.3 10190.0 10219.9 10349.5 10357.9 639.8 672.9 734.1 737.8 743.6 4713.2 4777.9 4827.0 4836.9 4851.7 67349.7 67820.0 68868.7 68960.7 71636.0 63154.0 63175.0 63381.7 64584.4 64966.7 53723.0 56684.0 56741.4 56938.0 57990.1 9588.6 10315.4 10376.9 10438.4 10456.6 36781.0 37300.6 38385.0 38561.0 38684.6 46811.0 51004.0 51749.5 53409.2 53929.2 13015.7 13018.7 13176.3 13214.7 13255.5 13795.8 14264.0 14408.5 14710.5 15281.1 12659.8 13552.3 13583.5 14236.7 14239.0 13485.9 13486.1 13507.3 13539.6 13807.9 13430.5 13793.9 13932.0 14116.6 14555.3 11532.5 11582.8 11657.3 11922.1 11930.7 11673.8 11805.9 12038.7 12093.4 12098.3 14:36:20 INFO - PROCESS | 6799 | -------- Summary: end -------- 14:36:20 INFO - PROCESS | 6799 | 14:36:21 INFO - TEST-INFO | 6799: exit 0 14:36:21 INFO - TEST-OK | dromaeo_css | took 1113207ms 14:36:21 INFO - TEST-START | kraken 14:36:21 INFO - operating with platform_type : linux_ 14:36:21 INFO - Initialising browser for kraken test... 14:36:21 INFO - TEST-INFO | started process 6982 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMSU9sg/profile http://localhost:39644/getInfo.html) 14:36:25 INFO - PROCESS | 6982 | __metrics Screen width/height:1600/1200 14:36:25 INFO - PROCESS | 6982 | colorDepth:24 14:36:25 INFO - PROCESS | 6982 | Browser inner width/height: 1024/697 14:36:25 INFO - PROCESS | 6982 | __metrics 14:36:26 ERROR - PROCESS | 6982 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:36:27 INFO - TEST-INFO | 6982: exit 0 14:36:27 INFO - Browser initialized. 14:36:27 INFO - Running cycle 1/1 for kraken test... 14:36:27 INFO - TEST-INFO | started process 7061 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMSU9sg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:36:39 INFO - PROCESS | 7061 | RSS: Main: 155324416 14:36:39 INFO - PROCESS | 7061 | 14:36:41 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:39644/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39644/tests/kraken/driver.html?testName=audio-beat-detection) 14:36:42 INFO - PROCESS | 7061 | RSS: Main: 211587072 14:36:42 INFO - PROCESS | 7061 | 14:36:45 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:39644/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39644/tests/kraken/driver.html?testName=audio-dft) 14:36:45 INFO - PROCESS | 7061 | RSS: Main: 199204864 14:36:45 INFO - PROCESS | 7061 | 14:36:48 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:39644/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39644/tests/kraken/driver.html?testName=audio-fft) 14:36:49 INFO - PROCESS | 7061 | RSS: Main: 268369920 14:36:49 INFO - PROCESS | 7061 | 14:36:51 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:39644/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39644/tests/kraken/driver.html?testName=audio-oscillator) 14:36:52 INFO - PROCESS | 7061 | RSS: Main: 176975872 14:36:52 INFO - PROCESS | 7061 | 14:36:54 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:39644/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39644/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:36:54 INFO - PROCESS | 7061 | RSS: Main: 182415360 14:36:54 INFO - PROCESS | 7061 | 14:36:57 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:39644/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39644/tests/kraken/driver.html?testName=imaging-darkroom) 14:36:58 INFO - PROCESS | 7061 | RSS: Main: 218128384 14:36:58 INFO - PROCESS | 7061 | 14:37:01 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:39644/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39644/tests/kraken/driver.html?testName=imaging-desaturate) 14:37:02 INFO - PROCESS | 7061 | RSS: Main: 218578944 14:37:02 INFO - PROCESS | 7061 | 14:37:05 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:39644/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39644/tests/kraken/driver.html?testName=json-parse-financial) 14:37:05 INFO - PROCESS | 7061 | RSS: Main: 218468352 14:37:05 INFO - PROCESS | 7061 | 14:37:07 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:39644/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39644/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:37:07 INFO - PROCESS | 7061 | RSS: Main: 204972032 14:37:07 INFO - PROCESS | 7061 | 14:37:09 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:39644/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39644/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:37:10 INFO - PROCESS | 7061 | RSS: Main: 209526784 14:37:10 INFO - PROCESS | 7061 | 14:37:12 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:39644/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39644/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:37:13 INFO - PROCESS | 7061 | RSS: Main: 218910720 14:37:13 INFO - PROCESS | 7061 | 14:37:15 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:39644/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39644/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:37:16 INFO - PROCESS | 7061 | RSS: Main: 226258944 14:37:16 INFO - PROCESS | 7061 | 14:37:18 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:39644/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39644/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:37:19 INFO - PROCESS | 7061 | RSS: Main: 223703040 14:37:19 INFO - PROCESS | 7061 | 14:37:21 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:39644/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39644/tests/kraken/driver.html?testName=ai-astar) 14:37:21 INFO - PROCESS | 7061 | RSS: Main: 270340096 14:37:21 INFO - PROCESS | 7061 | 14:37:21 INFO - PROCESS | 7061 | __start_tp_report 14:37:21 INFO - PROCESS | 7061 | _x_x_mozilla_page_load 14:37:21 INFO - PROCESS | 7061 | _x_x_mozilla_page_load_details 14:37:21 INFO - PROCESS | 7061 | |i|pagename|runs| 14:37:21 INFO - PROCESS | 7061 | |0;ai-astar;111;106;111;110;110;112;110;110;109;111 14:37:21 INFO - PROCESS | 7061 | |1;audio-beat-detection;149;123;125;172;126;126;150;124;152;126 14:37:21 INFO - PROCESS | 7061 | |2;audio-dft;161;160;160;159;160;166;159;160;162;161 14:37:21 INFO - PROCESS | 7061 | |3;audio-fft;73;73;73;110;75;75;74;76;121;76 14:37:21 INFO - PROCESS | 7061 | |4;audio-oscillator;82;82;121;82;82;82;111;82;82;129 14:37:21 INFO - PROCESS | 7061 | |5;imaging-gaussian-blur;116;117;117;116;116;116;117;117;117;117 14:37:21 INFO - PROCESS | 7061 | |6;imaging-darkroom;146;146;146;145;145;146;145;146;145;145 14:37:21 INFO - PROCESS | 7061 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 14:37:21 INFO - PROCESS | 7061 | |8;json-parse-financial;55;53;54;54;54;54;54;69;52;52 14:37:21 INFO - PROCESS | 7061 | |9;json-stringify-tinderbox;61;61;61;60;61;61;60;61;61;62 14:37:21 INFO - PROCESS | 7061 | |10;stanford-crypto-aes;85;81;78;77;80;80;82;85;83;84 14:37:21 INFO - PROCESS | 7061 | |11;stanford-crypto-ccm;121;117;118;117;117;121;119;117;162;120 14:37:21 INFO - PROCESS | 7061 | |12;stanford-crypto-pbkdf2;160;159;157;158;157;155;163;158;155;156 14:37:21 INFO - PROCESS | 7061 | |13;stanford-crypto-sha256-iterative;62;69;63;62;63;66;62;63;64;62 14:37:21 INFO - PROCESS | 7061 | __end_tp_report 14:37:21 INFO - PROCESS | 7061 | __start_cc_report 14:37:21 INFO - PROCESS | 7061 | _x_x_mozilla_cycle_collect,1589 14:37:21 INFO - PROCESS | 7061 | __end_cc_report 14:37:21 INFO - PROCESS | 7061 | __startTimestamp1464298641321__endTimestamp 14:37:21 INFO - PROCESS | 7061 | 14:37:21 INFO - PROCESS | 7061 | ------- Summary: start ------- 14:37:21 INFO - PROCESS | 7061 | Number of tests: 14 14:37:21 INFO - PROCESS | 7061 | 14:37:21 INFO - PROCESS | 7061 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.50 stddev:1.63 (1.5%) stddev-sans-first:1.69 14:37:21 INFO - PROCESS | 7061 | Values: 111.0 106.0 111.0 110.0 110.0 112.0 110.0 110.0 109.0 111.0 14:37:21 INFO - PROCESS | 7061 | 14:37:21 INFO - PROCESS | 7061 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:137.50 stddev:17.11 (12.4%) stddev-sans-first:17.61 14:37:21 INFO - PROCESS | 7061 | Values: 149.0 123.0 125.0 172.0 126.0 126.0 150.0 124.0 152.0 126.0 14:37:21 INFO - PROCESS | 7061 | 14:37:21 INFO - PROCESS | 7061 | [#2] audio-dft Cycles:10 Average:160.80 Median:160.50 stddev:2.04 (1.3%) stddev-sans-first:2.17 14:37:21 INFO - PROCESS | 7061 | Values: 161.0 160.0 160.0 159.0 160.0 166.0 159.0 160.0 162.0 161.0 14:37:21 INFO - PROCESS | 7061 | 14:37:21 INFO - PROCESS | 7061 | [#3] audio-fft Cycles:10 Average:82.60 Median:74.50 stddev:17.57 (23.6%) stddev-sans-first:18.29 14:37:21 INFO - PROCESS | 7061 | Values: 73.0 73.0 73.0 110.0 75.0 75.0 74.0 76.0 121.0 76.0 14:37:21 INFO - PROCESS | 7061 | 14:37:21 INFO - PROCESS | 7061 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:82.00 stddev:19.00 (23.2%) stddev-sans-first:19.69 14:37:21 INFO - PROCESS | 7061 | Values: 82.0 82.0 121.0 82.0 82.0 82.0 111.0 82.0 82.0 129.0 14:37:21 INFO - PROCESS | 7061 | 14:37:21 INFO - PROCESS | 7061 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 14:37:21 INFO - PROCESS | 7061 | Values: 116.0 117.0 117.0 116.0 116.0 116.0 117.0 117.0 117.0 117.0 14:37:21 INFO - PROCESS | 7061 | 14:37:21 INFO - PROCESS | 7061 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 14:37:21 INFO - PROCESS | 7061 | Values: 146.0 146.0 146.0 145.0 145.0 146.0 145.0 146.0 145.0 145.0 14:37:21 INFO - PROCESS | 7061 | 14:37:21 INFO - PROCESS | 7061 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 14:37:21 INFO - PROCESS | 7061 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 14:37:21 INFO - PROCESS | 7061 | 14:37:21 INFO - PROCESS | 7061 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:54.00 stddev:4.98 (9.2%) stddev-sans-first:5.28 14:37:21 INFO - PROCESS | 7061 | Values: 55.0 53.0 54.0 54.0 54.0 54.0 54.0 69.0 52.0 52.0 14:37:21 INFO - PROCESS | 7061 | 14:37:21 INFO - PROCESS | 7061 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 14:37:21 INFO - PROCESS | 7061 | Values: 61.0 61.0 61.0 60.0 61.0 61.0 60.0 61.0 61.0 62.0 14:37:21 INFO - PROCESS | 7061 | 14:37:21 INFO - PROCESS | 7061 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:82.50 stddev:2.80 (3.4%) stddev-sans-first:2.67 14:37:21 INFO - PROCESS | 7061 | Values: 85.0 81.0 78.0 77.0 80.0 80.0 82.0 85.0 83.0 84.0 14:37:21 INFO - PROCESS | 7061 | 14:37:21 INFO - PROCESS | 7061 | [#11] stanford-crypto-ccm Cycles:10 Average:122.90 Median:119.50 stddev:13.84 (11.6%) stddev-sans-first:14.66 14:37:21 INFO - PROCESS | 7061 | Values: 121.0 117.0 118.0 117.0 117.0 121.0 119.0 117.0 162.0 120.0 14:37:21 INFO - PROCESS | 7061 | 14:37:21 INFO - PROCESS | 7061 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.80 Median:158.00 stddev:2.44 (1.5%) stddev-sans-first:2.46 14:37:21 INFO - PROCESS | 7061 | Values: 160.0 159.0 157.0 158.0 157.0 155.0 163.0 158.0 155.0 156.0 14:37:21 INFO - PROCESS | 7061 | 14:37:21 INFO - PROCESS | 7061 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:63.00 stddev:2.27 (3.6%) stddev-sans-first:2.33 14:37:21 INFO - PROCESS | 7061 | Values: 62.0 69.0 63.0 62.0 63.0 66.0 62.0 63.0 64.0 62.0 14:37:21 INFO - PROCESS | 7061 | -------- Summary: end -------- 14:37:21 INFO - PROCESS | 7061 | 14:37:22 INFO - TEST-INFO | 7061: exit 0 14:37:22 INFO - TEST-OK | kraken | took 60876ms 14:37:22 INFO - SUITE-END | took 1174s 14:37:22 INFO - Completed test suite (00:19:34) 14:37:22 INFO - javascript benchmark 14:37:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3133.8589763460627, 3137.5293705944114, 3163.066895265896, 3174.587303650528, 3198.6161660600733, 5298.23175639532, 5308.0, 5366.4633536646415, 5396.0, 5397.514223719864, 5302.390225124112, 5321.866953326169, 5348.705821179843, 5358.973205133979, 5364.678119312844, 4745.383100196969, 4758.952410475894, 4879.463259041502, 4919.483454237307, 4945.060438516671, 4828.155072862252, 4913.26301054841, 4942.01159768046, 4955.612428520002, 4964.230544265644, 4776.092542416947, 4836.46798852126, 4843.200871856175, 4894.559489645949, 4911.607071434312, 4868.2210846264425, 4880.951190488086, 4884.120858245515, 4916.729579873106, 4923.679960802537, 4726.550977657152, 4818.7831547580445, 4854.466008739071, 4867.902641947177, 4895.11887860185, 5325.467453254682, 5383.488568585978, 5404.297441332641, 5432.13085906257, 5432.891342173174, 5838.970805145989, 5878.235829342201, 5880.8235752927485, 5883.911741323884, 5884.735186916556, 5676.517496012844, 5729.255196824428, 5772.7113644317615, 5777.942220577783, 5813.6802475863815, 5450.4549545045575, 5472.972635136839, 5478.835634930959, 5479.232907392969, 5489.231507588941, 5967.254093238345, 5967.761289548456, 5976.940230597638, 5980.372060933626, 5986.4013598639785, 5513.062779327524, 5615.494605485526, 5675.829725108253, 5680.744366503517, 5725.914111288334, 5776.913346299725, 5802.187693722883, 5839.357670656224, 5848.912266316009, 5869.178315035813, 5703.600747947687, 5752.482276595127, 5781.797637082682, 5782.074868021096, 5785.797497087582, 5572.4706152915405, 5691.089425691869, 5749.137629355547, 5772.2207501986695, 5805.187273781674, 4407.27279998803, 4409.955900440955, 4414.690971631955, 4423.955760442419, 4450.977745111254, 3858.7491813032625, 3930.272899513542, 3933.2330195612153, 3960.3663413853646, 3991.022199561068, 5437.048516509595, 5475.342958844964, 5518.91721624176, 5524.364698059774, 5549.611527193058, 5794.565407594448, 5815.79644712433, 5823.88352232953, 5842.240508733922, 5892.027815410409, 5368.651037682538, 5519.779208831682, 5535.280413546213, 5542.334919809568, 5558.6942718150085, 4977.352944117241, 5045.84862454127, 5055.140626093573, 5059.443461219263, 5066.138756411419, 6032.909506357408, 6044.455998960115, 6044.486218671462, 6047.0929360596265, 6048.183495228176, 5649.576281778801, 5735.0537161369575, 5836.503897168788, 5837.737301821513, 5849.970750146222, 5990.6705131218205, 6037.75848966054, 6083.756649733961, 6085.4523092921845, 6086.178365920544, 5709.286339207599, 5714.885702285847, 5734.856628584152, 5759.740811663569, 5770.163326317745, 5719.28508936383, 5832.562557808266, 5855.0, 5859.707014649336, 5860.824175274749, 5673.120666296731, 5729.713514324184, 5739.426057394227, 5753.626014309057, 5767.106098554731, 5709.51469125129, 5719.971400142973, 5721.342045664802, 5725.141228815544, 5729.28383952006, 5482.725863706878, 5495.752691128829, 5612.747426365905, 5623.88752224945, 5633.549316054788, 5643.3792282848035, 5730.054541000855, 5743.282089738783, 5747.971260143672, 5748.45389687979, 5529.972350138384, 5560.36055853582, 5582.49757521825, 5588.888222235451, 5622.803201887914], "value": 5340.174434177296, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.661483032426, 625.9593126446782, 627.0, 627.1564745417412, 629.7827249598888, 33583.66416335836, 36339.81830090849, 43633.563664363384, 44468.77765611168, 44587.0, 46020.0, 46492.53507464924, 46546.0, 46644.76677616616, 46765.298520522134, 8702.086280940504, 8884.555772211395, 8895.644174233055, 8897.911020889806, 8898.644054237822, 8718.651253949834, 8797.428167169146, 8799.868001979976, 8852.690155844546, 8854.822903541957, 8830.293576513895, 8921.0, 8922.375433719642, 8934.86597701035, 8936.910630893673, 8830.514321712304, 8881.156290152425, 8884.511351875644, 8885.511296878669, 8893.199612034883, 8677.132286771335, 8710.085441028665, 8719.869201961976, 8756.387052906299, 8812.69155579558, 41767.37348939738, 42178.0, 42296.15407691829, 42436.0, 42446.15107697829, 3534.3461459629793, 3634.1096431374217, 3722.7021838252876, 3725.18046029873, 4006.2679029473106, 32129.51805722916, 32253.51619725706, 32708.672913270802, 32790.0, 33440.49839252413, 4247.256730072225, 4258.212230737293, 4274.187904298174, 4301.376300436419, 4432.933505997413, 340111.0, 340391.9999999975, 340552.0, 341631.0, 342316.0, 34170.0, 34948.825255874064, 58407.0, 59108.70445647744, 59225.703871480364, 36319.0, 36370.45444318337, 36476.27047459089, 36491.27017459636, 36544.81727591345, 15760.76358854618, 15888.126153061461, 15898.364065437485, 15900.52298431049, 15909.204539772965, 13185.077044606785, 13192.20846749198, 13218.867811321956, 13224.074314798065, 13249.0, 8280.461769984931, 8293.129221431784, 8298.709545166012, 8345.706415505607, 8366.498010119412, 3231.8545665445113, 3232.191952011997, 3244.6917542833394, 3259.7392208623255, 3291.555639988571, 1007.1590222164575, 1052.6736711619421, 1105.6738262212666, 1119.630521927778, 1139.0602752729033, 32117.35765284681, 32629.836850816067, 33004.50493242603, 33023.339533209684, 33206.66793332084, 1060.0459586372326, 1127.4926283172442, 1154.8902854228834, 1159.3623507071077, 1193.4604360375192, 17084.0, 17325.2203650836, 17328.0, 17461.912690436468, 17517.562060948578, 531637.0, 543218.0, 548583.0, 549873.0, 551848.0, 57539.0, 57974.42025579775, 57997.0, 58040.4195958035, 58177.0, 1245.7508498300376, 1286.6654669785923, 1353.9796903046658, 1372.1561239837429, 1373.25844044217, 30280.242993925327, 33876.83061584676, 33933.0, 33988.660113398546, 34334.82832585821, 49640.503594965034, 50192.0, 50201.74899125481, 50218.49781502138, 50234.497655022984, 316091.0, 319857.0, 320966.0, 321660.0, 322714.0, 25996.61005084963, 27321.863390683713, 27587.31031724223, 27998.160055198376, 28170.2957426066, 47510.52489475061, 47787.522124779694, 48024.82538455106, 48058.75970620265, 48543.271850921556, 40596.1880762389, 41072.38391424191, 41991.16017679568, 44369.10216380141, 45095.77452112718, 41638.791806040776, 41714.80844378632, 42155.3676694856, 42272.15455690931, 42496.15007699891, 40862.38706419346, 41026.92298077596, 41239.587604123575, 42166.15667686691, 42318.0, 36916.446253306756, 37185.814070929475, 37419.714607211106, 38132.0, 38205.23589528138, 28656.713432865403, 28684.569731454463, 28713.0, 28940.56589151122, 28963.0], "value": 18842.240440061156, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.02662803050316, 389.2060197197717, 398.2930298719772, 403.9858604948827, 409.9528554216266, 14390.496332628334, 16694.499165025038, 18193.272269109235, 18960.241590336387, 19041.809581904177, 18549.90725046373, 18675.066246687646, 19010.954397508132, 19148.0, 19252.42242732717, 5564.221009058725, 5765.596408251424, 5772.163036359725, 5775.191473193756, 5784.884302313952, 4195.727277726954, 5613.270274864262, 5679.233303504016, 6005.819825405223, 6356.904646430307, 6394.744210231585, 6430.421262086411, 6434.806955791334, 6438.291787903327, 6446.645434501101, 6175.475084617813, 6364.0, 6373.075903993941, 6374.426301632829, 6402.359764023584, 5382.085045542267, 5561.610687251894, 5586.888262234733, 5587.776488940438, 5603.215549823028, 22360.10559577615, 22875.428114297276, 23080.076796928104, 23128.76871231283, 23134.652980205312, 2385.976140238593, 2593.9235217384953, 2707.512647723409, 2825.27955371379, 3123.453395655751, 13942.442302307896, 14016.859831401658, 14213.644658883508, 14931.25343732809, 14955.177465239407, 1991.0841013133975, 1999.4304470990203, 2033.176563491788, 2040.540878302385, 2068.7620923593827, 49705.25442118371, 50024.49975500235, 55684.75066009059, 58807.411925880624, 58938.705306473625, 9366.812663746687, 10187.592496300065, 10335.069843714102, 10929.781404371868, 11081.612143574936, 15099.924500377429, 15178.696426071638, 15316.770248446282, 15328.386864525293, 15338.616534586725, 8414.915850841535, 8453.957730211432, 8457.323414126979, 8550.957245213734, 8607.741767746978, 8174.67301307941, 8183.624801271789, 8316.257684042204, 8324.25081742646, 8455.577221138918, 4578.5650363215445, 4735.934414756721, 4737.194676904935, 4747.074320507468, 4769.976150119227, 1890.1966664167674, 1890.7258447525032, 1932.748742663473, 1990.910409031597, 1998.450426132796, 974.6052848596188, 987.9061489158519, 998.4658207858906, 1006.7332156978407, 1034.1571619130384, 18506.167222475022, 18676.43970680882, 18946.905265473586, 18979.43061708151, 19271.325503607306, 959.8385952996813, 964.9758756031156, 1018.5060245780791, 1041.7603951091291, 1080.5407701726735, 10529.631462898762, 10640.148788096934, 10759.408232547285, 10800.729981750519, 10855.185861060294, 469923.0, 475663.0, 482919.0, 483325.0, 488165.0, 61866.38133618606, 85442.57278713692, 91358.0, 91574.54212729027, 101532.49233753784, 828.4076885027234, 853.8206976534997, 855.9614817333235, 886.9467831930104, 935.2704890185666, 17275.481735547954, 17472.82527174712, 17708.203130858885, 17715.0, 17892.0, 40892.97767555835, 41637.0, 41774.37338439865, 42414.57585424106, 44386.334204986306, 57382.13926791018, 57912.0, 59984.0, 60483.0, 61103.0, 8240.83518329618, 8506.447080939719, 8533.487990720576, 8597.355198360023, 8616.35377346689, 9361.531923403938, 12909.031822613153, 13162.0, 13267.734645307233, 13281.0, 11614.477348519506, 11678.182527223013, 11847.644570662895, 12070.637880863587, 12350.876491234972, 11401.543938242377, 11549.711257218301, 11706.88293117092, 11787.351695656822, 11848.940755296167, 11682.12384071181, 11908.642740717793, 12089.33508656997, 12102.636920892388, 12214.816777748163, 8359.874601881098, 8531.952331440285, 8541.95729021351, 8701.17338852808, 8834.734957951272, 8892.28861691076, 10895.400752958663, 11691.415429228335, 11742.884425979519, 11849.111316651459], "value": 9215.200558289898, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1354.092757852239, 1510.509084547522, 1530.3113598880502, 1656.7100757367466, 1804.5578833185864, 8749.21257086862, 9108.681196158128, 9141.085891410856, 9355.438673679584, 9357.298202634813, 9041.367104302684, 9238.86141707875, 9249.95375023124, 9254.6298148074, 9258.444493330406, 2096.4549217203485, 2164.3398763377163, 2168.620491414004, 2404.675368825208, 2438.5488684593406, 2380.571497130516, 2458.0659349447187, 2469.6172093325563, 2482.515909397668, 2485.2420011896365, 2401.1215176281034, 2419.552382809186, 2425.6361545768186, 2443.486867757773, 2445.7798798108165, 2091.435312465626, 2341.7120583678907, 2379.6311571706415, 2409.927702168929, 2415.1546958564536, 2415.347856078849, 2446.8164887633498, 2449.0326321103066, 2449.106076282162, 2452.865092419916, 8938.597763100675, 8966.68616598416, 8998.59506322217, 8999.0, 9004.369694121415, 5321.122014867542, 5445.591580631469, 5449.727513624303, 5453.645513041679, 5456.372517160498, 3344.7658663893535, 3369.2587630721446, 3583.301256255031, 3598.8200589970397, 3600.4419315006216, 1075.5858994287178, 1080.7568297133162, 1085.2945585369494, 1105.8783533811275, 1182.4383417876527, 12896.161749486253, 12904.096713230172, 12914.935425322814, 12921.741565168739, 12936.417861196174, 4739.905201895943, 4925.103835023542, 4993.925091123563, 4997.325361076281, 5124.5131712487255, 10812.189085818594, 10814.243002989873, 10868.836967445495, 10886.72783180411, 10896.509657065451, 5533.916991245134, 5546.195801608744, 5548.778048878, 5566.526845218121, 5571.220029195916, 4452.198604251266, 4842.176829938919, 4980.05378977993, 5022.497750225021, 5147.510986456281, 4068.7965601719798, 4068.8372465101065, 4118.794060296973, 4209.7474151551005, 4212.957870421318, 1311.9832130099248, 1348.7032852772375, 1357.6537982814318, 1362.843273023615, 1378.7457506976166, 859.8280343931239, 983.8622592837008, 989.4904124375952, 1023.4371095897227, 1025.21474092546, 6325.367463253638, 6378.553501254868, 6471.611703297817, 6549.24683661385, 6550.0829883816305, 465.2137886971008, 471.8513668194508, 472.2514814019817, 475.8881662809237, 478.4163320748681, 4378.343248512685, 4419.0940857124215, 4444.155610434007, 4509.34614480905, 4540.704854184468, 11209.719757005976, 11549.88450115505, 11591.826122608, 11617.477213525412, 11618.88381116195, 10844.0, 11319.717007074889, 11324.037456816262, 11579.826302605468, 11592.826107608393, 8348.0, 8434.313137372428, 8561.743147705578, 8648.827023459622, 8661.956690216508, 6277.591956522994, 6289.40250676185, 6306.117143599991, 6444.065610486547, 6474.70863811139, 10349.74125646865, 10561.313514621525, 10567.260291779501, 10597.62908298206, 10638.308509946828, 10826.0, 10848.728781780519, 10886.67339979802, 10970.286931349438, 10971.615993440191, 8151.83696326082, 8249.091790384711, 8301.0, 8383.95808020956, 8404.243618074403, 8797.0, 8905.287576993695, 8919.197272245528, 8920.509371984603, 8928.73213803587, 7847.332976697045, 8066.314363278952, 8241.052278987754, 8242.052164001216, 8366.288865446506, 7813.609319533887, 7913.327367173854, 7952.284294413299, 7954.323882470055, 7968.561729104955, 7151.642417878981, 7211.819704507429, 7255.419566434778, 7387.593682347522, 7400.814979625552, 5290.65610735301, 5344.5991550634635, 5395.514403703685, 5460.535854452416, 5461.481159289861, 5476.945230547803, 5492.1778827702765, 5546.639468434539, 5670.546356291569, 5707.714614269187], "value": 4748.803017035567, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.6576936522998, 311.7692907248636, 314.84100529232734, 317.9809211447313, 317.99682003179976, 5184.8703782405455, 5272.077386457374, 5388.703621300831, 5399.298091248142, 5431.321084864392, 5290.841274761763, 5315.521603055724, 5319.734013299339, 5322.201669749539, 5326.493983071602, 4115.629593336599, 4127.587241275864, 4127.731697439672, 4129.4012368206595, 4136.0, 3867.1878905429753, 3885.9805700971456, 4055.9797201013953, 4108.342665173573, 4133.793310334487, 4039.3738970459626, 4050.4936882889638, 4060.5127384713874, 4062.9796851015853, 4075.673946084321, 4052.4398106728972, 4058.4115303281005, 4066.2883995300704, 4071.75569465833, 4078.7960601969785, 3493.283876805249, 3569.464580312974, 3577.3918433866306, 3594.6405359463843, 3606.747527673064, 5059.0, 5062.265971434122, 5073.923891141636, 5094.388673359221, 5113.0, 4662.7668616569035, 4666.903277729731, 4677.321788340671, 4677.4854765975715, 4693.929591056137, 5294.987904596267, 5549.5005449509335, 5552.194931734876, 5562.3047119110115, 5580.441955804387, 3954.7033972451895, 3967.107400834818, 3977.6420122189143, 3980.3034468967817, 3989.6409323161056, 5758.510526605243, 5761.308642962829, 5771.740271687742, 5771.769129234825, 5782.7686892523825, 4071.6156506787834, 4072.552019277877, 4078.1435898461064, 4086.836526538965, 4090.754554726726, 3814.504114465102, 4006.8397264109694, 4017.9397309040387, 4018.1963607278076, 4029.798510074543, 4615.930761038587, 4635.351050852883, 4641.535846415399, 4642.907141857144, 4646.512116227815, 5566.165075238666, 5567.415421380778, 5593.944060559424, 5596.4403559644525, 5611.9438805612235, 1283.1787655900232, 1295.8768916952874, 1379.9586012419643, 1387.458891032498, 1391.8051472793818, 862.9309655227567, 880.300161371711, 894.342658146262, 897.8069715011304, 904.8280826642916, 4848.733319667452, 4873.31773551703, 4896.779644915988, 4905.0, 4941.308216849644, 4985.351904252424, 5015.0, 5043.394792624908, 5127.846164615067, 5129.9743501283, 4554.027369468164, 4759.762461759968, 4766.713997160182, 4822.324874517571, 4883.804647814119, 2653.601959706021, 2662.988064535464, 2664.4804263168885, 2680.3701130234767, 2681.1554360376417, 5201.973990130025, 5226.294450249244, 5229.398619158769, 5239.0, 5244.816431424882, 4869.488703686062, 5141.460146684619, 5168.7415629218385, 5179.48205179479, 5179.533841954242, 5224.6342756008235, 5242.370915490165, 5272.367315922037, 5291.814786482455, 5292.470752924677, 5043.2939388486375, 5070.518300761421, 5078.720670363018, 5096.796128154832, 5111.131107711623, 4770.880727981828, 4961.454240033666, 4999.300097986357, 5054.2923990642075, 5069.645124841226, 5148.764296568871, 5206.843794686166, 5236.266922630911, 5236.528712415901, 5253.632245742914, 3597.514335564665, 3651.356889399834, 3655.7258205635217, 3669.7798132112157, 3764.7364684471822, 5561.860953476195, 5724.141378793214, 5762.24251603265, 5762.8847423050465, 5792.333881603501, 5554.972225138848, 5570.749316280696, 5614.326280846324, 5620.667423019565, 5651.915221271766, 5343.744220108194, 5519.2824932758485, 5565.415631358811, 5633.155026746021, 5645.294338207724, 5531.617095726068, 5532.944670553243, 5538.224648549126, 5552.5280351168985, 5572.3034620672415, 5609.681724794752, 5642.915356269741, 5645.520130788929, 5650.316099852537, 5689.374168841507, 5276.60170054928, 5520.91718624229, 5554.833354999357, 5564.19319198722, 5564.721763911707], "value": 4066.1243383676465, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [818.3862103422432, 843.6119385082861, 844.3414136973163, 846.7586737779731, 849.6856163219605, 15171.241437928114, 15981.680366392666, 15982.84017159828, 16000.439984600542, 16005.519834404957, 14296.92851535741, 14325.856741432583, 14328.0, 14333.641658958531, 14334.928325358385, 669.1969636436272, 781.1641543548377, 807.7132617920641, 808.6280311056921, 810.1372038778711, 806.2743530822278, 810.9878351824727, 812.1513018895268, 813.4712436916022, 814.7881550796776, 714.118064190724, 857.8412993596205, 858.1504310732362, 858.5449711652834, 859.4456575508793, 728.0135416510605, 729.3727394440776, 824.3240542754974, 854.5513605357175, 856.6873091321685, 621.1118101115403, 625.5683578330937, 626.0577830365316, 626.0859145647361, 626.5363630913091, 14450.783238251435, 14453.349599267953, 14467.059641123398, 14489.42042318306, 14504.70990580193, 13648.590542283748, 14115.576532704035, 14270.714585708332, 14306.070105443114, 14335.78496322556, 12128.332941688204, 12326.568570100004, 12342.938285308606, 12369.257844529267, 12632.11575189737, 4404.471463424377, 4422.181896349186, 4429.092036132617, 4500.212462819027, 4511.977440112779, 57923.42076579222, 58013.0, 58528.99999999957, 59061.0, 59064.40935590632, 10665.626703065356, 10807.62155971261, 10818.350898946088, 10898.128149748001, 11029.83455248172, 20255.59488810245, 20470.59058818815, 20484.79515204829, 20513.794862051487, 20515.79484205139, 8372.748817535483, 8548.615312310962, 8599.39804213699, 8750.03749587545, 8810.118988101138, 4721.409823772028, 4741.834035808799, 4799.832005879847, 4847.587955023862, 4964.801407943714, 3423.281110966725, 3513.5432393789156, 3530.135116896377, 3540.681338679531, 3540.9822950885596, 640.6572483721187, 652.3509108437136, 659.0674196012588, 659.3143131143653, 681.6353251010686, 625.8404106952698, 634.314939864954, 697.870893884633, 735.9558426494427, 757.5379018798528, 10100.292979491513, 10190.0, 10219.948900255451, 10349.482525873676, 10357.9482102589, 639.7696829141505, 672.8519725660346, 734.1263895963785, 737.8081698758361, 743.6393349225622, 4713.151632706145, 4777.880552986134, 4827.0, 4836.854894353175, 4851.684640498356, 67349.66325168342, 67819.98270025855, 68868.6556567224, 68960.65519672369, 71636.0, 63154.0, 63175.0, 63381.68309158517, 64584.35415645783, 64966.67516662481, 53722.99999999922, 56684.0, 56741.43258567444, 56938.0, 57990.130148047814, 9588.616455341988, 10315.432651203955, 10376.948115259376, 10438.37369757817, 10456.581736730446, 36781.0, 37300.62699372972, 38385.0, 38561.0, 38684.6131538681, 46811.0, 51004.0, 51749.48250517446, 53409.198862017874, 53929.19106213489, 13015.674608134872, 13018.739625207254, 13176.341182941007, 13214.735705285648, 13255.469781209029, 13795.754921884116, 14264.0, 14408.495702650356, 14710.485133020293, 15281.08313501149, 12659.81010284828, 13552.322383880964, 13583.52457663977, 14236.715265694835, 14239.0, 13485.932570337478, 13486.05597608158, 13507.257100859548, 13539.59381218565, 13807.86192138106, 13430.529931452353, 13793.86206137966, 13932.0, 14116.647083822576, 14555.345009474811, 11532.481038353126, 11582.768344633228, 11657.262695361194, 11922.105842062054, 11930.701732456411, 11673.824892626788, 11805.881941180478, 12038.699032524257, 12093.395330233629, 12098.334591597546], "value": 7152.112544207274, "unit": "score"}], "name": "dromaeo_css", "value": 7099.687434949744, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 111.0, 110.0, 110.0, 112.0, 110.0, 110.0, 109.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 123.0, 125.0, 172.0, 126.0, 126.0, 150.0, 124.0, 152.0, 126.0], "value": 137.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 159.0, 160.0, 166.0, 159.0, 160.0, 162.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 110.0, 75.0, 75.0, 74.0, 76.0, 121.0, 76.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 121.0, 82.0, 82.0, 82.0, 111.0, 82.0, 82.0, 129.0], "value": 93.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 54.0, 54.0, 54.0, 54.0, 69.0, 52.0, 52.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 60.0, 61.0, 61.0, 60.0, 61.0, 61.0, 62.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 81.0, 78.0, 77.0, 80.0, 80.0, 82.0, 85.0, 83.0, 84.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 117.0, 118.0, 117.0, 117.0, 121.0, 119.0, 117.0, 162.0, 120.0], "value": 122.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 157.0, 158.0, 157.0, 155.0, 163.0, 158.0, 155.0, 156.0], "value": 157.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 69.0, 63.0, 62.0, 63.0, 66.0, 62.0, 63.0, 64.0, 62.0], "value": 63.6, "unit": "score"}], "name": "kraken", "value": 1483.2, "alertThreshold": 2.0}]} 14:37:22 INFO - Return code: 0 14:37:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:37:22 ERROR - # TBPL SUCCESS # 14:37:22 INFO - Running post-action listener: _resource_record_post_action 14:37:22 INFO - ##### 14:37:22 INFO - ##### Finished run-tests step (success) 14:37:22 INFO - ##### 14:37:22 INFO - Running post-run listener: _resource_record_post_run 14:37:22 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 421888; Write bytes: 539185152; Read time: 308; Write time: 530724 14:37:22 INFO - TinderboxPrint: CPU usage
13.2% 14:37:22 INFO - TinderboxPrint: I/O read bytes / time
421,888 / 308 14:37:22 INFO - TinderboxPrint: I/O write bytes / time
539,185,152 / 530,724 14:37:22 INFO - TinderboxPrint: CPU idle
8,255.9 (86.8%) 14:37:22 INFO - TinderboxPrint: CPU user
1,210.3 (12.7%) 14:37:22 INFO - TinderboxPrint: Swap in / out
0 / 0 14:37:22 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247123968; Read time: 0; Write time: 307468 14:37:22 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 421888; Write bytes: 291983360; Read time: 308; Write time: 223256 14:37:23 INFO - Running post-run listener: _upload_blobber_files 14:37:23 INFO - Blob upload gear active. 14:37:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:37: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 14:37: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'] 14:37: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 14:37:23 INFO - (blobuploader) - INFO - Open directory for files ... 14:37:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:37:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:37:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:37:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:37:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:37:24 INFO - (blobuploader) - INFO - Done attempting. 14:37:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:37:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:37:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:37:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:37:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:37:28 INFO - (blobuploader) - INFO - Done attempting. 14:37:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:37:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:37:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:37:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:37:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:37:29 INFO - (blobuploader) - INFO - Done attempting. 14:37:29 INFO - (blobuploader) - INFO - Iteration through files over. 14:37:29 INFO - Return code: 0 14:37:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:37:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:37:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c4aa3833128628b0c4dc753d7d781379705ee55bcbfa193fc557c88a0687afa7ec8efe75104253241f8b3eb389c1ea28bfb9ea382b821367f2f139231ec1f55", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/93c45c79075d30e212c697a939aed7513c8e33e30c62249972da24c1d840e27e3575a39b3e0bae6623aaec93eec18d9ada843d4946201a0b15441882dc5f3d36", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/42c0b4b273d772162cec19cfad2c504cde4407f324045f49573cd22365cb05dc411e8f6ae7a57fe02af1bb1f904593ace54dcaef7321b0fdefa9fab0f370588b"} 14:37:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:37:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:37:29 INFO - Contents: 14:37:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c4aa3833128628b0c4dc753d7d781379705ee55bcbfa193fc557c88a0687afa7ec8efe75104253241f8b3eb389c1ea28bfb9ea382b821367f2f139231ec1f55", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/93c45c79075d30e212c697a939aed7513c8e33e30c62249972da24c1d840e27e3575a39b3e0bae6623aaec93eec18d9ada843d4946201a0b15441882dc5f3d36", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/42c0b4b273d772162cec19cfad2c504cde4407f324045f49573cd22365cb05dc411e8f6ae7a57fe02af1bb1f904593ace54dcaef7321b0fdefa9fab0f370588b"} 14:37:29 INFO - Running post-run listener: copy_logs_to_upload_dir 14:37:29 INFO - Copying logs to upload dir... 14:37:29 INFO - mkdir: /builds/slave/test/build/upload/logs 14:37:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.641167 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-26 14:37:29.738552) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 14:37:29.742215) ========= 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=836cfdc75598d54cb747368e000001a9-1464297284.619721-1106222388 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/9c4aa3833128628b0c4dc753d7d781379705ee55bcbfa193fc557c88a0687afa7ec8efe75104253241f8b3eb389c1ea28bfb9ea382b821367f2f139231ec1f55", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/93c45c79075d30e212c697a939aed7513c8e33e30c62249972da24c1d840e27e3575a39b3e0bae6623aaec93eec18d9ada843d4946201a0b15441882dc5f3d36", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/42c0b4b273d772162cec19cfad2c504cde4407f324045f49573cd22365cb05dc411e8f6ae7a57fe02af1bb1f904593ace54dcaef7321b0fdefa9fab0f370588b"} build_url:https://queue.taskcluster.net/v1/task/IcNAXxo9SI2y_FlMmLjxYw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011301 build_url: 'https://queue.taskcluster.net/v1/task/IcNAXxo9SI2y_FlMmLjxYw/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/9c4aa3833128628b0c4dc753d7d781379705ee55bcbfa193fc557c88a0687afa7ec8efe75104253241f8b3eb389c1ea28bfb9ea382b821367f2f139231ec1f55", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/93c45c79075d30e212c697a939aed7513c8e33e30c62249972da24c1d840e27e3575a39b3e0bae6623aaec93eec18d9ada843d4946201a0b15441882dc5f3d36", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/42c0b4b273d772162cec19cfad2c504cde4407f324045f49573cd22365cb05dc411e8f6ae7a57fe02af1bb1f904593ace54dcaef7321b0fdefa9fab0f370588b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 14:37:29.768187) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 14:37:29.768571) ========= 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=836cfdc75598d54cb747368e000001a9-1464297284.619721-1106222388 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.40 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 14:37:30.172301) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 14:37:30.172615) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 14:37:30.172906) ========= ========= Total master_lag: 0.51 =========