builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-065 starttime: 1455849005.38 results: success (0) buildid: 20160218160128 builduid: 1c74be3d9d3d4320af2c0337f65cf285 revision: 4f651e16a0391ed36df1d4b18622183b54988702 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-18 18:30:05.379176) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-18 18:30:05.379649) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-18 18:30:05.379931) ========= 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=523ca41ca1e0623de333ad52000001bf-1455847872.916573-726376969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006528 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-18 18:30:05.426183) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-18 18:30:05.430514) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-18 18:30:05.563243) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 18:30:05.563522) ========= 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=523ca41ca1e0623de333ad52000001bf-1455847872.916573-726376969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004591 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 18:30:05.621864) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-18 18:30:05.622126) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-18 18:30:05.625493) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 18:30:05.625790) ========= 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=523ca41ca1e0623de333ad52000001bf-1455847872.916573-726376969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-18 18:30:06-- 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% 219M=0s 2016-02-18 18:30:06 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115128 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 18:30:05.755853) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 18:30:05.756160) ========= 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=523ca41ca1e0623de333ad52000001bf-1455847872.916573-726376969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022558 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 18:30:05.810090) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 18:30:05.810448) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4f651e16a0391ed36df1d4b18622183b54988702 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4f651e16a0391ed36df1d4b18622183b54988702 --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=523ca41ca1e0623de333ad52000001bf-1455847872.916573-726376969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-18 18:30:06,278 truncating revision to first 12 chars 2016-02-18 18:30:06,278 Setting DEBUG logging. 2016-02-18 18:30:06,278 attempt 1/10 2016-02-18 18:30:06,278 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4f651e16a039?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-18 18:30:06,581 unpacking tar archive at: mozilla-aurora-4f651e16a039/testing/mozharness/ program finished with exit code 0 elapsedTime=0.596160 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 18:30:06.423403) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-18 18:30:06.423701) ========= echo 4f651e16a0391ed36df1d4b18622183b54988702 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'4f651e16a0391ed36df1d4b18622183b54988702'] 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=523ca41ca1e0623de333ad52000001bf-1455847872.916573-726376969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 4f651e16a0391ed36df1d4b18622183b54988702 program finished with exit code 0 elapsedTime=0.004654 script_repo_revision: '4f651e16a0391ed36df1d4b18622183b54988702' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-18 18:30:06.481390) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-18 18:30:06.481670) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-18 18:30:06.504806) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-02-18 18:30:06.505079) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=523ca41ca1e0623de333ad52000001bf-1455847872.916573-726376969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:30:07 INFO - MultiFileLogger online at 20160218 18:30:07 in /builds/slave/test-pgo 18:30:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 18:30:07 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:30:07 INFO - {'append_to_log': False, 18:30:07 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:30:07 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:30:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:30:07 INFO - 'branch': 'Mozilla-Aurora', 18:30:07 INFO - 'buildbot_json_path': 'buildprops.json', 18:30:07 INFO - 'config_files': ('talos/linux_config.py',), 18:30:07 INFO - 'default_actions': ('clobber', 18:30:07 INFO - 'read-buildbot-config', 18:30:07 INFO - 'download-and-extract', 18:30:07 INFO - 'populate-webroot', 18:30:07 INFO - 'create-virtualenv', 18:30:07 INFO - 'install', 18:30:07 INFO - 'run-tests'), 18:30:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:30:07 INFO - 'download_minidump_stackwalk': True, 18:30:07 INFO - 'download_symbols': 'ondemand', 18:30:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:30:07 INFO - 'tooltool.py': '/tools/tooltool.py', 18:30:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:30:07 INFO - '/tools/misc-python/virtualenv.py')}, 18:30:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:30:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:30:07 INFO - 'installer_path': 'installer.exe', 18:30:07 INFO - 'log_level': 'info', 18:30:07 INFO - 'log_name': 'talos', 18:30:07 INFO - 'log_to_console': True, 18:30:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:30:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:30:07 INFO - 'opt_config_files': (), 18:30:07 INFO - 'pip_index': False, 18:30:07 INFO - 'sps_profile': False, 18:30:07 INFO - 'sps_profile_interval': 0, 18:30:07 INFO - 'suite': 'dromaeojs', 18:30:07 INFO - 'system_bits': '32', 18:30:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:30:07 INFO - 'title': 'talos-linux64-ix-065', 18:30:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:30:07 INFO - 'use_talos_json': True, 18:30:07 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:30:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:30:07 INFO - 'work_dir': 'build'} 18:30:07 INFO - ##### 18:30:07 INFO - ##### Running clobber step. 18:30:07 INFO - ##### 18:30:07 INFO - Running pre-action listener: _resource_record_pre_action 18:30:07 INFO - Running main action method: clobber 18:30:07 INFO - rmtree: /builds/slave/test-pgo/build 18:30:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:30:08 INFO - Running post-action listener: _resource_record_post_action 18:30:08 INFO - ##### 18:30:08 INFO - ##### Running read-buildbot-config step. 18:30:08 INFO - ##### 18:30:08 INFO - Running pre-action listener: _resource_record_pre_action 18:30:08 INFO - Running main action method: read_buildbot_config 18:30:08 INFO - Using buildbot properties: 18:30:08 INFO - { 18:30:08 INFO - "project": "", 18:30:08 INFO - "product": "firefox", 18:30:08 INFO - "script_repo_revision": "production", 18:30:08 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 18:30:08 INFO - "repository": "", 18:30:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 18:30:08 INFO - "buildid": "20160218160128", 18:30:08 INFO - "pgo_build": "True", 18:30:08 INFO - "basedir": "/builds/slave/test-pgo", 18:30:08 INFO - "buildnumber": 54, 18:30:08 INFO - "slavename": "talos-linux64-ix-065", 18:30:08 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:30:08 INFO - "platform": "ubuntu64_hw", 18:30:08 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 18:30:08 INFO - "branch": "mozilla-aurora", 18:30:08 INFO - "repo_path": "releases/mozilla-aurora", 18:30:08 INFO - "revision": "4f651e16a0391ed36df1d4b18622183b54988702", 18:30:08 INFO - "stage_platform": "linux64-pgo", 18:30:08 INFO - "builduid": "1c74be3d9d3d4320af2c0337f65cf285", 18:30:08 INFO - "slavebuilddir": "test" 18:30:08 INFO - } 18:30:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/BFP3B-vnSfSY8H3ErDWIcg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 18:30:08 INFO - Running post-action listener: _resource_record_post_action 18:30:08 INFO - ##### 18:30:08 INFO - ##### Running download-and-extract step. 18:30:08 INFO - ##### 18:30:08 INFO - Running pre-action listener: _resource_record_pre_action 18:30:08 INFO - Running main action method: download_and_extract 18:30:08 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:30:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:08 INFO - https://queue.taskcluster.net/v1/task/BFP3B-vnSfSY8H3ErDWIcg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:30:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFP3B-vnSfSY8H3ErDWIcg/artifacts/public/build/test_packages.json 18:30:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFP3B-vnSfSY8H3ErDWIcg/artifacts/public/build/test_packages.json 18:30:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFP3B-vnSfSY8H3ErDWIcg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 18:30:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFP3B-vnSfSY8H3ErDWIcg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 18:30:12 INFO - Downloaded 1448 bytes. 18:30:12 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 18:30:12 INFO - Using the following test package requirements: 18:30:12 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 18:30:12 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 18:30:12 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 18:30:12 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 18:30:12 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 18:30:12 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 18:30:12 INFO - u'jsshell-linux-x86_64.zip'], 18:30:12 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 18:30:12 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 18:30:12 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 18:30:12 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 18:30:12 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 18:30:12 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 18:30:12 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 18:30:12 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 18:30:12 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 18:30:12 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 18:30:12 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 18:30:12 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 18:30:12 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:30:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:12 INFO - https://queue.taskcluster.net/v1/task/BFP3B-vnSfSY8H3ErDWIcg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:30:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFP3B-vnSfSY8H3ErDWIcg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 18:30:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFP3B-vnSfSY8H3ErDWIcg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 18:30:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFP3B-vnSfSY8H3ErDWIcg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 18:30:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFP3B-vnSfSY8H3ErDWIcg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:30:13 INFO - Downloaded 23077814 bytes. 18:30:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:30:13 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 18:30:14 INFO - Return code: 0 18:30:14 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:30:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:14 INFO - https://queue.taskcluster.net/v1/task/BFP3B-vnSfSY8H3ErDWIcg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:30:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFP3B-vnSfSY8H3ErDWIcg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 18:30:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFP3B-vnSfSY8H3ErDWIcg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 18:30:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFP3B-vnSfSY8H3ErDWIcg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 18:30:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFP3B-vnSfSY8H3ErDWIcg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:30:27 INFO - Downloaded 23077814 bytes. 18:30:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:30:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 18:30:29 INFO - Return code: 0 18:30:29 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')]} 18:30:29 INFO - https://queue.taskcluster.net/v1/task/BFP3B-vnSfSY8H3ErDWIcg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:30:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFP3B-vnSfSY8H3ErDWIcg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 18:30:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFP3B-vnSfSY8H3ErDWIcg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 18:30:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFP3B-vnSfSY8H3ErDWIcg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 18:30:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFP3B-vnSfSY8H3ErDWIcg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:30:30 INFO - Downloaded 10706572 bytes. 18:30:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:30:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 18:30:30 INFO - Return code: 0 18:30:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:30 INFO - https://queue.taskcluster.net/v1/task/BFP3B-vnSfSY8H3ErDWIcg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:30:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFP3B-vnSfSY8H3ErDWIcg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 18:30:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFP3B-vnSfSY8H3ErDWIcg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 18:30:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFP3B-vnSfSY8H3ErDWIcg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 18:30:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFP3B-vnSfSY8H3ErDWIcg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:30:31 INFO - Downloaded 59958210 bytes. 18:30:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BFP3B-vnSfSY8H3ErDWIcg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 18:30:31 INFO - mkdir: /builds/slave/test-pgo/properties 18:30:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:30:31 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:30:31 INFO - Contents: 18:30:31 INFO - build_url:https://queue.taskcluster.net/v1/task/BFP3B-vnSfSY8H3ErDWIcg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 18:30:32 INFO - Running post-action listener: _resource_record_post_action 18:30:32 INFO - Running post-action listener: set_extra_try_arguments 18:30:32 INFO - ##### 18:30:32 INFO - ##### Running populate-webroot step. 18:30:32 INFO - ##### 18:30:32 INFO - Running pre-action listener: _resource_record_pre_action 18:30:32 INFO - Running main action method: populate_webroot 18:30:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:30:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:30:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:30:32 INFO - '--tppagecycles', 18:30:32 INFO - '7'], 18:30:32 INFO - 'tests': ['tsvgm']}}, 18:30:32 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:30:32 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:30:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:30:32 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:30:32 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:30:32 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:30:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:30:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:32 INFO - 'talos_options': ['--e10s'], 18:30:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:30:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:32 INFO - 'tests': ['damp', 'tps']}, 18:30:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:32 INFO - 'talos_options': ['--e10s'], 18:30:32 INFO - 'tests': ['damp', 'tps']}, 18:30:32 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:30:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:30:32 INFO - 'other': {'tests': ['a11yr', 18:30:32 INFO - 'ts_paint', 18:30:32 INFO - 'tpaint', 18:30:32 INFO - 'sessionrestore', 18:30:32 INFO - 'sessionrestore_no_auto_restore']}, 18:30:32 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:30:32 INFO - 'tests': ['a11yr', 18:30:32 INFO - 'ts_paint', 18:30:32 INFO - 'tpaint', 18:30:32 INFO - 'sessionrestore', 18:30:32 INFO - 'sessionrestore_no_auto_restore']}, 18:30:32 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:30:32 INFO - 'tests': ['a11yr', 18:30:32 INFO - 'ts_paint', 18:30:32 INFO - 'tpaint', 18:30:32 INFO - 'sessionrestore', 18:30:32 INFO - 'sessionrestore_no_auto_restore']}, 18:30:32 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:30:32 INFO - 'tests': ['a11yr', 18:30:32 INFO - 'ts_paint', 18:30:32 INFO - 'tpaint', 18:30:32 INFO - 'sessionrestore', 18:30:32 INFO - 'sessionrestore_no_auto_restore']}, 18:30:32 INFO - 'other_l64': {'tests': ['a11yr', 18:30:32 INFO - 'ts_paint', 18:30:32 INFO - 'tpaint', 18:30:32 INFO - 'sessionrestore', 18:30:32 INFO - 'sessionrestore_no_auto_restore']}, 18:30:32 INFO - 'other_nol64': {'tests': ['a11yr', 18:30:32 INFO - 'ts_paint', 18:30:32 INFO - 'tpaint', 18:30:32 INFO - 'sessionrestore', 18:30:32 INFO - 'sessionrestore_no_auto_restore']}, 18:30:32 INFO - 'svgr': {'tests': ['tsvgx', 18:30:32 INFO - 'tsvgr_opacity', 18:30:32 INFO - 'tart', 18:30:32 INFO - 'tscrollx', 18:30:32 INFO - 'cart']}, 18:30:32 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:30:32 INFO - 'tests': ['tsvgx', 18:30:32 INFO - 'tsvgr_opacity', 18:30:32 INFO - 'tart', 18:30:32 INFO - 'tscrollx', 18:30:32 INFO - 'cart']}, 18:30:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:32 INFO - 'tests': ['tp5o']}, 18:30:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:32 INFO - 'talos_options': ['--e10s'], 18:30:32 INFO - 'tests': ['tp5o']}, 18:30:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:32 INFO - 'talos_options': ['--xperf_path', 18:30:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:30:32 INFO - 'tests': ['tp5n']}, 18:30:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:30:32 INFO - 'talos_options': ['--e10s', 18:30:32 INFO - '--xperf_path', 18:30:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:30:32 INFO - 'tests': ['tp5n']}}, 18:30:32 INFO - 'talos.zip': {'path': '', 18:30:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:30:32 INFO - Running post-action listener: _resource_record_post_action 18:30:32 INFO - ##### 18:30:32 INFO - ##### Running create-virtualenv step. 18:30:32 INFO - ##### 18:30:32 INFO - Running pre-action listener: _resource_record_pre_action 18:30:32 INFO - Running main action method: create_virtualenv 18:30:32 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:30:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 18:30:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:30:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:30:32 INFO - Using real prefix '/usr' 18:30:32 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:30:33 INFO - Installing distribute.............................................................................................................................................................................................done. 18:30:35 INFO - Installing pip.................done. 18:30:35 INFO - Return code: 0 18:30:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:30: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')]} 18:30:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30: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')]} 18:30:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:35 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed17cf6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1361480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f0660>, '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 0x13f1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f1a10>, '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': '523ca41ca1e0623de333ad52000001bf-1455847872.916573-726376969', '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 18:30:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 18:30:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:30:35 INFO - Using env: {'DISPLAY': ':0', 18:30:35 INFO - 'HOME': '/home/cltbld', 18:30:35 INFO - 'LANG': 'en_US.UTF-8', 18:30:35 INFO - 'LANGUAGE': 'en_US:en', 18:30:35 INFO - 'LOGNAME': 'cltbld', 18:30:35 INFO - 'MAIL': '/var/mail/cltbld', 18:30:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:35 INFO - 'MOZ_NO_REMOTE': '1', 18:30:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:35 INFO - 'NO_EM_RESTART': '1', 18:30:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:30:35 INFO - 'PWD': '/builds/slave/test-pgo', 18:30:35 INFO - 'SHELL': '/bin/bash', 18:30:35 INFO - 'SHLVL': '1', 18:30:35 INFO - 'TERM': 'linux', 18:30:35 INFO - 'TMOUT': '86400', 18:30:35 INFO - 'USER': 'cltbld', 18:30:35 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1455847872.916573-726376969', 18:30:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:35 INFO - '_': '/tools/buildbot/bin/python'} 18:30:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:35 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 18:30:35 INFO - Cleaning up... 18:30:35 INFO - Return code: 0 18:30:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:30: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')]} 18:30:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30: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')]} 18:30:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:35 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fed17cf6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1361480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f0660>, '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 0x13f1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f1a10>, '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': '523ca41ca1e0623de333ad52000001bf-1455847872.916573-726376969', '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 18:30:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 18:30:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:30:35 INFO - Using env: {'DISPLAY': ':0', 18:30:35 INFO - 'HOME': '/home/cltbld', 18:30:35 INFO - 'LANG': 'en_US.UTF-8', 18:30:35 INFO - 'LANGUAGE': 'en_US:en', 18:30:35 INFO - 'LOGNAME': 'cltbld', 18:30:35 INFO - 'MAIL': '/var/mail/cltbld', 18:30:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:35 INFO - 'MOZ_NO_REMOTE': '1', 18:30:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:35 INFO - 'NO_EM_RESTART': '1', 18:30:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:30:35 INFO - 'PWD': '/builds/slave/test-pgo', 18:30:35 INFO - 'SHELL': '/bin/bash', 18:30:35 INFO - 'SHLVL': '1', 18:30:35 INFO - 'TERM': 'linux', 18:30:35 INFO - 'TMOUT': '86400', 18:30:35 INFO - 'USER': 'cltbld', 18:30:35 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1455847872.916573-726376969', 18:30:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:35 INFO - '_': '/tools/buildbot/bin/python'} 18:30:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:35 INFO - Downloading/unpacking psutil>=0.7.1 18:30:35 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 18:30:35 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 18:30:35 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 18:30:35 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 18:30:35 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 18:30:35 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 18:30:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:30:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:30:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:30:37 INFO - Installing collected packages: psutil 18:30:37 INFO - Running setup.py install for psutil 18:30:37 INFO - building 'psutil._psutil_linux' extension 18:30:37 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 18:30:37 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 18:30:37 INFO - building 'psutil._psutil_posix' extension 18:30:37 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 18:30:37 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 18:30:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:30:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:30:37 INFO - Successfully installed psutil 18:30:37 INFO - Cleaning up... 18:30:37 INFO - Return code: 0 18:30:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:37 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed17cf6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1361480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f0660>, '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 0x13f1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f1a10>, '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': '523ca41ca1e0623de333ad52000001bf-1455847872.916573-726376969', '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 18:30:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 18:30:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:30:37 INFO - Using env: {'DISPLAY': ':0', 18:30:37 INFO - 'HOME': '/home/cltbld', 18:30:37 INFO - 'LANG': 'en_US.UTF-8', 18:30:37 INFO - 'LANGUAGE': 'en_US:en', 18:30:37 INFO - 'LOGNAME': 'cltbld', 18:30:37 INFO - 'MAIL': '/var/mail/cltbld', 18:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:37 INFO - 'MOZ_NO_REMOTE': '1', 18:30:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:37 INFO - 'NO_EM_RESTART': '1', 18:30:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:30:37 INFO - 'PWD': '/builds/slave/test-pgo', 18:30:37 INFO - 'SHELL': '/bin/bash', 18:30:37 INFO - 'SHLVL': '1', 18:30:37 INFO - 'TERM': 'linux', 18:30:37 INFO - 'TMOUT': '86400', 18:30:37 INFO - 'USER': 'cltbld', 18:30:37 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1455847872.916573-726376969', 18:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:37 INFO - '_': '/tools/buildbot/bin/python'} 18:30:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:30:38 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 18:30:38 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 18:30:38 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 18:30:38 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 18:30:38 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 18:30:38 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 18:30:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:30:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:30:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:30:40 INFO - Installing collected packages: mozsystemmonitor 18:30:40 INFO - Running setup.py install for mozsystemmonitor 18:30:40 INFO - Successfully installed mozsystemmonitor 18:30:40 INFO - Cleaning up... 18:30:40 INFO - Return code: 0 18:30:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:30:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed17cf6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1361480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f0660>, '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 0x13f1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f1a10>, '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': '523ca41ca1e0623de333ad52000001bf-1455847872.916573-726376969', '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 18:30:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 18:30:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:30:40 INFO - Using env: {'DISPLAY': ':0', 18:30:40 INFO - 'HOME': '/home/cltbld', 18:30:40 INFO - 'LANG': 'en_US.UTF-8', 18:30:40 INFO - 'LANGUAGE': 'en_US:en', 18:30:40 INFO - 'LOGNAME': 'cltbld', 18:30:40 INFO - 'MAIL': '/var/mail/cltbld', 18:30:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:40 INFO - 'MOZ_NO_REMOTE': '1', 18:30:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:40 INFO - 'NO_EM_RESTART': '1', 18:30:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:30:40 INFO - 'PWD': '/builds/slave/test-pgo', 18:30:40 INFO - 'SHELL': '/bin/bash', 18:30:40 INFO - 'SHLVL': '1', 18:30:40 INFO - 'TERM': 'linux', 18:30:40 INFO - 'TMOUT': '86400', 18:30:40 INFO - 'USER': 'cltbld', 18:30:40 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1455847872.916573-726376969', 18:30:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:40 INFO - '_': '/tools/buildbot/bin/python'} 18:30:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:40 INFO - Downloading/unpacking blobuploader==1.2.4 18:30:40 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 18:30:40 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 18:30:40 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 18:30:40 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 18:30:40 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 18:30:40 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 18:30:42 INFO - Downloading blobuploader-1.2.4.tar.gz 18:30:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:30:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:30: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 18:30: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 18:30: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 18:30: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 18:30: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 18:30: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 18:30:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:30:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:30: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 18:30: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 18:30: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 18:30: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 18:30: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 18:30: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 18:30:42 INFO - Downloading docopt-0.6.1.tar.gz 18:30:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:30:42 INFO - Installing collected packages: blobuploader, requests, docopt 18:30:42 INFO - Running setup.py install for blobuploader 18:30:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:30:43 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:30:43 INFO - Running setup.py install for requests 18:30:43 INFO - Running setup.py install for docopt 18:30:43 INFO - Successfully installed blobuploader requests docopt 18:30:43 INFO - Cleaning up... 18:30:43 INFO - Return code: 0 18:30:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:30:43 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')]} 18:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:43 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')]} 18:30:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed17cf6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1361480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f0660>, '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 0x13f1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f1a10>, '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': '523ca41ca1e0623de333ad52000001bf-1455847872.916573-726376969', '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 18:30:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 18:30:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:30:43 INFO - Using env: {'DISPLAY': ':0', 18:30:43 INFO - 'HOME': '/home/cltbld', 18:30:43 INFO - 'LANG': 'en_US.UTF-8', 18:30:43 INFO - 'LANGUAGE': 'en_US:en', 18:30:43 INFO - 'LOGNAME': 'cltbld', 18:30:43 INFO - 'MAIL': '/var/mail/cltbld', 18:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:43 INFO - 'MOZ_NO_REMOTE': '1', 18:30:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:43 INFO - 'NO_EM_RESTART': '1', 18:30:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:30:43 INFO - 'PWD': '/builds/slave/test-pgo', 18:30:43 INFO - 'SHELL': '/bin/bash', 18:30:43 INFO - 'SHLVL': '1', 18:30:43 INFO - 'TERM': 'linux', 18:30:43 INFO - 'TMOUT': '86400', 18:30:43 INFO - 'USER': 'cltbld', 18:30:43 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1455847872.916573-726376969', 18:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:43 INFO - '_': '/tools/buildbot/bin/python'} 18:30:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:30:43 INFO - Running setup.py (path:/tmp/pip-Kgwdvm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:30:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:30:43 INFO - Running setup.py (path:/tmp/pip-tngCL6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:30:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:30:43 INFO - Running setup.py (path:/tmp/pip-qb0N57-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:30:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:30:44 INFO - Running setup.py (path:/tmp/pip-brZp2x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:30:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:30:44 INFO - Running setup.py (path:/tmp/pip-a39O0R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:30:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:30:44 INFO - Running setup.py (path:/tmp/pip-pwn6YV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:30:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:30:44 INFO - Running setup.py (path:/tmp/pip-m6Y7KG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:30:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:30:44 INFO - Running setup.py (path:/tmp/pip-dXrijH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:30:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:30:44 INFO - Running setup.py (path:/tmp/pip-1IQUYI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:30:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:30:44 INFO - Running setup.py (path:/tmp/pip-Iq7y28-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:30:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:30:44 INFO - Running setup.py (path:/tmp/pip-mTZrL_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:30:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:30:44 INFO - Running setup.py (path:/tmp/pip-gYklBS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:30:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:30:44 INFO - Running setup.py (path:/tmp/pip-fweLcq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:30:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:30:44 INFO - Running setup.py (path:/tmp/pip-izQjYN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:30:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:30:44 INFO - Running setup.py (path:/tmp/pip-d2M_WM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:30:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:30:44 INFO - Running setup.py (path:/tmp/pip-42wqpX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:30:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:30:44 INFO - Running setup.py (path:/tmp/pip-Mb0MOh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:30:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:30:45 INFO - Running setup.py install for manifestparser 18:30:45 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:30:45 INFO - Running setup.py install for mozcrash 18:30:45 INFO - Running setup.py install for mozdebug 18:30:45 INFO - Running setup.py install for mozdevice 18:30:45 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:30:45 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:30:45 INFO - Running setup.py install for mozfile 18:30:45 INFO - Running setup.py install for mozhttpd 18:30:45 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:30:45 INFO - Running setup.py install for mozinfo 18:30:45 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:30:45 INFO - Running setup.py install for mozInstall 18:30:45 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:30:45 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:30:45 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:30:45 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:30:45 INFO - Running setup.py install for mozleak 18:30:45 INFO - Running setup.py install for mozlog 18:30:46 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:30:46 INFO - Running setup.py install for moznetwork 18:30:46 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:30:46 INFO - Running setup.py install for mozprocess 18:30:46 INFO - Running setup.py install for mozprofile 18:30:46 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:30:46 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:30:46 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:30:46 INFO - Running setup.py install for mozrunner 18:30:46 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:30:46 INFO - Running setup.py install for mozscreenshot 18:30:46 INFO - Running setup.py install for moztest 18:30:46 INFO - Running setup.py install for mozversion 18:30:46 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:30:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:30:46 INFO - Cleaning up... 18:30:46 INFO - Return code: 0 18:30:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:30: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')]} 18:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30: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')]} 18:30:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed17cf6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1361480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f0660>, '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 0x13f1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f1a10>, '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': '523ca41ca1e0623de333ad52000001bf-1455847872.916573-726376969', '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 18:30:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 18:30:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:30:46 INFO - Using env: {'DISPLAY': ':0', 18:30:46 INFO - 'HOME': '/home/cltbld', 18:30:46 INFO - 'LANG': 'en_US.UTF-8', 18:30:46 INFO - 'LANGUAGE': 'en_US:en', 18:30:46 INFO - 'LOGNAME': 'cltbld', 18:30:46 INFO - 'MAIL': '/var/mail/cltbld', 18:30:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:46 INFO - 'MOZ_NO_REMOTE': '1', 18:30:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:46 INFO - 'NO_EM_RESTART': '1', 18:30:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:30:46 INFO - 'PWD': '/builds/slave/test-pgo', 18:30:46 INFO - 'SHELL': '/bin/bash', 18:30:46 INFO - 'SHLVL': '1', 18:30:46 INFO - 'TERM': 'linux', 18:30:46 INFO - 'TMOUT': '86400', 18:30:46 INFO - 'USER': 'cltbld', 18:30:46 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1455847872.916573-726376969', 18:30:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:46 INFO - '_': '/tools/buildbot/bin/python'} 18:30:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:30:47 INFO - Running setup.py (path:/tmp/pip-ok6xQB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:30:47 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)) 18:30:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:30:47 INFO - Running setup.py (path:/tmp/pip-vBDR6G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:30:47 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)) 18:30:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:30:47 INFO - Running setup.py (path:/tmp/pip-6ZrflH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:30:47 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)) 18:30:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:30:47 INFO - Running setup.py (path:/tmp/pip-GjIWkV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:30:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:30:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:30:47 INFO - Running setup.py (path:/tmp/pip-w7GnQy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:30:47 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)) 18:30:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:30:47 INFO - Running setup.py (path:/tmp/pip-B0I1FO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:30:47 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)) 18:30:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:30:47 INFO - Running setup.py (path:/tmp/pip-HQq59i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:30:47 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)) 18:30:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:30:47 INFO - Running setup.py (path:/tmp/pip-MOzhxK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:30:47 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)) 18:30:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:30:47 INFO - Running setup.py (path:/tmp/pip-_N8ixP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:30:47 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)) 18:30:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:30:47 INFO - Running setup.py (path:/tmp/pip-T1szTS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:30:47 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)) 18:30:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:30:47 INFO - Running setup.py (path:/tmp/pip-ZLHZRB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:30:47 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)) 18:30:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:30:47 INFO - Running setup.py (path:/tmp/pip-ThyWEk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:30:47 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)) 18:30:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:30:47 INFO - Running setup.py (path:/tmp/pip-DfzOdI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:30:47 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)) 18:30:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:30:47 INFO - Running setup.py (path:/tmp/pip-5BDpJL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:30:48 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)) 18:30:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:30:48 INFO - Running setup.py (path:/tmp/pip-NcZDaf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:30:48 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)) 18:30:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:30:48 INFO - Running setup.py (path:/tmp/pip-PNOfOP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:30:48 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)) 18:30:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:30:48 INFO - Running setup.py (path:/tmp/pip-zQdUlp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:30:48 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)) 18:30:48 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)) 18:30:48 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)) 18:30:48 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)) 18:30:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:30:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:30:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:30: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 18:30: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 18:30: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 18:30: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 18:30: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 18:30: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 18:30:50 INFO - Downloading blessings-1.6.tar.gz 18:30:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:30:50 INFO - Installing collected packages: blessings 18:30:50 INFO - Running setup.py install for blessings 18:30:50 INFO - Successfully installed blessings 18:30:50 INFO - Cleaning up... 18:30:50 INFO - Return code: 0 18:30:50 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:30:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:30:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:30:50 INFO - Reading from file tmpfile_stdout 18:30:50 INFO - Current package versions: 18:30:50 INFO - argparse == 1.2.1 18:30:50 INFO - blessings == 1.6 18:30:50 INFO - blobuploader == 1.2.4 18:30:50 INFO - docopt == 0.6.1 18:30:50 INFO - manifestparser == 1.1 18:30:50 INFO - mozInstall == 1.12 18:30:50 INFO - mozcrash == 0.16 18:30:50 INFO - mozdebug == 0.1 18:30:50 INFO - mozdevice == 0.48 18:30:50 INFO - mozfile == 1.2 18:30:50 INFO - mozhttpd == 0.7 18:30:50 INFO - mozinfo == 0.9 18:30:50 INFO - mozleak == 0.1 18:30:50 INFO - mozlog == 3.1 18:30:50 INFO - moznetwork == 0.27 18:30:50 INFO - mozprocess == 0.22 18:30:50 INFO - mozprofile == 0.28 18:30:50 INFO - mozrunner == 6.11 18:30:50 INFO - mozscreenshot == 0.1 18:30:50 INFO - mozsystemmonitor == 0.0 18:30:50 INFO - moztest == 0.7 18:30:50 INFO - mozversion == 1.4 18:30:50 INFO - psutil == 3.1.1 18:30:50 INFO - requests == 1.2.3 18:30:50 INFO - wsgiref == 0.1.2 18:30:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed17cf6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1361480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f0660>, '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 0x13f1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f1a10>, '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': '523ca41ca1e0623de333ad52000001bf-1455847872.916573-726376969', '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 18:30:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 18:30:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:30:50 INFO - Using env: {'DISPLAY': ':0', 18:30:50 INFO - 'HOME': '/home/cltbld', 18:30:50 INFO - 'LANG': 'en_US.UTF-8', 18:30:50 INFO - 'LANGUAGE': 'en_US:en', 18:30:50 INFO - 'LOGNAME': 'cltbld', 18:30:50 INFO - 'MAIL': '/var/mail/cltbld', 18:30:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:50 INFO - 'MOZ_NO_REMOTE': '1', 18:30:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:50 INFO - 'NO_EM_RESTART': '1', 18:30:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:30:50 INFO - 'PWD': '/builds/slave/test-pgo', 18:30:50 INFO - 'SHELL': '/bin/bash', 18:30:50 INFO - 'SHLVL': '1', 18:30:50 INFO - 'TERM': 'linux', 18:30:50 INFO - 'TMOUT': '86400', 18:30:50 INFO - 'USER': 'cltbld', 18:30:50 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1455847872.916573-726376969', 18:30:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:50 INFO - '_': '/tools/buildbot/bin/python'} 18:30:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:50 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)) 18:30:50 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)) 18:30:50 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)) 18:30:50 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)) 18:30:50 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)) 18:30:50 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)) 18:30:50 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)) 18:30:50 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)) 18:30:50 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)) 18:30:50 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)) 18:30:50 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)) 18:30:50 INFO - Cleaning up... 18:30:50 INFO - Return code: 0 18:30:50 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed17cf6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1361480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f0660>, '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 0x13f1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f1a10>, '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': '523ca41ca1e0623de333ad52000001bf-1455847872.916573-726376969', '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 18:30:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 18:30:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:30:50 INFO - Using env: {'DISPLAY': ':0', 18:30:50 INFO - 'HOME': '/home/cltbld', 18:30:50 INFO - 'LANG': 'en_US.UTF-8', 18:30:50 INFO - 'LANGUAGE': 'en_US:en', 18:30:50 INFO - 'LOGNAME': 'cltbld', 18:30:50 INFO - 'MAIL': '/var/mail/cltbld', 18:30:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:50 INFO - 'MOZ_NO_REMOTE': '1', 18:30:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:50 INFO - 'NO_EM_RESTART': '1', 18:30:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:30:50 INFO - 'PWD': '/builds/slave/test-pgo', 18:30:50 INFO - 'SHELL': '/bin/bash', 18:30:50 INFO - 'SHLVL': '1', 18:30:50 INFO - 'TERM': 'linux', 18:30:50 INFO - 'TMOUT': '86400', 18:30:50 INFO - 'USER': 'cltbld', 18:30:50 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1455847872.916573-726376969', 18:30:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:50 INFO - '_': '/tools/buildbot/bin/python'} 18:30:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:50 INFO - Downloading/unpacking jsonschema 18:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:30:52 INFO - Downloading/unpacking functools32 (from jsonschema) 18:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:52 INFO - Downloading functools32-3.2.3-2.tar.gz 18:30:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:30:52 INFO - warning: no files found matching '*.txt' 18:30:52 INFO - no previously-included directories found matching 'build' 18:30:52 INFO - no previously-included directories found matching 'dist' 18:30:52 INFO - no previously-included directories found matching '.git*' 18:30:52 INFO - Installing collected packages: jsonschema, functools32 18:30:53 INFO - Running setup.py install for functools32 18:30:53 INFO - warning: no files found matching '*.txt' 18:30:53 INFO - no previously-included directories found matching 'build' 18:30:53 INFO - no previously-included directories found matching 'dist' 18:30:53 INFO - no previously-included directories found matching '.git*' 18:30:53 INFO - Successfully installed jsonschema functools32 18:30:53 INFO - Cleaning up... 18:30:53 INFO - Return code: 0 18:30:53 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:30: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')]} 18:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30: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')]} 18:30:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:30:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed17cf6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1361480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f0660>, '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 0x13f1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f1a10>, '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': '523ca41ca1e0623de333ad52000001bf-1455847872.916573-726376969', '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 18:30:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 18:30:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:30:53 INFO - Using env: {'DISPLAY': ':0', 18:30:53 INFO - 'HOME': '/home/cltbld', 18:30:53 INFO - 'LANG': 'en_US.UTF-8', 18:30:53 INFO - 'LANGUAGE': 'en_US:en', 18:30:53 INFO - 'LOGNAME': 'cltbld', 18:30:53 INFO - 'MAIL': '/var/mail/cltbld', 18:30:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:53 INFO - 'MOZ_NO_REMOTE': '1', 18:30:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:53 INFO - 'NO_EM_RESTART': '1', 18:30:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:30:53 INFO - 'PWD': '/builds/slave/test-pgo', 18:30:53 INFO - 'SHELL': '/bin/bash', 18:30:53 INFO - 'SHLVL': '1', 18:30:53 INFO - 'TERM': 'linux', 18:30:53 INFO - 'TMOUT': '86400', 18:30:53 INFO - 'USER': 'cltbld', 18:30:53 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1455847872.916573-726376969', 18:30:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:53 INFO - '_': '/tools/buildbot/bin/python'} 18:30:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:53 INFO - Downloading/unpacking flake8 18:30:53 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 18:30:53 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 18:30:53 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 18:30:53 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 18:30:53 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 18:30:53 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 18:30:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:30:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:30:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:30:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:30:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:30:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:30:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:30:55 INFO - no previously-included directories found matching 'docs/_build' 18:30:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:30:55 INFO - Running setup.py install for pep8 18:30:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:30:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:30:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:30:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:30:56 INFO - no previously-included directories found matching 'docs/_build' 18:30:56 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:30:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:30:56 INFO - Cleaning up... 18:30:56 INFO - Return code: 0 18:30:56 INFO - Running post-action listener: _resource_record_post_action 18:30:56 INFO - Running post-action listener: _start_resource_monitoring 18:30:56 INFO - Starting resource monitoring. 18:30:56 INFO - ##### 18:30:56 INFO - ##### Running install step. 18:30:56 INFO - ##### 18:30:56 INFO - Running pre-action listener: _resource_record_pre_action 18:30:56 INFO - Running main action method: install 18:30:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:30:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:30:56 INFO - Reading from file tmpfile_stdout 18:30:56 INFO - Detecting whether we're running mozinstall >=1.0... 18:30:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:30:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:30:56 INFO - Reading from file tmpfile_stdout 18:30:56 INFO - Output received: 18:30:56 INFO - Usage: mozinstall [options] installer 18:30:56 INFO - Options: 18:30:56 INFO - -h, --help show this help message and exit 18:30:56 INFO - -d DEST, --destination=DEST 18:30:56 INFO - Directory to install application into. [default: 18:30:56 INFO - "/builds/slave/test-pgo"] 18:30:56 INFO - --app=APP Application being installed. [default: firefox] 18:30:56 INFO - mkdir: /builds/slave/test-pgo/build/application 18:30:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 18:30:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 18:31:11 INFO - Reading from file tmpfile_stdout 18:31:11 INFO - Output received: 18:31:11 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:31:11 INFO - Running post-action listener: _resource_record_post_action 18:31:11 INFO - ##### 18:31:11 INFO - ##### Running run-tests step. 18:31:11 INFO - ##### 18:31:11 INFO - Running pre-action listener: _resource_record_pre_action 18:31:11 INFO - Running main action method: run_tests 18:31:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:31:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:31:11 INFO - Python 2.7.3 18:31:11 INFO - Return code: 0 18:31:11 INFO - grabbing minidump binary from tooltool 18:31:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:11 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 0x13f0660>, '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 0x13f1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f1a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:31:11 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 18:31:11 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 18:31:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:31:11 INFO - Return code: 0 18:31:11 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:31:11 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:31:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:31:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:31:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:31:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:31:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:31:12 INFO - Return code: 0 18:31:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BFP3B-vnSfSY8H3ErDWIcg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 18:31:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BFP3B-vnSfSY8H3ErDWIcg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 18:31:12 INFO - Using env: {'DISPLAY': ':0', 18:31:12 INFO - 'HOME': '/home/cltbld', 18:31:12 INFO - 'LANG': 'en_US.UTF-8', 18:31:12 INFO - 'LANGUAGE': 'en_US:en', 18:31:12 INFO - 'LOGNAME': 'cltbld', 18:31:12 INFO - 'MAIL': '/var/mail/cltbld', 18:31:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:31:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:31:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:12 INFO - 'MOZ_NO_REMOTE': '1', 18:31:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:31:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:12 INFO - 'NO_EM_RESTART': '1', 18:31:12 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:31:12 INFO - 'PWD': '/builds/slave/test-pgo', 18:31:12 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:31:12 INFO - 'SHELL': '/bin/bash', 18:31:12 INFO - 'SHLVL': '1', 18:31:12 INFO - 'TERM': 'linux', 18:31:12 INFO - 'TMOUT': '86400', 18:31:12 INFO - 'USER': 'cltbld', 18:31:12 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1455847872.916573-726376969', 18:31:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:12 INFO - '_': '/tools/buildbot/bin/python'} 18:31:12 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BFP3B-vnSfSY8H3ErDWIcg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 18:31:12 INFO - mozversion application_buildid: 20160218160128 18:31:12 INFO - mozversion application_changeset: 4f651e16a0391ed36df1d4b18622183b54988702 18:31:12 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:31:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:31:12 INFO - mozversion application_name: Firefox 18:31:12 INFO - mozversion application_remotingname: firefox-dev 18:31:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:31:12 INFO - mozversion application_vendor: Mozilla 18:31:12 INFO - mozversion application_version: 46.0a2 18:31:12 INFO - mozversion platform_buildid: 20160218160128 18:31:12 INFO - mozversion platform_changeset: 4f651e16a0391ed36df1d4b18622183b54988702 18:31:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:31:12 INFO - mozversion platform_version: 46.0a2 18:31:12 INFO - using testdate: 1455849072 18:31:12 INFO - actual date: 1455849072 18:31:12 INFO - starting webserver on 'localhost:46887' 18:31:12 INFO - SUITE-START | Running 3 tests 18:31:12 INFO - TEST-START | dromaeo_css 18:31:12 INFO - operating with platform_type : linux_ 18:31:12 INFO - Initialising browser for dromaeo_css test... 18:31:12 INFO - TEST-INFO | started process 23691 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmph58qcV/profile http://localhost:46887/getInfo.html) 18:31:16 INFO - PROCESS | 23691 | __metrics Screen width/height:1600/1200 18:31:16 INFO - PROCESS | 23691 | colorDepth:24 18:31:16 INFO - PROCESS | 23691 | Browser inner width/height: 1024/697 18:31:16 INFO - PROCESS | 23691 | __metrics 18:31:17 INFO - PROCESS | 23691 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:31:18 INFO - TEST-INFO | 23691: exit 0 18:31:18 INFO - Browser initialized. 18:31:18 INFO - Running cycle 1/1 for dromaeo_css test... 18:31:18 INFO - TEST-INFO | started process 23780 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmph58qcV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:31:30 INFO - PROCESS | 23780 | RSS: Main: 136695808 18:31:30 INFO - PROCESS | 23780 | 18:32:20 INFO - PROCESS | 23780 | 1455849140733 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] 18:34:28 INFO - PROCESS | 23780 | Cycle 1(1): loaded http://localhost:46887/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46887/tests/dromaeo/cssquery-ext.html) 18:34:29 INFO - PROCESS | 23780 | RSS: Main: 244473856 18:34:29 INFO - PROCESS | 23780 | 18:37:32 INFO - PROCESS | 23780 | Cycle 1(1): loaded http://localhost:46887/tests/dromaeo/cssquery-ext.html (next: http://localhost:46887/tests/dromaeo/cssquery-jquery.html) 18:37:32 INFO - PROCESS | 23780 | RSS: Main: 223657984 18:37:32 INFO - PROCESS | 23780 | 18:40:34 INFO - PROCESS | 23780 | Cycle 1(1): loaded http://localhost:46887/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46887/tests/dromaeo/cssquery-mootools.html) 18:40:35 INFO - PROCESS | 23780 | RSS: Main: 236134400 18:40:35 INFO - PROCESS | 23780 | 18:43:36 INFO - PROCESS | 23780 | Cycle 1(1): loaded http://localhost:46887/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46887/tests/dromaeo/cssquery-prototype.html) 18:43:37 INFO - PROCESS | 23780 | RSS: Main: 205336576 18:43:37 INFO - PROCESS | 23780 | 18:46:40 INFO - PROCESS | 23780 | Cycle 1(1): loaded http://localhost:46887/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46887/tests/dromaeo/cssquery-yui.html) 18:46:40 INFO - PROCESS | 23780 | RSS: Main: 208457728 18:46:40 INFO - PROCESS | 23780 | 18:49:42 INFO - PROCESS | 23780 | Cycle 1(1): loaded http://localhost:46887/tests/dromaeo/cssquery-yui.html (next: http://localhost:46887/tests/dromaeo/cssquery-dojo.html) 18:49:43 INFO - PROCESS | 23780 | RSS: Main: 235307008 18:49:43 INFO - PROCESS | 23780 | 18:49:43 INFO - PROCESS | 23780 | __start_tp_report 18:49:43 INFO - PROCESS | 23780 | _x_x_mozilla_page_load 18:49:43 INFO - PROCESS | 23780 | _x_x_mozilla_page_load_details 18:49:43 INFO - PROCESS | 23780 | |i|pagename|runs| 18:49:43 INFO - PROCESS | 23780 | |0;dojo.html;3209.6308924473683;3274.3451309738057;3295.143262751684;3299.307145499445;3324.5179448979893;5268.631195816294;5269.262303277535;5279.234510995903;5281.841544753659;5300.231466437364;5273.920891186635;5276.551493123079;5297;5306.124489459245;5349.5720342372615;4774.474807771142;4816.133096042711;4817.638677099214;4846.151923413407;4899.363082799231;4818;4851.63612729045;4859.514048595148;4860.489648586883;4863.975680121612;4762.357081793948;4802.615790736732;4850.345203397532;4865.489123642002;4869.659123861331;4791.976040119812;4838.201696720054;4885.120678277908;4911.533404326619;4935.728534930578;4834.081524510332;4836.564709176156;4836.709797412132;4840.661153719241;4864.051509955525;4999.475055119233;5069.721165335905;5093.643444958854;5108.770105345268;5162.612804039674;5581.134924086773;5676;5683.9715801420725;5685.346185188673;5686.0617998030275;5683.914741278884;5702.3157221133315;5706.457886500776;5722.113072473731;5733.082706766897;5201.089809283398;5226.660267082628;5320.52115309624;5401.7029063401105;5417.945820541823;5760;5775.133729940542;5790.623609465371;5792.623479473821;5827.35899051104;5465.180222966586;5514.972425137848;5524.723763811793;5529.944700553024;5531;5620.803271885465;5698.601097923189;5782.710864456844;5783.074708046693;5798.449147330997;5587.189857470644;5590.776368945197;5600.411956744483;5608.327000759935;5617.185508101303;5498.422665620133;5586.469285417878;5587.3015873015875;5592.217089607459;5599.608027438122;4341.804618792162;4343.283358245917;4370.125974804988;4379.715318504287;4381.890452738643;3902.902427439337;3970.0273433009097;3974.264761019163;3977.284088864032;3979.621935916083;5287.735613219324;5296.1261391870685;5298.470152984748;5312.282841816305;5313.840584782462;5651.519620832193;5654.15187721845;5656.434356564393;5660.405657405995;5661.34894487131;5200.739963001834;5221.503957124067;5229;5261.605379596545;5297.576193904479;4890.633202509826;4901.411830580282;4905.288733133747;4908.165611845995;4933.28467372229;5717.685527295956;5776.393478684761;5850.531957443394;5854.824355269264;5862.237909071879;5572.498475137176;5576.358718747396;5621.072523033654;5641.125625527886;5679.346875109415;5770.5095066919785;5790.276215473066;5790.971045144747;5801.767929282782;5806.390329015561;5523.613347065667;5569.275994120739;5573.024720673947;5579.804706835242;5599.80400685974;5556.444355564411;5589.385167631639;5598.664080155204;5598.720063996865;5629.605927585029;5449.100898351886;5476.561875049907;5482.616216864782;5482.753276102505;5499.340079190522;5447.264619276347;5504.311961004874;5520.282363292747;5528.55771538284;5547.583931205095;5511.862203444946;5516.089845175501;5516.972415137899;5519;5522.3649280333275;5546.334439867242;5566.053770858883;5582;5591.4688104629995;5604.887902242014;5348.57211423093;5418.512333889968;5431;5485.670859748428;5510.476504732044 18:49:43 INFO - PROCESS | 23780 | |1;ext.html;556.0602581637033;561.3460318728681;578.0693084134542;582.1093726598306;589.172213040678;30581.54127688084;31377.686223137764;38898.41652375213;39497.21005579887;39690.20619587607;44437.55562444375;45243.77378113105;45281.320780188325;45319.54680453194;45423;8879.511626860536;9194.678186263482;9195.632174713037;9197.678081267157;9201.17189452949;8889.866652000224;9041.593128309209;9045.864312035324;9047;9052.456852588833;8979.595918183664;9074.500902450363;9075.500847453388;9075.95462022689;9080.318976076787;8945.597448114819;8988.146126118008;9017.053209413049;9024.368294219406;9027.548622568878;8893.644254229823;9006;9011.459312441275;9016.909830901739;9043.502607356593;42026;42547.57452425467;42551.57448425507;42632.57367426317;42660.3600945983;3672.6143754905615;3800.904977375588;3944.3886197639413;4269.829206831723;4335.739855608642;32271.51592726111;32573.348533029442;32778.508322375186;32888.835555822305;33048.50427243593;4363.454568178978;4380.763342027689;4395.824167033315;4412.977935110336;4431.357453169272;215271;217419;217924;218259;302158;46471.5352846474;46732.29901551479;63329.68335158295;65165.67417162884;65227;59122.704386477795;59264.703676482204;59564;59643;59659.70170149121;16791.91604041972;17125.314987400365;17775.111244437725;18367.72448413275;18380;13986.370613322424;14342.49801256951;14349;14365.856341436453;14366.35351409189;20430.489237768878;20745.585088298452;20780;20814;20825.79174208269;8046.879296810553;8200.138985406566;8354.164583541718;8355.415120941476;8372.162783721578;1146.8165093584987;1157.7047852797482;1168.2347614522191;1212.53923509066;1273.9680858504455;30298.394032119235;30847.691523084482;31166.532502012487;31473;31637.8418107908;1160.9593664221882;1167.7255844876447;1214.969625759363;1221.8106193540016;1274.5220542296638;14349.426022958965;14652.19412932299;14743.115413075035;16433.506994790176;16658;353694;356590;356995;357137;357361;56850.715746421;56892.71553642288;57100;57108;57135;1464.670449148933;1465.8680718735152;1466.5380405172336;1482.0737039350406;1486.6283429142713;31316.843415782776;31352.37295254128;31783.52324715085;31835;31840.68159318377;49761.50238497568;50177.49822501728;50225;50307.49692503028;50312.748436257585;351246;352517;353350;353367;354196;29130.56304155482;29678.70321296846;33015.33969320648;33462.16344591405;33942.83028584841;39311.21377572375;39808.60191398165;39896.80051599723;40960.18079638331;41066.58933410628;33946.32107357888;34281.82859085689;34334.48498272578;34633.134171645914;34672.82663586666;30859.691403085682;33952.15119622029;36438;36606.45090323594;37027.25945481021;36421;36692.81653591822;36820.26359472742;39937.2012559753;40625.39061914015;30261.243468913453;31040.844795775876;31907.202319942186;31926.84036579895;32003.039908802773;25630.359241019123;26554.203373898814;26844.865775670998;27575.862120689268;28816 18:49:43 INFO - PROCESS | 23780 | |2;jquery.html;391.67099636305505;394.1545385148856;395.13465510531915;396.0633102712085;403.54802621064414;14024.439022439115;14056.437742490314;16489.42287019953;18883.33908313211;19036.524086897836;14769.778453323182;17212.741808872877;17584.64830703385;18049.278028878864;18055.729164062548;5298.4436634153435;5544.750486228119;5575.080111781572;5578.972105139469;5583.944160558403;4157.6466000389855;4281.807318670667;5511.200875872996;5571.470710282517;6043.274807023164;5963.314218864821;6150.169727086831;6220.968895155518;6221.191245138126;6223.2532096148525;6006.159137720722;6008.489278411296;6032.909506357364;6060.909086363708;6066.757329706807;5256.053910296145;5363.570914326844;5379.139337705988;5379.892402151974;5385.111456609655;19961.700574491395;21109;21275.574488510298;21518.462038449008;21523.246686365903;1725;2220.3449982255274;2416.4683769570843;2505.899764009456;2582.4447743735186;10091.29360944734;10397.896021039769;10446.216533759998;11234;13661.726765464635;1937.0798870536523;1954.9413517594494;1983.6231116087897;2002.3092033248506;2010.7989201079774;54054.72972635151;57467.40260779128;58834;60084.69957650184;60226.39773602252;10302.793944121076;10405.53175107122;10458.895411045944;10761.30051546647;10788.946055269673;13939.512117075854;14156.079854809404;14170.504032358818;14189.503367382093;14195.78706319406;8329.125441828643;8483.74548763538;8511.74464766058;8536.402451828437;8553.101924297984;8319.958400208081;8362;8391.202835730595;8404.747857564284;8418;4648.7443190624845;4769.928451073237;4794.7842347094465;4795.424549054136;4829.975850120797;1742.310072611992;1802.2880962019929;1843.972340414895;1930.4015755115959;1942.786293507713;1045.8378951262566;1076.2036093290908;1117.6535274065066;1138.7153211697075;1166.6150170443734;13502.797458037941;16460.506184814476;17579.384721534683;17893.910530447265;17917.05233355279;1043.3270540501335;1064.5688496159069;1070.8714954205545;1090.9672709818717;1125.0886781706843;9566.378185417925;9985.30102892805;10052.74868128288;10747.570097196181;10916.836247456295;558042;559397;561420;571453;624670;75466.62266688631;76877;77452.22547774563;77704.61147694338;78272.60863695644;1012.6152062216311;1043.1706793099504;1045.6183493024992;1113.5156207049959;1193.3913704011018;15092.320845561757;16036.11801350937;16077.919610401874;16250.67498650044;16253.349866005701;30867.213139320662;33526.66473335236;34712;35134;35219.823900881354;41921.580784192985;42046;42163.7891810539;42651;42871.3569296467;7874.21257874208;8024.919750802417;8033.638486268015;8076.515409075474;8176.918230817853;10974.561017559208;11609.3614851184;12133.21134126279;12389.814152787536;12704.428300726304;10514.684559463229;10672.413017284123;10851.40317282557;10942.835857462303;11139.610113645984;10572.207084468542;10722.624708135178;10736.516856741622;10768.569257229936;10809.621663241749;7455.5294679453755;8750;9780.119789219005;10373.170146388422;10374.481275936323;7343.632818358954;7579.393648508217;7719.807004824925;7733.458657894119;7772.106207786177;9266.953665231631;10416.843747343644;10782.245242832927;11007.889921100686;11018.283811552223 18:49:43 INFO - PROCESS | 23780 | |3;mootools.html;1471.8086648735664;1523.3678023620198;1575.3383578896867;1771.1675512509116;1875.840553552948;7407.962960185198;8097.47366421183;8226.136255693156;8235.670573177065;8245.587720613976;8171.142030086845;8252.91747082529;8340.708075217368;8346.666133354658;8352.20654037867;2168.7831216878344;2215.925276241022;2420.8063354931564;2478.7893029092547;2516.0313279387383;2468.123816045305;2471.369800700819;2480.615504596781;2492.0654754467073;2512.133314006665;2458.0659349447187;2479.6280557916366;2484.9378765530823;2489.576771948764;2492.252324302711;2415.9637605435933;2459.7048354197523;2460.815438842094;2479.776820086201;2481.689788776394;2435.683361163055;2447.9510409791883;2449.314192026218;2466.7163276223287;2472.2336075816374;8508.78728031798;8598.742037738877;8601.22588966996;8609.655613775441;8621.482711037295;5161.690298582097;5285.788568457296;5331.573474122061;5335.439778823245;5338.572914166896;3363.1760218746317;3365.1082463147286;3516.244007538366;3528.7177025837873;3560.3769340365334;1101.509828126484;1110.4725255503652;1130.37829193943;1158.94205289736;1183.0594677231536;12161.635150945485;12232.388380581024;12239.265644061385;12239.632811015685;12282;4789.185838407479;4801.159797035574;4830.9275360869615;4840.419149702058;4959.776810043557;10377.481125943672;10382.532786024647;10395.16838652906;10402.5838966442;10409.635662751918;5241.266222728821;5286.15421532553;5288.7355632219005;5291.153415453586;5297.576193904479;4734.313524538922;4782;4785.449673287547;4788.760561971888;4794.832180873653;4186.497620285585;4189.07840275139;4205.600467955539;4238.0252541914915;4252.085801552681;1349.7165595224917;1363.9931800341133;1367.4803574641574;1383.875451209396;1393.2546087842954;1433.333499922541;1447.5729659750398;1470.7132109238596;1475.2328789029646;1485.5172069077594;7989.800254993672;8032.718854840053;8035.196480351918;8036.839263214703;8043.19568043191;532.0741909078254;539.981100661475;541.9132938729784;543.1391244876914;543.2014938041074;6180.752769889244;6205.28639206488;6209.720562574605;6215.844603884849;6216.44052035319;10456.73858153537;10659.73350666224;10766.73083172927;10772.030517253328;10775.94612026935;10423.061924426838;10534.631287904887;10702.946485267525;10705.036546710833;10720.195985300978;8130.715424960098;8151.551664658382;8169.673213071529;8251.546164960864;8262.132476090044;7797.337226335825;7948.920510794818;7961.323287520626;7990.280874721303;8047.195280471906;9314.580843861906;9385.249180065715;9427.15155635996;9433.716988490356;9680.564374603018;9514.238860890973;9731.075547822946;9740.025997400488;9880.258980576342;9976.850347244652;6770.1537307836525;6902;6976.19773726028;7133.85732285341;7178.138623365229;7858.685652574061;7882.093559240531;7889.526628402315;7912.248336408032;7917.802054948673;7021.1574611047;7254.528455650366;7373.705051797868;7429.925700742923;7587.089549254125;7316.304951029643;7411.370033546993;7420.295071968154;7499.925000749922;7521.360684341892;7525.849483010418;7571.3942884568005;7577.772666820004;7583.203763604963;7592.278733520307;6962.060121883481;6967.477439191979;7004.544704594185;7149.034880291302;7152.785416437515;7129.857402851811;7189.820254493679;7190.245024272376;7192.784216473514;7196.820079498055 18:49:43 INFO - PROCESS | 23780 | |4;prototype.html;374.66093185666966;377.1965713031243;377.2511564544379;380.950476438063;388.9416587511871;5820.767169313222;5905.084711869662;5936.139259807331;5946.672932988684;5972.163897054415;5808;5922.881542369161;5937.6140550864275;5938.732757025933;5943.197668314776;4668.766561671911;4679.391679081715;4682.555157260055;4689.88275293117;4690.061987602493;4431.64546836254;4488.304312831517;4506.391637128979;4594.74728889911;4683.08679807436;4557.772111394417;4593.586577208051;4601.240795268776;4601.884952876188;4613.976930115362;4608.446986361624;4638.884027899296;4655.86032419028;4667.603253723438;4672.672912896099;4152.397902304149;4166.749995000309;4168.541460439349;4186.518550366716;4187.958120418818;5563.443655634444;5653.123765816264;5665.093585026376;5677.744501497443;5677.772889084432;5376.709589698483;5441.129419292894;5445.1832225166145;5445.891082178374;5455.0453670607485;6029.969850150721;6228.626282423069;6235.345288744662;6296.590721603081;6310.148130002437;4502.797374118172;4547.067851090552;4614.3770590970125;4624.884377890546;4635.817866444069;6529.575577587441;6530.379613936669;6552.213734351861;6562.67186640666;6567;4726.196546587088;4726.456457507362;4733.455652599926;4738.336632871401;4738.8341408050555;4738.739369334719;4769.689970151929;4795.520447955177;4812.951870481251;4818.783154757974;5406.107992181324;5417.810376636878;5420.403755586883;5424.105022671294;5424.810131645373;6312.558120931582;6319.146915166486;6331.271903731038;6333.429991300805;6342.429181373698;1683.4697070422778;1708.2569082448927;1709.119803301276;1709.3675340124234;1713.5373449168655;1101.251149218523;1136.5169802833764;1149.5689116581282;1197.1141355397117;1220.0910321810131;5956.970215148983;6047.818565443044;6079.513638908877;6086.969565152146;6089.238845144357;6482.611043337415;6503.577267477599;6514.902276465857;6517.185351831021;6519.185101862267;5962.195103661037;6070.3929607038945;6081.726322315418;6084.726187321581;6086.513078953673;3483.1292176955762;3515.5078289039557;3518.1556426457464;3518.82405879705;3522.682958533744;6661.600303981777;6666.200055993312;6674.933250667528;6680.064790929274;6684.6991885364305;6535.313792051861;6639.336066393322;6649.867002659919;6652.567583107082;6662.233843108008;6634.668266586651;6653.700583473756;6654.068430419745;6662.200535935719;6664.8000559983275;6343.714532845941;6469.547131700736;6481.027845823164;6486.740530378732;6499.837504062247;6461.838454038687;6467.320931302145;6483.708233129615;6489.286178520453;6490.935090649033;6711.865762684816;6742.662866856539;6757;6758.797236082925;6759.425448836904;4531.3429552714015;4642.6750127492105;4643.233866412139;4656.371389862461;4658.86023419298;6517.283098859217;6548.410643042149;6559.6064236145985;6560.3111673273615;6564.37638424368;6334.493240540838;6339.587926784744;6412.935870641234;6419;6423.389777971085;6274.937250627618;6381.329960354282;6383.202099737533;6384.936150638434;6398.264199616918;6248.875022499616;6258.186435763321;6302.590331628429;6319.304876463677;6341.397567231105;6413.551051426355;6414.486841052611;6419.55063145594;6420.101185833893;6427.3251308611925;6128.816135515942;6264.718087685974;6269.777393408424;6293.056041593798;6312.400321969406 18:49:43 INFO - PROCESS | 23780 | |5;yui.html;814.8411059843332;822.6133717152939;844.1895780051146;869.0744357259518;872.7163671806665;14161.858381416196;14552.345144468498;14604.853951460482;15067.472638457657;15348;15032.473863414783;15154.318055687492;15165.696686066272;15166.393344266244;15176.544703658881;758.0448634720237;766.2988365645456;910.4173329069384;912.5893347993397;925.8888933327977;916.9220616247627;921.1295325917011;921.9308551858604;923.2660035271941;925.676013395313;956.1585804492038;964.7588102974256;965.6089283840056;966.3718582921088;966.9081437263449;782.3819182845546;790.4466873188762;937.5265490927106;950.8098380323963;954.2747511891013;704.9753258635974;705.2524324216347;706.4101475268158;706.4948561778302;706.6290197646225;14437.927810360987;14463.638409039753;14542;14580.343884525222;14585.416583336653;11865.110116741193;12116.636500904988;12728.109032367738;12936.805947910789;13093.47626094955;10229.641962531276;10528;10621.681349559525;10635.46822658864;10663.200259980455;3439.1917899293644;3450.189205536697;3479.4085005548864;3484.9651503484893;3495.405781017233;51407.74296128533;51674.48325516772;51742;51804.481955180345;52025;10113.64602238918;10203.234757393077;10239.18086553074;10515.684529464128;10524.526396312185;18955.526111847314;19059.332923347618;19234.8076519233;19287.035648217534;19305.710414343797;7898.644560994769;7913;8021.679132834622;8059.919400806034;8238.09380968093;4478.541981346034;4568.451785785727;4578.88552786183;4619.46876109245;4669.673122881366;3137.30979184579;3158.463061279588;3174.333389988082;3178.570892929471;3189.1389324882152;597.5189972072436;602.3705228036712;605.3008774865037;608.0817964873073;614.640435345319;549.9505044546011;632.4063360331937;662.0532638327238;696.7909627111846;710.2187593646947;9025.458472491671;9272.629094836131;9572.282078844115;9573.856392154123;9954.552045157985;602.4577879908118;606.1725744358919;644.6228956060756;646.747768370336;755.524019867491;4233.534311225762;4530.728156310632;4560.475545312332;4565.543445655474;4573.6569757268335;58444;58552.707236463546;59202.40797591969;59261.70369148126;62333.68833155896;49293.75353123283;50249;50536.49463505392;50813.23780143227;51364.22953655698;46402.303965440544;47247.29129063067;47490.525094749304;47994;48838.75580622074;8818.338624603308;9152.313576481658;9281.953590232006;9334.159925606727;9354.579043942902;35035;35575.644243558265;35738.10654733652;36018.27963440769;36383;43024;43398.56601433945;44448.33327500155;45296;46032.309515356625;11171.832422513506;11382.94308528452;11595.594154204562;11597.76804463923;11807.350595716975;12868.806967895676;13010.349482525646;13015.088943773844;13103.672408189872;13163.60509184726;12110.75778484443;12121;12168.08739344535;12204;12654.936725316315;11584.652460426201;11724.648260552198;11729.765404692029;11839.230450020721;12018.699532511757;11905.345206013752;11941.82087268709;12213.877861221274;12230.816537751763;12400.19398739079;8920.152585504367;9023.909760902307;9788.412695238309;9879.357841740264;10016.098551130433;9923.702288931056;10023.298369114093;10024.359930400198;10064.69805905824;10490.790184196427 18:49:43 INFO - PROCESS | 23780 | __end_tp_report 18:49:43 INFO - PROCESS | 23780 | __start_cc_report 18:49:43 INFO - PROCESS | 23780 | _x_x_mozilla_cycle_collect,805 18:49:43 INFO - PROCESS | 23780 | __end_cc_report 18:49:43 INFO - PROCESS | 23780 | __startTimestamp1455850183233__endTimestamp 18:49:43 INFO - PROCESS | 23780 | 18:49:43 INFO - PROCESS | 23780 | ------- Summary: start ------- 18:49:43 INFO - PROCESS | 23780 | Number of tests: 6 18:49:43 INFO - PROCESS | 23780 | 18:49:43 INFO - PROCESS | 23780 | [#0] dojo.html Cycles:165 Average:5254.94 Median:5482.62 stddev:552.53 (10.1%) stddev-sans-first:530.42 18:49:43 INFO - PROCESS | 23780 | Values: 3209.6 3274.3 3295.1 3299.3 3324.5 5268.6 5269.3 5279.2 5281.8 5300.2 5273.9 5276.6 5297.0 5306.1 5349.6 4774.5 4816.1 4817.6 4846.2 4899.4 4818.0 4851.6 4859.5 4860.5 4864.0 4762.4 4802.6 4850.3 4865.5 4869.7 4792.0 4838.2 4885.1 4911.5 4935.7 4834.1 4836.6 4836.7 4840.7 4864.1 4999.5 5069.7 5093.6 5108.8 5162.6 5581.1 5676.0 5684.0 5685.3 5686.1 5683.9 5702.3 5706.5 5722.1 5733.1 5201.1 5226.7 5320.5 5401.7 5417.9 5760.0 5775.1 5790.6 5792.6 5827.4 5465.2 5515.0 5524.7 5529.9 5531.0 5620.8 5698.6 5782.7 5783.1 5798.4 5587.2 5590.8 5600.4 5608.3 5617.2 5498.4 5586.5 5587.3 5592.2 5599.6 4341.8 4343.3 4370.1 4379.7 4381.9 3902.9 3970.0 3974.3 3977.3 3979.6 5287.7 5296.1 5298.5 5312.3 5313.8 5651.5 5654.2 5656.4 5660.4 5661.3 5200.7 5221.5 5229.0 5261.6 5297.6 4890.6 4901.4 4905.3 4908.2 4933.3 5717.7 5776.4 5850.5 5854.8 5862.2 5572.5 5576.4 5621.1 5641.1 5679.3 5770.5 5790.3 5791.0 5801.8 5806.4 5523.6 5569.3 5573.0 5579.8 5599.8 5556.4 5589.4 5598.7 5598.7 5629.6 5449.1 5476.6 5482.6 5482.8 5499.3 5447.3 5504.3 5520.3 5528.6 5547.6 5511.9 5516.1 5517.0 5519.0 5522.4 5546.3 5566.1 5582.0 5591.5 5604.9 5348.6 5418.5 5431.0 5485.7 5510.5 18:49:43 INFO - PROCESS | 23780 | 18:49:43 INFO - PROCESS | 23780 | [#1] ext.html Cycles:180 Average:48859.75 Median:36522.23 stddev:83967.92 (229.9%) stddev-sans-first:84125.15 18:49:43 INFO - PROCESS | 23780 | Values: 556.1 561.3 578.1 582.1 589.2 30581.5 31377.7 38898.4 39497.2 39690.2 44437.6 45243.8 45281.3 45319.5 45423.0 8879.5 9194.7 9195.6 9197.7 9201.2 8889.9 9041.6 9045.9 9047.0 9052.5 8979.6 9074.5 9075.5 9076.0 9080.3 8945.6 8988.1 9017.1 9024.4 9027.5 8893.6 9006.0 9011.5 9016.9 9043.5 42026.0 42547.6 42551.6 42632.6 42660.4 3672.6 3800.9 3944.4 4269.8 4335.7 32271.5 32573.3 32778.5 32888.8 33048.5 4363.5 4380.8 4395.8 4413.0 4431.4 215271.0 217419.0 217924.0 218259.0 302158.0 46471.5 46732.3 63329.7 65165.7 65227.0 59122.7 59264.7 59564.0 59643.0 59659.7 16791.9 17125.3 17775.1 18367.7 18380.0 13986.4 14342.5 14349.0 14365.9 14366.4 20430.5 20745.6 20780.0 20814.0 20825.8 8046.9 8200.1 8354.2 8355.4 8372.2 1146.8 1157.7 1168.2 1212.5 1274.0 30298.4 30847.7 31166.5 31473.0 31637.8 1161.0 1167.7 1215.0 1221.8 1274.5 14349.4 14652.2 14743.1 16433.5 16658.0 353694.0 356590.0 356995.0 357137.0 357361.0 56850.7 56892.7 57100.0 57108.0 57135.0 1464.7 1465.9 1466.5 1482.1 1486.6 31316.8 31352.4 31783.5 31835.0 31840.7 49761.5 50177.5 50225.0 50307.5 50312.7 351246.0 352517.0 353350.0 353367.0 354196.0 29130.6 29678.7 33015.3 33462.2 33942.8 39311.2 39808.6 39896.8 40960.2 41066.6 33946.3 34281.8 34334.5 34633.1 34672.8 30859.7 33952.2 36438.0 36606.5 37027.3 36421.0 36692.8 36820.3 39937.2 40625.4 30261.2 31040.8 31907.2 31926.8 32003.0 25630.4 26554.2 26844.9 27575.9 28816.0 18:49:43 INFO - PROCESS | 23780 | 18:49:43 INFO - PROCESS | 23780 | [#2] jquery.html Cycles:180 Average:29125.91 Median:2318.41 stddev:93971.31 (4053.3%) stddev-sans-first:94210.16 18:49:43 INFO - PROCESS | 23780 | Values: 391.7 394.2 395.1 396.1 403.5 14024.4 14056.4 16489.4 18883.3 19036.5 14769.8 17212.7 17584.6 18049.3 18055.7 5298.4 5544.8 5575.1 5579.0 5583.9 4157.6 4281.8 5511.2 5571.5 6043.3 5963.3 6150.2 6221.0 6221.2 6223.3 6006.2 6008.5 6032.9 6060.9 6066.8 5256.1 5363.6 5379.1 5379.9 5385.1 19961.7 21109.0 21275.6 21518.5 21523.2 1725.0 2220.3 2416.5 2505.9 2582.4 10091.3 10397.9 10446.2 11234.0 13661.7 1937.1 1954.9 1983.6 2002.3 2010.8 54054.7 57467.4 58834.0 60084.7 60226.4 10302.8 10405.5 10458.9 10761.3 10788.9 13939.5 14156.1 14170.5 14189.5 14195.8 8329.1 8483.7 8511.7 8536.4 8553.1 8320.0 8362.0 8391.2 8404.7 8418.0 4648.7 4769.9 4794.8 4795.4 4830.0 1742.3 1802.3 1844.0 1930.4 1942.8 1045.8 1076.2 1117.7 1138.7 1166.6 13502.8 16460.5 17579.4 17893.9 17917.1 1043.3 1064.6 1070.9 1091.0 1125.1 9566.4 9985.3 10052.7 10747.6 10916.8 558042.0 559397.0 561420.0 571453.0 624670.0 75466.6 76877.0 77452.2 77704.6 78272.6 1012.6 1043.2 1045.6 1113.5 1193.4 15092.3 16036.1 16077.9 16250.7 16253.3 30867.2 33526.7 34712.0 35134.0 35219.8 41921.6 42046.0 42163.8 42651.0 42871.4 7874.2 8024.9 8033.6 8076.5 8176.9 10974.6 11609.4 12133.2 12389.8 12704.4 10514.7 10672.4 10851.4 10942.8 11139.6 10572.2 10722.6 10736.5 10768.6 10809.6 7455.5 8750.0 9780.1 10373.2 10374.5 7343.6 7579.4 7719.8 7733.5 7772.1 9267.0 10416.8 10782.2 11007.9 11018.3 18:49:43 INFO - PROCESS | 23780 | 18:49:43 INFO - PROCESS | 23780 | [#3] mootools.html Cycles:180 Average:6004.44 Median:5294.36 stddev:3175.80 (60.0%) stddev-sans-first:3166.44 18:49:43 INFO - PROCESS | 23780 | Values: 1471.8 1523.4 1575.3 1771.2 1875.8 7408.0 8097.5 8226.1 8235.7 8245.6 8171.1 8252.9 8340.7 8346.7 8352.2 2168.8 2215.9 2420.8 2478.8 2516.0 2468.1 2471.4 2480.6 2492.1 2512.1 2458.1 2479.6 2484.9 2489.6 2492.3 2416.0 2459.7 2460.8 2479.8 2481.7 2435.7 2448.0 2449.3 2466.7 2472.2 8508.8 8598.7 8601.2 8609.7 8621.5 5161.7 5285.8 5331.6 5335.4 5338.6 3363.2 3365.1 3516.2 3528.7 3560.4 1101.5 1110.5 1130.4 1158.9 1183.1 12161.6 12232.4 12239.3 12239.6 12282.0 4789.2 4801.2 4830.9 4840.4 4959.8 10377.5 10382.5 10395.2 10402.6 10409.6 5241.3 5286.2 5288.7 5291.2 5297.6 4734.3 4782.0 4785.4 4788.8 4794.8 4186.5 4189.1 4205.6 4238.0 4252.1 1349.7 1364.0 1367.5 1383.9 1393.3 1433.3 1447.6 1470.7 1475.2 1485.5 7989.8 8032.7 8035.2 8036.8 8043.2 532.1 540.0 541.9 543.1 543.2 6180.8 6205.3 6209.7 6215.8 6216.4 10456.7 10659.7 10766.7 10772.0 10775.9 10423.1 10534.6 10702.9 10705.0 10720.2 8130.7 8151.6 8169.7 8251.5 8262.1 7797.3 7948.9 7961.3 7990.3 8047.2 9314.6 9385.2 9427.2 9433.7 9680.6 9514.2 9731.1 9740.0 9880.3 9976.9 6770.2 6902.0 6976.2 7133.9 7178.1 7858.7 7882.1 7889.5 7912.2 7917.8 7021.2 7254.5 7373.7 7429.9 7587.1 7316.3 7411.4 7420.3 7499.9 7521.4 7525.8 7571.4 7577.8 7583.2 7592.3 6962.1 6967.5 7004.5 7149.0 7152.8 7129.9 7189.8 7190.2 7192.8 7196.8 18:49:43 INFO - PROCESS | 23780 | 18:49:43 INFO - PROCESS | 23780 | [#4] prototype.html Cycles:180 Average:5335.21 Median:5967.18 stddev:1554.10 (26.0%) stddev-sans-first:1513.20 18:49:43 INFO - PROCESS | 23780 | Values: 374.7 377.2 377.3 381.0 388.9 5820.8 5905.1 5936.1 5946.7 5972.2 5808.0 5922.9 5937.6 5938.7 5943.2 4668.8 4679.4 4682.6 4689.9 4690.1 4431.6 4488.3 4506.4 4594.7 4683.1 4557.8 4593.6 4601.2 4601.9 4614.0 4608.4 4638.9 4655.9 4667.6 4672.7 4152.4 4166.7 4168.5 4186.5 4188.0 5563.4 5653.1 5665.1 5677.7 5677.8 5376.7 5441.1 5445.2 5445.9 5455.0 6030.0 6228.6 6235.3 6296.6 6310.1 4502.8 4547.1 4614.4 4624.9 4635.8 6529.6 6530.4 6552.2 6562.7 6567.0 4726.2 4726.5 4733.5 4738.3 4738.8 4738.7 4769.7 4795.5 4813.0 4818.8 5406.1 5417.8 5420.4 5424.1 5424.8 6312.6 6319.1 6331.3 6333.4 6342.4 1683.5 1708.3 1709.1 1709.4 1713.5 1101.3 1136.5 1149.6 1197.1 1220.1 5957.0 6047.8 6079.5 6087.0 6089.2 6482.6 6503.6 6514.9 6517.2 6519.2 5962.2 6070.4 6081.7 6084.7 6086.5 3483.1 3515.5 3518.2 3518.8 3522.7 6661.6 6666.2 6674.9 6680.1 6684.7 6535.3 6639.3 6649.9 6652.6 6662.2 6634.7 6653.7 6654.1 6662.2 6664.8 6343.7 6469.5 6481.0 6486.7 6499.8 6461.8 6467.3 6483.7 6489.3 6490.9 6711.9 6742.7 6757.0 6758.8 6759.4 4531.3 4642.7 4643.2 4656.4 4658.9 6517.3 6548.4 6559.6 6560.3 6564.4 6334.5 6339.6 6412.9 6419.0 6423.4 6274.9 6381.3 6383.2 6384.9 6398.3 6248.9 6258.2 6302.6 6319.3 6341.4 6413.6 6414.5 6419.6 6420.1 6427.3 6128.8 6264.7 6269.8 6293.1 6312.4 18:49:43 INFO - PROCESS | 23780 | 18:49:43 INFO - PROCESS | 23780 | [#5] yui.html Cycles:180 Average:14342.70 Median:4576.27 stddev:16312.22 (356.5%) stddev-sans-first:16326.34 18:49:43 INFO - PROCESS | 23780 | Values: 814.8 822.6 844.2 869.1 872.7 14161.9 14552.3 14604.9 15067.5 15348.0 15032.5 15154.3 15165.7 15166.4 15176.5 758.0 766.3 910.4 912.6 925.9 916.9 921.1 921.9 923.3 925.7 956.2 964.8 965.6 966.4 966.9 782.4 790.4 937.5 950.8 954.3 705.0 705.3 706.4 706.5 706.6 14437.9 14463.6 14542.0 14580.3 14585.4 11865.1 12116.6 12728.1 12936.8 13093.5 10229.6 10528.0 10621.7 10635.5 10663.2 3439.2 3450.2 3479.4 3485.0 3495.4 51407.7 51674.5 51742.0 51804.5 52025.0 10113.6 10203.2 10239.2 10515.7 10524.5 18955.5 19059.3 19234.8 19287.0 19305.7 7898.6 7913.0 8021.7 8059.9 8238.1 4478.5 4568.5 4578.9 4619.5 4669.7 3137.3 3158.5 3174.3 3178.6 3189.1 597.5 602.4 605.3 608.1 614.6 550.0 632.4 662.1 696.8 710.2 9025.5 9272.6 9572.3 9573.9 9954.6 602.5 606.2 644.6 646.7 755.5 4233.5 4530.7 4560.5 4565.5 4573.7 58444.0 58552.7 59202.4 59261.7 62333.7 49293.8 50249.0 50536.5 50813.2 51364.2 46402.3 47247.3 47490.5 47994.0 48838.8 8818.3 9152.3 9282.0 9334.2 9354.6 35035.0 35575.6 35738.1 36018.3 36383.0 43024.0 43398.6 44448.3 45296.0 46032.3 11171.8 11382.9 11595.6 11597.8 11807.4 12868.8 13010.3 13015.1 13103.7 13163.6 12110.8 12121.0 12168.1 12204.0 12654.9 11584.7 11724.6 11729.8 11839.2 12018.7 11905.3 11941.8 12213.9 12230.8 12400.2 8920.2 9023.9 9788.4 9879.4 10016.1 9923.7 10023.3 10024.4 10064.7 10490.8 18:49:43 INFO - PROCESS | 23780 | -------- Summary: end -------- 18:49:43 INFO - PROCESS | 23780 | 18:49:43 INFO - TEST-INFO | 23780: exit 0 18:49:43 INFO - TEST-OK | dromaeo_css | took 1111034ms 18:49:43 INFO - TEST-START | kraken 18:49:43 INFO - operating with platform_type : linux_ 18:49:43 INFO - Initialising browser for kraken test... 18:49:43 INFO - TEST-INFO | started process 23970 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp02MlK1/profile http://localhost:46887/getInfo.html) 18:49:47 INFO - PROCESS | 23970 | __metrics Screen width/height:1600/1200 18:49:47 INFO - PROCESS | 23970 | colorDepth:24 18:49:47 INFO - PROCESS | 23970 | Browser inner width/height: 1024/697 18:49:47 INFO - PROCESS | 23970 | __metrics 18:49:47 INFO - PROCESS | 23970 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:49:48 INFO - TEST-INFO | 23970: exit 0 18:49:48 INFO - Browser initialized. 18:49:48 INFO - Running cycle 1/1 for kraken test... 18:49:48 INFO - TEST-INFO | started process 24057 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp02MlK1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:50:00 INFO - PROCESS | 24057 | RSS: Main: 137347072 18:50:00 INFO - PROCESS | 24057 | 18:50:03 INFO - PROCESS | 24057 | Cycle 1(1): loaded http://localhost:46887/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46887/tests/kraken/driver.html?testName=audio-beat-detection) 18:50:03 INFO - PROCESS | 24057 | RSS: Main: 171163648 18:50:03 INFO - PROCESS | 24057 | 18:50:06 INFO - PROCESS | 24057 | Cycle 1(1): loaded http://localhost:46887/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46887/tests/kraken/driver.html?testName=audio-dft) 18:50:06 INFO - PROCESS | 24057 | RSS: Main: 168521728 18:50:06 INFO - PROCESS | 24057 | 18:50:09 INFO - PROCESS | 24057 | Cycle 1(1): loaded http://localhost:46887/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46887/tests/kraken/driver.html?testName=audio-fft) 18:50:10 INFO - PROCESS | 24057 | RSS: Main: 167165952 18:50:10 INFO - PROCESS | 24057 | 18:50:12 INFO - PROCESS | 24057 | Cycle 1(1): loaded http://localhost:46887/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46887/tests/kraken/driver.html?testName=audio-oscillator) 18:50:12 INFO - PROCESS | 24057 | RSS: Main: 166862848 18:50:12 INFO - PROCESS | 24057 | 18:50:15 INFO - PROCESS | 24057 | Cycle 1(1): loaded http://localhost:46887/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46887/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:50:15 INFO - PROCESS | 24057 | RSS: Main: 166273024 18:50:15 INFO - PROCESS | 24057 | 18:50:18 INFO - PROCESS | 24057 | Cycle 1(1): loaded http://localhost:46887/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46887/tests/kraken/driver.html?testName=imaging-darkroom) 18:50:19 INFO - PROCESS | 24057 | RSS: Main: 166100992 18:50:19 INFO - PROCESS | 24057 | 18:50:22 INFO - PROCESS | 24057 | Cycle 1(1): loaded http://localhost:46887/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46887/tests/kraken/driver.html?testName=imaging-desaturate) 18:50:23 INFO - PROCESS | 24057 | RSS: Main: 167432192 18:50:23 INFO - PROCESS | 24057 | 18:50:25 INFO - PROCESS | 24057 | Cycle 1(1): loaded http://localhost:46887/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46887/tests/kraken/driver.html?testName=json-parse-financial) 18:50:26 INFO - PROCESS | 24057 | RSS: Main: 166404096 18:50:26 INFO - PROCESS | 24057 | 18:50:27 INFO - PROCESS | 24057 | Cycle 1(1): loaded http://localhost:46887/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46887/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:50:28 INFO - PROCESS | 24057 | RSS: Main: 170520576 18:50:28 INFO - PROCESS | 24057 | 18:50:30 INFO - PROCESS | 24057 | Cycle 1(1): loaded http://localhost:46887/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46887/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:50:30 INFO - PROCESS | 24057 | RSS: Main: 171888640 18:50:30 INFO - PROCESS | 24057 | 18:50:32 INFO - PROCESS | 24057 | Cycle 1(1): loaded http://localhost:46887/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46887/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:50:33 INFO - PROCESS | 24057 | RSS: Main: 178753536 18:50:33 INFO - PROCESS | 24057 | 18:50:35 INFO - PROCESS | 24057 | Cycle 1(1): loaded http://localhost:46887/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46887/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:50:36 INFO - PROCESS | 24057 | RSS: Main: 184508416 18:50:36 INFO - PROCESS | 24057 | 18:50:38 INFO - PROCESS | 24057 | Cycle 1(1): loaded http://localhost:46887/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46887/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:50:39 INFO - PROCESS | 24057 | RSS: Main: 185196544 18:50:39 INFO - PROCESS | 24057 | 18:50:41 INFO - PROCESS | 24057 | Cycle 1(1): loaded http://localhost:46887/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46887/tests/kraken/driver.html?testName=ai-astar) 18:50:41 INFO - PROCESS | 24057 | RSS: Main: 245673984 18:50:41 INFO - PROCESS | 24057 | 18:50:41 INFO - PROCESS | 24057 | __start_tp_report 18:50:41 INFO - PROCESS | 24057 | _x_x_mozilla_page_load 18:50:41 INFO - PROCESS | 24057 | _x_x_mozilla_page_load_details 18:50:41 INFO - PROCESS | 24057 | |i|pagename|runs| 18:50:41 INFO - PROCESS | 24057 | |0;ai-astar;109;113;108;112;111;111;99;111;111;110 18:50:41 INFO - PROCESS | 24057 | |1;audio-beat-detection;152;125;147;162;123;157;153;135;170;126 18:50:41 INFO - PROCESS | 24057 | |2;audio-dft;159;161;160;160;168;162;161;163;161;161 18:50:41 INFO - PROCESS | 24057 | |3;audio-fft;75;73;76;151;74;73;73;73;141;74 18:50:41 INFO - PROCESS | 24057 | |4;audio-oscillator;94;95;135;94;96;95;143;94;94;138 18:50:41 INFO - PROCESS | 24057 | |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;110;109 18:50:41 INFO - PROCESS | 24057 | |6;imaging-darkroom;147;146;147;146;147;148;146;145;148;150 18:50:41 INFO - PROCESS | 24057 | |7;imaging-desaturate;95;96;96;95;96;96;96;96;96;96 18:50:41 INFO - PROCESS | 24057 | |8;json-parse-financial;53;55;55;54;55;55;54;54;52;51 18:50:41 INFO - PROCESS | 24057 | |9;json-stringify-tinderbox;65;66;66;65;66;66;65;65;70;65 18:50:41 INFO - PROCESS | 24057 | |10;stanford-crypto-aes;79;79;81;80;81;80;80;81;80;82 18:50:41 INFO - PROCESS | 24057 | |11;stanford-crypto-ccm;112;110;119;112;111;111;110;119;109;109 18:50:41 INFO - PROCESS | 24057 | |12;stanford-crypto-pbkdf2;139;127;143;139;135;136;153;142;147;153 18:50:41 INFO - PROCESS | 24057 | |13;stanford-crypto-sha256-iterative;69;65;65;65;66;66;64;67;65;65 18:50:41 INFO - PROCESS | 24057 | __end_tp_report 18:50:41 INFO - PROCESS | 24057 | __start_cc_report 18:50:41 INFO - PROCESS | 24057 | _x_x_mozilla_cycle_collect,919 18:50:41 INFO - PROCESS | 24057 | __end_cc_report 18:50:41 INFO - PROCESS | 24057 | __startTimestamp1455850241318__endTimestamp 18:50:41 INFO - PROCESS | 24057 | 18:50:41 INFO - PROCESS | 24057 | ------- Summary: start ------- 18:50:41 INFO - PROCESS | 24057 | Number of tests: 14 18:50:41 INFO - PROCESS | 24057 | 18:50:41 INFO - PROCESS | 24057 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:3.95 (3.6%) stddev-sans-first:4.19 18:50:41 INFO - PROCESS | 24057 | Values: 109.0 113.0 108.0 112.0 111.0 111.0 99.0 111.0 111.0 110.0 18:50:41 INFO - PROCESS | 24057 | 18:50:41 INFO - PROCESS | 24057 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:152.50 stddev:16.73 (11.0%) stddev-sans-first:17.56 18:50:41 INFO - PROCESS | 24057 | Values: 152.0 125.0 147.0 162.0 123.0 157.0 153.0 135.0 170.0 126.0 18:50:41 INFO - PROCESS | 24057 | 18:50:41 INFO - PROCESS | 24057 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.00 stddev:2.50 (1.6%) stddev-sans-first:2.47 18:50:41 INFO - PROCESS | 24057 | Values: 159.0 161.0 160.0 160.0 168.0 162.0 161.0 163.0 161.0 161.0 18:50:41 INFO - PROCESS | 24057 | 18:50:41 INFO - PROCESS | 24057 | [#3] audio-fft Cycles:10 Average:88.30 Median:73.50 stddev:30.52 (41.5%) stddev-sans-first:31.99 18:50:41 INFO - PROCESS | 24057 | Values: 75.0 73.0 76.0 151.0 74.0 73.0 73.0 73.0 141.0 74.0 18:50:41 INFO - PROCESS | 24057 | 18:50:41 INFO - PROCESS | 24057 | [#4] audio-oscillator Cycles:10 Average:107.80 Median:94.00 stddev:21.39 (22.8%) stddev-sans-first:22.10 18:50:41 INFO - PROCESS | 24057 | Values: 94.0 95.0 135.0 94.0 96.0 95.0 143.0 94.0 94.0 138.0 18:50:41 INFO - PROCESS | 24057 | 18:50:41 INFO - PROCESS | 24057 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 18:50:41 INFO - PROCESS | 24057 | Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 18:50:41 INFO - PROCESS | 24057 | 18:50:41 INFO - PROCESS | 24057 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.41 (1.0%) stddev-sans-first:1.50 18:50:41 INFO - PROCESS | 24057 | Values: 147.0 146.0 147.0 146.0 147.0 148.0 146.0 145.0 148.0 150.0 18:50:41 INFO - PROCESS | 24057 | 18:50:41 INFO - PROCESS | 24057 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 18:50:41 INFO - PROCESS | 24057 | Values: 95.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 18:50:41 INFO - PROCESS | 24057 | 18:50:41 INFO - PROCESS | 24057 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.50 stddev:1.40 (2.6%) stddev-sans-first:1.45 18:50:41 INFO - PROCESS | 24057 | Values: 53.0 55.0 55.0 54.0 55.0 55.0 54.0 54.0 52.0 51.0 18:50:41 INFO - PROCESS | 24057 | 18:50:41 INFO - PROCESS | 24057 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:1.52 (2.3%) stddev-sans-first:1.58 18:50:41 INFO - PROCESS | 24057 | Values: 65.0 66.0 66.0 65.0 66.0 66.0 65.0 65.0 70.0 65.0 18:50:41 INFO - PROCESS | 24057 | 18:50:41 INFO - PROCESS | 24057 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:80.50 stddev:0.95 (1.2%) stddev-sans-first:0.88 18:50:41 INFO - PROCESS | 24057 | Values: 79.0 79.0 81.0 80.0 81.0 80.0 80.0 81.0 80.0 82.0 18:50:41 INFO - PROCESS | 24057 | 18:50:41 INFO - PROCESS | 24057 | [#11] stanford-crypto-ccm Cycles:10 Average:112.20 Median:111.50 stddev:3.74 (3.4%) stddev-sans-first:3.96 18:50:41 INFO - PROCESS | 24057 | Values: 112.0 110.0 119.0 112.0 111.0 111.0 110.0 119.0 109.0 109.0 18:50:41 INFO - PROCESS | 24057 | 18:50:41 INFO - PROCESS | 24057 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.40 Median:142.50 stddev:8.11 (5.7%) stddev-sans-first:8.56 18:50:41 INFO - PROCESS | 24057 | Values: 139.0 127.0 143.0 139.0 135.0 136.0 153.0 142.0 147.0 153.0 18:50:41 INFO - PROCESS | 24057 | 18:50:41 INFO - PROCESS | 24057 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:65.50 stddev:1.42 (2.2%) stddev-sans-first:0.87 18:50:41 INFO - PROCESS | 24057 | Values: 69.0 65.0 65.0 65.0 66.0 66.0 64.0 67.0 65.0 65.0 18:50:41 INFO - PROCESS | 24057 | -------- Summary: end -------- 18:50:41 INFO - PROCESS | 24057 | 18:50:42 INFO - TEST-INFO | 24057: exit 0 18:50:42 INFO - TEST-OK | kraken | took 58327ms 18:50:42 INFO - TEST-START | v8_7 18:50:42 INFO - operating with platform_type : linux_ 18:50:42 INFO - Initialising browser for v8_7 test... 18:50:42 INFO - TEST-INFO | started process 24309 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSKZ0yJ/profile http://localhost:46887/getInfo.html) 18:50:45 INFO - PROCESS | 24309 | __metrics Screen width/height:1600/1200 18:50:45 INFO - PROCESS | 24309 | colorDepth:24 18:50:45 INFO - PROCESS | 24309 | Browser inner width/height: 1024/697 18:50:45 INFO - PROCESS | 24309 | __metrics 18:50:46 INFO - PROCESS | 24309 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:50:47 INFO - TEST-INFO | 24309: exit 0 18:50:47 INFO - Browser initialized. 18:50:47 INFO - Running cycle 1/1 for v8_7 test... 18:50:47 INFO - TEST-INFO | started process 24401 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSKZ0yJ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:50:59 INFO - PROCESS | 24401 | RSS: Main: 137404416 18:50:59 INFO - PROCESS | 24401 | 18:51:21 INFO - PROCESS | 24401 | Cycle 1(1): loaded http://localhost:46887/tests/v8_7/run.html (next: http://localhost:46887/tests/v8_7/run.html) 18:51:21 INFO - PROCESS | 24401 | RSS: Main: 439377920 18:51:21 INFO - PROCESS | 24401 | 18:51:21 INFO - PROCESS | 24401 | __start_tp_report 18:51:21 INFO - PROCESS | 24401 | _x_x_mozilla_page_load 18:51:21 INFO - PROCESS | 24401 | _x_x_mozilla_page_load_details 18:51:21 INFO - PROCESS | 24401 | |i|pagename|runs| 18:51:21 INFO - PROCESS | 24401 | |0;Richards;169.29067208396816 18:51:21 INFO - PROCESS | 24401 | |1;DeltaBlue;172.0578114246387 18:51:21 INFO - PROCESS | 24401 | |2;Encrypt;280.0336040324839 18:51:21 INFO - PROCESS | 24401 | |3;Decrypt;5191.709844559586 18:51:21 INFO - PROCESS | 24401 | |4;RayTrace;953.2888465204957 18:51:21 INFO - PROCESS | 24401 | |5;Earley;575.3739930955121 18:51:21 INFO - PROCESS | 24401 | |6;Boyer;11144.444444444445 18:51:21 INFO - PROCESS | 24401 | |7;RegExp;41000 18:51:21 INFO - PROCESS | 24401 | |8;Splay;505.5611729019211 18:51:21 INFO - PROCESS | 24401 | |9;NavierStokes;4826.923076923077 18:51:21 INFO - PROCESS | 24401 | __end_tp_report 18:51:21 INFO - PROCESS | 24401 | __startTimestamp1455850281635__endTimestamp 18:51:21 INFO - PROCESS | 24401 | 18:51:21 INFO - PROCESS | 24401 | ------- Summary: start ------- 18:51:21 INFO - PROCESS | 24401 | Number of tests: 10 18:51:21 INFO - PROCESS | 24401 | 18:51:21 INFO - PROCESS | 24401 | [#0] Richards Cycles:1 Average:169.29 Median:169.29 stddev:0.00 (0.0%) 18:51:21 INFO - PROCESS | 24401 | Values: 169.3 18:51:21 INFO - PROCESS | 24401 | 18:51:21 INFO - PROCESS | 24401 | [#1] DeltaBlue Cycles:1 Average:172.06 Median:172.06 stddev:0.00 (0.0%) 18:51:21 INFO - PROCESS | 24401 | Values: 172.1 18:51:21 INFO - PROCESS | 24401 | 18:51:21 INFO - PROCESS | 24401 | [#2] Encrypt Cycles:1 Average:280.03 Median:280.03 stddev:0.00 (0.0%) 18:51:21 INFO - PROCESS | 24401 | Values: 280.0 18:51:21 INFO - PROCESS | 24401 | 18:51:21 INFO - PROCESS | 24401 | [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 18:51:21 INFO - PROCESS | 24401 | Values: 5191.7 18:51:21 INFO - PROCESS | 24401 | 18:51:21 INFO - PROCESS | 24401 | [#4] RayTrace Cycles:1 Average:953.29 Median:953.29 stddev:0.00 (0.0%) 18:51:21 INFO - PROCESS | 24401 | Values: 953.3 18:51:21 INFO - PROCESS | 24401 | 18:51:21 INFO - PROCESS | 24401 | [#5] Earley Cycles:1 Average:575.37 Median:575.37 stddev:0.00 (0.0%) 18:51:21 INFO - PROCESS | 24401 | Values: 575.4 18:51:21 INFO - PROCESS | 24401 | 18:51:21 INFO - PROCESS | 24401 | [#6] Boyer Cycles:1 Average:11144.44 Median:11144.44 stddev:0.00 (0.0%) 18:51:21 INFO - PROCESS | 24401 | Values: 11144.4 18:51:21 INFO - PROCESS | 24401 | 18:51:21 INFO - PROCESS | 24401 | [#7] RegExp Cycles:1 Average:41000.00 Median:41000.00 stddev:0.00 (0.0%) 18:51:21 INFO - PROCESS | 24401 | Values: 41000.0 18:51:21 INFO - PROCESS | 24401 | 18:51:21 INFO - PROCESS | 24401 | [#8] Splay Cycles:1 Average:505.56 Median:505.56 stddev:0.00 (0.0%) 18:51:21 INFO - PROCESS | 24401 | Values: 505.6 18:51:21 INFO - PROCESS | 24401 | 18:51:21 INFO - PROCESS | 24401 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 18:51:21 INFO - PROCESS | 24401 | Values: 4826.9 18:51:21 INFO - PROCESS | 24401 | -------- Summary: end -------- 18:51:21 INFO - PROCESS | 24401 | 18:51:22 INFO - TEST-INFO | 24401: exit 0 18:51:22 INFO - TEST-OK | v8_7 | took 40241ms 18:51:22 INFO - SUITE-END | took 1209s 18:51:22 INFO - Completed test suite (00:20:09) 18:51:22 INFO - Working with test: dromaeo_css 18:51:22 INFO - Generating results file: dromaeo_css 18:51:22 INFO - Working with test: kraken 18:51:22 INFO - Generating results file: kraken 18:51:22 INFO - javascript benchmark 18:51:22 INFO - Working with test: v8_7 18:51:22 INFO - Generating results file: v8_7 18:51:22 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:51:22 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 18:51:22 INFO - process_Request line: dromaeo_css 7193.29 graph.html#tests=[[72,52,35]] 18:51:22 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:51:22 INFO - process_Request line: kraken 1483.40 graph.html#tests=[[232,52,35]] 18:51:22 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:51:22 INFO - process_Request line: v8_7 21815.02 graph.html#tests=[[230,52,35]] 18:51:22 INFO - RETURN: dromaeo_css: 7193.29 18:51:22 INFO - RETURN: kraken: 1483.40 18:51:22 INFO - RETURN: v8_7: 21815.02 18:51:22 INFO - javascript benchmark 18:51:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3209.6308924473683, 3274.3451309738057, 3295.143262751684, 3299.307145499445, 3324.5179448979893, 5268.631195816294, 5269.262303277535, 5279.234510995903, 5281.841544753659, 5300.231466437364, 5273.920891186635, 5276.551493123079, 5297.0, 5306.124489459245, 5349.5720342372615, 4774.474807771142, 4816.133096042711, 4817.638677099214, 4846.151923413407, 4899.363082799231, 4818.0, 4851.63612729045, 4859.514048595148, 4860.489648586883, 4863.975680121612, 4762.357081793948, 4802.615790736732, 4850.345203397532, 4865.489123642002, 4869.659123861331, 4791.976040119812, 4838.201696720054, 4885.120678277908, 4911.533404326619, 4935.728534930578, 4834.081524510332, 4836.564709176156, 4836.709797412132, 4840.661153719241, 4864.051509955525, 4999.475055119233, 5069.721165335905, 5093.643444958854, 5108.770105345268, 5162.612804039674, 5581.134924086773, 5676.0, 5683.9715801420725, 5685.346185188673, 5686.0617998030275, 5683.914741278884, 5702.3157221133315, 5706.457886500776, 5722.113072473731, 5733.082706766897, 5201.089809283398, 5226.660267082628, 5320.52115309624, 5401.7029063401105, 5417.945820541823, 5760.0, 5775.133729940542, 5790.623609465371, 5792.623479473821, 5827.35899051104, 5465.180222966586, 5514.972425137848, 5524.723763811793, 5529.944700553024, 5531.0, 5620.803271885465, 5698.601097923189, 5782.710864456844, 5783.074708046693, 5798.449147330997, 5587.189857470644, 5590.776368945197, 5600.411956744483, 5608.327000759935, 5617.185508101303, 5498.422665620133, 5586.469285417878, 5587.3015873015875, 5592.217089607459, 5599.608027438122, 4341.804618792162, 4343.283358245917, 4370.125974804988, 4379.715318504287, 4381.890452738643, 3902.902427439337, 3970.0273433009097, 3974.264761019163, 3977.284088864032, 3979.621935916083, 5287.735613219324, 5296.1261391870685, 5298.470152984748, 5312.282841816305, 5313.840584782462, 5651.519620832193, 5654.15187721845, 5656.434356564393, 5660.405657405995, 5661.34894487131, 5200.739963001834, 5221.503957124067, 5229.0, 5261.605379596545, 5297.576193904479, 4890.633202509826, 4901.411830580282, 4905.288733133747, 4908.165611845995, 4933.28467372229, 5717.685527295956, 5776.393478684761, 5850.531957443394, 5854.824355269264, 5862.237909071879, 5572.498475137176, 5576.358718747396, 5621.072523033654, 5641.125625527886, 5679.346875109415, 5770.5095066919785, 5790.276215473066, 5790.971045144747, 5801.767929282782, 5806.390329015561, 5523.613347065667, 5569.275994120739, 5573.024720673947, 5579.804706835242, 5599.80400685974, 5556.444355564411, 5589.385167631639, 5598.664080155204, 5598.720063996865, 5629.605927585029, 5449.100898351886, 5476.561875049907, 5482.616216864782, 5482.753276102505, 5499.340079190522, 5447.264619276347, 5504.311961004874, 5520.282363292747, 5528.55771538284, 5547.583931205095, 5511.862203444946, 5516.089845175501, 5516.972415137899, 5519.0, 5522.3649280333275, 5546.334439867242, 5566.053770858883, 5582.0, 5591.4688104629995, 5604.887902242014, 5348.57211423093, 5418.512333889968, 5431.0, 5485.670859748428, 5510.476504732044], "unit": "score", "name": "dojo.html", "value": 5221.311077139223}, {"lowerIsBetter": false, "replicates": [556.0602581637033, 561.3460318728681, 578.0693084134542, 582.1093726598306, 589.172213040678, 30581.54127688084, 31377.686223137764, 38898.41652375213, 39497.21005579887, 39690.20619587607, 44437.55562444375, 45243.77378113105, 45281.320780188325, 45319.54680453194, 45423.0, 8879.511626860536, 9194.678186263482, 9195.632174713037, 9197.678081267157, 9201.17189452949, 8889.866652000224, 9041.593128309209, 9045.864312035324, 9047.0, 9052.456852588833, 8979.595918183664, 9074.500902450363, 9075.500847453388, 9075.95462022689, 9080.318976076787, 8945.597448114819, 8988.146126118008, 9017.053209413049, 9024.368294219406, 9027.548622568878, 8893.644254229823, 9006.0, 9011.459312441275, 9016.909830901739, 9043.502607356593, 42026.0, 42547.57452425467, 42551.57448425507, 42632.57367426317, 42660.3600945983, 3672.6143754905615, 3800.904977375588, 3944.3886197639413, 4269.829206831723, 4335.739855608642, 32271.51592726111, 32573.348533029442, 32778.508322375186, 32888.835555822305, 33048.50427243593, 4363.454568178978, 4380.763342027689, 4395.824167033315, 4412.977935110336, 4431.357453169272, 215271.0, 217419.0, 217924.0, 218259.0, 302158.0, 46471.5352846474, 46732.29901551479, 63329.68335158295, 65165.67417162884, 65227.0, 59122.704386477795, 59264.703676482204, 59564.0, 59643.0, 59659.70170149121, 16791.91604041972, 17125.314987400365, 17775.111244437725, 18367.72448413275, 18380.0, 13986.370613322424, 14342.49801256951, 14349.0, 14365.856341436453, 14366.35351409189, 20430.489237768878, 20745.585088298452, 20780.0, 20814.0, 20825.79174208269, 8046.879296810553, 8200.138985406566, 8354.164583541718, 8355.415120941476, 8372.162783721578, 1146.8165093584987, 1157.7047852797482, 1168.2347614522191, 1212.53923509066, 1273.9680858504455, 30298.394032119235, 30847.691523084482, 31166.532502012487, 31473.0, 31637.8418107908, 1160.9593664221882, 1167.7255844876447, 1214.969625759363, 1221.8106193540016, 1274.5220542296638, 14349.426022958965, 14652.19412932299, 14743.115413075035, 16433.506994790176, 16658.0, 353694.0, 356590.0, 356995.0, 357137.0, 357361.0, 56850.715746421, 56892.71553642288, 57100.0, 57108.0, 57135.0, 1464.670449148933, 1465.8680718735152, 1466.5380405172336, 1482.0737039350406, 1486.6283429142713, 31316.843415782776, 31352.37295254128, 31783.52324715085, 31835.0, 31840.68159318377, 49761.50238497568, 50177.49822501728, 50225.0, 50307.49692503028, 50312.748436257585, 351246.0, 352517.0, 353350.0, 353367.0, 354196.0, 29130.56304155482, 29678.70321296846, 33015.33969320648, 33462.16344591405, 33942.83028584841, 39311.21377572375, 39808.60191398165, 39896.80051599723, 40960.18079638331, 41066.58933410628, 33946.32107357888, 34281.82859085689, 34334.48498272578, 34633.134171645914, 34672.82663586666, 30859.691403085682, 33952.15119622029, 36438.0, 36606.45090323594, 37027.25945481021, 36421.0, 36692.81653591822, 36820.26359472742, 39937.2012559753, 40625.39061914015, 30261.243468913453, 31040.844795775876, 31907.202319942186, 31926.84036579895, 32003.039908802773, 25630.359241019123, 26554.203373898814, 26844.865775670998, 27575.862120689268, 28816.0], "unit": "score", "name": "ext.html", "value": 19497.606804266157}, {"lowerIsBetter": false, "replicates": [391.67099636305505, 394.1545385148856, 395.13465510531915, 396.0633102712085, 403.54802621064414, 14024.439022439115, 14056.437742490314, 16489.42287019953, 18883.33908313211, 19036.524086897836, 14769.778453323182, 17212.741808872877, 17584.64830703385, 18049.278028878864, 18055.729164062548, 5298.4436634153435, 5544.750486228119, 5575.080111781572, 5578.972105139469, 5583.944160558403, 4157.6466000389855, 4281.807318670667, 5511.200875872996, 5571.470710282517, 6043.274807023164, 5963.314218864821, 6150.169727086831, 6220.968895155518, 6221.191245138126, 6223.2532096148525, 6006.159137720722, 6008.489278411296, 6032.909506357364, 6060.909086363708, 6066.757329706807, 5256.053910296145, 5363.570914326844, 5379.139337705988, 5379.892402151974, 5385.111456609655, 19961.700574491395, 21109.0, 21275.574488510298, 21518.462038449008, 21523.246686365903, 1725.0, 2220.3449982255274, 2416.4683769570843, 2505.899764009456, 2582.4447743735186, 10091.29360944734, 10397.896021039769, 10446.216533759998, 11234.0, 13661.726765464635, 1937.0798870536523, 1954.9413517594494, 1983.6231116087897, 2002.3092033248506, 2010.7989201079774, 54054.72972635151, 57467.40260779128, 58834.0, 60084.69957650184, 60226.39773602252, 10302.793944121076, 10405.53175107122, 10458.895411045944, 10761.30051546647, 10788.946055269673, 13939.512117075854, 14156.079854809404, 14170.504032358818, 14189.503367382093, 14195.78706319406, 8329.125441828643, 8483.74548763538, 8511.74464766058, 8536.402451828437, 8553.101924297984, 8319.958400208081, 8362.0, 8391.202835730595, 8404.747857564284, 8418.0, 4648.7443190624845, 4769.928451073237, 4794.7842347094465, 4795.424549054136, 4829.975850120797, 1742.310072611992, 1802.2880962019929, 1843.972340414895, 1930.4015755115959, 1942.786293507713, 1045.8378951262566, 1076.2036093290908, 1117.6535274065066, 1138.7153211697075, 1166.6150170443734, 13502.797458037941, 16460.506184814476, 17579.384721534683, 17893.910530447265, 17917.05233355279, 1043.3270540501335, 1064.5688496159069, 1070.8714954205545, 1090.9672709818717, 1125.0886781706843, 9566.378185417925, 9985.30102892805, 10052.74868128288, 10747.570097196181, 10916.836247456295, 558042.0, 559397.0, 561420.0, 571453.0, 624670.0, 75466.62266688631, 76877.0, 77452.22547774563, 77704.61147694338, 78272.60863695644, 1012.6152062216311, 1043.1706793099504, 1045.6183493024992, 1113.5156207049959, 1193.3913704011018, 15092.320845561757, 16036.11801350937, 16077.919610401874, 16250.67498650044, 16253.349866005701, 30867.213139320662, 33526.66473335236, 34712.0, 35134.0, 35219.823900881354, 41921.580784192985, 42046.0, 42163.7891810539, 42651.0, 42871.3569296467, 7874.21257874208, 8024.919750802417, 8033.638486268015, 8076.515409075474, 8176.918230817853, 10974.561017559208, 11609.3614851184, 12133.21134126279, 12389.814152787536, 12704.428300726304, 10514.684559463229, 10672.413017284123, 10851.40317282557, 10942.835857462303, 11139.610113645984, 10572.207084468542, 10722.624708135178, 10736.516856741622, 10768.569257229936, 10809.621663241749, 7455.5294679453755, 8750.0, 9780.119789219005, 10373.170146388422, 10374.481275936323, 7343.632818358954, 7579.393648508217, 7719.807004824925, 7733.458657894119, 7772.106207786177, 9266.953665231631, 10416.843747343644, 10782.245242832927, 11007.889921100686, 11018.283811552223], "unit": "score", "name": "jquery.html", "value": 8707.682589092583}, {"lowerIsBetter": false, "replicates": [1471.8086648735664, 1523.3678023620198, 1575.3383578896867, 1771.1675512509116, 1875.840553552948, 7407.962960185198, 8097.47366421183, 8226.136255693156, 8235.670573177065, 8245.587720613976, 8171.142030086845, 8252.91747082529, 8340.708075217368, 8346.666133354658, 8352.20654037867, 2168.7831216878344, 2215.925276241022, 2420.8063354931564, 2478.7893029092547, 2516.0313279387383, 2468.123816045305, 2471.369800700819, 2480.615504596781, 2492.0654754467073, 2512.133314006665, 2458.0659349447187, 2479.6280557916366, 2484.9378765530823, 2489.576771948764, 2492.252324302711, 2415.9637605435933, 2459.7048354197523, 2460.815438842094, 2479.776820086201, 2481.689788776394, 2435.683361163055, 2447.9510409791883, 2449.314192026218, 2466.7163276223287, 2472.2336075816374, 8508.78728031798, 8598.742037738877, 8601.22588966996, 8609.655613775441, 8621.482711037295, 5161.690298582097, 5285.788568457296, 5331.573474122061, 5335.439778823245, 5338.572914166896, 3363.1760218746317, 3365.1082463147286, 3516.244007538366, 3528.7177025837873, 3560.3769340365334, 1101.509828126484, 1110.4725255503652, 1130.37829193943, 1158.94205289736, 1183.0594677231536, 12161.635150945485, 12232.388380581024, 12239.265644061385, 12239.632811015685, 12282.0, 4789.185838407479, 4801.159797035574, 4830.9275360869615, 4840.419149702058, 4959.776810043557, 10377.481125943672, 10382.532786024647, 10395.16838652906, 10402.5838966442, 10409.635662751918, 5241.266222728821, 5286.15421532553, 5288.7355632219005, 5291.153415453586, 5297.576193904479, 4734.313524538922, 4782.0, 4785.449673287547, 4788.760561971888, 4794.832180873653, 4186.497620285585, 4189.07840275139, 4205.600467955539, 4238.0252541914915, 4252.085801552681, 1349.7165595224917, 1363.9931800341133, 1367.4803574641574, 1383.875451209396, 1393.2546087842954, 1433.333499922541, 1447.5729659750398, 1470.7132109238596, 1475.2328789029646, 1485.5172069077594, 7989.800254993672, 8032.718854840053, 8035.196480351918, 8036.839263214703, 8043.19568043191, 532.0741909078254, 539.981100661475, 541.9132938729784, 543.1391244876914, 543.2014938041074, 6180.752769889244, 6205.28639206488, 6209.720562574605, 6215.844603884849, 6216.44052035319, 10456.73858153537, 10659.73350666224, 10766.73083172927, 10772.030517253328, 10775.94612026935, 10423.061924426838, 10534.631287904887, 10702.946485267525, 10705.036546710833, 10720.195985300978, 8130.715424960098, 8151.551664658382, 8169.673213071529, 8251.546164960864, 8262.132476090044, 7797.337226335825, 7948.920510794818, 7961.323287520626, 7990.280874721303, 8047.195280471906, 9314.580843861906, 9385.249180065715, 9427.15155635996, 9433.716988490356, 9680.564374603018, 9514.238860890973, 9731.075547822946, 9740.025997400488, 9880.258980576342, 9976.850347244652, 6770.1537307836525, 6902.0, 6976.19773726028, 7133.85732285341, 7178.138623365229, 7858.685652574061, 7882.093559240531, 7889.526628402315, 7912.248336408032, 7917.802054948673, 7021.1574611047, 7254.528455650366, 7373.705051797868, 7429.925700742923, 7587.089549254125, 7316.304951029643, 7411.370033546993, 7420.295071968154, 7499.925000749922, 7521.360684341892, 7525.849483010418, 7571.3942884568005, 7577.772666820004, 7583.203763604963, 7592.278733520307, 6962.060121883481, 6967.477439191979, 7004.544704594185, 7149.034880291302, 7152.785416437515, 7129.857402851811, 7189.820254493679, 7190.245024272376, 7192.784216473514, 7196.820079498055], "unit": "score", "name": "mootools.html", "value": 4848.354598190998}, {"lowerIsBetter": false, "replicates": [374.66093185666966, 377.1965713031243, 377.2511564544379, 380.950476438063, 388.9416587511871, 5820.767169313222, 5905.084711869662, 5936.139259807331, 5946.672932988684, 5972.163897054415, 5808.0, 5922.881542369161, 5937.6140550864275, 5938.732757025933, 5943.197668314776, 4668.766561671911, 4679.391679081715, 4682.555157260055, 4689.88275293117, 4690.061987602493, 4431.64546836254, 4488.304312831517, 4506.391637128979, 4594.74728889911, 4683.08679807436, 4557.772111394417, 4593.586577208051, 4601.240795268776, 4601.884952876188, 4613.976930115362, 4608.446986361624, 4638.884027899296, 4655.86032419028, 4667.603253723438, 4672.672912896099, 4152.397902304149, 4166.749995000309, 4168.541460439349, 4186.518550366716, 4187.958120418818, 5563.443655634444, 5653.123765816264, 5665.093585026376, 5677.744501497443, 5677.772889084432, 5376.709589698483, 5441.129419292894, 5445.1832225166145, 5445.891082178374, 5455.0453670607485, 6029.969850150721, 6228.626282423069, 6235.345288744662, 6296.590721603081, 6310.148130002437, 4502.797374118172, 4547.067851090552, 4614.3770590970125, 4624.884377890546, 4635.817866444069, 6529.575577587441, 6530.379613936669, 6552.213734351861, 6562.67186640666, 6567.0, 4726.196546587088, 4726.456457507362, 4733.455652599926, 4738.336632871401, 4738.8341408050555, 4738.739369334719, 4769.689970151929, 4795.520447955177, 4812.951870481251, 4818.783154757974, 5406.107992181324, 5417.810376636878, 5420.403755586883, 5424.105022671294, 5424.810131645373, 6312.558120931582, 6319.146915166486, 6331.271903731038, 6333.429991300805, 6342.429181373698, 1683.4697070422778, 1708.2569082448927, 1709.119803301276, 1709.3675340124234, 1713.5373449168655, 1101.251149218523, 1136.5169802833764, 1149.5689116581282, 1197.1141355397117, 1220.0910321810131, 5956.970215148983, 6047.818565443044, 6079.513638908877, 6086.969565152146, 6089.238845144357, 6482.611043337415, 6503.577267477599, 6514.902276465857, 6517.185351831021, 6519.185101862267, 5962.195103661037, 6070.3929607038945, 6081.726322315418, 6084.726187321581, 6086.513078953673, 3483.1292176955762, 3515.5078289039557, 3518.1556426457464, 3518.82405879705, 3522.682958533744, 6661.600303981777, 6666.200055993312, 6674.933250667528, 6680.064790929274, 6684.6991885364305, 6535.313792051861, 6639.336066393322, 6649.867002659919, 6652.567583107082, 6662.233843108008, 6634.668266586651, 6653.700583473756, 6654.068430419745, 6662.200535935719, 6664.8000559983275, 6343.714532845941, 6469.547131700736, 6481.027845823164, 6486.740530378732, 6499.837504062247, 6461.838454038687, 6467.320931302145, 6483.708233129615, 6489.286178520453, 6490.935090649033, 6711.865762684816, 6742.662866856539, 6757.0, 6758.797236082925, 6759.425448836904, 4531.3429552714015, 4642.6750127492105, 4643.233866412139, 4656.371389862461, 4658.86023419298, 6517.283098859217, 6548.410643042149, 6559.6064236145985, 6560.3111673273615, 6564.37638424368, 6334.493240540838, 6339.587926784744, 6412.935870641234, 6419.0, 6423.389777971085, 6274.937250627618, 6381.329960354282, 6383.202099737533, 6384.936150638434, 6398.264199616918, 6248.875022499616, 6258.186435763321, 6302.590331628429, 6319.304876463677, 6341.397567231105, 6413.551051426355, 6414.486841052611, 6419.55063145594, 6420.101185833893, 6427.3251308611925, 6128.816135515942, 6264.718087685974, 6269.777393408424, 6293.056041593798, 6312.400321969406], "unit": "score", "name": "prototype.html", "value": 4848.579479418249}, {"lowerIsBetter": false, "replicates": [814.8411059843332, 822.6133717152939, 844.1895780051146, 869.0744357259518, 872.7163671806665, 14161.858381416196, 14552.345144468498, 14604.853951460482, 15067.472638457657, 15348.0, 15032.473863414783, 15154.318055687492, 15165.696686066272, 15166.393344266244, 15176.544703658881, 758.0448634720237, 766.2988365645456, 910.4173329069384, 912.5893347993397, 925.8888933327977, 916.9220616247627, 921.1295325917011, 921.9308551858604, 923.2660035271941, 925.676013395313, 956.1585804492038, 964.7588102974256, 965.6089283840056, 966.3718582921088, 966.9081437263449, 782.3819182845546, 790.4466873188762, 937.5265490927106, 950.8098380323963, 954.2747511891013, 704.9753258635974, 705.2524324216347, 706.4101475268158, 706.4948561778302, 706.6290197646225, 14437.927810360987, 14463.638409039753, 14542.0, 14580.343884525222, 14585.416583336653, 11865.110116741193, 12116.636500904988, 12728.109032367738, 12936.805947910789, 13093.47626094955, 10229.641962531276, 10528.0, 10621.681349559525, 10635.46822658864, 10663.200259980455, 3439.1917899293644, 3450.189205536697, 3479.4085005548864, 3484.9651503484893, 3495.405781017233, 51407.74296128533, 51674.48325516772, 51742.0, 51804.481955180345, 52025.0, 10113.64602238918, 10203.234757393077, 10239.18086553074, 10515.684529464128, 10524.526396312185, 18955.526111847314, 19059.332923347618, 19234.8076519233, 19287.035648217534, 19305.710414343797, 7898.644560994769, 7913.0, 8021.679132834622, 8059.919400806034, 8238.09380968093, 4478.541981346034, 4568.451785785727, 4578.88552786183, 4619.46876109245, 4669.673122881366, 3137.30979184579, 3158.463061279588, 3174.333389988082, 3178.570892929471, 3189.1389324882152, 597.5189972072436, 602.3705228036712, 605.3008774865037, 608.0817964873073, 614.640435345319, 549.9505044546011, 632.4063360331937, 662.0532638327238, 696.7909627111846, 710.2187593646947, 9025.458472491671, 9272.629094836131, 9572.282078844115, 9573.856392154123, 9954.552045157985, 602.4577879908118, 606.1725744358919, 644.6228956060756, 646.747768370336, 755.524019867491, 4233.534311225762, 4530.728156310632, 4560.475545312332, 4565.543445655474, 4573.6569757268335, 58444.0, 58552.707236463546, 59202.40797591969, 59261.70369148126, 62333.68833155896, 49293.75353123283, 50249.0, 50536.49463505392, 50813.23780143227, 51364.22953655698, 46402.303965440544, 47247.29129063067, 47490.525094749304, 47994.0, 48838.75580622074, 8818.338624603308, 9152.313576481658, 9281.953590232006, 9334.159925606727, 9354.579043942902, 35035.0, 35575.644243558265, 35738.10654733652, 36018.27963440769, 36383.0, 43024.0, 43398.56601433945, 44448.33327500155, 45296.0, 46032.309515356625, 11171.832422513506, 11382.94308528452, 11595.594154204562, 11597.76804463923, 11807.350595716975, 12868.806967895676, 13010.349482525646, 13015.088943773844, 13103.672408189872, 13163.60509184726, 12110.75778484443, 12121.0, 12168.08739344535, 12204.0, 12654.936725316315, 11584.652460426201, 11724.648260552198, 11729.765404692029, 11839.230450020721, 12018.699532511757, 11905.345206013752, 11941.82087268709, 12213.877861221274, 12230.816537751763, 12400.19398739079, 8920.152585504367, 9023.909760902307, 9788.412695238309, 9879.357841740264, 10016.098551130433, 9923.702288931056, 10023.298369114093, 10024.359930400198, 10064.69805905824, 10490.790184196427], "unit": "score", "name": "yui.html", "value": 6647.43884700854}], "name": "dromaeo_css", "value": 7193.286804011509}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 113.0, 108.0, 112.0, 111.0, 111.0, 99.0, 111.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.5}, {"lowerIsBetter": true, "replicates": [152.0, 125.0, 147.0, 162.0, 123.0, 157.0, 153.0, 135.0, 170.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 145.0}, {"lowerIsBetter": true, "replicates": [159.0, 161.0, 160.0, 160.0, 168.0, 162.0, 161.0, 163.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 76.0, 151.0, 74.0, 73.0, 73.0, 73.0, 141.0, 74.0], "unit": "score", "name": "audio-fft", "value": 88.3}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 135.0, 94.0, 96.0, 95.0, 143.0, 94.0, 94.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 107.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 146.0, 147.0, 148.0, 146.0, 145.0, 148.0, 150.0], "unit": "score", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [53.0, 55.0, 55.0, 54.0, 55.0, 55.0, 54.0, 54.0, 52.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 53.8}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 66.0, 65.0, 66.0, 66.0, 65.0, 65.0, 70.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.9}, {"lowerIsBetter": true, "replicates": [79.0, 79.0, 81.0, 80.0, 81.0, 80.0, 80.0, 81.0, 80.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.3}, {"lowerIsBetter": true, "replicates": [112.0, 110.0, 119.0, 112.0, 111.0, 111.0, 110.0, 119.0, 109.0, 109.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 112.2}, {"lowerIsBetter": true, "replicates": [139.0, 127.0, 143.0, 139.0, 135.0, 136.0, 153.0, 142.0, 147.0, 153.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.4}, {"lowerIsBetter": true, "replicates": [69.0, 65.0, 65.0, 65.0, 66.0, 66.0, 64.0, 67.0, 65.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.7}], "name": "kraken", "value": 1483.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.29067208396816], "unit": "score", "name": "Richards", "value": 208.5289139999999}, {"lowerIsBetter": false, "replicates": [172.0578114246387], "unit": "score", "name": "DeltaBlue", "value": 384.2778159999999}, {"lowerIsBetter": false, "replicates": [280.0336040324839], "unit": "score", "name": "Encrypt", "value": 950.5323509999997}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [953.2888465204957], "unit": "score", "name": "RayTrace", "value": 776.2484609999998}, {"lowerIsBetter": false, "replicates": [575.3739930955121], "unit": "score", "name": "Earley", "value": 1158.312694}, {"lowerIsBetter": false, "replicates": [11144.444444444445], "unit": "score", "name": "Boyer", "value": 59.80226321036885}, {"lowerIsBetter": false, "replicates": [41000.0], "unit": "score", "name": "RegExp", "value": 22.219146341463418}, {"lowerIsBetter": false, "replicates": [505.5611729019211], "unit": "score", "name": "Splay", "value": 161.18919799999998}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 21815.023973048723}]} 18:51:22 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "21815.02"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1483.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7193.29"}}} 18:51:23 INFO - Return code: 0 18:51:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 18:51:23 INFO - # TBPL SUCCESS # 18:51:23 INFO - Running post-action listener: _resource_record_post_action 18:51:23 INFO - Running post-run listener: _resource_record_post_run 18:51:24 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 0; Write bytes: 500658176; Read time: 0; Write time: 503604 18:51:24 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 241569792; Read time: 0; Write time: 323428 18:51:24 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 259088384; Read time: 0; Write time: 180176 18:51:24 INFO - Running post-run listener: _upload_blobber_files 18:51:24 INFO - Blob upload gear active. 18:51:24 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 18:51:24 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 18:51:24 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', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 18:51:24 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 Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 18:51:24 INFO - (blobuploader) - INFO - Open directory for files ... 18:51:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:51:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:51:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:51:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:51:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:51:25 INFO - (blobuploader) - INFO - Done attempting. 18:51:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 18:51:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:51:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:51:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:51:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:51:26 INFO - (blobuploader) - INFO - Done attempting. 18:51:26 INFO - (blobuploader) - INFO - Iteration through files over. 18:51:26 INFO - Return code: 0 18:51:26 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 18:51:26 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 18:51:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c4f94381ca29a268a9045324a9df74ea5dfe02f55918fe2e160538b386ec4e339e311c2962f83da9ea10aa1df6c39115a1172fe1436150f2a403843a1882cb81", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3fe0af9c68a667fe146e8a4927f3632695aff5aa862cd67d327d76d0a7155d677dae33bc8785195d8b02381c8beecf6da35b3c6533d9af82571bc603e07d14fd"} 18:51:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 18:51:26 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 18:51:26 INFO - Contents: 18:51:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c4f94381ca29a268a9045324a9df74ea5dfe02f55918fe2e160538b386ec4e339e311c2962f83da9ea10aa1df6c39115a1172fe1436150f2a403843a1882cb81", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3fe0af9c68a667fe146e8a4927f3632695aff5aa862cd67d327d76d0a7155d677dae33bc8785195d8b02381c8beecf6da35b3c6533d9af82571bc603e07d14fd"} 18:51:26 INFO - Running post-run listener: copy_logs_to_upload_dir 18:51:26 INFO - Copying logs to upload dir... 18:51:26 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 18:51:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.562305 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-02-18 18:51:26.067506) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-18 18:51:26.070645) ========= 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=523ca41ca1e0623de333ad52000001bf-1455847872.916573-726376969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c4f94381ca29a268a9045324a9df74ea5dfe02f55918fe2e160538b386ec4e339e311c2962f83da9ea10aa1df6c39115a1172fe1436150f2a403843a1882cb81", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3fe0af9c68a667fe146e8a4927f3632695aff5aa862cd67d327d76d0a7155d677dae33bc8785195d8b02381c8beecf6da35b3c6533d9af82571bc603e07d14fd"} build_url:https://queue.taskcluster.net/v1/task/BFP3B-vnSfSY8H3ErDWIcg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011438 build_url: 'https://queue.taskcluster.net/v1/task/BFP3B-vnSfSY8H3ErDWIcg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c4f94381ca29a268a9045324a9df74ea5dfe02f55918fe2e160538b386ec4e339e311c2962f83da9ea10aa1df6c39115a1172fe1436150f2a403843a1882cb81", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3fe0af9c68a667fe146e8a4927f3632695aff5aa862cd67d327d76d0a7155d677dae33bc8785195d8b02381c8beecf6da35b3c6533d9af82571bc603e07d14fd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-18 18:51:26.096921) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 18:51:26.097345) ========= 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=523ca41ca1e0623de333ad52000001bf-1455847872.916573-726376969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 18:51:26.179818) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-18 18:51:26.180133) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-18 18:51:26.180426) ========= ========= Total master_lag: 0.30 =========