builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-036 starttime: 1451706684.53 results: success (0) buildid: 20160101173004 builduid: 8363781bf1b84107ad43bc71660b056c revision: 1f682dc05790a8ab1cdda60dad61e511ba611629 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:24.530608) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:24.531152) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:24.531458) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1451705884.266894-1085942255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006386 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:24.576670) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:24.576971) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:24.648534) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:24.648831) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1451705884.266894-1085942255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004579 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:24.703012) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:24.703312) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:24.703676) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:24.703948) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1451705884.266894-1085942255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-01 19:51:24-- 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% 84.6M=0s 2016-01-01 19:51:25 (84.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169507 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:24.887892) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:24.888212) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1451705884.266894-1085942255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018721 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:24.937977) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-01 19:51:24.938345) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1f682dc05790a8ab1cdda60dad61e511ba611629 --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 1f682dc05790a8ab1cdda60dad61e511ba611629 --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=9c54e757a4c805d85fea3bc7000001f2-1451705884.266894-1085942255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-01 19:51:25,271 truncating revision to first 12 chars 2016-01-01 19:51:25,271 Setting DEBUG logging. 2016-01-01 19:51:25,271 attempt 1/10 2016-01-01 19:51:25,271 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1f682dc05790?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-01 19:51:26,581 unpacking tar archive at: fx-team-1f682dc05790/testing/mozharness/ program finished with exit code 0 elapsedTime=1.598338 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-01 19:51:26.549580) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:26.549887) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:26.560254) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:26.560624) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-01 19:51:26.561087) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-01 19:51:26.561373) ========= /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=9c54e757a4c805d85fea3bc7000001f2-1451705884.266894-1085942255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:51:26 INFO - MultiFileLogger online at 20160101 19:51:26 in /builds/slave/test-pgo 19:51:26 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 19:51:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:51:26 INFO - {'append_to_log': False, 19:51:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:51:26 INFO - 'blob_upload_branch': 'Fx-Team', 19:51:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:51:26 INFO - 'branch': 'Fx-Team', 19:51:26 INFO - 'buildbot_json_path': 'buildprops.json', 19:51:26 INFO - 'config_files': ('talos/linux_config.py',), 19:51:26 INFO - 'default_actions': ('clobber', 19:51:26 INFO - 'read-buildbot-config', 19:51:26 INFO - 'download-and-extract', 19:51:26 INFO - 'populate-webroot', 19:51:26 INFO - 'create-virtualenv', 19:51:26 INFO - 'install', 19:51:26 INFO - 'run-tests'), 19:51:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:51:26 INFO - 'download_minidump_stackwalk': True, 19:51:26 INFO - 'download_symbols': 'ondemand', 19:51:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:51:26 INFO - 'tooltool.py': '/tools/tooltool.py', 19:51:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:51:26 INFO - '/tools/misc-python/virtualenv.py')}, 19:51:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:51:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:51:26 INFO - 'installer_path': 'installer.exe', 19:51:26 INFO - 'log_level': 'info', 19:51:26 INFO - 'log_name': 'talos', 19:51:26 INFO - 'log_to_console': True, 19:51:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:51:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:51:26 INFO - 'opt_config_files': (), 19:51:26 INFO - 'pip_index': False, 19:51:26 INFO - 'sps_profile': False, 19:51:26 INFO - 'sps_profile_interval': 0, 19:51:26 INFO - 'suite': 'dromaeojs', 19:51:26 INFO - 'system_bits': '32', 19:51:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:51:26 INFO - 'title': 'talos-linux64-ix-036', 19:51:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:51:26 INFO - 'use_talos_json': True, 19:51:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:51:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:51:26 INFO - 'work_dir': 'build'} 19:51:26 INFO - ##### 19:51:26 INFO - ##### Running clobber step. 19:51:26 INFO - ##### 19:51:26 INFO - Running pre-action listener: _resource_record_pre_action 19:51:26 INFO - Running main action method: clobber 19:51:26 INFO - rmtree: /builds/slave/test-pgo/build 19:51:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:51:27 INFO - Running post-action listener: _resource_record_post_action 19:51:27 INFO - ##### 19:51:27 INFO - ##### Running read-buildbot-config step. 19:51:27 INFO - ##### 19:51:27 INFO - Running pre-action listener: _resource_record_pre_action 19:51:27 INFO - Running main action method: read_buildbot_config 19:51:27 INFO - Using buildbot properties: 19:51:27 INFO - { 19:51:27 INFO - "project": "", 19:51:27 INFO - "product": "firefox", 19:51:27 INFO - "script_repo_revision": "production", 19:51:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:51:27 INFO - "repository": "", 19:51:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 19:51:27 INFO - "buildid": "20160101173004", 19:51:27 INFO - "pgo_build": "True", 19:51:27 INFO - "basedir": "/builds/slave/test-pgo", 19:51:27 INFO - "buildnumber": 866, 19:51:27 INFO - "slavename": "talos-linux64-ix-036", 19:51:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:51:27 INFO - "platform": "ubuntu64_hw", 19:51:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:51:27 INFO - "branch": "fx-team", 19:51:27 INFO - "repo_path": "integration/fx-team", 19:51:27 INFO - "revision": "1f682dc05790a8ab1cdda60dad61e511ba611629", 19:51:27 INFO - "stage_platform": "linux64-pgo", 19:51:27 INFO - "builduid": "8363781bf1b84107ad43bc71660b056c", 19:51:27 INFO - "slavebuilddir": "test" 19:51:27 INFO - } 19:51:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:51:27 INFO - Running post-action listener: _resource_record_post_action 19:51:27 INFO - ##### 19:51:27 INFO - ##### Running download-and-extract step. 19:51:27 INFO - ##### 19:51:27 INFO - Running pre-action listener: _resource_record_pre_action 19:51:27 INFO - Running main action method: download_and_extract 19:51:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:51:27 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')]} 19:51:27 INFO - https://queue.taskcluster.net/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:51:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/test_packages.json 19:51:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/test_packages.json 19:51:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:51:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:51:30 INFO - Downloaded 1302 bytes. 19:51:30 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:51:30 INFO - Using the following test package requirements: 19:51:30 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:51:30 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:51:30 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:30 INFO - u'jsshell-linux-x86_64.zip'], 19:51:30 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:51:30 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:51:30 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:51:30 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:51:30 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:51:30 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:51:30 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:51:30 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:51:30 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')]} 19:51:30 INFO - https://queue.taskcluster.net/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:51:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:51:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:51:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/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 19:51:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/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 19:51:33 INFO - Downloaded 23198211 bytes. 19:51:33 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 19:51:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:51:33 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 19:51:34 INFO - Return code: 0 19:51:34 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 19:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:34 INFO - https://queue.taskcluster.net/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:51:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:51:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:51:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/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 19:51:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/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 19:51:38 INFO - Downloaded 23198211 bytes. 19:51:38 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 19:51:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:51:38 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 19:51:40 INFO - Return code: 0 19:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:40 INFO - https://queue.taskcluster.net/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:51:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:51:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:51:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/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 19:51:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/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 19:51:41 INFO - Downloaded 11132285 bytes. 19:51:41 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 19:51:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:51:41 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 19:51:41 INFO - Return code: 0 19:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:41 INFO - https://queue.taskcluster.net/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:51:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:51:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:51:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/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 19:51:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/acMhVtLJRSaAMEMRWU2YHg/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 19:51:42 INFO - Downloaded 54982849 bytes. 19:51:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:51:42 INFO - mkdir: /builds/slave/test-pgo/properties 19:51:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:51:42 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:51:42 INFO - Contents: 19:51:42 INFO - build_url:https://queue.taskcluster.net/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:51:42 INFO - Running post-action listener: _resource_record_post_action 19:51:42 INFO - Running post-action listener: set_extra_try_arguments 19:51:42 INFO - ##### 19:51:42 INFO - ##### Running populate-webroot step. 19:51:42 INFO - ##### 19:51:42 INFO - Running pre-action listener: _resource_record_pre_action 19:51:42 INFO - Running main action method: populate_webroot 19:51:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:51:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:51:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:51:42 INFO - '--tppagecycles', 19:51:42 INFO - '7'], 19:51:42 INFO - 'tests': ['tsvgm']}}, 19:51:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:51:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:51:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:51:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:51:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:51:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:51:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:51:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:42 INFO - 'talos_options': ['--e10s'], 19:51:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:51:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:42 INFO - 'tests': ['damp', 'tps']}, 19:51:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:42 INFO - 'talos_options': ['--e10s'], 19:51:42 INFO - 'tests': ['damp', 'tps']}, 19:51:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:51:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:51:42 INFO - 'other': {'tests': ['a11yr', 19:51:42 INFO - 'ts_paint', 19:51:42 INFO - 'tpaint', 19:51:42 INFO - 'sessionrestore', 19:51:42 INFO - 'sessionrestore_no_auto_restore']}, 19:51:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:51:42 INFO - 'tests': ['a11yr', 19:51:42 INFO - 'ts_paint', 19:51:42 INFO - 'tpaint', 19:51:42 INFO - 'sessionrestore', 19:51:42 INFO - 'sessionrestore_no_auto_restore']}, 19:51:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:51:42 INFO - 'tests': ['a11yr', 19:51:42 INFO - 'ts_paint', 19:51:42 INFO - 'tpaint', 19:51:42 INFO - 'sessionrestore', 19:51:42 INFO - 'sessionrestore_no_auto_restore']}, 19:51:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:51:42 INFO - 'tests': ['a11yr', 19:51:42 INFO - 'ts_paint', 19:51:42 INFO - 'tpaint', 19:51:42 INFO - 'sessionrestore', 19:51:42 INFO - 'sessionrestore_no_auto_restore']}, 19:51:42 INFO - 'other_l64': {'tests': ['a11yr', 19:51:42 INFO - 'ts_paint', 19:51:42 INFO - 'tpaint', 19:51:42 INFO - 'sessionrestore', 19:51:42 INFO - 'sessionrestore_no_auto_restore']}, 19:51:42 INFO - 'other_nol64': {'tests': ['a11yr', 19:51:42 INFO - 'ts_paint', 19:51:42 INFO - 'tpaint', 19:51:42 INFO - 'sessionrestore', 19:51:42 INFO - 'sessionrestore_no_auto_restore']}, 19:51:42 INFO - 'svgr': {'tests': ['tsvgx', 19:51:42 INFO - 'tsvgr_opacity', 19:51:42 INFO - 'tart', 19:51:42 INFO - 'tscrollx', 19:51:42 INFO - 'cart']}, 19:51:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:51:42 INFO - 'tests': ['tsvgx', 19:51:42 INFO - 'tsvgr_opacity', 19:51:42 INFO - 'tart', 19:51:42 INFO - 'tscrollx', 19:51:42 INFO - 'cart']}, 19:51:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:42 INFO - 'tests': ['tp5o']}, 19:51:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:42 INFO - 'talos_options': ['--e10s'], 19:51:42 INFO - 'tests': ['tp5o']}, 19:51:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:42 INFO - 'talos_options': ['--xperf_path', 19:51:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:51:42 INFO - 'tests': ['tp5n']}, 19:51:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:42 INFO - 'talos_options': ['--e10s', 19:51:42 INFO - '--xperf_path', 19:51:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:51:42 INFO - 'tests': ['tp5n']}}, 19:51:42 INFO - 'talos.zip': {'path': '', 19:51:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:51:42 INFO - Running post-action listener: _resource_record_post_action 19:51:42 INFO - ##### 19:51:42 INFO - ##### Running create-virtualenv step. 19:51:42 INFO - ##### 19:51:42 INFO - Running pre-action listener: _resource_record_pre_action 19:51:42 INFO - Running main action method: create_virtualenv 19:51:42 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:51:42 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 19:51:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:51:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:51:42 INFO - Using real prefix '/usr' 19:51:42 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:51:43 INFO - Installing distribute.............................................................................................................................................................................................done. 19:51:45 INFO - Installing pip.................done. 19:51:45 INFO - Return code: 0 19:51:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:51: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')]} 19:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51: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')]} 19:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:45 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 0x7f0133146f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ff630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890840>, '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 0x17fd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17fdb60>, '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': '9c54e757a4c805d85fea3bc7000001f2-1451705884.266894-1085942255', '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 19:51:45 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 19:51:45 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 19:51:45 INFO - Using env: {'DISPLAY': ':0', 19:51:45 INFO - 'HOME': '/home/cltbld', 19:51:45 INFO - 'LANG': 'en_US.UTF-8', 19:51:45 INFO - 'LANGUAGE': 'en_US:en', 19:51:45 INFO - 'LOGNAME': 'cltbld', 19:51:45 INFO - 'MAIL': '/var/mail/cltbld', 19:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:45 INFO - 'MOZ_NO_REMOTE': '1', 19:51:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:45 INFO - 'NO_EM_RESTART': '1', 19:51:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:45 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:45 INFO - 'SHELL': '/bin/bash', 19:51:45 INFO - 'SHLVL': '1', 19:51:45 INFO - 'TERM': 'linux', 19:51:45 INFO - 'TMOUT': '86400', 19:51:45 INFO - 'USER': 'cltbld', 19:51:45 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1451705884.266894-1085942255', 19:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:45 INFO - '_': '/tools/buildbot/bin/python'} 19:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:45 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 19:51:45 INFO - Cleaning up... 19:51:45 INFO - Return code: 0 19:51:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:51: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')]} 19:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51: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')]} 19:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:45 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 0x7f0133146f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ff630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890840>, '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 0x17fd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17fdb60>, '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': '9c54e757a4c805d85fea3bc7000001f2-1451705884.266894-1085942255', '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 19:51:45 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 19:51:45 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 19:51:45 INFO - Using env: {'DISPLAY': ':0', 19:51:45 INFO - 'HOME': '/home/cltbld', 19:51:45 INFO - 'LANG': 'en_US.UTF-8', 19:51:45 INFO - 'LANGUAGE': 'en_US:en', 19:51:45 INFO - 'LOGNAME': 'cltbld', 19:51:45 INFO - 'MAIL': '/var/mail/cltbld', 19:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:45 INFO - 'MOZ_NO_REMOTE': '1', 19:51:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:45 INFO - 'NO_EM_RESTART': '1', 19:51:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:45 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:45 INFO - 'SHELL': '/bin/bash', 19:51:45 INFO - 'SHLVL': '1', 19:51:45 INFO - 'TERM': 'linux', 19:51:45 INFO - 'TMOUT': '86400', 19:51:45 INFO - 'USER': 'cltbld', 19:51:45 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1451705884.266894-1085942255', 19:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:45 INFO - '_': '/tools/buildbot/bin/python'} 19:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:45 INFO - Downloading/unpacking psutil>=0.7.1 19:51:45 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 19:51:45 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 19:51:45 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 19:51:45 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 19:51:45 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 19:51:45 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 19:51:47 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:51:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:51:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:51:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:51:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:51:47 INFO - Installing collected packages: psutil 19:51:47 INFO - Running setup.py install for psutil 19:51:47 INFO - building 'psutil._psutil_linux' extension 19:51:47 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 19:51:47 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 19:51:48 INFO - building 'psutil._psutil_posix' extension 19:51:48 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 19:51:48 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 19:51:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:51:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:51:48 INFO - Successfully installed psutil 19:51:48 INFO - Cleaning up... 19:51:48 INFO - Return code: 0 19:51:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:51:48 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')]} 19:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:48 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')]} 19:51:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:48 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 0x7f0133146f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ff630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890840>, '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 0x17fd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17fdb60>, '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': '9c54e757a4c805d85fea3bc7000001f2-1451705884.266894-1085942255', '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 19:51:48 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 19:51:48 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 19:51:48 INFO - Using env: {'DISPLAY': ':0', 19:51:48 INFO - 'HOME': '/home/cltbld', 19:51:48 INFO - 'LANG': 'en_US.UTF-8', 19:51:48 INFO - 'LANGUAGE': 'en_US:en', 19:51:48 INFO - 'LOGNAME': 'cltbld', 19:51:48 INFO - 'MAIL': '/var/mail/cltbld', 19:51:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:48 INFO - 'MOZ_NO_REMOTE': '1', 19:51:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:48 INFO - 'NO_EM_RESTART': '1', 19:51:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:48 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:48 INFO - 'SHELL': '/bin/bash', 19:51:48 INFO - 'SHLVL': '1', 19:51:48 INFO - 'TERM': 'linux', 19:51:48 INFO - 'TMOUT': '86400', 19:51:48 INFO - 'USER': 'cltbld', 19:51:48 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1451705884.266894-1085942255', 19:51:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:48 INFO - '_': '/tools/buildbot/bin/python'} 19:51:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:51:48 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 19:51:48 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 19:51:48 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 19:51:48 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 19:51:48 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 19:51:48 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 19:51:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:51:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:51:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:51:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:51:50 INFO - Installing collected packages: mozsystemmonitor 19:51:50 INFO - Running setup.py install for mozsystemmonitor 19:51:50 INFO - Successfully installed mozsystemmonitor 19:51:50 INFO - Cleaning up... 19:51:50 INFO - Return code: 0 19:51:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:51:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:50 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 0x7f0133146f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ff630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890840>, '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 0x17fd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17fdb60>, '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': '9c54e757a4c805d85fea3bc7000001f2-1451705884.266894-1085942255', '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 19:51:50 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 19:51:50 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 19:51:50 INFO - Using env: {'DISPLAY': ':0', 19:51:50 INFO - 'HOME': '/home/cltbld', 19:51:50 INFO - 'LANG': 'en_US.UTF-8', 19:51:50 INFO - 'LANGUAGE': 'en_US:en', 19:51:50 INFO - 'LOGNAME': 'cltbld', 19:51:50 INFO - 'MAIL': '/var/mail/cltbld', 19:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:50 INFO - 'MOZ_NO_REMOTE': '1', 19:51:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:50 INFO - 'NO_EM_RESTART': '1', 19:51:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:50 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:50 INFO - 'SHELL': '/bin/bash', 19:51:50 INFO - 'SHLVL': '1', 19:51:50 INFO - 'TERM': 'linux', 19:51:50 INFO - 'TMOUT': '86400', 19:51:50 INFO - 'USER': 'cltbld', 19:51:50 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1451705884.266894-1085942255', 19:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:50 INFO - '_': '/tools/buildbot/bin/python'} 19:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:50 INFO - Downloading/unpacking blobuploader==1.2.4 19:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:52 INFO - Downloading blobuploader-1.2.4.tar.gz 19:51:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:51:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:51:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:51:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:51:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:52 INFO - Downloading docopt-0.6.1.tar.gz 19:51:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:51:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:51:53 INFO - Installing collected packages: blobuploader, requests, docopt 19:51:53 INFO - Running setup.py install for blobuploader 19:51:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:51:53 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:51:53 INFO - Running setup.py install for requests 19:51:53 INFO - Running setup.py install for docopt 19:51:53 INFO - Successfully installed blobuploader requests docopt 19:51:53 INFO - Cleaning up... 19:51:53 INFO - Return code: 0 19:51:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:51:53 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')]} 19:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:53 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')]} 19:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:53 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 0x7f0133146f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ff630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890840>, '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 0x17fd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17fdb60>, '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': '9c54e757a4c805d85fea3bc7000001f2-1451705884.266894-1085942255', '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 19:51:53 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 19:51:53 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 19:51:53 INFO - Using env: {'DISPLAY': ':0', 19:51:53 INFO - 'HOME': '/home/cltbld', 19:51:53 INFO - 'LANG': 'en_US.UTF-8', 19:51:53 INFO - 'LANGUAGE': 'en_US:en', 19:51:53 INFO - 'LOGNAME': 'cltbld', 19:51:53 INFO - 'MAIL': '/var/mail/cltbld', 19:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:53 INFO - 'MOZ_NO_REMOTE': '1', 19:51:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:53 INFO - 'NO_EM_RESTART': '1', 19:51:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:53 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:53 INFO - 'SHELL': '/bin/bash', 19:51:53 INFO - 'SHLVL': '1', 19:51:53 INFO - 'TERM': 'linux', 19:51:53 INFO - 'TMOUT': '86400', 19:51:53 INFO - 'USER': 'cltbld', 19:51:53 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1451705884.266894-1085942255', 19:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:53 INFO - '_': '/tools/buildbot/bin/python'} 19:51:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:51:53 INFO - Running setup.py (path:/tmp/pip-TCg9i8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:51:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:51:53 INFO - Running setup.py (path:/tmp/pip-d9VdNY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:51:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:51:53 INFO - Running setup.py (path:/tmp/pip-49TBKX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:51:54 INFO - Running setup.py (path:/tmp/pip-XFiXKv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:51:54 INFO - Running setup.py (path:/tmp/pip-_ZonF7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:51:54 INFO - Running setup.py (path:/tmp/pip-rSEYvO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:51:54 INFO - Running setup.py (path:/tmp/pip-78VzUg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:51:54 INFO - Running setup.py (path:/tmp/pip-NLn8NO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:51:54 INFO - Running setup.py (path:/tmp/pip-620GiJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:51:54 INFO - Running setup.py (path:/tmp/pip-bDmRf3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:51:54 INFO - Running setup.py (path:/tmp/pip-69Wo4D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:51:54 INFO - Running setup.py (path:/tmp/pip-HBwPbL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:51:54 INFO - Running setup.py (path:/tmp/pip-6fdEM5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:51:54 INFO - Running setup.py (path:/tmp/pip-aHlFvW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:51:54 INFO - Running setup.py (path:/tmp/pip-mKOwKJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:51:54 INFO - Running setup.py (path:/tmp/pip-bjosAo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:51:54 INFO - Running setup.py (path:/tmp/pip-ikWeGx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:51:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:51:55 INFO - Running setup.py install for manifestparser 19:51:55 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:51:55 INFO - Running setup.py install for mozcrash 19:51:55 INFO - Running setup.py install for mozdebug 19:51:55 INFO - Running setup.py install for mozdevice 19:51:55 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:51:55 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:51:55 INFO - Running setup.py install for mozfile 19:51:55 INFO - Running setup.py install for mozhttpd 19:51:55 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:51:55 INFO - Running setup.py install for mozinfo 19:51:55 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:51:55 INFO - Running setup.py install for mozInstall 19:51:55 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:51:55 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:51:55 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:51:55 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:51:55 INFO - Running setup.py install for mozleak 19:51:55 INFO - Running setup.py install for mozlog 19:51:56 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:51:56 INFO - Running setup.py install for moznetwork 19:51:56 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:51:56 INFO - Running setup.py install for mozprocess 19:51:56 INFO - Running setup.py install for mozprofile 19:51:56 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:51:56 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:51:56 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:51:56 INFO - Running setup.py install for mozrunner 19:51:56 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:51:56 INFO - Running setup.py install for mozscreenshot 19:51:56 INFO - Running setup.py install for moztest 19:51:56 INFO - Running setup.py install for mozversion 19:51:56 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:51:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:51:56 INFO - Cleaning up... 19:51:56 INFO - Return code: 0 19:51:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:51: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')]} 19:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51: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')]} 19:51:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:56 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 0x7f0133146f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ff630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890840>, '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 0x17fd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17fdb60>, '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': '9c54e757a4c805d85fea3bc7000001f2-1451705884.266894-1085942255', '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 19:51:56 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 19:51:56 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 19:51:56 INFO - Using env: {'DISPLAY': ':0', 19:51:56 INFO - 'HOME': '/home/cltbld', 19:51:56 INFO - 'LANG': 'en_US.UTF-8', 19:51:56 INFO - 'LANGUAGE': 'en_US:en', 19:51:56 INFO - 'LOGNAME': 'cltbld', 19:51:56 INFO - 'MAIL': '/var/mail/cltbld', 19:51:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:56 INFO - 'MOZ_NO_REMOTE': '1', 19:51:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:56 INFO - 'NO_EM_RESTART': '1', 19:51:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:56 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:56 INFO - 'SHELL': '/bin/bash', 19:51:56 INFO - 'SHLVL': '1', 19:51:56 INFO - 'TERM': 'linux', 19:51:56 INFO - 'TMOUT': '86400', 19:51:56 INFO - 'USER': 'cltbld', 19:51:56 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1451705884.266894-1085942255', 19:51:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:56 INFO - '_': '/tools/buildbot/bin/python'} 19:51:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:51:57 INFO - Running setup.py (path:/tmp/pip-RLw13m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:51:57 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)) 19:51:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:51:57 INFO - Running setup.py (path:/tmp/pip-HSQOUA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:51:57 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)) 19:51:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:51:57 INFO - Running setup.py (path:/tmp/pip-Xm9j_d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:51:57 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)) 19:51:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:51:57 INFO - Running setup.py (path:/tmp/pip-SztUaz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:51:57 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)) 19:51:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:51:57 INFO - Running setup.py (path:/tmp/pip-Fm711F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:51:57 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)) 19:51:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:51:57 INFO - Running setup.py (path:/tmp/pip-e81Trs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:51:57 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)) 19:51:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:51:57 INFO - Running setup.py (path:/tmp/pip-TPkJ0k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:51:57 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)) 19:51:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:51:57 INFO - Running setup.py (path:/tmp/pip-PIDNLB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:51:57 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)) 19:51:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:51:57 INFO - Running setup.py (path:/tmp/pip-T_8muI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:51:57 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)) 19:51:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:51:57 INFO - Running setup.py (path:/tmp/pip-NivXui-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:51:57 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)) 19:51:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:51:57 INFO - Running setup.py (path:/tmp/pip-NgQWbh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:51:57 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)) 19:51:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:51:57 INFO - Running setup.py (path:/tmp/pip-i26alf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:51:57 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)) 19:51:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:51:57 INFO - Running setup.py (path:/tmp/pip-hoVL5L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:51:58 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)) 19:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:51:58 INFO - Running setup.py (path:/tmp/pip-2VtzsQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:51:58 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)) 19:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:51:58 INFO - Running setup.py (path:/tmp/pip-avJZeb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:51:58 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)) 19:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:51:58 INFO - Running setup.py (path:/tmp/pip-s9zehw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:51:58 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)) 19:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:51:58 INFO - Running setup.py (path:/tmp/pip-nfYk4v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:51:58 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)) 19:51:58 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)) 19:51:58 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)) 19:51:58 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)) 19:51:58 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)) 19:51:58 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)) 19:51:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:59 INFO - Downloading blessings-1.5.1.tar.gz 19:52:00 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 19:52:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:52:00 INFO - Installing collected packages: blessings 19:52:00 INFO - Running setup.py install for blessings 19:52:00 INFO - Successfully installed blessings 19:52:00 INFO - Cleaning up... 19:52:00 INFO - Return code: 0 19:52:00 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:52:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:52:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:52:00 INFO - Reading from file tmpfile_stdout 19:52:00 INFO - Current package versions: 19:52:00 INFO - argparse == 1.2.1 19:52:00 INFO - blessings == 1.5.1 19:52:00 INFO - blobuploader == 1.2.4 19:52:00 INFO - docopt == 0.6.1 19:52:00 INFO - manifestparser == 1.1 19:52:00 INFO - mozInstall == 1.12 19:52:00 INFO - mozcrash == 0.16 19:52:00 INFO - mozdebug == 0.1 19:52:00 INFO - mozdevice == 0.47 19:52:00 INFO - mozfile == 1.2 19:52:00 INFO - mozhttpd == 0.7 19:52:00 INFO - mozinfo == 0.9 19:52:00 INFO - mozleak == 0.1 19:52:00 INFO - mozlog == 3.1 19:52:00 INFO - moznetwork == 0.27 19:52:00 INFO - mozprocess == 0.22 19:52:00 INFO - mozprofile == 0.28 19:52:00 INFO - mozrunner == 6.11 19:52:00 INFO - mozscreenshot == 0.1 19:52:00 INFO - mozsystemmonitor == 0.0 19:52:00 INFO - moztest == 0.7 19:52:00 INFO - mozversion == 1.4 19:52:00 INFO - psutil == 3.1.1 19:52:00 INFO - requests == 1.2.3 19:52:00 INFO - wsgiref == 0.1.2 19:52:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:52: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')]} 19:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:52:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52: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')]} 19:52:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:52:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52:00 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 0x7f0133146f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ff630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890840>, '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 0x17fd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17fdb60>, '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': '9c54e757a4c805d85fea3bc7000001f2-1451705884.266894-1085942255', '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 19:52:00 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 19:52:00 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 19:52:00 INFO - Using env: {'DISPLAY': ':0', 19:52:00 INFO - 'HOME': '/home/cltbld', 19:52:00 INFO - 'LANG': 'en_US.UTF-8', 19:52:00 INFO - 'LANGUAGE': 'en_US:en', 19:52:00 INFO - 'LOGNAME': 'cltbld', 19:52:00 INFO - 'MAIL': '/var/mail/cltbld', 19:52:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:52:00 INFO - 'MOZ_NO_REMOTE': '1', 19:52:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:52:00 INFO - 'NO_EM_RESTART': '1', 19:52:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:52:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:52:00 INFO - 'PWD': '/builds/slave/test-pgo', 19:52:00 INFO - 'SHELL': '/bin/bash', 19:52:00 INFO - 'SHLVL': '1', 19:52:00 INFO - 'TERM': 'linux', 19:52:00 INFO - 'TMOUT': '86400', 19:52:00 INFO - 'USER': 'cltbld', 19:52:00 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1451705884.266894-1085942255', 19:52:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:52:00 INFO - '_': '/tools/buildbot/bin/python'} 19:52:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:52:00 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)) 19:52:00 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)) 19:52:00 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)) 19:52:00 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)) 19:52:00 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)) 19:52:00 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)) 19:52:00 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)) 19:52:00 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)) 19:52:00 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)) 19:52:00 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)) 19:52:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 19:52:00 INFO - Cleaning up... 19:52:00 INFO - Return code: 0 19:52:00 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:52: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')]} 19:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:52:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52: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')]} 19:52:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:52:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52:00 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 0x7f0133146f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ff630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890840>, '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 0x17fd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17fdb60>, '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': '9c54e757a4c805d85fea3bc7000001f2-1451705884.266894-1085942255', '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 19:52:00 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 19:52:00 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 19:52:00 INFO - Using env: {'DISPLAY': ':0', 19:52:00 INFO - 'HOME': '/home/cltbld', 19:52:00 INFO - 'LANG': 'en_US.UTF-8', 19:52:00 INFO - 'LANGUAGE': 'en_US:en', 19:52:00 INFO - 'LOGNAME': 'cltbld', 19:52:00 INFO - 'MAIL': '/var/mail/cltbld', 19:52:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:52:00 INFO - 'MOZ_NO_REMOTE': '1', 19:52:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:52:00 INFO - 'NO_EM_RESTART': '1', 19:52:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:52:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:52:00 INFO - 'PWD': '/builds/slave/test-pgo', 19:52:00 INFO - 'SHELL': '/bin/bash', 19:52:00 INFO - 'SHLVL': '1', 19:52:00 INFO - 'TERM': 'linux', 19:52:00 INFO - 'TMOUT': '86400', 19:52:00 INFO - 'USER': 'cltbld', 19:52:00 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1451705884.266894-1085942255', 19:52:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:52:00 INFO - '_': '/tools/buildbot/bin/python'} 19:52:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:52:00 INFO - Downloading/unpacking jsonschema 19:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:52:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:52:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:52:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:52:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:52:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:52:02 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 19:52:02 INFO - Downloading/unpacking functools32 (from jsonschema) 19:52:02 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 19:52:02 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 19:52:02 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 19:52:02 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 19:52:02 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 19:52:02 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 19:52:02 INFO - Downloading functools32-3.2.3-2.tar.gz 19:52:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:52:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:52:02 INFO - warning: no files found matching '*.txt' 19:52:02 INFO - no previously-included directories found matching 'build' 19:52:02 INFO - no previously-included directories found matching 'dist' 19:52:02 INFO - no previously-included directories found matching '.git*' 19:52:02 INFO - Installing collected packages: jsonschema, functools32 19:52:02 INFO - Running setup.py install for functools32 19:52:02 INFO - warning: no files found matching '*.txt' 19:52:02 INFO - no previously-included directories found matching 'build' 19:52:02 INFO - no previously-included directories found matching 'dist' 19:52:02 INFO - no previously-included directories found matching '.git*' 19:52:02 INFO - Successfully installed jsonschema functools32 19:52:02 INFO - Cleaning up... 19:52:03 INFO - Return code: 0 19:52:03 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:52:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:52:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:52:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:52:03 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 0x7f0133146f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ff630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890840>, '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 0x17fd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17fdb60>, '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': '9c54e757a4c805d85fea3bc7000001f2-1451705884.266894-1085942255', '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 19:52:03 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 19:52:03 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 19:52:03 INFO - Using env: {'DISPLAY': ':0', 19:52:03 INFO - 'HOME': '/home/cltbld', 19:52:03 INFO - 'LANG': 'en_US.UTF-8', 19:52:03 INFO - 'LANGUAGE': 'en_US:en', 19:52:03 INFO - 'LOGNAME': 'cltbld', 19:52:03 INFO - 'MAIL': '/var/mail/cltbld', 19:52:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:52:03 INFO - 'MOZ_NO_REMOTE': '1', 19:52:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:52:03 INFO - 'NO_EM_RESTART': '1', 19:52:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:52:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:52:03 INFO - 'PWD': '/builds/slave/test-pgo', 19:52:03 INFO - 'SHELL': '/bin/bash', 19:52:03 INFO - 'SHLVL': '1', 19:52:03 INFO - 'TERM': 'linux', 19:52:03 INFO - 'TMOUT': '86400', 19:52:03 INFO - 'USER': 'cltbld', 19:52:03 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1451705884.266894-1085942255', 19:52:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:52:03 INFO - '_': '/tools/buildbot/bin/python'} 19:52:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:52:03 INFO - Downloading/unpacking flake8 19:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:52:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:52:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:52:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:52:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:52:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:52:04 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 19:52:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:52:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:52:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:52:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:52:05 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 19:52:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:52:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:52:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:52:05 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 19:52:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:52:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:52:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:52:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:52:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:52:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:52:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:52:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:52:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:52:05 INFO - no previously-included directories found matching 'docs/_build' 19:52:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:52:05 INFO - Running setup.py install for pep8 19:52:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:52:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:52:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:52:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:52:05 INFO - no previously-included directories found matching 'docs/_build' 19:52:05 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:52:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:52:05 INFO - Cleaning up... 19:52:05 INFO - Return code: 0 19:52:05 INFO - Running post-action listener: _resource_record_post_action 19:52:05 INFO - Running post-action listener: _start_resource_monitoring 19:52:05 INFO - Starting resource monitoring. 19:52:05 INFO - ##### 19:52:05 INFO - ##### Running install step. 19:52:05 INFO - ##### 19:52:05 INFO - Running pre-action listener: _resource_record_pre_action 19:52:05 INFO - Running main action method: install 19:52:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:52:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:52:06 INFO - Reading from file tmpfile_stdout 19:52:06 INFO - Detecting whether we're running mozinstall >=1.0... 19:52:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:52:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:52:06 INFO - Reading from file tmpfile_stdout 19:52:06 INFO - Output received: 19:52:06 INFO - Usage: mozinstall [options] installer 19:52:06 INFO - Options: 19:52:06 INFO - -h, --help show this help message and exit 19:52:06 INFO - -d DEST, --destination=DEST 19:52:06 INFO - Directory to install application into. [default: 19:52:06 INFO - "/builds/slave/test-pgo"] 19:52:06 INFO - --app=APP Application being installed. [default: firefox] 19:52:06 INFO - mkdir: /builds/slave/test-pgo/build/application 19:52:06 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'] 19:52:06 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 19:52:21 INFO - Reading from file tmpfile_stdout 19:52:21 INFO - Output received: 19:52:21 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:52:21 INFO - Running post-action listener: _resource_record_post_action 19:52:21 INFO - ##### 19:52:21 INFO - ##### Running run-tests step. 19:52:21 INFO - ##### 19:52:21 INFO - Running pre-action listener: _resource_record_pre_action 19:52:21 INFO - Running main action method: run_tests 19:52:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:52:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:52:21 INFO - Python 2.7.3 19:52:21 INFO - Return code: 0 19:52:21 INFO - grabbing minidump binary from tooltool 19:52:21 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')]} 19:52:21 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 0x1890840>, '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 0x17fd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17fdb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:52:21 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 19:52:21 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 19:52:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:52:22 INFO - Return code: 0 19:52:22 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:52:22 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:52:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:52:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:52:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:52:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:52:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:52:22 INFO - Return code: 0 19:52:22 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/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 19:52:22 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/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 19:52:22 INFO - Using env: {'DISPLAY': ':0', 19:52:22 INFO - 'HOME': '/home/cltbld', 19:52:22 INFO - 'LANG': 'en_US.UTF-8', 19:52:22 INFO - 'LANGUAGE': 'en_US:en', 19:52:22 INFO - 'LOGNAME': 'cltbld', 19:52:22 INFO - 'MAIL': '/var/mail/cltbld', 19:52:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:52:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:52:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:52:22 INFO - 'MOZ_NO_REMOTE': '1', 19:52:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:52:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:52:22 INFO - 'NO_EM_RESTART': '1', 19:52:22 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:52:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:52:22 INFO - 'PWD': '/builds/slave/test-pgo', 19:52:22 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:52:22 INFO - 'SHELL': '/bin/bash', 19:52:22 INFO - 'SHLVL': '1', 19:52:22 INFO - 'TERM': 'linux', 19:52:22 INFO - 'TMOUT': '86400', 19:52:22 INFO - 'USER': 'cltbld', 19:52:22 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1451705884.266894-1085942255', 19:52:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:52:22 INFO - '_': '/tools/buildbot/bin/python'} 19:52:22 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/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 19:52:23 INFO - mozversion application_buildid: 20160101173004 19:52:23 INFO - mozversion application_changeset: 1f682dc05790a8ab1cdda60dad61e511ba611629 19:52:23 INFO - mozversion application_display_name: Nightly 19:52:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:52:23 INFO - mozversion application_name: Firefox 19:52:23 INFO - mozversion application_remotingname: firefox 19:52:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:52:23 INFO - mozversion application_vendor: Mozilla 19:52:23 INFO - mozversion application_version: 46.0a1 19:52:23 INFO - mozversion platform_buildid: 20160101173004 19:52:23 INFO - mozversion platform_changeset: 1f682dc05790a8ab1cdda60dad61e511ba611629 19:52:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:52:23 INFO - mozversion platform_version: 46.0a1 19:52:23 INFO - using testdate: 1451706743 19:52:23 INFO - actual date: 1451706743 19:52:23 INFO - starting webserver on 'localhost:50711' 19:52:23 INFO - SUITE-START | Running 3 tests 19:52:23 INFO - TEST-START | dromaeo_css 19:52:23 INFO - operating with platform_type : linux_ 19:52:23 INFO - Initialising browser for dromaeo_css test... 19:52:23 INFO - TEST-INFO | started process 1552 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppljmxh/profile http://localhost:50711/getInfo.html) 19:52:28 INFO - PROCESS | 1552 | __metrics Screen width/height:1600/1200 19:52:28 INFO - PROCESS | 1552 | colorDepth:24 19:52:28 INFO - PROCESS | 1552 | Browser inner width/height: 1024/697 19:52:28 INFO - PROCESS | 1552 | __metrics 19:52:28 INFO - PROCESS | 1552 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:52:28 INFO - PROCESS | 1552 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:52:29 INFO - TEST-INFO | 1552: exit 0 19:52:29 INFO - Browser initialized. 19:52:29 INFO - Running cycle 1/1 for dromaeo_css test... 19:52:29 INFO - TEST-INFO | started process 1650 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppljmxh/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:52:41 INFO - PROCESS | 1650 | RSS: Main: 149778432 19:52:41 INFO - PROCESS | 1650 | 19:53:32 INFO - PROCESS | 1650 | 1451706812464 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] 19:55:41 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:50711/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50711/tests/dromaeo/cssquery-ext.html) 19:55:42 INFO - PROCESS | 1650 | RSS: Main: 271020032 19:55:42 INFO - PROCESS | 1650 | 19:58:44 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:50711/tests/dromaeo/cssquery-ext.html (next: http://localhost:50711/tests/dromaeo/cssquery-jquery.html) 19:58:45 INFO - PROCESS | 1650 | RSS: Main: 226287616 19:58:45 INFO - PROCESS | 1650 | 20:01:47 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:50711/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50711/tests/dromaeo/cssquery-mootools.html) 20:01:47 INFO - PROCESS | 1650 | RSS: Main: 221335552 20:01:47 INFO - PROCESS | 1650 | 20:04:49 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:50711/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50711/tests/dromaeo/cssquery-prototype.html) 20:04:50 INFO - PROCESS | 1650 | RSS: Main: 215547904 20:04:50 INFO - PROCESS | 1650 | 20:07:52 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:50711/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50711/tests/dromaeo/cssquery-yui.html) 20:07:53 INFO - PROCESS | 1650 | RSS: Main: 216801280 20:07:53 INFO - PROCESS | 1650 | 20:10:55 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:50711/tests/dromaeo/cssquery-yui.html (next: http://localhost:50711/tests/dromaeo/cssquery-dojo.html) 20:10:56 INFO - PROCESS | 1650 | RSS: Main: 261042176 20:10:56 INFO - PROCESS | 1650 | 20:10:56 INFO - PROCESS | 1650 | __start_tp_report 20:10:56 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 20:10:56 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 20:10:56 INFO - PROCESS | 1650 | |i|pagename|runs| 20:10:56 INFO - PROCESS | 1650 | |0;dojo.html;3052.481078216703;3103.8913638022673;3116.1586371679646;3118.5945827042497;3144.1039303798416;4958.231474121517;5110.795568177273;5111.463296353881;5134.281200631905;5143.922841157381;5119.5392414682765;5146.897062058757;5182.989317083161;5202;5203.4796520347945;4542.750148741818;4675.859724208279;4685.4377474703;4716.858494245161;4811.08589368019;4649.256119020957;4779.16364636189;4792.736399498043;4812.783424745878;4854.150523658345;4647.32613771003;4680.227762419197;4790.449098353682;4795.232762757942;4816.614670826326;4734.124187025412;4739.834105806315;4744.122337367598;4756.048790241931;4788.186008378584;4718.268668356411;4722.150012997659;4723.173444647173;4746.860753419189;4755.881102972418;4896.681715688469;4969.875753106165;4989.675671081368;5109.897802043938;5139.511746384088;5613.80351687693;5629.521490673298;5640.8307750767135;5644.57665675076;5652.491275785158;5485;5673.914891276634;5678.971605141989;5683.261176047129;5684.261046064026;5138.152204886189;5148.150555158394;5200.973995130038;5264.236685680555;5281.260623512673;5643.266375371176;5667.319921609351;5671.376148623648;5672.262605861294;5678.318601767732;5393.7303134843105;5442.591805614595;5459.153831156177;5460.945390546123;5466;5464.316960379952;5532.419095994863;5541.722913854291;5560;5591.27313449249;5426.050441172779;5434.782608695607;5436.103042997861;5436.891262174734;5438.483344082306;5420.24116623673;5458.754356053908;5460.672359658433;5460.918086228709;5519.254900588369;4320.135972805451;4325.243082460557;4366.366876802846;4401.119776044804;4407.867763967086;3847.7306588539095;3861;3873.748206366577;3892.3772196449;3894.8636797711943;5130.230465430215;5206.349206349207;5242.9213561796605;5251.553617942518;5253.3958594761325;5521.585881058937;5570.220169176318;5605.915911261334;5619.971900140473;5663.150527420919;5254.553362964114;5262.02652509287;5265.9736701317015;5272.841814745564;5289.047971365114;4807.78364973577;4810.6632535722165;4819.373481447459;4819.662623616383;4857.708537487762;5616.943830561724;5706.629069110494;5711.742971566289;5738.512226460798;5771.422857714195;5606.131049687305;5626.606137570331;5626.690532020778;5637.548996080386;5651.689157096399;5744.138379243147;5775.855603609775;5789.044807606698;5791.8552036199435;5793.159991801081;5332.200169974535;5450.890982180414;5470.152126420411;5552.7778888845605;5604.663720176803;5581.330240371181;5614.85962850932;5615.915761263503;5623.8594035149445;5638.4925356718095;5432.2123292123215;5482.342118945752;5485.890282194414;5487.588430867621;5509.917351239655;5327.653702509325;5378.704171270618;5419.268398766116;5425.21334406501;5509.338879334506;5390.029794637003;5392.137258038695;5394.163904594794;5395.4604539545735;5397.622166448311;5467.398586155599;5470.152126420411;5482.698451585201;5541.806036788855;5546.389897111395;5304.761285742228;5396.460353964572;5408.107662235844;5473.972630136824;5519.31008623922 20:10:56 INFO - PROCESS | 1650 | |1;ext.html;531.6358294568221;555.4750760531297;558.7290164270331;567.5374569725673;578.9594728369015;30810.229744256405;31510.842445787795;31574.210644733892;31592.52611210834;36666.8166659167;39840.40239396404;39955;40126.99682507932;40165.7991710041;40233.19533609326;8434.873476897836;8567.100454452286;8606.56967151643;8607.655693772273;8611.35414843886;7621.961890190541;7774.300312971832;8361.540115293656;10104.545295461721;10332.431716255604;10046.744156980378;10152;10157.441340726256;10168.084872361485;10168.440735759566;7572.015637967084;9754.170895473893;9841.655542056065;9867.16129129025;9878.407295562254;7472.663730132157;9992.900070999269;10236.48817559119;10259.948700256526;10307.278490505667;37172.442413363824;37265.81367093147;37567.436488452695;37574.81212593947;37597.43603845945;3029.0761317798065;3029.8344415457286;3089.7991630544166;3105.394448082625;3108.7512998960256;28908.277293067633;28981.42037159245;29165;29468.8526557368;32220.516692249636;3806.448065030555;3807.2385522895534;3855.383138697795;3983.223271462066;4030.8992275193064;266992;268556;268677;269596;269668;60345.69827150924;60702.696486518165;60728.69635651793;60767.39232607706;60781;56181.71909140428;57818.421815782145;64570.67714661397;64992.35007649958;65141.348586514476;15119.848801511844;15272.694546109016;15315.61710957235;15353.155576443403;15356.308966096552;11159.721006974729;11171.050460710769;11185.384803835705;11192.832107518394;11194.272372295774;19189.520261993563;19340;19368.225270989285;19403.4178974631;19458.17856410841;7692.153863075169;7939.523628582304;7948.443608947434;8022.799430014296;8111.310538604284;972.9513524323755;1018.8420794776673;1022.3865680591585;1062.134360496193;1108.9500972456258;28850.711492884802;28868.27829304284;28933.71066289352;29257.85371073131;29326.26684332909;1010.7611640216954;1020.5203554329453;1040.8750949885912;1044.1959691037857;1113.49677934789;14876.330565124596;14935.775963360342;15013.249337533298;15201.087934723952;15256.237188140549;316997;321070;322437;323548;324054;52448.73775631098;52850.73574632179;53111.203331950055;53283;53447.465525345026;1301.811237370576;1309.7609561752988;1311.9212847229196;1325.5758157389735;1349.9392527336292;24637.630435543124;26722.86638566795;28758.85620571884;28774.7122528772;28946.855265723538;41744;42432;42567.57432425636;42572.36141457943;42592.57407425886;193021;193251;193431;193659.03170484057;193755;27800.165995020183;31532;31945.201369965936;32127;32337.838310808296;37220.81389593035;37910.62089379181;38050.42924356192;38076.61923380731;38683;32036.6796332043;32048.5192722114;32149;34060.82969585136;35786.64213357833;32528.83735581307;32798;33187.50218746672;33242.66757332395;33558;33968;34848.82575587106;34944.30111397707;34982.82508587441;35138.29723405569;29556.408871822012;32237;32560.34879302448;32868.83565582157;32888.50667239945;24163.15428959978;24360.63459048151;24418.75581244236;24636.260912172664;24700.38249043788 20:10:56 INFO - PROCESS | 1650 | |2;jquery.html;341.4400383371273;352.97529172957906;353.55805243445695;354.7658545360063;361.8588750387349;16235.75646365304;16475;16926;17172.914135429335;17180.22688978996;13108.606741797737;13479.191248525096;15593.53219403417;15716.292766825492;16543.42098026569;5253.238280449342;5386.8922621547545;5419.810306639269;5421.159720243349;5422.105352616813;4018.63832255097;5477.890442191154;5494.80768173114;5507.972460137694;5519.061759500874;5560.082586373263;5938.8218353449465;5970.34326224115;5970.79102231422;5980.820575382723;5521.779128834882;5923.703814809264;5928.99207134786;5936.762529498815;6072.058830881177;5310.20346947957;5336.039512887679;5351.277577527023;5360.249565060894;5366.490183432567;20389;20394;20400.183992640275;20417;20938.89530552353;2066.070268379235;2085.895705214733;2218.0905828610353;2365.0066971871856;2490.887910044052;11871.643850684406;12488.313142777144;12647.936760316232;12718.385712721387;12805.679858003532;1577.6213708709943;1606.4698649445654;1620.3599578166559;1646.1193261605104;1680.2186983052816;56508.15237771437;59232.70383648054;59392;59646.70176649089;59672.70163649198;9421.481818500048;9545.140937315537;9683.273754468302;9702.369345992487;9781.755456113511;12441.688957776129;12465.813012804816;12497.312647804458;12499.93750031244;12541.372931353579;6874.553154044971;7106.467014973898;7202.747903823341;7284.526505777214;7831.373490120776;6804.285550017276;6845.212800528003;6897.931020689729;7035.401990830836;7111.7866464006165;4086.6322031017353;4094.0788322627172;4095.4266402703647;4120.7733574653685;4146.274401979642;1679.8320167983104;1681.1846254566526;1721.2942693495606;1723.83623555762;1769.4160926894094;799;843.9957800211082;875.9904383416531;939.1359948847077;979.710985259336;16355.754663680054;17022.404215852384;17122;17214.741778873326;17462.738058929128;803.541981070784;881.9250363719156;894.2488309819782;900.4732231644562;920.9953950230206;8809;9075.2286055686;9147.451152930846;9187.770305742277;9189.540522973824;538118;541938;545336;549095;551338;71693.54758071694;76209;76435;77923.2207677916;79457.60271198723;1159.8724140344725;1166.4925757295603;1179.5812486567318;1202.6091520255952;1214.3685283652628;15586.298616562508;15646.687066258839;15938.282777274819;15981.961172523748;16171.948823326446;32742.34515309728;33346.33307333791;33387.33225335431;34081.48877766885;34181.65818341785;43942;45214.77392613016;45773;47134;48532.27201591909;9508.429494230368;9565.808683826424;9598.808023839345;9713.222942164752;9718.902810972082;11334.773304534028;16362.836371636131;16721.080340581386;17282.74075888888;17572.82427175763;13429.597112086261;13579.185248885098;13637.659058523219;13690.65773355674;13905.930470347583;13715.657108572366;13752.730799417985;13933.23367214813;14174.929125354307;14224.50214242538;11124.721881953015;13324.866751332362;13523.391447385087;13710.794338084737;14113;9280.675176368795;9282.164605185566;9341.532923353941;9480.85778713306;9522.381045232314;9805.509724513888;9855.408675479493;10421.37471751667;13323.467061317438;13572 20:10:56 INFO - PROCESS | 1650 | |3;mootools.html;1294.0682708449913;1454.6872422429176;1472.7054589082184;1614.539856141;1776.3516316544465;6501.252355979063;7084.185318688346;7184.820379490516;7192.96403517983;7195.064641596592;7105.253948335428;7246.23914488979;7270.309320614547;7277.053982982218;7278.163011253708;1987.7217189593396;2020.3231917307646;2022.6258142243657;2217.756046834851;2260.773922607734;2025;2216.5012872103807;2230.631945728953;2231.207921187979;2233.486298151426;2169.6311627023365;2192.583409152264;2197.3407977606735;2206.7682893296214;2245.494763678176;2165.1339464214284;2181.476445653048;2195.879226642534;2199.296225207934;2199.4941163532476;2073.6785798201304;2112.9329688507205;2116.9364919052455;2117.2695420080204;2132.381609333307;7319.048523691886;7394.408447324201;7395.926040739578;7407.407407407394;7411.518251313647;4576.633869290449;4624.28323609841;4652.209124448818;4661.533846615345;4680;2955.12823717004;2957.955630665542;3009.3830764693184;3012.5631783391505;3036.529337952621;926.8331700293944;958.1568219966455;973.7516933182064;981.6613268422383;986.2701600815417;9706.466144362057;9849.950750246275;9864.30949833512;9869.605215791431;9874.308798384116;4010.27814993304;4012.8996775080273;4108.732932359387;4109.712320137622;4141.109661422808;8142.145074767182;8169.877451838227;8170.632321545545;8173.6321865515;8175.305099066646;4544.341070544752;4547.545245475426;4571.314302854598;4587.403637527167;4612.0545288215835;4209.536950935395;4215.97892010538;4263.147370525907;4265.083007153415;4265.573442655709;3188.1232661017943;3369.191394065456;3372.8144952027874;3389.6440873708398;3411.4541673332146;1014.2595904989399;1028.7068185567077;1074.1299547366657;1086.0334302470808;1099.1316859680762;986.1223511075149;1011.6408674920444;1014.4826138669332;1014.5383850348221;1072.785442911421;6982.615956122462;7007.054047703597;7015.193252775996;7048.154221493453;7062.15254169503;1023.150784848574;1032.9431881246453;1041.520900385831;1113.5100555755441;1133.484264659578;5453.045716999509;5591.440855914376;5611.438856114438;5613.410591887875;5622.128570071645;8516.061958624265;8856.822863542693;8890.422122562142;8981.550922453851;9021.32340074497;8812.647494100293;8825.426347287406;8894.4663320201;8915.153060459246;8966.23786978101;6817.147856517935;6868.416184624263;6888.621125838027;6891.310868913069;7046.330598593126;6858.691358888962;6865.141857267841;6871.656417179221;6872.656367181721;6883.27725588806;7897.723579674684;7959.920400795918;7998.240167184108;8147.959260203661;8151.959240203761;8111.797205069921;8197.303229225345;8376.83246335082;8377.581120943807;8385.413021088465;6032.125341825323;6093.969530152321;6101.633901965896;6130.570860039755;6142.907856382247;6389.4888408926245;6873.381395674413;6903.344182302673;6910.792676219721;6917.204521479893;5738.139279108167;6162.845928851635;6339.587926784744;6351.2060992375955;6478.190226221723;6169.629822210682;6261.5616906816085;6337.017762246859;6349.746010159542;6404.647744374104;6355.459785918249;6390.13733146038;6391.648459334595;6391.9041214380895;6393.392627700361;5841.1238314253205;5845.678487683048;5855.385184555731;5911.7635294587735;5919.171316015847;5710.8001219957105;5793.478586927196;5796.101604251179;5805.158252053513;6016.368281330398 20:10:56 INFO - PROCESS | 1650 | |4;prototype.html;315.733205441402;317.85888659711645;324.67045948362403;327.0482894776202;329.8729988954252;5759.39526349733;5807.41925807419;5869.295684517853;5870.207521984542;5907.379725128853;5788.6237394569325;5811.564132690055;5822.912656310159;5823.767049318022;5825.5048320892665;4269.786510674469;4325.913481730364;4342.696011279212;4459.710118842265;4461.130079634472;4394.648428125758;4418.2268103082;4419.3150061740325;4427.114577084596;4434.49003364614;4353.67347448941;4382.408374869399;4388.97805510972;4390.517043125254;4400.669949753781;4251.192273468047;4318.093200427914;4333.155034768237;4385.956140438587;4413.558644135593;3838.673712734393;3849.6727778138893;3857.8263978121054;3873.2253549290253;3875.7093218008763;5516.7517461714315;5525.281713377275;5529.336479622471;5531.7234138293325;5535.169724541311;5147.6654017488745;5151.871203219912;5153.1497302945345;5163.096458119814;5169.534741873212;5974.163617093611;6155.415235552616;6160.784372546939;6163.414475624809;6170.136180934673;4193.1404062167185;4204.222218889515;4205.558416366268;4206.221848957953;4206.537280899099;6384.840378990562;6452.161219041494;6463.446938459329;6464.41820236181;6469.644169570672;4152.91694166115;4265.594768496988;4295.463067116611;4299.484061912591;4306.397104405386;4282.48610166782;4341.739495630272;4343.413639158736;4346.760928148982;4350.825966961286;5057.544820966131;5078.796848126033;5084.796608135707;5086.669366491166;5088.440271570124;6185.195924529872;6227.532935029801;6232.750689972441;6235;6242.09489624002;1489.3819065087866;1501.2193659297104;1527.511196417158;1530.1966467604598;1535.5316628428213;992.9205663546899;995.8008398320364;1000.3747657713928;1000.9049140331803;1003.964861229868;5852.853678658068;5900.64596124234;5913.379095195029;5913.49735272498;5913.852153696192;6313.273973493016;6326.841828954221;6334.714937827809;6342;6342.048692696132;5885.911711324334;5893.322267939242;5897.941020589825;5903.527717782567;5914.2311499504785;3193.760467964912;3295.307985323061;3395.8811441599423;3451.706604938558;3452.775569588019;6608.636524991076;6615.4376877965915;6618.96690516554;6620.966895165493;6626.635535045619;6490.578112422678;6509.934900651027;6515.087887695727;6575.309592492719;6587.209534855848;6490.123833282447;6626.602403855881;6637.568558043712;6683.6658167091455;6697.09589205451;6363.6499992499;6366.331535188924;6445.774397896051;6461.127747754181;6461.741530338733;6373.171487706569;6373.330800266091;6382.776602818879;6389.7763578274535;6391.10524526576;6437.613743175424;6695.393105654705;6719.428848547928;6729.932700672931;6730.461563074844;4347.065380943112;4383.868483945486;4388.51726310112;4388.890277743082;4396.164728701537;6459.935400645933;6461.321561236191;6462.709178086903;6468;6477.740890364333;6121.234845644294;6304.18045654062;6314.305426403;6315.242170939517;6324.620522768649;6287.559870809182;6293.653849038347;6295.464885484785;6299.181106456132;6302.65335406557;6166.1983942087245;6193.84515387119;6199.411055949678;6202.379762023762;6205.875882482415;6127.417895299939;6308.653024083719;6324.430801227912;6331.461825744863;6332.493400527855;6116.816495505142;6161.106639537153;6162.722677479434;6170.907436388368;6178.042403427476 20:10:56 INFO - PROCESS | 1650 | |5;yui.html;649.2209348781463;654.5941516259917;777.3370992320939;781.1251398433755;788.7081779741496;12162.20945638534;12436.502539898416;12460.626181214555;12463.68840778981;12478.81281780774;11991.40042997851;12026.699332516691;12050.276983381003;12060.336681482537;12072.577459788909;662.4567854359427;667.4927055437878;791.1179035375544;804.6700852650414;808.8341889912583;803.907550631676;807.5962018990505;810.7162493127418;815.9388045896552;816.6243527977138;847.0851480401152;856.1438561438562;857.1471385970937;857.348415204446;857.8970523537184;688.5834070387418;698.1203683358979;844.0841686769832;867.483847110968;868.2099289646392;597.4533302028639;598.3776872053103;599.5024129972113;608.6621924831717;613.9048447490646;12104.455299511543;12240.510379584806;12265.877341226562;12275.38623068843;12328.383580820922;10920;11113.666590002313;11358.488868000877;11447.942760286229;12071.336076515789;9578.56896439662;9786.510674466319;9869;9892.5161225816;10146.441945692985;3463.0995941055253;3481.1645205150835;3495.3533596284515;3499.33512632599;3595.2449985503076;45798;46283.76858115688;46472;46596.534034659555;46780.29829552525;9184.516874296676;9369.063093690713;9513.143817056498;9524.333296669167;9658.468784216795;18896.905515472336;18926;18929;18942.337018204296;18946.810531894505;7197.748078817321;7231;7240.529365591325;7252.492325537267;7394.5193562419345;3862.5364956205435;3866.3040652682225;3867.6325749053794;3891.2606604745006;3895.24042811649;3219.146926064595;3263.1026467721567;3265.363254165415;3266.5426840242385;3267.4772036474524;544.9400565937743;563.2086917880384;563.5097465205298;564.5004171308422;566.3600131850982;574.7212601888081;590.3624085987124;610.5573459242103;638.5625846295303;640.8654182621608;7807.7267295645515;8247.21651443112;8301.128381519975;8400.45397049202;8547.35894807892;507.58124547248667;510.6553076673231;553.7867920850501;625.124825244652;633.3286716080969;3548.6451354864307;3620.692241159531;3747.775133491999;3894.162755007687;4104.835806567764;49958.50041499611;50291.74854125706;50498.49501505012;53057.46942530602;53677.1948420774;45938.31092533615;46062.539374606495;46149.53850461519;46235;46251.30623040657;44874.32688509675;45029.774851125534;45223.54776452259;46151.30773038407;46723.532764671916;7958.442908996315;8117.756467305991;8244.29923456513;8323.791905202419;8706.521141337034;36089.458658120675;36755.81622091872;36807.81596092002;37141.071473213386;37228.44157337588;44201;44522.55477445184;45954.54045459503;48517.75741121272;50463.74768126136;10801.297915635458;10959.56161753521;10979.386842091986;11483.94258028738;11529.769404611692;10915.345079295268;10983.395913224529;11048.226624136554;11336.886631133582;11498.310101393943;9733.610655573697;9794.26543009263;9887.752806179904;9944.751381215527;10246.282760206714;9867.703968880945;10109.494525273854;10227.48862556884;10247.795044099226;10578.206634502289;8060.217961976033;9612.327137100336;10131.594736210469;10339.741506462098;10350.430726309824;8999.460032397816;9115.588083210829;9201.907980920105;9401.952990235006;9415.293852961193;8798.38411311202;9031.683891063782;9084.909150908406;9086.54567271647;9220.769480763034 20:10:56 INFO - PROCESS | 1650 | __end_tp_report 20:10:56 INFO - PROCESS | 1650 | __start_cc_report 20:10:56 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,914 20:10:56 INFO - PROCESS | 1650 | __end_cc_report 20:10:56 INFO - PROCESS | 1650 | __startTimestamp1451707856043__endTimestamp 20:10:56 INFO - PROCESS | 1650 | 20:10:56 INFO - PROCESS | 1650 | ------- Summary: start ------- 20:10:56 INFO - PROCESS | 1650 | Number of tests: 6 20:10:56 INFO - PROCESS | 1650 | 20:10:56 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5172.22 Median:5394.16 stddev:566.72 (10.5%) stddev-sans-first:543.52 20:10:56 INFO - PROCESS | 1650 | Values: 3052.5 3103.9 3116.2 3118.6 3144.1 4958.2 5110.8 5111.5 5134.3 5143.9 5119.5 5146.9 5183.0 5202.0 5203.5 4542.8 4675.9 4685.4 4716.9 4811.1 4649.3 4779.2 4792.7 4812.8 4854.2 4647.3 4680.2 4790.4 4795.2 4816.6 4734.1 4739.8 4744.1 4756.0 4788.2 4718.3 4722.2 4723.2 4746.9 4755.9 4896.7 4969.9 4989.7 5109.9 5139.5 5613.8 5629.5 5640.8 5644.6 5652.5 5485.0 5673.9 5679.0 5683.3 5684.3 5138.2 5148.2 5201.0 5264.2 5281.3 5643.3 5667.3 5671.4 5672.3 5678.3 5393.7 5442.6 5459.2 5460.9 5466.0 5464.3 5532.4 5541.7 5560.0 5591.3 5426.1 5434.8 5436.1 5436.9 5438.5 5420.2 5458.8 5460.7 5460.9 5519.3 4320.1 4325.2 4366.4 4401.1 4407.9 3847.7 3861.0 3873.7 3892.4 3894.9 5130.2 5206.3 5242.9 5251.6 5253.4 5521.6 5570.2 5605.9 5620.0 5663.2 5254.6 5262.0 5266.0 5272.8 5289.0 4807.8 4810.7 4819.4 4819.7 4857.7 5616.9 5706.6 5711.7 5738.5 5771.4 5606.1 5626.6 5626.7 5637.5 5651.7 5744.1 5775.9 5789.0 5791.9 5793.2 5332.2 5450.9 5470.2 5552.8 5604.7 5581.3 5614.9 5615.9 5623.9 5638.5 5432.2 5482.3 5485.9 5487.6 5509.9 5327.7 5378.7 5419.3 5425.2 5509.3 5390.0 5392.1 5394.2 5395.5 5397.6 5467.4 5470.2 5482.7 5541.8 5546.4 5304.8 5396.5 5408.1 5474.0 5519.3 20:10:56 INFO - PROCESS | 1650 | 20:10:56 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:43079.15 Median:32138.00 stddev:69688.48 (216.8%) stddev-sans-first:69810.75 20:10:56 INFO - PROCESS | 1650 | Values: 531.6 555.5 558.7 567.5 579.0 30810.2 31510.8 31574.2 31592.5 36666.8 39840.4 39955.0 40127.0 40165.8 40233.2 8434.9 8567.1 8606.6 8607.7 8611.4 7622.0 7774.3 8361.5 10104.5 10332.4 10046.7 10152.0 10157.4 10168.1 10168.4 7572.0 9754.2 9841.7 9867.2 9878.4 7472.7 9992.9 10236.5 10259.9 10307.3 37172.4 37265.8 37567.4 37574.8 37597.4 3029.1 3029.8 3089.8 3105.4 3108.8 28908.3 28981.4 29165.0 29468.9 32220.5 3806.4 3807.2 3855.4 3983.2 4030.9 266992.0 268556.0 268677.0 269596.0 269668.0 60345.7 60702.7 60728.7 60767.4 60781.0 56181.7 57818.4 64570.7 64992.4 65141.3 15119.8 15272.7 15315.6 15353.2 15356.3 11159.7 11171.1 11185.4 11192.8 11194.3 19189.5 19340.0 19368.2 19403.4 19458.2 7692.2 7939.5 7948.4 8022.8 8111.3 973.0 1018.8 1022.4 1062.1 1109.0 28850.7 28868.3 28933.7 29257.9 29326.3 1010.8 1020.5 1040.9 1044.2 1113.5 14876.3 14935.8 15013.2 15201.1 15256.2 316997.0 321070.0 322437.0 323548.0 324054.0 52448.7 52850.7 53111.2 53283.0 53447.5 1301.8 1309.8 1311.9 1325.6 1349.9 24637.6 26722.9 28758.9 28774.7 28946.9 41744.0 42432.0 42567.6 42572.4 42592.6 193021.0 193251.0 193431.0 193659.0 193755.0 27800.2 31532.0 31945.2 32127.0 32337.8 37220.8 37910.6 38050.4 38076.6 38683.0 32036.7 32048.5 32149.0 34060.8 35786.6 32528.8 32798.0 33187.5 33242.7 33558.0 33968.0 34848.8 34944.3 34982.8 35138.3 29556.4 32237.0 32560.3 32868.8 32888.5 24163.2 24360.6 24418.8 24636.3 24700.4 20:10:56 INFO - PROCESS | 1650 | 20:10:56 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:28632.65 Median:4094.75 stddev:89010.88 (2173.8%) stddev-sans-first:89235.23 20:10:56 INFO - PROCESS | 1650 | Values: 341.4 353.0 353.6 354.8 361.9 16235.8 16475.0 16926.0 17172.9 17180.2 13108.6 13479.2 15593.5 15716.3 16543.4 5253.2 5386.9 5419.8 5421.2 5422.1 4018.6 5477.9 5494.8 5508.0 5519.1 5560.1 5938.8 5970.3 5970.8 5980.8 5521.8 5923.7 5929.0 5936.8 6072.1 5310.2 5336.0 5351.3 5360.2 5366.5 20389.0 20394.0 20400.2 20417.0 20938.9 2066.1 2085.9 2218.1 2365.0 2490.9 11871.6 12488.3 12647.9 12718.4 12805.7 1577.6 1606.5 1620.4 1646.1 1680.2 56508.2 59232.7 59392.0 59646.7 59672.7 9421.5 9545.1 9683.3 9702.4 9781.8 12441.7 12465.8 12497.3 12499.9 12541.4 6874.6 7106.5 7202.7 7284.5 7831.4 6804.3 6845.2 6897.9 7035.4 7111.8 4086.6 4094.1 4095.4 4120.8 4146.3 1679.8 1681.2 1721.3 1723.8 1769.4 799.0 844.0 876.0 939.1 979.7 16355.8 17022.4 17122.0 17214.7 17462.7 803.5 881.9 894.2 900.5 921.0 8809.0 9075.2 9147.5 9187.8 9189.5 538118.0 541938.0 545336.0 549095.0 551338.0 71693.5 76209.0 76435.0 77923.2 79457.6 1159.9 1166.5 1179.6 1202.6 1214.4 15586.3 15646.7 15938.3 15982.0 16171.9 32742.3 33346.3 33387.3 34081.5 34181.7 43942.0 45214.8 45773.0 47134.0 48532.3 9508.4 9565.8 9598.8 9713.2 9718.9 11334.8 16362.8 16721.1 17282.7 17572.8 13429.6 13579.2 13637.7 13690.7 13905.9 13715.7 13752.7 13933.2 14174.9 14224.5 11124.7 13324.9 13523.4 13710.8 14113.0 9280.7 9282.2 9341.5 9480.9 9522.4 9805.5 9855.4 10421.4 13323.5 13572.0 20:10:56 INFO - PROCESS | 1650 | 20:10:56 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5107.89 Median:6063.05 stddev:2614.20 (43.1%) stddev-sans-first:2605.81 20:10:56 INFO - PROCESS | 1650 | Values: 1294.1 1454.7 1472.7 1614.5 1776.4 6501.3 7084.2 7184.8 7193.0 7195.1 7105.3 7246.2 7270.3 7277.1 7278.2 1987.7 2020.3 2022.6 2217.8 2260.8 2025.0 2216.5 2230.6 2231.2 2233.5 2169.6 2192.6 2197.3 2206.8 2245.5 2165.1 2181.5 2195.9 2199.3 2199.5 2073.7 2112.9 2116.9 2117.3 2132.4 7319.0 7394.4 7395.9 7407.4 7411.5 4576.6 4624.3 4652.2 4661.5 4680.0 2955.1 2958.0 3009.4 3012.6 3036.5 926.8 958.2 973.8 981.7 986.3 9706.5 9850.0 9864.3 9869.6 9874.3 4010.3 4012.9 4108.7 4109.7 4141.1 8142.1 8169.9 8170.6 8173.6 8175.3 4544.3 4547.5 4571.3 4587.4 4612.1 4209.5 4216.0 4263.1 4265.1 4265.6 3188.1 3369.2 3372.8 3389.6 3411.5 1014.3 1028.7 1074.1 1086.0 1099.1 986.1 1011.6 1014.5 1014.5 1072.8 6982.6 7007.1 7015.2 7048.2 7062.2 1023.2 1032.9 1041.5 1113.5 1133.5 5453.0 5591.4 5611.4 5613.4 5622.1 8516.1 8856.8 8890.4 8981.6 9021.3 8812.6 8825.4 8894.5 8915.2 8966.2 6817.1 6868.4 6888.6 6891.3 7046.3 6858.7 6865.1 6871.7 6872.7 6883.3 7897.7 7959.9 7998.2 8148.0 8152.0 8111.8 8197.3 8376.8 8377.6 8385.4 6032.1 6094.0 6101.6 6130.6 6142.9 6389.5 6873.4 6903.3 6910.8 6917.2 5738.1 6162.8 6339.6 6351.2 6478.2 6169.6 6261.6 6337.0 6349.7 6404.6 6355.5 6390.1 6391.6 6391.9 6393.4 5841.1 5845.7 5855.4 5911.8 5919.2 5710.8 5793.5 5796.1 5805.2 6016.4 20:10:56 INFO - PROCESS | 1650 | 20:10:56 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:5167.13 Median:5899.29 stddev:1592.13 (27.0%) stddev-sans-first:1554.40 20:10:56 INFO - PROCESS | 1650 | Values: 315.7 317.9 324.7 327.0 329.9 5759.4 5807.4 5869.3 5870.2 5907.4 5788.6 5811.6 5822.9 5823.8 5825.5 4269.8 4325.9 4342.7 4459.7 4461.1 4394.6 4418.2 4419.3 4427.1 4434.5 4353.7 4382.4 4389.0 4390.5 4400.7 4251.2 4318.1 4333.2 4386.0 4413.6 3838.7 3849.7 3857.8 3873.2 3875.7 5516.8 5525.3 5529.3 5531.7 5535.2 5147.7 5151.9 5153.1 5163.1 5169.5 5974.2 6155.4 6160.8 6163.4 6170.1 4193.1 4204.2 4205.6 4206.2 4206.5 6384.8 6452.2 6463.4 6464.4 6469.6 4152.9 4265.6 4295.5 4299.5 4306.4 4282.5 4341.7 4343.4 4346.8 4350.8 5057.5 5078.8 5084.8 5086.7 5088.4 6185.2 6227.5 6232.8 6235.0 6242.1 1489.4 1501.2 1527.5 1530.2 1535.5 992.9 995.8 1000.4 1000.9 1004.0 5852.9 5900.6 5913.4 5913.5 5913.9 6313.3 6326.8 6334.7 6342.0 6342.0 5885.9 5893.3 5897.9 5903.5 5914.2 3193.8 3295.3 3395.9 3451.7 3452.8 6608.6 6615.4 6619.0 6621.0 6626.6 6490.6 6509.9 6515.1 6575.3 6587.2 6490.1 6626.6 6637.6 6683.7 6697.1 6363.6 6366.3 6445.8 6461.1 6461.7 6373.2 6373.3 6382.8 6389.8 6391.1 6437.6 6695.4 6719.4 6729.9 6730.5 4347.1 4383.9 4388.5 4388.9 4396.2 6459.9 6461.3 6462.7 6468.0 6477.7 6121.2 6304.2 6314.3 6315.2 6324.6 6287.6 6293.7 6295.5 6299.2 6302.7 6166.2 6193.8 6199.4 6202.4 6205.9 6127.4 6308.7 6324.4 6331.5 6332.5 6116.8 6161.1 6162.7 6170.9 6178.0 20:10:56 INFO - PROCESS | 1650 | 20:10:56 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:13176.26 Median:50481.12 stddev:15309.56 (30.3%) stddev-sans-first:15323.61 20:10:56 INFO - PROCESS | 1650 | Values: 649.2 654.6 777.3 781.1 788.7 12162.2 12436.5 12460.6 12463.7 12478.8 11991.4 12026.7 12050.3 12060.3 12072.6 662.5 667.5 791.1 804.7 808.8 803.9 807.6 810.7 815.9 816.6 847.1 856.1 857.1 857.3 857.9 688.6 698.1 844.1 867.5 868.2 597.5 598.4 599.5 608.7 613.9 12104.5 12240.5 12265.9 12275.4 12328.4 10920.0 11113.7 11358.5 11447.9 12071.3 9578.6 9786.5 9869.0 9892.5 10146.4 3463.1 3481.2 3495.4 3499.3 3595.2 45798.0 46283.8 46472.0 46596.5 46780.3 9184.5 9369.1 9513.1 9524.3 9658.5 18896.9 18926.0 18929.0 18942.3 18946.8 7197.7 7231.0 7240.5 7252.5 7394.5 3862.5 3866.3 3867.6 3891.3 3895.2 3219.1 3263.1 3265.4 3266.5 3267.5 544.9 563.2 563.5 564.5 566.4 574.7 590.4 610.6 638.6 640.9 7807.7 8247.2 8301.1 8400.5 8547.4 507.6 510.7 553.8 625.1 633.3 3548.6 3620.7 3747.8 3894.2 4104.8 49958.5 50291.7 50498.5 53057.5 53677.2 45938.3 46062.5 46149.5 46235.0 46251.3 44874.3 45029.8 45223.5 46151.3 46723.5 7958.4 8117.8 8244.3 8323.8 8706.5 36089.5 36755.8 36807.8 37141.1 37228.4 44201.0 44522.6 45954.5 48517.8 50463.7 10801.3 10959.6 10979.4 11483.9 11529.8 10915.3 10983.4 11048.2 11336.9 11498.3 9733.6 9794.3 9887.8 9944.8 10246.3 9867.7 10109.5 10227.5 10247.8 10578.2 8060.2 9612.3 10131.6 10339.7 10350.4 8999.5 9115.6 9201.9 9402.0 9415.3 8798.4 9031.7 9084.9 9086.5 9220.8 20:10:56 INFO - PROCESS | 1650 | -------- Summary: end -------- 20:10:56 INFO - PROCESS | 1650 | 20:10:56 INFO - TEST-INFO | 1650: exit 0 20:10:56 INFO - TEST-OK | dromaeo_css | took 1113593ms 20:10:56 INFO - TEST-START | kraken 20:10:56 INFO - operating with platform_type : linux_ 20:10:56 INFO - Initialising browser for kraken test... 20:10:56 INFO - TEST-INFO | started process 1843 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKBvZ_v/profile http://localhost:50711/getInfo.html) 20:11:01 INFO - PROCESS | 1843 | __metrics Screen width/height:1600/1200 20:11:01 INFO - PROCESS | 1843 | colorDepth:24 20:11:01 INFO - PROCESS | 1843 | Browser inner width/height: 1024/697 20:11:01 INFO - PROCESS | 1843 | __metrics 20:11:01 INFO - PROCESS | 1843 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:11:01 INFO - PROCESS | 1843 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:11:02 INFO - TEST-INFO | 1843: exit 0 20:11:02 INFO - Browser initialized. 20:11:02 INFO - Running cycle 1/1 for kraken test... 20:11:02 INFO - TEST-INFO | started process 1928 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKBvZ_v/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:11:14 INFO - PROCESS | 1928 | RSS: Main: 150134784 20:11:14 INFO - PROCESS | 1928 | 20:11:16 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:50711/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50711/tests/kraken/driver.html?testName=audio-beat-detection) 20:11:17 INFO - PROCESS | 1928 | RSS: Main: 185503744 20:11:17 INFO - PROCESS | 1928 | 20:11:20 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:50711/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50711/tests/kraken/driver.html?testName=audio-dft) 20:11:20 INFO - PROCESS | 1928 | RSS: Main: 174804992 20:11:20 INFO - PROCESS | 1928 | 20:11:23 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:50711/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50711/tests/kraken/driver.html?testName=audio-fft) 20:11:23 INFO - PROCESS | 1928 | RSS: Main: 160804864 20:11:23 INFO - PROCESS | 1928 | 20:11:25 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:50711/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50711/tests/kraken/driver.html?testName=audio-oscillator) 20:11:26 INFO - PROCESS | 1928 | RSS: Main: 161492992 20:11:26 INFO - PROCESS | 1928 | 20:11:28 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:50711/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50711/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:11:29 INFO - PROCESS | 1928 | RSS: Main: 163598336 20:11:29 INFO - PROCESS | 1928 | 20:11:32 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:50711/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50711/tests/kraken/driver.html?testName=imaging-darkroom) 20:11:32 INFO - PROCESS | 1928 | RSS: Main: 164102144 20:11:32 INFO - PROCESS | 1928 | 20:11:36 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:50711/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50711/tests/kraken/driver.html?testName=imaging-desaturate) 20:11:36 INFO - PROCESS | 1928 | RSS: Main: 164904960 20:11:36 INFO - PROCESS | 1928 | 20:11:39 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:50711/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50711/tests/kraken/driver.html?testName=json-parse-financial) 20:11:40 INFO - PROCESS | 1928 | RSS: Main: 164204544 20:11:40 INFO - PROCESS | 1928 | 20:11:41 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:50711/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50711/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:11:42 INFO - PROCESS | 1928 | RSS: Main: 174862336 20:11:42 INFO - PROCESS | 1928 | 20:11:43 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:50711/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50711/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:11:44 INFO - PROCESS | 1928 | RSS: Main: 173297664 20:11:44 INFO - PROCESS | 1928 | 20:11:46 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:50711/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50711/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:11:47 INFO - PROCESS | 1928 | RSS: Main: 184688640 20:11:47 INFO - PROCESS | 1928 | 20:11:49 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:50711/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50711/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:11:50 INFO - PROCESS | 1928 | RSS: Main: 191844352 20:11:50 INFO - PROCESS | 1928 | 20:11:52 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:50711/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50711/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:11:53 INFO - PROCESS | 1928 | RSS: Main: 188645376 20:11:53 INFO - PROCESS | 1928 | 20:11:55 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:50711/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50711/tests/kraken/driver.html?testName=ai-astar) 20:11:55 INFO - PROCESS | 1928 | RSS: Main: 247332864 20:11:55 INFO - PROCESS | 1928 | 20:11:55 INFO - PROCESS | 1928 | __start_tp_report 20:11:55 INFO - PROCESS | 1928 | _x_x_mozilla_page_load 20:11:55 INFO - PROCESS | 1928 | _x_x_mozilla_page_load_details 20:11:55 INFO - PROCESS | 1928 | |i|pagename|runs| 20:11:55 INFO - PROCESS | 1928 | |0;ai-astar;110;110;104;110;110;111;100;110;110;110 20:11:55 INFO - PROCESS | 1928 | |1;audio-beat-detection;151;127;153;165;126;162;150;125;175;127 20:11:55 INFO - PROCESS | 1928 | |2;audio-dft;163;162;161;161;161;161;161;163;162;164 20:11:55 INFO - PROCESS | 1928 | |3;audio-fft;74;73;90;104;74;75;71;107;96;72 20:11:55 INFO - PROCESS | 1928 | |4;audio-oscillator;98;97;141;95;97;96;145;95;96;139 20:11:55 INFO - PROCESS | 1928 | |5;imaging-gaussian-blur;109;109;109;109;109;110;109;109;110;109 20:11:55 INFO - PROCESS | 1928 | |6;imaging-darkroom;147;145;146;145;146;145;145;146;146;145 20:11:55 INFO - PROCESS | 1928 | |7;imaging-desaturate;95;95;96;95;95;96;96;96;95;96 20:11:55 INFO - PROCESS | 1928 | |8;json-parse-financial;58;57;56;55;56;58;58;65;54;55 20:11:55 INFO - PROCESS | 1928 | |9;json-stringify-tinderbox;66;67;67;67;67;68;67;66;67;67 20:11:55 INFO - PROCESS | 1928 | |10;stanford-crypto-aes;87;93;85;85;86;86;85;86;87;86 20:11:55 INFO - PROCESS | 1928 | |11;stanford-crypto-ccm;128;122;124;130;116;124;119;118;124;115 20:11:55 INFO - PROCESS | 1928 | |12;stanford-crypto-pbkdf2;142;152;151;150;140;139;150;152;148;140 20:11:55 INFO - PROCESS | 1928 | |13;stanford-crypto-sha256-iterative;69;68;70;71;76;67;68;71;73;69 20:11:55 INFO - PROCESS | 1928 | __end_tp_report 20:11:55 INFO - PROCESS | 1928 | __start_cc_report 20:11:55 INFO - PROCESS | 1928 | _x_x_mozilla_cycle_collect,921 20:11:55 INFO - PROCESS | 1928 | __end_cc_report 20:11:55 INFO - PROCESS | 1928 | __startTimestamp1451707915274__endTimestamp 20:11:55 INFO - PROCESS | 1928 | 20:11:55 INFO - PROCESS | 1928 | ------- Summary: start ------- 20:11:55 INFO - PROCESS | 1928 | Number of tests: 14 20:11:55 INFO - PROCESS | 1928 | 20:11:55 INFO - PROCESS | 1928 | [#0] ai-astar Cycles:10 Average:108.50 Median:110.00 stddev:3.57 (3.2%) stddev-sans-first:3.74 20:11:55 INFO - PROCESS | 1928 | Values: 110.0 110.0 104.0 110.0 110.0 111.0 100.0 110.0 110.0 110.0 20:11:55 INFO - PROCESS | 1928 | 20:11:55 INFO - PROCESS | 1928 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:152.00 stddev:18.59 (12.2%) stddev-sans-first:19.63 20:11:55 INFO - PROCESS | 1928 | Values: 151.0 127.0 153.0 165.0 126.0 162.0 150.0 125.0 175.0 127.0 20:11:55 INFO - PROCESS | 1928 | 20:11:55 INFO - PROCESS | 1928 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.10 (0.7%) stddev-sans-first:1.09 20:11:55 INFO - PROCESS | 1928 | Values: 163.0 162.0 161.0 161.0 161.0 161.0 161.0 163.0 162.0 164.0 20:11:55 INFO - PROCESS | 1928 | 20:11:55 INFO - PROCESS | 1928 | [#3] audio-fft Cycles:10 Average:83.60 Median:74.00 stddev:14.23 (19.2%) stddev-sans-first:14.66 20:11:55 INFO - PROCESS | 1928 | Values: 74.0 73.0 90.0 104.0 74.0 75.0 71.0 107.0 96.0 72.0 20:11:55 INFO - PROCESS | 1928 | 20:11:55 INFO - PROCESS | 1928 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:96.00 stddev:21.99 (22.9%) stddev-sans-first:22.90 20:11:55 INFO - PROCESS | 1928 | Values: 98.0 97.0 141.0 95.0 97.0 96.0 145.0 95.0 96.0 139.0 20:11:55 INFO - PROCESS | 1928 | 20:11:55 INFO - PROCESS | 1928 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:11:55 INFO - PROCESS | 1928 | Values: 109.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 110.0 109.0 20:11:55 INFO - PROCESS | 1928 | 20:11:55 INFO - PROCESS | 1928 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 20:11:55 INFO - PROCESS | 1928 | Values: 147.0 145.0 146.0 145.0 146.0 145.0 145.0 146.0 146.0 145.0 20:11:55 INFO - PROCESS | 1928 | 20:11:55 INFO - PROCESS | 1928 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 20:11:55 INFO - PROCESS | 1928 | Values: 95.0 95.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 96.0 20:11:55 INFO - PROCESS | 1928 | 20:11:55 INFO - PROCESS | 1928 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.50 stddev:3.08 (5.4%) stddev-sans-first:3.26 20:11:55 INFO - PROCESS | 1928 | Values: 58.0 57.0 56.0 55.0 56.0 58.0 58.0 65.0 54.0 55.0 20:11:55 INFO - PROCESS | 1928 | 20:11:55 INFO - PROCESS | 1928 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 20:11:55 INFO - PROCESS | 1928 | Values: 66.0 67.0 67.0 67.0 67.0 68.0 67.0 66.0 67.0 67.0 20:11:55 INFO - PROCESS | 1928 | 20:11:55 INFO - PROCESS | 1928 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:86.00 stddev:2.37 (2.8%) stddev-sans-first:2.51 20:11:55 INFO - PROCESS | 1928 | Values: 87.0 93.0 85.0 85.0 86.0 86.0 85.0 86.0 87.0 86.0 20:11:55 INFO - PROCESS | 1928 | 20:11:55 INFO - PROCESS | 1928 | [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:124.00 stddev:4.97 (4.0%) stddev-sans-first:4.77 20:11:55 INFO - PROCESS | 1928 | Values: 128.0 122.0 124.0 130.0 116.0 124.0 119.0 118.0 124.0 115.0 20:11:55 INFO - PROCESS | 1928 | 20:11:55 INFO - PROCESS | 1928 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.40 Median:150.00 stddev:5.46 (3.6%) stddev-sans-first:5.56 20:11:55 INFO - PROCESS | 1928 | Values: 142.0 152.0 151.0 150.0 140.0 139.0 150.0 152.0 148.0 140.0 20:11:55 INFO - PROCESS | 1928 | 20:11:55 INFO - PROCESS | 1928 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.50 stddev:2.70 (3.8%) stddev-sans-first:2.83 20:11:55 INFO - PROCESS | 1928 | Values: 69.0 68.0 70.0 71.0 76.0 67.0 68.0 71.0 73.0 69.0 20:11:55 INFO - PROCESS | 1928 | -------- Summary: end -------- 20:11:55 INFO - PROCESS | 1928 | 20:11:56 INFO - TEST-INFO | 1928: exit 0 20:11:56 INFO - TEST-OK | kraken | took 59360ms 20:11:56 INFO - TEST-START | v8_7 20:11:56 INFO - operating with platform_type : linux_ 20:11:56 INFO - Initialising browser for v8_7 test... 20:11:56 INFO - TEST-INFO | started process 2179 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYuMlCk/profile http://localhost:50711/getInfo.html) 20:12:00 INFO - PROCESS | 2179 | __metrics Screen width/height:1600/1200 20:12:00 INFO - PROCESS | 2179 | colorDepth:24 20:12:00 INFO - PROCESS | 2179 | Browser inner width/height: 1024/697 20:12:00 INFO - PROCESS | 2179 | __metrics 20:12:00 INFO - PROCESS | 2179 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:12:00 INFO - PROCESS | 2179 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:12:02 INFO - TEST-INFO | 2179: exit 0 20:12:02 INFO - Browser initialized. 20:12:02 INFO - Running cycle 1/1 for v8_7 test... 20:12:02 INFO - TEST-INFO | started process 2264 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYuMlCk/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:12:13 INFO - PROCESS | 2264 | RSS: Main: 150048768 20:12:13 INFO - PROCESS | 2264 | 20:12:35 INFO - PROCESS | 2264 | Cycle 1(1): loaded http://localhost:50711/tests/v8_7/run.html (next: http://localhost:50711/tests/v8_7/run.html) 20:12:35 INFO - PROCESS | 2264 | RSS: Main: 614174720 20:12:35 INFO - PROCESS | 2264 | 20:12:35 INFO - PROCESS | 2264 | __start_tp_report 20:12:35 INFO - PROCESS | 2264 | _x_x_mozilla_page_load 20:12:35 INFO - PROCESS | 2264 | _x_x_mozilla_page_load_details 20:12:35 INFO - PROCESS | 2264 | |i|pagename|runs| 20:12:35 INFO - PROCESS | 2264 | |0;Richards;166.8335001668335 20:12:35 INFO - PROCESS | 2264 | |1;DeltaBlue;197.19976336028398 20:12:35 INFO - PROCESS | 2264 | |2;Encrypt;285.5511136493432 20:12:35 INFO - PROCESS | 2264 | |3;Decrypt;5191.709844559586 20:12:35 INFO - PROCESS | 2264 | |4;RayTrace;1111.111111111111 20:12:35 INFO - PROCESS | 2264 | |5;Earley;802.5682182985554 20:12:35 INFO - PROCESS | 2264 | |6;Boyer;12144.578313253012 20:12:35 INFO - PROCESS | 2264 | |7;RegExp;25923.076923076922 20:12:35 INFO - PROCESS | 2264 | |8;Splay;633.8383838383838 20:12:35 INFO - PROCESS | 2264 | |9;NavierStokes;4826.923076923077 20:12:35 INFO - PROCESS | 2264 | __end_tp_report 20:12:35 INFO - PROCESS | 2264 | __startTimestamp1451707955637__endTimestamp 20:12:35 INFO - PROCESS | 2264 | 20:12:35 INFO - PROCESS | 2264 | ------- Summary: start ------- 20:12:35 INFO - PROCESS | 2264 | Number of tests: 10 20:12:35 INFO - PROCESS | 2264 | 20:12:35 INFO - PROCESS | 2264 | [#0] Richards Cycles:1 Average:166.83 Median:166.83 stddev:0.00 (0.0%) 20:12:35 INFO - PROCESS | 2264 | Values: 166.8 20:12:35 INFO - PROCESS | 2264 | 20:12:35 INFO - PROCESS | 2264 | [#1] DeltaBlue Cycles:1 Average:197.20 Median:197.20 stddev:0.00 (0.0%) 20:12:35 INFO - PROCESS | 2264 | Values: 197.2 20:12:35 INFO - PROCESS | 2264 | 20:12:35 INFO - PROCESS | 2264 | [#2] Encrypt Cycles:1 Average:285.55 Median:285.55 stddev:0.00 (0.0%) 20:12:35 INFO - PROCESS | 2264 | Values: 285.6 20:12:35 INFO - PROCESS | 2264 | 20:12:35 INFO - PROCESS | 2264 | [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 20:12:35 INFO - PROCESS | 2264 | Values: 5191.7 20:12:35 INFO - PROCESS | 2264 | 20:12:35 INFO - PROCESS | 2264 | [#4] RayTrace Cycles:1 Average:1111.11 Median:1111.11 stddev:0.00 (0.0%) 20:12:35 INFO - PROCESS | 2264 | Values: 1111.1 20:12:35 INFO - PROCESS | 2264 | 20:12:35 INFO - PROCESS | 2264 | [#5] Earley Cycles:1 Average:802.57 Median:802.57 stddev:0.00 (0.0%) 20:12:35 INFO - PROCESS | 2264 | Values: 802.6 20:12:35 INFO - PROCESS | 2264 | 20:12:35 INFO - PROCESS | 2264 | [#6] Boyer Cycles:1 Average:12144.58 Median:12144.58 stddev:0.00 (0.0%) 20:12:35 INFO - PROCESS | 2264 | Values: 12144.6 20:12:35 INFO - PROCESS | 2264 | 20:12:35 INFO - PROCESS | 2264 | [#7] RegExp Cycles:1 Average:25923.08 Median:25923.08 stddev:0.00 (0.0%) 20:12:35 INFO - PROCESS | 2264 | Values: 25923.1 20:12:35 INFO - PROCESS | 2264 | 20:12:35 INFO - PROCESS | 2264 | [#8] Splay Cycles:1 Average:633.84 Median:633.84 stddev:0.00 (0.0%) 20:12:35 INFO - PROCESS | 2264 | Values: 633.8 20:12:35 INFO - PROCESS | 2264 | 20:12:35 INFO - PROCESS | 2264 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 20:12:35 INFO - PROCESS | 2264 | Values: 4826.9 20:12:35 INFO - PROCESS | 2264 | -------- Summary: end -------- 20:12:35 INFO - PROCESS | 2264 | 20:12:36 INFO - TEST-INFO | 2264: exit 0 20:12:36 INFO - TEST-OK | v8_7 | took 40312ms 20:12:36 INFO - SUITE-END | took 1213s 20:12:36 INFO - Completed test suite (00:20:13) 20:12:36 INFO - Working with test: dromaeo_css 20:12:36 INFO - Generating results file: dromaeo_css 20:12:36 INFO - Working with test: kraken 20:12:36 INFO - Generating results file: kraken 20:12:36 INFO - javascript benchmark 20:12:36 INFO - Working with test: v8_7 20:12:36 INFO - Generating results file: v8_7 20:12:36 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:12:36 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 20:12:36 INFO - process_Request line: dromaeo_css 6744.13 graph.html#tests=[[72,64,35]] 20:12:36 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:12:36 INFO - process_Request line: kraken 1509.60 graph.html#tests=[[232,64,35]] 20:12:36 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:12:36 INFO - process_Request line: v8_7 20760.93 graph.html#tests=[[230,64,35]] 20:12:36 INFO - RETURN: dromaeo_css: 6744.13 20:12:36 INFO - RETURN: kraken: 1509.60 20:12:36 INFO - RETURN: v8_7: 20760.93 20:12:36 INFO - javascript benchmark 20:12:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3052.481078216703, 3103.8913638022673, 3116.1586371679646, 3118.5945827042497, 3144.1039303798416, 4958.231474121517, 5110.795568177273, 5111.463296353881, 5134.281200631905, 5143.922841157381, 5119.5392414682765, 5146.897062058757, 5182.989317083161, 5202.0, 5203.4796520347945, 4542.750148741818, 4675.859724208279, 4685.4377474703, 4716.858494245161, 4811.08589368019, 4649.256119020957, 4779.16364636189, 4792.736399498043, 4812.783424745878, 4854.150523658345, 4647.32613771003, 4680.227762419197, 4790.449098353682, 4795.232762757942, 4816.614670826326, 4734.124187025412, 4739.834105806315, 4744.122337367598, 4756.048790241931, 4788.186008378584, 4718.268668356411, 4722.150012997659, 4723.173444647173, 4746.860753419189, 4755.881102972418, 4896.681715688469, 4969.875753106165, 4989.675671081368, 5109.897802043938, 5139.511746384088, 5613.80351687693, 5629.521490673298, 5640.8307750767135, 5644.57665675076, 5652.491275785158, 5485.0, 5673.914891276634, 5678.971605141989, 5683.261176047129, 5684.261046064026, 5138.152204886189, 5148.150555158394, 5200.973995130038, 5264.236685680555, 5281.260623512673, 5643.266375371176, 5667.319921609351, 5671.376148623648, 5672.262605861294, 5678.318601767732, 5393.7303134843105, 5442.591805614595, 5459.153831156177, 5460.945390546123, 5466.0, 5464.316960379952, 5532.419095994863, 5541.722913854291, 5560.0, 5591.27313449249, 5426.050441172779, 5434.782608695607, 5436.103042997861, 5436.891262174734, 5438.483344082306, 5420.24116623673, 5458.754356053908, 5460.672359658433, 5460.918086228709, 5519.254900588369, 4320.135972805451, 4325.243082460557, 4366.366876802846, 4401.119776044804, 4407.867763967086, 3847.7306588539095, 3861.0, 3873.748206366577, 3892.3772196449, 3894.8636797711943, 5130.230465430215, 5206.349206349207, 5242.9213561796605, 5251.553617942518, 5253.3958594761325, 5521.585881058937, 5570.220169176318, 5605.915911261334, 5619.971900140473, 5663.150527420919, 5254.553362964114, 5262.02652509287, 5265.9736701317015, 5272.841814745564, 5289.047971365114, 4807.78364973577, 4810.6632535722165, 4819.373481447459, 4819.662623616383, 4857.708537487762, 5616.943830561724, 5706.629069110494, 5711.742971566289, 5738.512226460798, 5771.422857714195, 5606.131049687305, 5626.606137570331, 5626.690532020778, 5637.548996080386, 5651.689157096399, 5744.138379243147, 5775.855603609775, 5789.044807606698, 5791.8552036199435, 5793.159991801081, 5332.200169974535, 5450.890982180414, 5470.152126420411, 5552.7778888845605, 5604.663720176803, 5581.330240371181, 5614.85962850932, 5615.915761263503, 5623.8594035149445, 5638.4925356718095, 5432.2123292123215, 5482.342118945752, 5485.890282194414, 5487.588430867621, 5509.917351239655, 5327.653702509325, 5378.704171270618, 5419.268398766116, 5425.21334406501, 5509.338879334506, 5390.029794637003, 5392.137258038695, 5394.163904594794, 5395.4604539545735, 5397.622166448311, 5467.398586155599, 5470.152126420411, 5482.698451585201, 5541.806036788855, 5546.389897111395, 5304.761285742228, 5396.460353964572, 5408.107662235844, 5473.972630136824, 5519.31008623922], "unit": "score", "name": "dojo.html", "value": 5135.911857254261}, {"lowerIsBetter": false, "replicates": [531.6358294568221, 555.4750760531297, 558.7290164270331, 567.5374569725673, 578.9594728369015, 30810.229744256405, 31510.842445787795, 31574.210644733892, 31592.52611210834, 36666.8166659167, 39840.40239396404, 39955.0, 40126.99682507932, 40165.7991710041, 40233.19533609326, 8434.873476897836, 8567.100454452286, 8606.56967151643, 8607.655693772273, 8611.35414843886, 7621.961890190541, 7774.300312971832, 8361.540115293656, 10104.545295461721, 10332.431716255604, 10046.744156980378, 10152.0, 10157.441340726256, 10168.084872361485, 10168.440735759566, 7572.015637967084, 9754.170895473893, 9841.655542056065, 9867.16129129025, 9878.407295562254, 7472.663730132157, 9992.900070999269, 10236.48817559119, 10259.948700256526, 10307.278490505667, 37172.442413363824, 37265.81367093147, 37567.436488452695, 37574.81212593947, 37597.43603845945, 3029.0761317798065, 3029.8344415457286, 3089.7991630544166, 3105.394448082625, 3108.7512998960256, 28908.277293067633, 28981.42037159245, 29165.0, 29468.8526557368, 32220.516692249636, 3806.448065030555, 3807.2385522895534, 3855.383138697795, 3983.223271462066, 4030.8992275193064, 266992.0, 268556.0, 268677.0, 269596.0, 269668.0, 60345.69827150924, 60702.696486518165, 60728.69635651793, 60767.39232607706, 60781.0, 56181.71909140428, 57818.421815782145, 64570.67714661397, 64992.35007649958, 65141.348586514476, 15119.848801511844, 15272.694546109016, 15315.61710957235, 15353.155576443403, 15356.308966096552, 11159.721006974729, 11171.050460710769, 11185.384803835705, 11192.832107518394, 11194.272372295774, 19189.520261993563, 19340.0, 19368.225270989285, 19403.4178974631, 19458.17856410841, 7692.153863075169, 7939.523628582304, 7948.443608947434, 8022.799430014296, 8111.310538604284, 972.9513524323755, 1018.8420794776673, 1022.3865680591585, 1062.134360496193, 1108.9500972456258, 28850.711492884802, 28868.27829304284, 28933.71066289352, 29257.85371073131, 29326.26684332909, 1010.7611640216954, 1020.5203554329453, 1040.8750949885912, 1044.1959691037857, 1113.49677934789, 14876.330565124596, 14935.775963360342, 15013.249337533298, 15201.087934723952, 15256.237188140549, 316997.0, 321070.0, 322437.0, 323548.0, 324054.0, 52448.73775631098, 52850.73574632179, 53111.203331950055, 53283.0, 53447.465525345026, 1301.811237370576, 1309.7609561752988, 1311.9212847229196, 1325.5758157389735, 1349.9392527336292, 24637.630435543124, 26722.86638566795, 28758.85620571884, 28774.7122528772, 28946.855265723538, 41744.0, 42432.0, 42567.57432425636, 42572.36141457943, 42592.57407425886, 193021.0, 193251.0, 193431.0, 193659.03170484057, 193755.0, 27800.165995020183, 31532.0, 31945.201369965936, 32127.0, 32337.838310808296, 37220.81389593035, 37910.62089379181, 38050.42924356192, 38076.61923380731, 38683.0, 32036.6796332043, 32048.5192722114, 32149.0, 34060.82969585136, 35786.64213357833, 32528.83735581307, 32798.0, 33187.50218746672, 33242.66757332395, 33558.0, 33968.0, 34848.82575587106, 34944.30111397707, 34982.82508587441, 35138.29723405569, 29556.408871822012, 32237.0, 32560.34879302448, 32868.83565582157, 32888.50667239945, 24163.15428959978, 24360.63459048151, 24418.75581244236, 24636.260912172664, 24700.38249043788], "unit": "score", "name": "ext.html", "value": 17992.663186048176}, {"lowerIsBetter": false, "replicates": [341.4400383371273, 352.97529172957906, 353.55805243445695, 354.7658545360063, 361.8588750387349, 16235.75646365304, 16475.0, 16926.0, 17172.914135429335, 17180.22688978996, 13108.606741797737, 13479.191248525096, 15593.53219403417, 15716.292766825492, 16543.42098026569, 5253.238280449342, 5386.8922621547545, 5419.810306639269, 5421.159720243349, 5422.105352616813, 4018.63832255097, 5477.890442191154, 5494.80768173114, 5507.972460137694, 5519.061759500874, 5560.082586373263, 5938.8218353449465, 5970.34326224115, 5970.79102231422, 5980.820575382723, 5521.779128834882, 5923.703814809264, 5928.99207134786, 5936.762529498815, 6072.058830881177, 5310.20346947957, 5336.039512887679, 5351.277577527023, 5360.249565060894, 5366.490183432567, 20389.0, 20394.0, 20400.183992640275, 20417.0, 20938.89530552353, 2066.070268379235, 2085.895705214733, 2218.0905828610353, 2365.0066971871856, 2490.887910044052, 11871.643850684406, 12488.313142777144, 12647.936760316232, 12718.385712721387, 12805.679858003532, 1577.6213708709943, 1606.4698649445654, 1620.3599578166559, 1646.1193261605104, 1680.2186983052816, 56508.15237771437, 59232.70383648054, 59392.0, 59646.70176649089, 59672.70163649198, 9421.481818500048, 9545.140937315537, 9683.273754468302, 9702.369345992487, 9781.755456113511, 12441.688957776129, 12465.813012804816, 12497.312647804458, 12499.93750031244, 12541.372931353579, 6874.553154044971, 7106.467014973898, 7202.747903823341, 7284.526505777214, 7831.373490120776, 6804.285550017276, 6845.212800528003, 6897.931020689729, 7035.401990830836, 7111.7866464006165, 4086.6322031017353, 4094.0788322627172, 4095.4266402703647, 4120.7733574653685, 4146.274401979642, 1679.8320167983104, 1681.1846254566526, 1721.2942693495606, 1723.83623555762, 1769.4160926894094, 799.0, 843.9957800211082, 875.9904383416531, 939.1359948847077, 979.710985259336, 16355.754663680054, 17022.404215852384, 17122.0, 17214.741778873326, 17462.738058929128, 803.541981070784, 881.9250363719156, 894.2488309819782, 900.4732231644562, 920.9953950230206, 8809.0, 9075.2286055686, 9147.451152930846, 9187.770305742277, 9189.540522973824, 538118.0, 541938.0, 545336.0, 549095.0, 551338.0, 71693.54758071694, 76209.0, 76435.0, 77923.2207677916, 79457.60271198723, 1159.8724140344725, 1166.4925757295603, 1179.5812486567318, 1202.6091520255952, 1214.3685283652628, 15586.298616562508, 15646.687066258839, 15938.282777274819, 15981.961172523748, 16171.948823326446, 32742.34515309728, 33346.33307333791, 33387.33225335431, 34081.48877766885, 34181.65818341785, 43942.0, 45214.77392613016, 45773.0, 47134.0, 48532.27201591909, 9508.429494230368, 9565.808683826424, 9598.808023839345, 9713.222942164752, 9718.902810972082, 11334.773304534028, 16362.836371636131, 16721.080340581386, 17282.74075888888, 17572.82427175763, 13429.597112086261, 13579.185248885098, 13637.659058523219, 13690.65773355674, 13905.930470347583, 13715.657108572366, 13752.730799417985, 13933.23367214813, 14174.929125354307, 14224.50214242538, 11124.721881953015, 13324.866751332362, 13523.391447385087, 13710.794338084737, 14113.0, 9280.675176368795, 9282.164605185566, 9341.532923353941, 9480.85778713306, 9522.381045232314, 9805.509724513888, 9855.408675479493, 10421.37471751667, 13323.467061317438, 13572.0], "unit": "score", "name": "jquery.html", "value": 8693.44029837504}, {"lowerIsBetter": false, "replicates": [1294.0682708449913, 1454.6872422429176, 1472.7054589082184, 1614.539856141, 1776.3516316544465, 6501.252355979063, 7084.185318688346, 7184.820379490516, 7192.96403517983, 7195.064641596592, 7105.253948335428, 7246.23914488979, 7270.309320614547, 7277.053982982218, 7278.163011253708, 1987.7217189593396, 2020.3231917307646, 2022.6258142243657, 2217.756046834851, 2260.773922607734, 2025.0, 2216.5012872103807, 2230.631945728953, 2231.207921187979, 2233.486298151426, 2169.6311627023365, 2192.583409152264, 2197.3407977606735, 2206.7682893296214, 2245.494763678176, 2165.1339464214284, 2181.476445653048, 2195.879226642534, 2199.296225207934, 2199.4941163532476, 2073.6785798201304, 2112.9329688507205, 2116.9364919052455, 2117.2695420080204, 2132.381609333307, 7319.048523691886, 7394.408447324201, 7395.926040739578, 7407.407407407394, 7411.518251313647, 4576.633869290449, 4624.28323609841, 4652.209124448818, 4661.533846615345, 4680.0, 2955.12823717004, 2957.955630665542, 3009.3830764693184, 3012.5631783391505, 3036.529337952621, 926.8331700293944, 958.1568219966455, 973.7516933182064, 981.6613268422383, 986.2701600815417, 9706.466144362057, 9849.950750246275, 9864.30949833512, 9869.605215791431, 9874.308798384116, 4010.27814993304, 4012.8996775080273, 4108.732932359387, 4109.712320137622, 4141.109661422808, 8142.145074767182, 8169.877451838227, 8170.632321545545, 8173.6321865515, 8175.305099066646, 4544.341070544752, 4547.545245475426, 4571.314302854598, 4587.403637527167, 4612.0545288215835, 4209.536950935395, 4215.97892010538, 4263.147370525907, 4265.083007153415, 4265.573442655709, 3188.1232661017943, 3369.191394065456, 3372.8144952027874, 3389.6440873708398, 3411.4541673332146, 1014.2595904989399, 1028.7068185567077, 1074.1299547366657, 1086.0334302470808, 1099.1316859680762, 986.1223511075149, 1011.6408674920444, 1014.4826138669332, 1014.5383850348221, 1072.785442911421, 6982.615956122462, 7007.054047703597, 7015.193252775996, 7048.154221493453, 7062.15254169503, 1023.150784848574, 1032.9431881246453, 1041.520900385831, 1113.5100555755441, 1133.484264659578, 5453.045716999509, 5591.440855914376, 5611.438856114438, 5613.410591887875, 5622.128570071645, 8516.061958624265, 8856.822863542693, 8890.422122562142, 8981.550922453851, 9021.32340074497, 8812.647494100293, 8825.426347287406, 8894.4663320201, 8915.153060459246, 8966.23786978101, 6817.147856517935, 6868.416184624263, 6888.621125838027, 6891.310868913069, 7046.330598593126, 6858.691358888962, 6865.141857267841, 6871.656417179221, 6872.656367181721, 6883.27725588806, 7897.723579674684, 7959.920400795918, 7998.240167184108, 8147.959260203661, 8151.959240203761, 8111.797205069921, 8197.303229225345, 8376.83246335082, 8377.581120943807, 8385.413021088465, 6032.125341825323, 6093.969530152321, 6101.633901965896, 6130.570860039755, 6142.907856382247, 6389.4888408926245, 6873.381395674413, 6903.344182302673, 6910.792676219721, 6917.204521479893, 5738.139279108167, 6162.845928851635, 6339.587926784744, 6351.2060992375955, 6478.190226221723, 6169.629822210682, 6261.5616906816085, 6337.017762246859, 6349.746010159542, 6404.647744374104, 6355.459785918249, 6390.13733146038, 6391.648459334595, 6391.9041214380895, 6393.392627700361, 5841.1238314253205, 5845.678487683048, 5855.385184555731, 5911.7635294587735, 5919.171316015847, 5710.8001219957105, 5793.478586927196, 5796.101604251179, 5805.158252053513, 6016.368281330398], "unit": "score", "name": "mootools.html", "value": 4212.804826355141}, {"lowerIsBetter": false, "replicates": [315.733205441402, 317.85888659711645, 324.67045948362403, 327.0482894776202, 329.8729988954252, 5759.39526349733, 5807.41925807419, 5869.295684517853, 5870.207521984542, 5907.379725128853, 5788.6237394569325, 5811.564132690055, 5822.912656310159, 5823.767049318022, 5825.5048320892665, 4269.786510674469, 4325.913481730364, 4342.696011279212, 4459.710118842265, 4461.130079634472, 4394.648428125758, 4418.2268103082, 4419.3150061740325, 4427.114577084596, 4434.49003364614, 4353.67347448941, 4382.408374869399, 4388.97805510972, 4390.517043125254, 4400.669949753781, 4251.192273468047, 4318.093200427914, 4333.155034768237, 4385.956140438587, 4413.558644135593, 3838.673712734393, 3849.6727778138893, 3857.8263978121054, 3873.2253549290253, 3875.7093218008763, 5516.7517461714315, 5525.281713377275, 5529.336479622471, 5531.7234138293325, 5535.169724541311, 5147.6654017488745, 5151.871203219912, 5153.1497302945345, 5163.096458119814, 5169.534741873212, 5974.163617093611, 6155.415235552616, 6160.784372546939, 6163.414475624809, 6170.136180934673, 4193.1404062167185, 4204.222218889515, 4205.558416366268, 4206.221848957953, 4206.537280899099, 6384.840378990562, 6452.161219041494, 6463.446938459329, 6464.41820236181, 6469.644169570672, 4152.91694166115, 4265.594768496988, 4295.463067116611, 4299.484061912591, 4306.397104405386, 4282.48610166782, 4341.739495630272, 4343.413639158736, 4346.760928148982, 4350.825966961286, 5057.544820966131, 5078.796848126033, 5084.796608135707, 5086.669366491166, 5088.440271570124, 6185.195924529872, 6227.532935029801, 6232.750689972441, 6235.0, 6242.09489624002, 1489.3819065087866, 1501.2193659297104, 1527.511196417158, 1530.1966467604598, 1535.5316628428213, 992.9205663546899, 995.8008398320364, 1000.3747657713928, 1000.9049140331803, 1003.964861229868, 5852.853678658068, 5900.64596124234, 5913.379095195029, 5913.49735272498, 5913.852153696192, 6313.273973493016, 6326.841828954221, 6334.714937827809, 6342.0, 6342.048692696132, 5885.911711324334, 5893.322267939242, 5897.941020589825, 5903.527717782567, 5914.2311499504785, 3193.760467964912, 3295.307985323061, 3395.8811441599423, 3451.706604938558, 3452.775569588019, 6608.636524991076, 6615.4376877965915, 6618.96690516554, 6620.966895165493, 6626.635535045619, 6490.578112422678, 6509.934900651027, 6515.087887695727, 6575.309592492719, 6587.209534855848, 6490.123833282447, 6626.602403855881, 6637.568558043712, 6683.6658167091455, 6697.09589205451, 6363.6499992499, 6366.331535188924, 6445.774397896051, 6461.127747754181, 6461.741530338733, 6373.171487706569, 6373.330800266091, 6382.776602818879, 6389.7763578274535, 6391.10524526576, 6437.613743175424, 6695.393105654705, 6719.428848547928, 6729.932700672931, 6730.461563074844, 4347.065380943112, 4383.868483945486, 4388.51726310112, 4388.890277743082, 4396.164728701537, 6459.935400645933, 6461.321561236191, 6462.709178086903, 6468.0, 6477.740890364333, 6121.234845644294, 6304.18045654062, 6314.305426403, 6315.242170939517, 6324.620522768649, 6287.559870809182, 6293.653849038347, 6295.464885484785, 6299.181106456132, 6302.65335406557, 6166.1983942087245, 6193.84515387119, 6199.411055949678, 6202.379762023762, 6205.875882482415, 6127.417895299939, 6308.653024083719, 6324.430801227912, 6331.461825744863, 6332.493400527855, 6116.816495505142, 6161.106639537153, 6162.722677479434, 6170.907436388368, 6178.042403427476], "unit": "score", "name": "prototype.html", "value": 4643.53880640462}, {"lowerIsBetter": false, "replicates": [649.2209348781463, 654.5941516259917, 777.3370992320939, 781.1251398433755, 788.7081779741496, 12162.20945638534, 12436.502539898416, 12460.626181214555, 12463.68840778981, 12478.81281780774, 11991.40042997851, 12026.699332516691, 12050.276983381003, 12060.336681482537, 12072.577459788909, 662.4567854359427, 667.4927055437878, 791.1179035375544, 804.6700852650414, 808.8341889912583, 803.907550631676, 807.5962018990505, 810.7162493127418, 815.9388045896552, 816.6243527977138, 847.0851480401152, 856.1438561438562, 857.1471385970937, 857.348415204446, 857.8970523537184, 688.5834070387418, 698.1203683358979, 844.0841686769832, 867.483847110968, 868.2099289646392, 597.4533302028639, 598.3776872053103, 599.5024129972113, 608.6621924831717, 613.9048447490646, 12104.455299511543, 12240.510379584806, 12265.877341226562, 12275.38623068843, 12328.383580820922, 10920.0, 11113.666590002313, 11358.488868000877, 11447.942760286229, 12071.336076515789, 9578.56896439662, 9786.510674466319, 9869.0, 9892.5161225816, 10146.441945692985, 3463.0995941055253, 3481.1645205150835, 3495.3533596284515, 3499.33512632599, 3595.2449985503076, 45798.0, 46283.76858115688, 46472.0, 46596.534034659555, 46780.29829552525, 9184.516874296676, 9369.063093690713, 9513.143817056498, 9524.333296669167, 9658.468784216795, 18896.905515472336, 18926.0, 18929.0, 18942.337018204296, 18946.810531894505, 7197.748078817321, 7231.0, 7240.529365591325, 7252.492325537267, 7394.5193562419345, 3862.5364956205435, 3866.3040652682225, 3867.6325749053794, 3891.2606604745006, 3895.24042811649, 3219.146926064595, 3263.1026467721567, 3265.363254165415, 3266.5426840242385, 3267.4772036474524, 544.9400565937743, 563.2086917880384, 563.5097465205298, 564.5004171308422, 566.3600131850982, 574.7212601888081, 590.3624085987124, 610.5573459242103, 638.5625846295303, 640.8654182621608, 7807.7267295645515, 8247.21651443112, 8301.128381519975, 8400.45397049202, 8547.35894807892, 507.58124547248667, 510.6553076673231, 553.7867920850501, 625.124825244652, 633.3286716080969, 3548.6451354864307, 3620.692241159531, 3747.775133491999, 3894.162755007687, 4104.835806567764, 49958.50041499611, 50291.74854125706, 50498.49501505012, 53057.46942530602, 53677.1948420774, 45938.31092533615, 46062.539374606495, 46149.53850461519, 46235.0, 46251.30623040657, 44874.32688509675, 45029.774851125534, 45223.54776452259, 46151.30773038407, 46723.532764671916, 7958.442908996315, 8117.756467305991, 8244.29923456513, 8323.791905202419, 8706.521141337034, 36089.458658120675, 36755.81622091872, 36807.81596092002, 37141.071473213386, 37228.44157337588, 44201.0, 44522.55477445184, 45954.54045459503, 48517.75741121272, 50463.74768126136, 10801.297915635458, 10959.56161753521, 10979.386842091986, 11483.94258028738, 11529.769404611692, 10915.345079295268, 10983.395913224529, 11048.226624136554, 11336.886631133582, 11498.310101393943, 9733.610655573697, 9794.26543009263, 9887.752806179904, 9944.751381215527, 10246.282760206714, 9867.703968880945, 10109.494525273854, 10227.48862556884, 10247.795044099226, 10578.206634502289, 8060.217961976033, 9612.327137100336, 10131.594736210469, 10339.741506462098, 10350.430726309824, 8999.460032397816, 9115.588083210829, 9201.907980920105, 9401.952990235006, 9415.293852961193, 8798.38411311202, 9031.683891063782, 9084.909150908406, 9086.54567271647, 9220.769480763034], "unit": "score", "name": "yui.html", "value": 5986.731558021154}], "name": "dromaeo_css", "value": 6744.1318597244735}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 104.0, 110.0, 110.0, 111.0, 100.0, 110.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.5}, {"lowerIsBetter": true, "replicates": [151.0, 127.0, 153.0, 165.0, 126.0, 162.0, 150.0, 125.0, 175.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 146.1}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 161.0, 161.0, 161.0, 161.0, 161.0, 163.0, 162.0, 164.0], "unit": "score", "name": "audio-dft", "value": 161.9}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 90.0, 104.0, 74.0, 75.0, 71.0, 107.0, 96.0, 72.0], "unit": "score", "name": "audio-fft", "value": 83.6}, {"lowerIsBetter": true, "replicates": [98.0, 97.0, 141.0, 95.0, 97.0, 96.0, 145.0, 95.0, 96.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 109.9}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 56.0, 55.0, 56.0, 58.0, 58.0, 65.0, 54.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 67.0, 67.0, 68.0, 67.0, 66.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.9}, {"lowerIsBetter": true, "replicates": [87.0, 93.0, 85.0, 85.0, 86.0, 86.0, 85.0, 86.0, 87.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.6}, {"lowerIsBetter": true, "replicates": [128.0, 122.0, 124.0, 130.0, 116.0, 124.0, 119.0, 118.0, 124.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.0}, {"lowerIsBetter": true, "replicates": [142.0, 152.0, 151.0, 150.0, 140.0, 139.0, 150.0, 152.0, 148.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.4}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 70.0, 71.0, 76.0, 67.0, 68.0, 71.0, 73.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.2}], "name": "kraken", "value": 1509.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.8335001668335], "unit": "score", "name": "Richards", "value": 211.6001880000001}, {"lowerIsBetter": false, "replicates": [197.19976336028398], "unit": "score", "name": "DeltaBlue", "value": 335.28437799999983}, {"lowerIsBetter": false, "replicates": [285.5511136493432], "unit": "score", "name": "Encrypt", "value": 932.1658620000004}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [1111.111111111111], "unit": "score", "name": "RayTrace", "value": 665.9901}, {"lowerIsBetter": false, "replicates": [802.5682182985554], "unit": "score", "name": "Earley", "value": 830.4128980000002}, {"lowerIsBetter": false, "replicates": [12144.578313253012], "unit": "score", "name": "Boyer", "value": 54.87740972222223}, {"lowerIsBetter": false, "replicates": [25923.076923076922], "unit": "score", "name": "RegExp", "value": 35.14185459940652}, {"lowerIsBetter": false, "replicates": [633.8383838383838], "unit": "score", "name": "Splay", "value": 128.56747410358565}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20760.934583598184}]} 20:12:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20760.93"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1509.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6744.13"}}} 20:12:36 INFO - Return code: 0 20:12:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:12:36 INFO - # TBPL SUCCESS # 20:12:36 INFO - Running post-action listener: _resource_record_post_action 20:12:36 INFO - Running post-run listener: _resource_record_post_run 20:12:37 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 4096; Write bytes: 553963520; Read time: 12; Write time: 644432 20:12:37 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 235458560; Read time: 0; Write time: 374040 20:12:37 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 4096; Write bytes: 318504960; Read time: 12; Write time: 270392 20:12:37 INFO - Running post-run listener: _upload_blobber_files 20:12:37 INFO - Blob upload gear active. 20:12:37 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:12:37 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 20:12:37 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'] 20:12:37 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 20:12:38 INFO - (blobuploader) - INFO - Open directory for files ... 20:12:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:12:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:12:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:12:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:12:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:12:39 INFO - (blobuploader) - INFO - Done attempting. 20:12:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 20:12:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:12:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:12:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:12:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:12:40 INFO - (blobuploader) - INFO - Done attempting. 20:12:40 INFO - (blobuploader) - INFO - Iteration through files over. 20:12:40 INFO - Return code: 0 20:12:40 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:12:40 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:12:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98842f80afa2db4d921791523cf7ac4532a1273d2e4fbd6846f4d1b5b222b11188a25d22b5d4eb86526b9cac559fee01a30c0ea5c316fb1ab9249e193c769552", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/51f5d41eea162f6570e3a90f090e81770734002af39780c08807c6f3ba3c303cc90063eced593f0bcd89a50e04632e02812151f7fe8ce565ba3828dbe9314264"} 20:12:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:12:40 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:12:40 INFO - Contents: 20:12:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98842f80afa2db4d921791523cf7ac4532a1273d2e4fbd6846f4d1b5b222b11188a25d22b5d4eb86526b9cac559fee01a30c0ea5c316fb1ab9249e193c769552", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/51f5d41eea162f6570e3a90f090e81770734002af39780c08807c6f3ba3c303cc90063eced593f0bcd89a50e04632e02812151f7fe8ce565ba3828dbe9314264"} 20:12:40 INFO - Copying logs to upload dir... 20:12:40 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1273.354527 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-01 20:12:39.944317) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-01 20:12:39.947549) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1451705884.266894-1085942255 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/98842f80afa2db4d921791523cf7ac4532a1273d2e4fbd6846f4d1b5b222b11188a25d22b5d4eb86526b9cac559fee01a30c0ea5c316fb1ab9249e193c769552", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/51f5d41eea162f6570e3a90f090e81770734002af39780c08807c6f3ba3c303cc90063eced593f0bcd89a50e04632e02812151f7fe8ce565ba3828dbe9314264"} build_url:https://queue.taskcluster.net/v1/task/acMhVtLJRSaAMEMRWU2YHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011265 build_url: 'https://queue.taskcluster.net/v1/task/acMhVtLJRSaAMEMRWU2YHg/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/98842f80afa2db4d921791523cf7ac4532a1273d2e4fbd6846f4d1b5b222b11188a25d22b5d4eb86526b9cac559fee01a30c0ea5c316fb1ab9249e193c769552", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/51f5d41eea162f6570e3a90f090e81770734002af39780c08807c6f3ba3c303cc90063eced593f0bcd89a50e04632e02812151f7fe8ce565ba3828dbe9314264"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-01 20:12:39.972735) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 20:12:39.973113) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1451705884.266894-1085942255 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 20:12:40.055158) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-01 20:12:40.055528) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-01 20:12:40.055862) ========= ========= Total master_lag: 0.27 =========