builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-034 starttime: 1456337751.98 results: success (0) buildid: 20160224073519 builduid: b13a5a743eea481bbc4b777b1eadd0b7 revision: 50b1c7bdf690b9d011fe5827b15a04e14a0d5fa8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 10:15:51.975682) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 10:15:51.976046) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 10:15:51.976332) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1456336816.224511-2044066368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006691 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 10:15:52.000607) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 10:15:52.000871) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 10:15:52.014310) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:15:52.014607) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1456336816.224511-2044066368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004648 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:15:52.066546) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 10:15:52.067378) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 10:15:52.068165) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:15:52.068797) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1456336816.224511-2044066368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-24 10:15:52-- 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% 73.1M=0s 2016-02-24 10:15:52 (73.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158020 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:15:52.240084) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:15:52.240407) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1456336816.224511-2044066368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020586 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:15:52.289696) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:15:52.290054) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 50b1c7bdf690b9d011fe5827b15a04e14a0d5fa8 --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 50b1c7bdf690b9d011fe5827b15a04e14a0d5fa8 --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=d6bbd613908ccac0c6c9cb47000001f7-1456336816.224511-2044066368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-24 10:15:52,583 truncating revision to first 12 chars 2016-02-24 10:15:52,583 Setting DEBUG logging. 2016-02-24 10:15:52,583 attempt 1/10 2016-02-24 10:15:52,583 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/50b1c7bdf690?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-24 10:15:52,836 unpacking tar archive at: mozilla-aurora-50b1c7bdf690/testing/mozharness/ program finished with exit code 0 elapsedTime=0.547586 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:15:52.851542) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 10:15:52.851927) ========= echo 50b1c7bdf690b9d011fe5827b15a04e14a0d5fa8 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'50b1c7bdf690b9d011fe5827b15a04e14a0d5fa8'] 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=d6bbd613908ccac0c6c9cb47000001f7-1456336816.224511-2044066368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 50b1c7bdf690b9d011fe5827b15a04e14a0d5fa8 program finished with exit code 0 elapsedTime=0.003967 script_repo_revision: '50b1c7bdf690b9d011fe5827b15a04e14a0d5fa8' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 10:15:52.901562) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 10:15:52.901916) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 10:15:52.912108) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-02-24 10:15:52.912514) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1456336816.224511-2044066368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:15:53 INFO - MultiFileLogger online at 20160224 10:15:53 in /builds/slave/test-pgo 10:15:53 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 10:15:53 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:15:53 INFO - {'append_to_log': False, 10:15:53 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:15:53 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:15:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:15:53 INFO - 'branch': 'Mozilla-Aurora', 10:15:53 INFO - 'buildbot_json_path': 'buildprops.json', 10:15:53 INFO - 'config_files': ('talos/linux_config.py',), 10:15:53 INFO - 'default_actions': ('clobber', 10:15:53 INFO - 'read-buildbot-config', 10:15:53 INFO - 'download-and-extract', 10:15:53 INFO - 'populate-webroot', 10:15:53 INFO - 'create-virtualenv', 10:15:53 INFO - 'install', 10:15:53 INFO - 'run-tests'), 10:15:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:15:53 INFO - 'download_minidump_stackwalk': True, 10:15:53 INFO - 'download_symbols': 'ondemand', 10:15:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:15:53 INFO - 'tooltool.py': '/tools/tooltool.py', 10:15:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:15:53 INFO - '/tools/misc-python/virtualenv.py')}, 10:15:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:15:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:15:53 INFO - 'installer_path': 'installer.exe', 10:15:53 INFO - 'log_level': 'info', 10:15:53 INFO - 'log_name': 'talos', 10:15:53 INFO - 'log_to_console': True, 10:15:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:15:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:15:53 INFO - 'opt_config_files': (), 10:15:53 INFO - 'pip_index': False, 10:15:53 INFO - 'sps_profile': False, 10:15:53 INFO - 'sps_profile_interval': 0, 10:15:53 INFO - 'suite': 'dromaeojs-e10s', 10:15:53 INFO - 'system_bits': '32', 10:15:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:15:53 INFO - 'title': 'talos-linux64-ix-034', 10:15:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:15:53 INFO - 'use_talos_json': True, 10:15:53 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:15:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:15:53 INFO - 'work_dir': 'build'} 10:15:53 INFO - ##### 10:15:53 INFO - ##### Running clobber step. 10:15:53 INFO - ##### 10:15:53 INFO - Running pre-action listener: _resource_record_pre_action 10:15:53 INFO - Running main action method: clobber 10:15:53 INFO - rmtree: /builds/slave/test-pgo/build 10:15:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:15:54 INFO - Running post-action listener: _resource_record_post_action 10:15:54 INFO - ##### 10:15:54 INFO - ##### Running read-buildbot-config step. 10:15:54 INFO - ##### 10:15:54 INFO - Running pre-action listener: _resource_record_pre_action 10:15:54 INFO - Running main action method: read_buildbot_config 10:15:54 INFO - Using buildbot properties: 10:15:54 INFO - { 10:15:54 INFO - "project": "", 10:15:54 INFO - "product": "firefox", 10:15:54 INFO - "script_repo_revision": "production", 10:15:54 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 10:15:54 INFO - "repository": "", 10:15:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 10:15:54 INFO - "buildid": "20160224073519", 10:15:54 INFO - "pgo_build": "True", 10:15:54 INFO - "basedir": "/builds/slave/test-pgo", 10:15:54 INFO - "buildnumber": 153, 10:15:54 INFO - "slavename": "talos-linux64-ix-034", 10:15:54 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:15:54 INFO - "platform": "ubuntu64_hw", 10:15:54 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:15:54 INFO - "branch": "mozilla-aurora", 10:15:54 INFO - "repo_path": "releases/mozilla-aurora", 10:15:54 INFO - "revision": "50b1c7bdf690b9d011fe5827b15a04e14a0d5fa8", 10:15:54 INFO - "stage_platform": "linux64-pgo", 10:15:54 INFO - "builduid": "b13a5a743eea481bbc4b777b1eadd0b7", 10:15:54 INFO - "slavebuilddir": "test" 10:15:54 INFO - } 10:15:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/c3F7PVDpSfKdUdXACnHGIg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 10:15:54 INFO - Running post-action listener: _resource_record_post_action 10:15:54 INFO - ##### 10:15:54 INFO - ##### Running download-and-extract step. 10:15:54 INFO - ##### 10:15:54 INFO - Running pre-action listener: _resource_record_pre_action 10:15:54 INFO - Running main action method: download_and_extract 10:15:54 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:54 INFO - https://queue.taskcluster.net/v1/task/c3F7PVDpSfKdUdXACnHGIg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:15:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3F7PVDpSfKdUdXACnHGIg/artifacts/public/build/test_packages.json 10:15:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3F7PVDpSfKdUdXACnHGIg/artifacts/public/build/test_packages.json 10:15:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3F7PVDpSfKdUdXACnHGIg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:15:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3F7PVDpSfKdUdXACnHGIg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:15:54 INFO - Downloaded 1448 bytes. 10:15:54 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:15:54 INFO - Using the following test package requirements: 10:15:54 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 10:15:54 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 10:15:54 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:15:54 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 10:15:54 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:15:54 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 10:15:54 INFO - u'jsshell-linux-x86_64.zip'], 10:15:54 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 10:15:54 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:15:54 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 10:15:54 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 10:15:54 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:15:54 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 10:15:54 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:15:54 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 10:15:54 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:15:54 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 10:15:54 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 10:15:54 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:15:54 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:54 INFO - https://queue.taskcluster.net/v1/task/c3F7PVDpSfKdUdXACnHGIg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:15:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3F7PVDpSfKdUdXACnHGIg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 10:15:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3F7PVDpSfKdUdXACnHGIg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 10:15:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3F7PVDpSfKdUdXACnHGIg/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 10:15:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3F7PVDpSfKdUdXACnHGIg/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 10:15:56 INFO - Downloaded 23079311 bytes. 10:15:56 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'] 10:15:56 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 10:15:57 INFO - Return code: 0 10:15:57 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 10:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:57 INFO - https://queue.taskcluster.net/v1/task/c3F7PVDpSfKdUdXACnHGIg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:15:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3F7PVDpSfKdUdXACnHGIg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 10:15:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3F7PVDpSfKdUdXACnHGIg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 10:15:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3F7PVDpSfKdUdXACnHGIg/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 10:15:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3F7PVDpSfKdUdXACnHGIg/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 10:15:58 INFO - Downloaded 23079311 bytes. 10:15:58 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'] 10:15:58 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 10:15:59 INFO - Return code: 0 10:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:59 INFO - https://queue.taskcluster.net/v1/task/c3F7PVDpSfKdUdXACnHGIg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:15:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3F7PVDpSfKdUdXACnHGIg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 10:15:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3F7PVDpSfKdUdXACnHGIg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 10:15:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3F7PVDpSfKdUdXACnHGIg/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 10:15:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3F7PVDpSfKdUdXACnHGIg/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 10:16:00 INFO - Downloaded 10706572 bytes. 10:16:00 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'] 10:16:00 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 10:16:01 INFO - Return code: 0 10:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:01 INFO - https://queue.taskcluster.net/v1/task/c3F7PVDpSfKdUdXACnHGIg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:16:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3F7PVDpSfKdUdXACnHGIg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 10:16:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3F7PVDpSfKdUdXACnHGIg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 10:16:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3F7PVDpSfKdUdXACnHGIg/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 10:16:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3F7PVDpSfKdUdXACnHGIg/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 10:16:02 INFO - Downloaded 59965081 bytes. 10:16:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c3F7PVDpSfKdUdXACnHGIg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 10:16:02 INFO - mkdir: /builds/slave/test-pgo/properties 10:16:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:16:02 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:16:02 INFO - Contents: 10:16:02 INFO - build_url:https://queue.taskcluster.net/v1/task/c3F7PVDpSfKdUdXACnHGIg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 10:16:03 INFO - Running post-action listener: _resource_record_post_action 10:16:03 INFO - Running post-action listener: set_extra_try_arguments 10:16:03 INFO - ##### 10:16:03 INFO - ##### Running populate-webroot step. 10:16:03 INFO - ##### 10:16:03 INFO - Running pre-action listener: _resource_record_pre_action 10:16:03 INFO - Running main action method: populate_webroot 10:16:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:16:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:16:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:16:03 INFO - '--tppagecycles', 10:16:03 INFO - '7'], 10:16:03 INFO - 'tests': ['tsvgm']}}, 10:16:03 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:16:03 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:16:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:16:03 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:16:03 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:16:03 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:16:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:16:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:03 INFO - 'talos_options': ['--e10s'], 10:16:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:16:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:03 INFO - 'tests': ['damp', 'tps']}, 10:16:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:03 INFO - 'talos_options': ['--e10s'], 10:16:03 INFO - 'tests': ['damp', 'tps']}, 10:16:03 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:16:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:16:03 INFO - 'other': {'tests': ['a11yr', 10:16:03 INFO - 'ts_paint', 10:16:03 INFO - 'tpaint', 10:16:03 INFO - 'sessionrestore', 10:16:03 INFO - 'sessionrestore_no_auto_restore']}, 10:16:03 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:16:03 INFO - 'tests': ['a11yr', 10:16:03 INFO - 'ts_paint', 10:16:03 INFO - 'tpaint', 10:16:03 INFO - 'sessionrestore', 10:16:03 INFO - 'sessionrestore_no_auto_restore']}, 10:16:03 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:16:03 INFO - 'tests': ['a11yr', 10:16:03 INFO - 'ts_paint', 10:16:03 INFO - 'tpaint', 10:16:03 INFO - 'sessionrestore', 10:16:03 INFO - 'sessionrestore_no_auto_restore']}, 10:16:03 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:16:03 INFO - 'tests': ['a11yr', 10:16:03 INFO - 'ts_paint', 10:16:03 INFO - 'tpaint', 10:16:03 INFO - 'sessionrestore', 10:16:03 INFO - 'sessionrestore_no_auto_restore']}, 10:16:03 INFO - 'other_l64': {'tests': ['a11yr', 10:16:03 INFO - 'ts_paint', 10:16:03 INFO - 'tpaint', 10:16:03 INFO - 'sessionrestore', 10:16:03 INFO - 'sessionrestore_no_auto_restore']}, 10:16:03 INFO - 'other_nol64': {'tests': ['a11yr', 10:16:03 INFO - 'ts_paint', 10:16:03 INFO - 'tpaint', 10:16:03 INFO - 'sessionrestore', 10:16:03 INFO - 'sessionrestore_no_auto_restore']}, 10:16:03 INFO - 'svgr': {'tests': ['tsvgx', 10:16:03 INFO - 'tsvgr_opacity', 10:16:03 INFO - 'tart', 10:16:03 INFO - 'tscrollx', 10:16:03 INFO - 'cart']}, 10:16:03 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:16:03 INFO - 'tests': ['tsvgx', 10:16:03 INFO - 'tsvgr_opacity', 10:16:03 INFO - 'tart', 10:16:03 INFO - 'tscrollx', 10:16:03 INFO - 'cart']}, 10:16:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:03 INFO - 'tests': ['tp5o']}, 10:16:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:03 INFO - 'talos_options': ['--e10s'], 10:16:03 INFO - 'tests': ['tp5o']}, 10:16:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:03 INFO - 'talos_options': ['--xperf_path', 10:16:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:16:03 INFO - 'tests': ['tp5n']}, 10:16:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:03 INFO - 'talos_options': ['--e10s', 10:16:03 INFO - '--xperf_path', 10:16:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:16:03 INFO - 'tests': ['tp5n']}}, 10:16:03 INFO - 'talos.zip': {'path': '', 10:16:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:16:03 INFO - Running post-action listener: _resource_record_post_action 10:16:03 INFO - ##### 10:16:03 INFO - ##### Running create-virtualenv step. 10:16:03 INFO - ##### 10:16:03 INFO - Running pre-action listener: _resource_record_pre_action 10:16:03 INFO - Running main action method: create_virtualenv 10:16:03 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:16:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 10:16:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:16:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:16:03 INFO - Using real prefix '/usr' 10:16:03 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:16:04 INFO - Installing distribute.............................................................................................................................................................................................done. 10:16:06 INFO - Installing pip.................done. 10:16:06 INFO - Return code: 0 10:16:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:06 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 0x7f50ae72af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a94230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b267f0>, '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 0x2a922d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a92760>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1456336816.224511-2044066368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:16:06 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 10:16:06 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 10:16:06 INFO - Using env: {'DISPLAY': ':0', 10:16:06 INFO - 'HOME': '/home/cltbld', 10:16:06 INFO - 'LANG': 'en_US.UTF-8', 10:16:06 INFO - 'LANGUAGE': 'en_US:en', 10:16:06 INFO - 'LOGNAME': 'cltbld', 10:16:06 INFO - 'MAIL': '/var/mail/cltbld', 10:16:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:06 INFO - 'MOZ_NO_REMOTE': '1', 10:16:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:06 INFO - 'NO_EM_RESTART': '1', 10:16:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:16:06 INFO - 'PWD': '/builds/slave/test-pgo', 10:16:06 INFO - 'SHELL': '/bin/bash', 10:16:06 INFO - 'SHLVL': '1', 10:16:06 INFO - 'TERM': 'linux', 10:16:06 INFO - 'TMOUT': '86400', 10:16:06 INFO - 'USER': 'cltbld', 10:16:06 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1456336816.224511-2044066368', 10:16:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:06 INFO - '_': '/tools/buildbot/bin/python'} 10:16:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:16:06 INFO - Cleaning up... 10:16:06 INFO - Return code: 0 10:16:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:06 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 0x7f50ae72af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a94230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b267f0>, '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 0x2a922d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a92760>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1456336816.224511-2044066368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:16:06 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 10:16:06 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 10:16:06 INFO - Using env: {'DISPLAY': ':0', 10:16:06 INFO - 'HOME': '/home/cltbld', 10:16:06 INFO - 'LANG': 'en_US.UTF-8', 10:16:06 INFO - 'LANGUAGE': 'en_US:en', 10:16:06 INFO - 'LOGNAME': 'cltbld', 10:16:06 INFO - 'MAIL': '/var/mail/cltbld', 10:16:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:06 INFO - 'MOZ_NO_REMOTE': '1', 10:16:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:06 INFO - 'NO_EM_RESTART': '1', 10:16:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:16:06 INFO - 'PWD': '/builds/slave/test-pgo', 10:16:06 INFO - 'SHELL': '/bin/bash', 10:16:06 INFO - 'SHLVL': '1', 10:16:06 INFO - 'TERM': 'linux', 10:16:06 INFO - 'TMOUT': '86400', 10:16:06 INFO - 'USER': 'cltbld', 10:16:06 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1456336816.224511-2044066368', 10:16:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:06 INFO - '_': '/tools/buildbot/bin/python'} 10:16:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:06 INFO - Downloading/unpacking psutil>=0.7.1 10:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:16:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:16:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:16:08 INFO - Installing collected packages: psutil 10:16:08 INFO - Running setup.py install for psutil 10:16:08 INFO - building 'psutil._psutil_linux' extension 10:16:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:16:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:16:08 INFO - building 'psutil._psutil_posix' extension 10:16:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:16:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:16:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:16:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:16:08 INFO - Successfully installed psutil 10:16:08 INFO - Cleaning up... 10:16:09 INFO - Return code: 0 10:16:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:09 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 0x7f50ae72af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a94230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b267f0>, '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 0x2a922d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a92760>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1456336816.224511-2044066368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:16:09 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 10:16:09 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 10:16:09 INFO - Using env: {'DISPLAY': ':0', 10:16:09 INFO - 'HOME': '/home/cltbld', 10:16:09 INFO - 'LANG': 'en_US.UTF-8', 10:16:09 INFO - 'LANGUAGE': 'en_US:en', 10:16:09 INFO - 'LOGNAME': 'cltbld', 10:16:09 INFO - 'MAIL': '/var/mail/cltbld', 10:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:09 INFO - 'MOZ_NO_REMOTE': '1', 10:16:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:09 INFO - 'NO_EM_RESTART': '1', 10:16:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:16:09 INFO - 'PWD': '/builds/slave/test-pgo', 10:16:09 INFO - 'SHELL': '/bin/bash', 10:16:09 INFO - 'SHLVL': '1', 10:16:09 INFO - 'TERM': 'linux', 10:16:09 INFO - 'TMOUT': '86400', 10:16:09 INFO - 'USER': 'cltbld', 10:16:09 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1456336816.224511-2044066368', 10:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:09 INFO - '_': '/tools/buildbot/bin/python'} 10:16:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:16:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:16:11 INFO - Installing collected packages: mozsystemmonitor 10:16:11 INFO - Running setup.py install for mozsystemmonitor 10:16:11 INFO - Successfully installed mozsystemmonitor 10:16:11 INFO - Cleaning up... 10:16:11 INFO - Return code: 0 10:16:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:11 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 0x7f50ae72af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a94230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b267f0>, '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 0x2a922d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a92760>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1456336816.224511-2044066368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:16:11 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 10:16:11 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 10:16:11 INFO - Using env: {'DISPLAY': ':0', 10:16:11 INFO - 'HOME': '/home/cltbld', 10:16:11 INFO - 'LANG': 'en_US.UTF-8', 10:16:11 INFO - 'LANGUAGE': 'en_US:en', 10:16:11 INFO - 'LOGNAME': 'cltbld', 10:16:11 INFO - 'MAIL': '/var/mail/cltbld', 10:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:11 INFO - 'MOZ_NO_REMOTE': '1', 10:16:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:11 INFO - 'NO_EM_RESTART': '1', 10:16:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:16:11 INFO - 'PWD': '/builds/slave/test-pgo', 10:16:11 INFO - 'SHELL': '/bin/bash', 10:16:11 INFO - 'SHLVL': '1', 10:16:11 INFO - 'TERM': 'linux', 10:16:11 INFO - 'TMOUT': '86400', 10:16:11 INFO - 'USER': 'cltbld', 10:16:11 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1456336816.224511-2044066368', 10:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:11 INFO - '_': '/tools/buildbot/bin/python'} 10:16:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:11 INFO - Downloading/unpacking blobuploader==1.2.4 10:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:13 INFO - Downloading blobuploader-1.2.4.tar.gz 10:16:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:16:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:16:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:13 INFO - Downloading docopt-0.6.1.tar.gz 10:16:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:16:14 INFO - Installing collected packages: blobuploader, requests, docopt 10:16:14 INFO - Running setup.py install for blobuploader 10:16:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:16:14 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:16:14 INFO - Running setup.py install for requests 10:16:14 INFO - Running setup.py install for docopt 10:16:14 INFO - Successfully installed blobuploader requests docopt 10:16:14 INFO - Cleaning up... 10:16:14 INFO - Return code: 0 10:16:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:16: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')]} 10:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16: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')]} 10:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:14 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 0x7f50ae72af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a94230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b267f0>, '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 0x2a922d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a92760>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1456336816.224511-2044066368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:16:14 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 10:16:14 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 10:16:14 INFO - Using env: {'DISPLAY': ':0', 10:16:14 INFO - 'HOME': '/home/cltbld', 10:16:14 INFO - 'LANG': 'en_US.UTF-8', 10:16:14 INFO - 'LANGUAGE': 'en_US:en', 10:16:14 INFO - 'LOGNAME': 'cltbld', 10:16:14 INFO - 'MAIL': '/var/mail/cltbld', 10:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:14 INFO - 'MOZ_NO_REMOTE': '1', 10:16:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:14 INFO - 'NO_EM_RESTART': '1', 10:16:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:16:14 INFO - 'PWD': '/builds/slave/test-pgo', 10:16:14 INFO - 'SHELL': '/bin/bash', 10:16:14 INFO - 'SHLVL': '1', 10:16:14 INFO - 'TERM': 'linux', 10:16:14 INFO - 'TMOUT': '86400', 10:16:14 INFO - 'USER': 'cltbld', 10:16:14 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1456336816.224511-2044066368', 10:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:14 INFO - '_': '/tools/buildbot/bin/python'} 10:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:16:14 INFO - Running setup.py (path:/tmp/pip-dVHC3s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:16:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:16:14 INFO - Running setup.py (path:/tmp/pip-mRyzuz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:16:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:16:14 INFO - Running setup.py (path:/tmp/pip-oYC9U9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:16:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:16:15 INFO - Running setup.py (path:/tmp/pip-rNck1q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:16:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:16:15 INFO - Running setup.py (path:/tmp/pip-BJUsHo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:16:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:16:15 INFO - Running setup.py (path:/tmp/pip-9KbOsN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:16:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:16:15 INFO - Running setup.py (path:/tmp/pip-2Ww9yH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:16:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:16:15 INFO - Running setup.py (path:/tmp/pip-np4MTC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:16:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:16:15 INFO - Running setup.py (path:/tmp/pip-m9G_TW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:16:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:16:15 INFO - Running setup.py (path:/tmp/pip-Kt8gfa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:16:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:16:15 INFO - Running setup.py (path:/tmp/pip-BVC4SA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:16:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:16:15 INFO - Running setup.py (path:/tmp/pip-HZYeFR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:16:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:16:15 INFO - Running setup.py (path:/tmp/pip-Woh0s6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:16:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:16:15 INFO - Running setup.py (path:/tmp/pip-GG524E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:16:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:16:15 INFO - Running setup.py (path:/tmp/pip-cSfl0I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:16:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:16:15 INFO - Running setup.py (path:/tmp/pip-wHtXUE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:16:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:16:15 INFO - Running setup.py (path:/tmp/pip-eX846i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:16:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:16:16 INFO - Running setup.py install for manifestparser 10:16:16 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:16:16 INFO - Running setup.py install for mozcrash 10:16:16 INFO - Running setup.py install for mozdebug 10:16:16 INFO - Running setup.py install for mozdevice 10:16:16 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:16:16 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:16:16 INFO - Running setup.py install for mozfile 10:16:16 INFO - Running setup.py install for mozhttpd 10:16:16 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:16:16 INFO - Running setup.py install for mozinfo 10:16:16 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:16:16 INFO - Running setup.py install for mozInstall 10:16:16 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:16:16 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:16:16 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:16:16 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:16:16 INFO - Running setup.py install for mozleak 10:16:16 INFO - Running setup.py install for mozlog 10:16:17 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:16:17 INFO - Running setup.py install for moznetwork 10:16:17 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:16:17 INFO - Running setup.py install for mozprocess 10:16:17 INFO - Running setup.py install for mozprofile 10:16:17 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:16:17 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:16:17 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:16:17 INFO - Running setup.py install for mozrunner 10:16:17 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:16:17 INFO - Running setup.py install for mozscreenshot 10:16:17 INFO - Running setup.py install for moztest 10:16:17 INFO - Running setup.py install for mozversion 10:16:17 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:16:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:16:17 INFO - Cleaning up... 10:16:17 INFO - Return code: 0 10:16:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:17 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 0x7f50ae72af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a94230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b267f0>, '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 0x2a922d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a92760>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1456336816.224511-2044066368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:16:17 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 10:16:17 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 10:16:17 INFO - Using env: {'DISPLAY': ':0', 10:16:17 INFO - 'HOME': '/home/cltbld', 10:16:17 INFO - 'LANG': 'en_US.UTF-8', 10:16:17 INFO - 'LANGUAGE': 'en_US:en', 10:16:17 INFO - 'LOGNAME': 'cltbld', 10:16:17 INFO - 'MAIL': '/var/mail/cltbld', 10:16:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:17 INFO - 'MOZ_NO_REMOTE': '1', 10:16:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:17 INFO - 'NO_EM_RESTART': '1', 10:16:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:16:17 INFO - 'PWD': '/builds/slave/test-pgo', 10:16:17 INFO - 'SHELL': '/bin/bash', 10:16:17 INFO - 'SHLVL': '1', 10:16:17 INFO - 'TERM': 'linux', 10:16:17 INFO - 'TMOUT': '86400', 10:16:17 INFO - 'USER': 'cltbld', 10:16:17 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1456336816.224511-2044066368', 10:16:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:17 INFO - '_': '/tools/buildbot/bin/python'} 10:16:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:16:18 INFO - Running setup.py (path:/tmp/pip-dPigkZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:16:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 10:16:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:16:18 INFO - Running setup.py (path:/tmp/pip-Nu7uWp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:16:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:16:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:16:18 INFO - Running setup.py (path:/tmp/pip-4up_qg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:16:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 10:16:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:16:18 INFO - Running setup.py (path:/tmp/pip-_JueIR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:16:18 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)) 10:16:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:16:18 INFO - Running setup.py (path:/tmp/pip-3ElD1W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:16:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 10:16:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:16:18 INFO - Running setup.py (path:/tmp/pip-K1fAXF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:16:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 10:16:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:16:18 INFO - Running setup.py (path:/tmp/pip-sxozJW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:16:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 10:16:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:16:18 INFO - Running setup.py (path:/tmp/pip-cHl8R_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:16:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 10:16:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:16:18 INFO - Running setup.py (path:/tmp/pip-ycY_zd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:16:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 10:16:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:16:18 INFO - Running setup.py (path:/tmp/pip-3Z8QhR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:16:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:16:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:16:18 INFO - Running setup.py (path:/tmp/pip-ZDh9SR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:16:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 10:16:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:16:18 INFO - Running setup.py (path:/tmp/pip-NpC95X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:16:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 10:16:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:16:18 INFO - Running setup.py (path:/tmp/pip-KTuiey-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:16:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 10:16:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:16:19 INFO - Running setup.py (path:/tmp/pip-vj_SpD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:16:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 10:16:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:16:19 INFO - Running setup.py (path:/tmp/pip-rHl1pT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:16:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 10:16:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:16:19 INFO - Running setup.py (path:/tmp/pip-4Qah9P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:16:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 10:16:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:16:19 INFO - Running setup.py (path:/tmp/pip-RATzRy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:16:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 10:16:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:16:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:16:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 10:16:19 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)) 10:16:19 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)) 10:16:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:16: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 10:16: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 10:16: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 10:16: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 10:16: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 10:16: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 10:16:21 INFO - Downloading blessings-1.6.tar.gz 10:16:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:16:21 INFO - Installing collected packages: blessings 10:16:21 INFO - Running setup.py install for blessings 10:16:21 INFO - Successfully installed blessings 10:16:21 INFO - Cleaning up... 10:16:21 INFO - Return code: 0 10:16:21 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:16:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:16:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:16:21 INFO - Reading from file tmpfile_stdout 10:16:21 INFO - Current package versions: 10:16:21 INFO - argparse == 1.2.1 10:16:21 INFO - blessings == 1.6 10:16:21 INFO - blobuploader == 1.2.4 10:16:21 INFO - docopt == 0.6.1 10:16:21 INFO - manifestparser == 1.1 10:16:21 INFO - mozInstall == 1.12 10:16:21 INFO - mozcrash == 0.16 10:16:21 INFO - mozdebug == 0.1 10:16:21 INFO - mozdevice == 0.48 10:16:21 INFO - mozfile == 1.2 10:16:21 INFO - mozhttpd == 0.7 10:16:21 INFO - mozinfo == 0.9 10:16:21 INFO - mozleak == 0.1 10:16:21 INFO - mozlog == 3.1 10:16:21 INFO - moznetwork == 0.27 10:16:21 INFO - mozprocess == 0.22 10:16:21 INFO - mozprofile == 0.28 10:16:21 INFO - mozrunner == 6.11 10:16:21 INFO - mozscreenshot == 0.1 10:16:21 INFO - mozsystemmonitor == 0.0 10:16:21 INFO - moztest == 0.7 10:16:21 INFO - mozversion == 1.4 10:16:21 INFO - psutil == 3.1.1 10:16:21 INFO - requests == 1.2.3 10:16:21 INFO - wsgiref == 0.1.2 10:16:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:16: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')]} 10:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16: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')]} 10:16:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:21 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 0x7f50ae72af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a94230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b267f0>, '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 0x2a922d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a92760>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1456336816.224511-2044066368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:16:21 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 10:16:21 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 10:16:21 INFO - Using env: {'DISPLAY': ':0', 10:16:21 INFO - 'HOME': '/home/cltbld', 10:16:21 INFO - 'LANG': 'en_US.UTF-8', 10:16:21 INFO - 'LANGUAGE': 'en_US:en', 10:16:21 INFO - 'LOGNAME': 'cltbld', 10:16:21 INFO - 'MAIL': '/var/mail/cltbld', 10:16:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:21 INFO - 'MOZ_NO_REMOTE': '1', 10:16:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:21 INFO - 'NO_EM_RESTART': '1', 10:16:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:16:21 INFO - 'PWD': '/builds/slave/test-pgo', 10:16:21 INFO - 'SHELL': '/bin/bash', 10:16:21 INFO - 'SHLVL': '1', 10:16:21 INFO - 'TERM': 'linux', 10:16:21 INFO - 'TMOUT': '86400', 10:16:21 INFO - 'USER': 'cltbld', 10:16:21 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1456336816.224511-2044066368', 10:16:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:21 INFO - '_': '/tools/buildbot/bin/python'} 10:16:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:16:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 10:16:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 10:16:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 10:16:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 10:16:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 10:16:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 10:16:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 10:16:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 10:16:21 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:16:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 10:16:21 INFO - Cleaning up... 10:16:21 INFO - Return code: 0 10:16:21 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:16: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')]} 10:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16: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')]} 10:16:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f50ae72af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a94230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b267f0>, '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 0x2a922d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a92760>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1456336816.224511-2044066368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:16: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', 'jsonschema'] in /builds/slave/test-pgo/build 10:16: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 jsonschema 10:16:21 INFO - Using env: {'DISPLAY': ':0', 10:16:21 INFO - 'HOME': '/home/cltbld', 10:16:21 INFO - 'LANG': 'en_US.UTF-8', 10:16:21 INFO - 'LANGUAGE': 'en_US:en', 10:16:21 INFO - 'LOGNAME': 'cltbld', 10:16:21 INFO - 'MAIL': '/var/mail/cltbld', 10:16:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:21 INFO - 'MOZ_NO_REMOTE': '1', 10:16:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:21 INFO - 'NO_EM_RESTART': '1', 10:16:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:16:21 INFO - 'PWD': '/builds/slave/test-pgo', 10:16:21 INFO - 'SHELL': '/bin/bash', 10:16:21 INFO - 'SHLVL': '1', 10:16:21 INFO - 'TERM': 'linux', 10:16:21 INFO - 'TMOUT': '86400', 10:16:21 INFO - 'USER': 'cltbld', 10:16:21 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1456336816.224511-2044066368', 10:16:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:21 INFO - '_': '/tools/buildbot/bin/python'} 10:16:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:22 INFO - Downloading/unpacking jsonschema 10:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:16:23 INFO - Downloading/unpacking functools32 (from jsonschema) 10:16: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 10:16: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 10:16: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 10:16: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 10:16: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 10:16: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 10:16:24 INFO - Downloading functools32-3.2.3-2.tar.gz 10:16:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:16:24 INFO - warning: no files found matching '*.txt' 10:16:24 INFO - no previously-included directories found matching 'build' 10:16:24 INFO - no previously-included directories found matching 'dist' 10:16:24 INFO - no previously-included directories found matching '.git*' 10:16:24 INFO - Installing collected packages: jsonschema, functools32 10:16:24 INFO - Running setup.py install for functools32 10:16:24 INFO - warning: no files found matching '*.txt' 10:16:24 INFO - no previously-included directories found matching 'build' 10:16:24 INFO - no previously-included directories found matching 'dist' 10:16:24 INFO - no previously-included directories found matching '.git*' 10:16:24 INFO - Successfully installed jsonschema functools32 10:16:24 INFO - Cleaning up... 10:16:24 INFO - Return code: 0 10:16:24 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:24 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 0x7f50ae72af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a94230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b267f0>, '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 0x2a922d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a92760>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1456336816.224511-2044066368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:16:24 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 10:16:24 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 10:16:24 INFO - Using env: {'DISPLAY': ':0', 10:16:24 INFO - 'HOME': '/home/cltbld', 10:16:24 INFO - 'LANG': 'en_US.UTF-8', 10:16:24 INFO - 'LANGUAGE': 'en_US:en', 10:16:24 INFO - 'LOGNAME': 'cltbld', 10:16:24 INFO - 'MAIL': '/var/mail/cltbld', 10:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:24 INFO - 'MOZ_NO_REMOTE': '1', 10:16:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:24 INFO - 'NO_EM_RESTART': '1', 10:16:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:16:24 INFO - 'PWD': '/builds/slave/test-pgo', 10:16:24 INFO - 'SHELL': '/bin/bash', 10:16:24 INFO - 'SHLVL': '1', 10:16:24 INFO - 'TERM': 'linux', 10:16:24 INFO - 'TMOUT': '86400', 10:16:24 INFO - 'USER': 'cltbld', 10:16:24 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1456336816.224511-2044066368', 10:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:24 INFO - '_': '/tools/buildbot/bin/python'} 10:16:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:24 INFO - Downloading/unpacking flake8 10:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:16:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:16: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 10:16: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 10:16: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 10:16: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 10:16: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 10:16: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 10:16:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:16:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:16: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 10:16: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 10:16: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 10:16: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 10:16: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 10:16: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 10:16:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:16: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 10:16: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 10:16: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 10:16: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 10:16: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 10:16: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 10:16:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:16:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:16:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:16:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:16:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:16:27 INFO - no previously-included directories found matching 'docs/_build' 10:16:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:16:27 INFO - Running setup.py install for pep8 10:16:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:16:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:16:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:16:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:16:27 INFO - no previously-included directories found matching 'docs/_build' 10:16:27 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:16:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:16:27 INFO - Cleaning up... 10:16:27 INFO - Return code: 0 10:16:27 INFO - Running post-action listener: _resource_record_post_action 10:16:27 INFO - Running post-action listener: _start_resource_monitoring 10:16:27 INFO - Starting resource monitoring. 10:16:27 INFO - ##### 10:16:27 INFO - ##### Running install step. 10:16:27 INFO - ##### 10:16:27 INFO - Running pre-action listener: _resource_record_pre_action 10:16:27 INFO - Running main action method: install 10:16:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:16:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:16:27 INFO - Reading from file tmpfile_stdout 10:16:27 INFO - Detecting whether we're running mozinstall >=1.0... 10:16:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:16:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:16:27 INFO - Reading from file tmpfile_stdout 10:16:27 INFO - Output received: 10:16:27 INFO - Usage: mozinstall [options] installer 10:16:27 INFO - Options: 10:16:27 INFO - -h, --help show this help message and exit 10:16:27 INFO - -d DEST, --destination=DEST 10:16:27 INFO - Directory to install application into. [default: 10:16:27 INFO - "/builds/slave/test-pgo"] 10:16:27 INFO - --app=APP Application being installed. [default: firefox] 10:16:27 INFO - mkdir: /builds/slave/test-pgo/build/application 10:16:27 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'] 10:16:27 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 10:16:43 INFO - Reading from file tmpfile_stdout 10:16:43 INFO - Output received: 10:16:43 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:16:43 INFO - Running post-action listener: _resource_record_post_action 10:16:43 INFO - ##### 10:16:43 INFO - ##### Running run-tests step. 10:16:43 INFO - ##### 10:16:43 INFO - Running pre-action listener: _resource_record_pre_action 10:16:43 INFO - Running main action method: run_tests 10:16:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:16:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:16:43 INFO - Python 2.7.3 10:16:43 INFO - Return code: 0 10:16:43 INFO - grabbing minidump binary from tooltool 10:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:43 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 0x2b267f0>, '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 0x2a922d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a92760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:16:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 10:16:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:16:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:16:43 INFO - Return code: 0 10:16:43 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:16:43 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:16:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:16:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:16:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:16:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:16:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:16:44 INFO - Return code: 0 10:16:44 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/c3F7PVDpSfKdUdXACnHGIg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 10:16:44 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/c3F7PVDpSfKdUdXACnHGIg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:16:44 INFO - Using env: {'DISPLAY': ':0', 10:16:44 INFO - 'HOME': '/home/cltbld', 10:16:44 INFO - 'LANG': 'en_US.UTF-8', 10:16:44 INFO - 'LANGUAGE': 'en_US:en', 10:16:44 INFO - 'LOGNAME': 'cltbld', 10:16:44 INFO - 'MAIL': '/var/mail/cltbld', 10:16:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:16:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:44 INFO - 'MOZ_NO_REMOTE': '1', 10:16:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:16:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:44 INFO - 'NO_EM_RESTART': '1', 10:16:44 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:16:44 INFO - 'PWD': '/builds/slave/test-pgo', 10:16:44 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:16:44 INFO - 'SHELL': '/bin/bash', 10:16:44 INFO - 'SHLVL': '1', 10:16:44 INFO - 'TERM': 'linux', 10:16:44 INFO - 'TMOUT': '86400', 10:16:44 INFO - 'USER': 'cltbld', 10:16:44 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1456336816.224511-2044066368', 10:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:44 INFO - '_': '/tools/buildbot/bin/python'} 10:16:44 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/c3F7PVDpSfKdUdXACnHGIg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:16:44 INFO - mozversion application_buildid: 20160224073519 10:16:44 INFO - mozversion application_changeset: 50b1c7bdf690b9d011fe5827b15a04e14a0d5fa8 10:16:44 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:16:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:16:44 INFO - mozversion application_name: Firefox 10:16:44 INFO - mozversion application_remotingname: firefox-dev 10:16:44 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:16:44 INFO - mozversion application_vendor: Mozilla 10:16:44 INFO - mozversion application_version: 46.0a2 10:16:44 INFO - mozversion platform_buildid: 20160224073519 10:16:44 INFO - mozversion platform_changeset: 50b1c7bdf690b9d011fe5827b15a04e14a0d5fa8 10:16:44 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:16:44 INFO - mozversion platform_version: 46.0a2 10:16:44 INFO - using testdate: 1456337804 10:16:44 INFO - actual date: 1456337804 10:16:44 INFO - starting webserver on 'localhost:60322' 10:16:44 INFO - SUITE-START | Running 3 tests 10:16:44 INFO - TEST-START | dromaeo_css 10:16:44 INFO - operating with platform_type : linux_ 10:16:44 INFO - Initialising browser for dromaeo_css test... 10:16:44 INFO - TEST-INFO | started process 26326 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfnrR3V/profile http://localhost:60322/getInfo.html) 10:16:48 INFO - PROCESS | 26326 | 10:16:48 INFO - PROCESS | 26326 | (process:26407): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:16:49 INFO - PROCESS | 26326 | __metrics Screen width/height:1600/1200 10:16:49 INFO - PROCESS | 26326 | colorDepth:24 10:16:49 INFO - PROCESS | 26326 | Browser inner width/height: 1024/697 10:16:49 INFO - PROCESS | 26326 | __metrics 10:16:50 INFO - TEST-INFO | 26326: exit 0 10:16:50 INFO - Browser initialized. 10:16:50 INFO - Running cycle 1/1 for dromaeo_css test... 10:16:50 INFO - TEST-INFO | started process 26456 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfnrR3V/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:16:52 INFO - PROCESS | 26456 | 10:16:52 INFO - PROCESS | 26456 | (process:26517): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:17:02 INFO - PROCESS | 26456 | RSS: Main: 141410304 10:17:02 INFO - PROCESS | 26456 | 10:17:52 INFO - PROCESS | 26456 | 1456337872287 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:19:59 INFO - PROCESS | 26456 | Cycle 1(1): loaded http://localhost:60322/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60322/tests/dromaeo/cssquery-ext.html) 10:20:00 INFO - PROCESS | 26456 | RSS: Main: 145887232 10:20:00 INFO - PROCESS | 26456 | 10:23:02 INFO - PROCESS | 26456 | Cycle 1(1): loaded http://localhost:60322/tests/dromaeo/cssquery-ext.html (next: http://localhost:60322/tests/dromaeo/cssquery-jquery.html) 10:23:03 INFO - PROCESS | 26456 | RSS: Main: 143491072 10:23:03 INFO - PROCESS | 26456 | 10:26:05 INFO - PROCESS | 26456 | Cycle 1(1): loaded http://localhost:60322/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60322/tests/dromaeo/cssquery-mootools.html) 10:26:05 INFO - PROCESS | 26456 | RSS: Main: 142979072 10:26:05 INFO - PROCESS | 26456 | 10:29:07 INFO - PROCESS | 26456 | Cycle 1(1): loaded http://localhost:60322/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60322/tests/dromaeo/cssquery-prototype.html) 10:29:07 INFO - PROCESS | 26456 | RSS: Main: 143081472 10:29:07 INFO - PROCESS | 26456 | 10:32:10 INFO - PROCESS | 26456 | Cycle 1(1): loaded http://localhost:60322/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60322/tests/dromaeo/cssquery-yui.html) 10:32:10 INFO - PROCESS | 26456 | RSS: Main: 145006592 10:32:10 INFO - PROCESS | 26456 | 10:35:12 INFO - PROCESS | 26456 | Cycle 1(1): loaded http://localhost:60322/tests/dromaeo/cssquery-yui.html (next: http://localhost:60322/tests/dromaeo/cssquery-dojo.html) 10:35:13 INFO - PROCESS | 26456 | RSS: Main: 147423232 10:35:13 INFO - PROCESS | 26456 | 10:35:13 INFO - PROCESS | 26456 | __start_tp_report 10:35:13 INFO - PROCESS | 26456 | _x_x_mozilla_page_load 10:35:13 INFO - PROCESS | 26456 | _x_x_mozilla_page_load_details 10:35:13 INFO - PROCESS | 26456 | |i|pagename|runs| 10:35:13 INFO - PROCESS | 26456 | |0;dojo.html;3356.7146792522635;3375.071855239809;3389.542411774413;3404.6935775780175;3406.403879321118;5394.865128371793;5403.621746477748;5410.0802863513245;5436.293281873356;5447.373552041517;5415.10650742628;5462.317210348697;5472.699001554913;5479.835604931848;5481.287432633762;4955.876103097416;4974.900501989958;5035.949640503584;5053.014662140884;5120.667156634825;4871.878203044935;4992.07646585381;5011.173156429185;5022.447530771612;5083.694978301295;4995.500449955011;5010.799568017275;5069.467705890884;5072.036313100518;5090.440051594322;5121.513456221672;5130.538251557377;5133.845984620468;5153.510416510426;5176.741162941876;4833.782479788418;4907;4930.482299358588;5042.117629414838;5047.066292735855;5211.218317252405;5212.8957420851375;5306.071437498423;5307.2835167252315;5331.466853314638;5864.354920958691;5869.442402971711;5894.145348924425;5903.557233207526;5918.437748413894;5669.829905102853;5822.0684690449325;5870.706464676792;5931.406859314077;5941.376155503696;5484.067708489566;5485.917711234295;5497.917531237034;5504.339479262514;5512.586556008276;5949.137375080676;5952.7023648817385;5953.255843019622;5970;5992.161097446361;5631.831045068655;5734.455226753452;5752.165935939265;5827.970860145672;5850.64896106235;5903.822885313448;5923.763049477972;5938.198343223696;5952.8809423812145;5959.851003724942;5762.193292938992;5874.73563689635;5904.822855314347;5908.438698323653;5920.348761636216;5757.827265182052;5826.2134611827705;5926.940730592725;5932.2584676915385;5970.373110823388;4432.800523976429;4453.866384008485;4458.888527786831;4459.576340247671;4490.326451032306;3957.762534247954;4044.7168698190844;4049.8785036448953;4063.6545893599377;4064.837406503707;5467.9453205467435;5518.19986102013;5530.391656917735;5533.6403133796175;5587.8603034923635;5929.584929055011;5937.346891841894;5966.940330596725;5975.641461512323;5978.760849566055;5347.331583552056;5391.81128660495;5527.695976721319;5576.665400075927;5578.330600327987;4906;4934.629902757308;4947.579455746302;4956.553910148104;4964;6002.849928751816;6061.090836374579;6099.207103076572;6104.267487901391;6127.601705889192;5801.36185019639;5864.208331875313;5887.1757953887345;5925.64446133242;5972.223610930551;6025.517958563392;6040.818775436744;6087.147799308189;6090.573659843769;6100;5801.535877129735;5829.766809327749;5833.854153646193;5846.093855452412;5858.121281807763;5792.594518383673;5919.526437884872;5939.376365481735;5968.104784282393;6065.514758819196;5666.036773748555;5725.7137143141845;5728.312602487728;5746.339170995222;5761.539076873756;5688;5697.971510142423;5734.913976290442;5741.110127930177;5753.1945527627;5567.914256719901;5632.9436705632415;5666.744996475251;5734.5125664319;5764.36591974874;5713;5828.883422331614;5834.27071616048;5839.5036421904615;5848.473637372657;5587.938291724559;5696.145578163143;5714.171445140514;5725.08398656213;5728.083506639085 10:35:13 INFO - PROCESS | 26456 | |1;ext.html;538.719865669852;553.3636318234032;554.0746952589176;567.6735876870798;579.9884002319953;30371.84814075929;38023.80988095063;38357.80821095894;38530.229395412076;38564.61435385649;40914.59085409145;41202.175956480925;41509.58490415095;41532.79233603835;41630;8743.387962842604;8905.777355566099;8983.146601072887;8989.146031127033;9002.54987250638;8665.220130188281;8724.345674074439;8748.912510874874;8760;8821.955890220572;8762.079981601935;9109.225715814164;9148.405353651991;9156.542172891362;9160.633574657006;9010.54947252638;9039.141281578239;9055.954720226422;9066.954665226698;9083.22792562633;8931.196192342655;8998.415103018282;9037.68368107113;9058.909410905939;9118.270538356915;41888.1622367554;42559;42602.57397426048;42625.78687106576;42731.57268427307;3655.5796083450214;3696.0944568580603;3721.4045752679713;3822.9426558601645;4236.894077648052;33737.6626233737;33916.15209619755;34048.6595134048;34108.48837267443;34422;4051.0441528932542;4102.548719640837;4240.830366785356;4247.723897946655;4304.39738436616;225836;228956;229492;231177.84411078005;232335;61724;62430.687846561385;64220.67889660522;71021;72549.6372518134;66957;67273.66363168153;67415.3258467419;67555.66222168857;67609.66195168992;17944.820551794313;18156.45530634083;18212.36256731008;18238.726419103725;18288.81711182871;13441.865581344256;13571.1857288563;13599.252041137635;13627.863721362659;13680.247586382844;22486.887565562396;23977;24008.51982960331;24095.638565421534;24128.63807042896;9331.617999042594;9374.203192728559;9461.101195386427;9534.95232523833;9545.809083818285;1079.7192729890285;1099.8240281554913;1107.0811226681835;1181.4033912873945;1194.9342786146844;31583.684163158534;32084.03747887567;33329.00012999614;33724.49413258803;34135.829320853234;1116.4975760907623;1148.9885101148882;1175.4534141624185;1209;1248.1450206608502;15477.767833482507;15765.527034188992;15890.284937177854;16009.919950400406;16151.757723634155;428013;500309;501337;507409;509961;53993;54689;54890.45109548853;54991.725041374535;55053.44946550483;1467.4130347860942;1485.2128371962876;1504.4207979927587;1505.3301280929882;1508.9170095644624;30272.697273026988;30480.84759576188;31346.216344590655;31751.68248317487;33558.16104597405;50048;50649.74675126601;50757.746211268706;50759.49240507548;50874.23688644599;312863;313091;315004;315212;315324;34536;35295.470567942015;35383.64616353803;35693;35921.820390897876;46057;47119.528804712885;47251;47706.52293477021;48214.27678584754;39314.80342598269;39547.40678889876;40035.59964400435;40414.39378409385;40774;41755.1648967025;43467.34798977955;43594.346084808116;43904;44170;36927.44608830816;37044.25911481701;37413.625863741014;37773.24453510969;37843.432348514245;31585.8420707895;32677;32798.836005819816;32984.34031319408;33062.33875322528;26696;27572.862135689193;27839.721602784524;27991;28011.859940700167 10:35:13 INFO - PROCESS | 26456 | |2;jquery.html;391.37575566970673;394.4773175542407;397.47334781414617;398.0844058665073;398.67507980995487;15677.372905083783;16516.587085322873;16954.23705933233;18244.908775456122;18253;15302.387904483836;15879.444219452322;15959.601009974756;17207.397741079065;18498.722519162224;5121.206213036985;5478.205660179272;5683.886322273552;5690.118031705071;5703.201551782754;5508.669479831203;5586.190002449643;5687.658740475564;5691.51622112121;5709.4290570942985;5525.198846167304;5615.438456154393;5628.831135065954;5632.127020311858;5708.372079071299;5638.4361563843495;5677.17680936264;5714.51426628737;5728.026235539968;5728.79949201776;5356.625036247464;5494.395616482224;5544.584156188302;5573.637713548606;5607.8878422431735;19732.80267197324;20092.49768755778;20502.5899482011;20596.176152953863;20696;2249.898754556049;2313.4679023824447;2318.385627808632;2472.7898128659085;2501.9866953883707;9891.604335826558;10177.592896284139;10235.590576376935;10521.579136834594;10573.9471302643;1788.1685016467404;1901.1444849817499;1953.7850836408127;2035.1073501643466;2175.71715676961;61048.38951610516;61200.38799611991;61930.380696193366;62860.05709914355;63246.36753632497;10959.397233152094;11006.834897476545;11014.779704405866;11041.668749937355;11061.281016733887;14334.354954027094;14396.28018599066;14459.204743739196;14473.203973781332;14523.564293071226;8479.576021198915;8495.938007749031;8528.360372972053;8575.442596231349;8603.827923441497;8546;8554.35842311829;8557.786055348666;8565.61454734526;8627.654893804178;4529.682922195415;4698.2952557116705;4719.244920812654;4744.5492678195515;4775.068861572029;1936.7579052618423;1961.3527535913115;2008.256944930385;2010.6380851446588;2026.8378529717588;991.5339790298548;1019.6176433837311;1024.7643042100358;1041.4116024446164;1043.3218408034686;16486.258118384703;17453.7381939271;18059.819401806075;18273.17770700322;18545.25818967253;966.7873067925045;1006.4263369879098;1022.8619136416637;1026.5483187397522;1079.6976846482996;10279.640212592523;10481.213908956859;10572.52423640938;10581.57673693059;10713.464326783629;599853;611928;617573;620707;622726;49093.2636010453;64357.03464448037;76757.23242767502;77430.22569774343;77865.61067194628;1112.1380929779486;1118.139032944628;1128.328644456547;1150.7525881935424;1155.122107198535;16264;16358.34566617322;16363.34546618122;16495.34018639241;16572.254248558602;34525;35122;35967.28065438729;36043.45934811032;36383.636163638024;45833.083338333716;45932.77033614944;46586;46895;47074.76462617665;7654.770356889302;7688.423368247516;7856.882146767689;7905.56519391439;8083;10872.347659140476;10909.34543927367;11438.169892817443;11629.825552616887;11940.16418850707;9979.151772099453;10100.191984641358;10390.480475976323;10437.373757574569;10619.628313009007;10288.794224115625;10413.895861041292;10502.474876256309;10609.9469502652;10798.460076995962;10028.849567256351;10526;10988.175886808362;10999.670009899715;11041.39272340029;8187.426880118334;8296.83406331882;8345.123762004901;8358.916410835815;8359.456635318686;10901.127909767041;10999.285046471954;11038.392888390894;11073.94463027712;11225.214235003472 10:35:13 INFO - PROCESS | 26456 | |3;mootools.html;1572.6147093961977;1592.0368177252765;1794.8474379677727;1858.5911099558093;1867.0291448446817;7878.960605196966;7894.802629934247;7957.681692732298;8036.477628954121;8088.676452941882;7846.686132554691;7898.605069746504;7943.880841787378;7951.72168974086;7982.441229113964;2353.0705371378294;2366.1363602285214;2372.762723727622;2390.6294524348755;2397.4725560376687;2380.0955636858057;2389.8446600970883;2407.1334319644916;2407.8916448759846;2411.46947671512;2355.057976809273;2392.3899405651537;2411.7829395354415;2424.4302588891596;2432.1122790181544;2352.3766201956496;2352.7882490575844;2362.7400985891536;2379.9643005354847;2383.1778036577352;2371.0752806405517;2375.3942744600017;2380.9047638094457;2391.6651668766385;2392.3301475586863;7865.960670196612;7878.251566101211;7900.762977110696;7903.683852645887;7921;4789.688670236458;4934.087193869145;4952.281919121707;4956.6282528810125;4968.279599458058;3174.4286028514857;3200.5917396345767;3221.7261532769744;3244.626867910197;3245.075153581218;1058.9099926506256;1072.0780129088978;1076.95692172313;1076.962306319275;1095.0691911874842;10682.412467314294;10719.732006699895;10728.249022568501;10791.082757965503;10851.51168197433;4181.832726690959;4244.045089854758;4317.201317756225;4383.561643835591;4396.912061758747;8984.46093234408;8986.68546600866;9012.2790176787;9032.412893162054;9046.683366082156;4935.506449355107;4958.9504104959215;4961.975190124026;4969.105560999054;4971.105201063771;4563.885902852455;4574.817007319736;4602.125596136723;4606.5854073132905;4644.210484217691;3372.460406334975;3420.846061927219;3433.4334834752485;3498.5626796650417;3525.5945566260207;1029;1043.4991204222015;1047.518141654832;1049.8320268757116;1105.3644154611131;1287.523616261989;1287.8969682425384;1342.2684636872928;1372.567641193021;1412.8304603447446;7129.714811407589;7395.445341599401;7552.093748750075;7554.131274903457;7561;1157.7047852797482;1169.9415029248503;1195.6114262864603;1201.5193922430922;1209.57664817315;5655.0386434306265;5655.604107712421;5656.91514627281;5692.9146062809095;5701.144828275709;8895.377323587416;9457.66898158575;9478.95260523693;9482.762930926781;9506.429614223169;9566.760830979281;9603.807923841623;9610.183134433652;9629.133377996013;9646.758831029281;7424;7558.395328373717;7579.204183560757;7585.772426827204;7606.163322034572;7331.486795924234;7364.815879603053;7386.815329616803;7424.183339832506;7438.330550250287;8590;8693.739187824376;8868.379213454997;8875.556222188736;8910.420822646507;9033.367664263438;9036.638534458549;9046.276297896022;9080.59137338808;9180.862287065833;6729.192496900403;6760.18877734675;6772.458203343819;6780.627065511444;6874.381305682513;7515.962420187864;7520;7579.962100189464;7610.391168706379;7630.8855367170645;6824.863502730017;6931.549449285781;7350.448716346403;7389.113306403266;7523.172451030273;6995.650217489004;6999.0551275577145;7042.683079261343;7062.858742825012;7140.07179066718;7047.7180912762915;7085.078939737801;7085.858282834418;7095;7099.716011359487;6422.775202867877;6584.901226481511;6590.90113648286;6594.670266486753;6598.934010659832;6630.734770609121;6631;6639.568428052161;6655;6675.632840193642 10:35:13 INFO - PROCESS | 26456 | |4;prototype.html;356.3621118198424;361.4097968936678;365.11823945172404;366.30767848765856;372.0364256575467;6296.968515157418;6381.202349706286;6416.935830641698;6448.580842245251;6617.834554136137;6364.363563643645;6414.262359828621;6424.967875160618;6435.903461448082;6439.130717353156;4906.705597664134;4910.312556242129;4911.5088491150955;4915;4927.384076990376;4897.412310522743;4926.433460152092;4929.359183306183;4940.184869496528;4948.653594248404;4495.258282383403;4807.591354734852;4819.903601927959;4821.325014497973;4829.589484893788;4800.543948324921;4809.8456370471185;4811.398575178103;4823.782929768169;4826.131296366652;4195.202911446846;4196.971741923217;4235.8093885775215;4240.936385954183;4248.235317642823;5954.07711804671;6048.637081775108;6064.9090263646085;6087.05650624154;6100.389961003909;5680.3467601225975;5690;5692.658440493584;5697.857553561153;5707.828765137053;6775.424088952395;6786.185657721105;6797.082393876863;6803.421709154728;6830.453563714891;4733.3846599942135;4748.8127968008;4753.287006948951;4755.9286610700865;4766.904661906742;6794.796156115275;6923.757668481579;6927.896081558731;6955.721771129149;6957.5129740918155;4754.144254034307;4759.809607615726;4775.5224477551965;4782.115308667908;4792.832250871203;4831.806727730922;4836.613070954315;4837.177679794373;4837.661363704507;4848.393950756155;5479.561635069264;5538.224648549206;5559.555235581144;5562.16567514876;5600.579956503197;6644.933550664431;6668.566543174678;6685.532012759158;6700.865982680417;6711.63086030273;1712.3236321652878;1734.2022669572139;1783.8662100342526;1784.6609144262547;1785.4643606918132;1196.7307355844866;1199;1209.915305928594;1220.7619514194646;1234.2224398628807;6373.840653983688;6411.294757576663;6422.357764223634;6426.4537514311805;6434.453071488882;6894.827629309308;6943.79168624942;6945.617991010543;6965.616891071039;6967.059446974695;6345.968270158712;6410.775622853178;6412.102305677209;6422.100905873182;6466.385693359218;3750.3249415104997;3769.660730534265;3781.1681430085337;3787.299349620274;3796.3166630006313;7125.96437017822;7179.461540384492;7186.065811444479;7186.706392849337;7211.639418029077;6979.3020697930815;7052.365287124184;7127.4654400920135;7147.8570428592175;7158.319959603829;7081.964590177016;7100.538464999759;7109.217986021534;7118.5017048806085;7135.928640713734;6889.586624802528;6908.481863860331;6910.343517365842;6925.411340035952;6930.965345173242;6734.528582999143;6817.659117044227;6889.724411023503;6982.1272340957385;6999.580025198505;7250.782476525713;7290.3438690518105;7298.854022919618;7316.158641756266;7317.378022868116;4843.95156048435;4862.440819305683;4875.731834749123;4876.853939324185;4884.7069175849565;6879.89680154788;6956;7068.858622827617;7103.538270012433;7108.609026503592;6863.6568171590225;6868.210155832143;6899.724011039502;6931.68807403658;6941.722331106699;6871.450283977169;6978.371946524837;6979.2671769465505;6984.546004509691;6993;6609.900851487136;6755.527113102232;6781.0845535854005;6786.185657721105;6787.457003439614;6833.180018397824;6894.586324820527;6933.4106600939485;6940.479464040116;6948.235694073749;6725.226598941184;6735.158105236846;6759.594424334556;6759.729610815709;6778.220504641832 10:35:13 INFO - PROCESS | 26456 | |5;yui.html;869.699953516037;944.1078181118845;953.6519170502769;956.8421210500268;970.9320347575671;14508.927455362722;14612.780808287858;14651.853481465196;15164.317605707742;15246.237688115578;13228.867711322884;13288.402021909013;13291.268980206109;13435.26106064166;13485.123466974665;764.6826566974698;776.2509178642608;878.3280790195505;917.1562162810214;927.8932922713873;907.6324088744069;912.2473958983832;918.485648037098;919.1957037592107;920.3419555018161;944.8015916657511;965.1892410375283;965.9275554333418;966.4877614864098;971.7036303927299;955.7945041815973;957.0716405087054;957.6552441121191;959.2182371367348;968.3124981263277;715.599264411931;716.5378330976544;717.0212659719498;717.3149642091789;722.0757430488983;14068.085574437731;14149.646258843612;14186.787198192036;14197.574072777834;14208.786868196985;13980.58058258254;14108.294585270696;14225.715485690229;14322.498712545115;14338.42646294147;11328.773424531464;11440.828387574193;11465.828012579817;11678.357690327028;11764.823527647091;3731.2164445466483;3751.3247615429214;3780.8109594520165;3811.7712937223578;3827.0432391902023;49741.751291243316;49773;50393.74803125961;50500.24249636258;50785.238221426705;11053.283519469389;11297.49161287744;11402.0308273796;11423.942880285711;11482.77034459323;20245.595088098155;20400.59198816045;20485.38543843687;20485.89757051235;20534.69197962032;7651.846963060819;7660.042494688164;7866.803329916684;7947.801304967306;8204.958975205085;4417.249067658506;4455.754933478625;4583.060472603175;4605.700629459075;4618.122556714214;2991.0279159273323;3044.786864919479;3051.420230156263;3063.785535012528;3071.754259659222;532.866783304174;544.3902828831655;545.9563234941274;546.1507356061363;552.1855263486326;561.9241402410704;672.825065482978;707.377507793149;717.4762423430925;735.4447392218948;8731.781705457288;9025.503597302211;9320.20778233844;9903.900960990442;9938.055884690943;546.3525722019419;554.4515103338584;588.3968931844893;751.8158051277472;771.4407054885276;4127.153933443637;4193.161367726467;4305.655547556188;4323.221820072355;4432.867013989586;63136.684316578125;63371.366286336546;63401.68299158475;63741.36258637354;63886;27997.72002279992;28033.57949630757;28061.43877122446;28097.859510702725;28138.71861281402;48004.279935800296;48253.276200856315;48380.75809620929;48626;48646.270305945436;8221.848941148124;8595.613197406257;8729.6944606941;8842.823143536965;9413.058694130532;35921.28157436889;36436.81781591075;36732.81633591815;37045.62954370422;37847;46736.7663161682;46995.29507057329;47247.29129062998;47748.761256193495;51453.742731286104;11303.547858085913;11472.598459053894;11499.8275025873;11554;11852.992495637622;12798.872011279767;13041.804372934224;13140.211587304791;13216.933915330363;13384.330783460982;11848.76302473963;12244.755104897675;12585.93707031459;12630.980464522392;12966.35168241603;10575.682729518127;10683.57265709363;11584.015358694605;11953.521859125538;12104.334261615695;10947.288426252268;11594.71013224676;11712.941435292769;11812.291262524275;12218.327991960528;10112.898871011195;10304.227182961158;10459.581616735246;10466.738331541772;10653.733656658336;10300.742481438025;10855.2401331906;11063.72340691489;11088.611898583511;11154 10:35:13 INFO - PROCESS | 26456 | __end_tp_report 10:35:13 INFO - PROCESS | 26456 | __start_cc_report 10:35:13 INFO - PROCESS | 26456 | _x_x_mozilla_cycle_collect,291 10:35:13 INFO - PROCESS | 26456 | __end_cc_report 10:35:13 INFO - PROCESS | 26456 | __startTimestamp1456338913122__endTimestamp 10:35:13 INFO - PROCESS | 26456 | 10:35:13 INFO - PROCESS | 26456 | ------- Summary: start ------- 10:35:13 INFO - PROCESS | 26456 | Number of tests: 6 10:35:13 INFO - PROCESS | 26456 | 10:35:13 INFO - PROCESS | 26456 | [#0] dojo.html Cycles:165 Average:5460.55 Median:5688.00 stddev:600.50 (10.6%) stddev-sans-first:579.22 10:35:13 INFO - PROCESS | 26456 | Values: 3356.7 3375.1 3389.5 3404.7 3406.4 5394.9 5403.6 5410.1 5436.3 5447.4 5415.1 5462.3 5472.7 5479.8 5481.3 4955.9 4974.9 5035.9 5053.0 5120.7 4871.9 4992.1 5011.2 5022.4 5083.7 4995.5 5010.8 5069.5 5072.0 5090.4 5121.5 5130.5 5133.8 5153.5 5176.7 4833.8 4907.0 4930.5 5042.1 5047.1 5211.2 5212.9 5306.1 5307.3 5331.5 5864.4 5869.4 5894.1 5903.6 5918.4 5669.8 5822.1 5870.7 5931.4 5941.4 5484.1 5485.9 5497.9 5504.3 5512.6 5949.1 5952.7 5953.3 5970.0 5992.2 5631.8 5734.5 5752.2 5828.0 5850.6 5903.8 5923.8 5938.2 5952.9 5959.9 5762.2 5874.7 5904.8 5908.4 5920.3 5757.8 5826.2 5926.9 5932.3 5970.4 4432.8 4453.9 4458.9 4459.6 4490.3 3957.8 4044.7 4049.9 4063.7 4064.8 5467.9 5518.2 5530.4 5533.6 5587.9 5929.6 5937.3 5966.9 5975.6 5978.8 5347.3 5391.8 5527.7 5576.7 5578.3 4906.0 4934.6 4947.6 4956.6 4964.0 6002.8 6061.1 6099.2 6104.3 6127.6 5801.4 5864.2 5887.2 5925.6 5972.2 6025.5 6040.8 6087.1 6090.6 6100.0 5801.5 5829.8 5833.9 5846.1 5858.1 5792.6 5919.5 5939.4 5968.1 6065.5 5666.0 5725.7 5728.3 5746.3 5761.5 5688.0 5698.0 5734.9 5741.1 5753.2 5567.9 5632.9 5666.7 5734.5 5764.4 5713.0 5828.9 5834.3 5839.5 5848.5 5587.9 5696.1 5714.2 5725.1 5728.1 10:35:13 INFO - PROCESS | 26456 | 10:35:13 INFO - PROCESS | 26456 | [#1] ext.html Cycles:180 Average:52587.19 Median:39791.50 stddev:95587.16 (240.2%) stddev-sans-first:95775.42 10:35:13 INFO - PROCESS | 26456 | Values: 538.7 553.4 554.1 567.7 580.0 30371.8 38023.8 38357.8 38530.2 38564.6 40914.6 41202.2 41509.6 41532.8 41630.0 8743.4 8905.8 8983.1 8989.1 9002.5 8665.2 8724.3 8748.9 8760.0 8822.0 8762.1 9109.2 9148.4 9156.5 9160.6 9010.5 9039.1 9056.0 9067.0 9083.2 8931.2 8998.4 9037.7 9058.9 9118.3 41888.2 42559.0 42602.6 42625.8 42731.6 3655.6 3696.1 3721.4 3822.9 4236.9 33737.7 33916.2 34048.7 34108.5 34422.0 4051.0 4102.5 4240.8 4247.7 4304.4 225836.0 228956.0 229492.0 231177.8 232335.0 61724.0 62430.7 64220.7 71021.0 72549.6 66957.0 67273.7 67415.3 67555.7 67609.7 17944.8 18156.5 18212.4 18238.7 18288.8 13441.9 13571.2 13599.3 13627.9 13680.2 22486.9 23977.0 24008.5 24095.6 24128.6 9331.6 9374.2 9461.1 9535.0 9545.8 1079.7 1099.8 1107.1 1181.4 1194.9 31583.7 32084.0 33329.0 33724.5 34135.8 1116.5 1149.0 1175.5 1209.0 1248.1 15477.8 15765.5 15890.3 16009.9 16151.8 428013.0 500309.0 501337.0 507409.0 509961.0 53993.0 54689.0 54890.5 54991.7 55053.4 1467.4 1485.2 1504.4 1505.3 1508.9 30272.7 30480.8 31346.2 31751.7 33558.2 50048.0 50649.7 50757.7 50759.5 50874.2 312863.0 313091.0 315004.0 315212.0 315324.0 34536.0 35295.5 35383.6 35693.0 35921.8 46057.0 47119.5 47251.0 47706.5 48214.3 39314.8 39547.4 40035.6 40414.4 40774.0 41755.2 43467.3 43594.3 43904.0 44170.0 36927.4 37044.3 37413.6 37773.2 37843.4 31585.8 32677.0 32798.8 32984.3 33062.3 26696.0 27572.9 27839.7 27991.0 28011.9 10:35:13 INFO - PROCESS | 26456 | 10:35:13 INFO - PROCESS | 26456 | [#2] jquery.html Cycles:180 Average:30334.83 Median:2212.81 stddev:100275.06 (4531.6%) stddev-sans-first:100531.14 10:35:13 INFO - PROCESS | 26456 | Values: 391.4 394.5 397.5 398.1 398.7 15677.4 16516.6 16954.2 18244.9 18253.0 15302.4 15879.4 15959.6 17207.4 18498.7 5121.2 5478.2 5683.9 5690.1 5703.2 5508.7 5586.2 5687.7 5691.5 5709.4 5525.2 5615.4 5628.8 5632.1 5708.4 5638.4 5677.2 5714.5 5728.0 5728.8 5356.6 5494.4 5544.6 5573.6 5607.9 19732.8 20092.5 20502.6 20596.2 20696.0 2249.9 2313.5 2318.4 2472.8 2502.0 9891.6 10177.6 10235.6 10521.6 10573.9 1788.2 1901.1 1953.8 2035.1 2175.7 61048.4 61200.4 61930.4 62860.1 63246.4 10959.4 11006.8 11014.8 11041.7 11061.3 14334.4 14396.3 14459.2 14473.2 14523.6 8479.6 8495.9 8528.4 8575.4 8603.8 8546.0 8554.4 8557.8 8565.6 8627.7 4529.7 4698.3 4719.2 4744.5 4775.1 1936.8 1961.4 2008.3 2010.6 2026.8 991.5 1019.6 1024.8 1041.4 1043.3 16486.3 17453.7 18059.8 18273.2 18545.3 966.8 1006.4 1022.9 1026.5 1079.7 10279.6 10481.2 10572.5 10581.6 10713.5 599853.0 611928.0 617573.0 620707.0 622726.0 49093.3 64357.0 76757.2 77430.2 77865.6 1112.1 1118.1 1128.3 1150.8 1155.1 16264.0 16358.3 16363.3 16495.3 16572.3 34525.0 35122.0 35967.3 36043.5 36383.6 45833.1 45932.8 46586.0 46895.0 47074.8 7654.8 7688.4 7856.9 7905.6 8083.0 10872.3 10909.3 11438.2 11629.8 11940.2 9979.2 10100.2 10390.5 10437.4 10619.6 10288.8 10413.9 10502.5 10609.9 10798.5 10028.8 10526.0 10988.2 10999.7 11041.4 8187.4 8296.8 8345.1 8358.9 8359.5 10901.1 10999.3 11038.4 11073.9 11225.2 10:35:13 INFO - PROCESS | 26456 | 10:35:13 INFO - PROCESS | 26456 | [#3] mootools.html Cycles:180 Average:5586.48 Median:6503.84 stddev:2851.01 (43.8%) stddev-sans-first:2843.04 10:35:13 INFO - PROCESS | 26456 | Values: 1572.6 1592.0 1794.8 1858.6 1867.0 7879.0 7894.8 7957.7 8036.5 8088.7 7846.7 7898.6 7943.9 7951.7 7982.4 2353.1 2366.1 2372.8 2390.6 2397.5 2380.1 2389.8 2407.1 2407.9 2411.5 2355.1 2392.4 2411.8 2424.4 2432.1 2352.4 2352.8 2362.7 2380.0 2383.2 2371.1 2375.4 2380.9 2391.7 2392.3 7866.0 7878.3 7900.8 7903.7 7921.0 4789.7 4934.1 4952.3 4956.6 4968.3 3174.4 3200.6 3221.7 3244.6 3245.1 1058.9 1072.1 1077.0 1077.0 1095.1 10682.4 10719.7 10728.2 10791.1 10851.5 4181.8 4244.0 4317.2 4383.6 4396.9 8984.5 8986.7 9012.3 9032.4 9046.7 4935.5 4959.0 4962.0 4969.1 4971.1 4563.9 4574.8 4602.1 4606.6 4644.2 3372.5 3420.8 3433.4 3498.6 3525.6 1029.0 1043.5 1047.5 1049.8 1105.4 1287.5 1287.9 1342.3 1372.6 1412.8 7129.7 7395.4 7552.1 7554.1 7561.0 1157.7 1169.9 1195.6 1201.5 1209.6 5655.0 5655.6 5656.9 5692.9 5701.1 8895.4 9457.7 9479.0 9482.8 9506.4 9566.8 9603.8 9610.2 9629.1 9646.8 7424.0 7558.4 7579.2 7585.8 7606.2 7331.5 7364.8 7386.8 7424.2 7438.3 8590.0 8693.7 8868.4 8875.6 8910.4 9033.4 9036.6 9046.3 9080.6 9180.9 6729.2 6760.2 6772.5 6780.6 6874.4 7516.0 7520.0 7580.0 7610.4 7630.9 6824.9 6931.5 7350.4 7389.1 7523.2 6995.7 6999.1 7042.7 7062.9 7140.1 7047.7 7085.1 7085.9 7095.0 7099.7 6422.8 6584.9 6590.9 6594.7 6598.9 6630.7 6631.0 6639.6 6655.0 6675.6 10:35:13 INFO - PROCESS | 26456 | 10:35:13 INFO - PROCESS | 26456 | [#4] prototype.html Cycles:180 Average:5667.95 Median:6422.23 stddev:1700.37 (26.5%) stddev-sans-first:1657.74 10:35:13 INFO - PROCESS | 26456 | Values: 356.4 361.4 365.1 366.3 372.0 6297.0 6381.2 6416.9 6448.6 6617.8 6364.4 6414.3 6425.0 6435.9 6439.1 4906.7 4910.3 4911.5 4915.0 4927.4 4897.4 4926.4 4929.4 4940.2 4948.7 4495.3 4807.6 4819.9 4821.3 4829.6 4800.5 4809.8 4811.4 4823.8 4826.1 4195.2 4197.0 4235.8 4240.9 4248.2 5954.1 6048.6 6064.9 6087.1 6100.4 5680.3 5690.0 5692.7 5697.9 5707.8 6775.4 6786.2 6797.1 6803.4 6830.5 4733.4 4748.8 4753.3 4755.9 4766.9 6794.8 6923.8 6927.9 6955.7 6957.5 4754.1 4759.8 4775.5 4782.1 4792.8 4831.8 4836.6 4837.2 4837.7 4848.4 5479.6 5538.2 5559.6 5562.2 5600.6 6644.9 6668.6 6685.5 6700.9 6711.6 1712.3 1734.2 1783.9 1784.7 1785.5 1196.7 1199.0 1209.9 1220.8 1234.2 6373.8 6411.3 6422.4 6426.5 6434.5 6894.8 6943.8 6945.6 6965.6 6967.1 6346.0 6410.8 6412.1 6422.1 6466.4 3750.3 3769.7 3781.2 3787.3 3796.3 7126.0 7179.5 7186.1 7186.7 7211.6 6979.3 7052.4 7127.5 7147.9 7158.3 7082.0 7100.5 7109.2 7118.5 7135.9 6889.6 6908.5 6910.3 6925.4 6931.0 6734.5 6817.7 6889.7 6982.1 6999.6 7250.8 7290.3 7298.9 7316.2 7317.4 4844.0 4862.4 4875.7 4876.9 4884.7 6879.9 6956.0 7068.9 7103.5 7108.6 6863.7 6868.2 6899.7 6931.7 6941.7 6871.5 6978.4 6979.3 6984.5 6993.0 6609.9 6755.5 6781.1 6786.2 6787.5 6833.2 6894.6 6933.4 6940.5 6948.2 6725.2 6735.2 6759.6 6759.7 6778.2 10:35:13 INFO - PROCESS | 26456 | 10:35:13 INFO - PROCESS | 26456 | [#5] yui.html Cycles:180 Average:14032.35 Median:4160.16 stddev:15847.17 (380.9%) stddev-sans-first:15860.80 10:35:13 INFO - PROCESS | 26456 | Values: 869.7 944.1 953.7 956.8 970.9 14508.9 14612.8 14651.9 15164.3 15246.2 13228.9 13288.4 13291.3 13435.3 13485.1 764.7 776.3 878.3 917.2 927.9 907.6 912.2 918.5 919.2 920.3 944.8 965.2 965.9 966.5 971.7 955.8 957.1 957.7 959.2 968.3 715.6 716.5 717.0 717.3 722.1 14068.1 14149.6 14186.8 14197.6 14208.8 13980.6 14108.3 14225.7 14322.5 14338.4 11328.8 11440.8 11465.8 11678.4 11764.8 3731.2 3751.3 3780.8 3811.8 3827.0 49741.8 49773.0 50393.7 50500.2 50785.2 11053.3 11297.5 11402.0 11423.9 11482.8 20245.6 20400.6 20485.4 20485.9 20534.7 7651.8 7660.0 7866.8 7947.8 8205.0 4417.2 4455.8 4583.1 4605.7 4618.1 2991.0 3044.8 3051.4 3063.8 3071.8 532.9 544.4 546.0 546.2 552.2 561.9 672.8 707.4 717.5 735.4 8731.8 9025.5 9320.2 9903.9 9938.1 546.4 554.5 588.4 751.8 771.4 4127.2 4193.2 4305.7 4323.2 4432.9 63136.7 63371.4 63401.7 63741.4 63886.0 27997.7 28033.6 28061.4 28097.9 28138.7 48004.3 48253.3 48380.8 48626.0 48646.3 8221.8 8595.6 8729.7 8842.8 9413.1 35921.3 36436.8 36732.8 37045.6 37847.0 46736.8 46995.3 47247.3 47748.8 51453.7 11303.5 11472.6 11499.8 11554.0 11853.0 12798.9 13041.8 13140.2 13216.9 13384.3 11848.8 12244.8 12585.9 12631.0 12966.4 10575.7 10683.6 11584.0 11953.5 12104.3 10947.3 11594.7 11712.9 11812.3 12218.3 10112.9 10304.2 10459.6 10466.7 10653.7 10300.7 10855.2 11063.7 11088.6 11154.0 10:35:13 INFO - PROCESS | 26456 | -------- Summary: end -------- 10:35:13 INFO - PROCESS | 26456 | 10:35:13 INFO - TEST-INFO | 26456: exit 0 10:35:13 INFO - TEST-OK | dromaeo_css | took 1109009ms 10:35:13 INFO - TEST-START | kraken 10:35:13 INFO - operating with platform_type : linux_ 10:35:13 INFO - Initialising browser for kraken test... 10:35:13 INFO - TEST-INFO | started process 26700 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7jy7Zf/profile http://localhost:60322/getInfo.html) 10:35:17 INFO - PROCESS | 26700 | 10:35:17 INFO - PROCESS | 26700 | (process:26784): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:35:18 INFO - PROCESS | 26700 | __metrics Screen width/height:1600/1200 10:35:18 INFO - PROCESS | 26700 | colorDepth:24 10:35:18 INFO - PROCESS | 26700 | Browser inner width/height: 1024/697 10:35:18 INFO - PROCESS | 26700 | __metrics 10:35:19 INFO - TEST-INFO | 26700: exit 0 10:35:19 INFO - Browser initialized. 10:35:19 INFO - Running cycle 1/1 for kraken test... 10:35:19 INFO - TEST-INFO | started process 26833 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7jy7Zf/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:35:20 INFO - PROCESS | 26833 | 10:35:20 INFO - PROCESS | 26833 | (process:26897): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:35:31 INFO - PROCESS | 26833 | RSS: Main: 141946880 10:35:31 INFO - PROCESS | 26833 | 10:35:33 INFO - PROCESS | 26833 | Cycle 1(1): loaded http://localhost:60322/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60322/tests/kraken/driver.html?testName=audio-beat-detection) 10:35:34 INFO - PROCESS | 26833 | RSS: Main: 146096128 10:35:34 INFO - PROCESS | 26833 | 10:35:36 INFO - PROCESS | 26833 | Cycle 1(1): loaded http://localhost:60322/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60322/tests/kraken/driver.html?testName=audio-dft) 10:35:37 INFO - PROCESS | 26833 | RSS: Main: 145879040 10:35:37 INFO - PROCESS | 26833 | 10:35:40 INFO - PROCESS | 26833 | Cycle 1(1): loaded http://localhost:60322/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60322/tests/kraken/driver.html?testName=audio-fft) 10:35:40 INFO - PROCESS | 26833 | RSS: Main: 145985536 10:35:40 INFO - PROCESS | 26833 | 10:35:42 INFO - PROCESS | 26833 | Cycle 1(1): loaded http://localhost:60322/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60322/tests/kraken/driver.html?testName=audio-oscillator) 10:35:43 INFO - PROCESS | 26833 | RSS: Main: 145321984 10:35:43 INFO - PROCESS | 26833 | 10:35:45 INFO - PROCESS | 26833 | Cycle 1(1): loaded http://localhost:60322/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60322/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:35:46 INFO - PROCESS | 26833 | RSS: Main: 145526784 10:35:46 INFO - PROCESS | 26833 | 10:35:49 INFO - PROCESS | 26833 | Cycle 1(1): loaded http://localhost:60322/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60322/tests/kraken/driver.html?testName=imaging-darkroom) 10:35:49 INFO - PROCESS | 26833 | RSS: Main: 146968576 10:35:49 INFO - PROCESS | 26833 | 10:35:53 INFO - PROCESS | 26833 | Cycle 1(1): loaded http://localhost:60322/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60322/tests/kraken/driver.html?testName=imaging-desaturate) 10:35:53 INFO - PROCESS | 26833 | RSS: Main: 146296832 10:35:53 INFO - PROCESS | 26833 | 10:35:56 INFO - PROCESS | 26833 | Cycle 1(1): loaded http://localhost:60322/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60322/tests/kraken/driver.html?testName=json-parse-financial) 10:35:57 INFO - PROCESS | 26833 | RSS: Main: 146722816 10:35:57 INFO - PROCESS | 26833 | 10:35:58 INFO - PROCESS | 26833 | Cycle 1(1): loaded http://localhost:60322/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60322/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:35:59 INFO - PROCESS | 26833 | RSS: Main: 147324928 10:35:59 INFO - PROCESS | 26833 | 10:36:01 INFO - PROCESS | 26833 | Cycle 1(1): loaded http://localhost:60322/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60322/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:36:01 INFO - PROCESS | 26833 | RSS: Main: 146124800 10:36:01 INFO - PROCESS | 26833 | 10:36:03 INFO - PROCESS | 26833 | Cycle 1(1): loaded http://localhost:60322/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60322/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:36:04 INFO - PROCESS | 26833 | RSS: Main: 146579456 10:36:04 INFO - PROCESS | 26833 | 10:36:06 INFO - PROCESS | 26833 | Cycle 1(1): loaded http://localhost:60322/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60322/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:36:07 INFO - PROCESS | 26833 | RSS: Main: 145457152 10:36:07 INFO - PROCESS | 26833 | 10:36:09 INFO - PROCESS | 26833 | Cycle 1(1): loaded http://localhost:60322/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60322/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:36:10 INFO - PROCESS | 26833 | RSS: Main: 146128896 10:36:10 INFO - PROCESS | 26833 | 10:36:11 INFO - PROCESS | 26833 | Cycle 1(1): loaded http://localhost:60322/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60322/tests/kraken/driver.html?testName=ai-astar) 10:36:12 INFO - PROCESS | 26833 | RSS: Main: 147304448 10:36:12 INFO - PROCESS | 26833 | 10:36:12 INFO - PROCESS | 26833 | __start_tp_report 10:36:12 INFO - PROCESS | 26833 | _x_x_mozilla_page_load 10:36:12 INFO - PROCESS | 26833 | _x_x_mozilla_page_load_details 10:36:12 INFO - PROCESS | 26833 | |i|pagename|runs| 10:36:12 INFO - PROCESS | 26833 | |0;ai-astar;111;107;118;112;112;122;111;111;113;110 10:36:12 INFO - PROCESS | 26833 | |1;audio-beat-detection;145;126;152;165;132;169;160;128;168;124 10:36:12 INFO - PROCESS | 26833 | |2;audio-dft;162;165;162;162;164;160;164;163;163;162 10:36:12 INFO - PROCESS | 26833 | |3;audio-fft;75;75;73;146;75;73;76;73;163;74 10:36:12 INFO - PROCESS | 26833 | |4;audio-oscillator;95;98;146;94;96;95;141;96;96;143 10:36:12 INFO - PROCESS | 26833 | |5;imaging-gaussian-blur;110;110;110;110;110;110;110;109;110;110 10:36:12 INFO - PROCESS | 26833 | |6;imaging-darkroom;150;146;146;146;146;146;146;147;146;168 10:36:12 INFO - PROCESS | 26833 | |7;imaging-desaturate;97;96;96;97;96;98;96;97;97;100 10:36:12 INFO - PROCESS | 26833 | |8;json-parse-financial;53;55;55;55;57;55;54;64;52;57 10:36:12 INFO - PROCESS | 26833 | |9;json-stringify-tinderbox;64;65;65;65;65;65;65;65;64;64 10:36:12 INFO - PROCESS | 26833 | |10;stanford-crypto-aes;80;82;82;83;82;89;83;81;83;81 10:36:12 INFO - PROCESS | 26833 | |11;stanford-crypto-ccm;111;117;112;130;111;113;111;116;114;115 10:36:12 INFO - PROCESS | 26833 | |12;stanford-crypto-pbkdf2;129;137;138;135;136;146;139;135;147;135 10:36:12 INFO - PROCESS | 26833 | |13;stanford-crypto-sha256-iterative;64;66;64;64;64;65;64;67;68;64 10:36:12 INFO - PROCESS | 26833 | __end_tp_report 10:36:12 INFO - PROCESS | 26833 | __start_cc_report 10:36:12 INFO - PROCESS | 26833 | _x_x_mozilla_cycle_collect,730 10:36:12 INFO - PROCESS | 26833 | __end_cc_report 10:36:12 INFO - PROCESS | 26833 | __startTimestamp1456338972203__endTimestamp 10:36:12 INFO - PROCESS | 26833 | 10:36:12 INFO - PROCESS | 26833 | ------- Summary: start ------- 10:36:12 INFO - PROCESS | 26833 | Number of tests: 14 10:36:12 INFO - PROCESS | 26833 | 10:36:12 INFO - PROCESS | 26833 | [#0] ai-astar Cycles:10 Average:112.70 Median:112.00 stddev:4.27 (3.8%) stddev-sans-first:4.48 10:36:12 INFO - PROCESS | 26833 | Values: 111.0 107.0 118.0 112.0 112.0 122.0 111.0 111.0 113.0 110.0 10:36:12 INFO - PROCESS | 26833 | 10:36:12 INFO - PROCESS | 26833 | [#1] audio-beat-detection Cycles:10 Average:146.90 Median:156.00 stddev:18.27 (11.7%) stddev-sans-first:19.36 10:36:12 INFO - PROCESS | 26833 | Values: 145.0 126.0 152.0 165.0 132.0 169.0 160.0 128.0 168.0 124.0 10:36:12 INFO - PROCESS | 26833 | 10:36:12 INFO - PROCESS | 26833 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:1.42 (0.9%) stddev-sans-first:1.48 10:36:12 INFO - PROCESS | 26833 | Values: 162.0 165.0 162.0 162.0 164.0 160.0 164.0 163.0 163.0 162.0 10:36:12 INFO - PROCESS | 26833 | 10:36:12 INFO - PROCESS | 26833 | [#3] audio-fft Cycles:10 Average:90.30 Median:74.50 stddev:34.09 (45.8%) stddev-sans-first:35.70 10:36:12 INFO - PROCESS | 26833 | Values: 75.0 75.0 73.0 146.0 75.0 73.0 76.0 73.0 163.0 74.0 10:36:12 INFO - PROCESS | 26833 | 10:36:12 INFO - PROCESS | 26833 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:95.50 stddev:23.06 (24.1%) stddev-sans-first:23.81 10:36:12 INFO - PROCESS | 26833 | Values: 95.0 98.0 146.0 94.0 96.0 95.0 141.0 96.0 96.0 143.0 10:36:12 INFO - PROCESS | 26833 | 10:36:12 INFO - PROCESS | 26833 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:36:12 INFO - PROCESS | 26833 | Values: 110.0 110.0 110.0 110.0 110.0 110.0 110.0 109.0 110.0 110.0 10:36:12 INFO - PROCESS | 26833 | 10:36:12 INFO - PROCESS | 26833 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:146.00 stddev:6.90 (4.7%) stddev-sans-first:7.30 10:36:12 INFO - PROCESS | 26833 | Values: 150.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 168.0 10:36:12 INFO - PROCESS | 26833 | 10:36:12 INFO - PROCESS | 26833 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:97.00 stddev:1.25 (1.3%) stddev-sans-first:1.32 10:36:12 INFO - PROCESS | 26833 | Values: 97.0 96.0 96.0 97.0 96.0 98.0 96.0 97.0 97.0 100.0 10:36:12 INFO - PROCESS | 26833 | 10:36:12 INFO - PROCESS | 26833 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.00 stddev:3.30 (6.0%) stddev-sans-first:3.35 10:36:12 INFO - PROCESS | 26833 | Values: 53.0 55.0 55.0 55.0 57.0 55.0 54.0 64.0 52.0 57.0 10:36:12 INFO - PROCESS | 26833 | 10:36:12 INFO - PROCESS | 26833 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 10:36:12 INFO - PROCESS | 26833 | Values: 64.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 64.0 64.0 10:36:12 INFO - PROCESS | 26833 | 10:36:12 INFO - PROCESS | 26833 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.50 stddev:2.46 (3.0%) stddev-sans-first:2.42 10:36:12 INFO - PROCESS | 26833 | Values: 80.0 82.0 82.0 83.0 82.0 89.0 83.0 81.0 83.0 81.0 10:36:12 INFO - PROCESS | 26833 | 10:36:12 INFO - PROCESS | 26833 | [#11] stanford-crypto-ccm Cycles:10 Average:115.00 Median:114.50 stddev:5.70 (5.0%) stddev-sans-first:5.85 10:36:12 INFO - PROCESS | 26833 | Values: 111.0 117.0 112.0 130.0 111.0 113.0 111.0 116.0 114.0 115.0 10:36:12 INFO - PROCESS | 26833 | 10:36:12 INFO - PROCESS | 26833 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.70 Median:137.50 stddev:5.36 (3.9%) stddev-sans-first:4.66 10:36:12 INFO - PROCESS | 26833 | Values: 129.0 137.0 138.0 135.0 136.0 146.0 139.0 135.0 147.0 135.0 10:36:12 INFO - PROCESS | 26833 | 10:36:12 INFO - PROCESS | 26833 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:64.50 stddev:1.49 (2.3%) stddev-sans-first:1.54 10:36:12 INFO - PROCESS | 26833 | Values: 64.0 66.0 64.0 64.0 64.0 65.0 64.0 67.0 68.0 64.0 10:36:12 INFO - PROCESS | 26833 | -------- Summary: end -------- 10:36:12 INFO - PROCESS | 26833 | 10:36:13 INFO - TEST-INFO | 26833: exit 0 10:36:13 INFO - TEST-OK | kraken | took 59297ms 10:36:13 INFO - TEST-START | v8_7 10:36:13 INFO - operating with platform_type : linux_ 10:36:13 INFO - Initialising browser for v8_7 test... 10:36:13 INFO - TEST-INFO | started process 27125 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppzKolv/profile http://localhost:60322/getInfo.html) 10:36:16 INFO - PROCESS | 27125 | 10:36:16 INFO - PROCESS | 27125 | (process:27202): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:36:17 INFO - PROCESS | 27125 | __metrics Screen width/height:1600/1200 10:36:17 INFO - PROCESS | 27125 | colorDepth:24 10:36:17 INFO - PROCESS | 27125 | Browser inner width/height: 1024/697 10:36:17 INFO - PROCESS | 27125 | __metrics 10:36:18 INFO - TEST-INFO | 27125: exit 0 10:36:18 INFO - Browser initialized. 10:36:18 INFO - Running cycle 1/1 for v8_7 test... 10:36:18 INFO - TEST-INFO | started process 27251 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppzKolv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:36:19 INFO - PROCESS | 27251 | 10:36:19 INFO - PROCESS | 27251 | (process:27318): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:36:30 INFO - PROCESS | 27251 | RSS: Main: 141406208 10:36:30 INFO - PROCESS | 27251 | 10:36:52 INFO - PROCESS | 27251 | Cycle 1(1): loaded http://localhost:60322/tests/v8_7/run.html (next: http://localhost:60322/tests/v8_7/run.html) 10:36:52 INFO - PROCESS | 27251 | RSS: Main: 144941056 10:36:52 INFO - PROCESS | 27251 | 10:36:52 INFO - PROCESS | 27251 | __start_tp_report 10:36:52 INFO - PROCESS | 27251 | _x_x_mozilla_page_load 10:36:52 INFO - PROCESS | 27251 | _x_x_mozilla_page_load_details 10:36:52 INFO - PROCESS | 27251 | |i|pagename|runs| 10:36:52 INFO - PROCESS | 27251 | |0;Richards;165.61775422325275 10:36:52 INFO - PROCESS | 27251 | |1;DeltaBlue;169.9524133242692 10:36:52 INFO - PROCESS | 27251 | |2;Encrypt;280.50490883590464 10:36:52 INFO - PROCESS | 27251 | |3;Decrypt;5251.308900523561 10:36:52 INFO - PROCESS | 27251 | |4;RayTrace;945.179584120983 10:36:52 INFO - PROCESS | 27251 | |5;Earley;553.4034311012729 10:36:52 INFO - PROCESS | 27251 | |6;Boyer;11131.868131868132 10:36:52 INFO - PROCESS | 27251 | |7;RegExp;38679.24528301887 10:36:52 INFO - PROCESS | 27251 | |8;Splay;523.8344683080147 10:36:52 INFO - PROCESS | 27251 | |9;NavierStokes;4850.241545893719 10:36:52 INFO - PROCESS | 27251 | __end_tp_report 10:36:52 INFO - PROCESS | 27251 | __startTimestamp1456339012978__endTimestamp 10:36:52 INFO - PROCESS | 27251 | 10:36:52 INFO - PROCESS | 27251 | ------- Summary: start ------- 10:36:52 INFO - PROCESS | 27251 | Number of tests: 10 10:36:52 INFO - PROCESS | 27251 | 10:36:52 INFO - PROCESS | 27251 | [#0] Richards Cycles:1 Average:165.62 Median:165.62 stddev:0.00 (0.0%) 10:36:52 INFO - PROCESS | 27251 | Values: 165.6 10:36:52 INFO - PROCESS | 27251 | 10:36:52 INFO - PROCESS | 27251 | [#1] DeltaBlue Cycles:1 Average:169.95 Median:169.95 stddev:0.00 (0.0%) 10:36:52 INFO - PROCESS | 27251 | Values: 170.0 10:36:52 INFO - PROCESS | 27251 | 10:36:52 INFO - PROCESS | 27251 | [#2] Encrypt Cycles:1 Average:280.50 Median:280.50 stddev:0.00 (0.0%) 10:36:52 INFO - PROCESS | 27251 | Values: 280.5 10:36:52 INFO - PROCESS | 27251 | 10:36:52 INFO - PROCESS | 27251 | [#3] Decrypt Cycles:1 Average:5251.31 Median:5251.31 stddev:0.00 (0.0%) 10:36:52 INFO - PROCESS | 27251 | Values: 5251.3 10:36:52 INFO - PROCESS | 27251 | 10:36:52 INFO - PROCESS | 27251 | [#4] RayTrace Cycles:1 Average:945.18 Median:945.18 stddev:0.00 (0.0%) 10:36:52 INFO - PROCESS | 27251 | Values: 945.2 10:36:52 INFO - PROCESS | 27251 | 10:36:52 INFO - PROCESS | 27251 | [#5] Earley Cycles:1 Average:553.40 Median:553.40 stddev:0.00 (0.0%) 10:36:52 INFO - PROCESS | 27251 | Values: 553.4 10:36:52 INFO - PROCESS | 27251 | 10:36:52 INFO - PROCESS | 27251 | [#6] Boyer Cycles:1 Average:11131.87 Median:11131.87 stddev:0.00 (0.0%) 10:36:52 INFO - PROCESS | 27251 | Values: 11131.9 10:36:52 INFO - PROCESS | 27251 | 10:36:52 INFO - PROCESS | 27251 | [#7] RegExp Cycles:1 Average:38679.25 Median:38679.25 stddev:0.00 (0.0%) 10:36:52 INFO - PROCESS | 27251 | Values: 38679.2 10:36:52 INFO - PROCESS | 27251 | 10:36:52 INFO - PROCESS | 27251 | [#8] Splay Cycles:1 Average:523.83 Median:523.83 stddev:0.00 (0.0%) 10:36:52 INFO - PROCESS | 27251 | Values: 523.8 10:36:52 INFO - PROCESS | 27251 | 10:36:52 INFO - PROCESS | 27251 | [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 10:36:52 INFO - PROCESS | 27251 | Values: 4850.2 10:36:52 INFO - PROCESS | 27251 | -------- Summary: end -------- 10:36:52 INFO - PROCESS | 27251 | 10:36:53 INFO - TEST-INFO | 27251: exit 0 10:36:53 INFO - TEST-OK | v8_7 | took 40813ms 10:36:53 INFO - SUITE-END | took 1209s 10:36:54 INFO - Completed test suite (00:20:09) 10:36:54 INFO - Working with test: dromaeo_css 10:36:54 INFO - Generating results file: dromaeo_css 10:36:54 INFO - Working with test: kraken 10:36:54 INFO - Generating results file: kraken 10:36:54 INFO - javascript benchmark 10:36:54 INFO - Working with test: v8_7 10:36:54 INFO - Generating results file: v8_7 10:36:54 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:36:54 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 10:36:54 INFO - process_Request line: dromaeo_css 7297.18 graph.html#tests=[[72,52,43]] 10:36:54 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:36:54 INFO - process_Request line: kraken 1498.90 graph.html#tests=[[232,52,43]] 10:36:54 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:36:54 INFO - process_Request line: v8_7 22003.25 graph.html#tests=[[230,52,43]] 10:36:54 INFO - RETURN: dromaeo_css: 7297.18 10:36:54 INFO - RETURN: kraken: 1498.90 10:36:54 INFO - RETURN: v8_7: 22003.25 10:36:54 INFO - javascript benchmark 10:36:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3356.7146792522635, 3375.071855239809, 3389.542411774413, 3404.6935775780175, 3406.403879321118, 5394.865128371793, 5403.621746477748, 5410.0802863513245, 5436.293281873356, 5447.373552041517, 5415.10650742628, 5462.317210348697, 5472.699001554913, 5479.835604931848, 5481.287432633762, 4955.876103097416, 4974.900501989958, 5035.949640503584, 5053.014662140884, 5120.667156634825, 4871.878203044935, 4992.07646585381, 5011.173156429185, 5022.447530771612, 5083.694978301295, 4995.500449955011, 5010.799568017275, 5069.467705890884, 5072.036313100518, 5090.440051594322, 5121.513456221672, 5130.538251557377, 5133.845984620468, 5153.510416510426, 5176.741162941876, 4833.782479788418, 4907.0, 4930.482299358588, 5042.117629414838, 5047.066292735855, 5211.218317252405, 5212.8957420851375, 5306.071437498423, 5307.2835167252315, 5331.466853314638, 5864.354920958691, 5869.442402971711, 5894.145348924425, 5903.557233207526, 5918.437748413894, 5669.829905102853, 5822.0684690449325, 5870.706464676792, 5931.406859314077, 5941.376155503696, 5484.067708489566, 5485.917711234295, 5497.917531237034, 5504.339479262514, 5512.586556008276, 5949.137375080676, 5952.7023648817385, 5953.255843019622, 5970.0, 5992.161097446361, 5631.831045068655, 5734.455226753452, 5752.165935939265, 5827.970860145672, 5850.64896106235, 5903.822885313448, 5923.763049477972, 5938.198343223696, 5952.8809423812145, 5959.851003724942, 5762.193292938992, 5874.73563689635, 5904.822855314347, 5908.438698323653, 5920.348761636216, 5757.827265182052, 5826.2134611827705, 5926.940730592725, 5932.2584676915385, 5970.373110823388, 4432.800523976429, 4453.866384008485, 4458.888527786831, 4459.576340247671, 4490.326451032306, 3957.762534247954, 4044.7168698190844, 4049.8785036448953, 4063.6545893599377, 4064.837406503707, 5467.9453205467435, 5518.19986102013, 5530.391656917735, 5533.6403133796175, 5587.8603034923635, 5929.584929055011, 5937.346891841894, 5966.940330596725, 5975.641461512323, 5978.760849566055, 5347.331583552056, 5391.81128660495, 5527.695976721319, 5576.665400075927, 5578.330600327987, 4906.0, 4934.629902757308, 4947.579455746302, 4956.553910148104, 4964.0, 6002.849928751816, 6061.090836374579, 6099.207103076572, 6104.267487901391, 6127.601705889192, 5801.36185019639, 5864.208331875313, 5887.1757953887345, 5925.64446133242, 5972.223610930551, 6025.517958563392, 6040.818775436744, 6087.147799308189, 6090.573659843769, 6100.0, 5801.535877129735, 5829.766809327749, 5833.854153646193, 5846.093855452412, 5858.121281807763, 5792.594518383673, 5919.526437884872, 5939.376365481735, 5968.104784282393, 6065.514758819196, 5666.036773748555, 5725.7137143141845, 5728.312602487728, 5746.339170995222, 5761.539076873756, 5688.0, 5697.971510142423, 5734.913976290442, 5741.110127930177, 5753.1945527627, 5567.914256719901, 5632.9436705632415, 5666.744996475251, 5734.5125664319, 5764.36591974874, 5713.0, 5828.883422331614, 5834.27071616048, 5839.5036421904615, 5848.473637372657, 5587.938291724559, 5696.145578163143, 5714.171445140514, 5725.08398656213, 5728.083506639085], "unit": "score", "name": "dojo.html", "value": 5422.494507814671}, {"lowerIsBetter": false, "replicates": [538.719865669852, 553.3636318234032, 554.0746952589176, 567.6735876870798, 579.9884002319953, 30371.84814075929, 38023.80988095063, 38357.80821095894, 38530.229395412076, 38564.61435385649, 40914.59085409145, 41202.175956480925, 41509.58490415095, 41532.79233603835, 41630.0, 8743.387962842604, 8905.777355566099, 8983.146601072887, 8989.146031127033, 9002.54987250638, 8665.220130188281, 8724.345674074439, 8748.912510874874, 8760.0, 8821.955890220572, 8762.079981601935, 9109.225715814164, 9148.405353651991, 9156.542172891362, 9160.633574657006, 9010.54947252638, 9039.141281578239, 9055.954720226422, 9066.954665226698, 9083.22792562633, 8931.196192342655, 8998.415103018282, 9037.68368107113, 9058.909410905939, 9118.270538356915, 41888.1622367554, 42559.0, 42602.57397426048, 42625.78687106576, 42731.57268427307, 3655.5796083450214, 3696.0944568580603, 3721.4045752679713, 3822.9426558601645, 4236.894077648052, 33737.6626233737, 33916.15209619755, 34048.6595134048, 34108.48837267443, 34422.0, 4051.0441528932542, 4102.548719640837, 4240.830366785356, 4247.723897946655, 4304.39738436616, 225836.0, 228956.0, 229492.0, 231177.84411078005, 232335.0, 61724.0, 62430.687846561385, 64220.67889660522, 71021.0, 72549.6372518134, 66957.0, 67273.66363168153, 67415.3258467419, 67555.66222168857, 67609.66195168992, 17944.820551794313, 18156.45530634083, 18212.36256731008, 18238.726419103725, 18288.81711182871, 13441.865581344256, 13571.1857288563, 13599.252041137635, 13627.863721362659, 13680.247586382844, 22486.887565562396, 23977.0, 24008.51982960331, 24095.638565421534, 24128.63807042896, 9331.617999042594, 9374.203192728559, 9461.101195386427, 9534.95232523833, 9545.809083818285, 1079.7192729890285, 1099.8240281554913, 1107.0811226681835, 1181.4033912873945, 1194.9342786146844, 31583.684163158534, 32084.03747887567, 33329.00012999614, 33724.49413258803, 34135.829320853234, 1116.4975760907623, 1148.9885101148882, 1175.4534141624185, 1209.0, 1248.1450206608502, 15477.767833482507, 15765.527034188992, 15890.284937177854, 16009.919950400406, 16151.757723634155, 428013.0, 500309.0, 501337.0, 507409.0, 509961.0, 53993.0, 54689.0, 54890.45109548853, 54991.725041374535, 55053.44946550483, 1467.4130347860942, 1485.2128371962876, 1504.4207979927587, 1505.3301280929882, 1508.9170095644624, 30272.697273026988, 30480.84759576188, 31346.216344590655, 31751.68248317487, 33558.16104597405, 50048.0, 50649.74675126601, 50757.746211268706, 50759.49240507548, 50874.23688644599, 312863.0, 313091.0, 315004.0, 315212.0, 315324.0, 34536.0, 35295.470567942015, 35383.64616353803, 35693.0, 35921.820390897876, 46057.0, 47119.528804712885, 47251.0, 47706.52293477021, 48214.27678584754, 39314.80342598269, 39547.40678889876, 40035.59964400435, 40414.39378409385, 40774.0, 41755.1648967025, 43467.34798977955, 43594.346084808116, 43904.0, 44170.0, 36927.44608830816, 37044.25911481701, 37413.625863741014, 37773.24453510969, 37843.432348514245, 31585.8420707895, 32677.0, 32798.836005819816, 32984.34031319408, 33062.33875322528, 26696.0, 27572.862135689193, 27839.721602784524, 27991.0, 28011.859940700167], "unit": "score", "name": "ext.html", "value": 20144.508173906448}, {"lowerIsBetter": false, "replicates": [391.37575566970673, 394.4773175542407, 397.47334781414617, 398.0844058665073, 398.67507980995487, 15677.372905083783, 16516.587085322873, 16954.23705933233, 18244.908775456122, 18253.0, 15302.387904483836, 15879.444219452322, 15959.601009974756, 17207.397741079065, 18498.722519162224, 5121.206213036985, 5478.205660179272, 5683.886322273552, 5690.118031705071, 5703.201551782754, 5508.669479831203, 5586.190002449643, 5687.658740475564, 5691.51622112121, 5709.4290570942985, 5525.198846167304, 5615.438456154393, 5628.831135065954, 5632.127020311858, 5708.372079071299, 5638.4361563843495, 5677.17680936264, 5714.51426628737, 5728.026235539968, 5728.79949201776, 5356.625036247464, 5494.395616482224, 5544.584156188302, 5573.637713548606, 5607.8878422431735, 19732.80267197324, 20092.49768755778, 20502.5899482011, 20596.176152953863, 20696.0, 2249.898754556049, 2313.4679023824447, 2318.385627808632, 2472.7898128659085, 2501.9866953883707, 9891.604335826558, 10177.592896284139, 10235.590576376935, 10521.579136834594, 10573.9471302643, 1788.1685016467404, 1901.1444849817499, 1953.7850836408127, 2035.1073501643466, 2175.71715676961, 61048.38951610516, 61200.38799611991, 61930.380696193366, 62860.05709914355, 63246.36753632497, 10959.397233152094, 11006.834897476545, 11014.779704405866, 11041.668749937355, 11061.281016733887, 14334.354954027094, 14396.28018599066, 14459.204743739196, 14473.203973781332, 14523.564293071226, 8479.576021198915, 8495.938007749031, 8528.360372972053, 8575.442596231349, 8603.827923441497, 8546.0, 8554.35842311829, 8557.786055348666, 8565.61454734526, 8627.654893804178, 4529.682922195415, 4698.2952557116705, 4719.244920812654, 4744.5492678195515, 4775.068861572029, 1936.7579052618423, 1961.3527535913115, 2008.256944930385, 2010.6380851446588, 2026.8378529717588, 991.5339790298548, 1019.6176433837311, 1024.7643042100358, 1041.4116024446164, 1043.3218408034686, 16486.258118384703, 17453.7381939271, 18059.819401806075, 18273.17770700322, 18545.25818967253, 966.7873067925045, 1006.4263369879098, 1022.8619136416637, 1026.5483187397522, 1079.6976846482996, 10279.640212592523, 10481.213908956859, 10572.52423640938, 10581.57673693059, 10713.464326783629, 599853.0, 611928.0, 617573.0, 620707.0, 622726.0, 49093.2636010453, 64357.03464448037, 76757.23242767502, 77430.22569774343, 77865.61067194628, 1112.1380929779486, 1118.139032944628, 1128.328644456547, 1150.7525881935424, 1155.122107198535, 16264.0, 16358.34566617322, 16363.34546618122, 16495.34018639241, 16572.254248558602, 34525.0, 35122.0, 35967.28065438729, 36043.45934811032, 36383.636163638024, 45833.083338333716, 45932.77033614944, 46586.0, 46895.0, 47074.76462617665, 7654.770356889302, 7688.423368247516, 7856.882146767689, 7905.56519391439, 8083.0, 10872.347659140476, 10909.34543927367, 11438.169892817443, 11629.825552616887, 11940.16418850707, 9979.151772099453, 10100.191984641358, 10390.480475976323, 10437.373757574569, 10619.628313009007, 10288.794224115625, 10413.895861041292, 10502.474876256309, 10609.9469502652, 10798.460076995962, 10028.849567256351, 10526.0, 10988.175886808362, 10999.670009899715, 11041.39272340029, 8187.426880118334, 8296.83406331882, 8345.123762004901, 8358.916410835815, 8359.456635318686, 10901.127909767041, 10999.285046471954, 11038.392888390894, 11073.94463027712, 11225.214235003472], "unit": "score", "name": "jquery.html", "value": 8797.720348996996}, {"lowerIsBetter": false, "replicates": [1572.6147093961977, 1592.0368177252765, 1794.8474379677727, 1858.5911099558093, 1867.0291448446817, 7878.960605196966, 7894.802629934247, 7957.681692732298, 8036.477628954121, 8088.676452941882, 7846.686132554691, 7898.605069746504, 7943.880841787378, 7951.72168974086, 7982.441229113964, 2353.0705371378294, 2366.1363602285214, 2372.762723727622, 2390.6294524348755, 2397.4725560376687, 2380.0955636858057, 2389.8446600970883, 2407.1334319644916, 2407.8916448759846, 2411.46947671512, 2355.057976809273, 2392.3899405651537, 2411.7829395354415, 2424.4302588891596, 2432.1122790181544, 2352.3766201956496, 2352.7882490575844, 2362.7400985891536, 2379.9643005354847, 2383.1778036577352, 2371.0752806405517, 2375.3942744600017, 2380.9047638094457, 2391.6651668766385, 2392.3301475586863, 7865.960670196612, 7878.251566101211, 7900.762977110696, 7903.683852645887, 7921.0, 4789.688670236458, 4934.087193869145, 4952.281919121707, 4956.6282528810125, 4968.279599458058, 3174.4286028514857, 3200.5917396345767, 3221.7261532769744, 3244.626867910197, 3245.075153581218, 1058.9099926506256, 1072.0780129088978, 1076.95692172313, 1076.962306319275, 1095.0691911874842, 10682.412467314294, 10719.732006699895, 10728.249022568501, 10791.082757965503, 10851.51168197433, 4181.832726690959, 4244.045089854758, 4317.201317756225, 4383.561643835591, 4396.912061758747, 8984.46093234408, 8986.68546600866, 9012.2790176787, 9032.412893162054, 9046.683366082156, 4935.506449355107, 4958.9504104959215, 4961.975190124026, 4969.105560999054, 4971.105201063771, 4563.885902852455, 4574.817007319736, 4602.125596136723, 4606.5854073132905, 4644.210484217691, 3372.460406334975, 3420.846061927219, 3433.4334834752485, 3498.5626796650417, 3525.5945566260207, 1029.0, 1043.4991204222015, 1047.518141654832, 1049.8320268757116, 1105.3644154611131, 1287.523616261989, 1287.8969682425384, 1342.2684636872928, 1372.567641193021, 1412.8304603447446, 7129.714811407589, 7395.445341599401, 7552.093748750075, 7554.131274903457, 7561.0, 1157.7047852797482, 1169.9415029248503, 1195.6114262864603, 1201.5193922430922, 1209.57664817315, 5655.0386434306265, 5655.604107712421, 5656.91514627281, 5692.9146062809095, 5701.144828275709, 8895.377323587416, 9457.66898158575, 9478.95260523693, 9482.762930926781, 9506.429614223169, 9566.760830979281, 9603.807923841623, 9610.183134433652, 9629.133377996013, 9646.758831029281, 7424.0, 7558.395328373717, 7579.204183560757, 7585.772426827204, 7606.163322034572, 7331.486795924234, 7364.815879603053, 7386.815329616803, 7424.183339832506, 7438.330550250287, 8590.0, 8693.739187824376, 8868.379213454997, 8875.556222188736, 8910.420822646507, 9033.367664263438, 9036.638534458549, 9046.276297896022, 9080.59137338808, 9180.862287065833, 6729.192496900403, 6760.18877734675, 6772.458203343819, 6780.627065511444, 6874.381305682513, 7515.962420187864, 7520.0, 7579.962100189464, 7610.391168706379, 7630.8855367170645, 6824.863502730017, 6931.549449285781, 7350.448716346403, 7389.113306403266, 7523.172451030273, 6995.650217489004, 6999.0551275577145, 7042.683079261343, 7062.858742825012, 7140.07179066718, 7047.7180912762915, 7085.078939737801, 7085.858282834418, 7095.0, 7099.716011359487, 6422.775202867877, 6584.901226481511, 6590.90113648286, 6594.670266486753, 6598.934010659832, 6630.734770609121, 6631.0, 6639.568428052161, 6655.0, 6675.632840193642], "unit": "score", "name": "mootools.html", "value": 4621.618172970737}, {"lowerIsBetter": false, "replicates": [356.3621118198424, 361.4097968936678, 365.11823945172404, 366.30767848765856, 372.0364256575467, 6296.968515157418, 6381.202349706286, 6416.935830641698, 6448.580842245251, 6617.834554136137, 6364.363563643645, 6414.262359828621, 6424.967875160618, 6435.903461448082, 6439.130717353156, 4906.705597664134, 4910.312556242129, 4911.5088491150955, 4915.0, 4927.384076990376, 4897.412310522743, 4926.433460152092, 4929.359183306183, 4940.184869496528, 4948.653594248404, 4495.258282383403, 4807.591354734852, 4819.903601927959, 4821.325014497973, 4829.589484893788, 4800.543948324921, 4809.8456370471185, 4811.398575178103, 4823.782929768169, 4826.131296366652, 4195.202911446846, 4196.971741923217, 4235.8093885775215, 4240.936385954183, 4248.235317642823, 5954.07711804671, 6048.637081775108, 6064.9090263646085, 6087.05650624154, 6100.389961003909, 5680.3467601225975, 5690.0, 5692.658440493584, 5697.857553561153, 5707.828765137053, 6775.424088952395, 6786.185657721105, 6797.082393876863, 6803.421709154728, 6830.453563714891, 4733.3846599942135, 4748.8127968008, 4753.287006948951, 4755.9286610700865, 4766.904661906742, 6794.796156115275, 6923.757668481579, 6927.896081558731, 6955.721771129149, 6957.5129740918155, 4754.144254034307, 4759.809607615726, 4775.5224477551965, 4782.115308667908, 4792.832250871203, 4831.806727730922, 4836.613070954315, 4837.177679794373, 4837.661363704507, 4848.393950756155, 5479.561635069264, 5538.224648549206, 5559.555235581144, 5562.16567514876, 5600.579956503197, 6644.933550664431, 6668.566543174678, 6685.532012759158, 6700.865982680417, 6711.63086030273, 1712.3236321652878, 1734.2022669572139, 1783.8662100342526, 1784.6609144262547, 1785.4643606918132, 1196.7307355844866, 1199.0, 1209.915305928594, 1220.7619514194646, 1234.2224398628807, 6373.840653983688, 6411.294757576663, 6422.357764223634, 6426.4537514311805, 6434.453071488882, 6894.827629309308, 6943.79168624942, 6945.617991010543, 6965.616891071039, 6967.059446974695, 6345.968270158712, 6410.775622853178, 6412.102305677209, 6422.100905873182, 6466.385693359218, 3750.3249415104997, 3769.660730534265, 3781.1681430085337, 3787.299349620274, 3796.3166630006313, 7125.96437017822, 7179.461540384492, 7186.065811444479, 7186.706392849337, 7211.639418029077, 6979.3020697930815, 7052.365287124184, 7127.4654400920135, 7147.8570428592175, 7158.319959603829, 7081.964590177016, 7100.538464999759, 7109.217986021534, 7118.5017048806085, 7135.928640713734, 6889.586624802528, 6908.481863860331, 6910.343517365842, 6925.411340035952, 6930.965345173242, 6734.528582999143, 6817.659117044227, 6889.724411023503, 6982.1272340957385, 6999.580025198505, 7250.782476525713, 7290.3438690518105, 7298.854022919618, 7316.158641756266, 7317.378022868116, 4843.95156048435, 4862.440819305683, 4875.731834749123, 4876.853939324185, 4884.7069175849565, 6879.89680154788, 6956.0, 7068.858622827617, 7103.538270012433, 7108.609026503592, 6863.6568171590225, 6868.210155832143, 6899.724011039502, 6931.68807403658, 6941.722331106699, 6871.450283977169, 6978.371946524837, 6979.2671769465505, 6984.546004509691, 6993.0, 6609.900851487136, 6755.527113102232, 6781.0845535854005, 6786.185657721105, 6787.457003439614, 6833.180018397824, 6894.586324820527, 6933.4106600939485, 6940.479464040116, 6948.235694073749, 6725.226598941184, 6735.158105236846, 6759.594424334556, 6759.729610815709, 6778.220504641832], "unit": "score", "name": "prototype.html", "value": 5122.302178436315}, {"lowerIsBetter": false, "replicates": [869.699953516037, 944.1078181118845, 953.6519170502769, 956.8421210500268, 970.9320347575671, 14508.927455362722, 14612.780808287858, 14651.853481465196, 15164.317605707742, 15246.237688115578, 13228.867711322884, 13288.402021909013, 13291.268980206109, 13435.26106064166, 13485.123466974665, 764.6826566974698, 776.2509178642608, 878.3280790195505, 917.1562162810214, 927.8932922713873, 907.6324088744069, 912.2473958983832, 918.485648037098, 919.1957037592107, 920.3419555018161, 944.8015916657511, 965.1892410375283, 965.9275554333418, 966.4877614864098, 971.7036303927299, 955.7945041815973, 957.0716405087054, 957.6552441121191, 959.2182371367348, 968.3124981263277, 715.599264411931, 716.5378330976544, 717.0212659719498, 717.3149642091789, 722.0757430488983, 14068.085574437731, 14149.646258843612, 14186.787198192036, 14197.574072777834, 14208.786868196985, 13980.58058258254, 14108.294585270696, 14225.715485690229, 14322.498712545115, 14338.42646294147, 11328.773424531464, 11440.828387574193, 11465.828012579817, 11678.357690327028, 11764.823527647091, 3731.2164445466483, 3751.3247615429214, 3780.8109594520165, 3811.7712937223578, 3827.0432391902023, 49741.751291243316, 49773.0, 50393.74803125961, 50500.24249636258, 50785.238221426705, 11053.283519469389, 11297.49161287744, 11402.0308273796, 11423.942880285711, 11482.77034459323, 20245.595088098155, 20400.59198816045, 20485.38543843687, 20485.89757051235, 20534.69197962032, 7651.846963060819, 7660.042494688164, 7866.803329916684, 7947.801304967306, 8204.958975205085, 4417.249067658506, 4455.754933478625, 4583.060472603175, 4605.700629459075, 4618.122556714214, 2991.0279159273323, 3044.786864919479, 3051.420230156263, 3063.785535012528, 3071.754259659222, 532.866783304174, 544.3902828831655, 545.9563234941274, 546.1507356061363, 552.1855263486326, 561.9241402410704, 672.825065482978, 707.377507793149, 717.4762423430925, 735.4447392218948, 8731.781705457288, 9025.503597302211, 9320.20778233844, 9903.900960990442, 9938.055884690943, 546.3525722019419, 554.4515103338584, 588.3968931844893, 751.8158051277472, 771.4407054885276, 4127.153933443637, 4193.161367726467, 4305.655547556188, 4323.221820072355, 4432.867013989586, 63136.684316578125, 63371.366286336546, 63401.68299158475, 63741.36258637354, 63886.0, 27997.72002279992, 28033.57949630757, 28061.43877122446, 28097.859510702725, 28138.71861281402, 48004.279935800296, 48253.276200856315, 48380.75809620929, 48626.0, 48646.270305945436, 8221.848941148124, 8595.613197406257, 8729.6944606941, 8842.823143536965, 9413.058694130532, 35921.28157436889, 36436.81781591075, 36732.81633591815, 37045.62954370422, 37847.0, 46736.7663161682, 46995.29507057329, 47247.29129062998, 47748.761256193495, 51453.742731286104, 11303.547858085913, 11472.598459053894, 11499.8275025873, 11554.0, 11852.992495637622, 12798.872011279767, 13041.804372934224, 13140.211587304791, 13216.933915330363, 13384.330783460982, 11848.76302473963, 12244.755104897675, 12585.93707031459, 12630.980464522392, 12966.35168241603, 10575.682729518127, 10683.57265709363, 11584.015358694605, 11953.521859125538, 12104.334261615695, 10947.288426252268, 11594.71013224676, 11712.941435292769, 11812.291262524275, 12218.327991960528, 10112.898871011195, 10304.227182961158, 10459.581616735246, 10466.738331541772, 10653.733656658336, 10300.742481438025, 10855.2401331906, 11063.72340691489, 11088.611898583511, 11154.0], "unit": "score", "name": "yui.html", "value": 6635.994070860881}], "name": "dromaeo_css", "value": 7297.177051977525}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 118.0, 112.0, 112.0, 122.0, 111.0, 111.0, 113.0, 110.0], "unit": "score", "name": "ai-astar", "value": 112.7}, {"lowerIsBetter": true, "replicates": [145.0, 126.0, 152.0, 165.0, 132.0, 169.0, 160.0, 128.0, 168.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 146.9}, {"lowerIsBetter": true, "replicates": [162.0, 165.0, 162.0, 162.0, 164.0, 160.0, 164.0, 163.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.7}, {"lowerIsBetter": true, "replicates": [75.0, 75.0, 73.0, 146.0, 75.0, 73.0, 76.0, 73.0, 163.0, 74.0], "unit": "score", "name": "audio-fft", "value": 90.3}, {"lowerIsBetter": true, "replicates": [95.0, 98.0, 146.0, 94.0, 96.0, 95.0, 141.0, 96.0, 96.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 110.0}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [150.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 168.0], "unit": "score", "name": "imaging-darkroom", "value": 148.7}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 97.0, 96.0, 98.0, 96.0, 97.0, 97.0, 100.0], "unit": "score", "name": "imaging-desaturate", "value": 97.0}, {"lowerIsBetter": true, "replicates": [53.0, 55.0, 55.0, 55.0, 57.0, 55.0, 54.0, 64.0, 52.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 55.7}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.7}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 82.0, 83.0, 82.0, 89.0, 83.0, 81.0, 83.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.6}, {"lowerIsBetter": true, "replicates": [111.0, 117.0, 112.0, 130.0, 111.0, 113.0, 111.0, 116.0, 114.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.0}, {"lowerIsBetter": true, "replicates": [129.0, 137.0, 138.0, 135.0, 136.0, 146.0, 139.0, 135.0, 147.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.7}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 64.0, 64.0, 64.0, 65.0, 64.0, 67.0, 68.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.0}], "name": "kraken", "value": 1498.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.61775422325275], "unit": "score", "name": "Richards", "value": 213.15347599999996}, {"lowerIsBetter": false, "replicates": [169.9524133242692], "unit": "score", "name": "DeltaBlue", "value": 389.0383119999998}, {"lowerIsBetter": false, "replicates": [280.50490883590464], "unit": "score", "name": "Encrypt", "value": 948.9352650000003}, {"lowerIsBetter": false, "replicates": [5251.308900523561], "unit": "score", "name": "Decrypt", "value": 50.68850548354939}, {"lowerIsBetter": false, "replicates": [945.179584120983], "unit": "score", "name": "RayTrace", "value": 782.908362}, {"lowerIsBetter": false, "replicates": [553.4034311012729], "unit": "score", "name": "Earley", "value": 1204.2986409999994}, {"lowerIsBetter": false, "replicates": [11131.868131868132], "unit": "score", "name": "Boyer", "value": 59.869825271470894}, {"lowerIsBetter": false, "replicates": [38679.24528301887], "unit": "score", "name": "RegExp", "value": 23.55229512195121}, {"lowerIsBetter": false, "replicates": [523.8344683080147], "unit": "score", "name": "Splay", "value": 155.56631900000005}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 22003.24556197631}]} 10:36:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "22003.25"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1498.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7297.18"}}} 10:36:54 INFO - Return code: 0 10:36:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:36:54 INFO - # TBPL SUCCESS # 10:36:54 INFO - Running post-action listener: _resource_record_post_action 10:36:54 INFO - Running post-run listener: _resource_record_post_run 10:36:55 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 262144; Write bytes: 524939264; Read time: 20; Write time: 1027524 10:36:55 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 0; Write bytes: 255225856; Read time: 0; Write time: 727244 10:36:55 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 262144; Write bytes: 269713408; Read time: 20; Write time: 300280 10:36:55 INFO - Running post-run listener: _upload_blobber_files 10:36:55 INFO - Blob upload gear active. 10:36:55 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 10:36:55 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 10:36:55 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'] 10:36:55 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 10:36:55 INFO - (blobuploader) - INFO - Open directory for files ... 10:36:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:36:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:36:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:36:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:56 INFO - (blobuploader) - INFO - Done attempting. 10:36:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:36:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:36:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:36:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:57 INFO - (blobuploader) - INFO - Done attempting. 10:36:57 INFO - (blobuploader) - INFO - Iteration through files over. 10:36:57 INFO - Return code: 0 10:36:57 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 10:36:57 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 10:36:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/739f852be2d293e1f61213bc14658bac13046fae3fc38c40ba3034d7e0e89b0afa7cf106f46d74d165f64496718cdc306fb9200f76a175cade6ae5a0f46b1ff7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ca73b2410e53921c51a595f36d686e70e92fc25fa78b313e185ad45c541d2c1378e62422587eaf832066be785bafee0c80e9ccb49ec0a429eaa18dbb66cf693"} 10:36:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 10:36:57 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 10:36:57 INFO - Contents: 10:36:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/739f852be2d293e1f61213bc14658bac13046fae3fc38c40ba3034d7e0e89b0afa7cf106f46d74d165f64496718cdc306fb9200f76a175cade6ae5a0f46b1ff7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ca73b2410e53921c51a595f36d686e70e92fc25fa78b313e185ad45c541d2c1378e62422587eaf832066be785bafee0c80e9ccb49ec0a429eaa18dbb66cf693"} 10:36:57 INFO - Running post-run listener: copy_logs_to_upload_dir 10:36:57 INFO - Copying logs to upload dir... 10:36:57 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 10:36:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.436262 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-02-24 10:36:57.361650) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 10:36:57.365094) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1456336816.224511-2044066368 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/739f852be2d293e1f61213bc14658bac13046fae3fc38c40ba3034d7e0e89b0afa7cf106f46d74d165f64496718cdc306fb9200f76a175cade6ae5a0f46b1ff7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ca73b2410e53921c51a595f36d686e70e92fc25fa78b313e185ad45c541d2c1378e62422587eaf832066be785bafee0c80e9ccb49ec0a429eaa18dbb66cf693"} build_url:https://queue.taskcluster.net/v1/task/c3F7PVDpSfKdUdXACnHGIg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011227 build_url: 'https://queue.taskcluster.net/v1/task/c3F7PVDpSfKdUdXACnHGIg/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/739f852be2d293e1f61213bc14658bac13046fae3fc38c40ba3034d7e0e89b0afa7cf106f46d74d165f64496718cdc306fb9200f76a175cade6ae5a0f46b1ff7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ca73b2410e53921c51a595f36d686e70e92fc25fa78b313e185ad45c541d2c1378e62422587eaf832066be785bafee0c80e9ccb49ec0a429eaa18dbb66cf693"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 10:36:57.392224) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:36:57.392612) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1456336816.224511-2044066368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 10:36:57.476999) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 10:36:57.477376) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 10:36:57.477758) ========= ========= Total master_lag: 0.28 =========