builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1451609330.39 results: success (0) buildid: 20151231143004 builduid: 0a00839bea154d759fcb6e301a558c4a revision: 6053ffd738ce52d994327446441db583954e8399 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-31 16:48:50.393276) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-31 16:48:50.393863) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-31 16:48:50.394172) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1451593341.309537-888449318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006117 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-31 16:48:50.432286) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-31 16:48:50.432619) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-31 16:48:50.458393) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 16:48:50.458811) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1451593341.309537-888449318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.050728 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 16:48:50.519478) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-31 16:48:50.519792) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-31 16:48:50.520189) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 16:48:50.520497) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1451593341.309537-888449318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-31 16:48:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 28.3M=0s 2015-12-31 16:48:51 (28.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.480454 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 16:48:51.013589) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 16:48:51.013924) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1451593341.309537-888449318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.140123 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 16:48:51.164531) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-31 16:48:51.164998) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6053ffd738ce52d994327446441db583954e8399 --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 6053ffd738ce52d994327446441db583954e8399 --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=d16fe3a243cfe9e60ec7df77000001e0-1451593341.309537-888449318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-31 16:48:51,475 truncating revision to first 12 chars 2015-12-31 16:48:51,475 Setting DEBUG logging. 2015-12-31 16:48:51,475 attempt 1/10 2015-12-31 16:48:51,475 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6053ffd738ce?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-31 16:48:52,603 unpacking tar archive at: fx-team-6053ffd738ce/testing/mozharness/ program finished with exit code 0 elapsedTime=1.407503 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-31 16:48:52.584497) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-31 16:48:52.584809) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-31 16:48:52.608915) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-31 16:48:52.609175) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-31 16:48:52.609626) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-31 16:48:52.609921) ========= /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=d16fe3a243cfe9e60ec7df77000001e0-1451593341.309537-888449318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:48:53 INFO - MultiFileLogger online at 20151231 16:48:53 in /builds/slave/test-pgo 16:48:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:48:53 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:48:53 INFO - {'append_to_log': False, 16:48:53 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:48:53 INFO - 'blob_upload_branch': 'Fx-Team', 16:48:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:48:53 INFO - 'branch': 'Fx-Team', 16:48:53 INFO - 'buildbot_json_path': 'buildprops.json', 16:48:53 INFO - 'config_files': ('talos/linux_config.py',), 16:48:53 INFO - 'default_actions': ('clobber', 16:48:53 INFO - 'read-buildbot-config', 16:48:53 INFO - 'download-and-extract', 16:48:53 INFO - 'populate-webroot', 16:48:53 INFO - 'create-virtualenv', 16:48:53 INFO - 'install', 16:48:53 INFO - 'run-tests'), 16:48:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:48:53 INFO - 'download_minidump_stackwalk': True, 16:48:53 INFO - 'download_symbols': 'ondemand', 16:48:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:48:53 INFO - 'tooltool.py': '/tools/tooltool.py', 16:48:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:48:53 INFO - '/tools/misc-python/virtualenv.py')}, 16:48:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:48:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:48:53 INFO - 'installer_path': 'installer.exe', 16:48:53 INFO - 'log_level': 'info', 16:48:53 INFO - 'log_name': 'talos', 16:48:53 INFO - 'log_to_console': True, 16:48:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:48:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:48:53 INFO - 'opt_config_files': (), 16:48:53 INFO - 'pip_index': False, 16:48:53 INFO - 'sps_profile': False, 16:48:53 INFO - 'sps_profile_interval': 0, 16:48:53 INFO - 'suite': 'dromaeojs', 16:48:53 INFO - 'system_bits': '32', 16:48:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:48:53 INFO - 'title': 'talos-linux64-ix-034', 16:48:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:48:53 INFO - 'use_talos_json': True, 16:48:53 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:48:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:48:53 INFO - 'work_dir': 'build'} 16:48:53 INFO - ##### 16:48:53 INFO - ##### Running clobber step. 16:48:53 INFO - ##### 16:48:53 INFO - Running pre-action listener: _resource_record_pre_action 16:48:53 INFO - Running main action method: clobber 16:48:53 INFO - rmtree: /builds/slave/test-pgo/build 16:48:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:48:54 INFO - Running post-action listener: _resource_record_post_action 16:48:54 INFO - ##### 16:48:54 INFO - ##### Running read-buildbot-config step. 16:48:54 INFO - ##### 16:48:54 INFO - Running pre-action listener: _resource_record_pre_action 16:48:54 INFO - Running main action method: read_buildbot_config 16:48:54 INFO - Using buildbot properties: 16:48:54 INFO - { 16:48:54 INFO - "project": "", 16:48:54 INFO - "product": "firefox", 16:48:54 INFO - "script_repo_revision": "production", 16:48:54 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:48:54 INFO - "repository": "", 16:48:54 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 16:48:54 INFO - "buildid": "20151231143004", 16:48:54 INFO - "pgo_build": "True", 16:48:54 INFO - "basedir": "/builds/slave/test-pgo", 16:48:54 INFO - "buildnumber": 565, 16:48:54 INFO - "slavename": "talos-linux64-ix-034", 16:48:54 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:48:54 INFO - "platform": "ubuntu64_hw", 16:48:54 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 16:48:54 INFO - "branch": "fx-team", 16:48:54 INFO - "repo_path": "integration/fx-team", 16:48:54 INFO - "revision": "6053ffd738ce52d994327446441db583954e8399", 16:48:54 INFO - "stage_platform": "linux64-pgo", 16:48:54 INFO - "builduid": "0a00839bea154d759fcb6e301a558c4a", 16:48:54 INFO - "slavebuilddir": "test" 16:48:54 INFO - } 16:48:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/fLLi6ttNQXq0xgKsOuNzcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 16:48:54 INFO - Running post-action listener: _resource_record_post_action 16:48:54 INFO - ##### 16:48:54 INFO - ##### Running download-and-extract step. 16:48:54 INFO - ##### 16:48:54 INFO - Running pre-action listener: _resource_record_pre_action 16:48:54 INFO - Running main action method: download_and_extract 16:48:54 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:48:54 INFO - https://queue.taskcluster.net/v1/task/fLLi6ttNQXq0xgKsOuNzcg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:48:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fLLi6ttNQXq0xgKsOuNzcg/artifacts/public/build/test_packages.json 16:48:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fLLi6ttNQXq0xgKsOuNzcg/artifacts/public/build/test_packages.json 16:48:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fLLi6ttNQXq0xgKsOuNzcg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:48:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fLLi6ttNQXq0xgKsOuNzcg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:48:55 INFO - Downloaded 1302 bytes. 16:48:55 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:48:55 INFO - Using the following test package requirements: 16:48:55 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:48:55 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:48:55 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:55 INFO - u'jsshell-linux-x86_64.zip'], 16:48:55 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:48:55 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:48:55 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:48:55 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:48:55 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:48:55 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:48:55 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:48:55 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:48: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')]} 16:48:55 INFO - https://queue.taskcluster.net/v1/task/fLLi6ttNQXq0xgKsOuNzcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:48:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fLLi6ttNQXq0xgKsOuNzcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:48:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fLLi6ttNQXq0xgKsOuNzcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:48:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fLLi6ttNQXq0xgKsOuNzcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:48:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fLLi6ttNQXq0xgKsOuNzcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:48:57 INFO - Downloaded 23195441 bytes. 16:48:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 16:48:57 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:48:57 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:48:58 INFO - Return code: 0 16:48:58 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:48:58 INFO - https://queue.taskcluster.net/v1/task/fLLi6ttNQXq0xgKsOuNzcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:48:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fLLi6ttNQXq0xgKsOuNzcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:48:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fLLi6ttNQXq0xgKsOuNzcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:48:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fLLi6ttNQXq0xgKsOuNzcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:48:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fLLi6ttNQXq0xgKsOuNzcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:49:02 INFO - Downloaded 23195441 bytes. 16:49:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 16:49:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:49:02 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:49:03 INFO - Return code: 0 16:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:03 INFO - https://queue.taskcluster.net/v1/task/fLLi6ttNQXq0xgKsOuNzcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:49:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fLLi6ttNQXq0xgKsOuNzcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:49:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fLLi6ttNQXq0xgKsOuNzcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:49:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fLLi6ttNQXq0xgKsOuNzcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:49:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fLLi6ttNQXq0xgKsOuNzcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:49:05 INFO - Downloaded 11132285 bytes. 16:49:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 16:49:05 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:49:05 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 16:49:05 INFO - Return code: 0 16:49: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')]} 16:49:05 INFO - https://queue.taskcluster.net/v1/task/fLLi6ttNQXq0xgKsOuNzcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:49:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fLLi6ttNQXq0xgKsOuNzcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:49:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fLLi6ttNQXq0xgKsOuNzcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:49:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fLLi6ttNQXq0xgKsOuNzcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:49:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fLLi6ttNQXq0xgKsOuNzcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:49:07 INFO - Downloaded 54938938 bytes. 16:49:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fLLi6ttNQXq0xgKsOuNzcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:49:07 INFO - mkdir: /builds/slave/test-pgo/properties 16:49:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:49:07 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:49:07 INFO - Contents: 16:49:07 INFO - build_url:https://queue.taskcluster.net/v1/task/fLLi6ttNQXq0xgKsOuNzcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:49:07 INFO - Running post-action listener: _resource_record_post_action 16:49:07 INFO - Running post-action listener: set_extra_try_arguments 16:49:07 INFO - ##### 16:49:07 INFO - ##### Running populate-webroot step. 16:49:07 INFO - ##### 16:49:07 INFO - Running pre-action listener: _resource_record_pre_action 16:49:07 INFO - Running main action method: populate_webroot 16:49:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:49:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:49:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:49:07 INFO - '--tppagecycles', 16:49:07 INFO - '7'], 16:49:07 INFO - 'tests': ['tsvgm']}}, 16:49:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:49:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:49:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:49:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:49:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:49:07 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:49:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:49:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:07 INFO - 'talos_options': ['--e10s'], 16:49:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:49:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:07 INFO - 'tests': ['damp', 'tps']}, 16:49:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:07 INFO - 'talos_options': ['--e10s'], 16:49:07 INFO - 'tests': ['damp', 'tps']}, 16:49:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:49:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:49:07 INFO - 'other': {'tests': ['a11yr', 16:49:07 INFO - 'ts_paint', 16:49:07 INFO - 'tpaint', 16:49:07 INFO - 'sessionrestore', 16:49:07 INFO - 'sessionrestore_no_auto_restore']}, 16:49:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:49:07 INFO - 'tests': ['a11yr', 16:49:07 INFO - 'ts_paint', 16:49:07 INFO - 'tpaint', 16:49:07 INFO - 'sessionrestore', 16:49:07 INFO - 'sessionrestore_no_auto_restore']}, 16:49:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:49:07 INFO - 'tests': ['a11yr', 16:49:07 INFO - 'ts_paint', 16:49:07 INFO - 'tpaint', 16:49:07 INFO - 'sessionrestore', 16:49:07 INFO - 'sessionrestore_no_auto_restore']}, 16:49:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:49:07 INFO - 'tests': ['a11yr', 16:49:07 INFO - 'ts_paint', 16:49:07 INFO - 'tpaint', 16:49:07 INFO - 'sessionrestore', 16:49:07 INFO - 'sessionrestore_no_auto_restore']}, 16:49:07 INFO - 'other_l64': {'tests': ['a11yr', 16:49:07 INFO - 'ts_paint', 16:49:07 INFO - 'tpaint', 16:49:07 INFO - 'sessionrestore', 16:49:07 INFO - 'sessionrestore_no_auto_restore']}, 16:49:07 INFO - 'other_nol64': {'tests': ['a11yr', 16:49:07 INFO - 'ts_paint', 16:49:07 INFO - 'tpaint', 16:49:07 INFO - 'sessionrestore', 16:49:07 INFO - 'sessionrestore_no_auto_restore']}, 16:49:07 INFO - 'svgr': {'tests': ['tsvgx', 16:49:07 INFO - 'tsvgr_opacity', 16:49:07 INFO - 'tart', 16:49:07 INFO - 'tscrollx', 16:49:07 INFO - 'cart']}, 16:49:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:49:07 INFO - 'tests': ['tsvgx', 16:49:07 INFO - 'tsvgr_opacity', 16:49:07 INFO - 'tart', 16:49:07 INFO - 'tscrollx', 16:49:07 INFO - 'cart']}, 16:49:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:07 INFO - 'tests': ['tp5o']}, 16:49:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:07 INFO - 'talos_options': ['--e10s'], 16:49:07 INFO - 'tests': ['tp5o']}, 16:49:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:07 INFO - 'talos_options': ['--xperf_path', 16:49:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:49:07 INFO - 'tests': ['tp5n']}, 16:49:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:49:07 INFO - 'talos_options': ['--e10s', 16:49:07 INFO - '--xperf_path', 16:49:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:49:07 INFO - 'tests': ['tp5n']}}, 16:49:07 INFO - 'talos.zip': {'path': '', 16:49:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:49:07 INFO - Running post-action listener: _resource_record_post_action 16:49:07 INFO - ##### 16:49:07 INFO - ##### Running create-virtualenv step. 16:49:07 INFO - ##### 16:49:07 INFO - Running pre-action listener: _resource_record_pre_action 16:49:07 INFO - Running main action method: create_virtualenv 16:49:07 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:49:07 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 16:49:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:49:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:49:07 INFO - Using real prefix '/usr' 16:49:07 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:49:08 INFO - Installing distribute.............................................................................................................................................................................................done. 16:49:10 INFO - Installing pip.................done. 16:49:10 INFO - Return code: 0 16:49:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fe99dca6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16936c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1690e40>, '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 0x1691740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1691bf0>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1451593341.309537-888449318', '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 16:49:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 16:49:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 16:49:10 INFO - Using env: {'DISPLAY': ':0', 16:49:10 INFO - 'HOME': '/home/cltbld', 16:49:10 INFO - 'LANG': 'en_US.UTF-8', 16:49:10 INFO - 'LANGUAGE': 'en_US:en', 16:49:10 INFO - 'LOGNAME': 'cltbld', 16:49:10 INFO - 'MAIL': '/var/mail/cltbld', 16:49:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:10 INFO - 'MOZ_NO_REMOTE': '1', 16:49:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:10 INFO - 'NO_EM_RESTART': '1', 16:49:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:49:10 INFO - 'PWD': '/builds/slave/test-pgo', 16:49:10 INFO - 'SHELL': '/bin/bash', 16:49:10 INFO - 'SHLVL': '1', 16:49:10 INFO - 'TERM': 'linux', 16:49:10 INFO - 'TMOUT': '86400', 16:49:10 INFO - 'USER': 'cltbld', 16:49:10 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1451593341.309537-888449318', 16:49:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:10 INFO - '_': '/tools/buildbot/bin/python'} 16:49:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:10 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 16:49:10 INFO - Cleaning up... 16:49:10 INFO - Return code: 0 16:49:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fe99dca6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16936c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1690e40>, '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 0x1691740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1691bf0>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1451593341.309537-888449318', '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 16:49:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 16:49:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 16:49:10 INFO - Using env: {'DISPLAY': ':0', 16:49:10 INFO - 'HOME': '/home/cltbld', 16:49:10 INFO - 'LANG': 'en_US.UTF-8', 16:49:10 INFO - 'LANGUAGE': 'en_US:en', 16:49:10 INFO - 'LOGNAME': 'cltbld', 16:49:10 INFO - 'MAIL': '/var/mail/cltbld', 16:49:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:10 INFO - 'MOZ_NO_REMOTE': '1', 16:49:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:10 INFO - 'NO_EM_RESTART': '1', 16:49:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:49:10 INFO - 'PWD': '/builds/slave/test-pgo', 16:49:10 INFO - 'SHELL': '/bin/bash', 16:49:10 INFO - 'SHLVL': '1', 16:49:10 INFO - 'TERM': 'linux', 16:49:10 INFO - 'TMOUT': '86400', 16:49:10 INFO - 'USER': 'cltbld', 16:49:10 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1451593341.309537-888449318', 16:49:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:10 INFO - '_': '/tools/buildbot/bin/python'} 16:49:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:10 INFO - Downloading/unpacking psutil>=0.7.1 16:49:10 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 16:49:10 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 16:49:10 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 16:49:10 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 16:49:10 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 16:49:10 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 16:49:12 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 16:49:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:49:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:49:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:49:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:49:12 INFO - Installing collected packages: psutil 16:49:12 INFO - Running setup.py install for psutil 16:49:12 INFO - building 'psutil._psutil_linux' extension 16:49:12 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 16:49:13 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 16:49:13 INFO - building 'psutil._psutil_posix' extension 16:49:13 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 16:49:13 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 16:49:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:49:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:49:13 INFO - Successfully installed psutil 16:49:13 INFO - Cleaning up... 16:49:13 INFO - Return code: 0 16:49:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:49:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fe99dca6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16936c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1690e40>, '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 0x1691740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1691bf0>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1451593341.309537-888449318', '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 16:49:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 16:49:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 16:49:13 INFO - Using env: {'DISPLAY': ':0', 16:49:13 INFO - 'HOME': '/home/cltbld', 16:49:13 INFO - 'LANG': 'en_US.UTF-8', 16:49:13 INFO - 'LANGUAGE': 'en_US:en', 16:49:13 INFO - 'LOGNAME': 'cltbld', 16:49:13 INFO - 'MAIL': '/var/mail/cltbld', 16:49:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:13 INFO - 'MOZ_NO_REMOTE': '1', 16:49:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:13 INFO - 'NO_EM_RESTART': '1', 16:49:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:49:13 INFO - 'PWD': '/builds/slave/test-pgo', 16:49:13 INFO - 'SHELL': '/bin/bash', 16:49:13 INFO - 'SHLVL': '1', 16:49:13 INFO - 'TERM': 'linux', 16:49:13 INFO - 'TMOUT': '86400', 16:49:13 INFO - 'USER': 'cltbld', 16:49:13 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1451593341.309537-888449318', 16:49:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:13 INFO - '_': '/tools/buildbot/bin/python'} 16:49:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:49:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:49:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:49:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:49:15 INFO - Installing collected packages: mozsystemmonitor 16:49:15 INFO - Running setup.py install for mozsystemmonitor 16:49:15 INFO - Successfully installed mozsystemmonitor 16:49:15 INFO - Cleaning up... 16:49:15 INFO - Return code: 0 16:49:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:49:15 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')]} 16:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:15 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')]} 16:49:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fe99dca6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16936c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1690e40>, '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 0x1691740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1691bf0>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1451593341.309537-888449318', '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 16:49:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 16:49:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 16:49:15 INFO - Using env: {'DISPLAY': ':0', 16:49:15 INFO - 'HOME': '/home/cltbld', 16:49:15 INFO - 'LANG': 'en_US.UTF-8', 16:49:15 INFO - 'LANGUAGE': 'en_US:en', 16:49:15 INFO - 'LOGNAME': 'cltbld', 16:49:15 INFO - 'MAIL': '/var/mail/cltbld', 16:49:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:15 INFO - 'MOZ_NO_REMOTE': '1', 16:49:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:15 INFO - 'NO_EM_RESTART': '1', 16:49:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:49:15 INFO - 'PWD': '/builds/slave/test-pgo', 16:49:15 INFO - 'SHELL': '/bin/bash', 16:49:15 INFO - 'SHLVL': '1', 16:49:15 INFO - 'TERM': 'linux', 16:49:15 INFO - 'TMOUT': '86400', 16:49:15 INFO - 'USER': 'cltbld', 16:49:15 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1451593341.309537-888449318', 16:49:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:15 INFO - '_': '/tools/buildbot/bin/python'} 16:49:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:15 INFO - Downloading/unpacking blobuploader==1.2.4 16:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:17 INFO - Downloading blobuploader-1.2.4.tar.gz 16:49:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:49:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:49:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:49:17 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 16:49:17 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 16:49:17 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 16:49:17 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 16:49:17 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 16:49:17 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 16:49:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:49:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:49:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:49:17 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 16:49:17 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 16:49:17 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 16:49:17 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 16:49:17 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 16:49:17 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 16:49:18 INFO - Downloading docopt-0.6.1.tar.gz 16:49:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:49:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:49:18 INFO - Installing collected packages: blobuploader, requests, docopt 16:49:18 INFO - Running setup.py install for blobuploader 16:49:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:49:18 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:49:18 INFO - Running setup.py install for requests 16:49:18 INFO - Running setup.py install for docopt 16:49:18 INFO - Successfully installed blobuploader requests docopt 16:49:18 INFO - Cleaning up... 16:49:18 INFO - Return code: 0 16:49:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:49:18 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')]} 16:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:18 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')]} 16:49:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fe99dca6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16936c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1690e40>, '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 0x1691740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1691bf0>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1451593341.309537-888449318', '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 16:49:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 16:49:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --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 16:49:18 INFO - Using env: {'DISPLAY': ':0', 16:49:18 INFO - 'HOME': '/home/cltbld', 16:49:18 INFO - 'LANG': 'en_US.UTF-8', 16:49:18 INFO - 'LANGUAGE': 'en_US:en', 16:49:18 INFO - 'LOGNAME': 'cltbld', 16:49:18 INFO - 'MAIL': '/var/mail/cltbld', 16:49:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:18 INFO - 'MOZ_NO_REMOTE': '1', 16:49:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:18 INFO - 'NO_EM_RESTART': '1', 16:49:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:49:18 INFO - 'PWD': '/builds/slave/test-pgo', 16:49:18 INFO - 'SHELL': '/bin/bash', 16:49:18 INFO - 'SHLVL': '1', 16:49:18 INFO - 'TERM': 'linux', 16:49:18 INFO - 'TMOUT': '86400', 16:49:18 INFO - 'USER': 'cltbld', 16:49:18 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1451593341.309537-888449318', 16:49:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:18 INFO - '_': '/tools/buildbot/bin/python'} 16:49:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:49:19 INFO - Running setup.py (path:/tmp/pip-jBXJ1G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:49:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:49:19 INFO - Running setup.py (path:/tmp/pip-xi_jfo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:49:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:49:19 INFO - Running setup.py (path:/tmp/pip-lySU4_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:49:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:49:19 INFO - Running setup.py (path:/tmp/pip-BFcV8k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:49:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:49:19 INFO - Running setup.py (path:/tmp/pip-Mw5VkQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:49:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:49:19 INFO - Running setup.py (path:/tmp/pip-gTwuoU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:49:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:49:19 INFO - Running setup.py (path:/tmp/pip-zZc0Yx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:49:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:49:19 INFO - Running setup.py (path:/tmp/pip-q31esB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:49:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:49:19 INFO - Running setup.py (path:/tmp/pip-gS6ao7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:49:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:49:19 INFO - Running setup.py (path:/tmp/pip-EJUfE1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:49:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:49:19 INFO - Running setup.py (path:/tmp/pip-tG_nui-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:49:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:49:19 INFO - Running setup.py (path:/tmp/pip-0WYZVv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:49:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:49:19 INFO - Running setup.py (path:/tmp/pip-Af4AFT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:49:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:49:19 INFO - Running setup.py (path:/tmp/pip-g_d_PG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:49:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:49:20 INFO - Running setup.py (path:/tmp/pip-oydCv4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:49:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:49:20 INFO - Running setup.py (path:/tmp/pip-Cn6hMP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:49:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:49:20 INFO - Running setup.py (path:/tmp/pip-7yYmRo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:49:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:49:20 INFO - Running setup.py install for manifestparser 16:49:20 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:49:20 INFO - Running setup.py install for mozcrash 16:49:20 INFO - Running setup.py install for mozdebug 16:49:20 INFO - Running setup.py install for mozdevice 16:49:20 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:49:20 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:49:20 INFO - Running setup.py install for mozfile 16:49:20 INFO - Running setup.py install for mozhttpd 16:49:20 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:49:20 INFO - Running setup.py install for mozinfo 16:49:20 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:49:20 INFO - Running setup.py install for mozInstall 16:49:21 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:49:21 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:49:21 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:49:21 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:49:21 INFO - Running setup.py install for mozleak 16:49:21 INFO - Running setup.py install for mozlog 16:49:21 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:49:21 INFO - Running setup.py install for moznetwork 16:49:21 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:49:21 INFO - Running setup.py install for mozprocess 16:49:21 INFO - Running setup.py install for mozprofile 16:49:21 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:49:21 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:49:21 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:49:21 INFO - Running setup.py install for mozrunner 16:49:21 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:49:21 INFO - Running setup.py install for mozscreenshot 16:49:21 INFO - Running setup.py install for moztest 16:49:21 INFO - Running setup.py install for mozversion 16:49:21 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:49:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:49:22 INFO - Cleaning up... 16:49:22 INFO - Return code: 0 16:49:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:49:22 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')]} 16:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:22 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')]} 16:49:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:22 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fe99dca6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16936c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1690e40>, '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 0x1691740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1691bf0>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1451593341.309537-888449318', '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 16:49:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 16:49:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 16:49:22 INFO - Using env: {'DISPLAY': ':0', 16:49:22 INFO - 'HOME': '/home/cltbld', 16:49:22 INFO - 'LANG': 'en_US.UTF-8', 16:49:22 INFO - 'LANGUAGE': 'en_US:en', 16:49:22 INFO - 'LOGNAME': 'cltbld', 16:49:22 INFO - 'MAIL': '/var/mail/cltbld', 16:49:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:22 INFO - 'MOZ_NO_REMOTE': '1', 16:49:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:22 INFO - 'NO_EM_RESTART': '1', 16:49:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:49:22 INFO - 'PWD': '/builds/slave/test-pgo', 16:49:22 INFO - 'SHELL': '/bin/bash', 16:49:22 INFO - 'SHLVL': '1', 16:49:22 INFO - 'TERM': 'linux', 16:49:22 INFO - 'TMOUT': '86400', 16:49:22 INFO - 'USER': 'cltbld', 16:49:22 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1451593341.309537-888449318', 16:49:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:22 INFO - '_': '/tools/buildbot/bin/python'} 16:49:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:49:22 INFO - Running setup.py (path:/tmp/pip-d_jHgZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:49:22 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)) 16:49:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:49:22 INFO - Running setup.py (path:/tmp/pip-zFq65p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:49:22 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)) 16:49:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:49:22 INFO - Running setup.py (path:/tmp/pip-d1H2Ah-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:49:22 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)) 16:49:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:49:22 INFO - Running setup.py (path:/tmp/pip-JhTQJL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:49:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 16:49:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:49:22 INFO - Running setup.py (path:/tmp/pip-3aOAWN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:49:22 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)) 16:49:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:49:22 INFO - Running setup.py (path:/tmp/pip-imICCM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:49:22 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)) 16:49:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:49:22 INFO - Running setup.py (path:/tmp/pip-3RF9OI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:49:22 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)) 16:49:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:49:22 INFO - Running setup.py (path:/tmp/pip-PqN8NY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:49:22 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)) 16:49:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:49:22 INFO - Running setup.py (path:/tmp/pip-vuxIcX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:49:22 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)) 16:49:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:49:22 INFO - Running setup.py (path:/tmp/pip-B3YSMf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:49:22 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)) 16:49:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:49:22 INFO - Running setup.py (path:/tmp/pip-nFkCQ8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:49:23 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)) 16:49:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:49:23 INFO - Running setup.py (path:/tmp/pip-7pKwt9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:49:23 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)) 16:49:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:49:23 INFO - Running setup.py (path:/tmp/pip-9kGbYr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:49:23 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)) 16:49:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:49:23 INFO - Running setup.py (path:/tmp/pip-fkeHnV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:49:23 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)) 16:49:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:49:23 INFO - Running setup.py (path:/tmp/pip-MQ7tcO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:49:23 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)) 16:49:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:49:23 INFO - Running setup.py (path:/tmp/pip-bos7Kf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:49:23 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)) 16:49:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:49:23 INFO - Running setup.py (path:/tmp/pip-nnRYf4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:49:23 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)) 16:49:23 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)) 16:49:23 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)) 16:49:23 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)) 16:49:23 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:49:23 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:49:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:49:23 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 16:49:23 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 16:49:23 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 16:49:23 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 16:49:23 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 16:49:23 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 16:49:25 INFO - Downloading blessings-1.5.1.tar.gz 16:49:25 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 16:49:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:49:25 INFO - Installing collected packages: blessings 16:49:25 INFO - Running setup.py install for blessings 16:49:25 INFO - Successfully installed blessings 16:49:25 INFO - Cleaning up... 16:49:25 INFO - Return code: 0 16:49:25 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:49:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:49:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:49:25 INFO - Reading from file tmpfile_stdout 16:49:25 INFO - Current package versions: 16:49:25 INFO - argparse == 1.2.1 16:49:25 INFO - blessings == 1.5.1 16:49:25 INFO - blobuploader == 1.2.4 16:49:25 INFO - docopt == 0.6.1 16:49:25 INFO - manifestparser == 1.1 16:49:25 INFO - mozInstall == 1.12 16:49:25 INFO - mozcrash == 0.16 16:49:25 INFO - mozdebug == 0.1 16:49:25 INFO - mozdevice == 0.47 16:49:25 INFO - mozfile == 1.2 16:49:25 INFO - mozhttpd == 0.7 16:49:25 INFO - mozinfo == 0.9 16:49:25 INFO - mozleak == 0.1 16:49:25 INFO - mozlog == 3.1 16:49:25 INFO - moznetwork == 0.27 16:49:25 INFO - mozprocess == 0.22 16:49:25 INFO - mozprofile == 0.28 16:49:25 INFO - mozrunner == 6.11 16:49:25 INFO - mozscreenshot == 0.1 16:49:25 INFO - mozsystemmonitor == 0.0 16:49:25 INFO - moztest == 0.7 16:49:25 INFO - mozversion == 1.4 16:49:25 INFO - psutil == 3.1.1 16:49:25 INFO - requests == 1.2.3 16:49:25 INFO - wsgiref == 0.1.2 16:49:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fe99dca6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16936c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1690e40>, '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 0x1691740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1691bf0>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1451593341.309537-888449318', '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 16:49:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 16:49:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 16:49:25 INFO - Using env: {'DISPLAY': ':0', 16:49:25 INFO - 'HOME': '/home/cltbld', 16:49:25 INFO - 'LANG': 'en_US.UTF-8', 16:49:25 INFO - 'LANGUAGE': 'en_US:en', 16:49:25 INFO - 'LOGNAME': 'cltbld', 16:49:25 INFO - 'MAIL': '/var/mail/cltbld', 16:49:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:25 INFO - 'MOZ_NO_REMOTE': '1', 16:49:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:25 INFO - 'NO_EM_RESTART': '1', 16:49:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:49:25 INFO - 'PWD': '/builds/slave/test-pgo', 16:49:25 INFO - 'SHELL': '/bin/bash', 16:49:25 INFO - 'SHLVL': '1', 16:49:25 INFO - 'TERM': 'linux', 16:49:25 INFO - 'TMOUT': '86400', 16:49:25 INFO - 'USER': 'cltbld', 16:49:25 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1451593341.309537-888449318', 16:49:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:25 INFO - '_': '/tools/buildbot/bin/python'} 16:49:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:25 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)) 16:49:25 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)) 16:49:25 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)) 16:49:25 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)) 16:49:25 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)) 16:49:25 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)) 16:49:25 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)) 16:49:25 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)) 16:49:25 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)) 16:49:25 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)) 16:49:25 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)) 16:49:25 INFO - Cleaning up... 16:49:25 INFO - Return code: 0 16:49:25 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fe99dca6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16936c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1690e40>, '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 0x1691740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1691bf0>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1451593341.309537-888449318', '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 16:49:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 16:49:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 16:49:25 INFO - Using env: {'DISPLAY': ':0', 16:49:25 INFO - 'HOME': '/home/cltbld', 16:49:25 INFO - 'LANG': 'en_US.UTF-8', 16:49:25 INFO - 'LANGUAGE': 'en_US:en', 16:49:25 INFO - 'LOGNAME': 'cltbld', 16:49:25 INFO - 'MAIL': '/var/mail/cltbld', 16:49:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:25 INFO - 'MOZ_NO_REMOTE': '1', 16:49:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:25 INFO - 'NO_EM_RESTART': '1', 16:49:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:49:25 INFO - 'PWD': '/builds/slave/test-pgo', 16:49:25 INFO - 'SHELL': '/bin/bash', 16:49:25 INFO - 'SHLVL': '1', 16:49:25 INFO - 'TERM': 'linux', 16:49:25 INFO - 'TMOUT': '86400', 16:49:25 INFO - 'USER': 'cltbld', 16:49:25 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1451593341.309537-888449318', 16:49:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:25 INFO - '_': '/tools/buildbot/bin/python'} 16:49:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:26 INFO - Downloading/unpacking jsonschema 16:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:49:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 16:49:27 INFO - Downloading/unpacking functools32 (from jsonschema) 16:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:27 INFO - Downloading functools32-3.2.3-2.tar.gz 16:49:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 16:49:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:49:28 INFO - warning: no files found matching '*.txt' 16:49:28 INFO - no previously-included directories found matching 'build' 16:49:28 INFO - no previously-included directories found matching 'dist' 16:49:28 INFO - no previously-included directories found matching '.git*' 16:49:28 INFO - Installing collected packages: jsonschema, functools32 16:49:28 INFO - Running setup.py install for functools32 16:49:28 INFO - warning: no files found matching '*.txt' 16:49:28 INFO - no previously-included directories found matching 'build' 16:49:28 INFO - no previously-included directories found matching 'dist' 16:49:28 INFO - no previously-included directories found matching '.git*' 16:49:28 INFO - Successfully installed jsonschema functools32 16:49:28 INFO - Cleaning up... 16:49:28 INFO - Return code: 0 16:49:28 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:49:28 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')]} 16:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:28 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')]} 16:49:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fe99dca6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16936c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1690e40>, '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 0x1691740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1691bf0>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1451593341.309537-888449318', '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 16:49:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 16:49:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 16:49:28 INFO - Using env: {'DISPLAY': ':0', 16:49:28 INFO - 'HOME': '/home/cltbld', 16:49:28 INFO - 'LANG': 'en_US.UTF-8', 16:49:28 INFO - 'LANGUAGE': 'en_US:en', 16:49:28 INFO - 'LOGNAME': 'cltbld', 16:49:28 INFO - 'MAIL': '/var/mail/cltbld', 16:49:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:28 INFO - 'MOZ_NO_REMOTE': '1', 16:49:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:28 INFO - 'NO_EM_RESTART': '1', 16:49:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:49:28 INFO - 'PWD': '/builds/slave/test-pgo', 16:49:28 INFO - 'SHELL': '/bin/bash', 16:49:28 INFO - 'SHLVL': '1', 16:49:28 INFO - 'TERM': 'linux', 16:49:28 INFO - 'TMOUT': '86400', 16:49:28 INFO - 'USER': 'cltbld', 16:49:28 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1451593341.309537-888449318', 16:49:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:28 INFO - '_': '/tools/buildbot/bin/python'} 16:49:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:28 INFO - Downloading/unpacking flake8 16:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:49:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 16:49:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:49:30 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 16:49:30 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 16:49:30 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 16:49:30 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 16:49:30 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 16:49:30 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 16:49:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:49:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 16:49:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:49:30 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 16:49:30 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 16:49:30 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 16:49:30 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 16:49:30 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 16:49:30 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 16:49:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 16:49:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:49:30 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 16:49:30 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 16:49:30 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 16:49:30 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 16:49:30 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 16:49:30 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 16:49:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 16:49:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:49:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:49:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:49:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:49:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:49:30 INFO - no previously-included directories found matching 'docs/_build' 16:49:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:49:30 INFO - Running setup.py install for pep8 16:49:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:49:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:49:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:49:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:49:30 INFO - no previously-included directories found matching 'docs/_build' 16:49:30 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:49:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:49:30 INFO - Cleaning up... 16:49:31 INFO - Return code: 0 16:49:31 INFO - Running post-action listener: _resource_record_post_action 16:49:31 INFO - Running post-action listener: _start_resource_monitoring 16:49:31 INFO - Starting resource monitoring. 16:49:31 INFO - ##### 16:49:31 INFO - ##### Running install step. 16:49:31 INFO - ##### 16:49:31 INFO - Running pre-action listener: _resource_record_pre_action 16:49:31 INFO - Running main action method: install 16:49:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:49:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:49:31 INFO - Reading from file tmpfile_stdout 16:49:31 INFO - Detecting whether we're running mozinstall >=1.0... 16:49:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:49:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:49:31 INFO - Reading from file tmpfile_stdout 16:49:31 INFO - Output received: 16:49:31 INFO - Usage: mozinstall [options] installer 16:49:31 INFO - Options: 16:49:31 INFO - -h, --help show this help message and exit 16:49:31 INFO - -d DEST, --destination=DEST 16:49:31 INFO - Directory to install application into. [default: 16:49:31 INFO - "/builds/slave/test-pgo"] 16:49:31 INFO - --app=APP Application being installed. [default: firefox] 16:49:31 INFO - mkdir: /builds/slave/test-pgo/build/application 16:49:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 16:49:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 16:49:47 INFO - Reading from file tmpfile_stdout 16:49:47 INFO - Output received: 16:49:47 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:49:47 INFO - Running post-action listener: _resource_record_post_action 16:49:47 INFO - ##### 16:49:47 INFO - ##### Running run-tests step. 16:49:47 INFO - ##### 16:49:47 INFO - Running pre-action listener: _resource_record_pre_action 16:49:47 INFO - Running main action method: run_tests 16:49:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:49:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:49:47 INFO - Python 2.7.3 16:49:47 INFO - Return code: 0 16:49:47 INFO - grabbing minidump binary from tooltool 16:49: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')]} 16:49:47 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-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 0x1690e40>, '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 0x1691740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1691bf0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:49:47 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 16:49:47 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:49:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:49:47 INFO - Return code: 0 16:49:47 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:49:47 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:49:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:49:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:49:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:49:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:49:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:49:48 INFO - Return code: 0 16:49:48 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/fLLi6ttNQXq0xgKsOuNzcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 16:49:48 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/fLLi6ttNQXq0xgKsOuNzcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 16:49:48 INFO - Using env: {'DISPLAY': ':0', 16:49:48 INFO - 'HOME': '/home/cltbld', 16:49:48 INFO - 'LANG': 'en_US.UTF-8', 16:49:48 INFO - 'LANGUAGE': 'en_US:en', 16:49:48 INFO - 'LOGNAME': 'cltbld', 16:49:48 INFO - 'MAIL': '/var/mail/cltbld', 16:49:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:49:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:48 INFO - 'MOZ_NO_REMOTE': '1', 16:49:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:49:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:48 INFO - 'NO_EM_RESTART': '1', 16:49:48 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:49:48 INFO - 'PWD': '/builds/slave/test-pgo', 16:49:48 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:49:48 INFO - 'SHELL': '/bin/bash', 16:49:48 INFO - 'SHLVL': '1', 16:49:48 INFO - 'TERM': 'linux', 16:49:48 INFO - 'TMOUT': '86400', 16:49:48 INFO - 'USER': 'cltbld', 16:49:48 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1451593341.309537-888449318', 16:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:48 INFO - '_': '/tools/buildbot/bin/python'} 16:49:48 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/fLLi6ttNQXq0xgKsOuNzcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 16:49:48 INFO - mozversion application_buildid: 20151231143004 16:49:48 INFO - mozversion application_changeset: 6053ffd738ce52d994327446441db583954e8399 16:49:48 INFO - mozversion application_display_name: Nightly 16:49:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:49:48 INFO - mozversion application_name: Firefox 16:49:48 INFO - mozversion application_remotingname: firefox 16:49:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:49:48 INFO - mozversion application_vendor: Mozilla 16:49:48 INFO - mozversion application_version: 46.0a1 16:49:48 INFO - mozversion platform_buildid: 20151231143004 16:49:48 INFO - mozversion platform_changeset: 6053ffd738ce52d994327446441db583954e8399 16:49:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:49:48 INFO - mozversion platform_version: 46.0a1 16:49:48 INFO - using testdate: 1451609388 16:49:48 INFO - actual date: 1451609388 16:49:48 INFO - starting webserver on 'localhost:35777' 16:49:48 INFO - SUITE-START | Running 3 tests 16:49:48 INFO - TEST-START | dromaeo_css 16:49:48 INFO - operating with platform_type : linux_ 16:49:48 INFO - Initialising browser for dromaeo_css test... 16:49:48 INFO - TEST-INFO | started process 17923 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0riWvD/profile http://localhost:35777/getInfo.html) 16:49:53 INFO - PROCESS | 17923 | __metrics Screen width/height:1600/1200 16:49:53 INFO - PROCESS | 17923 | colorDepth:24 16:49:53 INFO - PROCESS | 17923 | Browser inner width/height: 1024/697 16:49:53 INFO - PROCESS | 17923 | __metrics 16:49:53 INFO - PROCESS | 17923 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:49:53 INFO - PROCESS | 17923 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:49:54 INFO - TEST-INFO | 17923: exit 0 16:49:54 INFO - Browser initialized. 16:49:54 INFO - Running cycle 1/1 for dromaeo_css test... 16:49:54 INFO - TEST-INFO | started process 18018 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0riWvD/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:50:06 INFO - PROCESS | 18018 | RSS: Main: 150102016 16:50:06 INFO - PROCESS | 18018 | 16:50:57 INFO - PROCESS | 18018 | 1451609457448 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] 16:53:07 INFO - PROCESS | 18018 | Cycle 1(1): loaded http://localhost:35777/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35777/tests/dromaeo/cssquery-ext.html) 16:53:08 INFO - PROCESS | 18018 | RSS: Main: 268480512 16:53:08 INFO - PROCESS | 18018 | 16:56:11 INFO - PROCESS | 18018 | Cycle 1(1): loaded http://localhost:35777/tests/dromaeo/cssquery-ext.html (next: http://localhost:35777/tests/dromaeo/cssquery-jquery.html) 16:56:11 INFO - PROCESS | 18018 | RSS: Main: 242798592 16:56:11 INFO - PROCESS | 18018 | 16:59:13 INFO - PROCESS | 18018 | Cycle 1(1): loaded http://localhost:35777/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35777/tests/dromaeo/cssquery-mootools.html) 16:59:14 INFO - PROCESS | 18018 | RSS: Main: 241823744 16:59:14 INFO - PROCESS | 18018 | 17:02:15 INFO - PROCESS | 18018 | Cycle 1(1): loaded http://localhost:35777/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35777/tests/dromaeo/cssquery-prototype.html) 17:02:16 INFO - PROCESS | 18018 | RSS: Main: 216150016 17:02:16 INFO - PROCESS | 18018 | 17:05:18 INFO - PROCESS | 18018 | Cycle 1(1): loaded http://localhost:35777/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35777/tests/dromaeo/cssquery-yui.html) 17:05:19 INFO - PROCESS | 18018 | RSS: Main: 222019584 17:05:19 INFO - PROCESS | 18018 | 17:08:21 INFO - PROCESS | 18018 | Cycle 1(1): loaded http://localhost:35777/tests/dromaeo/cssquery-yui.html (next: http://localhost:35777/tests/dromaeo/cssquery-dojo.html) 17:08:22 INFO - PROCESS | 18018 | RSS: Main: 262717440 17:08:22 INFO - PROCESS | 18018 | 17:08:22 INFO - PROCESS | 18018 | __start_tp_report 17:08:22 INFO - PROCESS | 18018 | _x_x_mozilla_page_load 17:08:22 INFO - PROCESS | 18018 | _x_x_mozilla_page_load_details 17:08:22 INFO - PROCESS | 18018 | |i|pagename|runs| 17:08:22 INFO - PROCESS | 18018 | |0;dojo.html;3121.1572875323664;3163.3515129398447;3202.7918185317953;3204.615446146463;3217.1474559241806;5110.821121260757;5206.8698282542955;5230.372355317358;5248.685078895264;5265.684058956455;5158.380994280692;5280.3663560372715;5284.233786101013;5343.893122137564;5348.331458567679;4768.880777980561;4782.593479554242;4854.417469903617;4936.136176169174;4942.15983282841;4860.684055536397;4873.293372460991;4920.778564964585;4937.308776771255;4949.455559888409;4721.669483136182;4755.667103302771;4833.758312084382;4862.878428039292;4867.415910090776;4758.928616070762;4780.784864681098;4804.25534042224;4807.831725889577;4830.589399901012;4750.002499475115;4762.666613337068;4783.856484305442;4785.21044027735;4788.04239152171;5002.299678045077;5019.472955339674;5078.263651770472;5102.38771347437;5113.795448182068;5575.776968921238;5604.495595396434;5611.523020543259;5614.747336369873;5616.185653080322;5466.453354664542;5655.8586035349035;5664.433556644344;5674.914876276859;5678.063119585264;5167.896642067138;5212.139996900545;5240.842774716764;5247.4490178530705;5281.86795330116;5707.914381284284;5708.942910570924;5710.857228569236;5714;5718.7426565804635;5399.946000539944;5503.944960550343;5504.6421982571;5509.5041446270025;5522.364928033247;5566.916496252559;5605.0751625982075;5630.746616402272;5664.688442135722;5689.487946084872;5519;5540.806071787549;5560.77756889728;5574.331080270394;5575.776968921279;5480.342358916876;5525.060739674265;5573.470520300565;5583.944160558423;5587.217789509472;4346.369776382407;4352.086061927031;4386.824527018884;4437.7781110944325;4440.555944405533;3908.101136738509;3912.178442527101;3915.9216815663526;3925.92148157041;3948.052467407859;5140.974295128501;5200.271961925334;5209.765560549784;5221.686698798084;5224.216367544823;5529.419410961791;5543.916841247385;5561.63849349791;5569.108942569251;5621.494065534122;5167;5176.611754118381;5194;5221.791128354899;5232.502912223333;4811.903761924742;4846.5638092571835;4860.343853579721;4864.610831133501;4891.04624598207;5702.087665973424;5763;5825.300963884276;5825.94174058254;5830.41695830422;5604.579656525695;5674.914876276942;5682.232898558642;5686.374498805211;5725.713714314351;5795.710214489174;5831.300243970751;5837.0368889132815;5840.094785308284;5843.2695913010875;5416.079266524779;5526.253955716088;5532.91700624499;5543.584231182596;5550.750216240198;5662.433756624305;5691.943080569141;5699.344575373885;5703.714814259188;5715.457031581993;5554.1391084381985;5574.749136288796;5575.581831362583;5581.7209139543675;5581.860453488695;5233.738313084406;5412.864678383072;5421.241026256248;5528.530074943675;5545.750441230235;5343.7595308212;5352.4915133062295;5356.5982551308025;5357.571394288526;5361.329833770778;5417.431169727122;5458.399576046711;5464.535514481314;5506.889862202654;5525.530329922001;5263.499967503081;5318.149096144598;5373.570114390761;5379.919301210407;5435.510804027656 17:08:22 INFO - PROCESS | 18018 | |1;ext.html;511.43741883927686;517.3533083645441;518.2045560065301;539.6384422436967;541.3936391241809;27044.86477567612;27512.724872751292;35290.647093529056;36005;36112.2777544449;38322.23355532888;39149.608503914955;39191.80404097983;39268.21463570727;39274.21451570974;7486.737964171255;8509.149085091487;8670.219680228778;8677.739667809976;8686.044535101133;7616.086069671647;7708.267714567135;10104.44425556594;10312.587496500131;10316.277860549764;9970.302078854484;10165.440900750456;10171.542280597354;10176.440295783728;10176.694699159;7717.884231736529;7877.936478575376;9887.604495820158;9964.70105896817;9992.25058120644;7554.962225188894;10021.849672254923;10256.38461692301;10257.384556926534;10284.742881428025;36917.446238306446;37393.25213495742;37454.81272593647;37470.43794343087;37508.624913750784;3104.7205751482475;3262.5432439458496;3302.669733026702;3616.2405894762132;3623.2572322673786;28509.144725658265;30760.384792304252;30931.84534077315;31568.684313156806;32099.83950080258;3929.7249192556533;3953.9011524711823;3998.9200215995807;4048.7165898387125;4061.1268577255737;278055;278778;279163;279393;279752;52476.58902171423;53776.73111634417;60206;60617.393826062056;61203.6939815307;54820.72589637106;54894.17658735122;55077.173842392396;55176.448235517935;55276.72361638166;15161.469348572748;15302.923485382502;15378.538643840702;15414.46049388266;15423.845761542465;11678.94160529209;11768.70578235551;11804;11840.467178976967;11842.585509507126;19035;19719.041883848564;19730;19802.900985495267;19925.800741992683;7465.589392583352;7652.540847549165;7682.385409167253;7715.691372345043;7723;942.533445944262;942.830290547708;948.7684925233398;961.33667769239;1003.3528374198601;25273.747262527508;25328.366790830376;25334.873325633253;25488.490230195293;25694.743052569236;1024.636254129788;1030.9690709278734;1047.706642140202;1071.3625392891217;1142.2061667141256;13278.66803329905;13691.657708557366;15534.1456219909;15788.60528486797;16127.274272657523;120890.39554802346;121337;121864.39067804781;126231.3688431552;134714.32642836723;51680.483195168315;51772.482275176764;51777.741111294956;51810;51894.74052629788;1336.4787732784223;1352.0670737191306;1365.9521916732867;1371.6022353517567;1373.7115205806692;27939.58090628683;29544.852275738485;29709.5543566851;30261.394772104875;30283.394332113676;46055.53944460512;46305.53694463147;46409;46428.767856160506;46445.535544644124;288908;294941;396484;412449;412570;31037.689623104383;31081.222969425944;31179.844100780258;31180.688193118687;31189.220269492536;43501.56498434975;43968.56031439773;44146.33780493231;45025.32462013138;45127.77436112799;36280.09299767527;36681.266374672894;36689.44965825461;37097.629023709414;37434.812825935696;36702;37112.44331334978;37263.813680931424;37978.24043519169;38074.619253807105;35474.46788298126;36487;36708.26583468262;36724.44913326249;36768.26463470662;32917.341653167285;33714.59070117738;33715.494267586495;33939.321213576084;34335.656643434246;25183.748162518874;25507.744922550537;25662.230133096036;25815.225543233733;25980.090696825522 17:08:22 INFO - PROCESS | 18018 | |2;jquery.html;347.91650003999047;350.55654596934863;352.6297387742869;355.57686353239643;357.3210899291346;13926.303684815744;14348.497802576912;16005.519834404957;16206.270717817697;17049.82950170498;14631.561053168421;15714.764278535831;16014.119223442705;16018.279177437014;16300.184990750475;5285.814996475124;5412.4587541245955;5418.620696551243;5421.430749771276;5423.403425623178;4024.537178224498;4145.067359844026;5334.093204155303;5362.088444964365;5707.343655479611;5803.854903627422;5822.1266809978415;5843.912341314884;5857.238558987326;5867.061270196769;5649.435056494359;5813.476787089161;5817.7382017809305;5818.679972601505;5835.212246346774;5108.412532558729;5112.130937740556;5126.307948426989;5127.743612819344;5130.025295193901;11557.595484158099;11932.284062956163;19156.329528466576;19884.70172947407;19932.501687457785;1948.2888745607893;2097.3857513470425;2100.3698890332994;2146.4741138421186;2170.5984392887367;9493.335466517347;9757.170640495495;10007.149392301662;10463.79072418555;13391.330433478288;1777.626698393339;1812.5287425269394;1844.6956252218367;1848.112905805221;1865.9440216793519;61509;61807;62902;63267;64038.359616404174;9742.415455072718;9944.502774861228;9960.352577082467;9986.700398987896;9994.550245238981;12985.545505907248;13117.344132793321;13126;13148.60554183376;13159.736805263841;7300.4159667226495;7335.88996165058;7512.699492020258;7536.811579710551;7638.274363935418;7030;7057.858842823218;7437.070366204224;7490;7490.70037198506;4320.719153255029;4336.631386332134;4384.890377740582;4416.889577760582;4476.970296831747;1646.4648989078598;1677.3961373905383;1682.0916704979418;1729.8529624982018;1785.9910700446414;849.4181485682327;850.7277671145174;1033.379972016784;1033.565902321027;1057.3972835483855;15805.209739512979;15988.440404586016;16051.438199662956;16515.17424128813;17142;913.9405938613969;940.3464592108419;951.9381240219363;965.2037069417759;977.5454413697522;9392.29557783169;9545.665901693546;9552.704317010759;9910.752231194134;10106.696799096038;498379;549461;551319;564766;566127;63976.4812935293;70243.29756702368;71366;73065.6346718263;73852;1160.3675996581715;1171.77736230116;1172.8533933258343;1196.521391443412;1196.8503937007874;14483.348249329016;15224.238788060775;15481.612959676098;15669.451569195024;15855.365785368456;31336.843315784186;32190.35619287648;32254.83872580622;32280.515792262664;33360.332793343514;38551.61448385593;40109.39835902405;40330.79834600808;42912;43079.7846010768;8949.776255593662;9547.28395370364;9609.183219426428;9657.46883921391;9738.707838764565;11012.17408694335;11099.500522476346;11159;11159.330440173615;11941.880581194077;14215.573532794033;14220.288985550887;14235.572932812032;14434.566962991126;14437;13954.23251721165;14047.648808779863;14207.502737404142;14507.709845803236;14708.705825883637;15094.622634434227;15190.848091518943;15446;15517.301721422336;15566.143862087694;9312.48781317034;9324.627014919599;9403.717888463358;9405.670801521914;9428.528573571431;10122.139618132542;11861.881381186078;14261.500847470288;14418.13491190532;15014.6997060056 17:08:22 INFO - PROCESS | 18018 | |3;mootools.html;1291.5350473829415;1440.4958264607385;1441.2217402602591;1579.620890986163;1742.8692848036392;6621.536492445524;6821.420179284761;6911.619860907648;6936.826579335519;6942.861142777141;7130.786076417703;7322.890156647654;7347.926520734791;7355.374793142576;7366.152892417374;1887.3016983716045;1937.6705959986837;2023.2109477303864;2069.0896005757495;2156.967645485319;2196.3301193136085;2203.7025001624816;2206.305013920618;2207.6578130389735;2207.724034495688;2080.427882332363;2140.0262880389464;2140.860844045132;2141.7429908411013;2146.61360955028;2050.3028970150144;2083.3541602103396;2097.6958341040463;2102.7792081831494;2105.705201271823;2166.263470420049;2168.978310216909;2193.7915897989665;2195.056125865877;2195.9780402195934;7134.2509036551455;7243.275672432767;7266.781996540112;7268.2368351322875;7282.016927714743;4315.093830295642;4379.08039311745;4394.4946331172005;4410.558944105596;4414.955850441486;2897.4494845979407;2931.2378781516745;2976.955345669817;2987.850607469618;3031.4998025326017;960.0975083421562;964.4743614729989;976.379998700823;977.7653363192853;990.484947827133;10136.442495662735;10147.137493313077;10149.644762433354;10150.13723833475;10151.492425378701;3988.7806170660892;3989.800509974548;4022.1151346703678;4027.2348253832265;4070.063885306396;8693.565321733888;8768.473891566398;8769.868451973225;8777.824443511221;8788.824223515494;4477.529859364719;4492.528284530143;4503.482099558527;4511.052678937394;4514.683972121986;4055.411965265079;4115.032967252693;4115.36211887158;4121.031557583965;4121.175764847043;3204.182933352027;3248.707616314543;3389.508521264403;3420.538227339327;3491.581010278732;1067.4235912607105;1077.1490522487147;1081.7566047639375;1108.7449886526144;1113.2151832957907;1027.8920713325142;1034.4517405774952;1238.4241327782624;1290.7805673035418;1311.1477539599146;7046.330598593126;7102.396296314768;7109.715611375487;7122.5726456412785;7130.037444944866;1082.2910993299402;1100.0594491709633;1109.8224284114503;1112.1047556716921;1123.152020224725;5528.50730302824;5583.748731307101;5584.832455026356;5584.972075139598;5605.047141985872;8274;8302.377321700897;8347.207015333533;8441.620127094295;8465.195806398382;8353.95823020881;8435.11431299717;8450.66197352099;8477.491350518865;8480.363972702073;6650.634215118215;6687.665616719145;6791.966040169867;6793.252742198354;6819.352161544645;6590.077389165616;6598;6601.768938087144;6621.073049773132;6622.337766223339;7441.776746697607;7508.174100848793;7546.622668866425;7638.427117966286;7646.541207527566;7665.156832748505;7767.883481747891;7830.686772529263;7933.325667318342;7944.6822127114265;6163.568550201443;6213.409726076015;6218.191635087591;6220.7511699533325;6223.253209614875;6761.695723692544;6906.412954898889;6917.550359226634;6936.687849046906;6953.443724501926;6489.448396886318;6497.285298617243;6601.10885030534;6687.595604923021;6707.631080290631;6394.520410969103;6426.068220107964;6463.903041454288;6542.051402546509;6595;6541;6542.967285163544;6548.345165483413;6560.803175904731;6563.278039415756;6030.90953635687;6032.728527216374;6036.245469316335;6058.212432383762;6074.331823499323;6176.042713379434;6278.560500764903;6299.055141728777;6308.116863639002;6314.989601663712 17:08:22 INFO - PROCESS | 18018 | |4;prototype.html;333.4747772258692;337.33376581252014;338.4027192006108;341.8102952861163;345.3283363857297;5817.941820581798;5857.238558987337;5862.062070068784;5874.735636896339;5901.20333754944;5524.944750552493;5611.9438805611935;5679.318481782192;5764.711764411783;5767.509761670263;4506.526814684444;4522.728636281817;4525.411696479453;4528.660350473711;4551.340055691922;4516.706414083091;4526.434195725535;4539.659525535581;4543.477500087482;4554.180247555439;4300.827966881321;4387.758673272969;4405.339199120125;4463.68754187207;4511.7969691363805;4483.327500874862;4485.573870482299;4491.461024677027;4493.842715504941;4497.100579884036;3986.7009974251755;3989.960100398988;3993.0616305168264;3996.4205190247253;4006;5517.889642207174;5526.861828454321;5531.917021244684;5545.944540554583;5550.86122846928;5123.795048198068;5234.607404444682;5241.056609810233;5243.161094224944;5255.632105752599;6117.082437634346;6141.631502109888;6153.384661533811;6160.168377269056;6160.322364539897;4367.301231802928;4372.322290045048;4377.781110944472;4413.668974826901;4416.84541041062;6212.409821066992;6389.009703495965;6394.392532709385;6396.26442959061;6397.168368112162;4442.311441726538;4449.9777501112285;4450.866474005785;4456.3538286948215;4465.285554311295;4505.324201369821;4508.864734057984;4509;4509.842155524541;4514.796834142471;5136;5166.767495462638;5175.689458632494;5177.456367081478;5178.197379406198;6053.667048312297;6175.752969881244;6177.289611694623;6189.164462797555;6191.81424557264;1603.6471976165226;1620.440947872982;1622.9513114606345;1624.025584649201;1625.5610985033975;1109.938953357557;1111.111111111108;1121.1927412263158;1121.9495122719497;1136.7158210447387;5837.620554663933;5846.473817356458;5853.765849366063;5855.531557475391;5862.794802181903;6338.968305158444;6344.143540622049;6349.936500635027;6360.586561873463;6362.268339141058;5644.407337229532;5767.480926716616;5795.594308398456;5846.1230815377185;5920.437558431942;3436.536067630888;3438.7420943428842;3460.0657822387816;3460.2733425980323;3465.2722928184858;6619.073329733841;6678.09845670838;6680.365365290289;6687;6688;6411.551191416556;6545.967270163619;6547.181602299713;6564.98242772371;6579;6648.933510664831;6668.766593169215;6670.099536562502;6670.599764014078;6680.899786503109;6402.647854368054;6405.103285540122;6405.967970160305;6412.2625898022325;6417.71120299597;6232.937670623236;6328.272248691275;6343.207099112611;6345.1434056401795;6347.428731414195;6624.039514270307;6642.867142657216;6643.269240383457;6646.468282537482;6658.766943156967;4542.477615074176;4542.704724192917;4548.295014272793;4548.3859678944245;4552.226121559276;6307;6404.103425520524;6415.390537898892;6425.678716064084;6428.839279018062;6249.218847644044;6251.031090181029;6258.249010118633;6259.405356491126;6263.96868015657;6178.845528861814;6204.472619827366;6209.348018457997;6216.316205217513;6229.0967809668255;6002.189704389852;6116.327204007466;6120.387961203844;6123.2958209804665;6131.662758548323;6254.593451425642;6257.9687101564205;6258.405451482102;6259.217597800275;6270.278917924315;6037.818865434044;6064.241969753781;6064.575479716377;6078.088286756845;6088.056351265561 17:08:22 INFO - PROCESS | 18018 | |5;yui.html;667.4827009067972;699.5732603112101;815.6615004773016;821.1624143373755;826.1366871619157;12651.936740316298;12826.102172847905;12837.550685726;12871.034672399584;12890.033247506439;11487.195896287263;11578.363190024545;11596.594119205829;13958.581242562714;14531.491397801079;681.6285124607076;692.5636848785258;820.7578764264556;838.375410319313;850.4854562989395;838.1618381618382;840.9159084091604;842.970496032639;843.6372359885247;845.3997661660198;704.4012589299081;713.3722324354586;880.8810810540559;889.1020069729555;889.2574700125404;866.4584634603373;892.3485855325648;893.0444424465824;894.025512191711;898.420518765396;638.5274896576547;644.5262731892055;644.6969924135649;644.7904431059924;644.8452371430869;13409.798853017213;13465.394057267447;13521.323933803369;13546.322683865867;13560.796588051187;11745.119116066244;11765.294082355085;11868.347240901747;12573.434195461226;12960.481580736854;9435.103665151799;9505.952470237604;9746.269029822792;9817.90182098177;9877.209823214198;3577.373959557067;3590.6768390844686;3602.261536385061;3609.5127157833617;3627.4740162676526;48617.51382486165;48737.51262487365;48877.5112248873;49472.25791613129;49861;9207.63169473227;9689;9805.901940980499;10635.202359823044;10738.194635402377;18465.5383615408;18757.624847503248;18785.34251301198;18800.15399307007;18801.153948072097;7280.235575264627;7294.8176295591975;7475;7512.286332798375;7622.161562228151;3985.4021896715144;3990.461287726178;4006.3536007887274;4052.7365721228025;4100.0159961609;2761.226856480189;2794.3433293176085;2795.5247607906704;2795.636567246245;2835.6738975017724;523.8716514453984;537.8655336165958;545.4000599340773;546.9835904922859;547.6029878338173;523.6491550661066;530.7028064284013;589.4576989169974;621.6891554222889;624.6252248650864;7824.804379890548;8008.799780005546;8051.154628763896;8059.113497515269;8144.959275203586;550.7598904412991;623.5167744997573;639.3702203329716;642.7525402719893;656.1797752808989;3656.670899619047;3713.9788795417808;3826.521684789401;3848.8845334640005;3853.6531712146043;57958;58332.70833645805;58436.707816461494;58465.70767146137;58499;49411;49508.50491495111;49866.75066624644;50022.499775002514;50679;45805;46565.5343446568;46770.5322946773;47581;47873.281900771515;8376.832463350576;8509;8587.313014958663;8881.467111973303;8953.820923581623;34383;34573.65426345704;35478.822605887835;36079.63920360763;36166.63833361738;43497.78251108851;43755.34366984561;44500;45156.548434516546;45513;10434.321769084985;11133.888661113286;11150.932313910645;11269.71825704364;11815.822762658396;12248.877511224773;12689.428975695932;12717.872821271669;13072.80390794158;13093.083484156017;11438.771224575295;11622.88377116218;11731.23746956445;11814.763704726029;12184;11486.655400338002;11553.711157221136;11844;12230.082743794073;12236.87763122393;7508.58702771331;9594.799696449154;10993.560257589927;11248.718782030515;11375.488103035217;8608.139186081593;9570.521473926416;9822.852657210005;9841.360311579725;9959.103680668775;9226.40028398152;9421.811563768822;9490.620375184915;9603.615855365708;9628 17:08:22 INFO - PROCESS | 18018 | __end_tp_report 17:08:22 INFO - PROCESS | 18018 | __start_cc_report 17:08:22 INFO - PROCESS | 18018 | _x_x_mozilla_cycle_collect,960 17:08:22 INFO - PROCESS | 18018 | __end_cc_report 17:08:22 INFO - PROCESS | 18018 | __startTimestamp1451610502122__endTimestamp 17:08:22 INFO - PROCESS | 18018 | 17:08:22 INFO - PROCESS | 18018 | ------- Summary: start ------- 17:08:22 INFO - PROCESS | 18018 | Number of tests: 6 17:08:22 INFO - PROCESS | 18018 | 17:08:22 INFO - PROCESS | 18018 | [#0] dojo.html Cycles:165 Average:5215.22 Median:5361.33 stddev:556.25 (10.4%) stddev-sans-first:533.14 17:08:22 INFO - PROCESS | 18018 | Values: 3121.2 3163.4 3202.8 3204.6 3217.1 5110.8 5206.9 5230.4 5248.7 5265.7 5158.4 5280.4 5284.2 5343.9 5348.3 4768.9 4782.6 4854.4 4936.1 4942.2 4860.7 4873.3 4920.8 4937.3 4949.5 4721.7 4755.7 4833.8 4862.9 4867.4 4758.9 4780.8 4804.3 4807.8 4830.6 4750.0 4762.7 4783.9 4785.2 4788.0 5002.3 5019.5 5078.3 5102.4 5113.8 5575.8 5604.5 5611.5 5614.7 5616.2 5466.5 5655.9 5664.4 5674.9 5678.1 5167.9 5212.1 5240.8 5247.4 5281.9 5707.9 5708.9 5710.9 5714.0 5718.7 5399.9 5503.9 5504.6 5509.5 5522.4 5566.9 5605.1 5630.7 5664.7 5689.5 5519.0 5540.8 5560.8 5574.3 5575.8 5480.3 5525.1 5573.5 5583.9 5587.2 4346.4 4352.1 4386.8 4437.8 4440.6 3908.1 3912.2 3915.9 3925.9 3948.1 5141.0 5200.3 5209.8 5221.7 5224.2 5529.4 5543.9 5561.6 5569.1 5621.5 5167.0 5176.6 5194.0 5221.8 5232.5 4811.9 4846.6 4860.3 4864.6 4891.0 5702.1 5763.0 5825.3 5825.9 5830.4 5604.6 5674.9 5682.2 5686.4 5725.7 5795.7 5831.3 5837.0 5840.1 5843.3 5416.1 5526.3 5532.9 5543.6 5550.8 5662.4 5691.9 5699.3 5703.7 5715.5 5554.1 5574.7 5575.6 5581.7 5581.9 5233.7 5412.9 5421.2 5528.5 5545.8 5343.8 5352.5 5356.6 5357.6 5361.3 5417.4 5458.4 5464.5 5506.9 5525.5 5263.5 5318.1 5373.6 5379.9 5435.5 17:08:22 INFO - PROCESS | 18018 | 17:08:22 INFO - PROCESS | 18018 | [#1] ext.html Cycles:180 Average:42863.69 Median:35739.73 stddev:72648.65 (203.3%) stddev-sans-first:72782.85 17:08:22 INFO - PROCESS | 18018 | Values: 511.4 517.4 518.2 539.6 541.4 27044.9 27512.7 35290.6 36005.0 36112.3 38322.2 39149.6 39191.8 39268.2 39274.2 7486.7 8509.1 8670.2 8677.7 8686.0 7616.1 7708.3 10104.4 10312.6 10316.3 9970.3 10165.4 10171.5 10176.4 10176.7 7717.9 7877.9 9887.6 9964.7 9992.3 7555.0 10021.8 10256.4 10257.4 10284.7 36917.4 37393.3 37454.8 37470.4 37508.6 3104.7 3262.5 3302.7 3616.2 3623.3 28509.1 30760.4 30931.8 31568.7 32099.8 3929.7 3953.9 3998.9 4048.7 4061.1 278055.0 278778.0 279163.0 279393.0 279752.0 52476.6 53776.7 60206.0 60617.4 61203.7 54820.7 54894.2 55077.2 55176.4 55276.7 15161.5 15302.9 15378.5 15414.5 15423.8 11678.9 11768.7 11804.0 11840.5 11842.6 19035.0 19719.0 19730.0 19802.9 19925.8 7465.6 7652.5 7682.4 7715.7 7723.0 942.5 942.8 948.8 961.3 1003.4 25273.7 25328.4 25334.9 25488.5 25694.7 1024.6 1031.0 1047.7 1071.4 1142.2 13278.7 13691.7 15534.1 15788.6 16127.3 120890.4 121337.0 121864.4 126231.4 134714.3 51680.5 51772.5 51777.7 51810.0 51894.7 1336.5 1352.1 1366.0 1371.6 1373.7 27939.6 29544.9 29709.6 30261.4 30283.4 46055.5 46305.5 46409.0 46428.8 46445.5 288908.0 294941.0 396484.0 412449.0 412570.0 31037.7 31081.2 31179.8 31180.7 31189.2 43501.6 43968.6 44146.3 45025.3 45127.8 36280.1 36681.3 36689.4 37097.6 37434.8 36702.0 37112.4 37263.8 37978.2 38074.6 35474.5 36487.0 36708.3 36724.4 36768.3 32917.3 33714.6 33715.5 33939.3 34335.7 25183.7 25507.7 25662.2 25815.2 25980.1 17:08:22 INFO - PROCESS | 18018 | 17:08:22 INFO - PROCESS | 18018 | [#2] jquery.html Cycles:180 Average:28271.01 Median:356.45 stddev:89189.93 (25021.8%) stddev-sans-first:89415.48 17:08:22 INFO - PROCESS | 18018 | Values: 347.9 350.6 352.6 355.6 357.3 13926.3 14348.5 16005.5 16206.3 17049.8 14631.6 15714.8 16014.1 16018.3 16300.2 5285.8 5412.5 5418.6 5421.4 5423.4 4024.5 4145.1 5334.1 5362.1 5707.3 5803.9 5822.1 5843.9 5857.2 5867.1 5649.4 5813.5 5817.7 5818.7 5835.2 5108.4 5112.1 5126.3 5127.7 5130.0 11557.6 11932.3 19156.3 19884.7 19932.5 1948.3 2097.4 2100.4 2146.5 2170.6 9493.3 9757.2 10007.1 10463.8 13391.3 1777.6 1812.5 1844.7 1848.1 1865.9 61509.0 61807.0 62902.0 63267.0 64038.4 9742.4 9944.5 9960.4 9986.7 9994.6 12985.5 13117.3 13126.0 13148.6 13159.7 7300.4 7335.9 7512.7 7536.8 7638.3 7030.0 7057.9 7437.1 7490.0 7490.7 4320.7 4336.6 4384.9 4416.9 4477.0 1646.5 1677.4 1682.1 1729.9 1786.0 849.4 850.7 1033.4 1033.6 1057.4 15805.2 15988.4 16051.4 16515.2 17142.0 913.9 940.3 951.9 965.2 977.5 9392.3 9545.7 9552.7 9910.8 10106.7 498379.0 549461.0 551319.0 564766.0 566127.0 63976.5 70243.3 71366.0 73065.6 73852.0 1160.4 1171.8 1172.9 1196.5 1196.9 14483.3 15224.2 15481.6 15669.5 15855.4 31336.8 32190.4 32254.8 32280.5 33360.3 38551.6 40109.4 40330.8 42912.0 43079.8 8949.8 9547.3 9609.2 9657.5 9738.7 11012.2 11099.5 11159.0 11159.3 11941.9 14215.6 14220.3 14235.6 14434.6 14437.0 13954.2 14047.6 14207.5 14507.7 14708.7 15094.6 15190.8 15446.0 15517.3 15566.1 9312.5 9324.6 9403.7 9405.7 9428.5 10122.1 11861.9 14261.5 14418.1 15014.7 17:08:22 INFO - PROCESS | 18018 | 17:08:22 INFO - PROCESS | 18018 | [#3] mootools.html Cycles:180 Average:5093.69 Median:6169.81 stddev:2596.45 (42.1%) stddev-sans-first:2588.00 17:08:22 INFO - PROCESS | 18018 | Values: 1291.5 1440.5 1441.2 1579.6 1742.9 6621.5 6821.4 6911.6 6936.8 6942.9 7130.8 7322.9 7347.9 7355.4 7366.2 1887.3 1937.7 2023.2 2069.1 2157.0 2196.3 2203.7 2206.3 2207.7 2207.7 2080.4 2140.0 2140.9 2141.7 2146.6 2050.3 2083.4 2097.7 2102.8 2105.7 2166.3 2169.0 2193.8 2195.1 2196.0 7134.3 7243.3 7266.8 7268.2 7282.0 4315.1 4379.1 4394.5 4410.6 4415.0 2897.4 2931.2 2977.0 2987.9 3031.5 960.1 964.5 976.4 977.8 990.5 10136.4 10147.1 10149.6 10150.1 10151.5 3988.8 3989.8 4022.1 4027.2 4070.1 8693.6 8768.5 8769.9 8777.8 8788.8 4477.5 4492.5 4503.5 4511.1 4514.7 4055.4 4115.0 4115.4 4121.0 4121.2 3204.2 3248.7 3389.5 3420.5 3491.6 1067.4 1077.1 1081.8 1108.7 1113.2 1027.9 1034.5 1238.4 1290.8 1311.1 7046.3 7102.4 7109.7 7122.6 7130.0 1082.3 1100.1 1109.8 1112.1 1123.2 5528.5 5583.7 5584.8 5585.0 5605.0 8274.0 8302.4 8347.2 8441.6 8465.2 8354.0 8435.1 8450.7 8477.5 8480.4 6650.6 6687.7 6792.0 6793.3 6819.4 6590.1 6598.0 6601.8 6621.1 6622.3 7441.8 7508.2 7546.6 7638.4 7646.5 7665.2 7767.9 7830.7 7933.3 7944.7 6163.6 6213.4 6218.2 6220.8 6223.3 6761.7 6906.4 6917.6 6936.7 6953.4 6489.4 6497.3 6601.1 6687.6 6707.6 6394.5 6426.1 6463.9 6542.1 6595.0 6541.0 6543.0 6548.3 6560.8 6563.3 6030.9 6032.7 6036.2 6058.2 6074.3 6176.0 6278.6 6299.1 6308.1 6315.0 17:08:22 INFO - PROCESS | 18018 | 17:08:22 INFO - PROCESS | 18018 | [#4] prototype.html Cycles:180 Average:5195.25 Median:5846.30 stddev:1540.31 (26.3%) stddev-sans-first:1500.78 17:08:22 INFO - PROCESS | 18018 | Values: 333.5 337.3 338.4 341.8 345.3 5817.9 5857.2 5862.1 5874.7 5901.2 5524.9 5611.9 5679.3 5764.7 5767.5 4506.5 4522.7 4525.4 4528.7 4551.3 4516.7 4526.4 4539.7 4543.5 4554.2 4300.8 4387.8 4405.3 4463.7 4511.8 4483.3 4485.6 4491.5 4493.8 4497.1 3986.7 3990.0 3993.1 3996.4 4006.0 5517.9 5526.9 5531.9 5545.9 5550.9 5123.8 5234.6 5241.1 5243.2 5255.6 6117.1 6141.6 6153.4 6160.2 6160.3 4367.3 4372.3 4377.8 4413.7 4416.8 6212.4 6389.0 6394.4 6396.3 6397.2 4442.3 4450.0 4450.9 4456.4 4465.3 4505.3 4508.9 4509.0 4509.8 4514.8 5136.0 5166.8 5175.7 5177.5 5178.2 6053.7 6175.8 6177.3 6189.2 6191.8 1603.6 1620.4 1623.0 1624.0 1625.6 1109.9 1111.1 1121.2 1121.9 1136.7 5837.6 5846.5 5853.8 5855.5 5862.8 6339.0 6344.1 6349.9 6360.6 6362.3 5644.4 5767.5 5795.6 5846.1 5920.4 3436.5 3438.7 3460.1 3460.3 3465.3 6619.1 6678.1 6680.4 6687.0 6688.0 6411.6 6546.0 6547.2 6565.0 6579.0 6648.9 6668.8 6670.1 6670.6 6680.9 6402.6 6405.1 6406.0 6412.3 6417.7 6232.9 6328.3 6343.2 6345.1 6347.4 6624.0 6642.9 6643.3 6646.5 6658.8 4542.5 4542.7 4548.3 4548.4 4552.2 6307.0 6404.1 6415.4 6425.7 6428.8 6249.2 6251.0 6258.2 6259.4 6264.0 6178.8 6204.5 6209.3 6216.3 6229.1 6002.2 6116.3 6120.4 6123.3 6131.7 6254.6 6258.0 6258.4 6259.2 6270.3 6037.8 6064.2 6064.6 6078.1 6088.1 17:08:22 INFO - PROCESS | 18018 | 17:08:22 INFO - PROCESS | 18018 | [#5] yui.html Cycles:180 Average:13754.42 Median:49684.75 stddev:16058.03 (32.3%) stddev-sans-first:16073.01 17:08:22 INFO - PROCESS | 18018 | Values: 667.5 699.6 815.7 821.2 826.1 12651.9 12826.1 12837.6 12871.0 12890.0 11487.2 11578.4 11596.6 13958.6 14531.5 681.6 692.6 820.8 838.4 850.5 838.2 840.9 843.0 843.6 845.4 704.4 713.4 880.9 889.1 889.3 866.5 892.3 893.0 894.0 898.4 638.5 644.5 644.7 644.8 644.8 13409.8 13465.4 13521.3 13546.3 13560.8 11745.1 11765.3 11868.3 12573.4 12960.5 9435.1 9506.0 9746.3 9817.9 9877.2 3577.4 3590.7 3602.3 3609.5 3627.5 48617.5 48737.5 48877.5 49472.3 49861.0 9207.6 9689.0 9805.9 10635.2 10738.2 18465.5 18757.6 18785.3 18800.2 18801.2 7280.2 7294.8 7475.0 7512.3 7622.2 3985.4 3990.5 4006.4 4052.7 4100.0 2761.2 2794.3 2795.5 2795.6 2835.7 523.9 537.9 545.4 547.0 547.6 523.6 530.7 589.5 621.7 624.6 7824.8 8008.8 8051.2 8059.1 8145.0 550.8 623.5 639.4 642.8 656.2 3656.7 3714.0 3826.5 3848.9 3853.7 57958.0 58332.7 58436.7 58465.7 58499.0 49411.0 49508.5 49866.8 50022.5 50679.0 45805.0 46565.5 46770.5 47581.0 47873.3 8376.8 8509.0 8587.3 8881.5 8953.8 34383.0 34573.7 35478.8 36079.6 36166.6 43497.8 43755.3 44500.0 45156.5 45513.0 10434.3 11133.9 11150.9 11269.7 11815.8 12248.9 12689.4 12717.9 13072.8 13093.1 11438.8 11622.9 11731.2 11814.8 12184.0 11486.7 11553.7 11844.0 12230.1 12236.9 7508.6 9594.8 10993.6 11248.7 11375.5 8608.1 9570.5 9822.9 9841.4 9959.1 9226.4 9421.8 9490.6 9603.6 9628.0 17:08:22 INFO - PROCESS | 18018 | -------- Summary: end -------- 17:08:22 INFO - PROCESS | 18018 | 17:08:22 INFO - TEST-INFO | 18018: exit 0 17:08:22 INFO - TEST-OK | dromaeo_css | took 1114381ms 17:08:22 INFO - TEST-START | kraken 17:08:22 INFO - operating with platform_type : linux_ 17:08:22 INFO - Initialising browser for kraken test... 17:08:22 INFO - TEST-INFO | started process 18216 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprkSuPq/profile http://localhost:35777/getInfo.html) 17:08:26 INFO - PROCESS | 18216 | __metrics Screen width/height:1600/1200 17:08:26 INFO - PROCESS | 18216 | colorDepth:24 17:08:26 INFO - PROCESS | 18216 | Browser inner width/height: 1024/697 17:08:26 INFO - PROCESS | 18216 | __metrics 17:08:27 INFO - PROCESS | 18216 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:08:27 INFO - PROCESS | 18216 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:08:28 INFO - TEST-INFO | 18216: exit 0 17:08:28 INFO - Browser initialized. 17:08:28 INFO - Running cycle 1/1 for kraken test... 17:08:28 INFO - TEST-INFO | started process 18298 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprkSuPq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:08:40 INFO - PROCESS | 18298 | RSS: Main: 150065152 17:08:40 INFO - PROCESS | 18298 | 17:08:42 INFO - PROCESS | 18298 | Cycle 1(1): loaded http://localhost:35777/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35777/tests/kraken/driver.html?testName=audio-beat-detection) 17:08:43 INFO - PROCESS | 18298 | RSS: Main: 183603200 17:08:43 INFO - PROCESS | 18298 | 17:08:45 INFO - PROCESS | 18298 | Cycle 1(1): loaded http://localhost:35777/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35777/tests/kraken/driver.html?testName=audio-dft) 17:08:46 INFO - PROCESS | 18298 | RSS: Main: 174854144 17:08:46 INFO - PROCESS | 18298 | 17:08:49 INFO - PROCESS | 18298 | Cycle 1(1): loaded http://localhost:35777/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35777/tests/kraken/driver.html?testName=audio-fft) 17:08:49 INFO - PROCESS | 18298 | RSS: Main: 159358976 17:08:49 INFO - PROCESS | 18298 | 17:08:51 INFO - PROCESS | 18298 | Cycle 1(1): loaded http://localhost:35777/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35777/tests/kraken/driver.html?testName=audio-oscillator) 17:08:52 INFO - PROCESS | 18298 | RSS: Main: 162066432 17:08:52 INFO - PROCESS | 18298 | 17:08:54 INFO - PROCESS | 18298 | Cycle 1(1): loaded http://localhost:35777/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35777/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:08:55 INFO - PROCESS | 18298 | RSS: Main: 164753408 17:08:55 INFO - PROCESS | 18298 | 17:08:58 INFO - PROCESS | 18298 | Cycle 1(1): loaded http://localhost:35777/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35777/tests/kraken/driver.html?testName=imaging-darkroom) 17:08:58 INFO - PROCESS | 18298 | RSS: Main: 165896192 17:08:58 INFO - PROCESS | 18298 | 17:09:01 INFO - PROCESS | 18298 | Cycle 1(1): loaded http://localhost:35777/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35777/tests/kraken/driver.html?testName=imaging-desaturate) 17:09:02 INFO - PROCESS | 18298 | RSS: Main: 164560896 17:09:02 INFO - PROCESS | 18298 | 17:09:05 INFO - PROCESS | 18298 | Cycle 1(1): loaded http://localhost:35777/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35777/tests/kraken/driver.html?testName=json-parse-financial) 17:09:05 INFO - PROCESS | 18298 | RSS: Main: 164597760 17:09:05 INFO - PROCESS | 18298 | 17:09:07 INFO - PROCESS | 18298 | Cycle 1(1): loaded http://localhost:35777/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35777/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:09:08 INFO - PROCESS | 18298 | RSS: Main: 176062464 17:09:08 INFO - PROCESS | 18298 | 17:09:09 INFO - PROCESS | 18298 | Cycle 1(1): loaded http://localhost:35777/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35777/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:09:10 INFO - PROCESS | 18298 | RSS: Main: 172294144 17:09:10 INFO - PROCESS | 18298 | 17:09:12 INFO - PROCESS | 18298 | Cycle 1(1): loaded http://localhost:35777/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35777/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:09:13 INFO - PROCESS | 18298 | RSS: Main: 185962496 17:09:13 INFO - PROCESS | 18298 | 17:09:15 INFO - PROCESS | 18298 | Cycle 1(1): loaded http://localhost:35777/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35777/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:09:16 INFO - PROCESS | 18298 | RSS: Main: 191553536 17:09:16 INFO - PROCESS | 18298 | 17:09:18 INFO - PROCESS | 18298 | Cycle 1(1): loaded http://localhost:35777/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35777/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:09:19 INFO - PROCESS | 18298 | RSS: Main: 188334080 17:09:19 INFO - PROCESS | 18298 | 17:09:20 INFO - PROCESS | 18298 | Cycle 1(1): loaded http://localhost:35777/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35777/tests/kraken/driver.html?testName=ai-astar) 17:09:21 INFO - PROCESS | 18298 | RSS: Main: 248705024 17:09:21 INFO - PROCESS | 18298 | 17:09:21 INFO - PROCESS | 18298 | __start_tp_report 17:09:21 INFO - PROCESS | 18298 | _x_x_mozilla_page_load 17:09:21 INFO - PROCESS | 18298 | _x_x_mozilla_page_load_details 17:09:21 INFO - PROCESS | 18298 | |i|pagename|runs| 17:09:21 INFO - PROCESS | 18298 | |0;ai-astar;111;113;106;112;113;112;101;113;113;100 17:09:21 INFO - PROCESS | 18298 | |1;audio-beat-detection;147;128;156;169;127;152;152;123;160;126 17:09:21 INFO - PROCESS | 18298 | |2;audio-dft;162;161;163;160;160;159;162;162;160;160 17:09:21 INFO - PROCESS | 18298 | |3;audio-fft;71;73;87;94;71;74;71;97;93;74 17:09:21 INFO - PROCESS | 18298 | |4;audio-oscillator;96;96;140;95;96;96;150;95;96;142 17:09:21 INFO - PROCESS | 18298 | |5;imaging-gaussian-blur;109;109;109;109;109;108;109;109;108;108 17:09:21 INFO - PROCESS | 18298 | |6;imaging-darkroom;146;145;145;145;145;145;147;145;146;145 17:09:21 INFO - PROCESS | 18298 | |7;imaging-desaturate;96;96;96;96;95;96;96;95;96;95 17:09:21 INFO - PROCESS | 18298 | |8;json-parse-financial;61;58;60;59;58;59;62;59;57;57 17:09:21 INFO - PROCESS | 18298 | |9;json-stringify-tinderbox;67;68;68;68;73;68;68;68;68;68 17:09:21 INFO - PROCESS | 18298 | |10;stanford-crypto-aes;86;88;86;86;87;87;86;86;89;87 17:09:21 INFO - PROCESS | 18298 | |11;stanford-crypto-ccm;118;117;117;120;116;127;122;126;131;119 17:09:21 INFO - PROCESS | 18298 | |12;stanford-crypto-pbkdf2;142;142;153;163;152;147;153;151;152;141 17:09:21 INFO - PROCESS | 18298 | |13;stanford-crypto-sha256-iterative;68;69;71;73;73;69;70;72;67;67 17:09:21 INFO - PROCESS | 18298 | __end_tp_report 17:09:21 INFO - PROCESS | 18298 | __start_cc_report 17:09:21 INFO - PROCESS | 18298 | _x_x_mozilla_cycle_collect,936 17:09:21 INFO - PROCESS | 18298 | __end_cc_report 17:09:21 INFO - PROCESS | 18298 | __startTimestamp1451610561186__endTimestamp 17:09:21 INFO - PROCESS | 18298 | 17:09:21 INFO - PROCESS | 18298 | ------- Summary: start ------- 17:09:21 INFO - PROCESS | 18298 | Number of tests: 14 17:09:21 INFO - PROCESS | 18298 | 17:09:21 INFO - PROCESS | 18298 | [#0] ai-astar Cycles:10 Average:109.40 Median:112.50 stddev:5.15 (4.6%) stddev-sans-first:5.43 17:09:21 INFO - PROCESS | 18298 | Values: 111.0 113.0 106.0 112.0 113.0 112.0 101.0 113.0 113.0 100.0 17:09:21 INFO - PROCESS | 18298 | 17:09:21 INFO - PROCESS | 18298 | [#1] audio-beat-detection Cycles:10 Average:144.00 Median:152.00 stddev:16.57 (10.9%) stddev-sans-first:17.54 17:09:21 INFO - PROCESS | 18298 | Values: 147.0 128.0 156.0 169.0 127.0 152.0 152.0 123.0 160.0 126.0 17:09:21 INFO - PROCESS | 18298 | 17:09:21 INFO - PROCESS | 18298 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.50 stddev:1.29 (0.8%) stddev-sans-first:1.30 17:09:21 INFO - PROCESS | 18298 | Values: 162.0 161.0 163.0 160.0 160.0 159.0 162.0 162.0 160.0 160.0 17:09:21 INFO - PROCESS | 18298 | 17:09:21 INFO - PROCESS | 18298 | [#3] audio-fft Cycles:10 Average:80.50 Median:80.50 stddev:10.88 (13.5%) stddev-sans-first:10.98 17:09:21 INFO - PROCESS | 18298 | Values: 71.0 73.0 87.0 94.0 71.0 74.0 71.0 97.0 93.0 74.0 17:09:21 INFO - PROCESS | 18298 | 17:09:21 INFO - PROCESS | 18298 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:96.00 stddev:23.46 (24.4%) stddev-sans-first:24.31 17:09:21 INFO - PROCESS | 18298 | Values: 96.0 96.0 140.0 95.0 96.0 96.0 150.0 95.0 96.0 142.0 17:09:21 INFO - PROCESS | 18298 | 17:09:21 INFO - PROCESS | 18298 | [#5] imaging-gaussian-blur Cycles:10 Average:108.70 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 17:09:21 INFO - PROCESS | 18298 | Values: 109.0 109.0 109.0 109.0 109.0 108.0 109.0 109.0 108.0 108.0 17:09:21 INFO - PROCESS | 18298 | 17:09:21 INFO - PROCESS | 18298 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 17:09:21 INFO - PROCESS | 18298 | Values: 146.0 145.0 145.0 145.0 145.0 145.0 147.0 145.0 146.0 145.0 17:09:21 INFO - PROCESS | 18298 | 17:09:21 INFO - PROCESS | 18298 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 17:09:21 INFO - PROCESS | 18298 | Values: 96.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 96.0 95.0 17:09:21 INFO - PROCESS | 18298 | 17:09:21 INFO - PROCESS | 18298 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:59.00 stddev:1.63 (2.8%) stddev-sans-first:1.56 17:09:21 INFO - PROCESS | 18298 | Values: 61.0 58.0 60.0 59.0 58.0 59.0 62.0 59.0 57.0 57.0 17:09:21 INFO - PROCESS | 18298 | 17:09:21 INFO - PROCESS | 18298 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.00 stddev:1.65 (2.4%) stddev-sans-first:1.67 17:09:21 INFO - PROCESS | 18298 | Values: 67.0 68.0 68.0 68.0 73.0 68.0 68.0 68.0 68.0 68.0 17:09:21 INFO - PROCESS | 18298 | 17:09:21 INFO - PROCESS | 18298 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:87.00 stddev:1.03 (1.2%) stddev-sans-first:1.05 17:09:21 INFO - PROCESS | 18298 | Values: 86.0 88.0 86.0 86.0 87.0 87.0 86.0 86.0 89.0 87.0 17:09:21 INFO - PROCESS | 18298 | 17:09:21 INFO - PROCESS | 18298 | [#11] stanford-crypto-ccm Cycles:10 Average:121.30 Median:121.00 stddev:5.08 (4.2%) stddev-sans-first:5.24 17:09:21 INFO - PROCESS | 18298 | Values: 118.0 117.0 117.0 120.0 116.0 127.0 122.0 126.0 131.0 119.0 17:09:21 INFO - PROCESS | 18298 | 17:09:21 INFO - PROCESS | 18298 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.60 Median:152.00 stddev:6.77 (4.5%) stddev-sans-first:6.60 17:09:21 INFO - PROCESS | 18298 | Values: 142.0 142.0 153.0 163.0 152.0 147.0 153.0 151.0 152.0 141.0 17:09:21 INFO - PROCESS | 18298 | 17:09:21 INFO - PROCESS | 18298 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.50 stddev:2.28 (3.2%) stddev-sans-first:2.32 17:09:21 INFO - PROCESS | 18298 | Values: 68.0 69.0 71.0 73.0 73.0 69.0 70.0 72.0 67.0 67.0 17:09:21 INFO - PROCESS | 18298 | -------- Summary: end -------- 17:09:21 INFO - PROCESS | 18298 | 17:09:22 INFO - TEST-INFO | 18298: exit 0 17:09:22 INFO - TEST-OK | kraken | took 59240ms 17:09:22 INFO - TEST-START | v8_7 17:09:22 INFO - operating with platform_type : linux_ 17:09:22 INFO - Initialising browser for v8_7 test... 17:09:22 INFO - TEST-INFO | started process 18548 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7SqSXw/profile http://localhost:35777/getInfo.html) 17:09:26 INFO - PROCESS | 18548 | __metrics Screen width/height:1600/1200 17:09:26 INFO - PROCESS | 18548 | colorDepth:24 17:09:26 INFO - PROCESS | 18548 | Browser inner width/height: 1024/697 17:09:26 INFO - PROCESS | 18548 | __metrics 17:09:26 INFO - PROCESS | 18548 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:09:26 INFO - PROCESS | 18548 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:09:27 INFO - TEST-INFO | 18548: exit 0 17:09:27 INFO - Browser initialized. 17:09:27 INFO - Running cycle 1/1 for v8_7 test... 17:09:27 INFO - TEST-INFO | started process 18634 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7SqSXw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:09:39 INFO - PROCESS | 18634 | RSS: Main: 150093824 17:09:39 INFO - PROCESS | 18634 | 17:10:01 INFO - PROCESS | 18634 | Cycle 1(1): loaded http://localhost:35777/tests/v8_7/run.html (next: http://localhost:35777/tests/v8_7/run.html) 17:10:01 INFO - PROCESS | 18634 | RSS: Main: 550572032 17:10:01 INFO - PROCESS | 18634 | 17:10:01 INFO - PROCESS | 18634 | __start_tp_report 17:10:01 INFO - PROCESS | 18634 | _x_x_mozilla_page_load 17:10:01 INFO - PROCESS | 18634 | _x_x_mozilla_page_load_details 17:10:01 INFO - PROCESS | 18634 | |i|pagename|runs| 17:10:01 INFO - PROCESS | 18634 | |0;Richards;167.36401673640168 17:10:01 INFO - PROCESS | 18634 | |1;DeltaBlue;190.83969465648855 17:10:01 INFO - PROCESS | 18634 | |2;Encrypt;281.7695125387433 17:10:01 INFO - PROCESS | 18634 | |3;Decrypt;5256.544502617801 17:10:01 INFO - PROCESS | 18634 | |4;RayTrace;1932.4324324324325 17:10:01 INFO - PROCESS | 18634 | |5;Earley;798.7220447284345 17:10:01 INFO - PROCESS | 18634 | |6;Boyer;12060.240963855422 17:10:01 INFO - PROCESS | 18634 | |7;RegExp;26894.736842105263 17:10:01 INFO - PROCESS | 18634 | |8;Splay;591.016548463357 17:10:01 INFO - PROCESS | 18634 | |9;NavierStokes;4826.923076923077 17:10:01 INFO - PROCESS | 18634 | __end_tp_report 17:10:01 INFO - PROCESS | 18634 | __startTimestamp1451610601297__endTimestamp 17:10:01 INFO - PROCESS | 18634 | 17:10:01 INFO - PROCESS | 18634 | ------- Summary: start ------- 17:10:01 INFO - PROCESS | 18634 | Number of tests: 10 17:10:01 INFO - PROCESS | 18634 | 17:10:01 INFO - PROCESS | 18634 | [#0] Richards Cycles:1 Average:167.36 Median:167.36 stddev:0.00 (0.0%) 17:10:01 INFO - PROCESS | 18634 | Values: 167.4 17:10:01 INFO - PROCESS | 18634 | 17:10:01 INFO - PROCESS | 18634 | [#1] DeltaBlue Cycles:1 Average:190.84 Median:190.84 stddev:0.00 (0.0%) 17:10:01 INFO - PROCESS | 18634 | Values: 190.8 17:10:01 INFO - PROCESS | 18634 | 17:10:01 INFO - PROCESS | 18634 | [#2] Encrypt Cycles:1 Average:281.77 Median:281.77 stddev:0.00 (0.0%) 17:10:01 INFO - PROCESS | 18634 | Values: 281.8 17:10:01 INFO - PROCESS | 18634 | 17:10:01 INFO - PROCESS | 18634 | [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 17:10:01 INFO - PROCESS | 18634 | Values: 5256.5 17:10:01 INFO - PROCESS | 18634 | 17:10:01 INFO - PROCESS | 18634 | [#4] RayTrace Cycles:1 Average:1932.43 Median:1932.43 stddev:0.00 (0.0%) 17:10:01 INFO - PROCESS | 18634 | Values: 1932.4 17:10:01 INFO - PROCESS | 18634 | 17:10:01 INFO - PROCESS | 18634 | [#5] Earley Cycles:1 Average:798.72 Median:798.72 stddev:0.00 (0.0%) 17:10:01 INFO - PROCESS | 18634 | Values: 798.7 17:10:01 INFO - PROCESS | 18634 | 17:10:01 INFO - PROCESS | 18634 | [#6] Boyer Cycles:1 Average:12060.24 Median:12060.24 stddev:0.00 (0.0%) 17:10:01 INFO - PROCESS | 18634 | Values: 12060.2 17:10:01 INFO - PROCESS | 18634 | 17:10:01 INFO - PROCESS | 18634 | [#7] RegExp Cycles:1 Average:26894.74 Median:26894.74 stddev:0.00 (0.0%) 17:10:01 INFO - PROCESS | 18634 | Values: 26894.7 17:10:01 INFO - PROCESS | 18634 | 17:10:01 INFO - PROCESS | 18634 | [#8] Splay Cycles:1 Average:591.02 Median:591.02 stddev:0.00 (0.0%) 17:10:01 INFO - PROCESS | 18634 | Values: 591.0 17:10:01 INFO - PROCESS | 18634 | 17:10:01 INFO - PROCESS | 18634 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 17:10:01 INFO - PROCESS | 18634 | Values: 4826.9 17:10:01 INFO - PROCESS | 18634 | -------- Summary: end -------- 17:10:01 INFO - PROCESS | 18634 | 17:10:02 INFO - TEST-INFO | 18634: exit 0 17:10:02 INFO - TEST-OK | v8_7 | took 40076ms 17:10:02 INFO - SUITE-END | took 1213s 17:10:02 INFO - Completed test suite (00:20:13) 17:10:02 INFO - Working with test: dromaeo_css 17:10:02 INFO - Generating results file: dromaeo_css 17:10:02 INFO - Working with test: kraken 17:10:02 INFO - Generating results file: kraken 17:10:02 INFO - javascript benchmark 17:10:02 INFO - Working with test: v8_7 17:10:02 INFO - Generating results file: v8_7 17:10:02 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:10:07 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 17:10:07 INFO - process_Request line: dromaeo_css 6804.21 graph.html#tests=[[72,64,35]] 17:10:07 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:10:07 INFO - process_Request line: kraken 1509.80 graph.html#tests=[[232,64,35]] 17:10:07 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:10:07 INFO - process_Request line: v8_7 19790.56 graph.html#tests=[[230,64,35]] 17:10:07 INFO - RETURN: dromaeo_css: 6804.21 17:10:07 INFO - RETURN: kraken: 1509.80 17:10:07 INFO - RETURN: v8_7: 19790.56 17:10:07 INFO - javascript benchmark 17:10:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3121.1572875323664, 3163.3515129398447, 3202.7918185317953, 3204.615446146463, 3217.1474559241806, 5110.821121260757, 5206.8698282542955, 5230.372355317358, 5248.685078895264, 5265.684058956455, 5158.380994280692, 5280.3663560372715, 5284.233786101013, 5343.893122137564, 5348.331458567679, 4768.880777980561, 4782.593479554242, 4854.417469903617, 4936.136176169174, 4942.15983282841, 4860.684055536397, 4873.293372460991, 4920.778564964585, 4937.308776771255, 4949.455559888409, 4721.669483136182, 4755.667103302771, 4833.758312084382, 4862.878428039292, 4867.415910090776, 4758.928616070762, 4780.784864681098, 4804.25534042224, 4807.831725889577, 4830.589399901012, 4750.002499475115, 4762.666613337068, 4783.856484305442, 4785.21044027735, 4788.04239152171, 5002.299678045077, 5019.472955339674, 5078.263651770472, 5102.38771347437, 5113.795448182068, 5575.776968921238, 5604.495595396434, 5611.523020543259, 5614.747336369873, 5616.185653080322, 5466.453354664542, 5655.8586035349035, 5664.433556644344, 5674.914876276859, 5678.063119585264, 5167.896642067138, 5212.139996900545, 5240.842774716764, 5247.4490178530705, 5281.86795330116, 5707.914381284284, 5708.942910570924, 5710.857228569236, 5714.0, 5718.7426565804635, 5399.946000539944, 5503.944960550343, 5504.6421982571, 5509.5041446270025, 5522.364928033247, 5566.916496252559, 5605.0751625982075, 5630.746616402272, 5664.688442135722, 5689.487946084872, 5519.0, 5540.806071787549, 5560.77756889728, 5574.331080270394, 5575.776968921279, 5480.342358916876, 5525.060739674265, 5573.470520300565, 5583.944160558423, 5587.217789509472, 4346.369776382407, 4352.086061927031, 4386.824527018884, 4437.7781110944325, 4440.555944405533, 3908.101136738509, 3912.178442527101, 3915.9216815663526, 3925.92148157041, 3948.052467407859, 5140.974295128501, 5200.271961925334, 5209.765560549784, 5221.686698798084, 5224.216367544823, 5529.419410961791, 5543.916841247385, 5561.63849349791, 5569.108942569251, 5621.494065534122, 5167.0, 5176.611754118381, 5194.0, 5221.791128354899, 5232.502912223333, 4811.903761924742, 4846.5638092571835, 4860.343853579721, 4864.610831133501, 4891.04624598207, 5702.087665973424, 5763.0, 5825.300963884276, 5825.94174058254, 5830.41695830422, 5604.579656525695, 5674.914876276942, 5682.232898558642, 5686.374498805211, 5725.713714314351, 5795.710214489174, 5831.300243970751, 5837.0368889132815, 5840.094785308284, 5843.2695913010875, 5416.079266524779, 5526.253955716088, 5532.91700624499, 5543.584231182596, 5550.750216240198, 5662.433756624305, 5691.943080569141, 5699.344575373885, 5703.714814259188, 5715.457031581993, 5554.1391084381985, 5574.749136288796, 5575.581831362583, 5581.7209139543675, 5581.860453488695, 5233.738313084406, 5412.864678383072, 5421.241026256248, 5528.530074943675, 5545.750441230235, 5343.7595308212, 5352.4915133062295, 5356.5982551308025, 5357.571394288526, 5361.329833770778, 5417.431169727122, 5458.399576046711, 5464.535514481314, 5506.889862202654, 5525.530329922001, 5263.499967503081, 5318.149096144598, 5373.570114390761, 5379.919301210407, 5435.510804027656], "unit": "score", "name": "dojo.html", "value": 5180.646161295259}, {"lowerIsBetter": false, "replicates": [511.43741883927686, 517.3533083645441, 518.2045560065301, 539.6384422436967, 541.3936391241809, 27044.86477567612, 27512.724872751292, 35290.647093529056, 36005.0, 36112.2777544449, 38322.23355532888, 39149.608503914955, 39191.80404097983, 39268.21463570727, 39274.21451570974, 7486.737964171255, 8509.149085091487, 8670.219680228778, 8677.739667809976, 8686.044535101133, 7616.086069671647, 7708.267714567135, 10104.44425556594, 10312.587496500131, 10316.277860549764, 9970.302078854484, 10165.440900750456, 10171.542280597354, 10176.440295783728, 10176.694699159, 7717.884231736529, 7877.936478575376, 9887.604495820158, 9964.70105896817, 9992.25058120644, 7554.962225188894, 10021.849672254923, 10256.38461692301, 10257.384556926534, 10284.742881428025, 36917.446238306446, 37393.25213495742, 37454.81272593647, 37470.43794343087, 37508.624913750784, 3104.7205751482475, 3262.5432439458496, 3302.669733026702, 3616.2405894762132, 3623.2572322673786, 28509.144725658265, 30760.384792304252, 30931.84534077315, 31568.684313156806, 32099.83950080258, 3929.7249192556533, 3953.9011524711823, 3998.9200215995807, 4048.7165898387125, 4061.1268577255737, 278055.0, 278778.0, 279163.0, 279393.0, 279752.0, 52476.58902171423, 53776.73111634417, 60206.0, 60617.393826062056, 61203.6939815307, 54820.72589637106, 54894.17658735122, 55077.173842392396, 55176.448235517935, 55276.72361638166, 15161.469348572748, 15302.923485382502, 15378.538643840702, 15414.46049388266, 15423.845761542465, 11678.94160529209, 11768.70578235551, 11804.0, 11840.467178976967, 11842.585509507126, 19035.0, 19719.041883848564, 19730.0, 19802.900985495267, 19925.800741992683, 7465.589392583352, 7652.540847549165, 7682.385409167253, 7715.691372345043, 7723.0, 942.533445944262, 942.830290547708, 948.7684925233398, 961.33667769239, 1003.3528374198601, 25273.747262527508, 25328.366790830376, 25334.873325633253, 25488.490230195293, 25694.743052569236, 1024.636254129788, 1030.9690709278734, 1047.706642140202, 1071.3625392891217, 1142.2061667141256, 13278.66803329905, 13691.657708557366, 15534.1456219909, 15788.60528486797, 16127.274272657523, 120890.39554802346, 121337.0, 121864.39067804781, 126231.3688431552, 134714.32642836723, 51680.483195168315, 51772.482275176764, 51777.741111294956, 51810.0, 51894.74052629788, 1336.4787732784223, 1352.0670737191306, 1365.9521916732867, 1371.6022353517567, 1373.7115205806692, 27939.58090628683, 29544.852275738485, 29709.5543566851, 30261.394772104875, 30283.394332113676, 46055.53944460512, 46305.53694463147, 46409.0, 46428.767856160506, 46445.535544644124, 288908.0, 294941.0, 396484.0, 412449.0, 412570.0, 31037.689623104383, 31081.222969425944, 31179.844100780258, 31180.688193118687, 31189.220269492536, 43501.56498434975, 43968.56031439773, 44146.33780493231, 45025.32462013138, 45127.77436112799, 36280.09299767527, 36681.266374672894, 36689.44965825461, 37097.629023709414, 37434.812825935696, 36702.0, 37112.44331334978, 37263.813680931424, 37978.24043519169, 38074.619253807105, 35474.46788298126, 36487.0, 36708.26583468262, 36724.44913326249, 36768.26463470662, 32917.341653167285, 33714.59070117738, 33715.494267586495, 33939.321213576084, 34335.656643434246, 25183.748162518874, 25507.744922550537, 25662.230133096036, 25815.225543233733, 25980.090696825522], "unit": "score", "name": "ext.html", "value": 18057.020496099667}, {"lowerIsBetter": false, "replicates": [347.91650003999047, 350.55654596934863, 352.6297387742869, 355.57686353239643, 357.3210899291346, 13926.303684815744, 14348.497802576912, 16005.519834404957, 16206.270717817697, 17049.82950170498, 14631.561053168421, 15714.764278535831, 16014.119223442705, 16018.279177437014, 16300.184990750475, 5285.814996475124, 5412.4587541245955, 5418.620696551243, 5421.430749771276, 5423.403425623178, 4024.537178224498, 4145.067359844026, 5334.093204155303, 5362.088444964365, 5707.343655479611, 5803.854903627422, 5822.1266809978415, 5843.912341314884, 5857.238558987326, 5867.061270196769, 5649.435056494359, 5813.476787089161, 5817.7382017809305, 5818.679972601505, 5835.212246346774, 5108.412532558729, 5112.130937740556, 5126.307948426989, 5127.743612819344, 5130.025295193901, 11557.595484158099, 11932.284062956163, 19156.329528466576, 19884.70172947407, 19932.501687457785, 1948.2888745607893, 2097.3857513470425, 2100.3698890332994, 2146.4741138421186, 2170.5984392887367, 9493.335466517347, 9757.170640495495, 10007.149392301662, 10463.79072418555, 13391.330433478288, 1777.626698393339, 1812.5287425269394, 1844.6956252218367, 1848.112905805221, 1865.9440216793519, 61509.0, 61807.0, 62902.0, 63267.0, 64038.359616404174, 9742.415455072718, 9944.502774861228, 9960.352577082467, 9986.700398987896, 9994.550245238981, 12985.545505907248, 13117.344132793321, 13126.0, 13148.60554183376, 13159.736805263841, 7300.4159667226495, 7335.88996165058, 7512.699492020258, 7536.811579710551, 7638.274363935418, 7030.0, 7057.858842823218, 7437.070366204224, 7490.0, 7490.70037198506, 4320.719153255029, 4336.631386332134, 4384.890377740582, 4416.889577760582, 4476.970296831747, 1646.4648989078598, 1677.3961373905383, 1682.0916704979418, 1729.8529624982018, 1785.9910700446414, 849.4181485682327, 850.7277671145174, 1033.379972016784, 1033.565902321027, 1057.3972835483855, 15805.209739512979, 15988.440404586016, 16051.438199662956, 16515.17424128813, 17142.0, 913.9405938613969, 940.3464592108419, 951.9381240219363, 965.2037069417759, 977.5454413697522, 9392.29557783169, 9545.665901693546, 9552.704317010759, 9910.752231194134, 10106.696799096038, 498379.0, 549461.0, 551319.0, 564766.0, 566127.0, 63976.4812935293, 70243.29756702368, 71366.0, 73065.6346718263, 73852.0, 1160.3675996581715, 1171.77736230116, 1172.8533933258343, 1196.521391443412, 1196.8503937007874, 14483.348249329016, 15224.238788060775, 15481.612959676098, 15669.451569195024, 15855.365785368456, 31336.843315784186, 32190.35619287648, 32254.83872580622, 32280.515792262664, 33360.332793343514, 38551.61448385593, 40109.39835902405, 40330.79834600808, 42912.0, 43079.7846010768, 8949.776255593662, 9547.28395370364, 9609.183219426428, 9657.46883921391, 9738.707838764565, 11012.17408694335, 11099.500522476346, 11159.0, 11159.330440173615, 11941.880581194077, 14215.573532794033, 14220.288985550887, 14235.572932812032, 14434.566962991126, 14437.0, 13954.23251721165, 14047.648808779863, 14207.502737404142, 14507.709845803236, 14708.705825883637, 15094.622634434227, 15190.848091518943, 15446.0, 15517.301721422336, 15566.143862087694, 9312.48781317034, 9324.627014919599, 9403.717888463358, 9405.670801521914, 9428.528573571431, 10122.139618132542, 11861.881381186078, 14261.500847470288, 14418.13491190532, 15014.6997060056], "unit": "score", "name": "jquery.html", "value": 8626.735584431435}, {"lowerIsBetter": false, "replicates": [1291.5350473829415, 1440.4958264607385, 1441.2217402602591, 1579.620890986163, 1742.8692848036392, 6621.536492445524, 6821.420179284761, 6911.619860907648, 6936.826579335519, 6942.861142777141, 7130.786076417703, 7322.890156647654, 7347.926520734791, 7355.374793142576, 7366.152892417374, 1887.3016983716045, 1937.6705959986837, 2023.2109477303864, 2069.0896005757495, 2156.967645485319, 2196.3301193136085, 2203.7025001624816, 2206.305013920618, 2207.6578130389735, 2207.724034495688, 2080.427882332363, 2140.0262880389464, 2140.860844045132, 2141.7429908411013, 2146.61360955028, 2050.3028970150144, 2083.3541602103396, 2097.6958341040463, 2102.7792081831494, 2105.705201271823, 2166.263470420049, 2168.978310216909, 2193.7915897989665, 2195.056125865877, 2195.9780402195934, 7134.2509036551455, 7243.275672432767, 7266.781996540112, 7268.2368351322875, 7282.016927714743, 4315.093830295642, 4379.08039311745, 4394.4946331172005, 4410.558944105596, 4414.955850441486, 2897.4494845979407, 2931.2378781516745, 2976.955345669817, 2987.850607469618, 3031.4998025326017, 960.0975083421562, 964.4743614729989, 976.379998700823, 977.7653363192853, 990.484947827133, 10136.442495662735, 10147.137493313077, 10149.644762433354, 10150.13723833475, 10151.492425378701, 3988.7806170660892, 3989.800509974548, 4022.1151346703678, 4027.2348253832265, 4070.063885306396, 8693.565321733888, 8768.473891566398, 8769.868451973225, 8777.824443511221, 8788.824223515494, 4477.529859364719, 4492.528284530143, 4503.482099558527, 4511.052678937394, 4514.683972121986, 4055.411965265079, 4115.032967252693, 4115.36211887158, 4121.031557583965, 4121.175764847043, 3204.182933352027, 3248.707616314543, 3389.508521264403, 3420.538227339327, 3491.581010278732, 1067.4235912607105, 1077.1490522487147, 1081.7566047639375, 1108.7449886526144, 1113.2151832957907, 1027.8920713325142, 1034.4517405774952, 1238.4241327782624, 1290.7805673035418, 1311.1477539599146, 7046.330598593126, 7102.396296314768, 7109.715611375487, 7122.5726456412785, 7130.037444944866, 1082.2910993299402, 1100.0594491709633, 1109.8224284114503, 1112.1047556716921, 1123.152020224725, 5528.50730302824, 5583.748731307101, 5584.832455026356, 5584.972075139598, 5605.047141985872, 8274.0, 8302.377321700897, 8347.207015333533, 8441.620127094295, 8465.195806398382, 8353.95823020881, 8435.11431299717, 8450.66197352099, 8477.491350518865, 8480.363972702073, 6650.634215118215, 6687.665616719145, 6791.966040169867, 6793.252742198354, 6819.352161544645, 6590.077389165616, 6598.0, 6601.768938087144, 6621.073049773132, 6622.337766223339, 7441.776746697607, 7508.174100848793, 7546.622668866425, 7638.427117966286, 7646.541207527566, 7665.156832748505, 7767.883481747891, 7830.686772529263, 7933.325667318342, 7944.6822127114265, 6163.568550201443, 6213.409726076015, 6218.191635087591, 6220.7511699533325, 6223.253209614875, 6761.695723692544, 6906.412954898889, 6917.550359226634, 6936.687849046906, 6953.443724501926, 6489.448396886318, 6497.285298617243, 6601.10885030534, 6687.595604923021, 6707.631080290631, 6394.520410969103, 6426.068220107964, 6463.903041454288, 6542.051402546509, 6595.0, 6541.0, 6542.967285163544, 6548.345165483413, 6560.803175904731, 6563.278039415756, 6030.90953635687, 6032.728527216374, 6036.245469316335, 6058.212432383762, 6074.331823499323, 6176.042713379434, 6278.560500764903, 6299.055141728777, 6308.116863639002, 6314.989601663712], "unit": "score", "name": "mootools.html", "value": 4216.025495800234}, {"lowerIsBetter": false, "replicates": [333.4747772258692, 337.33376581252014, 338.4027192006108, 341.8102952861163, 345.3283363857297, 5817.941820581798, 5857.238558987337, 5862.062070068784, 5874.735636896339, 5901.20333754944, 5524.944750552493, 5611.9438805611935, 5679.318481782192, 5764.711764411783, 5767.509761670263, 4506.526814684444, 4522.728636281817, 4525.411696479453, 4528.660350473711, 4551.340055691922, 4516.706414083091, 4526.434195725535, 4539.659525535581, 4543.477500087482, 4554.180247555439, 4300.827966881321, 4387.758673272969, 4405.339199120125, 4463.68754187207, 4511.7969691363805, 4483.327500874862, 4485.573870482299, 4491.461024677027, 4493.842715504941, 4497.100579884036, 3986.7009974251755, 3989.960100398988, 3993.0616305168264, 3996.4205190247253, 4006.0, 5517.889642207174, 5526.861828454321, 5531.917021244684, 5545.944540554583, 5550.86122846928, 5123.795048198068, 5234.607404444682, 5241.056609810233, 5243.161094224944, 5255.632105752599, 6117.082437634346, 6141.631502109888, 6153.384661533811, 6160.168377269056, 6160.322364539897, 4367.301231802928, 4372.322290045048, 4377.781110944472, 4413.668974826901, 4416.84541041062, 6212.409821066992, 6389.009703495965, 6394.392532709385, 6396.26442959061, 6397.168368112162, 4442.311441726538, 4449.9777501112285, 4450.866474005785, 4456.3538286948215, 4465.285554311295, 4505.324201369821, 4508.864734057984, 4509.0, 4509.842155524541, 4514.796834142471, 5136.0, 5166.767495462638, 5175.689458632494, 5177.456367081478, 5178.197379406198, 6053.667048312297, 6175.752969881244, 6177.289611694623, 6189.164462797555, 6191.81424557264, 1603.6471976165226, 1620.440947872982, 1622.9513114606345, 1624.025584649201, 1625.5610985033975, 1109.938953357557, 1111.111111111108, 1121.1927412263158, 1121.9495122719497, 1136.7158210447387, 5837.620554663933, 5846.473817356458, 5853.765849366063, 5855.531557475391, 5862.794802181903, 6338.968305158444, 6344.143540622049, 6349.936500635027, 6360.586561873463, 6362.268339141058, 5644.407337229532, 5767.480926716616, 5795.594308398456, 5846.1230815377185, 5920.437558431942, 3436.536067630888, 3438.7420943428842, 3460.0657822387816, 3460.2733425980323, 3465.2722928184858, 6619.073329733841, 6678.09845670838, 6680.365365290289, 6687.0, 6688.0, 6411.551191416556, 6545.967270163619, 6547.181602299713, 6564.98242772371, 6579.0, 6648.933510664831, 6668.766593169215, 6670.099536562502, 6670.599764014078, 6680.899786503109, 6402.647854368054, 6405.103285540122, 6405.967970160305, 6412.2625898022325, 6417.71120299597, 6232.937670623236, 6328.272248691275, 6343.207099112611, 6345.1434056401795, 6347.428731414195, 6624.039514270307, 6642.867142657216, 6643.269240383457, 6646.468282537482, 6658.766943156967, 4542.477615074176, 4542.704724192917, 4548.295014272793, 4548.3859678944245, 4552.226121559276, 6307.0, 6404.103425520524, 6415.390537898892, 6425.678716064084, 6428.839279018062, 6249.218847644044, 6251.031090181029, 6258.249010118633, 6259.405356491126, 6263.96868015657, 6178.845528861814, 6204.472619827366, 6209.348018457997, 6216.316205217513, 6229.0967809668255, 6002.189704389852, 6116.327204007466, 6120.387961203844, 6123.2958209804665, 6131.662758548323, 6254.593451425642, 6257.9687101564205, 6258.405451482102, 6259.217597800275, 6270.278917924315, 6037.818865434044, 6064.241969753781, 6064.575479716377, 6078.088286756845, 6088.056351265561], "unit": "score", "name": "prototype.html", "value": 4702.958524739928}, {"lowerIsBetter": false, "replicates": [667.4827009067972, 699.5732603112101, 815.6615004773016, 821.1624143373755, 826.1366871619157, 12651.936740316298, 12826.102172847905, 12837.550685726, 12871.034672399584, 12890.033247506439, 11487.195896287263, 11578.363190024545, 11596.594119205829, 13958.581242562714, 14531.491397801079, 681.6285124607076, 692.5636848785258, 820.7578764264556, 838.375410319313, 850.4854562989395, 838.1618381618382, 840.9159084091604, 842.970496032639, 843.6372359885247, 845.3997661660198, 704.4012589299081, 713.3722324354586, 880.8810810540559, 889.1020069729555, 889.2574700125404, 866.4584634603373, 892.3485855325648, 893.0444424465824, 894.025512191711, 898.420518765396, 638.5274896576547, 644.5262731892055, 644.6969924135649, 644.7904431059924, 644.8452371430869, 13409.798853017213, 13465.394057267447, 13521.323933803369, 13546.322683865867, 13560.796588051187, 11745.119116066244, 11765.294082355085, 11868.347240901747, 12573.434195461226, 12960.481580736854, 9435.103665151799, 9505.952470237604, 9746.269029822792, 9817.90182098177, 9877.209823214198, 3577.373959557067, 3590.6768390844686, 3602.261536385061, 3609.5127157833617, 3627.4740162676526, 48617.51382486165, 48737.51262487365, 48877.5112248873, 49472.25791613129, 49861.0, 9207.63169473227, 9689.0, 9805.901940980499, 10635.202359823044, 10738.194635402377, 18465.5383615408, 18757.624847503248, 18785.34251301198, 18800.15399307007, 18801.153948072097, 7280.235575264627, 7294.8176295591975, 7475.0, 7512.286332798375, 7622.161562228151, 3985.4021896715144, 3990.461287726178, 4006.3536007887274, 4052.7365721228025, 4100.0159961609, 2761.226856480189, 2794.3433293176085, 2795.5247607906704, 2795.636567246245, 2835.6738975017724, 523.8716514453984, 537.8655336165958, 545.4000599340773, 546.9835904922859, 547.6029878338173, 523.6491550661066, 530.7028064284013, 589.4576989169974, 621.6891554222889, 624.6252248650864, 7824.804379890548, 8008.799780005546, 8051.154628763896, 8059.113497515269, 8144.959275203586, 550.7598904412991, 623.5167744997573, 639.3702203329716, 642.7525402719893, 656.1797752808989, 3656.670899619047, 3713.9788795417808, 3826.521684789401, 3848.8845334640005, 3853.6531712146043, 57958.0, 58332.70833645805, 58436.707816461494, 58465.70767146137, 58499.0, 49411.0, 49508.50491495111, 49866.75066624644, 50022.499775002514, 50679.0, 45805.0, 46565.5343446568, 46770.5322946773, 47581.0, 47873.281900771515, 8376.832463350576, 8509.0, 8587.313014958663, 8881.467111973303, 8953.820923581623, 34383.0, 34573.65426345704, 35478.822605887835, 36079.63920360763, 36166.63833361738, 43497.78251108851, 43755.34366984561, 44500.0, 45156.548434516546, 45513.0, 10434.321769084985, 11133.888661113286, 11150.932313910645, 11269.71825704364, 11815.822762658396, 12248.877511224773, 12689.428975695932, 12717.872821271669, 13072.80390794158, 13093.083484156017, 11438.771224575295, 11622.88377116218, 11731.23746956445, 11814.763704726029, 12184.0, 11486.655400338002, 11553.711157221136, 11844.0, 12230.082743794073, 12236.87763122393, 7508.58702771331, 9594.799696449154, 10993.560257589927, 11248.718782030515, 11375.488103035217, 8608.139186081593, 9570.521473926416, 9822.852657210005, 9841.360311579725, 9959.103680668775, 9226.40028398152, 9421.811563768822, 9490.620375184915, 9603.615855365708, 9628.0], "unit": "score", "name": "yui.html", "value": 6201.184717905461}], "name": "dromaeo_css", "value": 6804.209841919384}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 106.0, 112.0, 113.0, 112.0, 101.0, 113.0, 113.0, 100.0], "unit": "score", "name": "ai-astar", "value": 109.4}, {"lowerIsBetter": true, "replicates": [147.0, 128.0, 156.0, 169.0, 127.0, 152.0, 152.0, 123.0, 160.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 144.0}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 163.0, 160.0, 160.0, 159.0, 162.0, 162.0, 160.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 87.0, 94.0, 71.0, 74.0, 71.0, 97.0, 93.0, 74.0], "unit": "score", "name": "audio-fft", "value": 80.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 140.0, 95.0, 96.0, 96.0, 150.0, 95.0, 96.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 110.2}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 108.0, 109.0, 109.0, 108.0, 108.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 108.7}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 147.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [61.0, 58.0, 60.0, 59.0, 58.0, 59.0, 62.0, 59.0, 57.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 59.0}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 73.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [86.0, 88.0, 86.0, 86.0, 87.0, 87.0, 86.0, 86.0, 89.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.8}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 117.0, 120.0, 116.0, 127.0, 122.0, 126.0, 131.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.3}, {"lowerIsBetter": true, "replicates": [142.0, 142.0, 153.0, 163.0, 152.0, 147.0, 153.0, 151.0, 152.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.6}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 71.0, 73.0, 73.0, 69.0, 70.0, 72.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.9}], "name": "kraken", "value": 1509.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.36401673640168], "unit": "score", "name": "Richards", "value": 210.92945000000006}, {"lowerIsBetter": false, "replicates": [190.83969465648855], "unit": "score", "name": "DeltaBlue", "value": 346.45831999999996}, {"lowerIsBetter": false, "replicates": [281.7695125387433], "unit": "score", "name": "Encrypt", "value": 944.6763689999997}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [1932.4324324324325], "unit": "score", "name": "RayTrace", "value": 382.9313706293705}, {"lowerIsBetter": false, "replicates": [798.7220447284345], "unit": "score", "name": "Earley", "value": 834.4116759999996}, {"lowerIsBetter": false, "replicates": [12060.240963855422], "unit": "score", "name": "Boyer", "value": 55.2611678321678}, {"lowerIsBetter": false, "replicates": [26894.736842105263], "unit": "score", "name": "RegExp", "value": 33.87224070450098}, {"lowerIsBetter": false, "replicates": [591.016548463357], "unit": "score", "name": "Splay", "value": 137.882772}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19790.564487277174}]} 17:10:07 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19790.56"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1509.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6804.21"}}} 17:10:07 INFO - Return code: 0 17:10:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:10:07 INFO - # TBPL SUCCESS # 17:10:07 INFO - Running post-action listener: _resource_record_post_action 17:10:07 INFO - Running post-run listener: _resource_record_post_run 17:10:08 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 9773056; Write bytes: 557322240; Read time: 3660; Write time: 660376 17:10:08 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 234979328; Read time: 108; Write time: 307884 17:10:08 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 7901184; Write bytes: 321720320; Read time: 3172; Write time: 352492 17:10:08 INFO - Running post-run listener: _upload_blobber_files 17:10:08 INFO - Blob upload gear active. 17:10:08 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:10:08 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 17:10:08 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'] 17:10:08 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 17:10:09 INFO - (blobuploader) - INFO - Open directory for files ... 17:10:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 17:10:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:10:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:10:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:10:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:10:09 INFO - (blobuploader) - INFO - Done attempting. 17:10:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:10:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:10:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:10:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:10:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:10:10 INFO - (blobuploader) - INFO - Done attempting. 17:10:10 INFO - (blobuploader) - INFO - Iteration through files over. 17:10:10 INFO - Return code: 0 17:10:10 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:10:10 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:10:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f71a497103d8e14404d532436773687f90780d8243c31c505ca6da9f4ebaae1a100d6ce135c2f74ec96557f6e48931d9864b54cb41d34bff6901a8394c7c64bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3cbd5afca82c31d6a41481fd347d3e079cdda84828190c1e32d26513c9b09b7fa93545255b745bb69c24ce792532f9897fee4e6eab9f639d3790bd7ffb4c641b"} 17:10:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:10:10 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:10:10 INFO - Contents: 17:10:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f71a497103d8e14404d532436773687f90780d8243c31c505ca6da9f4ebaae1a100d6ce135c2f74ec96557f6e48931d9864b54cb41d34bff6901a8394c7c64bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3cbd5afca82c31d6a41481fd347d3e079cdda84828190c1e32d26513c9b09b7fa93545255b745bb69c24ce792532f9897fee4e6eab9f639d3790bd7ffb4c641b"} 17:10:10 INFO - Copying logs to upload dir... 17:10:10 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1277.819337 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-31 17:10:10.454136) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-31 17:10:10.461850) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1451593341.309537-888449318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f71a497103d8e14404d532436773687f90780d8243c31c505ca6da9f4ebaae1a100d6ce135c2f74ec96557f6e48931d9864b54cb41d34bff6901a8394c7c64bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3cbd5afca82c31d6a41481fd347d3e079cdda84828190c1e32d26513c9b09b7fa93545255b745bb69c24ce792532f9897fee4e6eab9f639d3790bd7ffb4c641b"} build_url:https://queue.taskcluster.net/v1/task/fLLi6ttNQXq0xgKsOuNzcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011142 build_url: 'https://queue.taskcluster.net/v1/task/fLLi6ttNQXq0xgKsOuNzcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f71a497103d8e14404d532436773687f90780d8243c31c505ca6da9f4ebaae1a100d6ce135c2f74ec96557f6e48931d9864b54cb41d34bff6901a8394c7c64bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3cbd5afca82c31d6a41481fd347d3e079cdda84828190c1e32d26513c9b09b7fa93545255b745bb69c24ce792532f9897fee4e6eab9f639d3790bd7ffb4c641b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-31 17:10:10.488935) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 17:10:10.489252) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1451593341.309537-888449318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 17:10:10.538143) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-31 17:10:10.541480) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-31 17:10:10.541782) ========= ========= Total master_lag: 0.16 =========