builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1459491908.62 results: success (0) buildid: 20160331203545 builduid: 14b0993c187e4c859ed09ccd2805fc98 revision: c9d25791f8219540e527c3d18aa919418fff4061 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-31 23:25:08.624130) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-31 23:25:08.624818) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-31 23:25:08.625133) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1459487987.669708-1988215406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006336 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-31 23:25:08.649107) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-31 23:25:08.649432) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-31 23:25:08.669543) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 23:25:08.669807) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1459487987.669708-1988215406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004607 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 23:25:08.719707) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-31 23:25:08.719979) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-31 23:25:08.720325) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 23:25:08.720807) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1459487987.669708-1988215406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-31 23:25:09-- 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% 43.0M=0s 2016-03-31 23:25:09 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.185797 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 23:25:08.927888) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 23:25:08.928168) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1459487987.669708-1988215406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015730 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 23:25:08.988103) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-31 23:25:08.988444) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c9d25791f8219540e527c3d18aa919418fff4061 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c9d25791f8219540e527c3d18aa919418fff4061 --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=2c5dd2b0a310ecf02fd87158000001b4-1459487987.669708-1988215406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-31 23:25:09,412 truncating revision to first 12 chars 2016-03-31 23:25:09,413 Setting DEBUG logging. 2016-03-31 23:25:09,413 attempt 1/10 2016-03-31 23:25:09,413 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c9d25791f821?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-31 23:25:10,674 unpacking tar archive at: mozilla-aurora-c9d25791f821/testing/mozharness/ program finished with exit code 0 elapsedTime=1.556521 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-31 23:25:10.557413) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-31 23:25:10.557756) ========= echo c9d25791f8219540e527c3d18aa919418fff4061 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c9d25791f8219540e527c3d18aa919418fff4061'] 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=2c5dd2b0a310ecf02fd87158000001b4-1459487987.669708-1988215406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False c9d25791f8219540e527c3d18aa919418fff4061 program finished with exit code 0 elapsedTime=0.003847 script_repo_revision: 'c9d25791f8219540e527c3d18aa919418fff4061' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-31 23:25:10.606997) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-31 23:25:10.607323) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-31 23:25:10.617285) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-03-31 23:25:10.617689) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1459487987.669708-1988215406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:25:11 INFO - MultiFileLogger online at 20160331 23:25:11 in /builds/slave/test-pgo 23:25:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 23:25:11 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 23:25:11 INFO - {'append_to_log': False, 23:25:11 INFO - 'base_work_dir': '/builds/slave/test-pgo', 23:25:11 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 23:25:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 23:25:11 INFO - 'branch': 'Mozilla-Aurora', 23:25:11 INFO - 'buildbot_json_path': 'buildprops.json', 23:25:11 INFO - 'config_files': ('talos/linux_config.py',), 23:25:11 INFO - 'default_actions': ('clobber', 23:25:11 INFO - 'read-buildbot-config', 23:25:11 INFO - 'download-and-extract', 23:25:11 INFO - 'populate-webroot', 23:25:11 INFO - 'create-virtualenv', 23:25:11 INFO - 'install', 23:25:11 INFO - 'run-tests'), 23:25:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:25:11 INFO - 'download_minidump_stackwalk': True, 23:25:11 INFO - 'download_symbols': 'ondemand', 23:25:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:25:11 INFO - 'tooltool.py': '/tools/tooltool.py', 23:25:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:25:11 INFO - '/tools/misc-python/virtualenv.py')}, 23:25:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:25:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:25:11 INFO - 'installer_path': 'installer.exe', 23:25:11 INFO - 'log_level': 'info', 23:25:11 INFO - 'log_name': 'talos', 23:25:11 INFO - 'log_to_console': True, 23:25:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:25:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:25:11 INFO - 'opt_config_files': (), 23:25:11 INFO - 'pip_index': False, 23:25:11 INFO - 'sps_profile': False, 23:25:11 INFO - 'sps_profile_interval': 0, 23:25:11 INFO - 'suite': 'dromaeojs', 23:25:11 INFO - 'system_bits': '32', 23:25:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:25:11 INFO - 'title': 'talos-linux64-ix-012', 23:25:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:25:11 INFO - 'use_talos_json': True, 23:25:11 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 23:25:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:25:11 INFO - 'work_dir': 'build'} 23:25:11 INFO - ##### 23:25:11 INFO - ##### Running clobber step. 23:25:11 INFO - ##### 23:25:11 INFO - Running pre-action listener: _resource_record_pre_action 23:25:11 INFO - Running main action method: clobber 23:25:11 INFO - rmtree: /builds/slave/test-pgo/build 23:25:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 23:25:11 INFO - Running post-action listener: _resource_record_post_action 23:25:11 INFO - ##### 23:25:11 INFO - ##### Running read-buildbot-config step. 23:25:11 INFO - ##### 23:25:11 INFO - Running pre-action listener: _resource_record_pre_action 23:25:11 INFO - Running main action method: read_buildbot_config 23:25:11 INFO - Using buildbot properties: 23:25:11 INFO - { 23:25:11 INFO - "project": "", 23:25:11 INFO - "product": "firefox", 23:25:11 INFO - "script_repo_revision": "production", 23:25:11 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 23:25:11 INFO - "repository": "", 23:25:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 23:25:11 INFO - "buildid": "20160331203545", 23:25:11 INFO - "pgo_build": "True", 23:25:11 INFO - "basedir": "/builds/slave/test-pgo", 23:25:11 INFO - "buildnumber": 143, 23:25:11 INFO - "slavename": "talos-linux64-ix-012", 23:25:11 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:25:11 INFO - "platform": "ubuntu64_hw", 23:25:11 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 23:25:11 INFO - "branch": "mozilla-aurora", 23:25:11 INFO - "repo_path": "releases/mozilla-aurora", 23:25:11 INFO - "revision": "c9d25791f8219540e527c3d18aa919418fff4061", 23:25:11 INFO - "stage_platform": "linux64-pgo", 23:25:11 INFO - "builduid": "14b0993c187e4c859ed09ccd2805fc98", 23:25:11 INFO - "slavebuilddir": "test" 23:25:11 INFO - } 23:25:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/U6h6R4XpT7q4zC5eAFY6BQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 23:25:11 INFO - Running post-action listener: _resource_record_post_action 23:25:11 INFO - ##### 23:25:11 INFO - ##### Running download-and-extract step. 23:25:11 INFO - ##### 23:25:11 INFO - Running pre-action listener: _resource_record_pre_action 23:25:11 INFO - Running main action method: download_and_extract 23:25:11 INFO - mkdir: /builds/slave/test-pgo/build/tests 23:25:11 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')]} 23:25:11 INFO - https://queue.taskcluster.net/v1/task/U6h6R4XpT7q4zC5eAFY6BQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:25:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6h6R4XpT7q4zC5eAFY6BQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 23:25:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6h6R4XpT7q4zC5eAFY6BQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 23:25:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6h6R4XpT7q4zC5eAFY6BQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 23:25:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6h6R4XpT7q4zC5eAFY6BQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:25:23 INFO - Downloaded 1448 bytes. 23:25:23 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 23:25:23 INFO - Using the following test package requirements: 23:25:23 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 23:25:23 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 23:25:23 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 23:25:23 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 23:25:23 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 23:25:23 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 23:25:23 INFO - u'jsshell-linux-x86_64.zip'], 23:25:23 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 23:25:23 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 23:25:23 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 23:25:23 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 23:25:23 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 23:25:23 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 23:25:23 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 23:25:23 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 23:25:23 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 23:25:23 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 23:25:23 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 23:25:23 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 23:25:23 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:25:23 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')]} 23:25:23 INFO - https://queue.taskcluster.net/v1/task/U6h6R4XpT7q4zC5eAFY6BQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:25:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6h6R4XpT7q4zC5eAFY6BQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 23:25:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6h6R4XpT7q4zC5eAFY6BQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 23:25:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6h6R4XpT7q4zC5eAFY6BQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 23:25:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6h6R4XpT7q4zC5eAFY6BQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:25:25 INFO - Downloaded 23344361 bytes. 23:25:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 23:25:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 23:25:26 INFO - Return code: 0 23:25:26 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:25:26 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')]} 23:25:26 INFO - https://queue.taskcluster.net/v1/task/U6h6R4XpT7q4zC5eAFY6BQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:25:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6h6R4XpT7q4zC5eAFY6BQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 23:25:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6h6R4XpT7q4zC5eAFY6BQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 23:25:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6h6R4XpT7q4zC5eAFY6BQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 23:25:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6h6R4XpT7q4zC5eAFY6BQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:25:32 INFO - Downloaded 23344361 bytes. 23:25:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 23:25:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 23:25:33 INFO - Return code: 0 23:25: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')]} 23:25:33 INFO - https://queue.taskcluster.net/v1/task/U6h6R4XpT7q4zC5eAFY6BQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:25:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6h6R4XpT7q4zC5eAFY6BQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 23:25:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6h6R4XpT7q4zC5eAFY6BQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 23:25:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6h6R4XpT7q4zC5eAFY6BQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 23:25:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6h6R4XpT7q4zC5eAFY6BQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:25:34 INFO - Downloaded 10845161 bytes. 23:25:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 23:25:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 23:25:34 INFO - Return code: 0 23:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:34 INFO - https://queue.taskcluster.net/v1/task/U6h6R4XpT7q4zC5eAFY6BQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:25:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6h6R4XpT7q4zC5eAFY6BQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 23:25:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6h6R4XpT7q4zC5eAFY6BQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 23:25:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6h6R4XpT7q4zC5eAFY6BQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 23:25:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U6h6R4XpT7q4zC5eAFY6BQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:25:36 INFO - Downloaded 60557332 bytes. 23:25:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U6h6R4XpT7q4zC5eAFY6BQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 23:25:36 INFO - mkdir: /builds/slave/test-pgo/properties 23:25:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 23:25:36 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 23:25:36 INFO - Contents: 23:25:36 INFO - build_url:https://queue.taskcluster.net/v1/task/U6h6R4XpT7q4zC5eAFY6BQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 23:25:37 INFO - Running post-action listener: _resource_record_post_action 23:25:37 INFO - Running post-action listener: set_extra_try_arguments 23:25:37 INFO - ##### 23:25:37 INFO - ##### Running populate-webroot step. 23:25:37 INFO - ##### 23:25:37 INFO - Running pre-action listener: _resource_record_pre_action 23:25:37 INFO - Running main action method: populate_webroot 23:25:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:25:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:25:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:25:37 INFO - '--tppagecycles', 23:25:37 INFO - '7'], 23:25:37 INFO - 'tests': ['tsvgm']}}, 23:25:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:25:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:25:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:25:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 23:25:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:25:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:25:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:25:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:25:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:25:37 INFO - 'talos_options': ['--e10s'], 23:25:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:25:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:25:37 INFO - 'tests': ['damp', 'tps']}, 23:25:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:25:37 INFO - 'talos_options': ['--e10s'], 23:25:37 INFO - 'tests': ['damp', 'tps']}, 23:25:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:25:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:25:37 INFO - 'other': {'tests': ['a11yr', 23:25:37 INFO - 'ts_paint', 23:25:37 INFO - 'tpaint', 23:25:37 INFO - 'sessionrestore', 23:25:37 INFO - 'sessionrestore_no_auto_restore', 23:25:37 INFO - 'tabpaint']}, 23:25:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:25:37 INFO - 'tests': ['a11yr', 23:25:37 INFO - 'ts_paint', 23:25:37 INFO - 'tpaint', 23:25:37 INFO - 'sessionrestore', 23:25:37 INFO - 'sessionrestore_no_auto_restore', 23:25:37 INFO - 'tabpaint']}, 23:25:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:25:37 INFO - 'tests': ['a11yr', 23:25:37 INFO - 'ts_paint', 23:25:37 INFO - 'tpaint', 23:25:37 INFO - 'sessionrestore', 23:25:37 INFO - 'sessionrestore_no_auto_restore', 23:25:37 INFO - 'tabpaint']}, 23:25:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:25:37 INFO - 'tests': ['a11yr', 23:25:37 INFO - 'ts_paint', 23:25:37 INFO - 'tpaint', 23:25:37 INFO - 'sessionrestore', 23:25:37 INFO - 'sessionrestore_no_auto_restore', 23:25:37 INFO - 'tabpaint']}, 23:25:37 INFO - 'other_l64': {'tests': ['a11yr', 23:25:37 INFO - 'ts_paint', 23:25:37 INFO - 'tpaint', 23:25:37 INFO - 'sessionrestore', 23:25:37 INFO - 'sessionrestore_no_auto_restore', 23:25:37 INFO - 'tabpaint']}, 23:25:37 INFO - 'other_nol64': {'tests': ['a11yr', 23:25:37 INFO - 'ts_paint', 23:25:37 INFO - 'tpaint', 23:25:37 INFO - 'sessionrestore', 23:25:37 INFO - 'sessionrestore_no_auto_restore', 23:25:37 INFO - 'tabpaint']}, 23:25:37 INFO - 'svgr': {'tests': ['tsvgx', 23:25:37 INFO - 'tsvgr_opacity', 23:25:37 INFO - 'tart', 23:25:37 INFO - 'tscrollx', 23:25:37 INFO - 'cart']}, 23:25:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:25:37 INFO - 'tests': ['tsvgx', 23:25:37 INFO - 'tsvgr_opacity', 23:25:37 INFO - 'tart', 23:25:37 INFO - 'tscrollx', 23:25:37 INFO - 'cart']}, 23:25:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:25:37 INFO - 'tests': ['tp5o']}, 23:25:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:25:37 INFO - 'talos_options': ['--e10s'], 23:25:37 INFO - 'tests': ['tp5o']}, 23:25:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:25:37 INFO - 'talos_options': ['--xperf_path', 23:25:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:25:37 INFO - 'tests': ['tp5n']}, 23:25:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:25:37 INFO - 'talos_options': ['--e10s', 23:25:37 INFO - '--xperf_path', 23:25:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:25:37 INFO - 'tests': ['tp5n']}}, 23:25:37 INFO - 'talos.zip': {'path': '', 23:25:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:25:37 INFO - Running post-action listener: _resource_record_post_action 23:25:37 INFO - ##### 23:25:37 INFO - ##### Running create-virtualenv step. 23:25:37 INFO - ##### 23:25:37 INFO - Running pre-action listener: _resource_record_pre_action 23:25:37 INFO - Running main action method: create_virtualenv 23:25:37 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 23:25:37 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 23:25:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 23:25:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:25:37 INFO - Using real prefix '/usr' 23:25:37 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 23:25:37 INFO - Installing distribute.............................................................................................................................................................................................done. 23:25:39 INFO - Installing pip.................done. 23:25:39 INFO - Return code: 0 23:25:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 23:25:39 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')]} 23:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:39 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')]} 23:25:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:39 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 0x7f8dc54caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2671920>, '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 0x2672820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2672cb0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1459487987.669708-1988215406', '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 23:25:39 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 23:25:39 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 23:25:39 INFO - Using env: {'DISPLAY': ':0', 23:25:39 INFO - 'HOME': '/home/cltbld', 23:25:39 INFO - 'LANG': 'en_US.UTF-8', 23:25:39 INFO - 'LANGUAGE': 'en_US:en', 23:25:39 INFO - 'LOGNAME': 'cltbld', 23:25:39 INFO - 'MAIL': '/var/mail/cltbld', 23:25:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:39 INFO - 'MOZ_NO_REMOTE': '1', 23:25:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:25:39 INFO - 'NO_EM_RESTART': '1', 23:25:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:25:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:25:39 INFO - 'PWD': '/builds/slave/test-pgo', 23:25:39 INFO - 'SHELL': '/bin/bash', 23:25:39 INFO - 'SHLVL': '1', 23:25:39 INFO - 'TERM': 'linux', 23:25:39 INFO - 'TMOUT': '86400', 23:25:39 INFO - 'USER': 'cltbld', 23:25:39 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1459487987.669708-1988215406', 23:25:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:39 INFO - '_': '/tools/buildbot/bin/python'} 23:25:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:39 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 23:25:39 INFO - Cleaning up... 23:25:39 INFO - Return code: 0 23:25:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 23:25:39 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')]} 23:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:39 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')]} 23:25:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:39 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 0x7f8dc54caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2671920>, '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 0x2672820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2672cb0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1459487987.669708-1988215406', '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 23:25:39 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 23:25:39 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 23:25:39 INFO - Using env: {'DISPLAY': ':0', 23:25:39 INFO - 'HOME': '/home/cltbld', 23:25:39 INFO - 'LANG': 'en_US.UTF-8', 23:25:39 INFO - 'LANGUAGE': 'en_US:en', 23:25:39 INFO - 'LOGNAME': 'cltbld', 23:25:39 INFO - 'MAIL': '/var/mail/cltbld', 23:25:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:39 INFO - 'MOZ_NO_REMOTE': '1', 23:25:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:25:39 INFO - 'NO_EM_RESTART': '1', 23:25:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:25:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:25:39 INFO - 'PWD': '/builds/slave/test-pgo', 23:25:39 INFO - 'SHELL': '/bin/bash', 23:25:39 INFO - 'SHLVL': '1', 23:25:39 INFO - 'TERM': 'linux', 23:25:39 INFO - 'TMOUT': '86400', 23:25:39 INFO - 'USER': 'cltbld', 23:25:39 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1459487987.669708-1988215406', 23:25:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:39 INFO - '_': '/tools/buildbot/bin/python'} 23:25:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:40 INFO - Downloading/unpacking psutil>=0.7.1 23:25:40 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 23:25:40 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 23:25:40 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 23:25:40 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 23:25:40 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 23:25:40 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 23:25:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 23:25:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:25:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:25:42 INFO - Installing collected packages: psutil 23:25:42 INFO - Running setup.py install for psutil 23:25:42 INFO - building 'psutil._psutil_linux' extension 23:25:42 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 23:25:42 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 23:25:42 INFO - building 'psutil._psutil_posix' extension 23:25:42 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 23:25:42 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 23:25:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:25:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:25:42 INFO - Successfully installed psutil 23:25:42 INFO - Cleaning up... 23:25:42 INFO - Return code: 0 23:25:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 23:25:42 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')]} 23:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:42 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')]} 23:25:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:42 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 0x7f8dc54caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2671920>, '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 0x2672820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2672cb0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1459487987.669708-1988215406', '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 23:25:42 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 23:25:42 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 23:25:42 INFO - Using env: {'DISPLAY': ':0', 23:25:42 INFO - 'HOME': '/home/cltbld', 23:25:42 INFO - 'LANG': 'en_US.UTF-8', 23:25:42 INFO - 'LANGUAGE': 'en_US:en', 23:25:42 INFO - 'LOGNAME': 'cltbld', 23:25:42 INFO - 'MAIL': '/var/mail/cltbld', 23:25:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:42 INFO - 'MOZ_NO_REMOTE': '1', 23:25:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:25:42 INFO - 'NO_EM_RESTART': '1', 23:25:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:25:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:25:42 INFO - 'PWD': '/builds/slave/test-pgo', 23:25:42 INFO - 'SHELL': '/bin/bash', 23:25:42 INFO - 'SHLVL': '1', 23:25:42 INFO - 'TERM': 'linux', 23:25:42 INFO - 'TMOUT': '86400', 23:25:42 INFO - 'USER': 'cltbld', 23:25:42 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1459487987.669708-1988215406', 23:25:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:42 INFO - '_': '/tools/buildbot/bin/python'} 23:25:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:25:42 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 23:25:42 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 23:25:42 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 23:25:42 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 23:25:42 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 23:25:42 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 23:25:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:25:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:25:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:25:44 INFO - Installing collected packages: mozsystemmonitor 23:25:44 INFO - Running setup.py install for mozsystemmonitor 23:25:44 INFO - Successfully installed mozsystemmonitor 23:25:44 INFO - Cleaning up... 23:25:44 INFO - Return code: 0 23:25:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 23:25:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8dc54caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2671920>, '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 0x2672820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2672cb0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1459487987.669708-1988215406', '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 23:25:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 23:25:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:25:44 INFO - Using env: {'DISPLAY': ':0', 23:25:44 INFO - 'HOME': '/home/cltbld', 23:25:44 INFO - 'LANG': 'en_US.UTF-8', 23:25:44 INFO - 'LANGUAGE': 'en_US:en', 23:25:44 INFO - 'LOGNAME': 'cltbld', 23:25:44 INFO - 'MAIL': '/var/mail/cltbld', 23:25:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:44 INFO - 'MOZ_NO_REMOTE': '1', 23:25:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:25:44 INFO - 'NO_EM_RESTART': '1', 23:25:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:25:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:25:44 INFO - 'PWD': '/builds/slave/test-pgo', 23:25:44 INFO - 'SHELL': '/bin/bash', 23:25:44 INFO - 'SHLVL': '1', 23:25:44 INFO - 'TERM': 'linux', 23:25:44 INFO - 'TMOUT': '86400', 23:25:44 INFO - 'USER': 'cltbld', 23:25:44 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1459487987.669708-1988215406', 23:25:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:44 INFO - '_': '/tools/buildbot/bin/python'} 23:25:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:45 INFO - Downloading/unpacking blobuploader==1.2.4 23:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:47 INFO - Downloading blobuploader-1.2.4.tar.gz 23:25:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:25:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 23:25:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:47 INFO - Downloading docopt-0.6.1.tar.gz 23:25:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 23:25:47 INFO - Installing collected packages: blobuploader, requests, docopt 23:25:47 INFO - Running setup.py install for blobuploader 23:25:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:25:47 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 23:25:47 INFO - Running setup.py install for requests 23:25:48 INFO - Running setup.py install for docopt 23:25:48 INFO - Successfully installed blobuploader requests docopt 23:25:48 INFO - Cleaning up... 23:25:48 INFO - Return code: 0 23:25:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:25: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')]} 23:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25: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')]} 23:25:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:48 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 0x7f8dc54caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2671920>, '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 0x2672820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2672cb0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1459487987.669708-1988215406', '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 23:25:48 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 23:25:48 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 23:25:48 INFO - Using env: {'DISPLAY': ':0', 23:25:48 INFO - 'HOME': '/home/cltbld', 23:25:48 INFO - 'LANG': 'en_US.UTF-8', 23:25:48 INFO - 'LANGUAGE': 'en_US:en', 23:25:48 INFO - 'LOGNAME': 'cltbld', 23:25:48 INFO - 'MAIL': '/var/mail/cltbld', 23:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:48 INFO - 'MOZ_NO_REMOTE': '1', 23:25:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:25:48 INFO - 'NO_EM_RESTART': '1', 23:25:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:25:48 INFO - 'PWD': '/builds/slave/test-pgo', 23:25:48 INFO - 'SHELL': '/bin/bash', 23:25:48 INFO - 'SHLVL': '1', 23:25:48 INFO - 'TERM': 'linux', 23:25:48 INFO - 'TMOUT': '86400', 23:25:48 INFO - 'USER': 'cltbld', 23:25:48 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1459487987.669708-1988215406', 23:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:48 INFO - '_': '/tools/buildbot/bin/python'} 23:25:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:25:48 INFO - Running setup.py (path:/tmp/pip-cWBwbS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:25:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:25:48 INFO - Running setup.py (path:/tmp/pip-GRWkOl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:25:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:25:48 INFO - Running setup.py (path:/tmp/pip-VM4_Xu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:25:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:25:48 INFO - Running setup.py (path:/tmp/pip-QvxLdj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:25:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:25:48 INFO - Running setup.py (path:/tmp/pip-G1EzT2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:25:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:25:49 INFO - Running setup.py (path:/tmp/pip-8LhfAe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:25:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:25:49 INFO - Running setup.py (path:/tmp/pip-mLHoY5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:25:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:25:49 INFO - Running setup.py (path:/tmp/pip-sk1oMn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:25:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:25:49 INFO - Running setup.py (path:/tmp/pip-_x0D0B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:25:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:25:49 INFO - Running setup.py (path:/tmp/pip-bND1SK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:25:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:25:49 INFO - Running setup.py (path:/tmp/pip-6Cr7Dr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:25:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:25:49 INFO - Running setup.py (path:/tmp/pip-dg51_v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:25:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:25:49 INFO - Running setup.py (path:/tmp/pip-Us02_i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:25:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:25:49 INFO - Running setup.py (path:/tmp/pip-8_fgo5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:25:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:25:49 INFO - Running setup.py (path:/tmp/pip-w6GVCs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:25:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:25:49 INFO - Running setup.py (path:/tmp/pip-QZnDZQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:25:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:25:49 INFO - Running setup.py (path:/tmp/pip-ooKmny-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:25:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:25:49 INFO - Running setup.py install for manifestparser 23:25:50 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 23:25:50 INFO - Running setup.py install for mozcrash 23:25:50 INFO - Running setup.py install for mozdebug 23:25:50 INFO - Running setup.py install for mozdevice 23:25:50 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 23:25:50 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 23:25:50 INFO - Running setup.py install for mozfile 23:25:50 INFO - Running setup.py install for mozhttpd 23:25:50 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 23:25:50 INFO - Running setup.py install for mozinfo 23:25:50 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 23:25:50 INFO - Running setup.py install for mozInstall 23:25:50 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 23:25:50 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 23:25:50 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 23:25:50 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 23:25:50 INFO - Running setup.py install for mozleak 23:25:50 INFO - Running setup.py install for mozlog 23:25:50 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 23:25:50 INFO - Running setup.py install for moznetwork 23:25:51 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 23:25:51 INFO - Running setup.py install for mozprocess 23:25:51 INFO - Running setup.py install for mozprofile 23:25:51 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 23:25:51 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 23:25:51 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 23:25:51 INFO - Running setup.py install for mozrunner 23:25:51 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 23:25:51 INFO - Running setup.py install for mozscreenshot 23:25:51 INFO - Running setup.py install for moztest 23:25:51 INFO - Running setup.py install for mozversion 23:25:51 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 23:25:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:25:51 INFO - Cleaning up... 23:25:51 INFO - Return code: 0 23:25:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:25:51 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')]} 23:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:51 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')]} 23:25:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:51 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 0x7f8dc54caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2671920>, '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 0x2672820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2672cb0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1459487987.669708-1988215406', '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 23:25:51 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 23:25:51 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 23:25:51 INFO - Using env: {'DISPLAY': ':0', 23:25:51 INFO - 'HOME': '/home/cltbld', 23:25:51 INFO - 'LANG': 'en_US.UTF-8', 23:25:51 INFO - 'LANGUAGE': 'en_US:en', 23:25:51 INFO - 'LOGNAME': 'cltbld', 23:25:51 INFO - 'MAIL': '/var/mail/cltbld', 23:25:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:51 INFO - 'MOZ_NO_REMOTE': '1', 23:25:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:25:51 INFO - 'NO_EM_RESTART': '1', 23:25:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:25:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:25:51 INFO - 'PWD': '/builds/slave/test-pgo', 23:25:51 INFO - 'SHELL': '/bin/bash', 23:25:51 INFO - 'SHLVL': '1', 23:25:51 INFO - 'TERM': 'linux', 23:25:51 INFO - 'TMOUT': '86400', 23:25:51 INFO - 'USER': 'cltbld', 23:25:51 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1459487987.669708-1988215406', 23:25:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:51 INFO - '_': '/tools/buildbot/bin/python'} 23:25:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:25:51 INFO - Running setup.py (path:/tmp/pip-TvZ2mz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:25:51 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)) 23:25:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:25:51 INFO - Running setup.py (path:/tmp/pip-HnvEx6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 23:25:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:25:52 INFO - Running setup.py (path:/tmp/pip-NwCkCF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:25:52 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)) 23:25:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:25:52 INFO - Running setup.py (path:/tmp/pip-DUnzaS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:25:52 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)) 23:25:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:25:52 INFO - Running setup.py (path:/tmp/pip-p8M63w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:25:52 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)) 23:25:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:25:52 INFO - Running setup.py (path:/tmp/pip-JcJoUd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:25:52 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)) 23:25:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:25:52 INFO - Running setup.py (path:/tmp/pip-j4yyj0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:25:52 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)) 23:25:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:25:52 INFO - Running setup.py (path:/tmp/pip-8cG23L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:25:52 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)) 23:25:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:25:52 INFO - Running setup.py (path:/tmp/pip-BFCzqW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:25:52 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)) 23:25:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:25:52 INFO - Running setup.py (path:/tmp/pip-H7ajka-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:25:52 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)) 23:25:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:25:52 INFO - Running setup.py (path:/tmp/pip-nZUvKy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:25:52 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)) 23:25:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:25:52 INFO - Running setup.py (path:/tmp/pip-mwxX0j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:25:52 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)) 23:25:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:25:52 INFO - Running setup.py (path:/tmp/pip-jAJFgS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:25:52 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)) 23:25:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:25:52 INFO - Running setup.py (path:/tmp/pip-jN6Itj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:25:52 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)) 23:25:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:25:52 INFO - Running setup.py (path:/tmp/pip-2Qu7Jr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:25:52 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)) 23:25:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:25:52 INFO - Running setup.py (path:/tmp/pip-ew7dwy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:25:53 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)) 23:25:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:25:53 INFO - Running setup.py (path:/tmp/pip-g8IUEE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:25:53 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)) 23:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 23:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 23:25:53 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)) 23:25:53 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)) 23:25:53 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)) 23:25:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 23:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:54 INFO - Downloading blessings-1.6.tar.gz 23:25:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 23:25:55 INFO - Installing collected packages: blessings 23:25:55 INFO - Running setup.py install for blessings 23:25:55 INFO - Successfully installed blessings 23:25:55 INFO - Cleaning up... 23:25:55 INFO - Return code: 0 23:25:55 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 23:25:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:25:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:25:55 INFO - Reading from file tmpfile_stdout 23:25:55 INFO - Current package versions: 23:25:55 INFO - argparse == 1.2.1 23:25:55 INFO - blessings == 1.6 23:25:55 INFO - blobuploader == 1.2.4 23:25:55 INFO - docopt == 0.6.1 23:25:55 INFO - manifestparser == 1.1 23:25:55 INFO - mozInstall == 1.12 23:25:55 INFO - mozcrash == 0.17 23:25:55 INFO - mozdebug == 0.1 23:25:55 INFO - mozdevice == 0.48 23:25:55 INFO - mozfile == 1.2 23:25:55 INFO - mozhttpd == 0.7 23:25:55 INFO - mozinfo == 0.9 23:25:55 INFO - mozleak == 0.1 23:25:55 INFO - mozlog == 3.1 23:25:55 INFO - moznetwork == 0.27 23:25:55 INFO - mozprocess == 0.22 23:25:55 INFO - mozprofile == 0.28 23:25:55 INFO - mozrunner == 6.11 23:25:55 INFO - mozscreenshot == 0.1 23:25:55 INFO - mozsystemmonitor == 0.0 23:25:55 INFO - moztest == 0.7 23:25:55 INFO - mozversion == 1.4 23:25:55 INFO - psutil == 3.1.1 23:25:55 INFO - requests == 1.2.3 23:25:55 INFO - wsgiref == 0.1.2 23:25:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:25: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')]} 23:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25: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')]} 23:25:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25: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/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 0x7f8dc54caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2671920>, '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 0x2672820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2672cb0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1459487987.669708-1988215406', '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 23:25:55 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 23:25:55 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 23:25:55 INFO - Using env: {'DISPLAY': ':0', 23:25:55 INFO - 'HOME': '/home/cltbld', 23:25:55 INFO - 'LANG': 'en_US.UTF-8', 23:25:55 INFO - 'LANGUAGE': 'en_US:en', 23:25:55 INFO - 'LOGNAME': 'cltbld', 23:25:55 INFO - 'MAIL': '/var/mail/cltbld', 23:25:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:55 INFO - 'MOZ_NO_REMOTE': '1', 23:25:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:25:55 INFO - 'NO_EM_RESTART': '1', 23:25:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:25:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:25:55 INFO - 'PWD': '/builds/slave/test-pgo', 23:25:55 INFO - 'SHELL': '/bin/bash', 23:25:55 INFO - 'SHLVL': '1', 23:25:55 INFO - 'TERM': 'linux', 23:25:55 INFO - 'TMOUT': '86400', 23:25:55 INFO - 'USER': 'cltbld', 23:25:55 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1459487987.669708-1988215406', 23:25:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:55 INFO - '_': '/tools/buildbot/bin/python'} 23:25:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:55 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)) 23:25:55 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)) 23:25:55 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)) 23:25:55 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)) 23:25:55 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)) 23:25:55 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)) 23:25:55 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)) 23:25:55 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)) 23:25:55 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)) 23:25:55 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)) 23:25:55 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)) 23:25:55 INFO - Cleaning up... 23:25:55 INFO - Return code: 0 23:25:55 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 23:25: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')]} 23:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25: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')]} 23:25:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8dc54caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2671920>, '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 0x2672820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2672cb0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1459487987.669708-1988215406', '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 23:25:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 23:25:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:25:55 INFO - Using env: {'DISPLAY': ':0', 23:25:55 INFO - 'HOME': '/home/cltbld', 23:25:55 INFO - 'LANG': 'en_US.UTF-8', 23:25:55 INFO - 'LANGUAGE': 'en_US:en', 23:25:55 INFO - 'LOGNAME': 'cltbld', 23:25:55 INFO - 'MAIL': '/var/mail/cltbld', 23:25:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:55 INFO - 'MOZ_NO_REMOTE': '1', 23:25:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:25:55 INFO - 'NO_EM_RESTART': '1', 23:25:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:25:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:25:55 INFO - 'PWD': '/builds/slave/test-pgo', 23:25:55 INFO - 'SHELL': '/bin/bash', 23:25:55 INFO - 'SHLVL': '1', 23:25:55 INFO - 'TERM': 'linux', 23:25:55 INFO - 'TMOUT': '86400', 23:25:55 INFO - 'USER': 'cltbld', 23:25:55 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1459487987.669708-1988215406', 23:25:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:55 INFO - '_': '/tools/buildbot/bin/python'} 23:25:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:55 INFO - Downloading/unpacking jsonschema 23:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:25:57 INFO - Downloading/unpacking functools32 (from jsonschema) 23:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:57 INFO - Downloading functools32-3.2.3-2.tar.gz 23:25:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 23:25:57 INFO - warning: no files found matching '*.txt' 23:25:57 INFO - no previously-included directories found matching 'build' 23:25:57 INFO - no previously-included directories found matching 'dist' 23:25:57 INFO - no previously-included directories found matching '.git*' 23:25:57 INFO - Installing collected packages: jsonschema, functools32 23:25:58 INFO - Running setup.py install for functools32 23:25:58 INFO - warning: no files found matching '*.txt' 23:25:58 INFO - no previously-included directories found matching 'build' 23:25:58 INFO - no previously-included directories found matching 'dist' 23:25:58 INFO - no previously-included directories found matching '.git*' 23:25:58 INFO - Successfully installed jsonschema functools32 23:25:58 INFO - Cleaning up... 23:25:58 INFO - Return code: 0 23:25:58 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 23:25:58 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')]} 23:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:25:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:58 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')]} 23:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:25:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:25:58 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 0x7f8dc54caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2671920>, '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 0x2672820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2672cb0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1459487987.669708-1988215406', '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 23:25:58 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 23:25:58 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 23:25:58 INFO - Using env: {'DISPLAY': ':0', 23:25:58 INFO - 'HOME': '/home/cltbld', 23:25:58 INFO - 'LANG': 'en_US.UTF-8', 23:25:58 INFO - 'LANGUAGE': 'en_US:en', 23:25:58 INFO - 'LOGNAME': 'cltbld', 23:25:58 INFO - 'MAIL': '/var/mail/cltbld', 23:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:58 INFO - 'MOZ_NO_REMOTE': '1', 23:25:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:25:58 INFO - 'NO_EM_RESTART': '1', 23:25:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:25:58 INFO - 'PWD': '/builds/slave/test-pgo', 23:25:58 INFO - 'SHELL': '/bin/bash', 23:25:58 INFO - 'SHLVL': '1', 23:25:58 INFO - 'TERM': 'linux', 23:25:58 INFO - 'TMOUT': '86400', 23:25:58 INFO - 'USER': 'cltbld', 23:25:58 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1459487987.669708-1988215406', 23:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:58 INFO - '_': '/tools/buildbot/bin/python'} 23:25:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:25:58 INFO - Downloading/unpacking flake8 23:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:25:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:26:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:26:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:26:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:26:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:26:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:26:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:26:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:26:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:26:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:26:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:26:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:26:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 23:26:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:26:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:26:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:26:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:26:00 INFO - no previously-included directories found matching 'docs/_build' 23:26:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:26:01 INFO - Running setup.py install for pep8 23:26:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:26:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:26:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:26:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:26:01 INFO - no previously-included directories found matching 'docs/_build' 23:26:01 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 23:26:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:26:01 INFO - Cleaning up... 23:26:01 INFO - Return code: 0 23:26:01 INFO - Running post-action listener: _resource_record_post_action 23:26:01 INFO - Running post-action listener: _start_resource_monitoring 23:26:01 INFO - Starting resource monitoring. 23:26:01 INFO - ##### 23:26:01 INFO - ##### Running install step. 23:26:01 INFO - ##### 23:26:01 INFO - Running pre-action listener: _resource_record_pre_action 23:26:01 INFO - Running main action method: install 23:26:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:26:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:26:01 INFO - Reading from file tmpfile_stdout 23:26:01 INFO - Detecting whether we're running mozinstall >=1.0... 23:26:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 23:26:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 23:26:01 INFO - Reading from file tmpfile_stdout 23:26:01 INFO - Output received: 23:26:01 INFO - Usage: mozinstall [options] installer 23:26:01 INFO - Options: 23:26:01 INFO - -h, --help show this help message and exit 23:26:01 INFO - -d DEST, --destination=DEST 23:26:01 INFO - Directory to install application into. [default: 23:26:01 INFO - "/builds/slave/test-pgo"] 23:26:01 INFO - --app=APP Application being installed. [default: firefox] 23:26:01 INFO - mkdir: /builds/slave/test-pgo/build/application 23:26:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 23:26:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 23:26:16 INFO - Reading from file tmpfile_stdout 23:26:16 INFO - Output received: 23:26:16 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 23:26:16 INFO - Running post-action listener: _resource_record_post_action 23:26:16 INFO - ##### 23:26:16 INFO - ##### Running run-tests step. 23:26:16 INFO - ##### 23:26:16 INFO - Running pre-action listener: _resource_record_pre_action 23:26:16 INFO - Running main action method: run_tests 23:26:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 23:26:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 23:26:16 INFO - Python 2.7.3 23:26:16 INFO - Return code: 0 23:26:16 INFO - grabbing minidump binary from tooltool 23:26:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:26:16 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2671920>, '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 0x2672820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2672cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 23:26:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 23:26:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 23:26:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:26:16 INFO - Return code: 0 23:26:16 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 23:26:16 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 23:26:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 23:26:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 23:26:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 23:26:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 23:26:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 23:26:17 INFO - Return code: 0 23:26:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U6h6R4XpT7q4zC5eAFY6BQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 23:26:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/U6h6R4XpT7q4zC5eAFY6BQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 23:26:17 INFO - Using env: {'DISPLAY': ':0', 23:26:17 INFO - 'HOME': '/home/cltbld', 23:26:17 INFO - 'LANG': 'en_US.UTF-8', 23:26:17 INFO - 'LANGUAGE': 'en_US:en', 23:26:17 INFO - 'LOGNAME': 'cltbld', 23:26:17 INFO - 'MAIL': '/var/mail/cltbld', 23:26:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:26:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 23:26:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:26:17 INFO - 'MOZ_NO_REMOTE': '1', 23:26:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:26:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:26:17 INFO - 'NO_EM_RESTART': '1', 23:26:17 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:26:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:26:17 INFO - 'PWD': '/builds/slave/test-pgo', 23:26:17 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 23:26:17 INFO - 'SHELL': '/bin/bash', 23:26:17 INFO - 'SHLVL': '1', 23:26:17 INFO - 'TERM': 'linux', 23:26:17 INFO - 'TMOUT': '86400', 23:26:17 INFO - 'USER': 'cltbld', 23:26:17 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1459487987.669708-1988215406', 23:26:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:26:17 INFO - '_': '/tools/buildbot/bin/python'} 23:26:17 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U6h6R4XpT7q4zC5eAFY6BQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 23:26:18 INFO - mozversion application_buildid: 20160331203545 23:26:18 INFO - mozversion application_changeset: c9d25791f8219540e527c3d18aa919418fff4061 23:26:18 INFO - mozversion application_display_name: FirefoxDeveloperEdition 23:26:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:26:18 INFO - mozversion application_name: Firefox 23:26:18 INFO - mozversion application_remotingname: firefox-dev 23:26:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:26:18 INFO - mozversion application_vendor: Mozilla 23:26:18 INFO - mozversion application_version: 47.0a2 23:26:18 INFO - mozversion platform_buildid: 20160331203545 23:26:18 INFO - mozversion platform_changeset: c9d25791f8219540e527c3d18aa919418fff4061 23:26:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:26:18 INFO - mozversion platform_version: 47.0a2 23:26:18 INFO - using testdate: 1459491978 23:26:18 INFO - actual date: 1459491978 23:26:18 INFO - starting webserver on 'localhost:60571' 23:26:18 INFO - SUITE-START | Running 2 tests 23:26:18 INFO - TEST-START | dromaeo_css 23:26:18 INFO - operating with platform_type : linux_ 23:26:18 INFO - Initialising browser for dromaeo_css test... 23:26:18 INFO - TEST-INFO | started process 19413 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbXZKK1/profile http://localhost:60571/getInfo.html) 23:26:21 INFO - PROCESS | 19413 | __metrics Screen width/height:1600/1200 23:26:21 INFO - PROCESS | 19413 | colorDepth:24 23:26:21 INFO - PROCESS | 19413 | Browser inner width/height: 1024/697 23:26:21 INFO - PROCESS | 19413 | __metrics 23:26:22 INFO - PROCESS | 19413 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:26:23 INFO - TEST-INFO | 19413: exit 0 23:26:23 INFO - Browser initialized. 23:26:23 INFO - Running cycle 1/1 for dromaeo_css test... 23:26:23 INFO - TEST-INFO | started process 19501 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbXZKK1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:26:35 INFO - PROCESS | 19501 | RSS: Main: 143147008 23:26:35 INFO - PROCESS | 19501 | 23:27:25 INFO - PROCESS | 19501 | 1459492045844 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] 23:29:33 INFO - PROCESS | 19501 | Cycle 1(1): loaded http://localhost:60571/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60571/tests/dromaeo/cssquery-ext.html) 23:29:34 INFO - PROCESS | 19501 | RSS: Main: 253685760 23:29:34 INFO - PROCESS | 19501 | 23:32:36 INFO - PROCESS | 19501 | Cycle 1(1): loaded http://localhost:60571/tests/dromaeo/cssquery-ext.html (next: http://localhost:60571/tests/dromaeo/cssquery-jquery.html) 23:32:37 INFO - PROCESS | 19501 | RSS: Main: 219914240 23:32:37 INFO - PROCESS | 19501 | 23:35:39 INFO - PROCESS | 19501 | Cycle 1(1): loaded http://localhost:60571/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60571/tests/dromaeo/cssquery-mootools.html) 23:35:39 INFO - PROCESS | 19501 | RSS: Main: 236748800 23:35:39 INFO - PROCESS | 19501 | 23:38:41 INFO - PROCESS | 19501 | Cycle 1(1): loaded http://localhost:60571/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60571/tests/dromaeo/cssquery-prototype.html) 23:38:42 INFO - PROCESS | 19501 | RSS: Main: 208531456 23:38:42 INFO - PROCESS | 19501 | 23:41:44 INFO - PROCESS | 19501 | Cycle 1(1): loaded http://localhost:60571/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60571/tests/dromaeo/cssquery-yui.html) 23:41:45 INFO - PROCESS | 19501 | RSS: Main: 209408000 23:41:45 INFO - PROCESS | 19501 | 23:44:47 INFO - PROCESS | 19501 | Cycle 1(1): loaded http://localhost:60571/tests/dromaeo/cssquery-yui.html (next: http://localhost:60571/tests/dromaeo/cssquery-dojo.html) 23:44:47 INFO - PROCESS | 19501 | RSS: Main: 258449408 23:44:47 INFO - PROCESS | 19501 | 23:44:47 INFO - PROCESS | 19501 | __start_tp_report 23:44:47 INFO - PROCESS | 19501 | _x_x_mozilla_page_load 23:44:47 INFO - PROCESS | 19501 | _x_x_mozilla_page_load_details 23:44:47 INFO - PROCESS | 19501 | |i|pagename|runs| 23:44:47 INFO - PROCESS | 19501 | |0;dojo.html;3256.478963365861;3341.1814105544145;3345.5483509726196;3359.6976272135516;3388.1698983748984;5344.19837024446;5351.7056561889085;5362.034833729927;5367.4900884415965;5381.730913454331;5355.196720491928;5362.678239305645;5377.542908852743;5385.084535628943;5395.433479484646;4808.08646357191;4941.110600091991;4948.985457981124;4979.278004689318;5020.3724534433195;4824.831130910419;4883.047805677894;4913.213885778277;4958.826441074563;5005.474425185358;4946.15915294399;4962.6526143169995;4963.900721985558;4966.404031516205;5000.249962505635;4892.6575139740235;4915.827946021908;4939.061578300129;4961.900761984776;4963.379577552806;4796.25658023007;4814.10938976287;4877.0489754497885;4893.266010098479;4895.290182923492;5149.124648809711;5181.145111056671;5186.7147306898105;5191.688498690053;5220.791168353261;5681.801136960228;5741.483266505993;5754.97122514389;5757.68332741699;5765.1352297155345;5751;5803.7968671096305;5810.302763668345;5845.298564172326;5873.148393482921;5418.783248670048;5420.159875219308;5423.83728488146;5425.647332923387;5426.8914621707345;5650.802221922213;5815.9709201453725;5911.645301281937;5912.320083190402;5916.556258280646;5792.652440853562;5792.710364481759;5805.477507024388;5811.244538210006;5839.620424672383;5851.327097383855;5860.677662728591;5871.442212989759;5882.323532793698;5887.2052272943465;5596.692181930033;5639.956608027446;5755.280589926259;5813.680247586339;5865.94134058654;5764.452377024176;5765.85585360361;5769.480746732815;5778.653280803165;5782.681952492653;4418.977905110518;4426.490953540319;4431.62331201845;4441.489228738672;4449.644028477714;3905.6094390561284;3968.6229808168177;4001.7198796084576;4034.8184331705143;4062.370332598452;5516.724163791794;5527.088030475007;5541.778328866801;5544.528715059185;5548.4174161712435;5826.883462330729;5841.649501029951;5843.1235314703135;5864.091065884794;5894.734736936763;5391.191321301758;5475.534579560703;5514.641548299348;5559;5566.638168519034;4980.850574482772;4991.051700176955;5005.124103281911;5007.273945277914;5043.016611760745;5839.941600583939;6027.0356742921795;6038.30559485656;6041.667708275999;6043.607165534227;5741.081426971748;5821.214136091573;5838.065909454637;5842.532597392284;5853.765849366148;6082.11809287642;6090.3605121461605;6101.542384321105;6110.450059494667;6111;5642.210090587403;5674.74463649145;5788.594798364074;5799.971000144972;5802.361740208658;5736.799212027559;5791.044477661138;5794.0439827428;5816.592838501264;5833.504152146946;5622.240997465454;5629.802956896489;5632.464915832989;5638.436156384329;5640.915386269127;5585.832425027255;5649.435056494318;5662.943370566406;5663.461971112738;5773.220615216892;5490.5882058844945;5530.91703624454;5531.7234138293725;5546.889062218814;5558.416366281483;5605.1872478491205;5619.072852979212;5623.746931388016;5626.099824028136;5640.153976903333;5445.319335083114;5555.166724991283;5564.944350556442;5659.660420374791;5667.149927510906 23:44:47 INFO - PROCESS | 19501 | |1;ext.html;560.4059696721473;582.1326223926351;583.4719578781203;586.2730214533977;587.210202277936;32497.187570310754;33183.33633327332;41032.384514232275;41557.58442415575;41586.376204356886;44329.556704432944;44889;44962.55037449625;44965.55034449654;44967.55032449675;8754.737357879274;8984.326175536828;9010.414323069012;9011.594478248462;9021;8896.599653015597;9140.360174787767;9154.176124148826;9157.130072643089;9159.771005724877;9145.817083658323;9226.815463690722;9236.307276954221;9243.39917905334;9245.861312080324;8923.821523569492;8927.732168034969;8970.372073954793;8970.551472426418;8992.910070899272;9170.724878253663;9270.768230794216;9305.627774888997;9310.162085412345;9310.627574896997;43895.12209755787;44281;44283.77858110721;44374.55625443737;44398.33402498965;3818.369968955119;4037.6366127048414;4170.624643782044;4180.832766689329;4181.435506206653;32712.836435817906;34598.13504662403;34800.47799283013;34919;35271.82364088163;4221.451211342506;4316.2446571849805;4354.804033818486;4357.19391912494;4539.773011349419;239989;242054;242772;243639;244757;47242.29136562954;48134.518654813;66233.66883165554;68057;68249.65875170691;48688;49091.263631045564;49145.26282105771;49152.50847491551;49180.50819491831;14486.203258820866;14700;14715.55853324402;14718.705625887422;14729;11345.376004319842;11479.770404591862;11500.88499115015;11501.36742479155;11504;16339.83660163407;16396.344146234256;16451.341946322013;16454.095024773753;16484.83515164857;6281.654509002049;6359.809205723743;6376.426121649074;6379.840503987438;6430.292667806538;1023.7747695506977;1039.8076355874186;1065.7016035510069;1086.1310951239136;1129.4409267412684;30440;30483.542746858813;31367.84316078405;31503.21241968969;31541.684583153874;1069.390447444949;1103.9613613523488;1115.2750712037077;1141.8116010858282;1175.2889501851428;15581.376744930303;15819.68360632781;15981.522417946353;16078.43725469603;16175.595610109842;333543;337247;337484;338303;338945;58289.12566311509;58783;58791.4120858786;58824.41175588275;58828;1371.739369519788;1375.6217040313993;1441.128117488946;1441.8846492280593;1448.0877047460033;27559.586606201323;28286.85856570704;29567.191116843864;30395.088147355615;30411.391772163992;46062;46261.30608040949;46372;46416;46430.53569464262;223390;224291;224755;225194;225228;30310.84844575851;32826.34347313088;34891.65108348986;35214;35700.64299356973;41544.37683434811;42391;42478.78760606177;42984;42987.78506107449;34966.65033349736;35504.46743298801;36555.634443655224;37921.43117853179;38389.61610383972;37281.440778387805;37432.625673744005;37671.81164094162;38239.61760382361;38246.23507529778;34732.13169670779;34920.12699682528;35224.82387588046;35276.64723352836;36823;33110.83444582858;34113.14717132092;34829.825850870584;34871;34873.12817179591;26617.467650647264;26655;26690.332741681614;26834;26972.730272697023 23:44:47 INFO - PROCESS | 19501 | |2;jquery.html;361.2666287436503;366.18341099348453;370.70343725019984;374.69462388153636;377.7752237418735;17190.74213886791;17522.474325770214;18594.628107437842;18605;18612.255509779625;17152.82847171528;17455.563610909732;17599.82400175998;17612.119394030313;17625;5537.972310138443;5727.140928860684;5733.455321744427;5757.68332741699;5758.280214973129;4176.958230417687;5625.606207565472;6005.3093894202075;6259.467945224661;6259.874802503947;6211.9378806212035;6213.440790328869;6231.750729970796;6238.781642642509;6241.313455519912;6081.604695694788;6363.681815909186;6363.9045414318825;6370;6372.426481616653;3794.3739283018544;5208.114620514521;5364.409914909357;5417.539509141728;5552;21658.675119873216;21783;21847.126114955383;22214.555708885895;22216.777832221633;2209.4255493571627;2311.6301391777233;2385.7017872765905;2469.2468797016904;2470.0984140788664;13585.932070339684;14018.088824226495;14139.505117320845;14234.92882535591;14237.78643320351;1813.6916724156924;1847.4734700610395;1910.360029390156;1914.15777058094;1946.6009468059015;62948;63924.36075639231;64227;65172.3482765171;65686.67156664234;9690;9940.453275069796;10551.15590752738;10559.208059395576;10734.355938643706;13830.585082447542;13848.446062157602;13899.79150312746;13953.093048951785;14006.0896041759;7584.2794934481135;7677.61611919413;7682.615869206517;7694.038245219348;7843;7416.147143078615;7444.516106453063;7459.291367320096;7478.214787447239;7517.812054698677;4748.548887855648;4756.952430475721;4764.547368000034;4788.3056956741075;4805.207140821795;1797.532641513216;1806.3677712800677;1831.2217307644198;1905.627947877526;1929.8649094563245;942.6512190489562;1042.0048853345038;1065.0042210533022;1066.7653116314398;1067.9092277156374;15026.398944042334;16904.13255109259;17070.23183956725;17366.39217627377;17759.02325372117;846.2341580869323;949.943003419797;953.2231231546267;982.037603148918;1025.1747343388495;9600.087991640783;9646.131848133702;9737.318387712934;9739.464329461805;9878.851817222747;449509;452268;452889;469111;469406;72850.27149728542;73600.63199684075;77644.22355776482;80642;84267.15732842594;1029.6396261308632;1036.2073014144187;1047.4710271312938;1067.9786404272027;1075.6719200643722;15754.684906302038;15805.519657104302;15884.52346429609;15921.283542240395;16165.919170404073;21980.560388792455;24731.752682472947;34288.14279642929;34584.82707586446;35175.296494069466;48723.75638121787;49400.25899611581;49709;49770.502294976584;49964.500354997435;8102.959485202537;8227.670893164206;8316.209960053786;8440.071592124985;8622.913770862211;11583.478743456397;12433.93783031079;12805.679858003625;13461.394237259543;13682.31588420595;11313.321200727984;11681.357525336189;11841.703957401134;11857.703557410789;11998.100142489522;11724.237924534878;11806.291622502677;11910.344931028876;11964.64106076819;12200.938995304967;11262.324260544394;11302.717432064264;11616.767664646828;11621.593244236412;12148.86525948258;8417.368697347845;8451.704190353554;8456.957715211385;8493.702720405003;8843.734687959372;8859.60131794058;11087.556497740323;11497.137714671266;11635.941820290844;11681.415929203677 23:44:47 INFO - PROCESS | 19501 | |3;mootools.html;1377.7175678985795;1564.7965764450623;1572.9528114156572;1805.6388722255551;1928.8746231494943;8206.220409061138;8328.958355208222;8352.20654037867;8357.080721120672;8360.080391156984;8220.547869867154;8324.167583241673;8336.624851881665;8340.207680270365;8341.95829020854;2181.8690878547336;2239.0931672672596;2401.1595941420537;2408.7109546854404;2428.6599876017285;2479.429731161834;2486.1298545509017;2488.713797913236;2489.253224032792;2489.5020995800824;2412.348665860217;2447.1679628926163;2461.938451538708;2463.5442443147986;2464.125235541375;2354.023080421623;2367.9052837886466;2380.6667066610603;2430.963535546968;2431.3192306154306;2328.3247858121126;2360.78752912237;2441.9023239070416;2464.630305454178;2471.1598056660823;8616.181462761027;8701.17338852808;8702.869456958151;8711.128887111301;8713.259372953307;5209.921851172236;5318.574514038867;5327.653702509363;5372.462753724596;5374.220737993008;3295.7198638115788;3335.5663763710804;3402.302527981758;3404.063882432326;3408.625051244361;998.3710262534629;999.3903718731568;1011.3123076308108;1012.6961911426542;1057.0328149742977;12266.938665306616;12285.754284914341;12297.077719171099;12305.69235769104;12320.322382268881;4762.690425122356;4779.665423420397;4818.301346304766;4870.9269360959615;4871.29366241893;10357.223208259411;10404.479776011169;10408.583656653649;10435.634752783617;10439.895601044043;5369.382521010056;5375.301210842644;5421.512063914267;5428.457154284619;5430.239766432703;4303.505096913832;4563.361129441881;4666.066786642685;4703.223968045234;4712.246040633482;4006.016864860641;4060.7766572838777;4081.0409553754844;4119.423280740699;4130;1288.8066789981578;1331.1547167548483;1349.203969657887;1352.134633834347;1361.251311778518;1414.4200877640324;1423.2599048494724;1439.964000899965;1460.7662773956115;1468.3392473387019;8234.135415781377;8356.874646880302;8370.288525475282;8436.662533498715;8450;503.7330214986063;510.79568172731206;511.5651696058395;512.515672689305;513.2378418049194;6218.6268823869805;6264.154339164154;6280.937190628035;6320.336364681734;6321.304656487782;10451.111655509367;10814.29707069038;10826.404547749791;10838.132949364031;10848.132149428027;10353.275270730977;10495.160387169008;10603.787924241473;10657.360558366368;10672.30630009047;8178.795530111675;8222.671093156207;8243;8334.749957501284;8339.749807505785;7830.725924592612;7839.25527074927;7856.921430785619;7981.3614910808155;8041.155678653658;9246.907530924873;9419.152276295166;9460.243180545678;9555.761105972128;9571.425714457155;9662.227021838376;9781.364211326241;9904.752381190528;9924.255680824112;9987.500624968578;6349.07938348946;7076.256993015865;7293.744718934812;7836.725714599962;7881.369490440637;8142.7557173284895;8145.266925976691;8150.510969341858;8157.388195885451;8217.465864718773;6943.583384996917;7170.533915295489;7175.533590316612;7215;7357.484976051625;6947.61788101639;6955.200151982587;7057.894131587927;7064.434845212473;7075.681594328371;7712.151663317143;7850.489718168301;7869.527828330319;7870.803229919298;7880.605969701606;6973.163220413583;6997.580145191305;7024.192217895007;7165.641717914188;7178.389836863925;6672.332766723289;6777.288384719731;6790.287019862843;6792.049113124068;7090.4682148840075 23:44:47 INFO - PROCESS | 19501 | |4;prototype.html;343.597990351289;350.1613635343354;350.3885719419613;351.28864050298154;355.74386441761925;5939;5947.226860508139;5970.970145149268;6016.067509536024;6022.728977196031;5879.941200587993;5896.410358964102;5902.734376953037;5903.911441328383;5911.408859114086;4414.7351158930405;4496.482904465979;4571.337156112353;4576.130535198318;4586.656000799953;4585.2663573828195;4587.931181032287;4589.609883159918;4602.194615942213;4603.4015577974815;4548.31775233716;4555.681102322822;4558.339040839076;4567.474740404846;4574.6569007324415;4396.758178300192;4451.933221001671;4534.6372290216705;4538.72767633943;4542.2051141050515;3989.740666856645;3994.380870965005;4000.6399424051974;4003.619656132663;4024.436578878959;5562.193481945135;5562.3881373048935;5565.109582466826;5565.666060036411;5568.248286481355;5286.6035047371215;5293.867653308698;5299.576033917316;5300.602454815866;5302.390225124122;6234.345393733638;6240.063990401431;6240.937590624081;6243.968780156116;6254.249490061176;4248.723832950879;4370.409994650713;4379.4525684289465;4448.955510444886;4454.910901781946;6504.902426463606;6539.869202615969;6545.803625891231;6581.7367305307735;6585.275619681831;4432.955670443319;4436.866893993185;4439.289713645801;4442.244818380883;4442.800073996678;4499.955000449953;4502.257127573979;4506.504284528699;4507.18870603288;4510.548945105529;5217.426083130853;5219;5221.477852214748;5221.738913054332;5226.764795584208;6132.386761323921;6310.242770867433;6322.683865806691;6323.936760632427;6333.1450254216015;1569.995203070036;1579.202502736134;1592.6018495376156;1593.05213398028;1594.290540709373;1009.934354266985;1028.4857571214393;1031.2677998620914;1059.9771220771993;1079.8272276435732;6080.7567697291615;6101.115338276014;6110.29731580865;6111.816645500642;6113.724882380304;6445.807525607777;6446.935530644633;6489.8702025960165;6492.480601551864;6492.935070649328;6126.816195514141;6130.570860039755;6132.264128304632;6141.815745527641;6143.354947730513;3464.2378676691087;3489.9127521812156;3496.8076755778675;3497.0557949354043;3498.5801703795705;6616.073749675049;6744.190697116377;6757.493188010919;6779.186497620317;6785.491088168308;6515.120458738104;6571.080048793077;6572.34276572339;6578.243501997236;6585.242697089896;6739.898901516482;6749.392554670103;6752.155980502437;6760.121184246115;6770.593764374054;6454.67726613658;6457.4511166551365;6459.289478157493;6463;6473.417392434515;6252.718192770562;6345.96827015862;6355.809325720235;6359.077933699495;6498.187726534184;6881;6891.689873955785;6922.826929326807;6927.995440660975;6932.133483314586;4455.376247325312;4491.438570178728;4492.236319825703;4500.617447516997;4505.707129036602;6573.5398522103;6585.111010013587;6585.80242592723;6588.341165883373;6597.0434287029075;6394.26465956421;6396.360363963567;6397.744090236339;6403.135576697273;6408.231012278557;6183.412575805291;6360;6373.649449280334;6393.6483493408305;6394.23269207698;6229;6256.562040657111;6289.962156244169;6292.748290068529;6298.401651843067;6408.935910640834;6414.807555773335;6417.839554011187;6418.19772528434;6419.486441084796;6009.789657361971;6129.295131059986;6240.4071613196675;6252.218472690914;6259.2488901332135 23:44:47 INFO - PROCESS | 19501 | |5;yui.html;822.5763731678187;877.2280393253935;905.2983937448477;930.2325581395343;931.501646619059;15013.249337533121;15133.09201447914;15148.394064237416;15160.848391516096;15227.467038653636;13094.541691040815;14028.719425611482;14096.64758381041;14180.858191418083;14238;758.4387553210639;909.9090090990915;919.4850883505259;924.1636319131197;925.842606756853;900.5722281916103;928.7770934975591;930.3208657679897;931.3154831199063;931.5994122527311;962.5043102802063;967.8596603492489;971.9514024298792;972.1687956796943;972.9367591106555;776.561242897761;933.8599210118468;957.9042095790435;958.4249450329816;963.6916186820221;701.0850839654249;705.7988473285141;706.6360824175554;709.2446544430165;709.2765379313123;14744.336504857307;14778.926105369512;14839.183844888526;14844.70310593793;14882.479113231093;13732.244726540037;13844.723105537934;14079.577612671636;14127.505537306144;14255.358508867126;11596.362200078993;11656.650300491;11657.358845263507;11728.35494047827;11998.880011199864;3873.748206366577;3897.8830635080994;3907.824147913322;3914.7846868422225;3916.6475017248586;51543;51664.22503662448;54379;54406.18390724103;54663.72668136634;11421.657350279505;11718.589849355232;11884.286942783461;12002.819957700467;12198.207116537396;20007.399778006682;20165.09257083435;20166.39500814978;20183.596328073356;20200.49498762543;8293.585320733939;8356.749297521084;8603.139686031347;8665.566721664018;8950.462972221687;4527.230370836965;4528.932066019012;4589.747563883951;4604.861854144381;4714.764261786897;3489;3501.9299614008087;3513.7013353864695;3515.8417871195857;3520.3663340598428;622.3558616831558;629.7008920762601;630.6499892559674;648.6594537867563;656.8193746719691;583.7723287917715;598.3597550620881;686.9347411995852;760.4106817216701;768.3776141325544;8686.305095592337;8903.243224325875;8907.910920890708;8950.507722075348;9038.276937844958;643.2217017408988;654.9770758023446;659.3637140159769;699.989500157498;707.8407358344331;3773.735838491334;3819.102510909934;3835.8082095895093;4069.816858241327;4082.9183416331507;56886.7155664219;57327.71336143376;57429.13856292159;59149.70425147933;59473;51937.48062519402;52677.736611317465;52693.73653131787;53213;54269;45924;48096.7595162022;48587;48783;49190.262146067835;7308.342249197598;7392.926070739224;7474.177840437439;7493.662785174572;7517.060367454068;35944.101397465274;36327.81836090803;36438.81780591186;37033.44449833308;37259.44110838285;40561;40564.18871622492;44669;45967.310490342;46695.533044669115;10843.512041957973;11151.665450036511;11223.214374993671;11236.213465057368;11330.546778128783;11081;11088.33469991803;11120;11176.608818691308;11480.885191147981;10749.032587067202;10784.676459706221;10833.241673082808;11082.279651822606;11216.878312168717;10615;10869.565217391215;10917.781644367227;10958.616448424267;11024.559017639525;10089.293749437762;10276.845847312446;10316.535755890853;10389.48052597352;10439.321444106108;8888.422252553562;9089.045650206897;9107.499087549983;9288.442693438416;9460.479673618018;8718.82562348762;9298.72103836886;9323.673671421468;9350.111739384747;9394.812103758024 23:44:47 INFO - PROCESS | 19501 | __end_tp_report 23:44:47 INFO - PROCESS | 19501 | __start_cc_report 23:44:47 INFO - PROCESS | 19501 | _x_x_mozilla_cycle_collect,863 23:44:47 INFO - PROCESS | 19501 | __end_cc_report 23:44:47 INFO - PROCESS | 19501 | __startTimestamp1459493087664__endTimestamp 23:44:47 INFO - PROCESS | 19501 | 23:44:47 INFO - PROCESS | 19501 | ------- Summary: start ------- 23:44:47 INFO - PROCESS | 19501 | Number of tests: 6 23:44:47 INFO - PROCESS | 19501 | 23:44:47 INFO - PROCESS | 19501 | [#0] dojo.html Cycles:165 Average:5384.61 Median:5566.64 stddev:590.83 (10.6%) stddev-sans-first:568.57 23:44:47 INFO - PROCESS | 19501 | Values: 3256.5 3341.2 3345.5 3359.7 3388.2 5344.2 5351.7 5362.0 5367.5 5381.7 5355.2 5362.7 5377.5 5385.1 5395.4 4808.1 4941.1 4949.0 4979.3 5020.4 4824.8 4883.0 4913.2 4958.8 5005.5 4946.2 4962.7 4963.9 4966.4 5000.2 4892.7 4915.8 4939.1 4961.9 4963.4 4796.3 4814.1 4877.0 4893.3 4895.3 5149.1 5181.1 5186.7 5191.7 5220.8 5681.8 5741.5 5755.0 5757.7 5765.1 5751.0 5803.8 5810.3 5845.3 5873.1 5418.8 5420.2 5423.8 5425.6 5426.9 5650.8 5816.0 5911.6 5912.3 5916.6 5792.7 5792.7 5805.5 5811.2 5839.6 5851.3 5860.7 5871.4 5882.3 5887.2 5596.7 5640.0 5755.3 5813.7 5865.9 5764.5 5765.9 5769.5 5778.7 5782.7 4419.0 4426.5 4431.6 4441.5 4449.6 3905.6 3968.6 4001.7 4034.8 4062.4 5516.7 5527.1 5541.8 5544.5 5548.4 5826.9 5841.6 5843.1 5864.1 5894.7 5391.2 5475.5 5514.6 5559.0 5566.6 4980.9 4991.1 5005.1 5007.3 5043.0 5839.9 6027.0 6038.3 6041.7 6043.6 5741.1 5821.2 5838.1 5842.5 5853.8 6082.1 6090.4 6101.5 6110.5 6111.0 5642.2 5674.7 5788.6 5800.0 5802.4 5736.8 5791.0 5794.0 5816.6 5833.5 5622.2 5629.8 5632.5 5638.4 5640.9 5585.8 5649.4 5662.9 5663.5 5773.2 5490.6 5530.9 5531.7 5546.9 5558.4 5605.2 5619.1 5623.7 5626.1 5640.2 5445.3 5555.2 5564.9 5659.7 5667.1 23:44:47 INFO - PROCESS | 19501 | 23:44:47 INFO - PROCESS | 19501 | [#1] ext.html Cycles:180 Average:44721.61 Median:37357.03 stddev:71157.72 (190.5%) stddev-sans-first:71280.08 23:44:47 INFO - PROCESS | 19501 | Values: 560.4 582.1 583.5 586.3 587.2 32497.2 33183.3 41032.4 41557.6 41586.4 44329.6 44889.0 44962.6 44965.6 44967.6 8754.7 8984.3 9010.4 9011.6 9021.0 8896.6 9140.4 9154.2 9157.1 9159.8 9145.8 9226.8 9236.3 9243.4 9245.9 8923.8 8927.7 8970.4 8970.6 8992.9 9170.7 9270.8 9305.6 9310.2 9310.6 43895.1 44281.0 44283.8 44374.6 44398.3 3818.4 4037.6 4170.6 4180.8 4181.4 32712.8 34598.1 34800.5 34919.0 35271.8 4221.5 4316.2 4354.8 4357.2 4539.8 239989.0 242054.0 242772.0 243639.0 244757.0 47242.3 48134.5 66233.7 68057.0 68249.7 48688.0 49091.3 49145.3 49152.5 49180.5 14486.2 14700.0 14715.6 14718.7 14729.0 11345.4 11479.8 11500.9 11501.4 11504.0 16339.8 16396.3 16451.3 16454.1 16484.8 6281.7 6359.8 6376.4 6379.8 6430.3 1023.8 1039.8 1065.7 1086.1 1129.4 30440.0 30483.5 31367.8 31503.2 31541.7 1069.4 1104.0 1115.3 1141.8 1175.3 15581.4 15819.7 15981.5 16078.4 16175.6 333543.0 337247.0 337484.0 338303.0 338945.0 58289.1 58783.0 58791.4 58824.4 58828.0 1371.7 1375.6 1441.1 1441.9 1448.1 27559.6 28286.9 29567.2 30395.1 30411.4 46062.0 46261.3 46372.0 46416.0 46430.5 223390.0 224291.0 224755.0 225194.0 225228.0 30310.8 32826.3 34891.7 35214.0 35700.6 41544.4 42391.0 42478.8 42984.0 42987.8 34966.7 35504.5 36555.6 37921.4 38389.6 37281.4 37432.6 37671.8 38239.6 38246.2 34732.1 34920.1 35224.8 35276.6 36823.0 33110.8 34113.1 34829.8 34871.0 34873.1 26617.5 26655.0 26690.3 26834.0 26972.7 23:44:47 INFO - PROCESS | 19501 | 23:44:47 INFO - PROCESS | 19501 | [#2] jquery.html Cycles:180 Average:26472.96 Median:34880.06 stddev:75156.36 (215.5%) stddev-sans-first:75341.62 23:44:47 INFO - PROCESS | 19501 | Values: 361.3 366.2 370.7 374.7 377.8 17190.7 17522.5 18594.6 18605.0 18612.3 17152.8 17455.6 17599.8 17612.1 17625.0 5538.0 5727.1 5733.5 5757.7 5758.3 4177.0 5625.6 6005.3 6259.5 6259.9 6211.9 6213.4 6231.8 6238.8 6241.3 6081.6 6363.7 6363.9 6370.0 6372.4 3794.4 5208.1 5364.4 5417.5 5552.0 21658.7 21783.0 21847.1 22214.6 22216.8 2209.4 2311.6 2385.7 2469.2 2470.1 13585.9 14018.1 14139.5 14234.9 14237.8 1813.7 1847.5 1910.4 1914.2 1946.6 62948.0 63924.4 64227.0 65172.3 65686.7 9690.0 9940.5 10551.2 10559.2 10734.4 13830.6 13848.4 13899.8 13953.1 14006.1 7584.3 7677.6 7682.6 7694.0 7843.0 7416.1 7444.5 7459.3 7478.2 7517.8 4748.5 4757.0 4764.5 4788.3 4805.2 1797.5 1806.4 1831.2 1905.6 1929.9 942.7 1042.0 1065.0 1066.8 1067.9 15026.4 16904.1 17070.2 17366.4 17759.0 846.2 949.9 953.2 982.0 1025.2 9600.1 9646.1 9737.3 9739.5 9878.9 449509.0 452268.0 452889.0 469111.0 469406.0 72850.3 73600.6 77644.2 80642.0 84267.2 1029.6 1036.2 1047.5 1068.0 1075.7 15754.7 15805.5 15884.5 15921.3 16165.9 21980.6 24731.8 34288.1 34584.8 35175.3 48723.8 49400.3 49709.0 49770.5 49964.5 8103.0 8227.7 8316.2 8440.1 8622.9 11583.5 12433.9 12805.7 13461.4 13682.3 11313.3 11681.4 11841.7 11857.7 11998.1 11724.2 11806.3 11910.3 11964.6 12200.9 11262.3 11302.7 11616.8 11621.6 12148.9 8417.4 8451.7 8457.0 8493.7 8843.7 8859.6 11087.6 11497.1 11635.9 11681.4 23:44:47 INFO - PROCESS | 19501 | 23:44:47 INFO - PROCESS | 19501 | [#3] mootools.html Cycles:180 Average:6012.52 Median:5348.52 stddev:3221.88 (60.2%) stddev-sans-first:3212.08 23:44:47 INFO - PROCESS | 19501 | Values: 1377.7 1564.8 1573.0 1805.6 1928.9 8206.2 8329.0 8352.2 8357.1 8360.1 8220.5 8324.2 8336.6 8340.2 8342.0 2181.9 2239.1 2401.2 2408.7 2428.7 2479.4 2486.1 2488.7 2489.3 2489.5 2412.3 2447.2 2461.9 2463.5 2464.1 2354.0 2367.9 2380.7 2431.0 2431.3 2328.3 2360.8 2441.9 2464.6 2471.2 8616.2 8701.2 8702.9 8711.1 8713.3 5209.9 5318.6 5327.7 5372.5 5374.2 3295.7 3335.6 3402.3 3404.1 3408.6 998.4 999.4 1011.3 1012.7 1057.0 12266.9 12285.8 12297.1 12305.7 12320.3 4762.7 4779.7 4818.3 4870.9 4871.3 10357.2 10404.5 10408.6 10435.6 10439.9 5369.4 5375.3 5421.5 5428.5 5430.2 4303.5 4563.4 4666.1 4703.2 4712.2 4006.0 4060.8 4081.0 4119.4 4130.0 1288.8 1331.2 1349.2 1352.1 1361.3 1414.4 1423.3 1440.0 1460.8 1468.3 8234.1 8356.9 8370.3 8436.7 8450.0 503.7 510.8 511.6 512.5 513.2 6218.6 6264.2 6280.9 6320.3 6321.3 10451.1 10814.3 10826.4 10838.1 10848.1 10353.3 10495.2 10603.8 10657.4 10672.3 8178.8 8222.7 8243.0 8334.7 8339.7 7830.7 7839.3 7856.9 7981.4 8041.2 9246.9 9419.2 9460.2 9555.8 9571.4 9662.2 9781.4 9904.8 9924.3 9987.5 6349.1 7076.3 7293.7 7836.7 7881.4 8142.8 8145.3 8150.5 8157.4 8217.5 6943.6 7170.5 7175.5 7215.0 7357.5 6947.6 6955.2 7057.9 7064.4 7075.7 7712.2 7850.5 7869.5 7870.8 7880.6 6973.2 6997.6 7024.2 7165.6 7178.4 6672.3 6777.3 6790.3 6792.0 7090.5 23:44:47 INFO - PROCESS | 19501 | 23:44:47 INFO - PROCESS | 19501 | [#4] prototype.html Cycles:180 Average:5283.23 Median:6051.74 stddev:1597.83 (26.4%) stddev-sans-first:1558.71 23:44:47 INFO - PROCESS | 19501 | Values: 343.6 350.2 350.4 351.3 355.7 5939.0 5947.2 5971.0 6016.1 6022.7 5879.9 5896.4 5902.7 5903.9 5911.4 4414.7 4496.5 4571.3 4576.1 4586.7 4585.3 4587.9 4589.6 4602.2 4603.4 4548.3 4555.7 4558.3 4567.5 4574.7 4396.8 4451.9 4534.6 4538.7 4542.2 3989.7 3994.4 4000.6 4003.6 4024.4 5562.2 5562.4 5565.1 5565.7 5568.2 5286.6 5293.9 5299.6 5300.6 5302.4 6234.3 6240.1 6240.9 6244.0 6254.2 4248.7 4370.4 4379.5 4449.0 4454.9 6504.9 6539.9 6545.8 6581.7 6585.3 4433.0 4436.9 4439.3 4442.2 4442.8 4500.0 4502.3 4506.5 4507.2 4510.5 5217.4 5219.0 5221.5 5221.7 5226.8 6132.4 6310.2 6322.7 6323.9 6333.1 1570.0 1579.2 1592.6 1593.1 1594.3 1009.9 1028.5 1031.3 1060.0 1079.8 6080.8 6101.1 6110.3 6111.8 6113.7 6445.8 6446.9 6489.9 6492.5 6492.9 6126.8 6130.6 6132.3 6141.8 6143.4 3464.2 3489.9 3496.8 3497.1 3498.6 6616.1 6744.2 6757.5 6779.2 6785.5 6515.1 6571.1 6572.3 6578.2 6585.2 6739.9 6749.4 6752.2 6760.1 6770.6 6454.7 6457.5 6459.3 6463.0 6473.4 6252.7 6346.0 6355.8 6359.1 6498.2 6881.0 6891.7 6922.8 6928.0 6932.1 4455.4 4491.4 4492.2 4500.6 4505.7 6573.5 6585.1 6585.8 6588.3 6597.0 6394.3 6396.4 6397.7 6403.1 6408.2 6183.4 6360.0 6373.6 6393.6 6394.2 6229.0 6256.6 6290.0 6292.7 6298.4 6408.9 6414.8 6417.8 6418.2 6419.5 6009.8 6129.3 6240.4 6252.2 6259.2 23:44:47 INFO - PROCESS | 19501 | 23:44:47 INFO - PROCESS | 19501 | [#5] yui.html Cycles:180 Average:14314.42 Median:26405.76 stddev:16530.17 (62.6%) stddev-sans-first:16545.49 23:44:47 INFO - PROCESS | 19501 | Values: 822.6 877.2 905.3 930.2 931.5 15013.2 15133.1 15148.4 15160.8 15227.5 13094.5 14028.7 14096.6 14180.9 14238.0 758.4 909.9 919.5 924.2 925.8 900.6 928.8 930.3 931.3 931.6 962.5 967.9 972.0 972.2 972.9 776.6 933.9 957.9 958.4 963.7 701.1 705.8 706.6 709.2 709.3 14744.3 14778.9 14839.2 14844.7 14882.5 13732.2 13844.7 14079.6 14127.5 14255.4 11596.4 11656.7 11657.4 11728.4 11998.9 3873.7 3897.9 3907.8 3914.8 3916.6 51543.0 51664.2 54379.0 54406.2 54663.7 11421.7 11718.6 11884.3 12002.8 12198.2 20007.4 20165.1 20166.4 20183.6 20200.5 8293.6 8356.7 8603.1 8665.6 8950.5 4527.2 4528.9 4589.7 4604.9 4714.8 3489.0 3501.9 3513.7 3515.8 3520.4 622.4 629.7 630.6 648.7 656.8 583.8 598.4 686.9 760.4 768.4 8686.3 8903.2 8907.9 8950.5 9038.3 643.2 655.0 659.4 700.0 707.8 3773.7 3819.1 3835.8 4069.8 4082.9 56886.7 57327.7 57429.1 59149.7 59473.0 51937.5 52677.7 52693.7 53213.0 54269.0 45924.0 48096.8 48587.0 48783.0 49190.3 7308.3 7392.9 7474.2 7493.7 7517.1 35944.1 36327.8 36438.8 37033.4 37259.4 40561.0 40564.2 44669.0 45967.3 46695.5 10843.5 11151.7 11223.2 11236.2 11330.5 11081.0 11088.3 11120.0 11176.6 11480.9 10749.0 10784.7 10833.2 11082.3 11216.9 10615.0 10869.6 10917.8 10958.6 11024.6 10089.3 10276.8 10316.5 10389.5 10439.3 8888.4 9089.0 9107.5 9288.4 9460.5 8718.8 9298.7 9323.7 9350.1 9394.8 23:44:47 INFO - PROCESS | 19501 | -------- Summary: end -------- 23:44:47 INFO - PROCESS | 19501 | 23:44:48 INFO - TEST-INFO | 19501: exit 0 23:44:48 INFO - TEST-OK | dromaeo_css | took 1110300ms 23:44:48 INFO - TEST-START | kraken 23:44:48 INFO - operating with platform_type : linux_ 23:44:48 INFO - Initialising browser for kraken test... 23:44:48 INFO - TEST-INFO | started process 19697 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxczkUk/profile http://localhost:60571/getInfo.html) 23:44:51 INFO - PROCESS | 19697 | __metrics Screen width/height:1600/1200 23:44:51 INFO - PROCESS | 19697 | colorDepth:24 23:44:51 INFO - PROCESS | 19697 | Browser inner width/height: 1024/697 23:44:51 INFO - PROCESS | 19697 | __metrics 23:44:52 INFO - PROCESS | 19697 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:44:53 INFO - TEST-INFO | 19697: exit 0 23:44:53 INFO - Browser initialized. 23:44:53 INFO - Running cycle 1/1 for kraken test... 23:44:53 INFO - TEST-INFO | started process 19787 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxczkUk/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:45:05 INFO - PROCESS | 19787 | RSS: Main: 145154048 23:45:05 INFO - PROCESS | 19787 | 23:45:07 INFO - PROCESS | 19787 | Cycle 1(1): loaded http://localhost:60571/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60571/tests/kraken/driver.html?testName=audio-beat-detection) 23:45:08 INFO - PROCESS | 19787 | RSS: Main: 179679232 23:45:08 INFO - PROCESS | 19787 | 23:45:10 INFO - PROCESS | 19787 | Cycle 1(1): loaded http://localhost:60571/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60571/tests/kraken/driver.html?testName=audio-dft) 23:45:11 INFO - PROCESS | 19787 | RSS: Main: 178405376 23:45:11 INFO - PROCESS | 19787 | 23:45:14 INFO - PROCESS | 19787 | Cycle 1(1): loaded http://localhost:60571/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60571/tests/kraken/driver.html?testName=audio-fft) 23:45:14 INFO - PROCESS | 19787 | RSS: Main: 174166016 23:45:14 INFO - PROCESS | 19787 | 23:45:16 INFO - PROCESS | 19787 | Cycle 1(1): loaded http://localhost:60571/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60571/tests/kraken/driver.html?testName=audio-oscillator) 23:45:17 INFO - PROCESS | 19787 | RSS: Main: 175423488 23:45:17 INFO - PROCESS | 19787 | 23:45:19 INFO - PROCESS | 19787 | Cycle 1(1): loaded http://localhost:60571/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60571/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:45:19 INFO - PROCESS | 19787 | RSS: Main: 175198208 23:45:19 INFO - PROCESS | 19787 | 23:45:22 INFO - PROCESS | 19787 | Cycle 1(1): loaded http://localhost:60571/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60571/tests/kraken/driver.html?testName=imaging-darkroom) 23:45:23 INFO - PROCESS | 19787 | RSS: Main: 174075904 23:45:23 INFO - PROCESS | 19787 | 23:45:26 INFO - PROCESS | 19787 | Cycle 1(1): loaded http://localhost:60571/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60571/tests/kraken/driver.html?testName=imaging-desaturate) 23:45:27 INFO - PROCESS | 19787 | RSS: Main: 173723648 23:45:27 INFO - PROCESS | 19787 | 23:45:30 INFO - PROCESS | 19787 | Cycle 1(1): loaded http://localhost:60571/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60571/tests/kraken/driver.html?testName=json-parse-financial) 23:45:30 INFO - PROCESS | 19787 | RSS: Main: 172433408 23:45:30 INFO - PROCESS | 19787 | 23:45:32 INFO - PROCESS | 19787 | Cycle 1(1): loaded http://localhost:60571/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60571/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:45:32 INFO - PROCESS | 19787 | RSS: Main: 178089984 23:45:32 INFO - PROCESS | 19787 | 23:45:34 INFO - PROCESS | 19787 | Cycle 1(1): loaded http://localhost:60571/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60571/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:45:35 INFO - PROCESS | 19787 | RSS: Main: 175308800 23:45:35 INFO - PROCESS | 19787 | 23:45:37 INFO - PROCESS | 19787 | Cycle 1(1): loaded http://localhost:60571/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60571/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:45:37 INFO - PROCESS | 19787 | RSS: Main: 180977664 23:45:37 INFO - PROCESS | 19787 | 23:45:40 INFO - PROCESS | 19787 | Cycle 1(1): loaded http://localhost:60571/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60571/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:45:40 INFO - PROCESS | 19787 | RSS: Main: 191184896 23:45:40 INFO - PROCESS | 19787 | 23:45:43 INFO - PROCESS | 19787 | Cycle 1(1): loaded http://localhost:60571/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60571/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:45:43 INFO - PROCESS | 19787 | RSS: Main: 190390272 23:45:43 INFO - PROCESS | 19787 | 23:45:45 INFO - PROCESS | 19787 | Cycle 1(1): loaded http://localhost:60571/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60571/tests/kraken/driver.html?testName=ai-astar) 23:45:45 INFO - PROCESS | 19787 | RSS: Main: 249876480 23:45:45 INFO - PROCESS | 19787 | 23:45:45 INFO - PROCESS | 19787 | __start_tp_report 23:45:45 INFO - PROCESS | 19787 | _x_x_mozilla_page_load 23:45:45 INFO - PROCESS | 19787 | _x_x_mozilla_page_load_details 23:45:45 INFO - PROCESS | 19787 | |i|pagename|runs| 23:45:45 INFO - PROCESS | 19787 | |0;ai-astar;108;110;106;108;108;110;100;109;109;110 23:45:45 INFO - PROCESS | 19787 | |1;audio-beat-detection;156;125;149;161;127;148;149;127;178;127 23:45:45 INFO - PROCESS | 19787 | |2;audio-dft;160;161;160;159;160;159;159;165;162;159 23:45:45 INFO - PROCESS | 19787 | |3;audio-fft;74;75;76;158;75;76;73;74;162;76 23:45:45 INFO - PROCESS | 19787 | |4;audio-oscillator;93;93;144;93;93;93;146;92;93;147 23:45:45 INFO - PROCESS | 19787 | |5;imaging-gaussian-blur;117;116;116;117;117;116;116;117;117;117 23:45:45 INFO - PROCESS | 19787 | |6;imaging-darkroom;145;146;145;146;147;145;146;146;145;145 23:45:45 INFO - PROCESS | 19787 | |7;imaging-desaturate;95;96;95;95;97;95;96;96;95;94 23:45:45 INFO - PROCESS | 19787 | |8;json-parse-financial;53;54;53;53;55;54;55;63;53;52 23:45:45 INFO - PROCESS | 19787 | |9;json-stringify-tinderbox;63;64;64;64;65;65;65;64;65;64 23:45:45 INFO - PROCESS | 19787 | |10;stanford-crypto-aes;76;86;78;79;78;77;76;76;77;77 23:45:45 INFO - PROCESS | 19787 | |11;stanford-crypto-ccm;112;109;108;118;113;110;111;111;119;111 23:45:45 INFO - PROCESS | 19787 | |12;stanford-crypto-pbkdf2;144;142;142;144;139;132;149;143;142;141 23:45:45 INFO - PROCESS | 19787 | |13;stanford-crypto-sha256-iterative;65;65;66;65;65;65;68;70;68;63 23:45:45 INFO - PROCESS | 19787 | __end_tp_report 23:45:45 INFO - PROCESS | 19787 | __start_cc_report 23:45:45 INFO - PROCESS | 19787 | _x_x_mozilla_cycle_collect,1072 23:45:45 INFO - PROCESS | 19787 | __end_cc_report 23:45:45 INFO - PROCESS | 19787 | __startTimestamp1459493145821__endTimestamp 23:45:45 INFO - PROCESS | 19787 | 23:45:45 INFO - PROCESS | 19787 | ------- Summary: start ------- 23:45:45 INFO - PROCESS | 19787 | Number of tests: 14 23:45:45 INFO - PROCESS | 19787 | 23:45:45 INFO - PROCESS | 19787 | [#0] ai-astar Cycles:10 Average:107.80 Median:109.00 stddev:3.01 (2.8%) stddev-sans-first:3.19 23:45:45 INFO - PROCESS | 19787 | Values: 108.0 110.0 106.0 108.0 108.0 110.0 100.0 109.0 109.0 110.0 23:45:45 INFO - PROCESS | 19787 | 23:45:45 INFO - PROCESS | 19787 | [#1] audio-beat-detection Cycles:10 Average:144.70 Median:149.00 stddev:17.88 (12.0%) stddev-sans-first:18.49 23:45:45 INFO - PROCESS | 19787 | Values: 156.0 125.0 149.0 161.0 127.0 148.0 149.0 127.0 178.0 127.0 23:45:45 INFO - PROCESS | 19787 | 23:45:45 INFO - PROCESS | 19787 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.00 stddev:1.90 (1.2%) stddev-sans-first:2.01 23:45:45 INFO - PROCESS | 19787 | Values: 160.0 161.0 160.0 159.0 160.0 159.0 159.0 165.0 162.0 159.0 23:45:45 INFO - PROCESS | 19787 | 23:45:45 INFO - PROCESS | 19787 | [#3] audio-fft Cycles:10 Average:91.90 Median:75.00 stddev:35.92 (47.9%) stddev-sans-first:37.51 23:45:45 INFO - PROCESS | 19787 | Values: 74.0 75.0 76.0 158.0 75.0 76.0 73.0 74.0 162.0 76.0 23:45:45 INFO - PROCESS | 19787 | 23:45:45 INFO - PROCESS | 19787 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:93.00 stddev:25.52 (27.4%) stddev-sans-first:26.43 23:45:45 INFO - PROCESS | 19787 | Values: 93.0 93.0 144.0 93.0 93.0 93.0 146.0 92.0 93.0 147.0 23:45:45 INFO - PROCESS | 19787 | 23:45:45 INFO - PROCESS | 19787 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 23:45:45 INFO - PROCESS | 19787 | Values: 117.0 116.0 116.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 23:45:45 INFO - PROCESS | 19787 | 23:45:45 INFO - PROCESS | 19787 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 23:45:45 INFO - PROCESS | 19787 | Values: 145.0 146.0 145.0 146.0 147.0 145.0 146.0 146.0 145.0 145.0 23:45:45 INFO - PROCESS | 19787 | 23:45:45 INFO - PROCESS | 19787 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.84 (0.9%) stddev-sans-first:0.88 23:45:45 INFO - PROCESS | 19787 | Values: 95.0 96.0 95.0 95.0 97.0 95.0 96.0 96.0 95.0 94.0 23:45:45 INFO - PROCESS | 19787 | 23:45:45 INFO - PROCESS | 19787 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.00 stddev:3.14 (5.8%) stddev-sans-first:3.28 23:45:45 INFO - PROCESS | 19787 | Values: 53.0 54.0 53.0 53.0 55.0 54.0 55.0 63.0 53.0 52.0 23:45:45 INFO - PROCESS | 19787 | 23:45:45 INFO - PROCESS | 19787 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.50 stddev:0.67 (1.0%) stddev-sans-first:0.53 23:45:45 INFO - PROCESS | 19787 | Values: 63.0 64.0 64.0 64.0 65.0 65.0 65.0 64.0 65.0 64.0 23:45:45 INFO - PROCESS | 19787 | 23:45:45 INFO - PROCESS | 19787 | [#10] stanford-crypto-aes Cycles:10 Average:78.00 Median:77.50 stddev:2.98 (3.8%) stddev-sans-first:3.07 23:45:45 INFO - PROCESS | 19787 | Values: 76.0 86.0 78.0 79.0 78.0 77.0 76.0 76.0 77.0 77.0 23:45:45 INFO - PROCESS | 19787 | 23:45:45 INFO - PROCESS | 19787 | [#11] stanford-crypto-ccm Cycles:10 Average:112.20 Median:111.50 stddev:3.61 (3.2%) stddev-sans-first:3.83 23:45:45 INFO - PROCESS | 19787 | Values: 112.0 109.0 108.0 118.0 113.0 110.0 111.0 111.0 119.0 111.0 23:45:45 INFO - PROCESS | 19787 | 23:45:45 INFO - PROCESS | 19787 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.80 Median:142.50 stddev:4.32 (3.0%) stddev-sans-first:4.50 23:45:45 INFO - PROCESS | 19787 | Values: 144.0 142.0 142.0 144.0 139.0 132.0 149.0 143.0 142.0 141.0 23:45:45 INFO - PROCESS | 19787 | 23:45:45 INFO - PROCESS | 19787 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:65.50 stddev:2.05 (3.1%) stddev-sans-first:2.15 23:45:45 INFO - PROCESS | 19787 | Values: 65.0 65.0 66.0 65.0 65.0 65.0 68.0 70.0 68.0 63.0 23:45:45 INFO - PROCESS | 19787 | -------- Summary: end -------- 23:45:45 INFO - PROCESS | 19787 | 23:45:46 INFO - TEST-INFO | 19787: exit 0 23:45:46 INFO - TEST-OK | kraken | took 58462ms 23:45:46 INFO - SUITE-END | took 1168s 23:45:46 INFO - Completed test suite (00:19:28) 23:45:46 INFO - javascript benchmark 23:45:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3256.478963365861, 3341.1814105544145, 3345.5483509726196, 3359.6976272135516, 3388.1698983748984, 5344.19837024446, 5351.7056561889085, 5362.034833729927, 5367.4900884415965, 5381.730913454331, 5355.196720491928, 5362.678239305645, 5377.542908852743, 5385.084535628943, 5395.433479484646, 4808.08646357191, 4941.110600091991, 4948.985457981124, 4979.278004689318, 5020.3724534433195, 4824.831130910419, 4883.047805677894, 4913.213885778277, 4958.826441074563, 5005.474425185358, 4946.15915294399, 4962.6526143169995, 4963.900721985558, 4966.404031516205, 5000.249962505635, 4892.6575139740235, 4915.827946021908, 4939.061578300129, 4961.900761984776, 4963.379577552806, 4796.25658023007, 4814.10938976287, 4877.0489754497885, 4893.266010098479, 4895.290182923492, 5149.124648809711, 5181.145111056671, 5186.7147306898105, 5191.688498690053, 5220.791168353261, 5681.801136960228, 5741.483266505993, 5754.97122514389, 5757.68332741699, 5765.1352297155345, 5751.0, 5803.7968671096305, 5810.302763668345, 5845.298564172326, 5873.148393482921, 5418.783248670048, 5420.159875219308, 5423.83728488146, 5425.647332923387, 5426.8914621707345, 5650.802221922213, 5815.9709201453725, 5911.645301281937, 5912.320083190402, 5916.556258280646, 5792.652440853562, 5792.710364481759, 5805.477507024388, 5811.244538210006, 5839.620424672383, 5851.327097383855, 5860.677662728591, 5871.442212989759, 5882.323532793698, 5887.2052272943465, 5596.692181930033, 5639.956608027446, 5755.280589926259, 5813.680247586339, 5865.94134058654, 5764.452377024176, 5765.85585360361, 5769.480746732815, 5778.653280803165, 5782.681952492653, 4418.977905110518, 4426.490953540319, 4431.62331201845, 4441.489228738672, 4449.644028477714, 3905.6094390561284, 3968.6229808168177, 4001.7198796084576, 4034.8184331705143, 4062.370332598452, 5516.724163791794, 5527.088030475007, 5541.778328866801, 5544.528715059185, 5548.4174161712435, 5826.883462330729, 5841.649501029951, 5843.1235314703135, 5864.091065884794, 5894.734736936763, 5391.191321301758, 5475.534579560703, 5514.641548299348, 5559.0, 5566.638168519034, 4980.850574482772, 4991.051700176955, 5005.124103281911, 5007.273945277914, 5043.016611760745, 5839.941600583939, 6027.0356742921795, 6038.30559485656, 6041.667708275999, 6043.607165534227, 5741.081426971748, 5821.214136091573, 5838.065909454637, 5842.532597392284, 5853.765849366148, 6082.11809287642, 6090.3605121461605, 6101.542384321105, 6110.450059494667, 6111.0, 5642.210090587403, 5674.74463649145, 5788.594798364074, 5799.971000144972, 5802.361740208658, 5736.799212027559, 5791.044477661138, 5794.0439827428, 5816.592838501264, 5833.504152146946, 5622.240997465454, 5629.802956896489, 5632.464915832989, 5638.436156384329, 5640.915386269127, 5585.832425027255, 5649.435056494318, 5662.943370566406, 5663.461971112738, 5773.220615216892, 5490.5882058844945, 5530.91703624454, 5531.7234138293725, 5546.889062218814, 5558.416366281483, 5605.1872478491205, 5619.072852979212, 5623.746931388016, 5626.099824028136, 5640.153976903333, 5445.319335083114, 5555.166724991283, 5564.944350556442, 5659.660420374791, 5667.149927510906], "unit": "score", "name": "dojo.html", "value": 5347.273837508193}, {"lowerIsBetter": false, "replicates": [560.4059696721473, 582.1326223926351, 583.4719578781203, 586.2730214533977, 587.210202277936, 32497.187570310754, 33183.33633327332, 41032.384514232275, 41557.58442415575, 41586.376204356886, 44329.556704432944, 44889.0, 44962.55037449625, 44965.55034449654, 44967.55032449675, 8754.737357879274, 8984.326175536828, 9010.414323069012, 9011.594478248462, 9021.0, 8896.599653015597, 9140.360174787767, 9154.176124148826, 9157.130072643089, 9159.771005724877, 9145.817083658323, 9226.815463690722, 9236.307276954221, 9243.39917905334, 9245.861312080324, 8923.821523569492, 8927.732168034969, 8970.372073954793, 8970.551472426418, 8992.910070899272, 9170.724878253663, 9270.768230794216, 9305.627774888997, 9310.162085412345, 9310.627574896997, 43895.12209755787, 44281.0, 44283.77858110721, 44374.55625443737, 44398.33402498965, 3818.369968955119, 4037.6366127048414, 4170.624643782044, 4180.832766689329, 4181.435506206653, 32712.836435817906, 34598.13504662403, 34800.47799283013, 34919.0, 35271.82364088163, 4221.451211342506, 4316.2446571849805, 4354.804033818486, 4357.19391912494, 4539.773011349419, 239989.0, 242054.0, 242772.0, 243639.0, 244757.0, 47242.29136562954, 48134.518654813, 66233.66883165554, 68057.0, 68249.65875170691, 48688.0, 49091.263631045564, 49145.26282105771, 49152.50847491551, 49180.50819491831, 14486.203258820866, 14700.0, 14715.55853324402, 14718.705625887422, 14729.0, 11345.376004319842, 11479.770404591862, 11500.88499115015, 11501.36742479155, 11504.0, 16339.83660163407, 16396.344146234256, 16451.341946322013, 16454.095024773753, 16484.83515164857, 6281.654509002049, 6359.809205723743, 6376.426121649074, 6379.840503987438, 6430.292667806538, 1023.7747695506977, 1039.8076355874186, 1065.7016035510069, 1086.1310951239136, 1129.4409267412684, 30440.0, 30483.542746858813, 31367.84316078405, 31503.21241968969, 31541.684583153874, 1069.390447444949, 1103.9613613523488, 1115.2750712037077, 1141.8116010858282, 1175.2889501851428, 15581.376744930303, 15819.68360632781, 15981.522417946353, 16078.43725469603, 16175.595610109842, 333543.0, 337247.0, 337484.0, 338303.0, 338945.0, 58289.12566311509, 58783.0, 58791.4120858786, 58824.41175588275, 58828.0, 1371.739369519788, 1375.6217040313993, 1441.128117488946, 1441.8846492280593, 1448.0877047460033, 27559.586606201323, 28286.85856570704, 29567.191116843864, 30395.088147355615, 30411.391772163992, 46062.0, 46261.30608040949, 46372.0, 46416.0, 46430.53569464262, 223390.0, 224291.0, 224755.0, 225194.0, 225228.0, 30310.84844575851, 32826.34347313088, 34891.65108348986, 35214.0, 35700.64299356973, 41544.37683434811, 42391.0, 42478.78760606177, 42984.0, 42987.78506107449, 34966.65033349736, 35504.46743298801, 36555.634443655224, 37921.43117853179, 38389.61610383972, 37281.440778387805, 37432.625673744005, 37671.81164094162, 38239.61760382361, 38246.23507529778, 34732.13169670779, 34920.12699682528, 35224.82387588046, 35276.64723352836, 36823.0, 33110.83444582858, 34113.14717132092, 34829.825850870584, 34871.0, 34873.12817179591, 26617.467650647264, 26655.0, 26690.332741681614, 26834.0, 26972.730272697023], "unit": "score", "name": "ext.html", "value": 18757.969363325185}, {"lowerIsBetter": false, "replicates": [361.2666287436503, 366.18341099348453, 370.70343725019984, 374.69462388153636, 377.7752237418735, 17190.74213886791, 17522.474325770214, 18594.628107437842, 18605.0, 18612.255509779625, 17152.82847171528, 17455.563610909732, 17599.82400175998, 17612.119394030313, 17625.0, 5537.972310138443, 5727.140928860684, 5733.455321744427, 5757.68332741699, 5758.280214973129, 4176.958230417687, 5625.606207565472, 6005.3093894202075, 6259.467945224661, 6259.874802503947, 6211.9378806212035, 6213.440790328869, 6231.750729970796, 6238.781642642509, 6241.313455519912, 6081.604695694788, 6363.681815909186, 6363.9045414318825, 6370.0, 6372.426481616653, 3794.3739283018544, 5208.114620514521, 5364.409914909357, 5417.539509141728, 5552.0, 21658.675119873216, 21783.0, 21847.126114955383, 22214.555708885895, 22216.777832221633, 2209.4255493571627, 2311.6301391777233, 2385.7017872765905, 2469.2468797016904, 2470.0984140788664, 13585.932070339684, 14018.088824226495, 14139.505117320845, 14234.92882535591, 14237.78643320351, 1813.6916724156924, 1847.4734700610395, 1910.360029390156, 1914.15777058094, 1946.6009468059015, 62948.0, 63924.36075639231, 64227.0, 65172.3482765171, 65686.67156664234, 9690.0, 9940.453275069796, 10551.15590752738, 10559.208059395576, 10734.355938643706, 13830.585082447542, 13848.446062157602, 13899.79150312746, 13953.093048951785, 14006.0896041759, 7584.2794934481135, 7677.61611919413, 7682.615869206517, 7694.038245219348, 7843.0, 7416.147143078615, 7444.516106453063, 7459.291367320096, 7478.214787447239, 7517.812054698677, 4748.548887855648, 4756.952430475721, 4764.547368000034, 4788.3056956741075, 4805.207140821795, 1797.532641513216, 1806.3677712800677, 1831.2217307644198, 1905.627947877526, 1929.8649094563245, 942.6512190489562, 1042.0048853345038, 1065.0042210533022, 1066.7653116314398, 1067.9092277156374, 15026.398944042334, 16904.13255109259, 17070.23183956725, 17366.39217627377, 17759.02325372117, 846.2341580869323, 949.943003419797, 953.2231231546267, 982.037603148918, 1025.1747343388495, 9600.087991640783, 9646.131848133702, 9737.318387712934, 9739.464329461805, 9878.851817222747, 449509.0, 452268.0, 452889.0, 469111.0, 469406.0, 72850.27149728542, 73600.63199684075, 77644.22355776482, 80642.0, 84267.15732842594, 1029.6396261308632, 1036.2073014144187, 1047.4710271312938, 1067.9786404272027, 1075.6719200643722, 15754.684906302038, 15805.519657104302, 15884.52346429609, 15921.283542240395, 16165.919170404073, 21980.560388792455, 24731.752682472947, 34288.14279642929, 34584.82707586446, 35175.296494069466, 48723.75638121787, 49400.25899611581, 49709.0, 49770.502294976584, 49964.500354997435, 8102.959485202537, 8227.670893164206, 8316.209960053786, 8440.071592124985, 8622.913770862211, 11583.478743456397, 12433.93783031079, 12805.679858003625, 13461.394237259543, 13682.31588420595, 11313.321200727984, 11681.357525336189, 11841.703957401134, 11857.703557410789, 11998.100142489522, 11724.237924534878, 11806.291622502677, 11910.344931028876, 11964.64106076819, 12200.938995304967, 11262.324260544394, 11302.717432064264, 11616.767664646828, 11621.593244236412, 12148.86525948258, 8417.368697347845, 8451.704190353554, 8456.957715211385, 8493.702720405003, 8843.734687959372, 8859.60131794058, 11087.556497740323, 11497.137714671266, 11635.941820290844, 11681.415929203677], "unit": "score", "name": "jquery.html", "value": 8830.88886204293}, {"lowerIsBetter": false, "replicates": [1377.7175678985795, 1564.7965764450623, 1572.9528114156572, 1805.6388722255551, 1928.8746231494943, 8206.220409061138, 8328.958355208222, 8352.20654037867, 8357.080721120672, 8360.080391156984, 8220.547869867154, 8324.167583241673, 8336.624851881665, 8340.207680270365, 8341.95829020854, 2181.8690878547336, 2239.0931672672596, 2401.1595941420537, 2408.7109546854404, 2428.6599876017285, 2479.429731161834, 2486.1298545509017, 2488.713797913236, 2489.253224032792, 2489.5020995800824, 2412.348665860217, 2447.1679628926163, 2461.938451538708, 2463.5442443147986, 2464.125235541375, 2354.023080421623, 2367.9052837886466, 2380.6667066610603, 2430.963535546968, 2431.3192306154306, 2328.3247858121126, 2360.78752912237, 2441.9023239070416, 2464.630305454178, 2471.1598056660823, 8616.181462761027, 8701.17338852808, 8702.869456958151, 8711.128887111301, 8713.259372953307, 5209.921851172236, 5318.574514038867, 5327.653702509363, 5372.462753724596, 5374.220737993008, 3295.7198638115788, 3335.5663763710804, 3402.302527981758, 3404.063882432326, 3408.625051244361, 998.3710262534629, 999.3903718731568, 1011.3123076308108, 1012.6961911426542, 1057.0328149742977, 12266.938665306616, 12285.754284914341, 12297.077719171099, 12305.69235769104, 12320.322382268881, 4762.690425122356, 4779.665423420397, 4818.301346304766, 4870.9269360959615, 4871.29366241893, 10357.223208259411, 10404.479776011169, 10408.583656653649, 10435.634752783617, 10439.895601044043, 5369.382521010056, 5375.301210842644, 5421.512063914267, 5428.457154284619, 5430.239766432703, 4303.505096913832, 4563.361129441881, 4666.066786642685, 4703.223968045234, 4712.246040633482, 4006.016864860641, 4060.7766572838777, 4081.0409553754844, 4119.423280740699, 4130.0, 1288.8066789981578, 1331.1547167548483, 1349.203969657887, 1352.134633834347, 1361.251311778518, 1414.4200877640324, 1423.2599048494724, 1439.964000899965, 1460.7662773956115, 1468.3392473387019, 8234.135415781377, 8356.874646880302, 8370.288525475282, 8436.662533498715, 8450.0, 503.7330214986063, 510.79568172731206, 511.5651696058395, 512.515672689305, 513.2378418049194, 6218.6268823869805, 6264.154339164154, 6280.937190628035, 6320.336364681734, 6321.304656487782, 10451.111655509367, 10814.29707069038, 10826.404547749791, 10838.132949364031, 10848.132149428027, 10353.275270730977, 10495.160387169008, 10603.787924241473, 10657.360558366368, 10672.30630009047, 8178.795530111675, 8222.671093156207, 8243.0, 8334.749957501284, 8339.749807505785, 7830.725924592612, 7839.25527074927, 7856.921430785619, 7981.3614910808155, 8041.155678653658, 9246.907530924873, 9419.152276295166, 9460.243180545678, 9555.761105972128, 9571.425714457155, 9662.227021838376, 9781.364211326241, 9904.752381190528, 9924.255680824112, 9987.500624968578, 6349.07938348946, 7076.256993015865, 7293.744718934812, 7836.725714599962, 7881.369490440637, 8142.7557173284895, 8145.266925976691, 8150.510969341858, 8157.388195885451, 8217.465864718773, 6943.583384996917, 7170.533915295489, 7175.533590316612, 7215.0, 7357.484976051625, 6947.61788101639, 6955.200151982587, 7057.894131587927, 7064.434845212473, 7075.681594328371, 7712.151663317143, 7850.489718168301, 7869.527828330319, 7870.803229919298, 7880.605969701606, 6973.163220413583, 6997.580145191305, 7024.192217895007, 7165.641717914188, 7178.389836863925, 6672.332766723289, 6777.288384719731, 6790.287019862843, 6792.049113124068, 7090.4682148840075], "unit": "score", "name": "mootools.html", "value": 4815.255138291617}, {"lowerIsBetter": false, "replicates": [343.597990351289, 350.1613635343354, 350.3885719419613, 351.28864050298154, 355.74386441761925, 5939.0, 5947.226860508139, 5970.970145149268, 6016.067509536024, 6022.728977196031, 5879.941200587993, 5896.410358964102, 5902.734376953037, 5903.911441328383, 5911.408859114086, 4414.7351158930405, 4496.482904465979, 4571.337156112353, 4576.130535198318, 4586.656000799953, 4585.2663573828195, 4587.931181032287, 4589.609883159918, 4602.194615942213, 4603.4015577974815, 4548.31775233716, 4555.681102322822, 4558.339040839076, 4567.474740404846, 4574.6569007324415, 4396.758178300192, 4451.933221001671, 4534.6372290216705, 4538.72767633943, 4542.2051141050515, 3989.740666856645, 3994.380870965005, 4000.6399424051974, 4003.619656132663, 4024.436578878959, 5562.193481945135, 5562.3881373048935, 5565.109582466826, 5565.666060036411, 5568.248286481355, 5286.6035047371215, 5293.867653308698, 5299.576033917316, 5300.602454815866, 5302.390225124122, 6234.345393733638, 6240.063990401431, 6240.937590624081, 6243.968780156116, 6254.249490061176, 4248.723832950879, 4370.409994650713, 4379.4525684289465, 4448.955510444886, 4454.910901781946, 6504.902426463606, 6539.869202615969, 6545.803625891231, 6581.7367305307735, 6585.275619681831, 4432.955670443319, 4436.866893993185, 4439.289713645801, 4442.244818380883, 4442.800073996678, 4499.955000449953, 4502.257127573979, 4506.504284528699, 4507.18870603288, 4510.548945105529, 5217.426083130853, 5219.0, 5221.477852214748, 5221.738913054332, 5226.764795584208, 6132.386761323921, 6310.242770867433, 6322.683865806691, 6323.936760632427, 6333.1450254216015, 1569.995203070036, 1579.202502736134, 1592.6018495376156, 1593.05213398028, 1594.290540709373, 1009.934354266985, 1028.4857571214393, 1031.2677998620914, 1059.9771220771993, 1079.8272276435732, 6080.7567697291615, 6101.115338276014, 6110.29731580865, 6111.816645500642, 6113.724882380304, 6445.807525607777, 6446.935530644633, 6489.8702025960165, 6492.480601551864, 6492.935070649328, 6126.816195514141, 6130.570860039755, 6132.264128304632, 6141.815745527641, 6143.354947730513, 3464.2378676691087, 3489.9127521812156, 3496.8076755778675, 3497.0557949354043, 3498.5801703795705, 6616.073749675049, 6744.190697116377, 6757.493188010919, 6779.186497620317, 6785.491088168308, 6515.120458738104, 6571.080048793077, 6572.34276572339, 6578.243501997236, 6585.242697089896, 6739.898901516482, 6749.392554670103, 6752.155980502437, 6760.121184246115, 6770.593764374054, 6454.67726613658, 6457.4511166551365, 6459.289478157493, 6463.0, 6473.417392434515, 6252.718192770562, 6345.96827015862, 6355.809325720235, 6359.077933699495, 6498.187726534184, 6881.0, 6891.689873955785, 6922.826929326807, 6927.995440660975, 6932.133483314586, 4455.376247325312, 4491.438570178728, 4492.236319825703, 4500.617447516997, 4505.707129036602, 6573.5398522103, 6585.111010013587, 6585.80242592723, 6588.341165883373, 6597.0434287029075, 6394.26465956421, 6396.360363963567, 6397.744090236339, 6403.135576697273, 6408.231012278557, 6183.412575805291, 6360.0, 6373.649449280334, 6393.6483493408305, 6394.23269207698, 6229.0, 6256.562040657111, 6289.962156244169, 6292.748290068529, 6298.401651843067, 6408.935910640834, 6414.807555773335, 6417.839554011187, 6418.19772528434, 6419.486441084796, 6009.789657361971, 6129.295131059986, 6240.4071613196675, 6252.218472690914, 6259.2488901332135], "unit": "score", "name": "prototype.html", "value": 4766.028722542782}, {"lowerIsBetter": false, "replicates": [822.5763731678187, 877.2280393253935, 905.2983937448477, 930.2325581395343, 931.501646619059, 15013.249337533121, 15133.09201447914, 15148.394064237416, 15160.848391516096, 15227.467038653636, 13094.541691040815, 14028.719425611482, 14096.64758381041, 14180.858191418083, 14238.0, 758.4387553210639, 909.9090090990915, 919.4850883505259, 924.1636319131197, 925.842606756853, 900.5722281916103, 928.7770934975591, 930.3208657679897, 931.3154831199063, 931.5994122527311, 962.5043102802063, 967.8596603492489, 971.9514024298792, 972.1687956796943, 972.9367591106555, 776.561242897761, 933.8599210118468, 957.9042095790435, 958.4249450329816, 963.6916186820221, 701.0850839654249, 705.7988473285141, 706.6360824175554, 709.2446544430165, 709.2765379313123, 14744.336504857307, 14778.926105369512, 14839.183844888526, 14844.70310593793, 14882.479113231093, 13732.244726540037, 13844.723105537934, 14079.577612671636, 14127.505537306144, 14255.358508867126, 11596.362200078993, 11656.650300491, 11657.358845263507, 11728.35494047827, 11998.880011199864, 3873.748206366577, 3897.8830635080994, 3907.824147913322, 3914.7846868422225, 3916.6475017248586, 51543.0, 51664.22503662448, 54379.0, 54406.18390724103, 54663.72668136634, 11421.657350279505, 11718.589849355232, 11884.286942783461, 12002.819957700467, 12198.207116537396, 20007.399778006682, 20165.09257083435, 20166.39500814978, 20183.596328073356, 20200.49498762543, 8293.585320733939, 8356.749297521084, 8603.139686031347, 8665.566721664018, 8950.462972221687, 4527.230370836965, 4528.932066019012, 4589.747563883951, 4604.861854144381, 4714.764261786897, 3489.0, 3501.9299614008087, 3513.7013353864695, 3515.8417871195857, 3520.3663340598428, 622.3558616831558, 629.7008920762601, 630.6499892559674, 648.6594537867563, 656.8193746719691, 583.7723287917715, 598.3597550620881, 686.9347411995852, 760.4106817216701, 768.3776141325544, 8686.305095592337, 8903.243224325875, 8907.910920890708, 8950.507722075348, 9038.276937844958, 643.2217017408988, 654.9770758023446, 659.3637140159769, 699.989500157498, 707.8407358344331, 3773.735838491334, 3819.102510909934, 3835.8082095895093, 4069.816858241327, 4082.9183416331507, 56886.7155664219, 57327.71336143376, 57429.13856292159, 59149.70425147933, 59473.0, 51937.48062519402, 52677.736611317465, 52693.73653131787, 53213.0, 54269.0, 45924.0, 48096.7595162022, 48587.0, 48783.0, 49190.262146067835, 7308.342249197598, 7392.926070739224, 7474.177840437439, 7493.662785174572, 7517.060367454068, 35944.101397465274, 36327.81836090803, 36438.81780591186, 37033.44449833308, 37259.44110838285, 40561.0, 40564.18871622492, 44669.0, 45967.310490342, 46695.533044669115, 10843.512041957973, 11151.665450036511, 11223.214374993671, 11236.213465057368, 11330.546778128783, 11081.0, 11088.33469991803, 11120.0, 11176.608818691308, 11480.885191147981, 10749.032587067202, 10784.676459706221, 10833.241673082808, 11082.279651822606, 11216.878312168717, 10615.0, 10869.565217391215, 10917.781644367227, 10958.616448424267, 11024.559017639525, 10089.293749437762, 10276.845847312446, 10316.535755890853, 10389.48052597352, 10439.321444106108, 8888.422252553562, 9089.045650206897, 9107.499087549983, 9288.442693438416, 9460.479673618018, 8718.82562348762, 9298.72103836886, 9323.673671421468, 9350.111739384747, 9394.812103758024], "unit": "score", "name": "yui.html", "value": 6631.371678924224}], "name": "dromaeo_css", "value": 7160.715300659508}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 106.0, 108.0, 108.0, 110.0, 100.0, 109.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 107.8}, {"lowerIsBetter": true, "replicates": [156.0, 125.0, 149.0, 161.0, 127.0, 148.0, 149.0, 127.0, 178.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 144.7}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 160.0, 159.0, 160.0, 159.0, 159.0, 165.0, 162.0, 159.0], "unit": "score", "name": "audio-dft", "value": 160.4}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 76.0, 158.0, 75.0, 76.0, 73.0, 74.0, 162.0, 76.0], "unit": "score", "name": "audio-fft", "value": 91.9}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 144.0, 93.0, 93.0, 93.0, 146.0, 92.0, 93.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 108.7}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.6}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 146.0, 147.0, 145.0, 146.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 97.0, 95.0, 96.0, 96.0, 95.0, 94.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [53.0, 54.0, 53.0, 53.0, 55.0, 54.0, 55.0, 63.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.5}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 64.0, 64.0, 65.0, 65.0, 65.0, 64.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.3}, {"lowerIsBetter": true, "replicates": [76.0, 86.0, 78.0, 79.0, 78.0, 77.0, 76.0, 76.0, 77.0, 77.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.0}, {"lowerIsBetter": true, "replicates": [112.0, 109.0, 108.0, 118.0, 113.0, 110.0, 111.0, 111.0, 119.0, 111.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 112.2}, {"lowerIsBetter": true, "replicates": [144.0, 142.0, 142.0, 144.0, 139.0, 132.0, 149.0, 143.0, 142.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.8}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 68.0, 70.0, 68.0, 63.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.0}], "name": "kraken", "value": 1487.8999999999999}]} 23:45:47 INFO - Return code: 0 23:45:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:45:47 INFO - # TBPL SUCCESS # 23:45:47 INFO - Running post-action listener: _resource_record_post_action 23:45:47 INFO - Running post-run listener: _resource_record_post_run 23:45:48 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 266240; Write bytes: 489201664; Read time: 44; Write time: 361972 23:45:48 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 245194752; Read time: 0; Write time: 234420 23:45:48 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 266240; Write bytes: 244006912; Read time: 44; Write time: 127552 23:45:48 INFO - Running post-run listener: _upload_blobber_files 23:45:48 INFO - Blob upload gear active. 23:45:48 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:45:48 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 23:45:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 23:45:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 23:45:48 INFO - (blobuploader) - INFO - Open directory for files ... 23:45:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:45:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:45:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:45:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:45:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:45:49 INFO - (blobuploader) - INFO - Done attempting. 23:45:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 23:45:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:45:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:45:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:45:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:45:50 INFO - (blobuploader) - INFO - Done attempting. 23:45:50 INFO - (blobuploader) - INFO - Iteration through files over. 23:45:50 INFO - Return code: 0 23:45:50 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:45:50 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:45:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a1882b01b70a15cb946e06c30523614b846a6fec5daf9919b449f50abe59fa817a04ec01ff67e51272bf5667bfdc1ec4ac4c872c6520cfd7aa014a13d1ef5207", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a6ffeac48c3dffd12dd407133ff2fe73f027a928eed1036585d8884f8cd5ebdca697472742483ed512fe42024bcbde8759981b0cfaecddcb83595086aa8b1814"} 23:45:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:45:50 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:45:50 INFO - Contents: 23:45:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a1882b01b70a15cb946e06c30523614b846a6fec5daf9919b449f50abe59fa817a04ec01ff67e51272bf5667bfdc1ec4ac4c872c6520cfd7aa014a13d1ef5207", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a6ffeac48c3dffd12dd407133ff2fe73f027a928eed1036585d8884f8cd5ebdca697472742483ed512fe42024bcbde8759981b0cfaecddcb83595086aa8b1814"} 23:45:50 INFO - Running post-run listener: copy_logs_to_upload_dir 23:45:50 INFO - Copying logs to upload dir... 23:45:50 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 23:45:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.321467 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-03-31 23:45:49.964641) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-31 23:45:49.968776) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1459487987.669708-1988215406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a1882b01b70a15cb946e06c30523614b846a6fec5daf9919b449f50abe59fa817a04ec01ff67e51272bf5667bfdc1ec4ac4c872c6520cfd7aa014a13d1ef5207", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a6ffeac48c3dffd12dd407133ff2fe73f027a928eed1036585d8884f8cd5ebdca697472742483ed512fe42024bcbde8759981b0cfaecddcb83595086aa8b1814"} build_url:https://queue.taskcluster.net/v1/task/U6h6R4XpT7q4zC5eAFY6BQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011363 build_url: 'https://queue.taskcluster.net/v1/task/U6h6R4XpT7q4zC5eAFY6BQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a1882b01b70a15cb946e06c30523614b846a6fec5daf9919b449f50abe59fa817a04ec01ff67e51272bf5667bfdc1ec4ac4c872c6520cfd7aa014a13d1ef5207", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a6ffeac48c3dffd12dd407133ff2fe73f027a928eed1036585d8884f8cd5ebdca697472742483ed512fe42024bcbde8759981b0cfaecddcb83595086aa8b1814"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-31 23:45:49.993972) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 23:45:49.994337) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1459487987.669708-1988215406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 23:45:50.079903) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-31 23:45:50.080591) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-31 23:45:50.081234) ========= ========= Total master_lag: 0.31 =========