builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-026 starttime: 1464816513.1 results: success (0) buildid: 20160601113032 builduid: 30c43aac810e4769be79033e3b0d179c revision: 359674b9970a98e42c97184e9d7c59c89bac06d7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 14:28:33.098110) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 14:28:33.098589) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 14:28:33.098884) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 14:28:33.115028) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 14:28:33.115315) ========= 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=41bf3e9aed84707956354da8000001c5-1464816465.776019-620572038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-01 14:28:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-06-01 14:28:33 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079037 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 14:28:33.209368) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 14:28:33.209700) ========= 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=41bf3e9aed84707956354da8000001c5-1464816465.776019-620572038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019698 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 14:28:33.259482) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 14:28:33.259834) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 359674b9970a98e42c97184e9d7c59c89bac06d7 --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 359674b9970a98e42c97184e9d7c59c89bac06d7 --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=41bf3e9aed84707956354da8000001c5-1464816465.776019-620572038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-01 14:28:33,400 truncating revision to first 12 chars 2016-06-01 14:28:33,400 Setting DEBUG logging. 2016-06-01 14:28:33,401 attempt 1/10 2016-06-01 14:28:33,401 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/359674b9970a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-01 14:28:33,835 unpacking tar archive at: fx-team-359674b9970a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.756160 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 14:28:34.029375) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 14:28:34.029724) ========= script_repo_revision: 359674b9970a98e42c97184e9d7c59c89bac06d7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 14:28:34.030112) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 14:28:34.030402) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 14:28:34.041060) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-06-01 14:28:34.041420) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=41bf3e9aed84707956354da8000001c5-1464816465.776019-620572038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:28:34 INFO - MultiFileLogger online at 20160601 14:28:34 in /builds/slave/test 14:28:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:28:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:28:34 INFO - {'append_to_log': False, 14:28:34 INFO - 'base_work_dir': '/builds/slave/test', 14:28:34 INFO - 'blob_upload_branch': 'Fx-Team', 14:28:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:28:34 INFO - 'branch': 'Fx-Team', 14:28:34 INFO - 'buildbot_json_path': 'buildprops.json', 14:28:34 INFO - 'config_files': ('talos/linux_config.py',), 14:28:34 INFO - 'default_actions': ('clobber', 14:28:34 INFO - 'read-buildbot-config', 14:28:34 INFO - 'download-and-extract', 14:28:34 INFO - 'populate-webroot', 14:28:34 INFO - 'create-virtualenv', 14:28:34 INFO - 'install', 14:28:34 INFO - 'run-tests'), 14:28:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:28:34 INFO - 'download_minidump_stackwalk': True, 14:28:34 INFO - 'download_symbols': 'ondemand', 14:28:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:28:34 INFO - 'tooltool.py': '/tools/tooltool.py', 14:28:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:28:34 INFO - '/tools/misc-python/virtualenv.py')}, 14:28:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:28:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:28:34 INFO - 'installer_path': 'installer.exe', 14:28:34 INFO - 'log_level': 'info', 14:28:34 INFO - 'log_name': 'talos', 14:28:34 INFO - 'log_to_console': True, 14:28:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:28:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:28:34 INFO - 'opt_config_files': (), 14:28:34 INFO - 'pip_index': False, 14:28:34 INFO - 'sps_profile': False, 14:28:34 INFO - 'sps_profile_interval': 0, 14:28:34 INFO - 'suite': 'dromaeojs-e10s', 14:28:34 INFO - 'system_bits': '32', 14:28:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:28:34 INFO - 'title': 'talos-linux64-ix-026', 14:28:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:28:34 INFO - 'use_talos_json': True, 14:28:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:28:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:28:34 INFO - 'work_dir': 'build'} 14:28:34 INFO - ##### 14:28:34 INFO - ##### Running clobber step. 14:28:34 INFO - ##### 14:28:34 INFO - Running pre-action listener: _resource_record_pre_action 14:28:34 INFO - Running main action method: clobber 14:28:34 INFO - rmtree: /builds/slave/test/build 14:28:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:28:34 INFO - Running post-action listener: _resource_record_post_action 14:28:34 INFO - ##### 14:28:34 INFO - ##### Finished clobber step (success) 14:28:34 INFO - ##### 14:28:34 INFO - ##### 14:28:34 INFO - ##### Running read-buildbot-config step. 14:28:34 INFO - ##### 14:28:34 INFO - Running pre-action listener: _resource_record_pre_action 14:28:34 INFO - Running main action method: read_buildbot_config 14:28:34 INFO - Using buildbot properties: 14:28:34 INFO - { 14:28:34 INFO - "project": "", 14:28:34 INFO - "product": "firefox", 14:28:34 INFO - "script_repo_revision": "production", 14:28:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:28:34 INFO - "repository": "", 14:28:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:28:34 INFO - "buildid": "20160601113032", 14:28:34 INFO - "pgo_build": "True", 14:28:34 INFO - "basedir": "/builds/slave/test", 14:28:34 INFO - "buildnumber": 520, 14:28:34 INFO - "slavename": "talos-linux64-ix-026", 14:28:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:28:34 INFO - "platform": "ubuntu64_hw", 14:28:34 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:28:34 INFO - "branch": "fx-team", 14:28:34 INFO - "repo_path": "integration/fx-team", 14:28:34 INFO - "revision": "359674b9970a98e42c97184e9d7c59c89bac06d7", 14:28:34 INFO - "stage_platform": "linux64-pgo", 14:28:34 INFO - "builduid": "30c43aac810e4769be79033e3b0d179c", 14:28:34 INFO - "slavebuilddir": "test" 14:28:34 INFO - } 14:28:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:28:34 INFO - Running post-action listener: _resource_record_post_action 14:28:34 INFO - ##### 14:28:34 INFO - ##### Finished read-buildbot-config step (success) 14:28:34 INFO - ##### 14:28:34 INFO - ##### 14:28:34 INFO - ##### Running download-and-extract step. 14:28:34 INFO - ##### 14:28:34 INFO - Running pre-action listener: _resource_record_pre_action 14:28:34 INFO - Running main action method: download_and_extract 14:28:34 INFO - mkdir: /builds/slave/test/build/tests 14:28:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:34 INFO - https://queue.taskcluster.net/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:28:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:28:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:28:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:28:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:28:35 INFO - Downloaded 1361 bytes. 14:28:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:28:35 INFO - Using the following test package requirements: 14:28:35 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:28:35 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:28:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:28:35 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:28:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:28:35 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:28:35 INFO - u'jsshell-linux-x86_64.zip'], 14:28:35 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:28:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:28:35 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:28:35 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:28:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:28:35 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:28:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:28:35 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:28:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:28:35 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:28:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:28:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:28:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:35 INFO - https://queue.taskcluster.net/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:28:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:28:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:28:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:28:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:28:36 INFO - Downloaded 24422471 bytes. 14:28:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:28:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:28:37 INFO - Return code: 0 14:28:37 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:28: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')]} 14:28:37 INFO - https://queue.taskcluster.net/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:28:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:28:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:28:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:28:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:28:39 INFO - Downloaded 24422471 bytes. 14:28: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'] 14:28: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 14:28:40 INFO - Return code: 0 14:28: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')]} 14:28:40 INFO - https://queue.taskcluster.net/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:28:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:28:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:28:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:28:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:28:41 INFO - Downloaded 10834055 bytes. 14:28:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:28:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:28:41 INFO - Return code: 0 14:28:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:41 INFO - https://queue.taskcluster.net/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:28:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:28:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:28:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:28:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:28:43 INFO - Downloaded 59027104 bytes. 14:28:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:28:43 INFO - mkdir: /builds/slave/test/properties 14:28:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:28:43 INFO - Writing to file /builds/slave/test/properties/build_url 14:28:43 INFO - Contents: 14:28:43 INFO - build_url:https://queue.taskcluster.net/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:28:44 INFO - Running post-action listener: _resource_record_post_action 14:28:44 INFO - Running post-action listener: set_extra_try_arguments 14:28:44 INFO - ##### 14:28:44 INFO - ##### Finished download-and-extract step (success) 14:28:44 INFO - ##### 14:28:44 INFO - ##### 14:28:44 INFO - ##### Running populate-webroot step. 14:28:44 INFO - ##### 14:28:44 INFO - Running pre-action listener: _resource_record_pre_action 14:28:44 INFO - Running main action method: populate_webroot 14:28:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:28:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:28:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:28:44 INFO - '--tppagecycles', 14:28:44 INFO - '7'], 14:28:44 INFO - 'tests': ['tsvgm']}}, 14:28:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:28:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:28:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:28:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:28:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:28:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:28:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:44 INFO - 'talos_options': ['--disable-e10s'], 14:28:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:28:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:28:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:44 INFO - 'talos_options': ['--disable-e10s'], 14:28:44 INFO - 'tests': ['damp', 'tps']}, 14:28:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:44 INFO - 'tests': ['damp', 'tps']}, 14:28:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:28:44 INFO - 'tests': ['dromaeo_dom']}, 14:28:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:28:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:28:44 INFO - 'tests': ['a11yr', 14:28:44 INFO - 'ts_paint', 14:28:44 INFO - 'tpaint', 14:28:44 INFO - 'sessionrestore', 14:28:44 INFO - 'sessionrestore_no_auto_restore', 14:28:44 INFO - 'tabpaint']}, 14:28:44 INFO - 'other-e10s': {'tests': ['a11yr', 14:28:44 INFO - 'ts_paint', 14:28:44 INFO - 'tpaint', 14:28:44 INFO - 'sessionrestore', 14:28:44 INFO - 'sessionrestore_no_auto_restore', 14:28:44 INFO - 'tabpaint']}, 14:28:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:28:44 INFO - 'ts_paint', 14:28:44 INFO - 'tpaint', 14:28:44 INFO - 'sessionrestore', 14:28:44 INFO - 'sessionrestore_no_auto_restore', 14:28:44 INFO - 'tabpaint']}, 14:28:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:28:44 INFO - 'ts_paint', 14:28:44 INFO - 'tpaint', 14:28:44 INFO - 'sessionrestore', 14:28:44 INFO - 'sessionrestore_no_auto_restore', 14:28:44 INFO - 'tabpaint']}, 14:28:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:28:44 INFO - 'tests': ['a11yr', 14:28:44 INFO - 'ts_paint', 14:28:44 INFO - 'tpaint', 14:28:44 INFO - 'sessionrestore', 14:28:44 INFO - 'sessionrestore_no_auto_restore', 14:28:44 INFO - 'tabpaint']}, 14:28:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:28:44 INFO - 'tests': ['a11yr', 14:28:44 INFO - 'ts_paint', 14:28:44 INFO - 'tpaint', 14:28:44 INFO - 'sessionrestore', 14:28:44 INFO - 'sessionrestore_no_auto_restore', 14:28:44 INFO - 'tabpaint']}, 14:28:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:28:44 INFO - 'tests': ['tsvgx', 14:28:44 INFO - 'tsvgr_opacity', 14:28:44 INFO - 'tart', 14:28:44 INFO - 'tscrollx', 14:28:44 INFO - 'cart']}, 14:28:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:28:44 INFO - 'tsvgr_opacity', 14:28:44 INFO - 'tart', 14:28:44 INFO - 'tscrollx', 14:28:44 INFO - 'cart']}, 14:28:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:44 INFO - 'talos_options': ['--disable-e10s'], 14:28:44 INFO - 'tests': ['tp5o']}, 14:28:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:44 INFO - 'tests': ['tp5o']}, 14:28:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:44 INFO - 'talos_options': ['--disable-e10s', 14:28:44 INFO - '--xperf_path', 14:28:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:28:44 INFO - 'tests': ['tp5n']}, 14:28:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:28:44 INFO - 'talos_options': ['--xperf_path', 14:28:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:28:44 INFO - 'tests': ['tp5n']}}, 14:28:44 INFO - 'talos.zip': {'path': '', 14:28:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:28:44 INFO - Running post-action listener: _resource_record_post_action 14:28:44 INFO - ##### 14:28:44 INFO - ##### Finished populate-webroot step (success) 14:28:44 INFO - ##### 14:28:44 INFO - ##### 14:28:44 INFO - ##### Running create-virtualenv step. 14:28:44 INFO - ##### 14:28:44 INFO - Running pre-action listener: _resource_record_pre_action 14:28:44 INFO - Running main action method: create_virtualenv 14:28:44 INFO - Creating virtualenv /builds/slave/test/build/venv 14:28:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:28:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:28:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:28:44 INFO - Using real prefix '/usr' 14:28:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:28:44 INFO - Installing distribute.............................................................................................................................................................................................done. 14:28:46 INFO - Installing pip.................done. 14:28:46 INFO - Return code: 0 14:28:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:28:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:46 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 0x7f0cfe5a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20749c0>, '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 0x20758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2075d50>, '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': '41bf3e9aed84707956354da8000001c5-1464816465.776019-620572038', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:28:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:28:46 INFO - Using env: {'DISPLAY': ':0', 14:28:46 INFO - 'HOME': '/home/cltbld', 14:28:46 INFO - 'LANG': 'en_US.UTF-8', 14:28:46 INFO - 'LANGUAGE': 'en_US:en', 14:28:46 INFO - 'LOGNAME': 'cltbld', 14:28:46 INFO - 'MAIL': '/var/mail/cltbld', 14:28:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:46 INFO - 'MOZ_NO_REMOTE': '1', 14:28:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:46 INFO - 'NO_EM_RESTART': '1', 14:28:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:46 INFO - 'PWD': '/builds/slave/test', 14:28:46 INFO - 'SHELL': '/bin/bash', 14:28:46 INFO - 'SHLVL': '1', 14:28:46 INFO - 'TERM': 'linux', 14:28:46 INFO - 'TMOUT': '86400', 14:28:46 INFO - 'USER': 'cltbld', 14:28:46 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464816465.776019-620572038', 14:28:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:46 INFO - '_': '/tools/buildbot/bin/python'} 14:28:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:28:47 INFO - Cleaning up... 14:28:47 INFO - Return code: 0 14:28:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:47 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 0x7f0cfe5a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20749c0>, '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 0x20758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2075d50>, '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': '41bf3e9aed84707956354da8000001c5-1464816465.776019-620572038', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:28:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:28:47 INFO - Using env: {'DISPLAY': ':0', 14:28:47 INFO - 'HOME': '/home/cltbld', 14:28:47 INFO - 'LANG': 'en_US.UTF-8', 14:28:47 INFO - 'LANGUAGE': 'en_US:en', 14:28:47 INFO - 'LOGNAME': 'cltbld', 14:28:47 INFO - 'MAIL': '/var/mail/cltbld', 14:28:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:47 INFO - 'MOZ_NO_REMOTE': '1', 14:28:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:47 INFO - 'NO_EM_RESTART': '1', 14:28:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:47 INFO - 'PWD': '/builds/slave/test', 14:28:47 INFO - 'SHELL': '/bin/bash', 14:28:47 INFO - 'SHLVL': '1', 14:28:47 INFO - 'TERM': 'linux', 14:28:47 INFO - 'TMOUT': '86400', 14:28:47 INFO - 'USER': 'cltbld', 14:28:47 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464816465.776019-620572038', 14:28:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:47 INFO - '_': '/tools/buildbot/bin/python'} 14:28:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:47 INFO - Downloading/unpacking psutil>=3.1.1 14:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:28:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:28:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:28:49 INFO - Installing collected packages: psutil 14:28:49 INFO - Running setup.py install for psutil 14:28:49 INFO - building 'psutil._psutil_linux' extension 14:28:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:28:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:28:49 INFO - building 'psutil._psutil_posix' extension 14:28:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:28:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:28:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:28:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:28:49 INFO - Successfully installed psutil 14:28:49 INFO - Cleaning up... 14:28:49 INFO - Return code: 0 14:28:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:49 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 0x7f0cfe5a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20749c0>, '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 0x20758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2075d50>, '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': '41bf3e9aed84707956354da8000001c5-1464816465.776019-620572038', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:28:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:28:49 INFO - Using env: {'DISPLAY': ':0', 14:28:49 INFO - 'HOME': '/home/cltbld', 14:28:49 INFO - 'LANG': 'en_US.UTF-8', 14:28:49 INFO - 'LANGUAGE': 'en_US:en', 14:28:49 INFO - 'LOGNAME': 'cltbld', 14:28:49 INFO - 'MAIL': '/var/mail/cltbld', 14:28:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:49 INFO - 'MOZ_NO_REMOTE': '1', 14:28:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:49 INFO - 'NO_EM_RESTART': '1', 14:28:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:49 INFO - 'PWD': '/builds/slave/test', 14:28:49 INFO - 'SHELL': '/bin/bash', 14:28:49 INFO - 'SHLVL': '1', 14:28:49 INFO - 'TERM': 'linux', 14:28:49 INFO - 'TMOUT': '86400', 14:28:49 INFO - 'USER': 'cltbld', 14:28:49 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464816465.776019-620572038', 14:28:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:49 INFO - '_': '/tools/buildbot/bin/python'} 14:28:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:28:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:28:51 INFO - Installing collected packages: mozsystemmonitor 14:28:51 INFO - Running setup.py install for mozsystemmonitor 14:28:52 INFO - Successfully installed mozsystemmonitor 14:28:52 INFO - Cleaning up... 14:28:52 INFO - Return code: 0 14:28:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:28:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:52 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 0x7f0cfe5a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20749c0>, '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 0x20758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2075d50>, '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': '41bf3e9aed84707956354da8000001c5-1464816465.776019-620572038', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:28:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:28:52 INFO - Using env: {'DISPLAY': ':0', 14:28:52 INFO - 'HOME': '/home/cltbld', 14:28:52 INFO - 'LANG': 'en_US.UTF-8', 14:28:52 INFO - 'LANGUAGE': 'en_US:en', 14:28:52 INFO - 'LOGNAME': 'cltbld', 14:28:52 INFO - 'MAIL': '/var/mail/cltbld', 14:28:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:52 INFO - 'MOZ_NO_REMOTE': '1', 14:28:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:52 INFO - 'NO_EM_RESTART': '1', 14:28:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:52 INFO - 'PWD': '/builds/slave/test', 14:28:52 INFO - 'SHELL': '/bin/bash', 14:28:52 INFO - 'SHLVL': '1', 14:28:52 INFO - 'TERM': 'linux', 14:28:52 INFO - 'TMOUT': '86400', 14:28:52 INFO - 'USER': 'cltbld', 14:28:52 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464816465.776019-620572038', 14:28:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:52 INFO - '_': '/tools/buildbot/bin/python'} 14:28:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:52 INFO - Downloading/unpacking blobuploader==1.2.4 14:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:54 INFO - Downloading blobuploader-1.2.4.tar.gz 14:28:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:28:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:28:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:55 INFO - Downloading docopt-0.6.1.tar.gz 14:28:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:28:55 INFO - Installing collected packages: blobuploader, requests, docopt 14:28:55 INFO - Running setup.py install for blobuploader 14:28:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:28:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:28:55 INFO - Running setup.py install for requests 14:28:55 INFO - Running setup.py install for docopt 14:28:55 INFO - Successfully installed blobuploader requests docopt 14:28:55 INFO - Cleaning up... 14:28:55 INFO - Return code: 0 14:28:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:55 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 0x7f0cfe5a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20749c0>, '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 0x20758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2075d50>, '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': '41bf3e9aed84707956354da8000001c5-1464816465.776019-620572038', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:28:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:28:55 INFO - Using env: {'DISPLAY': ':0', 14:28:55 INFO - 'HOME': '/home/cltbld', 14:28:55 INFO - 'LANG': 'en_US.UTF-8', 14:28:55 INFO - 'LANGUAGE': 'en_US:en', 14:28:55 INFO - 'LOGNAME': 'cltbld', 14:28:55 INFO - 'MAIL': '/var/mail/cltbld', 14:28:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:55 INFO - 'MOZ_NO_REMOTE': '1', 14:28:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:55 INFO - 'NO_EM_RESTART': '1', 14:28:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:55 INFO - 'PWD': '/builds/slave/test', 14:28:55 INFO - 'SHELL': '/bin/bash', 14:28:55 INFO - 'SHLVL': '1', 14:28:55 INFO - 'TERM': 'linux', 14:28:55 INFO - 'TMOUT': '86400', 14:28:55 INFO - 'USER': 'cltbld', 14:28:55 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464816465.776019-620572038', 14:28:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:55 INFO - '_': '/tools/buildbot/bin/python'} 14:28:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:28:55 INFO - Running setup.py (path:/tmp/pip-9u9iXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:28:56 INFO - Running setup.py (path:/tmp/pip-muMmtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:28:56 INFO - Running setup.py (path:/tmp/pip-h35rn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:28:56 INFO - Running setup.py (path:/tmp/pip-c_l2zu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:28:56 INFO - Running setup.py (path:/tmp/pip-EZd0YA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:28:56 INFO - Running setup.py (path:/tmp/pip-FVcFKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:28:56 INFO - Running setup.py (path:/tmp/pip-MXz6tm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:28:56 INFO - Running setup.py (path:/tmp/pip-G8g597-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:28:56 INFO - Running setup.py (path:/tmp/pip-8rHz9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:28:56 INFO - Running setup.py (path:/tmp/pip-7NSj1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:28:56 INFO - Running setup.py (path:/tmp/pip-hUmD76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:28:56 INFO - Running setup.py (path:/tmp/pip-DPcfvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:28:56 INFO - Running setup.py (path:/tmp/pip-O8jRUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:28:56 INFO - Running setup.py (path:/tmp/pip-Lcvh5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:56 INFO - Running setup.py (path:/tmp/pip-PFWWmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:28:57 INFO - Running setup.py (path:/tmp/pip-d8jGgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:28:57 INFO - Running setup.py (path:/tmp/pip-hXNYSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:28:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:28:57 INFO - Running setup.py install for manifestparser 14:28:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:28:57 INFO - Running setup.py install for mozcrash 14:28:57 INFO - Running setup.py install for mozdebug 14:28:57 INFO - Running setup.py install for mozdevice 14:28:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:28:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:28:57 INFO - Running setup.py install for mozfile 14:28:57 INFO - Running setup.py install for mozhttpd 14:28:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:28:57 INFO - Running setup.py install for mozinfo 14:28:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:28:57 INFO - Running setup.py install for mozInstall 14:28:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:28:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:28:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:28:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:28:57 INFO - Running setup.py install for mozleak 14:28:58 INFO - Running setup.py install for mozlog 14:28:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:28:58 INFO - Running setup.py install for moznetwork 14:28:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:28:58 INFO - Running setup.py install for mozprocess 14:28:58 INFO - Running setup.py install for mozprofile 14:28:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:28:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:28:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:28:58 INFO - Running setup.py install for mozrunner 14:28:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:28:58 INFO - Running setup.py install for mozscreenshot 14:28:58 INFO - Running setup.py install for moztest 14:28:58 INFO - Running setup.py install for mozversion 14:28:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:28:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:28:58 INFO - Cleaning up... 14:28:58 INFO - Return code: 0 14:28:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:28: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')]} 14:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28: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')]} 14:28:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:58 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 0x7f0cfe5a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20749c0>, '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 0x20758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2075d50>, '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': '41bf3e9aed84707956354da8000001c5-1464816465.776019-620572038', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:28:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:28:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:28:58 INFO - Using env: {'DISPLAY': ':0', 14:28:58 INFO - 'HOME': '/home/cltbld', 14:28:58 INFO - 'LANG': 'en_US.UTF-8', 14:28:58 INFO - 'LANGUAGE': 'en_US:en', 14:28:58 INFO - 'LOGNAME': 'cltbld', 14:28:58 INFO - 'MAIL': '/var/mail/cltbld', 14:28:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:58 INFO - 'MOZ_NO_REMOTE': '1', 14:28:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:28:58 INFO - 'NO_EM_RESTART': '1', 14:28:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:28:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:58 INFO - 'PWD': '/builds/slave/test', 14:28:58 INFO - 'SHELL': '/bin/bash', 14:28:58 INFO - 'SHLVL': '1', 14:28:58 INFO - 'TERM': 'linux', 14:28:58 INFO - 'TMOUT': '86400', 14:28:58 INFO - 'USER': 'cltbld', 14:28:58 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464816465.776019-620572038', 14:28:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:58 INFO - '_': '/tools/buildbot/bin/python'} 14:28:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:28:59 INFO - Running setup.py (path:/tmp/pip-VxzrY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:28:59 INFO - Running setup.py (path:/tmp/pip-CXeFEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:28:59 INFO - Running setup.py (path:/tmp/pip-M3ldo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:28:59 INFO - Running setup.py (path:/tmp/pip-tKQVqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:28:59 INFO - Running setup.py (path:/tmp/pip-3EfrW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:28:59 INFO - Running setup.py (path:/tmp/pip-DiaHN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:28:59 INFO - Running setup.py (path:/tmp/pip-G888PB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:28:59 INFO - Running setup.py (path:/tmp/pip-omHRIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:28:59 INFO - Running setup.py (path:/tmp/pip-YJyJNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:28:59 INFO - Running setup.py (path:/tmp/pip-JmkMq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:28:59 INFO - Running setup.py (path:/tmp/pip-sZq4Pu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:29:00 INFO - Running setup.py (path:/tmp/pip-9xuXwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:29:00 INFO - Running setup.py (path:/tmp/pip-MdWVG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:29:00 INFO - Running setup.py (path:/tmp/pip-2K8YAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:29:00 INFO - Running setup.py (path:/tmp/pip-AzEpG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:29:00 INFO - Running setup.py (path:/tmp/pip-IcvkMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:29:00 INFO - Running setup.py (path:/tmp/pip-QOrE6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:29:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:29: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 14:29: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 14:29: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 14:29: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 14:29: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 14:29: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 14:29:02 INFO - Downloading blessings-1.6.tar.gz 14:29:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:29:02 INFO - Installing collected packages: blessings 14:29:02 INFO - Running setup.py install for blessings 14:29:02 INFO - Successfully installed blessings 14:29:02 INFO - Cleaning up... 14:29:02 INFO - Return code: 0 14:29:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:29:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:29:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:29:02 INFO - Reading from file tmpfile_stdout 14:29:02 INFO - Current package versions: 14:29:02 INFO - argparse == 1.2.1 14:29:02 INFO - blessings == 1.6 14:29:02 INFO - blobuploader == 1.2.4 14:29:02 INFO - docopt == 0.6.1 14:29:02 INFO - manifestparser == 1.1 14:29:02 INFO - mozInstall == 1.12 14:29:02 INFO - mozcrash == 0.17 14:29:02 INFO - mozdebug == 0.1 14:29:02 INFO - mozdevice == 0.48 14:29:02 INFO - mozfile == 1.2 14:29:02 INFO - mozhttpd == 0.7 14:29:02 INFO - mozinfo == 0.9 14:29:02 INFO - mozleak == 0.1 14:29:02 INFO - mozlog == 3.2 14:29:02 INFO - moznetwork == 0.27 14:29:02 INFO - mozprocess == 0.22 14:29:02 INFO - mozprofile == 0.28 14:29:02 INFO - mozrunner == 6.11 14:29:02 INFO - mozscreenshot == 0.1 14:29:02 INFO - mozsystemmonitor == 0.3 14:29:02 INFO - moztest == 0.7 14:29:02 INFO - mozversion == 1.4 14:29:02 INFO - psutil == 3.1.1 14:29:02 INFO - requests == 1.2.3 14:29:02 INFO - wsgiref == 0.1.2 14:29:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:02 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 0x7f0cfe5a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20749c0>, '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 0x20758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2075d50>, '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': '41bf3e9aed84707956354da8000001c5-1464816465.776019-620572038', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:29:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:29:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:29:02 INFO - Using env: {'DISPLAY': ':0', 14:29:02 INFO - 'HOME': '/home/cltbld', 14:29:02 INFO - 'LANG': 'en_US.UTF-8', 14:29:02 INFO - 'LANGUAGE': 'en_US:en', 14:29:02 INFO - 'LOGNAME': 'cltbld', 14:29:02 INFO - 'MAIL': '/var/mail/cltbld', 14:29:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:02 INFO - 'MOZ_NO_REMOTE': '1', 14:29:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:02 INFO - 'NO_EM_RESTART': '1', 14:29:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:02 INFO - 'PWD': '/builds/slave/test', 14:29:02 INFO - 'SHELL': '/bin/bash', 14:29:02 INFO - 'SHLVL': '1', 14:29:02 INFO - 'TERM': 'linux', 14:29:02 INFO - 'TMOUT': '86400', 14:29:02 INFO - 'USER': 'cltbld', 14:29:02 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464816465.776019-620572038', 14:29:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:02 INFO - '_': '/tools/buildbot/bin/python'} 14:29:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:29:02 INFO - Cleaning up... 14:29:02 INFO - Return code: 0 14:29:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x7f0cfe5a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20749c0>, '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 0x20758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2075d50>, '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': '41bf3e9aed84707956354da8000001c5-1464816465.776019-620572038', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:29:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:29:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:29:03 INFO - Using env: {'DISPLAY': ':0', 14:29:03 INFO - 'HOME': '/home/cltbld', 14:29:03 INFO - 'LANG': 'en_US.UTF-8', 14:29:03 INFO - 'LANGUAGE': 'en_US:en', 14:29:03 INFO - 'LOGNAME': 'cltbld', 14:29:03 INFO - 'MAIL': '/var/mail/cltbld', 14:29:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:03 INFO - 'MOZ_NO_REMOTE': '1', 14:29:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:03 INFO - 'NO_EM_RESTART': '1', 14:29:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:03 INFO - 'PWD': '/builds/slave/test', 14:29:03 INFO - 'SHELL': '/bin/bash', 14:29:03 INFO - 'SHLVL': '1', 14:29:03 INFO - 'TERM': 'linux', 14:29:03 INFO - 'TMOUT': '86400', 14:29:03 INFO - 'USER': 'cltbld', 14:29:03 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464816465.776019-620572038', 14:29:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:03 INFO - '_': '/tools/buildbot/bin/python'} 14:29:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:03 INFO - Downloading/unpacking jsonschema 14:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:29:05 INFO - Downloading/unpacking functools32 (from jsonschema) 14:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:05 INFO - Downloading functools32-3.2.3-2.tar.gz 14:29:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:29:05 INFO - warning: no files found matching '*.txt' 14:29:05 INFO - no previously-included directories found matching 'build' 14:29:05 INFO - no previously-included directories found matching 'dist' 14:29:05 INFO - no previously-included directories found matching '.git*' 14:29:05 INFO - Installing collected packages: jsonschema, functools32 14:29:05 INFO - Running setup.py install for functools32 14:29:05 INFO - warning: no files found matching '*.txt' 14:29:05 INFO - no previously-included directories found matching 'build' 14:29:05 INFO - no previously-included directories found matching 'dist' 14:29:05 INFO - no previously-included directories found matching '.git*' 14:29:05 INFO - Successfully installed jsonschema functools32 14:29:05 INFO - Cleaning up... 14:29:05 INFO - Return code: 0 14:29:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:29: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')]} 14:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29: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')]} 14:29:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:05 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 0x7f0cfe5a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20749c0>, '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 0x20758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2075d50>, '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': '41bf3e9aed84707956354da8000001c5-1464816465.776019-620572038', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:29:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:29:05 INFO - Using env: {'DISPLAY': ':0', 14:29:05 INFO - 'HOME': '/home/cltbld', 14:29:05 INFO - 'LANG': 'en_US.UTF-8', 14:29:05 INFO - 'LANGUAGE': 'en_US:en', 14:29:05 INFO - 'LOGNAME': 'cltbld', 14:29:05 INFO - 'MAIL': '/var/mail/cltbld', 14:29:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:05 INFO - 'MOZ_NO_REMOTE': '1', 14:29:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:05 INFO - 'NO_EM_RESTART': '1', 14:29:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:05 INFO - 'PWD': '/builds/slave/test', 14:29:05 INFO - 'SHELL': '/bin/bash', 14:29:05 INFO - 'SHLVL': '1', 14:29:05 INFO - 'TERM': 'linux', 14:29:05 INFO - 'TMOUT': '86400', 14:29:05 INFO - 'USER': 'cltbld', 14:29:05 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464816465.776019-620572038', 14:29:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:05 INFO - '_': '/tools/buildbot/bin/python'} 14:29:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:05 INFO - Downloading/unpacking flake8 14:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:29:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:29:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:29:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:29:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:29:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:29:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:29:08 INFO - no previously-included directories found matching 'docs/_build' 14:29:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:29:08 INFO - Running setup.py install for pep8 14:29:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:29:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:29:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:29:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:29:08 INFO - no previously-included directories found matching 'docs/_build' 14:29:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:29:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:29:08 INFO - Cleaning up... 14:29:08 INFO - Return code: 0 14:29:08 INFO - Running post-action listener: _resource_record_post_action 14:29:08 INFO - Running post-action listener: _start_resource_monitoring 14:29:08 INFO - Starting resource monitoring. 14:29:08 INFO - ##### 14:29:08 INFO - ##### Finished create-virtualenv step (success) 14:29:08 INFO - ##### 14:29:08 INFO - ##### 14:29:08 INFO - ##### Running install step. 14:29:08 INFO - ##### 14:29:08 INFO - Running pre-action listener: _resource_record_pre_action 14:29:08 INFO - Running main action method: install 14:29:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:29:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:29:08 INFO - Reading from file tmpfile_stdout 14:29:08 INFO - Detecting whether we're running mozinstall >=1.0... 14:29:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:29:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:29:08 INFO - Reading from file tmpfile_stdout 14:29:08 INFO - Output received: 14:29:08 INFO - Usage: mozinstall [options] installer 14:29:08 INFO - Options: 14:29:08 INFO - -h, --help show this help message and exit 14:29:08 INFO - -d DEST, --destination=DEST 14:29:08 INFO - Directory to install application into. [default: 14:29:08 INFO - "/builds/slave/test"] 14:29:08 INFO - --app=APP Application being installed. [default: firefox] 14:29:08 INFO - mkdir: /builds/slave/test/build/application 14:29:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:29:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:29:25 INFO - Reading from file tmpfile_stdout 14:29:25 INFO - Output received: 14:29:25 INFO - /builds/slave/test/build/application/firefox/firefox 14:29:25 INFO - Running post-action listener: _resource_record_post_action 14:29:25 INFO - ##### 14:29:25 INFO - ##### Finished install step (success) 14:29:25 INFO - ##### 14:29:25 INFO - ##### 14:29:25 INFO - ##### Running run-tests step. 14:29:25 INFO - ##### 14:29:25 INFO - Running pre-action listener: _resource_record_pre_action 14:29:25 INFO - Running main action method: run_tests 14:29:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:29:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:29:25 INFO - Python 2.7.3 14:29:25 INFO - Return code: 0 14:29:25 INFO - grabbing minidump binary from tooltool 14:29:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:25 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 0x20749c0>, '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 0x20758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2075d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:29:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:29:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:29:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:29:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:29:25 INFO - Return code: 0 14:29:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:29:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:29:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:29:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:29:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:29:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:29:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:29:26 INFO - Return code: 0 14:29:26 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:29:26 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:29:26 INFO - Using env: {'DISPLAY': ':0', 14:29:26 INFO - 'HOME': '/home/cltbld', 14:29:26 INFO - 'LANG': 'en_US.UTF-8', 14:29:26 INFO - 'LANGUAGE': 'en_US:en', 14:29:26 INFO - 'LOGNAME': 'cltbld', 14:29:26 INFO - 'MAIL': '/var/mail/cltbld', 14:29:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:29:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:29:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:26 INFO - 'MOZ_NO_REMOTE': '1', 14:29:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:29:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:26 INFO - 'NO_EM_RESTART': '1', 14:29:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:26 INFO - 'PWD': '/builds/slave/test', 14:29:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:29:26 INFO - 'SHELL': '/bin/bash', 14:29:26 INFO - 'SHLVL': '1', 14:29:26 INFO - 'TERM': 'linux', 14:29:26 INFO - 'TMOUT': '86400', 14:29:26 INFO - 'USER': 'cltbld', 14:29:26 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464816465.776019-620572038', 14:29:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:26 INFO - '_': '/tools/buildbot/bin/python'} 14:29:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:29:26 INFO - mozversion application_buildid: 20160601113032 14:29:26 INFO - mozversion application_changeset: 359674b9970a98e42c97184e9d7c59c89bac06d7 14:29:26 INFO - mozversion application_display_name: Nightly 14:29:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:29:26 INFO - mozversion application_name: Firefox 14:29:26 INFO - mozversion application_remotingname: firefox 14:29:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:29:26 INFO - mozversion application_vendor: Mozilla 14:29:26 INFO - mozversion application_version: 49.0a1 14:29:26 INFO - mozversion platform_buildid: 20160601113032 14:29:26 INFO - mozversion platform_changeset: 359674b9970a98e42c97184e9d7c59c89bac06d7 14:29:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:29:26 INFO - mozversion platform_version: 49.0a1 14:29:26 INFO - using testdate: 1464816566 14:29:26 INFO - actual date: 1464816566 14:29:26 INFO - starting webserver on 'localhost:60268' 14:29:26 INFO - SUITE-START | Running 2 tests 14:29:26 INFO - TEST-START | dromaeo_css 14:29:26 INFO - operating with platform_type : linux_ 14:29:26 INFO - Initialising browser for dromaeo_css test... 14:29:26 INFO - TEST-INFO | started process 3632 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprInI4E/profile http://localhost:60268/getInfo.html) 14:29:31 INFO - PROCESS | 3632 | __metrics Screen width/height:1600/1200 14:29:31 INFO - PROCESS | 3632 | colorDepth:24 14:29:31 INFO - PROCESS | 3632 | Browser inner width/height: 1024/697 14:29:31 INFO - PROCESS | 3632 | __metrics 14:29:31 ERROR - PROCESS | 3632 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 14:29:32 INFO - TEST-INFO | 3632: exit 0 14:29:32 INFO - Browser initialized. 14:29:32 INFO - Running cycle 1/1 for dromaeo_css test... 14:29:32 INFO - TEST-INFO | started process 3750 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprInI4E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:29:44 INFO - PROCESS | 3750 | RSS: Main: 167153664 14:29:44 INFO - PROCESS | 3750 | 14:30:34 INFO - PROCESS | 3750 | 1464816634222 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:32:41 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:60268/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60268/tests/dromaeo/cssquery-ext.html) 14:32:42 INFO - PROCESS | 3750 | RSS: Main: 170385408 14:32:42 INFO - PROCESS | 3750 | 14:35:44 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:60268/tests/dromaeo/cssquery-ext.html (next: http://localhost:60268/tests/dromaeo/cssquery-jquery.html) 14:35:45 INFO - PROCESS | 3750 | RSS: Main: 169644032 14:35:45 INFO - PROCESS | 3750 | 14:38:47 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:60268/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60268/tests/dromaeo/cssquery-mootools.html) 14:38:48 INFO - PROCESS | 3750 | RSS: Main: 170786816 14:38:48 INFO - PROCESS | 3750 | 14:41:49 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:60268/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60268/tests/dromaeo/cssquery-prototype.html) 14:41:50 INFO - PROCESS | 3750 | RSS: Main: 168673280 14:41:50 INFO - PROCESS | 3750 | 14:44:52 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:60268/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60268/tests/dromaeo/cssquery-yui.html) 14:44:53 INFO - PROCESS | 3750 | RSS: Main: 170975232 14:44:53 INFO - PROCESS | 3750 | 14:47:56 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:60268/tests/dromaeo/cssquery-yui.html (next: http://localhost:60268/tests/dromaeo/cssquery-dojo.html) 14:47:56 INFO - PROCESS | 3750 | RSS: Main: 171724800 14:47:56 INFO - PROCESS | 3750 | 14:47:56 INFO - PROCESS | 3750 | __start_tp_report 14:47:56 INFO - PROCESS | 3750 | _x_x_mozilla_page_load 14:47:56 INFO - PROCESS | 3750 | _x_x_mozilla_page_load_details 14:47:56 INFO - PROCESS | 3750 | |i|pagename|runs| 14:47:56 INFO - PROCESS | 3750 | |0;dojo.html;3137.717605415513;3168.207948012997;3172.9206769830753;3202.2954949911027;3205.4230238557066;5430.8913821723545;5436.456354364566;5451.236826844245;5482.205080263359;5494.2857428534235;5275.709835959021;5383.327084114486;5403.78384864605;5455.918161227585;5544.362398324194;4827.275908613701;4853.708777473345;4948.307236986807;4996.125678006352;5047.899042019158;947.4564201009381;4826;4865.975670121645;4918.139325618003;4931.235658472942;4869.2939523768855;4921.458639549646;4922.70463772173;4928.162212423878;4964.230544265626;4950.554450099508;4958.057968985881;4968.701877887338;4969.204927211665;4971.328870602459;4865.0756356292195;4927.285543596195;4935.062338155739;4946.554810067111;4957.1572832618185;5379.569634429236;5427.185922111676;5469.480399362054;5473.28847249859;5477.5070243677865;5722.513586345166;5810.7385167667135;5870.471657550841;5878.970605146989;5882.647041177543;5900.232969713909;5918.7928422505;5938.198343223696;5953.791617293374;5990.580659353847;5470.835874923799;5474.069408200616;5475.4524547545325;5476.698781567012;5537.473939975695;5913.46778789911;6009.038553831366;6053.4551890330085;6056.788012419544;6058.697065146813;5638.210650508932;5666.773329066791;5691.146328050742;5716;5739.053056245756;5799.072148456311;5813.76744930198;5821.679807610622;5823.737931793079;5841.474267315962;5811.27359080115;5863.149843272787;5889.352171261158;5896.764129434775;5947.6431414115295;5912.379200184005;5958.672273025025;5970.611910225822;5978.4021597839865;5982.611130276518;4397.406350142754;4533.138703646297;4537.2059889519205;4544.302980025583;4578.702384345007;3927.5286965564314;3976.661983731415;3996.2207369562657;4022.155347377025;4033.274010678106;5555.722213889289;5569.693666848362;5603.579731520153;5634.126710359901;5637.069883469182;5817.418258174233;5834.212381328466;5875;5876.676782776903;5882.264716910387;5646.943530564724;5698.7435565399655;5727.742251598688;5744.540436765049;5747.540196784331;5123.948760512421;5159.329287192641;5161;5172.9741351293005;5196.4803519648485;5975.581709280395;6084.269887613515;6184.134221209034;6209.96895015522;6230.6573138476915;5923.822285331361;5960.195373624505;5991.940080599313;6016.308124565556;6042.093685947143;6097.817065488042;6123.112148738497;6129.632222066691;6138.693065346804;6179.443850053517;5716.114002329646;5739.827805165852;5851.502622277154;5859.56053296013;5870.442307980735;5823.068309070698;5934.643921364732;5942.1978032965;5958.076498142795;5996.940030599638;5713.742881570256;5775.624584402;5780.277465316835;5794.507466865363;5800.4489573490455;5590.329160500766;5698.230738850202;5721.656700597978;5784.681842498535;5801.36185019639;5706.686132262766;5720.885582288414;5732.7706891723865;5738.68437235956;5750.741216645178;5814.331351894586;5832.912506312494;5867.178594996789;5877.529797616095;5879.7060146993335;5564.944350556442;5627.521660658726;5680.943190568041;5686.09022556389;5734.627249228787 14:47:56 INFO - PROCESS | 3750 | |1;ext.html;577.5466258986694;618.1191801682602;620.048225973131;640.7533099756592;650.4113777031788;39736.60263397365;40626.59373406265;42762;42843.57156428435;42897.571024289784;44899.77550112253;45413.545864541346;45711;45817.770911145395;45847.31229031567;8712.956435217815;8921.15249051339;8944.373893827435;8946.329025323093;8961.05908879568;8817.911820881773;8907.554622268894;8912.8663070054;8920.464772113693;8931.821363572757;8898.154675305868;8910.064443233432;8974.237189838872;9009.369344145913;9021.864672029924;8912.420692654989;8955.552222388855;8991.100889911022;8998.460092394445;9007.144321289466;8786.384953053288;8884.244839188612;8886.06696296886;8910.50992195429;8949.418287811337;41539.1692166158;42022;42023.7898810504;42071.7896410519;42134;2976.479116154664;3324.634290228073;3446.2590543033366;3459;3586.946195807065;31455.842720786477;31683.914945972978;31754.682453175403;31821;32441.351172976643;4016.3172260715455;4017.1563971565715;4112.300908845504;4115.218108559364;4268.807903644343;303736;305480;306091.9999999978;306185;306382;34911.825440872635;35035.824820876245;35131.64868351284;35218.47172292418;35227.295454090774;36155.81922090373;36672;36813.07967300839;38850;38874.416883746766;16475.752863707054;16486.17569121563;16524.75212871808;16533.421330253623;16607.83392166063;12547.623571292876;12596.55912043074;12605;12613.117081804186;12646.683832904067;19668;19955;19979.60040799176;19989.200431982557;20122.29571964974;7199.460040496983;7214.170370407365;7292.744753933587;7428.4428667850125;7462.291082347168;1015.5582321690089;1114.654457118296;1163.947622356996;1169.2984209474419;1183.331417748969;32533.349333013208;32661.346773064404;33108.503372449435;33218.66781332204;33364;1102.818035024228;1116.9329840209614;1144.9183660251178;1146.3263635092692;1216.531635320408;15909.681806363807;16684.6663066738;16956.915215423844;17029;17046.462271200955;553713;559092;561132;562188;563255;57197.71401143051;57950.420495794504;58129.70935145297;58175;58268;1355.715299787036;1364.0519838712198;1375.4429456070307;1413.1097408632495;1420.7584710599017;29920.700792992662;30987.535186971763;31506.369872602878;31733.20666983344;31857.8407107963;49266.507334926195;49726.25410618771;50216.49783502118;50269.74865125651;50312.748436257585;518096;518228;520710;524586;525916;27333.726662733912;28228.85885570641;28287.29281767972;28325;28330.575041374806;46286.53713462957;46947.59157225289;47415.52584474111;47479;47778.761106194244;40645.59354406536;40936.181276374904;41509.58490415057;41827;42356.36465453082;39749;39936.80031599823;40005.59994400019;40764.796176020114;41335;37064.25871482609;39918.2016359677;40722.59277407306;40727;41583.58416415797;34782.304353912274;36729.63270367262;37178.442323365714;37254.44118338281;37313.62686373101;28194;28450.57324140181;28646.283842904093;28823;28891 14:47:56 INFO - PROCESS | 3750 | |2;jquery.html;395.1149425287355;396.3143761292963;400.5673872218004;408.779259200032;415.5242247626468;14808.777868331958;17931.193096310664;19062.237510499563;19484.123214455347;19523.511912202186;18387;18431.815681843178;18444.907775461103;18484.260629574834;18785.436436906915;5579.497845193931;5696.658200507973;5824.650520968734;5830.970845145768;5881.705914704269;5774.162746401769;5774.913376299359;5775.5668324875805;5818.7963421280265;5829.7376618052285;5528.226048353234;5740.052891272956;5742.454466825645;5756.395578464264;5796.942030579704;5557.249771280865;5747.42525747424;5774.047282198432;5776.740046697867;5779.913301300484;5099.46455622158;5133.666311689728;5152.407473140599;5165.251038599419;5169.741512924376;22297.21959731418;22627.66058509124;22963.54072918549;23388.18141365044;23416.297511074696;2346.4368551547504;2408.0969636386353;2481.5781317176125;2958.5118455454826;3096.5045592705283;13981.580552583337;14307.928460357736;14383.640408989755;14792;15005.474808381654;1973.842092632586;1986.6622674145285;1994.8005199479935;2095.1409921932086;2171.1423987524995;77656;79899.20100798976;82424;82924.58537707334;84398.15601844026;11126.165537584551;11182.273152245078;11236.381998990135;11266.211365204521;11270.605528806616;12212.328321942201;12870.22778633285;12882.871171288167;15583.142927139117;15682.902196846111;7322.121345438475;7423.1092268927;7633.503822251536;7810.609469526501;7851.05787305527;7529.736459223901;7546.547207167588;7702.3067923886;7733.458657894006;7837.725679601187;3972.523297204354;4035.1122752994293;4086.2849001424634;4192.0777428965575;4198.6431153352305;1950.658634738915;1987.6322880267196;2040.6326861165132;2046.6827641715558;2055.5991581641733;918.5269586163131;969.6751588218026;985.8324084905584;1025.707673313102;1052.6999805055523;17663.38178163784;19186.61626767457;19399.709004364944;19884.204631814566;20040.198392064445;1008.3193844155165;1033.9069483746348;1055.551390658967;1092.94535273236;1093.1801149138146;10550.366977981346;11079.446027698745;11102.61140860066;11198.888011119947;11208.383538905438;453515;461686;463105;538420;539931;59949;90694.54652726694;95277.5236123815;96171.51914240383;96292.51853740687;1020.2246292817364;1033.565902321027;1046.7697106636529;1052.55792567122;1055.2718624149466;17409.21658525344;17542.473725788248;17717.822821771617;17819.910900445935;17822.46532604024;34869.476957845145;39015;40720.1855962885;43247.56752432435;45236.54763452455;54798;55230.44769552253;55947.72026140006;56625.71687141538;56906;5286.656367336111;7931.920680793118;8220.260176583897;8651.351148664002;8925;11530.94234528822;13119.73760524765;13434.93282533581;13439.126456780277;13736.244506552235;11358.488868000795;11523.193376463567;11711.355875426932;11797.941010294893;12061.336626485627;11086.22396432242;11261.66215013551;11277.774444511228;11337.603183888854;11434.142439316918;8913.777155570902;10778.771200159264;11844.763104737685;12399.566015189424;12436.626901192978;8590.098039705741;8599.097094804956;8650.351223658377;8842.46945183291;8978.147076027766;8949.507777072064;10856.509882424325;11988.220765650205;12174.330411827434;12230.510779569073 14:47:56 INFO - PROCESS | 3750 | |3;mootools.html;1251.061703722208;1271.3325504110342;1400.4175281931418;1583.7228485015119;1590.4274461193975;8046.959765201181;8589.484630922141;8736.51949142797;9092.3180761443;9203.769905752359;8991.505467199302;9008.189262966333;9030.864537031934;9037.72886813395;9107.362484626063;2363.9763602363973;2403.0748161957686;2403.351095204294;2405.6151015837468;2408.963865542018;2350.236173243694;2355.1521452277166;2377.679013333204;2378.286514045788;2381.166591692911;2334.4397344637337;2343.355577216262;2343.7187537495524;2346.8239882008834;2352.494213744045;2305.1931823861682;2306.5156317173414;2338.543983923136;2343.871087090209;2359.504504054151;2311.318161142467;2337.988310058439;2344.3553022918663;2344.6131388320905;2346.16711067572;9017.639294428214;9098.181163695299;9099.681511147079;9103.817923641556;9106.225970792491;5108.310378098946;5229.738513074331;5253.6322457428;5302.708351040691;5303.178007408857;3243.399971005348;3294.6046474422983;3316.7512436567113;3332.7000569948823;3429.691327780487;1164.9184557081007;1166.4459381793665;1172.7947609168448;1184.1119160629528;1203.3261373630708;12777.23336599807;12799.360031998363;12803.743925121445;12809.935950320189;12835.614931552069;4481.843135490242;4512.548745125527;4635.466921304093;4640.791164397543;4658.604018658384;10104.242181836391;10138.138258248131;10193.490325483695;10202.795944081077;10217.33587316822;5170.1727723564045;5208.583313334924;5218.947810521846;5232.058229518723;5247.239150323258;4500.684952053391;4816.807327706852;4919.729414882216;4994.4755800640405;5034.093863104603;4120.299549076604;4156.189543039139;4172.5410204877435;4180.853670121592;4228.302330115558;1281.88463038327;1287.5107459165458;1305.3668970549277;1305.4712841299288;1307.6992291772756;1002.4236064263077;1011.7318910488726;1013.7009582173276;1018.7962407518378;1027.4913917610832;6200.131981522591;6216.751329946842;6225.906611400833;6228.5951413158;6363.522735794834;456.82868924153445;463.2194751843155;465.8695565241738;468.5501918158538;471.6627611257967;4134.834606615702;4221.409002739619;4284.143171365739;4295.398644189816;4295.656347492193;11036.503357348938;11313.83029254562;11462.54149834014;11463;11480.598179063692;11103.666889993314;11210.943945280222;11253.437328133561;11270.661880143609;11350.659480215607;8397.370197235232;8446.873296900552;8494;8504.872426913602;8533.573321333908;6027.638341699512;6080.148779170831;6149.84625384369;6209.627422354673;6317.842053948688;9937.602495900082;10280.177585793268;10336.741581460523;10388.792224155626;10434.791304174027;10470.581176752845;10483.842742359024;10510.264281500222;10539.314944528582;10582.365058096539;7627.199144090013;7882.448228623941;7937.325327347009;7952.522848629101;8121;8822.955885220534;8823.07357727455;8827.426217295855;8866.42368246062;8870.467771933705;7550.962245188739;7870.606469676608;7883.526988380716;8067.112617611941;8069.31410830086;7684.269994350528;7702.075750909927;7750.92249077502;7842.176571459914;7880.487768295043;7332.706691732485;7421.628918554159;7426.517276377018;7516;7519.060117485315;5160.741962901765;5172.405173405106;5266.315379000705;5289.41816400188;5473.452654734654;5460.31746031746;5593.776248949996;5706.9714651426475;5746.0721952574695;5752.30972283312 14:47:56 INFO - PROCESS | 3750 | |4;prototype.html;331.0779479150566;336.6364326527351;337.1369294605808;339.5619650650661;343.673510165343;5605.663660180387;5654.151877218419;5686.4597863203035;5707.14392841074;5707.77168913244;5518.448155184479;5518.834434966948;5543.168524721294;5554.7222638868;5596.384397716248;4069.226846899087;4234.30134027885;4307.1601037797645;4312.159128969852;4323.113761678848;4343.674224433164;4343.847965321214;4346.804393802271;4349;4358.5423530529315;4315.287977483711;4327.610515053644;4337.7397356158735;4342.609165175134;4361.9345709814215;4163.333866581333;4284.186004659105;4295.165190973942;4297.763623000734;4299.081260811257;3758.1919887224103;3777.452269420946;3807;3816.503854498925;3834.559025712051;5291.4708529147165;5365.382980957201;5373.543248823855;5392.379876314235;5395.244665746799;4890.877728056791;4895.975520122377;4992.326035985132;4993.525615066599;5006.272835871619;5768.163616275659;5842.123681447774;5842.795502157446;5844.53243740504;5903.288046466562;4205.137946720914;4246.7027308088445;4256.872293831159;4257.34011228257;4265.87202383929;5863.53091752663;6076.696165191723;6077.604955677911;6082.726277317532;6112.419320164578;4315.834724624334;4330.501992270866;4334.544872788375;4346.587074227943;4351.671855557262;4348.5216626171095;4367.10474352757;4376.40918476008;4402.207602631493;4428.734275943454;4900.926486102711;4976.441844081499;4989.451160372356;5002.324686167393;5094.159463688524;5870.589058765845;5905;5914.970425147847;5943.70281485924;5976.133460648269;1521.5587479631004;1534.8541888520572;1539.9384024639114;1545.1347245542531;1547.411983446283;956.9043445255282;960.2605993385055;977.7604486900755;997.2670087485692;998.8851282102651;5648.4633959773755;5666.603337766317;5677.17680936262;5685.658860468302;5734.827955161351;5997.820065398045;6015.909761353583;6088.665123418166;6103;6107.633541987495;5642.26650535436;5682.374938756733;5717.628354156966;5732.541396688338;5773.45967774178;3226.6934641209045;3239.967600324014;3243.62698289695;3244.3835671222864;3248.9675103249137;6043.8791224175275;6236.656983865931;6250.4374606285655;6256.6871656417;6319.494440444753;6087.878242435127;6120.265568131853;6152.477039451607;6154.907676384858;6164.568480206342;6035.857270669025;6250.249970003538;6283.465905398001;6285.308616052231;6285.685715714196;5998.850028749316;6059.303824666861;6073.210482637405;6079;6082.300535438481;5940.346561878104;5978.581499295007;5981.192539007352;5982.7008649568215;6017.789377371771;5991.47217459545;6249.78125765596;6250.468710159687;6264.5614806964895;6268.1851359323;4219.831206751818;4241.512226094039;4250.404943308001;4268.466441694788;4282.272013757606;5877.207451727264;6089.208402907594;6097.756089756537;6100.481459076028;6133.478654314434;5936.940630593639;5949.286085669747;5951.49412299942;5960.403959604005;5962.704358821798;5837.883242335214;5840;5845.473907348359;5874.970625146847;5921.407859214044;5600.691961942132;5773.53811695055;5811.099279611667;5821.224526519452;5859.121131830259;5833.445822646841;5961.2846458425265;5966.224390829165;6006.699665016819;6049.848753781191;5556.388797232382;5835.2122463466885;5836.970815145897;5880.911786323123;5909.8227053188475 14:47:56 INFO - PROCESS | 3750 | |5;yui.html;795.4193438789683;809.9190080991898;822.4982760516084;836.0719601242623;844.8774927635491;14911.179885106314;15613.687726245482;15628.374865005415;16059.839401605981;16213.675726485464;15306.846931530681;15789;15846.524604261862;15907.602309942256;15910.284037218324;816.7263966571206;827.5365795154732;828.9295409890136;831.6340810043562;833.4374297349295;796.8167321516055;819.1849110135423;823.7940514871282;824.5464994253167;826.9545175015402;865.4504389712515;866.4584634603373;868.674247157316;868.7741187291318;869.4044579463088;847.3009766942297;851.8509260879352;854.9358798090137;855.5422848775875;858.0347109501811;624.4473640827855;626.1953389893964;626.9529785266078;633.0283015571076;633.3223450907531;12970.675733106653;12977.545785897542;13003.219806811621;13027;13030.478780848754;13144.605661830064;13368.532101376502;13587.660308492268;13592.11651242666;13599.252041137734;10884.836727449094;11081.889181108247;11110.888891111146;11200.495977680943;11207.66377008691;3748.55017397914;3777.8111094445444;3793.3930571108767;3811.4092315690837;3833.50164478616;51779.74110129463;53540.196897046575;54019.189712154744;59576.10635840466;59632;10223;10540.262181647364;10961.342319460859;11021.559137634405;11117.888821111685;18600.53498662517;18610.534736631693;18631.627367452576;18678.813211867706;18737.531561711065;7566.810829729191;7988.520688758693;8112.641943937089;8430.283425908867;8707.956460217658;4544.250198717241;4610.423697037871;4652.1626107300335;4670.53294670537;4726.645501587326;3275.410426123273;3365.2764655598676;3368.1747971747077;3376.206591451007;3389.1527118220447;627.9372062793684;642.2357394700292;647.2007071266981;659.7954634063456;668.4585485756553;631.835722712089;678.0575000748963;679.3626271329185;750.4784174998324;758.5941521286086;9317.39436936597;9557;9617.182539484082;9728.221742260603;9746.463944482979;628.7610707930957;646.8188907106017;760.3119177144692;779.3414564692825;786.9134395216522;3986.661133803659;4197.685173611992;4225.619694227473;4238.830446782094;4305.784710764449;74995.62502187454;75075.24924750792;75230;75809.62095189489;77076.61461692768;68111.3188868115;68439;69008.3099169012;69850.30149698438;70034;60007;60888.39111608827;60893.69553152206;61268.38731612627;61341;8295.253427191581;8724.78188045304;8726.476411415335;8821.955890220508;8876.156765107304;36319;36752;36930;37032;37800.243995120494;48900.75549622229;49045.5095449041;49953.50046499488;50668.746656266485;50869.23696144487;11611;11971.401429928643;12021.278723276631;12238.571649992207;12398.938005309916;13712.17726936387;13873;13892.72214555683;13902.37439315213;13975;12847.871521284667;12946.287954162612;13225.470981160646;13229.470821167046;13731.45074197061;13187.142835715647;13444.193348399127;13798.034137610672;13876.444942202199;13894.374753136335;12720;12721.681957951125;13002.869971300166;13200.679932006722;13674.863251367757;9627.711168664951;9822.361546499455;10001.599936002769;10056.49717514136;10091.495425228562;10812.945935270272;10966.232363734782;10984.340939543654;11411.885881141083;11441.542338306708 14:47:56 INFO - PROCESS | 3750 | __end_tp_report 14:47:56 INFO - PROCESS | 3750 | __start_cc_report 14:47:56 INFO - PROCESS | 3750 | _x_x_mozilla_cycle_collect,340 14:47:56 INFO - PROCESS | 3750 | __end_cc_report 14:47:56 INFO - PROCESS | 3750 | __startTimestamp1464817676369__endTimestamp 14:47:56 INFO - PROCESS | 3750 | 14:47:56 INFO - PROCESS | 3750 | ------- Summary: start ------- 14:47:56 INFO - PROCESS | 3750 | Number of tests: 6 14:47:56 INFO - PROCESS | 3750 | 14:47:56 INFO - PROCESS | 3750 | [#0] dojo.html Cycles:165 Average:5440.68 Median:5716.00 stddev:727.10 (12.7%) stddev-sans-first:706.53 14:47:56 INFO - PROCESS | 3750 | Values: 3137.7 3168.2 3172.9 3202.3 3205.4 5430.9 5436.5 5451.2 5482.2 5494.3 5275.7 5383.3 5403.8 5455.9 5544.4 4827.3 4853.7 4948.3 4996.1 5047.9 947.5 4826.0 4866.0 4918.1 4931.2 4869.3 4921.5 4922.7 4928.2 4964.2 4950.6 4958.1 4968.7 4969.2 4971.3 4865.1 4927.3 4935.1 4946.6 4957.2 5379.6 5427.2 5469.5 5473.3 5477.5 5722.5 5810.7 5870.5 5879.0 5882.6 5900.2 5918.8 5938.2 5953.8 5990.6 5470.8 5474.1 5475.5 5476.7 5537.5 5913.5 6009.0 6053.5 6056.8 6058.7 5638.2 5666.8 5691.1 5716.0 5739.1 5799.1 5813.8 5821.7 5823.7 5841.5 5811.3 5863.1 5889.4 5896.8 5947.6 5912.4 5958.7 5970.6 5978.4 5982.6 4397.4 4533.1 4537.2 4544.3 4578.7 3927.5 3976.7 3996.2 4022.2 4033.3 5555.7 5569.7 5603.6 5634.1 5637.1 5817.4 5834.2 5875.0 5876.7 5882.3 5646.9 5698.7 5727.7 5744.5 5747.5 5123.9 5159.3 5161.0 5173.0 5196.5 5975.6 6084.3 6184.1 6210.0 6230.7 5923.8 5960.2 5991.9 6016.3 6042.1 6097.8 6123.1 6129.6 6138.7 6179.4 5716.1 5739.8 5851.5 5859.6 5870.4 5823.1 5934.6 5942.2 5958.1 5996.9 5713.7 5775.6 5780.3 5794.5 5800.4 5590.3 5698.2 5721.7 5784.7 5801.4 5706.7 5720.9 5732.8 5738.7 5750.7 5814.3 5832.9 5867.2 5877.5 5879.7 5564.9 5627.5 5680.9 5686.1 5734.6 14:47:56 INFO - PROCESS | 3750 | 14:47:56 INFO - PROCESS | 3750 | [#1] ext.html Cycles:180 Average:60681.81 Median:22010.96 stddev:126749.08 (575.8%) stddev-sans-first:127024.31 14:47:56 INFO - PROCESS | 3750 | Values: 577.5 618.1 620.0 640.8 650.4 39736.6 40626.6 42762.0 42843.6 42897.6 44899.8 45413.5 45711.0 45817.8 45847.3 8713.0 8921.2 8944.4 8946.3 8961.1 8817.9 8907.6 8912.9 8920.5 8931.8 8898.2 8910.1 8974.2 9009.4 9021.9 8912.4 8955.6 8991.1 8998.5 9007.1 8786.4 8884.2 8886.1 8910.5 8949.4 41539.2 42022.0 42023.8 42071.8 42134.0 2976.5 3324.6 3446.3 3459.0 3586.9 31455.8 31683.9 31754.7 31821.0 32441.4 4016.3 4017.2 4112.3 4115.2 4268.8 303736.0 305480.0 306092.0 306185.0 306382.0 34911.8 35035.8 35131.6 35218.5 35227.3 36155.8 36672.0 36813.1 38850.0 38874.4 16475.8 16486.2 16524.8 16533.4 16607.8 12547.6 12596.6 12605.0 12613.1 12646.7 19668.0 19955.0 19979.6 19989.2 20122.3 7199.5 7214.2 7292.7 7428.4 7462.3 1015.6 1114.7 1163.9 1169.3 1183.3 32533.3 32661.3 33108.5 33218.7 33364.0 1102.8 1116.9 1144.9 1146.3 1216.5 15909.7 16684.7 16956.9 17029.0 17046.5 553713.0 559092.0 561132.0 562188.0 563255.0 57197.7 57950.4 58129.7 58175.0 58268.0 1355.7 1364.1 1375.4 1413.1 1420.8 29920.7 30987.5 31506.4 31733.2 31857.8 49266.5 49726.3 50216.5 50269.7 50312.7 518096.0 518228.0 520710.0 524586.0 525916.0 27333.7 28228.9 28287.3 28325.0 28330.6 46286.5 46947.6 47415.5 47479.0 47778.8 40645.6 40936.2 41509.6 41827.0 42356.4 39749.0 39936.8 40005.6 40764.8 41335.0 37064.3 39918.2 40722.6 40727.0 41583.6 34782.3 36729.6 37178.4 37254.4 37313.6 28194.0 28450.6 28646.3 28823.0 28891.0 14:47:56 INFO - PROCESS | 3750 | 14:47:56 INFO - PROCESS | 3750 | [#2] jquery.html Cycles:180 Average:28802.12 Median:2377.27 stddev:81204.35 (3415.9%) stddev-sans-first:81404.14 14:47:56 INFO - PROCESS | 3750 | Values: 395.1 396.3 400.6 408.8 415.5 14808.8 17931.2 19062.2 19484.1 19523.5 18387.0 18431.8 18444.9 18484.3 18785.4 5579.5 5696.7 5824.7 5831.0 5881.7 5774.2 5774.9 5775.6 5818.8 5829.7 5528.2 5740.1 5742.5 5756.4 5796.9 5557.2 5747.4 5774.0 5776.7 5779.9 5099.5 5133.7 5152.4 5165.3 5169.7 22297.2 22627.7 22963.5 23388.2 23416.3 2346.4 2408.1 2481.6 2958.5 3096.5 13981.6 14307.9 14383.6 14792.0 15005.5 1973.8 1986.7 1994.8 2095.1 2171.1 77656.0 79899.2 82424.0 82924.6 84398.2 11126.2 11182.3 11236.4 11266.2 11270.6 12212.3 12870.2 12882.9 15583.1 15682.9 7322.1 7423.1 7633.5 7810.6 7851.1 7529.7 7546.5 7702.3 7733.5 7837.7 3972.5 4035.1 4086.3 4192.1 4198.6 1950.7 1987.6 2040.6 2046.7 2055.6 918.5 969.7 985.8 1025.7 1052.7 17663.4 19186.6 19399.7 19884.2 20040.2 1008.3 1033.9 1055.6 1092.9 1093.2 10550.4 11079.4 11102.6 11198.9 11208.4 453515.0 461686.0 463105.0 538420.0 539931.0 59949.0 90694.5 95277.5 96171.5 96292.5 1020.2 1033.6 1046.8 1052.6 1055.3 17409.2 17542.5 17717.8 17819.9 17822.5 34869.5 39015.0 40720.2 43247.6 45236.5 54798.0 55230.4 55947.7 56625.7 56906.0 5286.7 7931.9 8220.3 8651.4 8925.0 11530.9 13119.7 13434.9 13439.1 13736.2 11358.5 11523.2 11711.4 11797.9 12061.3 11086.2 11261.7 11277.8 11337.6 11434.1 8913.8 10778.8 11844.8 12399.6 12436.6 8590.1 8599.1 8650.4 8842.5 8978.1 8949.5 10856.5 11988.2 12174.3 12230.5 14:47:56 INFO - PROCESS | 3750 | 14:47:56 INFO - PROCESS | 3750 | [#3] mootools.html Cycles:180 Average:5934.83 Median:4506.62 stddev:3419.65 (75.9%) stddev-sans-first:3411.12 14:47:56 INFO - PROCESS | 3750 | Values: 1251.1 1271.3 1400.4 1583.7 1590.4 8047.0 8589.5 8736.5 9092.3 9203.8 8991.5 9008.2 9030.9 9037.7 9107.4 2364.0 2403.1 2403.4 2405.6 2409.0 2350.2 2355.2 2377.7 2378.3 2381.2 2334.4 2343.4 2343.7 2346.8 2352.5 2305.2 2306.5 2338.5 2343.9 2359.5 2311.3 2338.0 2344.4 2344.6 2346.2 9017.6 9098.2 9099.7 9103.8 9106.2 5108.3 5229.7 5253.6 5302.7 5303.2 3243.4 3294.6 3316.8 3332.7 3429.7 1164.9 1166.4 1172.8 1184.1 1203.3 12777.2 12799.4 12803.7 12809.9 12835.6 4481.8 4512.5 4635.5 4640.8 4658.6 10104.2 10138.1 10193.5 10202.8 10217.3 5170.2 5208.6 5218.9 5232.1 5247.2 4500.7 4816.8 4919.7 4994.5 5034.1 4120.3 4156.2 4172.5 4180.9 4228.3 1281.9 1287.5 1305.4 1305.5 1307.7 1002.4 1011.7 1013.7 1018.8 1027.5 6200.1 6216.8 6225.9 6228.6 6363.5 456.8 463.2 465.9 468.6 471.7 4134.8 4221.4 4284.1 4295.4 4295.7 11036.5 11313.8 11462.5 11463.0 11480.6 11103.7 11210.9 11253.4 11270.7 11350.7 8397.4 8446.9 8494.0 8504.9 8533.6 6027.6 6080.1 6149.8 6209.6 6317.8 9937.6 10280.2 10336.7 10388.8 10434.8 10470.6 10483.8 10510.3 10539.3 10582.4 7627.2 7882.4 7937.3 7952.5 8121.0 8823.0 8823.1 8827.4 8866.4 8870.5 7551.0 7870.6 7883.5 8067.1 8069.3 7684.3 7702.1 7750.9 7842.2 7880.5 7332.7 7421.6 7426.5 7516.0 7519.1 5160.7 5172.4 5266.3 5289.4 5473.5 5460.3 5593.8 5707.0 5746.1 5752.3 14:47:56 INFO - PROCESS | 3750 | 14:47:56 INFO - PROCESS | 3750 | [#4] prototype.html Cycles:180 Average:4954.18 Median:5696.80 stddev:1464.51 (25.7%) stddev-sans-first:1426.91 14:47:56 INFO - PROCESS | 3750 | Values: 331.1 336.6 337.1 339.6 343.7 5605.7 5654.2 5686.5 5707.1 5707.8 5518.4 5518.8 5543.2 5554.7 5596.4 4069.2 4234.3 4307.2 4312.2 4323.1 4343.7 4343.8 4346.8 4349.0 4358.5 4315.3 4327.6 4337.7 4342.6 4361.9 4163.3 4284.2 4295.2 4297.8 4299.1 3758.2 3777.5 3807.0 3816.5 3834.6 5291.5 5365.4 5373.5 5392.4 5395.2 4890.9 4896.0 4992.3 4993.5 5006.3 5768.2 5842.1 5842.8 5844.5 5903.3 4205.1 4246.7 4256.9 4257.3 4265.9 5863.5 6076.7 6077.6 6082.7 6112.4 4315.8 4330.5 4334.5 4346.6 4351.7 4348.5 4367.1 4376.4 4402.2 4428.7 4900.9 4976.4 4989.5 5002.3 5094.2 5870.6 5905.0 5915.0 5943.7 5976.1 1521.6 1534.9 1539.9 1545.1 1547.4 956.9 960.3 977.8 997.3 998.9 5648.5 5666.6 5677.2 5685.7 5734.8 5997.8 6015.9 6088.7 6103.0 6107.6 5642.3 5682.4 5717.6 5732.5 5773.5 3226.7 3240.0 3243.6 3244.4 3249.0 6043.9 6236.7 6250.4 6256.7 6319.5 6087.9 6120.3 6152.5 6154.9 6164.6 6035.9 6250.2 6283.5 6285.3 6285.7 5998.9 6059.3 6073.2 6079.0 6082.3 5940.3 5978.6 5981.2 5982.7 6017.8 5991.5 6249.8 6250.5 6264.6 6268.2 4219.8 4241.5 4250.4 4268.5 4282.3 5877.2 6089.2 6097.8 6100.5 6133.5 5936.9 5949.3 5951.5 5960.4 5962.7 5837.9 5840.0 5845.5 5875.0 5921.4 5600.7 5773.5 5811.1 5821.2 5859.1 5833.4 5961.3 5966.2 6006.7 6049.8 5556.4 5835.2 5837.0 5880.9 5909.8 14:47:56 INFO - PROCESS | 3750 | 14:47:56 INFO - PROCESS | 3750 | [#5] yui.html Cycles:180 Average:16187.82 Median:4661.35 stddev:20171.11 (432.7%) stddev-sans-first:20194.58 14:47:56 INFO - PROCESS | 3750 | Values: 795.4 809.9 822.5 836.1 844.9 14911.2 15613.7 15628.4 16059.8 16213.7 15306.8 15789.0 15846.5 15907.6 15910.3 816.7 827.5 828.9 831.6 833.4 796.8 819.2 823.8 824.5 827.0 865.5 866.5 868.7 868.8 869.4 847.3 851.9 854.9 855.5 858.0 624.4 626.2 627.0 633.0 633.3 12970.7 12977.5 13003.2 13027.0 13030.5 13144.6 13368.5 13587.7 13592.1 13599.3 10884.8 11081.9 11110.9 11200.5 11207.7 3748.6 3777.8 3793.4 3811.4 3833.5 51779.7 53540.2 54019.2 59576.1 59632.0 10223.0 10540.3 10961.3 11021.6 11117.9 18600.5 18610.5 18631.6 18678.8 18737.5 7566.8 7988.5 8112.6 8430.3 8708.0 4544.3 4610.4 4652.2 4670.5 4726.6 3275.4 3365.3 3368.2 3376.2 3389.2 627.9 642.2 647.2 659.8 668.5 631.8 678.1 679.4 750.5 758.6 9317.4 9557.0 9617.2 9728.2 9746.5 628.8 646.8 760.3 779.3 786.9 3986.7 4197.7 4225.6 4238.8 4305.8 74995.6 75075.2 75230.0 75809.6 77076.6 68111.3 68439.0 69008.3 69850.3 70034.0 60007.0 60888.4 60893.7 61268.4 61341.0 8295.3 8724.8 8726.5 8822.0 8876.2 36319.0 36752.0 36930.0 37032.0 37800.2 48900.8 49045.5 49953.5 50668.7 50869.2 11611.0 11971.4 12021.3 12238.6 12398.9 13712.2 13873.0 13892.7 13902.4 13975.0 12847.9 12946.3 13225.5 13229.5 13731.5 13187.1 13444.2 13798.0 13876.4 13894.4 12720.0 12721.7 13002.9 13200.7 13674.9 9627.7 9822.4 10001.6 10056.5 10091.5 10812.9 10966.2 10984.3 11411.9 11441.5 14:47:56 INFO - PROCESS | 3750 | -------- Summary: end -------- 14:47:56 INFO - PROCESS | 3750 | 14:47:57 INFO - TEST-INFO | 3750: exit 0 14:47:57 INFO - TEST-OK | dromaeo_css | took 1110225ms 14:47:57 INFO - TEST-START | kraken 14:47:57 INFO - operating with platform_type : linux_ 14:47:57 INFO - Initialising browser for kraken test... 14:47:57 INFO - TEST-INFO | started process 3983 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGTd426/profile http://localhost:60268/getInfo.html) 14:48:01 INFO - PROCESS | 3983 | __metrics Screen width/height:1600/1200 14:48:01 INFO - PROCESS | 3983 | colorDepth:24 14:48:01 INFO - PROCESS | 3983 | Browser inner width/height: 1024/697 14:48:01 INFO - PROCESS | 3983 | __metrics 14:48:02 ERROR - PROCESS | 3983 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 14:48:02 INFO - TEST-INFO | 3983: exit 0 14:48:02 INFO - Browser initialized. 14:48:02 INFO - Running cycle 1/1 for kraken test... 14:48:02 INFO - TEST-INFO | started process 4100 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGTd426/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:48:14 INFO - PROCESS | 4100 | RSS: Main: 167399424 14:48:14 INFO - PROCESS | 4100 | 14:48:17 INFO - PROCESS | 4100 | Cycle 1(1): loaded http://localhost:60268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60268/tests/kraken/driver.html?testName=audio-beat-detection) 14:48:18 INFO - PROCESS | 4100 | RSS: Main: 172404736 14:48:18 INFO - PROCESS | 4100 | 14:48:20 INFO - PROCESS | 4100 | Cycle 1(1): loaded http://localhost:60268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60268/tests/kraken/driver.html?testName=audio-dft) 14:48:21 INFO - PROCESS | 4100 | RSS: Main: 172068864 14:48:21 INFO - PROCESS | 4100 | 14:48:24 INFO - PROCESS | 4100 | Cycle 1(1): loaded http://localhost:60268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60268/tests/kraken/driver.html?testName=audio-fft) 14:48:24 INFO - PROCESS | 4100 | RSS: Main: 166776832 14:48:24 INFO - PROCESS | 4100 | 14:48:27 INFO - PROCESS | 4100 | Cycle 1(1): loaded http://localhost:60268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60268/tests/kraken/driver.html?testName=audio-oscillator) 14:48:27 INFO - PROCESS | 4100 | RSS: Main: 167641088 14:48:27 INFO - PROCESS | 4100 | 14:48:29 INFO - PROCESS | 4100 | Cycle 1(1): loaded http://localhost:60268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:48:30 INFO - PROCESS | 4100 | RSS: Main: 167866368 14:48:30 INFO - PROCESS | 4100 | 14:48:33 INFO - PROCESS | 4100 | Cycle 1(1): loaded http://localhost:60268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60268/tests/kraken/driver.html?testName=imaging-darkroom) 14:48:34 INFO - PROCESS | 4100 | RSS: Main: 168054784 14:48:34 INFO - PROCESS | 4100 | 14:48:37 INFO - PROCESS | 4100 | Cycle 1(1): loaded http://localhost:60268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60268/tests/kraken/driver.html?testName=imaging-desaturate) 14:48:38 INFO - PROCESS | 4100 | RSS: Main: 166010880 14:48:38 INFO - PROCESS | 4100 | 14:48:41 INFO - PROCESS | 4100 | Cycle 1(1): loaded http://localhost:60268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60268/tests/kraken/driver.html?testName=json-parse-financial) 14:48:41 INFO - PROCESS | 4100 | RSS: Main: 166936576 14:48:41 INFO - PROCESS | 4100 | 14:48:43 INFO - PROCESS | 4100 | Cycle 1(1): loaded http://localhost:60268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:48:43 INFO - PROCESS | 4100 | RSS: Main: 167313408 14:48:43 INFO - PROCESS | 4100 | 14:48:45 INFO - PROCESS | 4100 | Cycle 1(1): loaded http://localhost:60268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60268/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:48:46 INFO - PROCESS | 4100 | RSS: Main: 167415808 14:48:46 INFO - PROCESS | 4100 | 14:48:48 INFO - PROCESS | 4100 | Cycle 1(1): loaded http://localhost:60268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:48:49 INFO - PROCESS | 4100 | RSS: Main: 167632896 14:48:49 INFO - PROCESS | 4100 | 14:48:51 INFO - PROCESS | 4100 | Cycle 1(1): loaded http://localhost:60268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:48:52 INFO - PROCESS | 4100 | RSS: Main: 167739392 14:48:52 INFO - PROCESS | 4100 | 14:48:55 INFO - PROCESS | 4100 | Cycle 1(1): loaded http://localhost:60268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:48:55 INFO - PROCESS | 4100 | RSS: Main: 167944192 14:48:55 INFO - PROCESS | 4100 | 14:48:57 INFO - PROCESS | 4100 | Cycle 1(1): loaded http://localhost:60268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60268/tests/kraken/driver.html?testName=ai-astar) 14:48:57 INFO - PROCESS | 4100 | RSS: Main: 168423424 14:48:57 INFO - PROCESS | 4100 | 14:48:57 INFO - PROCESS | 4100 | __start_tp_report 14:48:57 INFO - PROCESS | 4100 | _x_x_mozilla_page_load 14:48:57 INFO - PROCESS | 4100 | _x_x_mozilla_page_load_details 14:48:57 INFO - PROCESS | 4100 | |i|pagename|runs| 14:48:57 INFO - PROCESS | 4100 | |0;ai-astar;111;104;111;111;111;113;109;109;110;110 14:48:57 INFO - PROCESS | 4100 | |1;audio-beat-detection;154;128;158;175;128;162;155;133;180;135 14:48:57 INFO - PROCESS | 4100 | |2;audio-dft;164;168;162;163;163;175;164;164;167;161 14:48:57 INFO - PROCESS | 4100 | |3;audio-fft;75;74;75;170;76;76;74;75;159;77 14:48:57 INFO - PROCESS | 4100 | |4;audio-oscillator;84;83;152;84;84;85;144;82;84;150 14:48:57 INFO - PROCESS | 4100 | |5;imaging-gaussian-blur;117;118;117;117;117;118;117;118;118;117 14:48:57 INFO - PROCESS | 4100 | |6;imaging-darkroom;146;148;146;147;149;146;146;146;146;146 14:48:57 INFO - PROCESS | 4100 | |7;imaging-desaturate;95;97;96;94;95;95;95;96;94;95 14:48:57 INFO - PROCESS | 4100 | |8;json-parse-financial;55;53;57;54;54;57;53;57;53;57 14:48:57 INFO - PROCESS | 4100 | |9;json-stringify-tinderbox;61;62;62;62;63;61;61;61;63;62 14:48:57 INFO - PROCESS | 4100 | |10;stanford-crypto-aes;82;82;81;80;80;81;82;80;115;87 14:48:57 INFO - PROCESS | 4100 | |11;stanford-crypto-ccm;126;129;137;131;121;128;127;128;132;123 14:48:57 INFO - PROCESS | 4100 | |12;stanford-crypto-pbkdf2;158;158;170;158;160;159;165;163;156;157 14:48:57 INFO - PROCESS | 4100 | |13;stanford-crypto-sha256-iterative;64;65;63;62;63;62;63;61;63;62 14:48:57 INFO - PROCESS | 4100 | __end_tp_report 14:48:57 INFO - PROCESS | 4100 | __start_cc_report 14:48:57 INFO - PROCESS | 4100 | _x_x_mozilla_cycle_collect,864 14:48:57 INFO - PROCESS | 4100 | __end_cc_report 14:48:57 INFO - PROCESS | 4100 | __startTimestamp1464817737573__endTimestamp 14:48:57 INFO - PROCESS | 4100 | 14:48:57 INFO - PROCESS | 4100 | ------- Summary: start ------- 14:48:57 INFO - PROCESS | 4100 | Number of tests: 14 14:48:57 INFO - PROCESS | 4100 | 14:48:57 INFO - PROCESS | 4100 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:2.38 (2.1%) stddev-sans-first:2.49 14:48:57 INFO - PROCESS | 4100 | Values: 111.0 104.0 111.0 111.0 111.0 113.0 109.0 109.0 110.0 110.0 14:48:57 INFO - PROCESS | 4100 | 14:48:57 INFO - PROCESS | 4100 | [#1] audio-beat-detection Cycles:10 Average:150.80 Median:156.50 stddev:19.00 (12.1%) stddev-sans-first:20.12 14:48:57 INFO - PROCESS | 4100 | Values: 154.0 128.0 158.0 175.0 128.0 162.0 155.0 133.0 180.0 135.0 14:48:57 INFO - PROCESS | 4100 | 14:48:57 INFO - PROCESS | 4100 | [#2] audio-dft Cycles:10 Average:165.10 Median:164.00 stddev:4.07 (2.5%) stddev-sans-first:4.29 14:48:57 INFO - PROCESS | 4100 | Values: 164.0 168.0 162.0 163.0 163.0 175.0 164.0 164.0 167.0 161.0 14:48:57 INFO - PROCESS | 4100 | 14:48:57 INFO - PROCESS | 4100 | [#3] audio-fft Cycles:10 Average:93.10 Median:75.00 stddev:37.73 (50.3%) stddev-sans-first:39.45 14:48:57 INFO - PROCESS | 4100 | Values: 75.0 74.0 75.0 170.0 76.0 76.0 74.0 75.0 159.0 77.0 14:48:57 INFO - PROCESS | 4100 | 14:48:57 INFO - PROCESS | 4100 | [#4] audio-oscillator Cycles:10 Average:103.20 Median:84.00 stddev:31.45 (37.4%) stddev-sans-first:32.58 14:48:57 INFO - PROCESS | 4100 | Values: 84.0 83.0 152.0 84.0 84.0 85.0 144.0 82.0 84.0 150.0 14:48:57 INFO - PROCESS | 4100 | 14:48:57 INFO - PROCESS | 4100 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 14:48:57 INFO - PROCESS | 4100 | Values: 117.0 118.0 117.0 117.0 117.0 118.0 117.0 118.0 118.0 117.0 14:48:57 INFO - PROCESS | 4100 | 14:48:57 INFO - PROCESS | 4100 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.00 stddev:1.07 (0.7%) stddev-sans-first:1.12 14:48:57 INFO - PROCESS | 4100 | Values: 146.0 148.0 146.0 147.0 149.0 146.0 146.0 146.0 146.0 146.0 14:48:57 INFO - PROCESS | 4100 | 14:48:57 INFO - PROCESS | 4100 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.92 (1.0%) stddev-sans-first:0.97 14:48:57 INFO - PROCESS | 4100 | Values: 95.0 97.0 96.0 94.0 95.0 95.0 95.0 96.0 94.0 95.0 14:48:57 INFO - PROCESS | 4100 | 14:48:57 INFO - PROCESS | 4100 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:56.00 stddev:1.83 (3.3%) stddev-sans-first:1.94 14:48:57 INFO - PROCESS | 4100 | Values: 55.0 53.0 57.0 54.0 54.0 57.0 53.0 57.0 53.0 57.0 14:48:57 INFO - PROCESS | 4100 | 14:48:57 INFO - PROCESS | 4100 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.79 (1.3%) stddev-sans-first:0.78 14:48:57 INFO - PROCESS | 4100 | Values: 61.0 62.0 62.0 62.0 63.0 61.0 61.0 61.0 63.0 62.0 14:48:57 INFO - PROCESS | 4100 | 14:48:57 INFO - PROCESS | 4100 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:81.50 stddev:10.74 (13.2%) stddev-sans-first:11.34 14:48:57 INFO - PROCESS | 4100 | Values: 82.0 82.0 81.0 80.0 80.0 81.0 82.0 80.0 115.0 87.0 14:48:57 INFO - PROCESS | 4100 | 14:48:57 INFO - PROCESS | 4100 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:128.50 stddev:4.54 (3.5%) stddev-sans-first:4.75 14:48:57 INFO - PROCESS | 4100 | Values: 126.0 129.0 137.0 131.0 121.0 128.0 127.0 128.0 132.0 123.0 14:48:57 INFO - PROCESS | 4100 | 14:48:57 INFO - PROCESS | 4100 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.40 Median:159.50 stddev:4.35 (2.7%) stddev-sans-first:4.53 14:48:57 INFO - PROCESS | 4100 | Values: 158.0 158.0 170.0 158.0 160.0 159.0 165.0 163.0 156.0 157.0 14:48:57 INFO - PROCESS | 4100 | 14:48:57 INFO - PROCESS | 4100 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:1.14 (1.8%) stddev-sans-first:1.12 14:48:57 INFO - PROCESS | 4100 | Values: 64.0 65.0 63.0 62.0 63.0 62.0 63.0 61.0 63.0 62.0 14:48:57 INFO - PROCESS | 4100 | -------- Summary: end -------- 14:48:57 INFO - PROCESS | 4100 | 14:48:58 INFO - TEST-INFO | 4100: exit 0 14:48:58 INFO - TEST-OK | kraken | took 61412ms 14:48:58 INFO - SUITE-END | took 1171s 14:48:58 INFO - Completed test suite (00:19:31) 14:48:58 INFO - javascript benchmark 14:48:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7215.423978185888, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3137.717605415513, 3168.207948012997, 3172.9206769830753, 3202.2954949911027, 3205.4230238557066, 5430.8913821723545, 5436.456354364566, 5451.236826844245, 5482.205080263359, 5494.2857428534235, 5275.709835959021, 5383.327084114486, 5403.78384864605, 5455.918161227585, 5544.362398324194, 4827.275908613701, 4853.708777473345, 4948.307236986807, 4996.125678006352, 5047.899042019158, 947.4564201009381, 4826.0, 4865.975670121645, 4918.139325618003, 4931.235658472942, 4869.2939523768855, 4921.458639549646, 4922.70463772173, 4928.162212423878, 4964.230544265626, 4950.554450099508, 4958.057968985881, 4968.701877887338, 4969.204927211665, 4971.328870602459, 4865.0756356292195, 4927.285543596195, 4935.062338155739, 4946.554810067111, 4957.1572832618185, 5379.569634429236, 5427.185922111676, 5469.480399362054, 5473.28847249859, 5477.5070243677865, 5722.513586345166, 5810.7385167667135, 5870.471657550841, 5878.970605146989, 5882.647041177543, 5900.232969713909, 5918.7928422505, 5938.198343223696, 5953.791617293374, 5990.580659353847, 5470.835874923799, 5474.069408200616, 5475.4524547545325, 5476.698781567012, 5537.473939975695, 5913.46778789911, 6009.038553831366, 6053.4551890330085, 6056.788012419544, 6058.697065146813, 5638.210650508932, 5666.773329066791, 5691.146328050742, 5716.0, 5739.053056245756, 5799.072148456311, 5813.76744930198, 5821.679807610622, 5823.737931793079, 5841.474267315962, 5811.27359080115, 5863.149843272787, 5889.352171261158, 5896.764129434775, 5947.6431414115295, 5912.379200184005, 5958.672273025025, 5970.611910225822, 5978.4021597839865, 5982.611130276518, 4397.406350142754, 4533.138703646297, 4537.2059889519205, 4544.302980025583, 4578.702384345007, 3927.5286965564314, 3976.661983731415, 3996.2207369562657, 4022.155347377025, 4033.274010678106, 5555.722213889289, 5569.693666848362, 5603.579731520153, 5634.126710359901, 5637.069883469182, 5817.418258174233, 5834.212381328466, 5875.0, 5876.676782776903, 5882.264716910387, 5646.943530564724, 5698.7435565399655, 5727.742251598688, 5744.540436765049, 5747.540196784331, 5123.948760512421, 5159.329287192641, 5161.0, 5172.9741351293005, 5196.4803519648485, 5975.581709280395, 6084.269887613515, 6184.134221209034, 6209.96895015522, 6230.6573138476915, 5923.822285331361, 5960.195373624505, 5991.940080599313, 6016.308124565556, 6042.093685947143, 6097.817065488042, 6123.112148738497, 6129.632222066691, 6138.693065346804, 6179.443850053517, 5716.114002329646, 5739.827805165852, 5851.502622277154, 5859.56053296013, 5870.442307980735, 5823.068309070698, 5934.643921364732, 5942.1978032965, 5958.076498142795, 5996.940030599638, 5713.742881570256, 5775.624584402, 5780.277465316835, 5794.507466865363, 5800.4489573490455, 5590.329160500766, 5698.230738850202, 5721.656700597978, 5784.681842498535, 5801.36185019639, 5706.686132262766, 5720.885582288414, 5732.7706891723865, 5738.68437235956, 5750.741216645178, 5814.331351894586, 5832.912506312494, 5867.178594996789, 5877.529797616095, 5879.7060146993335, 5564.944350556442, 5627.521660658726, 5680.943190568041, 5686.09022556389, 5734.627249228787], "value": 5391.693617834104, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.5466258986694, 618.1191801682602, 620.048225973131, 640.7533099756592, 650.4113777031788, 39736.60263397365, 40626.59373406265, 42762.0, 42843.57156428435, 42897.571024289784, 44899.77550112253, 45413.545864541346, 45711.0, 45817.770911145395, 45847.31229031567, 8712.956435217815, 8921.15249051339, 8944.373893827435, 8946.329025323093, 8961.05908879568, 8817.911820881773, 8907.554622268894, 8912.8663070054, 8920.464772113693, 8931.821363572757, 8898.154675305868, 8910.064443233432, 8974.237189838872, 9009.369344145913, 9021.864672029924, 8912.420692654989, 8955.552222388855, 8991.100889911022, 8998.460092394445, 9007.144321289466, 8786.384953053288, 8884.244839188612, 8886.06696296886, 8910.50992195429, 8949.418287811337, 41539.1692166158, 42022.0, 42023.7898810504, 42071.7896410519, 42134.0, 2976.479116154664, 3324.634290228073, 3446.2590543033366, 3459.0, 3586.946195807065, 31455.842720786477, 31683.914945972978, 31754.682453175403, 31821.0, 32441.351172976643, 4016.3172260715455, 4017.1563971565715, 4112.300908845504, 4115.218108559364, 4268.807903644343, 303736.0, 305480.0, 306091.9999999978, 306185.0, 306382.0, 34911.825440872635, 35035.824820876245, 35131.64868351284, 35218.47172292418, 35227.295454090774, 36155.81922090373, 36672.0, 36813.07967300839, 38850.0, 38874.416883746766, 16475.752863707054, 16486.17569121563, 16524.75212871808, 16533.421330253623, 16607.83392166063, 12547.623571292876, 12596.55912043074, 12605.0, 12613.117081804186, 12646.683832904067, 19668.0, 19955.0, 19979.60040799176, 19989.200431982557, 20122.29571964974, 7199.460040496983, 7214.170370407365, 7292.744753933587, 7428.4428667850125, 7462.291082347168, 1015.5582321690089, 1114.654457118296, 1163.947622356996, 1169.2984209474419, 1183.331417748969, 32533.349333013208, 32661.346773064404, 33108.503372449435, 33218.66781332204, 33364.0, 1102.818035024228, 1116.9329840209614, 1144.9183660251178, 1146.3263635092692, 1216.531635320408, 15909.681806363807, 16684.6663066738, 16956.915215423844, 17029.0, 17046.462271200955, 553713.0, 559092.0, 561132.0, 562188.0, 563255.0, 57197.71401143051, 57950.420495794504, 58129.70935145297, 58175.0, 58268.0, 1355.715299787036, 1364.0519838712198, 1375.4429456070307, 1413.1097408632495, 1420.7584710599017, 29920.700792992662, 30987.535186971763, 31506.369872602878, 31733.20666983344, 31857.8407107963, 49266.507334926195, 49726.25410618771, 50216.49783502118, 50269.74865125651, 50312.748436257585, 518096.0, 518228.0, 520710.0, 524586.0, 525916.0, 27333.726662733912, 28228.85885570641, 28287.29281767972, 28325.0, 28330.575041374806, 46286.53713462957, 46947.59157225289, 47415.52584474111, 47479.0, 47778.761106194244, 40645.59354406536, 40936.181276374904, 41509.58490415057, 41827.0, 42356.36465453082, 39749.0, 39936.80031599823, 40005.59994400019, 40764.796176020114, 41335.0, 37064.25871482609, 39918.2016359677, 40722.59277407306, 40727.0, 41583.58416415797, 34782.304353912274, 36729.63270367262, 37178.442323365714, 37254.44118338281, 37313.62686373101, 28194.0, 28450.57324140181, 28646.283842904093, 28823.0, 28891.0], "value": 19653.827928124654, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.1149425287355, 396.3143761292963, 400.5673872218004, 408.779259200032, 415.5242247626468, 14808.777868331958, 17931.193096310664, 19062.237510499563, 19484.123214455347, 19523.511912202186, 18387.0, 18431.815681843178, 18444.907775461103, 18484.260629574834, 18785.436436906915, 5579.497845193931, 5696.658200507973, 5824.650520968734, 5830.970845145768, 5881.705914704269, 5774.162746401769, 5774.913376299359, 5775.5668324875805, 5818.7963421280265, 5829.7376618052285, 5528.226048353234, 5740.052891272956, 5742.454466825645, 5756.395578464264, 5796.942030579704, 5557.249771280865, 5747.42525747424, 5774.047282198432, 5776.740046697867, 5779.913301300484, 5099.46455622158, 5133.666311689728, 5152.407473140599, 5165.251038599419, 5169.741512924376, 22297.21959731418, 22627.66058509124, 22963.54072918549, 23388.18141365044, 23416.297511074696, 2346.4368551547504, 2408.0969636386353, 2481.5781317176125, 2958.5118455454826, 3096.5045592705283, 13981.580552583337, 14307.928460357736, 14383.640408989755, 14792.0, 15005.474808381654, 1973.842092632586, 1986.6622674145285, 1994.8005199479935, 2095.1409921932086, 2171.1423987524995, 77656.0, 79899.20100798976, 82424.0, 82924.58537707334, 84398.15601844026, 11126.165537584551, 11182.273152245078, 11236.381998990135, 11266.211365204521, 11270.605528806616, 12212.328321942201, 12870.22778633285, 12882.871171288167, 15583.142927139117, 15682.902196846111, 7322.121345438475, 7423.1092268927, 7633.503822251536, 7810.609469526501, 7851.05787305527, 7529.736459223901, 7546.547207167588, 7702.3067923886, 7733.458657894006, 7837.725679601187, 3972.523297204354, 4035.1122752994293, 4086.2849001424634, 4192.0777428965575, 4198.6431153352305, 1950.658634738915, 1987.6322880267196, 2040.6326861165132, 2046.6827641715558, 2055.5991581641733, 918.5269586163131, 969.6751588218026, 985.8324084905584, 1025.707673313102, 1052.6999805055523, 17663.38178163784, 19186.61626767457, 19399.709004364944, 19884.204631814566, 20040.198392064445, 1008.3193844155165, 1033.9069483746348, 1055.551390658967, 1092.94535273236, 1093.1801149138146, 10550.366977981346, 11079.446027698745, 11102.61140860066, 11198.888011119947, 11208.383538905438, 453515.0, 461686.0, 463105.0, 538420.0, 539931.0, 59949.0, 90694.54652726694, 95277.5236123815, 96171.51914240383, 96292.51853740687, 1020.2246292817364, 1033.565902321027, 1046.7697106636529, 1052.55792567122, 1055.2718624149466, 17409.21658525344, 17542.473725788248, 17717.822821771617, 17819.910900445935, 17822.46532604024, 34869.476957845145, 39015.0, 40720.1855962885, 43247.56752432435, 45236.54763452455, 54798.0, 55230.44769552253, 55947.72026140006, 56625.71687141538, 56906.0, 5286.656367336111, 7931.920680793118, 8220.260176583897, 8651.351148664002, 8925.0, 11530.94234528822, 13119.73760524765, 13434.93282533581, 13439.126456780277, 13736.244506552235, 11358.488868000795, 11523.193376463567, 11711.355875426932, 11797.941010294893, 12061.336626485627, 11086.22396432242, 11261.66215013551, 11277.774444511228, 11337.603183888854, 11434.142439316918, 8913.777155570902, 10778.771200159264, 11844.763104737685, 12399.566015189424, 12436.626901192978, 8590.098039705741, 8599.097094804956, 8650.351223658377, 8842.46945183291, 8978.147076027766, 8949.507777072064, 10856.509882424325, 11988.220765650205, 12174.330411827434, 12230.510779569073], "value": 9202.129891583716, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1251.061703722208, 1271.3325504110342, 1400.4175281931418, 1583.7228485015119, 1590.4274461193975, 8046.959765201181, 8589.484630922141, 8736.51949142797, 9092.3180761443, 9203.769905752359, 8991.505467199302, 9008.189262966333, 9030.864537031934, 9037.72886813395, 9107.362484626063, 2363.9763602363973, 2403.0748161957686, 2403.351095204294, 2405.6151015837468, 2408.963865542018, 2350.236173243694, 2355.1521452277166, 2377.679013333204, 2378.286514045788, 2381.166591692911, 2334.4397344637337, 2343.355577216262, 2343.7187537495524, 2346.8239882008834, 2352.494213744045, 2305.1931823861682, 2306.5156317173414, 2338.543983923136, 2343.871087090209, 2359.504504054151, 2311.318161142467, 2337.988310058439, 2344.3553022918663, 2344.6131388320905, 2346.16711067572, 9017.639294428214, 9098.181163695299, 9099.681511147079, 9103.817923641556, 9106.225970792491, 5108.310378098946, 5229.738513074331, 5253.6322457428, 5302.708351040691, 5303.178007408857, 3243.399971005348, 3294.6046474422983, 3316.7512436567113, 3332.7000569948823, 3429.691327780487, 1164.9184557081007, 1166.4459381793665, 1172.7947609168448, 1184.1119160629528, 1203.3261373630708, 12777.23336599807, 12799.360031998363, 12803.743925121445, 12809.935950320189, 12835.614931552069, 4481.843135490242, 4512.548745125527, 4635.466921304093, 4640.791164397543, 4658.604018658384, 10104.242181836391, 10138.138258248131, 10193.490325483695, 10202.795944081077, 10217.33587316822, 5170.1727723564045, 5208.583313334924, 5218.947810521846, 5232.058229518723, 5247.239150323258, 4500.684952053391, 4816.807327706852, 4919.729414882216, 4994.4755800640405, 5034.093863104603, 4120.299549076604, 4156.189543039139, 4172.5410204877435, 4180.853670121592, 4228.302330115558, 1281.88463038327, 1287.5107459165458, 1305.3668970549277, 1305.4712841299288, 1307.6992291772756, 1002.4236064263077, 1011.7318910488726, 1013.7009582173276, 1018.7962407518378, 1027.4913917610832, 6200.131981522591, 6216.751329946842, 6225.906611400833, 6228.5951413158, 6363.522735794834, 456.82868924153445, 463.2194751843155, 465.8695565241738, 468.5501918158538, 471.6627611257967, 4134.834606615702, 4221.409002739619, 4284.143171365739, 4295.398644189816, 4295.656347492193, 11036.503357348938, 11313.83029254562, 11462.54149834014, 11463.0, 11480.598179063692, 11103.666889993314, 11210.943945280222, 11253.437328133561, 11270.661880143609, 11350.659480215607, 8397.370197235232, 8446.873296900552, 8494.0, 8504.872426913602, 8533.573321333908, 6027.638341699512, 6080.148779170831, 6149.84625384369, 6209.627422354673, 6317.842053948688, 9937.602495900082, 10280.177585793268, 10336.741581460523, 10388.792224155626, 10434.791304174027, 10470.581176752845, 10483.842742359024, 10510.264281500222, 10539.314944528582, 10582.365058096539, 7627.199144090013, 7882.448228623941, 7937.325327347009, 7952.522848629101, 8121.0, 8822.955885220534, 8823.07357727455, 8827.426217295855, 8866.42368246062, 8870.467771933705, 7550.962245188739, 7870.606469676608, 7883.526988380716, 8067.112617611941, 8069.31410830086, 7684.269994350528, 7702.075750909927, 7750.92249077502, 7842.176571459914, 7880.487768295043, 7332.706691732485, 7421.628918554159, 7426.517276377018, 7516.0, 7519.060117485315, 5160.741962901765, 5172.405173405106, 5266.315379000705, 5289.41816400188, 5473.452654734654, 5460.31746031746, 5593.776248949996, 5706.9714651426475, 5746.0721952574695, 5752.30972283312], "value": 4649.646819310709, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.0779479150566, 336.6364326527351, 337.1369294605808, 339.5619650650661, 343.673510165343, 5605.663660180387, 5654.151877218419, 5686.4597863203035, 5707.14392841074, 5707.77168913244, 5518.448155184479, 5518.834434966948, 5543.168524721294, 5554.7222638868, 5596.384397716248, 4069.226846899087, 4234.30134027885, 4307.1601037797645, 4312.159128969852, 4323.113761678848, 4343.674224433164, 4343.847965321214, 4346.804393802271, 4349.0, 4358.5423530529315, 4315.287977483711, 4327.610515053644, 4337.7397356158735, 4342.609165175134, 4361.9345709814215, 4163.333866581333, 4284.186004659105, 4295.165190973942, 4297.763623000734, 4299.081260811257, 3758.1919887224103, 3777.452269420946, 3807.0, 3816.503854498925, 3834.559025712051, 5291.4708529147165, 5365.382980957201, 5373.543248823855, 5392.379876314235, 5395.244665746799, 4890.877728056791, 4895.975520122377, 4992.326035985132, 4993.525615066599, 5006.272835871619, 5768.163616275659, 5842.123681447774, 5842.795502157446, 5844.53243740504, 5903.288046466562, 4205.137946720914, 4246.7027308088445, 4256.872293831159, 4257.34011228257, 4265.87202383929, 5863.53091752663, 6076.696165191723, 6077.604955677911, 6082.726277317532, 6112.419320164578, 4315.834724624334, 4330.501992270866, 4334.544872788375, 4346.587074227943, 4351.671855557262, 4348.5216626171095, 4367.10474352757, 4376.40918476008, 4402.207602631493, 4428.734275943454, 4900.926486102711, 4976.441844081499, 4989.451160372356, 5002.324686167393, 5094.159463688524, 5870.589058765845, 5905.0, 5914.970425147847, 5943.70281485924, 5976.133460648269, 1521.5587479631004, 1534.8541888520572, 1539.9384024639114, 1545.1347245542531, 1547.411983446283, 956.9043445255282, 960.2605993385055, 977.7604486900755, 997.2670087485692, 998.8851282102651, 5648.4633959773755, 5666.603337766317, 5677.17680936262, 5685.658860468302, 5734.827955161351, 5997.820065398045, 6015.909761353583, 6088.665123418166, 6103.0, 6107.633541987495, 5642.26650535436, 5682.374938756733, 5717.628354156966, 5732.541396688338, 5773.45967774178, 3226.6934641209045, 3239.967600324014, 3243.62698289695, 3244.3835671222864, 3248.9675103249137, 6043.8791224175275, 6236.656983865931, 6250.4374606285655, 6256.6871656417, 6319.494440444753, 6087.878242435127, 6120.265568131853, 6152.477039451607, 6154.907676384858, 6164.568480206342, 6035.857270669025, 6250.249970003538, 6283.465905398001, 6285.308616052231, 6285.685715714196, 5998.850028749316, 6059.303824666861, 6073.210482637405, 6079.0, 6082.300535438481, 5940.346561878104, 5978.581499295007, 5981.192539007352, 5982.7008649568215, 6017.789377371771, 5991.47217459545, 6249.78125765596, 6250.468710159687, 6264.5614806964895, 6268.1851359323, 4219.831206751818, 4241.512226094039, 4250.404943308001, 4268.466441694788, 4282.272013757606, 5877.207451727264, 6089.208402907594, 6097.756089756537, 6100.481459076028, 6133.478654314434, 5936.940630593639, 5949.286085669747, 5951.49412299942, 5960.403959604005, 5962.704358821798, 5837.883242335214, 5840.0, 5845.473907348359, 5874.970625146847, 5921.407859214044, 5600.691961942132, 5773.53811695055, 5811.099279611667, 5821.224526519452, 5859.121131830259, 5833.445822646841, 5961.2846458425265, 5966.224390829165, 6006.699665016819, 6049.848753781191, 5556.388797232382, 5835.2122463466885, 5836.970815145897, 5880.911786323123, 5909.8227053188475], "value": 4482.72754085299, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [795.4193438789683, 809.9190080991898, 822.4982760516084, 836.0719601242623, 844.8774927635491, 14911.179885106314, 15613.687726245482, 15628.374865005415, 16059.839401605981, 16213.675726485464, 15306.846931530681, 15789.0, 15846.524604261862, 15907.602309942256, 15910.284037218324, 816.7263966571206, 827.5365795154732, 828.9295409890136, 831.6340810043562, 833.4374297349295, 796.8167321516055, 819.1849110135423, 823.7940514871282, 824.5464994253167, 826.9545175015402, 865.4504389712515, 866.4584634603373, 868.674247157316, 868.7741187291318, 869.4044579463088, 847.3009766942297, 851.8509260879352, 854.9358798090137, 855.5422848775875, 858.0347109501811, 624.4473640827855, 626.1953389893964, 626.9529785266078, 633.0283015571076, 633.3223450907531, 12970.675733106653, 12977.545785897542, 13003.219806811621, 13027.0, 13030.478780848754, 13144.605661830064, 13368.532101376502, 13587.660308492268, 13592.11651242666, 13599.252041137734, 10884.836727449094, 11081.889181108247, 11110.888891111146, 11200.495977680943, 11207.66377008691, 3748.55017397914, 3777.8111094445444, 3793.3930571108767, 3811.4092315690837, 3833.50164478616, 51779.74110129463, 53540.196897046575, 54019.189712154744, 59576.10635840466, 59632.0, 10223.0, 10540.262181647364, 10961.342319460859, 11021.559137634405, 11117.888821111685, 18600.53498662517, 18610.534736631693, 18631.627367452576, 18678.813211867706, 18737.531561711065, 7566.810829729191, 7988.520688758693, 8112.641943937089, 8430.283425908867, 8707.956460217658, 4544.250198717241, 4610.423697037871, 4652.1626107300335, 4670.53294670537, 4726.645501587326, 3275.410426123273, 3365.2764655598676, 3368.1747971747077, 3376.206591451007, 3389.1527118220447, 627.9372062793684, 642.2357394700292, 647.2007071266981, 659.7954634063456, 668.4585485756553, 631.835722712089, 678.0575000748963, 679.3626271329185, 750.4784174998324, 758.5941521286086, 9317.39436936597, 9557.0, 9617.182539484082, 9728.221742260603, 9746.463944482979, 628.7610707930957, 646.8188907106017, 760.3119177144692, 779.3414564692825, 786.9134395216522, 3986.661133803659, 4197.685173611992, 4225.619694227473, 4238.830446782094, 4305.784710764449, 74995.62502187454, 75075.24924750792, 75230.0, 75809.62095189489, 77076.61461692768, 68111.3188868115, 68439.0, 69008.3099169012, 69850.30149698438, 70034.0, 60007.0, 60888.39111608827, 60893.69553152206, 61268.38731612627, 61341.0, 8295.253427191581, 8724.78188045304, 8726.476411415335, 8821.955890220508, 8876.156765107304, 36319.0, 36752.0, 36930.0, 37032.0, 37800.243995120494, 48900.75549622229, 49045.5095449041, 49953.50046499488, 50668.746656266485, 50869.23696144487, 11611.0, 11971.401429928643, 12021.278723276631, 12238.571649992207, 12398.938005309916, 13712.17726936387, 13873.0, 13892.72214555683, 13902.37439315213, 13975.0, 12847.871521284667, 12946.287954162612, 13225.470981160646, 13229.470821167046, 13731.45074197061, 13187.142835715647, 13444.193348399127, 13798.034137610672, 13876.444942202199, 13894.374753136335, 12720.0, 12721.681957951125, 13002.869971300166, 13200.679932006722, 13674.863251367757, 9627.711168664951, 9822.361546499455, 10001.599936002769, 10056.49717514136, 10091.495425228562, 10812.945935270272, 10966.232363734782, 10984.340939543654, 11411.885881141083, 11441.542338306708], "value": 6942.351108068876, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 111.0, 111.0, 111.0, 113.0, 109.0, 109.0, 110.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 128.0, 158.0, 175.0, 128.0, 162.0, 155.0, 133.0, 180.0, 135.0], "value": 150.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 168.0, 162.0, 163.0, 163.0, 175.0, 164.0, 164.0, 167.0, 161.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 170.0, 76.0, 76.0, 74.0, 75.0, 159.0, 77.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 152.0, 84.0, 84.0, 85.0, 144.0, 82.0, 84.0, 150.0], "value": 103.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 147.0, 149.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 96.0, 94.0, 95.0, 95.0, 95.0, 96.0, 94.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 57.0, 54.0, 54.0, 57.0, 53.0, 57.0, 53.0, 57.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 63.0, 61.0, 61.0, 61.0, 63.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 81.0, 80.0, 80.0, 81.0, 82.0, 80.0, 115.0, 87.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 129.0, 137.0, 131.0, 121.0, 128.0, 127.0, 128.0, 132.0, 123.0], "value": 128.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 158.0, 170.0, 158.0, 160.0, 159.0, 165.0, 163.0, 156.0, 157.0], "value": 160.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 63.0, 62.0, 63.0, 62.0, 63.0, 61.0, 63.0, 62.0], "value": 62.8, "unit": "score"}]}]} 14:48:58 INFO - Return code: 0 14:48:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:48:58 ERROR - # TBPL SUCCESS # 14:48:58 INFO - Running post-action listener: _resource_record_post_action 14:48:58 INFO - ##### 14:48:58 INFO - ##### Finished run-tests step (success) 14:48:58 INFO - ##### 14:48:58 INFO - Running post-run listener: _resource_record_post_run 14:48:58 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 543920128; Read time: 0; Write time: 390352 14:48:58 INFO - TinderboxPrint: CPU usage
13.4% 14:48:58 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 14:48:58 INFO - TinderboxPrint: I/O write bytes / time
543,920,128 / 390,352 14:48:58 INFO - TinderboxPrint: CPU idle
8,217.8 (86.5%) 14:48:58 INFO - TinderboxPrint: CPU user
1,223.9 (12.9%) 14:48:58 INFO - TinderboxPrint: Swap in / out
0 / 0 14:48:58 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 251072512; Read time: 0; Write time: 218904 14:48:58 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 287731712; Read time: 0; Write time: 170680 14:48:59 INFO - Running post-run listener: _upload_blobber_files 14:48:59 INFO - Blob upload gear active. 14:48:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:48:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:48:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:48:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:48:59 INFO - (blobuploader) - INFO - Open directory for files ... 14:48:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:48:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:48:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:49:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:49:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:49:00 INFO - (blobuploader) - INFO - Done attempting. 14:49:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:49:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:49:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:49:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:49:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:49:01 INFO - (blobuploader) - INFO - Done attempting. 14:49:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:49:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:49:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:49:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:49:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:49:05 INFO - (blobuploader) - INFO - Done attempting. 14:49:05 INFO - (blobuploader) - INFO - Iteration through files over. 14:49:05 INFO - Return code: 0 14:49:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:49:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:49:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bf414a920e9437879b59f5d3b2751fc5c5b2538bad0564b09a21a9adbcfd03886118dd74b299a7fef05e5cfbc589d8e59fa2242d68069fb465880bbee6180753", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8401559874d199bd7adb211b13c206c70a5e46c2c2ec898b71185d3dda070b0779c4c98ef438bdd5ea6b88752929836f877201896ca2e4d54f115deefade20d9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56b662e3671940a93152fd7b1cc6961360250679af82004bf0dc6c1ccb7d715ae86a7d067db42423c07218ed4978ebcb347791fe7e65b50fd0bb8ff295d9f03a"} 14:49:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:49:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:49:05 INFO - Contents: 14:49:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bf414a920e9437879b59f5d3b2751fc5c5b2538bad0564b09a21a9adbcfd03886118dd74b299a7fef05e5cfbc589d8e59fa2242d68069fb465880bbee6180753", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8401559874d199bd7adb211b13c206c70a5e46c2c2ec898b71185d3dda070b0779c4c98ef438bdd5ea6b88752929836f877201896ca2e4d54f115deefade20d9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56b662e3671940a93152fd7b1cc6961360250679af82004bf0dc6c1ccb7d715ae86a7d067db42423c07218ed4978ebcb347791fe7e65b50fd0bb8ff295d9f03a"} 14:49:05 INFO - Running post-run listener: copy_logs_to_upload_dir 14:49:05 INFO - Copying logs to upload dir... 14:49:05 INFO - mkdir: /builds/slave/test/build/upload/logs 14:49:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.673389 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-06-01 14:49:05.737346) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 14:49:05.741216) ========= 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=41bf3e9aed84707956354da8000001c5-1464816465.776019-620572038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bf414a920e9437879b59f5d3b2751fc5c5b2538bad0564b09a21a9adbcfd03886118dd74b299a7fef05e5cfbc589d8e59fa2242d68069fb465880bbee6180753", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8401559874d199bd7adb211b13c206c70a5e46c2c2ec898b71185d3dda070b0779c4c98ef438bdd5ea6b88752929836f877201896ca2e4d54f115deefade20d9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56b662e3671940a93152fd7b1cc6961360250679af82004bf0dc6c1ccb7d715ae86a7d067db42423c07218ed4978ebcb347791fe7e65b50fd0bb8ff295d9f03a"} build_url:https://queue.taskcluster.net/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011427 build_url: 'https://queue.taskcluster.net/v1/task/EvDzxYytRzSM1u-qc8krpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bf414a920e9437879b59f5d3b2751fc5c5b2538bad0564b09a21a9adbcfd03886118dd74b299a7fef05e5cfbc589d8e59fa2242d68069fb465880bbee6180753", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8401559874d199bd7adb211b13c206c70a5e46c2c2ec898b71185d3dda070b0779c4c98ef438bdd5ea6b88752929836f877201896ca2e4d54f115deefade20d9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56b662e3671940a93152fd7b1cc6961360250679af82004bf0dc6c1ccb7d715ae86a7d067db42423c07218ed4978ebcb347791fe7e65b50fd0bb8ff295d9f03a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 14:49:05.773110) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 14:49:05.773687) ========= 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=41bf3e9aed84707956354da8000001c5-1464816465.776019-620572038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 14:49:05.857139) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 14:49:05.857692) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 14:49:05.858139) ========= ========= Total master_lag: 0.18 =========