builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-053 starttime: 1453769412.68 results: success (0) buildid: 20160125113043 builduid: 3f72b65b911847c1892c28652f45b717 revision: 415edbd4f1f945b1ed63d9054fbd3acda09e47e5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 16:50:12.675750) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 16:50:12.676206) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 16:50:12.676543) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1453768191.453622-2080212055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006131 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 16:50:12.755135) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 16:50:12.755482) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 16:50:12.817027) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 16:50:12.817353) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1453768191.453622-2080212055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.027029 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 16:50:12.874377) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 16:50:12.874730) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 16:50:12.875206) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 16:50:12.875581) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1453768191.453622-2080212055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 16:50:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 85.5M=0s 2016-01-25 16:50:13 (85.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.178784 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 16:50:13.086696) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 16:50:13.087030) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1453768191.453622-2080212055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.146332 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 16:50:13.251749) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 16:50:13.252146) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 415edbd4f1f945b1ed63d9054fbd3acda09e47e5 --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 415edbd4f1f945b1ed63d9054fbd3acda09e47e5 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1453768191.453622-2080212055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 16:50:13,250 truncating revision to first 12 chars 2016-01-25 16:50:13,250 Setting DEBUG logging. 2016-01-25 16:50:13,250 attempt 1/10 2016-01-25 16:50:13,250 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/415edbd4f1f9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-25 16:50:13,499 unpacking tar archive at: fx-team-415edbd4f1f9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.530611 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 16:50:13.797043) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 16:50:13.797403) ========= echo 415edbd4f1f945b1ed63d9054fbd3acda09e47e5 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'415edbd4f1f945b1ed63d9054fbd3acda09e47e5'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1453768191.453622-2080212055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 415edbd4f1f945b1ed63d9054fbd3acda09e47e5 program finished with exit code 0 elapsedTime=0.003645 script_repo_revision: '415edbd4f1f945b1ed63d9054fbd3acda09e47e5' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 16:50:13.846229) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 16:50:13.846579) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 16:50:13.857011) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-01-25 16:50:13.857341) ========= /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=920470bf432669ad7e3a5387000001ca-1453768191.453622-2080212055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:50:14 INFO - MultiFileLogger online at 20160125 16:50:14 in /builds/slave/test-pgo 16:50:14 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 16:50:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:50:14 INFO - {'append_to_log': False, 16:50:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:50:14 INFO - 'blob_upload_branch': 'Fx-Team', 16:50:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:50:14 INFO - 'branch': 'Fx-Team', 16:50:14 INFO - 'buildbot_json_path': 'buildprops.json', 16:50:14 INFO - 'config_files': ('talos/linux_config.py',), 16:50:14 INFO - 'default_actions': ('clobber', 16:50:14 INFO - 'read-buildbot-config', 16:50:14 INFO - 'download-and-extract', 16:50:14 INFO - 'populate-webroot', 16:50:14 INFO - 'create-virtualenv', 16:50:14 INFO - 'install', 16:50:14 INFO - 'run-tests'), 16:50:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:50:14 INFO - 'download_minidump_stackwalk': True, 16:50:14 INFO - 'download_symbols': 'ondemand', 16:50:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:50:14 INFO - 'tooltool.py': '/tools/tooltool.py', 16:50:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:50:14 INFO - '/tools/misc-python/virtualenv.py')}, 16:50:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:50:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:50:14 INFO - 'installer_path': 'installer.exe', 16:50:14 INFO - 'log_level': 'info', 16:50:14 INFO - 'log_name': 'talos', 16:50:14 INFO - 'log_to_console': True, 16:50:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:50:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:50:14 INFO - 'opt_config_files': (), 16:50:14 INFO - 'pip_index': False, 16:50:14 INFO - 'sps_profile': False, 16:50:14 INFO - 'sps_profile_interval': 0, 16:50:14 INFO - 'suite': 'dromaeojs-e10s', 16:50:14 INFO - 'system_bits': '32', 16:50:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:50:14 INFO - 'title': 'talos-linux64-ix-053', 16:50:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:50:14 INFO - 'use_talos_json': True, 16:50:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:50:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:50:14 INFO - 'work_dir': 'build'} 16:50:14 INFO - ##### 16:50:14 INFO - ##### Running clobber step. 16:50:14 INFO - ##### 16:50:14 INFO - Running pre-action listener: _resource_record_pre_action 16:50:14 INFO - Running main action method: clobber 16:50:14 INFO - rmtree: /builds/slave/test-pgo/build 16:50:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:50:18 INFO - Running post-action listener: _resource_record_post_action 16:50:18 INFO - ##### 16:50:18 INFO - ##### Running read-buildbot-config step. 16:50:18 INFO - ##### 16:50:18 INFO - Running pre-action listener: _resource_record_pre_action 16:50:18 INFO - Running main action method: read_buildbot_config 16:50:18 INFO - Using buildbot properties: 16:50:18 INFO - { 16:50:18 INFO - "project": "", 16:50:18 INFO - "product": "firefox", 16:50:18 INFO - "script_repo_revision": "production", 16:50:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 16:50:18 INFO - "repository": "", 16:50:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 16:50:18 INFO - "buildid": "20160125113043", 16:50:18 INFO - "pgo_build": "True", 16:50:18 INFO - "basedir": "/builds/slave/test-pgo", 16:50:18 INFO - "buildnumber": 245, 16:50:18 INFO - "slavename": "talos-linux64-ix-053", 16:50:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:50:18 INFO - "platform": "ubuntu64_hw", 16:50:18 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 16:50:18 INFO - "branch": "fx-team", 16:50:18 INFO - "repo_path": "integration/fx-team", 16:50:18 INFO - "revision": "415edbd4f1f945b1ed63d9054fbd3acda09e47e5", 16:50:18 INFO - "stage_platform": "linux64-pgo", 16:50:18 INFO - "builduid": "3f72b65b911847c1892c28652f45b717", 16:50:18 INFO - "slavebuilddir": "test" 16:50:18 INFO - } 16:50:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/DrCLPgmbSKq61UjvILmFhQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 16:50:18 INFO - Running post-action listener: _resource_record_post_action 16:50:18 INFO - ##### 16:50:18 INFO - ##### Running download-and-extract step. 16:50:18 INFO - ##### 16:50:18 INFO - Running pre-action listener: _resource_record_pre_action 16:50:18 INFO - Running main action method: download_and_extract 16:50:18 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:50:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:18 INFO - https://queue.taskcluster.net/v1/task/DrCLPgmbSKq61UjvILmFhQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:50:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrCLPgmbSKq61UjvILmFhQ/artifacts/public/build/test_packages.json 16:50:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrCLPgmbSKq61UjvILmFhQ/artifacts/public/build/test_packages.json 16:50:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrCLPgmbSKq61UjvILmFhQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:50:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrCLPgmbSKq61UjvILmFhQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:50:18 INFO - Downloaded 1448 bytes. 16:50:18 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:50:18 INFO - Using the following test package requirements: 16:50:18 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:50:18 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:50:18 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:50:18 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:18 INFO - u'jsshell-linux-x86_64.zip'], 16:50:18 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:50:18 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:50:18 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:50:18 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:50:18 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:50:18 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:50:18 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:50:18 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:50:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:18 INFO - https://queue.taskcluster.net/v1/task/DrCLPgmbSKq61UjvILmFhQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:50:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrCLPgmbSKq61UjvILmFhQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:50:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrCLPgmbSKq61UjvILmFhQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:50:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrCLPgmbSKq61UjvILmFhQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:50:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrCLPgmbSKq61UjvILmFhQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:50:25 INFO - Downloaded 22496153 bytes. 16:50:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 16:50:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 16:50:26 INFO - Return code: 0 16:50:26 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:50:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:26 INFO - https://queue.taskcluster.net/v1/task/DrCLPgmbSKq61UjvILmFhQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:50:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrCLPgmbSKq61UjvILmFhQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:50:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrCLPgmbSKq61UjvILmFhQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:50:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrCLPgmbSKq61UjvILmFhQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:50:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrCLPgmbSKq61UjvILmFhQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:50:28 INFO - Downloaded 22496153 bytes. 16:50:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 16:50:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 16:50:30 INFO - Return code: 0 16: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')]} 16:50:30 INFO - https://queue.taskcluster.net/v1/task/DrCLPgmbSKq61UjvILmFhQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:50:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrCLPgmbSKq61UjvILmFhQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:50:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrCLPgmbSKq61UjvILmFhQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:50:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrCLPgmbSKq61UjvILmFhQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:50:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrCLPgmbSKq61UjvILmFhQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:50:31 INFO - Downloaded 10706572 bytes. 16:50:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 16:50:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 16:50:31 INFO - Return code: 0 16: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')]} 16:50:31 INFO - https://queue.taskcluster.net/v1/task/DrCLPgmbSKq61UjvILmFhQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:50:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrCLPgmbSKq61UjvILmFhQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:50:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrCLPgmbSKq61UjvILmFhQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:50:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrCLPgmbSKq61UjvILmFhQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:50:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DrCLPgmbSKq61UjvILmFhQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:50:32 INFO - Downloaded 55963873 bytes. 16:50:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DrCLPgmbSKq61UjvILmFhQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:50:32 INFO - mkdir: /builds/slave/test-pgo/properties 16:50:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:50:32 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:50:32 INFO - Contents: 16:50:32 INFO - build_url:https://queue.taskcluster.net/v1/task/DrCLPgmbSKq61UjvILmFhQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:50:32 INFO - Running post-action listener: _resource_record_post_action 16:50:32 INFO - Running post-action listener: set_extra_try_arguments 16:50:32 INFO - ##### 16:50:32 INFO - ##### Running populate-webroot step. 16:50:32 INFO - ##### 16:50:32 INFO - Running pre-action listener: _resource_record_pre_action 16:50:32 INFO - Running main action method: populate_webroot 16:50:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:50:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:50:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:50:32 INFO - '--tppagecycles', 16:50:32 INFO - '7'], 16:50:32 INFO - 'tests': ['tsvgm']}}, 16:50:32 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:50:32 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:50:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:50:32 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:50:32 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:50:32 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:50:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:50:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:32 INFO - 'talos_options': ['--e10s'], 16:50:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:50:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:32 INFO - 'tests': ['damp', 'tps']}, 16:50:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:32 INFO - 'talos_options': ['--e10s'], 16:50:32 INFO - 'tests': ['damp', 'tps']}, 16:50:32 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:50:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:50:32 INFO - 'other': {'tests': ['a11yr', 16:50:32 INFO - 'ts_paint', 16:50:32 INFO - 'tpaint', 16:50:32 INFO - 'sessionrestore', 16:50:32 INFO - 'sessionrestore_no_auto_restore']}, 16:50:32 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:50:32 INFO - 'tests': ['a11yr', 16:50:32 INFO - 'ts_paint', 16:50:32 INFO - 'tpaint', 16:50:32 INFO - 'sessionrestore', 16:50:32 INFO - 'sessionrestore_no_auto_restore']}, 16:50:32 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:50:32 INFO - 'tests': ['a11yr', 16:50:32 INFO - 'ts_paint', 16:50:32 INFO - 'tpaint', 16:50:32 INFO - 'sessionrestore', 16:50:32 INFO - 'sessionrestore_no_auto_restore']}, 16:50:32 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:50:32 INFO - 'tests': ['a11yr', 16:50:32 INFO - 'ts_paint', 16:50:32 INFO - 'tpaint', 16:50:32 INFO - 'sessionrestore', 16:50:32 INFO - 'sessionrestore_no_auto_restore']}, 16:50:32 INFO - 'other_l64': {'tests': ['a11yr', 16:50:32 INFO - 'ts_paint', 16:50:32 INFO - 'tpaint', 16:50:32 INFO - 'sessionrestore', 16:50:32 INFO - 'sessionrestore_no_auto_restore']}, 16:50:32 INFO - 'other_nol64': {'tests': ['a11yr', 16:50:32 INFO - 'ts_paint', 16:50:32 INFO - 'tpaint', 16:50:32 INFO - 'sessionrestore', 16:50:32 INFO - 'sessionrestore_no_auto_restore']}, 16:50:32 INFO - 'svgr': {'tests': ['tsvgx', 16:50:32 INFO - 'tsvgr_opacity', 16:50:32 INFO - 'tart', 16:50:32 INFO - 'tscrollx', 16:50:32 INFO - 'cart']}, 16:50:32 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:50:32 INFO - 'tests': ['tsvgx', 16:50:32 INFO - 'tsvgr_opacity', 16:50:32 INFO - 'tart', 16:50:32 INFO - 'tscrollx', 16:50:32 INFO - 'cart']}, 16:50:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:32 INFO - 'tests': ['tp5o']}, 16:50:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:32 INFO - 'talos_options': ['--e10s'], 16:50:32 INFO - 'tests': ['tp5o']}, 16:50:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:32 INFO - 'talos_options': ['--xperf_path', 16:50:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:50:32 INFO - 'tests': ['tp5n']}, 16:50:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:32 INFO - 'talos_options': ['--e10s', 16:50:32 INFO - '--xperf_path', 16:50:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:50:32 INFO - 'tests': ['tp5n']}}, 16:50:32 INFO - 'talos.zip': {'path': '', 16:50:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:50:32 INFO - Running post-action listener: _resource_record_post_action 16:50:32 INFO - ##### 16:50:32 INFO - ##### Running create-virtualenv step. 16:50:32 INFO - ##### 16:50:32 INFO - Running pre-action listener: _resource_record_pre_action 16:50:32 INFO - Running main action method: create_virtualenv 16:50:32 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:50:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 16:50:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:50:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:50:32 INFO - Using real prefix '/usr' 16:50:32 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:50:33 INFO - Installing distribute.............................................................................................................................................................................................done. 16:50:35 INFO - Installing pip.................done. 16:50:35 INFO - Return code: 0 16:50:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:35 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f20f7ccaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd90630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe21840>, '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 0xd8e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8eb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453768191.453622-2080212055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:50:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 16:50:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:50:35 INFO - Using env: {'DISPLAY': ':0', 16:50:35 INFO - 'HOME': '/home/cltbld', 16:50:35 INFO - 'LANG': 'en_US.UTF-8', 16:50:35 INFO - 'LANGUAGE': 'en_US:en', 16:50:35 INFO - 'LOGNAME': 'cltbld', 16:50:35 INFO - 'MAIL': '/var/mail/cltbld', 16:50:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:35 INFO - 'MOZ_NO_REMOTE': '1', 16:50:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:35 INFO - 'NO_EM_RESTART': '1', 16:50:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:35 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:35 INFO - 'SHELL': '/bin/bash', 16:50:35 INFO - 'SHLVL': '1', 16:50:35 INFO - 'TERM': 'linux', 16:50:35 INFO - 'TMOUT': '86400', 16:50:35 INFO - 'USER': 'cltbld', 16:50:35 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453768191.453622-2080212055', 16:50:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:35 INFO - '_': '/tools/buildbot/bin/python'} 16:50:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:50:36 INFO - Cleaning up... 16:50:36 INFO - Return code: 0 16:50:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:50:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f20f7ccaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd90630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe21840>, '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 0xd8e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8eb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453768191.453622-2080212055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:50:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 16:50:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:50:36 INFO - Using env: {'DISPLAY': ':0', 16:50:36 INFO - 'HOME': '/home/cltbld', 16:50:36 INFO - 'LANG': 'en_US.UTF-8', 16:50:36 INFO - 'LANGUAGE': 'en_US:en', 16:50:36 INFO - 'LOGNAME': 'cltbld', 16:50:36 INFO - 'MAIL': '/var/mail/cltbld', 16:50:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:36 INFO - 'MOZ_NO_REMOTE': '1', 16:50:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:36 INFO - 'NO_EM_RESTART': '1', 16:50:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:36 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:36 INFO - 'SHELL': '/bin/bash', 16:50:36 INFO - 'SHLVL': '1', 16:50:36 INFO - 'TERM': 'linux', 16:50:36 INFO - 'TMOUT': '86400', 16:50:36 INFO - 'USER': 'cltbld', 16:50:36 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453768191.453622-2080212055', 16:50:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:36 INFO - '_': '/tools/buildbot/bin/python'} 16:50:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:36 INFO - Downloading/unpacking psutil>=0.7.1 16:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:50:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:50:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:50:38 INFO - Installing collected packages: psutil 16:50:38 INFO - Running setup.py install for psutil 16:50:38 INFO - building 'psutil._psutil_linux' extension 16:50:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:50:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:50:39 INFO - building 'psutil._psutil_posix' extension 16:50:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:50:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:50:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:50:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:50:39 INFO - Successfully installed psutil 16:50:39 INFO - Cleaning up... 16:50:39 INFO - Return code: 0 16:50:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f20f7ccaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd90630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe21840>, '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 0xd8e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8eb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453768191.453622-2080212055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:50:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 16:50:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:50:39 INFO - Using env: {'DISPLAY': ':0', 16:50:39 INFO - 'HOME': '/home/cltbld', 16:50:39 INFO - 'LANG': 'en_US.UTF-8', 16:50:39 INFO - 'LANGUAGE': 'en_US:en', 16:50:39 INFO - 'LOGNAME': 'cltbld', 16:50:39 INFO - 'MAIL': '/var/mail/cltbld', 16:50:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:39 INFO - 'MOZ_NO_REMOTE': '1', 16:50:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:39 INFO - 'NO_EM_RESTART': '1', 16:50:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:39 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:39 INFO - 'SHELL': '/bin/bash', 16:50:39 INFO - 'SHLVL': '1', 16:50:39 INFO - 'TERM': 'linux', 16:50:39 INFO - 'TMOUT': '86400', 16:50:39 INFO - 'USER': 'cltbld', 16:50:39 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453768191.453622-2080212055', 16:50:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:39 INFO - '_': '/tools/buildbot/bin/python'} 16:50:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:50:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:50:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:50:41 INFO - Installing collected packages: mozsystemmonitor 16:50:41 INFO - Running setup.py install for mozsystemmonitor 16:50:41 INFO - Successfully installed mozsystemmonitor 16:50:41 INFO - Cleaning up... 16:50:41 INFO - Return code: 0 16:50:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:50:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f20f7ccaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd90630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe21840>, '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 0xd8e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8eb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453768191.453622-2080212055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:50:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 16:50:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:50:41 INFO - Using env: {'DISPLAY': ':0', 16:50:41 INFO - 'HOME': '/home/cltbld', 16:50:41 INFO - 'LANG': 'en_US.UTF-8', 16:50:41 INFO - 'LANGUAGE': 'en_US:en', 16:50:41 INFO - 'LOGNAME': 'cltbld', 16:50:41 INFO - 'MAIL': '/var/mail/cltbld', 16:50:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:41 INFO - 'MOZ_NO_REMOTE': '1', 16:50:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:41 INFO - 'NO_EM_RESTART': '1', 16:50:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:41 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:41 INFO - 'SHELL': '/bin/bash', 16:50:41 INFO - 'SHLVL': '1', 16:50:41 INFO - 'TERM': 'linux', 16:50:41 INFO - 'TMOUT': '86400', 16:50:41 INFO - 'USER': 'cltbld', 16:50:41 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453768191.453622-2080212055', 16:50:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:41 INFO - '_': '/tools/buildbot/bin/python'} 16:50:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:41 INFO - Downloading/unpacking blobuploader==1.2.4 16:50:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:43 INFO - Downloading blobuploader-1.2.4.tar.gz 16:50:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:50:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:50:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:50:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:44 INFO - Downloading docopt-0.6.1.tar.gz 16:50:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:50:44 INFO - Installing collected packages: blobuploader, requests, docopt 16:50:44 INFO - Running setup.py install for blobuploader 16:50:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:50:44 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:50:44 INFO - Running setup.py install for requests 16:50:44 INFO - Running setup.py install for docopt 16:50:45 INFO - Successfully installed blobuploader requests docopt 16:50:45 INFO - Cleaning up... 16:50:45 INFO - Return code: 0 16:50:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:50:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f20f7ccaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd90630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe21840>, '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 0xd8e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8eb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453768191.453622-2080212055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:50:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 16:50:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:50:45 INFO - Using env: {'DISPLAY': ':0', 16:50:45 INFO - 'HOME': '/home/cltbld', 16:50:45 INFO - 'LANG': 'en_US.UTF-8', 16:50:45 INFO - 'LANGUAGE': 'en_US:en', 16:50:45 INFO - 'LOGNAME': 'cltbld', 16:50:45 INFO - 'MAIL': '/var/mail/cltbld', 16:50:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:45 INFO - 'MOZ_NO_REMOTE': '1', 16:50:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:45 INFO - 'NO_EM_RESTART': '1', 16:50:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:45 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:45 INFO - 'SHELL': '/bin/bash', 16:50:45 INFO - 'SHLVL': '1', 16:50:45 INFO - 'TERM': 'linux', 16:50:45 INFO - 'TMOUT': '86400', 16:50:45 INFO - 'USER': 'cltbld', 16:50:45 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453768191.453622-2080212055', 16:50:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:45 INFO - '_': '/tools/buildbot/bin/python'} 16:50:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:50:45 INFO - Running setup.py (path:/tmp/pip-6ixPAM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:50:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:50:45 INFO - Running setup.py (path:/tmp/pip-0zmH6X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:50:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:50:45 INFO - Running setup.py (path:/tmp/pip-AG9oHA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:50:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:50:45 INFO - Running setup.py (path:/tmp/pip-JdUsVb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:50:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:50:45 INFO - Running setup.py (path:/tmp/pip-F7aLLS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:50:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:50:45 INFO - Running setup.py (path:/tmp/pip-T32HTW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:50:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:50:45 INFO - Running setup.py (path:/tmp/pip-sIbkTK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:50:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:50:45 INFO - Running setup.py (path:/tmp/pip-k0cgIT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:50:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:50:45 INFO - Running setup.py (path:/tmp/pip-F8BcEb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:50:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:50:45 INFO - Running setup.py (path:/tmp/pip-6tXLQO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:50:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:50:46 INFO - Running setup.py (path:/tmp/pip-MvxUOr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:50:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:50:46 INFO - Running setup.py (path:/tmp/pip-CGcbt5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:50:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:50:46 INFO - Running setup.py (path:/tmp/pip-RpEbpx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:50:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:50:46 INFO - Running setup.py (path:/tmp/pip-SGhpiV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:50:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:50:46 INFO - Running setup.py (path:/tmp/pip-eQo1X0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:50:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:50:46 INFO - Running setup.py (path:/tmp/pip-rpEcXI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:50:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:50:46 INFO - Running setup.py (path:/tmp/pip-LZbhY7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:50:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:50:46 INFO - Running setup.py install for manifestparser 16:50:46 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:50:46 INFO - Running setup.py install for mozcrash 16:50:46 INFO - Running setup.py install for mozdebug 16:50:46 INFO - Running setup.py install for mozdevice 16:50:46 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:50:46 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:50:46 INFO - Running setup.py install for mozfile 16:50:47 INFO - Running setup.py install for mozhttpd 16:50:47 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:50:47 INFO - Running setup.py install for mozinfo 16:50:47 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:50:47 INFO - Running setup.py install for mozInstall 16:50:47 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:50:47 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:50:47 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:50:47 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:50:47 INFO - Running setup.py install for mozleak 16:50:47 INFO - Running setup.py install for mozlog 16:50:47 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:50:47 INFO - Running setup.py install for moznetwork 16:50:47 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:50:47 INFO - Running setup.py install for mozprocess 16:50:47 INFO - Running setup.py install for mozprofile 16:50:47 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:50:47 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:50:47 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:50:47 INFO - Running setup.py install for mozrunner 16:50:47 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:50:47 INFO - Running setup.py install for mozscreenshot 16:50:48 INFO - Running setup.py install for moztest 16:50:48 INFO - Running setup.py install for mozversion 16:50:48 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:50:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:50:48 INFO - Cleaning up... 16:50:48 INFO - Return code: 0 16:50:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f20f7ccaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd90630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe21840>, '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 0xd8e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8eb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453768191.453622-2080212055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:50:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 16:50:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:50:48 INFO - Using env: {'DISPLAY': ':0', 16:50:48 INFO - 'HOME': '/home/cltbld', 16:50:48 INFO - 'LANG': 'en_US.UTF-8', 16:50:48 INFO - 'LANGUAGE': 'en_US:en', 16:50:48 INFO - 'LOGNAME': 'cltbld', 16:50:48 INFO - 'MAIL': '/var/mail/cltbld', 16:50:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:48 INFO - 'MOZ_NO_REMOTE': '1', 16:50:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:48 INFO - 'NO_EM_RESTART': '1', 16:50:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:48 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:48 INFO - 'SHELL': '/bin/bash', 16:50:48 INFO - 'SHLVL': '1', 16:50:48 INFO - 'TERM': 'linux', 16:50:48 INFO - 'TMOUT': '86400', 16:50:48 INFO - 'USER': 'cltbld', 16:50:48 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453768191.453622-2080212055', 16:50:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:48 INFO - '_': '/tools/buildbot/bin/python'} 16:50:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:50:48 INFO - Running setup.py (path:/tmp/pip-PzP3vs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:50:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 16:50:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:50:48 INFO - Running setup.py (path:/tmp/pip-dRAifd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:50:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:50:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:50:48 INFO - Running setup.py (path:/tmp/pip-y9KHza-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:50:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 16:50:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:50:48 INFO - Running setup.py (path:/tmp/pip-rfxiKp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:50:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:50:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:50:48 INFO - Running setup.py (path:/tmp/pip-MqlC_8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:50:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 16:50:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:50:48 INFO - Running setup.py (path:/tmp/pip-3TJmD2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:50:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 16:50:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:50:48 INFO - Running setup.py (path:/tmp/pip-tsZhEt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 16:50:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:50:49 INFO - Running setup.py (path:/tmp/pip-Z3NxJg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 16:50:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:50:49 INFO - Running setup.py (path:/tmp/pip-RPpkra-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 16:50:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:50:49 INFO - Running setup.py (path:/tmp/pip-3BtDJP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:50:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:50:49 INFO - Running setup.py (path:/tmp/pip-rB_TMX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 16:50:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:50:49 INFO - Running setup.py (path:/tmp/pip-RWf0xr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 16:50:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:50:49 INFO - Running setup.py (path:/tmp/pip-4CSRaT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 16:50:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:50:49 INFO - Running setup.py (path:/tmp/pip-louk6l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 16:50:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:50:49 INFO - Running setup.py (path:/tmp/pip-BDAJIz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 16:50:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:50:49 INFO - Running setup.py (path:/tmp/pip-j6AYQh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 16:50:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:50:49 INFO - Running setup.py (path:/tmp/pip-BJClvq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 16:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 16:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:50:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:51 INFO - Downloading blessings-1.6.tar.gz 16:50:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:50:51 INFO - Installing collected packages: blessings 16:50:51 INFO - Running setup.py install for blessings 16:50:51 INFO - Successfully installed blessings 16:50:51 INFO - Cleaning up... 16:50:51 INFO - Return code: 0 16:50:51 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:50:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:50:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:50:52 INFO - Reading from file tmpfile_stdout 16:50:52 INFO - Current package versions: 16:50:52 INFO - argparse == 1.2.1 16:50:52 INFO - blessings == 1.6 16:50:52 INFO - blobuploader == 1.2.4 16:50:52 INFO - docopt == 0.6.1 16:50:52 INFO - manifestparser == 1.1 16:50:52 INFO - mozInstall == 1.12 16:50:52 INFO - mozcrash == 0.16 16:50:52 INFO - mozdebug == 0.1 16:50:52 INFO - mozdevice == 0.48 16:50:52 INFO - mozfile == 1.2 16:50:52 INFO - mozhttpd == 0.7 16:50:52 INFO - mozinfo == 0.9 16:50:52 INFO - mozleak == 0.1 16:50:52 INFO - mozlog == 3.1 16:50:52 INFO - moznetwork == 0.27 16:50:52 INFO - mozprocess == 0.22 16:50:52 INFO - mozprofile == 0.28 16:50:52 INFO - mozrunner == 6.11 16:50:52 INFO - mozscreenshot == 0.1 16:50:52 INFO - mozsystemmonitor == 0.0 16:50:52 INFO - moztest == 0.7 16:50:52 INFO - mozversion == 1.4 16:50:52 INFO - psutil == 3.1.1 16:50:52 INFO - requests == 1.2.3 16:50:52 INFO - wsgiref == 0.1.2 16:50:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f20f7ccaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd90630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe21840>, '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 0xd8e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8eb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453768191.453622-2080212055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:50:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 16:50:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:50:52 INFO - Using env: {'DISPLAY': ':0', 16:50:52 INFO - 'HOME': '/home/cltbld', 16:50:52 INFO - 'LANG': 'en_US.UTF-8', 16:50:52 INFO - 'LANGUAGE': 'en_US:en', 16:50:52 INFO - 'LOGNAME': 'cltbld', 16:50:52 INFO - 'MAIL': '/var/mail/cltbld', 16:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:52 INFO - 'MOZ_NO_REMOTE': '1', 16:50:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:52 INFO - 'NO_EM_RESTART': '1', 16:50:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:52 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:52 INFO - 'SHELL': '/bin/bash', 16:50:52 INFO - 'SHLVL': '1', 16:50:52 INFO - 'TERM': 'linux', 16:50:52 INFO - 'TMOUT': '86400', 16:50:52 INFO - 'USER': 'cltbld', 16:50:52 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453768191.453622-2080212055', 16:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:52 INFO - '_': '/tools/buildbot/bin/python'} 16:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 16:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 16:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 16:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 16:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 16:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 16:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 16:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 16:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 16:50:52 INFO - Cleaning up... 16:50:52 INFO - Return code: 0 16:50:52 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f20f7ccaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd90630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe21840>, '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 0xd8e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8eb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453768191.453622-2080212055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:50:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 16:50:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:50:52 INFO - Using env: {'DISPLAY': ':0', 16:50:52 INFO - 'HOME': '/home/cltbld', 16:50:52 INFO - 'LANG': 'en_US.UTF-8', 16:50:52 INFO - 'LANGUAGE': 'en_US:en', 16:50:52 INFO - 'LOGNAME': 'cltbld', 16:50:52 INFO - 'MAIL': '/var/mail/cltbld', 16:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:52 INFO - 'MOZ_NO_REMOTE': '1', 16:50:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:52 INFO - 'NO_EM_RESTART': '1', 16:50:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:52 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:52 INFO - 'SHELL': '/bin/bash', 16:50:52 INFO - 'SHLVL': '1', 16:50:52 INFO - 'TERM': 'linux', 16:50:52 INFO - 'TMOUT': '86400', 16:50:52 INFO - 'USER': 'cltbld', 16:50:52 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453768191.453622-2080212055', 16:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:52 INFO - '_': '/tools/buildbot/bin/python'} 16:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:52 INFO - Downloading/unpacking jsonschema 16:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:50:54 INFO - Downloading/unpacking functools32 (from jsonschema) 16:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:54 INFO - Downloading functools32-3.2.3-2.tar.gz 16:50:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:50:54 INFO - warning: no files found matching '*.txt' 16:50:54 INFO - no previously-included directories found matching 'build' 16:50:54 INFO - no previously-included directories found matching 'dist' 16:50:54 INFO - no previously-included directories found matching '.git*' 16:50:54 INFO - Installing collected packages: jsonschema, functools32 16:50:54 INFO - Running setup.py install for functools32 16:50:54 INFO - warning: no files found matching '*.txt' 16:50:54 INFO - no previously-included directories found matching 'build' 16:50:54 INFO - no previously-included directories found matching 'dist' 16:50:54 INFO - no previously-included directories found matching '.git*' 16:50:54 INFO - Successfully installed jsonschema functools32 16:50:54 INFO - Cleaning up... 16:50:54 INFO - Return code: 0 16:50:54 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f20f7ccaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd90630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe21840>, '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 0xd8e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8eb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453768191.453622-2080212055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:50:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 16:50:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:50:54 INFO - Using env: {'DISPLAY': ':0', 16:50:54 INFO - 'HOME': '/home/cltbld', 16:50:54 INFO - 'LANG': 'en_US.UTF-8', 16:50:54 INFO - 'LANGUAGE': 'en_US:en', 16:50:54 INFO - 'LOGNAME': 'cltbld', 16:50:54 INFO - 'MAIL': '/var/mail/cltbld', 16:50:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:54 INFO - 'MOZ_NO_REMOTE': '1', 16:50:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:54 INFO - 'NO_EM_RESTART': '1', 16:50:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:54 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:54 INFO - 'SHELL': '/bin/bash', 16:50:54 INFO - 'SHLVL': '1', 16:50:54 INFO - 'TERM': 'linux', 16:50:54 INFO - 'TMOUT': '86400', 16:50:54 INFO - 'USER': 'cltbld', 16:50:54 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453768191.453622-2080212055', 16:50:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:54 INFO - '_': '/tools/buildbot/bin/python'} 16:50:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:55 INFO - Downloading/unpacking flake8 16:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:50:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:50:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:50:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:50:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:50:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:50:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:50:57 INFO - no previously-included directories found matching 'docs/_build' 16:50:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:50:57 INFO - Running setup.py install for pep8 16:50:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:50:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:50:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:50:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:50:57 INFO - no previously-included directories found matching 'docs/_build' 16:50:57 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:50:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:50:57 INFO - Cleaning up... 16:50:57 INFO - Return code: 0 16:50:57 INFO - Running post-action listener: _resource_record_post_action 16:50:57 INFO - Running post-action listener: _start_resource_monitoring 16:50:57 INFO - Starting resource monitoring. 16:50:57 INFO - ##### 16:50:57 INFO - ##### Running install step. 16:50:57 INFO - ##### 16:50:57 INFO - Running pre-action listener: _resource_record_pre_action 16:50:57 INFO - Running main action method: install 16:50:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:50:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:50:57 INFO - Reading from file tmpfile_stdout 16:50:57 INFO - Detecting whether we're running mozinstall >=1.0... 16:50:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:50:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:50:58 INFO - Reading from file tmpfile_stdout 16:50:58 INFO - Output received: 16:50:58 INFO - Usage: mozinstall [options] installer 16:50:58 INFO - Options: 16:50:58 INFO - -h, --help show this help message and exit 16:50:58 INFO - -d DEST, --destination=DEST 16:50:58 INFO - Directory to install application into. [default: 16:50:58 INFO - "/builds/slave/test-pgo"] 16:50:58 INFO - --app=APP Application being installed. [default: firefox] 16:50:58 INFO - mkdir: /builds/slave/test-pgo/build/application 16:50:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 16:50:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 16:51:14 INFO - Reading from file tmpfile_stdout 16:51:14 INFO - Output received: 16:51:14 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:51:14 INFO - Running post-action listener: _resource_record_post_action 16:51:14 INFO - ##### 16:51:14 INFO - ##### Running run-tests step. 16:51:14 INFO - ##### 16:51:14 INFO - Running pre-action listener: _resource_record_pre_action 16:51:14 INFO - Running main action method: run_tests 16:51:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:51:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:51:14 INFO - Python 2.7.3 16:51:14 INFO - Return code: 0 16:51:14 INFO - grabbing minidump binary from tooltool 16:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:14 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 0xe21840>, '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 0xd8e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8eb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:51:14 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 16:51:14 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:51:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:51:14 INFO - Return code: 0 16:51:14 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:51:14 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:51:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:51:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:51:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:51:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:51:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:51:15 INFO - Return code: 0 16:51:15 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/DrCLPgmbSKq61UjvILmFhQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 16:51:15 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/DrCLPgmbSKq61UjvILmFhQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:51:15 INFO - Using env: {'DISPLAY': ':0', 16:51:15 INFO - 'HOME': '/home/cltbld', 16:51:15 INFO - 'LANG': 'en_US.UTF-8', 16:51:15 INFO - 'LANGUAGE': 'en_US:en', 16:51:15 INFO - 'LOGNAME': 'cltbld', 16:51:15 INFO - 'MAIL': '/var/mail/cltbld', 16:51:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:51:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:15 INFO - 'MOZ_NO_REMOTE': '1', 16:51:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:51:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:15 INFO - 'NO_EM_RESTART': '1', 16:51:15 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:15 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:15 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:51:15 INFO - 'SHELL': '/bin/bash', 16:51:15 INFO - 'SHLVL': '1', 16:51:15 INFO - 'TERM': 'linux', 16:51:15 INFO - 'TMOUT': '86400', 16:51:15 INFO - 'USER': 'cltbld', 16:51:15 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453768191.453622-2080212055', 16:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:15 INFO - '_': '/tools/buildbot/bin/python'} 16:51:15 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/DrCLPgmbSKq61UjvILmFhQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:51:15 INFO - mozversion application_buildid: 20160125113043 16:51:15 INFO - mozversion application_changeset: 415edbd4f1f945b1ed63d9054fbd3acda09e47e5 16:51:15 INFO - mozversion application_display_name: Nightly 16:51:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:51:15 INFO - mozversion application_name: Firefox 16:51:15 INFO - mozversion application_remotingname: firefox 16:51:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:51:15 INFO - mozversion application_vendor: Mozilla 16:51:15 INFO - mozversion application_version: 46.0a1 16:51:15 INFO - mozversion platform_buildid: 20160125113043 16:51:15 INFO - mozversion platform_changeset: 415edbd4f1f945b1ed63d9054fbd3acda09e47e5 16:51:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:51:15 INFO - mozversion platform_version: 46.0a1 16:51:15 INFO - using testdate: 1453769475 16:51:15 INFO - actual date: 1453769475 16:51:15 INFO - starting webserver on 'localhost:58998' 16:51:15 INFO - SUITE-START | Running 3 tests 16:51:15 INFO - TEST-START | dromaeo_css 16:51:15 INFO - operating with platform_type : linux_ 16:51:15 INFO - Initialising browser for dromaeo_css test... 16:51:15 INFO - TEST-INFO | started process 3317 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWikSTH/profile http://localhost:58998/getInfo.html) 16:51:21 INFO - PROCESS | 3317 | 16:51:21 INFO - PROCESS | 3317 | (process:3401): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:51:22 INFO - PROCESS | 3317 | __metrics Screen width/height:1600/1200 16:51:22 INFO - PROCESS | 3317 | colorDepth:24 16:51:22 INFO - PROCESS | 3317 | Browser inner width/height: 1024/697 16:51:22 INFO - PROCESS | 3317 | __metrics 16:51:22 INFO - PROCESS | 3317 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:51:24 INFO - TEST-INFO | 3317: exit 0 16:51:24 INFO - Browser initialized. 16:51:24 INFO - Running cycle 1/1 for dromaeo_css test... 16:51:24 INFO - TEST-INFO | started process 3450 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWikSTH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:51:25 INFO - PROCESS | 3450 | 16:51:25 INFO - PROCESS | 3450 | (process:3510): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:51:35 INFO - PROCESS | 3450 | RSS: Main: 152375296 16:51:35 INFO - PROCESS | 3450 | 16:52:25 INFO - PROCESS | 3450 | 1453769545432 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:54:33 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:58998/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58998/tests/dromaeo/cssquery-ext.html) 16:54:34 INFO - PROCESS | 3450 | RSS: Main: 161411072 16:54:34 INFO - PROCESS | 3450 | 16:57:36 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:58998/tests/dromaeo/cssquery-ext.html (next: http://localhost:58998/tests/dromaeo/cssquery-jquery.html) 16:57:37 INFO - PROCESS | 3450 | RSS: Main: 155332608 16:57:37 INFO - PROCESS | 3450 | 17:00:39 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:58998/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58998/tests/dromaeo/cssquery-mootools.html) 17:00:39 INFO - PROCESS | 3450 | RSS: Main: 156635136 17:00:39 INFO - PROCESS | 3450 | 17:03:41 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:58998/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58998/tests/dromaeo/cssquery-prototype.html) 17:03:42 INFO - PROCESS | 3450 | RSS: Main: 154845184 17:03:42 INFO - PROCESS | 3450 | 17:06:44 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:58998/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58998/tests/dromaeo/cssquery-yui.html) 17:06:44 INFO - PROCESS | 3450 | RSS: Main: 156299264 17:06:44 INFO - PROCESS | 3450 | 17:09:47 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:58998/tests/dromaeo/cssquery-yui.html (next: http://localhost:58998/tests/dromaeo/cssquery-dojo.html) 17:09:47 INFO - PROCESS | 3450 | RSS: Main: 158273536 17:09:47 INFO - PROCESS | 3450 | 17:09:47 INFO - PROCESS | 3450 | __start_tp_report 17:09:47 INFO - PROCESS | 3450 | _x_x_mozilla_page_load 17:09:47 INFO - PROCESS | 3450 | _x_x_mozilla_page_load_details 17:09:47 INFO - PROCESS | 3450 | |i|pagename|runs| 17:09:47 INFO - PROCESS | 3450 | |0;dojo.html;3108.891188808391;3113.657497675256;3135.4983202687577;3138.419392412405;3165.841707914604;5100.642954993152;5114.795408183678;5133.999999999995;5173.922391164131;5196.636235463509;5173.560247378978;5189.974050129744;5221.0863098957625;5245.44922783108;5268.262443257947;4471.172833025885;4706.599939005188;4861.076395484846;4872.561469467747;4910.803567857281;4706.788194531237;4783.354247176621;4824.059308434857;4849.5877850382585;4857.829975950843;4702.036082603076;4783.4499032611;4792.688475249115;4795.4964728703335;4797.880052998668;4664.230401983668;4684.110019096361;4689.249720044811;4705;4715.764211789431;4619.445666520039;4653.790579423934;4662.7668616569035;4683.180443422421;4697.765111744433;5012.749362531858;5015.849524514234;5019.598432125457;5056.317397151374;5095.108356037716;5531;5566.832995010116;5572.749226284827;5578.9163162552595;5636.4927156556105;5543.085390910495;5567.638103523258;5604.887902241973;5615.2700148980775;5625.1843482695185;5227.294315267466;5242.842714718565;5252.842414727565;5257.237700533439;5286.233496143076;5675.574331925122;5675.886482270332;5688.345840228344;5689.829305120853;5729.627574207663;5322.813701520428;5379.381371142369;5475.67145971243;5480.890382192334;5576.804811831566;5476.288082549243;5482.80810171642;5483.341998960151;5490.313710786152;5500.50495455411;5455.672659640355;5458;5462.371827239839;5488.121900495901;5502.312210973629;5437.891242175135;5466.426025267369;5466.508014278734;5498.532624726863;5570.3315602127195;4289.356596510486;4291.463567054118;4292.656587473057;4299.806508707115;4315.78421078951;3854.4411060396087;3876.7673939563715;3893.610638936084;3908.785016824045;3909.980450097731;5225.608079394061;5253.4221235664045;5275.155975043975;5309.123994540934;5338.092524270884;5494.2582751328855;5501.669899806025;5529.778808847682;5542.11326187808;5548.500634942875;5142.382914050263;5204.193350030751;5217.608679349064;5236.764345604457;5261.500157485033;4733.266343716729;4735.739534325645;4767.856964291077;4806.423229212517;4833.806647734122;5767.682777447197;5783;5785.0454674978155;5807.303123625192;5814.912776308359;5464.9453505464435;5505.421930697379;5581.665100094007;5599.580031497572;5654.491095801315;5778.971105144616;5783.6818974955095;5815.94184058154;5836.795712150054;5883.264591926009;5396.78412863481;5403.513683768322;5405.054115529845;5416.8645783854145;5434.864128396822;5387.245785590099;5431.4840090191365;5447.891042179213;5497.890042199214;5509.3664228614225;5427;5428.864278393072;5473.233747275464;5510.614257001971;5529.612927095065;5424.077906755782;5452.672839629635;5470.452954704498;5481.808136715196;5487.917681234705;5298.125809241432;5358.383785864519;5394.703291319015;5398.541124004503;5438.619296649196;5385.596080293915;5449.863753406196;5527.751251193626;5529.281193444826;5560.527355174855;5239.24031015493;5259.710715910662;5280.3663560373;5303.284056652303;5322.414534401135 17:09:47 INFO - PROCESS | 3450 | |1;ext.html;524.0802391802388;541.6533418612089;546.1616418797146;547.0699810322453;550.5705549671258;34629;34761.82619086904;35096.12259693503;35106.64893351066;35187.29625407491;35788.82105589475;35858.10354741133;36143.4578481323;36269.274614507696;36279.81860090696;8248.67005319788;8411.411201215917;8421.410501264914;8434.78913027173;8488.151184881493;8171.264586187242;8343;8359.331253499737;8428.747137585882;8432.283255923254;8414.284785793216;8414.453060551044;8532.402731808776;8533.445326053787;8549.786255343604;8438;8501.06488286288;8503.914960850405;8505.532195729264;8544.401891867572;8317.209865062809;8349.874751878726;8382.287505562035;8404.8319033619;8443.535605541692;34406;34569.48145777815;34614.13464663403;34659.306813863834;34725;2955.2611847038243;3034.575159477675;3071.232191952012;3276.1809547612856;3307.1732066983254;29756.404871902658;29857.850710746523;29923.10230693083;29962.40075198484;30170.09489715312;3570.3037907608027;3710.870119545803;3714.972934480035;3740.9438858417147;3822.7515211511163;189183;190551;190644;191158.04420977805;191677;49151.26273105906;49393.75303123461;54098.91802163934;54318.18522722162;54409.45590544123;64440.355596443434;65928.67035664887;66099;66260;66369.6681516599;10846.132309415385;11016.889831101747;11071.72320691989;11094.944525277322;11108.555657773599;8727.781805454915;8764.780880477912;8766.342524310703;8776.473411595325;8807.647694092164;17618.823811761973;17653.7351939721;17818.376356827448;17851.642967140586;17868.374606888698;7293.671784769698;7511.737089201961;7513;7560.206178351194;7619.08570971487;927.939683920543;943.4527973775193;958.9089036541517;1006.7684432580547;1058.0319008107494;27567;27725;28063.57904631432;28124.156275311772;28282.292942676188;1008.8032833597379;1017.6590842067842;1024.3034736379184;1068.9946550267198;1085.5874767588423;14263.286835658175;14579.41682332716;14713.190774507504;14917.552473425814;14930.92534537342;130431.34784326017;134954.32522837323;135373;135381;304468;47161;47371.76314118407;47867.21327867186;48053.279200812016;48102.75948620235;1263.5135472843021;1271.465984286602;1275.7384736129072;1280.9423575939104;1382.4262930883572;25655.358616034748;26456.206313810617;26723.599146013214;26926.461470770868;27104.593431098154;42591.787041065836;42714.57285427106;42929;43123.784381077894;43130.353044704985;282316;282871;284839;285138;285712;29701.851490742407;29948.85025574858;30159.69840301569;30237.546436803026;31565.210869728442;35021.64978350286;35574.46638300376;35928;35947.82026089853;36535.81732091322;32837.50743738894;33159.336813263115;33672.831635842645;33849.661503385636;34240.828795855865;32946.38690009239;33609.327813444084;33697.326053479286;34043.65956340504;34252;33314.16714582155;33395.66604333925;33787.493187601714;33850.49224261589;33850.830745847095;29418.26454338573;30032.699673003863;30929.536056958714;31289.530657040617;31663.20841978969;23672.763272367745;23715.762842371354;23825.166119185746;23969.28092157238;24187 17:09:47 INFO - PROCESS | 3450 | |2;jquery.html;360.7673050882181;362.510610675588;362.5848403577902;366.19619934244326;367.84918183544744;15001.549953501399;15990;16562.50312490627;16879.83120168798;17147.657046859054;14156.50452234172;14522;14652.706945861102;14715.043522171052;14741.410343586243;4461.754603496806;4717.2688233323715;4729.739864307479;4738.549837765407;4740.336352910578;4350.890522916668;4650.348951146842;4683.414573178353;4721.268203428457;4744.881377965544;4830.637702172334;4888.828890988816;5096.184610462326;5293.6294459387855;5349.973250133763;5060.493950604947;5061.721605311706;5072.898542029176;5086.237064440326;5120.92318615221;5139.640225184201;5144.794208231666;5145.871353216162;5152.227165925104;5176.55999240065;11588.6523404298;14131.576052718436;18550.907245463823;19327.130279137473;19358.225670973145;2005.5587770690424;2051.9589608207903;2098.653722135846;2104.653022065879;2218.589560931217;8831.69089081879;8888.511131887744;9024.23294020009;9049.095090490899;9493.66772162978;1757.7890653121708;1785.9196336164903;1788.65121301345;1793.067604845473;1802.4592622213283;52719.20921186185;54344.184837227476;55543.44456555423;56144.43855561433;56952.43047569554;14508.492202772852;14849.960502764703;14877.809775217956;15029.421910699437;15190.012649177768;21468.141274349164;21580.56838863214;21654.35036948894;21761.673574896387;21780.564388712453;7547.132079810783;7631.3131818136635;7634.160242373335;7718.961405192938;7807.765767026998;6201.503879689704;6231.376862313823;6250.312465628777;6258.561900666909;6283.37166283368;7377.372923301579;7484.438667099989;7509.286617771303;7516.624168791539;7534.095908491016;1747.9825201748074;3027.606411166534;3055.114016935064;3120.469520181575;3124.109628755794;820.1880138662681;899.2311573604604;922.1331947969022;982.832918403873;988.8813342398959;15537.766933496006;16067.11630860314;16097.517074487783;16240.187990600423;16387.426440074778;856.8450347376354;878.0867897386775;881.1584936385736;960.279790157382;976.2141476111656;8706.157289129182;9479.194268487117;9542.856857147148;9564.234861211087;9583.141283930832;441617;443982;450132.23743744293;453537;506782;66266.66866665636;67552.6622366885;68938.31061689419;69624.30375696179;70488.64755676189;1089.096050278267;1097.742030622803;1107.4628805029554;1109.3399427340719;1122.7305446692735;14147.717045659236;14700.926495367456;14887.627809304853;14956.700865982402;15250.923745381202;31683.20791980219;31987.680123198472;32617.673823261463;32824;33795;38306.80846595749;38574.6142538571;38953;39058.6094139055;39955;6929.618870961944;6960.338767817049;7011.614361210182;7056.329648683367;7301.4158867289425;10233.334833235816;11392.715182120513;11573.768524629628;11779.52881884715;11803.173777835469;9183.54082295896;9543.47510886908;9579.185769209416;9871.555779989774;10181.03280188381;9196.194127454926;9452.149306562442;9567.856482152634;9578.616855325708;9686.321957463191;9617.471039092638;9724.756881077747;9740.610375584898;10040.995900410193;10086.848697269694;6802.897956530755;6905.930940690529;6981.847995080958;6987;7025.332593403618;8591.871121933302;9846.261530385107;9856.457894815854;9886.110250077527;9920.900790992286 17:09:47 INFO - PROCESS | 3450 | |3;mootools.html;1458.2271396160036;1489.8510148985104;1644.5970737169396;1740.4517576963265;1768.885022473539;7520.548767073979;7544.358729507985;7688.461807673458;7915.1689072647405;7915.920840791598;7827.060752709668;7929.722459713911;7946.76159715208;8001.079875814283;8010.1589333120055;2351.8000969917534;2373.6558199061124;2380.3573035280465;2386.892589833453;2392.294273189413;2370.7392186859433;2385.1651921827397;2394.341556072077;2398.64020396941;2399.7360290368047;2265.8753768542724;2321.7330007049154;2322.140807901079;2328.2549584133085;2345.94135146621;2317.316391664463;2331.5570041692026;2356.7761062699014;2361.988190059047;2363.8889721830797;2316.3861576682193;2317.2005658047947;2336.2290444153386;2337.1819863047967;2340.789328960385;7738.380929525681;7783.104942931579;7786.649600767979;7828.178041305638;7835.8432831343625;4692.882677933045;4840.636952228597;4865.537773911508;4866.6106711463;4868.853934381974;3015.849207539636;3016.170553097894;3069.8004629699;3104.798188117765;3107.9378412431624;851.3317046118767;857.3098655582254;866.3805379153872;899.8875140607424;921.3688623293066;10892.455377231187;10968.17738669603;11045.005949464507;11061.225714200009;11067.446627668665;4208.284591619371;4291.806868690916;4319.028218650778;4334.891627709269;4356.063446358985;8899.599518021576;8899.599518021705;8934.374593778373;8946.105389461001;8968;4801.5438533339275;4805.399325084364;4817.2774083887;4833.468318484964;4834.95165048345;4366.410534577792;4379.781010949439;4409.779511024436;4423.380726698265;4440.023194897118;3426.811525366079;3429.3827111120236;3453.7755045921936;3454.4127498325347;3464.220550376145;1003.1423133220991;1034.2863424237403;1052.6999805055523;1060.0936199549428;1061.1828891753462;982.6658935961807;1061.9787604247872;1140.8516892803882;1166.3235323512342;1267.461328935199;7022.578645281197;7032.191298000693;7038.049863268496;7080.04419403374;7091.716331346792;1030.9484525773682;1073.1468482556386;1076.7200527862813;1098.5166526728215;1103.7240689827543;5739.598228124075;5828.504577110908;5842.591018628656;5844.532437404998;5925.703714814242;9358.298127640453;9413.952930235306;9756.609735610497;9862.112409883002;9905.405675659484;9595.616175353047;9610.95194524023;9625.278104142217;9686.903130968742;9760.365576237522;7299.781006569811;7442.18136005039;7599.202083781234;7601.163871974079;7654.158042615308;7206.315400036988;7243.710251589878;7245.420366370572;7264.963675181591;7295.270472952662;8492.70275540353;8554.57227138653;8754.562271886252;8777.166169213915;8844.513551754715;8595.613197406257;8746.644270138138;8802.339824513316;8812.647494100163;8917.55412229373;6823.522353435212;6876.965615171892;6879.277675843964;6910.827229319308;6941.548799328028;7284.672189751368;7304.853902922018;7342.6695798688115;7362.7054917804835;7373.483856130019;6309.432151106239;6914.101166848278;7236.927630723625;7266.96366518164;7418.9629051856555;6305.653189074645;6576.112224849584;6881.311868813079;6956;6972.825679358057;6293.087502312048;6753.15585551806;6859.348361905611;6879.449644028366;6884.862302753817;6050.485708714808;6079.665618391031;6086.969565152323;6087.9391206087375;6092.939070609415;6374.74501019954;6383.265924418752;6406.167198264196;6420.935790642034;6443.516736244894 17:09:47 INFO - PROCESS | 3450 | |4;prototype.html;322.94832826747717;331.66336168788683;332.5377724962301;333.95157702133184;336.56751074868816;6137.447629713325;6224.968875155623;6279.748810047604;6324.525660575452;6336.049592561112;6013.669248191348;6149.661768602725;6168.722407491662;6178.3512731163255;6188.793185328863;4755.6671033027615;4756.120117778205;4760.642951778613;4771.117343291485;4778.569928706415;4769.284607308897;4769.61681112477;4772.76136193189;4773.92839107412;4785.856424307259;4655.837045703401;4695.741734204617;4722.881927951811;4724.31497432872;4725.763711814413;4698.013417182413;4704.717716936978;4714.457837348715;4716.740579268139;4726.054789042205;3921.607839216084;4002.039510517484;4133.875983720493;4136.503619565641;4142.834286628531;5761.740721667535;5896.941030589682;5911.645301281937;5966.433188847052;5991.430814072656;5442.727863606843;5453.23654688344;5474.616776825624;5479.04116779566;5502.394736578973;6455.160829092235;6576;6601.207855057424;6603;6614.636195009272;4573.49691533931;4578.954210457886;4583.03756211196;4584.7936842842155;4592.885177870547;6858.10844590205;6879.449644028516;6884.965575172142;6888.104546408985;6906.585604863674;4656.557627025427;4658.091672123971;4690.577847993697;4691.648126390534;4692.929606055912;4651.418572678415;4740.241561350167;4760.785764640599;4762.333273341735;4771.427428708577;5476;5483.396826349178;5488.121900495981;5491.423400542965;5501.229827824028;6578.736850526021;6635.170603674541;6635.535512514078;6640.8671826563195;6670.866582668319;1664.6504234110973;1702.540314115182;1703.7444383342597;1704.0797969096798;1713.1177443616548;1122.3266040375709;1127.0420142878488;1130.463030060731;1140.2474366917795;1157.7626586549736;6214.067889816473;6294;6296.842578935563;6313.810585682437;6326.272478665012;6788.898166527506;6845.794626161223;6852.760153394707;6854.862902742017;6875.724971001104;6199.597026193283;6273.749050038039;6286.811395658137;6300.873982520324;6306.49548036156;3721.2371463850386;3724.8137593120236;3725.590185079639;3730.7948062856804;3741.7380783345448;7021.648917554102;7186.928130718626;7230.891536626955;7259.165196002527;7266.237045110187;6977.546459480118;6993.510454268152;7040.577565346096;7040.9647951760935;7057.541259818096;7097.183823860219;7204.711811527585;7210.351068403869;7216;7240.927590724025;6908.654567271717;6914.0666010088;6918.654067296716;6928.064711263914;6952.165740111017;6782.152230971129;6798.728050878108;6814;6829.112215411965;6842.55523390978;7063.894041589483;7161.534500257467;7210.387117095106;7224.674889629874;7240;4560.4071470708595;4618.422697162855;4619.35329053926;4634.698744581591;4635.281531362644;6895;6923.376896079377;6945.305469453217;6952.5480843745;6957.79126626202;6671.666416679243;6749.190097188172;6774.254831968578;6784.660766961731;6785.5250132490255;6695.163104611924;6709.832254193489;6712.127423435118;6723.495737819585;6738.46092312604;6589.6375699336995;6594.70323835419;6608.50436217276;6617.735290588515;6620.966895165493;6619.172603424572;6757.851165302009;6765.797026089225;6779.8983015253825;6792.558483698742;6482.319356467503;6547.1161393211305;6550.115734375799;6566.310537393505;6568.6058836469965 17:09:47 INFO - PROCESS | 3450 | |5;yui.html;696.4672025900187;729.9416046716264;751.5678484871199;763.9236076392361;790.1821614628853;14634.414623415063;14805.629859253524;14825.92587037066;14829.406823727051;14837.18395488249;11584.07327413807;11647.184697071209;11658.766824663502;11666.941665291663;11694.356810375426;788.6805843633323;792.7463211772235;800.1838125112382;801.2988634944423;806.5080301016376;799.3046049936563;799.808046068945;802.6869520886859;805.2269820971874;806.9193080691913;821.9219174178473;823.9629216685264;827.2554700769296;827.4249396669318;827.6482494939627;824.8680211166185;825.1377310710262;825.2201669422399;826.3017750001269;828.2545708862042;599.1641659884481;604.8155312629647;606.0969155957636;609.9237595300588;610.261583483985;13270;13371.26458044807;13414.061015728903;13425.328733563381;13427.194368337834;11278.548858045668;11465.140114491447;11494.287252497494;11543.13426493008;11655.184137110406;9195.264618394525;9889.357191782512;9897.257705672104;10143.442110683984;10487.842682359771;3454.827258637058;3481.791092534431;3508.6491350864962;3586.3903136466865;3600.837962291703;47933;48481.75759121182;48595.75702121467;48618;48720;8535.573221338907;8924.687635932842;8945.23965462943;9068.8639670405;9189.448633082036;16560.089195094384;16648;16733.748993765104;16740.49778506647;16746.74879876803;6525.765333914354;6594.472442204612;6604.933950660528;6730.764423245163;6835.418989385858;3961.207758448264;4083.6324730773777;4156.771377574202;4211.052513184571;4322.589354011427;2982.075556577468;2994.446027484922;3011.698830116971;3025.3646734185627;3038.3923215357017;543.6303313746611;551.3604219105898;556.2157358125024;566.9914951275734;567.9176519404663;442.11356230757127;491.39803740418415;523.9240310155006;562.7748900439857;587.8038142817429;7764.883526747103;7804.921950780533;7886.842263154705;7890.802729931797;8126.878096828552;501.490986648552;614.4316507230883;618.1346115438422;631.0754744299624;645.8320836582428;3455.101673564841;3671.3295450569926;3728.2357116790995;3825.2349530094093;3890.5331360236387;50610.74694626577;51372;51693.7415312921;51896;51922.22116668253;49801.750991244815;51189.74405127951;51343;51370.486295137314;51729.48270517322;45881.541184587724;46149.7692511542;46351.76824115858;46382;46709;7527.924720752722;7638.732644357421;7717.536947783151;7834.882476762739;7903.486273392211;34391.656083438844;34471;34590.481142783385;34778.652213477544;34904.47643285403;42081.57918420777;42168.1566368677;43809.56190438182;46486.76756616195;47172;9872.85190722154;10093.444860532742;10109.545070471699;10225.181985441295;10333.225008124271;11788.469518871843;12191.75616487683;12204.267743935392;12863.742725145257;12885.871141288842;11002.889971100507;11087.33475991443;11226.045786108272;11315.943420282845;11608.6517404478;10925.726856828325;11284;11296;11355.716107097389;11727.889941926174;10472.21458390639;11167.274127181707;11365.772684546428;11596.304221746723;11758.58844940423;9136.771580710536;9153.63385464574;9179.816403672023;9244.306676999386;9757.170640495353;8499.447535910145;8575.356848236532;8959.491660047554;9151.450912945245;9163.22112620408 17:09:47 INFO - PROCESS | 3450 | __end_tp_report 17:09:47 INFO - PROCESS | 3450 | __start_cc_report 17:09:47 INFO - PROCESS | 3450 | _x_x_mozilla_cycle_collect,304 17:09:47 INFO - PROCESS | 3450 | __end_cc_report 17:09:47 INFO - PROCESS | 3450 | __startTimestamp1453770587723__endTimestamp 17:09:47 INFO - PROCESS | 3450 | 17:09:47 INFO - PROCESS | 3450 | ------- Summary: start ------- 17:09:47 INFO - PROCESS | 3450 | Number of tests: 6 17:09:47 INFO - PROCESS | 3450 | 17:09:47 INFO - PROCESS | 3450 | [#0] dojo.html Cycles:165 Average:5162.00 Median:5358.38 stddev:560.63 (10.5%) stddev-sans-first:538.72 17:09:47 INFO - PROCESS | 3450 | Values: 3108.9 3113.7 3135.5 3138.4 3165.8 5100.6 5114.8 5134.0 5173.9 5196.6 5173.6 5190.0 5221.1 5245.4 5268.3 4471.2 4706.6 4861.1 4872.6 4910.8 4706.8 4783.4 4824.1 4849.6 4857.8 4702.0 4783.4 4792.7 4795.5 4797.9 4664.2 4684.1 4689.2 4705.0 4715.8 4619.4 4653.8 4662.8 4683.2 4697.8 5012.7 5015.8 5019.6 5056.3 5095.1 5531.0 5566.8 5572.7 5578.9 5636.5 5543.1 5567.6 5604.9 5615.3 5625.2 5227.3 5242.8 5252.8 5257.2 5286.2 5675.6 5675.9 5688.3 5689.8 5729.6 5322.8 5379.4 5475.7 5480.9 5576.8 5476.3 5482.8 5483.3 5490.3 5500.5 5455.7 5458.0 5462.4 5488.1 5502.3 5437.9 5466.4 5466.5 5498.5 5570.3 4289.4 4291.5 4292.7 4299.8 4315.8 3854.4 3876.8 3893.6 3908.8 3910.0 5225.6 5253.4 5275.2 5309.1 5338.1 5494.3 5501.7 5529.8 5542.1 5548.5 5142.4 5204.2 5217.6 5236.8 5261.5 4733.3 4735.7 4767.9 4806.4 4833.8 5767.7 5783.0 5785.0 5807.3 5814.9 5464.9 5505.4 5581.7 5599.6 5654.5 5779.0 5783.7 5815.9 5836.8 5883.3 5396.8 5403.5 5405.1 5416.9 5434.9 5387.2 5431.5 5447.9 5497.9 5509.4 5427.0 5428.9 5473.2 5510.6 5529.6 5424.1 5452.7 5470.5 5481.8 5487.9 5298.1 5358.4 5394.7 5398.5 5438.6 5385.6 5449.9 5527.8 5529.3 5560.5 5239.2 5259.7 5280.4 5303.3 5322.4 17:09:47 INFO - PROCESS | 3450 | 17:09:47 INFO - PROCESS | 3450 | [#1] ext.html Cycles:180 Average:38217.73 Median:34246.41 stddev:58616.33 (171.2%) stddev-sans-first:58712.44 17:09:47 INFO - PROCESS | 3450 | Values: 524.1 541.7 546.2 547.1 550.6 34629.0 34761.8 35096.1 35106.6 35187.3 35788.8 35858.1 36143.5 36269.3 36279.8 8248.7 8411.4 8421.4 8434.8 8488.2 8171.3 8343.0 8359.3 8428.7 8432.3 8414.3 8414.5 8532.4 8533.4 8549.8 8438.0 8501.1 8503.9 8505.5 8544.4 8317.2 8349.9 8382.3 8404.8 8443.5 34406.0 34569.5 34614.1 34659.3 34725.0 2955.3 3034.6 3071.2 3276.2 3307.2 29756.4 29857.9 29923.1 29962.4 30170.1 3570.3 3710.9 3715.0 3740.9 3822.8 189183.0 190551.0 190644.0 191158.0 191677.0 49151.3 49393.8 54098.9 54318.2 54409.5 64440.4 65928.7 66099.0 66260.0 66369.7 10846.1 11016.9 11071.7 11094.9 11108.6 8727.8 8764.8 8766.3 8776.5 8807.6 17618.8 17653.7 17818.4 17851.6 17868.4 7293.7 7511.7 7513.0 7560.2 7619.1 927.9 943.5 958.9 1006.8 1058.0 27567.0 27725.0 28063.6 28124.2 28282.3 1008.8 1017.7 1024.3 1069.0 1085.6 14263.3 14579.4 14713.2 14917.6 14930.9 130431.3 134954.3 135373.0 135381.0 304468.0 47161.0 47371.8 47867.2 48053.3 48102.8 1263.5 1271.5 1275.7 1280.9 1382.4 25655.4 26456.2 26723.6 26926.5 27104.6 42591.8 42714.6 42929.0 43123.8 43130.4 282316.0 282871.0 284839.0 285138.0 285712.0 29701.9 29948.9 30159.7 30237.5 31565.2 35021.6 35574.5 35928.0 35947.8 36535.8 32837.5 33159.3 33672.8 33849.7 34240.8 32946.4 33609.3 33697.3 34043.7 34252.0 33314.2 33395.7 33787.5 33850.5 33850.8 29418.3 30032.7 30929.5 31289.5 31663.2 23672.8 23715.8 23825.2 23969.3 24187.0 17:09:47 INFO - PROCESS | 3450 | 17:09:47 INFO - PROCESS | 3450 | [#2] jquery.html Cycles:180 Average:25216.00 Median:4742.61 stddev:75096.29 (1583.4%) stddev-sans-first:75283.77 17:09:47 INFO - PROCESS | 3450 | Values: 360.8 362.5 362.6 366.2 367.8 15001.5 15990.0 16562.5 16879.8 17147.7 14156.5 14522.0 14652.7 14715.0 14741.4 4461.8 4717.3 4729.7 4738.5 4740.3 4350.9 4650.3 4683.4 4721.3 4744.9 4830.6 4888.8 5096.2 5293.6 5350.0 5060.5 5061.7 5072.9 5086.2 5120.9 5139.6 5144.8 5145.9 5152.2 5176.6 11588.7 14131.6 18550.9 19327.1 19358.2 2005.6 2052.0 2098.7 2104.7 2218.6 8831.7 8888.5 9024.2 9049.1 9493.7 1757.8 1785.9 1788.7 1793.1 1802.5 52719.2 54344.2 55543.4 56144.4 56952.4 14508.5 14850.0 14877.8 15029.4 15190.0 21468.1 21580.6 21654.4 21761.7 21780.6 7547.1 7631.3 7634.2 7719.0 7807.8 6201.5 6231.4 6250.3 6258.6 6283.4 7377.4 7484.4 7509.3 7516.6 7534.1 1748.0 3027.6 3055.1 3120.5 3124.1 820.2 899.2 922.1 982.8 988.9 15537.8 16067.1 16097.5 16240.2 16387.4 856.8 878.1 881.2 960.3 976.2 8706.2 9479.2 9542.9 9564.2 9583.1 441617.0 443982.0 450132.2 453537.0 506782.0 66266.7 67552.7 68938.3 69624.3 70488.6 1089.1 1097.7 1107.5 1109.3 1122.7 14147.7 14700.9 14887.6 14956.7 15250.9 31683.2 31987.7 32617.7 32824.0 33795.0 38306.8 38574.6 38953.0 39058.6 39955.0 6929.6 6960.3 7011.6 7056.3 7301.4 10233.3 11392.7 11573.8 11779.5 11803.2 9183.5 9543.5 9579.2 9871.6 10181.0 9196.2 9452.1 9567.9 9578.6 9686.3 9617.5 9724.8 9740.6 10041.0 10086.8 6802.9 6905.9 6981.8 6987.0 7025.3 8591.9 9846.3 9856.5 9886.1 9920.9 17:09:47 INFO - PROCESS | 3450 | 17:09:47 INFO - PROCESS | 3450 | [#3] mootools.html Cycles:180 Average:5483.16 Median:6307.54 stddev:2865.19 (45.4%) stddev-sans-first:2857.26 17:09:47 INFO - PROCESS | 3450 | Values: 1458.2 1489.9 1644.6 1740.5 1768.9 7520.5 7544.4 7688.5 7915.2 7915.9 7827.1 7929.7 7946.8 8001.1 8010.2 2351.8 2373.7 2380.4 2386.9 2392.3 2370.7 2385.2 2394.3 2398.6 2399.7 2265.9 2321.7 2322.1 2328.3 2345.9 2317.3 2331.6 2356.8 2362.0 2363.9 2316.4 2317.2 2336.2 2337.2 2340.8 7738.4 7783.1 7786.6 7828.2 7835.8 4692.9 4840.6 4865.5 4866.6 4868.9 3015.8 3016.2 3069.8 3104.8 3107.9 851.3 857.3 866.4 899.9 921.4 10892.5 10968.2 11045.0 11061.2 11067.4 4208.3 4291.8 4319.0 4334.9 4356.1 8899.6 8899.6 8934.4 8946.1 8968.0 4801.5 4805.4 4817.3 4833.5 4835.0 4366.4 4379.8 4409.8 4423.4 4440.0 3426.8 3429.4 3453.8 3454.4 3464.2 1003.1 1034.3 1052.7 1060.1 1061.2 982.7 1062.0 1140.9 1166.3 1267.5 7022.6 7032.2 7038.0 7080.0 7091.7 1030.9 1073.1 1076.7 1098.5 1103.7 5739.6 5828.5 5842.6 5844.5 5925.7 9358.3 9414.0 9756.6 9862.1 9905.4 9595.6 9611.0 9625.3 9686.9 9760.4 7299.8 7442.2 7599.2 7601.2 7654.2 7206.3 7243.7 7245.4 7265.0 7295.3 8492.7 8554.6 8754.6 8777.2 8844.5 8595.6 8746.6 8802.3 8812.6 8917.6 6823.5 6877.0 6879.3 6910.8 6941.5 7284.7 7304.9 7342.7 7362.7 7373.5 6309.4 6914.1 7236.9 7267.0 7419.0 6305.7 6576.1 6881.3 6956.0 6972.8 6293.1 6753.2 6859.3 6879.4 6884.9 6050.5 6079.7 6087.0 6087.9 6092.9 6374.7 6383.3 6406.2 6420.9 6443.5 17:09:47 INFO - PROCESS | 3450 | 17:09:47 INFO - PROCESS | 3450 | [#4] prototype.html Cycles:180 Average:5552.97 Median:6283.28 stddev:1693.62 (27.0%) stddev-sans-first:1652.25 17:09:47 INFO - PROCESS | 3450 | Values: 322.9 331.7 332.5 334.0 336.6 6137.4 6225.0 6279.7 6324.5 6336.0 6013.7 6149.7 6168.7 6178.4 6188.8 4755.7 4756.1 4760.6 4771.1 4778.6 4769.3 4769.6 4772.8 4773.9 4785.9 4655.8 4695.7 4722.9 4724.3 4725.8 4698.0 4704.7 4714.5 4716.7 4726.1 3921.6 4002.0 4133.9 4136.5 4142.8 5761.7 5896.9 5911.6 5966.4 5991.4 5442.7 5453.2 5474.6 5479.0 5502.4 6455.2 6576.0 6601.2 6603.0 6614.6 4573.5 4579.0 4583.0 4584.8 4592.9 6858.1 6879.4 6885.0 6888.1 6906.6 4656.6 4658.1 4690.6 4691.6 4692.9 4651.4 4740.2 4760.8 4762.3 4771.4 5476.0 5483.4 5488.1 5491.4 5501.2 6578.7 6635.2 6635.5 6640.9 6670.9 1664.7 1702.5 1703.7 1704.1 1713.1 1122.3 1127.0 1130.5 1140.2 1157.8 6214.1 6294.0 6296.8 6313.8 6326.3 6788.9 6845.8 6852.8 6854.9 6875.7 6199.6 6273.7 6286.8 6300.9 6306.5 3721.2 3724.8 3725.6 3730.8 3741.7 7021.6 7186.9 7230.9 7259.2 7266.2 6977.5 6993.5 7040.6 7041.0 7057.5 7097.2 7204.7 7210.4 7216.0 7240.9 6908.7 6914.1 6918.7 6928.1 6952.2 6782.2 6798.7 6814.0 6829.1 6842.6 7063.9 7161.5 7210.4 7224.7 7240.0 4560.4 4618.4 4619.4 4634.7 4635.3 6895.0 6923.4 6945.3 6952.5 6957.8 6671.7 6749.2 6774.3 6784.7 6785.5 6695.2 6709.8 6712.1 6723.5 6738.5 6589.6 6594.7 6608.5 6617.7 6621.0 6619.2 6757.9 6765.8 6779.9 6792.6 6482.3 6547.1 6550.1 6566.3 6568.6 17:09:47 INFO - PROCESS | 3450 | 17:09:47 INFO - PROCESS | 3450 | [#5] yui.html Cycles:180 Average:13351.26 Median:48669.00 stddev:15550.65 (32.0%) stddev-sans-first:15565.23 17:09:47 INFO - PROCESS | 3450 | Values: 696.5 729.9 751.6 763.9 790.2 14634.4 14805.6 14825.9 14829.4 14837.2 11584.1 11647.2 11658.8 11666.9 11694.4 788.7 792.7 800.2 801.3 806.5 799.3 799.8 802.7 805.2 806.9 821.9 824.0 827.3 827.4 827.6 824.9 825.1 825.2 826.3 828.3 599.2 604.8 606.1 609.9 610.3 13270.0 13371.3 13414.1 13425.3 13427.2 11278.5 11465.1 11494.3 11543.1 11655.2 9195.3 9889.4 9897.3 10143.4 10487.8 3454.8 3481.8 3508.6 3586.4 3600.8 47933.0 48481.8 48595.8 48618.0 48720.0 8535.6 8924.7 8945.2 9068.9 9189.4 16560.1 16648.0 16733.7 16740.5 16746.7 6525.8 6594.5 6604.9 6730.8 6835.4 3961.2 4083.6 4156.8 4211.1 4322.6 2982.1 2994.4 3011.7 3025.4 3038.4 543.6 551.4 556.2 567.0 567.9 442.1 491.4 523.9 562.8 587.8 7764.9 7804.9 7886.8 7890.8 8126.9 501.5 614.4 618.1 631.1 645.8 3455.1 3671.3 3728.2 3825.2 3890.5 50610.7 51372.0 51693.7 51896.0 51922.2 49801.8 51189.7 51343.0 51370.5 51729.5 45881.5 46149.8 46351.8 46382.0 46709.0 7527.9 7638.7 7717.5 7834.9 7903.5 34391.7 34471.0 34590.5 34778.7 34904.5 42081.6 42168.2 43809.6 46486.8 47172.0 9872.9 10093.4 10109.5 10225.2 10333.2 11788.5 12191.8 12204.3 12863.7 12885.9 11002.9 11087.3 11226.0 11315.9 11608.7 10925.7 11284.0 11296.0 11355.7 11727.9 10472.2 11167.3 11365.8 11596.3 11758.6 9136.8 9153.6 9179.8 9244.3 9757.2 8499.4 8575.4 8959.5 9151.5 9163.2 17:09:47 INFO - PROCESS | 3450 | -------- Summary: end -------- 17:09:47 INFO - PROCESS | 3450 | 17:09:48 INFO - TEST-INFO | 3450: exit 0 17:09:48 INFO - TEST-OK | dromaeo_css | took 1112541ms 17:09:48 INFO - TEST-START | kraken 17:09:48 INFO - operating with platform_type : linux_ 17:09:48 INFO - Initialising browser for kraken test... 17:09:48 INFO - TEST-INFO | started process 3694 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSAkek8/profile http://localhost:58998/getInfo.html) 17:09:52 INFO - PROCESS | 3694 | 17:09:52 INFO - PROCESS | 3694 | (process:3768): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:09:53 INFO - PROCESS | 3694 | __metrics Screen width/height:1600/1200 17:09:53 INFO - PROCESS | 3694 | colorDepth:24 17:09:53 INFO - PROCESS | 3694 | Browser inner width/height: 1024/697 17:09:53 INFO - PROCESS | 3694 | __metrics 17:09:53 INFO - PROCESS | 3694 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:09:54 INFO - TEST-INFO | 3694: exit 0 17:09:54 INFO - Browser initialized. 17:09:54 INFO - Running cycle 1/1 for kraken test... 17:09:54 INFO - TEST-INFO | started process 3817 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSAkek8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:09:55 INFO - PROCESS | 3817 | 17:09:55 INFO - PROCESS | 3817 | (process:3876): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:10:05 INFO - PROCESS | 3817 | RSS: Main: 152104960 17:10:05 INFO - PROCESS | 3817 | 17:10:08 INFO - PROCESS | 3817 | Cycle 1(1): loaded http://localhost:58998/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58998/tests/kraken/driver.html?testName=audio-beat-detection) 17:10:08 INFO - PROCESS | 3817 | RSS: Main: 155377664 17:10:08 INFO - PROCESS | 3817 | 17:10:11 INFO - PROCESS | 3817 | Cycle 1(1): loaded http://localhost:58998/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58998/tests/kraken/driver.html?testName=audio-dft) 17:10:12 INFO - PROCESS | 3817 | RSS: Main: 159617024 17:10:12 INFO - PROCESS | 3817 | 17:10:15 INFO - PROCESS | 3817 | Cycle 1(1): loaded http://localhost:58998/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58998/tests/kraken/driver.html?testName=audio-fft) 17:10:15 INFO - PROCESS | 3817 | RSS: Main: 153284608 17:10:15 INFO - PROCESS | 3817 | 17:10:17 INFO - PROCESS | 3817 | Cycle 1(1): loaded http://localhost:58998/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58998/tests/kraken/driver.html?testName=audio-oscillator) 17:10:18 INFO - PROCESS | 3817 | RSS: Main: 152969216 17:10:18 INFO - PROCESS | 3817 | 17:10:20 INFO - PROCESS | 3817 | Cycle 1(1): loaded http://localhost:58998/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58998/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:10:21 INFO - PROCESS | 3817 | RSS: Main: 153817088 17:10:21 INFO - PROCESS | 3817 | 17:10:24 INFO - PROCESS | 3817 | Cycle 1(1): loaded http://localhost:58998/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58998/tests/kraken/driver.html?testName=imaging-darkroom) 17:10:24 INFO - PROCESS | 3817 | RSS: Main: 154693632 17:10:24 INFO - PROCESS | 3817 | 17:10:27 INFO - PROCESS | 3817 | Cycle 1(1): loaded http://localhost:58998/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58998/tests/kraken/driver.html?testName=imaging-desaturate) 17:10:28 INFO - PROCESS | 3817 | RSS: Main: 154779648 17:10:28 INFO - PROCESS | 3817 | 17:10:31 INFO - PROCESS | 3817 | Cycle 1(1): loaded http://localhost:58998/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58998/tests/kraken/driver.html?testName=json-parse-financial) 17:10:32 INFO - PROCESS | 3817 | RSS: Main: 153755648 17:10:32 INFO - PROCESS | 3817 | 17:10:33 INFO - PROCESS | 3817 | Cycle 1(1): loaded http://localhost:58998/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58998/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:10:34 INFO - PROCESS | 3817 | RSS: Main: 154628096 17:10:34 INFO - PROCESS | 3817 | 17:10:36 INFO - PROCESS | 3817 | Cycle 1(1): loaded http://localhost:58998/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58998/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:10:36 INFO - PROCESS | 3817 | RSS: Main: 154447872 17:10:36 INFO - PROCESS | 3817 | 17:10:39 INFO - PROCESS | 3817 | Cycle 1(1): loaded http://localhost:58998/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58998/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:10:39 INFO - PROCESS | 3817 | RSS: Main: 155086848 17:10:39 INFO - PROCESS | 3817 | 17:10:41 INFO - PROCESS | 3817 | Cycle 1(1): loaded http://localhost:58998/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58998/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:10:42 INFO - PROCESS | 3817 | RSS: Main: 154529792 17:10:42 INFO - PROCESS | 3817 | 17:10:44 INFO - PROCESS | 3817 | Cycle 1(1): loaded http://localhost:58998/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58998/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:10:45 INFO - PROCESS | 3817 | RSS: Main: 153210880 17:10:45 INFO - PROCESS | 3817 | 17:10:47 INFO - PROCESS | 3817 | Cycle 1(1): loaded http://localhost:58998/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58998/tests/kraken/driver.html?testName=ai-astar) 17:10:47 INFO - PROCESS | 3817 | RSS: Main: 156209152 17:10:47 INFO - PROCESS | 3817 | 17:10:47 INFO - PROCESS | 3817 | __start_tp_report 17:10:47 INFO - PROCESS | 3817 | _x_x_mozilla_page_load 17:10:47 INFO - PROCESS | 3817 | _x_x_mozilla_page_load_details 17:10:47 INFO - PROCESS | 3817 | |i|pagename|runs| 17:10:47 INFO - PROCESS | 3817 | |0;ai-astar;112;105;110;109;109;122;110;110;111;112 17:10:47 INFO - PROCESS | 3817 | |1;audio-beat-detection;155;127;151;158;135;151;150;129;158;127 17:10:47 INFO - PROCESS | 3817 | |2;audio-dft;162;163;162;162;163;163;161;162;167;160 17:10:47 INFO - PROCESS | 3817 | |3;audio-fft;72;72;73;73;74;147;77;86;72;76 17:10:47 INFO - PROCESS | 3817 | |4;audio-oscillator;96;96;153;96;96;98;142;96;104;142 17:10:47 INFO - PROCESS | 3817 | |5;imaging-gaussian-blur;110;110;110;109;109;110;110;110;109;110 17:10:47 INFO - PROCESS | 3817 | |6;imaging-darkroom;145;147;147;148;146;146;147;147;147;146 17:10:47 INFO - PROCESS | 3817 | |7;imaging-desaturate;96;97;96;96;96;96;96;97;97;97 17:10:47 INFO - PROCESS | 3817 | |8;json-parse-financial;60;61;60;61;61;60;61;61;70;58 17:10:47 INFO - PROCESS | 3817 | |9;json-stringify-tinderbox;67;67;67;67;69;67;67;67;68;68 17:10:47 INFO - PROCESS | 3817 | |10;stanford-crypto-aes;83;83;84;84;83;88;83;84;90;92 17:10:47 INFO - PROCESS | 3817 | |11;stanford-crypto-ccm;119;123;120;125;117;133;118;124;118;119 17:10:47 INFO - PROCESS | 3817 | |12;stanford-crypto-pbkdf2;143;151;148;152;151;143;147;148;151;149 17:10:47 INFO - PROCESS | 3817 | |13;stanford-crypto-sha256-iterative;70;72;70;71;69;67;70;72;74;68 17:10:47 INFO - PROCESS | 3817 | __end_tp_report 17:10:47 INFO - PROCESS | 3817 | __start_cc_report 17:10:47 INFO - PROCESS | 3817 | _x_x_mozilla_cycle_collect,725 17:10:47 INFO - PROCESS | 3817 | __end_cc_report 17:10:47 INFO - PROCESS | 3817 | __startTimestamp1453770647440__endTimestamp 17:10:47 INFO - PROCESS | 3817 | 17:10:47 INFO - PROCESS | 3817 | ------- Summary: start ------- 17:10:47 INFO - PROCESS | 3817 | Number of tests: 14 17:10:47 INFO - PROCESS | 3817 | 17:10:47 INFO - PROCESS | 3817 | [#0] ai-astar Cycles:10 Average:111.00 Median:110.50 stddev:4.35 (3.9%) stddev-sans-first:4.59 17:10:47 INFO - PROCESS | 3817 | Values: 112.0 105.0 110.0 109.0 109.0 122.0 110.0 110.0 111.0 112.0 17:10:47 INFO - PROCESS | 3817 | 17:10:47 INFO - PROCESS | 3817 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:151.00 stddev:13.04 (8.6%) stddev-sans-first:13.22 17:10:47 INFO - PROCESS | 3817 | Values: 155.0 127.0 151.0 158.0 135.0 151.0 150.0 129.0 158.0 127.0 17:10:47 INFO - PROCESS | 3817 | 17:10:47 INFO - PROCESS | 3817 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.50 stddev:1.84 (1.1%) stddev-sans-first:1.94 17:10:47 INFO - PROCESS | 3817 | Values: 162.0 163.0 162.0 162.0 163.0 163.0 161.0 162.0 167.0 160.0 17:10:47 INFO - PROCESS | 3817 | 17:10:47 INFO - PROCESS | 3817 | [#3] audio-fft Cycles:10 Average:82.20 Median:73.50 stddev:23.16 (31.5%) stddev-sans-first:24.27 17:10:47 INFO - PROCESS | 3817 | Values: 72.0 72.0 73.0 73.0 74.0 147.0 77.0 86.0 72.0 76.0 17:10:47 INFO - PROCESS | 3817 | 17:10:47 INFO - PROCESS | 3817 | [#4] audio-oscillator Cycles:10 Average:111.90 Median:96.00 stddev:23.62 (24.6%) stddev-sans-first:24.34 17:10:47 INFO - PROCESS | 3817 | Values: 96.0 96.0 153.0 96.0 96.0 98.0 142.0 96.0 104.0 142.0 17:10:47 INFO - PROCESS | 3817 | 17:10:47 INFO - PROCESS | 3817 | [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 17:10:47 INFO - PROCESS | 3817 | Values: 110.0 110.0 110.0 109.0 109.0 110.0 110.0 110.0 109.0 110.0 17:10:47 INFO - PROCESS | 3817 | 17:10:47 INFO - PROCESS | 3817 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.84 (0.6%) stddev-sans-first:0.67 17:10:47 INFO - PROCESS | 3817 | Values: 145.0 147.0 147.0 148.0 146.0 146.0 147.0 147.0 147.0 146.0 17:10:47 INFO - PROCESS | 3817 | 17:10:47 INFO - PROCESS | 3817 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 17:10:47 INFO - PROCESS | 3817 | Values: 96.0 97.0 96.0 96.0 96.0 96.0 96.0 97.0 97.0 97.0 17:10:47 INFO - PROCESS | 3817 | 17:10:47 INFO - PROCESS | 3817 | [#8] json-parse-financial Cycles:10 Average:61.30 Median:61.00 stddev:3.20 (5.2%) stddev-sans-first:3.36 17:10:47 INFO - PROCESS | 3817 | Values: 60.0 61.0 60.0 61.0 61.0 60.0 61.0 61.0 70.0 58.0 17:10:47 INFO - PROCESS | 3817 | 17:10:47 INFO - PROCESS | 3817 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 17:10:47 INFO - PROCESS | 3817 | Values: 67.0 67.0 67.0 67.0 69.0 67.0 67.0 67.0 68.0 68.0 17:10:47 INFO - PROCESS | 3817 | 17:10:47 INFO - PROCESS | 3817 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:84.00 stddev:3.34 (4.0%) stddev-sans-first:3.43 17:10:47 INFO - PROCESS | 3817 | Values: 83.0 83.0 84.0 84.0 83.0 88.0 83.0 84.0 90.0 92.0 17:10:47 INFO - PROCESS | 3817 | 17:10:47 INFO - PROCESS | 3817 | [#11] stanford-crypto-ccm Cycles:10 Average:121.60 Median:121.50 stddev:4.86 (4.0%) stddev-sans-first:5.06 17:10:47 INFO - PROCESS | 3817 | Values: 119.0 123.0 120.0 125.0 117.0 133.0 118.0 124.0 118.0 119.0 17:10:47 INFO - PROCESS | 3817 | 17:10:47 INFO - PROCESS | 3817 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.30 Median:150.00 stddev:3.23 (2.2%) stddev-sans-first:2.80 17:10:47 INFO - PROCESS | 3817 | Values: 143.0 151.0 148.0 152.0 151.0 143.0 147.0 148.0 151.0 149.0 17:10:47 INFO - PROCESS | 3817 | 17:10:47 INFO - PROCESS | 3817 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:70.50 stddev:2.06 (2.9%) stddev-sans-first:2.18 17:10:47 INFO - PROCESS | 3817 | Values: 70.0 72.0 70.0 71.0 69.0 67.0 70.0 72.0 74.0 68.0 17:10:47 INFO - PROCESS | 3817 | -------- Summary: end -------- 17:10:47 INFO - PROCESS | 3817 | 17:10:48 INFO - TEST-INFO | 3817: exit 0 17:10:48 INFO - TEST-OK | kraken | took 59951ms 17:10:48 INFO - TEST-START | v8_7 17:10:48 INFO - operating with platform_type : linux_ 17:10:48 INFO - Initialising browser for v8_7 test... 17:10:48 INFO - TEST-INFO | started process 4105 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpETyFwZ/profile http://localhost:58998/getInfo.html) 17:10:52 INFO - PROCESS | 4105 | 17:10:52 INFO - PROCESS | 4105 | (process:4175): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:10:53 INFO - PROCESS | 4105 | __metrics Screen width/height:1600/1200 17:10:53 INFO - PROCESS | 4105 | colorDepth:24 17:10:53 INFO - PROCESS | 4105 | Browser inner width/height: 1024/697 17:10:53 INFO - PROCESS | 4105 | __metrics 17:10:53 INFO - PROCESS | 4105 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:10:53 INFO - TEST-INFO | 4105: exit 0 17:10:53 INFO - Browser initialized. 17:10:53 INFO - Running cycle 1/1 for v8_7 test... 17:10:53 INFO - TEST-INFO | started process 4224 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpETyFwZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:10:55 INFO - PROCESS | 4224 | 17:10:55 INFO - PROCESS | 4224 | (process:4284): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:11:05 INFO - PROCESS | 4224 | RSS: Main: 150663168 17:11:05 INFO - PROCESS | 4224 | 17:11:28 INFO - PROCESS | 4224 | Cycle 1(1): loaded http://localhost:58998/tests/v8_7/run.html (next: http://localhost:58998/tests/v8_7/run.html) 17:11:28 INFO - PROCESS | 4224 | RSS: Main: 151945216 17:11:28 INFO - PROCESS | 4224 | 17:11:28 INFO - PROCESS | 4224 | __start_tp_report 17:11:28 INFO - PROCESS | 4224 | _x_x_mozilla_page_load 17:11:28 INFO - PROCESS | 4224 | _x_x_mozilla_page_load_details 17:11:28 INFO - PROCESS | 4224 | |i|pagename|runs| 17:11:28 INFO - PROCESS | 4224 | |0;Richards;170.590242238144 17:11:28 INFO - PROCESS | 4224 | |1;DeltaBlue;189.000189000189 17:11:28 INFO - PROCESS | 4224 | |2;Encrypt;279.79854504756577 17:11:28 INFO - PROCESS | 4224 | |3;Decrypt;5223.958333333333 17:11:28 INFO - PROCESS | 4224 | |4;RayTrace;1070.6638115631692 17:11:28 INFO - PROCESS | 4224 | |5;Earley;711.4427860696518 17:11:28 INFO - PROCESS | 4224 | |6;Boyer;12345.67901234568 17:11:28 INFO - PROCESS | 4224 | |7;RegExp;40725.490196078434 17:11:28 INFO - PROCESS | 4224 | |8;Splay;570.7762557077625 17:11:28 INFO - PROCESS | 4224 | |9;NavierStokes;4817.307692307692 17:11:28 INFO - PROCESS | 4224 | __end_tp_report 17:11:28 INFO - PROCESS | 4224 | __startTimestamp1453770688495__endTimestamp 17:11:28 INFO - PROCESS | 4224 | 17:11:28 INFO - PROCESS | 4224 | ------- Summary: start ------- 17:11:28 INFO - PROCESS | 4224 | Number of tests: 10 17:11:28 INFO - PROCESS | 4224 | 17:11:28 INFO - PROCESS | 4224 | [#0] Richards Cycles:1 Average:170.59 Median:170.59 stddev:0.00 (0.0%) 17:11:28 INFO - PROCESS | 4224 | Values: 170.6 17:11:28 INFO - PROCESS | 4224 | 17:11:28 INFO - PROCESS | 4224 | [#1] DeltaBlue Cycles:1 Average:189.00 Median:189.00 stddev:0.00 (0.0%) 17:11:28 INFO - PROCESS | 4224 | Values: 189.0 17:11:28 INFO - PROCESS | 4224 | 17:11:28 INFO - PROCESS | 4224 | [#2] Encrypt Cycles:1 Average:279.80 Median:279.80 stddev:0.00 (0.0%) 17:11:28 INFO - PROCESS | 4224 | Values: 279.8 17:11:28 INFO - PROCESS | 4224 | 17:11:28 INFO - PROCESS | 4224 | [#3] Decrypt Cycles:1 Average:5223.96 Median:5223.96 stddev:0.00 (0.0%) 17:11:28 INFO - PROCESS | 4224 | Values: 5224.0 17:11:28 INFO - PROCESS | 4224 | 17:11:28 INFO - PROCESS | 4224 | [#4] RayTrace Cycles:1 Average:1070.66 Median:1070.66 stddev:0.00 (0.0%) 17:11:28 INFO - PROCESS | 4224 | Values: 1070.7 17:11:28 INFO - PROCESS | 4224 | 17:11:28 INFO - PROCESS | 4224 | [#5] Earley Cycles:1 Average:711.44 Median:711.44 stddev:0.00 (0.0%) 17:11:28 INFO - PROCESS | 4224 | Values: 711.4 17:11:28 INFO - PROCESS | 4224 | 17:11:28 INFO - PROCESS | 4224 | [#6] Boyer Cycles:1 Average:12345.68 Median:12345.68 stddev:0.00 (0.0%) 17:11:28 INFO - PROCESS | 4224 | Values: 12345.7 17:11:28 INFO - PROCESS | 4224 | 17:11:28 INFO - PROCESS | 4224 | [#7] RegExp Cycles:1 Average:40725.49 Median:40725.49 stddev:0.00 (0.0%) 17:11:28 INFO - PROCESS | 4224 | Values: 40725.5 17:11:28 INFO - PROCESS | 4224 | 17:11:28 INFO - PROCESS | 4224 | [#8] Splay Cycles:1 Average:570.78 Median:570.78 stddev:0.00 (0.0%) 17:11:28 INFO - PROCESS | 4224 | Values: 570.8 17:11:28 INFO - PROCESS | 4224 | 17:11:28 INFO - PROCESS | 4224 | [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 17:11:28 INFO - PROCESS | 4224 | Values: 4817.3 17:11:28 INFO - PROCESS | 4224 | -------- Summary: end -------- 17:11:28 INFO - PROCESS | 4224 | 17:11:29 INFO - TEST-INFO | 4224: exit 0 17:11:29 INFO - TEST-OK | v8_7 | took 41086ms 17:11:29 INFO - SUITE-END | took 1213s 17:11:29 INFO - Completed test suite (00:20:13) 17:11:29 INFO - Working with test: dromaeo_css 17:11:29 INFO - Generating results file: dromaeo_css 17:11:29 INFO - Working with test: kraken 17:11:29 INFO - Generating results file: kraken 17:11:29 INFO - javascript benchmark 17:11:29 INFO - Working with test: v8_7 17:11:29 INFO - Generating results file: v8_7 17:11:29 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:11:29 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 17:11:29 INFO - process_Request line: dromaeo_css 6766.21 graph.html#tests=[[72,64,43]] 17:11:29 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:11:29 INFO - process_Request line: kraken 1518.70 graph.html#tests=[[232,64,43]] 17:11:29 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:11:29 INFO - process_Request line: v8_7 20441.51 graph.html#tests=[[230,64,43]] 17:11:29 INFO - RETURN: dromaeo_css: 6766.21 17:11:29 INFO - RETURN: kraken: 1518.70 17:11:29 INFO - RETURN: v8_7: 20441.51 17:11:29 INFO - javascript benchmark 17:11:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3108.891188808391, 3113.657497675256, 3135.4983202687577, 3138.419392412405, 3165.841707914604, 5100.642954993152, 5114.795408183678, 5133.999999999995, 5173.922391164131, 5196.636235463509, 5173.560247378978, 5189.974050129744, 5221.0863098957625, 5245.44922783108, 5268.262443257947, 4471.172833025885, 4706.599939005188, 4861.076395484846, 4872.561469467747, 4910.803567857281, 4706.788194531237, 4783.354247176621, 4824.059308434857, 4849.5877850382585, 4857.829975950843, 4702.036082603076, 4783.4499032611, 4792.688475249115, 4795.4964728703335, 4797.880052998668, 4664.230401983668, 4684.110019096361, 4689.249720044811, 4705.0, 4715.764211789431, 4619.445666520039, 4653.790579423934, 4662.7668616569035, 4683.180443422421, 4697.765111744433, 5012.749362531858, 5015.849524514234, 5019.598432125457, 5056.317397151374, 5095.108356037716, 5531.0, 5566.832995010116, 5572.749226284827, 5578.9163162552595, 5636.4927156556105, 5543.085390910495, 5567.638103523258, 5604.887902241973, 5615.2700148980775, 5625.1843482695185, 5227.294315267466, 5242.842714718565, 5252.842414727565, 5257.237700533439, 5286.233496143076, 5675.574331925122, 5675.886482270332, 5688.345840228344, 5689.829305120853, 5729.627574207663, 5322.813701520428, 5379.381371142369, 5475.67145971243, 5480.890382192334, 5576.804811831566, 5476.288082549243, 5482.80810171642, 5483.341998960151, 5490.313710786152, 5500.50495455411, 5455.672659640355, 5458.0, 5462.371827239839, 5488.121900495901, 5502.312210973629, 5437.891242175135, 5466.426025267369, 5466.508014278734, 5498.532624726863, 5570.3315602127195, 4289.356596510486, 4291.463567054118, 4292.656587473057, 4299.806508707115, 4315.78421078951, 3854.4411060396087, 3876.7673939563715, 3893.610638936084, 3908.785016824045, 3909.980450097731, 5225.608079394061, 5253.4221235664045, 5275.155975043975, 5309.123994540934, 5338.092524270884, 5494.2582751328855, 5501.669899806025, 5529.778808847682, 5542.11326187808, 5548.500634942875, 5142.382914050263, 5204.193350030751, 5217.608679349064, 5236.764345604457, 5261.500157485033, 4733.266343716729, 4735.739534325645, 4767.856964291077, 4806.423229212517, 4833.806647734122, 5767.682777447197, 5783.0, 5785.0454674978155, 5807.303123625192, 5814.912776308359, 5464.9453505464435, 5505.421930697379, 5581.665100094007, 5599.580031497572, 5654.491095801315, 5778.971105144616, 5783.6818974955095, 5815.94184058154, 5836.795712150054, 5883.264591926009, 5396.78412863481, 5403.513683768322, 5405.054115529845, 5416.8645783854145, 5434.864128396822, 5387.245785590099, 5431.4840090191365, 5447.891042179213, 5497.890042199214, 5509.3664228614225, 5427.0, 5428.864278393072, 5473.233747275464, 5510.614257001971, 5529.612927095065, 5424.077906755782, 5452.672839629635, 5470.452954704498, 5481.808136715196, 5487.917681234705, 5298.125809241432, 5358.383785864519, 5394.703291319015, 5398.541124004503, 5438.619296649196, 5385.596080293915, 5449.863753406196, 5527.751251193626, 5529.281193444826, 5560.527355174855, 5239.24031015493, 5259.710715910662, 5280.3663560373, 5303.284056652303, 5322.414534401135], "unit": "score", "name": "dojo.html", "value": 5126.541949388992}, {"lowerIsBetter": false, "replicates": [524.0802391802388, 541.6533418612089, 546.1616418797146, 547.0699810322453, 550.5705549671258, 34629.0, 34761.82619086904, 35096.12259693503, 35106.64893351066, 35187.29625407491, 35788.82105589475, 35858.10354741133, 36143.4578481323, 36269.274614507696, 36279.81860090696, 8248.67005319788, 8411.411201215917, 8421.410501264914, 8434.78913027173, 8488.151184881493, 8171.264586187242, 8343.0, 8359.331253499737, 8428.747137585882, 8432.283255923254, 8414.284785793216, 8414.453060551044, 8532.402731808776, 8533.445326053787, 8549.786255343604, 8438.0, 8501.06488286288, 8503.914960850405, 8505.532195729264, 8544.401891867572, 8317.209865062809, 8349.874751878726, 8382.287505562035, 8404.8319033619, 8443.535605541692, 34406.0, 34569.48145777815, 34614.13464663403, 34659.306813863834, 34725.0, 2955.2611847038243, 3034.575159477675, 3071.232191952012, 3276.1809547612856, 3307.1732066983254, 29756.404871902658, 29857.850710746523, 29923.10230693083, 29962.40075198484, 30170.09489715312, 3570.3037907608027, 3710.870119545803, 3714.972934480035, 3740.9438858417147, 3822.7515211511163, 189183.0, 190551.0, 190644.0, 191158.04420977805, 191677.0, 49151.26273105906, 49393.75303123461, 54098.91802163934, 54318.18522722162, 54409.45590544123, 64440.355596443434, 65928.67035664887, 66099.0, 66260.0, 66369.6681516599, 10846.132309415385, 11016.889831101747, 11071.72320691989, 11094.944525277322, 11108.555657773599, 8727.781805454915, 8764.780880477912, 8766.342524310703, 8776.473411595325, 8807.647694092164, 17618.823811761973, 17653.7351939721, 17818.376356827448, 17851.642967140586, 17868.374606888698, 7293.671784769698, 7511.737089201961, 7513.0, 7560.206178351194, 7619.08570971487, 927.939683920543, 943.4527973775193, 958.9089036541517, 1006.7684432580547, 1058.0319008107494, 27567.0, 27725.0, 28063.57904631432, 28124.156275311772, 28282.292942676188, 1008.8032833597379, 1017.6590842067842, 1024.3034736379184, 1068.9946550267198, 1085.5874767588423, 14263.286835658175, 14579.41682332716, 14713.190774507504, 14917.552473425814, 14930.92534537342, 130431.34784326017, 134954.32522837323, 135373.0, 135381.0, 304468.0, 47161.0, 47371.76314118407, 47867.21327867186, 48053.279200812016, 48102.75948620235, 1263.5135472843021, 1271.465984286602, 1275.7384736129072, 1280.9423575939104, 1382.4262930883572, 25655.358616034748, 26456.206313810617, 26723.599146013214, 26926.461470770868, 27104.593431098154, 42591.787041065836, 42714.57285427106, 42929.0, 43123.784381077894, 43130.353044704985, 282316.0, 282871.0, 284839.0, 285138.0, 285712.0, 29701.851490742407, 29948.85025574858, 30159.69840301569, 30237.546436803026, 31565.210869728442, 35021.64978350286, 35574.46638300376, 35928.0, 35947.82026089853, 36535.81732091322, 32837.50743738894, 33159.336813263115, 33672.831635842645, 33849.661503385636, 34240.828795855865, 32946.38690009239, 33609.327813444084, 33697.326053479286, 34043.65956340504, 34252.0, 33314.16714582155, 33395.66604333925, 33787.493187601714, 33850.49224261589, 33850.830745847095, 29418.26454338573, 30032.699673003863, 30929.536056958714, 31289.530657040617, 31663.20841978969, 23672.763272367745, 23715.762842371354, 23825.166119185746, 23969.28092157238, 24187.0], "unit": "score", "name": "ext.html", "value": 16787.7871780182}, {"lowerIsBetter": false, "replicates": [360.7673050882181, 362.510610675588, 362.5848403577902, 366.19619934244326, 367.84918183544744, 15001.549953501399, 15990.0, 16562.50312490627, 16879.83120168798, 17147.657046859054, 14156.50452234172, 14522.0, 14652.706945861102, 14715.043522171052, 14741.410343586243, 4461.754603496806, 4717.2688233323715, 4729.739864307479, 4738.549837765407, 4740.336352910578, 4350.890522916668, 4650.348951146842, 4683.414573178353, 4721.268203428457, 4744.881377965544, 4830.637702172334, 4888.828890988816, 5096.184610462326, 5293.6294459387855, 5349.973250133763, 5060.493950604947, 5061.721605311706, 5072.898542029176, 5086.237064440326, 5120.92318615221, 5139.640225184201, 5144.794208231666, 5145.871353216162, 5152.227165925104, 5176.55999240065, 11588.6523404298, 14131.576052718436, 18550.907245463823, 19327.130279137473, 19358.225670973145, 2005.5587770690424, 2051.9589608207903, 2098.653722135846, 2104.653022065879, 2218.589560931217, 8831.69089081879, 8888.511131887744, 9024.23294020009, 9049.095090490899, 9493.66772162978, 1757.7890653121708, 1785.9196336164903, 1788.65121301345, 1793.067604845473, 1802.4592622213283, 52719.20921186185, 54344.184837227476, 55543.44456555423, 56144.43855561433, 56952.43047569554, 14508.492202772852, 14849.960502764703, 14877.809775217956, 15029.421910699437, 15190.012649177768, 21468.141274349164, 21580.56838863214, 21654.35036948894, 21761.673574896387, 21780.564388712453, 7547.132079810783, 7631.3131818136635, 7634.160242373335, 7718.961405192938, 7807.765767026998, 6201.503879689704, 6231.376862313823, 6250.312465628777, 6258.561900666909, 6283.37166283368, 7377.372923301579, 7484.438667099989, 7509.286617771303, 7516.624168791539, 7534.095908491016, 1747.9825201748074, 3027.606411166534, 3055.114016935064, 3120.469520181575, 3124.109628755794, 820.1880138662681, 899.2311573604604, 922.1331947969022, 982.832918403873, 988.8813342398959, 15537.766933496006, 16067.11630860314, 16097.517074487783, 16240.187990600423, 16387.426440074778, 856.8450347376354, 878.0867897386775, 881.1584936385736, 960.279790157382, 976.2141476111656, 8706.157289129182, 9479.194268487117, 9542.856857147148, 9564.234861211087, 9583.141283930832, 441617.0, 443982.0, 450132.23743744293, 453537.0, 506782.0, 66266.66866665636, 67552.6622366885, 68938.31061689419, 69624.30375696179, 70488.64755676189, 1089.096050278267, 1097.742030622803, 1107.4628805029554, 1109.3399427340719, 1122.7305446692735, 14147.717045659236, 14700.926495367456, 14887.627809304853, 14956.700865982402, 15250.923745381202, 31683.20791980219, 31987.680123198472, 32617.673823261463, 32824.0, 33795.0, 38306.80846595749, 38574.6142538571, 38953.0, 39058.6094139055, 39955.0, 6929.618870961944, 6960.338767817049, 7011.614361210182, 7056.329648683367, 7301.4158867289425, 10233.334833235816, 11392.715182120513, 11573.768524629628, 11779.52881884715, 11803.173777835469, 9183.54082295896, 9543.47510886908, 9579.185769209416, 9871.555779989774, 10181.03280188381, 9196.194127454926, 9452.149306562442, 9567.856482152634, 9578.616855325708, 9686.321957463191, 9617.471039092638, 9724.756881077747, 9740.610375584898, 10040.995900410193, 10086.848697269694, 6802.897956530755, 6905.930940690529, 6981.847995080958, 6987.0, 7025.332593403618, 8591.871121933302, 9846.261530385107, 9856.457894815854, 9886.110250077527, 9920.900790992286], "unit": "score", "name": "jquery.html", "value": 8256.765802368176}, {"lowerIsBetter": false, "replicates": [1458.2271396160036, 1489.8510148985104, 1644.5970737169396, 1740.4517576963265, 1768.885022473539, 7520.548767073979, 7544.358729507985, 7688.461807673458, 7915.1689072647405, 7915.920840791598, 7827.060752709668, 7929.722459713911, 7946.76159715208, 8001.079875814283, 8010.1589333120055, 2351.8000969917534, 2373.6558199061124, 2380.3573035280465, 2386.892589833453, 2392.294273189413, 2370.7392186859433, 2385.1651921827397, 2394.341556072077, 2398.64020396941, 2399.7360290368047, 2265.8753768542724, 2321.7330007049154, 2322.140807901079, 2328.2549584133085, 2345.94135146621, 2317.316391664463, 2331.5570041692026, 2356.7761062699014, 2361.988190059047, 2363.8889721830797, 2316.3861576682193, 2317.2005658047947, 2336.2290444153386, 2337.1819863047967, 2340.789328960385, 7738.380929525681, 7783.104942931579, 7786.649600767979, 7828.178041305638, 7835.8432831343625, 4692.882677933045, 4840.636952228597, 4865.537773911508, 4866.6106711463, 4868.853934381974, 3015.849207539636, 3016.170553097894, 3069.8004629699, 3104.798188117765, 3107.9378412431624, 851.3317046118767, 857.3098655582254, 866.3805379153872, 899.8875140607424, 921.3688623293066, 10892.455377231187, 10968.17738669603, 11045.005949464507, 11061.225714200009, 11067.446627668665, 4208.284591619371, 4291.806868690916, 4319.028218650778, 4334.891627709269, 4356.063446358985, 8899.599518021576, 8899.599518021705, 8934.374593778373, 8946.105389461001, 8968.0, 4801.5438533339275, 4805.399325084364, 4817.2774083887, 4833.468318484964, 4834.95165048345, 4366.410534577792, 4379.781010949439, 4409.779511024436, 4423.380726698265, 4440.023194897118, 3426.811525366079, 3429.3827111120236, 3453.7755045921936, 3454.4127498325347, 3464.220550376145, 1003.1423133220991, 1034.2863424237403, 1052.6999805055523, 1060.0936199549428, 1061.1828891753462, 982.6658935961807, 1061.9787604247872, 1140.8516892803882, 1166.3235323512342, 1267.461328935199, 7022.578645281197, 7032.191298000693, 7038.049863268496, 7080.04419403374, 7091.716331346792, 1030.9484525773682, 1073.1468482556386, 1076.7200527862813, 1098.5166526728215, 1103.7240689827543, 5739.598228124075, 5828.504577110908, 5842.591018628656, 5844.532437404998, 5925.703714814242, 9358.298127640453, 9413.952930235306, 9756.609735610497, 9862.112409883002, 9905.405675659484, 9595.616175353047, 9610.95194524023, 9625.278104142217, 9686.903130968742, 9760.365576237522, 7299.781006569811, 7442.18136005039, 7599.202083781234, 7601.163871974079, 7654.158042615308, 7206.315400036988, 7243.710251589878, 7245.420366370572, 7264.963675181591, 7295.270472952662, 8492.70275540353, 8554.57227138653, 8754.562271886252, 8777.166169213915, 8844.513551754715, 8595.613197406257, 8746.644270138138, 8802.339824513316, 8812.647494100163, 8917.55412229373, 6823.522353435212, 6876.965615171892, 6879.277675843964, 6910.827229319308, 6941.548799328028, 7284.672189751368, 7304.853902922018, 7342.6695798688115, 7362.7054917804835, 7373.483856130019, 6309.432151106239, 6914.101166848278, 7236.927630723625, 7266.96366518164, 7418.9629051856555, 6305.653189074645, 6576.112224849584, 6881.311868813079, 6956.0, 6972.825679358057, 6293.087502312048, 6753.15585551806, 6859.348361905611, 6879.449644028366, 6884.862302753817, 6050.485708714808, 6079.665618391031, 6086.969565152323, 6087.9391206087375, 6092.939070609415, 6374.74501019954, 6383.265924418752, 6406.167198264196, 6420.935790642034, 6443.516736244894], "unit": "score", "name": "mootools.html", "value": 4481.755114345154}, {"lowerIsBetter": false, "replicates": [322.94832826747717, 331.66336168788683, 332.5377724962301, 333.95157702133184, 336.56751074868816, 6137.447629713325, 6224.968875155623, 6279.748810047604, 6324.525660575452, 6336.049592561112, 6013.669248191348, 6149.661768602725, 6168.722407491662, 6178.3512731163255, 6188.793185328863, 4755.6671033027615, 4756.120117778205, 4760.642951778613, 4771.117343291485, 4778.569928706415, 4769.284607308897, 4769.61681112477, 4772.76136193189, 4773.92839107412, 4785.856424307259, 4655.837045703401, 4695.741734204617, 4722.881927951811, 4724.31497432872, 4725.763711814413, 4698.013417182413, 4704.717716936978, 4714.457837348715, 4716.740579268139, 4726.054789042205, 3921.607839216084, 4002.039510517484, 4133.875983720493, 4136.503619565641, 4142.834286628531, 5761.740721667535, 5896.941030589682, 5911.645301281937, 5966.433188847052, 5991.430814072656, 5442.727863606843, 5453.23654688344, 5474.616776825624, 5479.04116779566, 5502.394736578973, 6455.160829092235, 6576.0, 6601.207855057424, 6603.0, 6614.636195009272, 4573.49691533931, 4578.954210457886, 4583.03756211196, 4584.7936842842155, 4592.885177870547, 6858.10844590205, 6879.449644028516, 6884.965575172142, 6888.104546408985, 6906.585604863674, 4656.557627025427, 4658.091672123971, 4690.577847993697, 4691.648126390534, 4692.929606055912, 4651.418572678415, 4740.241561350167, 4760.785764640599, 4762.333273341735, 4771.427428708577, 5476.0, 5483.396826349178, 5488.121900495981, 5491.423400542965, 5501.229827824028, 6578.736850526021, 6635.170603674541, 6635.535512514078, 6640.8671826563195, 6670.866582668319, 1664.6504234110973, 1702.540314115182, 1703.7444383342597, 1704.0797969096798, 1713.1177443616548, 1122.3266040375709, 1127.0420142878488, 1130.463030060731, 1140.2474366917795, 1157.7626586549736, 6214.067889816473, 6294.0, 6296.842578935563, 6313.810585682437, 6326.272478665012, 6788.898166527506, 6845.794626161223, 6852.760153394707, 6854.862902742017, 6875.724971001104, 6199.597026193283, 6273.749050038039, 6286.811395658137, 6300.873982520324, 6306.49548036156, 3721.2371463850386, 3724.8137593120236, 3725.590185079639, 3730.7948062856804, 3741.7380783345448, 7021.648917554102, 7186.928130718626, 7230.891536626955, 7259.165196002527, 7266.237045110187, 6977.546459480118, 6993.510454268152, 7040.577565346096, 7040.9647951760935, 7057.541259818096, 7097.183823860219, 7204.711811527585, 7210.351068403869, 7216.0, 7240.927590724025, 6908.654567271717, 6914.0666010088, 6918.654067296716, 6928.064711263914, 6952.165740111017, 6782.152230971129, 6798.728050878108, 6814.0, 6829.112215411965, 6842.55523390978, 7063.894041589483, 7161.534500257467, 7210.387117095106, 7224.674889629874, 7240.0, 4560.4071470708595, 4618.422697162855, 4619.35329053926, 4634.698744581591, 4635.281531362644, 6895.0, 6923.376896079377, 6945.305469453217, 6952.5480843745, 6957.79126626202, 6671.666416679243, 6749.190097188172, 6774.254831968578, 6784.660766961731, 6785.5250132490255, 6695.163104611924, 6709.832254193489, 6712.127423435118, 6723.495737819585, 6738.46092312604, 6589.6375699336995, 6594.70323835419, 6608.50436217276, 6617.735290588515, 6620.966895165493, 6619.172603424572, 6757.851165302009, 6765.797026089225, 6779.8983015253825, 6792.558483698742, 6482.319356467503, 6547.1161393211305, 6550.115734375799, 6566.310537393505, 6568.6058836469965], "unit": "score", "name": "prototype.html", "value": 4997.62423086719}, {"lowerIsBetter": false, "replicates": [696.4672025900187, 729.9416046716264, 751.5678484871199, 763.9236076392361, 790.1821614628853, 14634.414623415063, 14805.629859253524, 14825.92587037066, 14829.406823727051, 14837.18395488249, 11584.07327413807, 11647.184697071209, 11658.766824663502, 11666.941665291663, 11694.356810375426, 788.6805843633323, 792.7463211772235, 800.1838125112382, 801.2988634944423, 806.5080301016376, 799.3046049936563, 799.808046068945, 802.6869520886859, 805.2269820971874, 806.9193080691913, 821.9219174178473, 823.9629216685264, 827.2554700769296, 827.4249396669318, 827.6482494939627, 824.8680211166185, 825.1377310710262, 825.2201669422399, 826.3017750001269, 828.2545708862042, 599.1641659884481, 604.8155312629647, 606.0969155957636, 609.9237595300588, 610.261583483985, 13270.0, 13371.26458044807, 13414.061015728903, 13425.328733563381, 13427.194368337834, 11278.548858045668, 11465.140114491447, 11494.287252497494, 11543.13426493008, 11655.184137110406, 9195.264618394525, 9889.357191782512, 9897.257705672104, 10143.442110683984, 10487.842682359771, 3454.827258637058, 3481.791092534431, 3508.6491350864962, 3586.3903136466865, 3600.837962291703, 47933.0, 48481.75759121182, 48595.75702121467, 48618.0, 48720.0, 8535.573221338907, 8924.687635932842, 8945.23965462943, 9068.8639670405, 9189.448633082036, 16560.089195094384, 16648.0, 16733.748993765104, 16740.49778506647, 16746.74879876803, 6525.765333914354, 6594.472442204612, 6604.933950660528, 6730.764423245163, 6835.418989385858, 3961.207758448264, 4083.6324730773777, 4156.771377574202, 4211.052513184571, 4322.589354011427, 2982.075556577468, 2994.446027484922, 3011.698830116971, 3025.3646734185627, 3038.3923215357017, 543.6303313746611, 551.3604219105898, 556.2157358125024, 566.9914951275734, 567.9176519404663, 442.11356230757127, 491.39803740418415, 523.9240310155006, 562.7748900439857, 587.8038142817429, 7764.883526747103, 7804.921950780533, 7886.842263154705, 7890.802729931797, 8126.878096828552, 501.490986648552, 614.4316507230883, 618.1346115438422, 631.0754744299624, 645.8320836582428, 3455.101673564841, 3671.3295450569926, 3728.2357116790995, 3825.2349530094093, 3890.5331360236387, 50610.74694626577, 51372.0, 51693.7415312921, 51896.0, 51922.22116668253, 49801.750991244815, 51189.74405127951, 51343.0, 51370.486295137314, 51729.48270517322, 45881.541184587724, 46149.7692511542, 46351.76824115858, 46382.0, 46709.0, 7527.924720752722, 7638.732644357421, 7717.536947783151, 7834.882476762739, 7903.486273392211, 34391.656083438844, 34471.0, 34590.481142783385, 34778.652213477544, 34904.47643285403, 42081.57918420777, 42168.1566368677, 43809.56190438182, 46486.76756616195, 47172.0, 9872.85190722154, 10093.444860532742, 10109.545070471699, 10225.181985441295, 10333.225008124271, 11788.469518871843, 12191.75616487683, 12204.267743935392, 12863.742725145257, 12885.871141288842, 11002.889971100507, 11087.33475991443, 11226.045786108272, 11315.943420282845, 11608.6517404478, 10925.726856828325, 11284.0, 11296.0, 11355.716107097389, 11727.889941926174, 10472.21458390639, 11167.274127181707, 11365.772684546428, 11596.304221746723, 11758.58844940423, 9136.771580710536, 9153.63385464574, 9179.816403672023, 9244.306676999386, 9757.170640495353, 8499.447535910145, 8575.356848236532, 8959.491660047554, 9151.450912945245, 9163.22112620408], "unit": "score", "name": "yui.html", "value": 6028.340909757602}], "name": "dromaeo_css", "value": 6766.206183803768}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 105.0, 110.0, 109.0, 109.0, 122.0, 110.0, 110.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [155.0, 127.0, 151.0, 158.0, 135.0, 151.0, 150.0, 129.0, 158.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 144.1}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 162.0, 162.0, 163.0, 163.0, 161.0, 162.0, 167.0, 160.0], "unit": "score", "name": "audio-dft", "value": 162.5}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 73.0, 73.0, 74.0, 147.0, 77.0, 86.0, 72.0, 76.0], "unit": "score", "name": "audio-fft", "value": 82.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 153.0, 96.0, 96.0, 98.0, 142.0, 96.0, 104.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 111.9}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [145.0, 147.0, 147.0, 148.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"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": [60.0, 61.0, 60.0, 61.0, 61.0, 60.0, 61.0, 61.0, 70.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 61.3}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 69.0, 67.0, 67.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.4}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 84.0, 84.0, 83.0, 88.0, 83.0, 84.0, 90.0, 92.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [119.0, 123.0, 120.0, 125.0, 117.0, 133.0, 118.0, 124.0, 118.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.6}, {"lowerIsBetter": true, "replicates": [143.0, 151.0, 148.0, 152.0, 151.0, 143.0, 147.0, 148.0, 151.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.3}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 70.0, 71.0, 69.0, 67.0, 70.0, 72.0, 74.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.3}], "name": "kraken", "value": 1518.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [170.590242238144], "unit": "score", "name": "Richards", "value": 206.940324}, {"lowerIsBetter": false, "replicates": [189.000189000189], "unit": "score", "name": "DeltaBlue", "value": 349.8303379999999}, {"lowerIsBetter": false, "replicates": [279.79854504756577], "unit": "score", "name": "Encrypt", "value": 951.330894}, {"lowerIsBetter": false, "replicates": [5223.958333333333], "unit": "score", "name": "Decrypt", "value": 50.95389032901295}, {"lowerIsBetter": false, "replicates": [1070.6638115631692], "unit": "score", "name": "RayTrace", "value": 691.1497260000002}, {"lowerIsBetter": false, "replicates": [711.4427860696518], "unit": "score", "name": "Earley", "value": 936.7766643356641}, {"lowerIsBetter": false, "replicates": [12345.67901234568], "unit": "score", "name": "Boyer", "value": 53.98350299999995}, {"lowerIsBetter": false, "replicates": [40725.490196078434], "unit": "score", "name": "RegExp", "value": 22.368914299470404}, {"lowerIsBetter": false, "replicates": [570.7762557077625], "unit": "score", "name": "Splay", "value": 142.77223200000006}, {"lowerIsBetter": false, "replicates": [4817.307692307692], "unit": "score", "name": "NavierStokes", "value": 308.055888223553}], "name": "v8_7", "value": 20441.512853118722}]} 17:11:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20441.51"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1518.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6766.21"}}} 17:11:29 INFO - Return code: 0 17:11:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:11:29 INFO - # TBPL SUCCESS # 17:11:29 INFO - Running post-action listener: _resource_record_post_action 17:11:29 INFO - Running post-run listener: _resource_record_post_run 17:11:30 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 10399744; Write bytes: 440344576; Read time: 3028; Write time: 353516 17:11:30 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5173248; Read time: 0; Write time: 320 17:11:30 INFO - run-tests - Wall time: 1216s; CPU: 13.0%; Read bytes: 8638464; Write bytes: 435171328; Read time: 2980; Write time: 353196 17:11:30 INFO - Running post-run listener: _upload_blobber_files 17:11:30 INFO - Blob upload gear active. 17:11:30 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:11:30 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:11:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 17:11:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 17:11:31 INFO - (blobuploader) - INFO - Open directory for files ... 17:11:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:11:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:11:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:11:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:11:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:11:32 INFO - (blobuploader) - INFO - Done attempting. 17:11:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:11:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:11:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:11:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:11:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:11:33 INFO - (blobuploader) - INFO - Done attempting. 17:11:33 INFO - (blobuploader) - INFO - Iteration through files over. 17:11:33 INFO - Return code: 0 17:11:33 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:11:33 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:11:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/02946881de6e8a8d14817f0e909e352cb6c6a3acc8c17fca875eef25070f290ccb34e9a412c912287a550089b6eb129f1e9c4f9fd7cd2e14c57ebffd070f21be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b293c04587a0cef4fd851f8af880c84a3ee5f5b442623264823b36c5cc85f554ad852a3d805157b9be7da4290b262b8943ffa305bb5659e0890039d474e9555b"} 17:11:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:11:33 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:11:33 INFO - Contents: 17:11:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/02946881de6e8a8d14817f0e909e352cb6c6a3acc8c17fca875eef25070f290ccb34e9a412c912287a550089b6eb129f1e9c4f9fd7cd2e14c57ebffd070f21be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b293c04587a0cef4fd851f8af880c84a3ee5f5b442623264823b36c5cc85f554ad852a3d805157b9be7da4290b262b8943ffa305bb5659e0890039d474e9555b"} 17:11:33 INFO - Running post-run listener: copy_logs_to_upload_dir 17:11:33 INFO - Copying logs to upload dir... 17:11:33 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 17:11:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.654147 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-01-25 17:11:33.518861) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-25 17:11:33.521831) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1453768191.453622-2080212055 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/02946881de6e8a8d14817f0e909e352cb6c6a3acc8c17fca875eef25070f290ccb34e9a412c912287a550089b6eb129f1e9c4f9fd7cd2e14c57ebffd070f21be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b293c04587a0cef4fd851f8af880c84a3ee5f5b442623264823b36c5cc85f554ad852a3d805157b9be7da4290b262b8943ffa305bb5659e0890039d474e9555b"} build_url:https://queue.taskcluster.net/v1/task/DrCLPgmbSKq61UjvILmFhQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011431 build_url: 'https://queue.taskcluster.net/v1/task/DrCLPgmbSKq61UjvILmFhQ/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/02946881de6e8a8d14817f0e909e352cb6c6a3acc8c17fca875eef25070f290ccb34e9a412c912287a550089b6eb129f1e9c4f9fd7cd2e14c57ebffd070f21be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b293c04587a0cef4fd851f8af880c84a3ee5f5b442623264823b36c5cc85f554ad852a3d805157b9be7da4290b262b8943ffa305bb5659e0890039d474e9555b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-25 17:11:33.546225) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 17:11:33.546555) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1453768191.453622-2080212055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004428 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 17:11:33.629336) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 17:11:33.629655) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 17:11:33.629944) ========= ========= Total master_lag: 0.31 =========