builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-053 starttime: 1455345692.79 results: success (0) buildid: 20160212203128 builduid: 1e417528b49c41dc9dbc533ef962cfe3 revision: 617e089684ae22f75215467ac13729d1ef3bf01e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:32.788300) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:32.788730) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:32.789041) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1455338373.179070-87280582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006314 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:32.817514) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:32.817824) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:32.844035) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:32.844365) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1455338373.179070-87280582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004637 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:32.894018) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:32.898960) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:32.899388) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:32.899686) ========= 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-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1455338373.179070-87280582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-12 22:41: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% 39.9M=0s 2016-02-12 22:41:33 (39.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.171308 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:33.083399) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:33.084191) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1455338373.179070-87280582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018378 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:33.133997) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-12 22:41:33.137358) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 617e089684ae22f75215467ac13729d1ef3bf01e --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 617e089684ae22f75215467ac13729d1ef3bf01e --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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1455338373.179070-87280582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-12 22:41:33,812 truncating revision to first 12 chars 2016-02-12 22:41:33,812 Setting DEBUG logging. 2016-02-12 22:41:33,812 attempt 1/10 2016-02-12 22:41:33,812 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/617e089684ae?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-12 22:41:34,560 unpacking tar archive at: fx-team-617e089684ae/testing/mozharness/ program finished with exit code 0 elapsedTime=1.039894 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-12 22:41:34.194362) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:34.194722) ========= echo 617e089684ae22f75215467ac13729d1ef3bf01e in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'617e089684ae22f75215467ac13729d1ef3bf01e'] 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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1455338373.179070-87280582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 617e089684ae22f75215467ac13729d1ef3bf01e program finished with exit code 0 elapsedTime=0.004807 script_repo_revision: '617e089684ae22f75215467ac13729d1ef3bf01e' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:34.247951) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:34.248287) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:34.260941) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-02-12 22:41:34.261358) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1455338373.179070-87280582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:41:35 INFO - MultiFileLogger online at 20160212 22:41:35 in /builds/slave/test-pgo 22:41:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 22:41:35 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:41:35 INFO - {'append_to_log': False, 22:41:35 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:41:35 INFO - 'blob_upload_branch': 'Fx-Team', 22:41:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:41:35 INFO - 'branch': 'Fx-Team', 22:41:35 INFO - 'buildbot_json_path': 'buildprops.json', 22:41:35 INFO - 'config_files': ('talos/linux_config.py',), 22:41:35 INFO - 'default_actions': ('clobber', 22:41:35 INFO - 'read-buildbot-config', 22:41:35 INFO - 'download-and-extract', 22:41:35 INFO - 'populate-webroot', 22:41:35 INFO - 'create-virtualenv', 22:41:35 INFO - 'install', 22:41:35 INFO - 'run-tests'), 22:41:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:41:35 INFO - 'download_minidump_stackwalk': True, 22:41:35 INFO - 'download_symbols': 'ondemand', 22:41:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:41:35 INFO - 'tooltool.py': '/tools/tooltool.py', 22:41:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:41:35 INFO - '/tools/misc-python/virtualenv.py')}, 22:41:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:41:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:41:35 INFO - 'installer_path': 'installer.exe', 22:41:35 INFO - 'log_level': 'info', 22:41:35 INFO - 'log_name': 'talos', 22:41:35 INFO - 'log_to_console': True, 22:41:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:41:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:41:35 INFO - 'opt_config_files': (), 22:41:35 INFO - 'pip_index': False, 22:41:35 INFO - 'sps_profile': False, 22:41:35 INFO - 'sps_profile_interval': 0, 22:41:35 INFO - 'suite': 'dromaeojs', 22:41:35 INFO - 'system_bits': '32', 22:41:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:41:35 INFO - 'title': 'talos-linux64-ix-053', 22:41:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:41:35 INFO - 'use_talos_json': True, 22:41:35 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:41:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:41:35 INFO - 'work_dir': 'build'} 22:41:35 INFO - ##### 22:41:35 INFO - ##### Running clobber step. 22:41:35 INFO - ##### 22:41:35 INFO - Running pre-action listener: _resource_record_pre_action 22:41:35 INFO - Running main action method: clobber 22:41:35 INFO - rmtree: /builds/slave/test-pgo/build 22:41:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:41:35 INFO - Running post-action listener: _resource_record_post_action 22:41:35 INFO - ##### 22:41:35 INFO - ##### Running read-buildbot-config step. 22:41:35 INFO - ##### 22:41:35 INFO - Running pre-action listener: _resource_record_pre_action 22:41:35 INFO - Running main action method: read_buildbot_config 22:41:35 INFO - Using buildbot properties: 22:41:35 INFO - { 22:41:35 INFO - "project": "", 22:41:35 INFO - "product": "firefox", 22:41:35 INFO - "script_repo_revision": "production", 22:41:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:41:35 INFO - "repository": "", 22:41:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 22:41:35 INFO - "buildid": "20160212203128", 22:41:35 INFO - "pgo_build": "True", 22:41:35 INFO - "basedir": "/builds/slave/test-pgo", 22:41:35 INFO - "buildnumber": 941, 22:41:35 INFO - "slavename": "talos-linux64-ix-053", 22:41:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:41:35 INFO - "platform": "ubuntu64_hw", 22:41:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:41:35 INFO - "branch": "fx-team", 22:41:35 INFO - "repo_path": "integration/fx-team", 22:41:35 INFO - "revision": "617e089684ae22f75215467ac13729d1ef3bf01e", 22:41:35 INFO - "stage_platform": "linux64-pgo", 22:41:35 INFO - "builduid": "1e417528b49c41dc9dbc533ef962cfe3", 22:41:35 INFO - "slavebuilddir": "test" 22:41:35 INFO - } 22:41:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 22:41:35 INFO - Running post-action listener: _resource_record_post_action 22:41:35 INFO - ##### 22:41:35 INFO - ##### Running download-and-extract step. 22:41:35 INFO - ##### 22:41:35 INFO - Running pre-action listener: _resource_record_pre_action 22:41:35 INFO - Running main action method: download_and_extract 22:41:35 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:41: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')]} 22:41:35 INFO - https://queue.taskcluster.net/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:41:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/test_packages.json 22:41:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/test_packages.json 22:41:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:41:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:41:36 INFO - Downloaded 1448 bytes. 22:41:36 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:41:36 INFO - Using the following test package requirements: 22:41:36 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:41:36 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:36 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:41:36 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:36 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:41:36 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:36 INFO - u'jsshell-linux-x86_64.zip'], 22:41:36 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:36 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:41:36 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:41:36 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:36 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:41:36 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:36 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:41:36 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:36 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:41:36 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:41:36 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:36 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:41:36 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:41:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:36 INFO - https://queue.taskcluster.net/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:41:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:41:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:41:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:41:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:41:37 INFO - Downloaded 23296074 bytes. 22:41:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:41:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:41:38 INFO - Return code: 0 22:41:38 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:41:38 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')]} 22:41:38 INFO - https://queue.taskcluster.net/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:41:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:41:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:41:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:41:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:41:40 INFO - Downloaded 23296074 bytes. 22:41:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:41:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:41:41 INFO - Return code: 0 22:41: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')]} 22:41:41 INFO - https://queue.taskcluster.net/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:41:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:41:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:41:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:41:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:41:42 INFO - Downloaded 10707070 bytes. 22:41:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:41:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 22:41:42 INFO - Return code: 0 22:41:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:42 INFO - https://queue.taskcluster.net/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:41:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:41:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:41:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:41:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:41:44 INFO - Downloaded 56531876 bytes. 22:41:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:41:44 INFO - mkdir: /builds/slave/test-pgo/properties 22:41:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:41:44 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:41:44 INFO - Contents: 22:41:44 INFO - build_url:https://queue.taskcluster.net/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:41:44 INFO - Running post-action listener: _resource_record_post_action 22:41:44 INFO - Running post-action listener: set_extra_try_arguments 22:41:44 INFO - ##### 22:41:44 INFO - ##### Running populate-webroot step. 22:41:44 INFO - ##### 22:41:44 INFO - Running pre-action listener: _resource_record_pre_action 22:41:44 INFO - Running main action method: populate_webroot 22:41:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:41:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:41:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:41:44 INFO - '--tppagecycles', 22:41:44 INFO - '7'], 22:41:44 INFO - 'tests': ['tsvgm']}}, 22:41:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:41:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:41:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:41:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:41:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:41:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:41:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:41:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:44 INFO - 'talos_options': ['--e10s'], 22:41:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:41:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:44 INFO - 'tests': ['damp', 'tps']}, 22:41:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:44 INFO - 'talos_options': ['--e10s'], 22:41:44 INFO - 'tests': ['damp', 'tps']}, 22:41:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:41:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:41:44 INFO - 'other': {'tests': ['a11yr', 22:41:44 INFO - 'ts_paint', 22:41:44 INFO - 'tpaint', 22:41:44 INFO - 'sessionrestore', 22:41:44 INFO - 'sessionrestore_no_auto_restore']}, 22:41:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:41:44 INFO - 'tests': ['a11yr', 22:41:44 INFO - 'ts_paint', 22:41:44 INFO - 'tpaint', 22:41:44 INFO - 'sessionrestore', 22:41:44 INFO - 'sessionrestore_no_auto_restore']}, 22:41:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:41:44 INFO - 'tests': ['a11yr', 22:41:44 INFO - 'ts_paint', 22:41:44 INFO - 'tpaint', 22:41:44 INFO - 'sessionrestore', 22:41:44 INFO - 'sessionrestore_no_auto_restore']}, 22:41:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:41:44 INFO - 'tests': ['a11yr', 22:41:44 INFO - 'ts_paint', 22:41:44 INFO - 'tpaint', 22:41:44 INFO - 'sessionrestore', 22:41:44 INFO - 'sessionrestore_no_auto_restore']}, 22:41:44 INFO - 'other_l64': {'tests': ['a11yr', 22:41:44 INFO - 'ts_paint', 22:41:44 INFO - 'tpaint', 22:41:44 INFO - 'sessionrestore', 22:41:44 INFO - 'sessionrestore_no_auto_restore']}, 22:41:44 INFO - 'other_nol64': {'tests': ['a11yr', 22:41:44 INFO - 'ts_paint', 22:41:44 INFO - 'tpaint', 22:41:44 INFO - 'sessionrestore', 22:41:44 INFO - 'sessionrestore_no_auto_restore']}, 22:41:44 INFO - 'svgr': {'tests': ['tsvgx', 22:41:44 INFO - 'tsvgr_opacity', 22:41:44 INFO - 'tart', 22:41:44 INFO - 'tscrollx', 22:41:44 INFO - 'cart']}, 22:41:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:41:44 INFO - 'tests': ['tsvgx', 22:41:44 INFO - 'tsvgr_opacity', 22:41:44 INFO - 'tart', 22:41:44 INFO - 'tscrollx', 22:41:44 INFO - 'cart']}, 22:41:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:44 INFO - 'tests': ['tp5o']}, 22:41:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:44 INFO - 'talos_options': ['--e10s'], 22:41:44 INFO - 'tests': ['tp5o']}, 22:41:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:44 INFO - 'talos_options': ['--xperf_path', 22:41:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:41:44 INFO - 'tests': ['tp5n']}, 22:41:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:44 INFO - 'talos_options': ['--e10s', 22:41:44 INFO - '--xperf_path', 22:41:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:41:44 INFO - 'tests': ['tp5n']}}, 22:41:44 INFO - 'talos.zip': {'path': '', 22:41:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:41:44 INFO - Running post-action listener: _resource_record_post_action 22:41:44 INFO - ##### 22:41:44 INFO - ##### Running create-virtualenv step. 22:41:44 INFO - ##### 22:41:44 INFO - Running pre-action listener: _resource_record_pre_action 22:41:44 INFO - Running main action method: create_virtualenv 22:41:44 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:41:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 22:41:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:41:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:41:45 INFO - Using real prefix '/usr' 22:41:45 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:41:45 INFO - Installing distribute.............................................................................................................................................................................................done. 22:41:47 INFO - Installing pip.................done. 22:41:47 INFO - Return code: 0 22:41:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:41: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')]} 22:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41: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')]} 22:41:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/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 0x7fec9ea1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1228670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b78c0>, '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 0x12b87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b8c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1455338373.179070-87280582', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 22:41:47 INFO - Running command: ['/builds/slave/test-pgo/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-pgo/build 22:41:47 INFO - Copy/paste: /builds/slave/test-pgo/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 22:41:47 INFO - Using env: {'DISPLAY': ':0', 22:41:47 INFO - 'HOME': '/home/cltbld', 22:41:47 INFO - 'LANG': 'en_US.UTF-8', 22:41:47 INFO - 'LANGUAGE': 'en_US:en', 22:41:47 INFO - 'LOGNAME': 'cltbld', 22:41:47 INFO - 'MAIL': '/var/mail/cltbld', 22:41:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:47 INFO - 'MOZ_NO_REMOTE': '1', 22:41:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:47 INFO - 'NO_EM_RESTART': '1', 22:41:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:41:47 INFO - 'PWD': '/builds/slave/test-pgo', 22:41:47 INFO - 'SHELL': '/bin/bash', 22:41:47 INFO - 'SHLVL': '1', 22:41:47 INFO - 'TERM': 'linux', 22:41:47 INFO - 'TMOUT': '86400', 22:41:47 INFO - 'USER': 'cltbld', 22:41:47 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1455338373.179070-87280582', 22:41:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:47 INFO - '_': '/tools/buildbot/bin/python'} 22:41:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41: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 22:41:47 INFO - Cleaning up... 22:41:47 INFO - Return code: 0 22:41:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:41: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')]} 22:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41: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')]} 22:41:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec9ea1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1228670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b78c0>, '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 0x12b87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b8c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1455338373.179070-87280582', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 22:41:47 INFO - Running command: ['/builds/slave/test-pgo/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>=0.7.1'] in /builds/slave/test-pgo/build 22:41:47 INFO - Copy/paste: /builds/slave/test-pgo/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>=0.7.1 22:41:47 INFO - Using env: {'DISPLAY': ':0', 22:41:47 INFO - 'HOME': '/home/cltbld', 22:41:47 INFO - 'LANG': 'en_US.UTF-8', 22:41:47 INFO - 'LANGUAGE': 'en_US:en', 22:41:47 INFO - 'LOGNAME': 'cltbld', 22:41:47 INFO - 'MAIL': '/var/mail/cltbld', 22:41:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:47 INFO - 'MOZ_NO_REMOTE': '1', 22:41:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:47 INFO - 'NO_EM_RESTART': '1', 22:41:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:41:47 INFO - 'PWD': '/builds/slave/test-pgo', 22:41:47 INFO - 'SHELL': '/bin/bash', 22:41:47 INFO - 'SHLVL': '1', 22:41:47 INFO - 'TERM': 'linux', 22:41:47 INFO - 'TMOUT': '86400', 22:41:47 INFO - 'USER': 'cltbld', 22:41:47 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1455338373.179070-87280582', 22:41:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:47 INFO - '_': '/tools/buildbot/bin/python'} 22:41:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:47 INFO - Downloading/unpacking psutil>=0.7.1 22:41: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 22:41: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 22:41: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 22:41: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 22:41: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 22:41: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 22:41:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:41:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:41:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:41:49 INFO - Installing collected packages: psutil 22:41:49 INFO - Running setup.py install for psutil 22:41:49 INFO - building 'psutil._psutil_linux' extension 22:41: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 22:41:50 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 22:41:50 INFO - building 'psutil._psutil_posix' extension 22:41:50 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 22:41:50 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 22:41:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:41:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:41:50 INFO - Successfully installed psutil 22:41:50 INFO - Cleaning up... 22:41:50 INFO - Return code: 0 22:41:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec9ea1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1228670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b78c0>, '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 0x12b87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b8c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1455338373.179070-87280582', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 22:41:50 INFO - Running command: ['/builds/slave/test-pgo/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.0.0'] in /builds/slave/test-pgo/build 22:41:50 INFO - Copy/paste: /builds/slave/test-pgo/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.0.0 22:41:50 INFO - Using env: {'DISPLAY': ':0', 22:41:50 INFO - 'HOME': '/home/cltbld', 22:41:50 INFO - 'LANG': 'en_US.UTF-8', 22:41:50 INFO - 'LANGUAGE': 'en_US:en', 22:41:50 INFO - 'LOGNAME': 'cltbld', 22:41:50 INFO - 'MAIL': '/var/mail/cltbld', 22:41:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:50 INFO - 'MOZ_NO_REMOTE': '1', 22:41:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:50 INFO - 'NO_EM_RESTART': '1', 22:41:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:41:50 INFO - 'PWD': '/builds/slave/test-pgo', 22:41:50 INFO - 'SHELL': '/bin/bash', 22:41:50 INFO - 'SHLVL': '1', 22:41:50 INFO - 'TERM': 'linux', 22:41:50 INFO - 'TMOUT': '86400', 22:41:50 INFO - 'USER': 'cltbld', 22:41:50 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1455338373.179070-87280582', 22:41:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:50 INFO - '_': '/tools/buildbot/bin/python'} 22:41:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:41:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:41:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:41:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:41:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:41:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:41:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:41:52 INFO - Installing collected packages: mozsystemmonitor 22:41:52 INFO - Running setup.py install for mozsystemmonitor 22:41:52 INFO - Successfully installed mozsystemmonitor 22:41:52 INFO - Cleaning up... 22:41:52 INFO - Return code: 0 22:41:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:41: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')]} 22:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41: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')]} 22:41:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/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 0x7fec9ea1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1228670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b78c0>, '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 0x12b87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b8c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1455338373.179070-87280582', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 22:41:52 INFO - Running command: ['/builds/slave/test-pgo/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-pgo/build 22:41:52 INFO - Copy/paste: /builds/slave/test-pgo/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 22:41:52 INFO - Using env: {'DISPLAY': ':0', 22:41:52 INFO - 'HOME': '/home/cltbld', 22:41:52 INFO - 'LANG': 'en_US.UTF-8', 22:41:52 INFO - 'LANGUAGE': 'en_US:en', 22:41:52 INFO - 'LOGNAME': 'cltbld', 22:41:52 INFO - 'MAIL': '/var/mail/cltbld', 22:41:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:52 INFO - 'MOZ_NO_REMOTE': '1', 22:41:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:52 INFO - 'NO_EM_RESTART': '1', 22:41:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:41:52 INFO - 'PWD': '/builds/slave/test-pgo', 22:41:52 INFO - 'SHELL': '/bin/bash', 22:41:52 INFO - 'SHLVL': '1', 22:41:52 INFO - 'TERM': 'linux', 22:41:52 INFO - 'TMOUT': '86400', 22:41:52 INFO - 'USER': 'cltbld', 22:41:52 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1455338373.179070-87280582', 22:41:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:52 INFO - '_': '/tools/buildbot/bin/python'} 22:41:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:52 INFO - Downloading/unpacking blobuploader==1.2.4 22:41: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 22:41: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 22:41: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 22:41: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 22:41: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 22:41: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 22:41:54 INFO - Downloading blobuploader-1.2.4.tar.gz 22:41:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:41:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:41: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 22:41: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 22:41: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 22:41: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 22:41: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 22:41: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 22:41:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:41:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:41: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 22:41: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 22:41: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 22:41: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 22:41: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 22:41: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 22:41:55 INFO - Downloading docopt-0.6.1.tar.gz 22:41:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:41:55 INFO - Installing collected packages: blobuploader, requests, docopt 22:41:55 INFO - Running setup.py install for blobuploader 22:41:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:41:55 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:41:55 INFO - Running setup.py install for requests 22:41:55 INFO - Running setup.py install for docopt 22:41:55 INFO - Successfully installed blobuploader requests docopt 22:41:55 INFO - Cleaning up... 22:41:55 INFO - Return code: 0 22:41:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:41: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')]} 22:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41: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')]} 22:41:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7fec9ea1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1228670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b78c0>, '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 0x12b87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b8c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1455338373.179070-87280582', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 22:41:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/config 22:41:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/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 22:41:55 INFO - Using env: {'DISPLAY': ':0', 22:41:55 INFO - 'HOME': '/home/cltbld', 22:41:55 INFO - 'LANG': 'en_US.UTF-8', 22:41:55 INFO - 'LANGUAGE': 'en_US:en', 22:41:55 INFO - 'LOGNAME': 'cltbld', 22:41:55 INFO - 'MAIL': '/var/mail/cltbld', 22:41:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:55 INFO - 'MOZ_NO_REMOTE': '1', 22:41:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:55 INFO - 'NO_EM_RESTART': '1', 22:41:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:41:55 INFO - 'PWD': '/builds/slave/test-pgo', 22:41:55 INFO - 'SHELL': '/bin/bash', 22:41:55 INFO - 'SHLVL': '1', 22:41:55 INFO - 'TERM': 'linux', 22:41:55 INFO - 'TMOUT': '86400', 22:41:55 INFO - 'USER': 'cltbld', 22:41:55 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1455338373.179070-87280582', 22:41:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:55 INFO - '_': '/tools/buildbot/bin/python'} 22:41:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:41:56 INFO - Running setup.py (path:/tmp/pip-ChQP4f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:41:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:41:56 INFO - Running setup.py (path:/tmp/pip-lVUSng-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:41:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:41:56 INFO - Running setup.py (path:/tmp/pip-40kPfb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:41:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:41:56 INFO - Running setup.py (path:/tmp/pip-UKKh8o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:41:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:41:56 INFO - Running setup.py (path:/tmp/pip-yJA5w9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:41:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:41:56 INFO - Running setup.py (path:/tmp/pip-INY9oJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:41:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:41:56 INFO - Running setup.py (path:/tmp/pip-n7gpMg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:41:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:41:56 INFO - Running setup.py (path:/tmp/pip-FNQsRa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:41:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:41:56 INFO - Running setup.py (path:/tmp/pip-OLxi9u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:41:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:41:56 INFO - Running setup.py (path:/tmp/pip-lGeP2x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:41:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:41:56 INFO - Running setup.py (path:/tmp/pip-e_PMhI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:41:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:41:56 INFO - Running setup.py (path:/tmp/pip-H2ERx6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:41:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:41:56 INFO - Running setup.py (path:/tmp/pip-P8holR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:41:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:41:57 INFO - Running setup.py (path:/tmp/pip-nXHWqx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:41:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:41:57 INFO - Running setup.py (path:/tmp/pip-ZgOWuy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:41:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:41:57 INFO - Running setup.py (path:/tmp/pip-hQONPb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:41:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:41:57 INFO - Running setup.py (path:/tmp/pip-em21K2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:41:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:41:57 INFO - Running setup.py install for manifestparser 22:41:57 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:41:57 INFO - Running setup.py install for mozcrash 22:41:57 INFO - Running setup.py install for mozdebug 22:41:57 INFO - Running setup.py install for mozdevice 22:41:57 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:41:57 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:41:57 INFO - Running setup.py install for mozfile 22:41:57 INFO - Running setup.py install for mozhttpd 22:41:57 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:41:57 INFO - Running setup.py install for mozinfo 22:41:57 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:41:57 INFO - Running setup.py install for mozInstall 22:41:58 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:41:58 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:41:58 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:41:58 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:41:58 INFO - Running setup.py install for mozleak 22:41:58 INFO - Running setup.py install for mozlog 22:41:58 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:41:58 INFO - Running setup.py install for moznetwork 22:41:58 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:41:58 INFO - Running setup.py install for mozprocess 22:41:58 INFO - Running setup.py install for mozprofile 22:41:58 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:41:58 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:41:58 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:41:58 INFO - Running setup.py install for mozrunner 22:41:58 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:41:58 INFO - Running setup.py install for mozscreenshot 22:41:58 INFO - Running setup.py install for moztest 22:41:58 INFO - Running setup.py install for mozversion 22:41:59 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:41:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:41:59 INFO - Cleaning up... 22:41:59 INFO - Return code: 0 22:41:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:41:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7fec9ea1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1228670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b78c0>, '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 0x12b87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b8c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1455338373.179070-87280582', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 22:41:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/config 22:41:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/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 22:41:59 INFO - Using env: {'DISPLAY': ':0', 22:41:59 INFO - 'HOME': '/home/cltbld', 22:41:59 INFO - 'LANG': 'en_US.UTF-8', 22:41:59 INFO - 'LANGUAGE': 'en_US:en', 22:41:59 INFO - 'LOGNAME': 'cltbld', 22:41:59 INFO - 'MAIL': '/var/mail/cltbld', 22:41:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:59 INFO - 'MOZ_NO_REMOTE': '1', 22:41:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:59 INFO - 'NO_EM_RESTART': '1', 22:41:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:41:59 INFO - 'PWD': '/builds/slave/test-pgo', 22:41:59 INFO - 'SHELL': '/bin/bash', 22:41:59 INFO - 'SHLVL': '1', 22:41:59 INFO - 'TERM': 'linux', 22:41:59 INFO - 'TMOUT': '86400', 22:41:59 INFO - 'USER': 'cltbld', 22:41:59 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1455338373.179070-87280582', 22:41:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:59 INFO - '_': '/tools/buildbot/bin/python'} 22:41:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:41:59 INFO - Running setup.py (path:/tmp/pip-H8uqFL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 22:41:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:41:59 INFO - Running setup.py (path:/tmp/pip-c41Wyg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:41:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:41:59 INFO - Running setup.py (path:/tmp/pip-aQRiMv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:41:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:41:59 INFO - Running setup.py (path:/tmp/pip-Q2cnfC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:41:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:41:59 INFO - Running setup.py (path:/tmp/pip-fKBHMy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 22:41:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:41:59 INFO - Running setup.py (path:/tmp/pip-c5HbkC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 22:41:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:41:59 INFO - Running setup.py (path:/tmp/pip-MU2SRC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 22:41:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:41:59 INFO - Running setup.py (path:/tmp/pip-cplYIf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 22:41:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:41:59 INFO - Running setup.py (path:/tmp/pip-VHadD8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 22:41:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:41:59 INFO - Running setup.py (path:/tmp/pip-sjwiVD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:42:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:42:00 INFO - Running setup.py (path:/tmp/pip-F5Qgs0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 22:42:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:42:00 INFO - Running setup.py (path:/tmp/pip-ShxE3a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 22:42:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:42:00 INFO - Running setup.py (path:/tmp/pip-4sBnyV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 22:42:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:42:00 INFO - Running setup.py (path:/tmp/pip-aQUc7R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 22:42:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:42:00 INFO - Running setup.py (path:/tmp/pip-MkCQcr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 22:42:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:42:00 INFO - Running setup.py (path:/tmp/pip-7u3L_E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 22:42:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:42:00 INFO - Running setup.py (path:/tmp/pip-wT8l9u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 22:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:42:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42:02 INFO - Downloading blessings-1.6.tar.gz 22:42:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:42:02 INFO - Installing collected packages: blessings 22:42:02 INFO - Running setup.py install for blessings 22:42:02 INFO - Successfully installed blessings 22:42:02 INFO - Cleaning up... 22:42:02 INFO - Return code: 0 22:42:02 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:42:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:42:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:42:02 INFO - Reading from file tmpfile_stdout 22:42:02 INFO - Current package versions: 22:42:02 INFO - argparse == 1.2.1 22:42:02 INFO - blessings == 1.6 22:42:02 INFO - blobuploader == 1.2.4 22:42:02 INFO - docopt == 0.6.1 22:42:02 INFO - manifestparser == 1.1 22:42:02 INFO - mozInstall == 1.12 22:42:02 INFO - mozcrash == 0.16 22:42:02 INFO - mozdebug == 0.1 22:42:02 INFO - mozdevice == 0.48 22:42:02 INFO - mozfile == 1.2 22:42:02 INFO - mozhttpd == 0.7 22:42:02 INFO - mozinfo == 0.9 22:42:02 INFO - mozleak == 0.1 22:42:02 INFO - mozlog == 3.1 22:42:02 INFO - moznetwork == 0.27 22:42:02 INFO - mozprocess == 0.22 22:42:02 INFO - mozprofile == 0.28 22:42:02 INFO - mozrunner == 6.11 22:42:02 INFO - mozscreenshot == 0.1 22:42:02 INFO - mozsystemmonitor == 0.0 22:42:02 INFO - moztest == 0.7 22:42:02 INFO - mozversion == 1.4 22:42:02 INFO - psutil == 3.1.1 22:42:02 INFO - requests == 1.2.3 22:42:02 INFO - wsgiref == 0.1.2 22:42:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:42: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')]} 22:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42: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')]} 22:42:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7fec9ea1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1228670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b78c0>, '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 0x12b87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b8c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1455338373.179070-87280582', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 22:42:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/talos 22:42:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/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 22:42:02 INFO - Using env: {'DISPLAY': ':0', 22:42:02 INFO - 'HOME': '/home/cltbld', 22:42:02 INFO - 'LANG': 'en_US.UTF-8', 22:42:02 INFO - 'LANGUAGE': 'en_US:en', 22:42:02 INFO - 'LOGNAME': 'cltbld', 22:42:02 INFO - 'MAIL': '/var/mail/cltbld', 22:42:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:02 INFO - 'MOZ_NO_REMOTE': '1', 22:42:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:02 INFO - 'NO_EM_RESTART': '1', 22:42:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:42:02 INFO - 'PWD': '/builds/slave/test-pgo', 22:42:02 INFO - 'SHELL': '/bin/bash', 22:42:02 INFO - 'SHLVL': '1', 22:42:02 INFO - 'TERM': 'linux', 22:42:02 INFO - 'TMOUT': '86400', 22:42:02 INFO - 'USER': 'cltbld', 22:42:02 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1455338373.179070-87280582', 22:42:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:02 INFO - '_': '/tools/buildbot/bin/python'} 22:42:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 22:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 22:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 22:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 22:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 22:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 22:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 22:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:42:02 INFO - Cleaning up... 22:42:02 INFO - Return code: 0 22:42:02 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:42: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')]} 22:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42: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')]} 22:42:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/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 0x7fec9ea1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1228670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b78c0>, '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 0x12b87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b8c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1455338373.179070-87280582', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 22:42:02 INFO - Running command: ['/builds/slave/test-pgo/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-pgo/build 22:42:02 INFO - Copy/paste: /builds/slave/test-pgo/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 22:42:02 INFO - Using env: {'DISPLAY': ':0', 22:42:02 INFO - 'HOME': '/home/cltbld', 22:42:02 INFO - 'LANG': 'en_US.UTF-8', 22:42:02 INFO - 'LANGUAGE': 'en_US:en', 22:42:02 INFO - 'LOGNAME': 'cltbld', 22:42:02 INFO - 'MAIL': '/var/mail/cltbld', 22:42:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:02 INFO - 'MOZ_NO_REMOTE': '1', 22:42:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:02 INFO - 'NO_EM_RESTART': '1', 22:42:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:42:02 INFO - 'PWD': '/builds/slave/test-pgo', 22:42:02 INFO - 'SHELL': '/bin/bash', 22:42:02 INFO - 'SHLVL': '1', 22:42:02 INFO - 'TERM': 'linux', 22:42:02 INFO - 'TMOUT': '86400', 22:42:02 INFO - 'USER': 'cltbld', 22:42:02 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1455338373.179070-87280582', 22:42:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:02 INFO - '_': '/tools/buildbot/bin/python'} 22:42:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:03 INFO - Downloading/unpacking jsonschema 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:42:04 INFO - Downloading/unpacking functools32 (from jsonschema) 22:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:42:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:05 INFO - Downloading functools32-3.2.3-2.tar.gz 22:42:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:42:05 INFO - warning: no files found matching '*.txt' 22:42:05 INFO - no previously-included directories found matching 'build' 22:42:05 INFO - no previously-included directories found matching 'dist' 22:42:05 INFO - no previously-included directories found matching '.git*' 22:42:05 INFO - Installing collected packages: jsonschema, functools32 22:42:05 INFO - Running setup.py install for functools32 22:42:05 INFO - warning: no files found matching '*.txt' 22:42:05 INFO - no previously-included directories found matching 'build' 22:42:05 INFO - no previously-included directories found matching 'dist' 22:42:05 INFO - no previously-included directories found matching '.git*' 22:42:05 INFO - Successfully installed jsonschema functools32 22:42:05 INFO - Cleaning up... 22:42:05 INFO - Return code: 0 22:42:05 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:42: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')]} 22:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42: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')]} 22:42:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/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 0x7fec9ea1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1228670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b78c0>, '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 0x12b87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b8c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1455338373.179070-87280582', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 22:42:05 INFO - Running command: ['/builds/slave/test-pgo/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-pgo/build 22:42:05 INFO - Copy/paste: /builds/slave/test-pgo/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 22:42:05 INFO - Using env: {'DISPLAY': ':0', 22:42:05 INFO - 'HOME': '/home/cltbld', 22:42:05 INFO - 'LANG': 'en_US.UTF-8', 22:42:05 INFO - 'LANGUAGE': 'en_US:en', 22:42:05 INFO - 'LOGNAME': 'cltbld', 22:42:05 INFO - 'MAIL': '/var/mail/cltbld', 22:42:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:05 INFO - 'MOZ_NO_REMOTE': '1', 22:42:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:05 INFO - 'NO_EM_RESTART': '1', 22:42:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:42:05 INFO - 'PWD': '/builds/slave/test-pgo', 22:42:05 INFO - 'SHELL': '/bin/bash', 22:42:05 INFO - 'SHLVL': '1', 22:42:05 INFO - 'TERM': 'linux', 22:42:05 INFO - 'TMOUT': '86400', 22:42:05 INFO - 'USER': 'cltbld', 22:42:05 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1455338373.179070-87280582', 22:42:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:05 INFO - '_': '/tools/buildbot/bin/python'} 22:42:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:05 INFO - Downloading/unpacking flake8 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:42:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:42:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:42:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:42:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:42:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:42:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:42:08 INFO - no previously-included directories found matching 'docs/_build' 22:42:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:42:08 INFO - Running setup.py install for pep8 22:42:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:42:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:42:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:42:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:42:08 INFO - no previously-included directories found matching 'docs/_build' 22:42:08 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:42:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:42:08 INFO - Cleaning up... 22:42:08 INFO - Return code: 0 22:42:08 INFO - Running post-action listener: _resource_record_post_action 22:42:08 INFO - Running post-action listener: _start_resource_monitoring 22:42:08 INFO - Starting resource monitoring. 22:42:08 INFO - ##### 22:42:08 INFO - ##### Running install step. 22:42:08 INFO - ##### 22:42:08 INFO - Running pre-action listener: _resource_record_pre_action 22:42:08 INFO - Running main action method: install 22:42:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:42:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:42:08 INFO - Reading from file tmpfile_stdout 22:42:08 INFO - Detecting whether we're running mozinstall >=1.0... 22:42:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:42:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:42:08 INFO - Reading from file tmpfile_stdout 22:42:08 INFO - Output received: 22:42:08 INFO - Usage: mozinstall [options] installer 22:42:08 INFO - Options: 22:42:08 INFO - -h, --help show this help message and exit 22:42:08 INFO - -d DEST, --destination=DEST 22:42:08 INFO - Directory to install application into. [default: 22:42:08 INFO - "/builds/slave/test-pgo"] 22:42:08 INFO - --app=APP Application being installed. [default: firefox] 22:42:08 INFO - mkdir: /builds/slave/test-pgo/build/application 22:42:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:42:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:42:24 INFO - Reading from file tmpfile_stdout 22:42:24 INFO - Output received: 22:42:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:42:24 INFO - Running post-action listener: _resource_record_post_action 22:42:24 INFO - ##### 22:42:24 INFO - ##### Running run-tests step. 22:42:24 INFO - ##### 22:42:24 INFO - Running pre-action listener: _resource_record_pre_action 22:42:24 INFO - Running main action method: run_tests 22:42:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:42:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:42:24 INFO - Python 2.7.3 22:42:24 INFO - Return code: 0 22:42:24 INFO - grabbing minidump binary from tooltool 22:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:42:24 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-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b78c0>, '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 0x12b87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b8c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:42:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 22:42:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:42:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:42:25 INFO - Return code: 0 22:42:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:42:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:42:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:42:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:42:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:42:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:42:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:42:26 INFO - Return code: 0 22:42:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 22:42:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 22:42:26 INFO - Using env: {'DISPLAY': ':0', 22:42:26 INFO - 'HOME': '/home/cltbld', 22:42:26 INFO - 'LANG': 'en_US.UTF-8', 22:42:26 INFO - 'LANGUAGE': 'en_US:en', 22:42:26 INFO - 'LOGNAME': 'cltbld', 22:42:26 INFO - 'MAIL': '/var/mail/cltbld', 22:42:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:42:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:26 INFO - 'MOZ_NO_REMOTE': '1', 22:42:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:42:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:26 INFO - 'NO_EM_RESTART': '1', 22:42:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:42:26 INFO - 'PWD': '/builds/slave/test-pgo', 22:42:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:42:26 INFO - 'SHELL': '/bin/bash', 22:42:26 INFO - 'SHLVL': '1', 22:42:26 INFO - 'TERM': 'linux', 22:42:26 INFO - 'TMOUT': '86400', 22:42:26 INFO - 'USER': 'cltbld', 22:42:26 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1455338373.179070-87280582', 22:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:26 INFO - '_': '/tools/buildbot/bin/python'} 22:42:26 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:42:26 INFO - mozversion application_buildid: 20160212203128 22:42:26 INFO - mozversion application_changeset: 617e089684ae22f75215467ac13729d1ef3bf01e 22:42:26 INFO - mozversion application_display_name: Nightly 22:42:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:42:26 INFO - mozversion application_name: Firefox 22:42:26 INFO - mozversion application_remotingname: firefox 22:42:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:42:26 INFO - mozversion application_vendor: Mozilla 22:42:26 INFO - mozversion application_version: 47.0a1 22:42:26 INFO - mozversion platform_buildid: 20160212203128 22:42:26 INFO - mozversion platform_changeset: 617e089684ae22f75215467ac13729d1ef3bf01e 22:42:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:42:26 INFO - mozversion platform_version: 47.0a1 22:42:26 INFO - using testdate: 1455345746 22:42:26 INFO - actual date: 1455345746 22:42:26 INFO - starting webserver on 'localhost:52894' 22:42:26 INFO - SUITE-START | Running 2 tests 22:42:26 INFO - TEST-START | dromaeo_css 22:42:26 INFO - operating with platform_type : linux_ 22:42:26 INFO - Initialising browser for dromaeo_css test... 22:42:26 INFO - TEST-INFO | started process 28406 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVD5HBg/profile http://localhost:52894/getInfo.html) 22:42:30 INFO - PROCESS | 28406 | __metrics Screen width/height:1600/1200 22:42:30 INFO - PROCESS | 28406 | colorDepth:24 22:42:30 INFO - PROCESS | 28406 | Browser inner width/height: 1024/697 22:42:30 INFO - PROCESS | 28406 | __metrics 22:42:31 INFO - PROCESS | 28406 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:42:31 INFO - PROCESS | 28406 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 22:42:32 INFO - TEST-INFO | 28406: exit 0 22:42:32 INFO - Browser initialized. 22:42:32 INFO - Running cycle 1/1 for dromaeo_css test... 22:42:32 INFO - TEST-INFO | started process 28499 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVD5HBg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:42:44 INFO - PROCESS | 28499 | RSS: Main: 150908928 22:42:44 INFO - PROCESS | 28499 | 22:43:36 INFO - PROCESS | 28499 | 1455345816026 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] 22:45:44 INFO - PROCESS | 28499 | Cycle 1(1): loaded http://localhost:52894/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52894/tests/dromaeo/cssquery-ext.html) 22:45:45 INFO - PROCESS | 28499 | RSS: Main: 276578304 22:45:45 INFO - PROCESS | 28499 | 22:48:47 INFO - PROCESS | 28499 | Cycle 1(1): loaded http://localhost:52894/tests/dromaeo/cssquery-ext.html (next: http://localhost:52894/tests/dromaeo/cssquery-jquery.html) 22:48:48 INFO - PROCESS | 28499 | RSS: Main: 240562176 22:48:48 INFO - PROCESS | 28499 | 22:51:50 INFO - PROCESS | 28499 | Cycle 1(1): loaded http://localhost:52894/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52894/tests/dromaeo/cssquery-mootools.html) 22:51:51 INFO - PROCESS | 28499 | RSS: Main: 245964800 22:51:51 INFO - PROCESS | 28499 | 22:54:53 INFO - PROCESS | 28499 | Cycle 1(1): loaded http://localhost:52894/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52894/tests/dromaeo/cssquery-prototype.html) 22:54:53 INFO - PROCESS | 28499 | RSS: Main: 222326784 22:54:53 INFO - PROCESS | 28499 | 22:57:56 INFO - PROCESS | 28499 | Cycle 1(1): loaded http://localhost:52894/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52894/tests/dromaeo/cssquery-yui.html) 22:57:56 INFO - PROCESS | 28499 | RSS: Main: 224612352 22:57:56 INFO - PROCESS | 28499 | 23:00:59 INFO - PROCESS | 28499 | Cycle 1(1): loaded http://localhost:52894/tests/dromaeo/cssquery-yui.html (next: http://localhost:52894/tests/dromaeo/cssquery-dojo.html) 23:00:59 INFO - PROCESS | 28499 | RSS: Main: 270315520 23:00:59 INFO - PROCESS | 28499 | 23:00:59 INFO - PROCESS | 28499 | __start_tp_report 23:00:59 INFO - PROCESS | 28499 | _x_x_mozilla_page_load 23:00:59 INFO - PROCESS | 28499 | _x_x_mozilla_page_load_details 23:00:59 INFO - PROCESS | 28499 | |i|pagename|runs| 23:00:59 INFO - PROCESS | 28499 | |0;dojo.html;3127.7185053345197;3134.921626959327;3178.3643271345722;3183.92040198995;3211.2453573410253;5051.722155281458;5092.949070509294;5106.412762532305;5138.794448222066;5188.48115188481;5068.391792984838;5123.257127716479;5139.486051394859;5164.664296820704;5177.4045984711765;4686.53134686532;4742.454617718963;4743.098811225873;4811.398575178103;4917.311576379309;4663.4637016743;4811.951880481203;4813.350197723297;4835.927461088069;4902.950970490303;4653.6044436222965;4707.411573553306;4736.857894263143;4758.881027974294;4766.618670506351;4622.791974361162;4633.235516139866;4641.187792136397;4641.976790116061;4670.813167473297;4626.976865115686;4630.1202771473645;4636.930446043312;4640.559146881041;4663.370444989917;4994.101061808873;5004.5495905368325;5081.5426611605135;5085.898282034339;5096.057229412533;5437.945620543784;5445.101558242885;5452.59105567084;5455.290812194429;5495.340559132889;5393.164059570773;5473.890522189574;5517.806876759334;5523.696196709179;5526.889462210774;5195.610329225286;5217.608679349064;5222.895542089175;5293.708846013467;5326.961242557664;5716.456936591017;5724.599278050497;5727.570432217517;5759.51044161251;5770.278715160605;5494.80768173112;5502.339719233638;5521.834344969658;5524.889502209933;5526.226328314039;5379.973100134474;5406.78372865081;5575.944240557624;5578.30271216098;5665.49010589049;5637.408072152365;5637.548996080303;5637.689927054052;5640.464155905182;5650.23721797552;5617.606767526316;5631.802886898939;5633.042382794934;5633.464820842013;5642.802501912413;4210.578942105765;4310.094880075157;4353.325234588644;4373.343998400202;4414.55854414556;3876.302265592164;3886.8639597613947;3909.0618251619408;3938.468306778548;3943.073377756225;5176.378834539804;5191.143461328914;5195.870103247449;5198.246254293106;5201.869953251199;5467.753951072212;5578.721063946868;5610.354809196994;5659.151127330933;5696.629719068247;5144.202648589475;5145.048166089286;5165.457626949192;5170.043541944752;5173.63784535079;4625.051864367797;4749.382580264543;4750.762461876892;4751.026039661861;4760.404949381327;5574.386817450078;5615.522680572116;5639.492445679908;5672.716364181774;5714.228579141846;5602.467765562265;5605.355384130877;5615.157726341082;5619.80330688424;5623.578231632562;5595.720213989365;5739.971300143639;5746.798862039808;5808.767649293981;5819.15622234782;5457.508824205841;5520.972395137998;5535.667859928417;5540.36285827135;5581.469760372758;5458.781648734006;5462.8361149164;5475.917861232165;5476.397596264487;5482.945170548243;5336.012837625051;5347.144456886879;5398.028354896156;5465.69938653362;5466.1527463243265;5362.115250983544;5420.674759514442;5427.24018637399;5453.672779633234;5471.124620060771;5334.919976200283;5335.599830012687;5336.626436149588;5358.705271209965;5379.623426360117;5358.062339090721;5446.564274857923;5459.317585301837;5459.945400546103;5483.862903427286;5397.055515284731;5398.271233383443;5400.054990376747;5400.1899715043055;5407.351117865881 23:00:59 INFO - PROCESS | 28499 | |1;ext.html;530.6046994988732;531.0494215354515;536.0993530868143;551.244794631355;556.9916451253234;27511;28191;35823.64176358235;36362.45456318157;36606.633933660654;39590.60409395905;40029;40100.59899401005;40161.39757903634;40211.79894100533;8521.105283945204;8685.652573897036;8694.087120852315;8708.17272359125;8708.651653933835;8670.34972377071;8826.249768769661;8836.690715824947;8840.823183536326;8865.202131808135;8886.86669699955;8965.596548155349;8968.46189228645;8985.505797181153;8988.59551320192;8819.206271435569;8854.424462409923;8900.109989001114;8910.777230569223;8917.42036767608;8767.956160219223;8827.293816494664;8905.821883562292;8925.107489251088;8926;39696;39979.200415991516;40128.39807402891;40137.39793903094;40163;2890.3930174663346;2993.580898674187;3328.8002719836645;3936.3701807710627;4034.798260086984;27110.728892711017;27315.590266146024;27932.860335698395;28246.293842653893;28390.432191356056;3168.1154797033173;3258.771885967983;3313.6023677158896;3475.3049390121823;3570.982145089284;252656;255686;256490;256597;350533;43330.783346083066;61122.38877611167;62182.68908655428;62292;62310.37689623136;57997.71001144967;58026.41973580295;58200.4179958195;58236;58328;13440.462381504825;14134.64663383403;14400.855991440161;14415.711685766226;14431.49489767853;10327.431991240554;10499.895001050045;10553.05022547959;10581.84127238092;10609.522571484302;18068.096595170187;18269;18273.451796446127;18283.360082397052;18314.816851831576;7145.1425828900865;7365.742199023009;7368.005319281936;7406.3334299912185;7465.813354666068;861.4960248254716;863.6631713631689;920.4477313611914;1016.5832008876325;1072.3083611070815;27993;28065.298367540974;28849.56725649117;28853.422931541252;30199.396012079636;914.492456686532;932.8942074124869;966.4249771386014;1033.5762337441613;1137.7951968645723;13798.568633763483;13892.791608125886;13990.300484975915;14081.929590351983;14082.295885205698;303199;307520;307917;308228;308555;45086;45152.096958060654;45247.547524524336;45271.094578108256;45355.77322113435;1349.6355983884296;1352.1684164238923;1358.864113588653;1384.9307534623229;1489.1065360783443;25680.486390272465;26168.8691556541;26934.730652693223;26942.730572694807;27037.1888843335;43581.128377432906;43829.12341753211;43928.78035609802;43934.12131757411;43947;242781;244115;244451;244571;245681;26797.732022680302;26871.596926046517;32612.34775304528;33516;33650.99047028593;38341;38534.42198367083;38769.4184587237;38844.223115538094;39176.80411597924;33026;33221;33422.665773341956;33432.498512521845;33468.832655836566;27430.5885411715;31568.368632627677;33253.33493330071;33593.83203083969;33967.32065358728;30445.69554304517;30688;30697.693023070377;31220.68779312178;31758.841205793822;27464.588031179148;28550.714492854804;28674.713252868038;28697.713022869502;28978;22922.54154916859;23072.655034727195;23232.186873459348;23423.76576234284;23478.413039674146 23:00:59 INFO - PROCESS | 28499 | |2;jquery.html;351.882119489971;353.3851099087588;353.5068579331832;354.4895350694999;357.485221281355;13012.544560940369;13430.731385372286;16226;16256.512304630865;16869.91565042173;15050.096994180329;15116.773248401283;15378.077315361086;15664.686706265897;15702.293396797142;5122.92315615266;5237.45006774289;5429.239906413105;5433.673979561239;5434.91847622286;3642.8724994625195;3753.7184711146638;5333.5199832015305;6565.343465653445;6868.278830722752;6335.778247761329;6582.3417658234275;6851.1778586569435;6883.380495755381;6890.655467226644;6391.648459334735;6421.068945002972;6426.228852537702;6464.224293084813;6464.547481676261;6281.3404592518045;6444.7744328948265;6448.580842245286;6454.41910228077;6454.774082907123;21146.365609031753;21793.782062179333;22277.108915643355;22293.331200064025;22515.662265066036;2038.500567361006;2164.3615133535645;2203;2798.272449163232;2900.6809250982374;13312.600621981355;13344.132631379027;13636.522721704792;13786.586402407944;13786.93106534471;1903.4289713086018;1909.799471055547;1911.0826803134435;1969.6848504239397;2002;66801;67894.32105678979;68659;68876.21180835052;69122;14742.96799224044;15263.465778697693;15333.923330383499;15341;15374.461893833886;23170;23334.416639584146;23349.41626459352;23649.29052128439;23731.644025339632;8599.226069653636;8690.304775617935;8729.388942774072;8738.432001919855;8847.955760221157;7446.7021319146625;7534.472586918972;7537;7554.2823431773895;7559.811004724816;6505.447037001813;7180.820479488055;7200.171980222237;7515.248475152551;7553.924460755322;2777.472280266743;2916;2938.61797966263;2944.7349738523635;2950.6164198654037;809.9878501822477;827.2182787265975;947.3368641950663;957.7414098193449;1030.2479190191052;15118.168500732565;15257.237138143271;16245.837541624433;16591.6681666366;16663;780.7384526183793;870.7170169694874;890.7372325164092;890.9198172164407;917.8852643419573;8547.273481753997;8844.136566056408;8860.4240724354;8950.14973577509;9015.368924175376;489985;493685;497715;503768;504646;56793;75502.62248688831;75668.62165689246;76213;77903.61048194722;1092.208149091902;1108.9944550277196;1134.1097238667605;1157.6932112990064;1162.110985096402;13921.234332111426;14250.857491425368;14376.137431754129;14675.779863301845;14710.338034788674;31162;31375.05874823759;31587.21031974219;31645.683543164272;31693;34372;38067.42898856575;43533.78233108814;45871.541284586725;46533.534664654275;6814.795556133324;7305.305995930378;7307.232740562377;7432.442566807619;7461.216572259835;10020;10290;10564;10872.347659140476;11097.38964356968;9876.160526355341;10026;10131.696049118538;10135.746606334606;10235.539400727133;10120.84818727705;10187.337823041478;10370.533326000197;10518.579256829948;10572.89427105719;10130.89869101329;10197.796044078928;10362.792744144925;10364.792704146026;10422.166226701695;7527.473076884566;7539.811504712206;7573.674606943873;7635.732749353746;7701.961490192513;9243.907560924305;9602.85595716051;9780.315377923762;9796.755081123029;10589.470526473491 23:00:59 INFO - PROCESS | 28499 | |3;mootools.html;1287.1118927939726;1421.2325344314072;1440.7406666799977;1589.8410158984102;1755.8244175582442;6806.659667016648;7693.961530192349;7849.215078492148;7873.448858579902;7879.093904201019;7686.577238251908;7872.897794308801;7880;7893.684252629902;7898.881516777253;1960.2942940541393;2236.1279101150485;2273.795358417742;2300.413394584383;2324.6164382876805;2296.2307626944994;2303.7581053989343;2303.942401439969;2307.930762077132;2310.376198426424;2214.1032881682945;2291.759365266648;2300.6894069300683;2304;2304.0783686525356;2287.6617178950332;2316.2124877541632;2333.4166458385403;2334.3697201755517;2339.578875802355;2257.2776711452343;2273.9772602274097;2313.063209400196;2315.79157875792;2317.7913987741185;8005.839883202361;8049.074356449025;8054.194580541899;8062.677492900277;8090.838183236302;4764.523547645243;4841.3222148899185;4845.563899249085;4849.878753031167;4880.316755654211;2967.5279922490736;3061.8928337508305;3085.7377122944354;3089.2276930767307;3133.15404840694;888.2583043158905;896.1262768800433;914.9176574108295;919.1635611593418;972.7908499672604;10972.506237219264;10972.945135274353;11057.391843448608;11088;11136.888631113747;4426.247537918497;4483.932741008887;4490.550944905483;4498.887527811831;4516.88707782308;9522.666706665234;9537.570809313598;9537.570809313598;9547.188488978514;9554;4867.561919427198;4899.436564795023;4911.778969946361;4914.655974081851;4915.0415668944925;4465.218586747306;4469.664775141878;4473.597376236155;4475.037866858641;4481.7535035573355;3397.5073614325784;3605.4591811228524;3695.5011073504734;3733.346664333785;3755.455458958436;1191.8986886114778;1199.2444759801444;1201.6214892308894;1209.056935590241;1210.975780484403;1232.3283810323396;1242.2856857307086;1261.8233447317382;1273.446050967832;1274.2927675140386;7050.612216328049;7127.821804454827;7146.642667866586;7169.318914703095;7194.820129496699;1091.7761858818924;1093.3221402730358;1094.9781004379868;1110.245033377295;1121.0471099565304;5464.890702186013;5512.944870551243;5521.923224971172;5523.28197334344;5523.8066667666435;9407;9684.385215991642;9848.606055757833;9899.554520046615;9910.603575857029;9761.511924403894;9785.36395134314;9862.753431164136;9910.851337229948;9914.40513569188;7509.436792240604;7545.584992825447;7612.543247405173;7643.885341719879;7685.807854803563;7200.819979500555;7238.782836514913;7246.275372462923;7265.636718163965;7287.963560182166;8350.874736879074;8634.913650863411;8704.695335663222;8886.73339799807;8888.155625215593;8914.955425222832;9061.275097992013;9065.728028159167;9073.047330030251;9094.454332740057;7035.296470353129;7106.431485481253;7112.57324560528;7144.428445724226;7173.390261827594;6720.227173875067;7320.96339518299;7567.886481702669;7590.051243594551;7619.542827430372;6409.7115629795835;6745;6828.214755303204;6984;7221.241769614115;6657;6845.315468453115;6865.519413640997;6875.5874647521305;6999.825004374931;6653.600783952978;6698.497612679166;6698.966505167443;6700.430463410665;6704.66476676174;6222.222222222223;6266.154069200599;6284.214473190851;6295.276043255084;6295.3704629538515;6336.7148478319505;6385.265694445013;6388.329225431263;6395.712192951235;6415.486761059197 23:00:59 INFO - PROCESS | 28499 | |4;prototype.html;333.40154422811054;333.9983300083499;336.323988782547;338.8034939734954;342.94855771634235;5727.599068065237;5821.708914554266;5839.386864379243;5884.411558844119;5894.233749612555;5624;5713.571482138836;5744.971275143618;5752.079667253241;5758.510526605233;4524.977375113136;4536.183486972343;4539.046800171968;4553.772311384434;4557.521460246676;4327.329263964075;4430.401895744066;4438.26768583185;4439.245328294198;4557.56436722433;4402.713823601472;4469.039156581334;4496.303073023671;4509.864704058883;4518.615917647004;4503.166914120898;4503.234450143467;4503.468820601011;4512.45850497939;4519.299508576143;3956.723029387944;3991.5808840071954;3997.7407116758127;4001.4397984282223;4008.018035581272;5439.619226654136;5573.41479144688;5577.888442231133;5621.550275977912;5623.9437605623825;5256.842294731164;5261.184516399964;5263.578913686896;5269.0252303324005;5279.5512381447625;5896.911546326808;6218.4714299284615;6218.81343559694;6228.906566401508;6229.127922090911;4314.137172565468;4355.346697995326;4397.2304846651705;4406.09675016624;4415.094905544356;6316.08416779569;6418.101465794793;6430.421262086388;6464.903026454654;6469.547131700783;4508.819647214074;4509.053098849213;4515.300128480091;4516.706414083074;4519.457665080211;4477.507474177838;4551.499335073139;4565.086982603426;4566.931496027562;4588.977055114703;5170.45710200431;5182.481751824787;5183.637145399861;5187.688738675616;5188.688678679291;6163.907541386883;6167.229096362955;6167.444929956326;6170.845728856814;6180.258368995659;1612.6049117966174;1627.2026706913528;1629.6333325002017;1632.795900512436;1633.6487655153962;1097.6432659385732;1104.2160066352978;1107.291333546531;1113.2040590977329;1140.2189500192394;5808.738606762706;5813.215215945877;5816.5055970243;5822.475977162076;5826.126081087871;6373.681315934185;6380.617162970237;6382.521310901701;6389.137466442064;6391.296957334689;5812.128180772834;5826.1552074948895;5828.766849326064;5830.096335068071;5832.737526811304;3391.3895498810452;3491.5635545556806;3498.3003399320237;3503.5095086687375;3503.632118627507;6660.533762636569;6722.563033402813;6726.697298621574;6734.595924244561;6734.831629209211;6606;6606.273309935903;6611.86776264472;6613.702383392759;6648.235452922976;6533.771318003942;6649.73401063952;6699.799006029827;6718.462522998246;6720.495962802712;6189.721462534107;6255.499560035095;6455.419012288917;6466.256380516301;6492.220933488012;6342.334054924351;6366.5225108118;6370.076338930737;6382.436303105769;6395.744170233139;6699.732010719516;6704.497162712719;6706.228783689938;6712.731490740316;6713.899291510534;4235.301175306163;4353.064091220403;4382.05785756064;4382.23310920594;4384.4519435070615;6416.7754128605275;6422.550421470452;6429.7106630200815;6430.614163150226;6446.065320528591;6230.439260466398;6231.158793562811;6232.501399888089;6234.407731265523;6236.469900058546;6075.088736689532;6235.906461402992;6243.406876346739;6247.687615619292;6248.218972628421;6165.383461653978;6165.969170154121;6170.6914654268;6171.259448866164;6172.567920245539;6291.213598300213;6305.747770089145;6317.5893566918;6328.114064031131;6348.111264422892;6082.817515474543;6144.324124346229;6197.070439433941;6198.876022479615;6201.131841542278 23:00:59 INFO - PROCESS | 28499 | |5;yui.html;582.5310624946916;641.7785863876962;650.3528988656287;715.7101373943555;723.9312265334793;13974.650633734149;14110.223937683424;14112.506062287835;14121.57635270941;14129.434822607083;13171;13215.801762973539;13235.536756213534;13700.383482743275;14787.92606036971;813.5159580049875;826.4132465949183;827.1934863508092;827.5076329583887;829.9792505187388;824.044108833753;827.3753316246226;827.5034979012604;827.8758186272047;828.3456069704926;871.9084496127911;871.9520426376547;872.5419154943673;873.0832625742976;873.9344549158807;867.0332579174238;869.1395518436765;870.9433886797369;871.834351473218;871.9825603487958;636.5098873867142;639.6130341143635;640.078287266335;640.5868215001298;642.0241233325366;13689.86310136896;13717;13763.793543096861;13766.793498097437;13790;12416.875831241663;12732.23606583608;12944.093913426064;13281.136726112773;13473.124246923919;9688.660896868647;9725.902740972571;9730.41617502952;9790.75523111928;10231.386116833013;3484.303139372136;3558.982205088984;3580.445031020196;3586.5696116466193;3605.0987253186704;44040.77979610114;45046;47696.28455573169;48021;49609.75195124001;8901.154390332907;9399.859002114974;9463.952680236554;9816.263780216512;10678.1991350649;15716.21418929049;17872.106394680213;18091;18117.637647246982;18128.184231709605;7452.776416707507;7691.961540192263;7704;7859.410544209093;8283.668653253802;4211.936820947688;4248.745075295492;4317.07182955666;4328.091100868853;4573.679842410999;3157.5737275467977;3188.713015828587;3194.121616555419;3196.2488815128427;3198.040587823644;575.0942265931175;587.4771453406472;589.2869627750384;594.5332913662841;611.0467670434138;580.2978396140633;580.988380232393;583.7869177750175;633.4926994434564;658.2397331082607;7525.774226773206;7629;7642.235776422424;7771.4559980800805;7808.726694565777;488.2505354281232;594.7620951619386;607.4745345276392;635.6535688049931;639.766485232896;3679.1354031802507;3813.4089216171537;3890.922181556353;3946.861859834892;4014.558398576154;58008;58140.41859581435;58367.70816145892;58374.41625583775;58489.41510584925;51331;51485.48514514882;52027.47972520226;52259.47740522622;52703.73648131735;46922.53077469182;47369;47489.5251047492;47572;48047.519524805;7905.32804711583;8022.518648881086;8042.316403105568;8085.514869107872;8205.220504052106;29508;32700.672993270713;34344.65655343414;34856.302873942885;37295.813520933305;43424.78287608542;43875.341869871336;44075.77962110169;44665.55334446614;45170.54829451664;10346.068853802893;10535.42055186972;10561.735956601147;10622.309549879234;10752.193585480964;10839.403832789272;11096.944515277371;11183.32900026001;11508.94245528767;11531.250468719507;10204.540795664065;10313.329633574094;10327.277090603586;10354.637587684696;10364.637237696645;10626.36241825493;10657.307275027099;11069.531808166597;11141.944290278496;11149.275297105662;9781.266405019509;9944.45305508204;10078.596856125967;10106.292559521056;10355.068043876086;8042.919570804217;8273.627686753991;8655.6970506032;8679.166417865827;8946.463212207029;8218.753437396888;8352.874706879524;9076.909230907606;9199.494027828534;9279.67521136757 23:00:59 INFO - PROCESS | 28499 | __end_tp_report 23:00:59 INFO - PROCESS | 28499 | __start_cc_report 23:00:59 INFO - PROCESS | 28499 | _x_x_mozilla_cycle_collect,1030 23:00:59 INFO - PROCESS | 28499 | __end_cc_report 23:00:59 INFO - PROCESS | 28499 | __startTimestamp1455346859933__endTimestamp 23:00:59 INFO - PROCESS | 28499 | 23:00:59 INFO - PROCESS | 28499 | ------- Summary: start ------- 23:00:59 INFO - PROCESS | 28499 | Number of tests: 6 23:00:59 INFO - PROCESS | 28499 | 23:00:59 INFO - PROCESS | 28499 | [#0] dojo.html Cycles:165 Average:5159.04 Median:5362.12 stddev:558.91 (10.4%) stddev-sans-first:537.43 23:00:59 INFO - PROCESS | 28499 | Values: 3127.7 3134.9 3178.4 3183.9 3211.2 5051.7 5092.9 5106.4 5138.8 5188.5 5068.4 5123.3 5139.5 5164.7 5177.4 4686.5 4742.5 4743.1 4811.4 4917.3 4663.5 4812.0 4813.4 4835.9 4903.0 4653.6 4707.4 4736.9 4758.9 4766.6 4622.8 4633.2 4641.2 4642.0 4670.8 4627.0 4630.1 4636.9 4640.6 4663.4 4994.1 5004.5 5081.5 5085.9 5096.1 5437.9 5445.1 5452.6 5455.3 5495.3 5393.2 5473.9 5517.8 5523.7 5526.9 5195.6 5217.6 5222.9 5293.7 5327.0 5716.5 5724.6 5727.6 5759.5 5770.3 5494.8 5502.3 5521.8 5524.9 5526.2 5380.0 5406.8 5575.9 5578.3 5665.5 5637.4 5637.5 5637.7 5640.5 5650.2 5617.6 5631.8 5633.0 5633.5 5642.8 4210.6 4310.1 4353.3 4373.3 4414.6 3876.3 3886.9 3909.1 3938.5 3943.1 5176.4 5191.1 5195.9 5198.2 5201.9 5467.8 5578.7 5610.4 5659.2 5696.6 5144.2 5145.0 5165.5 5170.0 5173.6 4625.1 4749.4 4750.8 4751.0 4760.4 5574.4 5615.5 5639.5 5672.7 5714.2 5602.5 5605.4 5615.2 5619.8 5623.6 5595.7 5740.0 5746.8 5808.8 5819.2 5457.5 5521.0 5535.7 5540.4 5581.5 5458.8 5462.8 5475.9 5476.4 5482.9 5336.0 5347.1 5398.0 5465.7 5466.2 5362.1 5420.7 5427.2 5453.7 5471.1 5334.9 5335.6 5336.6 5358.7 5379.6 5358.1 5446.6 5459.3 5459.9 5483.9 5397.1 5398.3 5400.1 5400.2 5407.4 23:00:59 INFO - PROCESS | 28499 | 23:00:59 INFO - PROCESS | 28499 | [#1] ext.html Cycles:180 Average:43438.86 Median:33450.67 stddev:72549.24 (216.9%) stddev-sans-first:72681.23 23:00:59 INFO - PROCESS | 28499 | Values: 530.6 531.0 536.1 551.2 557.0 27511.0 28191.0 35823.6 36362.5 36606.6 39590.6 40029.0 40100.6 40161.4 40211.8 8521.1 8685.7 8694.1 8708.2 8708.7 8670.3 8826.2 8836.7 8840.8 8865.2 8886.9 8965.6 8968.5 8985.5 8988.6 8819.2 8854.4 8900.1 8910.8 8917.4 8768.0 8827.3 8905.8 8925.1 8926.0 39696.0 39979.2 40128.4 40137.4 40163.0 2890.4 2993.6 3328.8 3936.4 4034.8 27110.7 27315.6 27932.9 28246.3 28390.4 3168.1 3258.8 3313.6 3475.3 3571.0 252656.0 255686.0 256490.0 256597.0 350533.0 43330.8 61122.4 62182.7 62292.0 62310.4 57997.7 58026.4 58200.4 58236.0 58328.0 13440.5 14134.6 14400.9 14415.7 14431.5 10327.4 10499.9 10553.1 10581.8 10609.5 18068.1 18269.0 18273.5 18283.4 18314.8 7145.1 7365.7 7368.0 7406.3 7465.8 861.5 863.7 920.4 1016.6 1072.3 27993.0 28065.3 28849.6 28853.4 30199.4 914.5 932.9 966.4 1033.6 1137.8 13798.6 13892.8 13990.3 14081.9 14082.3 303199.0 307520.0 307917.0 308228.0 308555.0 45086.0 45152.1 45247.5 45271.1 45355.8 1349.6 1352.2 1358.9 1384.9 1489.1 25680.5 26168.9 26934.7 26942.7 27037.2 43581.1 43829.1 43928.8 43934.1 43947.0 242781.0 244115.0 244451.0 244571.0 245681.0 26797.7 26871.6 32612.3 33516.0 33651.0 38341.0 38534.4 38769.4 38844.2 39176.8 33026.0 33221.0 33422.7 33432.5 33468.8 27430.6 31568.4 33253.3 33593.8 33967.3 30445.7 30688.0 30697.7 31220.7 31758.8 27464.6 28550.7 28674.7 28697.7 28978.0 22922.5 23072.7 23232.2 23423.8 23478.4 23:00:59 INFO - PROCESS | 28499 | 23:00:59 INFO - PROCESS | 28499 | [#2] jquery.html Cycles:180 Average:27384.95 Median:355.99 stddev:81398.61 (22865.6%) stddev-sans-first:81601.64 23:00:59 INFO - PROCESS | 28499 | Values: 351.9 353.4 353.5 354.5 357.5 13012.5 13430.7 16226.0 16256.5 16869.9 15050.1 15116.8 15378.1 15664.7 15702.3 5122.9 5237.5 5429.2 5433.7 5434.9 3642.9 3753.7 5333.5 6565.3 6868.3 6335.8 6582.3 6851.2 6883.4 6890.7 6391.6 6421.1 6426.2 6464.2 6464.5 6281.3 6444.8 6448.6 6454.4 6454.8 21146.4 21793.8 22277.1 22293.3 22515.7 2038.5 2164.4 2203.0 2798.3 2900.7 13312.6 13344.1 13636.5 13786.6 13786.9 1903.4 1909.8 1911.1 1969.7 2002.0 66801.0 67894.3 68659.0 68876.2 69122.0 14743.0 15263.5 15333.9 15341.0 15374.5 23170.0 23334.4 23349.4 23649.3 23731.6 8599.2 8690.3 8729.4 8738.4 8848.0 7446.7 7534.5 7537.0 7554.3 7559.8 6505.4 7180.8 7200.2 7515.2 7553.9 2777.5 2916.0 2938.6 2944.7 2950.6 810.0 827.2 947.3 957.7 1030.2 15118.2 15257.2 16245.8 16591.7 16663.0 780.7 870.7 890.7 890.9 917.9 8547.3 8844.1 8860.4 8950.1 9015.4 489985.0 493685.0 497715.0 503768.0 504646.0 56793.0 75502.6 75668.6 76213.0 77903.6 1092.2 1109.0 1134.1 1157.7 1162.1 13921.2 14250.9 14376.1 14675.8 14710.3 31162.0 31375.1 31587.2 31645.7 31693.0 34372.0 38067.4 43533.8 45871.5 46533.5 6814.8 7305.3 7307.2 7432.4 7461.2 10020.0 10290.0 10564.0 10872.3 11097.4 9876.2 10026.0 10131.7 10135.7 10235.5 10120.8 10187.3 10370.5 10518.6 10572.9 10130.9 10197.8 10362.8 10364.8 10422.2 7527.5 7539.8 7573.7 7635.7 7702.0 9243.9 9602.9 9780.3 9796.8 10589.5 23:00:59 INFO - PROCESS | 28499 | 23:00:59 INFO - PROCESS | 28499 | [#3] mootools.html Cycles:180 Average:5534.62 Median:6360.99 stddev:2910.21 (45.8%) stddev-sans-first:2900.86 23:00:59 INFO - PROCESS | 28499 | Values: 1287.1 1421.2 1440.7 1589.8 1755.8 6806.7 7694.0 7849.2 7873.4 7879.1 7686.6 7872.9 7880.0 7893.7 7898.9 1960.3 2236.1 2273.8 2300.4 2324.6 2296.2 2303.8 2303.9 2307.9 2310.4 2214.1 2291.8 2300.7 2304.0 2304.1 2287.7 2316.2 2333.4 2334.4 2339.6 2257.3 2274.0 2313.1 2315.8 2317.8 8005.8 8049.1 8054.2 8062.7 8090.8 4764.5 4841.3 4845.6 4849.9 4880.3 2967.5 3061.9 3085.7 3089.2 3133.2 888.3 896.1 914.9 919.2 972.8 10972.5 10972.9 11057.4 11088.0 11136.9 4426.2 4483.9 4490.6 4498.9 4516.9 9522.7 9537.6 9537.6 9547.2 9554.0 4867.6 4899.4 4911.8 4914.7 4915.0 4465.2 4469.7 4473.6 4475.0 4481.8 3397.5 3605.5 3695.5 3733.3 3755.5 1191.9 1199.2 1201.6 1209.1 1211.0 1232.3 1242.3 1261.8 1273.4 1274.3 7050.6 7127.8 7146.6 7169.3 7194.8 1091.8 1093.3 1095.0 1110.2 1121.0 5464.9 5512.9 5521.9 5523.3 5523.8 9407.0 9684.4 9848.6 9899.6 9910.6 9761.5 9785.4 9862.8 9910.9 9914.4 7509.4 7545.6 7612.5 7643.9 7685.8 7200.8 7238.8 7246.3 7265.6 7288.0 8350.9 8634.9 8704.7 8886.7 8888.2 8915.0 9061.3 9065.7 9073.0 9094.5 7035.3 7106.4 7112.6 7144.4 7173.4 6720.2 7321.0 7567.9 7590.1 7619.5 6409.7 6745.0 6828.2 6984.0 7221.2 6657.0 6845.3 6865.5 6875.6 6999.8 6653.6 6698.5 6699.0 6700.4 6704.7 6222.2 6266.2 6284.2 6295.3 6295.4 6336.7 6385.3 6388.3 6395.7 6415.5 23:00:59 INFO - PROCESS | 28499 | 23:00:59 INFO - PROCESS | 28499 | [#4] prototype.html Cycles:180 Average:5211.63 Median:5822.09 stddev:1553.91 (26.7%) stddev-sans-first:1514.52 23:00:59 INFO - PROCESS | 28499 | Values: 333.4 334.0 336.3 338.8 342.9 5727.6 5821.7 5839.4 5884.4 5894.2 5624.0 5713.6 5745.0 5752.1 5758.5 4525.0 4536.2 4539.0 4553.8 4557.5 4327.3 4430.4 4438.3 4439.2 4557.6 4402.7 4469.0 4496.3 4509.9 4518.6 4503.2 4503.2 4503.5 4512.5 4519.3 3956.7 3991.6 3997.7 4001.4 4008.0 5439.6 5573.4 5577.9 5621.6 5623.9 5256.8 5261.2 5263.6 5269.0 5279.6 5896.9 6218.5 6218.8 6228.9 6229.1 4314.1 4355.3 4397.2 4406.1 4415.1 6316.1 6418.1 6430.4 6464.9 6469.5 4508.8 4509.1 4515.3 4516.7 4519.5 4477.5 4551.5 4565.1 4566.9 4589.0 5170.5 5182.5 5183.6 5187.7 5188.7 6163.9 6167.2 6167.4 6170.8 6180.3 1612.6 1627.2 1629.6 1632.8 1633.6 1097.6 1104.2 1107.3 1113.2 1140.2 5808.7 5813.2 5816.5 5822.5 5826.1 6373.7 6380.6 6382.5 6389.1 6391.3 5812.1 5826.2 5828.8 5830.1 5832.7 3391.4 3491.6 3498.3 3503.5 3503.6 6660.5 6722.6 6726.7 6734.6 6734.8 6606.0 6606.3 6611.9 6613.7 6648.2 6533.8 6649.7 6699.8 6718.5 6720.5 6189.7 6255.5 6455.4 6466.3 6492.2 6342.3 6366.5 6370.1 6382.4 6395.7 6699.7 6704.5 6706.2 6712.7 6713.9 4235.3 4353.1 4382.1 4382.2 4384.5 6416.8 6422.6 6429.7 6430.6 6446.1 6230.4 6231.2 6232.5 6234.4 6236.5 6075.1 6235.9 6243.4 6247.7 6248.2 6165.4 6166.0 6170.7 6171.3 6172.6 6291.2 6305.7 6317.6 6328.1 6348.1 6082.8 6144.3 6197.1 6198.9 6201.1 23:00:59 INFO - PROCESS | 28499 | 23:00:59 INFO - PROCESS | 28499 | [#5] yui.html Cycles:180 Average:13596.86 Median:50470.38 stddev:16034.37 (31.8%) stddev-sans-first:16049.56 23:00:59 INFO - PROCESS | 28499 | Values: 582.5 641.8 650.4 715.7 723.9 13974.7 14110.2 14112.5 14121.6 14129.4 13171.0 13215.8 13235.5 13700.4 14787.9 813.5 826.4 827.2 827.5 830.0 824.0 827.4 827.5 827.9 828.3 871.9 872.0 872.5 873.1 873.9 867.0 869.1 870.9 871.8 872.0 636.5 639.6 640.1 640.6 642.0 13689.9 13717.0 13763.8 13766.8 13790.0 12416.9 12732.2 12944.1 13281.1 13473.1 9688.7 9725.9 9730.4 9790.8 10231.4 3484.3 3559.0 3580.4 3586.6 3605.1 44040.8 45046.0 47696.3 48021.0 49609.8 8901.2 9399.9 9464.0 9816.3 10678.2 15716.2 17872.1 18091.0 18117.6 18128.2 7452.8 7692.0 7704.0 7859.4 8283.7 4211.9 4248.7 4317.1 4328.1 4573.7 3157.6 3188.7 3194.1 3196.2 3198.0 575.1 587.5 589.3 594.5 611.0 580.3 581.0 583.8 633.5 658.2 7525.8 7629.0 7642.2 7771.5 7808.7 488.3 594.8 607.5 635.7 639.8 3679.1 3813.4 3890.9 3946.9 4014.6 58008.0 58140.4 58367.7 58374.4 58489.4 51331.0 51485.5 52027.5 52259.5 52703.7 46922.5 47369.0 47489.5 47572.0 48047.5 7905.3 8022.5 8042.3 8085.5 8205.2 29508.0 32700.7 34344.7 34856.3 37295.8 43424.8 43875.3 44075.8 44665.6 45170.5 10346.1 10535.4 10561.7 10622.3 10752.2 10839.4 11096.9 11183.3 11508.9 11531.3 10204.5 10313.3 10327.3 10354.6 10364.6 10626.4 10657.3 11069.5 11141.9 11149.3 9781.3 9944.5 10078.6 10106.3 10355.1 8042.9 8273.6 8655.7 8679.2 8946.5 8218.8 8352.9 9076.9 9199.5 9279.7 23:00:59 INFO - PROCESS | 28499 | -------- Summary: end -------- 23:00:59 INFO - PROCESS | 28499 | 23:01:00 INFO - TEST-INFO | 28499: exit 0 23:01:00 INFO - TEST-OK | dromaeo_css | took 1114322ms 23:01:00 INFO - TEST-START | kraken 23:01:00 INFO - operating with platform_type : linux_ 23:01:00 INFO - Initialising browser for kraken test... 23:01:00 INFO - TEST-INFO | started process 28688 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpu0LTHy/profile http://localhost:52894/getInfo.html) 23:01:05 INFO - PROCESS | 28688 | __metrics Screen width/height:1600/1200 23:01:05 INFO - PROCESS | 28688 | colorDepth:24 23:01:05 INFO - PROCESS | 28688 | Browser inner width/height: 1024/697 23:01:05 INFO - PROCESS | 28688 | __metrics 23:01:05 INFO - PROCESS | 28688 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:01:06 INFO - TEST-INFO | 28688: exit 0 23:01:06 INFO - Browser initialized. 23:01:06 INFO - Running cycle 1/1 for kraken test... 23:01:06 INFO - TEST-INFO | started process 28772 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpu0LTHy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:01:18 INFO - PROCESS | 28772 | RSS: Main: 151310336 23:01:18 INFO - PROCESS | 28772 | 23:01:21 INFO - PROCESS | 28772 | Cycle 1(1): loaded http://localhost:52894/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52894/tests/kraken/driver.html?testName=audio-beat-detection) 23:01:21 INFO - PROCESS | 28772 | RSS: Main: 193826816 23:01:21 INFO - PROCESS | 28772 | 23:01:24 INFO - PROCESS | 28772 | Cycle 1(1): loaded http://localhost:52894/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52894/tests/kraken/driver.html?testName=audio-dft) 23:01:24 INFO - PROCESS | 28772 | RSS: Main: 183943168 23:01:24 INFO - PROCESS | 28772 | 23:01:27 INFO - PROCESS | 28772 | Cycle 1(1): loaded http://localhost:52894/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52894/tests/kraken/driver.html?testName=audio-fft) 23:01:28 INFO - PROCESS | 28772 | RSS: Main: 169943040 23:01:28 INFO - PROCESS | 28772 | 23:01:30 INFO - PROCESS | 28772 | Cycle 1(1): loaded http://localhost:52894/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52894/tests/kraken/driver.html?testName=audio-oscillator) 23:01:30 INFO - PROCESS | 28772 | RSS: Main: 170012672 23:01:30 INFO - PROCESS | 28772 | 23:01:33 INFO - PROCESS | 28772 | Cycle 1(1): loaded http://localhost:52894/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52894/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:01:33 INFO - PROCESS | 28772 | RSS: Main: 170795008 23:01:33 INFO - PROCESS | 28772 | 23:01:36 INFO - PROCESS | 28772 | Cycle 1(1): loaded http://localhost:52894/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52894/tests/kraken/driver.html?testName=imaging-darkroom) 23:01:37 INFO - PROCESS | 28772 | RSS: Main: 171884544 23:01:37 INFO - PROCESS | 28772 | 23:01:40 INFO - PROCESS | 28772 | Cycle 1(1): loaded http://localhost:52894/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52894/tests/kraken/driver.html?testName=imaging-desaturate) 23:01:41 INFO - PROCESS | 28772 | RSS: Main: 173137920 23:01:41 INFO - PROCESS | 28772 | 23:01:44 INFO - PROCESS | 28772 | Cycle 1(1): loaded http://localhost:52894/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52894/tests/kraken/driver.html?testName=json-parse-financial) 23:01:44 INFO - PROCESS | 28772 | RSS: Main: 172453888 23:01:44 INFO - PROCESS | 28772 | 23:01:46 INFO - PROCESS | 28772 | Cycle 1(1): loaded http://localhost:52894/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52894/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:01:46 INFO - PROCESS | 28772 | RSS: Main: 184836096 23:01:46 INFO - PROCESS | 28772 | 23:01:48 INFO - PROCESS | 28772 | Cycle 1(1): loaded http://localhost:52894/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52894/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:01:49 INFO - PROCESS | 28772 | RSS: Main: 182386688 23:01:49 INFO - PROCESS | 28772 | 23:01:51 INFO - PROCESS | 28772 | Cycle 1(1): loaded http://localhost:52894/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52894/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:01:51 INFO - PROCESS | 28772 | RSS: Main: 198230016 23:01:51 INFO - PROCESS | 28772 | 23:01:54 INFO - PROCESS | 28772 | Cycle 1(1): loaded http://localhost:52894/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52894/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:01:54 INFO - PROCESS | 28772 | RSS: Main: 202977280 23:01:54 INFO - PROCESS | 28772 | 23:01:57 INFO - PROCESS | 28772 | Cycle 1(1): loaded http://localhost:52894/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52894/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:01:58 INFO - PROCESS | 28772 | RSS: Main: 200491008 23:01:58 INFO - PROCESS | 28772 | 23:01:59 INFO - PROCESS | 28772 | Cycle 1(1): loaded http://localhost:52894/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52894/tests/kraken/driver.html?testName=ai-astar) 23:02:00 INFO - PROCESS | 28772 | RSS: Main: 260145152 23:02:00 INFO - PROCESS | 28772 | 23:02:00 INFO - PROCESS | 28772 | __start_tp_report 23:02:00 INFO - PROCESS | 28772 | _x_x_mozilla_page_load 23:02:00 INFO - PROCESS | 28772 | _x_x_mozilla_page_load_details 23:02:00 INFO - PROCESS | 28772 | |i|pagename|runs| 23:02:00 INFO - PROCESS | 28772 | |0;ai-astar;110;112;105;111;112;111;102;110;111;110 23:02:00 INFO - PROCESS | 28772 | |1;audio-beat-detection;159;133;154;172;126;167;150;129;168;136 23:02:00 INFO - PROCESS | 28772 | |2;audio-dft;161;162;161;163;162;160;163;163;162;160 23:02:00 INFO - PROCESS | 28772 | |3;audio-fft;73;73;133;91;73;73;76;114;98;73 23:02:00 INFO - PROCESS | 28772 | |4;audio-oscillator;97;97;139;95;96;96;149;96;96;142 23:02:00 INFO - PROCESS | 28772 | |5;imaging-gaussian-blur;118;116;115;116;115;115;115;114;114;115 23:02:00 INFO - PROCESS | 28772 | |6;imaging-darkroom;145;145;145;145;147;146;146;145;145;146 23:02:00 INFO - PROCESS | 28772 | |7;imaging-desaturate;97;96;96;97;96;97;97;96;97;97 23:02:00 INFO - PROCESS | 28772 | |8;json-parse-financial;56;55;58;56;55;56;56;65;53;53 23:02:00 INFO - PROCESS | 28772 | |9;json-stringify-tinderbox;68;67;68;67;69;67;68;68;68;68 23:02:00 INFO - PROCESS | 28772 | |10;stanford-crypto-aes;84;82;91;84;83;90;84;83;84;84 23:02:00 INFO - PROCESS | 28772 | |11;stanford-crypto-ccm;122;119;117;116;117;122;124;119;132;117 23:02:00 INFO - PROCESS | 28772 | |12;stanford-crypto-pbkdf2;156;142;161;149;149;140;152;154;149;162 23:02:00 INFO - PROCESS | 28772 | |13;stanford-crypto-sha256-iterative;68;69;70;71;67;67;70;69;67;67 23:02:00 INFO - PROCESS | 28772 | __end_tp_report 23:02:00 INFO - PROCESS | 28772 | __start_cc_report 23:02:00 INFO - PROCESS | 28772 | _x_x_mozilla_cycle_collect,991 23:02:00 INFO - PROCESS | 28772 | __end_cc_report 23:02:00 INFO - PROCESS | 28772 | __startTimestamp1455346920057__endTimestamp 23:02:00 INFO - PROCESS | 28772 | 23:02:00 INFO - PROCESS | 28772 | ------- Summary: start ------- 23:02:00 INFO - PROCESS | 28772 | Number of tests: 14 23:02:00 INFO - PROCESS | 28772 | 23:02:00 INFO - PROCESS | 28772 | [#0] ai-astar Cycles:10 Average:109.40 Median:111.00 stddev:3.27 (2.9%) stddev-sans-first:3.46 23:02:00 INFO - PROCESS | 28772 | Values: 110.0 112.0 105.0 111.0 112.0 111.0 102.0 110.0 111.0 110.0 23:02:00 INFO - PROCESS | 28772 | 23:02:00 INFO - PROCESS | 28772 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:156.50 stddev:17.30 (11.1%) stddev-sans-first:17.99 23:02:00 INFO - PROCESS | 28772 | Values: 159.0 133.0 154.0 172.0 126.0 167.0 150.0 129.0 168.0 136.0 23:02:00 INFO - PROCESS | 28772 | 23:02:00 INFO - PROCESS | 28772 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.16 (0.7%) stddev-sans-first:1.20 23:02:00 INFO - PROCESS | 28772 | Values: 161.0 162.0 161.0 163.0 162.0 160.0 163.0 163.0 162.0 160.0 23:02:00 INFO - PROCESS | 28772 | 23:02:00 INFO - PROCESS | 28772 | [#3] audio-fft Cycles:10 Average:87.70 Median:73.00 stddev:21.29 (29.2%) stddev-sans-first:21.90 23:02:00 INFO - PROCESS | 28772 | Values: 73.0 73.0 133.0 91.0 73.0 73.0 76.0 114.0 98.0 73.0 23:02:00 INFO - PROCESS | 28772 | 23:02:00 INFO - PROCESS | 28772 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:96.00 stddev:22.93 (23.9%) stddev-sans-first:23.81 23:02:00 INFO - PROCESS | 28772 | Values: 97.0 97.0 139.0 95.0 96.0 96.0 149.0 96.0 96.0 142.0 23:02:00 INFO - PROCESS | 28772 | 23:02:00 INFO - PROCESS | 28772 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:115.00 stddev:1.16 (1.0%) stddev-sans-first:0.71 23:02:00 INFO - PROCESS | 28772 | Values: 118.0 116.0 115.0 116.0 115.0 115.0 115.0 114.0 114.0 115.0 23:02:00 INFO - PROCESS | 28772 | 23:02:00 INFO - PROCESS | 28772 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 23:02:00 INFO - PROCESS | 28772 | Values: 145.0 145.0 145.0 145.0 147.0 146.0 146.0 145.0 145.0 146.0 23:02:00 INFO - PROCESS | 28772 | 23:02:00 INFO - PROCESS | 28772 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 23:02:00 INFO - PROCESS | 28772 | Values: 97.0 96.0 96.0 97.0 96.0 97.0 97.0 96.0 97.0 97.0 23:02:00 INFO - PROCESS | 28772 | 23:02:00 INFO - PROCESS | 28772 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.00 stddev:3.40 (6.1%) stddev-sans-first:3.61 23:02:00 INFO - PROCESS | 28772 | Values: 56.0 55.0 58.0 56.0 55.0 56.0 56.0 65.0 53.0 53.0 23:02:00 INFO - PROCESS | 28772 | 23:02:00 INFO - PROCESS | 28772 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 23:02:00 INFO - PROCESS | 28772 | Values: 68.0 67.0 68.0 67.0 69.0 67.0 68.0 68.0 68.0 68.0 23:02:00 INFO - PROCESS | 28772 | 23:02:00 INFO - PROCESS | 28772 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.00 stddev:3.03 (3.6%) stddev-sans-first:3.20 23:02:00 INFO - PROCESS | 28772 | Values: 84.0 82.0 91.0 84.0 83.0 90.0 84.0 83.0 84.0 84.0 23:02:00 INFO - PROCESS | 28772 | 23:02:00 INFO - PROCESS | 28772 | [#11] stanford-crypto-ccm Cycles:10 Average:120.50 Median:120.50 stddev:4.84 (4.0%) stddev-sans-first:5.10 23:02:00 INFO - PROCESS | 28772 | Values: 122.0 119.0 117.0 116.0 117.0 122.0 124.0 119.0 132.0 117.0 23:02:00 INFO - PROCESS | 28772 | 23:02:00 INFO - PROCESS | 28772 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.40 Median:153.00 stddev:7.21 (4.7%) stddev-sans-first:7.46 23:02:00 INFO - PROCESS | 28772 | Values: 156.0 142.0 161.0 149.0 149.0 140.0 152.0 154.0 149.0 162.0 23:02:00 INFO - PROCESS | 28772 | 23:02:00 INFO - PROCESS | 28772 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.51 (2.2%) stddev-sans-first:1.59 23:02:00 INFO - PROCESS | 28772 | Values: 68.0 69.0 70.0 71.0 67.0 67.0 70.0 69.0 67.0 67.0 23:02:00 INFO - PROCESS | 28772 | -------- Summary: end -------- 23:02:00 INFO - PROCESS | 28772 | 23:02:00 INFO - TEST-INFO | 28772: exit 0 23:02:01 INFO - TEST-OK | kraken | took 60321ms 23:02:01 INFO - SUITE-END | took 1174s 23:02:01 INFO - Completed test suite (00:19:34) 23:02:01 INFO - Working with test: dromaeo_css 23:02:01 INFO - Generating results file: dromaeo_css 23:02:01 INFO - Working with test: kraken 23:02:01 INFO - Generating results file: kraken 23:02:01 INFO - javascript benchmark 23:02:01 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:02:01 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 23:02:01 INFO - process_Request line: dromaeo_css 6864.39 graph.html#tests=[[72,64,35]] 23:02:01 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:02:01 INFO - process_Request line: kraken 1525.30 graph.html#tests=[[232,64,35]] 23:02:01 INFO - RETURN: dromaeo_css: 6864.39 23:02:01 INFO - RETURN: kraken: 1525.30 23:02:01 INFO - javascript benchmark 23:02:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3127.7185053345197, 3134.921626959327, 3178.3643271345722, 3183.92040198995, 3211.2453573410253, 5051.722155281458, 5092.949070509294, 5106.412762532305, 5138.794448222066, 5188.48115188481, 5068.391792984838, 5123.257127716479, 5139.486051394859, 5164.664296820704, 5177.4045984711765, 4686.53134686532, 4742.454617718963, 4743.098811225873, 4811.398575178103, 4917.311576379309, 4663.4637016743, 4811.951880481203, 4813.350197723297, 4835.927461088069, 4902.950970490303, 4653.6044436222965, 4707.411573553306, 4736.857894263143, 4758.881027974294, 4766.618670506351, 4622.791974361162, 4633.235516139866, 4641.187792136397, 4641.976790116061, 4670.813167473297, 4626.976865115686, 4630.1202771473645, 4636.930446043312, 4640.559146881041, 4663.370444989917, 4994.101061808873, 5004.5495905368325, 5081.5426611605135, 5085.898282034339, 5096.057229412533, 5437.945620543784, 5445.101558242885, 5452.59105567084, 5455.290812194429, 5495.340559132889, 5393.164059570773, 5473.890522189574, 5517.806876759334, 5523.696196709179, 5526.889462210774, 5195.610329225286, 5217.608679349064, 5222.895542089175, 5293.708846013467, 5326.961242557664, 5716.456936591017, 5724.599278050497, 5727.570432217517, 5759.51044161251, 5770.278715160605, 5494.80768173112, 5502.339719233638, 5521.834344969658, 5524.889502209933, 5526.226328314039, 5379.973100134474, 5406.78372865081, 5575.944240557624, 5578.30271216098, 5665.49010589049, 5637.408072152365, 5637.548996080303, 5637.689927054052, 5640.464155905182, 5650.23721797552, 5617.606767526316, 5631.802886898939, 5633.042382794934, 5633.464820842013, 5642.802501912413, 4210.578942105765, 4310.094880075157, 4353.325234588644, 4373.343998400202, 4414.55854414556, 3876.302265592164, 3886.8639597613947, 3909.0618251619408, 3938.468306778548, 3943.073377756225, 5176.378834539804, 5191.143461328914, 5195.870103247449, 5198.246254293106, 5201.869953251199, 5467.753951072212, 5578.721063946868, 5610.354809196994, 5659.151127330933, 5696.629719068247, 5144.202648589475, 5145.048166089286, 5165.457626949192, 5170.043541944752, 5173.63784535079, 4625.051864367797, 4749.382580264543, 4750.762461876892, 4751.026039661861, 4760.404949381327, 5574.386817450078, 5615.522680572116, 5639.492445679908, 5672.716364181774, 5714.228579141846, 5602.467765562265, 5605.355384130877, 5615.157726341082, 5619.80330688424, 5623.578231632562, 5595.720213989365, 5739.971300143639, 5746.798862039808, 5808.767649293981, 5819.15622234782, 5457.508824205841, 5520.972395137998, 5535.667859928417, 5540.36285827135, 5581.469760372758, 5458.781648734006, 5462.8361149164, 5475.917861232165, 5476.397596264487, 5482.945170548243, 5336.012837625051, 5347.144456886879, 5398.028354896156, 5465.69938653362, 5466.1527463243265, 5362.115250983544, 5420.674759514442, 5427.24018637399, 5453.672779633234, 5471.124620060771, 5334.919976200283, 5335.599830012687, 5336.626436149588, 5358.705271209965, 5379.623426360117, 5358.062339090721, 5446.564274857923, 5459.317585301837, 5459.945400546103, 5483.862903427286, 5397.055515284731, 5398.271233383443, 5400.054990376747, 5400.1899715043055, 5407.351117865881], "unit": "score", "name": "dojo.html", "value": 5124.085202566606}, {"lowerIsBetter": false, "replicates": [530.6046994988732, 531.0494215354515, 536.0993530868143, 551.244794631355, 556.9916451253234, 27511.0, 28191.0, 35823.64176358235, 36362.45456318157, 36606.633933660654, 39590.60409395905, 40029.0, 40100.59899401005, 40161.39757903634, 40211.79894100533, 8521.105283945204, 8685.652573897036, 8694.087120852315, 8708.17272359125, 8708.651653933835, 8670.34972377071, 8826.249768769661, 8836.690715824947, 8840.823183536326, 8865.202131808135, 8886.86669699955, 8965.596548155349, 8968.46189228645, 8985.505797181153, 8988.59551320192, 8819.206271435569, 8854.424462409923, 8900.109989001114, 8910.777230569223, 8917.42036767608, 8767.956160219223, 8827.293816494664, 8905.821883562292, 8925.107489251088, 8926.0, 39696.0, 39979.200415991516, 40128.39807402891, 40137.39793903094, 40163.0, 2890.3930174663346, 2993.580898674187, 3328.8002719836645, 3936.3701807710627, 4034.798260086984, 27110.728892711017, 27315.590266146024, 27932.860335698395, 28246.293842653893, 28390.432191356056, 3168.1154797033173, 3258.771885967983, 3313.6023677158896, 3475.3049390121823, 3570.982145089284, 252656.0, 255686.0, 256490.0, 256597.0, 350533.0, 43330.783346083066, 61122.38877611167, 62182.68908655428, 62292.0, 62310.37689623136, 57997.71001144967, 58026.41973580295, 58200.4179958195, 58236.0, 58328.0, 13440.462381504825, 14134.64663383403, 14400.855991440161, 14415.711685766226, 14431.49489767853, 10327.431991240554, 10499.895001050045, 10553.05022547959, 10581.84127238092, 10609.522571484302, 18068.096595170187, 18269.0, 18273.451796446127, 18283.360082397052, 18314.816851831576, 7145.1425828900865, 7365.742199023009, 7368.005319281936, 7406.3334299912185, 7465.813354666068, 861.4960248254716, 863.6631713631689, 920.4477313611914, 1016.5832008876325, 1072.3083611070815, 27993.0, 28065.298367540974, 28849.56725649117, 28853.422931541252, 30199.396012079636, 914.492456686532, 932.8942074124869, 966.4249771386014, 1033.5762337441613, 1137.7951968645723, 13798.568633763483, 13892.791608125886, 13990.300484975915, 14081.929590351983, 14082.295885205698, 303199.0, 307520.0, 307917.0, 308228.0, 308555.0, 45086.0, 45152.096958060654, 45247.547524524336, 45271.094578108256, 45355.77322113435, 1349.6355983884296, 1352.1684164238923, 1358.864113588653, 1384.9307534623229, 1489.1065360783443, 25680.486390272465, 26168.8691556541, 26934.730652693223, 26942.730572694807, 27037.1888843335, 43581.128377432906, 43829.12341753211, 43928.78035609802, 43934.12131757411, 43947.0, 242781.0, 244115.0, 244451.0, 244571.0, 245681.0, 26797.732022680302, 26871.596926046517, 32612.34775304528, 33516.0, 33650.99047028593, 38341.0, 38534.42198367083, 38769.4184587237, 38844.223115538094, 39176.80411597924, 33026.0, 33221.0, 33422.665773341956, 33432.498512521845, 33468.832655836566, 27430.5885411715, 31568.368632627677, 33253.33493330071, 33593.83203083969, 33967.32065358728, 30445.69554304517, 30688.0, 30697.693023070377, 31220.68779312178, 31758.841205793822, 27464.588031179148, 28550.714492854804, 28674.713252868038, 28697.713022869502, 28978.0, 22922.54154916859, 23072.655034727195, 23232.186873459348, 23423.76576234284, 23478.413039674146], "unit": "score", "name": "ext.html", "value": 17439.026567000925}, {"lowerIsBetter": false, "replicates": [351.882119489971, 353.3851099087588, 353.5068579331832, 354.4895350694999, 357.485221281355, 13012.544560940369, 13430.731385372286, 16226.0, 16256.512304630865, 16869.91565042173, 15050.096994180329, 15116.773248401283, 15378.077315361086, 15664.686706265897, 15702.293396797142, 5122.92315615266, 5237.45006774289, 5429.239906413105, 5433.673979561239, 5434.91847622286, 3642.8724994625195, 3753.7184711146638, 5333.5199832015305, 6565.343465653445, 6868.278830722752, 6335.778247761329, 6582.3417658234275, 6851.1778586569435, 6883.380495755381, 6890.655467226644, 6391.648459334735, 6421.068945002972, 6426.228852537702, 6464.224293084813, 6464.547481676261, 6281.3404592518045, 6444.7744328948265, 6448.580842245286, 6454.41910228077, 6454.774082907123, 21146.365609031753, 21793.782062179333, 22277.108915643355, 22293.331200064025, 22515.662265066036, 2038.500567361006, 2164.3615133535645, 2203.0, 2798.272449163232, 2900.6809250982374, 13312.600621981355, 13344.132631379027, 13636.522721704792, 13786.586402407944, 13786.93106534471, 1903.4289713086018, 1909.799471055547, 1911.0826803134435, 1969.6848504239397, 2002.0, 66801.0, 67894.32105678979, 68659.0, 68876.21180835052, 69122.0, 14742.96799224044, 15263.465778697693, 15333.923330383499, 15341.0, 15374.461893833886, 23170.0, 23334.416639584146, 23349.41626459352, 23649.29052128439, 23731.644025339632, 8599.226069653636, 8690.304775617935, 8729.388942774072, 8738.432001919855, 8847.955760221157, 7446.7021319146625, 7534.472586918972, 7537.0, 7554.2823431773895, 7559.811004724816, 6505.447037001813, 7180.820479488055, 7200.171980222237, 7515.248475152551, 7553.924460755322, 2777.472280266743, 2916.0, 2938.61797966263, 2944.7349738523635, 2950.6164198654037, 809.9878501822477, 827.2182787265975, 947.3368641950663, 957.7414098193449, 1030.2479190191052, 15118.168500732565, 15257.237138143271, 16245.837541624433, 16591.6681666366, 16663.0, 780.7384526183793, 870.7170169694874, 890.7372325164092, 890.9198172164407, 917.8852643419573, 8547.273481753997, 8844.136566056408, 8860.4240724354, 8950.14973577509, 9015.368924175376, 489985.0, 493685.0, 497715.0, 503768.0, 504646.0, 56793.0, 75502.62248688831, 75668.62165689246, 76213.0, 77903.61048194722, 1092.208149091902, 1108.9944550277196, 1134.1097238667605, 1157.6932112990064, 1162.110985096402, 13921.234332111426, 14250.857491425368, 14376.137431754129, 14675.779863301845, 14710.338034788674, 31162.0, 31375.05874823759, 31587.21031974219, 31645.683543164272, 31693.0, 34372.0, 38067.42898856575, 43533.78233108814, 45871.541284586725, 46533.534664654275, 6814.795556133324, 7305.305995930378, 7307.232740562377, 7432.442566807619, 7461.216572259835, 10020.0, 10290.0, 10564.0, 10872.347659140476, 11097.38964356968, 9876.160526355341, 10026.0, 10131.696049118538, 10135.746606334606, 10235.539400727133, 10120.84818727705, 10187.337823041478, 10370.533326000197, 10518.579256829948, 10572.89427105719, 10130.89869101329, 10197.796044078928, 10362.792744144925, 10364.792704146026, 10422.166226701695, 7527.473076884566, 7539.811504712206, 7573.674606943873, 7635.732749353746, 7701.961490192513, 9243.907560924305, 9602.85595716051, 9780.315377923762, 9796.755081123029, 10589.470526473491], "unit": "score", "name": "jquery.html", "value": 8914.636321672187}, {"lowerIsBetter": false, "replicates": [1287.1118927939726, 1421.2325344314072, 1440.7406666799977, 1589.8410158984102, 1755.8244175582442, 6806.659667016648, 7693.961530192349, 7849.215078492148, 7873.448858579902, 7879.093904201019, 7686.577238251908, 7872.897794308801, 7880.0, 7893.684252629902, 7898.881516777253, 1960.2942940541393, 2236.1279101150485, 2273.795358417742, 2300.413394584383, 2324.6164382876805, 2296.2307626944994, 2303.7581053989343, 2303.942401439969, 2307.930762077132, 2310.376198426424, 2214.1032881682945, 2291.759365266648, 2300.6894069300683, 2304.0, 2304.0783686525356, 2287.6617178950332, 2316.2124877541632, 2333.4166458385403, 2334.3697201755517, 2339.578875802355, 2257.2776711452343, 2273.9772602274097, 2313.063209400196, 2315.79157875792, 2317.7913987741185, 8005.839883202361, 8049.074356449025, 8054.194580541899, 8062.677492900277, 8090.838183236302, 4764.523547645243, 4841.3222148899185, 4845.563899249085, 4849.878753031167, 4880.316755654211, 2967.5279922490736, 3061.8928337508305, 3085.7377122944354, 3089.2276930767307, 3133.15404840694, 888.2583043158905, 896.1262768800433, 914.9176574108295, 919.1635611593418, 972.7908499672604, 10972.506237219264, 10972.945135274353, 11057.391843448608, 11088.0, 11136.888631113747, 4426.247537918497, 4483.932741008887, 4490.550944905483, 4498.887527811831, 4516.88707782308, 9522.666706665234, 9537.570809313598, 9537.570809313598, 9547.188488978514, 9554.0, 4867.561919427198, 4899.436564795023, 4911.778969946361, 4914.655974081851, 4915.0415668944925, 4465.218586747306, 4469.664775141878, 4473.597376236155, 4475.037866858641, 4481.7535035573355, 3397.5073614325784, 3605.4591811228524, 3695.5011073504734, 3733.346664333785, 3755.455458958436, 1191.8986886114778, 1199.2444759801444, 1201.6214892308894, 1209.056935590241, 1210.975780484403, 1232.3283810323396, 1242.2856857307086, 1261.8233447317382, 1273.446050967832, 1274.2927675140386, 7050.612216328049, 7127.821804454827, 7146.642667866586, 7169.318914703095, 7194.820129496699, 1091.7761858818924, 1093.3221402730358, 1094.9781004379868, 1110.245033377295, 1121.0471099565304, 5464.890702186013, 5512.944870551243, 5521.923224971172, 5523.28197334344, 5523.8066667666435, 9407.0, 9684.385215991642, 9848.606055757833, 9899.554520046615, 9910.603575857029, 9761.511924403894, 9785.36395134314, 9862.753431164136, 9910.851337229948, 9914.40513569188, 7509.436792240604, 7545.584992825447, 7612.543247405173, 7643.885341719879, 7685.807854803563, 7200.819979500555, 7238.782836514913, 7246.275372462923, 7265.636718163965, 7287.963560182166, 8350.874736879074, 8634.913650863411, 8704.695335663222, 8886.73339799807, 8888.155625215593, 8914.955425222832, 9061.275097992013, 9065.728028159167, 9073.047330030251, 9094.454332740057, 7035.296470353129, 7106.431485481253, 7112.57324560528, 7144.428445724226, 7173.390261827594, 6720.227173875067, 7320.96339518299, 7567.886481702669, 7590.051243594551, 7619.542827430372, 6409.7115629795835, 6745.0, 6828.214755303204, 6984.0, 7221.241769614115, 6657.0, 6845.315468453115, 6865.519413640997, 6875.5874647521305, 6999.825004374931, 6653.600783952978, 6698.497612679166, 6698.966505167443, 6700.430463410665, 6704.66476676174, 6222.222222222223, 6266.154069200599, 6284.214473190851, 6295.276043255084, 6295.3704629538515, 6336.7148478319505, 6385.265694445013, 6388.329225431263, 6395.712192951235, 6415.486761059197], "unit": "score", "name": "mootools.html", "value": 4529.198829804639}, {"lowerIsBetter": false, "replicates": [333.40154422811054, 333.9983300083499, 336.323988782547, 338.8034939734954, 342.94855771634235, 5727.599068065237, 5821.708914554266, 5839.386864379243, 5884.411558844119, 5894.233749612555, 5624.0, 5713.571482138836, 5744.971275143618, 5752.079667253241, 5758.510526605233, 4524.977375113136, 4536.183486972343, 4539.046800171968, 4553.772311384434, 4557.521460246676, 4327.329263964075, 4430.401895744066, 4438.26768583185, 4439.245328294198, 4557.56436722433, 4402.713823601472, 4469.039156581334, 4496.303073023671, 4509.864704058883, 4518.615917647004, 4503.166914120898, 4503.234450143467, 4503.468820601011, 4512.45850497939, 4519.299508576143, 3956.723029387944, 3991.5808840071954, 3997.7407116758127, 4001.4397984282223, 4008.018035581272, 5439.619226654136, 5573.41479144688, 5577.888442231133, 5621.550275977912, 5623.9437605623825, 5256.842294731164, 5261.184516399964, 5263.578913686896, 5269.0252303324005, 5279.5512381447625, 5896.911546326808, 6218.4714299284615, 6218.81343559694, 6228.906566401508, 6229.127922090911, 4314.137172565468, 4355.346697995326, 4397.2304846651705, 4406.09675016624, 4415.094905544356, 6316.08416779569, 6418.101465794793, 6430.421262086388, 6464.903026454654, 6469.547131700783, 4508.819647214074, 4509.053098849213, 4515.300128480091, 4516.706414083074, 4519.457665080211, 4477.507474177838, 4551.499335073139, 4565.086982603426, 4566.931496027562, 4588.977055114703, 5170.45710200431, 5182.481751824787, 5183.637145399861, 5187.688738675616, 5188.688678679291, 6163.907541386883, 6167.229096362955, 6167.444929956326, 6170.845728856814, 6180.258368995659, 1612.6049117966174, 1627.2026706913528, 1629.6333325002017, 1632.795900512436, 1633.6487655153962, 1097.6432659385732, 1104.2160066352978, 1107.291333546531, 1113.2040590977329, 1140.2189500192394, 5808.738606762706, 5813.215215945877, 5816.5055970243, 5822.475977162076, 5826.126081087871, 6373.681315934185, 6380.617162970237, 6382.521310901701, 6389.137466442064, 6391.296957334689, 5812.128180772834, 5826.1552074948895, 5828.766849326064, 5830.096335068071, 5832.737526811304, 3391.3895498810452, 3491.5635545556806, 3498.3003399320237, 3503.5095086687375, 3503.632118627507, 6660.533762636569, 6722.563033402813, 6726.697298621574, 6734.595924244561, 6734.831629209211, 6606.0, 6606.273309935903, 6611.86776264472, 6613.702383392759, 6648.235452922976, 6533.771318003942, 6649.73401063952, 6699.799006029827, 6718.462522998246, 6720.495962802712, 6189.721462534107, 6255.499560035095, 6455.419012288917, 6466.256380516301, 6492.220933488012, 6342.334054924351, 6366.5225108118, 6370.076338930737, 6382.436303105769, 6395.744170233139, 6699.732010719516, 6704.497162712719, 6706.228783689938, 6712.731490740316, 6713.899291510534, 4235.301175306163, 4353.064091220403, 4382.05785756064, 4382.23310920594, 4384.4519435070615, 6416.7754128605275, 6422.550421470452, 6429.7106630200815, 6430.614163150226, 6446.065320528591, 6230.439260466398, 6231.158793562811, 6232.501399888089, 6234.407731265523, 6236.469900058546, 6075.088736689532, 6235.906461402992, 6243.406876346739, 6247.687615619292, 6248.218972628421, 6165.383461653978, 6165.969170154121, 6170.6914654268, 6171.259448866164, 6172.567920245539, 6291.213598300213, 6305.747770089145, 6317.5893566918, 6328.114064031131, 6348.111264422892, 6082.817515474543, 6144.324124346229, 6197.070439433941, 6198.876022479615, 6201.131841542278], "unit": "score", "name": "prototype.html", "value": 4713.847672526516}, {"lowerIsBetter": false, "replicates": [582.5310624946916, 641.7785863876962, 650.3528988656287, 715.7101373943555, 723.9312265334793, 13974.650633734149, 14110.223937683424, 14112.506062287835, 14121.57635270941, 14129.434822607083, 13171.0, 13215.801762973539, 13235.536756213534, 13700.383482743275, 14787.92606036971, 813.5159580049875, 826.4132465949183, 827.1934863508092, 827.5076329583887, 829.9792505187388, 824.044108833753, 827.3753316246226, 827.5034979012604, 827.8758186272047, 828.3456069704926, 871.9084496127911, 871.9520426376547, 872.5419154943673, 873.0832625742976, 873.9344549158807, 867.0332579174238, 869.1395518436765, 870.9433886797369, 871.834351473218, 871.9825603487958, 636.5098873867142, 639.6130341143635, 640.078287266335, 640.5868215001298, 642.0241233325366, 13689.86310136896, 13717.0, 13763.793543096861, 13766.793498097437, 13790.0, 12416.875831241663, 12732.23606583608, 12944.093913426064, 13281.136726112773, 13473.124246923919, 9688.660896868647, 9725.902740972571, 9730.41617502952, 9790.75523111928, 10231.386116833013, 3484.303139372136, 3558.982205088984, 3580.445031020196, 3586.5696116466193, 3605.0987253186704, 44040.77979610114, 45046.0, 47696.28455573169, 48021.0, 49609.75195124001, 8901.154390332907, 9399.859002114974, 9463.952680236554, 9816.263780216512, 10678.1991350649, 15716.21418929049, 17872.106394680213, 18091.0, 18117.637647246982, 18128.184231709605, 7452.776416707507, 7691.961540192263, 7704.0, 7859.410544209093, 8283.668653253802, 4211.936820947688, 4248.745075295492, 4317.07182955666, 4328.091100868853, 4573.679842410999, 3157.5737275467977, 3188.713015828587, 3194.121616555419, 3196.2488815128427, 3198.040587823644, 575.0942265931175, 587.4771453406472, 589.2869627750384, 594.5332913662841, 611.0467670434138, 580.2978396140633, 580.988380232393, 583.7869177750175, 633.4926994434564, 658.2397331082607, 7525.774226773206, 7629.0, 7642.235776422424, 7771.4559980800805, 7808.726694565777, 488.2505354281232, 594.7620951619386, 607.4745345276392, 635.6535688049931, 639.766485232896, 3679.1354031802507, 3813.4089216171537, 3890.922181556353, 3946.861859834892, 4014.558398576154, 58008.0, 58140.41859581435, 58367.70816145892, 58374.41625583775, 58489.41510584925, 51331.0, 51485.48514514882, 52027.47972520226, 52259.47740522622, 52703.73648131735, 46922.53077469182, 47369.0, 47489.5251047492, 47572.0, 48047.519524805, 7905.32804711583, 8022.518648881086, 8042.316403105568, 8085.514869107872, 8205.220504052106, 29508.0, 32700.672993270713, 34344.65655343414, 34856.302873942885, 37295.813520933305, 43424.78287608542, 43875.341869871336, 44075.77962110169, 44665.55334446614, 45170.54829451664, 10346.068853802893, 10535.42055186972, 10561.735956601147, 10622.309549879234, 10752.193585480964, 10839.403832789272, 11096.944515277371, 11183.32900026001, 11508.94245528767, 11531.250468719507, 10204.540795664065, 10313.329633574094, 10327.277090603586, 10354.637587684696, 10364.637237696645, 10626.36241825493, 10657.307275027099, 11069.531808166597, 11141.944290278496, 11149.275297105662, 9781.266405019509, 9944.45305508204, 10078.596856125967, 10106.292559521056, 10355.068043876086, 8042.919570804217, 8273.627686753991, 8655.6970506032, 8679.166417865827, 8946.463212207029, 8218.753437396888, 8352.874706879524, 9076.909230907606, 9199.494027828534, 9279.67521136757], "unit": "score", "name": "yui.html", "value": 6150.841582900499}], "name": "dromaeo_css", "value": 6864.3883432339435}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 105.0, 111.0, 112.0, 111.0, 102.0, 110.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.4}, {"lowerIsBetter": true, "replicates": [159.0, 133.0, 154.0, 172.0, 126.0, 167.0, 150.0, 129.0, 168.0, 136.0], "unit": "score", "name": "audio-beat-detection", "value": 149.4}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 163.0, 162.0, 160.0, 163.0, 163.0, 162.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 133.0, 91.0, 73.0, 73.0, 76.0, 114.0, 98.0, 73.0], "unit": "score", "name": "audio-fft", "value": 87.7}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 139.0, 95.0, 96.0, 96.0, 149.0, 96.0, 96.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 110.3}, {"lowerIsBetter": true, "replicates": [118.0, 116.0, 115.0, 116.0, 115.0, 115.0, 115.0, 114.0, 114.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.3}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 147.0, 146.0, 146.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 97.0, 96.0, 97.0, 97.0, 96.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 58.0, 56.0, 55.0, 56.0, 56.0, 65.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.3}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 67.0, 69.0, 67.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [84.0, 82.0, 91.0, 84.0, 83.0, 90.0, 84.0, 83.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.9}, {"lowerIsBetter": true, "replicates": [122.0, 119.0, 117.0, 116.0, 117.0, 122.0, 124.0, 119.0, 132.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.5}, {"lowerIsBetter": true, "replicates": [156.0, 142.0, 161.0, 149.0, 149.0, 140.0, 152.0, 154.0, 149.0, 162.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.4}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 70.0, 71.0, 67.0, 67.0, 70.0, 69.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.5}], "name": "kraken", "value": 1525.3000000000002}]} 23:02:01 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1525.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6864.39"}}} 23:02:01 INFO - Return code: 0 23:02:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:02:01 INFO - # TBPL SUCCESS # 23:02:01 INFO - Running post-action listener: _resource_record_post_action 23:02:01 INFO - Running post-run listener: _resource_record_post_run 23:02:02 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 16384; Write bytes: 550346752; Read time: 416; Write time: 670028 23:02:02 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 4096; Write bytes: 250789888; Read time: 160; Write time: 327888 23:02:02 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 12288; Write bytes: 295665664; Read time: 256; Write time: 341268 23:02:02 INFO - Running post-run listener: _upload_blobber_files 23:02:02 INFO - Blob upload gear active. 23:02:02 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:02:02 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:02:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 23:02:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 23:02:03 INFO - Traceback (most recent call last): 23:02:03 INFO - File "/builds/slave/test-pgo/build/venv/bin/blobberc.py", line 253, in 23:02:03 INFO - main() 23:02:03 INFO - File "/builds/slave/test-pgo/build/venv/bin/blobberc.py", line 235, in main 23:02:03 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 23:02:03 INFO - File "/builds/slave/test-pgo/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 23:02:03 INFO - return set(response.json().get('whitelist', [])) 23:02:03 INFO - File "/builds/slave/test-pgo/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 23:02:03 INFO - return json.loads(self.text or self.content, **kwargs) 23:02:03 INFO - File "/usr/lib/python2.7/json/__init__.py", line 326, in loads 23:02:03 INFO - return _default_decoder.decode(s) 23:02:03 INFO - File "/usr/lib/python2.7/json/decoder.py", line 366, in decode 23:02:03 INFO - obj, end = self.raw_decode(s, idx=_w(s, 0).end()) 23:02:03 INFO - File "/usr/lib/python2.7/json/decoder.py", line 384, in raw_decode 23:02:03 INFO - raise ValueError("No JSON object could be decoded") 23:02:03 INFO - ValueError: No JSON object could be decoded 23:02:03 ERROR - Return code: 1 23:02:03 INFO - Setting buildbot property blobber_files to {} 23:02:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:02:03 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:02:03 INFO - Contents: 23:02:03 INFO - blobber_files:{} 23:02:03 INFO - Running post-run listener: copy_logs_to_upload_dir 23:02:03 INFO - Copying logs to upload dir... 23:02:03 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 23:02:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.253460 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-02-12 23:02:02.524000) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-12 23:02:02.527972) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/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-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1455338373.179070-87280582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011282 build_url: 'https://queue.taskcluster.net/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-12 23:02:02.580552) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 23:02:02.580969) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1455338373.179070-87280582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004603 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 23:02:02.631937) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-12 23:02:02.632343) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-12 23:02:02.632823) ========= ========= Total master_lag: 0.27 =========