builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-005 starttime: 1456620754.61 results: success (0) buildid: 20160227143004 builduid: 61336fa529d44bbe8553c3e790953f2c revision: a96f17e627e5b86e1d6d603e10751edb37d1601d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-27 16:52:34.605500) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-27 16:52:34.605865) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-27 16:52:34.606173) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1456618433.889777-1847586165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.009298 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-27 16:52:34.630688) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-27 16:52:34.630958) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-27 16:52:34.643717) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 16:52:34.644007) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1456618433.889777-1847586165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004604 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 16:52:34.692665) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-27 16:52:34.693299) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-27 16:52:34.693694) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 16:52:34.693983) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1456618433.889777-1847586165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-27 16:52:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 228M=0s 2016-02-27 16:52:35 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099167 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 16:52:34.808571) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 16:52:34.808903) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1456618433.889777-1847586165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017743 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 16:52:34.858732) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 16:52:34.859184) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a96f17e627e5b86e1d6d603e10751edb37d1601d --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 a96f17e627e5b86e1d6d603e10751edb37d1601d --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=7fc86f70bae03e018da0b1d8000001c4-1456618433.889777-1847586165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-27 16:52:35,183 truncating revision to first 12 chars 2016-02-27 16:52:35,183 Setting DEBUG logging. 2016-02-27 16:52:35,183 attempt 1/10 2016-02-27 16:52:35,183 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a96f17e627e5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-27 16:52:35,433 unpacking tar archive at: fx-team-a96f17e627e5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.542467 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 16:52:35.414602) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-27 16:52:35.414929) ========= echo a96f17e627e5b86e1d6d603e10751edb37d1601d in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a96f17e627e5b86e1d6d603e10751edb37d1601d'] 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=7fc86f70bae03e018da0b1d8000001c4-1456618433.889777-1847586165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False a96f17e627e5b86e1d6d603e10751edb37d1601d program finished with exit code 0 elapsedTime=0.004642 script_repo_revision: 'a96f17e627e5b86e1d6d603e10751edb37d1601d' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-27 16:52:35.465781) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-27 16:52:35.466078) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-27 16:52:35.475486) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-02-27 16:52:35.475759) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1456618433.889777-1847586165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:52:35 INFO - MultiFileLogger online at 20160227 16:52:35 in /builds/slave/test-pgo 16:52:35 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 16:52:35 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:52:35 INFO - {'append_to_log': False, 16:52:35 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:52:35 INFO - 'blob_upload_branch': 'Fx-Team', 16:52:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:52:35 INFO - 'branch': 'Fx-Team', 16:52:35 INFO - 'buildbot_json_path': 'buildprops.json', 16:52:35 INFO - 'config_files': ('talos/linux_config.py',), 16:52:35 INFO - 'default_actions': ('clobber', 16:52:35 INFO - 'read-buildbot-config', 16:52:35 INFO - 'download-and-extract', 16:52:35 INFO - 'populate-webroot', 16:52:35 INFO - 'create-virtualenv', 16:52:35 INFO - 'install', 16:52:35 INFO - 'run-tests'), 16:52:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:52:35 INFO - 'download_minidump_stackwalk': True, 16:52:35 INFO - 'download_symbols': 'ondemand', 16:52:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:52:35 INFO - 'tooltool.py': '/tools/tooltool.py', 16:52:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:52:35 INFO - '/tools/misc-python/virtualenv.py')}, 16:52:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:52:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:52:35 INFO - 'installer_path': 'installer.exe', 16:52:35 INFO - 'log_level': 'info', 16:52:35 INFO - 'log_name': 'talos', 16:52:35 INFO - 'log_to_console': True, 16:52:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:52:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:52:35 INFO - 'opt_config_files': (), 16:52:35 INFO - 'pip_index': False, 16:52:35 INFO - 'sps_profile': False, 16:52:35 INFO - 'sps_profile_interval': 0, 16:52:35 INFO - 'suite': 'dromaeojs', 16:52:35 INFO - 'system_bits': '32', 16:52:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:52:35 INFO - 'title': 'talos-linux64-ix-005', 16:52:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:52:35 INFO - 'use_talos_json': True, 16:52:35 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:52:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:52:35 INFO - 'work_dir': 'build'} 16:52:35 INFO - ##### 16:52:35 INFO - ##### Running clobber step. 16:52:35 INFO - ##### 16:52:35 INFO - Running pre-action listener: _resource_record_pre_action 16:52:35 INFO - Running main action method: clobber 16:52:35 INFO - rmtree: /builds/slave/test-pgo/build 16:52:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:52:36 INFO - Running post-action listener: _resource_record_post_action 16:52:36 INFO - ##### 16:52:36 INFO - ##### Running read-buildbot-config step. 16:52:36 INFO - ##### 16:52:36 INFO - Running pre-action listener: _resource_record_pre_action 16:52:36 INFO - Running main action method: read_buildbot_config 16:52:36 INFO - Using buildbot properties: 16:52:36 INFO - { 16:52:36 INFO - "project": "", 16:52:36 INFO - "product": "firefox", 16:52:36 INFO - "script_repo_revision": "production", 16:52:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:52:36 INFO - "repository": "", 16:52:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 16:52:36 INFO - "buildid": "20160227143004", 16:52:36 INFO - "pgo_build": "True", 16:52:36 INFO - "basedir": "/builds/slave/test-pgo", 16:52:36 INFO - "buildnumber": 682, 16:52:36 INFO - "slavename": "talos-linux64-ix-005", 16:52:36 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:52:36 INFO - "platform": "ubuntu64_hw", 16:52:36 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 16:52:36 INFO - "branch": "fx-team", 16:52:36 INFO - "repo_path": "integration/fx-team", 16:52:36 INFO - "revision": "a96f17e627e5b86e1d6d603e10751edb37d1601d", 16:52:36 INFO - "stage_platform": "linux64-pgo", 16:52:36 INFO - "builduid": "61336fa529d44bbe8553c3e790953f2c", 16:52:36 INFO - "slavebuilddir": "test" 16:52:36 INFO - } 16:52:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/I2fdZ7toTSmvX3IV9wZzSQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 16:52:36 INFO - Running post-action listener: _resource_record_post_action 16:52:36 INFO - ##### 16:52:36 INFO - ##### Running download-and-extract step. 16:52:36 INFO - ##### 16:52:36 INFO - Running pre-action listener: _resource_record_pre_action 16:52:36 INFO - Running main action method: download_and_extract 16:52:36 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:36 INFO - https://queue.taskcluster.net/v1/task/I2fdZ7toTSmvX3IV9wZzSQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:52:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2fdZ7toTSmvX3IV9wZzSQ/artifacts/public/build/test_packages.json 16:52:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2fdZ7toTSmvX3IV9wZzSQ/artifacts/public/build/test_packages.json 16:52:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2fdZ7toTSmvX3IV9wZzSQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:52:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2fdZ7toTSmvX3IV9wZzSQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:52:38 INFO - Downloaded 1448 bytes. 16:52:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:52:38 INFO - Using the following test package requirements: 16:52:38 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 16:52:38 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:52:38 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:52:38 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:38 INFO - u'jsshell-linux-x86_64.zip'], 16:52:38 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:52:38 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 16:52:38 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:52:38 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:52:38 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:52:38 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 16:52:38 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:52:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:52:38 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:52: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')]} 16:52:38 INFO - https://queue.taskcluster.net/v1/task/I2fdZ7toTSmvX3IV9wZzSQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:52:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2fdZ7toTSmvX3IV9wZzSQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:52:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2fdZ7toTSmvX3IV9wZzSQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:52:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2fdZ7toTSmvX3IV9wZzSQ/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 16:52:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2fdZ7toTSmvX3IV9wZzSQ/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 16:52:39 INFO - Downloaded 23371646 bytes. 16:52:39 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'] 16:52:39 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 16:52:40 INFO - Return code: 0 16:52:40 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 16:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:40 INFO - https://queue.taskcluster.net/v1/task/I2fdZ7toTSmvX3IV9wZzSQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:52:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2fdZ7toTSmvX3IV9wZzSQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:52:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2fdZ7toTSmvX3IV9wZzSQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:52:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2fdZ7toTSmvX3IV9wZzSQ/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 16:52:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2fdZ7toTSmvX3IV9wZzSQ/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 16:52:44 INFO - Downloaded 23371646 bytes. 16:52:44 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'] 16:52:44 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 16:52:46 INFO - Return code: 0 16:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:46 INFO - https://queue.taskcluster.net/v1/task/I2fdZ7toTSmvX3IV9wZzSQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:52:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2fdZ7toTSmvX3IV9wZzSQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 16:52:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2fdZ7toTSmvX3IV9wZzSQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 16:52:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2fdZ7toTSmvX3IV9wZzSQ/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 16:52:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2fdZ7toTSmvX3IV9wZzSQ/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 16:52:47 INFO - Downloaded 10713410 bytes. 16:52:47 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'] 16:52:47 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 16:52:47 INFO - Return code: 0 16:52: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')]} 16:52:47 INFO - https://queue.taskcluster.net/v1/task/I2fdZ7toTSmvX3IV9wZzSQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:52:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2fdZ7toTSmvX3IV9wZzSQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:52:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2fdZ7toTSmvX3IV9wZzSQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:52:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2fdZ7toTSmvX3IV9wZzSQ/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 16:52:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2fdZ7toTSmvX3IV9wZzSQ/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 16:52:49 INFO - Downloaded 56628483 bytes. 16:52:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I2fdZ7toTSmvX3IV9wZzSQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:52:49 INFO - mkdir: /builds/slave/test-pgo/properties 16:52:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:52:49 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:52:49 INFO - Contents: 16:52:49 INFO - build_url:https://queue.taskcluster.net/v1/task/I2fdZ7toTSmvX3IV9wZzSQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:52:49 INFO - Running post-action listener: _resource_record_post_action 16:52:49 INFO - Running post-action listener: set_extra_try_arguments 16:52:49 INFO - ##### 16:52:49 INFO - ##### Running populate-webroot step. 16:52:49 INFO - ##### 16:52:49 INFO - Running pre-action listener: _resource_record_pre_action 16:52:49 INFO - Running main action method: populate_webroot 16:52:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:52:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:52:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:52:49 INFO - '--tppagecycles', 16:52:49 INFO - '7'], 16:52:49 INFO - 'tests': ['tsvgm']}}, 16:52:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:52:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:52:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:52:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:52:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:52:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:52:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:52:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:49 INFO - 'talos_options': ['--e10s'], 16:52:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:52:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:49 INFO - 'tests': ['damp', 'tps']}, 16:52:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:49 INFO - 'talos_options': ['--e10s'], 16:52:49 INFO - 'tests': ['damp', 'tps']}, 16:52:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:52:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:52:49 INFO - 'other': {'tests': ['a11yr', 16:52:49 INFO - 'ts_paint', 16:52:49 INFO - 'tpaint', 16:52:49 INFO - 'sessionrestore', 16:52:49 INFO - 'sessionrestore_no_auto_restore']}, 16:52:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:52:49 INFO - 'tests': ['a11yr', 16:52:49 INFO - 'ts_paint', 16:52:49 INFO - 'tpaint', 16:52:49 INFO - 'sessionrestore', 16:52:49 INFO - 'sessionrestore_no_auto_restore']}, 16:52:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:52:49 INFO - 'tests': ['a11yr', 16:52:49 INFO - 'ts_paint', 16:52:49 INFO - 'tpaint', 16:52:49 INFO - 'sessionrestore', 16:52:49 INFO - 'sessionrestore_no_auto_restore']}, 16:52:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:52:49 INFO - 'tests': ['a11yr', 16:52:49 INFO - 'ts_paint', 16:52:49 INFO - 'tpaint', 16:52:49 INFO - 'sessionrestore', 16:52:49 INFO - 'sessionrestore_no_auto_restore']}, 16:52:49 INFO - 'other_l64': {'tests': ['a11yr', 16:52:49 INFO - 'ts_paint', 16:52:49 INFO - 'tpaint', 16:52:49 INFO - 'sessionrestore', 16:52:49 INFO - 'sessionrestore_no_auto_restore']}, 16:52:49 INFO - 'other_nol64': {'tests': ['a11yr', 16:52:49 INFO - 'ts_paint', 16:52:49 INFO - 'tpaint', 16:52:49 INFO - 'sessionrestore', 16:52:49 INFO - 'sessionrestore_no_auto_restore']}, 16:52:49 INFO - 'svgr': {'tests': ['tsvgx', 16:52:49 INFO - 'tsvgr_opacity', 16:52:49 INFO - 'tart', 16:52:49 INFO - 'tscrollx', 16:52:49 INFO - 'cart']}, 16:52:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:52:49 INFO - 'tests': ['tsvgx', 16:52:49 INFO - 'tsvgr_opacity', 16:52:49 INFO - 'tart', 16:52:49 INFO - 'tscrollx', 16:52:49 INFO - 'cart']}, 16:52:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:49 INFO - 'tests': ['tp5o']}, 16:52:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:49 INFO - 'talos_options': ['--e10s'], 16:52:49 INFO - 'tests': ['tp5o']}, 16:52:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:49 INFO - 'talos_options': ['--xperf_path', 16:52:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:52:49 INFO - 'tests': ['tp5n']}, 16:52:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:52:49 INFO - 'talos_options': ['--e10s', 16:52:49 INFO - '--xperf_path', 16:52:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:52:49 INFO - 'tests': ['tp5n']}}, 16:52:49 INFO - 'talos.zip': {'path': '', 16:52:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:52:49 INFO - Running post-action listener: _resource_record_post_action 16:52:49 INFO - ##### 16:52:49 INFO - ##### Running create-virtualenv step. 16:52:49 INFO - ##### 16:52:49 INFO - Running pre-action listener: _resource_record_pre_action 16:52:49 INFO - Running main action method: create_virtualenv 16:52:49 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:52:49 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 16:52:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:52:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:52:50 INFO - Using real prefix '/usr' 16:52:50 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:52:50 INFO - Installing distribute.............................................................................................................................................................................................done. 16:52:52 INFO - Installing pip.................done. 16:52:52 INFO - Return code: 0 16:52:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:52:52 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')]} 16:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:52 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')]} 16:52:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:52 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 0x7ff4d9e00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ce670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145d8c0>, '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 0x145e7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145ec50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1456618433.889777-1847586165', '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 16:52:52 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 16:52:52 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 16:52:52 INFO - Using env: {'DISPLAY': ':0', 16:52:52 INFO - 'HOME': '/home/cltbld', 16:52:52 INFO - 'LANG': 'en_US.UTF-8', 16:52:52 INFO - 'LANGUAGE': 'en_US:en', 16:52:52 INFO - 'LOGNAME': 'cltbld', 16:52:52 INFO - 'MAIL': '/var/mail/cltbld', 16:52:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:52 INFO - 'MOZ_NO_REMOTE': '1', 16:52:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:52 INFO - 'NO_EM_RESTART': '1', 16:52:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:52:52 INFO - 'PWD': '/builds/slave/test-pgo', 16:52:52 INFO - 'SHELL': '/bin/bash', 16:52:52 INFO - 'SHLVL': '1', 16:52:52 INFO - 'TERM': 'linux', 16:52:52 INFO - 'TMOUT': '86400', 16:52:52 INFO - 'USER': 'cltbld', 16:52:52 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1456618433.889777-1847586165', 16:52:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:52 INFO - '_': '/tools/buildbot/bin/python'} 16:52:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:52 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 16:52:52 INFO - Cleaning up... 16:52:52 INFO - Return code: 0 16:52:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:52:52 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')]} 16:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:52 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')]} 16:52:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:52 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 0x7ff4d9e00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ce670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145d8c0>, '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 0x145e7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145ec50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1456618433.889777-1847586165', '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 16:52:52 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 16:52:52 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 16:52:52 INFO - Using env: {'DISPLAY': ':0', 16:52:52 INFO - 'HOME': '/home/cltbld', 16:52:52 INFO - 'LANG': 'en_US.UTF-8', 16:52:52 INFO - 'LANGUAGE': 'en_US:en', 16:52:52 INFO - 'LOGNAME': 'cltbld', 16:52:52 INFO - 'MAIL': '/var/mail/cltbld', 16:52:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:52 INFO - 'MOZ_NO_REMOTE': '1', 16:52:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:52 INFO - 'NO_EM_RESTART': '1', 16:52:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:52:52 INFO - 'PWD': '/builds/slave/test-pgo', 16:52:52 INFO - 'SHELL': '/bin/bash', 16:52:52 INFO - 'SHLVL': '1', 16:52:52 INFO - 'TERM': 'linux', 16:52:52 INFO - 'TMOUT': '86400', 16:52:52 INFO - 'USER': 'cltbld', 16:52:52 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1456618433.889777-1847586165', 16:52:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:52 INFO - '_': '/tools/buildbot/bin/python'} 16:52:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:52 INFO - Downloading/unpacking psutil>=0.7.1 16:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:52:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:52:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:52:54 INFO - Installing collected packages: psutil 16:52:54 INFO - Running setup.py install for psutil 16:52:54 INFO - building 'psutil._psutil_linux' extension 16:52:54 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 16:52:55 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 16:52:55 INFO - building 'psutil._psutil_posix' extension 16:52:55 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 16:52:55 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 16:52:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:52:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:52:55 INFO - Successfully installed psutil 16:52:55 INFO - Cleaning up... 16:52:55 INFO - Return code: 0 16:52:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:55 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 0x7ff4d9e00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ce670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145d8c0>, '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 0x145e7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145ec50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1456618433.889777-1847586165', '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 16:52:55 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 16:52:55 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 16:52:55 INFO - Using env: {'DISPLAY': ':0', 16:52:55 INFO - 'HOME': '/home/cltbld', 16:52:55 INFO - 'LANG': 'en_US.UTF-8', 16:52:55 INFO - 'LANGUAGE': 'en_US:en', 16:52:55 INFO - 'LOGNAME': 'cltbld', 16:52:55 INFO - 'MAIL': '/var/mail/cltbld', 16:52:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:55 INFO - 'MOZ_NO_REMOTE': '1', 16:52:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:55 INFO - 'NO_EM_RESTART': '1', 16:52:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:52:55 INFO - 'PWD': '/builds/slave/test-pgo', 16:52:55 INFO - 'SHELL': '/bin/bash', 16:52:55 INFO - 'SHLVL': '1', 16:52:55 INFO - 'TERM': 'linux', 16:52:55 INFO - 'TMOUT': '86400', 16:52:55 INFO - 'USER': 'cltbld', 16:52:55 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1456618433.889777-1847586165', 16:52:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:55 INFO - '_': '/tools/buildbot/bin/python'} 16:52:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:52:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:52:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:52:57 INFO - Installing collected packages: mozsystemmonitor 16:52:57 INFO - Running setup.py install for mozsystemmonitor 16:52:57 INFO - Successfully installed mozsystemmonitor 16:52:57 INFO - Cleaning up... 16:52:57 INFO - Return code: 0 16:52:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:52:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:52:57 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 0x7ff4d9e00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ce670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145d8c0>, '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 0x145e7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145ec50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1456618433.889777-1847586165', '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 16:52:57 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 16:52:57 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 16:52:57 INFO - Using env: {'DISPLAY': ':0', 16:52:57 INFO - 'HOME': '/home/cltbld', 16:52:57 INFO - 'LANG': 'en_US.UTF-8', 16:52:57 INFO - 'LANGUAGE': 'en_US:en', 16:52:57 INFO - 'LOGNAME': 'cltbld', 16:52:57 INFO - 'MAIL': '/var/mail/cltbld', 16:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:57 INFO - 'MOZ_NO_REMOTE': '1', 16:52:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:57 INFO - 'NO_EM_RESTART': '1', 16:52:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:52:57 INFO - 'PWD': '/builds/slave/test-pgo', 16:52:57 INFO - 'SHELL': '/bin/bash', 16:52:57 INFO - 'SHLVL': '1', 16:52:57 INFO - 'TERM': 'linux', 16:52:57 INFO - 'TMOUT': '86400', 16:52:57 INFO - 'USER': 'cltbld', 16:52:57 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1456618433.889777-1847586165', 16:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:57 INFO - '_': '/tools/buildbot/bin/python'} 16:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:57 INFO - Downloading/unpacking blobuploader==1.2.4 16:52: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 16:52: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 16:52: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 16:52: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 16:52: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 16:52: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 16:52:59 INFO - Downloading blobuploader-1.2.4.tar.gz 16:52:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:52:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:52: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 16:52: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 16:52: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 16:52: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 16:52: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 16:52: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 16:52:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:53:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:53:00 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 16:53:00 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 16:53:00 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 16:53:00 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 16:53:00 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 16:53:00 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 16:53:00 INFO - Downloading docopt-0.6.1.tar.gz 16:53:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:53:00 INFO - Installing collected packages: blobuploader, requests, docopt 16:53:00 INFO - Running setup.py install for blobuploader 16:53:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:53:00 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:53:00 INFO - Running setup.py install for requests 16:53:00 INFO - Running setup.py install for docopt 16:53:00 INFO - Successfully installed blobuploader requests docopt 16:53:00 INFO - Cleaning up... 16:53:00 INFO - Return code: 0 16:53:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:53:00 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')]} 16:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:00 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')]} 16:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:00 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 0x7ff4d9e00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ce670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145d8c0>, '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 0x145e7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145ec50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1456618433.889777-1847586165', '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 16:53:00 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 16:53:00 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 16:53:00 INFO - Using env: {'DISPLAY': ':0', 16:53:00 INFO - 'HOME': '/home/cltbld', 16:53:00 INFO - 'LANG': 'en_US.UTF-8', 16:53:00 INFO - 'LANGUAGE': 'en_US:en', 16:53:00 INFO - 'LOGNAME': 'cltbld', 16:53:00 INFO - 'MAIL': '/var/mail/cltbld', 16:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:00 INFO - 'MOZ_NO_REMOTE': '1', 16:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:00 INFO - 'NO_EM_RESTART': '1', 16:53:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:53:00 INFO - 'PWD': '/builds/slave/test-pgo', 16:53:00 INFO - 'SHELL': '/bin/bash', 16:53:00 INFO - 'SHLVL': '1', 16:53:00 INFO - 'TERM': 'linux', 16:53:00 INFO - 'TMOUT': '86400', 16:53:00 INFO - 'USER': 'cltbld', 16:53:00 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1456618433.889777-1847586165', 16:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:00 INFO - '_': '/tools/buildbot/bin/python'} 16:53:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:53:01 INFO - Running setup.py (path:/tmp/pip-WyQV4g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:53:01 INFO - Running setup.py (path:/tmp/pip-S7K0_6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:53:01 INFO - Running setup.py (path:/tmp/pip-YHIKuA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:53:01 INFO - Running setup.py (path:/tmp/pip-7KIN1N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:53:01 INFO - Running setup.py (path:/tmp/pip-B1hp_P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:53:01 INFO - Running setup.py (path:/tmp/pip-AV5WRv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:53:01 INFO - Running setup.py (path:/tmp/pip-BnO_2w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:53:01 INFO - Running setup.py (path:/tmp/pip-HxJtpg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:53:01 INFO - Running setup.py (path:/tmp/pip-FOzVe2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:53:01 INFO - Running setup.py (path:/tmp/pip-QHhWCQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:53:01 INFO - Running setup.py (path:/tmp/pip-ZvvKid-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:53:01 INFO - Running setup.py (path:/tmp/pip-e4HYzw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:53:02 INFO - Running setup.py (path:/tmp/pip-9HLIj9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:53:02 INFO - Running setup.py (path:/tmp/pip-KfxT9Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:53:02 INFO - Running setup.py (path:/tmp/pip-M2IjLM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:53:02 INFO - Running setup.py (path:/tmp/pip-sYXhwK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:53:02 INFO - Running setup.py (path:/tmp/pip-NjxRmj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:53:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:53:02 INFO - Running setup.py install for manifestparser 16:53:02 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:53:02 INFO - Running setup.py install for mozcrash 16:53:02 INFO - Running setup.py install for mozdebug 16:53:02 INFO - Running setup.py install for mozdevice 16:53:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:53:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:53:02 INFO - Running setup.py install for mozfile 16:53:02 INFO - Running setup.py install for mozhttpd 16:53:03 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:53:03 INFO - Running setup.py install for mozinfo 16:53:03 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:53:03 INFO - Running setup.py install for mozInstall 16:53:03 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:53:03 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:53:03 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:53:03 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:53:03 INFO - Running setup.py install for mozleak 16:53:03 INFO - Running setup.py install for mozlog 16:53:03 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:53:03 INFO - Running setup.py install for moznetwork 16:53:03 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:53:03 INFO - Running setup.py install for mozprocess 16:53:03 INFO - Running setup.py install for mozprofile 16:53:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:53:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:53:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:53:03 INFO - Running setup.py install for mozrunner 16:53:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:53:03 INFO - Running setup.py install for mozscreenshot 16:53:03 INFO - Running setup.py install for moztest 16:53:04 INFO - Running setup.py install for mozversion 16:53:04 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:53:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:53:04 INFO - Cleaning up... 16:53:04 INFO - Return code: 0 16:53:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:53:04 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')]} 16:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:04 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')]} 16:53:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:04 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 0x7ff4d9e00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ce670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145d8c0>, '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 0x145e7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145ec50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1456618433.889777-1847586165', '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 16:53:04 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 16:53:04 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 16:53:04 INFO - Using env: {'DISPLAY': ':0', 16:53:04 INFO - 'HOME': '/home/cltbld', 16:53:04 INFO - 'LANG': 'en_US.UTF-8', 16:53:04 INFO - 'LANGUAGE': 'en_US:en', 16:53:04 INFO - 'LOGNAME': 'cltbld', 16:53:04 INFO - 'MAIL': '/var/mail/cltbld', 16:53:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:04 INFO - 'MOZ_NO_REMOTE': '1', 16:53:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:04 INFO - 'NO_EM_RESTART': '1', 16:53:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:53:04 INFO - 'PWD': '/builds/slave/test-pgo', 16:53:04 INFO - 'SHELL': '/bin/bash', 16:53:04 INFO - 'SHLVL': '1', 16:53:04 INFO - 'TERM': 'linux', 16:53:04 INFO - 'TMOUT': '86400', 16:53:04 INFO - 'USER': 'cltbld', 16:53:04 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1456618433.889777-1847586165', 16:53:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:04 INFO - '_': '/tools/buildbot/bin/python'} 16:53:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:53:04 INFO - Running setup.py (path:/tmp/pip-iajz3S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:53:04 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)) 16:53:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:53:04 INFO - Running setup.py (path:/tmp/pip-cVu3AE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:53:04 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)) 16:53:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:53:04 INFO - Running setup.py (path:/tmp/pip-s4Ir4a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:53:04 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)) 16:53:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:53:04 INFO - Running setup.py (path:/tmp/pip-Ufd44C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:53:04 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)) 16:53:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:53:04 INFO - Running setup.py (path:/tmp/pip-zGQYaj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:53:04 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)) 16:53:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:53:04 INFO - Running setup.py (path:/tmp/pip-S7twz1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:53:04 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)) 16:53:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:53:04 INFO - Running setup.py (path:/tmp/pip-A4beWk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:53:04 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)) 16:53:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:53:04 INFO - Running setup.py (path:/tmp/pip-El9_59-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:53:04 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)) 16:53:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:53:04 INFO - Running setup.py (path:/tmp/pip-Rj96sY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:53:05 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)) 16:53:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:53:05 INFO - Running setup.py (path:/tmp/pip-vRhMeX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:53:05 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)) 16:53:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:53:05 INFO - Running setup.py (path:/tmp/pip-kJ25kU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:53:05 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)) 16:53:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:53:05 INFO - Running setup.py (path:/tmp/pip-yUhQLr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:53:05 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)) 16:53:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:53:05 INFO - Running setup.py (path:/tmp/pip-komEKP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:53:05 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)) 16:53:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:53:05 INFO - Running setup.py (path:/tmp/pip-D1Tpcs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:53:05 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)) 16:53:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:53:05 INFO - Running setup.py (path:/tmp/pip-yUMZr_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:53:05 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)) 16:53:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:53:05 INFO - Running setup.py (path:/tmp/pip-4ftAI8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:53:05 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)) 16:53:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:53:05 INFO - Running setup.py (path:/tmp/pip-B7FqT8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:53:05 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)) 16:53:05 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)) 16:53:05 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)) 16:53:05 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)) 16:53:05 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)) 16:53:05 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)) 16:53:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:53:05 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 16:53:05 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 16:53:05 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 16:53:05 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 16:53:05 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 16:53:05 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 16:53:07 INFO - Downloading blessings-1.6.tar.gz 16:53:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:53:07 INFO - Installing collected packages: blessings 16:53:07 INFO - Running setup.py install for blessings 16:53:07 INFO - Successfully installed blessings 16:53:07 INFO - Cleaning up... 16:53:07 INFO - Return code: 0 16:53:07 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:53:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:53:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:53:07 INFO - Reading from file tmpfile_stdout 16:53:07 INFO - Current package versions: 16:53:07 INFO - argparse == 1.2.1 16:53:07 INFO - blessings == 1.6 16:53:07 INFO - blobuploader == 1.2.4 16:53:07 INFO - docopt == 0.6.1 16:53:07 INFO - manifestparser == 1.1 16:53:07 INFO - mozInstall == 1.12 16:53:07 INFO - mozcrash == 0.16 16:53:07 INFO - mozdebug == 0.1 16:53:07 INFO - mozdevice == 0.48 16:53:07 INFO - mozfile == 1.2 16:53:07 INFO - mozhttpd == 0.7 16:53:07 INFO - mozinfo == 0.9 16:53:07 INFO - mozleak == 0.1 16:53:07 INFO - mozlog == 3.1 16:53:07 INFO - moznetwork == 0.27 16:53:07 INFO - mozprocess == 0.22 16:53:07 INFO - mozprofile == 0.28 16:53:07 INFO - mozrunner == 6.11 16:53:07 INFO - mozscreenshot == 0.1 16:53:07 INFO - mozsystemmonitor == 0.0 16:53:07 INFO - moztest == 0.7 16:53:07 INFO - mozversion == 1.4 16:53:07 INFO - psutil == 3.1.1 16:53:07 INFO - requests == 1.2.3 16:53:07 INFO - wsgiref == 0.1.2 16:53:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:53:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:07 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 0x7ff4d9e00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ce670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145d8c0>, '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 0x145e7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145ec50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1456618433.889777-1847586165', '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 16:53:07 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 16:53:07 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 16:53:07 INFO - Using env: {'DISPLAY': ':0', 16:53:07 INFO - 'HOME': '/home/cltbld', 16:53:07 INFO - 'LANG': 'en_US.UTF-8', 16:53:07 INFO - 'LANGUAGE': 'en_US:en', 16:53:07 INFO - 'LOGNAME': 'cltbld', 16:53:07 INFO - 'MAIL': '/var/mail/cltbld', 16:53:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:07 INFO - 'MOZ_NO_REMOTE': '1', 16:53:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:07 INFO - 'NO_EM_RESTART': '1', 16:53:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:53:07 INFO - 'PWD': '/builds/slave/test-pgo', 16:53:07 INFO - 'SHELL': '/bin/bash', 16:53:07 INFO - 'SHLVL': '1', 16:53:07 INFO - 'TERM': 'linux', 16:53:07 INFO - 'TMOUT': '86400', 16:53:07 INFO - 'USER': 'cltbld', 16:53:07 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1456618433.889777-1847586165', 16:53:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:07 INFO - '_': '/tools/buildbot/bin/python'} 16:53:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:08 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)) 16:53:08 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)) 16:53:08 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)) 16:53:08 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)) 16:53:08 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)) 16:53:08 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)) 16:53:08 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)) 16:53:08 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)) 16:53:08 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)) 16:53:08 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)) 16:53:08 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)) 16:53:08 INFO - Cleaning up... 16:53:08 INFO - Return code: 0 16:53:08 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:08 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 0x7ff4d9e00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ce670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145d8c0>, '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 0x145e7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145ec50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1456618433.889777-1847586165', '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 16:53:08 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 16:53:08 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 16:53:08 INFO - Using env: {'DISPLAY': ':0', 16:53:08 INFO - 'HOME': '/home/cltbld', 16:53:08 INFO - 'LANG': 'en_US.UTF-8', 16:53:08 INFO - 'LANGUAGE': 'en_US:en', 16:53:08 INFO - 'LOGNAME': 'cltbld', 16:53:08 INFO - 'MAIL': '/var/mail/cltbld', 16:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:08 INFO - 'MOZ_NO_REMOTE': '1', 16:53:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:08 INFO - 'NO_EM_RESTART': '1', 16:53:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:53:08 INFO - 'PWD': '/builds/slave/test-pgo', 16:53:08 INFO - 'SHELL': '/bin/bash', 16:53:08 INFO - 'SHLVL': '1', 16:53:08 INFO - 'TERM': 'linux', 16:53:08 INFO - 'TMOUT': '86400', 16:53:08 INFO - 'USER': 'cltbld', 16:53:08 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1456618433.889777-1847586165', 16:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:08 INFO - '_': '/tools/buildbot/bin/python'} 16:53:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:08 INFO - Downloading/unpacking jsonschema 16:53:08 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 16:53:08 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 16:53:08 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 16:53:08 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 16:53:08 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 16:53:08 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 16:53:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:53:10 INFO - Downloading/unpacking functools32 (from jsonschema) 16:53:10 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 16:53:10 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 16:53:10 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 16:53:10 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 16:53:10 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 16:53:10 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 16:53:10 INFO - Downloading functools32-3.2.3-2.tar.gz 16:53:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:53:10 INFO - warning: no files found matching '*.txt' 16:53:10 INFO - no previously-included directories found matching 'build' 16:53:10 INFO - no previously-included directories found matching 'dist' 16:53:10 INFO - no previously-included directories found matching '.git*' 16:53:10 INFO - Installing collected packages: jsonschema, functools32 16:53:10 INFO - Running setup.py install for functools32 16:53:10 INFO - warning: no files found matching '*.txt' 16:53:10 INFO - no previously-included directories found matching 'build' 16:53:10 INFO - no previously-included directories found matching 'dist' 16:53:10 INFO - no previously-included directories found matching '.git*' 16:53:10 INFO - Successfully installed jsonschema functools32 16:53:10 INFO - Cleaning up... 16:53:10 INFO - Return code: 0 16:53:10 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:53:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:10 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 0x7ff4d9e00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ce670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145d8c0>, '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 0x145e7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145ec50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1456618433.889777-1847586165', '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 16:53:10 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 16:53:10 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 16:53:10 INFO - Using env: {'DISPLAY': ':0', 16:53:10 INFO - 'HOME': '/home/cltbld', 16:53:10 INFO - 'LANG': 'en_US.UTF-8', 16:53:10 INFO - 'LANGUAGE': 'en_US:en', 16:53:10 INFO - 'LOGNAME': 'cltbld', 16:53:10 INFO - 'MAIL': '/var/mail/cltbld', 16:53:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:10 INFO - 'MOZ_NO_REMOTE': '1', 16:53:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:10 INFO - 'NO_EM_RESTART': '1', 16:53:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:53:10 INFO - 'PWD': '/builds/slave/test-pgo', 16:53:10 INFO - 'SHELL': '/bin/bash', 16:53:10 INFO - 'SHLVL': '1', 16:53:10 INFO - 'TERM': 'linux', 16:53:10 INFO - 'TMOUT': '86400', 16:53:10 INFO - 'USER': 'cltbld', 16:53:10 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1456618433.889777-1847586165', 16:53:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:10 INFO - '_': '/tools/buildbot/bin/python'} 16:53:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:10 INFO - Downloading/unpacking flake8 16:53:10 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 16:53:10 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 16:53:10 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 16:53:10 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 16:53:10 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 16:53:10 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 16:53:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:53:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:53:12 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 16:53:12 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 16:53:12 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 16:53:12 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 16:53:12 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 16:53:12 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 16:53:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:53:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:53:12 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 16:53:12 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 16:53:12 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 16:53:12 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 16:53:12 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 16:53:12 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 16:53:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:53:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:53:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:53:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:53:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:53:13 INFO - no previously-included directories found matching 'docs/_build' 16:53:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:53:13 INFO - Running setup.py install for pep8 16:53:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:53:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:53:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:53:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:53:13 INFO - no previously-included directories found matching 'docs/_build' 16:53:13 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:53:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:53:13 INFO - Cleaning up... 16:53:13 INFO - Return code: 0 16:53:13 INFO - Running post-action listener: _resource_record_post_action 16:53:13 INFO - Running post-action listener: _start_resource_monitoring 16:53:13 INFO - Starting resource monitoring. 16:53:13 INFO - ##### 16:53:13 INFO - ##### Running install step. 16:53:13 INFO - ##### 16:53:13 INFO - Running pre-action listener: _resource_record_pre_action 16:53:13 INFO - Running main action method: install 16:53:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:53:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:53:13 INFO - Reading from file tmpfile_stdout 16:53:13 INFO - Detecting whether we're running mozinstall >=1.0... 16:53:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:53:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:53:13 INFO - Reading from file tmpfile_stdout 16:53:13 INFO - Output received: 16:53:13 INFO - Usage: mozinstall [options] installer 16:53:13 INFO - Options: 16:53:13 INFO - -h, --help show this help message and exit 16:53:13 INFO - -d DEST, --destination=DEST 16:53:13 INFO - Directory to install application into. [default: 16:53:13 INFO - "/builds/slave/test-pgo"] 16:53:13 INFO - --app=APP Application being installed. [default: firefox] 16:53:13 INFO - mkdir: /builds/slave/test-pgo/build/application 16:53:13 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'] 16:53:13 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 16:53:30 INFO - Reading from file tmpfile_stdout 16:53:30 INFO - Output received: 16:53:30 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:53:30 INFO - Running post-action listener: _resource_record_post_action 16:53:30 INFO - ##### 16:53:30 INFO - ##### Running run-tests step. 16:53:30 INFO - ##### 16:53:30 INFO - Running pre-action listener: _resource_record_pre_action 16:53:30 INFO - Running main action method: run_tests 16:53:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:53:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:53:30 INFO - Python 2.7.3 16:53:30 INFO - Return code: 0 16:53:30 INFO - grabbing minidump binary from tooltool 16:53: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')]} 16:53:30 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 0x145d8c0>, '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 0x145e7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145ec50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:53:30 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 16:53:30 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 16:53:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:53:30 INFO - Return code: 0 16:53:30 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:53:30 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:53:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:53:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:53:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:53:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:53:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:53:31 INFO - Return code: 0 16:53:31 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/I2fdZ7toTSmvX3IV9wZzSQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 16:53:31 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/I2fdZ7toTSmvX3IV9wZzSQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 16:53:31 INFO - Using env: {'DISPLAY': ':0', 16:53:31 INFO - 'HOME': '/home/cltbld', 16:53:31 INFO - 'LANG': 'en_US.UTF-8', 16:53:31 INFO - 'LANGUAGE': 'en_US:en', 16:53:31 INFO - 'LOGNAME': 'cltbld', 16:53:31 INFO - 'MAIL': '/var/mail/cltbld', 16:53:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:53:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:31 INFO - 'MOZ_NO_REMOTE': '1', 16:53:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:53:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:31 INFO - 'NO_EM_RESTART': '1', 16:53:31 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:53:31 INFO - 'PWD': '/builds/slave/test-pgo', 16:53:31 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:53:31 INFO - 'SHELL': '/bin/bash', 16:53:31 INFO - 'SHLVL': '1', 16:53:31 INFO - 'TERM': 'linux', 16:53:31 INFO - 'TMOUT': '86400', 16:53:31 INFO - 'USER': 'cltbld', 16:53:31 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1456618433.889777-1847586165', 16:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:31 INFO - '_': '/tools/buildbot/bin/python'} 16:53:31 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/I2fdZ7toTSmvX3IV9wZzSQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:53:31 INFO - mozversion application_buildid: 20160227143004 16:53:31 INFO - mozversion application_changeset: a96f17e627e5b86e1d6d603e10751edb37d1601d 16:53:31 INFO - mozversion application_display_name: Nightly 16:53:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:53:31 INFO - mozversion application_name: Firefox 16:53:31 INFO - mozversion application_remotingname: firefox 16:53:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:53:31 INFO - mozversion application_vendor: Mozilla 16:53:31 INFO - mozversion application_version: 47.0a1 16:53:31 INFO - mozversion platform_buildid: 20160227143004 16:53:31 INFO - mozversion platform_changeset: a96f17e627e5b86e1d6d603e10751edb37d1601d 16:53:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:53:31 INFO - mozversion platform_version: 47.0a1 16:53:31 INFO - using testdate: 1456620811 16:53:31 INFO - actual date: 1456620811 16:53:31 INFO - starting webserver on 'localhost:42970' 16:53:31 INFO - SUITE-START | Running 2 tests 16:53:31 INFO - TEST-START | dromaeo_css 16:53:31 INFO - operating with platform_type : linux_ 16:53:31 INFO - Initialising browser for dromaeo_css test... 16:53:31 INFO - TEST-INFO | started process 9154 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpea1RnR/profile http://localhost:42970/getInfo.html) 16:53:35 INFO - PROCESS | 9154 | __metrics Screen width/height:1600/1200 16:53:35 INFO - PROCESS | 9154 | colorDepth:24 16:53:35 INFO - PROCESS | 9154 | Browser inner width/height: 1024/697 16:53:35 INFO - PROCESS | 9154 | __metrics 16:53:36 INFO - PROCESS | 9154 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:53:36 INFO - PROCESS | 9154 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:53:36 INFO - PROCESS | 9154 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:53:36 INFO - PROCESS | 9154 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:53:36 INFO - PROCESS | 9154 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:53:36 INFO - PROCESS | 9154 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:53:36 INFO - PROCESS | 9154 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:53:36 INFO - PROCESS | 9154 | 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. 16:53:36 INFO - TEST-INFO | 9154: exit 0 16:53:36 INFO - Browser initialized. 16:53:36 INFO - Running cycle 1/1 for dromaeo_css test... 16:53:36 INFO - TEST-INFO | started process 9247 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpea1RnR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:53:48 INFO - PROCESS | 9247 | RSS: Main: 150155264 16:53:48 INFO - PROCESS | 9247 | 16:54:39 INFO - PROCESS | 9247 | 1456620879352 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] 16:56:48 INFO - PROCESS | 9247 | Cycle 1(1): loaded http://localhost:42970/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42970/tests/dromaeo/cssquery-ext.html) 16:56:49 INFO - PROCESS | 9247 | RSS: Main: 249270272 16:56:49 INFO - PROCESS | 9247 | 16:59:51 INFO - PROCESS | 9247 | Cycle 1(1): loaded http://localhost:42970/tests/dromaeo/cssquery-ext.html (next: http://localhost:42970/tests/dromaeo/cssquery-jquery.html) 16:59:51 INFO - PROCESS | 9247 | RSS: Main: 235413504 16:59:51 INFO - PROCESS | 9247 | 17:02:53 INFO - PROCESS | 9247 | Cycle 1(1): loaded http://localhost:42970/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42970/tests/dromaeo/cssquery-mootools.html) 17:02:54 INFO - PROCESS | 9247 | RSS: Main: 233684992 17:02:54 INFO - PROCESS | 9247 | 17:05:56 INFO - PROCESS | 9247 | Cycle 1(1): loaded http://localhost:42970/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42970/tests/dromaeo/cssquery-prototype.html) 17:05:56 INFO - PROCESS | 9247 | RSS: Main: 219004928 17:05:56 INFO - PROCESS | 9247 | 17:08:59 INFO - PROCESS | 9247 | Cycle 1(1): loaded http://localhost:42970/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42970/tests/dromaeo/cssquery-yui.html) 17:08:59 INFO - PROCESS | 9247 | RSS: Main: 212291584 17:08:59 INFO - PROCESS | 9247 | 17:12:02 INFO - PROCESS | 9247 | Cycle 1(1): loaded http://localhost:42970/tests/dromaeo/cssquery-yui.html (next: http://localhost:42970/tests/dromaeo/cssquery-dojo.html) 17:12:02 INFO - PROCESS | 9247 | RSS: Main: 322691072 17:12:02 INFO - PROCESS | 9247 | 17:12:02 INFO - PROCESS | 9247 | __start_tp_report 17:12:02 INFO - PROCESS | 9247 | _x_x_mozilla_page_load 17:12:02 INFO - PROCESS | 9247 | _x_x_mozilla_page_load_details 17:12:02 INFO - PROCESS | 9247 | |i|pagename|runs| 17:12:02 INFO - PROCESS | 9247 | |0;dojo.html;3123.0630810756775;3131.091983324836;3168.461361568533;3180.395724812287;3202.1514298710845;4943.233798761194;4980.87547811304;4989.875253118669;4994.925076123856;4998.2752500887345;5055.191169412895;5096.643234973553;5135;5142.280080788692;5164.509371609701;4557.361969324297;4578.473475550312;4698;4736.265878788793;4781.187198176319;4687.250039993602;4707.435107787053;4735.597474214679;4740.336352910595;4795.904081918359;4543.477500087482;4587.174308624446;4663.114008338422;4683.625309975194;4693.460252070987;4648.093621743761;4651.465081515636;4651.62786977041;4653.906921861578;4692.131955588227;4619.838305659286;4625.884352891205;4635.490096089427;4645.581897629196;4647.53524647536;4899.044686286175;4959.132151873444;5039.042581909425;5047.949520504784;5059.215821547666;5306.283651707009;5323.441038690959;5325.467453254643;5327.280817089682;5334.119870221409;5297.311349524575;5342.946570534284;5364.168553874156;5379.031774280628;5407.351117865842;5118.334616499868;5139.8458046258675;5183.585313174937;5194.974025129888;5197.350331208599;5546.417626149277;5555.444455554493;5563.415841336682;5577.107662773937;5579.023670857584;5308.681479111266;5353.437889021675;5368.57051435892;5372.382176049804;5372.677639341652;5410.1343784995;5429.511343979061;5434.64674796137;5434.809781657623;5479.17812328146;5367.275417818622;5383.515483606416;5391.81128660495;5394.32570928634;5439.102548079522;5316.308879845596;5384.6769193848495;5389.649672771257;5453.7818487260065;5519.337679478488;4125;4137.81379837908;4142.689298302639;4169.812358443877;4181.560936101726;3757.1734218471893;3757.887263382103;3760.1539653578275;3788.0719223790347;3792.2036372362113;5006.89986200274;5019.573336266459;5045.697258164522;5084.13569693153;5085.974570127126;5380.381256155514;5399.136138217945;5408.621396502207;5420.945790542123;5430.51125398716;5076.137056700296;5108.489151084862;5115.079285728604;5119.206522988943;5143.305653736773;4585.839495617637;4606.792694328763;4611.769411529477;4640.419947506562;4652.534746525388;5563.221149039137;5595.328560572757;5595.692236926927;5600.047991841397;5648.63283886546;5285.814996475105;5313.654612450178;5337.092694241911;5338.866528336823;5346.010987967238;5674;5734.655920644775;5741.196232527366;5764.711764411679;5782.363939966516;5397.271368365377;5403.162509810985;5405.540529054917;5405.756740946588;5412.215228791882;5361.142217245222;5414.512693857571;5464.071107911585;5468.808591699271;5524.972375138259;5342.091844386541;5342.9198562022375;5346.946530534645;5359.383670877743;5392.08334583114;5300.681959082467;5312.096943519534;5312.787488500571;5313.282706834682;5364.275822763877;5149.433562308218;5176.482351764944;5236.581073514034;5239.633225674166;5254.106801843619;5347.224652425454;5381.892362152813;5382;5384.057789886832;5385.946140538545;5222.921656175236;5228.189630607262;5266.289050978069;5270.077736396192;5282.630215885005 17:12:02 INFO - PROCESS | 9247 | |1;ext.html;491.1380527174808;521.9191025391065;526.5839986410735;544.6432586655741;577.1371799160256;27944.301392465197;36088.278234435325;36187.09532261695;36366.818165909135;36490.45264321034;39054.41418378727;39731.80134099333;39744.80127599358;39841.80079099608;39914;7523.3981281497345;7646.311831935125;8354.582270886447;8568.314534837198;9826.803463930717;9886.653967111153;10130.74673133174;10138.341007834468;10139.34094283873;10145.543450544743;10062.89937100627;10156.390616562992;10158.187345012419;10159.034891685278;10159.187265018782;10009.89990100097;10092;10104.292699511037;10109.090181883592;10111.393316400967;9992.250581206366;10110.140638045776;10125.645602403954;10129.746756331077;10449.059584637344;39022;39304.80347598244;39459.60540394588;39527.20945581072;39630.405543916866;2991.0578167877047;3128.968710312913;3155.5739975103297;3172.4448221561133;3222.4521831288503;29682.55476167859;30060.24849378783;30591;30602;31558.526622100686;3776.546814382292;3881.243157584272;3915.275674000319;3931.9606803932165;4080.4491393661774;255302;257021;257645;258055.70972145206;258216;56933.43066569364;57382.42617573771;57416;57443;57445;59908.40091599115;60968.39031609627;61017.08474372888;61110;61170.38829611647;16164.515064548083;16575.171241437878;16615.50153495397;16656.6668666626;16720.498385048468;10113.443760593238;10121.898781012243;10128.848067278997;10166.28835981489;11495.137864660017;19523.511912202026;20651.58696826055;20676.312079429877;20730.48173795667;20735.066921988546;7723.922760772432;7854.60726963661;7911.446198766032;7918.6436610352675;8053.919460805317;897.1342654338595;931.9207867331353;1045.2421994054403;1050.2700623067049;1062.9734256643646;25818.096366627076;25982.35044123874;26045.609315860278;26058;26061.478770424863;972.3873959405671;1024.0118285854187;1058.8252938265255;1082.1505118482112;1107.2304748199924;13671.931640341934;14080.887866819854;14300.785488217685;14328.713425731426;14351.712965740626;294872;297393;297944;298332;299434;51057.48942510602;51860.48139518557;51869;51869.221961670606;51875.48124518782;1229.7786398448186;1291.5673249461347;1338.7456383287144;1355.945762169522;1369.2127026959538;23473;24707.382315442257;25482;26634;26762.330941726614;41746.37380439235;41986.79006604947;42326;42356.57643423649;42381.78809106058;208948;209627;210725;211010;211620;26863.73136268612;30998.380032399677;31034.68965310318;31259.687403125678;31528.054158375286;37148.81425592855;38040.42939355967;38336.42495362627;38357.80821095876;38366;37380;38742.6125738739;38910.80544597259;39086.804565976985;39235.41146882742;34855.12862178466;35943.86510094592;36477.81761091178;36798.44802327914;37252.813735931144;35496;35975.460368093976;36324;36671.81664091662;36688.449673255454;30946.69053309438;32397.514037288987;32677.509837351983;32724.181895452803;32976.505352420216;24695.629565556173;24944;25069;25074.24777256685;25397.238082857544 17:12:02 INFO - PROCESS | 9247 | |2;jquery.html;329.84497286275456;333.4897606661807;336.3508428732545;337.2883216413366;341.48947323750997;15827.604309892258;16209.918950405247;16689.24898379573;17099.487015389528;17123.657526849485;14675.412983480675;14846.703065938675;14919.776203356958;15138.84861151391;15165.165915874622;5140.845774626767;5366.9463305366835;5386.73066346683;5386.865328366783;5411.918821217685;4835.1296766582;5007.2489126630935;5012.448630650625;5015.0972824891505;5019.121653710605;4968.478309777457;4979.875503112433;4989.875253118665;5234.528892399683;5857.238558987326;5852.356240813507;5872.236609240814;5893.499052580536;5909.349971503131;5942.078977758454;4930.852074437773;5089.618278629117;5098.923516147261;5100.030994111107;5127.154019586801;12439.502419903192;12535.24788512692;12570.057245706608;12667.11330206886;12681.36593170347;1980.9504762380911;2075.0662202009157;2122.5012122151284;2182.6071307164702;2406.38637147528;9024.593893274818;9411.90588094117;9562.18721408681;12045.337506437143;12827.230366178059;1759.7008508553577;1883.6797744383487;1885.198790514026;1894.2423030787795;1913.0817207740224;51471.74264128693;59449.702751485966;61581.38418615846;62534.37465625376;64107.67946160286;8785.209331160226;8822.735317940473;9195.586198620944;9239.630414783467;9361.859572106423;11364.94317528407;11622.360770157722;11623.360715160747;11634.185607007597;11727;6693.062971184038;6894.207166175854;6983.650817459208;6985.545939513915;7101.289871012961;6874.484413668994;6875;6887.621180835002;6989.217749473852;7004.859902801915;4042.2723909696538;4084.6732261419015;4091.1204091120553;4105.240530501807;4165.062860856283;1620.66776310856;1646.9906713809135;1651.8513333799776;1660.6346603747156;1682.2682133272067;854.2918946938221;913.0869130869131;922.5064590444081;928.4986107502008;960.7357976556364;15933;16414.83585164157;16546.338146474005;16683.49949501517;16686.49940501787;915.9816803664023;937.6624415210518;949.4967667136428;962.153305091515;999.0708640963828;9257;9470.763230919281;9567;9588.712338629852;9684.51577421126;393544;395523;397862;404752;408925;70686.29313706797;73127;73192.97438640926;74583.62708186424;74753.25246747572;963.7638778499453;983.6753871222479;1025.4462590201356;1034.255336157965;1034.6120204923154;14275.785863211853;14365.13809171453;14873.107613543221;14893.553193403783;15163.317650705965;30196.698033019387;30937.381252375275;31021.224469388446;31512;31808.840955795073;42056.57943420527;44881.775591121834;48464.788380290775;48605.5139448601;49021.26468103052;7331.74338898136;7453.850922981618;7564.50830696003;7633.160352361125;7649.158592554703;8691.435056721293;11376.089912807121;11890.76218475643;12149.149559530748;12182.208156469802;9917.553710083208;10284.588616455258;10423.061924426838;10830.566777328819;10927.726806829574;10414.323069000491;10614.469276535989;10698.572057117628;10709.196810239107;10906.454677265947;10568.20738444635;10725.356478611307;10791.190660700322;10795.56817727282;11069.893010698866;7294.781156565312;7360.153582337885;7387.002754628056;7445.664945077593;7720.266574675396;9647;10361.171106311627;10434.21743369235;10517.316374435637;10839.891601083888 17:12:02 INFO - PROCESS | 9247 | |3;mootools.html;1292.2052937443475;1447.8624530669586;1463.8975271730976;1603.7353836616958;1761.409927674229;7411.703531858726;7552.84894302115;7580.886286705704;7591.468597198198;7593.506422082568;7195.352418282354;7315.158756742976;7317.6707048182825;7329.413646908248;7331.816704582388;1917.5302050997525;2179.6512557990723;2215.77024751263;2218.4121207879925;2243.1363924888956;2202.273249827553;2239.2386588559884;2243.1924507177405;2243.6298010828195;2244.517428752818;2182.3889310992868;2241.2603840732518;2244.5847518209102;2245.259064508708;2246.528229071897;2198.9890050549725;2202.7466841313294;2207.602631526325;2234.5754306681843;2240.171136679423;2226.3543572363997;2245.65192395179;2256.8420210585264;2261.5816074026193;2264.7395549511853;7367.5211111277595;7471.25287471254;7501.549907005598;7520.736774212876;7525.2098529654695;4547.5452454754595;4628.467726211461;4660.743659098748;4671.85984420468;4684.36761037259;2927.6925922778014;2975.687552806946;3014.351914338406;3029.9394012119856;3103.255218747507;967.3083745122271;969.1132613658494;975.229568640773;988.4316518002178;1004.6985904228702;10321.43232122233;10370.63702770407;10398.428086455242;10482.580696772196;10500.474976251156;4133.586641335903;4206.789660516962;4236.279832428495;4273.957260427356;4291.399204111427;9103.81792364149;9122.270218382513;9138.725838224864;9173.266138708887;9177.678781242625;4176.624103830609;4726.669133160645;4730.479647238801;4753.33453316536;4756.738379389098;4132.669386449077;4177.060161463707;4207.03238255203;4212.620864122244;4240.300350442142;3421.196018935548;3495.2834668892815;3516.7186625069935;3540.8406621702084;3566.4293713005795;1077.2190162132392;1088.2599832114238;1094.7591529863416;1099.483242875847;1102.2064113838023;1296.4166125243678;1310.4299629660936;1316.861729518406;1383.5295999360267;1384.2732565403244;7085.89371159433;7194.64026798658;7198.49610527258;7227.566346019255;7287.781366559012;1059.7880423915094;1081.864766904137;1090.8363745438248;1098.1983152298708;1111.6220485034964;5438.510534051875;5475.315585551806;5508.944910550923;5520.337559492807;5524.972375138099;8872.423292485968;8974.37179397449;8984.910150898539;9202.815943681222;9325.207357374698;9103.49930753815;9115.589798459085;9139.81720365589;9150.725478235663;9156.084391560924;7126.5011449198055;7254.383377412979;7352.375048120863;7372.852542949111;7397.519161254609;7064.894026589708;7067.222605513287;7075.5047146699235;7097.9290207097265;7109.395701365442;8078.919210807817;8279.875801863098;8340.874886876823;8507.95746021266;8534.70128545498;8353.707620233263;8593.398462107592;8607.354448416268;8650.264727498234;8715.34634902372;6399.488040956619;6426.614403135827;6448.161738973903;6494.0258961156205;6497.415232629086;7380.704771809067;7388.261173882569;7420.332170104716;7423.331900129015;7454.142773581108;6606.669666516751;6758.290379510081;6776.28848970851;6893.655317234018;7080.079589653312;6723.932760672331;6746.257911629815;6838.93161068383;6841.3842754152365;6859.2454829969665;6883.965580172067;6917.066196063467;6963.8607227854145;7001.964990175016;7013.579185248901;6469.256035555972;6470.6117632940295;6506.25178104524;6547.410733034049;6548.98490733937;6504.089427480251;6582.144321238208;6593.241777195684;6595;6598.538102332791 17:12:02 INFO - PROCESS | 9247 | |4;prototype.html;310.0496976766212;311.5855911637522;312.2615015488371;318.8198667752718;319.120822135018;5879.67661778602;5888.617239879405;5904.85237869053;5927.762889484421;5932.40675932406;5842.415758424156;5846.123081537761;5856.121581762738;5857.627660797373;5865.1202319652075;4303.763293018883;4371.038371558268;4439.511653718088;4502.2571275739465;4518.683692141552;4474.597286244254;4494.280915053592;4501.279795232764;4512.97743511282;4515.571020753023;4253.29820579604;4447.73313601185;4447.933281000787;4448.510663826976;4452.487963884146;4297.935530967038;4412;4415.867523974286;4433.6674749393605;4444.400005999181;3846.0961674006585;3849.172427928009;3851.229754049173;3863.787491687956;3878.4376265441633;5573.386927437979;5575.080111781551;5578.330600327946;5578.86052848678;5590;5118.795248190068;5120.539151476348;5122.846314610568;5127.3847138343635;5128.71792051437;6126.601770884923;6183.443490085869;6184.381561843825;6187.195664563623;6192.721327540272;4018.698597605162;4131.35963925592;4139.689523285766;4140.875773726793;4263.104748002923;6413.7755178569;6468.3855033771715;6477.125588045647;6489.253735820346;6490.156279683658;4218.578142185757;4223.472065991751;4224.429701990192;4228.386883901817;4230.534641189467;4275.828966841354;4276.059266961263;4276.251655960256;4276.743395396286;4279.2083464559155;5038.5969122470115;5044.1677123274985;5044.974775126174;5046.772895219724;5049.722265275445;5964.612300200473;6241.001439769615;6243.531735119885;6247.187865577446;6249.875002499924;1447.826260848684;1453.273363318341;1454.0621299261916;1455.5778824141091;1459.0807791091756;923.7967647117623;955.302629080775;971.8590804333473;997.8602995580625;1001.8797744270735;5957.731902064417;5976.223090998229;5976.760929562769;5980.162777211194;5980.940190598125;6371.458426033746;6372.171617689671;6377;6382.297947225801;6408.775692850728;5964.493018093423;5966.492848107872;5967.880642387215;5967.940320596738;5973.701314934236;3394.9490757638655;3439.1402149462633;3443.0875817908272;3444.6727560881677;3445;6532.183477065367;6697.22981857083;6707.463402927851;6710.228323742832;6720.361565651256;6452;6477.287498375175;6489.610623362519;6490.675466226669;6529;6629.270780214269;6686.4985126115735;6706.59760414367;6732.899006514906;6744.7976560703255;6319.24169099711;6323.7786677466065;6325.841853953688;6327.873442531031;6338.936610633835;6069.393060694072;6232.127502149793;6251.78118765841;6265.498760099273;6267.717952692049;6673.432758215606;6700.966495167493;6712.83217919556;6719.764808231884;6719.932800671931;4166.0626359068965;4169.812358443938;4187.24629566681;4190.748555086705;4193.895152621087;6274.372562743689;6312.652804095819;6327.651979141191;6337.556371053982;6343.207099112611;6136.2636483622255;6151.200343955257;6153.661548614869;6155.753769849335;6158.938410615837;6014.188084608521;6087.05650624154;6147.200863887666;6150.876982460415;6158.199434073542;6020;6028.728707208098;6035.215421995113;6037.366076562073;6039.547033972557;6170.457385653586;6170.845728856814;6171.444569988723;6173.197484327009;6182.876342473035;5893.941060589339;5999.640021598718;6029.457348838626;6037.69811509414;6038.396160383926 17:12:02 INFO - PROCESS | 9247 | |5;yui.html;736.9005184300121;770.1259070954465;788.5111231036758;840.8612578924477;872.8297981893529;13137.211767293957;13291.93354033231;13327.067105302633;13384.263865487394;13409.865901340983;14929.104253744783;15093.094414335148;15096.924515377408;15099.245037748096;15120.017198882066;697.1703672629554;825.6821123867325;826.3884725303277;834.5827086456741;848.0544193224541;830.3855147191065;839.995800020999;841.4951029382382;842.5913431985482;843.1863251961855;878.1876763993313;880.058337578791;881.8677198420256;883.1874675298709;885.3890815337429;714.5355518912722;723.0564113831448;864.6195673903462;873.135595760196;881.1496905486173;643.7425029988042;647.1942431672551;647.427027081032;647.5402464250387;647.6211416321457;14242.643933901632;14271.500497482539;14288.857111428857;14313.57059288223;14318.713625727427;12220.083493738006;12373.69065773354;12553.184043037265;12684.23894566329;13031.283279419627;9984.850227246525;10072.194224462026;10228.130608898253;10313.89686103137;10525.47372631373;3543.7165026797793;3549.591796943333;3579.785212887209;3588.659077387644;3743.6630703236565;49849.75075124637;50754.49245507535;50841.23738143931;50852.491475085146;50856;9829.45937973404;9902;9927.553260103312;9945.353552019096;10095.343802652804;17863.910680446515;17889.19498622565;17889.552761180814;17896.642067158584;17930.731039034425;7514.323710865939;7525.510841795266;7631.809204769926;7638.197989211164;7819.335356494648;4390.626796722315;4405.449318835145;4413.095315460323;4445.2887537993765;4450.265706158512;3149.3071524264624;3174.158847905307;3176.0630613968933;3176.745860331168;3183.3474137801695;561.2311133746794;591.4972273567433;591.8905002574537;591.9200907877467;596.9731362088629;617.5029101573186;672.3411057164006;693.8716337477482;698.5319835710086;732.827785470414;8136.355684402474;8334.958325208336;8401.747947561584;8485.490870547786;8509.106543812934;619.8605313804449;624.2290770897937;627.8053803320985;629.5058379172419;640.2541039688804;3844.7116466265143;3858.151206734514;3923.4114882767244;3973.7615743055508;4024.2957482440456;52106.739466302424;55280;55534;55545;55803.441965580634;46844;47605.28592071122;48810.26784598234;49064.26403603949;49234.50765492299;44246.11507769827;44424.11151776947;44500.332495012604;45200;45288;7561.168271490242;7947.324477419253;8095.352371810123;8149.511029338259;8176.2821150668815;32536;34016.82991585026;34646.65353346535;35555;35647.46528802018;21105.6834147491;21242.78757212408;21260.893695531424;38599.42100868433;43245.3513197296;10109;10208.59165633396;10559;10842.295250808673;10953.56185752561;11419.543218271176;11539.4807233673;11874.940625296818;11918.642440726791;12333.814992775295;10546.736331591772;10911.781764364827;11048.889511104786;11073.446327683423;11394.202405831513;10990.96503732676;11126.221164518405;11178.217524773512;11292.378919159524;11417.942910285396;10664.946675266574;10890.29213101146;10956.945215273872;11086.61196858106;11295.096392288762;9597.856032159663;9604.66383676568;9631;9871.605135794487;10101.24240681937;8374.706885258987;9005.549722513717;9320.580573874056;9656.624522258171;9895.65365212214 17:12:02 INFO - PROCESS | 9247 | __end_tp_report 17:12:02 INFO - PROCESS | 9247 | __start_cc_report 17:12:02 INFO - PROCESS | 9247 | _x_x_mozilla_cycle_collect,810 17:12:02 INFO - PROCESS | 9247 | __end_cc_report 17:12:02 INFO - PROCESS | 9247 | __startTimestamp1456621922658__endTimestamp 17:12:02 INFO - PROCESS | 9247 | 17:12:02 INFO - PROCESS | 9247 | ------- Summary: start ------- 17:12:02 INFO - PROCESS | 9247 | Number of tests: 6 17:12:02 INFO - PROCESS | 9247 | 17:12:02 INFO - PROCESS | 9247 | [#0] dojo.html Cycles:165 Average:5053.11 Median:5266.29 stddev:539.40 (10.2%) stddev-sans-first:519.37 17:12:02 INFO - PROCESS | 9247 | Values: 3123.1 3131.1 3168.5 3180.4 3202.2 4943.2 4980.9 4989.9 4994.9 4998.3 5055.2 5096.6 5135.0 5142.3 5164.5 4557.4 4578.5 4698.0 4736.3 4781.2 4687.3 4707.4 4735.6 4740.3 4795.9 4543.5 4587.2 4663.1 4683.6 4693.5 4648.1 4651.5 4651.6 4653.9 4692.1 4619.8 4625.9 4635.5 4645.6 4647.5 4899.0 4959.1 5039.0 5047.9 5059.2 5306.3 5323.4 5325.5 5327.3 5334.1 5297.3 5342.9 5364.2 5379.0 5407.4 5118.3 5139.8 5183.6 5195.0 5197.4 5546.4 5555.4 5563.4 5577.1 5579.0 5308.7 5353.4 5368.6 5372.4 5372.7 5410.1 5429.5 5434.6 5434.8 5479.2 5367.3 5383.5 5391.8 5394.3 5439.1 5316.3 5384.7 5389.6 5453.8 5519.3 4125.0 4137.8 4142.7 4169.8 4181.6 3757.2 3757.9 3760.2 3788.1 3792.2 5006.9 5019.6 5045.7 5084.1 5086.0 5380.4 5399.1 5408.6 5420.9 5430.5 5076.1 5108.5 5115.1 5119.2 5143.3 4585.8 4606.8 4611.8 4640.4 4652.5 5563.2 5595.3 5595.7 5600.0 5648.6 5285.8 5313.7 5337.1 5338.9 5346.0 5674.0 5734.7 5741.2 5764.7 5782.4 5397.3 5403.2 5405.5 5405.8 5412.2 5361.1 5414.5 5464.1 5468.8 5525.0 5342.1 5342.9 5346.9 5359.4 5392.1 5300.7 5312.1 5312.8 5313.3 5364.3 5149.4 5176.5 5236.6 5239.6 5254.1 5347.2 5381.9 5382.0 5384.1 5385.9 5222.9 5228.2 5266.3 5270.1 5282.6 17:12:02 INFO - PROCESS | 9247 | 17:12:02 INFO - PROCESS | 9247 | [#1] ext.html Cycles:180 Average:42750.37 Median:17194.33 stddev:67057.33 (390.0%) stddev-sans-first:67170.38 17:12:02 INFO - PROCESS | 9247 | Values: 491.1 521.9 526.6 544.6 577.1 27944.3 36088.3 36187.1 36366.8 36490.5 39054.4 39731.8 39744.8 39841.8 39914.0 7523.4 7646.3 8354.6 8568.3 9826.8 9886.7 10130.7 10138.3 10139.3 10145.5 10062.9 10156.4 10158.2 10159.0 10159.2 10009.9 10092.0 10104.3 10109.1 10111.4 9992.3 10110.1 10125.6 10129.7 10449.1 39022.0 39304.8 39459.6 39527.2 39630.4 2991.1 3129.0 3155.6 3172.4 3222.5 29682.6 30060.2 30591.0 30602.0 31558.5 3776.5 3881.2 3915.3 3932.0 4080.4 255302.0 257021.0 257645.0 258055.7 258216.0 56933.4 57382.4 57416.0 57443.0 57445.0 59908.4 60968.4 61017.1 61110.0 61170.4 16164.5 16575.2 16615.5 16656.7 16720.5 10113.4 10121.9 10128.8 10166.3 11495.1 19523.5 20651.6 20676.3 20730.5 20735.1 7723.9 7854.6 7911.4 7918.6 8053.9 897.1 931.9 1045.2 1050.3 1063.0 25818.1 25982.4 26045.6 26058.0 26061.5 972.4 1024.0 1058.8 1082.2 1107.2 13671.9 14080.9 14300.8 14328.7 14351.7 294872.0 297393.0 297944.0 298332.0 299434.0 51057.5 51860.5 51869.0 51869.2 51875.5 1229.8 1291.6 1338.7 1355.9 1369.2 23473.0 24707.4 25482.0 26634.0 26762.3 41746.4 41986.8 42326.0 42356.6 42381.8 208948.0 209627.0 210725.0 211010.0 211620.0 26863.7 30998.4 31034.7 31259.7 31528.1 37148.8 38040.4 38336.4 38357.8 38366.0 37380.0 38742.6 38910.8 39086.8 39235.4 34855.1 35943.9 36477.8 36798.4 37252.8 35496.0 35975.5 36324.0 36671.8 36688.4 30946.7 32397.5 32677.5 32724.2 32976.5 24695.6 24944.0 25069.0 25074.2 25397.2 17:12:02 INFO - PROCESS | 9247 | 17:12:02 INFO - PROCESS | 9247 | [#2] jquery.html Cycles:180 Average:23578.23 Median:4135.15 stddev:65747.86 (1590.0%) stddev-sans-first:65909.12 17:12:02 INFO - PROCESS | 9247 | Values: 329.8 333.5 336.4 337.3 341.5 15827.6 16209.9 16689.2 17099.5 17123.7 14675.4 14846.7 14919.8 15138.8 15165.2 5140.8 5366.9 5386.7 5386.9 5411.9 4835.1 5007.2 5012.4 5015.1 5019.1 4968.5 4979.9 4989.9 5234.5 5857.2 5852.4 5872.2 5893.5 5909.3 5942.1 4930.9 5089.6 5098.9 5100.0 5127.2 12439.5 12535.2 12570.1 12667.1 12681.4 1981.0 2075.1 2122.5 2182.6 2406.4 9024.6 9411.9 9562.2 12045.3 12827.2 1759.7 1883.7 1885.2 1894.2 1913.1 51471.7 59449.7 61581.4 62534.4 64107.7 8785.2 8822.7 9195.6 9239.6 9361.9 11364.9 11622.4 11623.4 11634.2 11727.0 6693.1 6894.2 6983.7 6985.5 7101.3 6874.5 6875.0 6887.6 6989.2 7004.9 4042.3 4084.7 4091.1 4105.2 4165.1 1620.7 1647.0 1651.9 1660.6 1682.3 854.3 913.1 922.5 928.5 960.7 15933.0 16414.8 16546.3 16683.5 16686.5 916.0 937.7 949.5 962.2 999.1 9257.0 9470.8 9567.0 9588.7 9684.5 393544.0 395523.0 397862.0 404752.0 408925.0 70686.3 73127.0 73193.0 74583.6 74753.3 963.8 983.7 1025.4 1034.3 1034.6 14275.8 14365.1 14873.1 14893.6 15163.3 30196.7 30937.4 31021.2 31512.0 31808.8 42056.6 44881.8 48464.8 48605.5 49021.3 7331.7 7453.9 7564.5 7633.2 7649.2 8691.4 11376.1 11890.8 12149.1 12182.2 9917.6 10284.6 10423.1 10830.6 10927.7 10414.3 10614.5 10698.6 10709.2 10906.5 10568.2 10725.4 10791.2 10795.6 11069.9 7294.8 7360.2 7387.0 7445.7 7720.3 9647.0 10361.2 10434.2 10517.3 10839.9 17:12:02 INFO - PROCESS | 9247 | 17:12:02 INFO - PROCESS | 9247 | [#3] mootools.html Cycles:180 Average:5359.30 Median:6482.32 stddev:2767.48 (42.7%) stddev-sans-first:2758.35 17:12:02 INFO - PROCESS | 9247 | Values: 1292.2 1447.9 1463.9 1603.7 1761.4 7411.7 7552.8 7580.9 7591.5 7593.5 7195.4 7315.2 7317.7 7329.4 7331.8 1917.5 2179.7 2215.8 2218.4 2243.1 2202.3 2239.2 2243.2 2243.6 2244.5 2182.4 2241.3 2244.6 2245.3 2246.5 2199.0 2202.7 2207.6 2234.6 2240.2 2226.4 2245.7 2256.8 2261.6 2264.7 7367.5 7471.3 7501.5 7520.7 7525.2 4547.5 4628.5 4660.7 4671.9 4684.4 2927.7 2975.7 3014.4 3029.9 3103.3 967.3 969.1 975.2 988.4 1004.7 10321.4 10370.6 10398.4 10482.6 10500.5 4133.6 4206.8 4236.3 4274.0 4291.4 9103.8 9122.3 9138.7 9173.3 9177.7 4176.6 4726.7 4730.5 4753.3 4756.7 4132.7 4177.1 4207.0 4212.6 4240.3 3421.2 3495.3 3516.7 3540.8 3566.4 1077.2 1088.3 1094.8 1099.5 1102.2 1296.4 1310.4 1316.9 1383.5 1384.3 7085.9 7194.6 7198.5 7227.6 7287.8 1059.8 1081.9 1090.8 1098.2 1111.6 5438.5 5475.3 5508.9 5520.3 5525.0 8872.4 8974.4 8984.9 9202.8 9325.2 9103.5 9115.6 9139.8 9150.7 9156.1 7126.5 7254.4 7352.4 7372.9 7397.5 7064.9 7067.2 7075.5 7097.9 7109.4 8078.9 8279.9 8340.9 8508.0 8534.7 8353.7 8593.4 8607.4 8650.3 8715.3 6399.5 6426.6 6448.2 6494.0 6497.4 7380.7 7388.3 7420.3 7423.3 7454.1 6606.7 6758.3 6776.3 6893.7 7080.1 6723.9 6746.3 6838.9 6841.4 6859.2 6884.0 6917.1 6963.9 7002.0 7013.6 6469.3 6470.6 6506.3 6547.4 6549.0 6504.1 6582.1 6593.2 6595.0 6598.5 17:12:02 INFO - PROCESS | 9247 | 17:12:02 INFO - PROCESS | 9247 | [#4] prototype.html Cycles:180 Average:5143.12 Median:5967.19 stddev:1586.59 (26.6%) stddev-sans-first:1549.01 17:12:02 INFO - PROCESS | 9247 | Values: 310.0 311.6 312.3 318.8 319.1 5879.7 5888.6 5904.9 5927.8 5932.4 5842.4 5846.1 5856.1 5857.6 5865.1 4303.8 4371.0 4439.5 4502.3 4518.7 4474.6 4494.3 4501.3 4513.0 4515.6 4253.3 4447.7 4447.9 4448.5 4452.5 4297.9 4412.0 4415.9 4433.7 4444.4 3846.1 3849.2 3851.2 3863.8 3878.4 5573.4 5575.1 5578.3 5578.9 5590.0 5118.8 5120.5 5122.8 5127.4 5128.7 6126.6 6183.4 6184.4 6187.2 6192.7 4018.7 4131.4 4139.7 4140.9 4263.1 6413.8 6468.4 6477.1 6489.3 6490.2 4218.6 4223.5 4224.4 4228.4 4230.5 4275.8 4276.1 4276.3 4276.7 4279.2 5038.6 5044.2 5045.0 5046.8 5049.7 5964.6 6241.0 6243.5 6247.2 6249.9 1447.8 1453.3 1454.1 1455.6 1459.1 923.8 955.3 971.9 997.9 1001.9 5957.7 5976.2 5976.8 5980.2 5980.9 6371.5 6372.2 6377.0 6382.3 6408.8 5964.5 5966.5 5967.9 5967.9 5973.7 3394.9 3439.1 3443.1 3444.7 3445.0 6532.2 6697.2 6707.5 6710.2 6720.4 6452.0 6477.3 6489.6 6490.7 6529.0 6629.3 6686.5 6706.6 6732.9 6744.8 6319.2 6323.8 6325.8 6327.9 6338.9 6069.4 6232.1 6251.8 6265.5 6267.7 6673.4 6701.0 6712.8 6719.8 6719.9 4166.1 4169.8 4187.2 4190.7 4193.9 6274.4 6312.7 6327.7 6337.6 6343.2 6136.3 6151.2 6153.7 6155.8 6158.9 6014.2 6087.1 6147.2 6150.9 6158.2 6020.0 6028.7 6035.2 6037.4 6039.5 6170.5 6170.8 6171.4 6173.2 6182.9 5893.9 5999.6 6029.5 6037.7 6038.4 17:12:02 INFO - PROCESS | 9247 | 17:12:02 INFO - PROCESS | 9247 | [#5] yui.html Cycles:180 Average:13214.55 Median:46066.00 stddev:15042.09 (32.7%) stddev-sans-first:15055.10 17:12:02 INFO - PROCESS | 9247 | Values: 736.9 770.1 788.5 840.9 872.8 13137.2 13291.9 13327.1 13384.3 13409.9 14929.1 15093.1 15096.9 15099.2 15120.0 697.2 825.7 826.4 834.6 848.1 830.4 840.0 841.5 842.6 843.2 878.2 880.1 881.9 883.2 885.4 714.5 723.1 864.6 873.1 881.1 643.7 647.2 647.4 647.5 647.6 14242.6 14271.5 14288.9 14313.6 14318.7 12220.1 12373.7 12553.2 12684.2 13031.3 9984.9 10072.2 10228.1 10313.9 10525.5 3543.7 3549.6 3579.8 3588.7 3743.7 49849.8 50754.5 50841.2 50852.5 50856.0 9829.5 9902.0 9927.6 9945.4 10095.3 17863.9 17889.2 17889.6 17896.6 17930.7 7514.3 7525.5 7631.8 7638.2 7819.3 4390.6 4405.4 4413.1 4445.3 4450.3 3149.3 3174.2 3176.1 3176.7 3183.3 561.2 591.5 591.9 591.9 597.0 617.5 672.3 693.9 698.5 732.8 8136.4 8335.0 8401.7 8485.5 8509.1 619.9 624.2 627.8 629.5 640.3 3844.7 3858.2 3923.4 3973.8 4024.3 52106.7 55280.0 55534.0 55545.0 55803.4 46844.0 47605.3 48810.3 49064.3 49234.5 44246.1 44424.1 44500.3 45200.0 45288.0 7561.2 7947.3 8095.4 8149.5 8176.3 32536.0 34016.8 34646.7 35555.0 35647.5 21105.7 21242.8 21260.9 38599.4 43245.4 10109.0 10208.6 10559.0 10842.3 10953.6 11419.5 11539.5 11874.9 11918.6 12333.8 10546.7 10911.8 11048.9 11073.4 11394.2 10991.0 11126.2 11178.2 11292.4 11417.9 10664.9 10890.3 10956.9 11086.6 11295.1 9597.9 9604.7 9631.0 9871.6 10101.2 8374.7 9005.5 9320.6 9656.6 9895.7 17:12:02 INFO - PROCESS | 9247 | -------- Summary: end -------- 17:12:02 INFO - PROCESS | 9247 | 17:12:02 INFO - PROCESS | 9247 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:12:02 INFO - PROCESS | 9247 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:12:02 INFO - PROCESS | 9247 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:12:02 INFO - PROCESS | 9247 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:12:02 INFO - PROCESS | 9247 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:12:03 INFO - TEST-INFO | 9247: exit 0 17:12:03 INFO - TEST-OK | dromaeo_css | took 1111940ms 17:12:03 INFO - TEST-START | kraken 17:12:03 INFO - operating with platform_type : linux_ 17:12:03 INFO - Initialising browser for kraken test... 17:12:03 INFO - TEST-INFO | started process 9434 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiJjITP/profile http://localhost:42970/getInfo.html) 17:12:07 INFO - PROCESS | 9434 | __metrics Screen width/height:1600/1200 17:12:07 INFO - PROCESS | 9434 | colorDepth:24 17:12:07 INFO - PROCESS | 9434 | Browser inner width/height: 1024/697 17:12:07 INFO - PROCESS | 9434 | __metrics 17:12:07 INFO - PROCESS | 9434 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:12:08 INFO - PROCESS | 9434 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:12:08 INFO - PROCESS | 9434 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:12:08 INFO - PROCESS | 9434 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:12:08 INFO - PROCESS | 9434 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:12:08 INFO - PROCESS | 9434 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:12:08 INFO - PROCESS | 9434 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:12:08 INFO - PROCESS | 9434 | 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. 17:12:08 INFO - TEST-INFO | 9434: exit 0 17:12:08 INFO - Browser initialized. 17:12:08 INFO - Running cycle 1/1 for kraken test... 17:12:08 INFO - TEST-INFO | started process 9517 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiJjITP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:12:20 INFO - PROCESS | 9517 | RSS: Main: 150151168 17:12:20 INFO - PROCESS | 9517 | 17:12:23 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:42970/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42970/tests/kraken/driver.html?testName=audio-beat-detection) 17:12:23 INFO - PROCESS | 9517 | RSS: Main: 195760128 17:12:23 INFO - PROCESS | 9517 | 17:12:26 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:42970/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42970/tests/kraken/driver.html?testName=audio-dft) 17:12:26 INFO - PROCESS | 9517 | RSS: Main: 184025088 17:12:26 INFO - PROCESS | 9517 | 17:12:29 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:42970/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42970/tests/kraken/driver.html?testName=audio-fft) 17:12:30 INFO - PROCESS | 9517 | RSS: Main: 168697856 17:12:30 INFO - PROCESS | 9517 | 17:12:32 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:42970/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42970/tests/kraken/driver.html?testName=audio-oscillator) 17:12:32 INFO - PROCESS | 9517 | RSS: Main: 170201088 17:12:32 INFO - PROCESS | 9517 | 17:12:35 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:42970/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42970/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:12:35 INFO - PROCESS | 9517 | RSS: Main: 171433984 17:12:35 INFO - PROCESS | 9517 | 17:12:38 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:42970/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42970/tests/kraken/driver.html?testName=imaging-darkroom) 17:12:39 INFO - PROCESS | 9517 | RSS: Main: 173502464 17:12:39 INFO - PROCESS | 9517 | 17:12:42 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:42970/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42970/tests/kraken/driver.html?testName=imaging-desaturate) 17:12:43 INFO - PROCESS | 9517 | RSS: Main: 172769280 17:12:43 INFO - PROCESS | 9517 | 17:12:46 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:42970/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42970/tests/kraken/driver.html?testName=json-parse-financial) 17:12:46 INFO - PROCESS | 9517 | RSS: Main: 173596672 17:12:46 INFO - PROCESS | 9517 | 17:12:48 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:42970/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42970/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:12:48 INFO - PROCESS | 9517 | RSS: Main: 185847808 17:12:48 INFO - PROCESS | 9517 | 17:12:50 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:42970/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42970/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:12:51 INFO - PROCESS | 9517 | RSS: Main: 184406016 17:12:51 INFO - PROCESS | 9517 | 17:12:53 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:42970/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42970/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:12:53 INFO - PROCESS | 9517 | RSS: Main: 193388544 17:12:53 INFO - PROCESS | 9517 | 17:12:56 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:42970/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42970/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:12:56 INFO - PROCESS | 9517 | RSS: Main: 200151040 17:12:56 INFO - PROCESS | 9517 | 17:12:59 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:42970/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42970/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:13:00 INFO - PROCESS | 9517 | RSS: Main: 198975488 17:13:00 INFO - PROCESS | 9517 | 17:13:01 INFO - PROCESS | 9517 | Cycle 1(1): loaded http://localhost:42970/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42970/tests/kraken/driver.html?testName=ai-astar) 17:13:02 INFO - PROCESS | 9517 | RSS: Main: 260386816 17:13:02 INFO - PROCESS | 9517 | 17:13:02 INFO - PROCESS | 9517 | __start_tp_report 17:13:02 INFO - PROCESS | 9517 | _x_x_mozilla_page_load 17:13:02 INFO - PROCESS | 9517 | _x_x_mozilla_page_load_details 17:13:02 INFO - PROCESS | 9517 | |i|pagename|runs| 17:13:02 INFO - PROCESS | 9517 | |0;ai-astar;111;111;106;111;113;113;102;112;110;111 17:13:02 INFO - PROCESS | 9517 | |1;audio-beat-detection;149;124;149;165;127;153;156;125;168;130 17:13:02 INFO - PROCESS | 9517 | |2;audio-dft;160;160;162;161;160;159;162;162;160;160 17:13:02 INFO - PROCESS | 9517 | |3;audio-fft;72;72;99;97;73;74;72;119;94;73 17:13:02 INFO - PROCESS | 9517 | |4;audio-oscillator;96;96;149;95;95;96;150;95;95;137 17:13:02 INFO - PROCESS | 9517 | |5;imaging-gaussian-blur;119;115;115;127;116;116;114;115;115;116 17:13:02 INFO - PROCESS | 9517 | |6;imaging-darkroom;146;145;147;145;145;145;146;145;146;146 17:13:02 INFO - PROCESS | 9517 | |7;imaging-desaturate;96;96;97;96;97;96;96;96;95;96 17:13:02 INFO - PROCESS | 9517 | |8;json-parse-financial;57;58;56;56;56;56;57;64;54;53 17:13:02 INFO - PROCESS | 9517 | |9;json-stringify-tinderbox;67;67;67;67;68;68;71;67;67;69 17:13:02 INFO - PROCESS | 9517 | |10;stanford-crypto-aes;80;82;82;91;82;82;82;89;81;82 17:13:02 INFO - PROCESS | 9517 | |11;stanford-crypto-ccm;121;119;118;122;115;115;117;117;115;121 17:13:02 INFO - PROCESS | 9517 | |12;stanford-crypto-pbkdf2;158;139;153;154;149;137;153;153;149;148 17:13:02 INFO - PROCESS | 9517 | |13;stanford-crypto-sha256-iterative;69;73;69;68;72;69;67;70;67;71 17:13:02 INFO - PROCESS | 9517 | __end_tp_report 17:13:02 INFO - PROCESS | 9517 | __start_cc_report 17:13:02 INFO - PROCESS | 9517 | _x_x_mozilla_cycle_collect,1089 17:13:02 INFO - PROCESS | 9517 | __end_cc_report 17:13:02 INFO - PROCESS | 9517 | __startTimestamp1456621982044__endTimestamp 17:13:02 INFO - PROCESS | 9517 | 17:13:02 INFO - PROCESS | 9517 | ------- Summary: start ------- 17:13:02 INFO - PROCESS | 9517 | Number of tests: 14 17:13:02 INFO - PROCESS | 9517 | 17:13:02 INFO - PROCESS | 9517 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:3.43 (3.1%) stddev-sans-first:3.62 17:13:02 INFO - PROCESS | 9517 | Values: 111.0 111.0 106.0 111.0 113.0 113.0 102.0 112.0 110.0 111.0 17:13:02 INFO - PROCESS | 9517 | 17:13:02 INFO - PROCESS | 9517 | [#1] audio-beat-detection Cycles:10 Average:144.60 Median:151.00 stddev:16.78 (11.1%) stddev-sans-first:17.72 17:13:02 INFO - PROCESS | 9517 | Values: 149.0 124.0 149.0 165.0 127.0 153.0 156.0 125.0 168.0 130.0 17:13:02 INFO - PROCESS | 9517 | 17:13:02 INFO - PROCESS | 9517 | [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:1.07 (0.7%) stddev-sans-first:1.12 17:13:02 INFO - PROCESS | 9517 | Values: 160.0 160.0 162.0 161.0 160.0 159.0 162.0 162.0 160.0 160.0 17:13:02 INFO - PROCESS | 9517 | 17:13:02 INFO - PROCESS | 9517 | [#3] audio-fft Cycles:10 Average:84.50 Median:73.50 stddev:16.63 (22.6%) stddev-sans-first:17.02 17:13:02 INFO - PROCESS | 9517 | Values: 72.0 72.0 99.0 97.0 73.0 74.0 72.0 119.0 94.0 73.0 17:13:02 INFO - PROCESS | 9517 | 17:13:02 INFO - PROCESS | 9517 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:95.00 stddev:24.35 (25.6%) stddev-sans-first:25.26 17:13:02 INFO - PROCESS | 9517 | Values: 96.0 96.0 149.0 95.0 95.0 96.0 150.0 95.0 95.0 137.0 17:13:02 INFO - PROCESS | 9517 | 17:13:02 INFO - PROCESS | 9517 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:116.00 stddev:3.82 (3.3%) stddev-sans-first:3.97 17:13:02 INFO - PROCESS | 9517 | Values: 119.0 115.0 115.0 127.0 116.0 116.0 114.0 115.0 115.0 116.0 17:13:02 INFO - PROCESS | 9517 | 17:13:02 INFO - PROCESS | 9517 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 17:13:02 INFO - PROCESS | 9517 | Values: 146.0 145.0 147.0 145.0 145.0 145.0 146.0 145.0 146.0 146.0 17:13:02 INFO - PROCESS | 9517 | 17:13:02 INFO - PROCESS | 9517 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 17:13:02 INFO - PROCESS | 9517 | Values: 96.0 96.0 97.0 96.0 97.0 96.0 96.0 96.0 95.0 96.0 17:13:02 INFO - PROCESS | 9517 | 17:13:02 INFO - PROCESS | 9517 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.50 stddev:2.95 (5.2%) stddev-sans-first:3.12 17:13:02 INFO - PROCESS | 9517 | Values: 57.0 58.0 56.0 56.0 56.0 56.0 57.0 64.0 54.0 53.0 17:13:02 INFO - PROCESS | 9517 | 17:13:02 INFO - PROCESS | 9517 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:67.50 stddev:1.32 (2.0%) stddev-sans-first:1.36 17:13:02 INFO - PROCESS | 9517 | Values: 67.0 67.0 67.0 67.0 68.0 68.0 71.0 67.0 67.0 69.0 17:13:02 INFO - PROCESS | 9517 | 17:13:02 INFO - PROCESS | 9517 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:82.00 stddev:3.62 (4.4%) stddev-sans-first:3.64 17:13:02 INFO - PROCESS | 9517 | Values: 80.0 82.0 82.0 91.0 82.0 82.0 82.0 89.0 81.0 82.0 17:13:02 INFO - PROCESS | 9517 | 17:13:02 INFO - PROCESS | 9517 | [#11] stanford-crypto-ccm Cycles:10 Average:118.00 Median:118.50 stddev:2.67 (2.3%) stddev-sans-first:2.60 17:13:02 INFO - PROCESS | 9517 | Values: 121.0 119.0 118.0 122.0 115.0 115.0 117.0 117.0 115.0 121.0 17:13:02 INFO - PROCESS | 9517 | 17:13:02 INFO - PROCESS | 9517 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.30 Median:153.00 stddev:6.65 (4.3%) stddev-sans-first:6.26 17:13:02 INFO - PROCESS | 9517 | Values: 158.0 139.0 153.0 154.0 149.0 137.0 153.0 153.0 149.0 148.0 17:13:02 INFO - PROCESS | 9517 | 17:13:02 INFO - PROCESS | 9517 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.50 stddev:2.01 (2.9%) stddev-sans-first:2.13 17:13:02 INFO - PROCESS | 9517 | Values: 69.0 73.0 69.0 68.0 72.0 69.0 67.0 70.0 67.0 71.0 17:13:02 INFO - PROCESS | 9517 | -------- Summary: end -------- 17:13:02 INFO - PROCESS | 9517 | 17:13:02 INFO - PROCESS | 9517 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:13:02 INFO - PROCESS | 9517 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:13:02 INFO - PROCESS | 9517 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:13:02 INFO - PROCESS | 9517 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:13:02 INFO - PROCESS | 9517 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:13:02 INFO - PROCESS | 9517 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:13:02 INFO - PROCESS | 9517 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:13:02 INFO - TEST-INFO | 9517: exit 0 17:13:02 INFO - TEST-OK | kraken | took 59515ms 17:13:02 INFO - SUITE-END | took 1171s 17:13:03 INFO - Completed test suite (00:19:31) 17:13:03 INFO - Working with test: dromaeo_css 17:13:03 INFO - Generating results file: dromaeo_css 17:13:03 INFO - Working with test: kraken 17:13:03 INFO - Generating results file: kraken 17:13:03 INFO - javascript benchmark 17:13:03 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:13:03 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 17:13:03 INFO - process_Request line: dromaeo_css 6714.61 graph.html#tests=[[72,64,35]] 17:13:03 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:13:03 INFO - process_Request line: kraken 1513.20 graph.html#tests=[[232,64,35]] 17:13:03 INFO - RETURN: dromaeo_css: 6714.61 17:13:03 INFO - RETURN: kraken: 1513.20 17:13:03 INFO - javascript benchmark 17:13:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3123.0630810756775, 3131.091983324836, 3168.461361568533, 3180.395724812287, 3202.1514298710845, 4943.233798761194, 4980.87547811304, 4989.875253118669, 4994.925076123856, 4998.2752500887345, 5055.191169412895, 5096.643234973553, 5135.0, 5142.280080788692, 5164.509371609701, 4557.361969324297, 4578.473475550312, 4698.0, 4736.265878788793, 4781.187198176319, 4687.250039993602, 4707.435107787053, 4735.597474214679, 4740.336352910595, 4795.904081918359, 4543.477500087482, 4587.174308624446, 4663.114008338422, 4683.625309975194, 4693.460252070987, 4648.093621743761, 4651.465081515636, 4651.62786977041, 4653.906921861578, 4692.131955588227, 4619.838305659286, 4625.884352891205, 4635.490096089427, 4645.581897629196, 4647.53524647536, 4899.044686286175, 4959.132151873444, 5039.042581909425, 5047.949520504784, 5059.215821547666, 5306.283651707009, 5323.441038690959, 5325.467453254643, 5327.280817089682, 5334.119870221409, 5297.311349524575, 5342.946570534284, 5364.168553874156, 5379.031774280628, 5407.351117865842, 5118.334616499868, 5139.8458046258675, 5183.585313174937, 5194.974025129888, 5197.350331208599, 5546.417626149277, 5555.444455554493, 5563.415841336682, 5577.107662773937, 5579.023670857584, 5308.681479111266, 5353.437889021675, 5368.57051435892, 5372.382176049804, 5372.677639341652, 5410.1343784995, 5429.511343979061, 5434.64674796137, 5434.809781657623, 5479.17812328146, 5367.275417818622, 5383.515483606416, 5391.81128660495, 5394.32570928634, 5439.102548079522, 5316.308879845596, 5384.6769193848495, 5389.649672771257, 5453.7818487260065, 5519.337679478488, 4125.0, 4137.81379837908, 4142.689298302639, 4169.812358443877, 4181.560936101726, 3757.1734218471893, 3757.887263382103, 3760.1539653578275, 3788.0719223790347, 3792.2036372362113, 5006.89986200274, 5019.573336266459, 5045.697258164522, 5084.13569693153, 5085.974570127126, 5380.381256155514, 5399.136138217945, 5408.621396502207, 5420.945790542123, 5430.51125398716, 5076.137056700296, 5108.489151084862, 5115.079285728604, 5119.206522988943, 5143.305653736773, 4585.839495617637, 4606.792694328763, 4611.769411529477, 4640.419947506562, 4652.534746525388, 5563.221149039137, 5595.328560572757, 5595.692236926927, 5600.047991841397, 5648.63283886546, 5285.814996475105, 5313.654612450178, 5337.092694241911, 5338.866528336823, 5346.010987967238, 5674.0, 5734.655920644775, 5741.196232527366, 5764.711764411679, 5782.363939966516, 5397.271368365377, 5403.162509810985, 5405.540529054917, 5405.756740946588, 5412.215228791882, 5361.142217245222, 5414.512693857571, 5464.071107911585, 5468.808591699271, 5524.972375138259, 5342.091844386541, 5342.9198562022375, 5346.946530534645, 5359.383670877743, 5392.08334583114, 5300.681959082467, 5312.096943519534, 5312.787488500571, 5313.282706834682, 5364.275822763877, 5149.433562308218, 5176.482351764944, 5236.581073514034, 5239.633225674166, 5254.106801843619, 5347.224652425454, 5381.892362152813, 5382.0, 5384.057789886832, 5385.946140538545, 5222.921656175236, 5228.189630607262, 5266.289050978069, 5270.077736396192, 5282.630215885005], "unit": "score", "name": "dojo.html", "value": 5019.857016961191}, {"lowerIsBetter": false, "replicates": [491.1380527174808, 521.9191025391065, 526.5839986410735, 544.6432586655741, 577.1371799160256, 27944.301392465197, 36088.278234435325, 36187.09532261695, 36366.818165909135, 36490.45264321034, 39054.41418378727, 39731.80134099333, 39744.80127599358, 39841.80079099608, 39914.0, 7523.3981281497345, 7646.311831935125, 8354.582270886447, 8568.314534837198, 9826.803463930717, 9886.653967111153, 10130.74673133174, 10138.341007834468, 10139.34094283873, 10145.543450544743, 10062.89937100627, 10156.390616562992, 10158.187345012419, 10159.034891685278, 10159.187265018782, 10009.89990100097, 10092.0, 10104.292699511037, 10109.090181883592, 10111.393316400967, 9992.250581206366, 10110.140638045776, 10125.645602403954, 10129.746756331077, 10449.059584637344, 39022.0, 39304.80347598244, 39459.60540394588, 39527.20945581072, 39630.405543916866, 2991.0578167877047, 3128.968710312913, 3155.5739975103297, 3172.4448221561133, 3222.4521831288503, 29682.55476167859, 30060.24849378783, 30591.0, 30602.0, 31558.526622100686, 3776.546814382292, 3881.243157584272, 3915.275674000319, 3931.9606803932165, 4080.4491393661774, 255302.0, 257021.0, 257645.0, 258055.70972145206, 258216.0, 56933.43066569364, 57382.42617573771, 57416.0, 57443.0, 57445.0, 59908.40091599115, 60968.39031609627, 61017.08474372888, 61110.0, 61170.38829611647, 16164.515064548083, 16575.171241437878, 16615.50153495397, 16656.6668666626, 16720.498385048468, 10113.443760593238, 10121.898781012243, 10128.848067278997, 10166.28835981489, 11495.137864660017, 19523.511912202026, 20651.58696826055, 20676.312079429877, 20730.48173795667, 20735.066921988546, 7723.922760772432, 7854.60726963661, 7911.446198766032, 7918.6436610352675, 8053.919460805317, 897.1342654338595, 931.9207867331353, 1045.2421994054403, 1050.2700623067049, 1062.9734256643646, 25818.096366627076, 25982.35044123874, 26045.609315860278, 26058.0, 26061.478770424863, 972.3873959405671, 1024.0118285854187, 1058.8252938265255, 1082.1505118482112, 1107.2304748199924, 13671.931640341934, 14080.887866819854, 14300.785488217685, 14328.713425731426, 14351.712965740626, 294872.0, 297393.0, 297944.0, 298332.0, 299434.0, 51057.48942510602, 51860.48139518557, 51869.0, 51869.221961670606, 51875.48124518782, 1229.7786398448186, 1291.5673249461347, 1338.7456383287144, 1355.945762169522, 1369.2127026959538, 23473.0, 24707.382315442257, 25482.0, 26634.0, 26762.330941726614, 41746.37380439235, 41986.79006604947, 42326.0, 42356.57643423649, 42381.78809106058, 208948.0, 209627.0, 210725.0, 211010.0, 211620.0, 26863.73136268612, 30998.380032399677, 31034.68965310318, 31259.687403125678, 31528.054158375286, 37148.81425592855, 38040.42939355967, 38336.42495362627, 38357.80821095876, 38366.0, 37380.0, 38742.6125738739, 38910.80544597259, 39086.804565976985, 39235.41146882742, 34855.12862178466, 35943.86510094592, 36477.81761091178, 36798.44802327914, 37252.813735931144, 35496.0, 35975.460368093976, 36324.0, 36671.81664091662, 36688.449673255454, 30946.69053309438, 32397.514037288987, 32677.509837351983, 32724.181895452803, 32976.505352420216, 24695.629565556173, 24944.0, 25069.0, 25074.24777256685, 25397.238082857544], "unit": "score", "name": "ext.html", "value": 18123.70990951259}, {"lowerIsBetter": false, "replicates": [329.84497286275456, 333.4897606661807, 336.3508428732545, 337.2883216413366, 341.48947323750997, 15827.604309892258, 16209.918950405247, 16689.24898379573, 17099.487015389528, 17123.657526849485, 14675.412983480675, 14846.703065938675, 14919.776203356958, 15138.84861151391, 15165.165915874622, 5140.845774626767, 5366.9463305366835, 5386.73066346683, 5386.865328366783, 5411.918821217685, 4835.1296766582, 5007.2489126630935, 5012.448630650625, 5015.0972824891505, 5019.121653710605, 4968.478309777457, 4979.875503112433, 4989.875253118665, 5234.528892399683, 5857.238558987326, 5852.356240813507, 5872.236609240814, 5893.499052580536, 5909.349971503131, 5942.078977758454, 4930.852074437773, 5089.618278629117, 5098.923516147261, 5100.030994111107, 5127.154019586801, 12439.502419903192, 12535.24788512692, 12570.057245706608, 12667.11330206886, 12681.36593170347, 1980.9504762380911, 2075.0662202009157, 2122.5012122151284, 2182.6071307164702, 2406.38637147528, 9024.593893274818, 9411.90588094117, 9562.18721408681, 12045.337506437143, 12827.230366178059, 1759.7008508553577, 1883.6797744383487, 1885.198790514026, 1894.2423030787795, 1913.0817207740224, 51471.74264128693, 59449.702751485966, 61581.38418615846, 62534.37465625376, 64107.67946160286, 8785.209331160226, 8822.735317940473, 9195.586198620944, 9239.630414783467, 9361.859572106423, 11364.94317528407, 11622.360770157722, 11623.360715160747, 11634.185607007597, 11727.0, 6693.062971184038, 6894.207166175854, 6983.650817459208, 6985.545939513915, 7101.289871012961, 6874.484413668994, 6875.0, 6887.621180835002, 6989.217749473852, 7004.859902801915, 4042.2723909696538, 4084.6732261419015, 4091.1204091120553, 4105.240530501807, 4165.062860856283, 1620.66776310856, 1646.9906713809135, 1651.8513333799776, 1660.6346603747156, 1682.2682133272067, 854.2918946938221, 913.0869130869131, 922.5064590444081, 928.4986107502008, 960.7357976556364, 15933.0, 16414.83585164157, 16546.338146474005, 16683.49949501517, 16686.49940501787, 915.9816803664023, 937.6624415210518, 949.4967667136428, 962.153305091515, 999.0708640963828, 9257.0, 9470.763230919281, 9567.0, 9588.712338629852, 9684.51577421126, 393544.0, 395523.0, 397862.0, 404752.0, 408925.0, 70686.29313706797, 73127.0, 73192.97438640926, 74583.62708186424, 74753.25246747572, 963.7638778499453, 983.6753871222479, 1025.4462590201356, 1034.255336157965, 1034.6120204923154, 14275.785863211853, 14365.13809171453, 14873.107613543221, 14893.553193403783, 15163.317650705965, 30196.698033019387, 30937.381252375275, 31021.224469388446, 31512.0, 31808.840955795073, 42056.57943420527, 44881.775591121834, 48464.788380290775, 48605.5139448601, 49021.26468103052, 7331.74338898136, 7453.850922981618, 7564.50830696003, 7633.160352361125, 7649.158592554703, 8691.435056721293, 11376.089912807121, 11890.76218475643, 12149.149559530748, 12182.208156469802, 9917.553710083208, 10284.588616455258, 10423.061924426838, 10830.566777328819, 10927.726806829574, 10414.323069000491, 10614.469276535989, 10698.572057117628, 10709.196810239107, 10906.454677265947, 10568.20738444635, 10725.356478611307, 10791.190660700322, 10795.56817727282, 11069.893010698866, 7294.781156565312, 7360.153582337885, 7387.002754628056, 7445.664945077593, 7720.266574675396, 9647.0, 10361.171106311627, 10434.21743369235, 10517.316374435637, 10839.891601083888], "unit": "score", "name": "jquery.html", "value": 7948.564633990399}, {"lowerIsBetter": false, "replicates": [1292.2052937443475, 1447.8624530669586, 1463.8975271730976, 1603.7353836616958, 1761.409927674229, 7411.703531858726, 7552.84894302115, 7580.886286705704, 7591.468597198198, 7593.506422082568, 7195.352418282354, 7315.158756742976, 7317.6707048182825, 7329.413646908248, 7331.816704582388, 1917.5302050997525, 2179.6512557990723, 2215.77024751263, 2218.4121207879925, 2243.1363924888956, 2202.273249827553, 2239.2386588559884, 2243.1924507177405, 2243.6298010828195, 2244.517428752818, 2182.3889310992868, 2241.2603840732518, 2244.5847518209102, 2245.259064508708, 2246.528229071897, 2198.9890050549725, 2202.7466841313294, 2207.602631526325, 2234.5754306681843, 2240.171136679423, 2226.3543572363997, 2245.65192395179, 2256.8420210585264, 2261.5816074026193, 2264.7395549511853, 7367.5211111277595, 7471.25287471254, 7501.549907005598, 7520.736774212876, 7525.2098529654695, 4547.5452454754595, 4628.467726211461, 4660.743659098748, 4671.85984420468, 4684.36761037259, 2927.6925922778014, 2975.687552806946, 3014.351914338406, 3029.9394012119856, 3103.255218747507, 967.3083745122271, 969.1132613658494, 975.229568640773, 988.4316518002178, 1004.6985904228702, 10321.43232122233, 10370.63702770407, 10398.428086455242, 10482.580696772196, 10500.474976251156, 4133.586641335903, 4206.789660516962, 4236.279832428495, 4273.957260427356, 4291.399204111427, 9103.81792364149, 9122.270218382513, 9138.725838224864, 9173.266138708887, 9177.678781242625, 4176.624103830609, 4726.669133160645, 4730.479647238801, 4753.33453316536, 4756.738379389098, 4132.669386449077, 4177.060161463707, 4207.03238255203, 4212.620864122244, 4240.300350442142, 3421.196018935548, 3495.2834668892815, 3516.7186625069935, 3540.8406621702084, 3566.4293713005795, 1077.2190162132392, 1088.2599832114238, 1094.7591529863416, 1099.483242875847, 1102.2064113838023, 1296.4166125243678, 1310.4299629660936, 1316.861729518406, 1383.5295999360267, 1384.2732565403244, 7085.89371159433, 7194.64026798658, 7198.49610527258, 7227.566346019255, 7287.781366559012, 1059.7880423915094, 1081.864766904137, 1090.8363745438248, 1098.1983152298708, 1111.6220485034964, 5438.510534051875, 5475.315585551806, 5508.944910550923, 5520.337559492807, 5524.972375138099, 8872.423292485968, 8974.37179397449, 8984.910150898539, 9202.815943681222, 9325.207357374698, 9103.49930753815, 9115.589798459085, 9139.81720365589, 9150.725478235663, 9156.084391560924, 7126.5011449198055, 7254.383377412979, 7352.375048120863, 7372.852542949111, 7397.519161254609, 7064.894026589708, 7067.222605513287, 7075.5047146699235, 7097.9290207097265, 7109.395701365442, 8078.919210807817, 8279.875801863098, 8340.874886876823, 8507.95746021266, 8534.70128545498, 8353.707620233263, 8593.398462107592, 8607.354448416268, 8650.264727498234, 8715.34634902372, 6399.488040956619, 6426.614403135827, 6448.161738973903, 6494.0258961156205, 6497.415232629086, 7380.704771809067, 7388.261173882569, 7420.332170104716, 7423.331900129015, 7454.142773581108, 6606.669666516751, 6758.290379510081, 6776.28848970851, 6893.655317234018, 7080.079589653312, 6723.932760672331, 6746.257911629815, 6838.93161068383, 6841.3842754152365, 6859.2454829969665, 6883.965580172067, 6917.066196063467, 6963.8607227854145, 7001.964990175016, 7013.579185248901, 6469.256035555972, 6470.6117632940295, 6506.25178104524, 6547.410733034049, 6548.98490733937, 6504.089427480251, 6582.144321238208, 6593.241777195684, 6595.0, 6598.538102332791], "unit": "score", "name": "mootools.html", "value": 4411.799149611493}, {"lowerIsBetter": false, "replicates": [310.0496976766212, 311.5855911637522, 312.2615015488371, 318.8198667752718, 319.120822135018, 5879.67661778602, 5888.617239879405, 5904.85237869053, 5927.762889484421, 5932.40675932406, 5842.415758424156, 5846.123081537761, 5856.121581762738, 5857.627660797373, 5865.1202319652075, 4303.763293018883, 4371.038371558268, 4439.511653718088, 4502.2571275739465, 4518.683692141552, 4474.597286244254, 4494.280915053592, 4501.279795232764, 4512.97743511282, 4515.571020753023, 4253.29820579604, 4447.73313601185, 4447.933281000787, 4448.510663826976, 4452.487963884146, 4297.935530967038, 4412.0, 4415.867523974286, 4433.6674749393605, 4444.400005999181, 3846.0961674006585, 3849.172427928009, 3851.229754049173, 3863.787491687956, 3878.4376265441633, 5573.386927437979, 5575.080111781551, 5578.330600327946, 5578.86052848678, 5590.0, 5118.795248190068, 5120.539151476348, 5122.846314610568, 5127.3847138343635, 5128.71792051437, 6126.601770884923, 6183.443490085869, 6184.381561843825, 6187.195664563623, 6192.721327540272, 4018.698597605162, 4131.35963925592, 4139.689523285766, 4140.875773726793, 4263.104748002923, 6413.7755178569, 6468.3855033771715, 6477.125588045647, 6489.253735820346, 6490.156279683658, 4218.578142185757, 4223.472065991751, 4224.429701990192, 4228.386883901817, 4230.534641189467, 4275.828966841354, 4276.059266961263, 4276.251655960256, 4276.743395396286, 4279.2083464559155, 5038.5969122470115, 5044.1677123274985, 5044.974775126174, 5046.772895219724, 5049.722265275445, 5964.612300200473, 6241.001439769615, 6243.531735119885, 6247.187865577446, 6249.875002499924, 1447.826260848684, 1453.273363318341, 1454.0621299261916, 1455.5778824141091, 1459.0807791091756, 923.7967647117623, 955.302629080775, 971.8590804333473, 997.8602995580625, 1001.8797744270735, 5957.731902064417, 5976.223090998229, 5976.760929562769, 5980.162777211194, 5980.940190598125, 6371.458426033746, 6372.171617689671, 6377.0, 6382.297947225801, 6408.775692850728, 5964.493018093423, 5966.492848107872, 5967.880642387215, 5967.940320596738, 5973.701314934236, 3394.9490757638655, 3439.1402149462633, 3443.0875817908272, 3444.6727560881677, 3445.0, 6532.183477065367, 6697.22981857083, 6707.463402927851, 6710.228323742832, 6720.361565651256, 6452.0, 6477.287498375175, 6489.610623362519, 6490.675466226669, 6529.0, 6629.270780214269, 6686.4985126115735, 6706.59760414367, 6732.899006514906, 6744.7976560703255, 6319.24169099711, 6323.7786677466065, 6325.841853953688, 6327.873442531031, 6338.936610633835, 6069.393060694072, 6232.127502149793, 6251.78118765841, 6265.498760099273, 6267.717952692049, 6673.432758215606, 6700.966495167493, 6712.83217919556, 6719.764808231884, 6719.932800671931, 4166.0626359068965, 4169.812358443938, 4187.24629566681, 4190.748555086705, 4193.895152621087, 6274.372562743689, 6312.652804095819, 6327.651979141191, 6337.556371053982, 6343.207099112611, 6136.2636483622255, 6151.200343955257, 6153.661548614869, 6155.753769849335, 6158.938410615837, 6014.188084608521, 6087.05650624154, 6147.200863887666, 6150.876982460415, 6158.199434073542, 6020.0, 6028.728707208098, 6035.215421995113, 6037.366076562073, 6039.547033972557, 6170.457385653586, 6170.845728856814, 6171.444569988723, 6173.197484327009, 6182.876342473035, 5893.941060589339, 5999.640021598718, 6029.457348838626, 6037.69811509414, 6038.396160383926], "unit": "score", "name": "prototype.html", "value": 4614.7361147753545}, {"lowerIsBetter": false, "replicates": [736.9005184300121, 770.1259070954465, 788.5111231036758, 840.8612578924477, 872.8297981893529, 13137.211767293957, 13291.93354033231, 13327.067105302633, 13384.263865487394, 13409.865901340983, 14929.104253744783, 15093.094414335148, 15096.924515377408, 15099.245037748096, 15120.017198882066, 697.1703672629554, 825.6821123867325, 826.3884725303277, 834.5827086456741, 848.0544193224541, 830.3855147191065, 839.995800020999, 841.4951029382382, 842.5913431985482, 843.1863251961855, 878.1876763993313, 880.058337578791, 881.8677198420256, 883.1874675298709, 885.3890815337429, 714.5355518912722, 723.0564113831448, 864.6195673903462, 873.135595760196, 881.1496905486173, 643.7425029988042, 647.1942431672551, 647.427027081032, 647.5402464250387, 647.6211416321457, 14242.643933901632, 14271.500497482539, 14288.857111428857, 14313.57059288223, 14318.713625727427, 12220.083493738006, 12373.69065773354, 12553.184043037265, 12684.23894566329, 13031.283279419627, 9984.850227246525, 10072.194224462026, 10228.130608898253, 10313.89686103137, 10525.47372631373, 3543.7165026797793, 3549.591796943333, 3579.785212887209, 3588.659077387644, 3743.6630703236565, 49849.75075124637, 50754.49245507535, 50841.23738143931, 50852.491475085146, 50856.0, 9829.45937973404, 9902.0, 9927.553260103312, 9945.353552019096, 10095.343802652804, 17863.910680446515, 17889.19498622565, 17889.552761180814, 17896.642067158584, 17930.731039034425, 7514.323710865939, 7525.510841795266, 7631.809204769926, 7638.197989211164, 7819.335356494648, 4390.626796722315, 4405.449318835145, 4413.095315460323, 4445.2887537993765, 4450.265706158512, 3149.3071524264624, 3174.158847905307, 3176.0630613968933, 3176.745860331168, 3183.3474137801695, 561.2311133746794, 591.4972273567433, 591.8905002574537, 591.9200907877467, 596.9731362088629, 617.5029101573186, 672.3411057164006, 693.8716337477482, 698.5319835710086, 732.827785470414, 8136.355684402474, 8334.958325208336, 8401.747947561584, 8485.490870547786, 8509.106543812934, 619.8605313804449, 624.2290770897937, 627.8053803320985, 629.5058379172419, 640.2541039688804, 3844.7116466265143, 3858.151206734514, 3923.4114882767244, 3973.7615743055508, 4024.2957482440456, 52106.739466302424, 55280.0, 55534.0, 55545.0, 55803.441965580634, 46844.0, 47605.28592071122, 48810.26784598234, 49064.26403603949, 49234.50765492299, 44246.11507769827, 44424.11151776947, 44500.332495012604, 45200.0, 45288.0, 7561.168271490242, 7947.324477419253, 8095.352371810123, 8149.511029338259, 8176.2821150668815, 32536.0, 34016.82991585026, 34646.65353346535, 35555.0, 35647.46528802018, 21105.6834147491, 21242.78757212408, 21260.893695531424, 38599.42100868433, 43245.3513197296, 10109.0, 10208.59165633396, 10559.0, 10842.295250808673, 10953.56185752561, 11419.543218271176, 11539.4807233673, 11874.940625296818, 11918.642440726791, 12333.814992775295, 10546.736331591772, 10911.781764364827, 11048.889511104786, 11073.446327683423, 11394.202405831513, 10990.96503732676, 11126.221164518405, 11178.217524773512, 11292.378919159524, 11417.942910285396, 10664.946675266574, 10890.29213101146, 10956.945215273872, 11086.61196858106, 11295.096392288762, 9597.856032159663, 9604.66383676568, 9631.0, 9871.605135794487, 10101.24240681937, 8374.706885258987, 9005.549722513717, 9320.580573874056, 9656.624522258171, 9895.65365212214], "unit": "score", "name": "yui.html", "value": 6224.352734115963}], "name": "dromaeo_css", "value": 6714.606280385873}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 106.0, 111.0, 113.0, 113.0, 102.0, 112.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.0}, {"lowerIsBetter": true, "replicates": [149.0, 124.0, 149.0, 165.0, 127.0, 153.0, 156.0, 125.0, 168.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 144.6}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 162.0, 161.0, 160.0, 159.0, 162.0, 162.0, 160.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 99.0, 97.0, 73.0, 74.0, 72.0, 119.0, 94.0, 73.0], "unit": "score", "name": "audio-fft", "value": 84.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 149.0, 95.0, 95.0, 96.0, 150.0, 95.0, 95.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 110.4}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 115.0, 127.0, 116.0, 116.0, 114.0, 115.0, 115.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 147.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 56.0, 56.0, 56.0, 56.0, 57.0, 64.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 68.0, 68.0, 71.0, 67.0, 67.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 82.0, 91.0, 82.0, 82.0, 82.0, 89.0, 81.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [121.0, 119.0, 118.0, 122.0, 115.0, 115.0, 117.0, 117.0, 115.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.0}, {"lowerIsBetter": true, "replicates": [158.0, 139.0, 153.0, 154.0, 149.0, 137.0, 153.0, 153.0, 149.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.3}, {"lowerIsBetter": true, "replicates": [69.0, 73.0, 69.0, 68.0, 72.0, 69.0, 67.0, 70.0, 67.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.5}], "name": "kraken", "value": 1513.1999999999998}]} 17:13:03 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1513.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6714.61"}}} 17:13:03 INFO - Return code: 0 17:13:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:13:03 INFO - # TBPL SUCCESS # 17:13:03 INFO - Running post-action listener: _resource_record_post_action 17:13:03 INFO - Running post-run listener: _resource_record_post_run 17:13:04 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 552353792; Read time: 12; Write time: 473152 17:13:04 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 252596224; Read time: 0; Write time: 278736 17:13:04 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 299573248; Read time: 12; Write time: 194400 17:13:04 INFO - Running post-run listener: _upload_blobber_files 17:13:04 INFO - Blob upload gear active. 17:13:04 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:13:04 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 17:13:04 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'] 17:13:04 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 17:13:04 INFO - (blobuploader) - INFO - Open directory for files ... 17:13:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 17:13:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:13:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:13:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:13:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:13:05 INFO - (blobuploader) - INFO - Done attempting. 17:13:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:13:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:13:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:13:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:13:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:13:06 INFO - (blobuploader) - INFO - Done attempting. 17:13:06 INFO - (blobuploader) - INFO - Iteration through files over. 17:13:06 INFO - Return code: 0 17:13:06 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:13:06 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:13:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/58464d9d631699d12bf238584552298dff58609bfc600ccb5037bc0d29a247ba0f83f25d200d42877a61aeb6c9ad2ea4f194737a3136a74e3d64349ed2ea726d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98b318792e4ad9d1c31a9de1f739feb123bffeba787b760f51bdea95eac1b320e8412faef6f5c3d642234bf2f3a8afaa20847104b94d6e2ebb454864f2184cbd"} 17:13:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:13:06 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:13:06 INFO - Contents: 17:13:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/58464d9d631699d12bf238584552298dff58609bfc600ccb5037bc0d29a247ba0f83f25d200d42877a61aeb6c9ad2ea4f194737a3136a74e3d64349ed2ea726d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98b318792e4ad9d1c31a9de1f739feb123bffeba787b760f51bdea95eac1b320e8412faef6f5c3d642234bf2f3a8afaa20847104b94d6e2ebb454864f2184cbd"} 17:13:06 INFO - Running post-run listener: copy_logs_to_upload_dir 17:13:06 INFO - Copying logs to upload dir... 17:13:06 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 17:13:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.972456 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-02-27 17:13:06.459846) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-27 17:13:06.463630) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1456618433.889777-1847586165 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/58464d9d631699d12bf238584552298dff58609bfc600ccb5037bc0d29a247ba0f83f25d200d42877a61aeb6c9ad2ea4f194737a3136a74e3d64349ed2ea726d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98b318792e4ad9d1c31a9de1f739feb123bffeba787b760f51bdea95eac1b320e8412faef6f5c3d642234bf2f3a8afaa20847104b94d6e2ebb454864f2184cbd"} build_url:https://queue.taskcluster.net/v1/task/I2fdZ7toTSmvX3IV9wZzSQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011304 build_url: 'https://queue.taskcluster.net/v1/task/I2fdZ7toTSmvX3IV9wZzSQ/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/58464d9d631699d12bf238584552298dff58609bfc600ccb5037bc0d29a247ba0f83f25d200d42877a61aeb6c9ad2ea4f194737a3136a74e3d64349ed2ea726d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98b318792e4ad9d1c31a9de1f739feb123bffeba787b760f51bdea95eac1b320e8412faef6f5c3d642234bf2f3a8afaa20847104b94d6e2ebb454864f2184cbd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-27 17:13:06.487787) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 17:13:06.488068) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1456618433.889777-1847586165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004611 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 17:13:06.571139) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-27 17:13:06.571456) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-27 17:13:06.571751) ========= ========= Total master_lag: 0.27 =========