builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-049 starttime: 1454343054.31 results: success (0) buildid: 20160201054726 builduid: 7c22a3860f734842b2c2a1daf91f3309 revision: b02e8e8f06da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-01 08:10:54.307231) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-01 08:10:54.307676) ========= ========= Started set props: basedir (results: 0, elapsed: 4 secs) (at 2016-02-01 08:10:54.307962) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1454343051.506293-281325296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006490 basedir: '/builds/slave/test-pgo' ========= master_lag: 4.44 ========= ========= Finished set props: basedir (results: 0, elapsed: 4 secs) (at 2016-02-01 08:10:58.749587) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-01 08:10:58.749901) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-01 08:10:58.763597) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 08:10:58.763885) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1454343051.506293-281325296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004585 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 08:10:58.812796) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-01 08:10:58.813081) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-01 08:10:58.813415) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 08:10:58.813692) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1454343051.506293-281325296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-01 08:10:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 83.4M=0s 2016-02-01 08:10:59 (83.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.223820 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 08:10:59.050141) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 08:10:59.050467) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1454343051.506293-281325296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016084 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 08:10:59.099867) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-01 08:10:59.100195) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b02e8e8f06da --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 b02e8e8f06da --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=8c719f637fb0c43bc4e5671e000001d0-1454343051.506293-281325296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-01 08:10:59,527 Setting DEBUG logging. 2016-02-01 08:10:59,527 attempt 1/10 2016-02-01 08:10:59,527 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b02e8e8f06da?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-01 08:11:00,681 unpacking tar archive at: mozilla-beta-b02e8e8f06da/testing/mozharness/ program finished with exit code 0 elapsedTime=1.412505 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-01 08:11:00.525395) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-01 08:11:00.525744) ========= echo b02e8e8f06da in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b02e8e8f06da'] 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=8c719f637fb0c43bc4e5671e000001d0-1454343051.506293-281325296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b02e8e8f06da program finished with exit code 0 elapsedTime=0.004645 script_repo_revision: 'b02e8e8f06da' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-01 08:11:00.579384) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-01 08:11:00.579681) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-01 08:11:00.589482) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-02-01 08:11:00.589761) ========= /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=8c719f637fb0c43bc4e5671e000001d0-1454343051.506293-281325296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:11:01 INFO - MultiFileLogger online at 20160201 08:11:01 in /builds/slave/test-pgo 08:11:01 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 08:11:01 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:11:01 INFO - {'append_to_log': False, 08:11:01 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:11:01 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:11:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:11:01 INFO - 'branch': 'Mozilla-Beta', 08:11:01 INFO - 'buildbot_json_path': 'buildprops.json', 08:11:01 INFO - 'config_files': ('talos/linux_config.py',), 08:11:01 INFO - 'default_actions': ('clobber', 08:11:01 INFO - 'read-buildbot-config', 08:11:01 INFO - 'download-and-extract', 08:11:01 INFO - 'populate-webroot', 08:11:01 INFO - 'create-virtualenv', 08:11:01 INFO - 'install', 08:11:01 INFO - 'run-tests'), 08:11:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:11:01 INFO - 'download_minidump_stackwalk': True, 08:11:01 INFO - 'download_symbols': 'ondemand', 08:11:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:11:01 INFO - 'tooltool.py': '/tools/tooltool.py', 08:11:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:11:01 INFO - '/tools/misc-python/virtualenv.py')}, 08:11:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:11:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:11:01 INFO - 'installer_path': 'installer.exe', 08:11:01 INFO - 'log_level': 'info', 08:11:01 INFO - 'log_name': 'talos', 08:11:01 INFO - 'log_to_console': True, 08:11:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:11:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:11:01 INFO - 'opt_config_files': (), 08:11:01 INFO - 'pip_index': False, 08:11:01 INFO - 'sps_profile': False, 08:11:01 INFO - 'sps_profile_interval': 0, 08:11:01 INFO - 'suite': 'dromaeojs', 08:11:01 INFO - 'system_bits': '32', 08:11:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:11:01 INFO - 'title': 'talos-linux64-ix-049', 08:11:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:11:01 INFO - 'use_talos_json': True, 08:11:01 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:11:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:11:01 INFO - 'work_dir': 'build'} 08:11:01 INFO - ##### 08:11:01 INFO - ##### Running clobber step. 08:11:01 INFO - ##### 08:11:01 INFO - Running pre-action listener: _resource_record_pre_action 08:11:01 INFO - Running main action method: clobber 08:11:01 INFO - rmtree: /builds/slave/test-pgo/build 08:11:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:11:02 INFO - Running post-action listener: _resource_record_post_action 08:11:02 INFO - ##### 08:11:02 INFO - ##### Running read-buildbot-config step. 08:11:02 INFO - ##### 08:11:02 INFO - Running pre-action listener: _resource_record_pre_action 08:11:02 INFO - Running main action method: read_buildbot_config 08:11:02 INFO - Using buildbot properties: 08:11:02 INFO - { 08:11:02 INFO - "properties": { 08:11:02 INFO - "buildnumber": 97, 08:11:02 INFO - "product": "firefox", 08:11:02 INFO - "script_repo_revision": "production", 08:11:02 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 08:11:02 INFO - "repository": "", 08:11:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 08:11:02 INFO - "buildid": "20160201054726", 08:11:02 INFO - "slavename": "talos-linux64-ix-049", 08:11:02 INFO - "pgo_build": "True", 08:11:02 INFO - "basedir": "/builds/slave/test-pgo", 08:11:02 INFO - "project": "", 08:11:02 INFO - "platform": "ubuntu64_hw", 08:11:02 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:11:02 INFO - "slavebuilddir": "test", 08:11:02 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 08:11:02 INFO - "branch": "mozilla-beta", 08:11:02 INFO - "repo_path": "releases/mozilla-beta", 08:11:02 INFO - "stage_platform": "linux64-pgo", 08:11:02 INFO - "builduid": "7c22a3860f734842b2c2a1daf91f3309", 08:11:02 INFO - "revision": "b02e8e8f06da" 08:11:02 INFO - }, 08:11:02 INFO - "sourcestamp": { 08:11:02 INFO - "repository": "", 08:11:02 INFO - "hasPatch": false, 08:11:02 INFO - "project": "", 08:11:02 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 08:11:02 INFO - "changes": [ 08:11:02 INFO - { 08:11:02 INFO - "category": null, 08:11:02 INFO - "files": [ 08:11:02 INFO - { 08:11:02 INFO - "url": null, 08:11:02 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454334446/firefox-45.0.en-US.linux-x86_64.tar.bz2" 08:11:02 INFO - } 08:11:02 INFO - ], 08:11:02 INFO - "repository": "", 08:11:02 INFO - "rev": "b02e8e8f06da", 08:11:02 INFO - "who": "sendchange", 08:11:02 INFO - "when": 1454342908, 08:11:02 INFO - "number": 7543473, 08:11:02 INFO - "comments": "Bug 1242176 - Don_t migrate privacy.clearOnShutdown.passwords if privacy.sanitize.sanitizeOnShutdown is false. r=dolske, a=sylvestre", 08:11:02 INFO - "project": "", 08:11:02 INFO - "at": "Mon 01 Feb 2016 08:08:28", 08:11:02 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 08:11:02 INFO - "revlink": "", 08:11:02 INFO - "properties": [ 08:11:02 INFO - [ 08:11:02 INFO - "buildid", 08:11:02 INFO - "20160201054726", 08:11:02 INFO - "Change" 08:11:02 INFO - ], 08:11:02 INFO - [ 08:11:02 INFO - "builduid", 08:11:02 INFO - "7c22a3860f734842b2c2a1daf91f3309", 08:11:02 INFO - "Change" 08:11:02 INFO - ], 08:11:02 INFO - [ 08:11:02 INFO - "pgo_build", 08:11:02 INFO - "True", 08:11:02 INFO - "Change" 08:11:02 INFO - ] 08:11:02 INFO - ], 08:11:02 INFO - "revision": "b02e8e8f06da" 08:11:02 INFO - } 08:11:02 INFO - ], 08:11:02 INFO - "revision": "b02e8e8f06da" 08:11:02 INFO - } 08:11:02 INFO - } 08:11:02 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454334446/firefox-45.0.en-US.linux-x86_64.tar.bz2. 08:11:02 INFO - Running post-action listener: _resource_record_post_action 08:11:02 INFO - ##### 08:11:02 INFO - ##### Running download-and-extract step. 08:11:02 INFO - ##### 08:11:02 INFO - Running pre-action listener: _resource_record_pre_action 08:11:02 INFO - Running main action method: download_and_extract 08:11:02 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:11: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')]} 08:11:02 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454334446/test_packages.json 08:11:02 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454334446/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:11:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454334446/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:11:02 INFO - Downloaded 1270 bytes. 08:11:02 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:11:02 INFO - Using the following test package requirements: 08:11:02 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 08:11:02 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 08:11:02 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 08:11:02 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 08:11:02 INFO - u'jsshell-linux-x86_64.zip'], 08:11:02 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 08:11:02 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 08:11:02 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 08:11:02 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 08:11:02 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 08:11:02 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 08:11:02 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 08:11:02 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 08:11:02 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 08:11:02 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 08:11:02 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 08:11:02 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 08:11:02 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:11: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')]} 08:11:02 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454334446/firefox-45.0.en-US.linux-x86_64.common.tests.zip 08:11:02 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454334446/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 08:11:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454334446/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:11:02 INFO - Downloaded 21580352 bytes. 08:11:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 08:11:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 08:11:02 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 08:11:03 INFO - Return code: 0 08:11:03 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:11:03 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')]} 08:11:03 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454334446/firefox-45.0.en-US.linux-x86_64.common.tests.zip 08:11:03 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454334446/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 08:11:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454334446/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:11:04 INFO - Downloaded 21580352 bytes. 08:11:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 08:11:04 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 08:11:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 08:11:05 INFO - Return code: 0 08:11:05 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')]} 08:11:05 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454334446/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 08:11:05 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454334446/firefox-45.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 08:11:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454334446/firefox-45.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:11:05 INFO - Downloaded 11132038 bytes. 08:11:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 08:11:05 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 08:11:05 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 08:11:05 INFO - Return code: 0 08:11:05 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')]} 08:11:05 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454334446/firefox-45.0.en-US.linux-x86_64.tar.bz2 08:11:05 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454334446/firefox-45.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 08:11:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454334446/firefox-45.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:11:06 INFO - Downloaded 57948631 bytes. 08:11:06 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454334446/firefox-45.0.en-US.linux-x86_64.tar.bz2 08:11:06 INFO - mkdir: /builds/slave/test-pgo/properties 08:11:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:11:06 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:11:06 INFO - Contents: 08:11:06 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454334446/firefox-45.0.en-US.linux-x86_64.tar.bz2 08:11:06 INFO - Running post-action listener: _resource_record_post_action 08:11:06 INFO - Running post-action listener: set_extra_try_arguments 08:11:06 INFO - ##### 08:11:06 INFO - ##### Running populate-webroot step. 08:11:06 INFO - ##### 08:11:06 INFO - Running pre-action listener: _resource_record_pre_action 08:11:06 INFO - Running main action method: populate_webroot 08:11:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:11:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:11:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:11:06 INFO - '--tppagecycles', 08:11:06 INFO - '7'], 08:11:06 INFO - 'tests': ['tsvgm']}}, 08:11:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:11:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:11:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:11:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:11:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:11:06 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:11:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:11:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:06 INFO - 'talos_options': ['--e10s'], 08:11:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:11:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:06 INFO - 'tests': ['damp', 'tps']}, 08:11:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:06 INFO - 'talos_options': ['--e10s'], 08:11:06 INFO - 'tests': ['damp', 'tps']}, 08:11:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:11:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:11:06 INFO - 'other': {'tests': ['a11yr', 08:11:06 INFO - 'ts_paint', 08:11:06 INFO - 'tpaint', 08:11:06 INFO - 'sessionrestore', 08:11:06 INFO - 'sessionrestore_no_auto_restore']}, 08:11:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:11:06 INFO - 'tests': ['a11yr', 08:11:06 INFO - 'ts_paint', 08:11:06 INFO - 'tpaint', 08:11:06 INFO - 'sessionrestore', 08:11:06 INFO - 'sessionrestore_no_auto_restore']}, 08:11:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:11:06 INFO - 'tests': ['a11yr', 08:11:06 INFO - 'ts_paint', 08:11:06 INFO - 'tpaint', 08:11:06 INFO - 'sessionrestore', 08:11:06 INFO - 'sessionrestore_no_auto_restore']}, 08:11:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:11:06 INFO - 'tests': ['a11yr', 08:11:06 INFO - 'ts_paint', 08:11:06 INFO - 'tpaint', 08:11:06 INFO - 'sessionrestore', 08:11:06 INFO - 'sessionrestore_no_auto_restore']}, 08:11:06 INFO - 'other_l64': {'tests': ['a11yr', 08:11:06 INFO - 'ts_paint', 08:11:06 INFO - 'tpaint', 08:11:06 INFO - 'sessionrestore', 08:11:06 INFO - 'sessionrestore_no_auto_restore']}, 08:11:06 INFO - 'other_nol64': {'tests': ['a11yr', 08:11:06 INFO - 'ts_paint', 08:11:06 INFO - 'tpaint', 08:11:06 INFO - 'sessionrestore', 08:11:06 INFO - 'sessionrestore_no_auto_restore']}, 08:11:06 INFO - 'svgr': {'tests': ['tsvgx', 08:11:06 INFO - 'tsvgr_opacity', 08:11:06 INFO - 'tart', 08:11:06 INFO - 'tscrollx', 08:11:06 INFO - 'cart']}, 08:11:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:11:06 INFO - 'tests': ['tsvgx', 08:11:06 INFO - 'tsvgr_opacity', 08:11:06 INFO - 'tart', 08:11:06 INFO - 'tscrollx', 08:11:06 INFO - 'cart']}, 08:11:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:06 INFO - 'tests': ['tp5o']}, 08:11:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:06 INFO - 'talos_options': ['--e10s'], 08:11:06 INFO - 'tests': ['tp5o']}, 08:11:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:06 INFO - 'talos_options': ['--xperf_path', 08:11:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:11:06 INFO - 'tests': ['tp5n']}, 08:11:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:06 INFO - 'talos_options': ['--e10s', 08:11:06 INFO - '--xperf_path', 08:11:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:11:06 INFO - 'tests': ['tp5n']}}, 08:11:06 INFO - 'talos.zip': {'path': '', 08:11:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:11:06 INFO - Running post-action listener: _resource_record_post_action 08:11:06 INFO - ##### 08:11:06 INFO - ##### Running create-virtualenv step. 08:11:06 INFO - ##### 08:11:06 INFO - Running pre-action listener: _resource_record_pre_action 08:11:06 INFO - Running main action method: create_virtualenv 08:11:06 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:11:06 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 08:11:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:11:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:11:07 INFO - Using real prefix '/usr' 08:11:07 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:11:07 INFO - Installing distribute.............................................................................................................................................................................................done. 08:11:09 INFO - Installing pip.................done. 08:11:09 INFO - Return code: 0 08:11:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:11: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')]} 08:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11: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')]} 08:11:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb701caef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1830600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bf350>, '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 0x18c0250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c06e0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1454343051.506293-281325296', '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 08:11:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 08:11:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:11:09 INFO - Using env: {'DISPLAY': ':0', 08:11:09 INFO - 'HOME': '/home/cltbld', 08:11:09 INFO - 'LANG': 'en_US.UTF-8', 08:11:09 INFO - 'LANGUAGE': 'en_US:en', 08:11:09 INFO - 'LOGNAME': 'cltbld', 08:11:09 INFO - 'MAIL': '/var/mail/cltbld', 08:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:09 INFO - 'MOZ_NO_REMOTE': '1', 08:11:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:09 INFO - 'NO_EM_RESTART': '1', 08:11:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:11:09 INFO - 'PWD': '/builds/slave/test-pgo', 08:11:09 INFO - 'SHELL': '/bin/bash', 08:11:09 INFO - 'SHLVL': '1', 08:11:09 INFO - 'TERM': 'linux', 08:11:09 INFO - 'TMOUT': '86400', 08:11:09 INFO - 'USER': 'cltbld', 08:11:09 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1454343051.506293-281325296', 08:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:09 INFO - '_': '/tools/buildbot/bin/python'} 08:11:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:09 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 08:11:09 INFO - Cleaning up... 08:11:09 INFO - Return code: 0 08:11:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:11: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')]} 08:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11: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')]} 08:11:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb701caef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1830600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bf350>, '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 0x18c0250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c06e0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1454343051.506293-281325296', '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 08:11:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 08:11:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:11:09 INFO - Using env: {'DISPLAY': ':0', 08:11:09 INFO - 'HOME': '/home/cltbld', 08:11:09 INFO - 'LANG': 'en_US.UTF-8', 08:11:09 INFO - 'LANGUAGE': 'en_US:en', 08:11:09 INFO - 'LOGNAME': 'cltbld', 08:11:09 INFO - 'MAIL': '/var/mail/cltbld', 08:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:09 INFO - 'MOZ_NO_REMOTE': '1', 08:11:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:09 INFO - 'NO_EM_RESTART': '1', 08:11:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:11:09 INFO - 'PWD': '/builds/slave/test-pgo', 08:11:09 INFO - 'SHELL': '/bin/bash', 08:11:09 INFO - 'SHLVL': '1', 08:11:09 INFO - 'TERM': 'linux', 08:11:09 INFO - 'TMOUT': '86400', 08:11:09 INFO - 'USER': 'cltbld', 08:11:09 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1454343051.506293-281325296', 08:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:09 INFO - '_': '/tools/buildbot/bin/python'} 08:11:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:09 INFO - Downloading/unpacking psutil>=0.7.1 08:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:11:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:11:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:11:11 INFO - Installing collected packages: psutil 08:11:11 INFO - Running setup.py install for psutil 08:11:11 INFO - building 'psutil._psutil_linux' extension 08:11:11 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 08:11:12 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 08:11:12 INFO - building 'psutil._psutil_posix' extension 08:11:12 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 08:11:12 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 08:11:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:11:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:11:12 INFO - Successfully installed psutil 08:11:12 INFO - Cleaning up... 08:11:12 INFO - Return code: 0 08:11:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:11: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')]} 08:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11: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')]} 08:11:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb701caef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1830600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bf350>, '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 0x18c0250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c06e0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1454343051.506293-281325296', '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 08:11:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 08:11:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:11:12 INFO - Using env: {'DISPLAY': ':0', 08:11:12 INFO - 'HOME': '/home/cltbld', 08:11:12 INFO - 'LANG': 'en_US.UTF-8', 08:11:12 INFO - 'LANGUAGE': 'en_US:en', 08:11:12 INFO - 'LOGNAME': 'cltbld', 08:11:12 INFO - 'MAIL': '/var/mail/cltbld', 08:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:12 INFO - 'MOZ_NO_REMOTE': '1', 08:11:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:12 INFO - 'NO_EM_RESTART': '1', 08:11:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:11:12 INFO - 'PWD': '/builds/slave/test-pgo', 08:11:12 INFO - 'SHELL': '/bin/bash', 08:11:12 INFO - 'SHLVL': '1', 08:11:12 INFO - 'TERM': 'linux', 08:11:12 INFO - 'TMOUT': '86400', 08:11:12 INFO - 'USER': 'cltbld', 08:11:12 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1454343051.506293-281325296', 08:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:12 INFO - '_': '/tools/buildbot/bin/python'} 08:11:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:11:12 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 08:11:12 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 08:11:12 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 08:11:12 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 08:11:12 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 08:11:12 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 08:11:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:11:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:11:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:11:14 INFO - Installing collected packages: mozsystemmonitor 08:11:14 INFO - Running setup.py install for mozsystemmonitor 08:11:14 INFO - Successfully installed mozsystemmonitor 08:11:14 INFO - Cleaning up... 08:11:14 INFO - Return code: 0 08:11:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:11:14 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')]} 08:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:14 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')]} 08:11:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb701caef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1830600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bf350>, '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 0x18c0250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c06e0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1454343051.506293-281325296', '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 08:11:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 08:11:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:11:14 INFO - Using env: {'DISPLAY': ':0', 08:11:14 INFO - 'HOME': '/home/cltbld', 08:11:14 INFO - 'LANG': 'en_US.UTF-8', 08:11:14 INFO - 'LANGUAGE': 'en_US:en', 08:11:14 INFO - 'LOGNAME': 'cltbld', 08:11:14 INFO - 'MAIL': '/var/mail/cltbld', 08:11:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:14 INFO - 'MOZ_NO_REMOTE': '1', 08:11:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:14 INFO - 'NO_EM_RESTART': '1', 08:11:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:11:14 INFO - 'PWD': '/builds/slave/test-pgo', 08:11:14 INFO - 'SHELL': '/bin/bash', 08:11:14 INFO - 'SHLVL': '1', 08:11:14 INFO - 'TERM': 'linux', 08:11:14 INFO - 'TMOUT': '86400', 08:11:14 INFO - 'USER': 'cltbld', 08:11:14 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1454343051.506293-281325296', 08:11:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:14 INFO - '_': '/tools/buildbot/bin/python'} 08:11:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:14 INFO - Downloading/unpacking blobuploader==1.2.4 08:11:14 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 08:11:14 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 08:11:14 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 08:11:14 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 08:11:14 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 08:11:14 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 08:11:16 INFO - Downloading blobuploader-1.2.4.tar.gz 08:11:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:11:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:11:16 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 08:11:16 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 08:11:16 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 08:11:16 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 08:11:16 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 08:11:16 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 08:11:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:11:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:11:16 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 08:11:16 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 08:11:16 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 08:11:16 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 08:11:16 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 08:11:16 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 08:11:17 INFO - Downloading docopt-0.6.1.tar.gz 08:11:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:11:17 INFO - Installing collected packages: blobuploader, requests, docopt 08:11:17 INFO - Running setup.py install for blobuploader 08:11:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:11:17 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:11:17 INFO - Running setup.py install for requests 08:11:17 INFO - Running setup.py install for docopt 08:11:17 INFO - Successfully installed blobuploader requests docopt 08:11:17 INFO - Cleaning up... 08:11:17 INFO - Return code: 0 08:11:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:11:17 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')]} 08:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:17 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')]} 08:11:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:17 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb701caef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1830600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bf350>, '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 0x18c0250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c06e0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1454343051.506293-281325296', '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 08:11:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 08:11:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:11:17 INFO - Using env: {'DISPLAY': ':0', 08:11:17 INFO - 'HOME': '/home/cltbld', 08:11:17 INFO - 'LANG': 'en_US.UTF-8', 08:11:17 INFO - 'LANGUAGE': 'en_US:en', 08:11:17 INFO - 'LOGNAME': 'cltbld', 08:11:17 INFO - 'MAIL': '/var/mail/cltbld', 08:11:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:17 INFO - 'MOZ_NO_REMOTE': '1', 08:11:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:17 INFO - 'NO_EM_RESTART': '1', 08:11:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:11:17 INFO - 'PWD': '/builds/slave/test-pgo', 08:11:17 INFO - 'SHELL': '/bin/bash', 08:11:17 INFO - 'SHLVL': '1', 08:11:17 INFO - 'TERM': 'linux', 08:11:17 INFO - 'TMOUT': '86400', 08:11:17 INFO - 'USER': 'cltbld', 08:11:17 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1454343051.506293-281325296', 08:11:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:17 INFO - '_': '/tools/buildbot/bin/python'} 08:11:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:11:18 INFO - Running setup.py (path:/tmp/pip-_L_wcx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:11:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:11:18 INFO - Running setup.py (path:/tmp/pip-hosvLI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:11:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:11:18 INFO - Running setup.py (path:/tmp/pip-muSB0l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:11:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:11:18 INFO - Running setup.py (path:/tmp/pip-VTkw9n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:11:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:11:18 INFO - Running setup.py (path:/tmp/pip-edOzkt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:11:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:11:18 INFO - Running setup.py (path:/tmp/pip-Bi90Pr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:11:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:11:18 INFO - Running setup.py (path:/tmp/pip-9F1ya9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:11:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:11:18 INFO - Running setup.py (path:/tmp/pip-bLAtSm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:11:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:11:18 INFO - Running setup.py (path:/tmp/pip-3uLxYO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:11:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:11:18 INFO - Running setup.py (path:/tmp/pip-9S0TKT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:11:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:11:18 INFO - Running setup.py (path:/tmp/pip-hOqWgf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:11:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:11:18 INFO - Running setup.py (path:/tmp/pip-paswyn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:11:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:11:18 INFO - Running setup.py (path:/tmp/pip-s3cV30-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:11:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:11:19 INFO - Running setup.py (path:/tmp/pip-VLlxvi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:11:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:11:19 INFO - Running setup.py (path:/tmp/pip-jJvh5t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:11:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:11:19 INFO - Running setup.py (path:/tmp/pip-dsNKHS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:11:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:11:19 INFO - Running setup.py (path:/tmp/pip-BmdqSN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:11:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:11:19 INFO - Running setup.py install for manifestparser 08:11:19 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:11:19 INFO - Running setup.py install for mozcrash 08:11:19 INFO - Running setup.py install for mozdebug 08:11:19 INFO - Running setup.py install for mozdevice 08:11:19 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:11:19 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:11:19 INFO - Running setup.py install for mozfile 08:11:19 INFO - Running setup.py install for mozhttpd 08:11:19 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:11:19 INFO - Running setup.py install for mozinfo 08:11:19 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:11:19 INFO - Running setup.py install for mozInstall 08:11:20 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:11:20 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:11:20 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:11:20 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:11:20 INFO - Running setup.py install for mozleak 08:11:20 INFO - Running setup.py install for mozlog 08:11:20 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:11:20 INFO - Running setup.py install for moznetwork 08:11:20 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:11:20 INFO - Running setup.py install for mozprocess 08:11:20 INFO - Running setup.py install for mozprofile 08:11:20 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:11:20 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:11:20 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:11:20 INFO - Running setup.py install for mozrunner 08:11:20 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:11:20 INFO - Running setup.py install for mozscreenshot 08:11:20 INFO - Running setup.py install for moztest 08:11:20 INFO - Running setup.py install for mozversion 08:11:21 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:11:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:11:21 INFO - Cleaning up... 08:11:21 INFO - Return code: 0 08:11:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:11:21 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')]} 08:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:21 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')]} 08:11:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb701caef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1830600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bf350>, '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 0x18c0250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c06e0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1454343051.506293-281325296', '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 08:11:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 08:11:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:11:21 INFO - Using env: {'DISPLAY': ':0', 08:11:21 INFO - 'HOME': '/home/cltbld', 08:11:21 INFO - 'LANG': 'en_US.UTF-8', 08:11:21 INFO - 'LANGUAGE': 'en_US:en', 08:11:21 INFO - 'LOGNAME': 'cltbld', 08:11:21 INFO - 'MAIL': '/var/mail/cltbld', 08:11:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:21 INFO - 'MOZ_NO_REMOTE': '1', 08:11:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:21 INFO - 'NO_EM_RESTART': '1', 08:11:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:11:21 INFO - 'PWD': '/builds/slave/test-pgo', 08:11:21 INFO - 'SHELL': '/bin/bash', 08:11:21 INFO - 'SHLVL': '1', 08:11:21 INFO - 'TERM': 'linux', 08:11:21 INFO - 'TMOUT': '86400', 08:11:21 INFO - 'USER': 'cltbld', 08:11:21 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1454343051.506293-281325296', 08:11:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:21 INFO - '_': '/tools/buildbot/bin/python'} 08:11:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:11:21 INFO - Running setup.py (path:/tmp/pip-mDT6XV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:11:21 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)) 08:11:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:11:21 INFO - Running setup.py (path:/tmp/pip-jcpeHw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:11:21 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)) 08:11:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:11:21 INFO - Running setup.py (path:/tmp/pip-TMmoxu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:11:21 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)) 08:11:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:11:21 INFO - Running setup.py (path:/tmp/pip-e6zcUs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 08:11:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:11:21 INFO - Running setup.py (path:/tmp/pip-xvPnZ_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:11:21 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)) 08:11:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:11:21 INFO - Running setup.py (path:/tmp/pip-tMsduC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:11:21 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)) 08:11:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:11:21 INFO - Running setup.py (path:/tmp/pip-KXowjC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 08:11:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:11:21 INFO - Running setup.py (path:/tmp/pip-WPQmX6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:11:21 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)) 08:11:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:11:21 INFO - Running setup.py (path:/tmp/pip-AYsILi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:11:21 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)) 08:11:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:11:21 INFO - Running setup.py (path:/tmp/pip-HTHip0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:11:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:11:22 INFO - Running setup.py (path:/tmp/pip-jqmCON-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:11:22 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)) 08:11:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:11:22 INFO - Running setup.py (path:/tmp/pip-n5MaGs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:11:22 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)) 08:11:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:11:22 INFO - Running setup.py (path:/tmp/pip-tlNWK6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:11:22 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)) 08:11:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:11:22 INFO - Running setup.py (path:/tmp/pip-ERKHjb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:11:22 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)) 08:11:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:11:22 INFO - Running setup.py (path:/tmp/pip-pxo3bC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:11:22 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)) 08:11:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:11:22 INFO - Running setup.py (path:/tmp/pip-Wk_r9e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:11:22 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)) 08:11:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:11:22 INFO - Running setup.py (path:/tmp/pip-j4h3bk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:11:22 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)) 08:11:22 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)) 08:11:22 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)) 08:11:22 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)) 08:11:22 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:11:22 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:11:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:11:22 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 08:11:22 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 08:11:22 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 08:11:22 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 08:11:22 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 08:11:22 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 08:11:24 INFO - Downloading blessings-1.6.tar.gz 08:11:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:11:24 INFO - Installing collected packages: blessings 08:11:24 INFO - Running setup.py install for blessings 08:11:24 INFO - Successfully installed blessings 08:11:24 INFO - Cleaning up... 08:11:24 INFO - Return code: 0 08:11:24 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:11:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:11:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:11:24 INFO - Reading from file tmpfile_stdout 08:11:24 INFO - Current package versions: 08:11:24 INFO - argparse == 1.2.1 08:11:24 INFO - blessings == 1.6 08:11:24 INFO - blobuploader == 1.2.4 08:11:24 INFO - docopt == 0.6.1 08:11:24 INFO - manifestparser == 1.1 08:11:24 INFO - mozInstall == 1.12 08:11:24 INFO - mozcrash == 0.16 08:11:24 INFO - mozdebug == 0.1 08:11:24 INFO - mozdevice == 0.47 08:11:24 INFO - mozfile == 1.2 08:11:24 INFO - mozhttpd == 0.7 08:11:24 INFO - mozinfo == 0.9 08:11:24 INFO - mozleak == 0.1 08:11:24 INFO - mozlog == 3.1 08:11:24 INFO - moznetwork == 0.27 08:11:24 INFO - mozprocess == 0.22 08:11:24 INFO - mozprofile == 0.27 08:11:24 INFO - mozrunner == 6.11 08:11:24 INFO - mozscreenshot == 0.1 08:11:24 INFO - mozsystemmonitor == 0.0 08:11:24 INFO - moztest == 0.7 08:11:24 INFO - mozversion == 1.4 08:11:24 INFO - psutil == 3.1.1 08:11:24 INFO - requests == 1.2.3 08:11:24 INFO - wsgiref == 0.1.2 08:11:24 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:11:24 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')]} 08:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:24 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')]} 08:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:24 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb701caef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1830600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bf350>, '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 0x18c0250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c06e0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1454343051.506293-281325296', '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 08:11:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 08:11:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:11:24 INFO - Using env: {'DISPLAY': ':0', 08:11:24 INFO - 'HOME': '/home/cltbld', 08:11:24 INFO - 'LANG': 'en_US.UTF-8', 08:11:24 INFO - 'LANGUAGE': 'en_US:en', 08:11:24 INFO - 'LOGNAME': 'cltbld', 08:11:24 INFO - 'MAIL': '/var/mail/cltbld', 08:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:24 INFO - 'MOZ_NO_REMOTE': '1', 08:11:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:24 INFO - 'NO_EM_RESTART': '1', 08:11:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:11:24 INFO - 'PWD': '/builds/slave/test-pgo', 08:11:24 INFO - 'SHELL': '/bin/bash', 08:11:24 INFO - 'SHLVL': '1', 08:11:24 INFO - 'TERM': 'linux', 08:11:24 INFO - 'TMOUT': '86400', 08:11:24 INFO - 'USER': 'cltbld', 08:11:24 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1454343051.506293-281325296', 08:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:24 INFO - '_': '/tools/buildbot/bin/python'} 08:11:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:24 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)) 08:11:24 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)) 08:11:24 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)) 08:11:24 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)) 08:11:24 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)) 08:11:24 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)) 08:11:24 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)) 08:11:24 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)) 08:11:24 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)) 08:11:24 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)) 08:11:24 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)) 08:11:24 INFO - Cleaning up... 08:11:24 INFO - Return code: 0 08:11:24 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:11:24 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')]} 08:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:24 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')]} 08:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:24 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb701caef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1830600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bf350>, '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 0x18c0250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c06e0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1454343051.506293-281325296', '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 08:11:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 08:11:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:11:24 INFO - Using env: {'DISPLAY': ':0', 08:11:24 INFO - 'HOME': '/home/cltbld', 08:11:24 INFO - 'LANG': 'en_US.UTF-8', 08:11:24 INFO - 'LANGUAGE': 'en_US:en', 08:11:24 INFO - 'LOGNAME': 'cltbld', 08:11:24 INFO - 'MAIL': '/var/mail/cltbld', 08:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:24 INFO - 'MOZ_NO_REMOTE': '1', 08:11:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:24 INFO - 'NO_EM_RESTART': '1', 08:11:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:11:24 INFO - 'PWD': '/builds/slave/test-pgo', 08:11:24 INFO - 'SHELL': '/bin/bash', 08:11:24 INFO - 'SHLVL': '1', 08:11:24 INFO - 'TERM': 'linux', 08:11:24 INFO - 'TMOUT': '86400', 08:11:24 INFO - 'USER': 'cltbld', 08:11:24 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1454343051.506293-281325296', 08:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:24 INFO - '_': '/tools/buildbot/bin/python'} 08:11:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:25 INFO - Downloading/unpacking jsonschema 08:11:25 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 08:11:25 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 08:11:25 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 08:11:25 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 08:11:25 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 08:11:25 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 08:11:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:11:26 INFO - Downloading/unpacking functools32 (from jsonschema) 08:11:26 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 08:11:26 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 08:11:26 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 08:11:26 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 08:11:26 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 08:11:26 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 08:11:27 INFO - Downloading functools32-3.2.3-2.tar.gz 08:11:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:11:27 INFO - warning: no files found matching '*.txt' 08:11:27 INFO - no previously-included directories found matching 'build' 08:11:27 INFO - no previously-included directories found matching 'dist' 08:11:27 INFO - no previously-included directories found matching '.git*' 08:11:27 INFO - Installing collected packages: jsonschema, functools32 08:11:27 INFO - Running setup.py install for functools32 08:11:27 INFO - warning: no files found matching '*.txt' 08:11:27 INFO - no previously-included directories found matching 'build' 08:11:27 INFO - no previously-included directories found matching 'dist' 08:11:27 INFO - no previously-included directories found matching '.git*' 08:11:27 INFO - Successfully installed jsonschema functools32 08:11:27 INFO - Cleaning up... 08:11:27 INFO - Return code: 0 08:11:27 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:27 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb701caef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1830600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bf350>, '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 0x18c0250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c06e0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1454343051.506293-281325296', '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 08:11:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 08:11:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:11:27 INFO - Using env: {'DISPLAY': ':0', 08:11:27 INFO - 'HOME': '/home/cltbld', 08:11:27 INFO - 'LANG': 'en_US.UTF-8', 08:11:27 INFO - 'LANGUAGE': 'en_US:en', 08:11:27 INFO - 'LOGNAME': 'cltbld', 08:11:27 INFO - 'MAIL': '/var/mail/cltbld', 08:11:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:27 INFO - 'MOZ_NO_REMOTE': '1', 08:11:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:27 INFO - 'NO_EM_RESTART': '1', 08:11:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:11:27 INFO - 'PWD': '/builds/slave/test-pgo', 08:11:27 INFO - 'SHELL': '/bin/bash', 08:11:27 INFO - 'SHLVL': '1', 08:11:27 INFO - 'TERM': 'linux', 08:11:27 INFO - 'TMOUT': '86400', 08:11:27 INFO - 'USER': 'cltbld', 08:11:27 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1454343051.506293-281325296', 08:11:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:27 INFO - '_': '/tools/buildbot/bin/python'} 08:11:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:27 INFO - Downloading/unpacking flake8 08:11:27 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 08:11:27 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 08:11:27 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 08:11:27 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 08:11:27 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 08:11:27 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 08:11:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:11:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:11:29 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 08:11:29 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 08:11:29 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 08:11:29 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 08:11:29 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 08:11:29 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 08:11:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:11:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:11:29 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 08:11:29 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 08:11:29 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 08:11:29 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 08:11:29 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 08:11:29 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 08:11:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:11:29 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 08:11:29 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 08:11:29 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 08:11:29 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 08:11:29 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 08:11:29 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 08:11:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:11:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:11:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:11:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:11:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:11:30 INFO - no previously-included directories found matching 'docs/_build' 08:11:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:11:30 INFO - Running setup.py install for pep8 08:11:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:11:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:11:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:11:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:11:30 INFO - no previously-included directories found matching 'docs/_build' 08:11:30 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:11:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:11:30 INFO - Cleaning up... 08:11:30 INFO - Return code: 0 08:11:30 INFO - Running post-action listener: _resource_record_post_action 08:11:30 INFO - Running post-action listener: _start_resource_monitoring 08:11:30 INFO - Starting resource monitoring. 08:11:30 INFO - ##### 08:11:30 INFO - ##### Running install step. 08:11:30 INFO - ##### 08:11:30 INFO - Running pre-action listener: _resource_record_pre_action 08:11:30 INFO - Running main action method: install 08:11:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:11:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:11:30 INFO - Reading from file tmpfile_stdout 08:11:30 INFO - Detecting whether we're running mozinstall >=1.0... 08:11:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:11:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:11:30 INFO - Reading from file tmpfile_stdout 08:11:30 INFO - Output received: 08:11:30 INFO - Usage: mozinstall [options] installer 08:11:30 INFO - Options: 08:11:30 INFO - -h, --help show this help message and exit 08:11:30 INFO - -d DEST, --destination=DEST 08:11:30 INFO - Directory to install application into. [default: 08:11:30 INFO - "/builds/slave/test-pgo"] 08:11:30 INFO - --app=APP Application being installed. [default: firefox] 08:11:30 INFO - mkdir: /builds/slave/test-pgo/build/application 08:11:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 08:11:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 08:11:45 INFO - Reading from file tmpfile_stdout 08:11:45 INFO - Output received: 08:11:45 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:11:45 INFO - Running post-action listener: _resource_record_post_action 08:11:45 INFO - ##### 08:11:45 INFO - ##### Running run-tests step. 08:11:45 INFO - ##### 08:11:45 INFO - Running pre-action listener: _resource_record_pre_action 08:11:45 INFO - Running main action method: run_tests 08:11:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:11:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:11:45 INFO - Python 2.7.3 08:11:45 INFO - Return code: 0 08:11:45 INFO - grabbing minidump binary from tooltool 08:11:45 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')]} 08:11:45 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 0x18bf350>, '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 0x18c0250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c06e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:11:45 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 08:11:45 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 08:11:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:11:45 INFO - Return code: 0 08:11:45 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:11:45 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:11:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:11:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:11:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:11:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:11:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:11:46 INFO - Return code: 0 08:11:46 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/1454334446/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 08:11:46 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/1454334446/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost 08:11:46 INFO - Using env: {'DISPLAY': ':0', 08:11:46 INFO - 'HOME': '/home/cltbld', 08:11:46 INFO - 'LANG': 'en_US.UTF-8', 08:11:46 INFO - 'LANGUAGE': 'en_US:en', 08:11:46 INFO - 'LOGNAME': 'cltbld', 08:11:46 INFO - 'MAIL': '/var/mail/cltbld', 08:11:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:11:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:11:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:46 INFO - 'MOZ_NO_REMOTE': '1', 08:11:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:11:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:46 INFO - 'NO_EM_RESTART': '1', 08:11:46 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:11:46 INFO - 'PWD': '/builds/slave/test-pgo', 08:11:46 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:11:46 INFO - 'SHELL': '/bin/bash', 08:11:46 INFO - 'SHLVL': '1', 08:11:46 INFO - 'TERM': 'linux', 08:11:46 INFO - 'TMOUT': '86400', 08:11:46 INFO - 'USER': 'cltbld', 08:11:46 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1454343051.506293-281325296', 08:11:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:46 INFO - '_': '/tools/buildbot/bin/python'} 08:11:46 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/1454334446/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost'] with output_timeout 3600 08:11:46 INFO - mozversion INFO | application_buildid: 20160201054726 08:11:46 INFO - mozversion INFO | application_changeset: b02e8e8f06da85d2ec8e6e583fc536440eb101d2 08:11:46 INFO - mozversion INFO | application_display_name: Nightly 08:11:46 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:11:46 INFO - mozversion INFO | application_name: Firefox 08:11:46 INFO - mozversion INFO | application_remotingname: firefox 08:11:46 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:11:46 INFO - mozversion INFO | application_vendor: Mozilla 08:11:46 INFO - mozversion INFO | application_version: 45.0 08:11:46 INFO - mozversion INFO | platform_buildid: 20160201054726 08:11:46 INFO - mozversion INFO | platform_changeset: b02e8e8f06da85d2ec8e6e583fc536440eb101d2 08:11:46 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:11:46 INFO - mozversion INFO | platform_version: 45.0 08:11:46 INFO - 2016-02-01 08:11:46,518 DEBUG : using testdate: 1454343106 08:11:46 INFO - 2016-02-01 08:11:46,518 DEBUG : actual date: 1454343106 08:11:46 INFO - 2016-02-01 08:11:46,527 INFO : starting webserver on 'localhost:45832' 08:11:46 INFO - 2016-02-01 08:11:46,528 INFO : Starting test suite talos-linux64-ix-049 08:11:46 INFO - 2016-02-01 08:11:46,529 INFO : Starting test dromaeo_css 08:11:46 INFO - 2016-02-01 08:11:46,529 DEBUG : operating with platform_type : linux_ 08:11:46 INFO - 2016-02-01 08:11:46,529 INFO : Initialising browser for dromaeo_css test... 08:11:46 INFO - 2016-02-01 08:11:46,546 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcwV0e3/profile http://localhost:45832/getInfo.html 08:11:50 INFO - 2016-02-01 08:11:50,488 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:11:50 INFO - 2016-02-01 08:11:50,488 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:11:50 INFO - 2016-02-01 08:11:50,488 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:11:50 INFO - 2016-02-01 08:11:50,488 DEBUG : BROWSER_OUTPUT: __metrics 08:11:50 INFO - 2016-02-01 08:11:50,625 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] 08:11:51 INFO - 2016-02-01 08:11:51,266 INFO : Browser initialized. 08:11:51 INFO - 2016-02-01 08:11:51,267 INFO : Running cycle 1/1 for dromaeo_css test... 08:11:51 INFO - 2016-02-01 08:11:51,267 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcwV0e3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:12:03 INFO - 2016-02-01 08:12:03,040 DEBUG : BROWSER_OUTPUT: RSS: Main: 134336512 08:12:03 INFO - 2016-02-01 08:12:03,040 DEBUG : BROWSER_OUTPUT: 08:12:53 INFO - 2016-02-01 08:12:53,872 DEBUG : BROWSER_OUTPUT: 1454343173869 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] 08:15:02 INFO - 2016-02-01 08:15:02,237 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45832/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45832/tests/dromaeo/cssquery-ext.html) 08:15:03 INFO - 2016-02-01 08:15:03,334 DEBUG : BROWSER_OUTPUT: RSS: Main: 248279040 08:15:03 INFO - 2016-02-01 08:15:03,334 DEBUG : BROWSER_OUTPUT: 08:18:05 INFO - 2016-02-01 08:18:05,435 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45832/tests/dromaeo/cssquery-ext.html (next: http://localhost:45832/tests/dromaeo/cssquery-jquery.html) 08:18:05 INFO - 2016-02-01 08:18:05,996 DEBUG : BROWSER_OUTPUT: RSS: Main: 219914240 08:18:05 INFO - 2016-02-01 08:18:05,996 DEBUG : BROWSER_OUTPUT: 08:21:07 INFO - 2016-02-01 08:21:07,672 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45832/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45832/tests/dromaeo/cssquery-mootools.html) 08:21:08 INFO - 2016-02-01 08:21:08,239 DEBUG : BROWSER_OUTPUT: RSS: Main: 215220224 08:21:08 INFO - 2016-02-01 08:21:08,239 DEBUG : BROWSER_OUTPUT: 08:24:09 INFO - 2016-02-01 08:24:09,998 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45832/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45832/tests/dromaeo/cssquery-prototype.html) 08:24:10 INFO - 2016-02-01 08:24:10,565 DEBUG : BROWSER_OUTPUT: RSS: Main: 206499840 08:24:10 INFO - 2016-02-01 08:24:10,565 DEBUG : BROWSER_OUTPUT: 08:27:12 INFO - 2016-02-01 08:27:12,970 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45832/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45832/tests/dromaeo/cssquery-yui.html) 08:27:13 INFO - 2016-02-01 08:27:13,536 DEBUG : BROWSER_OUTPUT: RSS: Main: 201768960 08:27:13 INFO - 2016-02-01 08:27:13,536 DEBUG : BROWSER_OUTPUT: 08:30:15 INFO - 2016-02-01 08:30:15,604 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45832/tests/dromaeo/cssquery-yui.html (next: http://localhost:45832/tests/dromaeo/cssquery-dojo.html) 08:30:15 INFO - 2016-02-01 08:30:15,863 DEBUG : BROWSER_OUTPUT: RSS: Main: 243294208 08:30:15 INFO - 2016-02-01 08:30:15,863 DEBUG : BROWSER_OUTPUT: 08:30:15 INFO - 2016-02-01 08:30:15,863 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:30:15 INFO - 2016-02-01 08:30:15,863 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:30:15 INFO - 2016-02-01 08:30:15,863 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:30:15 INFO - 2016-02-01 08:30:15,863 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:30:15 INFO - 2016-02-01 08:30:15,864 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3283.326917981814;3352.3127758809446;3379.9324013519745;3385.983070084649;3406.4890266460034;5599.076152434854;5627.859303517414;5630.071038278684;5633.295838020247;5635.126555383917;5626.746796394162;5678.687672178028;5689.4879460848515;5700.857478563028;5709.571782116337;4926;4942.678725882824;5133.768980395891;5155.278261043457;5215.400228973679;5149.17613181891;5169.431362550116;5173.042987047408;5175.146100893348;5188.4811518848;4954.950450495485;5120.871978200556;5129.820456284031;5188.558972487324;5199.09015922214;5102.897942041157;5206.193040078775;5235.65968212065;5236.371635403738;5241.711705856176;5121.769520371592;5146.433892271847;5160.200168973777;5209.895802083975;5250.684958902478;5327.067763141474;5339.652922560022;5427.83716488506;5434.456554344573;5525.281713377275;6041.305249896231;6050;6051.273847138372;6054.69726513677;6061.605995610271;6009.188759517497;6092.695365231765;6093.969530152365;6100.84084024034;6106.3893610639025;5507.531859791922;5559.416261292587;5564.582656300753;5623.550115990711;5658.179563963285;6204.689765511796;6223.626582405071;6230.196411614791;6258.593191442542;6264.467520260829;5694.9430505695245;6058.1215723719815;6059.787907423219;6070.332263451017;6108.755649774048;5895;5949;6013.879722405527;6015.30823955242;6060.515158787286;6006.609570377911;6015;6018.789342372996;6027.969860150672;6028.668423236764;5782.190493330937;5833.970830145907;5999.5500337473995;6009;6012.068129439944;4495.977520112378;4515;4517.661175411791;4518.864434066983;4524.16302983949;4047;4105.4662893823615;4151.398047283187;4162.042730172077;4169.541350451448;5697.974364614409;5706.885862282814;5708.315002199763;5715.828525144252;5755.453231942959;5736.340320863154;6128.448439640454;6141.631502109888;6146.354632763585;6149.200603921461;5552.750126244328;5657.4908258256955;5711.914321285184;5730.025895597675;5745.913811292834;5255.710935898563;5261.868453288622;5276.314079169761;5310.495502927293;5313.495217954288;6062;6138.785142519991;6241.812745617639;6264;6265.561410701298;6016.789412370721;6123.4488895999575;6124.050772130327;6126.51767379719;6132.63204207749;6210.5652604317265;6212.409821066992;6223.284322302993;6223.751049957951;6226.5641405101205;5751.511121554548;5858.004139296415;5908.113782932594;6003.3996600339615;6018.909716354171;6107.553844087133;6109.144719739329;6137.570370074231;6137.9413674273155;6142.078688196806;5938.376470470538;5979.372165922689;5992.580519363777;5993.220881285405;6018.398160183947;5616.438356164351;5791.044477661138;5843.1235314703135;5959.553033522589;5966;5806.245188125686;5809.82570522885;5814.592978491465;5815.447532484407;5821.039528477754;5908.231929849092;5922.082077278029;5925.881482370242;5930.733117009659;5932.673702946379;5680.204771331934;5737;5752.1659359391815;5806.883862322646;5908.261467316585 08:30:15 INFO - 2016-02-01 08:30:15,864 DEBUG : BROWSER_OUTPUT: |1;ext.html;588.9469947704706;644.5874640230251;648.8053583924823;651.7262749645149;659.7262136213475;33082.50376244358;42523.36214956774;42855.78572107143;42918.35622465666;42962;47374.526254737444;47511.52488475123;47771.28343074857;47970.76014619931;47992.28011579829;8028;8141.877871831927;8929.866052009209;9103.362764606447;9107.772305692377;10494.632687855927;10598.841017384746;10603.257771955967;10633.627823026158;10650.573977040947;10579.20655950803;10665.626703065394;10671.83992240117;10675.092617127553;10680;10672.146228301755;10749.83875241872;10753.62362317323;10759.139268858473;10770.892291077067;10601.734956626146;10781.353118812818;10781.4609269537;10788.676339709822;10793;43570.346444803356;43976.56023439757;44084.559154408365;44114;44118;3482.4776283557417;3572.499850020999;3591.4612808078737;3711.2763011212824;3819.6371344722206;32880.83559582211;33017.50473742896;33103.172420689436;33218;33267.168320792174;4097.528784189826;4130.6282434580735;4193.22425351311;4231.957680423187;4241.512226094008;294744;295253;295491;295985.5200724004;296481;56484.152737708966;57460.425395746344;70464.64767676129;71391.28608713951;71523;63960.68019659872;64748.35251647423;64820.67589662022;64970.35029649643;65124.34875651277;17048.82951170497;17246;17312.22095005728;17313.65372692539;17380.739288910678;12745.299008554619;12937.353132343345;12967.22196668203;13064;13113.213207207407;21390.572188556453;21514.677279840816;21592;21660.45848853791;21697.45756356072;7840;7944.920550794418;8046.678132874737;8052.838943221102;8115.918840811634;1056.7252514346326;1083.1443159903588;1123.1464087293552;1154.6362895687832;1178.2753606531921;26880.05919792837;27205.863970680417;28740.99406520762;28747.425051498853;29267.560986585217;1133.484264659578;1152.3143729480946;1189.8215267709913;1191.5055252070467;1240.1752834365227;14334;14903.925480372529;15112.09327440357;16204.513864583845;16611.916940415464;265630;267776;268872;269604;269826;58094.7095264521;59232.70383648054;59329;59352.70323648354;59354.406455934884;1333.4599487207697;1352.6618345413647;1458.0741229319458;1461.4227380184768;1477.7340078785921;27941.44117117687;28484.715152848206;28785.28036799013;28788.424231514833;28812;42556.78721606372;42852.35721464243;42912.78543607262;42940.570594294906;42957.785211073744;201033;201308;201707;201870;202431;33128.83435582807;34056;34194.316113678084;34363;34390;45353;46355.53644463647;46614.53385466102;47159.764201178776;47171.29243061425;38830.805845970586;39007;39772.40341394823;40079.99800005023;40401.79799100986;38686;39308.6069139305;39470.21059578735;39828.800855995534;39956;38938;39507.802460987514;39592.60407396004;39690.2061958765;39767.602323977546;34084.97745067652;35946.8202658985;37411;38651.22697546089;38800.80599596984;26668.733312666624;26894.59658105169;27325.590116148673;27455.313617159733;27586.172414827586 08:30:15 INFO - 2016-02-01 08:30:15,864 DEBUG : BROWSER_OUTPUT: |2;jquery.html;380.5243445692882;382.68810919100946;385.42956424491734;396.49050969504185;398.8364770444118;14671.193084380355;16620.75068873965;17244.65510689787;18793.906030469847;18813.059347032646;11903.702407439796;12039.879601203986;12142.939285303582;18658.626827463442;19063.61872762544;5077.086124497599;5156.793728250866;5161.561267292266;5170.53465188133;5171.4311425743135;4059.3910913363084;4157.50109986802;5125.282460455539;5642.463965923231;5761.539076873861;5652;5671.574631902603;5703.8574035649235;5742.626729262605;5747.252857128588;5569.582281328896;5668.858278543028;5670.8015219467325;5673.602847800656;5674.914876276859;5434.049041417776;5469.589780766419;5487.286652735159;5490.258815059956;5490.423505531941;19994.500137496678;20345.18619255228;20573.07421166051;20667.483312917146;21251.5749685007;2271;2365.66880636711;2399.1722855614785;2402.5915594349003;2452.460458699083;13823.723525529535;13934.790978135336;14029.64925876851;14054.227017514135;14361.497347592784;1874.55010797409;1907.2085084689836;1929.6333696597742;1950.0444782056832;1991.661417559004;66436.3356366435;69060.65469672669;69408.65295673591;69792.651036745;71155;10495.265331426726;10555.05004549579;10629.255952083435;10643.680689579325;10675.412852293199;13403;13441.731165376637;13505.86494135046;13522.661933451742;13536.526221582395;7927.643256053491;7971.1630278819885;8247.051589067214;8290.875636865452;8294.37792165578;7621.580813055224;7626.542407455459;7627.389808815282;7672.462927595015;7809.336206422404;4340.392345071693;4387.868363949086;4398.010447649317;4517.5256598057385;4524.660650451229;1706.1980868991554;1751.0806826415978;1777.6178121703895;1790.8746387752992;1800.7208882623215;934.2899396458605;1016.913667020589;1038.7662775875367;1057.9206559508068;1061.1987949098382;15221.771673424908;17492.12539373026;17692.823071769373;17868.821311786716;18144.818551814576;1002.5889385352117;1007.778288776468;1072.512007036812;1072.5280876414354;1093.1746531368924;6457.644829534327;9707;9946.126398064896;10401.063904248655;10419.218558608134;640020;643997;647938;651793;656014;90587.54706226426;94949;94999.52500237593;95235;95504.52247738717;517.8938317644873;532.7283085626281;532.890757394741;533.1309964757498;533.650458949381;10605.628802991858;11166.888331116585;11252.493637786156;11311.038561722346;11354.26197297173;36392.45411318779;36608.633913660524;36965;37294.62705372911;37330.44004339883;45854.54145458636;46487.53512464967;47757.5224247767;47945;50220;10341.689749307532;10505.264631475724;10648.520816563117;10659.626913058006;10706.625268115578;12447.377631118588;12476.563320283747;12493.875061249271;12624.431900564314;17930.193141308413;15199.316030778862;15395.615109621902;15482.690346193238;15515.534533963999;15792.684146317239;15030.248487575796;15042.699146017238;15108.39566417331;15516.612084697972;15742.370305187664;15751.921240393725;15830.445934392701;16015.11916844538;16225.18874056269;16239.837601624306;10294.073533382032;10586.306191009402;10679.466026698788;10685.946570267099;10712.464376781285;11179;13032;16282.43011494592;16338.10140442287;16595.336186552402 08:30:15 INFO - 2016-02-01 08:30:15,864 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1436.712657468506;1439.3307112192836;1625.2929975460668;1802.774653168354;1844.1424737497066;7636.618169091544;8164.101948785629;8177.795555111125;8198.631061602227;8209.261166495015;6895.724171033153;7133.85732285354;7746.883796743039;7921.683132674701;8007.91992080079;2274.533720587284;2276.943076423094;2310.1106074161485;2310.7689231076924;2314.085936055257;2026.9189232430758;2334.3580515358244;2361.645753137026;2411.385096800322;2412.2883749293915;2049.75402951646;2289.942751431211;2333.976660233393;2334.684817549626;2335.1943579465055;2287.1880482428664;2338.567365037465;2340.637201233803;2345.9296221113395;2348.1194552042984;2357.7760112789256;2359.2332491940188;2391.198948352304;2392;2409.638554216864;7927.722529711433;7945.841083178304;7965.721199758039;7997.040355157418;8018.118007019223;4619.976900115512;4727.621790256771;4729.314249433847;4737.526247375269;4739.64452666048;3055.8624861881267;3097.90706278812;3115.018769087753;3118.844057797101;3185.5221716742444;1094.2231015978664;1095.27164435651;1106.1703722208345;1127.301073334538;1132.1839650232505;10793.946030269877;10983;10988.175886808522;11010.944945275303;11027.944860275727;4345.8261669533495;4387.012922092504;4399.054203346232;4455.1980643484485;4457.7548234846745;9532.237421006303;9535.284853636005;9541.761455963517;9550.188234000188;9571.952140239255;4795.95204047962;4800.255960326155;4821.108095002436;4830.792301924519;4835.395575553056;4339.63113135387;4381.890452738643;4394.670399720034;4395.7142785718825;4396.978015109968;3706.5922748498183;3731.3470142724914;3764.2095160016156;3767.246550689873;3775.433684947225;1135.625243669587;1186.3119390753343;1187.2994932989577;1207.8369420128347;1267.0750352242915;1188.5958774016876;1206.3063738350484;1213.0477575103678;1437.7699568069058;1455.0105927969082;7433.4053275737815;7447.627618619155;7757.495762775401;7767.456278060482;7792.181820908836;626.9090981807612;630.196499463188;636.2714691678095;658.233158370493;792.7265093542718;5981.790637327673;6106.786262480792;6113.38866113394;6120.1737765401995;6120.693965301717;9102.726918192464;9299.67451139207;9350.438973661601;9369.718908432758;9528.428294302365;9341.34610577253;9360.4383736976;9360.62557497706;9373.156415922464;9386.577604007836;7150.570965742072;7331.230220826843;7459.888101678371;7533.698652053857;7616.428767842434;7699.769006929801;7738.458307918391;7764.61176941162;7766.5728384939375;7793.727219547289;8477;8541.658333666584;8716.300321437258;8735.213830755009;8745.081766414434;8668.91331086681;8715.34634902372;8754.781130471789;8757.117219797774;8875.289976801969;7282.52663576887;7348.52234604749;7363;7367.26327367259;7381.335679788845;7848.215178482106;7865.685372585262;7925.801854953442;7934.722284720238;7940.841183176189;6614.206295244601;7357.2642735726;7371.741989030358;7391.2239214881665;7435.8141046474275;6613.636250006296;7302.707891684486;7379.778606641809;7435.665395057344;7488.925110748823;7440.888386674313;7496.812579685551;7497.137829149718;7517.097948246245;7532;6890.173179218526;6927.099477067949;6954.269801670752;6959.8608027838145;6972.860542789217;6547.247066587403;6636.2700102987665;6705.631190284581;6733.461323094239;6769.323067693192 08:30:15 INFO - 2016-02-01 08:30:15,864 DEBUG : BROWSER_OUTPUT: |4;prototype.html;366.0957435135216;373.56106574774634;375.24201113750206;375.5643453593831;381.481185587601;6029.155918171454;6076.058210977306;6102.694865256731;6110.511159107272;6112.358202388747;5752.568557358204;5879.911801322984;5899.823005309837;5907;5977.850553736159;4513.571210734975;4575.588197062264;4681.321208424776;4693.507181745918;4694.319323698061;4670.322803193535;4683.157031734287;4691.483936766953;4697.271922851964;4700.271457924027;4467.642588592921;4583.839565615204;4666.580007799297;4678.111158879819;4678.555537223959;4561.521040290771;4652.930206046912;4661.813527458898;4667.509911459282;4688.671792974493;4169.708120431571;4170.249355116078;4173.770442625654;4173.791310434496;4176.248275310443;5707.172459993278;5722.885542289173;5726.5705072119345;5727.627704199213;5731.140328950649;5344.412114667383;5419.945800541984;5435.42927992559;5474;5493.697846618435;6315.494760419201;6342.23893132827;6347.587406818542;6358.0462930560325;6368.29948705642;4566.54334566544;4572.3827283317;4575.062112267011;4575.336576196466;4577.33628623851;6426;6550.803475895731;6563.901541476882;6569.211694596631;6574.145361103026;4744.383230180124;4765.213739732905;4776.713397196179;4778.713277203379;4791.880202994953;4830.565249127525;4831.758412079382;4837.516248375135;4839.903201935942;4842.22524396102;5469.945300547023;5474.042042642602;5476.822483166138;5481.232627432163;5482.972585137049;6346.873062538723;6383.616982981036;6427.58220715652;6438.742450302029;6441.291457939623;1685.9831401686072;1710.187660861106;1711.0931206460596;1711.4437807712543;1712.8523888994403;1185.9563584046157;1187.75057237981;1192.6422073377953;1194.9163558550993;1212.6483319837325;6176.104464852661;6178.876422471525;6185.690715464209;6188.504919606421;6191.535634827406;6595.307492713292;6626.635535045619;6628.966855165693;6630.86738265232;6644.235912869985;5780;5983.6708981005595;6166.568340216142;6183.876322473526;6188.195534580475;3502.2820321833965;3544.4151714966742;3547.8580856765957;3550.55618047744;3597.6582224688614;6828.590284582841;6829.795106146824;6834.282400347991;6836.111305530349;6836.760713375008;6814.863702725917;6822.556533825285;6824.078749368871;6828.863422731518;6833.965830170917;6563.3764792344655;6776.42400395962;6803.965980170166;6823;6825.317468253135;6619.768308109193;6671.266160722414;6671.933280667131;6673.299303573055;6678.165229346332;6455.870882582228;6575.506836987341;6584;6589.27517973013;6590.47276217911;6791.388775010273;6800.557963732342;6803.625800581016;6809.829754256183;6813.2846051163915;4575.039241759135;4614.353990441274;4617.284320930261;4619.491855895916;4620.861374158781;6671.299513551007;6672.6997285121315;6674.064521288772;6674.532782705358;6680.298568650222;6366.490680745436;6481.643509607017;6486.383793539606;6490.578112422678;6493.610383377012;6441.967790161019;6454.096426500388;6462.063000864754;6471.967640161769;6473.643949582818;6162.445379915829;6324.3991820776955;6343.460805831556;6378.330275321025;6387.680615969276;6503.837404064936;6530.314316996837;6535.836604084936;6538.738450461929;6544.6727663617585;6156.353582873734;6218.751249949952;6262.436380725757;6354.3963323484195;6365.713542890674 08:30:15 INFO - 2016-02-01 08:30:15,864 DEBUG : BROWSER_OUTPUT: |5;yui.html;911.5806728904704;916.2898753466063;918.7289749523885;929.3819609959378;945.8297506448845;15241.466548670798;15657.373705051785;15746.842531574666;15750.291236894338;15760.684786304268;14689;14788.926055369735;14799.260036998161;14836.703265934675;14855.92572037141;775.4378075894988;779.2091027606983;907.6687009241629;927.9164875161234;928.3919033033374;918.6830543462495;929.832630126577;933.4539294512718;939.5771902643803;940.261894412886;947.9526023698822;957.6121670723368;959.0265880131672;959.4291396619001;959.6017652674132;806.4999700185894;812.743985644523;966.5843687214496;971.3006635222699;972.7033254857266;713.710947066439;714.5534041224234;714.7391202211207;714.9106361704787;715.0739791969412;12847.550335738299;13040.934795325962;13052.673683157902;13165.1442656228;13177.670558236121;12417.93791031048;12887.613371598773;12971.221726696429;13127.606171814861;13422.597322080353;10122.49387530628;10757.515911783988;10880.945595272053;10960.56157753689;11192;3738.775673459574;3739.083924438503;3805.6384643458828;3837.021559502337;3869.825857836376;52061.47938520642;52307.47692523064;52534;52594;54369.91260174814;9440.527973601293;9527.3807202533;9537.570809313458;9538.284628652878;9583.089606487372;19172.520686982938;19199.040047997543;19202.80797192038;19242.134103965356;19263.711044334344;7765.572893490912;7778.105517865405;7796;7870.685172593032;7966.482178658369;4246.766427846436;4275.593818587229;4278.272693642089;4324.567543245713;4417.271150260235;3120.594322738075;3160.4311223979903;3164.920876978094;3167.5407065975305;3169.271067654406;565.1663795901095;579.3337661689008;580.982570522885;594.818580332994;597.1430996520007;586.2437455682123;596.6599038547986;623.0840664223584;674.6828990374516;718.1956209045902;8422.747317580483;8633.740987770378;8673;8953.418027828171;9285.767855803524;611.6880391000533;637.2830565613684;708.5606923707231;709.8757717399434;723.5477826358526;3848.3457812171996;3949.1114499238015;4025.396190571379;4033.153037862082;4090.8363665453644;58839;65332.67333663396;65593.6720316405;65727.67136164289;65756;56576.43423565794;57435.425645743846;57866.71066644724;57884;58366.41633583695;50830.74584627053;50961.49038509642;52362.21456678076;52455.73772131115;53049.2042619361;8601.741947741577;8840.646374144962;9006.279497640042;9100.22648074921;9138.908610913806;39198.6080139195;39239.215215696095;40113.39829902612;40394.59605403908;40504.392434112924;47216.7639161802;48386.75806620944;51731.741341293055;52185;52262.47737522728;12207.145499814927;12264.32546209967;12328.137030407785;12466.002719782215;12723;11383.846695284168;11587.073034157078;12399.25604463735;12576.559820406608;12748.107632465639;11313.094952403624;11416.143789216008;11461.713457163638;11679.532818687157;11927;11107.944460277648;11723.35521546289;11875.940620296844;11939;12316.692082697646;11099.50052247667;11104.5558177672;11324.773504529698;11389.373584452604;11656.592019279284;9849.162821160282;10133.64532241368;10357.792844142925;10605;10617.681469555926;8982.55639698681;9918.206543476648;9940.502974851373;10259.57849633812;10339.534720937727 08:30:15 INFO - 2016-02-01 08:30:15,864 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:30:15 INFO - 2016-02-01 08:30:15,864 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:30:15 INFO - 2016-02-01 08:30:15,864 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,848 08:30:15 INFO - 2016-02-01 08:30:15,864 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:30:15 INFO - 2016-02-01 08:30:15,865 DEBUG : BROWSER_OUTPUT: __startTimestamp1454344215856__endTimestamp 08:30:15 INFO - 2016-02-01 08:30:15,865 DEBUG : BROWSER_OUTPUT: 08:30:15 INFO - 2016-02-01 08:30:15,865 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:30:15 INFO - 2016-02-01 08:30:15,865 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:30:15 INFO - 2016-02-01 08:30:15,865 DEBUG : BROWSER_OUTPUT: 08:30:15 INFO - 2016-02-01 08:30:15,865 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5605.38 Median:5782.19 stddev:631.77 (10.9%) stddev-sans-first:606.87 08:30:15 INFO - 2016-02-01 08:30:15,865 DEBUG : BROWSER_OUTPUT: Values: 3283.3 3352.3 3379.9 3386.0 3406.5 5599.1 5627.9 5630.1 5633.3 5635.1 5626.7 5678.7 5689.5 5700.9 5709.6 4926.0 4942.7 5133.8 5155.3 5215.4 5149.2 5169.4 5173.0 5175.1 5188.5 4955.0 5120.9 5129.8 5188.6 5199.1 5102.9 5206.2 5235.7 5236.4 5241.7 5121.8 5146.4 5160.2 5209.9 5250.7 5327.1 5339.7 5427.8 5434.5 5525.3 6041.3 6050.0 6051.3 6054.7 6061.6 6009.2 6092.7 6094.0 6100.8 6106.4 5507.5 5559.4 5564.6 5623.6 5658.2 6204.7 6223.6 6230.2 6258.6 6264.5 5694.9 6058.1 6059.8 6070.3 6108.8 5895.0 5949.0 6013.9 6015.3 6060.5 6006.6 6015.0 6018.8 6028.0 6028.7 5782.2 5834.0 5999.6 6009.0 6012.1 4496.0 4515.0 4517.7 4518.9 4524.2 4047.0 4105.5 4151.4 4162.0 4169.5 5698.0 5706.9 5708.3 5715.8 5755.5 5736.3 6128.4 6141.6 6146.4 6149.2 5552.8 5657.5 5711.9 5730.0 5745.9 5255.7 5261.9 5276.3 5310.5 5313.5 6062.0 6138.8 6241.8 6264.0 6265.6 6016.8 6123.4 6124.1 6126.5 6132.6 6210.6 6212.4 6223.3 6223.8 6226.6 5751.5 5858.0 5908.1 6003.4 6018.9 6107.6 6109.1 6137.6 6137.9 6142.1 5938.4 5979.4 5992.6 5993.2 6018.4 5616.4 5791.0 5843.1 5959.6 5966.0 5806.2 5809.8 5814.6 5815.4 5821.0 5908.2 5922.1 5925.9 5930.7 5932.7 5680.2 5737.0 5752.2 5806.9 5908.3 08:30:15 INFO - 2016-02-01 08:30:15,865 DEBUG : BROWSER_OUTPUT: 08:30:15 INFO - 2016-02-01 08:30:15,865 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45060.99 Median:33242.58 stddev:67130.03 (201.9%) stddev-sans-first:67235.29 08:30:15 INFO - 2016-02-01 08:30:15,865 DEBUG : BROWSER_OUTPUT: Values: 588.9 644.6 648.8 651.7 659.7 33082.5 42523.4 42855.8 42918.4 42962.0 47374.5 47511.5 47771.3 47970.8 47992.3 8028.0 8141.9 8929.9 9103.4 9107.8 10494.6 10598.8 10603.3 10633.6 10650.6 10579.2 10665.6 10671.8 10675.1 10680.0 10672.1 10749.8 10753.6 10759.1 10770.9 10601.7 10781.4 10781.5 10788.7 10793.0 43570.3 43976.6 44084.6 44114.0 44118.0 3482.5 3572.5 3591.5 3711.3 3819.6 32880.8 33017.5 33103.2 33218.0 33267.2 4097.5 4130.6 4193.2 4232.0 4241.5 294744.0 295253.0 295491.0 295985.5 296481.0 56484.2 57460.4 70464.6 71391.3 71523.0 63960.7 64748.4 64820.7 64970.4 65124.3 17048.8 17246.0 17312.2 17313.7 17380.7 12745.3 12937.4 12967.2 13064.0 13113.2 21390.6 21514.7 21592.0 21660.5 21697.5 7840.0 7944.9 8046.7 8052.8 8115.9 1056.7 1083.1 1123.1 1154.6 1178.3 26880.1 27205.9 28741.0 28747.4 29267.6 1133.5 1152.3 1189.8 1191.5 1240.2 14334.0 14903.9 15112.1 16204.5 16611.9 265630.0 267776.0 268872.0 269604.0 269826.0 58094.7 59232.7 59329.0 59352.7 59354.4 1333.5 1352.7 1458.1 1461.4 1477.7 27941.4 28484.7 28785.3 28788.4 28812.0 42556.8 42852.4 42912.8 42940.6 42957.8 201033.0 201308.0 201707.0 201870.0 202431.0 33128.8 34056.0 34194.3 34363.0 34390.0 45353.0 46355.5 46614.5 47159.8 47171.3 38830.8 39007.0 39772.4 40080.0 40401.8 38686.0 39308.6 39470.2 39828.8 39956.0 38938.0 39507.8 39592.6 39690.2 39767.6 34085.0 35946.8 37411.0 38651.2 38800.8 26668.7 26894.6 27325.6 27455.3 27586.2 08:30:15 INFO - 2016-02-01 08:30:15,865 DEBUG : BROWSER_OUTPUT: 08:30:15 INFO - 2016-02-01 08:30:15,865 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32691.68 Median:10993.08 stddev:106011.55 (964.3%) stddev-sans-first:106281.18 08:30:15 INFO - 2016-02-01 08:30:15,866 DEBUG : BROWSER_OUTPUT: Values: 380.5 382.7 385.4 396.5 398.8 14671.2 16620.8 17244.7 18793.9 18813.1 11903.7 12039.9 12142.9 18658.6 19063.6 5077.1 5156.8 5161.6 5170.5 5171.4 4059.4 4157.5 5125.3 5642.5 5761.5 5652.0 5671.6 5703.9 5742.6 5747.3 5569.6 5668.9 5670.8 5673.6 5674.9 5434.0 5469.6 5487.3 5490.3 5490.4 19994.5 20345.2 20573.1 20667.5 21251.6 2271.0 2365.7 2399.2 2402.6 2452.5 13823.7 13934.8 14029.6 14054.2 14361.5 1874.6 1907.2 1929.6 1950.0 1991.7 66436.3 69060.7 69408.7 69792.7 71155.0 10495.3 10555.1 10629.3 10643.7 10675.4 13403.0 13441.7 13505.9 13522.7 13536.5 7927.6 7971.2 8247.1 8290.9 8294.4 7621.6 7626.5 7627.4 7672.5 7809.3 4340.4 4387.9 4398.0 4517.5 4524.7 1706.2 1751.1 1777.6 1790.9 1800.7 934.3 1016.9 1038.8 1057.9 1061.2 15221.8 17492.1 17692.8 17868.8 18144.8 1002.6 1007.8 1072.5 1072.5 1093.2 6457.6 9707.0 9946.1 10401.1 10419.2 640020.0 643997.0 647938.0 651793.0 656014.0 90587.5 94949.0 94999.5 95235.0 95504.5 517.9 532.7 532.9 533.1 533.7 10605.6 11166.9 11252.5 11311.0 11354.3 36392.5 36608.6 36965.0 37294.6 37330.4 45854.5 46487.5 47757.5 47945.0 50220.0 10341.7 10505.3 10648.5 10659.6 10706.6 12447.4 12476.6 12493.9 12624.4 17930.2 15199.3 15395.6 15482.7 15515.5 15792.7 15030.2 15042.7 15108.4 15516.6 15742.4 15751.9 15830.4 16015.1 16225.2 16239.8 10294.1 10586.3 10679.5 10685.9 10712.5 11179.0 13032.0 16282.4 16338.1 16595.3 08:30:15 INFO - 2016-02-01 08:30:15,866 DEBUG : BROWSER_OUTPUT: 08:30:15 INFO - 2016-02-01 08:30:15,866 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5628.09 Median:6613.92 stddev:2924.91 (44.2%) stddev-sans-first:2916.15 08:30:15 INFO - 2016-02-01 08:30:15,866 DEBUG : BROWSER_OUTPUT: Values: 1436.7 1439.3 1625.3 1802.8 1844.1 7636.6 8164.1 8177.8 8198.6 8209.3 6895.7 7133.9 7746.9 7921.7 8007.9 2274.5 2276.9 2310.1 2310.8 2314.1 2026.9 2334.4 2361.6 2411.4 2412.3 2049.8 2289.9 2334.0 2334.7 2335.2 2287.2 2338.6 2340.6 2345.9 2348.1 2357.8 2359.2 2391.2 2392.0 2409.6 7927.7 7945.8 7965.7 7997.0 8018.1 4620.0 4727.6 4729.3 4737.5 4739.6 3055.9 3097.9 3115.0 3118.8 3185.5 1094.2 1095.3 1106.2 1127.3 1132.2 10793.9 10983.0 10988.2 11010.9 11027.9 4345.8 4387.0 4399.1 4455.2 4457.8 9532.2 9535.3 9541.8 9550.2 9572.0 4796.0 4800.3 4821.1 4830.8 4835.4 4339.6 4381.9 4394.7 4395.7 4397.0 3706.6 3731.3 3764.2 3767.2 3775.4 1135.6 1186.3 1187.3 1207.8 1267.1 1188.6 1206.3 1213.0 1437.8 1455.0 7433.4 7447.6 7757.5 7767.5 7792.2 626.9 630.2 636.3 658.2 792.7 5981.8 6106.8 6113.4 6120.2 6120.7 9102.7 9299.7 9350.4 9369.7 9528.4 9341.3 9360.4 9360.6 9373.2 9386.6 7150.6 7331.2 7459.9 7533.7 7616.4 7699.8 7738.5 7764.6 7766.6 7793.7 8477.0 8541.7 8716.3 8735.2 8745.1 8668.9 8715.3 8754.8 8757.1 8875.3 7282.5 7348.5 7363.0 7367.3 7381.3 7848.2 7865.7 7925.8 7934.7 7940.8 6614.2 7357.3 7371.7 7391.2 7435.8 6613.6 7302.7 7379.8 7435.7 7488.9 7440.9 7496.8 7497.1 7517.1 7532.0 6890.2 6927.1 6954.3 6959.9 6972.9 6547.2 6636.3 6705.6 6733.5 6769.3 08:30:15 INFO - 2016-02-01 08:30:15,866 DEBUG : BROWSER_OUTPUT: 08:30:15 INFO - 2016-02-01 08:30:15,866 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5397.09 Median:6111.43 stddev:1586.23 (26.0%) stddev-sans-first:1545.08 08:30:15 INFO - 2016-02-01 08:30:15,867 DEBUG : BROWSER_OUTPUT: Values: 366.1 373.6 375.2 375.6 381.5 6029.2 6076.1 6102.7 6110.5 6112.4 5752.6 5879.9 5899.8 5907.0 5977.9 4513.6 4575.6 4681.3 4693.5 4694.3 4670.3 4683.2 4691.5 4697.3 4700.3 4467.6 4583.8 4666.6 4678.1 4678.6 4561.5 4652.9 4661.8 4667.5 4688.7 4169.7 4170.2 4173.8 4173.8 4176.2 5707.2 5722.9 5726.6 5727.6 5731.1 5344.4 5419.9 5435.4 5474.0 5493.7 6315.5 6342.2 6347.6 6358.0 6368.3 4566.5 4572.4 4575.1 4575.3 4577.3 6426.0 6550.8 6563.9 6569.2 6574.1 4744.4 4765.2 4776.7 4778.7 4791.9 4830.6 4831.8 4837.5 4839.9 4842.2 5469.9 5474.0 5476.8 5481.2 5483.0 6346.9 6383.6 6427.6 6438.7 6441.3 1686.0 1710.2 1711.1 1711.4 1712.9 1186.0 1187.8 1192.6 1194.9 1212.6 6176.1 6178.9 6185.7 6188.5 6191.5 6595.3 6626.6 6629.0 6630.9 6644.2 5780.0 5983.7 6166.6 6183.9 6188.2 3502.3 3544.4 3547.9 3550.6 3597.7 6828.6 6829.8 6834.3 6836.1 6836.8 6814.9 6822.6 6824.1 6828.9 6834.0 6563.4 6776.4 6804.0 6823.0 6825.3 6619.8 6671.3 6671.9 6673.3 6678.2 6455.9 6575.5 6584.0 6589.3 6590.5 6791.4 6800.6 6803.6 6809.8 6813.3 4575.0 4614.4 4617.3 4619.5 4620.9 6671.3 6672.7 6674.1 6674.5 6680.3 6366.5 6481.6 6486.4 6490.6 6493.6 6442.0 6454.1 6462.1 6472.0 6473.6 6162.4 6324.4 6343.5 6378.3 6387.7 6503.8 6530.3 6535.8 6538.7 6544.7 6156.4 6218.8 6262.4 6354.4 6365.7 08:30:15 INFO - 2016-02-01 08:30:15,867 DEBUG : BROWSER_OUTPUT: 08:30:15 INFO - 2016-02-01 08:30:15,867 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:15006.16 Median:51896.61 stddev:17949.13 (34.6%) stddev-sans-first:17968.28 08:30:15 INFO - 2016-02-01 08:30:15,867 DEBUG : BROWSER_OUTPUT: Values: 911.6 916.3 918.7 929.4 945.8 15241.5 15657.4 15746.8 15750.3 15760.7 14689.0 14788.9 14799.3 14836.7 14855.9 775.4 779.2 907.7 927.9 928.4 918.7 929.8 933.5 939.6 940.3 948.0 957.6 959.0 959.4 959.6 806.5 812.7 966.6 971.3 972.7 713.7 714.6 714.7 714.9 715.1 12847.6 13040.9 13052.7 13165.1 13177.7 12417.9 12887.6 12971.2 13127.6 13422.6 10122.5 10757.5 10880.9 10960.6 11192.0 3738.8 3739.1 3805.6 3837.0 3869.8 52061.5 52307.5 52534.0 52594.0 54369.9 9440.5 9527.4 9537.6 9538.3 9583.1 19172.5 19199.0 19202.8 19242.1 19263.7 7765.6 7778.1 7796.0 7870.7 7966.5 4246.8 4275.6 4278.3 4324.6 4417.3 3120.6 3160.4 3164.9 3167.5 3169.3 565.2 579.3 581.0 594.8 597.1 586.2 596.7 623.1 674.7 718.2 8422.7 8633.7 8673.0 8953.4 9285.8 611.7 637.3 708.6 709.9 723.5 3848.3 3949.1 4025.4 4033.2 4090.8 58839.0 65332.7 65593.7 65727.7 65756.0 56576.4 57435.4 57866.7 57884.0 58366.4 50830.7 50961.5 52362.2 52455.7 53049.2 8601.7 8840.6 9006.3 9100.2 9138.9 39198.6 39239.2 40113.4 40394.6 40504.4 47216.8 48386.8 51731.7 52185.0 52262.5 12207.1 12264.3 12328.1 12466.0 12723.0 11383.8 11587.1 12399.3 12576.6 12748.1 11313.1 11416.1 11461.7 11679.5 11927.0 11107.9 11723.4 11875.9 11939.0 12316.7 11099.5 11104.6 11324.8 11389.4 11656.6 9849.2 10133.6 10357.8 10605.0 10617.7 8982.6 9918.2 9940.5 10259.6 10339.5 08:30:15 INFO - 2016-02-01 08:30:15,867 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:30:15 INFO - 2016-02-01 08:30:15,867 DEBUG : BROWSER_OUTPUT: 08:30:16 INFO - 2016-02-01 08:30:16,478 INFO : Browser exited with error code: 0 08:30:16 INFO - 2016-02-01 08:30:16,499 INFO : Completed test dromaeo_css (00:18:29) 08:30:16 INFO - 2016-02-01 08:30:16,499 INFO : Starting test kraken 08:30:16 INFO - 2016-02-01 08:30:16,499 DEBUG : operating with platform_type : linux_ 08:30:16 INFO - 2016-02-01 08:30:16,499 INFO : Initialising browser for kraken test... 08:30:16 INFO - 2016-02-01 08:30:16,505 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGrbVmW/profile http://localhost:45832/getInfo.html 08:30:20 INFO - 2016-02-01 08:30:20,144 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:30:20 INFO - 2016-02-01 08:30:20,144 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:30:20 INFO - 2016-02-01 08:30:20,144 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:30:20 INFO - 2016-02-01 08:30:20,144 DEBUG : BROWSER_OUTPUT: __metrics 08:30:20 INFO - 2016-02-01 08:30:20,367 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] 08:30:21 INFO - 2016-02-01 08:30:21,176 INFO : Browser initialized. 08:30:21 INFO - 2016-02-01 08:30:21,176 INFO : Running cycle 1/1 for kraken test... 08:30:21 INFO - 2016-02-01 08:30:21,176 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGrbVmW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:30:32 INFO - 2016-02-01 08:30:32,966 DEBUG : BROWSER_OUTPUT: RSS: Main: 134369280 08:30:32 INFO - 2016-02-01 08:30:32,966 DEBUG : BROWSER_OUTPUT: 08:30:35 INFO - 2016-02-01 08:30:35,388 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45832/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45832/tests/kraken/driver.html?testName=audio-beat-detection) 08:30:35 INFO - 2016-02-01 08:30:35,971 DEBUG : BROWSER_OUTPUT: RSS: Main: 165945344 08:30:35 INFO - 2016-02-01 08:30:35,972 DEBUG : BROWSER_OUTPUT: 08:30:38 INFO - 2016-02-01 08:30:38,501 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45832/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45832/tests/kraken/driver.html?testName=audio-dft) 08:30:39 INFO - 2016-02-01 08:30:39,067 DEBUG : BROWSER_OUTPUT: RSS: Main: 163491840 08:30:39 INFO - 2016-02-01 08:30:39,067 DEBUG : BROWSER_OUTPUT: 08:30:41 INFO - 2016-02-01 08:30:41,850 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45832/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45832/tests/kraken/driver.html?testName=audio-fft) 08:30:42 INFO - 2016-02-01 08:30:42,414 DEBUG : BROWSER_OUTPUT: RSS: Main: 160088064 08:30:42 INFO - 2016-02-01 08:30:42,415 DEBUG : BROWSER_OUTPUT: 08:30:44 INFO - 2016-02-01 08:30:44,395 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45832/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45832/tests/kraken/driver.html?testName=audio-oscillator) 08:30:44 INFO - 2016-02-01 08:30:44,963 DEBUG : BROWSER_OUTPUT: RSS: Main: 158605312 08:30:44 INFO - 2016-02-01 08:30:44,963 DEBUG : BROWSER_OUTPUT: 08:30:47 INFO - 2016-02-01 08:30:47,157 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45832/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45832/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:30:47 INFO - 2016-02-01 08:30:47,706 DEBUG : BROWSER_OUTPUT: RSS: Main: 158662656 08:30:47 INFO - 2016-02-01 08:30:47,706 DEBUG : BROWSER_OUTPUT: 08:30:50 INFO - 2016-02-01 08:30:50,593 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45832/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45832/tests/kraken/driver.html?testName=imaging-darkroom) 08:30:51 INFO - 2016-02-01 08:30:51,163 DEBUG : BROWSER_OUTPUT: RSS: Main: 158490624 08:30:51 INFO - 2016-02-01 08:30:51,163 DEBUG : BROWSER_OUTPUT: 08:30:54 INFO - 2016-02-01 08:30:54,485 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45832/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45832/tests/kraken/driver.html?testName=imaging-desaturate) 08:30:55 INFO - 2016-02-01 08:30:55,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 158187520 08:30:55 INFO - 2016-02-01 08:30:55,051 DEBUG : BROWSER_OUTPUT: 08:30:57 INFO - 2016-02-01 08:30:57,750 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45832/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45832/tests/kraken/driver.html?testName=json-parse-financial) 08:30:58 INFO - 2016-02-01 08:30:58,317 DEBUG : BROWSER_OUTPUT: RSS: Main: 160403456 08:30:58 INFO - 2016-02-01 08:30:58,317 DEBUG : BROWSER_OUTPUT: 08:30:59 INFO - 2016-02-01 08:30:59,850 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45832/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45832/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:31:00 INFO - 2016-02-01 08:31:00,412 DEBUG : BROWSER_OUTPUT: RSS: Main: 165298176 08:31:00 INFO - 2016-02-01 08:31:00,413 DEBUG : BROWSER_OUTPUT: 08:31:02 INFO - 2016-02-01 08:31:02,175 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45832/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45832/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:31:02 INFO - 2016-02-01 08:31:02,762 DEBUG : BROWSER_OUTPUT: RSS: Main: 162177024 08:31:02 INFO - 2016-02-01 08:31:02,762 DEBUG : BROWSER_OUTPUT: 08:31:04 INFO - 2016-02-01 08:31:04,780 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45832/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45832/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:31:05 INFO - 2016-02-01 08:31:05,346 DEBUG : BROWSER_OUTPUT: RSS: Main: 168738816 08:31:05 INFO - 2016-02-01 08:31:05,346 DEBUG : BROWSER_OUTPUT: 08:31:07 INFO - 2016-02-01 08:31:07,691 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45832/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45832/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:31:08 INFO - 2016-02-01 08:31:08,273 DEBUG : BROWSER_OUTPUT: RSS: Main: 176123904 08:31:08 INFO - 2016-02-01 08:31:08,273 DEBUG : BROWSER_OUTPUT: 08:31:10 INFO - 2016-02-01 08:31:10,769 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45832/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45832/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:31:11 INFO - 2016-02-01 08:31:11,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 173830144 08:31:11 INFO - 2016-02-01 08:31:11,336 DEBUG : BROWSER_OUTPUT: 08:31:13 INFO - 2016-02-01 08:31:13,010 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45832/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45832/tests/kraken/driver.html?testName=ai-astar) 08:31:13 INFO - 2016-02-01 08:31:13,256 DEBUG : BROWSER_OUTPUT: RSS: Main: 232247296 08:31:13 INFO - 2016-02-01 08:31:13,256 DEBUG : BROWSER_OUTPUT: 08:31:13 INFO - 2016-02-01 08:31:13,259 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:31:13 INFO - 2016-02-01 08:31:13,259 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:31:13 INFO - 2016-02-01 08:31:13,259 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:31:13 INFO - 2016-02-01 08:31:13,260 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:31:13 INFO - 2016-02-01 08:31:13,260 DEBUG : BROWSER_OUTPUT: |0;ai-astar;107;109;102;110;109;110;98;109;109;112 08:31:13 INFO - 2016-02-01 08:31:13,260 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;123;147;165;121;147;146;120;161;120 08:31:13 INFO - 2016-02-01 08:31:13,260 DEBUG : BROWSER_OUTPUT: |2;audio-dft;159;161;160;159;160;160;160;161;158;160 08:31:13 INFO - 2016-02-01 08:31:13,260 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;72;154;72;71;71;71;152;71 08:31:13 INFO - 2016-02-01 08:31:13,260 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;141;92;92;93;136;92;93;140 08:31:13 INFO - 2016-02-01 08:31:13,260 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;108;108;109;109;109;109;109;109;109;109 08:31:13 INFO - 2016-02-01 08:31:13,260 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;146;146;145;145;145;146;146;145 08:31:13 INFO - 2016-02-01 08:31:13,261 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;96;95;95;95;95 08:31:13 INFO - 2016-02-01 08:31:13,261 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;55;56;55;56;55;56;58;54;54 08:31:13 INFO - 2016-02-01 08:31:13,261 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;64;64;63;64;64;64;63;64 08:31:13 INFO - 2016-02-01 08:31:13,261 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;77;86;78;77;85;78;78;86;79 08:31:13 INFO - 2016-02-01 08:31:13,261 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;115;113;113;114;116;120;120;121;112 08:31:13 INFO - 2016-02-01 08:31:13,261 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;145;146;154;146;134;145;149;145;133 08:31:13 INFO - 2016-02-01 08:31:13,261 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;63;64;73;65;65;63;64;64;63;65 08:31:13 INFO - 2016-02-01 08:31:13,262 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:31:13 INFO - 2016-02-01 08:31:13,262 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:31:13 INFO - 2016-02-01 08:31:13,262 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,882 08:31:13 INFO - 2016-02-01 08:31:13,262 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:31:13 INFO - 2016-02-01 08:31:13,262 DEBUG : BROWSER_OUTPUT: __startTimestamp1454344273257__endTimestamp 08:31:13 INFO - 2016-02-01 08:31:13,262 DEBUG : BROWSER_OUTPUT: 08:31:13 INFO - 2016-02-01 08:31:13,266 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:31:13 INFO - 2016-02-01 08:31:13,266 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:31:13 INFO - 2016-02-01 08:31:13,266 DEBUG : BROWSER_OUTPUT: 08:31:13 INFO - 2016-02-01 08:31:13,266 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.50 Median:109.50 stddev:4.25 (3.9%) stddev-sans-first:4.50 08:31:13 INFO - 2016-02-01 08:31:13,266 DEBUG : BROWSER_OUTPUT: Values: 107.0 109.0 102.0 110.0 109.0 110.0 98.0 109.0 109.0 112.0 08:31:13 INFO - 2016-02-01 08:31:13,266 DEBUG : BROWSER_OUTPUT: 08:31:13 INFO - 2016-02-01 08:31:13,266 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.30 Median:147.00 stddev:17.70 (12.0%) stddev-sans-first:18.16 08:31:13 INFO - 2016-02-01 08:31:13,266 DEBUG : BROWSER_OUTPUT: Values: 153.0 123.0 147.0 165.0 121.0 147.0 146.0 120.0 161.0 120.0 08:31:13 INFO - 2016-02-01 08:31:13,266 DEBUG : BROWSER_OUTPUT: 08:31:13 INFO - 2016-02-01 08:31:13,267 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:159.80 Median:160.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 08:31:13 INFO - 2016-02-01 08:31:13,267 DEBUG : BROWSER_OUTPUT: Values: 159.0 161.0 160.0 159.0 160.0 160.0 160.0 161.0 158.0 160.0 08:31:13 INFO - 2016-02-01 08:31:13,267 DEBUG : BROWSER_OUTPUT: 08:31:13 INFO - 2016-02-01 08:31:13,267 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.70 Median:71.00 stddev:34.42 (48.5%) stddev-sans-first:35.98 08:31:13 INFO - 2016-02-01 08:31:13,267 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 72.0 154.0 72.0 71.0 71.0 71.0 152.0 71.0 08:31:13 INFO - 2016-02-01 08:31:13,267 DEBUG : BROWSER_OUTPUT: 08:31:13 INFO - 2016-02-01 08:31:13,267 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.40 Median:92.00 stddev:22.53 (24.5%) stddev-sans-first:23.29 08:31:13 INFO - 2016-02-01 08:31:13,267 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 141.0 92.0 92.0 93.0 136.0 92.0 93.0 140.0 08:31:13 INFO - 2016-02-01 08:31:13,267 DEBUG : BROWSER_OUTPUT: 08:31:13 INFO - 2016-02-01 08:31:13,267 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:108.80 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 08:31:13 INFO - 2016-02-01 08:31:13,267 DEBUG : BROWSER_OUTPUT: Values: 108.0 108.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 08:31:13 INFO - 2016-02-01 08:31:13,268 DEBUG : BROWSER_OUTPUT: 08:31:13 INFO - 2016-02-01 08:31:13,268 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 08:31:13 INFO - 2016-02-01 08:31:13,268 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 146.0 146.0 145.0 145.0 145.0 146.0 146.0 145.0 08:31:13 INFO - 2016-02-01 08:31:13,268 DEBUG : BROWSER_OUTPUT: 08:31:13 INFO - 2016-02-01 08:31:13,268 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:31:13 INFO - 2016-02-01 08:31:13,268 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 08:31:13 INFO - 2016-02-01 08:31:13,268 DEBUG : BROWSER_OUTPUT: 08:31:13 INFO - 2016-02-01 08:31:13,268 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.00 stddev:1.62 (2.9%) stddev-sans-first:1.24 08:31:13 INFO - 2016-02-01 08:31:13,268 DEBUG : BROWSER_OUTPUT: Values: 59.0 55.0 56.0 55.0 56.0 55.0 56.0 58.0 54.0 54.0 08:31:13 INFO - 2016-02-01 08:31:13,268 DEBUG : BROWSER_OUTPUT: 08:31:13 INFO - 2016-02-01 08:31:13,268 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 08:31:13 INFO - 2016-02-01 08:31:13,269 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 64.0 64.0 63.0 64.0 64.0 64.0 63.0 64.0 08:31:13 INFO - 2016-02-01 08:31:13,269 DEBUG : BROWSER_OUTPUT: 08:31:13 INFO - 2016-02-01 08:31:13,269 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:78.50 stddev:3.90 (5.0%) stddev-sans-first:3.97 08:31:13 INFO - 2016-02-01 08:31:13,269 DEBUG : BROWSER_OUTPUT: Values: 77.0 77.0 86.0 78.0 77.0 85.0 78.0 78.0 86.0 79.0 08:31:13 INFO - 2016-02-01 08:31:13,269 DEBUG : BROWSER_OUTPUT: 08:31:13 INFO - 2016-02-01 08:31:13,269 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:116.20 Median:117.00 stddev:3.33 (2.8%) stddev-sans-first:3.46 08:31:13 INFO - 2016-02-01 08:31:13,269 DEBUG : BROWSER_OUTPUT: Values: 118.0 115.0 113.0 113.0 114.0 116.0 120.0 120.0 121.0 112.0 08:31:13 INFO - 2016-02-01 08:31:13,269 DEBUG : BROWSER_OUTPUT: 08:31:13 INFO - 2016-02-01 08:31:13,269 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.40 Median:145.50 stddev:6.69 (4.6%) stddev-sans-first:6.68 08:31:13 INFO - 2016-02-01 08:31:13,269 DEBUG : BROWSER_OUTPUT: Values: 137.0 145.0 146.0 154.0 146.0 134.0 145.0 149.0 145.0 133.0 08:31:13 INFO - 2016-02-01 08:31:13,269 DEBUG : BROWSER_OUTPUT: 08:31:13 INFO - 2016-02-01 08:31:13,269 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:64.50 stddev:2.96 (4.6%) stddev-sans-first:3.06 08:31:13 INFO - 2016-02-01 08:31:13,269 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 73.0 65.0 65.0 63.0 64.0 64.0 63.0 65.0 08:31:13 INFO - 2016-02-01 08:31:13,269 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:31:13 INFO - 2016-02-01 08:31:13,269 DEBUG : BROWSER_OUTPUT: 08:31:13 INFO - 2016-02-01 08:31:13,974 INFO : Browser exited with error code: 0 08:31:14 INFO - 2016-02-01 08:31:14,027 INFO : Completed test kraken (00:00:57) 08:31:14 INFO - 2016-02-01 08:31:14,027 INFO : Starting test v8_7 08:31:14 INFO - 2016-02-01 08:31:14,027 DEBUG : operating with platform_type : linux_ 08:31:14 INFO - 2016-02-01 08:31:14,027 INFO : Initialising browser for v8_7 test... 08:31:14 INFO - 2016-02-01 08:31:14,033 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSDrtq7/profile http://localhost:45832/getInfo.html 08:31:17 INFO - 2016-02-01 08:31:17,717 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:31:17 INFO - 2016-02-01 08:31:17,718 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:31:17 INFO - 2016-02-01 08:31:17,718 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:31:17 INFO - 2016-02-01 08:31:17,718 DEBUG : BROWSER_OUTPUT: __metrics 08:31:17 INFO - 2016-02-01 08:31:17,875 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] 08:31:18 INFO - 2016-02-01 08:31:18,804 INFO : Browser initialized. 08:31:18 INFO - 2016-02-01 08:31:18,804 INFO : Running cycle 1/1 for v8_7 test... 08:31:18 INFO - 2016-02-01 08:31:18,804 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSDrtq7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:31:30 INFO - 2016-02-01 08:31:30,623 DEBUG : BROWSER_OUTPUT: RSS: Main: 134860800 08:31:30 INFO - 2016-02-01 08:31:30,623 DEBUG : BROWSER_OUTPUT: 08:31:51 INFO - 2016-02-01 08:31:51,988 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45832/tests/v8_7/run.html (next: http://localhost:45832/tests/v8_7/run.html) 08:31:52 INFO - 2016-02-01 08:31:52,238 DEBUG : BROWSER_OUTPUT: RSS: Main: 418906112 08:31:52 INFO - 2016-02-01 08:31:52,238 DEBUG : BROWSER_OUTPUT: 08:31:52 INFO - 2016-02-01 08:31:52,239 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:31:52 INFO - 2016-02-01 08:31:52,239 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:31:52 INFO - 2016-02-01 08:31:52,239 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:31:52 INFO - 2016-02-01 08:31:52,240 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:31:52 INFO - 2016-02-01 08:31:52,240 DEBUG : BROWSER_OUTPUT: |0;Richards;167.33601070950468 08:31:52 INFO - 2016-02-01 08:31:52,240 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;167.19612104999163 08:31:52 INFO - 2016-02-01 08:31:52,240 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.31895352073474 08:31:52 INFO - 2016-02-01 08:31:52,240 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5107.142857142857 08:31:52 INFO - 2016-02-01 08:31:52,240 DEBUG : BROWSER_OUTPUT: |4;RayTrace;956.0229445506692 08:31:52 INFO - 2016-02-01 08:31:52,240 DEBUG : BROWSER_OUTPUT: |5;Earley;540.8328826392644 08:31:52 INFO - 2016-02-01 08:31:52,240 DEBUG : BROWSER_OUTPUT: |6;Boyer;10557.894736842105 08:31:52 INFO - 2016-02-01 08:31:52,241 DEBUG : BROWSER_OUTPUT: |7;RegExp;24142.85714285714 08:31:52 INFO - 2016-02-01 08:31:52,241 DEBUG : BROWSER_OUTPUT: |8;Splay;531.9148936170212 08:31:52 INFO - 2016-02-01 08:31:52,241 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 08:31:52 INFO - 2016-02-01 08:31:52,241 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:31:52 INFO - 2016-02-01 08:31:52,241 DEBUG : BROWSER_OUTPUT: __startTimestamp1454344312238__endTimestamp 08:31:52 INFO - 2016-02-01 08:31:52,242 DEBUG : BROWSER_OUTPUT: 08:31:52 INFO - 2016-02-01 08:31:52,242 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:31:52 INFO - 2016-02-01 08:31:52,242 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:31:52 INFO - 2016-02-01 08:31:52,242 DEBUG : BROWSER_OUTPUT: 08:31:52 INFO - 2016-02-01 08:31:52,242 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.34 Median:167.34 stddev:0.00 (0.0%) 08:31:52 INFO - 2016-02-01 08:31:52,242 DEBUG : BROWSER_OUTPUT: Values: 167.3 08:31:52 INFO - 2016-02-01 08:31:52,242 DEBUG : BROWSER_OUTPUT: 08:31:52 INFO - 2016-02-01 08:31:52,242 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:167.20 Median:167.20 stddev:0.00 (0.0%) 08:31:52 INFO - 2016-02-01 08:31:52,242 DEBUG : BROWSER_OUTPUT: Values: 167.2 08:31:52 INFO - 2016-02-01 08:31:52,243 DEBUG : BROWSER_OUTPUT: 08:31:52 INFO - 2016-02-01 08:31:52,243 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.32 Median:278.32 stddev:0.00 (0.0%) 08:31:52 INFO - 2016-02-01 08:31:52,243 DEBUG : BROWSER_OUTPUT: Values: 278.3 08:31:52 INFO - 2016-02-01 08:31:52,243 DEBUG : BROWSER_OUTPUT: 08:31:52 INFO - 2016-02-01 08:31:52,243 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5107.14 Median:5107.14 stddev:0.00 (0.0%) 08:31:52 INFO - 2016-02-01 08:31:52,243 DEBUG : BROWSER_OUTPUT: Values: 5107.1 08:31:52 INFO - 2016-02-01 08:31:52,243 DEBUG : BROWSER_OUTPUT: 08:31:52 INFO - 2016-02-01 08:31:52,243 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:956.02 Median:956.02 stddev:0.00 (0.0%) 08:31:52 INFO - 2016-02-01 08:31:52,243 DEBUG : BROWSER_OUTPUT: Values: 956.0 08:31:52 INFO - 2016-02-01 08:31:52,243 DEBUG : BROWSER_OUTPUT: 08:31:52 INFO - 2016-02-01 08:31:52,243 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:540.83 Median:540.83 stddev:0.00 (0.0%) 08:31:52 INFO - 2016-02-01 08:31:52,244 DEBUG : BROWSER_OUTPUT: Values: 540.8 08:31:52 INFO - 2016-02-01 08:31:52,244 DEBUG : BROWSER_OUTPUT: 08:31:52 INFO - 2016-02-01 08:31:52,244 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10557.89 Median:10557.89 stddev:0.00 (0.0%) 08:31:52 INFO - 2016-02-01 08:31:52,244 DEBUG : BROWSER_OUTPUT: Values: 10557.9 08:31:52 INFO - 2016-02-01 08:31:52,244 DEBUG : BROWSER_OUTPUT: 08:31:52 INFO - 2016-02-01 08:31:52,244 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24142.86 Median:24142.86 stddev:0.00 (0.0%) 08:31:52 INFO - 2016-02-01 08:31:52,244 DEBUG : BROWSER_OUTPUT: Values: 24142.9 08:31:52 INFO - 2016-02-01 08:31:52,245 DEBUG : BROWSER_OUTPUT: 08:31:52 INFO - 2016-02-01 08:31:52,245 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:531.91 Median:531.91 stddev:0.00 (0.0%) 08:31:52 INFO - 2016-02-01 08:31:52,245 DEBUG : BROWSER_OUTPUT: Values: 531.9 08:31:52 INFO - 2016-02-01 08:31:52,245 DEBUG : BROWSER_OUTPUT: 08:31:52 INFO - 2016-02-01 08:31:52,246 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 08:31:52 INFO - 2016-02-01 08:31:52,246 DEBUG : BROWSER_OUTPUT: Values: 4822.1 08:31:52 INFO - 2016-02-01 08:31:52,246 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:31:52 INFO - 2016-02-01 08:31:52,246 DEBUG : BROWSER_OUTPUT: 08:31:52 INFO - 2016-02-01 08:31:52,942 INFO : Browser exited with error code: 0 08:31:52 INFO - 2016-02-01 08:31:52,954 INFO : Completed test v8_7 (00:00:38) 08:31:53 INFO - 2016-02-01 08:31:53,311 INFO : Completed test suite (00:20:06) 08:31:53 INFO - 2016-02-01 08:31:53,311 DEBUG : Working with test: dromaeo_css 08:31:53 INFO - 2016-02-01 08:31:53,311 DEBUG : Generating results file: dromaeo_css 08:31:53 INFO - 2016-02-01 08:31:53,312 DEBUG : Working with test: kraken 08:31:53 INFO - 2016-02-01 08:31:53,312 DEBUG : Generating results file: kraken 08:31:53 INFO - 2016-02-01 08:31:53,312 INFO : javascript benchmark 08:31:53 INFO - 2016-02-01 08:31:53,313 DEBUG : Working with test: v8_7 08:31:53 INFO - 2016-02-01 08:31:53,313 DEBUG : Generating results file: v8_7 08:31:53 INFO - 2016-02-01 08:31:53,313 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:31:53 INFO - 2016-02-01 08:31:53,365 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 08:31:53 INFO - 2016-02-01 08:31:53,365 DEBUG : process_Request line: dromaeo_css 7287.48 graph.html#tests=[[72,53,35]] 08:31:53 INFO - 2016-02-01 08:31:53,366 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:31:53 INFO - 2016-02-01 08:31:53,396 DEBUG : process_Request line: kraken 1475.20 graph.html#tests=[[232,53,35]] 08:31:53 INFO - 2016-02-01 08:31:53,397 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:31:53 INFO - 2016-02-01 08:31:53,438 DEBUG : process_Request line: v8_7 23255.99 graph.html#tests=[[230,53,35]] 08:31:53 INFO - 2016-02-01 08:31:53,439 INFO : javascript benchmark 08:31:53 INFO - 2016-02-01 08:31:53,442 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3283.326917981814, 3352.3127758809446, 3379.9324013519745, 3385.983070084649, 3406.4890266460034, 5599.076152434854, 5627.859303517414, 5630.071038278684, 5633.295838020247, 5635.126555383917, 5626.746796394162, 5678.687672178028, 5689.4879460848515, 5700.857478563028, 5709.571782116337, 4926.0, 4942.678725882824, 5133.768980395891, 5155.278261043457, 5215.400228973679, 5149.17613181891, 5169.431362550116, 5173.042987047408, 5175.146100893348, 5188.4811518848, 4954.950450495485, 5120.871978200556, 5129.820456284031, 5188.558972487324, 5199.09015922214, 5102.897942041157, 5206.193040078775, 5235.65968212065, 5236.371635403738, 5241.711705856176, 5121.769520371592, 5146.433892271847, 5160.200168973777, 5209.895802083975, 5250.684958902478, 5327.067763141474, 5339.652922560022, 5427.83716488506, 5434.456554344573, 5525.281713377275, 6041.305249896231, 6050.0, 6051.273847138372, 6054.69726513677, 6061.605995610271, 6009.188759517497, 6092.695365231765, 6093.969530152365, 6100.84084024034, 6106.3893610639025, 5507.531859791922, 5559.416261292587, 5564.582656300753, 5623.550115990711, 5658.179563963285, 6204.689765511796, 6223.626582405071, 6230.196411614791, 6258.593191442542, 6264.467520260829, 5694.9430505695245, 6058.1215723719815, 6059.787907423219, 6070.332263451017, 6108.755649774048, 5895.0, 5949.0, 6013.879722405527, 6015.30823955242, 6060.515158787286, 6006.609570377911, 6015.0, 6018.789342372996, 6027.969860150672, 6028.668423236764, 5782.190493330937, 5833.970830145907, 5999.5500337473995, 6009.0, 6012.068129439944, 4495.977520112378, 4515.0, 4517.661175411791, 4518.864434066983, 4524.16302983949, 4047.0, 4105.4662893823615, 4151.398047283187, 4162.042730172077, 4169.541350451448, 5697.974364614409, 5706.885862282814, 5708.315002199763, 5715.828525144252, 5755.453231942959, 5736.340320863154, 6128.448439640454, 6141.631502109888, 6146.354632763585, 6149.200603921461, 5552.750126244328, 5657.4908258256955, 5711.914321285184, 5730.025895597675, 5745.913811292834, 5255.710935898563, 5261.868453288622, 5276.314079169761, 5310.495502927293, 5313.495217954288, 6062.0, 6138.785142519991, 6241.812745617639, 6264.0, 6265.561410701298, 6016.789412370721, 6123.4488895999575, 6124.050772130327, 6126.51767379719, 6132.63204207749, 6210.5652604317265, 6212.409821066992, 6223.284322302993, 6223.751049957951, 6226.5641405101205, 5751.511121554548, 5858.004139296415, 5908.113782932594, 6003.3996600339615, 6018.909716354171, 6107.553844087133, 6109.144719739329, 6137.570370074231, 6137.9413674273155, 6142.078688196806, 5938.376470470538, 5979.372165922689, 5992.580519363777, 5993.220881285405, 6018.398160183947, 5616.438356164351, 5791.044477661138, 5843.1235314703135, 5959.553033522589, 5966.0, 5806.245188125686, 5809.82570522885, 5814.592978491465, 5815.447532484407, 5821.039528477754, 5908.231929849092, 5922.082077278029, 5925.881482370242, 5930.733117009659, 5932.673702946379, 5680.204771331934, 5737.0, 5752.1659359391815, 5806.883862322646, 5908.261467316585], "unit": "ms", "name": "dojo.html", "value": 5563.834646375619}, {"lowerIsBetter": false, "replicates": [588.9469947704706, 644.5874640230251, 648.8053583924823, 651.7262749645149, 659.7262136213475, 33082.50376244358, 42523.36214956774, 42855.78572107143, 42918.35622465666, 42962.0, 47374.526254737444, 47511.52488475123, 47771.28343074857, 47970.76014619931, 47992.28011579829, 8028.0, 8141.877871831927, 8929.866052009209, 9103.362764606447, 9107.772305692377, 10494.632687855927, 10598.841017384746, 10603.257771955967, 10633.627823026158, 10650.573977040947, 10579.20655950803, 10665.626703065394, 10671.83992240117, 10675.092617127553, 10680.0, 10672.146228301755, 10749.83875241872, 10753.62362317323, 10759.139268858473, 10770.892291077067, 10601.734956626146, 10781.353118812818, 10781.4609269537, 10788.676339709822, 10793.0, 43570.346444803356, 43976.56023439757, 44084.559154408365, 44114.0, 44118.0, 3482.4776283557417, 3572.499850020999, 3591.4612808078737, 3711.2763011212824, 3819.6371344722206, 32880.83559582211, 33017.50473742896, 33103.172420689436, 33218.0, 33267.168320792174, 4097.528784189826, 4130.6282434580735, 4193.22425351311, 4231.957680423187, 4241.512226094008, 294744.0, 295253.0, 295491.0, 295985.5200724004, 296481.0, 56484.152737708966, 57460.425395746344, 70464.64767676129, 71391.28608713951, 71523.0, 63960.68019659872, 64748.35251647423, 64820.67589662022, 64970.35029649643, 65124.34875651277, 17048.82951170497, 17246.0, 17312.22095005728, 17313.65372692539, 17380.739288910678, 12745.299008554619, 12937.353132343345, 12967.22196668203, 13064.0, 13113.213207207407, 21390.572188556453, 21514.677279840816, 21592.0, 21660.45848853791, 21697.45756356072, 7840.0, 7944.920550794418, 8046.678132874737, 8052.838943221102, 8115.918840811634, 1056.7252514346326, 1083.1443159903588, 1123.1464087293552, 1154.6362895687832, 1178.2753606531921, 26880.05919792837, 27205.863970680417, 28740.99406520762, 28747.425051498853, 29267.560986585217, 1133.484264659578, 1152.3143729480946, 1189.8215267709913, 1191.5055252070467, 1240.1752834365227, 14334.0, 14903.925480372529, 15112.09327440357, 16204.513864583845, 16611.916940415464, 265630.0, 267776.0, 268872.0, 269604.0, 269826.0, 58094.7095264521, 59232.70383648054, 59329.0, 59352.70323648354, 59354.406455934884, 1333.4599487207697, 1352.6618345413647, 1458.0741229319458, 1461.4227380184768, 1477.7340078785921, 27941.44117117687, 28484.715152848206, 28785.28036799013, 28788.424231514833, 28812.0, 42556.78721606372, 42852.35721464243, 42912.78543607262, 42940.570594294906, 42957.785211073744, 201033.0, 201308.0, 201707.0, 201870.0, 202431.0, 33128.83435582807, 34056.0, 34194.316113678084, 34363.0, 34390.0, 45353.0, 46355.53644463647, 46614.53385466102, 47159.764201178776, 47171.29243061425, 38830.805845970586, 39007.0, 39772.40341394823, 40079.99800005023, 40401.79799100986, 38686.0, 39308.6069139305, 39470.21059578735, 39828.800855995534, 39956.0, 38938.0, 39507.802460987514, 39592.60407396004, 39690.2061958765, 39767.602323977546, 34084.97745067652, 35946.8202658985, 37411.0, 38651.22697546089, 38800.80599596984, 26668.733312666624, 26894.59658105169, 27325.590116148673, 27455.313617159733, 27586.172414827586], "unit": "ms", "name": "ext.html", "value": 19793.36960131201}, {"lowerIsBetter": false, "replicates": [380.5243445692882, 382.68810919100946, 385.42956424491734, 396.49050969504185, 398.8364770444118, 14671.193084380355, 16620.75068873965, 17244.65510689787, 18793.906030469847, 18813.059347032646, 11903.702407439796, 12039.879601203986, 12142.939285303582, 18658.626827463442, 19063.61872762544, 5077.086124497599, 5156.793728250866, 5161.561267292266, 5170.53465188133, 5171.4311425743135, 4059.3910913363084, 4157.50109986802, 5125.282460455539, 5642.463965923231, 5761.539076873861, 5652.0, 5671.574631902603, 5703.8574035649235, 5742.626729262605, 5747.252857128588, 5569.582281328896, 5668.858278543028, 5670.8015219467325, 5673.602847800656, 5674.914876276859, 5434.049041417776, 5469.589780766419, 5487.286652735159, 5490.258815059956, 5490.423505531941, 19994.500137496678, 20345.18619255228, 20573.07421166051, 20667.483312917146, 21251.5749685007, 2271.0, 2365.66880636711, 2399.1722855614785, 2402.5915594349003, 2452.460458699083, 13823.723525529535, 13934.790978135336, 14029.64925876851, 14054.227017514135, 14361.497347592784, 1874.55010797409, 1907.2085084689836, 1929.6333696597742, 1950.0444782056832, 1991.661417559004, 66436.3356366435, 69060.65469672669, 69408.65295673591, 69792.651036745, 71155.0, 10495.265331426726, 10555.05004549579, 10629.255952083435, 10643.680689579325, 10675.412852293199, 13403.0, 13441.731165376637, 13505.86494135046, 13522.661933451742, 13536.526221582395, 7927.643256053491, 7971.1630278819885, 8247.051589067214, 8290.875636865452, 8294.37792165578, 7621.580813055224, 7626.542407455459, 7627.389808815282, 7672.462927595015, 7809.336206422404, 4340.392345071693, 4387.868363949086, 4398.010447649317, 4517.5256598057385, 4524.660650451229, 1706.1980868991554, 1751.0806826415978, 1777.6178121703895, 1790.8746387752992, 1800.7208882623215, 934.2899396458605, 1016.913667020589, 1038.7662775875367, 1057.9206559508068, 1061.1987949098382, 15221.771673424908, 17492.12539373026, 17692.823071769373, 17868.821311786716, 18144.818551814576, 1002.5889385352117, 1007.778288776468, 1072.512007036812, 1072.5280876414354, 1093.1746531368924, 6457.644829534327, 9707.0, 9946.126398064896, 10401.063904248655, 10419.218558608134, 640020.0, 643997.0, 647938.0, 651793.0, 656014.0, 90587.54706226426, 94949.0, 94999.52500237593, 95235.0, 95504.52247738717, 517.8938317644873, 532.7283085626281, 532.890757394741, 533.1309964757498, 533.650458949381, 10605.628802991858, 11166.888331116585, 11252.493637786156, 11311.038561722346, 11354.26197297173, 36392.45411318779, 36608.633913660524, 36965.0, 37294.62705372911, 37330.44004339883, 45854.54145458636, 46487.53512464967, 47757.5224247767, 47945.0, 50220.0, 10341.689749307532, 10505.264631475724, 10648.520816563117, 10659.626913058006, 10706.625268115578, 12447.377631118588, 12476.563320283747, 12493.875061249271, 12624.431900564314, 17930.193141308413, 15199.316030778862, 15395.615109621902, 15482.690346193238, 15515.534533963999, 15792.684146317239, 15030.248487575796, 15042.699146017238, 15108.39566417331, 15516.612084697972, 15742.370305187664, 15751.921240393725, 15830.445934392701, 16015.11916844538, 16225.18874056269, 16239.837601624306, 10294.073533382032, 10586.306191009402, 10679.466026698788, 10685.946570267099, 10712.464376781285, 11179.0, 13032.0, 16282.43011494592, 16338.10140442287, 16595.336186552402], "unit": "ms", "name": "jquery.html", "value": 9043.662664390979}, {"lowerIsBetter": false, "replicates": [1436.712657468506, 1439.3307112192836, 1625.2929975460668, 1802.774653168354, 1844.1424737497066, 7636.618169091544, 8164.101948785629, 8177.795555111125, 8198.631061602227, 8209.261166495015, 6895.724171033153, 7133.85732285354, 7746.883796743039, 7921.683132674701, 8007.91992080079, 2274.533720587284, 2276.943076423094, 2310.1106074161485, 2310.7689231076924, 2314.085936055257, 2026.9189232430758, 2334.3580515358244, 2361.645753137026, 2411.385096800322, 2412.2883749293915, 2049.75402951646, 2289.942751431211, 2333.976660233393, 2334.684817549626, 2335.1943579465055, 2287.1880482428664, 2338.567365037465, 2340.637201233803, 2345.9296221113395, 2348.1194552042984, 2357.7760112789256, 2359.2332491940188, 2391.198948352304, 2392.0, 2409.638554216864, 7927.722529711433, 7945.841083178304, 7965.721199758039, 7997.040355157418, 8018.118007019223, 4619.976900115512, 4727.621790256771, 4729.314249433847, 4737.526247375269, 4739.64452666048, 3055.8624861881267, 3097.90706278812, 3115.018769087753, 3118.844057797101, 3185.5221716742444, 1094.2231015978664, 1095.27164435651, 1106.1703722208345, 1127.301073334538, 1132.1839650232505, 10793.946030269877, 10983.0, 10988.175886808522, 11010.944945275303, 11027.944860275727, 4345.8261669533495, 4387.012922092504, 4399.054203346232, 4455.1980643484485, 4457.7548234846745, 9532.237421006303, 9535.284853636005, 9541.761455963517, 9550.188234000188, 9571.952140239255, 4795.95204047962, 4800.255960326155, 4821.108095002436, 4830.792301924519, 4835.395575553056, 4339.63113135387, 4381.890452738643, 4394.670399720034, 4395.7142785718825, 4396.978015109968, 3706.5922748498183, 3731.3470142724914, 3764.2095160016156, 3767.246550689873, 3775.433684947225, 1135.625243669587, 1186.3119390753343, 1187.2994932989577, 1207.8369420128347, 1267.0750352242915, 1188.5958774016876, 1206.3063738350484, 1213.0477575103678, 1437.7699568069058, 1455.0105927969082, 7433.4053275737815, 7447.627618619155, 7757.495762775401, 7767.456278060482, 7792.181820908836, 626.9090981807612, 630.196499463188, 636.2714691678095, 658.233158370493, 792.7265093542718, 5981.790637327673, 6106.786262480792, 6113.38866113394, 6120.1737765401995, 6120.693965301717, 9102.726918192464, 9299.67451139207, 9350.438973661601, 9369.718908432758, 9528.428294302365, 9341.34610577253, 9360.4383736976, 9360.62557497706, 9373.156415922464, 9386.577604007836, 7150.570965742072, 7331.230220826843, 7459.888101678371, 7533.698652053857, 7616.428767842434, 7699.769006929801, 7738.458307918391, 7764.61176941162, 7766.5728384939375, 7793.727219547289, 8477.0, 8541.658333666584, 8716.300321437258, 8735.213830755009, 8745.081766414434, 8668.91331086681, 8715.34634902372, 8754.781130471789, 8757.117219797774, 8875.289976801969, 7282.52663576887, 7348.52234604749, 7363.0, 7367.26327367259, 7381.335679788845, 7848.215178482106, 7865.685372585262, 7925.801854953442, 7934.722284720238, 7940.841183176189, 6614.206295244601, 7357.2642735726, 7371.741989030358, 7391.2239214881665, 7435.8141046474275, 6613.636250006296, 7302.707891684486, 7379.778606641809, 7435.665395057344, 7488.925110748823, 7440.888386674313, 7496.812579685551, 7497.137829149718, 7517.097948246245, 7532.0, 6890.173179218526, 6927.099477067949, 6954.269801670752, 6959.8608027838145, 6972.860542789217, 6547.247066587403, 6636.2700102987665, 6705.631190284581, 6733.461323094239, 6769.323067693192], "unit": "ms", "name": "mootools.html", "value": 4579.2453090699255}, {"lowerIsBetter": false, "replicates": [366.0957435135216, 373.56106574774634, 375.24201113750206, 375.5643453593831, 381.481185587601, 6029.155918171454, 6076.058210977306, 6102.694865256731, 6110.511159107272, 6112.358202388747, 5752.568557358204, 5879.911801322984, 5899.823005309837, 5907.0, 5977.850553736159, 4513.571210734975, 4575.588197062264, 4681.321208424776, 4693.507181745918, 4694.319323698061, 4670.322803193535, 4683.157031734287, 4691.483936766953, 4697.271922851964, 4700.271457924027, 4467.642588592921, 4583.839565615204, 4666.580007799297, 4678.111158879819, 4678.555537223959, 4561.521040290771, 4652.930206046912, 4661.813527458898, 4667.509911459282, 4688.671792974493, 4169.708120431571, 4170.249355116078, 4173.770442625654, 4173.791310434496, 4176.248275310443, 5707.172459993278, 5722.885542289173, 5726.5705072119345, 5727.627704199213, 5731.140328950649, 5344.412114667383, 5419.945800541984, 5435.42927992559, 5474.0, 5493.697846618435, 6315.494760419201, 6342.23893132827, 6347.587406818542, 6358.0462930560325, 6368.29948705642, 4566.54334566544, 4572.3827283317, 4575.062112267011, 4575.336576196466, 4577.33628623851, 6426.0, 6550.803475895731, 6563.901541476882, 6569.211694596631, 6574.145361103026, 4744.383230180124, 4765.213739732905, 4776.713397196179, 4778.713277203379, 4791.880202994953, 4830.565249127525, 4831.758412079382, 4837.516248375135, 4839.903201935942, 4842.22524396102, 5469.945300547023, 5474.042042642602, 5476.822483166138, 5481.232627432163, 5482.972585137049, 6346.873062538723, 6383.616982981036, 6427.58220715652, 6438.742450302029, 6441.291457939623, 1685.9831401686072, 1710.187660861106, 1711.0931206460596, 1711.4437807712543, 1712.8523888994403, 1185.9563584046157, 1187.75057237981, 1192.6422073377953, 1194.9163558550993, 1212.6483319837325, 6176.104464852661, 6178.876422471525, 6185.690715464209, 6188.504919606421, 6191.535634827406, 6595.307492713292, 6626.635535045619, 6628.966855165693, 6630.86738265232, 6644.235912869985, 5780.0, 5983.6708981005595, 6166.568340216142, 6183.876322473526, 6188.195534580475, 3502.2820321833965, 3544.4151714966742, 3547.8580856765957, 3550.55618047744, 3597.6582224688614, 6828.590284582841, 6829.795106146824, 6834.282400347991, 6836.111305530349, 6836.760713375008, 6814.863702725917, 6822.556533825285, 6824.078749368871, 6828.863422731518, 6833.965830170917, 6563.3764792344655, 6776.42400395962, 6803.965980170166, 6823.0, 6825.317468253135, 6619.768308109193, 6671.266160722414, 6671.933280667131, 6673.299303573055, 6678.165229346332, 6455.870882582228, 6575.506836987341, 6584.0, 6589.27517973013, 6590.47276217911, 6791.388775010273, 6800.557963732342, 6803.625800581016, 6809.829754256183, 6813.2846051163915, 4575.039241759135, 4614.353990441274, 4617.284320930261, 4619.491855895916, 4620.861374158781, 6671.299513551007, 6672.6997285121315, 6674.064521288772, 6674.532782705358, 6680.298568650222, 6366.490680745436, 6481.643509607017, 6486.383793539606, 6490.578112422678, 6493.610383377012, 6441.967790161019, 6454.096426500388, 6462.063000864754, 6471.967640161769, 6473.643949582818, 6162.445379915829, 6324.3991820776955, 6343.460805831556, 6378.330275321025, 6387.680615969276, 6503.837404064936, 6530.314316996837, 6535.836604084936, 6538.738450461929, 6544.6727663617585, 6156.353582873734, 6218.751249949952, 6262.436380725757, 6354.3963323484195, 6365.713542890674], "unit": "ms", "name": "prototype.html", "value": 4899.097315673965}, {"lowerIsBetter": false, "replicates": [911.5806728904704, 916.2898753466063, 918.7289749523885, 929.3819609959378, 945.8297506448845, 15241.466548670798, 15657.373705051785, 15746.842531574666, 15750.291236894338, 15760.684786304268, 14689.0, 14788.926055369735, 14799.260036998161, 14836.703265934675, 14855.92572037141, 775.4378075894988, 779.2091027606983, 907.6687009241629, 927.9164875161234, 928.3919033033374, 918.6830543462495, 929.832630126577, 933.4539294512718, 939.5771902643803, 940.261894412886, 947.9526023698822, 957.6121670723368, 959.0265880131672, 959.4291396619001, 959.6017652674132, 806.4999700185894, 812.743985644523, 966.5843687214496, 971.3006635222699, 972.7033254857266, 713.710947066439, 714.5534041224234, 714.7391202211207, 714.9106361704787, 715.0739791969412, 12847.550335738299, 13040.934795325962, 13052.673683157902, 13165.1442656228, 13177.670558236121, 12417.93791031048, 12887.613371598773, 12971.221726696429, 13127.606171814861, 13422.597322080353, 10122.49387530628, 10757.515911783988, 10880.945595272053, 10960.56157753689, 11192.0, 3738.775673459574, 3739.083924438503, 3805.6384643458828, 3837.021559502337, 3869.825857836376, 52061.47938520642, 52307.47692523064, 52534.0, 52594.0, 54369.91260174814, 9440.527973601293, 9527.3807202533, 9537.570809313458, 9538.284628652878, 9583.089606487372, 19172.520686982938, 19199.040047997543, 19202.80797192038, 19242.134103965356, 19263.711044334344, 7765.572893490912, 7778.105517865405, 7796.0, 7870.685172593032, 7966.482178658369, 4246.766427846436, 4275.593818587229, 4278.272693642089, 4324.567543245713, 4417.271150260235, 3120.594322738075, 3160.4311223979903, 3164.920876978094, 3167.5407065975305, 3169.271067654406, 565.1663795901095, 579.3337661689008, 580.982570522885, 594.818580332994, 597.1430996520007, 586.2437455682123, 596.6599038547986, 623.0840664223584, 674.6828990374516, 718.1956209045902, 8422.747317580483, 8633.740987770378, 8673.0, 8953.418027828171, 9285.767855803524, 611.6880391000533, 637.2830565613684, 708.5606923707231, 709.8757717399434, 723.5477826358526, 3848.3457812171996, 3949.1114499238015, 4025.396190571379, 4033.153037862082, 4090.8363665453644, 58839.0, 65332.67333663396, 65593.6720316405, 65727.67136164289, 65756.0, 56576.43423565794, 57435.425645743846, 57866.71066644724, 57884.0, 58366.41633583695, 50830.74584627053, 50961.49038509642, 52362.21456678076, 52455.73772131115, 53049.2042619361, 8601.741947741577, 8840.646374144962, 9006.279497640042, 9100.22648074921, 9138.908610913806, 39198.6080139195, 39239.215215696095, 40113.39829902612, 40394.59605403908, 40504.392434112924, 47216.7639161802, 48386.75806620944, 51731.741341293055, 52185.0, 52262.47737522728, 12207.145499814927, 12264.32546209967, 12328.137030407785, 12466.002719782215, 12723.0, 11383.846695284168, 11587.073034157078, 12399.25604463735, 12576.559820406608, 12748.107632465639, 11313.094952403624, 11416.143789216008, 11461.713457163638, 11679.532818687157, 11927.0, 11107.944460277648, 11723.35521546289, 11875.940620296844, 11939.0, 12316.692082697646, 11099.50052247667, 11104.5558177672, 11324.773504529698, 11389.373584452604, 11656.592019279284, 9849.162821160282, 10133.64532241368, 10357.792844142925, 10605.0, 10617.681469555926, 8982.55639698681, 9918.206543476648, 9940.502974851373, 10259.57849633812, 10339.534720937727], "unit": "ms", "name": "yui.html", "value": 6703.109255374163}], "name": "dromaeo_css", "value": 7287.4773200627615}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [107.0, 109.0, 102.0, 110.0, 109.0, 110.0, 98.0, 109.0, 109.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 107.5}, {"lowerIsBetter": true, "replicates": [153.0, 123.0, 147.0, 165.0, 121.0, 147.0, 146.0, 120.0, 161.0, 120.0], "unit": "ms", "name": "audio-beat-detection", "value": 140.3}, {"lowerIsBetter": true, "replicates": [159.0, 161.0, 160.0, 159.0, 160.0, 160.0, 160.0, 161.0, 158.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 159.8}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 72.0, 154.0, 72.0, 71.0, 71.0, 71.0, 152.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 87.7}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 141.0, 92.0, 92.0, 93.0, 136.0, 92.0, 93.0, 140.0], "unit": "ms", "name": "audio-oscillator", "value": 106.4}, {"lowerIsBetter": true, "replicates": [108.0, 108.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 108.8}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [59.0, 55.0, 56.0, 55.0, 56.0, 55.0, 56.0, 58.0, 54.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 55.8}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 64.0, 64.0, 63.0, 64.0, 64.0, 64.0, 63.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.7}, {"lowerIsBetter": true, "replicates": [77.0, 77.0, 86.0, 78.0, 77.0, 85.0, 78.0, 78.0, 86.0, 79.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 80.1}, {"lowerIsBetter": true, "replicates": [118.0, 115.0, 113.0, 113.0, 114.0, 116.0, 120.0, 120.0, 121.0, 112.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 116.2}, {"lowerIsBetter": true, "replicates": [137.0, 145.0, 146.0, 154.0, 146.0, 134.0, 145.0, 149.0, 145.0, 133.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.4}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 73.0, 65.0, 65.0, 63.0, 64.0, 64.0, 63.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.9}], "name": "kraken", "value": 1475.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.33601070950468], "unit": "score", "name": "Richards", "value": 210.96475200000003}, {"lowerIsBetter": false, "replicates": [167.19612104999163], "unit": "score", "name": "DeltaBlue", "value": 395.4517579999999}, {"lowerIsBetter": false, "replicates": [278.31895352073474], "unit": "score", "name": "Encrypt", "value": 956.3883330000003}, {"lowerIsBetter": false, "replicates": [5107.142857142857], "unit": "score", "name": "Decrypt", "value": 52.119356643356625}, {"lowerIsBetter": false, "replicates": [956.0229445506692], "unit": "score", "name": "RayTrace", "value": 774.0284939999998}, {"lowerIsBetter": false, "replicates": [540.8328826392644], "unit": "score", "name": "Earley", "value": 1232.290087}, {"lowerIsBetter": false, "replicates": [10557.894736842105], "unit": "score", "name": "Boyer", "value": 63.12461116650046}, {"lowerIsBetter": false, "replicates": [24142.85714285714], "unit": "score", "name": "RegExp", "value": 37.73310650887576}, {"lowerIsBetter": false, "replicates": [531.9148936170212], "unit": "score", "name": "Splay", "value": 153.20307999999997}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 23255.99200496356}]} 08:31:53 INFO - RETURN: dromaeo_css: 7287.48 08:31:53 INFO - RETURN: kraken: 1475.20 08:31:53 INFO - RETURN: v8_7: 23255.99 08:31:53 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23255.99"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1475.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7287.48"}}} 08:31:53 INFO - Return code: 0 08:31:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:31:53 INFO - # TBPL SUCCESS # 08:31:53 INFO - Running post-action listener: _resource_record_post_action 08:31:53 INFO - Running post-run listener: _resource_record_post_run 08:31:54 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 4096; Write bytes: 516587520; Read time: 176; Write time: 691636 08:31:54 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 251539456; Read time: 0; Write time: 492168 08:31:54 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 4096; Write bytes: 265048064; Read time: 176; Write time: 199468 08:31:54 INFO - Running post-run listener: _upload_blobber_files 08:31:54 INFO - Blob upload gear active. 08:31:54 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:31:54 INFO - Copying logs to upload dir... 08:31:54 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1253.700323 ========= master_lag: 2.78 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-02-01 08:31:57.073583) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-01 08:31:57.076706) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1454343051.506293-281325296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454334446/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010367 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454334446/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.15 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-01 08:31:57.241150) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 08:31:57.241474) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1454343051.506293-281325296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004862 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 08:31:57.258931) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-01 08:31:57.259197) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-01 08:31:57.259470) ========= ========= Total master_lag: 7.54 =========