builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-009 starttime: 1456761618.38 results: success (0) buildid: 20160229053003 builduid: 6436ae5f6f8046b6bc328b8bd4c782d4 revision: 76c51477853faeac91211c2adee7adfee858b276 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:18.383693) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:18.384473) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:18.384953) ========= 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=aa52b8aba932b19cc50b5275000001de-1456761388.332407-1175893989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.009151 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:18.408595) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:18.408876) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:18.422224) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:18.422508) ========= 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=aa52b8aba932b19cc50b5275000001de-1456761388.332407-1175893989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004585 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:18.471390) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:18.471689) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:18.472089) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:18.472363) ========= 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=aa52b8aba932b19cc50b5275000001de-1456761388.332407-1175893989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-29 08:00:18-- 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% 222M=0s 2016-02-29 08:00:18 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095245 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:18.579608) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:18.579922) ========= 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=aa52b8aba932b19cc50b5275000001de-1456761388.332407-1175893989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022239 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:18.629477) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:18.629825) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 76c51477853faeac91211c2adee7adfee858b276 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 76c51477853faeac91211c2adee7adfee858b276 --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=aa52b8aba932b19cc50b5275000001de-1456761388.332407-1175893989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-29 08:00:18,683 truncating revision to first 12 chars 2016-02-29 08:00:18,683 Setting DEBUG logging. 2016-02-29 08:00:18,683 attempt 1/10 2016-02-29 08:00:18,683 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/76c51477853f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-29 08:00:18,981 unpacking tar archive at: fx-team-76c51477853f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.633216 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:19.275654) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:19.276049) ========= echo 76c51477853faeac91211c2adee7adfee858b276 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'76c51477853faeac91211c2adee7adfee858b276'] 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=aa52b8aba932b19cc50b5275000001de-1456761388.332407-1175893989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 76c51477853faeac91211c2adee7adfee858b276 program finished with exit code 0 elapsedTime=0.004061 script_repo_revision: '76c51477853faeac91211c2adee7adfee858b276' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:19.325570) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:19.325886) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:19.335536) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-02-29 08:00:19.335914) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa52b8aba932b19cc50b5275000001de-1456761388.332407-1175893989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:00:19 INFO - MultiFileLogger online at 20160229 08:00:19 in /builds/slave/test-pgo 08:00:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:00:19 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:00:19 INFO - {'append_to_log': False, 08:00:19 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:00:19 INFO - 'blob_upload_branch': 'Fx-Team', 08:00:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:00:19 INFO - 'branch': 'Fx-Team', 08:00:19 INFO - 'buildbot_json_path': 'buildprops.json', 08:00:19 INFO - 'config_files': ('talos/linux_config.py',), 08:00:19 INFO - 'default_actions': ('clobber', 08:00:19 INFO - 'read-buildbot-config', 08:00:19 INFO - 'download-and-extract', 08:00:19 INFO - 'populate-webroot', 08:00:19 INFO - 'create-virtualenv', 08:00:19 INFO - 'install', 08:00:19 INFO - 'run-tests'), 08:00:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:00:19 INFO - 'download_minidump_stackwalk': True, 08:00:19 INFO - 'download_symbols': 'ondemand', 08:00:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:00:19 INFO - 'tooltool.py': '/tools/tooltool.py', 08:00:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:00:19 INFO - '/tools/misc-python/virtualenv.py')}, 08:00:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:00:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:00:19 INFO - 'installer_path': 'installer.exe', 08:00:19 INFO - 'log_level': 'info', 08:00:19 INFO - 'log_name': 'talos', 08:00:19 INFO - 'log_to_console': True, 08:00:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:00:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:00:19 INFO - 'opt_config_files': (), 08:00:19 INFO - 'pip_index': False, 08:00:19 INFO - 'sps_profile': False, 08:00:19 INFO - 'sps_profile_interval': 0, 08:00:19 INFO - 'suite': 'dromaeojs', 08:00:19 INFO - 'system_bits': '32', 08:00:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:00:19 INFO - 'title': 'talos-linux64-ix-009', 08:00:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:00:19 INFO - 'use_talos_json': True, 08:00:19 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:00:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:00:19 INFO - 'work_dir': 'build'} 08:00:19 INFO - ##### 08:00:19 INFO - ##### Running clobber step. 08:00:19 INFO - ##### 08:00:19 INFO - Running pre-action listener: _resource_record_pre_action 08:00:19 INFO - Running main action method: clobber 08:00:19 INFO - rmtree: /builds/slave/test-pgo/build 08:00:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:00:19 INFO - Running post-action listener: _resource_record_post_action 08:00:19 INFO - ##### 08:00:19 INFO - ##### Running read-buildbot-config step. 08:00:19 INFO - ##### 08:00:19 INFO - Running pre-action listener: _resource_record_pre_action 08:00:19 INFO - Running main action method: read_buildbot_config 08:00:19 INFO - Using buildbot properties: 08:00:19 INFO - { 08:00:19 INFO - "project": "", 08:00:19 INFO - "product": "firefox", 08:00:19 INFO - "script_repo_revision": "production", 08:00:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:00:19 INFO - "repository": "", 08:00:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:00:19 INFO - "buildid": "20160229053003", 08:00:19 INFO - "pgo_build": "True", 08:00:19 INFO - "basedir": "/builds/slave/test-pgo", 08:00:19 INFO - "buildnumber": 962, 08:00:19 INFO - "slavename": "talos-linux64-ix-009", 08:00:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:00:19 INFO - "platform": "ubuntu64_hw", 08:00:19 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:00:19 INFO - "branch": "fx-team", 08:00:19 INFO - "repo_path": "integration/fx-team", 08:00:19 INFO - "revision": "76c51477853faeac91211c2adee7adfee858b276", 08:00:19 INFO - "stage_platform": "linux64-pgo", 08:00:19 INFO - "builduid": "6436ae5f6f8046b6bc328b8bd4c782d4", 08:00:19 INFO - "slavebuilddir": "test" 08:00:19 INFO - } 08:00:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 08:00:19 INFO - Running post-action listener: _resource_record_post_action 08:00:19 INFO - ##### 08:00:19 INFO - ##### Running download-and-extract step. 08:00:19 INFO - ##### 08:00:19 INFO - Running pre-action listener: _resource_record_pre_action 08:00:19 INFO - Running main action method: download_and_extract 08:00:19 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:00:19 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')]} 08:00:19 INFO - https://queue.taskcluster.net/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:00:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/test_packages.json 08:00:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/test_packages.json 08:00:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:00:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:00:20 INFO - Downloaded 1448 bytes. 08:00:20 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:00:20 INFO - Using the following test package requirements: 08:00:20 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:00:20 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:20 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:00:20 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:20 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:00:20 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:20 INFO - u'jsshell-linux-x86_64.zip'], 08:00:20 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:20 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:00:20 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:00:20 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:20 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:00:20 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:20 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:00:20 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:20 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:00:20 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:00:20 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:20 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:00:20 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:00:20 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')]} 08:00:20 INFO - https://queue.taskcluster.net/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:00:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:00:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:00:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:00:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:00:29 INFO - Downloaded 23372317 bytes. 08:00:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:00:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 08:00:30 INFO - Return code: 0 08:00:30 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:30 INFO - https://queue.taskcluster.net/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:00:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:00:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:00:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:00:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:00:31 INFO - Downloaded 23372317 bytes. 08:00:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:00:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 08:00:32 INFO - Return code: 0 08:00:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:32 INFO - https://queue.taskcluster.net/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:00:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 08:00:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 08:00:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 08:00:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:00:33 INFO - Downloaded 10713410 bytes. 08:00:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:00:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 08:00:34 INFO - Return code: 0 08:00:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:34 INFO - https://queue.taskcluster.net/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:00:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:00:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:00:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:00:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:00:35 INFO - Downloaded 56634934 bytes. 08:00:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:00:35 INFO - mkdir: /builds/slave/test-pgo/properties 08:00:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:00:35 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:00:35 INFO - Contents: 08:00:35 INFO - build_url:https://queue.taskcluster.net/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:00:35 INFO - Running post-action listener: _resource_record_post_action 08:00:35 INFO - Running post-action listener: set_extra_try_arguments 08:00:35 INFO - ##### 08:00:35 INFO - ##### Running populate-webroot step. 08:00:35 INFO - ##### 08:00:35 INFO - Running pre-action listener: _resource_record_pre_action 08:00:35 INFO - Running main action method: populate_webroot 08:00:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:00:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:00:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:00:35 INFO - '--tppagecycles', 08:00:35 INFO - '7'], 08:00:35 INFO - 'tests': ['tsvgm']}}, 08:00:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:00:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:00:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:00:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:00:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:00:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:00:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:00:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:35 INFO - 'talos_options': ['--e10s'], 08:00:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:00:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:35 INFO - 'tests': ['damp', 'tps']}, 08:00:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:35 INFO - 'talos_options': ['--e10s'], 08:00:35 INFO - 'tests': ['damp', 'tps']}, 08:00:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:00:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:00:35 INFO - 'other': {'tests': ['a11yr', 08:00:35 INFO - 'ts_paint', 08:00:35 INFO - 'tpaint', 08:00:35 INFO - 'sessionrestore', 08:00:35 INFO - 'sessionrestore_no_auto_restore']}, 08:00:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:00:35 INFO - 'tests': ['a11yr', 08:00:35 INFO - 'ts_paint', 08:00:35 INFO - 'tpaint', 08:00:35 INFO - 'sessionrestore', 08:00:35 INFO - 'sessionrestore_no_auto_restore']}, 08:00:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:00:35 INFO - 'tests': ['a11yr', 08:00:35 INFO - 'ts_paint', 08:00:35 INFO - 'tpaint', 08:00:35 INFO - 'sessionrestore', 08:00:35 INFO - 'sessionrestore_no_auto_restore']}, 08:00:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:00:35 INFO - 'tests': ['a11yr', 08:00:35 INFO - 'ts_paint', 08:00:35 INFO - 'tpaint', 08:00:35 INFO - 'sessionrestore', 08:00:35 INFO - 'sessionrestore_no_auto_restore']}, 08:00:35 INFO - 'other_l64': {'tests': ['a11yr', 08:00:35 INFO - 'ts_paint', 08:00:35 INFO - 'tpaint', 08:00:35 INFO - 'sessionrestore', 08:00:35 INFO - 'sessionrestore_no_auto_restore']}, 08:00:35 INFO - 'other_nol64': {'tests': ['a11yr', 08:00:35 INFO - 'ts_paint', 08:00:35 INFO - 'tpaint', 08:00:35 INFO - 'sessionrestore', 08:00:35 INFO - 'sessionrestore_no_auto_restore']}, 08:00:35 INFO - 'svgr': {'tests': ['tsvgx', 08:00:35 INFO - 'tsvgr_opacity', 08:00:35 INFO - 'tart', 08:00:35 INFO - 'tscrollx', 08:00:35 INFO - 'cart']}, 08:00:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:00:35 INFO - 'tests': ['tsvgx', 08:00:35 INFO - 'tsvgr_opacity', 08:00:35 INFO - 'tart', 08:00:35 INFO - 'tscrollx', 08:00:35 INFO - 'cart']}, 08:00:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:35 INFO - 'tests': ['tp5o']}, 08:00:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:35 INFO - 'talos_options': ['--e10s'], 08:00:35 INFO - 'tests': ['tp5o']}, 08:00:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:35 INFO - 'talos_options': ['--xperf_path', 08:00:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:00:35 INFO - 'tests': ['tp5n']}, 08:00:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:35 INFO - 'talos_options': ['--e10s', 08:00:35 INFO - '--xperf_path', 08:00:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:00:35 INFO - 'tests': ['tp5n']}}, 08:00:35 INFO - 'talos.zip': {'path': '', 08:00:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:00:35 INFO - Running post-action listener: _resource_record_post_action 08:00:35 INFO - ##### 08:00:35 INFO - ##### Running create-virtualenv step. 08:00:35 INFO - ##### 08:00:35 INFO - Running pre-action listener: _resource_record_pre_action 08:00:35 INFO - Running main action method: create_virtualenv 08:00:35 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:00:35 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 08:00:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:00:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:00:36 INFO - Using real prefix '/usr' 08:00:36 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:00:36 INFO - Installing distribute.............................................................................................................................................................................................done. 08:00:38 INFO - Installing pip.................done. 08:00:38 INFO - Return code: 0 08:00:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:00:38 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')]} 08:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:38 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')]} 08:00:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:38 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 0x7fb3ec8ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c628c0>, '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 0x1c637c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c63c50>, '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': 'aa52b8aba932b19cc50b5275000001de-1456761388.332407-1175893989', '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 08:00:38 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 08:00:38 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 08:00:38 INFO - Using env: {'DISPLAY': ':0', 08:00:38 INFO - 'HOME': '/home/cltbld', 08:00:38 INFO - 'LANG': 'en_US.UTF-8', 08:00:38 INFO - 'LANGUAGE': 'en_US:en', 08:00:38 INFO - 'LOGNAME': 'cltbld', 08:00:38 INFO - 'MAIL': '/var/mail/cltbld', 08:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:38 INFO - 'MOZ_NO_REMOTE': '1', 08:00:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:38 INFO - 'NO_EM_RESTART': '1', 08:00:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:38 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:38 INFO - 'SHELL': '/bin/bash', 08:00:38 INFO - 'SHLVL': '1', 08:00:38 INFO - 'TERM': 'linux', 08:00:38 INFO - 'TMOUT': '86400', 08:00:38 INFO - 'USER': 'cltbld', 08:00:38 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1456761388.332407-1175893989', 08:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:38 INFO - '_': '/tools/buildbot/bin/python'} 08:00:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:38 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 08:00:38 INFO - Cleaning up... 08:00:38 INFO - Return code: 0 08:00:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:00:38 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')]} 08:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:38 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')]} 08:00:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:38 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 0x7fb3ec8ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c628c0>, '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 0x1c637c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c63c50>, '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': 'aa52b8aba932b19cc50b5275000001de-1456761388.332407-1175893989', '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 08:00:38 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 08:00:38 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 08:00:38 INFO - Using env: {'DISPLAY': ':0', 08:00:38 INFO - 'HOME': '/home/cltbld', 08:00:38 INFO - 'LANG': 'en_US.UTF-8', 08:00:38 INFO - 'LANGUAGE': 'en_US:en', 08:00:38 INFO - 'LOGNAME': 'cltbld', 08:00:38 INFO - 'MAIL': '/var/mail/cltbld', 08:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:38 INFO - 'MOZ_NO_REMOTE': '1', 08:00:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:38 INFO - 'NO_EM_RESTART': '1', 08:00:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:38 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:38 INFO - 'SHELL': '/bin/bash', 08:00:38 INFO - 'SHLVL': '1', 08:00:38 INFO - 'TERM': 'linux', 08:00:38 INFO - 'TMOUT': '86400', 08:00:38 INFO - 'USER': 'cltbld', 08:00:38 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1456761388.332407-1175893989', 08:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:38 INFO - '_': '/tools/buildbot/bin/python'} 08:00:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:38 INFO - Downloading/unpacking psutil>=0.7.1 08:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:00:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:00:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:00:40 INFO - Installing collected packages: psutil 08:00:40 INFO - Running setup.py install for psutil 08:00:40 INFO - building 'psutil._psutil_linux' extension 08:00:40 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 08:00:41 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 08:00:41 INFO - building 'psutil._psutil_posix' extension 08:00:41 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 08:00:41 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 08:00:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:00:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:00:41 INFO - Successfully installed psutil 08:00:41 INFO - Cleaning up... 08:00:41 INFO - Return code: 0 08:00:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb3ec8ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c628c0>, '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 0x1c637c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c63c50>, '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': 'aa52b8aba932b19cc50b5275000001de-1456761388.332407-1175893989', '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 08:00:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 08:00:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:00:41 INFO - Using env: {'DISPLAY': ':0', 08:00:41 INFO - 'HOME': '/home/cltbld', 08:00:41 INFO - 'LANG': 'en_US.UTF-8', 08:00:41 INFO - 'LANGUAGE': 'en_US:en', 08:00:41 INFO - 'LOGNAME': 'cltbld', 08:00:41 INFO - 'MAIL': '/var/mail/cltbld', 08:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:41 INFO - 'MOZ_NO_REMOTE': '1', 08:00:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:41 INFO - 'NO_EM_RESTART': '1', 08:00:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:41 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:41 INFO - 'SHELL': '/bin/bash', 08:00:41 INFO - 'SHLVL': '1', 08:00:41 INFO - 'TERM': 'linux', 08:00:41 INFO - 'TMOUT': '86400', 08:00:41 INFO - 'USER': 'cltbld', 08:00:41 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1456761388.332407-1175893989', 08:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:41 INFO - '_': '/tools/buildbot/bin/python'} 08:00:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:00:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:00:43 INFO - Installing collected packages: mozsystemmonitor 08:00:43 INFO - Running setup.py install for mozsystemmonitor 08:00:43 INFO - Successfully installed mozsystemmonitor 08:00:43 INFO - Cleaning up... 08:00:43 INFO - Return code: 0 08:00:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:00: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')]} 08:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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')]} 08:00:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:43 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 0x7fb3ec8ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c628c0>, '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 0x1c637c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c63c50>, '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': 'aa52b8aba932b19cc50b5275000001de-1456761388.332407-1175893989', '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 08:00:43 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 08:00:43 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 08:00:43 INFO - Using env: {'DISPLAY': ':0', 08:00:43 INFO - 'HOME': '/home/cltbld', 08:00:43 INFO - 'LANG': 'en_US.UTF-8', 08:00:43 INFO - 'LANGUAGE': 'en_US:en', 08:00:43 INFO - 'LOGNAME': 'cltbld', 08:00:43 INFO - 'MAIL': '/var/mail/cltbld', 08:00:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:43 INFO - 'MOZ_NO_REMOTE': '1', 08:00:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:43 INFO - 'NO_EM_RESTART': '1', 08:00:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:43 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:43 INFO - 'SHELL': '/bin/bash', 08:00:43 INFO - 'SHLVL': '1', 08:00:43 INFO - 'TERM': 'linux', 08:00:43 INFO - 'TMOUT': '86400', 08:00:43 INFO - 'USER': 'cltbld', 08:00:43 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1456761388.332407-1175893989', 08:00:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:43 INFO - '_': '/tools/buildbot/bin/python'} 08:00:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:43 INFO - Downloading/unpacking blobuploader==1.2.4 08:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:45 INFO - Downloading blobuploader-1.2.4.tar.gz 08:00:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:00:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:00:45 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 08:00:45 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 08:00:45 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 08:00:45 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 08:00:45 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 08:00:45 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 08:00:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:00:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:46 INFO - Downloading docopt-0.6.1.tar.gz 08:00:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:00:46 INFO - Installing collected packages: blobuploader, requests, docopt 08:00:46 INFO - Running setup.py install for blobuploader 08:00:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:00:46 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:00:46 INFO - Running setup.py install for requests 08:00:47 INFO - Running setup.py install for docopt 08:00:47 INFO - Successfully installed blobuploader requests docopt 08:00:47 INFO - Cleaning up... 08:00:47 INFO - Return code: 0 08:00:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:00:47 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')]} 08:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:47 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')]} 08:00:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:47 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 0x7fb3ec8ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c628c0>, '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 0x1c637c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c63c50>, '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': 'aa52b8aba932b19cc50b5275000001de-1456761388.332407-1175893989', '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 08:00:47 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 08:00:47 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 08:00:47 INFO - Using env: {'DISPLAY': ':0', 08:00:47 INFO - 'HOME': '/home/cltbld', 08:00:47 INFO - 'LANG': 'en_US.UTF-8', 08:00:47 INFO - 'LANGUAGE': 'en_US:en', 08:00:47 INFO - 'LOGNAME': 'cltbld', 08:00:47 INFO - 'MAIL': '/var/mail/cltbld', 08:00:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:47 INFO - 'MOZ_NO_REMOTE': '1', 08:00:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:47 INFO - 'NO_EM_RESTART': '1', 08:00:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:47 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:47 INFO - 'SHELL': '/bin/bash', 08:00:47 INFO - 'SHLVL': '1', 08:00:47 INFO - 'TERM': 'linux', 08:00:47 INFO - 'TMOUT': '86400', 08:00:47 INFO - 'USER': 'cltbld', 08:00:47 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1456761388.332407-1175893989', 08:00:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:47 INFO - '_': '/tools/buildbot/bin/python'} 08:00:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:00:47 INFO - Running setup.py (path:/tmp/pip-CtyTjL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:00:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:00:47 INFO - Running setup.py (path:/tmp/pip-7rPfK4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:00:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:00:47 INFO - Running setup.py (path:/tmp/pip-YGvTOi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:00:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:00:47 INFO - Running setup.py (path:/tmp/pip-Qlle9X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:00:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:00:47 INFO - Running setup.py (path:/tmp/pip-2hvxnM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:00:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:00:47 INFO - Running setup.py (path:/tmp/pip-uzUr9f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:00:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:00:47 INFO - Running setup.py (path:/tmp/pip-r8DfTP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:00:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:00:47 INFO - Running setup.py (path:/tmp/pip-MeVBb6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:00:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:00:47 INFO - Running setup.py (path:/tmp/pip-PPE_L_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:00:48 INFO - Running setup.py (path:/tmp/pip-lVUKZW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:00:48 INFO - Running setup.py (path:/tmp/pip-nDKoXQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:00:48 INFO - Running setup.py (path:/tmp/pip-fAqAbF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:00:48 INFO - Running setup.py (path:/tmp/pip-6GTm1y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:00:48 INFO - Running setup.py (path:/tmp/pip-BhEygi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:00:48 INFO - Running setup.py (path:/tmp/pip-hxxvop-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:00:48 INFO - Running setup.py (path:/tmp/pip-dkVgBy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:00:48 INFO - Running setup.py (path:/tmp/pip-SJGIyO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:00:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:00:48 INFO - Running setup.py install for manifestparser 08:00:48 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:00:48 INFO - Running setup.py install for mozcrash 08:00:48 INFO - Running setup.py install for mozdebug 08:00:48 INFO - Running setup.py install for mozdevice 08:00:49 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:00:49 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:00:49 INFO - Running setup.py install for mozfile 08:00:49 INFO - Running setup.py install for mozhttpd 08:00:49 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:00:49 INFO - Running setup.py install for mozinfo 08:00:49 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:00:49 INFO - Running setup.py install for mozInstall 08:00:49 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:00:49 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:00:49 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:00:49 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:00:49 INFO - Running setup.py install for mozleak 08:00:49 INFO - Running setup.py install for mozlog 08:00:49 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:00:49 INFO - Running setup.py install for moznetwork 08:00:49 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:00:49 INFO - Running setup.py install for mozprocess 08:00:49 INFO - Running setup.py install for mozprofile 08:00:49 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:00:49 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:00:49 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:00:49 INFO - Running setup.py install for mozrunner 08:00:50 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:00:50 INFO - Running setup.py install for mozscreenshot 08:00:50 INFO - Running setup.py install for moztest 08:00:50 INFO - Running setup.py install for mozversion 08:00:50 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:00:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:00:50 INFO - Cleaning up... 08:00:50 INFO - Return code: 0 08:00:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fb3ec8ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c628c0>, '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 0x1c637c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c63c50>, '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': 'aa52b8aba932b19cc50b5275000001de-1456761388.332407-1175893989', '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 08:00:50 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 08:00:50 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 08:00:50 INFO - Using env: {'DISPLAY': ':0', 08:00:50 INFO - 'HOME': '/home/cltbld', 08:00:50 INFO - 'LANG': 'en_US.UTF-8', 08:00:50 INFO - 'LANGUAGE': 'en_US:en', 08:00:50 INFO - 'LOGNAME': 'cltbld', 08:00:50 INFO - 'MAIL': '/var/mail/cltbld', 08:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:50 INFO - 'MOZ_NO_REMOTE': '1', 08:00:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:50 INFO - 'NO_EM_RESTART': '1', 08:00:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:50 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:50 INFO - 'SHELL': '/bin/bash', 08:00:50 INFO - 'SHLVL': '1', 08:00:50 INFO - 'TERM': 'linux', 08:00:50 INFO - 'TMOUT': '86400', 08:00:50 INFO - 'USER': 'cltbld', 08:00:50 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1456761388.332407-1175893989', 08:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:50 INFO - '_': '/tools/buildbot/bin/python'} 08:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:00:50 INFO - Running setup.py (path:/tmp/pip-jtsgBD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:00:50 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)) 08:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:00:50 INFO - Running setup.py (path:/tmp/pip-3MDV9n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:00:50 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)) 08:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:00:50 INFO - Running setup.py (path:/tmp/pip-S01RTp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:00:50 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)) 08:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:00:50 INFO - Running setup.py (path:/tmp/pip-vcfEoO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:00:50 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)) 08:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:00:50 INFO - Running setup.py (path:/tmp/pip-LvcdSX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:00:50 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)) 08:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:00:50 INFO - Running setup.py (path:/tmp/pip-y6OUdO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:00:51 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)) 08:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:00:51 INFO - Running setup.py (path:/tmp/pip-mpfkVv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:00:51 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)) 08:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:00:51 INFO - Running setup.py (path:/tmp/pip-WODvyP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:00:51 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)) 08:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:00:51 INFO - Running setup.py (path:/tmp/pip-ILpGU5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:00:51 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)) 08:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:00:51 INFO - Running setup.py (path:/tmp/pip-MPv4Mq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:00:51 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)) 08:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:00:51 INFO - Running setup.py (path:/tmp/pip-w4yO9y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:00:51 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)) 08:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:00:51 INFO - Running setup.py (path:/tmp/pip-pRlHh0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:00:51 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)) 08:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:00:51 INFO - Running setup.py (path:/tmp/pip-aFO719-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:00:51 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)) 08:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:00:51 INFO - Running setup.py (path:/tmp/pip-9ErKSv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:00:51 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)) 08:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:00:51 INFO - Running setup.py (path:/tmp/pip-cfGlRB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:00:51 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)) 08:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:00:51 INFO - Running setup.py (path:/tmp/pip-9Y2YQm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:00:51 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)) 08:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:00:51 INFO - Running setup.py (path:/tmp/pip-pWD2YC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:00:51 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)) 08:00:51 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)) 08:00:51 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)) 08:00:51 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)) 08:00:51 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)) 08:00:51 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)) 08:00:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:00:51 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 08:00:51 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 08:00:51 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 08:00:51 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 08:00:51 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 08:00:51 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 08:00:53 INFO - Downloading blessings-1.6.tar.gz 08:00:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:00:53 INFO - Installing collected packages: blessings 08:00:53 INFO - Running setup.py install for blessings 08:00:53 INFO - Successfully installed blessings 08:00:53 INFO - Cleaning up... 08:00:53 INFO - Return code: 0 08:00:53 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:00:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:00:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:00:54 INFO - Reading from file tmpfile_stdout 08:00:54 INFO - Current package versions: 08:00:54 INFO - argparse == 1.2.1 08:00:54 INFO - blessings == 1.6 08:00:54 INFO - blobuploader == 1.2.4 08:00:54 INFO - docopt == 0.6.1 08:00:54 INFO - manifestparser == 1.1 08:00:54 INFO - mozInstall == 1.12 08:00:54 INFO - mozcrash == 0.16 08:00:54 INFO - mozdebug == 0.1 08:00:54 INFO - mozdevice == 0.48 08:00:54 INFO - mozfile == 1.2 08:00:54 INFO - mozhttpd == 0.7 08:00:54 INFO - mozinfo == 0.9 08:00:54 INFO - mozleak == 0.1 08:00:54 INFO - mozlog == 3.1 08:00:54 INFO - moznetwork == 0.27 08:00:54 INFO - mozprocess == 0.22 08:00:54 INFO - mozprofile == 0.28 08:00:54 INFO - mozrunner == 6.11 08:00:54 INFO - mozscreenshot == 0.1 08:00:54 INFO - mozsystemmonitor == 0.0 08:00:54 INFO - moztest == 0.7 08:00:54 INFO - mozversion == 1.4 08:00:54 INFO - psutil == 3.1.1 08:00:54 INFO - requests == 1.2.3 08:00:54 INFO - wsgiref == 0.1.2 08:00:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:00: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')]} 08:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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')]} 08:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:54 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 0x7fb3ec8ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c628c0>, '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 0x1c637c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c63c50>, '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': 'aa52b8aba932b19cc50b5275000001de-1456761388.332407-1175893989', '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 08:00:54 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 08:00:54 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 08:00:54 INFO - Using env: {'DISPLAY': ':0', 08:00:54 INFO - 'HOME': '/home/cltbld', 08:00:54 INFO - 'LANG': 'en_US.UTF-8', 08:00:54 INFO - 'LANGUAGE': 'en_US:en', 08:00:54 INFO - 'LOGNAME': 'cltbld', 08:00:54 INFO - 'MAIL': '/var/mail/cltbld', 08:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:54 INFO - 'MOZ_NO_REMOTE': '1', 08:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:54 INFO - 'NO_EM_RESTART': '1', 08:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:54 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:54 INFO - 'SHELL': '/bin/bash', 08:00:54 INFO - 'SHLVL': '1', 08:00:54 INFO - 'TERM': 'linux', 08:00:54 INFO - 'TMOUT': '86400', 08:00:54 INFO - 'USER': 'cltbld', 08:00:54 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1456761388.332407-1175893989', 08:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:54 INFO - '_': '/tools/buildbot/bin/python'} 08:00:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:54 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)) 08:00:54 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)) 08:00:54 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)) 08:00:54 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)) 08:00:54 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)) 08:00:54 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)) 08:00:54 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)) 08:00:54 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)) 08:00:54 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)) 08:00:54 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)) 08:00:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 08:00:54 INFO - Cleaning up... 08:00:54 INFO - Return code: 0 08:00:54 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:00: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')]} 08:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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')]} 08:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3ec8ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c628c0>, '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 0x1c637c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c63c50>, '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': 'aa52b8aba932b19cc50b5275000001de-1456761388.332407-1175893989', '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 08:00:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 08:00:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:00:54 INFO - Using env: {'DISPLAY': ':0', 08:00:54 INFO - 'HOME': '/home/cltbld', 08:00:54 INFO - 'LANG': 'en_US.UTF-8', 08:00:54 INFO - 'LANGUAGE': 'en_US:en', 08:00:54 INFO - 'LOGNAME': 'cltbld', 08:00:54 INFO - 'MAIL': '/var/mail/cltbld', 08:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:54 INFO - 'MOZ_NO_REMOTE': '1', 08:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:54 INFO - 'NO_EM_RESTART': '1', 08:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:54 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:54 INFO - 'SHELL': '/bin/bash', 08:00:54 INFO - 'SHLVL': '1', 08:00:54 INFO - 'TERM': 'linux', 08:00:54 INFO - 'TMOUT': '86400', 08:00:54 INFO - 'USER': 'cltbld', 08:00:54 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1456761388.332407-1175893989', 08:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:54 INFO - '_': '/tools/buildbot/bin/python'} 08:00:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:54 INFO - Downloading/unpacking jsonschema 08:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:00:56 INFO - Downloading/unpacking functools32 (from jsonschema) 08:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:56 INFO - Downloading functools32-3.2.3-2.tar.gz 08:00:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:00:56 INFO - warning: no files found matching '*.txt' 08:00:56 INFO - no previously-included directories found matching 'build' 08:00:56 INFO - no previously-included directories found matching 'dist' 08:00:56 INFO - no previously-included directories found matching '.git*' 08:00:56 INFO - Installing collected packages: jsonschema, functools32 08:00:56 INFO - Running setup.py install for functools32 08:00:56 INFO - warning: no files found matching '*.txt' 08:00:56 INFO - no previously-included directories found matching 'build' 08:00:56 INFO - no previously-included directories found matching 'dist' 08:00:56 INFO - no previously-included directories found matching '.git*' 08:00:56 INFO - Successfully installed jsonschema functools32 08:00:56 INFO - Cleaning up... 08:00:56 INFO - Return code: 0 08:00:56 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:56 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 0x7fb3ec8ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c628c0>, '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 0x1c637c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c63c50>, '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': 'aa52b8aba932b19cc50b5275000001de-1456761388.332407-1175893989', '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 08:00:56 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 08:00:56 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 08:00:56 INFO - Using env: {'DISPLAY': ':0', 08:00:56 INFO - 'HOME': '/home/cltbld', 08:00:56 INFO - 'LANG': 'en_US.UTF-8', 08:00:56 INFO - 'LANGUAGE': 'en_US:en', 08:00:56 INFO - 'LOGNAME': 'cltbld', 08:00:56 INFO - 'MAIL': '/var/mail/cltbld', 08:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:56 INFO - 'MOZ_NO_REMOTE': '1', 08:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:56 INFO - 'NO_EM_RESTART': '1', 08:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:56 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:56 INFO - 'SHELL': '/bin/bash', 08:00:56 INFO - 'SHLVL': '1', 08:00:56 INFO - 'TERM': 'linux', 08:00:56 INFO - 'TMOUT': '86400', 08:00:56 INFO - 'USER': 'cltbld', 08:00:56 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1456761388.332407-1175893989', 08:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:56 INFO - '_': '/tools/buildbot/bin/python'} 08:00:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:57 INFO - Downloading/unpacking flake8 08:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:00:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:00:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:00:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:00:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:00:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:00:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:00:59 INFO - no previously-included directories found matching 'docs/_build' 08:00:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:00:59 INFO - Running setup.py install for pep8 08:00:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:00:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:00:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:00:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:00:59 INFO - no previously-included directories found matching 'docs/_build' 08:00:59 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:00:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:00:59 INFO - Cleaning up... 08:00:59 INFO - Return code: 0 08:00:59 INFO - Running post-action listener: _resource_record_post_action 08:00:59 INFO - Running post-action listener: _start_resource_monitoring 08:00:59 INFO - Starting resource monitoring. 08:00:59 INFO - ##### 08:00:59 INFO - ##### Running install step. 08:00:59 INFO - ##### 08:00:59 INFO - Running pre-action listener: _resource_record_pre_action 08:00:59 INFO - Running main action method: install 08:00:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:00:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:01:00 INFO - Reading from file tmpfile_stdout 08:01:00 INFO - Detecting whether we're running mozinstall >=1.0... 08:01:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:01:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:01:00 INFO - Reading from file tmpfile_stdout 08:01:00 INFO - Output received: 08:01:00 INFO - Usage: mozinstall [options] installer 08:01:00 INFO - Options: 08:01:00 INFO - -h, --help show this help message and exit 08:01:00 INFO - -d DEST, --destination=DEST 08:01:00 INFO - Directory to install application into. [default: 08:01:00 INFO - "/builds/slave/test-pgo"] 08:01:00 INFO - --app=APP Application being installed. [default: firefox] 08:01:00 INFO - mkdir: /builds/slave/test-pgo/build/application 08:01:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 08:01:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 08:01:16 INFO - Reading from file tmpfile_stdout 08:01:16 INFO - Output received: 08:01:16 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:01:16 INFO - Running post-action listener: _resource_record_post_action 08:01:16 INFO - ##### 08:01:16 INFO - ##### Running run-tests step. 08:01:16 INFO - ##### 08:01:16 INFO - Running pre-action listener: _resource_record_pre_action 08:01:16 INFO - Running main action method: run_tests 08:01:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:01:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:01:16 INFO - Python 2.7.3 08:01:16 INFO - Return code: 0 08:01:16 INFO - grabbing minidump binary from tooltool 08:01:16 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')]} 08:01:16 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 0x1c628c0>, '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 0x1c637c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c63c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:01:16 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 08:01:16 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 08:01:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:01:16 INFO - Return code: 0 08:01:16 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:01:16 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:01:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:01:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:01:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:01:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:01:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:01:17 INFO - Return code: 0 08:01:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 08:01:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 08:01:17 INFO - Using env: {'DISPLAY': ':0', 08:01:17 INFO - 'HOME': '/home/cltbld', 08:01:17 INFO - 'LANG': 'en_US.UTF-8', 08:01:17 INFO - 'LANGUAGE': 'en_US:en', 08:01:17 INFO - 'LOGNAME': 'cltbld', 08:01:17 INFO - 'MAIL': '/var/mail/cltbld', 08:01:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:01:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:01:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:17 INFO - 'MOZ_NO_REMOTE': '1', 08:01:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:01:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:17 INFO - 'NO_EM_RESTART': '1', 08:01:17 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:01:17 INFO - 'PWD': '/builds/slave/test-pgo', 08:01:17 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:01:17 INFO - 'SHELL': '/bin/bash', 08:01:17 INFO - 'SHLVL': '1', 08:01:17 INFO - 'TERM': 'linux', 08:01:17 INFO - 'TMOUT': '86400', 08:01:17 INFO - 'USER': 'cltbld', 08:01:17 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1456761388.332407-1175893989', 08:01:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:17 INFO - '_': '/tools/buildbot/bin/python'} 08:01:17 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:01:17 INFO - mozversion application_buildid: 20160229053003 08:01:17 INFO - mozversion application_changeset: 76c51477853faeac91211c2adee7adfee858b276 08:01:17 INFO - mozversion application_display_name: Nightly 08:01:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:01:17 INFO - mozversion application_name: Firefox 08:01:17 INFO - mozversion application_remotingname: firefox 08:01:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:01:17 INFO - mozversion application_vendor: Mozilla 08:01:17 INFO - mozversion application_version: 47.0a1 08:01:17 INFO - mozversion platform_buildid: 20160229053003 08:01:17 INFO - mozversion platform_changeset: 76c51477853faeac91211c2adee7adfee858b276 08:01:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:01:17 INFO - mozversion platform_version: 47.0a1 08:01:17 INFO - using testdate: 1456761677 08:01:17 INFO - actual date: 1456761677 08:01:17 INFO - starting webserver on 'localhost:59259' 08:01:17 INFO - SUITE-START | Running 2 tests 08:01:17 INFO - TEST-START | dromaeo_css 08:01:17 INFO - operating with platform_type : linux_ 08:01:17 INFO - Initialising browser for dromaeo_css test... 08:01:17 INFO - TEST-INFO | started process 12972 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEy6mCW/profile http://localhost:59259/getInfo.html) 08:01:22 INFO - PROCESS | 12972 | __metrics Screen width/height:1600/1200 08:01:22 INFO - PROCESS | 12972 | colorDepth:24 08:01:22 INFO - PROCESS | 12972 | Browser inner width/height: 1024/697 08:01:22 INFO - PROCESS | 12972 | __metrics 08:01:23 INFO - PROCESS | 12972 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:01:23 INFO - PROCESS | 12972 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:01:23 INFO - PROCESS | 12972 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:01:23 INFO - PROCESS | 12972 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:01:23 INFO - PROCESS | 12972 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:01:23 INFO - PROCESS | 12972 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:01:23 INFO - PROCESS | 12972 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:01:23 INFO - PROCESS | 12972 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 08:01:23 INFO - TEST-INFO | 12972: exit 0 08:01:23 INFO - Browser initialized. 08:01:23 INFO - Running cycle 1/1 for dromaeo_css test... 08:01:23 INFO - TEST-INFO | started process 13066 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEy6mCW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:01:35 INFO - PROCESS | 13066 | RSS: Main: 153714688 08:01:35 INFO - PROCESS | 13066 | 08:02:26 INFO - PROCESS | 13066 | 1456761746415 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] 08:04:35 INFO - PROCESS | 13066 | Cycle 1(1): loaded http://localhost:59259/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59259/tests/dromaeo/cssquery-ext.html) 08:04:36 INFO - PROCESS | 13066 | RSS: Main: 248217600 08:04:36 INFO - PROCESS | 13066 | 08:07:38 INFO - PROCESS | 13066 | Cycle 1(1): loaded http://localhost:59259/tests/dromaeo/cssquery-ext.html (next: http://localhost:59259/tests/dromaeo/cssquery-jquery.html) 08:07:39 INFO - PROCESS | 13066 | RSS: Main: 239759360 08:07:39 INFO - PROCESS | 13066 | 08:10:41 INFO - PROCESS | 13066 | Cycle 1(1): loaded http://localhost:59259/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59259/tests/dromaeo/cssquery-mootools.html) 08:10:41 INFO - PROCESS | 13066 | RSS: Main: 234381312 08:10:41 INFO - PROCESS | 13066 | 08:13:43 INFO - PROCESS | 13066 | Cycle 1(1): loaded http://localhost:59259/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59259/tests/dromaeo/cssquery-prototype.html) 08:13:44 INFO - PROCESS | 13066 | RSS: Main: 215789568 08:13:44 INFO - PROCESS | 13066 | 08:16:46 INFO - PROCESS | 13066 | Cycle 1(1): loaded http://localhost:59259/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59259/tests/dromaeo/cssquery-yui.html) 08:16:47 INFO - PROCESS | 13066 | RSS: Main: 217210880 08:16:47 INFO - PROCESS | 13066 | 08:19:50 INFO - PROCESS | 13066 | Cycle 1(1): loaded http://localhost:59259/tests/dromaeo/cssquery-yui.html (next: http://localhost:59259/tests/dromaeo/cssquery-dojo.html) 08:19:50 INFO - PROCESS | 13066 | RSS: Main: 304001024 08:19:50 INFO - PROCESS | 13066 | 08:19:50 INFO - PROCESS | 13066 | __start_tp_report 08:19:50 INFO - PROCESS | 13066 | _x_x_mozilla_page_load 08:19:50 INFO - PROCESS | 13066 | _x_x_mozilla_page_load_details 08:19:50 INFO - PROCESS | 13066 | |i|pagename|runs| 08:19:50 INFO - PROCESS | 13066 | |0;dojo.html;3090.8145511269327;3126.4841301185306;3162.320101178246;3166.6516683164864;3204.903852884413;5107.259447380127;5141.897162056756;5156.742162891855;5166.121759300914;5179.585633149349;5185.351831021122;5209.557187639046;5237.214417837326;5238.188080847474;5242.842714718565;4710.222813235812;4741.383620129378;4746.90506189876;4752.881177970561;4925.630577706668;4856.514348565133;4877.219644856824;4881.60947124231;4899.020195960804;4919.77860996256;4702.97648511757;4768.928466072977;4822.4936381679945;4827.951720482785;4858.344123543312;4748.050389922029;4749.7387643679585;4750.904981900378;4751.3585665935;4801.711897286139;4718.292256161569;4720.480747117815;4731.739754313511;4742.691725037862;4771.212749896263;4996.950030499721;5073.365829271341;5120.487951204887;5141.485851414866;5156.20078887773;5546.91679624806;5561.637398837271;5567.47109024642;5573.637713548606;5587.944120558783;5464.6994415307145;5607.046802043662;5615.326160860723;5628.04323265046;5632.127020311858;5215.269862219292;5230.476952304739;5287.682739035632;5292.073887069786;5292.9206061908335;5662.462066103713;5675.177099320658;5676.035074037423;5680.14797780328;5680.857978550569;5481.643693159932;5490.972545137249;5500.28496295487;5501.944980550144;5506.559475241971;5580.91628625571;5590.8043218487155;5595.692236927008;5600.299962504687;5641.661500309994;5554.972225138848;5564.527015203672;5565.387807341189;5569.136783798518;5573.944260557424;5447.073997420448;5504.834854954358;5577.191307260425;5578.847613707966;5636.070048442043;4346.348047792856;4348.9565104349185;4349.934750978738;4384.7369157850635;4385.758783266951;3877.941830872539;3891.630295121959;3911.1004468972296;3913.72603917723;3938.1139243669945;5068.113080210948;5191.428942816287;5209.557187639018;5218.165093585084;5270.552003079704;5585.441455854463;5597.440255974451;5605.663660180402;5608.10270356741;5642.943570564324;5169.06956747789;5170.017696637627;5173.92239116406;5174.534291913746;5220.269162317279;4685.929711054268;4773.570378665937;4779.784909679072;4815.662903596784;4827.372441582572;5754.108113242454;5797.246357973437;5800.419958004166;5802.535797136304;5805.709714514342;5584.162375643686;5584.246126772834;5584.525315348241;5588.916166257428;5604.327480702342;5661.980843448219;5800.7099645018425;5843.328017278068;5864.970675146597;5881.32364778056;5510.614257002132;5514.09017512106;5517.917231241615;5526.58550608714;5533.418991005887;5494.450554944474;5584.720763961867;5587.972060139673;5590.636608620427;5592.7762889483965;5484;5516.227728118147;5516.310461192351;5523.7790488380015;5562.137868630369;5430.864228394322;5446.1558458439;5446.891062178814;5448.509634132947;5450.155225939986;5160.819371322136;5375.623706340519;5385.27298814655;5401;5448.83653490396;5498.202760599611;5499.917501237404;5502.422245664147;5535.861603459945;5541.085720856014;5395.406505284337;5403.486668766461;5434.049041417815;5434.538064264424;5441.782328706808 08:19:50 INFO - PROCESS | 13066 | |1;ext.html;525.3485677759579;547.2912578211218;585.2012003615064;586.1383765864181;593.8752861899002;28515.42969140616;38614.22771544571;39010;39020.414693779545;39052.41421378682;42337.15325693484;42860.35709464361;42860.571394286046;43013;43077.19998200115;7480.214577469369;8641.91358086419;8866.202041816236;9950.353227040256;10077.848832267522;10061.647842325483;10187.134093602053;10206.64276750314;10222.846657300146;10226.642067527639;10190;10289.897101028968;10293.48532573372;10297.794044119113;10301.433421161833;10142.971405718848;10218.335808172445;10226.79546409075;10234.590616375335;10241.43672098038;10213.897861021444;10435.426051567161;10453.320534165256;10465.68602941913;10474.58101675932;39326.410103848466;39647.4052889204;39735.60264397348;39772;39779.20441591152;3154.3848949454864;3246.3831871944253;3363.9831800841084;3480.460528618068;3637.7999210043436;30413.23966900823;30526.69473305283;30721.692783072107;31937.36125277505;32004.679953200404;3968.6626636735914;3992.3612222044335;4016.8995775105855;4036.6568841648495;4155.709100362976;264513;265838;266661;267320;267813.9999999981;40805;41497.58502414998;57964;58445.70777146087;58732.41267587355;39555.208895821925;39809;39828.601713983066;39855.80072099621;39867;14849.777253341208;15076.24618769057;15078.321475533627;15086.698266034618;15086.773698394532;12088.697782555506;12109.333986630643;12118.454669539891;12134.878651213552;12140.392980350947;13986.510472133426;14032.158070515598;14074;14117.505887293895;14218.85781142196;5635.915461268084;5725.112607545837;5739.253896993448;5742.454466825729;5809.564282678816;1000.849872519128;1016.8220561401725;1051.5951358726945;1071.919606029551;1103.332483847277;27742;27960.44079118406;28017.08722431933;28589.428211435654;28657.42685146327;841.4110122913985;1030.9690709278734;1055.0715370474088;1070.3310430980637;1087.798757229915;12973.675658108623;13237.343011696372;13371.197728136343;13402.664933376744;13497.595072147851;297132;297495;298225;300340;301261;50989.49010509922;51742.01482799849;51807.740961295705;51813.222801658005;51861.740691296305;1333.953311634088;1365.7473367427058;1379.475799196319;1381.958541243744;1390.5202705066736;25152.49695006053;26590.468190635693;26888.731112688623;27046;27057.86471067632;43410.348844767985;46979.53020469751;47726.5227347736;47963.76018120027;48014.279785802544;225731;226366;226827;228031;228436;36194.27611447809;37144.25711485809;37482.06294842651;37556.06109847166;38697.41953870638;38623.42064869085;38676.226475470896;38977.2204555913;39087.41368879412;39794.80102599468;35357.46963795597;35669.643303566634;35942.8202858984;36093;36381.63618363783;36425;36520.26959460849;36551.26897462089;36601.26797464089;37060.258794823414;31081;35340.823295883354;36566;38715.80642096772;38939.415908761956;30502.38995220039;32331.838340808146;32784.34431311408;32831.17922051872;33074.33851322912;24672.136475224;24940;25008.249752507454;25319.620205697298;25339.366515837253 08:19:50 INFO - PROCESS | 13066 | |2;jquery.html;332.8931303416142;341.1318195193233;343.1096305088298;345.03046439504993;348.7802684308885;12623.116381853262;17366.565835854093;17846.46460606184;18192.545186370346;18896.149673264703;15849.92075039626;16002.119883406407;16429.26068326925;17109.54568861645;17119.743203851922;5304.70824104675;5515.806946756864;5527.032769265383;5532.170174473821;5534.335879694442;5117.283580298761;5413.079776437995;5416.864578385533;5421.159720243349;5427;5358.2766326546;5358.839234822962;5362.597805164609;5363.275957745713;5365.980463711901;5352.2506849041165;6094.542909281799;6321.431071203614;6352.555321127546;6376.776812811529;6037.607555508922;6043.8791224175275;6071.423214794588;6111.938880611181;6163.969180154116;22376.552468950693;22448.775512244996;22606.0957561699;22611.434714132112;22813.771862281497;2391.9402014949765;2412.457197130649;2715.579085241791;2716.361655011071;3188.4898416253286;13329.133606315656;13377.130486518443;13515.189088654712;13652.86347136526;13700.3834827433;1928.798807867674;1995.5809280051062;1996.3112726109468;2067.1627990663656;2082.37528741377;66675;71754.64122679354;71811;71872;73132.6343368285;12701.491940322283;14458.493952711604;14787.778183327258;14904.552863414116;15108.773368399483;20703.792962070187;23400.53198936012;23806.16678416282;23983.52032959366;24362.51274974526;9091.181793638472;9117.498537580497;9370.344075914756;9390.248780097576;9520.523973801282;7936.6031698414845;8048.315893149148;8067.273945344947;8215.630296636666;8248.670053197924;7524.586147761816;7560.243975602396;7574.5833979130575;7603.239676032463;7610.353119984863;2910.1996950838266;2994.131701806452;3002.6246719160104;3038.194878357237;3086.0896035669084;916.6287653500343;922.2529750901791;983.7983213441371;1013.3210748798175;1040.167865707431;15822.60443488922;16074.517764467084;16214.027158370536;16678;16751.413700520425;948.5399581203111;953.0945601678295;957.2150836314156;969.6024629901707;981.1856159387692;9155.267578593697;9341.486218258062;9358.812823743623;9417.387869788441;9466.526673666289;419575;420943;421773.5577757382;427897;428839;71991;72691;73508.26491735122;74279.62860185665;76109;1007.9949600252098;1009.3641006166215;1016.0499932563077;1033.7777377863795;1049.7218237167158;14097;14486.058406203985;14554;14579.198144102176;14699.191544465157;30624.693753062184;31236.687633123376;31529;32521.349573007934;33029.66970330266;43418.348724769785;45030.324545132506;45303;46006.309905350776;46106.53893461157;7427.554346739213;7620.390368770374;7843.137254902071;7845.882311765442;7880.290773830383;10074.136284787337;12092.334921579397;12169.634910952685;12204.87795122073;12356.073294502768;10170.542325595217;10285.331453455501;10408.895911040792;10549;10768.246222764332;10131.797364052825;10739.570417183226;10977.670669879917;11191.32852028881;11235.438228088726;10908.509117089592;10949.014588686738;11238.494267757807;11262;11265.71835704114;7599.886001709868;7887.881681774893;7890.763277101696;7906.367490600623;8010.959945200237;10097.747556310856;10105.44420056904;10168.84746728785;10196.235282354002;10684.57261709554 08:19:50 INFO - PROCESS | 13066 | |3;mootools.html;1346.6566025663453;1481.74810282252;1489.277700315347;1639.860611847993;1805.295934585512;7737;7854.842903141934;7868.134505204423;7869.291763741255;7914.84170316594;7673.616319184032;7791.961040194805;7806.960965195166;7824.687012519506;7829.099653539844;1909.6371689379043;2249.6850440938283;2263.7396699379533;2272.4091736148557;2318.675385446039;2293.9885300573474;2302.0906741836966;2302.366849116498;2303.0327262549768;2305.0664480885184;2220.3893929169526;2294.231432470116;2294.506681063571;2295.8737269450176;2297.8391512594126;2249.1219831440685;2279.8974046167964;2295.9770402296012;2317.9188728394593;2318.2697450303267;2287.874166920819;2331.7551657075933;2337.9532409351887;2347.248880358286;2348.7768661977084;8109.472884262504;8142.796430089236;8153.103158652543;8161.918380816234;8162.959185204036;4806.327114204014;4926.75366231687;4937.5556199942175;4976.950230497685;4981.800727970877;2990.596269503633;3079.1224501017327;3123.2035830862983;3128;3128.2961333699964;995.5868314649412;1008.1581879130935;1013.4881884648279;1020.9438480883548;1040.505759764106;11515.712107197303;11523.884761152365;11647.242929209575;11658.6502404928;11664.35846028468;4117.649999750055;4245.214635292481;4256.170046840836;4286.314189729628;4371.475422949203;9578.233741300819;9637.18083962871;9637.903620963842;9644.565994530123;9646.565904534313;4384.649228061748;4920.261960705922;4920.606351491872;4953.653244272867;4954.653174277838;4159.459270294903;4209.473815773028;4209.684273679425;4243.193793179286;4255.829766809355;3713.832877520518;3778.1499162688174;3785.8296376662565;3801.467794508771;3826.5408151021497;1208.4259976511262;1213.387239444075;1213.696575856036;1216.403962058585;1231.378154032208;1037.64719995202;1057.1701214546545;1067.4982758103679;1241.3482921466302;1376.7246550689902;7790.883136752953;7837.882431763528;7882.172371900982;7903.723369682033;7909.960450197712;459.32708581927636;473.79389965365175;475.2419890275006;480.87737626904914;481.1651784154489;5883.382244864228;5900.4984576310635;5912.290525136925;5918.171455996164;5945.64326140433;9469.289803264644;10035.548400322003;10175;10181.847272290921;10186.592536298465;9923.1069203772;9991.900080999098;10027.09756121938;10042.096211341015;10102.848457273147;7522.322990930843;7773.961130194313;7831.120531072615;7863.33161681252;7869.409794265453;7267.382272506896;7364.410847132323;7419.703211871465;7430.442716796154;7482.812929676802;8674.78313042179;8833.69082082124;8855.690050848189;8991.370604057653;9047.547622618711;9009.504477253813;9136;9158.862617060882;9222.861657075284;9251.861222081809;6396.136521569715;6771.898421523582;6889.345512176335;7264.091988501437;7320.597367144858;7555.282248186413;7656.157822639617;7656.464047516621;7661.923380766121;7688.308052275322;6779.322067793181;6907.309269073053;6964.930350696428;7001.789946301619;7153.213146553979;6708;6737.494687898329;6747.392734653905;6918.757843475454;6982.022516847747;7005.229424763374;7008.159020917523;7012.018317435461;7357.043584334002;7377.889331660137;6640;6661;6674.599524028379;6692.330766923269;6710.060591517094;6375.458086062737;6592.80221593353;6615;6654.401103900672;6655.73377064912 08:19:50 INFO - PROCESS | 13066 | |4;prototype.html;310.66137909678474;311.30734116590577;312.55304913973026;319.7042735469691;329.4810673189725;5891.55813314001;5940.138679891418;5965.850853728659;5970.164177015221;5982.371850955647;5865.882682346361;5882.176495290662;5891.705414729267;5900.1739756434135;5901.645901245928;4340.131973605284;4366.08312254427;4434.578715022084;4458;4458.063806600618;4417.646588272931;4451.799669014902;4459.732416055031;4462.754548499831;4478.8880277992985;4317.935230971538;4419.116176764644;4437.511873693891;4443.178012067761;4449.911001779962;4390.824367025315;4508.143452743984;4512.187806194884;4520.163769702583;4526.954730452686;3972.205558888205;3977.920441591181;3979;3980.0845805464905;3987.322155233617;5579.581531385122;5615.241942337773;5617.606767526275;5629;5637.126245431965;5266.420693723688;5269.2886460327745;5276.92084618731;5280.10238259493;5280.498352656491;6211.161493198406;6235.064740288947;6236.6258024518675;6241.28225254097;6241.594296370767;4172.70791044627;4287.48550173978;4292.399064131024;4294.914101717979;4432.468103827529;6462.644554549545;6499.870002599969;6523.315051919575;6525.1517302750335;6532.7713530026695;4367.45406824147;4371.715838470489;4374.715643483163;4378.737275763465;4383.035732138925;4421.867343979686;4433.600975912119;4434.889127771767;4440.822367105344;4442.311441726538;5119.692818430906;5129.820456284012;5156.020356132323;5162.97418512905;5173.327467429285;6193.969030154911;6270.7491700331475;6295.087212354275;6295.118683384329;6303.842403939847;1609.2999545197642;1615.668787898478;1617.4177296173368;1627.5849658337286;1629.8207197208299;1017.1405162637559;1068.391017120234;1074.5003573338436;1102.685734565661;1114.3202646385698;5822.272215973004;5856.297244330707;5887.1463637772285;5893.5579831512805;5895.20414744004;6393.840153996187;6398.712057957403;6401.231852177769;6405.711742971577;6415.2037429519805;5873.20711703923;5875.823725288248;5891.23413956183;5891.528677705774;5896.700286888117;3454.7581669283413;3480.164760457523;3482.9825850870584;3485.0938755923135;3487.145649315934;6544.509161812883;6708.1950165979415;6725.66371681414;6727.899081513781;6729.5625784323865;6560.803175904731;6582.769603063965;6587.473002159816;6601.405873471411;6615.437687796495;6675.465962723068;6684.732610695518;6685.298043705438;6685.699143538553;6689.163854518185;6404.071409645669;6408.487321014401;6414.294427612866;6417.294097649162;6417.48660107181;6266.780662676784;6349.555531112777;6373.3945275198785;6379.553431259767;6489.610623362613;6799.898001529882;6808.38724514796;6813.523053386215;6827.658617069226;6829.4877884157895;4340.891477713082;4382.671299652603;4384.408104905924;4384.824607015684;4386.824527019011;6494.1232933553365;6500.089987401673;6505.739770409131;6506.512011599054;6518.674066296571;6324.525660575383;6330.873382532415;6333.461655759312;6342.460890824332;6342.619442833445;6166.784162554469;6333.334999824952;6333.65164915934;6335.113084168128;6339.904901426575;6204.472619827366;6208;6220.471259942956;6221.906671399842;6223.439890409885;6331.841703957438;6342.365763423621;6344.460720838596;6346.4605508532295;6349.7142628580905;5982.222311099529;6064.514838812973;6212.720427580679;6216.409441103088;6223.533235007483 08:19:50 INFO - PROCESS | 13066 | |5;yui.html;748.4124961904906;753.9170691223968;760.3688938181308;761.6648674583183;768.8654485465046;13938.303084845755;14024.368903399347;14044.15735055896;14074.22591757453;14146.64633384166;12828.48686052559;13026;13045.282509461977;13067;13089.934550327234;681.536555142503;795.3398679096365;807.9070906845715;814.1288820961573;817.23588444804;810.1210186947169;816.995915020424;817.8732296494053;818.8526065308242;819.9672013119468;842.4608250719514;851.595492141231;851.6508231625004;852.4629483425464;852.526847599582;707.9964600177018;837.3761547647011;849.8045449546609;863.5509535041806;864.2696921101659;638.6710843915341;639.5331408072087;639.8560323927126;644.2655372874926;645.0968643898533;13296.202227866359;13365.599032029055;13384.933075334658;13387.196768193842;13387.263700496469;12861.549845755353;13100.213987160801;13237.801432978513;13316.201027938258;13496.257705826176;10589.36463812166;10591.25861189717;10605.204609654229;10688;10793.784124317548;3593.8203089845665;3608.350496910555;3658.158623516606;3705.2033812730124;3732.794696291703;48542.757286213695;49360.50639493631;49832;49924.50075499235;50062.49937500615;10044.478129924102;10177.18582513397;10187.388756674623;10197.541110650038;10216.642417515352;18799.15403806832;18931.905340473484;18942.81057189438;18952.241910323708;18992.715109273373;7417.406607471389;7502.399808015346;7653.770386888402;7654.655540500691;7759.262870027338;4358.5205627380965;4428.800703968329;4457.465104187519;4496.0558282760985;4637.884052898705;3097.3340731742783;3131.3267647455905;3141.4659507883716;3141.607299087614;3155.921101972423;556.5936866087698;564.1594024902865;599.3317451042057;638.2755572425237;640.9359064093553;532.7602578839537;551.9944800552023;622.2719418280623;657.2802780954847;675.4393853101914;7525.548467091882;7618.123915749649;7652.846943061219;7822.647980840876;7842.333401660922;523.8428471458548;562.0809975689776;664.930182330858;677.4681874728315;687.295522089862;3504.7196224301993;3643.5263415756312;3684.060564556021;3701.592824789271;3743.3074881147077;55209.447905521236;55732.72133639306;56989.43010569924;57104;57156.42843571511;47868.28197577039;47884;48100.51899481031;48943.510564894605;48975.51024489781;45136.3229551557;45775.542244577795;46890.76554617273;46959;47015.76492117518;7014.964925175545;7196.316349946746;7271.272872712898;7336.853262934818;7494.737684181027;32455;33228.50157247595;33536.83231583826;34766.82616586901;34868.82565587156;41158;41953.370699440144;42153.78923105365;42653;42937;10893.694930770262;11081.778364432828;11098.112151028059;11156.944215278872;11701.707457313636;12150.878491214975;12402.627921162019;12455.688607784878;12536.247825130522;12995.545155919497;9931.106200441995;11189.286088793211;11444.256123351955;12077.39613019328;12350.320732359447;11468.770624587629;12077.456514456695;12138.878611213775;12282.01743860507;12536.561220357244;11552.249103808226;11632.360220187971;11874.46564904564;11897.226680265756;11978.10164237703;9663.758406039906;9783.75540611462;10009.849852252077;10154.74613134648;10345.586176553155;8617.267532259828;8963.327750418614;9424.434533927986;9840.212782977202;9957.950210248902 08:19:50 INFO - PROCESS | 13066 | __end_tp_report 08:19:50 INFO - PROCESS | 13066 | __start_cc_report 08:19:50 INFO - PROCESS | 13066 | _x_x_mozilla_cycle_collect,772 08:19:50 INFO - PROCESS | 13066 | __end_cc_report 08:19:50 INFO - PROCESS | 13066 | __startTimestamp1456762790323__endTimestamp 08:19:50 INFO - PROCESS | 13066 | 08:19:50 INFO - PROCESS | 13066 | ------- Summary: start ------- 08:19:50 INFO - PROCESS | 13066 | Number of tests: 6 08:19:50 INFO - PROCESS | 13066 | 08:19:50 INFO - PROCESS | 13066 | [#0] dojo.html Cycles:165 Average:5195.48 Median:5434.05 stddev:560.59 (10.3%) stddev-sans-first:537.45 08:19:50 INFO - PROCESS | 13066 | Values: 3090.8 3126.5 3162.3 3166.7 3204.9 5107.3 5141.9 5156.7 5166.1 5179.6 5185.4 5209.6 5237.2 5238.2 5242.8 4710.2 4741.4 4746.9 4752.9 4925.6 4856.5 4877.2 4881.6 4899.0 4919.8 4703.0 4768.9 4822.5 4828.0 4858.3 4748.1 4749.7 4750.9 4751.4 4801.7 4718.3 4720.5 4731.7 4742.7 4771.2 4997.0 5073.4 5120.5 5141.5 5156.2 5546.9 5561.6 5567.5 5573.6 5587.9 5464.7 5607.0 5615.3 5628.0 5632.1 5215.3 5230.5 5287.7 5292.1 5292.9 5662.5 5675.2 5676.0 5680.1 5680.9 5481.6 5491.0 5500.3 5501.9 5506.6 5580.9 5590.8 5595.7 5600.3 5641.7 5555.0 5564.5 5565.4 5569.1 5573.9 5447.1 5504.8 5577.2 5578.8 5636.1 4346.3 4349.0 4349.9 4384.7 4385.8 3877.9 3891.6 3911.1 3913.7 3938.1 5068.1 5191.4 5209.6 5218.2 5270.6 5585.4 5597.4 5605.7 5608.1 5642.9 5169.1 5170.0 5173.9 5174.5 5220.3 4685.9 4773.6 4779.8 4815.7 4827.4 5754.1 5797.2 5800.4 5802.5 5805.7 5584.2 5584.2 5584.5 5588.9 5604.3 5662.0 5800.7 5843.3 5865.0 5881.3 5510.6 5514.1 5517.9 5526.6 5533.4 5494.5 5584.7 5588.0 5590.6 5592.8 5484.0 5516.2 5516.3 5523.8 5562.1 5430.9 5446.2 5446.9 5448.5 5450.2 5160.8 5375.6 5385.3 5401.0 5448.8 5498.2 5499.9 5502.4 5535.9 5541.1 5395.4 5403.5 5434.0 5434.5 5441.8 08:19:50 INFO - PROCESS | 13066 | 08:19:50 INFO - PROCESS | 13066 | [#1] ext.html Cycles:180 Average:43098.20 Median:17117.69 stddev:69172.34 (404.1%) stddev-sans-first:69292.52 08:19:50 INFO - PROCESS | 13066 | Values: 525.3 547.3 585.2 586.1 593.9 28515.4 38614.2 39010.0 39020.4 39052.4 42337.2 42860.4 42860.6 43013.0 43077.2 7480.2 8641.9 8866.2 9950.4 10077.8 10061.6 10187.1 10206.6 10222.8 10226.6 10190.0 10289.9 10293.5 10297.8 10301.4 10143.0 10218.3 10226.8 10234.6 10241.4 10213.9 10435.4 10453.3 10465.7 10474.6 39326.4 39647.4 39735.6 39772.0 39779.2 3154.4 3246.4 3364.0 3480.5 3637.8 30413.2 30526.7 30721.7 31937.4 32004.7 3968.7 3992.4 4016.9 4036.7 4155.7 264513.0 265838.0 266661.0 267320.0 267814.0 40805.0 41497.6 57964.0 58445.7 58732.4 39555.2 39809.0 39828.6 39855.8 39867.0 14849.8 15076.2 15078.3 15086.7 15086.8 12088.7 12109.3 12118.5 12134.9 12140.4 13986.5 14032.2 14074.0 14117.5 14218.9 5635.9 5725.1 5739.3 5742.5 5809.6 1000.8 1016.8 1051.6 1071.9 1103.3 27742.0 27960.4 28017.1 28589.4 28657.4 841.4 1031.0 1055.1 1070.3 1087.8 12973.7 13237.3 13371.2 13402.7 13497.6 297132.0 297495.0 298225.0 300340.0 301261.0 50989.5 51742.0 51807.7 51813.2 51861.7 1334.0 1365.7 1379.5 1382.0 1390.5 25152.5 26590.5 26888.7 27046.0 27057.9 43410.3 46979.5 47726.5 47963.8 48014.3 225731.0 226366.0 226827.0 228031.0 228436.0 36194.3 37144.3 37482.1 37556.1 38697.4 38623.4 38676.2 38977.2 39087.4 39794.8 35357.5 35669.6 35942.8 36093.0 36381.6 36425.0 36520.3 36551.3 36601.3 37060.3 31081.0 35340.8 36566.0 38715.8 38939.4 30502.4 32331.8 32784.3 32831.2 33074.3 24672.1 24940.0 25008.2 25319.6 25339.4 08:19:50 INFO - PROCESS | 13066 | 08:19:50 INFO - PROCESS | 13066 | [#2] jquery.html Cycles:180 Average:25758.03 Median:32775.51 stddev:69508.60 (212.1%) stddev-sans-first:69677.38 08:19:50 INFO - PROCESS | 13066 | Values: 332.9 341.1 343.1 345.0 348.8 12623.1 17366.6 17846.5 18192.5 18896.1 15849.9 16002.1 16429.3 17109.5 17119.7 5304.7 5515.8 5527.0 5532.2 5534.3 5117.3 5413.1 5416.9 5421.2 5427.0 5358.3 5358.8 5362.6 5363.3 5366.0 5352.3 6094.5 6321.4 6352.6 6376.8 6037.6 6043.9 6071.4 6111.9 6164.0 22376.6 22448.8 22606.1 22611.4 22813.8 2391.9 2412.5 2715.6 2716.4 3188.5 13329.1 13377.1 13515.2 13652.9 13700.4 1928.8 1995.6 1996.3 2067.2 2082.4 66675.0 71754.6 71811.0 71872.0 73132.6 12701.5 14458.5 14787.8 14904.6 15108.8 20703.8 23400.5 23806.2 23983.5 24362.5 9091.2 9117.5 9370.3 9390.2 9520.5 7936.6 8048.3 8067.3 8215.6 8248.7 7524.6 7560.2 7574.6 7603.2 7610.4 2910.2 2994.1 3002.6 3038.2 3086.1 916.6 922.3 983.8 1013.3 1040.2 15822.6 16074.5 16214.0 16678.0 16751.4 948.5 953.1 957.2 969.6 981.2 9155.3 9341.5 9358.8 9417.4 9466.5 419575.0 420943.0 421773.6 427897.0 428839.0 71991.0 72691.0 73508.3 74279.6 76109.0 1008.0 1009.4 1016.0 1033.8 1049.7 14097.0 14486.1 14554.0 14579.2 14699.2 30624.7 31236.7 31529.0 32521.3 33029.7 43418.3 45030.3 45303.0 46006.3 46106.5 7427.6 7620.4 7843.1 7845.9 7880.3 10074.1 12092.3 12169.6 12204.9 12356.1 10170.5 10285.3 10408.9 10549.0 10768.2 10131.8 10739.6 10977.7 11191.3 11235.4 10908.5 10949.0 11238.5 11262.0 11265.7 7599.9 7887.9 7890.8 7906.4 8011.0 10097.7 10105.4 10168.8 10196.2 10684.6 08:19:50 INFO - PROCESS | 13066 | 08:19:50 INFO - PROCESS | 13066 | [#3] mootools.html Cycles:180 Average:5630.34 Median:5432.59 stddev:3038.00 (55.9%) stddev-sans-first:3029.47 08:19:50 INFO - PROCESS | 13066 | Values: 1346.7 1481.7 1489.3 1639.9 1805.3 7737.0 7854.8 7868.1 7869.3 7914.8 7673.6 7792.0 7807.0 7824.7 7829.1 1909.6 2249.7 2263.7 2272.4 2318.7 2294.0 2302.1 2302.4 2303.0 2305.1 2220.4 2294.2 2294.5 2295.9 2297.8 2249.1 2279.9 2296.0 2317.9 2318.3 2287.9 2331.8 2338.0 2347.2 2348.8 8109.5 8142.8 8153.1 8161.9 8163.0 4806.3 4926.8 4937.6 4977.0 4981.8 2990.6 3079.1 3123.2 3128.0 3128.3 995.6 1008.2 1013.5 1020.9 1040.5 11515.7 11523.9 11647.2 11658.7 11664.4 4117.6 4245.2 4256.2 4286.3 4371.5 9578.2 9637.2 9637.9 9644.6 9646.6 4384.6 4920.3 4920.6 4953.7 4954.7 4159.5 4209.5 4209.7 4243.2 4255.8 3713.8 3778.1 3785.8 3801.5 3826.5 1208.4 1213.4 1213.7 1216.4 1231.4 1037.6 1057.2 1067.5 1241.3 1376.7 7790.9 7837.9 7882.2 7903.7 7910.0 459.3 473.8 475.2 480.9 481.2 5883.4 5900.5 5912.3 5918.2 5945.6 9469.3 10035.5 10175.0 10181.8 10186.6 9923.1 9991.9 10027.1 10042.1 10102.8 7522.3 7774.0 7831.1 7863.3 7869.4 7267.4 7364.4 7419.7 7430.4 7482.8 8674.8 8833.7 8855.7 8991.4 9047.5 9009.5 9136.0 9158.9 9222.9 9251.9 6396.1 6771.9 6889.3 7264.1 7320.6 7555.3 7656.2 7656.5 7661.9 7688.3 6779.3 6907.3 6964.9 7001.8 7153.2 6708.0 6737.5 6747.4 6918.8 6982.0 7005.2 7008.2 7012.0 7357.0 7377.9 6640.0 6661.0 6674.6 6692.3 6710.1 6375.5 6592.8 6615.0 6654.4 6655.7 08:19:50 INFO - PROCESS | 13066 | 08:19:50 INFO - PROCESS | 13066 | [#4] prototype.html Cycles:180 Average:5227.03 Median:5892.63 stddev:1585.11 (26.9%) stddev-sans-first:1546.01 08:19:50 INFO - PROCESS | 13066 | Values: 310.7 311.3 312.6 319.7 329.5 5891.6 5940.1 5965.9 5970.2 5982.4 5865.9 5882.2 5891.7 5900.2 5901.6 4340.1 4366.1 4434.6 4458.0 4458.1 4417.6 4451.8 4459.7 4462.8 4478.9 4317.9 4419.1 4437.5 4443.2 4449.9 4390.8 4508.1 4512.2 4520.2 4527.0 3972.2 3977.9 3979.0 3980.1 3987.3 5579.6 5615.2 5617.6 5629.0 5637.1 5266.4 5269.3 5276.9 5280.1 5280.5 6211.2 6235.1 6236.6 6241.3 6241.6 4172.7 4287.5 4292.4 4294.9 4432.5 6462.6 6499.9 6523.3 6525.2 6532.8 4367.5 4371.7 4374.7 4378.7 4383.0 4421.9 4433.6 4434.9 4440.8 4442.3 5119.7 5129.8 5156.0 5163.0 5173.3 6194.0 6270.7 6295.1 6295.1 6303.8 1609.3 1615.7 1617.4 1627.6 1629.8 1017.1 1068.4 1074.5 1102.7 1114.3 5822.3 5856.3 5887.1 5893.6 5895.2 6393.8 6398.7 6401.2 6405.7 6415.2 5873.2 5875.8 5891.2 5891.5 5896.7 3454.8 3480.2 3483.0 3485.1 3487.1 6544.5 6708.2 6725.7 6727.9 6729.6 6560.8 6582.8 6587.5 6601.4 6615.4 6675.5 6684.7 6685.3 6685.7 6689.2 6404.1 6408.5 6414.3 6417.3 6417.5 6266.8 6349.6 6373.4 6379.6 6489.6 6799.9 6808.4 6813.5 6827.7 6829.5 4340.9 4382.7 4384.4 4384.8 4386.8 6494.1 6500.1 6505.7 6506.5 6518.7 6324.5 6330.9 6333.5 6342.5 6342.6 6166.8 6333.3 6333.7 6335.1 6339.9 6204.5 6208.0 6220.5 6221.9 6223.4 6331.8 6342.4 6344.5 6346.5 6349.7 5982.2 6064.5 6212.7 6216.4 6223.5 08:19:50 INFO - PROCESS | 13066 | 08:19:50 INFO - PROCESS | 13066 | [#5] yui.html Cycles:180 Average:13675.45 Median:24816.19 stddev:15613.58 (62.9%) stddev-sans-first:15627.20 08:19:50 INFO - PROCESS | 13066 | Values: 748.4 753.9 760.4 761.7 768.9 13938.3 14024.4 14044.2 14074.2 14146.6 12828.5 13026.0 13045.3 13067.0 13089.9 681.5 795.3 807.9 814.1 817.2 810.1 817.0 817.9 818.9 820.0 842.5 851.6 851.7 852.5 852.5 708.0 837.4 849.8 863.6 864.3 638.7 639.5 639.9 644.3 645.1 13296.2 13365.6 13384.9 13387.2 13387.3 12861.5 13100.2 13237.8 13316.2 13496.3 10589.4 10591.3 10605.2 10688.0 10793.8 3593.8 3608.4 3658.2 3705.2 3732.8 48542.8 49360.5 49832.0 49924.5 50062.5 10044.5 10177.2 10187.4 10197.5 10216.6 18799.2 18931.9 18942.8 18952.2 18992.7 7417.4 7502.4 7653.8 7654.7 7759.3 4358.5 4428.8 4457.5 4496.1 4637.9 3097.3 3131.3 3141.5 3141.6 3155.9 556.6 564.2 599.3 638.3 640.9 532.8 552.0 622.3 657.3 675.4 7525.5 7618.1 7652.8 7822.6 7842.3 523.8 562.1 664.9 677.5 687.3 3504.7 3643.5 3684.1 3701.6 3743.3 55209.4 55732.7 56989.4 57104.0 57156.4 47868.3 47884.0 48100.5 48943.5 48975.5 45136.3 45775.5 46890.8 46959.0 47015.8 7015.0 7196.3 7271.3 7336.9 7494.7 32455.0 33228.5 33536.8 34766.8 34868.8 41158.0 41953.4 42153.8 42653.0 42937.0 10893.7 11081.8 11098.1 11156.9 11701.7 12150.9 12402.6 12455.7 12536.2 12995.5 9931.1 11189.3 11444.3 12077.4 12350.3 11468.8 12077.5 12138.9 12282.0 12536.6 11552.2 11632.4 11874.5 11897.2 11978.1 9663.8 9783.8 10009.8 10154.7 10345.6 8617.3 8963.3 9424.4 9840.2 9958.0 08:19:50 INFO - PROCESS | 13066 | -------- Summary: end -------- 08:19:50 INFO - PROCESS | 13066 | 08:19:50 INFO - PROCESS | 13066 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:19:50 INFO - PROCESS | 13066 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:19:50 INFO - PROCESS | 13066 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:19:50 INFO - PROCESS | 13066 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:19:50 INFO - PROCESS | 13066 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:19:50 INFO - PROCESS | 13066 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:19:50 INFO - PROCESS | 13066 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:19:51 INFO - TEST-INFO | 13066: exit 0 08:19:51 INFO - TEST-OK | dromaeo_css | took 1113257ms 08:19:51 INFO - TEST-START | kraken 08:19:51 INFO - operating with platform_type : linux_ 08:19:51 INFO - Initialising browser for kraken test... 08:19:51 INFO - TEST-INFO | started process 13261 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMcLzt1/profile http://localhost:59259/getInfo.html) 08:19:55 INFO - PROCESS | 13261 | __metrics Screen width/height:1600/1200 08:19:55 INFO - PROCESS | 13261 | colorDepth:24 08:19:55 INFO - PROCESS | 13261 | Browser inner width/height: 1024/697 08:19:55 INFO - PROCESS | 13261 | __metrics 08:19:56 INFO - PROCESS | 13261 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:19:56 INFO - PROCESS | 13261 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:19:56 INFO - PROCESS | 13261 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:19:56 INFO - PROCESS | 13261 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:19:56 INFO - PROCESS | 13261 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:19:56 INFO - PROCESS | 13261 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:19:56 INFO - PROCESS | 13261 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:19:56 INFO - PROCESS | 13261 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 08:19:56 INFO - TEST-INFO | 13261: exit 0 08:19:56 INFO - Browser initialized. 08:19:56 INFO - Running cycle 1/1 for kraken test... 08:19:56 INFO - TEST-INFO | started process 13345 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMcLzt1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:20:08 INFO - PROCESS | 13345 | RSS: Main: 153608192 08:20:08 INFO - PROCESS | 13345 | 08:20:11 INFO - PROCESS | 13345 | Cycle 1(1): loaded http://localhost:59259/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59259/tests/kraken/driver.html?testName=audio-beat-detection) 08:20:11 INFO - PROCESS | 13345 | RSS: Main: 198017024 08:20:11 INFO - PROCESS | 13345 | 08:20:14 INFO - PROCESS | 13345 | Cycle 1(1): loaded http://localhost:59259/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59259/tests/kraken/driver.html?testName=audio-dft) 08:20:15 INFO - PROCESS | 13345 | RSS: Main: 186814464 08:20:15 INFO - PROCESS | 13345 | 08:20:17 INFO - PROCESS | 13345 | Cycle 1(1): loaded http://localhost:59259/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59259/tests/kraken/driver.html?testName=audio-fft) 08:20:18 INFO - PROCESS | 13345 | RSS: Main: 169832448 08:20:18 INFO - PROCESS | 13345 | 08:20:20 INFO - PROCESS | 13345 | Cycle 1(1): loaded http://localhost:59259/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59259/tests/kraken/driver.html?testName=audio-oscillator) 08:20:21 INFO - PROCESS | 13345 | RSS: Main: 172810240 08:20:21 INFO - PROCESS | 13345 | 08:20:23 INFO - PROCESS | 13345 | Cycle 1(1): loaded http://localhost:59259/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59259/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:20:23 INFO - PROCESS | 13345 | RSS: Main: 174628864 08:20:23 INFO - PROCESS | 13345 | 08:20:26 INFO - PROCESS | 13345 | Cycle 1(1): loaded http://localhost:59259/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59259/tests/kraken/driver.html?testName=imaging-darkroom) 08:20:27 INFO - PROCESS | 13345 | RSS: Main: 174616576 08:20:27 INFO - PROCESS | 13345 | 08:20:30 INFO - PROCESS | 13345 | Cycle 1(1): loaded http://localhost:59259/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59259/tests/kraken/driver.html?testName=imaging-desaturate) 08:20:31 INFO - PROCESS | 13345 | RSS: Main: 175202304 08:20:31 INFO - PROCESS | 13345 | 08:20:34 INFO - PROCESS | 13345 | Cycle 1(1): loaded http://localhost:59259/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59259/tests/kraken/driver.html?testName=json-parse-financial) 08:20:34 INFO - PROCESS | 13345 | RSS: Main: 175878144 08:20:34 INFO - PROCESS | 13345 | 08:20:36 INFO - PROCESS | 13345 | Cycle 1(1): loaded http://localhost:59259/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59259/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:20:36 INFO - PROCESS | 13345 | RSS: Main: 186634240 08:20:36 INFO - PROCESS | 13345 | 08:20:38 INFO - PROCESS | 13345 | Cycle 1(1): loaded http://localhost:59259/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59259/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:20:39 INFO - PROCESS | 13345 | RSS: Main: 185040896 08:20:39 INFO - PROCESS | 13345 | 08:20:41 INFO - PROCESS | 13345 | Cycle 1(1): loaded http://localhost:59259/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59259/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:20:41 INFO - PROCESS | 13345 | RSS: Main: 195268608 08:20:41 INFO - PROCESS | 13345 | 08:20:44 INFO - PROCESS | 13345 | Cycle 1(1): loaded http://localhost:59259/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59259/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:20:44 INFO - PROCESS | 13345 | RSS: Main: 201269248 08:20:44 INFO - PROCESS | 13345 | 08:20:47 INFO - PROCESS | 13345 | Cycle 1(1): loaded http://localhost:59259/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59259/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:20:48 INFO - PROCESS | 13345 | RSS: Main: 201867264 08:20:48 INFO - PROCESS | 13345 | 08:20:49 INFO - PROCESS | 13345 | Cycle 1(1): loaded http://localhost:59259/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59259/tests/kraken/driver.html?testName=ai-astar) 08:20:50 INFO - PROCESS | 13345 | RSS: Main: 260603904 08:20:50 INFO - PROCESS | 13345 | 08:20:50 INFO - PROCESS | 13345 | __start_tp_report 08:20:50 INFO - PROCESS | 13345 | _x_x_mozilla_page_load 08:20:50 INFO - PROCESS | 13345 | _x_x_mozilla_page_load_details 08:20:50 INFO - PROCESS | 13345 | |i|pagename|runs| 08:20:50 INFO - PROCESS | 13345 | |0;ai-astar;110;111;106;111;113;113;100;111;110;110 08:20:50 INFO - PROCESS | 13345 | |1;audio-beat-detection;152;124;154;169;126;147;147;125;174;127 08:20:50 INFO - PROCESS | 13345 | |2;audio-dft;161;159;161;159;161;158;159;162;161;161 08:20:50 INFO - PROCESS | 13345 | |3;audio-fft;73;73;93;95;73;72;73;116;96;72 08:20:50 INFO - PROCESS | 13345 | |4;audio-oscillator;95;95;141;95;96;94;148;95;96;147 08:20:50 INFO - PROCESS | 13345 | |5;imaging-gaussian-blur;119;115;115;116;114;116;115;115;115;115 08:20:50 INFO - PROCESS | 13345 | |6;imaging-darkroom;146;148;145;146;148;146;145;147;145;146 08:20:50 INFO - PROCESS | 13345 | |7;imaging-desaturate;96;96;95;96;96;96;96;96;96;95 08:20:50 INFO - PROCESS | 13345 | |8;json-parse-financial;56;56;57;56;57;57;57;65;55;53 08:20:50 INFO - PROCESS | 13345 | |9;json-stringify-tinderbox;67;68;67;69;68;67;68;67;67;68 08:20:50 INFO - PROCESS | 13345 | |10;stanford-crypto-aes;81;83;83;82;90;83;83;83;83;87 08:20:50 INFO - PROCESS | 13345 | |11;stanford-crypto-ccm;125;121;119;115;122;118;117;118;118;125 08:20:50 INFO - PROCESS | 13345 | |12;stanford-crypto-pbkdf2;153;140;153;149;151;142;152;161;149;151 08:20:50 INFO - PROCESS | 13345 | |13;stanford-crypto-sha256-iterative;68;70;70;71;69;68;82;69;70;68 08:20:50 INFO - PROCESS | 13345 | __end_tp_report 08:20:50 INFO - PROCESS | 13345 | __start_cc_report 08:20:50 INFO - PROCESS | 13345 | _x_x_mozilla_cycle_collect,1071 08:20:50 INFO - PROCESS | 13345 | __end_cc_report 08:20:50 INFO - PROCESS | 13345 | __startTimestamp1456762850055__endTimestamp 08:20:50 INFO - PROCESS | 13345 | 08:20:50 INFO - PROCESS | 13345 | ------- Summary: start ------- 08:20:50 INFO - PROCESS | 13345 | Number of tests: 14 08:20:50 INFO - PROCESS | 13345 | 08:20:50 INFO - PROCESS | 13345 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:3.87 (3.5%) stddev-sans-first:4.10 08:20:50 INFO - PROCESS | 13345 | Values: 110.0 111.0 106.0 111.0 113.0 113.0 100.0 111.0 110.0 110.0 08:20:50 INFO - PROCESS | 13345 | 08:20:50 INFO - PROCESS | 13345 | [#1] audio-beat-detection Cycles:10 Average:144.50 Median:149.50 stddev:18.49 (12.4%) stddev-sans-first:19.42 08:20:50 INFO - PROCESS | 13345 | Values: 152.0 124.0 154.0 169.0 126.0 147.0 147.0 125.0 174.0 127.0 08:20:50 INFO - PROCESS | 13345 | 08:20:50 INFO - PROCESS | 13345 | [#2] audio-dft Cycles:10 Average:160.20 Median:161.00 stddev:1.32 (0.8%) stddev-sans-first:1.36 08:20:50 INFO - PROCESS | 13345 | Values: 161.0 159.0 161.0 159.0 161.0 158.0 159.0 162.0 161.0 161.0 08:20:50 INFO - PROCESS | 13345 | 08:20:50 INFO - PROCESS | 13345 | [#3] audio-fft Cycles:10 Average:83.60 Median:73.00 stddev:15.42 (21.1%) stddev-sans-first:15.87 08:20:50 INFO - PROCESS | 13345 | Values: 73.0 73.0 93.0 95.0 73.0 72.0 73.0 116.0 96.0 72.0 08:20:50 INFO - PROCESS | 13345 | 08:20:50 INFO - PROCESS | 13345 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:95.00 stddev:24.32 (25.6%) stddev-sans-first:25.16 08:20:50 INFO - PROCESS | 13345 | Values: 95.0 95.0 141.0 95.0 96.0 94.0 148.0 95.0 96.0 147.0 08:20:50 INFO - PROCESS | 13345 | 08:20:50 INFO - PROCESS | 13345 | [#5] imaging-gaussian-blur Cycles:10 Average:115.50 Median:115.00 stddev:1.35 (1.2%) stddev-sans-first:0.60 08:20:50 INFO - PROCESS | 13345 | Values: 119.0 115.0 115.0 116.0 114.0 116.0 115.0 115.0 115.0 115.0 08:20:50 INFO - PROCESS | 13345 | 08:20:50 INFO - PROCESS | 13345 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:1.14 (0.8%) stddev-sans-first:1.20 08:20:50 INFO - PROCESS | 13345 | Values: 146.0 148.0 145.0 146.0 148.0 146.0 145.0 147.0 145.0 146.0 08:20:50 INFO - PROCESS | 13345 | 08:20:50 INFO - PROCESS | 13345 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:20:50 INFO - PROCESS | 13345 | Values: 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 08:20:50 INFO - PROCESS | 13345 | 08:20:50 INFO - PROCESS | 13345 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:57.00 stddev:3.11 (5.5%) stddev-sans-first:3.28 08:20:50 INFO - PROCESS | 13345 | Values: 56.0 56.0 57.0 56.0 57.0 57.0 57.0 65.0 55.0 53.0 08:20:50 INFO - PROCESS | 13345 | 08:20:50 INFO - PROCESS | 13345 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 08:20:50 INFO - PROCESS | 13345 | Values: 67.0 68.0 67.0 69.0 68.0 67.0 68.0 67.0 67.0 68.0 08:20:50 INFO - PROCESS | 13345 | 08:20:50 INFO - PROCESS | 13345 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:83.00 stddev:2.66 (3.2%) stddev-sans-first:2.62 08:20:50 INFO - PROCESS | 13345 | Values: 81.0 83.0 83.0 82.0 90.0 83.0 83.0 83.0 83.0 87.0 08:20:50 INFO - PROCESS | 13345 | 08:20:50 INFO - PROCESS | 13345 | [#11] stanford-crypto-ccm Cycles:10 Average:119.80 Median:120.00 stddev:3.36 (2.8%) stddev-sans-first:2.99 08:20:50 INFO - PROCESS | 13345 | Values: 125.0 121.0 119.0 115.0 122.0 118.0 117.0 118.0 118.0 125.0 08:20:50 INFO - PROCESS | 13345 | 08:20:50 INFO - PROCESS | 13345 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.10 Median:151.50 stddev:5.88 (3.9%) stddev-sans-first:6.14 08:20:50 INFO - PROCESS | 13345 | Values: 153.0 140.0 153.0 149.0 151.0 142.0 152.0 161.0 149.0 151.0 08:20:50 INFO - PROCESS | 13345 | 08:20:50 INFO - PROCESS | 13345 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:70.00 stddev:4.17 (6.0%) stddev-sans-first:4.32 08:20:50 INFO - PROCESS | 13345 | Values: 68.0 70.0 70.0 71.0 69.0 68.0 82.0 69.0 70.0 68.0 08:20:50 INFO - PROCESS | 13345 | -------- Summary: end -------- 08:20:50 INFO - PROCESS | 13345 | 08:20:50 INFO - PROCESS | 13345 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:20:50 INFO - PROCESS | 13345 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:20:50 INFO - PROCESS | 13345 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:20:50 INFO - PROCESS | 13345 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:20:50 INFO - PROCESS | 13345 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:20:50 INFO - TEST-INFO | 13345: exit 0 08:20:51 INFO - TEST-OK | kraken | took 59995ms 08:20:51 INFO - SUITE-END | took 1173s 08:20:51 INFO - Completed test suite (00:19:33) 08:20:51 INFO - Working with test: dromaeo_css 08:20:51 INFO - Generating results file: dromaeo_css 08:20:51 INFO - Working with test: kraken 08:20:51 INFO - Generating results file: kraken 08:20:51 INFO - javascript benchmark 08:20:51 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:20:51 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 08:20:51 INFO - process_Request line: dromaeo_css 6945.73 graph.html#tests=[[72,64,35]] 08:20:51 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:20:51 INFO - process_Request line: kraken 1514.20 graph.html#tests=[[232,64,35]] 08:20:51 INFO - RETURN: dromaeo_css: 6945.73 08:20:51 INFO - RETURN: kraken: 1514.20 08:20:51 INFO - javascript benchmark 08:20:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3090.8145511269327, 3126.4841301185306, 3162.320101178246, 3166.6516683164864, 3204.903852884413, 5107.259447380127, 5141.897162056756, 5156.742162891855, 5166.121759300914, 5179.585633149349, 5185.351831021122, 5209.557187639046, 5237.214417837326, 5238.188080847474, 5242.842714718565, 4710.222813235812, 4741.383620129378, 4746.90506189876, 4752.881177970561, 4925.630577706668, 4856.514348565133, 4877.219644856824, 4881.60947124231, 4899.020195960804, 4919.77860996256, 4702.97648511757, 4768.928466072977, 4822.4936381679945, 4827.951720482785, 4858.344123543312, 4748.050389922029, 4749.7387643679585, 4750.904981900378, 4751.3585665935, 4801.711897286139, 4718.292256161569, 4720.480747117815, 4731.739754313511, 4742.691725037862, 4771.212749896263, 4996.950030499721, 5073.365829271341, 5120.487951204887, 5141.485851414866, 5156.20078887773, 5546.91679624806, 5561.637398837271, 5567.47109024642, 5573.637713548606, 5587.944120558783, 5464.6994415307145, 5607.046802043662, 5615.326160860723, 5628.04323265046, 5632.127020311858, 5215.269862219292, 5230.476952304739, 5287.682739035632, 5292.073887069786, 5292.9206061908335, 5662.462066103713, 5675.177099320658, 5676.035074037423, 5680.14797780328, 5680.857978550569, 5481.643693159932, 5490.972545137249, 5500.28496295487, 5501.944980550144, 5506.559475241971, 5580.91628625571, 5590.8043218487155, 5595.692236927008, 5600.299962504687, 5641.661500309994, 5554.972225138848, 5564.527015203672, 5565.387807341189, 5569.136783798518, 5573.944260557424, 5447.073997420448, 5504.834854954358, 5577.191307260425, 5578.847613707966, 5636.070048442043, 4346.348047792856, 4348.9565104349185, 4349.934750978738, 4384.7369157850635, 4385.758783266951, 3877.941830872539, 3891.630295121959, 3911.1004468972296, 3913.72603917723, 3938.1139243669945, 5068.113080210948, 5191.428942816287, 5209.557187639018, 5218.165093585084, 5270.552003079704, 5585.441455854463, 5597.440255974451, 5605.663660180402, 5608.10270356741, 5642.943570564324, 5169.06956747789, 5170.017696637627, 5173.92239116406, 5174.534291913746, 5220.269162317279, 4685.929711054268, 4773.570378665937, 4779.784909679072, 4815.662903596784, 4827.372441582572, 5754.108113242454, 5797.246357973437, 5800.419958004166, 5802.535797136304, 5805.709714514342, 5584.162375643686, 5584.246126772834, 5584.525315348241, 5588.916166257428, 5604.327480702342, 5661.980843448219, 5800.7099645018425, 5843.328017278068, 5864.970675146597, 5881.32364778056, 5510.614257002132, 5514.09017512106, 5517.917231241615, 5526.58550608714, 5533.418991005887, 5494.450554944474, 5584.720763961867, 5587.972060139673, 5590.636608620427, 5592.7762889483965, 5484.0, 5516.227728118147, 5516.310461192351, 5523.7790488380015, 5562.137868630369, 5430.864228394322, 5446.1558458439, 5446.891062178814, 5448.509634132947, 5450.155225939986, 5160.819371322136, 5375.623706340519, 5385.27298814655, 5401.0, 5448.83653490396, 5498.202760599611, 5499.917501237404, 5502.422245664147, 5535.861603459945, 5541.085720856014, 5395.406505284337, 5403.486668766461, 5434.049041417815, 5434.538064264424, 5441.782328706808], "unit": "score", "name": "dojo.html", "value": 5160.12367089487}, {"lowerIsBetter": false, "replicates": [525.3485677759579, 547.2912578211218, 585.2012003615064, 586.1383765864181, 593.8752861899002, 28515.42969140616, 38614.22771544571, 39010.0, 39020.414693779545, 39052.41421378682, 42337.15325693484, 42860.35709464361, 42860.571394286046, 43013.0, 43077.19998200115, 7480.214577469369, 8641.91358086419, 8866.202041816236, 9950.353227040256, 10077.848832267522, 10061.647842325483, 10187.134093602053, 10206.64276750314, 10222.846657300146, 10226.642067527639, 10190.0, 10289.897101028968, 10293.48532573372, 10297.794044119113, 10301.433421161833, 10142.971405718848, 10218.335808172445, 10226.79546409075, 10234.590616375335, 10241.43672098038, 10213.897861021444, 10435.426051567161, 10453.320534165256, 10465.68602941913, 10474.58101675932, 39326.410103848466, 39647.4052889204, 39735.60264397348, 39772.0, 39779.20441591152, 3154.3848949454864, 3246.3831871944253, 3363.9831800841084, 3480.460528618068, 3637.7999210043436, 30413.23966900823, 30526.69473305283, 30721.692783072107, 31937.36125277505, 32004.679953200404, 3968.6626636735914, 3992.3612222044335, 4016.8995775105855, 4036.6568841648495, 4155.709100362976, 264513.0, 265838.0, 266661.0, 267320.0, 267813.9999999981, 40805.0, 41497.58502414998, 57964.0, 58445.70777146087, 58732.41267587355, 39555.208895821925, 39809.0, 39828.601713983066, 39855.80072099621, 39867.0, 14849.777253341208, 15076.24618769057, 15078.321475533627, 15086.698266034618, 15086.773698394532, 12088.697782555506, 12109.333986630643, 12118.454669539891, 12134.878651213552, 12140.392980350947, 13986.510472133426, 14032.158070515598, 14074.0, 14117.505887293895, 14218.85781142196, 5635.915461268084, 5725.112607545837, 5739.253896993448, 5742.454466825729, 5809.564282678816, 1000.849872519128, 1016.8220561401725, 1051.5951358726945, 1071.919606029551, 1103.332483847277, 27742.0, 27960.44079118406, 28017.08722431933, 28589.428211435654, 28657.42685146327, 841.4110122913985, 1030.9690709278734, 1055.0715370474088, 1070.3310430980637, 1087.798757229915, 12973.675658108623, 13237.343011696372, 13371.197728136343, 13402.664933376744, 13497.595072147851, 297132.0, 297495.0, 298225.0, 300340.0, 301261.0, 50989.49010509922, 51742.01482799849, 51807.740961295705, 51813.222801658005, 51861.740691296305, 1333.953311634088, 1365.7473367427058, 1379.475799196319, 1381.958541243744, 1390.5202705066736, 25152.49695006053, 26590.468190635693, 26888.731112688623, 27046.0, 27057.86471067632, 43410.348844767985, 46979.53020469751, 47726.5227347736, 47963.76018120027, 48014.279785802544, 225731.0, 226366.0, 226827.0, 228031.0, 228436.0, 36194.27611447809, 37144.25711485809, 37482.06294842651, 37556.06109847166, 38697.41953870638, 38623.42064869085, 38676.226475470896, 38977.2204555913, 39087.41368879412, 39794.80102599468, 35357.46963795597, 35669.643303566634, 35942.8202858984, 36093.0, 36381.63618363783, 36425.0, 36520.26959460849, 36551.26897462089, 36601.26797464089, 37060.258794823414, 31081.0, 35340.823295883354, 36566.0, 38715.80642096772, 38939.415908761956, 30502.38995220039, 32331.838340808146, 32784.34431311408, 32831.17922051872, 33074.33851322912, 24672.136475224, 24940.0, 25008.249752507454, 25319.620205697298, 25339.366515837253], "unit": "score", "name": "ext.html", "value": 18025.394519884776}, {"lowerIsBetter": false, "replicates": [332.8931303416142, 341.1318195193233, 343.1096305088298, 345.03046439504993, 348.7802684308885, 12623.116381853262, 17366.565835854093, 17846.46460606184, 18192.545186370346, 18896.149673264703, 15849.92075039626, 16002.119883406407, 16429.26068326925, 17109.54568861645, 17119.743203851922, 5304.70824104675, 5515.806946756864, 5527.032769265383, 5532.170174473821, 5534.335879694442, 5117.283580298761, 5413.079776437995, 5416.864578385533, 5421.159720243349, 5427.0, 5358.2766326546, 5358.839234822962, 5362.597805164609, 5363.275957745713, 5365.980463711901, 5352.2506849041165, 6094.542909281799, 6321.431071203614, 6352.555321127546, 6376.776812811529, 6037.607555508922, 6043.8791224175275, 6071.423214794588, 6111.938880611181, 6163.969180154116, 22376.552468950693, 22448.775512244996, 22606.0957561699, 22611.434714132112, 22813.771862281497, 2391.9402014949765, 2412.457197130649, 2715.579085241791, 2716.361655011071, 3188.4898416253286, 13329.133606315656, 13377.130486518443, 13515.189088654712, 13652.86347136526, 13700.3834827433, 1928.798807867674, 1995.5809280051062, 1996.3112726109468, 2067.1627990663656, 2082.37528741377, 66675.0, 71754.64122679354, 71811.0, 71872.0, 73132.6343368285, 12701.491940322283, 14458.493952711604, 14787.778183327258, 14904.552863414116, 15108.773368399483, 20703.792962070187, 23400.53198936012, 23806.16678416282, 23983.52032959366, 24362.51274974526, 9091.181793638472, 9117.498537580497, 9370.344075914756, 9390.248780097576, 9520.523973801282, 7936.6031698414845, 8048.315893149148, 8067.273945344947, 8215.630296636666, 8248.670053197924, 7524.586147761816, 7560.243975602396, 7574.5833979130575, 7603.239676032463, 7610.353119984863, 2910.1996950838266, 2994.131701806452, 3002.6246719160104, 3038.194878357237, 3086.0896035669084, 916.6287653500343, 922.2529750901791, 983.7983213441371, 1013.3210748798175, 1040.167865707431, 15822.60443488922, 16074.517764467084, 16214.027158370536, 16678.0, 16751.413700520425, 948.5399581203111, 953.0945601678295, 957.2150836314156, 969.6024629901707, 981.1856159387692, 9155.267578593697, 9341.486218258062, 9358.812823743623, 9417.387869788441, 9466.526673666289, 419575.0, 420943.0, 421773.5577757382, 427897.0, 428839.0, 71991.0, 72691.0, 73508.26491735122, 74279.62860185665, 76109.0, 1007.9949600252098, 1009.3641006166215, 1016.0499932563077, 1033.7777377863795, 1049.7218237167158, 14097.0, 14486.058406203985, 14554.0, 14579.198144102176, 14699.191544465157, 30624.693753062184, 31236.687633123376, 31529.0, 32521.349573007934, 33029.66970330266, 43418.348724769785, 45030.324545132506, 45303.0, 46006.309905350776, 46106.53893461157, 7427.554346739213, 7620.390368770374, 7843.137254902071, 7845.882311765442, 7880.290773830383, 10074.136284787337, 12092.334921579397, 12169.634910952685, 12204.87795122073, 12356.073294502768, 10170.542325595217, 10285.331453455501, 10408.895911040792, 10549.0, 10768.246222764332, 10131.797364052825, 10739.570417183226, 10977.670669879917, 11191.32852028881, 11235.438228088726, 10908.509117089592, 10949.014588686738, 11238.494267757807, 11262.0, 11265.71835704114, 7599.886001709868, 7887.881681774893, 7890.763277101696, 7906.367490600623, 8010.959945200237, 10097.747556310856, 10105.44420056904, 10168.84746728785, 10196.235282354002, 10684.57261709554], "unit": "score", "name": "jquery.html", "value": 9098.57583497046}, {"lowerIsBetter": false, "replicates": [1346.6566025663453, 1481.74810282252, 1489.277700315347, 1639.860611847993, 1805.295934585512, 7737.0, 7854.842903141934, 7868.134505204423, 7869.291763741255, 7914.84170316594, 7673.616319184032, 7791.961040194805, 7806.960965195166, 7824.687012519506, 7829.099653539844, 1909.6371689379043, 2249.6850440938283, 2263.7396699379533, 2272.4091736148557, 2318.675385446039, 2293.9885300573474, 2302.0906741836966, 2302.366849116498, 2303.0327262549768, 2305.0664480885184, 2220.3893929169526, 2294.231432470116, 2294.506681063571, 2295.8737269450176, 2297.8391512594126, 2249.1219831440685, 2279.8974046167964, 2295.9770402296012, 2317.9188728394593, 2318.2697450303267, 2287.874166920819, 2331.7551657075933, 2337.9532409351887, 2347.248880358286, 2348.7768661977084, 8109.472884262504, 8142.796430089236, 8153.103158652543, 8161.918380816234, 8162.959185204036, 4806.327114204014, 4926.75366231687, 4937.5556199942175, 4976.950230497685, 4981.800727970877, 2990.596269503633, 3079.1224501017327, 3123.2035830862983, 3128.0, 3128.2961333699964, 995.5868314649412, 1008.1581879130935, 1013.4881884648279, 1020.9438480883548, 1040.505759764106, 11515.712107197303, 11523.884761152365, 11647.242929209575, 11658.6502404928, 11664.35846028468, 4117.649999750055, 4245.214635292481, 4256.170046840836, 4286.314189729628, 4371.475422949203, 9578.233741300819, 9637.18083962871, 9637.903620963842, 9644.565994530123, 9646.565904534313, 4384.649228061748, 4920.261960705922, 4920.606351491872, 4953.653244272867, 4954.653174277838, 4159.459270294903, 4209.473815773028, 4209.684273679425, 4243.193793179286, 4255.829766809355, 3713.832877520518, 3778.1499162688174, 3785.8296376662565, 3801.467794508771, 3826.5408151021497, 1208.4259976511262, 1213.387239444075, 1213.696575856036, 1216.403962058585, 1231.378154032208, 1037.64719995202, 1057.1701214546545, 1067.4982758103679, 1241.3482921466302, 1376.7246550689902, 7790.883136752953, 7837.882431763528, 7882.172371900982, 7903.723369682033, 7909.960450197712, 459.32708581927636, 473.79389965365175, 475.2419890275006, 480.87737626904914, 481.1651784154489, 5883.382244864228, 5900.4984576310635, 5912.290525136925, 5918.171455996164, 5945.64326140433, 9469.289803264644, 10035.548400322003, 10175.0, 10181.847272290921, 10186.592536298465, 9923.1069203772, 9991.900080999098, 10027.09756121938, 10042.096211341015, 10102.848457273147, 7522.322990930843, 7773.961130194313, 7831.120531072615, 7863.33161681252, 7869.409794265453, 7267.382272506896, 7364.410847132323, 7419.703211871465, 7430.442716796154, 7482.812929676802, 8674.78313042179, 8833.69082082124, 8855.690050848189, 8991.370604057653, 9047.547622618711, 9009.504477253813, 9136.0, 9158.862617060882, 9222.861657075284, 9251.861222081809, 6396.136521569715, 6771.898421523582, 6889.345512176335, 7264.091988501437, 7320.597367144858, 7555.282248186413, 7656.157822639617, 7656.464047516621, 7661.923380766121, 7688.308052275322, 6779.322067793181, 6907.309269073053, 6964.930350696428, 7001.789946301619, 7153.213146553979, 6708.0, 6737.494687898329, 6747.392734653905, 6918.757843475454, 6982.022516847747, 7005.229424763374, 7008.159020917523, 7012.018317435461, 7357.043584334002, 7377.889331660137, 6640.0, 6661.0, 6674.599524028379, 6692.330766923269, 6710.060591517094, 6375.458086062737, 6592.80221593353, 6615.0, 6654.401103900672, 6655.73377064912], "unit": "score", "name": "mootools.html", "value": 4493.27648260741}, {"lowerIsBetter": false, "replicates": [310.66137909678474, 311.30734116590577, 312.55304913973026, 319.7042735469691, 329.4810673189725, 5891.55813314001, 5940.138679891418, 5965.850853728659, 5970.164177015221, 5982.371850955647, 5865.882682346361, 5882.176495290662, 5891.705414729267, 5900.1739756434135, 5901.645901245928, 4340.131973605284, 4366.08312254427, 4434.578715022084, 4458.0, 4458.063806600618, 4417.646588272931, 4451.799669014902, 4459.732416055031, 4462.754548499831, 4478.8880277992985, 4317.935230971538, 4419.116176764644, 4437.511873693891, 4443.178012067761, 4449.911001779962, 4390.824367025315, 4508.143452743984, 4512.187806194884, 4520.163769702583, 4526.954730452686, 3972.205558888205, 3977.920441591181, 3979.0, 3980.0845805464905, 3987.322155233617, 5579.581531385122, 5615.241942337773, 5617.606767526275, 5629.0, 5637.126245431965, 5266.420693723688, 5269.2886460327745, 5276.92084618731, 5280.10238259493, 5280.498352656491, 6211.161493198406, 6235.064740288947, 6236.6258024518675, 6241.28225254097, 6241.594296370767, 4172.70791044627, 4287.48550173978, 4292.399064131024, 4294.914101717979, 4432.468103827529, 6462.644554549545, 6499.870002599969, 6523.315051919575, 6525.1517302750335, 6532.7713530026695, 4367.45406824147, 4371.715838470489, 4374.715643483163, 4378.737275763465, 4383.035732138925, 4421.867343979686, 4433.600975912119, 4434.889127771767, 4440.822367105344, 4442.311441726538, 5119.692818430906, 5129.820456284012, 5156.020356132323, 5162.97418512905, 5173.327467429285, 6193.969030154911, 6270.7491700331475, 6295.087212354275, 6295.118683384329, 6303.842403939847, 1609.2999545197642, 1615.668787898478, 1617.4177296173368, 1627.5849658337286, 1629.8207197208299, 1017.1405162637559, 1068.391017120234, 1074.5003573338436, 1102.685734565661, 1114.3202646385698, 5822.272215973004, 5856.297244330707, 5887.1463637772285, 5893.5579831512805, 5895.20414744004, 6393.840153996187, 6398.712057957403, 6401.231852177769, 6405.711742971577, 6415.2037429519805, 5873.20711703923, 5875.823725288248, 5891.23413956183, 5891.528677705774, 5896.700286888117, 3454.7581669283413, 3480.164760457523, 3482.9825850870584, 3485.0938755923135, 3487.145649315934, 6544.509161812883, 6708.1950165979415, 6725.66371681414, 6727.899081513781, 6729.5625784323865, 6560.803175904731, 6582.769603063965, 6587.473002159816, 6601.405873471411, 6615.437687796495, 6675.465962723068, 6684.732610695518, 6685.298043705438, 6685.699143538553, 6689.163854518185, 6404.071409645669, 6408.487321014401, 6414.294427612866, 6417.294097649162, 6417.48660107181, 6266.780662676784, 6349.555531112777, 6373.3945275198785, 6379.553431259767, 6489.610623362613, 6799.898001529882, 6808.38724514796, 6813.523053386215, 6827.658617069226, 6829.4877884157895, 4340.891477713082, 4382.671299652603, 4384.408104905924, 4384.824607015684, 4386.824527019011, 6494.1232933553365, 6500.089987401673, 6505.739770409131, 6506.512011599054, 6518.674066296571, 6324.525660575383, 6330.873382532415, 6333.461655759312, 6342.460890824332, 6342.619442833445, 6166.784162554469, 6333.334999824952, 6333.65164915934, 6335.113084168128, 6339.904901426575, 6204.472619827366, 6208.0, 6220.471259942956, 6221.906671399842, 6223.439890409885, 6331.841703957438, 6342.365763423621, 6344.460720838596, 6346.4605508532295, 6349.7142628580905, 5982.222311099529, 6064.514838812973, 6212.720427580679, 6216.409441103088, 6223.533235007483], "unit": "score", "name": "prototype.html", "value": 4709.58543005227}, {"lowerIsBetter": false, "replicates": [748.4124961904906, 753.9170691223968, 760.3688938181308, 761.6648674583183, 768.8654485465046, 13938.303084845755, 14024.368903399347, 14044.15735055896, 14074.22591757453, 14146.64633384166, 12828.48686052559, 13026.0, 13045.282509461977, 13067.0, 13089.934550327234, 681.536555142503, 795.3398679096365, 807.9070906845715, 814.1288820961573, 817.23588444804, 810.1210186947169, 816.995915020424, 817.8732296494053, 818.8526065308242, 819.9672013119468, 842.4608250719514, 851.595492141231, 851.6508231625004, 852.4629483425464, 852.526847599582, 707.9964600177018, 837.3761547647011, 849.8045449546609, 863.5509535041806, 864.2696921101659, 638.6710843915341, 639.5331408072087, 639.8560323927126, 644.2655372874926, 645.0968643898533, 13296.202227866359, 13365.599032029055, 13384.933075334658, 13387.196768193842, 13387.263700496469, 12861.549845755353, 13100.213987160801, 13237.801432978513, 13316.201027938258, 13496.257705826176, 10589.36463812166, 10591.25861189717, 10605.204609654229, 10688.0, 10793.784124317548, 3593.8203089845665, 3608.350496910555, 3658.158623516606, 3705.2033812730124, 3732.794696291703, 48542.757286213695, 49360.50639493631, 49832.0, 49924.50075499235, 50062.49937500615, 10044.478129924102, 10177.18582513397, 10187.388756674623, 10197.541110650038, 10216.642417515352, 18799.15403806832, 18931.905340473484, 18942.81057189438, 18952.241910323708, 18992.715109273373, 7417.406607471389, 7502.399808015346, 7653.770386888402, 7654.655540500691, 7759.262870027338, 4358.5205627380965, 4428.800703968329, 4457.465104187519, 4496.0558282760985, 4637.884052898705, 3097.3340731742783, 3131.3267647455905, 3141.4659507883716, 3141.607299087614, 3155.921101972423, 556.5936866087698, 564.1594024902865, 599.3317451042057, 638.2755572425237, 640.9359064093553, 532.7602578839537, 551.9944800552023, 622.2719418280623, 657.2802780954847, 675.4393853101914, 7525.548467091882, 7618.123915749649, 7652.846943061219, 7822.647980840876, 7842.333401660922, 523.8428471458548, 562.0809975689776, 664.930182330858, 677.4681874728315, 687.295522089862, 3504.7196224301993, 3643.5263415756312, 3684.060564556021, 3701.592824789271, 3743.3074881147077, 55209.447905521236, 55732.72133639306, 56989.43010569924, 57104.0, 57156.42843571511, 47868.28197577039, 47884.0, 48100.51899481031, 48943.510564894605, 48975.51024489781, 45136.3229551557, 45775.542244577795, 46890.76554617273, 46959.0, 47015.76492117518, 7014.964925175545, 7196.316349946746, 7271.272872712898, 7336.853262934818, 7494.737684181027, 32455.0, 33228.50157247595, 33536.83231583826, 34766.82616586901, 34868.82565587156, 41158.0, 41953.370699440144, 42153.78923105365, 42653.0, 42937.0, 10893.694930770262, 11081.778364432828, 11098.112151028059, 11156.944215278872, 11701.707457313636, 12150.878491214975, 12402.627921162019, 12455.688607784878, 12536.247825130522, 12995.545155919497, 9931.106200441995, 11189.286088793211, 11444.256123351955, 12077.39613019328, 12350.320732359447, 11468.770624587629, 12077.456514456695, 12138.878611213775, 12282.01743860507, 12536.561220357244, 11552.249103808226, 11632.360220187971, 11874.46564904564, 11897.226680265756, 11978.10164237703, 9663.758406039906, 9783.75540611462, 10009.849852252077, 10154.74613134648, 10345.586176553155, 8617.267532259828, 8963.327750418614, 9424.434533927986, 9840.212782977202, 9957.950210248902], "unit": "score", "name": "yui.html", "value": 6269.094395540952}], "name": "dromaeo_css", "value": 6945.731385197506}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 106.0, 111.0, 113.0, 113.0, 100.0, 111.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.5}, {"lowerIsBetter": true, "replicates": [152.0, 124.0, 154.0, 169.0, 126.0, 147.0, 147.0, 125.0, 174.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 144.5}, {"lowerIsBetter": true, "replicates": [161.0, 159.0, 161.0, 159.0, 161.0, 158.0, 159.0, 162.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.2}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 93.0, 95.0, 73.0, 72.0, 73.0, 116.0, 96.0, 72.0], "unit": "score", "name": "audio-fft", "value": 83.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 141.0, 95.0, 96.0, 94.0, 148.0, 95.0, 96.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 110.2}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 115.0, 116.0, 114.0, 116.0, 115.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.5}, {"lowerIsBetter": true, "replicates": [146.0, 148.0, 145.0, 146.0, 148.0, 146.0, 145.0, 147.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 57.0, 56.0, 57.0, 57.0, 57.0, 65.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.9}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 69.0, 68.0, 67.0, 68.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 83.0, 82.0, 90.0, 83.0, 83.0, 83.0, 83.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [125.0, 121.0, 119.0, 115.0, 122.0, 118.0, 117.0, 118.0, 118.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.8}, {"lowerIsBetter": true, "replicates": [153.0, 140.0, 153.0, 149.0, 151.0, 142.0, 152.0, 161.0, 149.0, 151.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.1}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 70.0, 71.0, 69.0, 68.0, 82.0, 69.0, 70.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.5}], "name": "kraken", "value": 1514.1999999999998}]} 08:20:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1514.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6945.73"}}} 08:20:51 INFO - Return code: 0 08:20:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:20:51 INFO - # TBPL SUCCESS # 08:20:51 INFO - Running post-action listener: _resource_record_post_action 08:20:51 INFO - Running post-run listener: _resource_record_post_run 08:20:52 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 538177536; Read time: 20; Write time: 746580 08:20:52 INFO - install - Wall time: 17s; CPU: 17.0%; Read bytes: 0; Write bytes: 240787456; Read time: 0; Write time: 504456 08:20:52 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295972864; Read time: 20; Write time: 242060 08:20:52 INFO - Running post-run listener: _upload_blobber_files 08:20:52 INFO - Blob upload gear active. 08:20:52 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:20:52 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 08:20:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 08:20:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 08:20:52 INFO - (blobuploader) - INFO - Open directory for files ... 08:20:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:20:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:20:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:53 INFO - (blobuploader) - INFO - Done attempting. 08:20:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 08:20:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:20:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:54 INFO - (blobuploader) - INFO - Done attempting. 08:20:54 INFO - (blobuploader) - INFO - Iteration through files over. 08:20:54 INFO - Return code: 0 08:20:54 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:20:54 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:20:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82713d63ec4a7ed2cde9dd0c22bdff1fde7cde720aad1c11dc2b570fb09c93f72d77ef746920374bf0661920ee4e1c09e2c42b8873cfd10969d1fc75eaa455d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9870a3e8c2139d763689da5aa007e99d8208b47065ca0e85f174b4947c2f7e65ec6e1f70a7988e5027a8f3ab3c91912c1f38dfc0322edc359f07fe8e8d20ef76"} 08:20:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:20:54 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:20:54 INFO - Contents: 08:20:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82713d63ec4a7ed2cde9dd0c22bdff1fde7cde720aad1c11dc2b570fb09c93f72d77ef746920374bf0661920ee4e1c09e2c42b8873cfd10969d1fc75eaa455d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9870a3e8c2139d763689da5aa007e99d8208b47065ca0e85f174b4947c2f7e65ec6e1f70a7988e5027a8f3ab3c91912c1f38dfc0322edc359f07fe8e8d20ef76"} 08:20:54 INFO - Running post-run listener: copy_logs_to_upload_dir 08:20:54 INFO - Copying logs to upload dir... 08:20:54 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 08:20:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.375256 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-02-29 08:20:54.728139) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 08:20:54.732046) ========= 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=aa52b8aba932b19cc50b5275000001de-1456761388.332407-1175893989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82713d63ec4a7ed2cde9dd0c22bdff1fde7cde720aad1c11dc2b570fb09c93f72d77ef746920374bf0661920ee4e1c09e2c42b8873cfd10969d1fc75eaa455d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9870a3e8c2139d763689da5aa007e99d8208b47065ca0e85f174b4947c2f7e65ec6e1f70a7988e5027a8f3ab3c91912c1f38dfc0322edc359f07fe8e8d20ef76"} build_url:https://queue.taskcluster.net/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011209 build_url: 'https://queue.taskcluster.net/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82713d63ec4a7ed2cde9dd0c22bdff1fde7cde720aad1c11dc2b570fb09c93f72d77ef746920374bf0661920ee4e1c09e2c42b8873cfd10969d1fc75eaa455d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9870a3e8c2139d763689da5aa007e99d8208b47065ca0e85f174b4947c2f7e65ec6e1f70a7988e5027a8f3ab3c91912c1f38dfc0322edc359f07fe8e8d20ef76"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 08:20:54.756492) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 08:20:54.756819) ========= 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=aa52b8aba932b19cc50b5275000001de-1456761388.332407-1175893989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004561 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 08:20:54.842570) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 08:20:54.842883) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 08:20:54.843177) ========= ========= Total master_lag: 0.27 =========