builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-046 starttime: 1456986244.85 results: success (0) buildid: 20160302194021 builduid: 04660a1bc8e94644af0d37813fd9b593 revision: 0bee186afe5ab070ca8adbba46bcea934adbb254 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 22:24:04.847804) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 22:24:04.848250) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-02 22:24:04.848540) ========= 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=652eb03db935cfc1c15ebda0000001ad-1456986244.149091-425265301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006328 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-02 22:24:04.870749) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-02 22:24:04.871036) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-02 22:24:04.883957) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 22:24:04.884215) ========= 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=652eb03db935cfc1c15ebda0000001ad-1456986244.149091-425265301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004596 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 22:24:04.932599) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 22:24:04.932876) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 22:24:04.933221) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 22:24:04.933494) ========= 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=652eb03db935cfc1c15ebda0000001ad-1456986244.149091-425265301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-02 22:24:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-03-02 22:24:05 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.139635 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 22:24:05.085263) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 22:24:05.085584) ========= 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=652eb03db935cfc1c15ebda0000001ad-1456986244.149091-425265301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022647 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 22:24:05.134611) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-02 22:24:05.134951) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0bee186afe5ab070ca8adbba46bcea934adbb254 --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 0bee186afe5ab070ca8adbba46bcea934adbb254 --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=652eb03db935cfc1c15ebda0000001ad-1456986244.149091-425265301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-02 22:24:05,224 truncating revision to first 12 chars 2016-03-02 22:24:05,224 Setting DEBUG logging. 2016-03-02 22:24:05,224 attempt 1/10 2016-03-02 22:24:05,224 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0bee186afe5a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-02 22:24:06,231 unpacking tar archive at: mozilla-aurora-0bee186afe5a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.299853 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-02 22:24:06.447464) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 22:24:06.447816) ========= echo 0bee186afe5ab070ca8adbba46bcea934adbb254 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'0bee186afe5ab070ca8adbba46bcea934adbb254'] 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=652eb03db935cfc1c15ebda0000001ad-1456986244.149091-425265301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 0bee186afe5ab070ca8adbba46bcea934adbb254 program finished with exit code 0 elapsedTime=0.004203 script_repo_revision: '0bee186afe5ab070ca8adbba46bcea934adbb254' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 22:24:06.497682) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 22:24:06.498043) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 22:24:06.507570) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-03-02 22:24:06.507839) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=652eb03db935cfc1c15ebda0000001ad-1456986244.149091-425265301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:24:06 INFO - MultiFileLogger online at 20160302 22:24:06 in /builds/slave/test-pgo 22:24:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 22:24:06 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:24:06 INFO - {'append_to_log': False, 22:24:06 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:24:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 22:24:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:24:06 INFO - 'branch': 'Mozilla-Aurora', 22:24:06 INFO - 'buildbot_json_path': 'buildprops.json', 22:24:06 INFO - 'config_files': ('talos/linux_config.py',), 22:24:06 INFO - 'default_actions': ('clobber', 22:24:06 INFO - 'read-buildbot-config', 22:24:06 INFO - 'download-and-extract', 22:24:06 INFO - 'populate-webroot', 22:24:06 INFO - 'create-virtualenv', 22:24:06 INFO - 'install', 22:24:06 INFO - 'run-tests'), 22:24:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:24:06 INFO - 'download_minidump_stackwalk': True, 22:24:06 INFO - 'download_symbols': 'ondemand', 22:24:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:24:06 INFO - 'tooltool.py': '/tools/tooltool.py', 22:24:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:24:06 INFO - '/tools/misc-python/virtualenv.py')}, 22:24:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:24:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:24:06 INFO - 'installer_path': 'installer.exe', 22:24:06 INFO - 'log_level': 'info', 22:24:06 INFO - 'log_name': 'talos', 22:24:06 INFO - 'log_to_console': True, 22:24:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:24:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:24:06 INFO - 'opt_config_files': (), 22:24:06 INFO - 'pip_index': False, 22:24:06 INFO - 'sps_profile': False, 22:24:06 INFO - 'sps_profile_interval': 0, 22:24:06 INFO - 'suite': 'dromaeojs-e10s', 22:24:06 INFO - 'system_bits': '32', 22:24:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:24:06 INFO - 'title': 'talos-linux64-ix-046', 22:24:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:24:06 INFO - 'use_talos_json': True, 22:24:06 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:24:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:24:06 INFO - 'work_dir': 'build'} 22:24:06 INFO - ##### 22:24:06 INFO - ##### Running clobber step. 22:24:06 INFO - ##### 22:24:06 INFO - Running pre-action listener: _resource_record_pre_action 22:24:06 INFO - Running main action method: clobber 22:24:06 INFO - rmtree: /builds/slave/test-pgo/build 22:24:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:24:07 INFO - Running post-action listener: _resource_record_post_action 22:24:07 INFO - ##### 22:24:07 INFO - ##### Running read-buildbot-config step. 22:24:07 INFO - ##### 22:24:07 INFO - Running pre-action listener: _resource_record_pre_action 22:24:07 INFO - Running main action method: read_buildbot_config 22:24:07 INFO - Using buildbot properties: 22:24:07 INFO - { 22:24:07 INFO - "project": "", 22:24:07 INFO - "product": "firefox", 22:24:07 INFO - "script_repo_revision": "production", 22:24:07 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 22:24:07 INFO - "repository": "", 22:24:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 22:24:07 INFO - "buildid": "20160302194021", 22:24:07 INFO - "pgo_build": "True", 22:24:07 INFO - "basedir": "/builds/slave/test-pgo", 22:24:07 INFO - "buildnumber": 176, 22:24:07 INFO - "slavename": "talos-linux64-ix-046", 22:24:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:24:07 INFO - "platform": "ubuntu64_hw", 22:24:07 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 22:24:07 INFO - "branch": "mozilla-aurora", 22:24:07 INFO - "repo_path": "releases/mozilla-aurora", 22:24:07 INFO - "revision": "0bee186afe5ab070ca8adbba46bcea934adbb254", 22:24:07 INFO - "stage_platform": "linux64-pgo", 22:24:07 INFO - "builduid": "04660a1bc8e94644af0d37813fd9b593", 22:24:07 INFO - "slavebuilddir": "test" 22:24:07 INFO - } 22:24:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZHwCgBIEQpyyHlaV7k-tvA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 22:24:07 INFO - Running post-action listener: _resource_record_post_action 22:24:07 INFO - ##### 22:24:07 INFO - ##### Running download-and-extract step. 22:24:07 INFO - ##### 22:24:07 INFO - Running pre-action listener: _resource_record_pre_action 22:24:07 INFO - Running main action method: download_and_extract 22:24:07 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:24:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:07 INFO - https://queue.taskcluster.net/v1/task/ZHwCgBIEQpyyHlaV7k-tvA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:24:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHwCgBIEQpyyHlaV7k-tvA/artifacts/public/build/test_packages.json 22:24:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHwCgBIEQpyyHlaV7k-tvA/artifacts/public/build/test_packages.json 22:24:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHwCgBIEQpyyHlaV7k-tvA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:24:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHwCgBIEQpyyHlaV7k-tvA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:24:07 INFO - Downloaded 1448 bytes. 22:24:07 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:24:07 INFO - Using the following test package requirements: 22:24:07 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 22:24:07 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 22:24:07 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 22:24:07 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 22:24:07 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 22:24:07 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 22:24:07 INFO - u'jsshell-linux-x86_64.zip'], 22:24:07 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 22:24:07 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 22:24:07 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 22:24:07 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 22:24:07 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 22:24:07 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 22:24:07 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 22:24:07 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 22:24:07 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 22:24:07 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 22:24:07 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 22:24:07 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 22:24:07 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:24:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:07 INFO - https://queue.taskcluster.net/v1/task/ZHwCgBIEQpyyHlaV7k-tvA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:24:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHwCgBIEQpyyHlaV7k-tvA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 22:24:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHwCgBIEQpyyHlaV7k-tvA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 22:24:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHwCgBIEQpyyHlaV7k-tvA/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 22:24:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHwCgBIEQpyyHlaV7k-tvA/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 22:24:09 INFO - Downloaded 23089850 bytes. 22:24:09 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'] 22:24:09 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 22:24:10 INFO - Return code: 0 22:24:10 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 22:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:10 INFO - https://queue.taskcluster.net/v1/task/ZHwCgBIEQpyyHlaV7k-tvA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:24:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHwCgBIEQpyyHlaV7k-tvA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 22:24:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHwCgBIEQpyyHlaV7k-tvA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 22:24:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHwCgBIEQpyyHlaV7k-tvA/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 22:24:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHwCgBIEQpyyHlaV7k-tvA/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 22:24:11 INFO - Downloaded 23089850 bytes. 22:24:11 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'] 22:24:11 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 22:24:12 INFO - Return code: 0 22:24: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')]} 22:24:12 INFO - https://queue.taskcluster.net/v1/task/ZHwCgBIEQpyyHlaV7k-tvA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:24:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHwCgBIEQpyyHlaV7k-tvA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 22:24:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHwCgBIEQpyyHlaV7k-tvA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 22:24:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHwCgBIEQpyyHlaV7k-tvA/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 22:24:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHwCgBIEQpyyHlaV7k-tvA/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 22:24:13 INFO - Downloaded 10706668 bytes. 22:24:13 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'] 22:24:13 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 22:24:14 INFO - Return code: 0 22:24: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')]} 22:24:14 INFO - https://queue.taskcluster.net/v1/task/ZHwCgBIEQpyyHlaV7k-tvA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:24:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHwCgBIEQpyyHlaV7k-tvA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 22:24:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHwCgBIEQpyyHlaV7k-tvA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 22:24:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHwCgBIEQpyyHlaV7k-tvA/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 22:24:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZHwCgBIEQpyyHlaV7k-tvA/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 22:24:15 INFO - Downloaded 59965424 bytes. 22:24:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZHwCgBIEQpyyHlaV7k-tvA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 22:24:15 INFO - mkdir: /builds/slave/test-pgo/properties 22:24:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:24:15 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:24:15 INFO - Contents: 22:24:15 INFO - build_url:https://queue.taskcluster.net/v1/task/ZHwCgBIEQpyyHlaV7k-tvA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 22:24:16 INFO - Running post-action listener: _resource_record_post_action 22:24:16 INFO - Running post-action listener: set_extra_try_arguments 22:24:16 INFO - ##### 22:24:16 INFO - ##### Running populate-webroot step. 22:24:16 INFO - ##### 22:24:16 INFO - Running pre-action listener: _resource_record_pre_action 22:24:16 INFO - Running main action method: populate_webroot 22:24:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:24:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:24:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:24:16 INFO - '--tppagecycles', 22:24:16 INFO - '7'], 22:24:16 INFO - 'tests': ['tsvgm']}}, 22:24:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:24:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:24:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:24:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:24:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:24:16 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:24:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:24:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:16 INFO - 'talos_options': ['--e10s'], 22:24:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:24:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:16 INFO - 'tests': ['damp', 'tps']}, 22:24:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:16 INFO - 'talos_options': ['--e10s'], 22:24:16 INFO - 'tests': ['damp', 'tps']}, 22:24:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:24:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:24:16 INFO - 'other': {'tests': ['a11yr', 22:24:16 INFO - 'ts_paint', 22:24:16 INFO - 'tpaint', 22:24:16 INFO - 'sessionrestore', 22:24:16 INFO - 'sessionrestore_no_auto_restore']}, 22:24:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:24:16 INFO - 'tests': ['a11yr', 22:24:16 INFO - 'ts_paint', 22:24:16 INFO - 'tpaint', 22:24:16 INFO - 'sessionrestore', 22:24:16 INFO - 'sessionrestore_no_auto_restore']}, 22:24:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:24:16 INFO - 'tests': ['a11yr', 22:24:16 INFO - 'ts_paint', 22:24:16 INFO - 'tpaint', 22:24:16 INFO - 'sessionrestore', 22:24:16 INFO - 'sessionrestore_no_auto_restore']}, 22:24:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:24:16 INFO - 'tests': ['a11yr', 22:24:16 INFO - 'ts_paint', 22:24:16 INFO - 'tpaint', 22:24:16 INFO - 'sessionrestore', 22:24:16 INFO - 'sessionrestore_no_auto_restore']}, 22:24:16 INFO - 'other_l64': {'tests': ['a11yr', 22:24:16 INFO - 'ts_paint', 22:24:16 INFO - 'tpaint', 22:24:16 INFO - 'sessionrestore', 22:24:16 INFO - 'sessionrestore_no_auto_restore']}, 22:24:16 INFO - 'other_nol64': {'tests': ['a11yr', 22:24:16 INFO - 'ts_paint', 22:24:16 INFO - 'tpaint', 22:24:16 INFO - 'sessionrestore', 22:24:16 INFO - 'sessionrestore_no_auto_restore']}, 22:24:16 INFO - 'svgr': {'tests': ['tsvgx', 22:24:16 INFO - 'tsvgr_opacity', 22:24:16 INFO - 'tart', 22:24:16 INFO - 'tscrollx', 22:24:16 INFO - 'cart']}, 22:24:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:24:16 INFO - 'tests': ['tsvgx', 22:24:16 INFO - 'tsvgr_opacity', 22:24:16 INFO - 'tart', 22:24:16 INFO - 'tscrollx', 22:24:16 INFO - 'cart']}, 22:24:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:16 INFO - 'tests': ['tp5o']}, 22:24:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:16 INFO - 'talos_options': ['--e10s'], 22:24:16 INFO - 'tests': ['tp5o']}, 22:24:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:16 INFO - 'talos_options': ['--xperf_path', 22:24:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:24:16 INFO - 'tests': ['tp5n']}, 22:24:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:16 INFO - 'talos_options': ['--e10s', 22:24:16 INFO - '--xperf_path', 22:24:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:24:16 INFO - 'tests': ['tp5n']}}, 22:24:16 INFO - 'talos.zip': {'path': '', 22:24:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:24:16 INFO - Running post-action listener: _resource_record_post_action 22:24:16 INFO - ##### 22:24:16 INFO - ##### Running create-virtualenv step. 22:24:16 INFO - ##### 22:24:16 INFO - Running pre-action listener: _resource_record_pre_action 22:24:16 INFO - Running main action method: create_virtualenv 22:24:16 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:24:16 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 22:24:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:24:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:24:16 INFO - Using real prefix '/usr' 22:24:16 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:24:16 INFO - Installing distribute.............................................................................................................................................................................................done. 22:24:18 INFO - Installing pip.................done. 22:24:18 INFO - Return code: 0 22:24:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:18 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 0x7fb6c5604f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e1290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a73850>, '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 0x29df330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29df7c0>, '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': '652eb03db935cfc1c15ebda0000001ad-1456986244.149091-425265301', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:24:18 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 22:24:18 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 22:24:18 INFO - Using env: {'DISPLAY': ':0', 22:24:18 INFO - 'HOME': '/home/cltbld', 22:24:18 INFO - 'LANG': 'en_US.UTF-8', 22:24:18 INFO - 'LANGUAGE': 'en_US:en', 22:24:18 INFO - 'LOGNAME': 'cltbld', 22:24:18 INFO - 'MAIL': '/var/mail/cltbld', 22:24:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:18 INFO - 'MOZ_NO_REMOTE': '1', 22:24:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:18 INFO - 'NO_EM_RESTART': '1', 22:24:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:24:18 INFO - 'PWD': '/builds/slave/test-pgo', 22:24:18 INFO - 'SHELL': '/bin/bash', 22:24:18 INFO - 'SHLVL': '1', 22:24:18 INFO - 'TERM': 'linux', 22:24:18 INFO - 'TMOUT': '86400', 22:24:18 INFO - 'USER': 'cltbld', 22:24:18 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1456986244.149091-425265301', 22:24:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:18 INFO - '_': '/tools/buildbot/bin/python'} 22:24:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:24:18 INFO - Cleaning up... 22:24:18 INFO - Return code: 0 22:24:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:18 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 0x7fb6c5604f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e1290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a73850>, '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 0x29df330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29df7c0>, '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': '652eb03db935cfc1c15ebda0000001ad-1456986244.149091-425265301', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:24:18 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 22:24:18 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 22:24:18 INFO - Using env: {'DISPLAY': ':0', 22:24:18 INFO - 'HOME': '/home/cltbld', 22:24:18 INFO - 'LANG': 'en_US.UTF-8', 22:24:18 INFO - 'LANGUAGE': 'en_US:en', 22:24:18 INFO - 'LOGNAME': 'cltbld', 22:24:18 INFO - 'MAIL': '/var/mail/cltbld', 22:24:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:18 INFO - 'MOZ_NO_REMOTE': '1', 22:24:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:18 INFO - 'NO_EM_RESTART': '1', 22:24:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:24:18 INFO - 'PWD': '/builds/slave/test-pgo', 22:24:18 INFO - 'SHELL': '/bin/bash', 22:24:18 INFO - 'SHLVL': '1', 22:24:18 INFO - 'TERM': 'linux', 22:24:18 INFO - 'TMOUT': '86400', 22:24:18 INFO - 'USER': 'cltbld', 22:24:18 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1456986244.149091-425265301', 22:24:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:18 INFO - '_': '/tools/buildbot/bin/python'} 22:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:19 INFO - Downloading/unpacking psutil>=0.7.1 22:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:24:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:24:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:24:21 INFO - Installing collected packages: psutil 22:24:21 INFO - Running setup.py install for psutil 22:24:21 INFO - building 'psutil._psutil_linux' extension 22:24:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:24:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:24:21 INFO - building 'psutil._psutil_posix' extension 22:24:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:24:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:24:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:24:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:24:21 INFO - Successfully installed psutil 22:24:21 INFO - Cleaning up... 22:24:21 INFO - Return code: 0 22:24:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:21 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 0x7fb6c5604f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e1290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a73850>, '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 0x29df330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29df7c0>, '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': '652eb03db935cfc1c15ebda0000001ad-1456986244.149091-425265301', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:24:21 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 22:24:21 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 22:24:21 INFO - Using env: {'DISPLAY': ':0', 22:24:21 INFO - 'HOME': '/home/cltbld', 22:24:21 INFO - 'LANG': 'en_US.UTF-8', 22:24:21 INFO - 'LANGUAGE': 'en_US:en', 22:24:21 INFO - 'LOGNAME': 'cltbld', 22:24:21 INFO - 'MAIL': '/var/mail/cltbld', 22:24:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:21 INFO - 'MOZ_NO_REMOTE': '1', 22:24:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:21 INFO - 'NO_EM_RESTART': '1', 22:24:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:24:21 INFO - 'PWD': '/builds/slave/test-pgo', 22:24:21 INFO - 'SHELL': '/bin/bash', 22:24:21 INFO - 'SHLVL': '1', 22:24:21 INFO - 'TERM': 'linux', 22:24:21 INFO - 'TMOUT': '86400', 22:24:21 INFO - 'USER': 'cltbld', 22:24:21 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1456986244.149091-425265301', 22:24:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:21 INFO - '_': '/tools/buildbot/bin/python'} 22:24:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:24:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:24:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:24:23 INFO - Installing collected packages: mozsystemmonitor 22:24:23 INFO - Running setup.py install for mozsystemmonitor 22:24:23 INFO - Successfully installed mozsystemmonitor 22:24:23 INFO - Cleaning up... 22:24:23 INFO - Return code: 0 22:24:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:23 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 0x7fb6c5604f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e1290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a73850>, '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 0x29df330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29df7c0>, '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': '652eb03db935cfc1c15ebda0000001ad-1456986244.149091-425265301', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:24:23 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 22:24:23 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 22:24:23 INFO - Using env: {'DISPLAY': ':0', 22:24:23 INFO - 'HOME': '/home/cltbld', 22:24:23 INFO - 'LANG': 'en_US.UTF-8', 22:24:23 INFO - 'LANGUAGE': 'en_US:en', 22:24:23 INFO - 'LOGNAME': 'cltbld', 22:24:23 INFO - 'MAIL': '/var/mail/cltbld', 22:24:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:23 INFO - 'MOZ_NO_REMOTE': '1', 22:24:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:23 INFO - 'NO_EM_RESTART': '1', 22:24:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:24:23 INFO - 'PWD': '/builds/slave/test-pgo', 22:24:23 INFO - 'SHELL': '/bin/bash', 22:24:23 INFO - 'SHLVL': '1', 22:24:23 INFO - 'TERM': 'linux', 22:24:23 INFO - 'TMOUT': '86400', 22:24:23 INFO - 'USER': 'cltbld', 22:24:23 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1456986244.149091-425265301', 22:24:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:23 INFO - '_': '/tools/buildbot/bin/python'} 22:24:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:23 INFO - Downloading/unpacking blobuploader==1.2.4 22:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:25 INFO - Downloading blobuploader-1.2.4.tar.gz 22:24:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:24:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:24:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:26 INFO - Downloading docopt-0.6.1.tar.gz 22:24:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:24:26 INFO - Installing collected packages: blobuploader, requests, docopt 22:24:26 INFO - Running setup.py install for blobuploader 22:24:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:24:26 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:24:26 INFO - Running setup.py install for requests 22:24:26 INFO - Running setup.py install for docopt 22:24:27 INFO - Successfully installed blobuploader requests docopt 22:24:27 INFO - Cleaning up... 22:24:27 INFO - Return code: 0 22:24:27 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:27 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 0x7fb6c5604f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e1290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a73850>, '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 0x29df330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29df7c0>, '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': '652eb03db935cfc1c15ebda0000001ad-1456986244.149091-425265301', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:24:27 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 22:24:27 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 22:24:27 INFO - Using env: {'DISPLAY': ':0', 22:24:27 INFO - 'HOME': '/home/cltbld', 22:24:27 INFO - 'LANG': 'en_US.UTF-8', 22:24:27 INFO - 'LANGUAGE': 'en_US:en', 22:24:27 INFO - 'LOGNAME': 'cltbld', 22:24:27 INFO - 'MAIL': '/var/mail/cltbld', 22:24:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:27 INFO - 'MOZ_NO_REMOTE': '1', 22:24:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:27 INFO - 'NO_EM_RESTART': '1', 22:24:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:24:27 INFO - 'PWD': '/builds/slave/test-pgo', 22:24:27 INFO - 'SHELL': '/bin/bash', 22:24:27 INFO - 'SHLVL': '1', 22:24:27 INFO - 'TERM': 'linux', 22:24:27 INFO - 'TMOUT': '86400', 22:24:27 INFO - 'USER': 'cltbld', 22:24:27 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1456986244.149091-425265301', 22:24:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:27 INFO - '_': '/tools/buildbot/bin/python'} 22:24:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:24:27 INFO - Running setup.py (path:/tmp/pip-Qw3nJ5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:24:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:24:27 INFO - Running setup.py (path:/tmp/pip-sVLbsS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:24:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:24:27 INFO - Running setup.py (path:/tmp/pip-XnZojg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:24:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:24:27 INFO - Running setup.py (path:/tmp/pip-0DaqNR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:24:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:24:27 INFO - Running setup.py (path:/tmp/pip-I0bRid-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:24:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:24:27 INFO - Running setup.py (path:/tmp/pip-xKAuuV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:24:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:24:27 INFO - Running setup.py (path:/tmp/pip-pbIAah-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:24:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:24:27 INFO - Running setup.py (path:/tmp/pip-d25RRW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:24:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:24:27 INFO - Running setup.py (path:/tmp/pip-28GPIR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:24:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:24:28 INFO - Running setup.py (path:/tmp/pip-ilcueX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:24:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:24:28 INFO - Running setup.py (path:/tmp/pip-4H77l7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:24:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:24:28 INFO - Running setup.py (path:/tmp/pip-XWlsKc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:24:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:24:28 INFO - Running setup.py (path:/tmp/pip-duEBta-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:24:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:24:28 INFO - Running setup.py (path:/tmp/pip-srZNX0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:24:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:24:28 INFO - Running setup.py (path:/tmp/pip-dU8etu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:24:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:24:28 INFO - Running setup.py (path:/tmp/pip-QsddTF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:24:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:24:28 INFO - Running setup.py (path:/tmp/pip-jd4QRm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:24:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:24:28 INFO - Running setup.py install for manifestparser 22:24:28 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:24:28 INFO - Running setup.py install for mozcrash 22:24:28 INFO - Running setup.py install for mozdebug 22:24:28 INFO - Running setup.py install for mozdevice 22:24:28 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:24:28 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:24:28 INFO - Running setup.py install for mozfile 22:24:29 INFO - Running setup.py install for mozhttpd 22:24:29 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:24:29 INFO - Running setup.py install for mozinfo 22:24:29 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:24:29 INFO - Running setup.py install for mozInstall 22:24:29 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:24:29 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:24:29 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:24:29 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:24:29 INFO - Running setup.py install for mozleak 22:24:29 INFO - Running setup.py install for mozlog 22:24:29 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:24:29 INFO - Running setup.py install for moznetwork 22:24:29 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:24:29 INFO - Running setup.py install for mozprocess 22:24:29 INFO - Running setup.py install for mozprofile 22:24:29 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:24:29 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:24:29 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:24:29 INFO - Running setup.py install for mozrunner 22:24:30 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:24:30 INFO - Running setup.py install for mozscreenshot 22:24:30 INFO - Running setup.py install for moztest 22:24:30 INFO - Running setup.py install for mozversion 22:24:30 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:24:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:24:30 INFO - Cleaning up... 22:24:30 INFO - Return code: 0 22:24:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:24: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')]} 22:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24: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')]} 22:24:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:30 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 0x7fb6c5604f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e1290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a73850>, '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 0x29df330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29df7c0>, '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': '652eb03db935cfc1c15ebda0000001ad-1456986244.149091-425265301', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:24:30 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 22:24:30 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 22:24:30 INFO - Using env: {'DISPLAY': ':0', 22:24:30 INFO - 'HOME': '/home/cltbld', 22:24:30 INFO - 'LANG': 'en_US.UTF-8', 22:24:30 INFO - 'LANGUAGE': 'en_US:en', 22:24:30 INFO - 'LOGNAME': 'cltbld', 22:24:30 INFO - 'MAIL': '/var/mail/cltbld', 22:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:30 INFO - 'MOZ_NO_REMOTE': '1', 22:24:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:30 INFO - 'NO_EM_RESTART': '1', 22:24:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:24:30 INFO - 'PWD': '/builds/slave/test-pgo', 22:24:30 INFO - 'SHELL': '/bin/bash', 22:24:30 INFO - 'SHLVL': '1', 22:24:30 INFO - 'TERM': 'linux', 22:24:30 INFO - 'TMOUT': '86400', 22:24:30 INFO - 'USER': 'cltbld', 22:24:30 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1456986244.149091-425265301', 22:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:30 INFO - '_': '/tools/buildbot/bin/python'} 22:24:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:24:30 INFO - Running setup.py (path:/tmp/pip-6kq0pO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 22:24:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:24:30 INFO - Running setup.py (path:/tmp/pip-FvE82c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:24:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:24:30 INFO - Running setup.py (path:/tmp/pip-IpSEeq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:24:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:24:30 INFO - Running setup.py (path:/tmp/pip-bD0SFv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:24:30 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)) 22:24:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:24:30 INFO - Running setup.py (path:/tmp/pip-ysKJ2X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 22:24:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:24:30 INFO - Running setup.py (path:/tmp/pip-wri0g7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 22:24:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:24:30 INFO - Running setup.py (path:/tmp/pip-aru8tv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 22:24:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:24:31 INFO - Running setup.py (path:/tmp/pip-WJsBlK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 22:24:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:24:31 INFO - Running setup.py (path:/tmp/pip-xVmTG4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 22:24:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:24:31 INFO - Running setup.py (path:/tmp/pip-CUhflu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:24:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:24:31 INFO - Running setup.py (path:/tmp/pip-iNxsbT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 22:24:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:24:31 INFO - Running setup.py (path:/tmp/pip-EnkZdx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 22:24:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:24:31 INFO - Running setup.py (path:/tmp/pip-tsQbMK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 22:24:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:24:31 INFO - Running setup.py (path:/tmp/pip-lI1U0H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 22:24:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:24:31 INFO - Running setup.py (path:/tmp/pip-T9GWAs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 22:24:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:24:31 INFO - Running setup.py (path:/tmp/pip-jUelZN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 22:24:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:24:31 INFO - Running setup.py (path:/tmp/pip-j5temZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 22:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:24:31 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)) 22:24:31 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)) 22:24:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:33 INFO - Downloading blessings-1.6.tar.gz 22:24:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:24:33 INFO - Installing collected packages: blessings 22:24:33 INFO - Running setup.py install for blessings 22:24:33 INFO - Successfully installed blessings 22:24:33 INFO - Cleaning up... 22:24:33 INFO - Return code: 0 22:24:33 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:24:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:24:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:24:34 INFO - Reading from file tmpfile_stdout 22:24:34 INFO - Current package versions: 22:24:34 INFO - argparse == 1.2.1 22:24:34 INFO - blessings == 1.6 22:24:34 INFO - blobuploader == 1.2.4 22:24:34 INFO - docopt == 0.6.1 22:24:34 INFO - manifestparser == 1.1 22:24:34 INFO - mozInstall == 1.12 22:24:34 INFO - mozcrash == 0.16 22:24:34 INFO - mozdebug == 0.1 22:24:34 INFO - mozdevice == 0.48 22:24:34 INFO - mozfile == 1.2 22:24:34 INFO - mozhttpd == 0.7 22:24:34 INFO - mozinfo == 0.9 22:24:34 INFO - mozleak == 0.1 22:24:34 INFO - mozlog == 3.1 22:24:34 INFO - moznetwork == 0.27 22:24:34 INFO - mozprocess == 0.22 22:24:34 INFO - mozprofile == 0.28 22:24:34 INFO - mozrunner == 6.11 22:24:34 INFO - mozscreenshot == 0.1 22:24:34 INFO - mozsystemmonitor == 0.0 22:24:34 INFO - moztest == 0.7 22:24:34 INFO - mozversion == 1.4 22:24:34 INFO - psutil == 3.1.1 22:24:34 INFO - requests == 1.2.3 22:24:34 INFO - wsgiref == 0.1.2 22:24:34 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:34 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 0x7fb6c5604f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e1290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a73850>, '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 0x29df330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29df7c0>, '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': '652eb03db935cfc1c15ebda0000001ad-1456986244.149091-425265301', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:24:34 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 22:24:34 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 22:24:34 INFO - Using env: {'DISPLAY': ':0', 22:24:34 INFO - 'HOME': '/home/cltbld', 22:24:34 INFO - 'LANG': 'en_US.UTF-8', 22:24:34 INFO - 'LANGUAGE': 'en_US:en', 22:24:34 INFO - 'LOGNAME': 'cltbld', 22:24:34 INFO - 'MAIL': '/var/mail/cltbld', 22:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:34 INFO - 'MOZ_NO_REMOTE': '1', 22:24:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:34 INFO - 'NO_EM_RESTART': '1', 22:24:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:24:34 INFO - 'PWD': '/builds/slave/test-pgo', 22:24:34 INFO - 'SHELL': '/bin/bash', 22:24:34 INFO - 'SHLVL': '1', 22:24:34 INFO - 'TERM': 'linux', 22:24:34 INFO - 'TMOUT': '86400', 22:24:34 INFO - 'USER': 'cltbld', 22:24:34 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1456986244.149091-425265301', 22:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:34 INFO - '_': '/tools/buildbot/bin/python'} 22:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 22:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 22:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 22:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 22:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 22:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 22:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 22:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:24:34 INFO - Cleaning up... 22:24:34 INFO - Return code: 0 22:24:34 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:34 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 0x7fb6c5604f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e1290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a73850>, '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 0x29df330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29df7c0>, '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': '652eb03db935cfc1c15ebda0000001ad-1456986244.149091-425265301', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:24:34 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 22:24:34 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 22:24:34 INFO - Using env: {'DISPLAY': ':0', 22:24:34 INFO - 'HOME': '/home/cltbld', 22:24:34 INFO - 'LANG': 'en_US.UTF-8', 22:24:34 INFO - 'LANGUAGE': 'en_US:en', 22:24:34 INFO - 'LOGNAME': 'cltbld', 22:24:34 INFO - 'MAIL': '/var/mail/cltbld', 22:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:34 INFO - 'MOZ_NO_REMOTE': '1', 22:24:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:34 INFO - 'NO_EM_RESTART': '1', 22:24:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:24:34 INFO - 'PWD': '/builds/slave/test-pgo', 22:24:34 INFO - 'SHELL': '/bin/bash', 22:24:34 INFO - 'SHLVL': '1', 22:24:34 INFO - 'TERM': 'linux', 22:24:34 INFO - 'TMOUT': '86400', 22:24:34 INFO - 'USER': 'cltbld', 22:24:34 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1456986244.149091-425265301', 22:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:34 INFO - '_': '/tools/buildbot/bin/python'} 22:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:34 INFO - Downloading/unpacking jsonschema 22:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:24:36 INFO - Downloading/unpacking functools32 (from jsonschema) 22:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:36 INFO - Downloading functools32-3.2.3-2.tar.gz 22:24:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:24:36 INFO - warning: no files found matching '*.txt' 22:24:36 INFO - no previously-included directories found matching 'build' 22:24:36 INFO - no previously-included directories found matching 'dist' 22:24:36 INFO - no previously-included directories found matching '.git*' 22:24:36 INFO - Installing collected packages: jsonschema, functools32 22:24:36 INFO - Running setup.py install for functools32 22:24:36 INFO - warning: no files found matching '*.txt' 22:24:36 INFO - no previously-included directories found matching 'build' 22:24:36 INFO - no previously-included directories found matching 'dist' 22:24:36 INFO - no previously-included directories found matching '.git*' 22:24:36 INFO - Successfully installed jsonschema functools32 22:24:36 INFO - Cleaning up... 22:24:36 INFO - Return code: 0 22:24:36 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6c5604f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e1290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a73850>, '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 0x29df330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29df7c0>, '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': '652eb03db935cfc1c15ebda0000001ad-1456986244.149091-425265301', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:24:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 22:24:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:24:36 INFO - Using env: {'DISPLAY': ':0', 22:24:36 INFO - 'HOME': '/home/cltbld', 22:24:36 INFO - 'LANG': 'en_US.UTF-8', 22:24:36 INFO - 'LANGUAGE': 'en_US:en', 22:24:36 INFO - 'LOGNAME': 'cltbld', 22:24:36 INFO - 'MAIL': '/var/mail/cltbld', 22:24:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:36 INFO - 'MOZ_NO_REMOTE': '1', 22:24:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:36 INFO - 'NO_EM_RESTART': '1', 22:24:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:24:36 INFO - 'PWD': '/builds/slave/test-pgo', 22:24:36 INFO - 'SHELL': '/bin/bash', 22:24:36 INFO - 'SHLVL': '1', 22:24:36 INFO - 'TERM': 'linux', 22:24:36 INFO - 'TMOUT': '86400', 22:24:36 INFO - 'USER': 'cltbld', 22:24:36 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1456986244.149091-425265301', 22:24:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:36 INFO - '_': '/tools/buildbot/bin/python'} 22:24:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:36 INFO - Downloading/unpacking flake8 22:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:24:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:24: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 22:24: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 22:24: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 22:24: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 22:24: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 22:24: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 22:24:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:24:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:24:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:24:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:24:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:24:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:24:39 INFO - no previously-included directories found matching 'docs/_build' 22:24:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:24:39 INFO - Running setup.py install for pep8 22:24:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:24:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:24:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:24:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:24:39 INFO - no previously-included directories found matching 'docs/_build' 22:24:39 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:24:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:24:39 INFO - Cleaning up... 22:24:39 INFO - Return code: 0 22:24:39 INFO - Running post-action listener: _resource_record_post_action 22:24:39 INFO - Running post-action listener: _start_resource_monitoring 22:24:39 INFO - Starting resource monitoring. 22:24:39 INFO - ##### 22:24:39 INFO - ##### Running install step. 22:24:39 INFO - ##### 22:24:39 INFO - Running pre-action listener: _resource_record_pre_action 22:24:39 INFO - Running main action method: install 22:24:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:24:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:24:39 INFO - Reading from file tmpfile_stdout 22:24:39 INFO - Detecting whether we're running mozinstall >=1.0... 22:24:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:24:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:24:40 INFO - Reading from file tmpfile_stdout 22:24:40 INFO - Output received: 22:24:40 INFO - Usage: mozinstall [options] installer 22:24:40 INFO - Options: 22:24:40 INFO - -h, --help show this help message and exit 22:24:40 INFO - -d DEST, --destination=DEST 22:24:40 INFO - Directory to install application into. [default: 22:24:40 INFO - "/builds/slave/test-pgo"] 22:24:40 INFO - --app=APP Application being installed. [default: firefox] 22:24:40 INFO - mkdir: /builds/slave/test-pgo/build/application 22:24:40 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'] 22:24:40 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 22:24:55 INFO - Reading from file tmpfile_stdout 22:24:55 INFO - Output received: 22:24:55 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:24:55 INFO - Running post-action listener: _resource_record_post_action 22:24:55 INFO - ##### 22:24:55 INFO - ##### Running run-tests step. 22:24:55 INFO - ##### 22:24:55 INFO - Running pre-action listener: _resource_record_pre_action 22:24:55 INFO - Running main action method: run_tests 22:24:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:24:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:24:55 INFO - Python 2.7.3 22:24:55 INFO - Return code: 0 22:24:55 INFO - grabbing minidump binary from tooltool 22:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:55 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 0x2a73850>, '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 0x29df330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29df7c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:24:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 22:24:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:24:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:24:55 INFO - Return code: 0 22:24:55 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:24:55 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:24:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:24:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:24:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:24:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:24:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:24:56 INFO - Return code: 0 22:24:56 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZHwCgBIEQpyyHlaV7k-tvA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 22:24:56 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZHwCgBIEQpyyHlaV7k-tvA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:24:56 INFO - Using env: {'DISPLAY': ':0', 22:24:56 INFO - 'HOME': '/home/cltbld', 22:24:56 INFO - 'LANG': 'en_US.UTF-8', 22:24:56 INFO - 'LANGUAGE': 'en_US:en', 22:24:56 INFO - 'LOGNAME': 'cltbld', 22:24:56 INFO - 'MAIL': '/var/mail/cltbld', 22:24:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:24:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:56 INFO - 'MOZ_NO_REMOTE': '1', 22:24:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:24:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:56 INFO - 'NO_EM_RESTART': '1', 22:24:56 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:24:56 INFO - 'PWD': '/builds/slave/test-pgo', 22:24:56 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:24:56 INFO - 'SHELL': '/bin/bash', 22:24:56 INFO - 'SHLVL': '1', 22:24:56 INFO - 'TERM': 'linux', 22:24:56 INFO - 'TMOUT': '86400', 22:24:56 INFO - 'USER': 'cltbld', 22:24:56 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1456986244.149091-425265301', 22:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:56 INFO - '_': '/tools/buildbot/bin/python'} 22:24:56 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZHwCgBIEQpyyHlaV7k-tvA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:24:56 INFO - mozversion application_buildid: 20160302194021 22:24:56 INFO - mozversion application_changeset: 0bee186afe5ab070ca8adbba46bcea934adbb254 22:24:56 INFO - mozversion application_display_name: FirefoxDeveloperEdition 22:24:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:24:56 INFO - mozversion application_name: Firefox 22:24:56 INFO - mozversion application_remotingname: firefox-dev 22:24:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:24:56 INFO - mozversion application_vendor: Mozilla 22:24:56 INFO - mozversion application_version: 46.0a2 22:24:56 INFO - mozversion platform_buildid: 20160302194021 22:24:56 INFO - mozversion platform_changeset: 0bee186afe5ab070ca8adbba46bcea934adbb254 22:24:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:24:56 INFO - mozversion platform_version: 46.0a2 22:24:56 INFO - using testdate: 1456986296 22:24:56 INFO - actual date: 1456986296 22:24:56 INFO - starting webserver on 'localhost:41556' 22:24:56 INFO - SUITE-START | Running 3 tests 22:24:56 INFO - TEST-START | dromaeo_css 22:24:56 INFO - operating with platform_type : linux_ 22:24:56 INFO - Initialising browser for dromaeo_css test... 22:24:56 INFO - TEST-INFO | started process 12501 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMmxt7h/profile http://localhost:41556/getInfo.html) 22:25:00 INFO - PROCESS | 12501 | 22:25:00 INFO - PROCESS | 12501 | (process:12580): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:25:00 INFO - PROCESS | 12501 | __metrics Screen width/height:1600/1200 22:25:00 INFO - PROCESS | 12501 | colorDepth:24 22:25:00 INFO - PROCESS | 12501 | Browser inner width/height: 1024/697 22:25:00 INFO - PROCESS | 12501 | __metrics 22:25:01 INFO - TEST-INFO | 12501: exit 0 22:25:01 INFO - Browser initialized. 22:25:01 INFO - Running cycle 1/1 for dromaeo_css test... 22:25:01 INFO - TEST-INFO | started process 12629 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMmxt7h/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:25:03 INFO - PROCESS | 12629 | 22:25:03 INFO - PROCESS | 12629 | (process:12693): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:25:13 INFO - PROCESS | 12629 | RSS: Main: 140959744 22:25:13 INFO - PROCESS | 12629 | 22:26:03 INFO - PROCESS | 12629 | 1456986363349 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:28:11 INFO - PROCESS | 12629 | Cycle 1(1): loaded http://localhost:41556/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41556/tests/dromaeo/cssquery-ext.html) 22:28:12 INFO - PROCESS | 12629 | RSS: Main: 145915904 22:28:12 INFO - PROCESS | 12629 | 22:31:14 INFO - PROCESS | 12629 | Cycle 1(1): loaded http://localhost:41556/tests/dromaeo/cssquery-ext.html (next: http://localhost:41556/tests/dromaeo/cssquery-jquery.html) 22:31:14 INFO - PROCESS | 12629 | RSS: Main: 145006592 22:31:14 INFO - PROCESS | 12629 | 22:34:16 INFO - PROCESS | 12629 | Cycle 1(1): loaded http://localhost:41556/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41556/tests/dromaeo/cssquery-mootools.html) 22:34:17 INFO - PROCESS | 12629 | RSS: Main: 143532032 22:34:17 INFO - PROCESS | 12629 | 22:37:18 INFO - PROCESS | 12629 | Cycle 1(1): loaded http://localhost:41556/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41556/tests/dromaeo/cssquery-prototype.html) 22:37:19 INFO - PROCESS | 12629 | RSS: Main: 143187968 22:37:19 INFO - PROCESS | 12629 | 22:40:21 INFO - PROCESS | 12629 | Cycle 1(1): loaded http://localhost:41556/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41556/tests/dromaeo/cssquery-yui.html) 22:40:22 INFO - PROCESS | 12629 | RSS: Main: 144965632 22:40:22 INFO - PROCESS | 12629 | 22:43:24 INFO - PROCESS | 12629 | Cycle 1(1): loaded http://localhost:41556/tests/dromaeo/cssquery-yui.html (next: http://localhost:41556/tests/dromaeo/cssquery-dojo.html) 22:43:24 INFO - PROCESS | 12629 | RSS: Main: 145752064 22:43:24 INFO - PROCESS | 12629 | 22:43:24 INFO - PROCESS | 12629 | __start_tp_report 22:43:24 INFO - PROCESS | 12629 | _x_x_mozilla_page_load 22:43:24 INFO - PROCESS | 12629 | _x_x_mozilla_page_load_details 22:43:24 INFO - PROCESS | 12629 | |i|pagename|runs| 22:43:24 INFO - PROCESS | 12629 | |0;dojo.html;3352.363051020306;3369.326134773046;3394.796312221267;3427.348803727292;3432.330695514375;5550.195221692852;5559.833205003852;5588.86027849304;5589.692566908823;5594.384617692056;5555.583331250163;5578.888422231553;5595.300587426572;5608.859778505539;5641.464060914217;5055.191169412886;5094.490550944913;5138.58891288696;5140.331756871601;5219.399769026572;4931.3835770528685;4983.978284451697;5035.924461133086;5047.747612619372;5098.668586541863;5077.5684066854365;5104.106781313274;5141.922871156936;5142.177251639739;5185.040767458014;5070.188769796851;5084.415292241384;5087.618428617869;5091.389033315989;5097.668651537638;4908.877278068041;4926.5812405945535;5005.074061298635;5012.997400519911;5075;5302.575793936476;5339.3058902342445;5353.304070470853;5384.111621582434;5391.541718953894;5856.267966504187;5934.376890426486;5987.9101813472835;5989.610675306091;5991.16123742672;5778.7399567019165;5807.128930660392;5822.737976791054;5975.372585878464;6000.459958603747;5364.7317634118135;5591.7483713233005;5637.238972738669;5643.915341269884;5664.745086471119;6047.637141771508;6072;6078.179445774764;6081.300650425169;6088.208532890696;5611.354694210137;5733.88532229353;5759.049756790083;5823.970880145657;5857.7656893724625;5849.2103566018895;5864.091065884794;5870.530357571384;5910.645361278337;5942.732577034044;5761.164631128547;5783.392743761844;5787.131930210502;5810.477057064884;5820.447057529528;5754.338251101093;5757.222774925415;5779.306483222041;5780.71096445176;5785;4408.515063343029;4470.776461176928;4476;4502.302143167814;4531.796069176895;4011.7592944422845;4015.77913214776;4023.2556976959354;4038.8384464621085;4053.756774593534;5369.838904832861;5526.364468086141;5528;5534.584906132056;5561.332640083216;5860.472557469848;5902.940970590239;5919.082542205965;5957.255343082114;5978.8206353809455;5597.3003374578175;5603.271574695264;5622.465865742748;5626.409227031185;5644.209810626516;4984.800607975641;5050.974745126325;5070.797168113308;5125.384953805493;5166.3025491558155;5935.406459354116;5939.049752039653;6076.665783381956;6094.756209751649;6113.144159817629;5963.612365196248;5976.491998180203;5982.880342393215;5996.160537524837;6000.609960352563;5979.402059793986;6031.487323577545;6100.0849872519475;6110.969445152746;6140.078988151813;5771.59598828078;5789.768409263583;5807.332156801853;5822.097574875901;5847.707614619337;5917.378675239038;5918.881622367442;5926.348101708895;5956.195913551788;5979.13302571116;5509.173623956439;5619.887602247851;5777.826665200051;5839.065749480233;5839.386864379179;5701.087825947829;5760;5760.251167348218;5767.307923049261;5781.624194427349;5668.121441176624;5707.828765137053;5715.142728590745;5723.828285151452;5734.254546909042;5650.152477128464;5716.571257155813;5808.041673124057;5808.94191058084;5871.853203669943;5727.427257274239;5762.798302059407;5772.2207501986695;5773.711314434346;5773.942260577341 22:43:24 INFO - PROCESS | 12629 | |1;ext.html;552.1965540139098;559.9104143337067;565.7312776431196;581.5463938128261;591.7573794744155;38056.61943380565;39037.21925561487;39174.02064948378;39256;39289;42263.57736422635;42676.14647707044;42872.49946251882;42939.785301073454;42956.3556546652;8849.690260840873;8952.820943581157;8954.238889694383;9048.457092574467;9051.637934482646;8777.34169937254;8956.820863582725;8960.910390896106;9087.591058402355;9157.038510956354;9071.138241867046;9128.72613821583;9185.540722963826;9210.953945230265;9219.078092190794;9053.50205738684;9120.407173533698;9129.634814607407;9146.314026447977;9168.495732734697;8943.50810705411;9034.09659034098;9068.773280668036;9076.22852057576;9123.81752364949;43074.35388469176;43535.34696979548;43583.34624980628;43604.56395436037;43686.344704829455;3726.4224045273027;3803.5435747710176;3817.618238176188;4185.518665353493;4193.706440549163;32759.672403276138;33084.834575827204;33136.33727325464;33140.17149571256;33547.3290534188;4310.137972405531;4369.847055353048;4390;4430.800613972379;4446.666500012512;282908;285041;286976;287193;287599;45220.64338069863;45310.546894530635;45407.772961134986;45645.31532027022;45688.543114569096;43288.56711432908;43432.131357373306;43623.127537449705;43726.12547749027;43990.780046100204;14706.705865882623;14875.851241487446;15026.474073407597;15057;15099;12491.93754031224;12503.124781265224;12510.937445312715;12705.491780328868;12967.870321296856;15055.096694198382;15068.623284417978;15108.54674359771;15123.546293611209;15277.694446111016;6026.337102918676;6049.213602231682;6140.385961403824;6248.375162483715;6275.654838983808;1059.4702648675661;1102.8125218712837;1121.2039451989017;1130.1749722702473;1165.889240522149;31247.843760781052;31427;31459.84270078681;31757.682423175935;31855.203619909687;1167.9591214307459;1183.627157445402;1218.622227109599;1265.9365234667432;1272.6691060324383;16305.184740762914;16310.429134980219;16477.176141192893;16502;16699.66600668004;504540;507570;510685;793465;804968;53717.46282537203;54310;54362.45637543653;55006.72496637571;55031;1441.747694153519;1461.174436443406;1506.7363211437955;1518.916459594733;1532.2491978930466;29695.70304297016;30603;32410.35179296448;32769.18077047997;33223.83388083044;50215.497845021084;50778.74610626923;50900.490995089574;50957.235641464664;50963;316347;316530;317705;318156;319772;34743.4788478168;34885.65114348824;34969.650303497656;35158;46340.30489542727;42863.78568107139;43109.137817244104;43153.56846431496;43249;43492.8253587313;36059.81970090133;36521.81739091394;37293.81353093217;37424.43863341997;37801.432978504796;36442.45336319904;38444.23111537698;38672.41991370075;39708.60291397049;40196.1960760789;40735.18529629332;40940.59059409368;41288.174236514504;43073.56926430821;44050;32516;32660.836695816368;32744.836275818467;33095.66904330926;34381;27890.581641274992;28046.158615241577;28169.57745633776;28300.716992830632;28439.857800710863 22:43:24 INFO - PROCESS | 12629 | |2;jquery.html;389.2079617977416;390.4358202397533;391.41288067898154;392.16077593948955;395.40096753418595;15278;16477.423290184815;16617.66764664706;18453.07734613269;18535.443936681888;16302.184890755474;16519.174041297916;16549.586260343498;16810;16990.66018679629;5002.374703162114;5239.659422137568;5503.724813759296;5509.972450137764;5515.558755299567;3947.328954077799;4087.9182416351655;5400.621956463049;5403.054465468547;5623.4938855503;5343.625946183769;5573.052581061209;5607.355154157263;5611.270534830466;5636.661800291975;5337.786488540453;5416.593755468336;5432.75552600134;5437.510624043815;5451.3458384993855;5447.264619276387;5468.699221542814;5472.671639701591;5482.890342193174;5499.807506737285;13544.255065971367;16802.83197168025;20566.485837854023;21301.147954081818;21302;2372.146027430124;2375.857448553075;2416.830821842472;2427.320350301901;2509.2346834215555;10182.745431364201;10218.693439196835;10266.897331026743;11484.081273498101;11916.404179791063;1949.2885096939656;1954.5797653504565;1956.6086782643386;2037.5619241863071;2062.5565503416838;57882;59163.70418147925;59181.40818591802;59615.10577341343;59638.10542841861;9906.20750339971;10320.277580569287;10547.947260263803;10590.735231619117;10647.094996925192;13801.516946907012;13914.95637827167;14027.71944561103;14076.648083797987;14114.50599229022;7803.102643196105;7808.609569521501;7856.5678887661725;7859.410544209207;7898.486598371088;7517.9099030640255;7575.128860181149;7644.273793989562;7652.846943061108;7653.349465295512;3842.615738426135;4294.76378799169;4336.132773445323;4474.753888536162;4661.184292748755;1754.7455618935182;1826.7899191592871;1847.5196448923107;1864.636395902786;1883.3125909043101;459.9264117741145;1082.128886246579;1113.1762495753246;1130.7568872692411;1144.016146114341;11117.888821111846;11369.943150284362;11390.974812266935;11444.427778611036;11475.827862582068;497.5348049573588;510.90548248574135;528.5903424845775;534.657818995843;537.2398056749734;6192.628442293477;6307.621542707452;6329.461995730415;6339.96830015847;6388.201474815648;553585;554859;557448;572825;609927;44522.77738611286;45449;45526.31710524345;62301.75396492136;76081.61959190169;518.4323166133079;1185.6561597136733;1235.5984305100878;1235.6293112066523;1235.715785369352;15329.923350383177;15390.07659540431;15435;15441.768373474632;15753.527394177734;22726.431839204153;26278.4744305109;27038.864805675847;32474.350512989135;35496.64503355037;41758.83490681563;43519;43911.56088439203;48863.755681221366;49839.252411214584;7527.736529221451;7890.526568405914;7939.920600794149;7940.483868548526;8160.83678326442;10352.637657681946;11083;11296.43517824122;11553.82669259945;11892.643220703392;3141.3246152077413;9483.810323793623;9902.405855648683;10048.899511004796;10180.13468855126;10317.587296508056;10492.737681558023;10576.4711764413;10641.148708103488;10997.780044398907;10735.624253151102;10942.671719848417;11042.171837112088;11100.5559777608;11229.55081796719;8011.679532818622;8066.878996814935;8114.918850811417;8159.143289954469;8252.298554622925;10253.692389228336;10931.398773067558;11081.390523521284;11104.944475277573;11350.318980861175 22:43:24 INFO - PROCESS | 12629 | |3;mootools.html;1556.1830039229403;1569.6546759712862;1749.5101371615951;1876.1651065275942;1885.7548518692568;8042.195780421955;8111.837763244739;8161.306288965445;8332.000159980804;8349.624266907997;8316.29311508521;8361.456505327149;8389.958050209756;8460.66157353705;8480.66077356905;2357.398863289863;2371.9525609487887;2395.149721848745;2395.64065390192;2400.6399040143942;2418.2745176446997;2443.3647251714506;2461.3354394313524;2463.6427717980973;2477.9008839646394;2367.5264947010583;2391.1152873436768;2408.5784987627185;2424.5635785558593;2425;2403.927882163538;2416.1664225842055;2425.0905910283645;2425.9029638814427;2428.1622840120217;2325.6976593042796;2348.765123487655;2362.2795047510504;2372.1934542255717;2378.191414918936;8251.216134467217;8321.375896807704;8322.83354332916;8325.916740832574;8326.2506374426;4877.878053048702;4978.925316120261;5016.49835016499;5020.497950204986;5025.346704928373;3274.787138835968;3306.0908250231378;3378.6114596821435;3407.5910890693026;3435.7594968352223;1083.3283364314098;1089.2647462962468;1105.4528008635777;1112.4382186995597;1125.831125331207;11190.160737944687;11318.830217546743;11356.091512679048;11360.147988900782;11373.658790236306;4289.571042895748;4299.226139294957;4396.780160991938;4427.734335939854;4430.357598148251;8983.281337492985;9005.504697241584;9022.503762293005;9038;9038.909610903807;4836.395450568679;4869.464358920516;4875.658703890694;4880.170371036932;4886.242632391985;4428.7121337112985;4453.22068637987;4456.309272062836;4501.887452813706;4506.076254367912;3552.378333791576;3631.782093074424;3641.890743277706;3643.653852883972;3662.3957047086933;1099.796537640539;1112.9165312601588;1114.0474893965543;1118.681175864891;1119.994400028011;990.8067926754213;993.6919554937992;1218.4516967364543;1324.24518024725;1430.6924011337612;7776.572288524072;7841.372690184771;7883.960580197062;7928.405369597303;8059.597020148969;1176.7293522489874;1180.9822852657217;1185.8458400408065;1185.9347735874437;1205.5358686905604;6181.196444462191;6197.194364732556;6218.471429928416;6249.187605611332;6259.874802504016;9613.375130616627;9826.65606703762;9870.753231169134;9934.50327483623;9980.45107519079;9575.712728618153;9678.56446459911;9786.75533111678;9802.705918822447;9804.901950980398;7788.649510772028;7789.7273595423885;7822.4524283299625;7852.882206766903;7863.842723145505;7629.237076292548;7637.541747495168;7719.652615632198;7756.650950707344;7881.881771773543;8801.823963520821;8960.551972401223;8976.192142707188;9024.187823095954;9095.226905713089;9185.265178785814;9250.259979201783;9294;9302.48836313982;9341.392809467363;7389.630518474162;7562.205968373241;7564.735234266775;7573;7589.582572958319;7904.84190316202;7952.562609056326;7966.203379661987;8020.759377218693;8023.518588884685;7317.414606831547;7652.502587331805;7685.5004424712215;7718.151003389735;7723.266289702469;7348.669309881175;7373.29953654402;7416.0729908761405;7464.066991626047;7539.170691224071;7346.77959661211;7350.301721336465;7371.741989030358;7382.704691812482;7390;6490.513211509061;6573.5069869759;6602.207735071822;6606.8017959461295;6654.201495820533;6670.799876003728;6746.595204287759;6855.07456493367;6866.279040700654;6877.4841886857685 22:43:24 INFO - PROCESS | 12629 | |4;prototype.html;357.93557159711247;372.76515795049124;374.9025253434106;377.70538979595926;381.60694484680755;6399.552031357807;6405;6434.099226108348;6455.451286640635;6639.302873198317;6358.554901156921;6396.200474940632;6407.647579383132;6409.070684750708;6428.3250258722865;4884.853454396365;4889.095517329305;4894.265860120992;4906.754662266891;4915.459299477055;4870.902581948359;4875.902481950359;4876.878078048059;4881.048195601859;4937.210046392578;4756.5243475652505;4839.975800120995;4867.659263851532;4885.413750349963;4885.828995985141;4850.272459131141;4870.683405578644;4875.390576177978;4881.902361952741;4896;4254.361845723135;4268.445102136733;4268.527358061464;4269.444972153631;4270.910917715963;6104.267487901436;6118.571699981003;6126.877462450726;6132.294786099611;6150.907736383958;5505.229267902497;5675.801346952878;5692.800751973661;5734.569907256972;5747.3677895431465;6756.425703815182;6791.219009813836;6806.421454176401;6810.863782724367;6819.147606549182;4743.241081426955;4753.643476739224;4758.738269395182;4773.641976851715;4783.043391321715;7036.40190583801;7073.398761105261;7115.395191408788;7124.786256412264;7140.28597140287;4850.563449289581;4857.684250523705;4865.513448655177;4865.781039853215;4866;4942.728149951788;4943.8022479101155;4945.431275403303;4946.258061290763;4954.1825598775795;5576.944230557724;5689.715514224355;5707.828765137053;5707.971460142673;5710.371859095496;6822.249552549216;6845.110135682329;6850.965745171242;6853.725850966005;6857.142857142857;1697.4737831272346;1736.4182998695578;1758.5251981964798;1759.1731886013554;1762.6122253104297;1153.1524329617723;1167.3521195736278;1170.017185564113;1177.9057675385948;1179.1215544419463;6447.516436267299;6472.644004579794;6473.417392434703;6474.061261117112;6509.967450162719;6909.585424874524;6943.930560694328;6951.443884489228;7000.474964377692;7017.824554386079;6399.243987963437;6457.61254324742;6463.321351258144;6471.255805582418;6501.0898474213645;3793.3551296279697;3796.4495148203355;3802.9239415212096;3813.370793819044;3814.4659747634796;7213.531120477152;7227.205007449176;7228.746993855189;7242.782716518513;7249.891251631229;6969.23338432772;7127.821804454827;7195.280471952763;7231.349178573953;7247.057882475245;7167.677454514559;7210.855782884313;7217.639118044077;7222.783316500409;7225.313595208447;6959.860802784017;6979.267176946348;6985.336393042653;6986.720531178899;7011.26381729911;6733.7306507741105;6838.2136054352395;6852.6916288768125;6866.553674011173;6887.827804304932;7134.714611415693;7160.140783106061;7178.353948144692;7191.928080719335;7194.928050719635;4819.855404337875;4858.6356023297685;4860.270959356125;4864.148773964613;4879.975600121977;6835.658217089225;6957.478189135733;6994.930050699428;7006.719731210695;7130.643467826691;6913.792586222421;6957.9304206959305;6959.19969203548;6980.825479362853;7008.0889484368745;6896.413804826445;6965.268646792217;6971.058907047483;6972.651367431709;7000.579965202104;6730.764423245163;6781.423578995643;6843.452523798183;6866.828329291808;6873.553219040747;6962.756303529555;6982.33667801558;7006.194287656985;7012.228654848064;7014.754483593049;6733.797986060426;6814.625195614289;6837.726490940307;6857.417119544695;6863.416609588041 22:43:24 INFO - PROCESS | 12629 | |5;yui.html;810.2748040503753;818.3984771193176;945.7304668169573;945.7966537194503;951.2960409297118;14190;14205.502807401743;14205.502807401743;14331.06848054877;14334.211618361;13607.115537490055;13612.863871361309;13622.727545449085;13626;13630.182189068662;855.9144085591438;882.07382248639;905.1265528764741;910.0399078971715;912.6760000199934;896.318797713739;897.5243121145803;899.8200359928007;902.2060586683709;904.7240591619553;932.673564252513;942.3686130292687;943.504660053474;944.1644144931751;946.5740416812428;916.2029034739786;925.6852670092134;931.1247427418206;937.9963439120144;938.4322484896608;691.0808624529363;693.3586432549921;693.4244577001077;696.3245651717876;696.8745625787357;14223.928880355636;14370.856291437056;14393.856061439355;14402.711945761026;14594.562163135122;11993.280403175837;12898.935505322506;13464.326783660777;13652.522161724291;13836.723265534632;10993.34039957597;11054.613088541942;11232.3260604364;11323.773524529546;11617.361045142514;3848.3073046851555;3875.922481550353;3886.5336159661024;3911.8826435206706;3915.6882444381167;52301.47698523004;52743;52980.47019529794;53105;53180.46819531794;10374.22193335503;10630.521626526825;10632.936706329305;10774.97637724415;10821.24251302417;19269;19281.807181928;19406.514837129183;19454;19490.902545487465;8375.288100511403;8488.660453581911;8563;8687.739367818975;8739.781505462413;4486.730796152241;4684.625229981593;4720.811167553259;4733.810647574059;4809.0862736080035;3205.4550726376574;3242.400155971153;3245.3996010738088;3250.8537115829845;3255.4628486299493;615.8460384903774;617.8702472480829;617.9567430279927;622.8941080016408;629.2449061126666;684.7706018483864;705.4990956420999;729.8321386081232;735.2463724682243;739.6264886232418;8740.086705632923;9523.52382380892;9673.081057299545;9699.806003879883;10446.895531044593;624.2758400255682;640.2445114764529;729.2670865779858;751.8421131562433;784.2353705137446;4408.6693497987135;4457.576530229623;4472.351509031172;4595.6193338442;4900.093482705711;59364.10953835696;59655.70172149112;60844.695776520835;60952.390476095556;61173;48709.26936095962;52073.21890171651;53137.202941955904;53310.73344633252;53382.19926701103;48547.757261214174;48947.26579101316;49039;49329.75335123301;50479.747601261755;9548.809023819624;9650.276229282692;9681.757956051155;9826.557804898654;9927.305088643725;36824.81587592045;40464.39303410392;40724.59275407208;41826.581734183485;41831.163376732904;48729.26906096341;50925.74537127439;52062.47937520577;52353.47646523486;54825.725871370385;11674.94162529182;12190.451429685509;12359.567415140427;12889.677758055748;12891.742165156831;13792.241426721626;13885.375158117708;13979.09135906163;14465.349059292568;14495.202763847668;12456.439460224494;12666.304980812121;12871.485140594272;12895.48418063267;13246.933765331112;12280.938595306967;12552.74894502123;12976.935115324362;13286.53497127596;14564.344604492611;12977.870221297666;13060.477580897037;13101.213927164019;13257.270850103338;13556.38996245191;9701.6604418845;9766.902330976884;10457.581696732046;10504.842427363443;10813.351198928089;10244.231682623684;10412.47937603132;10622.681319560426;10690.251682382159;10711.25021248505 22:43:24 INFO - PROCESS | 12629 | __end_tp_report 22:43:24 INFO - PROCESS | 12629 | __start_cc_report 22:43:24 INFO - PROCESS | 12629 | _x_x_mozilla_cycle_collect,302 22:43:24 INFO - PROCESS | 12629 | __end_cc_report 22:43:24 INFO - PROCESS | 12629 | __startTimestamp1456987404824__endTimestamp 22:43:24 INFO - PROCESS | 12629 | 22:43:24 INFO - PROCESS | 12629 | ------- Summary: start ------- 22:43:24 INFO - PROCESS | 12629 | Number of tests: 6 22:43:24 INFO - PROCESS | 12629 | 22:43:24 INFO - PROCESS | 12629 | [#0] dojo.html Cycles:165 Average:5489.29 Median:5715.14 stddev:593.82 (10.4%) stddev-sans-first:571.49 22:43:24 INFO - PROCESS | 12629 | Values: 3352.4 3369.3 3394.8 3427.3 3432.3 5550.2 5559.8 5588.9 5589.7 5594.4 5555.6 5578.9 5595.3 5608.9 5641.5 5055.2 5094.5 5138.6 5140.3 5219.4 4931.4 4984.0 5035.9 5047.7 5098.7 5077.6 5104.1 5141.9 5142.2 5185.0 5070.2 5084.4 5087.6 5091.4 5097.7 4908.9 4926.6 5005.1 5013.0 5075.0 5302.6 5339.3 5353.3 5384.1 5391.5 5856.3 5934.4 5987.9 5989.6 5991.2 5778.7 5807.1 5822.7 5975.4 6000.5 5364.7 5591.7 5637.2 5643.9 5664.7 6047.6 6072.0 6078.2 6081.3 6088.2 5611.4 5733.9 5759.0 5824.0 5857.8 5849.2 5864.1 5870.5 5910.6 5942.7 5761.2 5783.4 5787.1 5810.5 5820.4 5754.3 5757.2 5779.3 5780.7 5785.0 4408.5 4470.8 4476.0 4502.3 4531.8 4011.8 4015.8 4023.3 4038.8 4053.8 5369.8 5526.4 5528.0 5534.6 5561.3 5860.5 5902.9 5919.1 5957.3 5978.8 5597.3 5603.3 5622.5 5626.4 5644.2 4984.8 5051.0 5070.8 5125.4 5166.3 5935.4 5939.0 6076.7 6094.8 6113.1 5963.6 5976.5 5982.9 5996.2 6000.6 5979.4 6031.5 6100.1 6111.0 6140.1 5771.6 5789.8 5807.3 5822.1 5847.7 5917.4 5918.9 5926.3 5956.2 5979.1 5509.2 5619.9 5777.8 5839.1 5839.4 5701.1 5760.0 5760.3 5767.3 5781.6 5668.1 5707.8 5715.1 5723.8 5734.3 5650.2 5716.6 5808.0 5808.9 5871.9 5727.4 5762.8 5772.2 5773.7 5773.9 22:43:24 INFO - PROCESS | 12629 | 22:43:24 INFO - PROCESS | 12629 | [#1] ext.html Cycles:180 Average:56293.23 Median:39952.40 stddev:119092.42 (298.1%) stddev-sans-first:119352.97 22:43:24 INFO - PROCESS | 12629 | Values: 552.2 559.9 565.7 581.5 591.8 38056.6 39037.2 39174.0 39256.0 39289.0 42263.6 42676.1 42872.5 42939.8 42956.4 8849.7 8952.8 8954.2 9048.5 9051.6 8777.3 8956.8 8960.9 9087.6 9157.0 9071.1 9128.7 9185.5 9211.0 9219.1 9053.5 9120.4 9129.6 9146.3 9168.5 8943.5 9034.1 9068.8 9076.2 9123.8 43074.4 43535.3 43583.3 43604.6 43686.3 3726.4 3803.5 3817.6 4185.5 4193.7 32759.7 33084.8 33136.3 33140.2 33547.3 4310.1 4369.8 4390.0 4430.8 4446.7 282908.0 285041.0 286976.0 287193.0 287599.0 45220.6 45310.5 45407.8 45645.3 45688.5 43288.6 43432.1 43623.1 43726.1 43990.8 14706.7 14875.9 15026.5 15057.0 15099.0 12491.9 12503.1 12510.9 12705.5 12967.9 15055.1 15068.6 15108.5 15123.5 15277.7 6026.3 6049.2 6140.4 6248.4 6275.7 1059.5 1102.8 1121.2 1130.2 1165.9 31247.8 31427.0 31459.8 31757.7 31855.2 1168.0 1183.6 1218.6 1265.9 1272.7 16305.2 16310.4 16477.2 16502.0 16699.7 504540.0 507570.0 510685.0 793465.0 804968.0 53717.5 54310.0 54362.5 55006.7 55031.0 1441.7 1461.2 1506.7 1518.9 1532.2 29695.7 30603.0 32410.4 32769.2 33223.8 50215.5 50778.7 50900.5 50957.2 50963.0 316347.0 316530.0 317705.0 318156.0 319772.0 34743.5 34885.7 34969.7 35158.0 46340.3 42863.8 43109.1 43153.6 43249.0 43492.8 36059.8 36521.8 37293.8 37424.4 37801.4 36442.5 38444.2 38672.4 39708.6 40196.2 40735.2 40940.6 41288.2 43073.6 44050.0 32516.0 32660.8 32744.8 33095.7 34381.0 27890.6 28046.2 28169.6 28300.7 28439.9 22:43:24 INFO - PROCESS | 12629 | 22:43:24 INFO - PROCESS | 12629 | [#2] jquery.html Cycles:180 Average:27855.35 Median:2115.91 stddev:92971.34 (4393.9%) stddev-sans-first:93209.27 22:43:24 INFO - PROCESS | 12629 | Values: 389.2 390.4 391.4 392.2 395.4 15278.0 16477.4 16617.7 18453.1 18535.4 16302.2 16519.2 16549.6 16810.0 16990.7 5002.4 5239.7 5503.7 5510.0 5515.6 3947.3 4087.9 5400.6 5403.1 5623.5 5343.6 5573.1 5607.4 5611.3 5636.7 5337.8 5416.6 5432.8 5437.5 5451.3 5447.3 5468.7 5472.7 5482.9 5499.8 13544.3 16802.8 20566.5 21301.1 21302.0 2372.1 2375.9 2416.8 2427.3 2509.2 10182.7 10218.7 10266.9 11484.1 11916.4 1949.3 1954.6 1956.6 2037.6 2062.6 57882.0 59163.7 59181.4 59615.1 59638.1 9906.2 10320.3 10547.9 10590.7 10647.1 13801.5 13915.0 14027.7 14076.6 14114.5 7803.1 7808.6 7856.6 7859.4 7898.5 7517.9 7575.1 7644.3 7652.8 7653.3 3842.6 4294.8 4336.1 4474.8 4661.2 1754.7 1826.8 1847.5 1864.6 1883.3 459.9 1082.1 1113.2 1130.8 1144.0 11117.9 11369.9 11391.0 11444.4 11475.8 497.5 510.9 528.6 534.7 537.2 6192.6 6307.6 6329.5 6340.0 6388.2 553585.0 554859.0 557448.0 572825.0 609927.0 44522.8 45449.0 45526.3 62301.8 76081.6 518.4 1185.7 1235.6 1235.6 1235.7 15329.9 15390.1 15435.0 15441.8 15753.5 22726.4 26278.5 27038.9 32474.4 35496.6 41758.8 43519.0 43911.6 48863.8 49839.3 7527.7 7890.5 7939.9 7940.5 8160.8 10352.6 11083.0 11296.4 11553.8 11892.6 3141.3 9483.8 9902.4 10048.9 10180.1 10317.6 10492.7 10576.5 10641.1 10997.8 10735.6 10942.7 11042.2 11100.6 11229.6 8011.7 8066.9 8114.9 8159.1 8252.3 10253.7 10931.4 11081.4 11104.9 11350.3 22:43:24 INFO - PROCESS | 12629 | 22:43:24 INFO - PROCESS | 12629 | [#3] mootools.html Cycles:180 Average:5779.71 Median:6604.50 stddev:2993.30 (45.3%) stddev-sans-first:2984.87 22:43:24 INFO - PROCESS | 12629 | Values: 1556.2 1569.7 1749.5 1876.2 1885.8 8042.2 8111.8 8161.3 8332.0 8349.6 8316.3 8361.5 8390.0 8460.7 8480.7 2357.4 2372.0 2395.1 2395.6 2400.6 2418.3 2443.4 2461.3 2463.6 2477.9 2367.5 2391.1 2408.6 2424.6 2425.0 2403.9 2416.2 2425.1 2425.9 2428.2 2325.7 2348.8 2362.3 2372.2 2378.2 8251.2 8321.4 8322.8 8325.9 8326.3 4877.9 4978.9 5016.5 5020.5 5025.3 3274.8 3306.1 3378.6 3407.6 3435.8 1083.3 1089.3 1105.5 1112.4 1125.8 11190.2 11318.8 11356.1 11360.1 11373.7 4289.6 4299.2 4396.8 4427.7 4430.4 8983.3 9005.5 9022.5 9038.0 9038.9 4836.4 4869.5 4875.7 4880.2 4886.2 4428.7 4453.2 4456.3 4501.9 4506.1 3552.4 3631.8 3641.9 3643.7 3662.4 1099.8 1112.9 1114.0 1118.7 1120.0 990.8 993.7 1218.5 1324.2 1430.7 7776.6 7841.4 7884.0 7928.4 8059.6 1176.7 1181.0 1185.8 1185.9 1205.5 6181.2 6197.2 6218.5 6249.2 6259.9 9613.4 9826.7 9870.8 9934.5 9980.5 9575.7 9678.6 9786.8 9802.7 9804.9 7788.6 7789.7 7822.5 7852.9 7863.8 7629.2 7637.5 7719.7 7756.7 7881.9 8801.8 8960.6 8976.2 9024.2 9095.2 9185.3 9250.3 9294.0 9302.5 9341.4 7389.6 7562.2 7564.7 7573.0 7589.6 7904.8 7952.6 7966.2 8020.8 8023.5 7317.4 7652.5 7685.5 7718.2 7723.3 7348.7 7373.3 7416.1 7464.1 7539.2 7346.8 7350.3 7371.7 7382.7 7390.0 6490.5 6573.5 6602.2 6606.8 6654.2 6670.8 6746.6 6855.1 6866.3 6877.5 22:43:24 INFO - PROCESS | 12629 | 22:43:24 INFO - PROCESS | 12629 | [#4] prototype.html Cycles:180 Average:5705.76 Median:6456.53 stddev:1714.42 (26.6%) stddev-sans-first:1671.58 22:43:24 INFO - PROCESS | 12629 | Values: 357.9 372.8 374.9 377.7 381.6 6399.6 6405.0 6434.1 6455.5 6639.3 6358.6 6396.2 6407.6 6409.1 6428.3 4884.9 4889.1 4894.3 4906.8 4915.5 4870.9 4875.9 4876.9 4881.0 4937.2 4756.5 4840.0 4867.7 4885.4 4885.8 4850.3 4870.7 4875.4 4881.9 4896.0 4254.4 4268.4 4268.5 4269.4 4270.9 6104.3 6118.6 6126.9 6132.3 6150.9 5505.2 5675.8 5692.8 5734.6 5747.4 6756.4 6791.2 6806.4 6810.9 6819.1 4743.2 4753.6 4758.7 4773.6 4783.0 7036.4 7073.4 7115.4 7124.8 7140.3 4850.6 4857.7 4865.5 4865.8 4866.0 4942.7 4943.8 4945.4 4946.3 4954.2 5576.9 5689.7 5707.8 5708.0 5710.4 6822.2 6845.1 6851.0 6853.7 6857.1 1697.5 1736.4 1758.5 1759.2 1762.6 1153.2 1167.4 1170.0 1177.9 1179.1 6447.5 6472.6 6473.4 6474.1 6510.0 6909.6 6943.9 6951.4 7000.5 7017.8 6399.2 6457.6 6463.3 6471.3 6501.1 3793.4 3796.4 3802.9 3813.4 3814.5 7213.5 7227.2 7228.7 7242.8 7249.9 6969.2 7127.8 7195.3 7231.3 7247.1 7167.7 7210.9 7217.6 7222.8 7225.3 6959.9 6979.3 6985.3 6986.7 7011.3 6733.7 6838.2 6852.7 6866.6 6887.8 7134.7 7160.1 7178.4 7191.9 7194.9 4819.9 4858.6 4860.3 4864.1 4880.0 6835.7 6957.5 6994.9 7006.7 7130.6 6913.8 6957.9 6959.2 6980.8 7008.1 6896.4 6965.3 6971.1 6972.7 7000.6 6730.8 6781.4 6843.5 6866.8 6873.6 6962.8 6982.3 7006.2 7012.2 7014.8 6733.8 6814.6 6837.7 6857.4 6863.4 22:43:24 INFO - PROCESS | 12629 | 22:43:24 INFO - PROCESS | 12629 | [#5] yui.html Cycles:180 Average:15042.53 Median:4727.31 stddev:17176.59 (363.3%) stddev-sans-first:17191.52 22:43:24 INFO - PROCESS | 12629 | Values: 810.3 818.4 945.7 945.8 951.3 14190.0 14205.5 14205.5 14331.1 14334.2 13607.1 13612.9 13622.7 13626.0 13630.2 855.9 882.1 905.1 910.0 912.7 896.3 897.5 899.8 902.2 904.7 932.7 942.4 943.5 944.2 946.6 916.2 925.7 931.1 938.0 938.4 691.1 693.4 693.4 696.3 696.9 14223.9 14370.9 14393.9 14402.7 14594.6 11993.3 12898.9 13464.3 13652.5 13836.7 10993.3 11054.6 11232.3 11323.8 11617.4 3848.3 3875.9 3886.5 3911.9 3915.7 52301.5 52743.0 52980.5 53105.0 53180.5 10374.2 10630.5 10632.9 10775.0 10821.2 19269.0 19281.8 19406.5 19454.0 19490.9 8375.3 8488.7 8563.0 8687.7 8739.8 4486.7 4684.6 4720.8 4733.8 4809.1 3205.5 3242.4 3245.4 3250.9 3255.5 615.8 617.9 618.0 622.9 629.2 684.8 705.5 729.8 735.2 739.6 8740.1 9523.5 9673.1 9699.8 10446.9 624.3 640.2 729.3 751.8 784.2 4408.7 4457.6 4472.4 4595.6 4900.1 59364.1 59655.7 60844.7 60952.4 61173.0 48709.3 52073.2 53137.2 53310.7 53382.2 48547.8 48947.3 49039.0 49329.8 50479.7 9548.8 9650.3 9681.8 9826.6 9927.3 36824.8 40464.4 40724.6 41826.6 41831.2 48729.3 50925.7 52062.5 52353.5 54825.7 11674.9 12190.5 12359.6 12889.7 12891.7 13792.2 13885.4 13979.1 14465.3 14495.2 12456.4 12666.3 12871.5 12895.5 13246.9 12280.9 12552.7 12976.9 13286.5 14564.3 12977.9 13060.5 13101.2 13257.3 13556.4 9701.7 9766.9 10457.6 10504.8 10813.4 10244.2 10412.5 10622.7 10690.3 10711.3 22:43:24 INFO - PROCESS | 12629 | -------- Summary: end -------- 22:43:24 INFO - PROCESS | 12629 | 22:43:25 INFO - TEST-INFO | 12629: exit 0 22:43:25 INFO - TEST-OK | dromaeo_css | took 1109025ms 22:43:25 INFO - TEST-START | kraken 22:43:25 INFO - operating with platform_type : linux_ 22:43:25 INFO - Initialising browser for kraken test... 22:43:25 INFO - TEST-INFO | started process 12875 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfkMFOl/profile http://localhost:41556/getInfo.html) 22:43:29 INFO - PROCESS | 12875 | 22:43:29 INFO - PROCESS | 12875 | (process:12953): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:43:29 INFO - PROCESS | 12875 | __metrics Screen width/height:1600/1200 22:43:29 INFO - PROCESS | 12875 | colorDepth:24 22:43:29 INFO - PROCESS | 12875 | Browser inner width/height: 1024/697 22:43:29 INFO - PROCESS | 12875 | __metrics 22:43:30 INFO - TEST-INFO | 12875: exit 0 22:43:30 INFO - Browser initialized. 22:43:30 INFO - Running cycle 1/1 for kraken test... 22:43:30 INFO - TEST-INFO | started process 13002 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfkMFOl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:43:32 INFO - PROCESS | 13002 | 22:43:32 INFO - PROCESS | 13002 | (process:13062): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:43:42 INFO - PROCESS | 13002 | RSS: Main: 142000128 22:43:42 INFO - PROCESS | 13002 | 22:43:45 INFO - PROCESS | 13002 | Cycle 1(1): loaded http://localhost:41556/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41556/tests/kraken/driver.html?testName=audio-beat-detection) 22:43:45 INFO - PROCESS | 13002 | RSS: Main: 146141184 22:43:45 INFO - PROCESS | 13002 | 22:43:48 INFO - PROCESS | 13002 | Cycle 1(1): loaded http://localhost:41556/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41556/tests/kraken/driver.html?testName=audio-dft) 22:43:49 INFO - PROCESS | 13002 | RSS: Main: 145297408 22:43:49 INFO - PROCESS | 13002 | 22:43:51 INFO - PROCESS | 13002 | Cycle 1(1): loaded http://localhost:41556/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41556/tests/kraken/driver.html?testName=audio-fft) 22:43:52 INFO - PROCESS | 13002 | RSS: Main: 146391040 22:43:52 INFO - PROCESS | 13002 | 22:43:54 INFO - PROCESS | 13002 | Cycle 1(1): loaded http://localhost:41556/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41556/tests/kraken/driver.html?testName=audio-oscillator) 22:43:55 INFO - PROCESS | 13002 | RSS: Main: 145436672 22:43:55 INFO - PROCESS | 13002 | 22:43:57 INFO - PROCESS | 13002 | Cycle 1(1): loaded http://localhost:41556/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41556/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:43:57 INFO - PROCESS | 13002 | RSS: Main: 147914752 22:43:57 INFO - PROCESS | 13002 | 22:44:00 INFO - PROCESS | 13002 | Cycle 1(1): loaded http://localhost:41556/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41556/tests/kraken/driver.html?testName=imaging-darkroom) 22:44:01 INFO - PROCESS | 13002 | RSS: Main: 146845696 22:44:01 INFO - PROCESS | 13002 | 22:44:04 INFO - PROCESS | 13002 | Cycle 1(1): loaded http://localhost:41556/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41556/tests/kraken/driver.html?testName=imaging-desaturate) 22:44:05 INFO - PROCESS | 13002 | RSS: Main: 145563648 22:44:05 INFO - PROCESS | 13002 | 22:44:08 INFO - PROCESS | 13002 | Cycle 1(1): loaded http://localhost:41556/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41556/tests/kraken/driver.html?testName=json-parse-financial) 22:44:08 INFO - PROCESS | 13002 | RSS: Main: 146685952 22:44:08 INFO - PROCESS | 13002 | 22:44:10 INFO - PROCESS | 13002 | Cycle 1(1): loaded http://localhost:41556/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41556/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:44:10 INFO - PROCESS | 13002 | RSS: Main: 146948096 22:44:10 INFO - PROCESS | 13002 | 22:44:12 INFO - PROCESS | 13002 | Cycle 1(1): loaded http://localhost:41556/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41556/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:44:13 INFO - PROCESS | 13002 | RSS: Main: 146083840 22:44:13 INFO - PROCESS | 13002 | 22:44:15 INFO - PROCESS | 13002 | Cycle 1(1): loaded http://localhost:41556/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41556/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:44:15 INFO - PROCESS | 13002 | RSS: Main: 147193856 22:44:15 INFO - PROCESS | 13002 | 22:44:18 INFO - PROCESS | 13002 | Cycle 1(1): loaded http://localhost:41556/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41556/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:44:18 INFO - PROCESS | 13002 | RSS: Main: 146382848 22:44:18 INFO - PROCESS | 13002 | 22:44:21 INFO - PROCESS | 13002 | Cycle 1(1): loaded http://localhost:41556/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41556/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:44:21 INFO - PROCESS | 13002 | RSS: Main: 146821120 22:44:21 INFO - PROCESS | 13002 | 22:44:23 INFO - PROCESS | 13002 | Cycle 1(1): loaded http://localhost:41556/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41556/tests/kraken/driver.html?testName=ai-astar) 22:44:23 INFO - PROCESS | 13002 | RSS: Main: 148762624 22:44:23 INFO - PROCESS | 13002 | 22:44:23 INFO - PROCESS | 13002 | __start_tp_report 22:44:23 INFO - PROCESS | 13002 | _x_x_mozilla_page_load 22:44:23 INFO - PROCESS | 13002 | _x_x_mozilla_page_load_details 22:44:23 INFO - PROCESS | 13002 | |i|pagename|runs| 22:44:23 INFO - PROCESS | 13002 | |0;ai-astar;112;107;112;111;111;121;111;112;111;113 22:44:23 INFO - PROCESS | 13002 | |1;audio-beat-detection;157;127;156;158;126;153;159;123;161;134 22:44:23 INFO - PROCESS | 13002 | |2;audio-dft;162;164;160;160;164;160;160;162;163;161 22:44:23 INFO - PROCESS | 13002 | |3;audio-fft;75;75;73;143;77;78;75;76;149;76 22:44:23 INFO - PROCESS | 13002 | |4;audio-oscillator;95;94;140;95;95;95;137;95;95;143 22:44:23 INFO - PROCESS | 13002 | |5;imaging-gaussian-blur;111;110;110;109;109;110;110;109;110;110 22:44:23 INFO - PROCESS | 13002 | |6;imaging-darkroom;149;148;147;146;147;146;148;148;147;146 22:44:23 INFO - PROCESS | 13002 | |7;imaging-desaturate;96;96;96;96;97;96;97;96;97;97 22:44:23 INFO - PROCESS | 13002 | |8;json-parse-financial;55;58;57;58;58;57;57;64;57;60 22:44:23 INFO - PROCESS | 13002 | |9;json-stringify-tinderbox;66;66;64;64;64;65;66;66;64;66 22:44:23 INFO - PROCESS | 13002 | |10;stanford-crypto-aes;79;80;82;81;82;82;89;82;83;80 22:44:23 INFO - PROCESS | 13002 | |11;stanford-crypto-ccm;112;117;112;116;113;111;109;117;115;115 22:44:23 INFO - PROCESS | 13002 | |12;stanford-crypto-pbkdf2;137;138;142;139;149;142;138;140;136;131 22:44:23 INFO - PROCESS | 13002 | |13;stanford-crypto-sha256-iterative;67;67;68;67;67;67;67;65;66;64 22:44:23 INFO - PROCESS | 13002 | __end_tp_report 22:44:23 INFO - PROCESS | 13002 | __start_cc_report 22:44:23 INFO - PROCESS | 13002 | _x_x_mozilla_cycle_collect,743 22:44:23 INFO - PROCESS | 13002 | __end_cc_report 22:44:23 INFO - PROCESS | 13002 | __startTimestamp1456987463742__endTimestamp 22:44:23 INFO - PROCESS | 13002 | 22:44:23 INFO - PROCESS | 13002 | ------- Summary: start ------- 22:44:23 INFO - PROCESS | 13002 | Number of tests: 14 22:44:23 INFO - PROCESS | 13002 | 22:44:23 INFO - PROCESS | 13002 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.00 stddev:3.51 (3.1%) stddev-sans-first:3.72 22:44:23 INFO - PROCESS | 13002 | Values: 112.0 107.0 112.0 111.0 111.0 121.0 111.0 112.0 111.0 113.0 22:44:23 INFO - PROCESS | 13002 | 22:44:23 INFO - PROCESS | 13002 | [#1] audio-beat-detection Cycles:10 Average:145.40 Median:156.50 stddev:15.77 (10.1%) stddev-sans-first:16.16 22:44:23 INFO - PROCESS | 13002 | Values: 157.0 127.0 156.0 158.0 126.0 153.0 159.0 123.0 161.0 134.0 22:44:23 INFO - PROCESS | 13002 | 22:44:23 INFO - PROCESS | 13002 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.65 (1.0%) stddev-sans-first:1.74 22:44:23 INFO - PROCESS | 13002 | Values: 162.0 164.0 160.0 160.0 164.0 160.0 160.0 162.0 163.0 161.0 22:44:23 INFO - PROCESS | 13002 | 22:44:23 INFO - PROCESS | 13002 | [#3] audio-fft Cycles:10 Average:89.70 Median:75.50 stddev:29.74 (39.4%) stddev-sans-first:31.06 22:44:23 INFO - PROCESS | 13002 | Values: 75.0 75.0 73.0 143.0 77.0 78.0 75.0 76.0 149.0 76.0 22:44:23 INFO - PROCESS | 13002 | 22:44:23 INFO - PROCESS | 13002 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:95.00 stddev:21.85 (23.0%) stddev-sans-first:22.64 22:44:23 INFO - PROCESS | 13002 | Values: 95.0 94.0 140.0 95.0 95.0 95.0 137.0 95.0 95.0 143.0 22:44:23 INFO - PROCESS | 13002 | 22:44:23 INFO - PROCESS | 13002 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.50 22:44:23 INFO - PROCESS | 13002 | Values: 111.0 110.0 110.0 109.0 109.0 110.0 110.0 109.0 110.0 110.0 22:44:23 INFO - PROCESS | 13002 | 22:44:23 INFO - PROCESS | 13002 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:1.03 (0.7%) stddev-sans-first:0.87 22:44:23 INFO - PROCESS | 13002 | Values: 149.0 148.0 147.0 146.0 147.0 146.0 148.0 148.0 147.0 146.0 22:44:23 INFO - PROCESS | 13002 | 22:44:23 INFO - PROCESS | 13002 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 22:44:23 INFO - PROCESS | 13002 | Values: 96.0 96.0 96.0 96.0 97.0 96.0 97.0 96.0 97.0 97.0 22:44:23 INFO - PROCESS | 13002 | 22:44:23 INFO - PROCESS | 13002 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:58.00 stddev:2.42 (4.2%) stddev-sans-first:2.30 22:44:23 INFO - PROCESS | 13002 | Values: 55.0 58.0 57.0 58.0 58.0 57.0 57.0 64.0 57.0 60.0 22:44:23 INFO - PROCESS | 13002 | 22:44:23 INFO - PROCESS | 13002 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:66.00 stddev:0.99 (1.5%) stddev-sans-first:1.00 22:44:23 INFO - PROCESS | 13002 | Values: 66.0 66.0 64.0 64.0 64.0 65.0 66.0 66.0 64.0 66.0 22:44:23 INFO - PROCESS | 13002 | 22:44:23 INFO - PROCESS | 13002 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.00 stddev:2.75 (3.4%) stddev-sans-first:2.69 22:44:23 INFO - PROCESS | 13002 | Values: 79.0 80.0 82.0 81.0 82.0 82.0 89.0 82.0 83.0 80.0 22:44:23 INFO - PROCESS | 13002 | 22:44:23 INFO - PROCESS | 13002 | [#11] stanford-crypto-ccm Cycles:10 Average:113.70 Median:115.00 stddev:2.71 (2.4%) stddev-sans-first:2.80 22:44:23 INFO - PROCESS | 13002 | Values: 112.0 117.0 112.0 116.0 113.0 111.0 109.0 117.0 115.0 115.0 22:44:23 INFO - PROCESS | 13002 | 22:44:23 INFO - PROCESS | 13002 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.20 Median:139.50 stddev:4.69 (3.4%) stddev-sans-first:4.90 22:44:23 INFO - PROCESS | 13002 | Values: 137.0 138.0 142.0 139.0 149.0 142.0 138.0 140.0 136.0 131.0 22:44:23 INFO - PROCESS | 13002 | 22:44:23 INFO - PROCESS | 13002 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:1.18 (1.8%) stddev-sans-first:1.24 22:44:23 INFO - PROCESS | 13002 | Values: 67.0 67.0 68.0 67.0 67.0 67.0 67.0 65.0 66.0 64.0 22:44:23 INFO - PROCESS | 13002 | -------- Summary: end -------- 22:44:23 INFO - PROCESS | 13002 | 22:44:24 INFO - TEST-INFO | 13002: exit 0 22:44:24 INFO - TEST-OK | kraken | took 59240ms 22:44:24 INFO - TEST-START | v8_7 22:44:24 INFO - operating with platform_type : linux_ 22:44:24 INFO - Initialising browser for v8_7 test... 22:44:24 INFO - TEST-INFO | started process 13290 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSI9iEL/profile http://localhost:41556/getInfo.html) 22:44:28 INFO - PROCESS | 13290 | 22:44:28 INFO - PROCESS | 13290 | (process:13368): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:44:29 INFO - PROCESS | 13290 | __metrics Screen width/height:1600/1200 22:44:29 INFO - PROCESS | 13290 | colorDepth:24 22:44:29 INFO - PROCESS | 13290 | Browser inner width/height: 1024/697 22:44:29 INFO - PROCESS | 13290 | __metrics 22:44:30 INFO - TEST-INFO | 13290: exit 0 22:44:30 INFO - Browser initialized. 22:44:30 INFO - Running cycle 1/1 for v8_7 test... 22:44:30 INFO - TEST-INFO | started process 13417 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSI9iEL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:44:31 INFO - PROCESS | 13417 | 22:44:31 INFO - PROCESS | 13417 | (process:13482): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:44:41 INFO - PROCESS | 13417 | RSS: Main: 141209600 22:44:41 INFO - PROCESS | 13417 | 22:45:04 INFO - PROCESS | 13417 | Cycle 1(1): loaded http://localhost:41556/tests/v8_7/run.html (next: http://localhost:41556/tests/v8_7/run.html) 22:45:04 INFO - PROCESS | 13417 | RSS: Main: 144744448 22:45:04 INFO - PROCESS | 13417 | 22:45:04 INFO - PROCESS | 13417 | __start_tp_report 22:45:04 INFO - PROCESS | 13417 | _x_x_mozilla_page_load 22:45:04 INFO - PROCESS | 13417 | _x_x_mozilla_page_load_details 22:45:04 INFO - PROCESS | 13417 | |i|pagename|runs| 22:45:04 INFO - PROCESS | 13417 | |0;Richards;168.03898504453034 22:45:04 INFO - PROCESS | 13417 | |1;DeltaBlue;170.7067258449983 22:45:04 INFO - PROCESS | 13417 | |2;Encrypt;288.0184331797235 22:45:04 INFO - PROCESS | 13417 | |3;Decrypt;5164.948453608247 22:45:04 INFO - PROCESS | 13417 | |4;RayTrace;929.368029739777 22:45:04 INFO - PROCESS | 13417 | |5;Earley;547.0459518599563 22:45:04 INFO - PROCESS | 13417 | |6;Boyer;11054.945054945056 22:45:04 INFO - PROCESS | 13417 | |7;RegExp;40215.686274509804 22:45:04 INFO - PROCESS | 13417 | |8;Splay;509.4147582697201 22:45:04 INFO - PROCESS | 13417 | |9;NavierStokes;4830.917874396136 22:45:04 INFO - PROCESS | 13417 | __end_tp_report 22:45:04 INFO - PROCESS | 13417 | __startTimestamp1456987504639__endTimestamp 22:45:04 INFO - PROCESS | 13417 | 22:45:04 INFO - PROCESS | 13417 | ------- Summary: start ------- 22:45:04 INFO - PROCESS | 13417 | Number of tests: 10 22:45:04 INFO - PROCESS | 13417 | 22:45:04 INFO - PROCESS | 13417 | [#0] Richards Cycles:1 Average:168.04 Median:168.04 stddev:0.00 (0.0%) 22:45:04 INFO - PROCESS | 13417 | Values: 168.0 22:45:04 INFO - PROCESS | 13417 | 22:45:04 INFO - PROCESS | 13417 | [#1] DeltaBlue Cycles:1 Average:170.71 Median:170.71 stddev:0.00 (0.0%) 22:45:04 INFO - PROCESS | 13417 | Values: 170.7 22:45:04 INFO - PROCESS | 13417 | 22:45:04 INFO - PROCESS | 13417 | [#2] Encrypt Cycles:1 Average:288.02 Median:288.02 stddev:0.00 (0.0%) 22:45:04 INFO - PROCESS | 13417 | Values: 288.0 22:45:04 INFO - PROCESS | 13417 | 22:45:04 INFO - PROCESS | 13417 | [#3] Decrypt Cycles:1 Average:5164.95 Median:5164.95 stddev:0.00 (0.0%) 22:45:04 INFO - PROCESS | 13417 | Values: 5164.9 22:45:04 INFO - PROCESS | 13417 | 22:45:04 INFO - PROCESS | 13417 | [#4] RayTrace Cycles:1 Average:929.37 Median:929.37 stddev:0.00 (0.0%) 22:45:04 INFO - PROCESS | 13417 | Values: 929.4 22:45:04 INFO - PROCESS | 13417 | 22:45:04 INFO - PROCESS | 13417 | [#5] Earley Cycles:1 Average:547.05 Median:547.05 stddev:0.00 (0.0%) 22:45:04 INFO - PROCESS | 13417 | Values: 547.0 22:45:04 INFO - PROCESS | 13417 | 22:45:04 INFO - PROCESS | 13417 | [#6] Boyer Cycles:1 Average:11054.95 Median:11054.95 stddev:0.00 (0.0%) 22:45:04 INFO - PROCESS | 13417 | Values: 11054.9 22:45:04 INFO - PROCESS | 13417 | 22:45:04 INFO - PROCESS | 13417 | [#7] RegExp Cycles:1 Average:40215.69 Median:40215.69 stddev:0.00 (0.0%) 22:45:04 INFO - PROCESS | 13417 | Values: 40215.7 22:45:04 INFO - PROCESS | 13417 | 22:45:04 INFO - PROCESS | 13417 | [#8] Splay Cycles:1 Average:509.41 Median:509.41 stddev:0.00 (0.0%) 22:45:04 INFO - PROCESS | 13417 | Values: 509.4 22:45:04 INFO - PROCESS | 13417 | 22:45:04 INFO - PROCESS | 13417 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 22:45:04 INFO - PROCESS | 13417 | Values: 4830.9 22:45:04 INFO - PROCESS | 13417 | -------- Summary: end -------- 22:45:04 INFO - PROCESS | 13417 | 22:45:05 INFO - TEST-INFO | 13417: exit 0 22:45:05 INFO - TEST-OK | v8_7 | took 40764ms 22:45:05 INFO - SUITE-END | took 1209s 22:45:05 INFO - Completed test suite (00:20:09) 22:45:05 INFO - Working with test: dromaeo_css 22:45:05 INFO - Generating results file: dromaeo_css 22:45:05 INFO - Working with test: kraken 22:45:05 INFO - Generating results file: kraken 22:45:05 INFO - javascript benchmark 22:45:05 INFO - Working with test: v8_7 22:45:05 INFO - Generating results file: v8_7 22:45:05 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:45:07 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 22:45:07 INFO - process_Request line: dromaeo_css 7240.76 graph.html#tests=[[72,52,43]] 22:45:07 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:45:07 INFO - process_Request line: kraken 1495.20 graph.html#tests=[[232,52,43]] 22:45:07 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:45:07 INFO - process_Request line: v8_7 22004.55 graph.html#tests=[[230,52,43]] 22:45:07 INFO - RETURN: dromaeo_css: 7240.76 22:45:07 INFO - RETURN: kraken: 1495.20 22:45:07 INFO - RETURN: v8_7: 22004.55 22:45:07 INFO - javascript benchmark 22:45:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3352.363051020306, 3369.326134773046, 3394.796312221267, 3427.348803727292, 3432.330695514375, 5550.195221692852, 5559.833205003852, 5588.86027849304, 5589.692566908823, 5594.384617692056, 5555.583331250163, 5578.888422231553, 5595.300587426572, 5608.859778505539, 5641.464060914217, 5055.191169412886, 5094.490550944913, 5138.58891288696, 5140.331756871601, 5219.399769026572, 4931.3835770528685, 4983.978284451697, 5035.924461133086, 5047.747612619372, 5098.668586541863, 5077.5684066854365, 5104.106781313274, 5141.922871156936, 5142.177251639739, 5185.040767458014, 5070.188769796851, 5084.415292241384, 5087.618428617869, 5091.389033315989, 5097.668651537638, 4908.877278068041, 4926.5812405945535, 5005.074061298635, 5012.997400519911, 5075.0, 5302.575793936476, 5339.3058902342445, 5353.304070470853, 5384.111621582434, 5391.541718953894, 5856.267966504187, 5934.376890426486, 5987.9101813472835, 5989.610675306091, 5991.16123742672, 5778.7399567019165, 5807.128930660392, 5822.737976791054, 5975.372585878464, 6000.459958603747, 5364.7317634118135, 5591.7483713233005, 5637.238972738669, 5643.915341269884, 5664.745086471119, 6047.637141771508, 6072.0, 6078.179445774764, 6081.300650425169, 6088.208532890696, 5611.354694210137, 5733.88532229353, 5759.049756790083, 5823.970880145657, 5857.7656893724625, 5849.2103566018895, 5864.091065884794, 5870.530357571384, 5910.645361278337, 5942.732577034044, 5761.164631128547, 5783.392743761844, 5787.131930210502, 5810.477057064884, 5820.447057529528, 5754.338251101093, 5757.222774925415, 5779.306483222041, 5780.71096445176, 5785.0, 4408.515063343029, 4470.776461176928, 4476.0, 4502.302143167814, 4531.796069176895, 4011.7592944422845, 4015.77913214776, 4023.2556976959354, 4038.8384464621085, 4053.756774593534, 5369.838904832861, 5526.364468086141, 5528.0, 5534.584906132056, 5561.332640083216, 5860.472557469848, 5902.940970590239, 5919.082542205965, 5957.255343082114, 5978.8206353809455, 5597.3003374578175, 5603.271574695264, 5622.465865742748, 5626.409227031185, 5644.209810626516, 4984.800607975641, 5050.974745126325, 5070.797168113308, 5125.384953805493, 5166.3025491558155, 5935.406459354116, 5939.049752039653, 6076.665783381956, 6094.756209751649, 6113.144159817629, 5963.612365196248, 5976.491998180203, 5982.880342393215, 5996.160537524837, 6000.609960352563, 5979.402059793986, 6031.487323577545, 6100.0849872519475, 6110.969445152746, 6140.078988151813, 5771.59598828078, 5789.768409263583, 5807.332156801853, 5822.097574875901, 5847.707614619337, 5917.378675239038, 5918.881622367442, 5926.348101708895, 5956.195913551788, 5979.13302571116, 5509.173623956439, 5619.887602247851, 5777.826665200051, 5839.065749480233, 5839.386864379179, 5701.087825947829, 5760.0, 5760.251167348218, 5767.307923049261, 5781.624194427349, 5668.121441176624, 5707.828765137053, 5715.142728590745, 5723.828285151452, 5734.254546909042, 5650.152477128464, 5716.571257155813, 5808.041673124057, 5808.94191058084, 5871.853203669943, 5727.427257274239, 5762.798302059407, 5772.2207501986695, 5773.711314434346, 5773.942260577341], "unit": "score", "name": "dojo.html", "value": 5451.933153938976}, {"lowerIsBetter": false, "replicates": [552.1965540139098, 559.9104143337067, 565.7312776431196, 581.5463938128261, 591.7573794744155, 38056.61943380565, 39037.21925561487, 39174.02064948378, 39256.0, 39289.0, 42263.57736422635, 42676.14647707044, 42872.49946251882, 42939.785301073454, 42956.3556546652, 8849.690260840873, 8952.820943581157, 8954.238889694383, 9048.457092574467, 9051.637934482646, 8777.34169937254, 8956.820863582725, 8960.910390896106, 9087.591058402355, 9157.038510956354, 9071.138241867046, 9128.72613821583, 9185.540722963826, 9210.953945230265, 9219.078092190794, 9053.50205738684, 9120.407173533698, 9129.634814607407, 9146.314026447977, 9168.495732734697, 8943.50810705411, 9034.09659034098, 9068.773280668036, 9076.22852057576, 9123.81752364949, 43074.35388469176, 43535.34696979548, 43583.34624980628, 43604.56395436037, 43686.344704829455, 3726.4224045273027, 3803.5435747710176, 3817.618238176188, 4185.518665353493, 4193.706440549163, 32759.672403276138, 33084.834575827204, 33136.33727325464, 33140.17149571256, 33547.3290534188, 4310.137972405531, 4369.847055353048, 4390.0, 4430.800613972379, 4446.666500012512, 282908.0, 285041.0, 286976.0, 287193.0, 287599.0, 45220.64338069863, 45310.546894530635, 45407.772961134986, 45645.31532027022, 45688.543114569096, 43288.56711432908, 43432.131357373306, 43623.127537449705, 43726.12547749027, 43990.780046100204, 14706.705865882623, 14875.851241487446, 15026.474073407597, 15057.0, 15099.0, 12491.93754031224, 12503.124781265224, 12510.937445312715, 12705.491780328868, 12967.870321296856, 15055.096694198382, 15068.623284417978, 15108.54674359771, 15123.546293611209, 15277.694446111016, 6026.337102918676, 6049.213602231682, 6140.385961403824, 6248.375162483715, 6275.654838983808, 1059.4702648675661, 1102.8125218712837, 1121.2039451989017, 1130.1749722702473, 1165.889240522149, 31247.843760781052, 31427.0, 31459.84270078681, 31757.682423175935, 31855.203619909687, 1167.9591214307459, 1183.627157445402, 1218.622227109599, 1265.9365234667432, 1272.6691060324383, 16305.184740762914, 16310.429134980219, 16477.176141192893, 16502.0, 16699.66600668004, 504540.0, 507570.0, 510685.0, 793465.0, 804968.0, 53717.46282537203, 54310.0, 54362.45637543653, 55006.72496637571, 55031.0, 1441.747694153519, 1461.174436443406, 1506.7363211437955, 1518.916459594733, 1532.2491978930466, 29695.70304297016, 30603.0, 32410.35179296448, 32769.18077047997, 33223.83388083044, 50215.497845021084, 50778.74610626923, 50900.490995089574, 50957.235641464664, 50963.0, 316347.0, 316530.0, 317705.0, 318156.0, 319772.0, 34743.4788478168, 34885.65114348824, 34969.650303497656, 35158.0, 46340.30489542727, 42863.78568107139, 43109.137817244104, 43153.56846431496, 43249.0, 43492.8253587313, 36059.81970090133, 36521.81739091394, 37293.81353093217, 37424.43863341997, 37801.432978504796, 36442.45336319904, 38444.23111537698, 38672.41991370075, 39708.60291397049, 40196.1960760789, 40735.18529629332, 40940.59059409368, 41288.174236514504, 43073.56926430821, 44050.0, 32516.0, 32660.836695816368, 32744.836275818467, 33095.66904330926, 34381.0, 27890.581641274992, 28046.158615241577, 28169.57745633776, 28300.716992830632, 28439.857800710863], "unit": "score", "name": "ext.html", "value": 19423.37631751651}, {"lowerIsBetter": false, "replicates": [389.2079617977416, 390.4358202397533, 391.41288067898154, 392.16077593948955, 395.40096753418595, 15278.0, 16477.423290184815, 16617.66764664706, 18453.07734613269, 18535.443936681888, 16302.184890755474, 16519.174041297916, 16549.586260343498, 16810.0, 16990.66018679629, 5002.374703162114, 5239.659422137568, 5503.724813759296, 5509.972450137764, 5515.558755299567, 3947.328954077799, 4087.9182416351655, 5400.621956463049, 5403.054465468547, 5623.4938855503, 5343.625946183769, 5573.052581061209, 5607.355154157263, 5611.270534830466, 5636.661800291975, 5337.786488540453, 5416.593755468336, 5432.75552600134, 5437.510624043815, 5451.3458384993855, 5447.264619276387, 5468.699221542814, 5472.671639701591, 5482.890342193174, 5499.807506737285, 13544.255065971367, 16802.83197168025, 20566.485837854023, 21301.147954081818, 21302.0, 2372.146027430124, 2375.857448553075, 2416.830821842472, 2427.320350301901, 2509.2346834215555, 10182.745431364201, 10218.693439196835, 10266.897331026743, 11484.081273498101, 11916.404179791063, 1949.2885096939656, 1954.5797653504565, 1956.6086782643386, 2037.5619241863071, 2062.5565503416838, 57882.0, 59163.70418147925, 59181.40818591802, 59615.10577341343, 59638.10542841861, 9906.20750339971, 10320.277580569287, 10547.947260263803, 10590.735231619117, 10647.094996925192, 13801.516946907012, 13914.95637827167, 14027.71944561103, 14076.648083797987, 14114.50599229022, 7803.102643196105, 7808.609569521501, 7856.5678887661725, 7859.410544209207, 7898.486598371088, 7517.9099030640255, 7575.128860181149, 7644.273793989562, 7652.846943061108, 7653.349465295512, 3842.615738426135, 4294.76378799169, 4336.132773445323, 4474.753888536162, 4661.184292748755, 1754.7455618935182, 1826.7899191592871, 1847.5196448923107, 1864.636395902786, 1883.3125909043101, 459.9264117741145, 1082.128886246579, 1113.1762495753246, 1130.7568872692411, 1144.016146114341, 11117.888821111846, 11369.943150284362, 11390.974812266935, 11444.427778611036, 11475.827862582068, 497.5348049573588, 510.90548248574135, 528.5903424845775, 534.657818995843, 537.2398056749734, 6192.628442293477, 6307.621542707452, 6329.461995730415, 6339.96830015847, 6388.201474815648, 553585.0, 554859.0, 557448.0, 572825.0, 609927.0, 44522.77738611286, 45449.0, 45526.31710524345, 62301.75396492136, 76081.61959190169, 518.4323166133079, 1185.6561597136733, 1235.5984305100878, 1235.6293112066523, 1235.715785369352, 15329.923350383177, 15390.07659540431, 15435.0, 15441.768373474632, 15753.527394177734, 22726.431839204153, 26278.4744305109, 27038.864805675847, 32474.350512989135, 35496.64503355037, 41758.83490681563, 43519.0, 43911.56088439203, 48863.755681221366, 49839.252411214584, 7527.736529221451, 7890.526568405914, 7939.920600794149, 7940.483868548526, 8160.83678326442, 10352.637657681946, 11083.0, 11296.43517824122, 11553.82669259945, 11892.643220703392, 3141.3246152077413, 9483.810323793623, 9902.405855648683, 10048.899511004796, 10180.13468855126, 10317.587296508056, 10492.737681558023, 10576.4711764413, 10641.148708103488, 10997.780044398907, 10735.624253151102, 10942.671719848417, 11042.171837112088, 11100.5559777608, 11229.55081796719, 8011.679532818622, 8066.878996814935, 8114.918850811417, 8159.143289954469, 8252.298554622925, 10253.692389228336, 10931.398773067558, 11081.390523521284, 11104.944475277573, 11350.318980861175], "unit": "score", "name": "jquery.html", "value": 8036.151864790261}, {"lowerIsBetter": false, "replicates": [1556.1830039229403, 1569.6546759712862, 1749.5101371615951, 1876.1651065275942, 1885.7548518692568, 8042.195780421955, 8111.837763244739, 8161.306288965445, 8332.000159980804, 8349.624266907997, 8316.29311508521, 8361.456505327149, 8389.958050209756, 8460.66157353705, 8480.66077356905, 2357.398863289863, 2371.9525609487887, 2395.149721848745, 2395.64065390192, 2400.6399040143942, 2418.2745176446997, 2443.3647251714506, 2461.3354394313524, 2463.6427717980973, 2477.9008839646394, 2367.5264947010583, 2391.1152873436768, 2408.5784987627185, 2424.5635785558593, 2425.0, 2403.927882163538, 2416.1664225842055, 2425.0905910283645, 2425.9029638814427, 2428.1622840120217, 2325.6976593042796, 2348.765123487655, 2362.2795047510504, 2372.1934542255717, 2378.191414918936, 8251.216134467217, 8321.375896807704, 8322.83354332916, 8325.916740832574, 8326.2506374426, 4877.878053048702, 4978.925316120261, 5016.49835016499, 5020.497950204986, 5025.346704928373, 3274.787138835968, 3306.0908250231378, 3378.6114596821435, 3407.5910890693026, 3435.7594968352223, 1083.3283364314098, 1089.2647462962468, 1105.4528008635777, 1112.4382186995597, 1125.831125331207, 11190.160737944687, 11318.830217546743, 11356.091512679048, 11360.147988900782, 11373.658790236306, 4289.571042895748, 4299.226139294957, 4396.780160991938, 4427.734335939854, 4430.357598148251, 8983.281337492985, 9005.504697241584, 9022.503762293005, 9038.0, 9038.909610903807, 4836.395450568679, 4869.464358920516, 4875.658703890694, 4880.170371036932, 4886.242632391985, 4428.7121337112985, 4453.22068637987, 4456.309272062836, 4501.887452813706, 4506.076254367912, 3552.378333791576, 3631.782093074424, 3641.890743277706, 3643.653852883972, 3662.3957047086933, 1099.796537640539, 1112.9165312601588, 1114.0474893965543, 1118.681175864891, 1119.994400028011, 990.8067926754213, 993.6919554937992, 1218.4516967364543, 1324.24518024725, 1430.6924011337612, 7776.572288524072, 7841.372690184771, 7883.960580197062, 7928.405369597303, 8059.597020148969, 1176.7293522489874, 1180.9822852657217, 1185.8458400408065, 1185.9347735874437, 1205.5358686905604, 6181.196444462191, 6197.194364732556, 6218.471429928416, 6249.187605611332, 6259.874802504016, 9613.375130616627, 9826.65606703762, 9870.753231169134, 9934.50327483623, 9980.45107519079, 9575.712728618153, 9678.56446459911, 9786.75533111678, 9802.705918822447, 9804.901950980398, 7788.649510772028, 7789.7273595423885, 7822.4524283299625, 7852.882206766903, 7863.842723145505, 7629.237076292548, 7637.541747495168, 7719.652615632198, 7756.650950707344, 7881.881771773543, 8801.823963520821, 8960.551972401223, 8976.192142707188, 9024.187823095954, 9095.226905713089, 9185.265178785814, 9250.259979201783, 9294.0, 9302.48836313982, 9341.392809467363, 7389.630518474162, 7562.205968373241, 7564.735234266775, 7573.0, 7589.582572958319, 7904.84190316202, 7952.562609056326, 7966.203379661987, 8020.759377218693, 8023.518588884685, 7317.414606831547, 7652.502587331805, 7685.5004424712215, 7718.151003389735, 7723.266289702469, 7348.669309881175, 7373.29953654402, 7416.0729908761405, 7464.066991626047, 7539.170691224071, 7346.77959661211, 7350.301721336465, 7371.741989030358, 7382.704691812482, 7390.0, 6490.513211509061, 6573.5069869759, 6602.207735071822, 6606.8017959461295, 6654.201495820533, 6670.799876003728, 6746.595204287759, 6855.07456493367, 6866.279040700654, 6877.4841886857685], "unit": "score", "name": "mootools.html", "value": 4742.104249533137}, {"lowerIsBetter": false, "replicates": [357.93557159711247, 372.76515795049124, 374.9025253434106, 377.70538979595926, 381.60694484680755, 6399.552031357807, 6405.0, 6434.099226108348, 6455.451286640635, 6639.302873198317, 6358.554901156921, 6396.200474940632, 6407.647579383132, 6409.070684750708, 6428.3250258722865, 4884.853454396365, 4889.095517329305, 4894.265860120992, 4906.754662266891, 4915.459299477055, 4870.902581948359, 4875.902481950359, 4876.878078048059, 4881.048195601859, 4937.210046392578, 4756.5243475652505, 4839.975800120995, 4867.659263851532, 4885.413750349963, 4885.828995985141, 4850.272459131141, 4870.683405578644, 4875.390576177978, 4881.902361952741, 4896.0, 4254.361845723135, 4268.445102136733, 4268.527358061464, 4269.444972153631, 4270.910917715963, 6104.267487901436, 6118.571699981003, 6126.877462450726, 6132.294786099611, 6150.907736383958, 5505.229267902497, 5675.801346952878, 5692.800751973661, 5734.569907256972, 5747.3677895431465, 6756.425703815182, 6791.219009813836, 6806.421454176401, 6810.863782724367, 6819.147606549182, 4743.241081426955, 4753.643476739224, 4758.738269395182, 4773.641976851715, 4783.043391321715, 7036.40190583801, 7073.398761105261, 7115.395191408788, 7124.786256412264, 7140.28597140287, 4850.563449289581, 4857.684250523705, 4865.513448655177, 4865.781039853215, 4866.0, 4942.728149951788, 4943.8022479101155, 4945.431275403303, 4946.258061290763, 4954.1825598775795, 5576.944230557724, 5689.715514224355, 5707.828765137053, 5707.971460142673, 5710.371859095496, 6822.249552549216, 6845.110135682329, 6850.965745171242, 6853.725850966005, 6857.142857142857, 1697.4737831272346, 1736.4182998695578, 1758.5251981964798, 1759.1731886013554, 1762.6122253104297, 1153.1524329617723, 1167.3521195736278, 1170.017185564113, 1177.9057675385948, 1179.1215544419463, 6447.516436267299, 6472.644004579794, 6473.417392434703, 6474.061261117112, 6509.967450162719, 6909.585424874524, 6943.930560694328, 6951.443884489228, 7000.474964377692, 7017.824554386079, 6399.243987963437, 6457.61254324742, 6463.321351258144, 6471.255805582418, 6501.0898474213645, 3793.3551296279697, 3796.4495148203355, 3802.9239415212096, 3813.370793819044, 3814.4659747634796, 7213.531120477152, 7227.205007449176, 7228.746993855189, 7242.782716518513, 7249.891251631229, 6969.23338432772, 7127.821804454827, 7195.280471952763, 7231.349178573953, 7247.057882475245, 7167.677454514559, 7210.855782884313, 7217.639118044077, 7222.783316500409, 7225.313595208447, 6959.860802784017, 6979.267176946348, 6985.336393042653, 6986.720531178899, 7011.26381729911, 6733.7306507741105, 6838.2136054352395, 6852.6916288768125, 6866.553674011173, 6887.827804304932, 7134.714611415693, 7160.140783106061, 7178.353948144692, 7191.928080719335, 7194.928050719635, 4819.855404337875, 4858.6356023297685, 4860.270959356125, 4864.148773964613, 4879.975600121977, 6835.658217089225, 6957.478189135733, 6994.930050699428, 7006.719731210695, 7130.643467826691, 6913.792586222421, 6957.9304206959305, 6959.19969203548, 6980.825479362853, 7008.0889484368745, 6896.413804826445, 6965.268646792217, 6971.058907047483, 6972.651367431709, 7000.579965202104, 6730.764423245163, 6781.423578995643, 6843.452523798183, 6866.828329291808, 6873.553219040747, 6962.756303529555, 6982.33667801558, 7006.194287656985, 7012.228654848064, 7014.754483593049, 6733.797986060426, 6814.625195614289, 6837.726490940307, 6857.417119544695, 6863.416609588041], "unit": "score", "name": "prototype.html", "value": 5152.892596225139}, {"lowerIsBetter": false, "replicates": [810.2748040503753, 818.3984771193176, 945.7304668169573, 945.7966537194503, 951.2960409297118, 14190.0, 14205.502807401743, 14205.502807401743, 14331.06848054877, 14334.211618361, 13607.115537490055, 13612.863871361309, 13622.727545449085, 13626.0, 13630.182189068662, 855.9144085591438, 882.07382248639, 905.1265528764741, 910.0399078971715, 912.6760000199934, 896.318797713739, 897.5243121145803, 899.8200359928007, 902.2060586683709, 904.7240591619553, 932.673564252513, 942.3686130292687, 943.504660053474, 944.1644144931751, 946.5740416812428, 916.2029034739786, 925.6852670092134, 931.1247427418206, 937.9963439120144, 938.4322484896608, 691.0808624529363, 693.3586432549921, 693.4244577001077, 696.3245651717876, 696.8745625787357, 14223.928880355636, 14370.856291437056, 14393.856061439355, 14402.711945761026, 14594.562163135122, 11993.280403175837, 12898.935505322506, 13464.326783660777, 13652.522161724291, 13836.723265534632, 10993.34039957597, 11054.613088541942, 11232.3260604364, 11323.773524529546, 11617.361045142514, 3848.3073046851555, 3875.922481550353, 3886.5336159661024, 3911.8826435206706, 3915.6882444381167, 52301.47698523004, 52743.0, 52980.47019529794, 53105.0, 53180.46819531794, 10374.22193335503, 10630.521626526825, 10632.936706329305, 10774.97637724415, 10821.24251302417, 19269.0, 19281.807181928, 19406.514837129183, 19454.0, 19490.902545487465, 8375.288100511403, 8488.660453581911, 8563.0, 8687.739367818975, 8739.781505462413, 4486.730796152241, 4684.625229981593, 4720.811167553259, 4733.810647574059, 4809.0862736080035, 3205.4550726376574, 3242.400155971153, 3245.3996010738088, 3250.8537115829845, 3255.4628486299493, 615.8460384903774, 617.8702472480829, 617.9567430279927, 622.8941080016408, 629.2449061126666, 684.7706018483864, 705.4990956420999, 729.8321386081232, 735.2463724682243, 739.6264886232418, 8740.086705632923, 9523.52382380892, 9673.081057299545, 9699.806003879883, 10446.895531044593, 624.2758400255682, 640.2445114764529, 729.2670865779858, 751.8421131562433, 784.2353705137446, 4408.6693497987135, 4457.576530229623, 4472.351509031172, 4595.6193338442, 4900.093482705711, 59364.10953835696, 59655.70172149112, 60844.695776520835, 60952.390476095556, 61173.0, 48709.26936095962, 52073.21890171651, 53137.202941955904, 53310.73344633252, 53382.19926701103, 48547.757261214174, 48947.26579101316, 49039.0, 49329.75335123301, 50479.747601261755, 9548.809023819624, 9650.276229282692, 9681.757956051155, 9826.557804898654, 9927.305088643725, 36824.81587592045, 40464.39303410392, 40724.59275407208, 41826.581734183485, 41831.163376732904, 48729.26906096341, 50925.74537127439, 52062.47937520577, 52353.47646523486, 54825.725871370385, 11674.94162529182, 12190.451429685509, 12359.567415140427, 12889.677758055748, 12891.742165156831, 13792.241426721626, 13885.375158117708, 13979.09135906163, 14465.349059292568, 14495.202763847668, 12456.439460224494, 12666.304980812121, 12871.485140594272, 12895.48418063267, 13246.933765331112, 12280.938595306967, 12552.74894502123, 12976.935115324362, 13286.53497127596, 14564.344604492611, 12977.870221297666, 13060.477580897037, 13101.213927164019, 13257.270850103338, 13556.38996245191, 9701.6604418845, 9766.902330976884, 10457.581696732046, 10504.842427363443, 10813.351198928089, 10244.231682623684, 10412.47937603132, 10622.681319560426, 10690.251682382159, 10711.25021248505], "unit": "score", "name": "yui.html", "value": 6929.883550882525}], "name": "dromaeo_css", "value": 7240.7636171568065}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 107.0, 112.0, 111.0, 111.0, 121.0, 111.0, 112.0, 111.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.1}, {"lowerIsBetter": true, "replicates": [157.0, 127.0, 156.0, 158.0, 126.0, 153.0, 159.0, 123.0, 161.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 145.4}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 160.0, 160.0, 164.0, 160.0, 160.0, 162.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [75.0, 75.0, 73.0, 143.0, 77.0, 78.0, 75.0, 76.0, 149.0, 76.0], "unit": "score", "name": "audio-fft", "value": 89.7}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 140.0, 95.0, 95.0, 95.0, 137.0, 95.0, 95.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 108.4}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 110.0, 109.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [149.0, 148.0, 147.0, 146.0, 147.0, 146.0, 148.0, 148.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [55.0, 58.0, 57.0, 58.0, 58.0, 57.0, 57.0, 64.0, 57.0, 60.0], "unit": "score", "name": "json-parse-financial", "value": 58.1}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 64.0, 64.0, 64.0, 65.0, 66.0, 66.0, 64.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.1}, {"lowerIsBetter": true, "replicates": [79.0, 80.0, 82.0, 81.0, 82.0, 82.0, 89.0, 82.0, 83.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.0}, {"lowerIsBetter": true, "replicates": [112.0, 117.0, 112.0, 116.0, 113.0, 111.0, 109.0, 117.0, 115.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 113.7}, {"lowerIsBetter": true, "replicates": [137.0, 138.0, 142.0, 139.0, 149.0, 142.0, 138.0, 140.0, 136.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.2}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 67.0, 67.0, 67.0, 67.0, 65.0, 66.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1495.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.03898504453034], "unit": "score", "name": "Richards", "value": 210.08220199999997}, {"lowerIsBetter": false, "replicates": [170.7067258449983], "unit": "score", "name": "DeltaBlue", "value": 387.31924399999986}, {"lowerIsBetter": false, "replicates": [288.0184331797235], "unit": "score", "name": "Encrypt", "value": 924.180432}, {"lowerIsBetter": false, "replicates": [5164.948453608247], "unit": "score", "name": "Decrypt", "value": 51.53604191616765}, {"lowerIsBetter": false, "replicates": [929.368029739777], "unit": "score", "name": "RayTrace", "value": 796.2281640000003}, {"lowerIsBetter": false, "replicates": [547.0459518599563], "unit": "score", "name": "Earley", "value": 1218.294364}, {"lowerIsBetter": false, "replicates": [11054.945054945056], "unit": "score", "name": "Boyer", "value": 60.28641451292241}, {"lowerIsBetter": false, "replicates": [40215.686274509804], "unit": "score", "name": "RegExp", "value": 22.652479278400794}, {"lowerIsBetter": false, "replicates": [509.4147582697201], "unit": "score", "name": "Splay", "value": 159.96984515484507}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 22004.549349918558}]} 22:45:07 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "22004.55"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1495.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7240.76"}}} 22:45:07 INFO - Return code: 0 22:45:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:45:07 INFO - # TBPL SUCCESS # 22:45:07 INFO - Running post-action listener: _resource_record_post_action 22:45:07 INFO - Running post-run listener: _resource_record_post_run 22:45:08 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 475136; Write bytes: 518316032; Read time: 60; Write time: 475540 22:45:08 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 253403136; Read time: 0; Write time: 297836 22:45:08 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 475136; Write bytes: 264912896; Read time: 60; Write time: 177704 22:45:08 INFO - Running post-run listener: _upload_blobber_files 22:45:08 INFO - Blob upload gear active. 22:45:08 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:45:08 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 22:45:08 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'] 22:45:08 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 22:45:08 INFO - (blobuploader) - INFO - Open directory for files ... 22:45:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:45:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:45:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:45:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:45:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:45:09 INFO - (blobuploader) - INFO - Done attempting. 22:45:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:45:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:45:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:45:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:45:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:45:10 INFO - (blobuploader) - INFO - Done attempting. 22:45:10 INFO - (blobuploader) - INFO - Iteration through files over. 22:45:10 INFO - Return code: 0 22:45:10 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:45:10 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:45:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a26806c341a731a5790f2a388a519ebc415a863bc530874e67f1ccdeee9c782269b7bfb81a975386f4356a932dc9e272c2e9dfd2bf2c1bf132d4b0868ed035c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e1d4c82077ff5b71e0bcfa16f1ea443ab1592e49ad61cb881abd47c6dbd8d94cc6695c049eb574744afda60422be6921db3c9e217345ad75a9191bf9a9ff111"} 22:45:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:45:10 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:45:10 INFO - Contents: 22:45:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a26806c341a731a5790f2a388a519ebc415a863bc530874e67f1ccdeee9c782269b7bfb81a975386f4356a932dc9e272c2e9dfd2bf2c1bf132d4b0868ed035c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e1d4c82077ff5b71e0bcfa16f1ea443ab1592e49ad61cb881abd47c6dbd8d94cc6695c049eb574744afda60422be6921db3c9e217345ad75a9191bf9a9ff111"} 22:45:10 INFO - Running post-run listener: copy_logs_to_upload_dir 22:45:10 INFO - Copying logs to upload dir... 22:45:10 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:45:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.057731 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-03-02 22:45:10.584114) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-02 22:45:10.587332) ========= 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=652eb03db935cfc1c15ebda0000001ad-1456986244.149091-425265301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a26806c341a731a5790f2a388a519ebc415a863bc530874e67f1ccdeee9c782269b7bfb81a975386f4356a932dc9e272c2e9dfd2bf2c1bf132d4b0868ed035c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e1d4c82077ff5b71e0bcfa16f1ea443ab1592e49ad61cb881abd47c6dbd8d94cc6695c049eb574744afda60422be6921db3c9e217345ad75a9191bf9a9ff111"} build_url:https://queue.taskcluster.net/v1/task/ZHwCgBIEQpyyHlaV7k-tvA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011395 build_url: 'https://queue.taskcluster.net/v1/task/ZHwCgBIEQpyyHlaV7k-tvA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a26806c341a731a5790f2a388a519ebc415a863bc530874e67f1ccdeee9c782269b7bfb81a975386f4356a932dc9e272c2e9dfd2bf2c1bf132d4b0868ed035c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e1d4c82077ff5b71e0bcfa16f1ea443ab1592e49ad61cb881abd47c6dbd8d94cc6695c049eb574744afda60422be6921db3c9e217345ad75a9191bf9a9ff111"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-02 22:45:10.611782) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 22:45:10.612100) ========= 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=652eb03db935cfc1c15ebda0000001ad-1456986244.149091-425265301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004720 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 22:45:10.663173) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-02 22:45:10.663488) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-02 22:45:10.663786) ========= ========= Total master_lag: 0.23 =========