builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-059 starttime: 1451328629.06 results: success (0) buildid: 20151228083140 builduid: 88635c1fcf1c42658e7c08ce1563fd70 revision: 5b9292b9f878471b54498c1a70cecb76d5a409b3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:29.061817) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:29.062300) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:29.062666) ========= 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=5752742a61d0f534093fa7a9000001cb-1451326719.791254-2040881002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006507 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:29.099022) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:29.099333) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:29.160339) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:29.160605) ========= 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=5752742a61d0f534093fa7a9000001cb-1451326719.791254-2040881002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004575 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:29.234885) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:29.235168) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:29.235513) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:29.235790) ========= 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=5752742a61d0f534093fa7a9000001cb-1451326719.791254-2040881002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-28 10:50:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 83.6M=0s 2015-12-28 10:50:29 (83.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.149870 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:29.418438) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:29.418719) ========= 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=5752742a61d0f534093fa7a9000001cb-1451326719.791254-2040881002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018232 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:29.473292) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:29.473628) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5b9292b9f878471b54498c1a70cecb76d5a409b3 --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 5b9292b9f878471b54498c1a70cecb76d5a409b3 --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=5752742a61d0f534093fa7a9000001cb-1451326719.791254-2040881002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-28 10:50:29,882 truncating revision to first 12 chars 2015-12-28 10:50:29,882 Setting DEBUG logging. 2015-12-28 10:50:29,882 attempt 1/10 2015-12-28 10:50:29,882 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5b9292b9f878?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-28 10:50:30,126 unpacking tar archive at: fx-team-5b9292b9f878/testing/mozharness/ program finished with exit code 0 elapsedTime=0.509229 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:29.996667) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:29.996985) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:30.006211) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:30.006814) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-28 10:50:30.007601) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2015-12-28 10:50:30.008083) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5752742a61d0f534093fa7a9000001cb-1451326719.791254-2040881002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:50:30 INFO - MultiFileLogger online at 20151228 10:50:30 in /builds/slave/test-pgo 10:50:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 10:50:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:50:30 INFO - {'append_to_log': False, 10:50:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:50:30 INFO - 'blob_upload_branch': 'Fx-Team', 10:50:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:50:30 INFO - 'branch': 'Fx-Team', 10:50:30 INFO - 'buildbot_json_path': 'buildprops.json', 10:50:30 INFO - 'config_files': ('talos/linux_config.py',), 10:50:30 INFO - 'default_actions': ('clobber', 10:50:30 INFO - 'read-buildbot-config', 10:50:30 INFO - 'download-and-extract', 10:50:30 INFO - 'populate-webroot', 10:50:30 INFO - 'create-virtualenv', 10:50:30 INFO - 'install', 10:50:30 INFO - 'run-tests'), 10:50:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:50:30 INFO - 'download_minidump_stackwalk': True, 10:50:30 INFO - 'download_symbols': 'ondemand', 10:50:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:50:30 INFO - 'tooltool.py': '/tools/tooltool.py', 10:50:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:50:30 INFO - '/tools/misc-python/virtualenv.py')}, 10:50:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:50:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:50:30 INFO - 'installer_path': 'installer.exe', 10:50:30 INFO - 'log_level': 'info', 10:50:30 INFO - 'log_name': 'talos', 10:50:30 INFO - 'log_to_console': True, 10:50:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:50:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:50:30 INFO - 'opt_config_files': (), 10:50:30 INFO - 'pip_index': False, 10:50:30 INFO - 'sps_profile': False, 10:50:30 INFO - 'sps_profile_interval': 0, 10:50:30 INFO - 'suite': 'dromaeojs-e10s', 10:50:30 INFO - 'system_bits': '32', 10:50:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:50:30 INFO - 'title': 'talos-linux64-ix-059', 10:50:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:50:30 INFO - 'use_talos_json': True, 10:50:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:50:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:50:30 INFO - 'work_dir': 'build'} 10:50:30 INFO - ##### 10:50:30 INFO - ##### Running clobber step. 10:50:30 INFO - ##### 10:50:30 INFO - Running pre-action listener: _resource_record_pre_action 10:50:30 INFO - Running main action method: clobber 10:50:30 INFO - rmtree: /builds/slave/test-pgo/build 10:50:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:50:30 INFO - Running post-action listener: _resource_record_post_action 10:50:30 INFO - ##### 10:50:30 INFO - ##### Running read-buildbot-config step. 10:50:30 INFO - ##### 10:50:30 INFO - Running pre-action listener: _resource_record_pre_action 10:50:30 INFO - Running main action method: read_buildbot_config 10:50:30 INFO - Using buildbot properties: 10:50:30 INFO - { 10:50:30 INFO - "project": "", 10:50:30 INFO - "product": "firefox", 10:50:30 INFO - "script_repo_revision": "production", 10:50:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 10:50:30 INFO - "repository": "", 10:50:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 10:50:30 INFO - "buildid": "20151228083140", 10:50:30 INFO - "pgo_build": "True", 10:50:30 INFO - "basedir": "/builds/slave/test-pgo", 10:50:30 INFO - "buildnumber": 159, 10:50:30 INFO - "slavename": "talos-linux64-ix-059", 10:50:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:50:30 INFO - "platform": "ubuntu64_hw", 10:50:30 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 10:50:30 INFO - "branch": "fx-team", 10:50:30 INFO - "repo_path": "integration/fx-team", 10:50:30 INFO - "revision": "5b9292b9f878471b54498c1a70cecb76d5a409b3", 10:50:30 INFO - "stage_platform": "linux64-pgo", 10:50:30 INFO - "builduid": "88635c1fcf1c42658e7c08ce1563fd70", 10:50:30 INFO - "slavebuilddir": "test" 10:50:30 INFO - } 10:50:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:50:30 INFO - Running post-action listener: _resource_record_post_action 10:50:30 INFO - ##### 10:50:30 INFO - ##### Running download-and-extract step. 10:50:30 INFO - ##### 10:50:30 INFO - Running pre-action listener: _resource_record_pre_action 10:50:30 INFO - Running main action method: download_and_extract 10:50:30 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:50: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')]} 10:50:30 INFO - https://queue.taskcluster.net/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:50:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/test_packages.json 10:50:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/test_packages.json 10:50:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:50:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:50:31 INFO - Downloaded 1302 bytes. 10:50:31 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:50:31 INFO - Using the following test package requirements: 10:50:31 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:50:31 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:50:31 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:31 INFO - u'jsshell-linux-x86_64.zip'], 10:50:31 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:50:31 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:50:31 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:50:31 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:50:31 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:50:31 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:50:31 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:50:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:50:31 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')]} 10:50:31 INFO - https://queue.taskcluster.net/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:50:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:50:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:50:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/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 10:50:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/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 10:50:33 INFO - Downloaded 23191673 bytes. 10:50: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 10:50:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:50: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 10:50:34 INFO - Return code: 0 10:50: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 10:50: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')]} 10:50:34 INFO - https://queue.taskcluster.net/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:50:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:50:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:50:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/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 10:50:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/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 10:50:54 INFO - Downloaded 23191673 bytes. 10:50:54 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 10:50:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:50:54 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 10:50:56 INFO - Return code: 0 10:50: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')]} 10:50:56 INFO - https://queue.taskcluster.net/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:50:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:50:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:50:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/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 10:50:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/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 10:50:56 INFO - Downloaded 11132270 bytes. 10:50:56 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 10:50:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:50:56 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 10:50:57 INFO - Return code: 0 10:50:57 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')]} 10:50:57 INFO - https://queue.taskcluster.net/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:50:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:50:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:50:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/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 10:50:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7spQg9DMR0WB6z602ZU4Zg/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 10:50:58 INFO - Downloaded 54885874 bytes. 10:50:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:50:58 INFO - mkdir: /builds/slave/test-pgo/properties 10:50:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:50:58 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:50:58 INFO - Contents: 10:50:58 INFO - build_url:https://queue.taskcluster.net/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:50:58 INFO - Running post-action listener: _resource_record_post_action 10:50:58 INFO - Running post-action listener: set_extra_try_arguments 10:50:58 INFO - ##### 10:50:58 INFO - ##### Running populate-webroot step. 10:50:58 INFO - ##### 10:50:58 INFO - Running pre-action listener: _resource_record_pre_action 10:50:58 INFO - Running main action method: populate_webroot 10:50:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:50:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:50:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:50:58 INFO - '--tppagecycles', 10:50:58 INFO - '7'], 10:50:58 INFO - 'tests': ['tsvgm']}}, 10:50:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:50:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:50:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:50:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:50:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:50:58 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:50:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:50:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:58 INFO - 'talos_options': ['--e10s'], 10:50:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:50:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:58 INFO - 'tests': ['damp', 'tps']}, 10:50:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:58 INFO - 'talos_options': ['--e10s'], 10:50:58 INFO - 'tests': ['damp', 'tps']}, 10:50:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:50:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:50:58 INFO - 'other': {'tests': ['a11yr', 10:50:58 INFO - 'ts_paint', 10:50:58 INFO - 'tpaint', 10:50:58 INFO - 'sessionrestore', 10:50:58 INFO - 'sessionrestore_no_auto_restore']}, 10:50:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:50:58 INFO - 'tests': ['a11yr', 10:50:58 INFO - 'ts_paint', 10:50:58 INFO - 'tpaint', 10:50:58 INFO - 'sessionrestore', 10:50:58 INFO - 'sessionrestore_no_auto_restore']}, 10:50:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:50:58 INFO - 'tests': ['a11yr', 10:50:58 INFO - 'ts_paint', 10:50:58 INFO - 'tpaint', 10:50:58 INFO - 'sessionrestore', 10:50:58 INFO - 'sessionrestore_no_auto_restore']}, 10:50:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:50:58 INFO - 'tests': ['a11yr', 10:50:58 INFO - 'ts_paint', 10:50:58 INFO - 'tpaint', 10:50:58 INFO - 'sessionrestore', 10:50:58 INFO - 'sessionrestore_no_auto_restore']}, 10:50:58 INFO - 'other_l64': {'tests': ['a11yr', 10:50:58 INFO - 'ts_paint', 10:50:58 INFO - 'tpaint', 10:50:58 INFO - 'sessionrestore', 10:50:58 INFO - 'sessionrestore_no_auto_restore']}, 10:50:58 INFO - 'other_nol64': {'tests': ['a11yr', 10:50:58 INFO - 'ts_paint', 10:50:58 INFO - 'tpaint', 10:50:58 INFO - 'sessionrestore', 10:50:58 INFO - 'sessionrestore_no_auto_restore']}, 10:50:58 INFO - 'svgr': {'tests': ['tsvgx', 10:50:58 INFO - 'tsvgr_opacity', 10:50:58 INFO - 'tart', 10:50:58 INFO - 'tscrollx', 10:50:58 INFO - 'cart']}, 10:50:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:50:58 INFO - 'tests': ['tsvgx', 10:50:58 INFO - 'tsvgr_opacity', 10:50:58 INFO - 'tart', 10:50:58 INFO - 'tscrollx', 10:50:58 INFO - 'cart']}, 10:50:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:58 INFO - 'tests': ['tp5o']}, 10:50:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:58 INFO - 'talos_options': ['--e10s'], 10:50:58 INFO - 'tests': ['tp5o']}, 10:50:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:58 INFO - 'talos_options': ['--xperf_path', 10:50:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:50:58 INFO - 'tests': ['tp5n']}, 10:50:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:58 INFO - 'talos_options': ['--e10s', 10:50:58 INFO - '--xperf_path', 10:50:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:50:58 INFO - 'tests': ['tp5n']}}, 10:50:58 INFO - 'talos.zip': {'path': '', 10:50:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:50:58 INFO - Running post-action listener: _resource_record_post_action 10:50:58 INFO - ##### 10:50:58 INFO - ##### Running create-virtualenv step. 10:50:58 INFO - ##### 10:50:58 INFO - Running pre-action listener: _resource_record_pre_action 10:50:58 INFO - Running main action method: create_virtualenv 10:50:58 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:50:58 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 10:50:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:50:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:50:58 INFO - Using real prefix '/usr' 10:50:58 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:50:58 INFO - Installing distribute.............................................................................................................................................................................................done. 10:51:01 INFO - Installing pip.................done. 10:51:01 INFO - Return code: 0 10:51:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:51:01 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')]} 10:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:01 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')]} 10:51:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:01 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 0x7ffb83878f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2706630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2797840>, '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 0x27046b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2704b60>, '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': '5752742a61d0f534093fa7a9000001cb-1451326719.791254-2040881002', '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 10:51:01 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 10:51:01 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 10:51:01 INFO - Using env: {'DISPLAY': ':0', 10:51:01 INFO - 'HOME': '/home/cltbld', 10:51:01 INFO - 'LANG': 'en_US.UTF-8', 10:51:01 INFO - 'LANGUAGE': 'en_US:en', 10:51:01 INFO - 'LOGNAME': 'cltbld', 10:51:01 INFO - 'MAIL': '/var/mail/cltbld', 10:51:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:01 INFO - 'MOZ_NO_REMOTE': '1', 10:51:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:01 INFO - 'NO_EM_RESTART': '1', 10:51:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:01 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:01 INFO - 'SHELL': '/bin/bash', 10:51:01 INFO - 'SHLVL': '1', 10:51:01 INFO - 'TERM': 'linux', 10:51:01 INFO - 'TMOUT': '86400', 10:51:01 INFO - 'USER': 'cltbld', 10:51:01 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451326719.791254-2040881002', 10:51:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:01 INFO - '_': '/tools/buildbot/bin/python'} 10:51:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:01 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 10:51:01 INFO - Cleaning up... 10:51:01 INFO - Return code: 0 10:51:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:51:01 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')]} 10:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:01 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')]} 10:51:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:01 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 0x7ffb83878f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2706630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2797840>, '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 0x27046b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2704b60>, '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': '5752742a61d0f534093fa7a9000001cb-1451326719.791254-2040881002', '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 10:51:01 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 10:51:01 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 10:51:01 INFO - Using env: {'DISPLAY': ':0', 10:51:01 INFO - 'HOME': '/home/cltbld', 10:51:01 INFO - 'LANG': 'en_US.UTF-8', 10:51:01 INFO - 'LANGUAGE': 'en_US:en', 10:51:01 INFO - 'LOGNAME': 'cltbld', 10:51:01 INFO - 'MAIL': '/var/mail/cltbld', 10:51:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:01 INFO - 'MOZ_NO_REMOTE': '1', 10:51:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:01 INFO - 'NO_EM_RESTART': '1', 10:51:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:01 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:01 INFO - 'SHELL': '/bin/bash', 10:51:01 INFO - 'SHLVL': '1', 10:51:01 INFO - 'TERM': 'linux', 10:51:01 INFO - 'TMOUT': '86400', 10:51:01 INFO - 'USER': 'cltbld', 10:51:01 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451326719.791254-2040881002', 10:51:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:01 INFO - '_': '/tools/buildbot/bin/python'} 10:51:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:01 INFO - Downloading/unpacking psutil>=0.7.1 10:51:01 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 10:51:01 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 10:51:01 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 10:51:01 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 10:51:01 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 10:51:01 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 10:51:03 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:51:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:51:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:51:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:51:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:51:03 INFO - Installing collected packages: psutil 10:51:03 INFO - Running setup.py install for psutil 10:51:03 INFO - building 'psutil._psutil_linux' extension 10:51:03 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 10:51:03 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 10:51:03 INFO - building 'psutil._psutil_posix' extension 10:51:03 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 10:51:03 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 10:51:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:51:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:51:03 INFO - Successfully installed psutil 10:51:03 INFO - Cleaning up... 10:51:03 INFO - Return code: 0 10:51:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:51: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')]} 10:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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')]} 10:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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', '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 0x7ffb83878f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2706630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2797840>, '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 0x27046b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2704b60>, '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': '5752742a61d0f534093fa7a9000001cb-1451326719.791254-2040881002', '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 10:51: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 10:51: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 mozsystemmonitor==0.0.0 10:51:03 INFO - Using env: {'DISPLAY': ':0', 10:51:03 INFO - 'HOME': '/home/cltbld', 10:51:03 INFO - 'LANG': 'en_US.UTF-8', 10:51:03 INFO - 'LANGUAGE': 'en_US:en', 10:51:03 INFO - 'LOGNAME': 'cltbld', 10:51:03 INFO - 'MAIL': '/var/mail/cltbld', 10:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:03 INFO - 'MOZ_NO_REMOTE': '1', 10:51:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:03 INFO - 'NO_EM_RESTART': '1', 10:51:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:03 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:03 INFO - 'SHELL': '/bin/bash', 10:51:03 INFO - 'SHLVL': '1', 10:51:03 INFO - 'TERM': 'linux', 10:51:03 INFO - 'TMOUT': '86400', 10:51:03 INFO - 'USER': 'cltbld', 10:51:03 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451326719.791254-2040881002', 10:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:03 INFO - '_': '/tools/buildbot/bin/python'} 10:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:51: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 10:51: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 10:51: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 10:51: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 10:51: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 10:51: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 10:51:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:51:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:51:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:51:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:51:05 INFO - Installing collected packages: mozsystemmonitor 10:51:05 INFO - Running setup.py install for mozsystemmonitor 10:51:05 INFO - Successfully installed mozsystemmonitor 10:51:05 INFO - Cleaning up... 10:51:05 INFO - Return code: 0 10:51:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:51:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:05 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 0x7ffb83878f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2706630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2797840>, '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 0x27046b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2704b60>, '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': '5752742a61d0f534093fa7a9000001cb-1451326719.791254-2040881002', '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 10:51:05 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 10:51:05 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 10:51:05 INFO - Using env: {'DISPLAY': ':0', 10:51:05 INFO - 'HOME': '/home/cltbld', 10:51:05 INFO - 'LANG': 'en_US.UTF-8', 10:51:05 INFO - 'LANGUAGE': 'en_US:en', 10:51:05 INFO - 'LOGNAME': 'cltbld', 10:51:05 INFO - 'MAIL': '/var/mail/cltbld', 10:51:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:05 INFO - 'MOZ_NO_REMOTE': '1', 10:51:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:05 INFO - 'NO_EM_RESTART': '1', 10:51:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:05 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:05 INFO - 'SHELL': '/bin/bash', 10:51:05 INFO - 'SHLVL': '1', 10:51:05 INFO - 'TERM': 'linux', 10:51:05 INFO - 'TMOUT': '86400', 10:51:05 INFO - 'USER': 'cltbld', 10:51:05 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451326719.791254-2040881002', 10:51:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:05 INFO - '_': '/tools/buildbot/bin/python'} 10:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:06 INFO - Downloading/unpacking blobuploader==1.2.4 10:51:06 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 10:51:06 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 10:51:06 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 10:51:06 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 10:51:06 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 10:51:06 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 10:51:07 INFO - Downloading blobuploader-1.2.4.tar.gz 10:51:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:51:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:51:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:51:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:51:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:08 INFO - Downloading docopt-0.6.1.tar.gz 10:51:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:51:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:51:08 INFO - Installing collected packages: blobuploader, requests, docopt 10:51:08 INFO - Running setup.py install for blobuploader 10:51:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:51:08 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:51:08 INFO - Running setup.py install for requests 10:51:08 INFO - Running setup.py install for docopt 10:51:09 INFO - Successfully installed blobuploader requests docopt 10:51:09 INFO - Cleaning up... 10:51:09 INFO - Return code: 0 10:51:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:51:09 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')]} 10:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:09 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')]} 10:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:09 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 0x7ffb83878f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2706630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2797840>, '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 0x27046b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2704b60>, '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': '5752742a61d0f534093fa7a9000001cb-1451326719.791254-2040881002', '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 10:51:09 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 10:51:09 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 10:51:09 INFO - Using env: {'DISPLAY': ':0', 10:51:09 INFO - 'HOME': '/home/cltbld', 10:51:09 INFO - 'LANG': 'en_US.UTF-8', 10:51:09 INFO - 'LANGUAGE': 'en_US:en', 10:51:09 INFO - 'LOGNAME': 'cltbld', 10:51:09 INFO - 'MAIL': '/var/mail/cltbld', 10:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:09 INFO - 'MOZ_NO_REMOTE': '1', 10:51:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:09 INFO - 'NO_EM_RESTART': '1', 10:51:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:09 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:09 INFO - 'SHELL': '/bin/bash', 10:51:09 INFO - 'SHLVL': '1', 10:51:09 INFO - 'TERM': 'linux', 10:51:09 INFO - 'TMOUT': '86400', 10:51:09 INFO - 'USER': 'cltbld', 10:51:09 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451326719.791254-2040881002', 10:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:09 INFO - '_': '/tools/buildbot/bin/python'} 10:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:51:09 INFO - Running setup.py (path:/tmp/pip-WHw__J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:51:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:51:09 INFO - Running setup.py (path:/tmp/pip-ZsiCl1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:51:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:51:09 INFO - Running setup.py (path:/tmp/pip-MgrG9k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:51:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:51:09 INFO - Running setup.py (path:/tmp/pip-UlEBRr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:51:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:51:09 INFO - Running setup.py (path:/tmp/pip-gFH95g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:51:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:51:09 INFO - Running setup.py (path:/tmp/pip-BIPRv7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:51:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:51:09 INFO - Running setup.py (path:/tmp/pip-weRfXL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:51:10 INFO - Running setup.py (path:/tmp/pip-xpdE0W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:51:10 INFO - Running setup.py (path:/tmp/pip-EX1s6J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:51:10 INFO - Running setup.py (path:/tmp/pip-EjlOuc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:51:10 INFO - Running setup.py (path:/tmp/pip-RM8o4z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:51:10 INFO - Running setup.py (path:/tmp/pip-KNBD4w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:51:10 INFO - Running setup.py (path:/tmp/pip-E9lNpi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:51:10 INFO - Running setup.py (path:/tmp/pip-wRQfnV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:51:10 INFO - Running setup.py (path:/tmp/pip-d7wVw2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:51:10 INFO - Running setup.py (path:/tmp/pip-8BGgCA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:51:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:51:10 INFO - Running setup.py (path:/tmp/pip-eSIr0B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:51:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:51:10 INFO - Running setup.py install for manifestparser 10:51:10 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:51:10 INFO - Running setup.py install for mozcrash 10:51:10 INFO - Running setup.py install for mozdebug 10:51:11 INFO - Running setup.py install for mozdevice 10:51:11 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:51:11 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:51:11 INFO - Running setup.py install for mozfile 10:51:11 INFO - Running setup.py install for mozhttpd 10:51:11 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:51:11 INFO - Running setup.py install for mozinfo 10:51:11 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:51:11 INFO - Running setup.py install for mozInstall 10:51:11 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:51:11 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:51:11 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:51:11 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:51:11 INFO - Running setup.py install for mozleak 10:51:11 INFO - Running setup.py install for mozlog 10:51:11 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:51:11 INFO - Running setup.py install for moznetwork 10:51:11 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:51:11 INFO - Running setup.py install for mozprocess 10:51:11 INFO - Running setup.py install for mozprofile 10:51:12 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:51:12 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:51:12 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:51:12 INFO - Running setup.py install for mozrunner 10:51:12 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:51:12 INFO - Running setup.py install for mozscreenshot 10:51:12 INFO - Running setup.py install for moztest 10:51:12 INFO - Running setup.py install for mozversion 10:51:12 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:51:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:51:12 INFO - Cleaning up... 10:51:12 INFO - Return code: 0 10:51:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:51:12 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')]} 10:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:12 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')]} 10:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:12 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 0x7ffb83878f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2706630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2797840>, '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 0x27046b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2704b60>, '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': '5752742a61d0f534093fa7a9000001cb-1451326719.791254-2040881002', '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 10:51:12 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 10:51:12 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 10:51:12 INFO - Using env: {'DISPLAY': ':0', 10:51:12 INFO - 'HOME': '/home/cltbld', 10:51:12 INFO - 'LANG': 'en_US.UTF-8', 10:51:12 INFO - 'LANGUAGE': 'en_US:en', 10:51:12 INFO - 'LOGNAME': 'cltbld', 10:51:12 INFO - 'MAIL': '/var/mail/cltbld', 10:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:12 INFO - 'MOZ_NO_REMOTE': '1', 10:51:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:12 INFO - 'NO_EM_RESTART': '1', 10:51:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:12 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:12 INFO - 'SHELL': '/bin/bash', 10:51:12 INFO - 'SHLVL': '1', 10:51:12 INFO - 'TERM': 'linux', 10:51:12 INFO - 'TMOUT': '86400', 10:51:12 INFO - 'USER': 'cltbld', 10:51:12 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451326719.791254-2040881002', 10:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:12 INFO - '_': '/tools/buildbot/bin/python'} 10:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:51:12 INFO - Running setup.py (path:/tmp/pip-teo0DJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:51:12 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)) 10:51:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:51:12 INFO - Running setup.py (path:/tmp/pip-OLHEme-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:51:12 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)) 10:51:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:51:12 INFO - Running setup.py (path:/tmp/pip-MQmVDp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:51:12 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)) 10:51:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:51:12 INFO - Running setup.py (path:/tmp/pip-DXJJAr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:51:13 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)) 10:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:51:13 INFO - Running setup.py (path:/tmp/pip-0U3SPW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:51:13 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)) 10:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:51:13 INFO - Running setup.py (path:/tmp/pip-sxhHW9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:51:13 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)) 10:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:51:13 INFO - Running setup.py (path:/tmp/pip-EEWSEK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:51:13 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)) 10:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:51:13 INFO - Running setup.py (path:/tmp/pip-e_d1He-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:51:13 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)) 10:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:51:13 INFO - Running setup.py (path:/tmp/pip-Ld2rQ4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:51:13 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)) 10:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:51:13 INFO - Running setup.py (path:/tmp/pip-mTcf1X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:51:13 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)) 10:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:51:13 INFO - Running setup.py (path:/tmp/pip-SoCNzD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:51:13 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)) 10:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:51:13 INFO - Running setup.py (path:/tmp/pip-wzO7OI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:51:13 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)) 10:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:51:13 INFO - Running setup.py (path:/tmp/pip-bHJgVN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:51:13 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)) 10:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:51:13 INFO - Running setup.py (path:/tmp/pip-7hZQzh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:51:13 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)) 10:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:51:13 INFO - Running setup.py (path:/tmp/pip-e98Eph-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:51:13 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)) 10:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:51:13 INFO - Running setup.py (path:/tmp/pip-d5q0l4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:51:13 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)) 10:51:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:51:13 INFO - Running setup.py (path:/tmp/pip-CcODb9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:51:13 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)) 10:51:14 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)) 10:51:14 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)) 10:51:14 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)) 10:51:14 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)) 10:51:14 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)) 10:51:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:51:14 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 10:51:14 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 10:51:14 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 10:51:14 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 10:51:14 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 10:51:14 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 10:51:15 INFO - Downloading blessings-1.5.1.tar.gz 10:51:15 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 10:51:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:51:15 INFO - Installing collected packages: blessings 10:51:15 INFO - Running setup.py install for blessings 10:51:15 INFO - Successfully installed blessings 10:51:15 INFO - Cleaning up... 10:51:15 INFO - Return code: 0 10:51:15 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:51:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:51:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:51:16 INFO - Reading from file tmpfile_stdout 10:51:16 INFO - Current package versions: 10:51:16 INFO - argparse == 1.2.1 10:51:16 INFO - blessings == 1.5.1 10:51:16 INFO - blobuploader == 1.2.4 10:51:16 INFO - docopt == 0.6.1 10:51:16 INFO - manifestparser == 1.1 10:51:16 INFO - mozInstall == 1.12 10:51:16 INFO - mozcrash == 0.16 10:51:16 INFO - mozdebug == 0.1 10:51:16 INFO - mozdevice == 0.47 10:51:16 INFO - mozfile == 1.2 10:51:16 INFO - mozhttpd == 0.7 10:51:16 INFO - mozinfo == 0.9 10:51:16 INFO - mozleak == 0.1 10:51:16 INFO - mozlog == 3.1 10:51:16 INFO - moznetwork == 0.27 10:51:16 INFO - mozprocess == 0.22 10:51:16 INFO - mozprofile == 0.28 10:51:16 INFO - mozrunner == 6.11 10:51:16 INFO - mozscreenshot == 0.1 10:51:16 INFO - mozsystemmonitor == 0.0 10:51:16 INFO - moztest == 0.7 10:51:16 INFO - mozversion == 1.4 10:51:16 INFO - psutil == 3.1.1 10:51:16 INFO - requests == 1.2.3 10:51:16 INFO - wsgiref == 0.1.2 10:51:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:51:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:16 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 0x7ffb83878f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2706630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2797840>, '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 0x27046b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2704b60>, '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': '5752742a61d0f534093fa7a9000001cb-1451326719.791254-2040881002', '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 10:51:16 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 10:51:16 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 10:51:16 INFO - Using env: {'DISPLAY': ':0', 10:51:16 INFO - 'HOME': '/home/cltbld', 10:51:16 INFO - 'LANG': 'en_US.UTF-8', 10:51:16 INFO - 'LANGUAGE': 'en_US:en', 10:51:16 INFO - 'LOGNAME': 'cltbld', 10:51:16 INFO - 'MAIL': '/var/mail/cltbld', 10:51:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:16 INFO - 'MOZ_NO_REMOTE': '1', 10:51:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:16 INFO - 'NO_EM_RESTART': '1', 10:51:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:16 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:16 INFO - 'SHELL': '/bin/bash', 10:51:16 INFO - 'SHLVL': '1', 10:51:16 INFO - 'TERM': 'linux', 10:51:16 INFO - 'TMOUT': '86400', 10:51:16 INFO - 'USER': 'cltbld', 10:51:16 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451326719.791254-2040881002', 10:51:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:16 INFO - '_': '/tools/buildbot/bin/python'} 10:51:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:16 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)) 10:51:16 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)) 10:51:16 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)) 10:51:16 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)) 10:51:16 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)) 10:51:16 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)) 10:51:16 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)) 10:51:16 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)) 10:51:16 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)) 10:51:16 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)) 10:51:16 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)) 10:51:16 INFO - Cleaning up... 10:51:16 INFO - Return code: 0 10:51:16 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:51:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:16 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 0x7ffb83878f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2706630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2797840>, '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 0x27046b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2704b60>, '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': '5752742a61d0f534093fa7a9000001cb-1451326719.791254-2040881002', '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 10:51:16 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 10:51:16 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 10:51:16 INFO - Using env: {'DISPLAY': ':0', 10:51:16 INFO - 'HOME': '/home/cltbld', 10:51:16 INFO - 'LANG': 'en_US.UTF-8', 10:51:16 INFO - 'LANGUAGE': 'en_US:en', 10:51:16 INFO - 'LOGNAME': 'cltbld', 10:51:16 INFO - 'MAIL': '/var/mail/cltbld', 10:51:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:16 INFO - 'MOZ_NO_REMOTE': '1', 10:51:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:16 INFO - 'NO_EM_RESTART': '1', 10:51:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:16 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:16 INFO - 'SHELL': '/bin/bash', 10:51:16 INFO - 'SHLVL': '1', 10:51:16 INFO - 'TERM': 'linux', 10:51:16 INFO - 'TMOUT': '86400', 10:51:16 INFO - 'USER': 'cltbld', 10:51:16 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451326719.791254-2040881002', 10:51:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:16 INFO - '_': '/tools/buildbot/bin/python'} 10:51:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:16 INFO - Downloading/unpacking jsonschema 10:51:16 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 10:51:16 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 10:51:16 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 10:51:16 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 10:51:16 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 10:51:16 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 10:51:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:51:18 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 10:51:18 INFO - Downloading/unpacking functools32 (from jsonschema) 10:51:18 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 10:51:18 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 10:51:18 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 10:51:18 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 10:51:18 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 10:51:18 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 10:51:18 INFO - Downloading functools32-3.2.3-2.tar.gz 10:51:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:51:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:51:18 INFO - warning: no files found matching '*.txt' 10:51:18 INFO - no previously-included directories found matching 'build' 10:51:18 INFO - no previously-included directories found matching 'dist' 10:51:18 INFO - no previously-included directories found matching '.git*' 10:51:18 INFO - Installing collected packages: jsonschema, functools32 10:51:18 INFO - Running setup.py install for functools32 10:51:18 INFO - warning: no files found matching '*.txt' 10:51:18 INFO - no previously-included directories found matching 'build' 10:51:18 INFO - no previously-included directories found matching 'dist' 10:51:18 INFO - no previously-included directories found matching '.git*' 10:51:18 INFO - Successfully installed jsonschema functools32 10:51:18 INFO - Cleaning up... 10:51:18 INFO - Return code: 0 10:51:18 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:18 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 0x7ffb83878f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2706630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2797840>, '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 0x27046b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2704b60>, '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': '5752742a61d0f534093fa7a9000001cb-1451326719.791254-2040881002', '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 10:51:18 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 10:51:18 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 10:51:18 INFO - Using env: {'DISPLAY': ':0', 10:51:18 INFO - 'HOME': '/home/cltbld', 10:51:18 INFO - 'LANG': 'en_US.UTF-8', 10:51:18 INFO - 'LANGUAGE': 'en_US:en', 10:51:18 INFO - 'LOGNAME': 'cltbld', 10:51:18 INFO - 'MAIL': '/var/mail/cltbld', 10:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:18 INFO - 'MOZ_NO_REMOTE': '1', 10:51:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:18 INFO - 'NO_EM_RESTART': '1', 10:51:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:18 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:18 INFO - 'SHELL': '/bin/bash', 10:51:18 INFO - 'SHLVL': '1', 10:51:18 INFO - 'TERM': 'linux', 10:51:18 INFO - 'TMOUT': '86400', 10:51:18 INFO - 'USER': 'cltbld', 10:51:18 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451326719.791254-2040881002', 10:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:18 INFO - '_': '/tools/buildbot/bin/python'} 10:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:18 INFO - Downloading/unpacking flake8 10:51:18 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 10:51:18 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 10:51:18 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 10:51:18 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 10:51:18 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 10:51:18 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 10:51:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:51:20 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 10:51:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:51:20 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 10:51:20 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 10:51:20 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 10:51:20 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 10:51:20 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 10:51:20 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 10:51:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:51:20 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 10:51:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:51:20 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 10:51:20 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 10:51:20 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 10:51:20 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 10:51:20 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 10:51:20 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 10:51:20 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 10:51:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:51:20 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 10:51:20 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 10:51:20 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 10:51:20 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 10:51:20 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 10:51:20 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 10:51:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:51:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:51:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:51:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:51:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:51:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:51:21 INFO - no previously-included directories found matching 'docs/_build' 10:51:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:51:21 INFO - Running setup.py install for pep8 10:51:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:51:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:51:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:51:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:51:21 INFO - no previously-included directories found matching 'docs/_build' 10:51:21 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:51:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:51:21 INFO - Cleaning up... 10:51:21 INFO - Return code: 0 10:51:21 INFO - Running post-action listener: _resource_record_post_action 10:51:21 INFO - Running post-action listener: _start_resource_monitoring 10:51:21 INFO - Starting resource monitoring. 10:51:21 INFO - ##### 10:51:21 INFO - ##### Running install step. 10:51:21 INFO - ##### 10:51:21 INFO - Running pre-action listener: _resource_record_pre_action 10:51:21 INFO - Running main action method: install 10:51:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:51:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:51:21 INFO - Reading from file tmpfile_stdout 10:51:21 INFO - Detecting whether we're running mozinstall >=1.0... 10:51:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:51:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:51:21 INFO - Reading from file tmpfile_stdout 10:51:21 INFO - Output received: 10:51:21 INFO - Usage: mozinstall [options] installer 10:51:21 INFO - Options: 10:51:21 INFO - -h, --help show this help message and exit 10:51:21 INFO - -d DEST, --destination=DEST 10:51:21 INFO - Directory to install application into. [default: 10:51:21 INFO - "/builds/slave/test-pgo"] 10:51:21 INFO - --app=APP Application being installed. [default: firefox] 10:51:21 INFO - mkdir: /builds/slave/test-pgo/build/application 10:51:21 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'] 10:51:21 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 10:51:37 INFO - Reading from file tmpfile_stdout 10:51:37 INFO - Output received: 10:51:37 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:51:37 INFO - Running post-action listener: _resource_record_post_action 10:51:37 INFO - ##### 10:51:37 INFO - ##### Running run-tests step. 10:51:37 INFO - ##### 10:51:37 INFO - Running pre-action listener: _resource_record_pre_action 10:51:37 INFO - Running main action method: run_tests 10:51:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:51:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:51:37 INFO - Python 2.7.3 10:51:37 INFO - Return code: 0 10:51:37 INFO - grabbing minidump binary from tooltool 10:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:37 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 0x2797840>, '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 0x27046b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2704b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:51:37 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 10:51:37 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 10:51:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:51:37 INFO - Return code: 0 10:51:37 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:51:37 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:51:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:51:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:51:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:51:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:51:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:51:38 INFO - Return code: 0 10:51:38 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 10:51:38 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:51:38 INFO - Using env: {'DISPLAY': ':0', 10:51:38 INFO - 'HOME': '/home/cltbld', 10:51:38 INFO - 'LANG': 'en_US.UTF-8', 10:51:38 INFO - 'LANGUAGE': 'en_US:en', 10:51:38 INFO - 'LOGNAME': 'cltbld', 10:51:38 INFO - 'MAIL': '/var/mail/cltbld', 10:51:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:51:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:51:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:38 INFO - 'MOZ_NO_REMOTE': '1', 10:51:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:51:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:38 INFO - 'NO_EM_RESTART': '1', 10:51:38 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:38 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:38 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:51:38 INFO - 'SHELL': '/bin/bash', 10:51:38 INFO - 'SHLVL': '1', 10:51:38 INFO - 'TERM': 'linux', 10:51:38 INFO - 'TMOUT': '86400', 10:51:38 INFO - 'USER': 'cltbld', 10:51:38 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451326719.791254-2040881002', 10:51:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:38 INFO - '_': '/tools/buildbot/bin/python'} 10:51:38 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:51:38 INFO - mozversion application_buildid: 20151228083140 10:51:38 INFO - mozversion application_changeset: 5b9292b9f878471b54498c1a70cecb76d5a409b3 10:51:38 INFO - mozversion application_display_name: Nightly 10:51:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:51:38 INFO - mozversion application_name: Firefox 10:51:38 INFO - mozversion application_remotingname: firefox 10:51:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:51:38 INFO - mozversion application_vendor: Mozilla 10:51:38 INFO - mozversion application_version: 46.0a1 10:51:38 INFO - mozversion platform_buildid: 20151228083140 10:51:38 INFO - mozversion platform_changeset: 5b9292b9f878471b54498c1a70cecb76d5a409b3 10:51:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:51:38 INFO - mozversion platform_version: 46.0a1 10:51:38 INFO - using testdate: 1451328698 10:51:38 INFO - actual date: 1451328698 10:51:38 INFO - starting webserver on 'localhost:35574' 10:51:38 INFO - SUITE-START | Running 3 tests 10:51:38 INFO - TEST-START | dromaeo_css 10:51:38 INFO - operating with platform_type : linux_ 10:51:38 INFO - Initialising browser for dromaeo_css test... 10:51:38 INFO - TEST-INFO | started process 5775 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQ8A8mG/profile http://localhost:35574/getInfo.html) 10:51:43 INFO - PROCESS | 5775 | __metrics Screen width/height:1600/1200 10:51:43 INFO - PROCESS | 5775 | colorDepth:24 10:51:43 INFO - PROCESS | 5775 | Browser inner width/height: 1024/697 10:51:43 INFO - PROCESS | 5775 | __metrics 10:51:43 INFO - PROCESS | 5775 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:51:44 INFO - TEST-INFO | 5775: exit 0 10:51:44 INFO - Browser initialized. 10:51:44 INFO - Running cycle 1/1 for dromaeo_css test... 10:51:44 INFO - TEST-INFO | started process 5908 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQ8A8mG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:51:56 INFO - PROCESS | 5908 | RSS: Main: 149295104 10:51:56 INFO - PROCESS | 5908 | 10:52:45 INFO - PROCESS | 5908 | 1451328765982 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] 10:54:55 INFO - PROCESS | 5908 | Cycle 1(1): loaded http://localhost:35574/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35574/tests/dromaeo/cssquery-ext.html) 10:54:56 INFO - PROCESS | 5908 | RSS: Main: 156762112 10:54:56 INFO - PROCESS | 5908 | 10:57:58 INFO - PROCESS | 5908 | Cycle 1(1): loaded http://localhost:35574/tests/dromaeo/cssquery-ext.html (next: http://localhost:35574/tests/dromaeo/cssquery-jquery.html) 10:57:58 INFO - PROCESS | 5908 | RSS: Main: 152875008 10:57:58 INFO - PROCESS | 5908 | 11:01:00 INFO - PROCESS | 5908 | Cycle 1(1): loaded http://localhost:35574/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35574/tests/dromaeo/cssquery-mootools.html) 11:01:01 INFO - PROCESS | 5908 | RSS: Main: 154062848 11:01:01 INFO - PROCESS | 5908 | 11:04:02 INFO - PROCESS | 5908 | Cycle 1(1): loaded http://localhost:35574/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35574/tests/dromaeo/cssquery-prototype.html) 11:04:03 INFO - PROCESS | 5908 | RSS: Main: 152543232 11:04:03 INFO - PROCESS | 5908 | 11:07:05 INFO - PROCESS | 5908 | Cycle 1(1): loaded http://localhost:35574/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35574/tests/dromaeo/cssquery-yui.html) 11:07:06 INFO - PROCESS | 5908 | RSS: Main: 153620480 11:07:06 INFO - PROCESS | 5908 | 11:10:08 INFO - PROCESS | 5908 | Cycle 1(1): loaded http://localhost:35574/tests/dromaeo/cssquery-yui.html (next: http://localhost:35574/tests/dromaeo/cssquery-dojo.html) 11:10:09 INFO - PROCESS | 5908 | RSS: Main: 154873856 11:10:09 INFO - PROCESS | 5908 | 11:10:09 INFO - PROCESS | 5908 | __start_tp_report 11:10:09 INFO - PROCESS | 5908 | _x_x_mozilla_page_load 11:10:09 INFO - PROCESS | 5908 | _x_x_mozilla_page_load_details 11:10:09 INFO - PROCESS | 5908 | |i|pagename|runs| 11:10:09 INFO - PROCESS | 5908 | |0;dojo.html;3167.9366412671748;3239.416904957107;3250.739940804736;3271.7546184036205;3281.245313577877;5295.973520132398;5319.813806516768;5340.813071542492;5346.198070289459;5349.358077030752;5349.438308977559;5360.195970604412;5384.838454846351;5387.353517577896;5404.540614047811;4644.767761611923;4943.085529177105;5081.390233172025;5103.209002604603;5112.616553758465;4798.448178459487;5002.8249011284615;5047;5075.593952483792;5117.744112794364;4850.417949846006;4911.435184953741;4955.950440495585;4966.503349665005;4998.925016124761;4933.481984391659;4933.975330123362;4949.876253093701;4971.900561988776;4996.200607902718;4823.710577365334;4888.511148885119;4917.139500587383;4935.185694360426;5012.598992080625;5140.023395554833;5175.534201921808;5218.947810521884;5282.102042652758;5297.920531192035;5759.971200143972;5761.510271626917;5764.682942438164;5766.279215098113;5766.88466230673;5824.242848429677;5828.5628577856405;5829.621074630136;5834.708264586796;5839.182514447981;5309.893802123975;5362.195670649395;5392.4337944515655;5425.6202065855405;5463.235147079412;6020.939790602038;6032.638041717511;6043.516518678583;6046.3046749624355;6063.787767428119;5771.8557036074435;5800.9129863052085;5823.88352232953;5832.766689332379;5835.562332825055;5672.404397538199;5730.828075157752;5742.6554406734895;5774.797882074107;5865.618734782311;5777.62445441045;5781.71091445426;5785.739641716133;5787.189793428839;5788.53691704671;5649.12438572022;5764.423557644202;5784.1034639630925;5787.826365209051;5795.391483894215;4417.1386579616665;4418.911621767546;4453.665975051884;4467.463904331436;4500.549945005539;3981.3629819228786;3985.1631157456677;3997.980010099989;4023.4970628671417;4024.517057953006;5207.140821764442;5404.270423492857;5435.402105768362;5438.129899216106;5447;5775.653460792366;5787.2187254720075;5813.389594092644;5830.62100963436;5859.560532960045;5383.542398896059;5387.649802762808;5419.539339156216;5420.214068959979;5428.75570599324;4872.293517440023;4873.878153046202;4955.380577427822;5010.724410157476;5053;5882.323532793698;5893.322267939242;5895.587308888336;5901.5868889177345;5957.017092179828;5788.797392091256;5807.390224026585;5828.300603927556;5849.561282903885;5862.179294898803;5842.298924129132;5932.466078052996;5941.079132734433;5954.19618351517;6012.428819262163;5730.914036289542;5733.770649173986;5734.913976290442;5737.397573254915;5739.167820666064;5752.884942301214;5795.536357091339;5806.187133801355;5808.651480911159;5818.796342128006;5449.836504904859;5592.468715472024;5614.5789065821045;5702.7718891243885;5717.971410142923;5673.489385955284;5677.091665333527;5688.886222275614;5695.601307908407;5699.658020518782;5591.189277554813;5594.496495315441;5595.804146854841;5600.243967064557;5601.159826026129;5503.147012213113;5633.295838020247;5705.771769129355;5742.569307302053;5812.099124635688;5592.580556458201;5617.915731263953;5621.269234999588;5622.32532096151;5622.5501959842295 11:10:09 INFO - PROCESS | 5908 | |1;ext.html;554.1203699257652;580.4630716587158;584.2813339592301;591.1635036423461;591.3879135095171;35005.64994350056;35395.11512212196;35706.642933570656;35758.463623045674;35813.820930895345;38203.23593528128;38825.223495530074;39012.80493597528;39021.41467877977;39092.21815563687;8352.540610266433;8431.030431500363;8463.322934165251;8527.658893644279;8553.272971797405;8311.501309921394;8400.579971001456;8426;8549.145085491464;8649.610767515476;8581.656733730642;8626;8688.56557172142;8722.956385218065;8732.039475657673;8517.403781735282;8703.216710496086;8708.521031343274;8712;8726.607302671395;8425;8611.526366049864;8614.87077693835;8632.266257368132;8641.611127499278;39405.40891886624;39421.40867886984;39718.602813972066;39887.20225595472;40019.199616007514;3193.393255281489;3222.4521831288503;3325.285063711314;3415.9146021349416;3438.1748380388776;29064.564031539543;29376.70623293761;29825.552616710767;30178.84910575455;30553.54169687434;3657.617457536589;3804.1182288534487;3836.693064554829;3886.261610294035;3940.8817735467696;269241;271883;273427;274057;274670;56702.7164864173;57427.42572574304;59326.70336648289;59819;59882;64419.677901610194;65254;65379.34620653828;65394;65526.34473655298;14343.426262949573;14485.493007744679;14532.27338633064;14568.63578410527;14573.562793116223;10851.023407893328;10900.127989760958;10917;10937.56249750001;10941.83587246192;18799.624007519775;18851.71722424165;18858.52853678669;18930.716039259423;19473.318433854747;7705.691772329156;7957.920420795834;8000.839983200303;8055.315298199602;8073.394495412867;837.5812093953024;926.9026752190923;946.3044662173297;1029.763154474475;1046.8168070587617;27721.445571088465;27892.44215115686;28183.43633127326;28327.57508637372;28595.857020714764;1020.5815615597569;1048.6539441984128;1055.2665897201525;1063.361982810323;1076.05844885725;13976;14072.577822665336;14138.293085345691;14163.291835408188;14254.643633909236;363875;368210;368934;369100;374098;50289.497105029215;50577;50795.74602126966;50841.49158508368;51146.74426627843;1334.0928168845278;1336.8997325200648;1341.5371696764796;1344.7377761336445;1357.4366637845183;25886.74113258843;26556.601650975637;26866.462670746867;26875.596866047417;27156.592651109855;41045.794771025954;41574.37638435365;41621.58378416177;41945.1610967785;42012.159756805304;300525;302532;303947;304014;305874;32034.19914502063;41357.79321103375;41765.37351939663;42010.78994605008;42385.57614423816;38053.61946380501;38875.416868746426;39056.41415378715;39247.41128883012;39448.40827387649;32570.34859302848;33320;33442.665573343955;33649.66350336465;33743.32513349768;32791;34849.30301393907;36221.63778362182;36406.635933640326;36422.8178859104;32201.194970125933;32664.51003234906;32897.671023290415;33122.17194570059;33135.83432082824;28729.281767955967;29017.854910725313;30685.23286917845;32835.17912052122;32837.34325313433;24518.63222051635;25239.49521009606;25358.492830142925;25593;27148.1855544334 11:10:09 INFO - PROCESS | 5908 | |2;jquery.html;344.3199680630753;344.9189440481488;345.159536528553;360.142859993216;360.28303675685385;16358.263878125483;17474.737878931825;17820.287188512477;18328.81671183288;18892.527686807836;16523.66952660946;16723.247453864577;16847.91576042118;16924.915375423137;17203.91398043008;4835.806567737286;5000.324956130912;5005.349304590398;5011.473795251501;5014.724190169539;4618.12255671423;4887.951120488803;4952.851414457554;4960.727160006199;4963.057019166365;4969.826056088038;4994.900101997958;5003.449620541737;5007.198848184291;5007.7496125193775;4976.62675299354;4976.676516026465;4982.153033984213;4982.925256121143;5065.468125846806;4979.751012449399;4992.450830408652;5016.3227964224725;5024.221245706921;5028.572571331441;13060.738785224243;13063.085584009123;13156.473741050346;13231.603051908362;17853.28586856537;2013.577148798754;2040.3776848061336;2089.8223650989685;2127.0640917996034;2184.6067707812585;9531.761705957337;9622.951885240598;12106.910378065928;12292.508299668003;12520.749585008249;1714.914254287293;1813.8572699199551;1844.6679597672414;1846.621442604263;1872.447627949758;52866.73566632181;55290.72354638241;56540.999999999585;56722.432775672125;57363.13955290674;10191.23565732573;10214.744631384276;10234.846477302846;10264.692059238234;10372.11836993849;12658.367081645882;12936.741265174644;13023.869761302265;13075.411606477732;13456.259905705085;7293.5259208152365;7372.594507302043;7581.3934885209055;7604.961975190199;7625;7251.093613298338;7285.854282914418;7315.707371705179;7321.963390183121;7381.594012329266;4469.44131983502;4490.483594386687;4502.3921770560555;4503.369528266046;4538.160440318552;1700.1584215813252;1737.4353335166122;1743.625120599052;1762.6298477319906;1763.7336023210114;406.1673569183163;891.8216356728681;928.3687092776842;946.4841661294611;1001.5993602559034;10142.239332049978;10247.077763001365;16501.91749041247;17364.565885852953;18720.438386848415;869.9782505437415;877.7937184761576;909.5997760985146;932.7901222224945;984.2077127912099;8993.955030224806;9006.414583052081;9091.136342047495;9156.771080722901;9320.347575669774;381250;386721;391715;405774.62464939686;410408;70654.64672676603;74303.88544171842;75465;75628.62185689036;76728;1118.7706520163347;1128.7798879218637;1134.1437214902696;1147.0594112827569;1147.6499667601295;15791;15910.920445398162;15922.60193495172;16072.437464689148;16235.269412876685;33864;35674.643253567134;36017.27965440729;37786;37927.43108853314;45081.549184507734;45833;46176;46971;47112.76443617897;9608.327417080738;9815.312928094965;9836.606535738776;9838.60645574169;9937.801243975224;17011.067718075006;17274.740878886576;17527.21127549289;17588.208530616408;17717;13681.110727802661;13831.377588008363;14193;14681.779773303195;14767.483138090116;13833.446662133401;14195.219262940638;14298.21359825178;14613.123212607277;14793.482228122395;14320.14079155254;14350.425982960565;14568.41726330935;14780.33488492999;14878.404863805326;9409.29430292717;9420.858687119562;9512.809743804946;9573.138417542175;9581.808363832824;14124.2937853109;14601.488947886774;14698.485553005594;14918.850811491746;14930.701385972437 11:10:09 INFO - PROCESS | 5908 | |3;mootools.html;1447.8117844680194;1469.1552357394498;1611.7662938873864;1741.4514427955185;1745.8865173763704;7233.24050974648;7243.311885370881;7319.707211711532;7366.042414486109;7414.073240844895;7254.673539690713;7316.853662926738;7347.963260183705;7356.96321518393;7359.705611775523;2199.8790066546335;2230.3309007297826;2232.9330120096424;2239.3393948785147;2240.5854916840435;2203.4381232785618;2258.0516183203013;2271.6706077618737;2275.2946586558137;2275.943101422469;2187.9124835006583;2208.2381578355444;2222.4999375140624;2232.084845213463;2242.686023956647;2261.4459457432954;2273.1021246607497;2279.737830149521;2287.3023727763025;2289.4734211131367;2196.769339219391;2214;2231.977680223193;2237.4853783629856;2240.0703707961175;7143.714251429937;7175.748848790267;7179.89230161548;7192.928070719278;7193.784186474414;4316.848910288156;4372.147431250907;4386.978065109654;4425.513193548707;4431.047324825146;2836.2200394891365;2838.247864315958;2874.425114977013;2879.7120287971243;2882.2362074050393;857.1385757313859;864.8400045991511;888.2228050455851;897.6813231302858;908.1508789282043;9981.900180998242;10097.848532272023;10114.140298074599;10123.595056197742;10132.189424845921;3855.845766169322;3922.3528117860806;3997.1006523532556;3997.400389941474;4000.19996000801;8204.220599043081;8208.794780130545;8212.137725538732;8224.958875205586;8246.05170405399;4407.471103467605;4412.646988240933;4417.823287068545;4421.756803375781;4449.955500444954;3947.8618248361167;3991;4008.498937632796;4014.337634290368;4020.1758639478835;3300.85146168423;3344.832758362072;3362.1930736623035;3383.796972181677;3394.490826376014;1004.7739258666887;1021.3004092196869;1024.533837104116;1027.4092396871679;1039.3607931122306;1051.679237832453;1058.2697938422464;1157.571698471571;1209.8427204463364;1294.7022184897526;6893.620850853151;6931.930680693229;6936.79189624312;6944.236134025253;6944.548604340702;1092.9781404371868;1102.9669109926715;1113.1595645287919;1134.9092072634169;1141.9828702569469;5536.446355364512;5591.944080559224;5605.523530499871;5607.635503692247;5665.631733937281;8529.786755331043;8596.269317108116;8729.781755456037;8744.300455963508;8798.736037918872;8602.827943441096;8713.607887644945;8716.78208044804;8770.25452836516;8791.340649451316;6783.626900520519;6871.347222013901;6875.346842049998;6947.340002699836;7004.3696067354185;6640.535162538576;6683.565568238049;6707.8993815091835;6721.831954201184;6741.662916854236;7611.162772095176;7786.4160187985;7824.765257042298;7840.607969601611;7948.960255198687;7797.220277972157;7941.682332706627;7968.84062318762;8025.357971362394;8069.435139540175;6208.658523781235;6394;6484.805455836333;6509.641969691713;6531.052997315268;6981.5461994970165;7033.120859892513;7047.436205103682;7055.329743674342;7060.34081990742;6453.1610890583925;6489.740410383721;6570.5400621956005;6598.934010660024;6695.966520167368;5969.074793407029;6110.938890611037;6131.816045518642;6223.564350495421;6270.7491700331475;6388.584741991755;6428.967855160694;6429.292777794345;6433.324500927522;6434.8391290218115;5789.797357092481;5842.211301474246;5863.882722345615;5866.911996320144;5889.352171261072;5869.35437101927;5932.822015339547;5945.524358051432;5946.256717910262;5949.702514874326 11:10:09 INFO - PROCESS | 5908 | |4;prototype.html;330.2865809850723;337.340499323822;341.69418370558367;344.99262154508824;349.6782959677097;6312.179416675832;6334.936650633493;6406.2312522497305;6423.64669943153;6469.256035555913;6261.46777523911;6279.905801412971;6314.936850631492;6320.3363646817;6331.77838775643;4798.83204087857;4800.8319708810195;4806.543378379049;4809.158397280479;4817.205161148407;4809.90380192396;4811.59101476375;4816.397950256218;4817.181079216542;4821.879453013667;4641;4745.21703918853;4748.7415834803805;4751.572358487752;4768.23708206687;4722.480527142012;4727.834525791615;4727.929081063787;4735.360726301974;4742.881427964294;4120.793960301973;4178.059936514291;4182.728122672047;4185.246655601991;4187.120704652027;6019.217501724792;6024.186734790791;6036.456718895277;6070.726817293233;6071.362506936796;5517.062099443105;5645.604807663424;5656.971715141398;5666.121751128581;5667.093265077609;6635.86728265432;6682;6689.799306020778;6692.564983276072;6702.731890724365;4682.41469816273;4692.249240121564;4693.178693728584;4694.201985662446;4709.1288111699105;6849.691763870588;6941.583504989666;7007.789766307019;7008.964955175192;7014.789556313319;4670.065986802653;4673.299005149255;4685.625149987993;4690.460597031317;4691.859244222679;4728.621710263171;4740.786664600101;4755.191617425046;4765.523447655276;4768.284757286435;5537.695426751487;5540.889182216333;5541.445855414507;5543.833684989457;5544.500994910478;6616.172978377703;6700.363465470772;6743.561668491532;6753.561018533878;6770.69531871067;1663.9084850333106;1678.3706110208673;1697.830216978317;1706.709859323918;1709.1368858726264;1080.2438293194796;1083.8428427877914;1111.9888801112047;1121.6803211084964;1135.8693750218665;6189.535784816157;6222.191115155091;6274.780382686584;6346.873062538816;6353.269374021954;6837;6879.862402751917;6881;6893.827654308682;6895.55178913369;6164.4143806338325;6305.369463053749;6311.558190926683;6313.305536390993;6315;3723.646253605903;3735.103575142001;3739.8691045813266;3742.5883152853166;3743.47591337213;7082.291770822876;7115.501914865909;7123.643817809192;7149.785506434815;7160.856782864314;6981.2669669684965;7005.92994070063;7058.188308344606;7068.151821781419;7087;7249.528780629348;7269.091363579552;7276.56340619554;7307.050083489006;7322.96338518304;6999.12510936133;7035.929640703732;7042.507024508235;7047.506674532939;7065.258147894603;6789.93210067893;6893;6920.377166055079;6924;6941.236463989058;7224.458165637493;7241.986121943038;7330.266973302841;7376.815579610338;7406.666699998405;4632.189366860854;4670.229412146958;4677.485476597503;4678.017616300479;4691;6910.8617827644175;7020.192677841909;7022.894656580053;7028.472864535078;7041.155061392666;6816.965915170591;6824.249332573314;6829.351211634887;6832.863342733217;6840.11078559804;6820.556663816836;6821.113255276782;6822.11312529368;6827.863442731217;6847.863042739217;6528.477721782151;6684.498662600227;6684.565503242274;6688.83277918056;6689.163854518185;6796.422304104207;6853;6858.794236172923;6866.656667166521;6870.656467176721;6679.966600167162;6680.3987641112535;6689.5986240825705;6691.263960964193;6698.765543205965 11:10:09 INFO - PROCESS | 5908 | |5;yui.html;741.2735519191192;810.3679130278385;816.9845752125299;835.5488036460312;851.4167795060384;13426.865731342683;13583.388747506362;13718;13736.17582945024;13764.242966636844;12615.053870959691;12720.55478058268;12737.554185603505;12758.872411275885;14587.051841630313;821.5974172655416;831.3473922970469;832.9416940814145;835.6406745099605;835.7367429259795;829.2785276809185;837.049948308671;837.4807619276057;838.4172999765166;838.6393850644221;856.3235044314983;862.7023676831515;867.145861326596;868.9000764912021;869.6695255802786;858.0004294996353;862.7886167888907;863.9222469977701;865.074370423647;866.5234121233359;627.5889292513411;633.1326083265955;634.8254230086717;637.2607774981046;640.2668944059026;13841.861581384259;13911.652208694763;13916.860831391657;13954.372053257628;13989.230592317419;11481.196316257781;11481.483333250024;11763.176577639568;12222.449989750394;12867.87132128676;10398.376097434179;10435.79128417435;10496.68509944703;10645.787084258349;10741.946290268499;3453.8100404477746;3457.5159477673146;3502.2645244498685;3547.9645203548152;3590.9281814363567;44741.105177896585;44878.32682509765;45010.54989450096;45107;45162.32256516155;8680.348973826862;9096.1813436791;9138.406003609876;9145.862812057825;9397.718068457958;17496.47510574685;17632.118394080244;17669.38157164493;17753.7336939946;17786;7093.82265443368;7104.786856394317;7292.598907060056;7297.197308296083;7297.379722723628;3825.6174382562076;3865.033741564609;3904.6095390461296;3917.804109794499;4019.537753158366;2991.3269514359095;3046.634403871505;3049.344390955955;3055.663876973531;3060.9540856887165;520.1391696741898;522.193211488244;534.5963797333067;535.234614501267;542.7394850471717;517.5549027836058;640.2636967487334;647.5014239035916;678.2098854834063;682.1405029662661;7160.534565253241;7547.660355284025;7969.641366138538;8156.388270879707;8969.327300452493;548.0737553534514;628.9937100629027;642.7139922734339;647.6891092275735;665.8035879415584;3675.9264814704093;3722.906927326784;3726;3819.2170605025904;3835.4438606401914;55940;56811.14783278254;57144.142837857464;57241;57282.42717572771;44842.77578612086;45613.31580026302;48516.75741621269;53256;55250.72374638101;47166;47503.76248118807;47600.285995710095;47914.760426197645;48321.999999999294;8414.453060551044;8514.531700756517;8582.957085214533;8779.912200877909;9000.954995224982;32977;33398.666013339556;33559.49660755042;34699.13252168716;34766.47850282197;45444.54555454535;45589.088218234785;47060;47100;47637;10662.8400573993;10712.57149714034;11034.889651103385;11070.667879963292;11161.944190279322;11754.647360579196;11769.117316201147;11890.583829565923;11924.701882453008;12744.10791244604;10802.459877006275;10816.459177040959;10965.514166390009;11156.665300041012;11537.653870383901;11367.20429569922;11601.419929003685;11605.245659032136;12070.396480175781;12079.456424460745;11350.432478376213;11635.709107272047;11743.060555155738;12049.277043377426;12073.094517911017;9590.6665011791;9941.353812002197;10201.591936322464;10648.520816563117;10708.411037392707;8652.913470865462;8766.386352955487;8864.468131912106;9092.818143637223;9395.718128456158 11:10:09 INFO - PROCESS | 5908 | __end_tp_report 11:10:09 INFO - PROCESS | 5908 | __start_cc_report 11:10:09 INFO - PROCESS | 5908 | _x_x_mozilla_cycle_collect,317 11:10:09 INFO - PROCESS | 5908 | __end_cc_report 11:10:09 INFO - PROCESS | 5908 | __startTimestamp1451329809114__endTimestamp 11:10:09 INFO - PROCESS | 5908 | 11:10:09 INFO - PROCESS | 5908 | ------- Summary: start ------- 11:10:09 INFO - PROCESS | 5908 | Number of tests: 6 11:10:09 INFO - PROCESS | 5908 | 11:10:09 INFO - PROCESS | 5908 | [#0] dojo.html Cycles:165 Average:5379.24 Median:5600.24 stddev:594.16 (10.6%) stddev-sans-first:570.09 11:10:09 INFO - PROCESS | 5908 | Values: 3167.9 3239.4 3250.7 3271.8 3281.2 5296.0 5319.8 5340.8 5346.2 5349.4 5349.4 5360.2 5384.8 5387.4 5404.5 4644.8 4943.1 5081.4 5103.2 5112.6 4798.4 5002.8 5047.0 5075.6 5117.7 4850.4 4911.4 4956.0 4966.5 4998.9 4933.5 4934.0 4949.9 4971.9 4996.2 4823.7 4888.5 4917.1 4935.2 5012.6 5140.0 5175.5 5218.9 5282.1 5297.9 5760.0 5761.5 5764.7 5766.3 5766.9 5824.2 5828.6 5829.6 5834.7 5839.2 5309.9 5362.2 5392.4 5425.6 5463.2 6020.9 6032.6 6043.5 6046.3 6063.8 5771.9 5800.9 5823.9 5832.8 5835.6 5672.4 5730.8 5742.7 5774.8 5865.6 5777.6 5781.7 5785.7 5787.2 5788.5 5649.1 5764.4 5784.1 5787.8 5795.4 4417.1 4418.9 4453.7 4467.5 4500.5 3981.4 3985.2 3998.0 4023.5 4024.5 5207.1 5404.3 5435.4 5438.1 5447.0 5775.7 5787.2 5813.4 5830.6 5859.6 5383.5 5387.6 5419.5 5420.2 5428.8 4872.3 4873.9 4955.4 5010.7 5053.0 5882.3 5893.3 5895.6 5901.6 5957.0 5788.8 5807.4 5828.3 5849.6 5862.2 5842.3 5932.5 5941.1 5954.2 6012.4 5730.9 5733.8 5734.9 5737.4 5739.2 5752.9 5795.5 5806.2 5808.7 5818.8 5449.8 5592.5 5614.6 5702.8 5718.0 5673.5 5677.1 5688.9 5695.6 5699.7 5591.2 5594.5 5595.8 5600.2 5601.2 5503.1 5633.3 5705.8 5742.6 5812.1 5592.6 5617.9 5621.3 5622.3 5622.6 11:10:09 INFO - PROCESS | 5908 | 11:10:09 INFO - PROCESS | 5908 | [#1] ext.html Cycles:180 Average:47691.18 Median:200048.32 stddev:83368.22 (41.7%) stddev-sans-first:83526.97 11:10:09 INFO - PROCESS | 5908 | Values: 554.1 580.5 584.3 591.2 591.4 35005.6 35395.1 35706.6 35758.5 35813.8 38203.2 38825.2 39012.8 39021.4 39092.2 8352.5 8431.0 8463.3 8527.7 8553.3 8311.5 8400.6 8426.0 8549.1 8649.6 8581.7 8626.0 8688.6 8723.0 8732.0 8517.4 8703.2 8708.5 8712.0 8726.6 8425.0 8611.5 8614.9 8632.3 8641.6 39405.4 39421.4 39718.6 39887.2 40019.2 3193.4 3222.5 3325.3 3415.9 3438.2 29064.6 29376.7 29825.6 30178.8 30553.5 3657.6 3804.1 3836.7 3886.3 3940.9 269241.0 271883.0 273427.0 274057.0 274670.0 56702.7 57427.4 59326.7 59819.0 59882.0 64419.7 65254.0 65379.3 65394.0 65526.3 14343.4 14485.5 14532.3 14568.6 14573.6 10851.0 10900.1 10917.0 10937.6 10941.8 18799.6 18851.7 18858.5 18930.7 19473.3 7705.7 7957.9 8000.8 8055.3 8073.4 837.6 926.9 946.3 1029.8 1046.8 27721.4 27892.4 28183.4 28327.6 28595.9 1020.6 1048.7 1055.3 1063.4 1076.1 13976.0 14072.6 14138.3 14163.3 14254.6 363875.0 368210.0 368934.0 369100.0 374098.0 50289.5 50577.0 50795.7 50841.5 51146.7 1334.1 1336.9 1341.5 1344.7 1357.4 25886.7 26556.6 26866.5 26875.6 27156.6 41045.8 41574.4 41621.6 41945.2 42012.2 300525.0 302532.0 303947.0 304014.0 305874.0 32034.2 41357.8 41765.4 42010.8 42385.6 38053.6 38875.4 39056.4 39247.4 39448.4 32570.3 33320.0 33442.7 33649.7 33743.3 32791.0 34849.3 36221.6 36406.6 36422.8 32201.2 32664.5 32897.7 33122.2 33135.8 28729.3 29017.9 30685.2 32835.2 32837.3 24518.6 25239.5 25358.5 25593.0 27148.2 11:10:09 INFO - PROCESS | 5908 | 11:10:09 INFO - PROCESS | 5908 | [#2] jquery.html Cycles:180 Average:24401.47 Median:18188.78 stddev:64803.84 (356.3%) stddev-sans-first:64960.46 11:10:09 INFO - PROCESS | 5908 | Values: 344.3 344.9 345.2 360.1 360.3 16358.3 17474.7 17820.3 18328.8 18892.5 16523.7 16723.2 16847.9 16924.9 17203.9 4835.8 5000.3 5005.3 5011.5 5014.7 4618.1 4888.0 4952.9 4960.7 4963.1 4969.8 4994.9 5003.4 5007.2 5007.7 4976.6 4976.7 4982.2 4982.9 5065.5 4979.8 4992.5 5016.3 5024.2 5028.6 13060.7 13063.1 13156.5 13231.6 17853.3 2013.6 2040.4 2089.8 2127.1 2184.6 9531.8 9623.0 12106.9 12292.5 12520.7 1714.9 1813.9 1844.7 1846.6 1872.4 52866.7 55290.7 56541.0 56722.4 57363.1 10191.2 10214.7 10234.8 10264.7 10372.1 12658.4 12936.7 13023.9 13075.4 13456.3 7293.5 7372.6 7581.4 7605.0 7625.0 7251.1 7285.9 7315.7 7322.0 7381.6 4469.4 4490.5 4502.4 4503.4 4538.2 1700.2 1737.4 1743.6 1762.6 1763.7 406.2 891.8 928.4 946.5 1001.6 10142.2 10247.1 16501.9 17364.6 18720.4 870.0 877.8 909.6 932.8 984.2 8994.0 9006.4 9091.1 9156.8 9320.3 381250.0 386721.0 391715.0 405774.6 410408.0 70654.6 74303.9 75465.0 75628.6 76728.0 1118.8 1128.8 1134.1 1147.1 1147.6 15791.0 15910.9 15922.6 16072.4 16235.3 33864.0 35674.6 36017.3 37786.0 37927.4 45081.5 45833.0 46176.0 46971.0 47112.8 9608.3 9815.3 9836.6 9838.6 9937.8 17011.1 17274.7 17527.2 17588.2 17717.0 13681.1 13831.4 14193.0 14681.8 14767.5 13833.4 14195.2 14298.2 14613.1 14793.5 14320.1 14350.4 14568.4 14780.3 14878.4 9409.3 9420.9 9512.8 9573.1 9581.8 14124.3 14601.5 14698.5 14918.9 14930.7 11:10:09 INFO - PROCESS | 5908 | 11:10:09 INFO - PROCESS | 5908 | [#3] mootools.html Cycles:180 Average:5104.19 Median:5939.17 stddev:2599.46 (43.8%) stddev-sans-first:2592.22 11:10:09 INFO - PROCESS | 5908 | Values: 1447.8 1469.2 1611.8 1741.5 1745.9 7233.2 7243.3 7319.7 7366.0 7414.1 7254.7 7316.9 7348.0 7357.0 7359.7 2199.9 2230.3 2232.9 2239.3 2240.6 2203.4 2258.1 2271.7 2275.3 2275.9 2187.9 2208.2 2222.5 2232.1 2242.7 2261.4 2273.1 2279.7 2287.3 2289.5 2196.8 2214.0 2232.0 2237.5 2240.1 7143.7 7175.7 7179.9 7192.9 7193.8 4316.8 4372.1 4387.0 4425.5 4431.0 2836.2 2838.2 2874.4 2879.7 2882.2 857.1 864.8 888.2 897.7 908.2 9981.9 10097.8 10114.1 10123.6 10132.2 3855.8 3922.4 3997.1 3997.4 4000.2 8204.2 8208.8 8212.1 8225.0 8246.1 4407.5 4412.6 4417.8 4421.8 4450.0 3947.9 3991.0 4008.5 4014.3 4020.2 3300.9 3344.8 3362.2 3383.8 3394.5 1004.8 1021.3 1024.5 1027.4 1039.4 1051.7 1058.3 1157.6 1209.8 1294.7 6893.6 6931.9 6936.8 6944.2 6944.5 1093.0 1103.0 1113.2 1134.9 1142.0 5536.4 5591.9 5605.5 5607.6 5665.6 8529.8 8596.3 8729.8 8744.3 8798.7 8602.8 8713.6 8716.8 8770.3 8791.3 6783.6 6871.3 6875.3 6947.3 7004.4 6640.5 6683.6 6707.9 6721.8 6741.7 7611.2 7786.4 7824.8 7840.6 7949.0 7797.2 7941.7 7968.8 8025.4 8069.4 6208.7 6394.0 6484.8 6509.6 6531.1 6981.5 7033.1 7047.4 7055.3 7060.3 6453.2 6489.7 6570.5 6598.9 6696.0 5969.1 6110.9 6131.8 6223.6 6270.7 6388.6 6429.0 6429.3 6433.3 6434.8 5789.8 5842.2 5863.9 5866.9 5889.4 5869.4 5932.8 5945.5 5946.3 5949.7 11:10:09 INFO - PROCESS | 5908 | 11:10:09 INFO - PROCESS | 5908 | [#4] prototype.html Cycles:180 Average:5616.33 Median:6314.97 stddev:1717.55 (27.2%) stddev-sans-first:1675.91 11:10:09 INFO - PROCESS | 5908 | Values: 330.3 337.3 341.7 345.0 349.7 6312.2 6334.9 6406.2 6423.6 6469.3 6261.5 6279.9 6314.9 6320.3 6331.8 4798.8 4800.8 4806.5 4809.2 4817.2 4809.9 4811.6 4816.4 4817.2 4821.9 4641.0 4745.2 4748.7 4751.6 4768.2 4722.5 4727.8 4727.9 4735.4 4742.9 4120.8 4178.1 4182.7 4185.2 4187.1 6019.2 6024.2 6036.5 6070.7 6071.4 5517.1 5645.6 5657.0 5666.1 5667.1 6635.9 6682.0 6689.8 6692.6 6702.7 4682.4 4692.2 4693.2 4694.2 4709.1 6849.7 6941.6 7007.8 7009.0 7014.8 4670.1 4673.3 4685.6 4690.5 4691.9 4728.6 4740.8 4755.2 4765.5 4768.3 5537.7 5540.9 5541.4 5543.8 5544.5 6616.2 6700.4 6743.6 6753.6 6770.7 1663.9 1678.4 1697.8 1706.7 1709.1 1080.2 1083.8 1112.0 1121.7 1135.9 6189.5 6222.2 6274.8 6346.9 6353.3 6837.0 6879.9 6881.0 6893.8 6895.6 6164.4 6305.4 6311.6 6313.3 6315.0 3723.6 3735.1 3739.9 3742.6 3743.5 7082.3 7115.5 7123.6 7149.8 7160.9 6981.3 7005.9 7058.2 7068.2 7087.0 7249.5 7269.1 7276.6 7307.1 7323.0 6999.1 7035.9 7042.5 7047.5 7065.3 6789.9 6893.0 6920.4 6924.0 6941.2 7224.5 7242.0 7330.3 7376.8 7406.7 4632.2 4670.2 4677.5 4678.0 4691.0 6910.9 7020.2 7022.9 7028.5 7041.2 6817.0 6824.2 6829.4 6832.9 6840.1 6820.6 6821.1 6822.1 6827.9 6847.9 6528.5 6684.5 6684.6 6688.8 6689.2 6796.4 6853.0 6858.8 6866.7 6870.7 6680.0 6680.4 6689.6 6691.3 6698.8 11:10:09 INFO - PROCESS | 5908 | 11:10:09 INFO - PROCESS | 5908 | [#5] yui.html Cycles:180 Average:13633.24 Median:45601.20 stddev:15788.35 (34.6%) stddev-sans-first:15802.96 11:10:09 INFO - PROCESS | 5908 | Values: 741.3 810.4 817.0 835.5 851.4 13426.9 13583.4 13718.0 13736.2 13764.2 12615.1 12720.6 12737.6 12758.9 14587.1 821.6 831.3 832.9 835.6 835.7 829.3 837.0 837.5 838.4 838.6 856.3 862.7 867.1 868.9 869.7 858.0 862.8 863.9 865.1 866.5 627.6 633.1 634.8 637.3 640.3 13841.9 13911.7 13916.9 13954.4 13989.2 11481.2 11481.5 11763.2 12222.4 12867.9 10398.4 10435.8 10496.7 10645.8 10741.9 3453.8 3457.5 3502.3 3548.0 3590.9 44741.1 44878.3 45010.5 45107.0 45162.3 8680.3 9096.2 9138.4 9145.9 9397.7 17496.5 17632.1 17669.4 17753.7 17786.0 7093.8 7104.8 7292.6 7297.2 7297.4 3825.6 3865.0 3904.6 3917.8 4019.5 2991.3 3046.6 3049.3 3055.7 3061.0 520.1 522.2 534.6 535.2 542.7 517.6 640.3 647.5 678.2 682.1 7160.5 7547.7 7969.6 8156.4 8969.3 548.1 629.0 642.7 647.7 665.8 3675.9 3722.9 3726.0 3819.2 3835.4 55940.0 56811.1 57144.1 57241.0 57282.4 44842.8 45613.3 48516.8 53256.0 55250.7 47166.0 47503.8 47600.3 47914.8 48322.0 8414.5 8514.5 8583.0 8779.9 9001.0 32977.0 33398.7 33559.5 34699.1 34766.5 45444.5 45589.1 47060.0 47100.0 47637.0 10662.8 10712.6 11034.9 11070.7 11161.9 11754.6 11769.1 11890.6 11924.7 12744.1 10802.5 10816.5 10965.5 11156.7 11537.7 11367.2 11601.4 11605.2 12070.4 12079.5 11350.4 11635.7 11743.1 12049.3 12073.1 9590.7 9941.4 10201.6 10648.5 10708.4 8652.9 8766.4 8864.5 9092.8 9395.7 11:10:09 INFO - PROCESS | 5908 | -------- Summary: end -------- 11:10:09 INFO - PROCESS | 5908 | 11:10:09 INFO - TEST-INFO | 5908: exit 0 11:10:09 INFO - TEST-OK | dromaeo_css | took 1110923ms 11:10:09 INFO - TEST-START | kraken 11:10:09 INFO - operating with platform_type : linux_ 11:10:09 INFO - Initialising browser for kraken test... 11:10:09 INFO - TEST-INFO | started process 6151 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGIqg1B/profile http://localhost:35574/getInfo.html) 11:10:13 INFO - PROCESS | 6151 | __metrics Screen width/height:1600/1200 11:10:13 INFO - PROCESS | 6151 | colorDepth:24 11:10:13 INFO - PROCESS | 6151 | Browser inner width/height: 1024/697 11:10:13 INFO - PROCESS | 6151 | __metrics 11:10:14 INFO - PROCESS | 6151 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:10:14 INFO - TEST-INFO | 6151: exit 0 11:10:14 INFO - Browser initialized. 11:10:14 INFO - Running cycle 1/1 for kraken test... 11:10:14 INFO - TEST-INFO | started process 6273 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGIqg1B/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:10:26 INFO - PROCESS | 6273 | RSS: Main: 149491712 11:10:26 INFO - PROCESS | 6273 | 11:10:29 INFO - PROCESS | 6273 | Cycle 1(1): loaded http://localhost:35574/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35574/tests/kraken/driver.html?testName=audio-beat-detection) 11:10:29 INFO - PROCESS | 6273 | RSS: Main: 150474752 11:10:29 INFO - PROCESS | 6273 | 11:10:32 INFO - PROCESS | 6273 | Cycle 1(1): loaded http://localhost:35574/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35574/tests/kraken/driver.html?testName=audio-dft) 11:10:33 INFO - PROCESS | 6273 | RSS: Main: 151826432 11:10:33 INFO - PROCESS | 6273 | 11:10:35 INFO - PROCESS | 6273 | Cycle 1(1): loaded http://localhost:35574/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35574/tests/kraken/driver.html?testName=audio-fft) 11:10:36 INFO - PROCESS | 6273 | RSS: Main: 145977344 11:10:36 INFO - PROCESS | 6273 | 11:10:38 INFO - PROCESS | 6273 | Cycle 1(1): loaded http://localhost:35574/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35574/tests/kraken/driver.html?testName=audio-oscillator) 11:10:39 INFO - PROCESS | 6273 | RSS: Main: 145670144 11:10:39 INFO - PROCESS | 6273 | 11:10:41 INFO - PROCESS | 6273 | Cycle 1(1): loaded http://localhost:35574/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35574/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:10:41 INFO - PROCESS | 6273 | RSS: Main: 146530304 11:10:41 INFO - PROCESS | 6273 | 11:10:44 INFO - PROCESS | 6273 | Cycle 1(1): loaded http://localhost:35574/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35574/tests/kraken/driver.html?testName=imaging-darkroom) 11:10:45 INFO - PROCESS | 6273 | RSS: Main: 146673664 11:10:45 INFO - PROCESS | 6273 | 11:10:48 INFO - PROCESS | 6273 | Cycle 1(1): loaded http://localhost:35574/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35574/tests/kraken/driver.html?testName=imaging-desaturate) 11:10:49 INFO - PROCESS | 6273 | RSS: Main: 147939328 11:10:49 INFO - PROCESS | 6273 | 11:10:52 INFO - PROCESS | 6273 | Cycle 1(1): loaded http://localhost:35574/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35574/tests/kraken/driver.html?testName=json-parse-financial) 11:10:52 INFO - PROCESS | 6273 | RSS: Main: 148246528 11:10:52 INFO - PROCESS | 6273 | 11:10:54 INFO - PROCESS | 6273 | Cycle 1(1): loaded http://localhost:35574/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35574/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:10:54 INFO - PROCESS | 6273 | RSS: Main: 148733952 11:10:54 INFO - PROCESS | 6273 | 11:10:56 INFO - PROCESS | 6273 | Cycle 1(1): loaded http://localhost:35574/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35574/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:10:57 INFO - PROCESS | 6273 | RSS: Main: 148713472 11:10:57 INFO - PROCESS | 6273 | 11:10:59 INFO - PROCESS | 6273 | Cycle 1(1): loaded http://localhost:35574/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35574/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:11:00 INFO - PROCESS | 6273 | RSS: Main: 148631552 11:11:00 INFO - PROCESS | 6273 | 11:11:02 INFO - PROCESS | 6273 | Cycle 1(1): loaded http://localhost:35574/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35574/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:11:03 INFO - PROCESS | 6273 | RSS: Main: 149266432 11:11:03 INFO - PROCESS | 6273 | 11:11:05 INFO - PROCESS | 6273 | Cycle 1(1): loaded http://localhost:35574/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35574/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:11:06 INFO - PROCESS | 6273 | RSS: Main: 147968000 11:11:06 INFO - PROCESS | 6273 | 11:11:07 INFO - PROCESS | 6273 | Cycle 1(1): loaded http://localhost:35574/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35574/tests/kraken/driver.html?testName=ai-astar) 11:11:08 INFO - PROCESS | 6273 | RSS: Main: 147841024 11:11:08 INFO - PROCESS | 6273 | 11:11:08 INFO - PROCESS | 6273 | __start_tp_report 11:11:08 INFO - PROCESS | 6273 | _x_x_mozilla_page_load 11:11:08 INFO - PROCESS | 6273 | _x_x_mozilla_page_load_details 11:11:08 INFO - PROCESS | 6273 | |i|pagename|runs| 11:11:08 INFO - PROCESS | 6273 | |0;ai-astar;111;106;111;110;111;123;113;109;111;110 11:11:08 INFO - PROCESS | 6273 | |1;audio-beat-detection;147;125;146;162;123;151;159;126;160;129 11:11:08 INFO - PROCESS | 6273 | |2;audio-dft;161;165;162;165;166;162;162;166;174;161 11:11:08 INFO - PROCESS | 6273 | |3;audio-fft;71;71;72;71;76;126;72;73;72;72 11:11:08 INFO - PROCESS | 6273 | |4;audio-oscillator;97;97;136;97;96;97;142;97;96;138 11:11:08 INFO - PROCESS | 6273 | |5;imaging-gaussian-blur;110;112;110;110;109;110;109;110;110;110 11:11:08 INFO - PROCESS | 6273 | |6;imaging-darkroom;147;147;146;148;148;147;147;147;146;145 11:11:08 INFO - PROCESS | 6273 | |7;imaging-desaturate;96;97;96;96;96;96;96;97;97;97 11:11:08 INFO - PROCESS | 6273 | |8;json-parse-financial;61;59;60;59;59;60;58;62;63;57 11:11:08 INFO - PROCESS | 6273 | |9;json-stringify-tinderbox;69;70;68;72;69;71;70;70;70;70 11:11:08 INFO - PROCESS | 6273 | |10;stanford-crypto-aes;94;86;87;88;88;93;87;87;86;93 11:11:08 INFO - PROCESS | 6273 | |11;stanford-crypto-ccm;124;120;121;117;121;132;117;115;132;116 11:11:08 INFO - PROCESS | 6273 | |12;stanford-crypto-pbkdf2;163;152;162;168;146;145;148;148;159;139 11:11:08 INFO - PROCESS | 6273 | |13;stanford-crypto-sha256-iterative;67;67;66;71;69;67;68;69;67;66 11:11:08 INFO - PROCESS | 6273 | __end_tp_report 11:11:08 INFO - PROCESS | 6273 | __start_cc_report 11:11:08 INFO - PROCESS | 6273 | _x_x_mozilla_cycle_collect,735 11:11:08 INFO - PROCESS | 6273 | __end_cc_report 11:11:08 INFO - PROCESS | 6273 | __startTimestamp1451329868239__endTimestamp 11:11:08 INFO - PROCESS | 6273 | 11:11:08 INFO - PROCESS | 6273 | ------- Summary: start ------- 11:11:08 INFO - PROCESS | 6273 | Number of tests: 14 11:11:08 INFO - PROCESS | 6273 | 11:11:08 INFO - PROCESS | 6273 | [#0] ai-astar Cycles:10 Average:111.50 Median:111.00 stddev:4.43 (4.0%) stddev-sans-first:4.69 11:11:08 INFO - PROCESS | 6273 | Values: 111.0 106.0 111.0 110.0 111.0 123.0 113.0 109.0 111.0 110.0 11:11:08 INFO - PROCESS | 6273 | 11:11:08 INFO - PROCESS | 6273 | [#1] audio-beat-detection Cycles:10 Average:142.80 Median:149.00 stddev:15.65 (10.5%) stddev-sans-first:16.52 11:11:08 INFO - PROCESS | 6273 | Values: 147.0 125.0 146.0 162.0 123.0 151.0 159.0 126.0 160.0 129.0 11:11:08 INFO - PROCESS | 6273 | 11:11:08 INFO - PROCESS | 6273 | [#2] audio-dft Cycles:10 Average:164.40 Median:165.00 stddev:3.92 (2.4%) stddev-sans-first:3.96 11:11:08 INFO - PROCESS | 6273 | Values: 161.0 165.0 162.0 165.0 166.0 162.0 162.0 166.0 174.0 161.0 11:11:08 INFO - PROCESS | 6273 | 11:11:08 INFO - PROCESS | 6273 | [#3] audio-fft Cycles:10 Average:77.60 Median:72.00 stddev:17.07 (23.7%) stddev-sans-first:17.94 11:11:08 INFO - PROCESS | 6273 | Values: 71.0 71.0 72.0 71.0 76.0 126.0 72.0 73.0 72.0 72.0 11:11:08 INFO - PROCESS | 6273 | 11:11:08 INFO - PROCESS | 6273 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:97.00 stddev:20.32 (20.9%) stddev-sans-first:21.06 11:11:08 INFO - PROCESS | 6273 | Values: 97.0 97.0 136.0 97.0 96.0 97.0 142.0 97.0 96.0 138.0 11:11:08 INFO - PROCESS | 6273 | 11:11:08 INFO - PROCESS | 6273 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 11:11:08 INFO - PROCESS | 6273 | Values: 110.0 112.0 110.0 110.0 109.0 110.0 109.0 110.0 110.0 110.0 11:11:08 INFO - PROCESS | 6273 | 11:11:08 INFO - PROCESS | 6273 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 11:11:08 INFO - PROCESS | 6273 | Values: 147.0 147.0 146.0 148.0 148.0 147.0 147.0 147.0 146.0 145.0 11:11:08 INFO - PROCESS | 6273 | 11:11:08 INFO - PROCESS | 6273 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 11:11:08 INFO - PROCESS | 6273 | Values: 96.0 97.0 96.0 96.0 96.0 96.0 96.0 97.0 97.0 97.0 11:11:08 INFO - PROCESS | 6273 | 11:11:08 INFO - PROCESS | 6273 | [#8] json-parse-financial Cycles:10 Average:59.80 Median:60.00 stddev:1.81 (3.0%) stddev-sans-first:1.87 11:11:08 INFO - PROCESS | 6273 | Values: 61.0 59.0 60.0 59.0 59.0 60.0 58.0 62.0 63.0 57.0 11:11:08 INFO - PROCESS | 6273 | 11:11:08 INFO - PROCESS | 6273 | [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:70.00 stddev:1.10 (1.6%) stddev-sans-first:1.12 11:11:08 INFO - PROCESS | 6273 | Values: 69.0 70.0 68.0 72.0 69.0 71.0 70.0 70.0 70.0 70.0 11:11:08 INFO - PROCESS | 6273 | 11:11:08 INFO - PROCESS | 6273 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:88.00 stddev:3.14 (3.6%) stddev-sans-first:2.74 11:11:08 INFO - PROCESS | 6273 | Values: 94.0 86.0 87.0 88.0 88.0 93.0 87.0 87.0 86.0 93.0 11:11:08 INFO - PROCESS | 6273 | 11:11:08 INFO - PROCESS | 6273 | [#11] stanford-crypto-ccm Cycles:10 Average:121.50 Median:121.00 stddev:6.17 (5.1%) stddev-sans-first:6.48 11:11:08 INFO - PROCESS | 6273 | Values: 124.0 120.0 121.0 117.0 121.0 132.0 117.0 115.0 132.0 116.0 11:11:08 INFO - PROCESS | 6273 | 11:11:08 INFO - PROCESS | 6273 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.00 Median:155.50 stddev:9.44 (6.1%) stddev-sans-first:9.29 11:11:08 INFO - PROCESS | 6273 | Values: 163.0 152.0 162.0 168.0 146.0 145.0 148.0 148.0 159.0 139.0 11:11:08 INFO - PROCESS | 6273 | 11:11:08 INFO - PROCESS | 6273 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:67.50 stddev:1.57 (2.3%) stddev-sans-first:1.64 11:11:08 INFO - PROCESS | 6273 | Values: 67.0 67.0 66.0 71.0 69.0 67.0 68.0 69.0 67.0 66.0 11:11:08 INFO - PROCESS | 6273 | -------- Summary: end -------- 11:11:08 INFO - PROCESS | 6273 | 11:11:09 INFO - TEST-INFO | 6273: exit 0 11:11:09 INFO - TEST-OK | kraken | took 59301ms 11:11:09 INFO - TEST-START | v8_7 11:11:09 INFO - operating with platform_type : linux_ 11:11:09 INFO - Initialising browser for v8_7 test... 11:11:09 INFO - TEST-INFO | started process 6558 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyxR36K/profile http://localhost:35574/getInfo.html) 11:11:13 INFO - PROCESS | 6558 | __metrics Screen width/height:1600/1200 11:11:13 INFO - PROCESS | 6558 | colorDepth:24 11:11:13 INFO - PROCESS | 6558 | Browser inner width/height: 1024/697 11:11:13 INFO - PROCESS | 6558 | __metrics 11:11:13 INFO - PROCESS | 6558 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:11:14 INFO - TEST-INFO | 6558: exit 0 11:11:14 INFO - Browser initialized. 11:11:14 INFO - Running cycle 1/1 for v8_7 test... 11:11:14 INFO - TEST-INFO | started process 6679 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyxR36K/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:11:26 INFO - PROCESS | 6679 | RSS: Main: 149204992 11:11:26 INFO - PROCESS | 6679 | 11:11:47 INFO - PROCESS | 6679 | Cycle 1(1): loaded http://localhost:35574/tests/v8_7/run.html (next: http://localhost:35574/tests/v8_7/run.html) 11:11:47 INFO - PROCESS | 6679 | RSS: Main: 145424384 11:11:47 INFO - PROCESS | 6679 | 11:11:47 INFO - PROCESS | 6679 | __start_tp_report 11:11:47 INFO - PROCESS | 6679 | _x_x_mozilla_page_load 11:11:47 INFO - PROCESS | 6679 | _x_x_mozilla_page_load_details 11:11:47 INFO - PROCESS | 6679 | |i|pagename|runs| 11:11:47 INFO - PROCESS | 6679 | |0;Richards;167.33601070950468 11:11:47 INFO - PROCESS | 6679 | |1;DeltaBlue;189.64536317087047 11:11:47 INFO - PROCESS | 6679 | |2;Encrypt;280.74115665356544 11:11:47 INFO - PROCESS | 6679 | |3;Decrypt;5284.210526315789 11:11:47 INFO - PROCESS | 6679 | |4;RayTrace;1060.4453870625662 11:11:47 INFO - PROCESS | 6679 | |5;Earley;764.525993883792 11:11:47 INFO - PROCESS | 6679 | |6;Boyer;12382.716049382716 11:11:47 INFO - PROCESS | 6679 | |7;RegExp;25475 11:11:47 INFO - PROCESS | 6679 | |8;Splay;652.7415143603133 11:11:47 INFO - PROCESS | 6679 | |9;NavierStokes;4835.748792270531 11:11:47 INFO - PROCESS | 6679 | __end_tp_report 11:11:47 INFO - PROCESS | 6679 | __startTimestamp1451329907885__endTimestamp 11:11:47 INFO - PROCESS | 6679 | 11:11:47 INFO - PROCESS | 6679 | ------- Summary: start ------- 11:11:47 INFO - PROCESS | 6679 | Number of tests: 10 11:11:47 INFO - PROCESS | 6679 | 11:11:47 INFO - PROCESS | 6679 | [#0] Richards Cycles:1 Average:167.34 Median:167.34 stddev:0.00 (0.0%) 11:11:47 INFO - PROCESS | 6679 | Values: 167.3 11:11:47 INFO - PROCESS | 6679 | 11:11:47 INFO - PROCESS | 6679 | [#1] DeltaBlue Cycles:1 Average:189.65 Median:189.65 stddev:0.00 (0.0%) 11:11:47 INFO - PROCESS | 6679 | Values: 189.6 11:11:47 INFO - PROCESS | 6679 | 11:11:47 INFO - PROCESS | 6679 | [#2] Encrypt Cycles:1 Average:280.74 Median:280.74 stddev:0.00 (0.0%) 11:11:47 INFO - PROCESS | 6679 | Values: 280.7 11:11:47 INFO - PROCESS | 6679 | 11:11:47 INFO - PROCESS | 6679 | [#3] Decrypt Cycles:1 Average:5284.21 Median:5284.21 stddev:0.00 (0.0%) 11:11:47 INFO - PROCESS | 6679 | Values: 5284.2 11:11:47 INFO - PROCESS | 6679 | 11:11:47 INFO - PROCESS | 6679 | [#4] RayTrace Cycles:1 Average:1060.45 Median:1060.45 stddev:0.00 (0.0%) 11:11:47 INFO - PROCESS | 6679 | Values: 1060.4 11:11:47 INFO - PROCESS | 6679 | 11:11:47 INFO - PROCESS | 6679 | [#5] Earley Cycles:1 Average:764.53 Median:764.53 stddev:0.00 (0.0%) 11:11:47 INFO - PROCESS | 6679 | Values: 764.5 11:11:47 INFO - PROCESS | 6679 | 11:11:47 INFO - PROCESS | 6679 | [#6] Boyer Cycles:1 Average:12382.72 Median:12382.72 stddev:0.00 (0.0%) 11:11:47 INFO - PROCESS | 6679 | Values: 12382.7 11:11:47 INFO - PROCESS | 6679 | 11:11:47 INFO - PROCESS | 6679 | [#7] RegExp Cycles:1 Average:25475.00 Median:25475.00 stddev:0.00 (0.0%) 11:11:47 INFO - PROCESS | 6679 | Values: 25475.0 11:11:47 INFO - PROCESS | 6679 | 11:11:47 INFO - PROCESS | 6679 | [#8] Splay Cycles:1 Average:652.74 Median:652.74 stddev:0.00 (0.0%) 11:11:47 INFO - PROCESS | 6679 | Values: 652.7 11:11:47 INFO - PROCESS | 6679 | 11:11:47 INFO - PROCESS | 6679 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 11:11:47 INFO - PROCESS | 6679 | Values: 4835.7 11:11:47 INFO - PROCESS | 6679 | -------- Summary: end -------- 11:11:47 INFO - PROCESS | 6679 | 11:11:48 INFO - TEST-INFO | 6679: exit 0 11:11:48 INFO - TEST-OK | v8_7 | took 39659ms 11:11:48 INFO - SUITE-END | took 1209s 11:11:48 INFO - Completed test suite (00:20:10) 11:11:48 INFO - Working with test: dromaeo_css 11:11:48 INFO - Generating results file: dromaeo_css 11:11:48 INFO - Working with test: kraken 11:11:48 INFO - Generating results file: kraken 11:11:48 INFO - javascript benchmark 11:11:48 INFO - Working with test: v8_7 11:11:48 INFO - Generating results file: v8_7 11:11:48 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:11:48 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 11:11:48 INFO - process_Request line: dromaeo_css 6929.32 graph.html#tests=[[72,64,43]] 11:11:48 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:11:49 INFO - process_Request line: kraken 1519.60 graph.html#tests=[[232,64,43]] 11:11:49 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:11:49 INFO - process_Request line: v8_7 20965.58 graph.html#tests=[[230,64,43]] 11:11:49 INFO - RETURN: dromaeo_css: 6929.32 11:11:49 INFO - RETURN: kraken: 1519.60 11:11:49 INFO - RETURN: v8_7: 20965.58 11:11:49 INFO - javascript benchmark 11:11:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3167.9366412671748, 3239.416904957107, 3250.739940804736, 3271.7546184036205, 3281.245313577877, 5295.973520132398, 5319.813806516768, 5340.813071542492, 5346.198070289459, 5349.358077030752, 5349.438308977559, 5360.195970604412, 5384.838454846351, 5387.353517577896, 5404.540614047811, 4644.767761611923, 4943.085529177105, 5081.390233172025, 5103.209002604603, 5112.616553758465, 4798.448178459487, 5002.8249011284615, 5047.0, 5075.593952483792, 5117.744112794364, 4850.417949846006, 4911.435184953741, 4955.950440495585, 4966.503349665005, 4998.925016124761, 4933.481984391659, 4933.975330123362, 4949.876253093701, 4971.900561988776, 4996.200607902718, 4823.710577365334, 4888.511148885119, 4917.139500587383, 4935.185694360426, 5012.598992080625, 5140.023395554833, 5175.534201921808, 5218.947810521884, 5282.102042652758, 5297.920531192035, 5759.971200143972, 5761.510271626917, 5764.682942438164, 5766.279215098113, 5766.88466230673, 5824.242848429677, 5828.5628577856405, 5829.621074630136, 5834.708264586796, 5839.182514447981, 5309.893802123975, 5362.195670649395, 5392.4337944515655, 5425.6202065855405, 5463.235147079412, 6020.939790602038, 6032.638041717511, 6043.516518678583, 6046.3046749624355, 6063.787767428119, 5771.8557036074435, 5800.9129863052085, 5823.88352232953, 5832.766689332379, 5835.562332825055, 5672.404397538199, 5730.828075157752, 5742.6554406734895, 5774.797882074107, 5865.618734782311, 5777.62445441045, 5781.71091445426, 5785.739641716133, 5787.189793428839, 5788.53691704671, 5649.12438572022, 5764.423557644202, 5784.1034639630925, 5787.826365209051, 5795.391483894215, 4417.1386579616665, 4418.911621767546, 4453.665975051884, 4467.463904331436, 4500.549945005539, 3981.3629819228786, 3985.1631157456677, 3997.980010099989, 4023.4970628671417, 4024.517057953006, 5207.140821764442, 5404.270423492857, 5435.402105768362, 5438.129899216106, 5447.0, 5775.653460792366, 5787.2187254720075, 5813.389594092644, 5830.62100963436, 5859.560532960045, 5383.542398896059, 5387.649802762808, 5419.539339156216, 5420.214068959979, 5428.75570599324, 4872.293517440023, 4873.878153046202, 4955.380577427822, 5010.724410157476, 5053.0, 5882.323532793698, 5893.322267939242, 5895.587308888336, 5901.5868889177345, 5957.017092179828, 5788.797392091256, 5807.390224026585, 5828.300603927556, 5849.561282903885, 5862.179294898803, 5842.298924129132, 5932.466078052996, 5941.079132734433, 5954.19618351517, 6012.428819262163, 5730.914036289542, 5733.770649173986, 5734.913976290442, 5737.397573254915, 5739.167820666064, 5752.884942301214, 5795.536357091339, 5806.187133801355, 5808.651480911159, 5818.796342128006, 5449.836504904859, 5592.468715472024, 5614.5789065821045, 5702.7718891243885, 5717.971410142923, 5673.489385955284, 5677.091665333527, 5688.886222275614, 5695.601307908407, 5699.658020518782, 5591.189277554813, 5594.496495315441, 5595.804146854841, 5600.243967064557, 5601.159826026129, 5503.147012213113, 5633.295838020247, 5705.771769129355, 5742.569307302053, 5812.099124635688, 5592.580556458201, 5617.915731263953, 5621.269234999588, 5622.32532096151, 5622.5501959842295], "unit": "score", "name": "dojo.html", "value": 5341.006788963366}, {"lowerIsBetter": false, "replicates": [554.1203699257652, 580.4630716587158, 584.2813339592301, 591.1635036423461, 591.3879135095171, 35005.64994350056, 35395.11512212196, 35706.642933570656, 35758.463623045674, 35813.820930895345, 38203.23593528128, 38825.223495530074, 39012.80493597528, 39021.41467877977, 39092.21815563687, 8352.540610266433, 8431.030431500363, 8463.322934165251, 8527.658893644279, 8553.272971797405, 8311.501309921394, 8400.579971001456, 8426.0, 8549.145085491464, 8649.610767515476, 8581.656733730642, 8626.0, 8688.56557172142, 8722.956385218065, 8732.039475657673, 8517.403781735282, 8703.216710496086, 8708.521031343274, 8712.0, 8726.607302671395, 8425.0, 8611.526366049864, 8614.87077693835, 8632.266257368132, 8641.611127499278, 39405.40891886624, 39421.40867886984, 39718.602813972066, 39887.20225595472, 40019.199616007514, 3193.393255281489, 3222.4521831288503, 3325.285063711314, 3415.9146021349416, 3438.1748380388776, 29064.564031539543, 29376.70623293761, 29825.552616710767, 30178.84910575455, 30553.54169687434, 3657.617457536589, 3804.1182288534487, 3836.693064554829, 3886.261610294035, 3940.8817735467696, 269241.0, 271883.0, 273427.0, 274057.0, 274670.0, 56702.7164864173, 57427.42572574304, 59326.70336648289, 59819.0, 59882.0, 64419.677901610194, 65254.0, 65379.34620653828, 65394.0, 65526.34473655298, 14343.426262949573, 14485.493007744679, 14532.27338633064, 14568.63578410527, 14573.562793116223, 10851.023407893328, 10900.127989760958, 10917.0, 10937.56249750001, 10941.83587246192, 18799.624007519775, 18851.71722424165, 18858.52853678669, 18930.716039259423, 19473.318433854747, 7705.691772329156, 7957.920420795834, 8000.839983200303, 8055.315298199602, 8073.394495412867, 837.5812093953024, 926.9026752190923, 946.3044662173297, 1029.763154474475, 1046.8168070587617, 27721.445571088465, 27892.44215115686, 28183.43633127326, 28327.57508637372, 28595.857020714764, 1020.5815615597569, 1048.6539441984128, 1055.2665897201525, 1063.361982810323, 1076.05844885725, 13976.0, 14072.577822665336, 14138.293085345691, 14163.291835408188, 14254.643633909236, 363875.0, 368210.0, 368934.0, 369100.0, 374098.0, 50289.497105029215, 50577.0, 50795.74602126966, 50841.49158508368, 51146.74426627843, 1334.0928168845278, 1336.8997325200648, 1341.5371696764796, 1344.7377761336445, 1357.4366637845183, 25886.74113258843, 26556.601650975637, 26866.462670746867, 26875.596866047417, 27156.592651109855, 41045.794771025954, 41574.37638435365, 41621.58378416177, 41945.1610967785, 42012.159756805304, 300525.0, 302532.0, 303947.0, 304014.0, 305874.0, 32034.19914502063, 41357.79321103375, 41765.37351939663, 42010.78994605008, 42385.57614423816, 38053.61946380501, 38875.416868746426, 39056.41415378715, 39247.41128883012, 39448.40827387649, 32570.34859302848, 33320.0, 33442.665573343955, 33649.66350336465, 33743.32513349768, 32791.0, 34849.30301393907, 36221.63778362182, 36406.635933640326, 36422.8178859104, 32201.194970125933, 32664.51003234906, 32897.671023290415, 33122.17194570059, 33135.83432082824, 28729.281767955967, 29017.854910725313, 30685.23286917845, 32835.17912052122, 32837.34325313433, 24518.63222051635, 25239.49521009606, 25358.492830142925, 25593.0, 27148.1855544334], "unit": "score", "name": "ext.html", "value": 18184.63003151409}, {"lowerIsBetter": false, "replicates": [344.3199680630753, 344.9189440481488, 345.159536528553, 360.142859993216, 360.28303675685385, 16358.263878125483, 17474.737878931825, 17820.287188512477, 18328.81671183288, 18892.527686807836, 16523.66952660946, 16723.247453864577, 16847.91576042118, 16924.915375423137, 17203.91398043008, 4835.806567737286, 5000.324956130912, 5005.349304590398, 5011.473795251501, 5014.724190169539, 4618.12255671423, 4887.951120488803, 4952.851414457554, 4960.727160006199, 4963.057019166365, 4969.826056088038, 4994.900101997958, 5003.449620541737, 5007.198848184291, 5007.7496125193775, 4976.62675299354, 4976.676516026465, 4982.153033984213, 4982.925256121143, 5065.468125846806, 4979.751012449399, 4992.450830408652, 5016.3227964224725, 5024.221245706921, 5028.572571331441, 13060.738785224243, 13063.085584009123, 13156.473741050346, 13231.603051908362, 17853.28586856537, 2013.577148798754, 2040.3776848061336, 2089.8223650989685, 2127.0640917996034, 2184.6067707812585, 9531.761705957337, 9622.951885240598, 12106.910378065928, 12292.508299668003, 12520.749585008249, 1714.914254287293, 1813.8572699199551, 1844.6679597672414, 1846.621442604263, 1872.447627949758, 52866.73566632181, 55290.72354638241, 56540.999999999585, 56722.432775672125, 57363.13955290674, 10191.23565732573, 10214.744631384276, 10234.846477302846, 10264.692059238234, 10372.11836993849, 12658.367081645882, 12936.741265174644, 13023.869761302265, 13075.411606477732, 13456.259905705085, 7293.5259208152365, 7372.594507302043, 7581.3934885209055, 7604.961975190199, 7625.0, 7251.093613298338, 7285.854282914418, 7315.707371705179, 7321.963390183121, 7381.594012329266, 4469.44131983502, 4490.483594386687, 4502.3921770560555, 4503.369528266046, 4538.160440318552, 1700.1584215813252, 1737.4353335166122, 1743.625120599052, 1762.6298477319906, 1763.7336023210114, 406.1673569183163, 891.8216356728681, 928.3687092776842, 946.4841661294611, 1001.5993602559034, 10142.239332049978, 10247.077763001365, 16501.91749041247, 17364.565885852953, 18720.438386848415, 869.9782505437415, 877.7937184761576, 909.5997760985146, 932.7901222224945, 984.2077127912099, 8993.955030224806, 9006.414583052081, 9091.136342047495, 9156.771080722901, 9320.347575669774, 381250.0, 386721.0, 391715.0, 405774.62464939686, 410408.0, 70654.64672676603, 74303.88544171842, 75465.0, 75628.62185689036, 76728.0, 1118.7706520163347, 1128.7798879218637, 1134.1437214902696, 1147.0594112827569, 1147.6499667601295, 15791.0, 15910.920445398162, 15922.60193495172, 16072.437464689148, 16235.269412876685, 33864.0, 35674.643253567134, 36017.27965440729, 37786.0, 37927.43108853314, 45081.549184507734, 45833.0, 46176.0, 46971.0, 47112.76443617897, 9608.327417080738, 9815.312928094965, 9836.606535738776, 9838.60645574169, 9937.801243975224, 17011.067718075006, 17274.740878886576, 17527.21127549289, 17588.208530616408, 17717.0, 13681.110727802661, 13831.377588008363, 14193.0, 14681.779773303195, 14767.483138090116, 13833.446662133401, 14195.219262940638, 14298.21359825178, 14613.123212607277, 14793.482228122395, 14320.14079155254, 14350.425982960565, 14568.41726330935, 14780.33488492999, 14878.404863805326, 9409.29430292717, 9420.858687119562, 9512.809743804946, 9573.138417542175, 9581.808363832824, 14124.2937853109, 14601.488947886774, 14698.485553005594, 14918.850811491746, 14930.701385972437], "unit": "score", "name": "jquery.html", "value": 8576.41382349995}, {"lowerIsBetter": false, "replicates": [1447.8117844680194, 1469.1552357394498, 1611.7662938873864, 1741.4514427955185, 1745.8865173763704, 7233.24050974648, 7243.311885370881, 7319.707211711532, 7366.042414486109, 7414.073240844895, 7254.673539690713, 7316.853662926738, 7347.963260183705, 7356.96321518393, 7359.705611775523, 2199.8790066546335, 2230.3309007297826, 2232.9330120096424, 2239.3393948785147, 2240.5854916840435, 2203.4381232785618, 2258.0516183203013, 2271.6706077618737, 2275.2946586558137, 2275.943101422469, 2187.9124835006583, 2208.2381578355444, 2222.4999375140624, 2232.084845213463, 2242.686023956647, 2261.4459457432954, 2273.1021246607497, 2279.737830149521, 2287.3023727763025, 2289.4734211131367, 2196.769339219391, 2214.0, 2231.977680223193, 2237.4853783629856, 2240.0703707961175, 7143.714251429937, 7175.748848790267, 7179.89230161548, 7192.928070719278, 7193.784186474414, 4316.848910288156, 4372.147431250907, 4386.978065109654, 4425.513193548707, 4431.047324825146, 2836.2200394891365, 2838.247864315958, 2874.425114977013, 2879.7120287971243, 2882.2362074050393, 857.1385757313859, 864.8400045991511, 888.2228050455851, 897.6813231302858, 908.1508789282043, 9981.900180998242, 10097.848532272023, 10114.140298074599, 10123.595056197742, 10132.189424845921, 3855.845766169322, 3922.3528117860806, 3997.1006523532556, 3997.400389941474, 4000.19996000801, 8204.220599043081, 8208.794780130545, 8212.137725538732, 8224.958875205586, 8246.05170405399, 4407.471103467605, 4412.646988240933, 4417.823287068545, 4421.756803375781, 4449.955500444954, 3947.8618248361167, 3991.0, 4008.498937632796, 4014.337634290368, 4020.1758639478835, 3300.85146168423, 3344.832758362072, 3362.1930736623035, 3383.796972181677, 3394.490826376014, 1004.7739258666887, 1021.3004092196869, 1024.533837104116, 1027.4092396871679, 1039.3607931122306, 1051.679237832453, 1058.2697938422464, 1157.571698471571, 1209.8427204463364, 1294.7022184897526, 6893.620850853151, 6931.930680693229, 6936.79189624312, 6944.236134025253, 6944.548604340702, 1092.9781404371868, 1102.9669109926715, 1113.1595645287919, 1134.9092072634169, 1141.9828702569469, 5536.446355364512, 5591.944080559224, 5605.523530499871, 5607.635503692247, 5665.631733937281, 8529.786755331043, 8596.269317108116, 8729.781755456037, 8744.300455963508, 8798.736037918872, 8602.827943441096, 8713.607887644945, 8716.78208044804, 8770.25452836516, 8791.340649451316, 6783.626900520519, 6871.347222013901, 6875.346842049998, 6947.340002699836, 7004.3696067354185, 6640.535162538576, 6683.565568238049, 6707.8993815091835, 6721.831954201184, 6741.662916854236, 7611.162772095176, 7786.4160187985, 7824.765257042298, 7840.607969601611, 7948.960255198687, 7797.220277972157, 7941.682332706627, 7968.84062318762, 8025.357971362394, 8069.435139540175, 6208.658523781235, 6394.0, 6484.805455836333, 6509.641969691713, 6531.052997315268, 6981.5461994970165, 7033.120859892513, 7047.436205103682, 7055.329743674342, 7060.34081990742, 6453.1610890583925, 6489.740410383721, 6570.5400621956005, 6598.934010660024, 6695.966520167368, 5969.074793407029, 6110.938890611037, 6131.816045518642, 6223.564350495421, 6270.7491700331475, 6388.584741991755, 6428.967855160694, 6429.292777794345, 6433.324500927522, 6434.8391290218115, 5789.797357092481, 5842.211301474246, 5863.882722345615, 5866.911996320144, 5889.352171261072, 5869.35437101927, 5932.822015339547, 5945.524358051432, 5946.256717910262, 5949.702514874326], "unit": "score", "name": "mootools.html", "value": 4225.705713364795}, {"lowerIsBetter": false, "replicates": [330.2865809850723, 337.340499323822, 341.69418370558367, 344.99262154508824, 349.6782959677097, 6312.179416675832, 6334.936650633493, 6406.2312522497305, 6423.64669943153, 6469.256035555913, 6261.46777523911, 6279.905801412971, 6314.936850631492, 6320.3363646817, 6331.77838775643, 4798.83204087857, 4800.8319708810195, 4806.543378379049, 4809.158397280479, 4817.205161148407, 4809.90380192396, 4811.59101476375, 4816.397950256218, 4817.181079216542, 4821.879453013667, 4641.0, 4745.21703918853, 4748.7415834803805, 4751.572358487752, 4768.23708206687, 4722.480527142012, 4727.834525791615, 4727.929081063787, 4735.360726301974, 4742.881427964294, 4120.793960301973, 4178.059936514291, 4182.728122672047, 4185.246655601991, 4187.120704652027, 6019.217501724792, 6024.186734790791, 6036.456718895277, 6070.726817293233, 6071.362506936796, 5517.062099443105, 5645.604807663424, 5656.971715141398, 5666.121751128581, 5667.093265077609, 6635.86728265432, 6682.0, 6689.799306020778, 6692.564983276072, 6702.731890724365, 4682.41469816273, 4692.249240121564, 4693.178693728584, 4694.201985662446, 4709.1288111699105, 6849.691763870588, 6941.583504989666, 7007.789766307019, 7008.964955175192, 7014.789556313319, 4670.065986802653, 4673.299005149255, 4685.625149987993, 4690.460597031317, 4691.859244222679, 4728.621710263171, 4740.786664600101, 4755.191617425046, 4765.523447655276, 4768.284757286435, 5537.695426751487, 5540.889182216333, 5541.445855414507, 5543.833684989457, 5544.500994910478, 6616.172978377703, 6700.363465470772, 6743.561668491532, 6753.561018533878, 6770.69531871067, 1663.9084850333106, 1678.3706110208673, 1697.830216978317, 1706.709859323918, 1709.1368858726264, 1080.2438293194796, 1083.8428427877914, 1111.9888801112047, 1121.6803211084964, 1135.8693750218665, 6189.535784816157, 6222.191115155091, 6274.780382686584, 6346.873062538816, 6353.269374021954, 6837.0, 6879.862402751917, 6881.0, 6893.827654308682, 6895.55178913369, 6164.4143806338325, 6305.369463053749, 6311.558190926683, 6313.305536390993, 6315.0, 3723.646253605903, 3735.103575142001, 3739.8691045813266, 3742.5883152853166, 3743.47591337213, 7082.291770822876, 7115.501914865909, 7123.643817809192, 7149.785506434815, 7160.856782864314, 6981.2669669684965, 7005.92994070063, 7058.188308344606, 7068.151821781419, 7087.0, 7249.528780629348, 7269.091363579552, 7276.56340619554, 7307.050083489006, 7322.96338518304, 6999.12510936133, 7035.929640703732, 7042.507024508235, 7047.506674532939, 7065.258147894603, 6789.93210067893, 6893.0, 6920.377166055079, 6924.0, 6941.236463989058, 7224.458165637493, 7241.986121943038, 7330.266973302841, 7376.815579610338, 7406.666699998405, 4632.189366860854, 4670.229412146958, 4677.485476597503, 4678.017616300479, 4691.0, 6910.8617827644175, 7020.192677841909, 7022.894656580053, 7028.472864535078, 7041.155061392666, 6816.965915170591, 6824.249332573314, 6829.351211634887, 6832.863342733217, 6840.11078559804, 6820.556663816836, 6821.113255276782, 6822.11312529368, 6827.863442731217, 6847.863042739217, 6528.477721782151, 6684.498662600227, 6684.565503242274, 6688.83277918056, 6689.163854518185, 6796.422304104207, 6853.0, 6858.794236172923, 6866.656667166521, 6870.656467176721, 6679.966600167162, 6680.3987641112535, 6689.5986240825705, 6691.263960964193, 6698.765543205965], "unit": "score", "name": "prototype.html", "value": 5050.842015212911}, {"lowerIsBetter": false, "replicates": [741.2735519191192, 810.3679130278385, 816.9845752125299, 835.5488036460312, 851.4167795060384, 13426.865731342683, 13583.388747506362, 13718.0, 13736.17582945024, 13764.242966636844, 12615.053870959691, 12720.55478058268, 12737.554185603505, 12758.872411275885, 14587.051841630313, 821.5974172655416, 831.3473922970469, 832.9416940814145, 835.6406745099605, 835.7367429259795, 829.2785276809185, 837.049948308671, 837.4807619276057, 838.4172999765166, 838.6393850644221, 856.3235044314983, 862.7023676831515, 867.145861326596, 868.9000764912021, 869.6695255802786, 858.0004294996353, 862.7886167888907, 863.9222469977701, 865.074370423647, 866.5234121233359, 627.5889292513411, 633.1326083265955, 634.8254230086717, 637.2607774981046, 640.2668944059026, 13841.861581384259, 13911.652208694763, 13916.860831391657, 13954.372053257628, 13989.230592317419, 11481.196316257781, 11481.483333250024, 11763.176577639568, 12222.449989750394, 12867.87132128676, 10398.376097434179, 10435.79128417435, 10496.68509944703, 10645.787084258349, 10741.946290268499, 3453.8100404477746, 3457.5159477673146, 3502.2645244498685, 3547.9645203548152, 3590.9281814363567, 44741.105177896585, 44878.32682509765, 45010.54989450096, 45107.0, 45162.32256516155, 8680.348973826862, 9096.1813436791, 9138.406003609876, 9145.862812057825, 9397.718068457958, 17496.47510574685, 17632.118394080244, 17669.38157164493, 17753.7336939946, 17786.0, 7093.82265443368, 7104.786856394317, 7292.598907060056, 7297.197308296083, 7297.379722723628, 3825.6174382562076, 3865.033741564609, 3904.6095390461296, 3917.804109794499, 4019.537753158366, 2991.3269514359095, 3046.634403871505, 3049.344390955955, 3055.663876973531, 3060.9540856887165, 520.1391696741898, 522.193211488244, 534.5963797333067, 535.234614501267, 542.7394850471717, 517.5549027836058, 640.2636967487334, 647.5014239035916, 678.2098854834063, 682.1405029662661, 7160.534565253241, 7547.660355284025, 7969.641366138538, 8156.388270879707, 8969.327300452493, 548.0737553534514, 628.9937100629027, 642.7139922734339, 647.6891092275735, 665.8035879415584, 3675.9264814704093, 3722.906927326784, 3726.0, 3819.2170605025904, 3835.4438606401914, 55940.0, 56811.14783278254, 57144.142837857464, 57241.0, 57282.42717572771, 44842.77578612086, 45613.31580026302, 48516.75741621269, 53256.0, 55250.72374638101, 47166.0, 47503.76248118807, 47600.285995710095, 47914.760426197645, 48321.999999999294, 8414.453060551044, 8514.531700756517, 8582.957085214533, 8779.912200877909, 9000.954995224982, 32977.0, 33398.666013339556, 33559.49660755042, 34699.13252168716, 34766.47850282197, 45444.54555454535, 45589.088218234785, 47060.0, 47100.0, 47637.0, 10662.8400573993, 10712.57149714034, 11034.889651103385, 11070.667879963292, 11161.944190279322, 11754.647360579196, 11769.117316201147, 11890.583829565923, 11924.701882453008, 12744.10791244604, 10802.459877006275, 10816.459177040959, 10965.514166390009, 11156.665300041012, 11537.653870383901, 11367.20429569922, 11601.419929003685, 11605.245659032136, 12070.396480175781, 12079.456424460745, 11350.432478376213, 11635.709107272047, 11743.060555155738, 12049.277043377426, 12073.094517911017, 9590.6665011791, 9941.353812002197, 10201.591936322464, 10648.520816563117, 10708.411037392707, 8652.913470865462, 8766.386352955487, 8864.468131912106, 9092.818143637223, 9395.718128456158], "unit": "score", "name": "yui.html", "value": 6225.987116232615}], "name": "dromaeo_css", "value": 6929.317766678097}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 111.0, 110.0, 111.0, 123.0, 113.0, 109.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [147.0, 125.0, 146.0, 162.0, 123.0, 151.0, 159.0, 126.0, 160.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 142.8}, {"lowerIsBetter": true, "replicates": [161.0, 165.0, 162.0, 165.0, 166.0, 162.0, 162.0, 166.0, 174.0, 161.0], "unit": "score", "name": "audio-dft", "value": 164.4}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 72.0, 71.0, 76.0, 126.0, 72.0, 73.0, 72.0, 72.0], "unit": "score", "name": "audio-fft", "value": 77.6}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 136.0, 97.0, 96.0, 97.0, 142.0, 97.0, 96.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 109.3}, {"lowerIsBetter": true, "replicates": [110.0, 112.0, 110.0, 110.0, 109.0, 110.0, 109.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 148.0, 148.0, 147.0, 147.0, 147.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [61.0, 59.0, 60.0, 59.0, 59.0, 60.0, 58.0, 62.0, 63.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 59.8}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 68.0, 72.0, 69.0, 71.0, 70.0, 70.0, 70.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.9}, {"lowerIsBetter": true, "replicates": [94.0, 86.0, 87.0, 88.0, 88.0, 93.0, 87.0, 87.0, 86.0, 93.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.9}, {"lowerIsBetter": true, "replicates": [124.0, 120.0, 121.0, 117.0, 121.0, 132.0, 117.0, 115.0, 132.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.5}, {"lowerIsBetter": true, "replicates": [163.0, 152.0, 162.0, 168.0, 146.0, 145.0, 148.0, 148.0, 159.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.0}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 71.0, 69.0, 67.0, 68.0, 69.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.7}], "name": "kraken", "value": 1519.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.33601070950468], "unit": "score", "name": "Richards", "value": 210.96475200000003}, {"lowerIsBetter": false, "replicates": [189.64536317087047], "unit": "score", "name": "DeltaBlue", "value": 348.64021400000007}, {"lowerIsBetter": false, "replicates": [280.74115665356544], "unit": "score", "name": "Encrypt", "value": 948.136722}, {"lowerIsBetter": false, "replicates": [5284.210526315789], "unit": "score", "name": "Decrypt", "value": 50.37289840637447}, {"lowerIsBetter": false, "replicates": [1060.4453870625662], "unit": "score", "name": "RayTrace", "value": 697.809627}, {"lowerIsBetter": false, "replicates": [764.525993883792], "unit": "score", "name": "Earley", "value": 871.7336039999999}, {"lowerIsBetter": false, "replicates": [12382.716049382716], "unit": "score", "name": "Boyer", "value": 53.822036889332054}, {"lowerIsBetter": false, "replicates": [25475.0], "unit": "score", "name": "RegExp", "value": 35.759960745829254}, {"lowerIsBetter": false, "replicates": [652.7415143603133], "unit": "score", "name": "Splay", "value": 124.844212}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20965.583615475283}]} 11:11:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20965.58"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1519.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6929.32"}}} 11:11:49 INFO - Return code: 0 11:11:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:11:49 INFO - # TBPL SUCCESS # 11:11:49 INFO - Running post-action listener: _resource_record_post_action 11:11:49 INFO - Running post-run listener: _resource_record_post_run 11:11:50 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 4096; Write bytes: 555573248; Read time: 8; Write time: 432364 11:11:50 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 235401216; Read time: 0; Write time: 276624 11:11:50 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 320172032; Read time: 8; Write time: 155740 11:11:50 INFO - Running post-run listener: _upload_blobber_files 11:11:50 INFO - Blob upload gear active. 11:11:50 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:11:50 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 11:11:50 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'] 11:11:50 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 11:11:50 INFO - (blobuploader) - INFO - Open directory for files ... 11:11:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:11:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:11:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:51 INFO - (blobuploader) - INFO - Done attempting. 11:11:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:11:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:11:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:52 INFO - (blobuploader) - INFO - Done attempting. 11:11:52 INFO - (blobuploader) - INFO - Iteration through files over. 11:11:52 INFO - Return code: 0 11:11:52 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:11:52 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:11:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b515a8d2813cc3ce094487156122dbf84b039aa5da10014bb3f7218b71bc8f453dfd30d533905ee9f436ef5eafbfaa12adcdce7a5067de03d4bdb66effe59ec0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e6e78e225ce3b876edd87f764eb0ad1d7e22a001dd72027d79ebf7dca2ccb71e197251ab779a07329f8a9d77ee458e9d90800c35dc93a70d0fe10d1131c10e2d"} 11:11:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:11:52 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:11:52 INFO - Contents: 11:11:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b515a8d2813cc3ce094487156122dbf84b039aa5da10014bb3f7218b71bc8f453dfd30d533905ee9f436ef5eafbfaa12adcdce7a5067de03d4bdb66effe59ec0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e6e78e225ce3b876edd87f764eb0ad1d7e22a001dd72027d79ebf7dca2ccb71e197251ab779a07329f8a9d77ee458e9d90800c35dc93a70d0fe10d1131c10e2d"} 11:11:52 INFO - Copying logs to upload dir... 11:11:52 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1281.975420 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2015-12-28 11:11:51.983122) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-28 11:11:51.989017) ========= 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=5752742a61d0f534093fa7a9000001cb-1451326719.791254-2040881002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b515a8d2813cc3ce094487156122dbf84b039aa5da10014bb3f7218b71bc8f453dfd30d533905ee9f436ef5eafbfaa12adcdce7a5067de03d4bdb66effe59ec0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e6e78e225ce3b876edd87f764eb0ad1d7e22a001dd72027d79ebf7dca2ccb71e197251ab779a07329f8a9d77ee458e9d90800c35dc93a70d0fe10d1131c10e2d"} build_url:https://queue.taskcluster.net/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011361 build_url: 'https://queue.taskcluster.net/v1/task/7spQg9DMR0WB6z602ZU4Zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b515a8d2813cc3ce094487156122dbf84b039aa5da10014bb3f7218b71bc8f453dfd30d533905ee9f436ef5eafbfaa12adcdce7a5067de03d4bdb66effe59ec0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e6e78e225ce3b876edd87f764eb0ad1d7e22a001dd72027d79ebf7dca2ccb71e197251ab779a07329f8a9d77ee458e9d90800c35dc93a70d0fe10d1131c10e2d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-28 11:11:52.014210) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 11:11:52.014565) ========= 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=5752742a61d0f534093fa7a9000001cb-1451326719.791254-2040881002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 11:11:52.097920) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-28 11:11:52.098259) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-28 11:11:52.098655) ========= ========= Total master_lag: 0.27 =========