builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-020 starttime: 1455948086.03 results: success (0) buildid: 20160219193142 builduid: d57171c04da44282b0779a2fb093dec0 revision: 69ec3dc408a2a720cb2b8210fea33e3504aeec22 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-19 22:01:26.027196) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-19 22:01:26.027564) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-19 22:01:26.027855) ========= 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=af724c981e2a0f424dbabf99000001e7-1455942485.144514-978334050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006760 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-19 22:01:26.054059) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-19 22:01:26.054336) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-19 22:01:26.071498) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 22:01:26.071754) ========= 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=af724c981e2a0f424dbabf99000001e7-1455942485.144514-978334050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004704 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 22:01:26.120496) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-19 22:01:26.120794) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-19 22:01:26.121129) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 22:01:26.121402) ========= 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=af724c981e2a0f424dbabf99000001e7-1455942485.144514-978334050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-19 22:01:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 84.0M=0s 2016-02-19 22:01:26 (84.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.183238 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 22:01:26.316354) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 22:01:26.316631) ========= 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=af724c981e2a0f424dbabf99000001e7-1455942485.144514-978334050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019690 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 22:01:26.365515) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-19 22:01:26.365835) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 69ec3dc408a2a720cb2b8210fea33e3504aeec22 --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 69ec3dc408a2a720cb2b8210fea33e3504aeec22 --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=af724c981e2a0f424dbabf99000001e7-1455942485.144514-978334050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-19 22:01:26,996 truncating revision to first 12 chars 2016-02-19 22:01:26,996 Setting DEBUG logging. 2016-02-19 22:01:26,996 attempt 1/10 2016-02-19 22:01:26,996 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/69ec3dc408a2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-19 22:01:28,179 unpacking tar archive at: mozilla-central-69ec3dc408a2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.502246 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-19 22:01:27.880598) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-19 22:01:27.880934) ========= echo 69ec3dc408a2a720cb2b8210fea33e3504aeec22 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'69ec3dc408a2a720cb2b8210fea33e3504aeec22'] 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=af724c981e2a0f424dbabf99000001e7-1455942485.144514-978334050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 69ec3dc408a2a720cb2b8210fea33e3504aeec22 program finished with exit code 0 elapsedTime=0.004832 script_repo_revision: '69ec3dc408a2a720cb2b8210fea33e3504aeec22' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-19 22:01:27.933079) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-19 22:01:27.933380) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-19 22:01:27.943919) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-02-19 22:01:27.944222) ========= /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=af724c981e2a0f424dbabf99000001e7-1455942485.144514-978334050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:01:28 INFO - MultiFileLogger online at 20160219 22:01:28 in /builds/slave/test-pgo 22:01:28 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 22:01:28 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:01:28 INFO - {'append_to_log': False, 22:01:28 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:01:28 INFO - 'blob_upload_branch': 'Firefox', 22:01:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:01:28 INFO - 'branch': 'Firefox', 22:01:28 INFO - 'buildbot_json_path': 'buildprops.json', 22:01:28 INFO - 'config_files': ('talos/linux_config.py',), 22:01:28 INFO - 'default_actions': ('clobber', 22:01:28 INFO - 'read-buildbot-config', 22:01:28 INFO - 'download-and-extract', 22:01:28 INFO - 'populate-webroot', 22:01:28 INFO - 'create-virtualenv', 22:01:28 INFO - 'install', 22:01:28 INFO - 'run-tests'), 22:01:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:01:28 INFO - 'download_minidump_stackwalk': True, 22:01:28 INFO - 'download_symbols': 'ondemand', 22:01:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:01:28 INFO - 'tooltool.py': '/tools/tooltool.py', 22:01:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:01:28 INFO - '/tools/misc-python/virtualenv.py')}, 22:01:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:01:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:01:28 INFO - 'installer_path': 'installer.exe', 22:01:28 INFO - 'log_level': 'info', 22:01:28 INFO - 'log_name': 'talos', 22:01:28 INFO - 'log_to_console': True, 22:01:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:01:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:01:28 INFO - 'opt_config_files': (), 22:01:28 INFO - 'pip_index': False, 22:01:28 INFO - 'sps_profile': False, 22:01:28 INFO - 'sps_profile_interval': 0, 22:01:28 INFO - 'suite': 'dromaeojs-e10s', 22:01:28 INFO - 'system_bits': '32', 22:01:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:01:28 INFO - 'title': 'talos-linux64-ix-020', 22:01:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:01:28 INFO - 'use_talos_json': True, 22:01:28 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:01:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:01:28 INFO - 'work_dir': 'build'} 22:01:28 INFO - ##### 22:01:28 INFO - ##### Running clobber step. 22:01:28 INFO - ##### 22:01:28 INFO - Running pre-action listener: _resource_record_pre_action 22:01:28 INFO - Running main action method: clobber 22:01:28 INFO - rmtree: /builds/slave/test-pgo/build 22:01:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:01:29 INFO - Running post-action listener: _resource_record_post_action 22:01:29 INFO - ##### 22:01:29 INFO - ##### Running read-buildbot-config step. 22:01:29 INFO - ##### 22:01:29 INFO - Running pre-action listener: _resource_record_pre_action 22:01:29 INFO - Running main action method: read_buildbot_config 22:01:29 INFO - Using buildbot properties: 22:01:29 INFO - { 22:01:29 INFO - "project": "", 22:01:29 INFO - "product": "firefox", 22:01:29 INFO - "script_repo_revision": "production", 22:01:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 22:01:29 INFO - "repository": "", 22:01:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 22:01:29 INFO - "buildid": "20160219193142", 22:01:29 INFO - "pgo_build": "True", 22:01:29 INFO - "basedir": "/builds/slave/test-pgo", 22:01:29 INFO - "buildnumber": 647, 22:01:29 INFO - "slavename": "talos-linux64-ix-020", 22:01:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:01:29 INFO - "platform": "ubuntu64_hw", 22:01:29 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 22:01:29 INFO - "branch": "mozilla-central", 22:01:29 INFO - "repo_path": "mozilla-central", 22:01:29 INFO - "revision": "69ec3dc408a2a720cb2b8210fea33e3504aeec22", 22:01:29 INFO - "stage_platform": "linux64-pgo", 22:01:29 INFO - "builduid": "d57171c04da44282b0779a2fb093dec0", 22:01:29 INFO - "slavebuilddir": "test" 22:01:29 INFO - } 22:01:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/Jqoh1bttQu-i2GmytFawZw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 22:01:29 INFO - Running post-action listener: _resource_record_post_action 22:01:29 INFO - ##### 22:01:29 INFO - ##### Running download-and-extract step. 22:01:29 INFO - ##### 22:01:29 INFO - Running pre-action listener: _resource_record_pre_action 22:01:29 INFO - Running main action method: download_and_extract 22:01:29 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:01: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')]} 22:01:29 INFO - https://queue.taskcluster.net/v1/task/Jqoh1bttQu-i2GmytFawZw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:01:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqoh1bttQu-i2GmytFawZw/artifacts/public/build/test_packages.json 22:01:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqoh1bttQu-i2GmytFawZw/artifacts/public/build/test_packages.json 22:01:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqoh1bttQu-i2GmytFawZw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:01:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqoh1bttQu-i2GmytFawZw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:01:30 INFO - Downloaded 1448 bytes. 22:01:30 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:01:30 INFO - Using the following test package requirements: 22:01:30 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:01:30 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:30 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:01:30 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:30 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:01:30 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:30 INFO - u'jsshell-linux-x86_64.zip'], 22:01:30 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:30 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:01:30 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:01:30 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:30 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:01:30 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:30 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:01:30 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:30 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:01:30 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:01:30 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:30 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:01:30 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:30 INFO - https://queue.taskcluster.net/v1/task/Jqoh1bttQu-i2GmytFawZw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:01:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqoh1bttQu-i2GmytFawZw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:01:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqoh1bttQu-i2GmytFawZw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:01:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqoh1bttQu-i2GmytFawZw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:01:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqoh1bttQu-i2GmytFawZw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:01:31 INFO - Downloaded 23349749 bytes. 22:01:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:01:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:01:33 INFO - Return code: 0 22:01:33 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:01:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:33 INFO - https://queue.taskcluster.net/v1/task/Jqoh1bttQu-i2GmytFawZw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:01:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqoh1bttQu-i2GmytFawZw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:01:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqoh1bttQu-i2GmytFawZw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:01:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqoh1bttQu-i2GmytFawZw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:01:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqoh1bttQu-i2GmytFawZw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:01:35 INFO - Downloaded 23349749 bytes. 22:01:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:01:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:01:37 INFO - Return code: 0 22:01:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:37 INFO - https://queue.taskcluster.net/v1/task/Jqoh1bttQu-i2GmytFawZw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:01:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqoh1bttQu-i2GmytFawZw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:01:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqoh1bttQu-i2GmytFawZw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:01:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqoh1bttQu-i2GmytFawZw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:01:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqoh1bttQu-i2GmytFawZw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:01:38 INFO - Downloaded 10707015 bytes. 22:01:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:01:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 22:01:38 INFO - Return code: 0 22:01: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')]} 22:01:38 INFO - https://queue.taskcluster.net/v1/task/Jqoh1bttQu-i2GmytFawZw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:01:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqoh1bttQu-i2GmytFawZw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:01:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqoh1bttQu-i2GmytFawZw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:01:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqoh1bttQu-i2GmytFawZw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:01:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqoh1bttQu-i2GmytFawZw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:01:40 INFO - Downloaded 56598516 bytes. 22:01:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Jqoh1bttQu-i2GmytFawZw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:01:40 INFO - mkdir: /builds/slave/test-pgo/properties 22:01:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:01:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:01:40 INFO - Contents: 22:01:40 INFO - build_url:https://queue.taskcluster.net/v1/task/Jqoh1bttQu-i2GmytFawZw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:01:41 INFO - Running post-action listener: _resource_record_post_action 22:01:41 INFO - Running post-action listener: set_extra_try_arguments 22:01:41 INFO - ##### 22:01:41 INFO - ##### Running populate-webroot step. 22:01:41 INFO - ##### 22:01:41 INFO - Running pre-action listener: _resource_record_pre_action 22:01:41 INFO - Running main action method: populate_webroot 22:01:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:01:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:01:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:01:41 INFO - '--tppagecycles', 22:01:41 INFO - '7'], 22:01:41 INFO - 'tests': ['tsvgm']}}, 22:01:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:01:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:01:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:01:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:01:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:01:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:01:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:01:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:41 INFO - 'talos_options': ['--e10s'], 22:01:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:01:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:41 INFO - 'tests': ['damp', 'tps']}, 22:01:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:41 INFO - 'talos_options': ['--e10s'], 22:01:41 INFO - 'tests': ['damp', 'tps']}, 22:01:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:01:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:01:41 INFO - 'other': {'tests': ['a11yr', 22:01:41 INFO - 'ts_paint', 22:01:41 INFO - 'tpaint', 22:01:41 INFO - 'sessionrestore', 22:01:41 INFO - 'sessionrestore_no_auto_restore']}, 22:01:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:01:41 INFO - 'tests': ['a11yr', 22:01:41 INFO - 'ts_paint', 22:01:41 INFO - 'tpaint', 22:01:41 INFO - 'sessionrestore', 22:01:41 INFO - 'sessionrestore_no_auto_restore']}, 22:01:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:01:41 INFO - 'tests': ['a11yr', 22:01:41 INFO - 'ts_paint', 22:01:41 INFO - 'tpaint', 22:01:41 INFO - 'sessionrestore', 22:01:41 INFO - 'sessionrestore_no_auto_restore']}, 22:01:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:01:41 INFO - 'tests': ['a11yr', 22:01:41 INFO - 'ts_paint', 22:01:41 INFO - 'tpaint', 22:01:41 INFO - 'sessionrestore', 22:01:41 INFO - 'sessionrestore_no_auto_restore']}, 22:01:41 INFO - 'other_l64': {'tests': ['a11yr', 22:01:41 INFO - 'ts_paint', 22:01:41 INFO - 'tpaint', 22:01:41 INFO - 'sessionrestore', 22:01:41 INFO - 'sessionrestore_no_auto_restore']}, 22:01:41 INFO - 'other_nol64': {'tests': ['a11yr', 22:01:41 INFO - 'ts_paint', 22:01:41 INFO - 'tpaint', 22:01:41 INFO - 'sessionrestore', 22:01:41 INFO - 'sessionrestore_no_auto_restore']}, 22:01:41 INFO - 'svgr': {'tests': ['tsvgx', 22:01:41 INFO - 'tsvgr_opacity', 22:01:41 INFO - 'tart', 22:01:41 INFO - 'tscrollx', 22:01:41 INFO - 'cart']}, 22:01:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:01:41 INFO - 'tests': ['tsvgx', 22:01:41 INFO - 'tsvgr_opacity', 22:01:41 INFO - 'tart', 22:01:41 INFO - 'tscrollx', 22:01:41 INFO - 'cart']}, 22:01:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:41 INFO - 'tests': ['tp5o']}, 22:01:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:41 INFO - 'talos_options': ['--e10s'], 22:01:41 INFO - 'tests': ['tp5o']}, 22:01:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:41 INFO - 'talos_options': ['--xperf_path', 22:01:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:01:41 INFO - 'tests': ['tp5n']}, 22:01:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:41 INFO - 'talos_options': ['--e10s', 22:01:41 INFO - '--xperf_path', 22:01:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:01:41 INFO - 'tests': ['tp5n']}}, 22:01:41 INFO - 'talos.zip': {'path': '', 22:01:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:01:41 INFO - Running post-action listener: _resource_record_post_action 22:01:41 INFO - ##### 22:01:41 INFO - ##### Running create-virtualenv step. 22:01:41 INFO - ##### 22:01:41 INFO - Running pre-action listener: _resource_record_pre_action 22:01:41 INFO - Running main action method: create_virtualenv 22:01:41 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:01: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 22:01:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:01:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:01:41 INFO - Using real prefix '/usr' 22:01:41 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:01:41 INFO - Installing distribute.............................................................................................................................................................................................done. 22:01:43 INFO - Installing pip.................done. 22:01:43 INFO - Return code: 0 22:01:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01: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 0x7fc56fff6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a36670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac58c0>, '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 0x1ac67c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac6c50>, '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': 'af724c981e2a0f424dbabf99000001e7-1455942485.144514-978334050', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:01: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 22:01: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 22:01:43 INFO - Using env: {'DISPLAY': ':0', 22:01:43 INFO - 'HOME': '/home/cltbld', 22:01:43 INFO - 'LANG': 'en_US.UTF-8', 22:01:43 INFO - 'LANGUAGE': 'en_US:en', 22:01:43 INFO - 'LOGNAME': 'cltbld', 22:01:43 INFO - 'MAIL': '/var/mail/cltbld', 22:01:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:43 INFO - 'MOZ_NO_REMOTE': '1', 22:01:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:43 INFO - 'NO_EM_RESTART': '1', 22:01:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:01:43 INFO - 'PWD': '/builds/slave/test-pgo', 22:01:43 INFO - 'SHELL': '/bin/bash', 22:01:43 INFO - 'SHLVL': '1', 22:01:43 INFO - 'TERM': 'linux', 22:01:43 INFO - 'TMOUT': '86400', 22:01:43 INFO - 'USER': 'cltbld', 22:01:43 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1455942485.144514-978334050', 22:01:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:43 INFO - '_': '/tools/buildbot/bin/python'} 22:01:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:01:43 INFO - Cleaning up... 22:01:43 INFO - Return code: 0 22:01:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01: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', '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 0x7fc56fff6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a36670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac58c0>, '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 0x1ac67c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac6c50>, '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': 'af724c981e2a0f424dbabf99000001e7-1455942485.144514-978334050', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:01: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 22:01: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 psutil>=0.7.1 22:01:43 INFO - Using env: {'DISPLAY': ':0', 22:01:43 INFO - 'HOME': '/home/cltbld', 22:01:43 INFO - 'LANG': 'en_US.UTF-8', 22:01:43 INFO - 'LANGUAGE': 'en_US:en', 22:01:43 INFO - 'LOGNAME': 'cltbld', 22:01:43 INFO - 'MAIL': '/var/mail/cltbld', 22:01:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:43 INFO - 'MOZ_NO_REMOTE': '1', 22:01:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:43 INFO - 'NO_EM_RESTART': '1', 22:01:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:01:43 INFO - 'PWD': '/builds/slave/test-pgo', 22:01:43 INFO - 'SHELL': '/bin/bash', 22:01:43 INFO - 'SHLVL': '1', 22:01:43 INFO - 'TERM': 'linux', 22:01:43 INFO - 'TMOUT': '86400', 22:01:43 INFO - 'USER': 'cltbld', 22:01:43 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1455942485.144514-978334050', 22:01:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:43 INFO - '_': '/tools/buildbot/bin/python'} 22:01:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:44 INFO - Downloading/unpacking psutil>=0.7.1 22:01: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 22:01: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 22:01: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 22:01: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 22:01: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 22:01: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 22:01:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:01:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:01:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:01:46 INFO - Installing collected packages: psutil 22:01:46 INFO - Running setup.py install for psutil 22:01:46 INFO - building 'psutil._psutil_linux' extension 22:01: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 22:01: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 22:01:46 INFO - building 'psutil._psutil_posix' extension 22:01: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 22:01: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 22:01:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:01:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:01:46 INFO - Successfully installed psutil 22:01:46 INFO - Cleaning up... 22:01:46 INFO - Return code: 0 22:01:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:01: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')]} 22:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01: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')]} 22:01:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01: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 0x7fc56fff6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a36670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac58c0>, '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 0x1ac67c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac6c50>, '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': 'af724c981e2a0f424dbabf99000001e7-1455942485.144514-978334050', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:01: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 22:01: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 22:01:46 INFO - Using env: {'DISPLAY': ':0', 22:01:46 INFO - 'HOME': '/home/cltbld', 22:01:46 INFO - 'LANG': 'en_US.UTF-8', 22:01:46 INFO - 'LANGUAGE': 'en_US:en', 22:01:46 INFO - 'LOGNAME': 'cltbld', 22:01:46 INFO - 'MAIL': '/var/mail/cltbld', 22:01:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:46 INFO - 'MOZ_NO_REMOTE': '1', 22:01:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:46 INFO - 'NO_EM_RESTART': '1', 22:01:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:01:46 INFO - 'PWD': '/builds/slave/test-pgo', 22:01:46 INFO - 'SHELL': '/bin/bash', 22:01:46 INFO - 'SHLVL': '1', 22:01:46 INFO - 'TERM': 'linux', 22:01:46 INFO - 'TMOUT': '86400', 22:01:46 INFO - 'USER': 'cltbld', 22:01:46 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1455942485.144514-978334050', 22:01:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:46 INFO - '_': '/tools/buildbot/bin/python'} 22:01:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:01:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:01:48 INFO - Installing collected packages: mozsystemmonitor 22:01:48 INFO - Running setup.py install for mozsystemmonitor 22:01:48 INFO - Successfully installed mozsystemmonitor 22:01:48 INFO - Cleaning up... 22:01:48 INFO - Return code: 0 22:01:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:01:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:48 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 0x7fc56fff6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a36670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac58c0>, '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 0x1ac67c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac6c50>, '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': 'af724c981e2a0f424dbabf99000001e7-1455942485.144514-978334050', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:01:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 22:01:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:01:48 INFO - Using env: {'DISPLAY': ':0', 22:01:48 INFO - 'HOME': '/home/cltbld', 22:01:48 INFO - 'LANG': 'en_US.UTF-8', 22:01:48 INFO - 'LANGUAGE': 'en_US:en', 22:01:48 INFO - 'LOGNAME': 'cltbld', 22:01:48 INFO - 'MAIL': '/var/mail/cltbld', 22:01:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:48 INFO - 'MOZ_NO_REMOTE': '1', 22:01:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:48 INFO - 'NO_EM_RESTART': '1', 22:01:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:01:48 INFO - 'PWD': '/builds/slave/test-pgo', 22:01:48 INFO - 'SHELL': '/bin/bash', 22:01:48 INFO - 'SHLVL': '1', 22:01:48 INFO - 'TERM': 'linux', 22:01:48 INFO - 'TMOUT': '86400', 22:01:48 INFO - 'USER': 'cltbld', 22:01:48 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1455942485.144514-978334050', 22:01:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:48 INFO - '_': '/tools/buildbot/bin/python'} 22:01:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:48 INFO - Downloading/unpacking blobuploader==1.2.4 22:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:50 INFO - Downloading blobuploader-1.2.4.tar.gz 22:01:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:01:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:01:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:51 INFO - Downloading docopt-0.6.1.tar.gz 22:01:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:01:51 INFO - Installing collected packages: blobuploader, requests, docopt 22:01:51 INFO - Running setup.py install for blobuploader 22:01:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:01:51 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:01:51 INFO - Running setup.py install for requests 22:01:51 INFO - Running setup.py install for docopt 22:01:52 INFO - Successfully installed blobuploader requests docopt 22:01:52 INFO - Cleaning up... 22:01:52 INFO - Return code: 0 22:01:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:01: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')]} 22:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01: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')]} 22:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01: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 0x7fc56fff6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a36670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac58c0>, '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 0x1ac67c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac6c50>, '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': 'af724c981e2a0f424dbabf99000001e7-1455942485.144514-978334050', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:01: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 22:01: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 22:01:52 INFO - Using env: {'DISPLAY': ':0', 22:01:52 INFO - 'HOME': '/home/cltbld', 22:01:52 INFO - 'LANG': 'en_US.UTF-8', 22:01:52 INFO - 'LANGUAGE': 'en_US:en', 22:01:52 INFO - 'LOGNAME': 'cltbld', 22:01:52 INFO - 'MAIL': '/var/mail/cltbld', 22:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:52 INFO - 'MOZ_NO_REMOTE': '1', 22:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:52 INFO - 'NO_EM_RESTART': '1', 22:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:01:52 INFO - 'PWD': '/builds/slave/test-pgo', 22:01:52 INFO - 'SHELL': '/bin/bash', 22:01:52 INFO - 'SHLVL': '1', 22:01:52 INFO - 'TERM': 'linux', 22:01:52 INFO - 'TMOUT': '86400', 22:01:52 INFO - 'USER': 'cltbld', 22:01:52 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1455942485.144514-978334050', 22:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:52 INFO - '_': '/tools/buildbot/bin/python'} 22:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:01:52 INFO - Running setup.py (path:/tmp/pip-tDjVLe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:01:52 INFO - Running setup.py (path:/tmp/pip-BE2CMw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:01:52 INFO - Running setup.py (path:/tmp/pip-PgjP6X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:01:52 INFO - Running setup.py (path:/tmp/pip-iM08T7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:01:52 INFO - Running setup.py (path:/tmp/pip-9NlbpH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:01:52 INFO - Running setup.py (path:/tmp/pip-3nKJAM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:01:52 INFO - Running setup.py (path:/tmp/pip-gBNctc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:01:52 INFO - Running setup.py (path:/tmp/pip-AmyCyL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:01:52 INFO - Running setup.py (path:/tmp/pip-X07BK7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:01:52 INFO - Running setup.py (path:/tmp/pip-O8zkHD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:01:53 INFO - Running setup.py (path:/tmp/pip-QTt77y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:01:53 INFO - Running setup.py (path:/tmp/pip-ZA9Dxk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:01:53 INFO - Running setup.py (path:/tmp/pip-ti4hpa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:01:53 INFO - Running setup.py (path:/tmp/pip-DCwHCZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:01:53 INFO - Running setup.py (path:/tmp/pip-hUVXPY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:01:53 INFO - Running setup.py (path:/tmp/pip-Vu2U3E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:01:53 INFO - Running setup.py (path:/tmp/pip-Amq9w3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:01:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:01:53 INFO - Running setup.py install for manifestparser 22:01:53 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:01:53 INFO - Running setup.py install for mozcrash 22:01:53 INFO - Running setup.py install for mozdebug 22:01:53 INFO - Running setup.py install for mozdevice 22:01:53 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:01:53 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:01:53 INFO - Running setup.py install for mozfile 22:01:54 INFO - Running setup.py install for mozhttpd 22:01:54 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:01:54 INFO - Running setup.py install for mozinfo 22:01:54 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:01:54 INFO - Running setup.py install for mozInstall 22:01:54 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:01:54 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:01:54 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:01:54 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:01:54 INFO - Running setup.py install for mozleak 22:01:54 INFO - Running setup.py install for mozlog 22:01:54 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:01:54 INFO - Running setup.py install for moznetwork 22:01:54 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:01:54 INFO - Running setup.py install for mozprocess 22:01:54 INFO - Running setup.py install for mozprofile 22:01:54 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:01:54 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:01:54 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:01:54 INFO - Running setup.py install for mozrunner 22:01:55 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:01:55 INFO - Running setup.py install for mozscreenshot 22:01:55 INFO - Running setup.py install for moztest 22:01:55 INFO - Running setup.py install for mozversion 22:01:55 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:01:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:01:55 INFO - Cleaning up... 22:01:55 INFO - Return code: 0 22:01:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01: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 0x7fc56fff6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a36670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac58c0>, '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 0x1ac67c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac6c50>, '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': 'af724c981e2a0f424dbabf99000001e7-1455942485.144514-978334050', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:01: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 22:01: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 22:01:55 INFO - Using env: {'DISPLAY': ':0', 22:01:55 INFO - 'HOME': '/home/cltbld', 22:01:55 INFO - 'LANG': 'en_US.UTF-8', 22:01:55 INFO - 'LANGUAGE': 'en_US:en', 22:01:55 INFO - 'LOGNAME': 'cltbld', 22:01:55 INFO - 'MAIL': '/var/mail/cltbld', 22:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:55 INFO - 'MOZ_NO_REMOTE': '1', 22:01:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:55 INFO - 'NO_EM_RESTART': '1', 22:01:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:01:55 INFO - 'PWD': '/builds/slave/test-pgo', 22:01:55 INFO - 'SHELL': '/bin/bash', 22:01:55 INFO - 'SHLVL': '1', 22:01:55 INFO - 'TERM': 'linux', 22:01:55 INFO - 'TMOUT': '86400', 22:01:55 INFO - 'USER': 'cltbld', 22:01:55 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1455942485.144514-978334050', 22:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:55 INFO - '_': '/tools/buildbot/bin/python'} 22:01:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:01:55 INFO - Running setup.py (path:/tmp/pip-AaMc2J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 22:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:01:55 INFO - Running setup.py (path:/tmp/pip-viA_0X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:01:55 INFO - Running setup.py (path:/tmp/pip-QgaVI_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:01:55 INFO - Running setup.py (path:/tmp/pip-tNJjiY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:01:55 INFO - Running setup.py (path:/tmp/pip-Vf23TX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 22:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:01:55 INFO - Running setup.py (path:/tmp/pip-nATZjL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:01: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)) 22:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:01:56 INFO - Running setup.py (path:/tmp/pip-9arel0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:01: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)) 22:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:01:56 INFO - Running setup.py (path:/tmp/pip-n8LP3e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:01: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)) 22:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:01:56 INFO - Running setup.py (path:/tmp/pip-JfRwDA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:01: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)) 22:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:01:56 INFO - Running setup.py (path:/tmp/pip-Fg1luf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:01: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)) 22:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:01:56 INFO - Running setup.py (path:/tmp/pip-rJZzkY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:01: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)) 22:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:01:56 INFO - Running setup.py (path:/tmp/pip-zHPnoy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:01: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)) 22:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:01:56 INFO - Running setup.py (path:/tmp/pip-Ta4YUM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 22:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:01:56 INFO - Running setup.py (path:/tmp/pip-N2130h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 22:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:01:56 INFO - Running setup.py (path:/tmp/pip-x71n0f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 22:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:01:56 INFO - Running setup.py (path:/tmp/pip-piJqet-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 22:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:01:56 INFO - Running setup.py (path:/tmp/pip-T9z8NY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 22:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:01:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:58 INFO - Downloading blessings-1.6.tar.gz 22:01:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:01:58 INFO - Installing collected packages: blessings 22:01:58 INFO - Running setup.py install for blessings 22:01:58 INFO - Successfully installed blessings 22:01:58 INFO - Cleaning up... 22:01:58 INFO - Return code: 0 22:01:58 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:01:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:01:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:01:59 INFO - Reading from file tmpfile_stdout 22:01:59 INFO - Current package versions: 22:01:59 INFO - argparse == 1.2.1 22:01:59 INFO - blessings == 1.6 22:01:59 INFO - blobuploader == 1.2.4 22:01:59 INFO - docopt == 0.6.1 22:01:59 INFO - manifestparser == 1.1 22:01:59 INFO - mozInstall == 1.12 22:01:59 INFO - mozcrash == 0.16 22:01:59 INFO - mozdebug == 0.1 22:01:59 INFO - mozdevice == 0.48 22:01:59 INFO - mozfile == 1.2 22:01:59 INFO - mozhttpd == 0.7 22:01:59 INFO - mozinfo == 0.9 22:01:59 INFO - mozleak == 0.1 22:01:59 INFO - mozlog == 3.1 22:01:59 INFO - moznetwork == 0.27 22:01:59 INFO - mozprocess == 0.22 22:01:59 INFO - mozprofile == 0.28 22:01:59 INFO - mozrunner == 6.11 22:01:59 INFO - mozscreenshot == 0.1 22:01:59 INFO - mozsystemmonitor == 0.0 22:01:59 INFO - moztest == 0.7 22:01:59 INFO - mozversion == 1.4 22:01:59 INFO - psutil == 3.1.1 22:01:59 INFO - requests == 1.2.3 22:01:59 INFO - wsgiref == 0.1.2 22:01:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01: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 0x7fc56fff6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a36670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac58c0>, '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 0x1ac67c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac6c50>, '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': 'af724c981e2a0f424dbabf99000001e7-1455942485.144514-978334050', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:01: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 22:01: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 22:01:59 INFO - Using env: {'DISPLAY': ':0', 22:01:59 INFO - 'HOME': '/home/cltbld', 22:01:59 INFO - 'LANG': 'en_US.UTF-8', 22:01:59 INFO - 'LANGUAGE': 'en_US:en', 22:01:59 INFO - 'LOGNAME': 'cltbld', 22:01:59 INFO - 'MAIL': '/var/mail/cltbld', 22:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:59 INFO - 'MOZ_NO_REMOTE': '1', 22:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:59 INFO - 'NO_EM_RESTART': '1', 22:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:01:59 INFO - 'PWD': '/builds/slave/test-pgo', 22:01:59 INFO - 'SHELL': '/bin/bash', 22:01:59 INFO - 'SHLVL': '1', 22:01:59 INFO - 'TERM': 'linux', 22:01:59 INFO - 'TMOUT': '86400', 22:01:59 INFO - 'USER': 'cltbld', 22:01:59 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1455942485.144514-978334050', 22:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:59 INFO - '_': '/tools/buildbot/bin/python'} 22:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01: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)) 22:01: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)) 22:01: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)) 22:01: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)) 22:01: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)) 22:01: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)) 22:01: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)) 22:01: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)) 22:01: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)) 22:01: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)) 22:01: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)) 22:01:59 INFO - Cleaning up... 22:01:59 INFO - Return code: 0 22:01:59 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01: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 0x7fc56fff6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a36670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac58c0>, '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 0x1ac67c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac6c50>, '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': 'af724c981e2a0f424dbabf99000001e7-1455942485.144514-978334050', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:01: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 22:01: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 22:01:59 INFO - Using env: {'DISPLAY': ':0', 22:01:59 INFO - 'HOME': '/home/cltbld', 22:01:59 INFO - 'LANG': 'en_US.UTF-8', 22:01:59 INFO - 'LANGUAGE': 'en_US:en', 22:01:59 INFO - 'LOGNAME': 'cltbld', 22:01:59 INFO - 'MAIL': '/var/mail/cltbld', 22:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:59 INFO - 'MOZ_NO_REMOTE': '1', 22:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:59 INFO - 'NO_EM_RESTART': '1', 22:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:01:59 INFO - 'PWD': '/builds/slave/test-pgo', 22:01:59 INFO - 'SHELL': '/bin/bash', 22:01:59 INFO - 'SHLVL': '1', 22:01:59 INFO - 'TERM': 'linux', 22:01:59 INFO - 'TMOUT': '86400', 22:01:59 INFO - 'USER': 'cltbld', 22:01:59 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1455942485.144514-978334050', 22:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:59 INFO - '_': '/tools/buildbot/bin/python'} 22:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:59 INFO - Downloading/unpacking jsonschema 22:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:02:01 INFO - Downloading/unpacking functools32 (from jsonschema) 22:02: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 22:02: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 22:02: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 22:02: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 22:02: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 22:02: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 22:02:01 INFO - Downloading functools32-3.2.3-2.tar.gz 22:02:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:02:01 INFO - warning: no files found matching '*.txt' 22:02:01 INFO - no previously-included directories found matching 'build' 22:02:01 INFO - no previously-included directories found matching 'dist' 22:02:01 INFO - no previously-included directories found matching '.git*' 22:02:01 INFO - Installing collected packages: jsonschema, functools32 22:02:01 INFO - Running setup.py install for functools32 22:02:01 INFO - warning: no files found matching '*.txt' 22:02:01 INFO - no previously-included directories found matching 'build' 22:02:01 INFO - no previously-included directories found matching 'dist' 22:02:01 INFO - no previously-included directories found matching '.git*' 22:02:01 INFO - Successfully installed jsonschema functools32 22:02:01 INFO - Cleaning up... 22:02:01 INFO - Return code: 0 22:02:01 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:01 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 0x7fc56fff6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a36670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac58c0>, '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 0x1ac67c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac6c50>, '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': 'af724c981e2a0f424dbabf99000001e7-1455942485.144514-978334050', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:02:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 22:02:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:02:01 INFO - Using env: {'DISPLAY': ':0', 22:02:01 INFO - 'HOME': '/home/cltbld', 22:02:01 INFO - 'LANG': 'en_US.UTF-8', 22:02:01 INFO - 'LANGUAGE': 'en_US:en', 22:02:01 INFO - 'LOGNAME': 'cltbld', 22:02:01 INFO - 'MAIL': '/var/mail/cltbld', 22:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:01 INFO - 'MOZ_NO_REMOTE': '1', 22:02:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:01 INFO - 'NO_EM_RESTART': '1', 22:02:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:02:01 INFO - 'PWD': '/builds/slave/test-pgo', 22:02:01 INFO - 'SHELL': '/bin/bash', 22:02:01 INFO - 'SHLVL': '1', 22:02:01 INFO - 'TERM': 'linux', 22:02:01 INFO - 'TMOUT': '86400', 22:02:01 INFO - 'USER': 'cltbld', 22:02:01 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1455942485.144514-978334050', 22:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:01 INFO - '_': '/tools/buildbot/bin/python'} 22:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:01 INFO - Downloading/unpacking flake8 22:02: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 22:02: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 22:02: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 22:02: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 22:02: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 22:02: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 22:02:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:02:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:02:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:02:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:02:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:02:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:02:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:02:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:02:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:02:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:02:04 INFO - no previously-included directories found matching 'docs/_build' 22:02:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:02:04 INFO - Running setup.py install for pep8 22:02:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:02:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:02:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:02:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:02:04 INFO - no previously-included directories found matching 'docs/_build' 22:02:04 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:02:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:02:04 INFO - Cleaning up... 22:02:04 INFO - Return code: 0 22:02:04 INFO - Running post-action listener: _resource_record_post_action 22:02:04 INFO - Running post-action listener: _start_resource_monitoring 22:02:04 INFO - Starting resource monitoring. 22:02:04 INFO - ##### 22:02:04 INFO - ##### Running install step. 22:02:04 INFO - ##### 22:02:04 INFO - Running pre-action listener: _resource_record_pre_action 22:02:04 INFO - Running main action method: install 22:02:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:02:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:02:04 INFO - Reading from file tmpfile_stdout 22:02:04 INFO - Detecting whether we're running mozinstall >=1.0... 22:02:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:02:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:02:05 INFO - Reading from file tmpfile_stdout 22:02:05 INFO - Output received: 22:02:05 INFO - Usage: mozinstall [options] installer 22:02:05 INFO - Options: 22:02:05 INFO - -h, --help show this help message and exit 22:02:05 INFO - -d DEST, --destination=DEST 22:02:05 INFO - Directory to install application into. [default: 22:02:05 INFO - "/builds/slave/test-pgo"] 22:02:05 INFO - --app=APP Application being installed. [default: firefox] 22:02:05 INFO - mkdir: /builds/slave/test-pgo/build/application 22:02:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:02:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:02:22 INFO - Reading from file tmpfile_stdout 22:02:22 INFO - Output received: 22:02:22 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:02:22 INFO - Running post-action listener: _resource_record_post_action 22:02:22 INFO - ##### 22:02:22 INFO - ##### Running run-tests step. 22:02:22 INFO - ##### 22:02:22 INFO - Running pre-action listener: _resource_record_pre_action 22:02:22 INFO - Running main action method: run_tests 22:02:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:02:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:02:22 INFO - Python 2.7.3 22:02:22 INFO - Return code: 0 22:02:22 INFO - grabbing minidump binary from tooltool 22:02: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')]} 22:02: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 0x1ac58c0>, '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 0x1ac67c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac6c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:02: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 22:02: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 22:02:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:02:22 INFO - Return code: 0 22:02:22 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:02:22 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:02:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:02:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:02:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:02:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:02:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:02:23 INFO - Return code: 0 22:02: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/Jqoh1bttQu-i2GmytFawZw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 22:02: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/Jqoh1bttQu-i2GmytFawZw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:02:23 INFO - Using env: {'DISPLAY': ':0', 22:02:23 INFO - 'HOME': '/home/cltbld', 22:02:23 INFO - 'LANG': 'en_US.UTF-8', 22:02:23 INFO - 'LANGUAGE': 'en_US:en', 22:02:23 INFO - 'LOGNAME': 'cltbld', 22:02:23 INFO - 'MAIL': '/var/mail/cltbld', 22:02:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:02:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:02:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:23 INFO - 'MOZ_NO_REMOTE': '1', 22:02:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:02:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:23 INFO - 'NO_EM_RESTART': '1', 22:02:23 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:02:23 INFO - 'PWD': '/builds/slave/test-pgo', 22:02:23 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:02:23 INFO - 'SHELL': '/bin/bash', 22:02:23 INFO - 'SHLVL': '1', 22:02:23 INFO - 'TERM': 'linux', 22:02:23 INFO - 'TMOUT': '86400', 22:02:23 INFO - 'USER': 'cltbld', 22:02:23 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1455942485.144514-978334050', 22:02:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:23 INFO - '_': '/tools/buildbot/bin/python'} 22:02: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/Jqoh1bttQu-i2GmytFawZw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:02:23 INFO - mozversion application_buildid: 20160219193142 22:02:23 INFO - mozversion application_changeset: 69ec3dc408a2a720cb2b8210fea33e3504aeec22 22:02:23 INFO - mozversion application_display_name: Nightly 22:02:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:02:23 INFO - mozversion application_name: Firefox 22:02:23 INFO - mozversion application_remotingname: firefox 22:02:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:02:23 INFO - mozversion application_vendor: Mozilla 22:02:23 INFO - mozversion application_version: 47.0a1 22:02:23 INFO - mozversion platform_buildid: 20160219193142 22:02:23 INFO - mozversion platform_changeset: 69ec3dc408a2a720cb2b8210fea33e3504aeec22 22:02:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:02:23 INFO - mozversion platform_version: 47.0a1 22:02:23 INFO - using testdate: 1455948143 22:02:23 INFO - actual date: 1455948143 22:02:23 INFO - starting webserver on 'localhost:60376' 22:02:23 INFO - SUITE-START | Running 2 tests 22:02:23 INFO - TEST-START | dromaeo_css 22:02:23 INFO - operating with platform_type : linux_ 22:02:23 INFO - Initialising browser for dromaeo_css test... 22:02:23 INFO - TEST-INFO | started process 8355 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4yADNs/profile http://localhost:60376/getInfo.html) 22:02:27 INFO - PROCESS | 8355 | 22:02:27 INFO - PROCESS | 8355 | (process:8440): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:02:28 INFO - PROCESS | 8355 | __metrics Screen width/height:1600/1200 22:02:28 INFO - PROCESS | 8355 | colorDepth:24 22:02:28 INFO - PROCESS | 8355 | Browser inner width/height: 1024/697 22:02:28 INFO - PROCESS | 8355 | __metrics 22:02:29 ERROR - PROCESS | 8355 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2871: TypeError: this.tabs is undefined 22:02:30 INFO - TEST-INFO | 8355: exit 0 22:02:30 INFO - Browser initialized. 22:02:30 INFO - Running cycle 1/1 for dromaeo_css test... 22:02:30 INFO - TEST-INFO | started process 8491 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4yADNs/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:02:31 INFO - PROCESS | 8491 | 22:02:31 INFO - PROCESS | 8491 | (process:8549): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:02:42 INFO - PROCESS | 8491 | RSS: Main: 155013120 22:02:42 INFO - PROCESS | 8491 | 22:03:31 INFO - PROCESS | 8491 | 1455948211856 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:05:40 INFO - PROCESS | 8491 | Cycle 1(1): loaded http://localhost:60376/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60376/tests/dromaeo/cssquery-ext.html) 22:05:41 INFO - PROCESS | 8491 | RSS: Main: 163110912 22:05:41 INFO - PROCESS | 8491 | 22:08:43 INFO - PROCESS | 8491 | Cycle 1(1): loaded http://localhost:60376/tests/dromaeo/cssquery-ext.html (next: http://localhost:60376/tests/dromaeo/cssquery-jquery.html) 22:08:44 INFO - PROCESS | 8491 | RSS: Main: 159600640 22:08:44 INFO - PROCESS | 8491 | 22:11:45 INFO - PROCESS | 8491 | Cycle 1(1): loaded http://localhost:60376/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60376/tests/dromaeo/cssquery-mootools.html) 22:11:46 INFO - PROCESS | 8491 | RSS: Main: 162549760 22:11:46 INFO - PROCESS | 8491 | 22:14:48 INFO - PROCESS | 8491 | Cycle 1(1): loaded http://localhost:60376/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60376/tests/dromaeo/cssquery-prototype.html) 22:14:48 INFO - PROCESS | 8491 | RSS: Main: 159526912 22:14:48 INFO - PROCESS | 8491 | 22:17:51 INFO - PROCESS | 8491 | Cycle 1(1): loaded http://localhost:60376/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60376/tests/dromaeo/cssquery-yui.html) 22:17:51 INFO - PROCESS | 8491 | RSS: Main: 158957568 22:17:51 INFO - PROCESS | 8491 | 22:20:54 INFO - PROCESS | 8491 | Cycle 1(1): loaded http://localhost:60376/tests/dromaeo/cssquery-yui.html (next: http://localhost:60376/tests/dromaeo/cssquery-dojo.html) 22:20:54 INFO - PROCESS | 8491 | RSS: Main: 161320960 22:20:54 INFO - PROCESS | 8491 | 22:20:54 INFO - PROCESS | 8491 | __start_tp_report 22:20:54 INFO - PROCESS | 8491 | _x_x_mozilla_page_load 22:20:54 INFO - PROCESS | 8491 | _x_x_mozilla_page_load_details 22:20:54 INFO - PROCESS | 8491 | |i|pagename|runs| 22:20:54 INFO - PROCESS | 8491 | |0;dojo.html;3207.7754557180997;3221.162497750584;3238.9838050809744;3269.722073623742;3271.9018429447124;5119.334486516747;5230.372355317362;5247.527722504974;5254.789808407669;5260.263563101164;5153.69077855328;5216.295800067;5239.187925871496;5244.082285600024;5244.554212891909;4748.715077095377;4780.928286075712;4879.560839524442;4976.303317535548;4980.551750342468;4794.712317260958;4866.78099485524;4872;4888.071266459379;4920.926186107194;4732.574068333849;4742.928856067145;4757.0723708876785;4773.403324584427;4797.640176986705;4764.737939413331;4766.070616229837;4767;4779.784909679072;4784.42586889572;4744.098621261949;4752.120857641347;4753.382060332169;4757.310190022462;4760.404949381327;5008.398992120932;5034.597232221414;5046.167382381903;5053.671511351788;5066.797328106872;5516.862078448071;5583.078791999355;5593.2449119368775;5595.38450770415;5597.132444471114;5641.153826925953;5676.517496012844;5696.6866822324755;5749.540036797046;5772.105323674838;5283.207518872162;5371.919421208685;5376;5385.973070134663;5392.865178370572;5690.0895856663565;5816.82549523515;5820.796272130455;5821;5840.766369345263;5597.328320601554;5620.747066382022;5648.124540696199;5677.347105082886;5708.543316534668;5599.7480113394995;5637.943620563824;5638.407967163389;5646.943530564642;5650.519705825051;5494.862628434241;5563.805266815642;5604.6917419542315;5628.971855140698;5667.4332566743;5561.165825126263;5567.359753628384;5583.748731307101;5587.664740115606;5626.915596266059;4339.7396156230725;4352.368906508538;4357.128574285156;4362.738235705804;4419.42547468827;3882.456456096149;3909.4722212501515;3924.6860251179837;3926.980365098156;3931.6264954829244;5275.920861187085;5276.894462110737;5281.0758117329315;5290.805823557178;5328.36059672834;5684.459976302244;5717.885642287214;5720.685362305113;5723.8855222896145;5736.4550367715;5273.683578985273;5280.3663560373;5335.466453354711;5348.839534813962;5376.569874410038;4920.089783390084;4922.08941345845;4924.261360795837;4925.704457732548;4972.0801651694555;5709.029464990961;5876.294844618673;5976.701164941823;5997.580169388101;6021.548383871227;5594.608377413542;5623.437656234508;5674.74463649145;5682.460166284279;5682.829515114553;5844.795432159854;5883.2057672213705;5894.410558944071;5894.498967587631;5921.17103605487;5435.918461223006;5585.5531557476115;5604.075327571069;5657.519110875622;5706.828795136153;5505.6696598204235;5552.639078459887;5575.163725441216;5587.0502014656795;5595.916061259003;5344.064788662046;5410.053240682943;5429.864253393696;5437.5378092860965;5468.781248750005;5451.48210919962;5465.945340546544;5471.50756431923;5476.0690682584855;5517.172424136412;5332.06688829461;5399.05516534597;5402.6758394496455;5422.701751403552;5467.753951072132;5490.341159060778;5503.724813759376;5534.363548192009;5590.440955904377;5679.290088738908;5326.866828329168;5363.490468405495;5369.677819330853;5385.6230063895155;5391.892162156813 22:20:54 INFO - PROCESS | 8491 | |1;ext.html;482.5102520941243;504.12534253070936;509.1573445946958;527.5726661404261;539.4012645962982;35624.821875890615;35947.46078808814;36068.27863442736;36388.27223455529;36413.63586364136;38717.806410967976;39369;39638.60361396385;39660.801695991555;39801;8457.450265732723;8623.95688021559;8640.308775297992;8649.437786543855;8659.95670021649;8418.158184181593;8617.138286171365;8623.353248506388;8636.222739953402;8636.438631488965;8609.39734218605;8684.956575217115;8701.60842762074;8725.040245572982;8727.0836562161;8612;8632.697855575056;8659.826803463928;8679.826403471958;8703.52130632815;8515.403921725481;8582.613782379807;8646.654133834701;8661.220490155853;8692.043875173726;36922;37403.25193496142;37481;37584.62415375866;37614;3330.333933213343;3344.0803778960735;3714.9814250928844;3832.080300727833;3939.7045221608496;29427.558586621217;29771.10686679403;30058.098257052323;30543.2364190897;30545.541816872767;3760.492333534965;3800.657940785343;3828.617138286177;3841.750286231386;3966.702497312684;264151;264236;264955.9999999981;265543;267303;44347.33478997817;44418;44714.55285447169;57289;57375.42624573784;42549;42617.360739588934;42706.57293427088;42772;42818.35772463415;12862.292573908338;12993.155444896052;13068.673283167807;13068.738625227443;13075.803862942064;10004.749881252881;10008.299419040597;10015.799684006424;10048.648297309559;10121.59513619447;14230.28848557568;14241.359138838778;14280.42878284857;14339.426422943174;14425.134491930517;5550.58370622205;5657.264555607745;5659.151127330851;5775.047117225611;5812.854678633068;939.3518472254123;958;988.3526290279734;991.3754334769194;991.9156871665845;28315.07853195749;28374.290642733686;28425.43149137006;28715.712842871722;28832.711672883004;1011.6408674920444;1028.8713910761155;1078.0297732041226;1092.011729384908;1108.3460758152567;15971.920140399223;16045.919770401073;16199.514014579581;16280.185990700418;16362.836371636131;279745;282665;284823;285029;286472;55845.441545584836;55957.440425595225;56129.71935140298;56350;56457;1308.169312486559;1315.4803852478408;1335.8664133586562;1351.8107464954915;1393.3590548347875;29402.558961615166;30579.185294337844;31023.0693079208;31086.844565777028;31108;46768.766156169004;46962.76518617385;47361.52638473709;47672.2849157256;47701.76149119371;290367;292569;292826;293315;294178;32219.838900805345;32454;32874.342513149124;33127.17182070467;33206.335873282886;41458.170836583704;41751.1649767009;42000.1599968005;42252;42357.57642423536;35108.12229694278;35508.64491355053;35595.466068008485;36578.8171059143;36943;36049.27901442009;37116.628833711315;38472;38545.421818672185;39079.41380879232;34525.309493810484;34629.65370346365;38243;38905;38963.220735585695;28751;30358.696413036472;30772.38455230838;31103.22241943879;31272.687273126976;24339.634905476785;25007.624885626366;25184.49631007333;25740.485190296462;25867 22:20:54 INFO - PROCESS | 8491 | |2;jquery.html;349.6957646847243;353.20352604876;353.8779121203184;355.5360254867397;357.46380429355963;16490.340386384545;16953.660926781457;17171.82828171718;17969.91015044926;17976.011319377445;10844.6746597602;11729.648110556676;16171.110588917605;16555.420560280392;16558.917205413956;4852.805887764485;5473.397926228132;5517.2551705519845;5529.861753456175;5541.33503979523;4918.754062296871;5287.814926477574;5434.456554344553;5459.153831156177;5473.233747275384;4943.9752801235945;5163.922541161867;5183.688978661293;5440.891182176354;5478;5128.076946149691;5137.101007323703;5161.561267292266;5327.30745003151;5893.116032595102;5242.1088414969545;5249.947500524984;5257.290265814105;5266.447023062561;5287.391949925769;13160;18730.250789968384;19173;19246.61506769871;20165.781764005947;2053.650879350514;2098.0558748563053;2100.390886642872;2213.6347502662043;2405.458771776354;9511.429314241168;9555.474448905308;12140.3322817245;12166.209196402295;12224.838640329155;1859.237712537853;1865.5615930256379;1884.0579710144928;1885.792562818089;1891.943241702751;61979.690101549655;62139.689301553655;63485;63542;64279.357206427805;9712;9908.80182396348;10057.798844023078;10143.695689129338;10151.086402223687;13086.672833179247;13106.2136271824;13112.606621801362;13135.474581016844;13167.539136130381;6939.791806245821;7178.353948144692;7189.532680375759;7237.782866514013;7277.59973201479;6685.598864068074;6695;6728.226253980757;6843.452523798084;6985.126859142607;4235.110626768352;4283.186194623074;4286.699931004862;4345.8261669533495;4364.236258654722;1635.705572996872;1741.5210817025165;1750.1161913233736;1828.277830257041;1842.474894655017;448.44169009583277;452.7985046654273;882.5807741322949;959.4531117263233;1028.341861208827;10548.103411209979;10809.891901081046;10961.561537538568;10971.615993440191;11033.889661103447;447.57256819737074;470.55297467406103;471.29541335703345;844.9704260350858;889.2663552569156;8667.349948753868;8839.955800220958;8997.145271199226;9472.479013654316;10135.594576217016;297291;299504;309563;311286;312021;68856.311436886;72523;73534.6323268391;75868.24131758722;77072.61463692646;1021.0555236406294;1042.3276986343765;1042.937423754562;1051.2115913065202;1057.7091299892438;15577.065376077018;15624.531264062096;15646.843531564995;15653.217339133225;16026;29859.850700747225;32538.674613254512;33089.66910330962;33549.32901342008;33845;46786.76606616945;46916;47084.52915470801;47415;47562;7738.187490313436;7885.605719713876;7887.250711182429;7893.407994400328;8023.839523209386;10789.190810689386;11797.17419780607;11892.762144756884;12024.639260822189;12247.326397048248;10093.495325233856;10523.263371563917;10532.315399499008;10716.678499645022;10750.247482676137;10708.30396024256;10790.028897399272;10852.403117828595;10987.340759554452;11190.644017989334;10794.784104318027;10855.511501982272;10876.728081798019;11123;11304.321740695585;7945.48354356965;7950.761477155695;7991;8016.4388492807275;8033.0761962372735;10201.846972295272;11197.496112675111;11198.832017519906;11270.661880143609;11408.087353011904 22:20:54 INFO - PROCESS | 8491 | |3;mootools.html;1414.3564678071475;1439.9424023039076;1578.8500092491217;1710.7519409685597;1725.0426013562467;7417.480776345658;7546.2076481969425;7654.961725191373;7656.655450504727;7684.308412242897;7487.25127487251;7536.84926301475;7564.810879727996;7571.924280757191;7614.238576142383;2206.7572567017655;2230.2640128757553;2245.247841972941;2245.2815099168274;2248.1344682297354;2229.498362868358;2247.359502541776;2249.1790496468834;2250.9437264068365;2264.920727774528;2176.7387913450407;2195.692603035576;2217.689523466716;2269.602819506588;2275.6472746724285;2157.5577006713665;2160.3302976077466;2178.3464960511783;2196.6485362342028;2201.5376770878215;2245.326402079386;2250.8762018089;2260.6609008648834;2269.512054908186;2278.2026290798253;7108.751193708247;7156.570605763619;7156.892646610305;7160.928390716131;7179.210286868492;4500;4560.612347950429;4584.15193189261;4617.284320930227;4628.95371046292;2911.1557648281973;2968.5992391027366;2983.701629837021;2989.7458716009164;3005.594244776949;932.8181004704086;945.3618807305041;954.6467806911418;965.0446058402201;1016.1667432705111;10271.845922311171;10291.53688084038;10432.374057556572;10472.057514823702;10509.106725928305;4084.326086195744;4119.567445418188;4159.251334759772;4196.706230563892;4210.45264115663;9133.588988495534;9142.588583513758;9176.44941303524;9191.632334706537;9228.95385523068;4662.813487460464;4676.953230467651;4685.742284174335;4718.174319494075;4729.172394830891;4082.2039702258367;4184.518780340239;4189.622933935961;4328.069465065026;4353.151135528541;3376.915577110543;3404.982975085158;3455.06713187438;3473.774204676688;3474.861005559749;1009.9040591143829;1040.8022475729588;1043.1289872956015;1045.17953406577;1047.9476026198813;1262.2741923394085;1272.9045321600731;1285.3123578885438;1327.7610030194464;1334.5796074236584;7005;7142.107236595426;7160.749373771893;7341.265873412723;7350.007748953823;479.5875547029552;483.5744544800553;491.2385802006875;496.53573908395043;498.3372115086926;5421.701806400686;5424.186372044225;5448.591355648342;5488.862778430571;5489.862753431116;8920.509371984474;8956.283497320199;9023.548822558845;9091.772705682279;9108.590113444778;8917.375783695079;8985.191332780081;8993;8993.505357205417;9077.273818094536;6673.132492775908;6755.864882702417;6792.592444453348;7250.891236631454;7294.963525182447;7072.504924655431;7098.467614928798;7104;7117.181524124585;7146.249643787328;8047.839043218985;8195.262426381654;8281.21328473794;8297.543635100128;8385.874211886705;8222.588870556569;8572.099929507312;8666.35002374837;8686.261667758312;8730.126987301219;6565.671716414065;6686.933130668631;7019.122609673791;7205.819854503679;7208.531445456028;7218.205997340184;7230.493865429369;7295.270472952874;7301;7301.488895777245;6418.967905160444;6525.3148419417175;6571.34286571339;6596.142501474969;6777.525573210025;6634.270230274762;6638.17022872141;6740.090087838079;6779.322067793181;6790.083338749206;6761.425278851156;6888.793336199922;6906.274841141608;6947.513674042971;6953.20038195614;6463.482921366373;6469.805905822833;6471.320511346429;6482.157319548429;6491.870162596816;6408.198975128109;6468.676566171578;6474.1907261592305;6480.416762491398;6491.545591808528 22:20:54 INFO - PROCESS | 8491 | |4;prototype.html;319.1080928803993;325.92992506611074;325.9722923551498;326.43363763869695;334.0796106725971;6343.936560634393;6349.206349206349;6355.745770169194;6418.614883107011;6540.182477190351;6330.905036424458;6338.30278669346;6342.365763423667;6393.552451328409;6410.455111315544;4762.404699412574;4780.90438191236;4786.688865223749;4792;4792.131068883138;4765.666403351766;4775.856724298276;4781.091592597413;4782.713037217761;4785.641076919228;4625.745583992879;4745.738984355859;4755.667103302771;4761.190597598416;4763.737994410306;4710.62315014798;4725.196716558194;4727.739974301429;4729.196036673757;4740.810367585293;4066.430699702044;4067.6949228807957;4069.04377471294;4069.9186016279805;4084.4690190275073;6017.308009578911;6019.187409699678;6043.969780151071;6044.848878778022;6047.639281161747;5403.162509810985;5513.558915286768;5526.226328314039;5532.861678458071;5540.113581826889;6690.063391125246;6723.428508576777;6724.562903411263;6733.663316834188;6742.359475849787;4487.551244875519;4498.077894031749;4501.234790085693;4501.729896206238;4501.987052913101;6766;6938.722451101949;6985.266547012592;7012.964935175291;7058.823529411755;4560.794764235618;4568.611668008257;4580.610648094949;4584.7936842842155;4598.26427771555;4617.191991401559;4635.725175576744;4636.4899861015265;4640.83757068501;4647.512011238839;5466.753996070186;5469.453054694499;5471.972640136853;5477.835664930059;5496.148097044965;6644.66776661165;6788.966055169792;6797.286284940109;6821.488388370892;6877.6217308048535;1525.9923700381428;1603.9117848518445;1614.0315810513598;1650.026484374225;1653.9421120260733;1022.3763504262394;1024.6618615856748;1070.341739829999;1070.71626019105;1077.1113831089383;6200.627962322275;6217.875642487215;6228.408301211378;6245.344238854946;6251.093591429309;6840.31596840312;6849.623270720158;6873.381395674413;6875.106236189364;6883.174019117638;6133.509319254449;6189.535784816067;6191.102290167901;6212.192414986113;6225.8132256032395;3689.94465083024;3693.963060369416;3708.4066549351974;3729.21686445844;3734.029152420336;7093.92906070943;7125.144982602017;7128.465365097639;7143.1428228612895;7150.463715221275;6820.795376138624;6973.198082220508;7001.229864714877;7035.190953040364;7042.260562640951;7086.114235720535;7103.82240443993;7108.253633368422;7112.28877112295;7119.1457025157315;6801.659917004031;6828.351306625863;6844.21291551458;6857.931420685929;6862;6714.429273511806;6735.797926062226;6773.864522709617;6789.558678685869;6968.163820341591;7297.817554561178;7302.160251571137;7361.2638736125955;7362.411007119311;7364.374028207662;4572.542745725401;4585.770711464346;4592;4632.698874573142;4635.814567417266;6889.517733758589;6975.79072627822;7014.508984371045;7019;7044.964775176091;6807.115075040213;6813.488988325995;6824.590524568542;6827.317268273133;6832.487563432663;6791.45668346541;6793;6818.113645226089;6821.113255276782;6849.1096157499205;6518.380753828379;6686.598804071771;6717.529772915849;6727.293634168537;6795.116634837637;6890.724371025303;6899.379055884994;6911.032455456139;6916.308369163245;6984.161900571964;6618.271990080991;6628.370304821035;6683.532152749455;6699.899501507384;6700.631465269457 22:20:54 INFO - PROCESS | 8491 | |5;yui.html;714.4427346669597;802.8808080606844;807.8061265296327;812.4597142899972;822.6791551294995;12448.875511244885;12483.063770217224;12539.37303134843;12621.495140194393;12630.431630576622;12744.362781860917;13236.669083272898;13354.465821367157;13383.130096543742;13399.665008374795;809.6032943857497;811.4563242627454;831.966721331146;833.4374297349295;836.6444261189001;816.1063635319316;823.1357075071181;823.1644880446352;827.3381294964034;829.6391069884589;833.5748768128268;856.0668870930684;856.5802756649259;857.2028013947026;864.5893200729666;834.9833003339929;853.0744142605249;857.2884505860121;858.6093327535988;858.7209157023992;626.1671976271548;629.9149614802035;631.9968400158016;632.7310892870557;634.0710858592139;12376.07179461544;12397.070219733556;12399.070069744805;12401.875981240162;12488.937555312255;12644.178128421623;12697;12866.549670761571;12915;13102.80345794814;10538.683839484827;10685.519151638195;10868.239223254375;10973.561057557688;11006.614768483145;3651.9817400912825;3675.7978311192874;3741.5323084614424;3784.7729136251914;3791.298609757204;48050.759746201395;48200.51799482031;48282.27576586354;48660.5133948656;48790.26814597748;9006.144416280444;9006.234470070118;9062.456252624863;9416;9552.474613896302;17766.644667106844;17857.285708571773;17860.839045462002;17910.5522361942;17919.28322867071;7596.354309883612;7611.048618922635;7694.653740581687;7712.344450721639;7908.84182316362;4240.724352917051;4251.936220956688;4276.764777937244;4318.632916202095;4371.912561748811;3131.3580715953176;3133.482975309094;3143.9528407073913;3151.353972435645;3154.3060526684094;554.3901708121115;570.9457601527848;576.5790972590033;585.2508788750406;589.5342679283318;565.2849145830528;648.3840351665937;649.5821285697281;659.3176062775004;680.6868840333403;7476.738314158978;7514.361279291212;7572.848543029108;7749.341305988942;7774.2614451627005;617.0774691835645;660.643252643567;664.3655309179721;674.8899203848488;679.1171477079777;3608.9458658120147;3686.299603075407;3707.6663100321102;3867.57456679765;3919.353306704419;48170.759146204044;52488.212676809875;52668.473315267125;53178;53693.46306536963;43535.34696979548;43803.78098109553;44369.112617747465;44426.333604995954;44573.55426445694;43711.344329835076;44074.77962610166;44460.77769611131;45517.31724024142;45819.541804581524;7704.807379815549;7875.456044779758;7910.327622152182;8079.555624440477;8238.340932725248;32435.837820810746;33128.83435582807;33295.33409331751;33321.50017749687;34339.969800906016;40154.59845401509;41770.16459670729;41847.790761046;42033.36949945692;42290;11157.609483668357;11234.213605047567;11291.040261577858;11316.094712422822;11580.942095289807;11525;12080.51677932873;12255.379174696478;12287;12411.255324680547;10733.892661073289;10805.351678899291;10841.783164336826;10909.563617455531;10936.50785714629;11326.716832078935;11365.48855301497;11484.483198256266;11491.94254028758;11546;10625.096866766411;10639;10797.24419290642;10974.506147223554;11165.497552610315;9363.29775266844;9581.329306948446;9597.616095356108;10014.699559013241;10278.537465814206;8057.5165490070785;9059;9119.817603647758;9188.173064423967;9327.440353578535 22:20:54 INFO - PROCESS | 8491 | __end_tp_report 22:20:54 INFO - PROCESS | 8491 | __start_cc_report 22:20:54 INFO - PROCESS | 8491 | _x_x_mozilla_cycle_collect,307 22:20:54 INFO - PROCESS | 8491 | __end_cc_report 22:20:54 INFO - PROCESS | 8491 | __startTimestamp1455949254329__endTimestamp 22:20:54 INFO - PROCESS | 8491 | 22:20:54 INFO - PROCESS | 8491 | ------- Summary: start ------- 22:20:54 INFO - PROCESS | 8491 | Number of tests: 6 22:20:54 INFO - PROCESS | 8491 | 22:20:54 INFO - PROCESS | 8491 | [#0] dojo.html Cycles:165 Average:5243.89 Median:5399.06 stddev:569.68 (10.6%) stddev-sans-first:548.58 22:20:54 INFO - PROCESS | 8491 | Values: 3207.8 3221.2 3239.0 3269.7 3271.9 5119.3 5230.4 5247.5 5254.8 5260.3 5153.7 5216.3 5239.2 5244.1 5244.6 4748.7 4780.9 4879.6 4976.3 4980.6 4794.7 4866.8 4872.0 4888.1 4920.9 4732.6 4742.9 4757.1 4773.4 4797.6 4764.7 4766.1 4767.0 4779.8 4784.4 4744.1 4752.1 4753.4 4757.3 4760.4 5008.4 5034.6 5046.2 5053.7 5066.8 5516.9 5583.1 5593.2 5595.4 5597.1 5641.2 5676.5 5696.7 5749.5 5772.1 5283.2 5371.9 5376.0 5386.0 5392.9 5690.1 5816.8 5820.8 5821.0 5840.8 5597.3 5620.7 5648.1 5677.3 5708.5 5599.7 5637.9 5638.4 5646.9 5650.5 5494.9 5563.8 5604.7 5629.0 5667.4 5561.2 5567.4 5583.7 5587.7 5626.9 4339.7 4352.4 4357.1 4362.7 4419.4 3882.5 3909.5 3924.7 3927.0 3931.6 5275.9 5276.9 5281.1 5290.8 5328.4 5684.5 5717.9 5720.7 5723.9 5736.5 5273.7 5280.4 5335.5 5348.8 5376.6 4920.1 4922.1 4924.3 4925.7 4972.1 5709.0 5876.3 5976.7 5997.6 6021.5 5594.6 5623.4 5674.7 5682.5 5682.8 5844.8 5883.2 5894.4 5894.5 5921.2 5435.9 5585.6 5604.1 5657.5 5706.8 5505.7 5552.6 5575.2 5587.1 5595.9 5344.1 5410.1 5429.9 5437.5 5468.8 5451.5 5465.9 5471.5 5476.1 5517.2 5332.1 5399.1 5402.7 5422.7 5467.8 5490.3 5503.7 5534.4 5590.4 5679.3 5326.9 5363.5 5369.7 5385.6 5391.9 22:20:54 INFO - PROCESS | 8491 | 22:20:54 INFO - PROCESS | 8491 | [#1] ext.html Cycles:180 Average:44293.93 Median:37029.81 stddev:73270.17 (197.9%) stddev-sans-first:73401.87 22:20:54 INFO - PROCESS | 8491 | Values: 482.5 504.1 509.2 527.6 539.4 35624.8 35947.5 36068.3 36388.3 36413.6 38717.8 39369.0 39638.6 39660.8 39801.0 8457.5 8624.0 8640.3 8649.4 8660.0 8418.2 8617.1 8623.4 8636.2 8636.4 8609.4 8685.0 8701.6 8725.0 8727.1 8612.0 8632.7 8659.8 8679.8 8703.5 8515.4 8582.6 8646.7 8661.2 8692.0 36922.0 37403.3 37481.0 37584.6 37614.0 3330.3 3344.1 3715.0 3832.1 3939.7 29427.6 29771.1 30058.1 30543.2 30545.5 3760.5 3800.7 3828.6 3841.8 3966.7 264151.0 264236.0 264956.0 265543.0 267303.0 44347.3 44418.0 44714.6 57289.0 57375.4 42549.0 42617.4 42706.6 42772.0 42818.4 12862.3 12993.2 13068.7 13068.7 13075.8 10004.7 10008.3 10015.8 10048.6 10121.6 14230.3 14241.4 14280.4 14339.4 14425.1 5550.6 5657.3 5659.2 5775.0 5812.9 939.4 958.0 988.4 991.4 991.9 28315.1 28374.3 28425.4 28715.7 28832.7 1011.6 1028.9 1078.0 1092.0 1108.3 15971.9 16045.9 16199.5 16280.2 16362.8 279745.0 282665.0 284823.0 285029.0 286472.0 55845.4 55957.4 56129.7 56350.0 56457.0 1308.2 1315.5 1335.9 1351.8 1393.4 29402.6 30579.2 31023.1 31086.8 31108.0 46768.8 46962.8 47361.5 47672.3 47701.8 290367.0 292569.0 292826.0 293315.0 294178.0 32219.8 32454.0 32874.3 33127.2 33206.3 41458.2 41751.2 42000.2 42252.0 42357.6 35108.1 35508.6 35595.5 36578.8 36943.0 36049.3 37116.6 38472.0 38545.4 39079.4 34525.3 34629.7 38243.0 38905.0 38963.2 28751.0 30358.7 30772.4 31103.2 31272.7 24339.6 25007.6 25184.5 25740.5 25867.0 22:20:54 INFO - PROCESS | 8491 | 22:20:54 INFO - PROCESS | 8491 | [#2] jquery.html Cycles:180 Average:21294.38 Median:33319.50 stddev:50886.04 (152.7%) stddev-sans-first:51004.49 22:20:54 INFO - PROCESS | 8491 | Values: 349.7 353.2 353.9 355.5 357.5 16490.3 16953.7 17171.8 17969.9 17976.0 10844.7 11729.6 16171.1 16555.4 16558.9 4852.8 5473.4 5517.3 5529.9 5541.3 4918.8 5287.8 5434.5 5459.2 5473.2 4944.0 5163.9 5183.7 5440.9 5478.0 5128.1 5137.1 5161.6 5327.3 5893.1 5242.1 5249.9 5257.3 5266.4 5287.4 13160.0 18730.3 19173.0 19246.6 20165.8 2053.7 2098.1 2100.4 2213.6 2405.5 9511.4 9555.5 12140.3 12166.2 12224.8 1859.2 1865.6 1884.1 1885.8 1891.9 61979.7 62139.7 63485.0 63542.0 64279.4 9712.0 9908.8 10057.8 10143.7 10151.1 13086.7 13106.2 13112.6 13135.5 13167.5 6939.8 7178.4 7189.5 7237.8 7277.6 6685.6 6695.0 6728.2 6843.5 6985.1 4235.1 4283.2 4286.7 4345.8 4364.2 1635.7 1741.5 1750.1 1828.3 1842.5 448.4 452.8 882.6 959.5 1028.3 10548.1 10809.9 10961.6 10971.6 11033.9 447.6 470.6 471.3 845.0 889.3 8667.3 8840.0 8997.1 9472.5 10135.6 297291.0 299504.0 309563.0 311286.0 312021.0 68856.3 72523.0 73534.6 75868.2 77072.6 1021.1 1042.3 1042.9 1051.2 1057.7 15577.1 15624.5 15646.8 15653.2 16026.0 29859.9 32538.7 33089.7 33549.3 33845.0 46786.8 46916.0 47084.5 47415.0 47562.0 7738.2 7885.6 7887.3 7893.4 8023.8 10789.2 11797.2 11892.8 12024.6 12247.3 10093.5 10523.3 10532.3 10716.7 10750.2 10708.3 10790.0 10852.4 10987.3 11190.6 10794.8 10855.5 10876.7 11123.0 11304.3 7945.5 7950.8 7991.0 8016.4 8033.1 10201.8 11197.5 11198.8 11270.7 11408.1 22:20:54 INFO - PROCESS | 8491 | 22:20:54 INFO - PROCESS | 8491 | [#3] mootools.html Cycles:180 Average:5314.50 Median:6470.56 stddev:2778.62 (42.9%) stddev-sans-first:2770.95 22:20:54 INFO - PROCESS | 8491 | Values: 1414.4 1439.9 1578.9 1710.8 1725.0 7417.5 7546.2 7655.0 7656.7 7684.3 7487.3 7536.8 7564.8 7571.9 7614.2 2206.8 2230.3 2245.2 2245.3 2248.1 2229.5 2247.4 2249.2 2250.9 2264.9 2176.7 2195.7 2217.7 2269.6 2275.6 2157.6 2160.3 2178.3 2196.6 2201.5 2245.3 2250.9 2260.7 2269.5 2278.2 7108.8 7156.6 7156.9 7160.9 7179.2 4500.0 4560.6 4584.2 4617.3 4629.0 2911.2 2968.6 2983.7 2989.7 3005.6 932.8 945.4 954.6 965.0 1016.2 10271.8 10291.5 10432.4 10472.1 10509.1 4084.3 4119.6 4159.3 4196.7 4210.5 9133.6 9142.6 9176.4 9191.6 9229.0 4662.8 4677.0 4685.7 4718.2 4729.2 4082.2 4184.5 4189.6 4328.1 4353.2 3376.9 3405.0 3455.1 3473.8 3474.9 1009.9 1040.8 1043.1 1045.2 1047.9 1262.3 1272.9 1285.3 1327.8 1334.6 7005.0 7142.1 7160.7 7341.3 7350.0 479.6 483.6 491.2 496.5 498.3 5421.7 5424.2 5448.6 5488.9 5489.9 8920.5 8956.3 9023.5 9091.8 9108.6 8917.4 8985.2 8993.0 8993.5 9077.3 6673.1 6755.9 6792.6 7250.9 7295.0 7072.5 7098.5 7104.0 7117.2 7146.2 8047.8 8195.3 8281.2 8297.5 8385.9 8222.6 8572.1 8666.4 8686.3 8730.1 6565.7 6686.9 7019.1 7205.8 7208.5 7218.2 7230.5 7295.3 7301.0 7301.5 6419.0 6525.3 6571.3 6596.1 6777.5 6634.3 6638.2 6740.1 6779.3 6790.1 6761.4 6888.8 6906.3 6947.5 6953.2 6463.5 6469.8 6471.3 6482.2 6491.9 6408.2 6468.7 6474.2 6480.4 6491.5 22:20:54 INFO - PROCESS | 8491 | 22:20:54 INFO - PROCESS | 8491 | [#4] prototype.html Cycles:180 Average:5575.29 Median:6334.60 stddev:1729.75 (27.3%) stddev-sans-first:1689.02 22:20:54 INFO - PROCESS | 8491 | Values: 319.1 325.9 326.0 326.4 334.1 6343.9 6349.2 6355.7 6418.6 6540.2 6330.9 6338.3 6342.4 6393.6 6410.5 4762.4 4780.9 4786.7 4792.0 4792.1 4765.7 4775.9 4781.1 4782.7 4785.6 4625.7 4745.7 4755.7 4761.2 4763.7 4710.6 4725.2 4727.7 4729.2 4740.8 4066.4 4067.7 4069.0 4069.9 4084.5 6017.3 6019.2 6044.0 6044.8 6047.6 5403.2 5513.6 5526.2 5532.9 5540.1 6690.1 6723.4 6724.6 6733.7 6742.4 4487.6 4498.1 4501.2 4501.7 4502.0 6766.0 6938.7 6985.3 7013.0 7058.8 4560.8 4568.6 4580.6 4584.8 4598.3 4617.2 4635.7 4636.5 4640.8 4647.5 5466.8 5469.5 5472.0 5477.8 5496.1 6644.7 6789.0 6797.3 6821.5 6877.6 1526.0 1603.9 1614.0 1650.0 1653.9 1022.4 1024.7 1070.3 1070.7 1077.1 6200.6 6217.9 6228.4 6245.3 6251.1 6840.3 6849.6 6873.4 6875.1 6883.2 6133.5 6189.5 6191.1 6212.2 6225.8 3689.9 3694.0 3708.4 3729.2 3734.0 7093.9 7125.1 7128.5 7143.1 7150.5 6820.8 6973.2 7001.2 7035.2 7042.3 7086.1 7103.8 7108.3 7112.3 7119.1 6801.7 6828.4 6844.2 6857.9 6862.0 6714.4 6735.8 6773.9 6789.6 6968.2 7297.8 7302.2 7361.3 7362.4 7364.4 4572.5 4585.8 4592.0 4632.7 4635.8 6889.5 6975.8 7014.5 7019.0 7045.0 6807.1 6813.5 6824.6 6827.3 6832.5 6791.5 6793.0 6818.1 6821.1 6849.1 6518.4 6686.6 6717.5 6727.3 6795.1 6890.7 6899.4 6911.0 6916.3 6984.2 6618.3 6628.4 6683.5 6699.9 6700.6 22:20:54 INFO - PROCESS | 8491 | 22:20:54 INFO - PROCESS | 8491 | [#5] yui.html Cycles:180 Average:13146.20 Median:44221.95 stddev:14812.89 (33.5%) stddev-sans-first:14825.02 22:20:54 INFO - PROCESS | 8491 | Values: 714.4 802.9 807.8 812.5 822.7 12448.9 12483.1 12539.4 12621.5 12630.4 12744.4 13236.7 13354.5 13383.1 13399.7 809.6 811.5 832.0 833.4 836.6 816.1 823.1 823.2 827.3 829.6 833.6 856.1 856.6 857.2 864.6 835.0 853.1 857.3 858.6 858.7 626.2 629.9 632.0 632.7 634.1 12376.1 12397.1 12399.1 12401.9 12488.9 12644.2 12697.0 12866.5 12915.0 13102.8 10538.7 10685.5 10868.2 10973.6 11006.6 3652.0 3675.8 3741.5 3784.8 3791.3 48050.8 48200.5 48282.3 48660.5 48790.3 9006.1 9006.2 9062.5 9416.0 9552.5 17766.6 17857.3 17860.8 17910.6 17919.3 7596.4 7611.0 7694.7 7712.3 7908.8 4240.7 4251.9 4276.8 4318.6 4371.9 3131.4 3133.5 3144.0 3151.4 3154.3 554.4 570.9 576.6 585.3 589.5 565.3 648.4 649.6 659.3 680.7 7476.7 7514.4 7572.8 7749.3 7774.3 617.1 660.6 664.4 674.9 679.1 3608.9 3686.3 3707.7 3867.6 3919.4 48170.8 52488.2 52668.5 53178.0 53693.5 43535.3 43803.8 44369.1 44426.3 44573.6 43711.3 44074.8 44460.8 45517.3 45819.5 7704.8 7875.5 7910.3 8079.6 8238.3 32435.8 33128.8 33295.3 33321.5 34340.0 40154.6 41770.2 41847.8 42033.4 42290.0 11157.6 11234.2 11291.0 11316.1 11580.9 11525.0 12080.5 12255.4 12287.0 12411.3 10733.9 10805.4 10841.8 10909.6 10936.5 11326.7 11365.5 11484.5 11491.9 11546.0 10625.1 10639.0 10797.2 10974.5 11165.5 9363.3 9581.3 9597.6 10014.7 10278.5 8057.5 9059.0 9119.8 9188.2 9327.4 22:20:54 INFO - PROCESS | 8491 | -------- Summary: end -------- 22:20:54 INFO - PROCESS | 8491 | 22:20:54 INFO - TEST-INFO | 8491: exit 0 22:20:55 INFO - TEST-OK | dromaeo_css | took 1111547ms 22:20:55 INFO - TEST-START | kraken 22:20:55 INFO - operating with platform_type : linux_ 22:20:55 INFO - Initialising browser for kraken test... 22:20:55 INFO - TEST-INFO | started process 8731 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8GkhUF/profile http://localhost:60376/getInfo.html) 22:20:59 INFO - PROCESS | 8731 | 22:20:59 INFO - PROCESS | 8731 | (process:8799): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:21:00 INFO - PROCESS | 8731 | __metrics Screen width/height:1600/1200 22:21:00 INFO - PROCESS | 8731 | colorDepth:24 22:21:00 INFO - PROCESS | 8731 | Browser inner width/height: 1024/697 22:21:00 INFO - PROCESS | 8731 | __metrics 22:21:00 ERROR - PROCESS | 8731 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2871: TypeError: this.tabs is undefined 22:21:01 INFO - TEST-INFO | 8731: exit 0 22:21:01 INFO - Browser initialized. 22:21:01 INFO - Running cycle 1/1 for kraken test... 22:21:01 INFO - TEST-INFO | started process 8850 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8GkhUF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:21:03 INFO - PROCESS | 8850 | 22:21:03 INFO - PROCESS | 8850 | (process:8909): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:21:13 INFO - PROCESS | 8850 | RSS: Main: 155648000 22:21:13 INFO - PROCESS | 8850 | 22:21:16 INFO - PROCESS | 8850 | Cycle 1(1): loaded http://localhost:60376/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60376/tests/kraken/driver.html?testName=audio-beat-detection) 22:21:16 INFO - PROCESS | 8850 | RSS: Main: 162807808 22:21:16 INFO - PROCESS | 8850 | 22:21:19 INFO - PROCESS | 8850 | Cycle 1(1): loaded http://localhost:60376/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60376/tests/kraken/driver.html?testName=audio-dft) 22:21:19 INFO - PROCESS | 8850 | RSS: Main: 165736448 22:21:19 INFO - PROCESS | 8850 | 22:21:22 INFO - PROCESS | 8850 | Cycle 1(1): loaded http://localhost:60376/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60376/tests/kraken/driver.html?testName=audio-fft) 22:21:23 INFO - PROCESS | 8850 | RSS: Main: 158691328 22:21:23 INFO - PROCESS | 8850 | 22:21:25 INFO - PROCESS | 8850 | Cycle 1(1): loaded http://localhost:60376/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60376/tests/kraken/driver.html?testName=audio-oscillator) 22:21:26 INFO - PROCESS | 8850 | RSS: Main: 159363072 22:21:26 INFO - PROCESS | 8850 | 22:21:28 INFO - PROCESS | 8850 | Cycle 1(1): loaded http://localhost:60376/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60376/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:21:29 INFO - PROCESS | 8850 | RSS: Main: 159268864 22:21:29 INFO - PROCESS | 8850 | 22:21:32 INFO - PROCESS | 8850 | Cycle 1(1): loaded http://localhost:60376/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60376/tests/kraken/driver.html?testName=imaging-darkroom) 22:21:32 INFO - PROCESS | 8850 | RSS: Main: 160964608 22:21:32 INFO - PROCESS | 8850 | 22:21:36 INFO - PROCESS | 8850 | Cycle 1(1): loaded http://localhost:60376/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60376/tests/kraken/driver.html?testName=imaging-desaturate) 22:21:36 INFO - PROCESS | 8850 | RSS: Main: 160804864 22:21:36 INFO - PROCESS | 8850 | 22:21:39 INFO - PROCESS | 8850 | Cycle 1(1): loaded http://localhost:60376/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60376/tests/kraken/driver.html?testName=json-parse-financial) 22:21:40 INFO - PROCESS | 8850 | RSS: Main: 160972800 22:21:40 INFO - PROCESS | 8850 | 22:21:41 INFO - PROCESS | 8850 | Cycle 1(1): loaded http://localhost:60376/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60376/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:21:42 INFO - PROCESS | 8850 | RSS: Main: 160776192 22:21:42 INFO - PROCESS | 8850 | 22:21:44 INFO - PROCESS | 8850 | Cycle 1(1): loaded http://localhost:60376/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60376/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:21:44 INFO - PROCESS | 8850 | RSS: Main: 161697792 22:21:44 INFO - PROCESS | 8850 | 22:21:46 INFO - PROCESS | 8850 | Cycle 1(1): loaded http://localhost:60376/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60376/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:21:47 INFO - PROCESS | 8850 | RSS: Main: 160464896 22:21:47 INFO - PROCESS | 8850 | 22:21:49 INFO - PROCESS | 8850 | Cycle 1(1): loaded http://localhost:60376/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60376/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:21:50 INFO - PROCESS | 8850 | RSS: Main: 161325056 22:21:50 INFO - PROCESS | 8850 | 22:21:53 INFO - PROCESS | 8850 | Cycle 1(1): loaded http://localhost:60376/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60376/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:21:53 INFO - PROCESS | 8850 | RSS: Main: 161873920 22:21:53 INFO - PROCESS | 8850 | 22:21:55 INFO - PROCESS | 8850 | Cycle 1(1): loaded http://localhost:60376/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60376/tests/kraken/driver.html?testName=ai-astar) 22:21:55 INFO - PROCESS | 8850 | RSS: Main: 163024896 22:21:55 INFO - PROCESS | 8850 | 22:21:55 INFO - PROCESS | 8850 | __start_tp_report 22:21:55 INFO - PROCESS | 8850 | _x_x_mozilla_page_load 22:21:55 INFO - PROCESS | 8850 | _x_x_mozilla_page_load_details 22:21:55 INFO - PROCESS | 8850 | |i|pagename|runs| 22:21:55 INFO - PROCESS | 8850 | |0;ai-astar;112;111;114;116;113;124;113;113;112;113 22:21:55 INFO - PROCESS | 8850 | |1;audio-beat-detection;161;143;155;170;135;161;154;128;166;130 22:21:55 INFO - PROCESS | 8850 | |2;audio-dft;164;165;165;165;176;165;169;172;166;165 22:21:55 INFO - PROCESS | 8850 | |3;audio-fft;75;73;75;74;74;152;74;73;73;75 22:21:55 INFO - PROCESS | 8850 | |4;audio-oscillator;97;97;143;97;96;98;142;96;104;145 22:21:55 INFO - PROCESS | 8850 | |5;imaging-gaussian-blur;119;115;117;116;115;115;116;117;116;116 22:21:55 INFO - PROCESS | 8850 | |6;imaging-darkroom;147;146;146;146;148;147;146;147;151;147 22:21:55 INFO - PROCESS | 8850 | |7;imaging-desaturate;97;97;97;99;97;97;97;97;96;97 22:21:55 INFO - PROCESS | 8850 | |8;json-parse-financial;61;58;61;59;59;58;59;69;57;56 22:21:55 INFO - PROCESS | 8850 | |9;json-stringify-tinderbox;68;68;67;67;68;68;68;68;68;72 22:21:55 INFO - PROCESS | 8850 | |10;stanford-crypto-aes;86;91;84;84;87;83;84;84;85;84 22:21:55 INFO - PROCESS | 8850 | |11;stanford-crypto-ccm;124;116;121;129;135;127;119;123;137;117 22:21:55 INFO - PROCESS | 8850 | |12;stanford-crypto-pbkdf2;144;157;150;150;142;144;152;144;148;144 22:21:55 INFO - PROCESS | 8850 | |13;stanford-crypto-sha256-iterative;68;73;71;69;68;67;70;70;69;72 22:21:55 INFO - PROCESS | 8850 | __end_tp_report 22:21:55 INFO - PROCESS | 8850 | __start_cc_report 22:21:55 INFO - PROCESS | 8850 | _x_x_mozilla_cycle_collect,741 22:21:55 INFO - PROCESS | 8850 | __end_cc_report 22:21:55 INFO - PROCESS | 8850 | __startTimestamp1455949315581__endTimestamp 22:21:55 INFO - PROCESS | 8850 | 22:21:55 INFO - PROCESS | 8850 | ------- Summary: start ------- 22:21:55 INFO - PROCESS | 8850 | Number of tests: 14 22:21:55 INFO - PROCESS | 8850 | 22:21:55 INFO - PROCESS | 8850 | [#0] ai-astar Cycles:10 Average:114.10 Median:113.00 stddev:3.73 (3.3%) stddev-sans-first:3.87 22:21:55 INFO - PROCESS | 8850 | Values: 112.0 111.0 114.0 116.0 113.0 124.0 113.0 113.0 112.0 113.0 22:21:55 INFO - PROCESS | 8850 | 22:21:55 INFO - PROCESS | 8850 | [#1] audio-beat-detection Cycles:10 Average:150.30 Median:158.00 stddev:15.26 (9.7%) stddev-sans-first:15.69 22:21:55 INFO - PROCESS | 8850 | Values: 161.0 143.0 155.0 170.0 135.0 161.0 154.0 128.0 166.0 130.0 22:21:55 INFO - PROCESS | 8850 | 22:21:55 INFO - PROCESS | 8850 | [#2] audio-dft Cycles:10 Average:167.20 Median:165.50 stddev:3.94 (2.4%) stddev-sans-first:4.00 22:21:55 INFO - PROCESS | 8850 | Values: 164.0 165.0 165.0 165.0 176.0 165.0 169.0 172.0 166.0 165.0 22:21:55 INFO - PROCESS | 8850 | 22:21:55 INFO - PROCESS | 8850 | [#3] audio-fft Cycles:10 Average:81.80 Median:74.00 stddev:24.68 (33.4%) stddev-sans-first:26.05 22:21:55 INFO - PROCESS | 8850 | Values: 75.0 73.0 75.0 74.0 74.0 152.0 74.0 73.0 73.0 75.0 22:21:55 INFO - PROCESS | 8850 | 22:21:55 INFO - PROCESS | 8850 | [#4] audio-oscillator Cycles:10 Average:111.50 Median:96.50 stddev:22.10 (22.9%) stddev-sans-first:22.81 22:21:55 INFO - PROCESS | 8850 | Values: 97.0 97.0 143.0 97.0 96.0 98.0 142.0 96.0 104.0 145.0 22:21:55 INFO - PROCESS | 8850 | 22:21:55 INFO - PROCESS | 8850 | [#5] imaging-gaussian-blur Cycles:10 Average:116.20 Median:116.00 stddev:1.23 (1.1%) stddev-sans-first:0.78 22:21:55 INFO - PROCESS | 8850 | Values: 119.0 115.0 117.0 116.0 115.0 115.0 116.0 117.0 116.0 116.0 22:21:55 INFO - PROCESS | 8850 | 22:21:55 INFO - PROCESS | 8850 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:1.52 (1.0%) stddev-sans-first:1.62 22:21:55 INFO - PROCESS | 8850 | Values: 147.0 146.0 146.0 146.0 148.0 147.0 146.0 147.0 151.0 147.0 22:21:55 INFO - PROCESS | 8850 | 22:21:55 INFO - PROCESS | 8850 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:97.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 22:21:55 INFO - PROCESS | 8850 | Values: 97.0 97.0 97.0 99.0 97.0 97.0 97.0 97.0 96.0 97.0 22:21:55 INFO - PROCESS | 8850 | 22:21:55 INFO - PROCESS | 8850 | [#8] json-parse-financial Cycles:10 Average:59.70 Median:59.00 stddev:3.62 (6.1%) stddev-sans-first:3.81 22:21:55 INFO - PROCESS | 8850 | Values: 61.0 58.0 61.0 59.0 59.0 58.0 59.0 69.0 57.0 56.0 22:21:55 INFO - PROCESS | 8850 | 22:21:55 INFO - PROCESS | 8850 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:1.40 (2.1%) stddev-sans-first:1.48 22:21:55 INFO - PROCESS | 8850 | Values: 68.0 68.0 67.0 67.0 68.0 68.0 68.0 68.0 68.0 72.0 22:21:55 INFO - PROCESS | 8850 | 22:21:55 INFO - PROCESS | 8850 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:84.50 stddev:2.35 (2.8%) stddev-sans-first:2.47 22:21:55 INFO - PROCESS | 8850 | Values: 86.0 91.0 84.0 84.0 87.0 83.0 84.0 84.0 85.0 84.0 22:21:55 INFO - PROCESS | 8850 | 22:21:55 INFO - PROCESS | 8850 | [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:125.50 stddev:7.19 (5.7%) stddev-sans-first:7.62 22:21:55 INFO - PROCESS | 8850 | Values: 124.0 116.0 121.0 129.0 135.0 127.0 119.0 123.0 137.0 117.0 22:21:55 INFO - PROCESS | 8850 | 22:21:55 INFO - PROCESS | 8850 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.50 Median:149.00 stddev:4.74 (3.2%) stddev-sans-first:4.86 22:21:55 INFO - PROCESS | 8850 | Values: 144.0 157.0 150.0 150.0 142.0 144.0 152.0 144.0 148.0 144.0 22:21:55 INFO - PROCESS | 8850 | 22:21:55 INFO - PROCESS | 8850 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:1.89 (2.7%) stddev-sans-first:1.90 22:21:55 INFO - PROCESS | 8850 | Values: 68.0 73.0 71.0 69.0 68.0 67.0 70.0 70.0 69.0 72.0 22:21:55 INFO - PROCESS | 8850 | -------- Summary: end -------- 22:21:55 INFO - PROCESS | 8850 | 22:21:56 INFO - TEST-INFO | 8850: exit 0 22:21:56 INFO - TEST-OK | kraken | took 61519ms 22:21:56 INFO - SUITE-END | took 1173s 22:21:56 INFO - Completed test suite (00:19:33) 22:21:56 INFO - Working with test: dromaeo_css 22:21:56 INFO - Generating results file: dromaeo_css 22:21:56 INFO - Working with test: kraken 22:21:56 INFO - Generating results file: kraken 22:21:56 INFO - javascript benchmark 22:21:56 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:21:56 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 22:21:56 INFO - process_Request line: dromaeo_css 6774.24 graph.html#tests=[[72,1,43]] 22:21:56 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:21:56 INFO - process_Request line: kraken 1540.40 graph.html#tests=[[232,1,43]] 22:21:56 INFO - RETURN: dromaeo_css: 6774.24 22:21:56 INFO - RETURN: kraken: 1540.40 22:21:56 INFO - javascript benchmark 22:21:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3207.7754557180997, 3221.162497750584, 3238.9838050809744, 3269.722073623742, 3271.9018429447124, 5119.334486516747, 5230.372355317362, 5247.527722504974, 5254.789808407669, 5260.263563101164, 5153.69077855328, 5216.295800067, 5239.187925871496, 5244.082285600024, 5244.554212891909, 4748.715077095377, 4780.928286075712, 4879.560839524442, 4976.303317535548, 4980.551750342468, 4794.712317260958, 4866.78099485524, 4872.0, 4888.071266459379, 4920.926186107194, 4732.574068333849, 4742.928856067145, 4757.0723708876785, 4773.403324584427, 4797.640176986705, 4764.737939413331, 4766.070616229837, 4767.0, 4779.784909679072, 4784.42586889572, 4744.098621261949, 4752.120857641347, 4753.382060332169, 4757.310190022462, 4760.404949381327, 5008.398992120932, 5034.597232221414, 5046.167382381903, 5053.671511351788, 5066.797328106872, 5516.862078448071, 5583.078791999355, 5593.2449119368775, 5595.38450770415, 5597.132444471114, 5641.153826925953, 5676.517496012844, 5696.6866822324755, 5749.540036797046, 5772.105323674838, 5283.207518872162, 5371.919421208685, 5376.0, 5385.973070134663, 5392.865178370572, 5690.0895856663565, 5816.82549523515, 5820.796272130455, 5821.0, 5840.766369345263, 5597.328320601554, 5620.747066382022, 5648.124540696199, 5677.347105082886, 5708.543316534668, 5599.7480113394995, 5637.943620563824, 5638.407967163389, 5646.943530564642, 5650.519705825051, 5494.862628434241, 5563.805266815642, 5604.6917419542315, 5628.971855140698, 5667.4332566743, 5561.165825126263, 5567.359753628384, 5583.748731307101, 5587.664740115606, 5626.915596266059, 4339.7396156230725, 4352.368906508538, 4357.128574285156, 4362.738235705804, 4419.42547468827, 3882.456456096149, 3909.4722212501515, 3924.6860251179837, 3926.980365098156, 3931.6264954829244, 5275.920861187085, 5276.894462110737, 5281.0758117329315, 5290.805823557178, 5328.36059672834, 5684.459976302244, 5717.885642287214, 5720.685362305113, 5723.8855222896145, 5736.4550367715, 5273.683578985273, 5280.3663560373, 5335.466453354711, 5348.839534813962, 5376.569874410038, 4920.089783390084, 4922.08941345845, 4924.261360795837, 4925.704457732548, 4972.0801651694555, 5709.029464990961, 5876.294844618673, 5976.701164941823, 5997.580169388101, 6021.548383871227, 5594.608377413542, 5623.437656234508, 5674.74463649145, 5682.460166284279, 5682.829515114553, 5844.795432159854, 5883.2057672213705, 5894.410558944071, 5894.498967587631, 5921.17103605487, 5435.918461223006, 5585.5531557476115, 5604.075327571069, 5657.519110875622, 5706.828795136153, 5505.6696598204235, 5552.639078459887, 5575.163725441216, 5587.0502014656795, 5595.916061259003, 5344.064788662046, 5410.053240682943, 5429.864253393696, 5437.5378092860965, 5468.781248750005, 5451.48210919962, 5465.945340546544, 5471.50756431923, 5476.0690682584855, 5517.172424136412, 5332.06688829461, 5399.05516534597, 5402.6758394496455, 5422.701751403552, 5467.753951072132, 5490.341159060778, 5503.724813759376, 5534.363548192009, 5590.440955904377, 5679.290088738908, 5326.866828329168, 5363.490468405495, 5369.677819330853, 5385.6230063895155, 5391.892162156813], "unit": "score", "name": "dojo.html", "value": 5208.229391890851}, {"lowerIsBetter": false, "replicates": [482.5102520941243, 504.12534253070936, 509.1573445946958, 527.5726661404261, 539.4012645962982, 35624.821875890615, 35947.46078808814, 36068.27863442736, 36388.27223455529, 36413.63586364136, 38717.806410967976, 39369.0, 39638.60361396385, 39660.801695991555, 39801.0, 8457.450265732723, 8623.95688021559, 8640.308775297992, 8649.437786543855, 8659.95670021649, 8418.158184181593, 8617.138286171365, 8623.353248506388, 8636.222739953402, 8636.438631488965, 8609.39734218605, 8684.956575217115, 8701.60842762074, 8725.040245572982, 8727.0836562161, 8612.0, 8632.697855575056, 8659.826803463928, 8679.826403471958, 8703.52130632815, 8515.403921725481, 8582.613782379807, 8646.654133834701, 8661.220490155853, 8692.043875173726, 36922.0, 37403.25193496142, 37481.0, 37584.62415375866, 37614.0, 3330.333933213343, 3344.0803778960735, 3714.9814250928844, 3832.080300727833, 3939.7045221608496, 29427.558586621217, 29771.10686679403, 30058.098257052323, 30543.2364190897, 30545.541816872767, 3760.492333534965, 3800.657940785343, 3828.617138286177, 3841.750286231386, 3966.702497312684, 264151.0, 264236.0, 264955.9999999981, 265543.0, 267303.0, 44347.33478997817, 44418.0, 44714.55285447169, 57289.0, 57375.42624573784, 42549.0, 42617.360739588934, 42706.57293427088, 42772.0, 42818.35772463415, 12862.292573908338, 12993.155444896052, 13068.673283167807, 13068.738625227443, 13075.803862942064, 10004.749881252881, 10008.299419040597, 10015.799684006424, 10048.648297309559, 10121.59513619447, 14230.28848557568, 14241.359138838778, 14280.42878284857, 14339.426422943174, 14425.134491930517, 5550.58370622205, 5657.264555607745, 5659.151127330851, 5775.047117225611, 5812.854678633068, 939.3518472254123, 958.0, 988.3526290279734, 991.3754334769194, 991.9156871665845, 28315.07853195749, 28374.290642733686, 28425.43149137006, 28715.712842871722, 28832.711672883004, 1011.6408674920444, 1028.8713910761155, 1078.0297732041226, 1092.011729384908, 1108.3460758152567, 15971.920140399223, 16045.919770401073, 16199.514014579581, 16280.185990700418, 16362.836371636131, 279745.0, 282665.0, 284823.0, 285029.0, 286472.0, 55845.441545584836, 55957.440425595225, 56129.71935140298, 56350.0, 56457.0, 1308.169312486559, 1315.4803852478408, 1335.8664133586562, 1351.8107464954915, 1393.3590548347875, 29402.558961615166, 30579.185294337844, 31023.0693079208, 31086.844565777028, 31108.0, 46768.766156169004, 46962.76518617385, 47361.52638473709, 47672.2849157256, 47701.76149119371, 290367.0, 292569.0, 292826.0, 293315.0, 294178.0, 32219.838900805345, 32454.0, 32874.342513149124, 33127.17182070467, 33206.335873282886, 41458.170836583704, 41751.1649767009, 42000.1599968005, 42252.0, 42357.57642423536, 35108.12229694278, 35508.64491355053, 35595.466068008485, 36578.8171059143, 36943.0, 36049.27901442009, 37116.628833711315, 38472.0, 38545.421818672185, 39079.41380879232, 34525.309493810484, 34629.65370346365, 38243.0, 38905.0, 38963.220735585695, 28751.0, 30358.696413036472, 30772.38455230838, 31103.22241943879, 31272.687273126976, 24339.634905476785, 25007.624885626366, 25184.49631007333, 25740.485190296462, 25867.0], "unit": "score", "name": "ext.html", "value": 17647.44906354743}, {"lowerIsBetter": false, "replicates": [349.6957646847243, 353.20352604876, 353.8779121203184, 355.5360254867397, 357.46380429355963, 16490.340386384545, 16953.660926781457, 17171.82828171718, 17969.91015044926, 17976.011319377445, 10844.6746597602, 11729.648110556676, 16171.110588917605, 16555.420560280392, 16558.917205413956, 4852.805887764485, 5473.397926228132, 5517.2551705519845, 5529.861753456175, 5541.33503979523, 4918.754062296871, 5287.814926477574, 5434.456554344553, 5459.153831156177, 5473.233747275384, 4943.9752801235945, 5163.922541161867, 5183.688978661293, 5440.891182176354, 5478.0, 5128.076946149691, 5137.101007323703, 5161.561267292266, 5327.30745003151, 5893.116032595102, 5242.1088414969545, 5249.947500524984, 5257.290265814105, 5266.447023062561, 5287.391949925769, 13160.0, 18730.250789968384, 19173.0, 19246.61506769871, 20165.781764005947, 2053.650879350514, 2098.0558748563053, 2100.390886642872, 2213.6347502662043, 2405.458771776354, 9511.429314241168, 9555.474448905308, 12140.3322817245, 12166.209196402295, 12224.838640329155, 1859.237712537853, 1865.5615930256379, 1884.0579710144928, 1885.792562818089, 1891.943241702751, 61979.690101549655, 62139.689301553655, 63485.0, 63542.0, 64279.357206427805, 9712.0, 9908.80182396348, 10057.798844023078, 10143.695689129338, 10151.086402223687, 13086.672833179247, 13106.2136271824, 13112.606621801362, 13135.474581016844, 13167.539136130381, 6939.791806245821, 7178.353948144692, 7189.532680375759, 7237.782866514013, 7277.59973201479, 6685.598864068074, 6695.0, 6728.226253980757, 6843.452523798084, 6985.126859142607, 4235.110626768352, 4283.186194623074, 4286.699931004862, 4345.8261669533495, 4364.236258654722, 1635.705572996872, 1741.5210817025165, 1750.1161913233736, 1828.277830257041, 1842.474894655017, 448.44169009583277, 452.7985046654273, 882.5807741322949, 959.4531117263233, 1028.341861208827, 10548.103411209979, 10809.891901081046, 10961.561537538568, 10971.615993440191, 11033.889661103447, 447.57256819737074, 470.55297467406103, 471.29541335703345, 844.9704260350858, 889.2663552569156, 8667.349948753868, 8839.955800220958, 8997.145271199226, 9472.479013654316, 10135.594576217016, 297291.0, 299504.0, 309563.0, 311286.0, 312021.0, 68856.311436886, 72523.0, 73534.6323268391, 75868.24131758722, 77072.61463692646, 1021.0555236406294, 1042.3276986343765, 1042.937423754562, 1051.2115913065202, 1057.7091299892438, 15577.065376077018, 15624.531264062096, 15646.843531564995, 15653.217339133225, 16026.0, 29859.850700747225, 32538.674613254512, 33089.66910330962, 33549.32901342008, 33845.0, 46786.76606616945, 46916.0, 47084.52915470801, 47415.0, 47562.0, 7738.187490313436, 7885.605719713876, 7887.250711182429, 7893.407994400328, 8023.839523209386, 10789.190810689386, 11797.17419780607, 11892.762144756884, 12024.639260822189, 12247.326397048248, 10093.495325233856, 10523.263371563917, 10532.315399499008, 10716.678499645022, 10750.247482676137, 10708.30396024256, 10790.028897399272, 10852.403117828595, 10987.340759554452, 11190.644017989334, 10794.784104318027, 10855.511501982272, 10876.728081798019, 11123.0, 11304.321740695585, 7945.48354356965, 7950.761477155695, 7991.0, 8016.4388492807275, 8033.0761962372735, 10201.846972295272, 11197.496112675111, 11198.832017519906, 11270.661880143609, 11408.087353011904], "unit": "score", "name": "jquery.html", "value": 7948.697714236036}, {"lowerIsBetter": false, "replicates": [1414.3564678071475, 1439.9424023039076, 1578.8500092491217, 1710.7519409685597, 1725.0426013562467, 7417.480776345658, 7546.2076481969425, 7654.961725191373, 7656.655450504727, 7684.308412242897, 7487.25127487251, 7536.84926301475, 7564.810879727996, 7571.924280757191, 7614.238576142383, 2206.7572567017655, 2230.2640128757553, 2245.247841972941, 2245.2815099168274, 2248.1344682297354, 2229.498362868358, 2247.359502541776, 2249.1790496468834, 2250.9437264068365, 2264.920727774528, 2176.7387913450407, 2195.692603035576, 2217.689523466716, 2269.602819506588, 2275.6472746724285, 2157.5577006713665, 2160.3302976077466, 2178.3464960511783, 2196.6485362342028, 2201.5376770878215, 2245.326402079386, 2250.8762018089, 2260.6609008648834, 2269.512054908186, 2278.2026290798253, 7108.751193708247, 7156.570605763619, 7156.892646610305, 7160.928390716131, 7179.210286868492, 4500.0, 4560.612347950429, 4584.15193189261, 4617.284320930227, 4628.95371046292, 2911.1557648281973, 2968.5992391027366, 2983.701629837021, 2989.7458716009164, 3005.594244776949, 932.8181004704086, 945.3618807305041, 954.6467806911418, 965.0446058402201, 1016.1667432705111, 10271.845922311171, 10291.53688084038, 10432.374057556572, 10472.057514823702, 10509.106725928305, 4084.326086195744, 4119.567445418188, 4159.251334759772, 4196.706230563892, 4210.45264115663, 9133.588988495534, 9142.588583513758, 9176.44941303524, 9191.632334706537, 9228.95385523068, 4662.813487460464, 4676.953230467651, 4685.742284174335, 4718.174319494075, 4729.172394830891, 4082.2039702258367, 4184.518780340239, 4189.622933935961, 4328.069465065026, 4353.151135528541, 3376.915577110543, 3404.982975085158, 3455.06713187438, 3473.774204676688, 3474.861005559749, 1009.9040591143829, 1040.8022475729588, 1043.1289872956015, 1045.17953406577, 1047.9476026198813, 1262.2741923394085, 1272.9045321600731, 1285.3123578885438, 1327.7610030194464, 1334.5796074236584, 7005.0, 7142.107236595426, 7160.749373771893, 7341.265873412723, 7350.007748953823, 479.5875547029552, 483.5744544800553, 491.2385802006875, 496.53573908395043, 498.3372115086926, 5421.701806400686, 5424.186372044225, 5448.591355648342, 5488.862778430571, 5489.862753431116, 8920.509371984474, 8956.283497320199, 9023.548822558845, 9091.772705682279, 9108.590113444778, 8917.375783695079, 8985.191332780081, 8993.0, 8993.505357205417, 9077.273818094536, 6673.132492775908, 6755.864882702417, 6792.592444453348, 7250.891236631454, 7294.963525182447, 7072.504924655431, 7098.467614928798, 7104.0, 7117.181524124585, 7146.249643787328, 8047.839043218985, 8195.262426381654, 8281.21328473794, 8297.543635100128, 8385.874211886705, 8222.588870556569, 8572.099929507312, 8666.35002374837, 8686.261667758312, 8730.126987301219, 6565.671716414065, 6686.933130668631, 7019.122609673791, 7205.819854503679, 7208.531445456028, 7218.205997340184, 7230.493865429369, 7295.270472952874, 7301.0, 7301.488895777245, 6418.967905160444, 6525.3148419417175, 6571.34286571339, 6596.142501474969, 6777.525573210025, 6634.270230274762, 6638.17022872141, 6740.090087838079, 6779.322067793181, 6790.083338749206, 6761.425278851156, 6888.793336199922, 6906.274841141608, 6947.513674042971, 6953.20038195614, 6463.482921366373, 6469.805905822833, 6471.320511346429, 6482.157319548429, 6491.870162596816, 6408.198975128109, 6468.676566171578, 6474.1907261592305, 6480.416762491398, 6491.545591808528], "unit": "score", "name": "mootools.html", "value": 4291.861558483105}, {"lowerIsBetter": false, "replicates": [319.1080928803993, 325.92992506611074, 325.9722923551498, 326.43363763869695, 334.0796106725971, 6343.936560634393, 6349.206349206349, 6355.745770169194, 6418.614883107011, 6540.182477190351, 6330.905036424458, 6338.30278669346, 6342.365763423667, 6393.552451328409, 6410.455111315544, 4762.404699412574, 4780.90438191236, 4786.688865223749, 4792.0, 4792.131068883138, 4765.666403351766, 4775.856724298276, 4781.091592597413, 4782.713037217761, 4785.641076919228, 4625.745583992879, 4745.738984355859, 4755.667103302771, 4761.190597598416, 4763.737994410306, 4710.62315014798, 4725.196716558194, 4727.739974301429, 4729.196036673757, 4740.810367585293, 4066.430699702044, 4067.6949228807957, 4069.04377471294, 4069.9186016279805, 4084.4690190275073, 6017.308009578911, 6019.187409699678, 6043.969780151071, 6044.848878778022, 6047.639281161747, 5403.162509810985, 5513.558915286768, 5526.226328314039, 5532.861678458071, 5540.113581826889, 6690.063391125246, 6723.428508576777, 6724.562903411263, 6733.663316834188, 6742.359475849787, 4487.551244875519, 4498.077894031749, 4501.234790085693, 4501.729896206238, 4501.987052913101, 6766.0, 6938.722451101949, 6985.266547012592, 7012.964935175291, 7058.823529411755, 4560.794764235618, 4568.611668008257, 4580.610648094949, 4584.7936842842155, 4598.26427771555, 4617.191991401559, 4635.725175576744, 4636.4899861015265, 4640.83757068501, 4647.512011238839, 5466.753996070186, 5469.453054694499, 5471.972640136853, 5477.835664930059, 5496.148097044965, 6644.66776661165, 6788.966055169792, 6797.286284940109, 6821.488388370892, 6877.6217308048535, 1525.9923700381428, 1603.9117848518445, 1614.0315810513598, 1650.026484374225, 1653.9421120260733, 1022.3763504262394, 1024.6618615856748, 1070.341739829999, 1070.71626019105, 1077.1113831089383, 6200.627962322275, 6217.875642487215, 6228.408301211378, 6245.344238854946, 6251.093591429309, 6840.31596840312, 6849.623270720158, 6873.381395674413, 6875.106236189364, 6883.174019117638, 6133.509319254449, 6189.535784816067, 6191.102290167901, 6212.192414986113, 6225.8132256032395, 3689.94465083024, 3693.963060369416, 3708.4066549351974, 3729.21686445844, 3734.029152420336, 7093.92906070943, 7125.144982602017, 7128.465365097639, 7143.1428228612895, 7150.463715221275, 6820.795376138624, 6973.198082220508, 7001.229864714877, 7035.190953040364, 7042.260562640951, 7086.114235720535, 7103.82240443993, 7108.253633368422, 7112.28877112295, 7119.1457025157315, 6801.659917004031, 6828.351306625863, 6844.21291551458, 6857.931420685929, 6862.0, 6714.429273511806, 6735.797926062226, 6773.864522709617, 6789.558678685869, 6968.163820341591, 7297.817554561178, 7302.160251571137, 7361.2638736125955, 7362.411007119311, 7364.374028207662, 4572.542745725401, 4585.770711464346, 4592.0, 4632.698874573142, 4635.814567417266, 6889.517733758589, 6975.79072627822, 7014.508984371045, 7019.0, 7044.964775176091, 6807.115075040213, 6813.488988325995, 6824.590524568542, 6827.317268273133, 6832.487563432663, 6791.45668346541, 6793.0, 6818.113645226089, 6821.113255276782, 6849.1096157499205, 6518.380753828379, 6686.598804071771, 6717.529772915849, 6727.293634168537, 6795.116634837637, 6890.724371025303, 6899.379055884994, 6911.032455456139, 6916.308369163245, 6984.161900571964, 6618.271990080991, 6628.370304821035, 6683.532152749455, 6699.899501507384, 6700.631465269457], "unit": "score", "name": "prototype.html", "value": 4996.027423149318}, {"lowerIsBetter": false, "replicates": [714.4427346669597, 802.8808080606844, 807.8061265296327, 812.4597142899972, 822.6791551294995, 12448.875511244885, 12483.063770217224, 12539.37303134843, 12621.495140194393, 12630.431630576622, 12744.362781860917, 13236.669083272898, 13354.465821367157, 13383.130096543742, 13399.665008374795, 809.6032943857497, 811.4563242627454, 831.966721331146, 833.4374297349295, 836.6444261189001, 816.1063635319316, 823.1357075071181, 823.1644880446352, 827.3381294964034, 829.6391069884589, 833.5748768128268, 856.0668870930684, 856.5802756649259, 857.2028013947026, 864.5893200729666, 834.9833003339929, 853.0744142605249, 857.2884505860121, 858.6093327535988, 858.7209157023992, 626.1671976271548, 629.9149614802035, 631.9968400158016, 632.7310892870557, 634.0710858592139, 12376.07179461544, 12397.070219733556, 12399.070069744805, 12401.875981240162, 12488.937555312255, 12644.178128421623, 12697.0, 12866.549670761571, 12915.0, 13102.80345794814, 10538.683839484827, 10685.519151638195, 10868.239223254375, 10973.561057557688, 11006.614768483145, 3651.9817400912825, 3675.7978311192874, 3741.5323084614424, 3784.7729136251914, 3791.298609757204, 48050.759746201395, 48200.51799482031, 48282.27576586354, 48660.5133948656, 48790.26814597748, 9006.144416280444, 9006.234470070118, 9062.456252624863, 9416.0, 9552.474613896302, 17766.644667106844, 17857.285708571773, 17860.839045462002, 17910.5522361942, 17919.28322867071, 7596.354309883612, 7611.048618922635, 7694.653740581687, 7712.344450721639, 7908.84182316362, 4240.724352917051, 4251.936220956688, 4276.764777937244, 4318.632916202095, 4371.912561748811, 3131.3580715953176, 3133.482975309094, 3143.9528407073913, 3151.353972435645, 3154.3060526684094, 554.3901708121115, 570.9457601527848, 576.5790972590033, 585.2508788750406, 589.5342679283318, 565.2849145830528, 648.3840351665937, 649.5821285697281, 659.3176062775004, 680.6868840333403, 7476.738314158978, 7514.361279291212, 7572.848543029108, 7749.341305988942, 7774.2614451627005, 617.0774691835645, 660.643252643567, 664.3655309179721, 674.8899203848488, 679.1171477079777, 3608.9458658120147, 3686.299603075407, 3707.6663100321102, 3867.57456679765, 3919.353306704419, 48170.759146204044, 52488.212676809875, 52668.473315267125, 53178.0, 53693.46306536963, 43535.34696979548, 43803.78098109553, 44369.112617747465, 44426.333604995954, 44573.55426445694, 43711.344329835076, 44074.77962610166, 44460.77769611131, 45517.31724024142, 45819.541804581524, 7704.807379815549, 7875.456044779758, 7910.327622152182, 8079.555624440477, 8238.340932725248, 32435.837820810746, 33128.83435582807, 33295.33409331751, 33321.50017749687, 34339.969800906016, 40154.59845401509, 41770.16459670729, 41847.790761046, 42033.36949945692, 42290.0, 11157.609483668357, 11234.213605047567, 11291.040261577858, 11316.094712422822, 11580.942095289807, 11525.0, 12080.51677932873, 12255.379174696478, 12287.0, 12411.255324680547, 10733.892661073289, 10805.351678899291, 10841.783164336826, 10909.563617455531, 10936.50785714629, 11326.716832078935, 11365.48855301497, 11484.483198256266, 11491.94254028758, 11546.0, 10625.096866766411, 10639.0, 10797.24419290642, 10974.506147223554, 11165.497552610315, 9363.29775266844, 9581.329306948446, 9597.616095356108, 10014.699559013241, 10278.537465814206, 8057.5165490070785, 9059.0, 9119.817603647758, 9188.173064423967, 9327.440353578535], "unit": "score", "name": "yui.html", "value": 6168.633443396509}], "name": "dromaeo_css", "value": 6774.241346278021}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 111.0, 114.0, 116.0, 113.0, 124.0, 113.0, 113.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 114.1}, {"lowerIsBetter": true, "replicates": [161.0, 143.0, 155.0, 170.0, 135.0, 161.0, 154.0, 128.0, 166.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 150.3}, {"lowerIsBetter": true, "replicates": [164.0, 165.0, 165.0, 165.0, 176.0, 165.0, 169.0, 172.0, 166.0, 165.0], "unit": "score", "name": "audio-dft", "value": 167.2}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 75.0, 74.0, 74.0, 152.0, 74.0, 73.0, 73.0, 75.0], "unit": "score", "name": "audio-fft", "value": 81.8}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 143.0, 97.0, 96.0, 98.0, 142.0, 96.0, 104.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 111.5}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 117.0, 116.0, 115.0, 115.0, 116.0, 117.0, 116.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.2}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 146.0, 148.0, 147.0, 146.0, 147.0, 151.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 99.0, 97.0, 97.0, 97.0, 97.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 97.1}, {"lowerIsBetter": true, "replicates": [61.0, 58.0, 61.0, 59.0, 59.0, 58.0, 59.0, 69.0, 57.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 59.7}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 72.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [86.0, 91.0, 84.0, 84.0, 87.0, 83.0, 84.0, 84.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.2}, {"lowerIsBetter": true, "replicates": [124.0, 116.0, 121.0, 129.0, 135.0, 127.0, 119.0, 123.0, 137.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.8}, {"lowerIsBetter": true, "replicates": [144.0, 157.0, 150.0, 150.0, 142.0, 144.0, 152.0, 144.0, 148.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.5}, {"lowerIsBetter": true, "replicates": [68.0, 73.0, 71.0, 69.0, 68.0, 67.0, 70.0, 70.0, 69.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.7}], "name": "kraken", "value": 1540.4}]} 22:21:56 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1540.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6774.24"}}} 22:21:56 INFO - Return code: 0 22:21:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:21:56 ERROR - # TBPL SUCCESS # 22:21:56 INFO - Running post-action listener: _resource_record_post_action 22:21:56 INFO - Running post-run listener: _resource_record_post_run 22:21:58 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 546791424; Read time: 0; Write time: 1484816 22:21:58 INFO - install - Wall time: 17s; CPU: 22.0%; Read bytes: 0; Write bytes: 252719104; Read time: 0; Write time: 925708 22:21:58 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 293912576; Read time: 0; Write time: 559068 22:21:58 INFO - Running post-run listener: _upload_blobber_files 22:21:58 INFO - Blob upload gear active. 22:21:58 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:21:58 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:21:58 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'] 22:21:58 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 22:21:58 INFO - (blobuploader) - INFO - Open directory for files ... 22:21:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:21:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:21:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:21:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:21:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:21:59 INFO - (blobuploader) - INFO - Done attempting. 22:21:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:21:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:21:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:22:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:22:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:22:00 INFO - (blobuploader) - INFO - Done attempting. 22:22:00 INFO - (blobuploader) - INFO - Iteration through files over. 22:22:00 INFO - Return code: 0 22:22:00 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:22:00 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:22:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f9fdcc6ffcfa7782437c1460021cc61bc52463fcf3866800baf21206240f840e9a0d74ea50a4892c6672f5d5cc18d0ee1ca49bb6d76cb30e12f7c5123c7a9d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c8c0c3af2e28081bbc02bdeb7acb4eab04d78acd86135ff7958522dfe2fafd380f8b7f073e48c68b005834057a784260b99c309c3a447145a47adcef1292cc0"} 22:22:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:22:00 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:22:00 INFO - Contents: 22:22:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f9fdcc6ffcfa7782437c1460021cc61bc52463fcf3866800baf21206240f840e9a0d74ea50a4892c6672f5d5cc18d0ee1ca49bb6d76cb30e12f7c5123c7a9d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c8c0c3af2e28081bbc02bdeb7acb4eab04d78acd86135ff7958522dfe2fafd380f8b7f073e48c68b005834057a784260b99c309c3a447145a47adcef1292cc0"} 22:22:00 INFO - Running post-run listener: copy_logs_to_upload_dir 22:22:00 INFO - Copying logs to upload dir... 22:22:00 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:22:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.458685 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-02-19 22:22:00.433765) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-19 22:22:00.441617) ========= 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=af724c981e2a0f424dbabf99000001e7-1455942485.144514-978334050 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/9f9fdcc6ffcfa7782437c1460021cc61bc52463fcf3866800baf21206240f840e9a0d74ea50a4892c6672f5d5cc18d0ee1ca49bb6d76cb30e12f7c5123c7a9d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c8c0c3af2e28081bbc02bdeb7acb4eab04d78acd86135ff7958522dfe2fafd380f8b7f073e48c68b005834057a784260b99c309c3a447145a47adcef1292cc0"} build_url:https://queue.taskcluster.net/v1/task/Jqoh1bttQu-i2GmytFawZw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009852 build_url: 'https://queue.taskcluster.net/v1/task/Jqoh1bttQu-i2GmytFawZw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f9fdcc6ffcfa7782437c1460021cc61bc52463fcf3866800baf21206240f840e9a0d74ea50a4892c6672f5d5cc18d0ee1ca49bb6d76cb30e12f7c5123c7a9d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c8c0c3af2e28081bbc02bdeb7acb4eab04d78acd86135ff7958522dfe2fafd380f8b7f073e48c68b005834057a784260b99c309c3a447145a47adcef1292cc0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-19 22:22:00.469902) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 22:22:00.470275) ========= 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=af724c981e2a0f424dbabf99000001e7-1455942485.144514-978334050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004599 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 22:22:00.519946) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-19 22:22:00.523313) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-19 22:22:00.523633) ========= ========= Total master_lag: 0.26 =========