builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-009 starttime: 1451922952.08 results: success (0) buildid: 20160104053008 builduid: ee716b97e42046aaa9c9d7f4fe29dda0 revision: e31a99e1f8677a11926462aebfbdfbce16afe2f8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 07:55:52.084618) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 07:55:52.085274) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 07:55:52.085585) ========= 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=aa52b8aba932b19cc50b5275000001de-1451921101.252698-1044458391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006359 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 07:55:52.114095) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 07:55:52.114407) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 07:55:52.137138) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 07:55:52.137453) ========= 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=aa52b8aba932b19cc50b5275000001de-1451921101.252698-1044458391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004666 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 07:55:52.195075) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 07:55:52.195367) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 07:55:52.195769) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 07:55:52.196039) ========= 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=aa52b8aba932b19cc50b5275000001de-1451921101.252698-1044458391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-04 07:55:52-- 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% 60.0M=0s 2016-01-04 07:55:52 (60.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150044 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 07:55:52.358254) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 07:55:52.358561) ========= 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=aa52b8aba932b19cc50b5275000001de-1451921101.252698-1044458391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020773 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 07:55:52.408541) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 07:55:52.408888) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e31a99e1f8677a11926462aebfbdfbce16afe2f8 --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 e31a99e1f8677a11926462aebfbdfbce16afe2f8 --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=aa52b8aba932b19cc50b5275000001de-1451921101.252698-1044458391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-04 07:55:52,564 truncating revision to first 12 chars 2016-01-04 07:55:52,564 Setting DEBUG logging. 2016-01-04 07:55:52,564 attempt 1/10 2016-01-04 07:55:52,564 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e31a99e1f867?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-04 07:55:52,811 unpacking tar archive at: fx-team-e31a99e1f867/testing/mozharness/ program finished with exit code 0 elapsedTime=0.529845 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 07:55:52.951598) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 07:55:52.951909) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 07:55:52.961448) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 07:55:52.961842) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 07:55:52.962340) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-04 07:55:52.962641) ========= /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=aa52b8aba932b19cc50b5275000001de-1451921101.252698-1044458391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:55:53 INFO - MultiFileLogger online at 20160104 07:55:53 in /builds/slave/test-pgo 07:55: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 07:55:53 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:55:53 INFO - {'append_to_log': False, 07:55:53 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:55:53 INFO - 'blob_upload_branch': 'Fx-Team', 07:55:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:55:53 INFO - 'branch': 'Fx-Team', 07:55:53 INFO - 'buildbot_json_path': 'buildprops.json', 07:55:53 INFO - 'config_files': ('talos/linux_config.py',), 07:55:53 INFO - 'default_actions': ('clobber', 07:55:53 INFO - 'read-buildbot-config', 07:55:53 INFO - 'download-and-extract', 07:55:53 INFO - 'populate-webroot', 07:55:53 INFO - 'create-virtualenv', 07:55:53 INFO - 'install', 07:55:53 INFO - 'run-tests'), 07:55:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:55:53 INFO - 'download_minidump_stackwalk': True, 07:55:53 INFO - 'download_symbols': 'ondemand', 07:55:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:55:53 INFO - 'tooltool.py': '/tools/tooltool.py', 07:55:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:55:53 INFO - '/tools/misc-python/virtualenv.py')}, 07:55:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:55:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:55:53 INFO - 'installer_path': 'installer.exe', 07:55:53 INFO - 'log_level': 'info', 07:55:53 INFO - 'log_name': 'talos', 07:55:53 INFO - 'log_to_console': True, 07:55:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:55:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:55:53 INFO - 'opt_config_files': (), 07:55:53 INFO - 'pip_index': False, 07:55:53 INFO - 'sps_profile': False, 07:55:53 INFO - 'sps_profile_interval': 0, 07:55:53 INFO - 'suite': 'dromaeojs', 07:55:53 INFO - 'system_bits': '32', 07:55:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:55:53 INFO - 'title': 'talos-linux64-ix-009', 07:55:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:55:53 INFO - 'use_talos_json': True, 07:55:53 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:55:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:55:53 INFO - 'work_dir': 'build'} 07:55:53 INFO - ##### 07:55:53 INFO - ##### Running clobber step. 07:55:53 INFO - ##### 07:55:53 INFO - Running pre-action listener: _resource_record_pre_action 07:55:53 INFO - Running main action method: clobber 07:55:53 INFO - rmtree: /builds/slave/test-pgo/build 07:55:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:55:54 INFO - Running post-action listener: _resource_record_post_action 07:55:54 INFO - ##### 07:55:54 INFO - ##### Running read-buildbot-config step. 07:55:54 INFO - ##### 07:55:54 INFO - Running pre-action listener: _resource_record_pre_action 07:55:54 INFO - Running main action method: read_buildbot_config 07:55:54 INFO - Using buildbot properties: 07:55:54 INFO - { 07:55:54 INFO - "project": "", 07:55:54 INFO - "product": "firefox", 07:55:54 INFO - "script_repo_revision": "production", 07:55:54 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:55:54 INFO - "repository": "", 07:55:54 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 07:55:54 INFO - "buildid": "20160104053008", 07:55:54 INFO - "pgo_build": "True", 07:55:54 INFO - "basedir": "/builds/slave/test-pgo", 07:55:54 INFO - "buildnumber": 567, 07:55:54 INFO - "slavename": "talos-linux64-ix-009", 07:55:54 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:55:54 INFO - "platform": "ubuntu64_hw", 07:55:54 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 07:55:54 INFO - "branch": "fx-team", 07:55:54 INFO - "repo_path": "integration/fx-team", 07:55:54 INFO - "revision": "e31a99e1f8677a11926462aebfbdfbce16afe2f8", 07:55:54 INFO - "stage_platform": "linux64-pgo", 07:55:54 INFO - "builduid": "ee716b97e42046aaa9c9d7f4fe29dda0", 07:55:54 INFO - "slavebuilddir": "test" 07:55:54 INFO - } 07:55:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/FtdBAnaaTRa9fLMqZLODwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:55:54 INFO - Running post-action listener: _resource_record_post_action 07:55:54 INFO - ##### 07:55:54 INFO - ##### Running download-and-extract step. 07:55:54 INFO - ##### 07:55:54 INFO - Running pre-action listener: _resource_record_pre_action 07:55:54 INFO - Running main action method: download_and_extract 07:55:54 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:55: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')]} 07:55:54 INFO - https://queue.taskcluster.net/v1/task/FtdBAnaaTRa9fLMqZLODwQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:55:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtdBAnaaTRa9fLMqZLODwQ/artifacts/public/build/test_packages.json 07:55:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtdBAnaaTRa9fLMqZLODwQ/artifacts/public/build/test_packages.json 07:55:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtdBAnaaTRa9fLMqZLODwQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:55:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtdBAnaaTRa9fLMqZLODwQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:55:56 INFO - Downloaded 1302 bytes. 07:55:56 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:55:56 INFO - Using the following test package requirements: 07:55:56 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:55:56 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:55:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:55:56 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:55:56 INFO - u'jsshell-linux-x86_64.zip'], 07:55:56 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:55:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:55:56 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:55:56 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:55:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:55:56 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:55:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:55:56 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:55:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:55:56 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:55:56 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:55:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:55:56 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:55:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:56 INFO - https://queue.taskcluster.net/v1/task/FtdBAnaaTRa9fLMqZLODwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:55:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtdBAnaaTRa9fLMqZLODwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:55:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtdBAnaaTRa9fLMqZLODwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:55:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtdBAnaaTRa9fLMqZLODwQ/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 07:55:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtdBAnaaTRa9fLMqZLODwQ/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 07:55:59 INFO - Downloaded 23198212 bytes. 07:55:59 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 07:55:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:55:59 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 07:56:00 INFO - Return code: 0 07:56:00 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 07:56:00 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')]} 07:56:00 INFO - https://queue.taskcluster.net/v1/task/FtdBAnaaTRa9fLMqZLODwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:56:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtdBAnaaTRa9fLMqZLODwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:56:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtdBAnaaTRa9fLMqZLODwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:56:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtdBAnaaTRa9fLMqZLODwQ/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 07:56:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtdBAnaaTRa9fLMqZLODwQ/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 07:56:01 INFO - Downloaded 23198212 bytes. 07:56:01 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 07:56:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:56:01 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 07:56:02 INFO - Return code: 0 07:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:02 INFO - https://queue.taskcluster.net/v1/task/FtdBAnaaTRa9fLMqZLODwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:56:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtdBAnaaTRa9fLMqZLODwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:56:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtdBAnaaTRa9fLMqZLODwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:56:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtdBAnaaTRa9fLMqZLODwQ/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 07:56:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtdBAnaaTRa9fLMqZLODwQ/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 07:56:03 INFO - Downloaded 11132285 bytes. 07:56:03 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 07:56:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:56:03 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 07:56:04 INFO - Return code: 0 07:56:04 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')]} 07:56:04 INFO - https://queue.taskcluster.net/v1/task/FtdBAnaaTRa9fLMqZLODwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:56:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtdBAnaaTRa9fLMqZLODwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:56:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtdBAnaaTRa9fLMqZLODwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:56:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtdBAnaaTRa9fLMqZLODwQ/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 07:56:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FtdBAnaaTRa9fLMqZLODwQ/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 07:56:05 INFO - Downloaded 54978566 bytes. 07:56:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FtdBAnaaTRa9fLMqZLODwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:56:05 INFO - mkdir: /builds/slave/test-pgo/properties 07:56:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:56:05 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:56:05 INFO - Contents: 07:56:05 INFO - build_url:https://queue.taskcluster.net/v1/task/FtdBAnaaTRa9fLMqZLODwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:56:05 INFO - Running post-action listener: _resource_record_post_action 07:56:05 INFO - Running post-action listener: set_extra_try_arguments 07:56:05 INFO - ##### 07:56:05 INFO - ##### Running populate-webroot step. 07:56:05 INFO - ##### 07:56:05 INFO - Running pre-action listener: _resource_record_pre_action 07:56:05 INFO - Running main action method: populate_webroot 07:56:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:56:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:56:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:56:05 INFO - '--tppagecycles', 07:56:05 INFO - '7'], 07:56:05 INFO - 'tests': ['tsvgm']}}, 07:56:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:56:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:56:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:56:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:56:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:56:05 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:56:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:56:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:05 INFO - 'talos_options': ['--e10s'], 07:56:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:56:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:05 INFO - 'tests': ['damp', 'tps']}, 07:56:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:05 INFO - 'talos_options': ['--e10s'], 07:56:05 INFO - 'tests': ['damp', 'tps']}, 07:56:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:56:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:56:05 INFO - 'other': {'tests': ['a11yr', 07:56:05 INFO - 'ts_paint', 07:56:05 INFO - 'tpaint', 07:56:05 INFO - 'sessionrestore', 07:56:05 INFO - 'sessionrestore_no_auto_restore']}, 07:56:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:56:05 INFO - 'tests': ['a11yr', 07:56:05 INFO - 'ts_paint', 07:56:05 INFO - 'tpaint', 07:56:05 INFO - 'sessionrestore', 07:56:05 INFO - 'sessionrestore_no_auto_restore']}, 07:56:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:56:05 INFO - 'tests': ['a11yr', 07:56:05 INFO - 'ts_paint', 07:56:05 INFO - 'tpaint', 07:56:05 INFO - 'sessionrestore', 07:56:05 INFO - 'sessionrestore_no_auto_restore']}, 07:56:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:56:05 INFO - 'tests': ['a11yr', 07:56:05 INFO - 'ts_paint', 07:56:05 INFO - 'tpaint', 07:56:05 INFO - 'sessionrestore', 07:56:05 INFO - 'sessionrestore_no_auto_restore']}, 07:56:05 INFO - 'other_l64': {'tests': ['a11yr', 07:56:05 INFO - 'ts_paint', 07:56:05 INFO - 'tpaint', 07:56:05 INFO - 'sessionrestore', 07:56:05 INFO - 'sessionrestore_no_auto_restore']}, 07:56:05 INFO - 'other_nol64': {'tests': ['a11yr', 07:56:05 INFO - 'ts_paint', 07:56:05 INFO - 'tpaint', 07:56:05 INFO - 'sessionrestore', 07:56:05 INFO - 'sessionrestore_no_auto_restore']}, 07:56:05 INFO - 'svgr': {'tests': ['tsvgx', 07:56:05 INFO - 'tsvgr_opacity', 07:56:05 INFO - 'tart', 07:56:05 INFO - 'tscrollx', 07:56:05 INFO - 'cart']}, 07:56:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:56:05 INFO - 'tests': ['tsvgx', 07:56:05 INFO - 'tsvgr_opacity', 07:56:05 INFO - 'tart', 07:56:05 INFO - 'tscrollx', 07:56:05 INFO - 'cart']}, 07:56:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:05 INFO - 'tests': ['tp5o']}, 07:56:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:05 INFO - 'talos_options': ['--e10s'], 07:56:05 INFO - 'tests': ['tp5o']}, 07:56:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:05 INFO - 'talos_options': ['--xperf_path', 07:56:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:56:05 INFO - 'tests': ['tp5n']}, 07:56:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:05 INFO - 'talos_options': ['--e10s', 07:56:05 INFO - '--xperf_path', 07:56:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:56:05 INFO - 'tests': ['tp5n']}}, 07:56:05 INFO - 'talos.zip': {'path': '', 07:56:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:56:05 INFO - Running post-action listener: _resource_record_post_action 07:56:05 INFO - ##### 07:56:05 INFO - ##### Running create-virtualenv step. 07:56:05 INFO - ##### 07:56:05 INFO - Running pre-action listener: _resource_record_pre_action 07:56:05 INFO - Running main action method: create_virtualenv 07:56:05 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:56:05 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 07:56:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:56:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:56:05 INFO - Using real prefix '/usr' 07:56:05 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:56:06 INFO - Installing distribute.............................................................................................................................................................................................done. 07:56:08 INFO - Installing pip.................done. 07:56:08 INFO - Return code: 0 07:56:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:08 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 0x7f189b323f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff840>, '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 0x276c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276cb60>, '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': 'aa52b8aba932b19cc50b5275000001de-1451921101.252698-1044458391', '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 07:56:08 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 07:56:08 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 07:56:08 INFO - Using env: {'DISPLAY': ':0', 07:56:08 INFO - 'HOME': '/home/cltbld', 07:56:08 INFO - 'LANG': 'en_US.UTF-8', 07:56:08 INFO - 'LANGUAGE': 'en_US:en', 07:56:08 INFO - 'LOGNAME': 'cltbld', 07:56:08 INFO - 'MAIL': '/var/mail/cltbld', 07:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:08 INFO - 'MOZ_NO_REMOTE': '1', 07:56:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:08 INFO - 'NO_EM_RESTART': '1', 07:56:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:56:08 INFO - 'PWD': '/builds/slave/test-pgo', 07:56:08 INFO - 'SHELL': '/bin/bash', 07:56:08 INFO - 'SHLVL': '1', 07:56:08 INFO - 'TERM': 'linux', 07:56:08 INFO - 'TMOUT': '86400', 07:56:08 INFO - 'USER': 'cltbld', 07:56:08 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1451921101.252698-1044458391', 07:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:08 INFO - '_': '/tools/buildbot/bin/python'} 07:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:56:08 INFO - Cleaning up... 07:56:08 INFO - Return code: 0 07:56:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:08 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 0x7f189b323f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff840>, '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 0x276c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276cb60>, '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': 'aa52b8aba932b19cc50b5275000001de-1451921101.252698-1044458391', '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 07:56:08 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 07:56:08 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 07:56:08 INFO - Using env: {'DISPLAY': ':0', 07:56:08 INFO - 'HOME': '/home/cltbld', 07:56:08 INFO - 'LANG': 'en_US.UTF-8', 07:56:08 INFO - 'LANGUAGE': 'en_US:en', 07:56:08 INFO - 'LOGNAME': 'cltbld', 07:56:08 INFO - 'MAIL': '/var/mail/cltbld', 07:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:08 INFO - 'MOZ_NO_REMOTE': '1', 07:56:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:08 INFO - 'NO_EM_RESTART': '1', 07:56:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:56:08 INFO - 'PWD': '/builds/slave/test-pgo', 07:56:08 INFO - 'SHELL': '/bin/bash', 07:56:08 INFO - 'SHLVL': '1', 07:56:08 INFO - 'TERM': 'linux', 07:56:08 INFO - 'TMOUT': '86400', 07:56:08 INFO - 'USER': 'cltbld', 07:56:08 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1451921101.252698-1044458391', 07:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:08 INFO - '_': '/tools/buildbot/bin/python'} 07:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:08 INFO - Downloading/unpacking psutil>=0.7.1 07:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:10 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 07:56:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:56:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:56:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:56:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:56:10 INFO - Installing collected packages: psutil 07:56:10 INFO - Running setup.py install for psutil 07:56:10 INFO - building 'psutil._psutil_linux' extension 07:56:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:56:10 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 07:56:10 INFO - building 'psutil._psutil_posix' extension 07:56:10 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 07:56:10 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 07:56:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:56:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:56:11 INFO - Successfully installed psutil 07:56:11 INFO - Cleaning up... 07:56:11 INFO - Return code: 0 07:56:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:11 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 0x7f189b323f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff840>, '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 0x276c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276cb60>, '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': 'aa52b8aba932b19cc50b5275000001de-1451921101.252698-1044458391', '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 07:56:11 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 07:56:11 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 07:56:11 INFO - Using env: {'DISPLAY': ':0', 07:56:11 INFO - 'HOME': '/home/cltbld', 07:56:11 INFO - 'LANG': 'en_US.UTF-8', 07:56:11 INFO - 'LANGUAGE': 'en_US:en', 07:56:11 INFO - 'LOGNAME': 'cltbld', 07:56:11 INFO - 'MAIL': '/var/mail/cltbld', 07:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:11 INFO - 'MOZ_NO_REMOTE': '1', 07:56:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:11 INFO - 'NO_EM_RESTART': '1', 07:56:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:56:11 INFO - 'PWD': '/builds/slave/test-pgo', 07:56:11 INFO - 'SHELL': '/bin/bash', 07:56:11 INFO - 'SHLVL': '1', 07:56:11 INFO - 'TERM': 'linux', 07:56:11 INFO - 'TMOUT': '86400', 07:56:11 INFO - 'USER': 'cltbld', 07:56:11 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1451921101.252698-1044458391', 07:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:11 INFO - '_': '/tools/buildbot/bin/python'} 07:56:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:56:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:56:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:56:13 INFO - Installing collected packages: mozsystemmonitor 07:56:13 INFO - Running setup.py install for mozsystemmonitor 07:56:13 INFO - Successfully installed mozsystemmonitor 07:56:13 INFO - Cleaning up... 07:56:13 INFO - Return code: 0 07:56:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:56: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')]} 07:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56: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')]} 07:56:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56: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', '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 0x7f189b323f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff840>, '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 0x276c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276cb60>, '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': 'aa52b8aba932b19cc50b5275000001de-1451921101.252698-1044458391', '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 07:56: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 07:56: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 blobuploader==1.2.4 07:56:13 INFO - Using env: {'DISPLAY': ':0', 07:56:13 INFO - 'HOME': '/home/cltbld', 07:56:13 INFO - 'LANG': 'en_US.UTF-8', 07:56:13 INFO - 'LANGUAGE': 'en_US:en', 07:56:13 INFO - 'LOGNAME': 'cltbld', 07:56:13 INFO - 'MAIL': '/var/mail/cltbld', 07:56:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:13 INFO - 'MOZ_NO_REMOTE': '1', 07:56:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:13 INFO - 'NO_EM_RESTART': '1', 07:56:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:56:13 INFO - 'PWD': '/builds/slave/test-pgo', 07:56:13 INFO - 'SHELL': '/bin/bash', 07:56:13 INFO - 'SHLVL': '1', 07:56:13 INFO - 'TERM': 'linux', 07:56:13 INFO - 'TMOUT': '86400', 07:56:13 INFO - 'USER': 'cltbld', 07:56:13 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1451921101.252698-1044458391', 07:56:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:13 INFO - '_': '/tools/buildbot/bin/python'} 07:56:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:13 INFO - Downloading/unpacking blobuploader==1.2.4 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56:15 INFO - Downloading blobuploader-1.2.4.tar.gz 07:56:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:56:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:56:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:56:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:56:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56:15 INFO - Downloading docopt-0.6.1.tar.gz 07:56:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:56:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:56:16 INFO - Installing collected packages: blobuploader, requests, docopt 07:56:16 INFO - Running setup.py install for blobuploader 07:56:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:56:16 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:56:16 INFO - Running setup.py install for requests 07:56:16 INFO - Running setup.py install for docopt 07:56:16 INFO - Successfully installed blobuploader requests docopt 07:56:16 INFO - Cleaning up... 07:56:16 INFO - Return code: 0 07:56:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:56:16 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')]} 07:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:16 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')]} 07:56:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:16 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 0x7f189b323f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff840>, '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 0x276c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276cb60>, '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': 'aa52b8aba932b19cc50b5275000001de-1451921101.252698-1044458391', '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 07:56:16 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 07:56:16 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 07:56:16 INFO - Using env: {'DISPLAY': ':0', 07:56:16 INFO - 'HOME': '/home/cltbld', 07:56:16 INFO - 'LANG': 'en_US.UTF-8', 07:56:16 INFO - 'LANGUAGE': 'en_US:en', 07:56:16 INFO - 'LOGNAME': 'cltbld', 07:56:16 INFO - 'MAIL': '/var/mail/cltbld', 07:56:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:16 INFO - 'MOZ_NO_REMOTE': '1', 07:56:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:16 INFO - 'NO_EM_RESTART': '1', 07:56:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:56:16 INFO - 'PWD': '/builds/slave/test-pgo', 07:56:16 INFO - 'SHELL': '/bin/bash', 07:56:16 INFO - 'SHLVL': '1', 07:56:16 INFO - 'TERM': 'linux', 07:56:16 INFO - 'TMOUT': '86400', 07:56:16 INFO - 'USER': 'cltbld', 07:56:16 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1451921101.252698-1044458391', 07:56:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:16 INFO - '_': '/tools/buildbot/bin/python'} 07:56:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:56:16 INFO - Running setup.py (path:/tmp/pip-OvfX14-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:56:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:56:16 INFO - Running setup.py (path:/tmp/pip-aLnCka-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:56:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:56:16 INFO - Running setup.py (path:/tmp/pip-CJr4bs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:56:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:56:17 INFO - Running setup.py (path:/tmp/pip-2KvJxB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:56:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:56:17 INFO - Running setup.py (path:/tmp/pip-Xuizw7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:56:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:56:17 INFO - Running setup.py (path:/tmp/pip-viKq0V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:56:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:56:17 INFO - Running setup.py (path:/tmp/pip-mq0L8u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:56:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:56:17 INFO - Running setup.py (path:/tmp/pip-Y_BJTs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:56:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:56:17 INFO - Running setup.py (path:/tmp/pip-_sDVnb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:56:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:56:17 INFO - Running setup.py (path:/tmp/pip-tNS6yS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:56:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:56:17 INFO - Running setup.py (path:/tmp/pip-PDYcsJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:56:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:56:17 INFO - Running setup.py (path:/tmp/pip-XXDTZ5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:56:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:56:17 INFO - Running setup.py (path:/tmp/pip-zjEfuS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:56:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:56:17 INFO - Running setup.py (path:/tmp/pip-MeihPb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:56:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:56:17 INFO - Running setup.py (path:/tmp/pip-hs5PNt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:56:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:56:17 INFO - Running setup.py (path:/tmp/pip-kv8XzA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:56:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:56:17 INFO - Running setup.py (path:/tmp/pip-_RsFsw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:56:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:56:18 INFO - Running setup.py install for manifestparser 07:56:18 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:56:18 INFO - Running setup.py install for mozcrash 07:56:18 INFO - Running setup.py install for mozdebug 07:56:18 INFO - Running setup.py install for mozdevice 07:56:18 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:56:18 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:56:18 INFO - Running setup.py install for mozfile 07:56:18 INFO - Running setup.py install for mozhttpd 07:56:18 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:56:18 INFO - Running setup.py install for mozinfo 07:56:18 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:56:18 INFO - Running setup.py install for mozInstall 07:56:18 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:56:18 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:56:18 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:56:18 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:56:18 INFO - Running setup.py install for mozleak 07:56:18 INFO - Running setup.py install for mozlog 07:56:19 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:56:19 INFO - Running setup.py install for moznetwork 07:56:19 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:56:19 INFO - Running setup.py install for mozprocess 07:56:19 INFO - Running setup.py install for mozprofile 07:56:19 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:56:19 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:56:19 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:56:19 INFO - Running setup.py install for mozrunner 07:56:19 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:56:19 INFO - Running setup.py install for mozscreenshot 07:56:19 INFO - Running setup.py install for moztest 07:56:19 INFO - Running setup.py install for mozversion 07:56:19 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:56:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:56:19 INFO - Cleaning up... 07:56:19 INFO - Return code: 0 07:56:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:56:19 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')]} 07:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:19 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')]} 07:56:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:19 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 0x7f189b323f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff840>, '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 0x276c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276cb60>, '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': 'aa52b8aba932b19cc50b5275000001de-1451921101.252698-1044458391', '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 07:56:19 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 07:56:19 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 07:56:19 INFO - Using env: {'DISPLAY': ':0', 07:56:19 INFO - 'HOME': '/home/cltbld', 07:56:19 INFO - 'LANG': 'en_US.UTF-8', 07:56:19 INFO - 'LANGUAGE': 'en_US:en', 07:56:19 INFO - 'LOGNAME': 'cltbld', 07:56:19 INFO - 'MAIL': '/var/mail/cltbld', 07:56:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:19 INFO - 'MOZ_NO_REMOTE': '1', 07:56:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:19 INFO - 'NO_EM_RESTART': '1', 07:56:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:56:19 INFO - 'PWD': '/builds/slave/test-pgo', 07:56:19 INFO - 'SHELL': '/bin/bash', 07:56:19 INFO - 'SHLVL': '1', 07:56:19 INFO - 'TERM': 'linux', 07:56:19 INFO - 'TMOUT': '86400', 07:56:19 INFO - 'USER': 'cltbld', 07:56:19 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1451921101.252698-1044458391', 07:56:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:19 INFO - '_': '/tools/buildbot/bin/python'} 07:56:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:56:20 INFO - Running setup.py (path:/tmp/pip-8Bm1xa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:56:20 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)) 07:56:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:56:20 INFO - Running setup.py (path:/tmp/pip-qSG7Ye-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:56:20 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)) 07:56:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:56:20 INFO - Running setup.py (path:/tmp/pip-aN6FYP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:56:20 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)) 07:56:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:56:20 INFO - Running setup.py (path:/tmp/pip-vVEbIH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:56:20 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)) 07:56:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:56:20 INFO - Running setup.py (path:/tmp/pip-DjNZmU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:56:20 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)) 07:56:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:56:20 INFO - Running setup.py (path:/tmp/pip-fQwyss-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:56:20 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)) 07:56:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:56:20 INFO - Running setup.py (path:/tmp/pip-Si86Hi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:56:20 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)) 07:56:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:56:20 INFO - Running setup.py (path:/tmp/pip-P7CZV1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:56:20 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)) 07:56:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:56:20 INFO - Running setup.py (path:/tmp/pip-4tJEfq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:56:20 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)) 07:56:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:56:20 INFO - Running setup.py (path:/tmp/pip-aDV_ZU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:56:20 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)) 07:56:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:56:20 INFO - Running setup.py (path:/tmp/pip-57I_YJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:56:20 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)) 07:56:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:56:20 INFO - Running setup.py (path:/tmp/pip-pbu5rX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:56:20 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)) 07:56:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:56:20 INFO - Running setup.py (path:/tmp/pip-VaOXpU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:56:20 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)) 07:56:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:56:20 INFO - Running setup.py (path:/tmp/pip-mBGgew-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:56:21 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)) 07:56:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:56:21 INFO - Running setup.py (path:/tmp/pip-1pMjpn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:56:21 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)) 07:56:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:56:21 INFO - Running setup.py (path:/tmp/pip-qXrj8b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:56:21 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)) 07:56:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:56:21 INFO - Running setup.py (path:/tmp/pip-kL3RiB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:56:21 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)) 07:56:21 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)) 07:56:21 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)) 07:56:21 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)) 07:56:21 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)) 07:56:21 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)) 07:56:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:22 INFO - Downloading blessings-1.5.1.tar.gz 07:56:22 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 07:56:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:56:23 INFO - Installing collected packages: blessings 07:56:23 INFO - Running setup.py install for blessings 07:56:23 INFO - Successfully installed blessings 07:56:23 INFO - Cleaning up... 07:56:23 INFO - Return code: 0 07:56:23 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:56:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:56:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:56:23 INFO - Reading from file tmpfile_stdout 07:56:23 INFO - Current package versions: 07:56:23 INFO - argparse == 1.2.1 07:56:23 INFO - blessings == 1.5.1 07:56:23 INFO - blobuploader == 1.2.4 07:56:23 INFO - docopt == 0.6.1 07:56:23 INFO - manifestparser == 1.1 07:56:23 INFO - mozInstall == 1.12 07:56:23 INFO - mozcrash == 0.16 07:56:23 INFO - mozdebug == 0.1 07:56:23 INFO - mozdevice == 0.47 07:56:23 INFO - mozfile == 1.2 07:56:23 INFO - mozhttpd == 0.7 07:56:23 INFO - mozinfo == 0.9 07:56:23 INFO - mozleak == 0.1 07:56:23 INFO - mozlog == 3.1 07:56:23 INFO - moznetwork == 0.27 07:56:23 INFO - mozprocess == 0.22 07:56:23 INFO - mozprofile == 0.28 07:56:23 INFO - mozrunner == 6.11 07:56:23 INFO - mozscreenshot == 0.1 07:56:23 INFO - mozsystemmonitor == 0.0 07:56:23 INFO - moztest == 0.7 07:56:23 INFO - mozversion == 1.4 07:56:23 INFO - psutil == 3.1.1 07:56:23 INFO - requests == 1.2.3 07:56:23 INFO - wsgiref == 0.1.2 07:56:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:56:23 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')]} 07:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:23 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')]} 07:56:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:23 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 0x7f189b323f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff840>, '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 0x276c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276cb60>, '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': 'aa52b8aba932b19cc50b5275000001de-1451921101.252698-1044458391', '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 07:56:23 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 07:56:23 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 07:56:23 INFO - Using env: {'DISPLAY': ':0', 07:56:23 INFO - 'HOME': '/home/cltbld', 07:56:23 INFO - 'LANG': 'en_US.UTF-8', 07:56:23 INFO - 'LANGUAGE': 'en_US:en', 07:56:23 INFO - 'LOGNAME': 'cltbld', 07:56:23 INFO - 'MAIL': '/var/mail/cltbld', 07:56:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:23 INFO - 'MOZ_NO_REMOTE': '1', 07:56:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:23 INFO - 'NO_EM_RESTART': '1', 07:56:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:56:23 INFO - 'PWD': '/builds/slave/test-pgo', 07:56:23 INFO - 'SHELL': '/bin/bash', 07:56:23 INFO - 'SHLVL': '1', 07:56:23 INFO - 'TERM': 'linux', 07:56:23 INFO - 'TMOUT': '86400', 07:56:23 INFO - 'USER': 'cltbld', 07:56:23 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1451921101.252698-1044458391', 07:56:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:23 INFO - '_': '/tools/buildbot/bin/python'} 07:56:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:23 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)) 07:56:23 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)) 07:56:23 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)) 07:56:23 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)) 07:56:23 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)) 07:56:23 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)) 07:56:23 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)) 07:56:23 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)) 07:56:23 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)) 07:56:23 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)) 07:56: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 mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 07:56:23 INFO - Cleaning up... 07:56:23 INFO - Return code: 0 07:56:23 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:56:23 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')]} 07:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:23 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')]} 07:56:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:23 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 0x7f189b323f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff840>, '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 0x276c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276cb60>, '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': 'aa52b8aba932b19cc50b5275000001de-1451921101.252698-1044458391', '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 07:56:23 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 07:56:23 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 07:56:23 INFO - Using env: {'DISPLAY': ':0', 07:56:23 INFO - 'HOME': '/home/cltbld', 07:56:23 INFO - 'LANG': 'en_US.UTF-8', 07:56:23 INFO - 'LANGUAGE': 'en_US:en', 07:56:23 INFO - 'LOGNAME': 'cltbld', 07:56:23 INFO - 'MAIL': '/var/mail/cltbld', 07:56:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:23 INFO - 'MOZ_NO_REMOTE': '1', 07:56:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:23 INFO - 'NO_EM_RESTART': '1', 07:56:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:56:23 INFO - 'PWD': '/builds/slave/test-pgo', 07:56:23 INFO - 'SHELL': '/bin/bash', 07:56:23 INFO - 'SHLVL': '1', 07:56:23 INFO - 'TERM': 'linux', 07:56:23 INFO - 'TMOUT': '86400', 07:56:23 INFO - 'USER': 'cltbld', 07:56:23 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1451921101.252698-1044458391', 07:56:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:23 INFO - '_': '/tools/buildbot/bin/python'} 07:56:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:23 INFO - Downloading/unpacking jsonschema 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:56:25 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 07:56:25 INFO - Downloading/unpacking functools32 (from jsonschema) 07:56:25 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 07:56:25 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 07:56:25 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 07:56:25 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 07:56:25 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 07:56:25 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 07:56:25 INFO - Downloading functools32-3.2.3-2.tar.gz 07:56:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:56:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:56:25 INFO - warning: no files found matching '*.txt' 07:56:25 INFO - no previously-included directories found matching 'build' 07:56:25 INFO - no previously-included directories found matching 'dist' 07:56:25 INFO - no previously-included directories found matching '.git*' 07:56:25 INFO - Installing collected packages: jsonschema, functools32 07:56:25 INFO - Running setup.py install for functools32 07:56:25 INFO - warning: no files found matching '*.txt' 07:56:25 INFO - no previously-included directories found matching 'build' 07:56:25 INFO - no previously-included directories found matching 'dist' 07:56:25 INFO - no previously-included directories found matching '.git*' 07:56:25 INFO - Successfully installed jsonschema functools32 07:56:25 INFO - Cleaning up... 07:56:26 INFO - Return code: 0 07:56:26 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:26 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 0x7f189b323f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ff840>, '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 0x276c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276cb60>, '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': 'aa52b8aba932b19cc50b5275000001de-1451921101.252698-1044458391', '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 07:56:26 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 07:56:26 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 07:56:26 INFO - Using env: {'DISPLAY': ':0', 07:56:26 INFO - 'HOME': '/home/cltbld', 07:56:26 INFO - 'LANG': 'en_US.UTF-8', 07:56:26 INFO - 'LANGUAGE': 'en_US:en', 07:56:26 INFO - 'LOGNAME': 'cltbld', 07:56:26 INFO - 'MAIL': '/var/mail/cltbld', 07:56:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:26 INFO - 'MOZ_NO_REMOTE': '1', 07:56:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:26 INFO - 'NO_EM_RESTART': '1', 07:56:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:56:26 INFO - 'PWD': '/builds/slave/test-pgo', 07:56:26 INFO - 'SHELL': '/bin/bash', 07:56:26 INFO - 'SHLVL': '1', 07:56:26 INFO - 'TERM': 'linux', 07:56:26 INFO - 'TMOUT': '86400', 07:56:26 INFO - 'USER': 'cltbld', 07:56:26 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1451921101.252698-1044458391', 07:56:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:26 INFO - '_': '/tools/buildbot/bin/python'} 07:56:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:26 INFO - Downloading/unpacking flake8 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:56:27 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 07:56:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:56:28 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 07:56:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56:28 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 07:56:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:56:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:56:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:56:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:56:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:56:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:56:28 INFO - no previously-included directories found matching 'docs/_build' 07:56:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:56:28 INFO - Running setup.py install for pep8 07:56:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:56:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:56:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:56:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:56:28 INFO - no previously-included directories found matching 'docs/_build' 07:56:28 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:56:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:56:28 INFO - Cleaning up... 07:56:28 INFO - Return code: 0 07:56:28 INFO - Running post-action listener: _resource_record_post_action 07:56:28 INFO - Running post-action listener: _start_resource_monitoring 07:56:28 INFO - Starting resource monitoring. 07:56:29 INFO - ##### 07:56:29 INFO - ##### Running install step. 07:56:29 INFO - ##### 07:56:29 INFO - Running pre-action listener: _resource_record_pre_action 07:56:29 INFO - Running main action method: install 07:56:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:56:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:56:29 INFO - Reading from file tmpfile_stdout 07:56:29 INFO - Detecting whether we're running mozinstall >=1.0... 07:56:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:56:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:56:29 INFO - Reading from file tmpfile_stdout 07:56:29 INFO - Output received: 07:56:29 INFO - Usage: mozinstall [options] installer 07:56:29 INFO - Options: 07:56:29 INFO - -h, --help show this help message and exit 07:56:29 INFO - -d DEST, --destination=DEST 07:56:29 INFO - Directory to install application into. [default: 07:56:29 INFO - "/builds/slave/test-pgo"] 07:56:29 INFO - --app=APP Application being installed. [default: firefox] 07:56:29 INFO - mkdir: /builds/slave/test-pgo/build/application 07:56:29 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'] 07:56:29 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 07:56:45 INFO - Reading from file tmpfile_stdout 07:56:45 INFO - Output received: 07:56:45 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:56:45 INFO - Running post-action listener: _resource_record_post_action 07:56:45 INFO - ##### 07:56:45 INFO - ##### Running run-tests step. 07:56:45 INFO - ##### 07:56:45 INFO - Running pre-action listener: _resource_record_pre_action 07:56:45 INFO - Running main action method: run_tests 07:56:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:56:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:56:45 INFO - Python 2.7.3 07:56:45 INFO - Return code: 0 07:56:45 INFO - grabbing minidump binary from tooltool 07:56:45 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')]} 07:56:45 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 0x27ff840>, '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 0x276c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276cb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:56:45 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 07:56:45 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 07:56:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:56:45 INFO - Return code: 0 07:56:45 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:56:45 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:56:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:56:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:56:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:56:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:56:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:56:46 INFO - Return code: 0 07:56:46 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/FtdBAnaaTRa9fLMqZLODwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 07:56:46 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/FtdBAnaaTRa9fLMqZLODwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --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 07:56:46 INFO - Using env: {'DISPLAY': ':0', 07:56:46 INFO - 'HOME': '/home/cltbld', 07:56:46 INFO - 'LANG': 'en_US.UTF-8', 07:56:46 INFO - 'LANGUAGE': 'en_US:en', 07:56:46 INFO - 'LOGNAME': 'cltbld', 07:56:46 INFO - 'MAIL': '/var/mail/cltbld', 07:56:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:56:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:46 INFO - 'MOZ_NO_REMOTE': '1', 07:56:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:56:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:46 INFO - 'NO_EM_RESTART': '1', 07:56:46 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:56:46 INFO - 'PWD': '/builds/slave/test-pgo', 07:56:46 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:56:46 INFO - 'SHELL': '/bin/bash', 07:56:46 INFO - 'SHLVL': '1', 07:56:46 INFO - 'TERM': 'linux', 07:56:46 INFO - 'TMOUT': '86400', 07:56:46 INFO - 'USER': 'cltbld', 07:56:46 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1451921101.252698-1044458391', 07:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:46 INFO - '_': '/tools/buildbot/bin/python'} 07:56:46 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/FtdBAnaaTRa9fLMqZLODwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 07:56:46 INFO - mozversion application_buildid: 20160104053008 07:56:46 INFO - mozversion application_changeset: e31a99e1f8677a11926462aebfbdfbce16afe2f8 07:56:46 INFO - mozversion application_display_name: Nightly 07:56:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:56:46 INFO - mozversion application_name: Firefox 07:56:46 INFO - mozversion application_remotingname: firefox 07:56:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:56:46 INFO - mozversion application_vendor: Mozilla 07:56:46 INFO - mozversion application_version: 46.0a1 07:56:46 INFO - mozversion platform_buildid: 20160104053008 07:56:46 INFO - mozversion platform_changeset: e31a99e1f8677a11926462aebfbdfbce16afe2f8 07:56:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:56:46 INFO - mozversion platform_version: 46.0a1 07:56:46 INFO - using testdate: 1451923006 07:56:46 INFO - actual date: 1451923006 07:56:46 INFO - starting webserver on 'localhost:47689' 07:56:46 INFO - SUITE-START | Running 3 tests 07:56:46 INFO - TEST-START | dromaeo_css 07:56:46 INFO - operating with platform_type : linux_ 07:56:46 INFO - Initialising browser for dromaeo_css test... 07:56:46 INFO - TEST-INFO | started process 11894 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPmE1eg/profile http://localhost:47689/getInfo.html) 07:56:50 INFO - PROCESS | 11894 | __metrics Screen width/height:1600/1200 07:56:50 INFO - PROCESS | 11894 | colorDepth:24 07:56:50 INFO - PROCESS | 11894 | Browser inner width/height: 1024/697 07:56:50 INFO - PROCESS | 11894 | __metrics 07:56:50 INFO - PROCESS | 11894 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:56:50 INFO - PROCESS | 11894 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:56:52 INFO - TEST-INFO | 11894: exit 0 07:56:52 INFO - Browser initialized. 07:56:52 INFO - Running cycle 1/1 for dromaeo_css test... 07:56:52 INFO - TEST-INFO | started process 11989 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPmE1eg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:57:03 INFO - PROCESS | 11989 | RSS: Main: 150036480 07:57:03 INFO - PROCESS | 11989 | 07:57:55 INFO - PROCESS | 11989 | 1451923075387 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] 08:00:03 INFO - PROCESS | 11989 | Cycle 1(1): loaded http://localhost:47689/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47689/tests/dromaeo/cssquery-ext.html) 08:00:05 INFO - PROCESS | 11989 | RSS: Main: 272519168 08:00:05 INFO - PROCESS | 11989 | 08:03:07 INFO - PROCESS | 11989 | Cycle 1(1): loaded http://localhost:47689/tests/dromaeo/cssquery-ext.html (next: http://localhost:47689/tests/dromaeo/cssquery-jquery.html) 08:03:08 INFO - PROCESS | 11989 | RSS: Main: 233943040 08:03:08 INFO - PROCESS | 11989 | 08:06:10 INFO - PROCESS | 11989 | Cycle 1(1): loaded http://localhost:47689/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47689/tests/dromaeo/cssquery-mootools.html) 08:06:10 INFO - PROCESS | 11989 | RSS: Main: 234426368 08:06:10 INFO - PROCESS | 11989 | 08:09:12 INFO - PROCESS | 11989 | Cycle 1(1): loaded http://localhost:47689/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47689/tests/dromaeo/cssquery-prototype.html) 08:09:13 INFO - PROCESS | 11989 | RSS: Main: 213454848 08:09:13 INFO - PROCESS | 11989 | 08:12:15 INFO - PROCESS | 11989 | Cycle 1(1): loaded http://localhost:47689/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47689/tests/dromaeo/cssquery-yui.html) 08:12:16 INFO - PROCESS | 11989 | RSS: Main: 219725824 08:12:16 INFO - PROCESS | 11989 | 08:15:18 INFO - PROCESS | 11989 | Cycle 1(1): loaded http://localhost:47689/tests/dromaeo/cssquery-yui.html (next: http://localhost:47689/tests/dromaeo/cssquery-dojo.html) 08:15:19 INFO - PROCESS | 11989 | RSS: Main: 242999296 08:15:19 INFO - PROCESS | 11989 | 08:15:19 INFO - PROCESS | 11989 | __start_tp_report 08:15:19 INFO - PROCESS | 11989 | _x_x_mozilla_page_load 08:15:19 INFO - PROCESS | 11989 | _x_x_mozilla_page_load_details 08:15:19 INFO - PROCESS | 11989 | |i|pagename|runs| 08:15:19 INFO - PROCESS | 11989 | |0;dojo.html;3084.892028778993;3126.1403114143595;3174.746020318373;3178.8728450861954;3206.871725130994;5048.772805223764;5231.2153177023465;5253.605979551535;5267.789288428463;5309.867253318665;5236.633435659505;5261.605379596536;5316.308879845615;5341.359036915565;5343.278657381253;4779.90440191196;4814.085323788487;4840.515948405149;4849.854504364857;4899.020195960804;4616.215243408628;4841;4865.805367785284;4882.707037577757;4932.950670493285;4699.600533954618;4709.835155769549;4805.519448055202;4809;4837.0809546186465;4815.398075240595;4851.805927762885;4853.053654537367;4853.805847766085;4884.3161957326;4689.20283551797;4810.158222311082;4817.927731084036;4855.247436647325;4888.951110488885;5046.899062018739;5091.210862316347;5106.846794596168;5118.10433174193;5126.692398456067;5685.715714214272;5685.772569097231;5685.971570142165;5688.374278829326;5691.089425691911;5514;5623.0721930881355;5711.029125048752;5712.8857422851725;5722.313322401297;5176.818811341585;5259.500347467061;5271.920921186185;5276.5251127398715;5296.788128474856;5846.1523079153285;5851.970740146272;5856.209411729447;5860.501857342088;5863.501602363847;5414.485623865727;5627.746751396197;5641.435856414326;5642.0972644377525;5644.6330988485615;5606.439356064442;5640.71796410186;5713;5715.771369145187;5755.884882302415;5563.805266815642;5565.276514053147;5586.441355864381;5588.524975377139;5590.664560126405;5484.506394424521;5613.214150019001;5617.8595535111135;5627.831165065055;5631.099024156198;4374.365716971021;4436.112777444524;4463.24124898768;4469.955300447019;4470.865874023784;3872.4772155759174;3877.0307423144213;3885.1258466845297;3910.648041676263;3913.1195481016543;5166.5866730661455;5251.474852514718;5253.080710875582;5254.527092561688;5261;5570.97214513933;5595;5621.662700237917;5710.428957104339;5735.483806457355;5264.657797243167;5274.92087618686;5275.050490911596;5277.076511610453;5284.867878302996;4600.378948841931;4800.495947925488;4806.663533552618;4808.567228949341;4832.830850920201;5759.280089988752;5797.88404231913;5861.794837180678;5871.500922421642;5909;5641.351244606923;5644.858878527905;5654.943450565606;5657.264555607745;5658.462446067617;5551.111822108443;5713.800016999551;5830.096335068071;5845.386234445492;5855.443732845373;5514.641548299348;5580.525655319343;5656.208130861765;5671.404502527175;5715.342735585461;5656.321241451053;5687.687177205294;5692.31692196939;5696.373398926032;5711.571632127524;5266.078436273713;5387.811426600207;5539.861503462284;5559.388467268516;5563.415841336601;5405.054115529688;5559.416261292506;5567.860803479945;5572.108462645957;5614.24207731951;5227.895442091213;5315.803944112698;5325.147976323769;5326.6537675050995;5368.812091576776;5402.648827826179;5424.159255315432;5453.045716999589;5505.9724701376235;5552.167174923632;5416.8104116355735;5486.067368547277;5498.752556134904;5506.91739623914;5524.447555244444 08:15:19 INFO - PROCESS | 11989 | |1;ext.html;536.0966770990879;548.7722595123023;564.463759428543;570.8116321613867;578.3840210176162;28921.566176507342;29484.705152948463;29525.2618684533;34607.826960865226;35344;37495;37841.810790946074;37957.24085518295;37967.81016094916;37974.810125949334;8374.665013399457;8534.530600816952;8548.914510854875;8556.272716819078;8565.01502327234;7394.334509894108;7546.434017448686;7566.167721550625;7568.772936811904;8325.708600198994;7253.7098516059295;10022.248331375176;10149.644762433316;10175.440350780704;10253.487325633725;9967.053129952643;10075.798484030278;10079.798404031952;10082.495875206247;10097.949510252474;7394.815129621748;7621.885671714928;9781.168600668952;9872.259580531418;9910;38291.617083829085;38866.417003744966;38924;38935;38941.80529097365;3168.477201261789;3185.140012196694;3223.774335796495;3257.0426931278375;3314.5691060162267;26553.867230663916;26735.598966015525;27994.16017519478;28258.29354266139;28334.149975500768;3332.7000569948823;3354.76516643835;3360.4959256111533;3364.34395292918;3520.7887526748477;213006;216366;216509;216534;216845.99999999843;46710.29934550985;47311;47409.28886066712;52238.477615224125;52254.21618675723;55180.17229741557;55388.16917746237;55510.444895551336;55647;55852.720736396055;15045.322960466805;15509.922450387901;15529.922350388175;15544.378224871105;15550.377984880704;11937;12007.699807504707;12055.276683399024;12061;12061.155719099754;18337.541561460803;18358.265669373344;18366;18404.907975460304;18591.90704046471;7378.594177320191;7497.1753107158165;7575;7629.618519074024;7797;856.4261944497201;876.3514998900895;890.888638920135;972.2076507646245;977.0312819668374;27381;27473.86263068672;27581.58627620587;27916.30209244785;27929.860350698524;882.6116508736136;944.9007854175212;997.1005235027139;1021.4382089850701;1076.208986394999;12685.175463594836;12916.41876115577;13088.672783180496;13156.342182890818;13156.60530184096;300276;306180;306453;306507;308362;49862.750686246334;50044.249336259985;50328.74835625799;50476.24285635718;50546;1300.830891984036;1309.4696647857634;1323.993380033113;1330.0157883166387;1331.2944139606025;23138.884305578365;24793.132240371502;24959.376015599755;25223.099343575723;25246.495070098863;41883.58116418797;42284.36573451462;42349.57650423457;42363;42367.788161059;276421;288230;291622;291648;291711;23583;30326.696733032386;30465.390692186476;30770.230744231572;30875.845620772652;34983.300333993684;35496.82251588725;35926.101847454025;35932.64067359293;36840.26319473649;31185.220369490944;31496.527552087195;32802.50796238011;34396;34713;29841;33887.491687625195;36403;36642.85217460377;37466.81266593649;33847;34169.82915085508;34214.82892585521;34762;35329.47005794864;29410.705892941653;30027.399452011276;30689.846550767998;30737.692623073483;30839.537406939362;23517.41206469852;23681.881590591936;23804.761952380253;23818.285451436484;24057.63913541263 08:15:19 INFO - PROCESS | 11989 | |2;jquery.html;349.5386090360724;354.1253104831067;359.27605874163567;359.4338916206971;361.246800421122;13951.093178943362;14384;16072.598185045365;16424.425145119923;17279.049652269136;15864.28610712518;15934.601634959132;16495.422660206896;16523.421680241194;16526.83473165268;4585.472670642869;4760.619150467955;4762.333273341735;4765.046990601876;4767.785449654774;3736.757110787804;3835.9616403835885;4692.601128904047;5314.867128321785;5440.972795136019;5342.465753424646;5385.596080293974;5392.838214853561;5415.620906536544;5429.185622156669;5322.242443424588;5922.2597175353085;5978.790742323998;5997.490213331872;6011.158437818709;5274.947250527484;5287;5304.257403963448;5306.469353064701;5307.495787900143;17339;19500.414987550397;19820.30628927995;20632;20818;1966.6558352288434;2028.3103744726716;2060.1759296281457;2102.968455473154;2157.7626461089267;8921;8988.280937524982;9391.060893910622;10547.894521054845;12777.552785652551;1717.6994026045393;1750.422360620992;1796.622709231063;1799.9190036448392;1826.8721189516739;60477.58089676408;62563.68718156426;62860;63724.362756372306;64698;9679.177269931994;9986.850197246902;10080;10087.596496140071;10137.391756494633;13418.261995590141;13431.19412835233;13434.126781759154;13448.46206151743;13455.192688438725;7368.37368823656;7585.16563178061;7609.771706848804;7625.771226863203;7695.961520192363;7460.14208366034;7486.887696684554;7503.09962804467;7512.323890849741;7533.2466753324225;4288.592583704543;4344.1311737652595;4350.282203436461;4356.760378179167;4370.868873933787;1676.8490835824591;1705.2837808120619;1744.6859565278119;1751.5008222656481;1754.4473490850341;847.4025811802665;868.8609822428381;869.4565896314804;937.7139972308512;963.2342287881152;13660.726785464236;15590.844091559165;16406;16558.917205413894;16972.66054678924;841.760098371961;935.6771913689767;935.9064093590723;962.4514027004681;975.1077763846143;8573.099824518336;8756.912430875736;8904.59929303183;8914.777130571658;9035.186833185046;532496;534139;542457;546584;550568;73474;77908.61045694849;79355.60322198468;80508;81759;1165.1901928159848;1165.4231155578043;1185.0874826383808;1194.802857528498;1217.0993464835958;13783.241921694404;13886.305684715522;14007.43970241179;14365.85634143687;14367.353469094125;34431.65568344285;34548.30903381868;35115;35389.64610353864;35557.64442355543;43259.35110973401;44356;45603.77198113988;46623.30065048959;47127;9380.484073375757;9498.905010950079;9668.661596844076;9706.9029309706;9748.171405430334;11330.206885517935;11412.201145919706;11436.256643318491;11573.652790416301;11606.187566870576;9848.507574621097;12068.215565988183;13425.194488330731;13626.250556219504;13784.724305514033;10903.945480272865;13559.389827457591;13705.177689338672;13801.240931748449;13990.530994245457;12952;13945.163290202214;14160.645983850487;14291.785623215452;14451;9042.773930651787;9238.491882946233;9291.86062209081;9457.574409151466;9467.763305917408;9777.657781977596;12906.67733306675;13889.166650001032;14078.084924480285;14439.350229239919 08:15:19 INFO - PROCESS | 11989 | |3;mootools.html;1287.4335292471305;1445.3495926832925;1476.9335379907907;1612.709712251795;1778.9021603811793;6603.537752357331;7149.49953503255;7249.528780629255;7273.345398914096;7281.708731650734;7168.677409516571;7284.162321333049;7317.231690672483;7329.6701648425815;7336.156342020669;1878.6618408686431;1920.6830872905953;1921.8750781199246;2174.673798930165;2217.81148602369;1949.4249196486999;2198.6701994700843;2230.408941630469;2231.7991380775725;2240.09276243121;2190.769969153232;2210.806164671084;2214.900329485169;2225.0765932138142;2253.5154941687533;2196.527746534495;2218.223621732397;2224.7775222477785;2225.2767850448668;2225.899834507443;2141.539568992674;2176.3144609447972;2176.4123686604685;2177.1182671018105;2179.836512261571;7512.88730669035;7565.2812982766545;7573.734919277799;7584.089909210875;7587.355074818647;4508.571685689854;4567.566081222279;4579.107074120548;4581.427321584802;4586.036932244233;2869.2826793301674;2911.650601927761;2914.970850291491;2922.415516896608;2935.5890175375466;949.0011167638664;949.9050094990515;960.9807803843954;961.2838435365697;978.7063880835792;10032.749181270454;10037.69886903394;10039.799204015879;10050;10057.647982320585;4081.8367265309057;4149.6265336119895;4187.183499217624;4188.581141885848;4206.348016057516;8613.956930215434;8617.35369847264;8622.698205562776;8625.827483450295;8627.91372086271;4605.792739326738;4624.237000894882;4654.511276316006;4656.068786242765;4667.97304592989;4206.074663574009;4209.305464598368;4218.49378074633;4220.198162349144;4232.25935461293;3284.901452956415;3589.210373717778;3598.1544337080763;3662.9633703663153;3665.4318580620047;1055.4353420919772;1116.7878103160535;1123.7752449509967;1132.773445310941;1136.9431528423545;1054.9103326217357;1068.3376306689902;1114.788190243851;1189.1913498820884;1286.311823174597;6856.794296171123;6908.1364829396325;6936.722531098801;6942.479314051467;6958.930410695828;1089.0362029603857;1102.8400881872244;1103.3379972016726;1113.9443027848574;1124.2579897267929;5540.722963851791;5637.295338082739;5638.971805140948;5639.125935480007;5648.491635752802;8482.872756908651;8638.438501497509;8670.913290867136;8784.209421152127;9083.772905677279;8748.212660860427;8787.648494060293;8870.778230544289;8871.556422178865;8876.689315874042;6667.499937504706;6799.830004249834;6830.59016459014;6836.350546698155;6951.756688515979;6861;6916.100906882073;6920.550164239308;6922.1001269836615;6925.134358205224;7288.635568221462;7509.586972716553;7551.622418879144;7683.385329173541;8065.758027259191;7740.612969351398;7884.566348850639;8140.430169888051;8269.586520673822;8295.792605184919;7044.682989265393;7086.50394472382;7146.392556632536;7171.318724721144;7186.928130718626;6626.768063117768;6757.358050985148;7252.854942901218;7308.30571095745;7311.122665280201;6145.139680444652;6165.876682466236;6727.2263689674355;6841.760538381132;7018.227994920657;6599;6679.06493090958;6777.322267773183;6886;6946.617936013366;6711.530192886451;6750.257471678014;6787.592744435349;6811.829704257433;6817.113775209191;6387.4570661492435;6439.356064393523;6544.28012918569;6556.311587283458;6562.934370656423;6446.4520515756685;6480.967595161994;6487.967560162358;6488.221413430419;6496.220453545605 08:15:19 INFO - PROCESS | 11989 | |4;prototype.html;323.2742493102984;328.382640635605;329.6555099920583;332.3220629914974;335.18717111005805;5733.885322293551;5838.562107841913;5859.853503662411;5896.911546326798;5923.526117910567;5625.240592520008;5770.076787713967;5784.768609255635;5812.970935145329;5817.185594016841;4515.2324104902245;4516.4806047304655;4518.390017347649;4523.457185137771;4532.478764942024;4295.2912769393015;4368.170047690945;4398.450193725785;4461.24158892989;4512.729236245836;4394.846180383687;4402.537733537981;4411.16187924295;4426.55734426558;4429.424174857264;4425.822967081297;4426;4463.955360446386;4466.33005049242;4497.168023915553;3950.723449358546;3952.130531283113;3954.228925359556;3954.5452272988687;3959;5406.567474602022;5535.944640553583;5549.278593782782;5554.333479982388;5590.720463976825;5165.483451654842;5167.147420675584;5167.612429067835;5178.0679477694;5188.948110518922;6114.938850611526;6115.755369785204;6116.052011938156;6132.080187971796;6135.171751813493;4328.63206627437;4330.783460826946;4331.328644060176;4336.761478118702;4337.262665346899;6092.147099406086;6185.752569897199;6242.375762423767;6430.131932189188;6433.131527243809;4438.511763705989;4457.866264012085;4458.487273963471;4458.888527786831;4465.330200469891;4506.324051392317;4513.1650644630845;4516.096780643885;4517.503074661785;4523;4994.225894986283;5155.561777248976;5166.405863325691;5167.793288268427;5184.196449550326;6173.290071641729;6186.597871138361;6206.286277078194;6209.472194863487;6235.688215589203;1580.6680597074744;1594.4020992127953;1597.5526852481323;1598.472504073653;1599.4242072853997;1028.88682244953;1039.3348257115451;1062.2404980439023;1091.1979694924225;1094.3105843318658;5892.292924849045;5897.64614123154;5903.557233207441;5911.201987731602;5914.76340946366;6389.393007664265;6394.296627370985;6394.808155755335;6397.040443933447;6405.19935008124;5872.911906321408;5894.616849904743;5901.793437229762;5914.2311499504785;5916.645001299936;3354.26206234628;3443.362977849106;3443.724502039831;3455.980485756708;3458.342914846171;6536.803895883131;6590.3080176581725;6688.3646053624825;6698;6700.463962882957;6634.170728658918;6637.634930078795;6638.369354911276;6641.269460359356;6643.5017373697165;6524.902126468107;6678.265390807007;6679.398854103057;6684.598924064669;6688.7324507019175;6408.102865598913;6423.7430502781235;6446.67766611677;6449.322821103717;6456.418922297016;6093.48205402528;6363.459105976044;6366.140571023038;6381.042843573316;6389.648569328731;6131.785387511416;6429.164208652845;6538.378854008862;6692.230393504615;6706.329367063255;4414.42612460391;4457.977710111429;4463.620592249695;4466.57567531084;4466.843660471868;6409.743610255724;6418.261899881573;6451.870962580816;6455.9677201613695;6459.289478157305;6130;6272.184616000073;6276.843078923063;6296.181496405438;6307.148534947723;6226.066090086523;6277.96861015692;6280.0893870389455;6285.528585356025;6291.685415729286;6134.723937422916;6165.815025549241;6170.753169873335;6191.721372538336;6202;6209;6287.245530536365;6320.431161195331;6320.462760665395;6336.112944187726;6174.876502469836;6179.351168127282;6184.690765461619;6185.783497577563;6185.84535386601 08:15:19 INFO - PROCESS | 11989 | |5;yui.html;770.614692653673;817.0930267403181;831.484479622634;851.6593362654941;895.1853813030144;13420.865791342083;13609.319534023283;13619.387127579257;13657.112287701304;13674;12736.172148810321;12761.936190319035;12763.872361276384;12776.93611531941;12783.29691866947;681.553582403524;687.3298533929404;800.5556915911667;815.388458656008;818.0755746007004;826.3182874128838;827.0241115483727;834.7537476444434;835.1815221083342;835.4402550291289;708.3518580498837;858.7767180533075;868.1362044765467;869.0614136732314;869.7738587967142;704.9259827718092;848.5587494502855;853.0318088969003;855.0338117926765;856.5802756649259;636.360457739973;636.700750647195;636.9681515924185;637.4868231073983;637.588755252864;13120.212787232796;13213.537526186537;13222.537211197658;13240.139390939557;13249.271290079041;11925.522979080826;12250.693732656666;12412.875871241262;12704.872951270461;12806.03954703401;9935.602575896955;9963.302568820185;10073.89926100737;10183.796324073477;10232.334898231591;3604.5494313210847;3661.7436779425184;3677.6322367763278;3686.502322186524;3774.565924918642;47153.29270060952;47828.28257576139;47916.28125578119;48104.5189548107;48112.278315824944;10127;10144.442055687008;10187.185025197967;10306.690799276033;10335.379877207391;17939;17948;17952.102394880465;17956.1021948902;17975.370862019765;6980.704307622195;7057;7153.141623005273;7155.570665760071;7189.784306470814;4038.5759495253164;4121.196366708523;4153.792310384469;4171.124063946544;4194.622483976456;3146.0719087869134;3168.651448340681;3174.730147937451;3179.9046028618714;3180.300333926579;555.5916401444935;562.6652141975518;574.4887050524952;575.4791913318453;577.053632043449;609.5732986909181;646.9902951455732;657.5561495990188;678.2911857109333;679.78246960973;8403.747887563382;8544.401891867634;8599.914000860037;8823.029466758651;8955.014948355676;508.29347207381767;544.6650310059364;551.1429726774903;552.5220684108217;560.7028275014248;3872.5740168581433;3881.301365754135;3975.960240397617;4040.515138183378;4141.730787498803;51496.22755658668;51865.2220216697;51895.0699683537;52065.7396713014;52307.47692523102;47145.29282060772;49395.259071113964;49462.258066129034;49504.50495495071;49630.50369496259;43779.78110109429;44113.11773764571;44240.3363949541;45170.32244516335;45211.54788452073;8218.794530136794;8353.665853366041;8626.5255410953;8701.608427620646;8791.604377803142;33357.66642333545;34473.138171545914;34672.479912801835;34779.65220347764;35036.94889153329;40333.798331008154;40681.59318406778;40705.38941915814;40910.386344204264;41388;10542.947285263524;10654.680359589225;10871.67384978452;11009.61466348674;11033.613823516138;12008.39958002114;12128.696782580153;12158;12224.327661978676;12788.808167877303;11144.554217831195;11220.831687524857;11556.422178890854;11605.491286132748;11859.110566707359;10946.233763636468;11750.58872939443;11845.289282643069;12211.572594959134;12219.205751626116;11444.313341199555;11679.883201168219;11688.123390745557;11706.648800535997;12075.27548347102;9844.803103938024;9989.60041598328;10083.647072352433;10277.588896444358;10303.303943993058;9448.48033358172;9847.185172697864;9875.703728888146;9971.252156088467;10098.343607665478 08:15:19 INFO - PROCESS | 11989 | __end_tp_report 08:15:19 INFO - PROCESS | 11989 | __start_cc_report 08:15:19 INFO - PROCESS | 11989 | _x_x_mozilla_cycle_collect,1010 08:15:19 INFO - PROCESS | 11989 | __end_cc_report 08:15:19 INFO - PROCESS | 11989 | __startTimestamp1451924119229__endTimestamp 08:15:19 INFO - PROCESS | 11989 | 08:15:19 INFO - PROCESS | 11989 | ------- Summary: start ------- 08:15:19 INFO - PROCESS | 11989 | Number of tests: 6 08:15:19 INFO - PROCESS | 11989 | 08:15:19 INFO - PROCESS | 11989 | [#0] dojo.html Cycles:165 Average:5239.09 Median:5402.65 stddev:577.74 (10.7%) stddev-sans-first:554.25 08:15:19 INFO - PROCESS | 11989 | Values: 3084.9 3126.1 3174.7 3178.9 3206.9 5048.8 5231.2 5253.6 5267.8 5309.9 5236.6 5261.6 5316.3 5341.4 5343.3 4779.9 4814.1 4840.5 4849.9 4899.0 4616.2 4841.0 4865.8 4882.7 4933.0 4699.6 4709.8 4805.5 4809.0 4837.1 4815.4 4851.8 4853.1 4853.8 4884.3 4689.2 4810.2 4817.9 4855.2 4889.0 5046.9 5091.2 5106.8 5118.1 5126.7 5685.7 5685.8 5686.0 5688.4 5691.1 5514.0 5623.1 5711.0 5712.9 5722.3 5176.8 5259.5 5271.9 5276.5 5296.8 5846.2 5852.0 5856.2 5860.5 5863.5 5414.5 5627.7 5641.4 5642.1 5644.6 5606.4 5640.7 5713.0 5715.8 5755.9 5563.8 5565.3 5586.4 5588.5 5590.7 5484.5 5613.2 5617.9 5627.8 5631.1 4374.4 4436.1 4463.2 4470.0 4470.9 3872.5 3877.0 3885.1 3910.6 3913.1 5166.6 5251.5 5253.1 5254.5 5261.0 5571.0 5595.0 5621.7 5710.4 5735.5 5264.7 5274.9 5275.1 5277.1 5284.9 4600.4 4800.5 4806.7 4808.6 4832.8 5759.3 5797.9 5861.8 5871.5 5909.0 5641.4 5644.9 5654.9 5657.3 5658.5 5551.1 5713.8 5830.1 5845.4 5855.4 5514.6 5580.5 5656.2 5671.4 5715.3 5656.3 5687.7 5692.3 5696.4 5711.6 5266.1 5387.8 5539.9 5559.4 5563.4 5405.1 5559.4 5567.9 5572.1 5614.2 5227.9 5315.8 5325.1 5326.7 5368.8 5402.6 5424.2 5453.0 5506.0 5552.2 5416.8 5486.1 5498.8 5506.9 5524.4 08:15:19 INFO - PROCESS | 11989 | 08:15:19 INFO - PROCESS | 11989 | [#1] ext.html Cycles:180 Average:42711.95 Median:18058.54 stddev:71228.42 (394.4%) stddev-sans-first:71357.84 08:15:19 INFO - PROCESS | 11989 | Values: 536.1 548.8 564.5 570.8 578.4 28921.6 29484.7 29525.3 34607.8 35344.0 37495.0 37841.8 37957.2 37967.8 37974.8 8374.7 8534.5 8548.9 8556.3 8565.0 7394.3 7546.4 7566.2 7568.8 8325.7 7253.7 10022.2 10149.6 10175.4 10253.5 9967.1 10075.8 10079.8 10082.5 10097.9 7394.8 7621.9 9781.2 9872.3 9910.0 38291.6 38866.4 38924.0 38935.0 38941.8 3168.5 3185.1 3223.8 3257.0 3314.6 26553.9 26735.6 27994.2 28258.3 28334.1 3332.7 3354.8 3360.5 3364.3 3520.8 213006.0 216366.0 216509.0 216534.0 216846.0 46710.3 47311.0 47409.3 52238.5 52254.2 55180.2 55388.2 55510.4 55647.0 55852.7 15045.3 15509.9 15529.9 15544.4 15550.4 11937.0 12007.7 12055.3 12061.0 12061.2 18337.5 18358.3 18366.0 18404.9 18591.9 7378.6 7497.2 7575.0 7629.6 7797.0 856.4 876.4 890.9 972.2 977.0 27381.0 27473.9 27581.6 27916.3 27929.9 882.6 944.9 997.1 1021.4 1076.2 12685.2 12916.4 13088.7 13156.3 13156.6 300276.0 306180.0 306453.0 306507.0 308362.0 49862.8 50044.2 50328.7 50476.2 50546.0 1300.8 1309.5 1324.0 1330.0 1331.3 23138.9 24793.1 24959.4 25223.1 25246.5 41883.6 42284.4 42349.6 42363.0 42367.8 276421.0 288230.0 291622.0 291648.0 291711.0 23583.0 30326.7 30465.4 30770.2 30875.8 34983.3 35496.8 35926.1 35932.6 36840.3 31185.2 31496.5 32802.5 34396.0 34713.0 29841.0 33887.5 36403.0 36642.9 37466.8 33847.0 34169.8 34214.8 34762.0 35329.5 29410.7 30027.4 30689.8 30737.7 30839.5 23517.4 23681.9 23804.8 23818.3 24057.6 08:15:19 INFO - PROCESS | 11989 | 08:15:19 INFO - PROCESS | 11989 | [#2] jquery.html Cycles:180 Average:28451.69 Median:23773.97 stddev:88499.45 (372.3%) stddev-sans-first:88722.56 08:15:19 INFO - PROCESS | 11989 | Values: 349.5 354.1 359.3 359.4 361.2 13951.1 14384.0 16072.6 16424.4 17279.0 15864.3 15934.6 16495.4 16523.4 16526.8 4585.5 4760.6 4762.3 4765.0 4767.8 3736.8 3836.0 4692.6 5314.9 5441.0 5342.5 5385.6 5392.8 5415.6 5429.2 5322.2 5922.3 5978.8 5997.5 6011.2 5274.9 5287.0 5304.3 5306.5 5307.5 17339.0 19500.4 19820.3 20632.0 20818.0 1966.7 2028.3 2060.2 2103.0 2157.8 8921.0 8988.3 9391.1 10547.9 12777.6 1717.7 1750.4 1796.6 1799.9 1826.9 60477.6 62563.7 62860.0 63724.4 64698.0 9679.2 9986.9 10080.0 10087.6 10137.4 13418.3 13431.2 13434.1 13448.5 13455.2 7368.4 7585.2 7609.8 7625.8 7696.0 7460.1 7486.9 7503.1 7512.3 7533.2 4288.6 4344.1 4350.3 4356.8 4370.9 1676.8 1705.3 1744.7 1751.5 1754.4 847.4 868.9 869.5 937.7 963.2 13660.7 15590.8 16406.0 16558.9 16972.7 841.8 935.7 935.9 962.5 975.1 8573.1 8756.9 8904.6 8914.8 9035.2 532496.0 534139.0 542457.0 546584.0 550568.0 73474.0 77908.6 79355.6 80508.0 81759.0 1165.2 1165.4 1185.1 1194.8 1217.1 13783.2 13886.3 14007.4 14365.9 14367.4 34431.7 34548.3 35115.0 35389.6 35557.6 43259.4 44356.0 45603.8 46623.3 47127.0 9380.5 9498.9 9668.7 9706.9 9748.2 11330.2 11412.2 11436.3 11573.7 11606.2 9848.5 12068.2 13425.2 13626.3 13784.7 10903.9 13559.4 13705.2 13801.2 13990.5 12952.0 13945.2 14160.6 14291.8 14451.0 9042.8 9238.5 9291.9 9457.6 9467.8 9777.7 12906.7 13889.2 14078.1 14439.4 08:15:19 INFO - PROCESS | 11989 | 08:15:19 INFO - PROCESS | 11989 | [#3] mootools.html Cycles:180 Average:5225.97 Median:6484.47 stddev:2660.60 (41.0%) stddev-sans-first:2651.59 08:15:19 INFO - PROCESS | 11989 | Values: 1287.4 1445.3 1476.9 1612.7 1778.9 6603.5 7149.5 7249.5 7273.3 7281.7 7168.7 7284.2 7317.2 7329.7 7336.2 1878.7 1920.7 1921.9 2174.7 2217.8 1949.4 2198.7 2230.4 2231.8 2240.1 2190.8 2210.8 2214.9 2225.1 2253.5 2196.5 2218.2 2224.8 2225.3 2225.9 2141.5 2176.3 2176.4 2177.1 2179.8 7512.9 7565.3 7573.7 7584.1 7587.4 4508.6 4567.6 4579.1 4581.4 4586.0 2869.3 2911.7 2915.0 2922.4 2935.6 949.0 949.9 961.0 961.3 978.7 10032.7 10037.7 10039.8 10050.0 10057.6 4081.8 4149.6 4187.2 4188.6 4206.3 8614.0 8617.4 8622.7 8625.8 8627.9 4605.8 4624.2 4654.5 4656.1 4668.0 4206.1 4209.3 4218.5 4220.2 4232.3 3284.9 3589.2 3598.2 3663.0 3665.4 1055.4 1116.8 1123.8 1132.8 1136.9 1054.9 1068.3 1114.8 1189.2 1286.3 6856.8 6908.1 6936.7 6942.5 6958.9 1089.0 1102.8 1103.3 1113.9 1124.3 5540.7 5637.3 5639.0 5639.1 5648.5 8482.9 8638.4 8670.9 8784.2 9083.8 8748.2 8787.6 8870.8 8871.6 8876.7 6667.5 6799.8 6830.6 6836.4 6951.8 6861.0 6916.1 6920.6 6922.1 6925.1 7288.6 7509.6 7551.6 7683.4 8065.8 7740.6 7884.6 8140.4 8269.6 8295.8 7044.7 7086.5 7146.4 7171.3 7186.9 6626.8 6757.4 7252.9 7308.3 7311.1 6145.1 6165.9 6727.2 6841.8 7018.2 6599.0 6679.1 6777.3 6886.0 6946.6 6711.5 6750.3 6787.6 6811.8 6817.1 6387.5 6439.4 6544.3 6556.3 6562.9 6446.5 6481.0 6488.0 6488.2 6496.2 08:15:19 INFO - PROCESS | 11989 | 08:15:19 INFO - PROCESS | 11989 | [#4] prototype.html Cycles:180 Average:5193.94 Median:5895.76 stddev:1560.25 (26.5%) stddev-sans-first:1521.20 08:15:19 INFO - PROCESS | 11989 | Values: 323.3 328.4 329.7 332.3 335.2 5733.9 5838.6 5859.9 5896.9 5923.5 5625.2 5770.1 5784.8 5813.0 5817.2 4515.2 4516.5 4518.4 4523.5 4532.5 4295.3 4368.2 4398.5 4461.2 4512.7 4394.8 4402.5 4411.2 4426.6 4429.4 4425.8 4426.0 4464.0 4466.3 4497.2 3950.7 3952.1 3954.2 3954.5 3959.0 5406.6 5535.9 5549.3 5554.3 5590.7 5165.5 5167.1 5167.6 5178.1 5188.9 6114.9 6115.8 6116.1 6132.1 6135.2 4328.6 4330.8 4331.3 4336.8 4337.3 6092.1 6185.8 6242.4 6430.1 6433.1 4438.5 4457.9 4458.5 4458.9 4465.3 4506.3 4513.2 4516.1 4517.5 4523.0 4994.2 5155.6 5166.4 5167.8 5184.2 6173.3 6186.6 6206.3 6209.5 6235.7 1580.7 1594.4 1597.6 1598.5 1599.4 1028.9 1039.3 1062.2 1091.2 1094.3 5892.3 5897.6 5903.6 5911.2 5914.8 6389.4 6394.3 6394.8 6397.0 6405.2 5872.9 5894.6 5901.8 5914.2 5916.6 3354.3 3443.4 3443.7 3456.0 3458.3 6536.8 6590.3 6688.4 6698.0 6700.5 6634.2 6637.6 6638.4 6641.3 6643.5 6524.9 6678.3 6679.4 6684.6 6688.7 6408.1 6423.7 6446.7 6449.3 6456.4 6093.5 6363.5 6366.1 6381.0 6389.6 6131.8 6429.2 6538.4 6692.2 6706.3 4414.4 4458.0 4463.6 4466.6 4466.8 6409.7 6418.3 6451.9 6456.0 6459.3 6130.0 6272.2 6276.8 6296.2 6307.1 6226.1 6278.0 6280.1 6285.5 6291.7 6134.7 6165.8 6170.8 6191.7 6202.0 6209.0 6287.2 6320.4 6320.5 6336.1 6174.9 6179.4 6184.7 6185.8 6185.8 08:15:19 INFO - PROCESS | 11989 | 08:15:19 INFO - PROCESS | 11989 | [#5] yui.html Cycles:180 Average:13405.00 Median:4182.87 stddev:15035.65 (359.5%) stddev-sans-first:15047.89 08:15:19 INFO - PROCESS | 11989 | Values: 770.6 817.1 831.5 851.7 895.2 13420.9 13609.3 13619.4 13657.1 13674.0 12736.2 12761.9 12763.9 12776.9 12783.3 681.6 687.3 800.6 815.4 818.1 826.3 827.0 834.8 835.2 835.4 708.4 858.8 868.1 869.1 869.8 704.9 848.6 853.0 855.0 856.6 636.4 636.7 637.0 637.5 637.6 13120.2 13213.5 13222.5 13240.1 13249.3 11925.5 12250.7 12412.9 12704.9 12806.0 9935.6 9963.3 10073.9 10183.8 10232.3 3604.5 3661.7 3677.6 3686.5 3774.6 47153.3 47828.3 47916.3 48104.5 48112.3 10127.0 10144.4 10187.2 10306.7 10335.4 17939.0 17948.0 17952.1 17956.1 17975.4 6980.7 7057.0 7153.1 7155.6 7189.8 4038.6 4121.2 4153.8 4171.1 4194.6 3146.1 3168.7 3174.7 3179.9 3180.3 555.6 562.7 574.5 575.5 577.1 609.6 647.0 657.6 678.3 679.8 8403.7 8544.4 8599.9 8823.0 8955.0 508.3 544.7 551.1 552.5 560.7 3872.6 3881.3 3976.0 4040.5 4141.7 51496.2 51865.2 51895.1 52065.7 52307.5 47145.3 49395.3 49462.3 49504.5 49630.5 43779.8 44113.1 44240.3 45170.3 45211.5 8218.8 8353.7 8626.5 8701.6 8791.6 33357.7 34473.1 34672.5 34779.7 35036.9 40333.8 40681.6 40705.4 40910.4 41388.0 10542.9 10654.7 10871.7 11009.6 11033.6 12008.4 12128.7 12158.0 12224.3 12788.8 11144.6 11220.8 11556.4 11605.5 11859.1 10946.2 11750.6 11845.3 12211.6 12219.2 11444.3 11679.9 11688.1 11706.6 12075.3 9844.8 9989.6 10083.6 10277.6 10303.3 9448.5 9847.2 9875.7 9971.3 10098.3 08:15:19 INFO - PROCESS | 11989 | -------- Summary: end -------- 08:15:19 INFO - PROCESS | 11989 | 08:15:19 INFO - TEST-INFO | 11989: exit 0 08:15:19 INFO - TEST-OK | dromaeo_css | took 1113549ms 08:15:19 INFO - TEST-START | kraken 08:15:19 INFO - operating with platform_type : linux_ 08:15:19 INFO - Initialising browser for kraken test... 08:15:19 INFO - TEST-INFO | started process 12183 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHjuSqL/profile http://localhost:47689/getInfo.html) 08:15:24 INFO - PROCESS | 12183 | __metrics Screen width/height:1600/1200 08:15:24 INFO - PROCESS | 12183 | colorDepth:24 08:15:24 INFO - PROCESS | 12183 | Browser inner width/height: 1024/697 08:15:24 INFO - PROCESS | 12183 | __metrics 08:15:24 INFO - PROCESS | 12183 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:15:24 INFO - PROCESS | 12183 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:15:25 INFO - TEST-INFO | 12183: exit 0 08:15:25 INFO - Browser initialized. 08:15:25 INFO - Running cycle 1/1 for kraken test... 08:15:25 INFO - TEST-INFO | started process 12266 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHjuSqL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:15:37 INFO - PROCESS | 12266 | RSS: Main: 150396928 08:15:37 INFO - PROCESS | 12266 | 08:15:40 INFO - PROCESS | 12266 | Cycle 1(1): loaded http://localhost:47689/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47689/tests/kraken/driver.html?testName=audio-beat-detection) 08:15:40 INFO - PROCESS | 12266 | RSS: Main: 185565184 08:15:40 INFO - PROCESS | 12266 | 08:15:43 INFO - PROCESS | 12266 | Cycle 1(1): loaded http://localhost:47689/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47689/tests/kraken/driver.html?testName=audio-dft) 08:15:43 INFO - PROCESS | 12266 | RSS: Main: 174530560 08:15:43 INFO - PROCESS | 12266 | 08:15:46 INFO - PROCESS | 12266 | Cycle 1(1): loaded http://localhost:47689/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47689/tests/kraken/driver.html?testName=audio-fft) 08:15:47 INFO - PROCESS | 12266 | RSS: Main: 159940608 08:15:47 INFO - PROCESS | 12266 | 08:15:49 INFO - PROCESS | 12266 | Cycle 1(1): loaded http://localhost:47689/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47689/tests/kraken/driver.html?testName=audio-oscillator) 08:15:49 INFO - PROCESS | 12266 | RSS: Main: 161746944 08:15:49 INFO - PROCESS | 12266 | 08:15:51 INFO - PROCESS | 12266 | Cycle 1(1): loaded http://localhost:47689/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47689/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:15:52 INFO - PROCESS | 12266 | RSS: Main: 165490688 08:15:52 INFO - PROCESS | 12266 | 08:15:55 INFO - PROCESS | 12266 | Cycle 1(1): loaded http://localhost:47689/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47689/tests/kraken/driver.html?testName=imaging-darkroom) 08:15:55 INFO - PROCESS | 12266 | RSS: Main: 163667968 08:15:55 INFO - PROCESS | 12266 | 08:15:59 INFO - PROCESS | 12266 | Cycle 1(1): loaded http://localhost:47689/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47689/tests/kraken/driver.html?testName=imaging-desaturate) 08:15:59 INFO - PROCESS | 12266 | RSS: Main: 164536320 08:15:59 INFO - PROCESS | 12266 | 08:16:02 INFO - PROCESS | 12266 | Cycle 1(1): loaded http://localhost:47689/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47689/tests/kraken/driver.html?testName=json-parse-financial) 08:16:03 INFO - PROCESS | 12266 | RSS: Main: 166486016 08:16:03 INFO - PROCESS | 12266 | 08:16:04 INFO - PROCESS | 12266 | Cycle 1(1): loaded http://localhost:47689/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47689/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:16:05 INFO - PROCESS | 12266 | RSS: Main: 175915008 08:16:05 INFO - PROCESS | 12266 | 08:16:07 INFO - PROCESS | 12266 | Cycle 1(1): loaded http://localhost:47689/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47689/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:16:07 INFO - PROCESS | 12266 | RSS: Main: 174411776 08:16:07 INFO - PROCESS | 12266 | 08:16:09 INFO - PROCESS | 12266 | Cycle 1(1): loaded http://localhost:47689/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47689/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:16:10 INFO - PROCESS | 12266 | RSS: Main: 179109888 08:16:10 INFO - PROCESS | 12266 | 08:16:12 INFO - PROCESS | 12266 | Cycle 1(1): loaded http://localhost:47689/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47689/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:16:13 INFO - PROCESS | 12266 | RSS: Main: 191340544 08:16:13 INFO - PROCESS | 12266 | 08:16:15 INFO - PROCESS | 12266 | Cycle 1(1): loaded http://localhost:47689/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47689/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:16:16 INFO - PROCESS | 12266 | RSS: Main: 188043264 08:16:16 INFO - PROCESS | 12266 | 08:16:18 INFO - PROCESS | 12266 | Cycle 1(1): loaded http://localhost:47689/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47689/tests/kraken/driver.html?testName=ai-astar) 08:16:18 INFO - PROCESS | 12266 | RSS: Main: 245972992 08:16:18 INFO - PROCESS | 12266 | 08:16:18 INFO - PROCESS | 12266 | __start_tp_report 08:16:18 INFO - PROCESS | 12266 | _x_x_mozilla_page_load 08:16:18 INFO - PROCESS | 12266 | _x_x_mozilla_page_load_details 08:16:18 INFO - PROCESS | 12266 | |i|pagename|runs| 08:16:18 INFO - PROCESS | 12266 | |0;ai-astar;109;111;106;109;110;111;100;109;109;102 08:16:18 INFO - PROCESS | 12266 | |1;audio-beat-detection;155;126;150;164;131;150;146;133;166;128 08:16:18 INFO - PROCESS | 12266 | |2;audio-dft;161;160;161;159;161;161;160;162;161;163 08:16:18 INFO - PROCESS | 12266 | |3;audio-fft;76;73;83;90;73;72;71;101;97;71 08:16:18 INFO - PROCESS | 12266 | |4;audio-oscillator;97;96;152;96;96;96;152;96;97;135 08:16:18 INFO - PROCESS | 12266 | |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;109;109 08:16:18 INFO - PROCESS | 12266 | |6;imaging-darkroom;146;146;146;146;146;145;146;146;145;146 08:16:18 INFO - PROCESS | 12266 | |7;imaging-desaturate;95;96;96;96;96;96;96;96;96;95 08:16:18 INFO - PROCESS | 12266 | |8;json-parse-financial;58;57;57;57;57;58;56;65;54;54 08:16:18 INFO - PROCESS | 12266 | |9;json-stringify-tinderbox;68;68;67;68;68;68;68;69;68;69 08:16:18 INFO - PROCESS | 12266 | |10;stanford-crypto-aes;85;86;86;96;86;86;87;85;89;85 08:16:18 INFO - PROCESS | 12266 | |11;stanford-crypto-ccm;121;121;122;116;117;115;117;116;117;122 08:16:18 INFO - PROCESS | 12266 | |12;stanford-crypto-pbkdf2;145;160;152;150;151;140;145;150;149;141 08:16:18 INFO - PROCESS | 12266 | |13;stanford-crypto-sha256-iterative;67;69;68;67;68;68;68;69;69;70 08:16:18 INFO - PROCESS | 12266 | __end_tp_report 08:16:18 INFO - PROCESS | 12266 | __start_cc_report 08:16:18 INFO - PROCESS | 12266 | _x_x_mozilla_cycle_collect,918 08:16:18 INFO - PROCESS | 12266 | __end_cc_report 08:16:18 INFO - PROCESS | 12266 | __startTimestamp1451924178429__endTimestamp 08:16:18 INFO - PROCESS | 12266 | 08:16:18 INFO - PROCESS | 12266 | ------- Summary: start ------- 08:16:18 INFO - PROCESS | 12266 | Number of tests: 14 08:16:18 INFO - PROCESS | 12266 | 08:16:18 INFO - PROCESS | 12266 | [#0] ai-astar Cycles:10 Average:107.60 Median:109.00 stddev:3.78 (3.5%) stddev-sans-first:3.97 08:16:18 INFO - PROCESS | 12266 | Values: 109.0 111.0 106.0 109.0 110.0 111.0 100.0 109.0 109.0 102.0 08:16:18 INFO - PROCESS | 12266 | 08:16:18 INFO - PROCESS | 12266 | [#1] audio-beat-detection Cycles:10 Average:144.90 Median:150.00 stddev:14.69 (9.8%) stddev-sans-first:15.12 08:16:18 INFO - PROCESS | 12266 | Values: 155.0 126.0 150.0 164.0 131.0 150.0 146.0 133.0 166.0 128.0 08:16:18 INFO - PROCESS | 12266 | 08:16:18 INFO - PROCESS | 12266 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 08:16:18 INFO - PROCESS | 12266 | Values: 161.0 160.0 161.0 159.0 161.0 161.0 160.0 162.0 161.0 163.0 08:16:18 INFO - PROCESS | 12266 | 08:16:18 INFO - PROCESS | 12266 | [#3] audio-fft Cycles:10 Average:80.70 Median:74.50 stddev:11.42 (15.3%) stddev-sans-first:11.99 08:16:18 INFO - PROCESS | 12266 | Values: 76.0 73.0 83.0 90.0 73.0 72.0 71.0 101.0 97.0 71.0 08:16:18 INFO - PROCESS | 12266 | 08:16:18 INFO - PROCESS | 12266 | [#4] audio-oscillator Cycles:10 Average:111.30 Median:96.00 stddev:24.62 (25.6%) stddev-sans-first:25.56 08:16:18 INFO - PROCESS | 12266 | Values: 97.0 96.0 152.0 96.0 96.0 96.0 152.0 96.0 97.0 135.0 08:16:18 INFO - PROCESS | 12266 | 08:16:18 INFO - PROCESS | 12266 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 08:16:18 INFO - PROCESS | 12266 | Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 08:16:18 INFO - PROCESS | 12266 | 08:16:18 INFO - PROCESS | 12266 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 08:16:18 INFO - PROCESS | 12266 | Values: 146.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 145.0 146.0 08:16:18 INFO - PROCESS | 12266 | 08:16:18 INFO - PROCESS | 12266 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 08:16:18 INFO - PROCESS | 12266 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 08:16:18 INFO - PROCESS | 12266 | 08:16:18 INFO - PROCESS | 12266 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.00 stddev:3.06 (5.4%) stddev-sans-first:3.23 08:16:18 INFO - PROCESS | 12266 | Values: 58.0 57.0 57.0 57.0 57.0 58.0 56.0 65.0 54.0 54.0 08:16:18 INFO - PROCESS | 12266 | 08:16:18 INFO - PROCESS | 12266 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 08:16:18 INFO - PROCESS | 12266 | Values: 68.0 68.0 67.0 68.0 68.0 68.0 68.0 69.0 68.0 69.0 08:16:18 INFO - PROCESS | 12266 | 08:16:18 INFO - PROCESS | 12266 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:86.00 stddev:3.35 (3.9%) stddev-sans-first:3.46 08:16:18 INFO - PROCESS | 12266 | Values: 85.0 86.0 86.0 96.0 86.0 86.0 87.0 85.0 89.0 85.0 08:16:18 INFO - PROCESS | 12266 | 08:16:18 INFO - PROCESS | 12266 | [#11] stanford-crypto-ccm Cycles:10 Average:118.40 Median:119.00 stddev:2.76 (2.3%) stddev-sans-first:2.76 08:16:18 INFO - PROCESS | 12266 | Values: 121.0 121.0 122.0 116.0 117.0 115.0 117.0 116.0 117.0 122.0 08:16:18 INFO - PROCESS | 12266 | 08:16:18 INFO - PROCESS | 12266 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.30 Median:150.00 stddev:5.85 (3.9%) stddev-sans-first:6.08 08:16:18 INFO - PROCESS | 12266 | Values: 145.0 160.0 152.0 150.0 151.0 140.0 145.0 150.0 149.0 141.0 08:16:18 INFO - PROCESS | 12266 | 08:16:18 INFO - PROCESS | 12266 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:0.95 (1.4%) stddev-sans-first:0.88 08:16:18 INFO - PROCESS | 12266 | Values: 67.0 69.0 68.0 67.0 68.0 68.0 68.0 69.0 69.0 70.0 08:16:18 INFO - PROCESS | 12266 | -------- Summary: end -------- 08:16:18 INFO - PROCESS | 12266 | 08:16:19 INFO - TEST-INFO | 12266: exit 0 08:16:19 INFO - TEST-OK | kraken | took 59353ms 08:16:19 INFO - TEST-START | v8_7 08:16:19 INFO - operating with platform_type : linux_ 08:16:19 INFO - Initialising browser for v8_7 test... 08:16:19 INFO - TEST-INFO | started process 12516 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8_KnIF/profile http://localhost:47689/getInfo.html) 08:16:23 INFO - PROCESS | 12516 | __metrics Screen width/height:1600/1200 08:16:23 INFO - PROCESS | 12516 | colorDepth:24 08:16:23 INFO - PROCESS | 12516 | Browser inner width/height: 1024/697 08:16:23 INFO - PROCESS | 12516 | __metrics 08:16:23 INFO - PROCESS | 12516 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:16:23 INFO - PROCESS | 12516 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:16:25 INFO - TEST-INFO | 12516: exit 0 08:16:25 INFO - Browser initialized. 08:16:25 INFO - Running cycle 1/1 for v8_7 test... 08:16:25 INFO - TEST-INFO | started process 12598 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8_KnIF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:16:36 INFO - PROCESS | 12598 | RSS: Main: 150986752 08:16:36 INFO - PROCESS | 12598 | 08:16:58 INFO - PROCESS | 12598 | Cycle 1(1): loaded http://localhost:47689/tests/v8_7/run.html (next: http://localhost:47689/tests/v8_7/run.html) 08:16:58 INFO - PROCESS | 12598 | RSS: Main: 617594880 08:16:58 INFO - PROCESS | 12598 | 08:16:58 INFO - PROCESS | 12598 | __start_tp_report 08:16:58 INFO - PROCESS | 12598 | _x_x_mozilla_page_load 08:16:58 INFO - PROCESS | 12598 | _x_x_mozilla_page_load_details 08:16:58 INFO - PROCESS | 12598 | |i|pagename|runs| 08:16:58 INFO - PROCESS | 12598 | |0;Richards;167.2800267648043 08:16:58 INFO - PROCESS | 12598 | |1;DeltaBlue;189.53752843062927 08:16:58 INFO - PROCESS | 12598 | |2;Encrypt;281.135788585887 08:16:58 INFO - PROCESS | 12598 | |3;Decrypt;5208.333333333333 08:16:58 INFO - PROCESS | 12598 | |4;RayTrace;1125.984251968504 08:16:58 INFO - PROCESS | 12598 | |5;Earley;788.6435331230284 08:16:58 INFO - PROCESS | 12598 | |6;Boyer;12419.753086419752 08:16:58 INFO - PROCESS | 12598 | |7;RegExp;26153.846153846152 08:16:58 INFO - PROCESS | 12598 | |8;Splay;636.477201748907 08:16:58 INFO - PROCESS | 12598 | |9;NavierStokes;4830.917874396136 08:16:58 INFO - PROCESS | 12598 | __end_tp_report 08:16:58 INFO - PROCESS | 12598 | __startTimestamp1451924218487__endTimestamp 08:16:58 INFO - PROCESS | 12598 | 08:16:58 INFO - PROCESS | 12598 | ------- Summary: start ------- 08:16:58 INFO - PROCESS | 12598 | Number of tests: 10 08:16:58 INFO - PROCESS | 12598 | 08:16:58 INFO - PROCESS | 12598 | [#0] Richards Cycles:1 Average:167.28 Median:167.28 stddev:0.00 (0.0%) 08:16:58 INFO - PROCESS | 12598 | Values: 167.3 08:16:58 INFO - PROCESS | 12598 | 08:16:58 INFO - PROCESS | 12598 | [#1] DeltaBlue Cycles:1 Average:189.54 Median:189.54 stddev:0.00 (0.0%) 08:16:58 INFO - PROCESS | 12598 | Values: 189.5 08:16:58 INFO - PROCESS | 12598 | 08:16:58 INFO - PROCESS | 12598 | [#2] Encrypt Cycles:1 Average:281.14 Median:281.14 stddev:0.00 (0.0%) 08:16:58 INFO - PROCESS | 12598 | Values: 281.1 08:16:58 INFO - PROCESS | 12598 | 08:16:58 INFO - PROCESS | 12598 | [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 08:16:58 INFO - PROCESS | 12598 | Values: 5208.3 08:16:58 INFO - PROCESS | 12598 | 08:16:58 INFO - PROCESS | 12598 | [#4] RayTrace Cycles:1 Average:1125.98 Median:1125.98 stddev:0.00 (0.0%) 08:16:58 INFO - PROCESS | 12598 | Values: 1126.0 08:16:58 INFO - PROCESS | 12598 | 08:16:58 INFO - PROCESS | 12598 | [#5] Earley Cycles:1 Average:788.64 Median:788.64 stddev:0.00 (0.0%) 08:16:58 INFO - PROCESS | 12598 | Values: 788.6 08:16:58 INFO - PROCESS | 12598 | 08:16:58 INFO - PROCESS | 12598 | [#6] Boyer Cycles:1 Average:12419.75 Median:12419.75 stddev:0.00 (0.0%) 08:16:58 INFO - PROCESS | 12598 | Values: 12419.8 08:16:58 INFO - PROCESS | 12598 | 08:16:58 INFO - PROCESS | 12598 | [#7] RegExp Cycles:1 Average:26153.85 Median:26153.85 stddev:0.00 (0.0%) 08:16:58 INFO - PROCESS | 12598 | Values: 26153.8 08:16:58 INFO - PROCESS | 12598 | 08:16:58 INFO - PROCESS | 12598 | [#8] Splay Cycles:1 Average:636.48 Median:636.48 stddev:0.00 (0.0%) 08:16:58 INFO - PROCESS | 12598 | Values: 636.5 08:16:58 INFO - PROCESS | 12598 | 08:16:58 INFO - PROCESS | 12598 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 08:16:58 INFO - PROCESS | 12598 | Values: 4830.9 08:16:58 INFO - PROCESS | 12598 | -------- Summary: end -------- 08:16:58 INFO - PROCESS | 12598 | 08:16:59 INFO - TEST-INFO | 12598: exit 0 08:16:59 INFO - TEST-OK | v8_7 | took 40053ms 08:16:59 INFO - SUITE-END | took 1212s 08:16:59 INFO - Completed test suite (00:20:13) 08:16:59 INFO - Working with test: dromaeo_css 08:16:59 INFO - Generating results file: dromaeo_css 08:16:59 INFO - Working with test: kraken 08:16:59 INFO - Generating results file: kraken 08:16:59 INFO - javascript benchmark 08:16:59 INFO - Working with test: v8_7 08:16:59 INFO - Generating results file: v8_7 08:16:59 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:16:59 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 08:16:59 INFO - process_Request line: dromaeo_css 6779.13 graph.html#tests=[[72,64,35]] 08:16:59 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:16:59 INFO - process_Request line: kraken 1503.50 graph.html#tests=[[232,64,35]] 08:16:59 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:16:59 INFO - process_Request line: v8_7 20798.36 graph.html#tests=[[230,64,35]] 08:16:59 INFO - RETURN: dromaeo_css: 6779.13 08:16:59 INFO - RETURN: kraken: 1503.50 08:16:59 INFO - RETURN: v8_7: 20798.36 08:16:59 INFO - javascript benchmark 08:16:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3084.892028778993, 3126.1403114143595, 3174.746020318373, 3178.8728450861954, 3206.871725130994, 5048.772805223764, 5231.2153177023465, 5253.605979551535, 5267.789288428463, 5309.867253318665, 5236.633435659505, 5261.605379596536, 5316.308879845615, 5341.359036915565, 5343.278657381253, 4779.90440191196, 4814.085323788487, 4840.515948405149, 4849.854504364857, 4899.020195960804, 4616.215243408628, 4841.0, 4865.805367785284, 4882.707037577757, 4932.950670493285, 4699.600533954618, 4709.835155769549, 4805.519448055202, 4809.0, 4837.0809546186465, 4815.398075240595, 4851.805927762885, 4853.053654537367, 4853.805847766085, 4884.3161957326, 4689.20283551797, 4810.158222311082, 4817.927731084036, 4855.247436647325, 4888.951110488885, 5046.899062018739, 5091.210862316347, 5106.846794596168, 5118.10433174193, 5126.692398456067, 5685.715714214272, 5685.772569097231, 5685.971570142165, 5688.374278829326, 5691.089425691911, 5514.0, 5623.0721930881355, 5711.029125048752, 5712.8857422851725, 5722.313322401297, 5176.818811341585, 5259.500347467061, 5271.920921186185, 5276.5251127398715, 5296.788128474856, 5846.1523079153285, 5851.970740146272, 5856.209411729447, 5860.501857342088, 5863.501602363847, 5414.485623865727, 5627.746751396197, 5641.435856414326, 5642.0972644377525, 5644.6330988485615, 5606.439356064442, 5640.71796410186, 5713.0, 5715.771369145187, 5755.884882302415, 5563.805266815642, 5565.276514053147, 5586.441355864381, 5588.524975377139, 5590.664560126405, 5484.506394424521, 5613.214150019001, 5617.8595535111135, 5627.831165065055, 5631.099024156198, 4374.365716971021, 4436.112777444524, 4463.24124898768, 4469.955300447019, 4470.865874023784, 3872.4772155759174, 3877.0307423144213, 3885.1258466845297, 3910.648041676263, 3913.1195481016543, 5166.5866730661455, 5251.474852514718, 5253.080710875582, 5254.527092561688, 5261.0, 5570.97214513933, 5595.0, 5621.662700237917, 5710.428957104339, 5735.483806457355, 5264.657797243167, 5274.92087618686, 5275.050490911596, 5277.076511610453, 5284.867878302996, 4600.378948841931, 4800.495947925488, 4806.663533552618, 4808.567228949341, 4832.830850920201, 5759.280089988752, 5797.88404231913, 5861.794837180678, 5871.500922421642, 5909.0, 5641.351244606923, 5644.858878527905, 5654.943450565606, 5657.264555607745, 5658.462446067617, 5551.111822108443, 5713.800016999551, 5830.096335068071, 5845.386234445492, 5855.443732845373, 5514.641548299348, 5580.525655319343, 5656.208130861765, 5671.404502527175, 5715.342735585461, 5656.321241451053, 5687.687177205294, 5692.31692196939, 5696.373398926032, 5711.571632127524, 5266.078436273713, 5387.811426600207, 5539.861503462284, 5559.388467268516, 5563.415841336601, 5405.054115529688, 5559.416261292506, 5567.860803479945, 5572.108462645957, 5614.24207731951, 5227.895442091213, 5315.803944112698, 5325.147976323769, 5326.6537675050995, 5368.812091576776, 5402.648827826179, 5424.159255315432, 5453.045716999589, 5505.9724701376235, 5552.167174923632, 5416.8104116355735, 5486.067368547277, 5498.752556134904, 5506.91739623914, 5524.447555244444], "unit": "score", "name": "dojo.html", "value": 5202.045949984478}, {"lowerIsBetter": false, "replicates": [536.0966770990879, 548.7722595123023, 564.463759428543, 570.8116321613867, 578.3840210176162, 28921.566176507342, 29484.705152948463, 29525.2618684533, 34607.826960865226, 35344.0, 37495.0, 37841.810790946074, 37957.24085518295, 37967.81016094916, 37974.810125949334, 8374.665013399457, 8534.530600816952, 8548.914510854875, 8556.272716819078, 8565.01502327234, 7394.334509894108, 7546.434017448686, 7566.167721550625, 7568.772936811904, 8325.708600198994, 7253.7098516059295, 10022.248331375176, 10149.644762433316, 10175.440350780704, 10253.487325633725, 9967.053129952643, 10075.798484030278, 10079.798404031952, 10082.495875206247, 10097.949510252474, 7394.815129621748, 7621.885671714928, 9781.168600668952, 9872.259580531418, 9910.0, 38291.617083829085, 38866.417003744966, 38924.0, 38935.0, 38941.80529097365, 3168.477201261789, 3185.140012196694, 3223.774335796495, 3257.0426931278375, 3314.5691060162267, 26553.867230663916, 26735.598966015525, 27994.16017519478, 28258.29354266139, 28334.149975500768, 3332.7000569948823, 3354.76516643835, 3360.4959256111533, 3364.34395292918, 3520.7887526748477, 213006.0, 216366.0, 216509.0, 216534.0, 216845.99999999843, 46710.29934550985, 47311.0, 47409.28886066712, 52238.477615224125, 52254.21618675723, 55180.17229741557, 55388.16917746237, 55510.444895551336, 55647.0, 55852.720736396055, 15045.322960466805, 15509.922450387901, 15529.922350388175, 15544.378224871105, 15550.377984880704, 11937.0, 12007.699807504707, 12055.276683399024, 12061.0, 12061.155719099754, 18337.541561460803, 18358.265669373344, 18366.0, 18404.907975460304, 18591.90704046471, 7378.594177320191, 7497.1753107158165, 7575.0, 7629.618519074024, 7797.0, 856.4261944497201, 876.3514998900895, 890.888638920135, 972.2076507646245, 977.0312819668374, 27381.0, 27473.86263068672, 27581.58627620587, 27916.30209244785, 27929.860350698524, 882.6116508736136, 944.9007854175212, 997.1005235027139, 1021.4382089850701, 1076.208986394999, 12685.175463594836, 12916.41876115577, 13088.672783180496, 13156.342182890818, 13156.60530184096, 300276.0, 306180.0, 306453.0, 306507.0, 308362.0, 49862.750686246334, 50044.249336259985, 50328.74835625799, 50476.24285635718, 50546.0, 1300.830891984036, 1309.4696647857634, 1323.993380033113, 1330.0157883166387, 1331.2944139606025, 23138.884305578365, 24793.132240371502, 24959.376015599755, 25223.099343575723, 25246.495070098863, 41883.58116418797, 42284.36573451462, 42349.57650423457, 42363.0, 42367.788161059, 276421.0, 288230.0, 291622.0, 291648.0, 291711.0, 23583.0, 30326.696733032386, 30465.390692186476, 30770.230744231572, 30875.845620772652, 34983.300333993684, 35496.82251588725, 35926.101847454025, 35932.64067359293, 36840.26319473649, 31185.220369490944, 31496.527552087195, 32802.50796238011, 34396.0, 34713.0, 29841.0, 33887.491687625195, 36403.0, 36642.85217460377, 37466.81266593649, 33847.0, 34169.82915085508, 34214.82892585521, 34762.0, 35329.47005794864, 29410.705892941653, 30027.399452011276, 30689.846550767998, 30737.692623073483, 30839.537406939362, 23517.41206469852, 23681.881590591936, 23804.761952380253, 23818.285451436484, 24057.63913541263], "unit": "score", "name": "ext.html", "value": 17330.717506210505}, {"lowerIsBetter": false, "replicates": [349.5386090360724, 354.1253104831067, 359.27605874163567, 359.4338916206971, 361.246800421122, 13951.093178943362, 14384.0, 16072.598185045365, 16424.425145119923, 17279.049652269136, 15864.28610712518, 15934.601634959132, 16495.422660206896, 16523.421680241194, 16526.83473165268, 4585.472670642869, 4760.619150467955, 4762.333273341735, 4765.046990601876, 4767.785449654774, 3736.757110787804, 3835.9616403835885, 4692.601128904047, 5314.867128321785, 5440.972795136019, 5342.465753424646, 5385.596080293974, 5392.838214853561, 5415.620906536544, 5429.185622156669, 5322.242443424588, 5922.2597175353085, 5978.790742323998, 5997.490213331872, 6011.158437818709, 5274.947250527484, 5287.0, 5304.257403963448, 5306.469353064701, 5307.495787900143, 17339.0, 19500.414987550397, 19820.30628927995, 20632.0, 20818.0, 1966.6558352288434, 2028.3103744726716, 2060.1759296281457, 2102.968455473154, 2157.7626461089267, 8921.0, 8988.280937524982, 9391.060893910622, 10547.894521054845, 12777.552785652551, 1717.6994026045393, 1750.422360620992, 1796.622709231063, 1799.9190036448392, 1826.8721189516739, 60477.58089676408, 62563.68718156426, 62860.0, 63724.362756372306, 64698.0, 9679.177269931994, 9986.850197246902, 10080.0, 10087.596496140071, 10137.391756494633, 13418.261995590141, 13431.19412835233, 13434.126781759154, 13448.46206151743, 13455.192688438725, 7368.37368823656, 7585.16563178061, 7609.771706848804, 7625.771226863203, 7695.961520192363, 7460.14208366034, 7486.887696684554, 7503.09962804467, 7512.323890849741, 7533.2466753324225, 4288.592583704543, 4344.1311737652595, 4350.282203436461, 4356.760378179167, 4370.868873933787, 1676.8490835824591, 1705.2837808120619, 1744.6859565278119, 1751.5008222656481, 1754.4473490850341, 847.4025811802665, 868.8609822428381, 869.4565896314804, 937.7139972308512, 963.2342287881152, 13660.726785464236, 15590.844091559165, 16406.0, 16558.917205413894, 16972.66054678924, 841.760098371961, 935.6771913689767, 935.9064093590723, 962.4514027004681, 975.1077763846143, 8573.099824518336, 8756.912430875736, 8904.59929303183, 8914.777130571658, 9035.186833185046, 532496.0, 534139.0, 542457.0, 546584.0, 550568.0, 73474.0, 77908.61045694849, 79355.60322198468, 80508.0, 81759.0, 1165.1901928159848, 1165.4231155578043, 1185.0874826383808, 1194.802857528498, 1217.0993464835958, 13783.241921694404, 13886.305684715522, 14007.43970241179, 14365.85634143687, 14367.353469094125, 34431.65568344285, 34548.30903381868, 35115.0, 35389.64610353864, 35557.64442355543, 43259.35110973401, 44356.0, 45603.77198113988, 46623.30065048959, 47127.0, 9380.484073375757, 9498.905010950079, 9668.661596844076, 9706.9029309706, 9748.171405430334, 11330.206885517935, 11412.201145919706, 11436.256643318491, 11573.652790416301, 11606.187566870576, 9848.507574621097, 12068.215565988183, 13425.194488330731, 13626.250556219504, 13784.724305514033, 10903.945480272865, 13559.389827457591, 13705.177689338672, 13801.240931748449, 13990.530994245457, 12952.0, 13945.163290202214, 14160.645983850487, 14291.785623215452, 14451.0, 9042.773930651787, 9238.491882946233, 9291.86062209081, 9457.574409151466, 9467.763305917408, 9777.657781977596, 12906.67733306675, 13889.166650001032, 14078.084924480285, 14439.350229239919], "unit": "score", "name": "jquery.html", "value": 8548.51776516695}, {"lowerIsBetter": false, "replicates": [1287.4335292471305, 1445.3495926832925, 1476.9335379907907, 1612.709712251795, 1778.9021603811793, 6603.537752357331, 7149.49953503255, 7249.528780629255, 7273.345398914096, 7281.708731650734, 7168.677409516571, 7284.162321333049, 7317.231690672483, 7329.6701648425815, 7336.156342020669, 1878.6618408686431, 1920.6830872905953, 1921.8750781199246, 2174.673798930165, 2217.81148602369, 1949.4249196486999, 2198.6701994700843, 2230.408941630469, 2231.7991380775725, 2240.09276243121, 2190.769969153232, 2210.806164671084, 2214.900329485169, 2225.0765932138142, 2253.5154941687533, 2196.527746534495, 2218.223621732397, 2224.7775222477785, 2225.2767850448668, 2225.899834507443, 2141.539568992674, 2176.3144609447972, 2176.4123686604685, 2177.1182671018105, 2179.836512261571, 7512.88730669035, 7565.2812982766545, 7573.734919277799, 7584.089909210875, 7587.355074818647, 4508.571685689854, 4567.566081222279, 4579.107074120548, 4581.427321584802, 4586.036932244233, 2869.2826793301674, 2911.650601927761, 2914.970850291491, 2922.415516896608, 2935.5890175375466, 949.0011167638664, 949.9050094990515, 960.9807803843954, 961.2838435365697, 978.7063880835792, 10032.749181270454, 10037.69886903394, 10039.799204015879, 10050.0, 10057.647982320585, 4081.8367265309057, 4149.6265336119895, 4187.183499217624, 4188.581141885848, 4206.348016057516, 8613.956930215434, 8617.35369847264, 8622.698205562776, 8625.827483450295, 8627.91372086271, 4605.792739326738, 4624.237000894882, 4654.511276316006, 4656.068786242765, 4667.97304592989, 4206.074663574009, 4209.305464598368, 4218.49378074633, 4220.198162349144, 4232.25935461293, 3284.901452956415, 3589.210373717778, 3598.1544337080763, 3662.9633703663153, 3665.4318580620047, 1055.4353420919772, 1116.7878103160535, 1123.7752449509967, 1132.773445310941, 1136.9431528423545, 1054.9103326217357, 1068.3376306689902, 1114.788190243851, 1189.1913498820884, 1286.311823174597, 6856.794296171123, 6908.1364829396325, 6936.722531098801, 6942.479314051467, 6958.930410695828, 1089.0362029603857, 1102.8400881872244, 1103.3379972016726, 1113.9443027848574, 1124.2579897267929, 5540.722963851791, 5637.295338082739, 5638.971805140948, 5639.125935480007, 5648.491635752802, 8482.872756908651, 8638.438501497509, 8670.913290867136, 8784.209421152127, 9083.772905677279, 8748.212660860427, 8787.648494060293, 8870.778230544289, 8871.556422178865, 8876.689315874042, 6667.499937504706, 6799.830004249834, 6830.59016459014, 6836.350546698155, 6951.756688515979, 6861.0, 6916.100906882073, 6920.550164239308, 6922.1001269836615, 6925.134358205224, 7288.635568221462, 7509.586972716553, 7551.622418879144, 7683.385329173541, 8065.758027259191, 7740.612969351398, 7884.566348850639, 8140.430169888051, 8269.586520673822, 8295.792605184919, 7044.682989265393, 7086.50394472382, 7146.392556632536, 7171.318724721144, 7186.928130718626, 6626.768063117768, 6757.358050985148, 7252.854942901218, 7308.30571095745, 7311.122665280201, 6145.139680444652, 6165.876682466236, 6727.2263689674355, 6841.760538381132, 7018.227994920657, 6599.0, 6679.06493090958, 6777.322267773183, 6886.0, 6946.617936013366, 6711.530192886451, 6750.257471678014, 6787.592744435349, 6811.829704257433, 6817.113775209191, 6387.4570661492435, 6439.356064393523, 6544.28012918569, 6556.311587283458, 6562.934370656423, 6446.4520515756685, 6480.967595161994, 6487.967560162358, 6488.221413430419, 6496.220453545605], "unit": "score", "name": "mootools.html", "value": 4311.365743020688}, {"lowerIsBetter": false, "replicates": [323.2742493102984, 328.382640635605, 329.6555099920583, 332.3220629914974, 335.18717111005805, 5733.885322293551, 5838.562107841913, 5859.853503662411, 5896.911546326798, 5923.526117910567, 5625.240592520008, 5770.076787713967, 5784.768609255635, 5812.970935145329, 5817.185594016841, 4515.2324104902245, 4516.4806047304655, 4518.390017347649, 4523.457185137771, 4532.478764942024, 4295.2912769393015, 4368.170047690945, 4398.450193725785, 4461.24158892989, 4512.729236245836, 4394.846180383687, 4402.537733537981, 4411.16187924295, 4426.55734426558, 4429.424174857264, 4425.822967081297, 4426.0, 4463.955360446386, 4466.33005049242, 4497.168023915553, 3950.723449358546, 3952.130531283113, 3954.228925359556, 3954.5452272988687, 3959.0, 5406.567474602022, 5535.944640553583, 5549.278593782782, 5554.333479982388, 5590.720463976825, 5165.483451654842, 5167.147420675584, 5167.612429067835, 5178.0679477694, 5188.948110518922, 6114.938850611526, 6115.755369785204, 6116.052011938156, 6132.080187971796, 6135.171751813493, 4328.63206627437, 4330.783460826946, 4331.328644060176, 4336.761478118702, 4337.262665346899, 6092.147099406086, 6185.752569897199, 6242.375762423767, 6430.131932189188, 6433.131527243809, 4438.511763705989, 4457.866264012085, 4458.487273963471, 4458.888527786831, 4465.330200469891, 4506.324051392317, 4513.1650644630845, 4516.096780643885, 4517.503074661785, 4523.0, 4994.225894986283, 5155.561777248976, 5166.405863325691, 5167.793288268427, 5184.196449550326, 6173.290071641729, 6186.597871138361, 6206.286277078194, 6209.472194863487, 6235.688215589203, 1580.6680597074744, 1594.4020992127953, 1597.5526852481323, 1598.472504073653, 1599.4242072853997, 1028.88682244953, 1039.3348257115451, 1062.2404980439023, 1091.1979694924225, 1094.3105843318658, 5892.292924849045, 5897.64614123154, 5903.557233207441, 5911.201987731602, 5914.76340946366, 6389.393007664265, 6394.296627370985, 6394.808155755335, 6397.040443933447, 6405.19935008124, 5872.911906321408, 5894.616849904743, 5901.793437229762, 5914.2311499504785, 5916.645001299936, 3354.26206234628, 3443.362977849106, 3443.724502039831, 3455.980485756708, 3458.342914846171, 6536.803895883131, 6590.3080176581725, 6688.3646053624825, 6698.0, 6700.463962882957, 6634.170728658918, 6637.634930078795, 6638.369354911276, 6641.269460359356, 6643.5017373697165, 6524.902126468107, 6678.265390807007, 6679.398854103057, 6684.598924064669, 6688.7324507019175, 6408.102865598913, 6423.7430502781235, 6446.67766611677, 6449.322821103717, 6456.418922297016, 6093.48205402528, 6363.459105976044, 6366.140571023038, 6381.042843573316, 6389.648569328731, 6131.785387511416, 6429.164208652845, 6538.378854008862, 6692.230393504615, 6706.329367063255, 4414.42612460391, 4457.977710111429, 4463.620592249695, 4466.57567531084, 4466.843660471868, 6409.743610255724, 6418.261899881573, 6451.870962580816, 6455.9677201613695, 6459.289478157305, 6130.0, 6272.184616000073, 6276.843078923063, 6296.181496405438, 6307.148534947723, 6226.066090086523, 6277.96861015692, 6280.0893870389455, 6285.528585356025, 6291.685415729286, 6134.723937422916, 6165.815025549241, 6170.753169873335, 6191.721372538336, 6202.0, 6209.0, 6287.245530536365, 6320.431161195331, 6320.462760665395, 6336.112944187726, 6174.876502469836, 6179.351168127282, 6184.690765461619, 6185.783497577563, 6185.84535386601], "unit": "score", "name": "prototype.html", "value": 4688.043533236047}, {"lowerIsBetter": false, "replicates": [770.614692653673, 817.0930267403181, 831.484479622634, 851.6593362654941, 895.1853813030144, 13420.865791342083, 13609.319534023283, 13619.387127579257, 13657.112287701304, 13674.0, 12736.172148810321, 12761.936190319035, 12763.872361276384, 12776.93611531941, 12783.29691866947, 681.553582403524, 687.3298533929404, 800.5556915911667, 815.388458656008, 818.0755746007004, 826.3182874128838, 827.0241115483727, 834.7537476444434, 835.1815221083342, 835.4402550291289, 708.3518580498837, 858.7767180533075, 868.1362044765467, 869.0614136732314, 869.7738587967142, 704.9259827718092, 848.5587494502855, 853.0318088969003, 855.0338117926765, 856.5802756649259, 636.360457739973, 636.700750647195, 636.9681515924185, 637.4868231073983, 637.588755252864, 13120.212787232796, 13213.537526186537, 13222.537211197658, 13240.139390939557, 13249.271290079041, 11925.522979080826, 12250.693732656666, 12412.875871241262, 12704.872951270461, 12806.03954703401, 9935.602575896955, 9963.302568820185, 10073.89926100737, 10183.796324073477, 10232.334898231591, 3604.5494313210847, 3661.7436779425184, 3677.6322367763278, 3686.502322186524, 3774.565924918642, 47153.29270060952, 47828.28257576139, 47916.28125578119, 48104.5189548107, 48112.278315824944, 10127.0, 10144.442055687008, 10187.185025197967, 10306.690799276033, 10335.379877207391, 17939.0, 17948.0, 17952.102394880465, 17956.1021948902, 17975.370862019765, 6980.704307622195, 7057.0, 7153.141623005273, 7155.570665760071, 7189.784306470814, 4038.5759495253164, 4121.196366708523, 4153.792310384469, 4171.124063946544, 4194.622483976456, 3146.0719087869134, 3168.651448340681, 3174.730147937451, 3179.9046028618714, 3180.300333926579, 555.5916401444935, 562.6652141975518, 574.4887050524952, 575.4791913318453, 577.053632043449, 609.5732986909181, 646.9902951455732, 657.5561495990188, 678.2911857109333, 679.78246960973, 8403.747887563382, 8544.401891867634, 8599.914000860037, 8823.029466758651, 8955.014948355676, 508.29347207381767, 544.6650310059364, 551.1429726774903, 552.5220684108217, 560.7028275014248, 3872.5740168581433, 3881.301365754135, 3975.960240397617, 4040.515138183378, 4141.730787498803, 51496.22755658668, 51865.2220216697, 51895.0699683537, 52065.7396713014, 52307.47692523102, 47145.29282060772, 49395.259071113964, 49462.258066129034, 49504.50495495071, 49630.50369496259, 43779.78110109429, 44113.11773764571, 44240.3363949541, 45170.32244516335, 45211.54788452073, 8218.794530136794, 8353.665853366041, 8626.5255410953, 8701.608427620646, 8791.604377803142, 33357.66642333545, 34473.138171545914, 34672.479912801835, 34779.65220347764, 35036.94889153329, 40333.798331008154, 40681.59318406778, 40705.38941915814, 40910.386344204264, 41388.0, 10542.947285263524, 10654.680359589225, 10871.67384978452, 11009.61466348674, 11033.613823516138, 12008.39958002114, 12128.696782580153, 12158.0, 12224.327661978676, 12788.808167877303, 11144.554217831195, 11220.831687524857, 11556.422178890854, 11605.491286132748, 11859.110566707359, 10946.233763636468, 11750.58872939443, 11845.289282643069, 12211.572594959134, 12219.205751626116, 11444.313341199555, 11679.883201168219, 11688.123390745557, 11706.648800535997, 12075.27548347102, 9844.803103938024, 9989.60041598328, 10083.647072352433, 10277.588896444358, 10303.303943993058, 9448.48033358172, 9847.185172697864, 9875.703728888146, 9971.252156088467, 10098.343607665478], "unit": "score", "name": "yui.html", "value": 6230.442600715771}], "name": "dromaeo_css", "value": 6779.133141846725}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 106.0, 109.0, 110.0, 111.0, 100.0, 109.0, 109.0, 102.0], "unit": "score", "name": "ai-astar", "value": 107.6}, {"lowerIsBetter": true, "replicates": [155.0, 126.0, 150.0, 164.0, 131.0, 150.0, 146.0, 133.0, 166.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 144.9}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 159.0, 161.0, 161.0, 160.0, 162.0, 161.0, 163.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 83.0, 90.0, 73.0, 72.0, 71.0, 101.0, 97.0, 71.0], "unit": "score", "name": "audio-fft", "value": 80.7}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 152.0, 96.0, 96.0, 96.0, 152.0, 96.0, 97.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 111.3}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 57.0, 57.0, 57.0, 58.0, 56.0, 65.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.3}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 86.0, 96.0, 86.0, 86.0, 87.0, 85.0, 89.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.1}, {"lowerIsBetter": true, "replicates": [121.0, 121.0, 122.0, 116.0, 117.0, 115.0, 117.0, 116.0, 117.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.4}, {"lowerIsBetter": true, "replicates": [145.0, 160.0, 152.0, 150.0, 151.0, 140.0, 145.0, 150.0, 149.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.3}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 68.0, 67.0, 68.0, 68.0, 68.0, 69.0, 69.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1503.4999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.2800267648043], "unit": "score", "name": "Richards", "value": 211.03535600000004}, {"lowerIsBetter": false, "replicates": [189.53752843062927], "unit": "score", "name": "DeltaBlue", "value": 348.8385680000001}, {"lowerIsBetter": false, "replicates": [281.135788585887], "unit": "score", "name": "Encrypt", "value": 946.8058169999996}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1125.984251968504], "unit": "score", "name": "RayTrace", "value": 657.1930279720283}, {"lowerIsBetter": false, "replicates": [788.6435331230284], "unit": "score", "name": "Earley", "value": 845.075084}, {"lowerIsBetter": false, "replicates": [12419.753086419752], "unit": "score", "name": "Boyer", "value": 53.66153379721673}, {"lowerIsBetter": false, "replicates": [26153.846153846152], "unit": "score", "name": "RegExp", "value": 34.8317794117647}, {"lowerIsBetter": false, "replicates": [636.477201748907], "unit": "score", "name": "Splay", "value": 128.03443670264969}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20798.364855901124}]} 08:16:59 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20798.36"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1503.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6779.13"}}} 08:16:59 INFO - Return code: 0 08:16:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:16:59 INFO - # TBPL SUCCESS # 08:16:59 INFO - Running post-action listener: _resource_record_post_action 08:16:59 INFO - Running post-run listener: _resource_record_post_run 08:17:00 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 571662336; Read time: 0; Write time: 567328 08:17:00 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252375040; Read time: 0; Write time: 340028 08:17:00 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 0; Write bytes: 319287296; Read time: 0; Write time: 227300 08:17:00 INFO - Running post-run listener: _upload_blobber_files 08:17:00 INFO - Blob upload gear active. 08:17:00 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:17:00 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 08:17:00 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'] 08:17:00 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 08:17:01 INFO - (blobuploader) - INFO - Open directory for files ... 08:17:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:17:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:17:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:17:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:17:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:17:02 INFO - (blobuploader) - INFO - Done attempting. 08:17:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 08:17:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:17:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:17:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:17:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:17:03 INFO - (blobuploader) - INFO - Done attempting. 08:17:03 INFO - (blobuploader) - INFO - Iteration through files over. 08:17:03 INFO - Return code: 0 08:17:03 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:17:03 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:17:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1d98fd6c97224e291918ff4f25a52640ebbaeb89700cf9dbcb9e66971104fbd0e57de3fbc8ce271bb49dc1d15c2639de975b115a1ff197d86affed56b787d253", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e22ce032dd2cae8270a249b944f082b6edc9e7790589c63d2ece9e4d2ed2612020b0d6293f1a7dbd30f5c9151093ac82465eb96b2dc7e938637044939353ec03"} 08:17:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:17:03 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:17:03 INFO - Contents: 08:17:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1d98fd6c97224e291918ff4f25a52640ebbaeb89700cf9dbcb9e66971104fbd0e57de3fbc8ce271bb49dc1d15c2639de975b115a1ff197d86affed56b787d253", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e22ce032dd2cae8270a249b944f082b6edc9e7790589c63d2ece9e4d2ed2612020b0d6293f1a7dbd30f5c9151093ac82465eb96b2dc7e938637044939353ec03"} 08:17:03 INFO - Copying logs to upload dir... 08:17:03 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1270.597245 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-04 08:17:03.585477) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 08:17:03.588995) ========= 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=aa52b8aba932b19cc50b5275000001de-1451921101.252698-1044458391 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/1d98fd6c97224e291918ff4f25a52640ebbaeb89700cf9dbcb9e66971104fbd0e57de3fbc8ce271bb49dc1d15c2639de975b115a1ff197d86affed56b787d253", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e22ce032dd2cae8270a249b944f082b6edc9e7790589c63d2ece9e4d2ed2612020b0d6293f1a7dbd30f5c9151093ac82465eb96b2dc7e938637044939353ec03"} build_url:https://queue.taskcluster.net/v1/task/FtdBAnaaTRa9fLMqZLODwQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011130 build_url: 'https://queue.taskcluster.net/v1/task/FtdBAnaaTRa9fLMqZLODwQ/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/1d98fd6c97224e291918ff4f25a52640ebbaeb89700cf9dbcb9e66971104fbd0e57de3fbc8ce271bb49dc1d15c2639de975b115a1ff197d86affed56b787d253", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e22ce032dd2cae8270a249b944f082b6edc9e7790589c63d2ece9e4d2ed2612020b0d6293f1a7dbd30f5c9151093ac82465eb96b2dc7e938637044939353ec03"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 08:17:03.614268) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 08:17:03.614698) ========= 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=aa52b8aba932b19cc50b5275000001de-1451921101.252698-1044458391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004563 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 08:17:03.697100) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 08:17:03.697514) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 08:17:03.697928) ========= ========= Total master_lag: 0.25 =========