builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-042 starttime: 1458796166.54 results: success (0) buildid: 20160323193749 builduid: 96814e8575414833b496eaafadc6e0d4 revision: e6bd5cd06759d78f752c215c9ea6adab4c25a995 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-23 22:09:26.544116) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-23 22:09:26.544509) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-23 22:09:26.544812) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1458791551.447470-837921025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006333 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-23 22:09:26.594552) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-23 22:09:26.597888) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-23 22:09:26.813661) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 22:09:26.813920) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1458791551.447470-837921025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004542 ========= master_lag: 0.13 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 22:09:26.951469) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-23 22:09:26.954385) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-23 22:09:26.954766) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 22:09:26.955053) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1458791551.447470-837921025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-23 22:09:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 229M=0s 2016-03-23 22:09:27 (229 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.185138 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 22:09:27.216065) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 22:09:27.216392) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1458791551.447470-837921025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018972 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 22:09:27.296785) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 22:09:27.297105) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e6bd5cd06759d78f752c215c9ea6adab4c25a995 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e6bd5cd06759d78f752c215c9ea6adab4c25a995 --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=74d6aec007b0fa31a864ebd7000001f8-1458791551.447470-837921025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-23 22:09:27,532 truncating revision to first 12 chars 2016-03-23 22:09:27,532 Setting DEBUG logging. 2016-03-23 22:09:27,532 attempt 1/10 2016-03-23 22:09:27,532 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e6bd5cd06759?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-23 22:09:27,955 unpacking tar archive at: mozilla-aurora-e6bd5cd06759/testing/mozharness/ program finished with exit code 0 elapsedTime=0.704499 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 22:09:28.019099) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-23 22:09:28.019438) ========= echo e6bd5cd06759d78f752c215c9ea6adab4c25a995 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'e6bd5cd06759d78f752c215c9ea6adab4c25a995'] 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=74d6aec007b0fa31a864ebd7000001f8-1458791551.447470-837921025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False e6bd5cd06759d78f752c215c9ea6adab4c25a995 program finished with exit code 0 elapsedTime=0.003751 script_repo_revision: 'e6bd5cd06759d78f752c215c9ea6adab4c25a995' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-23 22:09:28.068701) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-23 22:09:28.069046) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-23 22:09:28.078517) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-03-23 22:09:28.078807) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1458791551.447470-837921025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:09:28 INFO - MultiFileLogger online at 20160323 22:09:28 in /builds/slave/test-pgo 22:09:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 22:09:28 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:09:28 INFO - {'append_to_log': False, 22:09:28 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:09:28 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 22:09:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:09:28 INFO - 'branch': 'Mozilla-Aurora', 22:09:28 INFO - 'buildbot_json_path': 'buildprops.json', 22:09:28 INFO - 'config_files': ('talos/linux_config.py',), 22:09:28 INFO - 'default_actions': ('clobber', 22:09:28 INFO - 'read-buildbot-config', 22:09:28 INFO - 'download-and-extract', 22:09:28 INFO - 'populate-webroot', 22:09:28 INFO - 'create-virtualenv', 22:09:28 INFO - 'install', 22:09:28 INFO - 'run-tests'), 22:09:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:09:28 INFO - 'download_minidump_stackwalk': True, 22:09:28 INFO - 'download_symbols': 'ondemand', 22:09:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:09:28 INFO - 'tooltool.py': '/tools/tooltool.py', 22:09:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:09:28 INFO - '/tools/misc-python/virtualenv.py')}, 22:09:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:09:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:09:28 INFO - 'installer_path': 'installer.exe', 22:09:28 INFO - 'log_level': 'info', 22:09:28 INFO - 'log_name': 'talos', 22:09:28 INFO - 'log_to_console': True, 22:09:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:09:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:09:28 INFO - 'opt_config_files': (), 22:09:28 INFO - 'pip_index': False, 22:09:28 INFO - 'sps_profile': False, 22:09:28 INFO - 'sps_profile_interval': 0, 22:09:28 INFO - 'suite': 'dromaeojs-e10s', 22:09:28 INFO - 'system_bits': '32', 22:09:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:09:28 INFO - 'title': 'talos-linux64-ix-042', 22:09:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:09:28 INFO - 'use_talos_json': True, 22:09:28 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:09:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:09:28 INFO - 'work_dir': 'build'} 22:09:28 INFO - ##### 22:09:28 INFO - ##### Running clobber step. 22:09:28 INFO - ##### 22:09:28 INFO - Running pre-action listener: _resource_record_pre_action 22:09:28 INFO - Running main action method: clobber 22:09:28 INFO - rmtree: /builds/slave/test-pgo/build 22:09:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:09:28 INFO - Running post-action listener: _resource_record_post_action 22:09:28 INFO - ##### 22:09:28 INFO - ##### Running read-buildbot-config step. 22:09:28 INFO - ##### 22:09:28 INFO - Running pre-action listener: _resource_record_pre_action 22:09:28 INFO - Running main action method: read_buildbot_config 22:09:28 INFO - Using buildbot properties: 22:09:28 INFO - { 22:09:28 INFO - "project": "", 22:09:28 INFO - "product": "firefox", 22:09:28 INFO - "script_repo_revision": "production", 22:09:28 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 22:09:28 INFO - "repository": "", 22:09:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 22:09:28 INFO - "buildid": "20160323193749", 22:09:28 INFO - "pgo_build": "True", 22:09:28 INFO - "basedir": "/builds/slave/test-pgo", 22:09:28 INFO - "buildnumber": 256, 22:09:28 INFO - "slavename": "talos-linux64-ix-042", 22:09:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:09:28 INFO - "platform": "ubuntu64_hw", 22:09:28 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 22:09:28 INFO - "branch": "mozilla-aurora", 22:09:28 INFO - "repo_path": "releases/mozilla-aurora", 22:09:28 INFO - "revision": "e6bd5cd06759d78f752c215c9ea6adab4c25a995", 22:09:28 INFO - "stage_platform": "linux64-pgo", 22:09:28 INFO - "builduid": "96814e8575414833b496eaafadc6e0d4", 22:09:28 INFO - "slavebuilddir": "test" 22:09:28 INFO - } 22:09:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/E1a0LUgGQYi3zUD60zhtSA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 22:09:28 INFO - Running post-action listener: _resource_record_post_action 22:09:28 INFO - ##### 22:09:28 INFO - ##### Running download-and-extract step. 22:09:28 INFO - ##### 22:09:28 INFO - Running pre-action listener: _resource_record_pre_action 22:09:28 INFO - Running main action method: download_and_extract 22:09:28 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:28 INFO - https://queue.taskcluster.net/v1/task/E1a0LUgGQYi3zUD60zhtSA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:09:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1a0LUgGQYi3zUD60zhtSA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 22:09:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1a0LUgGQYi3zUD60zhtSA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 22:09:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1a0LUgGQYi3zUD60zhtSA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 22:09:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1a0LUgGQYi3zUD60zhtSA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:09:34 INFO - Downloaded 1448 bytes. 22:09:34 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 22:09:34 INFO - Using the following test package requirements: 22:09:34 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 22:09:34 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 22:09:34 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 22:09:34 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 22:09:34 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 22:09:34 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 22:09:34 INFO - u'jsshell-linux-x86_64.zip'], 22:09:34 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 22:09:34 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 22:09:34 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 22:09:34 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 22:09:34 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 22:09:34 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 22:09:34 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 22:09:34 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 22:09:34 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 22:09:34 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 22:09:34 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 22:09:34 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 22:09:34 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:09:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:34 INFO - https://queue.taskcluster.net/v1/task/E1a0LUgGQYi3zUD60zhtSA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:09:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1a0LUgGQYi3zUD60zhtSA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 22:09:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1a0LUgGQYi3zUD60zhtSA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 22:09:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1a0LUgGQYi3zUD60zhtSA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 22:09:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1a0LUgGQYi3zUD60zhtSA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:09:36 INFO - Downloaded 23310178 bytes. 22:09:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:09:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:09:37 INFO - Return code: 0 22:09:37 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:09:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:37 INFO - https://queue.taskcluster.net/v1/task/E1a0LUgGQYi3zUD60zhtSA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:09:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1a0LUgGQYi3zUD60zhtSA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 22:09:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1a0LUgGQYi3zUD60zhtSA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 22:09:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1a0LUgGQYi3zUD60zhtSA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 22:09:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1a0LUgGQYi3zUD60zhtSA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:09:41 INFO - Downloaded 23310178 bytes. 22:09:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:09:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:09:43 INFO - Return code: 0 22:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:43 INFO - https://queue.taskcluster.net/v1/task/E1a0LUgGQYi3zUD60zhtSA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:09:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1a0LUgGQYi3zUD60zhtSA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 22:09:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1a0LUgGQYi3zUD60zhtSA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 22:09:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1a0LUgGQYi3zUD60zhtSA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 22:09:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1a0LUgGQYi3zUD60zhtSA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:09:44 INFO - Downloaded 10845161 bytes. 22:09:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:09:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 22:09:44 INFO - Return code: 0 22:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:44 INFO - https://queue.taskcluster.net/v1/task/E1a0LUgGQYi3zUD60zhtSA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:09:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1a0LUgGQYi3zUD60zhtSA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 22:09:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1a0LUgGQYi3zUD60zhtSA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 22:09:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1a0LUgGQYi3zUD60zhtSA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 22:09:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E1a0LUgGQYi3zUD60zhtSA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:09:45 INFO - Downloaded 60448328 bytes. 22:09:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E1a0LUgGQYi3zUD60zhtSA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 22:09:45 INFO - mkdir: /builds/slave/test-pgo/properties 22:09:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:09:45 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:09:45 INFO - Contents: 22:09:45 INFO - build_url:https://queue.taskcluster.net/v1/task/E1a0LUgGQYi3zUD60zhtSA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 22:09:48 INFO - Running post-action listener: _resource_record_post_action 22:09:48 INFO - Running post-action listener: set_extra_try_arguments 22:09:48 INFO - ##### 22:09:48 INFO - ##### Running populate-webroot step. 22:09:48 INFO - ##### 22:09:48 INFO - Running pre-action listener: _resource_record_pre_action 22:09:48 INFO - Running main action method: populate_webroot 22:09:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:09:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:09:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:09:48 INFO - '--tppagecycles', 22:09:48 INFO - '7'], 22:09:48 INFO - 'tests': ['tsvgm']}}, 22:09:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:09:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:09:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:09:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:09:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:09:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:09:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:09:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:09:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:09:48 INFO - 'talos_options': ['--e10s'], 22:09:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:09:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:09:48 INFO - 'tests': ['damp', 'tps']}, 22:09:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:09:48 INFO - 'talos_options': ['--e10s'], 22:09:48 INFO - 'tests': ['damp', 'tps']}, 22:09:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:09:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:09:48 INFO - 'other': {'tests': ['a11yr', 22:09:48 INFO - 'ts_paint', 22:09:48 INFO - 'tpaint', 22:09:48 INFO - 'sessionrestore', 22:09:48 INFO - 'sessionrestore_no_auto_restore', 22:09:48 INFO - 'tabpaint']}, 22:09:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:09:48 INFO - 'tests': ['a11yr', 22:09:48 INFO - 'ts_paint', 22:09:48 INFO - 'tpaint', 22:09:48 INFO - 'sessionrestore', 22:09:48 INFO - 'sessionrestore_no_auto_restore', 22:09:48 INFO - 'tabpaint']}, 22:09:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:09:48 INFO - 'tests': ['a11yr', 22:09:48 INFO - 'ts_paint', 22:09:48 INFO - 'tpaint', 22:09:48 INFO - 'sessionrestore', 22:09:48 INFO - 'sessionrestore_no_auto_restore', 22:09:48 INFO - 'tabpaint']}, 22:09:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:09:48 INFO - 'tests': ['a11yr', 22:09:48 INFO - 'ts_paint', 22:09:48 INFO - 'tpaint', 22:09:48 INFO - 'sessionrestore', 22:09:48 INFO - 'sessionrestore_no_auto_restore', 22:09:48 INFO - 'tabpaint']}, 22:09:48 INFO - 'other_l64': {'tests': ['a11yr', 22:09:48 INFO - 'ts_paint', 22:09:48 INFO - 'tpaint', 22:09:48 INFO - 'sessionrestore', 22:09:48 INFO - 'sessionrestore_no_auto_restore', 22:09:48 INFO - 'tabpaint']}, 22:09:48 INFO - 'other_nol64': {'tests': ['a11yr', 22:09:48 INFO - 'ts_paint', 22:09:48 INFO - 'tpaint', 22:09:48 INFO - 'sessionrestore', 22:09:48 INFO - 'sessionrestore_no_auto_restore', 22:09:48 INFO - 'tabpaint']}, 22:09:48 INFO - 'svgr': {'tests': ['tsvgx', 22:09:48 INFO - 'tsvgr_opacity', 22:09:48 INFO - 'tart', 22:09:48 INFO - 'tscrollx', 22:09:48 INFO - 'cart']}, 22:09:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:09:48 INFO - 'tests': ['tsvgx', 22:09:48 INFO - 'tsvgr_opacity', 22:09:48 INFO - 'tart', 22:09:48 INFO - 'tscrollx', 22:09:48 INFO - 'cart']}, 22:09:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:09:48 INFO - 'tests': ['tp5o']}, 22:09:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:09:48 INFO - 'talos_options': ['--e10s'], 22:09:48 INFO - 'tests': ['tp5o']}, 22:09:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:09:48 INFO - 'talos_options': ['--xperf_path', 22:09:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:09:48 INFO - 'tests': ['tp5n']}, 22:09:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:09:48 INFO - 'talos_options': ['--e10s', 22:09:48 INFO - '--xperf_path', 22:09:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:09:48 INFO - 'tests': ['tp5n']}}, 22:09:48 INFO - 'talos.zip': {'path': '', 22:09:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:09:48 INFO - Running post-action listener: _resource_record_post_action 22:09:48 INFO - ##### 22:09:48 INFO - ##### Running create-virtualenv step. 22:09:48 INFO - ##### 22:09:48 INFO - Running pre-action listener: _resource_record_pre_action 22:09:48 INFO - Running main action method: create_virtualenv 22:09:48 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:09:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 22:09:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:09:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:09:48 INFO - Using real prefix '/usr' 22:09:48 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:09:48 INFO - Installing distribute.............................................................................................................................................................................................done. 22:09:50 INFO - Installing pip.................done. 22:09:50 INFO - Return code: 0 22:09:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6c4d8a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17be920>, '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 0x17bf820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17bfcb0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1458791551.447470-837921025', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:09:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 22:09:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:09:50 INFO - Using env: {'DISPLAY': ':0', 22:09:50 INFO - 'HOME': '/home/cltbld', 22:09:50 INFO - 'LANG': 'en_US.UTF-8', 22:09:50 INFO - 'LANGUAGE': 'en_US:en', 22:09:50 INFO - 'LOGNAME': 'cltbld', 22:09:50 INFO - 'MAIL': '/var/mail/cltbld', 22:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:50 INFO - 'MOZ_NO_REMOTE': '1', 22:09:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:09:50 INFO - 'NO_EM_RESTART': '1', 22:09:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:09:50 INFO - 'PWD': '/builds/slave/test-pgo', 22:09:50 INFO - 'SHELL': '/bin/bash', 22:09:50 INFO - 'SHLVL': '1', 22:09:50 INFO - 'TERM': 'linux', 22:09:50 INFO - 'TMOUT': '86400', 22:09:50 INFO - 'USER': 'cltbld', 22:09:50 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1458791551.447470-837921025', 22:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:50 INFO - '_': '/tools/buildbot/bin/python'} 22:09:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:09:50 INFO - Cleaning up... 22:09:50 INFO - Return code: 0 22:09:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6c4d8a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17be920>, '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 0x17bf820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17bfcb0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1458791551.447470-837921025', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:09:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 22:09:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:09:50 INFO - Using env: {'DISPLAY': ':0', 22:09:50 INFO - 'HOME': '/home/cltbld', 22:09:50 INFO - 'LANG': 'en_US.UTF-8', 22:09:50 INFO - 'LANGUAGE': 'en_US:en', 22:09:50 INFO - 'LOGNAME': 'cltbld', 22:09:50 INFO - 'MAIL': '/var/mail/cltbld', 22:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:50 INFO - 'MOZ_NO_REMOTE': '1', 22:09:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:09:50 INFO - 'NO_EM_RESTART': '1', 22:09:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:09:50 INFO - 'PWD': '/builds/slave/test-pgo', 22:09:50 INFO - 'SHELL': '/bin/bash', 22:09:50 INFO - 'SHLVL': '1', 22:09:50 INFO - 'TERM': 'linux', 22:09:50 INFO - 'TMOUT': '86400', 22:09:50 INFO - 'USER': 'cltbld', 22:09:50 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1458791551.447470-837921025', 22:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:50 INFO - '_': '/tools/buildbot/bin/python'} 22:09:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:51 INFO - Downloading/unpacking psutil>=0.7.1 22:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:09:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:09:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:09:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:09:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:09:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:09:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:09:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:09:53 INFO - Installing collected packages: psutil 22:09:53 INFO - Running setup.py install for psutil 22:09:53 INFO - building 'psutil._psutil_linux' extension 22:09:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:09:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:09:53 INFO - building 'psutil._psutil_posix' extension 22:09:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:09:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:09:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:09:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:09:53 INFO - Successfully installed psutil 22:09:53 INFO - Cleaning up... 22:09:53 INFO - Return code: 0 22:09:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6c4d8a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17be920>, '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 0x17bf820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17bfcb0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1458791551.447470-837921025', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:09:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 22:09:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:09:53 INFO - Using env: {'DISPLAY': ':0', 22:09:53 INFO - 'HOME': '/home/cltbld', 22:09:53 INFO - 'LANG': 'en_US.UTF-8', 22:09:53 INFO - 'LANGUAGE': 'en_US:en', 22:09:53 INFO - 'LOGNAME': 'cltbld', 22:09:53 INFO - 'MAIL': '/var/mail/cltbld', 22:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:53 INFO - 'MOZ_NO_REMOTE': '1', 22:09:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:09:53 INFO - 'NO_EM_RESTART': '1', 22:09:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:09:53 INFO - 'PWD': '/builds/slave/test-pgo', 22:09:53 INFO - 'SHELL': '/bin/bash', 22:09:53 INFO - 'SHLVL': '1', 22:09:53 INFO - 'TERM': 'linux', 22:09:53 INFO - 'TMOUT': '86400', 22:09:53 INFO - 'USER': 'cltbld', 22:09:53 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1458791551.447470-837921025', 22:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:53 INFO - '_': '/tools/buildbot/bin/python'} 22:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:09:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:09:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:09:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:09:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:09:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:09:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:09:55 INFO - Installing collected packages: mozsystemmonitor 22:09:55 INFO - Running setup.py install for mozsystemmonitor 22:09:55 INFO - Successfully installed mozsystemmonitor 22:09:55 INFO - Cleaning up... 22:09:55 INFO - Return code: 0 22:09:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09: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', '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 0x7f6c4d8a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17be920>, '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 0x17bf820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17bfcb0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1458791551.447470-837921025', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:09: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 22:09: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 blobuploader==1.2.4 22:09:55 INFO - Using env: {'DISPLAY': ':0', 22:09:55 INFO - 'HOME': '/home/cltbld', 22:09:55 INFO - 'LANG': 'en_US.UTF-8', 22:09:55 INFO - 'LANGUAGE': 'en_US:en', 22:09:55 INFO - 'LOGNAME': 'cltbld', 22:09:55 INFO - 'MAIL': '/var/mail/cltbld', 22:09:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:55 INFO - 'MOZ_NO_REMOTE': '1', 22:09:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:09:55 INFO - 'NO_EM_RESTART': '1', 22:09:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:09:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:09:55 INFO - 'PWD': '/builds/slave/test-pgo', 22:09:55 INFO - 'SHELL': '/bin/bash', 22:09:55 INFO - 'SHLVL': '1', 22:09:55 INFO - 'TERM': 'linux', 22:09:55 INFO - 'TMOUT': '86400', 22:09:55 INFO - 'USER': 'cltbld', 22:09:55 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1458791551.447470-837921025', 22:09:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:55 INFO - '_': '/tools/buildbot/bin/python'} 22:09:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:56 INFO - Downloading/unpacking blobuploader==1.2.4 22:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:09:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:09:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:09:57 INFO - Downloading blobuploader-1.2.4.tar.gz 22:09:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:09:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:09:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:09:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:09:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:09:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:09:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:09:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:09:58 INFO - Downloading docopt-0.6.1.tar.gz 22:09:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:09:58 INFO - Installing collected packages: blobuploader, requests, docopt 22:09:58 INFO - Running setup.py install for blobuploader 22:09:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:09:58 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:09:58 INFO - Running setup.py install for requests 22:09:59 INFO - Running setup.py install for docopt 22:09:59 INFO - Successfully installed blobuploader requests docopt 22:09:59 INFO - Cleaning up... 22:09:59 INFO - Return code: 0 22:09:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:59 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 0x7f6c4d8a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17be920>, '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 0x17bf820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17bfcb0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1458791551.447470-837921025', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:09:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:09:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:09:59 INFO - Using env: {'DISPLAY': ':0', 22:09:59 INFO - 'HOME': '/home/cltbld', 22:09:59 INFO - 'LANG': 'en_US.UTF-8', 22:09:59 INFO - 'LANGUAGE': 'en_US:en', 22:09:59 INFO - 'LOGNAME': 'cltbld', 22:09:59 INFO - 'MAIL': '/var/mail/cltbld', 22:09:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:59 INFO - 'MOZ_NO_REMOTE': '1', 22:09:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:09:59 INFO - 'NO_EM_RESTART': '1', 22:09:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:09:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:09:59 INFO - 'PWD': '/builds/slave/test-pgo', 22:09:59 INFO - 'SHELL': '/bin/bash', 22:09:59 INFO - 'SHLVL': '1', 22:09:59 INFO - 'TERM': 'linux', 22:09:59 INFO - 'TMOUT': '86400', 22:09:59 INFO - 'USER': 'cltbld', 22:09:59 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1458791551.447470-837921025', 22:09:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:59 INFO - '_': '/tools/buildbot/bin/python'} 22:09:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:09:59 INFO - Running setup.py (path:/tmp/pip-FRYsRT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:09:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:09:59 INFO - Running setup.py (path:/tmp/pip-_lppJX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:09:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:09:59 INFO - Running setup.py (path:/tmp/pip-DqTZcM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:09:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:09:59 INFO - Running setup.py (path:/tmp/pip-QjKlC8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:09:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:09:59 INFO - Running setup.py (path:/tmp/pip-ImQWEb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:09:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:09:59 INFO - Running setup.py (path:/tmp/pip-lGdfni-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:09:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:09:59 INFO - Running setup.py (path:/tmp/pip-BJYVvB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:10:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:10:00 INFO - Running setup.py (path:/tmp/pip-I_UhWO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:10:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:10:00 INFO - Running setup.py (path:/tmp/pip-6GJDLe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:10:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:10:00 INFO - Running setup.py (path:/tmp/pip-1q7vG2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:10:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:10:00 INFO - Running setup.py (path:/tmp/pip-9Am15G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:10:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:10:00 INFO - Running setup.py (path:/tmp/pip-xqvU_u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:10:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:10:00 INFO - Running setup.py (path:/tmp/pip-dIqIvR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:10:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:10:00 INFO - Running setup.py (path:/tmp/pip-VncqDG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:10:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:10:00 INFO - Running setup.py (path:/tmp/pip-tyL_PM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:10:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:10:00 INFO - Running setup.py (path:/tmp/pip-xwY7Jv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:10:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:10:00 INFO - Running setup.py (path:/tmp/pip-IrIeyS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:10:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:10:00 INFO - Running setup.py install for manifestparser 22:10:00 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:10:00 INFO - Running setup.py install for mozcrash 22:10:00 INFO - Running setup.py install for mozdebug 22:10:01 INFO - Running setup.py install for mozdevice 22:10:01 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:10:01 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:10:01 INFO - Running setup.py install for mozfile 22:10:01 INFO - Running setup.py install for mozhttpd 22:10:01 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:10:01 INFO - Running setup.py install for mozinfo 22:10:01 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:10:01 INFO - Running setup.py install for mozInstall 22:10:01 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:10:01 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:10:01 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:10:01 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:10:01 INFO - Running setup.py install for mozleak 22:10:01 INFO - Running setup.py install for mozlog 22:10:01 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:10:01 INFO - Running setup.py install for moznetwork 22:10:01 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:10:01 INFO - Running setup.py install for mozprocess 22:10:02 INFO - Running setup.py install for mozprofile 22:10:02 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:10:02 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:10:02 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:10:02 INFO - Running setup.py install for mozrunner 22:10:02 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:10:02 INFO - Running setup.py install for mozscreenshot 22:10:02 INFO - Running setup.py install for moztest 22:10:02 INFO - Running setup.py install for mozversion 22:10:02 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:10:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:10:02 INFO - Cleaning up... 22:10:02 INFO - Return code: 0 22:10:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:10:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:10:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:02 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 0x7f6c4d8a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17be920>, '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 0x17bf820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17bfcb0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1458791551.447470-837921025', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:10:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:10:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:10:02 INFO - Using env: {'DISPLAY': ':0', 22:10:02 INFO - 'HOME': '/home/cltbld', 22:10:02 INFO - 'LANG': 'en_US.UTF-8', 22:10:02 INFO - 'LANGUAGE': 'en_US:en', 22:10:02 INFO - 'LOGNAME': 'cltbld', 22:10:02 INFO - 'MAIL': '/var/mail/cltbld', 22:10:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:10:02 INFO - 'MOZ_NO_REMOTE': '1', 22:10:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:10:02 INFO - 'NO_EM_RESTART': '1', 22:10:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:10:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:10:02 INFO - 'PWD': '/builds/slave/test-pgo', 22:10:02 INFO - 'SHELL': '/bin/bash', 22:10:02 INFO - 'SHLVL': '1', 22:10:02 INFO - 'TERM': 'linux', 22:10:02 INFO - 'TMOUT': '86400', 22:10:02 INFO - 'USER': 'cltbld', 22:10:02 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1458791551.447470-837921025', 22:10:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:10:02 INFO - '_': '/tools/buildbot/bin/python'} 22:10:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:10:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:10:02 INFO - Running setup.py (path:/tmp/pip-D00QAf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 22:10:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:10:02 INFO - Running setup.py (path:/tmp/pip-LBVXWw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:10:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:10:02 INFO - Running setup.py (path:/tmp/pip-UILYaa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:10:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:10:03 INFO - Running setup.py (path:/tmp/pip-CGitZx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:10:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:10:03 INFO - Running setup.py (path:/tmp/pip-L7StpA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 22:10:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:10:03 INFO - Running setup.py (path:/tmp/pip-BwlBpR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 22:10:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:10:03 INFO - Running setup.py (path:/tmp/pip-IBRvKY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 22:10:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:10:03 INFO - Running setup.py (path:/tmp/pip-3ehN3R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 22:10:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:10:03 INFO - Running setup.py (path:/tmp/pip-U1ZZD5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 22:10:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:10:03 INFO - Running setup.py (path:/tmp/pip-sAqxSa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:10:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:10:03 INFO - Running setup.py (path:/tmp/pip-eLpBvI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 22:10:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:10:03 INFO - Running setup.py (path:/tmp/pip-EsL6VB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 22:10:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:10:03 INFO - Running setup.py (path:/tmp/pip-fBk5Iq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 22:10:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:10:03 INFO - Running setup.py (path:/tmp/pip-OJhq6G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 22:10:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:10:03 INFO - Running setup.py (path:/tmp/pip-Rcuv1H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 22:10:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:10:03 INFO - Running setup.py (path:/tmp/pip-DYXtp7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 22:10:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:10:03 INFO - Running setup.py (path:/tmp/pip-yYU1gA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:10:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 22:10:04 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:10:04 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:10:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:10:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:10:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:10:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:10:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:10:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:10:05 INFO - Downloading blessings-1.6.tar.gz 22:10:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:10:05 INFO - Installing collected packages: blessings 22:10:05 INFO - Running setup.py install for blessings 22:10:06 INFO - Successfully installed blessings 22:10:06 INFO - Cleaning up... 22:10:06 INFO - Return code: 0 22:10:06 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:10:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:10:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:10:06 INFO - Reading from file tmpfile_stdout 22:10:06 INFO - Current package versions: 22:10:06 INFO - argparse == 1.2.1 22:10:06 INFO - blessings == 1.6 22:10:06 INFO - blobuploader == 1.2.4 22:10:06 INFO - docopt == 0.6.1 22:10:06 INFO - manifestparser == 1.1 22:10:06 INFO - mozInstall == 1.12 22:10:06 INFO - mozcrash == 0.17 22:10:06 INFO - mozdebug == 0.1 22:10:06 INFO - mozdevice == 0.48 22:10:06 INFO - mozfile == 1.2 22:10:06 INFO - mozhttpd == 0.7 22:10:06 INFO - mozinfo == 0.9 22:10:06 INFO - mozleak == 0.1 22:10:06 INFO - mozlog == 3.1 22:10:06 INFO - moznetwork == 0.27 22:10:06 INFO - mozprocess == 0.22 22:10:06 INFO - mozprofile == 0.28 22:10:06 INFO - mozrunner == 6.11 22:10:06 INFO - mozscreenshot == 0.1 22:10:06 INFO - mozsystemmonitor == 0.0 22:10:06 INFO - moztest == 0.7 22:10:06 INFO - mozversion == 1.4 22:10:06 INFO - psutil == 3.1.1 22:10:06 INFO - requests == 1.2.3 22:10:06 INFO - wsgiref == 0.1.2 22:10:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:10:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:10:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:06 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 0x7f6c4d8a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17be920>, '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 0x17bf820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17bfcb0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1458791551.447470-837921025', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:10:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 22:10:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:10:06 INFO - Using env: {'DISPLAY': ':0', 22:10:06 INFO - 'HOME': '/home/cltbld', 22:10:06 INFO - 'LANG': 'en_US.UTF-8', 22:10:06 INFO - 'LANGUAGE': 'en_US:en', 22:10:06 INFO - 'LOGNAME': 'cltbld', 22:10:06 INFO - 'MAIL': '/var/mail/cltbld', 22:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:10:06 INFO - 'MOZ_NO_REMOTE': '1', 22:10:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:10:06 INFO - 'NO_EM_RESTART': '1', 22:10:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:10:06 INFO - 'PWD': '/builds/slave/test-pgo', 22:10:06 INFO - 'SHELL': '/bin/bash', 22:10:06 INFO - 'SHLVL': '1', 22:10:06 INFO - 'TERM': 'linux', 22:10:06 INFO - 'TMOUT': '86400', 22:10:06 INFO - 'USER': 'cltbld', 22:10:06 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1458791551.447470-837921025', 22:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:10:06 INFO - '_': '/tools/buildbot/bin/python'} 22:10:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 22:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 22:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 22:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 22:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 22:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 22:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 22:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:10:06 INFO - Cleaning up... 22:10:06 INFO - Return code: 0 22:10:06 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:10:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:10:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6c4d8a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17be920>, '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 0x17bf820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17bfcb0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1458791551.447470-837921025', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:10:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 22:10:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:10:06 INFO - Using env: {'DISPLAY': ':0', 22:10:06 INFO - 'HOME': '/home/cltbld', 22:10:06 INFO - 'LANG': 'en_US.UTF-8', 22:10:06 INFO - 'LANGUAGE': 'en_US:en', 22:10:06 INFO - 'LOGNAME': 'cltbld', 22:10:06 INFO - 'MAIL': '/var/mail/cltbld', 22:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:10:06 INFO - 'MOZ_NO_REMOTE': '1', 22:10:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:10:06 INFO - 'NO_EM_RESTART': '1', 22:10:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:10:06 INFO - 'PWD': '/builds/slave/test-pgo', 22:10:06 INFO - 'SHELL': '/bin/bash', 22:10:06 INFO - 'SHLVL': '1', 22:10:06 INFO - 'TERM': 'linux', 22:10:06 INFO - 'TMOUT': '86400', 22:10:06 INFO - 'USER': 'cltbld', 22:10:06 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1458791551.447470-837921025', 22:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:10:06 INFO - '_': '/tools/buildbot/bin/python'} 22:10:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:10:06 INFO - Downloading/unpacking jsonschema 22:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:10:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:10:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:10:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:10:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:10:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:10:08 INFO - Downloading/unpacking functools32 (from jsonschema) 22:10: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 22:10: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 22:10: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 22:10: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 22:10: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 22:10: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 22:10:08 INFO - Downloading functools32-3.2.3-2.tar.gz 22:10:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:10:08 INFO - warning: no files found matching '*.txt' 22:10:08 INFO - no previously-included directories found matching 'build' 22:10:08 INFO - no previously-included directories found matching 'dist' 22:10:08 INFO - no previously-included directories found matching '.git*' 22:10:08 INFO - Installing collected packages: jsonschema, functools32 22:10:08 INFO - Running setup.py install for functools32 22:10:09 INFO - warning: no files found matching '*.txt' 22:10:09 INFO - no previously-included directories found matching 'build' 22:10:09 INFO - no previously-included directories found matching 'dist' 22:10:09 INFO - no previously-included directories found matching '.git*' 22:10:09 INFO - Successfully installed jsonschema functools32 22:10:09 INFO - Cleaning up... 22:10:09 INFO - Return code: 0 22:10:09 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:10:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:10:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:10:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:10:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6c4d8a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17be920>, '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 0x17bf820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17bfcb0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1458791551.447470-837921025', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:10:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 22:10:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:10:09 INFO - Using env: {'DISPLAY': ':0', 22:10:09 INFO - 'HOME': '/home/cltbld', 22:10:09 INFO - 'LANG': 'en_US.UTF-8', 22:10:09 INFO - 'LANGUAGE': 'en_US:en', 22:10:09 INFO - 'LOGNAME': 'cltbld', 22:10:09 INFO - 'MAIL': '/var/mail/cltbld', 22:10:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:10:09 INFO - 'MOZ_NO_REMOTE': '1', 22:10:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:10:09 INFO - 'NO_EM_RESTART': '1', 22:10:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:10:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:10:09 INFO - 'PWD': '/builds/slave/test-pgo', 22:10:09 INFO - 'SHELL': '/bin/bash', 22:10:09 INFO - 'SHLVL': '1', 22:10:09 INFO - 'TERM': 'linux', 22:10:09 INFO - 'TMOUT': '86400', 22:10:09 INFO - 'USER': 'cltbld', 22:10:09 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1458791551.447470-837921025', 22:10:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:10:09 INFO - '_': '/tools/buildbot/bin/python'} 22:10:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:10:09 INFO - Downloading/unpacking flake8 22:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:10:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:10:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:10:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:10:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:10:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:10:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:10:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:10:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:10:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:10:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:10:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:10:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:10:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:10:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:10:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:10:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:10:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:10:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:10:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:10:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:10:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:10:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:10:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:10:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:10:11 INFO - no previously-included directories found matching 'docs/_build' 22:10:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:10:11 INFO - Running setup.py install for pep8 22:10:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:10:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:10:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:10:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:10:12 INFO - no previously-included directories found matching 'docs/_build' 22:10:12 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:10:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:10:12 INFO - Cleaning up... 22:10:12 INFO - Return code: 0 22:10:12 INFO - Running post-action listener: _resource_record_post_action 22:10:12 INFO - Running post-action listener: _start_resource_monitoring 22:10:12 INFO - Starting resource monitoring. 22:10:12 INFO - ##### 22:10:12 INFO - ##### Running install step. 22:10:12 INFO - ##### 22:10:12 INFO - Running pre-action listener: _resource_record_pre_action 22:10:12 INFO - Running main action method: install 22:10:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:10:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:10:12 INFO - Reading from file tmpfile_stdout 22:10:12 INFO - Detecting whether we're running mozinstall >=1.0... 22:10:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:10:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:10:12 INFO - Reading from file tmpfile_stdout 22:10:12 INFO - Output received: 22:10:12 INFO - Usage: mozinstall [options] installer 22:10:12 INFO - Options: 22:10:12 INFO - -h, --help show this help message and exit 22:10:12 INFO - -d DEST, --destination=DEST 22:10:12 INFO - Directory to install application into. [default: 22:10:12 INFO - "/builds/slave/test-pgo"] 22:10:12 INFO - --app=APP Application being installed. [default: firefox] 22:10:12 INFO - mkdir: /builds/slave/test-pgo/build/application 22:10:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:10:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:10:27 INFO - Reading from file tmpfile_stdout 22:10:27 INFO - Output received: 22:10:27 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:10:27 INFO - Running post-action listener: _resource_record_post_action 22:10:27 INFO - ##### 22:10:27 INFO - ##### Running run-tests step. 22:10:27 INFO - ##### 22:10:27 INFO - Running pre-action listener: _resource_record_pre_action 22:10:27 INFO - Running main action method: run_tests 22:10:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:10:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:10:27 INFO - Python 2.7.3 22:10:27 INFO - Return code: 0 22:10:27 INFO - grabbing minidump binary from tooltool 22:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:27 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 0x17be920>, '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 0x17bf820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17bfcb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:10:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 22:10:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:10:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:10:27 INFO - Return code: 0 22:10:27 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:10:27 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:10:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:10:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:10:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:10:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:10:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:10:28 INFO - Return code: 0 22:10:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E1a0LUgGQYi3zUD60zhtSA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 22:10:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E1a0LUgGQYi3zUD60zhtSA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:10:28 INFO - Using env: {'DISPLAY': ':0', 22:10:28 INFO - 'HOME': '/home/cltbld', 22:10:28 INFO - 'LANG': 'en_US.UTF-8', 22:10:28 INFO - 'LANGUAGE': 'en_US:en', 22:10:28 INFO - 'LOGNAME': 'cltbld', 22:10:28 INFO - 'MAIL': '/var/mail/cltbld', 22:10:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:10:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:10:28 INFO - 'MOZ_NO_REMOTE': '1', 22:10:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:10:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:10:28 INFO - 'NO_EM_RESTART': '1', 22:10:28 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:10:28 INFO - 'PWD': '/builds/slave/test-pgo', 22:10:28 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:10:28 INFO - 'SHELL': '/bin/bash', 22:10:28 INFO - 'SHLVL': '1', 22:10:28 INFO - 'TERM': 'linux', 22:10:28 INFO - 'TMOUT': '86400', 22:10:28 INFO - 'USER': 'cltbld', 22:10:28 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1458791551.447470-837921025', 22:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:10:28 INFO - '_': '/tools/buildbot/bin/python'} 22:10:28 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E1a0LUgGQYi3zUD60zhtSA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:10:28 INFO - mozversion application_buildid: 20160323193749 22:10:28 INFO - mozversion application_changeset: e6bd5cd06759d78f752c215c9ea6adab4c25a995 22:10:28 INFO - mozversion application_display_name: FirefoxDeveloperEdition 22:10:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:10:28 INFO - mozversion application_name: Firefox 22:10:28 INFO - mozversion application_remotingname: firefox-dev 22:10:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:10:28 INFO - mozversion application_vendor: Mozilla 22:10:28 INFO - mozversion application_version: 47.0a2 22:10:28 INFO - mozversion platform_buildid: 20160323193749 22:10:28 INFO - mozversion platform_changeset: e6bd5cd06759d78f752c215c9ea6adab4c25a995 22:10:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:10:28 INFO - mozversion platform_version: 47.0a2 22:10:28 INFO - using testdate: 1458796228 22:10:28 INFO - actual date: 1458796228 22:10:28 INFO - starting webserver on 'localhost:37489' 22:10:28 INFO - SUITE-START | Running 2 tests 22:10:28 INFO - TEST-START | dromaeo_css 22:10:28 INFO - operating with platform_type : linux_ 22:10:28 INFO - Initialising browser for dromaeo_css test... 22:10:28 INFO - TEST-INFO | started process 13241 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHzEk88/profile http://localhost:37489/getInfo.html) 22:10:32 INFO - PROCESS | 13241 | 22:10:32 INFO - PROCESS | 13241 | (process:13316): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:10:33 INFO - PROCESS | 13241 | __metrics Screen width/height:1600/1200 22:10:33 INFO - PROCESS | 13241 | colorDepth:24 22:10:33 INFO - PROCESS | 13241 | Browser inner width/height: 1024/697 22:10:33 INFO - PROCESS | 13241 | __metrics 22:10:33 ERROR - PROCESS | 13241 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 22:10:34 INFO - TEST-INFO | 13241: exit 0 22:10:34 INFO - Browser initialized. 22:10:34 INFO - Running cycle 1/1 for dromaeo_css test... 22:10:34 INFO - TEST-INFO | started process 13367 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHzEk88/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:10:36 INFO - PROCESS | 13367 | 22:10:36 INFO - PROCESS | 13367 | (process:13436): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:10:46 INFO - PROCESS | 13367 | RSS: Main: 154456064 22:10:46 INFO - PROCESS | 13367 | 22:11:36 INFO - PROCESS | 13367 | 1458796296384 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:13:44 INFO - PROCESS | 13367 | Cycle 1(1): loaded http://localhost:37489/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37489/tests/dromaeo/cssquery-ext.html) 22:13:45 INFO - PROCESS | 13367 | RSS: Main: 156499968 22:13:45 INFO - PROCESS | 13367 | 22:16:47 INFO - PROCESS | 13367 | Cycle 1(1): loaded http://localhost:37489/tests/dromaeo/cssquery-ext.html (next: http://localhost:37489/tests/dromaeo/cssquery-jquery.html) 22:16:48 INFO - PROCESS | 13367 | RSS: Main: 156532736 22:16:48 INFO - PROCESS | 13367 | 22:19:49 INFO - PROCESS | 13367 | Cycle 1(1): loaded http://localhost:37489/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37489/tests/dromaeo/cssquery-mootools.html) 22:19:50 INFO - PROCESS | 13367 | RSS: Main: 156065792 22:19:50 INFO - PROCESS | 13367 | 22:22:51 INFO - PROCESS | 13367 | Cycle 1(1): loaded http://localhost:37489/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37489/tests/dromaeo/cssquery-prototype.html) 22:22:52 INFO - PROCESS | 13367 | RSS: Main: 155631616 22:22:52 INFO - PROCESS | 13367 | 22:25:54 INFO - PROCESS | 13367 | Cycle 1(1): loaded http://localhost:37489/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37489/tests/dromaeo/cssquery-yui.html) 22:25:55 INFO - PROCESS | 13367 | RSS: Main: 155348992 22:25:55 INFO - PROCESS | 13367 | 22:28:57 INFO - PROCESS | 13367 | Cycle 1(1): loaded http://localhost:37489/tests/dromaeo/cssquery-yui.html (next: http://localhost:37489/tests/dromaeo/cssquery-dojo.html) 22:28:57 INFO - PROCESS | 13367 | RSS: Main: 158461952 22:28:57 INFO - PROCESS | 13367 | 22:28:57 INFO - PROCESS | 13367 | __start_tp_report 22:28:57 INFO - PROCESS | 13367 | _x_x_mozilla_page_load 22:28:57 INFO - PROCESS | 13367 | _x_x_mozilla_page_load_details 22:28:57 INFO - PROCESS | 13367 | |i|pagename|runs| 22:28:57 INFO - PROCESS | 13367 | |0;dojo.html;3274;3340.665933406659;3371.5954085509743;3406.5571475708152;3407.8636854525803;5449.373322067963;5469.863253418662;5476.123820188771;5490.313710786157;5490.945090549093;5474.671519708821;5498.4501549845;5504.697241651707;5504.926539324833;5518.972405137979;4994.5005499450035;5052.772625231855;5126.205438157073;5131.358580177478;5133.409657889334;4971.875703107433;5084.44071152173;5124.4106927703415;5138.126518491866;5167.741612919358;5041.924371134436;5065.949340506603;5130.358705161855;5139.974300128512;5150.665206761567;5109.565686916635;5119.462456442076;5125.718085505296;5125.974370128163;5133.358330208724;4860.270959356089;4908.092002979461;5096.311997880276;5101.668391554575;5141.665791723563;5238.580913526908;5267.973660131714;5272.367315922075;5276.393214780311;5293.550048245904;5810.709464526757;5844.649321040752;5847.2983242010805;5868.295804503444;5873.530117590625;5890.793822216202;5915.112733090071;5992.131140984577;6002.459778619946;6030;5553.250311208016;5600.019996500678;5603.467670571289;5613.073842815971;5615.326160860682;5909.911351329733;6094.085887116968;6111.266648002268;6117.785877494266;6134.78528251509;5832.679202643895;5886.352501224862;5888.969430349757;5899.026660601038;5915.260592425947;5863.20846685692;5897.646141231454;5899.351071382144;5903.557233207526;5908.05471124618;5793.391693872167;5813.750043740616;5847.883042339215;5857.560682948796;5859.824205273849;5791.5656325775735;5828.271466066742;5831.358550559435;5847.152162936351;5870.354261031283;4428.047969686533;4431.468223813099;4446.666500012512;4457.531959144308;4492.887677808016;3980.9450495618107;4019.196160767858;4045.2314060328445;4066.430699702044;4079.918401631951;5531.502164805106;5647.604667673223;5678.517326027251;5725.742341594639;5767.826965191051;5934.020886553671;5958.940410595838;5981.910271345933;5986.191864098378;5990.490808281258;5502.862428439321;5673.290838645169;5687.1753595729215;5693.28833895763;5743.109817978137;4945.2087665973995;4995.450500444948;5004.324416203766;5006.774695138727;5015.247712843103;6123.9387606124255;6147.907781383283;6151.477124444383;6151.569390142647;6157.076438534166;5861.736221870111;5956.047032474783;5961.701914904237;6008.339082700987;6078.209832721718;6061.121137435135;6124.050772130327;6124.295705993868;6129.632222066691;6135.202423684892;5865.73604187804;5873.647581145145;5881.911846308447;5888.499477544457;5894.469497745224;5852.122181672783;5977.043673012297;6013.6692481913915;6046.3046749624355;6077.6353418795015;5760.654360738369;5815.651060936358;5846.619969701956;5849.61977471463;5866.2960444746905;5742.339630942495;5855.94144058554;5857.853553661193;5862.12068189775;5870.911936320873;5691.658500489818;5733.655980641175;5751.1373294006235;5774.682392468455;5804.158397032491;5759.424057594207;5814.825555233349;5824.15549745293;5839.416058394127;5898.174255604305;5641.379448260606;5687.687177205294;5752.446839353435;5753.395893431297;5764.538836892954 22:28:57 INFO - PROCESS | 13367 | |1;ext.html;539.8581999071964;586.4311617730802;608.315644899488;626.5614070150896;635.54876038013;37846;38466.4230036549;38698.032549186246;38717.419238711445;38737.612623873756;41596.376054359134;41801;41803.372949405784;41869;41963;8689.782755431117;8984.730458086235;9007.864882026775;9019.23336516397;9063;8840.071792461795;9017.188453039225;9024.593893274785;9216.631334746602;9246.86129708055;9197.540122993856;9243.352965292432;9246.214071803905;9272.67545635903;9302.581383837743;9094.590743416562;9101.135392137736;9127.863082053775;9166.633334666605;9179.541022948859;8954.641814327484;9065.954670226673;9098.181163695233;9107.089291070906;9125.178733913914;42394;42829.143417131796;42872.356914646305;42965.14069718588;42994.57005429937;3080.661127275998;3382.5940887093707;3658.5609726832686;3917.6865850731874;3938.547067087264;32559.348813023844;32663.183420414443;32674.183145421317;32697.346053079043;33104.17239569006;4028.234635419261;4123.876283711464;4133.1940271647045;4161.625453709151;4195.601417865298;304115;306605;307752;309403;309979;58811.41188588145;58925.41074589285;59391.40608593945;59394.406055939755;59423.70288148532;70374.2962570378;70662;71271.2872871275;71566;71825;15388;15647.452339168074;15651.686966260611;15676.921615392079;15691.13698746557;11108.61119860801;11183.384913829817;11198.664040078811;11236.775264494829;11301.49143288554;21315.68026479604;22116.557668846533;22295.219667311565;22303.44241393978;22310.776892231195;8493.915060849313;8704.04255531891;8704.477731336014;8743.606537705818;8744.475331480131;975.024975024975;1014.9340292881087;1076.8761592416815;1079.7246702090918;1127.7462570921641;28023.299417514725;28314.85842570774;28519.57220641692;28646.713532864404;29049.12852614425;1116.553378648547;1116.9944150279196;1135.4890299365154;1177.7821103095782;1264.480542432295;14918.676946033325;15125.54623361301;15133.940624156423;15244.771328430083;17009;410929;740817;755044;755380;765811;59064.40935590675;59076;59496.702516488;59800.102998455055;59959.700201498716;1461.6053665510465;1493.8954273200989;1495.6559991202084;1502.3164460170597;1506.517914267424;30064.549031764105;30390.544141837447;30814.70533899874;30932.845335773178;31343.529847051857;48488;49512.50487495223;49594.752026239636;49637.75181124216;49852;319359;319400;320883;321119;321913;33287.83356083204;33707.831460842535;44241.11517769691;44380.334294984954;44936.32595511005;41008.58991410048;41259.7937010313;41676;41969.370459443744;42217;38190.80904595459;38509.42235866408;38810.6118938807;38892.80553597327;39145.41281880831;37807.43288850615;38071;38116.61883381242;38372.23255534818;38703.80648096742;37130.8143459281;37407.625923740416;37862.43206351852;38182.23635527329;38414.423783643826;33198.502022470166;33553;33578.83210583931;33935.83032084923;34019.82990085034;26129.869350653124;26481.337966550218;26498.205053848415;26772.196834095008;26875.462490750466 22:28:57 INFO - PROCESS | 13367 | |2;jquery.html;387.8797572752445;390.95113110861143;394.95260568731754;395.0759799775096;397.79911144871835;18039.549011274707;18455.815441845578;18499.630007399843;18602;18619.06904654767;17361.565960850985;17387.73918391222;17670.558236044075;17902.82097179028;17926.103694815272;5186.299849520323;5344.064788661988;5390.4879036491475;5399;5412.972935135319;5235.55497782689;5290.39160496544;5331.866703332409;5333.253344531769;5355.892882142355;5634.323881134249;5687.971560142193;5708.372079071299;5712.600117991742;5741.598088133832;5563.610547261694;5698;5732.426757324297;5742.397048309909;5747.885042299152;5217.34783152106;5237.711925844077;5239.764210610493;5258.474152584749;5282.445343238943;14505.637359066002;14898.106113633217;14980.325885335076;20407.183712651477;22287.554248915094;2244.046280330853;2342.8125749939963;2345.1791872844537;2386.1529157149307;2582.8966841326323;10400.011998860096;10426.322289051188;10467.162626989822;10699.78600427995;10706.250562460631;1925.442637647229;1956.1197461142401;2033.2836242388776;2080.157536197842;2260.3557985974085;67303.66348168277;67677.32322676759;68078.65960670215;68906;69414.65292673555;11477.942610287062;11511.827322590168;11561.07511399086;11600.709982250512;11713.707157320965;15112.773308400383;15372.923135384252;15414.922925385526;15520.456784012731;15526.223688815515;8201.507909525448;8305.83388332242;8488.10874858131;8518.488890666456;8531.701390451304;8129.105798362176;8181.754547363588;8216.958915205385;8237.588120593946;8279.337652987746;4722.787474563653;4820.084184005098;4933.703977761345;5028.120078986163;5067.214581739762;1961.5782606739333;1981.3857704111772;1998.221582791317;2014.5265862522297;2090.864093833896;973;974.3228456222998;1007.1892126837965;1024.3085917005992;1045.7072019834459;17515.912420437817;17693.734593981102;17827.73258401125;18109;18540.16569254387;971;980.5293459139652;1019.3934608907688;1052.2476429353048;1078.5200585739271;10414.062734353945;10425.218108641882;10436.63471778484;10466.842997355046;10493.632722854663;429135;430228;438667;477245;478266;84093.57953210318;84771;86565.56717216373;86863.13136868677;87159;1069.1767339148967;1106.8837772033821;1120.708615759892;1122.180808010157;1124.145649306533;16094.839051609802;16349.918250408671;16403.83596164023;16439.589010274838;16832.326706931584;34692.826535867156;35179.472307915916;36057.819710901276;36264.36810343488;36865;51449.742751286;52430.73784631053;52561.7371913138;52611.73694131658;53147;8612.870806938026;8613.827723445622;8811.823763524822;8820.294376449998;8868.512231827312;12054.698632533906;12847.486100555872;12864.485420583445;13312;13500.662483437993;11106.833397499206;11158.776824463303;11384.886151138382;11694.4737486815;11808;11571.247868888495;11721.296722196696;11728.061755059403;11910.52357905674;11914.285142891455;11126.165537584875;12024;12041.397930103634;12229.205101668718;12255.142140050468;8236.094029656853;8296.585170741319;8836.64653413882;9055.23030542385;9086.500242486727;10447;11541.711457213636;11580.768384632429;11584.826227606762;11612.129090318429 22:28:57 INFO - PROCESS | 13367 | |3;mootools.html;1591.5464092733569;1611.4601608461162;1858.2752726436693;1890.9527261818462;1953.3456292142132;7579.924200757991;7883.448158628884;8117.553534555597;8244.752657420271;8287.254147126758;8244.793880152984;8252.546109963949;8282.668693252277;8312.210340017704;8345.499270043787;2445.0464318915638;2459.8524088554655;2476.7151777545632;2479.38015496126;2482.3049546127113;2423.006567307404;2445.596476581362;2449.0938352809485;2450.473148273121;2461.5569197544437;2432.2460037388464;2433.85396876188;2482.5283196192668;2487.253823852846;2488.6142647889606;2390.6533552634855;2400.0519794681177;2414.806815454768;2461.963070553943;2470.851748895072;2415.070197973775;2438.317271164077;2439.707235131778;2451.9877400613063;2459.88930498128;8449.746507604781;8485.66057357705;8507.489550626982;8519.446235994641;8540.103289154611;4965.180745177077;5025.1959686450355;5079.23811428285;5096.159133742928;5114.207297868837;3162.430762462756;3175.666555011737;3213.7268332191793;3232.4181647303476;3289.605247370307;1063.165415149112;1893.2994791927076;2014.6776515757556;2025.9189632414686;2030.279250865936;11225.8316125259;11276.605318813803;11332.49003794823;11334.489947952361;11339.489722962486;4304.634106100953;4322.200392927319;4396.4064851244675;4397.450318710161;4480.462344518679;8889.466632001971;8920.910790892138;8937;8943.418677786054;8976.41653292534;5063.544281014726;5069.112905241642;5082.1360368737405;5101.540861322499;5109.489051094861;4080.4083407905687;4617.884552886205;4647.18674232008;4647.395838540968;4689.390379250675;3786.242751449666;3796.202797412519;3860;3871.4773505576386;3874.0702231464247;1075.166745772033;1075.671920064388;1078.1536493852288;1082.0964494647058;1085.0776839686202;1389.4650559534653;1419.1272367493916;1421.7583010888175;1424.6865689548283;1432.6561625209874;7570.394368450511;7735.845283094307;7760.9223907761325;7769.184235655175;7772.300492955661;1189.6431070678761;1198.394810620631;1208.1844754790482;1208.7280361918674;1223.094909766784;6060.666663333559;6175.413335733098;6266.843328916813;6304.747810087545;6323.810285691437;10158.288919775545;10434.37393756377;10479.266451348332;10547.314424562379;10642.574297028032;10095.596176153018;10240.897591024144;10289.9485502572;10291.177143539331;10341.224408169266;7996.960015200003;8057.959710201411;8094.83810323802;8108.675652973933;8132.75601731949;7488.101427828696;7577.659005344663;7727.690892364468;7728.806779830549;7756.108047574601;8655.783605409915;8831.955840220759;9209.263258939403;9238.122378374044;9266.721998340061;8972.327075469235;8979.865302020344;9120.087991200828;9295.488748118918;9346.0653934606;6572.277049524453;6891.207511136284;7047.647617618996;7191.532550384209;7301.63491825396;7951.204879512234;7977.321927635984;7981.241782030698;7991.640376183202;8012.879806802786;7132.8930066048015;7240.312170343809;7336.559806411632;7486.812829679302;7499.362554182738;6942.687579059056;7082.150141982995;7096.042034325506;7231.4214862811905;7261.092363454568;7381.741639042608;7383.704651813868;7470.701171953278;7482.738104166328;7510.248975102446;6830.829229269308;6884.311568843075;6898.793036208922;6917.757878474229;6930.410915072073;6707.8993815091835;6716.3955244028275;6728.091707619409;6739.66301684904;6766.966165169143 22:28:57 INFO - PROCESS | 13367 | |4;prototype.html;359.4177432559254;361.3621957245464;367.3369567929887;368.2873639507552;370.4961252696334;6365.077063825743;6401.9359806402035;6421.036844473326;6472.967635161829;6496.350364963501;6322.0832979217985;6325.304216536178;6334.049892516125;6366.872662546746;6369.299377068519;4723.78742956566;4839.4434640016325;4842.733649649268;4860.684055536397;4927.359443272369;4824.493428190025;4842;4844.418669759616;4847.442544107437;4855.732934688591;4813.78337974792;4822.97588512057;4827.637927155477;4867.440244371889;4869.634777391692;4840.830570930018;4853.611711063124;4860.659753817235;4862.051899879525;4864.537868902448;4207.957920420788;4208.179405016023;4237.237297286487;4253.617174454314;4260.595243451867;5916.556258280603;6010.308814486346;6084.239470066242;6087.239095113111;6092.268927728701;5621.437856214387;5628.296462942132;5629.943700563023;5633.436656334375;5647.717614119278;6706.2958389368905;6709.932900671029;6748.325167483262;6757.966210168917;6764.966175169142;4660.627149828006;4663.044075964419;4665.95334046662;4668.906621867578;4673.906521869543;7039.648017599099;7097.432205423605;7102.857942841166;7113.679884405215;7127.750528731522;4715.481297057321;4779.784909679072;4801.231802911518;4809.350737650372;4838.225883858566;4826;4857.6599638025;4861.465238823726;4868.050730107595;4880.463149053601;5620.213170156181;5635.6618602883955;5649.4633009864;5653.491185793298;5657.971710141505;6792.234019155056;6806.829829254309;6833.58998460094;6836.658167091626;6843.213030501556;1691.3910992042854;1704.4119778676336;1713.1862365376346;1713.4431309824108;1713.5116491799777;1119.776044791045;1134.4838098665089;1138.4194061028934;1149.9597514086968;1168.1764356128908;6432.935670643327;6472.158619379545;6499.740010399626;6546.8363290918105;6564.474842012628;7002.124734408199;7038.612876291751;7046.577205367695;7058.894116588255;7062.964685176541;6278.121063051177;6382.489400847921;6518.543701940914;6528.575642583217;6593;3809.9238015240094;3813.7330386872654;3825.923481530354;3843.597087063202;3851.9807400963377;7315.195328513859;7351.669174887143;7357.2642735726;7374.815629609196;7378.225286344964;7255.383292420098;7257.2742725727;7310.268973102648;7319.011933388924;7325.560466372035;7138.678759455837;7282.089738782653;7328.853422931512;7335.486515943832;7430.702771889064;7073.151221853411;7107.75122870697;7146.678399471933;7162.033125528195;7165.140183177844;7008.509404341851;7013.579185248697;7014.088168538057;7031.156261248479;7042.190148132825;7334.6699398526125;7358.484906056525;7377.963110184414;7384.593847338448;7385.741499047507;4888.413390393175;4979.850604481871;5026.874328141826;5040.36995375578;5047.116754568009;7019.333163349474;7040.295970402919;7047.048648432396;7054.470914681317;7054.541454805421;6833.145856767904;6836.145481814773;6837.213720422215;6850.21222559412;6857.108575885103;6763.526553141233;6850.965745171242;6887.896681549881;6907.965460172667;6911.239763626098;6538.280789113289;6733.93266067333;6774.491913106635;6815.965920170367;6826.078479405415;6900.827479313058;6929.440875803106;6934.757283495053;6941.583504989717;6941.583504989717;6740.696668650021;6782.660866956731;6794.3545363190415;6814.522983391115;6848.212455567674 22:28:57 INFO - PROCESS | 13367 | |5;yui.html;800.0839039300001;810.3112354498674;887.1040249348157;909.4725059465511;915.0940568836852;13979.860201397983;14053.71892562148;14067.929660351709;14121.223332716709;14131.576052718423;11144.108471322295;14058;14150.78773818391;14167.574972750808;14198;888.5912480259072;924.3714274293478;928.6007016982695;928.8838895138108;931.1945167430158;906.2478143141177;906.4334790755778;912.4023764434273;913.5386629751999;919.3426699909563;939.248601119102;943.3632298198688;943.7404713703752;947.1854205383365;948.170350942925;939.4832841936976;942.4251206763903;943.5612440215299;943.9197668198211;945.3618807305041;693.7675878580682;694.0491526608579;696.7247937064882;696.7770313499682;697.7488104282454;14976.70046599062;15044.774328385083;15062.698746025128;15143.318550665246;15252;13927.234002129879;14211;14215.857841421557;14345.211013394259;14352.354144063542;11435.714107147387;11570.652880413601;11586.884131158666;11589.884101158965;11623.360715160663;3942.250972315251;3957.1294315250598;3957.5053118360206;3960.386140148282;4068.3897415387632;51815.74092129553;52025;52208;52227;52346;10029.899701003042;10091.394516329045;10121.443320617289;10122.746931326776;10482.947585262025;20898.58202835965;20982.895085524473;21004.47488812792;21052.368428947157;21053;8272.131426200162;8460.873086903579;8492.490450572861;8539.359548033923;8585.441946273471;4427.424434823452;4446.644268458515;4524.25349817283;4567.634589232854;4690.671652984327;3265.0368141398344;3329.417351963397;3336.182635254378;3347.6987071163226;3347.832608369572;559.0607778931353;564.9632773869686;567.7274908044162;569.8091139468324;593.3888095261888;704.4047779626208;720.6108701301343;725.7060890339316;746.1754760989137;748.0312994671913;8312.584370781437;8377.832443351099;8482.279006284412;8562.058173600899;8575.442596231225;658.9143411356494;678.7963610916705;682.952193346471;703.711478293897;705.2524324216347;4001.6198461146146;4026.315526360526;4041.3735870939463;4048.1903619276263;4177.603127702863;57072;59195.70402148048;59365.70317148473;59582.70208648929;59790.10314845281;53717;54651.453485465434;54689.1796623051;55252.17121743177;55442;47732.5226747735;47838.76080619574;48807.755961220675;48950.75524622425;49780.253296200586;8780.78048048804;8845.69040083594;8913.598888049924;8969.820603587761;9048.321375896703;38414;38437.23125537529;38559.228815422975;39002.809410024216;39971.40042899301;49070.509294906595;49100;49544.256836148204;49905.50094499008;50025.74987125041;12260.019198463922;12342.13605047638;12465.189762665397;12549.43527541281;12608.243505389706;12863.614091577268;13080.476780929037;13316.533921312708;13751.374590110896;14015.789763153356;11894.107941904565;11903;11908.880911190778;11993.220440671328;12291.69270768238;12002.1598488105;12029.759404811679;12169.939150304546;12297.385130743249;12586.685332866751;11417;11424.257423267461;11526.827097593376;11663.300201987568;11819.586314478953;10707.5181616829;10846.457677115955;10934.835977460185;11038.724031899266;11117.777644447227;10418.92533286709;10455.634052808115;10530.210234232616;10540.472976351306;10546.472676366304 22:28:57 INFO - PROCESS | 13367 | __end_tp_report 22:28:57 INFO - PROCESS | 13367 | __start_cc_report 22:28:57 INFO - PROCESS | 13367 | _x_x_mozilla_cycle_collect,329 22:28:57 INFO - PROCESS | 13367 | __end_cc_report 22:28:57 INFO - PROCESS | 13367 | __startTimestamp1458797337686__endTimestamp 22:28:57 INFO - PROCESS | 13367 | 22:28:57 INFO - PROCESS | 13367 | ------- Summary: start ------- 22:28:57 INFO - PROCESS | 13367 | Number of tests: 6 22:28:57 INFO - PROCESS | 13367 | 22:28:57 INFO - PROCESS | 13367 | [#0] dojo.html Cycles:165 Average:5509.98 Median:5759.42 stddev:614.50 (10.7%) stddev-sans-first:590.82 22:28:57 INFO - PROCESS | 13367 | Values: 3274.0 3340.7 3371.6 3406.6 3407.9 5449.4 5469.9 5476.1 5490.3 5490.9 5474.7 5498.5 5504.7 5504.9 5519.0 4994.5 5052.8 5126.2 5131.4 5133.4 4971.9 5084.4 5124.4 5138.1 5167.7 5041.9 5065.9 5130.4 5140.0 5150.7 5109.6 5119.5 5125.7 5126.0 5133.4 4860.3 4908.1 5096.3 5101.7 5141.7 5238.6 5268.0 5272.4 5276.4 5293.6 5810.7 5844.6 5847.3 5868.3 5873.5 5890.8 5915.1 5992.1 6002.5 6030.0 5553.3 5600.0 5603.5 5613.1 5615.3 5909.9 6094.1 6111.3 6117.8 6134.8 5832.7 5886.4 5889.0 5899.0 5915.3 5863.2 5897.6 5899.4 5903.6 5908.1 5793.4 5813.8 5847.9 5857.6 5859.8 5791.6 5828.3 5831.4 5847.2 5870.4 4428.0 4431.5 4446.7 4457.5 4492.9 3980.9 4019.2 4045.2 4066.4 4079.9 5531.5 5647.6 5678.5 5725.7 5767.8 5934.0 5958.9 5981.9 5986.2 5990.5 5502.9 5673.3 5687.2 5693.3 5743.1 4945.2 4995.5 5004.3 5006.8 5015.2 6123.9 6147.9 6151.5 6151.6 6157.1 5861.7 5956.0 5961.7 6008.3 6078.2 6061.1 6124.1 6124.3 6129.6 6135.2 5865.7 5873.6 5881.9 5888.5 5894.5 5852.1 5977.0 6013.7 6046.3 6077.6 5760.7 5815.7 5846.6 5849.6 5866.3 5742.3 5855.9 5857.9 5862.1 5870.9 5691.7 5733.7 5751.1 5774.7 5804.2 5759.4 5814.8 5824.2 5839.4 5898.2 5641.4 5687.7 5752.4 5753.4 5764.5 22:28:57 INFO - PROCESS | 13367 | 22:28:57 INFO - PROCESS | 13367 | [#1] ext.html Cycles:180 Average:59867.42 Median:38774.11 stddev:128478.33 (331.4%) stddev-sans-first:128761.53 22:28:57 INFO - PROCESS | 13367 | Values: 539.9 586.4 608.3 626.6 635.5 37846.0 38466.4 38698.0 38717.4 38737.6 41596.4 41801.0 41803.4 41869.0 41963.0 8689.8 8984.7 9007.9 9019.2 9063.0 8840.1 9017.2 9024.6 9216.6 9246.9 9197.5 9243.4 9246.2 9272.7 9302.6 9094.6 9101.1 9127.9 9166.6 9179.5 8954.6 9066.0 9098.2 9107.1 9125.2 42394.0 42829.1 42872.4 42965.1 42994.6 3080.7 3382.6 3658.6 3917.7 3938.5 32559.3 32663.2 32674.2 32697.3 33104.2 4028.2 4123.9 4133.2 4161.6 4195.6 304115.0 306605.0 307752.0 309403.0 309979.0 58811.4 58925.4 59391.4 59394.4 59423.7 70374.3 70662.0 71271.3 71566.0 71825.0 15388.0 15647.5 15651.7 15676.9 15691.1 11108.6 11183.4 11198.7 11236.8 11301.5 21315.7 22116.6 22295.2 22303.4 22310.8 8493.9 8704.0 8704.5 8743.6 8744.5 975.0 1014.9 1076.9 1079.7 1127.7 28023.3 28314.9 28519.6 28646.7 29049.1 1116.6 1117.0 1135.5 1177.8 1264.5 14918.7 15125.5 15133.9 15244.8 17009.0 410929.0 740817.0 755044.0 755380.0 765811.0 59064.4 59076.0 59496.7 59800.1 59959.7 1461.6 1493.9 1495.7 1502.3 1506.5 30064.5 30390.5 30814.7 30932.8 31343.5 48488.0 49512.5 49594.8 49637.8 49852.0 319359.0 319400.0 320883.0 321119.0 321913.0 33287.8 33707.8 44241.1 44380.3 44936.3 41008.6 41259.8 41676.0 41969.4 42217.0 38190.8 38509.4 38810.6 38892.8 39145.4 37807.4 38071.0 38116.6 38372.2 38703.8 37130.8 37407.6 37862.4 38182.2 38414.4 33198.5 33553.0 33578.8 33935.8 34019.8 26129.9 26481.3 26498.2 26772.2 26875.5 22:28:57 INFO - PROCESS | 13367 | 22:28:57 INFO - PROCESS | 13367 | [#2] jquery.html Cycles:180 Average:26794.32 Median:2252.20 stddev:74219.02 (3295.4%) stddev-sans-first:74400.74 22:28:57 INFO - PROCESS | 13367 | Values: 387.9 391.0 395.0 395.1 397.8 18039.5 18455.8 18499.6 18602.0 18619.1 17361.6 17387.7 17670.6 17902.8 17926.1 5186.3 5344.1 5390.5 5399.0 5413.0 5235.6 5290.4 5331.9 5333.3 5355.9 5634.3 5688.0 5708.4 5712.6 5741.6 5563.6 5698.0 5732.4 5742.4 5747.9 5217.3 5237.7 5239.8 5258.5 5282.4 14505.6 14898.1 14980.3 20407.2 22287.6 2244.0 2342.8 2345.2 2386.2 2582.9 10400.0 10426.3 10467.2 10699.8 10706.3 1925.4 1956.1 2033.3 2080.2 2260.4 67303.7 67677.3 68078.7 68906.0 69414.7 11477.9 11511.8 11561.1 11600.7 11713.7 15112.8 15372.9 15414.9 15520.5 15526.2 8201.5 8305.8 8488.1 8518.5 8531.7 8129.1 8181.8 8217.0 8237.6 8279.3 4722.8 4820.1 4933.7 5028.1 5067.2 1961.6 1981.4 1998.2 2014.5 2090.9 973.0 974.3 1007.2 1024.3 1045.7 17515.9 17693.7 17827.7 18109.0 18540.2 971.0 980.5 1019.4 1052.2 1078.5 10414.1 10425.2 10436.6 10466.8 10493.6 429135.0 430228.0 438667.0 477245.0 478266.0 84093.6 84771.0 86565.6 86863.1 87159.0 1069.2 1106.9 1120.7 1122.2 1124.1 16094.8 16349.9 16403.8 16439.6 16832.3 34692.8 35179.5 36057.8 36264.4 36865.0 51449.7 52430.7 52561.7 52611.7 53147.0 8612.9 8613.8 8811.8 8820.3 8868.5 12054.7 12847.5 12864.5 13312.0 13500.7 11106.8 11158.8 11384.9 11694.5 11808.0 11571.2 11721.3 11728.1 11910.5 11914.3 11126.2 12024.0 12041.4 12229.2 12255.1 8236.1 8296.6 8836.6 9055.2 9086.5 10447.0 11541.7 11580.8 11584.8 11612.1 22:28:57 INFO - PROCESS | 13367 | 22:28:57 INFO - PROCESS | 13367 | [#3] mootools.html Cycles:180 Average:5827.17 Median:5089.15 stddev:2970.16 (58.4%) stddev-sans-first:2961.43 22:28:57 INFO - PROCESS | 13367 | Values: 1591.5 1611.5 1858.3 1891.0 1953.3 7579.9 7883.4 8117.6 8244.8 8287.3 8244.8 8252.5 8282.7 8312.2 8345.5 2445.0 2459.9 2476.7 2479.4 2482.3 2423.0 2445.6 2449.1 2450.5 2461.6 2432.2 2433.9 2482.5 2487.3 2488.6 2390.7 2400.1 2414.8 2462.0 2470.9 2415.1 2438.3 2439.7 2452.0 2459.9 8449.7 8485.7 8507.5 8519.4 8540.1 4965.2 5025.2 5079.2 5096.2 5114.2 3162.4 3175.7 3213.7 3232.4 3289.6 1063.2 1893.3 2014.7 2025.9 2030.3 11225.8 11276.6 11332.5 11334.5 11339.5 4304.6 4322.2 4396.4 4397.5 4480.5 8889.5 8920.9 8937.0 8943.4 8976.4 5063.5 5069.1 5082.1 5101.5 5109.5 4080.4 4617.9 4647.2 4647.4 4689.4 3786.2 3796.2 3860.0 3871.5 3874.1 1075.2 1075.7 1078.2 1082.1 1085.1 1389.5 1419.1 1421.8 1424.7 1432.7 7570.4 7735.8 7760.9 7769.2 7772.3 1189.6 1198.4 1208.2 1208.7 1223.1 6060.7 6175.4 6266.8 6304.7 6323.8 10158.3 10434.4 10479.3 10547.3 10642.6 10095.6 10240.9 10289.9 10291.2 10341.2 7997.0 8058.0 8094.8 8108.7 8132.8 7488.1 7577.7 7727.7 7728.8 7756.1 8655.8 8832.0 9209.3 9238.1 9266.7 8972.3 8979.9 9120.1 9295.5 9346.1 6572.3 6891.2 7047.6 7191.5 7301.6 7951.2 7977.3 7981.2 7991.6 8012.9 7132.9 7240.3 7336.6 7486.8 7499.4 6942.7 7082.2 7096.0 7231.4 7261.1 7381.7 7383.7 7470.7 7482.7 7510.2 6830.8 6884.3 6898.8 6917.8 6930.4 6707.9 6716.4 6728.1 6739.7 6767.0 22:28:57 INFO - PROCESS | 13367 | 22:28:57 INFO - PROCESS | 13367 | [#4] prototype.html Cycles:180 Average:5705.64 Median:6452.55 stddev:1736.74 (26.9%) stddev-sans-first:1694.62 22:28:57 INFO - PROCESS | 13367 | Values: 359.4 361.4 367.3 368.3 370.5 6365.1 6401.9 6421.0 6473.0 6496.4 6322.1 6325.3 6334.0 6366.9 6369.3 4723.8 4839.4 4842.7 4860.7 4927.4 4824.5 4842.0 4844.4 4847.4 4855.7 4813.8 4823.0 4827.6 4867.4 4869.6 4840.8 4853.6 4860.7 4862.1 4864.5 4208.0 4208.2 4237.2 4253.6 4260.6 5916.6 6010.3 6084.2 6087.2 6092.3 5621.4 5628.3 5629.9 5633.4 5647.7 6706.3 6709.9 6748.3 6758.0 6765.0 4660.6 4663.0 4666.0 4668.9 4673.9 7039.6 7097.4 7102.9 7113.7 7127.8 4715.5 4779.8 4801.2 4809.4 4838.2 4826.0 4857.7 4861.5 4868.1 4880.5 5620.2 5635.7 5649.5 5653.5 5658.0 6792.2 6806.8 6833.6 6836.7 6843.2 1691.4 1704.4 1713.2 1713.4 1713.5 1119.8 1134.5 1138.4 1150.0 1168.2 6432.9 6472.2 6499.7 6546.8 6564.5 7002.1 7038.6 7046.6 7058.9 7063.0 6278.1 6382.5 6518.5 6528.6 6593.0 3809.9 3813.7 3825.9 3843.6 3852.0 7315.2 7351.7 7357.3 7374.8 7378.2 7255.4 7257.3 7310.3 7319.0 7325.6 7138.7 7282.1 7328.9 7335.5 7430.7 7073.2 7107.8 7146.7 7162.0 7165.1 7008.5 7013.6 7014.1 7031.2 7042.2 7334.7 7358.5 7378.0 7384.6 7385.7 4888.4 4979.9 5026.9 5040.4 5047.1 7019.3 7040.3 7047.0 7054.5 7054.5 6833.1 6836.1 6837.2 6850.2 6857.1 6763.5 6851.0 6887.9 6908.0 6911.2 6538.3 6733.9 6774.5 6816.0 6826.1 6900.8 6929.4 6934.8 6941.6 6941.6 6740.7 6782.7 6794.4 6814.5 6848.2 22:28:57 INFO - PROCESS | 13367 | 22:28:57 INFO - PROCESS | 13367 | [#5] yui.html Cycles:180 Average:14850.54 Median:4437.03 stddev:17013.42 (383.4%) stddev-sans-first:17028.42 22:28:57 INFO - PROCESS | 13367 | Values: 800.1 810.3 887.1 909.5 915.1 13979.9 14053.7 14067.9 14121.2 14131.6 11144.1 14058.0 14150.8 14167.6 14198.0 888.6 924.4 928.6 928.9 931.2 906.2 906.4 912.4 913.5 919.3 939.2 943.4 943.7 947.2 948.2 939.5 942.4 943.6 943.9 945.4 693.8 694.0 696.7 696.8 697.7 14976.7 15044.8 15062.7 15143.3 15252.0 13927.2 14211.0 14215.9 14345.2 14352.4 11435.7 11570.7 11586.9 11589.9 11623.4 3942.3 3957.1 3957.5 3960.4 4068.4 51815.7 52025.0 52208.0 52227.0 52346.0 10029.9 10091.4 10121.4 10122.7 10482.9 20898.6 20982.9 21004.5 21052.4 21053.0 8272.1 8460.9 8492.5 8539.4 8585.4 4427.4 4446.6 4524.3 4567.6 4690.7 3265.0 3329.4 3336.2 3347.7 3347.8 559.1 565.0 567.7 569.8 593.4 704.4 720.6 725.7 746.2 748.0 8312.6 8377.8 8482.3 8562.1 8575.4 658.9 678.8 683.0 703.7 705.3 4001.6 4026.3 4041.4 4048.2 4177.6 57072.0 59195.7 59365.7 59582.7 59790.1 53717.0 54651.5 54689.2 55252.2 55442.0 47732.5 47838.8 48807.8 48950.8 49780.3 8780.8 8845.7 8913.6 8969.8 9048.3 38414.0 38437.2 38559.2 39002.8 39971.4 49070.5 49100.0 49544.3 49905.5 50025.7 12260.0 12342.1 12465.2 12549.4 12608.2 12863.6 13080.5 13316.5 13751.4 14015.8 11894.1 11903.0 11908.9 11993.2 12291.7 12002.2 12029.8 12169.9 12297.4 12586.7 11417.0 11424.3 11526.8 11663.3 11819.6 10707.5 10846.5 10934.8 11038.7 11117.8 10418.9 10455.6 10530.2 10540.5 10546.5 22:28:57 INFO - PROCESS | 13367 | -------- Summary: end -------- 22:28:57 INFO - PROCESS | 13367 | 22:28:58 INFO - TEST-INFO | 13367: exit 0 22:28:58 INFO - TEST-OK | dromaeo_css | took 1109473ms 22:28:58 INFO - TEST-START | kraken 22:28:58 INFO - operating with platform_type : linux_ 22:28:58 INFO - Initialising browser for kraken test... 22:28:58 INFO - TEST-INFO | started process 13614 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNCI2ff/profile http://localhost:37489/getInfo.html) 22:29:01 INFO - PROCESS | 13614 | 22:29:01 INFO - PROCESS | 13614 | (process:13694): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:29:02 INFO - PROCESS | 13614 | __metrics Screen width/height:1600/1200 22:29:02 INFO - PROCESS | 13614 | colorDepth:24 22:29:02 INFO - PROCESS | 13614 | Browser inner width/height: 1024/697 22:29:02 INFO - PROCESS | 13614 | __metrics 22:29:03 ERROR - PROCESS | 13614 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 22:29:04 INFO - TEST-INFO | 13614: exit 0 22:29:04 INFO - Browser initialized. 22:29:04 INFO - Running cycle 1/1 for kraken test... 22:29:04 INFO - TEST-INFO | started process 13745 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNCI2ff/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:29:05 INFO - PROCESS | 13745 | 22:29:05 INFO - PROCESS | 13745 | (process:13814): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:29:15 INFO - PROCESS | 13745 | RSS: Main: 154578944 22:29:15 INFO - PROCESS | 13745 | 22:29:18 INFO - PROCESS | 13745 | Cycle 1(1): loaded http://localhost:37489/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37489/tests/kraken/driver.html?testName=audio-beat-detection) 22:29:19 INFO - PROCESS | 13745 | RSS: Main: 159338496 22:29:19 INFO - PROCESS | 13745 | 22:29:21 INFO - PROCESS | 13745 | Cycle 1(1): loaded http://localhost:37489/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37489/tests/kraken/driver.html?testName=audio-dft) 22:29:22 INFO - PROCESS | 13745 | RSS: Main: 158203904 22:29:22 INFO - PROCESS | 13745 | 22:29:25 INFO - PROCESS | 13745 | Cycle 1(1): loaded http://localhost:37489/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37489/tests/kraken/driver.html?testName=audio-fft) 22:29:25 INFO - PROCESS | 13745 | RSS: Main: 160157696 22:29:25 INFO - PROCESS | 13745 | 22:29:27 INFO - PROCESS | 13745 | Cycle 1(1): loaded http://localhost:37489/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37489/tests/kraken/driver.html?testName=audio-oscillator) 22:29:28 INFO - PROCESS | 13745 | RSS: Main: 159805440 22:29:28 INFO - PROCESS | 13745 | 22:29:30 INFO - PROCESS | 13745 | Cycle 1(1): loaded http://localhost:37489/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37489/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:29:31 INFO - PROCESS | 13745 | RSS: Main: 158330880 22:29:31 INFO - PROCESS | 13745 | 22:29:34 INFO - PROCESS | 13745 | Cycle 1(1): loaded http://localhost:37489/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37489/tests/kraken/driver.html?testName=imaging-darkroom) 22:29:34 INFO - PROCESS | 13745 | RSS: Main: 158744576 22:29:34 INFO - PROCESS | 13745 | 22:29:38 INFO - PROCESS | 13745 | Cycle 1(1): loaded http://localhost:37489/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37489/tests/kraken/driver.html?testName=imaging-desaturate) 22:29:38 INFO - PROCESS | 13745 | RSS: Main: 158269440 22:29:38 INFO - PROCESS | 13745 | 22:29:41 INFO - PROCESS | 13745 | Cycle 1(1): loaded http://localhost:37489/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37489/tests/kraken/driver.html?testName=json-parse-financial) 22:29:42 INFO - PROCESS | 13745 | RSS: Main: 158588928 22:29:42 INFO - PROCESS | 13745 | 22:29:43 INFO - PROCESS | 13745 | Cycle 1(1): loaded http://localhost:37489/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37489/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:29:44 INFO - PROCESS | 13745 | RSS: Main: 159285248 22:29:44 INFO - PROCESS | 13745 | 22:29:46 INFO - PROCESS | 13745 | Cycle 1(1): loaded http://localhost:37489/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37489/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:29:46 INFO - PROCESS | 13745 | RSS: Main: 158892032 22:29:46 INFO - PROCESS | 13745 | 22:29:48 INFO - PROCESS | 13745 | Cycle 1(1): loaded http://localhost:37489/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37489/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:29:49 INFO - PROCESS | 13745 | RSS: Main: 159432704 22:29:49 INFO - PROCESS | 13745 | 22:29:51 INFO - PROCESS | 13745 | Cycle 1(1): loaded http://localhost:37489/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37489/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:29:52 INFO - PROCESS | 13745 | RSS: Main: 159608832 22:29:52 INFO - PROCESS | 13745 | 22:29:54 INFO - PROCESS | 13745 | Cycle 1(1): loaded http://localhost:37489/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37489/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:29:55 INFO - PROCESS | 13745 | RSS: Main: 160968704 22:29:55 INFO - PROCESS | 13745 | 22:29:57 INFO - PROCESS | 13745 | Cycle 1(1): loaded http://localhost:37489/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37489/tests/kraken/driver.html?testName=ai-astar) 22:29:57 INFO - PROCESS | 13745 | RSS: Main: 160636928 22:29:57 INFO - PROCESS | 13745 | 22:29:57 INFO - PROCESS | 13745 | __start_tp_report 22:29:57 INFO - PROCESS | 13745 | _x_x_mozilla_page_load 22:29:57 INFO - PROCESS | 13745 | _x_x_mozilla_page_load_details 22:29:57 INFO - PROCESS | 13745 | |i|pagename|runs| 22:29:57 INFO - PROCESS | 13745 | |0;ai-astar;112;104;112;112;112;123;111;110;111;110 22:29:57 INFO - PROCESS | 13745 | |1;audio-beat-detection;160;128;162;177;126;153;160;127;165;129 22:29:57 INFO - PROCESS | 13745 | |2;audio-dft;161;162;161;160;162;160;160;161;166;161 22:29:57 INFO - PROCESS | 13745 | |3;audio-fft;74;76;74;173;74;78;72;76;155;76 22:29:57 INFO - PROCESS | 13745 | |4;audio-oscillator;92;93;146;94;92;93;145;93;93;138 22:29:57 INFO - PROCESS | 13745 | |5;imaging-gaussian-blur;118;117;117;118;119;117;117;117;117;117 22:29:57 INFO - PROCESS | 13745 | |6;imaging-darkroom;146;146;147;146;146;147;146;147;146;147 22:29:57 INFO - PROCESS | 13745 | |7;imaging-desaturate;96;96;95;95;97;96;96;97;96;95 22:29:57 INFO - PROCESS | 13745 | |8;json-parse-financial;54;58;56;58;54;59;56;61;53;53 22:29:57 INFO - PROCESS | 13745 | |9;json-stringify-tinderbox;64;64;65;64;66;65;64;65;65;66 22:29:57 INFO - PROCESS | 13745 | |10;stanford-crypto-aes;85;79;80;88;79;80;80;78;81;78 22:29:57 INFO - PROCESS | 13745 | |11;stanford-crypto-ccm;111;114;113;116;119;113;114;118;120;114 22:29:57 INFO - PROCESS | 13745 | |12;stanford-crypto-pbkdf2;139;148;151;159;156;143;148;146;150;146 22:29:57 INFO - PROCESS | 13745 | |13;stanford-crypto-sha256-iterative;70;67;68;68;68;69;67;69;66;69 22:29:57 INFO - PROCESS | 13745 | __end_tp_report 22:29:57 INFO - PROCESS | 13745 | __start_cc_report 22:29:57 INFO - PROCESS | 13745 | _x_x_mozilla_cycle_collect,815 22:29:57 INFO - PROCESS | 13745 | __end_cc_report 22:29:57 INFO - PROCESS | 13745 | __startTimestamp1458797397438__endTimestamp 22:29:57 INFO - PROCESS | 13745 | 22:29:57 INFO - PROCESS | 13745 | ------- Summary: start ------- 22:29:57 INFO - PROCESS | 13745 | Number of tests: 14 22:29:57 INFO - PROCESS | 13745 | 22:29:57 INFO - PROCESS | 13745 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.00 stddev:4.64 (4.1%) stddev-sans-first:4.92 22:29:57 INFO - PROCESS | 13745 | Values: 112.0 104.0 112.0 112.0 112.0 123.0 111.0 110.0 111.0 110.0 22:29:57 INFO - PROCESS | 13745 | 22:29:57 INFO - PROCESS | 13745 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:160.00 stddev:19.21 (12.0%) stddev-sans-first:19.93 22:29:57 INFO - PROCESS | 13745 | Values: 160.0 128.0 162.0 177.0 126.0 153.0 160.0 127.0 165.0 129.0 22:29:57 INFO - PROCESS | 13745 | 22:29:57 INFO - PROCESS | 13745 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:1.78 (1.1%) stddev-sans-first:1.88 22:29:57 INFO - PROCESS | 13745 | Values: 161.0 162.0 161.0 160.0 162.0 160.0 160.0 161.0 166.0 161.0 22:29:57 INFO - PROCESS | 13745 | 22:29:57 INFO - PROCESS | 13745 | [#3] audio-fft Cycles:10 Average:92.80 Median:75.00 stddev:37.80 (50.4%) stddev-sans-first:39.48 22:29:57 INFO - PROCESS | 13745 | Values: 74.0 76.0 74.0 173.0 74.0 78.0 72.0 76.0 155.0 76.0 22:29:57 INFO - PROCESS | 13745 | 22:29:57 INFO - PROCESS | 13745 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:93.00 stddev:24.31 (26.1%) stddev-sans-first:25.10 22:29:57 INFO - PROCESS | 13745 | Values: 92.0 93.0 146.0 94.0 92.0 93.0 145.0 93.0 93.0 138.0 22:29:57 INFO - PROCESS | 13745 | 22:29:57 INFO - PROCESS | 13745 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 22:29:57 INFO - PROCESS | 13745 | Values: 118.0 117.0 117.0 118.0 119.0 117.0 117.0 117.0 117.0 117.0 22:29:57 INFO - PROCESS | 13745 | 22:29:57 INFO - PROCESS | 13745 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 22:29:57 INFO - PROCESS | 13745 | Values: 146.0 146.0 147.0 146.0 146.0 147.0 146.0 147.0 146.0 147.0 22:29:57 INFO - PROCESS | 13745 | 22:29:57 INFO - PROCESS | 13745 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 22:29:57 INFO - PROCESS | 13745 | Values: 96.0 96.0 95.0 95.0 97.0 96.0 96.0 97.0 96.0 95.0 22:29:57 INFO - PROCESS | 13745 | 22:29:57 INFO - PROCESS | 13745 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:57.00 stddev:2.74 (4.8%) stddev-sans-first:2.79 22:29:57 INFO - PROCESS | 13745 | Values: 54.0 58.0 56.0 58.0 54.0 59.0 56.0 61.0 53.0 53.0 22:29:57 INFO - PROCESS | 13745 | 22:29:57 INFO - PROCESS | 13745 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 22:29:57 INFO - PROCESS | 13745 | Values: 64.0 64.0 65.0 64.0 66.0 65.0 64.0 65.0 65.0 66.0 22:29:57 INFO - PROCESS | 13745 | 22:29:57 INFO - PROCESS | 13745 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:80.00 stddev:3.22 (4.0%) stddev-sans-first:3.04 22:29:57 INFO - PROCESS | 13745 | Values: 85.0 79.0 80.0 88.0 79.0 80.0 80.0 78.0 81.0 78.0 22:29:57 INFO - PROCESS | 13745 | 22:29:57 INFO - PROCESS | 13745 | [#11] stanford-crypto-ccm Cycles:10 Average:115.20 Median:115.00 stddev:2.94 (2.6%) stddev-sans-first:2.69 22:29:57 INFO - PROCESS | 13745 | Values: 111.0 114.0 113.0 116.0 119.0 113.0 114.0 118.0 120.0 114.0 22:29:57 INFO - PROCESS | 13745 | 22:29:57 INFO - PROCESS | 13745 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.60 Median:149.00 stddev:5.85 (3.9%) stddev-sans-first:5.07 22:29:57 INFO - PROCESS | 13745 | Values: 139.0 148.0 151.0 159.0 156.0 143.0 148.0 146.0 150.0 146.0 22:29:57 INFO - PROCESS | 13745 | 22:29:57 INFO - PROCESS | 13745 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.50 stddev:1.20 (1.7%) stddev-sans-first:1.05 22:29:57 INFO - PROCESS | 13745 | Values: 70.0 67.0 68.0 68.0 68.0 69.0 67.0 69.0 66.0 69.0 22:29:57 INFO - PROCESS | 13745 | -------- Summary: end -------- 22:29:57 INFO - PROCESS | 13745 | 22:29:58 INFO - TEST-INFO | 13745: exit 0 22:29:58 INFO - TEST-OK | kraken | took 59959ms 22:29:58 INFO - SUITE-END | took 1169s 22:29:58 INFO - Completed test suite (00:19:29) 22:29:58 INFO - javascript benchmark 22:29:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3274.0, 3340.665933406659, 3371.5954085509743, 3406.5571475708152, 3407.8636854525803, 5449.373322067963, 5469.863253418662, 5476.123820188771, 5490.313710786157, 5490.945090549093, 5474.671519708821, 5498.4501549845, 5504.697241651707, 5504.926539324833, 5518.972405137979, 4994.5005499450035, 5052.772625231855, 5126.205438157073, 5131.358580177478, 5133.409657889334, 4971.875703107433, 5084.44071152173, 5124.4106927703415, 5138.126518491866, 5167.741612919358, 5041.924371134436, 5065.949340506603, 5130.358705161855, 5139.974300128512, 5150.665206761567, 5109.565686916635, 5119.462456442076, 5125.718085505296, 5125.974370128163, 5133.358330208724, 4860.270959356089, 4908.092002979461, 5096.311997880276, 5101.668391554575, 5141.665791723563, 5238.580913526908, 5267.973660131714, 5272.367315922075, 5276.393214780311, 5293.550048245904, 5810.709464526757, 5844.649321040752, 5847.2983242010805, 5868.295804503444, 5873.530117590625, 5890.793822216202, 5915.112733090071, 5992.131140984577, 6002.459778619946, 6030.0, 5553.250311208016, 5600.019996500678, 5603.467670571289, 5613.073842815971, 5615.326160860682, 5909.911351329733, 6094.085887116968, 6111.266648002268, 6117.785877494266, 6134.78528251509, 5832.679202643895, 5886.352501224862, 5888.969430349757, 5899.026660601038, 5915.260592425947, 5863.20846685692, 5897.646141231454, 5899.351071382144, 5903.557233207526, 5908.05471124618, 5793.391693872167, 5813.750043740616, 5847.883042339215, 5857.560682948796, 5859.824205273849, 5791.5656325775735, 5828.271466066742, 5831.358550559435, 5847.152162936351, 5870.354261031283, 4428.047969686533, 4431.468223813099, 4446.666500012512, 4457.531959144308, 4492.887677808016, 3980.9450495618107, 4019.196160767858, 4045.2314060328445, 4066.430699702044, 4079.918401631951, 5531.502164805106, 5647.604667673223, 5678.517326027251, 5725.742341594639, 5767.826965191051, 5934.020886553671, 5958.940410595838, 5981.910271345933, 5986.191864098378, 5990.490808281258, 5502.862428439321, 5673.290838645169, 5687.1753595729215, 5693.28833895763, 5743.109817978137, 4945.2087665973995, 4995.450500444948, 5004.324416203766, 5006.774695138727, 5015.247712843103, 6123.9387606124255, 6147.907781383283, 6151.477124444383, 6151.569390142647, 6157.076438534166, 5861.736221870111, 5956.047032474783, 5961.701914904237, 6008.339082700987, 6078.209832721718, 6061.121137435135, 6124.050772130327, 6124.295705993868, 6129.632222066691, 6135.202423684892, 5865.73604187804, 5873.647581145145, 5881.911846308447, 5888.499477544457, 5894.469497745224, 5852.122181672783, 5977.043673012297, 6013.6692481913915, 6046.3046749624355, 6077.6353418795015, 5760.654360738369, 5815.651060936358, 5846.619969701956, 5849.61977471463, 5866.2960444746905, 5742.339630942495, 5855.94144058554, 5857.853553661193, 5862.12068189775, 5870.911936320873, 5691.658500489818, 5733.655980641175, 5751.1373294006235, 5774.682392468455, 5804.158397032491, 5759.424057594207, 5814.825555233349, 5824.15549745293, 5839.416058394127, 5898.174255604305, 5641.379448260606, 5687.687177205294, 5752.446839353435, 5753.395893431297, 5764.538836892954], "unit": "score", "name": "dojo.html", "value": 5470.035520049724}, {"lowerIsBetter": false, "replicates": [539.8581999071964, 586.4311617730802, 608.315644899488, 626.5614070150896, 635.54876038013, 37846.0, 38466.4230036549, 38698.032549186246, 38717.419238711445, 38737.612623873756, 41596.376054359134, 41801.0, 41803.372949405784, 41869.0, 41963.0, 8689.782755431117, 8984.730458086235, 9007.864882026775, 9019.23336516397, 9063.0, 8840.071792461795, 9017.188453039225, 9024.593893274785, 9216.631334746602, 9246.86129708055, 9197.540122993856, 9243.352965292432, 9246.214071803905, 9272.67545635903, 9302.581383837743, 9094.590743416562, 9101.135392137736, 9127.863082053775, 9166.633334666605, 9179.541022948859, 8954.641814327484, 9065.954670226673, 9098.181163695233, 9107.089291070906, 9125.178733913914, 42394.0, 42829.143417131796, 42872.356914646305, 42965.14069718588, 42994.57005429937, 3080.661127275998, 3382.5940887093707, 3658.5609726832686, 3917.6865850731874, 3938.547067087264, 32559.348813023844, 32663.183420414443, 32674.183145421317, 32697.346053079043, 33104.17239569006, 4028.234635419261, 4123.876283711464, 4133.1940271647045, 4161.625453709151, 4195.601417865298, 304115.0, 306605.0, 307752.0, 309403.0, 309979.0, 58811.41188588145, 58925.41074589285, 59391.40608593945, 59394.406055939755, 59423.70288148532, 70374.2962570378, 70662.0, 71271.2872871275, 71566.0, 71825.0, 15388.0, 15647.452339168074, 15651.686966260611, 15676.921615392079, 15691.13698746557, 11108.61119860801, 11183.384913829817, 11198.664040078811, 11236.775264494829, 11301.49143288554, 21315.68026479604, 22116.557668846533, 22295.219667311565, 22303.44241393978, 22310.776892231195, 8493.915060849313, 8704.04255531891, 8704.477731336014, 8743.606537705818, 8744.475331480131, 975.024975024975, 1014.9340292881087, 1076.8761592416815, 1079.7246702090918, 1127.7462570921641, 28023.299417514725, 28314.85842570774, 28519.57220641692, 28646.713532864404, 29049.12852614425, 1116.553378648547, 1116.9944150279196, 1135.4890299365154, 1177.7821103095782, 1264.480542432295, 14918.676946033325, 15125.54623361301, 15133.940624156423, 15244.771328430083, 17009.0, 410929.0, 740817.0, 755044.0, 755380.0, 765811.0, 59064.40935590675, 59076.0, 59496.702516488, 59800.102998455055, 59959.700201498716, 1461.6053665510465, 1493.8954273200989, 1495.6559991202084, 1502.3164460170597, 1506.517914267424, 30064.549031764105, 30390.544141837447, 30814.70533899874, 30932.845335773178, 31343.529847051857, 48488.0, 49512.50487495223, 49594.752026239636, 49637.75181124216, 49852.0, 319359.0, 319400.0, 320883.0, 321119.0, 321913.0, 33287.83356083204, 33707.831460842535, 44241.11517769691, 44380.334294984954, 44936.32595511005, 41008.58991410048, 41259.7937010313, 41676.0, 41969.370459443744, 42217.0, 38190.80904595459, 38509.42235866408, 38810.6118938807, 38892.80553597327, 39145.41281880831, 37807.43288850615, 38071.0, 38116.61883381242, 38372.23255534818, 38703.80648096742, 37130.8143459281, 37407.625923740416, 37862.43206351852, 38182.23635527329, 38414.423783643826, 33198.502022470166, 33553.0, 33578.83210583931, 33935.83032084923, 34019.82990085034, 26129.869350653124, 26481.337966550218, 26498.205053848415, 26772.196834095008, 26875.462490750466], "unit": "score", "name": "ext.html", "value": 20031.61324601267}, {"lowerIsBetter": false, "replicates": [387.8797572752445, 390.95113110861143, 394.95260568731754, 395.0759799775096, 397.79911144871835, 18039.549011274707, 18455.815441845578, 18499.630007399843, 18602.0, 18619.06904654767, 17361.565960850985, 17387.73918391222, 17670.558236044075, 17902.82097179028, 17926.103694815272, 5186.299849520323, 5344.064788661988, 5390.4879036491475, 5399.0, 5412.972935135319, 5235.55497782689, 5290.39160496544, 5331.866703332409, 5333.253344531769, 5355.892882142355, 5634.323881134249, 5687.971560142193, 5708.372079071299, 5712.600117991742, 5741.598088133832, 5563.610547261694, 5698.0, 5732.426757324297, 5742.397048309909, 5747.885042299152, 5217.34783152106, 5237.711925844077, 5239.764210610493, 5258.474152584749, 5282.445343238943, 14505.637359066002, 14898.106113633217, 14980.325885335076, 20407.183712651477, 22287.554248915094, 2244.046280330853, 2342.8125749939963, 2345.1791872844537, 2386.1529157149307, 2582.8966841326323, 10400.011998860096, 10426.322289051188, 10467.162626989822, 10699.78600427995, 10706.250562460631, 1925.442637647229, 1956.1197461142401, 2033.2836242388776, 2080.157536197842, 2260.3557985974085, 67303.66348168277, 67677.32322676759, 68078.65960670215, 68906.0, 69414.65292673555, 11477.942610287062, 11511.827322590168, 11561.07511399086, 11600.709982250512, 11713.707157320965, 15112.773308400383, 15372.923135384252, 15414.922925385526, 15520.456784012731, 15526.223688815515, 8201.507909525448, 8305.83388332242, 8488.10874858131, 8518.488890666456, 8531.701390451304, 8129.105798362176, 8181.754547363588, 8216.958915205385, 8237.588120593946, 8279.337652987746, 4722.787474563653, 4820.084184005098, 4933.703977761345, 5028.120078986163, 5067.214581739762, 1961.5782606739333, 1981.3857704111772, 1998.221582791317, 2014.5265862522297, 2090.864093833896, 973.0, 974.3228456222998, 1007.1892126837965, 1024.3085917005992, 1045.7072019834459, 17515.912420437817, 17693.734593981102, 17827.73258401125, 18109.0, 18540.16569254387, 971.0, 980.5293459139652, 1019.3934608907688, 1052.2476429353048, 1078.5200585739271, 10414.062734353945, 10425.218108641882, 10436.63471778484, 10466.842997355046, 10493.632722854663, 429135.0, 430228.0, 438667.0, 477245.0, 478266.0, 84093.57953210318, 84771.0, 86565.56717216373, 86863.13136868677, 87159.0, 1069.1767339148967, 1106.8837772033821, 1120.708615759892, 1122.180808010157, 1124.145649306533, 16094.839051609802, 16349.918250408671, 16403.83596164023, 16439.589010274838, 16832.326706931584, 34692.826535867156, 35179.472307915916, 36057.819710901276, 36264.36810343488, 36865.0, 51449.742751286, 52430.73784631053, 52561.7371913138, 52611.73694131658, 53147.0, 8612.870806938026, 8613.827723445622, 8811.823763524822, 8820.294376449998, 8868.512231827312, 12054.698632533906, 12847.486100555872, 12864.485420583445, 13312.0, 13500.662483437993, 11106.833397499206, 11158.776824463303, 11384.886151138382, 11694.4737486815, 11808.0, 11571.247868888495, 11721.296722196696, 11728.061755059403, 11910.52357905674, 11914.285142891455, 11126.165537584875, 12024.0, 12041.397930103634, 12229.205101668718, 12255.142140050468, 8236.094029656853, 8296.585170741319, 8836.64653413882, 9055.23030542385, 9086.500242486727, 10447.0, 11541.711457213636, 11580.768384632429, 11584.826227606762, 11612.129090318429], "unit": "score", "name": "jquery.html", "value": 8983.277754079989}, {"lowerIsBetter": false, "replicates": [1591.5464092733569, 1611.4601608461162, 1858.2752726436693, 1890.9527261818462, 1953.3456292142132, 7579.924200757991, 7883.448158628884, 8117.553534555597, 8244.752657420271, 8287.254147126758, 8244.793880152984, 8252.546109963949, 8282.668693252277, 8312.210340017704, 8345.499270043787, 2445.0464318915638, 2459.8524088554655, 2476.7151777545632, 2479.38015496126, 2482.3049546127113, 2423.006567307404, 2445.596476581362, 2449.0938352809485, 2450.473148273121, 2461.5569197544437, 2432.2460037388464, 2433.85396876188, 2482.5283196192668, 2487.253823852846, 2488.6142647889606, 2390.6533552634855, 2400.0519794681177, 2414.806815454768, 2461.963070553943, 2470.851748895072, 2415.070197973775, 2438.317271164077, 2439.707235131778, 2451.9877400613063, 2459.88930498128, 8449.746507604781, 8485.66057357705, 8507.489550626982, 8519.446235994641, 8540.103289154611, 4965.180745177077, 5025.1959686450355, 5079.23811428285, 5096.159133742928, 5114.207297868837, 3162.430762462756, 3175.666555011737, 3213.7268332191793, 3232.4181647303476, 3289.605247370307, 1063.165415149112, 1893.2994791927076, 2014.6776515757556, 2025.9189632414686, 2030.279250865936, 11225.8316125259, 11276.605318813803, 11332.49003794823, 11334.489947952361, 11339.489722962486, 4304.634106100953, 4322.200392927319, 4396.4064851244675, 4397.450318710161, 4480.462344518679, 8889.466632001971, 8920.910790892138, 8937.0, 8943.418677786054, 8976.41653292534, 5063.544281014726, 5069.112905241642, 5082.1360368737405, 5101.540861322499, 5109.489051094861, 4080.4083407905687, 4617.884552886205, 4647.18674232008, 4647.395838540968, 4689.390379250675, 3786.242751449666, 3796.202797412519, 3860.0, 3871.4773505576386, 3874.0702231464247, 1075.166745772033, 1075.671920064388, 1078.1536493852288, 1082.0964494647058, 1085.0776839686202, 1389.4650559534653, 1419.1272367493916, 1421.7583010888175, 1424.6865689548283, 1432.6561625209874, 7570.394368450511, 7735.845283094307, 7760.9223907761325, 7769.184235655175, 7772.300492955661, 1189.6431070678761, 1198.394810620631, 1208.1844754790482, 1208.7280361918674, 1223.094909766784, 6060.666663333559, 6175.413335733098, 6266.843328916813, 6304.747810087545, 6323.810285691437, 10158.288919775545, 10434.37393756377, 10479.266451348332, 10547.314424562379, 10642.574297028032, 10095.596176153018, 10240.897591024144, 10289.9485502572, 10291.177143539331, 10341.224408169266, 7996.960015200003, 8057.959710201411, 8094.83810323802, 8108.675652973933, 8132.75601731949, 7488.101427828696, 7577.659005344663, 7727.690892364468, 7728.806779830549, 7756.108047574601, 8655.783605409915, 8831.955840220759, 9209.263258939403, 9238.122378374044, 9266.721998340061, 8972.327075469235, 8979.865302020344, 9120.087991200828, 9295.488748118918, 9346.0653934606, 6572.277049524453, 6891.207511136284, 7047.647617618996, 7191.532550384209, 7301.63491825396, 7951.204879512234, 7977.321927635984, 7981.241782030698, 7991.640376183202, 8012.879806802786, 7132.8930066048015, 7240.312170343809, 7336.559806411632, 7486.812829679302, 7499.362554182738, 6942.687579059056, 7082.150141982995, 7096.042034325506, 7231.4214862811905, 7261.092363454568, 7381.741639042608, 7383.704651813868, 7470.701171953278, 7482.738104166328, 7510.248975102446, 6830.829229269308, 6884.311568843075, 6898.793036208922, 6917.757878474229, 6930.410915072073, 6707.8993815091835, 6716.3955244028275, 6728.091707619409, 6739.66301684904, 6766.966165169143], "unit": "score", "name": "mootools.html", "value": 4854.10833686432}, {"lowerIsBetter": false, "replicates": [359.4177432559254, 361.3621957245464, 367.3369567929887, 368.2873639507552, 370.4961252696334, 6365.077063825743, 6401.9359806402035, 6421.036844473326, 6472.967635161829, 6496.350364963501, 6322.0832979217985, 6325.304216536178, 6334.049892516125, 6366.872662546746, 6369.299377068519, 4723.78742956566, 4839.4434640016325, 4842.733649649268, 4860.684055536397, 4927.359443272369, 4824.493428190025, 4842.0, 4844.418669759616, 4847.442544107437, 4855.732934688591, 4813.78337974792, 4822.97588512057, 4827.637927155477, 4867.440244371889, 4869.634777391692, 4840.830570930018, 4853.611711063124, 4860.659753817235, 4862.051899879525, 4864.537868902448, 4207.957920420788, 4208.179405016023, 4237.237297286487, 4253.617174454314, 4260.595243451867, 5916.556258280603, 6010.308814486346, 6084.239470066242, 6087.239095113111, 6092.268927728701, 5621.437856214387, 5628.296462942132, 5629.943700563023, 5633.436656334375, 5647.717614119278, 6706.2958389368905, 6709.932900671029, 6748.325167483262, 6757.966210168917, 6764.966175169142, 4660.627149828006, 4663.044075964419, 4665.95334046662, 4668.906621867578, 4673.906521869543, 7039.648017599099, 7097.432205423605, 7102.857942841166, 7113.679884405215, 7127.750528731522, 4715.481297057321, 4779.784909679072, 4801.231802911518, 4809.350737650372, 4838.225883858566, 4826.0, 4857.6599638025, 4861.465238823726, 4868.050730107595, 4880.463149053601, 5620.213170156181, 5635.6618602883955, 5649.4633009864, 5653.491185793298, 5657.971710141505, 6792.234019155056, 6806.829829254309, 6833.58998460094, 6836.658167091626, 6843.213030501556, 1691.3910992042854, 1704.4119778676336, 1713.1862365376346, 1713.4431309824108, 1713.5116491799777, 1119.776044791045, 1134.4838098665089, 1138.4194061028934, 1149.9597514086968, 1168.1764356128908, 6432.935670643327, 6472.158619379545, 6499.740010399626, 6546.8363290918105, 6564.474842012628, 7002.124734408199, 7038.612876291751, 7046.577205367695, 7058.894116588255, 7062.964685176541, 6278.121063051177, 6382.489400847921, 6518.543701940914, 6528.575642583217, 6593.0, 3809.9238015240094, 3813.7330386872654, 3825.923481530354, 3843.597087063202, 3851.9807400963377, 7315.195328513859, 7351.669174887143, 7357.2642735726, 7374.815629609196, 7378.225286344964, 7255.383292420098, 7257.2742725727, 7310.268973102648, 7319.011933388924, 7325.560466372035, 7138.678759455837, 7282.089738782653, 7328.853422931512, 7335.486515943832, 7430.702771889064, 7073.151221853411, 7107.75122870697, 7146.678399471933, 7162.033125528195, 7165.140183177844, 7008.509404341851, 7013.579185248697, 7014.088168538057, 7031.156261248479, 7042.190148132825, 7334.6699398526125, 7358.484906056525, 7377.963110184414, 7384.593847338448, 7385.741499047507, 4888.413390393175, 4979.850604481871, 5026.874328141826, 5040.36995375578, 5047.116754568009, 7019.333163349474, 7040.295970402919, 7047.048648432396, 7054.470914681317, 7054.541454805421, 6833.145856767904, 6836.145481814773, 6837.213720422215, 6850.21222559412, 6857.108575885103, 6763.526553141233, 6850.965745171242, 6887.896681549881, 6907.965460172667, 6911.239763626098, 6538.280789113289, 6733.93266067333, 6774.491913106635, 6815.965920170367, 6826.078479405415, 6900.827479313058, 6929.440875803106, 6934.757283495053, 6941.583504989717, 6941.583504989717, 6740.696668650021, 6782.660866956731, 6794.3545363190415, 6814.522983391115, 6848.212455567674], "unit": "score", "name": "prototype.html", "value": 5141.278897278967}, {"lowerIsBetter": false, "replicates": [800.0839039300001, 810.3112354498674, 887.1040249348157, 909.4725059465511, 915.0940568836852, 13979.860201397983, 14053.71892562148, 14067.929660351709, 14121.223332716709, 14131.576052718423, 11144.108471322295, 14058.0, 14150.78773818391, 14167.574972750808, 14198.0, 888.5912480259072, 924.3714274293478, 928.6007016982695, 928.8838895138108, 931.1945167430158, 906.2478143141177, 906.4334790755778, 912.4023764434273, 913.5386629751999, 919.3426699909563, 939.248601119102, 943.3632298198688, 943.7404713703752, 947.1854205383365, 948.170350942925, 939.4832841936976, 942.4251206763903, 943.5612440215299, 943.9197668198211, 945.3618807305041, 693.7675878580682, 694.0491526608579, 696.7247937064882, 696.7770313499682, 697.7488104282454, 14976.70046599062, 15044.774328385083, 15062.698746025128, 15143.318550665246, 15252.0, 13927.234002129879, 14211.0, 14215.857841421557, 14345.211013394259, 14352.354144063542, 11435.714107147387, 11570.652880413601, 11586.884131158666, 11589.884101158965, 11623.360715160663, 3942.250972315251, 3957.1294315250598, 3957.5053118360206, 3960.386140148282, 4068.3897415387632, 51815.74092129553, 52025.0, 52208.0, 52227.0, 52346.0, 10029.899701003042, 10091.394516329045, 10121.443320617289, 10122.746931326776, 10482.947585262025, 20898.58202835965, 20982.895085524473, 21004.47488812792, 21052.368428947157, 21053.0, 8272.131426200162, 8460.873086903579, 8492.490450572861, 8539.359548033923, 8585.441946273471, 4427.424434823452, 4446.644268458515, 4524.25349817283, 4567.634589232854, 4690.671652984327, 3265.0368141398344, 3329.417351963397, 3336.182635254378, 3347.6987071163226, 3347.832608369572, 559.0607778931353, 564.9632773869686, 567.7274908044162, 569.8091139468324, 593.3888095261888, 704.4047779626208, 720.6108701301343, 725.7060890339316, 746.1754760989137, 748.0312994671913, 8312.584370781437, 8377.832443351099, 8482.279006284412, 8562.058173600899, 8575.442596231225, 658.9143411356494, 678.7963610916705, 682.952193346471, 703.711478293897, 705.2524324216347, 4001.6198461146146, 4026.315526360526, 4041.3735870939463, 4048.1903619276263, 4177.603127702863, 57072.0, 59195.70402148048, 59365.70317148473, 59582.70208648929, 59790.10314845281, 53717.0, 54651.453485465434, 54689.1796623051, 55252.17121743177, 55442.0, 47732.5226747735, 47838.76080619574, 48807.755961220675, 48950.75524622425, 49780.253296200586, 8780.78048048804, 8845.69040083594, 8913.598888049924, 8969.820603587761, 9048.321375896703, 38414.0, 38437.23125537529, 38559.228815422975, 39002.809410024216, 39971.40042899301, 49070.509294906595, 49100.0, 49544.256836148204, 49905.50094499008, 50025.74987125041, 12260.019198463922, 12342.13605047638, 12465.189762665397, 12549.43527541281, 12608.243505389706, 12863.614091577268, 13080.476780929037, 13316.533921312708, 13751.374590110896, 14015.789763153356, 11894.107941904565, 11903.0, 11908.880911190778, 11993.220440671328, 12291.69270768238, 12002.1598488105, 12029.759404811679, 12169.939150304546, 12297.385130743249, 12586.685332866751, 11417.0, 11424.257423267461, 11526.827097593376, 11663.300201987568, 11819.586314478953, 10707.5181616829, 10846.457677115955, 10934.835977460185, 11038.724031899266, 11117.777644447227, 10418.92533286709, 10455.634052808115, 10530.210234232616, 10540.472976351306, 10546.472676366304], "unit": "score", "name": "yui.html", "value": 6820.105442279529}], "name": "dromaeo_css", "value": 7424.914383251613}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 104.0, 112.0, 112.0, 112.0, 123.0, 111.0, 110.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.7}, {"lowerIsBetter": true, "replicates": [160.0, 128.0, 162.0, 177.0, 126.0, 153.0, 160.0, 127.0, 165.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 148.7}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 160.0, 162.0, 160.0, 160.0, 161.0, 166.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [74.0, 76.0, 74.0, 173.0, 74.0, 78.0, 72.0, 76.0, 155.0, 76.0], "unit": "score", "name": "audio-fft", "value": 92.8}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 146.0, 94.0, 92.0, 93.0, 145.0, 93.0, 93.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 107.9}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 117.0, 118.0, 119.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.4}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 97.0, 96.0, 96.0, 97.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [54.0, 58.0, 56.0, 58.0, 54.0, 59.0, 56.0, 61.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.2}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 65.0, 64.0, 66.0, 65.0, 64.0, 65.0, 65.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.8}, {"lowerIsBetter": true, "replicates": [85.0, 79.0, 80.0, 88.0, 79.0, 80.0, 80.0, 78.0, 81.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.8}, {"lowerIsBetter": true, "replicates": [111.0, 114.0, 113.0, 116.0, 119.0, 113.0, 114.0, 118.0, 120.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.2}, {"lowerIsBetter": true, "replicates": [139.0, 148.0, 151.0, 159.0, 156.0, 143.0, 148.0, 146.0, 150.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.6}, {"lowerIsBetter": true, "replicates": [70.0, 67.0, 68.0, 68.0, 68.0, 69.0, 67.0, 69.0, 66.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.1}], "name": "kraken", "value": 1515.8999999999996}]} 22:29:58 INFO - Return code: 0 22:29:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:29:58 ERROR - # TBPL SUCCESS # 22:29:58 INFO - Running post-action listener: _resource_record_post_action 22:29:58 INFO - Running post-run listener: _resource_record_post_run 22:29:59 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 266240; Write bytes: 499249152; Read time: 24; Write time: 484388 22:29:59 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 244715520; Read time: 0; Write time: 350544 22:29:59 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 266240; Write bytes: 254533632; Read time: 24; Write time: 133844 22:29:59 INFO - Running post-run listener: _upload_blobber_files 22:29:59 INFO - Blob upload gear active. 22:29:59 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:29:59 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:29:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 22:29:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 22:30:00 INFO - (blobuploader) - INFO - Open directory for files ... 22:30:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:30:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:30:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:30:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:30:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:30:03 INFO - (blobuploader) - INFO - Done attempting. 22:30:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:30:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:30:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:30:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:30:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:30:05 INFO - (blobuploader) - INFO - Done attempting. 22:30:05 INFO - (blobuploader) - INFO - Iteration through files over. 22:30:05 INFO - Return code: 0 22:30:05 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:30:05 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:30:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/647dd86fb9e3844bf5750b7ae83061a782fe9e22f36f47002b5bdb768c469065a6fa4bd2839074beadacaf5e1fd5d073f3ab31dbc9ce23c1cf09a58c526db829", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7e6af534ac645bdfbd5fece5d8d8ccf0f799cff5921d2a1712d9f5546481ff769851158bb1d79fe4d94d86b3b8fdeb55f7bd5432976421b1124bfc2b8f840062"} 22:30:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:30:05 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:30:05 INFO - Contents: 22:30:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/647dd86fb9e3844bf5750b7ae83061a782fe9e22f36f47002b5bdb768c469065a6fa4bd2839074beadacaf5e1fd5d073f3ab31dbc9ce23c1cf09a58c526db829", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7e6af534ac645bdfbd5fece5d8d8ccf0f799cff5921d2a1712d9f5546481ff769851158bb1d79fe4d94d86b3b8fdeb55f7bd5432976421b1124bfc2b8f840062"} 22:30:05 INFO - Running post-run listener: copy_logs_to_upload_dir 22:30:05 INFO - Copying logs to upload dir... 22:30:05 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:30:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.207561 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-03-23 22:30:05.315981) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-23 22:30:05.319091) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1458791551.447470-837921025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/647dd86fb9e3844bf5750b7ae83061a782fe9e22f36f47002b5bdb768c469065a6fa4bd2839074beadacaf5e1fd5d073f3ab31dbc9ce23c1cf09a58c526db829", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7e6af534ac645bdfbd5fece5d8d8ccf0f799cff5921d2a1712d9f5546481ff769851158bb1d79fe4d94d86b3b8fdeb55f7bd5432976421b1124bfc2b8f840062"} build_url:https://queue.taskcluster.net/v1/task/E1a0LUgGQYi3zUD60zhtSA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/E1a0LUgGQYi3zUD60zhtSA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/647dd86fb9e3844bf5750b7ae83061a782fe9e22f36f47002b5bdb768c469065a6fa4bd2839074beadacaf5e1fd5d073f3ab31dbc9ce23c1cf09a58c526db829", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7e6af534ac645bdfbd5fece5d8d8ccf0f799cff5921d2a1712d9f5546481ff769851158bb1d79fe4d94d86b3b8fdeb55f7bd5432976421b1124bfc2b8f840062"}' ========= master_lag: 0.10 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-23 22:30:05.427145) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 22:30:05.427494) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1458791551.447470-837921025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.13 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 22:30:05.560105) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-23 22:30:05.560429) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-23 22:30:05.560754) ========= ========= Total master_lag: 0.63 =========