builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-005 starttime: 1451716944.49 results: success (0) buildid: 20160101203051 builduid: 9c776dea0a3b4a9d8bb3c934be3acf97 revision: ce643acfab14d95bea2fb6c4f56477413514b686 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-01 22:42:24.488857) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-01 22:42:24.489768) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-01 22:42:24.490140) ========= 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=cd88c086d1ff67493cfd1714000001ba-1451714881.751548-796644693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006312 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-01 22:42:24.521480) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-01 22:42:24.522085) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-01 22:42:24.596731) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 22:42:24.597047) ========= 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=cd88c086d1ff67493cfd1714000001ba-1451714881.751548-796644693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004630 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 22:42:24.649240) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-01 22:42:24.649540) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-01 22:42:24.649970) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 22:42:24.650297) ========= 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=cd88c086d1ff67493cfd1714000001ba-1451714881.751548-796644693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-01 22:42:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.3M=0s 2016-01-01 22:42:25 (47.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175389 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 22:42:24.839020) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 22:42:24.839339) ========= 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=cd88c086d1ff67493cfd1714000001ba-1451714881.751548-796644693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016840 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 22:42:24.894901) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-01 22:42:24.895265) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev ce643acfab14d95bea2fb6c4f56477413514b686 --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/b2g-inbound --rev ce643acfab14d95bea2fb6c4f56477413514b686 --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=cd88c086d1ff67493cfd1714000001ba-1451714881.751548-796644693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-01 22:42:25,178 truncating revision to first 12 chars 2016-01-01 22:42:25,178 Setting DEBUG logging. 2016-01-01 22:42:25,178 attempt 1/10 2016-01-01 22:42:25,178 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/ce643acfab14?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-01 22:42:26,089 unpacking tar archive at: b2g-inbound-ce643acfab14/testing/mozharness/ program finished with exit code 0 elapsedTime=1.196097 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-01 22:42:26.104424) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-01 22:42:26.104745) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-01 22:42:26.112445) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-01 22:42:26.112766) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-01 22:42:26.113245) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-01-01 22:42:26.113949) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] 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=cd88c086d1ff67493cfd1714000001ba-1451714881.751548-796644693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:42:26 INFO - MultiFileLogger online at 20160101 22:42:26 in /builds/slave/test-pgo 22:42:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 22:42:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:42:26 INFO - {'append_to_log': False, 22:42:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:42:26 INFO - 'blob_upload_branch': 'B2G-Inbound', 22:42:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:42:26 INFO - 'branch': 'B2G-Inbound', 22:42:26 INFO - 'buildbot_json_path': 'buildprops.json', 22:42:26 INFO - 'config_files': ('talos/linux_config.py',), 22:42:26 INFO - 'default_actions': ('clobber', 22:42:26 INFO - 'read-buildbot-config', 22:42:26 INFO - 'download-and-extract', 22:42:26 INFO - 'populate-webroot', 22:42:26 INFO - 'create-virtualenv', 22:42:26 INFO - 'install', 22:42:26 INFO - 'run-tests'), 22:42:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:42:26 INFO - 'download_minidump_stackwalk': True, 22:42:26 INFO - 'download_symbols': 'ondemand', 22:42:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:42:26 INFO - 'tooltool.py': '/tools/tooltool.py', 22:42:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:42:26 INFO - '/tools/misc-python/virtualenv.py')}, 22:42:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:42:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:42:26 INFO - 'installer_path': 'installer.exe', 22:42:26 INFO - 'log_level': 'info', 22:42:26 INFO - 'log_name': 'talos', 22:42:26 INFO - 'log_to_console': True, 22:42:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:42:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:42:26 INFO - 'opt_config_files': (), 22:42:26 INFO - 'pip_index': False, 22:42:26 INFO - 'sps_profile': False, 22:42:26 INFO - 'sps_profile_interval': 0, 22:42:26 INFO - 'suite': 'dromaeojs', 22:42:26 INFO - 'system_bits': '32', 22:42:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:42:26 INFO - 'title': 'talos-linux64-ix-005', 22:42:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:42:26 INFO - 'use_talos_json': True, 22:42:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:42:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:42:26 INFO - 'work_dir': 'build'} 22:42:26 INFO - ##### 22:42:26 INFO - ##### Running clobber step. 22:42:26 INFO - ##### 22:42:26 INFO - Running pre-action listener: _resource_record_pre_action 22:42:26 INFO - Running main action method: clobber 22:42:26 INFO - rmtree: /builds/slave/test-pgo/build 22:42:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:42:27 INFO - Running post-action listener: _resource_record_post_action 22:42:27 INFO - ##### 22:42:27 INFO - ##### Running read-buildbot-config step. 22:42:27 INFO - ##### 22:42:27 INFO - Running pre-action listener: _resource_record_pre_action 22:42:27 INFO - Running main action method: read_buildbot_config 22:42:27 INFO - Using buildbot properties: 22:42:27 INFO - { 22:42:27 INFO - "project": "", 22:42:27 INFO - "product": "firefox", 22:42:27 INFO - "script_repo_revision": "production", 22:42:27 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 22:42:27 INFO - "repository": "", 22:42:27 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 22:42:27 INFO - "buildid": "20160101203051", 22:42:27 INFO - "pgo_build": "True", 22:42:27 INFO - "basedir": "/builds/slave/test-pgo", 22:42:27 INFO - "buildnumber": 1084, 22:42:27 INFO - "slavename": "talos-linux64-ix-005", 22:42:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:42:27 INFO - "platform": "ubuntu64_hw", 22:42:27 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 22:42:27 INFO - "branch": "b2g-inbound", 22:42:27 INFO - "repo_path": "integration/b2g-inbound", 22:42:27 INFO - "revision": "ce643acfab14d95bea2fb6c4f56477413514b686", 22:42:27 INFO - "stage_platform": "linux64-pgo", 22:42:27 INFO - "builduid": "9c776dea0a3b4a9d8bb3c934be3acf97", 22:42:27 INFO - "slavebuilddir": "test" 22:42:27 INFO - } 22:42:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/fEs7AXnhQzmSHuuNxuM2oA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 22:42:27 INFO - Running post-action listener: _resource_record_post_action 22:42:27 INFO - ##### 22:42:27 INFO - ##### Running download-and-extract step. 22:42:27 INFO - ##### 22:42:27 INFO - Running pre-action listener: _resource_record_pre_action 22:42:27 INFO - Running main action method: download_and_extract 22:42:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:42:27 INFO - https://queue.taskcluster.net/v1/task/fEs7AXnhQzmSHuuNxuM2oA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:42:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fEs7AXnhQzmSHuuNxuM2oA/artifacts/public/build/test_packages.json 22:42:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fEs7AXnhQzmSHuuNxuM2oA/artifacts/public/build/test_packages.json 22:42:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fEs7AXnhQzmSHuuNxuM2oA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:42:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fEs7AXnhQzmSHuuNxuM2oA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:42:28 INFO - Downloaded 1302 bytes. 22:42:28 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:42:28 INFO - Using the following test package requirements: 22:42:28 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:42:28 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:42:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:42:28 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:42:28 INFO - u'jsshell-linux-x86_64.zip'], 22:42:28 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:42:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:42:28 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:42:28 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:42:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:42:28 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:42:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:42:28 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:42:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:42:28 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:42:28 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:42:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:42:28 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:42:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:42:28 INFO - https://queue.taskcluster.net/v1/task/fEs7AXnhQzmSHuuNxuM2oA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:42:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fEs7AXnhQzmSHuuNxuM2oA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:42:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fEs7AXnhQzmSHuuNxuM2oA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:42:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fEs7AXnhQzmSHuuNxuM2oA/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 22:42:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fEs7AXnhQzmSHuuNxuM2oA/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 22:42:31 INFO - Downloaded 23197868 bytes. 22:42:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 22:42:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:42:31 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:42:32 INFO - Return code: 0 22:42:32 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 22:42:32 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')]} 22:42:32 INFO - https://queue.taskcluster.net/v1/task/fEs7AXnhQzmSHuuNxuM2oA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:42:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fEs7AXnhQzmSHuuNxuM2oA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:42:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fEs7AXnhQzmSHuuNxuM2oA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:42:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fEs7AXnhQzmSHuuNxuM2oA/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 22:42:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fEs7AXnhQzmSHuuNxuM2oA/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 22:42:34 INFO - Downloaded 23197868 bytes. 22:42:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 22:42:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:42:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:42:35 INFO - Return code: 0 22:42: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')]} 22:42:35 INFO - https://queue.taskcluster.net/v1/task/fEs7AXnhQzmSHuuNxuM2oA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:42:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fEs7AXnhQzmSHuuNxuM2oA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:42:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fEs7AXnhQzmSHuuNxuM2oA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:42:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fEs7AXnhQzmSHuuNxuM2oA/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 22:42:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fEs7AXnhQzmSHuuNxuM2oA/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 22:42:36 INFO - Downloaded 11132285 bytes. 22:42:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 22:42:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:42:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 22:42:36 INFO - Return code: 0 22:42: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')]} 22:42:36 INFO - https://queue.taskcluster.net/v1/task/fEs7AXnhQzmSHuuNxuM2oA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:42:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fEs7AXnhQzmSHuuNxuM2oA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:42:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fEs7AXnhQzmSHuuNxuM2oA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:42:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fEs7AXnhQzmSHuuNxuM2oA/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 22:42:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fEs7AXnhQzmSHuuNxuM2oA/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 22:42:39 INFO - Downloaded 54987729 bytes. 22:42:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fEs7AXnhQzmSHuuNxuM2oA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:42:39 INFO - mkdir: /builds/slave/test-pgo/properties 22:42:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:42:39 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:42:39 INFO - Contents: 22:42:39 INFO - build_url:https://queue.taskcluster.net/v1/task/fEs7AXnhQzmSHuuNxuM2oA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:42:39 INFO - Running post-action listener: _resource_record_post_action 22:42:39 INFO - Running post-action listener: set_extra_try_arguments 22:42:39 INFO - ##### 22:42:39 INFO - ##### Running populate-webroot step. 22:42:39 INFO - ##### 22:42:39 INFO - Running pre-action listener: _resource_record_pre_action 22:42:39 INFO - Running main action method: populate_webroot 22:42:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:42:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:42:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:42:39 INFO - '--tppagecycles', 22:42:39 INFO - '7'], 22:42:39 INFO - 'tests': ['tsvgm']}}, 22:42:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:42:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:42:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:42:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:42:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:42:39 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:42:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:42:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:42:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:42:39 INFO - 'talos_options': ['--e10s'], 22:42:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:42:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:42:39 INFO - 'tests': ['damp', 'tps']}, 22:42:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:42:39 INFO - 'talos_options': ['--e10s'], 22:42:39 INFO - 'tests': ['damp', 'tps']}, 22:42:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:42:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:42:39 INFO - 'other': {'tests': ['a11yr', 22:42:39 INFO - 'ts_paint', 22:42:39 INFO - 'tpaint', 22:42:39 INFO - 'sessionrestore', 22:42:39 INFO - 'sessionrestore_no_auto_restore']}, 22:42:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:42:39 INFO - 'tests': ['a11yr', 22:42:39 INFO - 'ts_paint', 22:42:39 INFO - 'tpaint', 22:42:39 INFO - 'sessionrestore', 22:42:39 INFO - 'sessionrestore_no_auto_restore']}, 22:42:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:42:39 INFO - 'tests': ['a11yr', 22:42:39 INFO - 'ts_paint', 22:42:39 INFO - 'tpaint', 22:42:39 INFO - 'sessionrestore', 22:42:39 INFO - 'sessionrestore_no_auto_restore']}, 22:42:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:42:39 INFO - 'tests': ['a11yr', 22:42:39 INFO - 'ts_paint', 22:42:39 INFO - 'tpaint', 22:42:39 INFO - 'sessionrestore', 22:42:39 INFO - 'sessionrestore_no_auto_restore']}, 22:42:39 INFO - 'other_l64': {'tests': ['a11yr', 22:42:39 INFO - 'ts_paint', 22:42:39 INFO - 'tpaint', 22:42:39 INFO - 'sessionrestore', 22:42:39 INFO - 'sessionrestore_no_auto_restore']}, 22:42:39 INFO - 'other_nol64': {'tests': ['a11yr', 22:42:39 INFO - 'ts_paint', 22:42:39 INFO - 'tpaint', 22:42:39 INFO - 'sessionrestore', 22:42:39 INFO - 'sessionrestore_no_auto_restore']}, 22:42:39 INFO - 'svgr': {'tests': ['tsvgx', 22:42:39 INFO - 'tsvgr_opacity', 22:42:39 INFO - 'tart', 22:42:39 INFO - 'tscrollx', 22:42:39 INFO - 'cart']}, 22:42:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:42:39 INFO - 'tests': ['tsvgx', 22:42:39 INFO - 'tsvgr_opacity', 22:42:39 INFO - 'tart', 22:42:39 INFO - 'tscrollx', 22:42:39 INFO - 'cart']}, 22:42:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:42:39 INFO - 'tests': ['tp5o']}, 22:42:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:42:39 INFO - 'talos_options': ['--e10s'], 22:42:39 INFO - 'tests': ['tp5o']}, 22:42:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:42:39 INFO - 'talos_options': ['--xperf_path', 22:42:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:42:39 INFO - 'tests': ['tp5n']}, 22:42:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:42:39 INFO - 'talos_options': ['--e10s', 22:42:39 INFO - '--xperf_path', 22:42:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:42:39 INFO - 'tests': ['tp5n']}}, 22:42:39 INFO - 'talos.zip': {'path': '', 22:42:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:42:39 INFO - Running post-action listener: _resource_record_post_action 22:42:39 INFO - ##### 22:42:39 INFO - ##### Running create-virtualenv step. 22:42:39 INFO - ##### 22:42:39 INFO - Running pre-action listener: _resource_record_pre_action 22:42:39 INFO - Running main action method: create_virtualenv 22:42:39 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:42:39 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 22:42:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:42:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:42:39 INFO - Using real prefix '/usr' 22:42:39 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:42:39 INFO - Installing distribute.............................................................................................................................................................................................done. 22:42:41 INFO - Installing pip.................done. 22:42:41 INFO - Return code: 0 22:42:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:42: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')]} 22:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42: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')]} 22:42:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0d5cd26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a32630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3840>, '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 0x1a306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a30b60>, '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': 'cd88c086d1ff67493cfd1714000001ba-1451714881.751548-796644693', '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 22:42:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 22:42:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:42:41 INFO - Using env: {'DISPLAY': ':0', 22:42:41 INFO - 'HOME': '/home/cltbld', 22:42:41 INFO - 'LANG': 'en_US.UTF-8', 22:42:41 INFO - 'LANGUAGE': 'en_US:en', 22:42:41 INFO - 'LOGNAME': 'cltbld', 22:42:41 INFO - 'MAIL': '/var/mail/cltbld', 22:42:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:41 INFO - 'MOZ_NO_REMOTE': '1', 22:42:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:41 INFO - 'NO_EM_RESTART': '1', 22:42:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:42:41 INFO - 'PWD': '/builds/slave/test-pgo', 22:42:41 INFO - 'SHELL': '/bin/bash', 22:42:41 INFO - 'SHLVL': '1', 22:42:41 INFO - 'TERM': 'linux', 22:42:41 INFO - 'TMOUT': '86400', 22:42:41 INFO - 'USER': 'cltbld', 22:42:41 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1451714881.751548-796644693', 22:42:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:41 INFO - '_': '/tools/buildbot/bin/python'} 22:42:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:41 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 22:42:41 INFO - Cleaning up... 22:42:41 INFO - Return code: 0 22:42:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:42: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')]} 22:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42: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')]} 22:42:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0d5cd26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a32630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3840>, '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 0x1a306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a30b60>, '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': 'cd88c086d1ff67493cfd1714000001ba-1451714881.751548-796644693', '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 22:42:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 22:42:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:42:41 INFO - Using env: {'DISPLAY': ':0', 22:42:41 INFO - 'HOME': '/home/cltbld', 22:42:41 INFO - 'LANG': 'en_US.UTF-8', 22:42:41 INFO - 'LANGUAGE': 'en_US:en', 22:42:41 INFO - 'LOGNAME': 'cltbld', 22:42:41 INFO - 'MAIL': '/var/mail/cltbld', 22:42:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:41 INFO - 'MOZ_NO_REMOTE': '1', 22:42:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:41 INFO - 'NO_EM_RESTART': '1', 22:42:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:42:41 INFO - 'PWD': '/builds/slave/test-pgo', 22:42:41 INFO - 'SHELL': '/bin/bash', 22:42:41 INFO - 'SHLVL': '1', 22:42:41 INFO - 'TERM': 'linux', 22:42:41 INFO - 'TMOUT': '86400', 22:42:41 INFO - 'USER': 'cltbld', 22:42:41 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1451714881.751548-796644693', 22:42:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:41 INFO - '_': '/tools/buildbot/bin/python'} 22:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:42 INFO - Downloading/unpacking psutil>=0.7.1 22:42:42 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 22:42:42 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 22:42:42 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 22:42:42 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 22:42:42 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 22:42:42 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 22:42:43 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 22:42:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:42:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:42:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:42:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:42:43 INFO - Installing collected packages: psutil 22:42:43 INFO - Running setup.py install for psutil 22:42:43 INFO - building 'psutil._psutil_linux' extension 22:42:43 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 22:42:44 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 22:42:44 INFO - building 'psutil._psutil_posix' extension 22:42:44 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 22:42:44 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 22:42:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:42:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:42:44 INFO - Successfully installed psutil 22:42:44 INFO - Cleaning up... 22:42:44 INFO - Return code: 0 22:42:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:42:44 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')]} 22:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:44 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')]} 22:42:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0d5cd26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a32630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3840>, '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 0x1a306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a30b60>, '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': 'cd88c086d1ff67493cfd1714000001ba-1451714881.751548-796644693', '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 22:42:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 22:42:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:42:44 INFO - Using env: {'DISPLAY': ':0', 22:42:44 INFO - 'HOME': '/home/cltbld', 22:42:44 INFO - 'LANG': 'en_US.UTF-8', 22:42:44 INFO - 'LANGUAGE': 'en_US:en', 22:42:44 INFO - 'LOGNAME': 'cltbld', 22:42:44 INFO - 'MAIL': '/var/mail/cltbld', 22:42:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:44 INFO - 'MOZ_NO_REMOTE': '1', 22:42:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:44 INFO - 'NO_EM_RESTART': '1', 22:42:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:42:44 INFO - 'PWD': '/builds/slave/test-pgo', 22:42:44 INFO - 'SHELL': '/bin/bash', 22:42:44 INFO - 'SHLVL': '1', 22:42:44 INFO - 'TERM': 'linux', 22:42:44 INFO - 'TMOUT': '86400', 22:42:44 INFO - 'USER': 'cltbld', 22:42:44 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1451714881.751548-796644693', 22:42:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:44 INFO - '_': '/tools/buildbot/bin/python'} 22:42:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:42:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:42:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:42:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:42:46 INFO - Installing collected packages: mozsystemmonitor 22:42:46 INFO - Running setup.py install for mozsystemmonitor 22:42:46 INFO - Successfully installed mozsystemmonitor 22:42:46 INFO - Cleaning up... 22:42:46 INFO - Return code: 0 22:42:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:42:46 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')]} 22:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:46 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')]} 22:42:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0d5cd26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a32630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3840>, '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 0x1a306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a30b60>, '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': 'cd88c086d1ff67493cfd1714000001ba-1451714881.751548-796644693', '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 22:42:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 22:42:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:42:46 INFO - Using env: {'DISPLAY': ':0', 22:42:46 INFO - 'HOME': '/home/cltbld', 22:42:46 INFO - 'LANG': 'en_US.UTF-8', 22:42:46 INFO - 'LANGUAGE': 'en_US:en', 22:42:46 INFO - 'LOGNAME': 'cltbld', 22:42:46 INFO - 'MAIL': '/var/mail/cltbld', 22:42:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:46 INFO - 'MOZ_NO_REMOTE': '1', 22:42:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:46 INFO - 'NO_EM_RESTART': '1', 22:42:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:42:46 INFO - 'PWD': '/builds/slave/test-pgo', 22:42:46 INFO - 'SHELL': '/bin/bash', 22:42:46 INFO - 'SHLVL': '1', 22:42:46 INFO - 'TERM': 'linux', 22:42:46 INFO - 'TMOUT': '86400', 22:42:46 INFO - 'USER': 'cltbld', 22:42:46 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1451714881.751548-796644693', 22:42:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:46 INFO - '_': '/tools/buildbot/bin/python'} 22:42:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:46 INFO - Downloading/unpacking blobuploader==1.2.4 22:42:46 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 22:42:46 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 22:42:46 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 22:42:46 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 22:42:46 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 22:42:46 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 22:42:48 INFO - Downloading blobuploader-1.2.4.tar.gz 22:42:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:42:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:42:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:42:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:42:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:42:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42:49 INFO - Downloading docopt-0.6.1.tar.gz 22:42:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:42:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:42:49 INFO - Installing collected packages: blobuploader, requests, docopt 22:42:49 INFO - Running setup.py install for blobuploader 22:42:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:42:49 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:42:49 INFO - Running setup.py install for requests 22:42:49 INFO - Running setup.py install for docopt 22:42:49 INFO - Successfully installed blobuploader requests docopt 22:42:49 INFO - Cleaning up... 22:42:49 INFO - Return code: 0 22:42:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:42:49 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')]} 22:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:49 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')]} 22:42:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0d5cd26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a32630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3840>, '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 0x1a306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a30b60>, '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': 'cd88c086d1ff67493cfd1714000001ba-1451714881.751548-796644693', '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 22:42:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:42:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:42:49 INFO - Using env: {'DISPLAY': ':0', 22:42:49 INFO - 'HOME': '/home/cltbld', 22:42:49 INFO - 'LANG': 'en_US.UTF-8', 22:42:49 INFO - 'LANGUAGE': 'en_US:en', 22:42:49 INFO - 'LOGNAME': 'cltbld', 22:42:49 INFO - 'MAIL': '/var/mail/cltbld', 22:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:49 INFO - 'MOZ_NO_REMOTE': '1', 22:42:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:49 INFO - 'NO_EM_RESTART': '1', 22:42:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:42:49 INFO - 'PWD': '/builds/slave/test-pgo', 22:42:49 INFO - 'SHELL': '/bin/bash', 22:42:49 INFO - 'SHLVL': '1', 22:42:49 INFO - 'TERM': 'linux', 22:42:49 INFO - 'TMOUT': '86400', 22:42:49 INFO - 'USER': 'cltbld', 22:42:49 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1451714881.751548-796644693', 22:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:49 INFO - '_': '/tools/buildbot/bin/python'} 22:42:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:42:50 INFO - Running setup.py (path:/tmp/pip-DeuVCn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:42:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:42:50 INFO - Running setup.py (path:/tmp/pip-4m32bm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:42:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:42:50 INFO - Running setup.py (path:/tmp/pip-SjHpAS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:42:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:42:50 INFO - Running setup.py (path:/tmp/pip-KTOkig-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:42:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:42:50 INFO - Running setup.py (path:/tmp/pip-BMOq4v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:42:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:42:50 INFO - Running setup.py (path:/tmp/pip-HUdU3j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:42:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:42:50 INFO - Running setup.py (path:/tmp/pip-v14ArV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:42:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:42:50 INFO - Running setup.py (path:/tmp/pip-M1oyB1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:42:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:42:50 INFO - Running setup.py (path:/tmp/pip-mQdYO6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:42:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:42:50 INFO - Running setup.py (path:/tmp/pip-ChGtkO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:42:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:42:50 INFO - Running setup.py (path:/tmp/pip-xa7Iom-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:42:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:42:50 INFO - Running setup.py (path:/tmp/pip-YIrn2Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:42:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:42:51 INFO - Running setup.py (path:/tmp/pip-yPPcIe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:42:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:42:51 INFO - Running setup.py (path:/tmp/pip-SdLqwl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:42:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:42:51 INFO - Running setup.py (path:/tmp/pip-mFfCAH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:42:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:42:51 INFO - Running setup.py (path:/tmp/pip-YlUErx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:42:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:42:51 INFO - Running setup.py (path:/tmp/pip-85AjoQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:42:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:42:51 INFO - Running setup.py install for manifestparser 22:42:51 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:42:51 INFO - Running setup.py install for mozcrash 22:42:51 INFO - Running setup.py install for mozdebug 22:42:51 INFO - Running setup.py install for mozdevice 22:42:51 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:42:51 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:42:51 INFO - Running setup.py install for mozfile 22:42:51 INFO - Running setup.py install for mozhttpd 22:42:52 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:42:52 INFO - Running setup.py install for mozinfo 22:42:52 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:42:52 INFO - Running setup.py install for mozInstall 22:42:52 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:42:52 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:42:52 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:42:52 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:42:52 INFO - Running setup.py install for mozleak 22:42:52 INFO - Running setup.py install for mozlog 22:42:52 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:42:52 INFO - Running setup.py install for moznetwork 22:42:52 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:42:52 INFO - Running setup.py install for mozprocess 22:42:52 INFO - Running setup.py install for mozprofile 22:42:52 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:42:52 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:42:52 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:42:52 INFO - Running setup.py install for mozrunner 22:42:52 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:42:52 INFO - Running setup.py install for mozscreenshot 22:42:52 INFO - Running setup.py install for moztest 22:42:53 INFO - Running setup.py install for mozversion 22:42:53 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:42:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:42:53 INFO - Cleaning up... 22:42:53 INFO - Return code: 0 22:42:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:42:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0d5cd26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a32630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3840>, '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 0x1a306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a30b60>, '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': 'cd88c086d1ff67493cfd1714000001ba-1451714881.751548-796644693', '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 22:42:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:42:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:42:53 INFO - Using env: {'DISPLAY': ':0', 22:42:53 INFO - 'HOME': '/home/cltbld', 22:42:53 INFO - 'LANG': 'en_US.UTF-8', 22:42:53 INFO - 'LANGUAGE': 'en_US:en', 22:42:53 INFO - 'LOGNAME': 'cltbld', 22:42:53 INFO - 'MAIL': '/var/mail/cltbld', 22:42:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:53 INFO - 'MOZ_NO_REMOTE': '1', 22:42:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:53 INFO - 'NO_EM_RESTART': '1', 22:42:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:42:53 INFO - 'PWD': '/builds/slave/test-pgo', 22:42:53 INFO - 'SHELL': '/bin/bash', 22:42:53 INFO - 'SHLVL': '1', 22:42:53 INFO - 'TERM': 'linux', 22:42:53 INFO - 'TMOUT': '86400', 22:42:53 INFO - 'USER': 'cltbld', 22:42:53 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1451714881.751548-796644693', 22:42:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:53 INFO - '_': '/tools/buildbot/bin/python'} 22:42:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:42:53 INFO - Running setup.py (path:/tmp/pip-0Nm_QI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:42:53 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)) 22:42:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:42:53 INFO - Running setup.py (path:/tmp/pip-fc7zhY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:42:53 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)) 22:42:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:42:53 INFO - Running setup.py (path:/tmp/pip-xbIHaK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:42:53 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)) 22:42:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:42:53 INFO - Running setup.py (path:/tmp/pip-nFYLX8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:42:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:42:53 INFO - Running setup.py (path:/tmp/pip-Oj1fsS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:42:53 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)) 22:42:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:42:53 INFO - Running setup.py (path:/tmp/pip-qf0Csh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:42:53 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)) 22:42:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:42:53 INFO - Running setup.py (path:/tmp/pip-u7Crl1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:42:53 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)) 22:42:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:42:53 INFO - Running setup.py (path:/tmp/pip-Uk3pK6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:42:53 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)) 22:42:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:42:53 INFO - Running setup.py (path:/tmp/pip-B_Qh1Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:42:54 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)) 22:42:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:42:54 INFO - Running setup.py (path:/tmp/pip-73gMeB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:42:54 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)) 22:42:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:42:54 INFO - Running setup.py (path:/tmp/pip-LX4Klc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:42:54 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)) 22:42:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:42:54 INFO - Running setup.py (path:/tmp/pip-vtQvm4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:42:54 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)) 22:42:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:42:54 INFO - Running setup.py (path:/tmp/pip-FYAkNv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:42:54 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)) 22:42:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:42:54 INFO - Running setup.py (path:/tmp/pip-WUZYdV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:42:54 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)) 22:42:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:42:54 INFO - Running setup.py (path:/tmp/pip-gYWOXV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:42:54 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)) 22:42:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:42:54 INFO - Running setup.py (path:/tmp/pip-ERXaeT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:42:54 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)) 22:42:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:42:54 INFO - Running setup.py (path:/tmp/pip-wIAvSa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:42:54 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)) 22:42:54 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)) 22:42:54 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)) 22:42:54 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)) 22:42:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:42:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:42:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42:56 INFO - Downloading blessings-1.5.1.tar.gz 22:42:56 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 22:42:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:42:56 INFO - Installing collected packages: blessings 22:42:56 INFO - Running setup.py install for blessings 22:42:56 INFO - Successfully installed blessings 22:42:56 INFO - Cleaning up... 22:42:56 INFO - Return code: 0 22:42:56 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:42:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:42:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:42:56 INFO - Reading from file tmpfile_stdout 22:42:56 INFO - Current package versions: 22:42:56 INFO - argparse == 1.2.1 22:42:56 INFO - blessings == 1.5.1 22:42:56 INFO - blobuploader == 1.2.4 22:42:56 INFO - docopt == 0.6.1 22:42:56 INFO - manifestparser == 1.1 22:42:56 INFO - mozInstall == 1.12 22:42:56 INFO - mozcrash == 0.16 22:42:56 INFO - mozdebug == 0.1 22:42:56 INFO - mozdevice == 0.47 22:42:56 INFO - mozfile == 1.2 22:42:56 INFO - mozhttpd == 0.7 22:42:56 INFO - mozinfo == 0.9 22:42:56 INFO - mozleak == 0.1 22:42:56 INFO - mozlog == 3.1 22:42:56 INFO - moznetwork == 0.27 22:42:56 INFO - mozprocess == 0.22 22:42:56 INFO - mozprofile == 0.28 22:42:56 INFO - mozrunner == 6.11 22:42:56 INFO - mozscreenshot == 0.1 22:42:56 INFO - mozsystemmonitor == 0.0 22:42:56 INFO - moztest == 0.7 22:42:56 INFO - mozversion == 1.4 22:42:56 INFO - psutil == 3.1.1 22:42:56 INFO - requests == 1.2.3 22:42:56 INFO - wsgiref == 0.1.2 22:42:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:42:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:42:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f0d5cd26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a32630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3840>, '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 0x1a306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a30b60>, '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': 'cd88c086d1ff67493cfd1714000001ba-1451714881.751548-796644693', '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 22:42:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 22:42:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 22:42:56 INFO - Using env: {'DISPLAY': ':0', 22:42:56 INFO - 'HOME': '/home/cltbld', 22:42:56 INFO - 'LANG': 'en_US.UTF-8', 22:42:56 INFO - 'LANGUAGE': 'en_US:en', 22:42:56 INFO - 'LOGNAME': 'cltbld', 22:42:56 INFO - 'MAIL': '/var/mail/cltbld', 22:42:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:56 INFO - 'MOZ_NO_REMOTE': '1', 22:42:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:56 INFO - 'NO_EM_RESTART': '1', 22:42:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:42:56 INFO - 'PWD': '/builds/slave/test-pgo', 22:42:56 INFO - 'SHELL': '/bin/bash', 22:42:56 INFO - 'SHLVL': '1', 22:42:56 INFO - 'TERM': 'linux', 22:42:56 INFO - 'TMOUT': '86400', 22:42:56 INFO - 'USER': 'cltbld', 22:42:56 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1451714881.751548-796644693', 22:42:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:56 INFO - '_': '/tools/buildbot/bin/python'} 22:42:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:56 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)) 22:42:56 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)) 22:42:56 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)) 22:42:56 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)) 22:42:56 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)) 22:42:56 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)) 22:42:56 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)) 22:42:56 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)) 22:42:57 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)) 22:42:57 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)) 22:42:57 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)) 22:42:57 INFO - Cleaning up... 22:42:57 INFO - Return code: 0 22:42:57 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:42:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:42:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0d5cd26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a32630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3840>, '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 0x1a306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a30b60>, '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': 'cd88c086d1ff67493cfd1714000001ba-1451714881.751548-796644693', '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 22:42:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 22:42:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:42:57 INFO - Using env: {'DISPLAY': ':0', 22:42:57 INFO - 'HOME': '/home/cltbld', 22:42:57 INFO - 'LANG': 'en_US.UTF-8', 22:42:57 INFO - 'LANGUAGE': 'en_US:en', 22:42:57 INFO - 'LOGNAME': 'cltbld', 22:42:57 INFO - 'MAIL': '/var/mail/cltbld', 22:42:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:57 INFO - 'MOZ_NO_REMOTE': '1', 22:42:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:57 INFO - 'NO_EM_RESTART': '1', 22:42:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:42:57 INFO - 'PWD': '/builds/slave/test-pgo', 22:42:57 INFO - 'SHELL': '/bin/bash', 22:42:57 INFO - 'SHLVL': '1', 22:42:57 INFO - 'TERM': 'linux', 22:42:57 INFO - 'TMOUT': '86400', 22:42:57 INFO - 'USER': 'cltbld', 22:42:57 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1451714881.751548-796644693', 22:42:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:57 INFO - '_': '/tools/buildbot/bin/python'} 22:42:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:57 INFO - Downloading/unpacking jsonschema 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:42:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 22:42:58 INFO - Downloading/unpacking functools32 (from jsonschema) 22:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:42:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:59 INFO - Downloading functools32-3.2.3-2.tar.gz 22:42:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 22:42:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:42:59 INFO - warning: no files found matching '*.txt' 22:42:59 INFO - no previously-included directories found matching 'build' 22:42:59 INFO - no previously-included directories found matching 'dist' 22:42:59 INFO - no previously-included directories found matching '.git*' 22:42:59 INFO - Installing collected packages: jsonschema, functools32 22:42:59 INFO - Running setup.py install for functools32 22:42:59 INFO - warning: no files found matching '*.txt' 22:42:59 INFO - no previously-included directories found matching 'build' 22:42:59 INFO - no previously-included directories found matching 'dist' 22:42:59 INFO - no previously-included directories found matching '.git*' 22:42:59 INFO - Successfully installed jsonschema functools32 22:42:59 INFO - Cleaning up... 22:42:59 INFO - Return code: 0 22:42:59 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:42:59 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')]} 22:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:59 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')]} 22:42:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0d5cd26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a32630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3840>, '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 0x1a306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a30b60>, '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': 'cd88c086d1ff67493cfd1714000001ba-1451714881.751548-796644693', '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 22:42:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 22:42:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:42:59 INFO - Using env: {'DISPLAY': ':0', 22:42:59 INFO - 'HOME': '/home/cltbld', 22:42:59 INFO - 'LANG': 'en_US.UTF-8', 22:42:59 INFO - 'LANGUAGE': 'en_US:en', 22:42:59 INFO - 'LOGNAME': 'cltbld', 22:42:59 INFO - 'MAIL': '/var/mail/cltbld', 22:42:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:59 INFO - 'MOZ_NO_REMOTE': '1', 22:42:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:59 INFO - 'NO_EM_RESTART': '1', 22:42:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:42:59 INFO - 'PWD': '/builds/slave/test-pgo', 22:42:59 INFO - 'SHELL': '/bin/bash', 22:42:59 INFO - 'SHLVL': '1', 22:42:59 INFO - 'TERM': 'linux', 22:42:59 INFO - 'TMOUT': '86400', 22:42:59 INFO - 'USER': 'cltbld', 22:42:59 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1451714881.751548-796644693', 22:42:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:59 INFO - '_': '/tools/buildbot/bin/python'} 22:42:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:59 INFO - Downloading/unpacking flake8 22:42:59 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 22:42:59 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 22:42:59 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 22:42:59 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 22:42:59 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 22:42:59 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 22:43:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:43:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 22:43:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:43:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:43:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:43:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:43:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 22:43:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:43:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:43:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:43:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 22:43:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:43:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:43:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:43:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 22:43:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:43:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:43:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:43:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:43:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:43:01 INFO - no previously-included directories found matching 'docs/_build' 22:43:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:43:01 INFO - Running setup.py install for pep8 22:43:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:43:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:43:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:43:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:43:02 INFO - no previously-included directories found matching 'docs/_build' 22:43:02 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:43:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:43:02 INFO - Cleaning up... 22:43:02 INFO - Return code: 0 22:43:02 INFO - Running post-action listener: _resource_record_post_action 22:43:02 INFO - Running post-action listener: _start_resource_monitoring 22:43:02 INFO - Starting resource monitoring. 22:43:02 INFO - ##### 22:43:02 INFO - ##### Running install step. 22:43:02 INFO - ##### 22:43:02 INFO - Running pre-action listener: _resource_record_pre_action 22:43:02 INFO - Running main action method: install 22:43:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:43:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:43:02 INFO - Reading from file tmpfile_stdout 22:43:02 INFO - Detecting whether we're running mozinstall >=1.0... 22:43:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:43:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:43:02 INFO - Reading from file tmpfile_stdout 22:43:02 INFO - Output received: 22:43:02 INFO - Usage: mozinstall [options] installer 22:43:02 INFO - Options: 22:43:02 INFO - -h, --help show this help message and exit 22:43:02 INFO - -d DEST, --destination=DEST 22:43:02 INFO - Directory to install application into. [default: 22:43:02 INFO - "/builds/slave/test-pgo"] 22:43:02 INFO - --app=APP Application being installed. [default: firefox] 22:43:02 INFO - mkdir: /builds/slave/test-pgo/build/application 22:43:02 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'] 22:43:02 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 22:43:18 INFO - Reading from file tmpfile_stdout 22:43:18 INFO - Output received: 22:43:18 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:43:18 INFO - Running post-action listener: _resource_record_post_action 22:43:18 INFO - ##### 22:43:18 INFO - ##### Running run-tests step. 22:43:18 INFO - ##### 22:43:18 INFO - Running pre-action listener: _resource_record_pre_action 22:43:18 INFO - Running main action method: run_tests 22:43:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:43:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:43:18 INFO - Python 2.7.3 22:43:18 INFO - Return code: 0 22:43:18 INFO - grabbing minidump binary from tooltool 22:43: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')]} 22:43:18 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 0x1ac3840>, '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 0x1a306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a30b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:43:18 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 22:43:18 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 22:43:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:43:18 INFO - Return code: 0 22:43:18 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:43:18 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:43:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:43:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:43:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:43:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:43:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:43:19 INFO - Return code: 0 22:43:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fEs7AXnhQzmSHuuNxuM2oA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 22:43:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fEs7AXnhQzmSHuuNxuM2oA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 22:43:19 INFO - Using env: {'DISPLAY': ':0', 22:43:19 INFO - 'HOME': '/home/cltbld', 22:43:19 INFO - 'LANG': 'en_US.UTF-8', 22:43:19 INFO - 'LANGUAGE': 'en_US:en', 22:43:19 INFO - 'LOGNAME': 'cltbld', 22:43:19 INFO - 'MAIL': '/var/mail/cltbld', 22:43:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:43:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:43:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:43:19 INFO - 'MOZ_NO_REMOTE': '1', 22:43:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:43:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:43:19 INFO - 'NO_EM_RESTART': '1', 22:43:19 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:43:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:43:19 INFO - 'PWD': '/builds/slave/test-pgo', 22:43:19 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:43:19 INFO - 'SHELL': '/bin/bash', 22:43:19 INFO - 'SHLVL': '1', 22:43:19 INFO - 'TERM': 'linux', 22:43:19 INFO - 'TMOUT': '86400', 22:43:19 INFO - 'USER': 'cltbld', 22:43:19 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1451714881.751548-796644693', 22:43:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:43:19 INFO - '_': '/tools/buildbot/bin/python'} 22:43:19 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fEs7AXnhQzmSHuuNxuM2oA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:43:19 INFO - mozversion application_buildid: 20160101203051 22:43:19 INFO - mozversion application_changeset: ce643acfab14d95bea2fb6c4f56477413514b686 22:43:19 INFO - mozversion application_display_name: Nightly 22:43:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:43:19 INFO - mozversion application_name: Firefox 22:43:19 INFO - mozversion application_remotingname: firefox 22:43:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 22:43:19 INFO - mozversion application_vendor: Mozilla 22:43:19 INFO - mozversion application_version: 46.0a1 22:43:19 INFO - mozversion platform_buildid: 20160101203051 22:43:19 INFO - mozversion platform_changeset: ce643acfab14d95bea2fb6c4f56477413514b686 22:43:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 22:43:19 INFO - mozversion platform_version: 46.0a1 22:43:19 INFO - using testdate: 1451716999 22:43:19 INFO - actual date: 1451716999 22:43:19 INFO - starting webserver on 'localhost:37913' 22:43:19 INFO - SUITE-START | Running 3 tests 22:43:19 INFO - TEST-START | dromaeo_css 22:43:19 INFO - operating with platform_type : linux_ 22:43:19 INFO - Initialising browser for dromaeo_css test... 22:43:19 INFO - TEST-INFO | started process 6903 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHCBh4U/profile http://localhost:37913/getInfo.html) 22:43:23 INFO - PROCESS | 6903 | __metrics Screen width/height:1600/1200 22:43:23 INFO - PROCESS | 6903 | colorDepth:24 22:43:23 INFO - PROCESS | 6903 | Browser inner width/height: 1024/697 22:43:23 INFO - PROCESS | 6903 | __metrics 22:43:23 INFO - PROCESS | 6903 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:43:23 INFO - PROCESS | 6903 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:43:23 INFO - PROCESS | 6903 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 22:43:24 INFO - TEST-INFO | 6903: exit 0 22:43:24 INFO - Browser initialized. 22:43:24 INFO - Running cycle 1/1 for dromaeo_css test... 22:43:24 INFO - TEST-INFO | started process 6999 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHCBh4U/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:43:36 INFO - PROCESS | 6999 | RSS: Main: 147202048 22:43:36 INFO - PROCESS | 6999 | 22:44:27 INFO - PROCESS | 6999 | 1451717067452 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] 22:46:35 INFO - PROCESS | 6999 | Cycle 1(1): loaded http://localhost:37913/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37913/tests/dromaeo/cssquery-ext.html) 22:46:36 INFO - PROCESS | 6999 | RSS: Main: 318713856 22:46:36 INFO - PROCESS | 6999 | 22:49:39 INFO - PROCESS | 6999 | Cycle 1(1): loaded http://localhost:37913/tests/dromaeo/cssquery-ext.html (next: http://localhost:37913/tests/dromaeo/cssquery-jquery.html) 22:49:40 INFO - PROCESS | 6999 | RSS: Main: 243408896 22:49:40 INFO - PROCESS | 6999 | 22:52:42 INFO - PROCESS | 6999 | Cycle 1(1): loaded http://localhost:37913/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37913/tests/dromaeo/cssquery-mootools.html) 22:52:42 INFO - PROCESS | 6999 | RSS: Main: 232468480 22:52:42 INFO - PROCESS | 6999 | 22:55:44 INFO - PROCESS | 6999 | Cycle 1(1): loaded http://localhost:37913/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37913/tests/dromaeo/cssquery-prototype.html) 22:55:45 INFO - PROCESS | 6999 | RSS: Main: 214282240 22:55:45 INFO - PROCESS | 6999 | 22:58:47 INFO - PROCESS | 6999 | Cycle 1(1): loaded http://localhost:37913/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37913/tests/dromaeo/cssquery-yui.html) 22:58:48 INFO - PROCESS | 6999 | RSS: Main: 197853184 22:58:48 INFO - PROCESS | 6999 | 23:01:50 INFO - PROCESS | 6999 | Cycle 1(1): loaded http://localhost:37913/tests/dromaeo/cssquery-yui.html (next: http://localhost:37913/tests/dromaeo/cssquery-dojo.html) 23:01:51 INFO - PROCESS | 6999 | RSS: Main: 262631424 23:01:51 INFO - PROCESS | 6999 | 23:01:51 INFO - PROCESS | 6999 | __start_tp_report 23:01:51 INFO - PROCESS | 6999 | _x_x_mozilla_page_load 23:01:51 INFO - PROCESS | 6999 | _x_x_mozilla_page_load_details 23:01:51 INFO - PROCESS | 6999 | |i|pagename|runs| 23:01:51 INFO - PROCESS | 6999 | |0;dojo.html;3057.1592811976707;3118.3763247350535;3153.700398462147;3155.842207889605;3165.3827503636794;5139.511746384097;5216.608754343425;5216.634835561507;5231.52916237539;5289.365276166865;5152.407473140581;5226.529612334889;5228.0850851101095;5298.92051619226;5328.6269961102735;4788.114198873202;4804.975975120119;4810.9037819243595;4857.077155340492;4921.163402221631;4923.778429970642;4949.876253093666;4958.801647934079;4974.427940786802;5026.874328141789;4726.2201736713405;4753.1444340019125;4821.879453013686;4826.710397376133;4871.975640121776;4804.063207674505;4811.350467686888;4823.5658790709;4843.903121937541;4858.659893807435;4764.928526072112;4767.4994125617;4783.139034973703;4788.688735232199;4840.419149702023;5093.337866077386;5166.199239117943;5190.32525771651;5201.505856943584;5207.479252074762;5582.609217354787;5595.4964053235;5624.775008999635;5691.430856914317;5726.942730572682;5664.065429204176;5664.291963504562;5670.121131224667;5676.8864622707315;5678.37537870838;5245.160774276135;5250.737463126867;5252.5535329497425;5256.526912577886;5258.81594144207;5697.4302569742695;5764.423557644202;5811.709414529341;5834.474897259182;5877.382874798084;5546.667199968015;5598.944010559923;5608.46719561641;5618.410066942994;5652.293463317085;5647.068233741386;5663.858403539944;5665;5667.688277144796;5669.092945128842;5545.500904918496;5597.076482380443;5607.607467477237;5638.35158956717;5667.546596272288;5574.721263936787;5633.492985631313;5637.46444087811;5664.943350566442;5677.261955945701;4388.5611438856495;4410.117976404732;4410.4927933287445;4411.867643970686;4446.844360447369;3845.3655146900446;3891.4746509220895;3908.179282350681;3915.0603855075146;3927.136030073379;5225.503577160163;5271.077561426735;5274.578033757367;5281.313429254173;5321.3348331458565;5675.432456754292;5678.375378708339;5708.743106560215;5715.114157305624;5716.5140963017775;5139.331886854685;5220.817271395559;5228.843134705965;5298.072837253465;5322;4828.855134345975;4875.024995000943;4880.975595122072;4887.169181239198;4901.09329773993;5815.360310365856;5860.413958604191;5867.823965281048;5882.294124704978;5951.3751056139345;5495.230667706444;5596.188552659923;5602.2717046783655;5638.5489160867855;5703.914441283301;5766.855828604318;5838.766449342149;5844.6785426801935;5848.444397782204;5889.823305300848;5546.251256080539;5548.223248745259;5553.916691249715;5561.499465048165;5562.582806289625;5558.66648001105;5627.577931655061;5632.295963004624;5675.233843431249;5675.347335056356;5488.039593071277;5523.364813046391;5547.140193270049;5547.1679248113105;5547.41752116022;5491.560675145899;5539.335279766454;5539.7784088636;5543.307086614173;5545.7781688732;5444.074507333842;5449.64577302474;5453.345598528202;5455.372632147354;5463.918041229305;5513.448655134454;5535.667859928417;5588.413216612197;5609.467100625434;5619.747111380079;5483.561315094863;5506;5519.724013799214;5529.972350138384;5562.360328562106 23:01:51 INFO - PROCESS | 6999 | |1;ext.html;528.9021531016762;540.5297391269596;545.6398776807306;558.9804356847509;570.421022661998;27526.17421477354;35629;35828.82085589575;35880.64119358805;35922.92231233064;41189.17621647573;41545;41723;41726.79136604313;41927;7282.927170728278;7409.333160015598;8651.610677519511;8834;8842.778930526756;10015.899841001607;10238.89761102387;10266.332688375232;10267;10280.177585793119;9912.702618921408;9950.65172718955;10009.699709008704;10013.39919604826;10031.448270345129;7502.212267711893;7676.270754278335;9994.9500252499;10115.696529104138;10318.7420314492;9821.214302855755;9926.652567160187;9957.402555846673;9967.700968970943;9976.201903847676;34795.30409391823;35148.121296967525;35156.648433515846;35195.64804351949;35255.64744352549;3090.7527397808344;3130.5617213590117;3192.2976945072046;3439.329330780499;3837.2901013312626;29805.40389192204;29918.401631967237;29941.700582994108;30148;30175.849120754476;3714.3685573452576;3747.5502939647145;3804.2011177652726;3818.5417749869916;3909.863154789569;267597;268872;269444.6527767368;269673.7744669138;270582;51652.74173629108;52861.47138528565;58629;58666.706666466394;59961.40038599646;53926.191107133425;53997.1900421494;54214.728926355114;54260.728696356266;54336;14647.560573182822;14825.851741482662;14839.703205936037;14865.851341486446;14867.776983345258;11182.66452006441;11249.71875703114;11250.549978000789;11255;11269.887301127048;19062.237510499424;19286.324978625682;19946.210000548912;20047;20112;7628.656710448043;7797.727079552188;7831.960840195762;7923.326517245983;7926.24700653437;846.8729690546468;858.9441686290371;909.4588719711761;986.6398764450923;1049.6693541534391;25262.368440789127;26702.19893403201;26865.597016044776;27148.457030859274;27396.315092122855;923.2567782934668;955.9044095590524;963.0032915931977;1002.5037606384886;1011;13263.933680331536;13640.181589104686;13898.16611003343;13904.304784760721;14104.85895141056;320483;326366;326440;326600;327145;52012.73993630007;52277.47722522802;52315.73842130765;52329;52417;1276.21512769646;1302.8176055352258;1303.9543615973396;1311.4754098360731;1319.8284223050941;25150.874245628656;25389.365265868502;25480.74519254858;25497.872510637328;25662.565660778862;41559.1688166241;41666.16667666569;41815.1636967265;41980;42013;237089;238104;238284;298142;298641;27449.31376715598;27916.16251512458;30617.54073688852;31289.374212515166;31855.681443185273;36925.26149477049;37372.626273738;37398.75607463561;37761.05597360088;37766.811165944;31928.52107218347;32185;32416.83791581027;32682.50976235406;32873.342533149684;29170.7082929168;32476.350472990882;34086.829565853004;35083;37029.814850926654;32564;32857.17857053593;32887;35385;35910.28179436449;28496;29406.411871762873;29707.960221392146;29820.960937383054;31848.52227216547;24449.511009779348;24801.751982479946;24890;25151.87424062941;25291.87354063218 23:01:51 INFO - PROCESS | 6999 | |2;jquery.html;355.73320009992506;358.9605143434222;360.3082082401788;361.0810487309796;364.09885533305066;13395.799063014063;13812.516561920334;15995.360185592577;16013.27940242689;16594.087325197124;15594.37622495099;15784.368625254976;16382.83617163828;16408.343666253364;16495.505134845946;5098.235264710295;5375.462453754632;5393.649412788176;5398.055340315449;5398.055340315449;4023.336149535338;4112.136451345221;4119.361498967664;4120.793960301988;5319.388270348902;5772.884542309152;5969.13447550105;5971.044632858743;5972.970135149319;5975.312839023524;5836.416358364172;5919.644821310713;5958.404159584007;5958.791442299542;5959.314678811948;5260.552853007499;5274.2879711238875;5278.656887302313;5279.894402111975;5280.709560974145;18523.166457509444;19142.234310627697;19782.505437364038;20350.694739578918;20439.284625038053;2008.2970960163973;2062.804033616804;2068.152057656369;2182.74898386686;2184.486645638274;9051.773705657346;9286;9484.715458536255;10358.948205258925;12755.489780408772;1828.7256911463253;1844.5322793148928;1868.1406552985643;1868.374514172665;1882.28473180192;57741;60474;61176.69411653002;61264.38735612632;61703.69148154275;9938.80122397548;9982.750431239278;10024.097831195228;10031.347962382422;10069.395836249849;13258.403371848097;13262.734745305233;13263.336833158304;13265.734685306239;13272.411879683368;7477.065366829146;7510.511816731895;7517.736879209201;7526.962365188248;7721.6139193041245;7247.23903990084;7293.088363954505;7327.816804579928;7334.083239595051;7376.151742549569;4248.8300467980935;4261.765602891871;4280.422143010716;4318.611324980767;4329.415528903558;1615.5557221764109;1669.3072374964254;1757.3058641836658;1764.7264673975553;1802.53053316954;791.600241877848;798.1858504325555;914.7438717159206;959.2613687460756;991.7223177510309;15659.530214093595;15733.527994160193;15824.208789560476;15958;16269.349226031063;809.3282575462352;897.1387468030764;898.3262553085186;912.589334799343;954.5275088831073;8817.603207855662;9057;9179.81640367189;9421.434713917188;10045.648402306031;535175.0860364478;558993;575044.3034499254;581418;588214;38619.80690096531;75732.24267757362;77103;77623.61188194135;77880;1127.2278489234736;1133.1331531378503;1140.8916152965621;1157.6469176901126;1160.4313886195703;15285.54143375656;15358.769618455955;15375;15434.84565154379;15648.765268520754;19150.71273930864;31825.5226171603;32676.34647306993;33263.667363327026;34824.65175348214;37133;40501;43371.13257734891;43375.78312108419;44781.55218447904;9005.459672419676;9363.625454981724;9366.344355895022;9369.953150234205;9377;11054.723631908944;11080.722981925517;14066.437342506186;16008.519744407686;16074.517764467084;13675;13731;13859.445622175;14101.224432655892;14142.22217778032;13320;13339.733205335644;13417.060805743504;13703.725925481634;13920.860791391957;12003.339816310187;13331.733365332446;13762.518311859038;14162.079464834753;14675.339609717375;9048.502332371783;9157.130072643089;9178.26573874075;9178.449293042439;9178.770530736518;9240.815183696423;10341.793164136825;11148.609798657333;12315.75368492643;14106.153630782186 23:01:51 INFO - PROCESS | 6999 | |3;mootools.html;1297.539373522399;1454.6072560408686;1461.254760072363;1551.8816815047458;1754.333353325736;6755.628440435774;7497.437692173088;7585.620718964057;7593.772186834404;7601.0118684571;7524.924750752491;7697.9615101924555;7707.576083315415;7709.460337776358;7715.652795624196;2236.7204099487562;2260;2260.7174103237094;2262.4230821140586;2268.0587556164173;2244.4837687331924;2264.728232612081;2293.0713061210154;2294.025039358266;2300.0454811253394;2213.214308920334;2225.643896976484;2243.1363924888956;2246.0229800037037;2272.2047283450825;2185.9890700546553;2213.579419910212;2240.2047273217936;2243.842930994831;2243.9775602244013;2319.6636487709357;2342.6251799712136;2342.7188737351457;2343.648452732104;2344.777246161612;7709.267619576131;7803.219678032208;7804.921950780533;7824.843503129962;7838.216178382173;4705.529447055267;4750.263709125091;4772.546608072263;4775.832845850378;4807.567318941312;3021.425929073469;3049.496833022549;3116.9688303116905;3148.7008734170217;3149.5118256670253;1055.7202341379464;1077.6659235636978;1083.8265877459569;1104.9889501104967;1121.7307846116955;10740.08709259714;10820.188485863591;10843.945780271128;10854.294470859448;10877.184211184114;4259.8083086261195;4333.241682705514;4366.607005369468;4380.649548036149;4400.713953593006;9248;9255.67605133817;9264.814703706023;9269.582868770922;9271.860922086174;4744.810207591658;4749.691270067435;4757.310190022427;4771.069641419959;4773.355596994361;3872.9419058714143;3929.2927273090545;4213;4336.392904993303;4348.065165989265;3602.1895073608753;3612.8012959286966;3615.5119058927235;3645.9453108203397;3652.726045546595;1175.7589694112687;1177.4701384377065;1183.9940800296115;1184.7571247894161;1189.3220864107548;885.7342797160826;944.974702447838;976.4483067067084;997.870276864003;1204.2593804809978;7014.298570143047;7032.191298000693;7036;7092.184398794205;7099.89350159748;1041.7187359412917;1044.535181844072;1056.7041228456044;1073.6027669762238;1101.7741363020561;5400.297961265089;5506.174073888948;5513.807016754395;5513.917291240635;5516.696581688046;9034.14175653312;9292.53537323131;9468.90531094694;9582.856257156149;9605.279604029725;9362.906370936204;9383.577739001625;9435.29235307341;9464.432134071978;9496.810063798684;7221.494495385377;7340.853182936418;7360.558366498028;7408.703651853865;7416.147143078507;7019.824504387431;7029.26192749754;7033.191183014019;7052.9647351762915;7058.223595404604;8114.269715725377;8317.792055198426;8440.240378365976;8495.915040849512;8544.18830211129;8615.827683446421;8619.439736417113;8622.137786221578;8759.299256059372;8770.649174032967;6614.70233839488;6762.797116086525;6815;6819.283975182733;6822.590644561144;7201.747938822116;7207.279272072751;7242.311980361857;7260.709571617076;7266.527675701062;6101.694915254131;6663.433608143168;6746.392824645805;6867.793966181022;6869.210040845167;6780.11858458417;6801.489888258301;6802.285759995129;6865.210500792473;6917.827054323682;6618.437432818265;6767.323267673193;6774.627395493098;6777.6272305023695;6789.898151527632;6268.310485846644;6269.811905642656;6271.404216599416;6292.748290068346;6303.1175635412;5945.672987985529;5962.880742385041;6059.818205453667;6225.097360882737;6351.714172862325 23:01:51 INFO - PROCESS | 6999 | |4;prototype.html;327.2195812986029;329.4054232111039;340.1173953590433;341.55427167546344;342.9382711112;5926.199963004993;5935.139404786309;5948.167256584082;5982.940170598293;5986.341502434729;5612.41069687683;5692.829215123543;5737.397573254811;5865.853353666161;5892.616979896315;4538.205813982539;4547.499775024745;4567.155076310876;4573.268277075676;4581.221192397284;4351.238533256684;4562.836476698454;4565.817367305321;4569.885752856172;4576.496585375606;4393.143337049277;4445.066536027438;4497.9325310120375;4512;4526.6831321807485;4494.898749806286;4511.954880451186;4512.323151527265;4521.208788462022;4548.113117942003;4019.8191081401405;4030.052937559671;4030.496187976503;4030.738002029888;4040.151568170688;5543.8891222175735;5631.324241091054;5638.943610563924;5645.745941432645;5647.152927060933;5304.575633949314;5312.1766126250495;5315.415304316522;5316.282301889273;5324.41431442541;6176.629402235881;6185.845353866144;6187.102870083858;6192.783252586138;6238.781642642486;4422.7346359218545;4424.889377765549;4435.35687325336;4435.778211089465;4438.178936896685;6332.620042797447;6512.283648798629;6513.576617519846;6522.641254730988;6530.053142294389;4575.336576196433;4575.679702420799;4579.977100114478;4583.12920545102;4583.358329833826;4634.119517291704;4638.953610463852;4643.233866412072;4644.86065418038;4644.9767751161025;5266;5269.604779641542;5272.2882410874045;5281.947180528223;5295.020421222086;6113.602615829956;6258.968705156536;6279.623222606659;6299.622022678654;6314.400131987454;1581.2251996521622;1584.6434552225658;1586.7778511008469;1587.261923205715;1588.563145135074;1060.3160961179997;1069.385103565453;1078.7680648660576;1090.738222826516;1095.5672509358758;5975.4024597540765;5978.850528736816;5981.252343457068;5982.4316689914385;5984.222051133412;6481.513886458534;6484.870302593922;6491.642959637265;6493.740250389931;6497.350264973465;5806.912896306559;5916.467517923407;5920.674362909996;5926.111083337448;5927.940720592739;3346.782459140148;3480.443129099332;3528.2943411317838;3530.3115892400733;3549.982250088785;6770.796876093725;6804.65976701163;6806.285340039323;6814.727410903607;6815.659217039129;6666.500012499082;6678.432333251728;6679.365460281266;6686;6686.231083425371;6615.900761488581;6787.04981302618;6802.455803535705;6803.829904252433;6809.421199198124;6475.611463312216;6481.513886458629;6486.1243732097455;6490.350964903472;6527.640979745969;6444.967775161282;6447.6453795041725;6454.5159113065765;6457.935420645921;6467.353264673495;6590.835229119119;6772.93227067723;6779.254282029072;6783.05037294789;6783.253842077269;4535.070310586256;4562.680612357103;4568.1548913451115;4569.977150114228;4579.450465944108;6463.418292353711;6468.902966455601;6480.189976252968;6482.967585162044;6495.935040649533;6155.35368786271;6307.590006649737;6310.1796766420075;6315.3053164152825;6315.621062736251;6301.96849015752;6304.257647923168;6305.1172835803945;6305.495560355069;6306.180196574416;6174.845628859314;6179.196704428396;6189.9690501549;6194.5044396449075;6197.5351848610635;6175.62946223228;6200.844978875564;6235.378801511549;6345.238571371465;6353.269374022047;6211.720472578835;6230.532710046674;6242.188515492957;6244.188255526752;6244.438000579969 23:01:51 INFO - PROCESS | 6999 | |5;yui.html;711.5588335232155;793.4049462902823;837.6021389839827;842.8103676672749;869.9478031318125;11254.887451125487;11395;11411.087113030959;14260.429582816674;14433.711325773478;12522.624321270354;12576.811347829767;12582.874171258285;12590.181638193511;12598.433070511826;666.669998350817;813.3858936502932;825.154216927648;825.6821123867325;826.1862065865118;669.8827705151604;788.5229436191108;817.2930415190876;817.5176645778989;819.4304958054155;838.9077201507829;839;839.08539691736;839.3411172229801;841.4278290762279;690.7444245629099;696.5194016128905;821.5070957425556;834.1991687979547;845.6786421159982;620.8013435700533;622.2035794183453;622.7820262907991;628.9716962736687;630.495603517189;11745.647630571097;11771.764564708743;11809.822852657217;11856.347900865449;11858.407079645984;10922.071623911977;11031.448427578589;11799.174057815957;11836.585719499777;12397.690057748538;9776.266779991458;9815.067568580973;9864.60541578336;10049.145822605087;10248.436336001518;3509.4209455439823;3567.6967457766123;3610.223801882608;3639.909002274938;3652.086978255436;48244;48470.27294590584;48558.7572062141;48587;48598;9637.956276830773;9662.71011869645;9721.756956076013;9943.204543636637;10083.949580252052;17494.737578936325;17546.122693865254;17565.824341756674;17594.94430334184;17605.911970440324;6649.8174111184835;6716.798496045127;6758.493113016543;6769.482871459744;6948.096747422803;3969.166475040216;3979.542352629485;4000.599940005976;4032.6370626643743;4059.512858457004;3067.1871953932227;3090.969090309113;3093.969060309368;3097.597312349425;3101.116181888196;531.1209947536755;544.1484077418827;547.1246006389824;548.2844887421953;565.5164834066895;485.34478454087406;609.969501524922;619.1486705779553;640.9647469389229;687.2234375156141;7663.501872378278;7846.960765196138;7861.992076290576;7987.9201207988335;8055.798605034804;536.7557761218636;618.0605479670965;652.9118568993125;675.4731309578536;691.4641153106282;3665.908352291214;3917.7257591968287;3929.8035098245546;3947.881563553098;4008.07814202735;52655.73672131615;56016.71991640097;56198.43801562014;56336;56444;41534.584654153674;42449;42705.35941960873;42980.140397191884;43196.136077278905;43666.56333436625;44451.55548444539;44822.32766508505;44990.10019799586;46242.30636540455;7531.88702169457;7585.469017168745;7620.80947976305;7771.4559980800805;7812.3750099993;32302.515462268555;32365.35269294648;32854.178645534055;32954.83522582372;33695.494567582;40424.79787601043;40497;43274.567254327056;43831;44131.77934110309;10638;10707.571697132027;10993;11214.943925280322;11249.437528123724;11670;11789.823152652889;11851.585194518495;11948.683590163459;12156.209846359958;10722.571097156026;10879.728006799893;10881.455927203766;10945.781084378426;10979.451027448436;10737.89262107369;10951.83572246401;11234.269772464764;11517;11530.1928864982;8186.96182275397;10533.841992370273;10915.454227288445;11050.778984420427;11103.888961110286;8569;8873.334499912404;8960.163166550972;9269.72190834276;9338;8652.567371631267;8829.602667879832;8973.910260897308;9030.593623287099;9070.319726020443 23:01:51 INFO - PROCESS | 6999 | __end_tp_report 23:01:51 INFO - PROCESS | 6999 | __start_cc_report 23:01:51 INFO - PROCESS | 6999 | _x_x_mozilla_cycle_collect,1652 23:01:51 INFO - PROCESS | 6999 | __end_cc_report 23:01:51 INFO - PROCESS | 6999 | __startTimestamp1451718111067__endTimestamp 23:01:51 INFO - PROCESS | 6999 | 23:01:51 INFO - PROCESS | 6999 | ------- Summary: start ------- 23:01:51 INFO - PROCESS | 6999 | Number of tests: 6 23:01:51 INFO - PROCESS | 6999 | 23:01:51 INFO - PROCESS | 6999 | [#0] dojo.html Cycles:165 Average:5254.19 Median:5491.56 stddev:577.93 (10.5%) stddev-sans-first:553.41 23:01:51 INFO - PROCESS | 6999 | Values: 3057.2 3118.4 3153.7 3155.8 3165.4 5139.5 5216.6 5216.6 5231.5 5289.4 5152.4 5226.5 5228.1 5298.9 5328.6 4788.1 4805.0 4810.9 4857.1 4921.2 4923.8 4949.9 4958.8 4974.4 5026.9 4726.2 4753.1 4821.9 4826.7 4872.0 4804.1 4811.4 4823.6 4843.9 4858.7 4764.9 4767.5 4783.1 4788.7 4840.4 5093.3 5166.2 5190.3 5201.5 5207.5 5582.6 5595.5 5624.8 5691.4 5726.9 5664.1 5664.3 5670.1 5676.9 5678.4 5245.2 5250.7 5252.6 5256.5 5258.8 5697.4 5764.4 5811.7 5834.5 5877.4 5546.7 5598.9 5608.5 5618.4 5652.3 5647.1 5663.9 5665.0 5667.7 5669.1 5545.5 5597.1 5607.6 5638.4 5667.5 5574.7 5633.5 5637.5 5664.9 5677.3 4388.6 4410.1 4410.5 4411.9 4446.8 3845.4 3891.5 3908.2 3915.1 3927.1 5225.5 5271.1 5274.6 5281.3 5321.3 5675.4 5678.4 5708.7 5715.1 5716.5 5139.3 5220.8 5228.8 5298.1 5322.0 4828.9 4875.0 4881.0 4887.2 4901.1 5815.4 5860.4 5867.8 5882.3 5951.4 5495.2 5596.2 5602.3 5638.5 5703.9 5766.9 5838.8 5844.7 5848.4 5889.8 5546.3 5548.2 5553.9 5561.5 5562.6 5558.7 5627.6 5632.3 5675.2 5675.3 5488.0 5523.4 5547.1 5547.2 5547.4 5491.6 5539.3 5539.8 5543.3 5545.8 5444.1 5449.6 5453.3 5455.4 5463.9 5513.4 5535.7 5588.4 5609.5 5619.7 5483.6 5506.0 5519.7 5530.0 5562.4 23:01:51 INFO - PROCESS | 6999 | 23:01:51 INFO - PROCESS | 6999 | [#1] ext.html Cycles:180 Average:44496.93 Median:326520.00 stddev:75166.97 (23.0%) stddev-sans-first:75305.34 23:01:51 INFO - PROCESS | 6999 | Values: 528.9 540.5 545.6 559.0 570.4 27526.2 35629.0 35828.8 35880.6 35922.9 41189.2 41545.0 41723.0 41726.8 41927.0 7282.9 7409.3 8651.6 8834.0 8842.8 10015.9 10238.9 10266.3 10267.0 10280.2 9912.7 9950.7 10009.7 10013.4 10031.4 7502.2 7676.3 9995.0 10115.7 10318.7 9821.2 9926.7 9957.4 9967.7 9976.2 34795.3 35148.1 35156.6 35195.6 35255.6 3090.8 3130.6 3192.3 3439.3 3837.3 29805.4 29918.4 29941.7 30148.0 30175.8 3714.4 3747.6 3804.2 3818.5 3909.9 267597.0 268872.0 269444.7 269673.8 270582.0 51652.7 52861.5 58629.0 58666.7 59961.4 53926.2 53997.2 54214.7 54260.7 54336.0 14647.6 14825.9 14839.7 14865.9 14867.8 11182.7 11249.7 11250.5 11255.0 11269.9 19062.2 19286.3 19946.2 20047.0 20112.0 7628.7 7797.7 7832.0 7923.3 7926.2 846.9 858.9 909.5 986.6 1049.7 25262.4 26702.2 26865.6 27148.5 27396.3 923.3 955.9 963.0 1002.5 1011.0 13263.9 13640.2 13898.2 13904.3 14104.9 320483.0 326366.0 326440.0 326600.0 327145.0 52012.7 52277.5 52315.7 52329.0 52417.0 1276.2 1302.8 1304.0 1311.5 1319.8 25150.9 25389.4 25480.7 25497.9 25662.6 41559.2 41666.2 41815.2 41980.0 42013.0 237089.0 238104.0 238284.0 298142.0 298641.0 27449.3 27916.2 30617.5 31289.4 31855.7 36925.3 37372.6 37398.8 37761.1 37766.8 31928.5 32185.0 32416.8 32682.5 32873.3 29170.7 32476.4 34086.8 35083.0 37029.8 32564.0 32857.2 32887.0 35385.0 35910.3 28496.0 29406.4 29708.0 29821.0 31848.5 24449.5 24801.8 24890.0 25151.9 25291.9 23:01:51 INFO - PROCESS | 6999 | 23:01:51 INFO - PROCESS | 6999 | [#2] jquery.html Cycles:180 Average:28731.19 Median:37876.40 stddev:92695.31 (244.7%) stddev-sans-first:92930.86 23:01:51 INFO - PROCESS | 6999 | Values: 355.7 359.0 360.3 361.1 364.1 13395.8 13812.5 15995.4 16013.3 16594.1 15594.4 15784.4 16382.8 16408.3 16495.5 5098.2 5375.5 5393.6 5398.1 5398.1 4023.3 4112.1 4119.4 4120.8 5319.4 5772.9 5969.1 5971.0 5973.0 5975.3 5836.4 5919.6 5958.4 5958.8 5959.3 5260.6 5274.3 5278.7 5279.9 5280.7 18523.2 19142.2 19782.5 20350.7 20439.3 2008.3 2062.8 2068.2 2182.7 2184.5 9051.8 9286.0 9484.7 10358.9 12755.5 1828.7 1844.5 1868.1 1868.4 1882.3 57741.0 60474.0 61176.7 61264.4 61703.7 9938.8 9982.8 10024.1 10031.3 10069.4 13258.4 13262.7 13263.3 13265.7 13272.4 7477.1 7510.5 7517.7 7527.0 7721.6 7247.2 7293.1 7327.8 7334.1 7376.2 4248.8 4261.8 4280.4 4318.6 4329.4 1615.6 1669.3 1757.3 1764.7 1802.5 791.6 798.2 914.7 959.3 991.7 15659.5 15733.5 15824.2 15958.0 16269.3 809.3 897.1 898.3 912.6 954.5 8817.6 9057.0 9179.8 9421.4 10045.6 535175.1 558993.0 575044.3 581418.0 588214.0 38619.8 75732.2 77103.0 77623.6 77880.0 1127.2 1133.1 1140.9 1157.6 1160.4 15285.5 15358.8 15375.0 15434.8 15648.8 19150.7 31825.5 32676.3 33263.7 34824.7 37133.0 40501.0 43371.1 43375.8 44781.6 9005.5 9363.6 9366.3 9370.0 9377.0 11054.7 11080.7 14066.4 16008.5 16074.5 13675.0 13731.0 13859.4 14101.2 14142.2 13320.0 13339.7 13417.1 13703.7 13920.9 12003.3 13331.7 13762.5 14162.1 14675.3 9048.5 9157.1 9178.3 9178.4 9178.8 9240.8 10341.8 11148.6 12315.8 14106.2 23:01:51 INFO - PROCESS | 6999 | 23:01:51 INFO - PROCESS | 6999 | [#3] mootools.html Cycles:180 Average:5397.71 Median:6246.70 stddev:2813.72 (45.0%) stddev-sans-first:2804.74 23:01:51 INFO - PROCESS | 6999 | Values: 1297.5 1454.6 1461.3 1551.9 1754.3 6755.6 7497.4 7585.6 7593.8 7601.0 7524.9 7698.0 7707.6 7709.5 7715.7 2236.7 2260.0 2260.7 2262.4 2268.1 2244.5 2264.7 2293.1 2294.0 2300.0 2213.2 2225.6 2243.1 2246.0 2272.2 2186.0 2213.6 2240.2 2243.8 2244.0 2319.7 2342.6 2342.7 2343.6 2344.8 7709.3 7803.2 7804.9 7824.8 7838.2 4705.5 4750.3 4772.5 4775.8 4807.6 3021.4 3049.5 3117.0 3148.7 3149.5 1055.7 1077.7 1083.8 1105.0 1121.7 10740.1 10820.2 10843.9 10854.3 10877.2 4259.8 4333.2 4366.6 4380.6 4400.7 9248.0 9255.7 9264.8 9269.6 9271.9 4744.8 4749.7 4757.3 4771.1 4773.4 3872.9 3929.3 4213.0 4336.4 4348.1 3602.2 3612.8 3615.5 3645.9 3652.7 1175.8 1177.5 1184.0 1184.8 1189.3 885.7 945.0 976.4 997.9 1204.3 7014.3 7032.2 7036.0 7092.2 7099.9 1041.7 1044.5 1056.7 1073.6 1101.8 5400.3 5506.2 5513.8 5513.9 5516.7 9034.1 9292.5 9468.9 9582.9 9605.3 9362.9 9383.6 9435.3 9464.4 9496.8 7221.5 7340.9 7360.6 7408.7 7416.1 7019.8 7029.3 7033.2 7053.0 7058.2 8114.3 8317.8 8440.2 8495.9 8544.2 8615.8 8619.4 8622.1 8759.3 8770.6 6614.7 6762.8 6815.0 6819.3 6822.6 7201.7 7207.3 7242.3 7260.7 7266.5 6101.7 6663.4 6746.4 6867.8 6869.2 6780.1 6801.5 6802.3 6865.2 6917.8 6618.4 6767.3 6774.6 6777.6 6789.9 6268.3 6269.8 6271.4 6292.7 6303.1 5945.7 5962.9 6059.8 6225.1 6351.7 23:01:51 INFO - PROCESS | 6999 | 23:01:51 INFO - PROCESS | 6999 | [#4] prototype.html Cycles:180 Average:5270.14 Median:5931.54 stddev:1577.14 (26.6%) stddev-sans-first:1537.31 23:01:51 INFO - PROCESS | 6999 | Values: 327.2 329.4 340.1 341.6 342.9 5926.2 5935.1 5948.2 5982.9 5986.3 5612.4 5692.8 5737.4 5865.9 5892.6 4538.2 4547.5 4567.2 4573.3 4581.2 4351.2 4562.8 4565.8 4569.9 4576.5 4393.1 4445.1 4497.9 4512.0 4526.7 4494.9 4512.0 4512.3 4521.2 4548.1 4019.8 4030.1 4030.5 4030.7 4040.2 5543.9 5631.3 5638.9 5645.7 5647.2 5304.6 5312.2 5315.4 5316.3 5324.4 6176.6 6185.8 6187.1 6192.8 6238.8 4422.7 4424.9 4435.4 4435.8 4438.2 6332.6 6512.3 6513.6 6522.6 6530.1 4575.3 4575.7 4580.0 4583.1 4583.4 4634.1 4639.0 4643.2 4644.9 4645.0 5266.0 5269.6 5272.3 5281.9 5295.0 6113.6 6259.0 6279.6 6299.6 6314.4 1581.2 1584.6 1586.8 1587.3 1588.6 1060.3 1069.4 1078.8 1090.7 1095.6 5975.4 5978.9 5981.3 5982.4 5984.2 6481.5 6484.9 6491.6 6493.7 6497.4 5806.9 5916.5 5920.7 5926.1 5927.9 3346.8 3480.4 3528.3 3530.3 3550.0 6770.8 6804.7 6806.3 6814.7 6815.7 6666.5 6678.4 6679.4 6686.0 6686.2 6615.9 6787.0 6802.5 6803.8 6809.4 6475.6 6481.5 6486.1 6490.4 6527.6 6445.0 6447.6 6454.5 6457.9 6467.4 6590.8 6772.9 6779.3 6783.1 6783.3 4535.1 4562.7 4568.2 4570.0 4579.5 6463.4 6468.9 6480.2 6483.0 6495.9 6155.4 6307.6 6310.2 6315.3 6315.6 6302.0 6304.3 6305.1 6305.5 6306.2 6174.8 6179.2 6190.0 6194.5 6197.5 6175.6 6200.8 6235.4 6345.2 6353.3 6211.7 6230.5 6242.2 6244.2 6244.4 23:01:51 INFO - PROCESS | 6999 | 23:01:51 INFO - PROCESS | 6999 | [#5] yui.html Cycles:180 Average:13029.52 Median:45616.20 stddev:15065.82 (33.0%) stddev-sans-first:15079.68 23:01:51 INFO - PROCESS | 6999 | Values: 711.6 793.4 837.6 842.8 869.9 11254.9 11395.0 11411.1 14260.4 14433.7 12522.6 12576.8 12582.9 12590.2 12598.4 666.7 813.4 825.2 825.7 826.2 669.9 788.5 817.3 817.5 819.4 838.9 839.0 839.1 839.3 841.4 690.7 696.5 821.5 834.2 845.7 620.8 622.2 622.8 629.0 630.5 11745.6 11771.8 11809.8 11856.3 11858.4 10922.1 11031.4 11799.2 11836.6 12397.7 9776.3 9815.1 9864.6 10049.1 10248.4 3509.4 3567.7 3610.2 3639.9 3652.1 48244.0 48470.3 48558.8 48587.0 48598.0 9638.0 9662.7 9721.8 9943.2 10083.9 17494.7 17546.1 17565.8 17594.9 17605.9 6649.8 6716.8 6758.5 6769.5 6948.1 3969.2 3979.5 4000.6 4032.6 4059.5 3067.2 3091.0 3094.0 3097.6 3101.1 531.1 544.1 547.1 548.3 565.5 485.3 610.0 619.1 641.0 687.2 7663.5 7847.0 7862.0 7987.9 8055.8 536.8 618.1 652.9 675.5 691.5 3665.9 3917.7 3929.8 3947.9 4008.1 52655.7 56016.7 56198.4 56336.0 56444.0 41534.6 42449.0 42705.4 42980.1 43196.1 43666.6 44451.6 44822.3 44990.1 46242.3 7531.9 7585.5 7620.8 7771.5 7812.4 32302.5 32365.4 32854.2 32954.8 33695.5 40424.8 40497.0 43274.6 43831.0 44131.8 10638.0 10707.6 10993.0 11214.9 11249.4 11670.0 11789.8 11851.6 11948.7 12156.2 10722.6 10879.7 10881.5 10945.8 10979.5 10737.9 10951.8 11234.3 11517.0 11530.2 8187.0 10533.8 10915.5 11050.8 11103.9 8569.0 8873.3 8960.2 9269.7 9338.0 8652.6 8829.6 8973.9 9030.6 9070.3 23:01:51 INFO - PROCESS | 6999 | -------- Summary: end -------- 23:01:51 INFO - PROCESS | 6999 | 23:01:51 INFO - TEST-INFO | 6999: exit 0 23:01:51 INFO - TEST-OK | dromaeo_css | took 1112232ms 23:01:51 INFO - TEST-START | kraken 23:01:51 INFO - operating with platform_type : linux_ 23:01:51 INFO - Initialising browser for kraken test... 23:01:51 INFO - TEST-INFO | started process 7191 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfzSwRT/profile http://localhost:37913/getInfo.html) 23:01:55 INFO - PROCESS | 7191 | __metrics Screen width/height:1600/1200 23:01:55 INFO - PROCESS | 7191 | colorDepth:24 23:01:55 INFO - PROCESS | 7191 | Browser inner width/height: 1024/697 23:01:55 INFO - PROCESS | 7191 | __metrics 23:01:55 INFO - PROCESS | 7191 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:01:55 INFO - PROCESS | 7191 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:01:56 INFO - TEST-INFO | 7191: exit 0 23:01:56 INFO - Browser initialized. 23:01:56 INFO - Running cycle 1/1 for kraken test... 23:01:56 INFO - TEST-INFO | started process 7275 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfzSwRT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:02:08 INFO - PROCESS | 7275 | RSS: Main: 149991424 23:02:08 INFO - PROCESS | 7275 | 23:02:10 INFO - PROCESS | 7275 | Cycle 1(1): loaded http://localhost:37913/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37913/tests/kraken/driver.html?testName=audio-beat-detection) 23:02:11 INFO - PROCESS | 7275 | RSS: Main: 185454592 23:02:11 INFO - PROCESS | 7275 | 23:02:13 INFO - PROCESS | 7275 | Cycle 1(1): loaded http://localhost:37913/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37913/tests/kraken/driver.html?testName=audio-dft) 23:02:14 INFO - PROCESS | 7275 | RSS: Main: 175607808 23:02:14 INFO - PROCESS | 7275 | 23:02:17 INFO - PROCESS | 7275 | Cycle 1(1): loaded http://localhost:37913/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37913/tests/kraken/driver.html?testName=audio-fft) 23:02:17 INFO - PROCESS | 7275 | RSS: Main: 159358976 23:02:17 INFO - PROCESS | 7275 | 23:02:19 INFO - PROCESS | 7275 | Cycle 1(1): loaded http://localhost:37913/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37913/tests/kraken/driver.html?testName=audio-oscillator) 23:02:20 INFO - PROCESS | 7275 | RSS: Main: 163872768 23:02:20 INFO - PROCESS | 7275 | 23:02:22 INFO - PROCESS | 7275 | Cycle 1(1): loaded http://localhost:37913/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37913/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:02:23 INFO - PROCESS | 7275 | RSS: Main: 163770368 23:02:23 INFO - PROCESS | 7275 | 23:02:25 INFO - PROCESS | 7275 | Cycle 1(1): loaded http://localhost:37913/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37913/tests/kraken/driver.html?testName=imaging-darkroom) 23:02:26 INFO - PROCESS | 7275 | RSS: Main: 164057088 23:02:26 INFO - PROCESS | 7275 | 23:02:29 INFO - PROCESS | 7275 | Cycle 1(1): loaded http://localhost:37913/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37913/tests/kraken/driver.html?testName=imaging-desaturate) 23:02:30 INFO - PROCESS | 7275 | RSS: Main: 164970496 23:02:30 INFO - PROCESS | 7275 | 23:02:33 INFO - PROCESS | 7275 | Cycle 1(1): loaded http://localhost:37913/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37913/tests/kraken/driver.html?testName=json-parse-financial) 23:02:33 INFO - PROCESS | 7275 | RSS: Main: 164204544 23:02:33 INFO - PROCESS | 7275 | 23:02:35 INFO - PROCESS | 7275 | Cycle 1(1): loaded http://localhost:37913/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37913/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:02:35 INFO - PROCESS | 7275 | RSS: Main: 175874048 23:02:35 INFO - PROCESS | 7275 | 23:02:37 INFO - PROCESS | 7275 | Cycle 1(1): loaded http://localhost:37913/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37913/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:02:38 INFO - PROCESS | 7275 | RSS: Main: 174305280 23:02:38 INFO - PROCESS | 7275 | 23:02:40 INFO - PROCESS | 7275 | Cycle 1(1): loaded http://localhost:37913/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37913/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:02:40 INFO - PROCESS | 7275 | RSS: Main: 186167296 23:02:40 INFO - PROCESS | 7275 | 23:02:43 INFO - PROCESS | 7275 | Cycle 1(1): loaded http://localhost:37913/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37913/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:02:43 INFO - PROCESS | 7275 | RSS: Main: 192016384 23:02:43 INFO - PROCESS | 7275 | 23:02:46 INFO - PROCESS | 7275 | Cycle 1(1): loaded http://localhost:37913/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37913/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:02:46 INFO - PROCESS | 7275 | RSS: Main: 187957248 23:02:46 INFO - PROCESS | 7275 | 23:02:48 INFO - PROCESS | 7275 | Cycle 1(1): loaded http://localhost:37913/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37913/tests/kraken/driver.html?testName=ai-astar) 23:02:48 INFO - PROCESS | 7275 | RSS: Main: 246886400 23:02:48 INFO - PROCESS | 7275 | 23:02:48 INFO - PROCESS | 7275 | __start_tp_report 23:02:48 INFO - PROCESS | 7275 | _x_x_mozilla_page_load 23:02:48 INFO - PROCESS | 7275 | _x_x_mozilla_page_load_details 23:02:48 INFO - PROCESS | 7275 | |i|pagename|runs| 23:02:48 INFO - PROCESS | 7275 | |0;ai-astar;108;111;104;109;110;113;100;109;110;110 23:02:48 INFO - PROCESS | 7275 | |1;audio-beat-detection;148;134;151;162;127;164;149;129;177;124 23:02:48 INFO - PROCESS | 7275 | |2;audio-dft;161;161;160;161;161;160;161;162;160;161 23:02:48 INFO - PROCESS | 7275 | |3;audio-fft;74;71;85;95;71;71;74;101;102;74 23:02:48 INFO - PROCESS | 7275 | |4;audio-oscillator;96;96;136;95;95;96;140;95;96;141 23:02:48 INFO - PROCESS | 7275 | |5;imaging-gaussian-blur;110;109;109;109;109;110;110;110;109;110 23:02:48 INFO - PROCESS | 7275 | |6;imaging-darkroom;146;145;145;146;145;147;145;145;145;146 23:02:48 INFO - PROCESS | 7275 | |7;imaging-desaturate;96;96;96;97;96;96;96;96;97;97 23:02:48 INFO - PROCESS | 7275 | |8;json-parse-financial;57;56;57;56;56;56;57;69;54;55 23:02:48 INFO - PROCESS | 7275 | |9;json-stringify-tinderbox;67;68;67;67;68;68;68;70;67;68 23:02:48 INFO - PROCESS | 7275 | |10;stanford-crypto-aes;91;86;85;85;86;84;85;85;86;86 23:02:48 INFO - PROCESS | 7275 | |11;stanford-crypto-ccm;134;122;114;115;115;122;119;119;128;117 23:02:48 INFO - PROCESS | 7275 | |12;stanford-crypto-pbkdf2;141;142;151;152;151;138;149;150;150;138 23:02:48 INFO - PROCESS | 7275 | |13;stanford-crypto-sha256-iterative;72;68;72;68;70;67;67;72;68;66 23:02:48 INFO - PROCESS | 7275 | __end_tp_report 23:02:48 INFO - PROCESS | 7275 | __start_cc_report 23:02:48 INFO - PROCESS | 7275 | _x_x_mozilla_cycle_collect,951 23:02:48 INFO - PROCESS | 7275 | __end_cc_report 23:02:48 INFO - PROCESS | 7275 | __startTimestamp1451718168944__endTimestamp 23:02:48 INFO - PROCESS | 7275 | 23:02:48 INFO - PROCESS | 7275 | ------- Summary: start ------- 23:02:48 INFO - PROCESS | 7275 | Number of tests: 14 23:02:48 INFO - PROCESS | 7275 | 23:02:48 INFO - PROCESS | 7275 | [#0] ai-astar Cycles:10 Average:108.40 Median:110.00 stddev:3.75 (3.4%) stddev-sans-first:3.97 23:02:48 INFO - PROCESS | 7275 | Values: 108.0 111.0 104.0 109.0 110.0 113.0 100.0 109.0 110.0 110.0 23:02:48 INFO - PROCESS | 7275 | 23:02:48 INFO - PROCESS | 7275 | [#1] audio-beat-detection Cycles:10 Average:146.50 Median:150.00 stddev:17.81 (11.9%) stddev-sans-first:18.88 23:02:48 INFO - PROCESS | 7275 | Values: 148.0 134.0 151.0 162.0 127.0 164.0 149.0 129.0 177.0 124.0 23:02:48 INFO - PROCESS | 7275 | 23:02:48 INFO - PROCESS | 7275 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 23:02:48 INFO - PROCESS | 7275 | Values: 161.0 161.0 160.0 161.0 161.0 160.0 161.0 162.0 160.0 161.0 23:02:48 INFO - PROCESS | 7275 | 23:02:48 INFO - PROCESS | 7275 | [#3] audio-fft Cycles:10 Average:81.80 Median:74.00 stddev:12.88 (17.4%) stddev-sans-first:13.35 23:02:48 INFO - PROCESS | 7275 | Values: 74.0 71.0 85.0 95.0 71.0 71.0 74.0 101.0 102.0 74.0 23:02:48 INFO - PROCESS | 7275 | 23:02:48 INFO - PROCESS | 7275 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:95.50 stddev:21.02 (22.0%) stddev-sans-first:21.79 23:02:48 INFO - PROCESS | 7275 | Values: 96.0 96.0 136.0 95.0 95.0 96.0 140.0 95.0 96.0 141.0 23:02:48 INFO - PROCESS | 7275 | 23:02:48 INFO - PROCESS | 7275 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 23:02:48 INFO - PROCESS | 7275 | Values: 110.0 109.0 109.0 109.0 109.0 110.0 110.0 110.0 109.0 110.0 23:02:48 INFO - PROCESS | 7275 | 23:02:48 INFO - PROCESS | 7275 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 23:02:48 INFO - PROCESS | 7275 | Values: 146.0 145.0 145.0 146.0 145.0 147.0 145.0 145.0 145.0 146.0 23:02:48 INFO - PROCESS | 7275 | 23:02:48 INFO - PROCESS | 7275 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 23:02:48 INFO - PROCESS | 7275 | Values: 96.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 97.0 97.0 23:02:48 INFO - PROCESS | 7275 | 23:02:48 INFO - PROCESS | 7275 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:56.50 stddev:4.22 (7.5%) stddev-sans-first:4.47 23:02:48 INFO - PROCESS | 7275 | Values: 57.0 56.0 57.0 56.0 56.0 56.0 57.0 69.0 54.0 55.0 23:02:48 INFO - PROCESS | 7275 | 23:02:48 INFO - PROCESS | 7275 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 23:02:48 INFO - PROCESS | 7275 | Values: 67.0 68.0 67.0 67.0 68.0 68.0 68.0 70.0 67.0 68.0 23:02:48 INFO - PROCESS | 7275 | 23:02:48 INFO - PROCESS | 7275 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:86.00 stddev:1.91 (2.2%) stddev-sans-first:0.71 23:02:48 INFO - PROCESS | 7275 | Values: 91.0 86.0 85.0 85.0 86.0 84.0 85.0 85.0 86.0 86.0 23:02:48 INFO - PROCESS | 7275 | 23:02:48 INFO - PROCESS | 7275 | [#11] stanford-crypto-ccm Cycles:10 Average:120.50 Median:120.50 stddev:6.35 (5.3%) stddev-sans-first:4.47 23:02:48 INFO - PROCESS | 7275 | Values: 134.0 122.0 114.0 115.0 115.0 122.0 119.0 119.0 128.0 117.0 23:02:48 INFO - PROCESS | 7275 | 23:02:48 INFO - PROCESS | 7275 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.20 Median:150.00 stddev:5.73 (3.8%) stddev-sans-first:5.76 23:02:48 INFO - PROCESS | 7275 | Values: 141.0 142.0 151.0 152.0 151.0 138.0 149.0 150.0 150.0 138.0 23:02:48 INFO - PROCESS | 7275 | 23:02:48 INFO - PROCESS | 7275 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:2.31 (3.3%) stddev-sans-first:2.18 23:02:48 INFO - PROCESS | 7275 | Values: 72.0 68.0 72.0 68.0 70.0 67.0 67.0 72.0 68.0 66.0 23:02:48 INFO - PROCESS | 7275 | -------- Summary: end -------- 23:02:48 INFO - PROCESS | 7275 | 23:02:49 INFO - TEST-INFO | 7275: exit 0 23:02:49 INFO - TEST-OK | kraken | took 58042ms 23:02:49 INFO - TEST-START | v8_7 23:02:49 INFO - operating with platform_type : linux_ 23:02:49 INFO - Initialising browser for v8_7 test... 23:02:49 INFO - TEST-INFO | started process 7523 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0QjKcS/profile http://localhost:37913/getInfo.html) 23:02:53 INFO - PROCESS | 7523 | __metrics Screen width/height:1600/1200 23:02:53 INFO - PROCESS | 7523 | colorDepth:24 23:02:53 INFO - PROCESS | 7523 | Browser inner width/height: 1024/697 23:02:53 INFO - PROCESS | 7523 | __metrics 23:02:53 INFO - PROCESS | 7523 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:02:53 INFO - PROCESS | 7523 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:02:54 INFO - TEST-INFO | 7523: exit 0 23:02:54 INFO - Browser initialized. 23:02:54 INFO - Running cycle 1/1 for v8_7 test... 23:02:54 INFO - TEST-INFO | started process 7606 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0QjKcS/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:03:06 INFO - PROCESS | 7606 | RSS: Main: 150323200 23:03:06 INFO - PROCESS | 7606 | 23:03:27 INFO - PROCESS | 7606 | Cycle 1(1): loaded http://localhost:37913/tests/v8_7/run.html (next: http://localhost:37913/tests/v8_7/run.html) 23:03:27 INFO - PROCESS | 7606 | RSS: Main: 560627712 23:03:27 INFO - PROCESS | 7606 | 23:03:27 INFO - PROCESS | 7606 | __start_tp_report 23:03:27 INFO - PROCESS | 7606 | _x_x_mozilla_page_load 23:03:27 INFO - PROCESS | 7606 | _x_x_mozilla_page_load_details 23:03:27 INFO - PROCESS | 7606 | |i|pagename|runs| 23:03:27 INFO - PROCESS | 7606 | |0;Richards;167.0564650851988 23:03:27 INFO - PROCESS | 7606 | |1;DeltaBlue;197.08316909735908 23:03:27 INFO - PROCESS | 7606 | |2;Encrypt;286.5329512893983 23:03:27 INFO - PROCESS | 7606 | |3;Decrypt;5180.412371134021 23:03:27 INFO - PROCESS | 7606 | |4;RayTrace;1932.4324324324325 23:03:27 INFO - PROCESS | 7606 | |5;Earley;801.2820512820513 23:03:27 INFO - PROCESS | 7606 | |6;Boyer;12228.915662650603 23:03:27 INFO - PROCESS | 7606 | |7;RegExp;26394.736842105263 23:03:27 INFO - PROCESS | 7606 | |8;Splay;583.0903790087464 23:03:27 INFO - PROCESS | 7606 | |9;NavierStokes;4845.410628019324 23:03:27 INFO - PROCESS | 7606 | __end_tp_report 23:03:27 INFO - PROCESS | 7606 | __startTimestamp1451718207774__endTimestamp 23:03:27 INFO - PROCESS | 7606 | 23:03:27 INFO - PROCESS | 7606 | ------- Summary: start ------- 23:03:27 INFO - PROCESS | 7606 | Number of tests: 10 23:03:27 INFO - PROCESS | 7606 | 23:03:27 INFO - PROCESS | 7606 | [#0] Richards Cycles:1 Average:167.06 Median:167.06 stddev:0.00 (0.0%) 23:03:27 INFO - PROCESS | 7606 | Values: 167.1 23:03:27 INFO - PROCESS | 7606 | 23:03:27 INFO - PROCESS | 7606 | [#1] DeltaBlue Cycles:1 Average:197.08 Median:197.08 stddev:0.00 (0.0%) 23:03:27 INFO - PROCESS | 7606 | Values: 197.1 23:03:27 INFO - PROCESS | 7606 | 23:03:27 INFO - PROCESS | 7606 | [#2] Encrypt Cycles:1 Average:286.53 Median:286.53 stddev:0.00 (0.0%) 23:03:27 INFO - PROCESS | 7606 | Values: 286.5 23:03:27 INFO - PROCESS | 7606 | 23:03:27 INFO - PROCESS | 7606 | [#3] Decrypt Cycles:1 Average:5180.41 Median:5180.41 stddev:0.00 (0.0%) 23:03:27 INFO - PROCESS | 7606 | Values: 5180.4 23:03:27 INFO - PROCESS | 7606 | 23:03:27 INFO - PROCESS | 7606 | [#4] RayTrace Cycles:1 Average:1932.43 Median:1932.43 stddev:0.00 (0.0%) 23:03:27 INFO - PROCESS | 7606 | Values: 1932.4 23:03:27 INFO - PROCESS | 7606 | 23:03:27 INFO - PROCESS | 7606 | [#5] Earley Cycles:1 Average:801.28 Median:801.28 stddev:0.00 (0.0%) 23:03:27 INFO - PROCESS | 7606 | Values: 801.3 23:03:27 INFO - PROCESS | 7606 | 23:03:27 INFO - PROCESS | 7606 | [#6] Boyer Cycles:1 Average:12228.92 Median:12228.92 stddev:0.00 (0.0%) 23:03:27 INFO - PROCESS | 7606 | Values: 12228.9 23:03:27 INFO - PROCESS | 7606 | 23:03:27 INFO - PROCESS | 7606 | [#7] RegExp Cycles:1 Average:26394.74 Median:26394.74 stddev:0.00 (0.0%) 23:03:27 INFO - PROCESS | 7606 | Values: 26394.7 23:03:27 INFO - PROCESS | 7606 | 23:03:27 INFO - PROCESS | 7606 | [#8] Splay Cycles:1 Average:583.09 Median:583.09 stddev:0.00 (0.0%) 23:03:27 INFO - PROCESS | 7606 | Values: 583.1 23:03:27 INFO - PROCESS | 7606 | 23:03:27 INFO - PROCESS | 7606 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 23:03:27 INFO - PROCESS | 7606 | Values: 4845.4 23:03:27 INFO - PROCESS | 7606 | -------- Summary: end -------- 23:03:27 INFO - PROCESS | 7606 | 23:03:28 INFO - TEST-INFO | 7606: exit 0 23:03:28 INFO - TEST-OK | v8_7 | took 38737ms 23:03:28 INFO - SUITE-END | took 1209s 23:03:28 INFO - Completed test suite (00:20:09) 23:03:28 INFO - Working with test: dromaeo_css 23:03:28 INFO - Generating results file: dromaeo_css 23:03:28 INFO - Working with test: kraken 23:03:28 INFO - Generating results file: kraken 23:03:28 INFO - javascript benchmark 23:03:28 INFO - Working with test: v8_7 23:03:28 INFO - Generating results file: v8_7 23:03:28 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:03:28 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 23:03:28 INFO - process_Request line: dromaeo_css 6818.76 graph.html#tests=[[72,201,35]] 23:03:28 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:03:28 INFO - process_Request line: kraken 1504.10 graph.html#tests=[[232,201,35]] 23:03:28 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:03:28 INFO - process_Request line: v8_7 19747.42 graph.html#tests=[[230,201,35]] 23:03:28 INFO - RETURN: dromaeo_css: 6818.76 23:03:28 INFO - RETURN: kraken: 1504.10 23:03:28 INFO - RETURN: v8_7: 19747.42 23:03:28 INFO - javascript benchmark 23:03:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3057.1592811976707, 3118.3763247350535, 3153.700398462147, 3155.842207889605, 3165.3827503636794, 5139.511746384097, 5216.608754343425, 5216.634835561507, 5231.52916237539, 5289.365276166865, 5152.407473140581, 5226.529612334889, 5228.0850851101095, 5298.92051619226, 5328.6269961102735, 4788.114198873202, 4804.975975120119, 4810.9037819243595, 4857.077155340492, 4921.163402221631, 4923.778429970642, 4949.876253093666, 4958.801647934079, 4974.427940786802, 5026.874328141789, 4726.2201736713405, 4753.1444340019125, 4821.879453013686, 4826.710397376133, 4871.975640121776, 4804.063207674505, 4811.350467686888, 4823.5658790709, 4843.903121937541, 4858.659893807435, 4764.928526072112, 4767.4994125617, 4783.139034973703, 4788.688735232199, 4840.419149702023, 5093.337866077386, 5166.199239117943, 5190.32525771651, 5201.505856943584, 5207.479252074762, 5582.609217354787, 5595.4964053235, 5624.775008999635, 5691.430856914317, 5726.942730572682, 5664.065429204176, 5664.291963504562, 5670.121131224667, 5676.8864622707315, 5678.37537870838, 5245.160774276135, 5250.737463126867, 5252.5535329497425, 5256.526912577886, 5258.81594144207, 5697.4302569742695, 5764.423557644202, 5811.709414529341, 5834.474897259182, 5877.382874798084, 5546.667199968015, 5598.944010559923, 5608.46719561641, 5618.410066942994, 5652.293463317085, 5647.068233741386, 5663.858403539944, 5665.0, 5667.688277144796, 5669.092945128842, 5545.500904918496, 5597.076482380443, 5607.607467477237, 5638.35158956717, 5667.546596272288, 5574.721263936787, 5633.492985631313, 5637.46444087811, 5664.943350566442, 5677.261955945701, 4388.5611438856495, 4410.117976404732, 4410.4927933287445, 4411.867643970686, 4446.844360447369, 3845.3655146900446, 3891.4746509220895, 3908.179282350681, 3915.0603855075146, 3927.136030073379, 5225.503577160163, 5271.077561426735, 5274.578033757367, 5281.313429254173, 5321.3348331458565, 5675.432456754292, 5678.375378708339, 5708.743106560215, 5715.114157305624, 5716.5140963017775, 5139.331886854685, 5220.817271395559, 5228.843134705965, 5298.072837253465, 5322.0, 4828.855134345975, 4875.024995000943, 4880.975595122072, 4887.169181239198, 4901.09329773993, 5815.360310365856, 5860.413958604191, 5867.823965281048, 5882.294124704978, 5951.3751056139345, 5495.230667706444, 5596.188552659923, 5602.2717046783655, 5638.5489160867855, 5703.914441283301, 5766.855828604318, 5838.766449342149, 5844.6785426801935, 5848.444397782204, 5889.823305300848, 5546.251256080539, 5548.223248745259, 5553.916691249715, 5561.499465048165, 5562.582806289625, 5558.66648001105, 5627.577931655061, 5632.295963004624, 5675.233843431249, 5675.347335056356, 5488.039593071277, 5523.364813046391, 5547.140193270049, 5547.1679248113105, 5547.41752116022, 5491.560675145899, 5539.335279766454, 5539.7784088636, 5543.307086614173, 5545.7781688732, 5444.074507333842, 5449.64577302474, 5453.345598528202, 5455.372632147354, 5463.918041229305, 5513.448655134454, 5535.667859928417, 5588.413216612197, 5609.467100625434, 5619.747111380079, 5483.561315094863, 5506.0, 5519.724013799214, 5529.972350138384, 5562.360328562106], "unit": "score", "name": "dojo.html", "value": 5216.6739768494945}, {"lowerIsBetter": false, "replicates": [528.9021531016762, 540.5297391269596, 545.6398776807306, 558.9804356847509, 570.421022661998, 27526.17421477354, 35629.0, 35828.82085589575, 35880.64119358805, 35922.92231233064, 41189.17621647573, 41545.0, 41723.0, 41726.79136604313, 41927.0, 7282.927170728278, 7409.333160015598, 8651.610677519511, 8834.0, 8842.778930526756, 10015.899841001607, 10238.89761102387, 10266.332688375232, 10267.0, 10280.177585793119, 9912.702618921408, 9950.65172718955, 10009.699709008704, 10013.39919604826, 10031.448270345129, 7502.212267711893, 7676.270754278335, 9994.9500252499, 10115.696529104138, 10318.7420314492, 9821.214302855755, 9926.652567160187, 9957.402555846673, 9967.700968970943, 9976.201903847676, 34795.30409391823, 35148.121296967525, 35156.648433515846, 35195.64804351949, 35255.64744352549, 3090.7527397808344, 3130.5617213590117, 3192.2976945072046, 3439.329330780499, 3837.2901013312626, 29805.40389192204, 29918.401631967237, 29941.700582994108, 30148.0, 30175.849120754476, 3714.3685573452576, 3747.5502939647145, 3804.2011177652726, 3818.5417749869916, 3909.863154789569, 267597.0, 268872.0, 269444.6527767368, 269673.7744669138, 270582.0, 51652.74173629108, 52861.47138528565, 58629.0, 58666.706666466394, 59961.40038599646, 53926.191107133425, 53997.1900421494, 54214.728926355114, 54260.728696356266, 54336.0, 14647.560573182822, 14825.851741482662, 14839.703205936037, 14865.851341486446, 14867.776983345258, 11182.66452006441, 11249.71875703114, 11250.549978000789, 11255.0, 11269.887301127048, 19062.237510499424, 19286.324978625682, 19946.210000548912, 20047.0, 20112.0, 7628.656710448043, 7797.727079552188, 7831.960840195762, 7923.326517245983, 7926.24700653437, 846.8729690546468, 858.9441686290371, 909.4588719711761, 986.6398764450923, 1049.6693541534391, 25262.368440789127, 26702.19893403201, 26865.597016044776, 27148.457030859274, 27396.315092122855, 923.2567782934668, 955.9044095590524, 963.0032915931977, 1002.5037606384886, 1011.0, 13263.933680331536, 13640.181589104686, 13898.16611003343, 13904.304784760721, 14104.85895141056, 320483.0, 326366.0, 326440.0, 326600.0, 327145.0, 52012.73993630007, 52277.47722522802, 52315.73842130765, 52329.0, 52417.0, 1276.21512769646, 1302.8176055352258, 1303.9543615973396, 1311.4754098360731, 1319.8284223050941, 25150.874245628656, 25389.365265868502, 25480.74519254858, 25497.872510637328, 25662.565660778862, 41559.1688166241, 41666.16667666569, 41815.1636967265, 41980.0, 42013.0, 237089.0, 238104.0, 238284.0, 298142.0, 298641.0, 27449.31376715598, 27916.16251512458, 30617.54073688852, 31289.374212515166, 31855.681443185273, 36925.26149477049, 37372.626273738, 37398.75607463561, 37761.05597360088, 37766.811165944, 31928.52107218347, 32185.0, 32416.83791581027, 32682.50976235406, 32873.342533149684, 29170.7082929168, 32476.350472990882, 34086.829565853004, 35083.0, 37029.814850926654, 32564.0, 32857.17857053593, 32887.0, 35385.0, 35910.28179436449, 28496.0, 29406.411871762873, 29707.960221392146, 29820.960937383054, 31848.52227216547, 24449.511009779348, 24801.751982479946, 24890.0, 25151.87424062941, 25291.87354063218], "unit": "score", "name": "ext.html", "value": 17806.8469597367}, {"lowerIsBetter": false, "replicates": [355.73320009992506, 358.9605143434222, 360.3082082401788, 361.0810487309796, 364.09885533305066, 13395.799063014063, 13812.516561920334, 15995.360185592577, 16013.27940242689, 16594.087325197124, 15594.37622495099, 15784.368625254976, 16382.83617163828, 16408.343666253364, 16495.505134845946, 5098.235264710295, 5375.462453754632, 5393.649412788176, 5398.055340315449, 5398.055340315449, 4023.336149535338, 4112.136451345221, 4119.361498967664, 4120.793960301988, 5319.388270348902, 5772.884542309152, 5969.13447550105, 5971.044632858743, 5972.970135149319, 5975.312839023524, 5836.416358364172, 5919.644821310713, 5958.404159584007, 5958.791442299542, 5959.314678811948, 5260.552853007499, 5274.2879711238875, 5278.656887302313, 5279.894402111975, 5280.709560974145, 18523.166457509444, 19142.234310627697, 19782.505437364038, 20350.694739578918, 20439.284625038053, 2008.2970960163973, 2062.804033616804, 2068.152057656369, 2182.74898386686, 2184.486645638274, 9051.773705657346, 9286.0, 9484.715458536255, 10358.948205258925, 12755.489780408772, 1828.7256911463253, 1844.5322793148928, 1868.1406552985643, 1868.374514172665, 1882.28473180192, 57741.0, 60474.0, 61176.69411653002, 61264.38735612632, 61703.69148154275, 9938.80122397548, 9982.750431239278, 10024.097831195228, 10031.347962382422, 10069.395836249849, 13258.403371848097, 13262.734745305233, 13263.336833158304, 13265.734685306239, 13272.411879683368, 7477.065366829146, 7510.511816731895, 7517.736879209201, 7526.962365188248, 7721.6139193041245, 7247.23903990084, 7293.088363954505, 7327.816804579928, 7334.083239595051, 7376.151742549569, 4248.8300467980935, 4261.765602891871, 4280.422143010716, 4318.611324980767, 4329.415528903558, 1615.5557221764109, 1669.3072374964254, 1757.3058641836658, 1764.7264673975553, 1802.53053316954, 791.600241877848, 798.1858504325555, 914.7438717159206, 959.2613687460756, 991.7223177510309, 15659.530214093595, 15733.527994160193, 15824.208789560476, 15958.0, 16269.349226031063, 809.3282575462352, 897.1387468030764, 898.3262553085186, 912.589334799343, 954.5275088831073, 8817.603207855662, 9057.0, 9179.81640367189, 9421.434713917188, 10045.648402306031, 535175.0860364478, 558993.0, 575044.3034499254, 581418.0, 588214.0, 38619.80690096531, 75732.24267757362, 77103.0, 77623.61188194135, 77880.0, 1127.2278489234736, 1133.1331531378503, 1140.8916152965621, 1157.6469176901126, 1160.4313886195703, 15285.54143375656, 15358.769618455955, 15375.0, 15434.84565154379, 15648.765268520754, 19150.71273930864, 31825.5226171603, 32676.34647306993, 33263.667363327026, 34824.65175348214, 37133.0, 40501.0, 43371.13257734891, 43375.78312108419, 44781.55218447904, 9005.459672419676, 9363.625454981724, 9366.344355895022, 9369.953150234205, 9377.0, 11054.723631908944, 11080.722981925517, 14066.437342506186, 16008.519744407686, 16074.517764467084, 13675.0, 13731.0, 13859.445622175, 14101.224432655892, 14142.22217778032, 13320.0, 13339.733205335644, 13417.060805743504, 13703.725925481634, 13920.860791391957, 12003.339816310187, 13331.733365332446, 13762.518311859038, 14162.079464834753, 14675.339609717375, 9048.502332371783, 9157.130072643089, 9178.26573874075, 9178.449293042439, 9178.770530736518, 9240.815183696423, 10341.793164136825, 11148.609798657333, 12315.75368492643, 14106.153630782186], "unit": "score", "name": "jquery.html", "value": 8541.86765879662}, {"lowerIsBetter": false, "replicates": [1297.539373522399, 1454.6072560408686, 1461.254760072363, 1551.8816815047458, 1754.333353325736, 6755.628440435774, 7497.437692173088, 7585.620718964057, 7593.772186834404, 7601.0118684571, 7524.924750752491, 7697.9615101924555, 7707.576083315415, 7709.460337776358, 7715.652795624196, 2236.7204099487562, 2260.0, 2260.7174103237094, 2262.4230821140586, 2268.0587556164173, 2244.4837687331924, 2264.728232612081, 2293.0713061210154, 2294.025039358266, 2300.0454811253394, 2213.214308920334, 2225.643896976484, 2243.1363924888956, 2246.0229800037037, 2272.2047283450825, 2185.9890700546553, 2213.579419910212, 2240.2047273217936, 2243.842930994831, 2243.9775602244013, 2319.6636487709357, 2342.6251799712136, 2342.7188737351457, 2343.648452732104, 2344.777246161612, 7709.267619576131, 7803.219678032208, 7804.921950780533, 7824.843503129962, 7838.216178382173, 4705.529447055267, 4750.263709125091, 4772.546608072263, 4775.832845850378, 4807.567318941312, 3021.425929073469, 3049.496833022549, 3116.9688303116905, 3148.7008734170217, 3149.5118256670253, 1055.7202341379464, 1077.6659235636978, 1083.8265877459569, 1104.9889501104967, 1121.7307846116955, 10740.08709259714, 10820.188485863591, 10843.945780271128, 10854.294470859448, 10877.184211184114, 4259.8083086261195, 4333.241682705514, 4366.607005369468, 4380.649548036149, 4400.713953593006, 9248.0, 9255.67605133817, 9264.814703706023, 9269.582868770922, 9271.860922086174, 4744.810207591658, 4749.691270067435, 4757.310190022427, 4771.069641419959, 4773.355596994361, 3872.9419058714143, 3929.2927273090545, 4213.0, 4336.392904993303, 4348.065165989265, 3602.1895073608753, 3612.8012959286966, 3615.5119058927235, 3645.9453108203397, 3652.726045546595, 1175.7589694112687, 1177.4701384377065, 1183.9940800296115, 1184.7571247894161, 1189.3220864107548, 885.7342797160826, 944.974702447838, 976.4483067067084, 997.870276864003, 1204.2593804809978, 7014.298570143047, 7032.191298000693, 7036.0, 7092.184398794205, 7099.89350159748, 1041.7187359412917, 1044.535181844072, 1056.7041228456044, 1073.6027669762238, 1101.7741363020561, 5400.297961265089, 5506.174073888948, 5513.807016754395, 5513.917291240635, 5516.696581688046, 9034.14175653312, 9292.53537323131, 9468.90531094694, 9582.856257156149, 9605.279604029725, 9362.906370936204, 9383.577739001625, 9435.29235307341, 9464.432134071978, 9496.810063798684, 7221.494495385377, 7340.853182936418, 7360.558366498028, 7408.703651853865, 7416.147143078507, 7019.824504387431, 7029.26192749754, 7033.191183014019, 7052.9647351762915, 7058.223595404604, 8114.269715725377, 8317.792055198426, 8440.240378365976, 8495.915040849512, 8544.18830211129, 8615.827683446421, 8619.439736417113, 8622.137786221578, 8759.299256059372, 8770.649174032967, 6614.70233839488, 6762.797116086525, 6815.0, 6819.283975182733, 6822.590644561144, 7201.747938822116, 7207.279272072751, 7242.311980361857, 7260.709571617076, 7266.527675701062, 6101.694915254131, 6663.433608143168, 6746.392824645805, 6867.793966181022, 6869.210040845167, 6780.11858458417, 6801.489888258301, 6802.285759995129, 6865.210500792473, 6917.827054323682, 6618.437432818265, 6767.323267673193, 6774.627395493098, 6777.6272305023695, 6789.898151527632, 6268.310485846644, 6269.811905642656, 6271.404216599416, 6292.748290068346, 6303.1175635412, 5945.672987985529, 5962.880742385041, 6059.818205453667, 6225.097360882737, 6351.714172862325], "unit": "score", "name": "mootools.html", "value": 4430.900999414714}, {"lowerIsBetter": false, "replicates": [327.2195812986029, 329.4054232111039, 340.1173953590433, 341.55427167546344, 342.9382711112, 5926.199963004993, 5935.139404786309, 5948.167256584082, 5982.940170598293, 5986.341502434729, 5612.41069687683, 5692.829215123543, 5737.397573254811, 5865.853353666161, 5892.616979896315, 4538.205813982539, 4547.499775024745, 4567.155076310876, 4573.268277075676, 4581.221192397284, 4351.238533256684, 4562.836476698454, 4565.817367305321, 4569.885752856172, 4576.496585375606, 4393.143337049277, 4445.066536027438, 4497.9325310120375, 4512.0, 4526.6831321807485, 4494.898749806286, 4511.954880451186, 4512.323151527265, 4521.208788462022, 4548.113117942003, 4019.8191081401405, 4030.052937559671, 4030.496187976503, 4030.738002029888, 4040.151568170688, 5543.8891222175735, 5631.324241091054, 5638.943610563924, 5645.745941432645, 5647.152927060933, 5304.575633949314, 5312.1766126250495, 5315.415304316522, 5316.282301889273, 5324.41431442541, 6176.629402235881, 6185.845353866144, 6187.102870083858, 6192.783252586138, 6238.781642642486, 4422.7346359218545, 4424.889377765549, 4435.35687325336, 4435.778211089465, 4438.178936896685, 6332.620042797447, 6512.283648798629, 6513.576617519846, 6522.641254730988, 6530.053142294389, 4575.336576196433, 4575.679702420799, 4579.977100114478, 4583.12920545102, 4583.358329833826, 4634.119517291704, 4638.953610463852, 4643.233866412072, 4644.86065418038, 4644.9767751161025, 5266.0, 5269.604779641542, 5272.2882410874045, 5281.947180528223, 5295.020421222086, 6113.602615829956, 6258.968705156536, 6279.623222606659, 6299.622022678654, 6314.400131987454, 1581.2251996521622, 1584.6434552225658, 1586.7778511008469, 1587.261923205715, 1588.563145135074, 1060.3160961179997, 1069.385103565453, 1078.7680648660576, 1090.738222826516, 1095.5672509358758, 5975.4024597540765, 5978.850528736816, 5981.252343457068, 5982.4316689914385, 5984.222051133412, 6481.513886458534, 6484.870302593922, 6491.642959637265, 6493.740250389931, 6497.350264973465, 5806.912896306559, 5916.467517923407, 5920.674362909996, 5926.111083337448, 5927.940720592739, 3346.782459140148, 3480.443129099332, 3528.2943411317838, 3530.3115892400733, 3549.982250088785, 6770.796876093725, 6804.65976701163, 6806.285340039323, 6814.727410903607, 6815.659217039129, 6666.500012499082, 6678.432333251728, 6679.365460281266, 6686.0, 6686.231083425371, 6615.900761488581, 6787.04981302618, 6802.455803535705, 6803.829904252433, 6809.421199198124, 6475.611463312216, 6481.513886458629, 6486.1243732097455, 6490.350964903472, 6527.640979745969, 6444.967775161282, 6447.6453795041725, 6454.5159113065765, 6457.935420645921, 6467.353264673495, 6590.835229119119, 6772.93227067723, 6779.254282029072, 6783.05037294789, 6783.253842077269, 4535.070310586256, 4562.680612357103, 4568.1548913451115, 4569.977150114228, 4579.450465944108, 6463.418292353711, 6468.902966455601, 6480.189976252968, 6482.967585162044, 6495.935040649533, 6155.35368786271, 6307.590006649737, 6310.1796766420075, 6315.3053164152825, 6315.621062736251, 6301.96849015752, 6304.257647923168, 6305.1172835803945, 6305.495560355069, 6306.180196574416, 6174.845628859314, 6179.196704428396, 6189.9690501549, 6194.5044396449075, 6197.5351848610635, 6175.62946223228, 6200.844978875564, 6235.378801511549, 6345.238571371465, 6353.269374022047, 6211.720472578835, 6230.532710046674, 6242.188515492957, 6244.188255526752, 6244.438000579969], "unit": "score", "name": "prototype.html", "value": 4757.694762775601}, {"lowerIsBetter": false, "replicates": [711.5588335232155, 793.4049462902823, 837.6021389839827, 842.8103676672749, 869.9478031318125, 11254.887451125487, 11395.0, 11411.087113030959, 14260.429582816674, 14433.711325773478, 12522.624321270354, 12576.811347829767, 12582.874171258285, 12590.181638193511, 12598.433070511826, 666.669998350817, 813.3858936502932, 825.154216927648, 825.6821123867325, 826.1862065865118, 669.8827705151604, 788.5229436191108, 817.2930415190876, 817.5176645778989, 819.4304958054155, 838.9077201507829, 839.0, 839.08539691736, 839.3411172229801, 841.4278290762279, 690.7444245629099, 696.5194016128905, 821.5070957425556, 834.1991687979547, 845.6786421159982, 620.8013435700533, 622.2035794183453, 622.7820262907991, 628.9716962736687, 630.495603517189, 11745.647630571097, 11771.764564708743, 11809.822852657217, 11856.347900865449, 11858.407079645984, 10922.071623911977, 11031.448427578589, 11799.174057815957, 11836.585719499777, 12397.690057748538, 9776.266779991458, 9815.067568580973, 9864.60541578336, 10049.145822605087, 10248.436336001518, 3509.4209455439823, 3567.6967457766123, 3610.223801882608, 3639.909002274938, 3652.086978255436, 48244.0, 48470.27294590584, 48558.7572062141, 48587.0, 48598.0, 9637.956276830773, 9662.71011869645, 9721.756956076013, 9943.204543636637, 10083.949580252052, 17494.737578936325, 17546.122693865254, 17565.824341756674, 17594.94430334184, 17605.911970440324, 6649.8174111184835, 6716.798496045127, 6758.493113016543, 6769.482871459744, 6948.096747422803, 3969.166475040216, 3979.542352629485, 4000.599940005976, 4032.6370626643743, 4059.512858457004, 3067.1871953932227, 3090.969090309113, 3093.969060309368, 3097.597312349425, 3101.116181888196, 531.1209947536755, 544.1484077418827, 547.1246006389824, 548.2844887421953, 565.5164834066895, 485.34478454087406, 609.969501524922, 619.1486705779553, 640.9647469389229, 687.2234375156141, 7663.501872378278, 7846.960765196138, 7861.992076290576, 7987.9201207988335, 8055.798605034804, 536.7557761218636, 618.0605479670965, 652.9118568993125, 675.4731309578536, 691.4641153106282, 3665.908352291214, 3917.7257591968287, 3929.8035098245546, 3947.881563553098, 4008.07814202735, 52655.73672131615, 56016.71991640097, 56198.43801562014, 56336.0, 56444.0, 41534.584654153674, 42449.0, 42705.35941960873, 42980.140397191884, 43196.136077278905, 43666.56333436625, 44451.55548444539, 44822.32766508505, 44990.10019799586, 46242.30636540455, 7531.88702169457, 7585.469017168745, 7620.80947976305, 7771.4559980800805, 7812.3750099993, 32302.515462268555, 32365.35269294648, 32854.178645534055, 32954.83522582372, 33695.494567582, 40424.79787601043, 40497.0, 43274.567254327056, 43831.0, 44131.77934110309, 10638.0, 10707.571697132027, 10993.0, 11214.943925280322, 11249.437528123724, 11670.0, 11789.823152652889, 11851.585194518495, 11948.683590163459, 12156.209846359958, 10722.571097156026, 10879.728006799893, 10881.455927203766, 10945.781084378426, 10979.451027448436, 10737.89262107369, 10951.83572246401, 11234.269772464764, 11517.0, 11530.1928864982, 8186.96182275397, 10533.841992370273, 10915.454227288445, 11050.778984420427, 11103.888961110286, 8569.0, 8873.334499912404, 8960.163166550972, 9269.72190834276, 9338.0, 8652.567371631267, 8829.602667879832, 8973.910260897308, 9030.593623287099, 9070.319726020443], "unit": "score", "name": "yui.html", "value": 6008.584717891319}], "name": "dromaeo_css", "value": 6818.759595714864}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 111.0, 104.0, 109.0, 110.0, 113.0, 100.0, 109.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.4}, {"lowerIsBetter": true, "replicates": [148.0, 134.0, 151.0, 162.0, 127.0, 164.0, 149.0, 129.0, 177.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 146.5}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 161.0, 161.0, 160.0, 161.0, 162.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [74.0, 71.0, 85.0, 95.0, 71.0, 71.0, 74.0, 101.0, 102.0, 74.0], "unit": "score", "name": "audio-fft", "value": 81.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 136.0, 95.0, 95.0, 96.0, 140.0, 95.0, 96.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 108.6}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 146.0, 145.0, 147.0, 145.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 57.0, 56.0, 56.0, 56.0, 57.0, 69.0, 54.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.3}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 67.0, 68.0, 68.0, 68.0, 70.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [91.0, 86.0, 85.0, 85.0, 86.0, 84.0, 85.0, 85.0, 86.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.9}, {"lowerIsBetter": true, "replicates": [134.0, 122.0, 114.0, 115.0, 115.0, 122.0, 119.0, 119.0, 128.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.5}, {"lowerIsBetter": true, "replicates": [141.0, 142.0, 151.0, 152.0, 151.0, 138.0, 149.0, 150.0, 150.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.2}, {"lowerIsBetter": true, "replicates": [72.0, 68.0, 72.0, 68.0, 70.0, 67.0, 67.0, 72.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1504.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.0564650851988], "unit": "score", "name": "Richards", "value": 211.31777200000008}, {"lowerIsBetter": false, "replicates": [197.08316909735908], "unit": "score", "name": "DeltaBlue", "value": 335.48273200000006}, {"lowerIsBetter": false, "replicates": [286.5329512893983], "unit": "score", "name": "Encrypt", "value": 928.97169}, {"lowerIsBetter": false, "replicates": [5180.412371134021], "unit": "score", "name": "Decrypt", "value": 51.38220298507464}, {"lowerIsBetter": false, "replicates": [1932.4324324324325], "unit": "score", "name": "RayTrace", "value": 382.9313706293705}, {"lowerIsBetter": false, "replicates": [801.2820512820513], "unit": "score", "name": "Earley", "value": 831.745824}, {"lowerIsBetter": false, "replicates": [12228.915662650603], "unit": "score", "name": "Boyer", "value": 54.498944827586165}, {"lowerIsBetter": false, "replicates": [26394.736842105263], "unit": "score", "name": "RegExp", "value": 34.51388833499503}, {"lowerIsBetter": false, "replicates": [583.0903790087464], "unit": "score", "name": "Splay", "value": 139.75706500000004}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19747.42114892621}]} 23:03:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19747.42"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1504.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6818.76"}}} 23:03:29 INFO - Return code: 0 23:03:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:03:29 INFO - # TBPL SUCCESS # 23:03:29 INFO - Running post-action listener: _resource_record_post_action 23:03:29 INFO - Running post-run listener: _resource_record_post_run 23:03:30 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 8192; Write bytes: 561881088; Read time: 320; Write time: 403228 23:03:30 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 251850752; Read time: 160; Write time: 223124 23:03:30 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 4096; Write bytes: 310030336; Read time: 160; Write time: 180104 23:03:30 INFO - Running post-run listener: _upload_blobber_files 23:03:30 INFO - Blob upload gear active. 23:03:30 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:03: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 23:03: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', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 23:03: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 B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 23:03:30 INFO - (blobuploader) - INFO - Open directory for files ... 23:03:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 23:03:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:03:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:03:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:03:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:03:31 INFO - (blobuploader) - INFO - Done attempting. 23:03:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:03:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:03:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:03:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:03:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:03:32 INFO - (blobuploader) - INFO - Done attempting. 23:03:32 INFO - (blobuploader) - INFO - Iteration through files over. 23:03:32 INFO - Return code: 0 23:03:32 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:03:32 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:03:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/096f8c1345301ffed3df8dd526b09fcecea8e66aa8a8c9e8cc62946c1e6d12fd8480d9555d7d489cadb6a91d713fcdae72394c3407169fae7de58725738b7c8d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/d36cdaa4dcc739402fef55205e6afbaea9f3d4d1545ce322c257666393a23264f7ec827561f170de2d41efbbb8d51fd3fb915242af8ca884849e699b3a42a8a4"} 23:03:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:03:32 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:03:32 INFO - Contents: 23:03:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/096f8c1345301ffed3df8dd526b09fcecea8e66aa8a8c9e8cc62946c1e6d12fd8480d9555d7d489cadb6a91d713fcdae72394c3407169fae7de58725738b7c8d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/d36cdaa4dcc739402fef55205e6afbaea9f3d4d1545ce322c257666393a23264f7ec827561f170de2d41efbbb8d51fd3fb915242af8ca884849e699b3a42a8a4"} 23:03:32 INFO - Copying logs to upload dir... 23:03:32 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1265.772044 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-01-01 23:03:31.905566) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-01 23:03:31.909564) ========= 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=cd88c086d1ff67493cfd1714000001ba-1451714881.751548-796644693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/096f8c1345301ffed3df8dd526b09fcecea8e66aa8a8c9e8cc62946c1e6d12fd8480d9555d7d489cadb6a91d713fcdae72394c3407169fae7de58725738b7c8d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/d36cdaa4dcc739402fef55205e6afbaea9f3d4d1545ce322c257666393a23264f7ec827561f170de2d41efbbb8d51fd3fb915242af8ca884849e699b3a42a8a4"} build_url:https://queue.taskcluster.net/v1/task/fEs7AXnhQzmSHuuNxuM2oA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011127 build_url: 'https://queue.taskcluster.net/v1/task/fEs7AXnhQzmSHuuNxuM2oA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/096f8c1345301ffed3df8dd526b09fcecea8e66aa8a8c9e8cc62946c1e6d12fd8480d9555d7d489cadb6a91d713fcdae72394c3407169fae7de58725738b7c8d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/d36cdaa4dcc739402fef55205e6afbaea9f3d4d1545ce322c257666393a23264f7ec827561f170de2d41efbbb8d51fd3fb915242af8ca884849e699b3a42a8a4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-01 23:03:31.934847) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 23:03:31.935247) ========= 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=cd88c086d1ff67493cfd1714000001ba-1451714881.751548-796644693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 23:03:32.018241) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-01 23:03:32.018594) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-01 23:03:32.018916) ========= ========= Total master_lag: 0.25 =========