builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1452728066.41 results: success (0) buildid: 20160113131433 builduid: aacb8ad5a6804a00adeae388d8ed7d25 revision: bdb6dcb5477b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 15:34:26.408402) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 15:34:26.408852) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 15:34:26.409166) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1452726374.176553-1871198989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006281 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 15:34:26.431963) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 15:34:26.432276) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 15:34:26.454028) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 15:34:26.454375) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1452726374.176553-1871198989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.032007 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 15:34:26.500562) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 15:34:26.500857) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 15:34:26.501256) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 15:34:26.501535) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1452726374.176553-1871198989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-13 15:34:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 25.6M=0s 2016-01-13 15:34:26 (25.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161309 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 15:34:26.676675) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 15:34:26.676989) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1452726374.176553-1871198989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.089306 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 15:34:26.777972) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-13 15:34:26.778337) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev bdb6dcb5477b --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-beta --rev bdb6dcb5477b --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=8c6b6742ce8f6f39ef4ce27d000001f1-1452726374.176553-1871198989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-13 15:34:26,848 Setting DEBUG logging. 2016-01-13 15:34:26,849 attempt 1/10 2016-01-13 15:34:26,849 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/bdb6dcb5477b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-13 15:34:27,845 unpacking tar archive at: mozilla-beta-bdb6dcb5477b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.283358 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-13 15:34:28.074016) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 15:34:28.074339) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 15:34:28.082831) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 15:34:28.083110) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 15:34:28.083500) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-13 15:34:28.083782) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=8c6b6742ce8f6f39ef4ce27d000001f1-1452726374.176553-1871198989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:34:28 INFO - MultiFileLogger online at 20160113 15:34:28 in /builds/slave/test-pgo 15:34:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 15:34:28 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:34:28 INFO - {'append_to_log': False, 15:34:28 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:34:28 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:34:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:34:28 INFO - 'branch': 'Mozilla-Beta', 15:34:28 INFO - 'buildbot_json_path': 'buildprops.json', 15:34:28 INFO - 'config_files': ('talos/linux_config.py',), 15:34:28 INFO - 'default_actions': ('clobber', 15:34:28 INFO - 'read-buildbot-config', 15:34:28 INFO - 'download-and-extract', 15:34:28 INFO - 'populate-webroot', 15:34:28 INFO - 'create-virtualenv', 15:34:28 INFO - 'install', 15:34:28 INFO - 'run-tests'), 15:34:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:34:28 INFO - 'download_minidump_stackwalk': True, 15:34:28 INFO - 'download_symbols': 'ondemand', 15:34:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:34:28 INFO - 'tooltool.py': '/tools/tooltool.py', 15:34:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:34:28 INFO - '/tools/misc-python/virtualenv.py')}, 15:34:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:34:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:34:28 INFO - 'installer_path': 'installer.exe', 15:34:28 INFO - 'log_level': 'info', 15:34:28 INFO - 'log_name': 'talos', 15:34:28 INFO - 'log_to_console': True, 15:34:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:34:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:34:28 INFO - 'opt_config_files': (), 15:34:28 INFO - 'pip_index': False, 15:34:28 INFO - 'sps_profile': False, 15:34:28 INFO - 'sps_profile_interval': 0, 15:34:28 INFO - 'suite': 'dromaeojs', 15:34:28 INFO - 'system_bits': '32', 15:34:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:34:28 INFO - 'title': 'talos-linux64-ix-041', 15:34:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:34:28 INFO - 'use_talos_json': True, 15:34:28 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:34:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:34:28 INFO - 'work_dir': 'build'} 15:34:28 INFO - ##### 15:34:28 INFO - ##### Running clobber step. 15:34:28 INFO - ##### 15:34:28 INFO - Running pre-action listener: _resource_record_pre_action 15:34:28 INFO - Running main action method: clobber 15:34:28 INFO - rmtree: /builds/slave/test-pgo/build 15:34:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:34:32 INFO - Running post-action listener: _resource_record_post_action 15:34:32 INFO - ##### 15:34:32 INFO - ##### Running read-buildbot-config step. 15:34:32 INFO - ##### 15:34:32 INFO - Running pre-action listener: _resource_record_pre_action 15:34:32 INFO - Running main action method: read_buildbot_config 15:34:32 INFO - Using buildbot properties: 15:34:32 INFO - { 15:34:32 INFO - "properties": { 15:34:32 INFO - "buildnumber": 86, 15:34:32 INFO - "product": "firefox", 15:34:32 INFO - "script_repo_revision": "production", 15:34:32 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 15:34:32 INFO - "repository": "", 15:34:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 15:34:32 INFO - "buildid": "20160113131433", 15:34:32 INFO - "slavename": "talos-linux64-ix-041", 15:34:32 INFO - "pgo_build": "True", 15:34:32 INFO - "basedir": "/builds/slave/test-pgo", 15:34:32 INFO - "project": "", 15:34:32 INFO - "platform": "ubuntu64_hw", 15:34:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:34:32 INFO - "slavebuilddir": "test", 15:34:32 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 15:34:32 INFO - "branch": "mozilla-beta", 15:34:32 INFO - "repo_path": "releases/mozilla-beta", 15:34:32 INFO - "stage_platform": "linux64-pgo", 15:34:32 INFO - "builduid": "aacb8ad5a6804a00adeae388d8ed7d25", 15:34:32 INFO - "revision": "bdb6dcb5477b" 15:34:32 INFO - }, 15:34:32 INFO - "sourcestamp": { 15:34:32 INFO - "repository": "", 15:34:32 INFO - "hasPatch": false, 15:34:32 INFO - "project": "", 15:34:32 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 15:34:32 INFO - "changes": [ 15:34:32 INFO - { 15:34:32 INFO - "category": null, 15:34:32 INFO - "files": [ 15:34:32 INFO - { 15:34:32 INFO - "url": null, 15:34:32 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452719673/firefox-44.0.en-US.linux-x86_64.tar.bz2" 15:34:32 INFO - } 15:34:32 INFO - ], 15:34:32 INFO - "repository": "", 15:34:32 INFO - "rev": "bdb6dcb5477b", 15:34:32 INFO - "who": "sendchange", 15:34:32 INFO - "when": 1452728043, 15:34:32 INFO - "number": 7456646, 15:34:32 INFO - "comments": "Bug 1238892 - disable on-screen-keyboard support for Windows 8(.1), r=jaws,dolske a=ritu", 15:34:32 INFO - "project": "", 15:34:32 INFO - "at": "Wed 13 Jan 2016 15:34:03", 15:34:32 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 15:34:32 INFO - "revlink": "", 15:34:32 INFO - "properties": [ 15:34:32 INFO - [ 15:34:32 INFO - "buildid", 15:34:32 INFO - "20160113131433", 15:34:32 INFO - "Change" 15:34:32 INFO - ], 15:34:32 INFO - [ 15:34:32 INFO - "builduid", 15:34:32 INFO - "aacb8ad5a6804a00adeae388d8ed7d25", 15:34:32 INFO - "Change" 15:34:32 INFO - ], 15:34:32 INFO - [ 15:34:32 INFO - "pgo_build", 15:34:32 INFO - "True", 15:34:32 INFO - "Change" 15:34:32 INFO - ] 15:34:32 INFO - ], 15:34:32 INFO - "revision": "bdb6dcb5477b" 15:34:32 INFO - } 15:34:32 INFO - ], 15:34:32 INFO - "revision": "bdb6dcb5477b" 15:34:32 INFO - } 15:34:32 INFO - } 15:34:32 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452719673/firefox-44.0.en-US.linux-x86_64.tar.bz2. 15:34:32 INFO - Running post-action listener: _resource_record_post_action 15:34:32 INFO - ##### 15:34:32 INFO - ##### Running download-and-extract step. 15:34:32 INFO - ##### 15:34:32 INFO - Running pre-action listener: _resource_record_pre_action 15:34:32 INFO - Running main action method: download_and_extract 15:34:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:34:32 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')]} 15:34:32 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452719673/test_packages.json 15:34:32 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452719673/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 15:34:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452719673/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 15:34:32 INFO - Downloaded 1270 bytes. 15:34:32 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 15:34:32 INFO - Using the following test package requirements: 15:34:32 INFO - {u'common': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 15:34:32 INFO - u'cppunittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 15:34:32 INFO - u'firefox-44.0.en-US.linux-x86_64.cppunittest.tests.zip'], 15:34:32 INFO - u'jittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 15:34:32 INFO - u'jsshell-linux-x86_64.zip'], 15:34:32 INFO - u'mochitest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 15:34:32 INFO - u'firefox-44.0.en-US.linux-x86_64.mochitest.tests.zip'], 15:34:32 INFO - u'mozbase': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 15:34:32 INFO - u'reftest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 15:34:32 INFO - u'firefox-44.0.en-US.linux-x86_64.reftest.tests.zip'], 15:34:32 INFO - u'talos': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 15:34:32 INFO - u'firefox-44.0.en-US.linux-x86_64.talos.tests.zip'], 15:34:32 INFO - u'web-platform': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 15:34:32 INFO - u'firefox-44.0.en-US.linux-x86_64.web-platform.tests.zip'], 15:34:32 INFO - u'webapprt': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 15:34:32 INFO - u'xpcshell': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 15:34:32 INFO - u'firefox-44.0.en-US.linux-x86_64.xpcshell.tests.zip']} 15:34:32 INFO - Downloading packages: [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:34:32 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')]} 15:34:32 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452719673/firefox-44.0.en-US.linux-x86_64.common.tests.zip 15:34:32 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452719673/firefox-44.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 15:34:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452719673/firefox-44.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:34:34 INFO - Downloaded 22573299 bytes. 15:34:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 15:34:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 15:34:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 15:34:35 INFO - Return code: 0 15:34:35 INFO - Downloading packages: [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', u'firefox-44.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:34:35 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')]} 15:34:35 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452719673/firefox-44.0.en-US.linux-x86_64.common.tests.zip 15:34:35 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452719673/firefox-44.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 15:34:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452719673/firefox-44.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:34:36 INFO - Downloaded 22573299 bytes. 15:34:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 15:34:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 15:34:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 15:34:37 INFO - Return code: 0 15:34:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:37 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452719673/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 15:34:37 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452719673/firefox-44.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 15:34:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452719673/firefox-44.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:34:38 INFO - Downloaded 11131970 bytes. 15:34:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 15:34:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 15:34:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 15:34:39 INFO - Return code: 0 15:34: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')]} 15:34:39 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452719673/firefox-44.0.en-US.linux-x86_64.tar.bz2 15:34:39 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452719673/firefox-44.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2 15:34:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452719673/firefox-44.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:34:55 INFO - Downloaded 56629579 bytes. 15:34:55 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452719673/firefox-44.0.en-US.linux-x86_64.tar.bz2 15:34:55 INFO - mkdir: /builds/slave/test-pgo/properties 15:34:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:34:55 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:34:55 INFO - Contents: 15:34:55 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452719673/firefox-44.0.en-US.linux-x86_64.tar.bz2 15:34:55 INFO - Running post-action listener: _resource_record_post_action 15:34:55 INFO - Running post-action listener: set_extra_try_arguments 15:34:55 INFO - ##### 15:34:55 INFO - ##### Running populate-webroot step. 15:34:55 INFO - ##### 15:34:55 INFO - Running pre-action listener: _resource_record_pre_action 15:34:55 INFO - Running main action method: populate_webroot 15:34:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:34:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:34:55 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:34:55 INFO - '../fennec_ids.txt'], 15:34:55 INFO - 'tests': ['tcheck2']}, 15:34:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:34:55 INFO - '--tppagecycles', 15:34:55 INFO - '7'], 15:34:55 INFO - 'tests': ['tsvgm']}}, 15:34:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:34:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:34:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:34:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:34:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:34:55 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:34:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:34:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:55 INFO - 'talos_options': ['--e10s'], 15:34:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:34:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:55 INFO - 'tests': ['damp', 'tps']}, 15:34:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:55 INFO - 'talos_options': ['--e10s'], 15:34:55 INFO - 'tests': ['damp', 'tps']}, 15:34:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:34:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:34:55 INFO - 'other': {'tests': ['a11yr', 15:34:55 INFO - 'ts_paint', 15:34:55 INFO - 'tpaint', 15:34:55 INFO - 'sessionrestore', 15:34:55 INFO - 'sessionrestore_no_auto_restore']}, 15:34:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:34:55 INFO - 'tests': ['a11yr', 15:34:55 INFO - 'ts_paint', 15:34:55 INFO - 'tpaint', 15:34:55 INFO - 'sessionrestore', 15:34:55 INFO - 'sessionrestore_no_auto_restore']}, 15:34:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:34:55 INFO - 'tests': ['a11yr', 15:34:55 INFO - 'ts_paint', 15:34:55 INFO - 'tpaint', 15:34:55 INFO - 'sessionrestore', 15:34:55 INFO - 'sessionrestore_no_auto_restore']}, 15:34:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:34:55 INFO - 'tests': ['a11yr', 15:34:55 INFO - 'ts_paint', 15:34:55 INFO - 'tpaint', 15:34:55 INFO - 'sessionrestore', 15:34:55 INFO - 'sessionrestore_no_auto_restore']}, 15:34:55 INFO - 'other_l64': {'tests': ['a11yr', 15:34:55 INFO - 'ts_paint', 15:34:55 INFO - 'tpaint', 15:34:55 INFO - 'sessionrestore', 15:34:55 INFO - 'sessionrestore_no_auto_restore']}, 15:34:55 INFO - 'other_nol64': {'tests': ['a11yr', 15:34:55 INFO - 'ts_paint', 15:34:55 INFO - 'tpaint', 15:34:55 INFO - 'sessionrestore', 15:34:55 INFO - 'sessionrestore_no_auto_restore']}, 15:34:55 INFO - 'svgr': {'tests': ['tsvgx', 15:34:55 INFO - 'tsvgr_opacity', 15:34:55 INFO - 'tart', 15:34:55 INFO - 'tscrollx', 15:34:55 INFO - 'cart']}, 15:34:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:34:55 INFO - 'tests': ['tsvgx', 15:34:55 INFO - 'tsvgr_opacity', 15:34:55 INFO - 'tart', 15:34:55 INFO - 'tscrollx', 15:34:55 INFO - 'cart']}, 15:34:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:55 INFO - 'tests': ['tp5o']}, 15:34:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:55 INFO - 'talos_options': ['--e10s'], 15:34:55 INFO - 'tests': ['tp5o']}, 15:34:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:55 INFO - 'talos_options': ['--xperf_path', 15:34:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:34:55 INFO - 'tests': ['tp5n']}, 15:34:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:55 INFO - 'talos_options': ['--e10s', 15:34:55 INFO - '--xperf_path', 15:34:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:34:55 INFO - 'tests': ['tp5n']}}, 15:34:55 INFO - 'talos.zip': {'path': '', 15:34:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:34:55 INFO - Running post-action listener: _resource_record_post_action 15:34:55 INFO - ##### 15:34:55 INFO - ##### Running create-virtualenv step. 15:34:55 INFO - ##### 15:34:55 INFO - Running pre-action listener: _resource_record_pre_action 15:34:55 INFO - Running main action method: create_virtualenv 15:34:55 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:34:55 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 15:34:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:34:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:34:55 INFO - Using real prefix '/usr' 15:34:55 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:34:55 INFO - Installing distribute.............................................................................................................................................................................................done. 15:34:57 INFO - Installing pip.................done. 15:34:57 INFO - Return code: 0 15:34:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:34:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7ff0f002df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2643350>, '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 0x2644250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26446e0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452726374.176553-1871198989', '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 15:34:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:34:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:34:57 INFO - Using env: {'DISPLAY': ':0', 15:34:57 INFO - 'HOME': '/home/cltbld', 15:34:57 INFO - 'LANG': 'en_US.UTF-8', 15:34:57 INFO - 'LANGUAGE': 'en_US:en', 15:34:57 INFO - 'LOGNAME': 'cltbld', 15:34:57 INFO - 'MAIL': '/var/mail/cltbld', 15:34:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:57 INFO - 'MOZ_NO_REMOTE': '1', 15:34:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:57 INFO - 'NO_EM_RESTART': '1', 15:34:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:34:57 INFO - 'PWD': '/builds/slave/test-pgo', 15:34:57 INFO - 'SHELL': '/bin/bash', 15:34:57 INFO - 'SHLVL': '1', 15:34:57 INFO - 'TERM': 'linux', 15:34:57 INFO - 'TMOUT': '86400', 15:34:57 INFO - 'USER': 'cltbld', 15:34:57 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452726374.176553-1871198989', 15:34:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:57 INFO - '_': '/tools/buildbot/bin/python'} 15:34:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:57 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 15:34:57 INFO - Cleaning up... 15:34:57 INFO - Return code: 0 15:34:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:34:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7ff0f002df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2643350>, '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 0x2644250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26446e0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452726374.176553-1871198989', '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 15:34:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:34:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:34:57 INFO - Using env: {'DISPLAY': ':0', 15:34:57 INFO - 'HOME': '/home/cltbld', 15:34:57 INFO - 'LANG': 'en_US.UTF-8', 15:34:57 INFO - 'LANGUAGE': 'en_US:en', 15:34:57 INFO - 'LOGNAME': 'cltbld', 15:34:57 INFO - 'MAIL': '/var/mail/cltbld', 15:34:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:57 INFO - 'MOZ_NO_REMOTE': '1', 15:34:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:57 INFO - 'NO_EM_RESTART': '1', 15:34:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:34:57 INFO - 'PWD': '/builds/slave/test-pgo', 15:34:57 INFO - 'SHELL': '/bin/bash', 15:34:57 INFO - 'SHLVL': '1', 15:34:57 INFO - 'TERM': 'linux', 15:34:57 INFO - 'TMOUT': '86400', 15:34:57 INFO - 'USER': 'cltbld', 15:34:57 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452726374.176553-1871198989', 15:34:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:57 INFO - '_': '/tools/buildbot/bin/python'} 15:34:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:58 INFO - Downloading/unpacking psutil>=0.7.1 15:34: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 15:34: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 15:34: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 15:34: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 15:34: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 15:34: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 15:35:00 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 15:35:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:35:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:35:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:35:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:35:00 INFO - Installing collected packages: psutil 15:35:00 INFO - Running setup.py install for psutil 15:35:00 INFO - building 'psutil._psutil_linux' extension 15:35:00 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 15:35:00 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 15:35:00 INFO - building 'psutil._psutil_posix' extension 15:35:00 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 15:35:00 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 15:35:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:35:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:35:00 INFO - Successfully installed psutil 15:35:00 INFO - Cleaning up... 15:35:00 INFO - Return code: 0 15:35:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:35:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7ff0f002df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2643350>, '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 0x2644250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26446e0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452726374.176553-1871198989', '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 15:35:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:35:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:35:00 INFO - Using env: {'DISPLAY': ':0', 15:35:00 INFO - 'HOME': '/home/cltbld', 15:35:00 INFO - 'LANG': 'en_US.UTF-8', 15:35:00 INFO - 'LANGUAGE': 'en_US:en', 15:35:00 INFO - 'LOGNAME': 'cltbld', 15:35:00 INFO - 'MAIL': '/var/mail/cltbld', 15:35:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:00 INFO - 'MOZ_NO_REMOTE': '1', 15:35:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:00 INFO - 'NO_EM_RESTART': '1', 15:35:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:35:00 INFO - 'PWD': '/builds/slave/test-pgo', 15:35:00 INFO - 'SHELL': '/bin/bash', 15:35:00 INFO - 'SHLVL': '1', 15:35:00 INFO - 'TERM': 'linux', 15:35:00 INFO - 'TMOUT': '86400', 15:35:00 INFO - 'USER': 'cltbld', 15:35:00 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452726374.176553-1871198989', 15:35:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:00 INFO - '_': '/tools/buildbot/bin/python'} 15:35:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:35: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 15:35: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 15:35: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 15:35: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 15:35: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 15:35: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 15:35:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:35:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:35:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:35:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:35:02 INFO - Installing collected packages: mozsystemmonitor 15:35:02 INFO - Running setup.py install for mozsystemmonitor 15:35:02 INFO - Successfully installed mozsystemmonitor 15:35:02 INFO - Cleaning up... 15:35:02 INFO - Return code: 0 15:35:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7ff0f002df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2643350>, '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 0x2644250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26446e0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452726374.176553-1871198989', '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 15:35:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:35:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:35:02 INFO - Using env: {'DISPLAY': ':0', 15:35:02 INFO - 'HOME': '/home/cltbld', 15:35:02 INFO - 'LANG': 'en_US.UTF-8', 15:35:02 INFO - 'LANGUAGE': 'en_US:en', 15:35:02 INFO - 'LOGNAME': 'cltbld', 15:35:02 INFO - 'MAIL': '/var/mail/cltbld', 15:35:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:02 INFO - 'MOZ_NO_REMOTE': '1', 15:35:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:02 INFO - 'NO_EM_RESTART': '1', 15:35:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:35:02 INFO - 'PWD': '/builds/slave/test-pgo', 15:35:02 INFO - 'SHELL': '/bin/bash', 15:35:02 INFO - 'SHLVL': '1', 15:35:02 INFO - 'TERM': 'linux', 15:35:02 INFO - 'TMOUT': '86400', 15:35:02 INFO - 'USER': 'cltbld', 15:35:02 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452726374.176553-1871198989', 15:35:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:02 INFO - '_': '/tools/buildbot/bin/python'} 15:35:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:03 INFO - Downloading/unpacking blobuploader==1.2.4 15:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:04 INFO - Downloading blobuploader-1.2.4.tar.gz 15:35:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:35:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:35:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:35:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:35:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:05 INFO - Downloading docopt-0.6.1.tar.gz 15:35:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:35:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:35:05 INFO - Installing collected packages: blobuploader, requests, docopt 15:35:05 INFO - Running setup.py install for blobuploader 15:35:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:35:05 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:35:05 INFO - Running setup.py install for requests 15:35:05 INFO - Running setup.py install for docopt 15:35:06 INFO - Successfully installed blobuploader requests docopt 15:35:06 INFO - Cleaning up... 15:35:06 INFO - Return code: 0 15:35:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7ff0f002df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2643350>, '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 0x2644250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26446e0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452726374.176553-1871198989', '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 15:35:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:35:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:35:06 INFO - Using env: {'DISPLAY': ':0', 15:35:06 INFO - 'HOME': '/home/cltbld', 15:35:06 INFO - 'LANG': 'en_US.UTF-8', 15:35:06 INFO - 'LANGUAGE': 'en_US:en', 15:35:06 INFO - 'LOGNAME': 'cltbld', 15:35:06 INFO - 'MAIL': '/var/mail/cltbld', 15:35:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:06 INFO - 'MOZ_NO_REMOTE': '1', 15:35:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:06 INFO - 'NO_EM_RESTART': '1', 15:35:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:35:06 INFO - 'PWD': '/builds/slave/test-pgo', 15:35:06 INFO - 'SHELL': '/bin/bash', 15:35:06 INFO - 'SHLVL': '1', 15:35:06 INFO - 'TERM': 'linux', 15:35:06 INFO - 'TMOUT': '86400', 15:35:06 INFO - 'USER': 'cltbld', 15:35:06 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452726374.176553-1871198989', 15:35:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:06 INFO - '_': '/tools/buildbot/bin/python'} 15:35:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:35:06 INFO - Running setup.py (path:/tmp/pip-er5qP9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:35:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:35:06 INFO - Running setup.py (path:/tmp/pip-Utm37d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:35:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:35:06 INFO - Running setup.py (path:/tmp/pip-Y_KhYq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:35:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:35:06 INFO - Running setup.py (path:/tmp/pip-JBBCUj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:35:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:35:06 INFO - Running setup.py (path:/tmp/pip-_6NVYc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:35:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:35:06 INFO - Running setup.py (path:/tmp/pip-W9W7xV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:35:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:35:06 INFO - Running setup.py (path:/tmp/pip-yu8ENa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:35:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:35:06 INFO - Running setup.py (path:/tmp/pip-lB3ZJh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:35:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:35:06 INFO - Running setup.py (path:/tmp/pip-BqnksW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:35:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:35:06 INFO - Running setup.py (path:/tmp/pip-PXEV6b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:35:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:35:07 INFO - Running setup.py (path:/tmp/pip-yoXiiN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:35:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:35:07 INFO - Running setup.py (path:/tmp/pip-_qxXTA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:35:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:35:07 INFO - Running setup.py (path:/tmp/pip-YO1yl5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:35:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:35:07 INFO - Running setup.py (path:/tmp/pip-vF03lt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:35:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:35:07 INFO - Running setup.py (path:/tmp/pip-ytRoYY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:35:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:35:07 INFO - Running setup.py (path:/tmp/pip-j01Rdu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:35:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:35:07 INFO - Running setup.py (path:/tmp/pip-iBDJ2f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:35:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:35:07 INFO - Running setup.py install for manifestparser 15:35:07 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:35:07 INFO - Running setup.py install for mozcrash 15:35:07 INFO - Running setup.py install for mozdebug 15:35:07 INFO - Running setup.py install for mozdevice 15:35:07 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:35:07 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:35:07 INFO - Running setup.py install for mozfile 15:35:08 INFO - Running setup.py install for mozhttpd 15:35:08 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:35:08 INFO - Running setup.py install for mozinfo 15:35:08 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:35:08 INFO - Running setup.py install for mozInstall 15:35:08 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:35:08 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:35:08 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:35:08 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:35:08 INFO - Running setup.py install for mozleak 15:35:08 INFO - Running setup.py install for mozlog 15:35:08 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:35:08 INFO - Running setup.py install for moznetwork 15:35:08 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:35:08 INFO - Running setup.py install for mozprocess 15:35:08 INFO - Running setup.py install for mozprofile 15:35:08 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:35:08 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:35:08 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:35:08 INFO - Running setup.py install for mozrunner 15:35:08 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:35:09 INFO - Running setup.py install for mozscreenshot 15:35:09 INFO - Running setup.py install for moztest 15:35:09 INFO - Running setup.py install for mozversion 15:35:09 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:35:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:35:09 INFO - Cleaning up... 15:35:09 INFO - Return code: 0 15:35:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7ff0f002df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2643350>, '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 0x2644250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26446e0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452726374.176553-1871198989', '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 15:35:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:35:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:35:09 INFO - Using env: {'DISPLAY': ':0', 15:35:09 INFO - 'HOME': '/home/cltbld', 15:35:09 INFO - 'LANG': 'en_US.UTF-8', 15:35:09 INFO - 'LANGUAGE': 'en_US:en', 15:35:09 INFO - 'LOGNAME': 'cltbld', 15:35:09 INFO - 'MAIL': '/var/mail/cltbld', 15:35:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:09 INFO - 'MOZ_NO_REMOTE': '1', 15:35:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:09 INFO - 'NO_EM_RESTART': '1', 15:35:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:35:09 INFO - 'PWD': '/builds/slave/test-pgo', 15:35:09 INFO - 'SHELL': '/bin/bash', 15:35:09 INFO - 'SHLVL': '1', 15:35:09 INFO - 'TERM': 'linux', 15:35:09 INFO - 'TMOUT': '86400', 15:35:09 INFO - 'USER': 'cltbld', 15:35:09 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452726374.176553-1871198989', 15:35:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:09 INFO - '_': '/tools/buildbot/bin/python'} 15:35:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:35:09 INFO - Running setup.py (path:/tmp/pip-pifuRu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:35:09 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)) 15:35:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:35:09 INFO - Running setup.py (path:/tmp/pip-Lj520h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:35:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:35:09 INFO - Running setup.py (path:/tmp/pip-VSyxSP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:35:09 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)) 15:35:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:35:09 INFO - Running setup.py (path:/tmp/pip-IuYSmG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 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)) 15:35:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:35:09 INFO - Running setup.py (path:/tmp/pip-umNtWm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:35:09 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)) 15:35:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:35:09 INFO - Running setup.py (path:/tmp/pip-rxQYAQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:35:09 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)) 15:35:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:35:09 INFO - Running setup.py (path:/tmp/pip-WRVIdq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 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)) 15:35:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:35:10 INFO - Running setup.py (path:/tmp/pip-ntWvoE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:35:10 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)) 15:35:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:35:10 INFO - Running setup.py (path:/tmp/pip-uCZKgC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:35:10 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)) 15:35:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:35:10 INFO - Running setup.py (path:/tmp/pip-gxuqlc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 15:35:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:35:10 INFO - Running setup.py (path:/tmp/pip-5eyRAP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:35:10 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)) 15:35:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:35:10 INFO - Running setup.py (path:/tmp/pip-KyJECo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:35:10 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)) 15:35:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:35:10 INFO - Running setup.py (path:/tmp/pip-JjfkE1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 15:35:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:35:10 INFO - Running setup.py (path:/tmp/pip-ncIxFv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:35:10 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)) 15:35:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:35:10 INFO - Running setup.py (path:/tmp/pip-sR1zTZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:35:10 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)) 15:35:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:35:10 INFO - Running setup.py (path:/tmp/pip-Ef5NjP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:35:10 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)) 15:35:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:35:10 INFO - Running setup.py (path:/tmp/pip-A34grS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:35:10 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)) 15:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:35:10 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)) 15:35:10 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.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:35:10 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.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:35:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:12 INFO - Downloading blessings-1.5.1.tar.gz 15:35:12 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 15:35:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:35:12 INFO - Installing collected packages: blessings 15:35:12 INFO - Running setup.py install for blessings 15:35:12 INFO - Successfully installed blessings 15:35:12 INFO - Cleaning up... 15:35:12 INFO - Return code: 0 15:35:12 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:35:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:35:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:35:12 INFO - Reading from file tmpfile_stdout 15:35:12 INFO - Current package versions: 15:35:12 INFO - argparse == 1.2.1 15:35:12 INFO - blessings == 1.5.1 15:35:12 INFO - blobuploader == 1.2.4 15:35:12 INFO - docopt == 0.6.1 15:35:12 INFO - manifestparser == 1.1 15:35:12 INFO - mozInstall == 1.12 15:35:12 INFO - mozcrash == 0.16 15:35:12 INFO - mozdebug == 0.1 15:35:12 INFO - mozdevice == 0.46 15:35:12 INFO - mozfile == 1.2 15:35:12 INFO - mozhttpd == 0.7 15:35:12 INFO - mozinfo == 0.8 15:35:12 INFO - mozleak == 0.1 15:35:12 INFO - mozlog == 3.0 15:35:12 INFO - moznetwork == 0.27 15:35:12 INFO - mozprocess == 0.22 15:35:12 INFO - mozprofile == 0.27 15:35:12 INFO - mozrunner == 6.11 15:35:12 INFO - mozscreenshot == 0.1 15:35:12 INFO - mozsystemmonitor == 0.0 15:35:12 INFO - moztest == 0.7 15:35:12 INFO - mozversion == 1.4 15:35:12 INFO - psutil == 3.1.1 15:35:12 INFO - requests == 1.2.3 15:35:12 INFO - wsgiref == 0.1.2 15:35:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:35:12 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')]} 15:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:12 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')]} 15:35:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7ff0f002df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2643350>, '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 0x2644250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26446e0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452726374.176553-1871198989', '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 15:35:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:35:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:35:12 INFO - Using env: {'DISPLAY': ':0', 15:35:12 INFO - 'HOME': '/home/cltbld', 15:35:12 INFO - 'LANG': 'en_US.UTF-8', 15:35:12 INFO - 'LANGUAGE': 'en_US:en', 15:35:12 INFO - 'LOGNAME': 'cltbld', 15:35:12 INFO - 'MAIL': '/var/mail/cltbld', 15:35:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:12 INFO - 'MOZ_NO_REMOTE': '1', 15:35:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:12 INFO - 'NO_EM_RESTART': '1', 15:35:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:35:12 INFO - 'PWD': '/builds/slave/test-pgo', 15:35:12 INFO - 'SHELL': '/bin/bash', 15:35:12 INFO - 'SHLVL': '1', 15:35:12 INFO - 'TERM': 'linux', 15:35:12 INFO - 'TMOUT': '86400', 15:35:12 INFO - 'USER': 'cltbld', 15:35:12 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452726374.176553-1871198989', 15:35:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:12 INFO - '_': '/tools/buildbot/bin/python'} 15:35:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:13 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 1)) 15:35:13 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 2)) 15:35:13 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 3)) 15:35:13 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 4)) 15:35:13 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 5)) 15:35:13 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 6)) 15:35:13 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 7)) 15:35:13 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 8)) 15:35:13 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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 15:35:13 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 3)) 15:35:13 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.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 15:35:13 INFO - Cleaning up... 15:35:13 INFO - Return code: 0 15:35:13 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 15:35:13 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')]} 15:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:13 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')]} 15:35:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7ff0f002df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2643350>, '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 0x2644250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26446e0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452726374.176553-1871198989', '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 15:35:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:35:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:35:13 INFO - Using env: {'DISPLAY': ':0', 15:35:13 INFO - 'HOME': '/home/cltbld', 15:35:13 INFO - 'LANG': 'en_US.UTF-8', 15:35:13 INFO - 'LANGUAGE': 'en_US:en', 15:35:13 INFO - 'LOGNAME': 'cltbld', 15:35:13 INFO - 'MAIL': '/var/mail/cltbld', 15:35:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:13 INFO - 'MOZ_NO_REMOTE': '1', 15:35:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:13 INFO - 'NO_EM_RESTART': '1', 15:35:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:35:13 INFO - 'PWD': '/builds/slave/test-pgo', 15:35:13 INFO - 'SHELL': '/bin/bash', 15:35:13 INFO - 'SHLVL': '1', 15:35:13 INFO - 'TERM': 'linux', 15:35:13 INFO - 'TMOUT': '86400', 15:35:13 INFO - 'USER': 'cltbld', 15:35:13 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452726374.176553-1871198989', 15:35:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:13 INFO - '_': '/tools/buildbot/bin/python'} 15:35:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:13 INFO - Downloading/unpacking jsonschema 15:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:35:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 15:35:15 INFO - Downloading/unpacking functools32 (from jsonschema) 15:35:15 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 15:35:15 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 15:35:15 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 15:35:15 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 15:35:15 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 15:35:15 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 15:35:15 INFO - Downloading functools32-3.2.3-2.tar.gz 15:35:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 15:35:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 15:35:15 INFO - warning: no files found matching '*.txt' 15:35:15 INFO - no previously-included directories found matching 'build' 15:35:15 INFO - no previously-included directories found matching 'dist' 15:35:15 INFO - no previously-included directories found matching '.git*' 15:35:15 INFO - Installing collected packages: jsonschema, functools32 15:35:15 INFO - Running setup.py install for functools32 15:35:15 INFO - warning: no files found matching '*.txt' 15:35:15 INFO - no previously-included directories found matching 'build' 15:35:15 INFO - no previously-included directories found matching 'dist' 15:35:15 INFO - no previously-included directories found matching '.git*' 15:35:15 INFO - Successfully installed jsonschema functools32 15:35:15 INFO - Cleaning up... 15:35:15 INFO - Return code: 0 15:35:15 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 15:35:15 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')]} 15:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:15 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')]} 15:35:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7ff0f002df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2643350>, '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 0x2644250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26446e0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452726374.176553-1871198989', '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 15:35:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:35:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:35:15 INFO - Using env: {'DISPLAY': ':0', 15:35:15 INFO - 'HOME': '/home/cltbld', 15:35:15 INFO - 'LANG': 'en_US.UTF-8', 15:35:15 INFO - 'LANGUAGE': 'en_US:en', 15:35:15 INFO - 'LOGNAME': 'cltbld', 15:35:15 INFO - 'MAIL': '/var/mail/cltbld', 15:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:15 INFO - 'MOZ_NO_REMOTE': '1', 15:35:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:15 INFO - 'NO_EM_RESTART': '1', 15:35:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:35:15 INFO - 'PWD': '/builds/slave/test-pgo', 15:35:15 INFO - 'SHELL': '/bin/bash', 15:35:15 INFO - 'SHLVL': '1', 15:35:15 INFO - 'TERM': 'linux', 15:35:15 INFO - 'TMOUT': '86400', 15:35:15 INFO - 'USER': 'cltbld', 15:35:15 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452726374.176553-1871198989', 15:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:15 INFO - '_': '/tools/buildbot/bin/python'} 15:35:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:15 INFO - Downloading/unpacking flake8 15:35:15 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 15:35:15 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 15:35:15 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 15:35:15 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 15:35:15 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 15:35:15 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 15:35:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:35:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 15:35:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:35:17 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 15:35:17 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 15:35:17 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 15:35:17 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 15:35:17 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 15:35:17 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 15:35:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:35:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 15:35:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:35:17 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 15:35:17 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 15:35:17 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 15:35:17 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 15:35:17 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 15:35:17 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 15:35:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 15:35:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:35:17 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 15:35:17 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 15:35:17 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 15:35:17 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 15:35:17 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 15:35:17 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 15:35:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 15:35:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 15:35:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:35:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:35:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:35:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:35:18 INFO - no previously-included directories found matching 'docs/_build' 15:35:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:35:18 INFO - Running setup.py install for pep8 15:35:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:35:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:35:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:35:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:35:18 INFO - no previously-included directories found matching 'docs/_build' 15:35:18 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 15:35:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:35:18 INFO - Cleaning up... 15:35:18 INFO - Return code: 0 15:35:18 INFO - Running post-action listener: _resource_record_post_action 15:35:18 INFO - Running post-action listener: _start_resource_monitoring 15:35:18 INFO - Starting resource monitoring. 15:35:18 INFO - ##### 15:35:18 INFO - ##### Running install step. 15:35:18 INFO - ##### 15:35:18 INFO - Running pre-action listener: _resource_record_pre_action 15:35:18 INFO - Running main action method: install 15:35:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:35:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:35:18 INFO - Reading from file tmpfile_stdout 15:35:18 INFO - Detecting whether we're running mozinstall >=1.0... 15:35:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:35:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:35:18 INFO - Reading from file tmpfile_stdout 15:35:18 INFO - Output received: 15:35:18 INFO - Usage: mozinstall [options] installer 15:35:18 INFO - Options: 15:35:18 INFO - -h, --help show this help message and exit 15:35:18 INFO - -d DEST, --destination=DEST 15:35:18 INFO - Directory to install application into. [default: 15:35:18 INFO - "/builds/slave/test-pgo"] 15:35:18 INFO - --app=APP Application being installed. [default: firefox] 15:35:18 INFO - mkdir: /builds/slave/test-pgo/build/application 15:35:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 15:35:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 15:35:32 INFO - Reading from file tmpfile_stdout 15:35:32 INFO - Output received: 15:35:32 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:35:32 INFO - Running post-action listener: _resource_record_post_action 15:35:32 INFO - ##### 15:35:32 INFO - ##### Running run-tests step. 15:35:32 INFO - ##### 15:35:32 INFO - Running pre-action listener: _resource_record_pre_action 15:35:32 INFO - Running main action method: run_tests 15:35:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:35:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:35:32 INFO - Python 2.7.3 15:35:32 INFO - Return code: 0 15:35:32 INFO - grabbing minidump binary from tooltool 15:35:32 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')]} 15:35:32 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 0x2643350>, '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 0x2644250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26446e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:35:32 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 15:35:32 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 15:35:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:35:32 INFO - Return code: 0 15:35:32 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:35:32 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:35:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:35:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:35:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:35:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 15:35:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 15:35:33 INFO - Return code: 0 15:35:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452719673/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 15:35:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452719673/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost 15:35:33 INFO - Using env: {'DISPLAY': ':0', 15:35:33 INFO - 'HOME': '/home/cltbld', 15:35:33 INFO - 'LANG': 'en_US.UTF-8', 15:35:33 INFO - 'LANGUAGE': 'en_US:en', 15:35:33 INFO - 'LOGNAME': 'cltbld', 15:35:33 INFO - 'MAIL': '/var/mail/cltbld', 15:35:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:35:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:35:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:33 INFO - 'MOZ_NO_REMOTE': '1', 15:35:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:35:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:33 INFO - 'NO_EM_RESTART': '1', 15:35:33 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:35:33 INFO - 'PWD': '/builds/slave/test-pgo', 15:35:33 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:35:33 INFO - 'SHELL': '/bin/bash', 15:35:33 INFO - 'SHLVL': '1', 15:35:33 INFO - 'TERM': 'linux', 15:35:33 INFO - 'TMOUT': '86400', 15:35:33 INFO - 'USER': 'cltbld', 15:35:33 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452726374.176553-1871198989', 15:35:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:33 INFO - '_': '/tools/buildbot/bin/python'} 15:35:33 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452719673/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost'] with output_timeout 3600 15:35:34 INFO - mozversion INFO | application_buildid: 20160113131433 15:35:34 INFO - mozversion INFO | application_changeset: bdb6dcb5477b9afc0328f70fc35cd8f30470cd99 15:35:34 INFO - mozversion INFO | application_display_name: Nightly 15:35:34 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:35:34 INFO - mozversion INFO | application_name: Firefox 15:35:34 INFO - mozversion INFO | application_remotingname: firefox 15:35:34 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:35:34 INFO - mozversion INFO | application_vendor: Mozilla 15:35:34 INFO - mozversion INFO | application_version: 44.0 15:35:34 INFO - mozversion INFO | platform_buildid: 20160113131433 15:35:34 INFO - mozversion INFO | platform_changeset: bdb6dcb5477b9afc0328f70fc35cd8f30470cd99 15:35:34 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:35:34 INFO - mozversion INFO | platform_version: 44.0 15:35:34 INFO - 2016-01-13 15:35:34,080 DEBUG : using testdate: 1452728134 15:35:34 INFO - 2016-01-13 15:35:34,080 DEBUG : actual date: 1452728134 15:35:34 INFO - 2016-01-13 15:35:34,172 INFO : starting webserver on 'localhost:44150' 15:35:34 INFO - 2016-01-13 15:35:34,173 INFO : Starting test suite talos-linux64-ix-041 15:35:34 INFO - 2016-01-13 15:35:34,174 INFO : Starting test dromaeo_css 15:35:34 INFO - 2016-01-13 15:35:34,174 DEBUG : operating with platform_type : linux_ 15:35:34 INFO - 2016-01-13 15:35:34,174 INFO : Initialising browser for dromaeo_css test... 15:35:34 INFO - 2016-01-13 15:35:34,187 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNRuPFP/profile http://localhost:44150/getInfo.html 15:35:37 INFO - 2016-01-13 15:35:37,967 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:35:37 INFO - 2016-01-13 15:35:37,967 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:35:37 INFO - 2016-01-13 15:35:37,967 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:35:37 INFO - 2016-01-13 15:35:37,968 DEBUG : BROWSER_OUTPUT: __metrics 15:35:38 INFO - 2016-01-13 15:35:38,064 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:35:39 INFO - 2016-01-13 15:35:39,557 INFO : Browser initialized. 15:35:39 INFO - 2016-01-13 15:35:39,558 INFO : Running cycle 1/1 for dromaeo_css test... 15:35:39 INFO - 2016-01-13 15:35:39,558 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNRuPFP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:35:51 INFO - 2016-01-13 15:35:51,115 DEBUG : BROWSER_OUTPUT: RSS: Main: 129159168 15:35:51 INFO - 2016-01-13 15:35:51,115 DEBUG : BROWSER_OUTPUT: 15:36:42 INFO - 2016-01-13 15:36:42,874 DEBUG : BROWSER_OUTPUT: 1452728202870 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] 15:38:49 INFO - 2016-01-13 15:38:49,837 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44150/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44150/tests/dromaeo/cssquery-ext.html) 15:38:50 INFO - 2016-01-13 15:38:50,927 DEBUG : BROWSER_OUTPUT: RSS: Main: 239280128 15:38:50 INFO - 2016-01-13 15:38:50,928 DEBUG : BROWSER_OUTPUT: 15:41:52 INFO - 2016-01-13 15:41:52,993 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44150/tests/dromaeo/cssquery-ext.html (next: http://localhost:44150/tests/dromaeo/cssquery-jquery.html) 15:41:53 INFO - 2016-01-13 15:41:53,557 DEBUG : BROWSER_OUTPUT: RSS: Main: 204582912 15:41:53 INFO - 2016-01-13 15:41:53,557 DEBUG : BROWSER_OUTPUT: 15:44:55 INFO - 2016-01-13 15:44:55,179 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44150/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44150/tests/dromaeo/cssquery-mootools.html) 15:44:55 INFO - 2016-01-13 15:44:55,741 DEBUG : BROWSER_OUTPUT: RSS: Main: 199434240 15:44:55 INFO - 2016-01-13 15:44:55,741 DEBUG : BROWSER_OUTPUT: 15:47:57 INFO - 2016-01-13 15:47:57,428 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44150/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44150/tests/dromaeo/cssquery-prototype.html) 15:47:58 INFO - 2016-01-13 15:47:58,003 DEBUG : BROWSER_OUTPUT: RSS: Main: 198557696 15:47:58 INFO - 2016-01-13 15:47:58,003 DEBUG : BROWSER_OUTPUT: 15:51:00 INFO - 2016-01-13 15:51:00,276 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44150/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44150/tests/dromaeo/cssquery-yui.html) 15:51:00 INFO - 2016-01-13 15:51:00,857 DEBUG : BROWSER_OUTPUT: RSS: Main: 195088384 15:51:00 INFO - 2016-01-13 15:51:00,857 DEBUG : BROWSER_OUTPUT: 15:54:02 INFO - 2016-01-13 15:54:02,951 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44150/tests/dromaeo/cssquery-yui.html (next: http://localhost:44150/tests/dromaeo/cssquery-dojo.html) 15:54:03 INFO - 2016-01-13 15:54:03,202 DEBUG : BROWSER_OUTPUT: RSS: Main: 237322240 15:54:03 INFO - 2016-01-13 15:54:03,202 DEBUG : BROWSER_OUTPUT: 15:54:03 INFO - 2016-01-13 15:54:03,203 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:54:03 INFO - 2016-01-13 15:54:03,204 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:54:03 INFO - 2016-01-13 15:54:03,204 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:54:03 INFO - 2016-01-13 15:54:03,204 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:54:03 INFO - 2016-01-13 15:54:03,204 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3129.5462157987095;3174.2857856982196;3192.6966938140868;3207.887723929663;3227.3867965086633;5529.751161197746;5538.280023596937;5548.58385621078;5549.250851135095;5559.833205003846;5510.504054635082;5533;5541.889162216763;5544.6395984261;5572.164175373696;4996.375453068366;5043.873903152414;5114.667546609458;5155.304033955405;5168.638195326329;5052.343195384595;5116.616253780981;5120.539151476366;5151.5878729701535;5195.298634684326;5108.489151084899;5167.0957582422925;5169.819056333029;5178.741062946857;5197.116490196657;4938.62960277977;5124.128898087334;5176.534111929945;5188.7806365504075;5203.505666961613;5051.9494805051845;5067.9746601267125;5126.666766660155;5154.768035438415;5167.509086636801;5367.329083864517;5367.892642147135;5371.811986580451;5372.865678358034;5426.782928682848;5713.228714123582;5804.564657650651;5942.792002279943;5949.46454819064;5976.940230597682;5868.09044598088;5961.493273071794;5965.791197308074;5967.492763115097;6016.75932962681;5563.471470210324;5566.805161819358;5592.748326325325;5600.215969764236;5605.243292155588;5973.462388385066;6055.394460553909;6089.604175728564;6094.177286066324;6114.205153330127;5908.438698323653;5915.408459154136;5925.940740592625;5927.496162826122;5946.345901950782;6022.69886505673;6026.969865150646;6028.939710602838;6036.486898613667;6040.275166979991;5755.079187330007;5854.795082172103;5957.642541447527;6004.969975150097;6068.939310606926;6057.666828324484;6101.816945491642;6103.450689437972;6109.20580324555;6113.602615829956;4654.837080702159;4674.742889141062;4675.929861052087;4677.204875171229;4699.812007519661;3998.320285551405;3998.3602623580086;4058.837646494166;4077.5922407758985;4080.489938757655;5721.713914304268;5727.169560413717;5733.827985160452;5734.139879018097;5742.799002034993;5897.203877476486;6020.096985452217;6032.638041717511;6037.9396206038255;6069.2110025696375;5560;5637.23897273871;5648.293963254593;5653.830385088454;5683.431656834367;5245.160774276097;5280.392754833243;5283.101872681654;5283.313169288045;5285.814996475105;5962.2249107615735;6059.787907423219;6233.283172435228;6238.719257633417;6248.968755156286;5914.112883067574;5972.462478376967;6026.608270462406;6031.276246850406;6060.424259695322;6109.75560977556;6121;6122.877542449037;6126.571140020156;6183.319834818257;5803.564732644984;5841.591088623755;5867.559933004956;5949.137375080502;5952.345242023287;6052.0921861719335;6108.205933228652;6112;6114.816555503342;6118.663473509;5967.582269241111;5990.281166260077;5990.9700451497465;5991.850203744942;5998.760049598141;5601.215829783752;5735.512481439125;5740.13897915316;5891.410858914074;5934.9406505934385;5837.29952405714;5905.940940590539;5912.438318359749;5918.112283157561;5922.230110085661;5965.343812180743;6017.608855424383;6021.909671354845;6031.276246850406;6039.275286965592;5654.604177707521;5703.800366987136;5730.541556675539;5761.308642962704;5773.220615216892 15:54:03 INFO - 2016-01-13 15:54:03,205 DEBUG : BROWSER_OUTPUT: |1;ext.html;593.5518683394037;617.1668247865382;618.4001518527027;629.9338569450208;636.1094467745156;35107.64892351076;44022.57875816829;44623.10753784926;44671;44674.32988505175;47524;47915.760421197934;48236.758816205955;48249;48282;8107;8233.053198882146;9066.637334506611;9239;10679.519421626046;10914.23600347976;11036.006759391654;11062.723431914186;11069.667909962714;11076.612318568852;10926.235163538555;11042.723931901726;11048.723781905437;11050.944745276262;11052.834207486894;10966.945165274203;11065.778684426346;11069.335839849555;11072.833907491355;11087.113030957504;10813.08088812452;10972;10984.450777461096;10988.615398461016;10989.835152472719;43957.56042439599;44118.558814411765;44365.33451998223;44494.11011779746;44532.55467445317;3563.982180089109;3583.4445660922597;4116.176764647083;4508.120916421299;4569.543045695437;31189.84405077983;31607.52588711171;31867.52198717021;31928.840355798304;31948.680513194802;3829.329867273216;3878.749341785;3922.9803850980848;3993.860214892494;3996.840126394941;336655;339781;341211;341411;342689;56959.14561281501;57948;64399;69567.30432695609;71117;66655.33344666589;67196.6640166796;67388.3261167382;67419;67684;17734.20196091179;17814.554636134202;17914.193861276275;17941.37205197838;17952.19215135322;13646.454141834414;13684.589462316146;13711.657208569866;13715.519956801663;13780.448782048607;20312;20493.975301234877;20708.275210367567;20709.68935465969;20794.688079678817;8225.588720563948;8425.4944703318;8480.703175388831;8514.872276915852;8543.700970466129;952.3571589177278;1087.5377964365114;1096.4024606589428;1120.1486869978876;1172.3903570143477;30193.547096793565;30327.545086823717;30663.92676256365;30715.846420767753;30809.229769255948;1073.1307640810812;1106.623747925709;1137.852079229695;1196.4795314038422;1209.0790482735358;13241.602751917459;14434.855651443351;14515.477490686482;14841.257937103102;15023.699526009419;363541;364547;366316;366386;366862;51444.22833657498;51674.48325516697;51685.99999999925;51939.74030129901;51969.74015129976;1422.9430822766974;1444.3139508733268;1479.8742106920818;1521.0873475914364;1552.7903732996126;27713.168604941882;28002;28055;29962.330624654398;30210.84894575513;54138.458615414915;54762;54773.45226547843;54791;54835.45164548304;316054;317071;317182;317304;317513;33984.830075849466;34272;34279;34308.48537271993;34652.65347346595;49313.26030109479;49699.50300497093;49802;50012;50513.74743126261;36996.63003370039;37604.623953760114;39386.015349616486;39412;39474.60525394709;38801;39287.41068884026;39322.41016384814;39565.2086958265;39650;38615;39478.40782388209;39517.80241098776;39541.80229098836;39546.80226598849;34651.4802277961;35153.47269791007;35420.82289588536;36107.63892361043;36166.819165904;27087;27122.72877271202;27387.589186161826;27411.86294068517;27524.174274771787 15:54:03 INFO - 2016-01-13 15:54:03,209 DEBUG : BROWSER_OUTPUT: |2;jquery.html;386.3586446498812;388.45228228198226;391.17266980336586;392.57013570140685;392.8408994357286;13875.306234688276;13981.650458738537;18298.817011829895;20263.39209823706;20270.99999999998;13127.606171814838;13503.459861605525;13531.864681353183;19122.80877191231;19536.902315488438;4891.095147397734;4992.500749925015;5002.0246052019875;5013.699178049311;5016.824411145611;4950.405951285851;4979.975100124494;4988.950110498903;4990.6007519398545;5024.145895197825;3841.1741475582744;3892.70804689648;4989.675671081386;4993.725345106018;5002.674826136289;5327.786888524454;5396.217548455491;5435.130379139318;5448.863778405532;5458.972705136469;4581.106684196583;4658.114958157939;4723.07899959508;4723.574878260973;4742.976285118552;15117.848821511754;15203.61990950224;15234.695306093927;15279.465218717403;15854.841451585451;1980.5147738804085;2031.2992017753852;2037.6739721644615;2096.371088673407;2129.808317251455;10763.946180269128;10838.891611083945;10880.78238435227;11090.057345125673;11123.332600044023;1820.7268909663524;1885.3589779474908;1889.102676228794;1890.4517689869922;1925.7015162649811;66273.3372666272;67213.66393168003;68067;68346.31653683449;68650.65674671644;7851.371890248766;7921.722739704198;8055.597220139087;8056.959715201387;8061.234182752629;9624.085711857362;9627.277954153467;9634.421934683942;9637.277204209713;9648.131668149901;6385.808425747235;6399.872002559922;6472.0291956206;6480.416762491398;6486.902696459557;6721.1598550181225;6732.990051492316;6768.323167683192;6790.694418751168;6791.388775010273;3697;3729.68297694699;3734.0104872208885;3734.085149138424;3743.7005039596766;1282.2691066092425;1282.557517656407;1302.4659889445281;1302.9739405212033;1345.7510360583324;432.9220740266719;433.9826406943687;467.2687244462405;509;525.9868503287372;11663.475143618558;11834.349110798816;11873.346965916784;12136.817947730791;12399.814002789966;432.58904041161026;465.64843543125403;479.44863407081436;484.3437142671629;507.18596652373145;6373.904391434132;6501.430693612261;6553.508486863504;6593.142891424084;6640.767573134917;588033.1795023078;590986;592426;595764;603008;80905;84987;85183;85967;86184;593.5073888672391;600.4625859855493;601.1613798750718;602.120903480914;602.8553147244718;12308.876911230773;12439.689007774516;12451.315177665316;12525.185862918881;12549.623511294676;34660.65339346574;35338.646613533536;35568.644313556535;35570.46644300389;35727.46408803818;43976;44386.55613443953;45436.77281613571;45978.770106150594;46014.769926150155;7070.151581810215;7420.5547667140145;7432.405407567274;7495.850082998419;7543.73596924105;13606.86393136056;13632.795508067189;13725.382357794122;13898.23559704226;14138.151710897379;11923.224990375598;12094.334811585448;12305.815412768636;12510.562130325396;12627.747445050863;11895.048396128463;12272.26366417982;12310.630681079581;12311.69220769488;12314.384280786104;11791.115666324888;12393.256404615751;12426.81359779586;12531.812022819848;12546.498140074294;7556.4710470266555;7567.243275672388;7656.846863062819;7660.080790304976;7667.578283194478;11850.559529446813;11877.940610297239;11893.405329733305;11897.881021189678;12111.454984525893 15:54:03 INFO - 2016-01-13 15:54:03,210 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1580.4389441748178;1591.9442819501319;1798.9910050449746;1847.9260829566817;1866.3001374484563;7238.167610724755;7390.445716571252;7740.380769538438;7885.1326354101075;7901.7629471115815;7594.73418430355;7751.108622508414;7836.2947334739865;7844.333231675315;7845.372370210383;2372.79831214347;2414.577448946436;2415.4806716555936;2420.7579242075826;2421.370443684637;2118.8834614096218;2174.3911704722705;2225.254539729193;2300.8159347252263;2412.2039726890084;2315.6642286868396;2325.2559181062065;2333.7199536055696;2334.743178250391;2337.0067721218497;2391.222852572912;2414.4567472318586;2416.6012607919847;2421.757824217582;2423.3578101803037;2229.5095079082575;2261.9660705089436;2262.049939025613;2262.3326118794994;2262.513559584681;7794.649240784178;7853.136155022943;7858.057033156001;7858.960705196495;7864.252895974931;4789.640776941744;4827.25177597473;4855.441624213226;4867.805287788484;4873.02539492103;3114.314850732835;3145.6067991501063;3147.2289289124083;3176.904692859218;3198.6801319867827;1095.189559725805;1128.6388355726172;1138.299945533499;1138.6413279816913;1167.10716302029;10864.348139111678;10881.401522916236;10887.455627218607;10891.07425868802;10896.128309735202;4472.508024117345;4472.575105364985;4507.752073635916;4514.774261286922;4528.9094218116115;9347.112024357675;9366.95316523413;9367.297452691075;9371.156595906401;9373.297002724823;4937.5556199942175;4953.959668469662;4959.876003099951;4960.429550601727;4966.329545511309;4543.295789152687;4543.38664280318;4554.476235232924;4554.88612784683;4563.406757121553;3730.7948062856262;3742.9438558421643;3762.5861155272896;3770.45328427382;3795.804321638675;1129.1136457880525;1185.199990006742;1192.511070461124;1286.7040580666498;1313.1136482874213;1385.4112002399143;1447.3920953199681;1448.601634550507;1448.7537118689847;1480.4670318685264;7652.579108149105;7669.463137580316;7806.258405451473;7848.7645370638975;7853.764387068397;1203.8435003449495;1205.5780476833038;1216.0818581970732;1216.5863606373875;1228.1648479034163;6182.041783523561;6246.781362652286;6282.780102696475;6290.748370065237;6293.3391993840905;9773.560189791477;9879.753006174904;9891.802163956681;9901.950490247502;9916.057974492556;9481.383710058824;9733;9780.853287200698;9782.266330025133;9788.265880058882;7628.961855190689;7668.501547399401;7700.807479812937;7708.152103268636;7734.381249500027;7318.121825380988;7391.482596218213;7405.62971851416;7423.703051877865;7441.888371674538;8555.8716619252;8723.956380218058;8801.07588703177;8802.38383313162;8843.204111629984;8744.737657870273;8897.555122243732;8919.598618062333;8924.553772311489;8992.910070899206;7094.219635839951;7097.964510177416;7175.8564828704175;7178.353948144692;7181;7968.0836703779805;8050.959745201237;8087.1104178539135;8111.797205069684;8129.634166462642;6474.514411419256;6731.1922569292;6893.724251029903;7450.515716478411;7656.73201437947;7188.209296977224;7201.3518783309755;7285.635718213962;7359.043324368012;7421.2949769771785;7461.328480436787;7491.737789177353;7492.550446972981;7493.587852668155;7494.213107623621;6728.865422691617;6752.628605426748;6793.354631310018;6819.113515243185;6863.279355667583;6995.79012629622;7008.544444611084;7023.719051237893;7027.15674119109;7032.859342813217 15:54:03 INFO - 2016-01-13 15:54:03,210 DEBUG : BROWSER_OUTPUT: |4;prototype.html;367.7940353402095;370.97217708671855;374.26083485116897;379.11098474078284;379.756955548449;5951.761929522814;5994.340622531518;5995.460408563228;6005.279366476024;6021.819345419644;5734.770609175638;5814.186013958049;5821.912671309934;5929.2884853817495;5946.643201407918;4655.44134703836;4668.533146685321;4675.275332323478;4679.415073115861;4680.719156850591;4634.165850146972;4683.88290292742;4685.273782563708;4685.60172385346;4686.507916668752;4633.953660463386;4640.211164102111;4640.837570685027;4642.512536183703;4643.257078867382;4560.612347950429;4633.7683115844075;4634.281686338623;4652.139354219464;4658.091672123937;4084.4894388201474;4091.57038510958;4095.692823038254;4096.56986016467;4102.979485102585;5626.493615574577;5661;5683.5737319700775;5687.175359572881;5691.544676425876;5250.44870288618;5359.356877174725;5370.677759334452;5380.3274590676165;5389.622726409153;6283.2460104787715;6291;6309.432151106376;6316.273628532732;6320.683965801738;4527.750973696446;4560.270356742905;4563.840265590721;4564.224081906051;4564.589186973189;6516.446102081329;6538.574992625464;6566;6595.736170553172;6602.7689030883685;4703.670743048022;4707.5057119002695;4711.646626503026;4782.617390608743;4789.976050119797;4830.275458681155;4844.249141383091;4844.467108618049;4845.466998630148;4848.17581011229;5447.182922561568;5447.618666693294;5447.673139611636;5449.5640348772;5452.591055670761;6328.873422531616;6329.968350158219;6357.268914074941;6362.268339141058;6377.23473183221;1710.8716846236582;1773.361589827661;1777.0759205213217;1777.0848013273176;1780.1188411736273;1125.7804728077947;1151.153901882116;1192.7614477104614;1215.1129675337054;1223.2171410297417;6113.480354169857;6131.049687298476;6134.4172303631085;6134.570580059353;6138.1713468681155;6478.5141114415665;6480.31956644555;6488.578242414323;6493.155889734304;6494.512911531559;6021.668808215591;6129.11127886454;6129.785457508966;6130.172426722335;6238.844028899223;3624.7281453891064;3636.127329440915;3644.5444319460066;3668.321360548307;3670.5778835433734;6794.048833163361;6797.286284940109;6799.354061364163;6805.931940680629;6806.42145417645;6655.866882662416;6688.799336019927;6701.698423570951;6759.831004224835;6766.932330676728;6696.2968888267005;6759.966200168968;6760.18877734675;6762.492813039042;6791.7095751807;6568.80293591193;6590.110335104891;6595.472362210916;6600.636964966973;6603.471722262304;6374.681265936777;6497.350264973465;6498.967505162444;6505.056766768697;6505.804825855232;6735.932640673531;6780.050792889098;6791.185057793096;6794.796156115324;6794.9320506796275;4836.419629644465;4838.95161048385;4840.1529732296;4843.491433399583;4846.830360937351;6462.709178086903;6549.869002619826;6568.901466477911;6582.243042050225;6582.572132811543;6410.230772307166;6415.615063096229;6419.486441084796;6430.485561155003;6441.452476539546;6361.427471527585;6403.551751377358;6404.103425520338;6409.102725618324;6423.518236132402;6241.7038137691925;6279.937200627935;6304.779332723333;6316.526260530571;6320.5891617044745;6377.426031657174;6396.104545363746;6443.806685799434;6455.354464553695;6462.579932304385;6208.161898143693;6215.720292586754;6284.08880712285;6305.905411418924;6307.96846015767 15:54:03 INFO - 2016-01-13 15:54:03,211 DEBUG : BROWSER_OUTPUT: |5;yui.html;815.6655771133836;848.5587494502859;918.1782304837167;933.7525555727731;934.2339281788936;12642.557510487124;13279.93360033201;13294.401751921163;13297.46810127595;13305.201687898732;13109.147905386144;13188.406521706522;13194.53819116331;13207.207567545955;13244.404001819918;758.6813538313894;778.4784194589611;896.2650626486251;904.5341649050744;919.5678031325266;928.5171710710426;930.9441433513977;934.7663084228943;935.289180223032;936.8547875079373;977.5747549815817;983.5082458770614;986.3982970388093;987.8123156600259;987.8913319534845;790.7943934577023;812.772423721359;935.4667839331584;965.473816769855;970.2141265574907;710.1655554723179;710.7618947652543;713.7573225103438;715.459827829985;715.8747219236665;13469.663258418519;13536.187828730308;13548.59354219375;13625.978051646167;13630.454781808716;11407.25852819564;11761.470733817;12036.87963120375;12070.396480175956;12130.939345303304;9679.322447428684;9694.36986595869;9746.90253097467;9752.853707194397;9777.31558790885;3403.710684591813;3441.48377743338;3444.603870554893;3476.3394954958476;3478.8260586970805;51729.22406163911;51853.48146518524;52257.73871130658;53169.734151328994;53223.93552128974;9312.301577381724;9330.160285574195;9353.158215760614;9410.200132988773;9461.053894610484;19191;19265.036748162536;19284.421467356;19289.710654340197;19335.51661208481;6958.269381714847;7013.964930175419;7036;7036.410664544288;7204.027456293438;4395.033092719596;4458.554144585515;4462.665300102505;4470.865874023784;4475.6643251755595;2917.0957003329036;2925.9707402926124;2946.071987323986;2948.2187220386613;2948.43979643867;453.0418165579775;462.30884827183576;463.937368455261;467.352716487667;470.6846412903363;630.9148264984168;642.2164958750317;665.1685393258427;682.2836022176695;704.8378872859271;8708.738737837875;8777.166169213915;8849.60176792046;8866.556672166495;8874.054779460941;494.4967299409754;591.5267785771366;682.2052309059989;732.868083744931;743.6690672650727;4243.5746063061;4254.914901702011;4262;4377.277749171351;4591.494935557086;61038.69480652568;61808.38191618026;66200.66899665567;66535.33464665388;67028;58562;58827.70586147127;58911.70544147337;59747.402525975056;59835;52675.47324526706;52860.73569632127;52908;53659;54217.45782542203;9141.908580914373;9244;9352.67265645699;9466.479343636167;9565.665201717906;40224.597754022085;40601;41131.9999999988;41139.38290925699;41660.375094373005;49541;53258.4674153269;53715.73142134264;53752.46247537475;54162;8597.484150950962;8617.913820861711;8619.353548483763;8911.287097032093;9049.049849765943;12124.696882578006;12473.002159827374;12737.490500379881;12861.742765144458;12911.096223264281;11410.714732131431;11591.420428978687;11663.416829158678;11758.529658813552;11970.401479925795;10952.671419857417;11593.88406115928;11614;12396.380180990735;12400.56598019065;10316.948415258175;10353.119984801377;11321.320720756781;11451.141164412536;11516.424178791194;8746.25656819152;9972.152367048591;10081;10344.431056291674;10562.630307939186;9714;9882.901170988198;10081.848772268275;10083;10086.646967356108 15:54:03 INFO - 2016-01-13 15:54:03,212 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:54:03 INFO - 2016-01-13 15:54:03,212 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:54:03 INFO - 2016-01-13 15:54:03,212 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,852 15:54:03 INFO - 2016-01-13 15:54:03,212 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:54:03 INFO - 2016-01-13 15:54:03,212 DEBUG : BROWSER_OUTPUT: __startTimestamp1452729243201__endTimestamp 15:54:03 INFO - 2016-01-13 15:54:03,212 DEBUG : BROWSER_OUTPUT: 15:54:03 INFO - 2016-01-13 15:54:03,212 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:54:03 INFO - 2016-01-13 15:54:03,212 DEBUG : BROWSER_OUTPUT: Number of tests: 6 15:54:03 INFO - 2016-01-13 15:54:03,213 DEBUG : BROWSER_OUTPUT: 15:54:03 INFO - 2016-01-13 15:54:03,213 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5569.54 Median:5755.08 stddev:635.55 (11.0%) stddev-sans-first:607.99 15:54:03 INFO - 2016-01-13 15:54:03,213 DEBUG : BROWSER_OUTPUT: Values: 3129.5 3174.3 3192.7 3207.9 3227.4 5529.8 5538.3 5548.6 5549.3 5559.8 5510.5 5533.0 5541.9 5544.6 5572.2 4996.4 5043.9 5114.7 5155.3 5168.6 5052.3 5116.6 5120.5 5151.6 5195.3 5108.5 5167.1 5169.8 5178.7 5197.1 4938.6 5124.1 5176.5 5188.8 5203.5 5051.9 5068.0 5126.7 5154.8 5167.5 5367.3 5367.9 5371.8 5372.9 5426.8 5713.2 5804.6 5942.8 5949.5 5976.9 5868.1 5961.5 5965.8 5967.5 6016.8 5563.5 5566.8 5592.7 5600.2 5605.2 5973.5 6055.4 6089.6 6094.2 6114.2 5908.4 5915.4 5925.9 5927.5 5946.3 6022.7 6027.0 6028.9 6036.5 6040.3 5755.1 5854.8 5957.6 6005.0 6068.9 6057.7 6101.8 6103.5 6109.2 6113.6 4654.8 4674.7 4675.9 4677.2 4699.8 3998.3 3998.4 4058.8 4077.6 4080.5 5721.7 5727.2 5733.8 5734.1 5742.8 5897.2 6020.1 6032.6 6037.9 6069.2 5560.0 5637.2 5648.3 5653.8 5683.4 5245.2 5280.4 5283.1 5283.3 5285.8 5962.2 6059.8 6233.3 6238.7 6249.0 5914.1 5972.5 6026.6 6031.3 6060.4 6109.8 6121.0 6122.9 6126.6 6183.3 5803.6 5841.6 5867.6 5949.1 5952.3 6052.1 6108.2 6112.0 6114.8 6118.7 5967.6 5990.3 5991.0 5991.9 5998.8 5601.2 5735.5 5740.1 5891.4 5934.9 5837.3 5905.9 5912.4 5918.1 5922.2 5965.3 6017.6 6021.9 6031.3 6039.3 5654.6 5703.8 5730.5 5761.3 5773.2 15:54:03 INFO - 2016-01-13 15:54:03,213 DEBUG : BROWSER_OUTPUT: 15:54:03 INFO - 2016-01-13 15:54:03,213 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:52535.11 Median:34880.15 stddev:89358.64 (256.2%) stddev-sans-first:89524.21 15:54:03 INFO - 2016-01-13 15:54:03,213 DEBUG : BROWSER_OUTPUT: Values: 593.6 617.2 618.4 629.9 636.1 35107.6 44022.6 44623.1 44671.0 44674.3 47524.0 47915.8 48236.8 48249.0 48282.0 8107.0 8233.1 9066.6 9239.0 10679.5 10914.2 11036.0 11062.7 11069.7 11076.6 10926.2 11042.7 11048.7 11050.9 11052.8 10966.9 11065.8 11069.3 11072.8 11087.1 10813.1 10972.0 10984.5 10988.6 10989.8 43957.6 44118.6 44365.3 44494.1 44532.6 3564.0 3583.4 4116.2 4508.1 4569.5 31189.8 31607.5 31867.5 31928.8 31948.7 3829.3 3878.7 3923.0 3993.9 3996.8 336655.0 339781.0 341211.0 341411.0 342689.0 56959.1 57948.0 64399.0 69567.3 71117.0 66655.3 67196.7 67388.3 67419.0 67684.0 17734.2 17814.6 17914.2 17941.4 17952.2 13646.5 13684.6 13711.7 13715.5 13780.4 20312.0 20494.0 20708.3 20709.7 20794.7 8225.6 8425.5 8480.7 8514.9 8543.7 952.4 1087.5 1096.4 1120.1 1172.4 30193.5 30327.5 30663.9 30715.8 30809.2 1073.1 1106.6 1137.9 1196.5 1209.1 13241.6 14434.9 14515.5 14841.3 15023.7 363541.0 364547.0 366316.0 366386.0 366862.0 51444.2 51674.5 51686.0 51939.7 51969.7 1422.9 1444.3 1479.9 1521.1 1552.8 27713.2 28002.0 28055.0 29962.3 30210.8 54138.5 54762.0 54773.5 54791.0 54835.5 316054.0 317071.0 317182.0 317304.0 317513.0 33984.8 34272.0 34279.0 34308.5 34652.7 49313.3 49699.5 49802.0 50012.0 50513.7 36996.6 37604.6 39386.0 39412.0 39474.6 38801.0 39287.4 39322.4 39565.2 39650.0 38615.0 39478.4 39517.8 39541.8 39546.8 34651.5 35153.5 35420.8 36107.6 36166.8 27087.0 27122.7 27387.6 27411.9 27524.2 15:54:03 INFO - 2016-01-13 15:54:03,214 DEBUG : BROWSER_OUTPUT: 15:54:03 INFO - 2016-01-13 15:54:03,214 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29478.35 Median:44181.28 stddev:97342.78 (220.3%) stddev-sans-first:97591.33 15:54:03 INFO - 2016-01-13 15:54:03,215 DEBUG : BROWSER_OUTPUT: Values: 386.4 388.5 391.2 392.6 392.8 13875.3 13981.7 18298.8 20263.4 20271.0 13127.6 13503.5 13531.9 19122.8 19536.9 4891.1 4992.5 5002.0 5013.7 5016.8 4950.4 4980.0 4989.0 4990.6 5024.1 3841.2 3892.7 4989.7 4993.7 5002.7 5327.8 5396.2 5435.1 5448.9 5459.0 4581.1 4658.1 4723.1 4723.6 4743.0 15117.8 15203.6 15234.7 15279.5 15854.8 1980.5 2031.3 2037.7 2096.4 2129.8 10763.9 10838.9 10880.8 11090.1 11123.3 1820.7 1885.4 1889.1 1890.5 1925.7 66273.3 67213.7 68067.0 68346.3 68650.7 7851.4 7921.7 8055.6 8057.0 8061.2 9624.1 9627.3 9634.4 9637.3 9648.1 6385.8 6399.9 6472.0 6480.4 6486.9 6721.2 6733.0 6768.3 6790.7 6791.4 3697.0 3729.7 3734.0 3734.1 3743.7 1282.3 1282.6 1302.5 1303.0 1345.8 432.9 434.0 467.3 509.0 526.0 11663.5 11834.3 11873.3 12136.8 12399.8 432.6 465.6 479.4 484.3 507.2 6373.9 6501.4 6553.5 6593.1 6640.8 588033.2 590986.0 592426.0 595764.0 603008.0 80905.0 84987.0 85183.0 85967.0 86184.0 593.5 600.5 601.2 602.1 602.9 12308.9 12439.7 12451.3 12525.2 12549.6 34660.7 35338.6 35568.6 35570.5 35727.5 43976.0 44386.6 45436.8 45978.8 46014.8 7070.2 7420.6 7432.4 7495.9 7543.7 13606.9 13632.8 13725.4 13898.2 14138.2 11923.2 12094.3 12305.8 12510.6 12627.7 11895.0 12272.3 12310.6 12311.7 12314.4 11791.1 12393.3 12426.8 12531.8 12546.5 7556.5 7567.2 7656.8 7660.1 7667.6 11850.6 11877.9 11893.4 11897.9 12111.5 15:54:03 INFO - 2016-01-13 15:54:03,215 DEBUG : BROWSER_OUTPUT: 15:54:03 INFO - 2016-01-13 15:54:03,215 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5690.25 Median:6601.69 stddev:2903.58 (44.0%) stddev-sans-first:2895.29 15:54:03 INFO - 2016-01-13 15:54:03,215 DEBUG : BROWSER_OUTPUT: Values: 1580.4 1591.9 1799.0 1847.9 1866.3 7238.2 7390.4 7740.4 7885.1 7901.8 7594.7 7751.1 7836.3 7844.3 7845.4 2372.8 2414.6 2415.5 2420.8 2421.4 2118.9 2174.4 2225.3 2300.8 2412.2 2315.7 2325.3 2333.7 2334.7 2337.0 2391.2 2414.5 2416.6 2421.8 2423.4 2229.5 2262.0 2262.0 2262.3 2262.5 7794.6 7853.1 7858.1 7859.0 7864.3 4789.6 4827.3 4855.4 4867.8 4873.0 3114.3 3145.6 3147.2 3176.9 3198.7 1095.2 1128.6 1138.3 1138.6 1167.1 10864.3 10881.4 10887.5 10891.1 10896.1 4472.5 4472.6 4507.8 4514.8 4528.9 9347.1 9367.0 9367.3 9371.2 9373.3 4937.6 4954.0 4959.9 4960.4 4966.3 4543.3 4543.4 4554.5 4554.9 4563.4 3730.8 3742.9 3762.6 3770.5 3795.8 1129.1 1185.2 1192.5 1286.7 1313.1 1385.4 1447.4 1448.6 1448.8 1480.5 7652.6 7669.5 7806.3 7848.8 7853.8 1203.8 1205.6 1216.1 1216.6 1228.2 6182.0 6246.8 6282.8 6290.7 6293.3 9773.6 9879.8 9891.8 9902.0 9916.1 9481.4 9733.0 9780.9 9782.3 9788.3 7629.0 7668.5 7700.8 7708.2 7734.4 7318.1 7391.5 7405.6 7423.7 7441.9 8555.9 8724.0 8801.1 8802.4 8843.2 8744.7 8897.6 8919.6 8924.6 8992.9 7094.2 7098.0 7175.9 7178.4 7181.0 7968.1 8051.0 8087.1 8111.8 8129.6 6474.5 6731.2 6893.7 7450.5 7656.7 7188.2 7201.4 7285.6 7359.0 7421.3 7461.3 7491.7 7492.6 7493.6 7494.2 6728.9 6752.6 6793.4 6819.1 6863.3 6995.8 7008.5 7023.7 7027.2 7032.9 15:54:03 INFO - 2016-01-13 15:54:03,216 DEBUG : BROWSER_OUTPUT: 15:54:03 INFO - 2016-01-13 15:54:03,216 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5372.48 Median:6067.65 stddev:1558.76 (25.7%) stddev-sans-first:1517.20 15:54:03 INFO - 2016-01-13 15:54:03,216 DEBUG : BROWSER_OUTPUT: Values: 367.8 371.0 374.3 379.1 379.8 5951.8 5994.3 5995.5 6005.3 6021.8 5734.8 5814.2 5821.9 5929.3 5946.6 4655.4 4668.5 4675.3 4679.4 4680.7 4634.2 4683.9 4685.3 4685.6 4686.5 4634.0 4640.2 4640.8 4642.5 4643.3 4560.6 4633.8 4634.3 4652.1 4658.1 4084.5 4091.6 4095.7 4096.6 4103.0 5626.5 5661.0 5683.6 5687.2 5691.5 5250.4 5359.4 5370.7 5380.3 5389.6 6283.2 6291.0 6309.4 6316.3 6320.7 4527.8 4560.3 4563.8 4564.2 4564.6 6516.4 6538.6 6566.0 6595.7 6602.8 4703.7 4707.5 4711.6 4782.6 4790.0 4830.3 4844.2 4844.5 4845.5 4848.2 5447.2 5447.6 5447.7 5449.6 5452.6 6328.9 6330.0 6357.3 6362.3 6377.2 1710.9 1773.4 1777.1 1777.1 1780.1 1125.8 1151.2 1192.8 1215.1 1223.2 6113.5 6131.0 6134.4 6134.6 6138.2 6478.5 6480.3 6488.6 6493.2 6494.5 6021.7 6129.1 6129.8 6130.2 6238.8 3624.7 3636.1 3644.5 3668.3 3670.6 6794.0 6797.3 6799.4 6805.9 6806.4 6655.9 6688.8 6701.7 6759.8 6766.9 6696.3 6760.0 6760.2 6762.5 6791.7 6568.8 6590.1 6595.5 6600.6 6603.5 6374.7 6497.4 6499.0 6505.1 6505.8 6735.9 6780.1 6791.2 6794.8 6794.9 4836.4 4839.0 4840.2 4843.5 4846.8 6462.7 6549.9 6568.9 6582.2 6582.6 6410.2 6415.6 6419.5 6430.5 6441.5 6361.4 6403.6 6404.1 6409.1 6423.5 6241.7 6279.9 6304.8 6316.5 6320.6 6377.4 6396.1 6443.8 6455.4 6462.6 6208.2 6215.7 6284.1 6305.9 6308.0 15:54:03 INFO - 2016-01-13 15:54:03,216 DEBUG : BROWSER_OUTPUT: 15:54:03 INFO - 2016-01-13 15:54:03,216 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14906.19 Median:53241.20 stddev:18366.58 (34.5%) stddev-sans-first:18387.63 15:54:03 INFO - 2016-01-13 15:54:03,217 DEBUG : BROWSER_OUTPUT: Values: 815.7 848.6 918.2 933.8 934.2 12642.6 13279.9 13294.4 13297.5 13305.2 13109.1 13188.4 13194.5 13207.2 13244.4 758.7 778.5 896.3 904.5 919.6 928.5 930.9 934.8 935.3 936.9 977.6 983.5 986.4 987.8 987.9 790.8 812.8 935.5 965.5 970.2 710.2 710.8 713.8 715.5 715.9 13469.7 13536.2 13548.6 13626.0 13630.5 11407.3 11761.5 12036.9 12070.4 12130.9 9679.3 9694.4 9746.9 9752.9 9777.3 3403.7 3441.5 3444.6 3476.3 3478.8 51729.2 51853.5 52257.7 53169.7 53223.9 9312.3 9330.2 9353.2 9410.2 9461.1 19191.0 19265.0 19284.4 19289.7 19335.5 6958.3 7014.0 7036.0 7036.4 7204.0 4395.0 4458.6 4462.7 4470.9 4475.7 2917.1 2926.0 2946.1 2948.2 2948.4 453.0 462.3 463.9 467.4 470.7 630.9 642.2 665.2 682.3 704.8 8708.7 8777.2 8849.6 8866.6 8874.1 494.5 591.5 682.2 732.9 743.7 4243.6 4254.9 4262.0 4377.3 4591.5 61038.7 61808.4 66200.7 66535.3 67028.0 58562.0 58827.7 58911.7 59747.4 59835.0 52675.5 52860.7 52908.0 53659.0 54217.5 9141.9 9244.0 9352.7 9466.5 9565.7 40224.6 40601.0 41132.0 41139.4 41660.4 49541.0 53258.5 53715.7 53752.5 54162.0 8597.5 8617.9 8619.4 8911.3 9049.0 12124.7 12473.0 12737.5 12861.7 12911.1 11410.7 11591.4 11663.4 11758.5 11970.4 10952.7 11593.9 11614.0 12396.4 12400.6 10316.9 10353.1 11321.3 11451.1 11516.4 8746.3 9972.2 10081.0 10344.4 10562.6 9714.0 9882.9 10081.8 10083.0 10086.6 15:54:03 INFO - 2016-01-13 15:54:03,217 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:54:03 INFO - 2016-01-13 15:54:03,217 DEBUG : BROWSER_OUTPUT: 15:54:03 INFO - 2016-01-13 15:54:03,773 INFO : Browser exited with error code: 0 15:54:03 INFO - 2016-01-13 15:54:03,792 INFO : Completed test dromaeo_css (00:18:29) 15:54:03 INFO - 2016-01-13 15:54:03,792 INFO : Starting test kraken 15:54:03 INFO - 2016-01-13 15:54:03,792 DEBUG : operating with platform_type : linux_ 15:54:03 INFO - 2016-01-13 15:54:03,792 INFO : Initialising browser for kraken test... 15:54:03 INFO - 2016-01-13 15:54:03,799 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpi_bpul/profile http://localhost:44150/getInfo.html 15:54:07 INFO - 2016-01-13 15:54:07,271 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:54:07 INFO - 2016-01-13 15:54:07,271 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:54:07 INFO - 2016-01-13 15:54:07,271 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:54:07 INFO - 2016-01-13 15:54:07,271 DEBUG : BROWSER_OUTPUT: __metrics 15:54:07 INFO - 2016-01-13 15:54:07,355 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:54:08 INFO - 2016-01-13 15:54:08,685 INFO : Browser initialized. 15:54:08 INFO - 2016-01-13 15:54:08,686 INFO : Running cycle 1/1 for kraken test... 15:54:08 INFO - 2016-01-13 15:54:08,686 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpi_bpul/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:54:20 INFO - 2016-01-13 15:54:20,166 DEBUG : BROWSER_OUTPUT: RSS: Main: 128454656 15:54:20 INFO - 2016-01-13 15:54:20,166 DEBUG : BROWSER_OUTPUT: 15:54:22 INFO - 2016-01-13 15:54:22,621 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44150/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44150/tests/kraken/driver.html?testName=audio-beat-detection) 15:54:23 INFO - 2016-01-13 15:54:23,186 DEBUG : BROWSER_OUTPUT: RSS: Main: 163028992 15:54:23 INFO - 2016-01-13 15:54:23,187 DEBUG : BROWSER_OUTPUT: 15:54:25 INFO - 2016-01-13 15:54:25,748 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44150/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44150/tests/kraken/driver.html?testName=audio-dft) 15:54:26 INFO - 2016-01-13 15:54:26,330 DEBUG : BROWSER_OUTPUT: RSS: Main: 158298112 15:54:26 INFO - 2016-01-13 15:54:26,331 DEBUG : BROWSER_OUTPUT: 15:54:29 INFO - 2016-01-13 15:54:29,111 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44150/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44150/tests/kraken/driver.html?testName=audio-fft) 15:54:29 INFO - 2016-01-13 15:54:29,673 DEBUG : BROWSER_OUTPUT: RSS: Main: 157315072 15:54:29 INFO - 2016-01-13 15:54:29,673 DEBUG : BROWSER_OUTPUT: 15:54:31 INFO - 2016-01-13 15:54:31,631 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44150/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44150/tests/kraken/driver.html?testName=audio-oscillator) 15:54:32 INFO - 2016-01-13 15:54:32,193 DEBUG : BROWSER_OUTPUT: RSS: Main: 156594176 15:54:32 INFO - 2016-01-13 15:54:32,193 DEBUG : BROWSER_OUTPUT: 15:54:34 INFO - 2016-01-13 15:54:34,334 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44150/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44150/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:54:34 INFO - 2016-01-13 15:54:34,896 DEBUG : BROWSER_OUTPUT: RSS: Main: 156106752 15:54:34 INFO - 2016-01-13 15:54:34,896 DEBUG : BROWSER_OUTPUT: 15:54:37 INFO - 2016-01-13 15:54:37,760 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44150/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44150/tests/kraken/driver.html?testName=imaging-darkroom) 15:54:38 INFO - 2016-01-13 15:54:38,342 DEBUG : BROWSER_OUTPUT: RSS: Main: 155426816 15:54:38 INFO - 2016-01-13 15:54:38,342 DEBUG : BROWSER_OUTPUT: 15:54:41 INFO - 2016-01-13 15:54:41,668 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44150/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44150/tests/kraken/driver.html?testName=imaging-desaturate) 15:54:42 INFO - 2016-01-13 15:54:42,250 DEBUG : BROWSER_OUTPUT: RSS: Main: 155021312 15:54:42 INFO - 2016-01-13 15:54:42,250 DEBUG : BROWSER_OUTPUT: 15:54:45 INFO - 2016-01-13 15:54:45,001 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44150/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44150/tests/kraken/driver.html?testName=json-parse-financial) 15:54:45 INFO - 2016-01-13 15:54:45,568 DEBUG : BROWSER_OUTPUT: RSS: Main: 155770880 15:54:45 INFO - 2016-01-13 15:54:45,568 DEBUG : BROWSER_OUTPUT: 15:54:47 INFO - 2016-01-13 15:54:47,049 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44150/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44150/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:54:47 INFO - 2016-01-13 15:54:47,611 DEBUG : BROWSER_OUTPUT: RSS: Main: 160428032 15:54:47 INFO - 2016-01-13 15:54:47,611 DEBUG : BROWSER_OUTPUT: 15:54:49 INFO - 2016-01-13 15:54:49,306 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44150/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44150/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:54:49 INFO - 2016-01-13 15:54:49,894 DEBUG : BROWSER_OUTPUT: RSS: Main: 160096256 15:54:49 INFO - 2016-01-13 15:54:49,894 DEBUG : BROWSER_OUTPUT: 15:54:51 INFO - 2016-01-13 15:54:51,847 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44150/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44150/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:54:52 INFO - 2016-01-13 15:54:52,416 DEBUG : BROWSER_OUTPUT: RSS: Main: 163794944 15:54:52 INFO - 2016-01-13 15:54:52,416 DEBUG : BROWSER_OUTPUT: 15:54:54 INFO - 2016-01-13 15:54:54,738 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44150/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44150/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:54:55 INFO - 2016-01-13 15:54:55,321 DEBUG : BROWSER_OUTPUT: RSS: Main: 170409984 15:54:55 INFO - 2016-01-13 15:54:55,322 DEBUG : BROWSER_OUTPUT: 15:54:57 INFO - 2016-01-13 15:54:57,716 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44150/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44150/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:54:58 INFO - 2016-01-13 15:54:58,285 DEBUG : BROWSER_OUTPUT: RSS: Main: 166744064 15:54:58 INFO - 2016-01-13 15:54:58,286 DEBUG : BROWSER_OUTPUT: 15:54:59 INFO - 2016-01-13 15:54:59,866 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44150/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44150/tests/kraken/driver.html?testName=ai-astar) 15:55:00 INFO - 2016-01-13 15:55:00,117 DEBUG : BROWSER_OUTPUT: RSS: Main: 225845248 15:55:00 INFO - 2016-01-13 15:55:00,117 DEBUG : BROWSER_OUTPUT: 15:55:00 INFO - 2016-01-13 15:55:00,121 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:55:00 INFO - 2016-01-13 15:55:00,121 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:55:00 INFO - 2016-01-13 15:55:00,121 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:55:00 INFO - 2016-01-13 15:55:00,121 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:55:00 INFO - 2016-01-13 15:55:00,121 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;109;105;108;109;109;101;109;100;109 15:55:00 INFO - 2016-01-13 15:55:00,121 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;120;144;152;126;148;150;121;163;123 15:55:00 INFO - 2016-01-13 15:55:00,121 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;161;160;161;159;159;162;160;159 15:55:00 INFO - 2016-01-13 15:55:00,122 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;71;144;73;70;73;71;148;71 15:55:00 INFO - 2016-01-13 15:55:00,122 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;88;89;140;89;89;89;135;89;89;128 15:55:00 INFO - 2016-01-13 15:55:00,122 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;111;109;110;109;109;110;110 15:55:00 INFO - 2016-01-13 15:55:00,122 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;145;147;146;145;145;144;146;145 15:55:00 INFO - 2016-01-13 15:55:00,122 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;95;96;95;96;96;95 15:55:00 INFO - 2016-01-13 15:55:00,122 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;54;54;55;54;54;56;54;54;52;56 15:55:00 INFO - 2016-01-13 15:55:00,122 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;61;62;61;61;62;61;61;62;61;62 15:55:00 INFO - 2016-01-13 15:55:00,123 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;83;78;78;84;78;78;78;78;78 15:55:00 INFO - 2016-01-13 15:55:00,123 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;112;113;106;121;113;115;113;113;118;124 15:55:00 INFO - 2016-01-13 15:55:00,123 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;135;134;134;134;134;135;135;134;128 15:55:00 INFO - 2016-01-13 15:55:00,123 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;62;62;63;61;61;61;64;61;63;63 15:55:00 INFO - 2016-01-13 15:55:00,123 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:55:00 INFO - 2016-01-13 15:55:00,123 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:55:00 INFO - 2016-01-13 15:55:00,123 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,893 15:55:00 INFO - 2016-01-13 15:55:00,123 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:55:00 INFO - 2016-01-13 15:55:00,124 DEBUG : BROWSER_OUTPUT: __startTimestamp1452729300118__endTimestamp 15:55:00 INFO - 2016-01-13 15:55:00,124 DEBUG : BROWSER_OUTPUT: 15:55:00 INFO - 2016-01-13 15:55:00,127 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:55:00 INFO - 2016-01-13 15:55:00,127 DEBUG : BROWSER_OUTPUT: Number of tests: 14 15:55:00 INFO - 2016-01-13 15:55:00,127 DEBUG : BROWSER_OUTPUT: 15:55:00 INFO - 2016-01-13 15:55:00,127 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.70 Median:109.00 stddev:3.50 (3.2%) stddev-sans-first:3.68 15:55:00 INFO - 2016-01-13 15:55:00,127 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 105.0 108.0 109.0 109.0 101.0 109.0 100.0 109.0 15:55:00 INFO - 2016-01-13 15:55:00,127 DEBUG : BROWSER_OUTPUT: 15:55:00 INFO - 2016-01-13 15:55:00,128 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.20 Median:149.00 stddev:16.07 (10.8%) stddev-sans-first:16.13 15:55:00 INFO - 2016-01-13 15:55:00,128 DEBUG : BROWSER_OUTPUT: Values: 155.0 120.0 144.0 152.0 126.0 148.0 150.0 121.0 163.0 123.0 15:55:00 INFO - 2016-01-13 15:55:00,128 DEBUG : BROWSER_OUTPUT: 15:55:00 INFO - 2016-01-13 15:55:00,128 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 15:55:00 INFO - 2016-01-13 15:55:00,128 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 161.0 160.0 161.0 159.0 159.0 162.0 160.0 159.0 15:55:00 INFO - 2016-01-13 15:55:00,128 DEBUG : BROWSER_OUTPUT: 15:55:00 INFO - 2016-01-13 15:55:00,128 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:86.40 Median:71.00 stddev:31.44 (44.3%) stddev-sans-first:32.85 15:55:00 INFO - 2016-01-13 15:55:00,128 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 71.0 144.0 73.0 70.0 73.0 71.0 148.0 71.0 15:55:00 INFO - 2016-01-13 15:55:00,128 DEBUG : BROWSER_OUTPUT: 15:55:00 INFO - 2016-01-13 15:55:00,128 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.50 Median:89.00 stddev:22.15 (24.9%) stddev-sans-first:22.87 15:55:00 INFO - 2016-01-13 15:55:00,128 DEBUG : BROWSER_OUTPUT: Values: 88.0 89.0 140.0 89.0 89.0 89.0 135.0 89.0 89.0 128.0 15:55:00 INFO - 2016-01-13 15:55:00,128 DEBUG : BROWSER_OUTPUT: 15:55:00 INFO - 2016-01-13 15:55:00,128 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 15:55:00 INFO - 2016-01-13 15:55:00,128 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 111.0 109.0 110.0 109.0 109.0 110.0 110.0 15:55:00 INFO - 2016-01-13 15:55:00,128 DEBUG : BROWSER_OUTPUT: 15:55:00 INFO - 2016-01-13 15:55:00,128 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 15:55:00 INFO - 2016-01-13 15:55:00,129 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 145.0 147.0 146.0 145.0 145.0 144.0 146.0 145.0 15:55:00 INFO - 2016-01-13 15:55:00,129 DEBUG : BROWSER_OUTPUT: 15:55:00 INFO - 2016-01-13 15:55:00,129 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 15:55:00 INFO - 2016-01-13 15:55:00,129 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 15:55:00 INFO - 2016-01-13 15:55:00,129 DEBUG : BROWSER_OUTPUT: 15:55:00 INFO - 2016-01-13 15:55:00,129 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.00 stddev:1.16 (2.1%) stddev-sans-first:1.22 15:55:00 INFO - 2016-01-13 15:55:00,129 DEBUG : BROWSER_OUTPUT: Values: 54.0 54.0 55.0 54.0 54.0 56.0 54.0 54.0 52.0 56.0 15:55:00 INFO - 2016-01-13 15:55:00,129 DEBUG : BROWSER_OUTPUT: 15:55:00 INFO - 2016-01-13 15:55:00,129 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 15:55:00 INFO - 2016-01-13 15:55:00,129 DEBUG : BROWSER_OUTPUT: Values: 61.0 62.0 61.0 61.0 62.0 61.0 61.0 62.0 61.0 62.0 15:55:00 INFO - 2016-01-13 15:55:00,129 DEBUG : BROWSER_OUTPUT: 15:55:00 INFO - 2016-01-13 15:55:00,129 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:78.00 stddev:2.40 (3.1%) stddev-sans-first:2.44 15:55:00 INFO - 2016-01-13 15:55:00,129 DEBUG : BROWSER_OUTPUT: Values: 77.0 83.0 78.0 78.0 84.0 78.0 78.0 78.0 78.0 78.0 15:55:00 INFO - 2016-01-13 15:55:00,129 DEBUG : BROWSER_OUTPUT: 15:55:00 INFO - 2016-01-13 15:55:00,129 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:114.80 Median:114.00 stddev:5.07 (4.4%) stddev-sans-first:5.28 15:55:00 INFO - 2016-01-13 15:55:00,130 DEBUG : BROWSER_OUTPUT: Values: 112.0 113.0 106.0 121.0 113.0 115.0 113.0 113.0 118.0 124.0 15:55:00 INFO - 2016-01-13 15:55:00,130 DEBUG : BROWSER_OUTPUT: 15:55:00 INFO - 2016-01-13 15:55:00,130 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:133.90 Median:134.50 stddev:2.18 (1.6%) stddev-sans-first:2.18 15:55:00 INFO - 2016-01-13 15:55:00,130 DEBUG : BROWSER_OUTPUT: Values: 136.0 135.0 134.0 134.0 134.0 134.0 135.0 135.0 134.0 128.0 15:55:00 INFO - 2016-01-13 15:55:00,130 DEBUG : BROWSER_OUTPUT: 15:55:00 INFO - 2016-01-13 15:55:00,130 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.50 stddev:1.10 (1.8%) stddev-sans-first:1.17 15:55:00 INFO - 2016-01-13 15:55:00,130 DEBUG : BROWSER_OUTPUT: Values: 62.0 62.0 63.0 61.0 61.0 61.0 64.0 61.0 63.0 63.0 15:55:00 INFO - 2016-01-13 15:55:00,130 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:55:00 INFO - 2016-01-13 15:55:00,130 DEBUG : BROWSER_OUTPUT: 15:55:00 INFO - 2016-01-13 15:55:00,745 INFO : Browser exited with error code: 0 15:55:00 INFO - 2016-01-13 15:55:00,808 INFO : Completed test kraken (00:00:57) 15:55:00 INFO - 2016-01-13 15:55:00,808 INFO : Starting test v8_7 15:55:00 INFO - 2016-01-13 15:55:00,808 DEBUG : operating with platform_type : linux_ 15:55:00 INFO - 2016-01-13 15:55:00,808 INFO : Initialising browser for v8_7 test... 15:55:00 INFO - 2016-01-13 15:55:00,814 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOberXR/profile http://localhost:44150/getInfo.html 15:55:04 INFO - 2016-01-13 15:55:04,208 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:55:04 INFO - 2016-01-13 15:55:04,208 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:55:04 INFO - 2016-01-13 15:55:04,209 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:55:04 INFO - 2016-01-13 15:55:04,209 DEBUG : BROWSER_OUTPUT: __metrics 15:55:04 INFO - 2016-01-13 15:55:04,269 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:55:05 INFO - 2016-01-13 15:55:05,501 INFO : Browser initialized. 15:55:05 INFO - 2016-01-13 15:55:05,502 INFO : Running cycle 1/1 for v8_7 test... 15:55:05 INFO - 2016-01-13 15:55:05,502 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOberXR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:55:16 INFO - 2016-01-13 15:55:16,988 DEBUG : BROWSER_OUTPUT: RSS: Main: 127877120 15:55:16 INFO - 2016-01-13 15:55:16,988 DEBUG : BROWSER_OUTPUT: 15:55:38 INFO - 2016-01-13 15:55:38,317 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44150/tests/v8_7/run.html (next: http://localhost:44150/tests/v8_7/run.html) 15:55:38 INFO - 2016-01-13 15:55:38,567 DEBUG : BROWSER_OUTPUT: RSS: Main: 421531648 15:55:38 INFO - 2016-01-13 15:55:38,568 DEBUG : BROWSER_OUTPUT: 15:55:38 INFO - 2016-01-13 15:55:38,568 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:55:38 INFO - 2016-01-13 15:55:38,568 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:55:38 INFO - 2016-01-13 15:55:38,568 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:55:38 INFO - 2016-01-13 15:55:38,568 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:55:38 INFO - 2016-01-13 15:55:38,568 DEBUG : BROWSER_OUTPUT: |0;Richards;168.32183134152498 15:55:38 INFO - 2016-01-13 15:55:38,569 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;171.29153819801303 15:55:38 INFO - 2016-01-13 15:55:38,569 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.2524161455372 15:55:38 INFO - 2016-01-13 15:55:38,569 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5045.226130653266 15:55:38 INFO - 2016-01-13 15:55:38,569 DEBUG : BROWSER_OUTPUT: |4;RayTrace;949.667616334283 15:55:38 INFO - 2016-01-13 15:55:38,569 DEBUG : BROWSER_OUTPUT: |5;Earley;553.7098560354374 15:55:38 INFO - 2016-01-13 15:55:38,570 DEBUG : BROWSER_OUTPUT: |6;Boyer;10416.666666666666 15:55:38 INFO - 2016-01-13 15:55:38,570 DEBUG : BROWSER_OUTPUT: |7;RegExp;23833.333333333332 15:55:38 INFO - 2016-01-13 15:55:38,570 DEBUG : BROWSER_OUTPUT: |8;Splay;538.2131324004306 15:55:38 INFO - 2016-01-13 15:55:38,570 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4817.307692307692 15:55:38 INFO - 2016-01-13 15:55:38,570 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:55:38 INFO - 2016-01-13 15:55:38,571 DEBUG : BROWSER_OUTPUT: __startTimestamp1452729338564__endTimestamp 15:55:38 INFO - 2016-01-13 15:55:38,571 DEBUG : BROWSER_OUTPUT: 15:55:38 INFO - 2016-01-13 15:55:38,571 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:55:38 INFO - 2016-01-13 15:55:38,571 DEBUG : BROWSER_OUTPUT: Number of tests: 10 15:55:38 INFO - 2016-01-13 15:55:38,571 DEBUG : BROWSER_OUTPUT: 15:55:38 INFO - 2016-01-13 15:55:38,571 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.32 Median:168.32 stddev:0.00 (0.0%) 15:55:38 INFO - 2016-01-13 15:55:38,571 DEBUG : BROWSER_OUTPUT: Values: 168.3 15:55:38 INFO - 2016-01-13 15:55:38,572 DEBUG : BROWSER_OUTPUT: 15:55:38 INFO - 2016-01-13 15:55:38,572 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:171.29 Median:171.29 stddev:0.00 (0.0%) 15:55:38 INFO - 2016-01-13 15:55:38,572 DEBUG : BROWSER_OUTPUT: Values: 171.3 15:55:38 INFO - 2016-01-13 15:55:38,572 DEBUG : BROWSER_OUTPUT: 15:55:38 INFO - 2016-01-13 15:55:38,572 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.25 Median:284.25 stddev:0.00 (0.0%) 15:55:38 INFO - 2016-01-13 15:55:38,572 DEBUG : BROWSER_OUTPUT: Values: 284.3 15:55:38 INFO - 2016-01-13 15:55:38,572 DEBUG : BROWSER_OUTPUT: 15:55:38 INFO - 2016-01-13 15:55:38,572 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5045.23 Median:5045.23 stddev:0.00 (0.0%) 15:55:38 INFO - 2016-01-13 15:55:38,573 DEBUG : BROWSER_OUTPUT: Values: 5045.2 15:55:38 INFO - 2016-01-13 15:55:38,573 DEBUG : BROWSER_OUTPUT: 15:55:38 INFO - 2016-01-13 15:55:38,573 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:949.67 Median:949.67 stddev:0.00 (0.0%) 15:55:38 INFO - 2016-01-13 15:55:38,573 DEBUG : BROWSER_OUTPUT: Values: 949.7 15:55:38 INFO - 2016-01-13 15:55:38,573 DEBUG : BROWSER_OUTPUT: 15:55:38 INFO - 2016-01-13 15:55:38,573 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:553.71 Median:553.71 stddev:0.00 (0.0%) 15:55:38 INFO - 2016-01-13 15:55:38,573 DEBUG : BROWSER_OUTPUT: Values: 553.7 15:55:38 INFO - 2016-01-13 15:55:38,573 DEBUG : BROWSER_OUTPUT: 15:55:38 INFO - 2016-01-13 15:55:38,573 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10416.67 Median:10416.67 stddev:0.00 (0.0%) 15:55:38 INFO - 2016-01-13 15:55:38,573 DEBUG : BROWSER_OUTPUT: Values: 10416.7 15:55:38 INFO - 2016-01-13 15:55:38,573 DEBUG : BROWSER_OUTPUT: 15:55:38 INFO - 2016-01-13 15:55:38,573 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23833.33 Median:23833.33 stddev:0.00 (0.0%) 15:55:38 INFO - 2016-01-13 15:55:38,574 DEBUG : BROWSER_OUTPUT: Values: 23833.3 15:55:38 INFO - 2016-01-13 15:55:38,574 DEBUG : BROWSER_OUTPUT: 15:55:38 INFO - 2016-01-13 15:55:38,574 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:538.21 Median:538.21 stddev:0.00 (0.0%) 15:55:38 INFO - 2016-01-13 15:55:38,574 DEBUG : BROWSER_OUTPUT: Values: 538.2 15:55:38 INFO - 2016-01-13 15:55:38,574 DEBUG : BROWSER_OUTPUT: 15:55:38 INFO - 2016-01-13 15:55:38,574 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 15:55:38 INFO - 2016-01-13 15:55:38,574 DEBUG : BROWSER_OUTPUT: Values: 4817.3 15:55:38 INFO - 2016-01-13 15:55:38,574 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:55:38 INFO - 2016-01-13 15:55:38,574 DEBUG : BROWSER_OUTPUT: 15:55:39 INFO - 2016-01-13 15:55:39,277 INFO : Browser exited with error code: 0 15:55:39 INFO - 2016-01-13 15:55:39,295 INFO : Completed test v8_7 (00:00:38) 15:55:39 INFO - 2016-01-13 15:55:39,645 INFO : Completed test suite (00:20:05) 15:55:39 INFO - 2016-01-13 15:55:39,645 DEBUG : Working with test: dromaeo_css 15:55:39 INFO - 2016-01-13 15:55:39,646 DEBUG : Generating results file: dromaeo_css 15:55:39 INFO - 2016-01-13 15:55:39,647 DEBUG : Working with test: kraken 15:55:39 INFO - 2016-01-13 15:55:39,647 DEBUG : Generating results file: kraken 15:55:39 INFO - 2016-01-13 15:55:39,647 INFO : javascript benchmark 15:55:39 INFO - 2016-01-13 15:55:39,647 DEBUG : Working with test: v8_7 15:55:39 INFO - 2016-01-13 15:55:39,647 DEBUG : Generating results file: v8_7 15:55:39 INFO - 2016-01-13 15:55:39,648 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:55:39 INFO - 2016-01-13 15:55:39,700 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 15:55:39 INFO - 2016-01-13 15:55:39,701 DEBUG : process_Request line: dromaeo_css 7102.89 graph.html#tests=[[72,53,35]] 15:55:39 INFO - 2016-01-13 15:55:39,701 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:55:39 INFO - 2016-01-13 15:55:39,837 DEBUG : process_Request line: kraken 1451.70 graph.html#tests=[[232,53,35]] 15:55:39 INFO - 2016-01-13 15:55:39,837 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:55:39 INFO - 2016-01-13 15:55:39,872 DEBUG : process_Request line: v8_7 23160.88 graph.html#tests=[[230,53,35]] 15:55:39 INFO - 2016-01-13 15:55:39,873 INFO : javascript benchmark 15:55:39 INFO - 2016-01-13 15:55:39,877 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3129.5462157987095, 3174.2857856982196, 3192.6966938140868, 3207.887723929663, 3227.3867965086633, 5529.751161197746, 5538.280023596937, 5548.58385621078, 5549.250851135095, 5559.833205003846, 5510.504054635082, 5533.0, 5541.889162216763, 5544.6395984261, 5572.164175373696, 4996.375453068366, 5043.873903152414, 5114.667546609458, 5155.304033955405, 5168.638195326329, 5052.343195384595, 5116.616253780981, 5120.539151476366, 5151.5878729701535, 5195.298634684326, 5108.489151084899, 5167.0957582422925, 5169.819056333029, 5178.741062946857, 5197.116490196657, 4938.62960277977, 5124.128898087334, 5176.534111929945, 5188.7806365504075, 5203.505666961613, 5051.9494805051845, 5067.9746601267125, 5126.666766660155, 5154.768035438415, 5167.509086636801, 5367.329083864517, 5367.892642147135, 5371.811986580451, 5372.865678358034, 5426.782928682848, 5713.228714123582, 5804.564657650651, 5942.792002279943, 5949.46454819064, 5976.940230597682, 5868.09044598088, 5961.493273071794, 5965.791197308074, 5967.492763115097, 6016.75932962681, 5563.471470210324, 5566.805161819358, 5592.748326325325, 5600.215969764236, 5605.243292155588, 5973.462388385066, 6055.394460553909, 6089.604175728564, 6094.177286066324, 6114.205153330127, 5908.438698323653, 5915.408459154136, 5925.940740592625, 5927.496162826122, 5946.345901950782, 6022.69886505673, 6026.969865150646, 6028.939710602838, 6036.486898613667, 6040.275166979991, 5755.079187330007, 5854.795082172103, 5957.642541447527, 6004.969975150097, 6068.939310606926, 6057.666828324484, 6101.816945491642, 6103.450689437972, 6109.20580324555, 6113.602615829956, 4654.837080702159, 4674.742889141062, 4675.929861052087, 4677.204875171229, 4699.812007519661, 3998.320285551405, 3998.3602623580086, 4058.837646494166, 4077.5922407758985, 4080.489938757655, 5721.713914304268, 5727.169560413717, 5733.827985160452, 5734.139879018097, 5742.799002034993, 5897.203877476486, 6020.096985452217, 6032.638041717511, 6037.9396206038255, 6069.2110025696375, 5560.0, 5637.23897273871, 5648.293963254593, 5653.830385088454, 5683.431656834367, 5245.160774276097, 5280.392754833243, 5283.101872681654, 5283.313169288045, 5285.814996475105, 5962.2249107615735, 6059.787907423219, 6233.283172435228, 6238.719257633417, 6248.968755156286, 5914.112883067574, 5972.462478376967, 6026.608270462406, 6031.276246850406, 6060.424259695322, 6109.75560977556, 6121.0, 6122.877542449037, 6126.571140020156, 6183.319834818257, 5803.564732644984, 5841.591088623755, 5867.559933004956, 5949.137375080502, 5952.345242023287, 6052.0921861719335, 6108.205933228652, 6112.0, 6114.816555503342, 6118.663473509, 5967.582269241111, 5990.281166260077, 5990.9700451497465, 5991.850203744942, 5998.760049598141, 5601.215829783752, 5735.512481439125, 5740.13897915316, 5891.410858914074, 5934.9406505934385, 5837.29952405714, 5905.940940590539, 5912.438318359749, 5918.112283157561, 5922.230110085661, 5965.343812180743, 6017.608855424383, 6021.909671354845, 6031.276246850406, 6039.275286965592, 5654.604177707521, 5703.800366987136, 5730.541556675539, 5761.308642962704, 5773.220615216892], "unit": "ms", "name": "dojo.html", "value": 5525.918594589485}, {"lowerIsBetter": false, "replicates": [593.5518683394037, 617.1668247865382, 618.4001518527027, 629.9338569450208, 636.1094467745156, 35107.64892351076, 44022.57875816829, 44623.10753784926, 44671.0, 44674.32988505175, 47524.0, 47915.760421197934, 48236.758816205955, 48249.0, 48282.0, 8107.0, 8233.053198882146, 9066.637334506611, 9239.0, 10679.519421626046, 10914.23600347976, 11036.006759391654, 11062.723431914186, 11069.667909962714, 11076.612318568852, 10926.235163538555, 11042.723931901726, 11048.723781905437, 11050.944745276262, 11052.834207486894, 10966.945165274203, 11065.778684426346, 11069.335839849555, 11072.833907491355, 11087.113030957504, 10813.08088812452, 10972.0, 10984.450777461096, 10988.615398461016, 10989.835152472719, 43957.56042439599, 44118.558814411765, 44365.33451998223, 44494.11011779746, 44532.55467445317, 3563.982180089109, 3583.4445660922597, 4116.176764647083, 4508.120916421299, 4569.543045695437, 31189.84405077983, 31607.52588711171, 31867.52198717021, 31928.840355798304, 31948.680513194802, 3829.329867273216, 3878.749341785, 3922.9803850980848, 3993.860214892494, 3996.840126394941, 336655.0, 339781.0, 341211.0, 341411.0, 342689.0, 56959.14561281501, 57948.0, 64399.0, 69567.30432695609, 71117.0, 66655.33344666589, 67196.6640166796, 67388.3261167382, 67419.0, 67684.0, 17734.20196091179, 17814.554636134202, 17914.193861276275, 17941.37205197838, 17952.19215135322, 13646.454141834414, 13684.589462316146, 13711.657208569866, 13715.519956801663, 13780.448782048607, 20312.0, 20493.975301234877, 20708.275210367567, 20709.68935465969, 20794.688079678817, 8225.588720563948, 8425.4944703318, 8480.703175388831, 8514.872276915852, 8543.700970466129, 952.3571589177278, 1087.5377964365114, 1096.4024606589428, 1120.1486869978876, 1172.3903570143477, 30193.547096793565, 30327.545086823717, 30663.92676256365, 30715.846420767753, 30809.229769255948, 1073.1307640810812, 1106.623747925709, 1137.852079229695, 1196.4795314038422, 1209.0790482735358, 13241.602751917459, 14434.855651443351, 14515.477490686482, 14841.257937103102, 15023.699526009419, 363541.0, 364547.0, 366316.0, 366386.0, 366862.0, 51444.22833657498, 51674.48325516697, 51685.99999999925, 51939.74030129901, 51969.74015129976, 1422.9430822766974, 1444.3139508733268, 1479.8742106920818, 1521.0873475914364, 1552.7903732996126, 27713.168604941882, 28002.0, 28055.0, 29962.330624654398, 30210.84894575513, 54138.458615414915, 54762.0, 54773.45226547843, 54791.0, 54835.45164548304, 316054.0, 317071.0, 317182.0, 317304.0, 317513.0, 33984.830075849466, 34272.0, 34279.0, 34308.48537271993, 34652.65347346595, 49313.26030109479, 49699.50300497093, 49802.0, 50012.0, 50513.74743126261, 36996.63003370039, 37604.623953760114, 39386.015349616486, 39412.0, 39474.60525394709, 38801.0, 39287.41068884026, 39322.41016384814, 39565.2086958265, 39650.0, 38615.0, 39478.40782388209, 39517.80241098776, 39541.80229098836, 39546.80226598849, 34651.4802277961, 35153.47269791007, 35420.82289588536, 36107.63892361043, 36166.819165904, 27087.0, 27122.72877271202, 27387.589186161826, 27411.86294068517, 27524.174274771787], "unit": "ms", "name": "ext.html", "value": 20542.511613184226}, {"lowerIsBetter": false, "replicates": [386.3586446498812, 388.45228228198226, 391.17266980336586, 392.57013570140685, 392.8408994357286, 13875.306234688276, 13981.650458738537, 18298.817011829895, 20263.39209823706, 20270.99999999998, 13127.606171814838, 13503.459861605525, 13531.864681353183, 19122.80877191231, 19536.902315488438, 4891.095147397734, 4992.500749925015, 5002.0246052019875, 5013.699178049311, 5016.824411145611, 4950.405951285851, 4979.975100124494, 4988.950110498903, 4990.6007519398545, 5024.145895197825, 3841.1741475582744, 3892.70804689648, 4989.675671081386, 4993.725345106018, 5002.674826136289, 5327.786888524454, 5396.217548455491, 5435.130379139318, 5448.863778405532, 5458.972705136469, 4581.106684196583, 4658.114958157939, 4723.07899959508, 4723.574878260973, 4742.976285118552, 15117.848821511754, 15203.61990950224, 15234.695306093927, 15279.465218717403, 15854.841451585451, 1980.5147738804085, 2031.2992017753852, 2037.6739721644615, 2096.371088673407, 2129.808317251455, 10763.946180269128, 10838.891611083945, 10880.78238435227, 11090.057345125673, 11123.332600044023, 1820.7268909663524, 1885.3589779474908, 1889.102676228794, 1890.4517689869922, 1925.7015162649811, 66273.3372666272, 67213.66393168003, 68067.0, 68346.31653683449, 68650.65674671644, 7851.371890248766, 7921.722739704198, 8055.597220139087, 8056.959715201387, 8061.234182752629, 9624.085711857362, 9627.277954153467, 9634.421934683942, 9637.277204209713, 9648.131668149901, 6385.808425747235, 6399.872002559922, 6472.0291956206, 6480.416762491398, 6486.902696459557, 6721.1598550181225, 6732.990051492316, 6768.323167683192, 6790.694418751168, 6791.388775010273, 3697.0, 3729.68297694699, 3734.0104872208885, 3734.085149138424, 3743.7005039596766, 1282.2691066092425, 1282.557517656407, 1302.4659889445281, 1302.9739405212033, 1345.7510360583324, 432.9220740266719, 433.9826406943687, 467.2687244462405, 509.0, 525.9868503287372, 11663.475143618558, 11834.349110798816, 11873.346965916784, 12136.817947730791, 12399.814002789966, 432.58904041161026, 465.64843543125403, 479.44863407081436, 484.3437142671629, 507.18596652373145, 6373.904391434132, 6501.430693612261, 6553.508486863504, 6593.142891424084, 6640.767573134917, 588033.1795023078, 590986.0, 592426.0, 595764.0, 603008.0, 80905.0, 84987.0, 85183.0, 85967.0, 86184.0, 593.5073888672391, 600.4625859855493, 601.1613798750718, 602.120903480914, 602.8553147244718, 12308.876911230773, 12439.689007774516, 12451.315177665316, 12525.185862918881, 12549.623511294676, 34660.65339346574, 35338.646613533536, 35568.644313556535, 35570.46644300389, 35727.46408803818, 43976.0, 44386.55613443953, 45436.77281613571, 45978.770106150594, 46014.769926150155, 7070.151581810215, 7420.5547667140145, 7432.405407567274, 7495.850082998419, 7543.73596924105, 13606.86393136056, 13632.795508067189, 13725.382357794122, 13898.23559704226, 14138.151710897379, 11923.224990375598, 12094.334811585448, 12305.815412768636, 12510.562130325396, 12627.747445050863, 11895.048396128463, 12272.26366417982, 12310.630681079581, 12311.69220769488, 12314.384280786104, 11791.115666324888, 12393.256404615751, 12426.81359779586, 12531.812022819848, 12546.498140074294, 7556.4710470266555, 7567.243275672388, 7656.846863062819, 7660.080790304976, 7667.578283194478, 11850.559529446813, 11877.940610297239, 11893.405329733305, 11897.881021189678, 12111.454984525893], "unit": "ms", "name": "jquery.html", "value": 7548.112155445771}, {"lowerIsBetter": false, "replicates": [1580.4389441748178, 1591.9442819501319, 1798.9910050449746, 1847.9260829566817, 1866.3001374484563, 7238.167610724755, 7390.445716571252, 7740.380769538438, 7885.1326354101075, 7901.7629471115815, 7594.73418430355, 7751.108622508414, 7836.2947334739865, 7844.333231675315, 7845.372370210383, 2372.79831214347, 2414.577448946436, 2415.4806716555936, 2420.7579242075826, 2421.370443684637, 2118.8834614096218, 2174.3911704722705, 2225.254539729193, 2300.8159347252263, 2412.2039726890084, 2315.6642286868396, 2325.2559181062065, 2333.7199536055696, 2334.743178250391, 2337.0067721218497, 2391.222852572912, 2414.4567472318586, 2416.6012607919847, 2421.757824217582, 2423.3578101803037, 2229.5095079082575, 2261.9660705089436, 2262.049939025613, 2262.3326118794994, 2262.513559584681, 7794.649240784178, 7853.136155022943, 7858.057033156001, 7858.960705196495, 7864.252895974931, 4789.640776941744, 4827.25177597473, 4855.441624213226, 4867.805287788484, 4873.02539492103, 3114.314850732835, 3145.6067991501063, 3147.2289289124083, 3176.904692859218, 3198.6801319867827, 1095.189559725805, 1128.6388355726172, 1138.299945533499, 1138.6413279816913, 1167.10716302029, 10864.348139111678, 10881.401522916236, 10887.455627218607, 10891.07425868802, 10896.128309735202, 4472.508024117345, 4472.575105364985, 4507.752073635916, 4514.774261286922, 4528.9094218116115, 9347.112024357675, 9366.95316523413, 9367.297452691075, 9371.156595906401, 9373.297002724823, 4937.5556199942175, 4953.959668469662, 4959.876003099951, 4960.429550601727, 4966.329545511309, 4543.295789152687, 4543.38664280318, 4554.476235232924, 4554.88612784683, 4563.406757121553, 3730.7948062856262, 3742.9438558421643, 3762.5861155272896, 3770.45328427382, 3795.804321638675, 1129.1136457880525, 1185.199990006742, 1192.511070461124, 1286.7040580666498, 1313.1136482874213, 1385.4112002399143, 1447.3920953199681, 1448.601634550507, 1448.7537118689847, 1480.4670318685264, 7652.579108149105, 7669.463137580316, 7806.258405451473, 7848.7645370638975, 7853.764387068397, 1203.8435003449495, 1205.5780476833038, 1216.0818581970732, 1216.5863606373875, 1228.1648479034163, 6182.041783523561, 6246.781362652286, 6282.780102696475, 6290.748370065237, 6293.3391993840905, 9773.560189791477, 9879.753006174904, 9891.802163956681, 9901.950490247502, 9916.057974492556, 9481.383710058824, 9733.0, 9780.853287200698, 9782.266330025133, 9788.265880058882, 7628.961855190689, 7668.501547399401, 7700.807479812937, 7708.152103268636, 7734.381249500027, 7318.121825380988, 7391.482596218213, 7405.62971851416, 7423.703051877865, 7441.888371674538, 8555.8716619252, 8723.956380218058, 8801.07588703177, 8802.38383313162, 8843.204111629984, 8744.737657870273, 8897.555122243732, 8919.598618062333, 8924.553772311489, 8992.910070899206, 7094.219635839951, 7097.964510177416, 7175.8564828704175, 7178.353948144692, 7181.0, 7968.0836703779805, 8050.959745201237, 8087.1104178539135, 8111.797205069684, 8129.634166462642, 6474.514411419256, 6731.1922569292, 6893.724251029903, 7450.515716478411, 7656.73201437947, 7188.209296977224, 7201.3518783309755, 7285.635718213962, 7359.043324368012, 7421.2949769771785, 7461.328480436787, 7491.737789177353, 7492.550446972981, 7493.587852668155, 7494.213107623621, 6728.865422691617, 6752.628605426748, 6793.354631310018, 6819.113515243185, 6863.279355667583, 6995.79012629622, 7008.544444611084, 7023.719051237893, 7027.15674119109, 7032.859342813217], "unit": "ms", "name": "mootools.html", "value": 4714.004822822533}, {"lowerIsBetter": false, "replicates": [367.7940353402095, 370.97217708671855, 374.26083485116897, 379.11098474078284, 379.756955548449, 5951.761929522814, 5994.340622531518, 5995.460408563228, 6005.279366476024, 6021.819345419644, 5734.770609175638, 5814.186013958049, 5821.912671309934, 5929.2884853817495, 5946.643201407918, 4655.44134703836, 4668.533146685321, 4675.275332323478, 4679.415073115861, 4680.719156850591, 4634.165850146972, 4683.88290292742, 4685.273782563708, 4685.60172385346, 4686.507916668752, 4633.953660463386, 4640.211164102111, 4640.837570685027, 4642.512536183703, 4643.257078867382, 4560.612347950429, 4633.7683115844075, 4634.281686338623, 4652.139354219464, 4658.091672123937, 4084.4894388201474, 4091.57038510958, 4095.692823038254, 4096.56986016467, 4102.979485102585, 5626.493615574577, 5661.0, 5683.5737319700775, 5687.175359572881, 5691.544676425876, 5250.44870288618, 5359.356877174725, 5370.677759334452, 5380.3274590676165, 5389.622726409153, 6283.2460104787715, 6291.0, 6309.432151106376, 6316.273628532732, 6320.683965801738, 4527.750973696446, 4560.270356742905, 4563.840265590721, 4564.224081906051, 4564.589186973189, 6516.446102081329, 6538.574992625464, 6566.0, 6595.736170553172, 6602.7689030883685, 4703.670743048022, 4707.5057119002695, 4711.646626503026, 4782.617390608743, 4789.976050119797, 4830.275458681155, 4844.249141383091, 4844.467108618049, 4845.466998630148, 4848.17581011229, 5447.182922561568, 5447.618666693294, 5447.673139611636, 5449.5640348772, 5452.591055670761, 6328.873422531616, 6329.968350158219, 6357.268914074941, 6362.268339141058, 6377.23473183221, 1710.8716846236582, 1773.361589827661, 1777.0759205213217, 1777.0848013273176, 1780.1188411736273, 1125.7804728077947, 1151.153901882116, 1192.7614477104614, 1215.1129675337054, 1223.2171410297417, 6113.480354169857, 6131.049687298476, 6134.4172303631085, 6134.570580059353, 6138.1713468681155, 6478.5141114415665, 6480.31956644555, 6488.578242414323, 6493.155889734304, 6494.512911531559, 6021.668808215591, 6129.11127886454, 6129.785457508966, 6130.172426722335, 6238.844028899223, 3624.7281453891064, 3636.127329440915, 3644.5444319460066, 3668.321360548307, 3670.5778835433734, 6794.048833163361, 6797.286284940109, 6799.354061364163, 6805.931940680629, 6806.42145417645, 6655.866882662416, 6688.799336019927, 6701.698423570951, 6759.831004224835, 6766.932330676728, 6696.2968888267005, 6759.966200168968, 6760.18877734675, 6762.492813039042, 6791.7095751807, 6568.80293591193, 6590.110335104891, 6595.472362210916, 6600.636964966973, 6603.471722262304, 6374.681265936777, 6497.350264973465, 6498.967505162444, 6505.056766768697, 6505.804825855232, 6735.932640673531, 6780.050792889098, 6791.185057793096, 6794.796156115324, 6794.9320506796275, 4836.419629644465, 4838.95161048385, 4840.1529732296, 4843.491433399583, 4846.830360937351, 6462.709178086903, 6549.869002619826, 6568.901466477911, 6582.243042050225, 6582.572132811543, 6410.230772307166, 6415.615063096229, 6419.486441084796, 6430.485561155003, 6441.452476539546, 6361.427471527585, 6403.551751377358, 6404.103425520338, 6409.102725618324, 6423.518236132402, 6241.7038137691925, 6279.937200627935, 6304.779332723333, 6316.526260530571, 6320.5891617044745, 6377.426031657174, 6396.104545363746, 6443.806685799434, 6455.354464553695, 6462.579932304385, 6208.161898143693, 6215.720292586754, 6284.08880712285, 6305.905411418924, 6307.96846015767], "unit": "ms", "name": "prototype.html", "value": 4884.460825540718}, {"lowerIsBetter": false, "replicates": [815.6655771133836, 848.5587494502859, 918.1782304837167, 933.7525555727731, 934.2339281788936, 12642.557510487124, 13279.93360033201, 13294.401751921163, 13297.46810127595, 13305.201687898732, 13109.147905386144, 13188.406521706522, 13194.53819116331, 13207.207567545955, 13244.404001819918, 758.6813538313894, 778.4784194589611, 896.2650626486251, 904.5341649050744, 919.5678031325266, 928.5171710710426, 930.9441433513977, 934.7663084228943, 935.289180223032, 936.8547875079373, 977.5747549815817, 983.5082458770614, 986.3982970388093, 987.8123156600259, 987.8913319534845, 790.7943934577023, 812.772423721359, 935.4667839331584, 965.473816769855, 970.2141265574907, 710.1655554723179, 710.7618947652543, 713.7573225103438, 715.459827829985, 715.8747219236665, 13469.663258418519, 13536.187828730308, 13548.59354219375, 13625.978051646167, 13630.454781808716, 11407.25852819564, 11761.470733817, 12036.87963120375, 12070.396480175956, 12130.939345303304, 9679.322447428684, 9694.36986595869, 9746.90253097467, 9752.853707194397, 9777.31558790885, 3403.710684591813, 3441.48377743338, 3444.603870554893, 3476.3394954958476, 3478.8260586970805, 51729.22406163911, 51853.48146518524, 52257.73871130658, 53169.734151328994, 53223.93552128974, 9312.301577381724, 9330.160285574195, 9353.158215760614, 9410.200132988773, 9461.053894610484, 19191.0, 19265.036748162536, 19284.421467356, 19289.710654340197, 19335.51661208481, 6958.269381714847, 7013.964930175419, 7036.0, 7036.410664544288, 7204.027456293438, 4395.033092719596, 4458.554144585515, 4462.665300102505, 4470.865874023784, 4475.6643251755595, 2917.0957003329036, 2925.9707402926124, 2946.071987323986, 2948.2187220386613, 2948.43979643867, 453.0418165579775, 462.30884827183576, 463.937368455261, 467.352716487667, 470.6846412903363, 630.9148264984168, 642.2164958750317, 665.1685393258427, 682.2836022176695, 704.8378872859271, 8708.738737837875, 8777.166169213915, 8849.60176792046, 8866.556672166495, 8874.054779460941, 494.4967299409754, 591.5267785771366, 682.2052309059989, 732.868083744931, 743.6690672650727, 4243.5746063061, 4254.914901702011, 4262.0, 4377.277749171351, 4591.494935557086, 61038.69480652568, 61808.38191618026, 66200.66899665567, 66535.33464665388, 67028.0, 58562.0, 58827.70586147127, 58911.70544147337, 59747.402525975056, 59835.0, 52675.47324526706, 52860.73569632127, 52908.0, 53659.0, 54217.45782542203, 9141.908580914373, 9244.0, 9352.67265645699, 9466.479343636167, 9565.665201717906, 40224.597754022085, 40601.0, 41131.9999999988, 41139.38290925699, 41660.375094373005, 49541.0, 53258.4674153269, 53715.73142134264, 53752.46247537475, 54162.0, 8597.484150950962, 8617.913820861711, 8619.353548483763, 8911.287097032093, 9049.049849765943, 12124.696882578006, 12473.002159827374, 12737.490500379881, 12861.742765144458, 12911.096223264281, 11410.714732131431, 11591.420428978687, 11663.416829158678, 11758.529658813552, 11970.401479925795, 10952.671419857417, 11593.88406115928, 11614.0, 12396.380180990735, 12400.56598019065, 10316.948415258175, 10353.119984801377, 11321.320720756781, 11451.141164412536, 11516.424178791194, 8746.25656819152, 9972.152367048591, 10081.0, 10344.431056291674, 10562.630307939186, 9714.0, 9882.901170988198, 10081.848772268275, 10083.0, 10086.646967356108], "unit": "ms", "name": "yui.html", "value": 6508.330346700599}], "name": "dromaeo_css", "value": 7102.890677235622}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 105.0, 108.0, 109.0, 109.0, 101.0, 109.0, 100.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 106.7}, {"lowerIsBetter": true, "replicates": [155.0, 120.0, 144.0, 152.0, 126.0, 148.0, 150.0, 121.0, 163.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 140.2}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 161.0, 160.0, 161.0, 159.0, 159.0, 162.0, 160.0, 159.0], "unit": "ms", "name": "audio-dft", "value": 160.1}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 71.0, 144.0, 73.0, 70.0, 73.0, 71.0, 148.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 86.4}, {"lowerIsBetter": true, "replicates": [88.0, 89.0, 140.0, 89.0, 89.0, 89.0, 135.0, 89.0, 89.0, 128.0], "unit": "ms", "name": "audio-oscillator", "value": 102.5}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 111.0, 109.0, 110.0, 109.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 147.0, 146.0, 145.0, 145.0, 144.0, 146.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [54.0, 54.0, 55.0, 54.0, 54.0, 56.0, 54.0, 54.0, 52.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 54.3}, {"lowerIsBetter": true, "replicates": [61.0, 62.0, 61.0, 61.0, 62.0, 61.0, 61.0, 62.0, 61.0, 62.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 61.4}, {"lowerIsBetter": true, "replicates": [77.0, 83.0, 78.0, 78.0, 84.0, 78.0, 78.0, 78.0, 78.0, 78.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 79.0}, {"lowerIsBetter": true, "replicates": [112.0, 113.0, 106.0, 121.0, 113.0, 115.0, 113.0, 113.0, 118.0, 124.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 114.8}, {"lowerIsBetter": true, "replicates": [136.0, 135.0, 134.0, 134.0, 134.0, 134.0, 135.0, 135.0, 134.0, 128.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 133.9}, {"lowerIsBetter": true, "replicates": [62.0, 62.0, 63.0, 61.0, 61.0, 61.0, 64.0, 61.0, 63.0, 63.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 62.1}], "name": "kraken", "value": 1451.6999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.32183134152498], "unit": "score", "name": "Richards", "value": 209.72918199999998}, {"lowerIsBetter": false, "replicates": [171.29153819801303], "unit": "score", "name": "DeltaBlue", "value": 385.9968839999998}, {"lowerIsBetter": false, "replicates": [284.2524161455372], "unit": "score", "name": "Encrypt", "value": 936.4247580000001}, {"lowerIsBetter": false, "replicates": [5045.226130653266], "unit": "score", "name": "Decrypt", "value": 52.75898306772911}, {"lowerIsBetter": false, "replicates": [949.667616334283], "unit": "score", "name": "RayTrace", "value": 779.2084170000002}, {"lowerIsBetter": false, "replicates": [553.7098560354374], "unit": "score", "name": "Earley", "value": 1203.6321779999998}, {"lowerIsBetter": false, "replicates": [10416.666666666666], "unit": "score", "name": "Boyer", "value": 63.980448000000024}, {"lowerIsBetter": false, "replicates": [23833.333333333332], "unit": "score", "name": "RegExp", "value": 38.22314685314689}, {"lowerIsBetter": false, "replicates": [538.2131324004306], "unit": "score", "name": "Splay", "value": 151.41027799999995}, {"lowerIsBetter": false, "replicates": [4817.307692307692], "unit": "score", "name": "NavierStokes", "value": 308.055888223553}], "name": "v8_7", "value": 23160.878442261503}]} 15:55:39 INFO - RETURN: dromaeo_css: 7102.89 15:55:39 INFO - RETURN: kraken: 1451.70 15:55:39 INFO - RETURN: v8_7: 23160.88 15:55:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23160.88"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1451.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7102.89"}}} 15:55:39 INFO - Return code: 0 15:55:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 15:55:40 INFO - # TBPL SUCCESS # 15:55:40 INFO - Running post-action listener: _resource_record_post_action 15:55:40 INFO - Running post-run listener: _resource_record_post_run 15:55:41 INFO - Total resource usage - Wall time: 1221s; CPU: 13.0%; Read bytes: 856064; Write bytes: 310595584; Read time: 508; Write time: 233148 15:55:41 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 19480576; Read time: 0; Write time: 4016 15:55:41 INFO - run-tests - Wall time: 1207s; CPU: 13.0%; Read bytes: 745472; Write bytes: 258600960; Read time: 336; Write time: 219588 15:55:41 INFO - Running post-run listener: _upload_blobber_files 15:55:41 INFO - Blob upload gear active. 15:55:41 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 15:55:41 INFO - Copying logs to upload dir... 15:55:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1273.028539 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-13 15:55:41.128764) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-13 15:55:41.132487) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1452726374.176553-1871198989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452719673/firefox-44.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009895 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452719673/firefox-44.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-13 15:55:41.184445) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 15:55:41.184762) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1452726374.176553-1871198989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004526 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 15:55:41.233883) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 15:55:41.234200) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 15:55:41.234490) ========= ========= Total master_lag: 0.17 =========