builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-026 starttime: 1460512699.93 results: success (0) buildid: 20160412163035 builduid: 10dfc807cdf946a68de9b59ba3a2d81d revision: fb921246e2d60f521f83defed54e30a38df1be3e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:19.927253) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:19.927717) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:19.928007) ========= 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=41bf3e9aed84707956354da8000001c5-1460510962.741593-1884689750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006484 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:19.952967) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:19.953319) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:19.974040) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:19.974329) ========= 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=41bf3e9aed84707956354da8000001c5-1460510962.741593-1884689750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.025550 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:20.020567) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:20.020873) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:20.021259) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:20.021540) ========= 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=41bf3e9aed84707956354da8000001c5-1460510962.741593-1884689750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-12 18:58:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 216M=0s 2016-04-12 18:58:20 (216 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.191164 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:20.225145) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:20.225460) ========= 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=41bf3e9aed84707956354da8000001c5-1460510962.741593-1884689750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.076086 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:20.313012) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:20.313373) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fb921246e2d60f521f83defed54e30a38df1be3e --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev fb921246e2d60f521f83defed54e30a38df1be3e --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=41bf3e9aed84707956354da8000001c5-1460510962.741593-1884689750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-12 18:58:20,651 truncating revision to first 12 chars 2016-04-12 18:58:20,651 Setting DEBUG logging. 2016-04-12 18:58:20,651 attempt 1/10 2016-04-12 18:58:20,652 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fb921246e2d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-12 18:58:20,921 unpacking tar archive at: mozilla-central-fb921246e2d6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.599666 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:20.927609) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:20.928202) ========= echo fb921246e2d60f521f83defed54e30a38df1be3e in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'fb921246e2d60f521f83defed54e30a38df1be3e'] 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=41bf3e9aed84707956354da8000001c5-1460510962.741593-1884689750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False fb921246e2d60f521f83defed54e30a38df1be3e program finished with exit code 0 elapsedTime=0.004704 script_repo_revision: 'fb921246e2d60f521f83defed54e30a38df1be3e' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:20.980080) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:20.980405) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 18:58:20.990583) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-12 18:58:20.990964) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=41bf3e9aed84707956354da8000001c5-1460510962.741593-1884689750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:58:21 INFO - MultiFileLogger online at 20160412 18:58:21 in /builds/slave/test-pgo 18:58:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:58:21 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:58:21 INFO - {'append_to_log': False, 18:58:21 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:58:21 INFO - 'blob_upload_branch': 'Firefox', 18:58:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:58:21 INFO - 'branch': 'Firefox', 18:58:21 INFO - 'buildbot_json_path': 'buildprops.json', 18:58:21 INFO - 'config_files': ('talos/linux_config.py',), 18:58:21 INFO - 'default_actions': ('clobber', 18:58:21 INFO - 'read-buildbot-config', 18:58:21 INFO - 'download-and-extract', 18:58:21 INFO - 'populate-webroot', 18:58:21 INFO - 'create-virtualenv', 18:58:21 INFO - 'install', 18:58:21 INFO - 'run-tests'), 18:58:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:58:21 INFO - 'download_minidump_stackwalk': True, 18:58:21 INFO - 'download_symbols': 'ondemand', 18:58:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:58:21 INFO - 'tooltool.py': '/tools/tooltool.py', 18:58:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:58:21 INFO - '/tools/misc-python/virtualenv.py')}, 18:58:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:58:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:58:21 INFO - 'installer_path': 'installer.exe', 18:58:21 INFO - 'log_level': 'info', 18:58:21 INFO - 'log_name': 'talos', 18:58:21 INFO - 'log_to_console': True, 18:58:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:58:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:58:21 INFO - 'opt_config_files': (), 18:58:21 INFO - 'pip_index': False, 18:58:21 INFO - 'sps_profile': False, 18:58:21 INFO - 'sps_profile_interval': 0, 18:58:21 INFO - 'suite': 'dromaeojs-e10s', 18:58:21 INFO - 'system_bits': '32', 18:58:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:58:21 INFO - 'title': 'talos-linux64-ix-026', 18:58:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:58:21 INFO - 'use_talos_json': True, 18:58:21 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:58:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:58:21 INFO - 'work_dir': 'build'} 18:58:21 INFO - ##### 18:58:21 INFO - ##### Running clobber step. 18:58:21 INFO - ##### 18:58:21 INFO - Running pre-action listener: _resource_record_pre_action 18:58:21 INFO - Running main action method: clobber 18:58:21 INFO - rmtree: /builds/slave/test-pgo/build 18:58:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:58:25 INFO - Running post-action listener: _resource_record_post_action 18:58:25 INFO - ##### 18:58:25 INFO - ##### Running read-buildbot-config step. 18:58:25 INFO - ##### 18:58:25 INFO - Running pre-action listener: _resource_record_pre_action 18:58:25 INFO - Running main action method: read_buildbot_config 18:58:25 INFO - Using buildbot properties: 18:58:25 INFO - { 18:58:25 INFO - "project": "", 18:58:25 INFO - "product": "firefox", 18:58:25 INFO - "script_repo_revision": "production", 18:58:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:58:25 INFO - "repository": "", 18:58:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 18:58:25 INFO - "buildid": "20160412163035", 18:58:25 INFO - "pgo_build": "True", 18:58:25 INFO - "basedir": "/builds/slave/test-pgo", 18:58:25 INFO - "buildnumber": 412, 18:58:25 INFO - "slavename": "talos-linux64-ix-026", 18:58:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:58:25 INFO - "platform": "ubuntu64_hw", 18:58:25 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 18:58:25 INFO - "branch": "mozilla-central", 18:58:25 INFO - "repo_path": "mozilla-central", 18:58:25 INFO - "revision": "fb921246e2d60f521f83defed54e30a38df1be3e", 18:58:25 INFO - "stage_platform": "linux64-pgo", 18:58:25 INFO - "builduid": "10dfc807cdf946a68de9b59ba3a2d81d", 18:58:25 INFO - "slavebuilddir": "test" 18:58:25 INFO - } 18:58:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 18:58:25 INFO - Running post-action listener: _resource_record_post_action 18:58:25 INFO - ##### 18:58:25 INFO - ##### Running download-and-extract step. 18:58:25 INFO - ##### 18:58:25 INFO - Running pre-action listener: _resource_record_pre_action 18:58:25 INFO - Running main action method: download_and_extract 18:58:25 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:58:25 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')]} 18:58:25 INFO - https://queue.taskcluster.net/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:58:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:58:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:58:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:58:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:58:29 INFO - Downloaded 1361 bytes. 18:58:29 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:58:29 INFO - Using the following test package requirements: 18:58:29 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:58:29 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:58:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:58:29 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:58:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:58:29 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:58:29 INFO - u'jsshell-linux-x86_64.zip'], 18:58:29 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:58:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:58:29 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:58:29 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:58:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:58:29 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:58:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:58:29 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:58:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:58:29 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:58:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:58:29 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:58:29 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')]} 18:58:29 INFO - https://queue.taskcluster.net/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:58:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:58:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:58:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:58:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:58:33 INFO - Downloaded 23769494 bytes. 18:58:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:58:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 18:58:34 INFO - Return code: 0 18:58:34 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:58: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')]} 18:58:34 INFO - https://queue.taskcluster.net/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:58:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:58:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:58:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:58:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:58:36 INFO - Downloaded 23769494 bytes. 18:58:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:58:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 18:58:37 INFO - Return code: 0 18:58: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')]} 18:58:37 INFO - https://queue.taskcluster.net/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:58:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:58:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:58:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:58:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:58:38 INFO - Downloaded 10841076 bytes. 18:58:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:58:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 18:58:38 INFO - Return code: 0 18:58:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:38 INFO - https://queue.taskcluster.net/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:58:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:58:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:58:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:58:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:58:40 INFO - Downloaded 57823919 bytes. 18:58:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:58:40 INFO - mkdir: /builds/slave/test-pgo/properties 18:58:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:58:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:58:40 INFO - Contents: 18:58:40 INFO - build_url:https://queue.taskcluster.net/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:58:41 INFO - Running post-action listener: _resource_record_post_action 18:58:41 INFO - Running post-action listener: set_extra_try_arguments 18:58:41 INFO - ##### 18:58:41 INFO - ##### Running populate-webroot step. 18:58:41 INFO - ##### 18:58:41 INFO - Running pre-action listener: _resource_record_pre_action 18:58:41 INFO - Running main action method: populate_webroot 18:58:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:58:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:58:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:58:41 INFO - '--tppagecycles', 18:58:41 INFO - '7'], 18:58:41 INFO - 'tests': ['tsvgm']}}, 18:58:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:58:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:58:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:58:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:58:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:58:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:58:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:41 INFO - 'talos_options': ['--disable-e10s'], 18:58:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:58:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:58:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:41 INFO - 'talos_options': ['--disable-e10s'], 18:58:41 INFO - 'tests': ['damp', 'tps']}, 18:58:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:41 INFO - 'tests': ['damp', 'tps']}, 18:58:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:58:41 INFO - 'tests': ['dromaeo_dom']}, 18:58:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:58:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:58:41 INFO - 'tests': ['a11yr', 18:58:41 INFO - 'ts_paint', 18:58:41 INFO - 'tpaint', 18:58:41 INFO - 'sessionrestore', 18:58:41 INFO - 'sessionrestore_no_auto_restore', 18:58:41 INFO - 'tabpaint']}, 18:58:41 INFO - 'other-e10s': {'tests': ['a11yr', 18:58:41 INFO - 'ts_paint', 18:58:41 INFO - 'tpaint', 18:58:41 INFO - 'sessionrestore', 18:58:41 INFO - 'sessionrestore_no_auto_restore', 18:58:41 INFO - 'tabpaint']}, 18:58:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:58:41 INFO - 'ts_paint', 18:58:41 INFO - 'tpaint', 18:58:41 INFO - 'sessionrestore', 18:58:41 INFO - 'sessionrestore_no_auto_restore', 18:58:41 INFO - 'tabpaint']}, 18:58:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:58:41 INFO - 'ts_paint', 18:58:41 INFO - 'tpaint', 18:58:41 INFO - 'sessionrestore', 18:58:41 INFO - 'sessionrestore_no_auto_restore', 18:58:41 INFO - 'tabpaint']}, 18:58:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:58:41 INFO - 'tests': ['a11yr', 18:58:41 INFO - 'ts_paint', 18:58:41 INFO - 'tpaint', 18:58:41 INFO - 'sessionrestore', 18:58:41 INFO - 'sessionrestore_no_auto_restore', 18:58:41 INFO - 'tabpaint']}, 18:58:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:58:41 INFO - 'tests': ['a11yr', 18:58:41 INFO - 'ts_paint', 18:58:41 INFO - 'tpaint', 18:58:41 INFO - 'sessionrestore', 18:58:41 INFO - 'sessionrestore_no_auto_restore', 18:58:41 INFO - 'tabpaint']}, 18:58:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:58:41 INFO - 'tests': ['tsvgx', 18:58:41 INFO - 'tsvgr_opacity', 18:58:41 INFO - 'tart', 18:58:41 INFO - 'tscrollx', 18:58:41 INFO - 'cart']}, 18:58:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:58:41 INFO - 'tsvgr_opacity', 18:58:41 INFO - 'tart', 18:58:41 INFO - 'tscrollx', 18:58:41 INFO - 'cart']}, 18:58:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:41 INFO - 'talos_options': ['--disable-e10s'], 18:58:41 INFO - 'tests': ['tp5o']}, 18:58:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:41 INFO - 'tests': ['tp5o']}, 18:58:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:41 INFO - 'talos_options': ['--disable-e10s', 18:58:41 INFO - '--xperf_path', 18:58:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:58:41 INFO - 'tests': ['tp5n']}, 18:58:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:41 INFO - 'talos_options': ['--xperf_path', 18:58:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:58:41 INFO - 'tests': ['tp5n']}}, 18:58:41 INFO - 'talos.zip': {'path': '', 18:58:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:58:41 INFO - Running post-action listener: _resource_record_post_action 18:58:41 INFO - ##### 18:58:41 INFO - ##### Running create-virtualenv step. 18:58:41 INFO - ##### 18:58:41 INFO - Running pre-action listener: _resource_record_pre_action 18:58:41 INFO - Running main action method: create_virtualenv 18:58:41 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:58:41 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 18:58:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:58:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:58:41 INFO - Using real prefix '/usr' 18:58:41 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:58:41 INFO - Installing distribute.............................................................................................................................................................................................done. 18:58:43 INFO - Installing pip.................done. 18:58:43 INFO - Return code: 0 18:58:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:58: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')]} 18:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58: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')]} 18:58:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7eff48f94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fb8b0>, '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 0x25fc7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fcc60>, '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': '41bf3e9aed84707956354da8000001c5-1460510962.741593-1884689750', '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 18:58:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 18:58:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:58:43 INFO - Using env: {'DISPLAY': ':0', 18:58:43 INFO - 'HOME': '/home/cltbld', 18:58:43 INFO - 'LANG': 'en_US.UTF-8', 18:58:43 INFO - 'LANGUAGE': 'en_US:en', 18:58:43 INFO - 'LOGNAME': 'cltbld', 18:58:43 INFO - 'MAIL': '/var/mail/cltbld', 18:58:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:43 INFO - 'MOZ_NO_REMOTE': '1', 18:58:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:43 INFO - 'NO_EM_RESTART': '1', 18:58:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:58:43 INFO - 'PWD': '/builds/slave/test-pgo', 18:58:43 INFO - 'SHELL': '/bin/bash', 18:58:43 INFO - 'SHLVL': '1', 18:58:43 INFO - 'TERM': 'linux', 18:58:43 INFO - 'TMOUT': '86400', 18:58:43 INFO - 'USER': 'cltbld', 18:58:43 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1460510962.741593-1884689750', 18:58:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:43 INFO - '_': '/tools/buildbot/bin/python'} 18:58:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:44 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 18:58:44 INFO - Cleaning up... 18:58:44 INFO - Return code: 0 18:58:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:58: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')]} 18:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58: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')]} 18:58:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:44 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 0x7eff48f94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fb8b0>, '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 0x25fc7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fcc60>, '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': '41bf3e9aed84707956354da8000001c5-1460510962.741593-1884689750', '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 18:58:44 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 18:58:44 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 18:58:44 INFO - Using env: {'DISPLAY': ':0', 18:58:44 INFO - 'HOME': '/home/cltbld', 18:58:44 INFO - 'LANG': 'en_US.UTF-8', 18:58:44 INFO - 'LANGUAGE': 'en_US:en', 18:58:44 INFO - 'LOGNAME': 'cltbld', 18:58:44 INFO - 'MAIL': '/var/mail/cltbld', 18:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:44 INFO - 'MOZ_NO_REMOTE': '1', 18:58:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:44 INFO - 'NO_EM_RESTART': '1', 18:58:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:58:44 INFO - 'PWD': '/builds/slave/test-pgo', 18:58:44 INFO - 'SHELL': '/bin/bash', 18:58:44 INFO - 'SHLVL': '1', 18:58:44 INFO - 'TERM': 'linux', 18:58:44 INFO - 'TMOUT': '86400', 18:58:44 INFO - 'USER': 'cltbld', 18:58:44 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1460510962.741593-1884689750', 18:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:44 INFO - '_': '/tools/buildbot/bin/python'} 18:58:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:44 INFO - Downloading/unpacking psutil>=0.7.1 18:58:44 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 18:58:44 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 18:58:44 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 18:58:44 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 18:58:44 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 18:58:44 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 18:58:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:58:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:58:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:58:46 INFO - Installing collected packages: psutil 18:58:46 INFO - Running setup.py install for psutil 18:58:46 INFO - building 'psutil._psutil_linux' extension 18:58:46 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 18:58:46 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 18:58:46 INFO - building 'psutil._psutil_posix' extension 18:58:46 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 18:58:46 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 18:58:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:58:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:58:46 INFO - Successfully installed psutil 18:58:46 INFO - Cleaning up... 18:58:46 INFO - Return code: 0 18:58:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:46 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 0x7eff48f94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fb8b0>, '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 0x25fc7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fcc60>, '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': '41bf3e9aed84707956354da8000001c5-1460510962.741593-1884689750', '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 18:58:46 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 18:58:46 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 18:58:46 INFO - Using env: {'DISPLAY': ':0', 18:58:46 INFO - 'HOME': '/home/cltbld', 18:58:46 INFO - 'LANG': 'en_US.UTF-8', 18:58:46 INFO - 'LANGUAGE': 'en_US:en', 18:58:46 INFO - 'LOGNAME': 'cltbld', 18:58:46 INFO - 'MAIL': '/var/mail/cltbld', 18:58:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:46 INFO - 'MOZ_NO_REMOTE': '1', 18:58:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:46 INFO - 'NO_EM_RESTART': '1', 18:58:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:58:46 INFO - 'PWD': '/builds/slave/test-pgo', 18:58:46 INFO - 'SHELL': '/bin/bash', 18:58:46 INFO - 'SHLVL': '1', 18:58:46 INFO - 'TERM': 'linux', 18:58:46 INFO - 'TMOUT': '86400', 18:58:46 INFO - 'USER': 'cltbld', 18:58:46 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1460510962.741593-1884689750', 18:58:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:46 INFO - '_': '/tools/buildbot/bin/python'} 18:58:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:58:47 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 18:58:47 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 18:58:47 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 18:58:47 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 18:58:47 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 18:58:47 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 18:58:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:58:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:58:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:58:49 INFO - Installing collected packages: mozsystemmonitor 18:58:49 INFO - Running setup.py install for mozsystemmonitor 18:58:49 INFO - Successfully installed mozsystemmonitor 18:58:49 INFO - Cleaning up... 18:58:49 INFO - Return code: 0 18:58:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:58:49 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')]} 18:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:49 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')]} 18:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:49 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 0x7eff48f94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fb8b0>, '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 0x25fc7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fcc60>, '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': '41bf3e9aed84707956354da8000001c5-1460510962.741593-1884689750', '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 18:58:49 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 18:58:49 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 18:58:49 INFO - Using env: {'DISPLAY': ':0', 18:58:49 INFO - 'HOME': '/home/cltbld', 18:58:49 INFO - 'LANG': 'en_US.UTF-8', 18:58:49 INFO - 'LANGUAGE': 'en_US:en', 18:58:49 INFO - 'LOGNAME': 'cltbld', 18:58:49 INFO - 'MAIL': '/var/mail/cltbld', 18:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:49 INFO - 'MOZ_NO_REMOTE': '1', 18:58:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:49 INFO - 'NO_EM_RESTART': '1', 18:58:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:58:49 INFO - 'PWD': '/builds/slave/test-pgo', 18:58:49 INFO - 'SHELL': '/bin/bash', 18:58:49 INFO - 'SHLVL': '1', 18:58:49 INFO - 'TERM': 'linux', 18:58:49 INFO - 'TMOUT': '86400', 18:58:49 INFO - 'USER': 'cltbld', 18:58:49 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1460510962.741593-1884689750', 18:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:49 INFO - '_': '/tools/buildbot/bin/python'} 18:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:49 INFO - Downloading/unpacking blobuploader==1.2.4 18:58:49 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 18:58:49 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 18:58:49 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 18:58:49 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 18:58:49 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 18:58:49 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 18:58:51 INFO - Downloading blobuploader-1.2.4.tar.gz 18:58:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:58:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:58: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 18:58: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 18:58: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 18:58: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 18:58: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 18:58: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 18:58:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:58:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:58: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 18:58: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 18:58: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 18:58: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 18:58: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 18:58: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 18:58:51 INFO - Downloading docopt-0.6.1.tar.gz 18:58:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:58:52 INFO - Installing collected packages: blobuploader, requests, docopt 18:58:52 INFO - Running setup.py install for blobuploader 18:58:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:58:52 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:58:52 INFO - Running setup.py install for requests 18:58:52 INFO - Running setup.py install for docopt 18:58:52 INFO - Successfully installed blobuploader requests docopt 18:58:52 INFO - Cleaning up... 18:58:52 INFO - Return code: 0 18:58:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:52 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 0x7eff48f94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fb8b0>, '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 0x25fc7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fcc60>, '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': '41bf3e9aed84707956354da8000001c5-1460510962.741593-1884689750', '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 18:58:52 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 18:58:52 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 18:58:52 INFO - Using env: {'DISPLAY': ':0', 18:58:52 INFO - 'HOME': '/home/cltbld', 18:58:52 INFO - 'LANG': 'en_US.UTF-8', 18:58:52 INFO - 'LANGUAGE': 'en_US:en', 18:58:52 INFO - 'LOGNAME': 'cltbld', 18:58:52 INFO - 'MAIL': '/var/mail/cltbld', 18:58:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:52 INFO - 'MOZ_NO_REMOTE': '1', 18:58:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:52 INFO - 'NO_EM_RESTART': '1', 18:58:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:58:52 INFO - 'PWD': '/builds/slave/test-pgo', 18:58:52 INFO - 'SHELL': '/bin/bash', 18:58:52 INFO - 'SHLVL': '1', 18:58:52 INFO - 'TERM': 'linux', 18:58:52 INFO - 'TMOUT': '86400', 18:58:52 INFO - 'USER': 'cltbld', 18:58:52 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1460510962.741593-1884689750', 18:58:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:52 INFO - '_': '/tools/buildbot/bin/python'} 18:58:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:58:52 INFO - Running setup.py (path:/tmp/pip-r9wSRs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:58:52 INFO - Running setup.py (path:/tmp/pip-Kw97M5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:58:52 INFO - Running setup.py (path:/tmp/pip-arxi2c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:58:53 INFO - Running setup.py (path:/tmp/pip-GkHiGl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:58:53 INFO - Running setup.py (path:/tmp/pip-hpfp6l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:58:53 INFO - Running setup.py (path:/tmp/pip-BHSlxS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:58:53 INFO - Running setup.py (path:/tmp/pip-0MvoKE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:58:53 INFO - Running setup.py (path:/tmp/pip-SkAlX9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:58:53 INFO - Running setup.py (path:/tmp/pip-iwJnxE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:58:53 INFO - Running setup.py (path:/tmp/pip-jkNvuf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:58:53 INFO - Running setup.py (path:/tmp/pip-zOJPEf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:58:53 INFO - Running setup.py (path:/tmp/pip-dPfbQz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:58:53 INFO - Running setup.py (path:/tmp/pip-khKiKn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:58:53 INFO - Running setup.py (path:/tmp/pip-Jplmcf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:58:53 INFO - Running setup.py (path:/tmp/pip-AHaJC6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:58:53 INFO - Running setup.py (path:/tmp/pip-a6cjWX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:58:53 INFO - Running setup.py (path:/tmp/pip-AjU4sA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:58:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:58:54 INFO - Running setup.py install for manifestparser 18:58:54 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:58:54 INFO - Running setup.py install for mozcrash 18:58:54 INFO - Running setup.py install for mozdebug 18:58:54 INFO - Running setup.py install for mozdevice 18:58:54 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:58:54 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:58:54 INFO - Running setup.py install for mozfile 18:58:54 INFO - Running setup.py install for mozhttpd 18:58:54 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:58:54 INFO - Running setup.py install for mozinfo 18:58:54 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:58:54 INFO - Running setup.py install for mozInstall 18:58:54 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:58:54 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:58:54 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:58:54 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:58:54 INFO - Running setup.py install for mozleak 18:58:54 INFO - Running setup.py install for mozlog 18:58:55 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:58:55 INFO - Running setup.py install for moznetwork 18:58:55 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:58:55 INFO - Running setup.py install for mozprocess 18:58:55 INFO - Running setup.py install for mozprofile 18:58:55 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:58:55 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:58:55 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:58:55 INFO - Running setup.py install for mozrunner 18:58:55 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:58:55 INFO - Running setup.py install for mozscreenshot 18:58:55 INFO - Running setup.py install for moztest 18:58:55 INFO - Running setup.py install for mozversion 18:58:55 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:58:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:58:55 INFO - Cleaning up... 18:58:55 INFO - Return code: 0 18:58:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:58: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')]} 18:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58: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')]} 18:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:55 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 0x7eff48f94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fb8b0>, '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 0x25fc7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fcc60>, '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': '41bf3e9aed84707956354da8000001c5-1460510962.741593-1884689750', '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 18:58:55 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 18:58:55 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 18:58:55 INFO - Using env: {'DISPLAY': ':0', 18:58:55 INFO - 'HOME': '/home/cltbld', 18:58:55 INFO - 'LANG': 'en_US.UTF-8', 18:58:55 INFO - 'LANGUAGE': 'en_US:en', 18:58:55 INFO - 'LOGNAME': 'cltbld', 18:58:55 INFO - 'MAIL': '/var/mail/cltbld', 18:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:55 INFO - 'MOZ_NO_REMOTE': '1', 18:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:55 INFO - 'NO_EM_RESTART': '1', 18:58:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:58:55 INFO - 'PWD': '/builds/slave/test-pgo', 18:58:55 INFO - 'SHELL': '/bin/bash', 18:58:55 INFO - 'SHLVL': '1', 18:58:55 INFO - 'TERM': 'linux', 18:58:55 INFO - 'TMOUT': '86400', 18:58:55 INFO - 'USER': 'cltbld', 18:58:55 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1460510962.741593-1884689750', 18:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:55 INFO - '_': '/tools/buildbot/bin/python'} 18:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:58:56 INFO - Running setup.py (path:/tmp/pip-K_qlP7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:58:56 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)) 18:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:58:56 INFO - Running setup.py (path:/tmp/pip-bXFzNZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:58:56 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)) 18:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:58:56 INFO - Running setup.py (path:/tmp/pip-qQp6KV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:58:56 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)) 18:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:58:56 INFO - Running setup.py (path:/tmp/pip-qcoC7T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:58:56 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)) 18:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:58:56 INFO - Running setup.py (path:/tmp/pip-23ra_F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:58:56 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)) 18:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:58:56 INFO - Running setup.py (path:/tmp/pip-jy6VGr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:58:56 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)) 18:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:58:56 INFO - Running setup.py (path:/tmp/pip-yrGwIi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:58:56 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)) 18:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:58:56 INFO - Running setup.py (path:/tmp/pip-8m0liv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:58:56 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)) 18:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:58:56 INFO - Running setup.py (path:/tmp/pip-Bdh5Xz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:58:56 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)) 18:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:58:56 INFO - Running setup.py (path:/tmp/pip-58XqnF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:58:56 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)) 18:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:58:56 INFO - Running setup.py (path:/tmp/pip-T2iFFy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:58:56 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)) 18:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:58:56 INFO - Running setup.py (path:/tmp/pip-uOFrDV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:58:56 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)) 18:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:58:56 INFO - Running setup.py (path:/tmp/pip-X2FRIl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:58:57 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)) 18:58:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:58:57 INFO - Running setup.py (path:/tmp/pip-aBH5yz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:58:57 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)) 18:58:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:58:57 INFO - Running setup.py (path:/tmp/pip-ZMktVc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:58:57 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)) 18:58:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:58:57 INFO - Running setup.py (path:/tmp/pip-E6xxnQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:58:57 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)) 18:58:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:58:57 INFO - Running setup.py (path:/tmp/pip-lJZ0El-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:58:57 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)) 18:58:57 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)) 18:58:57 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)) 18:58:57 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)) 18:58:57 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)) 18:58:57 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)) 18:58:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:58:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:59 INFO - Downloading blessings-1.6.tar.gz 18:58:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:58:59 INFO - Installing collected packages: blessings 18:58:59 INFO - Running setup.py install for blessings 18:58:59 INFO - Successfully installed blessings 18:58:59 INFO - Cleaning up... 18:58:59 INFO - Return code: 0 18:58:59 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:58:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:58:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:58:59 INFO - Reading from file tmpfile_stdout 18:58:59 INFO - Current package versions: 18:58:59 INFO - argparse == 1.2.1 18:58:59 INFO - blessings == 1.6 18:58:59 INFO - blobuploader == 1.2.4 18:58:59 INFO - docopt == 0.6.1 18:58:59 INFO - manifestparser == 1.1 18:58:59 INFO - mozInstall == 1.12 18:58:59 INFO - mozcrash == 0.17 18:58:59 INFO - mozdebug == 0.1 18:58:59 INFO - mozdevice == 0.48 18:58:59 INFO - mozfile == 1.2 18:58:59 INFO - mozhttpd == 0.7 18:58:59 INFO - mozinfo == 0.9 18:58:59 INFO - mozleak == 0.1 18:58:59 INFO - mozlog == 3.1 18:58:59 INFO - moznetwork == 0.27 18:58:59 INFO - mozprocess == 0.22 18:58:59 INFO - mozprofile == 0.28 18:58:59 INFO - mozrunner == 6.11 18:58:59 INFO - mozscreenshot == 0.1 18:58:59 INFO - mozsystemmonitor == 0.0 18:58:59 INFO - moztest == 0.7 18:58:59 INFO - mozversion == 1.4 18:58:59 INFO - psutil == 3.1.1 18:58:59 INFO - requests == 1.2.3 18:58:59 INFO - wsgiref == 0.1.2 18:58:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:58: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')]} 18:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58: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')]} 18:58:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:59 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 0x7eff48f94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fb8b0>, '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 0x25fc7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fcc60>, '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': '41bf3e9aed84707956354da8000001c5-1460510962.741593-1884689750', '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 18:58:59 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 18:58:59 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 18:58:59 INFO - Using env: {'DISPLAY': ':0', 18:58:59 INFO - 'HOME': '/home/cltbld', 18:58:59 INFO - 'LANG': 'en_US.UTF-8', 18:58:59 INFO - 'LANGUAGE': 'en_US:en', 18:58:59 INFO - 'LOGNAME': 'cltbld', 18:58:59 INFO - 'MAIL': '/var/mail/cltbld', 18:58:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:59 INFO - 'MOZ_NO_REMOTE': '1', 18:58:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:59 INFO - 'NO_EM_RESTART': '1', 18:58:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:58:59 INFO - 'PWD': '/builds/slave/test-pgo', 18:58:59 INFO - 'SHELL': '/bin/bash', 18:58:59 INFO - 'SHLVL': '1', 18:58:59 INFO - 'TERM': 'linux', 18:58:59 INFO - 'TMOUT': '86400', 18:58:59 INFO - 'USER': 'cltbld', 18:58:59 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1460510962.741593-1884689750', 18:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:59 INFO - '_': '/tools/buildbot/bin/python'} 18:58:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:59 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)) 18:58:59 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)) 18:58:59 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)) 18:58:59 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)) 18:58:59 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)) 18:58:59 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)) 18:58:59 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)) 18:58:59 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)) 18:58:59 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)) 18:58:59 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)) 18:58:59 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)) 18:58:59 INFO - Cleaning up... 18:58:59 INFO - Return code: 0 18:58:59 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:58: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')]} 18:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58: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')]} 18:58:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:59 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 0x7eff48f94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fb8b0>, '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 0x25fc7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fcc60>, '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': '41bf3e9aed84707956354da8000001c5-1460510962.741593-1884689750', '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 18:58:59 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 18:58:59 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 18:58:59 INFO - Using env: {'DISPLAY': ':0', 18:58:59 INFO - 'HOME': '/home/cltbld', 18:58:59 INFO - 'LANG': 'en_US.UTF-8', 18:58:59 INFO - 'LANGUAGE': 'en_US:en', 18:58:59 INFO - 'LOGNAME': 'cltbld', 18:58:59 INFO - 'MAIL': '/var/mail/cltbld', 18:58:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:59 INFO - 'MOZ_NO_REMOTE': '1', 18:58:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:59 INFO - 'NO_EM_RESTART': '1', 18:58:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:58:59 INFO - 'PWD': '/builds/slave/test-pgo', 18:58:59 INFO - 'SHELL': '/bin/bash', 18:58:59 INFO - 'SHLVL': '1', 18:58:59 INFO - 'TERM': 'linux', 18:58:59 INFO - 'TMOUT': '86400', 18:58:59 INFO - 'USER': 'cltbld', 18:58:59 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1460510962.741593-1884689750', 18:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:59 INFO - '_': '/tools/buildbot/bin/python'} 18:59:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:00 INFO - Downloading/unpacking jsonschema 18:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:59:01 INFO - Downloading/unpacking functools32 (from jsonschema) 18:59:01 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 18:59:01 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 18:59:01 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 18:59:01 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 18:59:01 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 18:59:01 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 18:59:02 INFO - Downloading functools32-3.2.3-2.tar.gz 18:59:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:59:02 INFO - warning: no files found matching '*.txt' 18:59:02 INFO - no previously-included directories found matching 'build' 18:59:02 INFO - no previously-included directories found matching 'dist' 18:59:02 INFO - no previously-included directories found matching '.git*' 18:59:02 INFO - Installing collected packages: jsonschema, functools32 18:59:02 INFO - Running setup.py install for functools32 18:59:02 INFO - warning: no files found matching '*.txt' 18:59:02 INFO - no previously-included directories found matching 'build' 18:59:02 INFO - no previously-included directories found matching 'dist' 18:59:02 INFO - no previously-included directories found matching '.git*' 18:59:02 INFO - Successfully installed jsonschema functools32 18:59:02 INFO - Cleaning up... 18:59:02 INFO - Return code: 0 18:59:02 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:59: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')]} 18:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59: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')]} 18:59:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:02 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 0x7eff48f94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fb8b0>, '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 0x25fc7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fcc60>, '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': '41bf3e9aed84707956354da8000001c5-1460510962.741593-1884689750', '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 18:59:02 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 18:59:02 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 18:59:02 INFO - Using env: {'DISPLAY': ':0', 18:59:02 INFO - 'HOME': '/home/cltbld', 18:59:02 INFO - 'LANG': 'en_US.UTF-8', 18:59:02 INFO - 'LANGUAGE': 'en_US:en', 18:59:02 INFO - 'LOGNAME': 'cltbld', 18:59:02 INFO - 'MAIL': '/var/mail/cltbld', 18:59:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:02 INFO - 'MOZ_NO_REMOTE': '1', 18:59:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:02 INFO - 'NO_EM_RESTART': '1', 18:59:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:59:02 INFO - 'PWD': '/builds/slave/test-pgo', 18:59:02 INFO - 'SHELL': '/bin/bash', 18:59:02 INFO - 'SHLVL': '1', 18:59:02 INFO - 'TERM': 'linux', 18:59:02 INFO - 'TMOUT': '86400', 18:59:02 INFO - 'USER': 'cltbld', 18:59:02 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1460510962.741593-1884689750', 18:59:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:02 INFO - '_': '/tools/buildbot/bin/python'} 18:59:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:02 INFO - Downloading/unpacking flake8 18:59:02 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 18:59:02 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 18:59:02 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 18:59:02 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 18:59:02 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 18:59:02 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 18:59:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:59:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:59: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 18:59: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 18:59: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 18:59: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 18:59: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 18:59: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 18:59:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:59:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:59: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 18:59: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 18:59: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 18:59: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 18:59: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 18:59: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 18:59:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:59: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 18:59: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 18:59: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 18:59: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 18:59: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 18:59: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 18:59:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:59:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:59:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:59:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:59:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:59:05 INFO - no previously-included directories found matching 'docs/_build' 18:59:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:59:05 INFO - Running setup.py install for pep8 18:59:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:59:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:59:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:59:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:59:05 INFO - no previously-included directories found matching 'docs/_build' 18:59:05 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:59:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:59:05 INFO - Cleaning up... 18:59:05 INFO - Return code: 0 18:59:05 INFO - Running post-action listener: _resource_record_post_action 18:59:05 INFO - Running post-action listener: _start_resource_monitoring 18:59:05 INFO - Starting resource monitoring. 18:59:05 INFO - ##### 18:59:05 INFO - ##### Running install step. 18:59:05 INFO - ##### 18:59:05 INFO - Running pre-action listener: _resource_record_pre_action 18:59:05 INFO - Running main action method: install 18:59:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:59:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:59:05 INFO - Reading from file tmpfile_stdout 18:59:05 INFO - Detecting whether we're running mozinstall >=1.0... 18:59:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:59:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:59:05 INFO - Reading from file tmpfile_stdout 18:59:05 INFO - Output received: 18:59:05 INFO - Usage: mozinstall [options] installer 18:59:05 INFO - Options: 18:59:05 INFO - -h, --help show this help message and exit 18:59:05 INFO - -d DEST, --destination=DEST 18:59:05 INFO - Directory to install application into. [default: 18:59:05 INFO - "/builds/slave/test-pgo"] 18:59:05 INFO - --app=APP Application being installed. [default: firefox] 18:59:05 INFO - mkdir: /builds/slave/test-pgo/build/application 18:59:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 18:59:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 18:59:22 INFO - Reading from file tmpfile_stdout 18:59:22 INFO - Output received: 18:59:22 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:59:22 INFO - Running post-action listener: _resource_record_post_action 18:59:22 INFO - ##### 18:59:22 INFO - ##### Running run-tests step. 18:59:22 INFO - ##### 18:59:22 INFO - Running pre-action listener: _resource_record_pre_action 18:59:22 INFO - Running main action method: run_tests 18:59:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:59:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:59:22 INFO - Python 2.7.3 18:59:22 INFO - Return code: 0 18:59:22 INFO - grabbing minidump binary from tooltool 18:59:22 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')]} 18:59:22 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 0x25fb8b0>, '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 0x25fc7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fcc60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:59:22 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 18:59:22 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 18:59:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:59:22 INFO - Return code: 0 18:59:22 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:59:22 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:59:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:59:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:59:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:59:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:59:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:59:23 INFO - Return code: 0 18:59:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 18:59:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 18:59:23 INFO - Using env: {'DISPLAY': ':0', 18:59:23 INFO - 'HOME': '/home/cltbld', 18:59:23 INFO - 'LANG': 'en_US.UTF-8', 18:59:23 INFO - 'LANGUAGE': 'en_US:en', 18:59:23 INFO - 'LOGNAME': 'cltbld', 18:59:23 INFO - 'MAIL': '/var/mail/cltbld', 18:59:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:59:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:59:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:23 INFO - 'MOZ_NO_REMOTE': '1', 18:59:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:59:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:23 INFO - 'NO_EM_RESTART': '1', 18:59:23 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:59:23 INFO - 'PWD': '/builds/slave/test-pgo', 18:59:23 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:59:23 INFO - 'SHELL': '/bin/bash', 18:59:23 INFO - 'SHLVL': '1', 18:59:23 INFO - 'TERM': 'linux', 18:59:23 INFO - 'TMOUT': '86400', 18:59:23 INFO - 'USER': 'cltbld', 18:59:23 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1460510962.741593-1884689750', 18:59:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:23 INFO - '_': '/tools/buildbot/bin/python'} 18:59:23 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 18:59:23 INFO - mozversion application_buildid: 20160412163035 18:59:23 INFO - mozversion application_changeset: fb921246e2d60f521f83defed54e30a38df1be3e 18:59:23 INFO - mozversion application_display_name: Nightly 18:59:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:59:23 INFO - mozversion application_name: Firefox 18:59:23 INFO - mozversion application_remotingname: firefox 18:59:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:59:23 INFO - mozversion application_vendor: Mozilla 18:59:23 INFO - mozversion application_version: 48.0a1 18:59:23 INFO - mozversion platform_buildid: 20160412163035 18:59:23 INFO - mozversion platform_changeset: fb921246e2d60f521f83defed54e30a38df1be3e 18:59:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:59:23 INFO - mozversion platform_version: 48.0a1 18:59:23 INFO - using testdate: 1460512763 18:59:23 INFO - actual date: 1460512763 18:59:23 INFO - starting webserver on 'localhost:34941' 18:59:23 INFO - SUITE-START | Running 2 tests 18:59:23 INFO - TEST-START | dromaeo_css 18:59:23 INFO - operating with platform_type : linux_ 18:59:23 INFO - Initialising browser for dromaeo_css test... 18:59:23 INFO - TEST-INFO | started process 12406 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJc7pFp/profile http://localhost:34941/getInfo.html) 18:59:27 INFO - PROCESS | 12406 | 18:59:27 INFO - PROCESS | 12406 | (process:12472): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:59:27 INFO - PROCESS | 12406 | JavaScript error: jar:file:///builds/slave/test-pgo/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 18:59:28 INFO - PROCESS | 12406 | __metrics Screen width/height:1600/1200 18:59:28 INFO - PROCESS | 12406 | colorDepth:24 18:59:28 INFO - PROCESS | 12406 | Browser inner width/height: 1024/697 18:59:28 INFO - PROCESS | 12406 | __metrics 18:59:28 ERROR - PROCESS | 12406 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 18:59:29 INFO - TEST-INFO | 12406: exit 0 18:59:29 INFO - Browser initialized. 18:59:29 INFO - Running cycle 1/1 for dromaeo_css test... 18:59:29 INFO - TEST-INFO | started process 12523 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJc7pFp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:59:31 INFO - PROCESS | 12523 | 18:59:31 INFO - PROCESS | 12523 | (process:12585): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:59:41 INFO - PROCESS | 12523 | RSS: Main: 163180544 18:59:41 INFO - PROCESS | 12523 | 19:00:30 INFO - PROCESS | 12523 | 1460512830804 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] 19:02:38 INFO - PROCESS | 12523 | Cycle 1(1): loaded http://localhost:34941/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34941/tests/dromaeo/cssquery-ext.html) 19:02:39 INFO - PROCESS | 12523 | RSS: Main: 167391232 19:02:39 INFO - PROCESS | 12523 | 19:05:41 INFO - PROCESS | 12523 | Cycle 1(1): loaded http://localhost:34941/tests/dromaeo/cssquery-ext.html (next: http://localhost:34941/tests/dromaeo/cssquery-jquery.html) 19:05:42 INFO - PROCESS | 12523 | RSS: Main: 165588992 19:05:42 INFO - PROCESS | 12523 | 19:08:43 INFO - PROCESS | 12523 | Cycle 1(1): loaded http://localhost:34941/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34941/tests/dromaeo/cssquery-mootools.html) 19:08:44 INFO - PROCESS | 12523 | RSS: Main: 166481920 19:08:44 INFO - PROCESS | 12523 | 19:11:46 INFO - PROCESS | 12523 | Cycle 1(1): loaded http://localhost:34941/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34941/tests/dromaeo/cssquery-prototype.html) 19:11:46 INFO - PROCESS | 12523 | RSS: Main: 164585472 19:11:46 INFO - PROCESS | 12523 | 19:14:49 INFO - PROCESS | 12523 | Cycle 1(1): loaded http://localhost:34941/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34941/tests/dromaeo/cssquery-yui.html) 19:14:49 INFO - PROCESS | 12523 | RSS: Main: 165707776 19:14:49 INFO - PROCESS | 12523 | 19:17:52 INFO - PROCESS | 12523 | Cycle 1(1): loaded http://localhost:34941/tests/dromaeo/cssquery-yui.html (next: http://localhost:34941/tests/dromaeo/cssquery-dojo.html) 19:17:52 INFO - PROCESS | 12523 | RSS: Main: 168226816 19:17:52 INFO - PROCESS | 12523 | 19:17:52 INFO - PROCESS | 12523 | __start_tp_report 19:17:52 INFO - PROCESS | 12523 | _x_x_mozilla_page_load 19:17:52 INFO - PROCESS | 12523 | _x_x_mozilla_page_load_details 19:17:52 INFO - PROCESS | 12523 | |i|pagename|runs| 19:17:52 INFO - PROCESS | 12523 | |0;dojo.html;3161.8419079046043;3219.758518111142;3233.870645174193;3252.170696472399;3257.54394384786;5430.918536221955;5436.238926550276;5451.672899626025;5480.040992826254;5514.145307477343;5326.227696983935;5404.351477822657;5481.698506582136;5497.065498865192;5519.834404967847;4917.286993385966;4968.403791545002;5021.799128034874;5055.216441451563;5068.5438310552045;791.4878678559386;4830.516948305159;4892.3884514435695;4963.429205641343;4971.130052240862;4962.5533701967;4969.875753106183;4973.676711013773;4979.526944940225;4980.501949805027;5003.824866129705;5004.774785134641;5006.474320196364;5011.373578302712;5026.396832380101;4906.239532872411;4982.327385802906;4990.30135780991;4997.025580011863;5023.497650234947;5308.8141915033175;5336.67979921206;5357.7589008494715;5365.704886231256;5378.973105134489;5637.7181140942785;5840.211571437844;5850.824475265749;5852.414758524156;5879.206307148523;5946.732397042144;5968.940310596882;5976.64140151588;5979.611325263887;6046.425589568984;5510.1459273812625;5564.1931919871795;5574.275344205227;5575.470330318613;5581.49766521011;5831.241938547962;5983.9401605983385;6059.757609695651;6063.8484037898525;6101.816945491642;5768.278965129359;5771.59598828078;5798.188253644493;5818.185454036438;5822.097574875901;5883.558733095035;5894.498967587803;5896.174535565025;5898.911516327258;5905.232319798399;5834;5871.089981052944;5918.8816223675285;5963.5527335450015;5977.163197152315;5850.502707269845;5860.3260625027815;5879.911801322984;5892.852678682982;5895.41045895407;4333.349997500337;4434.467863856294;4435.955640443554;4441.844535441244;4496.572825581565;3844.442555829389;3930.7051971102283;3989.8005099744896;4001.459802926626;4023.054582173187;5517.337919449692;5558.805441809517;5618.4662457066515;5675.8080803031;5721;5884.529237660977;5892.469677729025;5910.497607703393;5931.1992880960515;5953.523718102541;5496.862578435491;5548.056830338772;5590.301212348457;5695.971520142456;5707.857303567361;4805.831795887128;4805.879853003703;4846.39420072491;4847.733374664357;4890.95109048912;6028.758849645965;6031.125486804389;6033.5474839387225;6041.939580604226;6045.304789949124;5843.474087332161;5864.560157988082;5921.970390148194;5925.377835327228;5958;6029.939700602938;6035.155078288955;6042.939570604238;6045.848853778691;6048.304444988707;5639.182318563868;5682.687452190169;5738.368779434342;5747.626404283708;5762.8847423050465;5840.123981402823;5919.6744179070565;5924.348321684525;5959.374265702038;5975.611585247119;5720.399358067343;5752;5772;5785.132230165509;5787.508061814625;5640.605157638925;5747.310322761128;5752.33848107473;5768.336641286306;5782.3639399666845;5669.064604340402;5697.401772813795;5711.171880077282;5722.1702853085235;5777.62445441045;5777.711114444177;5800.4489573490455;5804.593678442468;5807.332156801853;5819.82540523785;5524.972375138099;5616.326040875121;5627;5708.971455142698;5712.400197979318 19:17:52 INFO - PROCESS | 12523 | |1;ext.html;596.8120042186711;626.2891618013554;647.8412788866729;655.95736277142;683.1733602341167;35218.82390588047;36359.27281454369;36362.272754544894;36445.63554364452;36631;36828.44757328636;37200.62799372005;37299.62700373002;37367.62632373675;37468;8331.25018748311;8486.363522735788;8511.489310641351;8522.531260780686;8533.829323413527;8381.413301068897;8520.957395213016;8576.571171441403;8603.655853765842;8632.179942905444;8608.139186081373;8654.740357789276;8658.220760131588;8703.782405439852;8715.651373945066;8530.78673033176;8583;8584.227419532272;8588.785280368009;8591.613377397969;8416.705415310435;8473.322134229247;8564.785880352978;8584.74245772628;8586.914130858673;31426.21434464157;35810.820945895364;36772.26455470902;36908.63091369079;36944.81527592372;3237.2230664640315;3413.6586341365914;3548.3790336691236;3849.5049504950493;3950.348192548226;29791.702082979325;29881.551776723365;30478.085657430314;30574.235644108852;30854.22864428385;3817.866374676873;3833.5974722654;3843.2505661395758;3861.4787003754413;3883.786391748453;228203;232267;233022;234876;287591.9999999979;37755.81122094372;61103.38896611066;61525.69237153786;61686.69156654188;61717.38282617206;38159.23681526354;38165.42751858725;38303.233935321136;38356.232875342335;38371.2325753489;14446.277686115653;14543.27283635814;14573.854261457462;14618.780718289234;14637.414503419957;12511.687207819696;12559;12591.433385497674;12671.87328126707;12733.61799146027;8550.529720865412;8636.265917397091;8683.782905427288;8695;8732.912670873337;3379.9662003380145;3393.3891899458336;3420.0936751760805;3431.742619303562;3475.079104037432;990.782027953849;1012.2964539644876;1127.9210455268053;1137.778133264022;1178.5874943769784;32033.839830800698;32074.518882216784;32223.35553288921;32612.510812337834;32907.341853162805;1070.7483741320784;1071.1537885070707;1098.9450527473593;1123.8651361836469;1149.2587281203578;15135.394584216509;15325.540233793005;15609.141497217763;15872.968376746241;15921.12433816128;412447;421135.04892279924;421695;424016;424955;54224.45775542273;55900.720496397254;56114.43885561092;56435.153472697944;56503;1321.0884489702075;1323.5764555342198;1329.1227789658778;1334.159479527891;1353.1813252982001;29010.419791604472;29202.269943251587;29599.704002960556;29894.25264368408;29942.850285749304;45861.08277834358;46351.53648463472;46708.0298174659;46909.530904691885;46939.295910562054;358578;359795;360262;362481;363081;28117;28330.43339133247;28599.14202573926;28806.279843003253;28871.133865984055;46040.7697961508;46406;46578.767106164254;46895;47286;39376.60623393844;39802.402963954984;39814.402783958845;39950.40074398944;40066.1986760269;38667.613323867525;39670.2065958685;40198;40548.1890362197;40601;39879.80060099681;40555.39166912558;40670.79664601658;41123.58876411317;41452;34403;35482.822585886905;35872.10319742027;36069.63930360663;36117.374718137224;27549.862250688617;27581;27986.160415187576;28033;28157.43685126245 19:17:52 INFO - PROCESS | 12523 | |2;jquery.html;377.44704008627355;377.5865427357043;393.76767707052835;393.8345894724217;399.253396149201;15087.09477431355;16871.83128168718;17158.39945601904;18660.253589856406;18837.340693075745;17391.217395217212;17703;17930.37243696471;17944.64110717785;18998;5563.13771365438;5683.204351390808;5715.057015592422;5722.227499287585;5723.9141412878635;5480.095784195603;5606.159076138591;5620.690862002588;5649.265595472603;5653.717314134276;5554.555635549166;5570.442955704438;5578.721063946787;5600.355959064698;5608.411116832735;5403.918941215885;5604.047311956957;5625.971870140664;5631.211630371751;5649.4633009864;4798.448178459452;4990.775415106329;5003.424606170264;5011.724355160502;5025.6733312334945;12001.819972700416;12748.681282967907;22225.222117225818;22549.098036078536;22654.320370388916;2164.38315080203;2235.7540670526228;2251.763564825686;2298.402415371999;2300.953980920372;9965.950170249174;10099.192064634812;10130.746731331701;10705.678829635124;12519.687007824787;1972.5758961823133;1976.594798066393;1994.0528249081715;1999.5201151723627;2002.1390801955154;62843;72897;75693;76376.23623763802;78251.6087419565;10171.440570768531;10652.840207396895;10696.090832279187;10756.247062705535;10862.891371086187;14821.184834833972;14850;15001.17493537844;15046.924765376103;15052.172130532927;7789.454738168387;7927.207279272026;8044.913936618482;8097.473664211808;8101.6354264058255;7595.202503737028;7636.770896873103;7646.732364367221;7689.9615501922135;7722.266384693445;4550.7497087660495;4555.703879247838;4607.815687372535;4632.4672662644225;4683.765811709401;1876.0900963033191;1891.3569386408687;1904.628597423489;1946.571754214099;1979.208316673342;897.1432282170512;1006.3257617396362;1032.9793404131876;1034.425893629043;1052.489542571852;17929.7310540342;17938.192781324873;18064.548386290448;18156.818431815776;18509.074546272634;985.3201291109111;1002.2983911262146;1013.4628646817051;1042.374575254841;1077.8059949209062;9966;9980.550875210633;10182.389056656477;10259.204639188112;10368.015038571324;474889.12777180155;487440;492692;498909;512157;87615;87651;88030.1196988022;88379.11620883837;88389;999.980000399988;1002.588938535197;1011.7976404719086;1019.3119644240109;1026.609888242463;16078.678426431172;16170.110643914697;16218.67562648764;16297.429589964295;16366.590835229215;36130;36536.81731591325;37632.247355053296;37828.621713783614;37846.24307513779;50254.74872625613;52998.470015299354;54651.72674136604;54697.72651136719;54770.726146369016;8183.508989460652;8357;8381.539015354214;8515.701950431705;8668.523231222343;9063.456192628464;11805.76388472243;13579.728405432033;13647.11293765902;13686.863131368558;11987.64037078889;12024.939875300568;12069.879301207227;12121.393930303626;12284.508619655113;11437.714057148305;11622.94188529052;12123.151379403356;12131.75736485283;12348.506059757508;11643.12676549279;12095.274283543016;12325.938370308091;12418.627441176779;12430.440630171845;8567.143285671384;8637.352198585006;8637.524936128322;8865.423747456394;8897.73306800797;11141.832872506757;11262.436878156223;11353.37556434404;11471.197016208785;11531.135164862837 19:17:52 INFO - PROCESS | 12523 | |3;mootools.html;1351.5945216435066;1456.6576854439204;1549.5119037503187;1763.162497813538;1817.6364727054593;7425.665845036973;8153.551554664498;8205.712800051999;8462.534560599157;8482.957585212072;8221.136780638022;8269;8291.751247462571;8313;8320.542370169638;2289.5764283607546;2323.3959170615594;2323.8373313868037;2326.2090889097703;2331.463763334434;2280.8403411761183;2299.9885000574973;2308.8152947764224;2333.4516388648653;2340.602097643396;2305.250793492113;2316.2240649382393;2317.9420514487106;2339.1812865497027;2348.342464110052;2231.94420139497;2245.4274160089153;2246.977530224693;2250.054976909702;2280.0879648140713;2233.687283780272;2238.854474459155;2242.1031587365183;2244.6969659095976;2255.9661605075935;8338.874916876252;8362.372822038311;8447.070822209553;8460;8492.74521764348;5043.067032598981;5186.273921650934;5194.194899790501;5209.218617207412;5226.085435048889;3317.800931944091;3357.3117510910206;3449.068751437123;3467.098554375855;3477.8087205203706;1172.724409763705;1179.4044007776104;1182.7338848759046;1207.6497815633456;1210.7639010392977;11019.283746556448;11234.3259404436;11248.94375528117;11301;11333;4370.606645401929;4387.078713470143;4430.246858034077;4500.797464114123;4566.97716511422;9142.177204051668;9187.81624367509;9189;9203.079692030877;9231.169194772503;5212.50481204285;5217.06092903281;5217.973910130425;5236.502532259429;5239.921401178985;4184.267753143248;4622.075584883037;4774.069056534012;4774.116788394158;4916.06594746997;3717.4052151655605;3779.3197224499304;3859.826307816155;3882.6117388261514;3892.591277915835;1179.6520026592004;1188.5008296515484;1188.7147084699782;1190.5356910804794;1196.461592283476;1383.3290853935832;1391.0957877379783;1392.220356600307;1394.4352537222442;1398.2239856879326;7951.363890888831;8065.556394398364;8229.094799572042;8236.135205803424;8246.340292776564;470.40493775374176;473.21918833923615;474.3311930178432;476.7616191904048;504.70474772257904;6240.375962403723;6369.363063693593;6493.707783149675;6521.250056243593;6549.770758023446;9961.701148965543;10137.898621013843;10325.122364598943;10372.896271037343;10396.948015259875;9999.300048996645;10083.899161008296;10098.394096354243;10236.078752912124;10243.84634230487;7819.609019549;7838.725644602526;7875.251851074138;7915.881261781078;7959.124496305401;7701.460897737329;7796.961015195115;7857.096433910174;7869.0950540688555;7918.406119541172;9330.679027018527;9383.343165978316;9457.905420945977;9480.146786789222;9489.193418559224;9536.475493847905;9586.568604412958;9622.615095396386;9737.318387712792;9836.45899475507;6152.200213972155;6628.403443690091;6847.383735463832;6857.965710171417;6952.617606031717;8017.278444939983;8020.839583208186;8048;8058;8097.2307630774985;7208.207097219407;7504.174540800398;7504.437167212372;7622.009138811919;7708.576028318272;7310.305520975498;7452.590107544137;7484.513506622052;7530.28462296081;7580.279873412017;7486.401087912845;7554.848903022019;7597.544147351176;7601.353884919844;7613.961930190314;7064.434845212473;7090.07828982229;7145.749898753519;7219.061522002316;7255;7200.603966781878;7255.673494692646;7279.672414741455;7312.378447831994;7321.597312147883 19:17:52 INFO - PROCESS | 12523 | |4;prototype.html;300.3827135237088;305.88987964332836;310.3188501239778;316.44463965740124;317.75532839713435;5885.676287804169;6011;6069.302030266521;6075.726592303346;6080.300765411985;5852.151438041481;5929.495992840603;5932.2584676915385;5941.792037278696;5949.405059494048;4226.619604235618;4331.112122014979;4488.910221795562;4494.07871386365;4525.751083690396;4499.212637788374;4535.818567257305;4536.525629170516;4543.22765129927;4566.1780879441685;4464.799084041226;4495.303227999665;4501.279795232764;4515.593596576324;4517.796699148546;4400.207962566737;4470.619997300233;4491.9775401123115;4497.730136191806;4521.6261462732;3897.4348719435807;3898.2788184186015;3908.8045597720284;3916.3733802591732;3940.6650434713083;5735.598508104435;5743.770249190069;5760.164776107483;5778.797742079049;5803.390643982363;5110.8466745997675;5193.506616871391;5198.220266959948;5206.245094461282;5220.8694782630355;6249.2813326467585;6273.1844860167885;6280.309165991783;6282.340354262782;6297.54395785644;4315.4605674290715;4328.285832837578;4335.978320108411;4345.739255644671;4361.3457981302745;6394.776182833579;6587.637679927602;6587.934120658828;6598.208215014181;6605.900911486284;4342.131573685276;4385.429894113745;4389.561043895585;4392.692511524163;4405.118976204772;4420;4429.911401771947;4439.467263928349;4440.866773996785;4457.064016556495;4831.178699621073;5010.549050585392;5031.195008798574;5089.541941225308;5089.8727531812;6275.905861412082;6301.52738544611;6310.905336419957;6312.747490100436;6366.36336366369;1464.399596165567;1471.8969672122848;1480.0749531542785;1500.6848561801926;1503.8571335723088;899.2670973156856;951.752544338477;964.0937518732369;967.4630580028012;983.5868935047297;6017.669028203491;6027;6033.698315084316;6058.333583305833;6090.665013424305;6382.297947225801;6391.680415979183;6407.327230640809;6416;6432.163818703539;5826.563007774434;5984;6016.939830601638;6020.307664618625;6025.246844144482;3398.1334759636134;3412.368711788327;3442.1050526863196;3453.0849324928413;3458.1181798641187;6525.053867189231;6650.667466626649;6655.401013908675;6689.163854518185;6715.194176698729;6556.4427023702565;6562.442192413603;6569.386837239499;6571.2771595124495;6590.80227593173;6590;6615.966920165369;6649.936010238242;6700.497462690318;6727.865442691119;6321.557490975588;6362.872742545031;6396.1451179159385;6403.935960640334;6429.6142231466265;6226.782062627967;6291.716872740646;6345.17512723343;6366.649834258975;6391.488680905423;6646.743095883079;6669.0663307136065;6669.833254168685;6709;6712.899306510504;4272.650042476564;4272.893177670583;4285.978570107254;4286.249906266453;4287.506936702319;6297.905531417124;6400.423961843457;6408.839779005562;6428.774992875227;6429.32492088324;6170.969145154246;6210.254769427697;6234.532410069172;6268.498520118471;6269.404406581368;6072.635641861502;6247.406496382836;6256.154434441942;6265.373462653698;6269.96865015672;6115.174451448997;6133.601315914451;6287.654179020014;6290.937090629035;6304.747810087545;6301.495880329471;6335.1130841683125;6337.90493142594;6366.6180029198395;6379.393957574023;6049.697515124139;6200.286966998853;6224.253089629093;6243.722045925925;6274.278457977391 19:17:52 INFO - PROCESS | 12523 | |5;yui.html;740.5593671765299;761.8133557278461;810.3719617296591;852.0329426101373;857.1342943626937;13555.661108472268;13671.248081355521;13879.861201387983;13944.233067181302;13975.510857120003;14219.14685118891;14285.92857035716;14357.138571685706;14383.784243236334;14401.351939162736;792.8612492813763;830.3440282177073;835.9874601880977;836.45630340279;836.6026137584629;820.7004443378154;823.1644880446322;824.6660102658403;824.8061705499202;827.0447632983913;863.6415887406719;864.5504337744369;865.9567021648924;865.9826803463927;866.6273502393968;862.3144600042981;865.1521508921261;865.277493293101;865.446114486729;867.9913200867974;627.6830200748639;627.7677259414046;628.9716962736687;630.0895206426716;631.1731631562668;13899.235542045184;14218.360173792204;14278.214698191596;14341.928290358586;14351.856481435156;13928.233947132903;13998.370073346723;14017.158970461805;14029.228392438412;14052.437902483889;11615.477303521362;11672.474738636782;11752.118591105616;11841.703957401047;12132.636020919386;3813.48517950076;3814.6566808987045;3863.4011728182177;3864.188520410717;3980.5621381647998;59380.70309648467;59502.40497595012;59687.70156149235;60117.39882601205;60212.39787602112;10886.29239099456;10968.780624387467;11092.722681932855;11174.329540227613;11267.718307042389;19852.305169319003;19897.204111835654;19912.60174796496;19955.20179192816;20011.59976800456;7933.880991785128;7939.920600794034;7985.480943738638;8038.115807261197;8067;4648.1865673507;4700.341952126705;4730.195866702668;4974.427940786856;5022.296878437021;3292;3394.5247665326874;3396.117009577528;3404.8467818948207;3405;619.170311782214;619.6189343553772;627.8040333165327;631.0313668518802;645.1161908185721;607.7417097733446;660.8777376185421;736.7126820539994;757.7461550380574;768.1511929318135;9367.250619950388;9520.381175223589;9586.616535338648;9714.368566043184;9753.951230243803;632.2381530256031;643.3566433566433;698.9440844732511;783.0485959559163;807.8222790985974;4477.261486658676;4543.522930092358;4548.4541854977615;4592.035672508744;4598.149342371672;53185;53672;53808;55449.168262476094;57884.42115578875;48456.75771621119;50306.49693503091;50505.242421363706;50813.49186508162;51874.22188667173;45384.36925045989;45471.317930231075;45846;46313.75803693709;46555;9286.30352723535;9373.578188981375;9563.282753793632;9623.663171788954;9745.853812192965;31005.534916975812;31088.844555777076;31116.844415778683;31465.685343146277;31749.20626984344;39244.607553925234;40502;43184.78407607942;43186.4884729033;43825.34261986009;12174.45214965311;12295.385230738606;12301.44643491027;12437.75124497523;12478;13603.727925441237;13903.860961390257;13989.790153147507;14042.087264327785;14173.929130354281;12075.275483470668;12140.271583705005;12500.687482813002;12593.811092833432;12732.618021459371;12718.10973231865;12817;12864.549740759028;13061.673458163621;13336.066475346632;12889.935550322189;12928.159669621444;13039.543615973396;13062;13156.342182890625;10759.462026898467;10951.178661600252;10985.395803230898;11248.94375528117;11411.942940285246;10414.947925260325;10539.209559283237;10618.522166502371;10633.521491533054;10689.9465502672 19:17:52 INFO - PROCESS | 12523 | __end_tp_report 19:17:52 INFO - PROCESS | 12523 | __start_cc_report 19:17:52 INFO - PROCESS | 12523 | _x_x_mozilla_cycle_collect,335 19:17:52 INFO - PROCESS | 12523 | __end_cc_report 19:17:52 INFO - PROCESS | 12523 | __startTimestamp1460513872363__endTimestamp 19:17:52 INFO - PROCESS | 12523 | 19:17:52 INFO - PROCESS | 12523 | ------- Summary: start ------- 19:17:52 INFO - PROCESS | 12523 | Number of tests: 6 19:17:52 INFO - PROCESS | 12523 | 19:17:52 INFO - PROCESS | 12523 | [#0] dojo.html Cycles:165 Average:5425.10 Median:5708.97 stddev:728.15 (12.8%) stddev-sans-first:708.40 19:17:52 INFO - PROCESS | 12523 | Values: 3161.8 3219.8 3233.9 3252.2 3257.5 5430.9 5436.2 5451.7 5480.0 5514.1 5326.2 5404.4 5481.7 5497.1 5519.8 4917.3 4968.4 5021.8 5055.2 5068.5 791.5 4830.5 4892.4 4963.4 4971.1 4962.6 4969.9 4973.7 4979.5 4980.5 5003.8 5004.8 5006.5 5011.4 5026.4 4906.2 4982.3 4990.3 4997.0 5023.5 5308.8 5336.7 5357.8 5365.7 5379.0 5637.7 5840.2 5850.8 5852.4 5879.2 5946.7 5968.9 5976.6 5979.6 6046.4 5510.1 5564.2 5574.3 5575.5 5581.5 5831.2 5983.9 6059.8 6063.8 6101.8 5768.3 5771.6 5798.2 5818.2 5822.1 5883.6 5894.5 5896.2 5898.9 5905.2 5834.0 5871.1 5918.9 5963.6 5977.2 5850.5 5860.3 5879.9 5892.9 5895.4 4333.3 4434.5 4436.0 4441.8 4496.6 3844.4 3930.7 3989.8 4001.5 4023.1 5517.3 5558.8 5618.5 5675.8 5721.0 5884.5 5892.5 5910.5 5931.2 5953.5 5496.9 5548.1 5590.3 5696.0 5707.9 4805.8 4805.9 4846.4 4847.7 4891.0 6028.8 6031.1 6033.5 6041.9 6045.3 5843.5 5864.6 5922.0 5925.4 5958.0 6029.9 6035.2 6042.9 6045.8 6048.3 5639.2 5682.7 5738.4 5747.6 5762.9 5840.1 5919.7 5924.3 5959.4 5975.6 5720.4 5752.0 5772.0 5785.1 5787.5 5640.6 5747.3 5752.3 5768.3 5782.4 5669.1 5697.4 5711.2 5722.2 5777.6 5777.7 5800.4 5804.6 5807.3 5819.8 5525.0 5616.3 5627.0 5709.0 5712.4 19:17:52 INFO - PROCESS | 12523 | 19:17:52 INFO - PROCESS | 12523 | [#1] ext.html Cycles:180 Average:49774.16 Median:37417.81 stddev:92397.34 (246.9%) stddev-sans-first:92582.76 19:17:52 INFO - PROCESS | 12523 | Values: 596.8 626.3 647.8 656.0 683.2 35218.8 36359.3 36362.3 36445.6 36631.0 36828.4 37200.6 37299.6 37367.6 37468.0 8331.3 8486.4 8511.5 8522.5 8533.8 8381.4 8521.0 8576.6 8603.7 8632.2 8608.1 8654.7 8658.2 8703.8 8715.7 8530.8 8583.0 8584.2 8588.8 8591.6 8416.7 8473.3 8564.8 8584.7 8586.9 31426.2 35810.8 36772.3 36908.6 36944.8 3237.2 3413.7 3548.4 3849.5 3950.3 29791.7 29881.6 30478.1 30574.2 30854.2 3817.9 3833.6 3843.3 3861.5 3883.8 228203.0 232267.0 233022.0 234876.0 287592.0 37755.8 61103.4 61525.7 61686.7 61717.4 38159.2 38165.4 38303.2 38356.2 38371.2 14446.3 14543.3 14573.9 14618.8 14637.4 12511.7 12559.0 12591.4 12671.9 12733.6 8550.5 8636.3 8683.8 8695.0 8732.9 3380.0 3393.4 3420.1 3431.7 3475.1 990.8 1012.3 1127.9 1137.8 1178.6 32033.8 32074.5 32223.4 32612.5 32907.3 1070.7 1071.2 1098.9 1123.9 1149.3 15135.4 15325.5 15609.1 15873.0 15921.1 412447.0 421135.0 421695.0 424016.0 424955.0 54224.5 55900.7 56114.4 56435.2 56503.0 1321.1 1323.6 1329.1 1334.2 1353.2 29010.4 29202.3 29599.7 29894.3 29942.9 45861.1 46351.5 46708.0 46909.5 46939.3 358578.0 359795.0 360262.0 362481.0 363081.0 28117.0 28330.4 28599.1 28806.3 28871.1 46040.8 46406.0 46578.8 46895.0 47286.0 39376.6 39802.4 39814.4 39950.4 40066.2 38667.6 39670.2 40198.0 40548.2 40601.0 39879.8 40555.4 40670.8 41123.6 41452.0 34403.0 35482.8 35872.1 36069.6 36117.4 27549.9 27581.0 27986.2 28033.0 28157.4 19:17:52 INFO - PROCESS | 12523 | 19:17:52 INFO - PROCESS | 12523 | [#2] jquery.html Cycles:180 Average:28165.32 Median:12476.36 stddev:81115.92 (650.2%) stddev-sans-first:81316.63 19:17:52 INFO - PROCESS | 12523 | Values: 377.4 377.6 393.8 393.8 399.3 15087.1 16871.8 17158.4 18660.3 18837.3 17391.2 17703.0 17930.4 17944.6 18998.0 5563.1 5683.2 5715.1 5722.2 5723.9 5480.1 5606.2 5620.7 5649.3 5653.7 5554.6 5570.4 5578.7 5600.4 5608.4 5403.9 5604.0 5626.0 5631.2 5649.5 4798.4 4990.8 5003.4 5011.7 5025.7 12001.8 12748.7 22225.2 22549.1 22654.3 2164.4 2235.8 2251.8 2298.4 2301.0 9966.0 10099.2 10130.7 10705.7 12519.7 1972.6 1976.6 1994.1 1999.5 2002.1 62843.0 72897.0 75693.0 76376.2 78251.6 10171.4 10652.8 10696.1 10756.2 10862.9 14821.2 14850.0 15001.2 15046.9 15052.2 7789.5 7927.2 8044.9 8097.5 8101.6 7595.2 7636.8 7646.7 7690.0 7722.3 4550.7 4555.7 4607.8 4632.5 4683.8 1876.1 1891.4 1904.6 1946.6 1979.2 897.1 1006.3 1033.0 1034.4 1052.5 17929.7 17938.2 18064.5 18156.8 18509.1 985.3 1002.3 1013.5 1042.4 1077.8 9966.0 9980.6 10182.4 10259.2 10368.0 474889.1 487440.0 492692.0 498909.0 512157.0 87615.0 87651.0 88030.1 88379.1 88389.0 1000.0 1002.6 1011.8 1019.3 1026.6 16078.7 16170.1 16218.7 16297.4 16366.6 36130.0 36536.8 37632.2 37828.6 37846.2 50254.7 52998.5 54651.7 54697.7 54770.7 8183.5 8357.0 8381.5 8515.7 8668.5 9063.5 11805.8 13579.7 13647.1 13686.9 11987.6 12024.9 12069.9 12121.4 12284.5 11437.7 11622.9 12123.2 12131.8 12348.5 11643.1 12095.3 12325.9 12418.6 12430.4 8567.1 8637.4 8637.5 8865.4 8897.7 11141.8 11262.4 11353.4 11471.2 11531.1 19:17:52 INFO - PROCESS | 12523 | 19:17:52 INFO - PROCESS | 12523 | [#3] mootools.html Cycles:180 Average:5854.73 Median:5231.29 stddev:3093.23 (59.1%) stddev-sans-first:3083.39 19:17:52 INFO - PROCESS | 12523 | Values: 1351.6 1456.7 1549.5 1763.2 1817.6 7425.7 8153.6 8205.7 8462.5 8483.0 8221.1 8269.0 8291.8 8313.0 8320.5 2289.6 2323.4 2323.8 2326.2 2331.5 2280.8 2300.0 2308.8 2333.5 2340.6 2305.3 2316.2 2317.9 2339.2 2348.3 2231.9 2245.4 2247.0 2250.1 2280.1 2233.7 2238.9 2242.1 2244.7 2256.0 8338.9 8362.4 8447.1 8460.0 8492.7 5043.1 5186.3 5194.2 5209.2 5226.1 3317.8 3357.3 3449.1 3467.1 3477.8 1172.7 1179.4 1182.7 1207.6 1210.8 11019.3 11234.3 11248.9 11301.0 11333.0 4370.6 4387.1 4430.2 4500.8 4567.0 9142.2 9187.8 9189.0 9203.1 9231.2 5212.5 5217.1 5218.0 5236.5 5239.9 4184.3 4622.1 4774.1 4774.1 4916.1 3717.4 3779.3 3859.8 3882.6 3892.6 1179.7 1188.5 1188.7 1190.5 1196.5 1383.3 1391.1 1392.2 1394.4 1398.2 7951.4 8065.6 8229.1 8236.1 8246.3 470.4 473.2 474.3 476.8 504.7 6240.4 6369.4 6493.7 6521.3 6549.8 9961.7 10137.9 10325.1 10372.9 10396.9 9999.3 10083.9 10098.4 10236.1 10243.8 7819.6 7838.7 7875.3 7915.9 7959.1 7701.5 7797.0 7857.1 7869.1 7918.4 9330.7 9383.3 9457.9 9480.1 9489.2 9536.5 9586.6 9622.6 9737.3 9836.5 6152.2 6628.4 6847.4 6858.0 6952.6 8017.3 8020.8 8048.0 8058.0 8097.2 7208.2 7504.2 7504.4 7622.0 7708.6 7310.3 7452.6 7484.5 7530.3 7580.3 7486.4 7554.8 7597.5 7601.4 7614.0 7064.4 7090.1 7145.7 7219.1 7255.0 7200.6 7255.7 7279.7 7312.4 7321.6 19:17:52 INFO - PROCESS | 12523 | 19:17:52 INFO - PROCESS | 12523 | [#4] prototype.html Cycles:180 Average:5216.98 Median:6054.02 stddev:1602.39 (26.5%) stddev-sans-first:1563.82 19:17:52 INFO - PROCESS | 12523 | Values: 300.4 305.9 310.3 316.4 317.8 5885.7 6011.0 6069.3 6075.7 6080.3 5852.2 5929.5 5932.3 5941.8 5949.4 4226.6 4331.1 4488.9 4494.1 4525.8 4499.2 4535.8 4536.5 4543.2 4566.2 4464.8 4495.3 4501.3 4515.6 4517.8 4400.2 4470.6 4492.0 4497.7 4521.6 3897.4 3898.3 3908.8 3916.4 3940.7 5735.6 5743.8 5760.2 5778.8 5803.4 5110.8 5193.5 5198.2 5206.2 5220.9 6249.3 6273.2 6280.3 6282.3 6297.5 4315.5 4328.3 4336.0 4345.7 4361.3 6394.8 6587.6 6587.9 6598.2 6605.9 4342.1 4385.4 4389.6 4392.7 4405.1 4420.0 4429.9 4439.5 4440.9 4457.1 4831.2 5010.5 5031.2 5089.5 5089.9 6275.9 6301.5 6310.9 6312.7 6366.4 1464.4 1471.9 1480.1 1500.7 1503.9 899.3 951.8 964.1 967.5 983.6 6017.7 6027.0 6033.7 6058.3 6090.7 6382.3 6391.7 6407.3 6416.0 6432.2 5826.6 5984.0 6016.9 6020.3 6025.2 3398.1 3412.4 3442.1 3453.1 3458.1 6525.1 6650.7 6655.4 6689.2 6715.2 6556.4 6562.4 6569.4 6571.3 6590.8 6590.0 6616.0 6649.9 6700.5 6727.9 6321.6 6362.9 6396.1 6403.9 6429.6 6226.8 6291.7 6345.2 6366.6 6391.5 6646.7 6669.1 6669.8 6709.0 6712.9 4272.7 4272.9 4286.0 4286.2 4287.5 6297.9 6400.4 6408.8 6428.8 6429.3 6171.0 6210.3 6234.5 6268.5 6269.4 6072.6 6247.4 6256.2 6265.4 6270.0 6115.2 6133.6 6287.7 6290.9 6304.7 6301.5 6335.1 6337.9 6366.6 6379.4 6049.7 6200.3 6224.3 6243.7 6274.3 19:17:52 INFO - PROCESS | 12523 | 19:17:52 INFO - PROCESS | 12523 | [#5] yui.html Cycles:180 Average:14450.35 Median:24930.82 stddev:16121.52 (64.7%) stddev-sans-first:16133.87 19:17:52 INFO - PROCESS | 12523 | Values: 740.6 761.8 810.4 852.0 857.1 13555.7 13671.2 13879.9 13944.2 13975.5 14219.1 14285.9 14357.1 14383.8 14401.4 792.9 830.3 836.0 836.5 836.6 820.7 823.2 824.7 824.8 827.0 863.6 864.6 866.0 866.0 866.6 862.3 865.2 865.3 865.4 868.0 627.7 627.8 629.0 630.1 631.2 13899.2 14218.4 14278.2 14341.9 14351.9 13928.2 13998.4 14017.2 14029.2 14052.4 11615.5 11672.5 11752.1 11841.7 12132.6 3813.5 3814.7 3863.4 3864.2 3980.6 59380.7 59502.4 59687.7 60117.4 60212.4 10886.3 10968.8 11092.7 11174.3 11267.7 19852.3 19897.2 19912.6 19955.2 20011.6 7933.9 7939.9 7985.5 8038.1 8067.0 4648.2 4700.3 4730.2 4974.4 5022.3 3292.0 3394.5 3396.1 3404.8 3405.0 619.2 619.6 627.8 631.0 645.1 607.7 660.9 736.7 757.7 768.2 9367.3 9520.4 9586.6 9714.4 9754.0 632.2 643.4 698.9 783.0 807.8 4477.3 4543.5 4548.5 4592.0 4598.1 53185.0 53672.0 53808.0 55449.2 57884.4 48456.8 50306.5 50505.2 50813.5 51874.2 45384.4 45471.3 45846.0 46313.8 46555.0 9286.3 9373.6 9563.3 9623.7 9745.9 31005.5 31088.8 31116.8 31465.7 31749.2 39244.6 40502.0 43184.8 43186.5 43825.3 12174.5 12295.4 12301.4 12437.8 12478.0 13603.7 13903.9 13989.8 14042.1 14173.9 12075.3 12140.3 12500.7 12593.8 12732.6 12718.1 12817.0 12864.5 13061.7 13336.1 12889.9 12928.2 13039.5 13062.0 13156.3 10759.5 10951.2 10985.4 11248.9 11411.9 10414.9 10539.2 10618.5 10633.5 10689.9 19:17:52 INFO - PROCESS | 12523 | -------- Summary: end -------- 19:17:52 INFO - PROCESS | 12523 | 19:17:53 INFO - TEST-INFO | 12523: exit 0 19:17:53 INFO - TEST-OK | dromaeo_css | took 1109581ms 19:17:53 INFO - TEST-START | kraken 19:17:53 INFO - operating with platform_type : linux_ 19:17:53 INFO - Initialising browser for kraken test... 19:17:53 INFO - TEST-INFO | started process 12760 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsSeKLK/profile http://localhost:34941/getInfo.html) 19:17:56 INFO - PROCESS | 12760 | 19:17:56 INFO - PROCESS | 12760 | (process:12830): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:17:56 INFO - PROCESS | 12760 | JavaScript error: jar:file:///builds/slave/test-pgo/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 19:17:57 INFO - PROCESS | 12760 | __metrics Screen width/height:1600/1200 19:17:57 INFO - PROCESS | 12760 | colorDepth:24 19:17:57 INFO - PROCESS | 12760 | Browser inner width/height: 1024/697 19:17:57 INFO - PROCESS | 12760 | __metrics 19:17:58 ERROR - PROCESS | 12760 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 19:17:58 INFO - TEST-INFO | 12760: exit 0 19:17:58 INFO - Browser initialized. 19:17:58 INFO - Running cycle 1/1 for kraken test... 19:17:58 INFO - TEST-INFO | started process 12881 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsSeKLK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:18:00 INFO - PROCESS | 12881 | 19:18:00 INFO - PROCESS | 12881 | (process:12940): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:18:10 INFO - PROCESS | 12881 | RSS: Main: 163667968 19:18:10 INFO - PROCESS | 12881 | 19:18:13 INFO - PROCESS | 12881 | Cycle 1(1): loaded http://localhost:34941/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34941/tests/kraken/driver.html?testName=audio-beat-detection) 19:18:14 INFO - PROCESS | 12881 | RSS: Main: 167936000 19:18:14 INFO - PROCESS | 12881 | 19:18:16 INFO - PROCESS | 12881 | Cycle 1(1): loaded http://localhost:34941/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34941/tests/kraken/driver.html?testName=audio-dft) 19:18:17 INFO - PROCESS | 12881 | RSS: Main: 171331584 19:18:17 INFO - PROCESS | 12881 | 19:18:20 INFO - PROCESS | 12881 | Cycle 1(1): loaded http://localhost:34941/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34941/tests/kraken/driver.html?testName=audio-fft) 19:18:20 INFO - PROCESS | 12881 | RSS: Main: 161218560 19:18:20 INFO - PROCESS | 12881 | 19:18:22 INFO - PROCESS | 12881 | Cycle 1(1): loaded http://localhost:34941/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34941/tests/kraken/driver.html?testName=audio-oscillator) 19:18:23 INFO - PROCESS | 12881 | RSS: Main: 161886208 19:18:23 INFO - PROCESS | 12881 | 19:18:25 INFO - PROCESS | 12881 | Cycle 1(1): loaded http://localhost:34941/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34941/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:18:26 INFO - PROCESS | 12881 | RSS: Main: 163278848 19:18:26 INFO - PROCESS | 12881 | 19:18:29 INFO - PROCESS | 12881 | Cycle 1(1): loaded http://localhost:34941/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34941/tests/kraken/driver.html?testName=imaging-darkroom) 19:18:30 INFO - PROCESS | 12881 | RSS: Main: 163872768 19:18:30 INFO - PROCESS | 12881 | 19:18:33 INFO - PROCESS | 12881 | Cycle 1(1): loaded http://localhost:34941/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34941/tests/kraken/driver.html?testName=imaging-desaturate) 19:18:33 INFO - PROCESS | 12881 | RSS: Main: 163946496 19:18:33 INFO - PROCESS | 12881 | 19:18:36 INFO - PROCESS | 12881 | Cycle 1(1): loaded http://localhost:34941/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34941/tests/kraken/driver.html?testName=json-parse-financial) 19:18:37 INFO - PROCESS | 12881 | RSS: Main: 166445056 19:18:37 INFO - PROCESS | 12881 | 19:18:38 INFO - PROCESS | 12881 | Cycle 1(1): loaded http://localhost:34941/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34941/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:18:39 INFO - PROCESS | 12881 | RSS: Main: 166912000 19:18:39 INFO - PROCESS | 12881 | 19:18:41 INFO - PROCESS | 12881 | Cycle 1(1): loaded http://localhost:34941/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34941/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:18:42 INFO - PROCESS | 12881 | RSS: Main: 166424576 19:18:42 INFO - PROCESS | 12881 | 19:18:44 INFO - PROCESS | 12881 | Cycle 1(1): loaded http://localhost:34941/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34941/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:18:44 INFO - PROCESS | 12881 | RSS: Main: 166633472 19:18:44 INFO - PROCESS | 12881 | 19:18:47 INFO - PROCESS | 12881 | Cycle 1(1): loaded http://localhost:34941/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34941/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:18:48 INFO - PROCESS | 12881 | RSS: Main: 167108608 19:18:48 INFO - PROCESS | 12881 | 19:18:50 INFO - PROCESS | 12881 | Cycle 1(1): loaded http://localhost:34941/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34941/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:18:51 INFO - PROCESS | 12881 | RSS: Main: 167149568 19:18:51 INFO - PROCESS | 12881 | 19:18:53 INFO - PROCESS | 12881 | Cycle 1(1): loaded http://localhost:34941/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34941/tests/kraken/driver.html?testName=ai-astar) 19:18:53 INFO - PROCESS | 12881 | RSS: Main: 168116224 19:18:53 INFO - PROCESS | 12881 | 19:18:53 INFO - PROCESS | 12881 | __start_tp_report 19:18:53 INFO - PROCESS | 12881 | _x_x_mozilla_page_load 19:18:53 INFO - PROCESS | 12881 | _x_x_mozilla_page_load_details 19:18:53 INFO - PROCESS | 12881 | |i|pagename|runs| 19:18:53 INFO - PROCESS | 12881 | |0;ai-astar;112;105;111;111;113;123;111;111;113;111 19:18:53 INFO - PROCESS | 12881 | |1;audio-beat-detection;159;128;156;182;131;156;159;129;192;132 19:18:53 INFO - PROCESS | 12881 | |2;audio-dft;163;166;164;163;160;164;175;163;166;162 19:18:53 INFO - PROCESS | 12881 | |3;audio-fft;75;76;75;147;74;76;74;73;106;75 19:18:53 INFO - PROCESS | 12881 | |4;audio-oscillator;94;94;153;93;93;93;147;94;94;156 19:18:53 INFO - PROCESS | 12881 | |5;imaging-gaussian-blur;118;117;118;118;121;121;117;117;117;118 19:18:53 INFO - PROCESS | 12881 | |6;imaging-darkroom;146;146;147;146;147;147;147;147;147;146 19:18:53 INFO - PROCESS | 12881 | |7;imaging-desaturate;96;96;98;96;95;96;96;96;96;96 19:18:53 INFO - PROCESS | 12881 | |8;json-parse-financial;57;60;58;60;60;59;66;71;56;55 19:18:53 INFO - PROCESS | 12881 | |9;json-stringify-tinderbox;61;63;62;61;61;62;61;61;61;62 19:18:53 INFO - PROCESS | 12881 | |10;stanford-crypto-aes;80;81;81;82;82;83;82;82;91;83 19:18:53 INFO - PROCESS | 12881 | |11;stanford-crypto-ccm;131;133;135;140;131;140;153;132;173;144 19:18:53 INFO - PROCESS | 12881 | |12;stanford-crypto-pbkdf2;175;166;169;167;168;174;169;172;173;169 19:18:53 INFO - PROCESS | 12881 | |13;stanford-crypto-sha256-iterative;70;70;68;71;70;69;69;71;68;69 19:18:53 INFO - PROCESS | 12881 | __end_tp_report 19:18:53 INFO - PROCESS | 12881 | __start_cc_report 19:18:53 INFO - PROCESS | 12881 | _x_x_mozilla_cycle_collect,823 19:18:53 INFO - PROCESS | 12881 | __end_cc_report 19:18:53 INFO - PROCESS | 12881 | __startTimestamp1460513933448__endTimestamp 19:18:53 INFO - PROCESS | 12881 | 19:18:53 INFO - PROCESS | 12881 | ------- Summary: start ------- 19:18:53 INFO - PROCESS | 12881 | Number of tests: 14 19:18:53 INFO - PROCESS | 12881 | 19:18:53 INFO - PROCESS | 12881 | [#0] ai-astar Cycles:10 Average:112.10 Median:111.50 stddev:4.43 (4.0%) stddev-sans-first:4.70 19:18:53 INFO - PROCESS | 12881 | Values: 112.0 105.0 111.0 111.0 113.0 123.0 111.0 111.0 113.0 111.0 19:18:53 INFO - PROCESS | 12881 | 19:18:53 INFO - PROCESS | 12881 | [#1] audio-beat-detection Cycles:10 Average:152.40 Median:157.50 stddev:22.54 (14.3%) stddev-sans-first:23.79 19:18:53 INFO - PROCESS | 12881 | Values: 159.0 128.0 156.0 182.0 131.0 156.0 159.0 129.0 192.0 132.0 19:18:53 INFO - PROCESS | 12881 | 19:18:53 INFO - PROCESS | 12881 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:4.06 (2.5%) stddev-sans-first:4.27 19:18:53 INFO - PROCESS | 12881 | Values: 163.0 166.0 164.0 163.0 160.0 164.0 175.0 163.0 166.0 162.0 19:18:53 INFO - PROCESS | 12881 | 19:18:53 INFO - PROCESS | 12881 | [#3] audio-fft Cycles:10 Average:85.10 Median:75.00 stddev:23.88 (31.8%) stddev-sans-first:25.05 19:18:53 INFO - PROCESS | 12881 | Values: 75.0 76.0 75.0 147.0 74.0 76.0 74.0 73.0 106.0 75.0 19:18:53 INFO - PROCESS | 12881 | 19:18:53 INFO - PROCESS | 12881 | [#4] audio-oscillator Cycles:10 Average:111.10 Median:93.50 stddev:28.31 (30.3%) stddev-sans-first:29.34 19:18:53 INFO - PROCESS | 12881 | Values: 94.0 94.0 153.0 93.0 93.0 93.0 147.0 94.0 94.0 156.0 19:18:53 INFO - PROCESS | 12881 | 19:18:53 INFO - PROCESS | 12881 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:1.55 (1.3%) stddev-sans-first:1.64 19:18:53 INFO - PROCESS | 12881 | Values: 118.0 117.0 118.0 118.0 121.0 121.0 117.0 117.0 117.0 118.0 19:18:53 INFO - PROCESS | 12881 | 19:18:53 INFO - PROCESS | 12881 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 19:18:53 INFO - PROCESS | 12881 | Values: 146.0 146.0 147.0 146.0 147.0 147.0 147.0 147.0 147.0 146.0 19:18:53 INFO - PROCESS | 12881 | 19:18:53 INFO - PROCESS | 12881 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 19:18:53 INFO - PROCESS | 12881 | Values: 96.0 96.0 98.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 19:18:53 INFO - PROCESS | 12881 | 19:18:53 INFO - PROCESS | 12881 | [#8] json-parse-financial Cycles:10 Average:60.20 Median:60.00 stddev:4.85 (8.1%) stddev-sans-first:5.00 19:18:53 INFO - PROCESS | 12881 | Values: 57.0 60.0 58.0 60.0 60.0 59.0 66.0 71.0 56.0 55.0 19:18:53 INFO - PROCESS | 12881 | 19:18:53 INFO - PROCESS | 12881 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:61.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 19:18:53 INFO - PROCESS | 12881 | Values: 61.0 63.0 62.0 61.0 61.0 62.0 61.0 61.0 61.0 62.0 19:18:53 INFO - PROCESS | 12881 | 19:18:53 INFO - PROCESS | 12881 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:82.00 stddev:3.06 (3.7%) stddev-sans-first:3.08 19:18:53 INFO - PROCESS | 12881 | Values: 80.0 81.0 81.0 82.0 82.0 83.0 82.0 82.0 91.0 83.0 19:18:53 INFO - PROCESS | 12881 | 19:18:53 INFO - PROCESS | 12881 | [#11] stanford-crypto-ccm Cycles:10 Average:141.20 Median:140.00 stddev:13.16 (9.4%) stddev-sans-first:13.44 19:18:53 INFO - PROCESS | 12881 | Values: 131.0 133.0 135.0 140.0 131.0 140.0 153.0 132.0 173.0 144.0 19:18:53 INFO - PROCESS | 12881 | 19:18:53 INFO - PROCESS | 12881 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.20 Median:170.50 stddev:3.08 (1.8%) stddev-sans-first:2.74 19:18:53 INFO - PROCESS | 12881 | Values: 175.0 166.0 169.0 167.0 168.0 174.0 169.0 172.0 173.0 169.0 19:18:53 INFO - PROCESS | 12881 | 19:18:53 INFO - PROCESS | 12881 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:70.00 stddev:1.08 (1.5%) stddev-sans-first:1.13 19:18:53 INFO - PROCESS | 12881 | Values: 70.0 70.0 68.0 71.0 70.0 69.0 69.0 71.0 68.0 69.0 19:18:53 INFO - PROCESS | 12881 | -------- Summary: end -------- 19:18:53 INFO - PROCESS | 12881 | 19:18:54 INFO - TEST-INFO | 12881: exit 0 19:18:54 INFO - TEST-OK | kraken | took 61296ms 19:18:54 INFO - SUITE-END | took 1170s 19:18:54 INFO - Completed test suite (00:19:31) 19:18:54 INFO - javascript benchmark 19:18:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3161.8419079046043, 3219.758518111142, 3233.870645174193, 3252.170696472399, 3257.54394384786, 5430.918536221955, 5436.238926550276, 5451.672899626025, 5480.040992826254, 5514.145307477343, 5326.227696983935, 5404.351477822657, 5481.698506582136, 5497.065498865192, 5519.834404967847, 4917.286993385966, 4968.403791545002, 5021.799128034874, 5055.216441451563, 5068.5438310552045, 791.4878678559386, 4830.516948305159, 4892.3884514435695, 4963.429205641343, 4971.130052240862, 4962.5533701967, 4969.875753106183, 4973.676711013773, 4979.526944940225, 4980.501949805027, 5003.824866129705, 5004.774785134641, 5006.474320196364, 5011.373578302712, 5026.396832380101, 4906.239532872411, 4982.327385802906, 4990.30135780991, 4997.025580011863, 5023.497650234947, 5308.8141915033175, 5336.67979921206, 5357.7589008494715, 5365.704886231256, 5378.973105134489, 5637.7181140942785, 5840.211571437844, 5850.824475265749, 5852.414758524156, 5879.206307148523, 5946.732397042144, 5968.940310596882, 5976.64140151588, 5979.611325263887, 6046.425589568984, 5510.1459273812625, 5564.1931919871795, 5574.275344205227, 5575.470330318613, 5581.49766521011, 5831.241938547962, 5983.9401605983385, 6059.757609695651, 6063.8484037898525, 6101.816945491642, 5768.278965129359, 5771.59598828078, 5798.188253644493, 5818.185454036438, 5822.097574875901, 5883.558733095035, 5894.498967587803, 5896.174535565025, 5898.911516327258, 5905.232319798399, 5834.0, 5871.089981052944, 5918.8816223675285, 5963.5527335450015, 5977.163197152315, 5850.502707269845, 5860.3260625027815, 5879.911801322984, 5892.852678682982, 5895.41045895407, 4333.349997500337, 4434.467863856294, 4435.955640443554, 4441.844535441244, 4496.572825581565, 3844.442555829389, 3930.7051971102283, 3989.8005099744896, 4001.459802926626, 4023.054582173187, 5517.337919449692, 5558.805441809517, 5618.4662457066515, 5675.8080803031, 5721.0, 5884.529237660977, 5892.469677729025, 5910.497607703393, 5931.1992880960515, 5953.523718102541, 5496.862578435491, 5548.056830338772, 5590.301212348457, 5695.971520142456, 5707.857303567361, 4805.831795887128, 4805.879853003703, 4846.39420072491, 4847.733374664357, 4890.95109048912, 6028.758849645965, 6031.125486804389, 6033.5474839387225, 6041.939580604226, 6045.304789949124, 5843.474087332161, 5864.560157988082, 5921.970390148194, 5925.377835327228, 5958.0, 6029.939700602938, 6035.155078288955, 6042.939570604238, 6045.848853778691, 6048.304444988707, 5639.182318563868, 5682.687452190169, 5738.368779434342, 5747.626404283708, 5762.8847423050465, 5840.123981402823, 5919.6744179070565, 5924.348321684525, 5959.374265702038, 5975.611585247119, 5720.399358067343, 5752.0, 5772.0, 5785.132230165509, 5787.508061814625, 5640.605157638925, 5747.310322761128, 5752.33848107473, 5768.336641286306, 5782.3639399666845, 5669.064604340402, 5697.401772813795, 5711.171880077282, 5722.1702853085235, 5777.62445441045, 5777.711114444177, 5800.4489573490455, 5804.593678442468, 5807.332156801853, 5819.82540523785, 5524.972375138099, 5616.326040875121, 5627.0, 5708.971455142698, 5712.400197979318], "value": 5376.864484038148, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.8120042186711, 626.2891618013554, 647.8412788866729, 655.95736277142, 683.1733602341167, 35218.82390588047, 36359.27281454369, 36362.272754544894, 36445.63554364452, 36631.0, 36828.44757328636, 37200.62799372005, 37299.62700373002, 37367.62632373675, 37468.0, 8331.25018748311, 8486.363522735788, 8511.489310641351, 8522.531260780686, 8533.829323413527, 8381.413301068897, 8520.957395213016, 8576.571171441403, 8603.655853765842, 8632.179942905444, 8608.139186081373, 8654.740357789276, 8658.220760131588, 8703.782405439852, 8715.651373945066, 8530.78673033176, 8583.0, 8584.227419532272, 8588.785280368009, 8591.613377397969, 8416.705415310435, 8473.322134229247, 8564.785880352978, 8584.74245772628, 8586.914130858673, 31426.21434464157, 35810.820945895364, 36772.26455470902, 36908.63091369079, 36944.81527592372, 3237.2230664640315, 3413.6586341365914, 3548.3790336691236, 3849.5049504950493, 3950.348192548226, 29791.702082979325, 29881.551776723365, 30478.085657430314, 30574.235644108852, 30854.22864428385, 3817.866374676873, 3833.5974722654, 3843.2505661395758, 3861.4787003754413, 3883.786391748453, 228203.0, 232267.0, 233022.0, 234876.0, 287591.9999999979, 37755.81122094372, 61103.38896611066, 61525.69237153786, 61686.69156654188, 61717.38282617206, 38159.23681526354, 38165.42751858725, 38303.233935321136, 38356.232875342335, 38371.2325753489, 14446.277686115653, 14543.27283635814, 14573.854261457462, 14618.780718289234, 14637.414503419957, 12511.687207819696, 12559.0, 12591.433385497674, 12671.87328126707, 12733.61799146027, 8550.529720865412, 8636.265917397091, 8683.782905427288, 8695.0, 8732.912670873337, 3379.9662003380145, 3393.3891899458336, 3420.0936751760805, 3431.742619303562, 3475.079104037432, 990.782027953849, 1012.2964539644876, 1127.9210455268053, 1137.778133264022, 1178.5874943769784, 32033.839830800698, 32074.518882216784, 32223.35553288921, 32612.510812337834, 32907.341853162805, 1070.7483741320784, 1071.1537885070707, 1098.9450527473593, 1123.8651361836469, 1149.2587281203578, 15135.394584216509, 15325.540233793005, 15609.141497217763, 15872.968376746241, 15921.12433816128, 412447.0, 421135.04892279924, 421695.0, 424016.0, 424955.0, 54224.45775542273, 55900.720496397254, 56114.43885561092, 56435.153472697944, 56503.0, 1321.0884489702075, 1323.5764555342198, 1329.1227789658778, 1334.159479527891, 1353.1813252982001, 29010.419791604472, 29202.269943251587, 29599.704002960556, 29894.25264368408, 29942.850285749304, 45861.08277834358, 46351.53648463472, 46708.0298174659, 46909.530904691885, 46939.295910562054, 358578.0, 359795.0, 360262.0, 362481.0, 363081.0, 28117.0, 28330.43339133247, 28599.14202573926, 28806.279843003253, 28871.133865984055, 46040.7697961508, 46406.0, 46578.767106164254, 46895.0, 47286.0, 39376.60623393844, 39802.402963954984, 39814.402783958845, 39950.40074398944, 40066.1986760269, 38667.613323867525, 39670.2065958685, 40198.0, 40548.1890362197, 40601.0, 39879.80060099681, 40555.39166912558, 40670.79664601658, 41123.58876411317, 41452.0, 34403.0, 35482.822585886905, 35872.10319742027, 36069.63930360663, 36117.374718137224, 27549.862250688617, 27581.0, 27986.160415187576, 28033.0, 28157.43685126245], "value": 17941.49546789214, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.44704008627355, 377.5865427357043, 393.76767707052835, 393.8345894724217, 399.253396149201, 15087.09477431355, 16871.83128168718, 17158.39945601904, 18660.253589856406, 18837.340693075745, 17391.217395217212, 17703.0, 17930.37243696471, 17944.64110717785, 18998.0, 5563.13771365438, 5683.204351390808, 5715.057015592422, 5722.227499287585, 5723.9141412878635, 5480.095784195603, 5606.159076138591, 5620.690862002588, 5649.265595472603, 5653.717314134276, 5554.555635549166, 5570.442955704438, 5578.721063946787, 5600.355959064698, 5608.411116832735, 5403.918941215885, 5604.047311956957, 5625.971870140664, 5631.211630371751, 5649.4633009864, 4798.448178459452, 4990.775415106329, 5003.424606170264, 5011.724355160502, 5025.6733312334945, 12001.819972700416, 12748.681282967907, 22225.222117225818, 22549.098036078536, 22654.320370388916, 2164.38315080203, 2235.7540670526228, 2251.763564825686, 2298.402415371999, 2300.953980920372, 9965.950170249174, 10099.192064634812, 10130.746731331701, 10705.678829635124, 12519.687007824787, 1972.5758961823133, 1976.594798066393, 1994.0528249081715, 1999.5201151723627, 2002.1390801955154, 62843.0, 72897.0, 75693.0, 76376.23623763802, 78251.6087419565, 10171.440570768531, 10652.840207396895, 10696.090832279187, 10756.247062705535, 10862.891371086187, 14821.184834833972, 14850.0, 15001.17493537844, 15046.924765376103, 15052.172130532927, 7789.454738168387, 7927.207279272026, 8044.913936618482, 8097.473664211808, 8101.6354264058255, 7595.202503737028, 7636.770896873103, 7646.732364367221, 7689.9615501922135, 7722.266384693445, 4550.7497087660495, 4555.703879247838, 4607.815687372535, 4632.4672662644225, 4683.765811709401, 1876.0900963033191, 1891.3569386408687, 1904.628597423489, 1946.571754214099, 1979.208316673342, 897.1432282170512, 1006.3257617396362, 1032.9793404131876, 1034.425893629043, 1052.489542571852, 17929.7310540342, 17938.192781324873, 18064.548386290448, 18156.818431815776, 18509.074546272634, 985.3201291109111, 1002.2983911262146, 1013.4628646817051, 1042.374575254841, 1077.8059949209062, 9966.0, 9980.550875210633, 10182.389056656477, 10259.204639188112, 10368.015038571324, 474889.12777180155, 487440.0, 492692.0, 498909.0, 512157.0, 87615.0, 87651.0, 88030.1196988022, 88379.11620883837, 88389.0, 999.980000399988, 1002.588938535197, 1011.7976404719086, 1019.3119644240109, 1026.609888242463, 16078.678426431172, 16170.110643914697, 16218.67562648764, 16297.429589964295, 16366.590835229215, 36130.0, 36536.81731591325, 37632.247355053296, 37828.621713783614, 37846.24307513779, 50254.74872625613, 52998.470015299354, 54651.72674136604, 54697.72651136719, 54770.726146369016, 8183.508989460652, 8357.0, 8381.539015354214, 8515.701950431705, 8668.523231222343, 9063.456192628464, 11805.76388472243, 13579.728405432033, 13647.11293765902, 13686.863131368558, 11987.64037078889, 12024.939875300568, 12069.879301207227, 12121.393930303626, 12284.508619655113, 11437.714057148305, 11622.94188529052, 12123.151379403356, 12131.75736485283, 12348.506059757508, 11643.12676549279, 12095.274283543016, 12325.938370308091, 12418.627441176779, 12430.440630171845, 8567.143285671384, 8637.352198585006, 8637.524936128322, 8865.423747456394, 8897.73306800797, 11141.832872506757, 11262.436878156223, 11353.37556434404, 11471.197016208785, 11531.135164862837], "value": 8917.7598835518, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.5945216435066, 1456.6576854439204, 1549.5119037503187, 1763.162497813538, 1817.6364727054593, 7425.665845036973, 8153.551554664498, 8205.712800051999, 8462.534560599157, 8482.957585212072, 8221.136780638022, 8269.0, 8291.751247462571, 8313.0, 8320.542370169638, 2289.5764283607546, 2323.3959170615594, 2323.8373313868037, 2326.2090889097703, 2331.463763334434, 2280.8403411761183, 2299.9885000574973, 2308.8152947764224, 2333.4516388648653, 2340.602097643396, 2305.250793492113, 2316.2240649382393, 2317.9420514487106, 2339.1812865497027, 2348.342464110052, 2231.94420139497, 2245.4274160089153, 2246.977530224693, 2250.054976909702, 2280.0879648140713, 2233.687283780272, 2238.854474459155, 2242.1031587365183, 2244.6969659095976, 2255.9661605075935, 8338.874916876252, 8362.372822038311, 8447.070822209553, 8460.0, 8492.74521764348, 5043.067032598981, 5186.273921650934, 5194.194899790501, 5209.218617207412, 5226.085435048889, 3317.800931944091, 3357.3117510910206, 3449.068751437123, 3467.098554375855, 3477.8087205203706, 1172.724409763705, 1179.4044007776104, 1182.7338848759046, 1207.6497815633456, 1210.7639010392977, 11019.283746556448, 11234.3259404436, 11248.94375528117, 11301.0, 11333.0, 4370.606645401929, 4387.078713470143, 4430.246858034077, 4500.797464114123, 4566.97716511422, 9142.177204051668, 9187.81624367509, 9189.0, 9203.079692030877, 9231.169194772503, 5212.50481204285, 5217.06092903281, 5217.973910130425, 5236.502532259429, 5239.921401178985, 4184.267753143248, 4622.075584883037, 4774.069056534012, 4774.116788394158, 4916.06594746997, 3717.4052151655605, 3779.3197224499304, 3859.826307816155, 3882.6117388261514, 3892.591277915835, 1179.6520026592004, 1188.5008296515484, 1188.7147084699782, 1190.5356910804794, 1196.461592283476, 1383.3290853935832, 1391.0957877379783, 1392.220356600307, 1394.4352537222442, 1398.2239856879326, 7951.363890888831, 8065.556394398364, 8229.094799572042, 8236.135205803424, 8246.340292776564, 470.40493775374176, 473.21918833923615, 474.3311930178432, 476.7616191904048, 504.70474772257904, 6240.375962403723, 6369.363063693593, 6493.707783149675, 6521.250056243593, 6549.770758023446, 9961.701148965543, 10137.898621013843, 10325.122364598943, 10372.896271037343, 10396.948015259875, 9999.300048996645, 10083.899161008296, 10098.394096354243, 10236.078752912124, 10243.84634230487, 7819.609019549, 7838.725644602526, 7875.251851074138, 7915.881261781078, 7959.124496305401, 7701.460897737329, 7796.961015195115, 7857.096433910174, 7869.0950540688555, 7918.406119541172, 9330.679027018527, 9383.343165978316, 9457.905420945977, 9480.146786789222, 9489.193418559224, 9536.475493847905, 9586.568604412958, 9622.615095396386, 9737.318387712792, 9836.45899475507, 6152.200213972155, 6628.403443690091, 6847.383735463832, 6857.965710171417, 6952.617606031717, 8017.278444939983, 8020.839583208186, 8048.0, 8058.0, 8097.2307630774985, 7208.207097219407, 7504.174540800398, 7504.437167212372, 7622.009138811919, 7708.576028318272, 7310.305520975498, 7452.590107544137, 7484.513506622052, 7530.28462296081, 7580.279873412017, 7486.401087912845, 7554.848903022019, 7597.544147351176, 7601.353884919844, 7613.961930190314, 7064.434845212473, 7090.07828982229, 7145.749898753519, 7219.061522002316, 7255.0, 7200.603966781878, 7255.673494692646, 7279.672414741455, 7312.378447831994, 7321.597312147883], "value": 4692.320589477088, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.3827135237088, 305.88987964332836, 310.3188501239778, 316.44463965740124, 317.75532839713435, 5885.676287804169, 6011.0, 6069.302030266521, 6075.726592303346, 6080.300765411985, 5852.151438041481, 5929.495992840603, 5932.2584676915385, 5941.792037278696, 5949.405059494048, 4226.619604235618, 4331.112122014979, 4488.910221795562, 4494.07871386365, 4525.751083690396, 4499.212637788374, 4535.818567257305, 4536.525629170516, 4543.22765129927, 4566.1780879441685, 4464.799084041226, 4495.303227999665, 4501.279795232764, 4515.593596576324, 4517.796699148546, 4400.207962566737, 4470.619997300233, 4491.9775401123115, 4497.730136191806, 4521.6261462732, 3897.4348719435807, 3898.2788184186015, 3908.8045597720284, 3916.3733802591732, 3940.6650434713083, 5735.598508104435, 5743.770249190069, 5760.164776107483, 5778.797742079049, 5803.390643982363, 5110.8466745997675, 5193.506616871391, 5198.220266959948, 5206.245094461282, 5220.8694782630355, 6249.2813326467585, 6273.1844860167885, 6280.309165991783, 6282.340354262782, 6297.54395785644, 4315.4605674290715, 4328.285832837578, 4335.978320108411, 4345.739255644671, 4361.3457981302745, 6394.776182833579, 6587.637679927602, 6587.934120658828, 6598.208215014181, 6605.900911486284, 4342.131573685276, 4385.429894113745, 4389.561043895585, 4392.692511524163, 4405.118976204772, 4420.0, 4429.911401771947, 4439.467263928349, 4440.866773996785, 4457.064016556495, 4831.178699621073, 5010.549050585392, 5031.195008798574, 5089.541941225308, 5089.8727531812, 6275.905861412082, 6301.52738544611, 6310.905336419957, 6312.747490100436, 6366.36336366369, 1464.399596165567, 1471.8969672122848, 1480.0749531542785, 1500.6848561801926, 1503.8571335723088, 899.2670973156856, 951.752544338477, 964.0937518732369, 967.4630580028012, 983.5868935047297, 6017.669028203491, 6027.0, 6033.698315084316, 6058.333583305833, 6090.665013424305, 6382.297947225801, 6391.680415979183, 6407.327230640809, 6416.0, 6432.163818703539, 5826.563007774434, 5984.0, 6016.939830601638, 6020.307664618625, 6025.246844144482, 3398.1334759636134, 3412.368711788327, 3442.1050526863196, 3453.0849324928413, 3458.1181798641187, 6525.053867189231, 6650.667466626649, 6655.401013908675, 6689.163854518185, 6715.194176698729, 6556.4427023702565, 6562.442192413603, 6569.386837239499, 6571.2771595124495, 6590.80227593173, 6590.0, 6615.966920165369, 6649.936010238242, 6700.497462690318, 6727.865442691119, 6321.557490975588, 6362.872742545031, 6396.1451179159385, 6403.935960640334, 6429.6142231466265, 6226.782062627967, 6291.716872740646, 6345.17512723343, 6366.649834258975, 6391.488680905423, 6646.743095883079, 6669.0663307136065, 6669.833254168685, 6709.0, 6712.899306510504, 4272.650042476564, 4272.893177670583, 4285.978570107254, 4286.249906266453, 4287.506936702319, 6297.905531417124, 6400.423961843457, 6408.839779005562, 6428.774992875227, 6429.32492088324, 6170.969145154246, 6210.254769427697, 6234.532410069172, 6268.498520118471, 6269.404406581368, 6072.635641861502, 6247.406496382836, 6256.154434441942, 6265.373462653698, 6269.96865015672, 6115.174451448997, 6133.601315914451, 6287.654179020014, 6290.937090629035, 6304.747810087545, 6301.495880329471, 6335.1130841683125, 6337.90493142594, 6366.6180029198395, 6379.393957574023, 6049.697515124139, 6200.286966998853, 6224.253089629093, 6243.722045925925, 6274.278457977391], "value": 4677.076553223748, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.5593671765299, 761.8133557278461, 810.3719617296591, 852.0329426101373, 857.1342943626937, 13555.661108472268, 13671.248081355521, 13879.861201387983, 13944.233067181302, 13975.510857120003, 14219.14685118891, 14285.92857035716, 14357.138571685706, 14383.784243236334, 14401.351939162736, 792.8612492813763, 830.3440282177073, 835.9874601880977, 836.45630340279, 836.6026137584629, 820.7004443378154, 823.1644880446322, 824.6660102658403, 824.8061705499202, 827.0447632983913, 863.6415887406719, 864.5504337744369, 865.9567021648924, 865.9826803463927, 866.6273502393968, 862.3144600042981, 865.1521508921261, 865.277493293101, 865.446114486729, 867.9913200867974, 627.6830200748639, 627.7677259414046, 628.9716962736687, 630.0895206426716, 631.1731631562668, 13899.235542045184, 14218.360173792204, 14278.214698191596, 14341.928290358586, 14351.856481435156, 13928.233947132903, 13998.370073346723, 14017.158970461805, 14029.228392438412, 14052.437902483889, 11615.477303521362, 11672.474738636782, 11752.118591105616, 11841.703957401047, 12132.636020919386, 3813.48517950076, 3814.6566808987045, 3863.4011728182177, 3864.188520410717, 3980.5621381647998, 59380.70309648467, 59502.40497595012, 59687.70156149235, 60117.39882601205, 60212.39787602112, 10886.29239099456, 10968.780624387467, 11092.722681932855, 11174.329540227613, 11267.718307042389, 19852.305169319003, 19897.204111835654, 19912.60174796496, 19955.20179192816, 20011.59976800456, 7933.880991785128, 7939.920600794034, 7985.480943738638, 8038.115807261197, 8067.0, 4648.1865673507, 4700.341952126705, 4730.195866702668, 4974.427940786856, 5022.296878437021, 3292.0, 3394.5247665326874, 3396.117009577528, 3404.8467818948207, 3405.0, 619.170311782214, 619.6189343553772, 627.8040333165327, 631.0313668518802, 645.1161908185721, 607.7417097733446, 660.8777376185421, 736.7126820539994, 757.7461550380574, 768.1511929318135, 9367.250619950388, 9520.381175223589, 9586.616535338648, 9714.368566043184, 9753.951230243803, 632.2381530256031, 643.3566433566433, 698.9440844732511, 783.0485959559163, 807.8222790985974, 4477.261486658676, 4543.522930092358, 4548.4541854977615, 4592.035672508744, 4598.149342371672, 53185.0, 53672.0, 53808.0, 55449.168262476094, 57884.42115578875, 48456.75771621119, 50306.49693503091, 50505.242421363706, 50813.49186508162, 51874.22188667173, 45384.36925045989, 45471.317930231075, 45846.0, 46313.75803693709, 46555.0, 9286.30352723535, 9373.578188981375, 9563.282753793632, 9623.663171788954, 9745.853812192965, 31005.534916975812, 31088.844555777076, 31116.844415778683, 31465.685343146277, 31749.20626984344, 39244.607553925234, 40502.0, 43184.78407607942, 43186.4884729033, 43825.34261986009, 12174.45214965311, 12295.385230738606, 12301.44643491027, 12437.75124497523, 12478.0, 13603.727925441237, 13903.860961390257, 13989.790153147507, 14042.087264327785, 14173.929130354281, 12075.275483470668, 12140.271583705005, 12500.687482813002, 12593.811092833432, 12732.618021459371, 12718.10973231865, 12817.0, 12864.549740759028, 13061.673458163621, 13336.066475346632, 12889.935550322189, 12928.159669621444, 13039.543615973396, 13062.0, 13156.342182890625, 10759.462026898467, 10951.178661600252, 10985.395803230898, 11248.94375528117, 11411.942940285246, 10414.947925260325, 10539.209559283237, 10618.522166502371, 10633.521491533054, 10689.9465502672], "value": 6756.695748822429, "unit": "score"}], "name": "dromaeo_css", "value": 7095.168050777245, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 111.0, 111.0, 113.0, 123.0, 111.0, 111.0, 113.0, 111.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 128.0, 156.0, 182.0, 131.0, 156.0, 159.0, 129.0, 192.0, 132.0], "value": 152.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 164.0, 163.0, 160.0, 164.0, 175.0, 163.0, 166.0, 162.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 147.0, 74.0, 76.0, 74.0, 73.0, 106.0, 75.0], "value": 85.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 153.0, 93.0, 93.0, 93.0, 147.0, 94.0, 94.0, 156.0], "value": 111.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 121.0, 121.0, 117.0, 117.0, 117.0, 118.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 98.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 60.0, 58.0, 60.0, 60.0, 59.0, 66.0, 71.0, 56.0, 55.0], "value": 60.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 62.0, 61.0, 61.0, 62.0, 61.0, 61.0, 61.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 81.0, 82.0, 82.0, 83.0, 82.0, 82.0, 91.0, 83.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 133.0, 135.0, 140.0, 131.0, 140.0, 153.0, 132.0, 173.0, 144.0], "value": 141.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 166.0, 169.0, 167.0, 168.0, 174.0, 169.0, 172.0, 173.0, 169.0], "value": 170.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 68.0, 71.0, 70.0, 69.0, 69.0, 71.0, 68.0, 69.0], "value": 69.5, "unit": "score"}], "name": "kraken", "value": 1571.5000000000002, "alertThreshold": 2.0}]} 19:18:54 INFO - Return code: 0 19:18:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:18:54 ERROR - # TBPL SUCCESS # 19:18:54 INFO - Running post-action listener: _resource_record_post_action 19:18:54 INFO - Running post-run listener: _resource_record_post_run 19:18:55 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 28672; Write bytes: 537546752; Read time: 388; Write time: 443736 19:18:55 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 243589120; Read time: 136; Write time: 284328 19:18:55 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 24576; Write bytes: 293896192; Read time: 252; Write time: 159408 19:18:55 INFO - Running post-run listener: _upload_blobber_files 19:18:55 INFO - Blob upload gear active. 19:18:55 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:18:55 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:18:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 19:18:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 19:18:56 INFO - (blobuploader) - INFO - Open directory for files ... 19:18:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:18:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:18:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:18:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:18:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:18:57 INFO - (blobuploader) - INFO - Done attempting. 19:18:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:18:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:18:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:18:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:18:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:18:58 INFO - (blobuploader) - INFO - Done attempting. 19:18:58 INFO - (blobuploader) - INFO - Iteration through files over. 19:18:58 INFO - Return code: 0 19:18:58 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:18:58 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:18:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/119ab4ae6c9ee90970e0b37031c2adb6e121ade634689c93f88f7e368fedec72935e07f32babab873b931417305bece49151fb558fa382891396f671135e2e08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a11a9e244cb80b737e89dbbbd90012ecab9bdba783223b164b6fa18ba3c8785718ed159695d77cccfbca56515d88e5e2a3c69dfc4d47061b877ce86f7ab686a"} 19:18:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:18:58 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:18:58 INFO - Contents: 19:18:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/119ab4ae6c9ee90970e0b37031c2adb6e121ade634689c93f88f7e368fedec72935e07f32babab873b931417305bece49151fb558fa382891396f671135e2e08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a11a9e244cb80b737e89dbbbd90012ecab9bdba783223b164b6fa18ba3c8785718ed159695d77cccfbca56515d88e5e2a3c69dfc4d47061b877ce86f7ab686a"} 19:18:58 INFO - Running post-run listener: copy_logs_to_upload_dir 19:18:58 INFO - Copying logs to upload dir... 19:18:58 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 19:18:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.848688 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-12 19:18:57.864498) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 19:18:57.867666) ========= 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=41bf3e9aed84707956354da8000001c5-1460510962.741593-1884689750 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/Firefox/sha512/119ab4ae6c9ee90970e0b37031c2adb6e121ade634689c93f88f7e368fedec72935e07f32babab873b931417305bece49151fb558fa382891396f671135e2e08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a11a9e244cb80b737e89dbbbd90012ecab9bdba783223b164b6fa18ba3c8785718ed159695d77cccfbca56515d88e5e2a3c69dfc4d47061b877ce86f7ab686a"} build_url:https://queue.taskcluster.net/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011478 build_url: 'https://queue.taskcluster.net/v1/task/b1b7BdD0QG6YaBZq-_094Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/119ab4ae6c9ee90970e0b37031c2adb6e121ade634689c93f88f7e368fedec72935e07f32babab873b931417305bece49151fb558fa382891396f671135e2e08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a11a9e244cb80b737e89dbbbd90012ecab9bdba783223b164b6fa18ba3c8785718ed159695d77cccfbca56515d88e5e2a3c69dfc4d47061b877ce86f7ab686a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 19:18:57.895962) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 19:18:57.896304) ========= 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=41bf3e9aed84707956354da8000001c5-1460510962.741593-1884689750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 19:18:57.982435) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 19:18:57.983164) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 19:18:57.983864) ========= ========= Total master_lag: 0.25 =========