builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1464371555.38 results: success (0) buildid: 20160527080600 builduid: 70e46c6c707545b49a33a98472408916 revision: 6cfd5ff960f774afa9b946b93142e7dcc5869558 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 10:52:35.383506) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 10:52:35.383947) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 10:52:35.384222) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 10:52:35.420831) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 10:52:35.421454) ========= 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=6d15e502d8e29d5d2676d664000001c3-1464371553.790818-2064923401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-27 10:52:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.8M=0s 2016-05-27 10:52:35 (46.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133624 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 10:52:35.577829) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 10:52:35.578156) ========= 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=6d15e502d8e29d5d2676d664000001c3-1464371553.790818-2064923401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015219 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 10:52:35.627546) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 10:52:35.627922) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6cfd5ff960f774afa9b946b93142e7dcc5869558 --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 6cfd5ff960f774afa9b946b93142e7dcc5869558 --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=6d15e502d8e29d5d2676d664000001c3-1464371553.790818-2064923401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-27 10:52:35,685 truncating revision to first 12 chars 2016-05-27 10:52:35,685 Setting DEBUG logging. 2016-05-27 10:52:35,685 attempt 1/10 2016-05-27 10:52:35,685 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6cfd5ff960f7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-27 10:52:36,024 unpacking tar archive at: fx-team-6cfd5ff960f7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.648309 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 10:52:36.289015) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 10:52:36.289328) ========= script_repo_revision: 6cfd5ff960f774afa9b946b93142e7dcc5869558 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 10:52:36.289730) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 10:52:36.289997) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 10:52:36.297715) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-27 10:52:36.298041) ========= /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=6d15e502d8e29d5d2676d664000001c3-1464371553.790818-2064923401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:52:36 INFO - MultiFileLogger online at 20160527 10:52:36 in /builds/slave/test 10:52:36 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 10:52:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:52:36 INFO - {'append_to_log': False, 10:52:36 INFO - 'base_work_dir': '/builds/slave/test', 10:52:36 INFO - 'blob_upload_branch': 'Fx-Team', 10:52:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:52:36 INFO - 'branch': 'Fx-Team', 10:52:36 INFO - 'buildbot_json_path': 'buildprops.json', 10:52:36 INFO - 'config_files': ('talos/linux_config.py',), 10:52:36 INFO - 'default_actions': ('clobber', 10:52:36 INFO - 'read-buildbot-config', 10:52:36 INFO - 'download-and-extract', 10:52:36 INFO - 'populate-webroot', 10:52:36 INFO - 'create-virtualenv', 10:52:36 INFO - 'install', 10:52:36 INFO - 'run-tests'), 10:52:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:52:36 INFO - 'download_minidump_stackwalk': True, 10:52:36 INFO - 'download_symbols': 'ondemand', 10:52:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:52:36 INFO - 'tooltool.py': '/tools/tooltool.py', 10:52:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:52:36 INFO - '/tools/misc-python/virtualenv.py')}, 10:52:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:52:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:52:36 INFO - 'installer_path': 'installer.exe', 10:52:36 INFO - 'log_level': 'info', 10:52:36 INFO - 'log_name': 'talos', 10:52:36 INFO - 'log_to_console': True, 10:52:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:52:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:52:36 INFO - 'opt_config_files': (), 10:52:36 INFO - 'pip_index': False, 10:52:36 INFO - 'sps_profile': False, 10:52:36 INFO - 'sps_profile_interval': 0, 10:52:36 INFO - 'suite': 'dromaeojs', 10:52:36 INFO - 'system_bits': '32', 10:52:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:52:36 INFO - 'title': 'talos-linux64-ix-023', 10:52:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:52:36 INFO - 'use_talos_json': True, 10:52:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:52:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:52:36 INFO - 'work_dir': 'build'} 10:52:36 INFO - ##### 10:52:36 INFO - ##### Running clobber step. 10:52:36 INFO - ##### 10:52:36 INFO - Running pre-action listener: _resource_record_pre_action 10:52:36 INFO - Running main action method: clobber 10:52:36 INFO - rmtree: /builds/slave/test/build 10:52:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:52:36 INFO - Running post-action listener: _resource_record_post_action 10:52:36 INFO - ##### 10:52:36 INFO - ##### Finished clobber step (success) 10:52:36 INFO - ##### 10:52:36 INFO - ##### 10:52:36 INFO - ##### Running read-buildbot-config step. 10:52:36 INFO - ##### 10:52:36 INFO - Running pre-action listener: _resource_record_pre_action 10:52:36 INFO - Running main action method: read_buildbot_config 10:52:36 INFO - Using buildbot properties: 10:52:36 INFO - { 10:52:36 INFO - "project": "", 10:52:36 INFO - "product": "firefox", 10:52:36 INFO - "script_repo_revision": "production", 10:52:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:52:36 INFO - "repository": "", 10:52:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 10:52:36 INFO - "buildid": "20160527080600", 10:52:36 INFO - "pgo_build": "True", 10:52:36 INFO - "basedir": "/builds/slave/test", 10:52:36 INFO - "buildnumber": 1197, 10:52:36 INFO - "slavename": "talos-linux64-ix-023", 10:52:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:52:36 INFO - "platform": "ubuntu64_hw", 10:52:36 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 10:52:36 INFO - "branch": "fx-team", 10:52:36 INFO - "repo_path": "integration/fx-team", 10:52:36 INFO - "revision": "6cfd5ff960f774afa9b946b93142e7dcc5869558", 10:52:36 INFO - "stage_platform": "linux64-pgo", 10:52:36 INFO - "builduid": "70e46c6c707545b49a33a98472408916", 10:52:36 INFO - "slavebuilddir": "test" 10:52:36 INFO - } 10:52:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/DXd_bqXjTLK0FZ9TJ0x3Jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 10:52:36 INFO - Running post-action listener: _resource_record_post_action 10:52:36 INFO - ##### 10:52:36 INFO - ##### Finished read-buildbot-config step (success) 10:52:36 INFO - ##### 10:52:36 INFO - ##### 10:52:36 INFO - ##### Running download-and-extract step. 10:52:36 INFO - ##### 10:52:36 INFO - Running pre-action listener: _resource_record_pre_action 10:52:36 INFO - Running main action method: download_and_extract 10:52:36 INFO - mkdir: /builds/slave/test/build/tests 10:52:36 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')]} 10:52:36 INFO - https://queue.taskcluster.net/v1/task/DXd_bqXjTLK0FZ9TJ0x3Jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:52:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXd_bqXjTLK0FZ9TJ0x3Jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:52:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXd_bqXjTLK0FZ9TJ0x3Jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:52:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXd_bqXjTLK0FZ9TJ0x3Jg/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 10:52:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXd_bqXjTLK0FZ9TJ0x3Jg/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 10:52:37 INFO - Downloaded 1361 bytes. 10:52:37 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:52:37 INFO - Using the following test package requirements: 10:52:37 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:52:37 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:52:37 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:52:37 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:37 INFO - u'jsshell-linux-x86_64.zip'], 10:52:37 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:52:37 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:52:37 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:52:37 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:52:37 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:52:37 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:52:37 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:52:37 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')]} 10:52:37 INFO - https://queue.taskcluster.net/v1/task/DXd_bqXjTLK0FZ9TJ0x3Jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:52:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXd_bqXjTLK0FZ9TJ0x3Jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:52:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXd_bqXjTLK0FZ9TJ0x3Jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:52:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXd_bqXjTLK0FZ9TJ0x3Jg/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 10:52:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXd_bqXjTLK0FZ9TJ0x3Jg/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 10:52:39 INFO - Downloaded 24410787 bytes. 10:52:39 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'] 10:52:39 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 10:52:40 INFO - Return code: 0 10:52:40 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 10:52:40 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')]} 10:52:40 INFO - https://queue.taskcluster.net/v1/task/DXd_bqXjTLK0FZ9TJ0x3Jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:52:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXd_bqXjTLK0FZ9TJ0x3Jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:52:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXd_bqXjTLK0FZ9TJ0x3Jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:52:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXd_bqXjTLK0FZ9TJ0x3Jg/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 10:52:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXd_bqXjTLK0FZ9TJ0x3Jg/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 10:52:41 INFO - Downloaded 24410787 bytes. 10:52:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:52:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:52:43 INFO - Return code: 0 10:52:43 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')]} 10:52:43 INFO - https://queue.taskcluster.net/v1/task/DXd_bqXjTLK0FZ9TJ0x3Jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:52:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXd_bqXjTLK0FZ9TJ0x3Jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:52:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXd_bqXjTLK0FZ9TJ0x3Jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:52:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXd_bqXjTLK0FZ9TJ0x3Jg/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 10:52:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXd_bqXjTLK0FZ9TJ0x3Jg/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 10:52:44 INFO - Downloaded 10834034 bytes. 10:52:44 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'] 10:52:44 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 10:52:44 INFO - Return code: 0 10:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:44 INFO - https://queue.taskcluster.net/v1/task/DXd_bqXjTLK0FZ9TJ0x3Jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:52:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXd_bqXjTLK0FZ9TJ0x3Jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:52:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXd_bqXjTLK0FZ9TJ0x3Jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:52:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXd_bqXjTLK0FZ9TJ0x3Jg/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 10:52:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXd_bqXjTLK0FZ9TJ0x3Jg/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 10:52:45 INFO - Downloaded 58742240 bytes. 10:52:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DXd_bqXjTLK0FZ9TJ0x3Jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:52:45 INFO - mkdir: /builds/slave/test/properties 10:52:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:52:45 INFO - Writing to file /builds/slave/test/properties/build_url 10:52:45 INFO - Contents: 10:52:45 INFO - build_url:https://queue.taskcluster.net/v1/task/DXd_bqXjTLK0FZ9TJ0x3Jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:52:46 INFO - Running post-action listener: _resource_record_post_action 10:52:46 INFO - Running post-action listener: set_extra_try_arguments 10:52:46 INFO - ##### 10:52:46 INFO - ##### Finished download-and-extract step (success) 10:52:46 INFO - ##### 10:52:46 INFO - ##### 10:52:46 INFO - ##### Running populate-webroot step. 10:52:46 INFO - ##### 10:52:46 INFO - Running pre-action listener: _resource_record_pre_action 10:52:46 INFO - Running main action method: populate_webroot 10:52:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:52:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:52:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:52:46 INFO - '--tppagecycles', 10:52:46 INFO - '7'], 10:52:46 INFO - 'tests': ['tsvgm']}}, 10:52:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:52:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:52:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:52:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:52:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:52:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:52:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:46 INFO - 'talos_options': ['--disable-e10s'], 10:52:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:52:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:52:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:46 INFO - 'talos_options': ['--disable-e10s'], 10:52:46 INFO - 'tests': ['damp', 'tps']}, 10:52:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:46 INFO - 'tests': ['damp', 'tps']}, 10:52:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:52:46 INFO - 'tests': ['dromaeo_dom']}, 10:52:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:52:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:52:46 INFO - 'tests': ['a11yr', 10:52:46 INFO - 'ts_paint', 10:52:46 INFO - 'tpaint', 10:52:46 INFO - 'sessionrestore', 10:52:46 INFO - 'sessionrestore_no_auto_restore', 10:52:46 INFO - 'tabpaint']}, 10:52:46 INFO - 'other-e10s': {'tests': ['a11yr', 10:52:46 INFO - 'ts_paint', 10:52:46 INFO - 'tpaint', 10:52:46 INFO - 'sessionrestore', 10:52:46 INFO - 'sessionrestore_no_auto_restore', 10:52:46 INFO - 'tabpaint']}, 10:52:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:52:46 INFO - 'ts_paint', 10:52:46 INFO - 'tpaint', 10:52:46 INFO - 'sessionrestore', 10:52:46 INFO - 'sessionrestore_no_auto_restore', 10:52:46 INFO - 'tabpaint']}, 10:52:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:52:46 INFO - 'ts_paint', 10:52:46 INFO - 'tpaint', 10:52:46 INFO - 'sessionrestore', 10:52:46 INFO - 'sessionrestore_no_auto_restore', 10:52:46 INFO - 'tabpaint']}, 10:52:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:52:46 INFO - 'tests': ['a11yr', 10:52:46 INFO - 'ts_paint', 10:52:46 INFO - 'tpaint', 10:52:46 INFO - 'sessionrestore', 10:52:46 INFO - 'sessionrestore_no_auto_restore', 10:52:46 INFO - 'tabpaint']}, 10:52:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:52:46 INFO - 'tests': ['a11yr', 10:52:46 INFO - 'ts_paint', 10:52:46 INFO - 'tpaint', 10:52:46 INFO - 'sessionrestore', 10:52:46 INFO - 'sessionrestore_no_auto_restore', 10:52:46 INFO - 'tabpaint']}, 10:52:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:52:46 INFO - 'tests': ['tsvgx', 10:52:46 INFO - 'tsvgr_opacity', 10:52:46 INFO - 'tart', 10:52:46 INFO - 'tscrollx', 10:52:46 INFO - 'cart']}, 10:52:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:52:46 INFO - 'tsvgr_opacity', 10:52:46 INFO - 'tart', 10:52:46 INFO - 'tscrollx', 10:52:46 INFO - 'cart']}, 10:52:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:46 INFO - 'talos_options': ['--disable-e10s'], 10:52:46 INFO - 'tests': ['tp5o']}, 10:52:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:46 INFO - 'tests': ['tp5o']}, 10:52:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:46 INFO - 'talos_options': ['--disable-e10s', 10:52:46 INFO - '--xperf_path', 10:52:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:52:46 INFO - 'tests': ['tp5n']}, 10:52:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:46 INFO - 'talos_options': ['--xperf_path', 10:52:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:52:46 INFO - 'tests': ['tp5n']}}, 10:52:46 INFO - 'talos.zip': {'path': '', 10:52:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:52:46 INFO - Running post-action listener: _resource_record_post_action 10:52:46 INFO - ##### 10:52:46 INFO - ##### Finished populate-webroot step (success) 10:52:46 INFO - ##### 10:52:46 INFO - ##### 10:52:46 INFO - ##### Running create-virtualenv step. 10:52:46 INFO - ##### 10:52:46 INFO - Running pre-action listener: _resource_record_pre_action 10:52:46 INFO - Running main action method: create_virtualenv 10:52:46 INFO - Creating virtualenv /builds/slave/test/build/venv 10:52:46 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 10:52:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:52:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:52:47 INFO - Using real prefix '/usr' 10:52:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:52:48 INFO - Installing distribute.............................................................................................................................................................................................done. 10:52:50 INFO - Installing pip.................done. 10:52:50 INFO - Return code: 0 10:52:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f64095e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20759c0>, '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 0x20768c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2076d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464371553.790818-2064923401', '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 10:52:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:52:50 INFO - Using env: {'DISPLAY': ':0', 10:52:50 INFO - 'HOME': '/home/cltbld', 10:52:50 INFO - 'LANG': 'en_US.UTF-8', 10:52:50 INFO - 'LANGUAGE': 'en_US:en', 10:52:50 INFO - 'LOGNAME': 'cltbld', 10:52:50 INFO - 'MAIL': '/var/mail/cltbld', 10:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:50 INFO - 'MOZ_NO_REMOTE': '1', 10:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:50 INFO - 'NO_EM_RESTART': '1', 10:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:50 INFO - 'PWD': '/builds/slave/test', 10:52:50 INFO - 'SHELL': '/bin/bash', 10:52:50 INFO - 'SHLVL': '1', 10:52:50 INFO - 'TERM': 'linux', 10:52:50 INFO - 'TMOUT': '86400', 10:52:50 INFO - 'USER': 'cltbld', 10:52:50 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464371553.790818-2064923401', 10:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:50 INFO - '_': '/tools/buildbot/bin/python'} 10:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:52:50 INFO - Cleaning up... 10:52:50 INFO - Return code: 0 10:52:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f64095e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20759c0>, '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 0x20768c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2076d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464371553.790818-2064923401', '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 10:52:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:52:50 INFO - Using env: {'DISPLAY': ':0', 10:52:50 INFO - 'HOME': '/home/cltbld', 10:52:50 INFO - 'LANG': 'en_US.UTF-8', 10:52:50 INFO - 'LANGUAGE': 'en_US:en', 10:52:50 INFO - 'LOGNAME': 'cltbld', 10:52:50 INFO - 'MAIL': '/var/mail/cltbld', 10:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:50 INFO - 'MOZ_NO_REMOTE': '1', 10:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:50 INFO - 'NO_EM_RESTART': '1', 10:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:50 INFO - 'PWD': '/builds/slave/test', 10:52:50 INFO - 'SHELL': '/bin/bash', 10:52:50 INFO - 'SHLVL': '1', 10:52:50 INFO - 'TERM': 'linux', 10:52:50 INFO - 'TMOUT': '86400', 10:52:50 INFO - 'USER': 'cltbld', 10:52:50 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464371553.790818-2064923401', 10:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:50 INFO - '_': '/tools/buildbot/bin/python'} 10:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:50 INFO - Downloading/unpacking psutil>=3.1.1 10:52:50 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 10:52:50 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 10:52:50 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 10:52:50 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 10:52:50 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 10:52:50 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 10:52:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:52:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:52:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:52:54 INFO - Installing collected packages: psutil 10:52:54 INFO - Running setup.py install for psutil 10:52:54 INFO - building 'psutil._psutil_linux' extension 10:52:54 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 10:52:55 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 10:52:55 INFO - building 'psutil._psutil_posix' extension 10:52:55 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 10:52:55 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 10:52:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:52:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:52:55 INFO - Successfully installed psutil 10:52:55 INFO - Cleaning up... 10:52:56 INFO - Return code: 0 10:52:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f64095e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20759c0>, '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 0x20768c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2076d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464371553.790818-2064923401', '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 10:52:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:52:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:52:56 INFO - Using env: {'DISPLAY': ':0', 10:52:56 INFO - 'HOME': '/home/cltbld', 10:52:56 INFO - 'LANG': 'en_US.UTF-8', 10:52:56 INFO - 'LANGUAGE': 'en_US:en', 10:52:56 INFO - 'LOGNAME': 'cltbld', 10:52:56 INFO - 'MAIL': '/var/mail/cltbld', 10:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:56 INFO - 'MOZ_NO_REMOTE': '1', 10:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:56 INFO - 'NO_EM_RESTART': '1', 10:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:56 INFO - 'PWD': '/builds/slave/test', 10:52:56 INFO - 'SHELL': '/bin/bash', 10:52:56 INFO - 'SHLVL': '1', 10:52:56 INFO - 'TERM': 'linux', 10:52:56 INFO - 'TMOUT': '86400', 10:52:56 INFO - 'USER': 'cltbld', 10:52:56 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464371553.790818-2064923401', 10:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:56 INFO - '_': '/tools/buildbot/bin/python'} 10:52:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:52:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:52:58 INFO - Installing collected packages: mozsystemmonitor 10:52:58 INFO - Running setup.py install for mozsystemmonitor 10:52:58 INFO - Successfully installed mozsystemmonitor 10:52:58 INFO - Cleaning up... 10:52:58 INFO - Return code: 0 10:52:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:58 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 0x7f64095e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20759c0>, '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 0x20768c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2076d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464371553.790818-2064923401', '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 10:52:58 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 10:52:58 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 10:52:58 INFO - Using env: {'DISPLAY': ':0', 10:52:58 INFO - 'HOME': '/home/cltbld', 10:52:58 INFO - 'LANG': 'en_US.UTF-8', 10:52:58 INFO - 'LANGUAGE': 'en_US:en', 10:52:58 INFO - 'LOGNAME': 'cltbld', 10:52:58 INFO - 'MAIL': '/var/mail/cltbld', 10:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:58 INFO - 'MOZ_NO_REMOTE': '1', 10:52:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:58 INFO - 'NO_EM_RESTART': '1', 10:52:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:58 INFO - 'PWD': '/builds/slave/test', 10:52:58 INFO - 'SHELL': '/bin/bash', 10:52:58 INFO - 'SHLVL': '1', 10:52:58 INFO - 'TERM': 'linux', 10:52:58 INFO - 'TMOUT': '86400', 10:52:58 INFO - 'USER': 'cltbld', 10:52:58 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464371553.790818-2064923401', 10:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:58 INFO - '_': '/tools/buildbot/bin/python'} 10:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:58 INFO - Downloading/unpacking blobuploader==1.2.4 10:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:00 INFO - Downloading blobuploader-1.2.4.tar.gz 10:53:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:53:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:53:00 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 10:53:00 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 10:53:00 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 10:53:00 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 10:53:00 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 10:53:00 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 10:53:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:53:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:53:00 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 10:53:00 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 10:53:00 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 10:53:00 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 10:53:00 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 10:53:00 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 10:53:01 INFO - Downloading docopt-0.6.1.tar.gz 10:53:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:53:01 INFO - Installing collected packages: blobuploader, requests, docopt 10:53:01 INFO - Running setup.py install for blobuploader 10:53:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:53:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:53:01 INFO - Running setup.py install for requests 10:53:01 INFO - Running setup.py install for docopt 10:53:01 INFO - Successfully installed blobuploader requests docopt 10:53:01 INFO - Cleaning up... 10:53:01 INFO - Return code: 0 10:53:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:53: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')]} 10:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53: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')]} 10:53:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:01 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 0x7f64095e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20759c0>, '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 0x20768c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2076d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464371553.790818-2064923401', '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 10:53:01 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 10:53:01 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 10:53:01 INFO - Using env: {'DISPLAY': ':0', 10:53:01 INFO - 'HOME': '/home/cltbld', 10:53:01 INFO - 'LANG': 'en_US.UTF-8', 10:53:01 INFO - 'LANGUAGE': 'en_US:en', 10:53:01 INFO - 'LOGNAME': 'cltbld', 10:53:01 INFO - 'MAIL': '/var/mail/cltbld', 10:53:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:01 INFO - 'MOZ_NO_REMOTE': '1', 10:53:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:01 INFO - 'NO_EM_RESTART': '1', 10:53:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:01 INFO - 'PWD': '/builds/slave/test', 10:53:01 INFO - 'SHELL': '/bin/bash', 10:53:01 INFO - 'SHLVL': '1', 10:53:01 INFO - 'TERM': 'linux', 10:53:01 INFO - 'TMOUT': '86400', 10:53:01 INFO - 'USER': 'cltbld', 10:53:01 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464371553.790818-2064923401', 10:53:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:01 INFO - '_': '/tools/buildbot/bin/python'} 10:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:53:02 INFO - Running setup.py (path:/tmp/pip-1d3tFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:53:02 INFO - Running setup.py (path:/tmp/pip-jpHXIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:53:02 INFO - Running setup.py (path:/tmp/pip-du7XW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:53:02 INFO - Running setup.py (path:/tmp/pip-b6Lanm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:53:02 INFO - Running setup.py (path:/tmp/pip-ZCuaGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:53:02 INFO - Running setup.py (path:/tmp/pip-bl4Zbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:53:02 INFO - Running setup.py (path:/tmp/pip-B72Rnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:53:02 INFO - Running setup.py (path:/tmp/pip-OiPJTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:53:02 INFO - Running setup.py (path:/tmp/pip-Xqmk32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:53:02 INFO - Running setup.py (path:/tmp/pip-7xRrzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:53:02 INFO - Running setup.py (path:/tmp/pip-HcGwaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:53:02 INFO - Running setup.py (path:/tmp/pip-Lc4NFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:53:02 INFO - Running setup.py (path:/tmp/pip-1ba0AF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:53:02 INFO - Running setup.py (path:/tmp/pip-W2BkUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:53:03 INFO - Running setup.py (path:/tmp/pip-G2HBrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:53:03 INFO - Running setup.py (path:/tmp/pip-NFSsF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:53:03 INFO - Running setup.py (path:/tmp/pip-wA_ahK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:53:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:53:03 INFO - Running setup.py install for manifestparser 10:53:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:53:03 INFO - Running setup.py install for mozcrash 10:53:03 INFO - Running setup.py install for mozdebug 10:53:03 INFO - Running setup.py install for mozdevice 10:53:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:53:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:53:03 INFO - Running setup.py install for mozfile 10:53:03 INFO - Running setup.py install for mozhttpd 10:53:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:53:03 INFO - Running setup.py install for mozinfo 10:53:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:53:03 INFO - Running setup.py install for mozInstall 10:53:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:53:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:53:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:53:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:53:04 INFO - Running setup.py install for mozleak 10:53:04 INFO - Running setup.py install for mozlog 10:53:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:53:04 INFO - Running setup.py install for moznetwork 10:53:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:53:04 INFO - Running setup.py install for mozprocess 10:53:04 INFO - Running setup.py install for mozprofile 10:53:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:53:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:53:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:53:04 INFO - Running setup.py install for mozrunner 10:53:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:53:04 INFO - Running setup.py install for mozscreenshot 10:53:04 INFO - Running setup.py install for moztest 10:53:04 INFO - Running setup.py install for mozversion 10:53:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:53:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:53:05 INFO - Cleaning up... 10:53:05 INFO - Return code: 0 10:53:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:53:05 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')]} 10:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:05 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')]} 10:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:05 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 0x7f64095e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20759c0>, '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 0x20768c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2076d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464371553.790818-2064923401', '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 10:53:05 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 10:53:05 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 10:53:05 INFO - Using env: {'DISPLAY': ':0', 10:53:05 INFO - 'HOME': '/home/cltbld', 10:53:05 INFO - 'LANG': 'en_US.UTF-8', 10:53:05 INFO - 'LANGUAGE': 'en_US:en', 10:53:05 INFO - 'LOGNAME': 'cltbld', 10:53:05 INFO - 'MAIL': '/var/mail/cltbld', 10:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:05 INFO - 'MOZ_NO_REMOTE': '1', 10:53:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:05 INFO - 'NO_EM_RESTART': '1', 10:53:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:05 INFO - 'PWD': '/builds/slave/test', 10:53:05 INFO - 'SHELL': '/bin/bash', 10:53:05 INFO - 'SHLVL': '1', 10:53:05 INFO - 'TERM': 'linux', 10:53:05 INFO - 'TMOUT': '86400', 10:53:05 INFO - 'USER': 'cltbld', 10:53:05 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464371553.790818-2064923401', 10:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:05 INFO - '_': '/tools/buildbot/bin/python'} 10:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:53:05 INFO - Running setup.py (path:/tmp/pip-dZmg9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:53:05 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)) 10:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:53:05 INFO - Running setup.py (path:/tmp/pip-_YtsbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:53:05 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)) 10:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:53:05 INFO - Running setup.py (path:/tmp/pip-xwf3Nk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:53:05 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)) 10:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:53:05 INFO - Running setup.py (path:/tmp/pip-e1jw7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:53:05 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)) 10:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:53:05 INFO - Running setup.py (path:/tmp/pip-9gk1_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:53:05 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)) 10:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:53:05 INFO - Running setup.py (path:/tmp/pip-f0GwRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:53:05 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)) 10:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:53:05 INFO - Running setup.py (path:/tmp/pip-mXxBEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:53:05 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)) 10:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:53:05 INFO - Running setup.py (path:/tmp/pip-LaGP9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:53:05 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)) 10:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:53:05 INFO - Running setup.py (path:/tmp/pip-aXHPwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:53:05 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)) 10:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:53:05 INFO - Running setup.py (path:/tmp/pip-sF4CaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:53:05 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)) 10:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:53:05 INFO - Running setup.py (path:/tmp/pip-4E9ZuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:53:06 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)) 10:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:53:06 INFO - Running setup.py (path:/tmp/pip-5xv02O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:53:06 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)) 10:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:53:06 INFO - Running setup.py (path:/tmp/pip-KxQ2Du-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:53:06 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)) 10:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:53:06 INFO - Running setup.py (path:/tmp/pip-0qrmY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:53:06 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)) 10:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:53:06 INFO - Running setup.py (path:/tmp/pip-d0lZgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:53:06 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)) 10:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:53:06 INFO - Running setup.py (path:/tmp/pip-AJLoJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:53:06 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)) 10:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:53:06 INFO - Running setup.py (path:/tmp/pip-_j4csm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:53:06 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)) 10:53:06 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)) 10:53:06 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)) 10:53:06 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)) 10:53:06 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)) 10:53:06 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)) 10:53:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:53:06 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 10:53:06 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 10:53:06 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 10:53:06 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 10:53:06 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 10:53:06 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 10:53:08 INFO - Downloading blessings-1.6.tar.gz 10:53:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:53:08 INFO - Installing collected packages: blessings 10:53:08 INFO - Running setup.py install for blessings 10:53:08 INFO - Successfully installed blessings 10:53:08 INFO - Cleaning up... 10:53:08 INFO - Return code: 0 10:53:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:53:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:53:08 INFO - Reading from file tmpfile_stdout 10:53:08 INFO - Current package versions: 10:53:08 INFO - argparse == 1.2.1 10:53:08 INFO - blessings == 1.6 10:53:08 INFO - blobuploader == 1.2.4 10:53:08 INFO - docopt == 0.6.1 10:53:08 INFO - manifestparser == 1.1 10:53:08 INFO - mozInstall == 1.12 10:53:08 INFO - mozcrash == 0.17 10:53:08 INFO - mozdebug == 0.1 10:53:08 INFO - mozdevice == 0.48 10:53:08 INFO - mozfile == 1.2 10:53:08 INFO - mozhttpd == 0.7 10:53:08 INFO - mozinfo == 0.9 10:53:08 INFO - mozleak == 0.1 10:53:08 INFO - mozlog == 3.2 10:53:08 INFO - moznetwork == 0.27 10:53:08 INFO - mozprocess == 0.22 10:53:08 INFO - mozprofile == 0.28 10:53:08 INFO - mozrunner == 6.11 10:53:08 INFO - mozscreenshot == 0.1 10:53:08 INFO - mozsystemmonitor == 0.3 10:53:08 INFO - moztest == 0.7 10:53:08 INFO - mozversion == 1.4 10:53:08 INFO - psutil == 3.1.1 10:53:08 INFO - requests == 1.2.3 10:53:08 INFO - wsgiref == 0.1.2 10:53:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:53: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')]} 10:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53: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')]} 10:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:08 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 0x7f64095e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20759c0>, '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 0x20768c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2076d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464371553.790818-2064923401', '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 10:53:08 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 10:53:08 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 10:53:08 INFO - Using env: {'DISPLAY': ':0', 10:53:08 INFO - 'HOME': '/home/cltbld', 10:53:08 INFO - 'LANG': 'en_US.UTF-8', 10:53:08 INFO - 'LANGUAGE': 'en_US:en', 10:53:08 INFO - 'LOGNAME': 'cltbld', 10:53:08 INFO - 'MAIL': '/var/mail/cltbld', 10:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:08 INFO - 'MOZ_NO_REMOTE': '1', 10:53:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:08 INFO - 'NO_EM_RESTART': '1', 10:53:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:08 INFO - 'PWD': '/builds/slave/test', 10:53:08 INFO - 'SHELL': '/bin/bash', 10:53:08 INFO - 'SHLVL': '1', 10:53:08 INFO - 'TERM': 'linux', 10:53:08 INFO - 'TMOUT': '86400', 10:53:08 INFO - 'USER': 'cltbld', 10:53:08 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464371553.790818-2064923401', 10:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:08 INFO - '_': '/tools/buildbot/bin/python'} 10:53:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:09 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)) 10:53:09 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)) 10:53:09 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)) 10:53:09 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)) 10:53:09 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)) 10:53:09 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)) 10:53:09 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)) 10:53:09 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)) 10:53:09 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)) 10:53:09 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)) 10:53:09 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)) 10:53:09 INFO - Cleaning up... 10:53:09 INFO - Return code: 0 10:53:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:53:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f64095e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20759c0>, '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 0x20768c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2076d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464371553.790818-2064923401', '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 10:53:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:53:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:53:09 INFO - Using env: {'DISPLAY': ':0', 10:53:09 INFO - 'HOME': '/home/cltbld', 10:53:09 INFO - 'LANG': 'en_US.UTF-8', 10:53:09 INFO - 'LANGUAGE': 'en_US:en', 10:53:09 INFO - 'LOGNAME': 'cltbld', 10:53:09 INFO - 'MAIL': '/var/mail/cltbld', 10:53:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:09 INFO - 'MOZ_NO_REMOTE': '1', 10:53:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:09 INFO - 'NO_EM_RESTART': '1', 10:53:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:09 INFO - 'PWD': '/builds/slave/test', 10:53:09 INFO - 'SHELL': '/bin/bash', 10:53:09 INFO - 'SHLVL': '1', 10:53:09 INFO - 'TERM': 'linux', 10:53:09 INFO - 'TMOUT': '86400', 10:53:09 INFO - 'USER': 'cltbld', 10:53:09 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464371553.790818-2064923401', 10:53:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:09 INFO - '_': '/tools/buildbot/bin/python'} 10:53:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:09 INFO - Downloading/unpacking jsonschema 10:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:53:11 INFO - Downloading/unpacking functools32 (from jsonschema) 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53:11 INFO - Downloading functools32-3.2.3-2.tar.gz 10:53:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:53:11 INFO - warning: no files found matching '*.txt' 10:53:11 INFO - no previously-included directories found matching 'build' 10:53:11 INFO - no previously-included directories found matching 'dist' 10:53:11 INFO - no previously-included directories found matching '.git*' 10:53:11 INFO - Installing collected packages: jsonschema, functools32 10:53:11 INFO - Running setup.py install for functools32 10:53:11 INFO - warning: no files found matching '*.txt' 10:53:11 INFO - no previously-included directories found matching 'build' 10:53:11 INFO - no previously-included directories found matching 'dist' 10:53:11 INFO - no previously-included directories found matching '.git*' 10:53:11 INFO - Successfully installed jsonschema functools32 10:53:11 INFO - Cleaning up... 10:53:11 INFO - Return code: 0 10:53:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:53: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')]} 10:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53: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')]} 10:53:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f64095e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20759c0>, '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 0x20768c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2076d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464371553.790818-2064923401', '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 10:53: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', 'flake8'] in /builds/slave/test/build 10:53: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 flake8 10:53:11 INFO - Using env: {'DISPLAY': ':0', 10:53:11 INFO - 'HOME': '/home/cltbld', 10:53:11 INFO - 'LANG': 'en_US.UTF-8', 10:53:11 INFO - 'LANGUAGE': 'en_US:en', 10:53:11 INFO - 'LOGNAME': 'cltbld', 10:53:11 INFO - 'MAIL': '/var/mail/cltbld', 10:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:11 INFO - 'MOZ_NO_REMOTE': '1', 10:53:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:11 INFO - 'NO_EM_RESTART': '1', 10:53:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:11 INFO - 'PWD': '/builds/slave/test', 10:53:11 INFO - 'SHELL': '/bin/bash', 10:53:11 INFO - 'SHLVL': '1', 10:53:11 INFO - 'TERM': 'linux', 10:53:11 INFO - 'TMOUT': '86400', 10:53:11 INFO - 'USER': 'cltbld', 10:53:11 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464371553.790818-2064923401', 10:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:11 INFO - '_': '/tools/buildbot/bin/python'} 10:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:11 INFO - Downloading/unpacking flake8 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:53:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:53:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:53:14 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 10:53:14 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 10:53:14 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 10:53:14 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 10:53:14 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 10:53:14 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 10:53:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:53:14 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 10:53:14 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 10:53:14 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 10:53:14 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 10:53:14 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 10:53:14 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 10:53:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:53:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:53:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:53:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:53:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:53:14 INFO - no previously-included directories found matching 'docs/_build' 10:53:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:53:14 INFO - Running setup.py install for pep8 10:53:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:53:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:53:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:53:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:53:14 INFO - no previously-included directories found matching 'docs/_build' 10:53:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:53:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:53:14 INFO - Cleaning up... 10:53:14 INFO - Return code: 0 10:53:14 INFO - Running post-action listener: _resource_record_post_action 10:53:14 INFO - Running post-action listener: _start_resource_monitoring 10:53:14 INFO - Starting resource monitoring. 10:53:14 INFO - ##### 10:53:14 INFO - ##### Finished create-virtualenv step (success) 10:53:14 INFO - ##### 10:53:14 INFO - ##### 10:53:14 INFO - ##### Running install step. 10:53:14 INFO - ##### 10:53:14 INFO - Running pre-action listener: _resource_record_pre_action 10:53:14 INFO - Running main action method: install 10:53:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:53:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:53:15 INFO - Reading from file tmpfile_stdout 10:53:15 INFO - Detecting whether we're running mozinstall >=1.0... 10:53:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:53:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:53:15 INFO - Reading from file tmpfile_stdout 10:53:15 INFO - Output received: 10:53:15 INFO - Usage: mozinstall [options] installer 10:53:15 INFO - Options: 10:53:15 INFO - -h, --help show this help message and exit 10:53:15 INFO - -d DEST, --destination=DEST 10:53:15 INFO - Directory to install application into. [default: 10:53:15 INFO - "/builds/slave/test"] 10:53:15 INFO - --app=APP Application being installed. [default: firefox] 10:53:15 INFO - mkdir: /builds/slave/test/build/application 10:53:15 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'] 10:53:15 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 10:53:31 INFO - Reading from file tmpfile_stdout 10:53:31 INFO - Output received: 10:53:31 INFO - /builds/slave/test/build/application/firefox/firefox 10:53:31 INFO - Running post-action listener: _resource_record_post_action 10:53:31 INFO - ##### 10:53:31 INFO - ##### Finished install step (success) 10:53:31 INFO - ##### 10:53:31 INFO - ##### 10:53:31 INFO - ##### Running run-tests step. 10:53:31 INFO - ##### 10:53:31 INFO - Running pre-action listener: _resource_record_pre_action 10:53:31 INFO - Running main action method: run_tests 10:53:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:53:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:53:31 INFO - Python 2.7.3 10:53:31 INFO - Return code: 0 10:53:31 INFO - grabbing minidump binary from tooltool 10:53:31 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')]} 10:53:31 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 0x20759c0>, '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 0x20768c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2076d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:53:31 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 10:53:31 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 10:53:31 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 10:53:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:53:31 INFO - Return code: 0 10:53:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:53:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:53:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:53:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:53:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:53:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:53:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:53:32 INFO - Return code: 0 10:53:32 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/DXd_bqXjTLK0FZ9TJ0x3Jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 10:53:32 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/DXd_bqXjTLK0FZ9TJ0x3Jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 10:53:32 INFO - Using env: {'DISPLAY': ':0', 10:53:32 INFO - 'HOME': '/home/cltbld', 10:53:32 INFO - 'LANG': 'en_US.UTF-8', 10:53:32 INFO - 'LANGUAGE': 'en_US:en', 10:53:32 INFO - 'LOGNAME': 'cltbld', 10:53:32 INFO - 'MAIL': '/var/mail/cltbld', 10:53:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:53:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:53:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:32 INFO - 'MOZ_NO_REMOTE': '1', 10:53:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:53:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:32 INFO - 'NO_EM_RESTART': '1', 10:53:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:32 INFO - 'PWD': '/builds/slave/test', 10:53:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:53:32 INFO - 'SHELL': '/bin/bash', 10:53:32 INFO - 'SHLVL': '1', 10:53:32 INFO - 'TERM': 'linux', 10:53:32 INFO - 'TMOUT': '86400', 10:53:32 INFO - 'USER': 'cltbld', 10:53:32 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464371553.790818-2064923401', 10:53:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:32 INFO - '_': '/tools/buildbot/bin/python'} 10:53:32 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/DXd_bqXjTLK0FZ9TJ0x3Jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 10:53:33 INFO - mozversion application_buildid: 20160527080600 10:53:33 INFO - mozversion application_changeset: 6cfd5ff960f774afa9b946b93142e7dcc5869558 10:53:33 INFO - mozversion application_display_name: Nightly 10:53:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:53:33 INFO - mozversion application_name: Firefox 10:53:33 INFO - mozversion application_remotingname: firefox 10:53:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:53:33 INFO - mozversion application_vendor: Mozilla 10:53:33 INFO - mozversion application_version: 49.0a1 10:53:33 INFO - mozversion platform_buildid: 20160527080600 10:53:33 INFO - mozversion platform_changeset: 6cfd5ff960f774afa9b946b93142e7dcc5869558 10:53:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:53:33 INFO - mozversion platform_version: 49.0a1 10:53:33 INFO - using testdate: 1464371613 10:53:33 INFO - actual date: 1464371613 10:53:33 INFO - starting webserver on 'localhost:59916' 10:53:33 INFO - SUITE-START | Running 2 tests 10:53:33 INFO - TEST-START | dromaeo_css 10:53:33 INFO - operating with platform_type : linux_ 10:53:33 INFO - Initialising browser for dromaeo_css test... 10:53:33 INFO - TEST-INFO | started process 3291 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp867EEp/profile http://localhost:59916/getInfo.html) 10:53:39 INFO - PROCESS | 3291 | __metrics Screen width/height:1600/1200 10:53:39 INFO - PROCESS | 3291 | colorDepth:24 10:53:39 INFO - PROCESS | 3291 | Browser inner width/height: 1024/697 10:53:39 INFO - PROCESS | 3291 | __metrics 10:53:40 ERROR - PROCESS | 3291 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:53:41 INFO - TEST-INFO | 3291: exit 0 10:53:41 INFO - Browser initialized. 10:53:41 INFO - Running cycle 1/1 for dromaeo_css test... 10:53:41 INFO - TEST-INFO | started process 3373 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp867EEp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:53:53 INFO - PROCESS | 3373 | RSS: Main: 155336704 10:53:53 INFO - PROCESS | 3373 | 10:54:44 INFO - PROCESS | 3373 | 1464371684251 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] 10:56:52 INFO - PROCESS | 3373 | Cycle 1(1): loaded http://localhost:59916/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59916/tests/dromaeo/cssquery-ext.html) 10:56:53 INFO - PROCESS | 3373 | RSS: Main: 276770816 10:56:53 INFO - PROCESS | 3373 | 10:59:56 INFO - PROCESS | 3373 | Cycle 1(1): loaded http://localhost:59916/tests/dromaeo/cssquery-ext.html (next: http://localhost:59916/tests/dromaeo/cssquery-jquery.html) 10:59:56 INFO - PROCESS | 3373 | RSS: Main: 246214656 10:59:56 INFO - PROCESS | 3373 | 11:02:58 INFO - PROCESS | 3373 | Cycle 1(1): loaded http://localhost:59916/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59916/tests/dromaeo/cssquery-mootools.html) 11:02:59 INFO - PROCESS | 3373 | RSS: Main: 238215168 11:02:59 INFO - PROCESS | 3373 | 11:06:01 INFO - PROCESS | 3373 | Cycle 1(1): loaded http://localhost:59916/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59916/tests/dromaeo/cssquery-prototype.html) 11:06:01 INFO - PROCESS | 3373 | RSS: Main: 236613632 11:06:01 INFO - PROCESS | 3373 | 11:09:04 INFO - PROCESS | 3373 | Cycle 1(1): loaded http://localhost:59916/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59916/tests/dromaeo/cssquery-yui.html) 11:09:05 INFO - PROCESS | 3373 | RSS: Main: 221024256 11:09:05 INFO - PROCESS | 3373 | 11:12:07 INFO - PROCESS | 3373 | Cycle 1(1): loaded http://localhost:59916/tests/dromaeo/cssquery-yui.html (next: http://localhost:59916/tests/dromaeo/cssquery-dojo.html) 11:12:08 INFO - PROCESS | 3373 | RSS: Main: 309878784 11:12:08 INFO - PROCESS | 3373 | 11:12:08 INFO - PROCESS | 3373 | __start_tp_report 11:12:08 INFO - PROCESS | 3373 | _x_x_mozilla_page_load 11:12:08 INFO - PROCESS | 3373 | _x_x_mozilla_page_load_details 11:12:08 INFO - PROCESS | 3373 | |i|pagename|runs| 11:12:08 INFO - PROCESS | 3373 | |0;dojo.html;3066.356065226301;3116.657167711552;3118.968810311897;3154.116847282759;3160.3679264147177;5142.66572672776;5227.921581176276;5288.682679039261;5376.946230537698;5407.810726624574;5342.332208473941;5371.462853714626;5382.38102618199;5387.730613469331;5409.702466364349;4796.90406191876;4808.807647694088;4971.975140124312;5015.247712843066;5057.848264552069;4946.7526623668855;4988.800447982095;5000.899802043545;5020.322256495381;5024.422191447994;4649.628029757629;4825.276208568707;4861.805527778903;4887.3402090717655;4897.314375987365;4913.14020046494;4913.729744864031;4920.188168952119;4926.261060840867;4964.180910149821;4846.224604063368;4901.461857007427;4917;4917.237828136645;4932.975335123301;5133.332666753336;5187.636865419422;5189.143791274435;5241.3710354757295;5423.050966080959;5621.606487545873;5640.830775076754;5664.57515686321;5722.284714410699;5728.856778580527;5727.570432217601;5758.596898217126;5772.2496075510335;5773.509251713609;5773.9422605773825;5431.34823821144;5457.645253058538;5478.424765399655;5480.588955828249;5480.671159730429;5676.205331253628;5766.452187042224;5864.970675146597;5868.149118377812;5953.047512397996;5653.152027195953;5681.914771278434;5694.402087780806;5696.572757043155;5697.401772813795;5716.342620598602;5722.599418040697;5777.653340799566;5788.450097240755;5790;5474.178873169057;5706.828795136153;5721.77112915487;5763.942360576424;5770.365259821417;5713.8285851424525;5722.62802917809;5734.541236701138;5740.1102829061565;5741.540676745851;4223.472065991751;4363.127374525107;4370.562943705668;4373.1472362888935;4405.911881762347;3892.5718171001167;3914.5106861642294;3940.0346915006007;3941.0935484838647;3973.264945985002;5484.424135465719;5485;5487.807926722546;5491.533219676292;5493.23094766733;5544.69504177266;5715.2855893013375;5810.854728631733;5818.8254352369495;5879.265091863517;5449;5453.590980676465;5477.507024367826;5498.395176530578;5527.226188333637;4992.650514464025;5006.874828129326;5007.173816320339;5013.997200559903;5057.747112644353;5781.075027995501;5823.621464604787;5859.414058594191;5984.611000284967;6004.339522652592;5709.457601527848;5711.771529138788;5714.3999880012;5720.399358067343;5727.284089488814;5841;5896.6756828374855;5901.616394934315;5902.911456328245;5903.911441328298;5474.562035037108;5545.805896793593;5547.805826796042;5589;5591.27313449249;5694.743736531949;5697.031504644137;5708.771649133988;5710.314762228393;5713.485786279255;5555.472230138131;5558.471945165203;5558.749856256397;5560.110382338807;5563.582731295088;5347.43851895561;5564.276644036249;5586.245856809279;5607.158926161109;5643.633163844337;5479.123340265538;5515.09001014828;5517.44825517445;5518.724063796713;5520.53075488588;5453.700046497481;5693.089105743061;5707.571932105026;5748.511376533042;5762.078067509178;5379.273798037371;5428.294321738149;5482.259894914136;5488.490665067138;5532.91700624499 11:12:08 INFO - PROCESS | 3373 | |1;ext.html;583.4632138432642;634.9809505714828;639.9360063993598;643.5816719132563;652;32199.19502012448;33017.83491082544;43640;44415.77792111035;44484.332735009004;42389.57610423895;46657.533424665744;46923.53076469234;46978.765106174505;47020;8886.066962968893;9092.454452732823;9095.090490950884;9096.454212747256;9097.772555686095;8838;8954.32842536809;8966.506842123681;8977.551122443885;8981.550922453884;9028;9078.409903356294;9081.409708368936;9088.272938164931;9089.409188402733;9009.729708108767;9055.411398259157;9071.228945539637;9077.863832042525;9079.81840363189;8878.911210887938;8904.554772261426;8964.462132272085;8964.641414343418;8989.955050224773;42964;43257;43346.56653433457;43349.133017339474;43384;3463.8960831175104;3634.854605815764;3645.0705070206927;3658.743887927846;3691.53855768029;32342.514862277083;32616.184595385068;32860.50709239364;32888.835555822305;32972;4365.781710914442;4394.384786129945;4437.378766972626;4510.661700372485;4605.4933957264675;360590;360726.1963690191;361541;361756;362068;61332.69333653392;61487;61885;61895;61963.6901815488;63685.68157159184;64304;64387.356126439074;64469.35530644727;64486.67756661187;16290;16387.508374748777;16479.505614831574;16480.752788708178;16506.75239871403;12522;12593.748125037448;12601.621951341474;12607.49570017189;12615.369231538387;16999.830001699826;18027.369042083465;18056.18747156381;18119.72820407695;18133.45599632013;6252.874942501125;6593.967030164818;6600.86798264032;6744.932550674529;6758.425533829582;1021.5505177721778;1030.9329893557044;1059.6979860739807;1151.6832870960552;1228.0666693312967;32366.35267294688;33594;33710.831445843105;35295.4705679415;36493.27013459769;1051.321897376188;1086.315621158665;1155.4800339847102;1194.3908606610516;1274.4965738533413;17411.564710882078;17844.732329015074;18062.632934343448;19109.235630574898;19189.712154317698;496467;499837;501821;503891;503956;59801.10298345528;59822.99999999913;60019;60178.398216018155;60341.094883576785;1259.5654499197763;1365.1808914651328;1373.086897213362;1380.9861901380857;1420.5454254638416;32732;33854.66145338515;34149;34463;34507.30985380228;49091.50908490869;49251.26123108228;49470.752646236535;49497.75251123722;49595.25607115824;392774;397106;397108;397142;398393;25091.87454062718;25840;27570.86214568914;28223.57664634991;28460.715392846636;48054;48287.75856120697;48497.75751121222;49356.50643493519;49518.75240623774;39767.403488948265;40849;41409.37885931774;41596.3760543586;42215;41258;41315.7934210327;41509.58490415057;41731;41995;40529.1894162121;40659.59340406676;41712.58287417087;41808.1638367237;42053.36919946264;34786.478202827486;36351.27297453983;36924.815375922946;37009.81495092507;37133.62866371302;27983.860080699465;28078;28250.71749282481;28563.857180713963;28663.57004644974 11:12:08 INFO - PROCESS | 3373 | |2;jquery.html;370.07850452373583;381.4640430195576;388.2293647110486;392.444690762571;406.7274925799714;17463.214155363006;18896.5275868103;19416.320428784977;19424.902875485637;19473.902630486828;18153.455396338097;18186.454406367797;18809.24763009478;18809.247630094815;18959.241630334804;5294.602904782157;5636.774529018834;5735.713214339287;5823.242978412822;5834.124881267822;5487.478689524489;5589.944100558983;5601.243832082658;5611.018071837432;5615.438456154393;5604.579656525756;5607.130894711327;5608.186812912146;5815.360310365856;6297.685115744217;6114.266288045441;6183.536234782365;6227.1282020517165;6244.3755624437645;6287.308396076428;5327.680339179662;5440.211169380417;5442.482964118402;5449.427810079964;5563.415841336682;12865.935670321682;12934.547290844775;12969.092163548556;15760.448384306494;22765.203217887294;2162.7837216278404;2260.615695331781;2276.7495575486682;2430.6232533957264;2832.7733781297447;9257.953710231473;9378;9564.856527152098;9765.755856103584;9921.156701680366;1821.9817801821944;1899.2497963304556;1912.3880358285214;1918.8560857935572;1948.5128717820544;50292.579409208374;80166;81217.18782812155;83151;85306.14693853106;9977.501124943723;10116.494175291205;10150.03574660406;10158.746031349276;10270.691879243635;13561.186328820302;13915.65210869716;14158.787618185735;14692.118472891447;14719.55841324762;7753.418493613001;7867.055953285642;7895.447318687637;7935.404844636675;7956.801079972931;7421.443391745641;7481.9251807482315;7514.549127052394;7582.734604288823;7621.275978782118;4688.718676879398;4689.812407503729;4731.313959475857;4751.548602882721;4809.951900480951;1901.486598618393;1911.9522011949534;1920.596674698329;1943.7181608666947;2015.1334925981969;951.1487218939011;988;1000.1148983149819;1004.969850904474;1044.6657069737612;18357.541061473305;18448.49707202349;19284.325048623232;19313.613727725366;19414.2234310626;980.4852452462371;987.2891518106951;1001.5693251901606;1046.387863100095;1049.2550289294686;10464.110550603284;10652.520636571218;10831.512581933832;10839.295445795999;10866.619668311729;487874;494294;519007;523810;524437;91660.54169729109;91965.54017229872;92384;93144.53427732817;93200;958.6980101268078;960.09750834217;1022.6318525330875;1030.108955753268;1036.8859425463193;16603.66792664164;16753.581160471087;16865.409710660068;16883.66232675364;17120.143992800062;30449;39243;39399.606003939596;41009.38485922654;41826.1634767309;49019.50980490149;54038.45961540334;54613;55962.440375595725;56522;7995.360371170409;8050.758477245692;8146.144654811396;8170.632321545426;8320.417570769989;8968.82062358736;12076.275423474619;13039.217646941213;13223.47106115783;13231.603051908458;10631.149508039183;10755.643964194514;11345.432728363383;11488.138389620979;11627.59303424376;10812.297200681931;11142.442877856236;11363.375014373958;11378.31730096197;11418.543258269576;11593.88406115928;11774.882251177378;11784.41077946082;11794.528218871492;11932.477894549003;8107.310878575151;8115.269625733712;8187.631556579849;8243.299319557906;8683.08827573121;10928.890711093105;11044.392558409043;11051.392173430539;11467.369294688871;11501.712457188638 11:12:08 INFO - PROCESS | 3373 | |3;mootools.html;1327.754365442394;1475.763877779555;1508.1177511155972;1639.295103105664;1778.5109094998866;8068.6772529098835;8398.706045288416;8408.201220884013;8574.91425085749;8577.614007369668;8306;8485;8490.533020683875;8507.872381914261;8510.48937063775;1956.2664000999625;2026.827719643832;2205.3273751505862;2213.6458166693333;2255.842091053627;2237.9104835806547;2267.11582482831;2272.681844530177;2274.4882401459704;2274.863508189514;2251.212075773474;2260.457490202356;2281;2282.8173746100356;2286.576983258094;1899.43017094871;2147.6134295826746;2183.5742030304095;2218.190360518407;2241.887905604713;2173.880436575988;2193.407779899418;2194.6817711431754;2197.5934452126407;2198.296545105567;8416.2004609562;8476.364272679511;8482.236598706146;8483;8483.109273526314;4938.604911607099;5010.3737032870895;5064.468230835783;5068.72122033288;5071.56891664209;3020.6375234971943;3081.3221091359865;3228.418884600771;3243.4323993301314;3249.2689144942437;1054.8154073037265;1070.903618674323;1076.1498416251152;1078.1751959750798;1079.3200283821143;11588.536458541648;11627.94186029073;11629.185956983014;11643.76712465746;11660.358680272497;4423.646108311327;4444.599986001275;4522.23122069249;4523.5024147343765;4529.569690879362;9817.165540928958;9837;9837.458939758382;9845.75385615351;9845.950770246247;4964.255361695702;5030.949690503048;5032.723200224023;5032.84901452957;5037.5214354636255;4090.2433049885867;4561.566651168134;4647.047355292157;4723.7401942893475;4725.763711814396;3755.830987605564;3799.810009499514;3856.903577410531;3857.903552411156;3891.1828516011387;1232.778099942001;1239.2192918461492;1258.169608058695;1259.4710221706905;1263.7505240671435;1003.2174903575223;1017.333646461554;1020.637673625867;1022.3456987527989;1022.8619136416637;5676.489115979582;5824.155497452845;5924.644521328734;5958.82123536286;6082.361352058058;434.3745007189637;434.39835827379306;449.3776120073656;450.8782628690235;451.45825009988147;4149.128682976609;4173.290540608104;4190.832366705358;4214.831406743696;4256.765877876746;10028.598856045823;10269.127124194527;10277.845832312521;10372.42951637652;10398.948005260077;10101.797964040677;10148.137408320375;10174.593016279267;10180.490975451197;10198.43908585035;7859.292663660298;7868.331191848757;7916.08964969036;7937.2062793721325;7943.523388596703;5791.7683292667825;5816.82549523515;5894.322152952465;5993.130996005642;6029.155918171372;9372.1565059145;9752.122308992224;9785.902140978498;9853.078649663246;9855.753606159904;9730.902690973282;9743.31796774219;9793.902060979299;9796.069373409515;9870.753231169278;6488.772892948724;7419.258074192753;7547.05661792276;7710.4217183710325;7967.203279671987;8003.239692229229;8148.674053038049;8223.05434874997;8224.917750822655;8225.218604232588;6866.279040700854;7238.493305468567;7432.591207483424;7493.812654683677;7552.584607846621;7215.134183897966;7418.629068546443;7425.70297188128;7469.327760501581;7516.24837516244;6786.728530858711;6868.416184624363;6922;6922.169339679271;6922.480813938874;4845.9757701211265;4855.781489832895;4866.245731911559;4959.801607935642;5112.923306150336;5140.049090918192;5155.458676838878;5161.870953226199;5285.207218917193;5316.627836051439 11:12:08 INFO - PROCESS | 3373 | |4;prototype.html;301.8792483006798;316.49677013548455;320.64728798321835;322.55970600130826;323.1807368321306;5003.699778013312;5070.960453107114;5120.718360490171;5186.844394668156;5189.481051894813;5029.597632189425;5090.371081254;5092.446803724863;5119.206522988943;5122.821750997273;4020.8592699255532;4025.4163146343762;4033.556308806029;4034.11249525104;4038.818253178599;3809.257194847006;3872;4010.238054769599;4023.23558523881;4023.577524359944;3962.4056391541353;3991.7006224533275;4008.939865902014;4021.3565829467293;4028.1742242840146;3980.661643760284;3983.4821473208444;3989.7207195496326;3990.980045099785;4033.7983100845136;3473.322702073097;3550.7692000019915;3552.1652411683235;3561.2371875921326;3567.6967457765863;4973.4280557735965;4988.127077761414;5003.274525193827;5007.524285192901;5027.622928280357;4576.565226303496;4583.395811465994;4593.173228818811;4597.448306203243;4598.586127248564;5184.844454666366;5289.523942845124;5318.521333080042;5407.648502847303;5415.6479828811;3942.752631000331;3947.7695102267126;3950.2692001979726;3951.525816901961;3956.4658771066115;5553.361363443215;5579.944200558024;5625.9184101882565;5637.267155269788;5665.886682266331;3824.7513911595656;3966.2464131814863;3980.980095099506;3987.342088555356;3989.4414781930554;3996.5603783583783;4007.7996100194873;4022.0950286185957;4023.295923213426;4035.152617950205;4495.752733599684;4557.863264102082;4566.127887566082;4593.632509399307;4623.214053610895;5253.213907271546;5360.981413531416;5379.273798037293;5399.433059528771;5399.839034607499;1320.214472388927;1362.8160198373291;1388.687545302299;1390.3673828408253;1391.7703578909568;895.6820328783318;905.1355955062899;906.057699992001;920.7652048727665;920.9907900921039;4585.426821647294;4622.422197225347;4671.766411679402;4719.9292010619865;4721.536323739583;4845.49122342149;4872.537108974641;4892.363992680928;4895.388076490439;4897.4857639948;4323.513979461822;4625.687156421789;4656.441227052707;4674.392328997209;4707;2572.9099481518056;2613.2421597736443;2623.6720409948757;2623.698274698396;2625.474905019004;5022.89954200914;5033.7734801934;5038.370203724535;5061.392632884003;5073.898522029539;4719.622430205644;4795.878120990326;4922.975385123052;4980.377452818398;5064.265681476165;5054.848354549369;5056.469070747518;5076.7207803571155;5076.82231121909;5095.643304968617;4826.348442960296;4842.491538388418;4867.95132048675;4900.313956046228;4920.901581968412;4646.465656449552;4806.615470762401;4844.909895273535;4862.659613826998;4866.975665121652;5078.97460512695;5080.221922327156;5122.359705036871;5132.204508301219;5161.354830646169;3649.233660931128;3674.7138501525324;3679.595244523047;3725.231703419627;3730.515033045687;4924.212126059813;4936.950630493649;4938.506149385033;4959.578435832995;5202.97398513005;5022.292420577021;5425.263915546987;5450.781968721365;5469.234307196916;5473.480019398151;5393.352797664305;5423.457654234545;5441.319835020622;5443.237946687546;5451.56387488992;5098.923516147335;5205.85046047136;5296.126139187145;5332.440093790096;5333.653312534673;5438.374586922397;5441.591880608891;5465.07093794048;5494.642848214853;5508.697021663847;5360.0887849064975;5360.84741780519;5368.7047212403695;5379.031774280667;5388.245645609696 11:12:08 INFO - PROCESS | 3373 | |5;yui.html;742.4060751398883;742.6027075514601;772.8029352515108;792.1682233654661;803.5901690138028;12918.93540532296;14161.079529830553;14751.852481475182;15480.535583932471;15717.449889253878;14433.061850979679;14672.853271467282;14707.779383309258;14786.556403307892;14854.1830199339;671.7044500419825;807.7536351412816;814.3932770086265;815.1115284340083;821.5481485183155;806.7095845495646;825.2490233887164;826.2852632472927;828.3828547731948;829.4442723375353;870.6038752367657;874.8556488179474;874.9387542872001;875.4003507597284;875.9343049271298;869.395769939892;870.1211776106147;870.268974061788;870.4603146049458;870.791010157564;631.1321932343028;631.2235949781794;631.356016862802;631.7851930343705;632.175011609849;14655.92672036633;14666.926665366605;14682.926585367111;14685.55943321702;14685.926570367186;14465;14493;14512.27438628075;14548.781768273484;14580.270986450741;11166.441677916153;11179.4969226385;11546.01858841991;11547.133964952662;12099.697507562294;3677.1802016262877;3694.4643026761237;3701.8889433317045;3764.569463603813;3776.131489757371;52905.7354713224;54501.182482262404;55119;55980;56165.43834561643;10295.279330446947;10300.278980471296;10353.9482302588;10447.373157610567;10701.571937122584;19626.509337266398;19629.31297404584;19635.41093767189;19657.213711451383;19673.409797706092;8204.261616454547;8208;8266.214709602578;8366.24703776663;8481.15188481147;4628.282616194495;4701.741404222732;4725.031368569435;4728.858134255978;4857.6599638025;3339.1819004343606;3392.8642854285554;3393.5588373511778;3395.151212196951;3433.261848702491;614.1034090228317;624.1106423346804;631.7725618777237;645.1645119570168;651.569963823874;569.1633299050472;597.6520811099201;612.8570216546109;621.2606997672755;731.4331393170229;9517;9832.852507212398;9847.655332063343;9931.751706207402;9935.304528682922;730.817295676081;745.9440541959375;748.5246868238708;749.6543704051242;753.9019927409512;4209.848090600402;4465.37484752135;4494.70784399013;4531;4544.772761361919;69898;70326.64836675886;70417;70607.64696176487;70825.2917470829;60922.39077609167;62911.685441572496;62972.68513657402;63422.68288658527;64434;55554.722226389415;55758.72120639371;56235.71882140563;56249.718751405984;56788;9083.545822708971;9815.383697694579;10143.391396516232;10266.384016959006;10411.67305848515;38229.61770382261;38236.235275294894;39049.804750976065;39122.217555649295;39371.409428858016;50382;50791.74604126956;50869;51128.48871511237;51875.22187167271;12134.211276267015;12409.689757756129;12796.744065118832;12851.421686023965;13242.933785331012;13709.725805483635;13725.725485490035;13968.58094257174;14111.082779619292;14277.857221427652;13654.385552649956;13663.513318288828;13769.724605508034;13894.930525347309;14099.224542650252;13520.729585408433;13633.38649760783;13655.497895231716;13775.517856874962;14367.353469093707;12833.358332083546;13304.334783260605;13659.112157709716;13694.863051369359;14003;10519.842202367123;10603.681889543326;10812.945935270272;10860.782784344427;10913.18151138652;10997.395143267197;11125.443727813416;11233.606823761129;11623.244489108181;11633.185677002866 11:12:08 INFO - PROCESS | 3373 | __end_tp_report 11:12:08 INFO - PROCESS | 3373 | __start_cc_report 11:12:08 INFO - PROCESS | 3373 | _x_x_mozilla_cycle_collect,1082 11:12:08 INFO - PROCESS | 3373 | __end_cc_report 11:12:08 INFO - PROCESS | 3373 | __startTimestamp1464372728109__endTimestamp 11:12:08 INFO - PROCESS | 3373 | 11:12:08 INFO - PROCESS | 3373 | ------- Summary: start ------- 11:12:08 INFO - PROCESS | 3373 | Number of tests: 6 11:12:08 INFO - PROCESS | 3373 | 11:12:08 INFO - PROCESS | 3373 | [#0] dojo.html Cycles:165 Average:5324.88 Median:5498.40 stddev:592.77 (10.8%) stddev-sans-first:567.49 11:12:08 INFO - PROCESS | 3373 | Values: 3066.4 3116.7 3119.0 3154.1 3160.4 5142.7 5227.9 5288.7 5376.9 5407.8 5342.3 5371.5 5382.4 5387.7 5409.7 4796.9 4808.8 4972.0 5015.2 5057.8 4946.8 4988.8 5000.9 5020.3 5024.4 4649.6 4825.3 4861.8 4887.3 4897.3 4913.1 4913.7 4920.2 4926.3 4964.2 4846.2 4901.5 4917.0 4917.2 4933.0 5133.3 5187.6 5189.1 5241.4 5423.1 5621.6 5640.8 5664.6 5722.3 5728.9 5727.6 5758.6 5772.2 5773.5 5773.9 5431.3 5457.6 5478.4 5480.6 5480.7 5676.2 5766.5 5865.0 5868.1 5953.0 5653.2 5681.9 5694.4 5696.6 5697.4 5716.3 5722.6 5777.7 5788.5 5790.0 5474.2 5706.8 5721.8 5763.9 5770.4 5713.8 5722.6 5734.5 5740.1 5741.5 4223.5 4363.1 4370.6 4373.1 4405.9 3892.6 3914.5 3940.0 3941.1 3973.3 5484.4 5485.0 5487.8 5491.5 5493.2 5544.7 5715.3 5810.9 5818.8 5879.3 5449.0 5453.6 5477.5 5498.4 5527.2 4992.7 5006.9 5007.2 5014.0 5057.7 5781.1 5823.6 5859.4 5984.6 6004.3 5709.5 5711.8 5714.4 5720.4 5727.3 5841.0 5896.7 5901.6 5902.9 5903.9 5474.6 5545.8 5547.8 5589.0 5591.3 5694.7 5697.0 5708.8 5710.3 5713.5 5555.5 5558.5 5558.7 5560.1 5563.6 5347.4 5564.3 5586.2 5607.2 5643.6 5479.1 5515.1 5517.4 5518.7 5520.5 5453.7 5693.1 5707.6 5748.5 5762.1 5379.3 5428.3 5482.3 5488.5 5532.9 11:12:08 INFO - PROCESS | 3373 | 11:12:08 INFO - PROCESS | 3373 | [#1] ext.html Cycles:180 Average:58833.47 Median:41654.48 stddev:112027.07 (268.9%) stddev-sans-first:112255.96 11:12:08 INFO - PROCESS | 3373 | Values: 583.5 635.0 639.9 643.6 652.0 32199.2 33017.8 43640.0 44415.8 44484.3 42389.6 46657.5 46923.5 46978.8 47020.0 8886.1 9092.5 9095.1 9096.5 9097.8 8838.0 8954.3 8966.5 8977.6 8981.6 9028.0 9078.4 9081.4 9088.3 9089.4 9009.7 9055.4 9071.2 9077.9 9079.8 8878.9 8904.6 8964.5 8964.6 8990.0 42964.0 43257.0 43346.6 43349.1 43384.0 3463.9 3634.9 3645.1 3658.7 3691.5 32342.5 32616.2 32860.5 32888.8 32972.0 4365.8 4394.4 4437.4 4510.7 4605.5 360590.0 360726.2 361541.0 361756.0 362068.0 61332.7 61487.0 61885.0 61895.0 61963.7 63685.7 64304.0 64387.4 64469.4 64486.7 16290.0 16387.5 16479.5 16480.8 16506.8 12522.0 12593.7 12601.6 12607.5 12615.4 16999.8 18027.4 18056.2 18119.7 18133.5 6252.9 6594.0 6600.9 6744.9 6758.4 1021.6 1030.9 1059.7 1151.7 1228.1 32366.4 33594.0 33710.8 35295.5 36493.3 1051.3 1086.3 1155.5 1194.4 1274.5 17411.6 17844.7 18062.6 19109.2 19189.7 496467.0 499837.0 501821.0 503891.0 503956.0 59801.1 59823.0 60019.0 60178.4 60341.1 1259.6 1365.2 1373.1 1381.0 1420.5 32732.0 33854.7 34149.0 34463.0 34507.3 49091.5 49251.3 49470.8 49497.8 49595.3 392774.0 397106.0 397108.0 397142.0 398393.0 25091.9 25840.0 27570.9 28223.6 28460.7 48054.0 48287.8 48497.8 49356.5 49518.8 39767.4 40849.0 41409.4 41596.4 42215.0 41258.0 41315.8 41509.6 41731.0 41995.0 40529.2 40659.6 41712.6 41808.2 42053.4 34786.5 36351.3 36924.8 37009.8 37133.6 27983.9 28078.0 28250.7 28563.9 28663.6 11:12:08 INFO - PROCESS | 3373 | 11:12:08 INFO - PROCESS | 3373 | [#2] jquery.html Cycles:180 Average:28793.81 Median:390.34 stddev:83987.55 (21516.7%) stddev-sans-first:84196.04 11:12:08 INFO - PROCESS | 3373 | Values: 370.1 381.5 388.2 392.4 406.7 17463.2 18896.5 19416.3 19424.9 19473.9 18153.5 18186.5 18809.2 18809.2 18959.2 5294.6 5636.8 5735.7 5823.2 5834.1 5487.5 5589.9 5601.2 5611.0 5615.4 5604.6 5607.1 5608.2 5815.4 6297.7 6114.3 6183.5 6227.1 6244.4 6287.3 5327.7 5440.2 5442.5 5449.4 5563.4 12865.9 12934.5 12969.1 15760.4 22765.2 2162.8 2260.6 2276.7 2430.6 2832.8 9258.0 9378.0 9564.9 9765.8 9921.2 1822.0 1899.2 1912.4 1918.9 1948.5 50292.6 80166.0 81217.2 83151.0 85306.1 9977.5 10116.5 10150.0 10158.7 10270.7 13561.2 13915.7 14158.8 14692.1 14719.6 7753.4 7867.1 7895.4 7935.4 7956.8 7421.4 7481.9 7514.5 7582.7 7621.3 4688.7 4689.8 4731.3 4751.5 4810.0 1901.5 1912.0 1920.6 1943.7 2015.1 951.1 988.0 1000.1 1005.0 1044.7 18357.5 18448.5 19284.3 19313.6 19414.2 980.5 987.3 1001.6 1046.4 1049.3 10464.1 10652.5 10831.5 10839.3 10866.6 487874.0 494294.0 519007.0 523810.0 524437.0 91660.5 91965.5 92384.0 93144.5 93200.0 958.7 960.1 1022.6 1030.1 1036.9 16603.7 16753.6 16865.4 16883.7 17120.1 30449.0 39243.0 39399.6 41009.4 41826.2 49019.5 54038.5 54613.0 55962.4 56522.0 7995.4 8050.8 8146.1 8170.6 8320.4 8968.8 12076.3 13039.2 13223.5 13231.6 10631.1 10755.6 11345.4 11488.1 11627.6 10812.3 11142.4 11363.4 11378.3 11418.5 11593.9 11774.9 11784.4 11794.5 11932.5 8107.3 8115.3 8187.6 8243.3 8683.1 10928.9 11044.4 11051.4 11467.4 11501.7 11:12:08 INFO - PROCESS | 3373 | 11:12:08 INFO - PROCESS | 3373 | [#3] mootools.html Cycles:180 Average:5566.61 Median:4850.88 stddev:3151.03 (65.0%) stddev-sans-first:3143.76 11:12:08 INFO - PROCESS | 3373 | Values: 1327.8 1475.8 1508.1 1639.3 1778.5 8068.7 8398.7 8408.2 8574.9 8577.6 8306.0 8485.0 8490.5 8507.9 8510.5 1956.3 2026.8 2205.3 2213.6 2255.8 2237.9 2267.1 2272.7 2274.5 2274.9 2251.2 2260.5 2281.0 2282.8 2286.6 1899.4 2147.6 2183.6 2218.2 2241.9 2173.9 2193.4 2194.7 2197.6 2198.3 8416.2 8476.4 8482.2 8483.0 8483.1 4938.6 5010.4 5064.5 5068.7 5071.6 3020.6 3081.3 3228.4 3243.4 3249.3 1054.8 1070.9 1076.1 1078.2 1079.3 11588.5 11627.9 11629.2 11643.8 11660.4 4423.6 4444.6 4522.2 4523.5 4529.6 9817.2 9837.0 9837.5 9845.8 9846.0 4964.3 5030.9 5032.7 5032.8 5037.5 4090.2 4561.6 4647.0 4723.7 4725.8 3755.8 3799.8 3856.9 3857.9 3891.2 1232.8 1239.2 1258.2 1259.5 1263.8 1003.2 1017.3 1020.6 1022.3 1022.9 5676.5 5824.2 5924.6 5958.8 6082.4 434.4 434.4 449.4 450.9 451.5 4149.1 4173.3 4190.8 4214.8 4256.8 10028.6 10269.1 10277.8 10372.4 10398.9 10101.8 10148.1 10174.6 10180.5 10198.4 7859.3 7868.3 7916.1 7937.2 7943.5 5791.8 5816.8 5894.3 5993.1 6029.2 9372.2 9752.1 9785.9 9853.1 9855.8 9730.9 9743.3 9793.9 9796.1 9870.8 6488.8 7419.3 7547.1 7710.4 7967.2 8003.2 8148.7 8223.1 8224.9 8225.2 6866.3 7238.5 7432.6 7493.8 7552.6 7215.1 7418.6 7425.7 7469.3 7516.2 6786.7 6868.4 6922.0 6922.2 6922.5 4846.0 4855.8 4866.2 4959.8 5112.9 5140.0 5155.5 5161.9 5285.2 5316.6 11:12:08 INFO - PROCESS | 3373 | 11:12:08 INFO - PROCESS | 3373 | [#4] prototype.html Cycles:180 Average:4356.30 Median:4870.24 stddev:1249.82 (25.7%) stddev-sans-first:1215.71 11:12:08 INFO - PROCESS | 3373 | Values: 301.9 316.5 320.6 322.6 323.2 5003.7 5071.0 5120.7 5186.8 5189.5 5029.6 5090.4 5092.4 5119.2 5122.8 4020.9 4025.4 4033.6 4034.1 4038.8 3809.3 3872.0 4010.2 4023.2 4023.6 3962.4 3991.7 4008.9 4021.4 4028.2 3980.7 3983.5 3989.7 3991.0 4033.8 3473.3 3550.8 3552.2 3561.2 3567.7 4973.4 4988.1 5003.3 5007.5 5027.6 4576.6 4583.4 4593.2 4597.4 4598.6 5184.8 5289.5 5318.5 5407.6 5415.6 3942.8 3947.8 3950.3 3951.5 3956.5 5553.4 5579.9 5625.9 5637.3 5665.9 3824.8 3966.2 3981.0 3987.3 3989.4 3996.6 4007.8 4022.1 4023.3 4035.2 4495.8 4557.9 4566.1 4593.6 4623.2 5253.2 5361.0 5379.3 5399.4 5399.8 1320.2 1362.8 1388.7 1390.4 1391.8 895.7 905.1 906.1 920.8 921.0 4585.4 4622.4 4671.8 4719.9 4721.5 4845.5 4872.5 4892.4 4895.4 4897.5 4323.5 4625.7 4656.4 4674.4 4707.0 2572.9 2613.2 2623.7 2623.7 2625.5 5022.9 5033.8 5038.4 5061.4 5073.9 4719.6 4795.9 4923.0 4980.4 5064.3 5054.8 5056.5 5076.7 5076.8 5095.6 4826.3 4842.5 4868.0 4900.3 4920.9 4646.5 4806.6 4844.9 4862.7 4867.0 5079.0 5080.2 5122.4 5132.2 5161.4 3649.2 3674.7 3679.6 3725.2 3730.5 4924.2 4937.0 4938.5 4959.6 5203.0 5022.3 5425.3 5450.8 5469.2 5473.5 5393.4 5423.5 5441.3 5443.2 5451.6 5098.9 5205.9 5296.1 5332.4 5333.7 5438.4 5441.6 5465.1 5494.6 5508.7 5360.1 5360.8 5368.7 5379.0 5388.2 11:12:08 INFO - PROCESS | 3373 | 11:12:08 INFO - PROCESS | 3373 | [#5] yui.html Cycles:180 Average:15977.93 Median:4512.85 stddev:19048.52 (422.1%) stddev-sans-first:19067.60 11:12:08 INFO - PROCESS | 3373 | Values: 742.4 742.6 772.8 792.2 803.6 12918.9 14161.1 14751.9 15480.5 15717.4 14433.1 14672.9 14707.8 14786.6 14854.2 671.7 807.8 814.4 815.1 821.5 806.7 825.2 826.3 828.4 829.4 870.6 874.9 874.9 875.4 875.9 869.4 870.1 870.3 870.5 870.8 631.1 631.2 631.4 631.8 632.2 14655.9 14666.9 14682.9 14685.6 14685.9 14465.0 14493.0 14512.3 14548.8 14580.3 11166.4 11179.5 11546.0 11547.1 12099.7 3677.2 3694.5 3701.9 3764.6 3776.1 52905.7 54501.2 55119.0 55980.0 56165.4 10295.3 10300.3 10353.9 10447.4 10701.6 19626.5 19629.3 19635.4 19657.2 19673.4 8204.3 8208.0 8266.2 8366.2 8481.2 4628.3 4701.7 4725.0 4728.9 4857.7 3339.2 3392.9 3393.6 3395.2 3433.3 614.1 624.1 631.8 645.2 651.6 569.2 597.7 612.9 621.3 731.4 9517.0 9832.9 9847.7 9931.8 9935.3 730.8 745.9 748.5 749.7 753.9 4209.8 4465.4 4494.7 4531.0 4544.8 69898.0 70326.6 70417.0 70607.6 70825.3 60922.4 62911.7 62972.7 63422.7 64434.0 55554.7 55758.7 56235.7 56249.7 56788.0 9083.5 9815.4 10143.4 10266.4 10411.7 38229.6 38236.2 39049.8 39122.2 39371.4 50382.0 50791.7 50869.0 51128.5 51875.2 12134.2 12409.7 12796.7 12851.4 13242.9 13709.7 13725.7 13968.6 14111.1 14277.9 13654.4 13663.5 13769.7 13894.9 14099.2 13520.7 13633.4 13655.5 13775.5 14367.4 12833.4 13304.3 13659.1 13694.9 14003.0 10519.8 10603.7 10812.9 10860.8 10913.2 10997.4 11125.4 11233.6 11623.2 11633.2 11:12:08 INFO - PROCESS | 3373 | -------- Summary: end -------- 11:12:08 INFO - PROCESS | 3373 | 11:12:08 INFO - TEST-INFO | 3373: exit 0 11:12:08 INFO - TEST-OK | dromaeo_css | took 1115560ms 11:12:08 INFO - TEST-START | kraken 11:12:08 INFO - operating with platform_type : linux_ 11:12:08 INFO - Initialising browser for kraken test... 11:12:08 INFO - TEST-INFO | started process 3557 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUmVLjh/profile http://localhost:59916/getInfo.html) 11:12:12 INFO - PROCESS | 3557 | __metrics Screen width/height:1600/1200 11:12:12 INFO - PROCESS | 3557 | colorDepth:24 11:12:12 INFO - PROCESS | 3557 | Browser inner width/height: 1024/697 11:12:12 INFO - PROCESS | 3557 | __metrics 11:12:13 ERROR - PROCESS | 3557 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:12:14 INFO - TEST-INFO | 3557: exit 0 11:12:14 INFO - Browser initialized. 11:12:14 INFO - Running cycle 1/1 for kraken test... 11:12:14 INFO - TEST-INFO | started process 3635 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUmVLjh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:12:26 INFO - PROCESS | 3635 | RSS: Main: 155516928 11:12:26 INFO - PROCESS | 3635 | 11:12:28 INFO - PROCESS | 3635 | Cycle 1(1): loaded http://localhost:59916/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59916/tests/kraken/driver.html?testName=audio-beat-detection) 11:12:29 INFO - PROCESS | 3635 | RSS: Main: 213147648 11:12:29 INFO - PROCESS | 3635 | 11:12:32 INFO - PROCESS | 3635 | Cycle 1(1): loaded http://localhost:59916/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59916/tests/kraken/driver.html?testName=audio-dft) 11:12:33 INFO - PROCESS | 3635 | RSS: Main: 198934528 11:12:33 INFO - PROCESS | 3635 | 11:12:36 INFO - PROCESS | 3635 | Cycle 1(1): loaded http://localhost:59916/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59916/tests/kraken/driver.html?testName=audio-fft) 11:12:36 INFO - PROCESS | 3635 | RSS: Main: 268079104 11:12:36 INFO - PROCESS | 3635 | 11:12:38 INFO - PROCESS | 3635 | Cycle 1(1): loaded http://localhost:59916/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59916/tests/kraken/driver.html?testName=audio-oscillator) 11:12:39 INFO - PROCESS | 3635 | RSS: Main: 179740672 11:12:39 INFO - PROCESS | 3635 | 11:12:41 INFO - PROCESS | 3635 | Cycle 1(1): loaded http://localhost:59916/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59916/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:12:42 INFO - PROCESS | 3635 | RSS: Main: 183537664 11:12:42 INFO - PROCESS | 3635 | 11:12:45 INFO - PROCESS | 3635 | Cycle 1(1): loaded http://localhost:59916/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59916/tests/kraken/driver.html?testName=imaging-darkroom) 11:12:45 INFO - PROCESS | 3635 | RSS: Main: 217870336 11:12:45 INFO - PROCESS | 3635 | 11:12:49 INFO - PROCESS | 3635 | Cycle 1(1): loaded http://localhost:59916/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59916/tests/kraken/driver.html?testName=imaging-desaturate) 11:12:49 INFO - PROCESS | 3635 | RSS: Main: 219844608 11:12:49 INFO - PROCESS | 3635 | 11:12:52 INFO - PROCESS | 3635 | Cycle 1(1): loaded http://localhost:59916/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59916/tests/kraken/driver.html?testName=json-parse-financial) 11:12:53 INFO - PROCESS | 3635 | RSS: Main: 219701248 11:12:53 INFO - PROCESS | 3635 | 11:12:54 INFO - PROCESS | 3635 | Cycle 1(1): loaded http://localhost:59916/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59916/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:12:55 INFO - PROCESS | 3635 | RSS: Main: 207646720 11:12:55 INFO - PROCESS | 3635 | 11:12:57 INFO - PROCESS | 3635 | Cycle 1(1): loaded http://localhost:59916/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59916/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:12:57 INFO - PROCESS | 3635 | RSS: Main: 210165760 11:12:57 INFO - PROCESS | 3635 | 11:13:00 INFO - PROCESS | 3635 | Cycle 1(1): loaded http://localhost:59916/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59916/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:13:00 INFO - PROCESS | 3635 | RSS: Main: 215851008 11:13:00 INFO - PROCESS | 3635 | 11:13:03 INFO - PROCESS | 3635 | Cycle 1(1): loaded http://localhost:59916/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59916/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:13:04 INFO - PROCESS | 3635 | RSS: Main: 223518720 11:13:04 INFO - PROCESS | 3635 | 11:13:06 INFO - PROCESS | 3635 | Cycle 1(1): loaded http://localhost:59916/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59916/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:13:07 INFO - PROCESS | 3635 | RSS: Main: 223277056 11:13:07 INFO - PROCESS | 3635 | 11:13:08 INFO - PROCESS | 3635 | Cycle 1(1): loaded http://localhost:59916/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59916/tests/kraken/driver.html?testName=ai-astar) 11:13:09 INFO - PROCESS | 3635 | RSS: Main: 265117696 11:13:09 INFO - PROCESS | 3635 | 11:13:09 INFO - PROCESS | 3635 | __start_tp_report 11:13:09 INFO - PROCESS | 3635 | _x_x_mozilla_page_load 11:13:09 INFO - PROCESS | 3635 | _x_x_mozilla_page_load_details 11:13:09 INFO - PROCESS | 3635 | |i|pagename|runs| 11:13:09 INFO - PROCESS | 3635 | |0;ai-astar;111;106;113;111;111;112;111;110;111;112 11:13:09 INFO - PROCESS | 3635 | |1;audio-beat-detection;159;124;132;183;129;129;156;123;187;123 11:13:09 INFO - PROCESS | 3635 | |2;audio-dft;161;161;160;159;160;160;161;161;159;161 11:13:09 INFO - PROCESS | 3635 | |3;audio-fft;75;75;74;113;75;75;74;73;103;74 11:13:09 INFO - PROCESS | 3635 | |4;audio-oscillator;83;83;125;82;83;84;120;82;82;118 11:13:09 INFO - PROCESS | 3635 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;117;117;117 11:13:09 INFO - PROCESS | 3635 | |6;imaging-darkroom;147;145;145;145;147;146;145;146;147;145 11:13:09 INFO - PROCESS | 3635 | |7;imaging-desaturate;95;95;95;95;94;95;94;94;95;94 11:13:09 INFO - PROCESS | 3635 | |8;json-parse-financial;54;52;53;52;54;54;52;52;53;53 11:13:09 INFO - PROCESS | 3635 | |9;json-stringify-tinderbox;64;64;64;64;65;64;65;65;65;65 11:13:09 INFO - PROCESS | 3635 | |10;stanford-crypto-aes;80;80;83;78;80;80;86;80;113;84 11:13:09 INFO - PROCESS | 3635 | |11;stanford-crypto-ccm;127;128;127;128;125;120;120;123;130;121 11:13:09 INFO - PROCESS | 3635 | |12;stanford-crypto-pbkdf2;160;158;162;158;164;167;158;158;161;156 11:13:09 INFO - PROCESS | 3635 | |13;stanford-crypto-sha256-iterative;62;63;63;64;61;70;62;61;61;62 11:13:09 INFO - PROCESS | 3635 | __end_tp_report 11:13:09 INFO - PROCESS | 3635 | __start_cc_report 11:13:09 INFO - PROCESS | 3635 | _x_x_mozilla_cycle_collect,1607 11:13:09 INFO - PROCESS | 3635 | __end_cc_report 11:13:09 INFO - PROCESS | 3635 | __startTimestamp1464372789189__endTimestamp 11:13:09 INFO - PROCESS | 3635 | 11:13:09 INFO - PROCESS | 3635 | ------- Summary: start ------- 11:13:09 INFO - PROCESS | 3635 | Number of tests: 14 11:13:09 INFO - PROCESS | 3635 | 11:13:09 INFO - PROCESS | 3635 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:1.87 (1.7%) stddev-sans-first:1.99 11:13:09 INFO - PROCESS | 3635 | Values: 111.0 106.0 113.0 111.0 111.0 112.0 111.0 110.0 111.0 112.0 11:13:09 INFO - PROCESS | 3635 | 11:13:09 INFO - PROCESS | 3635 | [#1] audio-beat-detection Cycles:10 Average:144.50 Median:144.00 stddev:24.97 (17.3%) stddev-sans-first:25.93 11:13:09 INFO - PROCESS | 3635 | Values: 159.0 124.0 132.0 183.0 129.0 129.0 156.0 123.0 187.0 123.0 11:13:09 INFO - PROCESS | 3635 | 11:13:09 INFO - PROCESS | 3635 | [#2] audio-dft Cycles:10 Average:160.30 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 11:13:09 INFO - PROCESS | 3635 | Values: 161.0 161.0 160.0 159.0 160.0 160.0 161.0 161.0 159.0 161.0 11:13:09 INFO - PROCESS | 3635 | 11:13:09 INFO - PROCESS | 3635 | [#3] audio-fft Cycles:10 Average:81.10 Median:74.50 stddev:14.39 (19.3%) stddev-sans-first:15.09 11:13:09 INFO - PROCESS | 3635 | Values: 75.0 75.0 74.0 113.0 75.0 75.0 74.0 73.0 103.0 74.0 11:13:09 INFO - PROCESS | 3635 | 11:13:09 INFO - PROCESS | 3635 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:82.50 stddev:18.58 (22.5%) stddev-sans-first:19.26 11:13:09 INFO - PROCESS | 3635 | Values: 83.0 83.0 125.0 82.0 83.0 84.0 120.0 82.0 82.0 118.0 11:13:09 INFO - PROCESS | 3635 | 11:13:09 INFO - PROCESS | 3635 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:13:09 INFO - PROCESS | 3635 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 11:13:09 INFO - PROCESS | 3635 | 11:13:09 INFO - PROCESS | 3635 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 11:13:09 INFO - PROCESS | 3635 | Values: 147.0 145.0 145.0 145.0 147.0 146.0 145.0 146.0 147.0 145.0 11:13:09 INFO - PROCESS | 3635 | 11:13:09 INFO - PROCESS | 3635 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 11:13:09 INFO - PROCESS | 3635 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 94.0 94.0 95.0 94.0 11:13:09 INFO - PROCESS | 3635 | 11:13:09 INFO - PROCESS | 3635 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:0.88 (1.7%) stddev-sans-first:0.83 11:13:09 INFO - PROCESS | 3635 | Values: 54.0 52.0 53.0 52.0 54.0 54.0 52.0 52.0 53.0 53.0 11:13:09 INFO - PROCESS | 3635 | 11:13:09 INFO - PROCESS | 3635 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 11:13:09 INFO - PROCESS | 3635 | Values: 64.0 64.0 64.0 64.0 65.0 64.0 65.0 65.0 65.0 65.0 11:13:09 INFO - PROCESS | 3635 | 11:13:09 INFO - PROCESS | 3635 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:80.00 stddev:10.33 (12.9%) stddev-sans-first:10.83 11:13:09 INFO - PROCESS | 3635 | Values: 80.0 80.0 83.0 78.0 80.0 80.0 86.0 80.0 113.0 84.0 11:13:09 INFO - PROCESS | 3635 | 11:13:09 INFO - PROCESS | 3635 | [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:127.00 stddev:3.67 (2.9%) stddev-sans-first:3.81 11:13:09 INFO - PROCESS | 3635 | Values: 127.0 128.0 127.0 128.0 125.0 120.0 120.0 123.0 130.0 121.0 11:13:09 INFO - PROCESS | 3635 | 11:13:09 INFO - PROCESS | 3635 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:160.50 stddev:3.36 (2.1%) stddev-sans-first:3.56 11:13:09 INFO - PROCESS | 3635 | Values: 160.0 158.0 162.0 158.0 164.0 167.0 158.0 158.0 161.0 156.0 11:13:09 INFO - PROCESS | 3635 | 11:13:09 INFO - PROCESS | 3635 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:62.50 stddev:2.69 (4.3%) stddev-sans-first:2.83 11:13:09 INFO - PROCESS | 3635 | Values: 62.0 63.0 63.0 64.0 61.0 70.0 62.0 61.0 61.0 62.0 11:13:09 INFO - PROCESS | 3635 | -------- Summary: end -------- 11:13:09 INFO - PROCESS | 3635 | 11:13:10 INFO - TEST-INFO | 3635: exit 0 11:13:10 INFO - TEST-OK | kraken | took 61219ms 11:13:10 INFO - SUITE-END | took 1176s 11:13:10 INFO - Completed test suite (00:19:37) 11:13:10 INFO - javascript benchmark 11:13:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3066.356065226301, 3116.657167711552, 3118.968810311897, 3154.116847282759, 3160.3679264147177, 5142.66572672776, 5227.921581176276, 5288.682679039261, 5376.946230537698, 5407.810726624574, 5342.332208473941, 5371.462853714626, 5382.38102618199, 5387.730613469331, 5409.702466364349, 4796.90406191876, 4808.807647694088, 4971.975140124312, 5015.247712843066, 5057.848264552069, 4946.7526623668855, 4988.800447982095, 5000.899802043545, 5020.322256495381, 5024.422191447994, 4649.628029757629, 4825.276208568707, 4861.805527778903, 4887.3402090717655, 4897.314375987365, 4913.14020046494, 4913.729744864031, 4920.188168952119, 4926.261060840867, 4964.180910149821, 4846.224604063368, 4901.461857007427, 4917.0, 4917.237828136645, 4932.975335123301, 5133.332666753336, 5187.636865419422, 5189.143791274435, 5241.3710354757295, 5423.050966080959, 5621.606487545873, 5640.830775076754, 5664.57515686321, 5722.284714410699, 5728.856778580527, 5727.570432217601, 5758.596898217126, 5772.2496075510335, 5773.509251713609, 5773.9422605773825, 5431.34823821144, 5457.645253058538, 5478.424765399655, 5480.588955828249, 5480.671159730429, 5676.205331253628, 5766.452187042224, 5864.970675146597, 5868.149118377812, 5953.047512397996, 5653.152027195953, 5681.914771278434, 5694.402087780806, 5696.572757043155, 5697.401772813795, 5716.342620598602, 5722.599418040697, 5777.653340799566, 5788.450097240755, 5790.0, 5474.178873169057, 5706.828795136153, 5721.77112915487, 5763.942360576424, 5770.365259821417, 5713.8285851424525, 5722.62802917809, 5734.541236701138, 5740.1102829061565, 5741.540676745851, 4223.472065991751, 4363.127374525107, 4370.562943705668, 4373.1472362888935, 4405.911881762347, 3892.5718171001167, 3914.5106861642294, 3940.0346915006007, 3941.0935484838647, 3973.264945985002, 5484.424135465719, 5485.0, 5487.807926722546, 5491.533219676292, 5493.23094766733, 5544.69504177266, 5715.2855893013375, 5810.854728631733, 5818.8254352369495, 5879.265091863517, 5449.0, 5453.590980676465, 5477.507024367826, 5498.395176530578, 5527.226188333637, 4992.650514464025, 5006.874828129326, 5007.173816320339, 5013.997200559903, 5057.747112644353, 5781.075027995501, 5823.621464604787, 5859.414058594191, 5984.611000284967, 6004.339522652592, 5709.457601527848, 5711.771529138788, 5714.3999880012, 5720.399358067343, 5727.284089488814, 5841.0, 5896.6756828374855, 5901.616394934315, 5902.911456328245, 5903.911441328298, 5474.562035037108, 5545.805896793593, 5547.805826796042, 5589.0, 5591.27313449249, 5694.743736531949, 5697.031504644137, 5708.771649133988, 5710.314762228393, 5713.485786279255, 5555.472230138131, 5558.471945165203, 5558.749856256397, 5560.110382338807, 5563.582731295088, 5347.43851895561, 5564.276644036249, 5586.245856809279, 5607.158926161109, 5643.633163844337, 5479.123340265538, 5515.09001014828, 5517.44825517445, 5518.724063796713, 5520.53075488588, 5453.700046497481, 5693.089105743061, 5707.571932105026, 5748.511376533042, 5762.078067509178, 5379.273798037371, 5428.294321738149, 5482.259894914136, 5488.490665067138, 5532.91700624499], "value": 5285.660143398542, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.4632138432642, 634.9809505714828, 639.9360063993598, 643.5816719132563, 652.0, 32199.19502012448, 33017.83491082544, 43640.0, 44415.77792111035, 44484.332735009004, 42389.57610423895, 46657.533424665744, 46923.53076469234, 46978.765106174505, 47020.0, 8886.066962968893, 9092.454452732823, 9095.090490950884, 9096.454212747256, 9097.772555686095, 8838.0, 8954.32842536809, 8966.506842123681, 8977.551122443885, 8981.550922453884, 9028.0, 9078.409903356294, 9081.409708368936, 9088.272938164931, 9089.409188402733, 9009.729708108767, 9055.411398259157, 9071.228945539637, 9077.863832042525, 9079.81840363189, 8878.911210887938, 8904.554772261426, 8964.462132272085, 8964.641414343418, 8989.955050224773, 42964.0, 43257.0, 43346.56653433457, 43349.133017339474, 43384.0, 3463.8960831175104, 3634.854605815764, 3645.0705070206927, 3658.743887927846, 3691.53855768029, 32342.514862277083, 32616.184595385068, 32860.50709239364, 32888.835555822305, 32972.0, 4365.781710914442, 4394.384786129945, 4437.378766972626, 4510.661700372485, 4605.4933957264675, 360590.0, 360726.1963690191, 361541.0, 361756.0, 362068.0, 61332.69333653392, 61487.0, 61885.0, 61895.0, 61963.6901815488, 63685.68157159184, 64304.0, 64387.356126439074, 64469.35530644727, 64486.67756661187, 16290.0, 16387.508374748777, 16479.505614831574, 16480.752788708178, 16506.75239871403, 12522.0, 12593.748125037448, 12601.621951341474, 12607.49570017189, 12615.369231538387, 16999.830001699826, 18027.369042083465, 18056.18747156381, 18119.72820407695, 18133.45599632013, 6252.874942501125, 6593.967030164818, 6600.86798264032, 6744.932550674529, 6758.425533829582, 1021.5505177721778, 1030.9329893557044, 1059.6979860739807, 1151.6832870960552, 1228.0666693312967, 32366.35267294688, 33594.0, 33710.831445843105, 35295.4705679415, 36493.27013459769, 1051.321897376188, 1086.315621158665, 1155.4800339847102, 1194.3908606610516, 1274.4965738533413, 17411.564710882078, 17844.732329015074, 18062.632934343448, 19109.235630574898, 19189.712154317698, 496467.0, 499837.0, 501821.0, 503891.0, 503956.0, 59801.10298345528, 59822.99999999913, 60019.0, 60178.398216018155, 60341.094883576785, 1259.5654499197763, 1365.1808914651328, 1373.086897213362, 1380.9861901380857, 1420.5454254638416, 32732.0, 33854.66145338515, 34149.0, 34463.0, 34507.30985380228, 49091.50908490869, 49251.26123108228, 49470.752646236535, 49497.75251123722, 49595.25607115824, 392774.0, 397106.0, 397108.0, 397142.0, 398393.0, 25091.87454062718, 25840.0, 27570.86214568914, 28223.57664634991, 28460.715392846636, 48054.0, 48287.75856120697, 48497.75751121222, 49356.50643493519, 49518.75240623774, 39767.403488948265, 40849.0, 41409.37885931774, 41596.3760543586, 42215.0, 41258.0, 41315.7934210327, 41509.58490415057, 41731.0, 41995.0, 40529.1894162121, 40659.59340406676, 41712.58287417087, 41808.1638367237, 42053.36919946264, 34786.478202827486, 36351.27297453983, 36924.815375922946, 37009.81495092507, 37133.62866371302, 27983.860080699465, 28078.0, 28250.71749282481, 28563.857180713963, 28663.57004644974], "value": 20282.40026354607, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.07850452373583, 381.4640430195576, 388.2293647110486, 392.444690762571, 406.7274925799714, 17463.214155363006, 18896.5275868103, 19416.320428784977, 19424.902875485637, 19473.902630486828, 18153.455396338097, 18186.454406367797, 18809.24763009478, 18809.247630094815, 18959.241630334804, 5294.602904782157, 5636.774529018834, 5735.713214339287, 5823.242978412822, 5834.124881267822, 5487.478689524489, 5589.944100558983, 5601.243832082658, 5611.018071837432, 5615.438456154393, 5604.579656525756, 5607.130894711327, 5608.186812912146, 5815.360310365856, 6297.685115744217, 6114.266288045441, 6183.536234782365, 6227.1282020517165, 6244.3755624437645, 6287.308396076428, 5327.680339179662, 5440.211169380417, 5442.482964118402, 5449.427810079964, 5563.415841336682, 12865.935670321682, 12934.547290844775, 12969.092163548556, 15760.448384306494, 22765.203217887294, 2162.7837216278404, 2260.615695331781, 2276.7495575486682, 2430.6232533957264, 2832.7733781297447, 9257.953710231473, 9378.0, 9564.856527152098, 9765.755856103584, 9921.156701680366, 1821.9817801821944, 1899.2497963304556, 1912.3880358285214, 1918.8560857935572, 1948.5128717820544, 50292.579409208374, 80166.0, 81217.18782812155, 83151.0, 85306.14693853106, 9977.501124943723, 10116.494175291205, 10150.03574660406, 10158.746031349276, 10270.691879243635, 13561.186328820302, 13915.65210869716, 14158.787618185735, 14692.118472891447, 14719.55841324762, 7753.418493613001, 7867.055953285642, 7895.447318687637, 7935.404844636675, 7956.801079972931, 7421.443391745641, 7481.9251807482315, 7514.549127052394, 7582.734604288823, 7621.275978782118, 4688.718676879398, 4689.812407503729, 4731.313959475857, 4751.548602882721, 4809.951900480951, 1901.486598618393, 1911.9522011949534, 1920.596674698329, 1943.7181608666947, 2015.1334925981969, 951.1487218939011, 988.0, 1000.1148983149819, 1004.969850904474, 1044.6657069737612, 18357.541061473305, 18448.49707202349, 19284.325048623232, 19313.613727725366, 19414.2234310626, 980.4852452462371, 987.2891518106951, 1001.5693251901606, 1046.387863100095, 1049.2550289294686, 10464.110550603284, 10652.520636571218, 10831.512581933832, 10839.295445795999, 10866.619668311729, 487874.0, 494294.0, 519007.0, 523810.0, 524437.0, 91660.54169729109, 91965.54017229872, 92384.0, 93144.53427732817, 93200.0, 958.6980101268078, 960.09750834217, 1022.6318525330875, 1030.108955753268, 1036.8859425463193, 16603.66792664164, 16753.581160471087, 16865.409710660068, 16883.66232675364, 17120.143992800062, 30449.0, 39243.0, 39399.606003939596, 41009.38485922654, 41826.1634767309, 49019.50980490149, 54038.45961540334, 54613.0, 55962.440375595725, 56522.0, 7995.360371170409, 8050.758477245692, 8146.144654811396, 8170.632321545426, 8320.417570769989, 8968.82062358736, 12076.275423474619, 13039.217646941213, 13223.47106115783, 13231.603051908458, 10631.149508039183, 10755.643964194514, 11345.432728363383, 11488.138389620979, 11627.59303424376, 10812.297200681931, 11142.442877856236, 11363.375014373958, 11378.31730096197, 11418.543258269576, 11593.88406115928, 11774.882251177378, 11784.41077946082, 11794.528218871492, 11932.477894549003, 8107.310878575151, 8115.269625733712, 8187.631556579849, 8243.299319557906, 8683.08827573121, 10928.890711093105, 11044.392558409043, 11051.392173430539, 11467.369294688871, 11501.712457188638], "value": 8908.033176094174, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.754365442394, 1475.763877779555, 1508.1177511155972, 1639.295103105664, 1778.5109094998866, 8068.6772529098835, 8398.706045288416, 8408.201220884013, 8574.91425085749, 8577.614007369668, 8306.0, 8485.0, 8490.533020683875, 8507.872381914261, 8510.48937063775, 1956.2664000999625, 2026.827719643832, 2205.3273751505862, 2213.6458166693333, 2255.842091053627, 2237.9104835806547, 2267.11582482831, 2272.681844530177, 2274.4882401459704, 2274.863508189514, 2251.212075773474, 2260.457490202356, 2281.0, 2282.8173746100356, 2286.576983258094, 1899.43017094871, 2147.6134295826746, 2183.5742030304095, 2218.190360518407, 2241.887905604713, 2173.880436575988, 2193.407779899418, 2194.6817711431754, 2197.5934452126407, 2198.296545105567, 8416.2004609562, 8476.364272679511, 8482.236598706146, 8483.0, 8483.109273526314, 4938.604911607099, 5010.3737032870895, 5064.468230835783, 5068.72122033288, 5071.56891664209, 3020.6375234971943, 3081.3221091359865, 3228.418884600771, 3243.4323993301314, 3249.2689144942437, 1054.8154073037265, 1070.903618674323, 1076.1498416251152, 1078.1751959750798, 1079.3200283821143, 11588.536458541648, 11627.94186029073, 11629.185956983014, 11643.76712465746, 11660.358680272497, 4423.646108311327, 4444.599986001275, 4522.23122069249, 4523.5024147343765, 4529.569690879362, 9817.165540928958, 9837.0, 9837.458939758382, 9845.75385615351, 9845.950770246247, 4964.255361695702, 5030.949690503048, 5032.723200224023, 5032.84901452957, 5037.5214354636255, 4090.2433049885867, 4561.566651168134, 4647.047355292157, 4723.7401942893475, 4725.763711814396, 3755.830987605564, 3799.810009499514, 3856.903577410531, 3857.903552411156, 3891.1828516011387, 1232.778099942001, 1239.2192918461492, 1258.169608058695, 1259.4710221706905, 1263.7505240671435, 1003.2174903575223, 1017.333646461554, 1020.637673625867, 1022.3456987527989, 1022.8619136416637, 5676.489115979582, 5824.155497452845, 5924.644521328734, 5958.82123536286, 6082.361352058058, 434.3745007189637, 434.39835827379306, 449.3776120073656, 450.8782628690235, 451.45825009988147, 4149.128682976609, 4173.290540608104, 4190.832366705358, 4214.831406743696, 4256.765877876746, 10028.598856045823, 10269.127124194527, 10277.845832312521, 10372.42951637652, 10398.948005260077, 10101.797964040677, 10148.137408320375, 10174.593016279267, 10180.490975451197, 10198.43908585035, 7859.292663660298, 7868.331191848757, 7916.08964969036, 7937.2062793721325, 7943.523388596703, 5791.7683292667825, 5816.82549523515, 5894.322152952465, 5993.130996005642, 6029.155918171372, 9372.1565059145, 9752.122308992224, 9785.902140978498, 9853.078649663246, 9855.753606159904, 9730.902690973282, 9743.31796774219, 9793.902060979299, 9796.069373409515, 9870.753231169278, 6488.772892948724, 7419.258074192753, 7547.05661792276, 7710.4217183710325, 7967.203279671987, 8003.239692229229, 8148.674053038049, 8223.05434874997, 8224.917750822655, 8225.218604232588, 6866.279040700854, 7238.493305468567, 7432.591207483424, 7493.812654683677, 7552.584607846621, 7215.134183897966, 7418.629068546443, 7425.70297188128, 7469.327760501581, 7516.24837516244, 6786.728530858711, 6868.416184624363, 6922.0, 6922.169339679271, 6922.480813938874, 4845.9757701211265, 4855.781489832895, 4866.245731911559, 4959.801607935642, 5112.923306150336, 5140.049090918192, 5155.458676838878, 5161.870953226199, 5285.207218917193, 5316.627836051439], "value": 4393.799528154072, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.8792483006798, 316.49677013548455, 320.64728798321835, 322.55970600130826, 323.1807368321306, 5003.699778013312, 5070.960453107114, 5120.718360490171, 5186.844394668156, 5189.481051894813, 5029.597632189425, 5090.371081254, 5092.446803724863, 5119.206522988943, 5122.821750997273, 4020.8592699255532, 4025.4163146343762, 4033.556308806029, 4034.11249525104, 4038.818253178599, 3809.257194847006, 3872.0, 4010.238054769599, 4023.23558523881, 4023.577524359944, 3962.4056391541353, 3991.7006224533275, 4008.939865902014, 4021.3565829467293, 4028.1742242840146, 3980.661643760284, 3983.4821473208444, 3989.7207195496326, 3990.980045099785, 4033.7983100845136, 3473.322702073097, 3550.7692000019915, 3552.1652411683235, 3561.2371875921326, 3567.6967457765863, 4973.4280557735965, 4988.127077761414, 5003.274525193827, 5007.524285192901, 5027.622928280357, 4576.565226303496, 4583.395811465994, 4593.173228818811, 4597.448306203243, 4598.586127248564, 5184.844454666366, 5289.523942845124, 5318.521333080042, 5407.648502847303, 5415.6479828811, 3942.752631000331, 3947.7695102267126, 3950.2692001979726, 3951.525816901961, 3956.4658771066115, 5553.361363443215, 5579.944200558024, 5625.9184101882565, 5637.267155269788, 5665.886682266331, 3824.7513911595656, 3966.2464131814863, 3980.980095099506, 3987.342088555356, 3989.4414781930554, 3996.5603783583783, 4007.7996100194873, 4022.0950286185957, 4023.295923213426, 4035.152617950205, 4495.752733599684, 4557.863264102082, 4566.127887566082, 4593.632509399307, 4623.214053610895, 5253.213907271546, 5360.981413531416, 5379.273798037293, 5399.433059528771, 5399.839034607499, 1320.214472388927, 1362.8160198373291, 1388.687545302299, 1390.3673828408253, 1391.7703578909568, 895.6820328783318, 905.1355955062899, 906.057699992001, 920.7652048727665, 920.9907900921039, 4585.426821647294, 4622.422197225347, 4671.766411679402, 4719.9292010619865, 4721.536323739583, 4845.49122342149, 4872.537108974641, 4892.363992680928, 4895.388076490439, 4897.4857639948, 4323.513979461822, 4625.687156421789, 4656.441227052707, 4674.392328997209, 4707.0, 2572.9099481518056, 2613.2421597736443, 2623.6720409948757, 2623.698274698396, 2625.474905019004, 5022.89954200914, 5033.7734801934, 5038.370203724535, 5061.392632884003, 5073.898522029539, 4719.622430205644, 4795.878120990326, 4922.975385123052, 4980.377452818398, 5064.265681476165, 5054.848354549369, 5056.469070747518, 5076.7207803571155, 5076.82231121909, 5095.643304968617, 4826.348442960296, 4842.491538388418, 4867.95132048675, 4900.313956046228, 4920.901581968412, 4646.465656449552, 4806.615470762401, 4844.909895273535, 4862.659613826998, 4866.975665121652, 5078.97460512695, 5080.221922327156, 5122.359705036871, 5132.204508301219, 5161.354830646169, 3649.233660931128, 3674.7138501525324, 3679.595244523047, 3725.231703419627, 3730.515033045687, 4924.212126059813, 4936.950630493649, 4938.506149385033, 4959.578435832995, 5202.97398513005, 5022.292420577021, 5425.263915546987, 5450.781968721365, 5469.234307196916, 5473.480019398151, 5393.352797664305, 5423.457654234545, 5441.319835020622, 5443.237946687546, 5451.56387488992, 5098.923516147335, 5205.85046047136, 5296.126139187145, 5332.440093790096, 5333.653312534673, 5438.374586922397, 5441.591880608891, 5465.07093794048, 5494.642848214853, 5508.697021663847, 5360.0887849064975, 5360.84741780519, 5368.7047212403695, 5379.031774280667, 5388.245645609696], "value": 3961.2994592043187, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.4060751398883, 742.6027075514601, 772.8029352515108, 792.1682233654661, 803.5901690138028, 12918.93540532296, 14161.079529830553, 14751.852481475182, 15480.535583932471, 15717.449889253878, 14433.061850979679, 14672.853271467282, 14707.779383309258, 14786.556403307892, 14854.1830199339, 671.7044500419825, 807.7536351412816, 814.3932770086265, 815.1115284340083, 821.5481485183155, 806.7095845495646, 825.2490233887164, 826.2852632472927, 828.3828547731948, 829.4442723375353, 870.6038752367657, 874.8556488179474, 874.9387542872001, 875.4003507597284, 875.9343049271298, 869.395769939892, 870.1211776106147, 870.268974061788, 870.4603146049458, 870.791010157564, 631.1321932343028, 631.2235949781794, 631.356016862802, 631.7851930343705, 632.175011609849, 14655.92672036633, 14666.926665366605, 14682.926585367111, 14685.55943321702, 14685.926570367186, 14465.0, 14493.0, 14512.27438628075, 14548.781768273484, 14580.270986450741, 11166.441677916153, 11179.4969226385, 11546.01858841991, 11547.133964952662, 12099.697507562294, 3677.1802016262877, 3694.4643026761237, 3701.8889433317045, 3764.569463603813, 3776.131489757371, 52905.7354713224, 54501.182482262404, 55119.0, 55980.0, 56165.43834561643, 10295.279330446947, 10300.278980471296, 10353.9482302588, 10447.373157610567, 10701.571937122584, 19626.509337266398, 19629.31297404584, 19635.41093767189, 19657.213711451383, 19673.409797706092, 8204.261616454547, 8208.0, 8266.214709602578, 8366.24703776663, 8481.15188481147, 4628.282616194495, 4701.741404222732, 4725.031368569435, 4728.858134255978, 4857.6599638025, 3339.1819004343606, 3392.8642854285554, 3393.5588373511778, 3395.151212196951, 3433.261848702491, 614.1034090228317, 624.1106423346804, 631.7725618777237, 645.1645119570168, 651.569963823874, 569.1633299050472, 597.6520811099201, 612.8570216546109, 621.2606997672755, 731.4331393170229, 9517.0, 9832.852507212398, 9847.655332063343, 9931.751706207402, 9935.304528682922, 730.817295676081, 745.9440541959375, 748.5246868238708, 749.6543704051242, 753.9019927409512, 4209.848090600402, 4465.37484752135, 4494.70784399013, 4531.0, 4544.772761361919, 69898.0, 70326.64836675886, 70417.0, 70607.64696176487, 70825.2917470829, 60922.39077609167, 62911.685441572496, 62972.68513657402, 63422.68288658527, 64434.0, 55554.722226389415, 55758.72120639371, 56235.71882140563, 56249.718751405984, 56788.0, 9083.545822708971, 9815.383697694579, 10143.391396516232, 10266.384016959006, 10411.67305848515, 38229.61770382261, 38236.235275294894, 39049.804750976065, 39122.217555649295, 39371.409428858016, 50382.0, 50791.74604126956, 50869.0, 51128.48871511237, 51875.22187167271, 12134.211276267015, 12409.689757756129, 12796.744065118832, 12851.421686023965, 13242.933785331012, 13709.725805483635, 13725.725485490035, 13968.58094257174, 14111.082779619292, 14277.857221427652, 13654.385552649956, 13663.513318288828, 13769.724605508034, 13894.930525347309, 14099.224542650252, 13520.729585408433, 13633.38649760783, 13655.497895231716, 13775.517856874962, 14367.353469093707, 12833.358332083546, 13304.334783260605, 13659.112157709716, 13694.863051369359, 14003.0, 10519.842202367123, 10603.681889543326, 10812.945935270272, 10860.782784344427, 10913.18151138652, 10997.395143267197, 11125.443727813416, 11233.606823761129, 11623.244489108181, 11633.185677002866], "value": 6987.4363251221575, "unit": "score"}], "name": "dromaeo_css", "value": 6985.127665334311, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 113.0, 111.0, 111.0, 112.0, 111.0, 110.0, 111.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 124.0, 132.0, 183.0, 129.0, 129.0, 156.0, 123.0, 187.0, 123.0], "value": 144.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 159.0, 160.0, 160.0, 161.0, 161.0, 159.0, 161.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 113.0, 75.0, 75.0, 74.0, 73.0, 103.0, 74.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 125.0, 82.0, 83.0, 84.0, 120.0, 82.0, 82.0, 118.0], "value": 94.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 145.0, 145.0, 147.0, 146.0, 145.0, 146.0, 147.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 53.0, 52.0, 54.0, 54.0, 52.0, 52.0, 53.0, 53.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 83.0, 78.0, 80.0, 80.0, 86.0, 80.0, 113.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 128.0, 127.0, 128.0, 125.0, 120.0, 120.0, 123.0, 130.0, 121.0], "value": 124.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 158.0, 162.0, 158.0, 164.0, 167.0, 158.0, 158.0, 161.0, 156.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 64.0, 61.0, 70.0, 62.0, 61.0, 61.0, 62.0], "value": 62.9, "unit": "score"}], "name": "kraken", "value": 1498.0000000000005, "alertThreshold": 2.0}]} 11:13:10 INFO - Return code: 0 11:13:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:13:10 ERROR - # TBPL SUCCESS # 11:13:10 INFO - Running post-action listener: _resource_record_post_action 11:13:10 INFO - ##### 11:13:10 INFO - ##### Finished run-tests step (success) 11:13:10 INFO - ##### 11:13:10 INFO - Running post-run listener: _resource_record_post_run 11:13:10 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 7819264; Write bytes: 433500160; Read time: 1952; Write time: 488304 11:13:10 INFO - TinderboxPrint: CPU usage
13.2% 11:13:10 INFO - TinderboxPrint: I/O read bytes / time
7,819,264 / 1,952 11:13:10 INFO - TinderboxPrint: I/O write bytes / time
433,500,160 / 488,304 11:13:10 INFO - TinderboxPrint: CPU idle
8,274.7 (86.8%) 11:13:10 INFO - TinderboxPrint: CPU user
1,214.8 (12.7%) 11:13:10 INFO - TinderboxPrint: Swap in / out
0 / 0 11:13:10 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 16510976; Read time: 0; Write time: 34632 11:13:10 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 6275072; Write bytes: 416931840; Read time: 1908; Write time: 453656 11:13:11 INFO - Running post-run listener: _upload_blobber_files 11:13:11 INFO - Blob upload gear active. 11:13:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:13:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:13:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:13:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:13:11 INFO - (blobuploader) - INFO - Open directory for files ... 11:13:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:13:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:13:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:13:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:13:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:13:12 INFO - (blobuploader) - INFO - Done attempting. 11:13:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:13:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:13:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:13:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:13:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:13:13 INFO - (blobuploader) - INFO - Done attempting. 11:13:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:13:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:13:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:13:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:13:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:13:17 INFO - (blobuploader) - INFO - Done attempting. 11:13:17 INFO - (blobuploader) - INFO - Iteration through files over. 11:13:17 INFO - Return code: 0 11:13:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:13:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:13:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/72746a35bc1b26ca1671b31fe8873c19a5caf34272c44c71d67f4a848a303457f600dad68e9d47dc094fe77978291c5dc5b1bd9f4b09b7b4553e6630a843a460", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77a565688d0d86a3eb9769d1ec829ba3fd203f7373212fb8dd860d93cd3a2281bb61ba7f6bce61032393b4a7978d9abfe0d44d15c1fad412bdc513f5e2613134", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac9bca0a4c14f230128963028e5d9462711fbbdcadaf809ab391a8651ad39bb835653be3aafbcc09166420cac96393ec1f344df0b9bd08d0cd6e70543e869bbb"} 11:13:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:13:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:13:17 INFO - Contents: 11:13:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/72746a35bc1b26ca1671b31fe8873c19a5caf34272c44c71d67f4a848a303457f600dad68e9d47dc094fe77978291c5dc5b1bd9f4b09b7b4553e6630a843a460", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77a565688d0d86a3eb9769d1ec829ba3fd203f7373212fb8dd860d93cd3a2281bb61ba7f6bce61032393b4a7978d9abfe0d44d15c1fad412bdc513f5e2613134", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac9bca0a4c14f230128963028e5d9462711fbbdcadaf809ab391a8651ad39bb835653be3aafbcc09166420cac96393ec1f344df0b9bd08d0cd6e70543e869bbb"} 11:13:17 INFO - Running post-run listener: copy_logs_to_upload_dir 11:13:17 INFO - Copying logs to upload dir... 11:13:17 INFO - mkdir: /builds/slave/test/build/upload/logs 11:13:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.106175 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-27 11:13:17.409494) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 11:13:17.413112) ========= 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=6d15e502d8e29d5d2676d664000001c3-1464371553.790818-2064923401 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/72746a35bc1b26ca1671b31fe8873c19a5caf34272c44c71d67f4a848a303457f600dad68e9d47dc094fe77978291c5dc5b1bd9f4b09b7b4553e6630a843a460", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77a565688d0d86a3eb9769d1ec829ba3fd203f7373212fb8dd860d93cd3a2281bb61ba7f6bce61032393b4a7978d9abfe0d44d15c1fad412bdc513f5e2613134", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac9bca0a4c14f230128963028e5d9462711fbbdcadaf809ab391a8651ad39bb835653be3aafbcc09166420cac96393ec1f344df0b9bd08d0cd6e70543e869bbb"} build_url:https://queue.taskcluster.net/v1/task/DXd_bqXjTLK0FZ9TJ0x3Jg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011496 build_url: 'https://queue.taskcluster.net/v1/task/DXd_bqXjTLK0FZ9TJ0x3Jg/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/72746a35bc1b26ca1671b31fe8873c19a5caf34272c44c71d67f4a848a303457f600dad68e9d47dc094fe77978291c5dc5b1bd9f4b09b7b4553e6630a843a460", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77a565688d0d86a3eb9769d1ec829ba3fd203f7373212fb8dd860d93cd3a2281bb61ba7f6bce61032393b4a7978d9abfe0d44d15c1fad412bdc513f5e2613134", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac9bca0a4c14f230128963028e5d9462711fbbdcadaf809ab391a8651ad39bb835653be3aafbcc09166420cac96393ec1f344df0b9bd08d0cd6e70543e869bbb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 11:13:17.438687) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 11:13:17.439007) ========= 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=6d15e502d8e29d5d2676d664000001c3-1464371553.790818-2064923401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 11:13:17.524135) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 11:13:17.524517) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 11:13:17.524901) ========= ========= Total master_lag: 0.17 =========