builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-059 starttime: 1452550589.19 results: success (0) buildid: 20160111115730 builduid: c73354b6e9fa48b68828b8f35b690d83 revision: 3517ff00b87a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 14:16:29.187065) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 14:16:29.187525) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 14:16:29.188094) ========= 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=3a3620fb28aea1604ab609ef000001d2-1452550461.163104-431680944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006546 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 14:16:29.215888) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 14:16:29.216185) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 14:16:29.262351) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 14:16:29.262725) ========= 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=3a3620fb28aea1604ab609ef000001d2-1452550461.163104-431680944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004618 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 14:16:29.312474) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 14:16:29.312857) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 14:16:29.313229) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 14:16:29.313519) ========= 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=3a3620fb28aea1604ab609ef000001d2-1452550461.163104-431680944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-11 14:16:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.7M=0s 2016-01-11 14:16:29 (35.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.152391 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 14:16:29.483239) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 14:16:29.483524) ========= 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=3a3620fb28aea1604ab609ef000001d2-1452550461.163104-431680944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020768 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 14:16:29.534179) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-11 14:16:29.534487) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3517ff00b87a --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 3517ff00b87a --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=3a3620fb28aea1604ab609ef000001d2-1452550461.163104-431680944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-11 14:16:29,805 Setting DEBUG logging. 2016-01-11 14:16:29,806 attempt 1/10 2016-01-11 14:16:29,806 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/3517ff00b87a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-11 14:16:31,056 unpacking tar archive at: mozilla-beta-3517ff00b87a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.924326 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-11 14:16:31.471906) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 14:16:31.472277) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 14:16:31.482805) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 14:16:31.483180) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 14:16:31.483976) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-11 14:16:31.484310) ========= /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=3a3620fb28aea1604ab609ef000001d2-1452550461.163104-431680944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:16:31 INFO - MultiFileLogger online at 20160111 14:16:31 in /builds/slave/test-pgo 14:16:31 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 14:16:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:16:31 INFO - {'append_to_log': False, 14:16:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:16:31 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:16:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:16:31 INFO - 'branch': 'Mozilla-Beta', 14:16:31 INFO - 'buildbot_json_path': 'buildprops.json', 14:16:31 INFO - 'config_files': ('talos/linux_config.py',), 14:16:31 INFO - 'default_actions': ('clobber', 14:16:31 INFO - 'read-buildbot-config', 14:16:31 INFO - 'download-and-extract', 14:16:31 INFO - 'populate-webroot', 14:16:31 INFO - 'create-virtualenv', 14:16:31 INFO - 'install', 14:16:31 INFO - 'run-tests'), 14:16:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:16:31 INFO - 'download_minidump_stackwalk': True, 14:16:31 INFO - 'download_symbols': 'ondemand', 14:16:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:16:31 INFO - 'tooltool.py': '/tools/tooltool.py', 14:16:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:16:31 INFO - '/tools/misc-python/virtualenv.py')}, 14:16:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:16:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:16:31 INFO - 'installer_path': 'installer.exe', 14:16:31 INFO - 'log_level': 'info', 14:16:31 INFO - 'log_name': 'talos', 14:16:31 INFO - 'log_to_console': True, 14:16:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:16:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:16:31 INFO - 'opt_config_files': (), 14:16:31 INFO - 'pip_index': False, 14:16:31 INFO - 'sps_profile': False, 14:16:31 INFO - 'sps_profile_interval': 0, 14:16:31 INFO - 'suite': 'dromaeojs', 14:16:31 INFO - 'system_bits': '32', 14:16:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:16:31 INFO - 'title': 'talos-linux64-ix-059', 14:16:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:16:31 INFO - 'use_talos_json': True, 14:16:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:16:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:16:31 INFO - 'work_dir': 'build'} 14:16:31 INFO - ##### 14:16:31 INFO - ##### Running clobber step. 14:16:31 INFO - ##### 14:16:31 INFO - Running pre-action listener: _resource_record_pre_action 14:16:31 INFO - Running main action method: clobber 14:16:31 INFO - rmtree: /builds/slave/test-pgo/build 14:16:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:16:32 INFO - Running post-action listener: _resource_record_post_action 14:16:32 INFO - ##### 14:16:32 INFO - ##### Running read-buildbot-config step. 14:16:32 INFO - ##### 14:16:32 INFO - Running pre-action listener: _resource_record_pre_action 14:16:32 INFO - Running main action method: read_buildbot_config 14:16:32 INFO - Using buildbot properties: 14:16:32 INFO - { 14:16:32 INFO - "properties": { 14:16:32 INFO - "buildnumber": 72, 14:16:32 INFO - "product": "firefox", 14:16:32 INFO - "script_repo_revision": "production", 14:16:32 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 14:16:32 INFO - "repository": "", 14:16:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 14:16:32 INFO - "buildid": "20160111115730", 14:16:32 INFO - "slavename": "talos-linux64-ix-059", 14:16:32 INFO - "pgo_build": "True", 14:16:32 INFO - "basedir": "/builds/slave/test-pgo", 14:16:32 INFO - "project": "", 14:16:32 INFO - "platform": "ubuntu64_hw", 14:16:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:16:32 INFO - "slavebuilddir": "test", 14:16:32 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 14:16:32 INFO - "branch": "mozilla-beta", 14:16:32 INFO - "repo_path": "releases/mozilla-beta", 14:16:32 INFO - "stage_platform": "linux64-pgo", 14:16:32 INFO - "builduid": "c73354b6e9fa48b68828b8f35b690d83", 14:16:32 INFO - "revision": "3517ff00b87a" 14:16:32 INFO - }, 14:16:32 INFO - "sourcestamp": { 14:16:32 INFO - "repository": "", 14:16:32 INFO - "hasPatch": false, 14:16:32 INFO - "project": "", 14:16:32 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 14:16:32 INFO - "changes": [ 14:16:32 INFO - { 14:16:32 INFO - "category": null, 14:16:32 INFO - "files": [ 14:16:32 INFO - { 14:16:32 INFO - "url": null, 14:16:32 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452542250/firefox-44.0.en-US.linux-x86_64.tar.bz2" 14:16:32 INFO - } 14:16:32 INFO - ], 14:16:32 INFO - "repository": "", 14:16:32 INFO - "rev": "3517ff00b87a", 14:16:32 INFO - "who": "sendchange", 14:16:32 INFO - "when": 1452550544, 14:16:32 INFO - "number": 7444875, 14:16:32 INFO - "comments": "Bug 1236212 - Adjust month number spinner to account for the fact that month is 0-based. r=rnewman, a=ritu", 14:16:32 INFO - "project": "", 14:16:32 INFO - "at": "Mon 11 Jan 2016 14:15:44", 14:16:32 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 14:16:32 INFO - "revlink": "", 14:16:32 INFO - "properties": [ 14:16:32 INFO - [ 14:16:32 INFO - "buildid", 14:16:32 INFO - "20160111115730", 14:16:32 INFO - "Change" 14:16:32 INFO - ], 14:16:32 INFO - [ 14:16:32 INFO - "builduid", 14:16:32 INFO - "c73354b6e9fa48b68828b8f35b690d83", 14:16:32 INFO - "Change" 14:16:32 INFO - ], 14:16:32 INFO - [ 14:16:32 INFO - "pgo_build", 14:16:32 INFO - "True", 14:16:32 INFO - "Change" 14:16:32 INFO - ] 14:16:32 INFO - ], 14:16:32 INFO - "revision": "3517ff00b87a" 14:16:32 INFO - } 14:16:32 INFO - ], 14:16:32 INFO - "revision": "3517ff00b87a" 14:16:32 INFO - } 14:16:32 INFO - } 14:16:32 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452542250/firefox-44.0.en-US.linux-x86_64.tar.bz2. 14:16:32 INFO - Running post-action listener: _resource_record_post_action 14:16:32 INFO - ##### 14:16:32 INFO - ##### Running download-and-extract step. 14:16:32 INFO - ##### 14:16:32 INFO - Running pre-action listener: _resource_record_pre_action 14:16:32 INFO - Running main action method: download_and_extract 14:16:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:32 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452542250/test_packages.json 14:16:32 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452542250/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:16:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452542250/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:16:32 INFO - Downloaded 1270 bytes. 14:16:32 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:16:32 INFO - Using the following test package requirements: 14:16:32 INFO - {u'common': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 14:16:32 INFO - u'cppunittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 14:16:32 INFO - u'firefox-44.0.en-US.linux-x86_64.cppunittest.tests.zip'], 14:16:32 INFO - u'jittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 14:16:32 INFO - u'jsshell-linux-x86_64.zip'], 14:16:32 INFO - u'mochitest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 14:16:32 INFO - u'firefox-44.0.en-US.linux-x86_64.mochitest.tests.zip'], 14:16:32 INFO - u'mozbase': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 14:16:32 INFO - u'reftest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 14:16:32 INFO - u'firefox-44.0.en-US.linux-x86_64.reftest.tests.zip'], 14:16:32 INFO - u'talos': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 14:16:32 INFO - u'firefox-44.0.en-US.linux-x86_64.talos.tests.zip'], 14:16:32 INFO - u'web-platform': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 14:16:32 INFO - u'firefox-44.0.en-US.linux-x86_64.web-platform.tests.zip'], 14:16:32 INFO - u'webapprt': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 14:16:32 INFO - u'xpcshell': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 14:16:32 INFO - u'firefox-44.0.en-US.linux-x86_64.xpcshell.tests.zip']} 14:16:32 INFO - Downloading packages: [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:32 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452542250/firefox-44.0.en-US.linux-x86_64.common.tests.zip 14:16:32 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452542250/firefox-44.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 14:16:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452542250/firefox-44.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:16:39 INFO - Downloaded 22572420 bytes. 14:16:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 14:16:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 14:16:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:16:41 INFO - Return code: 0 14:16:41 INFO - Downloading packages: [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', u'firefox-44.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:16:41 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')]} 14:16:41 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452542250/firefox-44.0.en-US.linux-x86_64.common.tests.zip 14:16:41 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452542250/firefox-44.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 14:16:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452542250/firefox-44.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:16:43 INFO - Downloaded 22572420 bytes. 14:16:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 14:16:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 14:16:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:16:44 INFO - Return code: 0 14:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:44 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452542250/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 14:16:44 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452542250/firefox-44.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 14:16:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452542250/firefox-44.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:16:46 INFO - Downloaded 11131970 bytes. 14:16:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 14:16:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 14:16:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 14:16:46 INFO - Return code: 0 14:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:46 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452542250/firefox-44.0.en-US.linux-x86_64.tar.bz2 14:16:46 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452542250/firefox-44.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2 14:16:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452542250/firefox-44.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:16:58 INFO - Downloaded 56628307 bytes. 14:16:58 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452542250/firefox-44.0.en-US.linux-x86_64.tar.bz2 14:16:58 INFO - mkdir: /builds/slave/test-pgo/properties 14:16:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:16:58 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:16:58 INFO - Contents: 14:16:58 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452542250/firefox-44.0.en-US.linux-x86_64.tar.bz2 14:16:58 INFO - Running post-action listener: _resource_record_post_action 14:16:58 INFO - Running post-action listener: set_extra_try_arguments 14:16:58 INFO - ##### 14:16:58 INFO - ##### Running populate-webroot step. 14:16:58 INFO - ##### 14:16:58 INFO - Running pre-action listener: _resource_record_pre_action 14:16:58 INFO - Running main action method: populate_webroot 14:16:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:16:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:16:58 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 14:16:58 INFO - '../fennec_ids.txt'], 14:16:58 INFO - 'tests': ['tcheck2']}, 14:16:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:16:58 INFO - '--tppagecycles', 14:16:58 INFO - '7'], 14:16:58 INFO - 'tests': ['tsvgm']}}, 14:16:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:16:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:16:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:16:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:16:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:16:58 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:16:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:16:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:58 INFO - 'talos_options': ['--e10s'], 14:16:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:16:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:58 INFO - 'tests': ['damp', 'tps']}, 14:16:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:58 INFO - 'talos_options': ['--e10s'], 14:16:58 INFO - 'tests': ['damp', 'tps']}, 14:16:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:16:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:16:58 INFO - 'other': {'tests': ['a11yr', 14:16:58 INFO - 'ts_paint', 14:16:58 INFO - 'tpaint', 14:16:58 INFO - 'sessionrestore', 14:16:58 INFO - 'sessionrestore_no_auto_restore']}, 14:16:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:16:58 INFO - 'tests': ['a11yr', 14:16:58 INFO - 'ts_paint', 14:16:58 INFO - 'tpaint', 14:16:58 INFO - 'sessionrestore', 14:16:58 INFO - 'sessionrestore_no_auto_restore']}, 14:16:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:16:58 INFO - 'tests': ['a11yr', 14:16:58 INFO - 'ts_paint', 14:16:58 INFO - 'tpaint', 14:16:58 INFO - 'sessionrestore', 14:16:58 INFO - 'sessionrestore_no_auto_restore']}, 14:16:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:16:58 INFO - 'tests': ['a11yr', 14:16:58 INFO - 'ts_paint', 14:16:58 INFO - 'tpaint', 14:16:58 INFO - 'sessionrestore', 14:16:58 INFO - 'sessionrestore_no_auto_restore']}, 14:16:58 INFO - 'other_l64': {'tests': ['a11yr', 14:16:58 INFO - 'ts_paint', 14:16:58 INFO - 'tpaint', 14:16:58 INFO - 'sessionrestore', 14:16:58 INFO - 'sessionrestore_no_auto_restore']}, 14:16:58 INFO - 'other_nol64': {'tests': ['a11yr', 14:16:58 INFO - 'ts_paint', 14:16:58 INFO - 'tpaint', 14:16:58 INFO - 'sessionrestore', 14:16:58 INFO - 'sessionrestore_no_auto_restore']}, 14:16:58 INFO - 'svgr': {'tests': ['tsvgx', 14:16:58 INFO - 'tsvgr_opacity', 14:16:58 INFO - 'tart', 14:16:58 INFO - 'tscrollx', 14:16:58 INFO - 'cart']}, 14:16:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:16:58 INFO - 'tests': ['tsvgx', 14:16:58 INFO - 'tsvgr_opacity', 14:16:58 INFO - 'tart', 14:16:58 INFO - 'tscrollx', 14:16:58 INFO - 'cart']}, 14:16:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:58 INFO - 'tests': ['tp5o']}, 14:16:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:58 INFO - 'talos_options': ['--e10s'], 14:16:58 INFO - 'tests': ['tp5o']}, 14:16:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:58 INFO - 'talos_options': ['--xperf_path', 14:16:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:16:58 INFO - 'tests': ['tp5n']}, 14:16:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:58 INFO - 'talos_options': ['--e10s', 14:16:58 INFO - '--xperf_path', 14:16:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:16:58 INFO - 'tests': ['tp5n']}}, 14:16:58 INFO - 'talos.zip': {'path': '', 14:16:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:16:58 INFO - Running post-action listener: _resource_record_post_action 14:16:58 INFO - ##### 14:16:58 INFO - ##### Running create-virtualenv step. 14:16:58 INFO - ##### 14:16:58 INFO - Running pre-action listener: _resource_record_pre_action 14:16:58 INFO - Running main action method: create_virtualenv 14:16:58 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:16:58 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 14:16:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:16:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:16:58 INFO - Using real prefix '/usr' 14:16:58 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:16:58 INFO - Installing distribute.............................................................................................................................................................................................done. 14:17:00 INFO - Installing pip.................done. 14:17:00 INFO - Return code: 0 14:17:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9661c70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1deb350>, '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 0x1dec250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dec6e0>, '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': '3a3620fb28aea1604ab609ef000001d2-1452550461.163104-431680944', '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 14:17:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 14:17:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:17:00 INFO - Using env: {'DISPLAY': ':0', 14:17:00 INFO - 'HOME': '/home/cltbld', 14:17:00 INFO - 'LANG': 'en_US.UTF-8', 14:17:00 INFO - 'LANGUAGE': 'en_US:en', 14:17:00 INFO - 'LOGNAME': 'cltbld', 14:17:00 INFO - 'MAIL': '/var/mail/cltbld', 14:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:00 INFO - 'MOZ_NO_REMOTE': '1', 14:17:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:00 INFO - 'NO_EM_RESTART': '1', 14:17:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:00 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:00 INFO - 'SHELL': '/bin/bash', 14:17:00 INFO - 'SHLVL': '1', 14:17:00 INFO - 'TERM': 'linux', 14:17:00 INFO - 'TMOUT': '86400', 14:17:00 INFO - 'USER': 'cltbld', 14:17:00 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452550461.163104-431680944', 14:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:00 INFO - '_': '/tools/buildbot/bin/python'} 14:17:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:01 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 14:17:01 INFO - Cleaning up... 14:17:01 INFO - Return code: 0 14:17:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9661c70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1deb350>, '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 0x1dec250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dec6e0>, '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': '3a3620fb28aea1604ab609ef000001d2-1452550461.163104-431680944', '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 14:17:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 14:17:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:17:01 INFO - Using env: {'DISPLAY': ':0', 14:17:01 INFO - 'HOME': '/home/cltbld', 14:17:01 INFO - 'LANG': 'en_US.UTF-8', 14:17:01 INFO - 'LANGUAGE': 'en_US:en', 14:17:01 INFO - 'LOGNAME': 'cltbld', 14:17:01 INFO - 'MAIL': '/var/mail/cltbld', 14:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:01 INFO - 'MOZ_NO_REMOTE': '1', 14:17:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:01 INFO - 'NO_EM_RESTART': '1', 14:17:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:01 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:01 INFO - 'SHELL': '/bin/bash', 14:17:01 INFO - 'SHLVL': '1', 14:17:01 INFO - 'TERM': 'linux', 14:17:01 INFO - 'TMOUT': '86400', 14:17:01 INFO - 'USER': 'cltbld', 14:17:01 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452550461.163104-431680944', 14:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:01 INFO - '_': '/tools/buildbot/bin/python'} 14:17:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:01 INFO - Downloading/unpacking psutil>=0.7.1 14:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:02 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 14:17:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:17:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:17:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:17:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:17:03 INFO - Installing collected packages: psutil 14:17:03 INFO - Running setup.py install for psutil 14:17:03 INFO - building 'psutil._psutil_linux' extension 14:17:03 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 14:17:03 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 14:17:03 INFO - building 'psutil._psutil_posix' extension 14:17:03 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 14:17:03 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 14:17:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:17:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:17:03 INFO - Successfully installed psutil 14:17:03 INFO - Cleaning up... 14:17:03 INFO - Return code: 0 14:17:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:17: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')]} 14:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17: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')]} 14:17:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9661c70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1deb350>, '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 0x1dec250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dec6e0>, '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': '3a3620fb28aea1604ab609ef000001d2-1452550461.163104-431680944', '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 14:17:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 14:17:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:17:03 INFO - Using env: {'DISPLAY': ':0', 14:17:03 INFO - 'HOME': '/home/cltbld', 14:17:03 INFO - 'LANG': 'en_US.UTF-8', 14:17:03 INFO - 'LANGUAGE': 'en_US:en', 14:17:03 INFO - 'LOGNAME': 'cltbld', 14:17:03 INFO - 'MAIL': '/var/mail/cltbld', 14:17:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:03 INFO - 'MOZ_NO_REMOTE': '1', 14:17:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:03 INFO - 'NO_EM_RESTART': '1', 14:17:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:03 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:03 INFO - 'SHELL': '/bin/bash', 14:17:03 INFO - 'SHLVL': '1', 14:17:03 INFO - 'TERM': 'linux', 14:17:03 INFO - 'TMOUT': '86400', 14:17:03 INFO - 'USER': 'cltbld', 14:17:03 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452550461.163104-431680944', 14:17:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:03 INFO - '_': '/tools/buildbot/bin/python'} 14:17:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:17:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:17:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:17:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:17:05 INFO - Installing collected packages: mozsystemmonitor 14:17:05 INFO - Running setup.py install for mozsystemmonitor 14:17:05 INFO - Successfully installed mozsystemmonitor 14:17:05 INFO - Cleaning up... 14:17:05 INFO - Return code: 0 14:17:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:17: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')]} 14:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17: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')]} 14:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9661c70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1deb350>, '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 0x1dec250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dec6e0>, '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': '3a3620fb28aea1604ab609ef000001d2-1452550461.163104-431680944', '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 14:17:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 14:17:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:17:05 INFO - Using env: {'DISPLAY': ':0', 14:17:05 INFO - 'HOME': '/home/cltbld', 14:17:05 INFO - 'LANG': 'en_US.UTF-8', 14:17:05 INFO - 'LANGUAGE': 'en_US:en', 14:17:05 INFO - 'LOGNAME': 'cltbld', 14:17:05 INFO - 'MAIL': '/var/mail/cltbld', 14:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:05 INFO - 'MOZ_NO_REMOTE': '1', 14:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:05 INFO - 'NO_EM_RESTART': '1', 14:17:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:05 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:05 INFO - 'SHELL': '/bin/bash', 14:17:05 INFO - 'SHLVL': '1', 14:17:05 INFO - 'TERM': 'linux', 14:17:05 INFO - 'TMOUT': '86400', 14:17:05 INFO - 'USER': 'cltbld', 14:17:05 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452550461.163104-431680944', 14:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:05 INFO - '_': '/tools/buildbot/bin/python'} 14:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:05 INFO - Downloading/unpacking blobuploader==1.2.4 14:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:07 INFO - Downloading blobuploader-1.2.4.tar.gz 14:17:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:17:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:17:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:17:07 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 14:17:07 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 14:17:07 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 14:17:07 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 14:17:07 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 14:17:07 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 14:17:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:17:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:17:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:17:08 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 14:17:08 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 14:17:08 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 14:17:08 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 14:17:08 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 14:17:08 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 14:17:08 INFO - Downloading docopt-0.6.1.tar.gz 14:17:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:17:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:17:08 INFO - Installing collected packages: blobuploader, requests, docopt 14:17:08 INFO - Running setup.py install for blobuploader 14:17:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:17:08 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:17:08 INFO - Running setup.py install for requests 14:17:08 INFO - Running setup.py install for docopt 14:17:08 INFO - Successfully installed blobuploader requests docopt 14:17:08 INFO - Cleaning up... 14:17:09 INFO - Return code: 0 14:17:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:17: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')]} 14:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17: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')]} 14:17:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9661c70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1deb350>, '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 0x1dec250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dec6e0>, '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': '3a3620fb28aea1604ab609ef000001d2-1452550461.163104-431680944', '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 14:17:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 14:17:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:17:09 INFO - Using env: {'DISPLAY': ':0', 14:17:09 INFO - 'HOME': '/home/cltbld', 14:17:09 INFO - 'LANG': 'en_US.UTF-8', 14:17:09 INFO - 'LANGUAGE': 'en_US:en', 14:17:09 INFO - 'LOGNAME': 'cltbld', 14:17:09 INFO - 'MAIL': '/var/mail/cltbld', 14:17:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:09 INFO - 'MOZ_NO_REMOTE': '1', 14:17:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:09 INFO - 'NO_EM_RESTART': '1', 14:17:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:09 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:09 INFO - 'SHELL': '/bin/bash', 14:17:09 INFO - 'SHLVL': '1', 14:17:09 INFO - 'TERM': 'linux', 14:17:09 INFO - 'TMOUT': '86400', 14:17:09 INFO - 'USER': 'cltbld', 14:17:09 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452550461.163104-431680944', 14:17:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:09 INFO - '_': '/tools/buildbot/bin/python'} 14:17:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:17:09 INFO - Running setup.py (path:/tmp/pip-kppNfQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:17:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:17:09 INFO - Running setup.py (path:/tmp/pip-5SfWal-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:17:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:17:09 INFO - Running setup.py (path:/tmp/pip-8o9eis-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:17:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:17:09 INFO - Running setup.py (path:/tmp/pip-o3t_Cn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:17:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:17:09 INFO - Running setup.py (path:/tmp/pip-wZG2Nb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:17:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:17:09 INFO - Running setup.py (path:/tmp/pip-NzYXsx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:17:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:17:09 INFO - Running setup.py (path:/tmp/pip-B0a2bp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:17:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:17:09 INFO - Running setup.py (path:/tmp/pip-OJpfiT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:17:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:17:09 INFO - Running setup.py (path:/tmp/pip-hfdFt8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:17:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:17:09 INFO - Running setup.py (path:/tmp/pip-ya1f7n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:17:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:17:09 INFO - Running setup.py (path:/tmp/pip-rJcq6n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:17:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:17:10 INFO - Running setup.py (path:/tmp/pip-9AvAF7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:17:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:17:10 INFO - Running setup.py (path:/tmp/pip-gbacQg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:17:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:17:10 INFO - Running setup.py (path:/tmp/pip-sMdF0t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:17:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:17:10 INFO - Running setup.py (path:/tmp/pip-brGAjW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:17:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:17:10 INFO - Running setup.py (path:/tmp/pip-4gRN9j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:17:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:17:10 INFO - Running setup.py (path:/tmp/pip-v13IfN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:17:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:17:10 INFO - Running setup.py install for manifestparser 14:17:10 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:17:10 INFO - Running setup.py install for mozcrash 14:17:10 INFO - Running setup.py install for mozdebug 14:17:10 INFO - Running setup.py install for mozdevice 14:17:10 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:17:10 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:17:10 INFO - Running setup.py install for mozfile 14:17:10 INFO - Running setup.py install for mozhttpd 14:17:11 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:17:11 INFO - Running setup.py install for mozinfo 14:17:11 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:17:11 INFO - Running setup.py install for mozInstall 14:17:11 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:17:11 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:17:11 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:17:11 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:17:11 INFO - Running setup.py install for mozleak 14:17:11 INFO - Running setup.py install for mozlog 14:17:11 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:17:11 INFO - Running setup.py install for moznetwork 14:17:11 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:17:11 INFO - Running setup.py install for mozprocess 14:17:11 INFO - Running setup.py install for mozprofile 14:17:11 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:17:11 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:17:11 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:17:11 INFO - Running setup.py install for mozrunner 14:17:11 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:17:11 INFO - Running setup.py install for mozscreenshot 14:17:12 INFO - Running setup.py install for moztest 14:17:12 INFO - Running setup.py install for mozversion 14:17:12 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:17:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:17:12 INFO - Cleaning up... 14:17:12 INFO - Return code: 0 14:17:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:17: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')]} 14:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17: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')]} 14:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f9661c70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1deb350>, '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 0x1dec250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dec6e0>, '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': '3a3620fb28aea1604ab609ef000001d2-1452550461.163104-431680944', '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 14:17:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 14:17:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 14:17:12 INFO - Using env: {'DISPLAY': ':0', 14:17:12 INFO - 'HOME': '/home/cltbld', 14:17:12 INFO - 'LANG': 'en_US.UTF-8', 14:17:12 INFO - 'LANGUAGE': 'en_US:en', 14:17:12 INFO - 'LOGNAME': 'cltbld', 14:17:12 INFO - 'MAIL': '/var/mail/cltbld', 14:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:12 INFO - 'MOZ_NO_REMOTE': '1', 14:17:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:12 INFO - 'NO_EM_RESTART': '1', 14:17:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:12 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:12 INFO - 'SHELL': '/bin/bash', 14:17:12 INFO - 'SHLVL': '1', 14:17:12 INFO - 'TERM': 'linux', 14:17:12 INFO - 'TMOUT': '86400', 14:17:12 INFO - 'USER': 'cltbld', 14:17:12 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452550461.163104-431680944', 14:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:12 INFO - '_': '/tools/buildbot/bin/python'} 14:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:17:12 INFO - Running setup.py (path:/tmp/pip-ISRFch-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:17:12 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)) 14:17:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:17:12 INFO - Running setup.py (path:/tmp/pip-EQy34d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:17:12 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)) 14:17:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:17:12 INFO - Running setup.py (path:/tmp/pip-pxPxbi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:17:12 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)) 14:17:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:17:12 INFO - Running setup.py (path:/tmp/pip-w96MO0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:17:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:17:12 INFO - Running setup.py (path:/tmp/pip-HCrGdj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:17:12 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)) 14:17:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:17:12 INFO - Running setup.py (path:/tmp/pip-iZu12Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:17:12 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)) 14:17:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:17:12 INFO - Running setup.py (path:/tmp/pip-CKHPWC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 14:17:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:17:12 INFO - Running setup.py (path:/tmp/pip-Yo37FY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:17:13 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)) 14:17:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:17:13 INFO - Running setup.py (path:/tmp/pip-p_HAu3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:17:13 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)) 14:17:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:17:13 INFO - Running setup.py (path:/tmp/pip-JLFALM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:17:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:17:13 INFO - Running setup.py (path:/tmp/pip-2nPrvu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:17:13 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)) 14:17:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:17:13 INFO - Running setup.py (path:/tmp/pip-doemvu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:17:13 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)) 14:17:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:17:13 INFO - Running setup.py (path:/tmp/pip-ViMA2F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:17:13 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)) 14:17:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:17:13 INFO - Running setup.py (path:/tmp/pip-QFCD0z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:17:13 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)) 14:17:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:17:13 INFO - Running setup.py (path:/tmp/pip-zh2kuK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:17:13 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)) 14:17:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:17:13 INFO - Running setup.py (path:/tmp/pip-ciMG9N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:17:13 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)) 14:17:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:17:13 INFO - Running setup.py (path:/tmp/pip-MFBmHi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:17:13 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)) 14:17:13 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)) 14:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:17:13 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)) 14:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:17:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:15 INFO - Downloading blessings-1.5.1.tar.gz 14:17:15 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 14:17:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:17:15 INFO - Installing collected packages: blessings 14:17:15 INFO - Running setup.py install for blessings 14:17:15 INFO - Successfully installed blessings 14:17:15 INFO - Cleaning up... 14:17:15 INFO - Return code: 0 14:17:15 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:17:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:17:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:17:15 INFO - Reading from file tmpfile_stdout 14:17:15 INFO - Current package versions: 14:17:15 INFO - argparse == 1.2.1 14:17:15 INFO - blessings == 1.5.1 14:17:15 INFO - blobuploader == 1.2.4 14:17:15 INFO - docopt == 0.6.1 14:17:15 INFO - manifestparser == 1.1 14:17:15 INFO - mozInstall == 1.12 14:17:15 INFO - mozcrash == 0.16 14:17:15 INFO - mozdebug == 0.1 14:17:15 INFO - mozdevice == 0.46 14:17:15 INFO - mozfile == 1.2 14:17:15 INFO - mozhttpd == 0.7 14:17:15 INFO - mozinfo == 0.8 14:17:15 INFO - mozleak == 0.1 14:17:15 INFO - mozlog == 3.0 14:17:15 INFO - moznetwork == 0.27 14:17:15 INFO - mozprocess == 0.22 14:17:15 INFO - mozprofile == 0.27 14:17:15 INFO - mozrunner == 6.11 14:17:15 INFO - mozscreenshot == 0.1 14:17:15 INFO - mozsystemmonitor == 0.0 14:17:15 INFO - moztest == 0.7 14:17:15 INFO - mozversion == 1.4 14:17:15 INFO - psutil == 3.1.1 14:17:15 INFO - requests == 1.2.3 14:17:15 INFO - wsgiref == 0.1.2 14:17:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f9661c70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1deb350>, '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 0x1dec250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dec6e0>, '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': '3a3620fb28aea1604ab609ef000001d2-1452550461.163104-431680944', '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 14:17:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 14:17:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:17:15 INFO - Using env: {'DISPLAY': ':0', 14:17:15 INFO - 'HOME': '/home/cltbld', 14:17:15 INFO - 'LANG': 'en_US.UTF-8', 14:17:15 INFO - 'LANGUAGE': 'en_US:en', 14:17:15 INFO - 'LOGNAME': 'cltbld', 14:17:15 INFO - 'MAIL': '/var/mail/cltbld', 14:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:15 INFO - 'MOZ_NO_REMOTE': '1', 14:17:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:15 INFO - 'NO_EM_RESTART': '1', 14:17:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:15 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:15 INFO - 'SHELL': '/bin/bash', 14:17:15 INFO - 'SHLVL': '1', 14:17:15 INFO - 'TERM': 'linux', 14:17:15 INFO - 'TMOUT': '86400', 14:17:15 INFO - 'USER': 'cltbld', 14:17:15 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452550461.163104-431680944', 14:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:15 INFO - '_': '/tools/buildbot/bin/python'} 14:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:16 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)) 14:17:16 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)) 14:17:16 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)) 14:17:16 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)) 14:17:16 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)) 14:17:16 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)) 14:17:16 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)) 14:17:16 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)) 14:17:16 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)) 14:17:16 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)) 14:17:16 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)) 14:17:16 INFO - Cleaning up... 14:17:16 INFO - Return code: 0 14:17:16 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9661c70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1deb350>, '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 0x1dec250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dec6e0>, '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': '3a3620fb28aea1604ab609ef000001d2-1452550461.163104-431680944', '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 14:17:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 14:17:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:17:16 INFO - Using env: {'DISPLAY': ':0', 14:17:16 INFO - 'HOME': '/home/cltbld', 14:17:16 INFO - 'LANG': 'en_US.UTF-8', 14:17:16 INFO - 'LANGUAGE': 'en_US:en', 14:17:16 INFO - 'LOGNAME': 'cltbld', 14:17:16 INFO - 'MAIL': '/var/mail/cltbld', 14:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:16 INFO - 'MOZ_NO_REMOTE': '1', 14:17:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:16 INFO - 'NO_EM_RESTART': '1', 14:17:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:16 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:16 INFO - 'SHELL': '/bin/bash', 14:17:16 INFO - 'SHLVL': '1', 14:17:16 INFO - 'TERM': 'linux', 14:17:16 INFO - 'TMOUT': '86400', 14:17:16 INFO - 'USER': 'cltbld', 14:17:16 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452550461.163104-431680944', 14:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:16 INFO - '_': '/tools/buildbot/bin/python'} 14:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:16 INFO - Downloading/unpacking jsonschema 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:17:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 14:17:18 INFO - Downloading/unpacking functools32 (from jsonschema) 14:17:18 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 14:17:18 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 14:17:18 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 14:17:18 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 14:17:18 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 14:17:18 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 14:17:18 INFO - Downloading functools32-3.2.3-2.tar.gz 14:17:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 14:17:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:17:18 INFO - warning: no files found matching '*.txt' 14:17:18 INFO - no previously-included directories found matching 'build' 14:17:18 INFO - no previously-included directories found matching 'dist' 14:17:18 INFO - no previously-included directories found matching '.git*' 14:17:18 INFO - Installing collected packages: jsonschema, functools32 14:17:18 INFO - Running setup.py install for functools32 14:17:18 INFO - warning: no files found matching '*.txt' 14:17:18 INFO - no previously-included directories found matching 'build' 14:17:18 INFO - no previously-included directories found matching 'dist' 14:17:18 INFO - no previously-included directories found matching '.git*' 14:17:18 INFO - Successfully installed jsonschema functools32 14:17:18 INFO - Cleaning up... 14:17:18 INFO - Return code: 0 14:17:18 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:17:18 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')]} 14:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:18 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')]} 14:17:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9661c70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1deb350>, '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 0x1dec250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dec6e0>, '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': '3a3620fb28aea1604ab609ef000001d2-1452550461.163104-431680944', '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 14:17:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 14:17:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:17:18 INFO - Using env: {'DISPLAY': ':0', 14:17:18 INFO - 'HOME': '/home/cltbld', 14:17:18 INFO - 'LANG': 'en_US.UTF-8', 14:17:18 INFO - 'LANGUAGE': 'en_US:en', 14:17:18 INFO - 'LOGNAME': 'cltbld', 14:17:18 INFO - 'MAIL': '/var/mail/cltbld', 14:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:18 INFO - 'MOZ_NO_REMOTE': '1', 14:17:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:18 INFO - 'NO_EM_RESTART': '1', 14:17:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:18 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:18 INFO - 'SHELL': '/bin/bash', 14:17:18 INFO - 'SHLVL': '1', 14:17:18 INFO - 'TERM': 'linux', 14:17:18 INFO - 'TMOUT': '86400', 14:17:18 INFO - 'USER': 'cltbld', 14:17:18 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452550461.163104-431680944', 14:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:18 INFO - '_': '/tools/buildbot/bin/python'} 14:17:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:18 INFO - Downloading/unpacking flake8 14:17:18 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 14:17:18 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 14:17:18 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 14:17:18 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 14:17:18 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 14:17:18 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 14:17:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:17:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 14:17:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:17:20 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 14:17:20 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 14:17:20 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 14:17:20 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 14:17:20 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 14:17:20 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 14:17:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:17:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 14:17:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:17:20 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 14:17:20 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 14:17:20 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 14:17:20 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 14:17:20 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 14:17:20 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 14:17:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 14:17:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:17:20 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 14:17:20 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 14:17:20 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 14:17:20 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 14:17:20 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 14:17:20 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 14:17:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 14:17:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:17:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:17:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:17:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:17:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:17:21 INFO - no previously-included directories found matching 'docs/_build' 14:17:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:17:21 INFO - Running setup.py install for pep8 14:17:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:17:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:17:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:17:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:17:21 INFO - no previously-included directories found matching 'docs/_build' 14:17:21 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:17:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:17:21 INFO - Cleaning up... 14:17:21 INFO - Return code: 0 14:17:21 INFO - Running post-action listener: _resource_record_post_action 14:17:21 INFO - Running post-action listener: _start_resource_monitoring 14:17:21 INFO - Starting resource monitoring. 14:17:21 INFO - ##### 14:17:21 INFO - ##### Running install step. 14:17:21 INFO - ##### 14:17:21 INFO - Running pre-action listener: _resource_record_pre_action 14:17:21 INFO - Running main action method: install 14:17:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:17:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:17:21 INFO - Reading from file tmpfile_stdout 14:17:21 INFO - Detecting whether we're running mozinstall >=1.0... 14:17:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:17:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:17:21 INFO - Reading from file tmpfile_stdout 14:17:21 INFO - Output received: 14:17:21 INFO - Usage: mozinstall [options] installer 14:17:21 INFO - Options: 14:17:21 INFO - -h, --help show this help message and exit 14:17:21 INFO - -d DEST, --destination=DEST 14:17:21 INFO - Directory to install application into. [default: 14:17:21 INFO - "/builds/slave/test-pgo"] 14:17:21 INFO - --app=APP Application being installed. [default: firefox] 14:17:21 INFO - mkdir: /builds/slave/test-pgo/build/application 14:17:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 14:17:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 14:17:35 INFO - Reading from file tmpfile_stdout 14:17:35 INFO - Output received: 14:17:35 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:17:35 INFO - Running post-action listener: _resource_record_post_action 14:17:35 INFO - ##### 14:17:35 INFO - ##### Running run-tests step. 14:17:35 INFO - ##### 14:17:35 INFO - Running pre-action listener: _resource_record_pre_action 14:17:35 INFO - Running main action method: run_tests 14:17:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:17:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:17:35 INFO - Python 2.7.3 14:17:35 INFO - Return code: 0 14:17:35 INFO - grabbing minidump binary from tooltool 14:17:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:35 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 0x1deb350>, '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 0x1dec250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dec6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:17:35 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 14:17:35 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 14:17:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:17:35 INFO - Return code: 0 14:17:35 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:17:35 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:17:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:17:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:17:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:17:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:17:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:17:36 INFO - Return code: 0 14:17:36 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/1452542250/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 14:17:36 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/1452542250/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost 14:17:36 INFO - Using env: {'DISPLAY': ':0', 14:17:36 INFO - 'HOME': '/home/cltbld', 14:17:36 INFO - 'LANG': 'en_US.UTF-8', 14:17:36 INFO - 'LANGUAGE': 'en_US:en', 14:17:36 INFO - 'LOGNAME': 'cltbld', 14:17:36 INFO - 'MAIL': '/var/mail/cltbld', 14:17:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:17:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:36 INFO - 'MOZ_NO_REMOTE': '1', 14:17:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:17:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:36 INFO - 'NO_EM_RESTART': '1', 14:17:36 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:36 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:36 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:17:36 INFO - 'SHELL': '/bin/bash', 14:17:36 INFO - 'SHLVL': '1', 14:17:36 INFO - 'TERM': 'linux', 14:17:36 INFO - 'TMOUT': '86400', 14:17:36 INFO - 'USER': 'cltbld', 14:17:36 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452550461.163104-431680944', 14:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:36 INFO - '_': '/tools/buildbot/bin/python'} 14:17:36 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/1452542250/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost'] with output_timeout 3600 14:17:37 INFO - mozversion INFO | application_buildid: 20160111115730 14:17:37 INFO - mozversion INFO | application_changeset: 3517ff00b87a27e55af244e353ef7607a0264639 14:17:37 INFO - mozversion INFO | application_display_name: Nightly 14:17:37 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:17:37 INFO - mozversion INFO | application_name: Firefox 14:17:37 INFO - mozversion INFO | application_remotingname: firefox 14:17:37 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:17:37 INFO - mozversion INFO | application_vendor: Mozilla 14:17:37 INFO - mozversion INFO | application_version: 44.0 14:17:37 INFO - mozversion INFO | platform_buildid: 20160111115730 14:17:37 INFO - mozversion INFO | platform_changeset: 3517ff00b87a27e55af244e353ef7607a0264639 14:17:37 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:17:37 INFO - mozversion INFO | platform_version: 44.0 14:17:37 INFO - 2016-01-11 14:17:37,041 DEBUG : using testdate: 1452550657 14:17:37 INFO - 2016-01-11 14:17:37,041 DEBUG : actual date: 1452550657 14:17:37 INFO - 2016-01-11 14:17:37,051 INFO : starting webserver on 'localhost:37165' 14:17:37 INFO - 2016-01-11 14:17:37,052 INFO : Starting test suite talos-linux64-ix-059 14:17:37 INFO - 2016-01-11 14:17:37,052 INFO : Starting test dromaeo_css 14:17:37 INFO - 2016-01-11 14:17:37,052 DEBUG : operating with platform_type : linux_ 14:17:37 INFO - 2016-01-11 14:17:37,053 INFO : Initialising browser for dromaeo_css test... 14:17:37 INFO - 2016-01-11 14:17:37,069 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQWp3iM/profile http://localhost:37165/getInfo.html 14:17:40 INFO - 2016-01-11 14:17:40,623 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:17:40 INFO - 2016-01-11 14:17:40,623 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:17:40 INFO - 2016-01-11 14:17:40,623 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:17:40 INFO - 2016-01-11 14:17:40,623 DEBUG : BROWSER_OUTPUT: __metrics 14:17:40 INFO - 2016-01-11 14:17:40,719 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] 14:17:41 INFO - 2016-01-11 14:17:41,959 INFO : Browser initialized. 14:17:41 INFO - 2016-01-11 14:17:41,959 INFO : Running cycle 1/1 for dromaeo_css test... 14:17:41 INFO - 2016-01-11 14:17:41,960 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQWp3iM/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:17:53 INFO - 2016-01-11 14:17:53,468 DEBUG : BROWSER_OUTPUT: RSS: Main: 129019904 14:17:53 INFO - 2016-01-11 14:17:53,469 DEBUG : BROWSER_OUTPUT: 14:18:44 INFO - 2016-01-11 14:18:44,249 DEBUG : BROWSER_OUTPUT: 1452550724248 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] 14:20:52 INFO - 2016-01-11 14:20:52,355 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37165/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37165/tests/dromaeo/cssquery-ext.html) 14:20:53 INFO - 2016-01-11 14:20:53,423 DEBUG : BROWSER_OUTPUT: RSS: Main: 236797952 14:20:53 INFO - 2016-01-11 14:20:53,423 DEBUG : BROWSER_OUTPUT: 14:23:55 INFO - 2016-01-11 14:23:55,429 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37165/tests/dromaeo/cssquery-ext.html (next: http://localhost:37165/tests/dromaeo/cssquery-jquery.html) 14:23:55 INFO - 2016-01-11 14:23:55,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 208183296 14:23:55 INFO - 2016-01-11 14:23:55,990 DEBUG : BROWSER_OUTPUT: 14:26:57 INFO - 2016-01-11 14:26:57,756 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37165/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37165/tests/dromaeo/cssquery-mootools.html) 14:26:58 INFO - 2016-01-11 14:26:58,329 DEBUG : BROWSER_OUTPUT: RSS: Main: 193978368 14:26:58 INFO - 2016-01-11 14:26:58,329 DEBUG : BROWSER_OUTPUT: 14:29:59 INFO - 2016-01-11 14:29:59,990 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37165/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37165/tests/dromaeo/cssquery-prototype.html) 14:30:00 INFO - 2016-01-11 14:30:00,554 DEBUG : BROWSER_OUTPUT: RSS: Main: 190029824 14:30:00 INFO - 2016-01-11 14:30:00,554 DEBUG : BROWSER_OUTPUT: 14:33:02 INFO - 2016-01-11 14:33:02,798 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37165/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37165/tests/dromaeo/cssquery-yui.html) 14:33:03 INFO - 2016-01-11 14:33:03,384 DEBUG : BROWSER_OUTPUT: RSS: Main: 192819200 14:33:03 INFO - 2016-01-11 14:33:03,384 DEBUG : BROWSER_OUTPUT: 14:36:05 INFO - 2016-01-11 14:36:05,582 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37165/tests/dromaeo/cssquery-yui.html (next: http://localhost:37165/tests/dromaeo/cssquery-dojo.html) 14:36:05 INFO - 2016-01-11 14:36:05,832 DEBUG : BROWSER_OUTPUT: RSS: Main: 234631168 14:36:05 INFO - 2016-01-11 14:36:05,833 DEBUG : BROWSER_OUTPUT: 14:36:05 INFO - 2016-01-11 14:36:05,834 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:36:05 INFO - 2016-01-11 14:36:05,834 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:36:05 INFO - 2016-01-11 14:36:05,834 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:36:05 INFO - 2016-01-11 14:36:05,834 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:36:05 INFO - 2016-01-11 14:36:05,836 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3309.7517686173537;3394.456886898097;3416.5900091988965;3421.640727723589;3449.517067610534;5606.299212598426;5612.494875461208;5614.382417934029;5631.18347839563;5643;5645.125005624135;5654.095344744842;5655.0386434306165;5656.377798442168;5670;5014.648974571782;5111.284420181169;5114.335136432259;5225.921611175835;5250.947490525104;5028.296038554606;5110.718910459923;5121.641485096045;5152.330197074375;5211.739413029352;5245.082110630643;5265.394479634833;5273.736313184345;5279.868003299929;5296.179092240709;4905.558499735041;5193.195054766517;5195.766190521435;5268.0780863348955;5276.314079169702;5059.3169922060415;5120.180771076647;5175.585953123778;5188.610854185951;5221.112410890158;5484.808031718911;5485.670859748388;5501.174823776426;5501.972490137564;5503.036968530491;5941.55438342126;6114.021756518936;6115.541334399938;6121.540884433641;6122.908156377658;6019.367966363557;6086.726097325631;6143.232095988002;6160.907586386208;6161.353057928943;5798.362180160179;5809.302883653989;5809.651420914716;5811.128330750421;5825;5980.312264089598;6087.878242435127;6285.717142728588;6294.213223347082;6294.276158241769;5923;6015.849603759853;6022.18700475439;6028.09578563219;6039.7282122304605;5965.701714914324;6009.399060093956;6010.4891084258325;6020.57855950088;6054;5862.648241105548;6004.699765011732;6025.307089684742;6048.848778780478;6129.08063790435;6081.969590152109;6141.686823742543;6153.876922461615;6166.167567378437;6170.784022559189;4707.03505781314;4709.034647897173;4711.528847115261;4721.527847215251;4733.029728905566;4066.5933406659688;4140.648044916215;4170.582941705866;4208.9898424377925;4222.282212023963;5822.621529600562;5863.237779088691;5871.735771890275;5876.353601103875;5879.52963762898;6198.969005154945;6218.968905155445;6221.657808820558;6222.160008398808;6229.221347331583;5556.222128901957;5657.2928383952;5794.333651630032;5895.705214739246;5897.941020589825;5306.416294207711;5308.044551980681;5310.7610157543;5319.414864364917;5319.46805319465;6111.908321375183;6318.873622527523;6325.462335701425;6330.968345158245;6332.873342533216;5951.732172052355;6047.516198704006;6058.757649693963;6066.332703402534;6072.271327440735;6252.781152659635;6270.49836013127;6311.652859092794;6315.242170939517;6315.463185629273;5711.657300561979;5835.503982161564;6034.426729460694;6043.486303664238;6047.727852246748;5996.580239383201;6107.159036036683;6110.432506543687;6114.639512664841;6114.883574732085;5928.288605367384;5980.760769569169;5983.730732117152;5984.640921544721;5993;5788.21859049023;5802.709864506842;5916.526677865674;5954.583179177589;6036.336003039574;5854;5927.762889484372;5928.762849486145;5931.406859314034;5986.281646202309;5921.2006379138265;5958.195643588234;5966.880662386641;5996.670183139795;6010.669413182317;5635.323761148688;5761.971190144022;5790.392008839011;5886.999210134201;5914.645121292736 14:36:05 INFO - 2016-01-11 14:36:05,839 DEBUG : BROWSER_OUTPUT: |1;ext.html;585.913131141732;612.1643956000062;617.2500411999421;624.7376102037146;641.6182371488962;43418.782906085464;44709.77645111778;44770.77614611931;44850.32724509131;44944.77527612361;47326.526734732644;47700;47858.76070619642;47947.28079078808;47971.760141199244;8172.18278172184;8314.376421768362;9358.812823743505;9527.666531671393;10799.352038877692;11083.501242444068;11200;11207.21549491536;11208.66374008781;11210.551577936872;11120.666380008613;11230.943845280763;11241.943790281037;11243.66269011931;11249.043831274352;11077.667669969873;11147.219694621379;11169.273997190237;11184.720381990433;11192.216544841864;10970.890291097146;11014.339139651647;11016.614418495394;11105.278156919856;11118.054965327958;44562.554374456486;45149;45237.547624523664;45264.32103518417;45297.320540191926;3698.223373091654;3715.7213209009433;3744.794036328001;3824.617538246181;4014.859479918218;33712.15719607029;34018.149546261295;34020.82989585061;34051;34055.14862128442;4009.3384591542363;4016.879493615196;4045.7572545647063;4087.346024636044;4164.8125834337225;334812.99999999756;335048;335148.99999999756;335210;335315;66971.33028669651;67767.66116169388;67889.6055197248;68063;68101;70974.64512677403;71351;71536;71552;71584;18816.341428050226;19360.8063919359;19366.322178723676;19375.4187374379;19395.806041939682;14414.927925360305;14507.419703211754;14526.564203073925;14563.708725825423;14671.119732816065;21194.364169074954;21561.353159405244;21584.352469425943;21584.568308633738;21630.459238518848;8111.010654505308;8301.543415112226;8318.45930014547;8348.165183481724;8352.498850068894;1011.0900189829213;1080.3032044331362;1084.0622861224983;1088.804015277242;1152.8213126965165;30597.585812925692;30600.234994125323;30671.539926901114;30846;31259.531107033414;978.6379039755336;1068.4774196769572;1125.352922069813;1132.8527291452058;1146.295028557448;13540;14553.002135316501;14760.184328127802;15028.624284392978;15418.691626167638;374862;381786;382158;382933;383209;57982.7100864493;58211.41788582144;58364;58445.70777146087;58449;1379.7378498085332;1468.1338010573813;1489.1809504772332;1522.0639306826222;1540.1375229871308;28438.289042773267;28491.145265641233;28621.99823006268;28992.42015159727;29498.852505737334;62253.37746622657;63618.68190659017;63645.363546363944;63667.68166159139;63697;325340.373298132;328103;328284;328777;329735;35175.82412087923;35730.64269357273;35872.4619130708;35945.64054359528;36320.63679363278;48818.26772598485;49788.004239915725;49826.50173498219;50258.748706256236;50739.49260507496;40293;41141.58858411378;41373;45337.773311133235;46260.7686961563;40724.389134163604;40939.38590921079;41009;41610;41614.37578436265;39980.80009599934;40740.79629601833;40910.386344204264;41121;41167.38248926208;34915.30169396547;34993.12517187091;35278.118047048;35821.46267805933;36148.27703445969;27513.862430687717;27702.72297277082;27790.583141252493;27932.86033569819;27971 14:36:05 INFO - 2016-01-11 14:36:05,840 DEBUG : BROWSER_OUTPUT: |2;jquery.html;387.06246183544425;387.6433681013467;392.1490365905985;396.28668396885615;396.7104014069729;15728.685426291497;16136.435224767107;18625;18720.719189212155;19023.904880475595;18900.527486812804;19008.524786880334;19054.904725476386;19394.51513712158;19409.514762130955;5647.181158731992;5798.739056742456;5808.59339846211;5815.127730840365;5817.243758311413;3949.605039496056;4426.336049592554;5753.338366087891;6335.3981371769605;6342.238931328247;6129.724162412702;6260.18617579714;6272.843178920518;6291.905621415683;6312.589681670676;6228.408301211378;6290.842728931791;6296.307406185316;6301.6534090625;6347.650879201642;5523.8066667666435;5528.861778455571;5605.2713147291;5612.522935550483;5613.410591887875;22782.65826012611;22952.77047229523;22973.425664358358;23148.305550833502;23246.186383476666;2064.9070791814406;2231.62062449384;2237.5077482953725;2267.4331417145713;2391.414103544643;10544.683659490227;10624.628138015132;10827.296225745302;10857.131429485622;10934.726631834188;1746.2752957522614;1813.1659436659152;1816.0828781465275;1834.257125864027;1839.5217243516781;67125;68794;69513.3048669517;70406.29593704049;71085;7891.881621775678;7941.126476087626;7963.920360796434;7992.880106798402;8025.157358477276;9615.375000625078;9644.565994530123;9647.13175814166;9654.662086826927;9655.613775448903;6497.5126865484335;6568.737250510022;6593.505487088391;6618.106555615027;6625.966870165618;6908.240093589701;6909.7581584644295;6913.827154321081;6952.860942781116;6968.616726080013;3606.8196590170387;3641.0715267606593;3645.872394466181;3670.944935825965;3671.9265614688093;1260.949562017509;1280.481405030964;3117.0413574760382;3147.889823856154;3206.422843888076;534.2813915283937;535.9839204823861;542.2598153520416;563.6364544868619;566.6883214232156;11549.249298795552;12983;13014.544490942772;13125.34373281332;13597.048206625639;551.2227758859988;555.0425515984894;562.2662425534717;568.1364326224116;570.8744076303207;7115.324044215791;7132.643367831588;7255.45584081196;7332.340089391873;7540.773776786705;597751;598224;600482;628007;631624;86601.56699216463;88176.559117204;88991;89483.55258223668;89738;635.1393861317848;648.5913874259187;649.7141257846532;649.7693318871827;651.260818970472;12408.193467424588;12636.87363126357;12639.241645501299;12750.234985900875;12805.8079128815;39157.2168556633;39248.607513925635;39478.802605986784;40111.59888401079;40512.59487405088;52231.477685222664;52744.73627631837;54010.45989540054;54437;54573.45426545842;7720.884186737091;7754.263344982218;7880.487768295043;7900.051993760785;7902.012248468942;13794.241316727275;14014.649633759238;14042.368093436024;14080.929595351958;14306.499272525412;11896.464659090534;12058.15592908488;12262.877371226174;12289.324087175291;12324.815127772912;11731.178817482694;12016.038716902802;12038.398080096134;12047.277163370225;12105.152639315163;9855.655052073143;10280.177585793268;11466.827997579876;11695.298282103102;11883.82174267404;7599.518093971623;7604.695812167452;7692.307692307719;7700.691972321269;7703.075630924325;11481.540738370706;11731.35477548743;11804.350760708243;11832.11259155584;12108.515659373526 14:36:05 INFO - 2016-01-11 14:36:05,843 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1592.4904030710177;1594.62526306318;1866.4307386247194;1876.9812301876977;1877.6526342626623;7850.332721718653;7935.2461516155945;7997.840043199147;7997.88003179952;8006.239407256316;8104.675812967489;8114.513129212237;8129.878051829227;8140.348772098233;8165.3059489943425;2370.668106465096;2372.9881350593223;2395.940101497459;2397.1490121007055;2406.614941609343;2387.95224095518;2452.558539462896;2465.285067330472;2465.8767061646936;2466.987665061672;1929.3825975687785;1962.0680176915994;2290.8854557272152;2399.3521749127726;2414.577448946436;2361.232599405183;2365.9053637854463;2372.9169479068323;2376.738558758535;2377.7146742390937;2369.7037870266217;2418.093215044358;2420.225527831095;2422.467057247403;2422.5033868057008;6490.188726409199;6640.535162538624;7936.801579960547;8137.796555086111;8142.389320800964;4961.255811628249;5037.0429618372755;5043.697378157322;5048.116579598555;5049.570786483153;3338.749593780476;3364.6971772540587;3399.55805745254;3404.285100128976;3415.8975230743117;1182.3319824299244;1189.227002448407;1203.6810245285008;1224.6326102169314;1236.4621389695421;11090.279131856403;11110.388928608923;11147.442627868655;11150.275232109969;11152.386618735965;4599.839005634787;4601.815927362935;4644.651651126179;4654.418197725285;4673.158831410379;9753.073458021476;9754.756131096638;9763.511824408752;9767.413955162712;9769.413835169913;5162.767675454614;5163.380394352626;5163.457836927144;5165.9225111623355;5169.81905633301;4685.625149987993;4707.95292047082;4711.905761884743;4712.31671407644;4712.95287047132;3936.173403585279;3971.980140099281;3974.880753577397;3999.7400168988925;4015.6185162409524;1301.0827366706449;1303.12690497367;1307.0589175793414;1308.156239225713;1308.2804457548311;1118.3122379736403;1122.1247427006947;1253.1541209683428;1456.3155317000992;1485.3984136424765;7859.567723775247;7885.093214280317;7909.1299957004685;7909.485883417675;7912.960435197787;536.1692481310482;538.7360193505233;545.2802300962691;561.719140429785;563.9971800140974;5691.402402747652;5781.6241944274325;6344.746210151635;6406.103145559626;6419.101325814389;8537.658493660309;8790.252828509649;8823.470591764386;8829.381943264038;8830.249428798625;9233.076692330847;9302.069793020779;9389.530523473799;9503.382280151767;9523.523823808782;7453;7513.962430187814;7526.698932042657;7530.472866899265;7539.547627142389;7628.313451789366;7776.183500732342;7786.649600768093;7828.217178282126;7834.451588388758;8376;8405.49567025956;8512.106228845882;8873.467591944504;8982.640694372152;8498.787530311793;8506.957465212634;8575.742727718178;9183.265338773015;9187.586558604746;7204.603746793977;7274.8908766367485;7280.417566594554;7287.817804554928;7305.305995930378;7821.530708157528;7941.086775020715;7957.482763620346;7974.082980457089;7975.122736499096;7313.451491138292;7585.127710313384;7600.619969001417;7632.38940884739;7678.692852285846;7436.776896693108;7444.739434119996;7469.887951680837;7535.6985720570565;7550.962245188739;7537.133229678438;7627.5042122261875;7632.274933881273;7636.045494313211;7650.120236172911;6932.272111428228;6981.197162326397;6991.685374158277;6996.440284777307;7006.859862802818;6738.797836064926;6824.18109826824;6854.657267136524;6865.038894554867;7163.10461192351 14:36:05 INFO - 2016-01-11 14:36:05,843 DEBUG : BROWSER_OUTPUT: |4;prototype.html;355.7012109827744;356.5543071161049;360.21293473759823;360.3675549410782;360.6988164882324;5993.520518358532;6020.819375418733;6036.426539478748;6052.092186172071;6065.332813390529;5710.942890571093;5791.623544469607;5807.39022402648;5900.616459930102;5926;4638.512956139591;4642.396488456513;4653.441587009555;4661.930071048937;4674.7428891410955;4669.042846216535;4677.368555245032;4681.485036645966;4684.227102528096;4684.718916864982;4613.769311534426;4638.350630911675;4641.419822522184;4644;4644.326572646964;4602.700824446417;4671.416072990876;4689.577937985564;4695.506971767949;4700.694454860441;4157.230912281238;4162.375643653446;4163.292240319153;4167.229062623394;4169.791510424467;5676.035074037423;5681.886362272773;5684.175794509773;5690.48785609293;5695.1741997410145;5316.707581083039;5402.594805389612;5403.837884863421;5415.296011518517;5416.783328666888;6365.013422919455;6365.554411191219;6366.713497892606;6370.1718776558755;6371.936280637227;4631.60631346336;4638.281066434708;4639.6752227344095;4640.2343613303765;4645.883852903705;6496.058071579641;6585.703643336062;6599.241087274977;6602.570832895798;6606.768763093269;4706.929396059062;4748.572628463455;4784.425868895755;4790.952090479121;4799.064182484382;4843.176659967814;4846.321514987904;4846.80612775492;4848.9757551212015;4852.490488498727;5466.453354664502;5467.589930755209;5470.945290547043;5471.151971444432;5471.316085489314;6312.463440607508;6408.00675895237;6408.647524386203;6411.935880641227;6414;1730.2214003698134;1742.5904912345588;1745.4152858792193;1746.8864523805912;1749.212854215608;1129.4635048351968;1169.2399940039043;1198.844150260478;1219.5243854896598;1227.2513766602365;5991.161237426763;6004.639721616717;6012.759489620366;6019.548533859978;6035.577509574376;6377.71300291488;6409.038644203313;6412.070249813751;6419.903701444482;6424;5953.047512397996;6064.181335519736;6065.423784740443;6072.453479186895;6074.726637301332;3572.1783989682;3600.5499312585926;3602.819859007039;3608.332458495187;3608.440691692792;6723;6727.596344219362;6735.124433823572;6736.023276624862;6736.865262694719;6614.7023383947835;6694.59832410057;6696.029075783984;6698.698558564876;6699.698513566901;6750.493712971547;6768.2216545097945;6768.357006084414;6773.254941956381;6778.627175505395;6611.2727599963;6622.271550129578;6623.933760662524;6626.734930602915;6631.1379520662;6472.773452929125;6587.9670601646685;6590.538662293593;6592.077109204811;6596.8350791230605;6787.796366109024;6841.24746277919;6849.794506164823;6853.211880633591;6857.142857142857;4626.1210370029585;4654.371659826015;4660.650451216105;4666.34671146033;4667.113248482778;6516.152900122954;6637.1703537057865;6637.236717777518;6643.30245324234;6644.136262285871;6481.643509607017;6484.5460817742305;6487.513436492188;6487.805365839033;6492.513061520311;6462.321456247214;6463.450606698483;6467.805965821033;6469.547131700924;6479.708413121327;6279.96860015697;6363.268224154096;6371.362863713777;6374.904376434264;6377.617342959252;6498.480121590356;6499.7400103995315;6499.935000650122;6500.674966251763;6506.642134682638;6316.621002739666;6344.270408903035;6345.587536810092;6346.365363463617;6347.460465860454 14:36:05 INFO - 2016-01-11 14:36:05,844 DEBUG : BROWSER_OUTPUT: |5;yui.html;884.48257769205;914.935954483186;915.4004127296623;929.9860502092474;954.1794057110883;15524.301406436709;15845.92077039616;15865.444709435144;15909;15938.681226375465;14500.202488863108;14659.340329685163;14738.189399583018;14767.704645907075;14833.851661483382;782.659543098751;790.016429545217;926.2173463423413;926.4302453990781;952.261996952364;942.580551654514;946.4888959961612;951.2390087929663;952.4142652268839;953.3660116022836;801.5951944268137;993.4337427666234;993.662154867345;995.5719040812447;996.2577879479761;815.5473712089788;962.0667952086465;975.0639386189267;975.3513913247682;980.9558569864373;716.0440811516579;720.1142594608608;723.1033518437152;723.7756295548397;729.773770131261;15174.696506069817;15218.239088045553;15268.694626107526;15403.537893863202;15435.073895566302;13329.733405331936;13841;14064.859351406458;14240.287985600678;14486.058406203563;10658.893411065945;10825.729356766065;10998.175136864767;11437.313761174357;11590.884091159065;3510.666486683761;3514.2620049789575;3526.823658817049;3534.32847758925;3543.5924868639922;52166.21750673743;52680;53159.20261196085;53182.468175318136;53256.73371633156;8186.508809471332;8198.713045043394;8209.384296177692;8262.297704695167;8398.916010839814;13259.337033148304;13281.601551953458;13397.330133493286;13654.86345136536;13734.93132534331;7393.667284972189;7396.3343299103335;7485.887711684329;7620.237976202336;7774.961125194451;4867.6836005660225;4961.454240033593;4968.453470118284;5016.2224855147515;5026.09530284545;3103.4103520331064;3131.2798056447145;3134.279115803378;3136.2316232523176;3139.8430078495985;487.75855951304334;487.75855951304334;488.4773292576909;490.04441339388336;493.11731999720814;729.4565548666278;746.9290417410338;755.1542272654661;759.2255898983007;773.3349319585152;9840.950795245977;10056.145227655585;10118.797624047626;10146.137578305927;10201.693949181536;608.0358253514119;759;779.4349096904699;793.1790596732354;803.6463955859404;4232.70371074028;4634.657402660699;4636.095961287584;4704.388429504211;4774.259989701602;70062;70141;70780.29219707738;70781;71801;64358;64584.35415645877;65152.34847651557;65247.67376163089;65626.34373656298;55475.16787248194;56481;57121;57730;59136.70431647814;9138.862917056382;9304.813903722023;9512.85730714026;9533.570989305637;9567.61729530811;41322.173556529306;41387;41999.16001679888;42015.579844201166;42307.7884610575;50676.49323506718;53808;54146;54743.72628136834;54801.45198547964;8626;8694.39139260271;8776.956115219384;8946.507942062988;9168.954155229449;12949.352532373156;13060.738785224052;13101.934490327869;13287.534936277183;13351.532696355582;11762.529498819951;11784.70538236551;11852.822207667065;11882.940585297018;12359.752804943671;11830.585929492427;12002.279863208236;12189.085818563466;12389.566365177176;13106.60680179596;10919.454027298762;10969.616063437741;12508.124431289722;12542.811857821958;12595.622131336075;10430.37417754937;10473.21450891171;10487.79024419492;10904.400257985886;11394.715132121763;10477.175830821847;10783.676489705322;10916.836247456136;10978;10987.285826421257 14:36:05 INFO - 2016-01-11 14:36:05,844 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:36:05 INFO - 2016-01-11 14:36:05,845 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:36:05 INFO - 2016-01-11 14:36:05,845 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,838 14:36:05 INFO - 2016-01-11 14:36:05,845 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:36:05 INFO - 2016-01-11 14:36:05,845 DEBUG : BROWSER_OUTPUT: __startTimestamp1452551765833__endTimestamp 14:36:05 INFO - 2016-01-11 14:36:05,845 DEBUG : BROWSER_OUTPUT: 14:36:05 INFO - 2016-01-11 14:36:05,845 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:36:05 INFO - 2016-01-11 14:36:05,845 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:36:05 INFO - 2016-01-11 14:36:05,845 DEBUG : BROWSER_OUTPUT: 14:36:05 INFO - 2016-01-11 14:36:05,845 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5655.88 Median:5887.00 stddev:628.00 (10.7%) stddev-sans-first:602.35 14:36:05 INFO - 2016-01-11 14:36:05,846 DEBUG : BROWSER_OUTPUT: Values: 3309.8 3394.5 3416.6 3421.6 3449.5 5606.3 5612.5 5614.4 5631.2 5643.0 5645.1 5654.1 5655.0 5656.4 5670.0 5014.6 5111.3 5114.3 5225.9 5250.9 5028.3 5110.7 5121.6 5152.3 5211.7 5245.1 5265.4 5273.7 5279.9 5296.2 4905.6 5193.2 5195.8 5268.1 5276.3 5059.3 5120.2 5175.6 5188.6 5221.1 5484.8 5485.7 5501.2 5502.0 5503.0 5941.6 6114.0 6115.5 6121.5 6122.9 6019.4 6086.7 6143.2 6160.9 6161.4 5798.4 5809.3 5809.7 5811.1 5825.0 5980.3 6087.9 6285.7 6294.2 6294.3 5923.0 6015.8 6022.2 6028.1 6039.7 5965.7 6009.4 6010.5 6020.6 6054.0 5862.6 6004.7 6025.3 6048.8 6129.1 6082.0 6141.7 6153.9 6166.2 6170.8 4707.0 4709.0 4711.5 4721.5 4733.0 4066.6 4140.6 4170.6 4209.0 4222.3 5822.6 5863.2 5871.7 5876.4 5879.5 6199.0 6219.0 6221.7 6222.2 6229.2 5556.2 5657.3 5794.3 5895.7 5897.9 5306.4 5308.0 5310.8 5319.4 5319.5 6111.9 6318.9 6325.5 6331.0 6332.9 5951.7 6047.5 6058.8 6066.3 6072.3 6252.8 6270.5 6311.7 6315.2 6315.5 5711.7 5835.5 6034.4 6043.5 6047.7 5996.6 6107.2 6110.4 6114.6 6114.9 5928.3 5980.8 5983.7 5984.6 5993.0 5788.2 5802.7 5916.5 5954.6 6036.3 5854.0 5927.8 5928.8 5931.4 5986.3 5921.2 5958.2 5966.9 5996.7 6010.7 5635.3 5762.0 5790.4 5887.0 5914.6 14:36:05 INFO - 2016-01-11 14:36:05,846 DEBUG : BROWSER_OUTPUT: 14:36:05 INFO - 2016-01-11 14:36:05,846 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:54275.68 Median:35846.96 stddev:91284.15 (254.6%) stddev-sans-first:91451.22 14:36:05 INFO - 2016-01-11 14:36:05,846 DEBUG : BROWSER_OUTPUT: Values: 585.9 612.2 617.3 624.7 641.6 43418.8 44709.8 44770.8 44850.3 44944.8 47326.5 47700.0 47858.8 47947.3 47971.8 8172.2 8314.4 9358.8 9527.7 10799.4 11083.5 11200.0 11207.2 11208.7 11210.6 11120.7 11230.9 11241.9 11243.7 11249.0 11077.7 11147.2 11169.3 11184.7 11192.2 10970.9 11014.3 11016.6 11105.3 11118.1 44562.6 45149.0 45237.5 45264.3 45297.3 3698.2 3715.7 3744.8 3824.6 4014.9 33712.2 34018.1 34020.8 34051.0 34055.1 4009.3 4016.9 4045.8 4087.3 4164.8 334813.0 335048.0 335149.0 335210.0 335315.0 66971.3 67767.7 67889.6 68063.0 68101.0 70974.6 71351.0 71536.0 71552.0 71584.0 18816.3 19360.8 19366.3 19375.4 19395.8 14414.9 14507.4 14526.6 14563.7 14671.1 21194.4 21561.4 21584.4 21584.6 21630.5 8111.0 8301.5 8318.5 8348.2 8352.5 1011.1 1080.3 1084.1 1088.8 1152.8 30597.6 30600.2 30671.5 30846.0 31259.5 978.6 1068.5 1125.4 1132.9 1146.3 13540.0 14553.0 14760.2 15028.6 15418.7 374862.0 381786.0 382158.0 382933.0 383209.0 57982.7 58211.4 58364.0 58445.7 58449.0 1379.7 1468.1 1489.2 1522.1 1540.1 28438.3 28491.1 28622.0 28992.4 29498.9 62253.4 63618.7 63645.4 63667.7 63697.0 325340.4 328103.0 328284.0 328777.0 329735.0 35175.8 35730.6 35872.5 35945.6 36320.6 48818.3 49788.0 49826.5 50258.7 50739.5 40293.0 41141.6 41373.0 45337.8 46260.8 40724.4 40939.4 41009.0 41610.0 41614.4 39980.8 40740.8 40910.4 41121.0 41167.4 34915.3 34993.1 35278.1 35821.5 36148.3 27513.9 27702.7 27790.6 27932.9 27971.0 14:36:05 INFO - 2016-01-11 14:36:05,846 DEBUG : BROWSER_OUTPUT: 14:36:05 INFO - 2016-01-11 14:36:05,846 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:30972.39 Median:27276.36 stddev:100199.26 (367.3%) stddev-sans-first:100454.02 14:36:05 INFO - 2016-01-11 14:36:05,848 DEBUG : BROWSER_OUTPUT: Values: 387.1 387.6 392.1 396.3 396.7 15728.7 16136.4 18625.0 18720.7 19023.9 18900.5 19008.5 19054.9 19394.5 19409.5 5647.2 5798.7 5808.6 5815.1 5817.2 3949.6 4426.3 5753.3 6335.4 6342.2 6129.7 6260.2 6272.8 6291.9 6312.6 6228.4 6290.8 6296.3 6301.7 6347.7 5523.8 5528.9 5605.3 5612.5 5613.4 22782.7 22952.8 22973.4 23148.3 23246.2 2064.9 2231.6 2237.5 2267.4 2391.4 10544.7 10624.6 10827.3 10857.1 10934.7 1746.3 1813.2 1816.1 1834.3 1839.5 67125.0 68794.0 69513.3 70406.3 71085.0 7891.9 7941.1 7963.9 7992.9 8025.2 9615.4 9644.6 9647.1 9654.7 9655.6 6497.5 6568.7 6593.5 6618.1 6626.0 6908.2 6909.8 6913.8 6952.9 6968.6 3606.8 3641.1 3645.9 3670.9 3671.9 1260.9 1280.5 3117.0 3147.9 3206.4 534.3 536.0 542.3 563.6 566.7 11549.2 12983.0 13014.5 13125.3 13597.0 551.2 555.0 562.3 568.1 570.9 7115.3 7132.6 7255.5 7332.3 7540.8 597751.0 598224.0 600482.0 628007.0 631624.0 86601.6 88176.6 88991.0 89483.6 89738.0 635.1 648.6 649.7 649.8 651.3 12408.2 12636.9 12639.2 12750.2 12805.8 39157.2 39248.6 39478.8 40111.6 40512.6 52231.5 52744.7 54010.5 54437.0 54573.5 7720.9 7754.3 7880.5 7900.1 7902.0 13794.2 14014.6 14042.4 14080.9 14306.5 11896.5 12058.2 12262.9 12289.3 12324.8 11731.2 12016.0 12038.4 12047.3 12105.2 9855.7 10280.2 11466.8 11695.3 11883.8 7599.5 7604.7 7692.3 7700.7 7703.1 11481.5 11731.4 11804.4 11832.1 12108.5 14:36:05 INFO - 2016-01-11 14:36:05,848 DEBUG : BROWSER_OUTPUT: 14:36:05 INFO - 2016-01-11 14:36:05,848 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5719.38 Median:6565.36 stddev:2911.93 (44.4%) stddev-sans-first:2903.57 14:36:05 INFO - 2016-01-11 14:36:05,849 DEBUG : BROWSER_OUTPUT: Values: 1592.5 1594.6 1866.4 1877.0 1877.7 7850.3 7935.2 7997.8 7997.9 8006.2 8104.7 8114.5 8129.9 8140.3 8165.3 2370.7 2373.0 2395.9 2397.1 2406.6 2388.0 2452.6 2465.3 2465.9 2467.0 1929.4 1962.1 2290.9 2399.4 2414.6 2361.2 2365.9 2372.9 2376.7 2377.7 2369.7 2418.1 2420.2 2422.5 2422.5 6490.2 6640.5 7936.8 8137.8 8142.4 4961.3 5037.0 5043.7 5048.1 5049.6 3338.7 3364.7 3399.6 3404.3 3415.9 1182.3 1189.2 1203.7 1224.6 1236.5 11090.3 11110.4 11147.4 11150.3 11152.4 4599.8 4601.8 4644.7 4654.4 4673.2 9753.1 9754.8 9763.5 9767.4 9769.4 5162.8 5163.4 5163.5 5165.9 5169.8 4685.6 4708.0 4711.9 4712.3 4713.0 3936.2 3972.0 3974.9 3999.7 4015.6 1301.1 1303.1 1307.1 1308.2 1308.3 1118.3 1122.1 1253.2 1456.3 1485.4 7859.6 7885.1 7909.1 7909.5 7913.0 536.2 538.7 545.3 561.7 564.0 5691.4 5781.6 6344.7 6406.1 6419.1 8537.7 8790.3 8823.5 8829.4 8830.2 9233.1 9302.1 9389.5 9503.4 9523.5 7453.0 7514.0 7526.7 7530.5 7539.5 7628.3 7776.2 7786.6 7828.2 7834.5 8376.0 8405.5 8512.1 8873.5 8982.6 8498.8 8507.0 8575.7 9183.3 9187.6 7204.6 7274.9 7280.4 7287.8 7305.3 7821.5 7941.1 7957.5 7974.1 7975.1 7313.5 7585.1 7600.6 7632.4 7678.7 7436.8 7444.7 7469.9 7535.7 7551.0 7537.1 7627.5 7632.3 7636.0 7650.1 6932.3 6981.2 6991.7 6996.4 7006.9 6738.8 6824.2 6854.7 6865.0 7163.1 14:36:05 INFO - 2016-01-11 14:36:05,849 DEBUG : BROWSER_OUTPUT: 14:36:05 INFO - 2016-01-11 14:36:05,849 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5383.01 Median:6020.18 stddev:1569.15 (26.1%) stddev-sans-first:1527.51 14:36:05 INFO - 2016-01-11 14:36:05,849 DEBUG : BROWSER_OUTPUT: Values: 355.7 356.6 360.2 360.4 360.7 5993.5 6020.8 6036.4 6052.1 6065.3 5710.9 5791.6 5807.4 5900.6 5926.0 4638.5 4642.4 4653.4 4661.9 4674.7 4669.0 4677.4 4681.5 4684.2 4684.7 4613.8 4638.4 4641.4 4644.0 4644.3 4602.7 4671.4 4689.6 4695.5 4700.7 4157.2 4162.4 4163.3 4167.2 4169.8 5676.0 5681.9 5684.2 5690.5 5695.2 5316.7 5402.6 5403.8 5415.3 5416.8 6365.0 6365.6 6366.7 6370.2 6371.9 4631.6 4638.3 4639.7 4640.2 4645.9 6496.1 6585.7 6599.2 6602.6 6606.8 4706.9 4748.6 4784.4 4791.0 4799.1 4843.2 4846.3 4846.8 4849.0 4852.5 5466.5 5467.6 5470.9 5471.2 5471.3 6312.5 6408.0 6408.6 6411.9 6414.0 1730.2 1742.6 1745.4 1746.9 1749.2 1129.5 1169.2 1198.8 1219.5 1227.3 5991.2 6004.6 6012.8 6019.5 6035.6 6377.7 6409.0 6412.1 6419.9 6424.0 5953.0 6064.2 6065.4 6072.5 6074.7 3572.2 3600.5 3602.8 3608.3 3608.4 6723.0 6727.6 6735.1 6736.0 6736.9 6614.7 6694.6 6696.0 6698.7 6699.7 6750.5 6768.2 6768.4 6773.3 6778.6 6611.3 6622.3 6623.9 6626.7 6631.1 6472.8 6588.0 6590.5 6592.1 6596.8 6787.8 6841.2 6849.8 6853.2 6857.1 4626.1 4654.4 4660.7 4666.3 4667.1 6516.2 6637.2 6637.2 6643.3 6644.1 6481.6 6484.5 6487.5 6487.8 6492.5 6462.3 6463.5 6467.8 6469.5 6479.7 6280.0 6363.3 6371.4 6374.9 6377.6 6498.5 6499.7 6499.9 6500.7 6506.6 6316.6 6344.3 6345.6 6346.4 6347.5 14:36:05 INFO - 2016-01-11 14:36:05,849 DEBUG : BROWSER_OUTPUT: 14:36:05 INFO - 2016-01-11 14:36:05,849 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:15670.73 Median:4964.95 stddev:19484.66 (392.4%) stddev-sans-first:19507.68 14:36:05 INFO - 2016-01-11 14:36:05,850 DEBUG : BROWSER_OUTPUT: Values: 884.5 914.9 915.4 930.0 954.2 15524.3 15845.9 15865.4 15909.0 15938.7 14500.2 14659.3 14738.2 14767.7 14833.9 782.7 790.0 926.2 926.4 952.3 942.6 946.5 951.2 952.4 953.4 801.6 993.4 993.7 995.6 996.3 815.5 962.1 975.1 975.4 981.0 716.0 720.1 723.1 723.8 729.8 15174.7 15218.2 15268.7 15403.5 15435.1 13329.7 13841.0 14064.9 14240.3 14486.1 10658.9 10825.7 10998.2 11437.3 11590.9 3510.7 3514.3 3526.8 3534.3 3543.6 52166.2 52680.0 53159.2 53182.5 53256.7 8186.5 8198.7 8209.4 8262.3 8398.9 13259.3 13281.6 13397.3 13654.9 13734.9 7393.7 7396.3 7485.9 7620.2 7775.0 4867.7 4961.5 4968.5 5016.2 5026.1 3103.4 3131.3 3134.3 3136.2 3139.8 487.8 487.8 488.5 490.0 493.1 729.5 746.9 755.2 759.2 773.3 9841.0 10056.1 10118.8 10146.1 10201.7 608.0 759.0 779.4 793.2 803.6 4232.7 4634.7 4636.1 4704.4 4774.3 70062.0 70141.0 70780.3 70781.0 71801.0 64358.0 64584.4 65152.3 65247.7 65626.3 55475.2 56481.0 57121.0 57730.0 59136.7 9138.9 9304.8 9512.9 9533.6 9567.6 41322.2 41387.0 41999.2 42015.6 42307.8 50676.5 53808.0 54146.0 54743.7 54801.5 8626.0 8694.4 8777.0 8946.5 9169.0 12949.4 13060.7 13101.9 13287.5 13351.5 11762.5 11784.7 11852.8 11882.9 12359.8 11830.6 12002.3 12189.1 12389.6 13106.6 10919.5 10969.6 12508.1 12542.8 12595.6 10430.4 10473.2 10487.8 10904.4 11394.7 10477.2 10783.7 10916.8 10978.0 10987.3 14:36:05 INFO - 2016-01-11 14:36:05,850 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:36:05 INFO - 2016-01-11 14:36:05,850 DEBUG : BROWSER_OUTPUT: 14:36:06 INFO - 2016-01-11 14:36:06,459 INFO : Browser exited with error code: 0 14:36:06 INFO - 2016-01-11 14:36:06,475 INFO : Completed test dromaeo_css (00:18:29) 14:36:06 INFO - 2016-01-11 14:36:06,475 INFO : Starting test kraken 14:36:06 INFO - 2016-01-11 14:36:06,475 DEBUG : operating with platform_type : linux_ 14:36:06 INFO - 2016-01-11 14:36:06,475 INFO : Initialising browser for kraken test... 14:36:06 INFO - 2016-01-11 14:36:06,481 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnSKVfC/profile http://localhost:37165/getInfo.html 14:36:09 INFO - 2016-01-11 14:36:09,875 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:36:09 INFO - 2016-01-11 14:36:09,875 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:36:09 INFO - 2016-01-11 14:36:09,875 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:36:09 INFO - 2016-01-11 14:36:09,875 DEBUG : BROWSER_OUTPUT: __metrics 14:36:10 INFO - 2016-01-11 14:36:10,004 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] 14:36:11 INFO - 2016-01-11 14:36:11,279 INFO : Browser initialized. 14:36:11 INFO - 2016-01-11 14:36:11,279 INFO : Running cycle 1/1 for kraken test... 14:36:11 INFO - 2016-01-11 14:36:11,280 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnSKVfC/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:36:22 INFO - 2016-01-11 14:36:22,840 DEBUG : BROWSER_OUTPUT: RSS: Main: 128786432 14:36:22 INFO - 2016-01-11 14:36:22,841 DEBUG : BROWSER_OUTPUT: 14:36:25 INFO - 2016-01-11 14:36:25,265 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37165/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37165/tests/kraken/driver.html?testName=audio-beat-detection) 14:36:25 INFO - 2016-01-11 14:36:25,834 DEBUG : BROWSER_OUTPUT: RSS: Main: 163733504 14:36:25 INFO - 2016-01-11 14:36:25,834 DEBUG : BROWSER_OUTPUT: 14:36:28 INFO - 2016-01-11 14:36:28,391 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37165/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37165/tests/kraken/driver.html?testName=audio-dft) 14:36:28 INFO - 2016-01-11 14:36:28,952 DEBUG : BROWSER_OUTPUT: RSS: Main: 160264192 14:36:28 INFO - 2016-01-11 14:36:28,952 DEBUG : BROWSER_OUTPUT: 14:36:31 INFO - 2016-01-11 14:36:31,711 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37165/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37165/tests/kraken/driver.html?testName=audio-fft) 14:36:32 INFO - 2016-01-11 14:36:32,274 DEBUG : BROWSER_OUTPUT: RSS: Main: 157052928 14:36:32 INFO - 2016-01-11 14:36:32,274 DEBUG : BROWSER_OUTPUT: 14:36:34 INFO - 2016-01-11 14:36:34,252 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37165/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37165/tests/kraken/driver.html?testName=audio-oscillator) 14:36:34 INFO - 2016-01-11 14:36:34,813 DEBUG : BROWSER_OUTPUT: RSS: Main: 158420992 14:36:34 INFO - 2016-01-11 14:36:34,813 DEBUG : BROWSER_OUTPUT: 14:36:36 INFO - 2016-01-11 14:36:36,934 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37165/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37165/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:36:37 INFO - 2016-01-11 14:36:37,504 DEBUG : BROWSER_OUTPUT: RSS: Main: 155291648 14:36:37 INFO - 2016-01-11 14:36:37,505 DEBUG : BROWSER_OUTPUT: 14:36:40 INFO - 2016-01-11 14:36:40,375 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37165/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37165/tests/kraken/driver.html?testName=imaging-darkroom) 14:36:40 INFO - 2016-01-11 14:36:40,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 155721728 14:36:40 INFO - 2016-01-11 14:36:40,941 DEBUG : BROWSER_OUTPUT: 14:36:44 INFO - 2016-01-11 14:36:44,275 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37165/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37165/tests/kraken/driver.html?testName=imaging-desaturate) 14:36:44 INFO - 2016-01-11 14:36:44,837 DEBUG : BROWSER_OUTPUT: RSS: Main: 155250688 14:36:44 INFO - 2016-01-11 14:36:44,837 DEBUG : BROWSER_OUTPUT: 14:36:47 INFO - 2016-01-11 14:36:47,559 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37165/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37165/tests/kraken/driver.html?testName=json-parse-financial) 14:36:48 INFO - 2016-01-11 14:36:48,128 DEBUG : BROWSER_OUTPUT: RSS: Main: 157270016 14:36:48 INFO - 2016-01-11 14:36:48,128 DEBUG : BROWSER_OUTPUT: 14:36:49 INFO - 2016-01-11 14:36:49,626 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37165/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37165/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:36:50 INFO - 2016-01-11 14:36:50,187 DEBUG : BROWSER_OUTPUT: RSS: Main: 159453184 14:36:50 INFO - 2016-01-11 14:36:50,187 DEBUG : BROWSER_OUTPUT: 14:36:51 INFO - 2016-01-11 14:36:51,917 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37165/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37165/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:36:52 INFO - 2016-01-11 14:36:52,506 DEBUG : BROWSER_OUTPUT: RSS: Main: 160370688 14:36:52 INFO - 2016-01-11 14:36:52,506 DEBUG : BROWSER_OUTPUT: 14:36:54 INFO - 2016-01-11 14:36:54,458 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37165/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37165/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:36:55 INFO - 2016-01-11 14:36:55,024 DEBUG : BROWSER_OUTPUT: RSS: Main: 166400000 14:36:55 INFO - 2016-01-11 14:36:55,025 DEBUG : BROWSER_OUTPUT: 14:36:57 INFO - 2016-01-11 14:36:57,331 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37165/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37165/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:36:57 INFO - 2016-01-11 14:36:57,903 DEBUG : BROWSER_OUTPUT: RSS: Main: 171294720 14:36:57 INFO - 2016-01-11 14:36:57,903 DEBUG : BROWSER_OUTPUT: 14:37:00 INFO - 2016-01-11 14:37:00,344 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37165/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37165/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:37:00 INFO - 2016-01-11 14:37:00,910 DEBUG : BROWSER_OUTPUT: RSS: Main: 168353792 14:37:00 INFO - 2016-01-11 14:37:00,911 DEBUG : BROWSER_OUTPUT: 14:37:02 INFO - 2016-01-11 14:37:02,507 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37165/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37165/tests/kraken/driver.html?testName=ai-astar) 14:37:02 INFO - 2016-01-11 14:37:02,765 DEBUG : BROWSER_OUTPUT: RSS: Main: 225820672 14:37:02 INFO - 2016-01-11 14:37:02,766 DEBUG : BROWSER_OUTPUT: 14:37:02 INFO - 2016-01-11 14:37:02,766 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:37:02 INFO - 2016-01-11 14:37:02,766 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:37:02 INFO - 2016-01-11 14:37:02,766 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:37:02 INFO - 2016-01-11 14:37:02,766 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:37:02 INFO - 2016-01-11 14:37:02,766 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;112;103;108;111;111;101;109;107;108 14:37:02 INFO - 2016-01-11 14:37:02,767 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;122;148;155;129;152;152;122;159;121 14:37:02 INFO - 2016-01-11 14:37:02,767 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;160;160;159;161;160;163;161;159 14:37:02 INFO - 2016-01-11 14:37:02,767 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;72;139;72;70;71;70;154;71 14:37:02 INFO - 2016-01-11 14:37:02,767 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;89;135;89;89;89;134;90;89;130 14:37:02 INFO - 2016-01-11 14:37:02,767 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;109;109;110;109;110;109;110 14:37:02 INFO - 2016-01-11 14:37:02,767 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;145;145;144;145;147;145;145;145 14:37:02 INFO - 2016-01-11 14:37:02,767 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;96;95;96;96;95;96 14:37:02 INFO - 2016-01-11 14:37:02,768 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;52;54;54;55;56;55;54;62;52;54 14:37:02 INFO - 2016-01-11 14:37:02,768 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;63;63;64;63;63;63;63;64 14:37:02 INFO - 2016-01-11 14:37:02,768 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;76;77;81;79;80;78;86;78;78;78 14:37:02 INFO - 2016-01-11 14:37:02,768 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;113;107;123;106;115;124;115;109;119;113 14:37:02 INFO - 2016-01-11 14:37:02,768 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;137;138;136;138;136;147;134;134;136 14:37:02 INFO - 2016-01-11 14:37:02,769 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;63;61;62;61;61;64;63;64;62;64 14:37:02 INFO - 2016-01-11 14:37:02,769 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:37:02 INFO - 2016-01-11 14:37:02,769 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:37:02 INFO - 2016-01-11 14:37:02,769 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,858 14:37:02 INFO - 2016-01-11 14:37:02,769 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:37:02 INFO - 2016-01-11 14:37:02,769 DEBUG : BROWSER_OUTPUT: __startTimestamp1452551822760__endTimestamp 14:37:02 INFO - 2016-01-11 14:37:02,770 DEBUG : BROWSER_OUTPUT: 14:37:02 INFO - 2016-01-11 14:37:02,770 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:37:02 INFO - 2016-01-11 14:37:02,770 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:37:02 INFO - 2016-01-11 14:37:02,770 DEBUG : BROWSER_OUTPUT: 14:37:02 INFO - 2016-01-11 14:37:02,770 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.80 Median:108.50 stddev:3.49 (3.2%) stddev-sans-first:3.70 14:37:02 INFO - 2016-01-11 14:37:02,770 DEBUG : BROWSER_OUTPUT: Values: 108.0 112.0 103.0 108.0 111.0 111.0 101.0 109.0 107.0 108.0 14:37:02 INFO - 2016-01-11 14:37:02,770 DEBUG : BROWSER_OUTPUT: 14:37:02 INFO - 2016-01-11 14:37:02,770 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.30 Median:152.00 stddev:15.71 (10.3%) stddev-sans-first:16.08 14:37:02 INFO - 2016-01-11 14:37:02,770 DEBUG : BROWSER_OUTPUT: Values: 153.0 122.0 148.0 155.0 129.0 152.0 152.0 122.0 159.0 121.0 14:37:02 INFO - 2016-01-11 14:37:02,771 DEBUG : BROWSER_OUTPUT: 14:37:02 INFO - 2016-01-11 14:37:02,771 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:1.18 (0.7%) stddev-sans-first:1.24 14:37:02 INFO - 2016-01-11 14:37:02,771 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 160.0 160.0 159.0 161.0 160.0 163.0 161.0 159.0 14:37:02 INFO - 2016-01-11 14:37:02,771 DEBUG : BROWSER_OUTPUT: 14:37:02 INFO - 2016-01-11 14:37:02,771 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:86.10 Median:71.00 stddev:32.04 (45.1%) stddev-sans-first:33.51 14:37:02 INFO - 2016-01-11 14:37:02,771 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 72.0 139.0 72.0 70.0 71.0 70.0 154.0 71.0 14:37:02 INFO - 2016-01-11 14:37:02,771 DEBUG : BROWSER_OUTPUT: 14:37:02 INFO - 2016-01-11 14:37:02,771 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.30 Median:89.00 stddev:21.22 (23.8%) stddev-sans-first:21.96 14:37:02 INFO - 2016-01-11 14:37:02,771 DEBUG : BROWSER_OUTPUT: Values: 89.0 89.0 135.0 89.0 89.0 89.0 134.0 90.0 89.0 130.0 14:37:02 INFO - 2016-01-11 14:37:02,771 DEBUG : BROWSER_OUTPUT: 14:37:02 INFO - 2016-01-11 14:37:02,771 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 14:37:02 INFO - 2016-01-11 14:37:02,772 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 109.0 109.0 110.0 109.0 110.0 109.0 110.0 14:37:02 INFO - 2016-01-11 14:37:02,772 DEBUG : BROWSER_OUTPUT: 14:37:02 INFO - 2016-01-11 14:37:02,773 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 14:37:02 INFO - 2016-01-11 14:37:02,773 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 145.0 145.0 144.0 145.0 147.0 145.0 145.0 145.0 14:37:02 INFO - 2016-01-11 14:37:02,773 DEBUG : BROWSER_OUTPUT: 14:37:02 INFO - 2016-01-11 14:37:02,773 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 14:37:02 INFO - 2016-01-11 14:37:02,773 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 96.0 95.0 96.0 96.0 95.0 96.0 14:37:02 INFO - 2016-01-11 14:37:02,773 DEBUG : BROWSER_OUTPUT: 14:37:02 INFO - 2016-01-11 14:37:02,773 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.50 stddev:2.82 (5.2%) stddev-sans-first:2.80 14:37:02 INFO - 2016-01-11 14:37:02,773 DEBUG : BROWSER_OUTPUT: Values: 52.0 54.0 54.0 55.0 56.0 55.0 54.0 62.0 52.0 54.0 14:37:02 INFO - 2016-01-11 14:37:02,773 DEBUG : BROWSER_OUTPUT: 14:37:02 INFO - 2016-01-11 14:37:02,773 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.30 Median:63.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 14:37:02 INFO - 2016-01-11 14:37:02,774 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 63.0 63.0 64.0 63.0 63.0 63.0 63.0 64.0 14:37:02 INFO - 2016-01-11 14:37:02,774 DEBUG : BROWSER_OUTPUT: 14:37:02 INFO - 2016-01-11 14:37:02,774 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:78.50 stddev:2.81 (3.6%) stddev-sans-first:2.74 14:37:02 INFO - 2016-01-11 14:37:02,774 DEBUG : BROWSER_OUTPUT: Values: 76.0 77.0 81.0 79.0 80.0 78.0 86.0 78.0 78.0 78.0 14:37:02 INFO - 2016-01-11 14:37:02,774 DEBUG : BROWSER_OUTPUT: 14:37:02 INFO - 2016-01-11 14:37:02,774 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:114.40 Median:115.00 stddev:6.20 (5.4%) stddev-sans-first:6.56 14:37:02 INFO - 2016-01-11 14:37:02,774 DEBUG : BROWSER_OUTPUT: Values: 113.0 107.0 123.0 106.0 115.0 124.0 115.0 109.0 119.0 113.0 14:37:02 INFO - 2016-01-11 14:37:02,774 DEBUG : BROWSER_OUTPUT: 14:37:02 INFO - 2016-01-11 14:37:02,774 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.10 Median:136.50 stddev:3.75 (2.8%) stddev-sans-first:3.91 14:37:02 INFO - 2016-01-11 14:37:02,774 DEBUG : BROWSER_OUTPUT: Values: 135.0 137.0 138.0 136.0 138.0 136.0 147.0 134.0 134.0 136.0 14:37:02 INFO - 2016-01-11 14:37:02,774 DEBUG : BROWSER_OUTPUT: 14:37:02 INFO - 2016-01-11 14:37:02,774 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:63.00 stddev:1.27 (2.0%) stddev-sans-first:1.33 14:37:02 INFO - 2016-01-11 14:37:02,774 DEBUG : BROWSER_OUTPUT: Values: 63.0 61.0 62.0 61.0 61.0 64.0 63.0 64.0 62.0 64.0 14:37:02 INFO - 2016-01-11 14:37:02,774 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:37:02 INFO - 2016-01-11 14:37:02,774 DEBUG : BROWSER_OUTPUT: 14:37:03 INFO - 2016-01-11 14:37:03,483 INFO : Browser exited with error code: 0 14:37:03 INFO - 2016-01-11 14:37:03,531 INFO : Completed test kraken (00:00:57) 14:37:03 INFO - 2016-01-11 14:37:03,531 INFO : Starting test v8_7 14:37:03 INFO - 2016-01-11 14:37:03,531 DEBUG : operating with platform_type : linux_ 14:37:03 INFO - 2016-01-11 14:37:03,531 INFO : Initialising browser for v8_7 test... 14:37:03 INFO - 2016-01-11 14:37:03,537 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjl8ZF0/profile http://localhost:37165/getInfo.html 14:37:07 INFO - 2016-01-11 14:37:07,021 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:37:07 INFO - 2016-01-11 14:37:07,021 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:37:07 INFO - 2016-01-11 14:37:07,021 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:37:07 INFO - 2016-01-11 14:37:07,022 DEBUG : BROWSER_OUTPUT: __metrics 14:37:07 INFO - 2016-01-11 14:37:07,164 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] 14:37:08 INFO - 2016-01-11 14:37:08,271 INFO : Browser initialized. 14:37:08 INFO - 2016-01-11 14:37:08,271 INFO : Running cycle 1/1 for v8_7 test... 14:37:08 INFO - 2016-01-11 14:37:08,272 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjl8ZF0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:37:19 INFO - 2016-01-11 14:37:19,828 DEBUG : BROWSER_OUTPUT: RSS: Main: 129343488 14:37:19 INFO - 2016-01-11 14:37:19,828 DEBUG : BROWSER_OUTPUT: 14:37:41 INFO - 2016-01-11 14:37:41,181 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37165/tests/v8_7/run.html (next: http://localhost:37165/tests/v8_7/run.html) 14:37:41 INFO - 2016-01-11 14:37:41,427 DEBUG : BROWSER_OUTPUT: RSS: Main: 429703168 14:37:41 INFO - 2016-01-11 14:37:41,428 DEBUG : BROWSER_OUTPUT: 14:37:41 INFO - 2016-01-11 14:37:41,429 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:37:41 INFO - 2016-01-11 14:37:41,429 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:37:41 INFO - 2016-01-11 14:37:41,429 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:37:41 INFO - 2016-01-11 14:37:41,429 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:37:41 INFO - 2016-01-11 14:37:41,429 DEBUG : BROWSER_OUTPUT: |0;Richards;162.41676140977748 14:37:41 INFO - 2016-01-11 14:37:41,430 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;171.76228100309172 14:37:41 INFO - 2016-01-11 14:37:41,430 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.19052956010086 14:37:41 INFO - 2016-01-11 14:37:41,430 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4995.024875621891 14:37:41 INFO - 2016-01-11 14:37:41,430 DEBUG : BROWSER_OUTPUT: |4;RayTrace;943.3962264150944 14:37:41 INFO - 2016-01-11 14:37:41,430 DEBUG : BROWSER_OUTPUT: |5;Earley;558.659217877095 14:37:41 INFO - 2016-01-11 14:37:41,430 DEBUG : BROWSER_OUTPUT: |6;Boyer;10489.583333333334 14:37:41 INFO - 2016-01-11 14:37:41,431 DEBUG : BROWSER_OUTPUT: |7;RegExp;23651.162790697676 14:37:41 INFO - 2016-01-11 14:37:41,431 DEBUG : BROWSER_OUTPUT: |8;Splay;533.5463258785943 14:37:41 INFO - 2016-01-11 14:37:41,431 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4817.307692307692 14:37:41 INFO - 2016-01-11 14:37:41,431 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:37:41 INFO - 2016-01-11 14:37:41,431 DEBUG : BROWSER_OUTPUT: __startTimestamp1452551861427__endTimestamp 14:37:41 INFO - 2016-01-11 14:37:41,432 DEBUG : BROWSER_OUTPUT: 14:37:41 INFO - 2016-01-11 14:37:41,432 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:37:41 INFO - 2016-01-11 14:37:41,432 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:37:41 INFO - 2016-01-11 14:37:41,432 DEBUG : BROWSER_OUTPUT: 14:37:41 INFO - 2016-01-11 14:37:41,432 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.42 Median:162.42 stddev:0.00 (0.0%) 14:37:41 INFO - 2016-01-11 14:37:41,433 DEBUG : BROWSER_OUTPUT: Values: 162.4 14:37:41 INFO - 2016-01-11 14:37:41,433 DEBUG : BROWSER_OUTPUT: 14:37:41 INFO - 2016-01-11 14:37:41,433 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:171.76 Median:171.76 stddev:0.00 (0.0%) 14:37:41 INFO - 2016-01-11 14:37:41,433 DEBUG : BROWSER_OUTPUT: Values: 171.8 14:37:41 INFO - 2016-01-11 14:37:41,433 DEBUG : BROWSER_OUTPUT: 14:37:41 INFO - 2016-01-11 14:37:41,434 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.19 Median:280.19 stddev:0.00 (0.0%) 14:37:41 INFO - 2016-01-11 14:37:41,434 DEBUG : BROWSER_OUTPUT: Values: 280.2 14:37:41 INFO - 2016-01-11 14:37:41,435 DEBUG : BROWSER_OUTPUT: 14:37:41 INFO - 2016-01-11 14:37:41,435 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4995.02 Median:4995.02 stddev:0.00 (0.0%) 14:37:41 INFO - 2016-01-11 14:37:41,435 DEBUG : BROWSER_OUTPUT: Values: 4995.0 14:37:41 INFO - 2016-01-11 14:37:41,435 DEBUG : BROWSER_OUTPUT: 14:37:41 INFO - 2016-01-11 14:37:41,435 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:943.40 Median:943.40 stddev:0.00 (0.0%) 14:37:41 INFO - 2016-01-11 14:37:41,435 DEBUG : BROWSER_OUTPUT: Values: 943.4 14:37:41 INFO - 2016-01-11 14:37:41,435 DEBUG : BROWSER_OUTPUT: 14:37:41 INFO - 2016-01-11 14:37:41,435 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:558.66 Median:558.66 stddev:0.00 (0.0%) 14:37:41 INFO - 2016-01-11 14:37:41,435 DEBUG : BROWSER_OUTPUT: Values: 558.7 14:37:41 INFO - 2016-01-11 14:37:41,435 DEBUG : BROWSER_OUTPUT: 14:37:41 INFO - 2016-01-11 14:37:41,435 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10489.58 Median:10489.58 stddev:0.00 (0.0%) 14:37:41 INFO - 2016-01-11 14:37:41,435 DEBUG : BROWSER_OUTPUT: Values: 10489.6 14:37:41 INFO - 2016-01-11 14:37:41,435 DEBUG : BROWSER_OUTPUT: 14:37:41 INFO - 2016-01-11 14:37:41,435 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23651.16 Median:23651.16 stddev:0.00 (0.0%) 14:37:41 INFO - 2016-01-11 14:37:41,435 DEBUG : BROWSER_OUTPUT: Values: 23651.2 14:37:41 INFO - 2016-01-11 14:37:41,436 DEBUG : BROWSER_OUTPUT: 14:37:41 INFO - 2016-01-11 14:37:41,436 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:533.55 Median:533.55 stddev:0.00 (0.0%) 14:37:41 INFO - 2016-01-11 14:37:41,436 DEBUG : BROWSER_OUTPUT: Values: 533.5 14:37:41 INFO - 2016-01-11 14:37:41,436 DEBUG : BROWSER_OUTPUT: 14:37:41 INFO - 2016-01-11 14:37:41,436 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 14:37:41 INFO - 2016-01-11 14:37:41,436 DEBUG : BROWSER_OUTPUT: Values: 4817.3 14:37:41 INFO - 2016-01-11 14:37:41,436 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:37:41 INFO - 2016-01-11 14:37:41,436 DEBUG : BROWSER_OUTPUT: 14:37:42 INFO - 2016-01-11 14:37:42,091 INFO : Browser exited with error code: 0 14:37:42 INFO - 2016-01-11 14:37:42,107 INFO : Completed test v8_7 (00:00:38) 14:37:42 INFO - 2016-01-11 14:37:42,483 INFO : Completed test suite (00:20:05) 14:37:42 INFO - 2016-01-11 14:37:42,483 DEBUG : Working with test: dromaeo_css 14:37:42 INFO - 2016-01-11 14:37:42,483 DEBUG : Generating results file: dromaeo_css 14:37:42 INFO - 2016-01-11 14:37:42,485 DEBUG : Working with test: kraken 14:37:42 INFO - 2016-01-11 14:37:42,485 DEBUG : Generating results file: kraken 14:37:42 INFO - 2016-01-11 14:37:42,485 INFO : javascript benchmark 14:37:42 INFO - 2016-01-11 14:37:42,485 DEBUG : Working with test: v8_7 14:37:42 INFO - 2016-01-11 14:37:42,485 DEBUG : Generating results file: v8_7 14:37:42 INFO - 2016-01-11 14:37:42,486 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:37:42 INFO - 2016-01-11 14:37:42,534 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 14:37:42 INFO - 2016-01-11 14:37:42,534 DEBUG : process_Request line: dromaeo_css 7303.75 graph.html#tests=[[72,53,35]] 14:37:42 INFO - 2016-01-11 14:37:42,535 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:37:42 INFO - 2016-01-11 14:37:42,569 DEBUG : process_Request line: kraken 1459.50 graph.html#tests=[[232,53,35]] 14:37:42 INFO - 2016-01-11 14:37:42,569 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:37:42 INFO - 2016-01-11 14:37:42,601 DEBUG : process_Request line: v8_7 23310.20 graph.html#tests=[[230,53,35]] 14:37:42 INFO - 2016-01-11 14:37:42,603 INFO : javascript benchmark 14:37:42 INFO - 2016-01-11 14:37:42,606 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3309.7517686173537, 3394.456886898097, 3416.5900091988965, 3421.640727723589, 3449.517067610534, 5606.299212598426, 5612.494875461208, 5614.382417934029, 5631.18347839563, 5643.0, 5645.125005624135, 5654.095344744842, 5655.0386434306165, 5656.377798442168, 5670.0, 5014.648974571782, 5111.284420181169, 5114.335136432259, 5225.921611175835, 5250.947490525104, 5028.296038554606, 5110.718910459923, 5121.641485096045, 5152.330197074375, 5211.739413029352, 5245.082110630643, 5265.394479634833, 5273.736313184345, 5279.868003299929, 5296.179092240709, 4905.558499735041, 5193.195054766517, 5195.766190521435, 5268.0780863348955, 5276.314079169702, 5059.3169922060415, 5120.180771076647, 5175.585953123778, 5188.610854185951, 5221.112410890158, 5484.808031718911, 5485.670859748388, 5501.174823776426, 5501.972490137564, 5503.036968530491, 5941.55438342126, 6114.021756518936, 6115.541334399938, 6121.540884433641, 6122.908156377658, 6019.367966363557, 6086.726097325631, 6143.232095988002, 6160.907586386208, 6161.353057928943, 5798.362180160179, 5809.302883653989, 5809.651420914716, 5811.128330750421, 5825.0, 5980.312264089598, 6087.878242435127, 6285.717142728588, 6294.213223347082, 6294.276158241769, 5923.0, 6015.849603759853, 6022.18700475439, 6028.09578563219, 6039.7282122304605, 5965.701714914324, 6009.399060093956, 6010.4891084258325, 6020.57855950088, 6054.0, 5862.648241105548, 6004.699765011732, 6025.307089684742, 6048.848778780478, 6129.08063790435, 6081.969590152109, 6141.686823742543, 6153.876922461615, 6166.167567378437, 6170.784022559189, 4707.03505781314, 4709.034647897173, 4711.528847115261, 4721.527847215251, 4733.029728905566, 4066.5933406659688, 4140.648044916215, 4170.582941705866, 4208.9898424377925, 4222.282212023963, 5822.621529600562, 5863.237779088691, 5871.735771890275, 5876.353601103875, 5879.52963762898, 6198.969005154945, 6218.968905155445, 6221.657808820558, 6222.160008398808, 6229.221347331583, 5556.222128901957, 5657.2928383952, 5794.333651630032, 5895.705214739246, 5897.941020589825, 5306.416294207711, 5308.044551980681, 5310.7610157543, 5319.414864364917, 5319.46805319465, 6111.908321375183, 6318.873622527523, 6325.462335701425, 6330.968345158245, 6332.873342533216, 5951.732172052355, 6047.516198704006, 6058.757649693963, 6066.332703402534, 6072.271327440735, 6252.781152659635, 6270.49836013127, 6311.652859092794, 6315.242170939517, 6315.463185629273, 5711.657300561979, 5835.503982161564, 6034.426729460694, 6043.486303664238, 6047.727852246748, 5996.580239383201, 6107.159036036683, 6110.432506543687, 6114.639512664841, 6114.883574732085, 5928.288605367384, 5980.760769569169, 5983.730732117152, 5984.640921544721, 5993.0, 5788.21859049023, 5802.709864506842, 5916.526677865674, 5954.583179177589, 6036.336003039574, 5854.0, 5927.762889484372, 5928.762849486145, 5931.406859314034, 5986.281646202309, 5921.2006379138265, 5958.195643588234, 5966.880662386641, 5996.670183139795, 6010.669413182317, 5635.323761148688, 5761.971190144022, 5790.392008839011, 5886.999210134201, 5914.645121292736], "unit": "ms", "name": "dojo.html", "value": 5615.151665907264}, {"lowerIsBetter": false, "replicates": [585.913131141732, 612.1643956000062, 617.2500411999421, 624.7376102037146, 641.6182371488962, 43418.782906085464, 44709.77645111778, 44770.77614611931, 44850.32724509131, 44944.77527612361, 47326.526734732644, 47700.0, 47858.76070619642, 47947.28079078808, 47971.760141199244, 8172.18278172184, 8314.376421768362, 9358.812823743505, 9527.666531671393, 10799.352038877692, 11083.501242444068, 11200.0, 11207.21549491536, 11208.66374008781, 11210.551577936872, 11120.666380008613, 11230.943845280763, 11241.943790281037, 11243.66269011931, 11249.043831274352, 11077.667669969873, 11147.219694621379, 11169.273997190237, 11184.720381990433, 11192.216544841864, 10970.890291097146, 11014.339139651647, 11016.614418495394, 11105.278156919856, 11118.054965327958, 44562.554374456486, 45149.0, 45237.547624523664, 45264.32103518417, 45297.320540191926, 3698.223373091654, 3715.7213209009433, 3744.794036328001, 3824.617538246181, 4014.859479918218, 33712.15719607029, 34018.149546261295, 34020.82989585061, 34051.0, 34055.14862128442, 4009.3384591542363, 4016.879493615196, 4045.7572545647063, 4087.346024636044, 4164.8125834337225, 334812.99999999756, 335048.0, 335148.99999999756, 335210.0, 335315.0, 66971.33028669651, 67767.66116169388, 67889.6055197248, 68063.0, 68101.0, 70974.64512677403, 71351.0, 71536.0, 71552.0, 71584.0, 18816.341428050226, 19360.8063919359, 19366.322178723676, 19375.4187374379, 19395.806041939682, 14414.927925360305, 14507.419703211754, 14526.564203073925, 14563.708725825423, 14671.119732816065, 21194.364169074954, 21561.353159405244, 21584.352469425943, 21584.568308633738, 21630.459238518848, 8111.010654505308, 8301.543415112226, 8318.45930014547, 8348.165183481724, 8352.498850068894, 1011.0900189829213, 1080.3032044331362, 1084.0622861224983, 1088.804015277242, 1152.8213126965165, 30597.585812925692, 30600.234994125323, 30671.539926901114, 30846.0, 31259.531107033414, 978.6379039755336, 1068.4774196769572, 1125.352922069813, 1132.8527291452058, 1146.295028557448, 13540.0, 14553.002135316501, 14760.184328127802, 15028.624284392978, 15418.691626167638, 374862.0, 381786.0, 382158.0, 382933.0, 383209.0, 57982.7100864493, 58211.41788582144, 58364.0, 58445.70777146087, 58449.0, 1379.7378498085332, 1468.1338010573813, 1489.1809504772332, 1522.0639306826222, 1540.1375229871308, 28438.289042773267, 28491.145265641233, 28621.99823006268, 28992.42015159727, 29498.852505737334, 62253.37746622657, 63618.68190659017, 63645.363546363944, 63667.68166159139, 63697.0, 325340.373298132, 328103.0, 328284.0, 328777.0, 329735.0, 35175.82412087923, 35730.64269357273, 35872.4619130708, 35945.64054359528, 36320.63679363278, 48818.26772598485, 49788.004239915725, 49826.50173498219, 50258.748706256236, 50739.49260507496, 40293.0, 41141.58858411378, 41373.0, 45337.773311133235, 46260.7686961563, 40724.389134163604, 40939.38590921079, 41009.0, 41610.0, 41614.37578436265, 39980.80009599934, 40740.79629601833, 40910.386344204264, 41121.0, 41167.38248926208, 34915.30169396547, 34993.12517187091, 35278.118047048, 35821.46267805933, 36148.27703445969, 27513.862430687717, 27702.72297277082, 27790.583141252493, 27932.86033569819, 27971.0], "unit": "ms", "name": "ext.html", "value": 21107.424328870973}, {"lowerIsBetter": false, "replicates": [387.06246183544425, 387.6433681013467, 392.1490365905985, 396.28668396885615, 396.7104014069729, 15728.685426291497, 16136.435224767107, 18625.0, 18720.719189212155, 19023.904880475595, 18900.527486812804, 19008.524786880334, 19054.904725476386, 19394.51513712158, 19409.514762130955, 5647.181158731992, 5798.739056742456, 5808.59339846211, 5815.127730840365, 5817.243758311413, 3949.605039496056, 4426.336049592554, 5753.338366087891, 6335.3981371769605, 6342.238931328247, 6129.724162412702, 6260.18617579714, 6272.843178920518, 6291.905621415683, 6312.589681670676, 6228.408301211378, 6290.842728931791, 6296.307406185316, 6301.6534090625, 6347.650879201642, 5523.8066667666435, 5528.861778455571, 5605.2713147291, 5612.522935550483, 5613.410591887875, 22782.65826012611, 22952.77047229523, 22973.425664358358, 23148.305550833502, 23246.186383476666, 2064.9070791814406, 2231.62062449384, 2237.5077482953725, 2267.4331417145713, 2391.414103544643, 10544.683659490227, 10624.628138015132, 10827.296225745302, 10857.131429485622, 10934.726631834188, 1746.2752957522614, 1813.1659436659152, 1816.0828781465275, 1834.257125864027, 1839.5217243516781, 67125.0, 68794.0, 69513.3048669517, 70406.29593704049, 71085.0, 7891.881621775678, 7941.126476087626, 7963.920360796434, 7992.880106798402, 8025.157358477276, 9615.375000625078, 9644.565994530123, 9647.13175814166, 9654.662086826927, 9655.613775448903, 6497.5126865484335, 6568.737250510022, 6593.505487088391, 6618.106555615027, 6625.966870165618, 6908.240093589701, 6909.7581584644295, 6913.827154321081, 6952.860942781116, 6968.616726080013, 3606.8196590170387, 3641.0715267606593, 3645.872394466181, 3670.944935825965, 3671.9265614688093, 1260.949562017509, 1280.481405030964, 3117.0413574760382, 3147.889823856154, 3206.422843888076, 534.2813915283937, 535.9839204823861, 542.2598153520416, 563.6364544868619, 566.6883214232156, 11549.249298795552, 12983.0, 13014.544490942772, 13125.34373281332, 13597.048206625639, 551.2227758859988, 555.0425515984894, 562.2662425534717, 568.1364326224116, 570.8744076303207, 7115.324044215791, 7132.643367831588, 7255.45584081196, 7332.340089391873, 7540.773776786705, 597751.0, 598224.0, 600482.0, 628007.0, 631624.0, 86601.56699216463, 88176.559117204, 88991.0, 89483.55258223668, 89738.0, 635.1393861317848, 648.5913874259187, 649.7141257846532, 649.7693318871827, 651.260818970472, 12408.193467424588, 12636.87363126357, 12639.241645501299, 12750.234985900875, 12805.8079128815, 39157.2168556633, 39248.607513925635, 39478.802605986784, 40111.59888401079, 40512.59487405088, 52231.477685222664, 52744.73627631837, 54010.45989540054, 54437.0, 54573.45426545842, 7720.884186737091, 7754.263344982218, 7880.487768295043, 7900.051993760785, 7902.012248468942, 13794.241316727275, 14014.649633759238, 14042.368093436024, 14080.929595351958, 14306.499272525412, 11896.464659090534, 12058.15592908488, 12262.877371226174, 12289.324087175291, 12324.815127772912, 11731.178817482694, 12016.038716902802, 12038.398080096134, 12047.277163370225, 12105.152639315163, 9855.655052073143, 10280.177585793268, 11466.827997579876, 11695.298282103102, 11883.82174267404, 7599.518093971623, 7604.695812167452, 7692.307692307719, 7700.691972321269, 7703.075630924325, 11481.540738370706, 11731.35477548743, 11804.350760708243, 11832.11259155584, 12108.515659373526], "unit": "ms", "name": "jquery.html", "value": 8214.79981496738}, {"lowerIsBetter": false, "replicates": [1592.4904030710177, 1594.62526306318, 1866.4307386247194, 1876.9812301876977, 1877.6526342626623, 7850.332721718653, 7935.2461516155945, 7997.840043199147, 7997.88003179952, 8006.239407256316, 8104.675812967489, 8114.513129212237, 8129.878051829227, 8140.348772098233, 8165.3059489943425, 2370.668106465096, 2372.9881350593223, 2395.940101497459, 2397.1490121007055, 2406.614941609343, 2387.95224095518, 2452.558539462896, 2465.285067330472, 2465.8767061646936, 2466.987665061672, 1929.3825975687785, 1962.0680176915994, 2290.8854557272152, 2399.3521749127726, 2414.577448946436, 2361.232599405183, 2365.9053637854463, 2372.9169479068323, 2376.738558758535, 2377.7146742390937, 2369.7037870266217, 2418.093215044358, 2420.225527831095, 2422.467057247403, 2422.5033868057008, 6490.188726409199, 6640.535162538624, 7936.801579960547, 8137.796555086111, 8142.389320800964, 4961.255811628249, 5037.0429618372755, 5043.697378157322, 5048.116579598555, 5049.570786483153, 3338.749593780476, 3364.6971772540587, 3399.55805745254, 3404.285100128976, 3415.8975230743117, 1182.3319824299244, 1189.227002448407, 1203.6810245285008, 1224.6326102169314, 1236.4621389695421, 11090.279131856403, 11110.388928608923, 11147.442627868655, 11150.275232109969, 11152.386618735965, 4599.839005634787, 4601.815927362935, 4644.651651126179, 4654.418197725285, 4673.158831410379, 9753.073458021476, 9754.756131096638, 9763.511824408752, 9767.413955162712, 9769.413835169913, 5162.767675454614, 5163.380394352626, 5163.457836927144, 5165.9225111623355, 5169.81905633301, 4685.625149987993, 4707.95292047082, 4711.905761884743, 4712.31671407644, 4712.95287047132, 3936.173403585279, 3971.980140099281, 3974.880753577397, 3999.7400168988925, 4015.6185162409524, 1301.0827366706449, 1303.12690497367, 1307.0589175793414, 1308.156239225713, 1308.2804457548311, 1118.3122379736403, 1122.1247427006947, 1253.1541209683428, 1456.3155317000992, 1485.3984136424765, 7859.567723775247, 7885.093214280317, 7909.1299957004685, 7909.485883417675, 7912.960435197787, 536.1692481310482, 538.7360193505233, 545.2802300962691, 561.719140429785, 563.9971800140974, 5691.402402747652, 5781.6241944274325, 6344.746210151635, 6406.103145559626, 6419.101325814389, 8537.658493660309, 8790.252828509649, 8823.470591764386, 8829.381943264038, 8830.249428798625, 9233.076692330847, 9302.069793020779, 9389.530523473799, 9503.382280151767, 9523.523823808782, 7453.0, 7513.962430187814, 7526.698932042657, 7530.472866899265, 7539.547627142389, 7628.313451789366, 7776.183500732342, 7786.649600768093, 7828.217178282126, 7834.451588388758, 8376.0, 8405.49567025956, 8512.106228845882, 8873.467591944504, 8982.640694372152, 8498.787530311793, 8506.957465212634, 8575.742727718178, 9183.265338773015, 9187.586558604746, 7204.603746793977, 7274.8908766367485, 7280.417566594554, 7287.817804554928, 7305.305995930378, 7821.530708157528, 7941.086775020715, 7957.482763620346, 7974.082980457089, 7975.122736499096, 7313.451491138292, 7585.127710313384, 7600.619969001417, 7632.38940884739, 7678.692852285846, 7436.776896693108, 7444.739434119996, 7469.887951680837, 7535.6985720570565, 7550.962245188739, 7537.133229678438, 7627.5042122261875, 7632.274933881273, 7636.045494313211, 7650.120236172911, 6932.272111428228, 6981.197162326397, 6991.685374158277, 6996.440284777307, 7006.859862802818, 6738.797836064926, 6824.18109826824, 6854.657267136524, 6865.038894554867, 7163.10461192351], "unit": "ms", "name": "mootools.html", "value": 4667.600130182768}, {"lowerIsBetter": false, "replicates": [355.7012109827744, 356.5543071161049, 360.21293473759823, 360.3675549410782, 360.6988164882324, 5993.520518358532, 6020.819375418733, 6036.426539478748, 6052.092186172071, 6065.332813390529, 5710.942890571093, 5791.623544469607, 5807.39022402648, 5900.616459930102, 5926.0, 4638.512956139591, 4642.396488456513, 4653.441587009555, 4661.930071048937, 4674.7428891410955, 4669.042846216535, 4677.368555245032, 4681.485036645966, 4684.227102528096, 4684.718916864982, 4613.769311534426, 4638.350630911675, 4641.419822522184, 4644.0, 4644.326572646964, 4602.700824446417, 4671.416072990876, 4689.577937985564, 4695.506971767949, 4700.694454860441, 4157.230912281238, 4162.375643653446, 4163.292240319153, 4167.229062623394, 4169.791510424467, 5676.035074037423, 5681.886362272773, 5684.175794509773, 5690.48785609293, 5695.1741997410145, 5316.707581083039, 5402.594805389612, 5403.837884863421, 5415.296011518517, 5416.783328666888, 6365.013422919455, 6365.554411191219, 6366.713497892606, 6370.1718776558755, 6371.936280637227, 4631.60631346336, 4638.281066434708, 4639.6752227344095, 4640.2343613303765, 4645.883852903705, 6496.058071579641, 6585.703643336062, 6599.241087274977, 6602.570832895798, 6606.768763093269, 4706.929396059062, 4748.572628463455, 4784.425868895755, 4790.952090479121, 4799.064182484382, 4843.176659967814, 4846.321514987904, 4846.80612775492, 4848.9757551212015, 4852.490488498727, 5466.453354664502, 5467.589930755209, 5470.945290547043, 5471.151971444432, 5471.316085489314, 6312.463440607508, 6408.00675895237, 6408.647524386203, 6411.935880641227, 6414.0, 1730.2214003698134, 1742.5904912345588, 1745.4152858792193, 1746.8864523805912, 1749.212854215608, 1129.4635048351968, 1169.2399940039043, 1198.844150260478, 1219.5243854896598, 1227.2513766602365, 5991.161237426763, 6004.639721616717, 6012.759489620366, 6019.548533859978, 6035.577509574376, 6377.71300291488, 6409.038644203313, 6412.070249813751, 6419.903701444482, 6424.0, 5953.047512397996, 6064.181335519736, 6065.423784740443, 6072.453479186895, 6074.726637301332, 3572.1783989682, 3600.5499312585926, 3602.819859007039, 3608.332458495187, 3608.440691692792, 6723.0, 6727.596344219362, 6735.124433823572, 6736.023276624862, 6736.865262694719, 6614.7023383947835, 6694.59832410057, 6696.029075783984, 6698.698558564876, 6699.698513566901, 6750.493712971547, 6768.2216545097945, 6768.357006084414, 6773.254941956381, 6778.627175505395, 6611.2727599963, 6622.271550129578, 6623.933760662524, 6626.734930602915, 6631.1379520662, 6472.773452929125, 6587.9670601646685, 6590.538662293593, 6592.077109204811, 6596.8350791230605, 6787.796366109024, 6841.24746277919, 6849.794506164823, 6853.211880633591, 6857.142857142857, 4626.1210370029585, 4654.371659826015, 4660.650451216105, 4666.34671146033, 4667.113248482778, 6516.152900122954, 6637.1703537057865, 6637.236717777518, 6643.30245324234, 6644.136262285871, 6481.643509607017, 6484.5460817742305, 6487.513436492188, 6487.805365839033, 6492.513061520311, 6462.321456247214, 6463.450606698483, 6467.805965821033, 6469.547131700924, 6479.708413121327, 6279.96860015697, 6363.268224154096, 6371.362863713777, 6374.904376434264, 6377.617342959252, 6498.480121590356, 6499.7400103995315, 6499.935000650122, 6500.674966251763, 6506.642134682638, 6316.621002739666, 6344.270408903035, 6345.587536810092, 6346.365363463617, 6347.460465860454], "unit": "ms", "name": "prototype.html", "value": 4886.331585652605}, {"lowerIsBetter": false, "replicates": [884.48257769205, 914.935954483186, 915.4004127296623, 929.9860502092474, 954.1794057110883, 15524.301406436709, 15845.92077039616, 15865.444709435144, 15909.0, 15938.681226375465, 14500.202488863108, 14659.340329685163, 14738.189399583018, 14767.704645907075, 14833.851661483382, 782.659543098751, 790.016429545217, 926.2173463423413, 926.4302453990781, 952.261996952364, 942.580551654514, 946.4888959961612, 951.2390087929663, 952.4142652268839, 953.3660116022836, 801.5951944268137, 993.4337427666234, 993.662154867345, 995.5719040812447, 996.2577879479761, 815.5473712089788, 962.0667952086465, 975.0639386189267, 975.3513913247682, 980.9558569864373, 716.0440811516579, 720.1142594608608, 723.1033518437152, 723.7756295548397, 729.773770131261, 15174.696506069817, 15218.239088045553, 15268.694626107526, 15403.537893863202, 15435.073895566302, 13329.733405331936, 13841.0, 14064.859351406458, 14240.287985600678, 14486.058406203563, 10658.893411065945, 10825.729356766065, 10998.175136864767, 11437.313761174357, 11590.884091159065, 3510.666486683761, 3514.2620049789575, 3526.823658817049, 3534.32847758925, 3543.5924868639922, 52166.21750673743, 52680.0, 53159.20261196085, 53182.468175318136, 53256.73371633156, 8186.508809471332, 8198.713045043394, 8209.384296177692, 8262.297704695167, 8398.916010839814, 13259.337033148304, 13281.601551953458, 13397.330133493286, 13654.86345136536, 13734.93132534331, 7393.667284972189, 7396.3343299103335, 7485.887711684329, 7620.237976202336, 7774.961125194451, 4867.6836005660225, 4961.454240033593, 4968.453470118284, 5016.2224855147515, 5026.09530284545, 3103.4103520331064, 3131.2798056447145, 3134.279115803378, 3136.2316232523176, 3139.8430078495985, 487.75855951304334, 487.75855951304334, 488.4773292576909, 490.04441339388336, 493.11731999720814, 729.4565548666278, 746.9290417410338, 755.1542272654661, 759.2255898983007, 773.3349319585152, 9840.950795245977, 10056.145227655585, 10118.797624047626, 10146.137578305927, 10201.693949181536, 608.0358253514119, 759.0, 779.4349096904699, 793.1790596732354, 803.6463955859404, 4232.70371074028, 4634.657402660699, 4636.095961287584, 4704.388429504211, 4774.259989701602, 70062.0, 70141.0, 70780.29219707738, 70781.0, 71801.0, 64358.0, 64584.35415645877, 65152.34847651557, 65247.67376163089, 65626.34373656298, 55475.16787248194, 56481.0, 57121.0, 57730.0, 59136.70431647814, 9138.862917056382, 9304.813903722023, 9512.85730714026, 9533.570989305637, 9567.61729530811, 41322.173556529306, 41387.0, 41999.16001679888, 42015.579844201166, 42307.7884610575, 50676.49323506718, 53808.0, 54146.0, 54743.72628136834, 54801.45198547964, 8626.0, 8694.39139260271, 8776.956115219384, 8946.507942062988, 9168.954155229449, 12949.352532373156, 13060.738785224052, 13101.934490327869, 13287.534936277183, 13351.532696355582, 11762.529498819951, 11784.70538236551, 11852.822207667065, 11882.940585297018, 12359.752804943671, 11830.585929492427, 12002.279863208236, 12189.085818563466, 12389.566365177176, 13106.60680179596, 10919.454027298762, 10969.616063437741, 12508.124431289722, 12542.811857821958, 12595.622131336075, 10430.37417754937, 10473.21450891171, 10487.79024419492, 10904.400257985886, 11394.715132121763, 10477.175830821847, 10783.676489705322, 10916.836247456136, 10978.0, 10987.285826421257], "unit": "ms", "name": "yui.html", "value": 6835.460408177876}], "name": "dromaeo_css", "value": 7303.755986805057}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 112.0, 103.0, 108.0, 111.0, 111.0, 101.0, 109.0, 107.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 107.8}, {"lowerIsBetter": true, "replicates": [153.0, 122.0, 148.0, 155.0, 129.0, 152.0, 152.0, 122.0, 159.0, 121.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.3}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 160.0, 159.0, 161.0, 160.0, 163.0, 161.0, 159.0], "unit": "ms", "name": "audio-dft", "value": 160.5}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 72.0, 139.0, 72.0, 70.0, 71.0, 70.0, 154.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 86.1}, {"lowerIsBetter": true, "replicates": [89.0, 89.0, 135.0, 89.0, 89.0, 89.0, 134.0, 90.0, 89.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 102.3}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 144.0, 145.0, 147.0, 145.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [52.0, 54.0, 54.0, 55.0, 56.0, 55.0, 54.0, 62.0, 52.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 54.8}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 63.0, 63.0, 64.0, 63.0, 63.0, 63.0, 63.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.3}, {"lowerIsBetter": true, "replicates": [76.0, 77.0, 81.0, 79.0, 80.0, 78.0, 86.0, 78.0, 78.0, 78.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 79.1}, {"lowerIsBetter": true, "replicates": [113.0, 107.0, 123.0, 106.0, 115.0, 124.0, 115.0, 109.0, 119.0, 113.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 114.4}, {"lowerIsBetter": true, "replicates": [135.0, 137.0, 138.0, 136.0, 138.0, 136.0, 147.0, 134.0, 134.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 137.1}, {"lowerIsBetter": true, "replicates": [63.0, 61.0, 62.0, 61.0, 61.0, 64.0, 63.0, 64.0, 62.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 62.5}], "name": "kraken", "value": 1459.4999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.41676140977748], "unit": "score", "name": "Richards", "value": 217.35441400000002}, {"lowerIsBetter": false, "replicates": [171.76228100309172], "unit": "score", "name": "DeltaBlue", "value": 384.9389960000001}, {"lowerIsBetter": false, "replicates": [280.19052956010086], "unit": "score", "name": "Encrypt", "value": 949.9999890000003}, {"lowerIsBetter": false, "replicates": [4995.024875621891], "unit": "score", "name": "Decrypt", "value": 53.289224103585696}, {"lowerIsBetter": false, "replicates": [943.3962264150944], "unit": "score", "name": "RayTrace", "value": 784.3883400000002}, {"lowerIsBetter": false, "replicates": [558.659217877095], "unit": "score", "name": "Earley", "value": 1192.9687700000002}, {"lowerIsBetter": false, "replicates": [10489.583333333334], "unit": "score", "name": "Boyer", "value": 63.5356981132075}, {"lowerIsBetter": false, "replicates": [23651.162790697676], "unit": "score", "name": "RegExp", "value": 38.51755653883975}, {"lowerIsBetter": false, "replicates": [533.5463258785943], "unit": "score", "name": "Splay", "value": 152.73462874251493}, {"lowerIsBetter": false, "replicates": [4817.307692307692], "unit": "score", "name": "NavierStokes", "value": 308.055888223553}], "name": "v8_7", "value": 23310.19883012442}]} 14:37:42 INFO - RETURN: dromaeo_css: 7303.75 14:37:42 INFO - RETURN: kraken: 1459.50 14:37:42 INFO - RETURN: v8_7: 23310.20 14:37:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23310.20"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1459.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7303.75"}}} 14:37:42 INFO - Return code: 0 14:37:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:37:42 INFO - # TBPL SUCCESS # 14:37:42 INFO - Running post-action listener: _resource_record_post_action 14:37:42 INFO - Running post-run listener: _resource_record_post_run 14:37:43 INFO - Total resource usage - Wall time: 1221s; CPU: 12.0%; Read bytes: 315392; Write bytes: 279097344; Read time: 76; Write time: 132056 14:37:43 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 13950976; Read time: 0; Write time: 2652 14:37:43 INFO - run-tests - Wall time: 1207s; CPU: 12.0%; Read bytes: 315392; Write bytes: 265146368; Read time: 76; Write time: 129404 14:37:43 INFO - Running post-run listener: _upload_blobber_files 14:37:43 INFO - Blob upload gear active. 14:37:43 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:37:43 INFO - Copying logs to upload dir... 14:37:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1272.145590 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-11 14:37:43.631519) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-11 14:37:43.635246) ========= 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=3a3620fb28aea1604ab609ef000001d2-1452550461.163104-431680944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452542250/firefox-44.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009969 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1452542250/firefox-44.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-11 14:37:43.689036) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 14:37:43.689519) ========= 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=3a3620fb28aea1604ab609ef000001d2-1452550461.163104-431680944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004575 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 14:37:43.741400) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 14:37:43.741916) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 14:37:43.742468) ========= ========= Total master_lag: 0.22 =========